2025-07-11 19:40:06.716314 | Job console starting 2025-07-11 19:40:06.746533 | Updating git repos 2025-07-11 19:40:06.788431 | Cloning repos into workspace 2025-07-11 19:40:06.889134 | Restoring repo states 2025-07-11 19:40:06.893614 | Merging changes 2025-07-11 19:40:07.491661 | Checking out repos 2025-07-11 19:40:07.556140 | Preparing playbooks 2025-07-11 19:40:08.165992 | Running Ansible setup 2025-07-11 19:40:13.250123 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-11 19:40:14.037120 | 2025-07-11 19:40:14.037289 | PLAY [Base pre] 2025-07-11 19:40:14.061816 | 2025-07-11 19:40:14.061980 | TASK [Setup log path fact] 2025-07-11 19:40:14.081812 | debian-bookworm | ok 2025-07-11 19:40:14.098662 | 2025-07-11 19:40:14.099046 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-11 19:40:14.138152 | debian-bookworm | ok 2025-07-11 19:40:14.148847 | 2025-07-11 19:40:14.148992 | TASK [emit-job-header : Print job information] 2025-07-11 19:40:14.189068 | # Job Information 2025-07-11 19:40:14.189287 | Ansible Version: 2.16.14 2025-07-11 19:40:14.189335 | Job: python-black 2025-07-11 19:40:14.189380 | Pipeline: check 2025-07-11 19:40:14.189411 | Executor: 521e9411259a 2025-07-11 19:40:14.189432 | Triggered by: https://github.com/osism/testbed/pull/2739 2025-07-11 19:40:14.189455 | Event ID: d2e33d00-5e8e-11f0-9104-5f5eec7e8730 2025-07-11 19:40:14.194998 | 2025-07-11 19:40:14.195133 | LOOP [emit-job-header : Print node information] 2025-07-11 19:40:14.308240 | debian-bookworm | ok: 2025-07-11 19:40:14.308465 | debian-bookworm | # Node Information 2025-07-11 19:40:14.308501 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-11 19:40:14.308526 | debian-bookworm | Hostname: debian 2025-07-11 19:40:14.308548 | debian-bookworm | Username: zuul 2025-07-11 19:40:14.308569 | debian-bookworm | Distro: Debian 12.11 2025-07-11 19:40:14.308595 | debian-bookworm | Provider: regiocloud-a 2025-07-11 19:40:14.308616 | debian-bookworm | Region: 2025-07-11 19:40:14.308637 | debian-bookworm | Label: debian-bookworm 2025-07-11 19:40:14.308657 | debian-bookworm | Product Name: OpenStack Nova 2025-07-11 19:40:14.308677 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec5:621f 2025-07-11 19:40:14.322311 | 2025-07-11 19:40:14.322461 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-11 19:40:14.955806 | debian-bookworm -> localhost | changed 2025-07-11 19:40:14.963808 | 2025-07-11 19:40:14.963948 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-11 19:40:16.132107 | debian-bookworm -> localhost | changed 2025-07-11 19:40:16.155441 | 2025-07-11 19:40:16.155580 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-11 19:40:16.473273 | debian-bookworm -> localhost | ok 2025-07-11 19:40:16.479831 | 2025-07-11 19:40:16.479971 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-11 19:40:16.509093 | debian-bookworm | ok 2025-07-11 19:40:16.527811 | debian-bookworm | included: /var/lib/zuul/builds/6e6806fbf8e44acd9f44a31fb325255c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-11 19:40:16.534490 | 2025-07-11 19:40:16.534623 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-11 19:40:17.753730 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-11 19:40:17.753990 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6e6806fbf8e44acd9f44a31fb325255c/work/6e6806fbf8e44acd9f44a31fb325255c_id_rsa 2025-07-11 19:40:17.754029 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6e6806fbf8e44acd9f44a31fb325255c/work/6e6806fbf8e44acd9f44a31fb325255c_id_rsa.pub 2025-07-11 19:40:17.754056 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-11 19:40:17.754082 | debian-bookworm -> localhost | SHA256:pFu17IrVvwyQtLv7W3Dx5E3zgWwnW8Gd0o3oqrsSd1c zuul-build-sshkey 2025-07-11 19:40:17.754104 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-11 19:40:17.754137 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-11 19:40:17.754160 | debian-bookworm -> localhost | | .oo+| 2025-07-11 19:40:17.754182 | debian-bookworm -> localhost | | o.o++| 2025-07-11 19:40:17.754202 | debian-bookworm -> localhost | | o ...=o=.| 2025-07-11 19:40:17.754221 | debian-bookworm -> localhost | | + = .o=Eo+| 2025-07-11 19:40:17.754241 | debian-bookworm -> localhost | | . S +..oo o| 2025-07-11 19:40:17.754267 | debian-bookworm -> localhost | | .o.=oo. | 2025-07-11 19:40:17.754288 | debian-bookworm -> localhost | | .ooo+.. | 2025-07-11 19:40:17.754307 | debian-bookworm -> localhost | | .o.o = | 2025-07-11 19:40:17.754328 | debian-bookworm -> localhost | | ..*=o.+. | 2025-07-11 19:40:17.754349 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-11 19:40:17.754407 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.717302 2025-07-11 19:40:17.761292 | 2025-07-11 19:40:17.761400 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-11 19:40:17.789928 | debian-bookworm | ok 2025-07-11 19:40:17.799748 | debian-bookworm | included: /var/lib/zuul/builds/6e6806fbf8e44acd9f44a31fb325255c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-11 19:40:17.809477 | 2025-07-11 19:40:17.809602 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-11 19:40:17.834645 | debian-bookworm | skipping: Conditional result was False 2025-07-11 19:40:17.841365 | 2025-07-11 19:40:17.841497 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-11 19:40:18.481581 | debian-bookworm | changed 2025-07-11 19:40:18.496686 | 2025-07-11 19:40:18.496949 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-11 19:40:18.758509 | debian-bookworm | ok 2025-07-11 19:40:18.772023 | 2025-07-11 19:40:18.772201 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-11 19:40:19.476580 | debian-bookworm | changed 2025-07-11 19:40:19.488109 | 2025-07-11 19:40:19.488322 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-11 19:40:20.192678 | debian-bookworm | changed 2025-07-11 19:40:20.208033 | 2025-07-11 19:40:20.208174 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-11 19:40:20.232946 | debian-bookworm | skipping: Conditional result was False 2025-07-11 19:40:20.239740 | 2025-07-11 19:40:20.239860 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-11 19:40:20.829769 | debian-bookworm -> localhost | changed 2025-07-11 19:40:20.845683 | 2025-07-11 19:40:20.845888 | TASK [add-build-sshkey : Add back temp key] 2025-07-11 19:40:21.442286 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6e6806fbf8e44acd9f44a31fb325255c/work/6e6806fbf8e44acd9f44a31fb325255c_id_rsa (zuul-build-sshkey) 2025-07-11 19:40:21.442548 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018464 2025-07-11 19:40:21.451311 | 2025-07-11 19:40:21.451447 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-11 19:40:21.983756 | debian-bookworm | ok 2025-07-11 19:40:21.989652 | 2025-07-11 19:40:21.989807 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-11 19:40:22.016782 | debian-bookworm | skipping: Conditional result was False 2025-07-11 19:40:22.028825 | 2025-07-11 19:40:22.028969 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-11 19:40:22.521528 | debian-bookworm | ok 2025-07-11 19:40:22.533300 | 2025-07-11 19:40:22.533446 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-11 19:40:22.562615 | debian-bookworm | ok 2025-07-11 19:40:22.567891 | 2025-07-11 19:40:22.568013 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-11 19:40:22.978897 | debian-bookworm -> localhost | ok 2025-07-11 19:40:22.987585 | 2025-07-11 19:40:22.987740 | TASK [validate-host : Collect information about the host] 2025-07-11 19:40:24.360419 | debian-bookworm | ok 2025-07-11 19:40:24.388164 | 2025-07-11 19:40:24.388318 | TASK [validate-host : Sanitize hostname] 2025-07-11 19:40:24.563483 | debian-bookworm | ok 2025-07-11 19:40:24.614732 | 2025-07-11 19:40:24.614889 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-11 19:40:25.996409 | debian-bookworm -> localhost | changed 2025-07-11 19:40:26.003070 | 2025-07-11 19:40:26.003213 | TASK [validate-host : Collect information about zuul worker] 2025-07-11 19:40:26.606326 | debian-bookworm | ok 2025-07-11 19:40:26.612429 | 2025-07-11 19:40:26.612578 | TASK [validate-host : Write out all zuul information for each host] 2025-07-11 19:40:27.402079 | debian-bookworm -> localhost | changed 2025-07-11 19:40:27.418002 | 2025-07-11 19:40:27.418151 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-11 19:40:27.754217 | debian-bookworm | ok 2025-07-11 19:40:27.761350 | 2025-07-11 19:40:27.761478 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-11 19:40:29.048875 | debian-bookworm | changed: 2025-07-11 19:40:29.049104 | debian-bookworm | cd+++++++++ src/ 2025-07-11 19:40:29.049140 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-11 19:40:29.049164 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-11 19:40:29.049185 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-07-11 19:40:29.049205 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008745 2025-07-11 19:40:55.914202 | 2025-07-11 19:40:55.914331 | TASK [upload-logs : Upload logs to log server] 2025-07-11 19:40:56.488720 | localhost | Output suppressed because no_log was given 2025-07-11 19:40:56.491931 | 2025-07-11 19:40:56.492263 | LOOP [upload-logs : Compress console log and json output] 2025-07-11 19:40:56.569924 | localhost | skipping: Conditional result was False 2025-07-11 19:40:56.575418 | localhost | skipping: Conditional result was False 2025-07-11 19:40:56.585911 | 2025-07-11 19:40:56.586077 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-11 19:40:56.637008 | localhost | skipping: Conditional result was False 2025-07-11 19:40:56.637325 | 2025-07-11 19:40:56.642303 | localhost | skipping: Conditional result was False 2025-07-11 19:40:56.653552 | 2025-07-11 19:40:56.653694 | LOOP [upload-logs : Upload console log and json output]