2025-10-06 21:38:16.844171 | Job console starting 2025-10-06 21:38:16.880632 | Updating git repos 2025-10-06 21:38:16.953463 | Cloning repos into workspace 2025-10-06 21:38:17.025771 | Restoring repo states 2025-10-06 21:38:17.053360 | Merging changes 2025-10-06 21:38:17.716459 | Checking out repos 2025-10-06 21:38:17.797606 | Preparing playbooks 2025-10-06 21:38:19.055052 | Running Ansible setup 2025-10-06 21:38:25.147561 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-06 21:38:26.475754 | 2025-10-06 21:38:26.475920 | PLAY [Base pre] 2025-10-06 21:38:26.514402 | 2025-10-06 21:38:26.514560 | TASK [Setup log path fact] 2025-10-06 21:38:26.564481 | debian-bookworm | ok 2025-10-06 21:38:26.586203 | 2025-10-06 21:38:26.586365 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-06 21:38:26.627056 | debian-bookworm | ok 2025-10-06 21:38:26.637859 | 2025-10-06 21:38:26.638168 | TASK [emit-job-header : Print job information] 2025-10-06 21:38:26.688171 | # Job Information 2025-10-06 21:38:26.688364 | Ansible Version: 2.16.14 2025-10-06 21:38:26.688399 | Job: python-black 2025-10-06 21:38:26.688432 | Pipeline: check 2025-10-06 21:38:26.688455 | Executor: 521e9411259a 2025-10-06 21:38:26.688476 | Triggered by: https://github.com/osism/python-osism/pull/1739 2025-10-06 21:38:26.688498 | Event ID: bfea3160-a2fc-11f0-8a24-2bd4b6321ab5 2025-10-06 21:38:26.694566 | 2025-10-06 21:38:26.694708 | LOOP [emit-job-header : Print node information] 2025-10-06 21:38:27.009015 | debian-bookworm | ok: 2025-10-06 21:38:27.009155 | debian-bookworm | # Node Information 2025-10-06 21:38:27.009182 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-06 21:38:27.009202 | debian-bookworm | Hostname: debian 2025-10-06 21:38:27.009219 | debian-bookworm | Username: zuul 2025-10-06 21:38:27.009236 | debian-bookworm | Distro: Debian 12.12 2025-10-06 21:38:27.009256 | debian-bookworm | Provider: regiocloud-a 2025-10-06 21:38:27.009273 | debian-bookworm | Region: 2025-10-06 21:38:27.009290 | debian-bookworm | Label: debian-bookworm 2025-10-06 21:38:27.009306 | debian-bookworm | Product Name: OpenStack Nova 2025-10-06 21:38:27.009321 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe58:899b 2025-10-06 21:38:27.021619 | 2025-10-06 21:38:27.025577 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-06 21:38:27.926639 | debian-bookworm -> localhost | changed 2025-10-06 21:38:27.933298 | 2025-10-06 21:38:27.933393 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-06 21:38:29.662240 | debian-bookworm -> localhost | changed 2025-10-06 21:38:29.674170 | 2025-10-06 21:38:29.674272 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-06 21:38:30.179309 | debian-bookworm -> localhost | ok 2025-10-06 21:38:30.185144 | 2025-10-06 21:38:30.185242 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-06 21:38:30.213525 | debian-bookworm | ok 2025-10-06 21:38:30.283330 | debian-bookworm | included: /var/lib/zuul/builds/82e98593000a49c18a2c11a454702ce6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-06 21:38:30.303559 | 2025-10-06 21:38:30.303666 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-06 21:38:32.822302 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-06 21:38:32.823041 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/82e98593000a49c18a2c11a454702ce6/work/82e98593000a49c18a2c11a454702ce6_id_rsa 2025-10-06 21:38:32.823467 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/82e98593000a49c18a2c11a454702ce6/work/82e98593000a49c18a2c11a454702ce6_id_rsa.pub 2025-10-06 21:38:32.823527 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-06 21:38:32.823559 | debian-bookworm -> localhost | SHA256:vKEKB3NtvvEJemw0AqZDGQSWXfaEZKeqKovPERbykZY zuul-build-sshkey 2025-10-06 21:38:32.823584 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-06 21:38:32.823925 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-06 21:38:32.823960 | debian-bookworm -> localhost | |+oo o=.o | 2025-10-06 21:38:32.823985 | debian-bookworm -> localhost | |.o +o.= | 2025-10-06 21:38:32.824043 | debian-bookworm -> localhost | |. E . . | 2025-10-06 21:38:32.824070 | debian-bookworm -> localhost | | *oo.. . | 2025-10-06 21:38:32.824091 | debian-bookworm -> localhost | |.o*o. o S | 2025-10-06 21:38:32.824123 | debian-bookworm -> localhost | |o..=.oo. o | 2025-10-06 21:38:32.824145 | debian-bookworm -> localhost | | oo .+=.. | 2025-10-06 21:38:32.824166 | debian-bookworm -> localhost | |+. + o+= . | 2025-10-06 21:38:32.824188 | debian-bookworm -> localhost | |=oo oo. o | 2025-10-06 21:38:32.824209 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-06 21:38:32.824265 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.764286 2025-10-06 21:38:32.835928 | 2025-10-06 21:38:32.836046 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-06 21:38:32.854266 | debian-bookworm | ok 2025-10-06 21:38:32.867340 | debian-bookworm | included: /var/lib/zuul/builds/82e98593000a49c18a2c11a454702ce6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-06 21:38:32.876742 | 2025-10-06 21:38:32.876831 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-06 21:38:32.889796 | debian-bookworm | skipping: Conditional result was False 2025-10-06 21:38:32.895376 | 2025-10-06 21:38:32.895459 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-06 21:38:33.517022 | debian-bookworm | changed 2025-10-06 21:38:33.528524 | 2025-10-06 21:38:33.528631 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-06 21:38:33.805161 | debian-bookworm | ok 2025-10-06 21:38:33.812832 | 2025-10-06 21:38:33.814360 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-06 21:38:34.531421 | debian-bookworm | changed 2025-10-06 21:38:34.537713 | 2025-10-06 21:38:34.537798 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-06 21:38:35.315004 | debian-bookworm | changed 2025-10-06 21:38:35.321413 | 2025-10-06 21:38:35.321496 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-06 21:38:35.352068 | debian-bookworm | skipping: Conditional result was False 2025-10-06 21:38:35.356829 | 2025-10-06 21:38:35.356912 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-06 21:38:36.137179 | debian-bookworm -> localhost | changed 2025-10-06 21:38:36.145817 | 2025-10-06 21:38:36.145900 | TASK [add-build-sshkey : Add back temp key] 2025-10-06 21:38:36.544533 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/82e98593000a49c18a2c11a454702ce6/work/82e98593000a49c18a2c11a454702ce6_id_rsa (zuul-build-sshkey) 2025-10-06 21:38:36.545022 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011968 2025-10-06 21:38:36.555750 | 2025-10-06 21:38:36.555831 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-06 21:38:37.173823 | debian-bookworm | ok 2025-10-06 21:38:37.179181 | 2025-10-06 21:38:37.179317 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-06 21:38:37.216265 | debian-bookworm | skipping: Conditional result was False 2025-10-06 21:38:37.255807 | 2025-10-06 21:38:37.255904 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-06 21:38:37.792645 | debian-bookworm | ok 2025-10-06 21:38:37.810107 | 2025-10-06 21:38:37.810200 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-06 21:38:37.849321 | debian-bookworm | ok 2025-10-06 21:38:37.853337 | 2025-10-06 21:38:37.853423 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-06 21:38:38.781194 | debian-bookworm -> localhost | ok 2025-10-06 21:38:38.795833 | 2025-10-06 21:38:38.797326 | TASK [validate-host : Collect information about the host] 2025-10-06 21:38:39.926576 | debian-bookworm | ok 2025-10-06 21:38:39.945117 | 2025-10-06 21:38:39.945210 | TASK [validate-host : Sanitize hostname] 2025-10-06 21:38:40.115409 | debian-bookworm | ok 2025-10-06 21:38:40.187232 | 2025-10-06 21:38:40.187327 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-06 21:38:41.512820 | debian-bookworm -> localhost | changed 2025-10-06 21:38:41.517469 | 2025-10-06 21:38:41.517547 | TASK [validate-host : Collect information about zuul worker] 2025-10-06 21:38:42.040755 | debian-bookworm | ok 2025-10-06 21:38:42.044636 | 2025-10-06 21:38:42.044714 | TASK [validate-host : Write out all zuul information for each host] 2025-10-06 21:38:43.350081 | debian-bookworm -> localhost | changed 2025-10-06 21:38:43.367132 | 2025-10-06 21:38:43.367222 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-06 21:38:43.624710 | debian-bookworm | ok 2025-10-06 21:38:43.629076 | 2025-10-06 21:38:43.629147 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-06 21:38:45.476380 | debian-bookworm | changed: 2025-10-06 21:38:45.476534 | debian-bookworm | cd+++++++++ src/ 2025-10-06 21:38:45.476562 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-06 21:38:45.476603 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-06 21:38:45.476624 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-06 21:38:45.476641 | debian-bookworm | Containerfile 2025-10-06 21:38:45.476732 | debian-bookworm | Containerfile 2025-10-06 21:38:45.547775 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009888 2025-10-06 21:39:12.465694 | 2025-10-06 21:39:12.465789 | TASK [upload-logs : Upload logs to log server] 2025-10-06 21:39:13.041870 | localhost | Output suppressed because no_log was given 2025-10-06 21:39:13.043252 | 2025-10-06 21:39:13.043325 | LOOP [upload-logs : Compress console log and json output] 2025-10-06 21:39:13.077751 | localhost | skipping: Conditional result was False 2025-10-06 21:39:13.082240 | localhost | skipping: Conditional result was False 2025-10-06 21:39:13.088116 | 2025-10-06 21:39:13.088193 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-06 21:39:13.129351 | localhost | skipping: Conditional result was False 2025-10-06 21:39:13.129594 | 2025-10-06 21:39:13.139469 | localhost | skipping: Conditional result was False 2025-10-06 21:39:13.143148 | 2025-10-06 21:39:13.143229 | LOOP [upload-logs : Upload console log and json output]