SuccessConsole Output

Skipping 542 KB.. Full Log
TASK [openshift_sanitize_inventory : Ensure that openshift_use_dnsmasq is true] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.080)       0:03:59.704 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : Ensure that openshift_node_dnsmasq_install_network_manager_hook is true] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.042)       0:03:59.746 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : set_fact] *********************************
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.042)       0:03:59.789 ********* 

TASK [openshift_sanitize_inventory : Ensure that dynamic provisioning is set if using dynamic storage] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.070)       0:03:59.859 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : Ensure the hosted registry's GlusterFS storage is configured correctly] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.049)       0:03:59.909 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : Ensure the hosted registry's GlusterFS storage is configured correctly] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.041)       0:03:59.951 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : Ensure clusterid is set along with the cloudprovider] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.041)       0:03:59.992 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : Ensure ansible_service_broker_remove and ansible_service_broker_install are mutually exclusive] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.043)       0:04:00.036 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : Ensure template_service_broker_remove and template_service_broker_install are mutually exclusive] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.040)       0:04:00.076 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : Ensure that all requires vsphere configuration variables are set] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.040)       0:04:00.117 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : Ensure removed web console extension variables are not set] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.046)       0:04:00.163 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : Ensure that web console port matches API server port] ***
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.040)       0:04:00.203 ********* 
skipping: [40.121.38.74]

TASK [openshift_sanitize_inventory : At least one master is schedulable] *******
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.040)       0:04:00.243 ********* 
skipping: [40.121.38.74]

TASK [Detecting Operating System from ostree_booted] ***************************
Sunday 05 August 2018  15:14:24 +0000 (0:00:00.045)       0:04:00.289 ********* 
ok: [40.121.38.74]

TASK [set openshift_deployment_type if unset] **********************************
Sunday 05 August 2018  15:14:25 +0000 (0:00:00.234)       0:04:00.523 ********* 
skipping: [40.121.38.74]

TASK [initialize_facts set fact openshift_is_atomic and openshift_is_containerized] ***
Sunday 05 August 2018  15:14:25 +0000 (0:00:00.039)       0:04:00.563 ********* 
ok: [40.121.38.74]

TASK [Set use_crio to True if cri-o rpm is requested] **************************
Sunday 05 August 2018  15:14:25 +0000 (0:00:00.065)       0:04:00.629 ********* 
skipping: [40.121.38.74]

TASK [Determine Atomic Host Docker Version] ************************************
Sunday 05 August 2018  15:14:25 +0000 (0:00:00.040)       0:04:00.669 ********* 
skipping: [40.121.38.74]

TASK [assert atomic host docker version is 1.12 or later] **********************
Sunday 05 August 2018  15:14:25 +0000 (0:00:00.039)       0:04:00.709 ********* 
skipping: [40.121.38.74]
 [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 [Install packages necessary for installer] ********************************

TASK [Ensure openshift-ansible installer package deps are installed] ***********
Sunday 05 August 2018  15:14:25 +0000 (0:00:00.054)       0:04:00.764 ********* 
ok: [40.121.38.74] => (item=iproute)
ok: [40.121.38.74] => (item=dbus-python)
changed: [40.121.38.74] => (item=PyYAML)
changed: [40.121.38.74] => (item=python-ipaddress)
changed: [40.121.38.74] => (item=yum-utils)

TASK [Ensure various deps for running system containers are installed] *********
Sunday 05 August 2018  15:14:39 +0000 (0:00:14.435)       0:04:15.200 ********* 
skipping: [40.121.38.74] => (item=atomic) 
skipping: [40.121.38.74] => (item=ostree) 
skipping: [40.121.38.74] => (item=runc) 

PLAY [Initialize cluster facts] ************************************************

TASK [Gather Cluster facts] ****************************************************
Sunday 05 August 2018  15:14:39 +0000 (0:00:00.105)       0:04:15.306 ********* 
changed: [40.121.38.74]

TASK [Set fact of no_proxy_internal_hostnames] *********************************
Sunday 05 August 2018  15:14:40 +0000 (0:00:00.883)       0:04:16.189 ********* 
skipping: [40.121.38.74]

TASK [Initialize openshift.node.sdn_mtu] ***************************************
Sunday 05 August 2018  15:14:40 +0000 (0:00:00.041)       0:04:16.231 ********* 
changed: [40.121.38.74]

PLAY [Initialize etcd host variables] ******************************************
skipping: no hosts matched

PLAY [Determine openshift_version to configure on first master] ****************
skipping: no hosts matched

PLAY [Set openshift_version for etcd, node, and master hosts] ******************
skipping: no hosts matched

PLAY [Ensure the requested version packages are available.] ********************
skipping: no hosts matched

PLAY [Verify Requirements] *****************************************************
skipping: no hosts matched

PLAY [Initialization Checkpoint End] *******************************************

TASK [Set install initialization 'Complete'] ***********************************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.474)       0:04:16.705 ********* 
ok: [{}]

PLAY [Validate node hostnames] *************************************************

TASK [Query DNS for IP address of vm.lxq11h2hskxujagn103bwoj4kg.bx.internal.cloudapp.net] ***
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.078)       0:04:16.784 ********* 
skipping: [40.121.38.74]

TASK [Validate openshift_hostname when defined] ********************************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.040)       0:04:16.824 ********* 
skipping: [40.121.38.74]

TASK [Validate openshift_ip exists on node when defined] ***********************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.040)       0:04:16.864 ********* 
skipping: [40.121.38.74]

PLAY [Setup yum repositories for all hosts] ************************************

TASK [rhel_subscribe : fail] ***************************************************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.053)       0:04:16.918 ********* 
skipping: [40.121.38.74]

TASK [rhel_subscribe : Install Red Hat Subscription manager] *******************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.041)       0:04:16.959 ********* 
skipping: [40.121.38.74]

TASK [rhel_subscribe : Is host already registered?] ****************************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.041)       0:04:17.001 ********* 
skipping: [40.121.38.74]

TASK [rhel_subscribe : Register host] ******************************************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.041)       0:04:17.042 ********* 
skipping: [40.121.38.74]

TASK [rhel_subscribe : fail] ***************************************************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.040)       0:04:17.083 ********* 
skipping: [40.121.38.74]

TASK [rhel_subscribe : Determine if OpenShift Pool Already Attached] ***********
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.039)       0:04:17.123 ********* 
skipping: [40.121.38.74]

TASK [rhel_subscribe : Attach to OpenShift Pool] *******************************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.041)       0:04:17.164 ********* 
skipping: [40.121.38.74]

TASK [rhel_subscribe : include_tasks] ******************************************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.046)       0:04:17.211 ********* 
skipping: [40.121.38.74]

TASK [openshift_repos : openshift_repos detect ostree] *************************
Sunday 05 August 2018  15:14:41 +0000 (0:00:00.041)       0:04:17.252 ********* 
ok: [40.121.38.74]

TASK [openshift_repos : Ensure libselinux-python is installed] *****************
Sunday 05 August 2018  15:14:42 +0000 (0:00:00.211)       0:04:17.463 ********* 
ok: [40.121.38.74]

TASK [openshift_repos : Remove openshift_additional.repo file] *****************
Sunday 05 August 2018  15:14:42 +0000 (0:00:00.423)       0:04:17.887 ********* 
ok: [40.121.38.74]

TASK [openshift_repos : Create any additional repos that are defined] **********
Sunday 05 August 2018  15:14:42 +0000 (0:00:00.229)       0:04:18.117 ********* 
ok: [40.121.38.74] => (item={u'gpgkey': u'file:///etc/pki/rpm-gpg/RPM-GPG-KEY-CentOS-SIG-PaaS', u'enabled': True, u'name': u'openshift-origin39', u'baseurl': u'http://mirror.centos.org/centos/7/paas/x86_64/openshift-origin39/'})
ok: [40.121.38.74] => (item={'gpgcheck': False, 'enabled': True, 'name': u'install_repo', 'baseurl': u'https://storage.googleapis.com/origin-ci-test/pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/203/artifacts/rpms'})

TASK [openshift_repos : include_tasks] *****************************************
Sunday 05 August 2018  15:14:43 +0000 (0:00:00.452)       0:04:18.570 ********* 
skipping: [40.121.38.74]

TASK [openshift_repos : include_tasks] *****************************************
Sunday 05 August 2018  15:14:43 +0000 (0:00:00.049)       0:04:18.619 ********* 
skipping: [40.121.38.74]

TASK [openshift_repos : Ensure clean repo cache in the event repos have been changed manually] ***
Sunday 05 August 2018  15:14:43 +0000 (0:00:00.057)       0:04:18.677 ********* 
changed: [40.121.38.74] => {
    "msg": "First run of openshift_repos"
}

TASK [openshift_repos : Record that openshift_repos already ran] ***************
Sunday 05 August 2018  15:14:43 +0000 (0:00:00.071)       0:04:18.749 ********* 
ok: [40.121.38.74]

RUNNING HANDLER [openshift_repos : refresh cache] ******************************
Sunday 05 August 2018  15:14:43 +0000 (0:00:00.044)       0:04:18.793 ********* 
changed: [40.121.38.74]

PLAY [Configure os_firewall] ***************************************************

TASK [os_firewall : Detecting Atomic Host Operating System] ********************
Sunday 05 August 2018  15:14:43 +0000 (0:00:00.471)       0:04:19.264 ********* 
ok: [40.121.38.74]

TASK [os_firewall : Set fact r_os_firewall_is_atomic] **************************
Sunday 05 August 2018  15:14:44 +0000 (0:00:00.224)       0:04:19.489 ********* 
ok: [40.121.38.74]

TASK [os_firewall : include_tasks] *********************************************
Sunday 05 August 2018  15:14:44 +0000 (0:00:00.064)       0:04:19.554 ********* 
skipping: [40.121.38.74]

TASK [os_firewall : include_tasks] *********************************************
Sunday 05 August 2018  15:14:44 +0000 (0:00:00.045)       0:04:19.600 ********* 
included: /usr/share/ansible/openshift-ansible/roles/os_firewall/tasks/iptables.yml for 40.121.38.74

TASK [os_firewall : Ensure firewalld service is not enabled] *******************
Sunday 05 August 2018  15:14:44 +0000 (0:00:00.082)       0:04:19.682 ********* 
changed: [40.121.38.74]

TASK [os_firewall : Wait 10 seconds after disabling firewalld] *****************
Sunday 05 August 2018  15:14:45 +0000 (0:00:01.234)       0:04:20.917 ********* 
Pausing for 10 seconds
(ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)
ok: [40.121.38.74]

TASK [os_firewall : Install iptables packages] *********************************
Sunday 05 August 2018  15:14:55 +0000 (0:00:10.066)       0:04:30.984 ********* 
ok: [40.121.38.74] => (item=iptables)
changed: [40.121.38.74] => (item=iptables-services)

TASK [os_firewall : Start and enable iptables service] *************************
Sunday 05 August 2018  15:15:02 +0000 (0:00:06.643)       0:04:37.628 ********* 
changed: [40.121.38.74 -> 40.121.38.74] => (item=40.121.38.74)

TASK [os_firewall : need to pause here, otherwise the iptables service starting can sometimes cause ssh to fail] ***
Sunday 05 August 2018  15:15:02 +0000 (0:00:00.493)       0:04:38.121 ********* 
Pausing for 10 seconds
(ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)
ok: [40.121.38.74]

PLAY [create oo_hosts_containerized_managed_true host group] *******************
skipping: no hosts matched
 [WARNING]: Could not match supplied host pattern, ignoring:
oo_hosts_containerized_managed_true

PLAY [oo_nodes_to_config:oo_hosts_containerized_managed_true] ******************

TASK [container_runtime : Setup the docker-storage for overlay] ****************
Sunday 05 August 2018  15:15:12 +0000 (0:00:10.122)       0:04:48.243 ********* 
skipping: [40.121.38.74]

PLAY [create oo_hosts_containerized_managed_true host group] *******************
skipping: no hosts matched

PLAY [oo_nodes_to_config:oo_hosts_containerized_managed_true] ******************

TASK [openshift_excluder : Install excluders] **********************************
Sunday 05 August 2018  15:15:12 +0000 (0:00:00.063)       0:04:48.307 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/install.yml for 40.121.38.74

