2025-12-02 15:29:23.379450 | Job console starting 2025-12-02 15:29:23.406941 | Updating git repos 2025-12-02 15:29:23.461210 | Cloning repos into workspace 2025-12-02 15:29:23.564069 | Restoring repo states 2025-12-02 15:29:23.585830 | Merging changes 2025-12-02 15:29:24.312046 | Checking out repos 2025-12-02 15:29:24.365148 | Preparing playbooks 2025-12-02 15:29:25.661073 | Running Ansible setup 2025-12-02 15:29:32.126090 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-02 15:29:33.814209 | 2025-12-02 15:29:33.825828 | PLAY [Base pre] 2025-12-02 15:29:33.873417 | 2025-12-02 15:29:33.873636 | TASK [Setup log path fact] 2025-12-02 15:29:33.919652 | debian-bookworm | ok 2025-12-02 15:29:33.969076 | 2025-12-02 15:29:33.969261 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-02 15:29:34.022127 | debian-bookworm | ok 2025-12-02 15:29:34.038213 | 2025-12-02 15:29:34.038370 | TASK [emit-job-header : Print job information] 2025-12-02 15:29:34.130519 | # Job Information 2025-12-02 15:29:34.130813 | Ansible Version: 2.16.14 2025-12-02 15:29:34.130901 | Job: python-black 2025-12-02 15:29:34.130939 | Pipeline: check 2025-12-02 15:29:34.130964 | Executor: 521e9411259a 2025-12-02 15:29:34.130984 | Triggered by: https://github.com/osism/python-osism/pull/1872 2025-12-02 15:29:34.131006 | Event ID: a852dbb0-cf93-11f0-9211-0bc7b9145d19 2025-12-02 15:29:34.141965 | 2025-12-02 15:29:34.142123 | LOOP [emit-job-header : Print node information] 2025-12-02 15:29:34.281663 | debian-bookworm | ok: 2025-12-02 15:29:34.281871 | debian-bookworm | # Node Information 2025-12-02 15:29:34.281905 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-02 15:29:34.281929 | debian-bookworm | Hostname: debian 2025-12-02 15:29:34.281951 | debian-bookworm | Username: zuul 2025-12-02 15:29:34.281980 | debian-bookworm | Distro: Debian 12.12 2025-12-02 15:29:34.282007 | debian-bookworm | Provider: regiocloud-a 2025-12-02 15:29:34.282037 | debian-bookworm | Region: 2025-12-02 15:29:34.282059 | debian-bookworm | Label: debian-bookworm 2025-12-02 15:29:34.282082 | debian-bookworm | Product Name: OpenStack Nova 2025-12-02 15:29:34.282110 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5f:ffb2 2025-12-02 15:29:34.315144 | 2025-12-02 15:29:34.315302 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-02 15:29:35.232040 | debian-bookworm -> localhost | changed 2025-12-02 15:29:35.239565 | 2025-12-02 15:29:35.239705 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-02 15:29:36.971161 | debian-bookworm -> localhost | changed 2025-12-02 15:29:36.994353 | 2025-12-02 15:29:36.994499 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-02 15:29:37.550731 | debian-bookworm -> localhost | ok 2025-12-02 15:29:37.557361 | 2025-12-02 15:29:37.557504 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-02 15:29:37.590590 | debian-bookworm | ok 2025-12-02 15:29:37.640761 | debian-bookworm | included: /var/lib/zuul/builds/6b2380079a2d4e5d9c327ef9dca46c12/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-02 15:29:37.649282 | 2025-12-02 15:29:37.649410 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-02 15:29:39.640231 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-02 15:29:39.640394 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6b2380079a2d4e5d9c327ef9dca46c12/work/6b2380079a2d4e5d9c327ef9dca46c12_id_rsa 2025-12-02 15:29:39.640423 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6b2380079a2d4e5d9c327ef9dca46c12/work/6b2380079a2d4e5d9c327ef9dca46c12_id_rsa.pub 2025-12-02 15:29:39.640444 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-02 15:29:39.640465 | debian-bookworm -> localhost | SHA256:E59zAStF9aNOf1qq9kmVhPIMV5TK723qjpow8BriYfo zuul-build-sshkey 2025-12-02 15:29:39.640482 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-02 15:29:39.640509 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-02 15:29:39.640527 | debian-bookworm -> localhost | | .+.. .o.| 2025-12-02 15:29:39.640554 | debian-bookworm -> localhost | | . o .o. | 2025-12-02 15:29:39.640571 | debian-bookworm -> localhost | | o .ooo+. | 2025-12-02 15:29:39.640587 | debian-bookworm -> localhost | | + .*=...| 2025-12-02 15:29:39.640603 | debian-bookworm -> localhost | | . S + +o...| 2025-12-02 15:29:39.640623 | debian-bookworm -> localhost | | o . = . o | 2025-12-02 15:29:39.640640 | debian-bookworm -> localhost | | + . + . + +| 2025-12-02 15:29:39.640656 | debian-bookworm -> localhost | | + o o o ..o Bo| 2025-12-02 15:29:39.640672 | debian-bookworm -> localhost | | ..E . ooo=Oo | 2025-12-02 15:29:39.640688 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-02 15:29:39.640727 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.016191 2025-12-02 15:29:39.645838 | 2025-12-02 15:29:39.645916 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-02 15:29:39.692569 | debian-bookworm | ok 2025-12-02 15:29:39.703028 | debian-bookworm | included: /var/lib/zuul/builds/6b2380079a2d4e5d9c327ef9dca46c12/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-02 15:29:39.710079 | 2025-12-02 15:29:39.710156 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-02 15:29:39.764433 | debian-bookworm | skipping: Conditional result was False 2025-12-02 15:29:39.769178 | 2025-12-02 15:29:39.769258 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-02 15:29:40.452645 | debian-bookworm | changed 2025-12-02 15:29:40.457235 | 2025-12-02 15:29:40.457311 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-02 15:29:40.719616 | debian-bookworm | ok 2025-12-02 15:29:40.726657 | 2025-12-02 15:29:40.726762 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-02 15:29:41.351549 | debian-bookworm | changed 2025-12-02 15:29:41.360472 | 2025-12-02 15:29:41.360614 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-02 15:29:41.985076 | debian-bookworm | changed 2025-12-02 15:29:41.992136 | 2025-12-02 15:29:41.992237 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-02 15:29:42.008008 | debian-bookworm | skipping: Conditional result was False 2025-12-02 15:29:42.013988 | 2025-12-02 15:29:42.014087 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-02 15:29:42.505866 | debian-bookworm -> localhost | changed 2025-12-02 15:29:42.522193 | 2025-12-02 15:29:42.522302 | TASK [add-build-sshkey : Add back temp key] 2025-12-02 15:29:42.890090 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6b2380079a2d4e5d9c327ef9dca46c12/work/6b2380079a2d4e5d9c327ef9dca46c12_id_rsa (zuul-build-sshkey) 2025-12-02 15:29:42.890306 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015865 2025-12-02 15:29:42.897772 | 2025-12-02 15:29:42.897866 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-02 15:29:43.316086 | debian-bookworm | ok 2025-12-02 15:29:43.333175 | 2025-12-02 15:29:43.333419 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-02 15:29:43.388992 | debian-bookworm | skipping: Conditional result was False 2025-12-02 15:29:43.428932 | 2025-12-02 15:29:43.429088 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-02 15:29:44.065867 | debian-bookworm | ok 2025-12-02 15:29:44.085965 | 2025-12-02 15:29:44.086134 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-02 15:29:44.137325 | debian-bookworm | ok 2025-12-02 15:29:44.151718 | 2025-12-02 15:29:44.151910 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-02 15:29:44.594093 | debian-bookworm -> localhost | ok 2025-12-02 15:29:44.600855 | 2025-12-02 15:29:44.600982 | TASK [validate-host : Collect information about the host] 2025-12-02 15:29:45.851175 | debian-bookworm | ok 2025-12-02 15:29:45.873421 | 2025-12-02 15:29:45.873594 | TASK [validate-host : Sanitize hostname] 2025-12-02 15:29:46.027350 | debian-bookworm | ok 2025-12-02 15:29:46.079935 | 2025-12-02 15:29:46.080082 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-02 15:29:47.053785 | debian-bookworm -> localhost | changed 2025-12-02 15:29:47.060105 | 2025-12-02 15:29:47.060221 | TASK [validate-host : Collect information about zuul worker] 2025-12-02 15:29:47.511971 | debian-bookworm | ok 2025-12-02 15:29:47.516986 | 2025-12-02 15:29:47.517116 | TASK [validate-host : Write out all zuul information for each host] 2025-12-02 15:29:48.343484 | debian-bookworm -> localhost | changed 2025-12-02 15:29:48.355483 | 2025-12-02 15:29:48.355647 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-02 15:29:48.676214 | debian-bookworm | ok 2025-12-02 15:29:48.684561 | 2025-12-02 15:29:48.684694 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-02 15:29:49.993070 | debian-bookworm | changed: 2025-12-02 15:29:49.993296 | debian-bookworm | cd+++++++++ src/ 2025-12-02 15:29:49.993332 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-02 15:29:49.993356 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-02 15:29:49.993377 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-02 15:29:49.993398 | debian-bookworm | Containerfile 2025-12-02 15:29:49.993512 | debian-bookworm | Containerfile 2025-12-02 15:29:50.047758 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007877 2025-12-02 15:30:19.149808 | 2025-12-02 15:30:19.149968 | TASK [upload-logs : Upload logs to log server] 2025-12-02 15:30:19.782403 | localhost | Output suppressed because no_log was given 2025-12-02 15:30:19.787321 | 2025-12-02 15:30:19.787592 | LOOP [upload-logs : Compress console log and json output] 2025-12-02 15:30:19.864396 | localhost | skipping: Conditional result was False 2025-12-02 15:30:19.866043 | localhost | skipping: Conditional result was False 2025-12-02 15:30:19.872729 | 2025-12-02 15:30:19.872885 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-02 15:30:19.930394 | localhost | skipping: Conditional result was False 2025-12-02 15:30:19.930802 | 2025-12-02 15:30:19.937066 | localhost | skipping: Conditional result was False 2025-12-02 15:30:19.942149 | 2025-12-02 15:30:19.942287 | LOOP [upload-logs : Upload console log and json output]