2025-11-15 21:29:55.729936 | Job console starting 2025-11-15 21:29:55.755169 | Updating git repos 2025-11-15 21:29:55.801913 | Cloning repos into workspace 2025-11-15 21:29:55.849468 | Restoring repo states 2025-11-15 21:29:55.857957 | Merging changes 2025-11-15 21:29:56.335750 | Checking out repos 2025-11-15 21:29:56.370259 | Preparing playbooks 2025-11-15 21:29:57.325737 | Running Ansible setup 2025-11-15 21:30:02.693892 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-15 21:30:04.008417 | 2025-11-15 21:30:04.008597 | PLAY [Base pre] 2025-11-15 21:30:04.028191 | 2025-11-15 21:30:04.028376 | TASK [Setup log path fact] 2025-11-15 21:30:04.079529 | debian-bookworm | ok 2025-11-15 21:30:04.097596 | 2025-11-15 21:30:04.097825 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-15 21:30:04.129957 | debian-bookworm | ok 2025-11-15 21:30:04.151681 | 2025-11-15 21:30:04.151836 | TASK [emit-job-header : Print job information] 2025-11-15 21:30:04.224050 | # Job Information 2025-11-15 21:30:04.224255 | Ansible Version: 2.16.14 2025-11-15 21:30:04.224290 | Job: python-black 2025-11-15 21:30:04.224323 | Pipeline: check 2025-11-15 21:30:04.224346 | Executor: 521e9411259a 2025-11-15 21:30:04.224367 | Triggered by: https://github.com/osism/openstack-simple-stress/pull/236 2025-11-15 21:30:04.224389 | Event ID: 346ebd80-c26a-11f0-96a3-537290c15b87 2025-11-15 21:30:04.234682 | 2025-11-15 21:30:04.234873 | LOOP [emit-job-header : Print node information] 2025-11-15 21:30:04.423233 | debian-bookworm | ok: 2025-11-15 21:30:04.423502 | debian-bookworm | # Node Information 2025-11-15 21:30:04.423543 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-15 21:30:04.423570 | debian-bookworm | Hostname: debian 2025-11-15 21:30:04.423592 | debian-bookworm | Username: zuul 2025-11-15 21:30:04.423612 | debian-bookworm | Distro: Debian 12.12 2025-11-15 21:30:04.423652 | debian-bookworm | Provider: regiocloud-a 2025-11-15 21:30:04.423674 | debian-bookworm | Region: 2025-11-15 21:30:04.423694 | debian-bookworm | Label: debian-bookworm 2025-11-15 21:30:04.423715 | debian-bookworm | Product Name: OpenStack Nova 2025-11-15 21:30:04.423735 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8b:cb71 2025-11-15 21:30:04.447910 | 2025-11-15 21:30:04.448046 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-15 21:30:05.308267 | debian-bookworm -> localhost | changed 2025-11-15 21:30:05.316799 | 2025-11-15 21:30:05.316934 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-15 21:30:06.617421 | debian-bookworm -> localhost | changed 2025-11-15 21:30:06.639293 | 2025-11-15 21:30:06.639443 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-15 21:30:06.947523 | debian-bookworm -> localhost | ok 2025-11-15 21:30:06.954946 | 2025-11-15 21:30:06.955084 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-15 21:30:06.987881 | debian-bookworm | ok 2025-11-15 21:30:07.007605 | debian-bookworm | included: /var/lib/zuul/builds/68c77d199faf4df88d4fda8ce867fdc4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-15 21:30:07.014150 | 2025-11-15 21:30:07.014276 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-15 21:30:08.860952 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-15 21:30:08.861201 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/68c77d199faf4df88d4fda8ce867fdc4/work/68c77d199faf4df88d4fda8ce867fdc4_id_rsa 2025-11-15 21:30:08.861240 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/68c77d199faf4df88d4fda8ce867fdc4/work/68c77d199faf4df88d4fda8ce867fdc4_id_rsa.pub 2025-11-15 21:30:08.861267 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-15 21:30:08.861292 | debian-bookworm -> localhost | SHA256:H1k1x8+Y+psmk10E1mlG4QE12mM6UiEWsgmAsRp1KKg zuul-build-sshkey 2025-11-15 21:30:08.861316 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-15 21:30:08.861352 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-15 21:30:08.861375 | debian-bookworm -> localhost | |. o+o.. . +.o*O+| 2025-11-15 21:30:08.861398 | debian-bookworm -> localhost | |...oo . = ..B*=| 2025-11-15 21:30:08.861419 | debian-bookworm -> localhost | |.... o .+oX.| 2025-11-15 21:30:08.861440 | debian-bookworm -> localhost | |E o o. = =| 2025-11-15 21:30:08.861460 | debian-bookworm -> localhost | | . S o. + . | 2025-11-15 21:30:08.861484 | debian-bookworm -> localhost | | . .o . .| 2025-11-15 21:30:08.861505 | debian-bookworm -> localhost | | . + . | 2025-11-15 21:30:08.861525 | debian-bookworm -> localhost | | + +. | 2025-11-15 21:30:08.861545 | debian-bookworm -> localhost | | +o. | 2025-11-15 21:30:08.861565 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-15 21:30:08.861613 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.108455 2025-11-15 21:30:08.868200 | 2025-11-15 21:30:08.868337 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-15 21:30:08.917478 | debian-bookworm | ok 2025-11-15 21:30:08.927362 | debian-bookworm | included: /var/lib/zuul/builds/68c77d199faf4df88d4fda8ce867fdc4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-15 21:30:08.936801 | 2025-11-15 21:30:08.936926 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-15 21:30:08.986035 | debian-bookworm | skipping: Conditional result was False 2025-11-15 21:30:08.992297 | 2025-11-15 21:30:08.992425 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-15 21:30:09.676407 | debian-bookworm | changed 2025-11-15 21:30:09.682781 | 2025-11-15 21:30:09.682915 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-15 21:30:09.940948 | debian-bookworm | ok 2025-11-15 21:30:09.950064 | 2025-11-15 21:30:09.950225 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-15 21:30:10.606472 | debian-bookworm | changed 2025-11-15 21:30:10.615751 | 2025-11-15 21:30:10.615911 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-15 21:30:11.338799 | debian-bookworm | changed 2025-11-15 21:30:11.349374 | 2025-11-15 21:30:11.349670 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-15 21:30:11.375424 | debian-bookworm | skipping: Conditional result was False 2025-11-15 21:30:11.381709 | 2025-11-15 21:30:11.381838 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-15 21:30:11.911847 | debian-bookworm -> localhost | changed 2025-11-15 21:30:11.927538 | 2025-11-15 21:30:11.927704 | TASK [add-build-sshkey : Add back temp key] 2025-11-15 21:30:12.471301 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/68c77d199faf4df88d4fda8ce867fdc4/work/68c77d199faf4df88d4fda8ce867fdc4_id_rsa (zuul-build-sshkey) 2025-11-15 21:30:12.471559 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022384 2025-11-15 21:30:12.482227 | 2025-11-15 21:30:12.482370 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-15 21:30:12.901337 | debian-bookworm | ok 2025-11-15 21:30:12.911501 | 2025-11-15 21:30:12.911668 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-15 21:30:12.935389 | debian-bookworm | skipping: Conditional result was False 2025-11-15 21:30:12.947205 | 2025-11-15 21:30:12.947333 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-15 21:30:13.384907 | debian-bookworm | ok 2025-11-15 21:30:13.411925 | 2025-11-15 21:30:13.412093 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-15 21:30:13.444545 | debian-bookworm | ok 2025-11-15 21:30:13.450157 | 2025-11-15 21:30:13.450282 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-15 21:30:13.884319 | debian-bookworm -> localhost | ok 2025-11-15 21:30:13.896927 | 2025-11-15 21:30:13.897061 | TASK [validate-host : Collect information about the host] 2025-11-15 21:30:15.058860 | debian-bookworm | ok 2025-11-15 21:30:15.071943 | 2025-11-15 21:30:15.072068 | TASK [validate-host : Sanitize hostname] 2025-11-15 21:30:15.172348 | debian-bookworm | ok 2025-11-15 21:30:15.218325 | 2025-11-15 21:30:15.218458 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-15 21:30:15.990997 | debian-bookworm -> localhost | changed 2025-11-15 21:30:15.997505 | 2025-11-15 21:30:15.997646 | TASK [validate-host : Collect information about zuul worker] 2025-11-15 21:30:16.402434 | debian-bookworm | ok 2025-11-15 21:30:16.408363 | 2025-11-15 21:30:16.408494 | TASK [validate-host : Write out all zuul information for each host] 2025-11-15 21:30:17.112700 | debian-bookworm -> localhost | changed 2025-11-15 21:30:17.128833 | 2025-11-15 21:30:17.128963 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-15 21:30:17.394418 | debian-bookworm | ok 2025-11-15 21:30:17.400417 | 2025-11-15 21:30:17.400543 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-15 21:30:18.559807 | debian-bookworm | changed: 2025-11-15 21:30:18.560040 | debian-bookworm | cd+++++++++ src/ 2025-11-15 21:30:18.560077 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-15 21:30:18.560102 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-15 21:30:18.560123 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2025-11-15 21:30:18.560144 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008034 2025-11-15 21:30:44.838280 | 2025-11-15 21:30:44.838399 | TASK [upload-logs : Upload logs to log server] 2025-11-15 21:30:45.434516 | localhost | Output suppressed because no_log was given 2025-11-15 21:30:45.438241 | 2025-11-15 21:30:45.438451 | LOOP [upload-logs : Compress console log and json output] 2025-11-15 21:30:45.496811 | localhost | skipping: Conditional result was False 2025-11-15 21:30:45.503793 | localhost | skipping: Conditional result was False 2025-11-15 21:30:45.517533 | 2025-11-15 21:30:45.517765 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-15 21:30:45.588349 | localhost | skipping: Conditional result was False 2025-11-15 21:30:45.588688 | 2025-11-15 21:30:45.606272 | localhost | skipping: Conditional result was False 2025-11-15 21:30:45.616747 | 2025-11-15 21:30:45.616899 | LOOP [upload-logs : Upload console log and json output]