2026-03-23 03:08:41.811466 | Job console starting 2026-03-23 03:08:41.822030 | Updating git repos 2026-03-23 03:08:41.853054 | Cloning repos into workspace 2026-03-23 03:08:41.928162 | Restoring repo states 2026-03-23 03:08:41.937736 | Merging changes 2026-03-23 03:08:41.937761 | Checking out repos 2026-03-23 03:08:41.997956 | Preparing playbooks 2026-03-23 03:08:43.324940 | Running Ansible setup 2026-03-23 03:08:49.241969 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-23 03:08:49.983317 | 2026-03-23 03:08:49.983429 | PLAY [Base pre] 2026-03-23 03:08:49.996907 | 2026-03-23 03:08:49.997009 | TASK [Setup log path fact] 2026-03-23 03:08:50.025926 | debian-bookworm | ok 2026-03-23 03:08:50.039356 | 2026-03-23 03:08:50.039473 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-23 03:08:50.066904 | debian-bookworm | ok 2026-03-23 03:08:50.075571 | 2026-03-23 03:08:50.075668 | TASK [emit-job-header : Print job information] 2026-03-23 03:08:50.103823 | # Job Information 2026-03-23 03:08:50.104059 | Ansible Version: 2.16.14 2026-03-23 03:08:50.104100 | Job: python-black 2026-03-23 03:08:50.104129 | Pipeline: periodic-daily 2026-03-23 03:08:50.104147 | Executor: 521e9411259a 2026-03-23 03:08:50.104164 | Triggered by: https://github.com/osism/testbed 2026-03-23 03:08:50.104182 | Event ID: 334a025b45c342fa9e399306a8069677 2026-03-23 03:08:50.108424 | 2026-03-23 03:08:50.108518 | LOOP [emit-job-header : Print node information] 2026-03-23 03:08:50.201816 | debian-bookworm | ok: 2026-03-23 03:08:50.202014 | debian-bookworm | # Node Information 2026-03-23 03:08:50.202045 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-23 03:08:50.202067 | debian-bookworm | Hostname: debian 2026-03-23 03:08:50.202085 | debian-bookworm | Username: zuul 2026-03-23 03:08:50.202102 | debian-bookworm | Distro: Debian 12.13 2026-03-23 03:08:50.202121 | debian-bookworm | Provider: regiocloud-a 2026-03-23 03:08:50.202138 | debian-bookworm | Region: 2026-03-23 03:08:50.202155 | debian-bookworm | Label: debian-bookworm 2026-03-23 03:08:50.202171 | debian-bookworm | Product Name: OpenStack Nova 2026-03-23 03:08:50.202187 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe68:315e 2026-03-23 03:08:50.212543 | 2026-03-23 03:08:50.212643 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-23 03:08:50.654562 | debian-bookworm -> localhost | changed 2026-03-23 03:08:50.661155 | 2026-03-23 03:08:50.661271 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-23 03:08:52.171186 | debian-bookworm -> localhost | changed 2026-03-23 03:08:52.180340 | 2026-03-23 03:08:52.180464 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-23 03:08:52.604556 | debian-bookworm -> localhost | ok 2026-03-23 03:08:52.609472 | 2026-03-23 03:08:52.609559 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-23 03:08:52.646483 | debian-bookworm | ok 2026-03-23 03:08:52.669360 | debian-bookworm | included: /var/lib/zuul/builds/367338c0b2894ea3a8f8d96817e55c04/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-23 03:08:52.675320 | 2026-03-23 03:08:52.675410 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-23 03:08:53.818042 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-23 03:08:53.818253 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/367338c0b2894ea3a8f8d96817e55c04/work/367338c0b2894ea3a8f8d96817e55c04_id_rsa 2026-03-23 03:08:53.818293 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/367338c0b2894ea3a8f8d96817e55c04/work/367338c0b2894ea3a8f8d96817e55c04_id_rsa.pub 2026-03-23 03:08:53.818320 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-23 03:08:53.818344 | debian-bookworm -> localhost | SHA256:i4Y5E4u8TxhHy3sNHwAhLf/pkcjG6lRxgvRayld3RXE zuul-build-sshkey 2026-03-23 03:08:53.818366 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-23 03:08:53.818398 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-23 03:08:53.818420 | debian-bookworm -> localhost | | o.o. .+.E | 2026-03-23 03:08:53.818442 | debian-bookworm -> localhost | | ..+.. . . | 2026-03-23 03:08:53.818462 | debian-bookworm -> localhost | | .o* + . . | 2026-03-23 03:08:53.818482 | debian-bookworm -> localhost | | . *.* o . | 2026-03-23 03:08:53.818501 | debian-bookworm -> localhost | | =oBo.oS | 2026-03-23 03:08:53.818527 | debian-bookworm -> localhost | | . B=*== o | 2026-03-23 03:08:53.818549 | debian-bookworm -> localhost | | =oO.+.+ | 2026-03-23 03:08:53.818571 | debian-bookworm -> localhost | | ..o =. | 2026-03-23 03:08:53.818592 | debian-bookworm -> localhost | | .o.. | 2026-03-23 03:08:53.818613 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-23 03:08:53.818666 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.601440 2026-03-23 03:08:53.826024 | 2026-03-23 03:08:53.826120 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-23 03:08:53.843898 | debian-bookworm | ok 2026-03-23 03:08:53.853375 | debian-bookworm | included: /var/lib/zuul/builds/367338c0b2894ea3a8f8d96817e55c04/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-23 03:08:53.867363 | 2026-03-23 03:08:53.867474 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-23 03:08:53.881073 | debian-bookworm | skipping: Conditional result was False 2026-03-23 03:08:53.887468 | 2026-03-23 03:08:53.887557 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-23 03:08:54.626570 | debian-bookworm | changed 2026-03-23 03:08:54.633004 | 2026-03-23 03:08:54.633095 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-23 03:08:54.903702 | debian-bookworm | ok 2026-03-23 03:08:54.909154 | 2026-03-23 03:08:54.909261 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-23 03:08:55.697788 | debian-bookworm | changed 2026-03-23 03:08:55.704933 | 2026-03-23 03:08:55.705023 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-23 03:08:56.351090 | debian-bookworm | changed 2026-03-23 03:08:56.355588 | 2026-03-23 03:08:56.355671 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-23 03:08:56.388294 | debian-bookworm | skipping: Conditional result was False 2026-03-23 03:08:56.393214 | 2026-03-23 03:08:56.393324 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-23 03:08:57.045788 | debian-bookworm -> localhost | changed 2026-03-23 03:08:57.058276 | 2026-03-23 03:08:57.058386 | TASK [add-build-sshkey : Add back temp key] 2026-03-23 03:08:57.502123 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/367338c0b2894ea3a8f8d96817e55c04/work/367338c0b2894ea3a8f8d96817e55c04_id_rsa (zuul-build-sshkey) 2026-03-23 03:08:57.502347 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009244 2026-03-23 03:08:57.509718 | 2026-03-23 03:08:57.509820 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-23 03:08:57.880734 | debian-bookworm | ok 2026-03-23 03:08:57.885747 | 2026-03-23 03:08:57.885832 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-23 03:08:57.934759 | debian-bookworm | skipping: Conditional result was False 2026-03-23 03:08:57.945275 | 2026-03-23 03:08:57.945375 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-23 03:08:58.575895 | debian-bookworm | ok 2026-03-23 03:08:58.593861 | 2026-03-23 03:08:58.593955 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-23 03:08:58.645065 | debian-bookworm | ok 2026-03-23 03:08:58.650271 | 2026-03-23 03:08:58.650355 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-23 03:08:59.077704 | debian-bookworm -> localhost | ok 2026-03-23 03:08:59.083735 | 2026-03-23 03:08:59.083828 | TASK [validate-host : Collect information about the host] 2026-03-23 03:09:00.259795 | debian-bookworm | ok 2026-03-23 03:09:00.271075 | 2026-03-23 03:09:00.271167 | TASK [validate-host : Sanitize hostname] 2026-03-23 03:09:00.479991 | debian-bookworm | ok 2026-03-23 03:09:00.565665 | 2026-03-23 03:09:00.565770 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-23 03:09:01.432077 | debian-bookworm -> localhost | changed 2026-03-23 03:09:01.436781 | 2026-03-23 03:09:01.436867 | TASK [validate-host : Collect information about zuul worker] 2026-03-23 03:09:01.911266 | debian-bookworm | ok 2026-03-23 03:09:01.926040 | 2026-03-23 03:09:01.926844 | TASK [validate-host : Write out all zuul information for each host] 2026-03-23 03:09:02.817477 | debian-bookworm -> localhost | changed 2026-03-23 03:09:02.828233 | 2026-03-23 03:09:02.828354 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-23 03:09:03.160639 | debian-bookworm | ok 2026-03-23 03:09:03.166503 | 2026-03-23 03:09:03.166595 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-23 03:09:04.733708 | debian-bookworm | changed: 2026-03-23 03:09:04.733873 | debian-bookworm | cd+++++++++ src/ 2026-03-23 03:09:04.733904 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-23 03:09:04.733925 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-23 03:09:04.733945 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-03-23 03:09:04.733963 | debian-bookworm | localhost | ok: Runtime: 0:00:00.022094 2026-03-23 03:09:31.660587 | 2026-03-23 03:09:31.660710 | TASK [upload-logs : Upload logs to log server] 2026-03-23 03:09:32.752859 | localhost | Output suppressed because no_log was given 2026-03-23 03:09:32.755152 | 2026-03-23 03:09:32.755292 | LOOP [upload-logs : Compress console log and json output] 2026-03-23 03:09:32.812822 | localhost | skipping: Conditional result was False 2026-03-23 03:09:32.822648 | localhost | skipping: Conditional result was False 2026-03-23 03:09:32.832777 | 2026-03-23 03:09:32.832915 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-23 03:09:32.937435 | localhost | skipping: Conditional result was False 2026-03-23 03:09:32.937738 | 2026-03-23 03:09:32.950163 | localhost | skipping: Conditional result was False 2026-03-23 03:09:32.963178 | 2026-03-23 03:09:32.963346 | LOOP [upload-logs : Upload console log and json output]