2025-10-12 14:07:44.553758 | Job console starting 2025-10-12 14:07:44.571231 | Updating git repos 2025-10-12 14:07:44.630090 | Cloning repos into workspace 2025-10-12 14:07:44.708920 | Restoring repo states 2025-10-12 14:07:44.735359 | Merging changes 2025-10-12 14:07:45.338699 | Checking out repos 2025-10-12 14:07:45.416668 | Preparing playbooks 2025-10-12 14:07:46.675280 | Running Ansible setup 2025-10-12 14:07:52.530893 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-12 14:07:53.854706 | 2025-10-12 14:07:53.854826 | PLAY [Base pre] 2025-10-12 14:07:53.888618 | 2025-10-12 14:07:53.888742 | TASK [Setup log path fact] 2025-10-12 14:07:53.917008 | debian-bookworm | ok 2025-10-12 14:07:53.943859 | 2025-10-12 14:07:53.943981 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-12 14:07:53.972251 | debian-bookworm | ok 2025-10-12 14:07:53.981760 | 2025-10-12 14:07:53.981855 | TASK [emit-job-header : Print job information] 2025-10-12 14:07:54.060122 | # Job Information 2025-10-12 14:07:54.060273 | Ansible Version: 2.16.14 2025-10-12 14:07:54.060308 | Job: python-black 2025-10-12 14:07:54.060340 | Pipeline: check 2025-10-12 14:07:54.060362 | Executor: 521e9411259a 2025-10-12 14:07:54.060383 | Triggered by: https://github.com/osism/python-osism/pull/1749 2025-10-12 14:07:54.060404 | Event ID: cd844cd0-a774-11f0-8632-c5ab8e4cdd3f 2025-10-12 14:07:54.065086 | 2025-10-12 14:07:54.065179 | LOOP [emit-job-header : Print node information] 2025-10-12 14:07:54.213605 | debian-bookworm | ok: 2025-10-12 14:07:54.213755 | debian-bookworm | # Node Information 2025-10-12 14:07:54.213787 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-12 14:07:54.213811 | debian-bookworm | Hostname: debian 2025-10-12 14:07:54.213833 | debian-bookworm | Username: zuul 2025-10-12 14:07:54.213853 | debian-bookworm | Distro: Debian 12.12 2025-10-12 14:07:54.213878 | debian-bookworm | Provider: regiocloud-a 2025-10-12 14:07:54.213899 | debian-bookworm | Region: 2025-10-12 14:07:54.213919 | debian-bookworm | Label: debian-bookworm 2025-10-12 14:07:54.213938 | debian-bookworm | Product Name: OpenStack Nova 2025-10-12 14:07:54.213981 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec4:3ea0 2025-10-12 14:07:54.226121 | 2025-10-12 14:07:54.226223 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-12 14:07:54.743788 | debian-bookworm -> localhost | changed 2025-10-12 14:07:54.750849 | 2025-10-12 14:07:54.750971 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-12 14:07:56.635225 | debian-bookworm -> localhost | changed 2025-10-12 14:07:56.645533 | 2025-10-12 14:07:56.645658 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-12 14:07:57.018742 | debian-bookworm -> localhost | ok 2025-10-12 14:07:57.024482 | 2025-10-12 14:07:57.024605 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-12 14:07:57.057773 | debian-bookworm | ok 2025-10-12 14:07:57.097906 | debian-bookworm | included: /var/lib/zuul/builds/761c288a8384440db073beb57cfa1ed7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-12 14:07:57.111789 | 2025-10-12 14:07:57.111887 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-12 14:07:59.143328 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-12 14:07:59.143499 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/761c288a8384440db073beb57cfa1ed7/work/761c288a8384440db073beb57cfa1ed7_id_rsa 2025-10-12 14:07:59.143529 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/761c288a8384440db073beb57cfa1ed7/work/761c288a8384440db073beb57cfa1ed7_id_rsa.pub 2025-10-12 14:07:59.143550 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-12 14:07:59.143587 | debian-bookworm -> localhost | SHA256:WSPH/nqVCi7E8uqTl0PSEpZ89c5wVRju1co7ayHajtE zuul-build-sshkey 2025-10-12 14:07:59.143608 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-12 14:07:59.143636 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-12 14:07:59.143654 | debian-bookworm -> localhost | | .+.| 2025-10-12 14:07:59.143672 | debian-bookworm -> localhost | | .. .o .| 2025-10-12 14:07:59.143690 | debian-bookworm -> localhost | | . ...=. .. o| 2025-10-12 14:07:59.143707 | debian-bookworm -> localhost | | = .*..oo o | 2025-10-12 14:07:59.143723 | debian-bookworm -> localhost | | . =S .= +. | 2025-10-12 14:07:59.143743 | debian-bookworm -> localhost | | + = .o+ +. | 2025-10-12 14:07:59.143760 | debian-bookworm -> localhost | | O o.+E+o. | 2025-10-12 14:07:59.143776 | debian-bookworm -> localhost | | o * o++ .o | 2025-10-12 14:07:59.143792 | debian-bookworm -> localhost | | .o+ ooo... | 2025-10-12 14:07:59.143808 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-12 14:07:59.143846 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.341476 2025-10-12 14:07:59.149011 | 2025-10-12 14:07:59.149096 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-12 14:07:59.165314 | debian-bookworm | ok 2025-10-12 14:07:59.173959 | debian-bookworm | included: /var/lib/zuul/builds/761c288a8384440db073beb57cfa1ed7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-12 14:07:59.181118 | 2025-10-12 14:07:59.181193 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-12 14:07:59.193641 | debian-bookworm | skipping: Conditional result was False 2025-10-12 14:07:59.199147 | 2025-10-12 14:07:59.199234 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-12 14:07:59.828642 | debian-bookworm | changed 2025-10-12 14:07:59.837207 | 2025-10-12 14:07:59.837303 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-12 14:08:00.114343 | debian-bookworm | ok 2025-10-12 14:08:00.127125 | 2025-10-12 14:08:00.127252 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-12 14:08:00.813053 | debian-bookworm | changed 2025-10-12 14:08:00.828027 | 2025-10-12 14:08:00.828120 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-12 14:08:01.416256 | debian-bookworm | changed 2025-10-12 14:08:01.422971 | 2025-10-12 14:08:01.423070 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-12 14:08:01.446511 | debian-bookworm | skipping: Conditional result was False 2025-10-12 14:08:01.457414 | 2025-10-12 14:08:01.457561 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-12 14:08:02.063208 | debian-bookworm -> localhost | changed 2025-10-12 14:08:02.073624 | 2025-10-12 14:08:02.073719 | TASK [add-build-sshkey : Add back temp key] 2025-10-12 14:08:02.478894 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/761c288a8384440db073beb57cfa1ed7/work/761c288a8384440db073beb57cfa1ed7_id_rsa (zuul-build-sshkey) 2025-10-12 14:08:02.479110 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014109 2025-10-12 14:08:02.486391 | 2025-10-12 14:08:02.486484 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-12 14:08:02.850288 | debian-bookworm | ok 2025-10-12 14:08:02.855167 | 2025-10-12 14:08:02.855254 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-12 14:08:02.877990 | debian-bookworm | skipping: Conditional result was False 2025-10-12 14:08:02.888655 | 2025-10-12 14:08:02.888753 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-12 14:08:03.284026 | debian-bookworm | ok 2025-10-12 14:08:03.294249 | 2025-10-12 14:08:03.294346 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-12 14:08:03.333883 | debian-bookworm | ok 2025-10-12 14:08:03.338745 | 2025-10-12 14:08:03.338845 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-12 14:08:03.679176 | debian-bookworm -> localhost | ok 2025-10-12 14:08:03.685270 | 2025-10-12 14:08:03.685362 | TASK [validate-host : Collect information about the host] 2025-10-12 14:08:04.727423 | debian-bookworm | ok 2025-10-12 14:08:04.737311 | 2025-10-12 14:08:04.737405 | TASK [validate-host : Sanitize hostname] 2025-10-12 14:08:04.816000 | debian-bookworm | ok 2025-10-12 14:08:04.866861 | 2025-10-12 14:08:04.866970 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-12 14:08:05.485463 | debian-bookworm -> localhost | changed 2025-10-12 14:08:05.491259 | 2025-10-12 14:08:05.491356 | TASK [validate-host : Collect information about zuul worker] 2025-10-12 14:08:05.904200 | debian-bookworm | ok 2025-10-12 14:08:05.908650 | 2025-10-12 14:08:05.908740 | TASK [validate-host : Write out all zuul information for each host] 2025-10-12 14:08:06.519568 | debian-bookworm -> localhost | changed 2025-10-12 14:08:06.526979 | 2025-10-12 14:08:06.527055 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-12 14:08:06.776731 | debian-bookworm | ok 2025-10-12 14:08:06.781897 | 2025-10-12 14:08:06.781975 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-12 14:08:07.838377 | debian-bookworm | changed: 2025-10-12 14:08:07.838516 | debian-bookworm | cd+++++++++ src/ 2025-10-12 14:08:07.838544 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-12 14:08:07.838563 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-12 14:08:07.838592 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-12 14:08:07.838609 | debian-bookworm | Containerfile 2025-10-12 14:08:07.838702 | debian-bookworm | Containerfile 2025-10-12 14:08:07.869897 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004205 2025-10-12 14:08:34.390769 | 2025-10-12 14:08:34.390925 | TASK [upload-logs : Upload logs to log server] 2025-10-12 14:08:34.936251 | localhost | Output suppressed because no_log was given 2025-10-12 14:08:34.940115 | 2025-10-12 14:08:34.940297 | LOOP [upload-logs : Compress console log and json output] 2025-10-12 14:08:34.991511 | localhost | skipping: Conditional result was False 2025-10-12 14:08:34.997132 | localhost | skipping: Conditional result was False 2025-10-12 14:08:35.000942 | 2025-10-12 14:08:35.001063 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-12 14:08:35.048131 | localhost | skipping: Conditional result was False 2025-10-12 14:08:35.048737 | 2025-10-12 14:08:35.052271 | localhost | skipping: Conditional result was False 2025-10-12 14:08:35.060202 | 2025-10-12 14:08:35.060396 | LOOP [upload-logs : Upload console log and json output]