FailedConsole Output

Skipping 35 KB.. Full Log
        }, 
        "creationDate": "2021-02-16T22:05:53.000Z", 
        "description": "OpenShift Origin development AMI on rhel at the crio stage.", 
        "hypervisor": "xen", 
        "is_public": false, 
        "location": "531415883065/ami_build_origin_int_rhel_crio_1264", 
        "name": "ami_build_origin_int_rhel_crio_1264", 
        "owner_id": "531415883065", 
        "platform": null, 
        "root_device_name": "/dev/sda1", 
        "root_device_type": "ebs", 
        "state": "available", 
        "tags": {
            "Name": "ami_build_origin_int_rhel_crio_1264", 
            "image_stage": "crio", 
            "operating_system": "rhel", 
            "ready": "yes"
        }, 
        "virtualization_type": "hvm"
    }
}

TASK [aws-up : determine which AMI to use] *************************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:55
ok: [localhost] => {
    "ansible_facts": {
        "origin_ci_aws_ami_id": "ami-0db1bcec6bfd5a39f"
    }, 
    "changed": false, 
    "generated_timestamp": "2021-09-24 19:40:57.418666"
}

TASK [aws-up : determine which subnets are available] **************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:60
ok: [localhost] => {
    "changed": false, 
    "generated_timestamp": "2021-09-24 19:40:58.166203", 
    "subnets": [
        {
            "availability_zone": "us-east-1d", 
            "available_ip_address_count": 3932, 
            "cidr_block": "172.18.0.0/20", 
            "default_for_az": "false", 
            "id": "subnet-cf57c596", 
            "map_public_ip_on_launch": "true", 
            "state": "available", 
            "tags": {
                "Name": "devenv-subnet-1", 
                "openshift_creationDate": "2020-10-29T05:22:55.262494+00:00", 
                "origin_ci_aws_cluster_component": "master_subnet"
            }, 
            "vpc_id": "vpc-69705d0c"
        }, 
        {
            "availability_zone": "us-east-1c", 
            "available_ip_address_count": 4089, 
            "cidr_block": "172.18.16.0/20", 
            "default_for_az": "false", 
            "id": "subnet-8bdb5ac2", 
            "map_public_ip_on_launch": "true", 
            "state": "available", 
            "tags": {
                "Name": "devenv-subnet-2", 
                "openshift_creationDate": "2020-10-29T05:22:55.262494+00:00", 
                "origin_ci_aws_cluster_component": "master_subnet"
            }, 
            "vpc_id": "vpc-69705d0c"
        }
    ]
}

TASK [aws-up : determine which subnets to use for the master] ******************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:67
ok: [localhost] => {
    "ansible_facts": {
        "origin_ci_aws_master_subnet_ids": [
            "subnet-cf57c596", 
            "subnet-8bdb5ac2"
        ]
    }, 
    "changed": false, 
    "generated_timestamp": "2021-09-24 19:40:58.222089"
}

TASK [aws-up : determine which security groups are available] ******************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:72
ok: [localhost] => {
    "changed": false, 
    "generated_timestamp": "2021-09-24 19:40:59.580090", 
    "security_groups": [
        {
            "description": "default VPC security group", 
            "group_id": "sg-7e73221a", 
            "group_name": "default", 
            "ip_permissions": [
                {
                    "ip_protocol": "-1", 
                    "ip_ranges": [], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "user_id_group_pairs": [
                        {
                            "group_id": "sg-7e73221a", 
                            "user_id": "531415883065"
                        }
                    ]
                }, 
                {
                    "from_port": 80, 
                    "ip_protocol": "tcp", 
                    "ip_ranges": [
                        {
                            "cidr_ip": "54.241.19.245/32"
                        }, 
                        {
                            "cidr_ip": "97.65.119.184/29"
                        }, 
                        {
                            "cidr_ip": "107.20.219.35/32"
                        }, 
                        {
                            "cidr_ip": "108.166.48.153/32"
                        }, 
                        {
                            "cidr_ip": "212.199.177.64/27"
                        }, 
                        {
                            "cidr_ip": "212.72.208.162/32"
                        }
                    ], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "to_port": 443, 
                    "user_id_group_pairs": []
                }, 
                {
                    "from_port": 53, 
                    "ip_protocol": "tcp", 
                    "ip_ranges": [
                        {
                            "cidr_ip": "119.254.120.64/26"
                        }, 
                        {
                            "cidr_ip": "209.132.176.0/20"
                        }, 
                        {
                            "cidr_ip": "209.132.186.34/32"
                        }, 
                        {
                            "cidr_ip": "213.175.37.10/32"
                        }, 
                        {
                            "cidr_ip": "62.40.79.66/32"
                        }, 
                        {
                            "cidr_ip": "66.187.224.0/20"
                        }, 
                        {
                            "cidr_ip": "66.187.239.0/24"
                        }, 
                        {
                            "cidr_ip": "38.140.108.0/24"
                        }, 
                        {
                            "cidr_ip": "213.175.37.9/32"
                        }, 
                        {
                            "cidr_ip": "38.99.12.232/29"
                        }, 
                        {
                            "cidr_ip": "4.14.33.72/30"
                        }, 
                        {
                            "cidr_ip": "4.14.35.88/29"
                        }, 
                        {
                            "cidr_ip": "50.227.40.96/29"
                        }
                    ], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "to_port": 8444, 
                    "user_id_group_pairs": []
                }, 
                {
                    "from_port": 22, 
                    "ip_protocol": "tcp", 
                    "ip_ranges": [
                        {
                            "cidr_ip": "0.0.0.0/0"
                        }
                    ], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "to_port": 22, 
                    "user_id_group_pairs": []
                }, 
                {
                    "from_port": 53, 
                    "ip_protocol": "udp", 
                    "ip_ranges": [
                        {
                            "cidr_ip": "209.132.176.0/20"
                        }, 
                        {
                            "cidr_ip": "66.187.224.0/20"
                        }, 
                        {
                            "cidr_ip": "66.187.239.0/24"
                        }
                    ], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "to_port": 53, 
                    "user_id_group_pairs": []
                }, 
                {
                    "from_port": 0, 
                    "ip_protocol": "udp", 
                    "ip_ranges": [], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "to_port": 65535, 
                    "user_id_group_pairs": [
                        {
                            "group_id": "sg-0d1a5377", 
                            "user_id": "531415883065"
                        }, 
                        {
                            "group_id": "sg-5875023f", 
                            "user_id": "531415883065"
                        }, 
                        {
                            "group_id": "sg-7e73221a", 
                            "user_id": "531415883065"
                        }, 
                        {
                            "group_id": "sg-e1760186", 
                            "user_id": "531415883065"
                        }
                    ]
                }, 
                {
                    "from_port": 3389, 
                    "ip_protocol": "tcp", 
                    "ip_ranges": [
                        {
                            "cidr_ip": "0.0.0.0/0"
                        }
                    ], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "to_port": 3389, 
                    "user_id_group_pairs": []
                }, 
                {
                    "from_port": 443, 
                    "ip_protocol": "tcp", 
                    "ip_ranges": [
                        {
                            "cidr_ip": "73.162.159.233/32"
                        }
                    ], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "to_port": 443, 
                    "user_id_group_pairs": []
                }, 
                {
                    "from_port": -1, 
                    "ip_protocol": "icmp", 
                    "ip_ranges": [
                        {
                            "cidr_ip": "0.0.0.0/0"
                        }
                    ], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "to_port": -1, 
                    "user_id_group_pairs": []
                }
            ], 
            "ip_permissions_egress": [
                {
                    "ip_protocol": "-1", 
                    "ip_ranges": [
                        {
                            "cidr_ip": "0.0.0.0/0"
                        }
                    ], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "user_id_group_pairs": []
                }
            ], 
            "owner_id": "531415883065", 
            "tags": {
                "Name": "devenv-vpc", 
                "openshift_creationDate": "2020-10-29T05:22:55.262494+00:00", 
                "openshift_infra": "true", 
                "origin_ci_aws_cluster_component": "master_security_group"
            }, 
            "vpc_id": "vpc-69705d0c"
        }
    ]
}

