2025-08-23 09:53:36.684002 | Job console starting 2025-08-23 09:53:36.707357 | Updating git repos 2025-08-23 09:53:37.017030 | Cloning repos into workspace 2025-08-23 09:53:37.107291 | Restoring repo states 2025-08-23 09:53:37.139721 | Merging changes 2025-08-23 09:53:37.798879 | Checking out repos 2025-08-23 09:53:37.929558 | Preparing playbooks 2025-08-23 09:53:39.085760 | Running Ansible setup 2025-08-23 09:53:45.169018 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-23 09:53:46.365261 | 2025-08-23 09:53:46.365389 | PLAY [Base pre] 2025-08-23 09:53:46.386212 | 2025-08-23 09:53:46.386330 | TASK [Setup log path fact] 2025-08-23 09:53:46.404486 | debian-bookworm | ok 2025-08-23 09:53:46.430366 | 2025-08-23 09:53:46.430498 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-23 09:53:46.469992 | debian-bookworm | ok 2025-08-23 09:53:46.484846 | 2025-08-23 09:53:46.484964 | TASK [emit-job-header : Print job information] 2025-08-23 09:53:46.543348 | # Job Information 2025-08-23 09:53:46.543510 | Ansible Version: 2.16.14 2025-08-23 09:53:46.543547 | Job: python-black 2025-08-23 09:53:46.543582 | Pipeline: check 2025-08-23 09:53:46.543605 | Executor: 521e9411259a 2025-08-23 09:53:46.543626 | Triggered by: https://github.com/osism/python-osism/pull/1655 2025-08-23 09:53:46.543650 | Event ID: 046723c0-8007-11f0-9935-8ffb18e3020a 2025-08-23 09:53:46.548475 | 2025-08-23 09:53:46.548564 | LOOP [emit-job-header : Print node information] 2025-08-23 09:53:46.716370 | debian-bookworm | ok: 2025-08-23 09:53:46.716537 | debian-bookworm | # Node Information 2025-08-23 09:53:46.716570 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-23 09:53:46.716595 | debian-bookworm | Hostname: debian 2025-08-23 09:53:46.716617 | debian-bookworm | Username: zuul 2025-08-23 09:53:46.716638 | debian-bookworm | Distro: Debian 12.11 2025-08-23 09:53:46.716660 | debian-bookworm | Provider: regiocloud-a 2025-08-23 09:53:46.716682 | debian-bookworm | Region: 2025-08-23 09:53:46.716702 | debian-bookworm | Label: debian-bookworm 2025-08-23 09:53:46.716721 | debian-bookworm | Product Name: OpenStack Nova 2025-08-23 09:53:46.716740 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe25:6603 2025-08-23 09:53:46.732335 | 2025-08-23 09:53:46.732439 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-23 09:53:47.752875 | debian-bookworm -> localhost | changed 2025-08-23 09:53:47.758444 | 2025-08-23 09:53:47.758528 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-23 09:53:49.629256 | debian-bookworm -> localhost | changed 2025-08-23 09:53:49.637763 | 2025-08-23 09:53:49.637878 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-23 09:53:50.078063 | debian-bookworm -> localhost | ok 2025-08-23 09:53:50.082922 | 2025-08-23 09:53:50.083006 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-23 09:53:50.129526 | debian-bookworm | ok 2025-08-23 09:53:50.155031 | debian-bookworm | included: /var/lib/zuul/builds/22191d5024234cb6b42fe98d01743d46/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-23 09:53:50.171925 | 2025-08-23 09:53:50.172012 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-23 09:53:51.555097 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-23 09:53:51.555260 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/22191d5024234cb6b42fe98d01743d46/work/22191d5024234cb6b42fe98d01743d46_id_rsa 2025-08-23 09:53:51.555291 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/22191d5024234cb6b42fe98d01743d46/work/22191d5024234cb6b42fe98d01743d46_id_rsa.pub 2025-08-23 09:53:51.555312 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-23 09:53:51.555332 | debian-bookworm -> localhost | SHA256:sOIgs4eVi/6Ri0TShtwGNemowVOAqiz3Ap30ZQXC1do zuul-build-sshkey 2025-08-23 09:53:51.555350 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-23 09:53:51.555375 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-23 09:53:51.555393 | debian-bookworm -> localhost | |...+o.oo | 2025-08-23 09:53:51.555411 | debian-bookworm -> localhost | |. .oo. o | 2025-08-23 09:53:51.555428 | debian-bookworm -> localhost | |o.+ .+ | 2025-08-23 09:53:51.555445 | debian-bookworm -> localhost | |+*+o +oE | 2025-08-23 09:53:51.555462 | debian-bookworm -> localhost | |O*B=.o. S | 2025-08-23 09:53:51.555480 | debian-bookworm -> localhost | |BX=+o. | 2025-08-23 09:53:51.555497 | debian-bookworm -> localhost | |=+o+. | 2025-08-23 09:53:51.555513 | debian-bookworm -> localhost | |o.o + | 2025-08-23 09:53:51.555530 | debian-bookworm -> localhost | | o.+ | 2025-08-23 09:53:51.555546 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-23 09:53:51.555586 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.612100 2025-08-23 09:53:51.560675 | 2025-08-23 09:53:51.560746 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-23 09:53:51.596995 | debian-bookworm | ok 2025-08-23 09:53:51.610600 | debian-bookworm | included: /var/lib/zuul/builds/22191d5024234cb6b42fe98d01743d46/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-23 09:53:51.633991 | 2025-08-23 09:53:51.634078 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-23 09:53:51.676769 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:53:51.681513 | 2025-08-23 09:53:51.681590 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-23 09:53:52.377571 | debian-bookworm | changed 2025-08-23 09:53:52.382089 | 2025-08-23 09:53:52.382170 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-23 09:53:52.658945 | debian-bookworm | ok 2025-08-23 09:53:52.663390 | 2025-08-23 09:53:52.663475 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-23 09:53:53.406070 | debian-bookworm | changed 2025-08-23 09:53:53.411550 | 2025-08-23 09:53:53.411645 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-23 09:53:54.073730 | debian-bookworm | changed 2025-08-23 09:53:54.084874 | 2025-08-23 09:53:54.084971 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-23 09:53:54.131705 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:53:54.137963 | 2025-08-23 09:53:54.138052 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-23 09:53:54.811228 | debian-bookworm -> localhost | changed 2025-08-23 09:53:54.823190 | 2025-08-23 09:53:54.823278 | TASK [add-build-sshkey : Add back temp key] 2025-08-23 09:53:55.172779 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/22191d5024234cb6b42fe98d01743d46/work/22191d5024234cb6b42fe98d01743d46_id_rsa (zuul-build-sshkey) 2025-08-23 09:53:55.173006 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015422 2025-08-23 09:53:55.181408 | 2025-08-23 09:53:55.181495 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-23 09:53:55.582414 | debian-bookworm | ok 2025-08-23 09:53:55.586627 | 2025-08-23 09:53:55.586705 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-23 09:53:55.639411 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:53:55.647893 | 2025-08-23 09:53:55.647981 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-23 09:53:56.431290 | debian-bookworm | ok 2025-08-23 09:53:56.441438 | 2025-08-23 09:53:56.441524 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-23 09:53:56.476799 | debian-bookworm | ok 2025-08-23 09:53:56.481624 | 2025-08-23 09:53:56.481701 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-23 09:53:56.897796 | debian-bookworm -> localhost | ok 2025-08-23 09:53:56.902892 | 2025-08-23 09:53:56.902985 | TASK [validate-host : Collect information about the host] 2025-08-23 09:53:58.268134 | debian-bookworm | ok 2025-08-23 09:53:58.301304 | 2025-08-23 09:53:58.301403 | TASK [validate-host : Sanitize hostname] 2025-08-23 09:53:58.419612 | debian-bookworm | ok 2025-08-23 09:53:58.483329 | 2025-08-23 09:53:58.483426 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-23 09:53:59.407374 | debian-bookworm -> localhost | changed 2025-08-23 09:53:59.411848 | 2025-08-23 09:53:59.411927 | TASK [validate-host : Collect information about zuul worker] 2025-08-23 09:53:59.826574 | debian-bookworm | ok 2025-08-23 09:53:59.831080 | 2025-08-23 09:53:59.831163 | TASK [validate-host : Write out all zuul information for each host] 2025-08-23 09:54:00.629983 | debian-bookworm -> localhost | changed 2025-08-23 09:54:00.637858 | 2025-08-23 09:54:00.637934 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-23 09:54:00.945731 | debian-bookworm | ok 2025-08-23 09:54:00.951066 | 2025-08-23 09:54:00.957184 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-23 09:54:02.746885 | debian-bookworm | changed: 2025-08-23 09:54:02.747032 | debian-bookworm | cd+++++++++ src/ 2025-08-23 09:54:02.747116 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-23 09:54:02.747137 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-23 09:54:02.747155 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-23 09:54:02.747172 | debian-bookworm | Containerfile 2025-08-23 09:54:02.747265 | debian-bookworm | Containerfile 2025-08-23 09:54:02.790857 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007260 2025-08-23 09:54:29.941993 | 2025-08-23 09:54:29.942117 | TASK [upload-logs : Upload logs to log server] 2025-08-23 09:54:30.539957 | localhost | Output suppressed because no_log was given 2025-08-23 09:54:30.542634 | 2025-08-23 09:54:30.542749 | LOOP [upload-logs : Compress console log and json output] 2025-08-23 09:54:30.611033 | localhost | skipping: Conditional result was False 2025-08-23 09:54:30.618884 | localhost | skipping: Conditional result was False 2025-08-23 09:54:30.627720 | 2025-08-23 09:54:30.627986 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-23 09:54:30.704970 | localhost | skipping: Conditional result was False 2025-08-23 09:54:30.705327 | 2025-08-23 09:54:30.713344 | localhost | skipping: Conditional result was False 2025-08-23 09:54:30.719938 | 2025-08-23 09:54:30.720124 | LOOP [upload-logs : Upload console log and json output]