Console Output

Started by user OpenShift CI Robot
Running as SYSTEM
[EnvInject] - Loading node environment variables.
Building in workspace /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace
[WS-CLEANUP] Deleting project workspace...
[WS-CLEANUP] Deferred wipeout is used...
[workspace] $ /bin/bash /tmp/jenkins5172214194672128379.sh
########## STARTING STAGE: INSTALL THE ORIGIN-CI-TOOL ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/activate
+ cat
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_s2i_master/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 02s] ##########
[workspace] $ /bin/bash /tmp/jenkins3019815087558464113.sh
########## STARTING STAGE: PROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
+ oct provision remote all-in-one --os rhel --stage base --provider aws --discrete-ssh-config --name test_pull_request_s2i_master_225

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-13 14:57:39.946910", 
    "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-13 14:57:39.949565", 
    "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-13 14:57:39.952731", 
    "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-13 14:57:39.955887", 
    "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-13 14:57:39.960304", 
    "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-13 14:57:39.963505", 
    "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-13 14:57:39.966823", 
    "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-13 14:57:39.969981", 
    "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-13 14:57:39.973130", 
    "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-13 14:57:39.977464", 
    "item": "origin_ci_ssh_config_strategy", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=openshift_schedulable)  => {
    "changed": false, 
    "generated_timestamp": "2021-10-13 14:57:39.980567", 
    "item": "openshift_schedulable", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=openshift_node_labels)  => {
    "changed": false, 
    "generated_timestamp": "2021-10-13 14:57:39.983886", 
    "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-13 14:57:40.022260", 
    "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-13 14:57:40.027319", 
    "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-13 14:57:40.032893", 
    "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-13 14:57:40.037301", 
    "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-13 14:57:40.043047", 
    "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-13 14:57:40.047399", 
    "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-13 14:57:40.052879", 
    "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-13 14:57:40.059052", 
    "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-13 14:57:40.905847", 
    "gid": 995, 
    "group": "jenkins", 
    "mode": "0755", 
    "owner": "jenkins", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config/origin-ci-tool/inventory/nested_group_mappings", 
    "generated_timestamp": "2021-10-13 14:57:41.418281", 
    "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-1634151461.17-152647669472234/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-13 14:57:41.608080", 
    "gid": 995, 
    "group": "jenkins", 
    "mode": "0755", 
    "owner": "jenkins", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/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-13 14:57:41.798000", 
    "gid": 995, 
    "group": "jenkins", 
    "mode": "0755", 
    "owner": "jenkins", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config/origin-ci-tool/inventory/group_vars/OSEv3/general.yml", 
    "generated_timestamp": "2021-10-13 14:57:42.128629", 
    "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-1634151461.97-248257797688984/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.014395", 
    "end": "2021-10-13 14:57:42.374005", 
    "failed": false, 
    "failed_when_result": false, 
    "generated_timestamp": "2021-10-13 14:57:42.392459", 
    "rc": 0, 
    "start": "2021-10-13 14:57:42.359610", 
    "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-13 14:57:42.434688"
}

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_s2i_master/workspace/.config/origin-ci-tool/inventory/.ec2_cache"
    }, 
    "changed": false, 
    "generated_timestamp": "2021-10-13 14:57:42.473727"
}

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-13 14:57:42.661938", 
    "gid": 995, 
    "group": "jenkins", 
    "mode": "0755", 
    "owner": "jenkins", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config/origin-ci-tool/inventory/ec2.py", 
    "generated_timestamp": "2021-10-13 14:57:43.000319", 
    "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-1634151462.84-163908574490849/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": "38672c26d885bc4fb573d919fe7ffcca84bb07d9", 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/ec2.ini", 
    "generated_timestamp": "2021-10-13 14:57:43.333289", 
    "gid": 995, 
    "group": "jenkins", 
    "md5sum": "589a28d1804a29bac8fcac994570ef0c", 
    "mode": "0644", 
    "owner": "jenkins", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 379, 
    "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1634151463.04-127124543899175/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_s2i_master/workspace/.config/origin-ci-tool/inventory/tag_to_group_mappings", 
    "generated_timestamp": "2021-10-13 14:57:43.664672", 
    "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-1634151463.51-102113094588970/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-13 14:57:47.122044", 
    "results": [
        {
            "ami_id": "ami-07768c4a017d4160b", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 75, 
                    "snapshot_id": "snap-015bd4afa0a3e396a", 
                    "volume_type": "gp2"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 50, 
                    "snapshot_id": "snap-044ffb7970b562062", 
                    "volume_type": "gp2"
                }
            }, 
            "creationDate": "2020-11-20T01:31:42.000Z", 
            "description": "OpenShift Origin development AMI on rhel at the base stage.", 
            "hypervisor": "xen", 
            "is_public": false, 
            "location": "531415883065/ami_build_origin_int_rhel_base_2892", 
            "name": "ami_build_origin_int_rhel_base_2892", 
            "owner_id": "531415883065", 
            "platform": null, 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "available", 
            "tags": {
                "Name": "ami_build_origin_int_rhel_base_2892", 
                "image_stage": "base", 
                "operating_system": "rhel", 
                "ready": "yes"
            }, 
            "virtualization_type": "hvm"
        }, 
        {
            "ami_id": "ami-0be3a2afbcd35d3f1", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 75, 
                    "snapshot_id": "snap-0d19b398e8aff5176", 
                    "volume_type": "gp2"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "encrypted": false, 
                    "size": 50, 
                    "snapshot_id": "snap-0763fe55ac2e35539", 
                    "volume_type": "gp2"
                }
            }, 
            "creationDate": "2020-11-20T11:06:46.000Z", 
            "description": "OpenShift Origin development AMI on rhel at the base stage.", 
            "hypervisor": "xen", 
            "is_public": false, 
            "location": "531415883065/ami_build_origin_int_rhel_base_2893", 
            "name": "ami_build_origin_int_rhel_base_2893", 
            "owner_id": "531415883065", 
            "platform": null, 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "available", 
            "tags": {
                "Name": "ami_build_origin_int_rhel_base_2893", 
                "image_stage": "base", 
                "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-07768c4a017d4160b', u'root_device_type': u'ebs', u'description': u'OpenShift Origin development AMI on rhel at the base stage.', u'tags': {u'ready': u'yes', u'operating_system': u'rhel', u'image_stage': u'base', u'Name': u'ami_build_origin_int_rhel_base_2892'}, u'hypervisor': u'xen', u'block_device_mapping': {u'/dev/sdb': {u'encrypted': False, u'snapshot_id': u'snap-044ffb7970b562062', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 50}, u'/dev/sda1': {u'encrypted': False, u'snapshot_id': u'snap-015bd4afa0a3e396a', 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_base_2892', u'is_public': False, u'creationDate': u'2020-11-20T01:31:42.000Z', u'root_device_name': u'/dev/sda1', u'virtualization_type': u'hvm', u'name': u'ami_build_origin_int_rhel_base_2892'}) => {
    "ansible_facts": {
        "origin_ci_aws_ami_id_candidate": "ami-07768c4a017d4160b"
    }, 
    "changed": false, 
    "generated_timestamp": "2021-10-13 14:57:47.171459", 
    "item": {
        "ami_id": "ami-07768c4a017d4160b", 
        "architecture": "x86_64", 
        "block_device_mapping": {
            "/dev/sda1": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 75, 
                "snapshot_id": "snap-015bd4afa0a3e396a", 
                "volume_type": "gp2"
            }, 
            "/dev/sdb": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 50, 
                "snapshot_id": "snap-044ffb7970b562062", 
                "volume_type": "gp2"
            }
        }, 
        "creationDate": "2020-11-20T01:31:42.000Z", 
        "description": "OpenShift Origin development AMI on rhel at the base stage.", 
        "hypervisor": "xen", 
        "is_public": false, 
        "location": "531415883065/ami_build_origin_int_rhel_base_2892", 
        "name": "ami_build_origin_int_rhel_base_2892", 
        "owner_id": "531415883065", 
        "platform": null, 
        "root_device_name": "/dev/sda1", 
        "root_device_type": "ebs", 
        "state": "available", 
        "tags": {
            "Name": "ami_build_origin_int_rhel_base_2892", 
            "image_stage": "base", 
            "operating_system": "rhel", 
            "ready": "yes"
        }, 
        "virtualization_type": "hvm"
    }
}
ok: [localhost] => (item={u'ami_id': u'ami-0be3a2afbcd35d3f1', u'root_device_type': u'ebs', u'description': u'OpenShift Origin development AMI on rhel at the base stage.', u'tags': {u'ready': u'yes', u'image_stage': u'base', u'Name': u'ami_build_origin_int_rhel_base_2893', u'operating_system': u'rhel'}, u'hypervisor': u'xen', u'block_device_mapping': {u'/dev/sdb': {u'encrypted': False, u'snapshot_id': u'snap-0763fe55ac2e35539', u'delete_on_termination': True, u'volume_type': u'gp2', u'size': 50}, u'/dev/sda1': {u'encrypted': False, u'snapshot_id': u'snap-0d19b398e8aff5176', 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_base_2893', u'is_public': False, u'creationDate': u'2020-11-20T11:06:46.000Z', u'root_device_name': u'/dev/sda1', u'virtualization_type': u'hvm', u'name': u'ami_build_origin_int_rhel_base_2893'}) => {
    "ansible_facts": {
        "origin_ci_aws_ami_id_candidate": "ami-0be3a2afbcd35d3f1"
    }, 
    "changed": false, 
    "generated_timestamp": "2021-10-13 14:57:47.179123", 
    "item": {
        "ami_id": "ami-0be3a2afbcd35d3f1", 
        "architecture": "x86_64", 
        "block_device_mapping": {
            "/dev/sda1": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 75, 
                "snapshot_id": "snap-0d19b398e8aff5176", 
                "volume_type": "gp2"
            }, 
            "/dev/sdb": {
                "delete_on_termination": true, 
                "encrypted": false, 
                "size": 50, 
                "snapshot_id": "snap-0763fe55ac2e35539", 
                "volume_type": "gp2"
            }
        }, 
        "creationDate": "2020-11-20T11:06:46.000Z", 
        "description": "OpenShift Origin development AMI on rhel at the base stage.", 
        "hypervisor": "xen", 
        "is_public": false, 
        "location": "531415883065/ami_build_origin_int_rhel_base_2893", 
        "name": "ami_build_origin_int_rhel_base_2893", 
        "owner_id": "531415883065", 
        "platform": null, 
        "root_device_name": "/dev/sda1", 
        "root_device_type": "ebs", 
        "state": "available", 
        "tags": {
            "Name": "ami_build_origin_int_rhel_base_2893", 
            "image_stage": "base", 
            "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-0be3a2afbcd35d3f1"
    }, 
    "changed": false, 
    "generated_timestamp": "2021-10-13 14:57:47.219834"
}

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-13 14:57:47.885228", 
    "subnets": [
        {
            "availability_zone": "us-east-1d", 
            "available_ip_address_count": 3954, 
            "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-13 14:57:47.928298"
}

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-13 14:57:49.582685", 
    "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-13 14:57:49.626844"
}

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-13 14:58:12.760844", 
    "instance_ids": [
        "i-0667f099f4bc25d2c"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0a7ac212b7bc60552"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0828d330796b7ec5d"
                }
            }, 
            "dns_name": "ec2-54-242-71-87.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-0667f099f4bc25d2c", 
            "image_id": "ami-0be3a2afbcd35d3f1", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2021-10-13T18:57:51.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-8-225.ec2.internal", 
            "private_ip": "172.18.8.225", 
            "public_dns_name": "ec2-54-242-71-87.compute-1.amazonaws.com", 
            "public_ip": "54.242.71.87", 
            "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_s2i_master_225", 
                "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.8.225"
    }, 
    "changed": false, 
    "generated_timestamp": "2021-10-13 14:58:12.838134"
}

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-13 14:58:12.909272", 
    "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-13 14:58:12.950694"
}

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": "803eb66d0d0c7eef5f0fe7c4dbb40df069fe0271", 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.8.225.yml", 
    "generated_timestamp": "2021-10-13 14:58:13.298557", 
    "gid": 995, 
    "group": "jenkins", 
    "md5sum": "5c17d91ed4a619b0b4e21b636e0bb0d1", 
    "mode": "0644", 
    "owner": "jenkins", 
    "secontext": "system_u:object_r:var_lib_t:s0", 
    "size": 754, 
    "src": "/var/lib/jenkins/.ansible/tmp/ansible-tmp-1634151493.14-256959889531910/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_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config"
        ]
    }, 
    "changed": false, 
    "generated_timestamp": "2021-10-13 14:58:13.340832"
}

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-13 14:58:13.376120", 
    "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_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config) => {
    "changed": true, 
    "dest": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config", 
    "generated_timestamp": "2021-10-13 14:58:13.563578", 
    "gid": 995, 
    "group": "jenkins", 
    "item": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config) => {
    "changed": true, 
    "generated_timestamp": "2021-10-13 14:58:13.856409", 
    "item": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/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": 70, 
    "generated_timestamp": "2021-10-13 14:59:24.242769", 
    "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 45s] ##########
[workspace] $ /bin/bash /tmp/jenkins8247479677871462433.sh
########## STARTING STAGE: FORWARD GCS CREDENTIALS TO REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
+ (( i = 0 ))
+ (( i < 10 ))
+ scp -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config /var/lib/jenkins/.config/gcloud/gcs-publisher-credentials.json openshiftdevel:/data/credentials.json
+ break
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: FORWARD GCS CREDENTIALS TO REMOTE HOST [00h 00m 02s] ##########
[workspace] $ /bin/bash /tmp/jenkins3374531207757651265.sh
########## STARTING STAGE: FORWARD PARAMETERS TO THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod o+rw /etc/environment
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''JOB_SPEC={"type":"presubmit","job":"test_pull_request_s2i_master","buildid":"1448362268155711488","prowjobid":"5d63b9dc-2c57-11ec-a826-0a580a830222","refs":{"org":"openshift","repo":"source-to-image","repo_link":"https://github.com/openshift/source-to-image","base_ref":"master","base_sha":"cc5438d25d60966b70fb85b463bf724eafcad49c","base_link":"https://github.com/openshift/source-to-image/commit/cc5438d25d60966b70fb85b463bf724eafcad49c","pulls":[{"number":1072,"author":"seeker25","sha":"6d698a3701253319b16186b4bc1458433a5f0bb3","title":"Windows ignore path fix","link":"https://github.com/openshift/source-to-image/pull/1072","commit_link":"https://github.com/openshift/source-to-image/pull/1072/commits/6d698a3701253319b16186b4bc1458433a5f0bb3","author_link":"https://github.com/seeker25"}]}}'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''buildId='\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''BUILD_ID=1448362268155711488'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''REPO_OWNER=openshift'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''REPO_NAME=source-to-image'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_BASE_REF=master'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_BASE_SHA=cc5438d25d60966b70fb85b463bf724eafcad49c'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_REFS=master:cc5438d25d60966b70fb85b463bf724eafcad49c,1072:6d698a3701253319b16186b4bc1458433a5f0bb3'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_NUMBER=1072'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''PULL_PULL_SHA=6d698a3701253319b16186b4bc1458433a5f0bb3'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''JOB_SPEC={"type":"presubmit","job":"test_pull_request_s2i_master","buildid":"1448362268155711488","prowjobid":"5d63b9dc-2c57-11ec-a826-0a580a830222","refs":{"org":"openshift","repo":"source-to-image","repo_link":"https://github.com/openshift/source-to-image","base_ref":"master","base_sha":"cc5438d25d60966b70fb85b463bf724eafcad49c","base_link":"https://github.com/openshift/source-to-image/commit/cc5438d25d60966b70fb85b463bf724eafcad49c","pulls":[{"number":1072,"author":"seeker25","sha":"6d698a3701253319b16186b4bc1458433a5f0bb3","title":"Windows ignore path fix","link":"https://github.com/openshift/source-to-image/pull/1072","commit_link":"https://github.com/openshift/source-to-image/pull/1072/commits/6d698a3701253319b16186b4bc1458433a5f0bb3","author_link":"https://github.com/seeker25"}]}}'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''BUILD_NUMBER=225'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''CLONEREFS_ARGS='\'' >> /etc/environment'
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: FORWARD PARAMETERS TO THE REMOTE HOST [00h 00m 05s] ##########
[workspace] $ /bin/bash /tmp/jenkins7476502039248657271.sh
########## STARTING STAGE: SYNC REPOSITORIES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
++ mktemp
+ script=/tmp/tmp.NCsIrCKxqC
+ cat
+ chmod +x /tmp/tmp.NCsIrCKxqC
+ scp -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.NCsIrCKxqC openshiftdevel:/tmp/tmp.NCsIrCKxqC
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.NCsIrCKxqC"'
+ cd /home/origin
++ jq --compact-output '.buildid |= "225"'
+ JOB_SPEC='{"type":"presubmit","job":"test_pull_request_s2i_master","buildid":"225","prowjobid":"5d63b9dc-2c57-11ec-a826-0a580a830222","refs":{"org":"openshift","repo":"source-to-image","repo_link":"https://github.com/openshift/source-to-image","base_ref":"master","base_sha":"cc5438d25d60966b70fb85b463bf724eafcad49c","base_link":"https://github.com/openshift/source-to-image/commit/cc5438d25d60966b70fb85b463bf724eafcad49c","pulls":[{"number":1072,"author":"seeker25","sha":"6d698a3701253319b16186b4bc1458433a5f0bb3","title":"Windows ignore path fix","link":"https://github.com/openshift/source-to-image/pull/1072","commit_link":"https://github.com/openshift/source-to-image/pull/1072/commits/6d698a3701253319b16186b4bc1458433a5f0bb3","author_link":"https://github.com/seeker25"}]}}'
+ for image in ''\''registry.ci.openshift.org/ci/clonerefs:latest'\''' ''\''registry.ci.openshift.org/ci/initupload:latest'\'''
+ (( i = 0 ))
+ (( i < 5 ))
+ docker pull registry.ci.openshift.org/ci/clonerefs:latest
Trying to pull repository registry.ci.openshift.org/ci/clonerefs ... 
latest: Pulling from registry.ci.openshift.org/ci/clonerefs
29291e31a76a: Pulling fs layer
d8b0fef36ee8: Pulling fs layer
2ca59ef288e1: Pulling fs layer
c7ef9b04df87: Pulling fs layer
31dfb8fea394: Pulling fs layer
c7ef9b04df87: Waiting
31dfb8fea394: Waiting
d8b0fef36ee8: Download complete
29291e31a76a: Verifying Checksum
29291e31a76a: Download complete
2ca59ef288e1: Verifying Checksum
2ca59ef288e1: Download complete
31dfb8fea394: Verifying Checksum
31dfb8fea394: Download complete
c7ef9b04df87: Verifying Checksum
c7ef9b04df87: Download complete
29291e31a76a: Pull complete
d8b0fef36ee8: Pull complete
2ca59ef288e1: Pull complete
c7ef9b04df87: Pull complete
31dfb8fea394: Pull complete
Digest: sha256:d3e4b1c0b5b3d0f4e60c04566a80559c2ed0d5bd0e48846ac45faa3458340099
Status: Downloaded newer image for registry.ci.openshift.org/ci/clonerefs:latest
+ break
+ for image in ''\''registry.ci.openshift.org/ci/clonerefs:latest'\''' ''\''registry.ci.openshift.org/ci/initupload:latest'\'''
+ (( i = 0 ))
+ (( i < 5 ))
+ docker pull registry.ci.openshift.org/ci/initupload:latest
Trying to pull repository registry.ci.openshift.org/ci/initupload ... 
latest: Pulling from registry.ci.openshift.org/ci/initupload
df20fa9351a1: Pulling fs layer
809b39f1848e: Pulling fs layer
816d6cdd1425: Pulling fs layer
8e5b170ec95b: Pulling fs layer
8e5b170ec95b: Waiting
809b39f1848e: Verifying Checksum
809b39f1848e: Download complete
df20fa9351a1: Verifying Checksum
df20fa9351a1: Download complete
8e5b170ec95b: Verifying Checksum
8e5b170ec95b: Download complete
816d6cdd1425: Verifying Checksum
816d6cdd1425: Download complete
df20fa9351a1: Pull complete
809b39f1848e: Pull complete
816d6cdd1425: Pull complete
8e5b170ec95b: Pull complete
Digest: sha256:9b489a27616bcdc328f7e2c0975afb41840385008c0fc4d719479648c70996d3
Status: Downloaded newer image for registry.ci.openshift.org/ci/initupload:latest
+ break
+ clonerefs_args=
+ docker run -v /data:/data:z registry.ci.openshift.org/ci/clonerefs:latest --src-root=/data --log=/data/clone.json --repo=openshift,source-to-image=master:cc5438d25d60966b70fb85b463bf724eafcad49c,1072:6d698a3701253319b16186b4bc1458433a5f0bb3
{"component":"clonerefs","file":"prow/pod-utils/clone/clone.go:49","func":"k8s.io/test-infra/prow/pod-utils/clone.Run","level":"info","msg":"Cloning refs","refs":{"org":"openshift","repo":"source-to-image","base_ref":"master","base_sha":"cc5438d25d60966b70fb85b463bf724eafcad49c","pulls":[{"number":1072,"author":"","sha":"6d698a3701253319b16186b4bc1458433a5f0bb3"}]},"severity":"info","time":"2021-10-13T19:00:51Z"}
{"command":"mkdir -p /data/src/github.com/openshift/source-to-image","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"","severity":"info","time":"2021-10-13T19:00:51Z"}
{"command":"git init","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"Reinitialized existing shared Git repository in /data/src/github.com/openshift/source-to-image/.git/\n","severity":"info","time":"2021-10-13T19:00:51Z"}
{"command":"git config user.name ci-robot","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"","severity":"info","time":"2021-10-13T19:00:51Z"}
{"command":"git config user.email ci-robot@k8s.io","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"","severity":"info","time":"2021-10-13T19:00:51Z"}
{"command":"git fetch https://github.com/openshift/source-to-image.git --tags --prune","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"From https://github.com/openshift/source-to-image\n * branch              HEAD       -\u003e FETCH_HEAD\n","severity":"info","time":"2021-10-13T19:00:52Z"}
{"command":"git fetch https://github.com/openshift/source-to-image.git master","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"From https://github.com/openshift/source-to-image\n * branch              master     -\u003e FETCH_HEAD\n","severity":"info","time":"2021-10-13T19:00:52Z"}
{"command":"git checkout cc5438d25d60966b70fb85b463bf724eafcad49c","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"Note: switching to 'cc5438d25d60966b70fb85b463bf724eafcad49c'.\n\nYou are in 'detached HEAD' state. You can look around, make experimental\nchanges and commit them, and you can discard any commits you make in this\nstate without impacting any branches by switching back to a branch.\n\nIf you want to create a new branch to retain commits you create, you may\ndo so (now or later) by using -c with the switch command. Example:\n\n  git switch -c \u003cnew-branch-name\u003e\n\nOr undo this operation with:\n\n  git switch -\n\nTurn off this advice by setting config variable advice.detachedHead to false\n\nHEAD is now at cc5438d2 Merge pull request #1073 from gabemontero/fix-stirunimage\n","severity":"info","time":"2021-10-13T19:00:58Z"}
{"command":"git branch --force master cc5438d25d60966b70fb85b463bf724eafcad49c","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"","severity":"info","time":"2021-10-13T19:00:58Z"}
{"command":"git checkout master","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"Switched to branch 'master'\nYour branch is ahead of 'origin/master' by 9 commits.\n  (use \"git push\" to publish your local commits)\n","severity":"info","time":"2021-10-13T19:00:58Z"}
{"command":"git fetch https://github.com/openshift/source-to-image.git 6d698a3701253319b16186b4bc1458433a5f0bb3","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"From https://github.com/openshift/source-to-image\n * branch              6d698a3701253319b16186b4bc1458433a5f0bb3 -\u003e FETCH_HEAD\n","severity":"info","time":"2021-10-13T19:00:58Z"}
{"command":"git merge --no-ff 6d698a3701253319b16186b4bc1458433a5f0bb3","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"Merge made by the 'recursive' strategy.\n pkg/util/fs/fs.go | 5 ++---\n 1 file changed, 2 insertions(+), 3 deletions(-)\n","severity":"info","time":"2021-10-13T19:00:58Z"}
{"command":"git submodule update --init --recursive","component":"clonerefs","file":"prow/pod-utils/clone/clone.go:61","func":"k8s.io/test-infra/prow/pod-utils/clone.Run.func2","level":"info","msg":"Ran command","output":"","severity":"info","time":"2021-10-13T19:00:58Z"}
{"component":"clonerefs","file":"prow/cmd/clonerefs/main.go:43","func":"main.main","level":"info","msg":"Finished cloning refs","severity":"info","time":"2021-10-13T19:00:58Z"}
+ docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_s2i_master","buildid":"225","prowjobid":"5d63b9dc-2c57-11ec-a826-0a580a830222","refs":{"org":"openshift","repo":"source-to-image","repo_link":"https://github.com/openshift/source-to-image","base_ref":"master","base_sha":"cc5438d25d60966b70fb85b463bf724eafcad49c","base_link":"https://github.com/openshift/source-to-image/commit/cc5438d25d60966b70fb85b463bf724eafcad49c","pulls":[{"number":1072,"author":"seeker25","sha":"6d698a3701253319b16186b4bc1458433a5f0bb3","title":"Windows ignore path fix","link":"https://github.com/openshift/source-to-image/pull/1072","commit_link":"https://github.com/openshift/source-to-image/pull/1072/commits/6d698a3701253319b16186b4bc1458433a5f0bb3","author_link":"https://github.com/seeker25"}]}}' -v /data:/data:z registry.ci.openshift.org/ci/initupload:latest --clone-log=/data/clone.json --dry-run=false --gcs-path=gs://origin-ci-test --gcs-credentials-file=/data/credentials.json --path-strategy=single --default-org=openshift --default-repo=origin
{"component":"initupload","dest":"pr-logs/directory/test_pull_request_s2i_master/225.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-13T19:01:01Z"}
{"component":"initupload","dest":"pr-logs/directory/test_pull_request_s2i_master/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-13T19:01:01Z"}
{"component":"initupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/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-13T19:01:01Z"}
{"component":"initupload","dest":"pr-logs/directory/test_pull_request_s2i_master/225.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-13T19:01:02Z"}
{"component":"initupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/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-13T19:01:02Z"}
{"component":"initupload","dest":"pr-logs/directory/test_pull_request_s2i_master/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-13T19:01:02Z"}
{"component":"initupload","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-13T19:01:02Z"}
{"component":"initupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/clone-records.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-13T19:01:02Z"}
{"component":"initupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:01:02Z"}
{"component":"initupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/clone-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-13T19:01:02Z"}
{"component":"initupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:01:02Z"}
{"component":"initupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/clone-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-13T19:01:02Z"}
{"component":"initupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/clone-records.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-13T19:01:02Z"}
{"component":"initupload","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-13T19:01:02Z"}
+ sudo chmod -R a+rwX /data
+ sudo chown -R origin:origin-git /data
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: SYNC REPOSITORIES [00h 01m 34s] ##########
[workspace] $ /bin/bash /tmp/jenkins6173031593967114736.sh
########## STARTING STAGE: FORWARD PARAMETERS TO THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod o+rw /etc/environment
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''JOB_NAME=test_pull_request_s2i_master'\'' >> /etc/environment'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''BUILD_NUMBER=225'\'' >> /etc/environment'
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: FORWARD PARAMETERS TO THE REMOTE HOST [00h 00m 01s] ##########
[workspace] $ /bin/bash /tmp/jenkins6361174307463328361.sh
########## STARTING STAGE: BUILD AND INSTALL S2I ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
++ mktemp
+ script=/tmp/tmp.yHTUKrY3XQ
+ cat
+ chmod +x /tmp/tmp.yHTUKrY3XQ
+ scp -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.yHTUKrY3XQ openshiftdevel:/tmp/tmp.yHTUKrY3XQ
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.yHTUKrY3XQ"'
+ cd /data/src/github.com/openshift/source-to-image
+ export BUILD_GO_VERSION=go1.12.5
+ BUILD_GO_VERSION=go1.12.5
+ wget -q https://dl.google.com/go/go1.12.5.linux-amd64.tar.gz
+ sudo tar -C /usr/local -xzf go1.12.5.linux-amd64.tar.gz
+ sudo rm /bin/go /bin/gofmt
+ sudo ln -s /usr/local/go/bin/go /usr/local/go/bin/godoc /usr/local/go/bin/gofmt /bin
+ make build
hack/build-go.sh
++ Building go targets for linux/amd64: cmd/s2i
++ Placing binaries
+ sudo cp /data/src/github.com/openshift/source-to-image/_output/local/bin/linux/amd64/s2i /usr/bin
Printing s2i version
+ echo 'Printing s2i version'
+ s2i version
s2i v1.3.1-14-g193f732-dirty
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: BUILD AND INSTALL S2I [00h 00m 32s] ##########
[workspace] $ /bin/bash /tmp/jenkins7852684771273472737.sh
########## STARTING STAGE: BUILD TEST IMAGES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
++ mktemp
+ script=/tmp/tmp.puSrgwVh9H
+ cat
+ chmod +x /tmp/tmp.puSrgwVh9H
+ scp -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.puSrgwVh9H openshiftdevel:/tmp/tmp.puSrgwVh9H
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.puSrgwVh9H"'
+ cd /data/src/github.com/openshift/source-to-image
+ hack/build-test-images.sh
Sending build context to Docker daemon 7.168 kB

Step 1/4 : FROM busybox
Trying to pull repository registry.access.redhat.com/busybox ... 
Pulling repository registry.access.redhat.com/busybox
Trying to pull repository registry.redhat.io/busybox ... 
Trying to pull repository docker.io/library/busybox ... 
latest: Pulling from docker.io/library/busybox
24fb2886d6f6: Pulling fs layer
24fb2886d6f6: Verifying Checksum
24fb2886d6f6: Download complete
24fb2886d6f6: Pull complete
Digest: sha256:f7ca5a32c10d51aeda3b4d01c61c6061f497893d7f6628b92f822f7117182a57
Status: Downloaded newer image for docker.io/busybox:latest
 ---> 16ea53ea7c65
Step 2/4 : RUN mkdir -p /sti-fake/src && mkdir -p /opt/app-root/src && 	mkdir /usr/bin && 	ln -s /bin/env /usr/bin/env
 ---> Running in 324343aa718f

 ---> 97b0e69940eb
Removing intermediate container 324343aa718f
Step 3/4 : WORKDIR /opt/app-root/src
 ---> f75278c17d6d
Removing intermediate container a3ffbb324c8c
Step 4/4 : LABEL io.openshift.s2i.scripts-url http://127.0.0.1:23456/.s2i/bin
 ---> Running in c95d2b150136
 ---> b20ee93177fc
Removing intermediate container c95d2b150136
Successfully built b20ee93177fc
Sending build context to Docker daemon 7.168 kB

Step 1/4 : FROM sti_test/sti-fake
 ---> b20ee93177fc
Step 2/4 : LABEL io.openshift.s2i.assemble-user "0"
 ---> Running in b2e2c9fac85c
 ---> 8697e16c432b
Removing intermediate container b2e2c9fac85c
Step 3/4 : RUN mkdir -p /sti-fake &&     adduser -u 431 -h /sti-fake -s /sbin/nologin -D fakeuser &&     chown -R fakeuser /sti-fake
 ---> Running in 9c2472a66395

 ---> 3728974cf32d
Removing intermediate container 9c2472a66395
Step 4/4 : USER 431
 ---> Running in adab7543480a
 ---> dbd3f597f2d4
Removing intermediate container adab7543480a
Successfully built dbd3f597f2d4
Sending build context to Docker daemon 7.168 kB

Step 1/4 : FROM sti_test/sti-fake
 ---> b20ee93177fc
Step 2/4 : LABEL io.openshift.s2i.assemble-user "431"
 ---> Running in e8aa2e41c7db
 ---> 3d54ae9efb81
Removing intermediate container e8aa2e41c7db
Step 3/4 : RUN mkdir -p /sti-fake &&     adduser -u 431 -h /sti-fake -s /sbin/nologin -D fakeuser &&     chown -R fakeuser /sti-fake
 ---> Running in 5a371c19693b

 ---> 18c29db474eb
Removing intermediate container 5a371c19693b
Step 4/4 : USER 431
 ---> Running in 8f19ef8b432d
 ---> ab8738dee623
Removing intermediate container 8f19ef8b432d
Successfully built ab8738dee623
Sending build context to Docker daemon 7.168 kB

Step 1/4 : FROM busybox
 ---> 16ea53ea7c65
Step 2/4 : RUN mkdir -p /sti-fake/src && 	mkdir /usr/bin && 	ln -s /bin/env /usr/bin/env
 ---> Running in 809f0a340d84

 ---> d96a2e10928d
Removing intermediate container 809f0a340d84
Step 3/4 : WORKDIR /
 ---> 0c11b47bd7e7
Removing intermediate container c343485fa3f7
Step 4/4 : ENV STI_SCRIPTS_URL http://127.0.0.1:23456/.s2i/bin
 ---> Running in bdde2f499a2c
 ---> 87753166a641
Removing intermediate container bdde2f499a2c
Successfully built 87753166a641
Sending build context to Docker daemon 7.168 kB

Step 1/3 : FROM sti_test/sti-fake
 ---> b20ee93177fc
Step 2/3 : RUN mkdir -p /sti-fake &&     adduser -u 431 -h /sti-fake -s /sbin/nologin -D fakeuser &&     chown -R fakeuser /sti-fake
 ---> Running in 3c09e13875a7

 ---> e4c13be83c5d
Removing intermediate container 3c09e13875a7
Step 3/3 : USER fakeuser
 ---> Running in 54d8590b48b5
 ---> c4997e11ac7a
Removing intermediate container 54d8590b48b5
Successfully built c4997e11ac7a
Sending build context to Docker daemon 7.168 kB

Step 1/5 : FROM busybox
 ---> 16ea53ea7c65
Step 2/5 : RUN mkdir -p /sti-fake/src &&     mkdir -p /tmp/scripts && 	mkdir /usr/bin && 	ln -s /bin/env /usr/bin/env
 ---> Running in 13abc548c6b0

 ---> 929d84028c39
Removing intermediate container 13abc548c6b0
Step 3/5 : WORKDIR /
 ---> be5568463a72
Removing intermediate container 6f5b503e01c1
Step 4/5 : ADD scripts/.s2i/bin/ /tmp/scripts/
 ---> 03aefce90021
Removing intermediate container 82b481a91ce5
Step 5/5 : LABEL io.openshift.s2i.scripts-url image:///tmp/scripts/
 ---> Running in 1bf2f8fae689
 ---> 0a1f99917495
Removing intermediate container 1bf2f8fae689
Successfully built 0a1f99917495
Sending build context to Docker daemon 7.168 kB

Step 1/6 : FROM busybox
 ---> 16ea53ea7c65
Step 2/6 : RUN mkdir -p /sti-fake/src &&     mkdir -p /tmp/scripts && 	mkdir /usr/bin && 	ln -s /bin/env /usr/bin/env
 ---> Using cache
 ---> 929d84028c39
Step 3/6 : WORKDIR /
 ---> Using cache
 ---> be5568463a72
Step 4/6 : ADD scripts/.s2i/bin/run /tmp/scripts/
 ---> 4f16780c7d3f
Removing intermediate container 09082178f964
Step 5/6 : ADD scripts/.s2i/bin/assemble /tmp/scripts/
 ---> 3b097d181fa5
Removing intermediate container ce12e1fb5000
Step 6/6 : LABEL io.openshift.s2i.scripts-url image:///tmp/scripts/
 ---> Running in fe58691bdf3d
 ---> 97aca696268e
Removing intermediate container fe58691bdf3d
Successfully built 97aca696268e
Sending build context to Docker daemon 7.168 kB

Step 1/3 : FROM busybox
 ---> 16ea53ea7c65
Step 2/3 : RUN mkdir -p /sti-fake/src &&     rm /bin/tar && 	mkdir /usr/bin && 	ln -s /bin/env /usr/bin/env
 ---> Running in 3e299faff888

 ---> 58fe943dfa5a
Removing intermediate container 3e299faff888
Step 3/3 : WORKDIR /
 ---> fc2d25751f00
Removing intermediate container bd4fdf84c8f9
Successfully built fc2d25751f00
Sending build context to Docker daemon 7.168 kB

Step 1/4 : FROM sti_test/sti-fake
 ---> b20ee93177fc
Step 2/4 : ONBUILD run touch /sti-fake/src/onbuild
 ---> Running in 4cdf3531d708
 ---> 953e9f0f07d0
Removing intermediate container 4cdf3531d708
Step 3/4 : ONBUILD copy . /tmp/src/
 ---> Running in a7c9a7238db8
 ---> 377b16f4844f
Removing intermediate container a7c9a7238db8
Step 4/4 : WORKDIR /tmp/src
 ---> 60cc1a218982
Removing intermediate container ac9772175867
Successfully built 60cc1a218982
Sending build context to Docker daemon 7.168 kB

Step 1/3 : FROM sti_test/sti-fake
 ---> b20ee93177fc
Step 2/3 : RUN mkdir -p /sti-fake &&     adduser -u 431 -h /sti-fake -s /sbin/nologin -D fakeuser &&     chown -R fakeuser /sti-fake
 ---> Using cache
 ---> e4c13be83c5d
Step 3/3 : USER 431
 ---> Running in 53568047ff7e
 ---> 533041dee5a3
Removing intermediate container 53568047ff7e
Successfully built 533041dee5a3
Sending build context to Docker daemon 7.168 kB

Step 1/5 : FROM sti_test/sti-fake
 ---> b20ee93177fc
Step 2/5 : ONBUILD user 0
 ---> Running in 190cada92627
 ---> 9eea9eed5f44
Removing intermediate container 190cada92627
Step 3/5 : ONBUILD run touch /tmp/onbuild
 ---> Running in 077734a8abe8
 ---> 1defee2b8583
Removing intermediate container 077734a8abe8
Step 4/5 : ONBUILD copy . /tmp/src/
 ---> Running in 6724dae23ec1
 ---> 9004c53fe695
Removing intermediate container 6724dae23ec1
Step 5/5 : WORKDIR /tmp/src
 ---> 4f76ca915cf6
Removing intermediate container e00f7821cb2b
Successfully built 4f76ca915cf6
Sending build context to Docker daemon 7.168 kB

Step 1/6 : FROM sti_test/sti-fake
 ---> b20ee93177fc
Step 2/6 : USER 1001
 ---> Running in b7b773ee3f37
 ---> 8e7172cd4f2a
Removing intermediate container b7b773ee3f37
Step 3/6 : ONBUILD user 1001
 ---> Running in e515686b757b
 ---> ab2b68e5eb8f
Removing intermediate container e515686b757b
Step 4/6 : ONBUILD run touch /tmp/onbuild
 ---> Running in 340fd8c717c2
 ---> db016f90555c
Removing intermediate container 340fd8c717c2
Step 5/6 : ONBUILD copy . /tmp/src/
 ---> Running in 6ad96ac4a984
 ---> 67d96681c2c1
Removing intermediate container 6ad96ac4a984
Step 6/6 : WORKDIR /tmp/src
 ---> 282b89b67e4d
Removing intermediate container a8bf363e2b4e
Successfully built 282b89b67e4d
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: BUILD TEST IMAGES [00h 00m 15s] ##########
[workspace] $ /bin/bash /tmp/jenkins221993044841013134.sh
########## STARTING STAGE: EXECUTE DOCKER INTEGRATION TESTS ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
++ mktemp
+ script=/tmp/tmp.rVQPC7XTfE
+ cat
+ chmod +x /tmp/tmp.rVQPC7XTfE
+ scp -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.rVQPC7XTfE openshiftdevel:/tmp/tmp.rVQPC7XTfE
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 7200 /tmp/tmp.rVQPC7XTfE"'
+ cd /data/src/github.com/openshift/source-to-image
+ make test-docker
hack/test-docker.sh 

Running docker integration tests ...

go: finding golang.org/x/net v0.0.0-20200324143707-d3edc9973b7e
go: finding k8s.io/klog/v2 v2.3.0
go: finding google.golang.org/genproto v0.0.0-20190708153700-3bdd9d9f5532
go: finding github.com/docker/go-connections v0.4.0
go: finding github.com/spf13/pflag v1.0.3
go: finding github.com/spf13/cobra v0.0.0-20160802223737-7c674d9e7201
go: finding github.com/inconshreveable/mousetrap v1.0.0
go: finding github.com/docker/distribution v2.7.1+incompatible
go: finding github.com/docker/docker v0.0.0-20190404075923-dbe4a30928d4
go: finding github.com/containers/image/v5 v5.4.3
go: finding github.com/moby/buildkit v0.6.3
go: finding github.com/go-logr/logr v0.2.0
go: finding github.com/xeipuuv/gojsonschema v1.2.0
go: finding github.com/sirupsen/logrus v1.4.2
go: finding github.com/BurntSushi/toml v0.3.1
go: finding github.com/docker/docker-credential-helpers v0.6.3
go: finding github.com/ghodss/yaml v1.0.0
go: finding github.com/opencontainers/selinux v1.5.1
go: finding github.com/xeipuuv/gojsonreference v0.0.0-20180127040603-bd5ef7bd5415
go: finding github.com/ulikunitz/xz v0.5.7
go: finding golang.org/x/sync v0.0.0-20200317015054-43a5402ce75a
go: finding github.com/kr/pretty v0.1.0
go: finding github.com/docker/libtrust v0.0.0-20160708172513-aabc10ec26b7
go: finding github.com/google/shlex v0.0.0-20150127133951-6f45313302b9
go: finding golang.org/x/crypto v0.0.0-20180904163835-0709b304e793
go: finding github.com/tonistiigi/units v0.0.0-20180711220420-6950e57a87ea
go: finding github.com/ostreedev/ostree-go v0.0.0-20190702140239-759a8c1ac913
go: finding github.com/docker/go-events v0.0.0-20170721190031-9461782956ad
go: finding github.com/xeipuuv/gojsonpointer v0.0.0-20180127040702-4e3ac2762d5f
go: finding github.com/containerd/continuity v0.0.0-20190827140505-75bee3e2ccb6
go: finding github.com/docker/go-connections v0.3.0
go: finding github.com/docker/go-metrics v0.0.1
go: finding go.etcd.io/bbolt v1.3.2
go: finding github.com/vbauerster/mpb/v5 v5.0.3
go: finding github.com/codahale/hdrhistogram v0.0.0-20160425231609-f8ad88b59a58
go: finding github.com/containers/storage v1.18.2
go: finding github.com/uber/jaeger-client-go v0.0.0-20180103221425-e02c85f9069e
go: finding github.com/gogo/protobuf v1.2.0
go: finding github.com/hashicorp/uuid v0.0.0-20160311170451-ebb0a03e909c
go: finding github.com/sirupsen/logrus v1.3.0
go: finding github.com/pkg/errors v0.8.1
go: finding github.com/containers/libtrust v0.0.0-20190913040956-14b96171aa3b
go: finding github.com/tonistiigi/fsutil v0.0.0-20190819224149-3d2716dd0a4d
go: finding github.com/containerd/containerd v1.3.6
go: finding google.golang.org/grpc v1.12.0
go: finding github.com/mtrmac/gpgme v0.1.2
go: finding github.com/golang/protobuf v1.2.0
go: finding github.com/containerd/cgroups v0.0.0-20190226200435-dbea6f2bd416
go: finding github.com/morikuni/aec v1.0.0
go: finding github.com/kr/text v0.1.0
go: finding github.com/pquerna/ffjson v0.0.0-20190813045741-dac163c6c0a9
go: finding golang.org/x/time v0.0.0-20161028155119-f51c12702a4d
go: finding golang.org/x/sys v0.0.0-20191127021746-63cb32ae39b2
go: finding github.com/vishvananda/netlink v1.0.0
go: finding github.com/gotestyourself/gotestyourself v2.2.0+incompatible
go: finding github.com/grpc-ecosystem/grpc-opentracing v0.0.0-20180507213350-8e809c8a8645
go: finding github.com/docker/go-units v0.4.0
go: finding github.com/gogo/protobuf v1.3.1
go: finding github.com/kr/pty v1.1.1
go: finding golang.org/x/sys v0.0.0-20190303122642-d455e41777fc
go: finding github.com/uber/jaeger-lib v1.2.1
go: finding github.com/14rcole/gopopulate v0.0.0-20180821133914-b175b219e774
go: finding golang.org/x/net v0.0.0-20190628185345-da137c7871d7
go: finding github.com/opencontainers/runc v1.0.0-rc8
go: finding github.com/containerd/go-cni v0.0.0-20190610170741-5a4663dad645
go: finding github.com/opencontainers/go-digest v1.0.0-rc1
go: finding github.com/VividCortex/ewma v1.1.1
go: finding github.com/docker/docker-credential-helpers v0.6.0
go: finding golang.org/x/sys v0.0.0-20200323222414-85ca7c5b95cd
go: finding github.com/mistifyio/go-zfs v2.1.1+incompatible
go: finding github.com/morikuni/aec v0.0.0-20170113033406-39771216ff4c
go: finding github.com/Microsoft/hcsshim v0.8.5
go: finding github.com/prometheus/client_golang v1.1.0
go: finding github.com/serialx/hashring v0.0.0-20190422032157-8b2912629002
go: finding golang.org/x/sys v0.0.0-20190215142949-d0b11bdaac8a
go: finding github.com/opencontainers/image-spec v1.0.1
go: finding golang.org/x/sys v0.0.0-20190422165155-953cdadca894
go: finding github.com/stretchr/testify v1.5.1
go: finding github.com/kisielk/errcheck v1.2.0
go: finding github.com/google/go-cmp v0.2.0
go: finding github.com/hashicorp/go-multierror v1.0.0
go: finding github.com/konsorten/go-windows-terminal-sequences v1.0.1
go: finding github.com/onsi/ginkgo v1.7.0
go: finding github.com/docker/go-units v0.3.1
go: finding github.com/opencontainers/runtime-spec v0.1.2-0.20190507144316-5b71a03e2700
go: finding github.com/pkg/profile v1.2.1
go: finding github.com/pmezard/go-difflib v1.0.0
go: finding golang.org/x/sync v0.0.0-20180314180146-1d60e4601c6f
go: finding github.com/konsorten/go-windows-terminal-sequences v1.0.2
go: finding golang.org/x/text v0.3.0
go: finding github.com/tchap/go-patricia v2.3.0+incompatible
go: finding github.com/containerd/typeurl v0.0.0-20180627222232-a93fcdb778cd
go: finding gopkg.in/airbrake/gobrake.v2 v2.0.9
go: finding github.com/docker/distribution v2.7.1-0.20190205005809-0d3efadf0154+incompatible
go: finding gopkg.in/yaml.v2 v2.2.2
go: finding github.com/containers/ocicrypt v1.0.2
go: finding github.com/godbus/dbus v4.1.0+incompatible
go: finding golang.org/x/time v0.0.0-20191024005414-555d28b269f0
go: finding github.com/gorilla/mux v1.7.4
go: finding golang.org/x/lint v0.0.0-20190227174305-5b3e6a55c961
go: finding github.com/coreos/go-systemd v0.0.0-20190321100706-95778dfbb74e
go: finding github.com/apache/thrift v0.0.0-20161221203622-b2a4d4ae21c7
go: finding github.com/hashicorp/errwrap v1.0.0
go: finding github.com/Microsoft/hcsshim v0.8.7
go: finding github.com/mattn/go-shellwords v1.0.10
go: finding github.com/sirupsen/logrus v1.0.3
go: finding github.com/mitchellh/hashstructure v0.0.0-20170609045927-2bca23e0e452
go: finding gopkg.in/square/go-jose.v2 v2.3.1
go: finding github.com/golang/protobuf v1.3.1
go: finding golang.org/x/sys v0.0.0-20191115151921-52ab43148777
go: finding golang.org/x/sys v0.0.0-20200327173247-9dae0f8f5775
go: finding github.com/fullsailor/pkcs7 v0.0.0-20190404230743-d7302db945fa
go: finding honnef.co/go/tools v0.0.0-20190102054323-c2f93a96b099
go: finding github.com/Azure/go-ansiterm v0.0.0-20170929234023-d6e3b3328b78
go: finding golang.org/x/net v0.0.0-20190311183353-d8887717615a
go: finding github.com/opentracing-contrib/go-stdlib v0.0.0-20171029140428-b1a47cfbdd75
go: finding github.com/prometheus/procfs v0.0.3
go: finding golang.org/x/tools v0.0.0-20181030221726-6c7e314b6563
go: finding github.com/pkg/errors v0.9.1
go: finding github.com/syndtr/gocapability v0.0.0-20180916011248-d98352740cb2
go: finding github.com/Microsoft/go-winio v0.4.11
go: finding golang.org/x/sys v0.0.0-20190916202348-b4ddaad3f8a3
go: finding github.com/opencontainers/runc v1.0.0-rc6
go: finding github.com/sirupsen/logrus v1.4.1
go: finding github.com/containerd/ttrpc v0.0.0-20190411181408-699c4e40d1e7
go: finding github.com/stretchr/testify v1.3.0
go: finding golang.org/x/sys v0.0.0-20190801041406-cbf593c0f2f3
go: finding github.com/containerd/ttrpc v0.0.0-20190828154514-0e0f228740de
go: finding github.com/containerd/continuity v0.0.0-20181001140422-bd77b46c8352
go: finding github.com/containerd/console v0.0.0-20180822173158-c12b1e7919c1
go: finding github.com/containernetworking/cni v0.6.1-0.20180218032124-142cde0c766c
go: finding github.com/opencontainers/runc v0.0.0-20190115041553-12f6a991201f
go: finding github.com/opencontainers/selinux v1.4.0
go: finding github.com/pquerna/ffjson v0.0.0-20181028064349-e517b90714f7
go: finding github.com/opencontainers/runtime-tools v0.0.0-20181011054405-1d69bd0f9c39
go: finding golang.org/x/exp v0.0.0-20190121172915-509febef88a4
go: finding go.etcd.io/bbolt v1.3.4
go: finding github.com/prometheus/common v0.6.0
go: finding gopkg.in/check.v1 v1.0.0-20180628173108-788fd7840127
go: finding github.com/opencontainers/image-spec v1.0.2-0.20190823105129-775207bd45b6
go: finding github.com/hashicorp/go-immutable-radix v1.0.0
go: finding go.opencensus.io v0.22.0
go: finding github.com/gogo/protobuf v1.0.0
go: finding golang.org/x/tools v0.0.0-20190226205152-f727befe758c
go: finding gotest.tools v2.2.0+incompatible
go: finding github.com/vbatts/tar-split v0.11.1
go: finding github.com/kisielk/gotool v1.0.0
go: finding gopkg.in/gemnasium/logrus-airbrake-hook.v2 v2.1.2
go: finding github.com/jaguilar/vt100 v0.0.0-20150826170717-2703a27b14ea
go: finding github.com/klauspost/compress v1.10.3
go: finding github.com/davecgh/go-spew v1.1.0
go: finding github.com/klauspost/pgzip v1.2.3
go: finding github.com/xeipuuv/gojsonpointer v0.0.0-20190809123943-df4f5c81cb3b
go: finding github.com/hashicorp/golang-lru v0.5.1
go: finding github.com/davecgh/go-spew v1.1.1
go: finding github.com/json-iterator/go v1.1.7
go: finding github.com/docker/libnetwork v0.8.0-dev.2.0.20190604151032-3c26b4e7495e
go: finding github.com/gogo/googleapis v1.1.0
go: finding github.com/opencontainers/runc v1.0.0-rc9
go: finding github.com/hashicorp/golang-lru v0.0.0-20160207214719-a0d98a5f2880
go: finding github.com/acarl005/stripansi v0.0.0-20180116102854-5a71ef0e047d
go: finding gotest.tools v2.1.0+incompatible
go: finding github.com/Microsoft/go-winio v0.4.13-0.20190408173621-84b4ab48a507
go: finding github.com/pkg/errors v0.8.0
go: finding golang.org/x/sys v0.0.0-20180905080454-ebe1bf3edb33
go: finding github.com/containerd/fifo v0.0.0-20180307165137-3d5202aec260
go: finding github.com/containerd/fifo v0.0.0-20190226154929-a9fb20d87448
go: finding github.com/go-logfmt/logfmt v0.4.0
go: finding gopkg.in/yaml.v2 v2.2.1
go: finding github.com/containerd/cgroups v0.0.0-20190919134610-bf292b21730f
go: finding golang.org/x/sys v0.0.0-20200202164722-d101bd2416d5
go: finding github.com/google/go-cmp v0.3.0
go: finding github.com/hashicorp/errwrap v0.0.0-20141028054710-7554cd9344ce
go: finding github.com/opencontainers/go-digest v0.0.0-20180430190053-c9281466c8b2
go: finding github.com/prometheus/procfs v0.0.5
go: finding golang.org/x/net v0.0.0-20190613194153-d28f0bde5980
go: finding github.com/opencontainers/runtime-spec v0.0.0-20180909173843-eba862dc2470
go: finding github.com/godbus/dbus v0.0.0-20190422162347-ade71ed3457e
go: finding github.com/hashicorp/go-multierror v0.0.0-20161216184304-ed905158d874
go: finding github.com/xeipuuv/gojsonschema v0.0.0-20180618132009-1d523034197f
go: finding github.com/ishidawataru/sctp v0.0.0-20180213033435-07191f837fed
go: finding github.com/golang/protobuf v1.3.2
go: finding k8s.io/kubernetes v1.13.0
go: finding gopkg.in/yaml.v2 v2.2.8
go: finding github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90
go: finding github.com/google/gofuzz v1.0.0
go: finding github.com/containerd/go-runc v0.0.0-20180907222934-5a6d9f37cfa3
go: finding github.com/opentracing/opentracing-go v0.0.0-20171003133519-1361b9cd60be
go: finding github.com/gofrs/flock v0.7.0
go: finding github.com/kr/logfmt v0.0.0-20140226030751-b84e30acd515
go: finding golang.org/x/sys v0.0.0-20200302150141-5c8b2ff67527
go: finding github.com/onsi/gomega v1.4.3
go: finding github.com/vishvananda/netns v0.0.0-20180720170159-13995c7128cc
go: finding github.com/julienschmidt/httprouter v1.2.0
go: finding gopkg.in/check.v1 v1.0.0-20190902080502-41f04d3bba15
go: finding github.com/stretchr/testify v1.2.2
go: finding github.com/gogo/protobuf v1.2.1
go: finding github.com/stretchr/objx v0.1.0
go: finding golang.org/x/sync v0.0.0-20181221193216-37e7f081c4d4
go: finding gopkg.in/alecthomas/kingpin.v2 v2.2.6
go: finding github.com/modern-go/concurrent v0.0.0-20180228061459-e0a39a4cb421
go: finding google.golang.org/appengine v1.4.0
go: finding github.com/modern-go/reflect2 v0.0.0-20180701023420-4b7aa43c6742
go: finding github.com/go-kit/kit v0.8.0
go: finding github.com/matttproud/golang_protobuf_extensions v1.0.1
go: finding github.com/sirupsen/logrus v1.2.0
go: finding github.com/syndtr/gocapability v0.0.0-20170704070218-db04d3cc01c8
go: finding github.com/containerd/go-runc v0.0.0-20190911050354-e029b79d8cda
go: finding github.com/hpcloud/tail v1.0.0
go: finding golang.org/x/net v0.0.0-20180724234803-3673e40ba225
go: finding golang.org/x/sync v0.0.0-20190227155943-e225da77a7e6
go: finding github.com/mwitkow/go-conntrack v0.0.0-20161129095857-cc309e4a2223
go: finding golang.org/x/sys v0.0.0-20190514135907-3a4b5fb9f71f
go: finding github.com/stretchr/objx v0.1.1
go: finding gopkg.in/check.v1 v0.0.0-20161208181325-20d25e280405
go: finding golang.org/x/text v0.3.2
go: finding github.com/fsnotify/fsnotify v1.4.7
go: finding gopkg.in/fsnotify.v1 v1.4.7
go: finding golang.org/x/sync v0.0.0-20181108010431-42b317875d0f
go: finding github.com/Microsoft/go-winio v0.4.15-0.20190919025122-fc70bd9a86b5
go: finding golang.org/x/net v0.0.0-20190213061140-3a22650c66bd
go: finding github.com/urfave/cli v0.0.0-20171014202726-7bc6a0acffa5
go: finding golang.org/x/sys v0.0.0-20180909124046-d0be0721c37e
go: finding golang.org/x/net v0.0.0-20180906233101-161cd47e91fd
go: finding github.com/hashicorp/golang-lru v0.5.0
go: finding golang.org/x/sys v0.0.0-20190502145724-3ef323f4f1fd
go: finding github.com/containerd/console v0.0.0-20181022165439-0650fd9eeb50
go: finding github.com/onsi/ginkgo v1.6.0
go: finding github.com/kisielk/errcheck v1.1.0
go: finding github.com/hashicorp/go-uuid v1.0.0
go: finding github.com/docker/cli v0.0.0-20190321234815-f40f9c240ab0
go: finding github.com/prometheus/client_golang v1.0.0
go: finding golang.org/x/net v0.0.0-20190501004415-9ce7a6920f09
go: finding golang.org/x/tools v0.0.0-20180917221912-90fa682c2a6e
go: finding golang.org/x/tools v0.0.0-20180221164845-07fd8470d635
go: finding github.com/beorn7/perks v1.0.1
go: finding github.com/imdario/mergo v0.3.9
go: finding github.com/blang/semver v3.1.0+incompatible
go: finding gopkg.in/tomb.v1 v1.0.0-20141024135613-dd632973f1e7
go: finding github.com/prometheus/procfs v0.0.2
go: finding github.com/containerd/continuity v0.0.0-20190426062206-aaeac12a7ffc
go: finding golang.org/x/sys v0.0.0-20181116152217-5ac8a444bdc5
go: finding github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
go: finding github.com/json-iterator/go v1.1.6
go: finding github.com/modern-go/reflect2 v1.0.1
go: finding github.com/prometheus/common v0.4.1
go: finding github.com/beorn7/perks v1.0.0
go: finding github.com/beorn7/perks v0.0.0-20180321164747-3a771d992973
go: finding github.com/gogo/protobuf v1.1.1
go: finding github.com/prometheus/client_model v0.0.0-20180712105110-5c3871d89910
go: finding github.com/alecthomas/units v0.0.0-20151022065526-2efee857e7cf
go: finding github.com/prometheus/client_golang v0.9.1
go: finding golang.org/x/net v0.0.0-20181114220301-adae6a3d119a
go: finding github.com/go-logfmt/logfmt v0.3.0
go: finding github.com/go-stack/stack v1.8.0
go: finding github.com/prometheus/procfs v0.0.0-20181005140218-185b4288413d
go: finding github.com/alecthomas/template v0.0.0-20160405071501-a0175ee3bccc
?   	github.com/openshift/source-to-image/test/integration/docker	[no test files]

Complete
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: EXECUTE DOCKER INTEGRATION TESTS [00h 00m 47s] ##########
[workspace] $ /bin/bash /tmp/jenkins8530101729699752684.sh
########## STARTING STAGE: EXECUTE S2I RUNIMAGE TESTS ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
++ mktemp
+ script=/tmp/tmp.GBflvpkutC
+ cat
+ chmod +x /tmp/tmp.GBflvpkutC
+ scp -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.GBflvpkutC openshiftdevel:/tmp/tmp.GBflvpkutC
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 7200 /tmp/tmp.GBflvpkutC"'
+ cd /data/src/github.com/openshift/source-to-image
+ hack/test-stirunimage.sh
working dir:  /tmp/sti/test-work.NQgr
s2i working dir:  /tmp/sti/test-work.NQgr
/tmp/sti/test-work.NQgr /data/src/github.com/openshift/source-to-image

cloning source into working dir


TEST PASSED


s2i build with relative path without file://


TEST PASSED


s2i build with volume options


TEST PASSED

/data/src/github.com/openshift/source-to-image

s2i build with absolute path with file://


TEST PASSED


s2i build with absolute path without file://


TEST PASSED


s2i build with non-git repo file location


TEST PASSED

I1013 19:03:47.059760   18135 download.go:38] Copying sources from "/tmp/sti/test-work.NQgr/cakephp-ex" to "/tmp/s2i979104146/upload/src"

TEST PASSED


s2i rebuild


TEST PASSED


TEST PASSED


s2i usage


TEST PASSED

I1013 19:04:29.925418   19153 sti.go:713] Sample invocation:

TEST PASSED


s2i build with overriding assemble/run scripts

Running custom assemble

TEST PASSED

Running custom run

TEST PASSED


s2i build with add-host option

Gem::RemoteFetcher::FetchError: Errno::ECONNREFUSED: Failed to open TCP connection to rubygems.org:443 (Connection refused - connect(2) for "rubygems.org" port 443) (https://rubygems.org/gems/rake-13.0.3.gem)

TEST PASSED


s2i build with remote git repo


TEST PASSED


s2i build with runtime image


TEST PASSED


s2i build with Dockerfile output


TEST PASSED


s2i build with --run==true option

Waiting up to 15*TIME_MIN for the build to finish ...
The image test-jee-app:latest has been started in container 6a77d713853b9a491a69417380dfdb1787de71a58ede0bccc727ebcd45693c59 as a result of the --run=true option.  The container's stdout/stderr will be redirected to this command's log output to help you validate its behavior.  You can also inspect the container with docker commands if you like.  If the container is set up to stay running, you will have to Ctrl-C to exit this command, which should also stop the container 6a77d713853b9a491a69417380dfdb1787de71a58ede0bccc727ebcd45693c59.  This particular invocation attempts to run with the port mappings 
[INFO] Success running command s2i --run=true
[INFO] Success terminating associated docker container
Cleaning up working dir /tmp/sti/test-work.NQgr

Complete
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: EXECUTE S2I RUNIMAGE TESTS [00h 04m 10s] ##########
[PostBuildScript] - [INFO] Executing post build scripts.
[workspace] $ /bin/bash /tmp/jenkins6578344737721978706.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/gathered
+ tree /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/gathered
/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/gathered

0 directories, 0 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins4844076397198869368.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/generated
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo docker version && sudo docker info && sudo docker images && sudo docker ps -a 2>&1'
  WARNING: You're not using the default seccomp profile
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo cat /etc/sysconfig/docker /etc/sysconfig/docker-network /etc/sysconfig/docker-storage /etc/sysconfig/docker-storage-setup /etc/systemd/system/docker.service 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo find /var/lib/docker/containers -name *.log | sudo xargs tail -vn +1 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo df -T -h && sudo pvs && sudo vgs && sudo lvs && sudo findmnt --all 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo yum list installed 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl --dmesg --no-pager --all --lines=all 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/artifacts/generated
/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/generated
├── avc_denials.log
├── containers.log
├── dmesg.log
├── docker.config
├── docker.info
├── filesystem.info
├── installed_packages.log
└── pid1.journal

0 directories, 8 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins8684835282187838681.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/journals
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit docker.service --no-pager --all --lines=all
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit dnsmasq.service --no-pager --all --lines=all
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/artifacts/journals
/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/journals
├── dnsmasq.service
├── docker.service
└── systemd-journald.service

0 directories, 3 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins3836092911952246855.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/225/api/json'\''))['\''result'\'']'
+ result=SUCCESS
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_pull_request_s2i_master/builds/225/log
+ cp -r artifacts/generated gcs/artifacts/
+ cp -r artifacts/journals gcs/artifacts/
+ cp -r artifacts/gathered/ gcs/artifacts/
++ pwd
+ scp -F ./.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/gcs openshiftdevel:/data
+ scp -F ./.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/jenkins7410889727798267664.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config
++ mktemp
+ script=/tmp/tmp.vcGyLQ8207
+ cat
+ chmod +x /tmp/tmp.vcGyLQ8207
+ scp -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.vcGyLQ8207 openshiftdevel:/tmp/tmp.vcGyLQ8207
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.vcGyLQ8207"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"presubmit","job":"test_pull_request_s2i_master","buildid":"1448362268155711488","prowjobid":"5d63b9dc-2c57-11ec-a826-0a580a830222","refs":{"org":"openshift","repo":"source-to-image","repo_link":"https://github.com/openshift/source-to-image","base_ref":"master","base_sha":"cc5438d25d60966b70fb85b463bf724eafcad49c","base_link":"https://github.com/openshift/source-to-image/commit/cc5438d25d60966b70fb85b463bf724eafcad49c","pulls":[{"number":1072,"author":"seeker25","sha":"6d698a3701253319b16186b4bc1458433a5f0bb3","title":"Windows ignore path fix","link":"https://github.com/openshift/source-to-image/pull/1072","commit_link":"https://github.com/openshift/source-to-image/pull/1072/commits/6d698a3701253319b16186b4bc1458433a5f0bb3","author_link":"https://github.com/seeker25"}]}} ]]
++ jq --compact-output '.buildid |= "225"'
+ JOB_SPEC='{"type":"presubmit","job":"test_pull_request_s2i_master","buildid":"225","prowjobid":"5d63b9dc-2c57-11ec-a826-0a580a830222","refs":{"org":"openshift","repo":"source-to-image","repo_link":"https://github.com/openshift/source-to-image","base_ref":"master","base_sha":"cc5438d25d60966b70fb85b463bf724eafcad49c","base_link":"https://github.com/openshift/source-to-image/commit/cc5438d25d60966b70fb85b463bf724eafcad49c","pulls":[{"number":1072,"author":"seeker25","sha":"6d698a3701253319b16186b4bc1458433a5f0bb3","title":"Windows ignore path fix","link":"https://github.com/openshift/source-to-image/pull/1072","commit_link":"https://github.com/openshift/source-to-image/pull/1072/commits/6d698a3701253319b16186b4bc1458433a5f0bb3","author_link":"https://github.com/seeker25"}]}}'
+ docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_s2i_master","buildid":"225","prowjobid":"5d63b9dc-2c57-11ec-a826-0a580a830222","refs":{"org":"openshift","repo":"source-to-image","repo_link":"https://github.com/openshift/source-to-image","base_ref":"master","base_sha":"cc5438d25d60966b70fb85b463bf724eafcad49c","base_link":"https://github.com/openshift/source-to-image/commit/cc5438d25d60966b70fb85b463bf724eafcad49c","pulls":[{"number":1072,"author":"seeker25","sha":"6d698a3701253319b16186b4bc1458433a5f0bb3","title":"Windows ignore path fix","link":"https://github.com/openshift/source-to-image/pull/1072","commit_link":"https://github.com/openshift/source-to-image/pull/1072/commits/6d698a3701253319b16186b4bc1458433a5f0bb3","author_link":"https://github.com/seeker25"}]}}' -v /data:/data:z registry.ci.openshift.org/ci/gcsupload:latest --dry-run=false --gcs-path=gs://origin-ci-test --gcs-credentials-file=/data/credentials.json --path-strategy=single --default-org=openshift --default-repo=origin /data/gcs/artifacts /data/gcs/build-log.txt /data/gcs/finished.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: Already exists
809b39f1848e: Already exists
da890d203d61: Pulling fs layer
85cea451eec0: Pulling fs layer
85cea451eec0: Verifying Checksum
85cea451eec0: Download complete
da890d203d61: Verifying Checksum
da890d203d61: Download complete
da890d203d61: Pull complete
85cea451eec0: Pull complete
Digest: sha256:d36fde93a35122c7fc8dc19b077db036425d0eb855faf3d290bd1e6849300c1b
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-13T19:07:23Z"}
{"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/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/avc_denials.log\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"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/containers.log in artifact directory. Uploading as pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/containers.log\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"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/dmesg.log in artifact directory. Uploading as pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/dmesg.log\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"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/docker.config in artifact directory. Uploading as pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/docker.config\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"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/docker.info in artifact directory. Uploading as pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/docker.info\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"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/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/filesystem.info\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"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/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/installed_packages.log\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"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/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/pid1.journal\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"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/dnsmasq.service in artifact directory. Uploading as pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/journals/dnsmasq.service\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"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/docker.service in artifact directory. Uploading as pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/journals/docker.service\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"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/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/journals/systemd-journald.service\n","severity":"info","time":"2021-10-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/docker.config","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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/journals/docker.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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_s2i_master/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/containers.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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/dmesg.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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/docker.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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_s2i_master/225.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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/journals/dnsmasq.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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/docker.config","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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/docker.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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/dmesg.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-13T19:07:23Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:24Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_s2i_master/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-13T19:07:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/journals/docker.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-13T19:07:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/generated/containers.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-13T19:07:24Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_s2i_master/225.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-13T19:07:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/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-13T19:07:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/openshift_source-to-image/1072/test_pull_request_s2i_master/225/artifacts/journals/dnsmasq.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-13T19:07:24Z"}
{"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-13T19:07:24Z"}
{"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-13T19:07:24Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 07s] ##########
[workspace] $ /bin/bash /tmp/jenkins6714577401765960251.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_s2i_master/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-13 15:07:25.651525", 
    "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-13 15:07:25.656124", 
    "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-13 15:07:26.513030", 
    "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-13 15:07:27.178519", 
    "msg": "Tags {'Name': 'oct-terminate'} created for resource i-0667f099f4bc25d2c."
}

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-13 15:07:28.455891", 
    "instance_ids": [
        "i-0667f099f4bc25d2c"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0a7ac212b7bc60552"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0828d330796b7ec5d"
                }
            }, 
            "dns_name": "ec2-54-242-71-87.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-0667f099f4bc25d2c", 
            "image_id": "ami-0be3a2afbcd35d3f1", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2021-10-13T18:57:51.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-8-225.ec2.internal", 
            "private_ip": "172.18.8.225", 
            "public_dns_name": "ec2-54-242-71-87.compute-1.amazonaws.com", 
            "public_ip": "54.242.71.87", 
            "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-13 15:07:28.713175", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.8.225.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-13 15:07:29.222049", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_s2i_master/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_s2i_master/workspace/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/generated/containers.log, /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/generated/dmesg.log, /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/artifacts/generated/installed_packages.log, /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/gcs/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/gcs/artifacts/generated/containers.log, /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/gcs/artifacts/generated/dmesg.log, /var/lib/jenkins/jobs/test_pull_request_s2i_master/workspace/gcs/artifacts/generated/installed_packages.log] to splunk in 8 events
[WS-CLEANUP] Deleting project workspace...
[WS-CLEANUP] Deferred wipeout is used...
[WS-CLEANUP] done
Finished: SUCCESS