2025-05-02 11:47:19.910285 | Job console starting... 2025-05-02 11:47:19.923209 | Updating repositories 2025-05-02 11:47:19.952308 | Preparing job workspace 2025-05-02 11:47:21.510621 | Running Ansible setup... 2025-05-02 11:47:26.585690 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-02 11:47:27.329331 | 2025-05-02 11:47:27.329516 | PLAY [Base pre] 2025-05-02 11:47:27.359613 | 2025-05-02 11:47:27.359787 | TASK [Setup log path fact] 2025-05-02 11:47:27.402842 | ubuntu-noble | ok 2025-05-02 11:47:27.430457 | 2025-05-02 11:47:27.430622 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-02 11:47:27.504021 | ubuntu-noble | ok 2025-05-02 11:47:27.521298 | 2025-05-02 11:47:27.521457 | TASK [emit-job-header : Print job information] 2025-05-02 11:47:27.614755 | # Job Information 2025-05-02 11:47:27.614939 | Ansible Version: 2.15.3 2025-05-02 11:47:27.614974 | Job: metalbox-mirror-container-images 2025-05-02 11:47:27.615005 | Pipeline: check 2025-05-02 11:47:27.615026 | Executor: 7d211f194f6a 2025-05-02 11:47:27.615046 | Triggered by: https://github.com/osism/metalbox/pull/10 2025-05-02 11:47:27.615065 | Event ID: 30059cb0-274b-11f0-9352-08f21c015d1f 2025-05-02 11:47:27.621706 | 2025-05-02 11:47:27.621838 | LOOP [emit-job-header : Print node information] 2025-05-02 11:47:27.849102 | ubuntu-noble | ok: 2025-05-02 11:47:27.849301 | ubuntu-noble | # Node Information 2025-05-02 11:47:27.849335 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-05-02 11:47:27.849358 | ubuntu-noble | Hostname: ubuntu 2025-05-02 11:47:27.849399 | ubuntu-noble | Username: zuul 2025-05-02 11:47:27.849420 | ubuntu-noble | Distro: Ubuntu 24.04 2025-05-02 11:47:27.849443 | ubuntu-noble | Provider: regiocloud-a 2025-05-02 11:47:27.849462 | ubuntu-noble | Label: ubuntu-noble 2025-05-02 11:47:27.849483 | ubuntu-noble | Product Name: OpenStack Nova 2025-05-02 11:47:27.849502 | ubuntu-noble | Interface IP: 81.163.193.100 2025-05-02 11:47:27.867439 | 2025-05-02 11:47:27.867585 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-02 11:47:28.643127 | ubuntu-noble -> localhost | changed 2025-05-02 11:47:28.651961 | 2025-05-02 11:47:28.652096 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-02 11:47:29.682696 | ubuntu-noble -> localhost | changed 2025-05-02 11:47:29.696278 | 2025-05-02 11:47:29.696420 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-02 11:47:29.933029 | ubuntu-noble -> localhost | ok 2025-05-02 11:47:29.940241 | 2025-05-02 11:47:29.940338 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-02 11:47:29.969733 | ubuntu-noble | ok 2025-05-02 11:47:29.985224 | ubuntu-noble | included: /var/lib/zuul/builds/d9ec0e0bc02f424aa888d7b77d3c6964/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-02 11:47:29.992537 | 2025-05-02 11:47:29.992625 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-02 11:47:30.637794 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-05-02 11:47:30.637968 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d9ec0e0bc02f424aa888d7b77d3c6964/work/d9ec0e0bc02f424aa888d7b77d3c6964_id_rsa 2025-05-02 11:47:30.638003 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d9ec0e0bc02f424aa888d7b77d3c6964/work/d9ec0e0bc02f424aa888d7b77d3c6964_id_rsa.pub 2025-05-02 11:47:30.638155 | ubuntu-noble -> localhost | The key fingerprint is: 2025-05-02 11:47:30.638180 | ubuntu-noble -> localhost | SHA256:9Y+3LdEzPdKqL7JPjC4GRBZVi0Ln0Z7oRxDGc+Muoo8 zuul-build-sshkey 2025-05-02 11:47:30.638304 | ubuntu-noble -> localhost | The key's randomart image is: 2025-05-02 11:47:30.638330 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-05-02 11:47:30.638351 | ubuntu-noble -> localhost | | o+*+. | 2025-05-02 11:47:30.638371 | ubuntu-noble -> localhost | | .o++o+. | 2025-05-02 11:47:30.638418 | ubuntu-noble -> localhost | | o. oB.+ | 2025-05-02 11:47:30.638449 | ubuntu-noble -> localhost | | ... * . | 2025-05-02 11:47:30.638469 | ubuntu-noble -> localhost | | . . S . ...| 2025-05-02 11:47:30.638489 | ubuntu-noble -> localhost | | o o oo +.=o| 2025-05-02 11:47:30.638511 | ubuntu-noble -> localhost | | . o o. o. =.+| 2025-05-02 11:47:30.638531 | ubuntu-noble -> localhost | | .. o.... o.o | 2025-05-02 11:47:30.638550 | ubuntu-noble -> localhost | | E... .o+o+....| 2025-05-02 11:47:30.638569 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-05-02 11:47:30.638670 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.092992 2025-05-02 11:47:30.651257 | 2025-05-02 11:47:30.651585 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-02 11:47:30.682098 | ubuntu-noble | ok 2025-05-02 11:47:30.692656 | ubuntu-noble | included: /var/lib/zuul/builds/d9ec0e0bc02f424aa888d7b77d3c6964/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-02 11:47:30.701812 | 2025-05-02 11:47:30.701904 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-02 11:47:30.726149 | ubuntu-noble | skipping: Conditional result was False 2025-05-02 11:47:30.743196 | 2025-05-02 11:47:30.743330 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-02 11:47:31.427390 | ubuntu-noble | changed 2025-05-02 11:47:31.437890 | 2025-05-02 11:47:31.438006 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-02 11:47:31.730697 | ubuntu-noble | ok 2025-05-02 11:47:31.742411 | 2025-05-02 11:47:31.742547 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-02 11:47:32.416749 | ubuntu-noble | changed 2025-05-02 11:47:32.431625 | 2025-05-02 11:47:32.431770 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-02 11:47:33.149884 | ubuntu-noble | changed 2025-05-02 11:47:33.161748 | 2025-05-02 11:47:33.161983 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-02 11:47:33.191227 | ubuntu-noble | skipping: Conditional result was False 2025-05-02 11:47:33.207604 | 2025-05-02 11:47:33.207736 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-02 11:47:33.618826 | ubuntu-noble -> localhost | changed 2025-05-02 11:47:33.633131 | 2025-05-02 11:47:33.633240 | TASK [add-build-sshkey : Add back temp key] 2025-05-02 11:47:33.929131 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d9ec0e0bc02f424aa888d7b77d3c6964/work/d9ec0e0bc02f424aa888d7b77d3c6964_id_rsa (zuul-build-sshkey) 2025-05-02 11:47:33.929399 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011249 2025-05-02 11:47:33.938279 | 2025-05-02 11:47:33.938379 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-02 11:47:34.365587 | ubuntu-noble | ok 2025-05-02 11:47:34.371851 | 2025-05-02 11:47:34.371941 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-02 11:47:34.405862 | ubuntu-noble | skipping: Conditional result was False 2025-05-02 11:47:34.421194 | 2025-05-02 11:47:34.421295 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-02 11:47:34.861557 | ubuntu-noble | ok 2025-05-02 11:47:34.896716 | 2025-05-02 11:47:34.896809 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-02 11:47:34.926555 | ubuntu-noble | ok 2025-05-02 11:47:34.932973 | 2025-05-02 11:47:34.933062 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-02 11:47:35.179805 | ubuntu-noble -> localhost | ok 2025-05-02 11:47:35.187777 | 2025-05-02 11:47:35.187869 | TASK [validate-host : Collect information about the host] 2025-05-02 11:47:36.339307 | ubuntu-noble | ok 2025-05-02 11:47:36.355334 | 2025-05-02 11:47:36.355485 | TASK [validate-host : Sanitize hostname] 2025-05-02 11:47:36.457436 | ubuntu-noble | ok 2025-05-02 11:47:36.464135 | 2025-05-02 11:47:36.464265 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-02 11:47:37.043430 | ubuntu-noble -> localhost | changed 2025-05-02 11:47:37.051451 | 2025-05-02 11:47:37.051578 | TASK [validate-host : Collect information about zuul worker] 2025-05-02 11:47:37.531560 | ubuntu-noble | ok 2025-05-02 11:47:37.541601 | 2025-05-02 11:47:37.541744 | TASK [validate-host : Write out all zuul information for each host] 2025-05-02 11:47:38.223583 | ubuntu-noble -> localhost | changed 2025-05-02 11:47:38.266642 | 2025-05-02 11:47:38.266788 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-02 11:47:38.550939 | ubuntu-noble | ok 2025-05-02 11:47:38.560685 | 2025-05-02 11:47:38.560849 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-02 11:47:39.449459 | ubuntu-noble | changed: 2025-05-02 11:47:39.449940 | ubuntu-noble | cd+++++++++ src/ 2025-05-02 11:47:39.449981 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-05-02 11:47:39.450006 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-05-02 11:47:39.450039 | ubuntu-noble | cd+++++++++ src/github.com/osism/metalbox/ 2025-05-02 11:47:39.450295 | ubuntu-noble | [1/1] COPY ./registry.tar.bz2 /registry.tar.bz2: 2025-05-02 11:50:12.819347 | ubuntu-noble | ------ 2025-05-02 11:50:12.819365 | ubuntu-noble | Dockerfile:2 2025-05-02 11:50:12.826054 | ubuntu-noble | -------------------- 2025-05-02 11:50:12.826087 | ubuntu-noble | 1 | FROM scratch 2025-05-02 11:50:12.826097 | ubuntu-noble | 2 | >>> COPY ./registry.tar.bz2 /registry.tar.bz2 2025-05-02 11:50:12.826106 | ubuntu-noble | 3 | 2025-05-02 11:50:12.826114 | ubuntu-noble | -------------------- 2025-05-02 11:50:12.826124 | ubuntu-noble | ERROR: failed to solve: failed to compute cache key: failed to calculate checksum of ref dca97bf9-5518-442c-b590-1362ac9af36e::r58h4o6g82srdyqq0nhuyzilm: "/registry.tar.bz2": not found 2025-05-02 11:50:13.081594 | ubuntu-noble | ERROR 2025-05-02 11:50:13.082044 | ubuntu-noble | { 2025-05-02 11:50:13.082146 | ubuntu-noble | "delta": "0:00:00.507748", 2025-05-02 11:50:13.082214 | ubuntu-noble | "end": "2025-05-02 11:50:12.826621", 2025-05-02 11:50:13.082275 | ubuntu-noble | "msg": "non-zero return code", 2025-05-02 11:50:13.082333 | ubuntu-noble | "rc": 1, 2025-05-02 11:50:13.082391 | ubuntu-noble | "start": "2025-05-02 11:50:12.318873" 2025-05-02 11:50:13.082448 | ubuntu-noble | } failure 2025-05-02 11:50:13.092653 | 2025-05-02 11:50:13.092859 | PLAY RECAP 2025-05-02 11:50:13.093002 | ubuntu-noble | ok: 10 changed: 5 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-05-02 11:50:13.093071 | 2025-05-02 11:50:13.235951 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/metalbox/zuul/mirror-container-images.yml@main] 2025-05-02 11:50:13.238994 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-05-02 11:50:13.948557 | 2025-05-02 11:50:13.948715 | PLAY [Base post] 2025-05-02 11:50:13.974093 | 2025-05-02 11:50:13.974240 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-05-02 11:50:14.718613 | ubuntu-noble | changed 2025-05-02 11:50:14.752875 | 2025-05-02 11:50:14.753020 | PLAY RECAP 2025-05-02 11:50:14.753087 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-05-02 11:50:14.753151 | 2025-05-02 11:50:14.874306 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-05-02 11:50:14.881244 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-05-02 11:50:15.625943 | 2025-05-02 11:50:15.626105 | PLAY [Base post-logs] 2025-05-02 11:50:15.642961 | 2025-05-02 11:50:15.643102 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-05-02 11:50:16.095383 | localhost | changed 2025-05-02 11:50:16.101836 | 2025-05-02 11:50:16.102022 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-05-02 11:50:16.135163 | localhost | ok 2025-05-02 11:50:16.146945 | 2025-05-02 11:50:16.147098 | TASK [Set zuul-log-path fact] 2025-05-02 11:50:16.167792 | localhost | ok 2025-05-02 11:50:16.180204 | 2025-05-02 11:50:16.180323 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-02 11:50:16.208530 | localhost | ok 2025-05-02 11:50:16.214795 | 2025-05-02 11:50:16.214948 | TASK [upload-logs : Create log directories] 2025-05-02 11:50:16.727112 | localhost | changed 2025-05-02 11:50:16.733977 | 2025-05-02 11:50:16.734120 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-05-02 11:50:17.240786 | localhost -> localhost | ok: Runtime: 0:00:00.006098 2025-05-02 11:50:17.252003 | 2025-05-02 11:50:17.252175 | TASK [upload-logs : Upload logs to log server] 2025-05-02 11:50:17.823511 | localhost | Output suppressed because no_log was given 2025-05-02 11:50:17.827628 | 2025-05-02 11:50:17.827757 | LOOP [upload-logs : Compress console log and json output] 2025-05-02 11:50:17.899995 | localhost | skipping: Conditional result was False 2025-05-02 11:50:17.917240 | localhost | skipping: Conditional result was False 2025-05-02 11:50:17.933605 | 2025-05-02 11:50:17.933790 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-02 11:50:18.009397 | localhost | skipping: Conditional result was False 2025-05-02 11:50:18.010136 | 2025-05-02 11:50:18.022297 | localhost | skipping: Conditional result was False 2025-05-02 11:50:18.042625 | 2025-05-02 11:50:18.042802 | LOOP [upload-logs : Upload console log and json output]