2025-12-04 21:58:30.158811 | Job console starting 2025-12-04 21:58:30.168782 | Updating git repos 2025-12-04 21:58:30.224145 | Cloning repos into workspace 2025-12-04 21:58:30.429743 | Restoring repo states 2025-12-04 21:58:30.485574 | Merging changes 2025-12-04 21:58:31.536199 | Checking out repos 2025-12-04 21:58:31.601626 | Preparing playbooks 2025-12-04 21:58:32.912419 | Running Ansible setup 2025-12-04 21:58:42.387416 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-04 21:58:44.022056 | 2025-12-04 21:58:44.022279 | PLAY [Base pre] 2025-12-04 21:58:44.053431 | 2025-12-04 21:58:44.053604 | TASK [Setup log path fact] 2025-12-04 21:58:44.105674 | debian-bookworm | ok 2025-12-04 21:58:44.197606 | 2025-12-04 21:58:44.199613 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-04 21:58:44.303933 | debian-bookworm | ok 2025-12-04 21:58:44.330371 | 2025-12-04 21:58:44.330518 | TASK [emit-job-header : Print job information] 2025-12-04 21:58:44.407808 | # Job Information 2025-12-04 21:58:44.408006 | Ansible Version: 2.16.14 2025-12-04 21:58:44.408044 | Job: python-black 2025-12-04 21:58:44.408079 | Pipeline: check 2025-12-04 21:58:44.408119 | Executor: 521e9411259a 2025-12-04 21:58:44.408141 | Triggered by: https://github.com/osism/python-osism/pull/1898 2025-12-04 21:58:44.408163 | Event ID: 37579b10-d15c-11f0-83cc-ab02b982f357 2025-12-04 21:58:44.413316 | 2025-12-04 21:58:44.413435 | LOOP [emit-job-header : Print node information] 2025-12-04 21:58:44.665457 | debian-bookworm | ok: 2025-12-04 21:58:44.665689 | debian-bookworm | # Node Information 2025-12-04 21:58:44.665751 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-04 21:58:44.665790 | debian-bookworm | Hostname: debian 2025-12-04 21:58:44.665827 | debian-bookworm | Username: zuul 2025-12-04 21:58:44.665857 | debian-bookworm | Distro: Debian 12.12 2025-12-04 21:58:44.665894 | debian-bookworm | Provider: regiocloud-a 2025-12-04 21:58:44.665926 | debian-bookworm | Region: 2025-12-04 21:58:44.665949 | debian-bookworm | Label: debian-bookworm 2025-12-04 21:58:44.665969 | debian-bookworm | Product Name: OpenStack Nova 2025-12-04 21:58:44.665988 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec4:5efa 2025-12-04 21:58:44.684731 | 2025-12-04 21:58:44.684881 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-04 21:58:46.349927 | debian-bookworm -> localhost | changed 2025-12-04 21:58:46.360224 | 2025-12-04 21:58:46.360368 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-04 21:58:49.310286 | debian-bookworm -> localhost | changed 2025-12-04 21:58:49.328712 | 2025-12-04 21:58:49.328863 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-04 21:58:50.716061 | debian-bookworm -> localhost | ok 2025-12-04 21:58:50.732296 | 2025-12-04 21:58:50.732471 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-04 21:58:50.847042 | debian-bookworm | ok 2025-12-04 21:58:50.993508 | debian-bookworm | included: /var/lib/zuul/builds/67790b59b074485eb10e43229d56a237/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-04 21:58:51.087387 | 2025-12-04 21:58:51.087560 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-04 21:58:54.292843 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-04 21:58:54.293035 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/67790b59b074485eb10e43229d56a237/work/67790b59b074485eb10e43229d56a237_id_rsa 2025-12-04 21:58:54.293072 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/67790b59b074485eb10e43229d56a237/work/67790b59b074485eb10e43229d56a237_id_rsa.pub 2025-12-04 21:58:54.293145 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-04 21:58:54.293179 | debian-bookworm -> localhost | SHA256:JqYCOCPSNifkLEx8t/qTIjdawSDz3sxUKkM8ObZFGmI zuul-build-sshkey 2025-12-04 21:58:54.293202 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-04 21:58:54.293235 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-04 21:58:54.293256 | debian-bookworm -> localhost | |.E. . | 2025-12-04 21:58:54.293278 | debian-bookworm -> localhost | |oo = | 2025-12-04 21:58:54.293297 | debian-bookworm -> localhost | |o+X.... | 2025-12-04 21:58:54.293317 | debian-bookworm -> localhost | |=X+=.o. | 2025-12-04 21:58:54.293336 | debian-bookworm -> localhost | |O.%o+.o S | 2025-12-04 21:58:54.293360 | debian-bookworm -> localhost | |oB @oo o | 2025-12-04 21:58:54.293380 | debian-bookworm -> localhost | | oo= . | 2025-12-04 21:58:54.293399 | debian-bookworm -> localhost | | ..=.o | 2025-12-04 21:58:54.293420 | debian-bookworm -> localhost | | .+ o.. | 2025-12-04 21:58:54.293441 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-04 21:58:54.293494 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.624897 2025-12-04 21:58:54.300048 | 2025-12-04 21:58:54.300168 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-04 21:58:54.357452 | debian-bookworm | ok 2025-12-04 21:58:54.366822 | debian-bookworm | included: /var/lib/zuul/builds/67790b59b074485eb10e43229d56a237/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-04 21:58:54.405245 | 2025-12-04 21:58:54.405356 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-04 21:58:54.448809 | debian-bookworm | skipping: Conditional result was False 2025-12-04 21:58:54.459343 | 2025-12-04 21:58:54.459490 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-04 21:58:55.916007 | debian-bookworm | changed 2025-12-04 21:58:55.921285 | 2025-12-04 21:58:55.921378 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-04 21:58:56.328009 | debian-bookworm | ok 2025-12-04 21:58:56.334490 | 2025-12-04 21:58:56.334624 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-04 21:58:57.313700 | debian-bookworm | changed 2025-12-04 21:58:57.329695 | 2025-12-04 21:58:57.329848 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-04 21:58:58.181611 | debian-bookworm | changed 2025-12-04 21:58:58.195117 | 2025-12-04 21:58:58.195262 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-04 21:58:58.240407 | debian-bookworm | skipping: Conditional result was False 2025-12-04 21:58:58.252154 | 2025-12-04 21:58:58.252322 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-04 21:58:59.425287 | debian-bookworm -> localhost | changed 2025-12-04 21:58:59.445648 | 2025-12-04 21:58:59.445794 | TASK [add-build-sshkey : Add back temp key] 2025-12-04 21:59:00.169291 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/67790b59b074485eb10e43229d56a237/work/67790b59b074485eb10e43229d56a237_id_rsa (zuul-build-sshkey) 2025-12-04 21:59:00.169537 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032902 2025-12-04 21:59:00.178214 | 2025-12-04 21:59:00.178360 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-04 21:59:00.981583 | debian-bookworm | ok 2025-12-04 21:59:00.997307 | 2025-12-04 21:59:00.998960 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-04 21:59:01.023569 | debian-bookworm | skipping: Conditional result was False 2025-12-04 21:59:01.039795 | 2025-12-04 21:59:01.040964 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-04 21:59:01.650412 | debian-bookworm | ok 2025-12-04 21:59:01.702570 | 2025-12-04 21:59:01.703281 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-04 21:59:01.805811 | debian-bookworm | ok 2025-12-04 21:59:01.811539 | 2025-12-04 21:59:01.811677 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-04 21:59:02.611046 | debian-bookworm -> localhost | ok 2025-12-04 21:59:02.623036 | 2025-12-04 21:59:02.623210 | TASK [validate-host : Collect information about the host] 2025-12-04 21:59:03.993802 | debian-bookworm | ok 2025-12-04 21:59:04.016886 | 2025-12-04 21:59:04.017041 | TASK [validate-host : Sanitize hostname] 2025-12-04 21:59:04.255546 | debian-bookworm | ok 2025-12-04 21:59:04.390412 | 2025-12-04 21:59:04.390563 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-04 21:59:05.742737 | debian-bookworm -> localhost | changed 2025-12-04 21:59:05.752436 | 2025-12-04 21:59:05.752573 | TASK [validate-host : Collect information about zuul worker] 2025-12-04 21:59:06.279225 | debian-bookworm | ok 2025-12-04 21:59:06.284107 | 2025-12-04 21:59:06.284229 | TASK [validate-host : Write out all zuul information for each host] 2025-12-04 21:59:07.967620 | debian-bookworm -> localhost | changed 2025-12-04 21:59:07.981372 | 2025-12-04 21:59:07.981495 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-04 21:59:08.304135 | debian-bookworm | ok 2025-12-04 21:59:08.310027 | 2025-12-04 21:59:08.310170 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-04 21:59:09.753148 | debian-bookworm | changed: 2025-12-04 21:59:09.753402 | debian-bookworm | cd+++++++++ src/ 2025-12-04 21:59:09.753441 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-04 21:59:09.753465 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-04 21:59:09.753487 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-04 21:59:09.753508 | debian-bookworm | Containerfile 2025-12-04 21:59:09.753641 | debian-bookworm | Containerfile 2025-12-04 21:59:09.819839 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004976 2025-12-04 21:59:39.228353 | 2025-12-04 21:59:39.228483 | TASK [upload-logs : Upload logs to log server] 2025-12-04 21:59:39.802189 | localhost | Output suppressed because no_log was given 2025-12-04 21:59:39.804144 | 2025-12-04 21:59:39.804300 | LOOP [upload-logs : Compress console log and json output] 2025-12-04 21:59:39.860720 | localhost | skipping: Conditional result was False 2025-12-04 21:59:39.869082 | localhost | skipping: Conditional result was False 2025-12-04 21:59:39.885624 | 2025-12-04 21:59:39.885766 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-04 21:59:39.941560 | localhost | skipping: Conditional result was False 2025-12-04 21:59:39.942273 | 2025-12-04 21:59:39.947167 | localhost | skipping: Conditional result was False 2025-12-04 21:59:39.957580 | 2025-12-04 21:59:39.957740 | LOOP [upload-logs : Upload console log and json output]