2025-05-30 06:59:47.253454 | Job console starting 2025-05-30 06:59:47.294892 | Updating git repos 2025-05-30 06:59:47.381945 | Cloning repos into workspace 2025-05-30 06:59:47.452015 | Restoring repo states 2025-05-30 06:59:47.494864 | Merging changes 2025-05-30 06:59:48.129948 | Checking out repos 2025-05-30 06:59:48.251936 | Preparing playbooks 2025-05-30 06:59:49.260859 | Running Ansible setup 2025-05-30 06:59:54.976372 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-30 06:59:56.230879 | 2025-05-30 06:59:56.231060 | PLAY [Base pre] 2025-05-30 06:59:56.261825 | 2025-05-30 06:59:56.261990 | TASK [Setup log path fact] 2025-05-30 06:59:56.281779 | debian-bookworm | ok 2025-05-30 06:59:56.298264 | 2025-05-30 06:59:56.298425 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-30 06:59:56.339480 | debian-bookworm | ok 2025-05-30 06:59:56.352847 | 2025-05-30 06:59:56.352999 | TASK [emit-job-header : Print job information] 2025-05-30 06:59:56.392375 | # Job Information 2025-05-30 06:59:56.392570 | Ansible Version: 2.16.14 2025-05-30 06:59:56.392605 | Job: python-black 2025-05-30 06:59:56.392637 | Pipeline: check 2025-05-30 06:59:56.392660 | Executor: 521e9411259a 2025-05-30 06:59:56.392680 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1878 2025-05-30 06:59:56.392704 | Event ID: a6dbae90-3d23-11f0-88dd-0cc39f555c28 2025-05-30 06:59:56.400168 | 2025-05-30 06:59:56.400304 | LOOP [emit-job-header : Print node information] 2025-05-30 06:59:56.524251 | debian-bookworm | ok: 2025-05-30 06:59:56.524453 | debian-bookworm | # Node Information 2025-05-30 06:59:56.524488 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-30 06:59:56.524514 | debian-bookworm | Hostname: debian 2025-05-30 06:59:56.524537 | debian-bookworm | Username: zuul 2025-05-30 06:59:56.524559 | debian-bookworm | Distro: Debian 12.11 2025-05-30 06:59:56.524582 | debian-bookworm | Provider: regiocloud-a 2025-05-30 06:59:56.524604 | debian-bookworm | Region: 2025-05-30 06:59:56.524625 | debian-bookworm | Label: debian-bookworm 2025-05-30 06:59:56.524646 | debian-bookworm | Product Name: OpenStack Nova 2025-05-30 06:59:56.524665 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe35:4403 2025-05-30 06:59:56.563845 | 2025-05-30 06:59:56.564067 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-30 06:59:57.354373 | debian-bookworm -> localhost | changed 2025-05-30 06:59:57.361982 | 2025-05-30 06:59:57.362115 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-30 06:59:59.018624 | debian-bookworm -> localhost | changed 2025-05-30 06:59:59.038166 | 2025-05-30 06:59:59.038316 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-30 06:59:59.602174 | debian-bookworm -> localhost | ok 2025-05-30 06:59:59.608032 | 2025-05-30 06:59:59.608150 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-30 06:59:59.655737 | debian-bookworm | ok 2025-05-30 06:59:59.682173 | debian-bookworm | included: /var/lib/zuul/builds/984e297a8fd8406fa63a1ae658ae90b3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-30 06:59:59.693756 | 2025-05-30 06:59:59.693856 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-30 07:00:01.885797 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-30 07:00:01.885995 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/984e297a8fd8406fa63a1ae658ae90b3/work/984e297a8fd8406fa63a1ae658ae90b3_id_rsa 2025-05-30 07:00:01.886034 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/984e297a8fd8406fa63a1ae658ae90b3/work/984e297a8fd8406fa63a1ae658ae90b3_id_rsa.pub 2025-05-30 07:00:01.886061 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-30 07:00:01.886085 | debian-bookworm -> localhost | SHA256:iYf5IDZsGVnxBIQil9WuCwpJLyg1RgQ9FYj3TGKd/7M zuul-build-sshkey 2025-05-30 07:00:01.886107 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-30 07:00:01.886168 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-30 07:00:01.886194 | debian-bookworm -> localhost | |.=.*+*=o. | 2025-05-30 07:00:01.886216 | debian-bookworm -> localhost | |o % =o.o | 2025-05-30 07:00:01.886238 | debian-bookworm -> localhost | | * Boo . | 2025-05-30 07:00:01.886258 | debian-bookworm -> localhost | | .+.ooo+ . | 2025-05-30 07:00:01.886279 | debian-bookworm -> localhost | |o+..B.=.S | 2025-05-30 07:00:01.886304 | debian-bookworm -> localhost | |=..+.o +o | 2025-05-30 07:00:01.886325 | debian-bookworm -> localhost | |o... . .o | 2025-05-30 07:00:01.886346 | debian-bookworm -> localhost | |. . E | 2025-05-30 07:00:01.886367 | debian-bookworm -> localhost | | | 2025-05-30 07:00:01.886388 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-30 07:00:01.886434 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.730617 2025-05-30 07:00:01.893089 | 2025-05-30 07:00:01.893197 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-30 07:00:01.911686 | debian-bookworm | ok 2025-05-30 07:00:01.923397 | debian-bookworm | included: /var/lib/zuul/builds/984e297a8fd8406fa63a1ae658ae90b3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-30 07:00:01.937157 | 2025-05-30 07:00:01.937250 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-30 07:00:01.950448 | debian-bookworm | skipping: Conditional result was False 2025-05-30 07:00:01.956174 | 2025-05-30 07:00:01.956271 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-30 07:00:02.648931 | debian-bookworm | changed 2025-05-30 07:00:02.656991 | 2025-05-30 07:00:02.657239 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-30 07:00:02.943224 | debian-bookworm | ok 2025-05-30 07:00:02.951464 | 2025-05-30 07:00:02.951559 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-30 07:00:03.639377 | debian-bookworm | changed 2025-05-30 07:00:03.645850 | 2025-05-30 07:00:03.645962 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-30 07:00:04.334524 | debian-bookworm | changed 2025-05-30 07:00:04.339901 | 2025-05-30 07:00:04.340003 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-30 07:00:04.362816 | debian-bookworm | skipping: Conditional result was False 2025-05-30 07:00:04.368543 | 2025-05-30 07:00:04.368636 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-30 07:00:04.903245 | debian-bookworm -> localhost | changed 2025-05-30 07:00:04.914305 | 2025-05-30 07:00:04.914408 | TASK [add-build-sshkey : Add back temp key] 2025-05-30 07:00:05.223276 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/984e297a8fd8406fa63a1ae658ae90b3/work/984e297a8fd8406fa63a1ae658ae90b3_id_rsa (zuul-build-sshkey) 2025-05-30 07:00:05.223493 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008944 2025-05-30 07:00:05.232489 | 2025-05-30 07:00:05.232594 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-30 07:00:05.626485 | debian-bookworm | ok 2025-05-30 07:00:05.631496 | 2025-05-30 07:00:05.631586 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-30 07:00:05.664984 | debian-bookworm | skipping: Conditional result was False 2025-05-30 07:00:05.675143 | 2025-05-30 07:00:05.675243 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-30 07:00:06.100927 | debian-bookworm | ok 2025-05-30 07:00:06.116011 | 2025-05-30 07:00:06.116120 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-30 07:00:06.145476 | debian-bookworm | ok 2025-05-30 07:00:06.152752 | 2025-05-30 07:00:06.152885 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-30 07:00:06.504587 | debian-bookworm -> localhost | ok 2025-05-30 07:00:06.518117 | 2025-05-30 07:00:06.518274 | TASK [validate-host : Collect information about the host] 2025-05-30 07:00:07.671691 | debian-bookworm | ok 2025-05-30 07:00:07.691281 | 2025-05-30 07:00:07.691420 | TASK [validate-host : Sanitize hostname] 2025-05-30 07:00:07.819798 | debian-bookworm | ok 2025-05-30 07:00:07.869272 | 2025-05-30 07:00:07.869424 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-30 07:00:08.668036 | debian-bookworm -> localhost | changed 2025-05-30 07:00:08.677302 | 2025-05-30 07:00:08.677469 | TASK [validate-host : Collect information about zuul worker] 2025-05-30 07:00:09.143218 | debian-bookworm | ok 2025-05-30 07:00:09.148253 | 2025-05-30 07:00:09.148376 | TASK [validate-host : Write out all zuul information for each host] 2025-05-30 07:00:10.191409 | debian-bookworm -> localhost | changed 2025-05-30 07:00:10.202381 | 2025-05-30 07:00:10.202515 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-30 07:00:10.495441 | debian-bookworm | ok 2025-05-30 07:00:10.502640 | 2025-05-30 07:00:10.502754 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-30 07:00:11.829980 | debian-bookworm | changed: 2025-05-30 07:00:11.830234 | debian-bookworm | cd+++++++++ src/ 2025-05-30 07:00:11.830274 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-30 07:00:11.830302 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-30 07:00:11.830326 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-05-30 07:00:11.830349 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008907 2025-05-30 07:00:39.616407 | 2025-05-30 07:00:39.616527 | TASK [upload-logs : Upload logs to log server] 2025-05-30 07:00:40.209015 | localhost | Output suppressed because no_log was given 2025-05-30 07:00:40.214689 | 2025-05-30 07:00:40.214977 | LOOP [upload-logs : Compress console log and json output] 2025-05-30 07:00:40.275296 | localhost | skipping: Conditional result was False 2025-05-30 07:00:40.283682 | localhost | skipping: Conditional result was False 2025-05-30 07:00:40.288793 | 2025-05-30 07:00:40.288920 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-30 07:00:40.358752 | localhost | skipping: Conditional result was False 2025-05-30 07:00:40.359129 | 2025-05-30 07:00:40.366110 | localhost | skipping: Conditional result was False 2025-05-30 07:00:40.383461 | 2025-05-30 07:00:40.383652 | LOOP [upload-logs : Upload console log and json output]