2025-12-01 19:35:37.828941 | Job console starting 2025-12-01 19:35:37.866787 | Updating git repos 2025-12-01 19:35:37.912019 | Cloning repos into workspace 2025-12-01 19:35:38.046715 | Restoring repo states 2025-12-01 19:35:38.069624 | Merging changes 2025-12-01 19:35:38.853122 | Checking out repos 2025-12-01 19:35:38.916526 | Preparing playbooks 2025-12-01 19:35:40.310043 | Running Ansible setup 2025-12-01 19:35:47.127440 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-01 19:35:49.190932 | 2025-12-01 19:35:49.191088 | PLAY [Base pre] 2025-12-01 19:35:49.205308 | 2025-12-01 19:35:49.205423 | TASK [Setup log path fact] 2025-12-01 19:35:49.232946 | debian-bookworm | ok 2025-12-01 19:35:49.259007 | 2025-12-01 19:35:49.261163 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-01 19:35:49.365687 | debian-bookworm | ok 2025-12-01 19:35:49.373770 | 2025-12-01 19:35:49.373872 | TASK [emit-job-header : Print job information] 2025-12-01 19:35:49.447138 | # Job Information 2025-12-01 19:35:49.447273 | Ansible Version: 2.16.14 2025-12-01 19:35:49.447301 | Job: python-black 2025-12-01 19:35:49.447327 | Pipeline: check 2025-12-01 19:35:49.447345 | Executor: 521e9411259a 2025-12-01 19:35:49.447362 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/798 2025-12-01 19:35:49.447379 | Event ID: e31eb6d0-ceec-11f0-8eb4-2c2e2c9b66e2 2025-12-01 19:35:49.451365 | 2025-12-01 19:35:49.451446 | LOOP [emit-job-header : Print node information] 2025-12-01 19:35:49.624364 | debian-bookworm | ok: 2025-12-01 19:35:49.624556 | debian-bookworm | # Node Information 2025-12-01 19:35:49.624585 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-01 19:35:49.624605 | debian-bookworm | Hostname: debian 2025-12-01 19:35:49.624623 | debian-bookworm | Username: zuul 2025-12-01 19:35:49.624640 | debian-bookworm | Distro: Debian 12.12 2025-12-01 19:35:49.624659 | debian-bookworm | Provider: regiocloud-a 2025-12-01 19:35:49.624676 | debian-bookworm | Region: 2025-12-01 19:35:49.624693 | debian-bookworm | Label: debian-bookworm 2025-12-01 19:35:49.624709 | debian-bookworm | Product Name: OpenStack Nova 2025-12-01 19:35:49.624725 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:febd:1351 2025-12-01 19:35:49.639649 | 2025-12-01 19:35:49.639776 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-01 19:35:51.008230 | debian-bookworm -> localhost | changed 2025-12-01 19:35:51.015929 | 2025-12-01 19:35:51.016043 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-01 19:35:53.434380 | debian-bookworm -> localhost | changed 2025-12-01 19:35:53.443085 | 2025-12-01 19:35:53.443185 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-01 19:35:53.904195 | debian-bookworm -> localhost | ok 2025-12-01 19:35:53.916475 | 2025-12-01 19:35:53.916618 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-01 19:35:53.981394 | debian-bookworm | ok 2025-12-01 19:35:54.018014 | debian-bookworm | included: /var/lib/zuul/builds/e197cacc075540c6a4c3cc1d86299bd9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-01 19:35:54.036329 | 2025-12-01 19:35:54.036442 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-01 19:35:56.972488 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-01 19:35:56.972714 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e197cacc075540c6a4c3cc1d86299bd9/work/e197cacc075540c6a4c3cc1d86299bd9_id_rsa 2025-12-01 19:35:56.972758 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e197cacc075540c6a4c3cc1d86299bd9/work/e197cacc075540c6a4c3cc1d86299bd9_id_rsa.pub 2025-12-01 19:35:56.972785 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-01 19:35:56.972809 | debian-bookworm -> localhost | SHA256:H0CK0k3WA7aOsbiR3/ceqK9minAbfIuA2UkMEb3eNTM zuul-build-sshkey 2025-12-01 19:35:56.972833 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-01 19:35:56.972864 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-01 19:35:56.972886 | debian-bookworm -> localhost | |oo =o. | 2025-12-01 19:35:56.972908 | debian-bookworm -> localhost | | ... * +o | 2025-12-01 19:35:56.972929 | debian-bookworm -> localhost | |. ..+ + .. | 2025-12-01 19:35:56.972949 | debian-bookworm -> localhost | | o.+ =E . | 2025-12-01 19:35:56.972984 | debian-bookworm -> localhost | | .*.o..+S . | 2025-12-01 19:35:56.973014 | debian-bookworm -> localhost | |.=.=.. o . | 2025-12-01 19:35:56.973036 | debian-bookworm -> localhost | |= B o . o o | 2025-12-01 19:35:56.973057 | debian-bookworm -> localhost | | + * .oo . . | 2025-12-01 19:35:56.973079 | debian-bookworm -> localhost | | + o+oo..o | 2025-12-01 19:35:56.973100 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-01 19:35:56.973161 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.006868 2025-12-01 19:35:56.979546 | 2025-12-01 19:35:56.979644 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-01 19:35:57.020074 | debian-bookworm | ok 2025-12-01 19:35:57.047071 | debian-bookworm | included: /var/lib/zuul/builds/e197cacc075540c6a4c3cc1d86299bd9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-01 19:35:57.094927 | 2025-12-01 19:35:57.095056 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-01 19:35:57.141723 | debian-bookworm | skipping: Conditional result was False 2025-12-01 19:35:57.148015 | 2025-12-01 19:35:57.148114 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-01 19:35:57.865774 | debian-bookworm | changed 2025-12-01 19:35:57.875138 | 2025-12-01 19:35:57.875272 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-01 19:35:58.155670 | debian-bookworm | ok 2025-12-01 19:35:58.160979 | 2025-12-01 19:35:58.161073 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-01 19:35:58.941056 | debian-bookworm | changed 2025-12-01 19:35:58.948593 | 2025-12-01 19:35:58.948700 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-01 19:35:59.653374 | debian-bookworm | changed 2025-12-01 19:35:59.658917 | 2025-12-01 19:35:59.659020 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-01 19:35:59.695067 | debian-bookworm | skipping: Conditional result was False 2025-12-01 19:35:59.700914 | 2025-12-01 19:35:59.701026 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-01 19:36:00.422657 | debian-bookworm -> localhost | changed 2025-12-01 19:36:00.432903 | 2025-12-01 19:36:00.433056 | TASK [add-build-sshkey : Add back temp key] 2025-12-01 19:36:01.277945 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e197cacc075540c6a4c3cc1d86299bd9/work/e197cacc075540c6a4c3cc1d86299bd9_id_rsa (zuul-build-sshkey) 2025-12-01 19:36:01.278182 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.041574 2025-12-01 19:36:01.285685 | 2025-12-01 19:36:01.285790 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-01 19:36:02.137742 | debian-bookworm | ok 2025-12-01 19:36:02.144822 | 2025-12-01 19:36:02.144966 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-01 19:36:02.231062 | debian-bookworm | skipping: Conditional result was False 2025-12-01 19:36:02.243818 | 2025-12-01 19:36:02.244015 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-01 19:36:02.944674 | debian-bookworm | ok 2025-12-01 19:36:02.986890 | 2025-12-01 19:36:02.987209 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-01 19:36:03.066809 | debian-bookworm | ok 2025-12-01 19:36:03.076264 | 2025-12-01 19:36:03.076420 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-01 19:36:04.039706 | debian-bookworm -> localhost | ok 2025-12-01 19:36:04.046576 | 2025-12-01 19:36:04.046709 | TASK [validate-host : Collect information about the host] 2025-12-01 19:36:05.801660 | debian-bookworm | ok 2025-12-01 19:36:05.836533 | 2025-12-01 19:36:05.837412 | TASK [validate-host : Sanitize hostname] 2025-12-01 19:36:06.121968 | debian-bookworm | ok 2025-12-01 19:36:06.228349 | 2025-12-01 19:36:06.228463 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-01 19:36:07.873962 | debian-bookworm -> localhost | changed 2025-12-01 19:36:07.879539 | 2025-12-01 19:36:07.879643 | TASK [validate-host : Collect information about zuul worker] 2025-12-01 19:36:08.816245 | debian-bookworm | ok 2025-12-01 19:36:08.821010 | 2025-12-01 19:36:08.821108 | TASK [validate-host : Write out all zuul information for each host] 2025-12-01 19:36:09.863929 | debian-bookworm -> localhost | changed 2025-12-01 19:36:09.874910 | 2025-12-01 19:36:09.875057 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-01 19:36:10.158796 | debian-bookworm | ok 2025-12-01 19:36:10.164363 | 2025-12-01 19:36:10.164459 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-01 19:36:11.271172 | debian-bookworm | changed: 2025-12-01 19:36:11.271357 | debian-bookworm | cd+++++++++ src/ 2025-12-01 19:36:11.271393 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-01 19:36:11.271424 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-01 19:36:11.271446 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-12-01 19:36:11.271467 | debian-bookworm | Containerfile 2025-12-01 19:36:11.271605 | debian-bookworm | localhost | ok: Runtime: 0:00:00.013049 2025-12-01 19:36:42.585890 | 2025-12-01 19:36:42.586008 | TASK [upload-logs : Upload logs to log server] 2025-12-01 19:36:43.579196 | localhost | Output suppressed because no_log was given 2025-12-01 19:36:43.580914 | 2025-12-01 19:36:43.581015 | LOOP [upload-logs : Compress console log and json output] 2025-12-01 19:36:43.669388 | localhost | skipping: Conditional result was False 2025-12-01 19:36:43.687439 | localhost | skipping: Conditional result was False 2025-12-01 19:36:43.697236 | 2025-12-01 19:36:43.697341 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-01 19:36:43.759566 | localhost | skipping: Conditional result was False 2025-12-01 19:36:43.759826 | 2025-12-01 19:36:43.765301 | localhost | skipping: Conditional result was False 2025-12-01 19:36:43.773126 | 2025-12-01 19:36:43.773221 | LOOP [upload-logs : Upload console log and json output]