Console Output

Skipping 122 KB.. Full Log
  Installing : libjpeg-turbo-1.2.90-5.el7.x86_64                           2/36 
  Installing : python2-futures-3.0.5-1.el7.noarch                          3/36 
  Installing : python-paramiko-2.1.1-4.el7.noarch                          4/36 
  Installing : python-httplib2-0.9.2-1.el7.noarch                          5/36 
  Installing : libyaml-0.1.4-11.el7_0.x86_64                               6/36 
  Installing : PyYAML-3.10-11.el7.x86_64                                   7/36 
  Installing : jbigkit-libs-2.0-11.el7.x86_64                              8/36 
  Installing : libtiff-4.0.3-27.el7_3.x86_64                               9/36 
  Installing : libtommath-0.42.0-6.el7.x86_64                             10/36 
  Installing : libtomcrypt-1.17-26.el7.x86_64                             11/36 
  Installing : python2-crypto-2.6.1-15.el7.x86_64                         12/36 
  Installing : python-keyczar-0.71c-2.el7.noarch                          13/36 
  Installing : python-babel-0.9.6-8.el7.noarch                            14/36 
  Installing : python-markupsafe-0.11-10.el7.x86_64                       15/36 
  Installing : python-jinja2-2.7.2-2.el7.noarch                           16/36 
  Installing : python-urllib3-1.10.2-5.el7.noarch                         17/36 
  Installing : python-requests-2.6.0-1.el7_1.noarch                       18/36 
  Installing : python-dateutil-1.5-7.el7.noarch                           19/36 
  Installing : pyparsing-1.5.6-9.el7.noarch                               20/36 
  Installing : freetype-2.4.11-15.el7.x86_64                              21/36 
  Installing : sshpass-1.06-2.el7.x86_64                                  22/36 
  Installing : python2-rsa-3.4.1-1.el7.noarch                             23/36 
  Installing : libwebp-0.3.0-7.el7.x86_64                                 24/36 
  Installing : python-pillow-2.0.0-19.gitd1c6db8.el7.x86_64               25/36 
  Installing : python-docutils-0.11-0.3.20130715svn7687.el7.noarch        26/36 
  Installing : python2-botocore-1.6.0-1.el7.noarch                        27/36 
  Installing : python2-s3transfer-0.1.10-1.el7.noarch                     28/36 
  Installing : python2-boto3-1.4.6-1.el7.noarch                           29/36 
  Installing : python2-boto-2.45.0-3.el7.noarch                           30/36 
  Installing : ansible-2.6.5-1.el7.noarch                                 31/36 
  Installing : python2-packaging-16.8-5.el7.noarch                        32/36 
  Installing : azure-cli-2.0.46-1.el7.x86_64                              33/36 
  Installing : which-2.20-7.el7.x86_64                                    34/36 
install-info: No such file or directory for /usr/share/info/which.info.gz
  Installing : python2-scandir-1.8-1.el7.x86_64                           35/36 
  Installing : python2-pip-8.1.2-6.el7.noarch                             36/36 
  Verifying  : python-keyczar-0.71c-2.el7.noarch                           1/36 
  Verifying  : python-jinja2-2.7.2-2.el7.noarch                            2/36 
  Verifying  : libtiff-4.0.3-27.el7_3.x86_64                               3/36 
  Verifying  : libwebp-0.3.0-7.el7.x86_64                                  4/36 
  Verifying  : python2-futures-3.0.5-1.el7.noarch                          5/36 
  Verifying  : python2-boto3-1.4.6-1.el7.noarch                            6/36 
  Verifying  : python2-rsa-3.4.1-1.el7.noarch                              7/36 
  Verifying  : sshpass-1.06-2.el7.x86_64                                   8/36 
  Verifying  : freetype-2.4.11-15.el7.x86_64                               9/36 
  Verifying  : pyparsing-1.5.6-9.el7.noarch                               10/36 
  Verifying  : python2-pip-8.1.2-6.el7.noarch                             11/36 
  Verifying  : python-docutils-0.11-0.3.20130715svn7687.el7.noarch        12/36 
  Verifying  : python-dateutil-1.5-7.el7.noarch                           13/36 
  Verifying  : python2-scandir-1.8-1.el7.x86_64                           14/36 
  Verifying  : which-2.20-7.el7.x86_64                                    15/36 
  Verifying  : libjpeg-turbo-1.2.90-5.el7.x86_64                          16/36 
  Verifying  : python2-botocore-1.6.0-1.el7.noarch                        17/36 
  Verifying  : python2-packaging-16.8-5.el7.noarch                        18/36 
  Verifying  : python-urllib3-1.10.2-5.el7.noarch                         19/36 
  Verifying  : python2-jmespath-0.9.0-5.el7.noarch                        20/36 
  Verifying  : python-markupsafe-0.11-10.el7.x86_64                       21/36 
  Verifying  : python-babel-0.9.6-8.el7.noarch                            22/36 
  Verifying  : PyYAML-3.10-11.el7.x86_64                                  23/36 
  Verifying  : azure-cli-2.0.46-1.el7.x86_64                              24/36 
  Verifying  : libtommath-0.42.0-6.el7.x86_64                             25/36 
  Verifying  : python2-boto-2.45.0-3.el7.noarch                           26/36 
  Verifying  : python-pillow-2.0.0-19.gitd1c6db8.el7.x86_64               27/36 
  Verifying  : python2-s3transfer-0.1.10-1.el7.noarch                     28/36 
  Verifying  : jbigkit-libs-2.0-11.el7.x86_64                             29/36 
  Verifying  : ansible-2.6.5-1.el7.noarch                                 30/36 
  Verifying  : libyaml-0.1.4-11.el7_0.x86_64                              31/36 
  Verifying  : python2-crypto-2.6.1-15.el7.x86_64                         32/36 
  Verifying  : python-requests-2.6.0-1.el7_1.noarch                       33/36 
  Verifying  : python-httplib2-0.9.2-1.el7.noarch                         34/36 
  Verifying  : python-paramiko-2.1.1-4.el7.noarch                         35/36 
  Verifying  : libtomcrypt-1.17-26.el7.x86_64                             36/36 

Installed:
  ansible.noarch 0:2.6.5-1.el7           azure-cli.x86_64 0:2.0.46-1.el7        
  python2-boto.noarch 0:2.45.0-3.el7     python2-boto3.noarch 0:1.4.6-1.el7     
  python2-crypto.x86_64 0:2.6.1-15.el7   python2-packaging.noarch 0:16.8-5.el7  
  python2-pip.noarch 0:8.1.2-6.el7       python2-scandir.x86_64 0:1.8-1.el7     
  which.x86_64 0:2.20-7.el7             

Dependency Installed:
  PyYAML.x86_64 0:3.10-11.el7                                                   
  freetype.x86_64 0:2.4.11-15.el7                                               
  jbigkit-libs.x86_64 0:2.0-11.el7                                              
  libjpeg-turbo.x86_64 0:1.2.90-5.el7                                           
  libtiff.x86_64 0:4.0.3-27.el7_3                                               
  libtomcrypt.x86_64 0:1.17-26.el7                                              
  libtommath.x86_64 0:0.42.0-6.el7                                              
  libwebp.x86_64 0:0.3.0-7.el7                                                  
  libyaml.x86_64 0:0.1.4-11.el7_0                                               
  pyparsing.noarch 0:1.5.6-9.el7                                                
  python-babel.noarch 0:0.9.6-8.el7                                             
  python-dateutil.noarch 0:1.5-7.el7                                            
  python-docutils.noarch 0:0.11-0.3.20130715svn7687.el7                         
  python-httplib2.noarch 0:0.9.2-1.el7                                          
  python-jinja2.noarch 0:2.7.2-2.el7                                            
  python-keyczar.noarch 0:0.71c-2.el7                                           
  python-markupsafe.x86_64 0:0.11-10.el7                                        
  python-paramiko.noarch 0:2.1.1-4.el7                                          
  python-pillow.x86_64 0:2.0.0-19.gitd1c6db8.el7                                
  python-requests.noarch 0:2.6.0-1.el7_1                                        
  python-urllib3.noarch 0:1.10.2-5.el7                                          
  python2-botocore.noarch 0:1.6.0-1.el7                                         
  python2-futures.noarch 0:3.0.5-1.el7                                          
  python2-jmespath.noarch 0:0.9.0-5.el7                                         
  python2-rsa.noarch 0:3.4.1-1.el7                                              
  python2-s3transfer.noarch 0:0.1.10-1.el7                                      
  sshpass.x86_64 0:1.06-2.el7                                                   

Complete!
Loaded plugins: fastestmirror, ovl
Examining /var/tmp/yum-root-lyeWWq/google-cloud-sdk-183.0.0-3.el7.x86_64.rpm: google-cloud-sdk-183.0.0-3.el7.x86_64
Marking /var/tmp/yum-root-lyeWWq/google-cloud-sdk-183.0.0-3.el7.x86_64.rpm to be installed
Resolving Dependencies
--> Running transaction check
---> Package google-cloud-sdk.x86_64 0:183.0.0-3.el7 will be installed
--> Finished Dependency Resolution

Dependencies Resolved

================================================================================
 Package      Arch   Version       Repository                              Size
================================================================================
Installing:
 google-cloud-sdk
              x86_64 183.0.0-3.el7 /google-cloud-sdk-183.0.0-3.el7.x86_64  87 M

Transaction Summary
================================================================================
Install  1 Package

Total size: 87 M
Installed size: 87 M
Downloading packages:
Running transaction check
Running transaction test
Transaction test succeeded
Running transaction
  Installing : google-cloud-sdk-183.0.0-3.el7.x86_64                        1/1 
  Verifying  : google-cloud-sdk-183.0.0-3.el7.x86_64                        1/1 

Installed:
  google-cloud-sdk.x86_64 0:183.0.0-3.el7                                       

Complete!
Loaded plugins: fastestmirror, ovl
Loading mirror speeds from cached hostfile
 * base: mirrors.advancedhosters.com
 * epel: mirror.cogentco.com
 * extras: mirrors.advancedhosters.com
 * updates: mirrors.advancedhosters.com
Resolving Dependencies
--> Running transaction check
---> Package java-1.8.0-openjdk-headless.x86_64 1:1.8.0.191.b12-0.el7_5 will be installed
--> Processing Dependency: tzdata-java >= 2015d for package: 1:java-1.8.0-openjdk-headless-1.8.0.191.b12-0.el7_5.x86_64
--> Processing Dependency: copy-jdk-configs >= 2.2 for package: 1:java-1.8.0-openjdk-headless-1.8.0.191.b12-0.el7_5.x86_64
--> Processing Dependency: lksctp-tools(x86-64) for package: 1:java-1.8.0-openjdk-headless-1.8.0.191.b12-0.el7_5.x86_64
--> Processing Dependency: jpackage-utils for package: 1:java-1.8.0-openjdk-headless-1.8.0.191.b12-0.el7_5.x86_64
--> Running transaction check
---> Package copy-jdk-configs.noarch 0:3.3-10.el7_5 will be installed
---> Package javapackages-tools.noarch 0:3.4.1-11.el7 will be installed
--> Processing Dependency: python-javapackages = 3.4.1-11.el7 for package: javapackages-tools-3.4.1-11.el7.noarch
---> Package lksctp-tools.x86_64 0:1.0.17-2.el7 will be installed
---> Package tzdata-java.noarch 0:2018f-2.el7 will be installed
--> Running transaction check
---> Package python-javapackages.noarch 0:3.4.1-11.el7 will be installed
--> Finished Dependency Resolution

Dependencies Resolved

================================================================================
 Package                      Arch    Version                    Repository
                                                                           Size
================================================================================
Installing:
 java-1.8.0-openjdk-headless  x86_64  1:1.8.0.191.b12-0.el7_5    updates   32 M
Installing for dependencies:
 copy-jdk-configs             noarch  3.3-10.el7_5               updates   21 k
 javapackages-tools           noarch  3.4.1-11.el7               base      73 k
 lksctp-tools                 x86_64  1.0.17-2.el7               base      88 k
 python-javapackages          noarch  3.4.1-11.el7               base      31 k
 tzdata-java                  noarch  2018f-2.el7                updates  186 k

Transaction Summary
================================================================================
Install  1 Package (+5 Dependent packages)

Total download size: 32 M
Installed size: 104 M
Downloading packages:
--------------------------------------------------------------------------------
Total                                               27 MB/s |  32 MB  00:01     
Running transaction check
Running transaction test
Transaction test succeeded
Running transaction
  Installing : lksctp-tools-1.0.17-2.el7.x86_64                             1/6 
  Installing : python-javapackages-3.4.1-11.el7.noarch                      2/6 
  Installing : javapackages-tools-3.4.1-11.el7.noarch                       3/6 
  Installing : copy-jdk-configs-3.3-10.el7_5.noarch                         4/6 
  Installing : tzdata-java-2018f-2.el7.noarch                               5/6 
  Installing : 1:java-1.8.0-openjdk-headless-1.8.0.191.b12-0.el7_5.x86_64   6/6 
  Verifying  : tzdata-java-2018f-2.el7.noarch                               1/6 
  Verifying  : copy-jdk-configs-3.3-10.el7_5.noarch                         2/6 
  Verifying  : python-javapackages-3.4.1-11.el7.noarch                      3/6 
  Verifying  : 1:java-1.8.0-openjdk-headless-1.8.0.191.b12-0.el7_5.x86_64   4/6 
  Verifying  : javapackages-tools-3.4.1-11.el7.noarch                       5/6 
  Verifying  : lksctp-tools-1.0.17-2.el7.x86_64                             6/6 

Installed:
  java-1.8.0-openjdk-headless.x86_64 1:1.8.0.191.b12-0.el7_5                    

Dependency Installed:
  copy-jdk-configs.noarch 0:3.3-10.el7_5                                        
  javapackages-tools.noarch 0:3.4.1-11.el7                                      
  lksctp-tools.x86_64 0:1.0.17-2.el7                                            
  python-javapackages.noarch 0:3.4.1-11.el7                                     
  tzdata-java.noarch 0:2018f-2.el7                                              

Complete!
Collecting apache-libcloud~=2.2.1
  Downloading https://files.pythonhosted.org/packages/23/b5/b57733c2b0f5d810835a60f3a6e7fd679489879444603524efe5a6ac08c0/apache_libcloud-2.2.1-py2.py3-none-any.whl (2.9MB)
Collecting SecretStorage<3
  Downloading https://files.pythonhosted.org/packages/a5/a5/0830cfe34a4cfd0d1c3c8b614ede1edb2aaf999091ac8548dd19cb352e79/SecretStorage-2.3.1.tar.gz
