2026-05-02 00:04:11.273367 | Job console starting 2026-05-02 00:04:11.295335 | Updating git repos 2026-05-02 00:04:11.314256 | Cloning repos into workspace 2026-05-02 00:04:11.375844 | Restoring repo states 2026-05-02 00:04:11.384346 | Merging changes 2026-05-02 00:04:11.384379 | Checking out repos 2026-05-02 00:04:11.492353 | Preparing playbooks 2026-05-02 00:04:12.354356 | Running Ansible setup 2026-05-02 00:04:17.700029 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-02 00:04:18.359290 | 2026-05-02 00:04:18.359421 | PLAY [Base pre] 2026-05-02 00:04:18.372829 | 2026-05-02 00:04:18.372928 | TASK [Setup log path fact] 2026-05-02 00:04:18.399935 | ubuntu-noble-large | ok 2026-05-02 00:04:18.412690 | 2026-05-02 00:04:18.412801 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-02 00:04:18.439494 | ubuntu-noble-large | ok 2026-05-02 00:04:18.447501 | 2026-05-02 00:04:18.447598 | TASK [emit-job-header : Print job information] 2026-05-02 00:04:18.474535 | # Job Information 2026-05-02 00:04:18.474681 | Ansible Version: 2.16.14 2026-05-02 00:04:18.474710 | Job: metalbox-mirror-debian-packages-publish 2026-05-02 00:04:18.474737 | Pipeline: periodic-midnight 2026-05-02 00:04:18.474756 | Executor: 521e9411259a 2026-05-02 00:04:18.474772 | Triggered by: https://github.com/osism/metalbox 2026-05-02 00:04:18.474790 | Event ID: 4f92e70e8d2c4675941820bb51e3897d 2026-05-02 00:04:18.487539 | 2026-05-02 00:04:18.487709 | LOOP [emit-job-header : Print node information] 2026-05-02 00:04:18.591538 | ubuntu-noble-large | ok: 2026-05-02 00:04:18.591754 | ubuntu-noble-large | # Node Information 2026-05-02 00:04:18.591788 | ubuntu-noble-large | Inventory Hostname: ubuntu-noble-large 2026-05-02 00:04:18.591813 | ubuntu-noble-large | Hostname: ubuntu 2026-05-02 00:04:18.591835 | ubuntu-noble-large | Username: zuul 2026-05-02 00:04:18.591856 | ubuntu-noble-large | Distro: Ubuntu 24.04 2026-05-02 00:04:18.591881 | ubuntu-noble-large | Provider: regiocloud-a 2026-05-02 00:04:18.591903 | ubuntu-noble-large | Region: 2026-05-02 00:04:18.591925 | ubuntu-noble-large | Label: ubuntu-noble-large 2026-05-02 00:04:18.591946 | ubuntu-noble-large | Product Name: OpenStack Nova 2026-05-02 00:04:18.591966 | ubuntu-noble-large | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feaa:2dc9 2026-05-02 00:04:18.613270 | 2026-05-02 00:04:18.613419 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-02 00:04:19.118545 | ubuntu-noble-large -> localhost | changed 2026-05-02 00:04:19.126416 | 2026-05-02 00:04:19.126539 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-02 00:04:20.594415 | ubuntu-noble-large -> localhost | changed 2026-05-02 00:04:20.614840 | 2026-05-02 00:04:20.615360 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-02 00:04:21.110478 | ubuntu-noble-large -> localhost | ok 2026-05-02 00:04:21.123314 | 2026-05-02 00:04:21.123500 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-02 00:04:21.187473 | ubuntu-noble-large | ok 2026-05-02 00:04:21.240751 | ubuntu-noble-large | included: /var/lib/zuul/builds/527ab1ab44e24805a7c4a9df6e2306da/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-02 00:04:21.257695 | 2026-05-02 00:04:21.257992 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-02 00:04:23.550099 | ubuntu-noble-large -> localhost | Generating public/private rsa key pair. 2026-05-02 00:04:23.550631 | ubuntu-noble-large -> localhost | Your identification has been saved in /var/lib/zuul/builds/527ab1ab44e24805a7c4a9df6e2306da/work/527ab1ab44e24805a7c4a9df6e2306da_id_rsa 2026-05-02 00:04:23.550728 | ubuntu-noble-large -> localhost | Your public key has been saved in /var/lib/zuul/builds/527ab1ab44e24805a7c4a9df6e2306da/work/527ab1ab44e24805a7c4a9df6e2306da_id_rsa.pub 2026-05-02 00:04:23.550796 | ubuntu-noble-large -> localhost | The key fingerprint is: 2026-05-02 00:04:23.550893 | ubuntu-noble-large -> localhost | SHA256:vV7WfI/u09xCDtDRMuJoklYkalWiqL6g/zUWI2yyySM zuul-build-sshkey 2026-05-02 00:04:23.550976 | ubuntu-noble-large -> localhost | The key's randomart image is: 2026-05-02 00:04:23.551034 | ubuntu-noble-large -> localhost | +---[RSA 3072]----+ 2026-05-02 00:04:23.551088 | ubuntu-noble-large -> localhost | | +oo . | 2026-05-02 00:04:23.551142 | ubuntu-noble-large -> localhost | | . + o. . + . | 2026-05-02 00:04:23.551195 | ubuntu-noble-large -> localhost | | . + o o o + | 2026-05-02 00:04:23.551245 | ubuntu-noble-large -> localhost | | . o + o.o . | 2026-05-02 00:04:23.551376 | ubuntu-noble-large -> localhost | |. . +.ooS .. | 2026-05-02 00:04:23.551452 | ubuntu-noble-large -> localhost | |.. = . o ..o. | 2026-05-02 00:04:23.551505 | ubuntu-noble-large -> localhost | |E.= + . o+ooo| 2026-05-02 00:04:23.551548 | ubuntu-noble-large -> localhost | |o... o . . o +o=| 2026-05-02 00:04:23.551584 | ubuntu-noble-large -> localhost | |.o... . o+o.| 2026-05-02 00:04:23.551619 | ubuntu-noble-large -> localhost | +----[SHA256]-----+ 2026-05-02 00:04:23.551713 | ubuntu-noble-large -> localhost | ok: Runtime: 0:00:00.858050 2026-05-02 00:04:23.564183 | 2026-05-02 00:04:23.564421 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-02 00:04:23.593287 | ubuntu-noble-large | ok 2026-05-02 00:04:23.605163 | ubuntu-noble-large | included: /var/lib/zuul/builds/527ab1ab44e24805a7c4a9df6e2306da/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-02 00:04:23.619874 | 2026-05-02 00:04:23.620062 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-02 00:04:23.646033 | ubuntu-noble-large | skipping: Conditional result was False 2026-05-02 00:04:23.653557 | 2026-05-02 00:04:23.653747 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-02 00:04:24.451254 | ubuntu-noble-large | changed 2026-05-02 00:04:24.465928 | 2026-05-02 00:04:24.466112 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-02 00:04:24.751785 | ubuntu-noble-large | ok 2026-05-02 00:04:24.760101 | 2026-05-02 00:04:24.760260 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-02 00:04:25.618975 | ubuntu-noble-large | changed 2026-05-02 00:04:25.635776 | 2026-05-02 00:04:25.635939 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-02 00:04:26.488308 | ubuntu-noble-large | changed 2026-05-02 00:04:26.499201 | 2026-05-02 00:04:26.499383 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-02 00:04:26.525404 | ubuntu-noble-large | skipping: Conditional result was False 2026-05-02 00:04:26.533959 | 2026-05-02 00:04:26.534128 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-02 00:04:27.139259 | ubuntu-noble-large -> localhost | changed 2026-05-02 00:04:27.154818 | 2026-05-02 00:04:27.155040 | TASK [add-build-sshkey : Add back temp key] 2026-05-02 00:04:27.658743 | ubuntu-noble-large -> localhost | Identity added: /var/lib/zuul/builds/527ab1ab44e24805a7c4a9df6e2306da/work/527ab1ab44e24805a7c4a9df6e2306da_id_rsa (zuul-build-sshkey) 2026-05-02 00:04:27.659249 | ubuntu-noble-large -> localhost | ok: Runtime: 0:00:00.019354 2026-05-02 00:04:27.666683 | 2026-05-02 00:04:27.666825 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-02 00:04:28.285965 | ubuntu-noble-large | ok 2026-05-02 00:04:28.295165 | 2026-05-02 00:04:28.295356 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-02 00:04:28.350746 | ubuntu-noble-large | skipping: Conditional result was False 2026-05-02 00:04:28.372250 | 2026-05-02 00:04:28.372428 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-02 00:04:28.884699 | ubuntu-noble-large | ok 2026-05-02 00:04:28.920615 | 2026-05-02 00:04:28.920783 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-02 00:04:28.997471 | ubuntu-noble-large | ok 2026-05-02 00:04:29.010993 | 2026-05-02 00:04:29.011158 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-02 00:04:29.592581 | ubuntu-noble-large -> localhost | ok 2026-05-02 00:04:29.599886 | 2026-05-02 00:04:29.600007 | TASK [validate-host : Collect information about the host] 2026-05-02 00:04:31.240419 | ubuntu-noble-large | ok 2026-05-02 00:04:31.414811 | 2026-05-02 00:04:31.414993 | TASK [validate-host : Sanitize hostname] 2026-05-02 00:04:31.475647 | ubuntu-noble-large | ok 2026-05-02 00:04:31.481612 | 2026-05-02 00:04:31.481757 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-02 00:04:32.656954 | ubuntu-noble-large -> localhost | changed 2026-05-02 00:04:32.667450 | 2026-05-02 00:04:32.667591 | TASK [validate-host : Collect information about zuul worker] 2026-05-02 00:04:33.400168 | ubuntu-noble-large | ok 2026-05-02 00:04:33.408529 | 2026-05-02 00:04:33.408662 | TASK [validate-host : Write out all zuul information for each host] 2026-05-02 00:04:34.567513 | ubuntu-noble-large -> localhost | changed 2026-05-02 00:04:34.583254 | 2026-05-02 00:04:34.583522 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-02 00:04:34.938974 | ubuntu-noble-large | ok 2026-05-02 00:04:34.952868 | 2026-05-02 00:04:34.953001 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-02 00:04:36.266433 | ubuntu-noble-large | changed: 2026-05-02 00:04:36.266680 | ubuntu-noble-large | cd+++++++++ src/ 2026-05-02 00:04:36.266731 | ubuntu-noble-large | cd+++++++++ src/github.com/ 2026-05-02 00:04:36.266767 | ubuntu-noble-large | cd+++++++++ src/github.com/osism/ 2026-05-02 00:04:36.266798 | ubuntu-noble-large | cd+++++++++ src/github.com/osism/metalbox/ 2026-05-02 00:04:36.266827 | ubuntu-noble-large | Containerfile 2026-05-02 00:04:36.285537 | ubuntu-noble-large | localhost | ok: "/var/lib/zuul/builds/527ab1ab44e24805a7c4a9df6e2306da/work/logs" 2026-05-02 00:06:22.115651 | ubuntu-noble-large -> localhost | changed: "/var/lib/zuul/builds/527ab1ab44e24805a7c4a9df6e2306da/work/artifacts" 2026-05-02 00:06:22.423848 | ubuntu-noble-large -> localhost | changed: "/var/lib/zuul/builds/527ab1ab44e24805a7c4a9df6e2306da/work/docs" 2026-05-02 00:06:22.445888 | 2026-05-02 00:06:22.446049 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-02 00:06:23.301201 | ubuntu-noble-large | changed: 2026-05-02 00:06:23.301450 | ubuntu-noble-large | .d..t...... ./ 2026-05-02 00:06:23.301486 | ubuntu-noble-large | >f+++++++++ sudo-debug.txt 2026-05-02 00:06:23.301514 | ubuntu-noble-large | >f+++++++++ sudo-strace.log 2026-05-02 00:06:23.301540 | ubuntu-noble-large | >f+++++++++ sudo-strace.log.time 2026-05-02 00:06:23.301586 | ubuntu-noble-large | changed: All items complete 2026-05-02 00:06:23.301612 | 2026-05-02 00:06:23.940358 | ubuntu-noble-large | changed: .d..t...... ./ 2026-05-02 00:06:24.628652 | ubuntu-noble-large | changed: .d..t...... ./ 2026-05-02 00:06:24.648475 | 2026-05-02 00:06:24.648636 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-02 00:06:24.683626 | ubuntu-noble-large | skipping: Conditional result was False 2026-05-02 00:06:24.690702 | ubuntu-noble-large | skipping: Conditional result was False 2026-05-02 00:06:24.702815 | 2026-05-02 00:06:24.702949 | PLAY RECAP 2026-05-02 00:06:24.703005 | ubuntu-noble-large | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-02 00:06:24.703030 | 2026-05-02 00:06:24.880495 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-02 00:06:24.881460 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-02 00:06:25.801225 | 2026-05-02 00:06:25.801411 | PLAY [Base post] 2026-05-02 00:06:25.816588 | 2026-05-02 00:06:25.816744 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-02 00:06:26.479261 | ubuntu-noble-large | changed 2026-05-02 00:06:26.486695 | 2026-05-02 00:06:26.486894 | PLAY RECAP 2026-05-02 00:06:26.486969 | ubuntu-noble-large | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-02 00:06:26.487050 | 2026-05-02 00:06:26.652801 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-02 00:06:26.655216 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-02 00:06:27.975629 | 2026-05-02 00:06:27.975831 | PLAY [Base post-logs] 2026-05-02 00:06:28.001357 | 2026-05-02 00:06:28.001536 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-02 00:06:28.852369 | localhost | changed 2026-05-02 00:06:28.866288 | 2026-05-02 00:06:28.866485 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-02 00:06:28.894564 | localhost | ok 2026-05-02 00:06:28.898563 | 2026-05-02 00:06:28.898699 | TASK [Set zuul-log-path fact] 2026-05-02 00:06:28.917443 | localhost | ok 2026-05-02 00:06:28.927762 | 2026-05-02 00:06:28.927915 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-02 00:06:28.954866 | localhost | ok 2026-05-02 00:06:28.958759 | 2026-05-02 00:06:28.958959 | TASK [upload-logs : Create log directories] 2026-05-02 00:06:29.812965 | localhost | changed 2026-05-02 00:06:29.816249 | 2026-05-02 00:06:29.816385 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-02 00:06:30.621014 | localhost -> localhost | ok: Runtime: 0:00:00.006434 2026-05-02 00:06:30.625564 | 2026-05-02 00:06:30.625693 | TASK [upload-logs : Upload logs to log server] 2026-05-02 00:06:31.337375 | localhost | Output suppressed because no_log was given 2026-05-02 00:06:31.339490 | 2026-05-02 00:06:31.339621 | LOOP [upload-logs : Compress console log and json output] 2026-05-02 00:06:31.400696 | localhost | skipping: Conditional result was False 2026-05-02 00:06:31.408042 | localhost | skipping: Conditional result was False 2026-05-02 00:06:31.412215 | 2026-05-02 00:06:31.412366 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-02 00:06:31.511051 | localhost | skipping: Conditional result was False 2026-05-02 00:06:31.511412 | 2026-05-02 00:06:31.524411 | localhost | skipping: Conditional result was False 2026-05-02 00:06:31.540472 | 2026-05-02 00:06:31.540758 | LOOP [upload-logs : Upload console log and json output]