2025-12-03 08:44:33.423495 | Job console starting 2025-12-03 08:44:33.470309 | Updating git repos 2025-12-03 08:44:33.579173 | Cloning repos into workspace 2025-12-03 08:44:33.683068 | Restoring repo states 2025-12-03 08:44:33.710692 | Merging changes 2025-12-03 08:44:34.384295 | Checking out repos 2025-12-03 08:44:34.431653 | Preparing playbooks 2025-12-03 08:44:35.416804 | Running Ansible setup 2025-12-03 08:44:41.270807 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-03 08:44:42.344248 | 2025-12-03 08:44:42.344378 | PLAY [Base pre] 2025-12-03 08:44:42.358953 | 2025-12-03 08:44:42.359079 | TASK [Setup log path fact] 2025-12-03 08:44:42.393807 | debian-bookworm | ok 2025-12-03 08:44:42.420326 | 2025-12-03 08:44:42.420467 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-03 08:44:42.449272 | debian-bookworm | ok 2025-12-03 08:44:42.458647 | 2025-12-03 08:44:42.458746 | TASK [emit-job-header : Print job information] 2025-12-03 08:44:42.524281 | # Job Information 2025-12-03 08:44:42.524485 | Ansible Version: 2.16.14 2025-12-03 08:44:42.524520 | Job: python-black 2025-12-03 08:44:42.524560 | Pipeline: check 2025-12-03 08:44:42.524588 | Executor: 521e9411259a 2025-12-03 08:44:42.524609 | Triggered by: https://github.com/osism/python-osism/pull/1880 2025-12-03 08:44:42.524631 | Event ID: 447d2e60-d024-11f0-83af-2e860bc6886a 2025-12-03 08:44:42.531306 | 2025-12-03 08:44:42.531412 | LOOP [emit-job-header : Print node information] 2025-12-03 08:44:42.693382 | debian-bookworm | ok: 2025-12-03 08:44:42.693542 | debian-bookworm | # Node Information 2025-12-03 08:44:42.693574 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-03 08:44:42.693599 | debian-bookworm | Hostname: debian 2025-12-03 08:44:42.693621 | debian-bookworm | Username: zuul 2025-12-03 08:44:42.693641 | debian-bookworm | Distro: Debian 12.12 2025-12-03 08:44:42.694217 | debian-bookworm | Provider: regiocloud-a 2025-12-03 08:44:42.694279 | debian-bookworm | Region: 2025-12-03 08:44:42.694307 | debian-bookworm | Label: debian-bookworm 2025-12-03 08:44:42.694329 | debian-bookworm | Product Name: OpenStack Nova 2025-12-03 08:44:42.694350 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed9:6dae 2025-12-03 08:44:42.711906 | 2025-12-03 08:44:42.712013 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-03 08:44:43.569347 | debian-bookworm -> localhost | changed 2025-12-03 08:44:43.576283 | 2025-12-03 08:44:43.576390 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-03 08:44:44.966419 | debian-bookworm -> localhost | changed 2025-12-03 08:44:44.975472 | 2025-12-03 08:44:44.975566 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-03 08:44:45.297929 | debian-bookworm -> localhost | ok 2025-12-03 08:44:45.302697 | 2025-12-03 08:44:45.302780 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-03 08:44:45.340749 | debian-bookworm | ok 2025-12-03 08:44:45.359489 | debian-bookworm | included: /var/lib/zuul/builds/02de824b7062445f93b73c039c824399/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-03 08:44:45.365316 | 2025-12-03 08:44:45.365405 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-03 08:44:46.904026 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-03 08:44:46.904245 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/02de824b7062445f93b73c039c824399/work/02de824b7062445f93b73c039c824399_id_rsa 2025-12-03 08:44:46.904284 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/02de824b7062445f93b73c039c824399/work/02de824b7062445f93b73c039c824399_id_rsa.pub 2025-12-03 08:44:46.904311 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-03 08:44:46.904335 | debian-bookworm -> localhost | SHA256:d2NXSHmDoS/A9Lbtf0t1DOANkMvtsDbYwMSTW/IDMz0 zuul-build-sshkey 2025-12-03 08:44:46.904356 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-03 08:44:46.904386 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-03 08:44:46.904408 | debian-bookworm -> localhost | | . +.oo.+. | 2025-12-03 08:44:46.904430 | debian-bookworm -> localhost | | % E..*.o.| 2025-12-03 08:44:46.904450 | debian-bookworm -> localhost | | o & B. +.o| 2025-12-03 08:44:46.904471 | debian-bookworm -> localhost | | + O = + | 2025-12-03 08:44:46.904491 | debian-bookworm -> localhost | | S+.B+o. +| 2025-12-03 08:44:46.904514 | debian-bookworm -> localhost | | ..=o+o o| 2025-12-03 08:44:46.904536 | debian-bookworm -> localhost | | . . . . | 2025-12-03 08:44:46.904559 | debian-bookworm -> localhost | | o .| 2025-12-03 08:44:46.904585 | debian-bookworm -> localhost | | oo| 2025-12-03 08:44:46.904606 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-03 08:44:46.904656 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.764479 2025-12-03 08:44:46.911314 | 2025-12-03 08:44:46.911412 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-03 08:44:46.970681 | debian-bookworm | ok 2025-12-03 08:44:46.988353 | debian-bookworm | included: /var/lib/zuul/builds/02de824b7062445f93b73c039c824399/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-03 08:44:47.037132 | 2025-12-03 08:44:47.037242 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-03 08:44:47.063149 | debian-bookworm | skipping: Conditional result was False 2025-12-03 08:44:47.068688 | 2025-12-03 08:44:47.068779 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-03 08:44:47.875755 | debian-bookworm | changed 2025-12-03 08:44:47.880899 | 2025-12-03 08:44:47.880975 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-03 08:44:48.159307 | debian-bookworm | ok 2025-12-03 08:44:48.165222 | 2025-12-03 08:44:48.165315 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-03 08:44:48.885235 | debian-bookworm | changed 2025-12-03 08:44:48.896079 | 2025-12-03 08:44:48.896255 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-03 08:44:49.585073 | debian-bookworm | changed 2025-12-03 08:44:49.591636 | 2025-12-03 08:44:49.591744 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-03 08:44:49.606524 | debian-bookworm | skipping: Conditional result was False 2025-12-03 08:44:49.612416 | 2025-12-03 08:44:49.612509 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-03 08:44:50.044929 | debian-bookworm -> localhost | changed 2025-12-03 08:44:50.057819 | 2025-12-03 08:44:50.057918 | TASK [add-build-sshkey : Add back temp key] 2025-12-03 08:44:50.373328 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/02de824b7062445f93b73c039c824399/work/02de824b7062445f93b73c039c824399_id_rsa (zuul-build-sshkey) 2025-12-03 08:44:50.373543 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009034 2025-12-03 08:44:50.383579 | 2025-12-03 08:44:50.383677 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-03 08:44:50.785530 | debian-bookworm | ok 2025-12-03 08:44:50.790612 | 2025-12-03 08:44:50.790705 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-03 08:44:50.813928 | debian-bookworm | skipping: Conditional result was False 2025-12-03 08:44:50.827357 | 2025-12-03 08:44:50.827510 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-03 08:44:51.266420 | debian-bookworm | ok 2025-12-03 08:44:51.279879 | 2025-12-03 08:44:51.280000 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-03 08:44:51.326253 | debian-bookworm | ok 2025-12-03 08:44:51.336796 | 2025-12-03 08:44:51.336941 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-03 08:44:51.674968 | debian-bookworm -> localhost | ok 2025-12-03 08:44:51.681181 | 2025-12-03 08:44:51.681277 | TASK [validate-host : Collect information about the host] 2025-12-03 08:44:52.960510 | debian-bookworm | ok 2025-12-03 08:44:52.970885 | 2025-12-03 08:44:52.971018 | TASK [validate-host : Sanitize hostname] 2025-12-03 08:44:53.092374 | debian-bookworm | ok 2025-12-03 08:44:53.142703 | 2025-12-03 08:44:53.142899 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-03 08:44:53.900283 | debian-bookworm -> localhost | changed 2025-12-03 08:44:53.906236 | 2025-12-03 08:44:53.906360 | TASK [validate-host : Collect information about zuul worker] 2025-12-03 08:44:54.394512 | debian-bookworm | ok 2025-12-03 08:44:54.400640 | 2025-12-03 08:44:54.400778 | TASK [validate-host : Write out all zuul information for each host] 2025-12-03 08:44:55.205432 | debian-bookworm -> localhost | changed 2025-12-03 08:44:55.219471 | 2025-12-03 08:44:55.219611 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-03 08:44:55.541814 | debian-bookworm | ok 2025-12-03 08:44:55.549456 | 2025-12-03 08:44:55.549602 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-03 08:44:56.665180 | debian-bookworm | changed: 2025-12-03 08:44:56.665400 | debian-bookworm | cd+++++++++ src/ 2025-12-03 08:44:56.665436 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-03 08:44:56.665461 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-03 08:44:56.665483 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-03 08:44:56.665503 | debian-bookworm | Containerfile 2025-12-03 08:44:56.665618 | debian-bookworm | Containerfile 2025-12-03 08:44:56.714944 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007420 2025-12-03 08:45:24.527004 | 2025-12-03 08:45:24.527185 | TASK [upload-logs : Upload logs to log server] 2025-12-03 08:45:25.123445 | localhost | Output suppressed because no_log was given 2025-12-03 08:45:25.126290 | 2025-12-03 08:45:25.126439 | LOOP [upload-logs : Compress console log and json output] 2025-12-03 08:45:25.187014 | localhost | skipping: Conditional result was False 2025-12-03 08:45:25.193300 | localhost | skipping: Conditional result was False 2025-12-03 08:45:25.208742 | 2025-12-03 08:45:25.208982 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-03 08:45:25.271885 | localhost | skipping: Conditional result was False 2025-12-03 08:45:25.272625 | 2025-12-03 08:45:25.275812 | localhost | skipping: Conditional result was False 2025-12-03 08:45:25.288861 | 2025-12-03 08:45:25.288985 | LOOP [upload-logs : Upload console log and json output]