2025-10-17 14:59:38.866086 | Job console starting 2025-10-17 14:59:38.877268 | Updating git repos 2025-10-17 14:59:38.914916 | Cloning repos into workspace 2025-10-17 14:59:38.999269 | Restoring repo states 2025-10-17 14:59:39.022428 | Merging changes 2025-10-17 14:59:39.653948 | Checking out repos 2025-10-17 14:59:39.811414 | Preparing playbooks 2025-10-17 14:59:40.784101 | Running Ansible setup 2025-10-17 14:59:46.648220 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-17 14:59:47.545652 | 2025-10-17 14:59:47.545765 | PLAY [Base pre] 2025-10-17 14:59:47.583530 | 2025-10-17 14:59:47.583638 | TASK [Setup log path fact] 2025-10-17 14:59:47.620403 | debian-bookworm | ok 2025-10-17 14:59:47.633886 | 2025-10-17 14:59:47.633992 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-17 14:59:47.707711 | debian-bookworm | ok 2025-10-17 14:59:47.723393 | 2025-10-17 14:59:47.723494 | TASK [emit-job-header : Print job information] 2025-10-17 14:59:47.780407 | # Job Information 2025-10-17 14:59:47.780534 | Ansible Version: 2.16.14 2025-10-17 14:59:47.780561 | Job: python-black 2025-10-17 14:59:47.780587 | Pipeline: check 2025-10-17 14:59:47.780605 | Executor: 521e9411259a 2025-10-17 14:59:47.780622 | Triggered by: https://github.com/osism/python-osism/pull/1731 2025-10-17 14:59:47.780639 | Event ID: e09089d0-ab69-11f0-9cb2-3cd6b4a0cbea 2025-10-17 14:59:47.784627 | 2025-10-17 14:59:47.784710 | LOOP [emit-job-header : Print node information] 2025-10-17 14:59:47.941744 | debian-bookworm | ok: 2025-10-17 14:59:47.941945 | debian-bookworm | # Node Information 2025-10-17 14:59:47.941981 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-17 14:59:47.942005 | debian-bookworm | Hostname: debian 2025-10-17 14:59:47.942027 | debian-bookworm | Username: zuul 2025-10-17 14:59:47.942047 | debian-bookworm | Distro: Debian 12.12 2025-10-17 14:59:47.942071 | debian-bookworm | Provider: regiocloud-a 2025-10-17 14:59:47.942091 | debian-bookworm | Region: 2025-10-17 14:59:47.942112 | debian-bookworm | Label: debian-bookworm 2025-10-17 14:59:47.942130 | debian-bookworm | Product Name: OpenStack Nova 2025-10-17 14:59:47.942149 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe45:49c2 2025-10-17 14:59:47.958982 | 2025-10-17 14:59:47.959077 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-17 14:59:48.870243 | debian-bookworm -> localhost | changed 2025-10-17 14:59:48.877380 | 2025-10-17 14:59:48.877464 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-17 14:59:50.324443 | debian-bookworm -> localhost | changed 2025-10-17 14:59:50.332914 | 2025-10-17 14:59:50.333000 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-17 14:59:50.744358 | debian-bookworm -> localhost | ok 2025-10-17 14:59:50.754315 | 2025-10-17 14:59:50.754491 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-17 14:59:50.783243 | debian-bookworm | ok 2025-10-17 14:59:50.799362 | debian-bookworm | included: /var/lib/zuul/builds/7dbfe32741f7421486a624edf485a8d6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-17 14:59:50.815499 | 2025-10-17 14:59:50.815586 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-17 14:59:52.472447 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-17 14:59:52.472627 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7dbfe32741f7421486a624edf485a8d6/work/7dbfe32741f7421486a624edf485a8d6_id_rsa 2025-10-17 14:59:52.472675 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7dbfe32741f7421486a624edf485a8d6/work/7dbfe32741f7421486a624edf485a8d6_id_rsa.pub 2025-10-17 14:59:52.472702 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-17 14:59:52.472728 | debian-bookworm -> localhost | SHA256:3qSEDwZKVq6qCyxAWGQm+SpPkbtZN/5hexaKo9c8Y90 zuul-build-sshkey 2025-10-17 14:59:52.472751 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-17 14:59:52.472785 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-17 14:59:52.472807 | debian-bookworm -> localhost | |.o= . | 2025-10-17 14:59:52.472829 | debian-bookworm -> localhost | |o= o | 2025-10-17 14:59:52.472851 | debian-bookworm -> localhost | |.oo.o | 2025-10-17 14:59:52.472871 | debian-bookworm -> localhost | |.o+o . . | 2025-10-17 14:59:52.472891 | debian-bookworm -> localhost | |..oo + S . | 2025-10-17 14:59:52.472919 | debian-bookworm -> localhost | |=.o ..o= +. | 2025-10-17 14:59:52.472940 | debian-bookworm -> localhost | |=+ + o =*o.o | 2025-10-17 14:59:52.472961 | debian-bookworm -> localhost | |+ + =.Bo+ E | 2025-10-17 14:59:52.472981 | debian-bookworm -> localhost | |o. .o +o= | 2025-10-17 14:59:52.473001 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-17 14:59:52.473047 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.793768 2025-10-17 14:59:52.479139 | 2025-10-17 14:59:52.479228 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-17 14:59:52.516330 | debian-bookworm | ok 2025-10-17 14:59:52.525269 | debian-bookworm | included: /var/lib/zuul/builds/7dbfe32741f7421486a624edf485a8d6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-17 14:59:52.534021 | 2025-10-17 14:59:52.534113 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-17 14:59:52.546974 | debian-bookworm | skipping: Conditional result was False 2025-10-17 14:59:52.552672 | 2025-10-17 14:59:52.552760 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-17 14:59:53.287311 | debian-bookworm | changed 2025-10-17 14:59:53.291630 | 2025-10-17 14:59:53.291723 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-17 14:59:53.552111 | debian-bookworm | ok 2025-10-17 14:59:53.556535 | 2025-10-17 14:59:53.556606 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-17 14:59:54.285114 | debian-bookworm | changed 2025-10-17 14:59:54.290575 | 2025-10-17 14:59:54.290694 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-17 14:59:54.927808 | debian-bookworm | changed 2025-10-17 14:59:54.935346 | 2025-10-17 14:59:54.935497 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-17 14:59:54.959260 | debian-bookworm | skipping: Conditional result was False 2025-10-17 14:59:54.973936 | 2025-10-17 14:59:54.974176 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-17 14:59:55.421995 | debian-bookworm -> localhost | changed 2025-10-17 14:59:55.432233 | 2025-10-17 14:59:55.432315 | TASK [add-build-sshkey : Add back temp key] 2025-10-17 14:59:55.849765 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7dbfe32741f7421486a624edf485a8d6/work/7dbfe32741f7421486a624edf485a8d6_id_rsa (zuul-build-sshkey) 2025-10-17 14:59:55.849935 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014175 2025-10-17 14:59:55.856088 | 2025-10-17 14:59:55.856166 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-17 14:59:56.425909 | debian-bookworm | ok 2025-10-17 14:59:56.433591 | 2025-10-17 14:59:56.433725 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-17 14:59:56.457007 | debian-bookworm | skipping: Conditional result was False 2025-10-17 14:59:56.465959 | 2025-10-17 14:59:56.466053 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-17 14:59:56.885136 | debian-bookworm | ok 2025-10-17 14:59:56.895801 | 2025-10-17 14:59:56.895902 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-17 14:59:56.923494 | debian-bookworm | ok 2025-10-17 14:59:56.928338 | 2025-10-17 14:59:56.928421 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-17 14:59:57.204229 | debian-bookworm -> localhost | ok 2025-10-17 14:59:57.210274 | 2025-10-17 14:59:57.210359 | TASK [validate-host : Collect information about the host] 2025-10-17 14:59:58.579200 | debian-bookworm | ok 2025-10-17 14:59:58.589050 | 2025-10-17 14:59:58.589148 | TASK [validate-host : Sanitize hostname] 2025-10-17 14:59:58.698081 | debian-bookworm | ok 2025-10-17 14:59:58.741200 | 2025-10-17 14:59:58.741292 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-17 14:59:59.728811 | debian-bookworm -> localhost | changed 2025-10-17 14:59:59.734103 | 2025-10-17 14:59:59.734184 | TASK [validate-host : Collect information about zuul worker] 2025-10-17 15:00:00.144224 | debian-bookworm | ok 2025-10-17 15:00:00.148630 | 2025-10-17 15:00:00.148742 | TASK [validate-host : Write out all zuul information for each host] 2025-10-17 15:00:00.747946 | debian-bookworm -> localhost | changed 2025-10-17 15:00:00.759525 | 2025-10-17 15:00:00.759803 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-17 15:00:01.084694 | debian-bookworm | ok 2025-10-17 15:00:01.089927 | 2025-10-17 15:00:01.090023 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-17 15:00:02.192204 | debian-bookworm | changed: 2025-10-17 15:00:02.192350 | debian-bookworm | cd+++++++++ src/ 2025-10-17 15:00:02.192377 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-17 15:00:02.192396 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-17 15:00:02.192414 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-17 15:00:02.192431 | debian-bookworm | Containerfile 2025-10-17 15:00:02.192526 | debian-bookworm | Containerfile 2025-10-17 15:00:02.216499 | debian-bookworm | localhost | ok: Runtime: 0:00:00.017090 2025-10-17 15:00:30.866188 | 2025-10-17 15:00:30.866301 | TASK [upload-logs : Upload logs to log server] 2025-10-17 15:00:31.417471 | localhost | Output suppressed because no_log was given 2025-10-17 15:00:31.419433 | 2025-10-17 15:00:31.419544 | LOOP [upload-logs : Compress console log and json output] 2025-10-17 15:00:31.472442 | localhost | skipping: Conditional result was False 2025-10-17 15:00:31.478594 | localhost | skipping: Conditional result was False 2025-10-17 15:00:31.485863 | 2025-10-17 15:00:31.485969 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-17 15:00:31.530688 | localhost | skipping: Conditional result was False 2025-10-17 15:00:31.531008 | 2025-10-17 15:00:31.536743 | localhost | skipping: Conditional result was False 2025-10-17 15:00:31.547131 | 2025-10-17 15:00:31.547357 | LOOP [upload-logs : Upload console log and json output]