2025-09-21 19:48:46.167004 | Job console starting 2025-09-21 19:48:46.186859 | Updating git repos 2025-09-21 19:48:46.233731 | Cloning repos into workspace 2025-09-21 19:48:46.308747 | Restoring repo states 2025-09-21 19:48:46.335585 | Merging changes 2025-09-21 19:48:46.968078 | Checking out repos 2025-09-21 19:48:47.042711 | Preparing playbooks 2025-09-21 19:48:47.875410 | Running Ansible setup 2025-09-21 19:48:52.802575 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-21 19:48:53.674296 | 2025-09-21 19:48:53.674459 | PLAY [Base pre] 2025-09-21 19:48:53.690359 | 2025-09-21 19:48:53.690494 | TASK [Setup log path fact] 2025-09-21 19:48:53.709124 | debian-bookworm | ok 2025-09-21 19:48:53.724315 | 2025-09-21 19:48:53.724452 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-21 19:48:53.794433 | debian-bookworm | ok 2025-09-21 19:48:53.812460 | 2025-09-21 19:48:53.813643 | TASK [emit-job-header : Print job information] 2025-09-21 19:48:53.894630 | # Job Information 2025-09-21 19:48:53.894855 | Ansible Version: 2.16.14 2025-09-21 19:48:53.894897 | Job: python-black 2025-09-21 19:48:53.894930 | Pipeline: check 2025-09-21 19:48:53.894965 | Executor: 521e9411259a 2025-09-21 19:48:53.894986 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2000 2025-09-21 19:48:53.895009 | Event ID: f7b41870-9723-11f0-91eb-25693d36620f 2025-09-21 19:48:53.908150 | 2025-09-21 19:48:53.908290 | LOOP [emit-job-header : Print node information] 2025-09-21 19:48:54.065649 | debian-bookworm | ok: 2025-09-21 19:48:54.065906 | debian-bookworm | # Node Information 2025-09-21 19:48:54.065964 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-21 19:48:54.065992 | debian-bookworm | Hostname: debian 2025-09-21 19:48:54.066013 | debian-bookworm | Username: zuul 2025-09-21 19:48:54.066033 | debian-bookworm | Distro: Debian 12.12 2025-09-21 19:48:54.066057 | debian-bookworm | Provider: regiocloud-a 2025-09-21 19:48:54.066078 | debian-bookworm | Region: 2025-09-21 19:48:54.066099 | debian-bookworm | Label: debian-bookworm 2025-09-21 19:48:54.066118 | debian-bookworm | Product Name: OpenStack Nova 2025-09-21 19:48:54.066137 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6d:93c4 2025-09-21 19:48:54.086680 | 2025-09-21 19:48:54.086810 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-21 19:48:54.756723 | debian-bookworm -> localhost | changed 2025-09-21 19:48:54.764376 | 2025-09-21 19:48:54.764507 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-21 19:48:56.098738 | debian-bookworm -> localhost | changed 2025-09-21 19:48:56.107191 | 2025-09-21 19:48:56.107274 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-21 19:48:56.417626 | debian-bookworm -> localhost | ok 2025-09-21 19:48:56.422554 | 2025-09-21 19:48:56.422636 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-21 19:48:56.459172 | debian-bookworm | ok 2025-09-21 19:48:56.473015 | debian-bookworm | included: /var/lib/zuul/builds/6736397a690a43c3aa20d19b468939cd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-21 19:48:56.478497 | 2025-09-21 19:48:56.478570 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-21 19:48:57.319775 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-21 19:48:57.319934 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6736397a690a43c3aa20d19b468939cd/work/6736397a690a43c3aa20d19b468939cd_id_rsa 2025-09-21 19:48:57.319988 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6736397a690a43c3aa20d19b468939cd/work/6736397a690a43c3aa20d19b468939cd_id_rsa.pub 2025-09-21 19:48:57.320011 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-21 19:48:57.320031 | debian-bookworm -> localhost | SHA256:4gKp9g52ha/4nY3hkqpK5P1uWji4l1h0Ph4qm9k/Fqg zuul-build-sshkey 2025-09-21 19:48:57.320049 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-21 19:48:57.320073 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-21 19:48:57.320092 | debian-bookworm -> localhost | | | 2025-09-21 19:48:57.320109 | debian-bookworm -> localhost | | | 2025-09-21 19:48:57.320125 | debian-bookworm -> localhost | | | 2025-09-21 19:48:57.320141 | debian-bookworm -> localhost | | o.. | 2025-09-21 19:48:57.320157 | debian-bookworm -> localhost | | .+.+.. S | 2025-09-21 19:48:57.320179 | debian-bookworm -> localhost | |o.o++* . | 2025-09-21 19:48:57.320197 | debian-bookworm -> localhost | |.B+=*+= | 2025-09-21 19:48:57.320215 | debian-bookworm -> localhost | |+EX*B*= | 2025-09-21 19:48:57.320232 | debian-bookworm -> localhost | |=BBBBO.. | 2025-09-21 19:48:57.320249 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-21 19:48:57.320292 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.338899 2025-09-21 19:48:57.325298 | 2025-09-21 19:48:57.325367 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-21 19:48:57.351493 | debian-bookworm | ok 2025-09-21 19:48:57.358531 | debian-bookworm | included: /var/lib/zuul/builds/6736397a690a43c3aa20d19b468939cd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-21 19:48:57.365456 | 2025-09-21 19:48:57.365520 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-21 19:48:57.377799 | debian-bookworm | skipping: Conditional result was False 2025-09-21 19:48:57.382111 | 2025-09-21 19:48:57.382177 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-21 19:48:57.981855 | debian-bookworm | changed 2025-09-21 19:48:57.986277 | 2025-09-21 19:48:57.986358 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-21 19:48:58.308685 | debian-bookworm | ok 2025-09-21 19:48:58.315076 | 2025-09-21 19:48:58.315168 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-21 19:48:58.986590 | debian-bookworm | changed 2025-09-21 19:48:59.000682 | 2025-09-21 19:48:59.000835 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-21 19:48:59.650062 | debian-bookworm | changed 2025-09-21 19:48:59.655237 | 2025-09-21 19:48:59.655321 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-21 19:48:59.678177 | debian-bookworm | skipping: Conditional result was False 2025-09-21 19:48:59.684188 | 2025-09-21 19:48:59.684283 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-21 19:49:00.072053 | debian-bookworm -> localhost | changed 2025-09-21 19:49:00.082876 | 2025-09-21 19:49:00.082981 | TASK [add-build-sshkey : Add back temp key] 2025-09-21 19:49:00.432278 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6736397a690a43c3aa20d19b468939cd/work/6736397a690a43c3aa20d19b468939cd_id_rsa (zuul-build-sshkey) 2025-09-21 19:49:00.432511 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012401 2025-09-21 19:49:00.439916 | 2025-09-21 19:49:00.440043 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-21 19:49:00.854608 | debian-bookworm | ok 2025-09-21 19:49:00.859664 | 2025-09-21 19:49:00.859766 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-21 19:49:00.891342 | debian-bookworm | skipping: Conditional result was False 2025-09-21 19:49:00.912666 | 2025-09-21 19:49:00.912789 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-21 19:49:01.297404 | debian-bookworm | ok 2025-09-21 19:49:01.313346 | 2025-09-21 19:49:01.313455 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-21 19:49:01.341499 | debian-bookworm | ok 2025-09-21 19:49:01.346246 | 2025-09-21 19:49:01.346328 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-21 19:49:01.643166 | debian-bookworm -> localhost | ok 2025-09-21 19:49:01.649256 | 2025-09-21 19:49:01.649337 | TASK [validate-host : Collect information about the host] 2025-09-21 19:49:02.749104 | debian-bookworm | ok 2025-09-21 19:49:02.763056 | 2025-09-21 19:49:02.763165 | TASK [validate-host : Sanitize hostname] 2025-09-21 19:49:02.881774 | debian-bookworm | ok 2025-09-21 19:49:02.916166 | 2025-09-21 19:49:02.916270 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-21 19:49:03.445414 | debian-bookworm -> localhost | changed 2025-09-21 19:49:03.450884 | 2025-09-21 19:49:03.450992 | TASK [validate-host : Collect information about zuul worker] 2025-09-21 19:49:03.907625 | debian-bookworm | ok 2025-09-21 19:49:03.913907 | 2025-09-21 19:49:03.914051 | TASK [validate-host : Write out all zuul information for each host] 2025-09-21 19:49:04.381430 | debian-bookworm -> localhost | changed 2025-09-21 19:49:04.390560 | 2025-09-21 19:49:04.390649 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-21 19:49:04.671340 | debian-bookworm | ok 2025-09-21 19:49:04.676471 | 2025-09-21 19:49:04.676553 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-21 19:49:05.646250 | debian-bookworm | changed: 2025-09-21 19:49:05.646408 | debian-bookworm | cd+++++++++ src/ 2025-09-21 19:49:05.646442 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-21 19:49:05.646467 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-21 19:49:05.646489 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-09-21 19:49:05.646509 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006478 2025-09-21 19:49:30.281366 | 2025-09-21 19:49:30.281485 | TASK [upload-logs : Upload logs to log server] 2025-09-21 19:49:30.827195 | localhost | Output suppressed because no_log was given 2025-09-21 19:49:30.829620 | 2025-09-21 19:49:30.829741 | LOOP [upload-logs : Compress console log and json output] 2025-09-21 19:49:30.879132 | localhost | skipping: Conditional result was False 2025-09-21 19:49:30.887260 | localhost | skipping: Conditional result was False 2025-09-21 19:49:30.899661 | 2025-09-21 19:49:30.899866 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-21 19:49:30.945830 | localhost | skipping: Conditional result was False 2025-09-21 19:49:30.946171 | 2025-09-21 19:49:30.953066 | localhost | skipping: Conditional result was False 2025-09-21 19:49:30.962630 | 2025-09-21 19:49:30.962927 | LOOP [upload-logs : Upload console log and json output]