Requirement already satisfied (use --upgrade to upgrade): ansible[azure] in /usr/lib/python2.7/site-packages
Requirement already satisfied (use --upgrade to upgrade): requests in /usr/lib/python2.7/site-packages (from apache-libcloud~=2.2.1)
Requirement already satisfied (use --upgrade to upgrade): cryptography in /usr/lib64/python2.7/site-packages (from SecretStorage<3)
Requirement already satisfied (use --upgrade to upgrade): jinja2 in /usr/lib/python2.7/site-packages (from ansible[azure])
Requirement already satisfied (use --upgrade to upgrade): PyYAML in /usr/lib64/python2.7/site-packages (from ansible[azure])
Requirement already satisfied (use --upgrade to upgrade): paramiko in /usr/lib/python2.7/site-packages (from ansible[azure])
Requirement already satisfied (use --upgrade to upgrade): setuptools in /usr/lib/python2.7/site-packages (from ansible[azure])
Requirement already satisfied (use --upgrade to upgrade): packaging in /usr/lib/python2.7/site-packages (from ansible[azure])
Collecting azure-cli-core==2.0.35 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/ee/81/561473d6614d15f450eba6b7c8e0e1fbbaf34bf117fe77c1188010870e24/azure_cli_core-2.0.35-py2.py3-none-any.whl (90kB)
Collecting azure-cli-nspkg==3.0.2 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/7c/94/cf884b92a870422f02c3f1f86573d04d5cc1abdc2ac51b8419c7ee2e2a00/azure_cli_nspkg-3.0.2-py2.py3-none-any.whl
Collecting azure-common==1.1.11 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/97/3b/2c7cda25382c3bb566008c5c8f8aa28663fd15a80a6204c76ae0035de107/azure_common-1.1.11-py2.py3-none-any.whl
Collecting azure-mgmt-batch==4.1.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/e8/fb/fc700d1bf51c4359efb36aae643579b9bc6fabb5660403d5fb39293d028f/azure_mgmt_batch-4.1.0-py2.py3-none-any.whl
Collecting azure-mgmt-compute==2.1.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/13/4a/a51770139aa79ccda3a35b7213a22515b432d0d45fad5a8e207d9d39fb60/azure_mgmt_compute-2.1.0-py2.py3-none-any.whl (544kB)
Collecting azure-mgmt-containerinstance==0.4.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/b8/a7/cf09dfe3f122582af3a389366e6b1543d5ed7e99f1e55884524d4a0111c9/azure_mgmt_containerinstance-0.4.0-py2.py3-none-any.whl (43kB)
Collecting azure-mgmt-containerregistry==2.0.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/c5/b6/926aba2129e87976a00c4742aa1dba4fea09708c0871ab48ec7937f9ac99/azure_mgmt_containerregistry-2.0.0-py2.py3-none-any.whl (274kB)
Collecting azure-mgmt-containerservice==3.0.1 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/42/fd/3af202dbaf36b717f4e8d0e4e6b53bdb77c1683e4e73bfc003b84aa79f57/azure_mgmt_containerservice-3.0.1-py2.py3-none-any.whl
Collecting azure-mgmt-dns==1.2.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/29/e9/bff494c51298ebe8123aa0994e6cea47e110cb9542d9a8517dbb5bac8713/azure_mgmt_dns-1.2.0-py2.py3-none-any.whl
Collecting azure-mgmt-keyvault==0.40.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/45/5a/f3182d7ed82173d9af0bd96d01de4002eca8fddbd3c1feb99d839c5f4657/azure_mgmt_keyvault-0.40.0-py2.py3-none-any.whl
Collecting azure-mgmt-network==1.7.1 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/89/61/178d2fb43cd5c288a3e00e4433994dae4f243fa358ac5c87364a0dd55299/azure_mgmt_network-1.7.1-py2.py3-none-any.whl (2.3MB)
Collecting azure-mgmt-nspkg==2.0.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/c9/e3/48b98f929290b0cd0aaa4707ecabb8aaeb267e8ef628af907f1d1c506ec7/azure_mgmt_nspkg-2.0.0-py2.py3-none-any.whl
Collecting azure-mgmt-rdbms==1.2.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/96/36/fae53c5584f38d96e716834f3213b8432ed19062c322dce9725be388dd24/azure_mgmt_rdbms-1.2.0-py2.py3-none-any.whl (159kB)
Collecting azure-mgmt-resource==1.2.2 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/71/ec/30b1bea83782bd890ba84c21ab8d1af71bc30f14f51b3688c0a32aec82ce/azure_mgmt_resource-1.2.2-py2.py3-none-any.whl (323kB)
Collecting azure-mgmt-sql==0.7.1 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/c9/ce/84fb845640af04acc2486d4cf578ee5bc0e16188fbfc3da186199db135bb/azure_mgmt_sql-0.7.1-py2.py3-none-any.whl (141kB)
Collecting azure-mgmt-storage==1.5.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/c5/40/d8134d1ee9617fa8bd469e62f916349e1373b94e9f179d12050cfd051e20/azure_mgmt_storage-1.5.0-py2.py3-none-any.whl (189kB)
Collecting azure-mgmt-web==0.32.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/21/1d/1fd04a4d613779e27b2f30a4f17d319163489ac9112b1e2c206e7a4bcbf4/azure_mgmt_web-0.32.0-py2.py3-none-any.whl (257kB)
Collecting azure-nspkg==2.0.0 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/cd/a0/76ca6659ae9afd7567fdbb5b9c85e9c9a0b48238cfcacd92525484408f66/azure_nspkg-2.0.0-py2.py3-none-any.whl
Collecting azure-storage==0.35.1 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/76/bf/647b73450c70d4c5efbf57b35edf1b45928695a8b20dce2a4577dee0d539/azure_storage-0.35.1-py2.py3-none-any.whl (190kB)
Collecting msrest==0.4.29 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/e1/db/b4b8e0388ad7f100d2ec7c18dbcdfa3d86a1f42b052009ceed223aef7cbd/msrest-0.4.29-py2.py3-none-any.whl (41kB)
Collecting msrestazure==0.4.31 (from ansible[azure])
  Downloading https://files.pythonhosted.org/packages/ee/d4/0235848f1991dde8dac97cd85d4d71cd9146f75ece84215c1914a4fa3725/msrestazure-0.4.31-py2.py3-none-any.whl
Requirement already satisfied (use --upgrade to upgrade): idna>=2.0 in /usr/lib/python2.7/site-packages (from cryptography->SecretStorage<3)
Requirement already satisfied (use --upgrade to upgrade): pyasn1>=0.1.8 in /usr/lib/python2.7/site-packages (from cryptography->SecretStorage<3)
Requirement already satisfied (use --upgrade to upgrade): six>=1.4.1 in /usr/lib/python2.7/site-packages (from cryptography->SecretStorage<3)
Requirement already satisfied (use --upgrade to upgrade): enum34 in /usr/lib/python2.7/site-packages (from cryptography->SecretStorage<3)
Requirement already satisfied (use --upgrade to upgrade): ipaddress in /usr/lib/python2.7/site-packages (from cryptography->SecretStorage<3)
Requirement already satisfied (use --upgrade to upgrade): cffi>=1.4.1 in /usr/lib64/python2.7/site-packages (from cryptography->SecretStorage<3)
Requirement already satisfied (use --upgrade to upgrade): markupsafe in /usr/lib64/python2.7/site-packages (from jinja2->ansible[azure])
Requirement already satisfied (use --upgrade to upgrade): pyparsing in /usr/lib/python2.7/site-packages (from packaging->ansible[azure])
Collecting argcomplete>=1.8.0 (from azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/31/88/ba8d8684a8a27749250c66ff7c2b408fdbc29b50da61200338ff9b2607bf/argcomplete-1.9.4-py2.py3-none-any.whl
Collecting colorama>=0.3.9 (from azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/0a/93/6e8289231675d561d476d656c2ee3a868c1cca207e16c118d4503b25e2bf/colorama-0.4.0-py2.py3-none-any.whl
Collecting knack==0.3.3 (from azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/92/aa/d5563dfb2724a5d7899170461f8c70e88f8f9422bd1c44a2a7528e2e6235/knack-0.3.3-py2.py3-none-any.whl (42kB)
Collecting tabulate<=0.8.2,>=0.7.7 (from azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/12/c2/11d6845db5edf1295bc08b2f488cf5937806586afe42936c3f34c097ebdc/tabulate-0.8.2.tar.gz (45kB)
Collecting pyopenssl>=17.1.0 (from azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/96/af/9d29e6bd40823061aea2e0574ccb2fcf72bfd6130ce53d32773ec375458c/pyOpenSSL-18.0.0-py2.py3-none-any.whl (53kB)
Collecting wheel==0.30.0 (from azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/0c/80/16a85b47702a1f47a63c104c91abdd0a6704ee8ae3b4ce4afc49bc39f9d9/wheel-0.30.0-py2.py3-none-any.whl (49kB)
Collecting pygments (from azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/02/ee/b6e02dc6529e82b75bb06823ff7d005b141037cb1416b10c6f00fc419dca/Pygments-2.2.0-py2.py3-none-any.whl (841kB)
Collecting PyJWT (from azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/93/d1/3378cc8184a6524dc92993090ee8b4c03847c567e298305d6cf86987e005/PyJWT-1.6.4-py2.py3-none-any.whl
Requirement already satisfied (use --upgrade to upgrade): jmespath in /usr/lib/python2.7/site-packages (from azure-cli-core==2.0.35->ansible[azure])
Collecting applicationinsights>=0.11.1 (from azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/e3/c8/7848a0dd85158930b859eb8be1e38fc76a91f0a040d491723ebb356d7358/applicationinsights-0.11.7-py2.py3-none-any.whl (56kB)
Collecting humanfriendly>=4.7 (from azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/79/1e/13d96248e3fcaa7777b61fa889feab44865c85e524bbd667acfa0d8b66e3/humanfriendly-4.17-py2.py3-none-any.whl (72kB)
Requirement already satisfied (use --upgrade to upgrade): pip in /usr/lib/python2.7/site-packages (from azure-cli-core==2.0.35->ansible[azure])
Requirement already satisfied (use --upgrade to upgrade): python-dateutil in /usr/lib/python2.7/site-packages (from azure-storage==0.35.1->ansible[azure])
Collecting isodate>=0.6.0 (from msrest==0.4.29->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/9b/9f/b36f7774ff5ea8e428fdcfc4bb332c39ee5b9362ddd3d40d9516a55221b2/isodate-0.6.0-py2.py3-none-any.whl (45kB)
Collecting requests-oauthlib>=0.5.0 (from msrest==0.4.29->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/94/e7/c250d122992e1561690d9c0f7856dadb79d61fd4bdd0e598087dce607f6c/requests_oauthlib-1.0.0-py2.py3-none-any.whl
Collecting certifi>=2017.4.17 (from msrest==0.4.29->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/56/9d/1d02dd80bc4cd955f98980f28c5ee2200e1209292d5f9e9cc8d030d18655/certifi-2018.10.15-py2.py3-none-any.whl (146kB)
Collecting adal<2.0.0,>=0.5.0 (from msrestazure==0.4.31->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/2d/2f/14882b8dae0977e85577abde3065c141fb94dbb242adfb80e21797e4f7c9/adal-1.2.0-py2.py3-none-any.whl (52kB)
Collecting keyring>=12.0.2 (from msrestazure==0.4.31->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/5f/cb/dc7b2215cd82b77e7b8b48abd8989c1b09990d4c91a3ccfdc18a61157b36/keyring-16.0.2-py2.py3-none-any.whl
Requirement already satisfied (use --upgrade to upgrade): pycparser in /usr/lib/python2.7/site-packages (from cffi>=1.4.1->cryptography->SecretStorage<3)
Collecting monotonic; python_version == "2.6" or python_version == "2.7" or python_version == "3.0" or python_version == "3.1" or python_version == "3.2" (from humanfriendly>=4.7->azure-cli-core==2.0.35->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/ac/aa/063eca6a416f397bd99552c534c6d11d57f58f2e94c14780f3bbf818c4cf/monotonic-1.5-py2.py3-none-any.whl
Collecting oauthlib>=0.6.2 (from requests-oauthlib>=0.5.0->msrest==0.4.29->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/e6/d1/ddd9cfea3e736399b97ded5c2dd62d1322adef4a72d816f1ed1049d6a179/oauthlib-2.1.0-py2.py3-none-any.whl (121kB)
Collecting entrypoints (from keyring>=12.0.2->msrestazure==0.4.31->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/cc/8b/4eefa9b47f1910b3d2081da67726b066e379b04ca897acfe9f92bac56147/entrypoints-0.2.3-py2.py3-none-any.whl
Collecting configparser>=3.5; python_version == "2.7" (from entrypoints->keyring>=12.0.2->msrestazure==0.4.31->ansible[azure])
  Downloading https://files.pythonhosted.org/packages/7c/69/c2ce7e91c89dc073eb1aa74c0621c3eefbffe8216b3f9af9d3885265c01c/configparser-3.5.0.tar.gz
Installing collected packages: apache-libcloud, SecretStorage, argcomplete, colorama, PyJWT, adal, configparser, entrypoints, keyring, isodate, oauthlib, requests-oauthlib, certifi, msrest, msrestazure, azure-nspkg, azure-cli-nspkg, pygments, tabulate, knack, pyopenssl, wheel, applicationinsights, monotonic, humanfriendly, azure-cli-core, azure-common, azure-mgmt-nspkg, azure-mgmt-batch, azure-mgmt-compute, azure-mgmt-containerinstance, azure-mgmt-containerregistry, azure-mgmt-containerservice, azure-mgmt-dns, azure-mgmt-keyvault, azure-mgmt-network, azure-mgmt-rdbms, azure-mgmt-resource, azure-mgmt-sql, azure-mgmt-storage, azure-mgmt-web, azure-storage
  Running setup.py install for SecretStorage: started
    Running setup.py install for SecretStorage: finished with status 'done'
  Running setup.py install for configparser: started
    Running setup.py install for configparser: finished with status 'done'
  Running setup.py install for tabulate: started
    Running setup.py install for tabulate: finished with status 'done'
  Found existing installation: pyOpenSSL 0.13.1
    DEPRECATION: Uninstalling a distutils installed project (pyopenssl) has been deprecated and will be removed in a future version. This is due to the fact that uninstalling a distutils project will only partially uninstall the project.
    Uninstalling pyOpenSSL-0.13.1:
      Successfully uninstalled pyOpenSSL-0.13.1
Successfully installed PyJWT-1.6.4 SecretStorage-2.3.1 adal-1.2.0 apache-libcloud-2.2.1 applicationinsights-0.11.7 argcomplete-1.9.4 azure-cli-core-2.0.35 azure-cli-nspkg-3.0.2 azure-common-1.1.11 azure-mgmt-batch-4.1.0 azure-mgmt-compute-2.1.0 azure-mgmt-containerinstance-0.4.0 azure-mgmt-containerregistry-2.0.0 azure-mgmt-containerservice-3.0.1 azure-mgmt-dns-1.2.0 azure-mgmt-keyvault-0.40.0 azure-mgmt-network-1.7.1 azure-mgmt-nspkg-2.0.0 azure-mgmt-rdbms-1.2.0 azure-mgmt-resource-1.2.2 azure-mgmt-sql-0.7.1 azure-mgmt-storage-1.5.0 azure-mgmt-web-0.32.0 azure-nspkg-2.0.0 azure-storage-0.35.1 certifi-2018.10.15 colorama-0.4.0 configparser-3.5.0 entrypoints-0.2.3 humanfriendly-4.17 isodate-0.6.0 keyring-16.0.2 knack-0.3.3 monotonic-1.5 msrest-0.4.29 msrestazure-0.4.31 oauthlib-2.1.0 pygments-2.2.0 pyopenssl-18.0.0 requests-oauthlib-1.0.0 tabulate-0.8.2 wheel-0.30.0
You are using pip version 8.1.2, however version 18.1 is available.
You should consider upgrading via the 'pip install --upgrade pip' command.
Loaded plugins: fastestmirror, ovl
Cleaning repos: azure-cli base centos-ansible26-testing centos-openshift-origin
              : epel extras google-cloud-sdk updates
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
Cleaning up list of fastest mirrors
 ---> 5c62fb0fac60
Removing intermediate container de8a0af518bc
Step 6/14 : LABEL name "openshift/origin-ansible" summary "OpenShift's installation and configuration tool" description "A containerized openshift-ansible image to let you run playbooks to install, upgrade, maintain and check an OpenShift cluster" url "https://github.com/openshift/openshift-ansible" io.k8s.display-name "openshift-ansible" io.k8s.description "A containerized openshift-ansible image to let you run playbooks to install, upgrade, maintain and check an OpenShift cluster" io.openshift.expose-services "" io.openshift.tags "openshift,install,upgrade,ansible" atomic.run "once"
 ---> Running in 97646e018c9d
 ---> 35b46337c3cb
Removing intermediate container 97646e018c9d
Step 7/14 : ENV USER_UID 1001 HOME /opt/app-root/src WORK_DIR /usr/share/ansible/openshift-ansible OPTS "-v"
 ---> Running in eea47bcf9b15
 ---> 30f2b82bc783
Removing intermediate container eea47bcf9b15
Step 8/14 : COPY images/installer/root /
 ---> 36d79f28b6df
Removing intermediate container fcfc7a917ba8
Step 9/14 : COPY . ${WORK_DIR}
 ---> 1f3ea620fb69
Removing intermediate container b32ae845b318
Step 10/14 : RUN /usr/local/bin/user_setup  && rm /usr/local/bin/usage.ocp
 ---> Running in a0c004227c06

+ mkdir -p /opt/app-root/src
+ chown 1001:0 /opt/app-root/src
+ chmod ug+rwx /opt/app-root/src
+ chmod g+rw /etc/passwd
+ chmod -R g+r /usr/share/ansible/openshift-ansible
+ find /usr/share/ansible/openshift-ansible -type d -exec chmod g+x '{}' +
+ find /usr/share/ansible/openshift-ansible -type d -exec chmod g+wx '{}' +
+ rm /usr/local/bin/user_setup
 ---> 27bff25387d3
Removing intermediate container a0c004227c06
Step 11/14 : USER ${USER_UID}
 ---> Running in 725806271a85
 ---> a74403ff290b
Removing intermediate container 725806271a85
Step 12/14 : WORKDIR ${WORK_DIR}
 ---> ca98e8daddab
Removing intermediate container 4ec18f1454fa
Step 13/14 : ENTRYPOINT /usr/local/bin/entrypoint
 ---> Running in 7e841b471140
 ---> 106619b05078
Removing intermediate container 7e841b471140
Step 14/14 : CMD /usr/local/bin/run
 ---> Running in d67e03882716
 ---> a5ea667bba71
Removing intermediate container d67e03882716
Successfully built a5ea667bba71
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: BUILD OPENSHIFT INSTALLER IMAGE [00h 02m 58s] ##########
[workspace] $ /bin/bash /tmp/jenkins1640072313705826382.sh
########## STARTING STAGE: MOVE SECRETS TO REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate ]]
+ source /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
+ rsync --copy-links --omit-dir-times --archive --rsh 'ssh -F ./.config/origin-ci-tool/inventory/.ssh_config' /var/lib/jenkins/.azure/10_oreg_auth.yml /var/lib/jenkins/.azure/10_yum_repos.yml /var/lib/jenkins/.azure/credentials /var/lib/jenkins/.azure/kubeconfig /var/lib/jenkins/.azure/registry /var/lib/jenkins/.azure/ssh-privatekey openshiftdevel:/data/src/github.com/openshift/release/cluster/test-deploy/azure/
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo chown -R origin:origin-git /data/src/github.com/openshift/release/cluster/test-deploy/azure/'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo chmod -R ug+rwX /data/src/github.com/openshift/release/cluster/test-deploy/azure/'
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: MOVE SECRETS TO REMOTE HOST [00h 00m 01s] ##########
[workspace] $ /bin/bash /tmp/jenkins7550588171392211723.sh
########## STARTING STAGE: BUILD NODE IMAGE ##########
+ [[ -s /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate ]]
+ source /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
++ mktemp
+ script=/tmp/tmp.P71yPoyziS
+ cat
+ chmod +x /tmp/tmp.P71yPoyziS
+ scp -F /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.P71yPoyziS openshiftdevel:/tmp/tmp.P71yPoyziS
+ ssh -F /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.P71yPoyziS"'
+ cd /data/src/github.com/openshift/release
+ cd cluster/test-deploy/azure
++ curl -qs https://storage.googleapis.com/origin-ci-test/releases/openshift/origin/master/.latest-rpms
+ TYPE=azure
+ INSTANCE_PREFIX=unused
+ ../../bin/ansible.sh ansible-playbook -e openshift_azure_resource_group_name=ci-azure_build_node_image_centos-151 -e openshift_azure_resource_location=eastus -e openshift_azure_input_image_ns=images -e openshift_azure_input_image_prefix=centos7-base -e openshift_azure_output_image_ns=images -e openshift_azure_output_image_name=centos7-master-201811112220 -e openshift_azure_storage_account=openshiftimages -e openshift_azure_storage_account_ns=images -e openshift_azure_container=images -e openshift_azure_install_repo=https://storage.googleapis.com/origin-ci-test/logs/test_branch_origin_extended_conformance_gce/3628/artifacts/rpms -e openshift_azure_vm_size=Standard_D2s_v3 playbooks/azure/openshift-cluster/build_node_image.yml

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

TASK [calculate input image] ***************************************************
Sunday 11 November 2018  22:23:10 +0000 (0:00:00.097)       0:00:00.097 ******* 
changed: [localhost]

TASK [create resource group] ***************************************************
Sunday 11 November 2018  22:23:12 +0000 (0:00:01.808)       0:00:01.906 ******* 
changed: [localhost]

TASK [create vnet] *************************************************************
Sunday 11 November 2018  22:23:13 +0000 (0:00:01.571)       0:00:03.477 ******* 
changed: [localhost]

TASK [create subnet] ***********************************************************
Sunday 11 November 2018  22:23:29 +0000 (0:00:15.494)       0:00:18.972 ******* 
changed: [localhost]

TASK [create vm] ***************************************************************
Sunday 11 November 2018  22:23:34 +0000 (0:00:05.126)       0:00:24.099 ******* 
changed: [localhost]

TASK [add vm to inventory] *****************************************************
Sunday 11 November 2018  22:26:42 +0000 (0:03:08.573)       0:03:32.672 ******* 
changed: [localhost]

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

TASK [Gathering Facts] *********************************************************
Sunday 11 November 2018  22:26:42 +0000 (0:00:00.037)       0:03:32.710 ******* 
ok: [40.114.93.240]

TASK [set_fact] ****************************************************************
Sunday 11 November 2018  22:26:45 +0000 (0:00:02.296)       0:03:35.007 ******* 
ok: [40.114.93.240]

TASK [add insights-client to package installs when on rhel] ********************
Sunday 11 November 2018  22:26:45 +0000 (0:00:00.115)       0:03:35.122 ******* 
skipping: [40.114.93.240]

TASK [set_fact] ****************************************************************
Sunday 11 November 2018  22:26:45 +0000 (0:00:00.041)       0:03:35.163 ******* 
ok: [40.114.93.240]

TASK [install centos-release-paas-common rpm] **********************************
Sunday 11 November 2018  22:26:45 +0000 (0:00:00.067)       0:03:35.231 ******* 
changed: [40.114.93.240]

TASK [copy yum client certificate] *********************************************
Sunday 11 November 2018  22:26:57 +0000 (0:00:12.446)       0:03:47.677 ******* 
skipping: [40.114.93.240] => (item=None) 
skipping: [40.114.93.240] => (item=None) 
skipping: [40.114.93.240]

TASK [include_role : openshift_repos] ******************************************
Sunday 11 November 2018  22:26:57 +0000 (0:00:00.055)       0:03:47.733 ******* 

TASK [openshift_repos : Ensure libselinux-python is installed] *****************
Sunday 11 November 2018  22:26:57 +0000 (0:00:00.079)       0:03:47.813 ******* 
ok: [40.114.93.240]

TASK [openshift_repos : Remove openshift_additional.repo file] *****************
Sunday 11 November 2018  22:26:58 +0000 (0:00:00.445)       0:03:48.258 ******* 
ok: [40.114.93.240]

TASK [openshift_repos : Create any additional repos that are defined] **********
Sunday 11 November 2018  22:26:58 +0000 (0:00:00.381)       0:03:48.639 ******* 
changed: [40.114.93.240] => (item={u'gpgkey': u'file:///etc/pki/rpm-gpg/RPM-GPG-KEY-CentOS-SIG-PaaS', u'enabled': True, u'name': u'openshift-origin', u'baseurl': u'http://mirror.centos.org/centos/7/paas/x86_64/openshift-origin/'})
changed: [40.114.93.240] => (item={'gpgcheck': False, 'enabled': True, 'name': u'install_repo', 'baseurl': u'https://storage.googleapis.com/origin-ci-test/logs/test_branch_origin_extended_conformance_gce/3628/artifacts/rpms'})

TASK [openshift_repos : include_tasks] *****************************************
Sunday 11 November 2018  22:26:59 +0000 (0:00:00.598)       0:03:49.238 ******* 
skipping: [40.114.93.240]

TASK [openshift_repos : include_tasks] *****************************************
Sunday 11 November 2018  22:26:59 +0000 (0:00:00.041)       0:03:49.280 ******* 
skipping: [40.114.93.240]

TASK [openshift_repos : Ensure clean repo cache in the event repos have been changed manually] ***
Sunday 11 November 2018  22:26:59 +0000 (0:00:00.040)       0:03:49.320 ******* 
skipping: [40.114.93.240]

TASK [openshift_repos : Record that openshift_repos already ran] ***************
Sunday 11 November 2018  22:26:59 +0000 (0:00:00.042)       0:03:49.363 ******* 
skipping: [40.114.93.240]

RUNNING HANDLER [openshift_repos : refresh cache] ******************************
Sunday 11 November 2018  22:26:59 +0000 (0:00:00.062)       0:03:49.425 ******* 
changed: [40.114.93.240]

TASK [include_role : os_update_latest] *****************************************
Sunday 11 November 2018  22:27:00 +0000 (0:00:00.460)       0:03:49.886 ******* 

TASK [os_update_latest : Update all packages] **********************************
Sunday 11 November 2018  22:27:00 +0000 (0:00:00.072)       0:03:49.959 ******* 
ok: [40.114.93.240]

TASK [os_update_latest : shell] ************************************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:05.404)       0:03:55.363 ******* 
skipping: [40.114.93.240]

TASK [os_update_latest : wait_for_connection] **********************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.042)       0:03:55.406 ******* 
skipping: [40.114.93.240]

PLAY [Fail openshift_kubelet_name_override for new hosts] **********************

TASK [Fail when openshift_kubelet_name_override is defined] ********************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.052)       0:03:55.458 ******* 
skipping: [40.114.93.240]

PLAY [Initialization Checkpoint Start] *****************************************

TASK [Set install initialization 'In Progress'] ********************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.050)       0:03:55.508 ******* 
ok: [40.114.93.240]

PLAY [Populate config host groups] *********************************************

TASK [Load group name mapping variables] ***************************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.063)       0:03:55.572 ******* 
ok: [localhost]

TASK [Evaluate groups - g_nfs_hosts is single host] ****************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.029)       0:03:55.602 ******* 
skipping: [localhost]

TASK [Evaluate oo_all_hosts] ***************************************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.022)       0:03:55.625 ******* 
ok: [localhost] => (item=40.114.93.240)

TASK [Evaluate oo_masters] *****************************************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.055)       0:03:55.680 ******* 

TASK [Evaluate oo_first_master] ************************************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.023)       0:03:55.703 ******* 
skipping: [localhost]

TASK [Evaluate oo_new_etcd_to_config] ******************************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.022)       0:03:55.726 ******* 

TASK [Evaluate oo_masters_to_config] *******************************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.021)       0:03:55.748 ******* 

TASK [Evaluate oo_etcd_to_config] **********************************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.024)       0:03:55.773 ******* 

TASK [Evaluate oo_first_etcd] **************************************************
Sunday 11 November 2018  22:27:05 +0000 (0:00:00.022)       0:03:55.795 ******* 
skipping: [localhost]

TASK [Evaluate oo_etcd_hosts_to_upgrade] ***************************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.023)       0:03:55.819 ******* 

TASK [Evaluate oo_etcd_hosts_to_backup] ****************************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.020)       0:03:55.839 ******* 

TASK [Evaluate oo_nodes_to_config] *********************************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.020)       0:03:55.860 ******* 
ok: [localhost] => (item=40.114.93.240)

TASK [Evaluate oo_lb_to_config] ************************************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.041)       0:03:55.901 ******* 

TASK [Evaluate oo_nfs_to_config] ***********************************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.021)       0:03:55.923 ******* 

TASK [Evaluate oo_glusterfs_to_config] *****************************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.021)       0:03:55.944 ******* 

