FailedConsole Output

Started by user OpenShift CI Robot
Running as SYSTEM
[EnvInject] - Loading node environment variables.
Building in workspace /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace
[WS-CLEANUP] Deleting project workspace...
[WS-CLEANUP] Deferred wipeout is used...
[workspace] $ /bin/bash /tmp/jenkins6739415672140614484.sh
########## STARTING STAGE: INSTALL THE ORIGIN-CI-TOOL ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate ]]
++ readlink /var/lib/jenkins/origin-ci-tool/latest
+ latest=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
+ touch /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
+ cp /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin/activate /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
+ cat
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool
+ oct configure ansible-client verbosity 2
Option verbosity updated to be 2.
+ oct configure aws-client keypair_name openshift-dev
Option keypair_name updated to be openshift-dev.
+ oct configure aws-client private_key_path /var/lib/jenkins/.ssh/openshift-dev.pem
Option private_key_path updated to be /var/lib/jenkins/.ssh/openshift-dev.pem.
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: INSTALL THE ORIGIN-CI-TOOL [00h 00m 04s] ##########
[workspace] $ /bin/bash /tmp/jenkins5057242802774828154.sh
########## STARTING STAGE: PROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
+ oct provision remote all-in-one --os fedora --stage crio --provider aws --discrete-ssh-config --name test_pull_request_crio_e2e_crun_fedora_13240

PLAYBOOK: aws-up.yml ***********************************************************
2 plays in /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/aws-up.yml

PLAY [ensure we have the parameters necessary to bring up the AWS EC2 instance] ***

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/provision/aws-up.yml:9
skipping: [localhost] => (item=origin_ci_aws_keypair_name)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.583082", 
    "item": "origin_ci_aws_keypair_name", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_inventory_dir)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.585202", 
    "item": "origin_ci_inventory_dir", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_hostname)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.701342", 
    "item": "origin_ci_aws_hostname", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_identifying_tag_key)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.702788", 
    "item": "origin_ci_aws_identifying_tag_key", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_master_instance_type)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.703950", 
    "item": "origin_ci_aws_master_instance_type", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_instance_name)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.705151", 
    "item": "origin_ci_aws_instance_name", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_ami_tags)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.706338", 
    "item": "origin_ci_aws_ami_tags", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.707538", 
    "item": "origin_ci_aws_region", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_private_key_path)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.708736", 
    "item": "origin_ci_aws_private_key_path", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=openshift_node_labels)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.721982", 
    "item": "openshift_node_labels", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=openshift_schedulable)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.723072", 
    "item": "openshift_schedulable", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_ssh_config_strategy)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.724209", 
    "item": "origin_ci_ssh_config_strategy", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}

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/provision/aws-up.yml:27
skipping: [localhost] => (item=origin_ci_aws_etcd_security_group)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.935400", 
    "item": "origin_ci_aws_etcd_security_group", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_master_subnet)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.937410", 
    "item": "origin_ci_aws_master_subnet", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_master_security_group)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.950334", 
    "item": "origin_ci_aws_master_security_group", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_node_security_group)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.951558", 
    "item": "origin_ci_aws_node_security_group", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_master_external_elb_security_group)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.969550", 
    "item": "origin_ci_aws_master_external_elb_security_group", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_master_internal_elb_security_group)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.982089", 
    "item": "origin_ci_aws_master_internal_elb_security_group", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_router_security_group)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:12.994139", 
    "item": "origin_ci_aws_router_security_group", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_router_elb_security_group)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:13.019738", 
    "item": "origin_ci_aws_router_elb_security_group", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}

PLAY [provision an AWS EC2 instance] *******************************************

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

TASK [inventory : initialize the inventory directory] **************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/inventory/tasks/main.yml:2
ok: [localhost] => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:15.483994", 
    "gid": 995, 
    "group": "jenkins", 
    "mode": "0755", 
    "owner": "jenkins", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 6, 
    "state": "directory", 
    "uid": 997
}

TASK [inventory : add the nested group mapping] ********************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/inventory/tasks/main.yml:7
changed: [localhost] => {
    "changed": true, 
    "checksum": "18aaee00994df38cc3a63b635893175235331a9c", 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/nested_group_mappings", 
    "generated_timestamp": "2020-11-25 05:28:17.086898", 
    "gid": 995, 
    "group": "jenkins", 
    "md5sum": "b30c3226ea63efa3ff9c5e346c14a16e", 
    "mode": "0644", 
    "owner": "jenkins", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 93, 
    "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1606300096.16-138676570738459/source", 
    "state": "file", 
    "uid": 997
}

TASK [inventory : initialize the OSEv3 group variables directory] **************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/inventory/tasks/main.yml:12
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2020-11-25 05:28:17.555803", 
    "gid": 995, 
    "group": "jenkins", 
    "mode": "0755", 
    "owner": "jenkins", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/group_vars/OSEv3", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 6, 
    "state": "directory", 
    "uid": 997
}

