2025-09-26 02:25:38.899963 | Job console starting 2025-09-26 02:25:38.924445 | Updating git repos 2025-09-26 02:25:38.964969 | Cloning repos into workspace 2025-09-26 02:25:38.998954 | Restoring repo states 2025-09-26 02:25:39.006346 | Merging changes 2025-09-26 02:25:39.477080 | Checking out repos 2025-09-26 02:25:39.534735 | Preparing playbooks 2025-09-26 02:25:40.167530 | Running Ansible setup 2025-09-26 02:25:44.361358 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-26 02:25:45.101737 | 2025-09-26 02:25:45.101903 | PLAY [Base pre] 2025-09-26 02:25:45.118057 | 2025-09-26 02:25:45.118197 | TASK [Setup log path fact] 2025-09-26 02:25:45.148189 | debian-bookworm | ok 2025-09-26 02:25:45.163170 | 2025-09-26 02:25:45.163347 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-26 02:25:45.193209 | debian-bookworm | ok 2025-09-26 02:25:45.203146 | 2025-09-26 02:25:45.203302 | TASK [emit-job-header : Print job information] 2025-09-26 02:25:45.245143 | # Job Information 2025-09-26 02:25:45.245336 | Ansible Version: 2.16.14 2025-09-26 02:25:45.245371 | Job: python-black 2025-09-26 02:25:45.245404 | Pipeline: check 2025-09-26 02:25:45.245426 | Executor: 521e9411259a 2025-09-26 02:25:45.245447 | Triggered by: https://github.com/osism/openstack-sandbox-manager/pull/98 2025-09-26 02:25:45.245468 | Event ID: 12c81800-9a80-11f0-83de-1228646e73c9 2025-09-26 02:25:45.250400 | 2025-09-26 02:25:45.250516 | LOOP [emit-job-header : Print node information] 2025-09-26 02:25:45.364118 | debian-bookworm | ok: 2025-09-26 02:25:45.364379 | debian-bookworm | # Node Information 2025-09-26 02:25:45.364415 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-26 02:25:45.364439 | debian-bookworm | Hostname: debian 2025-09-26 02:25:45.364460 | debian-bookworm | Username: zuul 2025-09-26 02:25:45.364480 | debian-bookworm | Distro: Debian 12.12 2025-09-26 02:25:45.364502 | debian-bookworm | Provider: regiocloud-a 2025-09-26 02:25:45.364522 | debian-bookworm | Region: 2025-09-26 02:25:45.364542 | debian-bookworm | Label: debian-bookworm 2025-09-26 02:25:45.364562 | debian-bookworm | Product Name: OpenStack Nova 2025-09-26 02:25:45.364580 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe60:fe2 2025-09-26 02:25:45.377934 | 2025-09-26 02:25:45.378089 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-26 02:25:45.861642 | debian-bookworm -> localhost | changed 2025-09-26 02:25:45.870009 | 2025-09-26 02:25:45.870142 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-26 02:25:46.930775 | debian-bookworm -> localhost | changed 2025-09-26 02:25:46.941886 | 2025-09-26 02:25:46.942009 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-26 02:25:47.200355 | debian-bookworm -> localhost | ok 2025-09-26 02:25:47.207033 | 2025-09-26 02:25:47.207152 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-26 02:25:47.226646 | debian-bookworm | ok 2025-09-26 02:25:47.246736 | debian-bookworm | included: /var/lib/zuul/builds/388e455e35e647b0806d3a8088596dab/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-26 02:25:47.253016 | 2025-09-26 02:25:47.253115 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-26 02:25:48.582226 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-26 02:25:48.582474 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/388e455e35e647b0806d3a8088596dab/work/388e455e35e647b0806d3a8088596dab_id_rsa 2025-09-26 02:25:48.582513 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/388e455e35e647b0806d3a8088596dab/work/388e455e35e647b0806d3a8088596dab_id_rsa.pub 2025-09-26 02:25:48.582540 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-26 02:25:48.582565 | debian-bookworm -> localhost | SHA256:HVRN/vzHVslRjPUjLOhhmCi/dLvBfMcKvYezSvH6gtA zuul-build-sshkey 2025-09-26 02:25:48.582587 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-26 02:25:48.582618 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-26 02:25:48.582640 | debian-bookworm -> localhost | | ...o.+o| 2025-09-26 02:25:48.582662 | debian-bookworm -> localhost | | . o.. ..o +| 2025-09-26 02:25:48.582683 | debian-bookworm -> localhost | | . . o +.. o.o.| 2025-09-26 02:25:48.582703 | debian-bookworm -> localhost | | o o.... oo+| 2025-09-26 02:25:48.582723 | debian-bookworm -> localhost | | .o oS.. o+| 2025-09-26 02:25:48.582746 | debian-bookworm -> localhost | | ..E= = . .o| 2025-09-26 02:25:48.582767 | debian-bookworm -> localhost | | ...B +.o =| 2025-09-26 02:25:48.582788 | debian-bookworm -> localhost | | ...*o+. ..| 2025-09-26 02:25:48.582810 | debian-bookworm -> localhost | | ++=+ | 2025-09-26 02:25:48.582925 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-26 02:25:48.582990 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.853657 2025-09-26 02:25:48.589629 | 2025-09-26 02:25:48.589734 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-26 02:25:48.618916 | debian-bookworm | ok 2025-09-26 02:25:48.628407 | debian-bookworm | included: /var/lib/zuul/builds/388e455e35e647b0806d3a8088596dab/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-26 02:25:48.637374 | 2025-09-26 02:25:48.637475 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-26 02:25:48.651528 | debian-bookworm | skipping: Conditional result was False 2025-09-26 02:25:48.657420 | 2025-09-26 02:25:48.657522 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-26 02:25:49.357308 | debian-bookworm | changed 2025-09-26 02:25:49.366294 | 2025-09-26 02:25:49.366438 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-26 02:25:49.642070 | debian-bookworm | ok 2025-09-26 02:25:49.649131 | 2025-09-26 02:25:49.649309 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-26 02:25:50.337672 | debian-bookworm | changed 2025-09-26 02:25:50.347396 | 2025-09-26 02:25:50.347522 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-26 02:25:50.986113 | debian-bookworm | changed 2025-09-26 02:25:50.992045 | 2025-09-26 02:25:50.992149 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-26 02:25:51.026826 | debian-bookworm | skipping: Conditional result was False 2025-09-26 02:25:51.035576 | 2025-09-26 02:25:51.035710 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-26 02:25:51.480594 | debian-bookworm -> localhost | changed 2025-09-26 02:25:51.495426 | 2025-09-26 02:25:51.495540 | TASK [add-build-sshkey : Add back temp key] 2025-09-26 02:25:51.843835 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/388e455e35e647b0806d3a8088596dab/work/388e455e35e647b0806d3a8088596dab_id_rsa (zuul-build-sshkey) 2025-09-26 02:25:51.844162 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017625 2025-09-26 02:25:51.853200 | 2025-09-26 02:25:51.853334 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-26 02:25:52.259821 | debian-bookworm | ok 2025-09-26 02:25:52.265955 | 2025-09-26 02:25:52.266078 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-26 02:25:52.293866 | debian-bookworm | skipping: Conditional result was False 2025-09-26 02:25:52.314063 | 2025-09-26 02:25:52.314197 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-26 02:25:52.770727 | debian-bookworm | ok 2025-09-26 02:25:52.793160 | 2025-09-26 02:25:52.793390 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-26 02:25:52.825063 | debian-bookworm | ok 2025-09-26 02:25:52.831511 | 2025-09-26 02:25:52.831627 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-26 02:25:53.111055 | debian-bookworm -> localhost | ok 2025-09-26 02:25:53.117961 | 2025-09-26 02:25:53.118066 | TASK [validate-host : Collect information about the host] 2025-09-26 02:25:54.219283 | debian-bookworm | ok 2025-09-26 02:25:54.233201 | 2025-09-26 02:25:54.233334 | TASK [validate-host : Sanitize hostname] 2025-09-26 02:25:54.374965 | debian-bookworm | ok 2025-09-26 02:25:54.417560 | 2025-09-26 02:25:54.417704 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-26 02:25:54.991769 | debian-bookworm -> localhost | changed 2025-09-26 02:25:54.998147 | 2025-09-26 02:25:54.998295 | TASK [validate-host : Collect information about zuul worker] 2025-09-26 02:25:55.452295 | debian-bookworm | ok 2025-09-26 02:25:55.460449 | 2025-09-26 02:25:55.460594 | TASK [validate-host : Write out all zuul information for each host] 2025-09-26 02:25:56.007664 | debian-bookworm -> localhost | changed 2025-09-26 02:25:56.018646 | 2025-09-26 02:25:56.018775 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-26 02:25:56.298675 | debian-bookworm | ok 2025-09-26 02:25:56.308041 | 2025-09-26 02:25:56.308198 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-26 02:25:57.072305 | debian-bookworm | changed: 2025-09-26 02:25:57.072786 | debian-bookworm | cd+++++++++ src/ 2025-09-26 02:25:57.072887 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-26 02:25:57.072956 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-26 02:25:57.073016 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2025-09-26 02:25:57.073074 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007572 2025-09-26 02:26:21.410953 | 2025-09-26 02:26:21.411119 | TASK [upload-logs : Upload logs to log server] 2025-09-26 02:26:21.979438 | localhost | Output suppressed because no_log was given 2025-09-26 02:26:21.981404 | 2025-09-26 02:26:21.981535 | LOOP [upload-logs : Compress console log and json output] 2025-09-26 02:26:22.048011 | localhost | skipping: Conditional result was False 2025-09-26 02:26:22.054211 | localhost | skipping: Conditional result was False 2025-09-26 02:26:22.063012 | 2025-09-26 02:26:22.063150 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-26 02:26:22.119377 | localhost | skipping: Conditional result was False 2025-09-26 02:26:22.119784 | 2025-09-26 02:26:22.123626 | localhost | skipping: Conditional result was False 2025-09-26 02:26:22.134587 | 2025-09-26 02:26:22.135037 | LOOP [upload-logs : Upload console log and json output]