2025-10-03 21:42:23.448420 | Job console starting 2025-10-03 21:42:23.463111 | Updating git repos 2025-10-03 21:42:23.491130 | Cloning repos into workspace 2025-10-03 21:42:23.567566 | Restoring repo states 2025-10-03 21:42:23.583007 | Merging changes 2025-10-03 21:42:24.077689 | Checking out repos 2025-10-03 21:42:24.123154 | Preparing playbooks 2025-10-03 21:42:24.637763 | Running Ansible setup 2025-10-03 21:42:30.191230 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-03 21:42:31.058301 | 2025-10-03 21:42:31.058458 | PLAY [Base pre] 2025-10-03 21:42:31.082318 | 2025-10-03 21:42:31.082461 | TASK [Setup log path fact] 2025-10-03 21:42:31.102813 | debian-bookworm | ok 2025-10-03 21:42:31.139508 | 2025-10-03 21:42:31.139671 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-03 21:42:31.191231 | debian-bookworm | ok 2025-10-03 21:42:31.209421 | 2025-10-03 21:42:31.209557 | TASK [emit-job-header : Print job information] 2025-10-03 21:42:31.252682 | # Job Information 2025-10-03 21:42:31.253106 | Ansible Version: 2.16.14 2025-10-03 21:42:31.253169 | Job: python-black 2025-10-03 21:42:31.253206 | Pipeline: check 2025-10-03 21:42:31.253231 | Executor: 521e9411259a 2025-10-03 21:42:31.253252 | Triggered by: https://github.com/osism/python-osism/pull/1712 2025-10-03 21:42:31.253275 | Event ID: bee98840-a0a1-11f0-8048-1567d54ffa7d 2025-10-03 21:42:31.258340 | 2025-10-03 21:42:31.258452 | LOOP [emit-job-header : Print node information] 2025-10-03 21:42:31.430676 | debian-bookworm | ok: 2025-10-03 21:42:31.431257 | debian-bookworm | # Node Information 2025-10-03 21:42:31.431299 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-03 21:42:31.431401 | debian-bookworm | Hostname: debian 2025-10-03 21:42:31.431428 | debian-bookworm | Username: zuul 2025-10-03 21:42:31.431532 | debian-bookworm | Distro: Debian 12.12 2025-10-03 21:42:31.431575 | debian-bookworm | Provider: regiocloud-a 2025-10-03 21:42:31.431598 | debian-bookworm | Region: 2025-10-03 21:42:31.431621 | debian-bookworm | Label: debian-bookworm 2025-10-03 21:42:31.431642 | debian-bookworm | Product Name: OpenStack Nova 2025-10-03 21:42:31.431728 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee0:97ee 2025-10-03 21:42:31.469447 | 2025-10-03 21:42:31.469648 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-03 21:42:32.021438 | debian-bookworm -> localhost | changed 2025-10-03 21:42:32.029213 | 2025-10-03 21:42:32.029330 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-03 21:42:33.229184 | debian-bookworm -> localhost | changed 2025-10-03 21:42:33.260847 | 2025-10-03 21:42:33.260984 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-03 21:42:33.555977 | debian-bookworm -> localhost | ok 2025-10-03 21:42:33.562249 | 2025-10-03 21:42:33.562369 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-03 21:42:33.581403 | debian-bookworm | ok 2025-10-03 21:42:33.598493 | debian-bookworm | included: /var/lib/zuul/builds/fcfdc2be7a7240eaae3042fe86c7f493/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-03 21:42:33.604497 | 2025-10-03 21:42:33.604593 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-03 21:42:35.185892 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-03 21:42:35.186535 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fcfdc2be7a7240eaae3042fe86c7f493/work/fcfdc2be7a7240eaae3042fe86c7f493_id_rsa 2025-10-03 21:42:35.187063 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fcfdc2be7a7240eaae3042fe86c7f493/work/fcfdc2be7a7240eaae3042fe86c7f493_id_rsa.pub 2025-10-03 21:42:35.187183 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-03 21:42:35.187221 | debian-bookworm -> localhost | SHA256:rD9xp24t6T5/HYxROGHxTdv6qwAByMnzvJHSqudsYwM zuul-build-sshkey 2025-10-03 21:42:35.187426 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-03 21:42:35.187474 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-03 21:42:35.187501 | debian-bookworm -> localhost | | o o. ++ .| 2025-10-03 21:42:35.187524 | debian-bookworm -> localhost | | * . .o.o+| 2025-10-03 21:42:35.187545 | debian-bookworm -> localhost | | = .. ooo| 2025-10-03 21:42:35.187566 | debian-bookworm -> localhost | | . B . . . | 2025-10-03 21:42:35.187587 | debian-bookworm -> localhost | | o S. = | 2025-10-03 21:42:35.187614 | debian-bookworm -> localhost | | E . o. o .. + | 2025-10-03 21:42:35.187635 | debian-bookworm -> localhost | | o . o * .o| 2025-10-03 21:42:35.187655 | debian-bookworm -> localhost | | ..* .. * o . o| 2025-10-03 21:42:35.187677 | debian-bookworm -> localhost | | =oo .*++.o.. | 2025-10-03 21:42:35.187698 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-03 21:42:35.187761 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.971325 2025-10-03 21:42:35.199366 | 2025-10-03 21:42:35.199499 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-03 21:42:35.252900 | debian-bookworm | ok 2025-10-03 21:42:35.268782 | debian-bookworm | included: /var/lib/zuul/builds/fcfdc2be7a7240eaae3042fe86c7f493/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-03 21:42:35.282541 | 2025-10-03 21:42:35.282654 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-03 21:42:35.307805 | debian-bookworm | skipping: Conditional result was False 2025-10-03 21:42:35.319094 | 2025-10-03 21:42:35.319225 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-03 21:42:36.058909 | debian-bookworm | changed 2025-10-03 21:42:36.068200 | 2025-10-03 21:42:36.068313 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-03 21:42:36.353475 | debian-bookworm | ok 2025-10-03 21:42:36.360473 | 2025-10-03 21:42:36.360700 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-03 21:42:37.044453 | debian-bookworm | changed 2025-10-03 21:42:37.051827 | 2025-10-03 21:42:37.051950 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-03 21:42:37.681114 | debian-bookworm | changed 2025-10-03 21:42:37.689595 | 2025-10-03 21:42:37.689788 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-03 21:42:37.714886 | debian-bookworm | skipping: Conditional result was False 2025-10-03 21:42:37.721391 | 2025-10-03 21:42:37.721495 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-03 21:42:38.213032 | debian-bookworm -> localhost | changed 2025-10-03 21:42:38.240170 | 2025-10-03 21:42:38.240326 | TASK [add-build-sshkey : Add back temp key] 2025-10-03 21:42:38.575439 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fcfdc2be7a7240eaae3042fe86c7f493/work/fcfdc2be7a7240eaae3042fe86c7f493_id_rsa (zuul-build-sshkey) 2025-10-03 21:42:38.575693 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016744 2025-10-03 21:42:38.585446 | 2025-10-03 21:42:38.585564 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-03 21:42:39.040845 | debian-bookworm | ok 2025-10-03 21:42:39.046116 | 2025-10-03 21:42:39.046234 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-03 21:42:39.070179 | debian-bookworm | skipping: Conditional result was False 2025-10-03 21:42:39.080966 | 2025-10-03 21:42:39.081136 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-03 21:42:39.575344 | debian-bookworm | ok 2025-10-03 21:42:39.587546 | 2025-10-03 21:42:39.587661 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-03 21:42:39.617068 | debian-bookworm | ok 2025-10-03 21:42:39.622097 | 2025-10-03 21:42:39.622200 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-03 21:42:39.942204 | debian-bookworm -> localhost | ok 2025-10-03 21:42:39.948754 | 2025-10-03 21:42:39.948859 | TASK [validate-host : Collect information about the host] 2025-10-03 21:42:41.135437 | debian-bookworm | ok 2025-10-03 21:42:41.145897 | 2025-10-03 21:42:41.146006 | TASK [validate-host : Sanitize hostname] 2025-10-03 21:42:41.256956 | debian-bookworm | ok 2025-10-03 21:42:41.296125 | 2025-10-03 21:42:41.296247 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-03 21:42:41.892170 | debian-bookworm -> localhost | changed 2025-10-03 21:42:41.898431 | 2025-10-03 21:42:41.898534 | TASK [validate-host : Collect information about zuul worker] 2025-10-03 21:42:42.343296 | debian-bookworm | ok 2025-10-03 21:42:42.349599 | 2025-10-03 21:42:42.349716 | TASK [validate-host : Write out all zuul information for each host] 2025-10-03 21:42:43.075885 | debian-bookworm -> localhost | changed 2025-10-03 21:42:43.094235 | 2025-10-03 21:42:43.094348 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-03 21:42:43.393767 | debian-bookworm | ok 2025-10-03 21:42:43.400779 | 2025-10-03 21:42:43.400888 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-03 21:42:44.519170 | debian-bookworm | changed: 2025-10-03 21:42:44.519636 | debian-bookworm | cd+++++++++ src/ 2025-10-03 21:42:44.519698 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-03 21:42:44.519740 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-03 21:42:44.519778 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-03 21:42:44.519813 | debian-bookworm | Containerfile 2025-10-03 21:42:44.520091 | debian-bookworm | Containerfile 2025-10-03 21:42:44.555266 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007894 2025-10-03 21:43:10.227469 | 2025-10-03 21:43:10.227608 | TASK [upload-logs : Upload logs to log server] 2025-10-03 21:43:10.821996 | localhost | Output suppressed because no_log was given 2025-10-03 21:43:10.823945 | 2025-10-03 21:43:10.824099 | LOOP [upload-logs : Compress console log and json output] 2025-10-03 21:43:10.873093 | localhost | skipping: Conditional result was False 2025-10-03 21:43:10.881130 | localhost | skipping: Conditional result was False 2025-10-03 21:43:10.894630 | 2025-10-03 21:43:10.894898 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-03 21:43:10.942716 | localhost | skipping: Conditional result was False 2025-10-03 21:43:10.943074 | 2025-10-03 21:43:10.949643 | localhost | skipping: Conditional result was False 2025-10-03 21:43:10.959502 | 2025-10-03 21:43:10.959744 | LOOP [upload-logs : Upload console log and json output]