2025-12-10 10:36:50.615858 | Job console starting 2025-12-10 10:36:50.641719 | Updating git repos 2025-12-10 10:36:50.667989 | Cloning repos into workspace 2025-12-10 10:36:50.724863 | Restoring repo states 2025-12-10 10:36:50.731351 | Merging changes 2025-12-10 10:36:51.281521 | Checking out repos 2025-12-10 10:36:51.340981 | Preparing playbooks 2025-12-10 10:36:52.272589 | Running Ansible setup 2025-12-10 10:36:56.768883 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-10 10:36:57.627213 | 2025-12-10 10:36:57.627378 | PLAY [Base pre] 2025-12-10 10:36:57.644131 | 2025-12-10 10:36:57.644279 | TASK [Setup log path fact] 2025-12-10 10:36:57.674213 | debian-bookworm | ok 2025-12-10 10:36:57.690556 | 2025-12-10 10:36:57.690715 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-10 10:36:57.721928 | debian-bookworm | ok 2025-12-10 10:36:57.734523 | 2025-12-10 10:36:57.734672 | TASK [emit-job-header : Print job information] 2025-12-10 10:36:57.776642 | # Job Information 2025-12-10 10:36:57.776863 | Ansible Version: 2.16.14 2025-12-10 10:36:57.776898 | Job: python-black 2025-12-10 10:36:57.776931 | Pipeline: check 2025-12-10 10:36:57.776953 | Executor: 521e9411259a 2025-12-10 10:36:57.776973 | Triggered by: https://github.com/osism/testbed/pull/2809 2025-12-10 10:36:57.776996 | Event ID: 1e3ab980-d5b4-11f0-8acf-0d99d9cbf2e0 2025-12-10 10:36:57.782645 | 2025-12-10 10:36:57.782947 | LOOP [emit-job-header : Print node information] 2025-12-10 10:36:57.911645 | debian-bookworm | ok: 2025-12-10 10:36:57.911895 | debian-bookworm | # Node Information 2025-12-10 10:36:57.911938 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-10 10:36:57.911968 | debian-bookworm | Hostname: debian 2025-12-10 10:36:57.911995 | debian-bookworm | Username: zuul 2025-12-10 10:36:57.912020 | debian-bookworm | Distro: Debian 12.12 2025-12-10 10:36:57.912048 | debian-bookworm | Provider: regiocloud-a 2025-12-10 10:36:57.912074 | debian-bookworm | Region: 2025-12-10 10:36:57.912098 | debian-bookworm | Label: debian-bookworm 2025-12-10 10:36:57.912122 | debian-bookworm | Product Name: OpenStack Nova 2025-12-10 10:36:57.912146 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed2:3046 2025-12-10 10:36:57.935734 | 2025-12-10 10:36:57.935912 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-10 10:36:58.663360 | debian-bookworm -> localhost | changed 2025-12-10 10:36:58.671532 | 2025-12-10 10:36:58.671684 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-10 10:36:59.854270 | debian-bookworm -> localhost | changed 2025-12-10 10:36:59.874401 | 2025-12-10 10:36:59.874556 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-10 10:37:00.213547 | debian-bookworm -> localhost | ok 2025-12-10 10:37:00.221121 | 2025-12-10 10:37:00.221303 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-10 10:37:00.254934 | debian-bookworm | ok 2025-12-10 10:37:00.276579 | debian-bookworm | included: /var/lib/zuul/builds/c05402da49d04ee1bec8d035ba7f6c6f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-10 10:37:00.284133 | 2025-12-10 10:37:00.284273 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-10 10:37:02.812685 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-10 10:37:02.812971 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c05402da49d04ee1bec8d035ba7f6c6f/work/c05402da49d04ee1bec8d035ba7f6c6f_id_rsa 2025-12-10 10:37:02.813013 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c05402da49d04ee1bec8d035ba7f6c6f/work/c05402da49d04ee1bec8d035ba7f6c6f_id_rsa.pub 2025-12-10 10:37:02.813056 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-10 10:37:02.813081 | debian-bookworm -> localhost | SHA256:gpRSJ6xkp+Y8Mx7yC2T5jHOUEy4XBD2GZt74Xpd4euo zuul-build-sshkey 2025-12-10 10:37:02.813103 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-10 10:37:02.813140 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-10 10:37:02.813162 | debian-bookworm -> localhost | | .+oo . | 2025-12-10 10:37:02.813183 | debian-bookworm -> localhost | | ++=o+ | 2025-12-10 10:37:02.813204 | debian-bookworm -> localhost | |+o=*+ | 2025-12-10 10:37:02.813223 | debian-bookworm -> localhost | | o*++. | 2025-12-10 10:37:02.813242 | debian-bookworm -> localhost | | O.*. o S | 2025-12-10 10:37:02.813263 | debian-bookworm -> localhost | |+ #..o = | 2025-12-10 10:37:02.813282 | debian-bookworm -> localhost | |.*.O. + | 2025-12-10 10:37:02.813302 | debian-bookworm -> localhost | | .=. . . | 2025-12-10 10:37:02.813322 | debian-bookworm -> localhost | | ...Eo | 2025-12-10 10:37:02.813341 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-10 10:37:02.813399 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.910947 2025-12-10 10:37:02.820274 | 2025-12-10 10:37:02.820414 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-10 10:37:02.869890 | debian-bookworm | ok 2025-12-10 10:37:02.889078 | debian-bookworm | included: /var/lib/zuul/builds/c05402da49d04ee1bec8d035ba7f6c6f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-10 10:37:02.904446 | 2025-12-10 10:37:02.904590 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-10 10:37:02.946902 | debian-bookworm | skipping: Conditional result was False 2025-12-10 10:37:02.953476 | 2025-12-10 10:37:02.953603 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-10 10:37:03.584095 | debian-bookworm | changed 2025-12-10 10:37:03.599402 | 2025-12-10 10:37:03.599539 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-10 10:37:03.870975 | debian-bookworm | ok 2025-12-10 10:37:03.877225 | 2025-12-10 10:37:03.877345 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-10 10:37:04.595098 | debian-bookworm | changed 2025-12-10 10:37:04.608327 | 2025-12-10 10:37:04.608542 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-10 10:37:05.271335 | debian-bookworm | changed 2025-12-10 10:37:05.283334 | 2025-12-10 10:37:05.283489 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-10 10:37:05.310059 | debian-bookworm | skipping: Conditional result was False 2025-12-10 10:37:05.318365 | 2025-12-10 10:37:05.318665 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-10 10:37:06.179839 | debian-bookworm -> localhost | changed 2025-12-10 10:37:06.203056 | 2025-12-10 10:37:06.203214 | TASK [add-build-sshkey : Add back temp key] 2025-12-10 10:37:06.603621 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c05402da49d04ee1bec8d035ba7f6c6f/work/c05402da49d04ee1bec8d035ba7f6c6f_id_rsa (zuul-build-sshkey) 2025-12-10 10:37:06.603909 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015407 2025-12-10 10:37:06.616542 | 2025-12-10 10:37:06.616685 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-10 10:37:07.042643 | debian-bookworm | ok 2025-12-10 10:37:07.052238 | 2025-12-10 10:37:07.052374 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-10 10:37:07.086439 | debian-bookworm | skipping: Conditional result was False 2025-12-10 10:37:07.097424 | 2025-12-10 10:37:07.097557 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-10 10:37:07.613082 | debian-bookworm | ok 2025-12-10 10:37:07.635876 | 2025-12-10 10:37:07.636025 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-10 10:37:07.683216 | debian-bookworm | ok 2025-12-10 10:37:07.688580 | 2025-12-10 10:37:07.688691 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-10 10:37:08.006194 | debian-bookworm -> localhost | ok 2025-12-10 10:37:08.013001 | 2025-12-10 10:37:08.013127 | TASK [validate-host : Collect information about the host] 2025-12-10 10:37:09.188180 | debian-bookworm | ok 2025-12-10 10:37:09.198754 | 2025-12-10 10:37:09.198934 | TASK [validate-host : Sanitize hostname] 2025-12-10 10:37:09.340859 | debian-bookworm | ok 2025-12-10 10:37:09.442550 | 2025-12-10 10:37:09.442694 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-10 10:37:10.250117 | debian-bookworm -> localhost | changed 2025-12-10 10:37:10.271085 | 2025-12-10 10:37:10.271223 | TASK [validate-host : Collect information about zuul worker] 2025-12-10 10:37:10.887040 | debian-bookworm | ok 2025-12-10 10:37:10.891877 | 2025-12-10 10:37:10.891998 | TASK [validate-host : Write out all zuul information for each host] 2025-12-10 10:37:11.524850 | debian-bookworm -> localhost | changed 2025-12-10 10:37:11.546986 | 2025-12-10 10:37:11.547157 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-10 10:37:11.839875 | debian-bookworm | ok 2025-12-10 10:37:11.849162 | 2025-12-10 10:37:11.849321 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-10 10:37:12.972567 | debian-bookworm | changed: 2025-12-10 10:37:12.972873 | debian-bookworm | cd+++++++++ src/ 2025-12-10 10:37:12.972920 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-10 10:37:12.972947 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-10 10:37:12.972969 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-10 10:37:12.972990 | debian-bookworm | localhost | ok: Runtime: 0:00:00.014322 2025-12-10 10:37:38.452327 | 2025-12-10 10:37:38.452540 | TASK [upload-logs : Upload logs to log server] 2025-12-10 10:37:39.067122 | localhost | Output suppressed because no_log was given 2025-12-10 10:37:39.071343 | 2025-12-10 10:37:39.071548 | LOOP [upload-logs : Compress console log and json output] 2025-12-10 10:37:39.135486 | localhost | skipping: Conditional result was False 2025-12-10 10:37:39.144096 | localhost | skipping: Conditional result was False 2025-12-10 10:37:39.152948 | 2025-12-10 10:37:39.153143 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-10 10:37:39.210401 | localhost | skipping: Conditional result was False 2025-12-10 10:37:39.210924 | 2025-12-10 10:37:39.213353 | localhost | skipping: Conditional result was False 2025-12-10 10:37:39.219626 | 2025-12-10 10:37:39.219761 | LOOP [upload-logs : Upload console log and json output]