TASK [aws-up : determine which security group to use] **************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:79
ok: [localhost] => {
    "ansible_facts": {
        "origin_ci_aws_master_security_group_ids": [
            "sg-7e73221a"
        ]
    }, 
    "changed": false, 
    "generated_timestamp": "2021-09-24 19:40:59.645338"
}

TASK [aws-up : provision an AWS EC2 instance] **********************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:84
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2021-09-24 19:41:18.081934", 
    "instance_ids": [
        "i-0d913e75f073426c0"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-011408dae02f2b7fb"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0a6457b29f9315f9b"
                }
            }, 
            "dns_name": "ec2-54-162-20-224.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-0d913e75f073426c0", 
            "image_id": "ami-0db1bcec6bfd5a39f", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2021-09-24T23:41:01.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-4-240.ec2.internal", 
            "private_ip": "172.18.4.240", 
            "public_dns_name": "ec2-54-162-20-224.compute-1.amazonaws.com", 
            "public_ip": "54.162.20.224", 
            "ramdisk": null, 
            "region": "us-east-1", 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "running", 
            "state_code": 16, 
            "tags": {
                "Name": "test_pull_request_crio_integration_rhel_24923", 
                "openshift_etcd": "", 
                "openshift_master": "", 
                "openshift_node": ""
            }, 
            "tenancy": "default", 
            "virtualization_type": "hvm"
        }
    ], 
    "tagged_instances": []
}

TASK [aws-up : determine the host address] *************************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:110
ok: [localhost] => {
    "ansible_facts": {
        "origin_ci_aws_host": "172.18.4.240"
    }, 
    "changed": false, 
    "generated_timestamp": "2021-09-24 19:41:18.125807"
}

TASK [aws-up : determine the default user to use for SSH] **********************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:114
skipping: [localhost] => {
    "changed": false, 
    "generated_timestamp": "2021-09-24 19:41:18.166567", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}

TASK [aws-up : determine the default user to use for SSH] **********************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:119
ok: [localhost] => {
    "ansible_facts": {
        "origin_ci_aws_ssh_user": "origin"
    }, 
    "changed": false, 
    "generated_timestamp": "2021-09-24 19:41:18.212873"
}

TASK [aws-up : update variables for the host] **********************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:124
changed: [localhost] => {
    "changed": true, 
    "checksum": "988f0ce5ce402602b3f310b74d97113570fe34f2", 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/host_vars/172.18.4.240.yml", 
    "generated_timestamp": "2021-09-24 19:41:18.598627", 
    "gid": 995, 
    "group": "jenkins", 
    "md5sum": "e86d3eb7dea7edae34d8e90b7ebae720", 
    "mode": "0644", 
    "owner": "jenkins", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 767, 
    "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1632526878.43-234578641664007/source", 
    "state": "file", 
    "uid": 997
}

TASK [aws-up : determine where updated SSH configuration should go] ************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:141
ok: [localhost] => {
    "ansible_facts": {
        "origin_ci_ssh_config_files": [
            "/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config"
        ]
    }, 
    "changed": false, 
    "generated_timestamp": "2021-09-24 19:41:18.645935"
}

TASK [aws-up : determine where updated SSH configuration should go] ************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:146
skipping: [localhost] => {
    "changed": false, 
    "generated_timestamp": "2021-09-24 19:41:18.688409", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}

TASK [aws-up : ensure the targeted SSH configuration file exists] **************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:151
changed: [localhost] => (item=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config) => {
    "changed": true, 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config", 
    "generated_timestamp": "2021-09-24 19:41:18.893186", 
    "gid": 995, 
    "group": "jenkins", 
    "item": "/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config", 
    "mode": "0644", 
    "owner": "jenkins", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 0, 
    "state": "file", 
    "uid": 997
}

TASK [aws-up : update the SSH configuration] ***********************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:157
changed: [localhost] => (item=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config) => {
    "changed": true, 
    "generated_timestamp": "2021-09-24 19:41:19.217322", 
    "item": "/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config", 
    "msg": "Block inserted"
}

TASK [aws-up : wait for SSH to be available] ***********************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:175
ok: [localhost] => {
    "changed": false, 
    "elapsed": 33, 
    "generated_timestamp": "2021-09-24 19:41:52.602305", 
    "path": null, 
    "port": 22, 
    "search_regex": null, 
    "state": "started"
}

PLAY RECAP *********************************************************************
localhost                  : ok=28   changed=13   unreachable=0    failed=0   

