2025-06-22 12:38:56.532570 | Job console starting 2025-06-22 12:38:56.553626 | Updating git repos 2025-06-22 12:38:56.635475 | Cloning repos into workspace 2025-06-22 12:38:56.710546 | Restoring repo states 2025-06-22 12:38:56.732687 | Merging changes 2025-06-22 12:38:57.175910 | Checking out repos 2025-06-22 12:38:57.219549 | Preparing playbooks 2025-06-22 12:38:57.932761 | Running Ansible setup 2025-06-22 12:39:02.533134 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-22 12:39:03.574233 | 2025-06-22 12:39:03.574419 | PLAY [Base pre] 2025-06-22 12:39:03.612385 | 2025-06-22 12:39:03.612557 | TASK [Setup log path fact] 2025-06-22 12:39:03.643226 | debian-bookworm | ok 2025-06-22 12:39:03.672815 | 2025-06-22 12:39:03.673012 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-22 12:39:03.725454 | debian-bookworm | ok 2025-06-22 12:39:03.744241 | 2025-06-22 12:39:03.744390 | TASK [emit-job-header : Print job information] 2025-06-22 12:39:03.829571 | # Job Information 2025-06-22 12:39:03.829756 | Ansible Version: 2.16.14 2025-06-22 12:39:03.829792 | Job: python-black 2025-06-22 12:39:03.829826 | Pipeline: check 2025-06-22 12:39:03.829849 | Executor: 521e9411259a 2025-06-22 12:39:03.829871 | Triggered by: https://github.com/osism/python-osism/pull/1494 2025-06-22 12:39:03.829893 | Event ID: d82e75a0-4f65-11f0-8a93-9a319599f401 2025-06-22 12:39:03.851434 | 2025-06-22 12:39:03.851594 | LOOP [emit-job-header : Print node information] 2025-06-22 12:39:03.994797 | debian-bookworm | ok: 2025-06-22 12:39:03.995018 | debian-bookworm | # Node Information 2025-06-22 12:39:03.995055 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-22 12:39:03.995082 | debian-bookworm | Hostname: debian 2025-06-22 12:39:03.995104 | debian-bookworm | Username: zuul 2025-06-22 12:39:03.995125 | debian-bookworm | Distro: Debian 12.11 2025-06-22 12:39:03.995149 | debian-bookworm | Provider: regiocloud-a 2025-06-22 12:39:03.995171 | debian-bookworm | Region: 2025-06-22 12:39:03.995192 | debian-bookworm | Label: debian-bookworm 2025-06-22 12:39:03.995212 | debian-bookworm | Product Name: OpenStack Nova 2025-06-22 12:39:03.995232 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2c:65a3 2025-06-22 12:39:04.008923 | 2025-06-22 12:39:04.009105 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-22 12:39:04.990894 | debian-bookworm -> localhost | changed 2025-06-22 12:39:05.000216 | 2025-06-22 12:39:05.000358 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-22 12:39:07.542668 | debian-bookworm -> localhost | changed 2025-06-22 12:39:07.563420 | 2025-06-22 12:39:07.563529 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-22 12:39:08.209755 | debian-bookworm -> localhost | ok 2025-06-22 12:39:08.218287 | 2025-06-22 12:39:08.218412 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-22 12:39:08.291489 | debian-bookworm | ok 2025-06-22 12:39:08.320286 | debian-bookworm | included: /var/lib/zuul/builds/0ea4fd23519b4cb780e3b05007be4d42/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-22 12:39:08.328770 | 2025-06-22 12:39:08.328872 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-22 12:39:11.378426 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-22 12:39:11.378670 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0ea4fd23519b4cb780e3b05007be4d42/work/0ea4fd23519b4cb780e3b05007be4d42_id_rsa 2025-06-22 12:39:11.378706 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0ea4fd23519b4cb780e3b05007be4d42/work/0ea4fd23519b4cb780e3b05007be4d42_id_rsa.pub 2025-06-22 12:39:11.378727 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-22 12:39:11.378817 | debian-bookworm -> localhost | SHA256:1o/IEIs8VefZ5RKQxFB/QjM986kWR4wvJPdf/3LE658 zuul-build-sshkey 2025-06-22 12:39:11.378854 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-22 12:39:11.378918 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-22 12:39:11.378944 | debian-bookworm -> localhost | | o==o=.+ | 2025-06-22 12:39:11.378963 | debian-bookworm -> localhost | | . oo* X+o | 2025-06-22 12:39:11.379094 | debian-bookworm -> localhost | | o o O *+.| 2025-06-22 12:39:11.379121 | debian-bookworm -> localhost | | . o o . * =o| 2025-06-22 12:39:11.379140 | debian-bookworm -> localhost | | + o S . =.+| 2025-06-22 12:39:11.379161 | debian-bookworm -> localhost | | . + . o o =| 2025-06-22 12:39:11.379178 | debian-bookworm -> localhost | | o . o .o| 2025-06-22 12:39:11.379195 | debian-bookworm -> localhost | | ..+| 2025-06-22 12:39:11.379212 | debian-bookworm -> localhost | | .Eo| 2025-06-22 12:39:11.379228 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-22 12:39:11.379344 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.031990 2025-06-22 12:39:11.385723 | 2025-06-22 12:39:11.385888 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-22 12:39:11.434591 | debian-bookworm | ok 2025-06-22 12:39:11.450379 | debian-bookworm | included: /var/lib/zuul/builds/0ea4fd23519b4cb780e3b05007be4d42/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-22 12:39:11.467463 | 2025-06-22 12:39:11.467562 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-22 12:39:11.514515 | debian-bookworm | skipping: Conditional result was False 2025-06-22 12:39:11.521311 | 2025-06-22 12:39:11.521503 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-22 12:39:12.293157 | debian-bookworm | changed 2025-06-22 12:39:12.297912 | 2025-06-22 12:39:12.297990 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-22 12:39:12.560672 | debian-bookworm | ok 2025-06-22 12:39:12.566149 | 2025-06-22 12:39:12.566242 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-22 12:39:13.195656 | debian-bookworm | changed 2025-06-22 12:39:13.201192 | 2025-06-22 12:39:13.201282 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-22 12:39:13.792005 | debian-bookworm | changed 2025-06-22 12:39:13.797029 | 2025-06-22 12:39:13.797118 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-22 12:39:13.809725 | debian-bookworm | skipping: Conditional result was False 2025-06-22 12:39:13.815172 | 2025-06-22 12:39:13.815255 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-22 12:39:14.250446 | debian-bookworm -> localhost | changed 2025-06-22 12:39:14.260103 | 2025-06-22 12:39:14.260203 | TASK [add-build-sshkey : Add back temp key] 2025-06-22 12:39:14.602388 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0ea4fd23519b4cb780e3b05007be4d42/work/0ea4fd23519b4cb780e3b05007be4d42_id_rsa (zuul-build-sshkey) 2025-06-22 12:39:14.602591 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019231 2025-06-22 12:39:14.609943 | 2025-06-22 12:39:14.610067 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-22 12:39:15.051843 | debian-bookworm | ok 2025-06-22 12:39:15.056709 | 2025-06-22 12:39:15.056805 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-22 12:39:15.084655 | debian-bookworm | skipping: Conditional result was False 2025-06-22 12:39:15.095535 | 2025-06-22 12:39:15.095632 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-22 12:39:15.550926 | debian-bookworm | ok 2025-06-22 12:39:15.561103 | 2025-06-22 12:39:15.561209 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-22 12:39:15.592685 | debian-bookworm | ok 2025-06-22 12:39:15.597541 | 2025-06-22 12:39:15.597628 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-22 12:39:15.905695 | debian-bookworm -> localhost | ok 2025-06-22 12:39:15.912208 | 2025-06-22 12:39:15.912314 | TASK [validate-host : Collect information about the host] 2025-06-22 12:39:17.051110 | debian-bookworm | ok 2025-06-22 12:39:17.069407 | 2025-06-22 12:39:17.069519 | TASK [validate-host : Sanitize hostname] 2025-06-22 12:39:17.174036 | debian-bookworm | ok 2025-06-22 12:39:17.205271 | 2025-06-22 12:39:17.205376 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-22 12:39:17.682800 | debian-bookworm -> localhost | changed 2025-06-22 12:39:17.688515 | 2025-06-22 12:39:17.688617 | TASK [validate-host : Collect information about zuul worker] 2025-06-22 12:39:18.088970 | debian-bookworm | ok 2025-06-22 12:39:18.093539 | 2025-06-22 12:39:18.093638 | TASK [validate-host : Write out all zuul information for each host] 2025-06-22 12:39:18.749969 | debian-bookworm -> localhost | changed 2025-06-22 12:39:18.764966 | 2025-06-22 12:39:18.765127 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-22 12:39:19.082399 | debian-bookworm | ok 2025-06-22 12:39:19.090916 | 2025-06-22 12:39:19.091226 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-22 12:39:20.119949 | debian-bookworm | changed: 2025-06-22 12:39:20.120220 | debian-bookworm | cd+++++++++ src/ 2025-06-22 12:39:20.120263 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-22 12:39:20.120289 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-22 12:39:20.120310 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-22 12:39:20.120332 | debian-bookworm | Containerfile 2025-06-22 12:39:20.120453 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007181 2025-06-22 12:39:45.927814 | 2025-06-22 12:39:45.928059 | TASK [upload-logs : Upload logs to log server] 2025-06-22 12:39:46.505592 | localhost | Output suppressed because no_log was given 2025-06-22 12:39:46.507585 | 2025-06-22 12:39:46.507693 | LOOP [upload-logs : Compress console log and json output] 2025-06-22 12:39:46.565518 | localhost | skipping: Conditional result was False 2025-06-22 12:39:46.571366 | localhost | skipping: Conditional result was False 2025-06-22 12:39:46.574587 | 2025-06-22 12:39:46.574695 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-22 12:39:46.636741 | localhost | skipping: Conditional result was False 2025-06-22 12:39:46.637058 | 2025-06-22 12:39:46.642033 | localhost | skipping: Conditional result was False 2025-06-22 12:39:46.651069 | 2025-06-22 12:39:46.651180 | LOOP [upload-logs : Upload console log and json output]