2025-10-21 00:51:23.104022 | Job console starting 2025-10-21 00:51:23.113387 | Updating git repos 2025-10-21 00:51:23.161017 | Cloning repos into workspace 2025-10-21 00:51:23.207062 | Restoring repo states 2025-10-21 00:51:23.229129 | Merging changes 2025-10-21 00:51:23.837783 | Checking out repos 2025-10-21 00:51:23.932156 | Preparing playbooks 2025-10-21 00:51:24.939895 | Running Ansible setup 2025-10-21 00:51:32.668732 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-21 00:51:33.915074 | 2025-10-21 00:51:33.915208 | PLAY [Base pre] 2025-10-21 00:51:33.940593 | 2025-10-21 00:51:33.940717 | TASK [Setup log path fact] 2025-10-21 00:51:33.968933 | debian-bookworm | ok 2025-10-21 00:51:33.993815 | 2025-10-21 00:51:33.993946 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-21 00:51:34.042627 | debian-bookworm | ok 2025-10-21 00:51:34.060116 | 2025-10-21 00:51:34.060230 | TASK [emit-job-header : Print job information] 2025-10-21 00:51:34.130016 | # Job Information 2025-10-21 00:51:34.130170 | Ansible Version: 2.16.14 2025-10-21 00:51:34.130205 | Job: python-black 2025-10-21 00:51:34.130239 | Pipeline: check 2025-10-21 00:51:34.130262 | Executor: 521e9411259a 2025-10-21 00:51:34.130283 | Triggered by: https://github.com/osism/python-osism/pull/1709 2025-10-21 00:51:34.130306 | Event ID: 0b986430-ae18-11f0-9ec8-48ee77c5d5fc 2025-10-21 00:51:34.135307 | 2025-10-21 00:51:34.135408 | LOOP [emit-job-header : Print node information] 2025-10-21 00:51:34.301029 | debian-bookworm | ok: 2025-10-21 00:51:34.301246 | debian-bookworm | # Node Information 2025-10-21 00:51:34.301278 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-21 00:51:34.301299 | debian-bookworm | Hostname: debian 2025-10-21 00:51:34.301316 | debian-bookworm | Username: zuul 2025-10-21 00:51:34.301333 | debian-bookworm | Distro: Debian 12.12 2025-10-21 00:51:34.301361 | debian-bookworm | Provider: regiocloud-a 2025-10-21 00:51:34.301378 | debian-bookworm | Region: 2025-10-21 00:51:34.301395 | debian-bookworm | Label: debian-bookworm 2025-10-21 00:51:34.301412 | debian-bookworm | Product Name: OpenStack Nova 2025-10-21 00:51:34.301428 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7e:cfd6 2025-10-21 00:51:34.327973 | 2025-10-21 00:51:34.328714 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-21 00:51:35.025171 | debian-bookworm -> localhost | changed 2025-10-21 00:51:35.034571 | 2025-10-21 00:51:35.034681 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-21 00:51:36.186569 | debian-bookworm -> localhost | changed 2025-10-21 00:51:36.199517 | 2025-10-21 00:51:36.199627 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-21 00:51:36.556989 | debian-bookworm -> localhost | ok 2025-10-21 00:51:36.562773 | 2025-10-21 00:51:36.562979 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-21 00:51:36.591453 | debian-bookworm | ok 2025-10-21 00:51:36.608358 | debian-bookworm | included: /var/lib/zuul/builds/4e6cef2ba1d5474980690bb2962c9097/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-21 00:51:36.614822 | 2025-10-21 00:51:36.614933 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-21 00:51:38.431314 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-21 00:51:38.431478 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4e6cef2ba1d5474980690bb2962c9097/work/4e6cef2ba1d5474980690bb2962c9097_id_rsa 2025-10-21 00:51:38.431509 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4e6cef2ba1d5474980690bb2962c9097/work/4e6cef2ba1d5474980690bb2962c9097_id_rsa.pub 2025-10-21 00:51:38.431530 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-21 00:51:38.431550 | debian-bookworm -> localhost | SHA256:HSc+fXvmfKaz/S0aGmeKKqEYG1rmYlDtn2967EqX1hg zuul-build-sshkey 2025-10-21 00:51:38.431568 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-21 00:51:38.431593 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-21 00:51:38.431611 | debian-bookworm -> localhost | | | 2025-10-21 00:51:38.431629 | debian-bookworm -> localhost | | | 2025-10-21 00:51:38.431646 | debian-bookworm -> localhost | | . o . | 2025-10-21 00:51:38.431663 | debian-bookworm -> localhost | | . . o = | 2025-10-21 00:51:38.431679 | debian-bookworm -> localhost | | . . E + . . | 2025-10-21 00:51:38.431699 | debian-bookworm -> localhost | |+ o o = . . . | 2025-10-21 00:51:38.431715 | debian-bookworm -> localhost | |oO . o.o= o + . o| 2025-10-21 00:51:38.431732 | debian-bookworm -> localhost | |=.o ..oo+. * .o*+| 2025-10-21 00:51:38.431749 | debian-bookworm -> localhost | |.. .+O+ o ..o*O| 2025-10-21 00:51:38.431766 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-21 00:51:38.431810 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.137872 2025-10-21 00:51:38.436869 | 2025-10-21 00:51:38.436944 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-21 00:51:38.452854 | debian-bookworm | ok 2025-10-21 00:51:38.461727 | debian-bookworm | included: /var/lib/zuul/builds/4e6cef2ba1d5474980690bb2962c9097/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-21 00:51:38.468867 | 2025-10-21 00:51:38.468945 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-21 00:51:38.481464 | debian-bookworm | skipping: Conditional result was False 2025-10-21 00:51:38.486060 | 2025-10-21 00:51:38.486137 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-21 00:51:39.053822 | debian-bookworm | changed 2025-10-21 00:51:39.061259 | 2025-10-21 00:51:39.061367 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-21 00:51:39.357049 | debian-bookworm | ok 2025-10-21 00:51:39.363724 | 2025-10-21 00:51:39.363817 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-21 00:51:39.958495 | debian-bookworm | changed 2025-10-21 00:51:39.965085 | 2025-10-21 00:51:39.965176 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-21 00:51:40.612697 | debian-bookworm | changed 2025-10-21 00:51:40.619774 | 2025-10-21 00:51:40.619871 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-21 00:51:40.656891 | debian-bookworm | skipping: Conditional result was False 2025-10-21 00:51:40.663112 | 2025-10-21 00:51:40.663209 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-21 00:51:41.419992 | debian-bookworm -> localhost | changed 2025-10-21 00:51:41.430206 | 2025-10-21 00:51:41.430302 | TASK [add-build-sshkey : Add back temp key] 2025-10-21 00:51:41.904081 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4e6cef2ba1d5474980690bb2962c9097/work/4e6cef2ba1d5474980690bb2962c9097_id_rsa (zuul-build-sshkey) 2025-10-21 00:51:41.904289 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016812 2025-10-21 00:51:41.916768 | 2025-10-21 00:51:41.916862 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-21 00:51:42.316675 | debian-bookworm | ok 2025-10-21 00:51:42.326106 | 2025-10-21 00:51:42.326217 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-21 00:51:42.369508 | debian-bookworm | skipping: Conditional result was False 2025-10-21 00:51:42.387271 | 2025-10-21 00:51:42.387386 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-21 00:51:42.896753 | debian-bookworm | ok 2025-10-21 00:51:42.913879 | 2025-10-21 00:51:42.913985 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-21 00:51:42.944987 | debian-bookworm | ok 2025-10-21 00:51:42.950011 | 2025-10-21 00:51:42.950095 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-21 00:51:43.246517 | debian-bookworm -> localhost | ok 2025-10-21 00:51:43.252562 | 2025-10-21 00:51:43.252646 | TASK [validate-host : Collect information about the host] 2025-10-21 00:51:44.273246 | debian-bookworm | ok 2025-10-21 00:51:44.285426 | 2025-10-21 00:51:44.285542 | TASK [validate-host : Sanitize hostname] 2025-10-21 00:51:44.374176 | debian-bookworm | ok 2025-10-21 00:51:44.428017 | 2025-10-21 00:51:44.428123 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-21 00:51:45.152587 | debian-bookworm -> localhost | changed 2025-10-21 00:51:45.158004 | 2025-10-21 00:51:45.158088 | TASK [validate-host : Collect information about zuul worker] 2025-10-21 00:51:45.617516 | debian-bookworm | ok 2025-10-21 00:51:45.621978 | 2025-10-21 00:51:45.622067 | TASK [validate-host : Write out all zuul information for each host] 2025-10-21 00:51:46.263404 | debian-bookworm -> localhost | changed 2025-10-21 00:51:46.284269 | 2025-10-21 00:51:46.284397 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-21 00:51:46.544355 | debian-bookworm | ok 2025-10-21 00:51:46.549666 | 2025-10-21 00:51:46.549759 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-21 00:51:47.486274 | debian-bookworm | changed: 2025-10-21 00:51:47.486471 | debian-bookworm | cd+++++++++ src/ 2025-10-21 00:51:47.486510 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-21 00:51:47.486536 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-21 00:51:47.486557 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-21 00:51:47.486578 | debian-bookworm | Containerfile 2025-10-21 00:51:47.486693 | debian-bookworm | Containerfile 2025-10-21 00:51:47.489790 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007048 2025-10-21 00:52:13.331884 | 2025-10-21 00:52:13.332003 | TASK [upload-logs : Upload logs to log server] 2025-10-21 00:52:13.886968 | localhost | Output suppressed because no_log was given 2025-10-21 00:52:13.890422 | 2025-10-21 00:52:13.890668 | LOOP [upload-logs : Compress console log and json output] 2025-10-21 00:52:13.942516 | localhost | skipping: Conditional result was False 2025-10-21 00:52:13.948366 | localhost | skipping: Conditional result was False 2025-10-21 00:52:13.962303 | 2025-10-21 00:52:13.962574 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-21 00:52:14.008813 | localhost | skipping: Conditional result was False 2025-10-21 00:52:14.009050 | 2025-10-21 00:52:14.013718 | localhost | skipping: Conditional result was False 2025-10-21 00:52:14.025470 | 2025-10-21 00:52:14.025720 | LOOP [upload-logs : Upload console log and json output]