2025-10-06 21:39:15.003042 | Job console starting 2025-10-06 21:39:15.014020 | Updating git repos 2025-10-06 21:39:15.062216 | Cloning repos into workspace 2025-10-06 21:39:15.118212 | Restoring repo states 2025-10-06 21:39:15.150204 | Merging changes 2025-10-06 21:39:15.984377 | Checking out repos 2025-10-06 21:39:16.066098 | Preparing playbooks 2025-10-06 21:39:16.912725 | Running Ansible setup 2025-10-06 21:39:21.206037 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-06 21:39:22.006623 | 2025-10-06 21:39:22.006744 | PLAY [Base pre] 2025-10-06 21:39:22.021343 | 2025-10-06 21:39:22.021446 | TASK [Setup log path fact] 2025-10-06 21:39:22.039385 | debian-bookworm | ok 2025-10-06 21:39:22.055143 | 2025-10-06 21:39:22.055256 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-06 21:39:22.084387 | debian-bookworm | ok 2025-10-06 21:39:22.094025 | 2025-10-06 21:39:22.094120 | TASK [emit-job-header : Print job information] 2025-10-06 21:39:22.123957 | # Job Information 2025-10-06 21:39:22.124101 | Ansible Version: 2.16.14 2025-10-06 21:39:22.124136 | Job: python-black 2025-10-06 21:39:22.124170 | Pipeline: check 2025-10-06 21:39:22.124194 | Executor: 521e9411259a 2025-10-06 21:39:22.124215 | Triggered by: https://github.com/osism/python-osism/pull/1714 2025-10-06 21:39:22.124238 | Event ID: c90aec80-a2fc-11f0-8411-cef2a038acdd 2025-10-06 21:39:22.128830 | 2025-10-06 21:39:22.128916 | LOOP [emit-job-header : Print node information] 2025-10-06 21:39:22.247933 | debian-bookworm | ok: 2025-10-06 21:39:22.248205 | debian-bookworm | # Node Information 2025-10-06 21:39:22.248245 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-06 21:39:22.248270 | debian-bookworm | Hostname: debian 2025-10-06 21:39:22.248292 | debian-bookworm | Username: zuul 2025-10-06 21:39:22.248313 | debian-bookworm | Distro: Debian 12.12 2025-10-06 21:39:22.248337 | debian-bookworm | Provider: regiocloud-a 2025-10-06 21:39:22.248358 | debian-bookworm | Region: 2025-10-06 21:39:22.248379 | debian-bookworm | Label: debian-bookworm 2025-10-06 21:39:22.248400 | debian-bookworm | Product Name: OpenStack Nova 2025-10-06 21:39:22.248419 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fece:7caf 2025-10-06 21:39:22.261303 | 2025-10-06 21:39:22.261403 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-06 21:39:22.923939 | debian-bookworm -> localhost | changed 2025-10-06 21:39:22.932525 | 2025-10-06 21:39:22.932657 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-06 21:39:24.031604 | debian-bookworm -> localhost | changed 2025-10-06 21:39:24.044914 | 2025-10-06 21:39:24.045118 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-06 21:39:24.468172 | debian-bookworm -> localhost | ok 2025-10-06 21:39:24.476202 | 2025-10-06 21:39:24.476991 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-06 21:39:24.522922 | debian-bookworm | ok 2025-10-06 21:39:24.551227 | debian-bookworm | included: /var/lib/zuul/builds/0c5e6dcc40924dcab9228f3b1b23ba64/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-06 21:39:24.561204 | 2025-10-06 21:39:24.561317 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-06 21:39:26.397080 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-06 21:39:26.397536 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0c5e6dcc40924dcab9228f3b1b23ba64/work/0c5e6dcc40924dcab9228f3b1b23ba64_id_rsa 2025-10-06 21:39:26.397613 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0c5e6dcc40924dcab9228f3b1b23ba64/work/0c5e6dcc40924dcab9228f3b1b23ba64_id_rsa.pub 2025-10-06 21:39:26.397644 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-06 21:39:26.397673 | debian-bookworm -> localhost | SHA256:5T2O1q15CCGdYEtkiADzCCZi1Ai1pR/baECJw8pS7gs zuul-build-sshkey 2025-10-06 21:39:26.397698 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-06 21:39:26.397734 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-06 21:39:26.397760 | debian-bookworm -> localhost | |@B*o.. oo | 2025-10-06 21:39:26.397784 | debian-bookworm -> localhost | |OBo=. ..+ | 2025-10-06 21:39:26.397834 | debian-bookworm -> localhost | |++= . o +.. | 2025-10-06 21:39:26.398096 | debian-bookworm -> localhost | |o..o = oo+. | 2025-10-06 21:39:26.398143 | debian-bookworm -> localhost | |.. = . S...o | 2025-10-06 21:39:26.398179 | debian-bookworm -> localhost | |E .. .+ o | 2025-10-06 21:39:26.398207 | debian-bookworm -> localhost | | . . o.o.. | 2025-10-06 21:39:26.398232 | debian-bookworm -> localhost | | . . .o. | 2025-10-06 21:39:26.398256 | debian-bookworm -> localhost | | o. | 2025-10-06 21:39:26.398280 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-06 21:39:26.398346 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.173776 2025-10-06 21:39:26.407525 | 2025-10-06 21:39:26.407873 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-06 21:39:26.440108 | debian-bookworm | ok 2025-10-06 21:39:26.454662 | debian-bookworm | included: /var/lib/zuul/builds/0c5e6dcc40924dcab9228f3b1b23ba64/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-06 21:39:26.466997 | 2025-10-06 21:39:26.467253 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-06 21:39:26.492912 | debian-bookworm | skipping: Conditional result was False 2025-10-06 21:39:26.500865 | 2025-10-06 21:39:26.500977 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-06 21:39:27.267108 | debian-bookworm | changed 2025-10-06 21:39:27.272656 | 2025-10-06 21:39:27.272765 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-06 21:39:27.545065 | debian-bookworm | ok 2025-10-06 21:39:27.560884 | 2025-10-06 21:39:27.561006 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-06 21:39:28.222446 | debian-bookworm | changed 2025-10-06 21:39:28.230427 | 2025-10-06 21:39:28.230589 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-06 21:39:28.869655 | debian-bookworm | changed 2025-10-06 21:39:28.881026 | 2025-10-06 21:39:28.881154 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-06 21:39:28.911061 | debian-bookworm | skipping: Conditional result was False 2025-10-06 21:39:28.919689 | 2025-10-06 21:39:28.919833 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-06 21:39:29.875840 | debian-bookworm -> localhost | changed 2025-10-06 21:39:29.895492 | 2025-10-06 21:39:29.895714 | TASK [add-build-sshkey : Add back temp key] 2025-10-06 21:39:30.384930 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0c5e6dcc40924dcab9228f3b1b23ba64/work/0c5e6dcc40924dcab9228f3b1b23ba64_id_rsa (zuul-build-sshkey) 2025-10-06 21:39:30.385229 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019295 2025-10-06 21:39:30.393916 | 2025-10-06 21:39:30.394028 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-06 21:39:30.825566 | debian-bookworm | ok 2025-10-06 21:39:30.833702 | 2025-10-06 21:39:30.833823 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-06 21:39:30.859841 | debian-bookworm | skipping: Conditional result was False 2025-10-06 21:39:30.874048 | 2025-10-06 21:39:30.874177 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-06 21:39:31.352213 | debian-bookworm | ok 2025-10-06 21:39:31.401335 | 2025-10-06 21:39:31.401474 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-06 21:39:31.456514 | debian-bookworm | ok 2025-10-06 21:39:31.461705 | 2025-10-06 21:39:31.461811 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-06 21:39:32.720124 | debian-bookworm -> localhost | ok 2025-10-06 21:39:32.727360 | 2025-10-06 21:39:32.727474 | TASK [validate-host : Collect information about the host] 2025-10-06 21:39:34.191160 | debian-bookworm | ok 2025-10-06 21:39:34.246815 | 2025-10-06 21:39:34.246945 | TASK [validate-host : Sanitize hostname] 2025-10-06 21:39:34.552514 | debian-bookworm | ok 2025-10-06 21:39:34.707764 | 2025-10-06 21:39:34.707882 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-06 21:39:35.733460 | debian-bookworm -> localhost | changed 2025-10-06 21:39:35.738815 | 2025-10-06 21:39:35.738923 | TASK [validate-host : Collect information about zuul worker] 2025-10-06 21:39:36.242190 | debian-bookworm | ok 2025-10-06 21:39:36.246763 | 2025-10-06 21:39:36.246865 | TASK [validate-host : Write out all zuul information for each host] 2025-10-06 21:39:37.138460 | debian-bookworm -> localhost | changed 2025-10-06 21:39:37.147352 | 2025-10-06 21:39:37.147438 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-06 21:39:37.436665 | debian-bookworm | ok 2025-10-06 21:39:37.441778 | 2025-10-06 21:39:37.441868 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-06 21:39:38.964319 | debian-bookworm | changed: 2025-10-06 21:39:38.964458 | debian-bookworm | cd+++++++++ src/ 2025-10-06 21:39:38.964486 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-06 21:39:38.964507 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-06 21:39:38.964550 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-06 21:39:38.964570 | debian-bookworm | Containerfile 2025-10-06 21:39:38.964664 | debian-bookworm | Containerfile 2025-10-06 21:39:39.000805 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005711 2025-10-06 21:40:06.301381 | 2025-10-06 21:40:06.301539 | TASK [upload-logs : Upload logs to log server] 2025-10-06 21:40:06.876625 | localhost | Output suppressed because no_log was given 2025-10-06 21:40:06.878630 | 2025-10-06 21:40:06.878739 | LOOP [upload-logs : Compress console log and json output] 2025-10-06 21:40:06.928962 | localhost | skipping: Conditional result was False 2025-10-06 21:40:06.934594 | localhost | skipping: Conditional result was False 2025-10-06 21:40:06.940460 | 2025-10-06 21:40:06.940652 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-06 21:40:06.988356 | localhost | skipping: Conditional result was False 2025-10-06 21:40:06.988809 | 2025-10-06 21:40:06.992967 | localhost | skipping: Conditional result was False 2025-10-06 21:40:07.000767 | 2025-10-06 21:40:07.001696 | LOOP [upload-logs : Upload console log and json output]