TASK [openshift_excluder : Install docker excluder - yum] **********************
Sunday 05 August 2018  15:15:12 +0000 (0:00:00.071)       0:04:48.378 ********* 
changed: [40.121.38.74]

TASK [openshift_excluder : Install docker excluder - dnf] **********************
Sunday 05 August 2018  15:15:15 +0000 (0:00:02.983)       0:04:51.362 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Install openshift excluder - yum] *******************
Sunday 05 August 2018  15:15:15 +0000 (0:00:00.054)       0:04:51.416 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Install openshift excluder - dnf] *******************
Sunday 05 August 2018  15:15:16 +0000 (0:00:00.047)       0:04:51.464 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : set_fact] *******************************************
Sunday 05 August 2018  15:15:16 +0000 (0:00:00.048)       0:04:51.512 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : Enable excluders] ***********************************
Sunday 05 August 2018  15:15:16 +0000 (0:00:00.069)       0:04:51.581 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/exclude.yml for 40.121.38.74

TASK [openshift_excluder : Check for docker-excluder] **************************
Sunday 05 August 2018  15:15:16 +0000 (0:00:00.069)       0:04:51.651 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : Enable docker excluder] *****************************
Sunday 05 August 2018  15:15:16 +0000 (0:00:00.288)       0:04:51.940 ********* 
changed: [40.121.38.74]

TASK [openshift_excluder : Check for openshift excluder] ***********************
Sunday 05 August 2018  15:15:16 +0000 (0:00:00.262)       0:04:52.202 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : Enable openshift excluder] **************************
Sunday 05 August 2018  15:15:16 +0000 (0:00:00.225)       0:04:52.428 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:15:17 +0000 (0:00:00.043)       0:04:52.471 ********* 
included: /usr/share/ansible/openshift-ansible/roles/container_runtime/tasks/common/pre.yml for 40.121.38.74

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:15:17 +0000 (0:00:00.077)       0:04:52.549 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Add enterprise registry, if necessary] ***************
Sunday 05 August 2018  15:15:17 +0000 (0:00:00.047)       0:04:52.597 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:15:17 +0000 (0:00:00.051)       0:04:52.649 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Get current installed Docker version] ****************
Sunday 05 August 2018  15:15:17 +0000 (0:00:00.049)       0:04:52.699 ********* 
ok: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:15:17 +0000 (0:00:00.481)       0:04:53.180 ********* 
included: /usr/share/ansible/openshift-ansible/roles/container_runtime/tasks/docker_sanity.yml for 40.121.38.74

TASK [container_runtime : Error out if Docker pre-installed but too old] *******
Sunday 05 August 2018  15:15:17 +0000 (0:00:00.079)       0:04:53.260 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Error out if requested Docker is too old] ************
Sunday 05 August 2018  15:15:17 +0000 (0:00:00.054)       0:04:53.315 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Fail if Docker version requested but downgrade is required] ***
Sunday 05 August 2018  15:15:17 +0000 (0:00:00.048)       0:04:53.363 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Error out if attempting to upgrade Docker across the 1.10 boundary] ***
Sunday 05 August 2018  15:15:17 +0000 (0:00:00.049)       0:04:53.413 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Install Docker] **************************************
Sunday 05 August 2018  15:15:18 +0000 (0:00:00.049)       0:04:53.463 ********* 
changed: [40.121.38.74]

TASK [container_runtime : Ensure docker.service.d directory exists] ************
Sunday 05 August 2018  15:16:10 +0000 (0:00:52.469)       0:05:45.932 ********* 
changed: [40.121.38.74]

TASK [container_runtime : Configure Docker service unit file] ******************
Sunday 05 August 2018  15:16:10 +0000 (0:00:00.246)       0:05:46.178 ********* 
changed: [40.121.38.74]

TASK [container_runtime : stat] ************************************************
Sunday 05 August 2018  15:16:11 +0000 (0:00:00.851)       0:05:47.030 ********* 
ok: [40.121.38.74]

TASK [container_runtime : Set registry params] *********************************
Sunday 05 August 2018  15:16:11 +0000 (0:00:00.286)       0:05:47.316 ********* 
skipping: [40.121.38.74] => (item={u'reg_conf_var': u'ADD_REGISTRY', u'reg_flag': u'--add-registry', u'reg_fact_val': []}) 
skipping: [40.121.38.74] => (item={u'reg_conf_var': u'BLOCK_REGISTRY', u'reg_flag': u'--block-registry', u'reg_fact_val': []}) 
skipping: [40.121.38.74] => (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] ***
Sunday 05 August 2018  15:16:11 +0000 (0:00:00.112)       0:05:47.429 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Set Proxy Settings] **********************************
Sunday 05 August 2018  15:16:12 +0000 (0:00:00.048)       0:05:47.478 ********* 
skipping: [40.121.38.74] => (item={u'reg_conf_var': u'HTTP_PROXY', u'reg_fact_val': u''}) 
skipping: [40.121.38.74] => (item={u'reg_conf_var': u'HTTPS_PROXY', u'reg_fact_val': u''}) 
skipping: [40.121.38.74] => (item={u'reg_conf_var': u'NO_PROXY', u'reg_fact_val': u''}) 

TASK [container_runtime : Set various Docker options] **************************
Sunday 05 August 2018  15:16:12 +0000 (0:00:00.123)       0:05:47.601 ********* 
changed: [40.121.38.74]

TASK [container_runtime : stat] ************************************************
Sunday 05 August 2018  15:16:12 +0000 (0:00:00.535)       0:05:48.136 ********* 
ok: [40.121.38.74]

TASK [container_runtime : Configure Docker Network OPTIONS] ********************
Sunday 05 August 2018  15:16:12 +0000 (0:00:00.281)       0:05:48.418 ********* 
changed: [40.121.38.74]

TASK [container_runtime : Detect if docker is already started] *****************
Sunday 05 August 2018  15:16:13 +0000 (0:00:00.314)       0:05:48.732 ********* 
ok: [40.121.38.74]

TASK [container_runtime : Start the Docker service] ****************************
Sunday 05 August 2018  15:16:13 +0000 (0:00:00.252)       0:05:48.985 ********* 
changed: [40.121.38.74]

TASK [container_runtime : set_fact] ********************************************
Sunday 05 August 2018  15:16:16 +0000 (0:00:02.616)       0:05:51.601 ********* 
ok: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:16 +0000 (0:00:00.072)       0:05:51.674 ********* 
included: /usr/share/ansible/openshift-ansible/roles/container_runtime/tasks/common/post.yml for 40.121.38.74

TASK [container_runtime : Ensure /var/lib/containers exists] *******************
Sunday 05 August 2018  15:16:16 +0000 (0:00:00.086)       0:05:51.760 ********* 
changed: [40.121.38.74]

TASK [container_runtime : Fix SELinux Permissions on /var/lib/containers] ******
Sunday 05 August 2018  15:16:16 +0000 (0:00:00.254)       0:05:52.015 ********* 
ok: [40.121.38.74]

RUNNING HANDLER [container_runtime : restart container runtime] ****************
Sunday 05 August 2018  15:16:16 +0000 (0:00:00.209)       0:05:52.224 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:16 +0000 (0:00:00.069)       0:05:52.294 ********* 
included: /usr/share/ansible/openshift-ansible/roles/container_runtime/tasks/registry_auth.yml for 40.121.38.74

TASK [container_runtime : Check for credentials file for registry auth] ********
Sunday 05 August 2018  15:16:16 +0000 (0:00:00.081)       0:05:52.375 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Create credentials for docker cli registry auth] *****
Sunday 05 August 2018  15:16:16 +0000 (0:00:00.048)       0:05:52.423 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Create credentials for docker cli registry auth (alternative)] ***
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.049)       0:05:52.473 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : stat the docker data dir] ****************************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.047)       0:05:52.521 ********* 
ok: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.241)       0:05:52.762 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Fail quickly if openshift_docker_options are set] ****
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.047)       0:05:52.810 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.046)       0:05:52.856 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.042)       0:05:52.898 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Install Docker so we can use the client] *************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.043)       0:05:52.942 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Disable Docker] **************************************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.043)       0:05:52.985 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Ensure proxies are in the atomic.conf] ***************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.042)       0:05:53.028 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : debug] ***********************************************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.041)       0:05:53.070 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.046)       0:05:53.116 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Pre-pull Container Engine System Container image] ****
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.044)       0:05:53.161 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Ensure container-engine.service.d directory exists] ***
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.043)       0:05:53.204 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Ensure /etc/docker directory exists] *****************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.042)       0:05:53.246 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Install Container Engine System Container] ***********
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.041)       0:05:53.288 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Configure Container Engine Service File] *************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.041)       0:05:53.330 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Configure Container Engine] **************************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.041)       0:05:53.372 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Start the container-engine service] ******************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.047)       0:05:53.419 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : set_fact] ********************************************
Sunday 05 August 2018  15:16:17 +0000 (0:00:00.043)       0:05:53.462 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.044)       0:05:53.506 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Check we are not using node as a Docker container with CRI-O] ***
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.041)       0:05:53.548 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.042)       0:05:53.591 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.042)       0:05:53.634 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Check that overlay is in the kernel] *****************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.043)       0:05:53.678 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Add overlay to modprobe.d] ***************************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.043)       0:05:53.721 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Manually modprobe overlay into the kernel] ***********
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.043)       0:05:53.764 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Enable and start systemd-modules-load] ***************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.045)       0:05:53.809 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Ensure proxies are in the atomic.conf] ***************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.043)       0:05:53.853 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : debug] ***********************************************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.042)       0:05:53.896 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Pre-pull CRI-O System Container image] ***************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.044)       0:05:53.940 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Install CRI-O System Container] **********************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.048)       0:05:53.988 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Remove CRI-O default configuration files] ************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.043)       0:05:54.031 ********* 
skipping: [40.121.38.74] => (item=/etc/cni/net.d/200-loopback.conf) 
skipping: [40.121.38.74] => (item=/etc/cni/net.d/100-crio-bridge.conf) 

TASK [container_runtime : Create the CRI-O configuration] **********************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.053)       0:05:54.085 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Ensure CNI configuration directory exists] ***********
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.043)       0:05:54.129 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Add iptables allow rules] ****************************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.043)       0:05:54.172 ********* 
skipping: [40.121.38.74] => (item={u'port': u'10010/tcp', u'service': u'crio'}) 

TASK [container_runtime : Remove iptables rules] *******************************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.050)       0:05:54.223 ********* 

TASK [container_runtime : Add firewalld allow rules] ***************************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.042)       0:05:54.266 ********* 
skipping: [40.121.38.74] => (item={u'port': u'10010/tcp', u'service': u'crio'}) 

TASK [container_runtime : Remove firewalld allow rules] ************************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.052)       0:05:54.318 ********* 

TASK [container_runtime : Configure the CNI network] ***************************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.042)       0:05:54.360 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Create /etc/sysconfig/crio-storage] ******************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.044)       0:05:54.404 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Create /etc/sysconfig/crio-network] ******************
Sunday 05 August 2018  15:16:18 +0000 (0:00:00.042)       0:05:54.447 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : debug] ***********************************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.043)       0:05:54.491 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Start the CRI-O service] *****************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.043)       0:05:54.534 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.050)       0:05:54.585 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Fail if Atomic Host since this is an rpm request] ****
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.043)       0:05:54.628 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.043)       0:05:54.671 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Check that overlay is in the kernel] *****************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.044)       0:05:54.716 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Add overlay to modprobe.d] ***************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.043)       0:05:54.759 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Manually modprobe overlay into the kernel] ***********
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.042)       0:05:54.802 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Enable and start systemd-modules-load] ***************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.044)       0:05:54.846 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Install cri-o] ***************************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.118)       0:05:54.965 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Remove CRI-O default configuration files] ************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.044)       0:05:55.009 ********* 
skipping: [40.121.38.74] => (item=/etc/cni/net.d/200-loopback.conf) 
skipping: [40.121.38.74] => (item=/etc/cni/net.d/100-crio-bridge.conf) 

TASK [container_runtime : Create the CRI-O configuration] **********************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.053)       0:05:55.062 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Ensure CNI configuration directory exists] ***********
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.041)       0:05:55.103 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Add iptables allow rules] ****************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.041)       0:05:55.145 ********* 
skipping: [40.121.38.74] => (item={u'port': u'10010/tcp', u'service': u'crio'}) 

