2025-11-23 12:18:52.618660 | Job console starting 2025-11-23 12:18:52.652505 | Updating git repos 2025-11-23 12:18:52.769996 | Cloning repos into workspace 2025-11-23 12:18:52.828793 | Restoring repo states 2025-11-23 12:18:52.848674 | Merging changes 2025-11-23 12:18:53.459373 | Checking out repos 2025-11-23 12:18:53.509488 | Preparing playbooks 2025-11-23 12:18:54.628553 | Running Ansible setup 2025-11-23 12:19:00.680854 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-23 12:19:01.894210 | 2025-11-23 12:19:01.894387 | PLAY [Base pre] 2025-11-23 12:19:01.930010 | 2025-11-23 12:19:01.930177 | TASK [Setup log path fact] 2025-11-23 12:19:01.970957 | debian-bookworm | ok 2025-11-23 12:19:02.004095 | 2025-11-23 12:19:02.004281 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-23 12:19:02.067718 | debian-bookworm | ok 2025-11-23 12:19:02.089198 | 2025-11-23 12:19:02.089358 | TASK [emit-job-header : Print job information] 2025-11-23 12:19:02.192807 | # Job Information 2025-11-23 12:19:02.193004 | Ansible Version: 2.16.14 2025-11-23 12:19:02.193040 | Job: python-black 2025-11-23 12:19:02.193074 | Pipeline: check 2025-11-23 12:19:02.193097 | Executor: 521e9411259a 2025-11-23 12:19:02.193119 | Triggered by: https://github.com/osism/python-osism/pull/1841 2025-11-23 12:19:02.193141 | Event ID: 8dc03a10-c866-11f0-95b1-73c1e63a7656 2025-11-23 12:19:02.198411 | 2025-11-23 12:19:02.198542 | LOOP [emit-job-header : Print node information] 2025-11-23 12:19:02.482042 | debian-bookworm | ok: 2025-11-23 12:19:02.482331 | debian-bookworm | # Node Information 2025-11-23 12:19:02.482370 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-23 12:19:02.482395 | debian-bookworm | Hostname: debian 2025-11-23 12:19:02.482418 | debian-bookworm | Username: zuul 2025-11-23 12:19:02.482438 | debian-bookworm | Distro: Debian 12.12 2025-11-23 12:19:02.482469 | debian-bookworm | Provider: regiocloud-a 2025-11-23 12:19:02.482496 | debian-bookworm | Region: 2025-11-23 12:19:02.482518 | debian-bookworm | Label: debian-bookworm 2025-11-23 12:19:02.482538 | debian-bookworm | Product Name: OpenStack Nova 2025-11-23 12:19:02.482557 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefd:cc98 2025-11-23 12:19:02.495246 | 2025-11-23 12:19:02.495398 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-23 12:19:03.493038 | debian-bookworm -> localhost | changed 2025-11-23 12:19:03.500442 | 2025-11-23 12:19:03.500568 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-23 12:19:05.235174 | debian-bookworm -> localhost | changed 2025-11-23 12:19:05.250720 | 2025-11-23 12:19:05.262375 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-23 12:19:05.771568 | debian-bookworm -> localhost | ok 2025-11-23 12:19:05.777392 | 2025-11-23 12:19:05.777486 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-23 12:19:05.815437 | debian-bookworm | ok 2025-11-23 12:19:05.849244 | debian-bookworm | included: /var/lib/zuul/builds/055627445c244d07bfb57ece7aec4664/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-23 12:19:05.859631 | 2025-11-23 12:19:05.859730 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-23 12:19:07.765130 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-23 12:19:07.765322 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/055627445c244d07bfb57ece7aec4664/work/055627445c244d07bfb57ece7aec4664_id_rsa 2025-11-23 12:19:07.765359 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/055627445c244d07bfb57ece7aec4664/work/055627445c244d07bfb57ece7aec4664_id_rsa.pub 2025-11-23 12:19:07.765385 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-23 12:19:07.765409 | debian-bookworm -> localhost | SHA256:6KtRE8DIOpk+4yty0RFrY3kiLHRDcAZ2Irtfm6gJyzA zuul-build-sshkey 2025-11-23 12:19:07.765432 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-23 12:19:07.765461 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-23 12:19:07.765483 | debian-bookworm -> localhost | |.*+B. | 2025-11-23 12:19:07.765505 | debian-bookworm -> localhost | |ooBoo. | 2025-11-23 12:19:07.765525 | debian-bookworm -> localhost | |o=. .+. | 2025-11-23 12:19:07.765544 | debian-bookworm -> localhost | |*.o O .o | 2025-11-23 12:19:07.765563 | debian-bookworm -> localhost | |oo =.=+ S | 2025-11-23 12:19:07.765597 | debian-bookworm -> localhost | | =.o.= . | 2025-11-23 12:19:07.765619 | debian-bookworm -> localhost | |E =.+ . | 2025-11-23 12:19:07.765639 | debian-bookworm -> localhost | |**. . . | 2025-11-23 12:19:07.765660 | debian-bookworm -> localhost | |*+. ... | 2025-11-23 12:19:07.765680 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-23 12:19:07.765725 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.983438 2025-11-23 12:19:07.772011 | 2025-11-23 12:19:07.772114 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-23 12:19:07.800690 | debian-bookworm | ok 2025-11-23 12:19:07.824450 | debian-bookworm | included: /var/lib/zuul/builds/055627445c244d07bfb57ece7aec4664/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-23 12:19:07.841654 | 2025-11-23 12:19:07.841737 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-23 12:19:07.854452 | debian-bookworm | skipping: Conditional result was False 2025-11-23 12:19:07.858988 | 2025-11-23 12:19:07.859058 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-23 12:19:08.607026 | debian-bookworm | changed 2025-11-23 12:19:08.615336 | 2025-11-23 12:19:08.615474 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-23 12:19:08.871930 | debian-bookworm | ok 2025-11-23 12:19:08.878811 | 2025-11-23 12:19:08.878934 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-23 12:19:09.567776 | debian-bookworm | changed 2025-11-23 12:19:09.574903 | 2025-11-23 12:19:09.575008 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-23 12:19:10.231614 | debian-bookworm | changed 2025-11-23 12:19:10.236851 | 2025-11-23 12:19:10.236943 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-23 12:19:10.272952 | debian-bookworm | skipping: Conditional result was False 2025-11-23 12:19:10.278979 | 2025-11-23 12:19:10.279081 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-23 12:19:10.801513 | debian-bookworm -> localhost | changed 2025-11-23 12:19:10.815806 | 2025-11-23 12:19:10.815912 | TASK [add-build-sshkey : Add back temp key] 2025-11-23 12:19:11.476164 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/055627445c244d07bfb57ece7aec4664/work/055627445c244d07bfb57ece7aec4664_id_rsa (zuul-build-sshkey) 2025-11-23 12:19:11.476429 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015021 2025-11-23 12:19:11.486621 | 2025-11-23 12:19:11.486762 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-23 12:19:11.920989 | debian-bookworm | ok 2025-11-23 12:19:11.926333 | 2025-11-23 12:19:11.926449 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-23 12:19:11.950404 | debian-bookworm | skipping: Conditional result was False 2025-11-23 12:19:11.962036 | 2025-11-23 12:19:11.962167 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-23 12:19:12.430736 | debian-bookworm | ok 2025-11-23 12:19:12.454349 | 2025-11-23 12:19:12.454501 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-23 12:19:12.507320 | debian-bookworm | ok 2025-11-23 12:19:12.520451 | 2025-11-23 12:19:12.520637 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-23 12:19:13.009131 | debian-bookworm -> localhost | ok 2025-11-23 12:19:13.015850 | 2025-11-23 12:19:13.015967 | TASK [validate-host : Collect information about the host] 2025-11-23 12:19:14.207489 | debian-bookworm | ok 2025-11-23 12:19:14.237402 | 2025-11-23 12:19:14.237566 | TASK [validate-host : Sanitize hostname] 2025-11-23 12:19:14.361861 | debian-bookworm | ok 2025-11-23 12:19:14.413526 | 2025-11-23 12:19:14.413692 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-23 12:19:15.232863 | debian-bookworm -> localhost | changed 2025-11-23 12:19:15.240901 | 2025-11-23 12:19:15.241026 | TASK [validate-host : Collect information about zuul worker] 2025-11-23 12:19:15.820072 | debian-bookworm | ok 2025-11-23 12:19:15.826110 | 2025-11-23 12:19:15.826270 | TASK [validate-host : Write out all zuul information for each host] 2025-11-23 12:19:16.658683 | debian-bookworm -> localhost | changed 2025-11-23 12:19:16.681927 | 2025-11-23 12:19:16.682061 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-23 12:19:17.006205 | debian-bookworm | ok 2025-11-23 12:19:17.022867 | 2025-11-23 12:19:17.023008 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-23 12:19:18.328696 | debian-bookworm | changed: 2025-11-23 12:19:18.328929 | debian-bookworm | cd+++++++++ src/ 2025-11-23 12:19:18.328964 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-23 12:19:18.328989 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-23 12:19:18.329010 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-23 12:19:18.329030 | debian-bookworm | Containerfile 2025-11-23 12:19:18.329142 | debian-bookworm | Containerfile 2025-11-23 12:19:18.356189 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007108 2025-11-23 12:19:47.045217 | 2025-11-23 12:19:47.045328 | TASK [upload-logs : Upload logs to log server] 2025-11-23 12:19:47.694967 | localhost | Output suppressed because no_log was given 2025-11-23 12:19:47.697010 | 2025-11-23 12:19:47.697122 | LOOP [upload-logs : Compress console log and json output] 2025-11-23 12:19:47.771703 | localhost | skipping: Conditional result was False 2025-11-23 12:19:47.790915 | localhost | skipping: Conditional result was False 2025-11-23 12:19:47.798406 | 2025-11-23 12:19:47.798527 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-23 12:19:47.859153 | localhost | skipping: Conditional result was False 2025-11-23 12:19:47.859848 | 2025-11-23 12:19:47.864244 | localhost | skipping: Conditional result was False 2025-11-23 12:19:47.871686 | 2025-11-23 12:19:47.871952 | LOOP [upload-logs : Upload console log and json output]