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_rhel/workspace [WS-CLEANUP] Deleting project workspace... [WS-CLEANUP] Deferred wipeout is used... [workspace] $ /bin/bash /tmp/jenkins6029161554716858567.sh ########## STARTING STAGE: INSTALL THE ORIGIN-CI-TOOL ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/activate + cat + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config + mkdir -p /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config + rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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 01s] ########## [workspace] $ /bin/bash /tmp/jenkins206607548418711440.sh ########## STARTING STAGE: PROVISION CLOUD RESOURCES ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config + oct provision remote all-in-one --os rhel --stage crio --provider aws --discrete-ssh-config --name test_pull_request_crio_e2e_rhel_25393 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_inventory_dir) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.254613", "item": "origin_ci_inventory_dir", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_keypair_name) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.257323", "item": "origin_ci_aws_keypair_name", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_private_key_path) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.260598", "item": "origin_ci_aws_private_key_path", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_region) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.265080", "item": "origin_ci_aws_region", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_ami_tags) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.268413", "item": "origin_ci_aws_ami_tags", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_instance_name) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.271676", "item": "origin_ci_aws_instance_name", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_master_instance_type) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.274923", "item": "origin_ci_aws_master_instance_type", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_identifying_tag_key) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.278365", "item": "origin_ci_aws_identifying_tag_key", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_hostname) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.281561", "item": "origin_ci_aws_hostname", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_ssh_config_strategy) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.284804", "item": "origin_ci_ssh_config_strategy", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=openshift_schedulable) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.288010", "item": "openshift_schedulable", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=openshift_node_labels) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.292132", "item": "openshift_node_labels", "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_master_subnet) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.329839", "item": "origin_ci_aws_master_subnet", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_etcd_security_group) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.334770", "item": "origin_ci_aws_etcd_security_group", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_node_security_group) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.339127", "item": "origin_ci_aws_node_security_group", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_master_security_group) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.344693", "item": "origin_ci_aws_master_security_group", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_master_external_elb_security_group) => { "changed": false, "generated_timestamp": "2021-10-25 16:01:46.349302", "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": "2021-10-25 16:01:46.353673", "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": "2021-10-25 16:01:46.359275", "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": "2021-10-25 16:01:46.363935", "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": "2021-10-25 16:01:47.196552", "gid": 995, "group": "jenkins", "mode": "0755", "owner": "jenkins", "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config/origin-ci-tool/inventory/nested_group_mappings", "generated_timestamp": "2021-10-25 16:01:47.704585", "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-1635192107.46-86972434293310/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": "2021-10-25 16:01:47.897624", "gid": 995, "group": "jenkins", "mode": "0755", "owner": "jenkins", "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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": "2021-10-25 16:01:48.104903", "gid": 995, "group": "jenkins", "mode": "0755", "owner": "jenkins", "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config/origin-ci-tool/inventory/group_vars/OSEv3/general.yml", "generated_timestamp": "2021-10-25 16:01:48.448255", "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-1635192108.29-201816061617314/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.015009", "end": "2021-10-25 16:01:48.716654", "failed": false, "failed_when_result": false, "generated_timestamp": "2021-10-25 16:01:48.737145", "rc": 0, "start": "2021-10-25 16:01:48.701645", "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", "2021-01-03", "2021-03-23", "2021-07-15", "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": "2021-10-25 16:01:48.779460" } 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_rhel/workspace/.config/origin-ci-tool/inventory/.ec2_cache" }, "changed": false, "generated_timestamp": "2021-10-25 16:01:48.820312" } 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": "2021-10-25 16:01:49.001224", "gid": 995, "group": "jenkins", "mode": "0755", "owner": "jenkins", "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config/origin-ci-tool/inventory/ec2.py", "generated_timestamp": "2021-10-25 16:01:49.387072", "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-1635192109.2-141581572022256/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": "51172471e19b7cbea7e983b760d897eb343aa497", "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/ec2.ini", "generated_timestamp": "2021-10-25 16:01:49.725573", "gid": 995, "group": "jenkins", "md5sum": "cf112a63e311d0aee0c1f1f6f9d25a31", "mode": "0644", "owner": "jenkins", "secontext": "system_u:object_r:var_lib_t:s0", "size": 387, "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1635192109.43-60092109835898/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_rhel/workspace/.config/origin-ci-tool/inventory/tag_to_group_mappings", "generated_timestamp": "2021-10-25 16:01:50.080382", "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-1635192109.92-259312768221983/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": "2021-10-25 16:01:53.663776", "results": [ { "ami_id": "ami-059f469c73a982af7", "architecture": "x86_64", "block_device_mapping": { "/dev/sda1": { "delete_on_termination": true, "encrypted": false, "size": 75, "snapshot_id": "snap-0a923e26bcc9fa1b5", "volume_type": "gp2" }, "/dev/sdb": { "delete_on_termination": true, "encrypted": false, "size": 50, "snapshot_id": "snap-00c2da9f1b353b376", "volume_type": "gp2" } }, "creationDate": "2020-05-27T12:59:37.000Z", "description": "OpenShift Origin development AMI on rhel at the crio stage.", "hypervisor": "xen", "is_public": false, "location": "531415883065/test_pull_request_crio_ami_rhel_511", "name": "test_pull_request_crio_ami_rhel_511", "owner_id": "531415883065", "platform": null, "root_device_name": "/dev/sda1", "root_device_type": "ebs", "state": "available", "tags": { "Name": "test_pull_request_crio_ami_rhel_511", "image_stage": "crio", "operating_system": "rhel", "ready": "yes" }, "virtualization_type": "hvm" }, { "ami_id": "ami-0ea0190ad3458ff7f", "architecture": "x86_64", "block_device_mapping": { "/dev/sda1": { "delete_on_termination": true, "encrypted": false, "size": 75, "snapshot_id": "snap-08268db58d11bc117", "volume_type": "gp2" }, "/dev/sdb": { "delete_on_termination": true, "encrypted": false, "size": 50, "snapshot_id": "snap-05c31331f8516a039", "volume_type": "gp2" } }, "creationDate": "2020-05-29T19:56:53.000Z", "description": "OpenShift Origin development AMI on rhel at the crio stage.", "hypervisor": "xen", "is_public": false, "location": "531415883065/test_pull_request_crio_ami_rhel_513", "name": "test_pull_request_crio_ami_rhel_513", "owner_id": "531415883065", "platform": null, "root_device_name": "/dev/sda1", "root_device_type": "ebs", "state": "available", "tags": { "Name": "test_pull_request_crio_ami_rhel_513", "image_stage": "crio", "operating_system": "rhel", "ready": "yes" }, "virtualization_type": "hvm" }, { "ami_id": "ami-04c09594dc7af90da", "architecture": "x86_64", "block_device_mapping": { "/dev/sda1": { "delete_on_termination": true, "encrypted": false, "size": 75, "snapshot_id": "snap-08b898aa46b2c6615", "volume_type": "gp2" }, "/dev/sdb": { "delete_on_termination": true, "encrypted": false, "size": 50, "snapshot_id": "snap-07b1d5f000a644047", "volume_type": "gp2" } }, "creationDate": "2021-02-15T22:04:52.000Z", "description": "OpenShift Origin development AMI on rhel at the crio stage.", "hypervisor": "xen", "is_public": false, "location": "531415883065/ami_build_origin_int_rhel_crio_1263", "name": "ami_build_origin_int_rhel_crio_1263", "owner_id": "531415883065", "platform": null, "root_device_name": "/dev/sda1", "root_device_type": "ebs", "state": "available", "tags": { "Name": "ami_build_origin_int_rhel_crio_1263", "image_stage": "crio", "operating_system": "rhel", "ready": "yes" }, "virtualization_type": "hvm" }, { "ami_id": "ami-0db1bcec6bfd5a39f", "architecture": "x86_64", "block_device_mapping": { "/dev/sda1": { "delete_on_termination": true, "encrypted": false, "size": 75, "snapshot_id": "snap-0ad773c4debf631c9", "volume_type": "gp2" }, "/dev/sdb": { "delete_on_termination": true, "encrypted": false, "size": 50, "snapshot_id": "snap-0059c51400cea9b19", "volume_type": "gp2" } }, "creationDate": "2021-02-16T22:05:53.000Z", "description": "OpenShift Origin development AMI on rhel at the crio stage.", "hypervisor": "xen", "is_public": false, "location": "531415883065/ami_build_origin_int_rhel_crio_1264", "name": "ami_build_origin_int_rhel_crio_1264", "owner_id": "531415883065", "platform": null, "root_device_name": "/dev/sda1", "root_device_type": "ebs", "state": "available", "tags": { "Name": "ami_build_origin_int_rhel_crio_1264", "image_stage": "crio", "operating_system": "rhel", "ready": "yes" }, "virtualization_type": "hvm" } ] } TASK [aws-up : 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-059f469c73a982af7', u'root_device_type': u'ebs', u'description': u'OpenShift Origin development AMI on rhel at the crio stage.', u'tags': {u'ready': u'yes', u'image_stage': u'crio', u'Name': u'test_pull_request_crio_ami_rhel_511', u'operating_system': u'rhel'}, u'hypervisor': u'xen', u'block_device_mapping': {u'/dev/sdb': {u'encrypted': False, u'snapshot_id': u'snap-00c2da9f1b353b376', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 50}, u'/dev/sda1': {u'encrypted': False, u'snapshot_id': u'snap-0a923e26bcc9fa1b5', 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_rhel_511', u'is_public': False, u'creationDate': u'2020-05-27T12:59:37.000Z', u'root_device_name': u'/dev/sda1', u'virtualization_type': u'hvm', u'name': u'test_pull_request_crio_ami_rhel_511'}) => { "ansible_facts": { "origin_ci_aws_ami_id_candidate": "ami-059f469c73a982af7" }, "changed": false, "generated_timestamp": "2021-10-25 16:01:53.715857", "item": { "ami_id": "ami-059f469c73a982af7", "architecture": "x86_64", "block_device_mapping": { "/dev/sda1": { "delete_on_termination": true, "encrypted": false, "size": 75, "snapshot_id": "snap-0a923e26bcc9fa1b5", "volume_type": "gp2" }, "/dev/sdb": { "delete_on_termination": true, "encrypted": false, "size": 50, "snapshot_id": "snap-00c2da9f1b353b376", "volume_type": "gp2" } }, "creationDate": "2020-05-27T12:59:37.000Z", "description": "OpenShift Origin development AMI on rhel at the crio stage.", "hypervisor": "xen", "is_public": false, "location": "531415883065/test_pull_request_crio_ami_rhel_511", "name": "test_pull_request_crio_ami_rhel_511", "owner_id": "531415883065", "platform": null, "root_device_name": "/dev/sda1", "root_device_type": "ebs", "state": "available", "tags": { "Name": "test_pull_request_crio_ami_rhel_511", "image_stage": "crio", "operating_system": "rhel", "ready": "yes" }, "virtualization_type": "hvm" } } ok: [localhost] => (item={u'ami_id': u'ami-0ea0190ad3458ff7f', u'root_device_type': u'ebs', u'description': u'OpenShift Origin development AMI on rhel at the crio stage.', u'tags': {u'ready': u'yes', u'operating_system': u'rhel', u'image_stage': u'crio', u'Name': u'test_pull_request_crio_ami_rhel_513'}, u'hypervisor': u'xen', u'block_device_mapping': {u'/dev/sdb': {u'encrypted': False, u'snapshot_id': u'snap-05c31331f8516a039', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 50}, u'/dev/sda1': {u'encrypted': False, u'snapshot_id': u'snap-08268db58d11bc117', 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_rhel_513', u'is_public': False, u'creationDate': u'2020-05-29T19:56:53.000Z', u'root_device_name': u'/dev/sda1', u'virtualization_type': u'hvm', u'name': u'test_pull_request_crio_ami_rhel_513'}) => { "ansible_facts": { "origin_ci_aws_ami_id_candidate": "ami-0ea0190ad3458ff7f" }, "changed": false, "generated_timestamp": "2021-10-25 16:01:53.723459", "item": { "ami_id": "ami-0ea0190ad3458ff7f", "architecture": "x86_64", "block_device_mapping": { "/dev/sda1": { "delete_on_termination": true, "encrypted": false, "size": 75, "snapshot_id": "snap-08268db58d11bc117", "volume_type": "gp2" }, "/dev/sdb": { "delete_on_termination": true, "encrypted": false, "size": 50, "snapshot_id": "snap-05c31331f8516a039", "volume_type": "gp2" } }, "creationDate": "2020-05-29T19:56:53.000Z", "description": "OpenShift Origin development AMI on rhel at the crio stage.", "hypervisor": "xen", "is_public": false, "location": "531415883065/test_pull_request_crio_ami_rhel_513", "name": "test_pull_request_crio_ami_rhel_513", "owner_id": "531415883065", "platform": null, "root_device_name": "/dev/sda1", "root_device_type": "ebs", "state": "available", "tags": { "Name": "test_pull_request_crio_ami_rhel_513", "image_stage": "crio", "operating_system": "rhel", "ready": "yes" }, "virtualization_type": "hvm" } } ok: [localhost] => (item={u'ami_id': u'ami-04c09594dc7af90da', u'root_device_type': u'ebs', u'description': u'OpenShift Origin development AMI on rhel at the crio stage.', u'tags': {u'ready': u'yes', u'image_stage': u'crio', u'Name': u'ami_build_origin_int_rhel_crio_1263', u'operating_system': u'rhel'}, u'hypervisor': u'xen', u'block_device_mapping': {u'/dev/sdb': {u'encrypted': False, u'snapshot_id': u'snap-07b1d5f000a644047', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 50}, u'/dev/sda1': {u'encrypted': False, u'snapshot_id': u'snap-08b898aa46b2c6615', 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_rhel_crio_1263', u'is_public': False, u'creationDate': u'2021-02-15T22:04:52.000Z', u'root_device_name': u'/dev/sda1', u'virtualization_type': u'hvm', u'name': u'ami_build_origin_int_rhel_crio_1263'}) => { "ansible_facts": { "origin_ci_aws_ami_id_candidate": "ami-04c09594dc7af90da" }, "changed": false, "generated_timestamp": "2021-10-25 16:01:53.729258", "item": { "ami_id": "ami-04c09594dc7af90da", "architecture": "x86_64", "block_device_mapping": { "/dev/sda1": { "delete_on_termination": true, "encrypted": false, "size": 75, "snapshot_id": "snap-08b898aa46b2c6615", "volume_type": "gp2" }, "/dev/sdb": { "delete_on_termination": true, "encrypted": false, "size": 50, "snapshot_id": "snap-07b1d5f000a644047", "volume_type": "gp2" } }, "creationDate": "2021-02-15T22:04:52.000Z", "description": "OpenShift Origin development AMI on rhel at the crio stage.", "hypervisor": "xen", "is_public": false, "location": "531415883065/ami_build_origin_int_rhel_crio_1263", "name": "ami_build_origin_int_rhel_crio_1263", "owner_id": "531415883065", "platform": null, "root_device_name": "/dev/sda1", "root_device_type": "ebs", "state": "available", "tags": { "Name": "ami_build_origin_int_rhel_crio_1263", "image_stage": "crio", "operating_system": "rhel", "ready": "yes" }, "virtualization_type": "hvm" } } ok: [localhost] => (item={u'ami_id': u'ami-0db1bcec6bfd5a39f', u'root_device_type': u'ebs', u'description': u'OpenShift Origin development AMI on rhel at the crio stage.', u'tags': {u'ready': u'yes', u'image_stage': u'crio', u'Name': u'ami_build_origin_int_rhel_crio_1264', u'operating_system': u'rhel'}, u'hypervisor': u'xen', u'block_device_mapping': {u'/dev/sdb': {u'encrypted': False, u'snapshot_id': u'snap-0059c51400cea9b19', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 50}, u'/dev/sda1': {u'encrypted': False, u'snapshot_id': u'snap-0ad773c4debf631c9', 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_rhel_crio_1264', u'is_public': False, u'creationDate': u'2021-02-16T22:05:53.000Z', u'root_device_name': u'/dev/sda1', u'virtualization_type': u'hvm', u'name': u'ami_build_origin_int_rhel_crio_1264'}) => { "ansible_facts": { "origin_ci_aws_ami_id_candidate": "ami-0db1bcec6bfd5a39f" }, "changed": false, "generated_timestamp": "2021-10-25 16:01:53.738037", "item": { "ami_id": "ami-0db1bcec6bfd5a39f", "architecture": "x86_64", "block_device_mapping": { "/dev/sda1": { "delete_on_termination": true, "encrypted": false, "size": 75, "snapshot_id": "snap-0ad773c4debf631c9", "volume_type": "gp2" }, "/dev/sdb": { "delete_on_termination": true, "encrypted": false, "size": 50, "snapshot_id": "snap-0059c51400cea9b19", "volume_type": "gp2" } }, "creationDate": "2021-02-16T22:05:53.000Z", "description": "OpenShift Origin development AMI on rhel at the crio stage.", "hypervisor": "xen", "is_public": false, "location": "531415883065/ami_build_origin_int_rhel_crio_1264", "name": "ami_build_origin_int_rhel_crio_1264", "owner_id": "531415883065", "platform": null, "root_device_name": "/dev/sda1", "root_device_type": "ebs", "state": "available", "tags": { "Name": "ami_build_origin_int_rhel_crio_1264", "image_stage": "crio", "operating_system": "rhel", "ready": "yes" }, "virtualization_type": "hvm" } } TASK [aws-up : determine which AMI to use] ************************************* task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:55 ok: [localhost] => { "ansible_facts": { "origin_ci_aws_ami_id": "ami-0db1bcec6bfd5a39f" }, "changed": false, "generated_timestamp": "2021-10-25 16:01:53.784889" } TASK [aws-up : determine which subnets are available] ************************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:60 ok: [localhost] => { "changed": false, "generated_timestamp": "2021-10-25 16:01:54.478294", "subnets": [ { "availability_zone": "us-east-1d", "available_ip_address_count": 3966, "cidr_block": "172.18.0.0/20", "default_for_az": "false", "id": "subnet-cf57c596", "map_public_ip_on_launch": "true", "state": "available", "tags": { "Name": "devenv-subnet-1", "openshift_creationDate": "2020-10-29T05:22:55.262494+00:00", "origin_ci_aws_cluster_component": "master_subnet" }, "vpc_id": "vpc-69705d0c" }, { "availability_zone": "us-east-1c", "available_ip_address_count": 4089, "cidr_block": "172.18.16.0/20", "default_for_az": "false", "id": "subnet-8bdb5ac2", "map_public_ip_on_launch": "true", "state": "available", "tags": { "Name": "devenv-subnet-2", "openshift_creationDate": "2020-10-29T05:22:55.262494+00:00", "origin_ci_aws_cluster_component": "master_subnet" }, "vpc_id": "vpc-69705d0c" } ] } TASK [aws-up : determine which subnets to use for the master] ****************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:67 ok: [localhost] => { "ansible_facts": { "origin_ci_aws_master_subnet_ids": [ "subnet-cf57c596", "subnet-8bdb5ac2" ] }, "changed": false, "generated_timestamp": "2021-10-25 16:01:54.526618" } TASK [aws-up : determine which security groups are available] ****************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:72 ok: [localhost] => { "changed": false, "generated_timestamp": "2021-10-25 16:01:55.624612", "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": 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": 80, "ip_protocol": "tcp", "ip_ranges": [ { "cidr_ip": "212.199.177.64/27" }, { "cidr_ip": "107.20.219.35/32" }, { "cidr_ip": "108.166.48.153/32" }, { "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": 53, "ip_protocol": "tcp", "ip_ranges": [ { "cidr_ip": "38.99.12.232/29" }, { "cidr_ip": "4.14.35.88/29" }, { "cidr_ip": "213.175.37.9/32" }, { "cidr_ip": "62.40.79.66/32" }, { "cidr_ip": "209.132.186.34/32" }, { "cidr_ip": "66.187.224.0/20" }, { "cidr_ip": "4.14.33.72/30" }, { "cidr_ip": "209.132.176.0/20" }, { "cidr_ip": "213.175.37.10/32" }, { "cidr_ip": "38.140.108.0/24" }, { "cidr_ip": "66.187.239.0/24" }, { "cidr_ip": "119.254.120.64/26" }, { "cidr_ip": "50.227.40.96/29" } ], "ipv6_ranges": [], "prefix_list_ids": [], "to_port": 8444, "user_id_group_pairs": [] }, { "from_port": 53, "ip_protocol": "udp", "ip_ranges": [ { "cidr_ip": "66.187.239.0/24" }, { "cidr_ip": "209.132.176.0/20" }, { "cidr_ip": "66.187.224.0/20" } ], "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-7e73221a", "user_id": "531415883065" }, { "group_id": "sg-5875023f", "user_id": "531415883065" }, { "group_id": "sg-0d1a5377", "user_id": "531415883065" }, { "group_id": "sg-e1760186", "user_id": "531415883065" } ] }, { "from_port": 443, "ip_protocol": "tcp", "ip_ranges": [ { "cidr_ip": "73.162.159.233/32" } ], "ipv6_ranges": [], "prefix_list_ids": [], "to_port": 443, "user_id_group_pairs": [] }, { "from_port": 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": "2021-10-25 16:01:55.676886" } TASK [aws-up : provision an AWS EC2 instance] ********************************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:84 changed: [localhost] => { "changed": true, "generated_timestamp": "2021-10-25 16:02:13.976414", "instance_ids": [ "i-0feb09be9c4a06552" ], "instances": [ { "ami_launch_index": "0", "architecture": "x86_64", "block_device_mapping": { "/dev/sda1": { "delete_on_termination": true, "status": "attached", "volume_id": "vol-00a259e23a8a01b6e" }, "/dev/sdb": { "delete_on_termination": true, "status": "attached", "volume_id": "vol-021ad32fbcf0d8ea3" } }, "dns_name": "ec2-54-205-251-89.compute-1.amazonaws.com", "ebs_optimized": false, "groups": { "sg-7e73221a": "default" }, "hypervisor": "xen", "id": "i-0feb09be9c4a06552", "image_id": "ami-0db1bcec6bfd5a39f", "instance_type": "m4.xlarge", "kernel": null, "key_name": "openshift-dev", "launch_time": "2021-10-25T20:01:57.000Z", "placement": "us-east-1d", "private_dns_name": "ip-172-18-14-56.ec2.internal", "private_ip": "172.18.14.56", "public_dns_name": "ec2-54-205-251-89.compute-1.amazonaws.com", "public_ip": "54.205.251.89", "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_rhel_25393", "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.14.56" }, "changed": false, "generated_timestamp": "2021-10-25 16:02:14.022675" } TASK [aws-up : determine the default user to use for SSH] ********************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:114 skipping: [localhost] => { "changed": false, "generated_timestamp": "2021-10-25 16:02:14.078745", "skip_reason": "Conditional check failed", "skipped": true } TASK [aws-up : determine the default user to use for SSH] ********************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:119 ok: [localhost] => { "ansible_facts": { "origin_ci_aws_ssh_user": "origin" }, "changed": false, "generated_timestamp": "2021-10-25 16:02:14.133243" } 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": "e6ddd03bfb0b423746e4f5afeffcc48630dbe034", "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.14.56.yml", "generated_timestamp": "2021-10-25 16:02:14.623033", "gid": 995, "group": "jenkins", "md5sum": "b60e2dcbb8c179d5228d443d7cd337f7", "mode": "0644", "owner": "jenkins", "secontext": "system_u:object_r:var_lib_t:s0", "size": 759, "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1635192134.4-31986970701290/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_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config" ] }, "changed": false, "generated_timestamp": "2021-10-25 16:02:14.675597" } TASK [aws-up : determine where updated SSH configuration should go] ************ task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/provision/roles/aws-up/tasks/main.yml:146 skipping: [localhost] => { "changed": false, "generated_timestamp": "2021-10-25 16:02:14.720484", "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_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config) => { "changed": true, "dest": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config", "generated_timestamp": "2021-10-25 16:02:14.939019", "gid": 995, "group": "jenkins", "item": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config) => { "changed": true, "generated_timestamp": "2021-10-25 16:02:15.344882", "item": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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": 60, "generated_timestamp": "2021-10-25 16:03:15.887979", "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 30s] ########## [workspace] $ /bin/bash /tmp/jenkins6804938702275151878.sh ########## STARTING STAGE: FORWARD PARAMETERS TO THE REMOTE HOST ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod o+rw /etc/environment + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''BUILD_ID=1452726970071650310'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''REPO_OWNER=cri-o'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''REPO_NAME=cri-o'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_BASE_REF=main'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_BASE_SHA=bf8bc04f08417b38043979620b100838d46e4f00'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_REFS=main:bf8bc04f08417b38043979620b100838d46e4f00,5422:3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_NUMBER=5422'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_PULL_SHA=3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''JOB_SPEC={"type":"presubmit","job":"test_pull_request_crio_e2e_rhel","buildid":"1452726970071650310","prowjobid":"3506033a-35ce-11ec-be88-0a580a81089b","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"bf8bc04f08417b38043979620b100838d46e4f00","base_link":"https://github.com/cri-o/cri-o/commit/bf8bc04f08417b38043979620b100838d46e4f00","pulls":[{"number":5422,"author":"wgahnagl","sha":"3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2","title":"[WIP][Do not merge]fixes error with garbled output","link":"https://github.com/cri-o/cri-o/pull/5422","commit_link":"https://github.com/cri-o/cri-o/pull/5422/commits/3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2","author_link":"https://github.com/wgahnagl"}]}}'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PROW_JOB_ID=3506033a-35ce-11ec-be88-0a580a81089b'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''JOB_SPEC={"type":"presubmit","job":"test_pull_request_crio_e2e_rhel","buildid":"1452726970071650310","prowjobid":"3506033a-35ce-11ec-be88-0a580a81089b","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"bf8bc04f08417b38043979620b100838d46e4f00","base_link":"https://github.com/cri-o/cri-o/commit/bf8bc04f08417b38043979620b100838d46e4f00","pulls":[{"number":5422,"author":"wgahnagl","sha":"3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2","title":"[WIP][Do not merge]fixes error with garbled output","link":"https://github.com/cri-o/cri-o/pull/5422","commit_link":"https://github.com/cri-o/cri-o/pull/5422/commits/3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2","author_link":"https://github.com/wgahnagl"}]}}'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''BUILD_NUMBER=25393'\'' >> /etc/environment' + set +o xtrace ########## FINISHED STAGE: SUCCESS: FORWARD PARAMETERS TO THE REMOTE HOST [00h 00m 06s] ########## [workspace] $ /bin/bash /tmp/jenkins6939838341052945558.sh ########## STARTING STAGE: UPLOAD GCS STARTING METADATA ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config + trap 'exit 0' EXIT + mkdir -p gcs/ + [[ -n cri-o ]] + cat ++ date +%s + BUILD=25393 + bucket=gs://origin-federated-results/ + suffix=test_pull_request_crio_e2e_rhel/25393/ + [[ -n cri-o ]] + segment=cri-o_cri-o/ + [[ -n 5422 ]] + prefix=pr-logs/pull/ + segment=cri-o_cri-o/5422/ + path=gs://origin-federated-results/pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/ + gsutil cp gcs/started.json gs://origin-federated-results/pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/started.json Copying file://gcs/started.json [Content-Type=application/json]... / [0 files][ 0.0 B/ 280.0 B] / [1 files][ 280.0 B/ 280.0 B] Operation completed over 1 objects/280.0 B. + [[ -n 5422 ]] + echo gs://origin-federated-results/pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393 + gsutil cp 25393.txt gs://origin-federated-results/pr-logs/directory/test_pull_request_crio_e2e_rhel/25393.txt Copying file://25393.txt [Content-Type=text/plain]... / [0 files][ 0.0 B/ 98.0 B] / [1 files][ 98.0 B/ 98.0 B] Operation completed over 1 objects/98.0 B. + echo 25393 ++ jq --compact-output .type + job_type='"presubmit"' + [[ "presubmit" =~ presubmit ]] + gsutil cp latest-build.txt gs://origin-ci-test/pr-logs/directory/test_pull_request_crio_e2e_rhel/latest-build.txt Copying file://latest-build.txt [Content-Type=text/plain]... / [0 files][ 0.0 B/ 6.0 B] / [1 files][ 6.0 B/ 6.0 B] Operation completed over 1 objects/6.0 B. + exit 0 [workspace] $ /bin/bash /tmp/jenkins8911277412077755803.sh ########## STARTING STAGE: FORWARD PARAMETERS TO THE REMOTE HOST ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod o+rw /etc/environment + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_NUMBER=5422'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_BASE_SHA=bf8bc04f08417b38043979620b100838d46e4f00'\'' >> /etc/environment' + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_PULL_SHA=3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2'\'' >> /etc/environment' + set +o xtrace ########## FINISHED STAGE: SUCCESS: FORWARD PARAMETERS TO THE REMOTE HOST [00h 00m 02s] ########## [workspace] $ /bin/bash /tmp/jenkins6584908464238502495.sh ########## STARTING STAGE: CLONE CRI-O AND CHECK OUT THE CORRECT REFS ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config ++ mktemp + script=/tmp/tmp.nv2zhmK5ZA + cat + chmod +x /tmp/tmp.nv2zhmK5ZA + scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.nv2zhmK5ZA openshiftdevel:/tmp/tmp.nv2zhmK5ZA + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.nv2zhmK5ZA"' + cd /home/origin + cd /go/src/github.com/cri-o/cri-o + git fetch origin From https://github.com/cri-o/cri-o * [new branch] annotations-refactor -> origin/annotations-refactor * [new branch] dependabot/go_modules/github.com/coreos/go-systemd/v22-22.3.0 -> origin/dependabot/go_modules/github.com/coreos/go-systemd/v22-22.3.0 b60207c..112e228 gh-pages -> origin/gh-pages * [new branch] main -> origin/main 5218c73..54f9e69 release-1.11 -> origin/release-1.11 7f979af..f0bab49 release-1.17 -> origin/release-1.17 be796d1..fa57051 release-1.18 -> origin/release-1.18 6377f68..5d5a465 release-1.19 -> origin/release-1.19 b422fc2..e80c8db release-1.20 -> origin/release-1.20 900bc42..7415a53 release-1.21 -> origin/release-1.21 * [new branch] release-1.22 -> origin/release-1.22 * [new branch] release-1.23 -> origin/release-1.23 From https://github.com/cri-o/cri-o * [new tag] v1.19.2 -> v1.19.2 * [new tag] v1.19.3 -> v1.19.3 * [new tag] v1.19.4 -> v1.19.4 * [new tag] v1.20.1 -> v1.20.1 * [new tag] v1.20.2 -> v1.20.2 * [new tag] v1.20.3 -> v1.20.3 * [new tag] v1.20.4 -> v1.20.4 * [new tag] v1.20.5 -> v1.20.5 * [new tag] v1.21.0 -> v1.21.0 * [new tag] v1.21.1 -> v1.21.1 * [new tag] v1.21.2 -> v1.21.2 * [new tag] v1.21.3 -> v1.21.3 * [new tag] v1.22.0 -> v1.22.0 + git checkout -f master Already on 'master' + git branch -D target error: branch 'target' not found. + true + git branch -D pr error: branch 'pr' not found. + true + git branch target bf8bc04f08417b38043979620b100838d46e4f00 + git checkout -f target Switched to branch 'target' + git fetch origin pull/5422/head:pr From https://github.com/cri-o/cri-o * [new ref] refs/pull/5422/head -> pr + git merge 3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2 Auto-merging vendor/github.com/containers/storage/drivers/overlay/overlay.go CONFLICT (content): Merge conflict in vendor/github.com/containers/storage/drivers/overlay/overlay.go Automatic merge failed; fix conflicts and then commit the result. ++ export status=FAILURE ++ status=FAILURE + set +o xtrace ########## FINISHED STAGE: FAILURE: CLONE CRI-O AND CHECK OUT THE CORRECT REFS [00h 00m 19s] ########## Build step 'Execute shell' marked build as failure [PostBuildScript] - [INFO] Executing post build scripts. [workspace] $ /bin/bash /tmp/jenkins1910550986141263938.sh ########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config + trap 'exit 0' EXIT ++ pwd + ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/gathered + rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/gathered + mkdir -p /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/gathered + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/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_rhel/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_rhel/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_rhel/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_rhel/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_rhel/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_rhel/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_rhel/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_rhel/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_rhel/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_rhel/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_rhel/workspace/artifacts/gathered /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/gathered 0 directories, 0 files + exit 0 [workspace] $ /bin/bash /tmp/jenkins5940511437106310952.sh ########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config + trap 'exit 0' EXIT ++ pwd + ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/generated + rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/generated + mkdir /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/generated + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/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_rhel/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_rhel/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_rhel/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_rhel/workspace/artifacts/generated /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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/jenkins7423607459803546246.sh ########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config + trap 'exit 0' EXIT ++ pwd + ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/journals + rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/journals + mkdir /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/journals + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/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_rhel/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_rhel/workspace/artifacts/journals /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/journals ├── crio.service ├── customcluster.service └── systemd-journald.service 0 directories, 3 files + exit 0 [workspace] $ /bin/bash /tmp/jenkins6203569324445685753.sh ########## STARTING STAGE: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config ++ mktemp + script=/tmp/tmp.OipMled39d + cat + chmod +x /tmp/tmp.OipMled39d + scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.OipMled39d openshiftdevel:/tmp/tmp.OipMled39d + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.OipMled39d"' + cd /home/origin + trap 'exit 0' EXIT + sudo mkdir -p /data/gcs + sudo chown -R origin:origin /data + grep -q 'ID="centos"' /etc/os-release + grep -q 'ID="rhel"' /etc/os-release + sudo yum install -y https://dl.fedoraproject.org/pub/epel/epel-release-latest-7.noarch.rpm Loaded plugins: amazon-id, search-disabled-repos Examining /var/tmp/yum-root-slrjek/epel-release-latest-7.noarch.rpm: epel-release-7-14.noarch Marking /var/tmp/yum-root-slrjek/epel-release-latest-7.noarch.rpm to be installed Resolving Dependencies --> Running transaction check ---> Package epel-release.noarch 0:7-14 will be installed --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Installing: epel-release noarch 7-14 /epel-release-latest-7.noarch 25 k Transaction Summary ================================================================================ Install 1 Package Total size: 25 k Installed size: 25 k Downloading packages: Running transaction check Running transaction test Transaction test succeeded Running transaction Installing : epel-release-7-14.noarch 1/1 Verifying : epel-release-7-14.noarch 1/1 Installed: epel-release.noarch 0:7-14 Complete! + sudo yum install -y jq docker Loaded plugins: amazon-id, search-disabled-repos Resolving Dependencies --> Running transaction check ---> Package docker.x86_64 2:1.13.1-208.git7d71120.el7_9 will be installed --> Processing Dependency: docker-common = 2:1.13.1-208.git7d71120.el7_9 for package: 2:docker-1.13.1-208.git7d71120.el7_9.x86_64 --> Processing Dependency: docker-client = 2:1.13.1-208.git7d71120.el7_9 for package: 2:docker-1.13.1-208.git7d71120.el7_9.x86_64 ---> Package jq.x86_64 0:1.6-2.el7 will be installed --> Processing Dependency: libonig.so.5()(64bit) for package: jq-1.6-2.el7.x86_64 --> Running transaction check ---> Package docker-client.x86_64 2:1.13.1-208.git7d71120.el7_9 will be installed ---> Package docker-common.x86_64 2:1.13.1-208.git7d71120.el7_9 will be installed --> Processing Dependency: docker-rhel-push-plugin = 2:1.13.1-208.git7d71120.el7_9 for package: 2:docker-common-1.13.1-208.git7d71120.el7_9.x86_64 --> Processing Dependency: container-storage-setup >= 0.9.0-1 for package: 2:docker-common-1.13.1-208.git7d71120.el7_9.x86_64 ---> Package oniguruma.x86_64 0:6.8.2-1.el7 will be installed --> Running transaction check ---> Package container-storage-setup.noarch 0:0.11.0-2.git5eaf76c.el7 will be installed ---> Package docker-rhel-push-plugin.x86_64 2:1.13.1-208.git7d71120.el7_9 will be installed --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Installing: docker x86_64 2:1.13.1-208.git7d71120.el7_9 oso-rhui-rhel-server-extras 17 M jq x86_64 1.6-2.el7 epel 167 k Installing for dependencies: container-storage-setup noarch 0.11.0-2.git5eaf76c.el7 oso-rhui-rhel-server-extras 35 k docker-client x86_64 2:1.13.1-208.git7d71120.el7_9 oso-rhui-rhel-server-extras 3.9 M docker-common x86_64 2:1.13.1-208.git7d71120.el7_9 oso-rhui-rhel-server-extras 101 k docker-rhel-push-plugin x86_64 2:1.13.1-208.git7d71120.el7_9 oso-rhui-rhel-server-extras 2.0 M oniguruma x86_64 6.8.2-1.el7 epel 181 k Transaction Summary ================================================================================ Install 2 Packages (+5 Dependent packages) Total download size: 24 M Installed size: 84 M Downloading packages: warning: /var/cache/yum/x86_64/7Server/epel/packages/jq-1.6-2.el7.x86_64.rpm: Header V3 RSA/SHA256 Signature, key ID 352c64e5: NOKEY Public key for jq-1.6-2.el7.x86_64.rpm is not installed -------------------------------------------------------------------------------- Total 5.0 MB/s | 24 MB 00:04 Retrieving key from file:///etc/pki/rpm-gpg/RPM-GPG-KEY-EPEL-7 Importing GPG key 0x352C64E5: Userid : "Fedora EPEL (7) <epel@fedoraproject.org>" Fingerprint: 91e9 7d7c 4a5e 96f1 7f3e 888f 6a2f aea2 352c 64e5 Package : epel-release-7-14.noarch (@/epel-release-latest-7.noarch) From : /etc/pki/rpm-gpg/RPM-GPG-KEY-EPEL-7 Running transaction check Running transaction test Transaction test succeeded Running transaction Installing : oniguruma-6.8.2-1.el7.x86_64 1/7 Installing : 2:docker-rhel-push-plugin-1.13.1-208.git7d71120.el7_9.x86_ 2/7 Installing : container-storage-setup-0.11.0-2.git5eaf76c.el7.noarch 3/7 Installing : 2:docker-common-1.13.1-208.git7d71120.el7_9.x86_64 4/7 Installing : 2:docker-client-1.13.1-208.git7d71120.el7_9.x86_64 5/7 Installing : 2:docker-1.13.1-208.git7d71120.el7_9.x86_64 6/7 Installing : jq-1.6-2.el7.x86_64 7/7 Verifying : 2:docker-common-1.13.1-208.git7d71120.el7_9.x86_64 1/7 Verifying : 2:docker-1.13.1-208.git7d71120.el7_9.x86_64 2/7 Verifying : 2:docker-client-1.13.1-208.git7d71120.el7_9.x86_64 3/7 Verifying : container-storage-setup-0.11.0-2.git5eaf76c.el7.noarch 4/7 Verifying : jq-1.6-2.el7.x86_64 5/7 Verifying : 2:docker-rhel-push-plugin-1.13.1-208.git7d71120.el7_9.x86_ 6/7 Verifying : oniguruma-6.8.2-1.el7.x86_64 7/7 Installed: docker.x86_64 2:1.13.1-208.git7d71120.el7_9 jq.x86_64 0:1.6-2.el7 Dependency Installed: container-storage-setup.noarch 0:0.11.0-2.git5eaf76c.el7 docker-client.x86_64 2:1.13.1-208.git7d71120.el7_9 docker-common.x86_64 2:1.13.1-208.git7d71120.el7_9 docker-rhel-push-plugin.x86_64 2:1.13.1-208.git7d71120.el7_9 oniguruma.x86_64 0:6.8.2-1.el7 Complete! + sudo systemctl enable --now docker Created symlink from /etc/systemd/system/multi-user.target.wants/docker.service to /usr/lib/systemd/system/docker.service. + exit 0 + set +o xtrace ########## FINISHED STAGE: SUCCESS: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD [00h 02m 33s] ########## [workspace] $ /bin/bash /tmp/jenkins8946420830127212333.sh ########## STARTING STAGE: ASSEMBLE GCS OUTPUT ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/25393/api/json'\''))['\''result'\'']' + result=FAILURE + cat ++ date +%s + cat /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/builds/25393/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_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/gcs openshiftdevel:/data + scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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/jenkins6505937170806472785.sh ########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config ++ mktemp + script=/tmp/tmp.OUkfCK6e11 + cat + chmod +x /tmp/tmp.OUkfCK6e11 + scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.OUkfCK6e11 openshiftdevel:/tmp/tmp.OUkfCK6e11 + ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.OUkfCK6e11"' + cd /home/origin + trap 'exit 0' EXIT + [[ -n {"type":"presubmit","job":"test_pull_request_crio_e2e_rhel","buildid":"1452726970071650310","prowjobid":"3506033a-35ce-11ec-be88-0a580a81089b","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"bf8bc04f08417b38043979620b100838d46e4f00","base_link":"https://github.com/cri-o/cri-o/commit/bf8bc04f08417b38043979620b100838d46e4f00","pulls":[{"number":5422,"author":"wgahnagl","sha":"3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2","title":"[WIP][Do not merge]fixes error with garbled output","link":"https://github.com/cri-o/cri-o/pull/5422","commit_link":"https://github.com/cri-o/cri-o/pull/5422/commits/3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2","author_link":"https://github.com/wgahnagl"}]}} ]] ++ jq --compact-output '.buildid |= "25393"' + JOB_SPEC='{"type":"presubmit","job":"test_pull_request_crio_e2e_rhel","buildid":"25393","prowjobid":"3506033a-35ce-11ec-be88-0a580a81089b","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"bf8bc04f08417b38043979620b100838d46e4f00","base_link":"https://github.com/cri-o/cri-o/commit/bf8bc04f08417b38043979620b100838d46e4f00","pulls":[{"number":5422,"author":"wgahnagl","sha":"3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2","title":"[WIP][Do not merge]fixes error with garbled output","link":"https://github.com/cri-o/cri-o/pull/5422","commit_link":"https://github.com/cri-o/cri-o/pull/5422/commits/3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2","author_link":"https://github.com/wgahnagl"}]}}' + sudo docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_crio_e2e_rhel","buildid":"25393","prowjobid":"3506033a-35ce-11ec-be88-0a580a81089b","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"bf8bc04f08417b38043979620b100838d46e4f00","base_link":"https://github.com/cri-o/cri-o/commit/bf8bc04f08417b38043979620b100838d46e4f00","pulls":[{"number":5422,"author":"wgahnagl","sha":"3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2","title":"[WIP][Do not merge]fixes error with garbled output","link":"https://github.com/cri-o/cri-o/pull/5422","commit_link":"https://github.com/cri-o/cri-o/pull/5422/commits/3e81a6b1daea2ad19c972bde97b6f8a7857cf9d2","author_link":"https://github.com/wgahnagl"}]}}' -v /data:/data:z registry.ci.openshift.org/ci/gcsupload:latest --dry-run=false --gcs-path=gs://origin-federated-results --gcs-credentials-file=/data/credentials.json /data/gcs/artifacts /data/gcs/build-log.txt /data/gcs/finished.json /data/gcs/started.json Unable to find image 'registry.ci.openshift.org/ci/gcsupload:latest' locally Trying to pull repository registry.ci.openshift.org/ci/gcsupload ... latest: Pulling from registry.ci.openshift.org/ci/gcsupload df20fa9351a1: Pulling fs layer 809b39f1848e: Pulling fs layer b69115000677: Pulling fs layer 85cea451eec0: Pulling fs layer 85cea451eec0: Waiting df20fa9351a1: Verifying Checksum df20fa9351a1: Download complete 809b39f1848e: Download complete 85cea451eec0: Verifying Checksum 85cea451eec0: Download complete b69115000677: Verifying Checksum b69115000677: Download complete df20fa9351a1: Pull complete 809b39f1848e: Pull complete b69115000677: Pull complete 85cea451eec0: Pull complete Digest: sha256:b27fca02c103c75d2bd45986b2fc8825767138709f8ffd0c4ae34f94afbf0252 Status: Downloaded newer image for registry.ci.openshift.org/ci/gcsupload:latest {"component":"gcsupload","file":"prow/gcsupload/run.go:194","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts","level":"info","msg":"Gathering artifacts from artifact directory: /data/gcs/artifacts","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/avc_denials.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/avc_denials.log\n","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/filesystem.info in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/filesystem.info\n","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/installed_packages.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/installed_packages.log\n","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/pid1.journal in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/pid1.journal\n","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/system.journal in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/system.journal\n","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/crio.service in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/journals/crio.service\n","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/customcluster.service in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/journals/customcluster.service\n","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/systemd-journald.service in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/journals/systemd-journald.service\n","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/build-log.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/filesystem.info","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/journals/customcluster.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/installed_packages.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/pid1.journal","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/system.journal","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/journals/systemd-journald.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_e2e_rhel/25393.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_e2e_rhel/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/started.json","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/avc_denials.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/finished.json","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/journals/crio.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/filesystem.info","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/journals/systemd-journald.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/journals/customcluster.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/build-log.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/journals/crio.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_e2e_rhel/25393.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/started.json","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_e2e_rhel/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/avc_denials.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:52Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/finished.json","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:53Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/pid1.journal","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:53Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:53Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/installed_packages.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:53Z"} {"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5422/test_pull_request_crio_e2e_rhel/25393/artifacts/generated/system.journal","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-10-25T20:06:53Z"} {"component":"gcsupload","file":"prow/gcsupload/run.go:78","func":"k8s.io/test-infra/prow/gcsupload.completeUpload","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2021-10-25T20:06:53Z"} {"component":"gcsupload","file":"prow/gcsupload/run.go:78","func":"k8s.io/test-infra/prow/gcsupload.completeUpload","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2021-10-25T20:06:53Z"} + exit 0 + set +o xtrace ########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 05s] ########## [workspace] $ /bin/bash /tmp/jenkins5538016969047709853.sh ########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ########## + [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/activate ]] + source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/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_rhel/workspace/.config ++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config + oct deprovision PLAYBOOK: main.yml ************************************************************* 4 plays in /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml PLAY [ensure we have the parameters necessary to deprovision virtual hosts] **** TASK [ensure all required variables are set] *********************************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:9 skipping: [localhost] => (item=origin_ci_inventory_dir) => { "changed": false, "generated_timestamp": "2021-10-25 16:06:54.546731", "item": "origin_ci_inventory_dir", "skip_reason": "Conditional check failed", "skipped": true } skipping: [localhost] => (item=origin_ci_aws_region) => { "changed": false, "generated_timestamp": "2021-10-25 16:06:54.552764", "item": "origin_ci_aws_region", "skip_reason": "Conditional check failed", "skipped": true } PLAY [deprovision virtual hosts in EC2] **************************************** TASK [Gathering Facts] ********************************************************* ok: [localhost] TASK [deprovision a virtual EC2 host] ****************************************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:28 included: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml for localhost TASK [update the SSH configuration to remove AWS EC2 specifics] **************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:2 ok: [localhost] => { "changed": false, "generated_timestamp": "2021-10-25 16:06:55.587479", "msg": "" } TASK [rename EC2 instance for termination reaper] ****************************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:8 changed: [localhost] => { "changed": true, "generated_timestamp": "2021-10-25 16:06:56.376273", "msg": "Tags {'Name': 'oct-terminate'} created for resource i-0feb09be9c4a06552." } TASK [tear down the EC2 instance] ********************************************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:15 changed: [localhost] => { "changed": true, "generated_timestamp": "2021-10-25 16:06:57.648906", "instance_ids": [ "i-0feb09be9c4a06552" ], "instances": [ { "ami_launch_index": "0", "architecture": "x86_64", "block_device_mapping": { "/dev/sda1": { "delete_on_termination": true, "status": "attached", "volume_id": "vol-00a259e23a8a01b6e" }, "/dev/sdb": { "delete_on_termination": true, "status": "attached", "volume_id": "vol-021ad32fbcf0d8ea3" } }, "dns_name": "ec2-54-205-251-89.compute-1.amazonaws.com", "ebs_optimized": false, "groups": { "sg-7e73221a": "default" }, "hypervisor": "xen", "id": "i-0feb09be9c4a06552", "image_id": "ami-0db1bcec6bfd5a39f", "instance_type": "m4.xlarge", "kernel": null, "key_name": "openshift-dev", "launch_time": "2021-10-25T20:01:57.000Z", "placement": "us-east-1d", "private_dns_name": "ip-172-18-14-56.ec2.internal", "private_ip": "172.18.14.56", "public_dns_name": "ec2-54-205-251-89.compute-1.amazonaws.com", "public_ip": "54.205.251.89", "ramdisk": null, "region": "us-east-1", "root_device_name": "/dev/sda1", "root_device_type": "ebs", "state": "running", "state_code": 16, "tags": { "Name": "oct-terminate", "openshift_etcd": "", "openshift_master": "", "openshift_node": "" }, "tenancy": "default", "virtualization_type": "hvm" } ], "tagged_instances": [] } TASK [remove the serialized host variables] ************************************ task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:22 changed: [localhost] => { "changed": true, "generated_timestamp": "2021-10-25 16:06:57.972607", "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.14.56.yml", "state": "absent" } PLAY [deprovision virtual hosts locally manged by Vagrant] ********************* TASK [Gathering Facts] ********************************************************* ok: [localhost] PLAY [clean up local configuration for deprovisioned instances] **************** TASK [remove inventory configuration directory] ******************************** task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:61 changed: [localhost] => { "changed": true, "generated_timestamp": "2021-10-25 16:06:58.566000", "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/.config/origin-ci-tool/inventory", "state": "absent" } PLAY RECAP ********************************************************************* localhost : ok=8 changed=4 unreachable=0 failed=0 + set +o xtrace ########## FINISHED STAGE: SUCCESS: DEPROVISION CLOUD RESOURCES [00h 00m 05s] ########## Archiving artifacts Recording test results [Checks API] No suitable checks publisher found. sent [/var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/artifacts/generated/installed_packages.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/gcs/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_rhel/workspace/gcs/artifacts/generated/installed_packages.log] to splunk in 4 events [WS-CLEANUP] Deleting project workspace... [WS-CLEANUP] Deferred wipeout is used... [WS-CLEANUP] done Finished: FAILURE