TASK [container_runtime : Remove iptables rules] *******************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.050)       0:05:55.195 ********* 

TASK [container_runtime : Add firewalld allow rules] ***************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.044)       0:05:55.240 ********* 
skipping: [40.121.38.74] => (item={u'port': u'10010/tcp', u'service': u'crio'}) 

TASK [container_runtime : Remove firewalld allow rules] ************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.050)       0:05:55.291 ********* 

TASK [container_runtime : Configure the CNI network] ***************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.040)       0:05:55.332 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Create /etc/sysconfig/crio-network] ******************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.041)       0:05:55.374 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : Start the CRI-O service] *****************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.042)       0:05:55.416 ********* 
skipping: [40.121.38.74]

TASK [container_runtime : include_tasks] ***************************************
Sunday 05 August 2018  15:16:19 +0000 (0:00:00.042)       0:05:55.459 ********* 
skipping: [40.121.38.74]

PLAY [Determine openshift_version to configure on first master] ****************

TASK [include_role : openshift_version] ****************************************
Sunday 05 August 2018  15:16:20 +0000 (0:00:00.056)       0:05:55.516 ********* 

TASK [openshift_version : Use openshift.common.version fact as version to configure if already installed] ***
Sunday 05 August 2018  15:16:20 +0000 (0:00:00.093)       0:05:55.609 ********* 
skipping: [40.121.38.74]

TASK [openshift_version : include_tasks] ***************************************
Sunday 05 August 2018  15:16:20 +0000 (0:00:00.041)       0:05:55.651 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_version/tasks/first_master_rpm_version.yml for 40.121.38.74

TASK [openshift_version : Set rpm version to configure if openshift_pkg_version specified] ***
Sunday 05 August 2018  15:16:20 +0000 (0:00:00.072)       0:05:55.724 ********* 
skipping: [40.121.38.74]

TASK [openshift_version : Set openshift_version for rpm installation] **********
Sunday 05 August 2018  15:16:20 +0000 (0:00:00.041)       0:05:55.766 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_version/tasks/check_available_rpms.yml for 40.121.38.74

TASK [openshift_version : Get available RPM version] ***************************
Sunday 05 August 2018  15:16:20 +0000 (0:00:00.069)       0:05:55.835 ********* 
ok: [40.121.38.74]

TASK [openshift_version : fail] ************************************************
Sunday 05 August 2018  15:16:22 +0000 (0:00:01.843)       0:05:57.679 ********* 
skipping: [40.121.38.74]

TASK [openshift_version : set_fact] ********************************************
Sunday 05 August 2018  15:16:22 +0000 (0:00:00.044)       0:05:57.723 ********* 
ok: [40.121.38.74]

TASK [openshift_version : debug] ***********************************************
Sunday 05 August 2018  15:16:22 +0000 (0:00:00.069)       0:05:57.792 ********* 
ok: [40.121.38.74] => {
    "msg": "openshift_pkg_version was not defined. Falling back to -3.9.0"
}

TASK [openshift_version : set_fact] ********************************************
Sunday 05 August 2018  15:16:22 +0000 (0:00:00.064)       0:05:57.857 ********* 
ok: [40.121.38.74]

TASK [openshift_version : debug] ***********************************************
Sunday 05 August 2018  15:16:22 +0000 (0:00:00.064)       0:05:57.922 ********* 
ok: [40.121.38.74] => {
    "msg": "openshift_image_tag was not defined. Falling back to v3.9.0"
}

TASK [openshift_version : set_fact] ********************************************
Sunday 05 August 2018  15:16:22 +0000 (0:00:00.065)       0:05:57.987 ********* 
ok: [40.121.38.74]

TASK [openshift_version : debug] ***********************************************
Sunday 05 August 2018  15:16:22 +0000 (0:00:00.064)       0:05:58.052 ********* 
ok: [40.121.38.74] => {
    "openshift_release": "VARIABLE IS NOT DEFINED!"
}

TASK [openshift_version : debug] ***********************************************
Sunday 05 August 2018  15:16:22 +0000 (0:00:00.062)       0:05:58.114 ********* 
ok: [40.121.38.74] => {
    "openshift_image_tag": "v3.9.0"
}

TASK [openshift_version : debug] ***********************************************
Sunday 05 August 2018  15:16:22 +0000 (0:00:00.065)       0:05:58.180 ********* 
ok: [40.121.38.74] => {
    "openshift_pkg_version": "-3.9.0"
}

TASK [openshift_version : debug] ***********************************************
Sunday 05 August 2018  15:16:22 +0000 (0:00:00.060)       0:05:58.241 ********* 
ok: [40.121.38.74] => {
    "openshift_version": "3.9.0"
}

PLAY [Set openshift_version for etcd, node, and master hosts] ******************
skipping: no hosts matched

PLAY [Ensure the requested version packages are available.] ********************
skipping: no hosts matched

PLAY [Disable excluders] *******************************************************

TASK [openshift_excluder : Detecting Atomic Host Operating System] *************
Sunday 05 August 2018  15:16:22 +0000 (0:00:00.076)       0:05:58.317 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : Debug r_openshift_excluder_enable_docker_excluder] ***
Sunday 05 August 2018  15:16:23 +0000 (0:00:00.231)       0:05:58.548 ********* 
ok: [40.121.38.74] => {
    "r_openshift_excluder_enable_docker_excluder": true
}

TASK [openshift_excluder : Debug r_openshift_excluder_enable_openshift_excluder] ***
Sunday 05 August 2018  15:16:23 +0000 (0:00:00.072)       0:05:58.621 ********* 
ok: [40.121.38.74] => {
    "r_openshift_excluder_enable_openshift_excluder": true
}

TASK [openshift_excluder : Fail if invalid openshift_excluder_action provided] ***
Sunday 05 August 2018  15:16:23 +0000 (0:00:00.073)       0:05:58.695 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Fail if r_openshift_excluder_upgrade_target is not defined] ***
Sunday 05 August 2018  15:16:23 +0000 (0:00:00.045)       0:05:58.741 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Include main action task file] **********************
Sunday 05 August 2018  15:16:23 +0000 (0:00:00.045)       0:05:58.787 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/disable.yml for 40.121.38.74

TASK [openshift_excluder : Include verify_upgrade.yml when upgrading] **********
Sunday 05 August 2018  15:16:23 +0000 (0:00:00.085)       0:05:58.873 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Disable excluders before the upgrade to remove older excluding expressions] ***
Sunday 05 August 2018  15:16:23 +0000 (0:00:00.047)       0:05:58.920 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/unexclude.yml for 40.121.38.74

TASK [openshift_excluder : Check for docker-excluder] **************************
Sunday 05 August 2018  15:16:23 +0000 (0:00:00.076)       0:05:58.997 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : disable docker excluder] ****************************
Sunday 05 August 2018  15:16:23 +0000 (0:00:00.247)       0:05:59.244 ********* 
changed: [40.121.38.74]

TASK [openshift_excluder : Check for openshift excluder] ***********************
Sunday 05 August 2018  15:16:24 +0000 (0:00:00.268)       0:05:59.513 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : disable openshift excluder] *************************
Sunday 05 August 2018  15:16:24 +0000 (0:00:00.226)       0:05:59.739 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Include install.yml] ********************************
Sunday 05 August 2018  15:16:24 +0000 (0:00:00.054)       0:05:59.794 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/install.yml for 40.121.38.74

TASK [openshift_excluder : Install docker excluder - yum] **********************
Sunday 05 August 2018  15:16:24 +0000 (0:00:00.080)       0:05:59.875 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Install docker excluder - dnf] **********************
Sunday 05 August 2018  15:16:24 +0000 (0:00:00.049)       0:05:59.925 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Install openshift excluder - yum] *******************
Sunday 05 August 2018  15:16:24 +0000 (0:00:00.052)       0:05:59.977 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Install openshift excluder - dnf] *******************
Sunday 05 August 2018  15:16:24 +0000 (0:00:00.051)       0:06:00.028 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : set_fact] *******************************************
Sunday 05 August 2018  15:16:24 +0000 (0:00:00.051)       0:06:00.080 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Include exclude.yml] ********************************
Sunday 05 August 2018  15:16:24 +0000 (0:00:00.050)       0:06:00.130 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/exclude.yml for 40.121.38.74

TASK [openshift_excluder : Check for docker-excluder] **************************
Sunday 05 August 2018  15:16:24 +0000 (0:00:00.080)       0:06:00.211 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : Enable docker excluder] *****************************
Sunday 05 August 2018  15:16:25 +0000 (0:00:00.474)       0:06:00.685 ********* 
changed: [40.121.38.74]

TASK [openshift_excluder : Check for openshift excluder] ***********************
Sunday 05 August 2018  15:16:25 +0000 (0:00:00.285)       0:06:00.970 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : Enable openshift excluder] **************************
Sunday 05 August 2018  15:16:25 +0000 (0:00:00.218)       0:06:01.189 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Include unexclude.yml] ******************************
Sunday 05 August 2018  15:16:25 +0000 (0:00:00.053)       0:06:01.242 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/unexclude.yml for 40.121.38.74

TASK [openshift_excluder : Check for docker-excluder] **************************
Sunday 05 August 2018  15:16:25 +0000 (0:00:00.084)       0:06:01.327 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : disable docker excluder] ****************************
Sunday 05 August 2018  15:16:26 +0000 (0:00:00.235)       0:06:01.563 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Check for openshift excluder] ***********************
Sunday 05 August 2018  15:16:26 +0000 (0:00:00.048)       0:06:01.611 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : disable openshift excluder] *************************
Sunday 05 August 2018  15:16:26 +0000 (0:00:00.230)       0:06:01.842 ********* 
skipping: [40.121.38.74]

PLAY [Evaluate node groups] ****************************************************

TASK [Gathering Facts] *********************************************************
Sunday 05 August 2018  15:16:26 +0000 (0:00:00.044)       0:06:01.886 ********* 
ok: [localhost]

TASK [Evaluate oo_containerized_master_nodes] **********************************
Sunday 05 August 2018  15:16:35 +0000 (0:00:08.906)       0:06:10.792 ********* 
skipping: [localhost] => (item=40.121.38.74) 
 [WARNING]: Could not match supplied host pattern, ignoring:
oo_containerized_master_nodes

PLAY [Configure nodes] *********************************************************

TASK [openshift_clock : Determine if chrony is installed] **********************
Sunday 05 August 2018  15:16:35 +0000 (0:00:00.166)       0:06:10.959 ********* 
changed: [40.121.38.74]
 [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 [openshift_clock : Install ntp package] ***********************************
Sunday 05 August 2018  15:16:35 +0000 (0:00:00.298)       0:06:11.257 ********* 
skipping: [40.121.38.74]

TASK [openshift_clock : Start and enable ntpd/chronyd] *************************
Sunday 05 August 2018  15:16:35 +0000 (0:00:00.046)       0:06:11.304 ********* 
changed: [40.121.38.74]

TASK [openshift_cloud_provider : Set cloud provider facts] *********************
Sunday 05 August 2018  15:16:36 +0000 (0:00:00.375)       0:06:11.679 ********* 
skipping: [40.121.38.74]

TASK [openshift_cloud_provider : Create cloudprovider config dir] **************
Sunday 05 August 2018  15:16:36 +0000 (0:00:00.044)       0:06:11.724 ********* 
skipping: [40.121.38.74]

TASK [openshift_cloud_provider : include the defined cloud provider files] *****
Sunday 05 August 2018  15:16:36 +0000 (0:00:00.044)       0:06:11.768 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : fail] ***************************************************
Sunday 05 August 2018  15:16:36 +0000 (0:00:00.043)       0:06:11.812 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Check for NetworkManager service] ***********************
Sunday 05 August 2018  15:16:36 +0000 (0:00:00.044)       0:06:11.857 ********* 
ok: [40.121.38.74]

TASK [openshift_node : Set fact using_network_manager] *************************
Sunday 05 August 2018  15:16:36 +0000 (0:00:00.278)       0:06:12.136 ********* 
ok: [40.121.38.74]

TASK [openshift_node : Install dnsmasq] ****************************************
Sunday 05 August 2018  15:16:36 +0000 (0:00:00.066)       0:06:12.202 ********* 
changed: [40.121.38.74]

