Console Output
Skipping 525 KB..
Full Log4f40231ab7cd: Mounted from ci-pr-images/prtest-e07e3c7-786-origin-template-service-broker
a11d67d95f6c: Mounted from ci-pr-images/prtest-e07e3c7-786-origin-recycler
b20270190eef: Pushed
latest: digest: sha256:f2231c5f4c88e97cdf640dcbb9801f61a81cd7f2b6e6c4781fbb9539c07e64fc size: 1371
[INFO] Pushing registry.svc.ci.openshift.org/ci-pr-images/prtest-e07e3c7-786-origin-tests:v4.0...
The push refers to a repository [registry.svc.ci.openshift.org/ci-pr-images/prtest-e07e3c7-786-origin-tests]
b20270190eef: Preparing
a11d67d95f6c: Preparing
3af7a5efc9bf: Preparing
4f40231ab7cd: Preparing
f972d139738d: Preparing
b20270190eef: Layer already exists
a11d67d95f6c: Layer already exists
3af7a5efc9bf: Layer already exists
4f40231ab7cd: Layer already exists
f972d139738d: Layer already exists
v4.0: digest: sha256:f2231c5f4c88e97cdf640dcbb9801f61a81cd7f2b6e6c4781fbb9539c07e64fc size: 1371
[INFO] Pushing registry.svc.ci.openshift.org/ci-pr-images/prtest-e07e3c7-786-origin-tests:v4.0.0...
The push refers to a repository [registry.svc.ci.openshift.org/ci-pr-images/prtest-e07e3c7-786-origin-tests]
b20270190eef: Preparing
a11d67d95f6c: Preparing
3af7a5efc9bf: Preparing
4f40231ab7cd: Preparing
f972d139738d: Preparing
4f40231ab7cd: Layer already exists
a11d67d95f6c: Layer already exists
b20270190eef: Layer already exists
f972d139738d: Layer already exists
3af7a5efc9bf: Layer already exists
v4.0.0: digest: sha256:f2231c5f4c88e97cdf640dcbb9801f61a81cd7f2b6e6c4781fbb9539c07e64fc size: 1371
hack/push-release.sh took 261 seconds
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE RELEASE [00h 04m 22s] ##########
[workspace] $ /bin/bash /tmp/jenkins1989564678570072725.sh
########## STARTING STAGE: MOVE SECRETS TO REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
+ rsync --copy-links --omit-dir-times --archive --rsh 'ssh -F ./.config/origin-ci-tool/inventory/.ssh_config' /var/lib/jenkins/.azure/10_oreg_auth.yml /var/lib/jenkins/.azure/10_yum_repos.yml /var/lib/jenkins/.azure/credentials /var/lib/jenkins/.azure/kubeconfig /var/lib/jenkins/.azure/registry /var/lib/jenkins/.azure/ssh-privatekey openshiftdevel:/data/src/github.com/openshift/release/cluster/test-deploy/azure/
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo chown -R origin:origin-git /data/src/github.com/openshift/release/cluster/test-deploy/azure/'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo chmod -R ug+rwX /data/src/github.com/openshift/release/cluster/test-deploy/azure/'
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: MOVE SECRETS TO REMOTE HOST [00h 00m 01s] ##########
[workspace] $ /bin/bash /tmp/jenkins5801258103939494626.sh
########## STARTING STAGE: SET DEBUGGABILITY FLAG ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: SET DEBUGGABILITY FLAG [00h 00m 00s] ##########
[workspace] $ /bin/bash /tmp/jenkins3266983023961858931.sh
########## STARTING STAGE: BUILD NODE IMAGE ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ mktemp
+ script=/tmp/tmp.hSBIdgeNMl
+ cat
+ chmod +x /tmp/tmp.hSBIdgeNMl
+ scp -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.hSBIdgeNMl openshiftdevel:/tmp/tmp.hSBIdgeNMl
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.hSBIdgeNMl"'
+ cd /data/src/github.com/openshift/release
+ suffix='origin-${component}'
++ cat /data/src/github.com/openshift/aos-cd-jobs/ORIGIN_TAG
+ suffix='origin-${component}:v4.0'
+ cd cluster/test-deploy/azure
+ TYPE=azure
+ ../../bin/ansible.sh ansible-playbook -e openshift_azure_resource_group_name=ci-test_branch_origin_extended_c_azure-786 -e openshift_azure_resource_location=eastus -e openshift_azure_input_image_ns=images -e openshift_azure_input_image_prefix=centos7-base -e openshift_azure_output_image_ns=ci-test_branch_origin_extended_c_azure-786 -e openshift_azure_output_image_name=centos7-origin -e openshift_azure_install_repo=https://storage.googleapis.com/origin-ci-test/logs/test_branch_origin_extended_conformance_azure/786/artifacts/rpms -e openshift_azure_vm_size=Standard_D2s_v3 -e 'oreg_url=registry.svc.ci.openshift.org/ci-pr-images/prtest-e07e3c7-786-origin-${component}:v4.0' playbooks/azure/openshift-cluster/build_node_image.yml
PLAY [localhost] ***************************************************************
TASK [calculate input image] ***************************************************
Thursday 22 November 2018 05:47:56 +0000 (0:00:00.093) 0:00:00.093 *****
changed: [localhost]
TASK [create resource group] ***************************************************
Thursday 22 November 2018 05:47:58 +0000 (0:00:01.820) 0:00:01.913 *****
changed: [localhost]
TASK [create vnet] *************************************************************
Thursday 22 November 2018 05:48:00 +0000 (0:00:01.756) 0:00:03.670 *****
changed: [localhost]
TASK [create subnet] ***********************************************************
Thursday 22 November 2018 05:48:15 +0000 (0:00:15.530) 0:00:19.201 *****
changed: [localhost]
TASK [create vm] ***************************************************************
Thursday 22 November 2018 05:48:20 +0000 (0:00:05.206) 0:00:24.408 *****
changed: [localhost]
TASK [add vm to inventory] *****************************************************
Thursday 22 November 2018 05:50:58 +0000 (0:02:37.778) 0:03:02.186 *****
changed: [localhost]
PLAY [nodes] *******************************************************************
TASK [Gathering Facts] *********************************************************
Thursday 22 November 2018 05:50:58 +0000 (0:00:00.040) 0:03:02.227 *****
ok: [40.76.5.36]
TASK [set_fact] ****************************************************************
Thursday 22 November 2018 05:51:01 +0000 (0:00:03.126) 0:03:05.353 *****
ok: [40.76.5.36]
TASK [add insights-client to package installs when on rhel] ********************
Thursday 22 November 2018 05:51:01 +0000 (0:00:00.069) 0:03:05.423 *****
skipping: [40.76.5.36]
TASK [set_fact] ****************************************************************
Thursday 22 November 2018 05:51:01 +0000 (0:00:00.042) 0:03:05.466 *****
ok: [40.76.5.36]
TASK [install centos-release-paas-common rpm] **********************************
Thursday 22 November 2018 05:51:02 +0000 (0:00:00.113) 0:03:05.579 *****
changed: [40.76.5.36]
TASK [copy yum client certificate] *********************************************
Thursday 22 November 2018 05:51:13 +0000 (0:00:11.757) 0:03:17.337 *****
skipping: [40.76.5.36] => (item=None)
skipping: [40.76.5.36] => (item=None)
skipping: [40.76.5.36]
TASK [include_role : openshift_repos] ******************************************
Thursday 22 November 2018 05:51:13 +0000 (0:00:00.058) 0:03:17.395 *****
TASK [openshift_repos : Ensure libselinux-python is installed] *****************
Thursday 22 November 2018 05:51:13 +0000 (0:00:00.080) 0:03:17.475 *****
ok: [40.76.5.36]
TASK [openshift_repos : Remove openshift_additional.repo file] *****************
Thursday 22 November 2018 05:51:14 +0000 (0:00:00.403) 0:03:17.879 *****
ok: [40.76.5.36]
TASK [openshift_repos : Create any additional repos that are defined] **********
Thursday 22 November 2018 05:51:14 +0000 (0:00:00.393) 0:03:18.273 *****
changed: [40.76.5.36] => (item={u'gpgkey': u'file:///etc/pki/rpm-gpg/RPM-GPG-KEY-CentOS-SIG-PaaS', u'enabled': True, u'name': u'openshift-origin', u'baseurl': u'http://mirror.centos.org/centos/7/paas/x86_64/openshift-origin/'})
changed: [40.76.5.36] => (item={'gpgcheck': False, 'enabled': True, 'name': u'install_repo', 'baseurl': u'https://storage.googleapis.com/origin-ci-test/logs/test_branch_origin_extended_conformance_azure/786/artifacts/rpms'})
TASK [openshift_repos : include_tasks] *****************************************
Thursday 22 November 2018 05:51:15 +0000 (0:00:00.599) 0:03:18.872 *****
skipping: [40.76.5.36]
TASK [openshift_repos : include_tasks] *****************************************
Thursday 22 November 2018 05:51:15 +0000 (0:00:00.043) 0:03:18.916 *****
skipping: [40.76.5.36]
TASK [openshift_repos : Ensure clean repo cache in the event repos have been changed manually] ***
Thursday 22 November 2018 05:51:15 +0000 (0:00:00.042) 0:03:18.958 *****
skipping: [40.76.5.36]
TASK [openshift_repos : Record that openshift_repos already ran] ***************
Thursday 22 November 2018 05:51:15 +0000 (0:00:00.042) 0:03:19.001 *****
skipping: [40.76.5.36]
RUNNING HANDLER [openshift_repos : refresh cache] ******************************
Thursday 22 November 2018 05:51:15 +0000 (0:00:00.017) 0:03:19.018 *****
changed: [40.76.5.36]
TASK [include_role : os_update_latest] *****************************************
Thursday 22 November 2018 05:51:17 +0000 (0:00:01.871) 0:03:20.889 *****
TASK [os_update_latest : Update all packages] **********************************
Thursday 22 November 2018 05:51:17 +0000 (0:00:00.072) 0:03:20.962 *****
ok: [40.76.5.36]
TASK [os_update_latest : shell] ************************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:05.006) 0:03:25.968 *****
skipping: [40.76.5.36]
TASK [os_update_latest : wait_for_connection] **********************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.044) 0:03:26.013 *****
skipping: [40.76.5.36]
PLAY [Fail openshift_kubelet_name_override for new hosts] **********************
TASK [Fail when openshift_kubelet_name_override is defined] ********************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.054) 0:03:26.067 *****
skipping: [40.76.5.36]
PLAY [Initialization Checkpoint Start] *****************************************
TASK [Set install initialization 'In Progress'] ********************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.033) 0:03:26.100 *****
ok: [{}]
PLAY [Populate config host groups] *********************************************
TASK [Load group name mapping variables] ***************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.061) 0:03:26.162 *****
ok: [localhost]
TASK [Evaluate groups - g_nfs_hosts is single host] ****************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.030) 0:03:26.193 *****
skipping: [localhost]
TASK [Evaluate oo_all_hosts] ***************************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.024) 0:03:26.218 *****
ok: [localhost] => (item=40.76.5.36)
TASK [Evaluate oo_masters] *****************************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.057) 0:03:26.276 *****
TASK [Evaluate oo_first_master] ************************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.026) 0:03:26.302 *****
skipping: [localhost]
TASK [Evaluate oo_new_etcd_to_config] ******************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.026) 0:03:26.328 *****
TASK [Evaluate oo_masters_to_config] *******************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.023) 0:03:26.352 *****
TASK [Evaluate oo_etcd_to_config] **********************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.025) 0:03:26.377 *****
TASK [Evaluate oo_first_etcd] **************************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.023) 0:03:26.401 *****
skipping: [localhost]
TASK [Evaluate oo_etcd_hosts_to_upgrade] ***************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.024) 0:03:26.426 *****
TASK [Evaluate oo_etcd_hosts_to_backup] ****************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.022) 0:03:26.449 *****
TASK [Evaluate oo_nodes_to_config] *********************************************
Thursday 22 November 2018 05:51:22 +0000 (0:00:00.023) 0:03:26.472 *****
ok: [localhost] => (item=40.76.5.36)
TASK [Evaluate oo_lb_to_config] ************************************************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.047) 0:03:26.519 *****
TASK [Evaluate oo_nfs_to_config] ***********************************************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.026) 0:03:26.545 *****
TASK [Evaluate oo_glusterfs_to_config] *****************************************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.026) 0:03:26.572 *****
TASK [Evaluate oo_etcd_to_migrate] *********************************************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.030) 0:03:26.602 *****
[WARNING]: Could not match supplied host pattern, ignoring:
oo_masters_to_config
[WARNING]: Could not match supplied host pattern, ignoring: oo_etcd_to_config
[WARNING]: Could not match supplied host pattern, ignoring: oo_lb_to_config
[WARNING]: Could not match supplied host pattern, ignoring: oo_nfs_to_config
PLAY [Ensure that all non-node hosts are accessible] ***************************
skipping: no hosts matched
PLAY [Initialize basic host facts] *********************************************
TASK [openshift_sanitize_inventory : include_tasks] ****************************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.065) 0:03:26.667 *****
included: /usr/share/ansible/openshift-ansible/roles/openshift_sanitize_inventory/tasks/deprecations.yml for 40.76.5.36
TASK [openshift_sanitize_inventory : Check for usage of deprecated variables] ***
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.085) 0:03:26.753 *****
ok: [40.76.5.36]
TASK [openshift_sanitize_inventory : debug] ************************************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.132) 0:03:26.886 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : set_stats] ********************************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.043) 0:03:26.929 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : set_fact] *********************************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.043) 0:03:26.973 *****
ok: [40.76.5.36]
TASK [openshift_sanitize_inventory : Standardize on latest variable names] *****
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.074) 0:03:27.047 *****
ok: [40.76.5.36]
TASK [openshift_sanitize_inventory : Normalize openshift_release] **************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.066) 0:03:27.114 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : Abort when openshift_release is invalid] ***
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.042) 0:03:27.156 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : include_tasks] ****************************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.043) 0:03:27.200 *****
included: /usr/share/ansible/openshift-ansible/roles/openshift_sanitize_inventory/tasks/unsupported.yml for 40.76.5.36
TASK [openshift_sanitize_inventory : set_fact] *********************************
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.079) 0:03:27.280 *****
TASK [openshift_sanitize_inventory : Ensure that dynamic provisioning is set if using dynamic storage] ***
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.066) 0:03:27.347 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : Ensure the hosted registry's GlusterFS storage is configured correctly] ***
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.051) 0:03:27.398 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : Ensure the hosted registry's GlusterFS storage is configured correctly] ***
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.045) 0:03:27.444 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : Check for deprecated prometheus/grafana install] ***
Thursday 22 November 2018 05:51:23 +0000 (0:00:00.045) 0:03:27.489 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : Ensure clusterid is set along with the cloudprovider] ***
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.044) 0:03:27.534 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : Ensure ansible_service_broker_remove and ansible_service_broker_install are mutually exclusive] ***
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.046) 0:03:27.581 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : Ensure template_service_broker_remove and template_service_broker_install are mutually exclusive] ***
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.043) 0:03:27.624 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : Ensure that all requires vsphere configuration variables are set] ***
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.044) 0:03:27.668 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : ensure provider configuration variables are defined] ***
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.042) 0:03:27.710 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : Ensure removed web console extension variables are not set] ***
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.045) 0:03:27.756 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : Ensure that web console port matches API server port] ***
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.045) 0:03:27.801 *****
skipping: [40.76.5.36]
TASK [openshift_sanitize_inventory : At least one master is schedulable] *******
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.045) 0:03:27.846 *****
skipping: [40.76.5.36]
TASK [Detect OS Variant from /etc/os-release] **********************************
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.051) 0:03:27.898 *****
skipping: [40.76.5.36]
TASK [set openshift_deployment_type if unset] **********************************
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.048) 0:03:27.946 *****
skipping: [40.76.5.36]
PLAY [Retrieve existing master configs and validate] ***************************
skipping: no hosts matched
[WARNING]: Could not match supplied host pattern, ignoring: oo_first_master
PLAY [Initialize special first-master variables] *******************************
skipping: no hosts matched
PLAY [Disable web console if required] *****************************************
skipping: no hosts matched
PLAY [Setup yum repositories for all hosts] ************************************
TASK [rhel_subscribe : fail] ***************************************************
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.068) 0:03:28.014 *****
skipping: [40.76.5.36]
TASK [rhel_subscribe : Install Red Hat Subscription manager] *******************
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.043) 0:03:28.058 *****
skipping: [40.76.5.36]
TASK [rhel_subscribe : Is host already registered?] ****************************
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.044) 0:03:28.102 *****
skipping: [40.76.5.36]
TASK [rhel_subscribe : Register host using user/password] **********************
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.044) 0:03:28.146 *****
skipping: [40.76.5.36]
TASK [rhel_subscribe : Register host using activation key] *********************
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.044) 0:03:28.191 *****
skipping: [40.76.5.36]
TASK [rhel_subscribe : Determine if OpenShift Pool Already Attached] ***********
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.044) 0:03:28.235 *****
skipping: [40.76.5.36]
TASK [rhel_subscribe : Attach to OpenShift Pool] *******************************
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.043) 0:03:28.278 *****
skipping: [40.76.5.36]
TASK [rhel_subscribe : Satellite preparation] **********************************
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.049) 0:03:28.328 *****
skipping: [40.76.5.36]
TASK [openshift_repos : Ensure libselinux-python is installed] *****************
Thursday 22 November 2018 05:51:24 +0000 (0:00:00.044) 0:03:28.372 *****
ok: [40.76.5.36]
TASK [openshift_repos : Remove openshift_additional.repo file] *****************
Thursday 22 November 2018 05:51:25 +0000 (0:00:00.443) 0:03:28.815 *****
ok: [40.76.5.36]
TASK [openshift_repos : Create any additional repos that are defined] **********
Thursday 22 November 2018 05:51:25 +0000 (0:00:00.259) 0:03:29.075 *****
ok: [40.76.5.36] => (item={u'gpgkey': u'file:///etc/pki/rpm-gpg/RPM-GPG-KEY-CentOS-SIG-PaaS', u'enabled': True, u'name': u'openshift-origin', u'baseurl': u'http://mirror.centos.org/centos/7/paas/x86_64/openshift-origin/'})
ok: [40.76.5.36] => (item={'gpgcheck': False, 'enabled': True, 'name': u'install_repo', 'baseurl': u'https://storage.googleapis.com/origin-ci-test/logs/test_branch_origin_extended_conformance_azure/786/artifacts/rpms'})
TASK [openshift_repos : include_tasks] *****************************************
Thursday 22 November 2018 05:51:26 +0000 (0:00:00.477) 0:03:29.553 *****
skipping: [40.76.5.36]
TASK [openshift_repos : include_tasks] *****************************************
Thursday 22 November 2018 05:51:26 +0000 (0:00:00.048) 0:03:29.602 *****
skipping: [40.76.5.36]
TASK [openshift_repos : Ensure clean repo cache in the event repos have been changed manually] ***
Thursday 22 November 2018 05:51:26 +0000 (0:00:00.055) 0:03:29.657 *****
changed: [40.76.5.36] => {
"msg": "First run of openshift_repos"
}
TASK [openshift_repos : Record that openshift_repos already ran] ***************
Thursday 22 November 2018 05:51:26 +0000 (0:00:00.119) 0:03:29.777 *****
ok: [40.76.5.36]
RUNNING HANDLER [openshift_repos : refresh cache] ******************************
Thursday 22 November 2018 05:51:26 +0000 (0:00:00.092) 0:03:29.869 *****
changed: [40.76.5.36]
PLAY [Install packages necessary for installer] ********************************
TASK [Determine if chrony is installed] ****************************************
Thursday 22 November 2018 05:51:26 +0000 (0:00:00.494) 0:03:30.364 *****
changed: [40.76.5.36]
[WARNING]: Consider using the yum, dnf or zypper module rather than running
rpm. If you need to use command because yum, dnf or zypper is insufficient you
can add warn=False to this command task or set command_warnings=False in
ansible.cfg to get rid of this message.
TASK [Install ntp package] *****************************************************
Thursday 22 November 2018 05:51:27 +0000 (0:00:00.355) 0:03:30.719 *****
skipping: [40.76.5.36]
TASK [Start and enable ntpd/chronyd] *******************************************
Thursday 22 November 2018 05:51:27 +0000 (0:00:00.050) 0:03:30.769 *****
changed: [40.76.5.36]
TASK [Ensure openshift-ansible installer package deps are installed] ***********
Thursday 22 November 2018 05:51:27 +0000 (0:00:00.434) 0:03:31.203 *****
changed: [40.76.5.36]
PLAY [Initialize cluster facts] ************************************************
TASK [get openshift_current_version] *******************************************
Thursday 22 November 2018 05:51:40 +0000 (0:00:13.032) 0:03:44.236 *****
ok: [40.76.5.36]
TASK [set_fact openshift_portal_net if present on masters] *********************
Thursday 22 November 2018 05:51:41 +0000 (0:00:00.325) 0:03:44.562 *****
skipping: [40.76.5.36]
TASK [Gather Cluster facts] ****************************************************
Thursday 22 November 2018 05:51:41 +0000 (0:00:00.043) 0:03:44.605 *****
changed: [40.76.5.36]
TASK [Set fact of no_proxy_internal_hostnames] *********************************
Thursday 22 November 2018 05:51:42 +0000 (0:00:01.156) 0:03:45.762 *****
skipping: [40.76.5.36]
TASK [Initialize openshift.node.sdn_mtu] ***************************************
Thursday 22 November 2018 05:51:42 +0000 (0:00:00.045) 0:03:45.807 *****
changed: [40.76.5.36]
TASK [set_fact l_kubelet_node_name] ********************************************
Thursday 22 November 2018 05:51:42 +0000 (0:00:00.483) 0:03:46.290 *****
ok: [40.76.5.36]
PLAY [Initialize etcd host variables] ******************************************
skipping: no hosts matched
PLAY [Determine openshift_version to configure on first master] ****************
TASK [include_role : openshift_version] ****************************************
Thursday 22 November 2018 05:51:42 +0000 (0:00:00.082) 0:03:46.372 *****
TASK [openshift_version : Use openshift_current_version fact as version to configure if already installed] ***
Thursday 22 November 2018 05:51:42 +0000 (0:00:00.102) 0:03:46.475 *****
skipping: [40.76.5.36]
TASK [openshift_version : Set openshift_version to openshift_release if undefined] ***
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.046) 0:03:46.522 *****
ok: [40.76.5.36]
TASK [openshift_version : debug] ***********************************************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.068) 0:03:46.591 *****
ok: [40.76.5.36] => {
"msg": "openshift_pkg_version was not defined. Falling back to -4.0"
}
TASK [openshift_version : set_fact] ********************************************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.069) 0:03:46.660 *****
ok: [40.76.5.36]
TASK [openshift_version : debug] ***********************************************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.070) 0:03:46.731 *****
ok: [40.76.5.36] => {
"msg": "openshift_image_tag was not defined. Falling back to v4.0"
}
TASK [openshift_version : set_fact] ********************************************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.071) 0:03:46.802 *****
ok: [40.76.5.36]
TASK [openshift_version : assert openshift_release in openshift_image_tag] *****
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.070) 0:03:46.873 *****
ok: [40.76.5.36] => {
"changed": false,
"msg": "All assertions passed"
}
TASK [openshift_version : assert openshift_release in openshift_pkg_version] ***
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.070) 0:03:46.943 *****
ok: [40.76.5.36] => {
"changed": false,
"msg": "All assertions passed"
}
TASK [openshift_version : debug] ***********************************************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.070) 0:03:47.013 *****
ok: [40.76.5.36] => {
"openshift_release": "4.0"
}
TASK [openshift_version : debug] ***********************************************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.066) 0:03:47.079 *****
ok: [40.76.5.36] => {
"openshift_image_tag": "v4.0"
}
TASK [openshift_version : debug] ***********************************************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.065) 0:03:47.144 *****
ok: [40.76.5.36] => {
"openshift_pkg_version": "-4.0*"
}
TASK [openshift_version : debug] ***********************************************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.069) 0:03:47.213 *****
ok: [40.76.5.36] => {
"openshift_version": "4.0"
}
PLAY [Set openshift_version for etcd, node, and master hosts] ******************
skipping: no hosts matched
PLAY [Verify Requirements] *****************************************************
skipping: no hosts matched
PLAY [Verify Node NetworkManager] **********************************************
skipping: no hosts matched
PLAY [Initialization Checkpoint End] *******************************************
TASK [Set install initialization 'Complete'] ***********************************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.094) 0:03:47.308 *****
ok: [40.76.5.36]
PLAY [Validate node hostnames] *************************************************
TASK [Query DNS for IP address of vm.oh4umm21ic4unb20ct0ugmdhqb.bx.internal.cloudapp.net] ***
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.085) 0:03:47.394 *****
skipping: [40.76.5.36]
TASK [Validate openshift_kubelet_name_override when defined] *******************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.045) 0:03:47.439 *****
skipping: [40.76.5.36]
TASK [Validate openshift_ip exists on node when defined] ***********************
Thursday 22 November 2018 05:51:43 +0000 (0:00:00.044) 0:03:47.483 *****
skipping: [40.76.5.36]
PLAY [Configure os_firewall] ***************************************************
TASK [os_firewall : Install firewalld packages] ********************************
Thursday 22 November 2018 05:51:44 +0000 (0:00:00.062) 0:03:47.546 *****
skipping: [40.76.5.36]
TASK [os_firewall : Ensure iptables services are not enabled] ******************
Thursday 22 November 2018 05:51:44 +0000 (0:00:00.046) 0:03:47.592 *****
skipping: [40.76.5.36] => (item=iptables)
skipping: [40.76.5.36] => (item=ip6tables)
TASK [os_firewall : Wait 10 seconds after disabling iptables] ******************
Thursday 22 November 2018 05:51:44 +0000 (0:00:00.063) 0:03:47.656 *****
skipping: [40.76.5.36]
TASK [os_firewall : Start and enable firewalld service] ************************
Thursday 22 November 2018 05:51:44 +0000 (0:00:00.046) 0:03:47.703 *****
skipping: [40.76.5.36]
TASK [os_firewall : need to pause here, otherwise the firewalld service starting can sometimes cause ssh to fail] ***
Thursday 22 November 2018 05:51:44 +0000 (0:00:00.048) 0:03:47.751 *****
skipping: [40.76.5.36]
TASK [os_firewall : Restart polkitd] *******************************************
Thursday 22 November 2018 05:51:44 +0000 (0:00:00.049) 0:03:47.801 *****
skipping: [40.76.5.36]
TASK [os_firewall : Wait for polkit action to have been created] ***************
Thursday 22 November 2018 05:51:44 +0000 (0:00:00.047) 0:03:47.848 *****
skipping: [40.76.5.36]
TASK [os_firewall : Ensure firewalld service is not enabled] *******************
Thursday 22 November 2018 05:51:44 +0000 (0:00:00.047) 0:03:47.895 *****
changed: [40.76.5.36]
TASK [os_firewall : Wait 10 seconds after disabling firewalld] *****************
Thursday 22 November 2018 05:51:45 +0000 (0:00:01.255) 0:03:49.151 *****
Pausing for 10 seconds
(ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)
ok: [40.76.5.36]
TASK [os_firewall : Install iptables packages] *********************************
Thursday 22 November 2018 05:51:55 +0000 (0:00:10.127) 0:03:59.279 *****
changed: [40.76.5.36]
TASK [os_firewall : Start and enable iptables service] *************************
Thursday 22 November 2018 05:51:58 +0000 (0:00:02.487) 0:04:01.766 *****
changed: [40.76.5.36 -> 40.76.5.36] => (item=40.76.5.36)
TASK [os_firewall : need to pause here, otherwise the iptables service starting can sometimes cause ssh to fail] ***
Thursday 22 November 2018 05:51:58 +0000 (0:00:00.496) 0:04:02.263 *****
Pausing for 10 seconds
(ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)
ok: [40.76.5.36]
PLAY [oo_nodes_to_config] ******************************************************
TASK [container_runtime : Setup the docker-storage for overlay] ****************
Thursday 22 November 2018 05:52:08 +0000 (0:00:10.090) 0:04:12.353 *****
skipping: [40.76.5.36]
TASK [container_runtime : Create file system on extra volume device] ***********
Thursday 22 November 2018 05:52:08 +0000 (0:00:00.046) 0:04:12.400 *****
TASK [container_runtime : Create mount entry for extra volume] *****************
Thursday 22 November 2018 05:52:08 +0000 (0:00:00.043) 0:04:12.444 *****
PLAY [oo_nodes_to_config] ******************************************************
TASK [openshift_excluder : Install docker excluder - yum] **********************
Thursday 22 November 2018 05:52:09 +0000 (0:00:00.062) 0:04:12.506 *****
changed: [40.76.5.36]
TASK [openshift_excluder : Install docker excluder - dnf] **********************
Thursday 22 November 2018 05:52:15 +0000 (0:00:06.069) 0:04:18.576 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Install openshift excluder - yum] *******************
Thursday 22 November 2018 05:52:15 +0000 (0:00:00.056) 0:04:18.632 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Install openshift excluder - dnf] *******************
Thursday 22 November 2018 05:52:15 +0000 (0:00:00.050) 0:04:18.682 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : set_fact] *******************************************
Thursday 22 November 2018 05:52:15 +0000 (0:00:00.048) 0:04:18.731 *****
ok: [40.76.5.36]
TASK [openshift_excluder : Check for docker-excluder] **************************
Thursday 22 November 2018 05:52:15 +0000 (0:00:00.071) 0:04:18.802 *****
ok: [40.76.5.36]
TASK [openshift_excluder : Check for openshift excluder] ***********************
Thursday 22 November 2018 05:52:15 +0000 (0:00:00.379) 0:04:19.181 *****
ok: [40.76.5.36]
TASK [openshift_excluder : Enable docker excluder] *****************************
Thursday 22 November 2018 05:52:15 +0000 (0:00:00.217) 0:04:19.399 *****
changed: [40.76.5.36]
TASK [openshift_excluder : Enable openshift excluder] **************************
Thursday 22 November 2018 05:52:16 +0000 (0:00:00.257) 0:04:19.656 *****
skipping: [40.76.5.36]
TASK [container_runtime : Getting current systemd-udevd exec command] **********
Thursday 22 November 2018 05:52:16 +0000 (0:00:00.046) 0:04:19.703 *****
skipping: [40.76.5.36]
TASK [container_runtime : Assure systemd-udevd.service.d directory exists] *****
Thursday 22 November 2018 05:52:16 +0000 (0:00:00.050) 0:04:19.753 *****
skipping: [40.76.5.36]
TASK [container_runtime : Create systemd-udevd override file] ******************
Thursday 22 November 2018 05:52:16 +0000 (0:00:00.050) 0:04:19.803 *****
skipping: [40.76.5.36]
TASK [container_runtime : Add enterprise registry, if necessary] ***************
Thursday 22 November 2018 05:52:16 +0000 (0:00:00.049) 0:04:19.853 *****
skipping: [40.76.5.36]
TASK [container_runtime : Get current installed Docker version] ****************
Thursday 22 November 2018 05:52:16 +0000 (0:00:00.050) 0:04:19.904 *****
ok: [40.76.5.36]
TASK [container_runtime : Error out if Docker pre-installed but too old] *******
Thursday 22 November 2018 05:52:16 +0000 (0:00:00.400) 0:04:20.304 *****
skipping: [40.76.5.36]
TASK [container_runtime : Error out if requested Docker is too old] ************
Thursday 22 November 2018 05:52:16 +0000 (0:00:00.054) 0:04:20.358 *****
skipping: [40.76.5.36]
TASK [container_runtime : Install Docker] **************************************
Thursday 22 November 2018 05:52:16 +0000 (0:00:00.048) 0:04:20.407 *****
changed: [40.76.5.36]
TASK [container_runtime : Ensure docker.service.d directory exists] ************
Thursday 22 November 2018 05:53:03 +0000 (0:00:46.634) 0:05:07.041 *****
changed: [40.76.5.36]
TASK [container_runtime : Configure Docker service unit file] ******************
Thursday 22 November 2018 05:53:03 +0000 (0:00:00.235) 0:05:07.277 *****
changed: [40.76.5.36]
TASK [container_runtime : stat] ************************************************
Thursday 22 November 2018 05:53:04 +0000 (0:00:00.859) 0:05:08.137 *****
ok: [40.76.5.36]
TASK [container_runtime : Set registry params] *********************************
Thursday 22 November 2018 05:53:04 +0000 (0:00:00.309) 0:05:08.446 *****
skipping: [40.76.5.36] => (item={u'reg_conf_var': u'ADD_REGISTRY', u'reg_flag': u'--add-registry', u'reg_fact_val': []})
skipping: [40.76.5.36] => (item={u'reg_conf_var': u'BLOCK_REGISTRY', u'reg_flag': u'--block-registry', u'reg_fact_val': []})
skipping: [40.76.5.36] => (item={u'reg_conf_var': u'INSECURE_REGISTRY', u'reg_flag': u'--insecure-registry', u'reg_fact_val': []})
TASK [container_runtime : Place additional/blocked/insecure registries in /etc/containers/registries.conf] ***
Thursday 22 November 2018 05:53:05 +0000 (0:00:00.096) 0:05:08.543 *****
skipping: [40.76.5.36]
TASK [container_runtime : Set Proxy Settings] **********************************
Thursday 22 November 2018 05:53:05 +0000 (0:00:00.049) 0:05:08.592 *****
skipping: [40.76.5.36] => (item={u'reg_conf_var': u'HTTP_PROXY', u'reg_fact_val': u''})
skipping: [40.76.5.36] => (item={u'reg_conf_var': u'HTTPS_PROXY', u'reg_fact_val': u''})
skipping: [40.76.5.36] => (item={u'reg_conf_var': u'NO_PROXY', u'reg_fact_val': u''})
TASK [container_runtime : Set various Docker options] **************************
Thursday 22 November 2018 05:53:05 +0000 (0:00:00.104) 0:05:08.696 *****
changed: [40.76.5.36]
TASK [container_runtime : stat] ************************************************
Thursday 22 November 2018 05:53:05 +0000 (0:00:00.397) 0:05:09.094 *****
ok: [40.76.5.36]
TASK [container_runtime : Configure Docker Network OPTIONS] ********************
Thursday 22 November 2018 05:53:05 +0000 (0:00:00.266) 0:05:09.361 *****
changed: [40.76.5.36]
TASK [container_runtime : Detect if docker is already started] *****************
Thursday 22 November 2018 05:53:06 +0000 (0:00:00.278) 0:05:09.639 *****
ok: [40.76.5.36]
TASK [container_runtime : Start the Docker service] ****************************
Thursday 22 November 2018 05:53:06 +0000 (0:00:00.231) 0:05:09.870 *****
changed: [40.76.5.36]
TASK [container_runtime : set_fact] ********************************************
Thursday 22 November 2018 05:53:08 +0000 (0:00:02.534) 0:05:12.405 *****
ok: [40.76.5.36]
TASK [container_runtime : Check for docker_storage_path/overlay2] **************
Thursday 22 November 2018 05:53:09 +0000 (0:00:00.123) 0:05:12.528 *****
ok: [40.76.5.36]
TASK [container_runtime : Fixup SELinux permissions for docker] ****************
Thursday 22 November 2018 05:53:09 +0000 (0:00:00.289) 0:05:12.817 *****
changed: [40.76.5.36]
TASK [container_runtime : Ensure /var/lib/containers exists] *******************
Thursday 22 November 2018 05:53:10 +0000 (0:00:00.839) 0:05:13.657 *****
changed: [40.76.5.36]
TASK [container_runtime : Fix SELinux Permissions on /var/lib/containers] ******
Thursday 22 November 2018 05:53:10 +0000 (0:00:00.271) 0:05:13.928 *****
ok: [40.76.5.36]
RUNNING HANDLER [container_runtime : restart container runtime] ****************
Thursday 22 November 2018 05:53:10 +0000 (0:00:00.242) 0:05:14.171 *****
skipping: [40.76.5.36]
TASK [container_runtime : Create credentials for oreg_url] *********************
Thursday 22 November 2018 05:53:10 +0000 (0:00:00.073) 0:05:14.244 *****
skipping: [40.76.5.36]
TASK [container_runtime : Create for any additional registries] ****************
Thursday 22 November 2018 05:53:10 +0000 (0:00:00.050) 0:05:14.295 *****
TASK [container_runtime : stat the docker data dir] ****************************
Thursday 22 November 2018 05:53:10 +0000 (0:00:00.045) 0:05:14.340 *****
ok: [40.76.5.36]
TASK [container_runtime : stop the current running docker] *********************
Thursday 22 November 2018 05:53:11 +0000 (0:00:00.311) 0:05:14.651 *****
changed: [40.76.5.36]
TASK [container_runtime : copy "/var/lib/docker" to "/var/lib/containers/docker"] ***
Thursday 22 November 2018 05:53:12 +0000 (0:00:01.275) 0:05:15.927 *****
changed: [40.76.5.36]
TASK [container_runtime : Set the selinux context on /var/lib/containers/docker] ***
Thursday 22 November 2018 05:53:12 +0000 (0:00:00.447) 0:05:16.375 *****
changed: [40.76.5.36]
TASK [container_runtime : restorecon the /var/lib/containers/docker] ***********
Thursday 22 November 2018 05:53:14 +0000 (0:00:01.277) 0:05:17.652 *****
changed: [40.76.5.36]
TASK [container_runtime : ensure the unmount of top level mount point] *********
Thursday 22 November 2018 05:53:14 +0000 (0:00:00.237) 0:05:17.889 *****
ok: [40.76.5.36]
TASK [container_runtime : Remove the old docker location] **********************
Thursday 22 November 2018 05:53:14 +0000 (0:00:00.341) 0:05:18.231 *****
changed: [40.76.5.36]
TASK [container_runtime : Setup the link] **************************************
Thursday 22 November 2018 05:53:14 +0000 (0:00:00.242) 0:05:18.474 *****
changed: [40.76.5.36]
TASK [container_runtime : start docker] ****************************************
Thursday 22 November 2018 05:53:15 +0000 (0:00:00.236) 0:05:18.710 *****
changed: [40.76.5.36]
TASK [container_runtime : Getting current systemd-udevd exec command] **********
Thursday 22 November 2018 05:53:16 +0000 (0:00:01.649) 0:05:20.360 *****
skipping: [40.76.5.36]
TASK [container_runtime : Assure systemd-udevd.service.d directory exists] *****
Thursday 22 November 2018 05:53:16 +0000 (0:00:00.049) 0:05:20.409 *****
skipping: [40.76.5.36]
TASK [container_runtime : Create systemd-udevd override file] ******************
Thursday 22 November 2018 05:53:16 +0000 (0:00:00.048) 0:05:20.457 *****
skipping: [40.76.5.36]
TASK [container_runtime : Add enterprise registry, if necessary] ***************
Thursday 22 November 2018 05:53:17 +0000 (0:00:00.051) 0:05:20.509 *****
skipping: [40.76.5.36]
TASK [container_runtime : Check that overlay is in the kernel] *****************
Thursday 22 November 2018 05:53:17 +0000 (0:00:00.047) 0:05:20.557 *****
changed: [40.76.5.36]
TASK [container_runtime : Add overlay to modprobe.d] ***************************
Thursday 22 November 2018 05:53:17 +0000 (0:00:00.791) 0:05:21.349 *****
skipping: [40.76.5.36]
TASK [container_runtime : Manually modprobe overlay into the kernel] ***********
Thursday 22 November 2018 05:53:17 +0000 (0:00:00.048) 0:05:21.397 *****
skipping: [40.76.5.36]
TASK [container_runtime : Enable and start systemd-modules-load] ***************
Thursday 22 November 2018 05:53:17 +0000 (0:00:00.049) 0:05:21.446 *****
skipping: [40.76.5.36]
TASK [container_runtime : Install cri-o] ***************************************
Thursday 22 November 2018 05:53:18 +0000 (0:00:00.049) 0:05:21.496 *****
changed: [40.76.5.36]
TASK [container_runtime : Remove CRI-O default configuration files] ************
Thursday 22 November 2018 05:53:54 +0000 (0:00:36.042) 0:05:57.539 *****
changed: [40.76.5.36] => (item=/etc/cni/net.d/200-loopback.conf)
changed: [40.76.5.36] => (item=/etc/cni/net.d/100-crio-bridge.conf)
TASK [container_runtime : Create the CRI-O configuration] **********************
Thursday 22 November 2018 05:53:54 +0000 (0:00:00.394) 0:05:57.933 *****
changed: [40.76.5.36]
TASK [container_runtime : Update crictl.yaml runtime-endpoint] *****************
Thursday 22 November 2018 05:53:55 +0000 (0:00:00.621) 0:05:58.555 *****
ok: [40.76.5.36]
TASK [container_runtime : Ensure CNI configuration directory exists] ***********
Thursday 22 November 2018 05:53:55 +0000 (0:00:00.413) 0:05:58.968 *****
ok: [40.76.5.36]
TASK [container_runtime : Add iptables allow rules] ****************************
Thursday 22 November 2018 05:53:55 +0000 (0:00:00.222) 0:05:59.190 *****
changed: [40.76.5.36] => (item={u'port': u'10010/tcp', u'service': u'crio'})
TASK [container_runtime : Remove iptables rules] *******************************
Thursday 22 November 2018 05:53:56 +0000 (0:00:00.541) 0:05:59.732 *****
TASK [container_runtime : Add firewalld allow rules] ***************************
Thursday 22 November 2018 05:53:56 +0000 (0:00:00.048) 0:05:59.780 *****
skipping: [40.76.5.36] => (item={u'port': u'10010/tcp', u'service': u'crio'})
TASK [container_runtime : Remove firewalld allow rules] ************************
Thursday 22 November 2018 05:53:56 +0000 (0:00:00.061) 0:05:59.842 *****
TASK [container_runtime : Configure the CNI network] ***************************
Thursday 22 November 2018 05:53:56 +0000 (0:00:00.044) 0:05:59.886 *****
changed: [40.76.5.36]
TASK [container_runtime : Create /etc/sysconfig/crio-network] ******************
Thursday 22 November 2018 05:53:56 +0000 (0:00:00.595) 0:06:00.481 *****
changed: [40.76.5.36]
TASK [container_runtime : Place registries.conf in /etc/containers/registries.conf] ***
Thursday 22 November 2018 05:53:57 +0000 (0:00:00.608) 0:06:01.090 *****
changed: [40.76.5.36]
TASK [container_runtime : Start the CRI-O service] *****************************
Thursday 22 November 2018 05:53:58 +0000 (0:00:00.667) 0:06:01.757 *****
changed: [40.76.5.36]
TASK [container_runtime : Ensure /var/lib/containers exists] *******************
Thursday 22 November 2018 05:53:58 +0000 (0:00:00.493) 0:06:02.251 *****
ok: [40.76.5.36]
TASK [container_runtime : Fix SELinux Permissions on /var/lib/containers] ******
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.273) 0:06:02.524 *****
ok: [40.76.5.36]
TASK [container_runtime : Create credentials for oreg_url] *********************
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.276) 0:06:02.801 *****
skipping: [40.76.5.36]
TASK [container_runtime : Create for any additional registries] ****************
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.049) 0:06:02.851 *****
TASK [container_runtime : stat the docker data dir] ****************************
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.043) 0:06:02.894 *****
ok: [40.76.5.36]
TASK [container_runtime : stop the current running docker] *********************
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.243) 0:06:03.138 *****
skipping: [40.76.5.36]
TASK [container_runtime : copy "/var/lib/docker" to "/var/lib/containers/docker"] ***
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.056) 0:06:03.195 *****
skipping: [40.76.5.36]
TASK [container_runtime : Set the selinux context on /var/lib/containers/docker] ***
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.053) 0:06:03.248 *****
skipping: [40.76.5.36]
TASK [container_runtime : restorecon the /var/lib/containers/docker] ***********
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.052) 0:06:03.301 *****
skipping: [40.76.5.36]
TASK [container_runtime : ensure the unmount of top level mount point] *********
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.049) 0:06:03.350 *****
skipping: [40.76.5.36]
TASK [container_runtime : Remove the old docker location] **********************
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.050) 0:06:03.401 *****
skipping: [40.76.5.36]
TASK [container_runtime : Setup the link] **************************************
Thursday 22 November 2018 05:53:59 +0000 (0:00:00.051) 0:06:03.453 *****
skipping: [40.76.5.36]
TASK [container_runtime : start docker] ****************************************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.137) 0:06:03.590 *****
skipping: [40.76.5.36]
PLAY [Disable excluders] *******************************************************
TASK [openshift_excluder : Debug r_openshift_excluder_enable_docker_excluder] ***
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.059) 0:06:03.650 *****
ok: [40.76.5.36] => {
"r_openshift_excluder_enable_docker_excluder": true
}
TASK [openshift_excluder : Debug r_openshift_excluder_enable_openshift_excluder] ***
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.073) 0:06:03.723 *****
ok: [40.76.5.36] => {
"r_openshift_excluder_enable_openshift_excluder": true
}
TASK [openshift_excluder : Fail if invalid openshift_excluder_action provided] ***
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.074) 0:06:03.798 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Fail if r_openshift_excluder_upgrade_target is not defined] ***
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.045) 0:06:03.843 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Include main action task file] **********************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.044) 0:06:03.887 *****
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/disable.yml for 40.76.5.36
TASK [openshift_excluder : Get available excluder version] *********************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.137) 0:06:04.025 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Fail when excluder package is not found] ************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.043) 0:06:04.069 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Set fact excluder_version] **************************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.044) 0:06:04.114 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : origin-docker-excluder version detected] ************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.047) 0:06:04.161 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Printing upgrade target version] ********************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.043) 0:06:04.205 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Check the available origin-docker-excluder version is at most of the upgrade target version] ***
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.047) 0:06:04.252 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Get available excluder version] *********************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.042) 0:06:04.294 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Fail when excluder package is not found] ************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.043) 0:06:04.338 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Set fact excluder_version] **************************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.050) 0:06:04.388 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : origin-excluder version detected] *******************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.048) 0:06:04.437 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Printing upgrade target version] ********************
Thursday 22 November 2018 05:54:00 +0000 (0:00:00.043) 0:06:04.481 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Check the available origin-excluder version is at most of the upgrade target version] ***
Thursday 22 November 2018 05:54:01 +0000 (0:00:00.047) 0:06:04.528 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Check for docker-excluder] **************************
Thursday 22 November 2018 05:54:01 +0000 (0:00:00.043) 0:06:04.572 *****
ok: [40.76.5.36]
TASK [openshift_excluder : disable docker excluder] ****************************
Thursday 22 November 2018 05:54:01 +0000 (0:00:00.228) 0:06:04.800 *****
changed: [40.76.5.36]
TASK [openshift_excluder : Check for openshift excluder] ***********************
Thursday 22 November 2018 05:54:01 +0000 (0:00:00.277) 0:06:05.078 *****
ok: [40.76.5.36]
TASK [openshift_excluder : disable openshift excluder] *************************
Thursday 22 November 2018 05:54:01 +0000 (0:00:00.219) 0:06:05.297 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Install docker excluder - yum] **********************
Thursday 22 November 2018 05:54:01 +0000 (0:00:00.057) 0:06:05.354 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Install docker excluder - dnf] **********************
Thursday 22 November 2018 05:54:01 +0000 (0:00:00.046) 0:06:05.401 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Install openshift excluder - yum] *******************
Thursday 22 November 2018 05:54:01 +0000 (0:00:00.046) 0:06:05.447 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Install openshift excluder - dnf] *******************
Thursday 22 November 2018 05:54:02 +0000 (0:00:00.050) 0:06:05.497 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : set_fact] *******************************************
Thursday 22 November 2018 05:54:02 +0000 (0:00:00.046) 0:06:05.544 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Check for docker-excluder] **************************
Thursday 22 November 2018 05:54:02 +0000 (0:00:00.046) 0:06:05.590 *****
ok: [40.76.5.36]
TASK [openshift_excluder : Check for openshift excluder] ***********************
Thursday 22 November 2018 05:54:02 +0000 (0:00:00.219) 0:06:05.810 *****
ok: [40.76.5.36]
TASK [openshift_excluder : Enable docker excluder] *****************************
Thursday 22 November 2018 05:54:02 +0000 (0:00:00.217) 0:06:06.028 *****
changed: [40.76.5.36]
TASK [openshift_excluder : Enable openshift excluder] **************************
Thursday 22 November 2018 05:54:02 +0000 (0:00:00.267) 0:06:06.295 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Check for docker-excluder] **************************
Thursday 22 November 2018 05:54:02 +0000 (0:00:00.054) 0:06:06.350 *****
ok: [40.76.5.36]
TASK [openshift_excluder : disable docker excluder] ****************************
Thursday 22 November 2018 05:54:03 +0000 (0:00:00.227) 0:06:06.577 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Check for openshift excluder] ***********************
Thursday 22 November 2018 05:54:03 +0000 (0:00:00.047) 0:06:06.625 *****
ok: [40.76.5.36]
TASK [openshift_excluder : disable openshift excluder] *************************
Thursday 22 November 2018 05:54:03 +0000 (0:00:00.218) 0:06:06.844 *****
skipping: [40.76.5.36]
PLAY [Configure nodes] *********************************************************
TASK [openshift_cloud_provider : Set cloud provider facts] *********************
Thursday 22 November 2018 05:54:03 +0000 (0:00:00.092) 0:06:06.936 *****
skipping: [40.76.5.36]
TASK [openshift_cloud_provider : Create cloudprovider config dir] **************
Thursday 22 November 2018 05:54:03 +0000 (0:00:00.046) 0:06:06.983 *****
skipping: [40.76.5.36]
TASK [openshift_cloud_provider : include the defined cloud provider files] *****
Thursday 22 November 2018 05:54:03 +0000 (0:00:00.044) 0:06:07.028 *****
skipping: [40.76.5.36]
TASK [openshift_node : fail] ***************************************************
Thursday 22 November 2018 05:54:03 +0000 (0:00:00.046) 0:06:07.074 *****
skipping: [40.76.5.36]
TASK [openshift_node : Check for NetworkManager service] ***********************
Thursday 22 November 2018 05:54:03 +0000 (0:00:00.048) 0:06:07.122 *****
ok: [40.76.5.36]
TASK [openshift_node : Set fact using_network_manager] *************************
Thursday 22 November 2018 05:54:03 +0000 (0:00:00.233) 0:06:07.356 *****
ok: [40.76.5.36]
TASK [openshift_node : Install dnsmasq] ****************************************
Thursday 22 November 2018 05:54:03 +0000 (0:00:00.070) 0:06:07.427 *****
changed: [40.76.5.36]
TASK [openshift_node : ensure origin/node directory exists] ********************
Thursday 22 November 2018 05:54:07 +0000 (0:00:03.252) 0:06:10.680 *****
changed: [40.76.5.36] => (item=/etc/origin)
changed: [40.76.5.36] => (item=/etc/origin/node)
TASK [openshift_node : Install NetworkManager during node_bootstrap provisioning] ***
Thursday 22 November 2018 05:54:07 +0000 (0:00:00.435) 0:06:11.115 *****
skipping: [40.76.5.36]
TASK [openshift_node : Install network manager dispatch script] ****************
Thursday 22 November 2018 05:54:07 +0000 (0:00:00.046) 0:06:11.162 *****
skipping: [40.76.5.36]
TASK [openshift_node : Add network manager configuration] **********************
Thursday 22 November 2018 05:54:07 +0000 (0:00:00.045) 0:06:11.207 *****
skipping: [40.76.5.36] => (item={u'key': u'dns', u'value': u'none', u'present': False})
TASK [openshift_node : Install dnsmasq configuration] **************************
Thursday 22 November 2018 05:54:07 +0000 (0:00:00.057) 0:06:11.264 *****
changed: [40.76.5.36]
TASK [openshift_node : Deploy additional dnsmasq.conf] *************************
Thursday 22 November 2018 05:54:08 +0000 (0:00:00.640) 0:06:11.904 *****
skipping: [40.76.5.36]
TASK [openshift_node : Create override dnsmasq systemd unit directory] *********
Thursday 22 November 2018 05:54:08 +0000 (0:00:00.046) 0:06:11.951 *****
changed: [40.76.5.36]
TASK [openshift_node : Copy systemd dnsmasq unit override file] ****************
Thursday 22 November 2018 05:54:08 +0000 (0:00:00.269) 0:06:12.220 *****
changed: [40.76.5.36]
TASK [openshift_node : Enable dnsmasq] *****************************************
Thursday 22 November 2018 05:54:09 +0000 (0:00:00.676) 0:06:12.896 *****
changed: [40.76.5.36]
TASK [openshift_node : Install network manager dispatch script] ****************
Thursday 22 November 2018 05:54:09 +0000 (0:00:00.315) 0:06:13.212 *****
changed: [40.76.5.36]
TASK [openshift_node : Add network manager configuration] **********************
Thursday 22 November 2018 05:54:10 +0000 (0:00:00.570) 0:06:13.782 *****
ok: [40.76.5.36] => (item={u'key': u'dns', u'value': u'none', u'present': False})
RUNNING HANDLER [openshift_node : reload systemd units] ************************
Thursday 22 November 2018 05:54:10 +0000 (0:00:00.309) 0:06:14.092 *****
skipping: [40.76.5.36]
RUNNING HANDLER [openshift_node : restart NetworkManager] **********************
Thursday 22 November 2018 05:54:10 +0000 (0:00:00.046) 0:06:14.138 *****
skipping: [40.76.5.36]
RUNNING HANDLER [openshift_node : restart dnsmasq] *****************************
Thursday 22 November 2018 05:54:10 +0000 (0:00:00.045) 0:06:14.184 *****
skipping: [40.76.5.36]
TASK [openshift_node : Add iptables allow rules] *******************************
Thursday 22 November 2018 05:54:10 +0000 (0:00:00.072) 0:06:14.257 *****
changed: [40.76.5.36] => (item={u'port': u'10250/tcp', u'service': u'Kubernetes kubelet'})
changed: [40.76.5.36] => (item={u'port': u'10256/tcp', u'service': u'Kubernetes kube-proxy health check for service load balancers'})
changed: [40.76.5.36] => (item={u'port': u'80/tcp', u'service': u'http'})
changed: [40.76.5.36] => (item={u'port': u'443/tcp', u'service': u'https'})
changed: [40.76.5.36] => (item={u'cond': u'openshift_use_openshift_sdn | bool', u'port': u'4789/udp', u'service': u'OpenShift OVS sdn'})
skipping: [40.76.5.36] => (item={u'cond': False, u'port': u'179/tcp', u'service': u'Calico BGP Port'})
skipping: [40.76.5.36] => (item={u'cond': False, u'port': u'/tcp', u'service': u'Kubernetes service NodePort TCP'})
skipping: [40.76.5.36] => (item={u'cond': False, u'port': u'/udp', u'service': u'Kubernetes service NodePort UDP'})
changed: [40.76.5.36] => (item={u'port': u'9000-10000/tcp', u'service': u'Prometheus monitoring'})
TASK [openshift_node : Remove iptables rules] **********************************
Thursday 22 November 2018 05:54:12 +0000 (0:00:01.602) 0:06:15.859 *****
TASK [openshift_node : Add firewalld allow rules] ******************************
Thursday 22 November 2018 05:54:12 +0000 (0:00:00.044) 0:06:15.903 *****
skipping: [40.76.5.36] => (item={u'port': u'10250/tcp', u'service': u'Kubernetes kubelet'})
skipping: [40.76.5.36] => (item={u'port': u'10256/tcp', u'service': u'Kubernetes kube-proxy health check for service load balancers'})
skipping: [40.76.5.36] => (item={u'port': u'80/tcp', u'service': u'http'})
skipping: [40.76.5.36] => (item={u'port': u'443/tcp', u'service': u'https'})
skipping: [40.76.5.36] => (item={u'cond': u'openshift_use_openshift_sdn | bool', u'port': u'4789/udp', u'service': u'OpenShift OVS sdn'})
skipping: [40.76.5.36] => (item={u'cond': False, u'port': u'179/tcp', u'service': u'Calico BGP Port'})
skipping: [40.76.5.36] => (item={u'cond': False, u'port': u'/tcp', u'service': u'Kubernetes service NodePort TCP'})
skipping: [40.76.5.36] => (item={u'cond': False, u'port': u'/udp', u'service': u'Kubernetes service NodePort UDP'})
skipping: [40.76.5.36] => (item={u'port': u'9000-10000/tcp', u'service': u'Prometheus monitoring'})
TASK [openshift_node : Remove firewalld allow rules] ***************************
Thursday 22 November 2018 05:54:12 +0000 (0:00:00.155) 0:06:16.058 *****
TASK [openshift_node : Restart cri-o] ******************************************
Thursday 22 November 2018 05:54:12 +0000 (0:00:00.044) 0:06:16.103 *****
changed: [40.76.5.36]
TASK [openshift_node : restart NetworkManager to ensure resolv.conf is present] ***
Thursday 22 November 2018 05:54:13 +0000 (0:00:00.487) 0:06:16.591 *****
changed: [40.76.5.36]
TASK [openshift_node : Check that node image is present] ***********************
Thursday 22 November 2018 05:54:13 +0000 (0:00:00.369) 0:06:16.961 *****
changed: [40.76.5.36]
TASK [openshift_node : Pre-pull node image] ************************************
Thursday 22 November 2018 05:54:13 +0000 (0:00:00.372) 0:06:17.333 *****
changed: [40.76.5.36]
TASK [openshift_node : Check that pod image is present] ************************
Thursday 22 November 2018 05:54:15 +0000 (0:00:01.577) 0:06:18.911 *****
changed: [40.76.5.36]
TASK [openshift_node : pre-pull pod image] *************************************
Thursday 22 November 2018 05:54:15 +0000 (0:00:00.244) 0:06:19.155 *****
changed: [40.76.5.36]
TASK [openshift_node : Install node, clients, and conntrack packages] **********
Thursday 22 November 2018 05:54:17 +0000 (0:00:01.434) 0:06:20.589 *****
changed: [40.76.5.36]
TASK [openshift_node : Checking for journald.conf] *****************************
Thursday 22 November 2018 05:55:48 +0000 (0:01:31.239) 0:07:51.829 *****
ok: [40.76.5.36]
TASK [openshift_node : Create journald persistence directories] ****************
Thursday 22 November 2018 05:55:48 +0000 (0:00:00.284) 0:07:52.113 *****
changed: [40.76.5.36]
TASK [openshift_node : Update journald setup] **********************************
Thursday 22 November 2018 05:55:48 +0000 (0:00:00.278) 0:07:52.392 *****
changed: [40.76.5.36] => (item={u'var': u'Storage', u'val': u'persistent'})
changed: [40.76.5.36] => (item={u'var': u'Compress', u'val': True})
changed: [40.76.5.36] => (item={u'var': u'SyncIntervalSec', u'val': u'1s'})
changed: [40.76.5.36] => (item={u'var': u'RateLimitInterval', u'val': u'1s'})
changed: [40.76.5.36] => (item={u'var': u'RateLimitBurst', u'val': 10000})
changed: [40.76.5.36] => (item={u'var': u'SystemMaxUse', u'val': u'8G'})
ok: [40.76.5.36] => (item={u'var': u'SystemKeepFree', u'val': u'20%'})
changed: [40.76.5.36] => (item={u'var': u'SystemMaxFileSize', u'val': u'10M'})
changed: [40.76.5.36] => (item={u'var': u'MaxRetentionSec', u'val': u'1month'})
ok: [40.76.5.36] => (item={u'var': u'MaxFileSec', u'val': u'1day'})
changed: [40.76.5.36] => (item={u'var': u'ForwardToSyslog', u'val': False})
changed: [40.76.5.36] => (item={u'var': u'ForwardToWall', u'val': False})
[WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
with a mode of 0700, this may cause issues when running as another user. To
avoid this, create the remote_tmp dir with the correct permissions manually
TASK [openshift_node : Restart journald] ***************************************
Thursday 22 November 2018 05:55:52 +0000 (0:00:03.130) 0:07:55.522 *****
changed: [40.76.5.36]
TASK [openshift_node : Disable swap] *******************************************
Thursday 22 November 2018 05:55:52 +0000 (0:00:00.730) 0:07:56.253 *****
ok: [40.76.5.36]
TASK [openshift_node : sysctl] *************************************************
Thursday 22 November 2018 05:55:53 +0000 (0:00:00.594) 0:07:56.847 *****
changed: [40.76.5.36]
TASK [openshift_node : Setting sebool container_manage_cgroup] *****************
Thursday 22 November 2018 05:55:53 +0000 (0:00:00.469) 0:07:57.317 *****
changed: [40.76.5.36]
TASK [openshift_node : Check for credentials file for registry auth] ***********
Thursday 22 November 2018 05:55:55 +0000 (0:00:01.504) 0:07:58.821 *****
skipping: [40.76.5.36]
TASK [openshift_node : Create credentials for registry auth] *******************
Thursday 22 November 2018 05:55:55 +0000 (0:00:00.047) 0:07:58.868 *****
skipping: [40.76.5.36]
TASK [openshift_node : Create credentials for any additional registries] *******
Thursday 22 November 2018 05:55:55 +0000 (0:00:00.046) 0:07:58.915 *****
TASK [openshift_node : Check status of node image pre-pull] ********************
Thursday 22 November 2018 05:55:55 +0000 (0:00:00.044) 0:07:58.959 *****
FAILED - RETRYING: Check status of node image pre-pull (20 retries left).
changed: [40.76.5.36]
TASK [openshift_node : Check status of node pod image pre-pull] ****************
Thursday 22 November 2018 05:56:26 +0000 (0:00:30.610) 0:08:29.569 *****
changed: [40.76.5.36]
TASK [openshift_node : Copy node script to the node] ***************************
Thursday 22 November 2018 05:56:26 +0000 (0:00:00.291) 0:08:29.861 *****
changed: [40.76.5.36]
TASK [openshift_node : Install Node service file] ******************************
Thursday 22 November 2018 05:56:26 +0000 (0:00:00.625) 0:08:30.486 *****
changed: [40.76.5.36]
TASK [openshift_node : Configure Node settings] ********************************
Thursday 22 November 2018 05:56:27 +0000 (0:00:00.645) 0:08:31.132 *****
changed: [40.76.5.36] => (item={u'regex': u'^OPTIONS=', u'line': u'OPTIONS='})
changed: [40.76.5.36] => (item={u'regex': u'^DEBUG_LOGLEVEL=', u'line': u'DEBUG_LOGLEVEL=2'})
changed: [40.76.5.36] => (item={u'regex': u'^IMAGE_VERSION=', u'line': u'IMAGE_VERSION=v4.0'})
TASK [openshift_node : openshift_facts] ****************************************
Thursday 22 November 2018 05:56:28 +0000 (0:00:00.625) 0:08:31.757 *****
changed: [40.76.5.36]
TASK [openshift_node : Configure Proxy Settings] *******************************
Thursday 22 November 2018 05:56:35 +0000 (0:00:07.564) 0:08:39.322 *****
skipping: [40.76.5.36] => (item={u'regex': u'^HTTP_PROXY=', u'line': u'HTTP_PROXY='})
skipping: [40.76.5.36] => (item={u'regex': u'^HTTPS_PROXY=', u'line': u'HTTPS_PROXY='})
skipping: [40.76.5.36] => (item={u'regex': u'^NO_PROXY=', u'line': u'NO_PROXY=[],172.30.0.0/16,10.128.0.0/14'})
TASK [openshift_node : Configure Node Environment Variables] *******************
Thursday 22 November 2018 05:56:35 +0000 (0:00:00.086) 0:08:39.409 *****
TASK [openshift_node : Ensure the node static pod directory exists] ************
Thursday 22 November 2018 05:56:35 +0000 (0:00:00.048) 0:08:39.458 *****
changed: [40.76.5.36]
TASK [openshift_node : Configure AWS Cloud Provider Settings] ******************
Thursday 22 November 2018 05:56:36 +0000 (0:00:00.235) 0:08:39.694 *****
skipping: [40.76.5.36] => (item=None)
skipping: [40.76.5.36] => (item=None)
skipping: [40.76.5.36]
TASK [openshift_node : Install NFS storage plugin dependencies] ****************
Thursday 22 November 2018 05:56:36 +0000 (0:00:00.072) 0:08:39.766 *****
changed: [40.76.5.36]
TASK [openshift_node : Check for existence of nfs sebooleans] ******************
Thursday 22 November 2018 05:57:05 +0000 (0:00:29.698) 0:09:09.465 *****
ok: [40.76.5.36] => (item=virt_use_nfs)
ok: [40.76.5.36] => (item=virt_sandbox_use_nfs)
TASK [openshift_node : Set seboolean to allow nfs storage plugin access from containers] ***
Thursday 22 November 2018 05:57:06 +0000 (0:00:00.413) 0:09:09.878 *****
ok: [40.76.5.36] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-22 05:57:06.160913', '_ansible_no_log': False, u'stdout': u'virt_use_nfs --> on', u'cmd': [u'getsebool', u'virt_use_nfs'], u'rc': 0, 'item': u'virt_use_nfs', u'delta': u'0:00:00.003266', '_ansible_item_label': u'virt_use_nfs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_use_nfs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_nfs --> on'], 'failed_when_result': False, u'start': u'2018-11-22 05:57:06.157647', '_ansible_ignore_errors': None, 'failed': False})
skipping: [40.76.5.36] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-22 05:57:06.332439', '_ansible_no_log': False, u'stdout': u'virt_use_nfs --> on', u'cmd': [u'getsebool', u'virt_sandbox_use_nfs'], u'rc': 0, 'item': u'virt_sandbox_use_nfs', u'delta': u'0:00:00.002763', '_ansible_item_label': u'virt_sandbox_use_nfs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_sandbox_use_nfs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_nfs --> on'], 'failed_when_result': False, u'start': u'2018-11-22 05:57:06.329676', '_ansible_ignore_errors': None, 'failed': False})
TASK [openshift_node : Set seboolean to allow nfs storage plugin access from containers (python 3)] ***
Thursday 22 November 2018 05:57:06 +0000 (0:00:00.261) 0:09:10.140 *****
skipping: [40.76.5.36] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-22 05:57:06.160913', '_ansible_no_log': False, u'stdout': u'virt_use_nfs --> on', u'cmd': [u'getsebool', u'virt_use_nfs'], u'rc': 0, 'item': u'virt_use_nfs', u'delta': u'0:00:00.003266', '_ansible_item_label': u'virt_use_nfs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_use_nfs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_nfs --> on'], 'failed_when_result': False, u'start': u'2018-11-22 05:57:06.157647', '_ansible_ignore_errors': None, 'failed': False})
skipping: [40.76.5.36] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-22 05:57:06.332439', '_ansible_no_log': False, u'stdout': u'virt_use_nfs --> on', u'cmd': [u'getsebool', u'virt_sandbox_use_nfs'], u'rc': 0, 'item': u'virt_sandbox_use_nfs', u'delta': u'0:00:00.002763', '_ansible_item_label': u'virt_sandbox_use_nfs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_sandbox_use_nfs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_nfs --> on'], 'failed_when_result': False, u'start': u'2018-11-22 05:57:06.329676', '_ansible_ignore_errors': None, 'failed': False})
TASK [openshift_node : Install GlusterFS storage plugin dependencies] **********
Thursday 22 November 2018 05:57:06 +0000 (0:00:00.090) 0:09:10.230 *****
changed: [40.76.5.36]
TASK [openshift_node : Check for existence of fusefs sebooleans] ***************
Thursday 22 November 2018 05:57:10 +0000 (0:00:04.142) 0:09:14.373 *****
ok: [40.76.5.36] => (item=virt_use_fusefs)
ok: [40.76.5.36] => (item=virt_sandbox_use_fusefs)
TASK [openshift_node : Set seboolean to allow gluster storage plugin access from containers] ***
Thursday 22 November 2018 05:57:11 +0000 (0:00:00.403) 0:09:14.777 *****
changed: [40.76.5.36] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-22 05:57:11.068755', '_ansible_no_log': False, u'stdout': u'virt_use_fusefs --> off', u'cmd': [u'getsebool', u'virt_use_fusefs'], u'rc': 0, 'item': u'virt_use_fusefs', u'delta': u'0:00:00.002947', '_ansible_item_label': u'virt_use_fusefs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_use_fusefs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_fusefs --> off'], 'failed_when_result': False, u'start': u'2018-11-22 05:57:11.065808', '_ansible_ignore_errors': None, 'failed': False})
changed: [40.76.5.36] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-22 05:57:11.232117', '_ansible_no_log': False, u'stdout': u'virt_sandbox_use_fusefs --> off', u'cmd': [u'getsebool', u'virt_sandbox_use_fusefs'], u'rc': 0, 'item': u'virt_sandbox_use_fusefs', u'delta': u'0:00:00.002645', '_ansible_item_label': u'virt_sandbox_use_fusefs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_sandbox_use_fusefs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_sandbox_use_fusefs --> off'], 'failed_when_result': False, u'start': u'2018-11-22 05:57:11.229472', '_ansible_ignore_errors': None, 'failed': False})
TASK [openshift_node : Set seboolean to allow gluster storage plugin access from containers (python 3)] ***
Thursday 22 November 2018 05:57:13 +0000 (0:00:02.195) 0:09:16.973 *****
skipping: [40.76.5.36] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-22 05:57:11.068755', '_ansible_no_log': False, u'stdout': u'virt_use_fusefs --> off', u'cmd': [u'getsebool', u'virt_use_fusefs'], u'rc': 0, 'item': u'virt_use_fusefs', u'delta': u'0:00:00.002947', '_ansible_item_label': u'virt_use_fusefs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_use_fusefs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_fusefs --> off'], 'failed_when_result': False, u'start': u'2018-11-22 05:57:11.065808', '_ansible_ignore_errors': None, 'failed': False})
skipping: [40.76.5.36] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-22 05:57:11.232117', '_ansible_no_log': False, u'stdout': u'virt_sandbox_use_fusefs --> off', u'cmd': [u'getsebool', u'virt_sandbox_use_fusefs'], u'rc': 0, 'item': u'virt_sandbox_use_fusefs', u'delta': u'0:00:00.002645', '_ansible_item_label': u'virt_sandbox_use_fusefs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_sandbox_use_fusefs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_sandbox_use_fusefs --> off'], 'failed_when_result': False, u'start': u'2018-11-22 05:57:11.229472', '_ansible_ignore_errors': None, 'failed': False})
TASK [openshift_node : Install Ceph storage plugin dependencies] ***************
Thursday 22 November 2018 05:57:13 +0000 (0:00:00.103) 0:09:17.076 *****
changed: [40.76.5.36]
TASK [openshift_node : Install iSCSI storage plugin dependencies] **************
Thursday 22 November 2018 05:57:26 +0000 (0:00:13.241) 0:09:30.317 *****
changed: [40.76.5.36]
TASK [openshift_node : restart services] ***************************************
Thursday 22 November 2018 05:57:30 +0000 (0:00:03.930) 0:09:34.248 *****
changed: [40.76.5.36] => (item=multipathd)
changed: [40.76.5.36] => (item=rpcbind)
changed: [40.76.5.36] => (item=iscsid)
TASK [openshift_node : Template multipath configuration] ***********************
Thursday 22 November 2018 05:57:31 +0000 (0:00:00.892) 0:09:35.140 *****
changed: [40.76.5.36]
TASK [openshift_node : Enable and start multipath] *****************************
Thursday 22 November 2018 05:57:32 +0000 (0:00:00.601) 0:09:35.742 *****
changed: [40.76.5.36]
TASK [tuned : Check for tuned package] *****************************************
Thursday 22 November 2018 05:57:32 +0000 (0:00:00.540) 0:09:36.283 *****
ok: [40.76.5.36]
TASK [tuned : Ensure directory structure exists] *******************************
Thursday 22 November 2018 05:57:33 +0000 (0:00:00.312) 0:09:36.596 *****
changed: [40.76.5.36] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1542864130.0, 'owner': 'root', 'path': u'openshift', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.4407961})
changed: [40.76.5.36] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-control-plane', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.4407961})
changed: [40.76.5.36] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1542864130.0, 'owner': 'root', 'path': u'openshift-node', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.4407961})
skipping: [40.76.5.36] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/recommend.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '02666', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'recommend.conf', 'size': 290, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.370796})
skipping: [40.76.5.36] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '0666', 'mtime': 1542864130.0, 'owner': 'root', 'path': u'openshift/tuned.conf', 'size': 593, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.370796})
skipping: [40.76.5.36] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift-control-plane/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '02666', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-control-plane/tuned.conf', 'size': 744, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.370796})
skipping: [40.76.5.36] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift-node/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '0666', 'mtime': 1542864130.0, 'owner': 'root', 'path': u'openshift-node/tuned.conf', 'size': 283, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.370796})
TASK [tuned : Ensure files are populated from templates] ***********************
Thursday 22 November 2018 05:57:33 +0000 (0:00:00.613) 0:09:37.209 *****
skipping: [40.76.5.36] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1542864130.0, 'owner': 'root', 'path': u'openshift', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.4407961})
skipping: [40.76.5.36] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-control-plane', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.4407961})
skipping: [40.76.5.36] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1542864130.0, 'owner': 'root', 'path': u'openshift-node', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.4407961})
changed: [40.76.5.36] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/recommend.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '02666', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'recommend.conf', 'size': 290, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.370796})
changed: [40.76.5.36] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '0666', 'mtime': 1542864130.0, 'owner': 'root', 'path': u'openshift/tuned.conf', 'size': 593, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.370796})
changed: [40.76.5.36] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift-control-plane/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '02666', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-control-plane/tuned.conf', 'size': 744, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.370796})
changed: [40.76.5.36] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift-node/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '0666', 'mtime': 1542864130.0, 'owner': 'root', 'path': u'openshift-node/tuned.conf', 'size': 283, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1542865400.370796})
TASK [tuned : Make tuned use the recommended tuned profile on restart] *********
Thursday 22 November 2018 05:57:36 +0000 (0:00:02.320) 0:09:39.530 *****
changed: [40.76.5.36] => (item=/etc/tuned/active_profile)
changed: [40.76.5.36] => (item=/etc/tuned/profile_mode)
TASK [tuned : Restart tuned service] *******************************************
Thursday 22 November 2018 05:57:36 +0000 (0:00:00.462) 0:09:39.992 *****
changed: [40.76.5.36]
TASK [nickhammond.logrotate : nickhammond.logrotate | Install logrotate] *******
Thursday 22 November 2018 05:57:38 +0000 (0:00:01.955) 0:09:41.948 *****
ok: [40.76.5.36]
TASK [nickhammond.logrotate : nickhammond.logrotate | Setup logrotate.d scripts] ***
Thursday 22 November 2018 05:57:38 +0000 (0:00:00.511) 0:09:42.459 *****
TASK [openshift_storage_glusterfs : Ensure device mapper modules loaded] *******
Thursday 22 November 2018 05:57:39 +0000 (0:00:00.046) 0:09:42.506 *****
changed: [40.76.5.36]
TASK [openshift_storage_glusterfs : Install kernel modules package on Fedora] ***
Thursday 22 November 2018 05:57:39 +0000 (0:00:00.649) 0:09:43.155 *****
skipping: [40.76.5.36]
TASK [openshift_storage_glusterfs : load kernel modules] ***********************
Thursday 22 November 2018 05:57:39 +0000 (0:00:00.050) 0:09:43.206 *****
changed: [40.76.5.36]
RUNNING HANDLER [openshift_node : reload systemd units] ************************
Thursday 22 November 2018 05:57:40 +0000 (0:00:00.707) 0:09:43.913 *****
skipping: [40.76.5.36]
PLAY [node bootstrap config] ***************************************************
TASK [openshift_node : install needed rpm(s)] **********************************
Thursday 22 November 2018 05:57:40 +0000 (0:00:00.086) 0:09:43.999 *****
changed: [40.76.5.36]
TASK [openshift_node : create the directory for node] **************************
Thursday 22 November 2018 05:58:04 +0000 (0:00:24.105) 0:10:08.105 *****
skipping: [40.76.5.36]
TASK [openshift_node : laydown systemd override] *******************************
Thursday 22 November 2018 05:58:04 +0000 (0:00:00.053) 0:10:08.158 *****
skipping: [40.76.5.36]
TASK [openshift_node : update the sysconfig to have necessary variables] *******
Thursday 22 November 2018 05:58:04 +0000 (0:00:00.051) 0:10:08.210 *****
changed: [40.76.5.36] => (item={u'regexp': u'^KUBECONFIG=.*', u'line': u'KUBECONFIG=/etc/origin/node/bootstrap.kubeconfig'})
TASK [openshift_node : Configure AWS Cloud Provider Settings] ******************
Thursday 22 November 2018 05:58:04 +0000 (0:00:00.255) 0:10:08.466 *****
skipping: [40.76.5.36] => (item=None)
skipping: [40.76.5.36] => (item=None)
skipping: [40.76.5.36]
TASK [openshift_node : disable origin-node service] ****************************
Thursday 22 November 2018 05:58:05 +0000 (0:00:00.074) 0:10:08.540 *****
ok: [40.76.5.36] => (item=origin-node.service)
TASK [openshift_node : create directories for bootstrapping] *******************
Thursday 22 November 2018 05:58:05 +0000 (0:00:00.256) 0:10:08.797 *****
changed: [40.76.5.36] => (item=/root/openshift_bootstrap)
changed: [40.76.5.36] => (item=/var/lib/origin/openshift.local.config)
changed: [40.76.5.36] => (item=/var/lib/origin/openshift.local.config/node)
changed: [40.76.5.36] => (item=/etc/docker/certs.d/docker-registry.default.svc:5000)
TASK [openshift_node : laydown the bootstrap.yml file for on boot configuration] ***
Thursday 22 November 2018 05:58:06 +0000 (0:00:00.763) 0:10:09.560 *****
changed: [40.76.5.36]
TASK [openshift_node : Create a symlink to the node client CA for the docker registry] ***
Thursday 22 November 2018 05:58:06 +0000 (0:00:00.619) 0:10:10.180 *****
changed: [40.76.5.36]
TASK [openshift_node_group : create node config template] **********************
Thursday 22 November 2018 05:58:06 +0000 (0:00:00.234) 0:10:10.414 *****
changed: [40.76.5.36]
TASK [etcd : set etcd host and ip facts] ***************************************
Thursday 22 November 2018 05:58:07 +0000 (0:00:00.608) 0:10:11.022 *****
ok: [40.76.5.36]
TASK [etcd : Check that etcd image is present] *********************************
Thursday 22 November 2018 05:58:07 +0000 (0:00:00.077) 0:10:11.100 *****
changed: [40.76.5.36]
TASK [etcd : Pre-pull etcd image] **********************************************
Thursday 22 November 2018 05:58:07 +0000 (0:00:00.251) 0:10:11.351 *****
changed: [40.76.5.36]
TASK [etcd : Configure etcd profile.d aliases] *********************************
Thursday 22 November 2018 05:58:09 +0000 (0:00:01.415) 0:10:12.767 *****
changed: [40.76.5.36]
TASK [etcd : Add iptables allow rules] *****************************************
Thursday 22 November 2018 05:58:09 +0000 (0:00:00.631) 0:10:13.399 *****
changed: [40.76.5.36] => (item={u'port': u'2379/tcp', u'service': u'etcd'})
changed: [40.76.5.36] => (item={u'port': u'2380/tcp', u'service': u'etcd peering'})
TASK [etcd : Remove iptables rules] ********************************************
Thursday 22 November 2018 05:58:10 +0000 (0:00:00.686) 0:10:14.086 *****
TASK [etcd : Add firewalld allow rules] ****************************************
Thursday 22 November 2018 05:58:10 +0000 (0:00:00.046) 0:10:14.132 *****
skipping: [40.76.5.36] => (item={u'port': u'2379/tcp', u'service': u'etcd'})
skipping: [40.76.5.36] => (item={u'port': u'2380/tcp', u'service': u'etcd peering'})
TASK [etcd : Remove firewalld allow rules] *************************************
Thursday 22 November 2018 05:58:10 +0000 (0:00:00.082) 0:10:14.214 *****
TASK [etcd : Ensure etcd datadir exists] ***************************************
Thursday 22 November 2018 05:58:10 +0000 (0:00:00.045) 0:10:14.260 *****
changed: [40.76.5.36]
TASK [etcd : Validate permissions on the config dir] ***************************
Thursday 22 November 2018 05:58:11 +0000 (0:00:00.239) 0:10:14.500 *****
changed: [40.76.5.36]
TASK [etcd : Validate permissions on the static pods dir] **********************
Thursday 22 November 2018 05:58:11 +0000 (0:00:00.290) 0:10:14.790 *****
changed: [40.76.5.36]
TASK [etcd : Write etcd global config file] ************************************
Thursday 22 November 2018 05:58:11 +0000 (0:00:00.264) 0:10:15.055 *****
changed: [40.76.5.36]
TASK [etcd : Create temp directory for static pods] ****************************
Thursday 22 November 2018 05:58:12 +0000 (0:00:00.859) 0:10:15.915 *****
ok: [40.76.5.36]
TASK [etcd : Prepare etcd static pod] ******************************************
Thursday 22 November 2018 05:58:12 +0000 (0:00:00.277) 0:10:16.192 *****
changed: [40.76.5.36] => (item=etcd.yaml)
TASK [etcd : Update etcd static pod] *******************************************
Thursday 22 November 2018 05:58:13 +0000 (0:00:00.828) 0:10:17.021 *****
changed: [40.76.5.36] => (item=etcd.yaml)
TASK [etcd : Set etcd host as a probe target host] *****************************
Thursday 22 November 2018 05:58:13 +0000 (0:00:00.327) 0:10:17.349 *****
changed: [40.76.5.36] => (item=etcd.yaml)
TASK [etcd : Deploy etcd static pod] *******************************************
Thursday 22 November 2018 05:58:14 +0000 (0:00:00.291) 0:10:17.640 *****
changed: [40.76.5.36] => (item=etcd.yaml)
TASK [etcd : Remove temp directory] ********************************************
Thursday 22 November 2018 05:58:14 +0000 (0:00:00.316) 0:10:17.957 *****
ok: [40.76.5.36]
TASK [openshift_control_plane : Copy static master scripts] ********************
Thursday 22 November 2018 05:58:14 +0000 (0:00:00.279) 0:10:18.236 *****
changed: [40.76.5.36] => (item=scripts/crio/master-exec)
changed: [40.76.5.36] => (item=scripts/crio/master-logs)
changed: [40.76.5.36] => (item=scripts/crio/master-restart)
TASK [openshift_control_plane : Ensure cri-tools installed] ********************
Thursday 22 November 2018 05:58:16 +0000 (0:00:01.730) 0:10:19.966 *****
ok: [40.76.5.36]
TASK [openshift_control_plane : Enable bootstrapping in the master config] *****
Thursday 22 November 2018 05:58:16 +0000 (0:00:00.524) 0:10:20.490 *****
skipping: [40.76.5.36]
TASK [openshift_control_plane : Create temp directory for static pods] *********
Thursday 22 November 2018 05:58:17 +0000 (0:00:00.051) 0:10:20.542 *****
ok: [40.76.5.36]
TASK [openshift_control_plane : Prepare master static pods] ********************
Thursday 22 November 2018 05:58:17 +0000 (0:00:00.230) 0:10:20.772 *****
changed: [40.76.5.36] => (item=apiserver.yaml)
changed: [40.76.5.36] => (item=controller.yaml)
TASK [openshift_control_plane : Update master static pods] *********************
Thursday 22 November 2018 05:58:18 +0000 (0:00:01.484) 0:10:22.257 *****
changed: [40.76.5.36] => (item=apiserver.yaml)
changed: [40.76.5.36] => (item=controller.yaml)
TASK [openshift_control_plane : Update master static pod (api)] ****************
Thursday 22 November 2018 05:58:19 +0000 (0:00:00.567) 0:10:22.825 *****
ok: [40.76.5.36]
TASK [openshift_control_plane : ensure pod location exists] ********************
Thursday 22 November 2018 05:58:19 +0000 (0:00:00.336) 0:10:23.162 *****
changed: [40.76.5.36]
TASK [openshift_control_plane : Update master static pods] *********************
Thursday 22 November 2018 05:58:19 +0000 (0:00:00.291) 0:10:23.454 *****
changed: [40.76.5.36] => (item=apiserver.yaml)
changed: [40.76.5.36] => (item=controller.yaml)
TASK [openshift_control_plane : Remove temporary directory] ********************
Thursday 22 November 2018 05:58:21 +0000 (0:00:01.255) 0:10:24.710 *****
ok: [40.76.5.36]
PLAY [Re-enable excluder if it was previously enabled] *************************
TASK [openshift_excluder : Debug r_openshift_excluder_enable_docker_excluder] ***
Thursday 22 November 2018 05:58:21 +0000 (0:00:00.301) 0:10:25.011 *****
ok: [40.76.5.36] => {
"r_openshift_excluder_enable_docker_excluder": true
}
TASK [openshift_excluder : Debug r_openshift_excluder_enable_openshift_excluder] ***
Thursday 22 November 2018 05:58:21 +0000 (0:00:00.130) 0:10:25.141 *****
ok: [40.76.5.36] => {
"r_openshift_excluder_enable_openshift_excluder": true
}
TASK [openshift_excluder : Fail if invalid openshift_excluder_action provided] ***
Thursday 22 November 2018 05:58:21 +0000 (0:00:00.125) 0:10:25.267 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Fail if r_openshift_excluder_upgrade_target is not defined] ***
Thursday 22 November 2018 05:58:21 +0000 (0:00:00.087) 0:10:25.355 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Include main action task file] **********************
Thursday 22 November 2018 05:58:21 +0000 (0:00:00.048) 0:10:25.404 *****
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/enable.yml for 40.76.5.36
TASK [openshift_excluder : Install docker excluder - yum] **********************
Thursday 22 November 2018 05:58:22 +0000 (0:00:00.092) 0:10:25.497 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Install docker excluder - dnf] **********************
Thursday 22 November 2018 05:58:22 +0000 (0:00:00.049) 0:10:25.546 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Install openshift excluder - yum] *******************
Thursday 22 November 2018 05:58:22 +0000 (0:00:00.049) 0:10:25.595 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Install openshift excluder - dnf] *******************
Thursday 22 November 2018 05:58:22 +0000 (0:00:00.046) 0:10:25.642 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : set_fact] *******************************************
Thursday 22 November 2018 05:58:22 +0000 (0:00:00.047) 0:10:25.690 *****
skipping: [40.76.5.36]
TASK [openshift_excluder : Check for docker-excluder] **************************
Thursday 22 November 2018 05:58:22 +0000 (0:00:00.047) 0:10:25.737 *****
ok: [40.76.5.36]
TASK [openshift_excluder : Check for openshift excluder] ***********************
Thursday 22 November 2018 05:58:22 +0000 (0:00:00.233) 0:10:25.970 *****
ok: [40.76.5.36]
TASK [openshift_excluder : Enable docker excluder] *****************************
Thursday 22 November 2018 05:58:22 +0000 (0:00:00.234) 0:10:26.205 *****
changed: [40.76.5.36]
TASK [openshift_excluder : Enable openshift excluder] **************************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.292) 0:10:26.497 *****
skipping: [40.76.5.36]
PLAY [Reboot instance] *********************************************************
TASK [openshift_aws : fetch newly created instances] ***************************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.041) 0:10:26.539 *****
skipping: [localhost]
TASK [openshift_aws : reboot hosts] ********************************************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.032) 0:10:26.572 *****
skipping: [localhost]
TASK [openshift_aws : wait for ssh to become available] ************************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.034) 0:10:26.606 *****
skipping: [localhost]
PLAY [Configure nodes] *********************************************************
TASK [openshift_aws : fetch block device of slash filesystem] ******************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.057) 0:10:26.664 *****
skipping: [40.76.5.36]
TASK [openshift_aws : fetch filesystem of slash block device] ******************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.046) 0:10:26.711 *****
skipping: [40.76.5.36]
TASK [openshift_aws : fetch uuid of slash block device] ************************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.050) 0:10:26.761 *****
skipping: [40.76.5.36]
TASK [openshift_aws : ensure nonUUID based slash mount entry in /etc/fstab is removed] ***
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.047) 0:10:26.808 *****
skipping: [40.76.5.36]
TASK [openshift_aws : ensure slash mount uses UUID device and gquota option in /etc/fstab] ***
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.047) 0:10:26.856 *****
skipping: [40.76.5.36]
TASK [openshift_aws : set rootvol flags in grub conf] **************************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.047) 0:10:26.903 *****
skipping: [40.76.5.36]
TASK [openshift_aws : recreate grub2 config] ***********************************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.048) 0:10:26.951 *****
skipping: [40.76.5.36]
TASK [Remove any ansible facts created during AMI creation] ********************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.046) 0:10:26.997 *****
changed: [40.76.5.36] => (item=openshift.fact)
TASK [Clean cloud-init path] ***************************************************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.240) 0:10:27.238 *****
ok: [40.76.5.36]
PLAY [nodes] *******************************************************************
TASK [remove yum client certificate] *******************************************
Thursday 22 November 2018 05:58:23 +0000 (0:00:00.229) 0:10:27.467 *****
skipping: [40.76.5.36] => (item={u'name': u'client-cert.pem'})
skipping: [40.76.5.36] => (item={u'name': u'client-key.pem'})
TASK [remove yum repositories] *************************************************
Thursday 22 November 2018 05:58:24 +0000 (0:00:00.059) 0:10:27.527 *****
changed: [40.76.5.36] => (item={u'gpgkey': u'file:///etc/pki/rpm-gpg/RPM-GPG-KEY-CentOS-SIG-PaaS', u'enabled': True, u'name': u'openshift-origin', u'baseurl': u'http://mirror.centos.org/centos/7/paas/x86_64/openshift-origin/'})
changed: [40.76.5.36] => (item={'gpgcheck': False, 'enabled': True, 'name': u'install_repo', 'baseurl': u'https://storage.googleapis.com/origin-ci-test/logs/test_branch_origin_extended_conformance_azure/786/artifacts/rpms'})
TASK [add get-node-logs script] ************************************************
Thursday 22 November 2018 05:58:24 +0000 (0:00:00.403) 0:10:27.930 *****
changed: [40.76.5.36]
TASK [record installed rpms] ***************************************************
Thursday 22 November 2018 05:58:25 +0000 (0:00:00.607) 0:10:28.538 *****
ok: [40.76.5.36]
TASK [disable waagent data disk management] ************************************
Thursday 22 November 2018 05:58:26 +0000 (0:00:01.191) 0:10:29.729 *****
changed: [40.76.5.36] => (item={u'regexp': u'^ResourceDisk\\.Format=', u'line': u'ResourceDisk.Format=n'})
TASK [persist oreg_url] ********************************************************
Thursday 22 November 2018 05:58:26 +0000 (0:00:00.251) 0:10:29.981 *****
changed: [40.76.5.36]
TASK [create a file with image name] *******************************************
Thursday 22 November 2018 05:58:27 +0000 (0:00:00.615) 0:10:30.597 *****
changed: [40.76.5.36]
TASK [run waagent deprovision] *************************************************
Thursday 22 November 2018 05:58:27 +0000 (0:00:00.652) 0:10:31.249 *****
changed: [40.76.5.36]
PLAY [localhost] ***************************************************************
TASK [set_fact] ****************************************************************
Thursday 22 November 2018 05:58:29 +0000 (0:00:01.428) 0:10:32.678 *****
ok: [localhost]
TASK [deallocate vm] ***********************************************************
Thursday 22 November 2018 05:58:29 +0000 (0:00:00.120) 0:10:32.798 *****
changed: [localhost]
TASK [generalize vm] ***********************************************************
Thursday 22 November 2018 05:59:48 +0000 (0:01:19.120) 0:11:51.919 *****
changed: [localhost]
TASK [get vm details] **********************************************************
Thursday 22 November 2018 05:59:50 +0000 (0:00:01.720) 0:11:53.639 *****
changed: [localhost]
TASK [create image resource group] *********************************************
Thursday 22 November 2018 05:59:51 +0000 (0:00:01.669) 0:11:55.308 *****
ok: [localhost]
TASK [create image] ************************************************************
Thursday 22 November 2018 05:59:52 +0000 (0:00:00.801) 0:11:56.110 *****
changed: [localhost]
TASK [get input image tags] ****************************************************
Thursday 22 November 2018 06:00:26 +0000 (0:00:33.597) 0:12:29.708 *****
changed: [localhost]
TASK [remove valid tag from input image tags] **********************************
Thursday 22 November 2018 06:00:27 +0000 (0:00:01.734) 0:12:31.443 *****
ok: [localhost] => (item={'value': u'3.10.0-693.el7.x86_64', 'key': u'kernel'})
skipping: [localhost] => (item={'value': u'true', 'key': u'valid'})
ok: [localhost] => (item={'value': u'centos7-root-201804191712', 'key': u'root_image'})
TASK [calculate final tags] ****************************************************
Thursday 22 November 2018 06:00:28 +0000 (0:00:00.066) 0:12:31.509 *****
ok: [localhost]
TASK [tag image] ***************************************************************
Thursday 22 November 2018 06:00:28 +0000 (0:00:00.065) 0:12:31.575 *****
changed: [localhost]
TASK [log image resource group and name] ***************************************
Thursday 22 November 2018 06:01:01 +0000 (0:00:33.526) 0:13:05.102 *****
ok: [localhost] => (item=Resource group: ci-test_branch_origin_extended_c_azure-786) => {
"msg": "Resource group: ci-test_branch_origin_extended_c_azure-786"
}
ok: [localhost] => (item=Image name: centos7-origin) => {
"msg": "Image name: centos7-origin"
}
TASK [log image tag information] ***********************************************
Thursday 22 November 2018 06:01:01 +0000 (0:00:00.048) 0:13:05.150 *****
ok: [localhost] => (item={'value': u'3.10.0-862.14.4.el7.x86_64', 'key': u'kernel'}) => {
"msg": "kernel: 3.10.0-862.14.4.el7.x86_64"
}
ok: [localhost] => (item={'value': u'centos7-base-201811211625', 'key': u'base_image'}) => {
"msg": "base_image: centos7-base-201811211625"
}
ok: [localhost] => (item={'value': u'centos7-root-201804191712', 'key': u'root_image'}) => {
"msg": "root_image: centos7-root-201804191712"
}
ok: [localhost] => (item={'value': u'4.0.0-0.alpha.0.628.b55a046.x86_64', 'key': u'openshift'}) => {
"msg": "openshift: 4.0.0-0.alpha.0.628.b55a046.x86_64"
}
TASK [get vm details] **********************************************************
Thursday 22 November 2018 06:01:01 +0000 (0:00:00.071) 0:13:05.222 *****
skipping: [localhost]
TASK [get storage account key] *************************************************
Thursday 22 November 2018 06:01:01 +0000 (0:00:00.026) 0:13:05.248 *****
skipping: [localhost]
TASK [get disk sas url] ********************************************************
Thursday 22 November 2018 06:01:01 +0000 (0:00:00.027) 0:13:05.276 *****
skipping: [localhost]
TASK [start copy] **************************************************************
Thursday 22 November 2018 06:01:01 +0000 (0:00:00.028) 0:13:05.304 *****
skipping: [localhost]
TASK [get copy status] *********************************************************
Thursday 22 November 2018 06:01:01 +0000 (0:00:00.024) 0:13:05.329 *****
skipping: [localhost]
TASK [revoke disk sas url] *****************************************************
Thursday 22 November 2018 06:01:01 +0000 (0:00:00.025) 0:13:05.354 *****
skipping: [localhost]
PLAY RECAP *********************************************************************
40.76.5.36 : ok=195 changed=113 unreachable=0 failed=0
localhost : ok=21 changed=12 unreachable=0 failed=0
{} : ok=1 changed=0 unreachable=0 failed=0
INSTALLER STATUS ***************************************************************
Initialization : Complete (0:00:21)
Thursday 22 November 2018 06:01:01 +0000 (0:00:00.023) 0:13:05.378 *****
===============================================================================
create vm ------------------------------------------------------------- 157.78s
openshift_node : Install node, clients, and conntrack packages --------- 91.24s
deallocate vm ---------------------------------------------------------- 79.12s
container_runtime : Install Docker ------------------------------------- 46.63s
container_runtime : Install cri-o -------------------------------------- 36.04s
create image ----------------------------------------------------------- 33.60s
tag image -------------------------------------------------------------- 33.53s
openshift_node : Check status of node image pre-pull ------------------- 30.61s
openshift_node : Install NFS storage plugin dependencies --------------- 29.70s
openshift_node : install needed rpm(s) --------------------------------- 24.11s
create vnet ------------------------------------------------------------ 15.53s
openshift_node : Install Ceph storage plugin dependencies -------------- 13.24s
Ensure openshift-ansible installer package deps are installed ---------- 13.03s
install centos-release-paas-common rpm --------------------------------- 11.76s
os_firewall : Wait 10 seconds after disabling firewalld ---------------- 10.13s
os_firewall : need to pause here, otherwise the iptables service starting can sometimes cause ssh to fail -- 10.09s
openshift_node : openshift_facts ---------------------------------------- 7.56s
openshift_excluder : Install docker excluder - yum ---------------------- 6.07s
create subnet ----------------------------------------------------------- 5.21s
os_update_latest : Update all packages ---------------------------------- 5.01s
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: BUILD NODE IMAGE [00h 13m 10s] ##########
[workspace] $ /bin/bash /tmp/jenkins7468034138250631814.sh
########## STARTING STAGE: PROVISION TEST CLUSTER ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ mktemp
+ script=/tmp/tmp.nfQfN9Q6zC
+ cat
+ chmod +x /tmp/tmp.nfQfN9Q6zC
+ scp -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.nfQfN9Q6zC openshiftdevel:/tmp/tmp.nfQfN9Q6zC
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.nfQfN9Q6zC"'
+ cd /data/src/github.com/openshift/release
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PROVISION TEST CLUSTER [00h 00m 00s] ##########
[workspace] $ /bin/bash /tmp/jenkins7010431200953526117.sh
########## STARTING STAGE: RUN THE ACS-ENGINE E2E TEST ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ mktemp
+ script=/tmp/tmp.kivIFRakjx
+ cat
+ chmod +x /tmp/tmp.kivIFRakjx
+ scp -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.kivIFRakjx openshiftdevel:/tmp/tmp.kivIFRakjx
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.kivIFRakjx"'
+ cd /home/origin
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RUN THE ACS-ENGINE E2E TEST [00h 00m 01s] ##########
[workspace] $ /bin/bash /tmp/jenkins5483621413822529412.sh
########## STARTING STAGE: RUN TESTS ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ mktemp
+ script=/tmp/tmp.X3z6AlAJUR
+ cat
+ chmod +x /tmp/tmp.X3z6AlAJUR
+ scp -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.X3z6AlAJUR openshiftdevel:/tmp/tmp.X3z6AlAJUR
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 900 /tmp/tmp.X3z6AlAJUR"'
+ cd /home/origin
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RUN TESTS [00h 00m 01s] ##########
[PostBuildScript] - Executing post build scripts.
[workspace] $ /bin/bash /tmp/jenkins280786036458652548.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /data/src/github.com/openshift/origin/_output/scripts
File: ‘/data/src/github.com/openshift/origin/_output/scripts’
Size: 64 Blocks: 0 IO Block: 4096 directory
Device: ca02h/51714d Inode: 20994641 Links: 5
Access: (2755/drwxr-sr-x) Uid: ( 1001/ origin) Gid: ( 1003/origin-git)
Context: unconfined_u:object_r:container_file_t:s0
Access: 2018-11-22 05:24:14.138630382 +0000
Modify: 2018-11-22 05:43:30.159817710 +0000
Change: 2018-11-22 05:43:30.159817710 +0000
Birth: -
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /data/src/github.com/openshift/origin/_output/scripts
+ scp -r -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/data/src/github.com/openshift/origin/_output/scripts /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/gathered
+ tree /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/gathered
/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/gathered
└── scripts
├── build-base-images
│ ├── artifacts
│ ├── logs
│ └── openshift.local.home
├── push-release
│ ├── artifacts
│ ├── logs
│ │ └── scripts.log
│ └── openshift.local.home
└── shell
├── artifacts
├── logs
│ └── scripts.log
└── openshift.local.home
13 directories, 2 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins5552316819816544690.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/generated
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'oc get --raw /metrics --server=https://$( uname --nodename ):10250 --config=/etc/origin/master/admin.kubeconfig 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'oc get --raw /metrics --config=/etc/origin/master/admin.kubeconfig 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo yum list installed 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/workspace/artifacts/generated
/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/generated
├── avc_denials.log
├── containers.log
├── dmesg.log
├── docker.config
├── docker.info
├── filesystem.info
├── installed_packages.log
├── master-metrics.log
├── node-metrics.log
└── pid1.journal
0 directories, 10 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins4446675379609160322.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/journals
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/workspace/artifacts/journals
/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/artifacts/journals
├── dnsmasq.service
├── docker.service
└── systemd-journald.service
0 directories, 3 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins6545407640950002477.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/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_branch_origin_extended_conformance_azure/786/api/json'\''))['\''result'\'']'
+ result=SUCCESS
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/builds/786/log
+ cp artifacts/generated/avc_denials.log artifacts/generated/containers.log artifacts/generated/dmesg.log artifacts/generated/docker.config artifacts/generated/docker.info artifacts/generated/filesystem.info artifacts/generated/installed_packages.log artifacts/generated/master-metrics.log artifacts/generated/node-metrics.log artifacts/generated/pid1.journal gcs/artifacts/generated/
+ cp artifacts/journals/dnsmasq.service artifacts/journals/docker.service artifacts/journals/systemd-journald.service gcs/artifacts/journals/
+ cp -r artifacts/gathered/scripts gcs/artifacts/
++ pwd
+ scp -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/gcs openshiftdevel:/data
+ scp -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config /var/lib/jenkins/.config/gcloud/gcs-publisher-credentials.json openshiftdevel:/data/credentials.json
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins4537210211072360891.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ mktemp
+ script=/tmp/tmp.dxMvPno9r8
+ cat
+ chmod +x /tmp/tmp.dxMvPno9r8
+ scp -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.dxMvPno9r8 openshiftdevel:/tmp/tmp.dxMvPno9r8
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.dxMvPno9r8"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"postsubmit","job":"test_branch_origin_extended_conformance_azure","buildid":"1065474686646751233","prowjobid":"14c39c98-ee16-11e8-98be-0a58ac100f3f","refs":{"org":"openshift","repo":"origin","base_ref":"master","base_sha":"b55a0468a006b09b8aef4d7406e4d9c4a4591562"}} ]]
++ jq --compact-output '.buildid |= "786"'
+ JOB_SPEC='{"type":"postsubmit","job":"test_branch_origin_extended_conformance_azure","buildid":"786","prowjobid":"14c39c98-ee16-11e8-98be-0a58ac100f3f","refs":{"org":"openshift","repo":"origin","base_ref":"master","base_sha":"b55a0468a006b09b8aef4d7406e4d9c4a4591562"}}'
+ docker run -e 'JOB_SPEC={"type":"postsubmit","job":"test_branch_origin_extended_conformance_azure","buildid":"786","prowjobid":"14c39c98-ee16-11e8-98be-0a58ac100f3f","refs":{"org":"openshift","repo":"origin","base_ref":"master","base_sha":"b55a0468a006b09b8aef4d7406e4d9c4a4591562"}}' -v /data:/data:z registry.svc.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.svc.ci.openshift.org/ci/gcsupload:latest' locally
Trying to pull repository registry.svc.ci.openshift.org/ci/gcsupload ...
latest: Pulling from registry.svc.ci.openshift.org/ci/gcsupload
a073c86ecf9e: Already exists
cc3fc741b1a9: Already exists
c2227a877946: Pulling fs layer
c2227a877946: Verifying Checksum
c2227a877946: Download complete
c2227a877946: Pull complete
Digest: sha256:4c8023e31711340435b676f7f4486b101825100285e8b6d7c29677ba00233e10
Status: Downloaded newer image for registry.svc.ci.openshift.org/ci/gcsupload:latest
{"component":"gcsupload","level":"info","msg":"Gathering artifacts from artifact directory: /data/gcs/artifacts","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/avc_denials.log in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/avc_denials.log\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/containers.log in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/containers.log\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/dmesg.log in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/dmesg.log\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/docker.config in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/docker.config\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/docker.info in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/docker.info\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/filesystem.info in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/filesystem.info\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/installed_packages.log in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/installed_packages.log\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/master-metrics.log in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/master-metrics.log\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/node-metrics.log in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/node-metrics.log\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/pid1.journal in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/pid1.journal\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/dnsmasq.service in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/journals/dnsmasq.service\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/docker.service in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/journals/docker.service\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/systemd-journald.service in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/journals/systemd-journald.service\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/push-release/logs/scripts.log in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/scripts/push-release/logs/scripts.log\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/shell/logs/scripts.log in artifact directory. Uploading as logs/test_branch_origin_extended_conformance_azure/786/artifacts/scripts/shell/logs/scripts.log\n","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/journals/docker.service","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/scripts/shell/logs/scripts.log","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/avc_denials.log","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/dmesg.log","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/installed_packages.log","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/filesystem.info","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/finished.json","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/containers.log","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/node-metrics.log","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/pid1.journal","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/master-metrics.log","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/journals/dnsmasq.service","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/journals/systemd-journald.service","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/scripts/push-release/logs/scripts.log","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/build-log.txt","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/latest-build.txt","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/docker.config","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/docker.info","level":"info","msg":"Queued for upload","time":"2018-11-22T06:01:42Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/node-metrics.log","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/docker.config","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/installed_packages.log","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/containers.log","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/filesystem.info","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/journals/dnsmasq.service","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/master-metrics.log","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/docker.info","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/journals/systemd-journald.service","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/latest-build.txt","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/scripts/push-release/logs/scripts.log","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/scripts/shell/logs/scripts.log","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/finished.json","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/dmesg.log","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/avc_denials.log","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/build-log.txt","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/generated/pid1.journal","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_conformance_azure/786/artifacts/journals/docker.service","level":"info","msg":"Finished upload","time":"2018-11-22T06:01:43Z"}
{"component":"gcsupload","level":"info","msg":"Finished upload to GCS","time":"2018-11-22T06:01:43Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 06s] ##########
[workspace] $ /bin/bash /tmp/jenkins7039215560151727730.sh
########## STARTING STAGE: HOLD FAILED TEST CLUSTER FOR DEBUG ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: HOLD FAILED TEST CLUSTER FOR DEBUG [00h 00m 00s] ##########
[workspace] $ /bin/bash /tmp/jenkins2868138606389744857.sh
########## STARTING STAGE: DEPROVISION TEST CLUSTER ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ mktemp
+ script=/tmp/tmp.Qh6Azs7CTa
+ cat
+ chmod +x /tmp/tmp.Qh6Azs7CTa
+ scp -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.Qh6Azs7CTa openshiftdevel:/tmp/tmp.Qh6Azs7CTa
+ ssh -F /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.Qh6Azs7CTa"'
+ cd /data/src/github.com/openshift/release
+ trap 'exit 0' EXIT
+ cd cluster/test-deploy/azure
+ TYPE=azure
+ ../../bin/ansible.sh ansible-playbook -e openshift_azure_resource_group_name=ci-test_branch_origin_extended_c_azure-786 playbooks/azure/openshift-cluster/deprovision.yml
PLAY [localhost] ***************************************************************
TASK [delete resource group] ***************************************************
Thursday 22 November 2018 06:01:46 +0000 (0:00:00.075) 0:00:00.075 *****
changed: [localhost]
PLAY RECAP *********************************************************************
localhost : ok=1 changed=1 unreachable=0 failed=0
Thursday 22 November 2018 06:05:19 +0000 (0:03:33.582) 0:03:33.658 *****
===============================================================================
delete resource group ------------------------------------------------- 213.58s
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: DEPROVISION TEST CLUSTER [00h 03m 37s] ##########
[workspace] $ /bin/bash /tmp/jenkins1257342538852354764.sh
########## STARTING STAGE: DELETE PR IMAGES ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
+ trap 'exit 0' EXIT
+ source ./INSTANCE_PREFIX
++ INSTANCE_PREFIX=prtest-e07e3c7-786
++ OS_TAG=b55a046
++ OS_PUSH_BASE_REPO=ci-pr-images/prtest-e07e3c7-786-
+ export KUBECONFIG=/var/lib/jenkins/secrets/image-pr-push.kubeconfig
+ KUBECONFIG=/var/lib/jenkins/secrets/image-pr-push.kubeconfig
+ oc get is -o name -n ci-pr-images
+ grep prtest-e07e3c7-786
+ xargs -r oc delete
imagestream "prtest-e07e3c7-786-origin-base" deleted
imagestream "prtest-e07e3c7-786-origin-cli" deleted
imagestream "prtest-e07e3c7-786-origin-control-plane" deleted
imagestream "prtest-e07e3c7-786-origin-deployer" deleted
imagestream "prtest-e07e3c7-786-origin-docker-builder" deleted
imagestream "prtest-e07e3c7-786-origin-egress-dns-proxy" deleted
imagestream "prtest-e07e3c7-786-origin-egress-http-proxy" deleted
imagestream "prtest-e07e3c7-786-origin-egress-router" deleted
imagestream "prtest-e07e3c7-786-origin-f5-router" deleted
imagestream "prtest-e07e3c7-786-origin-haproxy-router" deleted
imagestream "prtest-e07e3c7-786-origin-hyperkube" deleted
imagestream "prtest-e07e3c7-786-origin-hypershift" deleted
imagestream "prtest-e07e3c7-786-origin-keepalived-ipfailover" deleted
imagestream "prtest-e07e3c7-786-origin-node" deleted
imagestream "prtest-e07e3c7-786-origin-pod" deleted
imagestream "prtest-e07e3c7-786-origin-recycler" deleted
imagestream "prtest-e07e3c7-786-origin-template-service-broker" deleted
imagestream "prtest-e07e3c7-786-origin-tests" deleted
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins6453695871844450856.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config
+ oct deprovision
PLAYBOOK: main.yml *************************************************************
4 plays in /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/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/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:9
skipping: [localhost] => (item=origin_ci_inventory_dir) => {
"changed": false,
"generated_timestamp": "2018-11-22 01:05:24.208083",
"item": "origin_ci_inventory_dir",
"skip_reason": "Conditional check failed",
"skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region) => {
"changed": false,
"generated_timestamp": "2018-11-22 01:05:24.210727",
"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/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:28
included: /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/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/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:2
ok: [localhost] => {
"changed": false,
"generated_timestamp": "2018-11-22 01:05:25.004512",
"msg": ""
}
TASK [rename EC2 instance for termination reaper] ******************************
task path: /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:8
changed: [localhost] => {
"changed": true,
"generated_timestamp": "2018-11-22 01:05:25.631672",
"msg": "Tags {'Name': 'oct-terminate'} created for resource i-090d920d1f9d44890."
}
TASK [tear down the EC2 instance] **********************************************
task path: /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:15
changed: [localhost] => {
"changed": true,
"generated_timestamp": "2018-11-22 01:05:26.715087",
"instance_ids": [
"i-090d920d1f9d44890"
],
"instances": [
{
"ami_launch_index": "0",
"architecture": "x86_64",
"block_device_mapping": {
"/dev/sda1": {
"delete_on_termination": true,
"status": "attached",
"volume_id": "vol-091baabc438bcc44f"
},
"/dev/sdb": {
"delete_on_termination": true,
"status": "attached",
"volume_id": "vol-0467ec4303af8a471"
}
},
"dns_name": "ec2-34-204-98-201.compute-1.amazonaws.com",
"ebs_optimized": false,
"groups": {
"sg-7e73221a": "default"
},
"hypervisor": "xen",
"id": "i-090d920d1f9d44890",
"image_id": "ami-0b77b87a37c3e662c",
"instance_type": "m4.xlarge",
"kernel": null,
"key_name": "libra",
"launch_time": "2018-11-22T05:19:08.000Z",
"placement": "us-east-1d",
"private_dns_name": "ip-172-18-8-27.ec2.internal",
"private_ip": "172.18.8.27",
"public_dns_name": "ec2-34-204-98-201.compute-1.amazonaws.com",
"public_ip": "34.204.98.201",
"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/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:22
changed: [localhost] => {
"changed": true,
"generated_timestamp": "2018-11-22 01:05:26.961660",
"path": "/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.8.27.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/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:61
changed: [localhost] => {
"changed": true,
"generated_timestamp": "2018-11-22 01:05:27.412997",
"path": "/var/lib/jenkins/jobs/test_branch_origin_extended_conformance_azure/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 04s] ##########
Archiving artifacts
Recording test results
[WS-CLEANUP] Deleting project workspace...[WS-CLEANUP] done
Finished: SUCCESS