TASK [inventory : initialize the host variables directory] *********************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/inventory/tasks/main.yml:17
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2020-11-25 05:28:18.023220", 
    "gid": 995, 
    "group": "jenkins", 
    "mode": "0755", 
    "owner": "jenkins", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/host_vars", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 6, 
    "state": "directory", 
    "uid": 997
}

TASK [inventory : add the default Origin installation configuration] ***********
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/inventory/tasks/main.yml:22
changed: [localhost] => {
    "changed": true, 
    "checksum": "4c06ba508f055c20f13426e8587342e8765a7b66", 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/group_vars/OSEv3/general.yml", 
    "generated_timestamp": "2020-11-25 05:28:18.821546", 
    "gid": 995, 
    "group": "jenkins", 
    "md5sum": "8aec71c75f7d512b278ae7c6f2959b12", 
    "mode": "0644", 
    "owner": "jenkins", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 331, 
    "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1606300098.4-200608068750218/source", 
    "state": "file", 
    "uid": 997
}

TASK [aws-up : determine if we are inside AWS EC2] *****************************
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:2
changed: [localhost] => {
    "changed": true, 
    "cmd": [
        "curl", 
        "-s", 
        "http://instance-data.ec2.internal"
    ], 
    "delta": "0:00:00.065799", 
    "end": "2020-11-25 05:28:19.449140", 
    "failed": false, 
    "failed_when_result": false, 
    "generated_timestamp": "2020-11-25 05:28:19.486674", 
    "rc": 0, 
    "start": "2020-11-25 05:28:19.383341", 
    "stderr": [], 
    "stdout": [
        "1.0", 
        "2007-01-19", 
        "2007-03-01", 
        "2007-08-29", 
        "2007-10-10", 
        "2007-12-15", 
        "2008-02-01", 
        "2008-09-01", 
        "2009-04-04", 
        "2011-01-01", 
        "2011-05-01", 
        "2012-01-12", 
        "2014-02-25", 
        "2014-11-05", 
        "2015-10-20", 
        "2016-04-19", 
        "2016-06-30", 
        "2016-09-02", 
        "2018-03-28", 
        "2018-08-17", 
        "2018-09-24", 
        "2019-10-01", 
        "2020-10-27", 
        "latest"
    ], 
    "warnings": [
        "Consider using get_url or uri module rather than running curl"
    ]
}
 [WARNING]: Consider using get_url or uri module rather than running curl

TASK [aws-up : configure EC2 parameters for inventory when controlling from inside EC2] ***
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:7
ok: [localhost] => {
    "ansible_facts": {
        "origin_ci_aws_destination_variable": "private_dns_name", 
        "origin_ci_aws_host_address_variable": "private_ip", 
        "origin_ci_aws_vpc_destination_variable": "private_ip_address"
    }, 
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:19.560619"
}

TASK [aws-up : determine where to put the AWS API cache] ***********************
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:14
ok: [localhost] => {
    "ansible_facts": {
        "origin_ci_aws_cache_dir": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ec2_cache"
    }, 
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:19.644203"
}

TASK [aws-up : ensure we have a place to put the AWS API cache] ****************
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:18
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2020-11-25 05:28:20.109849", 
    "gid": 995, 
    "group": "jenkins", 
    "mode": "0755", 
    "owner": "jenkins", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ec2_cache", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 6, 
    "state": "directory", 
    "uid": 997
}

TASK [aws-up : place the EC2 dynamic inventory script] *************************
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:23
changed: [localhost] => {
    "changed": true, 
    "checksum": "625b8af723189db3b96ba0026d0f997a0025bc47", 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/ec2.py", 
    "generated_timestamp": "2020-11-25 05:28:21.023466", 
    "gid": 995, 
    "group": "jenkins", 
    "md5sum": "cac06c14065dac74904232b89d4ba24c", 
    "mode": "0755", 
    "owner": "jenkins", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 63725, 
    "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1606300100.51-176742850819917/source", 
    "state": "file", 
    "uid": 997
}