TASK [openshift_node : ensure origin/node directory exists] ********************
Sunday 05 August 2018  15:16:43 +0000 (0:00:06.546)       0:06:18.749 ********* 
changed: [40.121.38.74] => (item=/etc/origin)
changed: [40.121.38.74] => (item=/etc/origin/node)

TASK [openshift_node : Install node-dnsmasq.conf] ******************************
Sunday 05 August 2018  15:16:43 +0000 (0:00:00.559)       0:06:19.308 ********* 
changed: [40.121.38.74]

TASK [openshift_node : fail] ***************************************************
Sunday 05 August 2018  15:16:44 +0000 (0:00:00.641)       0:06:19.949 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Install NetworkManager during node_bootstrap provisioning] ***
Sunday 05 August 2018  15:16:44 +0000 (0:00:00.045)       0:06:19.995 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Install network manager dispatch script] ****************
Sunday 05 August 2018  15:16:44 +0000 (0:00:00.043)       0:06:20.039 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Add network manager configuration] **********************
Sunday 05 August 2018  15:16:44 +0000 (0:00:00.043)       0:06:20.082 ********* 
skipping: [40.121.38.74] => (item={u'key': u'dns', u'value': u'none', u'present': False}) 

TASK [openshift_node : Install dnsmasq configuration] **************************
Sunday 05 August 2018  15:16:44 +0000 (0:00:00.054)       0:06:20.137 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Deploy additional dnsmasq.conf] *************************
Sunday 05 August 2018  15:16:45 +0000 (0:00:00.680)       0:06:20.818 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Enable dnsmasq] *****************************************
Sunday 05 August 2018  15:16:45 +0000 (0:00:00.048)       0:06:20.866 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Install network manager dispatch script] ****************
Sunday 05 August 2018  15:16:45 +0000 (0:00:00.366)       0:06:21.233 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Add network manager configuration] **********************
Sunday 05 August 2018  15:16:46 +0000 (0:00:00.672)       0:06:21.905 ********* 
ok: [40.121.38.74] => (item={u'key': u'dns', u'value': u'none', u'present': False})

RUNNING HANDLER [openshift_node : restart NetworkManager] **********************
Sunday 05 August 2018  15:16:46 +0000 (0:00:00.401)       0:06:22.306 ********* 
skipping: [40.121.38.74]

RUNNING HANDLER [openshift_node : restart dnsmasq] *****************************
Sunday 05 August 2018  15:16:46 +0000 (0:00:00.042)       0:06:22.349 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Add iptables allow rules] *******************************
Sunday 05 August 2018  15:16:46 +0000 (0:00:00.068)       0:06:22.418 ********* 
changed: [40.121.38.74] => (item={u'port': u'10250/tcp', u'service': u'Kubernetes kubelet'})
changed: [40.121.38.74] => (item={u'port': u'10256/tcp', u'service': u'Kubernetes kube-proxy health check for service load balancers'})
changed: [40.121.38.74] => (item={u'port': u'80/tcp', u'service': u'http'})
changed: [40.121.38.74] => (item={u'port': u'443/tcp', u'service': u'https'})
changed: [40.121.38.74] => (item={u'cond': u'openshift_use_openshift_sdn | bool', u'port': u'4789/udp', u'service': u'OpenShift OVS sdn'})
skipping: [40.121.38.74] => (item={u'cond': False, u'port': u'179/tcp', u'service': u'Calico BGP Port'}) 
skipping: [40.121.38.74] => (item={u'cond': False, u'port': u'/tcp', u'service': u'Kubernetes service NodePort TCP'}) 
skipping: [40.121.38.74] => (item={u'cond': False, u'port': u'/udp', u'service': u'Kubernetes service NodePort UDP'}) 
changed: [40.121.38.74] => (item={u'port': u'9000-10000/tcp', u'service': u'Prometheus monitoring'})

TASK [openshift_node : Remove iptables rules] **********************************
Sunday 05 August 2018  15:16:49 +0000 (0:00:02.069)       0:06:24.487 ********* 

TASK [openshift_node : Add firewalld allow rules] ******************************
Sunday 05 August 2018  15:16:49 +0000 (0:00:00.042)       0:06:24.529 ********* 
skipping: [40.121.38.74] => (item={u'port': u'10250/tcp', u'service': u'Kubernetes kubelet'}) 
skipping: [40.121.38.74] => (item={u'port': u'10256/tcp', u'service': u'Kubernetes kube-proxy health check for service load balancers'}) 
skipping: [40.121.38.74] => (item={u'port': u'80/tcp', u'service': u'http'}) 
skipping: [40.121.38.74] => (item={u'port': u'443/tcp', u'service': u'https'}) 
skipping: [40.121.38.74] => (item={u'cond': u'openshift_use_openshift_sdn | bool', u'port': u'4789/udp', u'service': u'OpenShift OVS sdn'}) 
skipping: [40.121.38.74] => (item={u'cond': False, u'port': u'179/tcp', u'service': u'Calico BGP Port'}) 
skipping: [40.121.38.74] => (item={u'cond': False, u'port': u'/tcp', u'service': u'Kubernetes service NodePort TCP'}) 
skipping: [40.121.38.74] => (item={u'cond': False, u'port': u'/udp', u'service': u'Kubernetes service NodePort UDP'}) 
skipping: [40.121.38.74] => (item={u'port': u'9000-10000/tcp', u'service': u'Prometheus monitoring'}) 

TASK [openshift_node : Remove firewalld allow rules] ***************************
Sunday 05 August 2018  15:16:49 +0000 (0:00:00.157)       0:06:24.687 ********* 

TASK [openshift_node : Checking for journald.conf] *****************************
Sunday 05 August 2018  15:16:49 +0000 (0:00:00.040)       0:06:24.727 ********* 
ok: [40.121.38.74]

TASK [openshift_node : Create journald persistence directories] ****************
Sunday 05 August 2018  15:16:49 +0000 (0:00:00.266)       0:06:24.994 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Update journald setup] **********************************
Sunday 05 August 2018  15:16:49 +0000 (0:00:00.250)       0:06:25.245 ********* 
changed: [40.121.38.74] => (item={u'var': u'Storage', u'val': u'persistent'})
changed: [40.121.38.74] => (item={u'var': u'Compress', u'val': True})
changed: [40.121.38.74] => (item={u'var': u'SyncIntervalSec', u'val': u'1s'})
changed: [40.121.38.74] => (item={u'var': u'RateLimitInterval', u'val': u'1s'})
changed: [40.121.38.74] => (item={u'var': u'RateLimitBurst', u'val': 10000})
changed: [40.121.38.74] => (item={u'var': u'SystemMaxUse', u'val': u'8G'})
ok: [40.121.38.74] => (item={u'var': u'SystemKeepFree', u'val': u'20%'})
changed: [40.121.38.74] => (item={u'var': u'SystemMaxFileSize', u'val': u'10M'})
changed: [40.121.38.74] => (item={u'var': u'MaxRetentionSec', u'val': u'1month'})
ok: [40.121.38.74] => (item={u'var': u'MaxFileSec', u'val': u'1day'})
changed: [40.121.38.74] => (item={u'var': u'ForwardToSyslog', u'val': False})
changed: [40.121.38.74] => (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] ***************************************
Sunday 05 August 2018  15:16:52 +0000 (0:00:02.781)       0:06:28.026 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Disable swap] *******************************************
Sunday 05 August 2018  15:16:53 +0000 (0:00:00.564)       0:06:28.591 ********* 
ok: [40.121.38.74]

TASK [openshift_node : Install Node package, sdn-ovs, conntrack packages] ******
Sunday 05 August 2018  15:16:53 +0000 (0:00:00.383)       0:06:28.974 ********* 
changed: [40.121.38.74] => (item={u'name': u'origin-node-3.9.0'})
changed: [40.121.38.74] => (item={u'name': u'origin-sdn-ovs-3.9.0', u'install': True})
ok: [40.121.38.74] => (item={u'name': u'conntrack-tools'})

TASK [openshift_node : Pre-pull node image when containerized] *****************
Sunday 05 August 2018  15:18:40 +0000 (0:01:47.119)       0:08:16.093 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Restart cri-o] ******************************************
Sunday 05 August 2018  15:18:40 +0000 (0:00:00.042)       0:08:16.136 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : restart NetworkManager to ensure resolv.conf is present] ***
Sunday 05 August 2018  15:18:40 +0000 (0:00:00.043)       0:08:16.180 ********* 
changed: [40.121.38.74]

TASK [openshift_node : sysctl] *************************************************
Sunday 05 August 2018  15:18:41 +0000 (0:00:00.413)       0:08:16.593 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Setting sebool container_manage_cgroup] *****************
Sunday 05 August 2018  15:18:41 +0000 (0:00:00.475)       0:08:17.069 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Check for credentials file for registry auth] ***********
Sunday 05 August 2018  15:18:42 +0000 (0:00:01.219)       0:08:18.289 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Create credentials for registry auth] *******************
Sunday 05 August 2018  15:18:42 +0000 (0:00:00.043)       0:08:18.333 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Create credentials for registry auth (alternative)] *****
Sunday 05 August 2018  15:18:42 +0000 (0:00:00.051)       0:08:18.384 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Setup ro mount of /root/.docker for containerized hosts] ***
Sunday 05 August 2018  15:18:42 +0000 (0:00:00.046)       0:08:18.431 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Install Node service file] ******************************
Sunday 05 August 2018  15:18:43 +0000 (0:00:00.044)       0:08:18.476 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Install Node dependencies docker service file] **********
Sunday 05 August 2018  15:18:43 +0000 (0:00:00.661)       0:08:19.137 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Create the openvswitch service env file] ****************
Sunday 05 August 2018  15:18:43 +0000 (0:00:00.044)       0:08:19.182 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Install OpenvSwitch docker service file] ****************
Sunday 05 August 2018  15:18:43 +0000 (0:00:00.042)       0:08:19.225 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Configure Node settings] ********************************
Sunday 05 August 2018  15:18:43 +0000 (0:00:00.043)       0:08:19.268 ********* 
changed: [40.121.38.74] => (item={u'regex': u'^OPTIONS=', u'line': u'OPTIONS=--loglevel=2 '})
ok: [40.121.38.74] => (item={u'regex': u'^CONFIG_FILE=', u'line': u'CONFIG_FILE=/etc/origin/node/node-config.yaml'})
changed: [40.121.38.74] => (item={u'regex': u'^IMAGE_VERSION=', u'line': u'IMAGE_VERSION=v3.9.0'})

TASK [openshift_node : Configure Proxy Settings] *******************************
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.665)       0:08:19.934 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Pre-pull node system container image] *******************
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.051)       0:08:19.986 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Install or Update node system container] ****************
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.043)       0:08:20.030 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : set_fact] ***********************************************
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.043)       0:08:20.073 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : set_fact] ***********************************************
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.043)       0:08:20.117 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Pre-pull OpenVSwitch system container image] ************
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.048)       0:08:20.165 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Install or Update OpenVSwitch system container] *********
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.043)       0:08:20.209 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Pre-pull openvswitch image] *****************************
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.043)       0:08:20.252 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Create flexvolume directory when containerized] *********
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.043)       0:08:20.296 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Start and enable openvswitch service] *******************
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.041)       0:08:20.338 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : set_fact] ***********************************************
Sunday 05 August 2018  15:18:44 +0000 (0:00:00.041)       0:08:20.380 ********* 
ok: [40.121.38.74]

TASK [openshift_node : Create kublet args config dir] **************************
Sunday 05 August 2018  15:18:45 +0000 (0:00:00.109)       0:08:20.490 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Create the Node config] *********************************
Sunday 05 August 2018  15:18:45 +0000 (0:00:00.057)       0:08:20.547 ********* 
[DEPRECATION WARNING]: Using tests as filters is deprecated. Instead of using 
`result|version_compare` use `result is version_compare`. This feature will be 
removed in version 2.9. Deprecation warnings can be disabled by setting 
deprecation_warnings=False in ansible.cfg.
changed: [40.121.38.74]

TASK [openshift_node : Configure Node Environment Variables] *******************
Sunday 05 August 2018  15:18:45 +0000 (0:00:00.716)       0:08:21.264 ********* 

TASK [openshift_node : Configure AWS Cloud Provider Settings] ******************
Sunday 05 August 2018  15:18:45 +0000 (0:00:00.043)       0:08:21.307 ********* 
skipping: [40.121.38.74] => (item=None) 
skipping: [40.121.38.74] => (item=None) 
skipping: [40.121.38.74]

