2025-12-05 05:10:25.930657 | Job console starting 2025-12-05 05:10:25.975932 | Updating git repos 2025-12-05 05:10:26.037449 | Cloning repos into workspace 2025-12-05 05:10:26.138373 | Restoring repo states 2025-12-05 05:10:26.150694 | Merging changes 2025-12-05 05:10:26.832904 | Checking out repos 2025-12-05 05:10:26.927962 | Preparing playbooks 2025-12-05 05:10:28.294563 | Running Ansible setup 2025-12-05 05:10:36.013943 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-05 05:10:38.231049 | 2025-12-05 05:10:38.231276 | PLAY [Base pre] 2025-12-05 05:10:38.265812 | 2025-12-05 05:10:38.265978 | TASK [Setup log path fact] 2025-12-05 05:10:38.305049 | debian-bookworm | ok 2025-12-05 05:10:38.347714 | 2025-12-05 05:10:38.347960 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-05 05:10:38.461231 | debian-bookworm | ok 2025-12-05 05:10:38.480544 | 2025-12-05 05:10:38.480697 | TASK [emit-job-header : Print job information] 2025-12-05 05:10:38.544651 | # Job Information 2025-12-05 05:10:38.544946 | Ansible Version: 2.16.14 2025-12-05 05:10:38.544988 | Job: python-black 2025-12-05 05:10:38.545031 | Pipeline: check 2025-12-05 05:10:38.545059 | Executor: 521e9411259a 2025-12-05 05:10:38.545081 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/801 2025-12-05 05:10:38.545104 | Event ID: aec510b0-d198-11f0-8a8b-43879c090509 2025-12-05 05:10:38.573368 | 2025-12-05 05:10:38.573524 | LOOP [emit-job-header : Print node information] 2025-12-05 05:10:38.836925 | debian-bookworm | ok: 2025-12-05 05:10:38.840234 | debian-bookworm | # Node Information 2025-12-05 05:10:38.840342 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-05 05:10:38.840373 | debian-bookworm | Hostname: debian 2025-12-05 05:10:38.840397 | debian-bookworm | Username: zuul 2025-12-05 05:10:38.840419 | debian-bookworm | Distro: Debian 12.12 2025-12-05 05:10:38.840533 | debian-bookworm | Provider: regiocloud-a 2025-12-05 05:10:38.840560 | debian-bookworm | Region: 2025-12-05 05:10:38.840582 | debian-bookworm | Label: debian-bookworm 2025-12-05 05:10:38.840603 | debian-bookworm | Product Name: OpenStack Nova 2025-12-05 05:10:38.840623 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe48:2188 2025-12-05 05:10:38.867152 | 2025-12-05 05:10:38.867345 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-05 05:10:40.350281 | debian-bookworm -> localhost | changed 2025-12-05 05:10:40.362535 | 2025-12-05 05:10:40.362757 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-05 05:10:43.186606 | debian-bookworm -> localhost | changed 2025-12-05 05:10:43.202451 | 2025-12-05 05:10:43.202596 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-05 05:10:44.053387 | debian-bookworm -> localhost | ok 2025-12-05 05:10:44.060842 | 2025-12-05 05:10:44.060995 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-05 05:10:44.133910 | debian-bookworm | ok 2025-12-05 05:10:44.161926 | debian-bookworm | included: /var/lib/zuul/builds/89b2613b2d1a4b77905a65bd5d1a82d3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-05 05:10:44.181068 | 2025-12-05 05:10:44.181264 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-05 05:10:47.819294 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-05 05:10:47.819677 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/89b2613b2d1a4b77905a65bd5d1a82d3/work/89b2613b2d1a4b77905a65bd5d1a82d3_id_rsa 2025-12-05 05:10:47.819729 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/89b2613b2d1a4b77905a65bd5d1a82d3/work/89b2613b2d1a4b77905a65bd5d1a82d3_id_rsa.pub 2025-12-05 05:10:47.819757 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-05 05:10:47.819784 | debian-bookworm -> localhost | SHA256:rG2Q0h+DbHFYlpEGo+kwziO6NBuqblxJyeVgZbwnN1M zuul-build-sshkey 2025-12-05 05:10:47.819806 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-05 05:10:47.819842 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-05 05:10:47.819864 | debian-bookworm -> localhost | | ooo.++ | 2025-12-05 05:10:47.819886 | debian-bookworm -> localhost | | o.= =+E | 2025-12-05 05:10:47.819907 | debian-bookworm -> localhost | | = B +.o | 2025-12-05 05:10:47.819962 | debian-bookworm -> localhost | | o B * @ | 2025-12-05 05:10:47.819993 | debian-bookworm -> localhost | |. = + @ S | 2025-12-05 05:10:47.820018 | debian-bookworm -> localhost | |.. + o = o | 2025-12-05 05:10:47.820038 | debian-bookworm -> localhost | |o+. . + | 2025-12-05 05:10:47.820058 | debian-bookworm -> localhost | |o++ . | 2025-12-05 05:10:47.820078 | debian-bookworm -> localhost | |Bo | 2025-12-05 05:10:47.820098 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-05 05:10:47.820188 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.041300 2025-12-05 05:10:47.833374 | 2025-12-05 05:10:47.833518 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-05 05:10:47.955120 | debian-bookworm | ok 2025-12-05 05:10:47.988167 | debian-bookworm | included: /var/lib/zuul/builds/89b2613b2d1a4b77905a65bd5d1a82d3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-05 05:10:48.029729 | 2025-12-05 05:10:48.029884 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-05 05:10:48.126433 | debian-bookworm | skipping: Conditional result was False 2025-12-05 05:10:48.135559 | 2025-12-05 05:10:48.135757 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-05 05:10:49.136343 | debian-bookworm | changed 2025-12-05 05:10:49.143689 | 2025-12-05 05:10:49.143819 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-05 05:10:49.408350 | debian-bookworm | ok 2025-12-05 05:10:49.416477 | 2025-12-05 05:10:49.416632 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-05 05:10:50.074351 | debian-bookworm | changed 2025-12-05 05:10:50.096706 | 2025-12-05 05:10:50.096924 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-05 05:10:50.840970 | debian-bookworm | changed 2025-12-05 05:10:50.847167 | 2025-12-05 05:10:50.847335 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-05 05:10:50.883133 | debian-bookworm | skipping: Conditional result was False 2025-12-05 05:10:50.890258 | 2025-12-05 05:10:50.890388 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-05 05:10:51.666374 | debian-bookworm -> localhost | changed 2025-12-05 05:10:51.678373 | 2025-12-05 05:10:51.678519 | TASK [add-build-sshkey : Add back temp key] 2025-12-05 05:10:52.599677 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/89b2613b2d1a4b77905a65bd5d1a82d3/work/89b2613b2d1a4b77905a65bd5d1a82d3_id_rsa (zuul-build-sshkey) 2025-12-05 05:10:52.599934 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025334 2025-12-05 05:10:52.609268 | 2025-12-05 05:10:52.609398 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-05 05:10:53.248874 | debian-bookworm | ok 2025-12-05 05:10:53.268740 | 2025-12-05 05:10:53.268885 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-05 05:10:53.319603 | debian-bookworm | skipping: Conditional result was False 2025-12-05 05:10:53.365820 | 2025-12-05 05:10:53.365966 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-05 05:10:54.143795 | debian-bookworm | ok 2025-12-05 05:10:54.176986 | 2025-12-05 05:10:54.177135 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-05 05:10:54.227583 | debian-bookworm | ok 2025-12-05 05:10:54.232945 | 2025-12-05 05:10:54.235415 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-05 05:10:54.823895 | debian-bookworm -> localhost | ok 2025-12-05 05:10:54.835307 | 2025-12-05 05:10:54.835445 | TASK [validate-host : Collect information about the host] 2025-12-05 05:10:56.212805 | debian-bookworm | ok 2025-12-05 05:10:56.237567 | 2025-12-05 05:10:56.237713 | TASK [validate-host : Sanitize hostname] 2025-12-05 05:10:56.406321 | debian-bookworm | ok 2025-12-05 05:10:56.517052 | 2025-12-05 05:10:56.517354 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-05 05:10:57.766673 | debian-bookworm -> localhost | changed 2025-12-05 05:10:57.773396 | 2025-12-05 05:10:57.773527 | TASK [validate-host : Collect information about zuul worker] 2025-12-05 05:10:58.460904 | debian-bookworm | ok 2025-12-05 05:10:58.470710 | 2025-12-05 05:10:58.470874 | TASK [validate-host : Write out all zuul information for each host] 2025-12-05 05:10:59.731350 | debian-bookworm -> localhost | changed 2025-12-05 05:10:59.746764 | 2025-12-05 05:10:59.746929 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-05 05:11:00.124418 | debian-bookworm | ok 2025-12-05 05:11:00.149644 | 2025-12-05 05:11:00.149796 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-05 05:11:01.634605 | debian-bookworm | changed: 2025-12-05 05:11:01.642920 | debian-bookworm | cd+++++++++ src/ 2025-12-05 05:11:01.643042 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-05 05:11:01.643073 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-05 05:11:01.643097 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-12-05 05:11:01.643118 | debian-bookworm | Containerfile 2025-12-05 05:11:01.643289 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005737 2025-12-05 05:11:28.976730 | 2025-12-05 05:11:28.976861 | TASK [upload-logs : Upload logs to log server] 2025-12-05 05:11:29.594662 | localhost | Output suppressed because no_log was given 2025-12-05 05:11:29.604237 | 2025-12-05 05:11:29.604379 | LOOP [upload-logs : Compress console log and json output] 2025-12-05 05:11:29.654995 | localhost | skipping: Conditional result was False 2025-12-05 05:11:29.661392 | localhost | skipping: Conditional result was False 2025-12-05 05:11:29.672277 | 2025-12-05 05:11:29.672415 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-05 05:11:29.720883 | localhost | skipping: Conditional result was False 2025-12-05 05:11:29.721216 | 2025-12-05 05:11:29.726318 | localhost | skipping: Conditional result was False 2025-12-05 05:11:29.730449 | 2025-12-05 05:11:29.730587 | LOOP [upload-logs : Upload console log and json output]