TASK [Evaluate oo_etcd_to_migrate] *********************************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.023)       0:03:55.968 ******* 
 [WARNING]: Could not match supplied host pattern, ignoring:
oo_masters_to_config
 [WARNING]: Could not match supplied host pattern, ignoring: oo_etcd_to_config
 [WARNING]: Could not match supplied host pattern, ignoring: oo_lb_to_config
 [WARNING]: Could not match supplied host pattern, ignoring: oo_nfs_to_config

PLAY [Ensure that all non-node hosts are accessible] ***************************
skipping: no hosts matched

PLAY [Initialize basic host facts] *********************************************

TASK [openshift_sanitize_inventory : include_tasks] ****************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.061)       0:03:56.030 ******* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_sanitize_inventory/tasks/deprecations.yml for 40.114.93.240

TASK [openshift_sanitize_inventory : Check for usage of deprecated variables] ***
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.084)       0:03:56.115 ******* 
ok: [40.114.93.240]

TASK [openshift_sanitize_inventory : debug] ************************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.130)       0:03:56.246 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : set_stats] ********************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.043)       0:03:56.290 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : set_fact] *********************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.044)       0:03:56.334 ******* 
ok: [40.114.93.240]

TASK [openshift_sanitize_inventory : Standardize on latest variable names] *****
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.073)       0:03:56.408 ******* 
ok: [40.114.93.240]

TASK [openshift_sanitize_inventory : Normalize openshift_release] **************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.064)       0:03:56.473 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : Abort when openshift_release is invalid] ***
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.042)       0:03:56.516 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : include_tasks] ****************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.043)       0:03:56.559 ******* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_sanitize_inventory/tasks/unsupported.yml for 40.114.93.240

TASK [openshift_sanitize_inventory : set_fact] *********************************
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.081)       0:03:56.641 ******* 

TASK [openshift_sanitize_inventory : Ensure that dynamic provisioning is set if using dynamic storage] ***
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.066)       0:03:56.708 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : Ensure the hosted registry's GlusterFS storage is configured correctly] ***
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.050)       0:03:56.759 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : Ensure the hosted registry's GlusterFS storage is configured correctly] ***
Sunday 11 November 2018  22:27:06 +0000 (0:00:00.042)       0:03:56.801 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : Check for deprecated prometheus/grafana install] ***
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.041)       0:03:56.843 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : Ensure clusterid is set along with the cloudprovider] ***
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.042)       0:03:56.886 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : Ensure ansible_service_broker_remove and ansible_service_broker_install are mutually exclusive] ***
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.044)       0:03:56.930 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : Ensure template_service_broker_remove and template_service_broker_install are mutually exclusive] ***
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.045)       0:03:56.976 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : Ensure that all requires vsphere configuration variables are set] ***
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.041)       0:03:57.018 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : ensure provider configuration variables are defined] ***
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.041)       0:03:57.059 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : Ensure removed web console extension variables are not set] ***
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.041)       0:03:57.101 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : Ensure that web console port matches API server port] ***
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.041)       0:03:57.143 ******* 
skipping: [40.114.93.240]

TASK [openshift_sanitize_inventory : At least one master is schedulable] *******
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.040)       0:03:57.184 ******* 
skipping: [40.114.93.240]

TASK [Detect OS Variant from /etc/os-release] **********************************
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.047)       0:03:57.231 ******* 
skipping: [40.114.93.240]

TASK [set openshift_deployment_type if unset] **********************************
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.049)       0:03:57.280 ******* 
skipping: [40.114.93.240]

PLAY [Retrieve existing master configs and validate] ***************************
skipping: no hosts matched
 [WARNING]: Could not match supplied host pattern, ignoring: oo_first_master

PLAY [Initialize special first-master variables] *******************************
skipping: no hosts matched

PLAY [Disable web console if required] *****************************************
skipping: no hosts matched

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

TASK [rhel_subscribe : fail] ***************************************************
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.062)       0:03:57.343 ******* 
skipping: [40.114.93.240]

TASK [rhel_subscribe : Install Red Hat Subscription manager] *******************
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.040)       0:03:57.383 ******* 
skipping: [40.114.93.240]

TASK [rhel_subscribe : Is host already registered?] ****************************
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.042)       0:03:57.426 ******* 
skipping: [40.114.93.240]

TASK [rhel_subscribe : Register host using user/password] **********************
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.040)       0:03:57.467 ******* 
skipping: [40.114.93.240]

TASK [rhel_subscribe : Register host using activation key] *********************
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.045)       0:03:57.513 ******* 
skipping: [40.114.93.240]

TASK [rhel_subscribe : Determine if OpenShift Pool Already Attached] ***********
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.041)       0:03:57.554 ******* 
skipping: [40.114.93.240]

TASK [rhel_subscribe : Attach to OpenShift Pool] *******************************
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.041)       0:03:57.595 ******* 
skipping: [40.114.93.240]

TASK [rhel_subscribe : Satellite preparation] **********************************
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.040)       0:03:57.636 ******* 
skipping: [40.114.93.240]

TASK [openshift_repos : Ensure libselinux-python is installed] *****************
Sunday 11 November 2018  22:27:07 +0000 (0:00:00.041)       0:03:57.677 ******* 
ok: [40.114.93.240]

TASK [openshift_repos : Remove openshift_additional.repo file] *****************
Sunday 11 November 2018  22:27:08 +0000 (0:00:00.432)       0:03:58.110 ******* 
ok: [40.114.93.240]

TASK [openshift_repos : Create any additional repos that are defined] **********
Sunday 11 November 2018  22:27:08 +0000 (0:00:00.266)       0:03:58.377 ******* 
ok: [40.114.93.240] => (item={u'gpgkey': u'file:///etc/pki/rpm-gpg/RPM-GPG-KEY-CentOS-SIG-PaaS', u'enabled': True, u'name': u'openshift-origin', u'baseurl': u'http://mirror.centos.org/centos/7/paas/x86_64/openshift-origin/'})
ok: [40.114.93.240] => (item={'gpgcheck': False, 'enabled': True, 'name': u'install_repo', 'baseurl': u'https://storage.googleapis.com/origin-ci-test/logs/test_branch_origin_extended_conformance_gce/3628/artifacts/rpms'})