TASK [openshift_node : Wait for master API to become available before proceeding] ***
Sunday 05 August 2018  15:18:45 +0000 (0:00:00.070)       0:08:21.378 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Start and enable node dep] ******************************
Sunday 05 August 2018  15:18:45 +0000 (0:00:00.041)       0:08:21.420 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Start and enable node] **********************************
Sunday 05 August 2018  15:18:46 +0000 (0:00:00.043)       0:08:21.463 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Dump logs from node service if it failed] ***************
Sunday 05 August 2018  15:18:46 +0000 (0:00:00.042)       0:08:21.506 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Abort if node failed to start] **************************
Sunday 05 August 2018  15:18:46 +0000 (0:00:00.042)       0:08:21.548 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : set_fact] ***********************************************
Sunday 05 August 2018  15:18:46 +0000 (0:00:00.042)       0:08:21.591 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : Install NFS storage plugin dependencies] ****************
Sunday 05 August 2018  15:18:46 +0000 (0:00:00.045)       0:08:21.636 ********* 
ok: [40.121.38.74]

TASK [openshift_node : Check for existence of nfs sebooleans] ******************
Sunday 05 August 2018  15:18:46 +0000 (0:00:00.468)       0:08:22.104 ********* 
ok: [40.121.38.74] => (item=virt_use_nfs)
ok: [40.121.38.74] => (item=virt_sandbox_use_nfs)

TASK [openshift_node : Set seboolean to allow nfs storage plugin access from containers] ***
Sunday 05 August 2018  15:18:47 +0000 (0:00:00.496)       0:08:22.601 ********* 
ok: [40.121.38.74] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-08-05 15:18:46.879133', '_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.062129', '_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-08-05 15:18:46.817004', '_ansible_ignore_errors': None, 'failed': False})
skipping: [40.121.38.74] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-08-05 15:18:47.092511', '_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.002585', '_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-08-05 15:18:47.089926', '_ansible_ignore_errors': None, 'failed': False}) 

TASK [openshift_node : Set seboolean to allow nfs storage plugin access from containers (python 3)] ***
Sunday 05 August 2018  15:18:47 +0000 (0:00:00.259)       0:08:22.861 ********* 
skipping: [40.121.38.74] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-08-05 15:18:46.879133', '_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.062129', '_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-08-05 15:18:46.817004', '_ansible_ignore_errors': None, 'failed': False}) 
skipping: [40.121.38.74] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-08-05 15:18:47.092511', '_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.002585', '_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-08-05 15:18:47.089926', '_ansible_ignore_errors': None, 'failed': False}) 

TASK [openshift_node : Install GlusterFS storage plugin dependencies] **********
Sunday 05 August 2018  15:18:47 +0000 (0:00:00.086)       0:08:22.948 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Check for existence of fusefs sebooleans] ***************
Sunday 05 August 2018  15:18:53 +0000 (0:00:06.254)       0:08:29.202 ********* 
ok: [40.121.38.74] => (item=virt_use_fusefs)
ok: [40.121.38.74] => (item=virt_sandbox_use_fusefs)

TASK [openshift_node : Set seboolean to allow gluster storage plugin access from containers] ***
Sunday 05 August 2018  15:18:54 +0000 (0:00:00.421)       0:08:29.623 ********* 
changed: [40.121.38.74] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-08-05 15:18:53.935909', '_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.003371', '_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-08-05 15:18:53.932538', '_ansible_ignore_errors': None, 'failed': False})
changed: [40.121.38.74] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-08-05 15:18:54.111509', '_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.002764', '_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-08-05 15:18:54.108745', '_ansible_ignore_errors': None, 'failed': False})

TASK [openshift_node : Set seboolean to allow gluster storage plugin access from containers (python 3)] ***
Sunday 05 August 2018  15:18:56 +0000 (0:00:02.555)       0:08:32.179 ********* 
skipping: [40.121.38.74] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-08-05 15:18:53.935909', '_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.003371', '_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-08-05 15:18:53.932538', '_ansible_ignore_errors': None, 'failed': False}) 
skipping: [40.121.38.74] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-08-05 15:18:54.111509', '_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.002764', '_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-08-05 15:18:54.108745', '_ansible_ignore_errors': None, 'failed': False}) 

TASK [openshift_node : Install Ceph storage plugin dependencies] ***************
Sunday 05 August 2018  15:18:56 +0000 (0:00:00.100)       0:08:32.279 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Install iSCSI storage plugin dependencies] **************
Sunday 05 August 2018  15:19:18 +0000 (0:00:21.736)       0:08:54.015 ********* 
changed: [40.121.38.74] => (item=iscsi-initiator-utils)
changed: [40.121.38.74] => (item=device-mapper-multipath)

TASK [openshift_node : restart services] ***************************************
Sunday 05 August 2018  15:19:28 +0000 (0:00:09.824)       0:09:03.840 ********* 
changed: [40.121.38.74] => (item=multipathd)
changed: [40.121.38.74] => (item=rpcbind)
changed: [40.121.38.74] => (item=iscsid)

TASK [openshift_node : Template multipath configuration] ***********************
Sunday 05 August 2018  15:19:29 +0000 (0:00:00.899)       0:09:04.740 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Enable and start multipath] *****************************
Sunday 05 August 2018  15:19:29 +0000 (0:00:00.611)       0:09:05.351 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Create OpenvSwitch service.d directory] *****************
Sunday 05 August 2018  15:19:30 +0000 (0:00:00.485)       0:09:05.837 ********* 
changed: [40.121.38.74]

TASK [openshift_node : Install OpenvSwitch service OOM fix] ********************
Sunday 05 August 2018  15:19:30 +0000 (0:00:00.229)       0:09:06.066 ********* 
changed: [40.121.38.74]

TASK [tuned : Check for tuned package] *****************************************
Sunday 05 August 2018  15:19:31 +0000 (0:00:00.596)       0:09:06.663 ********* 
ok: [40.121.38.74]

TASK [tuned : Set tuned OpenShift variables] ***********************************
Sunday 05 August 2018  15:19:31 +0000 (0:00:00.295)       0:09:06.958 ********* 
ok: [40.121.38.74]

TASK [tuned : Ensure directory structure exists] *******************************
Sunday 05 August 2018  15:19:31 +0000 (0:00:00.068)       0:09:07.027 ********* 
changed: [40.121.38.74] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1533479650.0, 'owner': 'root', 'path': u'openshift', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1533481616.8537323})
changed: [40.121.38.74] => (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': 1533481616.8537323})
changed: [40.121.38.74] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-node', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1533481616.8537323})
skipping: [40.121.38.74] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/recommend.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '0666', 'mtime': 1533479650.0, 'owner': 'root', 'path': u'recommend.conf', 'size': 268, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1533481616.7787328}) 
skipping: [40.121.38.74] => (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': 1533479650.0, 'owner': 'root', 'path': u'openshift/tuned.conf', 'size': 593, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1533481616.7787328}) 
skipping: [40.121.38.74] => (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': 1533481616.7787328}) 
skipping: [40.121.38.74] => (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': '02666', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-node/tuned.conf', 'size': 135, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1533481616.7787328}) 

TASK [tuned : Ensure files are populated from templates] ***********************
Sunday 05 August 2018  15:19:32 +0000 (0:00:00.621)       0:09:07.649 ********* 
skipping: [40.121.38.74] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1533479650.0, 'owner': 'root', 'path': u'openshift', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1533481616.8537323}) 
skipping: [40.121.38.74] => (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': 1533481616.8537323}) 
skipping: [40.121.38.74] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-node', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1533481616.8537323}) 
changed: [40.121.38.74] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/recommend.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '0666', 'mtime': 1533479650.0, 'owner': 'root', 'path': u'recommend.conf', 'size': 268, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1533481616.7787328})
changed: [40.121.38.74] => (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': 1533479650.0, 'owner': 'root', 'path': u'openshift/tuned.conf', 'size': 593, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1533481616.7787328})
changed: [40.121.38.74] => (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': 1533481616.7787328})
changed: [40.121.38.74] => (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': '02666', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-node/tuned.conf', 'size': 135, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1533481616.7787328})

TASK [tuned : Make tuned use the recommended tuned profile on restart] *********
Sunday 05 August 2018  15:19:34 +0000 (0:00:02.379)       0:09:10.029 ********* 
changed: [40.121.38.74] => (item=/etc/tuned/active_profile)
changed: [40.121.38.74] => (item=/etc/tuned/profile_mode)

TASK [tuned : Restart tuned service] *******************************************
Sunday 05 August 2018  15:19:35 +0000 (0:00:00.435)       0:09:10.464 ********* 
changed: [40.121.38.74]

TASK [nickhammond.logrotate : nickhammond.logrotate | Install logrotate] *******
Sunday 05 August 2018  15:19:39 +0000 (0:00:04.206)       0:09:14.671 ********* 
ok: [40.121.38.74]

TASK [nickhammond.logrotate : nickhammond.logrotate | Setup logrotate.d scripts] ***
Sunday 05 August 2018  15:19:39 +0000 (0:00:00.482)       0:09:15.153 ********* 

RUNNING HANDLER [openshift_node : restart openvswitch] *************************
Sunday 05 August 2018  15:19:39 +0000 (0:00:00.015)       0:09:15.169 ********* 
skipping: [40.121.38.74]

RUNNING HANDLER [openshift_node : restart node] ********************************
Sunday 05 August 2018  15:19:39 +0000 (0:00:00.041)       0:09:15.210 ********* 
skipping: [40.121.38.74]

RUNNING HANDLER [openshift_node : reload systemd units] ************************
Sunday 05 August 2018  15:19:39 +0000 (0:00:00.042)       0:09:15.253 ********* 
skipping: [40.121.38.74]

PLAY [node bootstrap config] ***************************************************

TASK [openshift_node : install needed rpm(s)] **********************************
Sunday 05 August 2018  15:19:39 +0000 (0:00:00.074)       0:09:15.327 ********* 
changed: [40.121.38.74] => (item=origin-master)
ok: [40.121.38.74] => (item=origin-node)
ok: [40.121.38.74] => (item=origin-docker-excluder)
changed: [40.121.38.74] => (item=ansible)
ok: [40.121.38.74] => (item=openvswitch)
ok: [40.121.38.74] => (item=docker)
changed: [40.121.38.74] => (item=etcd)
changed: [40.121.38.74] => (item=haproxy)
ok: [40.121.38.74] => (item=dnsmasq)
changed: [40.121.38.74] => (item=ntp)
ok: [40.121.38.74] => (item=logrotate)
changed: [40.121.38.74] => (item=httpd-tools)
changed: [40.121.38.74] => (item=bind)
ok: [40.121.38.74] => (item=firewalld)
ok: [40.121.38.74] => (item=libselinux-python)
ok: [40.121.38.74] => (item=conntrack-tools)
ok: [40.121.38.74] => (item=openssl)
ok: [40.121.38.74] => (item=iproute)
ok: [40.121.38.74] => (item=python-dbus)
ok: [40.121.38.74] => (item=PyYAML)
ok: [40.121.38.74] => (item=yum-utils)
ok: [40.121.38.74] => (item=glusterfs-fuse)
ok: [40.121.38.74] => (item=device-mapper-multipath)
ok: [40.121.38.74] => (item=nfs-utils)
changed: [40.121.38.74] => (item=flannel)
ok: [40.121.38.74] => (item=bash-completion)
changed: [40.121.38.74] => (item=cockpit-ws)
changed: [40.121.38.74] => (item=cockpit-system)
ok: [40.121.38.74] => (item=cockpit-bridge)
changed: [40.121.38.74] => (item=cockpit-docker)
ok: [40.121.38.74] => (item=iscsi-initiator-utils)
ok: [40.121.38.74] => (item=ceph-common)

TASK [openshift_node : install SDN package] ************************************
Sunday 05 August 2018  15:20:59 +0000 (0:01:19.140)       0:10:34.468 ********* 
[DEPRECATION WARNING]: Using tests as filters is deprecated. Instead of using 
`result|success` use `result is success`. This feature will be removed in 
version 2.9. Deprecation warnings can be disabled by setting 
deprecation_warnings=False in ansible.cfg.
ok: [40.121.38.74]

TASK [openshift_node : create the directory for node] **************************
Sunday 05 August 2018  15:20:59 +0000 (0:00:00.450)       0:10:34.918 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : laydown systemd override] *******************************
Sunday 05 August 2018  15:20:59 +0000 (0:00:00.051)       0:10:34.970 ********* 
skipping: [40.121.38.74]