+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PROVISION CLOUD RESOURCES [00h 01m 03s] ##########
[workspace@4] $ /bin/bash /tmp/jenkins1713949301230392011.sh
########## STARTING STAGE: FORWARD PARAMETERS TO THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod o+rw /etc/environment
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''BUILD_ID=1441548010113732617'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''REPO_OWNER=cri-o'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''REPO_NAME=cri-o'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_BASE_REF=main'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_BASE_SHA=8bb79b890d1069466ca9520f88883870acbb51b0'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_REFS=main:8bb79b890d1069466ca9520f88883870acbb51b0,5347:d56449c4c4c04c939ae34f332a015736216f2edb'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_NUMBER=5347'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_PULL_SHA=d56449c4c4c04c939ae34f332a015736216f2edb'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''JOB_SPEC={"type":"presubmit","job":"test_pull_request_crio_integration_rhel","buildid":"1441548010113732617","prowjobid":"a7b12211-1d90-11ec-9214-0a580a8048c6","refs":{"org":"cri-o","repo":"cri-o","base_ref":"main","base_sha":"8bb79b890d1069466ca9520f88883870acbb51b0","pulls":[{"number":5347,"author":"harche","sha":"d56449c4c4c04c939ae34f332a015736216f2edb","title":"bump crio commit for node e2e installer"}]}}'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PROW_JOB_ID=a7b12211-1d90-11ec-9214-0a580a8048c6'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''JOB_SPEC={"type":"presubmit","job":"test_pull_request_crio_integration_rhel","buildid":"1441548010113732617","prowjobid":"a7b12211-1d90-11ec-9214-0a580a8048c6","refs":{"org":"cri-o","repo":"cri-o","base_ref":"main","base_sha":"8bb79b890d1069466ca9520f88883870acbb51b0","pulls":[{"number":5347,"author":"harche","sha":"d56449c4c4c04c939ae34f332a015736216f2edb","title":"bump crio commit for node e2e installer"}]}}'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''BUILD_NUMBER=24923'\'' >> /etc/environment'
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: FORWARD PARAMETERS TO THE REMOTE HOST [00h 00m 06s] ##########
[workspace@4] $ /bin/bash /tmp/jenkins1152507762554156339.sh
########## STARTING STAGE: UPLOAD GCS STARTING METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
+ trap 'exit 0' EXIT
+ mkdir -p gcs/
+ [[ -n cri-o ]]
+ cat
++ date +%s
+ BUILD=24923
+ bucket=gs://origin-federated-results/
+ suffix=test_pull_request_crio_integration_rhel/24923/
+ [[ -n cri-o ]]
+ segment=cri-o_cri-o/
+ [[ -n 5347 ]]
+ prefix=pr-logs/pull/
+ segment=cri-o_cri-o/5347/
+ path=gs://origin-federated-results/pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/
+ gsutil cp gcs/started.json gs://origin-federated-results/pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/started.json
Copying file://gcs/started.json [Content-Type=application/json]...
/ [0 files][    0.0 B/  280.0 B]                                                
/ [1 files][  280.0 B/  280.0 B]                                                
Operation completed over 1 objects/280.0 B.                                      
+ [[ -n 5347 ]]
+ echo gs://origin-federated-results/pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923
+ gsutil cp 24923.txt gs://origin-federated-results/pr-logs/directory/test_pull_request_crio_integration_rhel/24923.txt
Copying file://24923.txt [Content-Type=text/plain]...
/ [0 files][    0.0 B/  106.0 B]                                                
/ [1 files][  106.0 B/  106.0 B]                                                
Operation completed over 1 objects/106.0 B.                                      
+ echo 24923
++ jq --compact-output .type
+ job_type='"presubmit"'
+ [[ "presubmit" =~ presubmit ]]
+ gsutil cp latest-build.txt gs://origin-ci-test/pr-logs/directory/test_pull_request_crio_integration_rhel/latest-build.txt
Copying file://latest-build.txt [Content-Type=text/plain]...
/ [0 files][    0.0 B/    6.0 B]                                                
/ [1 files][    6.0 B/    6.0 B]                                                
Operation completed over 1 objects/6.0 B.                                        
+ exit 0
[workspace@4] $ /bin/bash /tmp/jenkins4697200983398011507.sh
########## STARTING STAGE: FORWARD PARAMETERS TO THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod o+rw /etc/environment
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_NUMBER=5347'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_BASE_SHA=8bb79b890d1069466ca9520f88883870acbb51b0'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_PULL_SHA=d56449c4c4c04c939ae34f332a015736216f2edb'\'' >> /etc/environment'
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: FORWARD PARAMETERS TO THE REMOTE HOST [00h 00m 02s] ##########
[workspace@4] $ /bin/bash /tmp/jenkins1587187334339879151.sh
########## STARTING STAGE: CLONE CRI-O AND CHECK OUT THE CORRECT REFS ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
++ mktemp
+ script=/tmp/tmp.rumarIS1Kn
+ cat
+ chmod +x /tmp/tmp.rumarIS1Kn
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.rumarIS1Kn openshiftdevel:/tmp/tmp.rumarIS1Kn
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.rumarIS1Kn"'
+ cd /home/origin
+ cd /go/src/github.com/cri-o/cri-o
+ git fetch origin
From https://github.com/cri-o/cri-o
 * [new branch]      annotations-refactor -> origin/annotations-refactor
 * [new branch]      dependabot/go_modules/github.com/containers/buildah-1.23.0 -> origin/dependabot/go_modules/github.com/containers/buildah-1.23.0
 * [new branch]      dependabot/go_modules/github.com/containers/common-0.46.0 -> origin/dependabot/go_modules/github.com/containers/common-0.46.0
 * [new branch]      dependabot/go_modules/github.com/coreos/go-systemd/v22-22.3.0 -> origin/dependabot/go_modules/github.com/coreos/go-systemd/v22-22.3.0
 * [new branch]      dependabot/go_modules/github.com/intel/goresctrl-0.2.0 -> origin/dependabot/go_modules/github.com/intel/goresctrl-0.2.0
 * [new branch]      dependabot/go_modules/google.golang.org/grpc-1.41.0 -> origin/dependabot/go_modules/google.golang.org/grpc-1.41.0
 * [new branch]      dependabot/go_modules/k8s.io/api-0.22.2 -> origin/dependabot/go_modules/k8s.io/api-0.22.2
 * [new branch]      dependabot/go_modules/k8s.io/apimachinery-0.22.2 -> origin/dependabot/go_modules/k8s.io/apimachinery-0.22.2
 * [new branch]      dependabot/go_modules/k8s.io/cri-api-0.22.2 -> origin/dependabot/go_modules/k8s.io/cri-api-0.22.2
 * [new branch]      dependabot/go_modules/k8s.io/release-0.10.0 -> origin/dependabot/go_modules/k8s.io/release-0.10.0
 * [new branch]      dependabot/go_modules/sigs.k8s.io/yaml-1.3.0 -> origin/dependabot/go_modules/sigs.k8s.io/yaml-1.3.0
   b60207c..d32e54c  gh-pages   -> origin/gh-pages
 * [new branch]      main       -> origin/main
   5218c73..54f9e69  release-1.11 -> origin/release-1.11
   7f979af..f0bab49  release-1.17 -> origin/release-1.17
   be796d1..fa57051  release-1.18 -> origin/release-1.18
   6377f68..7d25e5d  release-1.19 -> origin/release-1.19
   b422fc2..5739238  release-1.20 -> origin/release-1.20
   900bc42..3583716  release-1.21 -> origin/release-1.21
 * [new branch]      release-1.22 -> origin/release-1.22
 * [new branch]      release-1.23 -> origin/release-1.23
 * [new tag]         v1.20.5    -> v1.20.5
From https://github.com/cri-o/cri-o
 * [new tag]         v1.19.2    -> v1.19.2
 * [new tag]         v1.19.3    -> v1.19.3
 * [new tag]         v1.19.4    -> v1.19.4
 * [new tag]         v1.20.1    -> v1.20.1
 * [new tag]         v1.20.2    -> v1.20.2
 * [new tag]         v1.20.3    -> v1.20.3
 * [new tag]         v1.20.4    -> v1.20.4
 * [new tag]         v1.21.0    -> v1.21.0
 * [new tag]         v1.21.1    -> v1.21.1
 * [new tag]         v1.21.2    -> v1.21.2
 * [new tag]         v1.21.3    -> v1.21.3
 * [new tag]         v1.22.0    -> v1.22.0
+ git checkout -f master
Already on 'master'
+ git branch -D target
error: branch 'target' not found.
+ true
+ git branch -D pr
error: branch 'pr' not found.
+ true
+ git branch target 8bb79b890d1069466ca9520f88883870acbb51b0
+ git checkout -f target
Switched to branch 'target'
+ git fetch origin pull/5347/head:pr
From https://github.com/cri-o/cri-o
 * [new ref]         refs/pull/5347/head -> pr
