2025-08-21 20:23:57.577269 | Job console starting 2025-08-21 20:23:57.599474 | Updating git repos 2025-08-21 20:23:57.620769 | Cloning repos into workspace 2025-08-21 20:23:57.675490 | Restoring repo states 2025-08-21 20:23:57.694777 | Merging changes 2025-08-21 20:23:58.227239 | Checking out repos 2025-08-21 20:23:58.261605 | Preparing playbooks 2025-08-21 20:23:58.824363 | Running Ansible setup 2025-08-21 20:24:04.023225 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-21 20:24:04.765216 | 2025-08-21 20:24:04.765377 | PLAY [Base pre] 2025-08-21 20:24:04.786015 | 2025-08-21 20:24:04.786177 | TASK [Setup log path fact] 2025-08-21 20:24:04.804975 | debian-bookworm | ok 2025-08-21 20:24:04.820430 | 2025-08-21 20:24:04.820560 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-21 20:24:04.849933 | debian-bookworm | ok 2025-08-21 20:24:04.859702 | 2025-08-21 20:24:04.859816 | TASK [emit-job-header : Print job information] 2025-08-21 20:24:04.899233 | # Job Information 2025-08-21 20:24:04.899412 | Ansible Version: 2.16.14 2025-08-21 20:24:04.899449 | Job: metalbox-mirror-debian-packages 2025-08-21 20:24:04.899481 | Pipeline: check 2025-08-21 20:24:04.899505 | Executor: 521e9411259a 2025-08-21 20:24:04.899527 | Triggered by: https://github.com/osism/metalbox/pull/189 2025-08-21 20:24:04.899550 | Event ID: bf7eed00-7ecc-11f0-9d46-32323f7e7020 2025-08-21 20:24:04.904529 | 2025-08-21 20:24:04.904698 | LOOP [emit-job-header : Print node information] 2025-08-21 20:24:05.007914 | debian-bookworm | ok: 2025-08-21 20:24:05.008130 | debian-bookworm | # Node Information 2025-08-21 20:24:05.008167 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-21 20:24:05.008192 | debian-bookworm | Hostname: debian 2025-08-21 20:24:05.008214 | debian-bookworm | Username: zuul 2025-08-21 20:24:05.008234 | debian-bookworm | Distro: Debian 12.11 2025-08-21 20:24:05.008258 | debian-bookworm | Provider: regiocloud-a 2025-08-21 20:24:05.008279 | debian-bookworm | Region: 2025-08-21 20:24:05.008301 | debian-bookworm | Label: debian-bookworm 2025-08-21 20:24:05.008320 | debian-bookworm | Product Name: OpenStack Nova 2025-08-21 20:24:05.008340 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed7:a33d 2025-08-21 20:24:05.020600 | 2025-08-21 20:24:05.020729 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-21 20:24:05.460746 | debian-bookworm -> localhost | changed 2025-08-21 20:24:05.468257 | 2025-08-21 20:24:05.468428 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-21 20:24:06.474967 | debian-bookworm -> localhost | changed 2025-08-21 20:24:06.485751 | 2025-08-21 20:24:06.485866 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-21 20:24:06.753370 | debian-bookworm -> localhost | ok 2025-08-21 20:24:06.767183 | 2025-08-21 20:24:06.767359 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-21 20:24:06.802173 | debian-bookworm | ok 2025-08-21 20:24:06.822047 | debian-bookworm | included: /var/lib/zuul/builds/c31ae8a1286442d09ddfcafffad3db1c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-21 20:24:06.828607 | 2025-08-21 20:24:06.829645 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-21 20:24:08.046530 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-21 20:24:08.046815 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c31ae8a1286442d09ddfcafffad3db1c/work/c31ae8a1286442d09ddfcafffad3db1c_id_rsa 2025-08-21 20:24:08.046889 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c31ae8a1286442d09ddfcafffad3db1c/work/c31ae8a1286442d09ddfcafffad3db1c_id_rsa.pub 2025-08-21 20:24:08.046926 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-21 20:24:08.046959 | debian-bookworm -> localhost | SHA256:h+p05wnpTkJNn65WfW/s7LS1qVeqiYLH5k+MSp/Nwso zuul-build-sshkey 2025-08-21 20:24:08.046989 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-21 20:24:08.047032 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-21 20:24:08.047061 | debian-bookworm -> localhost | | | 2025-08-21 20:24:08.047107 | debian-bookworm -> localhost | | | 2025-08-21 20:24:08.047138 | debian-bookworm -> localhost | | . | 2025-08-21 20:24:08.047166 | debian-bookworm -> localhost | | o o . | 2025-08-21 20:24:08.047195 | debian-bookworm -> localhost | | . S +. | 2025-08-21 20:24:08.047227 | debian-bookworm -> localhost | | . . *. . . .| 2025-08-21 20:24:08.047256 | debian-bookworm -> localhost | | =+*.= . ++| 2025-08-21 20:24:08.047285 | debian-bookworm -> localhost | | =.BOX o ..+O| 2025-08-21 20:24:08.047313 | debian-bookworm -> localhost | | EBB+B oooB+| 2025-08-21 20:24:08.047340 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-21 20:24:08.047414 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.730742 2025-08-21 20:24:08.063639 | 2025-08-21 20:24:08.063806 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-21 20:24:08.102026 | debian-bookworm | ok 2025-08-21 20:24:08.115483 | debian-bookworm | included: /var/lib/zuul/builds/c31ae8a1286442d09ddfcafffad3db1c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-21 20:24:08.125163 | 2025-08-21 20:24:08.125263 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-21 20:24:08.148835 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:24:08.154788 | 2025-08-21 20:24:08.154936 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-21 20:24:08.800235 | debian-bookworm | changed 2025-08-21 20:24:08.807800 | 2025-08-21 20:24:08.807921 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-21 20:24:09.091963 | debian-bookworm | ok 2025-08-21 20:24:09.101710 | 2025-08-21 20:24:09.101867 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-21 20:24:09.770678 | debian-bookworm | changed 2025-08-21 20:24:09.777910 | 2025-08-21 20:24:09.778023 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-21 20:24:10.494823 | debian-bookworm | changed 2025-08-21 20:24:10.500464 | 2025-08-21 20:24:10.500572 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-21 20:24:10.516842 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:24:10.523038 | 2025-08-21 20:24:10.523159 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-21 20:24:10.950807 | debian-bookworm -> localhost | changed 2025-08-21 20:24:10.962172 | 2025-08-21 20:24:10.962288 | TASK [add-build-sshkey : Add back temp key] 2025-08-21 20:24:11.310653 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c31ae8a1286442d09ddfcafffad3db1c/work/c31ae8a1286442d09ddfcafffad3db1c_id_rsa (zuul-build-sshkey) 2025-08-21 20:24:11.311285 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018485 2025-08-21 20:24:11.348677 | 2025-08-21 20:24:11.348798 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-21 20:24:11.767530 | debian-bookworm | ok 2025-08-21 20:24:11.774659 | 2025-08-21 20:24:11.774783 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-21 20:24:11.809486 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:24:11.830508 | 2025-08-21 20:24:11.830645 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-21 20:24:12.276237 | debian-bookworm | ok 2025-08-21 20:24:12.288438 | 2025-08-21 20:24:12.288580 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-21 20:24:12.332944 | debian-bookworm | ok 2025-08-21 20:24:12.341676 | 2025-08-21 20:24:12.341831 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-21 20:24:12.651854 | debian-bookworm -> localhost | ok 2025-08-21 20:24:12.664478 | 2025-08-21 20:24:12.664638 | TASK [validate-host : Collect information about the host] 2025-08-21 20:24:13.831975 | debian-bookworm | ok 2025-08-21 20:24:13.846868 | 2025-08-21 20:24:13.847001 | TASK [validate-host : Sanitize hostname] 2025-08-21 20:24:13.960944 | debian-bookworm | ok 2025-08-21 20:24:14.003383 | 2025-08-21 20:24:14.003510 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-21 20:24:14.563403 | debian-bookworm -> localhost | changed 2025-08-21 20:24:14.574731 | 2025-08-21 20:24:14.575191 | TASK [validate-host : Collect information about zuul worker] 2025-08-21 20:24:15.009322 | debian-bookworm | ok 2025-08-21 20:24:15.014293 | 2025-08-21 20:24:15.014403 | TASK [validate-host : Write out all zuul information for each host] 2025-08-21 20:24:15.585196 | debian-bookworm -> localhost | changed 2025-08-21 20:24:15.596060 | 2025-08-21 20:24:15.596230 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-21 20:24:15.880197 | debian-bookworm | ok 2025-08-21 20:24:15.887355 | 2025-08-21 20:24:15.887477 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-21 20:24:16.760153 | debian-bookworm | changed: 2025-08-21 20:24:16.760366 | debian-bookworm | cd+++++++++ src/ 2025-08-21 20:24:16.760400 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-21 20:24:16.760424 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-21 20:24:16.760445 | debian-bookworm | cd+++++++++ src/github.com/osism/metalbox/ 2025-08-21 20:24:16.760466 | debian-bookworm | 0% 2% 3% 5% 6% 7% 8% 9% 10% 12% 13% 14% 15% 16% 17% 18% 19% 20% 21% 22% 23% 24% 25% 26% 27% 29% 30% 31% 32% 33% 34% 35% 36% 37% 38% 39% 40% 41% 42% 43% 44% 45% 47% 48% 49% 50% 51% 52% 53% 54% 55% 56% 57% 58% 59% 60% 61% 62% 64% 65% 66% 67% 68% 69% 70% 71% 72% 73% 74% 75% 76% 77% 78% 79% 80% 82% 83% 84% 85% 86% 87% 88% 89% 90% 91% 92% 93% 94% 95% 96% 97% 98% 99%100%200 OK (1s) 2025-08-21 20:25:05.487593 | debian-bookworm | ok 2025-08-21 20:25:05.628087 | debian-bookworm | [ 0%] Getting: dists/jammy/InRelease... #** GET http://archive.ubuntu.com/ubuntu/dists/jammy/InRelease ==> 0% 2% 3% 5% 6% 8% 9% 10% 11% 12% 13% 14% 16% 17% 19% 20% 21% 22% 23% 24% 25% 27% 28% 30% 31% 32% 33% 34% 35% 36% 38% 40% 41% 43% 44% 46% 47% 48% 49% 51% 52% 54% 55% 56% 57% 58% 59% 60% 62% 63% 64% 65% 66% 67% 68% 70% 71% 72% 73% 74% 76% 78% 79% 81% 82% 83% 84% 86% 87% 88% 89% 90% 92% 93% 95% 97% 98% 99%100%200 OK 2025-08-21 20:25:05.628236 | debian-bookworm | ok 2025-08-21 20:25:05.709323 | debian-bookworm | [ 0%] Getting: dists/jammy/Release.gpg... #** GET http://archive.ubuntu.com/ubuntu/dists/jammy/Release.gpg ==> 83%100%200 OK 2025-08-21 20:25:05.709449 | debian-bookworm | ok 2025-08-21 20:25:05.723450 | debian-bookworm | No packages after parsing Packages and Sources files! 2025-08-21 20:25:05.726853 | debian-bookworm | WARNING: releasing 1 pending lock... 2025-08-21 20:25:05.727206 | debian-bookworm | Ubuntu Release file: using Suite (jammy). 2025-08-21 20:25:05.727227 | debian-bookworm | Parsing Packages and Sources files ... 2025-08-21 20:25:05.734706 | debian-bookworm | SUCCESS: Successfully mirrored packages from archive.ubuntu.com/ubuntu jammy 2025-08-21 20:25:05.737304 | debian-bookworm | Processing repository: archive.ubuntu.com/ubuntu jammy-updates 2025-08-21 20:25:05.739173 | debian-bookworm | Components: main,universe,restricted,multiverse 2025-08-21 20:25:05.741065 | debian-bookworm | Architecture: amd64 2025-08-21 20:25:05.745242 | debian-bookworm | Running debmirror for archive.ubuntu.com/ubuntu... 2025-08-21 20:25:05.936705 | debian-bookworm | Mirroring to src/github.com/osism/metalbox/zuul/files/mirror/jammy-updates from http://archive.ubuntu.com/ubuntu/ 2025-08-21 20:25:05.936797 | debian-bookworm | Arches: amd64 2025-08-21 20:25:05.936812 | debian-bookworm | Dists: jammy-updates 2025-08-21 20:25:05.936825 | debian-bookworm | Sections: main universe restricted multiverse 2025-08-21 20:25:05.936838 | debian-bookworm | Including source. 2025-08-21 20:25:05.936850 | debian-bookworm | Pdiff mode: none 2025-08-21 20:25:05.936861 | debian-bookworm | Not checking Release gpg signatures. 2025-08-21 20:25:05.936872 | debian-bookworm | Will clean up before mirroring. 2025-08-21 20:25:05.955702 | debian-bookworm | Attempting to get lock ... 2025-08-21 20:25:05.955851 | debian-bookworm | Updating remote trace files (using rsync) ... 2025-08-21 20:25:06.216832 | debian-bookworm | This is an Ubuntu mirror - treat it kindly 2025-08-21 20:25:06.216920 | debian-bookworm | 2025-08-21 20:25:06.658505 | debian-bookworm | receiving incremental file list 2025-08-21 20:25:06.938470 | debian-bookworm | ./ 2025-08-21 20:25:07.018010 | debian-bookworm | project/ 2025-08-21 20:25:07.018199 | debian-bookworm | project/trace/ 2025-08-21 20:25:07.018499 | debian-bookworm | project/trace/anonster.canonical.com 2025-08-21 20:25:07.018745 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 28.32kB/s 0:00:00 (xfr#1, to-chk=6/10) 2025-08-21 20:25:07.019124 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0 2025-08-21 20:25:07.019248 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 28.32kB/s 0:00:00 (xfr#2, to-chk=5/10) 2025-08-21 20:25:07.019487 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.dists-timestamps 2025-08-21 20:25:07.335759 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 306,920 100% 945.51kB/s 0:00:00 (xfr#3, to-chk=4/10) 2025-08-21 20:25:07.336223 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan 2025-08-21 20:25:07.336385 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 0.09kB/s 0:00:00 (xfr#4, to-chk=3/10) 2025-08-21 20:25:07.336684 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan.dists-timestamps 2025-08-21 20:25:07.407555 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 267,914 100% 674.32kB/s 0:00:00 (xfr#5, to-chk=2/10) 2025-08-21 20:25:07.408073 | debian-bookworm | project/trace/juju-4112d9-prod-launchpad-manual-servers-29.None 2025-08-21 20:25:07.408227 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 0.07kB/s 0:00:00 (xfr#6, to-chk=1/10) 2025-08-21 20:25:07.408445 | debian-bookworm | project/trace/juju-98d295-prod-launchpad-22 2025-08-21 20:25:07.408564 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 0.07kB/s 0:00:00 (xfr#7, to-chk=0/10) 2025-08-21 20:25:07.687651 | debian-bookworm | 2025-08-21 20:25:07.687886 | debian-bookworm | sent 264 bytes received 575,942 bytes 230,482.40 bytes/sec 2025-08-21 20:25:07.687947 | debian-bookworm | total size is 574,979 speedup is 1.00 2025-08-21 20:25:07.710962 | debian-bookworm | Getting meta files ... 2025-08-21 20:25:08.172197 | debian-bookworm | [ 0%] Getting: dists/jammy-updates/Release... #** GET http://archive.ubuntu.com/ubuntu/dists/jammy-updates/Release ==> 1% 4% 7% 10% 11% 13% 15% 18% 20% 22% 24% 27% 29% 30% 32% 33% 36% 38% 40% 42% 45% 47% 49% 51% 54% 55% 57% 59% 61% 64% 66% 68% 70% 73% 75% 77% 79% 82% 84% 86% 88% 91% 93% 95% 97%100%200 OK (1s) 2025-08-21 20:25:08.172735 | debian-bookworm | ok 2025-08-21 20:25:08.316378 | debian-bookworm | [ 0%] Getting: dists/jammy-updates/InRelease... #** GET http://archive.ubuntu.com/ubuntu/dists/jammy-updates/InRelease ==> 1% 4% 5% 8% 10% 12% 14% 16% 19% 21% 23% 25% 28% 30% 32% 34% 37% 39% 41% 43% 45% 48% 50% 52% 54% 57% 59% 60% 62% 64% 67% 69% 71% 73% 76% 78% 80% 82% 85% 87% 89% 91% 93% 96% 98%100%200 OK 2025-08-21 20:25:08.316842 | debian-bookworm | ok 2025-08-21 20:25:08.399845 | debian-bookworm | [ 0%] Getting: dists/jammy-updates/Release.gpg... #** GET http://archive.ubuntu.com/ubuntu/dists/jammy-updates/Release.gpg ==> 82%100%200 OK 2025-08-21 20:25:08.400254 | debian-bookworm | ok 2025-08-21 20:25:08.411500 | debian-bookworm | No packages after parsing Packages and Sources files! 2025-08-21 20:25:08.415328 | debian-bookworm | WARNING: releasing 1 pending lock... 2025-08-21 20:25:08.415892 | debian-bookworm | Ubuntu Release file: using Suite (jammy-updates). 2025-08-21 20:25:08.415917 | debian-bookworm | Parsing Packages and Sources files ... 2025-08-21 20:25:08.423673 | debian-bookworm | SUCCESS: Successfully mirrored packages from archive.ubuntu.com/ubuntu jammy-updates 2025-08-21 20:25:08.426280 | debian-bookworm | Processing repository: archive.ubuntu.com/ubuntu jammy-security 2025-08-21 20:25:08.428155 | debian-bookworm | Components: main,universe,restricted,multiverse 2025-08-21 20:25:08.429975 | debian-bookworm | Architecture: amd64 2025-08-21 20:25:08.435829 | debian-bookworm | Running debmirror for archive.ubuntu.com/ubuntu... 2025-08-21 20:25:08.641123 | debian-bookworm | Mirroring to src/github.com/osism/metalbox/zuul/files/mirror/jammy-security from http://archive.ubuntu.com/ubuntu/ 2025-08-21 20:25:08.641198 | debian-bookworm | Arches: amd64 2025-08-21 20:25:08.641204 | debian-bookworm | Dists: jammy-security 2025-08-21 20:25:08.641209 | debian-bookworm | Sections: main universe restricted multiverse 2025-08-21 20:25:08.641215 | debian-bookworm | Including source. 2025-08-21 20:25:08.641219 | debian-bookworm | Pdiff mode: none 2025-08-21 20:25:08.641222 | debian-bookworm | Not checking Release gpg signatures. 2025-08-21 20:25:08.641227 | debian-bookworm | Will clean up before mirroring. 2025-08-21 20:25:08.658643 | debian-bookworm | Attempting to get lock ... 2025-08-21 20:25:08.658690 | debian-bookworm | Updating remote trace files (using rsync) ... 2025-08-21 20:25:08.909372 | debian-bookworm | This is an Ubuntu mirror - treat it kindly 2025-08-21 20:25:08.909520 | debian-bookworm | 2025-08-21 20:25:09.352134 | debian-bookworm | receiving incremental file list 2025-08-21 20:25:09.632075 | debian-bookworm | ./ 2025-08-21 20:25:09.711320 | debian-bookworm | project/ 2025-08-21 20:25:09.711489 | debian-bookworm | project/trace/ 2025-08-21 20:25:09.711689 | debian-bookworm | project/trace/anonster.canonical.com 2025-08-21 20:25:09.711974 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 28.32kB/s 0:00:00 (xfr#1, to-chk=6/10) 2025-08-21 20:25:09.712335 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0 2025-08-21 20:25:09.712524 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 28.32kB/s 0:00:00 (xfr#2, to-chk=5/10) 2025-08-21 20:25:09.713050 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.dists-timestamps 2025-08-21 20:25:10.027573 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 306,920 100% 948.50kB/s 0:00:00 (xfr#3, to-chk=4/10) 2025-08-21 20:25:10.028008 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan 2025-08-21 20:25:10.028107 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 0.09kB/s 0:00:00 (xfr#4, to-chk=3/10) 2025-08-21 20:25:10.028216 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan.dists-timestamps 2025-08-21 20:25:10.099731 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 267,914 100% 674.32kB/s 0:00:00 (xfr#5, to-chk=2/10) 2025-08-21 20:25:10.100163 | debian-bookworm | project/trace/juju-4112d9-prod-launchpad-manual-servers-29.None 2025-08-21 20:25:10.100272 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 0.07kB/s 0:00:00 (xfr#6, to-chk=1/10) 2025-08-21 20:25:10.100437 | debian-bookworm | project/trace/juju-98d295-prod-launchpad-22 2025-08-21 20:25:10.100554 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 0.07kB/s 0:00:00 (xfr#7, to-chk=0/10) 2025-08-21 20:25:10.379885 | debian-bookworm | 2025-08-21 20:25:10.380032 | debian-bookworm | sent 264 bytes received 575,942 bytes 230,482.40 bytes/sec 2025-08-21 20:25:10.380049 | debian-bookworm | total size is 574,979 speedup is 1.00 2025-08-21 20:25:10.404338 | debian-bookworm | Getting meta files ... 2025-08-21 20:25:10.868879 | debian-bookworm | [ 0%] Getting: dists/jammy-security/Release... #** GET http://archive.ubuntu.com/ubuntu/dists/jammy-security/Release ==> 1% 4% 7% 10% 11% 13% 15% 18% 20% 22% 24% 26% 29% 31% 33% 35% 38% 40% 42% 44% 47% 49% 51% 53% 55% 58% 60% 62% 64% 67% 69% 71% 73% 76% 78% 80% 82% 84% 87% 89% 91% 93% 96% 98%100%200 OK 2025-08-21 20:25:10.869090 | debian-bookworm | ok 2025-08-21 20:25:11.008608 | debian-bookworm | [ 0%] Getting: dists/jammy-security/InRelease... #** GET http://archive.ubuntu.com/ubuntu/dists/jammy-security/InRelease ==> 1% 4% 5% 8% 10% 12% 14% 16% 19% 21% 23% 25% 27% 30% 32% 34% 36% 39% 41% 43% 45% 47% 50% 52% 54% 56% 58% 60% 62% 64% 66% 68% 71% 73% 75% 77% 80% 82% 84% 86% 88% 91% 93% 95% 97% 99%100%200 OK (1s) 2025-08-21 20:25:11.008953 | debian-bookworm | ok 2025-08-21 20:25:11.091312 | debian-bookworm | [ 0%] Getting: dists/jammy-security/Release.gpg... #** GET http://archive.ubuntu.com/ubuntu/dists/jammy-security/Release.gpg ==> 82%100%200 OK 2025-08-21 20:25:11.091685 | debian-bookworm | ok 2025-08-21 20:25:11.101755 | debian-bookworm | No packages after parsing Packages and Sources files! 2025-08-21 20:25:11.105363 | debian-bookworm | WARNING: releasing 1 pending lock... 2025-08-21 20:25:11.105805 | debian-bookworm | Ubuntu Release file: using Suite (jammy-security). 2025-08-21 20:25:11.105824 | debian-bookworm | Parsing Packages and Sources files ... 2025-08-21 20:25:11.113082 | debian-bookworm | SUCCESS: Successfully mirrored packages from archive.ubuntu.com/ubuntu jammy-security 2025-08-21 20:25:11.116519 | debian-bookworm | Processing repository: security.ubuntu.com/ubuntu jammy-security 2025-08-21 20:25:11.119354 | debian-bookworm | Components: main,universe,restricted,multiverse 2025-08-21 20:25:11.122217 | debian-bookworm | Architecture: amd64 2025-08-21 20:25:11.127634 | debian-bookworm | Running debmirror for security.ubuntu.com/ubuntu... 2025-08-21 20:25:11.319275 | debian-bookworm | Mirroring to src/github.com/osism/metalbox/zuul/files/mirror/jammy-security from http://security.ubuntu.com/ubuntu/ 2025-08-21 20:25:11.319325 | debian-bookworm | Arches: amd64 2025-08-21 20:25:11.319349 | debian-bookworm | Dists: jammy-security 2025-08-21 20:25:11.319359 | debian-bookworm | Sections: main universe restricted multiverse 2025-08-21 20:25:11.319367 | debian-bookworm | Including source. 2025-08-21 20:25:11.319374 | debian-bookworm | Pdiff mode: none 2025-08-21 20:25:11.319380 | debian-bookworm | Not checking Release gpg signatures. 2025-08-21 20:25:11.319387 | debian-bookworm | Will clean up before mirroring. 2025-08-21 20:25:11.334917 | debian-bookworm | Attempting to get lock ... 2025-08-21 20:25:11.334964 | debian-bookworm | Updating remote trace files (using rsync) ... 2025-08-21 20:25:11.471810 | debian-bookworm | This is an Ubuntu mirror - treat it kindly 2025-08-21 20:25:11.471873 | debian-bookworm | 2025-08-21 20:25:11.597543 | debian-bookworm | receiving incremental file list 2025-08-21 20:25:11.689739 | debian-bookworm | ./ 2025-08-21 20:25:11.692370 | debian-bookworm | project/trace/anonster.canonical.com 2025-08-21 20:25:11.692705 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 28.32kB/s 0:00:00 (xfr#1, to-chk=6/10) 2025-08-21 20:25:11.693294 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0 2025-08-21 20:25:11.693483 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 28.32kB/s 0:00:00 (xfr#2, to-chk=5/10) 2025-08-21 20:25:11.693852 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.dists-timestamps 2025-08-21 20:25:11.706290 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 306,920 100% 22.52MB/s 0:00:00 (xfr#3, to-chk=4/10) 2025-08-21 20:25:11.707054 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan 2025-08-21 20:25:11.707306 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 2.02kB/s 0:00:00 (xfr#4, to-chk=3/10) 2025-08-21 20:25:11.707694 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan.dists-timestamps 2025-08-21 20:25:11.722116 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 267,914 100% 8.81MB/s 0:00:00 (xfr#5, to-chk=2/10) 2025-08-21 20:25:11.722805 | debian-bookworm | project/trace/juju-4112d9-prod-launchpad-manual-servers-29.None 2025-08-21 20:25:11.723043 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 0.94kB/s 0:00:00 (xfr#6, to-chk=1/10) 2025-08-21 20:25:11.723349 | debian-bookworm | project/trace/juju-98d295-prod-launchpad-22 2025-08-21 20:25:11.723510 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 0.94kB/s 0:00:00 (xfr#7, to-chk=0/10) 2025-08-21 20:25:11.816466 | debian-bookworm | 2025-08-21 20:25:11.816609 | debian-bookworm | sent 5,220 bytes received 4,041 bytes 18,522.00 bytes/sec 2025-08-21 20:25:11.816660 | debian-bookworm | total size is 574,979 speedup is 62.09 2025-08-21 20:25:11.839334 | debian-bookworm | Getting meta files ... 2025-08-21 20:25:11.956314 | debian-bookworm | [ 0%] Getting: dists/jammy-security/Release... #** GET http://security.ubuntu.com/ubuntu/dists/jammy-security/Release ==> 1% 4% 7% 10% 11% 13% 15% 18% 20% 22% 24% 26% 29% 31% 33% 35% 38% 40% 42% 44% 47% 49% 51% 53% 55% 58% 60% 62% 64% 67% 69% 71% 73% 76% 78% 81% 84% 88% 91% 94% 95% 98%100%200 OK 2025-08-21 20:25:11.956948 | debian-bookworm | ok 2025-08-21 20:25:11.986794 | debian-bookworm | [ 0%] Getting: dists/jammy-security/InRelease... #** GET http://security.ubuntu.com/ubuntu/dists/jammy-security/InRelease ==> 1% 4% 7% 10% 13% 16% 20% 23% 25% 28% 32% 33% 35% 38% 41% 44% 47% 48% 52% 55% 56% 59% 63% 64% 67% 70% 72% 75% 76% 79% 83% 86% 89% 91% 94% 97% 98%100%200 OK 2025-08-21 20:25:11.987090 | debian-bookworm | ok 2025-08-21 20:25:12.006185 | debian-bookworm | [ 0%] Getting: dists/jammy-security/Release.gpg... #** GET http://security.ubuntu.com/ubuntu/dists/jammy-security/Release.gpg ==> 82%100%200 OK (1s) 2025-08-21 20:25:12.006384 | debian-bookworm | ok 2025-08-21 20:25:12.020974 | debian-bookworm | No packages after parsing Packages and Sources files! 2025-08-21 20:25:12.025033 | debian-bookworm | WARNING: releasing 1 pending lock... 2025-08-21 20:25:12.025459 | debian-bookworm | Ubuntu Release file: using Suite (jammy-security). 2025-08-21 20:25:12.025477 | debian-bookworm | Parsing Packages and Sources files ... 2025-08-21 20:25:12.034590 | debian-bookworm | SUCCESS: Successfully mirrored packages from security.ubuntu.com/ubuntu jammy-security 2025-08-21 20:25:12.036792 | debian-bookworm | Mirroring completed 2025-08-21 20:25:12.038496 | debian-bookworm | Successfully processed repositories: 4/4 2025-08-21 20:25:12.040222 | debian-bookworm | Creating unified repository structure... 2025-08-21 20:25:12.049146 | debian-bookworm | Organizing packages into unified structure... 2025-08-21 20:25:12.141787 | debian-bookworm | dpkg-scanpackages: info: Wrote 0 entries to output Packages file. 2025-08-21 20:25:12.151859 | debian-bookworm | SUCCESS: Unified repository created at: src/github.com/osism/metalbox/zuul/files/mirror/repository 2025-08-21 20:25:12.153363 | debian-bookworm | Repository is ready to be served via HTTP 2025-08-21 20:25:12.154905 | debian-bookworm | Example Apache configuration: 2025-08-21 20:25:12.156474 | debian-bookworm | DocumentRoot src/github.com/osism/metalbox/zuul/files/mirror/repository 2025-08-21 20:25:12.157962 | debian-bookworm | Directory directives for .deb files 2025-08-21 20:25:12.159945 | debian-bookworm | environment: line 244: src/github.com/osism/metalbox/zuul/files/mirror/USAGE.md: No such file or directory 2025-08-21 20:25:12.160357 | debian-bookworm | Cleaning up temporary files... 2025-08-21 20:25:12.164954 | debian-bookworm | SUCCESS: Cleanup completed 2025-08-21 20:25:12.461184 | debian-bookworm | ERROR 2025-08-21 20:25:12.461634 | debian-bookworm | { 2025-08-21 20:25:12.461738 | debian-bookworm | "delta": "0:00:09.566743", 2025-08-21 20:25:12.461808 | debian-bookworm | "end": "2025-08-21 20:25:12.168463", 2025-08-21 20:25:12.461894 | debian-bookworm | "msg": "non-zero return code", 2025-08-21 20:25:12.461955 | debian-bookworm | "rc": 1, 2025-08-21 20:25:12.462009 | debian-bookworm | "start": "2025-08-21 20:25:02.601720" 2025-08-21 20:25:12.462061 | debian-bookworm | } failure 2025-08-21 20:25:12.472420 | 2025-08-21 20:25:12.472541 | PLAY RECAP 2025-08-21 20:25:12.472627 | debian-bookworm | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-08-21 20:25:12.472670 | 2025-08-21 20:25:12.597940 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/metalbox/zuul/mirror-debian-packages.yml@main] 2025-08-21 20:25:12.598881 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-21 20:25:13.305187 | 2025-08-21 20:25:13.305344 | PLAY [Base post] 2025-08-21 20:25:13.318630 | 2025-08-21 20:25:13.318764 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-21 20:25:14.143158 | debian-bookworm | changed 2025-08-21 20:25:14.151864 | 2025-08-21 20:25:14.151982 | PLAY RECAP 2025-08-21 20:25:14.152056 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-21 20:25:14.152152 | 2025-08-21 20:25:14.266044 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-21 20:25:14.268159 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-21 20:25:15.063298 | 2025-08-21 20:25:15.063467 | PLAY [Base post-logs] 2025-08-21 20:25:15.073697 | 2025-08-21 20:25:15.073825 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-21 20:25:15.537852 | localhost | changed 2025-08-21 20:25:15.552243 | 2025-08-21 20:25:15.552434 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-21 20:25:15.579432 | localhost | ok 2025-08-21 20:25:15.583764 | 2025-08-21 20:25:15.583904 | TASK [Set zuul-log-path fact] 2025-08-21 20:25:15.610702 | localhost | ok 2025-08-21 20:25:15.619045 | 2025-08-21 20:25:15.619216 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-21 20:25:15.644903 | localhost | ok 2025-08-21 20:25:15.648075 | 2025-08-21 20:25:15.648233 | TASK [upload-logs : Create log directories] 2025-08-21 20:25:16.134690 | localhost | changed 2025-08-21 20:25:16.137668 | 2025-08-21 20:25:16.137774 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-21 20:25:16.628042 | localhost -> localhost | ok: Runtime: 0:00:00.006853 2025-08-21 20:25:16.632267 | 2025-08-21 20:25:16.632386 | TASK [upload-logs : Upload logs to log server] 2025-08-21 20:25:17.197103 | localhost | Output suppressed because no_log was given 2025-08-21 20:25:17.200976 | 2025-08-21 20:25:17.201182 | LOOP [upload-logs : Compress console log and json output] 2025-08-21 20:25:17.252008 | localhost | skipping: Conditional result was False 2025-08-21 20:25:17.259903 | localhost | skipping: Conditional result was False 2025-08-21 20:25:17.272666 | 2025-08-21 20:25:17.272879 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-21 20:25:17.319055 | localhost | skipping: Conditional result was False 2025-08-21 20:25:17.319368 | 2025-08-21 20:25:17.325980 | localhost | skipping: Conditional result was False 2025-08-21 20:25:17.335397 | 2025-08-21 20:25:17.335608 | LOOP [upload-logs : Upload console log and json output]