TASK [openshift_node : update the sysconfig to have necessary variables] *******
Sunday 05 August 2018  15:20:59 +0000 (0:00:00.052)       0:10:35.022 ********* 
changed: [40.121.38.74] => (item={u'regexp': u'^KUBECONFIG=.*', u'line': u'KUBECONFIG=/etc/origin/node/bootstrap.kubeconfig'})
ok: [40.121.38.74] => (item={u'regexp': u'^CONFIG_FILE=.*', u'line': u'CONFIG_FILE=/etc/origin/node/node-config.yaml'})

TASK [openshift_node : Configure AWS Cloud Provider Settings] ******************
Sunday 05 August 2018  15:20:59 +0000 (0:00:00.411)       0:10:35.433 ********* 
skipping: [40.121.38.74] => (item=None) 
skipping: [40.121.38.74] => (item=None) 
skipping: [40.121.38.74]

TASK [openshift_node : disable origin-node] ************************************
Sunday 05 August 2018  15:21:00 +0000 (0:00:00.070)       0:10:35.504 ********* 
ok: [40.121.38.74] => (item=origin-node.service)

TASK [openshift_node : Check for RPM generated config marker file .config_managed] ***
Sunday 05 August 2018  15:21:00 +0000 (0:00:00.253)       0:10:35.757 ********* 
ok: [40.121.38.74]

TASK [openshift_node : create directories for bootstrapping] *******************
Sunday 05 August 2018  15:21:00 +0000 (0:00:00.227)       0:10:35.984 ********* 
changed: [40.121.38.74] => (item=/root/openshift_bootstrap)
changed: [40.121.38.74] => (item=/var/lib/origin/openshift.local.config)
changed: [40.121.38.74] => (item=/var/lib/origin/openshift.local.config/node)
changed: [40.121.38.74] => (item=/etc/docker/certs.d/docker-registry.default.svc:5000)

TASK [openshift_node : laydown the bootstrap.yml file for on boot configuration] ***
Sunday 05 August 2018  15:21:01 +0000 (0:00:00.852)       0:10:36.836 ********* 
changed: [40.121.38.74]

TASK [openshift_node : symlink master ca for docker-registry] ******************
Sunday 05 August 2018  15:21:01 +0000 (0:00:00.599)       0:10:37.436 ********* 
changed: [40.121.38.74] => (item=/etc/origin/node/node-client-ca.crt)
 [WARNING]: Cannot set fs attributes on a non-existent symlink target. follow
should be set to False to avoid this.

TASK [openshift_node : Remove RPM generated config files if present] ***********
Sunday 05 August 2018  15:21:02 +0000 (0:00:00.247)       0:10:37.683 ********* 
changed: [40.121.38.74] => (item=master)
changed: [40.121.38.74] => (item=.config_managed)

TASK [openshift_node : find all files in /etc/origin/node so we can remove them] ***
Sunday 05 August 2018  15:21:02 +0000 (0:00:00.431)       0:10:38.114 ********* 
ok: [40.121.38.74]

TASK [openshift_node : Remove everything except the resolv.conf required for node] ***
Sunday 05 August 2018  15:21:03 +0000 (0:00:00.376)       0:10:38.491 ********* 
skipping: [40.121.38.74] => (item={u'uid': 0, u'woth': False, u'mtime': 1533482204.1970398, u'inode': 16887927, u'isgid': False, u'size': 63, u'roth': True, u'isuid': False, u'isreg': True, u'pw_name': u'root', u'gid': 0, u'ischr': False, u'wusr': True, u'xoth': False, u'rusr': True, u'nlink': 1, u'issock': False, u'rgrp': True, u'gr_name': u'root', u'path': u'/etc/origin/node/node-dnsmasq.conf', u'xusr': False, u'atime': 1533482204.4010415, u'isdir': False, u'ctime': 1533482204.4050415, u'isblk': False, u'xgrp': False, u'dev': 2049, u'wgrp': False, u'isfifo': False, u'mode': u'0644', u'islnk': False}) 
skipping: [40.121.38.74] => (item={u'uid': 0, u'woth': False, u'mtime': 1533482321.4091542, u'inode': 8733436, u'isgid': False, u'size': 25, u'roth': False, u'isuid': False, u'isreg': True, u'pw_name': u'root', u'gid': 0, u'ischr': False, u'wusr': True, u'xoth': False, u'rusr': True, u'nlink': 1, u'issock': False, u'rgrp': False, u'gr_name': u'root', u'path': u'/etc/origin/node/resolv.conf', u'xusr': False, u'atime': 1533482321.4091542, u'isdir': False, u'ctime': 1533482321.4091542, u'isblk': False, u'xgrp': False, u'dev': 2049, u'wgrp': False, u'isfifo': False, u'mode': u'0600', u'islnk': False}) 
changed: [40.121.38.74] => (item={u'uid': 0, u'woth': False, u'mtime': 1533482325.5291955, u'inode': 300135, u'isgid': False, u'size': 1282, u'roth': False, u'isuid': False, u'isreg': True, u'pw_name': u'root', u'gid': 0, u'ischr': False, u'wusr': True, u'xoth': False, u'rusr': True, u'nlink': 1, u'issock': False, u'rgrp': False, u'gr_name': u'root', u'path': u'/etc/origin/node/node-config.yaml', u'xusr': False, u'atime': 1533482376.3166525, u'isdir': False, u'ctime': 1533482325.7101974, u'isblk': False, u'xgrp': False, u'dev': 2049, u'wgrp': False, u'isfifo': False, u'mode': u'0600', u'islnk': False})

PLAY [Re-enable excluder if it was previously enabled] *************************

TASK [openshift_excluder : Detecting Atomic Host Operating System] *************
Sunday 05 August 2018  15:21:03 +0000 (0:00:00.312)       0:10:38.803 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : Debug r_openshift_excluder_enable_docker_excluder] ***
Sunday 05 August 2018  15:21:03 +0000 (0:00:00.242)       0:10:39.046 ********* 
ok: [40.121.38.74] => {
    "r_openshift_excluder_enable_docker_excluder": true
}

TASK [openshift_excluder : Debug r_openshift_excluder_enable_openshift_excluder] ***
Sunday 05 August 2018  15:21:03 +0000 (0:00:00.072)       0:10:39.119 ********* 
ok: [40.121.38.74] => {
    "r_openshift_excluder_enable_openshift_excluder": true
}

TASK [openshift_excluder : Fail if invalid openshift_excluder_action provided] ***
Sunday 05 August 2018  15:21:03 +0000 (0:00:00.073)       0:10:39.192 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Fail if r_openshift_excluder_upgrade_target is not defined] ***
Sunday 05 August 2018  15:21:03 +0000 (0:00:00.046)       0:10:39.238 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Include main action task file] **********************
Sunday 05 August 2018  15:21:03 +0000 (0:00:00.044)       0:10:39.283 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/enable.yml for 40.121.38.74

TASK [openshift_excluder : Install excluders] **********************************
Sunday 05 August 2018  15:21:03 +0000 (0:00:00.078)       0:10:39.361 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/install.yml for 40.121.38.74

TASK [openshift_excluder : Install docker excluder - yum] **********************
Sunday 05 August 2018  15:21:03 +0000 (0:00:00.079)       0:10:39.441 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Install docker excluder - dnf] **********************
Sunday 05 August 2018  15:21:04 +0000 (0:00:00.048)       0:10:39.490 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Install openshift excluder - yum] *******************
Sunday 05 August 2018  15:21:04 +0000 (0:00:00.048)       0:10:39.539 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Install openshift excluder - dnf] *******************
Sunday 05 August 2018  15:21:04 +0000 (0:00:00.052)       0:10:39.591 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : set_fact] *******************************************
Sunday 05 August 2018  15:21:04 +0000 (0:00:00.049)       0:10:39.641 ********* 
skipping: [40.121.38.74]

TASK [openshift_excluder : Enable excluders] ***********************************
Sunday 05 August 2018  15:21:04 +0000 (0:00:00.049)       0:10:39.690 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/exclude.yml for 40.121.38.74

TASK [openshift_excluder : Check for docker-excluder] **************************
Sunday 05 August 2018  15:21:04 +0000 (0:00:00.077)       0:10:39.768 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : Enable docker excluder] *****************************
Sunday 05 August 2018  15:21:04 +0000 (0:00:00.247)       0:10:40.016 ********* 
changed: [40.121.38.74]

TASK [openshift_excluder : Check for openshift excluder] ***********************
Sunday 05 August 2018  15:21:04 +0000 (0:00:00.307)       0:10:40.323 ********* 
ok: [40.121.38.74]

TASK [openshift_excluder : Enable openshift excluder] **************************
Sunday 05 August 2018  15:21:05 +0000 (0:00:00.271)       0:10:40.595 ********* 
skipping: [40.121.38.74]

PLAY [Configure nodes] *********************************************************

TASK [Remove any ansible facts created during AMI creation] ********************
Sunday 05 August 2018  15:21:05 +0000 (0:00:00.059)       0:10:40.655 ********* 
changed: [40.121.38.74] => (item=openshift.fact)

PLAY [nodes] *******************************************************************

TASK [openshift_master_facts : Verify required variables are set] **************
Sunday 05 August 2018  15:21:05 +0000 (0:00:00.279)       0:10:40.934 ********* 
skipping: [40.121.38.74]

TASK [openshift_master_facts : Set g_metrics_hostname] *************************
Sunday 05 August 2018  15:21:05 +0000 (0:00:00.076)       0:10:41.011 ********* 
ok: [40.121.38.74]

TASK [openshift_master_facts : set_fact] ***************************************
Sunday 05 August 2018  15:21:05 +0000 (0:00:00.066)       0:10:41.078 ********* 
skipping: [40.121.38.74]

TASK [openshift_master_facts : Set master facts] *******************************
Sunday 05 August 2018  15:21:05 +0000 (0:00:00.042)       0:10:41.121 ********* 
changed: [40.121.38.74]

TASK [openshift_master_facts : Determine if scheduler config present] **********
Sunday 05 August 2018  15:21:06 +0000 (0:00:01.054)       0:10:42.176 ********* 
ok: [40.121.38.74]

TASK [openshift_master_facts : Set Default scheduler predicates and priorities] ***
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.322)       0:10:42.498 ********* 
ok: [40.121.38.74]

TASK [openshift_master_facts : Retrieve current scheduler config] **************
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.078)       0:10:42.577 ********* 
skipping: [40.121.38.74]

TASK [openshift_master_facts : Set openshift_master_scheduler_current_config] ***
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.044)       0:10:42.622 ********* 
skipping: [40.121.38.74]

TASK [openshift_master_facts : Test if scheduler config is readable] ***********
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.044)       0:10:42.667 ********* 
skipping: [40.121.38.74]

TASK [openshift_master_facts : Set current scheduler predicates and priorities] ***
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.046)       0:10:42.714 ********* 
skipping: [40.121.38.74]

TASK [openshift_master : include push_via_dns.yml tasks] ***********************
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.044)       0:10:42.759 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_master/tasks/push_via_dns.yml for 40.121.38.74

TASK [openshift_master : check whether our docker-registry setting exists in the env file] ***
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.074)       0:10:42.834 ********* 
ok: [40.121.38.74]

TASK [openshift_master : set_fact] *********************************************
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.228)       0:10:43.062 ********* 
ok: [40.121.38.74]

TASK [openshift_master : Set HA Service Info for containerized installs] *******
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.076)       0:10:43.138 ********* 
skipping: [40.121.38.74]

TASK [openshift_master : include registry_auth tasks] **************************
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.046)       0:10:43.184 ********* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_master/tasks/registry_auth.yml for 40.121.38.74

TASK [openshift_master : Check for credentials file for registry auth] *********
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.080)       0:10:43.265 ********* 
skipping: [40.121.38.74]

TASK [openshift_master : Create credentials for registry auth] *****************
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.045)       0:10:43.311 ********* 
skipping: [40.121.38.74]