+ git merge d56449c4c4c04c939ae34f332a015736216f2edb
Merge made by the 'recursive' strategy.
 scripts/node_e2e_installer | 2 +-
 1 file changed, 1 insertion(+), 1 deletion(-)
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: CLONE CRI-O AND CHECK OUT THE CORRECT REFS [00h 00m 12s] ##########
[workspace@4] $ /bin/bash /tmp/jenkins5483077582624583966.sh
########## STARTING STAGE: RUN THE CRI-O INTEGRATION TESTS ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
++ mktemp
+ script=/tmp/tmp.IrpxhaoJEb
+ cat
+ chmod +x /tmp/tmp.IrpxhaoJEb
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.IrpxhaoJEb openshiftdevel:/tmp/tmp.IrpxhaoJEb
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.IrpxhaoJEb"'
+ cd /home/origin
+ ansible-playbook -vv --become -i localhost, --tags integration --become-user root --connection local /go/src/github.com/cri-o/cri-o/contrib/test/integration/main.yml
ansible-playbook 2.4.2.0
  config file = /etc/ansible/ansible.cfg
  configured module search path = [u'/home/origin/.ansible/plugins/modules', u'/usr/share/ansible/plugins/modules']
  ansible python module location = /usr/lib/python2.7/site-packages/ansible
  executable location = /usr/bin/ansible-playbook
  python version = 2.7.5 (default, Aug 13 2020, 02:51:10) [GCC 4.8.5 20150623 (Red Hat 4.8.5-39)]
Using /etc/ansible/ansible.cfg as config file
[DEPRECATION WARNING]: The use of 'include' for tasks has been deprecated. Use 
'import_tasks' for static inclusions or 'include_tasks' for dynamic inclusions.
 This feature will be removed in a future release. Deprecation warnings can be 
disabled by setting deprecation_warnings=False in ansible.cfg.
[DEPRECATION WARNING]: include is kept for backwards compatibility but usage is
 discouraged. The module documentation details page may explain more about this
 rationale.. This feature will be removed in a future release. Deprecation 
warnings can be disabled by setting deprecation_warnings=False in ansible.cfg.
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system-packages.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/python3.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/golang.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/bats.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-tools.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubetest.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/runc.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/plugins.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/conmon.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/jq.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/golang.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/conmon.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/jq.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/runc.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/disable_swap.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/parallel.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/python3.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-tools.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/test.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-tools.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/critest.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubetest.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubetest.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-features.yml
statically imported: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml

PLAYBOOK: main.yml *************************************************************
6 plays in /go/src/github.com/cri-o/cri-o/contrib/test/integration/main.yml

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

TASK [Gathering Facts] *********************************************************
ok: [localhost]
META: ran handlers
META: ran handlers
META: ran handlers

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

TASK [Gathering Facts] *********************************************************
ok: [localhost]
META: ran handlers

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

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

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

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

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

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

TASK [install Go tools and dependencies] ***************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/golang.yml:51
changed: [localhost] => (item=onsi/ginkgo/ginkgo) => {"changed": true, "cmd": "go get -u \"github.com/onsi/ginkgo/ginkgo\"", "delta": "0:00:06.222946", "end": "2021-09-24 23:42:49.882301", "item": "onsi/ginkgo/ginkgo", "rc": 0, "start": "2021-09-24 23:42:43.659355", "stderr": "go: downloading github.com/onsi/ginkgo v1.16.4\ngo: downloading github.com/go-task/slim-sprig v0.0.0-20210107165309-348f09dbbbc0\ngo: downloading golang.org/x/tools v0.0.0-20201224043029-2b0845dc783e\ngo: downloading github.com/nxadm/tail v1.4.8\ngo: downloading golang.org/x/sys v0.0.0-20210112080510-489259a85091\ngo: downloading gopkg.in/tomb.v1 v1.0.0-20141024135613-dd632973f1e7\ngo: downloading github.com/fsnotify/fsnotify v1.4.9\ngo: downloading github.com/fsnotify/fsnotify v1.5.1\ngo: downloading golang.org/x/sys v0.0.0-20210923061019-b8560ed6a9b7\ngo: downloading golang.org/x/tools v0.1.6\ngo: downloading golang.org/x/sys v0.0.0-20210630005230-0f9fa26af87c\ngo get: installing executables with 'go get' in module mode is deprecated.\n\tUse 'go install pkg@version' instead.\n\tFor more information, see https://golang.org/doc/go-get-install-deprecation\n\tor run 'go help get' or 'go help install'.", "stderr_lines": ["go: downloading github.com/onsi/ginkgo v1.16.4", "go: downloading github.com/go-task/slim-sprig v0.0.0-20210107165309-348f09dbbbc0", "go: downloading golang.org/x/tools v0.0.0-20201224043029-2b0845dc783e", "go: downloading github.com/nxadm/tail v1.4.8", "go: downloading golang.org/x/sys v0.0.0-20210112080510-489259a85091", "go: downloading gopkg.in/tomb.v1 v1.0.0-20141024135613-dd632973f1e7", "go: downloading github.com/fsnotify/fsnotify v1.4.9", "go: downloading github.com/fsnotify/fsnotify v1.5.1", "go: downloading golang.org/x/sys v0.0.0-20210923061019-b8560ed6a9b7", "go: downloading golang.org/x/tools v0.1.6", "go: downloading golang.org/x/sys v0.0.0-20210630005230-0f9fa26af87c", "go get: installing executables with 'go get' in module mode is deprecated.", "\tUse 'go install pkg@version' instead.", "\tFor more information, see https://golang.org/doc/go-get-install-deprecation", "\tor run 'go help get' or 'go help install'."], "stdout": "", "stdout_lines": []}
changed: [localhost] => (item=onsi/gomega) => {"changed": true, "cmd": "go get -u \"github.com/onsi/gomega\"", "delta": "0:00:07.041751", "end": "2021-09-24 23:42:57.092571", "item": "onsi/gomega", "rc": 0, "start": "2021-09-24 23:42:50.050820", "stderr": "go: downloading github.com/onsi/gomega v1.16.0\ngo: downloading golang.org/x/net v0.0.0-20210428140749-89ef3d95e781\ngo: downloading gopkg.in/yaml.v2 v2.4.0\ngo: downloading golang.org/x/net v0.0.0-20210924151903-3ad01bbaa167\ngo: downloading golang.org/x/text v0.3.6\ngo: downloading golang.org/x/text v0.3.7", "stderr_lines": ["go: downloading github.com/onsi/gomega v1.16.0", "go: downloading golang.org/x/net v0.0.0-20210428140749-89ef3d95e781", "go: downloading gopkg.in/yaml.v2 v2.4.0", "go: downloading golang.org/x/net v0.0.0-20210924151903-3ad01bbaa167", "go: downloading golang.org/x/text v0.3.6", "go: downloading golang.org/x/text v0.3.7"], "stdout": "", "stdout_lines": []}
changed: [localhost] => (item=jteeuwen/go-bindata/go-bindata) => {"changed": true, "cmd": "go get -u \"github.com/jteeuwen/go-bindata/go-bindata\"", "delta": "0:00:00.461794", "end": "2021-09-24 23:42:57.721206", "item": "jteeuwen/go-bindata/go-bindata", "rc": 0, "start": "2021-09-24 23:42:57.259412", "stderr": "go: downloading github.com/jteeuwen/go-bindata v3.0.7+incompatible\ngo get: installing executables with 'go get' in module mode is deprecated.\n\tUse 'go install pkg@version' instead.\n\tFor more information, see https://golang.org/doc/go-get-install-deprecation\n\tor run 'go help get' or 'go help install'.", "stderr_lines": ["go: downloading github.com/jteeuwen/go-bindata v3.0.7+incompatible", "go get: installing executables with 'go get' in module mode is deprecated.", "\tUse 'go install pkg@version' instead.", "\tFor more information, see https://golang.org/doc/go-get-install-deprecation", "\tor run 'go help get' or 'go help install'."], "stdout": "", "stdout_lines": []}

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

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