TASK [openshift_repos : include_tasks] *****************************************
Sunday 11 November 2018  22:27:09 +0000 (0:00:00.481)       0:03:58.858 ******* 
skipping: [40.114.93.240]

TASK [openshift_repos : include_tasks] *****************************************
Sunday 11 November 2018  22:27:09 +0000 (0:00:00.046)       0:03:58.905 ******* 
skipping: [40.114.93.240]

TASK [openshift_repos : Ensure clean repo cache in the event repos have been changed manually] ***
Sunday 11 November 2018  22:27:09 +0000 (0:00:00.053)       0:03:58.958 ******* 
changed: [40.114.93.240] => {
    "msg": "First run of openshift_repos"
}

TASK [openshift_repos : Record that openshift_repos already ran] ***************
Sunday 11 November 2018  22:27:09 +0000 (0:00:00.122)       0:03:59.081 ******* 
ok: [40.114.93.240]

RUNNING HANDLER [openshift_repos : refresh cache] ******************************
Sunday 11 November 2018  22:27:09 +0000 (0:00:00.092)       0:03:59.173 ******* 
changed: [40.114.93.240]

PLAY [Install packages necessary for installer] ********************************

TASK [Determine if chrony is installed] ****************************************
Sunday 11 November 2018  22:27:09 +0000 (0:00:00.504)       0:03:59.678 ******* 
changed: [40.114.93.240]
 [WARNING]: Consider using the yum, dnf or zypper module rather than running
rpm.  If you need to use command because yum, dnf or zypper is insufficient you
can add warn=False to this command task or set command_warnings=False in
ansible.cfg to get rid of this message.

TASK [Install ntp package] *****************************************************
Sunday 11 November 2018  22:27:10 +0000 (0:00:00.351)       0:04:00.029 ******* 
skipping: [40.114.93.240]

TASK [Start and enable ntpd/chronyd] *******************************************
Sunday 11 November 2018  22:27:10 +0000 (0:00:00.052)       0:04:00.082 ******* 
changed: [40.114.93.240]

TASK [Ensure openshift-ansible installer package deps are installed] ***********
Sunday 11 November 2018  22:27:10 +0000 (0:00:00.333)       0:04:00.415 ******* 
changed: [40.114.93.240]

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

TASK [get openshift_current_version] *******************************************
Sunday 11 November 2018  22:27:23 +0000 (0:00:12.774)       0:04:13.189 ******* 
ok: [40.114.93.240]

TASK [set_fact openshift_portal_net if present on masters] *********************
Sunday 11 November 2018  22:27:23 +0000 (0:00:00.363)       0:04:13.552 ******* 
skipping: [40.114.93.240]

TASK [Gather Cluster facts] ****************************************************
Sunday 11 November 2018  22:27:23 +0000 (0:00:00.041)       0:04:13.594 ******* 
changed: [40.114.93.240]

TASK [Set fact of no_proxy_internal_hostnames] *********************************
Sunday 11 November 2018  22:27:24 +0000 (0:00:01.088)       0:04:14.683 ******* 
skipping: [40.114.93.240]

TASK [Initialize openshift.node.sdn_mtu] ***************************************
Sunday 11 November 2018  22:27:24 +0000 (0:00:00.043)       0:04:14.727 ******* 
changed: [40.114.93.240]

TASK [set_fact l_kubelet_node_name] ********************************************
Sunday 11 November 2018  22:27:25 +0000 (0:00:00.508)       0:04:15.236 ******* 
ok: [40.114.93.240]

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

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

TASK [include_role : openshift_version] ****************************************
Sunday 11 November 2018  22:27:25 +0000 (0:00:00.077)       0:04:15.314 ******* 

TASK [openshift_version : Use openshift_current_version fact as version to configure if already installed] ***
Sunday 11 November 2018  22:27:25 +0000 (0:00:00.098)       0:04:15.412 ******* 
skipping: [40.114.93.240]

TASK [openshift_version : Set openshift_version to openshift_release if undefined] ***
Sunday 11 November 2018  22:27:25 +0000 (0:00:00.043)       0:04:15.455 ******* 
ok: [40.114.93.240]

TASK [openshift_version : debug] ***********************************************
Sunday 11 November 2018  22:27:25 +0000 (0:00:00.070)       0:04:15.526 ******* 
ok: [40.114.93.240] => {
    "msg": "openshift_pkg_version was not defined. Falling back to -4.0"
}

TASK [openshift_version : set_fact] ********************************************
Sunday 11 November 2018  22:27:25 +0000 (0:00:00.124)       0:04:15.651 ******* 
ok: [40.114.93.240]

TASK [openshift_version : debug] ***********************************************
Sunday 11 November 2018  22:27:25 +0000 (0:00:00.120)       0:04:15.772 ******* 
ok: [40.114.93.240] => {
    "msg": "openshift_image_tag was not defined. Falling back to v4.0"
}

TASK [openshift_version : set_fact] ********************************************
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.119)       0:04:15.892 ******* 
ok: [40.114.93.240]

TASK [openshift_version : assert openshift_release in openshift_image_tag] *****
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.069)       0:04:15.961 ******* 
ok: [40.114.93.240] => {
    "changed": false, 
    "msg": "All assertions passed"
}

TASK [openshift_version : assert openshift_release in openshift_pkg_version] ***
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.066)       0:04:16.027 ******* 
ok: [40.114.93.240] => {
    "changed": false, 
    "msg": "All assertions passed"
}

TASK [openshift_version : debug] ***********************************************
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.066)       0:04:16.094 ******* 
ok: [40.114.93.240] => {
    "openshift_release": "4.0"
}

TASK [openshift_version : debug] ***********************************************
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.112)       0:04:16.206 ******* 
ok: [40.114.93.240] => {
    "openshift_image_tag": "v4.0"
}

TASK [openshift_version : debug] ***********************************************
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.113)       0:04:16.320 ******* 
ok: [40.114.93.240] => {
    "openshift_pkg_version": "-4.0*"
}

TASK [openshift_version : debug] ***********************************************
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.118)       0:04:16.438 ******* 
ok: [40.114.93.240] => {
    "openshift_version": "4.0"
}

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

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

PLAY [Verify Node NetworkManager] **********************************************
skipping: no hosts matched

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

TASK [Set install initialization 'Complete'] ***********************************
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.144)       0:04:16.583 ******* 
ok: [40.114.93.240]

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

TASK [Query DNS for IP address of vm.kgfodgcel2mepm2ug2qrs02apg.bx.internal.cloudapp.net] ***
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.134)       0:04:16.718 ******* 
skipping: [40.114.93.240]

TASK [Validate openshift_kubelet_name_override when defined] *******************
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.042)       0:04:16.760 ******* 
skipping: [40.114.93.240]

TASK [Validate openshift_ip exists on node when defined] ***********************
Sunday 11 November 2018  22:27:26 +0000 (0:00:00.042)       0:04:16.802 ******* 
skipping: [40.114.93.240]

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

TASK [os_firewall : Install firewalld packages] ********************************
Sunday 11 November 2018  22:27:27 +0000 (0:00:00.056)       0:04:16.859 ******* 
skipping: [40.114.93.240]

TASK [os_firewall : Ensure iptables services are not enabled] ******************
Sunday 11 November 2018  22:27:27 +0000 (0:00:00.047)       0:04:16.906 ******* 
skipping: [40.114.93.240] => (item=iptables) 
skipping: [40.114.93.240] => (item=ip6tables) 

TASK [os_firewall : Wait 10 seconds after disabling iptables] ******************
Sunday 11 November 2018  22:27:27 +0000 (0:00:00.117)       0:04:17.023 ******* 
skipping: [40.114.93.240]

TASK [os_firewall : Start and enable firewalld service] ************************
Sunday 11 November 2018  22:27:27 +0000 (0:00:00.047)       0:04:17.071 ******* 
skipping: [40.114.93.240]

TASK [os_firewall : need to pause here, otherwise the firewalld service starting can sometimes cause ssh to fail] ***
Sunday 11 November 2018  22:27:27 +0000 (0:00:00.046)       0:04:17.117 ******* 
skipping: [40.114.93.240]

TASK [os_firewall : Restart polkitd] *******************************************
Sunday 11 November 2018  22:27:27 +0000 (0:00:00.045)       0:04:17.163 ******* 
skipping: [40.114.93.240]

TASK [os_firewall : Wait for polkit action to have been created] ***************
Sunday 11 November 2018  22:27:27 +0000 (0:00:00.045)       0:04:17.209 ******* 
skipping: [40.114.93.240]

TASK [os_firewall : Ensure firewalld service is not enabled] *******************
Sunday 11 November 2018  22:27:27 +0000 (0:00:00.044)       0:04:17.253 ******* 
changed: [40.114.93.240]

TASK [os_firewall : Wait 10 seconds after disabling firewalld] *****************
Sunday 11 November 2018  22:27:28 +0000 (0:00:01.262)       0:04:18.515 ******* 
Pausing for 10 seconds
(ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)
ok: [40.114.93.240]

TASK [os_firewall : Install iptables packages] *********************************
Sunday 11 November 2018  22:27:38 +0000 (0:00:10.072)       0:04:28.588 ******* 
changed: [40.114.93.240]

TASK [os_firewall : Start and enable iptables service] *************************
Sunday 11 November 2018  22:27:48 +0000 (0:00:09.319)       0:04:37.908 ******* 
changed: [40.114.93.240 -> 40.114.93.240] => (item=40.114.93.240)

TASK [os_firewall : need to pause here, otherwise the iptables service starting can sometimes cause ssh to fail] ***
Sunday 11 November 2018  22:27:48 +0000 (0:00:00.430)       0:04:38.338 ******* 
Pausing for 10 seconds
(ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)
ok: [40.114.93.240]

PLAY [oo_nodes_to_config] ******************************************************

TASK [container_runtime : Setup the docker-storage for overlay] ****************
Sunday 11 November 2018  22:27:58 +0000 (0:00:10.086)       0:04:48.425 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Create file system on extra volume device] ***********
Sunday 11 November 2018  22:27:58 +0000 (0:00:00.044)       0:04:48.469 ******* 

TASK [container_runtime : Create mount entry for extra volume] *****************
Sunday 11 November 2018  22:27:58 +0000 (0:00:00.042)       0:04:48.512 ******* 

PLAY [oo_nodes_to_config] ******************************************************

TASK [openshift_excluder : Install docker excluder - yum] **********************
Sunday 11 November 2018  22:27:58 +0000 (0:00:00.057)       0:04:48.569 ******* 
changed: [40.114.93.240]

TASK [openshift_excluder : Install docker excluder - dnf] **********************
Sunday 11 November 2018  22:28:02 +0000 (0:00:04.192)       0:04:52.762 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Install openshift excluder - yum] *******************
Sunday 11 November 2018  22:28:02 +0000 (0:00:00.054)       0:04:52.816 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Install openshift excluder - dnf] *******************
Sunday 11 November 2018  22:28:03 +0000 (0:00:00.047)       0:04:52.864 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : set_fact] *******************************************
Sunday 11 November 2018  22:28:03 +0000 (0:00:00.047)       0:04:52.912 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : Check for docker-excluder] **************************
Sunday 11 November 2018  22:28:03 +0000 (0:00:00.070)       0:04:52.982 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : Check for openshift excluder] ***********************
Sunday 11 November 2018  22:28:03 +0000 (0:00:00.383)       0:04:53.366 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : Enable docker excluder] *****************************
Sunday 11 November 2018  22:28:03 +0000 (0:00:00.218)       0:04:53.584 ******* 
changed: [40.114.93.240]

TASK [openshift_excluder : Enable openshift excluder] **************************
Sunday 11 November 2018  22:28:04 +0000 (0:00:00.261)       0:04:53.845 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Getting current systemd-udevd exec command] **********
Sunday 11 November 2018  22:28:04 +0000 (0:00:00.047)       0:04:53.893 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Assure systemd-udevd.service.d directory exists] *****
Sunday 11 November 2018  22:28:04 +0000 (0:00:00.048)       0:04:53.942 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Create systemd-udevd override file] ******************
Sunday 11 November 2018  22:28:04 +0000 (0:00:00.049)       0:04:53.992 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Add enterprise registry, if necessary] ***************
Sunday 11 November 2018  22:28:04 +0000 (0:00:00.048)       0:04:54.041 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Get current installed Docker version] ****************
Sunday 11 November 2018  22:28:04 +0000 (0:00:00.048)       0:04:54.090 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Error out if Docker pre-installed but too old] *******
Sunday 11 November 2018  22:28:04 +0000 (0:00:00.429)       0:04:54.520 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Error out if requested Docker is too old] ************
Sunday 11 November 2018  22:28:04 +0000 (0:00:00.055)       0:04:54.576 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Install Docker] **************************************
Sunday 11 November 2018  22:28:04 +0000 (0:00:00.048)       0:04:54.624 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Ensure docker.service.d directory exists] ************
Sunday 11 November 2018  22:28:56 +0000 (0:00:51.434)       0:05:46.059 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Configure Docker service unit file] ******************
Sunday 11 November 2018  22:28:56 +0000 (0:00:00.297)       0:05:46.356 ******* 
changed: [40.114.93.240]

TASK [container_runtime : stat] ************************************************
Sunday 11 November 2018  22:28:57 +0000 (0:00:00.793)       0:05:47.150 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Set registry params] *********************************
Sunday 11 November 2018  22:28:57 +0000 (0:00:00.234)       0:05:47.385 ******* 
skipping: [40.114.93.240] => (item={u'reg_conf_var': u'ADD_REGISTRY', u'reg_flag': u'--add-registry', u'reg_fact_val': []}) 
skipping: [40.114.93.240] => (item={u'reg_conf_var': u'BLOCK_REGISTRY', u'reg_flag': u'--block-registry', u'reg_fact_val': []}) 
skipping: [40.114.93.240] => (item={u'reg_conf_var': u'INSECURE_REGISTRY', u'reg_flag': u'--insecure-registry', u'reg_fact_val': []}) 

TASK [container_runtime : Place additional/blocked/insecure registries in /etc/containers/registries.conf] ***
Sunday 11 November 2018  22:28:57 +0000 (0:00:00.095)       0:05:47.481 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Set Proxy Settings] **********************************
Sunday 11 November 2018  22:28:57 +0000 (0:00:00.047)       0:05:47.528 ******* 
skipping: [40.114.93.240] => (item={u'reg_conf_var': u'HTTP_PROXY', u'reg_fact_val': u''}) 
skipping: [40.114.93.240] => (item={u'reg_conf_var': u'HTTPS_PROXY', u'reg_fact_val': u''}) 
skipping: [40.114.93.240] => (item={u'reg_conf_var': u'NO_PROXY', u'reg_fact_val': u''}) 

TASK [container_runtime : Set various Docker options] **************************
Sunday 11 November 2018  22:28:57 +0000 (0:00:00.103)       0:05:47.632 ******* 
changed: [40.114.93.240]

TASK [container_runtime : stat] ************************************************
Sunday 11 November 2018  22:28:58 +0000 (0:00:00.405)       0:05:48.037 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Configure Docker Network OPTIONS] ********************
Sunday 11 November 2018  22:28:58 +0000 (0:00:00.278)       0:05:48.315 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Detect if docker is already started] *****************
Sunday 11 November 2018  22:28:58 +0000 (0:00:00.279)       0:05:48.594 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Start the Docker service] ****************************
Sunday 11 November 2018  22:28:59 +0000 (0:00:00.241)       0:05:48.836 ******* 
changed: [40.114.93.240]

TASK [container_runtime : set_fact] ********************************************
Sunday 11 November 2018  22:29:01 +0000 (0:00:02.223)       0:05:51.060 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Check for docker_storage_path/overlay2] **************
Sunday 11 November 2018  22:29:01 +0000 (0:00:00.068)       0:05:51.129 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Fixup SELinux permissions for docker] ****************
Sunday 11 November 2018  22:29:01 +0000 (0:00:00.242)       0:05:51.372 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Ensure /var/lib/containers exists] *******************
Sunday 11 November 2018  22:29:02 +0000 (0:00:00.735)       0:05:52.107 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Fix SELinux Permissions on /var/lib/containers] ******
Sunday 11 November 2018  22:29:02 +0000 (0:00:00.230)       0:05:52.338 ******* 
ok: [40.114.93.240]

