2025-09-28 03:12:45.276459 | Job console starting 2025-09-28 03:12:45.284861 | Updating git repos 2025-09-28 03:12:45.317848 | Cloning repos into workspace 2025-09-28 03:12:45.375492 | Restoring repo states 2025-09-28 03:12:45.385136 | Merging changes 2025-09-28 03:12:45.385148 | Checking out repos 2025-09-28 03:12:45.448245 | Preparing playbooks 2025-09-28 03:12:46.302620 | Running Ansible setup 2025-09-28 03:12:52.427236 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-28 03:12:53.610201 | 2025-09-28 03:12:53.610323 | PLAY [Base pre] 2025-09-28 03:12:53.657036 | 2025-09-28 03:12:53.657161 | TASK [Setup log path fact] 2025-09-28 03:12:53.685232 | debian-bookworm | ok 2025-09-28 03:12:53.710344 | 2025-09-28 03:12:53.710463 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-28 03:12:53.759833 | debian-bookworm | ok 2025-09-28 03:12:53.777482 | 2025-09-28 03:12:53.777591 | TASK [emit-job-header : Print job information] 2025-09-28 03:12:53.834009 | # Job Information 2025-09-28 03:12:53.834173 | Ansible Version: 2.16.14 2025-09-28 03:12:53.834235 | Job: python-black 2025-09-28 03:12:53.834268 | Pipeline: periodic-daily 2025-09-28 03:12:53.834290 | Executor: 521e9411259a 2025-09-28 03:12:53.834309 | Triggered by: https://github.com/osism/testbed 2025-09-28 03:12:53.834330 | Event ID: 8dbef8b147a64adbb970dea31f43bab2 2025-09-28 03:12:53.839051 | 2025-09-28 03:12:53.839141 | LOOP [emit-job-header : Print node information] 2025-09-28 03:12:54.032049 | debian-bookworm | ok: 2025-09-28 03:12:54.032248 | debian-bookworm | # Node Information 2025-09-28 03:12:54.032282 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-28 03:12:54.032307 | debian-bookworm | Hostname: debian 2025-09-28 03:12:54.032329 | debian-bookworm | Username: zuul 2025-09-28 03:12:54.032349 | debian-bookworm | Distro: Debian 12.12 2025-09-28 03:12:54.032373 | debian-bookworm | Provider: regiocloud-a 2025-09-28 03:12:54.032393 | debian-bookworm | Region: 2025-09-28 03:12:54.032414 | debian-bookworm | Label: debian-bookworm 2025-09-28 03:12:54.032433 | debian-bookworm | Product Name: OpenStack Nova 2025-09-28 03:12:54.032454 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fead:f964 2025-09-28 03:12:54.069497 | 2025-09-28 03:12:54.069626 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-28 03:12:55.162069 | debian-bookworm -> localhost | changed 2025-09-28 03:12:55.169223 | 2025-09-28 03:12:55.169328 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-28 03:12:56.987007 | debian-bookworm -> localhost | changed 2025-09-28 03:12:56.995590 | 2025-09-28 03:12:56.995670 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-28 03:12:57.559960 | debian-bookworm -> localhost | ok 2025-09-28 03:12:57.564848 | 2025-09-28 03:12:57.564937 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-28 03:12:57.602064 | debian-bookworm | ok 2025-09-28 03:12:57.621006 | debian-bookworm | included: /var/lib/zuul/builds/a787fcb7214748c480a10f5970912990/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-28 03:12:57.639921 | 2025-09-28 03:12:57.640009 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-28 03:12:59.436061 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-28 03:12:59.436228 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a787fcb7214748c480a10f5970912990/work/a787fcb7214748c480a10f5970912990_id_rsa 2025-09-28 03:12:59.436258 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a787fcb7214748c480a10f5970912990/work/a787fcb7214748c480a10f5970912990_id_rsa.pub 2025-09-28 03:12:59.436279 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-28 03:12:59.436299 | debian-bookworm -> localhost | SHA256:9V22U3wWG0CrvMN4tYsgPD59haNzMOai/Wm74nhL9ts zuul-build-sshkey 2025-09-28 03:12:59.436318 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-28 03:12:59.436343 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-28 03:12:59.436362 | debian-bookworm -> localhost | | .o.o | 2025-09-28 03:12:59.436380 | debian-bookworm -> localhost | | ..+| 2025-09-28 03:12:59.436397 | debian-bookworm -> localhost | | . . .B| 2025-09-28 03:12:59.436413 | debian-bookworm -> localhost | | ..... ++| 2025-09-28 03:12:59.436430 | debian-bookworm -> localhost | | S oo..o | 2025-09-28 03:12:59.436452 | debian-bookworm -> localhost | | . +ooo.. .| 2025-09-28 03:12:59.436470 | debian-bookworm -> localhost | | *+o+=o. | 2025-09-28 03:12:59.436487 | debian-bookworm -> localhost | | *=+*=oo . | 2025-09-28 03:12:59.436504 | debian-bookworm -> localhost | | o+=BBBE . | 2025-09-28 03:12:59.436520 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-28 03:12:59.436560 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.954783 2025-09-28 03:12:59.441666 | 2025-09-28 03:12:59.441736 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-28 03:12:59.488372 | debian-bookworm | ok 2025-09-28 03:12:59.497031 | debian-bookworm | included: /var/lib/zuul/builds/a787fcb7214748c480a10f5970912990/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-28 03:12:59.510693 | 2025-09-28 03:12:59.510767 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-28 03:12:59.544127 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:12:59.553483 | 2025-09-28 03:12:59.553561 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-28 03:13:00.557990 | debian-bookworm | changed 2025-09-28 03:13:00.562272 | 2025-09-28 03:13:00.562343 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-28 03:13:00.856858 | debian-bookworm | ok 2025-09-28 03:13:00.867750 | 2025-09-28 03:13:00.867835 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-28 03:13:01.576723 | debian-bookworm | changed 2025-09-28 03:13:01.582327 | 2025-09-28 03:13:01.582400 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-28 03:13:02.254260 | debian-bookworm | changed 2025-09-28 03:13:02.269272 | 2025-09-28 03:13:02.269393 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-28 03:13:02.292852 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:02.301279 | 2025-09-28 03:13:02.301435 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-28 03:13:02.712937 | debian-bookworm -> localhost | changed 2025-09-28 03:13:02.723846 | 2025-09-28 03:13:02.723937 | TASK [add-build-sshkey : Add back temp key] 2025-09-28 03:13:03.115329 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a787fcb7214748c480a10f5970912990/work/a787fcb7214748c480a10f5970912990_id_rsa (zuul-build-sshkey) 2025-09-28 03:13:03.115506 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020445 2025-09-28 03:13:03.121973 | 2025-09-28 03:13:03.122051 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-28 03:13:03.525645 | debian-bookworm | ok 2025-09-28 03:13:03.530057 | 2025-09-28 03:13:03.530131 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-28 03:13:03.565034 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:03.573735 | 2025-09-28 03:13:03.573816 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-28 03:13:04.106549 | debian-bookworm | ok 2025-09-28 03:13:04.124686 | 2025-09-28 03:13:04.124783 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-28 03:13:04.171927 | debian-bookworm | ok 2025-09-28 03:13:04.175938 | 2025-09-28 03:13:04.176009 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-28 03:13:04.494775 | debian-bookworm -> localhost | ok 2025-09-28 03:13:04.500511 | 2025-09-28 03:13:04.500590 | TASK [validate-host : Collect information about the host] 2025-09-28 03:13:05.586752 | debian-bookworm | ok 2025-09-28 03:13:05.605399 | 2025-09-28 03:13:05.605505 | TASK [validate-host : Sanitize hostname] 2025-09-28 03:13:05.754980 | debian-bookworm | ok 2025-09-28 03:13:05.811796 | 2025-09-28 03:13:05.811899 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-28 03:13:06.816982 | debian-bookworm -> localhost | changed 2025-09-28 03:13:06.822471 | 2025-09-28 03:13:06.822557 | TASK [validate-host : Collect information about zuul worker] 2025-09-28 03:13:07.236700 | debian-bookworm | ok 2025-09-28 03:13:07.240647 | 2025-09-28 03:13:07.240722 | TASK [validate-host : Write out all zuul information for each host] 2025-09-28 03:13:08.034238 | debian-bookworm -> localhost | changed 2025-09-28 03:13:08.042022 | 2025-09-28 03:13:08.042131 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-28 03:13:08.324873 | debian-bookworm | ok 2025-09-28 03:13:08.329482 | 2025-09-28 03:13:08.329552 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-28 03:13:09.668533 | debian-bookworm | changed: 2025-09-28 03:13:09.668679 | debian-bookworm | cd+++++++++ src/ 2025-09-28 03:13:09.668707 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-28 03:13:09.668728 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-28 03:13:09.668745 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-09-28 03:13:09.668762 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009075 2025-09-28 03:13:36.178546 | 2025-09-28 03:13:36.178733 | TASK [upload-logs : Upload logs to log server] 2025-09-28 03:13:36.743379 | localhost | Output suppressed because no_log was given 2025-09-28 03:13:36.745005 | 2025-09-28 03:13:36.745089 | LOOP [upload-logs : Compress console log and json output] 2025-09-28 03:13:36.831137 | localhost | skipping: Conditional result was False 2025-09-28 03:13:36.836607 | localhost | skipping: Conditional result was False 2025-09-28 03:13:36.840788 | 2025-09-28 03:13:36.840890 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-28 03:13:36.902508 | localhost | skipping: Conditional result was False 2025-09-28 03:13:36.902762 | 2025-09-28 03:13:36.908457 | localhost | skipping: Conditional result was False 2025-09-28 03:13:36.916759 | 2025-09-28 03:13:36.916868 | LOOP [upload-logs : Upload console log and json output]