2025-12-14 17:30:22.564131 | Job console starting 2025-12-14 17:30:22.598818 | Updating git repos 2025-12-14 17:30:22.713234 | Cloning repos into workspace 2025-12-14 17:30:22.836412 | Restoring repo states 2025-12-14 17:30:22.876777 | Merging changes 2025-12-14 17:30:23.524925 | Checking out repos 2025-12-14 17:30:23.604432 | Preparing playbooks 2025-12-14 17:30:24.970487 | Running Ansible setup 2025-12-14 17:30:31.275871 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-14 17:30:33.118496 | 2025-12-14 17:30:33.118677 | PLAY [Base pre] 2025-12-14 17:30:33.158606 | 2025-12-14 17:30:33.158813 | TASK [Setup log path fact] 2025-12-14 17:30:33.206168 | debian-bookworm | ok 2025-12-14 17:30:33.246612 | 2025-12-14 17:30:33.246822 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-14 17:30:33.317768 | debian-bookworm | ok 2025-12-14 17:30:33.346618 | 2025-12-14 17:30:33.346797 | TASK [emit-job-header : Print job information] 2025-12-14 17:30:33.452126 | # Job Information 2025-12-14 17:30:33.452386 | Ansible Version: 2.16.14 2025-12-14 17:30:33.452425 | Job: python-black 2025-12-14 17:30:33.452465 | Pipeline: check 2025-12-14 17:30:33.452494 | Executor: 521e9411259a 2025-12-14 17:30:33.452517 | Triggered by: https://github.com/osism/python-osism/pull/1906 2025-12-14 17:30:33.452540 | Event ID: 8b8d7e30-d912-11f0-99a3-745908f4576a 2025-12-14 17:30:33.457871 | 2025-12-14 17:30:33.459392 | LOOP [emit-job-header : Print node information] 2025-12-14 17:30:33.778920 | debian-bookworm | ok: 2025-12-14 17:30:33.779120 | debian-bookworm | # Node Information 2025-12-14 17:30:33.779155 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-14 17:30:33.779181 | debian-bookworm | Hostname: debian 2025-12-14 17:30:33.779390 | debian-bookworm | Username: zuul 2025-12-14 17:30:33.779420 | debian-bookworm | Distro: Debian 12.12 2025-12-14 17:30:33.779446 | debian-bookworm | Provider: regiocloud-a 2025-12-14 17:30:33.779467 | debian-bookworm | Region: 2025-12-14 17:30:33.779488 | debian-bookworm | Label: debian-bookworm 2025-12-14 17:30:33.779508 | debian-bookworm | Product Name: OpenStack Nova 2025-12-14 17:30:33.779527 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe66:71a1 2025-12-14 17:30:33.807683 | 2025-12-14 17:30:33.807861 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-14 17:30:35.118689 | debian-bookworm -> localhost | changed 2025-12-14 17:30:35.128483 | 2025-12-14 17:30:35.128646 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-14 17:30:38.148468 | debian-bookworm -> localhost | changed 2025-12-14 17:30:38.177254 | 2025-12-14 17:30:38.183424 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-14 17:30:39.283791 | debian-bookworm -> localhost | ok 2025-12-14 17:30:39.291814 | 2025-12-14 17:30:39.291960 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-14 17:30:39.361851 | debian-bookworm | ok 2025-12-14 17:30:39.437932 | debian-bookworm | included: /var/lib/zuul/builds/359228c165094a0bb92be2701e767e7f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-14 17:30:39.484202 | 2025-12-14 17:30:39.484516 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-14 17:30:43.866295 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-14 17:30:43.866720 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/359228c165094a0bb92be2701e767e7f/work/359228c165094a0bb92be2701e767e7f_id_rsa 2025-12-14 17:30:43.866801 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/359228c165094a0bb92be2701e767e7f/work/359228c165094a0bb92be2701e767e7f_id_rsa.pub 2025-12-14 17:30:43.867103 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-14 17:30:43.867136 | debian-bookworm -> localhost | SHA256:+6sVqHZbqSJG0pum9ziHXG2hPqNIzvgV8jZXTVZwtFY zuul-build-sshkey 2025-12-14 17:30:43.867160 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-14 17:30:43.867191 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-14 17:30:43.867213 | debian-bookworm -> localhost | | .o+ E | 2025-12-14 17:30:43.867236 | debian-bookworm -> localhost | | o o | 2025-12-14 17:30:43.867256 | debian-bookworm -> localhost | | o o | 2025-12-14 17:30:43.867276 | debian-bookworm -> localhost | | .= . | 2025-12-14 17:30:43.867296 | debian-bookworm -> localhost | | ... oS.o | 2025-12-14 17:30:43.867324 | debian-bookworm -> localhost | | .oo.ooo. o | 2025-12-14 17:30:43.867345 | debian-bookworm -> localhost | | .+=*+.o + | 2025-12-14 17:30:43.867365 | debian-bookworm -> localhost | | = +@=*. * | 2025-12-14 17:30:43.867385 | debian-bookworm -> localhost | |..*=o*.++.o. | 2025-12-14 17:30:43.867406 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-14 17:30:43.867470 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.260627 2025-12-14 17:30:43.876023 | 2025-12-14 17:30:43.876246 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-14 17:30:43.965928 | debian-bookworm | ok 2025-12-14 17:30:43.988289 | debian-bookworm | included: /var/lib/zuul/builds/359228c165094a0bb92be2701e767e7f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-14 17:30:44.022681 | 2025-12-14 17:30:44.023637 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-14 17:30:44.079908 | debian-bookworm | skipping: Conditional result was False 2025-12-14 17:30:44.090709 | 2025-12-14 17:30:44.090912 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-14 17:30:44.922082 | debian-bookworm | changed 2025-12-14 17:30:44.956057 | 2025-12-14 17:30:44.956202 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-14 17:30:45.249871 | debian-bookworm | ok 2025-12-14 17:30:45.262657 | 2025-12-14 17:30:45.262809 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-14 17:30:46.193854 | debian-bookworm | changed 2025-12-14 17:30:46.209141 | 2025-12-14 17:30:46.209342 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-14 17:30:47.128758 | debian-bookworm | changed 2025-12-14 17:30:47.140498 | 2025-12-14 17:30:47.140645 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-14 17:30:47.167097 | debian-bookworm | skipping: Conditional result was False 2025-12-14 17:30:47.174444 | 2025-12-14 17:30:47.174603 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-14 17:30:48.599537 | debian-bookworm -> localhost | changed 2025-12-14 17:30:48.655372 | 2025-12-14 17:30:48.655535 | TASK [add-build-sshkey : Add back temp key] 2025-12-14 17:30:49.659238 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/359228c165094a0bb92be2701e767e7f/work/359228c165094a0bb92be2701e767e7f_id_rsa (zuul-build-sshkey) 2025-12-14 17:30:49.659522 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.069894 2025-12-14 17:30:49.668250 | 2025-12-14 17:30:49.668396 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-14 17:30:50.372666 | debian-bookworm | ok 2025-12-14 17:30:50.380945 | 2025-12-14 17:30:50.381092 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-14 17:30:50.442858 | debian-bookworm | skipping: Conditional result was False 2025-12-14 17:30:50.462668 | 2025-12-14 17:30:50.462849 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-14 17:30:51.201722 | debian-bookworm | ok 2025-12-14 17:30:51.215772 | 2025-12-14 17:30:51.215919 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-14 17:30:51.246249 | debian-bookworm | ok 2025-12-14 17:30:51.251668 | 2025-12-14 17:30:51.251842 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-14 17:30:51.698446 | debian-bookworm -> localhost | ok 2025-12-14 17:30:51.705516 | 2025-12-14 17:30:51.705654 | TASK [validate-host : Collect information about the host] 2025-12-14 17:30:53.229176 | debian-bookworm | ok 2025-12-14 17:30:53.260137 | 2025-12-14 17:30:53.260289 | TASK [validate-host : Sanitize hostname] 2025-12-14 17:30:53.372119 | debian-bookworm | ok 2025-12-14 17:30:53.421659 | 2025-12-14 17:30:53.421832 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-14 17:30:54.585946 | debian-bookworm -> localhost | changed 2025-12-14 17:30:54.592616 | 2025-12-14 17:30:54.592804 | TASK [validate-host : Collect information about zuul worker] 2025-12-14 17:30:55.207443 | debian-bookworm | ok 2025-12-14 17:30:55.212606 | 2025-12-14 17:30:55.212773 | TASK [validate-host : Write out all zuul information for each host] 2025-12-14 17:30:56.194536 | debian-bookworm -> localhost | changed 2025-12-14 17:30:56.215484 | 2025-12-14 17:30:56.215666 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-14 17:30:56.510921 | debian-bookworm | ok 2025-12-14 17:30:56.522579 | 2025-12-14 17:30:56.522767 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-14 17:30:57.859055 | debian-bookworm | changed: 2025-12-14 17:30:57.859283 | debian-bookworm | cd+++++++++ src/ 2025-12-14 17:30:57.859318 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-14 17:30:57.859341 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-14 17:30:57.859362 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-14 17:30:57.859382 | debian-bookworm | Containerfile 2025-12-14 17:30:57.859509 | debian-bookworm | Containerfile 2025-12-14 17:30:57.950359 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006947 2025-12-14 17:31:25.735452 | 2025-12-14 17:31:25.735615 | TASK [upload-logs : Upload logs to log server] 2025-12-14 17:31:26.343281 | localhost | Output suppressed because no_log was given 2025-12-14 17:31:26.346302 | 2025-12-14 17:31:26.346466 | LOOP [upload-logs : Compress console log and json output] 2025-12-14 17:31:26.404797 | localhost | skipping: Conditional result was False 2025-12-14 17:31:26.413094 | localhost | skipping: Conditional result was False 2025-12-14 17:31:26.417118 | 2025-12-14 17:31:26.417234 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-14 17:31:26.471518 | localhost | skipping: Conditional result was False 2025-12-14 17:31:26.472175 | 2025-12-14 17:31:26.475722 | localhost | skipping: Conditional result was False 2025-12-14 17:31:26.489411 | 2025-12-14 17:31:26.489643 | LOOP [upload-logs : Upload console log and json output]