TASK [openshift_master : Create credentials for registry auth (alternative)] ***
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.051)       0:10:43.362 ********* 
skipping: [40.121.38.74]

TASK [openshift_master : Setup ro mount of /root/.docker for containerized hosts] ***
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.048)       0:10:43.411 ********* 
skipping: [40.121.38.74]

TASK [openshift_master : Disable the legacy master service if it exists] *******
Sunday 05 August 2018  15:21:07 +0000 (0:00:00.045)       0:10:43.456 ********* 
changed: [40.121.38.74]

TASK [openshift_master : Remove the legacy master service if it exists] ********
Sunday 05 August 2018  15:21:08 +0000 (0:00:00.314)       0:10:43.770 ********* 
changed: [40.121.38.74]

TASK [openshift_master : Pre-pull master image] ********************************
Sunday 05 August 2018  15:21:08 +0000 (0:00:00.235)       0:10:44.006 ********* 
skipping: [40.121.38.74]

TASK [openshift_master : Create the ha systemd unit files] *********************
Sunday 05 August 2018  15:21:08 +0000 (0:00:00.049)       0:10:44.055 ********* 
changed: [40.121.38.74] => (item=api)
changed: [40.121.38.74] => (item=controllers)

TASK [openshift_master : command] **********************************************
Sunday 05 August 2018  15:21:09 +0000 (0:00:01.161)       0:10:45.217 ********* 
changed: [40.121.38.74]

TASK [openshift_master : enable master services] *******************************
Sunday 05 August 2018  15:21:10 +0000 (0:00:00.288)       0:10:45.505 ********* 
ok: [40.121.38.74] => (item=api)
ok: [40.121.38.74] => (item=controllers)

TASK [openshift_master : Preserve Master API Proxy Config options] *************
Sunday 05 August 2018  15:21:10 +0000 (0:00:00.446)       0:10:45.952 ********* 
ok: [40.121.38.74]

TASK [openshift_master : Preserve Master API AWS options] **********************
Sunday 05 August 2018  15:21:10 +0000 (0:00:00.233)       0:10:46.185 ********* 
ok: [40.121.38.74]

TASK [openshift_master : Create the master api service env file] ***************
Sunday 05 August 2018  15:21:10 +0000 (0:00:00.239)       0:10:46.425 ********* 
changed: [40.121.38.74]

TASK [openshift_master : Restore Master API Proxy Config Options] **************
Sunday 05 August 2018  15:21:11 +0000 (0:00:00.618)       0:10:47.044 ********* 

TASK [openshift_master : Restore Master API AWS Options] ***********************
Sunday 05 August 2018  15:21:11 +0000 (0:00:00.044)       0:10:47.089 ********* 
skipping: [40.121.38.74]

TASK [openshift_master : Preserve Master Controllers Proxy Config options] *****
Sunday 05 August 2018  15:21:11 +0000 (0:00:00.042)       0:10:47.131 ********* 
ok: [40.121.38.74]

TASK [openshift_master : Preserve Master Controllers AWS options] **************
Sunday 05 August 2018  15:21:11 +0000 (0:00:00.233)       0:10:47.365 ********* 
ok: [40.121.38.74]

TASK [openshift_master : Create the master controllers service env file] *******
Sunday 05 August 2018  15:21:12 +0000 (0:00:00.246)       0:10:47.612 ********* 
changed: [40.121.38.74]

TASK [openshift_master : Restore Master Controllers Proxy Config Options] ******
Sunday 05 August 2018  15:21:12 +0000 (0:00:00.652)       0:10:48.265 ********* 

TASK [openshift_master : Restore Master Controllers AWS Options] ***************
Sunday 05 August 2018  15:21:12 +0000 (0:00:00.044)       0:10:48.309 ********* 
skipping: [40.121.38.74]

RUNNING HANDLER [openshift_master : restart master api] ************************
Sunday 05 August 2018  15:21:12 +0000 (0:00:00.015)       0:10:48.325 ********* 
skipping: [40.121.38.74]

RUNNING HANDLER [openshift_master : restart master controllers] ****************
Sunday 05 August 2018  15:21:12 +0000 (0:00:00.044)       0:10:48.370 ********* 
skipping: [40.121.38.74]

TASK [remove yum client certificate] *******************************************
Sunday 05 August 2018  15:21:12 +0000 (0:00:00.074)       0:10:48.445 ********* 
skipping: [40.121.38.74] => (item={u'name': u'client-cert.pem'}) 
skipping: [40.121.38.74] => (item={u'name': u'client-key.pem'}) 

TASK [remove yum repositories] *************************************************
Sunday 05 August 2018  15:21:13 +0000 (0:00:00.058)       0:10:48.503 ********* 
changed: [40.121.38.74] => (item={u'gpgkey': u'file:///etc/pki/rpm-gpg/RPM-GPG-KEY-CentOS-SIG-PaaS', u'enabled': True, u'name': u'openshift-origin39', u'baseurl': u'http://mirror.centos.org/centos/7/paas/x86_64/openshift-origin39/'})
changed: [40.121.38.74] => (item={'gpgcheck': False, 'enabled': True, 'name': u'install_repo', 'baseurl': u'https://storage.googleapis.com/origin-ci-test/pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/203/artifacts/rpms'})

TASK [add get-node-logs script] ************************************************
Sunday 05 August 2018  15:21:13 +0000 (0:00:00.435)       0:10:48.938 ********* 
changed: [40.121.38.74]

TASK [record installed rpms] ***************************************************
Sunday 05 August 2018  15:21:14 +0000 (0:00:00.588)       0:10:49.526 ********* 
ok: [40.121.38.74]

TASK [disable waagent data disk management] ************************************
Sunday 05 August 2018  15:21:15 +0000 (0:00:01.299)       0:10:50.826 ********* 
changed: [40.121.38.74] => (item={u'regexp': u'^ResourceDisk\\.Format=', u'line': u'ResourceDisk.Format=n'})

TASK [persist oreg_url] ********************************************************
Sunday 05 August 2018  15:21:15 +0000 (0:00:00.248)       0:10:51.075 ********* 
changed: [40.121.38.74]

TASK [run waagent deprovision] *************************************************
Sunday 05 August 2018  15:21:16 +0000 (0:00:00.705)       0:10:51.780 ********* 
changed: [40.121.38.74]

PLAY [localhost] ***************************************************************

TASK [set_fact] ****************************************************************
Sunday 05 August 2018  15:21:17 +0000 (0:00:01.053)       0:10:52.834 ********* 
ok: [localhost]

TASK [deallocate vm] ***********************************************************
Sunday 05 August 2018  15:21:17 +0000 (0:00:00.083)       0:10:52.917 ********* 
changed: [localhost]

TASK [generalize vm] ***********************************************************
Sunday 05 August 2018  15:23:39 +0000 (0:02:21.645)       0:13:14.563 ********* 
changed: [localhost]

TASK [get vm details] **********************************************************
Sunday 05 August 2018  15:23:41 +0000 (0:00:02.218)       0:13:16.781 ********* 
changed: [localhost]

TASK [create image resource group] *********************************************
Sunday 05 August 2018  15:23:43 +0000 (0:00:02.085)       0:13:18.867 ********* 
ok: [localhost]

TASK [create image] ************************************************************
Sunday 05 August 2018  15:23:44 +0000 (0:00:00.766)       0:13:19.633 ********* 
changed: [localhost]

TASK [get input image tags] ****************************************************
Sunday 05 August 2018  15:24:18 +0000 (0:00:34.635)       0:13:54.269 ********* 
changed: [localhost]

TASK [remove valid tag from input image tags] **********************************
Sunday 05 August 2018  15:24:20 +0000 (0:00:02.142)       0:13:56.411 ********* 
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] ****************************************************
Sunday 05 August 2018  15:24:21 +0000 (0:00:00.076)       0:13:56.487 ********* 
ok: [localhost]

TASK [tag image] ***************************************************************
Sunday 05 August 2018  15:24:21 +0000 (0:00:00.075)       0:13:56.563 ********* 
changed: [localhost]

TASK [get vm details] **********************************************************
Sunday 05 August 2018  15:24:55 +0000 (0:00:34.379)       0:14:30.942 ********* 
skipping: [localhost]

TASK [get storage account key] *************************************************
Sunday 05 August 2018  15:24:55 +0000 (0:00:00.035)       0:14:30.978 ********* 
skipping: [localhost]

TASK [get disk sas url] ********************************************************
Sunday 05 August 2018  15:24:55 +0000 (0:00:00.033)       0:14:31.011 ********* 
skipping: [localhost]

TASK [start copy] **************************************************************
Sunday 05 August 2018  15:24:55 +0000 (0:00:00.033)       0:14:31.045 ********* 
skipping: [localhost]

TASK [get copy status] *********************************************************
Sunday 05 August 2018  15:24:55 +0000 (0:00:00.033)       0:14:31.078 ********* 
skipping: [localhost]

TASK [revoke disk sas url] *****************************************************
Sunday 05 August 2018  15:24:55 +0000 (0:00:00.033)       0:14:31.112 ********* 
skipping: [localhost]

PLAY RECAP *********************************************************************
40.121.38.74               : ok=183  changed=75   unreachable=0    failed=0   
localhost                  : ok=21   changed=12   unreachable=0    failed=0   
{}                         : ok=2    changed=0    unreachable=0    failed=0   


INSTALLER STATUS ***************************************************************
Initialization             : Complete (0:00:19)

Sunday 05 August 2018  15:24:55 +0000 (0:00:00.019)       0:14:31.131 ********* 
=============================================================================== 
create vm ------------------------------------------------------------- 189.66s
deallocate vm --------------------------------------------------------- 141.65s
openshift_node : Install Node package, sdn-ovs, conntrack packages ---- 107.12s
openshift_node : install needed rpm(s) --------------------------------- 79.14s
container_runtime : Install Docker ------------------------------------- 52.47s
create image ----------------------------------------------------------- 34.64s
tag image -------------------------------------------------------------- 34.38s
openshift_node : Install Ceph storage plugin dependencies -------------- 21.74s
create vnet ------------------------------------------------------------ 16.04s
Ensure openshift-ansible installer package deps are installed ---------- 14.44s
install centos-release-paas-common rpm --------------------------------- 11.36s
os_firewall : need to pause here, otherwise the iptables service starting can sometimes cause ssh to fail -- 10.12s
os_firewall : Wait 10 seconds after disabling firewalld ---------------- 10.07s
openshift_node : Install iSCSI storage plugin dependencies -------------- 9.82s
Gathering Facts --------------------------------------------------------- 8.91s
os_firewall : Install iptables packages --------------------------------- 6.64s
openshift_node : Install dnsmasq ---------------------------------------- 6.55s
openshift_node : Install GlusterFS storage plugin dependencies ---------- 6.25s
os_update_latest : Update all packages ---------------------------------- 5.55s
create subnet ----------------------------------------------------------- 5.46s
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: BUILD NODE IMAGE [00h 14m 35s] ##########
[workspace] $ /bin/bash /tmp/jenkins327554724160377433.sh
########## STARTING STAGE: PROVISION TEST CLUSTER ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ mktemp
+ script=/tmp/tmp.ZHLHnf6n8Y
+ cat
+ chmod +x /tmp/tmp.ZHLHnf6n8Y
+ scp -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.ZHLHnf6n8Y openshiftdevel:/tmp/tmp.ZHLHnf6n8Y
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.ZHLHnf6n8Y"'
+ cd /data/src/github.com/openshift/release
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PROVISION TEST CLUSTER [00h 00m 01s] ##########
[workspace] $ /bin/bash /tmp/jenkins1802347533020189605.sh
########## STARTING STAGE: RUN THE ACS-ENGINE E2E TEST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ mktemp
+ script=/tmp/tmp.0Mi8Q0VDvw
+ cat
+ chmod +x /tmp/tmp.0Mi8Q0VDvw
+ scp -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.0Mi8Q0VDvw openshiftdevel:/tmp/tmp.0Mi8Q0VDvw
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.0Mi8Q0VDvw"'
+ cd /home/origin
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RUN THE ACS-ENGINE E2E TEST [00h 00m 01s] ##########
[workspace] $ /bin/bash /tmp/jenkins3697275593107808437.sh
########## STARTING STAGE: RUN TESTS ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ mktemp
+ script=/tmp/tmp.t60N4fhudH
+ cat
+ chmod +x /tmp/tmp.t60N4fhudH
+ scp -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.t60N4fhudH openshiftdevel:/tmp/tmp.t60N4fhudH
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 900 /tmp/tmp.t60N4fhudH"'
+ 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/jenkins6132134744623434220.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/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: 20996224    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-08-05 14:36:38.314777116 +0000
Modify: 2018-08-05 15:07:06.484675136 +0000
Change: 2018-08-05 15:07:06.484675136 +0000
 Birth: -
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/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_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/data/src/github.com/openshift/origin/_output/scripts /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/gathered
+ tree /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/gathered
/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/gathered
└── scripts
    ├── build-base-images
    │   ├── artifacts
    │   ├── logs
    │   └── openshift.local.home
    ├── push-release
    │   ├── artifacts
    │   ├── logs
    │   │   └── scripts.log
    │   └── openshift.local.home
    └── shell
        ├── artifacts
        ├── logs
        │   ├── 293ccfb05d1cad432872e05ea08dee62fe427e0b8c88d449b045148a6c1e0106.json
        │   └── scripts.log
        └── openshift.local.home