RUNNING HANDLER [container_runtime : restart container runtime] ****************
Sunday 11 November 2018  22:29:02 +0000 (0:00:00.198)       0:05:52.536 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Create credentials for oreg_url] *********************
Sunday 11 November 2018  22:29:02 +0000 (0:00:00.072)       0:05:52.609 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Create for any additional registries] ****************
Sunday 11 November 2018  22:29:02 +0000 (0:00:00.046)       0:05:52.656 ******* 

TASK [container_runtime : stat the docker data dir] ****************************
Sunday 11 November 2018  22:29:02 +0000 (0:00:00.042)       0:05:52.699 ******* 
ok: [40.114.93.240]

TASK [container_runtime : stop the current running docker] *********************
Sunday 11 November 2018  22:29:03 +0000 (0:00:00.232)       0:05:52.931 ******* 
changed: [40.114.93.240]

TASK [container_runtime : copy "/var/lib/docker" to "/var/lib/containers/docker"] ***
Sunday 11 November 2018  22:29:04 +0000 (0:00:01.286)       0:05:54.217 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Set the selinux context on /var/lib/containers/docker] ***
Sunday 11 November 2018  22:29:04 +0000 (0:00:00.300)       0:05:54.517 ******* 
changed: [40.114.93.240]

TASK [container_runtime : restorecon the /var/lib/containers/docker] ***********
Sunday 11 November 2018  22:29:05 +0000 (0:00:00.802)       0:05:55.320 ******* 
changed: [40.114.93.240]

TASK [container_runtime : ensure the unmount of top level mount point] *********
Sunday 11 November 2018  22:29:05 +0000 (0:00:00.245)       0:05:55.565 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Remove the old docker location] **********************
Sunday 11 November 2018  22:29:06 +0000 (0:00:00.349)       0:05:55.914 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Setup the link] **************************************
Sunday 11 November 2018  22:29:06 +0000 (0:00:00.230)       0:05:56.145 ******* 
changed: [40.114.93.240]

TASK [container_runtime : start docker] ****************************************
Sunday 11 November 2018  22:29:06 +0000 (0:00:00.239)       0:05:56.384 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Getting current systemd-udevd exec command] **********
Sunday 11 November 2018  22:29:08 +0000 (0:00:01.921)       0:05:58.306 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Assure systemd-udevd.service.d directory exists] *****
Sunday 11 November 2018  22:29:08 +0000 (0:00:00.048)       0:05:58.355 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Create systemd-udevd override file] ******************
Sunday 11 November 2018  22:29:08 +0000 (0:00:00.047)       0:05:58.403 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Add enterprise registry, if necessary] ***************
Sunday 11 November 2018  22:29:08 +0000 (0:00:00.047)       0:05:58.450 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Check that overlay is in the kernel] *****************
Sunday 11 November 2018  22:29:08 +0000 (0:00:00.045)       0:05:58.496 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Add overlay to modprobe.d] ***************************
Sunday 11 November 2018  22:29:08 +0000 (0:00:00.234)       0:05:58.730 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Manually modprobe overlay into the kernel] ***********
Sunday 11 November 2018  22:29:08 +0000 (0:00:00.047)       0:05:58.778 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Enable and start systemd-modules-load] ***************
Sunday 11 November 2018  22:29:09 +0000 (0:00:00.049)       0:05:58.828 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Install cri-o] ***************************************
Sunday 11 November 2018  22:29:09 +0000 (0:00:00.047)       0:05:58.876 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Remove CRI-O default configuration files] ************
Sunday 11 November 2018  22:29:20 +0000 (0:00:11.732)       0:06:10.609 ******* 
changed: [40.114.93.240] => (item=/etc/cni/net.d/200-loopback.conf)
changed: [40.114.93.240] => (item=/etc/cni/net.d/100-crio-bridge.conf)

TASK [container_runtime : Create the CRI-O configuration] **********************
Sunday 11 November 2018  22:29:21 +0000 (0:00:00.453)       0:06:11.063 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Update crictl.yaml runtime-endpoint] *****************
Sunday 11 November 2018  22:29:21 +0000 (0:00:00.639)       0:06:11.702 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Ensure CNI configuration directory exists] ***********
Sunday 11 November 2018  22:29:22 +0000 (0:00:00.423)       0:06:12.125 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Add iptables allow rules] ****************************
Sunday 11 November 2018  22:29:22 +0000 (0:00:00.283)       0:06:12.409 ******* 
changed: [40.114.93.240] => (item={u'port': u'10010/tcp', u'service': u'crio'})

TASK [container_runtime : Remove iptables rules] *******************************
Sunday 11 November 2018  22:29:23 +0000 (0:00:00.568)       0:06:12.977 ******* 

TASK [container_runtime : Add firewalld allow rules] ***************************
Sunday 11 November 2018  22:29:23 +0000 (0:00:00.044)       0:06:13.022 ******* 
skipping: [40.114.93.240] => (item={u'port': u'10010/tcp', u'service': u'crio'}) 

TASK [container_runtime : Remove firewalld allow rules] ************************
Sunday 11 November 2018  22:29:23 +0000 (0:00:00.060)       0:06:13.082 ******* 

TASK [container_runtime : Configure the CNI network] ***************************
Sunday 11 November 2018  22:29:23 +0000 (0:00:00.043)       0:06:13.125 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Create /etc/sysconfig/crio-network] ******************
Sunday 11 November 2018  22:29:23 +0000 (0:00:00.656)       0:06:13.782 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Place registries.conf in /etc/containers/registries.conf] ***
Sunday 11 November 2018  22:29:24 +0000 (0:00:00.651)       0:06:14.433 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Start the CRI-O service] *****************************
Sunday 11 November 2018  22:29:25 +0000 (0:00:00.655)       0:06:15.089 ******* 
changed: [40.114.93.240]

TASK [container_runtime : Ensure /var/lib/containers exists] *******************
Sunday 11 November 2018  22:29:28 +0000 (0:00:03.285)       0:06:18.374 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Fix SELinux Permissions on /var/lib/containers] ******
Sunday 11 November 2018  22:29:28 +0000 (0:00:00.242)       0:06:18.617 ******* 
ok: [40.114.93.240]

TASK [container_runtime : Create credentials for oreg_url] *********************
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.237)       0:06:18.855 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Create for any additional registries] ****************
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.046)       0:06:18.901 ******* 

TASK [container_runtime : stat the docker data dir] ****************************
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.042)       0:06:18.943 ******* 
ok: [40.114.93.240]

TASK [container_runtime : stop the current running docker] *********************
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.277)       0:06:19.221 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : copy "/var/lib/docker" to "/var/lib/containers/docker"] ***
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.050)       0:06:19.271 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Set the selinux context on /var/lib/containers/docker] ***
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.050)       0:06:19.321 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : restorecon the /var/lib/containers/docker] ***********
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.051)       0:06:19.373 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : ensure the unmount of top level mount point] *********
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.048)       0:06:19.421 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Remove the old docker location] **********************
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.053)       0:06:19.475 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : Setup the link] **************************************
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.049)       0:06:19.525 ******* 
skipping: [40.114.93.240]

TASK [container_runtime : start docker] ****************************************
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.048)       0:06:19.574 ******* 
skipping: [40.114.93.240]

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

TASK [openshift_excluder : Debug r_openshift_excluder_enable_docker_excluder] ***
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.058)       0:06:19.632 ******* 
ok: [40.114.93.240] => {
    "r_openshift_excluder_enable_docker_excluder": true
}

TASK [openshift_excluder : Debug r_openshift_excluder_enable_openshift_excluder] ***
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.071)       0:06:19.704 ******* 
ok: [40.114.93.240] => {
    "r_openshift_excluder_enable_openshift_excluder": true
}

TASK [openshift_excluder : Fail if invalid openshift_excluder_action provided] ***
Sunday 11 November 2018  22:29:29 +0000 (0:00:00.074)       0:06:19.778 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Fail if r_openshift_excluder_upgrade_target is not defined] ***
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.044)       0:06:19.823 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Include main action task file] **********************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.043)       0:06:19.867 ******* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/disable.yml for 40.114.93.240

TASK [openshift_excluder : Get available excluder version] *********************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.131)       0:06:19.999 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Fail when excluder package is not found] ************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.041)       0:06:20.040 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Set fact excluder_version] **************************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.040)       0:06:20.081 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : origin-docker-excluder version detected] ************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.046)       0:06:20.128 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Printing upgrade target version] ********************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.042)       0:06:20.171 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Check the available origin-docker-excluder version is at most of the upgrade target version] ***
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.049)       0:06:20.220 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Get available excluder version] *********************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.042)       0:06:20.262 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Fail when excluder package is not found] ************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.043)       0:06:20.306 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Set fact excluder_version] **************************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.044)       0:06:20.350 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : origin-excluder version detected] *******************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.045)       0:06:20.396 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Printing upgrade target version] ********************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.040)       0:06:20.437 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Check the available origin-excluder version is at most of the upgrade target version] ***
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.044)       0:06:20.481 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Check for docker-excluder] **************************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.046)       0:06:20.528 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : disable docker excluder] ****************************
Sunday 11 November 2018  22:29:30 +0000 (0:00:00.246)       0:06:20.774 ******* 
changed: [40.114.93.240]

TASK [openshift_excluder : Check for openshift excluder] ***********************
Sunday 11 November 2018  22:29:31 +0000 (0:00:00.275)       0:06:21.050 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : disable openshift excluder] *************************
Sunday 11 November 2018  22:29:31 +0000 (0:00:00.224)       0:06:21.275 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Install docker excluder - yum] **********************
Sunday 11 November 2018  22:29:31 +0000 (0:00:00.053)       0:06:21.329 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Install docker excluder - dnf] **********************
Sunday 11 November 2018  22:29:31 +0000 (0:00:00.050)       0:06:21.380 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Install openshift excluder - yum] *******************
Sunday 11 November 2018  22:29:31 +0000 (0:00:00.045)       0:06:21.425 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Install openshift excluder - dnf] *******************
Sunday 11 November 2018  22:29:31 +0000 (0:00:00.046)       0:06:21.472 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : set_fact] *******************************************
Sunday 11 November 2018  22:29:31 +0000 (0:00:00.045)       0:06:21.517 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Check for docker-excluder] **************************
Sunday 11 November 2018  22:29:31 +0000 (0:00:00.044)       0:06:21.562 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : Check for openshift excluder] ***********************
Sunday 11 November 2018  22:29:31 +0000 (0:00:00.227)       0:06:21.789 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : Enable docker excluder] *****************************
Sunday 11 November 2018  22:29:32 +0000 (0:00:00.221)       0:06:22.011 ******* 
changed: [40.114.93.240]

TASK [openshift_excluder : Enable openshift excluder] **************************
Sunday 11 November 2018  22:29:32 +0000 (0:00:00.288)       0:06:22.299 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Check for docker-excluder] **************************
Sunday 11 November 2018  22:29:32 +0000 (0:00:00.050)       0:06:22.350 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : disable docker excluder] ****************************
Sunday 11 November 2018  22:29:32 +0000 (0:00:00.218)       0:06:22.568 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Check for openshift excluder] ***********************
Sunday 11 November 2018  22:29:32 +0000 (0:00:00.043)       0:06:22.612 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : disable openshift excluder] *************************
Sunday 11 November 2018  22:29:33 +0000 (0:00:00.271)       0:06:22.884 ******* 
skipping: [40.114.93.240]

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

TASK [openshift_cloud_provider : Set cloud provider facts] *********************
Sunday 11 November 2018  22:29:33 +0000 (0:00:00.083)       0:06:22.967 ******* 
skipping: [40.114.93.240]

TASK [openshift_cloud_provider : Create cloudprovider config dir] **************
Sunday 11 November 2018  22:29:33 +0000 (0:00:00.042)       0:06:23.010 ******* 
skipping: [40.114.93.240]

TASK [openshift_cloud_provider : include the defined cloud provider files] *****
Sunday 11 November 2018  22:29:33 +0000 (0:00:00.044)       0:06:23.055 ******* 
skipping: [40.114.93.240]

TASK [openshift_node : fail] ***************************************************
Sunday 11 November 2018  22:29:33 +0000 (0:00:00.134)       0:06:23.190 ******* 
skipping: [40.114.93.240]

TASK [openshift_node : Check for NetworkManager service] ***********************
Sunday 11 November 2018  22:29:33 +0000 (0:00:00.044)       0:06:23.235 ******* 
ok: [40.114.93.240]

TASK [openshift_node : Set fact using_network_manager] *************************
Sunday 11 November 2018  22:29:33 +0000 (0:00:00.248)       0:06:23.484 ******* 
ok: [40.114.93.240]

TASK [openshift_node : Install dnsmasq] ****************************************
Sunday 11 November 2018  22:29:33 +0000 (0:00:00.068)       0:06:23.553 ******* 
changed: [40.114.93.240]

TASK [openshift_node : ensure origin/node directory exists] ********************
Sunday 11 November 2018  22:29:39 +0000 (0:00:05.471)       0:06:29.025 ******* 
changed: [40.114.93.240] => (item=/etc/origin)
changed: [40.114.93.240] => (item=/etc/origin/node)

TASK [openshift_node : Install NetworkManager during node_bootstrap provisioning] ***
Sunday 11 November 2018  22:29:39 +0000 (0:00:00.408)       0:06:29.434 ******* 
skipping: [40.114.93.240]

TASK [openshift_node : Install network manager dispatch script] ****************
Sunday 11 November 2018  22:29:39 +0000 (0:00:00.045)       0:06:29.480 ******* 
skipping: [40.114.93.240]

TASK [openshift_node : Add network manager configuration] **********************
Sunday 11 November 2018  22:29:39 +0000 (0:00:00.046)       0:06:29.526 ******* 
skipping: [40.114.93.240] => (item={u'key': u'dns', u'value': u'none', u'present': False}) 

TASK [openshift_node : Install dnsmasq configuration] **************************
Sunday 11 November 2018  22:29:39 +0000 (0:00:00.061)       0:06:29.587 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Deploy additional dnsmasq.conf] *************************
Sunday 11 November 2018  22:29:40 +0000 (0:00:00.602)       0:06:30.190 ******* 
skipping: [40.114.93.240]

TASK [openshift_node : Create override dnsmasq systemd unit directory] *********
Sunday 11 November 2018  22:29:40 +0000 (0:00:00.046)       0:06:30.237 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Copy systemd dnsmasq unit override file] ****************
Sunday 11 November 2018  22:29:40 +0000 (0:00:00.232)       0:06:30.470 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Enable dnsmasq] *****************************************
Sunday 11 November 2018  22:29:41 +0000 (0:00:00.584)       0:06:31.055 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Install network manager dispatch script] ****************
Sunday 11 November 2018  22:29:41 +0000 (0:00:00.322)       0:06:31.378 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Add network manager configuration] **********************
Sunday 11 November 2018  22:29:42 +0000 (0:00:00.590)       0:06:31.968 ******* 
ok: [40.114.93.240] => (item={u'key': u'dns', u'value': u'none', u'present': False})

RUNNING HANDLER [openshift_node : reload systemd units] ************************
Sunday 11 November 2018  22:29:42 +0000 (0:00:00.385)       0:06:32.354 ******* 
skipping: [40.114.93.240]

RUNNING HANDLER [openshift_node : restart NetworkManager] **********************
Sunday 11 November 2018  22:29:42 +0000 (0:00:00.045)       0:06:32.399 ******* 
skipping: [40.114.93.240]

RUNNING HANDLER [openshift_node : restart dnsmasq] *****************************
Sunday 11 November 2018  22:29:42 +0000 (0:00:00.044)       0:06:32.444 ******* 
skipping: [40.114.93.240]

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

TASK [openshift_node : Remove iptables rules] **********************************
Sunday 11 November 2018  22:29:44 +0000 (0:00:01.572)       0:06:34.089 ******* 

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

TASK [openshift_node : Remove firewalld allow rules] ***************************
Sunday 11 November 2018  22:29:44 +0000 (0:00:00.161)       0:06:34.296 ******* 

TASK [openshift_node : Restart cri-o] ******************************************
Sunday 11 November 2018  22:29:44 +0000 (0:00:00.047)       0:06:34.343 ******* 
changed: [40.114.93.240]

TASK [openshift_node : restart NetworkManager to ensure resolv.conf is present] ***
Sunday 11 November 2018  22:29:45 +0000 (0:00:00.501)       0:06:34.844 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Check that node image is present] ***********************
Sunday 11 November 2018  22:29:45 +0000 (0:00:00.436)       0:06:35.281 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Pre-pull node image] ************************************
Sunday 11 November 2018  22:29:45 +0000 (0:00:00.338)       0:06:35.619 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Check that pod image is present] ************************
Sunday 11 November 2018  22:29:47 +0000 (0:00:01.958)       0:06:37.577 ******* 
changed: [40.114.93.240]

