2025-08-09 01:27:44.243872 | Job console starting 2025-08-09 01:27:44.270943 | Updating git repos 2025-08-09 01:27:44.308436 | Cloning repos into workspace 2025-08-09 01:27:44.365566 | Restoring repo states 2025-08-09 01:27:44.371184 | Merging changes 2025-08-09 01:27:44.901078 | Checking out repos 2025-08-09 01:27:44.995824 | Preparing playbooks 2025-08-09 01:27:46.196949 | Running Ansible setup 2025-08-09 01:27:52.518037 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-09 01:27:53.769966 | 2025-08-09 01:27:53.770105 | PLAY [Base pre] 2025-08-09 01:27:53.801232 | 2025-08-09 01:27:53.801362 | TASK [Setup log path fact] 2025-08-09 01:27:53.847415 | debian-bookworm | ok 2025-08-09 01:27:53.878063 | 2025-08-09 01:27:53.878204 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-09 01:27:53.957278 | debian-bookworm | ok 2025-08-09 01:27:53.966643 | 2025-08-09 01:27:53.966746 | TASK [emit-job-header : Print job information] 2025-08-09 01:27:54.073276 | # Job Information 2025-08-09 01:27:54.073443 | Ansible Version: 2.16.14 2025-08-09 01:27:54.073478 | Job: python-black 2025-08-09 01:27:54.073512 | Pipeline: check 2025-08-09 01:27:54.073535 | Executor: 521e9411259a 2025-08-09 01:27:54.073556 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/770 2025-08-09 01:27:54.073580 | Event ID: 0753a330-74c0-11f0-892a-260786c81da7 2025-08-09 01:27:54.078260 | 2025-08-09 01:27:54.078354 | LOOP [emit-job-header : Print node information] 2025-08-09 01:27:54.337250 | debian-bookworm | ok: 2025-08-09 01:27:54.337416 | debian-bookworm | # Node Information 2025-08-09 01:27:54.337451 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-09 01:27:54.337476 | debian-bookworm | Hostname: debian 2025-08-09 01:27:54.337498 | debian-bookworm | Username: zuul 2025-08-09 01:27:54.337519 | debian-bookworm | Distro: Debian 12.11 2025-08-09 01:27:54.337542 | debian-bookworm | Provider: regiocloud-a 2025-08-09 01:27:54.337563 | debian-bookworm | Region: 2025-08-09 01:27:54.337584 | debian-bookworm | Label: debian-bookworm 2025-08-09 01:27:54.337604 | debian-bookworm | Product Name: OpenStack Nova 2025-08-09 01:27:54.337623 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4e:fa4a 2025-08-09 01:27:54.352860 | 2025-08-09 01:27:54.352974 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-09 01:27:55.417737 | debian-bookworm -> localhost | changed 2025-08-09 01:27:55.424811 | 2025-08-09 01:27:55.424924 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-09 01:27:57.468976 | debian-bookworm -> localhost | changed 2025-08-09 01:27:57.489350 | 2025-08-09 01:27:57.489461 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-09 01:27:58.138507 | debian-bookworm -> localhost | ok 2025-08-09 01:27:58.144335 | 2025-08-09 01:27:58.144434 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-09 01:27:58.181818 | debian-bookworm | ok 2025-08-09 01:27:58.218120 | debian-bookworm | included: /var/lib/zuul/builds/fc925f1a980c4d30846c1d032e440729/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-09 01:27:58.236097 | 2025-08-09 01:27:58.236201 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-09 01:28:01.379038 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-09 01:28:01.379474 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fc925f1a980c4d30846c1d032e440729/work/fc925f1a980c4d30846c1d032e440729_id_rsa 2025-08-09 01:28:01.379577 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fc925f1a980c4d30846c1d032e440729/work/fc925f1a980c4d30846c1d032e440729_id_rsa.pub 2025-08-09 01:28:01.379657 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-09 01:28:01.379719 | debian-bookworm -> localhost | SHA256:4NSX06fxxG6OkHuxQkWdzbCcg1forHbuIwpvYKjkga4 zuul-build-sshkey 2025-08-09 01:28:01.379773 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-09 01:28:01.379840 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-09 01:28:01.379892 | debian-bookworm -> localhost | | ...*.| 2025-08-09 01:28:01.379942 | debian-bookworm -> localhost | | . + +++o| 2025-08-09 01:28:01.379988 | debian-bookworm -> localhost | | o . + =oX | 2025-08-09 01:28:01.380036 | debian-bookworm -> localhost | | o . . + Oo. | 2025-08-09 01:28:01.380081 | debian-bookworm -> localhost | | . ..S + o.+ | 2025-08-09 01:28:01.380143 | debian-bookworm -> localhost | | . o . o. oo*. | 2025-08-09 01:28:01.380211 | debian-bookworm -> localhost | | . o o ...o.+o. | 2025-08-09 01:28:01.380260 | debian-bookworm -> localhost | | . o o.o. o | 2025-08-09 01:28:01.380330 | debian-bookworm -> localhost | |E. .o. o.. | 2025-08-09 01:28:01.380382 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-09 01:28:01.380516 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.268657 2025-08-09 01:28:01.391804 | 2025-08-09 01:28:01.391942 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-09 01:28:01.410517 | debian-bookworm | ok 2025-08-09 01:28:01.419391 | debian-bookworm | included: /var/lib/zuul/builds/fc925f1a980c4d30846c1d032e440729/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-09 01:28:01.426460 | 2025-08-09 01:28:01.426528 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-09 01:28:01.439207 | debian-bookworm | skipping: Conditional result was False 2025-08-09 01:28:01.446437 | 2025-08-09 01:28:01.446545 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-09 01:28:02.057280 | debian-bookworm | changed 2025-08-09 01:28:02.061777 | 2025-08-09 01:28:02.061862 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-09 01:28:02.325590 | debian-bookworm | ok 2025-08-09 01:28:02.348616 | 2025-08-09 01:28:02.348797 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-09 01:28:02.973982 | debian-bookworm | changed 2025-08-09 01:28:02.979422 | 2025-08-09 01:28:02.979507 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-09 01:28:03.584658 | debian-bookworm | changed 2025-08-09 01:28:03.591008 | 2025-08-09 01:28:03.591105 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-09 01:28:03.623951 | debian-bookworm | skipping: Conditional result was False 2025-08-09 01:28:03.629720 | 2025-08-09 01:28:03.629816 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-09 01:28:04.600800 | debian-bookworm -> localhost | changed 2025-08-09 01:28:04.617385 | 2025-08-09 01:28:04.617500 | TASK [add-build-sshkey : Add back temp key] 2025-08-09 01:28:04.996963 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fc925f1a980c4d30846c1d032e440729/work/fc925f1a980c4d30846c1d032e440729_id_rsa (zuul-build-sshkey) 2025-08-09 01:28:04.997176 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012908 2025-08-09 01:28:05.004814 | 2025-08-09 01:28:05.004902 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-09 01:28:05.458984 | debian-bookworm | ok 2025-08-09 01:28:05.464067 | 2025-08-09 01:28:05.464166 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-09 01:28:05.489683 | debian-bookworm | skipping: Conditional result was False 2025-08-09 01:28:05.501865 | 2025-08-09 01:28:05.501991 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-09 01:28:06.042403 | debian-bookworm | ok 2025-08-09 01:28:06.057567 | 2025-08-09 01:28:06.057697 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-09 01:28:06.085244 | debian-bookworm | ok 2025-08-09 01:28:06.090186 | 2025-08-09 01:28:06.090279 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-09 01:28:06.444304 | debian-bookworm -> localhost | ok 2025-08-09 01:28:06.450327 | 2025-08-09 01:28:06.450416 | TASK [validate-host : Collect information about the host] 2025-08-09 01:28:07.601589 | debian-bookworm | ok 2025-08-09 01:28:07.611933 | 2025-08-09 01:28:07.612034 | TASK [validate-host : Sanitize hostname] 2025-08-09 01:28:07.725923 | debian-bookworm | ok 2025-08-09 01:28:07.757147 | 2025-08-09 01:28:07.757249 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-09 01:28:08.799076 | debian-bookworm -> localhost | changed 2025-08-09 01:28:08.804614 | 2025-08-09 01:28:08.804719 | TASK [validate-host : Collect information about zuul worker] 2025-08-09 01:28:09.312939 | debian-bookworm | ok 2025-08-09 01:28:09.317667 | 2025-08-09 01:28:09.317764 | TASK [validate-host : Write out all zuul information for each host] 2025-08-09 01:28:10.582070 | debian-bookworm -> localhost | changed 2025-08-09 01:28:10.591122 | 2025-08-09 01:28:10.591222 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-09 01:28:10.902732 | debian-bookworm | ok 2025-08-09 01:28:10.908000 | 2025-08-09 01:28:10.908093 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-09 01:28:11.781564 | debian-bookworm | changed: 2025-08-09 01:28:11.781748 | debian-bookworm | cd+++++++++ src/ 2025-08-09 01:28:11.781782 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-09 01:28:11.781806 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-09 01:28:11.781828 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-08-09 01:28:11.781848 | debian-bookworm | Containerfile 2025-08-09 01:28:11.781980 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004020 2025-08-09 01:28:37.780839 | 2025-08-09 01:28:37.780959 | TASK [upload-logs : Upload logs to log server] 2025-08-09 01:28:38.411902 | localhost | Output suppressed because no_log was given 2025-08-09 01:28:38.418599 | 2025-08-09 01:28:38.420109 | LOOP [upload-logs : Compress console log and json output] 2025-08-09 01:28:38.508187 | localhost | skipping: Conditional result was False 2025-08-09 01:28:38.530790 | localhost | skipping: Conditional result was False 2025-08-09 01:28:38.534815 | 2025-08-09 01:28:38.534976 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-09 01:28:38.589919 | localhost | skipping: Conditional result was False 2025-08-09 01:28:38.590200 | 2025-08-09 01:28:38.596969 | localhost | skipping: Conditional result was False 2025-08-09 01:28:38.608693 | 2025-08-09 01:28:38.608863 | LOOP [upload-logs : Upload console log and json output]