13 directories, 3 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins935812937709010626.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/generated
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo docker version && sudo docker info && sudo docker images && sudo docker ps -a 2>&1'
  WARNING: You're not using the default seccomp profile
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo cat /etc/sysconfig/docker /etc/sysconfig/docker-network /etc/sysconfig/docker-storage /etc/sysconfig/docker-storage-setup /etc/systemd/system/docker.service 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo find /var/lib/docker/containers -name *.log | sudo xargs tail -vn +1 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/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_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo ausearch -m AVC -m SELINUX_ERR -m USER_AVC 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/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_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo df -T -h && sudo pvs && sudo vgs && sudo lvs && sudo findmnt --all 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo yum list installed 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl --dmesg --no-pager --all --lines=all 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl _PID=1 --no-pager --all --lines=all 2>&1'
+ tree /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/generated
/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/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/jenkins5759563595586328988.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/journals
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit docker.service --no-pager --all --lines=all
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit dnsmasq.service --no-pager --all --lines=all
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
+ tree /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/journals
/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/artifacts/journals
├── dnsmasq.service
├── docker.service
└── systemd-journald.service

0 directories, 3 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins4110671485578971455.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
+ trap 'exit 0' EXIT
+ mkdir -p gcs/artifacts gcs/artifacts/generated gcs/artifacts/journals gcs/artifacts/gathered
++ python -c 'import json; import urllib; print json.load(urllib.urlopen('\''https://ci.openshift.redhat.com/jenkins/job/test_pull_request_origin_extended_conformance_azure_39/203/api/json'\''))['\''result'\'']'
+ result=SUCCESS
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/builds/203/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_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/gcs openshiftdevel:/data
+ scp -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/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/jenkins2227241169511086801.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ mktemp
+ script=/tmp/tmp.cqxPHH6w4E
+ cat
+ chmod +x /tmp/tmp.cqxPHH6w4E
+ scp -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.cqxPHH6w4E openshiftdevel:/tmp/tmp.cqxPHH6w4E
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.cqxPHH6w4E"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"presubmit","job":"test_pull_request_origin_extended_conformance_azure_39","buildid":"1026113545944698880","prowjobid":"3f0c185e-98bc-11e8-8c5a-0a58ac103f73","refs":{"org":"openshift","repo":"origin","base_ref":"release-3.9","base_sha":"71543b2d15e53f4ae56272988a6604bf2f790dfd","pulls":[{"number":19859,"author":"mohammedzee1000","sha":"faf70acab9436507cdeb00eef5fb2d8d3f163150"}]}} ]]
++ jq --compact-output .buildid
+ [[ "1026113545944698880" =~ ^"[0-9]+"$ ]]
+ echo 'Keeping BUILD_ID'
Keeping BUILD_ID
+ docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_origin_extended_conformance_azure_39","buildid":"1026113545944698880","prowjobid":"3f0c185e-98bc-11e8-8c5a-0a58ac103f73","refs":{"org":"openshift","repo":"origin","base_ref":"release-3.9","base_sha":"71543b2d15e53f4ae56272988a6604bf2f790dfd","pulls":[{"number":19859,"author":"mohammedzee1000","sha":"faf70acab9436507cdeb00eef5fb2d8d3f163150"}]}}' -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
605ce1bd3f31: Already exists
dc6346da9948: Already exists
63e065a0bd09: Pulling fs layer
63e065a0bd09: Download complete
63e065a0bd09: Pull complete
Digest: sha256:224229e57115dfbf101f57e347ca106d50a6ede7370af7ac22926768cfc64c03
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-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/avc_denials.log in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/avc_denials.log\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/containers.log in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/containers.log\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/dmesg.log in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/dmesg.log\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/docker.config in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/docker.config\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/docker.info in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/docker.info\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/filesystem.info in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/filesystem.info\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/installed_packages.log in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/installed_packages.log\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/master-metrics.log in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/master-metrics.log\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/node-metrics.log in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/node-metrics.log\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/pid1.journal in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/pid1.journal\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/dnsmasq.service in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/journals/dnsmasq.service\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/docker.service in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/journals/docker.service\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/systemd-journald.service in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/journals/systemd-journald.service\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/push-release/logs/scripts.log in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/scripts/push-release/logs/scripts.log\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/shell/logs/293ccfb05d1cad432872e05ea08dee62fe427e0b8c88d449b045148a6c1e0106.json in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/scripts/shell/logs/293ccfb05d1cad432872e05ea08dee62fe427e0b8c88d449b045148a6c1e0106.json\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/shell/logs/scripts.log in artifact directory. Uploading as pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/scripts/shell/logs/scripts.log\n","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/journals/dnsmasq.service","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/containers.log","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/dmesg.log","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/docker.info","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/master-metrics.log","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/pid1.journal","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_origin_extended_conformance_azure_39/latest-build.txt","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/journals/docker.service","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/scripts/push-release/logs/scripts.log","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/scripts/shell/logs/293ccfb05d1cad432872e05ea08dee62fe427e0b8c88d449b045148a6c1e0106.json","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/scripts/shell/logs/scripts.log","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/build-log.txt","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/finished.json","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/avc_denials.log","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/filesystem.info","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/installed_packages.log","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/node-metrics.log","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/journals/systemd-journald.service","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880.txt","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/latest-build.txt","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/docker.config","level":"info","msg":"Queued for upload","time":"2018-08-05T15:25:18Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/node-metrics.log","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/scripts/shell/logs/scripts.log","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/scripts/push-release/logs/scripts.log","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/journals/dnsmasq.service","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/pid1.journal","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/docker.config","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880.txt","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_origin_extended_conformance_azure_39/latest-build.txt","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/filesystem.info","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/avc_denials.log","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/scripts/shell/logs/293ccfb05d1cad432872e05ea08dee62fe427e0b8c88d449b045148a6c1e0106.json","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/finished.json","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/build-log.txt","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/journals/systemd-journald.service","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/docker.info","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/installed_packages.log","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/master-metrics.log","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/journals/docker.service","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/containers.log","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/1026113545944698880/artifacts/generated/dmesg.log","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","dest":"pr-logs/pull/19859/test_pull_request_origin_extended_conformance_azure_39/latest-build.txt","level":"info","msg":"Finished upload","time":"2018-08-05T15:25:19Z"}
{"component":"gcsupload","level":"info","msg":"Finished upload to GCS","time":"2018-08-05T15:25:19Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 06s] ##########
[workspace] $ /bin/bash /tmp/jenkins4158018456251425158.sh
########## STARTING STAGE: HOLD FAILED TEST CLUSTER FOR DEBUG ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: HOLD FAILED TEST CLUSTER FOR DEBUG [00h 00m 00s] ##########
[workspace] $ /bin/bash /tmp/jenkins8162270685499438298.sh
########## STARTING STAGE: DEPROVISION TEST CLUSTER ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ mktemp
+ script=/tmp/tmp.ma8zGUoIxC
+ cat
+ chmod +x /tmp/tmp.ma8zGUoIxC
+ scp -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.ma8zGUoIxC openshiftdevel:/tmp/tmp.ma8zGUoIxC
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.ma8zGUoIxC"'
+ 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_pr_origin_extended_c_azure_39-203 playbooks/azure/openshift-cluster/deprovision.yml

PLAY [localhost] ***************************************************************

TASK [delete resource group] ***************************************************
Sunday 05 August 2018  15:25:22 +0000 (0:00:00.074)       0:00:00.074 ********* 
changed: [localhost]

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

Sunday 05 August 2018  15:28:56 +0000 (0:03:34.310)       0:03:34.384 ********* 
=============================================================================== 
delete resource group ------------------------------------------------- 214.31s
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: DEPROVISION TEST CLUSTER [00h 03m 38s] ##########
[workspace] $ /bin/bash /tmp/jenkins668570632535171185.sh
########## STARTING STAGE: DELETE PR IMAGES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
+ trap 'exit 0' EXIT
+ source ./INSTANCE_PREFIX
++ INSTANCE_PREFIX=prtest-7cc19dc-203
++ OS_TAG=cc154fc
++ OS_PUSH_BASE_REPO=ci-pr-images/prtest-7cc19dc-203-
+ 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-7cc19dc-203
+ xargs -r oc delete
imagestream "prtest-7cc19dc-203-hello-openshift" deleted
imagestream "prtest-7cc19dc-203-node" deleted
imagestream "prtest-7cc19dc-203-openvswitch" deleted
imagestream "prtest-7cc19dc-203-origin" deleted
imagestream "prtest-7cc19dc-203-origin-base" deleted
imagestream "prtest-7cc19dc-203-origin-cluster-capacity" deleted
imagestream "prtest-7cc19dc-203-origin-deployer" deleted
imagestream "prtest-7cc19dc-203-origin-docker-builder" deleted
imagestream "prtest-7cc19dc-203-origin-egress-http-proxy" deleted
imagestream "prtest-7cc19dc-203-origin-egress-router" deleted
imagestream "prtest-7cc19dc-203-origin-f5-router" deleted
imagestream "prtest-7cc19dc-203-origin-haproxy-router" deleted
imagestream "prtest-7cc19dc-203-origin-keepalived-ipfailover" deleted
imagestream "prtest-7cc19dc-203-origin-pod" deleted
imagestream "prtest-7cc19dc-203-origin-recycler" deleted
imagestream "prtest-7cc19dc-203-origin-service-catalog" deleted
imagestream "prtest-7cc19dc-203-origin-sti-builder" deleted
imagestream "prtest-7cc19dc-203-origin-template-service-broker" deleted
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins7073175250615794415.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd
++ export PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config
+ oct deprovision

PLAYBOOK: main.yml *************************************************************
4 plays in /var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/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/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/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-08-05 11:29:00.722432", 
    "item": "origin_ci_inventory_dir", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region)  => {
    "changed": false, 
    "generated_timestamp": "2018-08-05 11:29:00.725114", 
    "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/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:28
included: /var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/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/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:2
ok: [localhost] => {
    "changed": false, 
    "generated_timestamp": "2018-08-05 11:29:01.487322", 
    "msg": ""
}

TASK [rename EC2 instance for termination reaper] ******************************
task path: /var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:8
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-08-05 11:29:02.079879", 
    "msg": "Tags {'Name': 'oct-terminate'} created for resource i-019ba5f3ed9a8c8db."
}

TASK [tear down the EC2 instance] **********************************************
task path: /var/lib/jenkins/origin-ci-tool/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:15
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-08-05 11:29:02.921789", 
    "instance_ids": [
        "i-019ba5f3ed9a8c8db"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-03c40ef72f81f1975"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0a4c573410c0a5b2a"
                }
            }, 
            "dns_name": "ec2-18-212-108-172.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-019ba5f3ed9a8c8db", 
            "image_id": "ami-0b77b87a37c3e662c", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "libra", 
            "launch_time": "2018-08-05T14:32:03.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-5-222.ec2.internal", 
            "private_ip": "172.18.5.222", 
            "public_dns_name": "ec2-18-212-108-172.compute-1.amazonaws.com", 
            "public_ip": "18.212.108.172", 
            "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/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:22
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-08-05 11:29:03.163879", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.5.222.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/dae8b1fdd92e4c6b040802a9f6893334ae0660fd/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:61
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-08-05 11:29:03.607831", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_azure_39/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