2025-11-07 13:09:48.946476 | Job console starting 2025-11-07 13:09:48.984263 | Updating git repos 2025-11-07 13:09:49.083092 | Cloning repos into workspace 2025-11-07 13:09:49.144637 | Restoring repo states 2025-11-07 13:09:49.173222 | Merging changes 2025-11-07 13:09:49.781964 | Checking out repos 2025-11-07 13:09:49.865362 | Preparing playbooks 2025-11-07 13:09:51.176117 | Running Ansible setup 2025-11-07 13:09:56.273932 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-07 13:09:57.384170 | 2025-11-07 13:09:57.384334 | PLAY [Base pre] 2025-11-07 13:09:57.402980 | 2025-11-07 13:09:57.403124 | TASK [Setup log path fact] 2025-11-07 13:09:57.445564 | debian-bookworm | ok 2025-11-07 13:09:57.507086 | 2025-11-07 13:09:57.507329 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-07 13:09:57.560183 | debian-bookworm | ok 2025-11-07 13:09:57.583043 | 2025-11-07 13:09:57.583202 | TASK [emit-job-header : Print job information] 2025-11-07 13:09:57.652891 | # Job Information 2025-11-07 13:09:57.653085 | Ansible Version: 2.16.14 2025-11-07 13:09:57.653120 | Job: python-black 2025-11-07 13:09:57.653151 | Pipeline: check 2025-11-07 13:09:57.653172 | Executor: 521e9411259a 2025-11-07 13:09:57.653193 | Triggered by: https://github.com/osism/python-osism/pull/1800 2025-11-07 13:09:57.653215 | Event ID: 03f7f8a0-bbdb-11f0-8420-66541ed02d73 2025-11-07 13:09:57.658806 | 2025-11-07 13:09:57.658961 | LOOP [emit-job-header : Print node information] 2025-11-07 13:09:57.834894 | debian-bookworm | ok: 2025-11-07 13:09:57.835165 | debian-bookworm | # Node Information 2025-11-07 13:09:57.835199 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-07 13:09:57.835223 | debian-bookworm | Hostname: debian 2025-11-07 13:09:57.835245 | debian-bookworm | Username: zuul 2025-11-07 13:09:57.835265 | debian-bookworm | Distro: Debian 12.12 2025-11-07 13:09:57.835292 | debian-bookworm | Provider: regiocloud-a 2025-11-07 13:09:57.835314 | debian-bookworm | Region: 2025-11-07 13:09:57.835336 | debian-bookworm | Label: debian-bookworm 2025-11-07 13:09:57.835356 | debian-bookworm | Product Name: OpenStack Nova 2025-11-07 13:09:57.835375 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedc:7105 2025-11-07 13:09:57.846517 | 2025-11-07 13:09:57.846639 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-07 13:09:58.617498 | debian-bookworm -> localhost | changed 2025-11-07 13:09:58.625840 | 2025-11-07 13:09:58.625945 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-07 13:10:00.120205 | debian-bookworm -> localhost | changed 2025-11-07 13:10:00.128941 | 2025-11-07 13:10:00.129024 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-07 13:10:00.552130 | debian-bookworm -> localhost | ok 2025-11-07 13:10:00.557390 | 2025-11-07 13:10:00.557483 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-07 13:10:00.594090 | debian-bookworm | ok 2025-11-07 13:10:00.620930 | debian-bookworm | included: /var/lib/zuul/builds/9e7a934c59f541c1b05386a68ec9c37c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-07 13:10:00.626132 | 2025-11-07 13:10:00.626209 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-07 13:10:01.994717 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-07 13:10:01.994909 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9e7a934c59f541c1b05386a68ec9c37c/work/9e7a934c59f541c1b05386a68ec9c37c_id_rsa 2025-11-07 13:10:01.994944 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9e7a934c59f541c1b05386a68ec9c37c/work/9e7a934c59f541c1b05386a68ec9c37c_id_rsa.pub 2025-11-07 13:10:01.994967 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-07 13:10:01.994987 | debian-bookworm -> localhost | SHA256:QGpZlp6XurH/5Tu8c5lp+UJ0TTyWABVj6xwzWkwx6t8 zuul-build-sshkey 2025-11-07 13:10:01.995005 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-07 13:10:01.995032 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-07 13:10:01.995050 | debian-bookworm -> localhost | | +. .oX+..| 2025-11-07 13:10:01.995069 | debian-bookworm -> localhost | | *. = ++o| 2025-11-07 13:10:01.995085 | debian-bookworm -> localhost | | +... . . B..o| 2025-11-07 13:10:01.995102 | debian-bookworm -> localhost | | . o.o . = = o| 2025-11-07 13:10:01.995118 | debian-bookworm -> localhost | | oS o + . | 2025-11-07 13:10:01.995139 | debian-bookworm -> localhost | | o . o | 2025-11-07 13:10:01.995156 | debian-bookworm -> localhost | | + ..o E | 2025-11-07 13:10:01.995172 | debian-bookworm -> localhost | | o o+ O | 2025-11-07 13:10:01.995189 | debian-bookworm -> localhost | | .... +B o.| 2025-11-07 13:10:01.995205 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-07 13:10:01.995248 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.803873 2025-11-07 13:10:02.000229 | 2025-11-07 13:10:02.000302 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-07 13:10:02.026178 | debian-bookworm | ok 2025-11-07 13:10:02.033338 | debian-bookworm | included: /var/lib/zuul/builds/9e7a934c59f541c1b05386a68ec9c37c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-07 13:10:02.049279 | 2025-11-07 13:10:02.049349 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-07 13:10:02.088893 | debian-bookworm | skipping: Conditional result was False 2025-11-07 13:10:02.093255 | 2025-11-07 13:10:02.093326 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-07 13:10:02.789525 | debian-bookworm | changed 2025-11-07 13:10:02.801435 | 2025-11-07 13:10:02.801510 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-07 13:10:03.062573 | debian-bookworm | ok 2025-11-07 13:10:03.066956 | 2025-11-07 13:10:03.067035 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-07 13:10:03.709108 | debian-bookworm | changed 2025-11-07 13:10:03.715430 | 2025-11-07 13:10:03.715523 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-07 13:10:04.239620 | debian-bookworm | changed 2025-11-07 13:10:04.243990 | 2025-11-07 13:10:04.244064 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-07 13:10:04.266887 | debian-bookworm | skipping: Conditional result was False 2025-11-07 13:10:04.271556 | 2025-11-07 13:10:04.271629 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-07 13:10:04.668451 | debian-bookworm -> localhost | changed 2025-11-07 13:10:04.689103 | 2025-11-07 13:10:04.689223 | TASK [add-build-sshkey : Add back temp key] 2025-11-07 13:10:05.008390 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9e7a934c59f541c1b05386a68ec9c37c/work/9e7a934c59f541c1b05386a68ec9c37c_id_rsa (zuul-build-sshkey) 2025-11-07 13:10:05.008565 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012513 2025-11-07 13:10:05.015220 | 2025-11-07 13:10:05.015302 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-07 13:10:05.334550 | debian-bookworm | ok 2025-11-07 13:10:05.338998 | 2025-11-07 13:10:05.339081 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-07 13:10:05.361826 | debian-bookworm | skipping: Conditional result was False 2025-11-07 13:10:05.370252 | 2025-11-07 13:10:05.370329 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-07 13:10:05.744204 | debian-bookworm | ok 2025-11-07 13:10:05.754918 | 2025-11-07 13:10:05.755005 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-07 13:10:05.781863 | debian-bookworm | ok 2025-11-07 13:10:05.786721 | 2025-11-07 13:10:05.786813 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-07 13:10:06.188133 | debian-bookworm -> localhost | ok 2025-11-07 13:10:06.193381 | 2025-11-07 13:10:06.193460 | TASK [validate-host : Collect information about the host] 2025-11-07 13:10:07.221494 | debian-bookworm | ok 2025-11-07 13:10:07.229743 | 2025-11-07 13:10:07.229833 | TASK [validate-host : Sanitize hostname] 2025-11-07 13:10:07.297102 | debian-bookworm | ok 2025-11-07 13:10:07.321730 | 2025-11-07 13:10:07.321828 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-07 13:10:07.847240 | debian-bookworm -> localhost | changed 2025-11-07 13:10:07.852637 | 2025-11-07 13:10:07.852737 | TASK [validate-host : Collect information about zuul worker] 2025-11-07 13:10:08.266909 | debian-bookworm | ok 2025-11-07 13:10:08.271316 | 2025-11-07 13:10:08.271404 | TASK [validate-host : Write out all zuul information for each host] 2025-11-07 13:10:08.923822 | debian-bookworm -> localhost | changed 2025-11-07 13:10:08.932837 | 2025-11-07 13:10:08.932936 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-07 13:10:09.153841 | debian-bookworm | ok 2025-11-07 13:10:09.160182 | 2025-11-07 13:10:09.160280 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-07 13:10:10.236725 | debian-bookworm | changed: 2025-11-07 13:10:10.236904 | debian-bookworm | cd+++++++++ src/ 2025-11-07 13:10:10.236940 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-07 13:10:10.236965 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-07 13:10:10.236987 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-07 13:10:10.237008 | debian-bookworm | Containerfile 2025-11-07 13:10:10.237125 | debian-bookworm | Containerfile 2025-11-07 13:10:10.249869 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005608 2025-11-07 13:10:36.149881 | 2025-11-07 13:10:36.150058 | TASK [upload-logs : Upload logs to log server] 2025-11-07 13:10:36.696805 | localhost | Output suppressed because no_log was given 2025-11-07 13:10:36.701118 | 2025-11-07 13:10:36.701332 | LOOP [upload-logs : Compress console log and json output] 2025-11-07 13:10:36.757092 | localhost | skipping: Conditional result was False 2025-11-07 13:10:36.760663 | localhost | skipping: Conditional result was False 2025-11-07 13:10:36.773805 | 2025-11-07 13:10:36.774020 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-07 13:10:36.837610 | localhost | skipping: Conditional result was False 2025-11-07 13:10:36.838320 | 2025-11-07 13:10:36.843111 | localhost | skipping: Conditional result was False 2025-11-07 13:10:36.857293 | 2025-11-07 13:10:36.857524 | LOOP [upload-logs : Upload console log and json output]