TASK [aws-up : place the EC2 dynamic inventory 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:29
changed: [localhost] => {
    "changed": true, 
    "checksum": "bd3c41acf7a4082c7e8051f66df7d83033abfd57", 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/ec2.ini", 
    "generated_timestamp": "2020-11-25 05:28:21.979430", 
    "gid": 995, 
    "group": "jenkins", 
    "md5sum": "99d88f929fd8c488efe6fd1a65a132d1", 
    "mode": "0644", 
    "owner": "jenkins", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 401, 
    "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1606300101.1-107789050861425/source", 
    "state": "file", 
    "uid": 997
}

TASK [aws-up : place the EC2 tag to group mappings] ****************************
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:34
changed: [localhost] => {
    "changed": true, 
    "checksum": "b4205a33dc73f62bd4f77f35d045cf8e09ae62b0", 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/tag_to_group_mappings", 
    "generated_timestamp": "2020-11-25 05:28:22.835695", 
    "gid": 995, 
    "group": "jenkins", 
    "md5sum": "bc3a567a1b6f342e1005182efc1b66be", 
    "mode": "0644", 
    "owner": "jenkins", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 287, 
    "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1606300102.45-80112350756940/source", 
    "state": "file", 
    "uid": 997
}

TASK [aws-up : list available AMIs] ********************************************
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:40
ok: [localhost] => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:26.488723", 
    "results": [
        {
            "ami_id": "ami-06d2f8939bc509e2f", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 75, 
                    "snapshot_id": "snap-00d6307db5d8bf316", 
                    "volume_type": "gp2"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 50, 
                    "snapshot_id": "snap-0d99d2b40ed30e73c", 
                    "volume_type": "gp2"
                }
            }, 
            "creationDate": "2020-05-27T12:57:01.000Z", 
            "description": "OpenShift Origin development AMI on fedora at the crio stage.", 
            "hypervisor": "xen", 
            "is_public": false, 
            "location": "531415883065/test_pull_request_crio_ami_fedora_562", 
            "name": "test_pull_request_crio_ami_fedora_562", 
            "owner_id": "531415883065", 
            "platform": null, 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "available", 
            "tags": {
                "Name": "test_pull_request_crio_ami_fedora_562", 
                "image_stage": "crio", 
                "operating_system": "fedora", 
                "ready": "yes"
            }, 
            "virtualization_type": "hvm"
        }, 
        {
            "ami_id": "ami-0371f2fdbea3bf7e7", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 75, 
                    "snapshot_id": "snap-0abb9da39c3bd80af", 
                    "volume_type": "gp2"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 50, 
                    "snapshot_id": "snap-07848c682bef0f2a3", 
                    "volume_type": "gp2"
                }
            }, 
            "creationDate": "2020-05-29T21:07:28.000Z", 
            "description": "OpenShift Origin development AMI on fedora at the crio stage.", 
            "hypervisor": "xen", 
            "is_public": false, 
            "location": "531415883065/test_pull_request_crio_ami_fedora_565", 
            "name": "test_pull_request_crio_ami_fedora_565", 
            "owner_id": "531415883065", 
            "platform": null, 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "available", 
            "tags": {
                "Name": "test_pull_request_crio_ami_fedora_565", 
                "image_stage": "crio", 
                "operating_system": "fedora", 
                "ready": "yes"
            }, 
            "virtualization_type": "hvm"
        }, 
        {
            "ami_id": "ami-01cb12bbd8f7c2d59", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 75, 
                    "snapshot_id": "snap-08241ec4eeb84f0d5", 
                    "volume_type": "gp2"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 50, 
                    "snapshot_id": "snap-04d4be9ea012e0034", 
                    "volume_type": "gp2"
                }
            }, 
            "creationDate": "2020-09-02T23:11:46.000Z", 
            "description": "OpenShift Origin development AMI on fedora at the crio stage.", 
            "hypervisor": "xen", 
            "is_public": false, 
            "location": "531415883065/ami_build_origin_int_fedora_crio_1087", 
            "name": "ami_build_origin_int_fedora_crio_1087", 
            "owner_id": "531415883065", 
            "platform": null, 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "available", 
            "tags": {
                "Name": "ami_build_origin_int_fedora_crio_1087", 
                "image_stage": "crio", 
                "operating_system": "fedora", 
                "ready": "yes"
            }, 
            "virtualization_type": "hvm"
        }, 
        {
            "ami_id": "ami-0055f2e7709c69f59", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 75, 
                    "snapshot_id": "snap-08c0bf0026d7fa42e", 
                    "volume_type": "gp2"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 50, 
                    "snapshot_id": "snap-099da99bf8f8badb9", 
                    "volume_type": "gp2"
                }
            }, 
            "creationDate": "2020-09-03T23:12:33.000Z", 
            "description": "OpenShift Origin development AMI on fedora at the crio stage.", 
            "hypervisor": "xen", 
            "is_public": false, 
            "location": "531415883065/ami_build_origin_int_fedora_crio_1088", 
            "name": "ami_build_origin_int_fedora_crio_1088", 
            "owner_id": "531415883065", 
            "platform": null, 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "available", 
            "tags": {
                "Name": "ami_build_origin_int_fedora_crio_1088", 
                "image_stage": "crio", 
                "operating_system": "fedora", 
                "ready": "yes"
            }, 
            "virtualization_type": "hvm"
        }
    ]
}

