2025-09-26 16:19:19.851030 | Job console starting 2025-09-26 16:19:19.875890 | Updating git repos 2025-09-26 16:19:19.894425 | Cloning repos into workspace 2025-09-26 16:19:19.944462 | Restoring repo states 2025-09-26 16:19:19.953392 | Merging changes 2025-09-26 16:19:20.431026 | Checking out repos 2025-09-26 16:19:20.471354 | Preparing playbooks 2025-09-26 16:19:21.142720 | Running Ansible setup 2025-09-26 16:19:25.275506 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-26 16:19:26.021696 | 2025-09-26 16:19:26.021855 | PLAY [Base pre] 2025-09-26 16:19:26.038710 | 2025-09-26 16:19:26.038870 | TASK [Setup log path fact] 2025-09-26 16:19:26.064937 | debian-bookworm | ok 2025-09-26 16:19:26.079865 | 2025-09-26 16:19:26.080010 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-26 16:19:26.122950 | debian-bookworm | ok 2025-09-26 16:19:26.136106 | 2025-09-26 16:19:26.136221 | TASK [emit-job-header : Print job information] 2025-09-26 16:19:26.201020 | # Job Information 2025-09-26 16:19:26.201282 | Ansible Version: 2.16.14 2025-09-26 16:19:26.201345 | Job: deb-packaging-build-qemu 2025-09-26 16:19:26.201404 | Pipeline: check 2025-09-26 16:19:26.201447 | Executor: 521e9411259a 2025-09-26 16:19:26.201533 | Triggered by: https://github.com/osism/deb-packaging/pull/33 2025-09-26 16:19:26.201578 | Event ID: 89cd3470-9af4-11f0-9c11-d8ba7b245c81 2025-09-26 16:19:26.208457 | 2025-09-26 16:19:26.208608 | LOOP [emit-job-header : Print node information] 2025-09-26 16:19:26.318909 | debian-bookworm | ok: 2025-09-26 16:19:26.319121 | debian-bookworm | # Node Information 2025-09-26 16:19:26.319167 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-26 16:19:26.319365 | debian-bookworm | Hostname: debian 2025-09-26 16:19:26.319401 | debian-bookworm | Username: zuul 2025-09-26 16:19:26.319425 | debian-bookworm | Distro: Debian 12.12 2025-09-26 16:19:26.319468 | debian-bookworm | Provider: regiocloud-a 2025-09-26 16:19:26.319634 | debian-bookworm | Region: 2025-09-26 16:19:26.319664 | debian-bookworm | Label: debian-bookworm 2025-09-26 16:19:26.319688 | debian-bookworm | Product Name: OpenStack Nova 2025-09-26 16:19:26.319710 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe69:bbbd 2025-09-26 16:19:26.341068 | 2025-09-26 16:19:26.341219 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-26 16:19:26.793001 | debian-bookworm -> localhost | changed 2025-09-26 16:19:26.800461 | 2025-09-26 16:19:26.800598 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-26 16:19:27.795949 | debian-bookworm -> localhost | changed 2025-09-26 16:19:27.812055 | 2025-09-26 16:19:27.812196 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-26 16:19:28.090320 | debian-bookworm -> localhost | ok 2025-09-26 16:19:28.098536 | 2025-09-26 16:19:28.098666 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-26 16:19:28.130810 | debian-bookworm | ok 2025-09-26 16:19:28.149851 | debian-bookworm | included: /var/lib/zuul/builds/8179dcd478ec46dba947655d9ca77ba4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-26 16:19:28.156262 | 2025-09-26 16:19:28.156369 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-26 16:19:29.220897 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-26 16:19:29.221403 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8179dcd478ec46dba947655d9ca77ba4/work/8179dcd478ec46dba947655d9ca77ba4_id_rsa 2025-09-26 16:19:29.221544 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8179dcd478ec46dba947655d9ca77ba4/work/8179dcd478ec46dba947655d9ca77ba4_id_rsa.pub 2025-09-26 16:19:29.221626 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-26 16:19:29.221700 | debian-bookworm -> localhost | SHA256:Ipf4NNKB2jqVwT+lt1gsksnT1U0g+AyoOL+EWE1P1Gc zuul-build-sshkey 2025-09-26 16:19:29.221766 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-26 16:19:29.221854 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-26 16:19:29.221917 | debian-bookworm -> localhost | | o.o. ... | 2025-09-26 16:19:29.221980 | debian-bookworm -> localhost | | .o.+ .oEo | 2025-09-26 16:19:29.222037 | debian-bookworm -> localhost | | . ++o.+oo. . | 2025-09-26 16:19:29.222092 | debian-bookworm -> localhost | |o o+.X.Bo | 2025-09-26 16:19:29.222149 | debian-bookworm -> localhost | |.=. & & S | 2025-09-26 16:19:29.222213 | debian-bookworm -> localhost | |o oo O O . | 2025-09-26 16:19:29.222270 | debian-bookworm -> localhost | | .o. o . | 2025-09-26 16:19:29.222327 | debian-bookworm -> localhost | | .. | 2025-09-26 16:19:29.222385 | debian-bookworm -> localhost | | | 2025-09-26 16:19:29.222442 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-26 16:19:29.222604 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.570723 2025-09-26 16:19:29.237884 | 2025-09-26 16:19:29.238032 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-26 16:19:29.273558 | debian-bookworm | ok 2025-09-26 16:19:29.286976 | debian-bookworm | included: /var/lib/zuul/builds/8179dcd478ec46dba947655d9ca77ba4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-26 16:19:29.297462 | 2025-09-26 16:19:29.297574 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-26 16:19:29.321634 | debian-bookworm | skipping: Conditional result was False 2025-09-26 16:19:29.328079 | 2025-09-26 16:19:29.328184 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-26 16:19:29.959107 | debian-bookworm | changed 2025-09-26 16:19:29.964831 | 2025-09-26 16:19:29.964935 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-26 16:19:30.235958 | debian-bookworm | ok 2025-09-26 16:19:30.245847 | 2025-09-26 16:19:30.245996 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-26 16:19:30.930082 | debian-bookworm | changed 2025-09-26 16:19:30.941774 | 2025-09-26 16:19:30.941938 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-26 16:19:31.597826 | debian-bookworm | changed 2025-09-26 16:19:31.605615 | 2025-09-26 16:19:31.605742 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-26 16:19:31.640095 | debian-bookworm | skipping: Conditional result was False 2025-09-26 16:19:31.651495 | 2025-09-26 16:19:31.651643 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-26 16:19:32.153301 | debian-bookworm -> localhost | changed 2025-09-26 16:19:32.164440 | 2025-09-26 16:19:32.164599 | TASK [add-build-sshkey : Add back temp key] 2025-09-26 16:19:32.498646 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8179dcd478ec46dba947655d9ca77ba4/work/8179dcd478ec46dba947655d9ca77ba4_id_rsa (zuul-build-sshkey) 2025-09-26 16:19:32.498948 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015831 2025-09-26 16:19:32.508136 | 2025-09-26 16:19:32.508248 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-26 16:19:32.920775 | debian-bookworm | ok 2025-09-26 16:19:32.929256 | 2025-09-26 16:19:32.929389 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-26 16:19:32.954418 | debian-bookworm | skipping: Conditional result was False 2025-09-26 16:19:32.970899 | 2025-09-26 16:19:32.971020 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-26 16:19:33.406649 | debian-bookworm | ok 2025-09-26 16:19:33.418907 | 2025-09-26 16:19:33.419027 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-26 16:19:33.449304 | debian-bookworm | ok 2025-09-26 16:19:33.454390 | 2025-09-26 16:19:33.454511 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-26 16:19:33.733732 | debian-bookworm -> localhost | ok 2025-09-26 16:19:33.741552 | 2025-09-26 16:19:33.741709 | TASK [validate-host : Collect information about the host] 2025-09-26 16:19:34.877189 | debian-bookworm | ok 2025-09-26 16:19:34.905036 | 2025-09-26 16:19:34.905207 | TASK [validate-host : Sanitize hostname] 2025-09-26 16:19:35.035153 | debian-bookworm | ok 2025-09-26 16:19:35.077632 | 2025-09-26 16:19:35.077771 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-26 16:19:35.675255 | debian-bookworm -> localhost | changed 2025-09-26 16:19:35.681748 | 2025-09-26 16:19:35.681861 | TASK [validate-host : Collect information about zuul worker] 2025-09-26 16:19:36.100643 | debian-bookworm | ok 2025-09-26 16:19:36.106959 | 2025-09-26 16:19:36.107090 | TASK [validate-host : Write out all zuul information for each host] 2025-09-26 16:19:36.668593 | debian-bookworm -> localhost | changed 2025-09-26 16:19:36.678757 | 2025-09-26 16:19:36.678926 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-26 16:19:36.951739 | debian-bookworm | ok 2025-09-26 16:19:36.965920 | 2025-09-26 16:19:36.966042 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-26 16:19:37.801226 | debian-bookworm | changed: 2025-09-26 16:19:37.801498 | debian-bookworm | cd+++++++++ src/ 2025-09-26 16:19:37.801552 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-26 16:19:37.801586 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-26 16:19:37.801617 | debian-bookworm | cd+++++++++ src/github.com/osism/deb-packaging/ 2025-09-26 16:19:37.801646 | debian-bookworm | Containerfile 2025-09-26 16:19:37.808451 | debian-bookworm | cd+++++++++ src/github.com/osism/deb-packaging/files/ovs/ 2025-09-26 16:19:37.808473 | debian-bookworm | Containerfile 2025-09-26 16:19:37.808553 | debian-bookworm | cd+++++++++ src/github.com/osism/deb-packaging/files/ovs/files/ 2025-09-26 16:19:37.808575 | debian-bookworm | Containerfile 2025-09-26 16:19:37.808661 | debian-bookworm | cd+++++++++ src/github.com/osism/deb-packaging/playbooks/ 2025-09-26 16:19:37.808681 | debian-bookworm | [builder 8/11] RUN cd qemu*/: 2025-09-26 16:22:14.757627 | debian-bookworm | 0.337 /bin/sh: 1: cd: can't cd to qemu*/ 2025-09-26 16:22:14.757637 | debian-bookworm | ------ 2025-09-26 16:22:14.758928 | debian-bookworm | Containerfile:10 2025-09-26 16:22:14.758962 | debian-bookworm | -------------------- 2025-09-26 16:22:14.758993 | debian-bookworm | 8 | RUN tar xf "qemu_8.2.2+ds-0ubuntu1.10.debian.tar.xz" 2025-09-26 16:22:14.759017 | debian-bookworm | 9 | RUN ls -la 2025-09-26 16:22:14.759040 | debian-bookworm | 10 | >>> RUN cd qemu*/ 2025-09-26 16:22:14.759062 | debian-bookworm | 11 | RUN yes | mk-build-deps --install --remove 2025-09-26 16:22:14.759085 | debian-bookworm | 12 | RUN dch --bpo 2025-09-26 16:22:14.759106 | debian-bookworm | -------------------- 2025-09-26 16:22:14.759137 | debian-bookworm | ERROR: failed to build: failed to solve: process "/bin/sh -c cd qemu*/" did not complete successfully: exit code: 2 2025-09-26 16:22:15.041377 | debian-bookworm | ERROR 2025-09-26 16:22:15.041888 | debian-bookworm | { 2025-09-26 16:22:15.041983 | debian-bookworm | "delta": "0:01:55.170570", 2025-09-26 16:22:15.042035 | debian-bookworm | "end": "2025-09-26 16:22:14.764651", 2025-09-26 16:22:15.042078 | debian-bookworm | "msg": "non-zero return code", 2025-09-26 16:22:15.042119 | debian-bookworm | "rc": 1, 2025-09-26 16:22:15.042159 | debian-bookworm | "start": "2025-09-26 16:20:19.594081" 2025-09-26 16:22:15.042202 | debian-bookworm | } failure 2025-09-26 16:22:15.082612 | 2025-09-26 16:22:15.082724 | PLAY RECAP 2025-09-26 16:22:15.082793 | debian-bookworm | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-26 16:22:15.082821 | 2025-09-26 16:22:15.206930 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/deb-packaging/playbooks/build-qemu.yml@main] 2025-09-26 16:22:15.207877 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-26 16:22:15.945448 | 2025-09-26 16:22:15.946113 | PLAY [Base post] 2025-09-26 16:22:15.959882 | 2025-09-26 16:22:15.960003 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-26 16:22:16.770989 | debian-bookworm | changed 2025-09-26 16:22:16.781489 | 2025-09-26 16:22:16.781625 | PLAY RECAP 2025-09-26 16:22:16.781711 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-26 16:22:16.781798 | 2025-09-26 16:22:16.903123 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-26 16:22:16.904133 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-26 16:22:17.664804 | 2025-09-26 16:22:17.664970 | PLAY [Base post-logs] 2025-09-26 16:22:17.675602 | 2025-09-26 16:22:17.675739 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-26 16:22:18.117477 | localhost | changed 2025-09-26 16:22:18.127743 | 2025-09-26 16:22:18.127885 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-26 16:22:18.166357 | localhost | ok 2025-09-26 16:22:18.173426 | 2025-09-26 16:22:18.173707 | TASK [Set zuul-log-path fact] 2025-09-26 16:22:18.192828 | localhost | ok 2025-09-26 16:22:18.205633 | 2025-09-26 16:22:18.205763 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-26 16:22:18.233304 | localhost | ok 2025-09-26 16:22:18.238426 | 2025-09-26 16:22:18.238631 | TASK [upload-logs : Create log directories] 2025-09-26 16:22:18.748565 | localhost | changed 2025-09-26 16:22:18.754805 | 2025-09-26 16:22:18.755022 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-26 16:22:19.248425 | localhost -> localhost | ok: Runtime: 0:00:00.004752 2025-09-26 16:22:19.254905 | 2025-09-26 16:22:19.255055 | TASK [upload-logs : Upload logs to log server] 2025-09-26 16:22:19.822545 | localhost | Output suppressed because no_log was given 2025-09-26 16:22:19.827054 | 2025-09-26 16:22:19.827267 | LOOP [upload-logs : Compress console log and json output] 2025-09-26 16:22:19.882191 | localhost | skipping: Conditional result was False 2025-09-26 16:22:19.887008 | localhost | skipping: Conditional result was False 2025-09-26 16:22:19.900674 | 2025-09-26 16:22:19.900926 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-26 16:22:19.946210 | localhost | skipping: Conditional result was False 2025-09-26 16:22:19.946933 | 2025-09-26 16:22:19.950137 | localhost | skipping: Conditional result was False 2025-09-26 16:22:19.965010 | 2025-09-26 16:22:19.965343 | LOOP [upload-logs : Upload console log and json output]