TASK [build cri-o] *************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:13
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/cri-o/cri-o", "params": null, "stderr": "time=\"2021-09-24T23:49:11Z\" level=warning msg=\"Failed to decode the keys [\\\"storage.options.override_kernel_check\\\"] from \\\"/etc/containers/storage.conf\\\".\"\ntime=\"2021-09-24 23:49:11.521582226Z\" level=info msg=\"Starting CRI-O, version: 1.22.0, git: cc58c8f9feaaa18ac540c7d136ab0f6455f882c3(clean)\"\nlevel=info msg=\"Using default capabilities: CAP_CHOWN, CAP_DAC_OVERRIDE, CAP_FSETID, CAP_FOWNER, CAP_SETGID, CAP_SETUID, CAP_SETPCAP, CAP_NET_BIND_SERVICE, CAP_KILL\"", "stderr_lines": ["time=\"2021-09-24T23:49:11Z\" level=warning msg=\"Failed to decode the keys [\\\"storage.options.override_kernel_check\\\"] from \\\"/etc/containers/storage.conf\\\".\"", "time=\"2021-09-24 23:49:11.521582226Z\" level=info msg=\"Starting CRI-O, version: 1.22.0, git: cc58c8f9feaaa18ac540c7d136ab0f6455f882c3(clean)\"", "level=info msg=\"Using default capabilities: CAP_CHOWN, CAP_DAC_OVERRIDE, CAP_FSETID, CAP_FOWNER, CAP_SETGID, CAP_SETUID, CAP_SETPCAP, CAP_NET_BIND_SERVICE, CAP_KILL\""], "stdout": "touch \"/go/.gopathok\"\ngo build -trimpath  -ldflags '-s -w -X github.com/cri-o/cri-o/internal/pkg/criocli.DefaultsPath=\"\" -X github.com/cri-o/cri-o/internal/version.buildDate='2021-09-24T23:47:06Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=cc58c8f9feaaa18ac540c7d136ab0f6455f882c3 -X github.com/cri-o/cri-o/internal/version.gitTreeState=clean ' -tags \"containers_image_ostree_stub  exclude_graphdriver_btrfs btrfs_noversion   containers_image_openpgp seccomp selinux \" -o bin/crio github.com/cri-o/cri-o/cmd/crio\ngo build -trimpath  -ldflags '-s -w -X github.com/cri-o/cri-o/internal/pkg/criocli.DefaultsPath=\"\" -X github.com/cri-o/cri-o/internal/version.buildDate='2021-09-24T23:49:07Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=cc58c8f9feaaa18ac540c7d136ab0f6455f882c3 -X github.com/cri-o/cri-o/internal/version.gitTreeState=clean ' -tags \"containers_image_ostree_stub  exclude_graphdriver_btrfs btrfs_noversion   containers_image_openpgp seccomp selinux \" -o bin/crio-status github.com/cri-o/cri-o/cmd/crio-status\n/bin/make -C pinns\nmake[1]: Entering directory `/go/src/github.com/cri-o/cri-o/pinns'\ncc -std=c99 -Os -Wall -Werror -Wextra -static -O3 -o src/sysctl.o -c src/sysctl.c\ncc -std=c99 -Os -Wall -Werror -Wextra -static -O3 -o src/pinns.o -c src/pinns.c\ncc -o ../bin/pinns src/sysctl.o src/pinns.o -std=c99 -Os -Wall -Werror -Wextra -static \nstrip -s ../bin/pinns\nmake[1]: Leaving directory `/go/src/github.com/cri-o/cri-o/pinns'\n./bin/crio -d \"\" --config=\"\"  config > crio.conf\n(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio-status.8.md -out docs/crio-status.8.tmp && touch docs/crio-status.8.tmp && mv docs/crio-status.8.tmp docs/crio-status.8) || \\\n\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio-status.8.md -out docs/crio-status.8.tmp && touch docs/crio-status.8.tmp && mv docs/crio-status.8.tmp docs/crio-status.8)\n(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.5.md -out docs/crio.conf.5.tmp && touch docs/crio.conf.5.tmp && mv docs/crio.conf.5.tmp docs/crio.conf.5) || \\\n\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.5.md -out docs/crio.conf.5.tmp && touch docs/crio.conf.5.tmp && mv docs/crio.conf.5.tmp docs/crio.conf.5)\n(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.d.5.md -out docs/crio.conf.d.5.tmp && touch docs/crio.conf.d.5.tmp && mv docs/crio.conf.d.5.tmp docs/crio.conf.d.5) || \\\n\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.d.5.md -out docs/crio.conf.d.5.tmp && touch docs/crio.conf.d.5.tmp && mv docs/crio.conf.d.5.tmp docs/crio.conf.d.5)\n(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.8.md -out docs/crio.8.tmp && touch docs/crio.8.tmp && mv docs/crio.8.tmp docs/crio.8) || \\\n\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.8.md -out docs/crio.8.tmp && touch docs/crio.8.tmp && mv docs/crio.8.tmp docs/crio.8)", "stdout_lines": ["touch \"/go/.gopathok\"", "go build -trimpath  -ldflags '-s -w -X github.com/cri-o/cri-o/internal/pkg/criocli.DefaultsPath=\"\" -X github.com/cri-o/cri-o/internal/version.buildDate='2021-09-24T23:47:06Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=cc58c8f9feaaa18ac540c7d136ab0f6455f882c3 -X github.com/cri-o/cri-o/internal/version.gitTreeState=clean ' -tags \"containers_image_ostree_stub  exclude_graphdriver_btrfs btrfs_noversion   containers_image_openpgp seccomp selinux \" -o bin/crio github.com/cri-o/cri-o/cmd/crio", "go build -trimpath  -ldflags '-s -w -X github.com/cri-o/cri-o/internal/pkg/criocli.DefaultsPath=\"\" -X github.com/cri-o/cri-o/internal/version.buildDate='2021-09-24T23:49:07Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=cc58c8f9feaaa18ac540c7d136ab0f6455f882c3 -X github.com/cri-o/cri-o/internal/version.gitTreeState=clean ' -tags \"containers_image_ostree_stub  exclude_graphdriver_btrfs btrfs_noversion   containers_image_openpgp seccomp selinux \" -o bin/crio-status github.com/cri-o/cri-o/cmd/crio-status", "/bin/make -C pinns", "make[1]: Entering directory `/go/src/github.com/cri-o/cri-o/pinns'", "cc -std=c99 -Os -Wall -Werror -Wextra -static -O3 -o src/sysctl.o -c src/sysctl.c", "cc -std=c99 -Os -Wall -Werror -Wextra -static -O3 -o src/pinns.o -c src/pinns.c", "cc -o ../bin/pinns src/sysctl.o src/pinns.o -std=c99 -Os -Wall -Werror -Wextra -static ", "strip -s ../bin/pinns", "make[1]: Leaving directory `/go/src/github.com/cri-o/cri-o/pinns'", "./bin/crio -d \"\" --config=\"\"  config > crio.conf", "(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio-status.8.md -out docs/crio-status.8.tmp && touch docs/crio-status.8.tmp && mv docs/crio-status.8.tmp docs/crio-status.8) || \\", "\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio-status.8.md -out docs/crio-status.8.tmp && touch docs/crio-status.8.tmp && mv docs/crio-status.8.tmp docs/crio-status.8)", "(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.5.md -out docs/crio.conf.5.tmp && touch docs/crio.conf.5.tmp && mv docs/crio.conf.5.tmp docs/crio.conf.5) || \\", "\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.5.md -out docs/crio.conf.5.tmp && touch docs/crio.conf.5.tmp && mv docs/crio.conf.5.tmp docs/crio.conf.5)", "(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.d.5.md -out docs/crio.conf.d.5.tmp && touch docs/crio.conf.d.5.tmp && mv docs/crio.conf.d.5.tmp docs/crio.conf.d.5) || \\", "\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.d.5.md -out docs/crio.conf.d.5.tmp && touch docs/crio.conf.d.5.tmp && mv docs/crio.conf.d.5.tmp docs/crio.conf.d.5)", "(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.8.md -out docs/crio.8.tmp && touch docs/crio.8.tmp && mv docs/crio.8.tmp docs/crio.8) || \\", "\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.8.md -out docs/crio.8.tmp && touch docs/crio.8.tmp && mv docs/crio.8.tmp docs/crio.8)"], "target": null}

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

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

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

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

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

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

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

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

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

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

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

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

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

