2025-08-21 20:17:08.965497 | Job console starting 2025-08-21 20:17:08.987290 | Updating git repos 2025-08-21 20:17:09.005311 | Cloning repos into workspace 2025-08-21 20:17:09.042884 | Restoring repo states 2025-08-21 20:17:09.051212 | Merging changes 2025-08-21 20:17:09.578121 | Checking out repos 2025-08-21 20:17:09.627438 | Preparing playbooks 2025-08-21 20:17:10.288880 | Running Ansible setup 2025-08-21 20:17:14.483052 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-21 20:17:15.206008 | 2025-08-21 20:17:15.206214 | PLAY [Base pre] 2025-08-21 20:17:15.222590 | 2025-08-21 20:17:15.222745 | TASK [Setup log path fact] 2025-08-21 20:17:15.251681 | debian-bookworm | ok 2025-08-21 20:17:15.266543 | 2025-08-21 20:17:15.266682 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-21 20:17:15.308956 | debian-bookworm | ok 2025-08-21 20:17:15.320270 | 2025-08-21 20:17:15.320381 | TASK [emit-job-header : Print job information] 2025-08-21 20:17:15.359918 | # Job Information 2025-08-21 20:17:15.360096 | Ansible Version: 2.16.14 2025-08-21 20:17:15.360144 | Job: metalbox-mirror-debian-packages 2025-08-21 20:17:15.360178 | Pipeline: check 2025-08-21 20:17:15.360201 | Executor: 521e9411259a 2025-08-21 20:17:15.360221 | Triggered by: https://github.com/osism/metalbox/pull/189 2025-08-21 20:17:15.360245 | Event ID: cbbe90d0-7ecb-11f0-9977-4a43aee62395 2025-08-21 20:17:15.365233 | 2025-08-21 20:17:15.365341 | LOOP [emit-job-header : Print node information] 2025-08-21 20:17:15.474002 | debian-bookworm | ok: 2025-08-21 20:17:15.474295 | debian-bookworm | # Node Information 2025-08-21 20:17:15.474335 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-21 20:17:15.474361 | debian-bookworm | Hostname: debian 2025-08-21 20:17:15.474383 | debian-bookworm | Username: zuul 2025-08-21 20:17:15.474403 | debian-bookworm | Distro: Debian 12.11 2025-08-21 20:17:15.474427 | debian-bookworm | Provider: regiocloud-a 2025-08-21 20:17:15.474448 | debian-bookworm | Region: 2025-08-21 20:17:15.474469 | debian-bookworm | Label: debian-bookworm 2025-08-21 20:17:15.474489 | debian-bookworm | Product Name: OpenStack Nova 2025-08-21 20:17:15.474509 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef0:25ed 2025-08-21 20:17:15.493065 | 2025-08-21 20:17:15.493219 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-21 20:17:15.969436 | debian-bookworm -> localhost | changed 2025-08-21 20:17:15.976777 | 2025-08-21 20:17:15.976902 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-21 20:17:17.007264 | debian-bookworm -> localhost | changed 2025-08-21 20:17:17.018448 | 2025-08-21 20:17:17.018586 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-21 20:17:17.309371 | debian-bookworm -> localhost | ok 2025-08-21 20:17:17.315598 | 2025-08-21 20:17:17.315713 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-21 20:17:17.344666 | debian-bookworm | ok 2025-08-21 20:17:17.364084 | debian-bookworm | included: /var/lib/zuul/builds/99fb0f6faa47445491266e6b9b5b5d87/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-21 20:17:17.370248 | 2025-08-21 20:17:17.370350 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-21 20:17:18.326084 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-21 20:17:18.326324 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/99fb0f6faa47445491266e6b9b5b5d87/work/99fb0f6faa47445491266e6b9b5b5d87_id_rsa 2025-08-21 20:17:18.326365 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/99fb0f6faa47445491266e6b9b5b5d87/work/99fb0f6faa47445491266e6b9b5b5d87_id_rsa.pub 2025-08-21 20:17:18.326392 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-21 20:17:18.326416 | debian-bookworm -> localhost | SHA256:CqsOkgQi1QKaYJ76mVbIDG9kOP3FGuhoo9nKtw/QoFM zuul-build-sshkey 2025-08-21 20:17:18.326438 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-21 20:17:18.326472 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-21 20:17:18.326495 | debian-bookworm -> localhost | |oo.. | 2025-08-21 20:17:18.326518 | debian-bookworm -> localhost | |==o... | 2025-08-21 20:17:18.326539 | debian-bookworm -> localhost | |X+E.. o | 2025-08-21 20:17:18.326560 | debian-bookworm -> localhost | |*%oo + | 2025-08-21 20:17:18.326580 | debian-bookworm -> localhost | |==B.= S | 2025-08-21 20:17:18.326608 | debian-bookworm -> localhost | |+Bo+ o . | 2025-08-21 20:17:18.326629 | debian-bookworm -> localhost | |* *.. . | 2025-08-21 20:17:18.326649 | debian-bookworm -> localhost | |o+ o. | 2025-08-21 20:17:18.326671 | debian-bookworm -> localhost | |.o+.o. | 2025-08-21 20:17:18.326692 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-21 20:17:18.326741 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.434192 2025-08-21 20:17:18.333308 | 2025-08-21 20:17:18.333421 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-21 20:17:18.351955 | debian-bookworm | ok 2025-08-21 20:17:18.361311 | debian-bookworm | included: /var/lib/zuul/builds/99fb0f6faa47445491266e6b9b5b5d87/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-21 20:17:18.370881 | 2025-08-21 20:17:18.370981 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-21 20:17:18.383980 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:17:18.389590 | 2025-08-21 20:17:18.389690 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-21 20:17:18.988659 | debian-bookworm | changed 2025-08-21 20:17:18.994115 | 2025-08-21 20:17:18.994258 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-21 20:17:19.254210 | debian-bookworm | ok 2025-08-21 20:17:19.263032 | 2025-08-21 20:17:19.263239 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-21 20:17:19.927939 | debian-bookworm | changed 2025-08-21 20:17:19.938718 | 2025-08-21 20:17:19.938884 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-21 20:17:20.598015 | debian-bookworm | changed 2025-08-21 20:17:20.606287 | 2025-08-21 20:17:20.606410 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-21 20:17:20.630169 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:17:20.636436 | 2025-08-21 20:17:20.636544 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-21 20:17:21.105540 | debian-bookworm -> localhost | changed 2025-08-21 20:17:21.117289 | 2025-08-21 20:17:21.117423 | TASK [add-build-sshkey : Add back temp key] 2025-08-21 20:17:21.446065 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/99fb0f6faa47445491266e6b9b5b5d87/work/99fb0f6faa47445491266e6b9b5b5d87_id_rsa (zuul-build-sshkey) 2025-08-21 20:17:21.446405 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012108 2025-08-21 20:17:21.455249 | 2025-08-21 20:17:21.455368 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-21 20:17:21.865064 | debian-bookworm | ok 2025-08-21 20:17:21.872815 | 2025-08-21 20:17:21.872953 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-21 20:17:21.896979 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:17:21.908018 | 2025-08-21 20:17:21.908167 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-21 20:17:22.348735 | debian-bookworm | ok 2025-08-21 20:17:22.363728 | 2025-08-21 20:17:22.363850 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-21 20:17:22.403928 | debian-bookworm | ok 2025-08-21 20:17:22.409078 | 2025-08-21 20:17:22.409229 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-21 20:17:22.696287 | debian-bookworm -> localhost | ok 2025-08-21 20:17:22.706934 | 2025-08-21 20:17:22.707069 | TASK [validate-host : Collect information about the host] 2025-08-21 20:17:23.797919 | debian-bookworm | ok 2025-08-21 20:17:23.813266 | 2025-08-21 20:17:23.813396 | TASK [validate-host : Sanitize hostname] 2025-08-21 20:17:23.927301 | debian-bookworm | ok 2025-08-21 20:17:23.963780 | 2025-08-21 20:17:23.963899 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-21 20:17:24.535097 | debian-bookworm -> localhost | changed 2025-08-21 20:17:24.540921 | 2025-08-21 20:17:24.541036 | TASK [validate-host : Collect information about zuul worker] 2025-08-21 20:17:24.979393 | debian-bookworm | ok 2025-08-21 20:17:24.986629 | 2025-08-21 20:17:24.986780 | TASK [validate-host : Write out all zuul information for each host] 2025-08-21 20:17:25.516394 | debian-bookworm -> localhost | changed 2025-08-21 20:17:25.526300 | 2025-08-21 20:17:25.526409 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-21 20:17:25.807387 | debian-bookworm | ok 2025-08-21 20:17:25.813208 | 2025-08-21 20:17:25.813322 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-21 20:17:26.621589 | debian-bookworm | changed: 2025-08-21 20:17:26.621798 | debian-bookworm | cd+++++++++ src/ 2025-08-21 20:17:26.621835 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-21 20:17:26.621860 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-21 20:17:26.621884 | debian-bookworm | cd+++++++++ src/github.com/osism/metalbox/ 2025-08-21 20:17:26.621906 | 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% 28% 29% 30% 31% 32% 33% 34% 35% 36% 38% 39% 40% 41% 42% 43% 44% 45% 46% 47% 48% 49% 50% 51% 52% 53% 54% 56% 57% 58% 59% 60% 61% 62% 63% 64% 65% 66% 67% 68% 69% 70% 71% 73% 74% 75% 76% 77% 78% 79% 80% 81% 82% 83% 84% 85% 86% 87% 88% 90% 91% 92% 93% 94% 95% 96% 97% 99%100%200 OK (1s) 2025-08-21 20:18:23.325068 | debian-bookworm | ok 2025-08-21 20:18:23.465291 | debian-bookworm | [ 0%] Getting: dists/jammy/InRelease... #** GET http://archive.ubuntu.com/ubuntu/dists/jammy/InRelease ==> 0% 2% 3% 4% 6% 7% 8% 9% 10% 12% 14% 15% 17% 18% 20% 21% 22% 23% 25% 26% 28% 29% 31% 33% 34% 36% 37% 39% 41% 42% 44% 45% 47% 48% 49% 50% 52% 53% 55% 56% 58% 60% 61% 63% 64% 66% 67% 68% 69% 71% 72% 74% 75% 77% 79% 80% 82% 83% 85% 87% 88% 90% 91% 93% 94% 95% 96% 98% 99%100%200 OK 2025-08-21 20:18:23.465487 | debian-bookworm | ok 2025-08-21 20:18:23.547611 | 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:18:23.547815 | debian-bookworm | ok 2025-08-21 20:18:23.566328 | debian-bookworm | No packages after parsing Packages and Sources files! 2025-08-21 20:18:23.569464 | debian-bookworm | WARNING: releasing 1 pending lock... 2025-08-21 20:18:23.569791 | debian-bookworm | Ubuntu Release file: using Suite (jammy). 2025-08-21 20:18:23.569809 | debian-bookworm | Parsing Packages and Sources files ... 2025-08-21 20:18:23.578795 | debian-bookworm | SUCCESS: Successfully mirrored packages from archive.ubuntu.com/ubuntu jammy 2025-08-21 20:18:23.581598 | debian-bookworm | Processing repository: archive.ubuntu.com/ubuntu jammy-updates 2025-08-21 20:18:23.583739 | debian-bookworm | Components: main,universe,restricted,multiverse 2025-08-21 20:18:23.585795 | debian-bookworm | Architecture: amd64 2025-08-21 20:18:23.589891 | debian-bookworm | Running debmirror for archive.ubuntu.com/ubuntu... 2025-08-21 20:18:23.781037 | debian-bookworm | Mirroring to src/github.com/osism/metalbox/zuul/files/mirror/jammy-updates from http://archive.ubuntu.com/ubuntu/ 2025-08-21 20:18:23.781119 | debian-bookworm | Arches: amd64 2025-08-21 20:18:23.781134 | debian-bookworm | Dists: jammy-updates 2025-08-21 20:18:23.781146 | debian-bookworm | Sections: main universe restricted multiverse 2025-08-21 20:18:23.781157 | debian-bookworm | Including source. 2025-08-21 20:18:23.781167 | debian-bookworm | Pdiff mode: none 2025-08-21 20:18:23.781178 | debian-bookworm | Not checking Release gpg signatures. 2025-08-21 20:18:23.781250 | debian-bookworm | Will clean up before mirroring. 2025-08-21 20:18:23.798299 | debian-bookworm | Attempting to get lock ... 2025-08-21 20:18:23.798366 | debian-bookworm | Updating remote trace files (using rsync) ... 2025-08-21 20:18:24.048187 | debian-bookworm | This is an Ubuntu mirror - treat it kindly 2025-08-21 20:18:24.048271 | debian-bookworm | 2025-08-21 20:18:24.489632 | debian-bookworm | receiving incremental file list 2025-08-21 20:18:24.768797 | debian-bookworm | ./ 2025-08-21 20:18:24.847931 | debian-bookworm | project/ 2025-08-21 20:18:24.848116 | debian-bookworm | project/trace/ 2025-08-21 20:18:24.848439 | debian-bookworm | project/trace/anonster.canonical.com 2025-08-21 20:18:24.848698 | 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:18:24.849114 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0 2025-08-21 20:18:24.849353 | 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:18:24.849660 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.dists-timestamps 2025-08-21 20:18:25.163875 | 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:18:25.164347 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan 2025-08-21 20:18:25.164537 | 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:18:25.164812 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan.dists-timestamps 2025-08-21 20:18:25.235783 | 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:18:25.236244 | debian-bookworm | project/trace/juju-4112d9-prod-launchpad-manual-servers-29.None 2025-08-21 20:18:25.236450 | 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:18:25.236648 | debian-bookworm | project/trace/juju-98d295-prod-launchpad-22 2025-08-21 20:18:25.236769 | 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:18:25.517365 | debian-bookworm | 2025-08-21 20:18:25.518703 | debian-bookworm | sent 264 bytes received 575,942 bytes 230,482.40 bytes/sec 2025-08-21 20:18:25.518742 | debian-bookworm | total size is 574,979 speedup is 1.00 2025-08-21 20:18:25.541372 | debian-bookworm | Getting meta files ... 2025-08-21 20:18:33.297265 | 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% 31% 33% 36% 38% 40% 42% 45% 47% 49% 51% 54% 56% 58% 60% 63% 65% 67% 69% 72% 74% 76% 78% 81% 83% 85% 87% 90% 92% 94% 96% 99%100%200 OK (8s) 2025-08-21 20:18:33.297776 | debian-bookworm | ok 2025-08-21 20:18:33.437092 | debian-bookworm | [ 0%] Getting: dists/jammy-updates/InRelease... #** GET http://archive.ubuntu.com/ubuntu/dists/jammy-updates/InRelease ==> 1% 4% 6% 9% 11% 13% 15% 18% 20% 22% 24% 27% 29% 31% 33% 35% 38% 40% 42% 44% 47% 49% 51% 53% 56% 57% 59% 61% 63% 66% 68% 70% 72% 74% 77% 79% 81% 83% 86% 88% 90% 92% 95% 97% 99%100%200 OK 2025-08-21 20:18:33.437548 | debian-bookworm | ok 2025-08-21 20:18:33.519821 | 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:18:33.520190 | debian-bookworm | ok 2025-08-21 20:18:33.533679 | debian-bookworm | No packages after parsing Packages and Sources files! 2025-08-21 20:18:33.538806 | debian-bookworm | WARNING: releasing 1 pending lock... 2025-08-21 20:18:33.539275 | debian-bookworm | Ubuntu Release file: using Suite (jammy-updates). 2025-08-21 20:18:33.539307 | debian-bookworm | Parsing Packages and Sources files ... 2025-08-21 20:18:33.548636 | debian-bookworm | SUCCESS: Successfully mirrored packages from archive.ubuntu.com/ubuntu jammy-updates 2025-08-21 20:18:33.553477 | debian-bookworm | Processing repository: archive.ubuntu.com/ubuntu jammy-security 2025-08-21 20:18:33.555798 | debian-bookworm | Components: main,universe,restricted,multiverse 2025-08-21 20:18:33.559343 | debian-bookworm | Architecture: amd64 2025-08-21 20:18:33.564841 | debian-bookworm | Running debmirror for archive.ubuntu.com/ubuntu... 2025-08-21 20:18:33.758875 | debian-bookworm | Mirroring to src/github.com/osism/metalbox/zuul/files/mirror/jammy-security from http://archive.ubuntu.com/ubuntu/ 2025-08-21 20:18:33.758935 | debian-bookworm | Arches: amd64 2025-08-21 20:18:33.758941 | debian-bookworm | Dists: jammy-security 2025-08-21 20:18:33.758946 | debian-bookworm | Sections: main universe restricted multiverse 2025-08-21 20:18:33.758951 | debian-bookworm | Including source. 2025-08-21 20:18:33.758956 | debian-bookworm | Pdiff mode: none 2025-08-21 20:18:33.758960 | debian-bookworm | Not checking Release gpg signatures. 2025-08-21 20:18:33.758964 | debian-bookworm | Will clean up before mirroring. 2025-08-21 20:18:33.778994 | debian-bookworm | Attempting to get lock ... 2025-08-21 20:18:33.779040 | debian-bookworm | Updating remote trace files (using rsync) ... 2025-08-21 20:18:35.059720 | debian-bookworm | This is an Ubuntu mirror - treat it kindly 2025-08-21 20:18:35.059798 | debian-bookworm | 2025-08-21 20:18:35.499632 | debian-bookworm | receiving incremental file list 2025-08-21 20:18:35.781165 | debian-bookworm | ./ 2025-08-21 20:18:35.860542 | debian-bookworm | project/ 2025-08-21 20:18:35.860629 | debian-bookworm | project/trace/ 2025-08-21 20:18:35.860925 | debian-bookworm | project/trace/anonster.canonical.com 2025-08-21 20:18:35.861165 | 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:18:35.861688 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0 2025-08-21 20:18:35.861787 | 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:18:35.861956 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.dists-timestamps 2025-08-21 20:18:36.176940 | 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:18:36.177354 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan 2025-08-21 20:18:36.177544 | 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:18:36.177757 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan.dists-timestamps 2025-08-21 20:18:36.248711 | 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:18:36.249011 | debian-bookworm | project/trace/juju-4112d9-prod-launchpad-manual-servers-29.None 2025-08-21 20:18:36.249099 | 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:18:36.249364 | debian-bookworm | project/trace/juju-98d295-prod-launchpad-22 2025-08-21 20:18:36.249412 | 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:18:36.529056 | debian-bookworm | 2025-08-21 20:18:36.529147 | debian-bookworm | sent 264 bytes received 575,942 bytes 164,630.29 bytes/sec 2025-08-21 20:18:36.529161 | debian-bookworm | total size is 574,979 speedup is 1.00 2025-08-21 20:18:36.552194 | debian-bookworm | Getting meta files ... 2025-08-21 20:18:37.014349 | 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% 30% 32% 34% 37% 39% 41% 43% 45% 48% 50% 52% 54% 57% 59% 61% 63% 66% 68% 70% 72% 74% 77% 79% 81% 83% 86% 88% 90% 92% 95% 97% 99%100%200 OK (1s) 2025-08-21 20:18:37.014886 | debian-bookworm | ok 2025-08-21 20:18:37.153675 | 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 2025-08-21 20:18:37.154135 | debian-bookworm | ok 2025-08-21 20:18:37.237273 | 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:18:37.238048 | debian-bookworm | ok 2025-08-21 20:18:37.249146 | debian-bookworm | No packages after parsing Packages and Sources files! 2025-08-21 20:18:37.253081 | debian-bookworm | WARNING: releasing 1 pending lock... 2025-08-21 20:18:37.253583 | debian-bookworm | Ubuntu Release file: using Suite (jammy-security). 2025-08-21 20:18:37.253607 | debian-bookworm | Parsing Packages and Sources files ... 2025-08-21 20:18:37.264371 | debian-bookworm | SUCCESS: Successfully mirrored packages from archive.ubuntu.com/ubuntu jammy-security 2025-08-21 20:18:37.266855 | debian-bookworm | Processing repository: security.ubuntu.com/ubuntu jammy-security 2025-08-21 20:18:37.268766 | debian-bookworm | Components: main,universe,restricted,multiverse 2025-08-21 20:18:37.270596 | debian-bookworm | Architecture: amd64 2025-08-21 20:18:37.274274 | debian-bookworm | Running debmirror for security.ubuntu.com/ubuntu... 2025-08-21 20:18:37.470353 | debian-bookworm | Mirroring to src/github.com/osism/metalbox/zuul/files/mirror/jammy-security from http://security.ubuntu.com/ubuntu/ 2025-08-21 20:18:37.470503 | debian-bookworm | Arches: amd64 2025-08-21 20:18:37.470512 | debian-bookworm | Dists: jammy-security 2025-08-21 20:18:37.470533 | debian-bookworm | Sections: main universe restricted multiverse 2025-08-21 20:18:37.470540 | debian-bookworm | Including source. 2025-08-21 20:18:37.470544 | debian-bookworm | Pdiff mode: none 2025-08-21 20:18:37.470549 | debian-bookworm | Not checking Release gpg signatures. 2025-08-21 20:18:37.470553 | debian-bookworm | Will clean up before mirroring. 2025-08-21 20:18:37.489453 | debian-bookworm | Attempting to get lock ... 2025-08-21 20:18:37.489508 | debian-bookworm | Updating remote trace files (using rsync) ... 2025-08-21 20:18:37.580583 | debian-bookworm | This is an Ubuntu mirror - treat it kindly 2025-08-21 20:18:37.580687 | debian-bookworm | 2025-08-21 20:18:37.706239 | debian-bookworm | receiving incremental file list 2025-08-21 20:18:37.798922 | debian-bookworm | ./ 2025-08-21 20:18:37.802671 | debian-bookworm | project/trace/anonster.canonical.com 2025-08-21 20:18:37.802909 | 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:18:37.803553 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0 2025-08-21 20:18:37.803658 | 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:18:37.804007 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.dists-timestamps 2025-08-21 20:18:37.815508 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 306,920 100% 24.39MB/s 0:00:00 (xfr#3, to-chk=4/10) 2025-08-21 20:18:37.816041 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan 2025-08-21 20:18:37.816224 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 2.18kB/s 0:00:00 (xfr#4, to-chk=3/10) 2025-08-21 20:18:37.816587 | debian-bookworm | project/trace/juju-2afd81-prod-ubuntu-syncproxy-0.openstack.prodstack5.lan.dists-timestamps 2025-08-21 20:18:37.831219 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 267,914 100% 9.13MB/s 0:00:00 (xfr#5, to-chk=2/10) 2025-08-21 20:18:37.831743 | debian-bookworm | project/trace/juju-4112d9-prod-launchpad-manual-servers-29.None 2025-08-21 20:18:37.831847 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 0.98kB/s 0:00:00 (xfr#6, to-chk=1/10) 2025-08-21 20:18:37.832183 | debian-bookworm | project/trace/juju-98d295-prod-launchpad-22 2025-08-21 20:18:37.832275 | debian-bookworm | 0 0% 0.00kB/s 0:00:00 29 100% 0.98kB/s 0:00:00 (xfr#7, to-chk=0/10) 2025-08-21 20:18:37.921793 | debian-bookworm | 2025-08-21 20:18:37.921926 | debian-bookworm | sent 5,220 bytes received 4,041 bytes 18,522.00 bytes/sec 2025-08-21 20:18:37.921943 | debian-bookworm | total size is 574,979 speedup is 62.09 2025-08-21 20:18:37.944683 | debian-bookworm | Getting meta files ... 2025-08-21 20:18:38.062868 | 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% 30% 32% 33% 35% 38% 40% 42% 44% 47% 49% 51% 53% 54% 57% 59% 61% 63% 66% 68% 70% 72% 74% 77% 79% 82% 85% 86% 89% 92% 95% 96% 99%100%200 OK (1s) 2025-08-21 20:18:38.063272 | debian-bookworm | ok 2025-08-21 20:18:38.093132 | debian-bookworm | [ 0%] Getting: dists/jammy-security/InRelease... #** GET http://security.ubuntu.com/ubuntu/dists/jammy-security/InRelease ==> 1% 4% 7% 10% 13% 16% 19% 22% 25% 26% 30% 33% 34% 36% 39% 42% 45% 48% 50% 53% 56% 57% 58% 62% 65% 68% 71% 73% 76% 79% 81% 84% 87% 90% 92% 93% 96% 99%100%200 OK 2025-08-21 20:18:38.093557 | debian-bookworm | ok 2025-08-21 20:18:38.112529 | debian-bookworm | [ 0%] Getting: dists/jammy-security/Release.gpg... #** GET http://security.ubuntu.com/ubuntu/dists/jammy-security/Release.gpg ==> 82%100%200 OK 2025-08-21 20:18:38.112810 | debian-bookworm | ok 2025-08-21 20:18:38.124700 | debian-bookworm | No packages after parsing Packages and Sources files! 2025-08-21 20:18:38.129748 | debian-bookworm | WARNING: releasing 1 pending lock... 2025-08-21 20:18:38.130250 | debian-bookworm | Ubuntu Release file: using Suite (jammy-security). 2025-08-21 20:18:38.130271 | debian-bookworm | Parsing Packages and Sources files ... 2025-08-21 20:18:38.141882 | debian-bookworm | SUCCESS: Successfully mirrored packages from security.ubuntu.com/ubuntu jammy-security 2025-08-21 20:18:38.145501 | debian-bookworm | Mirroring completed 2025-08-21 20:18:38.148962 | debian-bookworm | Successfully processed repositories: 4/4 2025-08-21 20:18:38.151735 | debian-bookworm | Creating unified repository structure... 2025-08-21 20:18:38.160850 | debian-bookworm | Organizing packages into unified structure... 2025-08-21 20:18:38.246555 | debian-bookworm | dpkg-scanpackages: info: Wrote 0 entries to output Packages file. 2025-08-21 20:18:38.259313 | debian-bookworm | tee: src/github.com/osism/metalbox/zuul/files/mirror.log: No such file or directory 2025-08-21 20:18:38.259353 | debian-bookworm | SUCCESS: Unified repository created at: src/github.com/osism/metalbox/zuul/files/mirror/repository 2025-08-21 20:18:38.262597 | debian-bookworm | tee: src/github.com/osism/metalbox/zuul/files/mirror.log: No such file or directory 2025-08-21 20:18:38.262614 | debian-bookworm | Cleaning up temporary files... 2025-08-21 20:18:38.729371 | debian-bookworm | ERROR 2025-08-21 20:18:38.729809 | debian-bookworm | { 2025-08-21 20:18:38.729913 | debian-bookworm | "delta": "0:00:26.404722", 2025-08-21 20:18:38.729984 | debian-bookworm | "end": "2025-08-21 20:18:38.263764", 2025-08-21 20:18:38.730045 | debian-bookworm | "msg": "non-zero return code", 2025-08-21 20:18:38.730100 | debian-bookworm | "rc": 1, 2025-08-21 20:18:38.730183 | debian-bookworm | "start": "2025-08-21 20:18:11.859042" 2025-08-21 20:18:38.730237 | debian-bookworm | } failure 2025-08-21 20:18:38.742406 | 2025-08-21 20:18:38.742752 | PLAY RECAP 2025-08-21 20:18:38.742958 | debian-bookworm | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-08-21 20:18:38.743029 | 2025-08-21 20:18:38.875073 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/metalbox/zuul/mirror-debian-packages.yml@main] 2025-08-21 20:18:38.877183 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-21 20:18:39.593455 | 2025-08-21 20:18:39.593614 | PLAY [Base post] 2025-08-21 20:18:39.607430 | 2025-08-21 20:18:39.607557 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-21 20:18:40.404797 | debian-bookworm | changed 2025-08-21 20:18:40.413682 | 2025-08-21 20:18:40.413804 | PLAY RECAP 2025-08-21 20:18:40.413878 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-21 20:18:40.413953 | 2025-08-21 20:18:40.525807 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-21 20:18:40.527261 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-21 20:18:41.317628 | 2025-08-21 20:18:41.317790 | PLAY [Base post-logs] 2025-08-21 20:18:41.328190 | 2025-08-21 20:18:41.328321 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-21 20:18:41.779679 | localhost | changed 2025-08-21 20:18:41.789471 | 2025-08-21 20:18:41.789616 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-21 20:18:41.827196 | localhost | ok 2025-08-21 20:18:41.833975 | 2025-08-21 20:18:41.834204 | TASK [Set zuul-log-path fact] 2025-08-21 20:18:41.852220 | localhost | ok 2025-08-21 20:18:41.864205 | 2025-08-21 20:18:41.864332 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-21 20:18:41.892088 | localhost | ok 2025-08-21 20:18:41.901469 | 2025-08-21 20:18:41.901843 | TASK [upload-logs : Create log directories] 2025-08-21 20:18:42.423958 | localhost | changed 2025-08-21 20:18:42.428704 | 2025-08-21 20:18:42.428857 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-21 20:18:42.931269 | localhost -> localhost | ok: Runtime: 0:00:00.006698 2025-08-21 20:18:42.935319 | 2025-08-21 20:18:42.935436 | TASK [upload-logs : Upload logs to log server] 2025-08-21 20:18:43.488465 | localhost | Output suppressed because no_log was given 2025-08-21 20:18:43.491513 | 2025-08-21 20:18:43.491653 | LOOP [upload-logs : Compress console log and json output] 2025-08-21 20:18:43.545894 | localhost | skipping: Conditional result was False 2025-08-21 20:18:43.550749 | localhost | skipping: Conditional result was False 2025-08-21 20:18:43.561203 | 2025-08-21 20:18:43.561392 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-21 20:18:43.605847 | localhost | skipping: Conditional result was False 2025-08-21 20:18:43.606477 | 2025-08-21 20:18:43.610029 | localhost | skipping: Conditional result was False 2025-08-21 20:18:43.622709 | 2025-08-21 20:18:43.623013 | LOOP [upload-logs : Upload console log and json output]