2025-11-25 18:49:49.532119 | Job console starting 2025-11-25 18:49:49.573690 | Updating git repos 2025-11-25 18:49:49.627193 | Cloning repos into workspace 2025-11-25 18:49:49.704860 | Restoring repo states 2025-11-25 18:49:49.732709 | Merging changes 2025-11-25 18:49:50.331372 | Checking out repos 2025-11-25 18:49:50.383547 | Preparing playbooks 2025-11-25 18:49:51.453144 | Running Ansible setup 2025-11-25 18:49:57.110590 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-25 18:49:58.178917 | 2025-11-25 18:49:58.179289 | PLAY [Base pre] 2025-11-25 18:49:58.200499 | 2025-11-25 18:49:58.200657 | TASK [Setup log path fact] 2025-11-25 18:49:58.230955 | debian-bookworm | ok 2025-11-25 18:49:58.254116 | 2025-11-25 18:49:58.254288 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-25 18:49:58.324595 | debian-bookworm | ok 2025-11-25 18:49:58.355133 | 2025-11-25 18:49:58.355280 | TASK [emit-job-header : Print job information] 2025-11-25 18:49:58.446048 | # Job Information 2025-11-25 18:49:58.446247 | Ansible Version: 2.16.14 2025-11-25 18:49:58.446280 | Job: python-black 2025-11-25 18:49:58.446313 | Pipeline: check 2025-11-25 18:49:58.446335 | Executor: 521e9411259a 2025-11-25 18:49:58.446355 | Triggered by: https://github.com/osism/python-osism/pull/1703 2025-11-25 18:49:58.446376 | Event ID: 7f876a20-ca2f-11f0-95ab-6e380e8804bc 2025-11-25 18:49:58.456268 | 2025-11-25 18:49:58.456403 | LOOP [emit-job-header : Print node information] 2025-11-25 18:49:58.679090 | debian-bookworm | ok: 2025-11-25 18:49:58.679313 | debian-bookworm | # Node Information 2025-11-25 18:49:58.679352 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-25 18:49:58.679379 | debian-bookworm | Hostname: debian 2025-11-25 18:49:58.679401 | debian-bookworm | Username: zuul 2025-11-25 18:49:58.679422 | debian-bookworm | Distro: Debian 12.12 2025-11-25 18:49:58.679446 | debian-bookworm | Provider: regiocloud-a 2025-11-25 18:49:58.679472 | debian-bookworm | Region: 2025-11-25 18:49:58.679493 | debian-bookworm | Label: debian-bookworm 2025-11-25 18:49:58.679513 | debian-bookworm | Product Name: OpenStack Nova 2025-11-25 18:49:58.679532 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5e:cebd 2025-11-25 18:49:58.697760 | 2025-11-25 18:49:58.697945 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-25 18:49:59.744135 | debian-bookworm -> localhost | changed 2025-11-25 18:49:59.751518 | 2025-11-25 18:49:59.751654 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-25 18:50:01.824918 | debian-bookworm -> localhost | changed 2025-11-25 18:50:01.843077 | 2025-11-25 18:50:01.843196 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-25 18:50:02.365662 | debian-bookworm -> localhost | ok 2025-11-25 18:50:02.371695 | 2025-11-25 18:50:02.371808 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-25 18:50:02.389102 | debian-bookworm | ok 2025-11-25 18:50:02.407017 | debian-bookworm | included: /var/lib/zuul/builds/c26f8c9de0de4a6ea5d64d97882ee745/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-25 18:50:02.413510 | 2025-11-25 18:50:02.413603 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-25 18:50:05.435834 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-25 18:50:05.436055 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c26f8c9de0de4a6ea5d64d97882ee745/work/c26f8c9de0de4a6ea5d64d97882ee745_id_rsa 2025-11-25 18:50:05.436100 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c26f8c9de0de4a6ea5d64d97882ee745/work/c26f8c9de0de4a6ea5d64d97882ee745_id_rsa.pub 2025-11-25 18:50:05.436132 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-25 18:50:05.436162 | debian-bookworm -> localhost | SHA256:m2xXg1FbrCwGRpR1MwXTCmCXXn+hRoarL+Ob5DAH//8 zuul-build-sshkey 2025-11-25 18:50:05.436189 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-25 18:50:05.436228 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-25 18:50:05.436255 | debian-bookworm -> localhost | | o=+o.O=o | 2025-11-25 18:50:05.436280 | debian-bookworm -> localhost | | .+.o+.Oo. | 2025-11-25 18:50:05.436304 | debian-bookworm -> localhost | | . o.+=+. .| 2025-11-25 18:50:05.436327 | debian-bookworm -> localhost | | +++o. .| 2025-11-25 18:50:05.436350 | debian-bookworm -> localhost | | .S.o.+ . | 2025-11-25 18:50:05.436377 | debian-bookworm -> localhost | | .o+ . . | 2025-11-25 18:50:05.436402 | debian-bookworm -> localhost | | o=+o | 2025-11-25 18:50:05.436425 | debian-bookworm -> localhost | | .*+o. | 2025-11-25 18:50:05.436448 | debian-bookworm -> localhost | | .=+....E | 2025-11-25 18:50:05.436472 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-25 18:50:05.436533 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.413321 2025-11-25 18:50:05.443815 | 2025-11-25 18:50:05.443938 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-25 18:50:05.476526 | debian-bookworm | ok 2025-11-25 18:50:05.492758 | debian-bookworm | included: /var/lib/zuul/builds/c26f8c9de0de4a6ea5d64d97882ee745/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-25 18:50:05.502650 | 2025-11-25 18:50:05.502736 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-25 18:50:05.526324 | debian-bookworm | skipping: Conditional result was False 2025-11-25 18:50:05.536564 | 2025-11-25 18:50:05.536703 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-25 18:50:06.109048 | debian-bookworm | changed 2025-11-25 18:50:06.114354 | 2025-11-25 18:50:06.114445 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-25 18:50:06.357520 | debian-bookworm | ok 2025-11-25 18:50:06.364645 | 2025-11-25 18:50:06.364749 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-25 18:50:07.001151 | debian-bookworm | changed 2025-11-25 18:50:07.013105 | 2025-11-25 18:50:07.013219 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-25 18:50:07.698721 | debian-bookworm | changed 2025-11-25 18:50:07.707113 | 2025-11-25 18:50:07.707255 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-25 18:50:07.732745 | debian-bookworm | skipping: Conditional result was False 2025-11-25 18:50:07.739653 | 2025-11-25 18:50:07.739769 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-25 18:50:08.391955 | debian-bookworm -> localhost | changed 2025-11-25 18:50:08.403372 | 2025-11-25 18:50:08.403496 | TASK [add-build-sshkey : Add back temp key] 2025-11-25 18:50:08.947002 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c26f8c9de0de4a6ea5d64d97882ee745/work/c26f8c9de0de4a6ea5d64d97882ee745_id_rsa (zuul-build-sshkey) 2025-11-25 18:50:08.947288 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016265 2025-11-25 18:50:08.956025 | 2025-11-25 18:50:08.956151 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-25 18:50:09.382636 | debian-bookworm | ok 2025-11-25 18:50:09.391645 | 2025-11-25 18:50:09.391777 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-25 18:50:09.435908 | debian-bookworm | skipping: Conditional result was False 2025-11-25 18:50:09.449703 | 2025-11-25 18:50:09.449850 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-25 18:50:09.895093 | debian-bookworm | ok 2025-11-25 18:50:09.911477 | 2025-11-25 18:50:09.911620 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-25 18:50:09.942426 | debian-bookworm | ok 2025-11-25 18:50:09.947928 | 2025-11-25 18:50:09.948045 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-25 18:50:10.291639 | debian-bookworm -> localhost | ok 2025-11-25 18:50:10.298997 | 2025-11-25 18:50:10.299115 | TASK [validate-host : Collect information about the host] 2025-11-25 18:50:11.476246 | debian-bookworm | ok 2025-11-25 18:50:11.494088 | 2025-11-25 18:50:11.494232 | TASK [validate-host : Sanitize hostname] 2025-11-25 18:50:11.615578 | debian-bookworm | ok 2025-11-25 18:50:11.687778 | 2025-11-25 18:50:11.687942 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-25 18:50:12.518776 | debian-bookworm -> localhost | changed 2025-11-25 18:50:12.525481 | 2025-11-25 18:50:12.525622 | TASK [validate-host : Collect information about zuul worker] 2025-11-25 18:50:13.144621 | debian-bookworm | ok 2025-11-25 18:50:13.153462 | 2025-11-25 18:50:13.153637 | TASK [validate-host : Write out all zuul information for each host] 2025-11-25 18:50:14.071182 | debian-bookworm -> localhost | changed 2025-11-25 18:50:14.081914 | 2025-11-25 18:50:14.082062 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-25 18:50:14.387152 | debian-bookworm | ok 2025-11-25 18:50:14.394309 | 2025-11-25 18:50:14.394455 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-25 18:50:15.995615 | debian-bookworm | changed: 2025-11-25 18:50:15.995879 | debian-bookworm | cd+++++++++ src/ 2025-11-25 18:50:15.995923 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-25 18:50:15.995949 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-25 18:50:15.995972 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-25 18:50:15.995992 | debian-bookworm | Containerfile 2025-11-25 18:50:15.996102 | debian-bookworm | Containerfile 2025-11-25 18:50:16.039640 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007629 2025-11-25 18:50:43.181389 | 2025-11-25 18:50:43.181540 | TASK [upload-logs : Upload logs to log server] 2025-11-25 18:50:43.761032 | localhost | Output suppressed because no_log was given 2025-11-25 18:50:43.763334 | 2025-11-25 18:50:43.763464 | LOOP [upload-logs : Compress console log and json output] 2025-11-25 18:50:43.820194 | localhost | skipping: Conditional result was False 2025-11-25 18:50:43.828513 | localhost | skipping: Conditional result was False 2025-11-25 18:50:43.836390 | 2025-11-25 18:50:43.836624 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-25 18:50:43.882249 | localhost | skipping: Conditional result was False 2025-11-25 18:50:43.882519 | 2025-11-25 18:50:43.889176 | localhost | skipping: Conditional result was False 2025-11-25 18:50:43.901006 | 2025-11-25 18:50:43.901231 | LOOP [upload-logs : Upload console log and json output]