2025-10-23 14:46:00.826976 | Job console starting 2025-10-23 14:46:00.855551 | Updating git repos 2025-10-23 14:46:00.917113 | Cloning repos into workspace 2025-10-23 14:46:01.007241 | Restoring repo states 2025-10-23 14:46:01.019857 | Merging changes 2025-10-23 14:46:01.664844 | Checking out repos 2025-10-23 14:46:01.712212 | Preparing playbooks 2025-10-23 14:46:02.795541 | Running Ansible setup 2025-10-23 14:46:09.055520 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-23 14:46:10.310387 | 2025-10-23 14:46:10.310510 | PLAY [Base pre] 2025-10-23 14:46:10.363454 | 2025-10-23 14:46:10.363575 | TASK [Setup log path fact] 2025-10-23 14:46:10.382492 | debian-bookworm | ok 2025-10-23 14:46:10.407457 | 2025-10-23 14:46:10.407577 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-23 14:46:10.447798 | debian-bookworm | ok 2025-10-23 14:46:10.470217 | 2025-10-23 14:46:10.470327 | TASK [emit-job-header : Print job information] 2025-10-23 14:46:10.541867 | # Job Information 2025-10-23 14:46:10.542016 | Ansible Version: 2.16.14 2025-10-23 14:46:10.542051 | Job: python-black 2025-10-23 14:46:10.542093 | Pipeline: check 2025-10-23 14:46:10.542117 | Executor: 521e9411259a 2025-10-23 14:46:10.542138 | Triggered by: https://github.com/osism/python-osism/pull/1711 2025-10-23 14:46:10.542160 | Event ID: f8852c30-b01e-11f0-86df-e638da0f9296 2025-10-23 14:46:10.546865 | 2025-10-23 14:46:10.546953 | LOOP [emit-job-header : Print node information] 2025-10-23 14:46:10.719228 | debian-bookworm | ok: 2025-10-23 14:46:10.719434 | debian-bookworm | # Node Information 2025-10-23 14:46:10.719471 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-23 14:46:10.719497 | debian-bookworm | Hostname: debian 2025-10-23 14:46:10.719519 | debian-bookworm | Username: zuul 2025-10-23 14:46:10.719540 | debian-bookworm | Distro: Debian 12.12 2025-10-23 14:46:10.719563 | debian-bookworm | Provider: regiocloud-a 2025-10-23 14:46:10.719584 | debian-bookworm | Region: 2025-10-23 14:46:10.719605 | debian-bookworm | Label: debian-bookworm 2025-10-23 14:46:10.719624 | debian-bookworm | Product Name: OpenStack Nova 2025-10-23 14:46:10.719644 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec5:3155 2025-10-23 14:46:10.738172 | 2025-10-23 14:46:10.738273 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-23 14:46:11.463708 | debian-bookworm -> localhost | changed 2025-10-23 14:46:11.470282 | 2025-10-23 14:46:11.470380 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-23 14:46:12.968936 | debian-bookworm -> localhost | changed 2025-10-23 14:46:12.978674 | 2025-10-23 14:46:12.978763 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-23 14:46:13.274500 | debian-bookworm -> localhost | ok 2025-10-23 14:46:13.279797 | 2025-10-23 14:46:13.279883 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-23 14:46:13.307018 | debian-bookworm | ok 2025-10-23 14:46:13.333153 | debian-bookworm | included: /var/lib/zuul/builds/d1c5ef4a6d50413fb4c7e760c7cdd7c5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-23 14:46:13.337931 | 2025-10-23 14:46:13.338009 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-23 14:46:15.588396 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-23 14:46:15.588558 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d1c5ef4a6d50413fb4c7e760c7cdd7c5/work/d1c5ef4a6d50413fb4c7e760c7cdd7c5_id_rsa 2025-10-23 14:46:15.588589 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d1c5ef4a6d50413fb4c7e760c7cdd7c5/work/d1c5ef4a6d50413fb4c7e760c7cdd7c5_id_rsa.pub 2025-10-23 14:46:15.588612 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-23 14:46:15.588632 | debian-bookworm -> localhost | SHA256:FhbHtW1xUUZ8afuNpm3wOXmtaNb80BKUYxUpPmiY3GU zuul-build-sshkey 2025-10-23 14:46:15.588651 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-23 14:46:15.588677 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-23 14:46:15.588696 | debian-bookworm -> localhost | | ..... .=%| 2025-10-23 14:46:15.588713 | debian-bookworm -> localhost | | o. E Xo| 2025-10-23 14:46:15.588730 | debian-bookworm -> localhost | | + + * X o| 2025-10-23 14:46:15.588747 | debian-bookworm -> localhost | | . = + * o | 2025-10-23 14:46:15.588763 | debian-bookworm -> localhost | | S . o.o| 2025-10-23 14:46:15.588781 | debian-bookworm -> localhost | | . . ooo| 2025-10-23 14:46:15.588797 | debian-bookworm -> localhost | | Oooo| 2025-10-23 14:46:15.588814 | debian-bookworm -> localhost | | +.Xoo| 2025-10-23 14:46:15.588831 | debian-bookworm -> localhost | | o...=.| 2025-10-23 14:46:15.588848 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-23 14:46:15.588892 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.382383 2025-10-23 14:46:15.593993 | 2025-10-23 14:46:15.594097 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-23 14:46:15.630338 | debian-bookworm | ok 2025-10-23 14:46:15.638488 | debian-bookworm | included: /var/lib/zuul/builds/d1c5ef4a6d50413fb4c7e760c7cdd7c5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-23 14:46:15.645409 | 2025-10-23 14:46:15.645479 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-23 14:46:15.661143 | debian-bookworm | skipping: Conditional result was False 2025-10-23 14:46:15.666311 | 2025-10-23 14:46:15.666387 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-23 14:46:16.249528 | debian-bookworm | changed 2025-10-23 14:46:16.254220 | 2025-10-23 14:46:16.254293 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-23 14:46:16.499300 | debian-bookworm | ok 2025-10-23 14:46:16.511177 | 2025-10-23 14:46:16.511317 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-23 14:46:17.138719 | debian-bookworm | changed 2025-10-23 14:46:17.145825 | 2025-10-23 14:46:17.145921 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-23 14:46:17.810168 | debian-bookworm | changed 2025-10-23 14:46:17.815540 | 2025-10-23 14:46:17.815642 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-23 14:46:17.855815 | debian-bookworm | skipping: Conditional result was False 2025-10-23 14:46:17.862072 | 2025-10-23 14:46:17.862179 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-23 14:46:18.506544 | debian-bookworm -> localhost | changed 2025-10-23 14:46:18.516688 | 2025-10-23 14:46:18.516790 | TASK [add-build-sshkey : Add back temp key] 2025-10-23 14:46:19.081612 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d1c5ef4a6d50413fb4c7e760c7cdd7c5/work/d1c5ef4a6d50413fb4c7e760c7cdd7c5_id_rsa (zuul-build-sshkey) 2025-10-23 14:46:19.081828 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.034073 2025-10-23 14:46:19.091527 | 2025-10-23 14:46:19.091638 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-23 14:46:19.476156 | debian-bookworm | ok 2025-10-23 14:46:19.480157 | 2025-10-23 14:46:19.480233 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-23 14:46:19.502721 | debian-bookworm | skipping: Conditional result was False 2025-10-23 14:46:19.510910 | 2025-10-23 14:46:19.510991 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-23 14:46:19.892440 | debian-bookworm | ok 2025-10-23 14:46:19.901581 | 2025-10-23 14:46:19.901665 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-23 14:46:19.948297 | debian-bookworm | ok 2025-10-23 14:46:19.952387 | 2025-10-23 14:46:19.952468 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-23 14:46:20.308179 | debian-bookworm -> localhost | ok 2025-10-23 14:46:20.313158 | 2025-10-23 14:46:20.313237 | TASK [validate-host : Collect information about the host] 2025-10-23 14:46:21.419349 | debian-bookworm | ok 2025-10-23 14:46:21.451995 | 2025-10-23 14:46:21.452112 | TASK [validate-host : Sanitize hostname] 2025-10-23 14:46:21.620378 | debian-bookworm | ok 2025-10-23 14:46:21.670778 | 2025-10-23 14:46:21.670916 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-23 14:46:22.292382 | debian-bookworm -> localhost | changed 2025-10-23 14:46:22.297671 | 2025-10-23 14:46:22.297758 | TASK [validate-host : Collect information about zuul worker] 2025-10-23 14:46:22.805162 | debian-bookworm | ok 2025-10-23 14:46:22.809637 | 2025-10-23 14:46:22.809724 | TASK [validate-host : Write out all zuul information for each host] 2025-10-23 14:46:23.491006 | debian-bookworm -> localhost | changed 2025-10-23 14:46:23.501920 | 2025-10-23 14:46:23.502293 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-23 14:46:23.776328 | debian-bookworm | ok 2025-10-23 14:46:23.781505 | 2025-10-23 14:46:23.781590 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-23 14:46:24.950300 | debian-bookworm | changed: 2025-10-23 14:46:24.950556 | debian-bookworm | cd+++++++++ src/ 2025-10-23 14:46:24.950597 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-23 14:46:24.950622 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-23 14:46:24.950644 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-23 14:46:24.950665 | debian-bookworm | Containerfile 2025-10-23 14:46:24.950782 | debian-bookworm | Containerfile 2025-10-23 14:46:24.969532 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006888 2025-10-23 14:46:52.835436 | 2025-10-23 14:46:52.835549 | TASK [upload-logs : Upload logs to log server] 2025-10-23 14:46:53.408719 | localhost | Output suppressed because no_log was given 2025-10-23 14:46:53.411606 | 2025-10-23 14:46:53.411744 | LOOP [upload-logs : Compress console log and json output] 2025-10-23 14:46:53.466184 | localhost | skipping: Conditional result was False 2025-10-23 14:46:53.474565 | localhost | skipping: Conditional result was False 2025-10-23 14:46:53.479623 | 2025-10-23 14:46:53.479743 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-23 14:46:53.587711 | localhost | skipping: Conditional result was False 2025-10-23 14:46:53.588049 | 2025-10-23 14:46:53.592081 | localhost | skipping: Conditional result was False 2025-10-23 14:46:53.601172 | 2025-10-23 14:46:53.601289 | LOOP [upload-logs : Upload console log and json output]