2025-09-30 03:09:32.612294 | Job console starting 2025-09-30 03:09:32.619375 | Updating git repos 2025-09-30 03:09:32.664918 | Cloning repos into workspace 2025-09-30 03:09:32.735028 | Restoring repo states 2025-09-30 03:09:32.771965 | Merging changes 2025-09-30 03:09:32.771981 | Checking out repos 2025-09-30 03:09:32.895333 | Preparing playbooks 2025-09-30 03:09:33.726065 | Running Ansible setup 2025-09-30 03:09:39.508367 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-30 03:09:40.186256 | 2025-09-30 03:09:40.186381 | PLAY [Base pre] 2025-09-30 03:09:40.201341 | 2025-09-30 03:09:40.201457 | TASK [Setup log path fact] 2025-09-30 03:09:40.229224 | debian-bookworm | ok 2025-09-30 03:09:40.243071 | 2025-09-30 03:09:40.243176 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-30 03:09:40.271107 | debian-bookworm | ok 2025-09-30 03:09:40.280223 | 2025-09-30 03:09:40.280314 | TASK [emit-job-header : Print job information] 2025-09-30 03:09:40.335279 | # Job Information 2025-09-30 03:09:40.335573 | Ansible Version: 2.16.14 2025-09-30 03:09:40.335647 | Job: python-black 2025-09-30 03:09:40.335713 | Pipeline: periodic-daily 2025-09-30 03:09:40.335760 | Executor: 521e9411259a 2025-09-30 03:09:40.335802 | Triggered by: https://github.com/osism/python-osism 2025-09-30 03:09:40.335847 | Event ID: a3257cee3e6b41279d7276c08936b0c8 2025-09-30 03:09:40.343536 | 2025-09-30 03:09:40.343665 | LOOP [emit-job-header : Print node information] 2025-09-30 03:09:40.462080 | debian-bookworm | ok: 2025-09-30 03:09:40.462472 | debian-bookworm | # Node Information 2025-09-30 03:09:40.462556 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-30 03:09:40.462609 | debian-bookworm | Hostname: debian 2025-09-30 03:09:40.462655 | debian-bookworm | Username: zuul 2025-09-30 03:09:40.462699 | debian-bookworm | Distro: Debian 12.12 2025-09-30 03:09:40.462748 | debian-bookworm | Provider: regiocloud-a 2025-09-30 03:09:40.462794 | debian-bookworm | Region: 2025-09-30 03:09:40.462866 | debian-bookworm | Label: debian-bookworm 2025-09-30 03:09:40.462914 | debian-bookworm | Product Name: OpenStack Nova 2025-09-30 03:09:40.462957 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feab:2981 2025-09-30 03:09:40.482738 | 2025-09-30 03:09:40.482864 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-30 03:09:40.906679 | debian-bookworm -> localhost | changed 2025-09-30 03:09:40.913366 | 2025-09-30 03:09:40.913479 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-30 03:09:41.768341 | debian-bookworm -> localhost | changed 2025-09-30 03:09:41.784349 | 2025-09-30 03:09:41.784470 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-30 03:09:42.089684 | debian-bookworm -> localhost | ok 2025-09-30 03:09:42.097081 | 2025-09-30 03:09:42.097282 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-30 03:09:42.126753 | debian-bookworm | ok 2025-09-30 03:09:42.148161 | debian-bookworm | included: /var/lib/zuul/builds/6dd97815f0f84e6e9c594ac9b01e6388/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-30 03:09:42.155371 | 2025-09-30 03:09:42.155489 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-30 03:09:43.036955 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-30 03:09:43.037374 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6dd97815f0f84e6e9c594ac9b01e6388/work/6dd97815f0f84e6e9c594ac9b01e6388_id_rsa 2025-09-30 03:09:43.037491 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6dd97815f0f84e6e9c594ac9b01e6388/work/6dd97815f0f84e6e9c594ac9b01e6388_id_rsa.pub 2025-09-30 03:09:43.037561 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-30 03:09:43.037627 | debian-bookworm -> localhost | SHA256:Q1Q49QF1f/2aYZwa4q3bdFmLb9Pczvo7Pi/4p3SZx7c zuul-build-sshkey 2025-09-30 03:09:43.037687 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-30 03:09:43.037762 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-30 03:09:43.037820 | debian-bookworm -> localhost | | .++oo . | 2025-09-30 03:09:43.037874 | debian-bookworm -> localhost | | .o . o ..| 2025-09-30 03:09:43.037927 | debian-bookworm -> localhost | | .. . +| 2025-09-30 03:09:43.037978 | debian-bookworm -> localhost | | . . .o| 2025-09-30 03:09:43.038029 | debian-bookworm -> localhost | | S . . = o| 2025-09-30 03:09:43.038088 | debian-bookworm -> localhost | | o o +.B+| 2025-09-30 03:09:43.038141 | debian-bookworm -> localhost | | . +o*=B| 2025-09-30 03:09:43.038196 | debian-bookworm -> localhost | | +.ooBO| 2025-09-30 03:09:43.038252 | debian-bookworm -> localhost | | o...*E@| 2025-09-30 03:09:43.038303 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-30 03:09:43.038437 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.434129 2025-09-30 03:09:43.054489 | 2025-09-30 03:09:43.054589 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-30 03:09:43.072104 | debian-bookworm | ok 2025-09-30 03:09:43.080854 | debian-bookworm | included: /var/lib/zuul/builds/6dd97815f0f84e6e9c594ac9b01e6388/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-30 03:09:43.089425 | 2025-09-30 03:09:43.089505 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-30 03:09:43.112849 | debian-bookworm | skipping: Conditional result was False 2025-09-30 03:09:43.118408 | 2025-09-30 03:09:43.118495 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-30 03:09:43.764351 | debian-bookworm | changed 2025-09-30 03:09:43.769544 | 2025-09-30 03:09:43.769625 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-30 03:09:44.001729 | debian-bookworm | ok 2025-09-30 03:09:44.033648 | 2025-09-30 03:09:44.033763 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-30 03:09:44.777831 | debian-bookworm | changed 2025-09-30 03:09:44.784310 | 2025-09-30 03:09:44.784438 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-30 03:09:45.441772 | debian-bookworm | changed 2025-09-30 03:09:45.450553 | 2025-09-30 03:09:45.450683 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-30 03:09:45.475054 | debian-bookworm | skipping: Conditional result was False 2025-09-30 03:09:45.486749 | 2025-09-30 03:09:45.486926 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-30 03:09:45.896343 | debian-bookworm -> localhost | changed 2025-09-30 03:09:45.906585 | 2025-09-30 03:09:45.906680 | TASK [add-build-sshkey : Add back temp key] 2025-09-30 03:09:46.212303 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6dd97815f0f84e6e9c594ac9b01e6388/work/6dd97815f0f84e6e9c594ac9b01e6388_id_rsa (zuul-build-sshkey) 2025-09-30 03:09:46.212530 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008793 2025-09-30 03:09:46.220066 | 2025-09-30 03:09:46.220159 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-30 03:09:46.606237 | debian-bookworm | ok 2025-09-30 03:09:46.612815 | 2025-09-30 03:09:46.613214 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-30 03:09:46.636971 | debian-bookworm | skipping: Conditional result was False 2025-09-30 03:09:46.647841 | 2025-09-30 03:09:46.647947 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-30 03:09:47.061364 | debian-bookworm | ok 2025-09-30 03:09:47.071358 | 2025-09-30 03:09:47.071461 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-30 03:09:47.099143 | debian-bookworm | ok 2025-09-30 03:09:47.103792 | 2025-09-30 03:09:47.103870 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-30 03:09:47.401406 | debian-bookworm -> localhost | ok 2025-09-30 03:09:47.412147 | 2025-09-30 03:09:47.412274 | TASK [validate-host : Collect information about the host] 2025-09-30 03:09:48.493456 | debian-bookworm | ok 2025-09-30 03:09:48.503499 | 2025-09-30 03:09:48.503607 | TASK [validate-host : Sanitize hostname] 2025-09-30 03:09:48.621879 | debian-bookworm | ok 2025-09-30 03:09:48.674471 | 2025-09-30 03:09:48.674621 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-30 03:09:49.260997 | debian-bookworm -> localhost | changed 2025-09-30 03:09:49.266542 | 2025-09-30 03:09:49.266632 | TASK [validate-host : Collect information about zuul worker] 2025-09-30 03:09:49.699940 | debian-bookworm | ok 2025-09-30 03:09:49.706597 | 2025-09-30 03:09:49.706715 | TASK [validate-host : Write out all zuul information for each host] 2025-09-30 03:09:50.263141 | debian-bookworm -> localhost | changed 2025-09-30 03:09:50.274780 | 2025-09-30 03:09:50.274955 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-30 03:09:50.550079 | debian-bookworm | ok 2025-09-30 03:09:50.557163 | 2025-09-30 03:09:50.557264 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-30 03:09:51.533400 | debian-bookworm | changed: 2025-09-30 03:09:51.533617 | debian-bookworm | cd+++++++++ src/ 2025-09-30 03:09:51.533652 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-30 03:09:51.533677 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-30 03:09:51.533699 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-09-30 03:09:51.533719 | debian-bookworm | Containerfile 2025-09-30 03:09:51.534361 | debian-bookworm | Containerfile 2025-09-30 03:09:51.556742 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007053 2025-09-30 03:10:19.284773 | 2025-09-30 03:10:19.284860 | TASK [upload-logs : Upload logs to log server] 2025-09-30 03:10:19.835600 | localhost | Output suppressed because no_log was given 2025-09-30 03:10:19.837561 | 2025-09-30 03:10:19.837657 | LOOP [upload-logs : Compress console log and json output] 2025-09-30 03:10:19.879158 | localhost | skipping: Conditional result was False 2025-09-30 03:10:19.886387 | localhost | skipping: Conditional result was False 2025-09-30 03:10:19.894219 | 2025-09-30 03:10:19.894299 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-30 03:10:19.931769 | localhost | skipping: Conditional result was False 2025-09-30 03:10:19.931984 | 2025-09-30 03:10:19.938038 | localhost | skipping: Conditional result was False 2025-09-30 03:10:19.941632 | 2025-09-30 03:10:19.941721 | LOOP [upload-logs : Upload console log and json output]