2025-10-24 12:01:30.863125 | Job console starting 2025-10-24 12:01:30.871915 | Updating git repos 2025-10-24 12:01:30.908459 | Cloning repos into workspace 2025-10-24 12:01:30.984024 | Restoring repo states 2025-10-24 12:01:31.013863 | Merging changes 2025-10-24 12:01:31.923175 | Checking out repos 2025-10-24 12:01:32.036839 | Preparing playbooks 2025-10-24 12:01:32.850010 | Running Ansible setup 2025-10-24 12:01:38.392701 | PRE-RUN START: [trusted : github.com/YAKEcloud/zuul-config/playbooks/base/pre.yaml@main] 2025-10-24 12:01:39.483172 | 2025-10-24 12:01:39.483274 | PLAY [Base pre] 2025-10-24 12:01:39.494925 | 2025-10-24 12:01:39.495007 | TASK [Setup log path fact] 2025-10-24 12:01:39.522764 | ubuntu-jammy | ok 2025-10-24 12:01:39.534166 | 2025-10-24 12:01:39.534250 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-24 12:01:39.588813 | ubuntu-jammy | ok 2025-10-24 12:01:39.603411 | 2025-10-24 12:01:39.603498 | TASK [emit-job-header : Print job information] 2025-10-24 12:01:39.651291 | # Job Information 2025-10-24 12:01:39.651495 | Ansible Version: 2.16.14 2025-10-24 12:01:39.651538 | Job: python-black 2025-10-24 12:01:39.651572 | Pipeline: check 2025-10-24 12:01:39.651596 | Executor: 521e9411259a 2025-10-24 12:01:39.651617 | Triggered by: https://github.com/YAKEcloud/yake-ansible/pull/325 2025-10-24 12:01:39.651640 | Event ID: 0c520280-b0d1-11f0-9718-18c025d5eef2 2025-10-24 12:01:39.656238 | 2025-10-24 12:01:39.656327 | LOOP [emit-job-header : Print node information] 2025-10-24 12:01:39.749774 | ubuntu-jammy | ok: 2025-10-24 12:01:39.750023 | ubuntu-jammy | # Node Information 2025-10-24 12:01:39.750060 | ubuntu-jammy | Inventory Hostname: ubuntu-jammy 2025-10-24 12:01:39.750081 | ubuntu-jammy | Hostname: ubuntu 2025-10-24 12:01:39.750099 | ubuntu-jammy | Username: zuul 2025-10-24 12:01:39.750116 | ubuntu-jammy | Distro: Ubuntu 22.04 2025-10-24 12:01:39.750140 | ubuntu-jammy | Provider: regiocloud-a 2025-10-24 12:01:39.750161 | ubuntu-jammy | Region: 2025-10-24 12:01:39.750178 | ubuntu-jammy | Label: ubuntu-jammy 2025-10-24 12:01:39.750194 | ubuntu-jammy | Product Name: OpenStack Nova 2025-10-24 12:01:39.750210 | ubuntu-jammy | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4f:1947 2025-10-24 12:01:39.770223 | 2025-10-24 12:01:39.770318 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-24 12:01:40.451768 | ubuntu-jammy -> localhost | changed 2025-10-24 12:01:40.457358 | 2025-10-24 12:01:40.457435 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-24 12:01:41.374613 | ubuntu-jammy -> localhost | changed 2025-10-24 12:01:41.384171 | 2025-10-24 12:01:41.384263 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-24 12:01:41.618978 | ubuntu-jammy -> localhost | ok 2025-10-24 12:01:41.623966 | 2025-10-24 12:01:41.624050 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-24 12:01:41.640351 | ubuntu-jammy | ok 2025-10-24 12:01:41.658095 | ubuntu-jammy | included: /var/lib/zuul/builds/8c51ae61b376428d85e991ece31fc02b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-24 12:01:41.677133 | 2025-10-24 12:01:41.677213 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-24 12:01:43.277779 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2025-10-24 12:01:43.277979 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/8c51ae61b376428d85e991ece31fc02b/work/8c51ae61b376428d85e991ece31fc02b_id_rsa 2025-10-24 12:01:43.278018 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/8c51ae61b376428d85e991ece31fc02b/work/8c51ae61b376428d85e991ece31fc02b_id_rsa.pub 2025-10-24 12:01:43.278045 | ubuntu-jammy -> localhost | The key fingerprint is: 2025-10-24 12:01:43.278070 | ubuntu-jammy -> localhost | SHA256:HPRfjOkZv7nWrzTmGpofOCTFcDVMFvpJfMQ62s0J3z8 zuul-build-sshkey 2025-10-24 12:01:43.278093 | ubuntu-jammy -> localhost | The key's randomart image is: 2025-10-24 12:01:43.278122 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2025-10-24 12:01:43.278146 | ubuntu-jammy -> localhost | | o .+*o. | 2025-10-24 12:01:43.278168 | ubuntu-jammy -> localhost | | . = +.*. | 2025-10-24 12:01:43.278188 | ubuntu-jammy -> localhost | | . = *.+ | 2025-10-24 12:01:43.278207 | ubuntu-jammy -> localhost | | . o =+B | 2025-10-24 12:01:43.278227 | ubuntu-jammy -> localhost | | S .o**.o | 2025-10-24 12:01:43.278253 | ubuntu-jammy -> localhost | | o... =o.| 2025-10-24 12:01:43.278273 | ubuntu-jammy -> localhost | | o o *..| 2025-10-24 12:01:43.278293 | ubuntu-jammy -> localhost | | + *.Eo| 2025-10-24 12:01:43.278314 | ubuntu-jammy -> localhost | | o.oo+.+| 2025-10-24 12:01:43.278334 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2025-10-24 12:01:43.278384 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:01.117884 2025-10-24 12:01:43.284406 | 2025-10-24 12:01:43.284497 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-24 12:01:43.326602 | ubuntu-jammy | ok 2025-10-24 12:01:43.340007 | ubuntu-jammy | included: /var/lib/zuul/builds/8c51ae61b376428d85e991ece31fc02b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-24 12:01:43.348758 | 2025-10-24 12:01:43.348882 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-24 12:01:43.361645 | ubuntu-jammy | skipping: Conditional result was False 2025-10-24 12:01:43.367484 | 2025-10-24 12:01:43.367581 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-24 12:01:43.947500 | ubuntu-jammy | changed 2025-10-24 12:01:43.951936 | 2025-10-24 12:01:43.952008 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-24 12:01:44.202133 | ubuntu-jammy | ok 2025-10-24 12:01:44.218657 | 2025-10-24 12:01:44.218817 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-24 12:01:44.895390 | ubuntu-jammy | changed 2025-10-24 12:01:44.901754 | 2025-10-24 12:01:44.901849 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-24 12:01:45.465593 | ubuntu-jammy | changed 2025-10-24 12:01:45.471971 | 2025-10-24 12:01:45.472063 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-24 12:01:45.484749 | ubuntu-jammy | skipping: Conditional result was False 2025-10-24 12:01:45.491622 | 2025-10-24 12:01:45.491721 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-24 12:01:45.847467 | ubuntu-jammy -> localhost | changed 2025-10-24 12:01:45.857875 | 2025-10-24 12:01:45.857976 | TASK [add-build-sshkey : Add back temp key] 2025-10-24 12:01:46.164958 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/8c51ae61b376428d85e991ece31fc02b/work/8c51ae61b376428d85e991ece31fc02b_id_rsa (zuul-build-sshkey) 2025-10-24 12:01:46.165428 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.013002 2025-10-24 12:01:46.183526 | 2025-10-24 12:01:46.183670 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-24 12:01:46.559391 | ubuntu-jammy | ok 2025-10-24 12:01:46.564117 | 2025-10-24 12:01:46.564202 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-24 12:01:46.586819 | ubuntu-jammy | skipping: Conditional result was False 2025-10-24 12:01:46.596523 | 2025-10-24 12:01:46.596610 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-24 12:01:46.986969 | ubuntu-jammy | ok 2025-10-24 12:01:46.997844 | 2025-10-24 12:01:46.997947 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-24 12:01:47.025214 | ubuntu-jammy | ok 2025-10-24 12:01:47.029963 | 2025-10-24 12:01:47.030045 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-24 12:01:47.548781 | ubuntu-jammy -> localhost | ok 2025-10-24 12:01:47.554870 | 2025-10-24 12:01:47.554956 | TASK [validate-host : Collect information about the host] 2025-10-24 12:01:48.684630 | ubuntu-jammy | ok 2025-10-24 12:01:48.702623 | 2025-10-24 12:01:48.702718 | TASK [validate-host : Sanitize hostname] 2025-10-24 12:01:48.805609 | ubuntu-jammy | ok 2025-10-24 12:01:48.842257 | 2025-10-24 12:01:48.842353 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-24 12:01:49.386578 | ubuntu-jammy -> localhost | changed 2025-10-24 12:01:49.392196 | 2025-10-24 12:01:49.392297 | TASK [validate-host : Collect information about zuul worker] 2025-10-24 12:01:49.893882 | ubuntu-jammy | ok 2025-10-24 12:01:49.897571 | 2025-10-24 12:01:49.897643 | TASK [validate-host : Write out all zuul information for each host] 2025-10-24 12:01:50.607642 | ubuntu-jammy -> localhost | changed 2025-10-24 12:01:50.616978 | 2025-10-24 12:01:50.617073 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-24 12:01:50.873860 | ubuntu-jammy | ok 2025-10-24 12:01:50.878979 | 2025-10-24 12:01:50.879063 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-24 12:01:51.829439 | ubuntu-jammy | changed: 2025-10-24 12:01:51.829610 | ubuntu-jammy | cd+++++++++ src/ 2025-10-24 12:01:51.829643 | ubuntu-jammy | cd+++++++++ src/github.com/ 2025-10-24 12:01:51.829669 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/ 2025-10-24 12:01:51.829690 | ubuntu-jammy | cd+++++++++ src/github.com/YAKEcloud/yake-ansible/ 2025-10-24 12:01:51.829709 | ubuntu-jammy | Containerfile 2025-10-24 12:01:51.829866 | ubuntu-jammy | Containerfile 2025-10-24 12:01:51.867864 | ubuntu-jammy | Containerfile 2025-10-24 12:01:51.867930 | ubuntu-jammy | Containerfile 2025-10-24 12:01:51.867998 | ubuntu-jammy | Containerfile 2025-10-24 12:01:51.868065 | ubuntu-jammy | Containerfile 2025-10-24 12:01:51.868131 | ubuntu-jammy | localhost | ok: Runtime: 0:00:00.007632 2025-10-24 12:02:19.978451 | 2025-10-24 12:02:19.978570 | TASK [upload-logs : Upload logs to log server] 2025-10-24 12:02:20.509337 | localhost | Output suppressed because no_log was given 2025-10-24 12:02:20.511225 | 2025-10-24 12:02:20.511334 | LOOP [upload-logs : Compress console log and json output] 2025-10-24 12:02:20.555372 | localhost | skipping: Conditional result was False 2025-10-24 12:02:20.576701 | localhost | skipping: Conditional result was False 2025-10-24 12:02:20.590178 | 2025-10-24 12:02:20.590354 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-24 12:02:20.648946 | localhost | skipping: Conditional result was False 2025-10-24 12:02:20.649527 | 2025-10-24 12:02:20.653196 | localhost | skipping: Conditional result was False 2025-10-24 12:02:20.660930 | 2025-10-24 12:02:20.661165 | LOOP [upload-logs : Upload console log and json output]