2025-10-24 03:02:25.804378 | Job console starting 2025-10-24 03:02:25.820861 | Updating git repos 2025-10-24 03:02:25.865285 | Cloning repos into workspace 2025-10-24 03:02:25.928267 | Restoring repo states 2025-10-24 03:02:25.955482 | Merging changes 2025-10-24 03:02:25.955496 | Checking out repos 2025-10-24 03:02:26.018599 | Preparing playbooks 2025-10-24 03:02:27.306095 | Running Ansible setup 2025-10-24 03:02:33.952266 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-24 03:02:35.012798 | 2025-10-24 03:02:35.012908 | PLAY [Base pre] 2025-10-24 03:02:35.040220 | 2025-10-24 03:02:35.040323 | TASK [Setup log path fact] 2025-10-24 03:02:35.067473 | debian-bookworm | ok 2025-10-24 03:02:35.095470 | 2025-10-24 03:02:35.095578 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-24 03:02:35.138818 | debian-bookworm | ok 2025-10-24 03:02:35.146409 | 2025-10-24 03:02:35.146492 | TASK [emit-job-header : Print job information] 2025-10-24 03:02:35.220441 | # Job Information 2025-10-24 03:02:35.220572 | Ansible Version: 2.16.14 2025-10-24 03:02:35.220601 | Job: python-black 2025-10-24 03:02:35.220628 | Pipeline: periodic-daily 2025-10-24 03:02:35.220646 | Executor: 521e9411259a 2025-10-24 03:02:35.220663 | Triggered by: https://github.com/osism/generics 2025-10-24 03:02:35.220682 | Event ID: 3ca3f22acc83455e8a364be662f3751e 2025-10-24 03:02:35.224631 | 2025-10-24 03:02:35.224710 | LOOP [emit-job-header : Print node information] 2025-10-24 03:02:35.331005 | debian-bookworm | ok: 2025-10-24 03:02:35.331164 | debian-bookworm | # Node Information 2025-10-24 03:02:35.331223 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-24 03:02:35.331247 | debian-bookworm | Hostname: debian 2025-10-24 03:02:35.331265 | debian-bookworm | Username: zuul 2025-10-24 03:02:35.331282 | debian-bookworm | Distro: Debian 12.12 2025-10-24 03:02:35.331301 | debian-bookworm | Provider: regiocloud-a 2025-10-24 03:02:35.331319 | debian-bookworm | Region: 2025-10-24 03:02:35.331337 | debian-bookworm | Label: debian-bookworm 2025-10-24 03:02:35.331353 | debian-bookworm | Product Name: OpenStack Nova 2025-10-24 03:02:35.331369 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef6:c941 2025-10-24 03:02:35.350123 | 2025-10-24 03:02:35.350218 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-24 03:02:36.197762 | debian-bookworm -> localhost | changed 2025-10-24 03:02:36.203454 | 2025-10-24 03:02:36.203543 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-24 03:02:38.281515 | debian-bookworm -> localhost | changed 2025-10-24 03:02:38.291783 | 2025-10-24 03:02:38.291882 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-24 03:02:39.168565 | debian-bookworm -> localhost | ok 2025-10-24 03:02:39.173439 | 2025-10-24 03:02:39.173531 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-24 03:02:39.220495 | debian-bookworm | ok 2025-10-24 03:02:39.247899 | debian-bookworm | included: /var/lib/zuul/builds/919ed68ca04b475da0b1bf75c4e8b656/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-24 03:02:39.264920 | 2025-10-24 03:02:39.265021 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-24 03:02:41.586674 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-24 03:02:41.586862 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/919ed68ca04b475da0b1bf75c4e8b656/work/919ed68ca04b475da0b1bf75c4e8b656_id_rsa 2025-10-24 03:02:41.586895 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/919ed68ca04b475da0b1bf75c4e8b656/work/919ed68ca04b475da0b1bf75c4e8b656_id_rsa.pub 2025-10-24 03:02:41.586917 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-24 03:02:41.586938 | debian-bookworm -> localhost | SHA256://taB9cXhkM+be8At65tV9mbL5aqPNSZkS/Ppb8c3zg zuul-build-sshkey 2025-10-24 03:02:41.586956 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-24 03:02:41.586982 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-24 03:02:41.587000 | debian-bookworm -> localhost | | . | 2025-10-24 03:02:41.587018 | debian-bookworm -> localhost | | o o | 2025-10-24 03:02:41.587035 | debian-bookworm -> localhost | | .*.= | 2025-10-24 03:02:41.587052 | debian-bookworm -> localhost | | oo=.+| 2025-10-24 03:02:41.587069 | debian-bookworm -> localhost | | S . =+ B| 2025-10-24 03:02:41.587119 | debian-bookworm -> localhost | | .. =..*=| 2025-10-24 03:02:41.587139 | debian-bookworm -> localhost | | .. +o=*| 2025-10-24 03:02:41.587157 | debian-bookworm -> localhost | | ... +E==| 2025-10-24 03:02:41.587174 | debian-bookworm -> localhost | | oo*B+BB| 2025-10-24 03:02:41.587190 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-24 03:02:41.587231 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.505349 2025-10-24 03:02:41.592184 | 2025-10-24 03:02:41.592260 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-24 03:02:41.618736 | debian-bookworm | ok 2025-10-24 03:02:41.626050 | debian-bookworm | included: /var/lib/zuul/builds/919ed68ca04b475da0b1bf75c4e8b656/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-24 03:02:41.645359 | 2025-10-24 03:02:41.645440 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-24 03:02:41.678061 | debian-bookworm | skipping: Conditional result was False 2025-10-24 03:02:41.682566 | 2025-10-24 03:02:41.682638 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-24 03:02:42.356008 | debian-bookworm | changed 2025-10-24 03:02:42.360433 | 2025-10-24 03:02:42.360507 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-24 03:02:42.629572 | debian-bookworm | ok 2025-10-24 03:02:42.633984 | 2025-10-24 03:02:42.634060 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-24 03:02:43.315039 | debian-bookworm | changed 2025-10-24 03:02:43.321340 | 2025-10-24 03:02:43.321436 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-24 03:02:44.029156 | debian-bookworm | changed 2025-10-24 03:02:44.033514 | 2025-10-24 03:02:44.033592 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-24 03:02:44.087391 | debian-bookworm | skipping: Conditional result was False 2025-10-24 03:02:44.092275 | 2025-10-24 03:02:44.092357 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-24 03:02:44.747570 | debian-bookworm -> localhost | changed 2025-10-24 03:02:44.756467 | 2025-10-24 03:02:44.756548 | TASK [add-build-sshkey : Add back temp key] 2025-10-24 03:02:45.397661 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/919ed68ca04b475da0b1bf75c4e8b656/work/919ed68ca04b475da0b1bf75c4e8b656_id_rsa (zuul-build-sshkey) 2025-10-24 03:02:45.397854 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.035039 2025-10-24 03:02:45.404118 | 2025-10-24 03:02:45.404196 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-24 03:02:45.809542 | debian-bookworm | ok 2025-10-24 03:02:45.813511 | 2025-10-24 03:02:45.813582 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-24 03:02:45.836711 | debian-bookworm | skipping: Conditional result was False 2025-10-24 03:02:45.844895 | 2025-10-24 03:02:45.844975 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-24 03:02:46.267707 | debian-bookworm | ok 2025-10-24 03:02:46.276131 | 2025-10-24 03:02:46.276217 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-24 03:02:46.332782 | debian-bookworm | ok 2025-10-24 03:02:46.336866 | 2025-10-24 03:02:46.336943 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-24 03:02:46.756153 | debian-bookworm -> localhost | ok 2025-10-24 03:02:46.761352 | 2025-10-24 03:02:46.761433 | TASK [validate-host : Collect information about the host] 2025-10-24 03:02:47.967976 | debian-bookworm | ok 2025-10-24 03:02:47.979084 | 2025-10-24 03:02:47.979182 | TASK [validate-host : Sanitize hostname] 2025-10-24 03:02:48.091974 | debian-bookworm | ok 2025-10-24 03:02:48.143670 | 2025-10-24 03:02:48.143773 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-24 03:02:49.160576 | debian-bookworm -> localhost | changed 2025-10-24 03:02:49.165123 | 2025-10-24 03:02:49.165205 | TASK [validate-host : Collect information about zuul worker] 2025-10-24 03:02:49.557493 | debian-bookworm | ok 2025-10-24 03:02:49.561402 | 2025-10-24 03:02:49.561484 | TASK [validate-host : Write out all zuul information for each host] 2025-10-24 03:02:50.528047 | debian-bookworm -> localhost | changed 2025-10-24 03:02:50.535558 | 2025-10-24 03:02:50.535635 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-24 03:02:50.847472 | debian-bookworm | ok 2025-10-24 03:02:50.853414 | 2025-10-24 03:02:50.853498 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-24 03:02:51.605270 | debian-bookworm | changed: 2025-10-24 03:02:51.605430 | debian-bookworm | cd+++++++++ src/ 2025-10-24 03:02:51.605464 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-24 03:02:51.605488 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-24 03:02:51.605510 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2025-10-24 03:02:51.605531 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004743 2025-10-24 03:03:21.273233 | 2025-10-24 03:03:21.273313 | TASK [upload-logs : Upload logs to log server] 2025-10-24 03:03:22.400040 | localhost | Output suppressed because no_log was given 2025-10-24 03:03:22.401406 | 2025-10-24 03:03:22.401479 | LOOP [upload-logs : Compress console log and json output] 2025-10-24 03:03:22.455398 | localhost | skipping: Conditional result was False 2025-10-24 03:03:22.464971 | localhost | skipping: Conditional result was False 2025-10-24 03:03:22.476577 | 2025-10-24 03:03:22.476671 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-24 03:03:22.528019 | localhost | skipping: Conditional result was False 2025-10-24 03:03:22.528226 | 2025-10-24 03:03:22.539939 | localhost | skipping: Conditional result was False 2025-10-24 03:03:22.553016 | 2025-10-24 03:03:22.553107 | LOOP [upload-logs : Upload console log and json output]