TASK [openshift_node : pre-pull pod image] *************************************
Sunday 11 November 2018  22:29:48 +0000 (0:00:00.377)       0:06:37.955 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Install node, clients, and conntrack packages] **********
Sunday 11 November 2018  22:29:49 +0000 (0:00:01.471)       0:06:39.427 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Checking for journald.conf] *****************************
Sunday 11 November 2018  22:31:33 +0000 (0:01:44.246)       0:08:23.673 ******* 
ok: [40.114.93.240]

TASK [openshift_node : Create journald persistence directories] ****************
Sunday 11 November 2018  22:31:34 +0000 (0:00:00.277)       0:08:23.950 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Update journald setup] **********************************
Sunday 11 November 2018  22:31:34 +0000 (0:00:00.272)       0:08:24.223 ******* 
changed: [40.114.93.240] => (item={u'var': u'Storage', u'val': u'persistent'})
changed: [40.114.93.240] => (item={u'var': u'Compress', u'val': True})
changed: [40.114.93.240] => (item={u'var': u'SyncIntervalSec', u'val': u'1s'})
changed: [40.114.93.240] => (item={u'var': u'RateLimitInterval', u'val': u'1s'})
changed: [40.114.93.240] => (item={u'var': u'RateLimitBurst', u'val': 10000})
changed: [40.114.93.240] => (item={u'var': u'SystemMaxUse', u'val': u'8G'})
ok: [40.114.93.240] => (item={u'var': u'SystemKeepFree', u'val': u'20%'})
changed: [40.114.93.240] => (item={u'var': u'SystemMaxFileSize', u'val': u'10M'})
changed: [40.114.93.240] => (item={u'var': u'MaxRetentionSec', u'val': u'1month'})
ok: [40.114.93.240] => (item={u'var': u'MaxFileSec', u'val': u'1day'})
changed: [40.114.93.240] => (item={u'var': u'ForwardToSyslog', u'val': False})
changed: [40.114.93.240] => (item={u'var': u'ForwardToWall', u'val': False})
 [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
with a mode of 0700, this may cause issues when running as another user. To
avoid this, create the remote_tmp dir with the correct permissions manually

TASK [openshift_node : Restart journald] ***************************************
Sunday 11 November 2018  22:31:36 +0000 (0:00:02.377)       0:08:26.600 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Disable swap] *******************************************
Sunday 11 November 2018  22:31:37 +0000 (0:00:00.820)       0:08:27.421 ******* 
ok: [40.114.93.240]

TASK [openshift_node : sysctl] *************************************************
Sunday 11 November 2018  22:31:38 +0000 (0:00:00.397)       0:08:27.819 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Setting sebool container_manage_cgroup] *****************
Sunday 11 November 2018  22:31:38 +0000 (0:00:00.342)       0:08:28.161 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Check for credentials file for registry auth] ***********
Sunday 11 November 2018  22:31:39 +0000 (0:00:01.064)       0:08:29.226 ******* 
skipping: [40.114.93.240]

TASK [openshift_node : Create credentials for registry auth] *******************
Sunday 11 November 2018  22:31:39 +0000 (0:00:00.043)       0:08:29.270 ******* 
skipping: [40.114.93.240]

TASK [openshift_node : Create credentials for any additional registries] *******
Sunday 11 November 2018  22:31:39 +0000 (0:00:00.044)       0:08:29.314 ******* 

TASK [openshift_node : Check status of node image pre-pull] ********************
Sunday 11 November 2018  22:31:39 +0000 (0:00:00.042)       0:08:29.357 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Check status of node pod image pre-pull] ****************
Sunday 11 November 2018  22:31:39 +0000 (0:00:00.348)       0:08:29.705 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Copy node script to the node] ***************************
Sunday 11 November 2018  22:31:40 +0000 (0:00:00.236)       0:08:29.941 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Install Node service file] ******************************
Sunday 11 November 2018  22:31:40 +0000 (0:00:00.584)       0:08:30.526 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Configure Node settings] ********************************
Sunday 11 November 2018  22:31:41 +0000 (0:00:00.597)       0:08:31.123 ******* 
changed: [40.114.93.240] => (item={u'regex': u'^OPTIONS=', u'line': u'OPTIONS='})
changed: [40.114.93.240] => (item={u'regex': u'^DEBUG_LOGLEVEL=', u'line': u'DEBUG_LOGLEVEL=2'})
changed: [40.114.93.240] => (item={u'regex': u'^IMAGE_VERSION=', u'line': u'IMAGE_VERSION=v4.0'})

TASK [openshift_node : openshift_facts] ****************************************
Sunday 11 November 2018  22:31:41 +0000 (0:00:00.593)       0:08:31.717 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Configure Proxy Settings] *******************************
Sunday 11 November 2018  22:31:42 +0000 (0:00:00.689)       0:08:32.407 ******* 
skipping: [40.114.93.240] => (item={u'regex': u'^HTTP_PROXY=', u'line': u'HTTP_PROXY='}) 
skipping: [40.114.93.240] => (item={u'regex': u'^HTTPS_PROXY=', u'line': u'HTTPS_PROXY='}) 
skipping: [40.114.93.240] => (item={u'regex': u'^NO_PROXY=', u'line': u'NO_PROXY=[],172.30.0.0/16,10.128.0.0/14'}) 

TASK [openshift_node : Configure Node Environment Variables] *******************
Sunday 11 November 2018  22:31:42 +0000 (0:00:00.085)       0:08:32.492 ******* 

TASK [openshift_node : Ensure the node static pod directory exists] ************
Sunday 11 November 2018  22:31:42 +0000 (0:00:00.048)       0:08:32.540 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Configure AWS Cloud Provider Settings] ******************
Sunday 11 November 2018  22:31:42 +0000 (0:00:00.228)       0:08:32.769 ******* 
skipping: [40.114.93.240] => (item=None) 
skipping: [40.114.93.240] => (item=None) 
skipping: [40.114.93.240]

TASK [openshift_node : Install NFS storage plugin dependencies] ****************
Sunday 11 November 2018  22:31:43 +0000 (0:00:00.068)       0:08:32.838 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Check for existence of nfs sebooleans] ******************
Sunday 11 November 2018  22:31:51 +0000 (0:00:08.536)       0:08:41.374 ******* 
ok: [40.114.93.240] => (item=virt_use_nfs)
ok: [40.114.93.240] => (item=virt_sandbox_use_nfs)

TASK [openshift_node : Set seboolean to allow nfs storage plugin access from containers] ***
Sunday 11 November 2018  22:31:51 +0000 (0:00:00.407)       0:08:41.782 ******* 
ok: [40.114.93.240] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-11 22:31:51.741325', '_ansible_no_log': False, u'stdout': u'virt_use_nfs --> on', u'cmd': [u'getsebool', u'virt_use_nfs'], u'rc': 0, 'item': u'virt_use_nfs', u'delta': u'0:00:00.003602', '_ansible_item_label': u'virt_use_nfs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_use_nfs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_nfs --> on'], 'failed_when_result': False, u'start': u'2018-11-11 22:31:51.737723', '_ansible_ignore_errors': None, 'failed': False})
skipping: [40.114.93.240] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-11 22:31:51.910522', '_ansible_no_log': False, u'stdout': u'virt_use_nfs --> on', u'cmd': [u'getsebool', u'virt_sandbox_use_nfs'], u'rc': 0, 'item': u'virt_sandbox_use_nfs', u'delta': u'0:00:00.003221', '_ansible_item_label': u'virt_sandbox_use_nfs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_sandbox_use_nfs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_nfs --> on'], 'failed_when_result': False, u'start': u'2018-11-11 22:31:51.907301', '_ansible_ignore_errors': None, 'failed': False}) 

TASK [openshift_node : Set seboolean to allow nfs storage plugin access from containers (python 3)] ***
Sunday 11 November 2018  22:31:52 +0000 (0:00:00.276)       0:08:42.059 ******* 
skipping: [40.114.93.240] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-11 22:31:51.741325', '_ansible_no_log': False, u'stdout': u'virt_use_nfs --> on', u'cmd': [u'getsebool', u'virt_use_nfs'], u'rc': 0, 'item': u'virt_use_nfs', u'delta': u'0:00:00.003602', '_ansible_item_label': u'virt_use_nfs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_use_nfs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_nfs --> on'], 'failed_when_result': False, u'start': u'2018-11-11 22:31:51.737723', '_ansible_ignore_errors': None, 'failed': False}) 
skipping: [40.114.93.240] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-11 22:31:51.910522', '_ansible_no_log': False, u'stdout': u'virt_use_nfs --> on', u'cmd': [u'getsebool', u'virt_sandbox_use_nfs'], u'rc': 0, 'item': u'virt_sandbox_use_nfs', u'delta': u'0:00:00.003221', '_ansible_item_label': u'virt_sandbox_use_nfs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_sandbox_use_nfs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_nfs --> on'], 'failed_when_result': False, u'start': u'2018-11-11 22:31:51.907301', '_ansible_ignore_errors': None, 'failed': False}) 

TASK [openshift_node : Install GlusterFS storage plugin dependencies] **********
Sunday 11 November 2018  22:31:52 +0000 (0:00:00.090)       0:08:42.149 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Check for existence of fusefs sebooleans] ***************
Sunday 11 November 2018  22:31:56 +0000 (0:00:03.730)       0:08:45.879 ******* 
ok: [40.114.93.240] => (item=virt_use_fusefs)
ok: [40.114.93.240] => (item=virt_sandbox_use_fusefs)

TASK [openshift_node : Set seboolean to allow gluster storage plugin access from containers] ***
Sunday 11 November 2018  22:31:56 +0000 (0:00:00.409)       0:08:46.289 ******* 
changed: [40.114.93.240] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-11 22:31:56.247997', '_ansible_no_log': False, u'stdout': u'virt_use_fusefs --> off', u'cmd': [u'getsebool', u'virt_use_fusefs'], u'rc': 0, 'item': u'virt_use_fusefs', u'delta': u'0:00:00.003011', '_ansible_item_label': u'virt_use_fusefs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_use_fusefs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_fusefs --> off'], 'failed_when_result': False, u'start': u'2018-11-11 22:31:56.244986', '_ansible_ignore_errors': None, 'failed': False})
changed: [40.114.93.240] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-11 22:31:56.417241', '_ansible_no_log': False, u'stdout': u'virt_sandbox_use_fusefs --> off', u'cmd': [u'getsebool', u'virt_sandbox_use_fusefs'], u'rc': 0, 'item': u'virt_sandbox_use_fusefs', u'delta': u'0:00:00.002898', '_ansible_item_label': u'virt_sandbox_use_fusefs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_sandbox_use_fusefs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_sandbox_use_fusefs --> off'], 'failed_when_result': False, u'start': u'2018-11-11 22:31:56.414343', '_ansible_ignore_errors': None, 'failed': False})

TASK [openshift_node : Set seboolean to allow gluster storage plugin access from containers (python 3)] ***
Sunday 11 November 2018  22:31:58 +0000 (0:00:01.941)       0:08:48.231 ******* 
skipping: [40.114.93.240] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-11 22:31:56.247997', '_ansible_no_log': False, u'stdout': u'virt_use_fusefs --> off', u'cmd': [u'getsebool', u'virt_use_fusefs'], u'rc': 0, 'item': u'virt_use_fusefs', u'delta': u'0:00:00.003011', '_ansible_item_label': u'virt_use_fusefs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_use_fusefs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_use_fusefs --> off'], 'failed_when_result': False, u'start': u'2018-11-11 22:31:56.244986', '_ansible_ignore_errors': None, 'failed': False}) 
skipping: [40.114.93.240] => (item={'_ansible_parsed': True, 'stderr_lines': [], '_ansible_item_result': True, u'end': u'2018-11-11 22:31:56.417241', '_ansible_no_log': False, u'stdout': u'virt_sandbox_use_fusefs --> off', u'cmd': [u'getsebool', u'virt_sandbox_use_fusefs'], u'rc': 0, 'item': u'virt_sandbox_use_fusefs', u'delta': u'0:00:00.002898', '_ansible_item_label': u'virt_sandbox_use_fusefs', u'stderr': u'', u'changed': False, u'invocation': {u'module_args': {u'warn': True, u'executable': None, u'_uses_shell': False, u'_raw_params': u'getsebool virt_sandbox_use_fusefs', u'removes': None, u'argv': None, u'creates': None, u'chdir': None, u'stdin': None}}, 'stdout_lines': [u'virt_sandbox_use_fusefs --> off'], 'failed_when_result': False, u'start': u'2018-11-11 22:31:56.414343', '_ansible_ignore_errors': None, 'failed': False}) 

TASK [openshift_node : Install Ceph storage plugin dependencies] ***************
Sunday 11 November 2018  22:31:58 +0000 (0:00:00.098)       0:08:48.329 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Install iSCSI storage plugin dependencies] **************
Sunday 11 November 2018  22:32:14 +0000 (0:00:15.592)       0:09:03.922 ******* 
changed: [40.114.93.240]

TASK [openshift_node : restart services] ***************************************
Sunday 11 November 2018  22:32:20 +0000 (0:00:06.626)       0:09:10.549 ******* 
changed: [40.114.93.240] => (item=multipathd)
changed: [40.114.93.240] => (item=rpcbind)
changed: [40.114.93.240] => (item=iscsid)

TASK [openshift_node : Template multipath configuration] ***********************
Sunday 11 November 2018  22:32:21 +0000 (0:00:00.933)       0:09:11.482 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Enable and start multipath] *****************************
Sunday 11 November 2018  22:32:22 +0000 (0:00:00.644)       0:09:12.127 ******* 
changed: [40.114.93.240]

TASK [tuned : Check for tuned package] *****************************************
Sunday 11 November 2018  22:32:23 +0000 (0:00:00.820)       0:09:12.947 ******* 
ok: [40.114.93.240]

TASK [tuned : Ensure directory structure exists] *******************************
Sunday 11 November 2018  22:32:23 +0000 (0:00:00.308)       0:09:13.255 ******* 
changed: [40.114.93.240] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1541974790.0, 'owner': 'root', 'path': u'openshift', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8998334})
changed: [40.114.93.240] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-control-plane', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8998334})
changed: [40.114.93.240] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1541974790.0, 'owner': 'root', 'path': u'openshift-node', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8998334})
skipping: [40.114.93.240] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/recommend.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '02666', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'recommend.conf', 'size': 290, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8898335}) 
skipping: [40.114.93.240] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '0666', 'mtime': 1541974790.0, 'owner': 'root', 'path': u'openshift/tuned.conf', 'size': 593, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8898335}) 
skipping: [40.114.93.240] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift-control-plane/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '02666', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-control-plane/tuned.conf', 'size': 744, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8898335}) 
skipping: [40.114.93.240] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift-node/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '0666', 'mtime': 1541974790.0, 'owner': 'root', 'path': u'openshift-node/tuned.conf', 'size': 283, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8898335}) 

