2025-08-06 02:24:53.541981 | Job console starting 2025-08-06 02:24:53.569470 | Updating git repos 2025-08-06 02:24:54.010796 | Cloning repos into workspace 2025-08-06 02:24:54.089511 | Restoring repo states 2025-08-06 02:24:54.110823 | Merging changes 2025-08-06 02:24:54.864423 | Checking out repos 2025-08-06 02:24:54.991422 | Preparing playbooks 2025-08-06 02:24:56.384520 | Running Ansible setup 2025-08-06 02:25:02.537720 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-06 02:25:03.635405 | 2025-08-06 02:25:03.635529 | PLAY [Base pre] 2025-08-06 02:25:03.647711 | 2025-08-06 02:25:03.647808 | TASK [Setup log path fact] 2025-08-06 02:25:03.664422 | debian-bookworm | ok 2025-08-06 02:25:03.676021 | 2025-08-06 02:25:03.676124 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-06 02:25:03.723503 | debian-bookworm | ok 2025-08-06 02:25:03.735805 | 2025-08-06 02:25:03.735896 | TASK [emit-job-header : Print job information] 2025-08-06 02:25:03.783690 | # Job Information 2025-08-06 02:25:03.783839 | Ansible Version: 2.16.14 2025-08-06 02:25:03.783869 | Job: python-black 2025-08-06 02:25:03.783897 | Pipeline: check 2025-08-06 02:25:03.783916 | Executor: 521e9411259a 2025-08-06 02:25:03.783933 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/769 2025-08-06 02:25:03.783952 | Event ID: 83fb3c00-726c-11f0-874c-ae1ecedd34e6 2025-08-06 02:25:03.788010 | 2025-08-06 02:25:03.788101 | LOOP [emit-job-header : Print node information] 2025-08-06 02:25:04.004643 | debian-bookworm | ok: 2025-08-06 02:25:04.004821 | debian-bookworm | # Node Information 2025-08-06 02:25:04.004853 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-06 02:25:04.004875 | debian-bookworm | Hostname: debian 2025-08-06 02:25:04.004894 | debian-bookworm | Username: zuul 2025-08-06 02:25:04.004911 | debian-bookworm | Distro: Debian 12.11 2025-08-06 02:25:04.004931 | debian-bookworm | Provider: regiocloud-a 2025-08-06 02:25:04.004949 | debian-bookworm | Region: 2025-08-06 02:25:04.004968 | debian-bookworm | Label: debian-bookworm 2025-08-06 02:25:04.004985 | debian-bookworm | Product Name: OpenStack Nova 2025-08-06 02:25:04.005002 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb8:d0c4 2025-08-06 02:25:04.025157 | 2025-08-06 02:25:04.025260 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-06 02:25:05.085705 | debian-bookworm -> localhost | changed 2025-08-06 02:25:05.091370 | 2025-08-06 02:25:05.091463 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-06 02:25:07.071796 | debian-bookworm -> localhost | changed 2025-08-06 02:25:07.080365 | 2025-08-06 02:25:07.080462 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-06 02:25:07.490083 | debian-bookworm -> localhost | ok 2025-08-06 02:25:07.494868 | 2025-08-06 02:25:07.494957 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-06 02:25:07.511130 | debian-bookworm | ok 2025-08-06 02:25:07.542188 | debian-bookworm | included: /var/lib/zuul/builds/c6feb1de6e124fb9bc8649aa5b3a695e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-06 02:25:07.557570 | 2025-08-06 02:25:07.557669 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-06 02:25:10.542768 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-06 02:25:10.542949 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c6feb1de6e124fb9bc8649aa5b3a695e/work/c6feb1de6e124fb9bc8649aa5b3a695e_id_rsa 2025-08-06 02:25:10.542982 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c6feb1de6e124fb9bc8649aa5b3a695e/work/c6feb1de6e124fb9bc8649aa5b3a695e_id_rsa.pub 2025-08-06 02:25:10.543005 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-06 02:25:10.543025 | debian-bookworm -> localhost | SHA256:EhwDvjjb+BYjYmZrmv4TUdwlnQFm7dWxj7+5teTvInw zuul-build-sshkey 2025-08-06 02:25:10.543044 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-06 02:25:10.543070 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-06 02:25:10.543089 | debian-bookworm -> localhost | | o.+==oo ... | 2025-08-06 02:25:10.543107 | debian-bookworm -> localhost | | . +o+.+ . .. | 2025-08-06 02:25:10.543124 | debian-bookworm -> localhost | | o o . . . | 2025-08-06 02:25:10.543140 | debian-bookworm -> localhost | | o . . . o | 2025-08-06 02:25:10.543156 | debian-bookworm -> localhost | | o o . S . . | 2025-08-06 02:25:10.543174 | debian-bookworm -> localhost | |.+.*o . . | 2025-08-06 02:25:10.543191 | debian-bookworm -> localhost | |+.+.oo . o.| 2025-08-06 02:25:10.543207 | debian-bookworm -> localhost | | + o. o E =| 2025-08-06 02:25:10.543225 | debian-bookworm -> localhost | |*..oo o O=| 2025-08-06 02:25:10.543241 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-06 02:25:10.543286 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.299938 2025-08-06 02:25:10.548836 | 2025-08-06 02:25:10.548915 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-06 02:25:10.566010 | debian-bookworm | ok 2025-08-06 02:25:10.573334 | debian-bookworm | included: /var/lib/zuul/builds/c6feb1de6e124fb9bc8649aa5b3a695e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-06 02:25:10.580419 | 2025-08-06 02:25:10.580486 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-06 02:25:10.593084 | debian-bookworm | skipping: Conditional result was False 2025-08-06 02:25:10.597660 | 2025-08-06 02:25:10.597734 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-06 02:25:11.277448 | debian-bookworm | changed 2025-08-06 02:25:11.282460 | 2025-08-06 02:25:11.282543 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-06 02:25:11.554637 | debian-bookworm | ok 2025-08-06 02:25:11.559191 | 2025-08-06 02:25:11.559268 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-06 02:25:12.295885 | debian-bookworm | changed 2025-08-06 02:25:12.301386 | 2025-08-06 02:25:12.301471 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-06 02:25:13.052747 | debian-bookworm | changed 2025-08-06 02:25:13.057198 | 2025-08-06 02:25:13.057273 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-06 02:25:13.091346 | debian-bookworm | skipping: Conditional result was False 2025-08-06 02:25:13.096420 | 2025-08-06 02:25:13.096509 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-06 02:25:14.235552 | debian-bookworm -> localhost | changed 2025-08-06 02:25:14.244336 | 2025-08-06 02:25:14.244424 | TASK [add-build-sshkey : Add back temp key] 2025-08-06 02:25:15.192555 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c6feb1de6e124fb9bc8649aa5b3a695e/work/c6feb1de6e124fb9bc8649aa5b3a695e_id_rsa (zuul-build-sshkey) 2025-08-06 02:25:15.192770 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018268 2025-08-06 02:25:15.199375 | 2025-08-06 02:25:15.199462 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-06 02:25:15.665804 | debian-bookworm | ok 2025-08-06 02:25:15.670617 | 2025-08-06 02:25:15.670709 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-06 02:25:15.697353 | debian-bookworm | skipping: Conditional result was False 2025-08-06 02:25:15.710643 | 2025-08-06 02:25:15.710732 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-06 02:25:16.094511 | debian-bookworm | ok 2025-08-06 02:25:16.108125 | 2025-08-06 02:25:16.108228 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-06 02:25:16.135719 | debian-bookworm | ok 2025-08-06 02:25:16.141408 | 2025-08-06 02:25:16.141499 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-06 02:25:16.564229 | debian-bookworm -> localhost | ok 2025-08-06 02:25:16.569454 | 2025-08-06 02:25:16.569531 | TASK [validate-host : Collect information about the host] 2025-08-06 02:25:17.821242 | debian-bookworm | ok 2025-08-06 02:25:17.842470 | 2025-08-06 02:25:17.842589 | TASK [validate-host : Sanitize hostname] 2025-08-06 02:25:18.015154 | debian-bookworm | ok 2025-08-06 02:25:18.115880 | 2025-08-06 02:25:18.115994 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-06 02:25:19.440874 | debian-bookworm -> localhost | changed 2025-08-06 02:25:19.446300 | 2025-08-06 02:25:19.446395 | TASK [validate-host : Collect information about zuul worker] 2025-08-06 02:25:19.844373 | debian-bookworm | ok 2025-08-06 02:25:19.850915 | 2025-08-06 02:25:19.851002 | TASK [validate-host : Write out all zuul information for each host] 2025-08-06 02:25:20.424240 | debian-bookworm -> localhost | changed 2025-08-06 02:25:20.431939 | 2025-08-06 02:25:20.432023 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-06 02:25:20.738377 | debian-bookworm | ok 2025-08-06 02:25:20.743430 | 2025-08-06 02:25:20.743513 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-06 02:25:21.718070 | debian-bookworm | changed: 2025-08-06 02:25:21.718212 | debian-bookworm | cd+++++++++ src/ 2025-08-06 02:25:21.718241 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-06 02:25:21.718262 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-06 02:25:21.718281 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-08-06 02:25:21.718298 | debian-bookworm | Containerfile 2025-08-06 02:25:21.718405 | debian-bookworm | localhost | ok: Runtime: 0:00:00.024921 2025-08-06 02:25:49.648928 | 2025-08-06 02:25:49.649011 | TASK [upload-logs : Upload logs to log server] 2025-08-06 02:25:50.721295 | localhost | Output suppressed because no_log was given 2025-08-06 02:25:50.722685 | 2025-08-06 02:25:50.722758 | LOOP [upload-logs : Compress console log and json output] 2025-08-06 02:25:50.815247 | localhost | skipping: Conditional result was False 2025-08-06 02:25:50.835223 | localhost | skipping: Conditional result was False 2025-08-06 02:25:50.838562 | 2025-08-06 02:25:50.838665 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-06 02:25:50.905858 | localhost | skipping: Conditional result was False 2025-08-06 02:25:50.906135 | 2025-08-06 02:25:50.911182 | localhost | skipping: Conditional result was False 2025-08-06 02:25:50.927607 | 2025-08-06 02:25:50.928215 | LOOP [upload-logs : Upload console log and json output]