2026-04-09 08:04:14.757978 | Job console starting 2026-04-09 08:04:14.769121 | Updating git repos 2026-04-09 08:04:14.789246 | Cloning repos into workspace 2026-04-09 08:04:14.861809 | Restoring repo states 2026-04-09 08:04:14.871765 | Merging changes 2026-04-09 08:04:15.492285 | Checking out repos 2026-04-09 08:04:15.565933 | Preparing playbooks 2026-04-09 08:04:16.304283 | Running Ansible setup 2026-04-09 08:04:21.829067 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-09 08:04:22.678619 | 2026-04-09 08:04:22.678788 | PLAY [Base pre] 2026-04-09 08:04:22.695938 | 2026-04-09 08:04:22.696093 | TASK [Setup log path fact] 2026-04-09 08:04:22.725119 | debian-bookworm | ok 2026-04-09 08:04:22.741931 | 2026-04-09 08:04:22.742092 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-09 08:04:22.771718 | debian-bookworm | ok 2026-04-09 08:04:22.781720 | 2026-04-09 08:04:22.781850 | TASK [emit-job-header : Print job information] 2026-04-09 08:04:22.820696 | # Job Information 2026-04-09 08:04:22.820889 | Ansible Version: 2.16.14 2026-04-09 08:04:22.820924 | Job: python-black 2026-04-09 08:04:22.820956 | Pipeline: check 2026-04-09 08:04:22.820979 | Executor: 521e9411259a 2026-04-09 08:04:22.821001 | Triggered by: https://github.com/osism/testbed/pull/2864 2026-04-09 08:04:22.821023 | Event ID: ac6bb620-33ea-11f1-9c38-5ab61398f1f8 2026-04-09 08:04:22.826014 | 2026-04-09 08:04:22.826124 | LOOP [emit-job-header : Print node information] 2026-04-09 08:04:22.928626 | debian-bookworm | ok: 2026-04-09 08:04:22.928826 | debian-bookworm | # Node Information 2026-04-09 08:04:22.928860 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-09 08:04:22.928885 | debian-bookworm | Hostname: debian 2026-04-09 08:04:22.928907 | debian-bookworm | Username: zuul 2026-04-09 08:04:22.928927 | debian-bookworm | Distro: Debian 12.13 2026-04-09 08:04:22.928951 | debian-bookworm | Provider: regiocloud-a 2026-04-09 08:04:22.928972 | debian-bookworm | Region: 2026-04-09 08:04:22.928993 | debian-bookworm | Label: debian-bookworm 2026-04-09 08:04:22.929013 | debian-bookworm | Product Name: OpenStack Nova 2026-04-09 08:04:22.929032 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1e:8b60 2026-04-09 08:04:22.941498 | 2026-04-09 08:04:22.941650 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-09 08:04:23.513124 | debian-bookworm -> localhost | changed 2026-04-09 08:04:23.520791 | 2026-04-09 08:04:23.520922 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-09 08:04:24.590640 | debian-bookworm -> localhost | changed 2026-04-09 08:04:24.602525 | 2026-04-09 08:04:24.602663 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-09 08:04:25.031791 | debian-bookworm -> localhost | ok 2026-04-09 08:04:25.046943 | 2026-04-09 08:04:25.047143 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-09 08:04:25.078016 | debian-bookworm | ok 2026-04-09 08:04:25.096914 | debian-bookworm | included: /var/lib/zuul/builds/a36f64ad6b7744ee8e34eda67827236f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-09 08:04:25.103724 | 2026-04-09 08:04:25.103843 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-09 08:04:26.057423 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-09 08:04:26.057686 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a36f64ad6b7744ee8e34eda67827236f/work/a36f64ad6b7744ee8e34eda67827236f_id_rsa 2026-04-09 08:04:26.057729 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a36f64ad6b7744ee8e34eda67827236f/work/a36f64ad6b7744ee8e34eda67827236f_id_rsa.pub 2026-04-09 08:04:26.057757 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-09 08:04:26.057782 | debian-bookworm -> localhost | SHA256:8Qoz/WHEvg8D+2FmWzZ9YWleZyMNxK2Gdz3oQM0PR/k zuul-build-sshkey 2026-04-09 08:04:26.057804 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-09 08:04:26.057842 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-09 08:04:26.057865 | debian-bookworm -> localhost | | +.o..| 2026-04-09 08:04:26.057887 | debian-bookworm -> localhost | | . ..= + | 2026-04-09 08:04:26.057907 | debian-bookworm -> localhost | | . + ..* o| 2026-04-09 08:04:26.057927 | debian-bookworm -> localhost | | . = o =o+E| 2026-04-09 08:04:26.057947 | debian-bookworm -> localhost | | + S = =..B=| 2026-04-09 08:04:26.057970 | debian-bookworm -> localhost | | + * o o=.=| 2026-04-09 08:04:26.057990 | debian-bookworm -> localhost | | o X + ...| 2026-04-09 08:04:26.058010 | debian-bookworm -> localhost | | = O . . | 2026-04-09 08:04:26.058031 | debian-bookworm -> localhost | | o . | 2026-04-09 08:04:26.058051 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-09 08:04:26.058102 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.446873 2026-04-09 08:04:26.069019 | 2026-04-09 08:04:26.069158 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-09 08:04:26.098191 | debian-bookworm | ok 2026-04-09 08:04:26.108020 | debian-bookworm | included: /var/lib/zuul/builds/a36f64ad6b7744ee8e34eda67827236f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-09 08:04:26.118171 | 2026-04-09 08:04:26.118299 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-09 08:04:26.142167 | debian-bookworm | skipping: Conditional result was False 2026-04-09 08:04:26.148435 | 2026-04-09 08:04:26.148569 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-09 08:04:26.834028 | debian-bookworm | changed 2026-04-09 08:04:26.844802 | 2026-04-09 08:04:26.844940 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-09 08:04:27.104873 | debian-bookworm | ok 2026-04-09 08:04:27.115785 | 2026-04-09 08:04:27.116062 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-09 08:04:27.817824 | debian-bookworm | changed 2026-04-09 08:04:27.828024 | 2026-04-09 08:04:27.828159 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-09 08:04:28.519238 | debian-bookworm | changed 2026-04-09 08:04:28.525006 | 2026-04-09 08:04:28.525118 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-09 08:04:28.558767 | debian-bookworm | skipping: Conditional result was False 2026-04-09 08:04:28.565612 | 2026-04-09 08:04:28.565723 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-09 08:04:29.066342 | debian-bookworm -> localhost | changed 2026-04-09 08:04:29.079171 | 2026-04-09 08:04:29.079307 | TASK [add-build-sshkey : Add back temp key] 2026-04-09 08:04:29.420494 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a36f64ad6b7744ee8e34eda67827236f/work/a36f64ad6b7744ee8e34eda67827236f_id_rsa (zuul-build-sshkey) 2026-04-09 08:04:29.420805 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020214 2026-04-09 08:04:29.432130 | 2026-04-09 08:04:29.432281 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-09 08:04:29.842169 | debian-bookworm | ok 2026-04-09 08:04:29.847728 | 2026-04-09 08:04:29.847855 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-09 08:04:29.871646 | debian-bookworm | skipping: Conditional result was False 2026-04-09 08:04:29.882538 | 2026-04-09 08:04:29.882666 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-09 08:04:30.321404 | debian-bookworm | ok 2026-04-09 08:04:30.339521 | 2026-04-09 08:04:30.339659 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-09 08:04:30.385845 | debian-bookworm | ok 2026-04-09 08:04:30.395711 | 2026-04-09 08:04:30.395850 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-09 08:04:30.713889 | debian-bookworm -> localhost | ok 2026-04-09 08:04:30.743341 | 2026-04-09 08:04:30.743484 | TASK [validate-host : Collect information about the host] 2026-04-09 08:04:31.913095 | debian-bookworm | ok 2026-04-09 08:04:31.923594 | 2026-04-09 08:04:31.923732 | TASK [validate-host : Sanitize hostname] 2026-04-09 08:04:32.044145 | debian-bookworm | ok 2026-04-09 08:04:32.088327 | 2026-04-09 08:04:32.088583 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-09 08:04:32.704595 | debian-bookworm -> localhost | changed 2026-04-09 08:04:32.710467 | 2026-04-09 08:04:32.710587 | TASK [validate-host : Collect information about zuul worker] 2026-04-09 08:04:33.115125 | debian-bookworm | ok 2026-04-09 08:04:33.120097 | 2026-04-09 08:04:33.120226 | TASK [validate-host : Write out all zuul information for each host] 2026-04-09 08:04:33.732423 | debian-bookworm -> localhost | changed 2026-04-09 08:04:33.744846 | 2026-04-09 08:04:33.745063 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-09 08:04:34.032082 | debian-bookworm | ok 2026-04-09 08:04:34.042657 | 2026-04-09 08:04:34.042791 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-09 08:04:35.209903 | debian-bookworm | changed: 2026-04-09 08:04:35.210220 | debian-bookworm | cd+++++++++ src/ 2026-04-09 08:04:35.210265 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-09 08:04:35.210290 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-09 08:04:35.210311 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-04-09 08:04:35.210331 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007487 2026-04-09 08:05:00.756230 | 2026-04-09 08:05:00.756541 | TASK [upload-logs : Upload logs to log server] 2026-04-09 08:05:01.306734 | localhost | Output suppressed because no_log was given 2026-04-09 08:05:01.308614 | 2026-04-09 08:05:01.308721 | LOOP [upload-logs : Compress console log and json output] 2026-04-09 08:05:01.378184 | localhost | skipping: Conditional result was False 2026-04-09 08:05:01.386499 | localhost | skipping: Conditional result was False 2026-04-09 08:05:01.395901 | 2026-04-09 08:05:01.396026 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-09 08:05:01.457583 | localhost | skipping: Conditional result was False 2026-04-09 08:05:01.457877 | 2026-04-09 08:05:01.464508 | localhost | skipping: Conditional result was False 2026-04-09 08:05:01.473015 | 2026-04-09 08:05:01.473139 | LOOP [upload-logs : Upload console log and json output]