2025-11-22 19:02:22.617826 | Job console starting 2025-11-22 19:02:22.657495 | Updating git repos 2025-11-22 19:02:22.728502 | Cloning repos into workspace 2025-11-22 19:02:22.812867 | Restoring repo states 2025-11-22 19:02:22.869331 | Merging changes 2025-11-22 19:02:23.538552 | Checking out repos 2025-11-22 19:02:23.607164 | Preparing playbooks 2025-11-22 19:02:24.896378 | Running Ansible setup 2025-11-22 19:02:30.464093 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-22 19:02:31.705575 | 2025-11-22 19:02:31.705758 | PLAY [Base pre] 2025-11-22 19:02:31.746969 | 2025-11-22 19:02:31.747128 | TASK [Setup log path fact] 2025-11-22 19:02:31.794448 | debian-bookworm | ok 2025-11-22 19:02:31.822634 | 2025-11-22 19:02:31.822816 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-22 19:02:31.875716 | debian-bookworm | ok 2025-11-22 19:02:31.898315 | 2025-11-22 19:02:31.898466 | TASK [emit-job-header : Print job information] 2025-11-22 19:02:31.981155 | # Job Information 2025-11-22 19:02:31.981463 | Ansible Version: 2.16.14 2025-11-22 19:02:31.981503 | Job: python-black 2025-11-22 19:02:31.981544 | Pipeline: check 2025-11-22 19:02:31.981571 | Executor: 521e9411259a 2025-11-22 19:02:31.981591 | Triggered by: https://github.com/osism/python-osism/pull/1830 2025-11-22 19:02:31.981614 | Event ID: c18389b0-c7d5-11f0-8581-9655f0d5dee3 2025-11-22 19:02:31.986980 | 2025-11-22 19:02:31.987118 | LOOP [emit-job-header : Print node information] 2025-11-22 19:02:32.231025 | debian-bookworm | ok: 2025-11-22 19:02:32.231334 | debian-bookworm | # Node Information 2025-11-22 19:02:32.231374 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-22 19:02:32.231399 | debian-bookworm | Hostname: debian 2025-11-22 19:02:32.231421 | debian-bookworm | Username: zuul 2025-11-22 19:02:32.231442 | debian-bookworm | Distro: Debian 12.12 2025-11-22 19:02:32.231466 | debian-bookworm | Provider: regiocloud-a 2025-11-22 19:02:32.231487 | debian-bookworm | Region: 2025-11-22 19:02:32.231508 | debian-bookworm | Label: debian-bookworm 2025-11-22 19:02:32.231528 | debian-bookworm | Product Name: OpenStack Nova 2025-11-22 19:02:32.231547 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef9:e12c 2025-11-22 19:02:32.259252 | 2025-11-22 19:02:32.259428 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-22 19:02:33.238938 | debian-bookworm -> localhost | changed 2025-11-22 19:02:33.246612 | 2025-11-22 19:02:33.246757 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-22 19:02:35.267149 | debian-bookworm -> localhost | changed 2025-11-22 19:02:35.278955 | 2025-11-22 19:02:35.279103 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-22 19:02:35.720010 | debian-bookworm -> localhost | ok 2025-11-22 19:02:35.726413 | 2025-11-22 19:02:35.726553 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-22 19:02:35.759370 | debian-bookworm | ok 2025-11-22 19:02:35.798541 | debian-bookworm | included: /var/lib/zuul/builds/057316f2014c45b4a9f92fbfe44a1463/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-22 19:02:35.805237 | 2025-11-22 19:02:35.805354 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-22 19:02:38.073628 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-22 19:02:38.073808 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/057316f2014c45b4a9f92fbfe44a1463/work/057316f2014c45b4a9f92fbfe44a1463_id_rsa 2025-11-22 19:02:38.073840 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/057316f2014c45b4a9f92fbfe44a1463/work/057316f2014c45b4a9f92fbfe44a1463_id_rsa.pub 2025-11-22 19:02:38.073873 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-22 19:02:38.073916 | debian-bookworm -> localhost | SHA256:kUYLoM1wy1VtD1R/crHAaUEJ3YCw8jbF3JEf+opsJVI zuul-build-sshkey 2025-11-22 19:02:38.073937 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-22 19:02:38.073963 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-22 19:02:38.073981 | debian-bookworm -> localhost | | . o.o.o+ooB*B. | 2025-11-22 19:02:38.073999 | debian-bookworm -> localhost | | B o o oB..Oooo| 2025-11-22 19:02:38.074016 | debian-bookworm -> localhost | | . = .=o *..=.+| 2025-11-22 19:02:38.074033 | debian-bookworm -> localhost | | .o..E.. = | 2025-11-22 19:02:38.074049 | debian-bookworm -> localhost | | S+. . | 2025-11-22 19:02:38.074068 | debian-bookworm -> localhost | | .... . . | 2025-11-22 19:02:38.074085 | debian-bookworm -> localhost | | o + . | 2025-11-22 19:02:38.074101 | debian-bookworm -> localhost | | + . | 2025-11-22 19:02:38.074119 | debian-bookworm -> localhost | | . | 2025-11-22 19:02:38.074136 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-22 19:02:38.074179 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.452432 2025-11-22 19:02:38.079318 | 2025-11-22 19:02:38.079389 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-22 19:02:38.118691 | debian-bookworm | ok 2025-11-22 19:02:38.129277 | debian-bookworm | included: /var/lib/zuul/builds/057316f2014c45b4a9f92fbfe44a1463/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-22 19:02:38.142632 | 2025-11-22 19:02:38.142710 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-22 19:02:38.156047 | debian-bookworm | skipping: Conditional result was False 2025-11-22 19:02:38.160775 | 2025-11-22 19:02:38.160851 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-22 19:02:39.049882 | debian-bookworm | changed 2025-11-22 19:02:39.058973 | 2025-11-22 19:02:39.059082 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-22 19:02:39.334131 | debian-bookworm | ok 2025-11-22 19:02:39.341838 | 2025-11-22 19:02:39.341955 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-22 19:02:40.064805 | debian-bookworm | changed 2025-11-22 19:02:40.072004 | 2025-11-22 19:02:40.072314 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-22 19:02:40.727175 | debian-bookworm | changed 2025-11-22 19:02:40.734977 | 2025-11-22 19:02:40.735093 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-22 19:02:40.748050 | debian-bookworm | skipping: Conditional result was False 2025-11-22 19:02:40.754865 | 2025-11-22 19:02:40.754978 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-22 19:02:41.214502 | debian-bookworm -> localhost | changed 2025-11-22 19:02:41.226029 | 2025-11-22 19:02:41.226126 | TASK [add-build-sshkey : Add back temp key] 2025-11-22 19:02:41.603835 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/057316f2014c45b4a9f92fbfe44a1463/work/057316f2014c45b4a9f92fbfe44a1463_id_rsa (zuul-build-sshkey) 2025-11-22 19:02:41.604058 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013899 2025-11-22 19:02:41.611346 | 2025-11-22 19:02:41.611447 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-22 19:02:42.049006 | debian-bookworm | ok 2025-11-22 19:02:42.053795 | 2025-11-22 19:02:42.053880 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-22 19:02:42.086765 | debian-bookworm | skipping: Conditional result was False 2025-11-22 19:02:42.098425 | 2025-11-22 19:02:42.098530 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-22 19:02:42.544016 | debian-bookworm | ok 2025-11-22 19:02:42.555298 | 2025-11-22 19:02:42.555410 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-22 19:02:42.585229 | debian-bookworm | ok 2025-11-22 19:02:42.590325 | 2025-11-22 19:02:42.590414 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-22 19:02:42.969378 | debian-bookworm -> localhost | ok 2025-11-22 19:02:42.975826 | 2025-11-22 19:02:42.975949 | TASK [validate-host : Collect information about the host] 2025-11-22 19:02:44.149351 | debian-bookworm | ok 2025-11-22 19:02:44.160092 | 2025-11-22 19:02:44.160200 | TASK [validate-host : Sanitize hostname] 2025-11-22 19:02:44.239082 | debian-bookworm | ok 2025-11-22 19:02:44.270722 | 2025-11-22 19:02:44.270847 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-22 19:02:44.991400 | debian-bookworm -> localhost | changed 2025-11-22 19:02:44.996933 | 2025-11-22 19:02:44.997033 | TASK [validate-host : Collect information about zuul worker] 2025-11-22 19:02:45.591517 | debian-bookworm | ok 2025-11-22 19:02:45.595936 | 2025-11-22 19:02:45.596028 | TASK [validate-host : Write out all zuul information for each host] 2025-11-22 19:02:46.199036 | debian-bookworm -> localhost | changed 2025-11-22 19:02:46.207944 | 2025-11-22 19:02:46.208045 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-22 19:02:46.487613 | debian-bookworm | ok 2025-11-22 19:02:46.493078 | 2025-11-22 19:02:46.493209 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-22 19:02:47.737604 | debian-bookworm | changed: 2025-11-22 19:02:47.737778 | debian-bookworm | cd+++++++++ src/ 2025-11-22 19:02:47.737812 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-22 19:02:47.737836 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-22 19:02:47.737858 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-22 19:02:47.737878 | debian-bookworm | Containerfile 2025-11-22 19:02:47.738059 | debian-bookworm | Containerfile 2025-11-22 19:02:47.748434 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007165 2025-11-22 19:03:16.660389 | 2025-11-22 19:03:16.660597 | TASK [upload-logs : Upload logs to log server] 2025-11-22 19:03:17.270623 | localhost | Output suppressed because no_log was given 2025-11-22 19:03:17.275552 | 2025-11-22 19:03:17.275797 | LOOP [upload-logs : Compress console log and json output] 2025-11-22 19:03:17.350316 | localhost | skipping: Conditional result was False 2025-11-22 19:03:17.356693 | localhost | skipping: Conditional result was False 2025-11-22 19:03:17.366245 | 2025-11-22 19:03:17.366365 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-22 19:03:17.424166 | localhost | skipping: Conditional result was False 2025-11-22 19:03:17.424830 | 2025-11-22 19:03:17.427780 | localhost | skipping: Conditional result was False 2025-11-22 19:03:17.436839 | 2025-11-22 19:03:17.437111 | LOOP [upload-logs : Upload console log and json output]