2025-12-02 16:28:51.705922 | Job console starting 2025-12-02 16:28:51.756762 | Updating git repos 2025-12-02 16:28:51.871733 | Cloning repos into workspace 2025-12-02 16:28:51.969190 | Restoring repo states 2025-12-02 16:28:52.005775 | Merging changes 2025-12-02 16:28:52.636649 | Checking out repos 2025-12-02 16:28:52.729669 | Preparing playbooks 2025-12-02 16:28:53.819849 | Running Ansible setup 2025-12-02 16:28:59.676173 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-02 16:29:00.944473 | 2025-12-02 16:29:00.944681 | PLAY [Base pre] 2025-12-02 16:29:00.973883 | 2025-12-02 16:29:00.974066 | TASK [Setup log path fact] 2025-12-02 16:29:01.015569 | debian-bookworm | ok 2025-12-02 16:29:01.042148 | 2025-12-02 16:29:01.042335 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-02 16:29:01.106020 | debian-bookworm | ok 2025-12-02 16:29:01.121878 | 2025-12-02 16:29:01.122025 | TASK [emit-job-header : Print job information] 2025-12-02 16:29:01.162728 | # Job Information 2025-12-02 16:29:01.162993 | Ansible Version: 2.16.14 2025-12-02 16:29:01.163034 | Job: python-black 2025-12-02 16:29:01.163068 | Pipeline: check 2025-12-02 16:29:01.163092 | Executor: 521e9411259a 2025-12-02 16:29:01.163113 | Triggered by: https://github.com/osism/python-osism/pull/1872 2025-12-02 16:29:01.163136 | Event ID: f715b1c0-cf9b-11f0-84f4-6664513bf7c8 2025-12-02 16:29:01.168115 | 2025-12-02 16:29:01.168237 | LOOP [emit-job-header : Print node information] 2025-12-02 16:29:01.282174 | debian-bookworm | ok: 2025-12-02 16:29:01.282468 | debian-bookworm | # Node Information 2025-12-02 16:29:01.282507 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-02 16:29:01.282533 | debian-bookworm | Hostname: debian 2025-12-02 16:29:01.282557 | debian-bookworm | Username: zuul 2025-12-02 16:29:01.282579 | debian-bookworm | Distro: Debian 12.12 2025-12-02 16:29:01.282603 | debian-bookworm | Provider: regiocloud-a 2025-12-02 16:29:01.282624 | debian-bookworm | Region: 2025-12-02 16:29:01.282645 | debian-bookworm | Label: debian-bookworm 2025-12-02 16:29:01.282664 | debian-bookworm | Product Name: OpenStack Nova 2025-12-02 16:29:01.282684 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1a:3f1d 2025-12-02 16:29:01.295922 | 2025-12-02 16:29:01.296080 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-02 16:29:01.878909 | debian-bookworm -> localhost | changed 2025-12-02 16:29:01.891123 | 2025-12-02 16:29:01.891331 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-02 16:29:03.696981 | debian-bookworm -> localhost | changed 2025-12-02 16:29:03.708329 | 2025-12-02 16:29:03.708473 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-02 16:29:04.413966 | debian-bookworm -> localhost | ok 2025-12-02 16:29:04.420364 | 2025-12-02 16:29:04.420475 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-02 16:29:04.458291 | debian-bookworm | ok 2025-12-02 16:29:04.475222 | debian-bookworm | included: /var/lib/zuul/builds/fa7f3d0a24464e62bb97f2b2bef76cee/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-02 16:29:04.481156 | 2025-12-02 16:29:04.481252 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-02 16:29:07.195135 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-02 16:29:07.195334 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fa7f3d0a24464e62bb97f2b2bef76cee/work/fa7f3d0a24464e62bb97f2b2bef76cee_id_rsa 2025-12-02 16:29:07.195372 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fa7f3d0a24464e62bb97f2b2bef76cee/work/fa7f3d0a24464e62bb97f2b2bef76cee_id_rsa.pub 2025-12-02 16:29:07.195399 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-02 16:29:07.195424 | debian-bookworm -> localhost | SHA256:fQ4l9kc75AgLiKDnH/FQSVs3G+eBt/bTNNV7MILaiu0 zuul-build-sshkey 2025-12-02 16:29:07.195447 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-02 16:29:07.195482 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-02 16:29:07.195504 | debian-bookworm -> localhost | | . .o.. +oo .| 2025-12-02 16:29:07.195526 | debian-bookworm -> localhost | | . . o.+ .o*o.o o| 2025-12-02 16:29:07.195547 | debian-bookworm -> localhost | |. . + o .o=.ooooo| 2025-12-02 16:29:07.195566 | debian-bookworm -> localhost | | o + .+.*o= +o| 2025-12-02 16:29:07.195586 | debian-bookworm -> localhost | | . . .oS.+.+.=oo| 2025-12-02 16:29:07.195607 | debian-bookworm -> localhost | | . .. o + .o..| 2025-12-02 16:29:07.195628 | debian-bookworm -> localhost | | . . . . | 2025-12-02 16:29:07.195648 | debian-bookworm -> localhost | | E | 2025-12-02 16:29:07.195669 | debian-bookworm -> localhost | | | 2025-12-02 16:29:07.195689 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-02 16:29:07.195742 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.972383 2025-12-02 16:29:07.201765 | 2025-12-02 16:29:07.201882 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-02 16:29:07.239799 | debian-bookworm | ok 2025-12-02 16:29:07.254805 | debian-bookworm | included: /var/lib/zuul/builds/fa7f3d0a24464e62bb97f2b2bef76cee/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-02 16:29:07.263418 | 2025-12-02 16:29:07.263510 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-02 16:29:07.277201 | debian-bookworm | skipping: Conditional result was False 2025-12-02 16:29:07.283718 | 2025-12-02 16:29:07.283843 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-02 16:29:07.993859 | debian-bookworm | changed 2025-12-02 16:29:07.999734 | 2025-12-02 16:29:07.999861 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-02 16:29:08.247352 | debian-bookworm | ok 2025-12-02 16:29:08.257033 | 2025-12-02 16:29:08.257302 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-02 16:29:08.877983 | debian-bookworm | changed 2025-12-02 16:29:08.886497 | 2025-12-02 16:29:08.886608 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-02 16:29:09.563670 | debian-bookworm | changed 2025-12-02 16:29:09.573616 | 2025-12-02 16:29:09.573755 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-02 16:29:09.596997 | debian-bookworm | skipping: Conditional result was False 2025-12-02 16:29:09.603071 | 2025-12-02 16:29:09.603174 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-02 16:29:10.051997 | debian-bookworm -> localhost | changed 2025-12-02 16:29:10.062630 | 2025-12-02 16:29:10.062737 | TASK [add-build-sshkey : Add back temp key] 2025-12-02 16:29:10.619155 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fa7f3d0a24464e62bb97f2b2bef76cee/work/fa7f3d0a24464e62bb97f2b2bef76cee_id_rsa (zuul-build-sshkey) 2025-12-02 16:29:10.619380 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022049 2025-12-02 16:29:10.626808 | 2025-12-02 16:29:10.626947 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-02 16:29:11.031224 | debian-bookworm | ok 2025-12-02 16:29:11.036902 | 2025-12-02 16:29:11.037041 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-02 16:29:11.061392 | debian-bookworm | skipping: Conditional result was False 2025-12-02 16:29:11.073217 | 2025-12-02 16:29:11.073334 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-02 16:29:11.541811 | debian-bookworm | ok 2025-12-02 16:29:11.564674 | 2025-12-02 16:29:11.564846 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-02 16:29:11.620925 | debian-bookworm | ok 2025-12-02 16:29:11.627411 | 2025-12-02 16:29:11.627541 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-02 16:29:12.087544 | debian-bookworm -> localhost | ok 2025-12-02 16:29:12.094386 | 2025-12-02 16:29:12.094515 | TASK [validate-host : Collect information about the host] 2025-12-02 16:29:13.353553 | debian-bookworm | ok 2025-12-02 16:29:13.364213 | 2025-12-02 16:29:13.364356 | TASK [validate-host : Sanitize hostname] 2025-12-02 16:29:13.487242 | debian-bookworm | ok 2025-12-02 16:29:13.543258 | 2025-12-02 16:29:13.543423 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-02 16:29:14.631316 | debian-bookworm -> localhost | changed 2025-12-02 16:29:14.637849 | 2025-12-02 16:29:14.637981 | TASK [validate-host : Collect information about zuul worker] 2025-12-02 16:29:15.149248 | debian-bookworm | ok 2025-12-02 16:29:15.156794 | 2025-12-02 16:29:15.156983 | TASK [validate-host : Write out all zuul information for each host] 2025-12-02 16:29:15.925279 | debian-bookworm -> localhost | changed 2025-12-02 16:29:15.935924 | 2025-12-02 16:29:15.936048 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-02 16:29:16.197320 | debian-bookworm | ok 2025-12-02 16:29:16.212515 | 2025-12-02 16:29:16.212815 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-02 16:29:17.466378 | debian-bookworm | changed: 2025-12-02 16:29:17.466765 | debian-bookworm | cd+++++++++ src/ 2025-12-02 16:29:17.466811 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-02 16:29:17.466923 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-02 16:29:17.466948 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-02 16:29:17.466969 | debian-bookworm | Containerfile 2025-12-02 16:29:17.467087 | debian-bookworm | Containerfile 2025-12-02 16:29:17.513237 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009421 2025-12-02 16:29:45.035283 | 2025-12-02 16:29:45.035428 | TASK [upload-logs : Upload logs to log server] 2025-12-02 16:29:45.631312 | localhost | Output suppressed because no_log was given 2025-12-02 16:29:45.635462 | 2025-12-02 16:29:45.635675 | LOOP [upload-logs : Compress console log and json output] 2025-12-02 16:29:45.703810 | localhost | skipping: Conditional result was False 2025-12-02 16:29:45.708602 | localhost | skipping: Conditional result was False 2025-12-02 16:29:45.720291 | 2025-12-02 16:29:45.720476 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-02 16:29:45.777502 | localhost | skipping: Conditional result was False 2025-12-02 16:29:45.778105 | 2025-12-02 16:29:45.781995 | localhost | skipping: Conditional result was False 2025-12-02 16:29:45.794293 | 2025-12-02 16:29:45.794505 | LOOP [upload-logs : Upload console log and json output]