TASK [tuned : Ensure files are populated from templates] ***********************
Sunday 11 November 2018  22:32:24 +0000 (0:00:00.701)       0:09:13.956 ******* 
skipping: [40.114.93.240] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1541974790.0, 'owner': 'root', 'path': u'openshift', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8998334}) 
skipping: [40.114.93.240] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-control-plane', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8998334}) 
skipping: [40.114.93.240] => (item={'group': u'root', 'uid': 0, 'state': 'directory', 'gid': 0, 'mode': '02777', 'mtime': 1541974790.0, 'owner': 'root', 'path': u'openshift-node', 'size': 24, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8998334}) 
changed: [40.114.93.240] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/recommend.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '02666', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'recommend.conf', 'size': 290, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8898335})
changed: [40.114.93.240] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '0666', 'mtime': 1541974790.0, 'owner': 'root', 'path': u'openshift/tuned.conf', 'size': 593, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8898335})
changed: [40.114.93.240] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift-control-plane/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '02666', 'mtime': 1530051323.0, 'owner': 'root', 'path': u'openshift-control-plane/tuned.conf', 'size': 744, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8898335})
changed: [40.114.93.240] => (item={'src': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates/openshift-node/tuned.conf', 'group': u'root', 'uid': 0, 'state': 'file', 'gid': 0, 'mode': '0666', 'mtime': 1541974790.0, 'owner': 'root', 'path': u'openshift-node/tuned.conf', 'size': 283, 'root': u'/usr/share/ansible/openshift-ansible/roles/tuned/templates', 'ctime': 1541974983.8898335})

TASK [tuned : Make tuned use the recommended tuned profile on restart] *********
Sunday 11 November 2018  22:32:26 +0000 (0:00:02.299)       0:09:16.256 ******* 
changed: [40.114.93.240] => (item=/etc/tuned/active_profile)
changed: [40.114.93.240] => (item=/etc/tuned/profile_mode)

TASK [tuned : Restart tuned service] *******************************************
Sunday 11 November 2018  22:32:26 +0000 (0:00:00.455)       0:09:16.712 ******* 
changed: [40.114.93.240]

TASK [nickhammond.logrotate : nickhammond.logrotate | Install logrotate] *******
Sunday 11 November 2018  22:32:28 +0000 (0:00:01.468)       0:09:18.180 ******* 
ok: [40.114.93.240]

TASK [nickhammond.logrotate : nickhammond.logrotate | Setup logrotate.d scripts] ***
Sunday 11 November 2018  22:32:28 +0000 (0:00:00.460)       0:09:18.640 ******* 

TASK [openshift_storage_glusterfs : Ensure device mapper modules loaded] *******
Sunday 11 November 2018  22:32:28 +0000 (0:00:00.043)       0:09:18.684 ******* 
changed: [40.114.93.240]

TASK [openshift_storage_glusterfs : Install kernel modules package on Fedora] ***
Sunday 11 November 2018  22:32:29 +0000 (0:00:00.638)       0:09:19.323 ******* 
skipping: [40.114.93.240]

TASK [openshift_storage_glusterfs : load kernel modules] ***********************
Sunday 11 November 2018  22:32:29 +0000 (0:00:00.052)       0:09:19.375 ******* 
changed: [40.114.93.240]

RUNNING HANDLER [openshift_node : reload systemd units] ************************
Sunday 11 November 2018  22:32:30 +0000 (0:00:00.475)       0:09:19.850 ******* 
skipping: [40.114.93.240]

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

TASK [openshift_node : install needed rpm(s)] **********************************
Sunday 11 November 2018  22:32:30 +0000 (0:00:00.081)       0:09:19.932 ******* 
changed: [40.114.93.240]

TASK [openshift_node : create the directory for node] **************************
Sunday 11 November 2018  22:32:54 +0000 (0:00:24.273)       0:09:44.205 ******* 
skipping: [40.114.93.240]

TASK [openshift_node : laydown systemd override] *******************************
Sunday 11 November 2018  22:32:54 +0000 (0:00:00.049)       0:09:44.254 ******* 
skipping: [40.114.93.240]

TASK [openshift_node : update the sysconfig to have necessary variables] *******
Sunday 11 November 2018  22:32:54 +0000 (0:00:00.050)       0:09:44.305 ******* 
changed: [40.114.93.240] => (item={u'regexp': u'^KUBECONFIG=.*', u'line': u'KUBECONFIG=/etc/origin/node/bootstrap.kubeconfig'})

TASK [openshift_node : Configure AWS Cloud Provider Settings] ******************
Sunday 11 November 2018  22:32:54 +0000 (0:00:00.259)       0:09:44.565 ******* 
skipping: [40.114.93.240] => (item=None) 
skipping: [40.114.93.240] => (item=None) 
skipping: [40.114.93.240]

TASK [openshift_node : disable origin-node service] ****************************
Sunday 11 November 2018  22:32:54 +0000 (0:00:00.068)       0:09:44.633 ******* 
ok: [40.114.93.240] => (item=origin-node.service)

TASK [openshift_node : create directories for bootstrapping] *******************
Sunday 11 November 2018  22:32:55 +0000 (0:00:00.255)       0:09:44.888 ******* 
changed: [40.114.93.240] => (item=/root/openshift_bootstrap)
changed: [40.114.93.240] => (item=/var/lib/origin/openshift.local.config)
changed: [40.114.93.240] => (item=/var/lib/origin/openshift.local.config/node)
changed: [40.114.93.240] => (item=/etc/docker/certs.d/docker-registry.default.svc:5000)

TASK [openshift_node : laydown the bootstrap.yml file for on boot configuration] ***
Sunday 11 November 2018  22:32:55 +0000 (0:00:00.753)       0:09:45.642 ******* 
changed: [40.114.93.240]

TASK [openshift_node : Create a symlink to the node client CA for the docker registry] ***
Sunday 11 November 2018  22:32:56 +0000 (0:00:00.594)       0:09:46.237 ******* 
changed: [40.114.93.240]

TASK [openshift_node_group : create node config template] **********************
Sunday 11 November 2018  22:32:56 +0000 (0:00:00.288)       0:09:46.526 ******* 
changed: [40.114.93.240]

TASK [etcd : set etcd host and ip facts] ***************************************
Sunday 11 November 2018  22:32:57 +0000 (0:00:00.591)       0:09:47.117 ******* 
ok: [40.114.93.240]

TASK [etcd : Check that etcd image is present] *********************************
Sunday 11 November 2018  22:32:57 +0000 (0:00:00.072)       0:09:47.190 ******* 
changed: [40.114.93.240]

TASK [etcd : Pre-pull etcd image] **********************************************
Sunday 11 November 2018  22:32:57 +0000 (0:00:00.246)       0:09:47.436 ******* 
changed: [40.114.93.240]

TASK [etcd : Configure etcd profile.d aliases] *********************************
Sunday 11 November 2018  22:32:59 +0000 (0:00:01.437)       0:09:48.874 ******* 
changed: [40.114.93.240]

TASK [etcd : Add iptables allow rules] *****************************************
Sunday 11 November 2018  22:32:59 +0000 (0:00:00.717)       0:09:49.592 ******* 
changed: [40.114.93.240] => (item={u'port': u'2379/tcp', u'service': u'etcd'})
changed: [40.114.93.240] => (item={u'port': u'2380/tcp', u'service': u'etcd peering'})

TASK [etcd : Remove iptables rules] ********************************************
Sunday 11 November 2018  22:33:00 +0000 (0:00:00.727)       0:09:50.320 ******* 

TASK [etcd : Add firewalld allow rules] ****************************************
Sunday 11 November 2018  22:33:00 +0000 (0:00:00.044)       0:09:50.364 ******* 
skipping: [40.114.93.240] => (item={u'port': u'2379/tcp', u'service': u'etcd'}) 
skipping: [40.114.93.240] => (item={u'port': u'2380/tcp', u'service': u'etcd peering'}) 

TASK [etcd : Remove firewalld allow rules] *************************************
Sunday 11 November 2018  22:33:00 +0000 (0:00:00.076)       0:09:50.441 ******* 

TASK [etcd : Ensure etcd datadir exists] ***************************************
Sunday 11 November 2018  22:33:00 +0000 (0:00:00.045)       0:09:50.486 ******* 
changed: [40.114.93.240]

TASK [etcd : Validate permissions on the config dir] ***************************
Sunday 11 November 2018  22:33:00 +0000 (0:00:00.299)       0:09:50.786 ******* 
changed: [40.114.93.240]

TASK [etcd : Validate permissions on the static pods dir] **********************
Sunday 11 November 2018  22:33:01 +0000 (0:00:00.328)       0:09:51.114 ******* 
changed: [40.114.93.240]

TASK [etcd : Write etcd global config file] ************************************
Sunday 11 November 2018  22:33:01 +0000 (0:00:00.358)       0:09:51.474 ******* 
changed: [40.114.93.240]

TASK [etcd : Create temp directory for static pods] ****************************
Sunday 11 November 2018  22:33:02 +0000 (0:00:00.815)       0:09:52.289 ******* 
ok: [40.114.93.240]

TASK [etcd : Prepare etcd static pod] ******************************************
Sunday 11 November 2018  22:33:02 +0000 (0:00:00.330)       0:09:52.620 ******* 
changed: [40.114.93.240] => (item=etcd.yaml)

TASK [etcd : Update etcd static pod] *******************************************
Sunday 11 November 2018  22:33:03 +0000 (0:00:00.869)       0:09:53.490 ******* 
changed: [40.114.93.240] => (item=etcd.yaml)

TASK [etcd : Set etcd host as a probe target host] *****************************
Sunday 11 November 2018  22:33:03 +0000 (0:00:00.281)       0:09:53.772 ******* 
changed: [40.114.93.240] => (item=etcd.yaml)

TASK [etcd : Deploy etcd static pod] *******************************************
Sunday 11 November 2018  22:33:04 +0000 (0:00:00.290)       0:09:54.062 ******* 
changed: [40.114.93.240] => (item=etcd.yaml)

TASK [etcd : Remove temp directory] ********************************************
Sunday 11 November 2018  22:33:04 +0000 (0:00:00.318)       0:09:54.381 ******* 
ok: [40.114.93.240]

TASK [openshift_control_plane : Copy static master scripts] ********************
Sunday 11 November 2018  22:33:04 +0000 (0:00:00.234)       0:09:54.615 ******* 
changed: [40.114.93.240] => (item=scripts/crio/master-exec)
changed: [40.114.93.240] => (item=scripts/crio/master-logs)
changed: [40.114.93.240] => (item=scripts/crio/master-restart)

TASK [openshift_control_plane : Ensure cri-tools installed] ********************
Sunday 11 November 2018  22:33:06 +0000 (0:00:01.651)       0:09:56.267 ******* 
ok: [40.114.93.240]

TASK [openshift_control_plane : Enable bootstrapping in the master config] *****
Sunday 11 November 2018  22:33:06 +0000 (0:00:00.454)       0:09:56.722 ******* 
skipping: [40.114.93.240]

TASK [openshift_control_plane : Create temp directory for static pods] *********
Sunday 11 November 2018  22:33:06 +0000 (0:00:00.050)       0:09:56.772 ******* 
ok: [40.114.93.240]

TASK [openshift_control_plane : Prepare master static pods] ********************
Sunday 11 November 2018  22:33:07 +0000 (0:00:00.233)       0:09:57.006 ******* 
changed: [40.114.93.240] => (item=apiserver.yaml)
changed: [40.114.93.240] => (item=controller.yaml)

TASK [openshift_control_plane : Update master static pods] *********************
Sunday 11 November 2018  22:33:08 +0000 (0:00:01.434)       0:09:58.440 ******* 
changed: [40.114.93.240] => (item=apiserver.yaml)
changed: [40.114.93.240] => (item=controller.yaml)

TASK [openshift_control_plane : Update master static pod (api)] ****************
Sunday 11 November 2018  22:33:09 +0000 (0:00:00.531)       0:09:58.972 ******* 
ok: [40.114.93.240]

TASK [openshift_control_plane : ensure pod location exists] ********************
Sunday 11 November 2018  22:33:09 +0000 (0:00:00.285)       0:09:59.257 ******* 
changed: [40.114.93.240]

TASK [openshift_control_plane : Update master static pods] *********************
Sunday 11 November 2018  22:33:09 +0000 (0:00:00.243)       0:09:59.500 ******* 
changed: [40.114.93.240] => (item=apiserver.yaml)
changed: [40.114.93.240] => (item=controller.yaml)

TASK [openshift_control_plane : Remove temporary directory] ********************
Sunday 11 November 2018  22:33:10 +0000 (0:00:00.564)       0:10:00.064 ******* 
ok: [40.114.93.240]

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

TASK [openshift_excluder : Debug r_openshift_excluder_enable_docker_excluder] ***
Sunday 11 November 2018  22:33:10 +0000 (0:00:00.253)       0:10:00.318 ******* 
ok: [40.114.93.240] => {
    "r_openshift_excluder_enable_docker_excluder": true
}

TASK [openshift_excluder : Debug r_openshift_excluder_enable_openshift_excluder] ***
Sunday 11 November 2018  22:33:10 +0000 (0:00:00.076)       0:10:00.395 ******* 
ok: [40.114.93.240] => {
    "r_openshift_excluder_enable_openshift_excluder": true
}

TASK [openshift_excluder : Fail if invalid openshift_excluder_action provided] ***
Sunday 11 November 2018  22:33:10 +0000 (0:00:00.072)       0:10:00.467 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Fail if r_openshift_excluder_upgrade_target is not defined] ***
Sunday 11 November 2018  22:33:10 +0000 (0:00:00.046)       0:10:00.513 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Include main action task file] **********************
Sunday 11 November 2018  22:33:10 +0000 (0:00:00.046)       0:10:00.560 ******* 
included: /usr/share/ansible/openshift-ansible/roles/openshift_excluder/tasks/enable.yml for 40.114.93.240

TASK [openshift_excluder : Install docker excluder - yum] **********************
Sunday 11 November 2018  22:33:10 +0000 (0:00:00.091)       0:10:00.652 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Install docker excluder - dnf] **********************
Sunday 11 November 2018  22:33:10 +0000 (0:00:00.047)       0:10:00.699 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Install openshift excluder - yum] *******************
Sunday 11 November 2018  22:33:10 +0000 (0:00:00.046)       0:10:00.746 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Install openshift excluder - dnf] *******************
Sunday 11 November 2018  22:33:10 +0000 (0:00:00.046)       0:10:00.792 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : set_fact] *******************************************
Sunday 11 November 2018  22:33:11 +0000 (0:00:00.045)       0:10:00.838 ******* 
skipping: [40.114.93.240]

TASK [openshift_excluder : Check for docker-excluder] **************************
Sunday 11 November 2018  22:33:11 +0000 (0:00:00.046)       0:10:00.884 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : Check for openshift excluder] ***********************
Sunday 11 November 2018  22:33:11 +0000 (0:00:00.238)       0:10:01.123 ******* 
ok: [40.114.93.240]

TASK [openshift_excluder : Enable docker excluder] *****************************
Sunday 11 November 2018  22:33:11 +0000 (0:00:00.233)       0:10:01.356 ******* 
changed: [40.114.93.240]

TASK [openshift_excluder : Enable openshift excluder] **************************
Sunday 11 November 2018  22:33:11 +0000 (0:00:00.265)       0:10:01.622 ******* 
skipping: [40.114.93.240]

PLAY [Reboot instance] *********************************************************

TASK [openshift_aws : fetch newly created instances] ***************************
Sunday 11 November 2018  22:33:11 +0000 (0:00:00.037)       0:10:01.659 ******* 
skipping: [localhost]

TASK [openshift_aws : reboot hosts] ********************************************
Sunday 11 November 2018  22:33:11 +0000 (0:00:00.028)       0:10:01.688 ******* 
skipping: [localhost]

TASK [openshift_aws : wait for ssh to become available] ************************
Sunday 11 November 2018  22:33:11 +0000 (0:00:00.035)       0:10:01.723 ******* 
skipping: [localhost]

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

TASK [openshift_aws : fetch block device of slash filesystem] ******************
Sunday 11 November 2018  22:33:11 +0000 (0:00:00.055)       0:10:01.779 ******* 
skipping: [40.114.93.240]

TASK [openshift_aws : fetch filesystem of slash block device] ******************
Sunday 11 November 2018  22:33:12 +0000 (0:00:00.047)       0:10:01.826 ******* 
skipping: [40.114.93.240]

TASK [openshift_aws : fetch uuid of slash block device] ************************
Sunday 11 November 2018  22:33:12 +0000 (0:00:00.045)       0:10:01.872 ******* 
skipping: [40.114.93.240]

TASK [openshift_aws : ensure nonUUID based slash mount entry in /etc/fstab is removed] ***
Sunday 11 November 2018  22:33:12 +0000 (0:00:00.044)       0:10:01.917 ******* 
skipping: [40.114.93.240]

TASK [openshift_aws : ensure slash mount uses UUID device and gquota option in /etc/fstab] ***
Sunday 11 November 2018  22:33:12 +0000 (0:00:00.044)       0:10:01.962 ******* 
skipping: [40.114.93.240]

TASK [openshift_aws : set rootvol flags in grub conf] **************************
Sunday 11 November 2018  22:33:12 +0000 (0:00:00.051)       0:10:02.013 ******* 
skipping: [40.114.93.240]

TASK [openshift_aws : recreate grub2 config] ***********************************
Sunday 11 November 2018  22:33:12 +0000 (0:00:00.046)       0:10:02.060 ******* 
skipping: [40.114.93.240]

TASK [Remove any ansible facts created during AMI creation] ********************
Sunday 11 November 2018  22:33:12 +0000 (0:00:00.046)       0:10:02.107 ******* 
changed: [40.114.93.240] => (item=openshift.fact)

TASK [Clean cloud-init path] ***************************************************
Sunday 11 November 2018  22:33:12 +0000 (0:00:00.281)       0:10:02.388 ******* 
ok: [40.114.93.240]

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

