2025-12-02 16:49:20.710938 | Job console starting 2025-12-02 16:49:20.745669 | Updating git repos 2025-12-02 16:49:20.877727 | Cloning repos into workspace 2025-12-02 16:49:21.211037 | Restoring repo states 2025-12-02 16:49:21.229839 | Merging changes 2025-12-02 16:49:21.909750 | Checking out repos 2025-12-02 16:49:22.091534 | Preparing playbooks 2025-12-02 16:49:23.510201 | Running Ansible setup 2025-12-02 16:49:29.400106 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-02 16:49:30.718873 | 2025-12-02 16:49:30.719054 | PLAY [Base pre] 2025-12-02 16:49:30.762806 | 2025-12-02 16:49:30.763022 | TASK [Setup log path fact] 2025-12-02 16:49:30.793545 | debian-bookworm | ok 2025-12-02 16:49:30.832257 | 2025-12-02 16:49:30.832459 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-02 16:49:30.893508 | debian-bookworm | ok 2025-12-02 16:49:30.908013 | 2025-12-02 16:49:30.908152 | TASK [emit-job-header : Print job information] 2025-12-02 16:49:30.968379 | # Job Information 2025-12-02 16:49:30.968579 | Ansible Version: 2.16.14 2025-12-02 16:49:30.968614 | Job: python-black 2025-12-02 16:49:30.968646 | Pipeline: check 2025-12-02 16:49:30.968669 | Executor: 521e9411259a 2025-12-02 16:49:30.968689 | Triggered by: https://github.com/osism/python-osism/pull/1872 2025-12-02 16:49:30.968710 | Event ID: d39d01f0-cf9e-11f0-8087-24a13524adbd 2025-12-02 16:49:30.973816 | 2025-12-02 16:49:30.973940 | LOOP [emit-job-header : Print node information] 2025-12-02 16:49:31.135418 | debian-bookworm | ok: 2025-12-02 16:49:31.136170 | debian-bookworm | # Node Information 2025-12-02 16:49:31.136224 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-02 16:49:31.136250 | debian-bookworm | Hostname: debian 2025-12-02 16:49:31.136272 | debian-bookworm | Username: zuul 2025-12-02 16:49:31.136293 | debian-bookworm | Distro: Debian 12.12 2025-12-02 16:49:31.136317 | debian-bookworm | Provider: regiocloud-a 2025-12-02 16:49:31.136338 | debian-bookworm | Region: 2025-12-02 16:49:31.136382 | debian-bookworm | Label: debian-bookworm 2025-12-02 16:49:31.136402 | debian-bookworm | Product Name: OpenStack Nova 2025-12-02 16:49:31.136423 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fecd:56a2 2025-12-02 16:49:31.151916 | 2025-12-02 16:49:31.152063 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-02 16:49:32.117620 | debian-bookworm -> localhost | changed 2025-12-02 16:49:32.125406 | 2025-12-02 16:49:32.125551 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-02 16:49:34.553020 | debian-bookworm -> localhost | changed 2025-12-02 16:49:34.581260 | 2025-12-02 16:49:34.581438 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-02 16:49:35.266037 | debian-bookworm -> localhost | ok 2025-12-02 16:49:35.272528 | 2025-12-02 16:49:35.272659 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-02 16:49:35.312416 | debian-bookworm | ok 2025-12-02 16:49:35.376659 | debian-bookworm | included: /var/lib/zuul/builds/bb0b824092f044678b23a3852fafea3a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-02 16:49:35.402760 | 2025-12-02 16:49:35.402985 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-02 16:49:37.139681 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-02 16:49:37.139925 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bb0b824092f044678b23a3852fafea3a/work/bb0b824092f044678b23a3852fafea3a_id_rsa 2025-12-02 16:49:37.139965 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bb0b824092f044678b23a3852fafea3a/work/bb0b824092f044678b23a3852fafea3a_id_rsa.pub 2025-12-02 16:49:37.139991 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-02 16:49:37.140017 | debian-bookworm -> localhost | SHA256:DpZT7znUoj405U8U4fnjEe4unGy62dQklpW/7bRvxw4 zuul-build-sshkey 2025-12-02 16:49:37.140039 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-02 16:49:37.140074 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-02 16:49:37.140096 | debian-bookworm -> localhost | | .. | 2025-12-02 16:49:37.140118 | debian-bookworm -> localhost | | ... . | 2025-12-02 16:49:37.140138 | debian-bookworm -> localhost | | . o.+ | 2025-12-02 16:49:37.140157 | debian-bookworm -> localhost | | o ....= o | 2025-12-02 16:49:37.140177 | debian-bookworm -> localhost | | = So+.= * .| 2025-12-02 16:49:37.140202 | debian-bookworm -> localhost | | . +o+.+.* oo| 2025-12-02 16:49:37.140222 | debian-bookworm -> localhost | | .o.+=..Eoo| 2025-12-02 16:49:37.140242 | debian-bookworm -> localhost | | .. =B. +=| 2025-12-02 16:49:37.140262 | debian-bookworm -> localhost | | ..++...+*| 2025-12-02 16:49:37.140282 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-02 16:49:37.140334 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.873408 2025-12-02 16:49:37.148690 | 2025-12-02 16:49:37.148823 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-02 16:49:37.185835 | debian-bookworm | ok 2025-12-02 16:49:37.206482 | debian-bookworm | included: /var/lib/zuul/builds/bb0b824092f044678b23a3852fafea3a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-02 16:49:37.216751 | 2025-12-02 16:49:37.216892 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-02 16:49:37.251701 | debian-bookworm | skipping: Conditional result was False 2025-12-02 16:49:37.258340 | 2025-12-02 16:49:37.258520 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-02 16:49:37.873154 | debian-bookworm | changed 2025-12-02 16:49:37.888568 | 2025-12-02 16:49:37.888727 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-02 16:49:38.145676 | debian-bookworm | ok 2025-12-02 16:49:38.156765 | 2025-12-02 16:49:38.156906 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-02 16:49:38.866073 | debian-bookworm | changed 2025-12-02 16:49:38.876311 | 2025-12-02 16:49:38.876481 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-02 16:49:39.543627 | debian-bookworm | changed 2025-12-02 16:49:39.552942 | 2025-12-02 16:49:39.553072 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-02 16:49:39.599944 | debian-bookworm | skipping: Conditional result was False 2025-12-02 16:49:39.608599 | 2025-12-02 16:49:39.608775 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-02 16:49:40.168061 | debian-bookworm -> localhost | changed 2025-12-02 16:49:40.183968 | 2025-12-02 16:49:40.184126 | TASK [add-build-sshkey : Add back temp key] 2025-12-02 16:49:40.715593 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bb0b824092f044678b23a3852fafea3a/work/bb0b824092f044678b23a3852fafea3a_id_rsa (zuul-build-sshkey) 2025-12-02 16:49:40.715873 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023713 2025-12-02 16:49:40.725537 | 2025-12-02 16:49:40.725701 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-02 16:49:41.297531 | debian-bookworm | ok 2025-12-02 16:49:41.302808 | 2025-12-02 16:49:41.302959 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-02 16:49:41.347307 | debian-bookworm | skipping: Conditional result was False 2025-12-02 16:49:41.359284 | 2025-12-02 16:49:41.359443 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-02 16:49:41.787307 | debian-bookworm | ok 2025-12-02 16:49:41.844505 | 2025-12-02 16:49:41.844663 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-02 16:49:41.913973 | debian-bookworm | ok 2025-12-02 16:49:41.919677 | 2025-12-02 16:49:41.919799 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-02 16:49:42.369917 | debian-bookworm -> localhost | ok 2025-12-02 16:49:42.376850 | 2025-12-02 16:49:42.376984 | TASK [validate-host : Collect information about the host] 2025-12-02 16:49:43.583933 | debian-bookworm | ok 2025-12-02 16:49:43.605327 | 2025-12-02 16:49:43.605506 | TASK [validate-host : Sanitize hostname] 2025-12-02 16:49:43.790431 | debian-bookworm | ok 2025-12-02 16:49:43.842284 | 2025-12-02 16:49:43.842463 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-02 16:49:44.638178 | debian-bookworm -> localhost | changed 2025-12-02 16:49:44.644309 | 2025-12-02 16:49:44.644477 | TASK [validate-host : Collect information about zuul worker] 2025-12-02 16:49:45.125977 | debian-bookworm | ok 2025-12-02 16:49:45.131092 | 2025-12-02 16:49:45.137178 | TASK [validate-host : Write out all zuul information for each host] 2025-12-02 16:49:45.897525 | debian-bookworm -> localhost | changed 2025-12-02 16:49:45.907687 | 2025-12-02 16:49:45.907826 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-02 16:49:46.207018 | debian-bookworm | ok 2025-12-02 16:49:46.216890 | 2025-12-02 16:49:46.217044 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-02 16:49:47.540653 | debian-bookworm | changed: 2025-12-02 16:49:47.540869 | debian-bookworm | cd+++++++++ src/ 2025-12-02 16:49:47.540904 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-02 16:49:47.540928 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-02 16:49:47.540950 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-02 16:49:47.540970 | debian-bookworm | Containerfile 2025-12-02 16:49:47.541084 | debian-bookworm | Containerfile 2025-12-02 16:49:47.598782 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007793 2025-12-02 16:50:15.567467 | 2025-12-02 16:50:15.567649 | TASK [upload-logs : Upload logs to log server] 2025-12-02 16:50:16.164272 | localhost | Output suppressed because no_log was given 2025-12-02 16:50:16.166228 | 2025-12-02 16:50:16.166392 | LOOP [upload-logs : Compress console log and json output] 2025-12-02 16:50:16.232482 | localhost | skipping: Conditional result was False 2025-12-02 16:50:16.253745 | localhost | skipping: Conditional result was False 2025-12-02 16:50:16.257747 | 2025-12-02 16:50:16.257861 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-02 16:50:16.319955 | localhost | skipping: Conditional result was False 2025-12-02 16:50:16.320467 | 2025-12-02 16:50:16.326657 | localhost | skipping: Conditional result was False 2025-12-02 16:50:16.336333 | 2025-12-02 16:50:16.336526 | LOOP [upload-logs : Upload console log and json output]