Attachment 1464871 Details for Bug 1602120 – installation log with inventory file embedded

installation log with inventory file embedded

inventory_install.log (text/plain), 107.39 KB, created by Johnny Liu on 2018-07-20 07:48:37 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Johnny Liu

Created: 2018-07-20 07:48:37 UTC

Size: 107.39 KB

patch

obsolete

>[07:13:24] INFO> HTTP GET http://git.app.eng.bos.redhat.com/git/openshift-misc.git/plain/v3-launch-templates/functionality-testing/aos-3_11/inventory.openshift-ansible
>[07:13:24] INFO> HTTP GET took 0.134 sec: 200 OK | text/plain 37588 bytes
>
>Ansible inventory inventory.openshift-ansible:
>#openshift-ansible-inventory-start
>[OSEv3:children]
>masters
>nodes
>
>etcd
>
>
>
>
>
>
>
>
>
>[OSEv3:vars]
>
>#qe playbooks options start
>iaas_name=openstack_qeos10
>image=qe-rhel-7-release
>
>
>
>
>
>
>
>enable_internal_dns=true
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>qe_additional_repos=[{'id': 'rhel7', 'name': 'rhel7', 'baseurl': 'http://pulp.dist.prod.ext.phx2.redhat.com/content/dist/rhel/server/7/7Server/x86_64/os', 'enabled': 1, 'gpgcheck': 0},{'id': 'rhel7-extra', 'name': 'rhel7-extra', 'baseurl': 'http://pulp.dist.prod.ext.phx2.redhat.com/content/dist/rhel/server/7/7Server/x86_64/extras/os', 'enabled': 1, 'gpgcheck': 0},{'id': 'fast-datapath', 'name': 'fast-datapath', 'baseurl': 'http://pulp.dist.prod.ext.phx2.redhat.com/content/dist/rhel/server/7/7Server/x86_64/fast-datapath/os', 'enabled': 1, 'gpgcheck': 0}]
>os_update=false
>
>
>
>install_update_docker=true
>
>docker_storage_driver=devicemapper
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>qe_registry_url=registry.dev.redhat.io
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>internal_dns_subdomain=int.0720-h9z.qe.rhcloud.com
>
>
>
>
>
>
>
>
>
># qe playbook options end
>
>#openshift-ansible options start
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>openshift_additional_repos=[{'id': 'aos-3_11-devel-install', 'name': 'aos-3_11-devel-install', 'baseurl': 'http://download.eng.bos.redhat.com/rcm-guest/puddles/RHAOS/AtomicOpenShift/3.11/2018-07-19.1/x86_64/os/', 'enabled': 1, 'gpgcheck': 0}]
>
>
>
>openshift_master_default_subdomain_enable=true
>openshift_master_default_subdomain=apps.0720-h9z.qe.rhcloud.com
>
>
>
>
>
>openshift_auth_type=allowall
>
>openshift_master_identity_providers=[{'name': 'allow_all', 'login': 'true', 'challenge': 'true', 'kind': 'AllowAllPasswordIdentityProvider'}]
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>openshift_hosted_registry_storage_swift_authurl=https://ci-rhos.centralci.eng.rdu2.redhat.com:13000/v2.0/
>openshift_hosted_registry_storage_swift_username=openshift-qe-jenkins
>openshift_hosted_registry_storage_swift_password=uv[sV80Xn
>openshift_hosted_registry_storage_swift_tenantid=e0fa85b6a06443959d2d3b497174bed6
>openshift_hosted_registry_storage_swift_region=regionOne
>openshift_hosted_registry_storage_swift_container=osev3-docker-registry-data1
>
>
>
>
>
>
>
>
>openshift_deployment_type=openshift-enterprise
>oreg_url=registry.dev.redhat.io/openshift3/ose-${component}:${version}
>openshift_examples_modify_imagestreams=true
>openshift_docker_blocked_registries=registry.hacker.com
>osm_use_cockpit=false
>osm_cockpit_plugins=['cockpit-kubernetes']
>openshift_hosted_registry_selector="role=node,registry=enabled"
>openshift_hosted_router_selector="role=node,router=enabled"
>debug_level=5
>template_service_broker_selector={"role": "node"}
>ansible_service_broker_node_selector={"role": "node"}
>openshift_hosted_registry_storage_kind=object
>openshift_hosted_registry_storage_provider=swift
>openshift_check_min_host_disk_gb=2
>openshift_check_min_host_memory_gb=1
>oreg_auth_user=xxx
>oreg_auth_password=yyy
>
>
>qe_kubelet_args="[{'key': 'kubeletArguments.pods-per-core', 'value': ['0']}, {'key': 'kubeletArguments.minimum-container-ttl-duration', 'value': ['10s']}, {'key': 'kubeletArguments.maximum-dead-containers-per-container', 'value': ['1']}, {'key': 'kubeletArguments.maximum-dead-containers', 'value': ['20']}, {'key': 'kubeletArguments.image-gc-high-threshold', 'value': ['80']}, {'key': 'kubeletArguments.image-gc-low-threshold', 'value': ['70']}]"
>qe_node_group_all_in_one_1="{ 'name': 'qe-all-in-one-1', 'labels': ['node-role.kubernetes.io/master=true', 'node-role.kubernetes.io/infra=true', 'node-role.kubernetes.io/compute=true'], 'edits': {{ qe_kubelet_args }} }"
>qe_node_group_all_in_one_2="{ 'name': 'qe-all-in-one-2', 'labels': ['node-role.kubernetes.io/master=true', 'role=node', 'registry=enabled', 'router=enabled', 'node-role.kubernetes.io/compute=true'], 'edits': {{ qe_kubelet_args }} }"
>qe_node_group_registry_router="{ 'name': 'qe-registry-router', 'labels': ['role=node', 'registry=enabled', 'router=enabled'], 'edits': {{ qe_kubelet_args }} }"
>qe_node_group_registry="{ 'name': 'qe-registry', 'labels': ['role=node', 'registry=enabled'], 'edits': {{ qe_kubelet_args }} }"
>qe_node_group_router="{ 'name': 'qe-router', 'labels': ['role=node', 'router=enabled'], 'edits': {{ qe_kubelet_args }} }"
>qe_node_group_primary="{ 'name': 'qe-primary', 'labels': ['role=node', 'region=primary'], 'edits': {{ qe_kubelet_args }} }"
>qe_node_group_compute="{ 'name': 'qe-compute', 'labels': ['role=node', 'node-role.kubernetes.io/compute=true'], 'edits': {{ qe_kubelet_args }} }"
>qe_node_group_infra="{ 'name': 'qe-infra', 'labels': ['role=node', 'node-role.kubernetes.io/infra=true'], 'edits': {{ qe_kubelet_args }} }"
>qe_node_group_master="{ 'name': 'qe-master', 'labels': ['node-role.kubernetes.io/master=true'], 'edits': {{ qe_kubelet_args }} }"
>qe_node_group_glusterfs="{ 'name': 'qe-glusterfs', 'labels': ['role=node', 'region=glusterfs'], 'edits': {{ qe_kubelet_args }} }"
>qe_node_group_glusterfs_registry="{ 'name': 'qe-glusterfs-registry', 'labels': ['role=node', 'region=glusterfs-registry'], 'edits': {{ qe_kubelet_args }} }"
>
>
>openshift_node_groups=[{{ qe_node_group_all_in_one_1 }}, {{ qe_node_group_all_in_one_2 }}, {{ qe_node_group_registry_router }}, {{ qe_node_group_registry }}, {{ qe_node_group_router }}, {{ qe_node_group_primary }}, {{ qe_node_group_compute }}, {{ qe_node_group_master }}, {{ qe_node_group_infra }}, {{ qe_node_group_glusterfs }}, {{ qe_node_group_glusterfs_registry }}]
>
>
>#openshift-ansible options end
>
>
>
>#openshift host defination start
>[masters]
>host-8-249-227.host.centralci.eng.rdu2.redhat.com ansible_user=root ansible_ssh_user=root ansible_ssh_private_key_file="/home/slave1/workspace/Launch Environment Flexy/private/config/keys/libra.pem" openshift_public_hostname=host-8-249-227.host.centralci.eng.rdu2.redhat.com
>
>
>
>[nodes]
>host-8-249-227.host.centralci.eng.rdu2.redhat.com ansible_user=root ansible_ssh_user=root ansible_ssh_private_key_file="/home/slave1/workspace/Launch Environment Flexy/private/config/keys/libra.pem" openshift_public_hostname=host-8-249-227.host.centralci.eng.rdu2.redhat.com openshift_node_group_name='qe-all-in-one-2'
>
>
>
>
>[etcd]
>host-8-249-227.host.centralci.eng.rdu2.redhat.com ansible_user=root ansible_ssh_user=root ansible_ssh_private_key_file="/home/slave1/workspace/Launch Environment Flexy/private/config/keys/libra.pem" openshift_public_hostname=host-8-249-227.host.centralci.eng.rdu2.redhat.com
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>
>#openshift host defination end
>
>
>
># qe customized host defination start
># host defination for qe testing env setup with cephrbd storage
>
>
># host defination for automation
>
>
>
>
># host defination for smoke testing
>
>
># host defination for scaleup/rerun/uninstall
>
>
>
># qe customized host defination end
>#openshift-ansible-inventory-end
>############ ANSIBLE RUN: /home/slave1/workspace/Launch Environment Flexy/private-openshift-ansible/playbooks/prerequisites.yml ############################
>[07:13:24] INFO> Shell Commands: ANSIBLE_FORCE_COLOR=true
>ANSIBLE_CALLBACK_WHITELIST=profile_tasks
>["ansible-playbook", "-v", "-i", "/home/slave1/workspace/Launch Environment Flexy/workdir/prod-jenkins-slave-7-10.8.243.17-1-0/inventory.openshift-ansible", "/home/slave1/workspace/Launch Environment Flexy/private-openshift-ansible/playbooks/prerequisites.yml"]
>Using /etc/ansible/ansible.cfg as config file
>
>PLAY [Initialization Checkpoint Start] *****************************************
>
>TASK [Set install initialization 'In Progress'] ********************************
>Friday 20 July 2018  03:13:25 -0400 (0:00:00.079)       0:00:00.079 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_stats": {"aggregate": true, "data": {"installer_phase_initialize": {"playbook": "", "start": "20180720031325Z", "status": "In Progress", "title": "Initialization"}}, "per_host": false}, "changed": false}
>
>PLAY [Populate config host groups] *********************************************
>
>TASK [Load group name mapping variables] ***************************************
>Friday 20 July 2018  03:13:25 -0400 (0:00:00.095)       0:00:00.175 *********** 
>ok: [localhost] => {"ansible_facts": {"g_all_hosts": "{{ g_master_hosts | union(g_node_hosts) | union(g_etcd_hosts) | union(g_new_etcd_hosts) | union(g_lb_hosts) | union(g_nfs_hosts) | union(g_new_node_hosts)| union(g_new_master_hosts) | union(g_glusterfs_hosts) | union(g_glusterfs_registry_hosts) | default([]) }}", "g_etcd_hosts": "{{ groups.etcd | default([]) }}", "g_glusterfs_hosts": "{{ groups.glusterfs | default([]) }}", "g_glusterfs_registry_hosts": "{{ groups.glusterfs_registry | default(g_glusterfs_hosts) }}", "g_lb_hosts": "{{ groups.lb | default([]) }}", "g_master_hosts": "{{ groups.masters | default([]) }}", "g_new_etcd_hosts": "{{ groups.new_etcd | default([]) }}", "g_new_master_hosts": "{{ groups.new_masters | default([]) }}", "g_new_node_hosts": "{{ groups.new_nodes | default([]) }}", "g_nfs_hosts": "{{ groups.nfs | default([]) }}", "g_node_hosts": "{{ groups.nodes | default([]) }}"}, "ansible_included_var_files": ["/home/slave1/workspace/Launch Environment Flexy/private-openshift-ansible/playbooks/init/vars/cluster_hosts.yml"], "changed": false}
>
>TASK [Evaluate groups - g_etcd_hosts or g_new_etcd_hosts required] *************
>Friday 20 July 2018  03:13:25 -0400 (0:00:00.075)       0:00:00.250 *********** 
>skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Evaluate groups - g_master_hosts or g_new_master_hosts required] *********
>Friday 20 July 2018  03:13:25 -0400 (0:00:00.023)       0:00:00.274 *********** 
>skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Evaluate groups - g_node_hosts or g_new_node_hosts required] *************
>Friday 20 July 2018  03:13:25 -0400 (0:00:00.021)       0:00:00.296 *********** 
>skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Evaluate groups - g_lb_hosts required] ***********************************
>Friday 20 July 2018  03:13:25 -0400 (0:00:00.023)       0:00:00.319 *********** 
>skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Evaluate groups - g_nfs_hosts required] **********************************
>Friday 20 July 2018  03:13:25 -0400 (0:00:00.019)       0:00:00.338 *********** 
>skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Evaluate groups - g_nfs_hosts is single host] ****************************
>Friday 20 July 2018  03:13:25 -0400 (0:00:00.021)       0:00:00.360 *********** 
>skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Evaluate groups - g_glusterfs_hosts required] ****************************
>Friday 20 July 2018  03:13:25 -0400 (0:00:00.020)       0:00:00.381 *********** 
>skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Evaluate oo_all_hosts] ***************************************************
>Friday 20 July 2018  03:13:25 -0400 (0:00:00.019)       0:00:00.400 *********** 
>ok: [localhost] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"add_host": {"groups": ["oo_all_hosts"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com"}
>
>TASK [Evaluate oo_masters] *****************************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.054)       0:00:00.455 *********** 
>ok: [localhost] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"add_host": {"groups": ["oo_masters"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com"}
>
>TASK [Evaluate oo_first_master] ************************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.040)       0:00:00.496 *********** 
>ok: [localhost] => {"add_host": {"groups": ["oo_first_master"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false}
>
>TASK [Evaluate oo_new_etcd_to_config] ******************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.033)       0:00:00.530 *********** 
>
>TASK [Evaluate oo_masters_to_config] *******************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.018)       0:00:00.548 *********** 
>ok: [localhost] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"add_host": {"groups": ["oo_masters_to_config"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com"}
>
>TASK [Evaluate oo_etcd_to_config] **********************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.039)       0:00:00.588 *********** 
>ok: [localhost] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"add_host": {"groups": ["oo_etcd_to_config"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com"}
>
>TASK [Evaluate oo_first_etcd] **************************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.036)       0:00:00.625 *********** 
>ok: [localhost] => {"add_host": {"groups": ["oo_first_etcd"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false}
>
>TASK [Evaluate oo_etcd_hosts_to_upgrade] ***************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.033)       0:00:00.658 *********** 
>ok: [localhost] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"add_host": {"groups": ["oo_etcd_hosts_to_upgrade"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com"}
>
>TASK [Evaluate oo_etcd_hosts_to_backup] ****************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.034)       0:00:00.692 *********** 
>ok: [localhost] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"add_host": {"groups": ["oo_etcd_hosts_to_backup"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com"}
>
>TASK [Evaluate oo_nodes_to_config] *********************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.034)       0:00:00.727 *********** 
>ok: [localhost] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"add_host": {"groups": ["oo_nodes_to_config"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com"}
>
>TASK [Evaluate oo_nodes_to_bootstrap] ******************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.040)       0:00:00.767 *********** 
>ok: [localhost] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"add_host": {"groups": ["oo_nodes_to_bootstrap"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com"}
>
>TASK [Add masters to oo_nodes_to_bootstrap] ************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.039)       0:00:00.806 *********** 
>ok: [localhost] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"add_host": {"groups": ["oo_nodes_to_bootstrap"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com"}
>
>TASK [Evaluate oo_lb_to_config] ************************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.048)       0:00:00.854 *********** 
>
>TASK [Evaluate oo_nfs_to_config] ***********************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.018)       0:00:00.873 *********** 
>
>TASK [Evaluate oo_glusterfs_to_config] *****************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.018)       0:00:00.892 *********** 
>
>TASK [Evaluate oo_etcd_to_migrate] *********************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.021)       0:00:00.913 *********** 
>ok: [localhost] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"add_host": {"groups": ["oo_etcd_to_migrate"], "host_name": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "host_vars": {}}, "changed": false, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com"}
> [WARNING]: Could not match supplied host pattern, ignoring: oo_lb_to_config
>
> [WARNING]: Could not match supplied host pattern, ignoring: oo_nfs_to_config
>
>
>PLAY [Ensure that all non-node hosts are accessible] ***************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:13:26 -0400 (0:00:00.048)       0:00:00.962 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>PLAY [Initialize basic host facts] *********************************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:13:27 -0400 (0:00:00.752)       0:00:01.714 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [openshift_sanitize_inventory : include_tasks] ****************************
>Friday 20 July 2018  03:13:27 -0400 (0:00:00.489)       0:00:02.204 *********** 
>included: /home/slave1/workspace/Launch Environment Flexy/private-openshift-ansible/roles/openshift_sanitize_inventory/tasks/deprecations.yml for host-8-249-227.host.centralci.eng.rdu2.redhat.com
>
>TASK [openshift_sanitize_inventory : Check for usage of deprecated variables] ***
>Friday 20 July 2018  03:13:27 -0400 (0:00:00.069)       0:00:02.273 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"censored": "the output has been hidden due to the fact that 'no_log: true' was specified for this result", "changed": false}
>
>TASK [openshift_sanitize_inventory : debug] ************************************
>Friday 20 July 2018  03:13:27 -0400 (0:00:00.103)       0:00:02.377 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {}
>
>TASK [openshift_sanitize_inventory : set_stats] ********************************
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.035)       0:00:02.412 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Assign deprecated variables to correct counterparts] ***
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.036)       0:00:02.448 *********** 
>included: /home/slave1/workspace/Launch Environment Flexy/private-openshift-ansible/roles/openshift_sanitize_inventory/tasks/__deprecations_logging.yml for host-8-249-227.host.centralci.eng.rdu2.redhat.com
>included: /home/slave1/workspace/Launch Environment Flexy/private-openshift-ansible/roles/openshift_sanitize_inventory/tasks/__deprecations_metrics.yml for host-8-249-227.host.centralci.eng.rdu2.redhat.com
>
>TASK [openshift_sanitize_inventory : conditional_set_fact] *********************
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.077)       0:00:02.526 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {}, "changed": false}
>
>TASK [openshift_sanitize_inventory : set_fact] *********************************
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.105)       0:00:02.631 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift_logging_elasticsearch_ops_pvc_dynamic": "", "openshift_logging_elasticsearch_ops_pvc_prefix": "", "openshift_logging_elasticsearch_ops_pvc_size": "", "openshift_logging_elasticsearch_pvc_dynamic": "", "openshift_logging_elasticsearch_pvc_prefix": "", "openshift_logging_elasticsearch_pvc_size": ""}, "changed": false}
>
>TASK [openshift_sanitize_inventory : conditional_set_fact] *********************
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.071)       0:00:02.703 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {}, "changed": false}
>
>TASK [openshift_sanitize_inventory : Standardize on latest variable names] *****
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.107)       0:00:02.810 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"deployment_subtype": "basic", "openshift_deployment_subtype": "basic"}, "changed": false}
>
>TASK [openshift_sanitize_inventory : Normalize openshift_release] **************
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.064)       0:00:02.875 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Abort when openshift_release is invalid] ***
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.039)       0:00:02.915 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : include_tasks] ****************************
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.040)       0:00:02.955 *********** 
>included: /home/slave1/workspace/Launch Environment Flexy/private-openshift-ansible/roles/openshift_sanitize_inventory/tasks/unsupported.yml for host-8-249-227.host.centralci.eng.rdu2.redhat.com
>
>TASK [openshift_sanitize_inventory : Ensure that openshift_use_dnsmasq is true] ***
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.070)       0:00:03.025 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Ensure that openshift_node_dnsmasq_install_network_manager_hook is true] ***
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.041)       0:00:03.067 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : set_fact] *********************************
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.037)       0:00:03.105 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=openshift_hosted_registry_storage_kind)  => {"changed": false, "item": "openshift_hosted_registry_storage_kind", "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Ensure that dynamic provisioning is set if using dynamic storage] ***
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.080)       0:00:03.185 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Ensure the hosted registry's GlusterFS storage is configured correctly] ***
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.043)       0:00:03.229 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Ensure the hosted registry's GlusterFS storage is configured correctly] ***
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.036)       0:00:03.265 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Ensure clusterid is set along with the cloudprovider] ***
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.037)       0:00:03.304 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Ensure ansible_service_broker_remove and ansible_service_broker_install are mutually exclusive] ***
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.039)       0:00:03.343 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Ensure template_service_broker_remove and template_service_broker_install are mutually exclusive] ***
>Friday 20 July 2018  03:13:28 -0400 (0:00:00.037)       0:00:03.380 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Ensure that all requires vsphere configuration variables are set] ***
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.037)       0:00:03.418 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : ensure provider configuration variables are defined] ***
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.043)       0:00:03.462 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Ensure removed web console extension variables are not set] ***
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.037)       0:00:03.499 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : Ensure that web console port matches API server port] ***
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.036)       0:00:03.536 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_sanitize_inventory : At least one master is schedulable] *******
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.035)       0:00:03.572 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Detecting Operating System from ostree_booted] ***************************
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.059)       0:00:03.631 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "stat": {"exists": false}}
>
>TASK [set openshift_deployment_type if unset] **********************************
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.305)       0:00:03.937 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [check for node already bootstrapped] *************************************
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.034)       0:00:03.972 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "stat": {"exists": false}}
>
>TASK [initialize_facts set fact openshift_is_bootstrapped] *********************
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.186)       0:00:04.158 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift_is_bootstrapped": false}, "changed": false}
>
>TASK [initialize_facts set fact openshift_is_atomic and openshift_is_containerized] ***
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.059)       0:00:04.218 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift_is_atomic": false, "openshift_is_containerized": false}, "changed": false}
>
>TASK [Determine Atomic Host Docker Version] ************************************
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.058)       0:00:04.276 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [assert atomic host docker version is 1.12 or later] **********************
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.035)       0:00:04.311 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>PLAY [Retrieve existing master configs and validate] ***************************
>
>TASK [openshift_control_plane : stat] ******************************************
>Friday 20 July 2018  03:13:29 -0400 (0:00:00.040)       0:00:04.351 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "stat": {"exists": false}}
>
>TASK [openshift_control_plane : slurp] *****************************************
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.192)       0:00:04.544 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_control_plane : set_fact] **************************************
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.036)       0:00:04.581 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_control_plane : Check for file paths outside of /etc/origin/master in master's config] ***
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.038)       0:00:04.620 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_control_plane : set_fact] **************************************
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.034)       0:00:04.655 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [set_fact] ****************************************************************
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.033)       0:00:04.688 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [set_fact] ****************************************************************
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.038)       0:00:04.727 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>PLAY [Initialize special first-master variables] *******************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.039)       0:00:04.767 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [set_fact] ****************************************************************
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.485)       0:00:05.252 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [set_fact] ****************************************************************
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.037)       0:00:05.290 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"first_master_client_binary": "oc", "l_osm_default_node_selector": "node-role.kubernetes.io/compute=true", "openshift_client_binary": "oc"}, "changed": false}
>
>PLAY [Disable web console if required] *****************************************
>
>TASK [set_fact] ****************************************************************
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.068)       0:00:05.358 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>PLAY [Setup yum repositories for all hosts] ************************************
>
>TASK [rhel_subscribe : fail] ***************************************************
>Friday 20 July 2018  03:13:30 -0400 (0:00:00.049)       0:00:05.408 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [rhel_subscribe : Install Red Hat Subscription manager] *******************
>Friday 20 July 2018  03:13:31 -0400 (0:00:00.038)       0:00:05.446 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [rhel_subscribe : Is host already registered?] ****************************
>Friday 20 July 2018  03:13:31 -0400 (0:00:00.038)       0:00:05.485 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [rhel_subscribe : Register host] ******************************************
>Friday 20 July 2018  03:13:31 -0400 (0:00:00.038)       0:00:05.524 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [rhel_subscribe : fail] ***************************************************
>Friday 20 July 2018  03:13:31 -0400 (0:00:00.041)       0:00:05.565 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [rhel_subscribe : Determine if OpenShift Pool Already Attached] ***********
>Friday 20 July 2018  03:13:31 -0400 (0:00:00.040)       0:00:05.606 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [rhel_subscribe : Attach to OpenShift Pool] *******************************
>Friday 20 July 2018  03:13:31 -0400 (0:00:00.038)       0:00:05.644 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [rhel_subscribe : Satellite preparation] **********************************
>Friday 20 July 2018  03:13:31 -0400 (0:00:00.040)       0:00:05.685 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_repos : Ensure libselinux-python is installed] *****************
>Friday 20 July 2018  03:13:31 -0400 (0:00:00.041)       0:00:05.726 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"attempts": 1, "changed": false, "msg": "", "rc": 0, "results": ["libselinux-python-2.5-12.el7.x86_64 providing libselinux-python is already installed"]}
>
>TASK [openshift_repos : Remove openshift_additional.repo file] *****************
>Friday 20 July 2018  03:13:31 -0400 (0:00:00.630)       0:00:06.357 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "path": "/etc/yum.repos.d/openshift_additional.repo", "state": "absent"}
>
>TASK [openshift_repos : Create any additional repos that are defined] **********
>Friday 20 July 2018  03:13:32 -0400 (0:00:00.373)       0:00:06.730 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item={'gpgcheck': 0, 'enabled': 1, 'id': u'aos-3_11-devel-install', 'baseurl': u'http://download.eng.bos.redhat.com/rcm-guest/puddles/RHAOS/AtomicOpenShift/3.11/2018-07-19.1/x86_64/os/', 'name': u'aos-3_11-devel-install'}) => {"changed": true, "item": {"baseurl": "http://download.eng.bos.redhat.com/rcm-guest/puddles/RHAOS/AtomicOpenShift/3.11/2018-07-19.1/x86_64/os/", "enabled": 1, "gpgcheck": 0, "id": "aos-3_11-devel-install", "name": "aos-3_11-devel-install"}, "repo": "aos-3_11-devel-install", "state": "present"}
>
>TASK [openshift_repos : include_tasks] *****************************************
>Friday 20 July 2018  03:13:32 -0400 (0:00:00.378)       0:00:07.109 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_repos : include_tasks] *****************************************
>Friday 20 July 2018  03:13:32 -0400 (0:00:00.044)       0:00:07.154 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_repos : Ensure clean repo cache in the event repos have been changed manually] ***
>Friday 20 July 2018  03:13:32 -0400 (0:00:00.045)       0:00:07.199 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {
>    "msg": "First run of openshift_repos"
>}
>
>TASK [openshift_repos : Record that openshift_repos already ran] ***************
>Friday 20 July 2018  03:13:32 -0400 (0:00:00.112)       0:00:07.312 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"r_openshift_repos_has_run": true}, "changed": false}
>
>RUNNING HANDLER [openshift_repos : refresh cache] ******************************
>Friday 20 July 2018  03:13:32 -0400 (0:00:00.091)       0:00:07.404 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": true, "cmd": ["yum", "clean", "all"], "delta": "0:00:00.285472", "end": "2018-07-20 03:13:45.066309", "rc": 0, "start": "2018-07-20 03:13:44.780837", "stderr": "", "stderr_lines": [], "stdout": "Loaded plugins: product-id, search-disabled-repos, subscription-manager\nThis system is not registered with an entitlement server. You can use subscription-manager to register.\nCleaning repos: aos-3_11-devel-install fast-datapath rhel7 rhel7-extra\nCleaning up everything\nMaybe you want: rm -rf /var/cache/yum, to also free up space taken by orphaned data from disabled or removed repos", "stdout_lines": ["Loaded plugins: product-id, search-disabled-repos, subscription-manager", "This system is not registered with an entitlement server. You can use subscription-manager to register.", "Cleaning repos: aos-3_11-devel-install fast-datapath rhel7 rhel7-extra", "Cleaning up everything", "Maybe you want: rm -rf /var/cache/yum, to also free up space taken by orphaned data from disabled or removed repos"]}
>
>PLAY [Install packages necessary for installer] ********************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:13:33 -0400 (0:00:00.660)       0:00:08.064 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [Determine if chrony is installed] ****************************************
>Friday 20 July 2018  03:13:34 -0400 (0:00:00.578)       0:00:08.643 *********** 
> [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.
>
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": true, "cmd": ["rpm", "-q", "chrony"], "delta": "0:00:00.031438", "end": "2018-07-20 03:13:45.876064", "failed_when_result": false, "rc": 0, "start": "2018-07-20 03:13:45.844626", "stderr": "", "stderr_lines": [], "stdout": "chrony-3.2-2.el7.x86_64", "stdout_lines": ["chrony-3.2-2.el7.x86_64"]}
>
>TASK [Install ntp package] *****************************************************
>Friday 20 July 2018  03:13:34 -0400 (0:00:00.224)       0:00:08.867 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Start and enable ntpd/chronyd] *******************************************
>Friday 20 July 2018  03:13:34 -0400 (0:00:00.043)       0:00:08.911 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": true, "cmd": ["timedatectl", "set-ntp", "true"], "delta": "0:00:00.033878", "end": "2018-07-20 03:13:46.150745", "rc": 0, "start": "2018-07-20 03:13:46.116867", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}
>
>TASK [Ensure openshift-ansible installer package deps are installed] ***********
>Friday 20 July 2018  03:13:34 -0400 (0:00:00.228)       0:00:09.139 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=iproute) => {"attempts": 1, "changed": false, "item": "iproute", "msg": "", "rc": 0, "results": ["iproute-4.11.0-14.el7.x86_64 providing iproute is already installed"]}
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=dbus-python) => {"attempts": 1, "changed": false, "item": "dbus-python", "msg": "", "rc": 0, "results": ["dbus-python-1.1.1-9.el7.x86_64 providing dbus-python is already installed"]}
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=PyYAML) => {"attempts": 1, "changed": false, "item": "PyYAML", "msg": "", "rc": 0, "results": ["PyYAML-3.10-11.el7.x86_64 providing PyYAML is already installed"]}
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=python-ipaddress) => {"attempts": 1, "changed": false, "item": "python-ipaddress", "msg": "", "rc": 0, "results": ["python-ipaddress-1.0.16-2.el7.noarch providing python-ipaddress is already installed"]}
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=libsemanage-python) => {"attempts": 1, "changed": false, "item": "libsemanage-python", "msg": "", "rc": 0, "results": ["libsemanage-python-2.5-11.el7.x86_64 providing libsemanage-python is already installed"]}
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=yum-utils) => {"attempts": 1, "changed": true, "item": "yum-utils", "msg": "", "rc": 0, "results": ["Loaded plugins: product-id, search-disabled-repos, subscription-manager\nThis system is not registered with an entitlement server. You can use subscription-manager to register.\nResolving Dependencies\n--> Running transaction check\n---> Package yum-utils.noarch 0:1.1.31-45.el7 will be installed\n--> Processing Dependency: python-kitchen for package: yum-utils-1.1.31-45.el7.noarch\n--> Running transaction check\n---> Package python-kitchen.noarch 0:1.1.1-5.el7 will be installed\n--> Finished Dependency Resolution\n\nDependencies Resolved\n\n================================================================================\n Package               Arch          Version                 Repository    Size\n================================================================================\nInstalling:\n yum-utils             noarch        1.1.31-45.el7           rhel7        119 k\nInstalling for dependencies:\n python-kitchen        noarch        1.1.1-5.el7             rhel7        266 k\n\nTransaction Summary\n================================================================================\nInstall  1 Package (+1 Dependent package)\n\nTotal download size: 385 k\nInstalled size: 1.7 M\nDownloading packages:\n--------------------------------------------------------------------------------\nTotal                                              802 kB/s | 385 kB  00:00     \nRunning transaction check\nRunning transaction test\nTransaction test succeeded\nRunning transaction\n  Installing : python-kitchen-1.1.1-5.el7.noarch                            1/2 \n  Installing : yum-utils-1.1.31-45.el7.noarch                               2/2 \n  Verifying  : yum-utils-1.1.31-45.el7.noarch                               1/2 \n  Verifying  : python-kitchen-1.1.1-5.el7.noarch                            2/2 \n\nInstalled:\n  yum-utils.noarch 0:1.1.31-45.el7                                              \n\nDependency Installed:\n  python-kitchen.noarch 0:1.1.1-5.el7                                           \n\nComplete!\n"]}
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=python-docker) => {"attempts": 1, "changed": true, "item": "python-docker", "msg": "", "rc": 0, "results": ["Loaded plugins: product-id, search-disabled-repos, subscription-manager\nThis system is not registered with an entitlement server. You can use subscription-manager to register.\nResolving Dependencies\n--> Running transaction check\n---> Package python-docker.noarch 0:2.4.2-1.3.el7 will be installed\n--> Processing Dependency: python-websocket-client >= 0.32.0 for package: python-docker-2.4.2-1.3.el7.noarch\n--> Processing Dependency: python-docker-pycreds for package: python-docker-2.4.2-1.3.el7.noarch\n--> Running transaction check\n---> Package python-docker-pycreds.noarch 0:1.10.6-4.el7 will be installed\n---> Package python-websocket-client.noarch 0:0.32.0-116.el7 will be installed\n--> Finished Dependency Resolution\n\nDependencies Resolved\n\n================================================================================\n Package                  Arch    Version         Repository               Size\n================================================================================\nInstalling:\n python-docker            noarch  2.4.2-1.3.el7   aos-3_11-devel-install  167 k\nInstalling for dependencies:\n python-docker-pycreds    noarch  1.10.6-4.el7    rhel7-extra              18 k\n python-websocket-client  noarch  0.32.0-116.el7  rhel7-extra              56 k\n\nTransaction Summary\n================================================================================\nInstall  1 Package (+2 Dependent packages)\n\nTotal download size: 241 k\nInstalled size: 996 k\nDownloading packages:\n--------------------------------------------------------------------------------\nTotal                                              826 kB/s | 241 kB  00:00     \nRunning transaction check\nRunning transaction test\nTransaction test succeeded\nRunning transaction\n  Installing : python-docker-pycreds-1.10.6-4.el7.noarch                    1/3 \n  Installing : python-websocket-client-0.32.0-116.el7.noarch                2/3 \n  Installing : python-docker-2.4.2-1.3.el7.noarch                           3/3 \n  Verifying  : python-docker-2.4.2-1.3.el7.noarch                           1/3 \n  Verifying  : python-websocket-client-0.32.0-116.el7.noarch                2/3 \n  Verifying  : python-docker-pycreds-1.10.6-4.el7.noarch                    3/3 \n\nInstalled:\n  python-docker.noarch 0:2.4.2-1.3.el7                                          \n\nDependency Installed:\n  python-docker-pycreds.noarch 0:1.10.6-4.el7                                   \n  python-websocket-client.noarch 0:0.32.0-116.el7                               \n\nComplete!\n"]}
>
>PLAY [Initialize cluster facts] ************************************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:15:25 -0400 (0:01:50.383)       0:01:59.523 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [get openshift_current_version] *******************************************
>Friday 20 July 2018  03:15:25 -0400 (0:00:00.503)       0:02:00.026 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {}, "changed": false}
>
>TASK [set_fact openshift_portal_net if present on masters] *********************
>Friday 20 July 2018  03:15:25 -0400 (0:00:00.334)       0:02:00.361 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Gather Cluster facts] ****************************************************
>Friday 20 July 2018  03:15:26 -0400 (0:00:00.059)       0:02:00.420 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift": {"common": {"all_hostnames": ["10.8.249.227", "172.16.120.48", "qe-jialiu3112-mrre-1", "host-8-249-227.host.centralci.eng.rdu2.redhat.com"], "config_base": "/etc/origin", "dns_domain": "cluster.local", "generate_no_proxy_hosts": true, "hostname": "qe-jialiu3112-mrre-1", "internal_hostnames": ["qe-jialiu3112-mrre-1", "172.16.120.48"], "ip": "172.16.120.48", "kube_svc_ip": "172.30.0.1", "portal_net": "172.30.0.0/16", "public_hostname": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "public_ip": "10.8.249.227", "raw_hostname": "qe-jialiu3112-mrre-1"}, "current_config": {}, "provider": {"metadata": {"availability_zone": "nova", "devices": [], "ec2_compat": {"ami-id": "ami-00009e4f", "ami-launch-index": "0", "ami-manifest-path": "FIXME", "block-device-mapping": {"ami": "vda", "root": "/dev/vda"}, "hostname": "qe-jialiu3112-mrre-1", "instance-action": "none", "instance-id": "i-00803d63", "instance-type": "m1.medium", "local-hostname": "qe-jialiu3112-mrre-1", "local-ipv4": "172.16.120.48", "placement": {"availability-zone": "nova"}, "public-hostname": "qe-jialiu3112-mrre-1", "public-ipv4": "10.8.249.227", "public-keys/": "0=libra", "reservation-id": "r-6b0upvnn", "security-groups": "default"}, "hostname": "qe-jialiu3112-mrre-1", "keys": [{"data": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDUq7W38xCZ9WGSWCvustaMGMT04tRohw6AKGzI7P7xql5lhCAReyt72n9qWQRZsE1YiCSQuTfXI1oc8NpSM7+lMLwj12G8z3I1YT31JHr9LLYg/XIcExkzfBI920CaS82VqmKOpI9+ARHSJBdIbKRI0f5Y+u4xbc5UzKCJX8jcKGG7nEiw8zm+cvAlfOgssMK+qJppIbVcb2iZNTsw5i2aX6FDMyC+b17DQHzBGpNbhZYxuoERZVRcnYctgIzuo6fD60gniX0fVvrchlOnubB1sRYbloP2r6UE22w/dpLKOFE5i7CA0ZzNBERZ94cIKumIH9MiJs1a6bMe89VOjjNV", "name": "libra", "type": "ssh"}], "launch_index": 0, "name": "qe-jialiu3112-mrre-1", "project_id": "e0fa85b6a06443959d2d3b497174bed6", "uuid": "dcd2f8da-99ba-4181-9e94-d139a7cfba54"}, "name": "openstack", "network": {"hostname": "qe-jialiu3112-mrre-1", "interfaces": [], "ip": "172.16.120.48", "ipv6_enabled": false, "public_hostname": "10.8.249.227", "public_ip": "10.8.249.227"}, "zone": "nova"}}}, "changed": true}
>
>TASK [Set fact of no_proxy_internal_hostnames] *********************************
>Friday 20 July 2018  03:15:29 -0400 (0:00:03.617)       0:02:04.038 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Initialize openshift.node.sdn_mtu] ***************************************
>Friday 20 July 2018  03:15:29 -0400 (0:00:00.037)       0:02:04.076 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift": {"common": {"all_hostnames": ["10.8.249.227", "172.16.120.48", "qe-jialiu3112-mrre-1", "host-8-249-227.host.centralci.eng.rdu2.redhat.com"], "config_base": "/etc/origin", "dns_domain": "cluster.local", "generate_no_proxy_hosts": true, "hostname": "qe-jialiu3112-mrre-1", "internal_hostnames": ["qe-jialiu3112-mrre-1", "172.16.120.48"], "ip": "172.16.120.48", "kube_svc_ip": "172.30.0.1", "portal_net": "172.30.0.0/16", "public_hostname": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "public_ip": "10.8.249.227", "raw_hostname": "qe-jialiu3112-mrre-1"}, "current_config": {"roles": ["node"]}, "node": {"bootstrapped": false, "nodename": "qe-jialiu3112-mrre-1", "sdn_mtu": "1450"}, "provider": {"metadata": {"availability_zone": "nova", "devices": [], "ec2_compat": {"ami-id": "ami-00009e4f", "ami-launch-index": "0", "ami-manifest-path": "FIXME", "block-device-mapping": {"ami": "vda", "root": "/dev/vda"}, "hostname": "qe-jialiu3112-mrre-1", "instance-action": "none", "instance-id": "i-00803d63", "instance-type": "m1.medium", "local-hostname": "qe-jialiu3112-mrre-1", "local-ipv4": "172.16.120.48", "placement": {"availability-zone": "nova"}, "public-hostname": "qe-jialiu3112-mrre-1", "public-ipv4": "10.8.249.227", "public-keys/": "0=libra", "reservation-id": "r-6b0upvnn", "security-groups": "default"}, "hostname": "qe-jialiu3112-mrre-1", "keys": [{"data": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDUq7W38xCZ9WGSWCvustaMGMT04tRohw6AKGzI7P7xql5lhCAReyt72n9qWQRZsE1YiCSQuTfXI1oc8NpSM7+lMLwj12G8z3I1YT31JHr9LLYg/XIcExkzfBI920CaS82VqmKOpI9+ARHSJBdIbKRI0f5Y+u4xbc5UzKCJX8jcKGG7nEiw8zm+cvAlfOgssMK+qJppIbVcb2iZNTsw5i2aX6FDMyC+b17DQHzBGpNbhZYxuoERZVRcnYctgIzuo6fD60gniX0fVvrchlOnubB1sRYbloP2r6UE22w/dpLKOFE5i7CA0ZzNBERZ94cIKumIH9MiJs1a6bMe89VOjjNV", "name": "libra", "type": "ssh"}], "launch_index": 0, "name": "qe-jialiu3112-mrre-1", "project_id": "e0fa85b6a06443959d2d3b497174bed6", "uuid": "dcd2f8da-99ba-4181-9e94-d139a7cfba54"}, "name": "openstack", "network": {"hostname": "qe-jialiu3112-mrre-1", "interfaces": [], "ip": "172.16.120.48", "ipv6_enabled": false, "public_hostname": "10.8.249.227", "public_ip": "10.8.249.227"}, "zone": "nova"}}}, "changed": true}
>
>PLAY [Initialize etcd host variables] ******************************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:15:31 -0400 (0:00:01.706)       0:02:05.783 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [set_fact] ****************************************************************
>Friday 20 July 2018  03:15:31 -0400 (0:00:00.505)       0:02:06.289 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift_master_etcd_hosts": ["qe-jialiu3112-mrre-1"], "openshift_master_etcd_port": "2379", "openshift_no_proxy_etcd_host_ips": "172.16.120.48"}, "changed": false}
>
>TASK [set_fact] ****************************************************************
>Friday 20 July 2018  03:15:31 -0400 (0:00:00.109)       0:02:06.398 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift_master_etcd_urls": ["https://qe-jialiu3112-mrre-1:2379"]}, "changed": false}
>
>PLAY [Determine openshift_version to configure on first master] ****************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:15:32 -0400 (0:00:00.077)       0:02:06.475 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [include_role : openshift_version] ****************************************
>Friday 20 July 2018  03:15:32 -0400 (0:00:00.504)       0:02:06.980 *********** 
>
>TASK [openshift_version : Use openshift_current_version fact as version to configure if already installed] ***
>Friday 20 July 2018  03:15:32 -0400 (0:00:00.086)       0:02:07.066 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_version : Set openshift_version to openshift_release if undefined] ***
>Friday 20 July 2018  03:15:32 -0400 (0:00:00.039)       0:02:07.106 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift_version": "3.11"}, "changed": false}
>
>TASK [openshift_version : debug] ***********************************************
>Friday 20 July 2018  03:15:32 -0400 (0:00:00.125)       0:02:07.232 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {
>    "msg": "openshift_pkg_version was not defined. Falling back to -3.11"
>}
>
>TASK [openshift_version : set_fact] ********************************************
>Friday 20 July 2018  03:15:32 -0400 (0:00:00.067)       0:02:07.300 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift_pkg_version": "-3.11*"}, "changed": false}
>
>TASK [openshift_version : debug] ***********************************************
>Friday 20 July 2018  03:15:32 -0400 (0:00:00.068)       0:02:07.368 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {
>    "msg": "openshift_image_tag was not defined. Falling back to v3.11"
>}
>
>TASK [openshift_version : set_fact] ********************************************
>Friday 20 July 2018  03:15:33 -0400 (0:00:00.067)       0:02:07.436 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift_image_tag": "v3.11"}, "changed": false}
>
>TASK [openshift_version : assert openshift_release in openshift_image_tag] *****
>Friday 20 July 2018  03:15:33 -0400 (0:00:00.069)       0:02:07.505 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {
>    "changed": false, 
>    "msg": "All assertions passed"
>}
>
>TASK [openshift_version : assert openshift_release in openshift_pkg_version] ***
>Friday 20 July 2018  03:15:33 -0400 (0:00:00.132)       0:02:07.638 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {
>    "changed": false, 
>    "msg": "All assertions passed"
>}
>
>TASK [openshift_version : debug] ***********************************************
>Friday 20 July 2018  03:15:33 -0400 (0:00:00.133)       0:02:07.772 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {
>    "openshift_release": "3.11"
>}
>
>TASK [openshift_version : debug] ***********************************************
>Friday 20 July 2018  03:15:33 -0400 (0:00:00.121)       0:02:07.893 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {
>    "openshift_image_tag": "v3.11"
>}
>
>TASK [openshift_version : debug] ***********************************************
>Friday 20 July 2018  03:15:33 -0400 (0:00:00.113)       0:02:08.007 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {
>    "openshift_pkg_version": "-3.11*"
>}
>
>TASK [openshift_version : debug] ***********************************************
>Friday 20 July 2018  03:15:33 -0400 (0:00:00.112)       0:02:08.119 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {
>    "openshift_version": "3.11"
>}
>
>TASK [set openshift_version booleans (first master)] ***************************
>Friday 20 July 2018  03:15:33 -0400 (0:00:00.067)       0:02:08.187 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"openshift_examples_content_version": "v3.11", "openshift_version_gte_3_10": true, "openshift_version_gte_3_11": true}, "changed": false, "msg": "Version facts set"}
>
>PLAY [Set openshift_version for etcd, node, and master hosts] ******************
>skipping: no hosts matched
>
>PLAY [Verify Requirements] *****************************************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:15:33 -0400 (0:00:00.075)       0:02:08.262 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [Run variable sanity checks] **********************************************
>Friday 20 July 2018  03:15:34 -0400 (0:00:00.579)       0:02:08.842 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "msg": "Sanity Checks passed"}
>
>TASK [Validate openshift_node_groups and openshift_node_group_name] ************
>Friday 20 July 2018  03:15:35 -0400 (0:00:01.003)       0:02:09.845 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "msg": "Node group checks passed"}
>
>PLAY [Initialization Checkpoint End] *******************************************
>
>TASK [Set install initialization 'Complete'] ***********************************
>Friday 20 July 2018  03:15:35 -0400 (0:00:00.166)       0:02:10.011 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_stats": {"aggregate": true, "data": {"installer_phase_initialize": {"end": "20180720031535Z", "status": "Complete"}}, "per_host": false}, "changed": false}
>
>PLAY [Validate node hostnames] *************************************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:15:35 -0400 (0:00:00.131)       0:02:10.142 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [Query DNS for IP address of qe-jialiu3112-mrre-1] ************************
>Friday 20 July 2018  03:15:36 -0400 (0:00:00.587)       0:02:10.730 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "cmd": "getent ahostsv4 qe-jialiu3112-mrre-1 | head -n 1 | awk '{ print $1 }'", "delta": "0:00:00.006715", "end": "2018-07-20 03:15:48.009602", "failed_when_result": false, "rc": 0, "start": "2018-07-20 03:15:48.002887", "stderr": "", "stderr_lines": [], "stdout": "172.16.120.48", "stdout_lines": ["172.16.120.48"]}
>
>TASK [Validate openshift_hostname when defined] ********************************
>Friday 20 July 2018  03:15:36 -0400 (0:00:00.268)       0:02:10.998 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [Validate openshift_ip exists on node when defined] ***********************
>Friday 20 July 2018  03:15:36 -0400 (0:00:00.049)       0:02:11.048 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>PLAY [Configure os_firewall] ***************************************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:15:36 -0400 (0:00:00.055)       0:02:11.104 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [os_firewall : Fail - Firewalld is not supported on Atomic Host] **********
>Friday 20 July 2018  03:15:37 -0400 (0:00:00.565)       0:02:11.670 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [os_firewall : Install firewalld packages] ********************************
>Friday 20 July 2018  03:15:37 -0400 (0:00:00.039)       0:02:11.710 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [os_firewall : Ensure iptables services are not enabled] ******************
>Friday 20 July 2018  03:15:37 -0400 (0:00:00.043)       0:02:11.753 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=iptables)  => {"changed": false, "item": "iptables", "skip_reason": "Conditional result was False"}
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=ip6tables)  => {"changed": false, "item": "ip6tables", "skip_reason": "Conditional result was False"}
>
>TASK [os_firewall : Wait 10 seconds after disabling iptables] ******************
>Friday 20 July 2018  03:15:37 -0400 (0:00:00.135)       0:02:11.888 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [os_firewall : Start and enable firewalld service] ************************
>Friday 20 July 2018  03:15:37 -0400 (0:00:00.038)       0:02:11.927 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [os_firewall : need to pause here, otherwise the firewalld service starting can sometimes cause ssh to fail] ***
>Friday 20 July 2018  03:15:37 -0400 (0:00:00.038)       0:02:11.966 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [os_firewall : Restart polkitd] *******************************************
>Friday 20 July 2018  03:15:37 -0400 (0:00:00.045)       0:02:12.011 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [os_firewall : Wait for polkit action to have been created] ***************
>Friday 20 July 2018  03:15:37 -0400 (0:00:00.039)       0:02:12.050 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [os_firewall : Ensure firewalld service is not enabled] *******************
>Friday 20 July 2018  03:15:37 -0400 (0:00:00.038)       0:02:12.089 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": true, "enabled": false, "failed_when_result": false, "name": "firewalld", "state": "stopped", "status": {"ActiveEnterTimestamp": "Fri 2018-07-20 03:10:09 EDT", "ActiveEnterTimestampMonotonic": "3512903", "ActiveExitTimestampMonotonic": "0", "ActiveState": "active", "After": "polkit.service system.slice basic.target dbus.service", "AllowIsolate": "no", "AmbientCapabilities": "0", "AssertResult": "yes", "AssertTimestamp": "Fri 2018-07-20 03:10:09 EDT", "AssertTimestampMonotonic": "3136448", "Before": "network-pre.target multi-user.target shutdown.target", "BlockIOAccounting": "no", "BlockIOWeight": "18446744073709551615", "BusName": "org.fedoraproject.FirewallD1", "CPUAccounting": "no", "CPUQuotaPerSecUSec": "infinity", "CPUSchedulingPolicy": "0", "CPUSchedulingPriority": "0", "CPUSchedulingResetOnFork": "no", "CPUShares": "18446744073709551615", "CanIsolate": "no", "CanReload": "yes", "CanStart": "yes", "CanStop": "yes", "CapabilityBoundingSet": "18446744073709551615", "ConditionResult": "yes", "ConditionTimestamp": "Fri 2018-07-20 03:10:09 EDT", "ConditionTimestampMonotonic": "3136447", "Conflicts": "shutdown.target ebtables.service iptables.service ip6tables.service ipset.service", "ControlGroup": "/system.slice/firewalld.service", "ControlPID": "0", "DefaultDependencies": "yes", "Delegate": "no", "Description": "firewalld - dynamic firewall daemon", "DevicePolicy": "auto", "Documentation": "man:firewalld(1)", "EnvironmentFile": "/etc/sysconfig/firewalld (ignore_errors=yes)", "ExecMainCode": "0", "ExecMainExitTimestampMonotonic": "0", "ExecMainPID": "630", "ExecMainStartTimestamp": "Fri 2018-07-20 03:10:09 EDT", "ExecMainStartTimestampMonotonic": "3138791", "ExecMainStatus": "0", "ExecReload": "{ path=/bin/kill ; argv[]=/bin/kill -HUP $MAINPID ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "ExecStart": "{ path=/usr/sbin/firewalld ; argv[]=/usr/sbin/firewalld --nofork --nopid $FIREWALLD_ARGS ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "FailureAction": "none", "FileDescriptorStoreMax": "0", "FragmentPath": "/usr/lib/systemd/system/firewalld.service", "GuessMainPID": "yes", "IOScheduling": "0", "Id": "firewalld.service", "IgnoreOnIsolate": "no", "IgnoreOnSnapshot": "no", "IgnoreSIGPIPE": "yes", "InactiveEnterTimestampMonotonic": "0", "InactiveExitTimestamp": "Fri 2018-07-20 03:10:09 EDT", "InactiveExitTimestampMonotonic": "3138823", "JobTimeoutAction": "none", "JobTimeoutUSec": "0", "KillMode": "mixed", "KillSignal": "15", "LimitAS": "18446744073709551615", "LimitCORE": "18446744073709551615", "LimitCPU": "18446744073709551615", "LimitDATA": "18446744073709551615", "LimitFSIZE": "18446744073709551615", "LimitLOCKS": "18446744073709551615", "LimitMEMLOCK": "65536", "LimitMSGQUEUE": "819200", "LimitNICE": "0", "LimitNOFILE": "4096", "LimitNPROC": "15055", "LimitRSS": "18446744073709551615", "LimitRTPRIO": "0", "LimitRTTIME": "18446744073709551615", "LimitSIGPENDING": "15055", "LimitSTACK": "18446744073709551615", "LoadState": "loaded", "MainPID": "630", "MemoryAccounting": "no", "MemoryCurrent": "18446744073709551615", "MemoryLimit": "18446744073709551615", "MountFlags": "0", "Names": "firewalld.service", "NeedDaemonReload": "no", "Nice": "0", "NoNewPrivileges": "no", "NonBlocking": "no", "NotifyAccess": "none", "OOMScoreAdjust": "0", "OnFailureJobMode": "replace", "PermissionsStartOnly": "no", "PrivateDevices": "no", "PrivateNetwork": "no", "PrivateTmp": "no", "ProtectHome": "no", "ProtectSystem": "no", "RefuseManualStart": "no", "RefuseManualStop": "no", "RemainAfterExit": "no", "Requires": "basic.target", "Restart": "no", "RestartUSec": "100ms", "Result": "success", "RootDirectoryStartOnly": "no", "RuntimeDirectoryMode": "0755", "SameProcessGroup": "no", "SecureBits": "0", "SendSIGHUP": "no", "SendSIGKILL": "yes", "Slice": "system.slice", "StandardError": "null", "StandardInput": "null", "StandardOutput": "null", "StartLimitAction": "none", "StartLimitBurst": "5", "StartLimitInterval": "10000000", "StartupBlockIOWeight": "18446744073709551615", "StartupCPUShares": "18446744073709551615", "StatusErrno": "0", "StopWhenUnneeded": "no", "SubState": "running", "SyslogLevelPrefix": "yes", "SyslogPriority": "30", "SystemCallErrorNumber": "0", "TTYReset": "no", "TTYVHangup": "no", "TTYVTDisallocate": "no", "TasksAccounting": "no", "TasksCurrent": "18446744073709551615", "TasksMax": "18446744073709551615", "TimeoutStartUSec": "1min 30s", "TimeoutStopUSec": "1min 30s", "TimerSlackNSec": "50000", "Transient": "no", "Type": "dbus", "UMask": "0022", "UnitFilePreset": "enabled", "UnitFileState": "enabled", "WantedBy": "multi-user.target", "Wants": "network-pre.target system.slice", "WatchdogTimestamp": "Fri 2018-07-20 03:10:09 EDT", "WatchdogTimestampMonotonic": "3512600", "WatchdogUSec": "0"}}
>
>TASK [os_firewall : Wait 10 seconds after disabling firewalld] *****************
>Friday 20 July 2018  03:15:38 -0400 (0:00:01.121)       0:02:13.211 *********** 
>Pausing for 10 seconds
>(ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "delta": 10, "echo": true, "rc": 0, "start": "2018-07-20 03:15:38.846976", "stderr": "", "stdout": "Paused for 10.0 seconds", "stop": "2018-07-20 03:15:48.847174", "user_input": ""}
>
>TASK [os_firewall : Install iptables packages] *********************************
>Friday 20 July 2018  03:15:48 -0400 (0:00:10.069)       0:02:23.281 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=iptables) => {"attempts": 1, "changed": false, "item": "iptables", "msg": "", "rc": 0, "results": ["iptables-1.4.21-24.1.el7_5.x86_64 providing iptables is already installed"]}
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=iptables-services) => {"attempts": 1, "changed": true, "item": "iptables-services", "msg": "", "rc": 0, "results": ["Loaded plugins: product-id, search-disabled-repos, subscription-manager\nThis system is not registered with an entitlement server. You can use subscription-manager to register.\nResolving Dependencies\n--> Running transaction check\n---> Package iptables-services.x86_64 0:1.4.21-24.1.el7_5 will be installed\n--> Finished Dependency Resolution\n\nDependencies Resolved\n\n================================================================================\n Package                 Arch         Version                 Repository   Size\n================================================================================\nInstalling:\n iptables-services       x86_64       1.4.21-24.1.el7_5       rhel7        51 k\n\nTransaction Summary\n================================================================================\nInstall  1 Package\n\nTotal download size: 51 k\nInstalled size: 25 k\nDownloading packages:\nRunning transaction check\nRunning transaction test\nTransaction test succeeded\nRunning transaction\n  Installing : iptables-services-1.4.21-24.1.el7_5.x86_64                   1/1 \n  Verifying  : iptables-services-1.4.21-24.1.el7_5.x86_64                   1/1 \n\nInstalled:\n  iptables-services.x86_64 0:1.4.21-24.1.el7_5                                  \n\nComplete!\n"]}
>
>TASK [os_firewall : Start and enable iptables service] *************************
>Friday 20 July 2018  03:15:53 -0400 (0:00:05.008)       0:02:28.290 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com -> host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item=host-8-249-227.host.centralci.eng.rdu2.redhat.com) => {"changed": true, "enabled": true, "item": "host-8-249-227.host.centralci.eng.rdu2.redhat.com", "name": "iptables", "state": "started", "status": {"ActiveEnterTimestampMonotonic": "0", "ActiveExitTimestampMonotonic": "0", "ActiveState": "inactive", "After": "basic.target system.slice systemd-journald.socket syslog.target", "AllowIsolate": "no", "AmbientCapabilities": "0", "AssertResult": "no", "AssertTimestampMonotonic": "0", "Before": "ip6tables.service network.service shutdown.target", "BlockIOAccounting": "no", "BlockIOWeight": "18446744073709551615", "CPUAccounting": "no", "CPUQuotaPerSecUSec": "infinity", "CPUSchedulingPolicy": "0", "CPUSchedulingPriority": "0", "CPUSchedulingResetOnFork": "no", "CPUShares": "18446744073709551615", "CanIsolate": "no", "CanReload": "yes", "CanStart": "yes", "CanStop": "yes", "CapabilityBoundingSet": "18446744073709551615", "ConditionResult": "no", "ConditionTimestampMonotonic": "0", "Conflicts": "shutdown.target", "ControlPID": "0", "DefaultDependencies": "yes", "Delegate": "no", "Description": "IPv4 firewall with iptables", "DevicePolicy": "auto", "Environment": "BOOTUP=serial CONSOLETYPE=serial", "ExecMainCode": "0", "ExecMainExitTimestampMonotonic": "0", "ExecMainPID": "0", "ExecMainStartTimestampMonotonic": "0", "ExecMainStatus": "0", "ExecReload": "{ path=/usr/libexec/iptables/iptables.init ; argv[]=/usr/libexec/iptables/iptables.init reload ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "ExecStart": "{ path=/usr/libexec/iptables/iptables.init ; argv[]=/usr/libexec/iptables/iptables.init start ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "ExecStop": "{ path=/usr/libexec/iptables/iptables.init ; argv[]=/usr/libexec/iptables/iptables.init stop ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "FailureAction": "none", "FileDescriptorStoreMax": "0", "FragmentPath": "/usr/lib/systemd/system/iptables.service", "GuessMainPID": "yes", "IOScheduling": "0", "Id": "iptables.service", "IgnoreOnIsolate": "no", "IgnoreOnSnapshot": "no", "IgnoreSIGPIPE": "yes", "InactiveEnterTimestampMonotonic": "0", "InactiveExitTimestampMonotonic": "0", "JobTimeoutAction": "none", "JobTimeoutUSec": "0", "KillMode": "control-group", "KillSignal": "15", "LimitAS": "18446744073709551615", "LimitCORE": "18446744073709551615", "LimitCPU": "18446744073709551615", "LimitDATA": "18446744073709551615", "LimitFSIZE": "18446744073709551615", "LimitLOCKS": "18446744073709551615", "LimitMEMLOCK": "65536", "LimitMSGQUEUE": "819200", "LimitNICE": "0", "LimitNOFILE": "4096", "LimitNPROC": "15055", "LimitRSS": "18446744073709551615", "LimitRTPRIO": "0", "LimitRTTIME": "18446744073709551615", "LimitSIGPENDING": "15055", "LimitSTACK": "18446744073709551615", "LoadState": "loaded", "MainPID": "0", "MemoryAccounting": "no", "MemoryCurrent": "18446744073709551615", "MemoryLimit": "18446744073709551615", "MountFlags": "0", "Names": "iptables.service", "NeedDaemonReload": "no", "Nice": "0", "NoNewPrivileges": "no", "NonBlocking": "no", "NotifyAccess": "none", "OOMScoreAdjust": "0", "OnFailureJobMode": "replace", "PermissionsStartOnly": "no", "PrivateDevices": "no", "PrivateNetwork": "no", "PrivateTmp": "no", "ProtectHome": "no", "ProtectSystem": "no", "RefuseManualStart": "no", "RefuseManualStop": "no", "RemainAfterExit": "yes", "Requires": "basic.target", "Restart": "no", "RestartUSec": "100ms", "Result": "success", "RootDirectoryStartOnly": "no", "RuntimeDirectoryMode": "0755", "SameProcessGroup": "no", "SecureBits": "0", "SendSIGHUP": "no", "SendSIGKILL": "yes", "Slice": "system.slice", "StandardError": "syslog", "StandardInput": "null", "StandardOutput": "syslog", "StartLimitAction": "none", "StartLimitBurst": "5", "StartLimitInterval": "10000000", "StartupBlockIOWeight": "18446744073709551615", "StartupCPUShares": "18446744073709551615", "StatusErrno": "0", "StopWhenUnneeded": "no", "SubState": "dead", "SyslogLevelPrefix": "yes", "SyslogPriority": "30", "SystemCallErrorNumber": "0", "TTYReset": "no", "TTYVHangup": "no", "TTYVTDisallocate": "no", "TasksAccounting": "no", "TasksCurrent": "18446744073709551615", "TasksMax": "18446744073709551615", "TimeoutStartUSec": "0", "TimeoutStopUSec": "1min 30s", "TimerSlackNSec": "50000", "Transient": "no", "Type": "oneshot", "UMask": "0022", "UnitFilePreset": "disabled", "UnitFileState": "disabled", "Wants": "system.slice", "WatchdogTimestampMonotonic": "0", "WatchdogUSec": "0"}}
>
>TASK [os_firewall : need to pause here, otherwise the iptables service starting can sometimes cause ssh to fail] ***
>Friday 20 July 2018  03:15:54 -0400 (0:00:00.414)       0:02:28.704 *********** 
>Pausing for 10 seconds
>(ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "delta": 10, "echo": true, "rc": 0, "start": "2018-07-20 03:15:54.341484", "stderr": "", "stdout": "Paused for 10.0 seconds", "stop": "2018-07-20 03:16:04.341680", "user_input": ""}
>
>PLAY [oo_nodes_to_config] ******************************************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:16:04 -0400 (0:00:10.080)       0:02:38.784 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [container_runtime : Setup the docker-storage for overlay] ****************
>Friday 20 July 2018  03:16:04 -0400 (0:00:00.519)       0:02:39.304 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Create file system on extra volume device] ***********
>Friday 20 July 2018  03:16:04 -0400 (0:00:00.040)       0:02:39.344 *********** 
>
>TASK [container_runtime : Create mount entry for extra volume] *****************
>Friday 20 July 2018  03:16:04 -0400 (0:00:00.037)       0:02:39.382 *********** 
>
>PLAY [oo_nodes_to_config] ******************************************************
>
>TASK [Gathering Facts] *********************************************************
>Friday 20 July 2018  03:16:05 -0400 (0:00:00.055)       0:02:39.437 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]
>
>TASK [openshift_excluder : Install docker excluder - yum] **********************
>Friday 20 July 2018  03:16:05 -0400 (0:00:00.535)       0:02:39.972 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"attempts": 1, "changed": false, "msg": "", "rc": 0, "results": ["atomic-openshift-docker-excluder-3.11.0-0.7.0.git.0.729a519.el7.noarch providing atomic-openshift-docker-excluder-3.11** is already installed"]}
>
>TASK [openshift_excluder : Install docker excluder - dnf] **********************
>Friday 20 July 2018  03:16:08 -0400 (0:00:02.558)       0:02:42.531 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_excluder : Install openshift excluder - yum] *******************
>Friday 20 July 2018  03:16:08 -0400 (0:00:00.049)       0:02:42.580 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_excluder : Install openshift excluder - dnf] *******************
>Friday 20 July 2018  03:16:08 -0400 (0:00:00.043)       0:02:42.623 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [openshift_excluder : set_fact] *******************************************
>Friday 20 July 2018  03:16:08 -0400 (0:00:00.044)       0:02:42.668 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"r_openshift_excluder_install_ran": true}, "changed": false}
>
>TASK [openshift_excluder : Check for docker-excluder] **************************
>Friday 20 July 2018  03:16:08 -0400 (0:00:00.121)       0:02:42.789 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "stat": {"atime": 1532070728.118958, "attr_flags": "", "attributes": [], "block_size": 4096, "blocks": 8, "charset": "us-ascii", "checksum": "b9cd3139c5b201a8580659ad5faa8af5430fd079", "ctime": 1532070728.091958, "dev": 64768, "device_type": 0, "executable": true, "exists": true, "gid": 0, "gr_name": "root", "inode": 9207761, "isblk": false, "ischr": false, "isdir": false, "isfifo": false, "isgid": false, "islnk": false, "isreg": true, "issock": false, "isuid": false, "mimetype": "text/x-shellscript", "mode": "0744", "mtime": 1532004889.0, "nlink": 1, "path": "/sbin/atomic-openshift-docker-excluder", "pw_name": "root", "readable": true, "rgrp": true, "roth": true, "rusr": true, "size": 2471, "uid": 0, "version": "18446744071858036962", "wgrp": false, "woth": false, "writeable": true, "wusr": true, "xgrp": false, "xoth": false, "xusr": true}}
>
>TASK [openshift_excluder : Enable docker excluder] *****************************
>Friday 20 July 2018  03:16:08 -0400 (0:00:00.266)       0:02:43.056 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": true, "cmd": ["/sbin/atomic-openshift-docker-excluder", "exclude"], "delta": "0:00:00.029125", "end": "2018-07-20 03:16:20.361933", "rc": 0, "start": "2018-07-20 03:16:20.332808", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}
>
>TASK [openshift_excluder : Check for openshift excluder] ***********************
>Friday 20 July 2018  03:16:08 -0400 (0:00:00.296)       0:02:43.353 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "stat": {"exists": false}}
>
>TASK [openshift_excluder : Enable openshift excluder] **************************
>Friday 20 July 2018  03:16:09 -0400 (0:00:00.197)       0:02:43.550 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Getting current systemd-udevd exec command] **********
>Friday 20 July 2018  03:16:09 -0400 (0:00:00.038)       0:02:43.589 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Assure systemd-udevd.service.d directory exists] *****
>Friday 20 July 2018  03:16:09 -0400 (0:00:00.043)       0:02:43.632 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Create systemd-udevd override file] ******************
>Friday 20 July 2018  03:16:09 -0400 (0:00:00.045)       0:02:43.678 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Add enterprise registry, if necessary] ***************
>Friday 20 July 2018  03:16:09 -0400 (0:00:00.042)       0:02:43.721 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"l2_docker_additional_registries": ["registry.redhat.io"]}, "changed": false}
>
>TASK [container_runtime : Add http_proxy to /etc/atomic.conf] ******************
>Friday 20 July 2018  03:16:09 -0400 (0:00:00.153)       0:02:43.874 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Add https_proxy to /etc/atomic.conf] *****************
>Friday 20 July 2018  03:16:09 -0400 (0:00:00.041)       0:02:43.915 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Add no_proxy to /etc/atomic.conf] ********************
>Friday 20 July 2018  03:16:09 -0400 (0:00:00.040)       0:02:43.956 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Get current installed Docker version] ****************
>Friday 20 July 2018  03:16:09 -0400 (0:00:00.041)       0:02:43.997 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"attempts": 1, "changed": false, "cmd": ["repoquery", "--plugins", "--installed", "--qf", "%{version}", "docker"], "delta": "0:00:00.245490", "end": "2018-07-20 03:16:21.456167", "rc": 0, "start": "2018-07-20 03:16:21.210677", "stderr": "", "stderr_lines": [], "stdout": "1.13.1", "stdout_lines": ["1.13.1"]}
>
>TASK [container_runtime : Error out if Docker pre-installed but too old] *******
>Friday 20 July 2018  03:16:10 -0400 (0:00:00.455)       0:02:44.453 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Error out if requested Docker is too old] ************
>Friday 20 July 2018  03:16:10 -0400 (0:00:00.047)       0:02:44.500 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Install Docker] **************************************
>Friday 20 July 2018  03:16:10 -0400 (0:00:00.044)       0:02:44.544 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Ensure docker.service.d directory exists] ************
>Friday 20 July 2018  03:16:10 -0400 (0:00:00.046)       0:02:44.591 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": true, "gid": 0, "group": "root", "mode": "0755", "owner": "root", "path": "/etc/systemd/system/docker.service.d", "secontext": "unconfined_u:object_r:systemd_unit_file_t:s0", "size": 6, "state": "directory", "uid": 0}
>
>TASK [container_runtime : Configure Docker service unit file] ******************
>Friday 20 July 2018  03:16:10 -0400 (0:00:00.262)       0:02:44.853 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": true, "checksum": "9e1e25c0262550dd6c750b8b58bfd898ccca1cb2", "dest": "/etc/systemd/system/docker.service.d/custom.conf", "gid": 0, "group": "root", "md5sum": "3c142b6e4f182f866ab2cf8c98dc71ca", "mode": "0644", "owner": "root", "secontext": "system_u:object_r:container_unit_file_t:s0", "size": 345, "src": "/root/.ansible/tmp/ansible-tmp-1532070970.54-251925650918082/source", "state": "file", "uid": 0}
>
>TASK [container_runtime : stat] ************************************************
>Friday 20 July 2018  03:16:11 -0400 (0:00:00.661)       0:02:45.515 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "stat": {"atime": 1532070798.381958, "attr_flags": "", "attributes": [], "block_size": 4096, "blocks": 8, "charset": "us-ascii", "checksum": "457727f3e0be227e7d6c7ff0e482f151c4da2e92", "ctime": 1532070791.929958, "dev": 64768, "device_type": 0, "executable": false, "exists": true, "gid": 0, "gr_name": "root", "inode": 8391101, "isblk": false, "ischr": false, "isdir": false, "isfifo": false, "isgid": false, "islnk": false, "isreg": true, "issock": false, "isuid": false, "mimetype": "text/plain", "mode": "0644", "mtime": 1528828052.0, "nlink": 1, "path": "/etc/sysconfig/docker", "pw_name": "root", "readable": true, "rgrp": true, "roth": true, "rusr": true, "size": 1059, "uid": 0, "version": "1475120311", "wgrp": false, "woth": false, "writeable": true, "wusr": true, "xgrp": false, "xoth": false, "xusr": false}}
>
>TASK [container_runtime : Set registry params] *********************************
>Friday 20 July 2018  03:16:11 -0400 (0:00:00.227)       0:02:45.743 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item={u'reg_conf_var': u'ADD_REGISTRY', u'reg_flag': u'--add-registry', u'reg_fact_val': [u'registry.redhat.io']}) => {"backup": "", "changed": true, "item": {"reg_conf_var": "ADD_REGISTRY", "reg_fact_val": ["registry.redhat.io"], "reg_flag": "--add-registry"}, "msg": "line added"}
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item={u'reg_conf_var': u'BLOCK_REGISTRY', u'reg_flag': u'--block-registry', u'reg_fact_val': [u'registry.hacker.com']}) => {"backup": "", "changed": true, "item": {"reg_conf_var": "BLOCK_REGISTRY", "reg_fact_val": ["registry.hacker.com"], "reg_flag": "--block-registry"}, "msg": "line added"}
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item={u'reg_conf_var': u'INSECURE_REGISTRY', u'reg_flag': u'--insecure-registry', u'reg_fact_val': []})  => {"changed": false, "item": {"reg_conf_var": "INSECURE_REGISTRY", "reg_fact_val": [], "reg_flag": "--insecure-registry"}, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Place additional/blocked/insecure registries in /etc/containers/registries.conf] ***
>Friday 20 July 2018  03:16:11 -0400 (0:00:00.583)       0:02:46.326 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Set Proxy Settings] **********************************
>Friday 20 July 2018  03:16:11 -0400 (0:00:00.042)       0:02:46.368 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item={u'reg_conf_var': u'HTTP_PROXY', u'reg_fact_val': u''})  => {"changed": false, "item": {"reg_conf_var": "HTTP_PROXY", "reg_fact_val": ""}, "skip_reason": "Conditional result was False"}
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item={u'reg_conf_var': u'HTTPS_PROXY', u'reg_fact_val': u''})  => {"changed": false, "item": {"reg_conf_var": "HTTPS_PROXY", "reg_fact_val": ""}, "skip_reason": "Conditional result was False"}
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => (item={u'reg_conf_var': u'NO_PROXY', u'reg_fact_val': u''})  => {"changed": false, "item": {"reg_conf_var": "NO_PROXY", "reg_fact_val": ""}, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Set various Docker options] **************************
>Friday 20 July 2018  03:16:12 -0400 (0:00:00.096)       0:02:46.464 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"backup": "", "changed": true, "msg": "line replaced"}
>
>TASK [container_runtime : stat] ************************************************
>Friday 20 July 2018  03:16:12 -0400 (0:00:00.277)       0:02:46.742 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "stat": {"atime": 1532070800.0899582, "attr_flags": "", "attributes": [], "block_size": 4096, "blocks": 8, "charset": "us-ascii", "checksum": "d30da59f8bb0969a680f73f836c3f8123deba6cc", "ctime": 1532070792.463958, "dev": 64768, "device_type": 0, "executable": false, "exists": true, "gid": 0, "gr_name": "root", "inode": 8389500, "isblk": false, "ischr": false, "isdir": false, "isfifo": false, "isgid": false, "islnk": false, "isreg": true, "issock": false, "isuid": false, "mimetype": "text/plain", "mode": "0644", "mtime": 1528828052.0, "nlink": 1, "path": "/etc/sysconfig/docker-network", "pw_name": "root", "readable": true, "rgrp": true, "roth": true, "rusr": true, "size": 56, "uid": 0, "version": "18446744073087362934", "wgrp": false, "woth": false, "writeable": true, "wusr": true, "xgrp": false, "xoth": false, "xusr": false}}
>
>TASK [container_runtime : Configure Docker Network OPTIONS] ********************
>Friday 20 July 2018  03:16:12 -0400 (0:00:00.280)       0:02:47.022 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"backup": "", "changed": true, "msg": "line replaced"}
>
>TASK [container_runtime : Detect if docker is already started] *****************
>Friday 20 July 2018  03:16:12 -0400 (0:00:00.269)       0:02:47.292 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "cmd": ["systemctl", "show", "docker", "-p", "ActiveState"], "delta": "0:00:00.010139", "end": "2018-07-20 03:16:24.569544", "rc": 0, "start": "2018-07-20 03:16:24.559405", "stderr": "", "stderr_lines": [], "stdout": "ActiveState=active", "stdout_lines": ["ActiveState=active"]}
>
>TASK [container_runtime : Start the Docker service] ****************************
>Friday 20 July 2018  03:16:13 -0400 (0:00:00.272)       0:02:47.564 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"attempts": 1, "changed": false, "enabled": true, "name": "docker", "state": "started", "status": {"ActiveEnterTimestamp": "Fri 2018-07-20 03:13:29 EDT", "ActiveEnterTimestampMonotonic": "204017428", "ActiveExitTimestamp": "Fri 2018-07-20 03:13:27 EDT", "ActiveExitTimestampMonotonic": "201254749", "ActiveState": "active", "After": "basic.target system.slice registries.service iptables.service network.target systemd-journald.socket docker-storage-setup.service rhel-push-plugin.socket", "AllowIsolate": "no", "AmbientCapabilities": "0", "AssertResult": "yes", "AssertTimestamp": "Fri 2018-07-20 03:13:28 EDT", "AssertTimestampMonotonic": "202492845", "Before": "shutdown.target multi-user.target", "BlockIOAccounting": "no", "BlockIOWeight": "18446744073709551615", "CPUAccounting": "no", "CPUQuotaPerSecUSec": "infinity", "CPUSchedulingPolicy": "0", "CPUSchedulingPriority": "0", "CPUSchedulingResetOnFork": "no", "CPUShares": "18446744073709551615", "CanIsolate": "no", "CanReload": "yes", "CanStart": "yes", "CanStop": "yes", "CapabilityBoundingSet": "18446744073709551615", "ConditionResult": "yes", "ConditionTimestamp": "Fri 2018-07-20 03:13:28 EDT", "ConditionTimestampMonotonic": "202492845", "Conflicts": "shutdown.target", "ControlGroup": "/system.slice/docker.service", "ControlPID": "0", "DefaultDependencies": "yes", "Delegate": "no", "Description": "Docker Application Container Engine", "DevicePolicy": "auto", "Documentation": "http://docs.docker.com", "DropInPaths": "/etc/systemd/system/docker.service.d/custom.conf", "Environment": "GOTRACEBACK=crash DOCKER_HTTP_HOST_COMPAT=1 PATH=/usr/libexec/docker:/usr/bin:/usr/sbin", "EnvironmentFile": "/etc/sysconfig/docker-network (ignore_errors=yes)", "ExecMainCode": "0", "ExecMainExitTimestampMonotonic": "0", "ExecMainPID": "12079", "ExecMainStartTimestamp": "Fri 2018-07-20 03:13:28 EDT", "ExecMainStartTimestampMonotonic": "202493775", "ExecMainStatus": "0", "ExecReload": "{ path=/bin/kill ; argv[]=/bin/kill -s HUP $MAINPID ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "ExecStart": "{ path=/usr/bin/dockerd-current ; argv[]=/usr/bin/dockerd-current --add-runtime docker-runc=/usr/libexec/docker/docker-runc-current --default-runtime=docker-runc --authorization-plugin=rhel-push-plugin --exec-opt native.cgroupdriver=systemd --userland-proxy-path=/usr/libexec/docker/docker-proxy-current --init-path=/usr/libexec/docker/docker-init-current --seccomp-profile=/etc/docker/seccomp.json $OPTIONS $DOCKER_STORAGE_OPTIONS $DOCKER_NETWORK_OPTIONS $ADD_REGISTRY $BLOCK_REGISTRY $INSECURE_REGISTRY $REGISTRIES ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "FailureAction": "none", "FileDescriptorStoreMax": "0", "FragmentPath": "/usr/lib/systemd/system/docker.service", "GuessMainPID": "yes", "IOScheduling": "0", "Id": "docker.service", "IgnoreOnIsolate": "no", "IgnoreOnSnapshot": "no", "IgnoreSIGPIPE": "yes", "InactiveEnterTimestamp": "Fri 2018-07-20 03:13:28 EDT", "InactiveEnterTimestampMonotonic": "202270984", "InactiveExitTimestamp": "Fri 2018-07-20 03:13:28 EDT", "InactiveExitTimestampMonotonic": "202493807", "JobTimeoutAction": "none", "JobTimeoutUSec": "0", "KillMode": "process", "KillSignal": "15", "LimitAS": "18446744073709551615", "LimitCORE": "18446744073709551615", "LimitCPU": "18446744073709551615", "LimitDATA": "18446744073709551615", "LimitFSIZE": "18446744073709551615", "LimitLOCKS": "18446744073709551615", "LimitMEMLOCK": "65536", "LimitMSGQUEUE": "819200", "LimitNICE": "0", "LimitNOFILE": "1048576", "LimitNPROC": "1048576", "LimitRSS": "18446744073709551615", "LimitRTPRIO": "0", "LimitRTTIME": "18446744073709551615", "LimitSIGPENDING": "15055", "LimitSTACK": "18446744073709551615", "LoadState": "loaded", "MainPID": "12079", "MemoryAccounting": "no", "MemoryCurrent": "18446744073709551615", "MemoryLimit": "18446744073709551615", "MountFlags": "0", "Names": "docker.service", "NeedDaemonReload": "no", "Nice": "0", "NoNewPrivileges": "no", "NonBlocking": "no", "NotifyAccess": "all", "OOMScoreAdjust": "0", "OnFailureJobMode": "replace", "PartOf": "iptables.service", "PermissionsStartOnly": "no", "PrivateDevices": "no", "PrivateNetwork": "no", "PrivateTmp": "no", "ProtectHome": "no", "ProtectSystem": "no", "RefuseManualStart": "no", "RefuseManualStop": "no", "RemainAfterExit": "no", "RequiredBy": "docker-cleanup.service", "Requires": "basic.target registries.service rhel-push-plugin.socket docker-cleanup.timer", "Restart": "on-abnormal", "RestartUSec": "100ms", "Result": "success", "RootDirectoryStartOnly": "no", "RuntimeDirectoryMode": "0755", "SameProcessGroup": "no", "SecureBits": "0", "SendSIGHUP": "no", "SendSIGKILL": "yes", "Slice": "system.slice", "StandardError": "inherit", "StandardInput": "null", "StandardOutput": "journal", "StartLimitAction": "none", "StartLimitBurst": "5", "StartLimitInterval": "10000000", "StartupBlockIOWeight": "18446744073709551615", "StartupCPUShares": "18446744073709551615", "StatusErrno": "0", "StopWhenUnneeded": "no", "SubState": "running", "SyslogLevelPrefix": "yes", "SyslogPriority": "30", "SystemCallErrorNumber": "0", "TTYReset": "no", "TTYVHangup": "no", "TTYVTDisallocate": "no", "TasksAccounting": "no", "TasksCurrent": "18446744073709551615", "TasksMax": "18446744073709551615", "TimeoutStartUSec": "0", "TimeoutStopUSec": "1min 30s", "TimerSlackNSec": "50000", "Transient": "no", "Type": "notify", "UMask": "0022", "UnitFilePreset": "disabled", "UnitFileState": "enabled", "WantedBy": "multi-user.target", "Wants": "iptables.service docker-storage-setup.service system.slice", "WatchdogTimestamp": "Fri 2018-07-20 03:13:29 EDT", "WatchdogTimestampMonotonic": "204017386", "WatchdogUSec": "0"}}
>
>TASK [container_runtime : set_fact] ********************************************
>Friday 20 July 2018  03:16:13 -0400 (0:00:00.357)       0:02:47.921 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"ansible_facts": {"docker_service_status_changed": false}, "changed": false}
>
>TASK [container_runtime : Check for docker_storage_path/overlay2] **************
>Friday 20 July 2018  03:16:13 -0400 (0:00:00.141)       0:02:48.063 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "stat": {"exists": false}}
>
>TASK [container_runtime : Fixup SELinux permissions for docker] ****************
>Friday 20 July 2018  03:16:13 -0400 (0:00:00.259)       0:02:48.322 *********** 
>skipping: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "skip_reason": "Conditional result was False"}
>
>TASK [container_runtime : Ensure /var/lib/containers exists] *******************
>Friday 20 July 2018  03:16:13 -0400 (0:00:00.042)       0:02:48.364 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": true, "gid": 0, "group": "root", "mode": "0755", "owner": "root", "path": "/var/lib/containers", "secontext": "unconfined_u:object_r:container_var_lib_t:s0", "size": 6, "state": "directory", "uid": 0}
>
>TASK [container_runtime : Fix SELinux Permissions on /var/lib/containers] ******
>Friday 20 July 2018  03:16:14 -0400 (0:00:00.276)       0:02:48.641 *********** 
>ok: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"changed": false, "cmd": ["restorecon", "-R", "/var/lib/containers/"], "delta": "0:00:00.011387", "end": "2018-07-20 03:16:25.950230", "rc": 0, "start": "2018-07-20 03:16:25.938843", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}
>
>RUNNING HANDLER [container_runtime : restart container runtime] ****************
>Friday 20 July 2018  03:16:14 -0400 (0:00:00.279)       0:02:48.920 *********** 
>changed: [host-8-249-227.host.centralci.eng.rdu2.redhat.com] => {"attempts": 1, "changed": true, "name": "docker", "state": "started", "status": {"ActiveEnterTimestamp": "Fri 2018-07-20 03:13:29 EDT", "ActiveEnterTimestampMonotonic": "204017428", "ActiveExitTimestamp": "Fri 2018-07-20 03:13:27 EDT", "ActiveExitTimestampMonotonic": "201254749", "ActiveState": "active", "After": "docker-storage-setup.service registries.service systemd-journald.socket rhel-push-plugin.socket network.target basic.target system.slice iptables.service", "AllowIsolate": "no", "AmbientCapabilities": "0", "AssertResult": "yes", "AssertTimestamp": "Fri 2018-07-20 03:13:28 EDT", "AssertTimestampMonotonic": "202492845", "Before": "shutdown.target multi-user.target", "BlockIOAccounting": "no", "BlockIOWeight": "18446744073709551615", "CPUAccounting": "no", "CPUQuotaPerSecUSec": "infinity", "CPUSchedulingPolicy": "0", "CPUSchedulingPriority": "0", "CPUSchedulingResetOnFork": "no", "CPUShares": "18446744073709551615", "CanIsolate": "no", "CanReload": "yes", "CanStart": "yes", "CanStop": "yes", "CapabilityBoundingSet": "18446744073709551615", "ConditionResult": "yes", "ConditionTimestamp": "Fri 2018-07-20 03:13:28 EDT", "ConditionTimestampMonotonic": "202492845", "Conflicts": "shutdown.target", "ControlGroup": "/system.slice/docker.service", "ControlPID": "0", "DefaultDependencies": "yes", "Delegate": "no", "Description": "Docker Application Container Engine", "DevicePolicy": "auto", "Documentation": "http://docs.docker.com", "DropInPaths": "/etc/systemd/system/docker.service.d/custom.conf", "Environment": "GOTRACEBACK=crash DOCKER_HTTP_HOST_COMPAT=1 PATH=/usr/libexec/docker:/usr/bin:/usr/sbin", "EnvironmentFile": "/etc/sysconfig/docker-network (ignore_errors=yes)", "ExecMainCode": "0", "ExecMainExitTimestampMonotonic": "0", "ExecMainPID": "12079", "ExecMainStartTimestamp": "Fri 2018-07-20 03:13:28 EDT", "ExecMainStartTimestampMonotonic": "202493775", "ExecMainStatus": "0", "ExecReload": "{ path=/bin/kill ; argv[]=/bin/kill -s HUP $MAINPID ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "ExecStart": "{ path=/usr/bin/dockerd-current ; argv[]=/usr/bin/dockerd-current --add-runtime docker-runc=/usr/libexec/docker/docker-runc-current --default-runtime=docker-runc --authorization-plugin=rhel-push-plugin --exec-opt native.cgroupdriver=systemd --userland-proxy-path=/usr/libexec/docker/docker-proxy-current --init-path=/usr/libexec/docker/docker-init-current --seccomp-profile=/etc/docker/seccomp.json $OPTIONS $DOCKER_STORAGE_OPTIONS $DOCKER_NETWORK_OPTIONS $ADD_REGISTRY $BLOCK_REGISTRY $INSECURE_REGISTRY $REGISTRIES ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "FailureAction": "none", "FileDescriptorStoreMax": "0", "FragmentPath": "/usr/lib/systemd/system/docker.service", "GuessMainPID": "yes", "IOScheduling": "0", "Id": "docker.service", "IgnoreOnIsolate": "no", "IgnoreOnSnapshot": "no", "IgnoreSIGPIPE": "yes", "InactiveEnterTimestamp": "Fri 2018-07-20 03:13:28 EDT", "InactiveEnterTimestampMonotonic": "202270984", "InactiveExitTimestamp": "Fri 2018-07-20 03:13:28 EDT", "InactiveExitTimestampMonotonic": "202493807", "JobTimeoutAction": "none", "JobTimeoutUSec": "0", "KillMode": "process", "KillSignal": "15", "LimitAS": "18446744073709551615", "LimitCORE": "18446744073709551615", "LimitCPU": "18446744073709551615", "LimitDATA": "18446744073709551615", "LimitFSIZE": "18446744073709551615", "LimitLOCKS": "18446744073709551615", "LimitMEMLOCK": "65536", "LimitMSGQUEUE": "819200", "LimitNICE": "0", "LimitNOFILE": "1048576", "LimitNPROC": "1048576", "LimitRSS": "18446744073709551615", "LimitRTPRIO": "0", "LimitRTTIME": "18446744073709551615", "LimitSIGPENDING": "15055", "LimitSTACK": "18446744073709551615", "LoadState": "loaded", "MainPID": "12079", "MemoryAccounting": "no", "MemoryCurrent": "18446744073709551615", "MemoryLimit": "18446744073709551615", "MountFlags": "0", "Names": "docker.service", "NeedDaemonReload": "no", "Nice": "0", "NoNewPrivileges": "no", "NonBlocking": "no", "NotifyAccess": "all", "OOMScoreAdjust": "0", "OnFailureJobMode": "replace", "PartOf": "iptables.service", "PermissionsStartOnly": "no", "PrivateDevices": "no", "PrivateNetwork": "no", "PrivateTmp": "no", "ProtectHome": "no", "ProtectSystem": "no", "RefuseManualStart": "no", "RefuseManualStop": "no", "RemainAfterExit": "no", "RequiredBy": "docker-cleanup.service", "Requires": "docker-cleanup.timer basic.target rhel-push-plugin.socket registries.service", "Restart": "on-abnormal", "RestartUSec": "100ms", "Result": "success", "RootDirectoryStartOnly": "no", "RuntimeDirectoryMode": "0755", "SameProcessGroup": "no", "SecureBits": "0", "SendSIGHUP": "no", "SendSIGKILL": "yes", "Slice": "system.slice", "StandardError": "inherit", "StandardInput": "null", "StandardOutput": "journal", "StartLimitAction": "none", "StartLimitBurst": "5", "StartLimitInterval": "10000000", "StartupBlockIOWeight": "18446744073709551615", "StartupCPUShares": "18446744073709551615", "StatusErrno": "0", "StopWhenUnneeded": "no", "SubState": "running", "SyslogLevelPrefix": "yes", "SyslogPriority": "30", "SystemCallErrorNumber": "0", "TTYReset": "no", "TTYVHangup": "no", "TTYVTDisallocate": "no", "TasksAccounting": "no", "TasksCurrent": "18446744073709551615", "TasksMax": "18446744073709551615", "TimeoutStartUSec": "0", "TimeoutStopUSec": "1min 30s", "TimerSlackNSec": "50000", "Transient": "no", "Type": "notify", "UMask": "0022", "UnitFilePreset": "disabled", "UnitFileState": "enabled", "WantedBy": "multi-user.target", "Wants": "docker-storage-setup.service iptables.service system.slice", "WatchdogTimestamp": "Fri 2018-07-20 03:13:29 EDT", "WatchdogTimestampMonotonic": "204017386", "WatchdogUSec": "0"}}
>
>TASK [container_runtime : Create credentials for docker cli registry auth (alternative)] ***
>Friday 20 July 2018  03:16:17 -0400 (0:00:02.848)       0:02:51.769 *********** 
>fatal: [host-8-249-227.host.centralci.eng.rdu2.redhat.com]: FAILED! => {"msg": "The conditional check 'crt_oreg_auth_credentials_create.rc == 0' failed. The error was: error while evaluating conditional (crt_oreg_auth_credentials_create.rc == 0): 'dict object' has no attribute 'rc'"}
>	to retry, use: --limit @/home/slave1/workspace/Launch Environment Flexy/private-openshift-ansible/playbooks/prerequisites.retry
>
>PLAY RECAP *********************************************************************
>host-8-249-227.host.centralci.eng.rdu2.redhat.com : ok=84   changed=19   unreachable=0    failed=1   
>localhost                  : ok=13   changed=0    unreachable=0    failed=0   
>
>
>INSTALLER STATUS ***************************************************************
>Initialization  : Complete (0:02:10)
>Friday 20 July 2018  03:16:17 -0400 (0:00:00.630)       0:02:52.400 *********** 
>=============================================================================== 
>Ensure openshift-ansible installer package deps are installed --------- 110.38s
>os_firewall : need to pause here, otherwise the iptables service starting can sometimes cause ssh to fail -- 10.08s
>os_firewall : Wait 10 seconds after disabling firewalld ---------------- 10.07s
>os_firewall : Install iptables packages --------------------------------- 5.01s
>Gather Cluster facts ---------------------------------------------------- 3.62s
>container_runtime : restart container runtime --------------------------- 2.85s
>openshift_excluder : Install docker excluder - yum ---------------------- 2.56s
>Initialize openshift.node.sdn_mtu --------------------------------------- 1.71s
>os_firewall : Ensure firewalld service is not enabled ------------------- 1.12s
>Run variable sanity checks ---------------------------------------------- 1.00s
>Gathering Facts --------------------------------------------------------- 0.75s
>container_runtime : Configure Docker service unit file ------------------ 0.66s
>openshift_repos : refresh cache ----------------------------------------- 0.66s
>container_runtime : Create credentials for docker cli registry auth (alternative) --- 0.63s
>openshift_repos : Ensure libselinux-python is installed ----------------- 0.63s
>Gathering Facts --------------------------------------------------------- 0.59s
>container_runtime : Set registry params --------------------------------- 0.58s
>Gathering Facts --------------------------------------------------------- 0.58s
>Gathering Facts --------------------------------------------------------- 0.58s
>Gathering Facts --------------------------------------------------------- 0.57s
>tools/launch_instance.rb:458:in `block in run_ansible_playbook': ansible failed execution, see logs (RuntimeError)
>	from tools/launch_instance.rb:446:in `times'
>	from tools/launch_instance.rb:446:in `run_ansible_playbook'
>	from tools/launch_instance.rb:543:in `installation_task'
>	from tools/launch_instance.rb:641:in `block in launch_template'
>	from tools/launch_instance.rb:640:in `each'
>	from tools/launch_instance.rb:640:in `launch_template'
>	from tools/launch_instance.rb:55:in `block (2 levels) in run'
>	from /usr/local/rvm/gems/ruby-2.3.3/gems/commander-4.4.5/lib/commander/command.rb:182:in `call'
>	from /usr/local/rvm/gems/ruby-2.3.3/gems/commander-4.4.5/lib/commander/command.rb:153:in `run'
>	from /usr/local/rvm/gems/ruby-2.3.3/gems/commander-4.4.5/lib/commander/runner.rb:446:in `run_active_command'
>	from /usr/local/rvm/gems/ruby-2.3.3/gems/commander-4.4.5/lib/commander/runner.rb:68:in `run!'
>	from /usr/local/rvm/gems/ruby-2.3.3/gems/commander-4.4.5/lib/commander/delegates.rb:15:in `run!'
>	from tools/launch_instance.rb:93:in `run'
>	from tools/launch_instance.rb:743:in `<main>'
>waiting for operation up to 36000 seconds..
>
>[07:16:18] INFO> Exit Status: 512
>############ ANSIBLE END: /home/slave1/workspace/Launch Environment Flexy/private-openshift-ansible/playbooks/prerequisites.yml ############################
>+ ret=1
>+ '[' X1 == X0 ']'
>+ result=FAIL
>+ '[' -n '' ']'
>+ exit 1
>Build step 'Execute shell' marked build as failure
>Archiving artifacts
>Started calculate disk usage of build
>Finished Calculation of disk usage of build in 0 seconds
>Started calculate disk usage of workspace
>Finished Calculation of disk usage of workspace in 0 seconds
>Finished: FAILURE

Actions: View

Attachments on bug 1602120: 1464871