2025-10-07 17:46:34.418035 | Job console starting 2025-10-07 17:46:34.438708 | Updating git repos 2025-10-07 17:46:34.490942 | Cloning repos into workspace 2025-10-07 17:46:34.545502 | Restoring repo states 2025-10-07 17:46:34.550592 | Merging changes 2025-10-07 17:46:35.120557 | Checking out repos 2025-10-07 17:46:35.163493 | Preparing playbooks 2025-10-07 17:46:36.285489 | Running Ansible setup 2025-10-07 17:46:43.182905 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-07 17:46:45.432620 | 2025-10-07 17:46:45.432786 | PLAY [Base pre] 2025-10-07 17:46:45.461608 | 2025-10-07 17:46:45.461725 | TASK [Setup log path fact] 2025-10-07 17:46:45.491797 | debian-bookworm | ok 2025-10-07 17:46:45.536217 | 2025-10-07 17:46:45.536353 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-07 17:46:45.597083 | debian-bookworm | ok 2025-10-07 17:46:45.609942 | 2025-10-07 17:46:45.610049 | TASK [emit-job-header : Print job information] 2025-10-07 17:46:45.701959 | # Job Information 2025-10-07 17:46:45.702112 | Ansible Version: 2.16.14 2025-10-07 17:46:45.702147 | Job: python-black 2025-10-07 17:46:45.702181 | Pipeline: check 2025-10-07 17:46:45.702204 | Executor: 521e9411259a 2025-10-07 17:46:45.702225 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/789 2025-10-07 17:46:45.702247 | Event ID: 8ba4f3a0-a3a5-11f0-9b5b-4f8f9ee359e5 2025-10-07 17:46:45.707020 | 2025-10-07 17:46:45.707118 | LOOP [emit-job-header : Print node information] 2025-10-07 17:46:45.965027 | debian-bookworm | ok: 2025-10-07 17:46:45.965246 | debian-bookworm | # Node Information 2025-10-07 17:46:45.965282 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-07 17:46:45.965306 | debian-bookworm | Hostname: debian 2025-10-07 17:46:45.965328 | debian-bookworm | Username: zuul 2025-10-07 17:46:45.965348 | debian-bookworm | Distro: Debian 12.12 2025-10-07 17:46:45.967385 | debian-bookworm | Provider: regiocloud-a 2025-10-07 17:46:45.967452 | debian-bookworm | Region: 2025-10-07 17:46:45.967479 | debian-bookworm | Label: debian-bookworm 2025-10-07 17:46:45.967502 | debian-bookworm | Product Name: OpenStack Nova 2025-10-07 17:46:45.967523 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3c:f22a 2025-10-07 17:46:45.989143 | 2025-10-07 17:46:45.989259 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-07 17:46:47.003531 | debian-bookworm -> localhost | changed 2025-10-07 17:46:47.009325 | 2025-10-07 17:46:47.009415 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-07 17:46:48.540735 | debian-bookworm -> localhost | changed 2025-10-07 17:46:48.549109 | 2025-10-07 17:46:48.549195 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-07 17:46:49.070712 | debian-bookworm -> localhost | ok 2025-10-07 17:46:49.075864 | 2025-10-07 17:46:49.075952 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-07 17:46:49.112441 | debian-bookworm | ok 2025-10-07 17:46:49.146202 | debian-bookworm | included: /var/lib/zuul/builds/9ad60ca28fc14fdfb4e8b621d89502b8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-07 17:46:49.175766 | 2025-10-07 17:46:49.175886 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-07 17:46:50.936328 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-07 17:46:50.936485 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9ad60ca28fc14fdfb4e8b621d89502b8/work/9ad60ca28fc14fdfb4e8b621d89502b8_id_rsa 2025-10-07 17:46:50.936515 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9ad60ca28fc14fdfb4e8b621d89502b8/work/9ad60ca28fc14fdfb4e8b621d89502b8_id_rsa.pub 2025-10-07 17:46:50.936536 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-07 17:46:50.936555 | debian-bookworm -> localhost | SHA256:rPhaXX7LHMLHI2i1wTbjQdI5Ng2Y5LuclwyzdhkCyDE zuul-build-sshkey 2025-10-07 17:46:50.936572 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-07 17:46:50.936597 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-07 17:46:50.936615 | debian-bookworm -> localhost | | E ..o. | 2025-10-07 17:46:50.936633 | debian-bookworm -> localhost | | . + .o. + | 2025-10-07 17:46:50.936649 | debian-bookworm -> localhost | | o . o B . | 2025-10-07 17:46:50.936665 | debian-bookworm -> localhost | | o * o | 2025-10-07 17:46:50.936681 | debian-bookworm -> localhost | | S @ | 2025-10-07 17:46:50.936705 | debian-bookworm -> localhost | | . + ^ @ | 2025-10-07 17:46:50.936722 | debian-bookworm -> localhost | | . o X & * | 2025-10-07 17:46:50.936738 | debian-bookworm -> localhost | | o o o B + | 2025-10-07 17:46:50.936755 | debian-bookworm -> localhost | | ... + | 2025-10-07 17:46:50.936771 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-07 17:46:50.936829 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.000713 2025-10-07 17:46:50.941845 | 2025-10-07 17:46:50.941918 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-07 17:46:50.968464 | debian-bookworm | ok 2025-10-07 17:46:50.976022 | debian-bookworm | included: /var/lib/zuul/builds/9ad60ca28fc14fdfb4e8b621d89502b8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-07 17:46:50.993271 | 2025-10-07 17:46:50.993348 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-07 17:46:51.025932 | debian-bookworm | skipping: Conditional result was False 2025-10-07 17:46:51.030546 | 2025-10-07 17:46:51.030623 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-07 17:46:51.701260 | debian-bookworm | changed 2025-10-07 17:46:51.705453 | 2025-10-07 17:46:51.705525 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-07 17:46:51.942962 | debian-bookworm | ok 2025-10-07 17:46:51.948351 | 2025-10-07 17:46:51.948442 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-07 17:46:52.558556 | debian-bookworm | changed 2025-10-07 17:46:52.565117 | 2025-10-07 17:46:52.565199 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-07 17:46:53.203021 | debian-bookworm | changed 2025-10-07 17:46:53.217645 | 2025-10-07 17:46:53.217746 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-07 17:46:53.240850 | debian-bookworm | skipping: Conditional result was False 2025-10-07 17:46:53.247438 | 2025-10-07 17:46:53.247533 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-07 17:46:53.725682 | debian-bookworm -> localhost | changed 2025-10-07 17:46:53.735878 | 2025-10-07 17:46:53.735968 | TASK [add-build-sshkey : Add back temp key] 2025-10-07 17:46:54.110661 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9ad60ca28fc14fdfb4e8b621d89502b8/work/9ad60ca28fc14fdfb4e8b621d89502b8_id_rsa (zuul-build-sshkey) 2025-10-07 17:46:54.110926 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016333 2025-10-07 17:46:54.118931 | 2025-10-07 17:46:54.119029 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-07 17:46:54.484145 | debian-bookworm | ok 2025-10-07 17:46:54.488959 | 2025-10-07 17:46:54.489045 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-07 17:46:54.511861 | debian-bookworm | skipping: Conditional result was False 2025-10-07 17:46:54.521564 | 2025-10-07 17:46:54.521658 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-07 17:46:54.992826 | debian-bookworm | ok 2025-10-07 17:46:55.009934 | 2025-10-07 17:46:55.010037 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-07 17:46:55.052289 | debian-bookworm | ok 2025-10-07 17:46:55.058299 | 2025-10-07 17:46:55.058403 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-07 17:46:55.529024 | debian-bookworm -> localhost | ok 2025-10-07 17:46:55.536662 | 2025-10-07 17:46:55.536750 | TASK [validate-host : Collect information about the host] 2025-10-07 17:46:57.786964 | debian-bookworm | ok 2025-10-07 17:46:57.821243 | 2025-10-07 17:46:57.821347 | TASK [validate-host : Sanitize hostname] 2025-10-07 17:46:58.006937 | debian-bookworm | ok 2025-10-07 17:46:58.072835 | 2025-10-07 17:46:58.072945 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-07 17:46:58.731199 | debian-bookworm -> localhost | changed 2025-10-07 17:46:58.738492 | 2025-10-07 17:46:58.738589 | TASK [validate-host : Collect information about zuul worker] 2025-10-07 17:46:59.221244 | debian-bookworm | ok 2025-10-07 17:46:59.233136 | 2025-10-07 17:46:59.234064 | TASK [validate-host : Write out all zuul information for each host] 2025-10-07 17:47:00.134177 | debian-bookworm -> localhost | changed 2025-10-07 17:47:00.143124 | 2025-10-07 17:47:00.143218 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-07 17:47:00.426955 | debian-bookworm | ok 2025-10-07 17:47:00.432062 | 2025-10-07 17:47:00.432152 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-07 17:47:01.610350 | debian-bookworm | changed: 2025-10-07 17:47:01.610543 | debian-bookworm | cd+++++++++ src/ 2025-10-07 17:47:01.610588 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-07 17:47:01.610620 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-07 17:47:01.610648 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-10-07 17:47:01.610674 | debian-bookworm | Containerfile 2025-10-07 17:47:01.610881 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004068 2025-10-07 17:47:26.008833 | 2025-10-07 17:47:26.008916 | TASK [upload-logs : Upload logs to log server] 2025-10-07 17:47:26.754266 | localhost | Output suppressed because no_log was given 2025-10-07 17:47:26.755940 | 2025-10-07 17:47:26.756025 | LOOP [upload-logs : Compress console log and json output] 2025-10-07 17:47:26.815703 | localhost | skipping: Conditional result was False 2025-10-07 17:47:26.825949 | localhost | skipping: Conditional result was False 2025-10-07 17:47:26.831668 | 2025-10-07 17:47:26.831762 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-07 17:47:26.880736 | localhost | skipping: Conditional result was False 2025-10-07 17:47:26.880934 | 2025-10-07 17:47:26.888207 | localhost | skipping: Conditional result was False 2025-10-07 17:47:26.897279 | 2025-10-07 17:47:26.897375 | LOOP [upload-logs : Upload console log and json output]