TASK [remove yum client certificate] *******************************************
Sunday 11 November 2018  22:33:12 +0000 (0:00:00.236)       0:10:02.625 ******* 
skipping: [40.114.93.240] => (item={u'name': u'client-cert.pem'}) 
skipping: [40.114.93.240] => (item={u'name': u'client-key.pem'}) 

TASK [remove yum repositories] *************************************************
Sunday 11 November 2018  22:33:12 +0000 (0:00:00.058)       0:10:02.683 ******* 
changed: [40.114.93.240] => (item={u'gpgkey': u'file:///etc/pki/rpm-gpg/RPM-GPG-KEY-CentOS-SIG-PaaS', u'enabled': True, u'name': u'openshift-origin', u'baseurl': u'http://mirror.centos.org/centos/7/paas/x86_64/openshift-origin/'})
changed: [40.114.93.240] => (item={'gpgcheck': False, 'enabled': True, 'name': u'install_repo', 'baseurl': u'https://storage.googleapis.com/origin-ci-test/logs/test_branch_origin_extended_conformance_gce/3628/artifacts/rpms'})

TASK [add get-node-logs script] ************************************************
Sunday 11 November 2018  22:33:13 +0000 (0:00:00.477)       0:10:03.161 ******* 
changed: [40.114.93.240]

TASK [record installed rpms] ***************************************************
Sunday 11 November 2018  22:33:13 +0000 (0:00:00.648)       0:10:03.809 ******* 
ok: [40.114.93.240]

TASK [disable waagent data disk management] ************************************
Sunday 11 November 2018  22:33:15 +0000 (0:00:01.263)       0:10:05.073 ******* 
changed: [40.114.93.240] => (item={u'regexp': u'^ResourceDisk\\.Format=', u'line': u'ResourceDisk.Format=n'})

TASK [persist oreg_url] ********************************************************
Sunday 11 November 2018  22:33:16 +0000 (0:00:01.125)       0:10:06.198 ******* 
skipping: [40.114.93.240]

TASK [create a file with image name] *******************************************
Sunday 11 November 2018  22:33:16 +0000 (0:00:00.045)       0:10:06.244 ******* 
changed: [40.114.93.240]

TASK [run waagent deprovision] *************************************************
Sunday 11 November 2018  22:33:17 +0000 (0:00:00.595)       0:10:06.839 ******* 
changed: [40.114.93.240]

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

TASK [set_fact] ****************************************************************
Sunday 11 November 2018  22:33:18 +0000 (0:00:01.359)       0:10:08.199 ******* 
ok: [localhost]

TASK [deallocate vm] ***********************************************************
Sunday 11 November 2018  22:33:18 +0000 (0:00:00.067)       0:10:08.267 ******* 
changed: [localhost]

TASK [generalize vm] ***********************************************************
Sunday 11 November 2018  22:34:37 +0000 (0:01:18.912)       0:11:27.179 ******* 
changed: [localhost]

TASK [get vm details] **********************************************************
Sunday 11 November 2018  22:34:38 +0000 (0:00:01.638)       0:11:28.818 ******* 
changed: [localhost]

TASK [create image resource group] *********************************************
Sunday 11 November 2018  22:34:40 +0000 (0:00:01.647)       0:11:30.465 ******* 
ok: [localhost]

TASK [create image] ************************************************************
Sunday 11 November 2018  22:34:41 +0000 (0:00:00.836)       0:11:31.302 ******* 
changed: [localhost]

TASK [get input image tags] ****************************************************
Sunday 11 November 2018  22:35:15 +0000 (0:00:33.563)       0:12:04.866 ******* 
changed: [localhost]

TASK [remove valid tag from input image tags] **********************************
Sunday 11 November 2018  22:35:16 +0000 (0:00:01.615)       0:12:06.481 ******* 
ok: [localhost] => (item={'value': u'3.10.0-693.el7.x86_64', 'key': u'kernel'})
skipping: [localhost] => (item={'value': u'true', 'key': u'valid'}) 
ok: [localhost] => (item={'value': u'centos7-root-201804191712', 'key': u'root_image'})

TASK [calculate final tags] ****************************************************
Sunday 11 November 2018  22:35:16 +0000 (0:00:00.063)       0:12:06.545 ******* 
ok: [localhost]

TASK [tag image] ***************************************************************
Sunday 11 November 2018  22:35:16 +0000 (0:00:00.062)       0:12:06.607 ******* 
changed: [localhost]

TASK [log image resource group and name] ***************************************
Sunday 11 November 2018  22:35:50 +0000 (0:00:33.461)       0:12:40.068 ******* 
ok: [localhost] => (item=Resource group: images) => {
    "msg": "Resource group: images"
}
ok: [localhost] => (item=Image name: centos7-master-201811112220) => {
    "msg": "Image name: centos7-master-201811112220"
}

TASK [log image tag information] ***********************************************
Sunday 11 November 2018  22:35:50 +0000 (0:00:00.044)       0:12:40.113 ******* 
ok: [localhost] => (item={'value': u'3.10.0-862.14.4.el7.x86_64', 'key': u'kernel'}) => {
    "msg": "kernel: 3.10.0-862.14.4.el7.x86_64"
}
ok: [localhost] => (item={'value': u'centos7-base-201811112206', 'key': u'base_image'}) => {
    "msg": "base_image: centos7-base-201811112206"
}
ok: [localhost] => (item={'value': u'centos7-root-201804191712', 'key': u'root_image'}) => {
    "msg": "root_image: centos7-root-201804191712"
}
ok: [localhost] => (item={'value': u'4.0.0-0.alpha.0.9.8d6f6f3.x86_64', 'key': u'openshift'}) => {
    "msg": "openshift: 4.0.0-0.alpha.0.9.8d6f6f3.x86_64"
}

TASK [get vm details] **********************************************************
Sunday 11 November 2018  22:35:50 +0000 (0:00:00.059)       0:12:40.173 ******* 
changed: [localhost]

TASK [get storage account key] *************************************************
Sunday 11 November 2018  22:35:52 +0000 (0:00:01.666)       0:12:41.840 ******* 
changed: [localhost]

TASK [get disk sas url] ********************************************************
Sunday 11 November 2018  22:35:53 +0000 (0:00:01.745)       0:12:43.585 ******* 
changed: [localhost]

TASK [start copy] **************************************************************
Sunday 11 November 2018  22:36:26 +0000 (0:00:32.790)       0:13:16.376 ******* 
changed: [localhost]

TASK [get copy status] *********************************************************
Sunday 11 November 2018  22:36:29 +0000 (0:00:02.444)       0:13:18.820 ******* 
FAILED - RETRYING: get copy status (120 retries left).
FAILED - RETRYING: get copy status (119 retries left).
FAILED - RETRYING: get copy status (118 retries left).
FAILED - RETRYING: get copy status (117 retries left).
FAILED - RETRYING: get copy status (116 retries left).
FAILED - RETRYING: get copy status (115 retries left).
FAILED - RETRYING: get copy status (114 retries left).
FAILED - RETRYING: get copy status (113 retries left).
FAILED - RETRYING: get copy status (112 retries left).
FAILED - RETRYING: get copy status (111 retries left).
FAILED - RETRYING: get copy status (110 retries left).
FAILED - RETRYING: get copy status (109 retries left).
FAILED - RETRYING: get copy status (108 retries left).
FAILED - RETRYING: get copy status (107 retries left).
FAILED - RETRYING: get copy status (106 retries left).
FAILED - RETRYING: get copy status (105 retries left).
FAILED - RETRYING: get copy status (104 retries left).
FAILED - RETRYING: get copy status (103 retries left).
FAILED - RETRYING: get copy status (102 retries left).
FAILED - RETRYING: get copy status (101 retries left).
FAILED - RETRYING: get copy status (100 retries left).
changed: [localhost]

TASK [revoke disk sas url] *****************************************************
Sunday 11 November 2018  22:47:31 +0000 (0:11:02.668)       0:24:21.489 ******* 
changed: [localhost]

PLAY RECAP *********************************************************************
40.114.93.240              : ok=195  changed=112  unreachable=0    failed=0   
localhost                  : ok=27   changed=18   unreachable=0    failed=0   


INSTALLER STATUS ***************************************************************
Initialization  : Complete (0:00:21)
Sunday 11 November 2018  22:48:04 +0000 (0:00:32.915)       0:24:54.405 ******* 
=============================================================================== 
get copy status ------------------------------------------------------- 662.67s
create vm ------------------------------------------------------------- 188.57s
openshift_node : Install node, clients, and conntrack packages -------- 104.25s
deallocate vm ---------------------------------------------------------- 78.91s
container_runtime : Install Docker ------------------------------------- 51.44s
create image ----------------------------------------------------------- 33.56s
tag image -------------------------------------------------------------- 33.46s
revoke disk sas url ---------------------------------------------------- 32.92s
get disk sas url ------------------------------------------------------- 32.79s
openshift_node : install needed rpm(s) --------------------------------- 24.27s
openshift_node : Install Ceph storage plugin dependencies -------------- 15.59s
create vnet ------------------------------------------------------------ 15.49s
Ensure openshift-ansible installer package deps are installed ---------- 12.77s
install centos-release-paas-common rpm --------------------------------- 12.45s
container_runtime : Install cri-o -------------------------------------- 11.73s
os_firewall : need to pause here, otherwise the iptables service starting can sometimes cause ssh to fail -- 10.09s
os_firewall : Wait 10 seconds after disabling firewalld ---------------- 10.07s
os_firewall : Install iptables packages --------------------------------- 9.32s
openshift_node : Install NFS storage plugin dependencies ---------------- 8.54s
openshift_node : Install iSCSI storage plugin dependencies -------------- 6.63s
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: BUILD NODE IMAGE [00h 24m 59s] ##########
[workspace] $ /bin/bash /tmp/jenkins682092072046348483.sh
########## STARTING STAGE: RUN THE ACS-ENGINE E2E TEST ##########
+ [[ -s /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate ]]
+ source /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
++ mktemp
+ script=/tmp/tmp.9VQMlMNlOY
+ cat
+ chmod +x /tmp/tmp.9VQMlMNlOY
+ scp -F /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.9VQMlMNlOY openshiftdevel:/tmp/tmp.9VQMlMNlOY
+ ssh -F /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.9VQMlMNlOY"'
+ cd /home/origin
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RUN THE ACS-ENGINE E2E TEST [00h 00m 01s] ##########
[workspace] $ /bin/bash /tmp/jenkins5178848353516961212.sh
########## STARTING STAGE: TAG NODE IMAGE AS VALID ##########
+ [[ -s /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate ]]
+ source /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
++ mktemp
+ script=/tmp/tmp.OJCRmpuiCM
+ cat
+ chmod +x /tmp/tmp.OJCRmpuiCM
+ scp -F /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.OJCRmpuiCM openshiftdevel:/tmp/tmp.OJCRmpuiCM
+ ssh -F /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.OJCRmpuiCM"'
+ cd /data/src/github.com/openshift/release
+ cd cluster/test-deploy/azure
+ TYPE=azure
+ INSTANCE_PREFIX=unused
+ ../../bin/ansible.sh ansible-playbook -e openshift_azure_resource_group_name=ci-azure_build_node_image_centos-151 -e openshift_azure_input_image_ns=images -e openshift_azure_input_image_name=centos7-master-201811112220 playbooks/azure/openshift-cluster/tag_image_as_valid.yml

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

TASK [add valid tag to the image] **********************************************
Sunday 11 November 2018  22:48:08 +0000 (0:00:00.074)       0:00:00.074 ******* 
changed: [localhost]

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

Sunday 11 November 2018  22:48:42 +0000 (0:00:34.513)       0:00:34.587 ******* 
=============================================================================== 
add valid tag to the image --------------------------------------------- 34.51s
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: TAG NODE IMAGE AS VALID [00h 00m 37s] ##########
[PostBuildScript] - Executing post build scripts.
[workspace] $ /bin/bash /tmp/jenkins5911684753565570416.sh
########## STARTING STAGE: CLEAN UP RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate ]]
+ source /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
++ mktemp
+ script=/tmp/tmp.0diD0126NK
+ cat
+ chmod +x /tmp/tmp.0diD0126NK
+ scp -F /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.0diD0126NK openshiftdevel:/tmp/tmp.0diD0126NK
+ ssh -F /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 14400 /tmp/tmp.0diD0126NK"'
+ cd /data/src/github.com/openshift/release
+ cd cluster/test-deploy/azure
+ TYPE=azure
+ INSTANCE_PREFIX=unused
+ ../../bin/ansible.sh ansible-playbook -e openshift_azure_resource_group_name=ci-azure_build_node_image_centos-151 playbooks/azure/openshift-cluster/deprovision.yml

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

TASK [delete resource group] ***************************************************
Sunday 11 November 2018  22:48:45 +0000 (0:00:00.076)       0:00:00.076 ******* 
changed: [localhost]

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

Sunday 11 November 2018  22:51:18 +0000 (0:02:33.106)       0:02:33.182 ******* 
=============================================================================== 
delete resource group ------------------------------------------------- 153.11s
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: CLEAN UP RESOURCES [00h 02m 37s] ##########
[workspace] $ /bin/bash /tmp/jenkins3721483432871833895.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate ]]
+ source /var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed
++ export PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config
+ oct deprovision

PLAYBOOK: main.yml *************************************************************
4 plays in /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml

PLAY [ensure we have the parameters necessary to deprovision virtual hosts] ****

TASK [ensure all required variables are set] ***********************************
task path: /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:9
skipping: [localhost] => (item=origin_ci_inventory_dir)  => {
    "changed": false, 
    "generated_timestamp": "2018-11-11 17:51:20.145062", 
    "item": "origin_ci_inventory_dir", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region)  => {
    "changed": false, 
    "generated_timestamp": "2018-11-11 17:51:20.149272", 
    "item": "origin_ci_aws_region", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}

PLAY [deprovision virtual hosts in EC2] ****************************************

TASK [Gathering Facts] *********************************************************
ok: [localhost]

TASK [deprovision a virtual EC2 host] ******************************************
task path: /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:28
included: /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml for localhost

TASK [update the SSH configuration to remove AWS EC2 specifics] ****************
task path: /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:2
ok: [localhost] => {
    "changed": false, 
    "generated_timestamp": "2018-11-11 17:51:20.913262", 
    "msg": ""
}

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

TASK [tear down the EC2 instance] **********************************************
task path: /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:15
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-11-11 17:51:22.424040", 
    "instance_ids": [
        "i-0de27d8836ce2efbd"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-09d734b62262880ae"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0541baabc62377f2f"
                }
            }, 
            "dns_name": "ec2-54-173-25-91.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-0de27d8836ce2efbd", 
            "image_id": "ami-0b77b87a37c3e662c", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "libra", 
            "launch_time": "2018-11-11T22:18:07.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-11-2.ec2.internal", 
            "private_ip": "172.18.11.2", 
            "public_dns_name": "ec2-54-173-25-91.compute-1.amazonaws.com", 
            "public_ip": "54.173.25.91", 
            "ramdisk": null, 
            "region": "us-east-1", 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "running", 
            "state_code": 16, 
            "tags": {
                "Name": "oct-terminate", 
                "openshift_etcd": "", 
                "openshift_master": "", 
                "openshift_node": ""
            }, 
            "tenancy": "default", 
            "virtualization_type": "hvm"
        }
    ], 
    "tagged_instances": []
}

TASK [remove the serialized host variables] ************************************
task path: /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:22
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-11-11 17:51:22.664489", 
    "path": "/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.11.2.yml", 
    "state": "absent"
}

PLAY [deprovision virtual hosts locally manged by Vagrant] *********************

TASK [Gathering Facts] *********************************************************
ok: [localhost]

PLAY [clean up local configuration for deprovisioned instances] ****************

TASK [remove inventory configuration directory] ********************************
task path: /var/lib/jenkins/origin-ci-tool/2b40f3e11aadb569dc9c0c9fb90e7273658ce6ed/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:61
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-11-11 17:51:23.112332", 
    "path": "/var/lib/jenkins/jobs/azure_build_node_image_centos/workspace/.config/origin-ci-tool/inventory", 
    "state": "absent"
}

PLAY RECAP *********************************************************************
localhost                  : ok=8    changed=4    unreachable=0    failed=0   

+ set +o xtrace
########## FINISHED STAGE: SUCCESS: DEPROVISION CLOUD RESOURCES [00h 00m 04s] ##########
Archiving artifacts
Recording test results
[WS-CLEANUP] Deleting project workspace...[WS-CLEANUP] done
Finished: SUCCESS