2025-10-02 00:46:21.701736 | Job console starting 2025-10-02 00:46:21.734456 | Updating git repos 2025-10-02 00:46:21.780226 | Cloning repos into workspace 2025-10-02 00:46:21.849061 | Restoring repo states 2025-10-02 00:46:21.863553 | Merging changes 2025-10-02 00:46:22.432415 | Checking out repos 2025-10-02 00:46:22.500994 | Preparing playbooks 2025-10-02 00:46:23.476522 | Running Ansible setup 2025-10-02 00:46:28.919934 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-02 00:46:30.195264 | 2025-10-02 00:46:30.195371 | PLAY [Base pre] 2025-10-02 00:46:30.232789 | 2025-10-02 00:46:30.232898 | TASK [Setup log path fact] 2025-10-02 00:46:30.259667 | debian-bookworm | ok 2025-10-02 00:46:30.277181 | 2025-10-02 00:46:30.277294 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-02 00:46:30.336685 | debian-bookworm | ok 2025-10-02 00:46:30.351195 | 2025-10-02 00:46:30.351288 | TASK [emit-job-header : Print job information] 2025-10-02 00:46:30.418432 | # Job Information 2025-10-02 00:46:30.418563 | Ansible Version: 2.16.14 2025-10-02 00:46:30.418592 | Job: python-black 2025-10-02 00:46:30.418618 | Pipeline: check 2025-10-02 00:46:30.418636 | Executor: 521e9411259a 2025-10-02 00:46:30.418653 | Triggered by: https://github.com/osism/python-osism/pull/1700 2025-10-02 00:46:30.418671 | Event ID: 30a439f0-9f29-11f0-86df-e43522112931 2025-10-02 00:46:30.422517 | 2025-10-02 00:46:30.422594 | LOOP [emit-job-header : Print node information] 2025-10-02 00:46:30.556063 | debian-bookworm | ok: 2025-10-02 00:46:30.556204 | debian-bookworm | # Node Information 2025-10-02 00:46:30.556232 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-02 00:46:30.556253 | debian-bookworm | Hostname: debian 2025-10-02 00:46:30.556271 | debian-bookworm | Username: zuul 2025-10-02 00:46:30.556288 | debian-bookworm | Distro: Debian 12.12 2025-10-02 00:46:30.556308 | debian-bookworm | Provider: regiocloud-a 2025-10-02 00:46:30.556326 | debian-bookworm | Region: 2025-10-02 00:46:30.556343 | debian-bookworm | Label: debian-bookworm 2025-10-02 00:46:30.556359 | debian-bookworm | Product Name: OpenStack Nova 2025-10-02 00:46:30.556423 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb4:1453 2025-10-02 00:46:30.574696 | 2025-10-02 00:46:30.574785 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-02 00:46:31.186770 | debian-bookworm -> localhost | changed 2025-10-02 00:46:31.192554 | 2025-10-02 00:46:31.192644 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-02 00:46:32.658655 | debian-bookworm -> localhost | changed 2025-10-02 00:46:32.667950 | 2025-10-02 00:46:32.668056 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-02 00:46:33.200745 | debian-bookworm -> localhost | ok 2025-10-02 00:46:33.205745 | 2025-10-02 00:46:33.205830 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-02 00:46:33.232215 | debian-bookworm | ok 2025-10-02 00:46:33.245935 | debian-bookworm | included: /var/lib/zuul/builds/2fc63774107b4f2d8dc68518a39f1b5f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-02 00:46:33.253320 | 2025-10-02 00:46:33.253388 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-02 00:46:34.635663 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-02 00:46:34.635826 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2fc63774107b4f2d8dc68518a39f1b5f/work/2fc63774107b4f2d8dc68518a39f1b5f_id_rsa 2025-10-02 00:46:34.635857 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2fc63774107b4f2d8dc68518a39f1b5f/work/2fc63774107b4f2d8dc68518a39f1b5f_id_rsa.pub 2025-10-02 00:46:34.635880 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-02 00:46:34.635901 | debian-bookworm -> localhost | SHA256:6tpfc9Wbb7sGW7TxyLtwo7jxVK4qdcKY7i/A+7Corfk zuul-build-sshkey 2025-10-02 00:46:34.635920 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-02 00:46:34.635944 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-02 00:46:34.635963 | debian-bookworm -> localhost | | | 2025-10-02 00:46:34.635981 | debian-bookworm -> localhost | | | 2025-10-02 00:46:34.635998 | debian-bookworm -> localhost | | | 2025-10-02 00:46:34.636025 | debian-bookworm -> localhost | | + | 2025-10-02 00:46:34.636043 | debian-bookworm -> localhost | | . S+ .+.=| 2025-10-02 00:46:34.636064 | debian-bookworm -> localhost | | o.o + .=oo+| 2025-10-02 00:46:34.636081 | debian-bookworm -> localhost | | o+ .+o+ B+ | 2025-10-02 00:46:34.636097 | debian-bookworm -> localhost | | o +.o+. B *.oo| 2025-10-02 00:46:34.636114 | debian-bookworm -> localhost | | ++E.++++=o+ o=+| 2025-10-02 00:46:34.636131 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-02 00:46:34.636175 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.693180 2025-10-02 00:46:34.641210 | 2025-10-02 00:46:34.641287 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-02 00:46:34.657376 | debian-bookworm | ok 2025-10-02 00:46:34.664596 | debian-bookworm | included: /var/lib/zuul/builds/2fc63774107b4f2d8dc68518a39f1b5f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-02 00:46:34.672338 | 2025-10-02 00:46:34.672403 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-02 00:46:34.684660 | debian-bookworm | skipping: Conditional result was False 2025-10-02 00:46:34.689371 | 2025-10-02 00:46:34.689444 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-02 00:46:35.294658 | debian-bookworm | changed 2025-10-02 00:46:35.299191 | 2025-10-02 00:46:35.299265 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-02 00:46:35.541604 | debian-bookworm | ok 2025-10-02 00:46:35.547810 | 2025-10-02 00:46:35.547905 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-02 00:46:36.168715 | debian-bookworm | changed 2025-10-02 00:46:36.175296 | 2025-10-02 00:46:36.175397 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-02 00:46:36.742587 | debian-bookworm | changed 2025-10-02 00:46:36.758721 | 2025-10-02 00:46:36.758827 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-02 00:46:36.781873 | debian-bookworm | skipping: Conditional result was False 2025-10-02 00:46:36.787584 | 2025-10-02 00:46:36.787677 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-02 00:46:37.194452 | debian-bookworm -> localhost | changed 2025-10-02 00:46:37.204707 | 2025-10-02 00:46:37.204804 | TASK [add-build-sshkey : Add back temp key] 2025-10-02 00:46:37.581150 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2fc63774107b4f2d8dc68518a39f1b5f/work/2fc63774107b4f2d8dc68518a39f1b5f_id_rsa (zuul-build-sshkey) 2025-10-02 00:46:37.581358 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017749 2025-10-02 00:46:37.588699 | 2025-10-02 00:46:37.588794 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-02 00:46:37.995809 | debian-bookworm | ok 2025-10-02 00:46:38.000028 | 2025-10-02 00:46:38.000111 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-02 00:46:38.032826 | debian-bookworm | skipping: Conditional result was False 2025-10-02 00:46:38.041582 | 2025-10-02 00:46:38.041677 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-02 00:46:38.478202 | debian-bookworm | ok 2025-10-02 00:46:38.487646 | 2025-10-02 00:46:38.487729 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-02 00:46:38.514081 | debian-bookworm | ok 2025-10-02 00:46:38.517993 | 2025-10-02 00:46:38.518086 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-02 00:46:38.853617 | debian-bookworm -> localhost | ok 2025-10-02 00:46:38.868385 | 2025-10-02 00:46:38.868474 | TASK [validate-host : Collect information about the host] 2025-10-02 00:46:39.959143 | debian-bookworm | ok 2025-10-02 00:46:39.967979 | 2025-10-02 00:46:39.968100 | TASK [validate-host : Sanitize hostname] 2025-10-02 00:46:40.045607 | debian-bookworm | ok 2025-10-02 00:46:40.110798 | 2025-10-02 00:46:40.110902 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-02 00:46:40.805504 | debian-bookworm -> localhost | changed 2025-10-02 00:46:40.809971 | 2025-10-02 00:46:40.810057 | TASK [validate-host : Collect information about zuul worker] 2025-10-02 00:46:41.213778 | debian-bookworm | ok 2025-10-02 00:46:41.217412 | 2025-10-02 00:46:41.217487 | TASK [validate-host : Write out all zuul information for each host] 2025-10-02 00:46:41.717174 | debian-bookworm -> localhost | changed 2025-10-02 00:46:41.731165 | 2025-10-02 00:46:41.731255 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-02 00:46:42.009157 | debian-bookworm | ok 2025-10-02 00:46:42.013456 | 2025-10-02 00:46:42.013537 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-02 00:46:42.978108 | debian-bookworm | changed: 2025-10-02 00:46:42.978249 | debian-bookworm | cd+++++++++ src/ 2025-10-02 00:46:42.978277 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-02 00:46:42.978298 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-02 00:46:42.978315 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-02 00:46:42.978332 | debian-bookworm | Containerfile 2025-10-02 00:46:42.978425 | debian-bookworm | Containerfile 2025-10-02 00:46:43.010235 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007354 2025-10-02 00:47:08.761543 | 2025-10-02 00:47:08.761727 | TASK [upload-logs : Upload logs to log server] 2025-10-02 00:47:09.333483 | localhost | Output suppressed because no_log was given 2025-10-02 00:47:09.337423 | 2025-10-02 00:47:09.337607 | LOOP [upload-logs : Compress console log and json output] 2025-10-02 00:47:09.395226 | localhost | skipping: Conditional result was False 2025-10-02 00:47:09.400537 | localhost | skipping: Conditional result was False 2025-10-02 00:47:09.413611 | 2025-10-02 00:47:09.413887 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-02 00:47:09.460323 | localhost | skipping: Conditional result was False 2025-10-02 00:47:09.461094 | 2025-10-02 00:47:09.464345 | localhost | skipping: Conditional result was False 2025-10-02 00:47:09.478338 | 2025-10-02 00:47:09.478583 | LOOP [upload-logs : Upload console log and json output]