2025-08-21 20:37:12.047721 | Job console starting 2025-08-21 20:37:12.078777 | Updating git repos 2025-08-21 20:37:12.108863 | Cloning repos into workspace 2025-08-21 20:37:12.217783 | Restoring repo states 2025-08-21 20:37:12.230742 | Merging changes 2025-08-21 20:37:12.897782 | Checking out repos 2025-08-21 20:37:13.069522 | Preparing playbooks 2025-08-21 20:37:14.129027 | Running Ansible setup 2025-08-21 20:37:19.094890 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-21 20:37:19.834593 | 2025-08-21 20:37:19.835685 | PLAY [Base pre] 2025-08-21 20:37:19.851811 | 2025-08-21 20:37:19.851931 | TASK [Setup log path fact] 2025-08-21 20:37:19.881522 | debian-bookworm | ok 2025-08-21 20:37:19.898684 | 2025-08-21 20:37:19.898879 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-21 20:37:19.928556 | debian-bookworm | ok 2025-08-21 20:37:19.938261 | 2025-08-21 20:37:19.938370 | TASK [emit-job-header : Print job information] 2025-08-21 20:37:19.978201 | # Job Information 2025-08-21 20:37:19.978372 | Ansible Version: 2.16.14 2025-08-21 20:37:19.978406 | Job: metalbox-mirror-debian-packages 2025-08-21 20:37:19.978437 | Pipeline: check 2025-08-21 20:37:19.978461 | Executor: 521e9411259a 2025-08-21 20:37:19.978481 | Triggered by: https://github.com/osism/metalbox/pull/189 2025-08-21 20:37:19.978503 | Event ID: 9891a550-7ece-11f0-8454-db10da4b69a0 2025-08-21 20:37:19.983579 | 2025-08-21 20:37:19.983692 | LOOP [emit-job-header : Print node information] 2025-08-21 20:37:20.108729 | debian-bookworm | ok: 2025-08-21 20:37:20.108969 | debian-bookworm | # Node Information 2025-08-21 20:37:20.109004 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-21 20:37:20.109029 | debian-bookworm | Hostname: debian 2025-08-21 20:37:20.109051 | debian-bookworm | Username: zuul 2025-08-21 20:37:20.109071 | debian-bookworm | Distro: Debian 12.11 2025-08-21 20:37:20.109111 | debian-bookworm | Provider: regiocloud-a 2025-08-21 20:37:20.109134 | debian-bookworm | Region: 2025-08-21 20:37:20.109154 | debian-bookworm | Label: debian-bookworm 2025-08-21 20:37:20.109174 | debian-bookworm | Product Name: OpenStack Nova 2025-08-21 20:37:20.109194 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9c:696e 2025-08-21 20:37:20.130308 | 2025-08-21 20:37:20.130435 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-21 20:37:20.692231 | debian-bookworm -> localhost | changed 2025-08-21 20:37:20.699736 | 2025-08-21 20:37:20.699865 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-21 20:37:21.878816 | debian-bookworm -> localhost | changed 2025-08-21 20:37:21.890271 | 2025-08-21 20:37:21.890423 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-21 20:37:22.136039 | debian-bookworm -> localhost | ok 2025-08-21 20:37:22.141777 | 2025-08-21 20:37:22.141871 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-21 20:37:22.159019 | debian-bookworm | ok 2025-08-21 20:37:22.175567 | debian-bookworm | included: /var/lib/zuul/builds/f1e8b3d19d43468aa4da68ea4430a77f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-21 20:37:22.185992 | 2025-08-21 20:37:22.186082 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-21 20:37:22.916149 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-21 20:37:22.916327 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f1e8b3d19d43468aa4da68ea4430a77f/work/f1e8b3d19d43468aa4da68ea4430a77f_id_rsa 2025-08-21 20:37:22.916362 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f1e8b3d19d43468aa4da68ea4430a77f/work/f1e8b3d19d43468aa4da68ea4430a77f_id_rsa.pub 2025-08-21 20:37:22.916387 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-21 20:37:22.916411 | debian-bookworm -> localhost | SHA256:ojTJfd8IE+njNr09QE5b9Y5O1LBncAOHaTbQYUbdt1w zuul-build-sshkey 2025-08-21 20:37:22.916433 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-21 20:37:22.916465 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-21 20:37:22.916488 | debian-bookworm -> localhost | | .+**..| 2025-08-21 20:37:22.916509 | debian-bookworm -> localhost | | . oB=oE| 2025-08-21 20:37:22.916529 | debian-bookworm -> localhost | | o o.oB=| 2025-08-21 20:37:22.916548 | debian-bookworm -> localhost | | . o . .o . oo=| 2025-08-21 20:37:22.916568 | debian-bookworm -> localhost | | = o S+ o . = | 2025-08-21 20:37:22.916591 | debian-bookworm -> localhost | | . o + *+o o .| 2025-08-21 20:37:22.916612 | debian-bookworm -> localhost | | . + +..o | 2025-08-21 20:37:22.916631 | debian-bookworm -> localhost | | . . o. . | 2025-08-21 20:37:22.916651 | debian-bookworm -> localhost | | . .. | 2025-08-21 20:37:22.916670 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-21 20:37:22.916719 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.317933 2025-08-21 20:37:22.922668 | 2025-08-21 20:37:22.922754 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-21 20:37:22.939648 | debian-bookworm | ok 2025-08-21 20:37:22.948606 | debian-bookworm | included: /var/lib/zuul/builds/f1e8b3d19d43468aa4da68ea4430a77f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-21 20:37:22.957469 | 2025-08-21 20:37:22.957547 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-21 20:37:22.969887 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:37:22.975142 | 2025-08-21 20:37:22.975224 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-21 20:37:23.687351 | debian-bookworm | changed 2025-08-21 20:37:23.692392 | 2025-08-21 20:37:23.692476 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-21 20:37:23.931634 | debian-bookworm | ok 2025-08-21 20:37:23.937444 | 2025-08-21 20:37:23.937546 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-21 20:37:24.577470 | debian-bookworm | changed 2025-08-21 20:37:24.588464 | 2025-08-21 20:37:24.588604 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-21 20:37:25.255787 | debian-bookworm | changed 2025-08-21 20:37:25.263174 | 2025-08-21 20:37:25.263277 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-21 20:37:25.286561 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:37:25.311527 | 2025-08-21 20:37:25.311606 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-21 20:37:25.738864 | debian-bookworm -> localhost | changed 2025-08-21 20:37:25.749432 | 2025-08-21 20:37:25.749518 | TASK [add-build-sshkey : Add back temp key] 2025-08-21 20:37:26.055762 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f1e8b3d19d43468aa4da68ea4430a77f/work/f1e8b3d19d43468aa4da68ea4430a77f_id_rsa (zuul-build-sshkey) 2025-08-21 20:37:26.056081 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020973 2025-08-21 20:37:26.070542 | 2025-08-21 20:37:26.070696 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-21 20:37:26.455392 | debian-bookworm | ok 2025-08-21 20:37:26.460169 | 2025-08-21 20:37:26.460253 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-21 20:37:26.483043 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:37:26.500557 | 2025-08-21 20:37:26.500634 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-21 20:37:26.900343 | debian-bookworm | ok 2025-08-21 20:37:26.908632 | 2025-08-21 20:37:26.908705 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-21 20:37:26.958169 | debian-bookworm | ok 2025-08-21 20:37:26.964626 | 2025-08-21 20:37:26.964728 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-21 20:37:27.209657 | debian-bookworm -> localhost | ok 2025-08-21 20:37:27.214685 | 2025-08-21 20:37:27.214759 | TASK [validate-host : Collect information about the host] 2025-08-21 20:37:28.401612 | debian-bookworm | ok 2025-08-21 20:37:28.414787 | 2025-08-21 20:37:28.414896 | TASK [validate-host : Sanitize hostname] 2025-08-21 20:37:28.511047 | debian-bookworm | ok 2025-08-21 20:37:28.542027 | 2025-08-21 20:37:28.542132 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-21 20:37:29.032700 | debian-bookworm -> localhost | changed 2025-08-21 20:37:29.045351 | 2025-08-21 20:37:29.045494 | TASK [validate-host : Collect information about zuul worker] 2025-08-21 20:37:29.447922 | debian-bookworm | ok 2025-08-21 20:37:29.451572 | 2025-08-21 20:37:29.451641 | TASK [validate-host : Write out all zuul information for each host] 2025-08-21 20:37:29.892549 | debian-bookworm -> localhost | changed 2025-08-21 20:37:29.905908 | 2025-08-21 20:37:29.906015 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-21 20:37:30.186356 | debian-bookworm | ok 2025-08-21 20:37:30.193264 | 2025-08-21 20:37:30.193353 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-21 20:37:31.153914 | debian-bookworm | changed: 2025-08-21 20:37:31.154078 | debian-bookworm | cd+++++++++ src/ 2025-08-21 20:37:31.154139 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-21 20:37:31.154164 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-21 20:37:31.154185 | debian-bookworm | cd+++++++++ src/github.com/osism/metalbox/ 2025-08-21 20:37:31.154205 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009939 2025-08-21 20:38:22.961736 | 2025-08-21 20:38:22.961880 | TASK [upload-logs : Upload logs to log server] 2025-08-21 20:38:23.506319 | localhost | Output suppressed because no_log was given 2025-08-21 20:38:23.508189 | 2025-08-21 20:38:23.508297 | LOOP [upload-logs : Compress console log and json output] 2025-08-21 20:38:23.565447 | localhost | skipping: Conditional result was False 2025-08-21 20:38:23.570807 | localhost | skipping: Conditional result was False 2025-08-21 20:38:23.577513 | 2025-08-21 20:38:23.577682 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-21 20:38:23.626451 | localhost | skipping: Conditional result was False 2025-08-21 20:38:23.627158 | 2025-08-21 20:38:23.630425 | localhost | skipping: Conditional result was False 2025-08-21 20:38:23.637698 | 2025-08-21 20:38:23.637875 | LOOP [upload-logs : Upload console log and json output]