2025-11-11 02:15:37.279784 | Job console starting 2025-11-11 02:15:37.327279 | Updating git repos 2025-11-11 02:15:37.369984 | Cloning repos into workspace 2025-11-11 02:15:37.409787 | Restoring repo states 2025-11-11 02:15:37.419051 | Merging changes 2025-11-11 02:15:37.991158 | Checking out repos 2025-11-11 02:15:38.090556 | Preparing playbooks 2025-11-11 02:15:39.479336 | Running Ansible setup 2025-11-11 02:15:45.819345 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-11 02:15:47.225743 | 2025-11-11 02:15:47.225848 | PLAY [Base pre] 2025-11-11 02:15:47.255461 | 2025-11-11 02:15:47.255579 | TASK [Setup log path fact] 2025-11-11 02:15:47.302454 | debian-bookworm | ok 2025-11-11 02:15:47.335179 | 2025-11-11 02:15:47.335294 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-11 02:15:47.376860 | debian-bookworm | ok 2025-11-11 02:15:47.391814 | 2025-11-11 02:15:47.391907 | TASK [emit-job-header : Print job information] 2025-11-11 02:15:47.428708 | # Job Information 2025-11-11 02:15:47.428836 | Ansible Version: 2.16.14 2025-11-11 02:15:47.428864 | Job: python-black 2025-11-11 02:15:47.428892 | Pipeline: check 2025-11-11 02:15:47.428911 | Executor: 521e9411259a 2025-11-11 02:15:47.428928 | Triggered by: https://github.com/osism/testbed/pull/2777 2025-11-11 02:15:47.428946 | Event ID: 4a1f13b0-bea4-11f0-8e43-23f6233a5194 2025-11-11 02:15:47.432879 | 2025-11-11 02:15:47.432952 | LOOP [emit-job-header : Print node information] 2025-11-11 02:15:47.565966 | debian-bookworm | ok: 2025-11-11 02:15:47.566151 | debian-bookworm | # Node Information 2025-11-11 02:15:47.566180 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-11 02:15:47.566201 | debian-bookworm | Hostname: debian 2025-11-11 02:15:47.566218 | debian-bookworm | Username: zuul 2025-11-11 02:15:47.566235 | debian-bookworm | Distro: Debian 12.12 2025-11-11 02:15:47.566254 | debian-bookworm | Provider: regiocloud-a 2025-11-11 02:15:47.566271 | debian-bookworm | Region: 2025-11-11 02:15:47.566288 | debian-bookworm | Label: debian-bookworm 2025-11-11 02:15:47.566304 | debian-bookworm | Product Name: OpenStack Nova 2025-11-11 02:15:47.566320 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2e:e17 2025-11-11 02:15:47.581480 | 2025-11-11 02:15:47.588639 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-11 02:15:48.319349 | debian-bookworm -> localhost | changed 2025-11-11 02:15:48.325048 | 2025-11-11 02:15:48.325137 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-11 02:15:50.563460 | debian-bookworm -> localhost | changed 2025-11-11 02:15:50.572514 | 2025-11-11 02:15:50.572612 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-11 02:15:51.034946 | debian-bookworm -> localhost | ok 2025-11-11 02:15:51.040096 | 2025-11-11 02:15:51.040186 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-11 02:15:51.087654 | debian-bookworm | ok 2025-11-11 02:15:51.121115 | debian-bookworm | included: /var/lib/zuul/builds/1bf2bc872f99462197ac105372299596/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-11 02:15:51.126141 | 2025-11-11 02:15:51.126223 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-11 02:15:53.660548 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-11 02:15:53.660735 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1bf2bc872f99462197ac105372299596/work/1bf2bc872f99462197ac105372299596_id_rsa 2025-11-11 02:15:53.660770 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1bf2bc872f99462197ac105372299596/work/1bf2bc872f99462197ac105372299596_id_rsa.pub 2025-11-11 02:15:53.660794 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-11 02:15:53.660816 | debian-bookworm -> localhost | SHA256:ddqEbXhqHWw48a5ho71B1QTQbP9unognK5d4TiMiR5M zuul-build-sshkey 2025-11-11 02:15:53.660836 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-11 02:15:53.660863 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-11 02:15:53.660883 | debian-bookworm -> localhost | | o+... | 2025-11-11 02:15:53.660903 | debian-bookworm -> localhost | | O+o | 2025-11-11 02:15:53.660921 | debian-bookworm -> localhost | | *.%.. | 2025-11-11 02:15:53.660939 | debian-bookworm -> localhost | | .. # .. | 2025-11-11 02:15:53.660957 | debian-bookworm -> localhost | | ES O + . | 2025-11-11 02:15:53.660978 | debian-bookworm -> localhost | | . .* + .| 2025-11-11 02:15:53.660997 | debian-bookworm -> localhost | | . o..=o. . | 2025-11-11 02:15:53.661015 | debian-bookworm -> localhost | | o .ooBo.. +| 2025-11-11 02:15:53.661033 | debian-bookworm -> localhost | | *++. +.| 2025-11-11 02:15:53.661049 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-11 02:15:53.661093 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.428156 2025-11-11 02:15:53.666713 | 2025-11-11 02:15:53.666789 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-11 02:15:53.714168 | debian-bookworm | ok 2025-11-11 02:15:53.721849 | debian-bookworm | included: /var/lib/zuul/builds/1bf2bc872f99462197ac105372299596/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-11 02:15:53.736583 | 2025-11-11 02:15:53.736670 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-11 02:15:53.749327 | debian-bookworm | skipping: Conditional result was False 2025-11-11 02:15:53.754014 | 2025-11-11 02:15:53.754093 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-11 02:15:54.539997 | debian-bookworm | changed 2025-11-11 02:15:54.545176 | 2025-11-11 02:15:54.545256 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-11 02:15:54.830961 | debian-bookworm | ok 2025-11-11 02:15:54.835269 | 2025-11-11 02:15:54.835343 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-11 02:15:55.602283 | debian-bookworm | changed 2025-11-11 02:15:55.607956 | 2025-11-11 02:15:55.608043 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-11 02:15:56.351498 | debian-bookworm | changed 2025-11-11 02:15:56.359657 | 2025-11-11 02:15:56.359749 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-11 02:15:56.463272 | debian-bookworm | skipping: Conditional result was False 2025-11-11 02:15:56.469132 | 2025-11-11 02:15:56.469219 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-11 02:15:57.391641 | debian-bookworm -> localhost | changed 2025-11-11 02:15:57.402950 | 2025-11-11 02:15:57.403054 | TASK [add-build-sshkey : Add back temp key] 2025-11-11 02:15:58.216671 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1bf2bc872f99462197ac105372299596/work/1bf2bc872f99462197ac105372299596_id_rsa (zuul-build-sshkey) 2025-11-11 02:15:58.216853 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022977 2025-11-11 02:15:58.223050 | 2025-11-11 02:15:58.223134 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-11 02:15:58.703690 | debian-bookworm | ok 2025-11-11 02:15:58.707738 | 2025-11-11 02:15:58.707815 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-11 02:15:58.731133 | debian-bookworm | skipping: Conditional result was False 2025-11-11 02:15:58.739548 | 2025-11-11 02:15:58.739648 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-11 02:15:59.174725 | debian-bookworm | ok 2025-11-11 02:15:59.196488 | 2025-11-11 02:15:59.196624 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-11 02:15:59.263735 | debian-bookworm | ok 2025-11-11 02:15:59.267766 | 2025-11-11 02:15:59.267847 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-11 02:16:00.086683 | debian-bookworm -> localhost | ok 2025-11-11 02:16:00.092966 | 2025-11-11 02:16:00.093045 | TASK [validate-host : Collect information about the host] 2025-11-11 02:16:01.389365 | debian-bookworm | ok 2025-11-11 02:16:01.402612 | 2025-11-11 02:16:01.402698 | TASK [validate-host : Sanitize hostname] 2025-11-11 02:16:01.471576 | debian-bookworm | ok 2025-11-11 02:16:01.523075 | 2025-11-11 02:16:01.523181 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-11 02:16:02.318975 | debian-bookworm -> localhost | changed 2025-11-11 02:16:02.324503 | 2025-11-11 02:16:02.324621 | TASK [validate-host : Collect information about zuul worker] 2025-11-11 02:16:02.802760 | debian-bookworm | ok 2025-11-11 02:16:02.806699 | 2025-11-11 02:16:02.806775 | TASK [validate-host : Write out all zuul information for each host] 2025-11-11 02:16:03.580876 | debian-bookworm -> localhost | changed 2025-11-11 02:16:03.588426 | 2025-11-11 02:16:03.588515 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-11 02:16:03.878057 | debian-bookworm | ok 2025-11-11 02:16:03.883687 | 2025-11-11 02:16:03.883771 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-11 02:16:04.985427 | debian-bookworm | changed: 2025-11-11 02:16:04.985676 | debian-bookworm | cd+++++++++ src/ 2025-11-11 02:16:04.985760 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-11 02:16:04.985798 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-11 02:16:04.985829 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-11-11 02:16:04.985858 | debian-bookworm | localhost | ok: Runtime: 0:00:00.023240 2025-11-11 02:16:30.970175 | 2025-11-11 02:16:30.970274 | TASK [upload-logs : Upload logs to log server] 2025-11-11 02:16:31.644428 | localhost | Output suppressed because no_log was given 2025-11-11 02:16:31.646552 | 2025-11-11 02:16:31.646694 | LOOP [upload-logs : Compress console log and json output] 2025-11-11 02:16:31.691449 | localhost | skipping: Conditional result was False 2025-11-11 02:16:31.697252 | localhost | skipping: Conditional result was False 2025-11-11 02:16:31.706330 | 2025-11-11 02:16:31.706410 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-11 02:16:31.739166 | localhost | skipping: Conditional result was False 2025-11-11 02:16:31.739347 | 2025-11-11 02:16:31.762225 | localhost | skipping: Conditional result was False 2025-11-11 02:16:31.772781 | 2025-11-11 02:16:31.772870 | LOOP [upload-logs : Upload console log and json output]