2025-08-23 09:54:14.927709 | Job console starting 2025-08-23 09:54:14.947257 | Updating git repos 2025-08-23 09:54:14.974908 | Cloning repos into workspace 2025-08-23 09:54:15.037936 | Restoring repo states 2025-08-23 09:54:15.050548 | Merging changes 2025-08-23 09:54:15.595853 | Checking out repos 2025-08-23 09:54:15.692442 | Preparing playbooks 2025-08-23 09:54:16.300174 | Running Ansible setup 2025-08-23 09:54:20.875501 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-23 09:54:21.687469 | 2025-08-23 09:54:21.687632 | PLAY [Base pre] 2025-08-23 09:54:21.703749 | 2025-08-23 09:54:21.703902 | TASK [Setup log path fact] 2025-08-23 09:54:21.733538 | debian-bookworm | ok 2025-08-23 09:54:21.749085 | 2025-08-23 09:54:21.749241 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-23 09:54:21.778989 | debian-bookworm | ok 2025-08-23 09:54:21.788930 | 2025-08-23 09:54:21.789049 | TASK [emit-job-header : Print job information] 2025-08-23 09:54:21.828281 | # Job Information 2025-08-23 09:54:21.828474 | Ansible Version: 2.16.14 2025-08-23 09:54:21.828508 | Job: python-black 2025-08-23 09:54:21.828540 | Pipeline: check 2025-08-23 09:54:21.828563 | Executor: 521e9411259a 2025-08-23 09:54:21.828583 | Triggered by: https://github.com/osism/python-osism/pull/1656 2025-08-23 09:54:21.828605 | Event ID: 0728b4c0-8007-11f0-8adf-79aa1e588a42 2025-08-23 09:54:21.836630 | 2025-08-23 09:54:21.836792 | LOOP [emit-job-header : Print node information] 2025-08-23 09:54:21.975656 | debian-bookworm | ok: 2025-08-23 09:54:21.975891 | debian-bookworm | # Node Information 2025-08-23 09:54:21.975927 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-23 09:54:21.975953 | debian-bookworm | Hostname: debian 2025-08-23 09:54:21.975975 | debian-bookworm | Username: zuul 2025-08-23 09:54:21.975996 | debian-bookworm | Distro: Debian 12.11 2025-08-23 09:54:21.976021 | debian-bookworm | Provider: regiocloud-a 2025-08-23 09:54:21.976042 | debian-bookworm | Region: 2025-08-23 09:54:21.976063 | debian-bookworm | Label: debian-bookworm 2025-08-23 09:54:21.976082 | debian-bookworm | Product Name: OpenStack Nova 2025-08-23 09:54:21.976102 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:febb:5b75 2025-08-23 09:54:21.992876 | 2025-08-23 09:54:21.993103 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-23 09:54:22.599136 | debian-bookworm -> localhost | changed 2025-08-23 09:54:22.612139 | 2025-08-23 09:54:22.612283 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-23 09:54:23.681884 | debian-bookworm -> localhost | changed 2025-08-23 09:54:23.702040 | 2025-08-23 09:54:23.702194 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-23 09:54:24.000628 | debian-bookworm -> localhost | ok 2025-08-23 09:54:24.013555 | 2025-08-23 09:54:24.013747 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-23 09:54:24.045039 | debian-bookworm | ok 2025-08-23 09:54:24.076392 | debian-bookworm | included: /var/lib/zuul/builds/fe673f79fb3a434f9d43b28b2de3d47d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-23 09:54:24.082947 | 2025-08-23 09:54:24.083060 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-23 09:54:26.897753 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-23 09:54:26.898090 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fe673f79fb3a434f9d43b28b2de3d47d/work/fe673f79fb3a434f9d43b28b2de3d47d_id_rsa 2025-08-23 09:54:26.898153 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fe673f79fb3a434f9d43b28b2de3d47d/work/fe673f79fb3a434f9d43b28b2de3d47d_id_rsa.pub 2025-08-23 09:54:26.898195 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-23 09:54:26.898236 | debian-bookworm -> localhost | SHA256:YQgJfnRmwjJVKHTrBhPa9jzp6dAtysR10egjDOPFDcY zuul-build-sshkey 2025-08-23 09:54:26.898272 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-23 09:54:26.898324 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-23 09:54:26.898361 | debian-bookworm -> localhost | | .+=O+= | 2025-08-23 09:54:26.898396 | debian-bookworm -> localhost | | ++*EX + | 2025-08-23 09:54:26.898429 | debian-bookworm -> localhost | |. O+= = + | 2025-08-23 09:54:26.898460 | debian-bookworm -> localhost | | o % o o . | 2025-08-23 09:54:26.898517 | debian-bookworm -> localhost | | . @ + S | 2025-08-23 09:54:26.898561 | debian-bookworm -> localhost | | . = * . | 2025-08-23 09:54:26.898596 | debian-bookworm -> localhost | | + = . | 2025-08-23 09:54:26.898629 | debian-bookworm -> localhost | | o + . | 2025-08-23 09:54:26.898662 | debian-bookworm -> localhost | | o . | 2025-08-23 09:54:26.898809 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-23 09:54:26.899055 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.286225 2025-08-23 09:54:26.909522 | 2025-08-23 09:54:26.909670 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-23 09:54:26.970073 | debian-bookworm | ok 2025-08-23 09:54:26.993873 | debian-bookworm | included: /var/lib/zuul/builds/fe673f79fb3a434f9d43b28b2de3d47d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-23 09:54:27.005907 | 2025-08-23 09:54:27.006038 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-23 09:54:27.040922 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:54:27.048355 | 2025-08-23 09:54:27.048471 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-23 09:54:27.775298 | debian-bookworm | changed 2025-08-23 09:54:27.782469 | 2025-08-23 09:54:27.782590 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-23 09:54:28.066999 | debian-bookworm | ok 2025-08-23 09:54:28.074584 | 2025-08-23 09:54:28.074695 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-23 09:54:28.696588 | debian-bookworm | changed 2025-08-23 09:54:28.704352 | 2025-08-23 09:54:28.704476 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-23 09:54:29.380746 | debian-bookworm | changed 2025-08-23 09:54:29.386449 | 2025-08-23 09:54:29.386556 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-23 09:54:29.410441 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:54:29.417735 | 2025-08-23 09:54:29.417859 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-23 09:54:29.884359 | debian-bookworm -> localhost | changed 2025-08-23 09:54:29.901517 | 2025-08-23 09:54:29.901649 | TASK [add-build-sshkey : Add back temp key] 2025-08-23 09:54:30.268487 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fe673f79fb3a434f9d43b28b2de3d47d/work/fe673f79fb3a434f9d43b28b2de3d47d_id_rsa (zuul-build-sshkey) 2025-08-23 09:54:30.269417 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015322 2025-08-23 09:54:30.282957 | 2025-08-23 09:54:30.283180 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-23 09:54:30.774954 | debian-bookworm | ok 2025-08-23 09:54:30.790925 | 2025-08-23 09:54:30.791066 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-23 09:54:30.826076 | debian-bookworm | skipping: Conditional result was False 2025-08-23 09:54:30.837796 | 2025-08-23 09:54:30.837923 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-23 09:54:31.286910 | debian-bookworm | ok 2025-08-23 09:54:31.299945 | 2025-08-23 09:54:31.300073 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-23 09:54:31.339333 | debian-bookworm | ok 2025-08-23 09:54:31.345167 | 2025-08-23 09:54:31.345283 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-23 09:54:31.663315 | debian-bookworm -> localhost | ok 2025-08-23 09:54:31.670584 | 2025-08-23 09:54:31.670713 | TASK [validate-host : Collect information about the host] 2025-08-23 09:54:32.882181 | debian-bookworm | ok 2025-08-23 09:54:32.892629 | 2025-08-23 09:54:32.892744 | TASK [validate-host : Sanitize hostname] 2025-08-23 09:54:33.003825 | debian-bookworm | ok 2025-08-23 09:54:33.053545 | 2025-08-23 09:54:33.053677 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-23 09:54:33.723583 | debian-bookworm -> localhost | changed 2025-08-23 09:54:33.737570 | 2025-08-23 09:54:33.737745 | TASK [validate-host : Collect information about zuul worker] 2025-08-23 09:54:34.155102 | debian-bookworm | ok 2025-08-23 09:54:34.160672 | 2025-08-23 09:54:34.160819 | TASK [validate-host : Write out all zuul information for each host] 2025-08-23 09:54:35.313953 | debian-bookworm -> localhost | changed 2025-08-23 09:54:35.324200 | 2025-08-23 09:54:35.324344 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-23 09:54:35.586563 | debian-bookworm | ok 2025-08-23 09:54:35.595363 | 2025-08-23 09:54:35.595498 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-23 09:54:37.057088 | debian-bookworm | changed: 2025-08-23 09:54:37.057306 | debian-bookworm | cd+++++++++ src/ 2025-08-23 09:54:37.057342 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-23 09:54:37.057366 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-23 09:54:37.057388 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-23 09:54:37.057409 | debian-bookworm | Containerfile 2025-08-23 09:54:37.057520 | debian-bookworm | Containerfile 2025-08-23 09:54:37.146267 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007299 2025-08-23 09:55:04.710600 | 2025-08-23 09:55:04.710679 | TASK [upload-logs : Upload logs to log server] 2025-08-23 09:55:05.306149 | localhost | Output suppressed because no_log was given 2025-08-23 09:55:05.308083 | 2025-08-23 09:55:05.308163 | LOOP [upload-logs : Compress console log and json output] 2025-08-23 09:55:05.367533 | localhost | skipping: Conditional result was False 2025-08-23 09:55:05.374343 | localhost | skipping: Conditional result was False 2025-08-23 09:55:05.386691 | 2025-08-23 09:55:05.386807 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-23 09:55:05.441765 | localhost | skipping: Conditional result was False 2025-08-23 09:55:05.442043 | 2025-08-23 09:55:05.447503 | localhost | skipping: Conditional result was False 2025-08-23 09:55:05.454566 | 2025-08-23 09:55:05.454698 | LOOP [upload-logs : Upload console log and json output]