2025-08-21 20:27:46.223733 | Job console starting 2025-08-21 20:27:46.245803 | Updating git repos 2025-08-21 20:27:46.276109 | Cloning repos into workspace 2025-08-21 20:27:46.335946 | Restoring repo states 2025-08-21 20:27:46.349052 | Merging changes 2025-08-21 20:27:46.922625 | Checking out repos 2025-08-21 20:27:46.973275 | Preparing playbooks 2025-08-21 20:27:47.620508 | Running Ansible setup 2025-08-21 20:27:51.688296 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-21 20:27:52.434368 | 2025-08-21 20:27:52.434531 | PLAY [Base pre] 2025-08-21 20:27:52.450468 | 2025-08-21 20:27:52.450617 | TASK [Setup log path fact] 2025-08-21 20:27:52.480437 | debian-bookworm | ok 2025-08-21 20:27:52.495290 | 2025-08-21 20:27:52.495422 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-21 20:27:52.537649 | debian-bookworm | ok 2025-08-21 20:27:52.548960 | 2025-08-21 20:27:52.549093 | TASK [emit-job-header : Print job information] 2025-08-21 20:27:52.604767 | # Job Information 2025-08-21 20:27:52.605040 | Ansible Version: 2.16.14 2025-08-21 20:27:52.605123 | Job: metalbox-mirror-debian-packages 2025-08-21 20:27:52.605181 | Pipeline: check 2025-08-21 20:27:52.605221 | Executor: 521e9411259a 2025-08-21 20:27:52.605257 | Triggered by: https://github.com/osism/metalbox/pull/189 2025-08-21 20:27:52.605296 | Event ID: 482587e0-7ecd-11f0-8d3b-9d4abeff8be6 2025-08-21 20:27:52.612750 | 2025-08-21 20:27:52.612891 | LOOP [emit-job-header : Print node information] 2025-08-21 20:27:52.735181 | debian-bookworm | ok: 2025-08-21 20:27:52.735469 | debian-bookworm | # Node Information 2025-08-21 20:27:52.735529 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-21 20:27:52.735573 | debian-bookworm | Hostname: debian 2025-08-21 20:27:52.735610 | debian-bookworm | Username: zuul 2025-08-21 20:27:52.735645 | debian-bookworm | Distro: Debian 12.11 2025-08-21 20:27:52.735684 | debian-bookworm | Provider: regiocloud-a 2025-08-21 20:27:52.735719 | debian-bookworm | Region: 2025-08-21 20:27:52.735753 | debian-bookworm | Label: debian-bookworm 2025-08-21 20:27:52.735786 | debian-bookworm | Product Name: OpenStack Nova 2025-08-21 20:27:52.735817 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea9:fb42 2025-08-21 20:27:52.756510 | 2025-08-21 20:27:52.756666 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-21 20:27:53.235846 | debian-bookworm -> localhost | changed 2025-08-21 20:27:53.243240 | 2025-08-21 20:27:53.243371 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-21 20:27:54.251424 | debian-bookworm -> localhost | changed 2025-08-21 20:27:54.267015 | 2025-08-21 20:27:54.267273 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-21 20:27:54.533763 | debian-bookworm -> localhost | ok 2025-08-21 20:27:54.540105 | 2025-08-21 20:27:54.540233 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-21 20:27:54.560097 | debian-bookworm | ok 2025-08-21 20:27:54.579939 | debian-bookworm | included: /var/lib/zuul/builds/06386f00912b4a6fadae3e890ca34f56/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-21 20:27:54.586033 | 2025-08-21 20:27:54.586191 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-21 20:27:55.612209 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-21 20:27:55.612478 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/06386f00912b4a6fadae3e890ca34f56/work/06386f00912b4a6fadae3e890ca34f56_id_rsa 2025-08-21 20:27:55.612516 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/06386f00912b4a6fadae3e890ca34f56/work/06386f00912b4a6fadae3e890ca34f56_id_rsa.pub 2025-08-21 20:27:55.612542 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-21 20:27:55.612566 | debian-bookworm -> localhost | SHA256:aGlf4fTLEMSMbKOy/Aj2kKMAFbkB84rjiTV8h1VXZYI zuul-build-sshkey 2025-08-21 20:27:55.612659 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-21 20:27:55.612696 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-21 20:27:55.612719 | debian-bookworm -> localhost | |o..o ..+ooo.o | 2025-08-21 20:27:55.612741 | debian-bookworm -> localhost | | o+ .=oE o | 2025-08-21 20:27:55.612761 | debian-bookworm -> localhost | | ..o .o .+ | 2025-08-21 20:27:55.612781 | debian-bookworm -> localhost | |oo. .o.o o + | 2025-08-21 20:27:55.612801 | debian-bookworm -> localhost | |= +ooo* S + . | 2025-08-21 20:27:55.612826 | debian-bookworm -> localhost | |+oBoo+ . . o . | 2025-08-21 20:27:55.612847 | debian-bookworm -> localhost | |o= = o . o | 2025-08-21 20:27:55.612867 | debian-bookworm -> localhost | |. o . | 2025-08-21 20:27:55.612888 | debian-bookworm -> localhost | | | 2025-08-21 20:27:55.612909 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-21 20:27:55.612962 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.551746 2025-08-21 20:27:55.623008 | 2025-08-21 20:27:55.623147 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-21 20:27:55.643973 | debian-bookworm | ok 2025-08-21 20:27:55.657456 | debian-bookworm | included: /var/lib/zuul/builds/06386f00912b4a6fadae3e890ca34f56/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-21 20:27:55.669207 | 2025-08-21 20:27:55.669306 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-21 20:27:55.693110 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:27:55.699179 | 2025-08-21 20:27:55.699294 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-21 20:27:56.321546 | debian-bookworm | changed 2025-08-21 20:27:56.330418 | 2025-08-21 20:27:56.330556 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-21 20:27:56.602173 | debian-bookworm | ok 2025-08-21 20:27:56.614605 | 2025-08-21 20:27:56.614801 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-21 20:27:57.287161 | debian-bookworm | changed 2025-08-21 20:27:57.294155 | 2025-08-21 20:27:57.294267 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-21 20:27:57.973128 | debian-bookworm | changed 2025-08-21 20:27:57.983337 | 2025-08-21 20:27:57.983483 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-21 20:27:58.018559 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:27:58.028719 | 2025-08-21 20:27:58.028849 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-21 20:27:58.469776 | debian-bookworm -> localhost | changed 2025-08-21 20:27:58.491071 | 2025-08-21 20:27:58.491220 | TASK [add-build-sshkey : Add back temp key] 2025-08-21 20:27:58.856904 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/06386f00912b4a6fadae3e890ca34f56/work/06386f00912b4a6fadae3e890ca34f56_id_rsa (zuul-build-sshkey) 2025-08-21 20:27:58.857154 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013711 2025-08-21 20:27:58.865050 | 2025-08-21 20:27:58.865203 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-21 20:27:59.282900 | debian-bookworm | ok 2025-08-21 20:27:59.291118 | 2025-08-21 20:27:59.291282 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-21 20:27:59.315596 | debian-bookworm | skipping: Conditional result was False 2025-08-21 20:27:59.326119 | 2025-08-21 20:27:59.326236 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-21 20:27:59.757045 | debian-bookworm | ok 2025-08-21 20:27:59.772261 | 2025-08-21 20:27:59.772407 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-21 20:27:59.815204 | debian-bookworm | ok 2025-08-21 20:27:59.820474 | 2025-08-21 20:27:59.820582 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-21 20:28:00.108612 | debian-bookworm -> localhost | ok 2025-08-21 20:28:00.119086 | 2025-08-21 20:28:00.119224 | TASK [validate-host : Collect information about the host] 2025-08-21 20:28:01.235796 | debian-bookworm | ok 2025-08-21 20:28:01.247041 | 2025-08-21 20:28:01.247188 | TASK [validate-host : Sanitize hostname] 2025-08-21 20:28:01.353966 | debian-bookworm | ok 2025-08-21 20:28:01.395550 | 2025-08-21 20:28:01.395683 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-21 20:28:01.955188 | debian-bookworm -> localhost | changed 2025-08-21 20:28:01.961361 | 2025-08-21 20:28:01.961483 | TASK [validate-host : Collect information about zuul worker] 2025-08-21 20:28:02.384745 | debian-bookworm | ok 2025-08-21 20:28:02.389506 | 2025-08-21 20:28:02.389615 | TASK [validate-host : Write out all zuul information for each host] 2025-08-21 20:28:02.909898 | debian-bookworm -> localhost | changed 2025-08-21 20:28:02.929039 | 2025-08-21 20:28:02.929228 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-21 20:28:03.201725 | debian-bookworm | ok 2025-08-21 20:28:03.207579 | 2025-08-21 20:28:03.207687 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-21 20:28:04.035523 | debian-bookworm | changed: 2025-08-21 20:28:04.035736 | debian-bookworm | cd+++++++++ src/ 2025-08-21 20:28:04.035773 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-21 20:28:04.035798 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-21 20:28:04.035820 | debian-bookworm | cd+++++++++ src/github.com/osism/metalbox/ 2025-08-21 20:28:04.035842 | debian-bookworm | 2025-08-21 20:28:48.643536 | debian-bookworm | 2025-08-21 20:28:48.643578 | debian-bookworm | For details, see man page. 2025-08-21 20:28:48.650411 | debian-bookworm | SUCCESS: Successfully mirrored packages from archive.ubuntu.com/ubuntu jammy 2025-08-21 20:28:48.653148 | debian-bookworm | Processing repository: archive.ubuntu.com/ubuntu jammy-updates 2025-08-21 20:28:48.654970 | debian-bookworm | Components: main,universe,restricted,multiverse 2025-08-21 20:28:48.656396 | debian-bookworm | Architecture: amd64 2025-08-21 20:28:48.660523 | debian-bookworm | Running debmirror for archive.ubuntu.com/ubuntu... 2025-08-21 20:28:48.871909 | debian-bookworm | Unknown option: include-deb 2025-08-21 20:28:48.872137 | debian-bookworm | Usage: /usr/bin/debmirror [options] 2025-08-21 20:28:48.872153 | debian-bookworm | 2025-08-21 20:28:48.872161 | debian-bookworm | For details, see man page. 2025-08-21 20:28:48.877294 | debian-bookworm | SUCCESS: Successfully mirrored packages from archive.ubuntu.com/ubuntu jammy-updates 2025-08-21 20:28:48.878956 | debian-bookworm | Processing repository: archive.ubuntu.com/ubuntu jammy-security 2025-08-21 20:28:48.880394 | debian-bookworm | Components: main,universe,restricted,multiverse 2025-08-21 20:28:48.881773 | debian-bookworm | Architecture: amd64 2025-08-21 20:28:48.884839 | debian-bookworm | Running debmirror for archive.ubuntu.com/ubuntu... 2025-08-21 20:28:49.078274 | debian-bookworm | Unknown option: include-deb 2025-08-21 20:28:49.078386 | debian-bookworm | Usage: /usr/bin/debmirror [options] 2025-08-21 20:28:49.078403 | debian-bookworm | 2025-08-21 20:28:49.078415 | debian-bookworm | For details, see man page. 2025-08-21 20:28:49.084044 | debian-bookworm | SUCCESS: Successfully mirrored packages from archive.ubuntu.com/ubuntu jammy-security 2025-08-21 20:28:49.087455 | debian-bookworm | Processing repository: security.ubuntu.com/ubuntu jammy-security 2025-08-21 20:28:49.089271 | debian-bookworm | Components: main,universe,restricted,multiverse 2025-08-21 20:28:49.090971 | debian-bookworm | Architecture: amd64 2025-08-21 20:28:49.094492 | debian-bookworm | Running debmirror for security.ubuntu.com/ubuntu... 2025-08-21 20:28:49.293489 | debian-bookworm | Unknown option: include-deb 2025-08-21 20:28:49.293610 | debian-bookworm | Usage: /usr/bin/debmirror [options] 2025-08-21 20:28:49.293626 | debian-bookworm | 2025-08-21 20:28:49.293638 | debian-bookworm | For details, see man page. 2025-08-21 20:28:49.298964 | debian-bookworm | SUCCESS: Successfully mirrored packages from security.ubuntu.com/ubuntu jammy-security 2025-08-21 20:28:49.300976 | debian-bookworm | Mirroring completed 2025-08-21 20:28:49.302541 | debian-bookworm | Successfully processed repositories: 4/4 2025-08-21 20:28:49.306120 | debian-bookworm | Creating unified repository structure... 2025-08-21 20:28:49.317346 | debian-bookworm | Organizing packages into unified structure... 2025-08-21 20:28:49.415064 | debian-bookworm | dpkg-scanpackages: info: Wrote 0 entries to output Packages file. 2025-08-21 20:28:49.424665 | debian-bookworm | SUCCESS: Unified repository created at: src/github.com/osism/metalbox/zuul/files/mirror/repository 2025-08-21 20:28:49.426186 | debian-bookworm | Cleaning up temporary files... 2025-08-21 20:28:49.429082 | debian-bookworm | SUCCESS: Cleanup completed 2025-08-21 20:28:49.430279 | debian-bookworm | SUCCESS: Mirror creation completed successfully! 2025-08-21 20:28:49.431892 | debian-bookworm | Mirror location: src/github.com/osism/metalbox/zuul/files/mirror/repository 2025-08-21 20:28:49.433412 | debian-bookworm | Log file: src/github.com/osism/metalbox/zuul/files/mirror.log 2025-08-21 20:28:49.436351 | debian-bookworm | Thu Aug 21 20:28:49 UTC 2025: Script execution finished 2025-08-21 20:28:49.437914 | debian-bookworm | Cleaning up temporary files... 2025-08-21 20:28:49.442614 | debian-bookworm | SUCCESS: Cleanup completed 2025-08-21 20:28:49.677174 | debian-bookworm | ok: Runtime: 0:00:01.125934 2025-08-21 20:28:49.683587 | 2025-08-21 20:28:49.683749 | PLAY RECAP 2025-08-21 20:28:49.683864 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-21 20:28:49.683922 | 2025-08-21 20:28:49.808871 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/metalbox/zuul/mirror-debian-packages.yml@main] 2025-08-21 20:28:49.811356 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-21 20:28:50.552357 | 2025-08-21 20:28:50.552527 | PLAY [Base post] 2025-08-21 20:28:50.566142 | 2025-08-21 20:28:50.566287 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-21 20:28:51.354984 | debian-bookworm | changed 2025-08-21 20:28:51.365630 | 2025-08-21 20:28:51.365765 | PLAY RECAP 2025-08-21 20:28:51.365848 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-21 20:28:51.365927 | 2025-08-21 20:28:51.500228 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-21 20:28:51.502293 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-21 20:28:52.349890 | 2025-08-21 20:28:52.350109 | PLAY [Base post-logs] 2025-08-21 20:28:52.361979 | 2025-08-21 20:28:52.362146 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-21 20:28:52.825736 | localhost | changed 2025-08-21 20:28:52.835733 | 2025-08-21 20:28:52.835876 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-21 20:28:52.861874 | localhost | ok 2025-08-21 20:28:52.864941 | 2025-08-21 20:28:52.865037 | TASK [Set zuul-log-path fact] 2025-08-21 20:28:52.879632 | localhost | ok 2025-08-21 20:28:52.887500 | 2025-08-21 20:28:52.887605 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-21 20:28:52.911953 | localhost | ok 2025-08-21 20:28:52.915337 | 2025-08-21 20:28:52.915475 | TASK [upload-logs : Create log directories] 2025-08-21 20:28:53.397526 | localhost | changed 2025-08-21 20:28:53.400366 | 2025-08-21 20:28:53.400470 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-21 20:28:53.879930 | localhost -> localhost | ok: Runtime: 0:00:00.008194 2025-08-21 20:28:53.884000 | 2025-08-21 20:28:53.884137 | TASK [upload-logs : Upload logs to log server] 2025-08-21 20:28:54.412411 | localhost | Output suppressed because no_log was given 2025-08-21 20:28:54.415411 | 2025-08-21 20:28:54.415557 | LOOP [upload-logs : Compress console log and json output] 2025-08-21 20:28:54.472349 | localhost | skipping: Conditional result was False 2025-08-21 20:28:54.477397 | localhost | skipping: Conditional result was False 2025-08-21 20:28:54.490301 | 2025-08-21 20:28:54.490558 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-21 20:28:54.535720 | localhost | skipping: Conditional result was False 2025-08-21 20:28:54.536330 | 2025-08-21 20:28:54.539654 | localhost | skipping: Conditional result was False 2025-08-21 20:28:54.553242 | 2025-08-21 20:28:54.553489 | LOOP [upload-logs : Upload console log and json output]