2025-11-26 20:49:44.116352 | Job console starting 2025-11-26 20:49:44.153279 | Updating git repos 2025-11-26 20:49:44.202335 | Cloning repos into workspace 2025-11-26 20:49:44.313349 | Restoring repo states 2025-11-26 20:49:44.319107 | Merging changes 2025-11-26 20:49:44.817382 | Checking out repos 2025-11-26 20:49:44.909545 | Preparing playbooks 2025-11-26 20:49:45.798918 | Running Ansible setup 2025-11-26 20:49:50.302443 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-26 20:49:51.244829 | 2025-11-26 20:49:51.245001 | PLAY [Base pre] 2025-11-26 20:49:51.261311 | 2025-11-26 20:49:51.261462 | TASK [Setup log path fact] 2025-11-26 20:49:51.293918 | debian-bookworm | ok 2025-11-26 20:49:51.313926 | 2025-11-26 20:49:51.314101 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-26 20:49:51.344412 | debian-bookworm | ok 2025-11-26 20:49:51.354795 | 2025-11-26 20:49:51.354949 | TASK [emit-job-header : Print job information] 2025-11-26 20:49:51.395018 | # Job Information 2025-11-26 20:49:51.395203 | Ansible Version: 2.16.14 2025-11-26 20:49:51.395238 | Job: python-black 2025-11-26 20:49:51.395269 | Pipeline: check 2025-11-26 20:49:51.395293 | Executor: 521e9411259a 2025-11-26 20:49:51.395314 | Triggered by: https://github.com/osism/testbed/pull/2788 2025-11-26 20:49:51.395337 | Event ID: 6aed82e0-cb09-11f0-8da4-56ad76e84ed0 2025-11-26 20:49:51.400408 | 2025-11-26 20:49:51.400528 | LOOP [emit-job-header : Print node information] 2025-11-26 20:49:51.509731 | debian-bookworm | ok: 2025-11-26 20:49:51.509990 | debian-bookworm | # Node Information 2025-11-26 20:49:51.510026 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-26 20:49:51.510052 | debian-bookworm | Hostname: debian 2025-11-26 20:49:51.510074 | debian-bookworm | Username: zuul 2025-11-26 20:49:51.510096 | debian-bookworm | Distro: Debian 12.12 2025-11-26 20:49:51.510119 | debian-bookworm | Provider: regiocloud-a 2025-11-26 20:49:51.510140 | debian-bookworm | Region: 2025-11-26 20:49:51.510161 | debian-bookworm | Label: debian-bookworm 2025-11-26 20:49:51.510187 | debian-bookworm | Product Name: OpenStack Nova 2025-11-26 20:49:51.510208 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fecf:7249 2025-11-26 20:49:51.529163 | 2025-11-26 20:49:51.529322 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-26 20:49:52.073519 | debian-bookworm -> localhost | changed 2025-11-26 20:49:52.081371 | 2025-11-26 20:49:52.081518 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-26 20:49:53.258814 | debian-bookworm -> localhost | changed 2025-11-26 20:49:53.278412 | 2025-11-26 20:49:53.278577 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-26 20:49:53.648439 | debian-bookworm -> localhost | ok 2025-11-26 20:49:53.655100 | 2025-11-26 20:49:53.655257 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-26 20:49:53.684478 | debian-bookworm | ok 2025-11-26 20:49:53.703987 | debian-bookworm | included: /var/lib/zuul/builds/145a53b6bb724758b9f39eb9c759509c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-26 20:49:53.710991 | 2025-11-26 20:49:53.711128 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-26 20:49:55.600281 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-26 20:49:55.600517 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/145a53b6bb724758b9f39eb9c759509c/work/145a53b6bb724758b9f39eb9c759509c_id_rsa 2025-11-26 20:49:55.600555 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/145a53b6bb724758b9f39eb9c759509c/work/145a53b6bb724758b9f39eb9c759509c_id_rsa.pub 2025-11-26 20:49:55.600580 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-26 20:49:55.600642 | debian-bookworm -> localhost | SHA256:pwaBdai65djAiR9J4I/9bN6Ycj+Ajie3KM1lqnmc1Mg zuul-build-sshkey 2025-11-26 20:49:55.600666 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-26 20:49:55.600717 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-26 20:49:55.600741 | debian-bookworm -> localhost | | ... | 2025-11-26 20:49:55.600761 | debian-bookworm -> localhost | |. o.. | 2025-11-26 20:49:55.600781 | debian-bookworm -> localhost | |.. ... | 2025-11-26 20:49:55.600801 | debian-bookworm -> localhost | | .. . . | 2025-11-26 20:49:55.600820 | debian-bookworm -> localhost | | =+*. . S . | 2025-11-26 20:49:55.600845 | debian-bookworm -> localhost | |..E+=. . o | 2025-11-26 20:49:55.600871 | debian-bookworm -> localhost | | *o&o . o | 2025-11-26 20:49:55.600892 | debian-bookworm -> localhost | |.+%=o=+o | 2025-11-26 20:49:55.600912 | debian-bookworm -> localhost | |+++.*+.o. | 2025-11-26 20:49:55.600932 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-26 20:49:55.600988 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.406154 2025-11-26 20:49:55.608547 | 2025-11-26 20:49:55.608698 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-26 20:49:55.650504 | debian-bookworm | ok 2025-11-26 20:49:55.662503 | debian-bookworm | included: /var/lib/zuul/builds/145a53b6bb724758b9f39eb9c759509c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-26 20:49:55.673295 | 2025-11-26 20:49:55.673411 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-26 20:49:55.707527 | debian-bookworm | skipping: Conditional result was False 2025-11-26 20:49:55.713948 | 2025-11-26 20:49:55.714062 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-26 20:49:56.369658 | debian-bookworm | changed 2025-11-26 20:49:56.379258 | 2025-11-26 20:49:56.379452 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-26 20:49:56.642011 | debian-bookworm | ok 2025-11-26 20:49:56.657617 | 2025-11-26 20:49:56.657820 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-26 20:49:57.339576 | debian-bookworm | changed 2025-11-26 20:49:57.350507 | 2025-11-26 20:49:57.350697 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-26 20:49:58.035929 | debian-bookworm | changed 2025-11-26 20:49:58.045748 | 2025-11-26 20:49:58.045910 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-26 20:49:58.071006 | debian-bookworm | skipping: Conditional result was False 2025-11-26 20:49:58.092759 | 2025-11-26 20:49:58.092922 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-26 20:49:58.585721 | debian-bookworm -> localhost | changed 2025-11-26 20:49:58.596849 | 2025-11-26 20:49:58.596991 | TASK [add-build-sshkey : Add back temp key] 2025-11-26 20:49:58.996229 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/145a53b6bb724758b9f39eb9c759509c/work/145a53b6bb724758b9f39eb9c759509c_id_rsa (zuul-build-sshkey) 2025-11-26 20:49:58.996481 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.038210 2025-11-26 20:49:59.011891 | 2025-11-26 20:49:59.012027 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-26 20:49:59.431124 | debian-bookworm | ok 2025-11-26 20:49:59.438108 | 2025-11-26 20:49:59.438252 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-26 20:49:59.462746 | debian-bookworm | skipping: Conditional result was False 2025-11-26 20:49:59.480148 | 2025-11-26 20:49:59.480296 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-26 20:49:59.956860 | debian-bookworm | ok 2025-11-26 20:49:59.969525 | 2025-11-26 20:49:59.969700 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-26 20:49:59.999120 | debian-bookworm | ok 2025-11-26 20:50:00.004486 | 2025-11-26 20:50:00.004650 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-26 20:50:00.315109 | debian-bookworm -> localhost | ok 2025-11-26 20:50:00.331406 | 2025-11-26 20:50:00.331632 | TASK [validate-host : Collect information about the host] 2025-11-26 20:50:01.516985 | debian-bookworm | ok 2025-11-26 20:50:01.529163 | 2025-11-26 20:50:01.529295 | TASK [validate-host : Sanitize hostname] 2025-11-26 20:50:01.643349 | debian-bookworm | ok 2025-11-26 20:50:01.690720 | 2025-11-26 20:50:01.690893 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-26 20:50:02.368139 | debian-bookworm -> localhost | changed 2025-11-26 20:50:02.374117 | 2025-11-26 20:50:02.374242 | TASK [validate-host : Collect information about zuul worker] 2025-11-26 20:50:02.794265 | debian-bookworm | ok 2025-11-26 20:50:02.799050 | 2025-11-26 20:50:02.803629 | TASK [validate-host : Write out all zuul information for each host] 2025-11-26 20:50:03.376407 | debian-bookworm -> localhost | changed 2025-11-26 20:50:03.386309 | 2025-11-26 20:50:03.386432 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-26 20:50:03.663368 | debian-bookworm | ok 2025-11-26 20:50:03.672172 | 2025-11-26 20:50:03.672318 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-26 20:50:04.828689 | debian-bookworm | changed: 2025-11-26 20:50:04.828903 | debian-bookworm | cd+++++++++ src/ 2025-11-26 20:50:04.828939 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-26 20:50:04.828963 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-26 20:50:04.828984 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-11-26 20:50:04.829005 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004334 2025-11-26 20:50:30.637407 | 2025-11-26 20:50:30.637526 | TASK [upload-logs : Upload logs to log server] 2025-11-26 20:50:31.209980 | localhost | Output suppressed because no_log was given 2025-11-26 20:50:31.214079 | 2025-11-26 20:50:31.214290 | LOOP [upload-logs : Compress console log and json output] 2025-11-26 20:50:31.274440 | localhost | skipping: Conditional result was False 2025-11-26 20:50:31.279552 | localhost | skipping: Conditional result was False 2025-11-26 20:50:31.287432 | 2025-11-26 20:50:31.287686 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-26 20:50:31.336483 | localhost | skipping: Conditional result was False 2025-11-26 20:50:31.337120 | 2025-11-26 20:50:31.340967 | localhost | skipping: Conditional result was False 2025-11-26 20:50:31.355211 | 2025-11-26 20:50:31.355481 | LOOP [upload-logs : Upload console log and json output]