TASK [install jq] **************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/jq.yml:2
ok: [localhost] => {"changed": false, "dest": "/usr/bin/jq", "gid": 0, "group": "root", "mode": "0775", "msg": "file already exists", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 3953824, "state": "file", "uid": 0, "url": "https://github.com/stedolan/jq/releases/download/jq-1.6/jq-linux64"}

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

TASK [build runc] **************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/runc.yml:9
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/opencontainers/runc", "params": {"BUILDTAGS": "seccomp selinux"}, "stderr": "", "stderr_lines": [], "stdout": "go build -trimpath \"-buildmode=pie\"  -tags \"seccomp selinux\" -ldflags \"-X main.gitCommit=v1.0.0-296-ge999e29 -X main.version=1.0.0+dev \" -o runc .", "stdout_lines": ["go build -trimpath \"-buildmode=pie\"  -tags \"seccomp selinux\" -ldflags \"-X main.gitCommit=v1.0.0-296-ge999e29 -X main.version=1.0.0+dev \" -o runc ."], "target": null}

TASK [install runc] ************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/runc.yml:14
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/opencontainers/runc", "params": null, "stderr": "", "stderr_lines": [], "stdout": "install -D -m0755 runc /usr/local/sbin/runc", "stdout_lines": ["install -D -m0755 runc /usr/local/sbin/runc"], "target": "install"}

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

TASK [set fs.may_detach_mounts = 1] ********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/main.yml:103
changed: [localhost] => {"changed": true}
META: ran handlers

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

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

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

TASK [Swap configuration does not persist across future reboots] ***************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/disable_swap.yml:18
META: ran handlers

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

TASK [Gathering Facts] *********************************************************
ok: [localhost]
META: ran handlers

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

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

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

TASK [download parallel sources] ***********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/parallel.yml:15
changed: [localhost] => {"changed": true, "dest": "/root", "extract_results": {"cmd": ["/bin/gtar", "--extract", "-C", "/root", "-f", "/tmp/ansible_eh1T4t/parallel-20190322.tar.bz2"], "err": "", "out": "", "rc": 0}, "gid": 0, "group": "root", "handler": "TarArchive", "mode": "0550", "owner": "root", "secontext": "system_u:object_r:admin_home_t:s0", "size": 275, "src": "/tmp/ansible_eh1T4t/parallel-20190322.tar.bz2", "state": "directory", "uid": 0}

TASK [install parallel from sources] *******************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/parallel.yml:22
changed: [localhost] => {"changed": true, "cmd": "./configure\n make\n cp ./src/{env_parallel*,niceload,parallel,parcat,parset,sql} /usr/bin\n ln -sf /usr/bin/parallel /usr/bin/sem", "delta": "0:00:01.277568", "end": "2021-09-24 23:53:32.772408", "rc": 0, "start": "2021-09-24 23:53:31.494840", "stderr": "", "stderr_lines": [], "stdout": "checking for a BSD-compatible install... /bin/install -c\nchecking whether build environment is sane... yes\nchecking for a thread-safe mkdir -p... /bin/mkdir -p\nchecking for gawk... gawk\nchecking whether make sets $(MAKE)... yes\nchecking whether make supports nested variables... yes\nchecking whether ln -s works... yes\nchecking that generated files are newer than configure... done\nconfigure: creating ./config.status\nconfig.status: creating Makefile\nconfig.status: creating src/Makefile\nconfig.status: creating config.h\nmake  all-recursive\nmake[1]: Entering directory `/root/parallel-20190322'\nMaking all in src\nmake[2]: Entering directory `/root/parallel-20190322/src'\nmake[2]: Nothing to be done for `all'.\nmake[2]: Leaving directory `/root/parallel-20190322/src'\nmake[2]: Entering directory `/root/parallel-20190322'\nmake[2]: Leaving directory `/root/parallel-20190322'\nmake[1]: Leaving directory `/root/parallel-20190322'", "stdout_lines": ["checking for a BSD-compatible install... /bin/install -c", "checking whether build environment is sane... yes", "checking for a thread-safe mkdir -p... /bin/mkdir -p", "checking for gawk... gawk", "checking whether make sets $(MAKE)... yes", "checking whether make supports nested variables... yes", "checking whether ln -s works... yes", "checking that generated files are newer than configure... done", "configure: creating ./config.status", "config.status: creating Makefile", "config.status: creating src/Makefile", "config.status: creating config.h", "make  all-recursive", "make[1]: Entering directory `/root/parallel-20190322'", "Making all in src", "make[2]: Entering directory `/root/parallel-20190322/src'", "make[2]: Nothing to be done for `all'.", "make[2]: Leaving directory `/root/parallel-20190322/src'", "make[2]: Entering directory `/root/parallel-20190322'", "make[2]: Leaving directory `/root/parallel-20190322'", "make[1]: Leaving directory `/root/parallel-20190322'"]}

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

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

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

TASK [Make testing output verbose so it can be converted to xunit] *************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/test.yml:3
changed: [localhost] => {"backup": "", "changed": true, "msg": "line replaced"}

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

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