TASK [aws-up : choose appropriate AMIs for 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:49
ok: [localhost] => (item={u'ami_id': u'ami-06d2f8939bc509e2f', u'root_device_type': u'ebs', u'description': u'OpenShift Origin development AMI on fedora at the crio stage.', u'tags': {u'ready': u'yes', u'image_stage': u'crio', u'Name': u'test_pull_request_crio_ami_fedora_562', u'operating_system': u'fedora'}, u'hypervisor': u'xen', u'block_device_mapping': {u'/dev/sdb': {u'encrypted': False, u'snapshot_id': u'snap-0d99d2b40ed30e73c', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 50}, u'/dev/sda1': {u'encrypted': False, u'snapshot_id': u'snap-00d6307db5d8bf316', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 75}}, u'architecture': u'x86_64', u'owner_id': u'531415883065', u'platform': None, u'state': u'available', u'location': u'531415883065/test_pull_request_crio_ami_fedora_562', u'is_public': False, u'creationDate': u'2020-05-27T12:57:01.000Z', u'root_device_name': u'/dev/sda1', u'virtualization_type': u'hvm', u'name': u'test_pull_request_crio_ami_fedora_562'}) => {
    "ansible_facts": {
        "origin_ci_aws_ami_id_candidate": "ami-06d2f8939bc509e2f"
    }, 
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:26.654160", 
    "item": {
        "ami_id": "ami-06d2f8939bc509e2f", 
        "architecture": "x86_64", 
        "block_device_mapping": {
            "/dev/sda1": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 75, 
                "snapshot_id": "snap-00d6307db5d8bf316", 
                "volume_type": "gp2"
            }, 
            "/dev/sdb": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 50, 
                "snapshot_id": "snap-0d99d2b40ed30e73c", 
                "volume_type": "gp2"
            }
        }, 
        "creationDate": "2020-05-27T12:57:01.000Z", 
        "description": "OpenShift Origin development AMI on fedora at the crio stage.", 
        "hypervisor": "xen", 
        "is_public": false, 
        "location": "531415883065/test_pull_request_crio_ami_fedora_562", 
        "name": "test_pull_request_crio_ami_fedora_562", 
        "owner_id": "531415883065", 
        "platform": null, 
        "root_device_name": "/dev/sda1", 
        "root_device_type": "ebs", 
        "state": "available", 
        "tags": {
            "Name": "test_pull_request_crio_ami_fedora_562", 
            "image_stage": "crio", 
            "operating_system": "fedora", 
            "ready": "yes"
        }, 
        "virtualization_type": "hvm"
    }
}
ok: [localhost] => (item={u'ami_id': u'ami-01cb12bbd8f7c2d59', u'root_device_type': u'ebs', u'description': u'OpenShift Origin development AMI on fedora at the crio stage.', u'tags': {u'ready': u'yes', u'image_stage': u'crio', u'Name': u'ami_build_origin_int_fedora_crio_1087', u'operating_system': u'fedora'}, u'hypervisor': u'xen', u'block_device_mapping': {u'/dev/sdb': {u'encrypted': False, u'snapshot_id': u'snap-04d4be9ea012e0034', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 50}, u'/dev/sda1': {u'encrypted': False, u'snapshot_id': u'snap-08241ec4eeb84f0d5', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 75}}, u'architecture': u'x86_64', u'owner_id': u'531415883065', u'platform': None, u'state': u'available', u'location': u'531415883065/ami_build_origin_int_fedora_crio_1087', u'is_public': False, u'creationDate': u'2020-09-02T23:11:46.000Z', u'root_device_name': u'/dev/sda1', u'virtualization_type': u'hvm', u'name': u'ami_build_origin_int_fedora_crio_1087'}) => {
    "ansible_facts": {
        "origin_ci_aws_ami_id_candidate": "ami-01cb12bbd8f7c2d59"
    }, 
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:26.674748", 
    "item": {
        "ami_id": "ami-01cb12bbd8f7c2d59", 
        "architecture": "x86_64", 
        "block_device_mapping": {
            "/dev/sda1": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 75, 
                "snapshot_id": "snap-08241ec4eeb84f0d5", 
                "volume_type": "gp2"
            }, 
            "/dev/sdb": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 50, 
                "snapshot_id": "snap-04d4be9ea012e0034", 
                "volume_type": "gp2"
            }
        }, 
        "creationDate": "2020-09-02T23:11:46.000Z", 
        "description": "OpenShift Origin development AMI on fedora at the crio stage.", 
        "hypervisor": "xen", 
        "is_public": false, 
        "location": "531415883065/ami_build_origin_int_fedora_crio_1087", 
        "name": "ami_build_origin_int_fedora_crio_1087", 
        "owner_id": "531415883065", 
        "platform": null, 
        "root_device_name": "/dev/sda1", 
        "root_device_type": "ebs", 
        "state": "available", 
        "tags": {
            "Name": "ami_build_origin_int_fedora_crio_1087", 
            "image_stage": "crio", 
            "operating_system": "fedora", 
            "ready": "yes"
        }, 
        "virtualization_type": "hvm"
    }
}
ok: [localhost] => (item={u'ami_id': u'ami-0371f2fdbea3bf7e7', u'root_device_type': u'ebs', u'description': u'OpenShift Origin development AMI on fedora at the crio stage.', u'tags': {u'ready': u'yes', u'operating_system': u'fedora', u'image_stage': u'crio', u'Name': u'test_pull_request_crio_ami_fedora_565'}, u'hypervisor': u'xen', u'block_device_mapping': {u'/dev/sdb': {u'encrypted': False, u'snapshot_id': u'snap-07848c682bef0f2a3', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 50}, u'/dev/sda1': {u'encrypted': False, u'snapshot_id': u'snap-0abb9da39c3bd80af', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 75}}, u'architecture': u'x86_64', u'owner_id': u'531415883065', u'platform': None, u'state': u'available', u'location': u'531415883065/test_pull_request_crio_ami_fedora_565', u'is_public': False, u'creationDate': u'2020-05-29T21:07:28.000Z', u'root_device_name': u'/dev/sda1', u'virtualization_type': u'hvm', u'name': u'test_pull_request_crio_ami_fedora_565'}) => {
    "ansible_facts": {
        "origin_ci_aws_ami_id_candidate": "ami-0371f2fdbea3bf7e7"
    }, 
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:26.678177", 
    "item": {
        "ami_id": "ami-0371f2fdbea3bf7e7", 
        "architecture": "x86_64", 
        "block_device_mapping": {
            "/dev/sda1": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 75, 
                "snapshot_id": "snap-0abb9da39c3bd80af", 
                "volume_type": "gp2"
            }, 
            "/dev/sdb": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 50, 
                "snapshot_id": "snap-07848c682bef0f2a3", 
                "volume_type": "gp2"
            }
        }, 
        "creationDate": "2020-05-29T21:07:28.000Z", 
        "description": "OpenShift Origin development AMI on fedora at the crio stage.", 
        "hypervisor": "xen", 
        "is_public": false, 
        "location": "531415883065/test_pull_request_crio_ami_fedora_565", 
        "name": "test_pull_request_crio_ami_fedora_565", 
        "owner_id": "531415883065", 
        "platform": null, 
        "root_device_name": "/dev/sda1", 
        "root_device_type": "ebs", 
        "state": "available", 
        "tags": {
            "Name": "test_pull_request_crio_ami_fedora_565", 
            "image_stage": "crio", 
            "operating_system": "fedora", 
            "ready": "yes"
        }, 
        "virtualization_type": "hvm"
    }
}
ok: [localhost] => (item={u'ami_id': u'ami-0055f2e7709c69f59', u'root_device_type': u'ebs', u'description': u'OpenShift Origin development AMI on fedora at the crio stage.', u'tags': {u'ready': u'yes', u'image_stage': u'crio', u'Name': u'ami_build_origin_int_fedora_crio_1088', u'operating_system': u'fedora'}, u'hypervisor': u'xen', u'block_device_mapping': {u'/dev/sdb': {u'encrypted': False, u'snapshot_id': u'snap-099da99bf8f8badb9', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 50}, u'/dev/sda1': {u'encrypted': False, u'snapshot_id': u'snap-08c0bf0026d7fa42e', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 75}}, u'architecture': u'x86_64', u'owner_id': u'531415883065', u'platform': None, u'state': u'available', u'location': u'531415883065/ami_build_origin_int_fedora_crio_1088', u'is_public': False, u'creationDate': u'2020-09-03T23:12:33.000Z', u'root_device_name': u'/dev/sda1', u'virtualization_type': u'hvm', u'name': u'ami_build_origin_int_fedora_crio_1088'}) => {
    "ansible_facts": {
        "origin_ci_aws_ami_id_candidate": "ami-0055f2e7709c69f59"
    }, 
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:26.692405", 
    "item": {
        "ami_id": "ami-0055f2e7709c69f59", 
        "architecture": "x86_64", 
        "block_device_mapping": {
            "/dev/sda1": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 75, 
                "snapshot_id": "snap-08c0bf0026d7fa42e", 
                "volume_type": "gp2"
            }, 
            "/dev/sdb": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 50, 
                "snapshot_id": "snap-099da99bf8f8badb9", 
                "volume_type": "gp2"
            }
        }, 
        "creationDate": "2020-09-03T23:12:33.000Z", 
        "description": "OpenShift Origin development AMI on fedora at the crio stage.", 
        "hypervisor": "xen", 
        "is_public": false, 
        "location": "531415883065/ami_build_origin_int_fedora_crio_1088", 
        "name": "ami_build_origin_int_fedora_crio_1088", 
        "owner_id": "531415883065", 
        "platform": null, 
        "root_device_name": "/dev/sda1", 
        "root_device_type": "ebs", 
        "state": "available", 
        "tags": {
            "Name": "ami_build_origin_int_fedora_crio_1088", 
            "image_stage": "crio", 
            "operating_system": "fedora", 
            "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-0055f2e7709c69f59"
    }, 
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:26.837521"
}

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": "2020-11-25 05:28:28.279440", 
    "subnets": [
        {
            "availability_zone": "us-east-1d", 
            "available_ip_address_count": 3938, 
            "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": "2020-11-25 05:28:28.423485"
}

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": "2020-11-25 05:28:30.203548", 
    "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": 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": "213.175.37.9/32"
                        }, 
                        {
                            "cidr_ip": "38.140.108.0/24"
                        }, 
                        {
                            "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"
                        }, 
                        {
                            "cidr_ip": "62.40.79.66/32"
                        }, 
                        {
                            "cidr_ip": "66.187.224.0/20"
                        }, 
                        {
                            "cidr_ip": "66.187.239.0/24"
                        }
                    ], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "to_port": 8444, 
                    "user_id_group_pairs": []
                }, 
                {
                    "from_port": 80, 
                    "ip_protocol": "tcp", 
                    "ip_ranges": [
                        {
                            "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"
                        }, 
                        {
                            "cidr_ip": "54.241.19.245/32"
                        }, 
                        {
                            "cidr_ip": "97.65.119.184/29"
                        }
                    ], 
                    "ipv6_ranges": [], 
                    "prefix_list_ids": [], 
                    "to_port": 443, 
                    "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": -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": "2020-11-25 05:28:30.378920"
}

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": "2020-11-25 05:28:49.144377", 
    "instance_ids": [
        "i-02bf7cd3a8819824a"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-07246ebcbee26489d"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0bca549594b4145d6"
                }
            }, 
            "dns_name": "ec2-54-145-151-245.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-02bf7cd3a8819824a", 
            "image_id": "ami-0055f2e7709c69f59", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2020-11-25T10:28:32.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-2-217.ec2.internal", 
            "private_ip": "172.18.2.217", 
            "public_dns_name": "ec2-54-145-151-245.compute-1.amazonaws.com", 
            "public_ip": "54.145.151.245", 
            "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_e2e_crun_fedora_13240", 
                "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.2.217"
    }, 
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:49.197270"
}

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": "2020-11-25 05:28:49.253985", 
    "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": "2020-11-25 05:28:49.319494"
}

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": "004d8e4ff7ff29099e25e777f43ccf566709c773", 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.2.217.yml", 
    "generated_timestamp": "2020-11-25 05:28:49.789223", 
    "gid": 995, 
    "group": "jenkins", 
    "md5sum": "dd1d0625141a275a125fe4711c6ea18b", 
    "mode": "0644", 
    "owner": "jenkins", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 768, 
    "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1606300129.58-147197754514804/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_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config"
        ]
    }, 
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:28:49.858551"
}

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": "2020-11-25 05:28:49.916033", 
    "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_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config) => {
    "changed": true, 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config", 
    "generated_timestamp": "2020-11-25 05:28:50.172714", 
    "gid": 995, 
    "group": "jenkins", 
    "item": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.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_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config) => {
    "changed": true, 
    "generated_timestamp": "2020-11-25 05:28:50.588061", 
    "item": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.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": 31, 
    "generated_timestamp": "2020-11-25 05:29:21.972292", 
    "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 12s] ##########
[workspace] $ /bin/bash /tmp/jenkins7957524023770837783.sh
########## STARTING STAGE: RECORD EXTRA EVARS ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ mktemp
+ script=/tmp/tmp.IC4JzLgv8Q
+ cat
+ chmod +x /tmp/tmp.IC4JzLgv8Q
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.IC4JzLgv8Q openshiftdevel:/tmp/tmp.IC4JzLgv8Q
lost connection
++ export status=FAILURE
++ status=FAILURE
+ set +o xtrace
########## FINISHED STAGE: FAILURE: RECORD EXTRA EVARS [00h 00m 00s] ##########
Build step 'Execute shell' marked build as failure
[PostBuildScript] - [INFO] Executing post build scripts.
[workspace] $ /bin/bash /tmp/jenkins4204132563032968553.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /go/src/k8s.io/kubernetes/artifacts
stat: cannot stat '/go/src/k8s.io/kubernetes/artifacts': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /go/src/k8s.io/kubernetes/e2e.log
stat: cannot stat '/go/src/k8s.io/kubernetes/e2e.log': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /go/src/github.com/cri-o/cri-o/testout.txt
stat: cannot stat '/go/src/github.com/cri-o/cri-o/testout.txt': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /go/src/github.com/cri-o/cri-o/reports
stat: cannot stat '/go/src/github.com/cri-o/cri-o/reports': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat '/tmp/artifacts/*'
stat: cannot stat '/tmp/artifacts/*': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kubelet.log
stat: cannot stat '/tmp/kubelet.log': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-apiserver.log
stat: cannot stat '/tmp/kube-apiserver.log': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-controller-manager.log
stat: cannot stat '/tmp/kube-controller-manager.log': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-proxy.log
stat: cannot stat '/tmp/kube-proxy.log': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-proxy.yaml
stat: cannot stat '/tmp/kube-proxy.yaml': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-scheduler.log
stat: cannot stat '/tmp/kube-scheduler.log': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /etc/crio/crio.conf
stat: cannot stat '/etc/crio/crio.conf': No such file or directory
+ tree /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/gathered
/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/gathered

0 directories, 0 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins7425652972727788583.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/generated
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo pvs && sudo vgs && sudo lvs 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo yum list installed 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo ausearch -m AVC -m SELINUX_ERR -m USER_AVC 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl --no-pager --boot 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl _PID=1 --no-pager --all --lines=all 2>&1'
+ tree /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/generated
/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/generated
├── avc_denials.log
├── filesystem.info
├── installed_packages.log
├── pid1.journal
└── system.journal

0 directories, 5 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins5040755817810836110.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/journals
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit crio.service --no-pager --all --lines=all
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit customcluster.service --no-pager --all --lines=all
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
+ tree /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/journals
/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/artifacts/journals
├── crio.service
├── customcluster.service
└── systemd-journald.service

0 directories, 3 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins7572599008924398953.sh
########## STARTING STAGE: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ mktemp
+ script=/tmp/tmp.uNwoqaylZb
+ cat
+ chmod +x /tmp/tmp.uNwoqaylZb
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.uNwoqaylZb openshiftdevel:/tmp/tmp.uNwoqaylZb
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.uNwoqaylZb"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ sudo mkdir -p /data/gcs
+ sudo chown -R origin:origin /data
+ grep -q 'ID="centos"' /etc/os-release
+ grep -q 'ID="rhel"' /etc/os-release
+ sudo dnf install -y jq podman-docker
Fedora Modular 30 - x86_64                       51 kB/s | 3.2 kB     00:00    
Fedora Modular 30 - x86_64 - Updates             73 kB/s | 3.1 kB     00:00    
Fedora 30 - x86_64 - Updates                     62 kB/s | 3.2 kB     00:00    
Fedora 30 - x86_64                               63 kB/s | 3.2 kB     00:00    
Last metadata expiration check: 0:00:01 ago on Thu 03 Sep 2020 11:02:15 PM UTC.
Dependencies resolved.
================================================================================
 Package                   Arch   Version                         Repo     Size
================================================================================
Installing:
 jq                        x86_64 1.6-2.fc30                      fedora  168 k
 podman-docker             noarch 2:1.8.0-4.fc30                  updates  71 k
Installing dependencies:
 conmon                    x86_64 2:2.0.13-1.fc30                 updates  38 k
 containernetworking-plugins
                           x86_64 0.8.5-1.fc30                    updates  20 M
 fuse3                     x86_64 3.6.2-1.fc30                    updates  53 k
 fuse3-libs                x86_64 3.6.2-1.fc30                    updates  88 k
 libbsd                    x86_64 0.9.1-3.fc30                    fedora  100 k
 libnet                    x86_64 1.1.6-17.fc30                   fedora   61 k
 libnftnl                  x86_64 1.1.3-1.fc30                    updates  71 k
 nftables                  x86_64 1:0.9.1-2.fc30                  updates 289 k
 oniguruma                 x86_64 6.9.2-4.fc30                    updates 198 k
 podman                    x86_64 2:1.8.0-4.fc30                  updates  13 M
 podman-plugins            x86_64 2:1.8.0-4.fc30                  updates 1.3 M
 protobuf-c                x86_64 1.3.1-2.fc30                    fedora   33 k
Installing weak dependencies:
 criu                      x86_64 3.13-5.fc30                     updates 482 k
 fuse-overlayfs            x86_64 0.7.5-2.fc30                    updates  62 k
 libvarlink-util           x86_64 18-1.fc30                       updates  47 k
 runc                      x86_64 2:1.0.0-102.dev.gitdc9208a.fc30 updates 2.7 M
 slirp4netns               x86_64 0.4.0-4.git19d199a.fc30         updates  85 k

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

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

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

Complete!
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD [00h 01m 10s] ##########
[workspace] $ /bin/bash /tmp/jenkins1902994104038249109.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
+ trap 'exit 0' EXIT
+ mkdir -p gcs/artifacts gcs/artifacts/generated gcs/artifacts/journals gcs/artifacts/gathered
++ python -c 'import json; import urllib; print json.load(urllib.urlopen('\''https://ci.openshift.redhat.com/jenkins/job/test_pull_request_crio_e2e_crun_fedora/13240/api/json'\''))['\''result'\'']'
+ result=FAILURE
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/builds/13240/log
+ cp -r 'artifacts/gathered/*' gcs/artifacts/
cp: cannot stat ‘artifacts/gathered/*’: No such file or directory
+ true
+ cp artifacts/generated/avc_denials.log artifacts/generated/filesystem.info artifacts/generated/installed_packages.log artifacts/generated/pid1.journal artifacts/generated/system.journal gcs/artifacts/generated/
+ cp artifacts/journals/crio.service artifacts/journals/customcluster.service artifacts/journals/systemd-journald.service gcs/artifacts/journals/
++ pwd
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/gcs openshiftdevel:/data
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /var/lib/jenkins/.config/gcloud/gcs-publisher-credentials.json openshiftdevel:/data/credentials.json
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins5233618855993573404.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ mktemp
+ script=/tmp/tmp.SSNI12emOq
+ cat
+ chmod +x /tmp/tmp.SSNI12emOq
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.SSNI12emOq openshiftdevel:/tmp/tmp.SSNI12emOq
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.SSNI12emOq"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"periodic","job":"ami_build_origin_int_fedora_crio","buildid":"1301654010108841984","prowjobid":"f4735196-ee37-11ea-b874-0a580a800dfa"} ]]
++ jq --compact-output '.buildid |= "1088"'
+ JOB_SPEC='{"type":"periodic","job":"ami_build_origin_int_fedora_crio","buildid":"1088","prowjobid":"f4735196-ee37-11ea-b874-0a580a800dfa"}'
+ sudo docker run -e 'JOB_SPEC={"type":"periodic","job":"ami_build_origin_int_fedora_crio","buildid":"1088","prowjobid":"f4735196-ee37-11ea-b874-0a580a800dfa"}' -v /data:/data:z registry.svc.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
Emulate Docker CLI using podman. Create /etc/containers/nodocker to quiet msg.
Trying to pull registry.svc.ci.openshift.org/ci/gcsupload:latest...
Getting image source signatures
Copying blob sha256:df20fa9351a15782c64e6dddb2d4a6f50bf6d3688060a34c4014b0d9a752eb4c
Copying blob sha256:79261ecc04564c24fb8146b1146be3e9cfd0f0dda113d7d0efa996f0fd3bf097
Copying blob sha256:85cea451eec057fa7e734548ca3ba6d779ed5836a3f9de14b8394575ef0d7d8e
Copying blob sha256:809b39f1848ee7cb2dbba3bff7065c1997cd5b19424d2e33ce139262d43a8887
Copying config sha256:2c73b119a2b5c445d6de23a3e574e0bd665d921e8864adff26e8e1deb76db93c
Writing manifest to image destination
Storing signatures
{"component":"gcsupload","file":"prow/gcsupload/run.go:174","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts","level":"info","msg":"Gathering artifacts from artifact directory: /data/gcs/artifacts","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:192","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/avc_denials.log in artifact directory. Uploading as logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/avc_denials.log\n","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:192","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/filesystem.info in artifact directory. Uploading as logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/filesystem.info\n","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:192","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/installed_packages.log in artifact directory. Uploading as logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/installed_packages.log\n","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:192","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/pid1.journal in artifact directory. Uploading as logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/pid1.journal\n","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:192","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/system.journal in artifact directory. Uploading as logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/system.journal\n","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:192","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/crio.service in artifact directory. Uploading as logs/ami_build_origin_int_fedora_crio/1088/artifacts/journals/crio.service\n","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:192","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/customcluster.service in artifact directory. Uploading as logs/ami_build_origin_int_fedora_crio/1088/artifacts/journals/customcluster.service\n","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:192","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/systemd-journald.service in artifact directory. Uploading as logs/ami_build_origin_int_fedora_crio/1088/artifacts/journals/systemd-journald.service\n","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/installed_packages.log","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/system.journal","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/build-log.txt","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/pid1.journal","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/journals/crio.service","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/journals/customcluster.service","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/journals/systemd-journald.service","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/finished.json","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/avc_denials.log","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/filesystem.info","file":"prow/pod-utils/gcs/upload.go:88","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/system.journal","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/filesystem.info","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/installed_packages.log","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/pid1.journal","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/journals/customcluster.service","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/build-log.txt","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/journals/crio.service","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:04Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/journals/systemd-journald.service","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:05Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/finished.json","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:05Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:05Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_fedora_crio/1088/artifacts/generated/avc_denials.log","file":"prow/pod-utils/gcs/upload.go:116","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2020-11-25T10:31:05Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:63","func":"k8s.io/test-infra/prow/gcsupload.Options.Run","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2020-11-25T10:31:05Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 11s] ##########
[workspace] $ /bin/bash /tmp/jenkins6954409695165040929.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config
+ oct deprovision

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

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

TASK [ensure all required variables are set] ***********************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:9
skipping: [localhost] => (item=origin_ci_inventory_dir)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:31:06.469169", 
    "item": "origin_ci_inventory_dir", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region)  => {
    "changed": false, 
    "generated_timestamp": "2020-11-25 05:31:06.472396", 
    "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": "2020-11-25 05:31:07.415270", 
    "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": "2020-11-25 05:31:08.090186", 
    "msg": "Tags {'Name': 'oct-terminate'} created for resource i-02bf7cd3a8819824a."
}

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": "2020-11-25 05:31:09.217674", 
    "instance_ids": [
        "i-02bf7cd3a8819824a"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-07246ebcbee26489d"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0bca549594b4145d6"
                }
            }, 
            "dns_name": "ec2-54-145-151-245.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-02bf7cd3a8819824a", 
            "image_id": "ami-0055f2e7709c69f59", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2020-11-25T10:28:32.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-2-217.ec2.internal", 
            "private_ip": "172.18.2.217", 
            "public_dns_name": "ec2-54-145-151-245.compute-1.amazonaws.com", 
            "public_ip": "54.145.151.245", 
            "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": "2020-11-25 05:31:09.470233", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.2.217.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": "2020-11-25 05:31:10.085444", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_crun_fedora/workspace/.config/origin-ci-tool/inventory", 
    "state": "absent"
}

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

+ set +o xtrace
########## FINISHED STAGE: SUCCESS: DEPROVISION CLOUD RESOURCES [00h 00m 05s] ##########
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
[WS-CLEANUP] Deleting project workspace...
[WS-CLEANUP] Deferred wipeout is used...
[WS-CLEANUP] done
Finished: FAILURE