2025-12-08 18:18:02.321397 | Job console starting 2025-12-08 18:18:02.334444 | Updating git repos 2025-12-08 18:18:02.382478 | Cloning repos into workspace 2025-12-08 18:18:02.465172 | Restoring repo states 2025-12-08 18:18:02.506685 | Merging changes 2025-12-08 18:18:03.047200 | Checking out repos 2025-12-08 18:18:03.145248 | Preparing playbooks 2025-12-08 18:18:04.346641 | Running Ansible setup 2025-12-08 18:18:09.080950 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-08 18:18:09.923423 | 2025-12-08 18:18:09.923592 | PLAY [Base pre] 2025-12-08 18:18:09.964037 | 2025-12-08 18:18:09.964217 | TASK [Setup log path fact] 2025-12-08 18:18:10.010743 | debian-bookworm | ok 2025-12-08 18:18:10.035720 | 2025-12-08 18:18:10.037034 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-08 18:18:10.069332 | debian-bookworm | ok 2025-12-08 18:18:10.084797 | 2025-12-08 18:18:10.084946 | TASK [emit-job-header : Print job information] 2025-12-08 18:18:10.125670 | # Job Information 2025-12-08 18:18:10.125891 | Ansible Version: 2.16.14 2025-12-08 18:18:10.125928 | Job: python-black 2025-12-08 18:18:10.125961 | Pipeline: check 2025-12-08 18:18:10.125984 | Executor: 521e9411259a 2025-12-08 18:18:10.126005 | Triggered by: https://github.com/osism/testbed/pull/2800 2025-12-08 18:18:10.126028 | Event ID: 36629800-d462-11f0-8ee3-2b930dfe07a6 2025-12-08 18:18:10.132227 | 2025-12-08 18:18:10.132364 | LOOP [emit-job-header : Print node information] 2025-12-08 18:18:10.262412 | debian-bookworm | ok: 2025-12-08 18:18:10.266926 | debian-bookworm | # Node Information 2025-12-08 18:18:10.267032 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-08 18:18:10.267062 | debian-bookworm | Hostname: debian 2025-12-08 18:18:10.267086 | debian-bookworm | Username: zuul 2025-12-08 18:18:10.267108 | debian-bookworm | Distro: Debian 12.12 2025-12-08 18:18:10.267132 | debian-bookworm | Provider: regiocloud-a 2025-12-08 18:18:10.267153 | debian-bookworm | Region: 2025-12-08 18:18:10.267174 | debian-bookworm | Label: debian-bookworm 2025-12-08 18:18:10.267193 | debian-bookworm | Product Name: OpenStack Nova 2025-12-08 18:18:10.267212 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8d:6da0 2025-12-08 18:18:10.283705 | 2025-12-08 18:18:10.283859 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-08 18:18:10.872435 | debian-bookworm -> localhost | changed 2025-12-08 18:18:10.880991 | 2025-12-08 18:18:10.881135 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-08 18:18:12.195341 | debian-bookworm -> localhost | changed 2025-12-08 18:18:12.212449 | 2025-12-08 18:18:12.212675 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-08 18:18:12.481337 | debian-bookworm -> localhost | ok 2025-12-08 18:18:12.487930 | 2025-12-08 18:18:12.488061 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-08 18:18:12.517268 | debian-bookworm | ok 2025-12-08 18:18:12.537950 | debian-bookworm | included: /var/lib/zuul/builds/db1364a73f6040a28df182dabe8bfa4e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-08 18:18:12.545379 | 2025-12-08 18:18:12.545547 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-08 18:18:14.748805 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-08 18:18:14.749039 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/db1364a73f6040a28df182dabe8bfa4e/work/db1364a73f6040a28df182dabe8bfa4e_id_rsa 2025-12-08 18:18:14.749080 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/db1364a73f6040a28df182dabe8bfa4e/work/db1364a73f6040a28df182dabe8bfa4e_id_rsa.pub 2025-12-08 18:18:14.749106 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-08 18:18:14.749131 | debian-bookworm -> localhost | SHA256:Zx+nttdO6JzZ0fB87QsSzfEP/EoXlaWsBBNLrsZvOoo zuul-build-sshkey 2025-12-08 18:18:14.749153 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-08 18:18:14.749190 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-08 18:18:14.749212 | debian-bookworm -> localhost | | =. .| 2025-12-08 18:18:14.749234 | debian-bookworm -> localhost | | o + . .o| 2025-12-08 18:18:14.749254 | debian-bookworm -> localhost | | o ..o..| 2025-12-08 18:18:14.749274 | debian-bookworm -> localhost | | . . .ooo .| 2025-12-08 18:18:14.749294 | debian-bookworm -> localhost | | S o.oo=o | 2025-12-08 18:18:14.749319 | debian-bookworm -> localhost | | . + ..+ B=| 2025-12-08 18:18:14.749340 | debian-bookworm -> localhost | | o.+.oo@| 2025-12-08 18:18:14.749360 | debian-bookworm -> localhost | | . .o ..=oO+| 2025-12-08 18:18:14.749380 | debian-bookworm -> localhost | | E .... ..*o=| 2025-12-08 18:18:14.749401 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-08 18:18:14.749461 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.407195 2025-12-08 18:18:14.756226 | 2025-12-08 18:18:14.756350 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-08 18:18:14.787506 | debian-bookworm | ok 2025-12-08 18:18:14.797678 | debian-bookworm | included: /var/lib/zuul/builds/db1364a73f6040a28df182dabe8bfa4e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-08 18:18:14.807270 | 2025-12-08 18:18:14.807393 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-08 18:18:14.831135 | debian-bookworm | skipping: Conditional result was False 2025-12-08 18:18:14.837699 | 2025-12-08 18:18:14.837870 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-08 18:18:15.502512 | debian-bookworm | changed 2025-12-08 18:18:15.512296 | 2025-12-08 18:18:15.512427 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-08 18:18:15.816657 | debian-bookworm | ok 2025-12-08 18:18:15.824286 | 2025-12-08 18:18:15.824436 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-08 18:18:16.516367 | debian-bookworm | changed 2025-12-08 18:18:16.526168 | 2025-12-08 18:18:16.526303 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-08 18:18:17.211390 | debian-bookworm | changed 2025-12-08 18:18:17.230470 | 2025-12-08 18:18:17.230617 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-08 18:18:17.263183 | debian-bookworm | skipping: Conditional result was False 2025-12-08 18:18:17.277913 | 2025-12-08 18:18:17.278131 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-08 18:18:17.897098 | debian-bookworm -> localhost | changed 2025-12-08 18:18:17.919615 | 2025-12-08 18:18:17.919769 | TASK [add-build-sshkey : Add back temp key] 2025-12-08 18:18:18.340415 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/db1364a73f6040a28df182dabe8bfa4e/work/db1364a73f6040a28df182dabe8bfa4e_id_rsa (zuul-build-sshkey) 2025-12-08 18:18:18.340806 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015636 2025-12-08 18:18:18.364514 | 2025-12-08 18:18:18.364668 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-08 18:18:18.871662 | debian-bookworm | ok 2025-12-08 18:18:18.877416 | 2025-12-08 18:18:18.877554 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-08 18:18:18.913044 | debian-bookworm | skipping: Conditional result was False 2025-12-08 18:18:18.925178 | 2025-12-08 18:18:18.925309 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-08 18:18:19.492045 | debian-bookworm | ok 2025-12-08 18:18:19.514069 | 2025-12-08 18:18:19.514263 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-08 18:18:19.558610 | debian-bookworm | ok 2025-12-08 18:18:19.571018 | 2025-12-08 18:18:19.571197 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-08 18:18:20.013004 | debian-bookworm -> localhost | ok 2025-12-08 18:18:20.020417 | 2025-12-08 18:18:20.020553 | TASK [validate-host : Collect information about the host] 2025-12-08 18:18:21.266659 | debian-bookworm | ok 2025-12-08 18:18:21.293588 | 2025-12-08 18:18:21.294141 | TASK [validate-host : Sanitize hostname] 2025-12-08 18:18:21.596870 | debian-bookworm | ok 2025-12-08 18:18:21.764939 | 2025-12-08 18:18:21.765141 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-08 18:18:22.784053 | debian-bookworm -> localhost | changed 2025-12-08 18:18:22.790158 | 2025-12-08 18:18:22.790291 | TASK [validate-host : Collect information about zuul worker] 2025-12-08 18:18:23.406121 | debian-bookworm | ok 2025-12-08 18:18:23.413130 | 2025-12-08 18:18:23.413274 | TASK [validate-host : Write out all zuul information for each host] 2025-12-08 18:18:24.195812 | debian-bookworm -> localhost | changed 2025-12-08 18:18:24.225160 | 2025-12-08 18:18:24.225306 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-08 18:18:24.581662 | debian-bookworm | ok 2025-12-08 18:18:24.592384 | 2025-12-08 18:18:24.592519 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-08 18:18:26.244779 | debian-bookworm | changed: 2025-12-08 18:18:26.244995 | debian-bookworm | cd+++++++++ src/ 2025-12-08 18:18:26.245196 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-08 18:18:26.245234 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-08 18:18:26.245258 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-08 18:18:26.245280 | debian-bookworm | localhost | ok: Runtime: 0:00:00.013373 2025-12-08 18:18:56.972317 | 2025-12-08 18:18:56.972448 | TASK [upload-logs : Upload logs to log server] 2025-12-08 18:18:57.596938 | localhost | Output suppressed because no_log was given 2025-12-08 18:18:57.599076 | 2025-12-08 18:18:57.599198 | LOOP [upload-logs : Compress console log and json output] 2025-12-08 18:18:57.652074 | localhost | skipping: Conditional result was False 2025-12-08 18:18:57.660715 | localhost | skipping: Conditional result was False 2025-12-08 18:18:57.666825 | 2025-12-08 18:18:57.666996 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-08 18:18:57.720887 | localhost | skipping: Conditional result was False 2025-12-08 18:18:57.721215 | 2025-12-08 18:18:57.730611 | localhost | skipping: Conditional result was False 2025-12-08 18:18:57.735668 | 2025-12-08 18:18:57.735859 | LOOP [upload-logs : Upload console log and json output]