2025-12-25 03:11:06.785425 | Job console starting 2025-12-25 03:11:06.824764 | Updating git repos 2025-12-25 03:11:06.883984 | Cloning repos into workspace 2025-12-25 03:11:06.954820 | Restoring repo states 2025-12-25 03:11:06.994568 | Merging changes 2025-12-25 03:11:06.994590 | Checking out repos 2025-12-25 03:11:07.246600 | Preparing playbooks 2025-12-25 03:11:09.264057 | Running Ansible setup 2025-12-25 03:11:18.846471 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-25 03:11:21.419564 | 2025-12-25 03:11:21.419748 | PLAY [Base pre] 2025-12-25 03:11:21.477092 | 2025-12-25 03:11:21.477313 | TASK [Setup log path fact] 2025-12-25 03:11:21.568486 | debian-bookworm | ok 2025-12-25 03:11:21.612198 | 2025-12-25 03:11:21.612423 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-25 03:11:21.736358 | debian-bookworm | ok 2025-12-25 03:11:21.785180 | 2025-12-25 03:11:21.785367 | TASK [emit-job-header : Print job information] 2025-12-25 03:11:21.879985 | # Job Information 2025-12-25 03:11:21.880183 | Ansible Version: 2.16.14 2025-12-25 03:11:21.880238 | Job: python-black 2025-12-25 03:11:21.880271 | Pipeline: periodic-daily 2025-12-25 03:11:21.880294 | Executor: 521e9411259a 2025-12-25 03:11:21.880315 | Triggered by: https://github.com/osism/python-osism 2025-12-25 03:11:21.880338 | Event ID: ac5f3779a09f4a708a9411634609e0b8 2025-12-25 03:11:21.885484 | 2025-12-25 03:11:21.885605 | LOOP [emit-job-header : Print node information] 2025-12-25 03:11:22.154125 | debian-bookworm | ok: 2025-12-25 03:11:22.154353 | debian-bookworm | # Node Information 2025-12-25 03:11:22.154389 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-25 03:11:22.154416 | debian-bookworm | Hostname: debian 2025-12-25 03:11:22.154439 | debian-bookworm | Username: zuul 2025-12-25 03:11:22.154460 | debian-bookworm | Distro: Debian 12.12 2025-12-25 03:11:22.154483 | debian-bookworm | Provider: regiocloud-a 2025-12-25 03:11:22.154504 | debian-bookworm | Region: 2025-12-25 03:11:22.154525 | debian-bookworm | Label: debian-bookworm 2025-12-25 03:11:22.154544 | debian-bookworm | Product Name: OpenStack Nova 2025-12-25 03:11:22.154942 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feaa:9d30 2025-12-25 03:11:22.173438 | 2025-12-25 03:11:22.173592 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-25 03:11:23.687608 | debian-bookworm -> localhost | changed 2025-12-25 03:11:23.697604 | 2025-12-25 03:11:23.697818 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-25 03:11:27.332189 | debian-bookworm -> localhost | changed 2025-12-25 03:11:27.365821 | 2025-12-25 03:11:27.367763 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-25 03:11:28.580735 | debian-bookworm -> localhost | ok 2025-12-25 03:11:28.607422 | 2025-12-25 03:11:28.607587 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-25 03:11:28.657790 | debian-bookworm | ok 2025-12-25 03:11:28.702752 | debian-bookworm | included: /var/lib/zuul/builds/4d1bb167883b4ba4827fe6ca63098a2b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-25 03:11:28.720006 | 2025-12-25 03:11:28.720152 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-25 03:11:30.445697 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-25 03:11:30.445983 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4d1bb167883b4ba4827fe6ca63098a2b/work/4d1bb167883b4ba4827fe6ca63098a2b_id_rsa 2025-12-25 03:11:30.446024 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4d1bb167883b4ba4827fe6ca63098a2b/work/4d1bb167883b4ba4827fe6ca63098a2b_id_rsa.pub 2025-12-25 03:11:30.446050 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-25 03:11:30.446077 | debian-bookworm -> localhost | SHA256:2S6JEvdMTQ51DK3Gy+kKR7geJHJSHumTAd6M8aHRj1U zuul-build-sshkey 2025-12-25 03:11:30.446100 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-25 03:11:30.446134 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-25 03:11:30.446156 | debian-bookworm -> localhost | | +.. .E o+. | 2025-12-25 03:11:30.446178 | debian-bookworm -> localhost | | . X.o. . .o | 2025-12-25 03:11:30.446198 | debian-bookworm -> localhost | | + O+ .... | 2025-12-25 03:11:30.446269 | debian-bookworm -> localhost | | +.+.. B+ | 2025-12-25 03:11:30.446294 | debian-bookworm -> localhost | | o O + So+o | 2025-12-25 03:11:30.446318 | debian-bookworm -> localhost | | + * B o+ | 2025-12-25 03:11:30.446339 | debian-bookworm -> localhost | | . = *.. | 2025-12-25 03:11:30.446359 | debian-bookworm -> localhost | | o + .. | 2025-12-25 03:11:30.446380 | debian-bookworm -> localhost | | . .. | 2025-12-25 03:11:30.446401 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-25 03:11:30.446455 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.482590 2025-12-25 03:11:30.455338 | 2025-12-25 03:11:30.455475 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-25 03:11:30.490468 | debian-bookworm | ok 2025-12-25 03:11:30.501429 | debian-bookworm | included: /var/lib/zuul/builds/4d1bb167883b4ba4827fe6ca63098a2b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-25 03:11:30.520872 | 2025-12-25 03:11:30.521023 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-25 03:11:30.550098 | debian-bookworm | skipping: Conditional result was False 2025-12-25 03:11:30.557586 | 2025-12-25 03:11:30.557866 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-25 03:11:31.387904 | debian-bookworm | changed 2025-12-25 03:11:31.393821 | 2025-12-25 03:11:31.393939 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-25 03:11:31.678397 | debian-bookworm | ok 2025-12-25 03:11:31.685735 | 2025-12-25 03:11:31.685871 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-25 03:11:32.475895 | debian-bookworm | changed 2025-12-25 03:11:32.487499 | 2025-12-25 03:11:32.487639 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-25 03:11:33.352150 | debian-bookworm | changed 2025-12-25 03:11:33.363067 | 2025-12-25 03:11:33.363203 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-25 03:11:33.413497 | debian-bookworm | skipping: Conditional result was False 2025-12-25 03:11:33.424952 | 2025-12-25 03:11:33.425095 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-25 03:11:34.551144 | debian-bookworm -> localhost | changed 2025-12-25 03:11:34.565754 | 2025-12-25 03:11:34.565895 | TASK [add-build-sshkey : Add back temp key] 2025-12-25 03:11:35.549964 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4d1bb167883b4ba4827fe6ca63098a2b/work/4d1bb167883b4ba4827fe6ca63098a2b_id_rsa (zuul-build-sshkey) 2025-12-25 03:11:35.550240 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.037574 2025-12-25 03:11:35.562970 | 2025-12-25 03:11:35.563145 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-25 03:11:36.012400 | debian-bookworm | ok 2025-12-25 03:11:36.020911 | 2025-12-25 03:11:36.021042 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-25 03:11:36.048729 | debian-bookworm | skipping: Conditional result was False 2025-12-25 03:11:36.079759 | 2025-12-25 03:11:36.079900 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-25 03:11:37.537052 | debian-bookworm | ok 2025-12-25 03:11:37.638110 | 2025-12-25 03:11:37.638318 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-25 03:11:37.801166 | debian-bookworm | ok 2025-12-25 03:11:37.815093 | 2025-12-25 03:11:37.815260 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-25 03:11:39.060860 | debian-bookworm -> localhost | ok 2025-12-25 03:11:39.067975 | 2025-12-25 03:11:39.068118 | TASK [validate-host : Collect information about the host] 2025-12-25 03:11:41.193118 | debian-bookworm | ok 2025-12-25 03:11:41.234173 | 2025-12-25 03:11:41.265010 | TASK [validate-host : Sanitize hostname] 2025-12-25 03:11:41.674601 | debian-bookworm | ok 2025-12-25 03:11:41.900605 | 2025-12-25 03:11:41.900758 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-25 03:11:43.699264 | debian-bookworm -> localhost | changed 2025-12-25 03:11:43.709125 | 2025-12-25 03:11:43.709294 | TASK [validate-host : Collect information about zuul worker] 2025-12-25 03:11:44.388705 | debian-bookworm | ok 2025-12-25 03:11:44.396709 | 2025-12-25 03:11:44.396847 | TASK [validate-host : Write out all zuul information for each host] 2025-12-25 03:11:45.903305 | debian-bookworm -> localhost | changed 2025-12-25 03:11:45.935667 | 2025-12-25 03:11:45.935984 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-25 03:11:46.305691 | debian-bookworm | ok 2025-12-25 03:11:46.318978 | 2025-12-25 03:11:46.319132 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-25 03:11:47.703099 | debian-bookworm | changed: 2025-12-25 03:11:47.703475 | debian-bookworm | cd+++++++++ src/ 2025-12-25 03:11:47.703523 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-25 03:11:47.703548 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-25 03:11:47.703570 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-25 03:11:47.703590 | debian-bookworm | Containerfile 2025-12-25 03:11:47.703723 | debian-bookworm | Containerfile 2025-12-25 03:11:47.717501 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007034 2025-12-25 03:12:26.456324 | 2025-12-25 03:12:26.456454 | TASK [upload-logs : Upload logs to log server] 2025-12-25 03:12:27.240251 | localhost | Output suppressed because no_log was given 2025-12-25 03:12:27.242114 | 2025-12-25 03:12:27.242245 | LOOP [upload-logs : Compress console log and json output] 2025-12-25 03:12:27.356012 | localhost | skipping: Conditional result was False 2025-12-25 03:12:27.376394 | localhost | skipping: Conditional result was False 2025-12-25 03:12:27.381077 | 2025-12-25 03:12:27.381210 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-25 03:12:27.485815 | localhost | skipping: Conditional result was False 2025-12-25 03:12:27.486107 | 2025-12-25 03:12:27.503664 | localhost | skipping: Conditional result was False 2025-12-25 03:12:27.510947 | 2025-12-25 03:12:27.511087 | LOOP [upload-logs : Upload console log and json output]