2025-10-21 17:09:15.333418 | Job console starting 2025-10-21 17:09:15.349482 | Updating git repos 2025-10-21 17:09:15.433912 | Cloning repos into workspace 2025-10-21 17:09:15.485109 | Restoring repo states 2025-10-21 17:09:15.495133 | Merging changes 2025-10-21 17:09:16.034972 | Checking out repos 2025-10-21 17:09:16.103948 | Preparing playbooks 2025-10-21 17:09:17.147763 | Running Ansible setup 2025-10-21 17:09:22.697222 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-21 17:09:23.593081 | 2025-10-21 17:09:23.593206 | PLAY [Base pre] 2025-10-21 17:09:23.609597 | 2025-10-21 17:09:23.609717 | TASK [Setup log path fact] 2025-10-21 17:09:23.627482 | debian-bookworm | ok 2025-10-21 17:09:23.649179 | 2025-10-21 17:09:23.649310 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-21 17:09:23.688282 | debian-bookworm | ok 2025-10-21 17:09:23.698113 | 2025-10-21 17:09:23.698228 | TASK [emit-job-header : Print job information] 2025-10-21 17:09:23.763334 | # Job Information 2025-10-21 17:09:23.763515 | Ansible Version: 2.16.14 2025-10-21 17:09:23.763551 | Job: python-black 2025-10-21 17:09:23.763584 | Pipeline: check 2025-10-21 17:09:23.763608 | Executor: 521e9411259a 2025-10-21 17:09:23.763628 | Triggered by: https://github.com/osism/python-osism/pull/1769 2025-10-21 17:09:23.763650 | Event ID: a5b41bd0-aea0-11f0-9db1-8bd8e12b405c 2025-10-21 17:09:23.768421 | 2025-10-21 17:09:23.768512 | LOOP [emit-job-header : Print node information] 2025-10-21 17:09:23.947279 | debian-bookworm | ok: 2025-10-21 17:09:23.947478 | debian-bookworm | # Node Information 2025-10-21 17:09:23.947527 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-21 17:09:23.947565 | debian-bookworm | Hostname: debian 2025-10-21 17:09:23.947590 | debian-bookworm | Username: zuul 2025-10-21 17:09:23.947611 | debian-bookworm | Distro: Debian 12.12 2025-10-21 17:09:23.947638 | debian-bookworm | Provider: regiocloud-a 2025-10-21 17:09:23.947659 | debian-bookworm | Region: 2025-10-21 17:09:23.947680 | debian-bookworm | Label: debian-bookworm 2025-10-21 17:09:23.947701 | debian-bookworm | Product Name: OpenStack Nova 2025-10-21 17:09:23.947721 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7d:885 2025-10-21 17:09:23.967127 | 2025-10-21 17:09:23.967241 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-21 17:09:24.739139 | debian-bookworm -> localhost | changed 2025-10-21 17:09:24.746677 | 2025-10-21 17:09:24.746808 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-21 17:09:26.795595 | debian-bookworm -> localhost | changed 2025-10-21 17:09:26.804084 | 2025-10-21 17:09:26.804168 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-21 17:09:27.174800 | debian-bookworm -> localhost | ok 2025-10-21 17:09:27.182419 | 2025-10-21 17:09:27.182529 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-21 17:09:27.215943 | debian-bookworm | ok 2025-10-21 17:09:27.241896 | debian-bookworm | included: /var/lib/zuul/builds/512135b4e6024cc0b399d27fe2f019e1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-21 17:09:27.257077 | 2025-10-21 17:09:27.257169 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-21 17:09:29.500229 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-21 17:09:29.500417 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/512135b4e6024cc0b399d27fe2f019e1/work/512135b4e6024cc0b399d27fe2f019e1_id_rsa 2025-10-21 17:09:29.500451 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/512135b4e6024cc0b399d27fe2f019e1/work/512135b4e6024cc0b399d27fe2f019e1_id_rsa.pub 2025-10-21 17:09:29.500474 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-21 17:09:29.500494 | debian-bookworm -> localhost | SHA256:BCuousc69dWU8I1kbVORedYEP0xEHqQE2YsHExdevME zuul-build-sshkey 2025-10-21 17:09:29.500513 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-21 17:09:29.500537 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-21 17:09:29.500556 | debian-bookworm -> localhost | | . . +BBO@.| 2025-10-21 17:09:29.500575 | debian-bookworm -> localhost | | . .oo ++*.OEo| 2025-10-21 17:09:29.500593 | debian-bookworm -> localhost | | . . .=.= .+=.++| 2025-10-21 17:09:29.500609 | debian-bookworm -> localhost | | . . .= .. o ..| 2025-10-21 17:09:29.500626 | debian-bookworm -> localhost | |. oS . | 2025-10-21 17:09:29.500646 | debian-bookworm -> localhost | |. . . . | 2025-10-21 17:09:29.500664 | debian-bookworm -> localhost | |.o . . | 2025-10-21 17:09:29.500681 | debian-bookworm -> localhost | |..o . | 2025-10-21 17:09:29.500699 | debian-bookworm -> localhost | |o+ | 2025-10-21 17:09:29.500716 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-21 17:09:29.500764 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.611858 2025-10-21 17:09:29.505815 | 2025-10-21 17:09:29.505886 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-21 17:09:29.524177 | debian-bookworm | ok 2025-10-21 17:09:29.532424 | debian-bookworm | included: /var/lib/zuul/builds/512135b4e6024cc0b399d27fe2f019e1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-21 17:09:29.539598 | 2025-10-21 17:09:29.539670 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-21 17:09:29.552085 | debian-bookworm | skipping: Conditional result was False 2025-10-21 17:09:29.556709 | 2025-10-21 17:09:29.556780 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-21 17:09:30.304512 | debian-bookworm | changed 2025-10-21 17:09:30.310984 | 2025-10-21 17:09:30.311079 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-21 17:09:30.563602 | debian-bookworm | ok 2025-10-21 17:09:30.567993 | 2025-10-21 17:09:30.568066 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-21 17:09:31.158416 | debian-bookworm | changed 2025-10-21 17:09:31.165386 | 2025-10-21 17:09:31.165494 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-21 17:09:31.794108 | debian-bookworm | changed 2025-10-21 17:09:31.799429 | 2025-10-21 17:09:31.799517 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-21 17:09:31.837419 | debian-bookworm | skipping: Conditional result was False 2025-10-21 17:09:31.843115 | 2025-10-21 17:09:31.843208 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-21 17:09:32.374144 | debian-bookworm -> localhost | changed 2025-10-21 17:09:32.384831 | 2025-10-21 17:09:32.384932 | TASK [add-build-sshkey : Add back temp key] 2025-10-21 17:09:32.812817 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/512135b4e6024cc0b399d27fe2f019e1/work/512135b4e6024cc0b399d27fe2f019e1_id_rsa (zuul-build-sshkey) 2025-10-21 17:09:32.813023 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016050 2025-10-21 17:09:32.820378 | 2025-10-21 17:09:32.820464 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-21 17:09:33.221921 | debian-bookworm | ok 2025-10-21 17:09:33.226707 | 2025-10-21 17:09:33.230987 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-21 17:09:33.267951 | debian-bookworm | skipping: Conditional result was False 2025-10-21 17:09:33.277925 | 2025-10-21 17:09:33.278018 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-21 17:09:33.720970 | debian-bookworm | ok 2025-10-21 17:09:33.735904 | 2025-10-21 17:09:33.736002 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-21 17:09:33.788653 | debian-bookworm | ok 2025-10-21 17:09:33.794951 | 2025-10-21 17:09:33.795044 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-21 17:09:34.140154 | debian-bookworm -> localhost | ok 2025-10-21 17:09:34.146468 | 2025-10-21 17:09:34.146559 | TASK [validate-host : Collect information about the host] 2025-10-21 17:09:35.209220 | debian-bookworm | ok 2025-10-21 17:09:35.219071 | 2025-10-21 17:09:35.219163 | TASK [validate-host : Sanitize hostname] 2025-10-21 17:09:35.318191 | debian-bookworm | ok 2025-10-21 17:09:35.379357 | 2025-10-21 17:09:35.379467 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-21 17:09:36.277572 | debian-bookworm -> localhost | changed 2025-10-21 17:09:36.282955 | 2025-10-21 17:09:36.283041 | TASK [validate-host : Collect information about zuul worker] 2025-10-21 17:09:36.685211 | debian-bookworm | ok 2025-10-21 17:09:36.689641 | 2025-10-21 17:09:36.689724 | TASK [validate-host : Write out all zuul information for each host] 2025-10-21 17:09:37.558455 | debian-bookworm -> localhost | changed 2025-10-21 17:09:37.579115 | 2025-10-21 17:09:37.579211 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-21 17:09:37.843119 | debian-bookworm | ok 2025-10-21 17:09:37.848301 | 2025-10-21 17:09:37.848397 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-21 17:09:38.892616 | debian-bookworm | changed: 2025-10-21 17:09:38.892783 | debian-bookworm | cd+++++++++ src/ 2025-10-21 17:09:38.892817 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-21 17:09:38.892841 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-21 17:09:38.892862 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-21 17:09:38.892882 | debian-bookworm | Containerfile 2025-10-21 17:09:38.892994 | debian-bookworm | Containerfile 2025-10-21 17:09:38.904355 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007436 2025-10-21 17:10:04.691247 | 2025-10-21 17:10:04.691411 | TASK [upload-logs : Upload logs to log server] 2025-10-21 17:10:05.245564 | localhost | Output suppressed because no_log was given 2025-10-21 17:10:05.248750 | 2025-10-21 17:10:05.248902 | LOOP [upload-logs : Compress console log and json output] 2025-10-21 17:10:05.294894 | localhost | skipping: Conditional result was False 2025-10-21 17:10:05.308617 | localhost | skipping: Conditional result was False 2025-10-21 17:10:05.319483 | 2025-10-21 17:10:05.319705 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-21 17:10:05.366292 | localhost | skipping: Conditional result was False 2025-10-21 17:10:05.366589 | 2025-10-21 17:10:05.381299 | localhost | skipping: Conditional result was False 2025-10-21 17:10:05.391438 | 2025-10-21 17:10:05.391661 | LOOP [upload-logs : Upload console log and json output]