TASK [skip tests not working in kata] ******************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/test.yml:23
skipping: [localhost] => (item=test "ctr lifecycle")  => {"changed": false, "item": "test \"ctr lifecycle\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr logging")  => {"changed": false, "item": "test \"ctr logging\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr journald logging")  => {"changed": false, "item": "test \"ctr journald logging\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr log max")  => {"changed": false, "item": "test \"ctr log max\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr log max with minimum value")  => {"changed": false, "item": "test \"ctr log max with minimum value\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr partial line logging")  => {"changed": false, "item": "test \"ctr partial line logging\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr execsync")  => {"changed": false, "item": "test \"ctr execsync\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr execsync should not overwrite initial spec args")  => {"changed": false, "item": "test \"ctr execsync should not overwrite initial spec args\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "privileged ctr device add")  => {"changed": false, "item": "test \"privileged ctr device add\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr execsync std{out,err}")  => {"changed": false, "item": "test \"ctr execsync std{out,err}\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr create with non-existent command")  => {"changed": false, "item": "test \"ctr create with non-existent command\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr create with non-existent command \[tty\]")  => {"changed": false, "item": "test \"ctr create with non-existent command \\[tty\\]\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr update resources")  => {"changed": false, "item": "test \"ctr update resources\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr resources")  => {"changed": false, "item": "test \"ctr resources\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr with non-root user has no effective capabilities")  => {"changed": false, "item": "test \"ctr with non-root user has no effective capabilities\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr with low memory configured should not be created")  => {"changed": false, "item": "test \"ctr with low memory configured should not be created\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "privileged ctr -- check for rw mounts")  => {"changed": false, "item": "test \"privileged ctr -- check for rw mounts\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "annotations passed through")  => {"changed": false, "item": "test \"annotations passed through\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr with default_env set in configuration")  => {"changed": false, "item": "test \"ctr with default_env set in configuration\"", "skip_reason": "Conditional result was False"}
skipping: [localhost] => (item=test "ctr with absent mount that should be rejected")  => {"changed": false, "item": "test \"ctr with absent mount that should be rejected\"", "skip_reason": "Conditional result was False"}

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

TASK [run integration tests] ***************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/test.yml:39
fatal: [localhost]: FAILED! => {"ansible_job_id": "972306866228.24975", "changed": true, "cmd": "make localintegration >& /tmp/artifacts/testout.txt", "delta": "0:22:11.069143", "end": "2021-09-25 00:16:49.450423", "finished": 1, "msg": "non-zero return code", "rc": 2, "start": "2021-09-24 23:54:38.381280", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}

TASK [Re-enable SELinux after integration tests] *******************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/test.yml:58
changed: [localhost] => {"changed": true, "cmd": ["setenforce", "1"], "delta": "0:00:00.004144", "end": "2021-09-25 00:16:52.882354", "rc": 0, "start": "2021-09-25 00:16:52.878210", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}
	to retry, use: --limit @/go/src/github.com/cri-o/cri-o/contrib/test/integration/main.retry

PLAY RECAP *********************************************************************
localhost                  : ok=39   changed=29   unreachable=0    failed=1   

++ export status=FAILURE
++ status=FAILURE
+ set +o xtrace
########## FINISHED STAGE: FAILURE: RUN THE CRI-O INTEGRATION TESTS [00h 34m 32s] ##########
Build step 'Execute shell' marked build as failure
[PostBuildScript] - [INFO] Executing post build scripts.
[workspace@4] $ /bin/bash /tmp/jenkins3848620555507151980.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat '/tmp/artifacts/*'
  File: ‘/tmp/artifacts/testout.txt’
  Size: 42096     	Blocks: 88         IO Block: 4096   regular file
Device: ca02h/51714d	Inode: 180634914   Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-09-24 23:54:38.383590839 +0000
Modify: 2021-09-25 00:16:46.501095233 +0000
Change: 2021-09-25 00:16:46.501095233 +0000
 Birth: -
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config 'openshiftdevel:/tmp/artifacts/*' /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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: ca02h/51714d	Inode: 100854502   Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:container_config_t:s0
Access: 2021-09-24 23:57:11.078169209 +0000
Modify: 2021-09-24 23:52:51.210575179 +0000
Change: 2021-09-24 23:52:51.210575179 +0000
 Birth: -
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/etc/crio/crio.conf /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/gathered
+ tree /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/gathered
/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/gathered
├── crio.conf
└── testout.txt

0 directories, 2 files
+ exit 0
[workspace@4] $ /bin/bash /tmp/jenkins6716419295182743096.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/generated
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo yum list installed 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/artifacts/generated
/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/generated
├── avc_denials.log
├── filesystem.info
├── installed_packages.log
├── pid1.journal
└── system.journal

0 directories, 5 files
+ exit 0
[workspace@4] $ /bin/bash /tmp/jenkins7795558690063705489.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/journals
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/.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_integration_rhel/workspace@4/artifacts/journals
/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/journals
├── crio.service
├── customcluster.service
└── systemd-journald.service

0 directories, 3 files
+ exit 0
[workspace@4] $ /bin/bash /tmp/jenkins8286879347324155257.sh
########## STARTING STAGE: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
++ mktemp
+ script=/tmp/tmp.WvHO86Mcjc
+ cat
+ chmod +x /tmp/tmp.WvHO86Mcjc
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.WvHO86Mcjc openshiftdevel:/tmp/tmp.WvHO86Mcjc
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.WvHO86Mcjc"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ sudo mkdir -p /data/gcs
+ sudo chown -R origin:origin /data
+ grep -q 'ID="centos"' /etc/os-release
+ grep -q 'ID="rhel"' /etc/os-release
+ sudo yum install -y https://dl.fedoraproject.org/pub/epel/epel-release-latest-7.noarch.rpm
Loaded plugins: amazon-id, search-disabled-repos
Examining /var/tmp/yum-root-o9z3St/epel-release-latest-7.noarch.rpm: epel-release-7-14.noarch
Marking /var/tmp/yum-root-o9z3St/epel-release-latest-7.noarch.rpm to be installed
Resolving Dependencies
--> Running transaction check
---> Package epel-release.noarch 0:7-14 will be installed
--> Finished Dependency Resolution

Dependencies Resolved

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

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

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

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

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

Dependencies Resolved

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

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

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

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

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

