2025-10-10 18:31:37.696997 | Job console starting 2025-10-10 18:31:37.735548 | Updating git repos 2025-10-10 18:31:37.768250 | Cloning repos into workspace 2025-10-10 18:31:37.862930 | Restoring repo states 2025-10-10 18:31:37.885460 | Merging changes 2025-10-10 18:31:38.425029 | Checking out repos 2025-10-10 18:31:38.485296 | Preparing playbooks 2025-10-10 18:31:39.296187 | Running Ansible setup 2025-10-10 18:31:43.809481 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-10 18:31:44.555628 | 2025-10-10 18:31:44.555779 | PLAY [Base pre] 2025-10-10 18:31:44.573534 | 2025-10-10 18:31:44.573665 | TASK [Setup log path fact] 2025-10-10 18:31:44.603037 | debian-bookworm | ok 2025-10-10 18:31:44.618070 | 2025-10-10 18:31:44.618207 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-10 18:31:44.651465 | debian-bookworm | ok 2025-10-10 18:31:44.661264 | 2025-10-10 18:31:44.661374 | TASK [emit-job-header : Print job information] 2025-10-10 18:31:44.722127 | # Job Information 2025-10-10 18:31:44.722321 | Ansible Version: 2.16.14 2025-10-10 18:31:44.722355 | Job: python-black 2025-10-10 18:31:44.722404 | Pipeline: check 2025-10-10 18:31:44.722428 | Executor: 521e9411259a 2025-10-10 18:31:44.722450 | Triggered by: https://github.com/osism/testbed/pull/2777 2025-10-10 18:31:44.722472 | Event ID: 55b89f30-a607-11f0-8a50-72e8ac3568d9 2025-10-10 18:31:44.727468 | 2025-10-10 18:31:44.727582 | LOOP [emit-job-header : Print node information] 2025-10-10 18:31:44.851059 | debian-bookworm | ok: 2025-10-10 18:31:44.851322 | debian-bookworm | # Node Information 2025-10-10 18:31:44.851361 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-10 18:31:44.851426 | debian-bookworm | Hostname: debian 2025-10-10 18:31:44.851452 | debian-bookworm | Username: zuul 2025-10-10 18:31:44.851473 | debian-bookworm | Distro: Debian 12.12 2025-10-10 18:31:44.851498 | debian-bookworm | Provider: regiocloud-a 2025-10-10 18:31:44.851520 | debian-bookworm | Region: 2025-10-10 18:31:44.851541 | debian-bookworm | Label: debian-bookworm 2025-10-10 18:31:44.851561 | debian-bookworm | Product Name: OpenStack Nova 2025-10-10 18:31:44.851580 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe31:c93d 2025-10-10 18:31:44.875735 | 2025-10-10 18:31:44.875870 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-10 18:31:45.376502 | debian-bookworm -> localhost | changed 2025-10-10 18:31:45.384211 | 2025-10-10 18:31:45.384347 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-10 18:31:46.428115 | debian-bookworm -> localhost | changed 2025-10-10 18:31:46.447229 | 2025-10-10 18:31:46.447362 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-10 18:31:46.794742 | debian-bookworm -> localhost | ok 2025-10-10 18:31:46.801540 | 2025-10-10 18:31:46.801659 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-10 18:31:46.831113 | debian-bookworm | ok 2025-10-10 18:31:46.849059 | debian-bookworm | included: /var/lib/zuul/builds/4dbf4ecf3a7245b08790186587c5f631/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-10 18:31:46.855293 | 2025-10-10 18:31:46.855438 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-10 18:31:50.286270 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-10 18:31:50.286624 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4dbf4ecf3a7245b08790186587c5f631/work/4dbf4ecf3a7245b08790186587c5f631_id_rsa 2025-10-10 18:31:50.286701 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4dbf4ecf3a7245b08790186587c5f631/work/4dbf4ecf3a7245b08790186587c5f631_id_rsa.pub 2025-10-10 18:31:50.286752 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-10 18:31:50.286803 | debian-bookworm -> localhost | SHA256:DU1F6LDOtwjPRhllabIWfWZuNSPYssgY+wE0otsIE+Q zuul-build-sshkey 2025-10-10 18:31:50.286888 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-10 18:31:50.286952 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-10 18:31:50.286999 | debian-bookworm -> localhost | |o. ..o ..Bo | 2025-10-10 18:31:50.287043 | debian-bookworm -> localhost | |.. . .o.+oX * + | 2025-10-10 18:31:50.287086 | debian-bookworm -> localhost | |oE. *.%.B o o | 2025-10-10 18:31:50.287178 | debian-bookworm -> localhost | | o + o Ooo o | 2025-10-10 18:31:50.287227 | debian-bookworm -> localhost | | o . =S+.. | 2025-10-10 18:31:50.287282 | debian-bookworm -> localhost | | . * . | 2025-10-10 18:31:50.287325 | debian-bookworm -> localhost | | = o . | 2025-10-10 18:31:50.287365 | debian-bookworm -> localhost | | = . | 2025-10-10 18:31:50.287428 | debian-bookworm -> localhost | | . | 2025-10-10 18:31:50.287471 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-10 18:31:50.287564 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.934105 2025-10-10 18:31:50.301304 | 2025-10-10 18:31:50.301468 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-10 18:31:50.343749 | debian-bookworm | ok 2025-10-10 18:31:50.356363 | debian-bookworm | included: /var/lib/zuul/builds/4dbf4ecf3a7245b08790186587c5f631/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-10 18:31:50.370435 | 2025-10-10 18:31:50.370527 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-10 18:31:50.409243 | debian-bookworm | skipping: Conditional result was False 2025-10-10 18:31:50.423845 | 2025-10-10 18:31:50.423953 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-10 18:31:51.093476 | debian-bookworm | changed 2025-10-10 18:31:51.099061 | 2025-10-10 18:31:51.099148 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-10 18:31:51.360530 | debian-bookworm | ok 2025-10-10 18:31:51.367050 | 2025-10-10 18:31:51.367248 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-10 18:31:52.046967 | debian-bookworm | changed 2025-10-10 18:31:52.055515 | 2025-10-10 18:31:52.055617 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-10 18:31:52.669934 | debian-bookworm | changed 2025-10-10 18:31:52.675587 | 2025-10-10 18:31:52.675678 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-10 18:31:52.699750 | debian-bookworm | skipping: Conditional result was False 2025-10-10 18:31:52.714808 | 2025-10-10 18:31:52.714963 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-10 18:31:53.082209 | debian-bookworm -> localhost | changed 2025-10-10 18:31:53.092485 | 2025-10-10 18:31:53.092575 | TASK [add-build-sshkey : Add back temp key] 2025-10-10 18:31:53.401425 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4dbf4ecf3a7245b08790186587c5f631/work/4dbf4ecf3a7245b08790186587c5f631_id_rsa (zuul-build-sshkey) 2025-10-10 18:31:53.401931 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017151 2025-10-10 18:31:53.419311 | 2025-10-10 18:31:53.419465 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-10 18:31:53.798292 | debian-bookworm | ok 2025-10-10 18:31:53.805722 | 2025-10-10 18:31:53.805834 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-10 18:31:53.839606 | debian-bookworm | skipping: Conditional result was False 2025-10-10 18:31:53.857878 | 2025-10-10 18:31:53.857994 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-10 18:31:54.268686 | debian-bookworm | ok 2025-10-10 18:31:54.279854 | 2025-10-10 18:31:54.279963 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-10 18:31:54.315071 | debian-bookworm | ok 2025-10-10 18:31:54.323550 | 2025-10-10 18:31:54.323677 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-10 18:31:54.579802 | debian-bookworm -> localhost | ok 2025-10-10 18:31:54.585770 | 2025-10-10 18:31:54.585856 | TASK [validate-host : Collect information about the host] 2025-10-10 18:31:55.660880 | debian-bookworm | ok 2025-10-10 18:31:55.673119 | 2025-10-10 18:31:55.673223 | TASK [validate-host : Sanitize hostname] 2025-10-10 18:31:55.781608 | debian-bookworm | ok 2025-10-10 18:31:55.821440 | 2025-10-10 18:31:55.821566 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-10 18:31:56.421205 | debian-bookworm -> localhost | changed 2025-10-10 18:31:56.434110 | 2025-10-10 18:31:56.434273 | TASK [validate-host : Collect information about zuul worker] 2025-10-10 18:31:56.880999 | debian-bookworm | ok 2025-10-10 18:31:56.886645 | 2025-10-10 18:31:56.886764 | TASK [validate-host : Write out all zuul information for each host] 2025-10-10 18:31:57.528344 | debian-bookworm -> localhost | changed 2025-10-10 18:31:57.538810 | 2025-10-10 18:31:57.538966 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-10 18:31:57.820327 | debian-bookworm | ok 2025-10-10 18:31:57.839550 | 2025-10-10 18:31:57.839670 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-10 18:31:59.056675 | debian-bookworm | changed: 2025-10-10 18:31:59.056890 | debian-bookworm | cd+++++++++ src/ 2025-10-10 18:31:59.056925 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-10 18:31:59.056949 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-10 18:31:59.056971 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-10-10 18:31:59.056990 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007004 2025-10-10 18:32:24.141805 | 2025-10-10 18:32:24.142025 | TASK [upload-logs : Upload logs to log server] 2025-10-10 18:32:24.694337 | localhost | Output suppressed because no_log was given 2025-10-10 18:32:24.699555 | 2025-10-10 18:32:24.699777 | LOOP [upload-logs : Compress console log and json output] 2025-10-10 18:32:24.760545 | localhost | skipping: Conditional result was False 2025-10-10 18:32:24.765473 | localhost | skipping: Conditional result was False 2025-10-10 18:32:24.774257 | 2025-10-10 18:32:24.774566 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-10 18:32:24.820772 | localhost | skipping: Conditional result was False 2025-10-10 18:32:24.821454 | 2025-10-10 18:32:24.824642 | localhost | skipping: Conditional result was False 2025-10-10 18:32:24.837370 | 2025-10-10 18:32:24.837728 | LOOP [upload-logs : Upload console log and json output]