2025-08-12 20:57:13.888847 | Job console starting 2025-08-12 20:57:13.920586 | Updating git repos 2025-08-12 20:57:13.987111 | Cloning repos into workspace 2025-08-12 20:57:14.085658 | Restoring repo states 2025-08-12 20:57:14.111594 | Merging changes 2025-08-12 20:57:14.690438 | Checking out repos 2025-08-12 20:57:14.755817 | Preparing playbooks 2025-08-12 20:57:15.763683 | Running Ansible setup 2025-08-12 20:57:21.314266 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-12 20:57:22.348135 | 2025-08-12 20:57:22.348247 | PLAY [Base pre] 2025-08-12 20:57:22.360785 | 2025-08-12 20:57:22.360878 | TASK [Setup log path fact] 2025-08-12 20:57:22.377365 | debian-bookworm | ok 2025-08-12 20:57:22.407643 | 2025-08-12 20:57:22.407754 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-12 20:57:22.435185 | debian-bookworm | ok 2025-08-12 20:57:22.451297 | 2025-08-12 20:57:22.451389 | TASK [emit-job-header : Print job information] 2025-08-12 20:57:22.478996 | # Job Information 2025-08-12 20:57:22.479126 | Ansible Version: 2.16.14 2025-08-12 20:57:22.479154 | Job: python-black 2025-08-12 20:57:22.479179 | Pipeline: check 2025-08-12 20:57:22.479197 | Executor: 521e9411259a 2025-08-12 20:57:22.479214 | Triggered by: https://github.com/osism/python-osism/pull/1641 2025-08-12 20:57:22.479232 | Event ID: e6e56410-77be-11f0-977f-378271e0563c 2025-08-12 20:57:22.483219 | 2025-08-12 20:57:22.483297 | LOOP [emit-job-header : Print node information] 2025-08-12 20:57:22.653004 | debian-bookworm | ok: 2025-08-12 20:57:22.653183 | debian-bookworm | # Node Information 2025-08-12 20:57:22.653214 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-12 20:57:22.653234 | debian-bookworm | Hostname: debian 2025-08-12 20:57:22.653251 | debian-bookworm | Username: zuul 2025-08-12 20:57:22.653268 | debian-bookworm | Distro: Debian 12.11 2025-08-12 20:57:22.653287 | debian-bookworm | Provider: regiocloud-a 2025-08-12 20:57:22.653305 | debian-bookworm | Region: 2025-08-12 20:57:22.653322 | debian-bookworm | Label: debian-bookworm 2025-08-12 20:57:22.653338 | debian-bookworm | Product Name: OpenStack Nova 2025-08-12 20:57:22.653354 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5e:52cc 2025-08-12 20:57:22.682413 | 2025-08-12 20:57:22.682509 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-12 20:57:23.464084 | debian-bookworm -> localhost | changed 2025-08-12 20:57:23.469682 | 2025-08-12 20:57:23.469762 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-12 20:57:24.840582 | debian-bookworm -> localhost | changed 2025-08-12 20:57:24.849427 | 2025-08-12 20:57:24.849524 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-12 20:57:25.218193 | debian-bookworm -> localhost | ok 2025-08-12 20:57:25.223561 | 2025-08-12 20:57:25.223652 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-12 20:57:25.249900 | debian-bookworm | ok 2025-08-12 20:57:25.263684 | debian-bookworm | included: /var/lib/zuul/builds/0e1cf3237d4444d099d45ef820da9811/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-12 20:57:25.270167 | 2025-08-12 20:57:25.270245 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-12 20:57:27.079931 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-12 20:57:27.080164 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0e1cf3237d4444d099d45ef820da9811/work/0e1cf3237d4444d099d45ef820da9811_id_rsa 2025-08-12 20:57:27.080199 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0e1cf3237d4444d099d45ef820da9811/work/0e1cf3237d4444d099d45ef820da9811_id_rsa.pub 2025-08-12 20:57:27.080221 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-12 20:57:27.080241 | debian-bookworm -> localhost | SHA256:bn2FgzNKZf7MlMN/R7fF/MwM5RLmcTMUl1Lfhkfv61o zuul-build-sshkey 2025-08-12 20:57:27.080258 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-12 20:57:27.080283 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-12 20:57:27.080301 | debian-bookworm -> localhost | | .+=| 2025-08-12 20:57:27.080318 | debian-bookworm -> localhost | | ..+=| 2025-08-12 20:57:27.080334 | debian-bookworm -> localhost | | o *oO| 2025-08-12 20:57:27.080350 | debian-bookworm -> localhost | | + o = %o| 2025-08-12 20:57:27.080366 | debian-bookworm -> localhost | | S = B = O| 2025-08-12 20:57:27.080387 | debian-bookworm -> localhost | | o o B = B*| 2025-08-12 20:57:27.080404 | debian-bookworm -> localhost | | + . = .EB| 2025-08-12 20:57:27.080420 | debian-bookworm -> localhost | | . . o..| 2025-08-12 20:57:27.080437 | debian-bookworm -> localhost | | ... | 2025-08-12 20:57:27.080453 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-12 20:57:27.080496 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.260650 2025-08-12 20:57:27.085648 | 2025-08-12 20:57:27.085721 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-12 20:57:27.105049 | debian-bookworm | ok 2025-08-12 20:57:27.113114 | debian-bookworm | included: /var/lib/zuul/builds/0e1cf3237d4444d099d45ef820da9811/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-12 20:57:27.131558 | 2025-08-12 20:57:27.131633 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-12 20:57:27.154125 | debian-bookworm | skipping: Conditional result was False 2025-08-12 20:57:27.160191 | 2025-08-12 20:57:27.160268 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-12 20:57:27.813165 | debian-bookworm | changed 2025-08-12 20:57:27.817424 | 2025-08-12 20:57:27.817495 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-12 20:57:28.058576 | debian-bookworm | ok 2025-08-12 20:57:28.075177 | 2025-08-12 20:57:28.075267 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-12 20:57:28.647606 | debian-bookworm | changed 2025-08-12 20:57:28.653980 | 2025-08-12 20:57:28.654073 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-12 20:57:29.312877 | debian-bookworm | changed 2025-08-12 20:57:29.318592 | 2025-08-12 20:57:29.318684 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-12 20:57:29.331798 | debian-bookworm | skipping: Conditional result was False 2025-08-12 20:57:29.338089 | 2025-08-12 20:57:29.338185 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-12 20:57:29.759133 | debian-bookworm -> localhost | changed 2025-08-12 20:57:29.770117 | 2025-08-12 20:57:29.770219 | TASK [add-build-sshkey : Add back temp key] 2025-08-12 20:57:30.089311 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0e1cf3237d4444d099d45ef820da9811/work/0e1cf3237d4444d099d45ef820da9811_id_rsa (zuul-build-sshkey) 2025-08-12 20:57:30.089512 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009153 2025-08-12 20:57:30.097096 | 2025-08-12 20:57:30.097187 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-12 20:57:30.435317 | debian-bookworm | ok 2025-08-12 20:57:30.443657 | 2025-08-12 20:57:30.443757 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-12 20:57:30.466612 | debian-bookworm | skipping: Conditional result was False 2025-08-12 20:57:30.476464 | 2025-08-12 20:57:30.476557 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-12 20:57:30.861069 | debian-bookworm | ok 2025-08-12 20:57:30.874599 | 2025-08-12 20:57:30.874702 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-12 20:57:30.903145 | debian-bookworm | ok 2025-08-12 20:57:30.908436 | 2025-08-12 20:57:30.908523 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-12 20:57:31.164975 | debian-bookworm -> localhost | ok 2025-08-12 20:57:31.171091 | 2025-08-12 20:57:31.171180 | TASK [validate-host : Collect information about the host] 2025-08-12 20:57:32.325879 | debian-bookworm | ok 2025-08-12 20:57:32.335618 | 2025-08-12 20:57:32.335709 | TASK [validate-host : Sanitize hostname] 2025-08-12 20:57:32.428605 | debian-bookworm | ok 2025-08-12 20:57:32.459394 | 2025-08-12 20:57:32.459487 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-12 20:57:33.243503 | debian-bookworm -> localhost | changed 2025-08-12 20:57:33.248753 | 2025-08-12 20:57:33.248844 | TASK [validate-host : Collect information about zuul worker] 2025-08-12 20:57:33.642820 | debian-bookworm | ok 2025-08-12 20:57:33.647426 | 2025-08-12 20:57:33.647514 | TASK [validate-host : Write out all zuul information for each host] 2025-08-12 20:57:34.277646 | debian-bookworm -> localhost | changed 2025-08-12 20:57:34.285251 | 2025-08-12 20:57:34.285332 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-12 20:57:34.543415 | debian-bookworm | ok 2025-08-12 20:57:34.547869 | 2025-08-12 20:57:34.547964 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-12 20:57:35.382989 | debian-bookworm | changed: 2025-08-12 20:57:35.383134 | debian-bookworm | cd+++++++++ src/ 2025-08-12 20:57:35.383162 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-12 20:57:35.383182 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-12 20:57:35.383199 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-12 20:57:35.383216 | debian-bookworm | Containerfile 2025-08-12 20:57:35.383307 | debian-bookworm | Containerfile 2025-08-12 20:57:35.419429 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006846 2025-08-12 20:58:01.011204 | 2025-08-12 20:58:01.011394 | TASK [upload-logs : Upload logs to log server] 2025-08-12 20:58:01.580203 | localhost | Output suppressed because no_log was given 2025-08-12 20:58:01.584387 | 2025-08-12 20:58:01.584567 | LOOP [upload-logs : Compress console log and json output] 2025-08-12 20:58:01.637542 | localhost | skipping: Conditional result was False 2025-08-12 20:58:01.642581 | localhost | skipping: Conditional result was False 2025-08-12 20:58:01.656228 | 2025-08-12 20:58:01.656475 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-12 20:58:01.703558 | localhost | skipping: Conditional result was False 2025-08-12 20:58:01.704295 | 2025-08-12 20:58:01.707269 | localhost | skipping: Conditional result was False 2025-08-12 20:58:01.721610 | 2025-08-12 20:58:01.721857 | LOOP [upload-logs : Upload console log and json output]