2025-08-03 04:59:58.811790 | Job console starting 2025-08-03 04:59:58.827851 | Updating git repos 2025-08-03 04:59:58.870330 | Cloning repos into workspace 2025-08-03 04:59:58.917153 | Restoring repo states 2025-08-03 04:59:58.924393 | Merging changes 2025-08-03 04:59:59.454206 | Checking out repos 2025-08-03 04:59:59.511402 | Preparing playbooks 2025-08-03 05:00:00.529812 | Running Ansible setup 2025-08-03 05:00:05.290522 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-03 05:00:06.165832 | 2025-08-03 05:00:06.165997 | PLAY [Base pre] 2025-08-03 05:00:06.201448 | 2025-08-03 05:00:06.201622 | TASK [Setup log path fact] 2025-08-03 05:00:06.232078 | debian-bookworm | ok 2025-08-03 05:00:06.251974 | 2025-08-03 05:00:06.252140 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-03 05:00:06.310705 | debian-bookworm | ok 2025-08-03 05:00:06.328817 | 2025-08-03 05:00:06.328957 | TASK [emit-job-header : Print job information] 2025-08-03 05:00:06.403103 | # Job Information 2025-08-03 05:00:06.403313 | Ansible Version: 2.16.14 2025-08-03 05:00:06.403348 | Job: python-black 2025-08-03 05:00:06.403381 | Pipeline: check 2025-08-03 05:00:06.403404 | Executor: 521e9411259a 2025-08-03 05:00:06.403425 | Triggered by: https://github.com/osism/openstack-project-manager/pull/227 2025-08-03 05:00:06.403448 | Event ID: af8284c0-7026-11f0-9843-a84e4a5663d9 2025-08-03 05:00:06.408577 | 2025-08-03 05:00:06.408722 | LOOP [emit-job-header : Print node information] 2025-08-03 05:00:06.516555 | debian-bookworm | ok: 2025-08-03 05:00:06.516845 | debian-bookworm | # Node Information 2025-08-03 05:00:06.516886 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-03 05:00:06.516912 | debian-bookworm | Hostname: debian 2025-08-03 05:00:06.516935 | debian-bookworm | Username: zuul 2025-08-03 05:00:06.516957 | debian-bookworm | Distro: Debian 12.11 2025-08-03 05:00:06.516981 | debian-bookworm | Provider: regiocloud-a 2025-08-03 05:00:06.517001 | debian-bookworm | Region: 2025-08-03 05:00:06.517023 | debian-bookworm | Label: debian-bookworm 2025-08-03 05:00:06.517041 | debian-bookworm | Product Name: OpenStack Nova 2025-08-03 05:00:06.517061 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6b:ab67 2025-08-03 05:00:06.537579 | 2025-08-03 05:00:06.537733 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-03 05:00:07.073003 | debian-bookworm -> localhost | changed 2025-08-03 05:00:07.081042 | 2025-08-03 05:00:07.081172 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-03 05:00:08.334744 | debian-bookworm -> localhost | changed 2025-08-03 05:00:08.346144 | 2025-08-03 05:00:08.346266 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-03 05:00:08.722804 | debian-bookworm -> localhost | ok 2025-08-03 05:00:08.729338 | 2025-08-03 05:00:08.729470 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-03 05:00:08.748210 | debian-bookworm | ok 2025-08-03 05:00:08.774115 | debian-bookworm | included: /var/lib/zuul/builds/671c859bc56747339a0180a9bd13d174/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-03 05:00:08.782667 | 2025-08-03 05:00:08.782785 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-03 05:00:10.052766 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-03 05:00:10.053007 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/671c859bc56747339a0180a9bd13d174/work/671c859bc56747339a0180a9bd13d174_id_rsa 2025-08-03 05:00:10.053047 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/671c859bc56747339a0180a9bd13d174/work/671c859bc56747339a0180a9bd13d174_id_rsa.pub 2025-08-03 05:00:10.053074 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-03 05:00:10.053100 | debian-bookworm -> localhost | SHA256:bhQXP9vkGdy+CWlnfCQfKQ5mgqf52CLq8EHF+tSiZpc zuul-build-sshkey 2025-08-03 05:00:10.053122 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-03 05:00:10.053156 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-03 05:00:10.053179 | debian-bookworm -> localhost | | . | 2025-08-03 05:00:10.053200 | debian-bookworm -> localhost | | . . o . ..| 2025-08-03 05:00:10.053221 | debian-bookworm -> localhost | | o ..o.+o.=oo| 2025-08-03 05:00:10.053241 | debian-bookworm -> localhost | | o . +o+ o*+B.| 2025-08-03 05:00:10.053261 | debian-bookworm -> localhost | | o o +S .=+++| 2025-08-03 05:00:10.053285 | debian-bookworm -> localhost | | . + oo+ . + +| 2025-08-03 05:00:10.053305 | debian-bookworm -> localhost | | . = E ooo o | 2025-08-03 05:00:10.053325 | debian-bookworm -> localhost | | = + ... | 2025-08-03 05:00:10.053346 | debian-bookworm -> localhost | | .+ | 2025-08-03 05:00:10.053366 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-03 05:00:10.053419 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.609906 2025-08-03 05:00:10.060146 | 2025-08-03 05:00:10.060263 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-03 05:00:10.088775 | debian-bookworm | ok 2025-08-03 05:00:10.099811 | debian-bookworm | included: /var/lib/zuul/builds/671c859bc56747339a0180a9bd13d174/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-03 05:00:10.109293 | 2025-08-03 05:00:10.109414 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-03 05:00:10.133295 | debian-bookworm | skipping: Conditional result was False 2025-08-03 05:00:10.139742 | 2025-08-03 05:00:10.139875 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-03 05:00:10.771682 | debian-bookworm | changed 2025-08-03 05:00:10.779844 | 2025-08-03 05:00:10.779975 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-03 05:00:11.039773 | debian-bookworm | ok 2025-08-03 05:00:11.048198 | 2025-08-03 05:00:11.048329 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-03 05:00:11.717886 | debian-bookworm | changed 2025-08-03 05:00:11.729146 | 2025-08-03 05:00:11.729296 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-03 05:00:12.412176 | debian-bookworm | changed 2025-08-03 05:00:12.419637 | 2025-08-03 05:00:12.419764 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-03 05:00:12.443541 | debian-bookworm | skipping: Conditional result was False 2025-08-03 05:00:12.451519 | 2025-08-03 05:00:12.451687 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-03 05:00:12.961333 | debian-bookworm -> localhost | changed 2025-08-03 05:00:12.972563 | 2025-08-03 05:00:12.972715 | TASK [add-build-sshkey : Add back temp key] 2025-08-03 05:00:13.392541 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/671c859bc56747339a0180a9bd13d174/work/671c859bc56747339a0180a9bd13d174_id_rsa (zuul-build-sshkey) 2025-08-03 05:00:13.392839 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012907 2025-08-03 05:00:13.402243 | 2025-08-03 05:00:13.402364 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-03 05:00:13.851995 | debian-bookworm | ok 2025-08-03 05:00:13.857184 | 2025-08-03 05:00:13.857296 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-03 05:00:13.880754 | debian-bookworm | skipping: Conditional result was False 2025-08-03 05:00:13.890992 | 2025-08-03 05:00:13.891095 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-03 05:00:14.352408 | debian-bookworm | ok 2025-08-03 05:00:14.367103 | 2025-08-03 05:00:14.367245 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-03 05:00:14.406547 | debian-bookworm | ok 2025-08-03 05:00:14.411712 | 2025-08-03 05:00:14.411812 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-03 05:00:14.847258 | debian-bookworm -> localhost | ok 2025-08-03 05:00:14.854319 | 2025-08-03 05:00:14.854460 | TASK [validate-host : Collect information about the host] 2025-08-03 05:00:16.067264 | debian-bookworm | ok 2025-08-03 05:00:16.081118 | 2025-08-03 05:00:16.081265 | TASK [validate-host : Sanitize hostname] 2025-08-03 05:00:16.186909 | debian-bookworm | ok 2025-08-03 05:00:16.232835 | 2025-08-03 05:00:16.232965 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-03 05:00:17.047357 | debian-bookworm -> localhost | changed 2025-08-03 05:00:17.053371 | 2025-08-03 05:00:17.053494 | TASK [validate-host : Collect information about zuul worker] 2025-08-03 05:00:17.487860 | debian-bookworm | ok 2025-08-03 05:00:17.493117 | 2025-08-03 05:00:17.493242 | TASK [validate-host : Write out all zuul information for each host] 2025-08-03 05:00:18.091330 | debian-bookworm -> localhost | changed 2025-08-03 05:00:18.101400 | 2025-08-03 05:00:18.101532 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-03 05:00:18.395142 | debian-bookworm | ok 2025-08-03 05:00:18.412097 | 2025-08-03 05:00:18.412227 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-03 05:00:19.219279 | debian-bookworm | changed: 2025-08-03 05:00:19.219494 | debian-bookworm | cd+++++++++ src/ 2025-08-03 05:00:19.219528 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-03 05:00:19.219552 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-03 05:00:19.219572 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2025-08-03 05:00:19.219592 | debian-bookworm | localhost | ok: Runtime: 0:00:00.011207 2025-08-03 05:00:44.788866 | 2025-08-03 05:00:44.788978 | TASK [upload-logs : Upload logs to log server] 2025-08-03 05:00:45.418864 | localhost | Output suppressed because no_log was given 2025-08-03 05:00:45.420803 | 2025-08-03 05:00:45.420906 | LOOP [upload-logs : Compress console log and json output] 2025-08-03 05:00:45.480680 | localhost | skipping: Conditional result was False 2025-08-03 05:00:45.495599 | localhost | skipping: Conditional result was False 2025-08-03 05:00:45.499331 | 2025-08-03 05:00:45.499454 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-03 05:00:45.546004 | localhost | skipping: Conditional result was False 2025-08-03 05:00:45.546328 | 2025-08-03 05:00:45.551728 | localhost | skipping: Conditional result was False 2025-08-03 05:00:45.555819 | 2025-08-03 05:00:45.555929 | LOOP [upload-logs : Upload console log and json output]