2025-05-16 03:01:28.079957 | Job console starting 2025-05-16 03:01:28.093991 | Updating git repos 2025-05-16 03:01:28.393228 | Cloning repos into workspace 2025-05-16 03:01:28.470233 | Restoring repo states 2025-05-16 03:01:28.506720 | Merging changes 2025-05-16 03:01:28.506742 | Checking out repos 2025-05-16 03:01:28.682621 | Preparing playbooks 2025-05-16 03:01:29.539689 | Running Ansible setup 2025-05-16 03:01:35.449104 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-16 03:01:36.642599 | 2025-05-16 03:01:36.642722 | PLAY [Base pre] 2025-05-16 03:01:36.669293 | 2025-05-16 03:01:36.669415 | TASK [Setup log path fact] 2025-05-16 03:01:36.697532 | debian-bookworm | ok 2025-05-16 03:01:36.721860 | 2025-05-16 03:01:36.721992 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-16 03:01:36.770749 | debian-bookworm | ok 2025-05-16 03:01:36.779966 | 2025-05-16 03:01:36.780066 | TASK [emit-job-header : Print job information] 2025-05-16 03:01:36.848109 | # Job Information 2025-05-16 03:01:36.848279 | Ansible Version: 2.16.14 2025-05-16 03:01:36.848314 | Job: python-black 2025-05-16 03:01:36.848346 | Pipeline: periodic-daily 2025-05-16 03:01:36.848369 | Executor: 521e9411259a 2025-05-16 03:01:36.848389 | Triggered by: https://github.com/osism/ansible-collection-services 2025-05-16 03:01:36.848411 | Event ID: 4005a957a11d4cfcb490736a28498158 2025-05-16 03:01:36.853180 | 2025-05-16 03:01:36.853282 | LOOP [emit-job-header : Print node information] 2025-05-16 03:01:36.983643 | debian-bookworm | ok: 2025-05-16 03:01:36.983895 | debian-bookworm | # Node Information 2025-05-16 03:01:36.983935 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-16 03:01:36.983961 | debian-bookworm | Hostname: debian 2025-05-16 03:01:36.983984 | debian-bookworm | Username: zuul 2025-05-16 03:01:36.984005 | debian-bookworm | Distro: Debian 12.10 2025-05-16 03:01:36.984029 | debian-bookworm | Provider: regiocloud-a 2025-05-16 03:01:36.984050 | debian-bookworm | Region: 2025-05-16 03:01:36.984071 | debian-bookworm | Label: debian-bookworm 2025-05-16 03:01:36.984091 | debian-bookworm | Product Name: OpenStack Nova 2025-05-16 03:01:36.984110 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0d:1931 2025-05-16 03:01:36.998753 | 2025-05-16 03:01:36.998890 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-16 03:01:37.522710 | debian-bookworm -> localhost | changed 2025-05-16 03:01:37.529878 | 2025-05-16 03:01:37.529985 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-16 03:01:38.597486 | debian-bookworm -> localhost | changed 2025-05-16 03:01:38.608298 | 2025-05-16 03:01:38.608453 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-16 03:01:38.905116 | debian-bookworm -> localhost | ok 2025-05-16 03:01:38.913421 | 2025-05-16 03:01:38.913520 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-16 03:01:38.933082 | debian-bookworm | ok 2025-05-16 03:01:38.951354 | debian-bookworm | included: /var/lib/zuul/builds/16a6cd18e28c4af1a8984f8e35e43f2d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-16 03:01:38.957416 | 2025-05-16 03:01:38.957500 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-16 03:01:40.061829 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-16 03:01:40.062214 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/16a6cd18e28c4af1a8984f8e35e43f2d/work/16a6cd18e28c4af1a8984f8e35e43f2d_id_rsa 2025-05-16 03:01:40.062336 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/16a6cd18e28c4af1a8984f8e35e43f2d/work/16a6cd18e28c4af1a8984f8e35e43f2d_id_rsa.pub 2025-05-16 03:01:40.062439 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-16 03:01:40.062513 | debian-bookworm -> localhost | SHA256:ARmQwDCkWiOZxk1FU3RTUHusQhVVr83TXmg0UP7JeRI zuul-build-sshkey 2025-05-16 03:01:40.062595 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-16 03:01:40.062670 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-16 03:01:40.062767 | debian-bookworm -> localhost | |++.o+*== ++=+oo. | 2025-05-16 03:01:40.062795 | debian-bookworm -> localhost | |o++ . o.. o oo .| 2025-05-16 03:01:40.062893 | debian-bookworm -> localhost | |=oo. .. . oE .| 2025-05-16 03:01:40.062990 | debian-bookworm -> localhost | |oo . .. o..O+| 2025-05-16 03:01:40.063071 | debian-bookworm -> localhost | |. S. . ==B| 2025-05-16 03:01:40.063099 | debian-bookworm -> localhost | | . . o+| 2025-05-16 03:01:40.063154 | debian-bookworm -> localhost | | .| 2025-05-16 03:01:40.063177 | debian-bookworm -> localhost | | | 2025-05-16 03:01:40.063200 | debian-bookworm -> localhost | | | 2025-05-16 03:01:40.063222 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-16 03:01:40.063291 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.639502 2025-05-16 03:01:40.073238 | 2025-05-16 03:01:40.073455 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-16 03:01:40.122574 | debian-bookworm | ok 2025-05-16 03:01:40.135553 | debian-bookworm | included: /var/lib/zuul/builds/16a6cd18e28c4af1a8984f8e35e43f2d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-16 03:01:40.147252 | 2025-05-16 03:01:40.147496 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-16 03:01:40.173064 | debian-bookworm | skipping: Conditional result was False 2025-05-16 03:01:40.181323 | 2025-05-16 03:01:40.181470 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-16 03:01:40.887353 | debian-bookworm | changed 2025-05-16 03:01:40.895542 | 2025-05-16 03:01:40.895667 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-16 03:01:41.161245 | debian-bookworm | ok 2025-05-16 03:01:41.168443 | 2025-05-16 03:01:41.168574 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-16 03:01:41.928482 | debian-bookworm | changed 2025-05-16 03:01:41.946322 | 2025-05-16 03:01:41.946458 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-16 03:01:42.681584 | debian-bookworm | changed 2025-05-16 03:01:42.689373 | 2025-05-16 03:01:42.689512 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-16 03:01:42.723963 | debian-bookworm | skipping: Conditional result was False 2025-05-16 03:01:42.736648 | 2025-05-16 03:01:42.736855 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-16 03:01:43.247965 | debian-bookworm -> localhost | changed 2025-05-16 03:01:43.259912 | 2025-05-16 03:01:43.260047 | TASK [add-build-sshkey : Add back temp key] 2025-05-16 03:01:43.629370 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/16a6cd18e28c4af1a8984f8e35e43f2d/work/16a6cd18e28c4af1a8984f8e35e43f2d_id_rsa (zuul-build-sshkey) 2025-05-16 03:01:43.629622 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020939 2025-05-16 03:01:43.637985 | 2025-05-16 03:01:43.638103 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-16 03:01:44.281585 | debian-bookworm | ok 2025-05-16 03:01:44.289059 | 2025-05-16 03:01:44.289206 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-16 03:01:44.324112 | debian-bookworm | skipping: Conditional result was False 2025-05-16 03:01:44.346319 | 2025-05-16 03:01:44.346578 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-16 03:01:44.791441 | debian-bookworm | ok 2025-05-16 03:01:44.807033 | 2025-05-16 03:01:44.807168 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-16 03:01:44.842770 | debian-bookworm | ok 2025-05-16 03:01:44.850600 | 2025-05-16 03:01:44.850754 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-16 03:01:45.212480 | debian-bookworm -> localhost | ok 2025-05-16 03:01:45.219153 | 2025-05-16 03:01:45.219273 | TASK [validate-host : Collect information about the host] 2025-05-16 03:01:46.544775 | debian-bookworm | ok 2025-05-16 03:01:46.560260 | 2025-05-16 03:01:46.560394 | TASK [validate-host : Sanitize hostname] 2025-05-16 03:01:46.700243 | debian-bookworm | ok 2025-05-16 03:01:46.796402 | 2025-05-16 03:01:46.796545 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-16 03:01:47.656050 | debian-bookworm -> localhost | changed 2025-05-16 03:01:47.663443 | 2025-05-16 03:01:47.663586 | TASK [validate-host : Collect information about zuul worker] 2025-05-16 03:01:48.191029 | debian-bookworm | ok 2025-05-16 03:01:48.197377 | 2025-05-16 03:01:48.197646 | TASK [validate-host : Write out all zuul information for each host] 2025-05-16 03:01:48.934624 | debian-bookworm -> localhost | changed 2025-05-16 03:01:48.944724 | 2025-05-16 03:01:48.944898 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-16 03:01:49.216970 | debian-bookworm | ok 2025-05-16 03:01:49.224151 | 2025-05-16 03:01:49.224274 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-16 03:01:50.477272 | debian-bookworm | changed: 2025-05-16 03:01:50.477933 | debian-bookworm | cd+++++++++ src/ 2025-05-16 03:01:50.478020 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-16 03:01:50.478058 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-16 03:01:50.478090 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-05-16 03:01:50.478119 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006688 2025-05-16 03:02:17.786172 | 2025-05-16 03:02:17.786293 | TASK [upload-logs : Upload logs to log server] 2025-05-16 03:02:18.421170 | localhost | Output suppressed because no_log was given 2025-05-16 03:02:18.423005 | 2025-05-16 03:02:18.423112 | LOOP [upload-logs : Compress console log and json output] 2025-05-16 03:02:18.477271 | localhost | skipping: Conditional result was False 2025-05-16 03:02:18.485448 | localhost | skipping: Conditional result was False 2025-05-16 03:02:18.503691 | 2025-05-16 03:02:18.503847 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-16 03:02:18.602557 | localhost | skipping: Conditional result was False 2025-05-16 03:02:18.602931 | 2025-05-16 03:02:18.614175 | localhost | skipping: Conditional result was False 2025-05-16 03:02:18.631320 | 2025-05-16 03:02:18.631455 | LOOP [upload-logs : Upload console log and json output]