2025-10-20 14:53:30.689802 | Job console starting 2025-10-20 14:53:30.714246 | Updating git repos 2025-10-20 14:53:30.748702 | Cloning repos into workspace 2025-10-20 14:53:30.809882 | Restoring repo states 2025-10-20 14:53:30.816468 | Merging changes 2025-10-20 14:53:31.351728 | Checking out repos 2025-10-20 14:53:31.405488 | Preparing playbooks 2025-10-20 14:53:32.160670 | Running Ansible setup 2025-10-20 14:53:36.614247 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-20 14:53:37.370892 | 2025-10-20 14:53:37.371078 | PLAY [Base pre] 2025-10-20 14:53:37.386951 | 2025-10-20 14:53:37.387098 | TASK [Setup log path fact] 2025-10-20 14:53:37.415899 | debian-bookworm | ok 2025-10-20 14:53:37.430788 | 2025-10-20 14:53:37.430962 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-20 14:53:37.460084 | debian-bookworm | ok 2025-10-20 14:53:37.472615 | 2025-10-20 14:53:37.472732 | TASK [emit-job-header : Print job information] 2025-10-20 14:53:37.511587 | # Job Information 2025-10-20 14:53:37.511759 | Ansible Version: 2.16.14 2025-10-20 14:53:37.511794 | Job: python-black 2025-10-20 14:53:37.511828 | Pipeline: check 2025-10-20 14:53:37.511885 | Executor: 521e9411259a 2025-10-20 14:53:37.511908 | Triggered by: https://github.com/osism/testbed/pull/2777 2025-10-20 14:53:37.511932 | Event ID: 85459310-adc4-11f0-8ab0-f62bf299d9e1 2025-10-20 14:53:37.516877 | 2025-10-20 14:53:37.516987 | LOOP [emit-job-header : Print node information] 2025-10-20 14:53:37.632219 | debian-bookworm | ok: 2025-10-20 14:53:37.632511 | debian-bookworm | # Node Information 2025-10-20 14:53:37.632550 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-20 14:53:37.632576 | debian-bookworm | Hostname: debian 2025-10-20 14:53:37.632599 | debian-bookworm | Username: zuul 2025-10-20 14:53:37.632619 | debian-bookworm | Distro: Debian 12.12 2025-10-20 14:53:37.632642 | debian-bookworm | Provider: regiocloud-a 2025-10-20 14:53:37.632663 | debian-bookworm | Region: 2025-10-20 14:53:37.632684 | debian-bookworm | Label: debian-bookworm 2025-10-20 14:53:37.632704 | debian-bookworm | Product Name: OpenStack Nova 2025-10-20 14:53:37.632723 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe30:9a 2025-10-20 14:53:37.654131 | 2025-10-20 14:53:37.654266 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-20 14:53:38.148077 | debian-bookworm -> localhost | changed 2025-10-20 14:53:38.155342 | 2025-10-20 14:53:38.155469 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-20 14:53:39.342299 | debian-bookworm -> localhost | changed 2025-10-20 14:53:39.361745 | 2025-10-20 14:53:39.362142 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-20 14:53:39.725313 | debian-bookworm -> localhost | ok 2025-10-20 14:53:39.731944 | 2025-10-20 14:53:39.732072 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-20 14:53:39.760598 | debian-bookworm | ok 2025-10-20 14:53:39.778133 | debian-bookworm | included: /var/lib/zuul/builds/00d6bd37aed14d789fda77a0aa0bcdf9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-20 14:53:39.784460 | 2025-10-20 14:53:39.784570 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-20 14:53:40.716581 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-20 14:53:40.716826 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/00d6bd37aed14d789fda77a0aa0bcdf9/work/00d6bd37aed14d789fda77a0aa0bcdf9_id_rsa 2025-10-20 14:53:40.716877 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/00d6bd37aed14d789fda77a0aa0bcdf9/work/00d6bd37aed14d789fda77a0aa0bcdf9_id_rsa.pub 2025-10-20 14:53:40.716904 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-20 14:53:40.716929 | debian-bookworm -> localhost | SHA256:JMkRovq4+qTV8Wx2UV2WhjS+5GcuGNnChmDTkbwwCNg zuul-build-sshkey 2025-10-20 14:53:40.716951 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-20 14:53:40.716984 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-20 14:53:40.717006 | debian-bookworm -> localhost | | o....oo.. .o.o. | 2025-10-20 14:53:40.717027 | debian-bookworm -> localhost | |. E..oo+o. o.+o | 2025-10-20 14:53:40.717046 | debian-bookworm -> localhost | | . Boo.. +. | 2025-10-20 14:53:40.717066 | debian-bookworm -> localhost | | . . =.+ = . | 2025-10-20 14:53:40.717085 | debian-bookworm -> localhost | |. . S * + o | 2025-10-20 14:53:40.717114 | debian-bookworm -> localhost | | o . + o + + | 2025-10-20 14:53:40.717135 | debian-bookworm -> localhost | |. + . = . . . . | 2025-10-20 14:53:40.717156 | debian-bookworm -> localhost | | = o . . | 2025-10-20 14:53:40.717177 | debian-bookworm -> localhost | |=.. | 2025-10-20 14:53:40.717198 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-20 14:53:40.717257 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.433141 2025-10-20 14:53:40.723721 | 2025-10-20 14:53:40.723824 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-20 14:53:40.761928 | debian-bookworm | ok 2025-10-20 14:53:40.771163 | debian-bookworm | included: /var/lib/zuul/builds/00d6bd37aed14d789fda77a0aa0bcdf9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-20 14:53:40.779943 | 2025-10-20 14:53:40.780036 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-20 14:53:40.803523 | debian-bookworm | skipping: Conditional result was False 2025-10-20 14:53:40.809208 | 2025-10-20 14:53:40.809304 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-20 14:53:41.404813 | debian-bookworm | changed 2025-10-20 14:53:41.411645 | 2025-10-20 14:53:41.411754 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-20 14:53:41.646112 | debian-bookworm | ok 2025-10-20 14:53:41.652036 | 2025-10-20 14:53:41.652141 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-20 14:53:42.299634 | debian-bookworm | changed 2025-10-20 14:53:42.307387 | 2025-10-20 14:53:42.307530 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-20 14:53:42.939677 | debian-bookworm | changed 2025-10-20 14:53:42.946827 | 2025-10-20 14:53:42.947006 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-20 14:53:42.971417 | debian-bookworm | skipping: Conditional result was False 2025-10-20 14:53:42.989161 | 2025-10-20 14:53:42.989357 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-20 14:53:43.415087 | debian-bookworm -> localhost | changed 2025-10-20 14:53:43.433793 | 2025-10-20 14:53:43.433940 | TASK [add-build-sshkey : Add back temp key] 2025-10-20 14:53:43.792790 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/00d6bd37aed14d789fda77a0aa0bcdf9/work/00d6bd37aed14d789fda77a0aa0bcdf9_id_rsa (zuul-build-sshkey) 2025-10-20 14:53:43.793145 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016953 2025-10-20 14:53:43.801480 | 2025-10-20 14:53:43.801592 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-20 14:53:44.206241 | debian-bookworm | ok 2025-10-20 14:53:44.212416 | 2025-10-20 14:53:44.212533 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-20 14:53:44.236072 | debian-bookworm | skipping: Conditional result was False 2025-10-20 14:53:44.254554 | 2025-10-20 14:53:44.254669 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-20 14:53:44.711337 | debian-bookworm | ok 2025-10-20 14:53:44.734927 | 2025-10-20 14:53:44.735103 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-20 14:53:44.775673 | debian-bookworm | ok 2025-10-20 14:53:44.783083 | 2025-10-20 14:53:44.783195 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-20 14:53:45.077867 | debian-bookworm -> localhost | ok 2025-10-20 14:53:45.084549 | 2025-10-20 14:53:45.084653 | TASK [validate-host : Collect information about the host] 2025-10-20 14:53:46.219893 | debian-bookworm | ok 2025-10-20 14:53:46.230076 | 2025-10-20 14:53:46.230195 | TASK [validate-host : Sanitize hostname] 2025-10-20 14:53:46.342188 | debian-bookworm | ok 2025-10-20 14:53:46.383303 | 2025-10-20 14:53:46.383441 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-20 14:53:46.954096 | debian-bookworm -> localhost | changed 2025-10-20 14:53:46.966624 | 2025-10-20 14:53:46.966814 | TASK [validate-host : Collect information about zuul worker] 2025-10-20 14:53:47.376177 | debian-bookworm | ok 2025-10-20 14:53:47.383229 | 2025-10-20 14:53:47.383391 | TASK [validate-host : Write out all zuul information for each host] 2025-10-20 14:53:47.893973 | debian-bookworm -> localhost | changed 2025-10-20 14:53:47.903609 | 2025-10-20 14:53:47.903728 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-20 14:53:48.170826 | debian-bookworm | ok 2025-10-20 14:53:48.180220 | 2025-10-20 14:53:48.180353 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-20 14:53:49.864524 | debian-bookworm | changed: 2025-10-20 14:53:49.864736 | debian-bookworm | cd+++++++++ src/ 2025-10-20 14:53:49.864772 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-20 14:53:49.864797 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-20 14:53:49.864818 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-10-20 14:53:49.864839 | debian-bookworm | localhost | ok: Runtime: 0:00:00.022365 2025-10-20 14:54:14.068148 | 2025-10-20 14:54:14.068273 | TASK [upload-logs : Upload logs to log server] 2025-10-20 14:54:14.579517 | localhost | Output suppressed because no_log was given 2025-10-20 14:54:14.581563 | 2025-10-20 14:54:14.581670 | LOOP [upload-logs : Compress console log and json output] 2025-10-20 14:54:14.631249 | localhost | skipping: Conditional result was False 2025-10-20 14:54:14.639088 | localhost | skipping: Conditional result was False 2025-10-20 14:54:14.648372 | 2025-10-20 14:54:14.648507 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-20 14:54:14.694265 | localhost | skipping: Conditional result was False 2025-10-20 14:54:14.694587 | 2025-10-20 14:54:14.701511 | localhost | skipping: Conditional result was False 2025-10-20 14:54:14.705952 | 2025-10-20 14:54:14.706099 | LOOP [upload-logs : Upload console log and json output]