2025-08-25 15:56:23.937728 | Job console starting 2025-08-25 15:56:23.969229 | Updating git repos 2025-08-25 15:56:24.008651 | Cloning repos into workspace 2025-08-25 15:56:24.153623 | Restoring repo states 2025-08-25 15:56:24.162879 | Merging changes 2025-08-25 15:56:24.745095 | Checking out repos 2025-08-25 15:56:24.805208 | Preparing playbooks 2025-08-25 15:56:26.084896 | Running Ansible setup 2025-08-25 15:56:32.149167 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-25 15:56:33.039735 | 2025-08-25 15:56:33.039851 | PLAY [Base pre] 2025-08-25 15:56:33.060118 | 2025-08-25 15:56:33.060233 | TASK [Setup log path fact] 2025-08-25 15:56:33.087508 | debian-bookworm | ok 2025-08-25 15:56:33.118050 | 2025-08-25 15:56:33.118172 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-25 15:56:33.155843 | debian-bookworm | ok 2025-08-25 15:56:33.174520 | 2025-08-25 15:56:33.174613 | TASK [emit-job-header : Print job information] 2025-08-25 15:56:33.244465 | # Job Information 2025-08-25 15:56:33.244606 | Ansible Version: 2.16.14 2025-08-25 15:56:33.244634 | Job: python-black 2025-08-25 15:56:33.244660 | Pipeline: check 2025-08-25 15:56:33.244678 | Executor: 521e9411259a 2025-08-25 15:56:33.244695 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/768 2025-08-25 15:56:33.244713 | Event ID: 07e5af50-81cc-11f0-9c35-76b1b52b6073 2025-08-25 15:56:33.248712 | 2025-08-25 15:56:33.248796 | LOOP [emit-job-header : Print node information] 2025-08-25 15:56:33.514328 | debian-bookworm | ok: 2025-08-25 15:56:33.514542 | debian-bookworm | # Node Information 2025-08-25 15:56:33.514572 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-25 15:56:33.514593 | debian-bookworm | Hostname: debian 2025-08-25 15:56:33.514611 | debian-bookworm | Username: zuul 2025-08-25 15:56:33.514628 | debian-bookworm | Distro: Debian 12.11 2025-08-25 15:56:33.514648 | debian-bookworm | Provider: regiocloud-a 2025-08-25 15:56:33.514665 | debian-bookworm | Region: 2025-08-25 15:56:33.514683 | debian-bookworm | Label: debian-bookworm 2025-08-25 15:56:33.514699 | debian-bookworm | Product Name: OpenStack Nova 2025-08-25 15:56:33.514715 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef4:7a92 2025-08-25 15:56:33.526987 | 2025-08-25 15:56:33.527093 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-25 15:56:34.253990 | debian-bookworm -> localhost | changed 2025-08-25 15:56:34.259874 | 2025-08-25 15:56:34.259960 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-25 15:56:36.280290 | debian-bookworm -> localhost | changed 2025-08-25 15:56:36.288992 | 2025-08-25 15:56:36.289087 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-25 15:56:36.847838 | debian-bookworm -> localhost | ok 2025-08-25 15:56:36.857801 | 2025-08-25 15:56:36.857901 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-25 15:56:36.894774 | debian-bookworm | ok 2025-08-25 15:56:36.919106 | debian-bookworm | included: /var/lib/zuul/builds/6fa528e3c96e4617a7dc3cff6d201399/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-25 15:56:36.927937 | 2025-08-25 15:56:36.928050 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-25 15:56:39.279896 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-25 15:56:39.280092 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6fa528e3c96e4617a7dc3cff6d201399/work/6fa528e3c96e4617a7dc3cff6d201399_id_rsa 2025-08-25 15:56:39.280129 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6fa528e3c96e4617a7dc3cff6d201399/work/6fa528e3c96e4617a7dc3cff6d201399_id_rsa.pub 2025-08-25 15:56:39.280155 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-25 15:56:39.280179 | debian-bookworm -> localhost | SHA256:wsR8m8cbk8dWMLrzl3fndPecW3Xj5HbEPuyNA/r+iV0 zuul-build-sshkey 2025-08-25 15:56:39.280201 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-25 15:56:39.280233 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-25 15:56:39.280256 | debian-bookworm -> localhost | | o | 2025-08-25 15:56:39.280278 | debian-bookworm -> localhost | | o . o | 2025-08-25 15:56:39.280298 | debian-bookworm -> localhost | | + . . . | 2025-08-25 15:56:39.280318 | debian-bookworm -> localhost | | o . + + . . | 2025-08-25 15:56:39.280338 | debian-bookworm -> localhost | | o S O + o=| 2025-08-25 15:56:39.280365 | debian-bookworm -> localhost | | . . O. =++| 2025-08-25 15:56:39.280386 | debian-bookworm -> localhost | | ....o*E| 2025-08-25 15:56:39.280405 | debian-bookworm -> localhost | | . ++O%| 2025-08-25 15:56:39.280425 | debian-bookworm -> localhost | | o+.==*| 2025-08-25 15:56:39.280445 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-25 15:56:39.280491 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.397030 2025-08-25 15:56:39.286439 | 2025-08-25 15:56:39.286527 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-25 15:56:39.314891 | debian-bookworm | ok 2025-08-25 15:56:39.331435 | debian-bookworm | included: /var/lib/zuul/builds/6fa528e3c96e4617a7dc3cff6d201399/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-25 15:56:39.350918 | 2025-08-25 15:56:39.351029 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-25 15:56:39.384477 | debian-bookworm | skipping: Conditional result was False 2025-08-25 15:56:39.390205 | 2025-08-25 15:56:39.390302 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-25 15:56:40.132835 | debian-bookworm | changed 2025-08-25 15:56:40.137167 | 2025-08-25 15:56:40.137236 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-25 15:56:40.417015 | debian-bookworm | ok 2025-08-25 15:56:40.421391 | 2025-08-25 15:56:40.421470 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-25 15:56:41.146816 | debian-bookworm | changed 2025-08-25 15:56:41.156296 | 2025-08-25 15:56:41.156380 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-25 15:56:41.826600 | debian-bookworm | changed 2025-08-25 15:56:41.830978 | 2025-08-25 15:56:41.831059 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-25 15:56:41.875220 | debian-bookworm | skipping: Conditional result was False 2025-08-25 15:56:41.880105 | 2025-08-25 15:56:41.880262 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-25 15:56:42.451181 | debian-bookworm -> localhost | changed 2025-08-25 15:56:42.460597 | 2025-08-25 15:56:42.460689 | TASK [add-build-sshkey : Add back temp key] 2025-08-25 15:56:42.797248 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6fa528e3c96e4617a7dc3cff6d201399/work/6fa528e3c96e4617a7dc3cff6d201399_id_rsa (zuul-build-sshkey) 2025-08-25 15:56:42.797697 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012810 2025-08-25 15:56:42.811466 | 2025-08-25 15:56:42.811601 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-25 15:56:43.245754 | debian-bookworm | ok 2025-08-25 15:56:43.250429 | 2025-08-25 15:56:43.250514 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-25 15:56:43.273161 | debian-bookworm | skipping: Conditional result was False 2025-08-25 15:56:43.282808 | 2025-08-25 15:56:43.282946 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-25 15:56:43.674104 | debian-bookworm | ok 2025-08-25 15:56:43.686377 | 2025-08-25 15:56:43.686471 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-25 15:56:43.733309 | debian-bookworm | ok 2025-08-25 15:56:43.737440 | 2025-08-25 15:56:43.737520 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-25 15:56:44.256490 | debian-bookworm -> localhost | ok 2025-08-25 15:56:44.261624 | 2025-08-25 15:56:44.261703 | TASK [validate-host : Collect information about the host] 2025-08-25 15:56:45.466291 | debian-bookworm | ok 2025-08-25 15:56:45.496399 | 2025-08-25 15:56:45.496517 | TASK [validate-host : Sanitize hostname] 2025-08-25 15:56:45.667849 | debian-bookworm | ok 2025-08-25 15:56:45.768515 | 2025-08-25 15:56:45.768625 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-25 15:56:47.077940 | debian-bookworm -> localhost | changed 2025-08-25 15:56:47.083391 | 2025-08-25 15:56:47.083482 | TASK [validate-host : Collect information about zuul worker] 2025-08-25 15:56:47.707443 | debian-bookworm | ok 2025-08-25 15:56:47.711924 | 2025-08-25 15:56:47.712035 | TASK [validate-host : Write out all zuul information for each host] 2025-08-25 15:56:48.656578 | debian-bookworm -> localhost | changed 2025-08-25 15:56:48.668096 | 2025-08-25 15:56:48.668195 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-25 15:56:48.981899 | debian-bookworm | ok 2025-08-25 15:56:48.988785 | 2025-08-25 15:56:48.989538 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-25 15:56:50.260425 | debian-bookworm | changed: 2025-08-25 15:56:50.260611 | debian-bookworm | cd+++++++++ src/ 2025-08-25 15:56:50.260643 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-25 15:56:50.260667 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-25 15:56:50.260689 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-08-25 15:56:50.260710 | debian-bookworm | Containerfile 2025-08-25 15:56:50.260904 | debian-bookworm | localhost | ok: Runtime: 0:00:00.038106 2025-08-25 15:57:20.709506 | 2025-08-25 15:57:20.709589 | TASK [upload-logs : Upload logs to log server] 2025-08-25 15:57:21.983835 | localhost | Output suppressed because no_log was given 2025-08-25 15:57:21.985334 | 2025-08-25 15:57:21.985406 | LOOP [upload-logs : Compress console log and json output] 2025-08-25 15:57:22.174578 | localhost | skipping: Conditional result was False 2025-08-25 15:57:22.186333 | localhost | skipping: Conditional result was False 2025-08-25 15:57:22.188839 | 2025-08-25 15:57:22.188929 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-25 15:57:22.238524 | localhost | skipping: Conditional result was False 2025-08-25 15:57:22.238717 | 2025-08-25 15:57:22.242384 | localhost | skipping: Conditional result was False 2025-08-25 15:57:22.247460 | 2025-08-25 15:57:22.247533 | LOOP [upload-logs : Upload console log and json output]