2025-11-22 03:13:05.508377 | Job console starting 2025-11-22 03:13:05.529489 | Updating git repos 2025-11-22 03:13:05.562956 | Cloning repos into workspace 2025-11-22 03:13:05.668437 | Restoring repo states 2025-11-22 03:13:05.683489 | Merging changes 2025-11-22 03:13:05.683512 | Checking out repos 2025-11-22 03:13:05.831784 | Preparing playbooks 2025-11-22 03:13:07.517888 | Running Ansible setup 2025-11-22 03:13:13.375705 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-22 03:13:15.053086 | 2025-11-22 03:13:15.053261 | PLAY [Base pre] 2025-11-22 03:13:15.099691 | 2025-11-22 03:13:15.099884 | TASK [Setup log path fact] 2025-11-22 03:13:15.130308 | debian-bookworm | ok 2025-11-22 03:13:15.147640 | 2025-11-22 03:13:15.147809 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-22 03:13:15.186551 | debian-bookworm | ok 2025-11-22 03:13:15.201925 | 2025-11-22 03:13:15.202061 | TASK [emit-job-header : Print job information] 2025-11-22 03:13:15.262707 | # Job Information 2025-11-22 03:13:15.262934 | Ansible Version: 2.16.14 2025-11-22 03:13:15.262971 | Job: python-black 2025-11-22 03:13:15.263004 | Pipeline: periodic-daily 2025-11-22 03:13:15.263026 | Executor: 521e9411259a 2025-11-22 03:13:15.263047 | Triggered by: https://github.com/osism/testbed 2025-11-22 03:13:15.263068 | Event ID: 6aa665080d1a4c7eb03aa25283d10f08 2025-11-22 03:13:15.268083 | 2025-11-22 03:13:15.268211 | LOOP [emit-job-header : Print node information] 2025-11-22 03:13:15.505729 | debian-bookworm | ok: 2025-11-22 03:13:15.505956 | debian-bookworm | # Node Information 2025-11-22 03:13:15.506150 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-22 03:13:15.506179 | debian-bookworm | Hostname: debian 2025-11-22 03:13:15.506203 | debian-bookworm | Username: zuul 2025-11-22 03:13:15.506224 | debian-bookworm | Distro: Debian 12.12 2025-11-22 03:13:15.506248 | debian-bookworm | Provider: regiocloud-a 2025-11-22 03:13:15.506270 | debian-bookworm | Region: 2025-11-22 03:13:15.506292 | debian-bookworm | Label: debian-bookworm 2025-11-22 03:13:15.506312 | debian-bookworm | Product Name: OpenStack Nova 2025-11-22 03:13:15.506331 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe83:bbf4 2025-11-22 03:13:15.523861 | 2025-11-22 03:13:15.524006 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-22 03:13:16.297548 | debian-bookworm -> localhost | changed 2025-11-22 03:13:16.305523 | 2025-11-22 03:13:16.305652 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-22 03:13:19.168983 | debian-bookworm -> localhost | changed 2025-11-22 03:13:19.192647 | 2025-11-22 03:13:19.192798 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-22 03:13:19.795584 | debian-bookworm -> localhost | ok 2025-11-22 03:13:19.812288 | 2025-11-22 03:13:19.812406 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-22 03:13:19.876578 | debian-bookworm | ok 2025-11-22 03:13:19.925549 | debian-bookworm | included: /var/lib/zuul/builds/1a2085793c724e398d9e2eec35685f80/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-22 03:13:19.939011 | 2025-11-22 03:13:19.939137 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-22 03:13:21.851945 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-22 03:13:21.852146 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1a2085793c724e398d9e2eec35685f80/work/1a2085793c724e398d9e2eec35685f80_id_rsa 2025-11-22 03:13:21.852185 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1a2085793c724e398d9e2eec35685f80/work/1a2085793c724e398d9e2eec35685f80_id_rsa.pub 2025-11-22 03:13:21.852213 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-22 03:13:21.852239 | debian-bookworm -> localhost | SHA256:XzVVVTAUprBkDYG0fGHT5aCVycma0XacmHC6Vt9LH5Q zuul-build-sshkey 2025-11-22 03:13:21.852261 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-22 03:13:21.852295 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-22 03:13:21.852317 | debian-bookworm -> localhost | | ...@X+XB+O| 2025-11-22 03:13:21.852338 | debian-bookworm -> localhost | | ..=.X&=+o.| 2025-11-22 03:13:21.852359 | debian-bookworm -> localhost | | o ==o.+E | 2025-11-22 03:13:21.852378 | debian-bookworm -> localhost | | .oo o.o | 2025-11-22 03:13:21.852398 | debian-bookworm -> localhost | | S o . .o.| 2025-11-22 03:13:21.852427 | debian-bookworm -> localhost | | o . . +| 2025-11-22 03:13:21.852448 | debian-bookworm -> localhost | | . ..| 2025-11-22 03:13:21.852468 | debian-bookworm -> localhost | | | 2025-11-22 03:13:21.852488 | debian-bookworm -> localhost | | | 2025-11-22 03:13:21.852508 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-22 03:13:21.852557 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.756258 2025-11-22 03:13:21.859945 | 2025-11-22 03:13:21.860043 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-22 03:13:21.895626 | debian-bookworm | ok 2025-11-22 03:13:21.904486 | debian-bookworm | included: /var/lib/zuul/builds/1a2085793c724e398d9e2eec35685f80/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-22 03:13:21.917125 | 2025-11-22 03:13:21.917221 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-22 03:13:21.940936 | debian-bookworm | skipping: Conditional result was False 2025-11-22 03:13:21.946863 | 2025-11-22 03:13:21.946964 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-22 03:13:22.870388 | debian-bookworm | changed 2025-11-22 03:13:22.884250 | 2025-11-22 03:13:22.884357 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-22 03:13:23.250668 | debian-bookworm | ok 2025-11-22 03:13:23.255988 | 2025-11-22 03:13:23.256083 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-22 03:13:24.160915 | debian-bookworm | changed 2025-11-22 03:13:24.178239 | 2025-11-22 03:13:24.178355 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-22 03:13:24.985302 | debian-bookworm | changed 2025-11-22 03:13:24.991088 | 2025-11-22 03:13:24.991180 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-22 03:13:25.034326 | debian-bookworm | skipping: Conditional result was False 2025-11-22 03:13:25.040715 | 2025-11-22 03:13:25.040816 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-22 03:13:26.201667 | debian-bookworm -> localhost | changed 2025-11-22 03:13:26.210288 | 2025-11-22 03:13:26.210375 | TASK [add-build-sshkey : Add back temp key] 2025-11-22 03:13:26.840738 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1a2085793c724e398d9e2eec35685f80/work/1a2085793c724e398d9e2eec35685f80_id_rsa (zuul-build-sshkey) 2025-11-22 03:13:26.840937 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008452 2025-11-22 03:13:26.847233 | 2025-11-22 03:13:26.847319 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-22 03:13:27.321540 | debian-bookworm | ok 2025-11-22 03:13:27.325941 | 2025-11-22 03:13:27.326032 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-22 03:13:27.362958 | debian-bookworm | skipping: Conditional result was False 2025-11-22 03:13:27.382658 | 2025-11-22 03:13:27.382756 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-22 03:13:27.833111 | debian-bookworm | ok 2025-11-22 03:13:27.869906 | 2025-11-22 03:13:27.870008 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-22 03:13:27.919431 | debian-bookworm | ok 2025-11-22 03:13:27.923993 | 2025-11-22 03:13:27.924090 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-22 03:13:28.406334 | debian-bookworm -> localhost | ok 2025-11-22 03:13:28.424109 | 2025-11-22 03:13:28.424201 | TASK [validate-host : Collect information about the host] 2025-11-22 03:13:29.452664 | debian-bookworm | ok 2025-11-22 03:13:29.465319 | 2025-11-22 03:13:29.465406 | TASK [validate-host : Sanitize hostname] 2025-11-22 03:13:29.700048 | debian-bookworm | ok 2025-11-22 03:13:29.783314 | 2025-11-22 03:13:29.783422 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-22 03:13:30.931584 | debian-bookworm -> localhost | changed 2025-11-22 03:13:30.936004 | 2025-11-22 03:13:30.936081 | TASK [validate-host : Collect information about zuul worker] 2025-11-22 03:13:31.533450 | debian-bookworm | ok 2025-11-22 03:13:31.537196 | 2025-11-22 03:13:31.537283 | TASK [validate-host : Write out all zuul information for each host] 2025-11-22 03:13:33.083278 | debian-bookworm -> localhost | changed 2025-11-22 03:13:33.092769 | 2025-11-22 03:13:33.092882 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-22 03:13:33.409692 | debian-bookworm | ok 2025-11-22 03:13:33.425175 | 2025-11-22 03:13:33.425285 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-22 03:13:34.719557 | debian-bookworm | changed: 2025-11-22 03:13:34.719727 | debian-bookworm | cd+++++++++ src/ 2025-11-22 03:13:34.719760 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-22 03:13:34.719784 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-22 03:13:34.719805 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-11-22 03:13:34.719824 | debian-bookworm | localhost | ok: Runtime: 0:00:00.019867 2025-11-22 03:14:07.593092 | 2025-11-22 03:14:07.593191 | TASK [upload-logs : Upload logs to log server] 2025-11-22 03:14:08.786551 | localhost | Output suppressed because no_log was given 2025-11-22 03:14:08.788609 | 2025-11-22 03:14:08.788698 | LOOP [upload-logs : Compress console log and json output] 2025-11-22 03:14:08.906193 | localhost | skipping: Conditional result was False 2025-11-22 03:14:08.944637 | localhost | skipping: Conditional result was False 2025-11-22 03:14:08.955234 | 2025-11-22 03:14:08.955341 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-22 03:14:09.058710 | localhost | skipping: Conditional result was False 2025-11-22 03:14:09.059018 | 2025-11-22 03:14:09.070682 | localhost | skipping: Conditional result was False 2025-11-22 03:14:09.082566 | 2025-11-22 03:14:09.082675 | LOOP [upload-logs : Upload console log and json output]