Complete!
+ sudo systemctl enable --now docker
Created symlink from /etc/systemd/system/multi-user.target.wants/docker.service to /usr/lib/systemd/system/docker.service.
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD [00h 01m 51s] ##########
[workspace@4] $ /bin/bash /tmp/jenkins275273793133393901.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.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_integration_rhel/24923/api/json'\''))['\''result'\'']'
+ result=FAILURE
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/builds/24923/log
+ cp -r artifacts/gathered/crio.conf artifacts/gathered/testout.txt 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_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/gcs openshiftdevel:/data
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config /var/lib/jenkins/.config/gcloud/gcs-publisher-credentials.json openshiftdevel:/data/credentials.json
+ exit 0
[workspace@4] $ /bin/bash /tmp/jenkins754341691426948853.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
++ mktemp
+ script=/tmp/tmp.ajQsmg8wCx
+ cat
+ chmod +x /tmp/tmp.ajQsmg8wCx
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.ajQsmg8wCx openshiftdevel:/tmp/tmp.ajQsmg8wCx
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.ajQsmg8wCx"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"presubmit","job":"test_pull_request_crio_integration_rhel","buildid":"1441548010113732617","prowjobid":"a7b12211-1d90-11ec-9214-0a580a8048c6","refs":{"org":"cri-o","repo":"cri-o","base_ref":"main","base_sha":"8bb79b890d1069466ca9520f88883870acbb51b0","pulls":[{"number":5347,"author":"harche","sha":"d56449c4c4c04c939ae34f332a015736216f2edb","title":"bump crio commit for node e2e installer"}]}} ]]
++ jq --compact-output '.buildid |= "24923"'
+ JOB_SPEC='{"type":"presubmit","job":"test_pull_request_crio_integration_rhel","buildid":"24923","prowjobid":"a7b12211-1d90-11ec-9214-0a580a8048c6","refs":{"org":"cri-o","repo":"cri-o","base_ref":"main","base_sha":"8bb79b890d1069466ca9520f88883870acbb51b0","pulls":[{"number":5347,"author":"harche","sha":"d56449c4c4c04c939ae34f332a015736216f2edb","title":"bump crio commit for node e2e installer"}]}}'
+ sudo docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_crio_integration_rhel","buildid":"24923","prowjobid":"a7b12211-1d90-11ec-9214-0a580a8048c6","refs":{"org":"cri-o","repo":"cri-o","base_ref":"main","base_sha":"8bb79b890d1069466ca9520f88883870acbb51b0","pulls":[{"number":5347,"author":"harche","sha":"d56449c4c4c04c939ae34f332a015736216f2edb","title":"bump crio commit for node e2e installer"}]}}' -v /data:/data:z registry.ci.openshift.org/ci/gcsupload:latest --dry-run=false --gcs-path=gs://origin-federated-results --gcs-credentials-file=/data/credentials.json /data/gcs/artifacts /data/gcs/build-log.txt /data/gcs/finished.json /data/gcs/started.json
Unable to find image 'registry.ci.openshift.org/ci/gcsupload:latest' locally
Trying to pull repository registry.ci.openshift.org/ci/gcsupload ... 
latest: Pulling from registry.ci.openshift.org/ci/gcsupload
df20fa9351a1: Pulling fs layer
809b39f1848e: Pulling fs layer
a90eeda06cad: Pulling fs layer
85cea451eec0: Pulling fs layer
85cea451eec0: Waiting
809b39f1848e: Verifying Checksum
809b39f1848e: Download complete
df20fa9351a1: Verifying Checksum
df20fa9351a1: Download complete
85cea451eec0: Verifying Checksum
85cea451eec0: Download complete
a90eeda06cad: Verifying Checksum
a90eeda06cad: Download complete
df20fa9351a1: Pull complete
809b39f1848e: Pull complete
a90eeda06cad: Pull complete
85cea451eec0: Pull complete
Digest: sha256:9f0c47dc4ac77300a4dcd04817c2a7f3929aeffb6774e4a0176c8492e6139f9f
Status: Downloaded newer image for registry.ci.openshift.org/ci/gcsupload:latest
{"component":"gcsupload","file":"prow/gcsupload/run.go:194","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts","level":"info","msg":"Gathering artifacts from artifact directory: /data/gcs/artifacts","severity":"info","time":"2021-09-25T00:19:03Z"}
{"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/5347/test_pull_request_crio_integration_rhel/24923/artifacts/crio.conf\n","severity":"info","time":"2021-09-25T00:19:03Z"}
{"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/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/avc_denials.log\n","severity":"info","time":"2021-09-25T00:19:03Z"}
{"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/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/filesystem.info\n","severity":"info","time":"2021-09-25T00:19:03Z"}
{"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/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/installed_packages.log\n","severity":"info","time":"2021-09-25T00:19:03Z"}
{"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/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/pid1.journal\n","severity":"info","time":"2021-09-25T00:19:03Z"}
{"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/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/system.journal\n","severity":"info","time":"2021-09-25T00:19:03Z"}
{"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/5347/test_pull_request_crio_integration_rhel/24923/artifacts/journals/crio.service\n","severity":"info","time":"2021-09-25T00:19:03Z"}
{"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/5347/test_pull_request_crio_integration_rhel/24923/artifacts/journals/customcluster.service\n","severity":"info","time":"2021-09-25T00:19:03Z"}
{"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/5347/test_pull_request_crio_integration_rhel/24923/artifacts/journals/systemd-journald.service\n","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/testout.txt in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/testout.txt\n","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/build-log.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_integration_rhel/24923.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_integration_rhel/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/crio.conf","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/filesystem.info","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/system.journal","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/journals/crio.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/testout.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/installed_packages.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/finished.json","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/started.json","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/journals/systemd-journald.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/avc_denials.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/pid1.journal","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/journals/customcluster.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-09-25T00:19:03Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/crio.conf","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/build-log.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/journals/customcluster.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_integration_rhel/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/filesystem.info","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/pid1.journal","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_integration_rhel/24923.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/system.journal","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/journals/systemd-journald.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/journals/crio.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/avc_denials.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/started.json","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/generated/installed_packages.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/artifacts/testout.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5347/test_pull_request_crio_integration_rhel/24923/finished.json","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:78","func":"k8s.io/test-infra/prow/gcsupload.completeUpload","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2021-09-25T00:19:04Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:78","func":"k8s.io/test-infra/prow/gcsupload.completeUpload","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2021-09-25T00:19:04Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 05s] ##########
[workspace@4] $ /bin/bash /tmp/jenkins8464847827157519563.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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_integration_rhel/workspace@4/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config
+ oct deprovision

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

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

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

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

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

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

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

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

TASK [tear down the EC2 instance] **********************************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:15
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2021-09-24 20:19:09.490935", 
    "instance_ids": [
        "i-0d913e75f073426c0"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-011408dae02f2b7fb"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0a6457b29f9315f9b"
                }
            }, 
            "dns_name": "ec2-54-162-20-224.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-0d913e75f073426c0", 
            "image_id": "ami-0db1bcec6bfd5a39f", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2021-09-24T23:41:01.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-4-240.ec2.internal", 
            "private_ip": "172.18.4.240", 
            "public_dns_name": "ec2-54-162-20-224.compute-1.amazonaws.com", 
            "public_ip": "54.162.20.224", 
            "ramdisk": null, 
            "region": "us-east-1", 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "running", 
            "state_code": 16, 
            "tags": {
                "Name": "oct-terminate", 
                "openshift_etcd": "", 
                "openshift_master": "", 
                "openshift_node": ""
            }, 
            "tenancy": "default", 
            "virtualization_type": "hvm"
        }
    ], 
    "tagged_instances": []
}

TASK [remove the serialized host variables] ************************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:22
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2021-09-24 20:19:09.761462", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory/host_vars/172.18.4.240.yml", 
    "state": "absent"
}

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

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

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

TASK [remove inventory configuration directory] ********************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:61
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2021-09-24 20:19:10.479144", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/.config/origin-ci-tool/inventory", 
    "state": "absent"
}

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

+ set +o xtrace
########## FINISHED STAGE: SUCCESS: DEPROVISION CLOUD RESOURCES [00h 00m 05s] ##########
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
sent [/var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/artifacts/generated/installed_packages.log, /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/gcs/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/test_pull_request_crio_integration_rhel/workspace@4/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