2026-02-11 03:06:17.956400 | Job console starting 2026-02-11 03:06:17.996046 | Updating git repos 2026-02-11 03:06:18.021960 | Cloning repos into workspace 2026-02-11 03:06:18.118735 | Restoring repo states 2026-02-11 03:06:18.126332 | Merging changes 2026-02-11 03:06:18.126351 | Checking out repos 2026-02-11 03:06:18.241911 | Preparing playbooks 2026-02-11 03:06:19.184640 | Running Ansible setup 2026-02-11 03:06:25.593728 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-11 03:06:27.282433 | 2026-02-11 03:06:27.282606 | PLAY [Base pre] 2026-02-11 03:06:27.301513 | 2026-02-11 03:06:27.301751 | TASK [Setup log path fact] 2026-02-11 03:06:27.322299 | ubuntu-noble-large | ok 2026-02-11 03:06:27.342969 | 2026-02-11 03:06:27.343157 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-11 03:06:27.373931 | ubuntu-noble-large | ok 2026-02-11 03:06:27.387253 | 2026-02-11 03:06:27.388862 | TASK [emit-job-header : Print job information] 2026-02-11 03:06:27.507527 | # Job Information 2026-02-11 03:06:27.507951 | Ansible Version: 2.16.14 2026-02-11 03:06:27.508019 | Job: openstack-ironic-images-publish-metalbox 2026-02-11 03:06:27.508061 | Pipeline: periodic-daily 2026-02-11 03:06:27.508094 | Executor: 521e9411259a 2026-02-11 03:06:27.508115 | Triggered by: https://github.com/osism/openstack-ironic-images 2026-02-11 03:06:27.508251 | Event ID: 110011ba8a3240a39716f0fb376d9277 2026-02-11 03:06:27.523443 | 2026-02-11 03:06:27.523589 | LOOP [emit-job-header : Print node information] 2026-02-11 03:06:27.733764 | ubuntu-noble-large | ok: 2026-02-11 03:06:27.733994 | ubuntu-noble-large | # Node Information 2026-02-11 03:06:27.734029 | ubuntu-noble-large | Inventory Hostname: ubuntu-noble-large 2026-02-11 03:06:27.734055 | ubuntu-noble-large | Hostname: ubuntu 2026-02-11 03:06:27.734078 | ubuntu-noble-large | Username: zuul 2026-02-11 03:06:27.734099 | ubuntu-noble-large | Distro: Ubuntu 24.04 2026-02-11 03:06:27.734123 | ubuntu-noble-large | Provider: regiocloud-a 2026-02-11 03:06:27.734144 | ubuntu-noble-large | Region: 2026-02-11 03:06:27.734165 | ubuntu-noble-large | Label: ubuntu-noble-large 2026-02-11 03:06:27.734185 | ubuntu-noble-large | Product Name: OpenStack Nova 2026-02-11 03:06:27.734204 | ubuntu-noble-large | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedf:b0f4 2026-02-11 03:06:27.757745 | 2026-02-11 03:06:27.757968 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-11 03:06:28.603415 | ubuntu-noble-large -> localhost | changed 2026-02-11 03:06:28.610466 | 2026-02-11 03:06:28.610570 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-11 03:06:29.941239 | ubuntu-noble-large -> localhost | changed 2026-02-11 03:06:29.956178 | 2026-02-11 03:06:29.956310 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-11 03:06:30.349684 | ubuntu-noble-large -> localhost | ok 2026-02-11 03:06:30.356929 | 2026-02-11 03:06:30.357052 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-11 03:06:30.377384 | ubuntu-noble-large | ok 2026-02-11 03:06:30.393008 | ubuntu-noble-large | included: /var/lib/zuul/builds/b4b96b1d94c74afb9bcf4a130804ec9d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-11 03:06:30.399899 | 2026-02-11 03:06:30.399988 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-11 03:06:31.381511 | ubuntu-noble-large -> localhost | Generating public/private rsa key pair. 2026-02-11 03:06:31.381735 | ubuntu-noble-large -> localhost | Your identification has been saved in /var/lib/zuul/builds/b4b96b1d94c74afb9bcf4a130804ec9d/work/b4b96b1d94c74afb9bcf4a130804ec9d_id_rsa 2026-02-11 03:06:31.381768 | ubuntu-noble-large -> localhost | Your public key has been saved in /var/lib/zuul/builds/b4b96b1d94c74afb9bcf4a130804ec9d/work/b4b96b1d94c74afb9bcf4a130804ec9d_id_rsa.pub 2026-02-11 03:06:31.381790 | ubuntu-noble-large -> localhost | The key fingerprint is: 2026-02-11 03:06:31.381811 | ubuntu-noble-large -> localhost | SHA256:6Nn/KR6lWJ1vtOsnUUGVM6q0lAX1j0Vvv0gzQgyrgpI zuul-build-sshkey 2026-02-11 03:06:31.381839 | ubuntu-noble-large -> localhost | The key's randomart image is: 2026-02-11 03:06:31.381858 | ubuntu-noble-large -> localhost | +---[RSA 3072]----+ 2026-02-11 03:06:31.381876 | ubuntu-noble-large -> localhost | | . .o...=| 2026-02-11 03:06:31.381894 | ubuntu-noble-large -> localhost | | + ..*.| 2026-02-11 03:06:31.381910 | ubuntu-noble-large -> localhost | | . oo ..B| 2026-02-11 03:06:31.381926 | ubuntu-noble-large -> localhost | | . . .. .= o ++| 2026-02-11 03:06:31.381943 | ubuntu-noble-large -> localhost | | E . ...S +.*+o.o| 2026-02-11 03:06:31.381964 | ubuntu-noble-large -> localhost | | . ..o o =oo=..| 2026-02-11 03:06:31.381981 | ubuntu-noble-large -> localhost | | o o o .+o | 2026-02-11 03:06:31.381997 | ubuntu-noble-large -> localhost | | ... o...| 2026-02-11 03:06:31.382014 | ubuntu-noble-large -> localhost | | .ooo.oo | 2026-02-11 03:06:31.382030 | ubuntu-noble-large -> localhost | +----[SHA256]-----+ 2026-02-11 03:06:31.382075 | ubuntu-noble-large -> localhost | ok: Runtime: 0:00:00.534949 2026-02-11 03:06:31.387807 | 2026-02-11 03:06:31.387895 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-11 03:06:31.407230 | ubuntu-noble-large | ok 2026-02-11 03:06:31.414937 | ubuntu-noble-large | included: /var/lib/zuul/builds/b4b96b1d94c74afb9bcf4a130804ec9d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-11 03:06:31.428050 | 2026-02-11 03:06:31.428123 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-11 03:06:31.440737 | ubuntu-noble-large | skipping: Conditional result was False 2026-02-11 03:06:31.445441 | 2026-02-11 03:06:31.445513 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-11 03:06:32.208546 | ubuntu-noble-large | changed 2026-02-11 03:06:32.216007 | 2026-02-11 03:06:32.216118 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-11 03:06:32.535504 | ubuntu-noble-large | ok 2026-02-11 03:06:32.546355 | 2026-02-11 03:06:32.546490 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-11 03:06:33.292698 | ubuntu-noble-large | changed 2026-02-11 03:06:33.297870 | 2026-02-11 03:06:33.297953 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-11 03:06:34.028192 | ubuntu-noble-large | changed 2026-02-11 03:06:34.037103 | 2026-02-11 03:06:34.037208 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-11 03:06:34.073943 | ubuntu-noble-large | skipping: Conditional result was False 2026-02-11 03:06:34.082688 | 2026-02-11 03:06:34.082789 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-11 03:06:34.702133 | ubuntu-noble-large -> localhost | changed 2026-02-11 03:06:34.716895 | 2026-02-11 03:06:34.717187 | TASK [add-build-sshkey : Add back temp key] 2026-02-11 03:06:35.188180 | ubuntu-noble-large -> localhost | Identity added: /var/lib/zuul/builds/b4b96b1d94c74afb9bcf4a130804ec9d/work/b4b96b1d94c74afb9bcf4a130804ec9d_id_rsa (zuul-build-sshkey) 2026-02-11 03:06:35.188407 | ubuntu-noble-large -> localhost | ok: Runtime: 0:00:00.009406 2026-02-11 03:06:35.196597 | 2026-02-11 03:06:35.196711 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-11 03:06:35.616551 | ubuntu-noble-large | ok 2026-02-11 03:06:35.621808 | 2026-02-11 03:06:35.621902 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-11 03:06:35.653535 | ubuntu-noble-large | skipping: Conditional result was False 2026-02-11 03:06:35.666527 | 2026-02-11 03:06:35.666641 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-11 03:06:36.115053 | ubuntu-noble-large | ok 2026-02-11 03:06:36.126014 | 2026-02-11 03:06:36.126117 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-11 03:06:36.174572 | ubuntu-noble-large | ok 2026-02-11 03:06:36.179837 | 2026-02-11 03:06:36.179929 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-11 03:06:36.455400 | ubuntu-noble-large -> localhost | ok 2026-02-11 03:06:36.462172 | 2026-02-11 03:06:36.462271 | TASK [validate-host : Collect information about the host] 2026-02-11 03:06:37.721622 | ubuntu-noble-large | ok 2026-02-11 03:06:37.734444 | 2026-02-11 03:06:37.734557 | TASK [validate-host : Sanitize hostname] 2026-02-11 03:06:37.838563 | ubuntu-noble-large | ok 2026-02-11 03:06:37.843129 | 2026-02-11 03:06:37.843213 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-11 03:06:38.283105 | ubuntu-noble-large -> localhost | changed 2026-02-11 03:06:38.287743 | 2026-02-11 03:06:38.287818 | TASK [validate-host : Collect information about zuul worker] 2026-02-11 03:06:38.763477 | ubuntu-noble-large | ok 2026-02-11 03:06:38.768350 | 2026-02-11 03:06:38.768441 | TASK [validate-host : Write out all zuul information for each host] 2026-02-11 03:06:39.310089 | ubuntu-noble-large -> localhost | changed 2026-02-11 03:06:39.319442 | 2026-02-11 03:06:39.319538 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-11 03:06:39.639683 | ubuntu-noble-large | ok 2026-02-11 03:06:39.645343 | 2026-02-11 03:06:39.645437 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-11 03:06:40.697981 | ubuntu-noble-large | changed: 2026-02-11 03:06:40.698323 | ubuntu-noble-large | cd+++++++++ src/ 2026-02-11 03:06:40.698366 | ubuntu-noble-large | cd+++++++++ src/github.com/ 2026-02-11 03:06:40.698391 | ubuntu-noble-large | cd+++++++++ src/github.com/osism/ 2026-02-11 03:06:40.698420 | ubuntu-noble-large | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-02-11 03:06:40.698453 | ubuntu-noble-large | 2026-02-11 03:27:20.228900 | ubuntu-noble-large | from diskimage_builder.disk_image_create import main 2026-02-11 03:27:20.228923 | ubuntu-noble-large | File "/tmp/venv/lib/python3.12/site-packages/diskimage_builder/disk_image_create.py", line 19, in 2026-02-11 03:27:20.228934 | ubuntu-noble-large | import diskimage_builder.paths 2026-02-11 03:27:20.228944 | ubuntu-noble-large | File "/tmp/venv/lib/python3.12/site-packages/diskimage_builder/paths.py", line 18, in 2026-02-11 03:27:20.228955 | ubuntu-noble-large | import pkg_resources 2026-02-11 03:27:20.228965 | ubuntu-noble-large | ModuleNotFoundError: No module named 'pkg_resources' 2026-02-11 03:27:20.423614 | ubuntu-noble-large | ERROR 2026-02-11 03:27:20.424028 | ubuntu-noble-large | { 2026-02-11 03:27:20.424132 | ubuntu-noble-large | "delta": "0:00:00.042131", 2026-02-11 03:27:20.424238 | ubuntu-noble-large | "end": "2026-02-11 03:27:20.233132", 2026-02-11 03:27:20.424344 | ubuntu-noble-large | "msg": "non-zero return code", 2026-02-11 03:27:20.424425 | ubuntu-noble-large | "rc": 1, 2026-02-11 03:27:20.424482 | ubuntu-noble-large | "start": "2026-02-11 03:27:20.191001" 2026-02-11 03:27:20.424601 | ubuntu-noble-large | } failure 2026-02-11 03:27:20.430130 | 2026-02-11 03:27:20.430285 | PLAY RECAP 2026-02-11 03:27:20.430405 | ubuntu-noble-large | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-11 03:27:20.430465 | 2026-02-11 03:27:20.535717 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openstack-ironic-images/playbooks/build.yml@main] 2026-02-11 03:27:20.538123 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-11 03:27:21.189460 | 2026-02-11 03:27:21.189605 | PLAY [Base post] 2026-02-11 03:27:21.203192 | 2026-02-11 03:27:21.203316 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-11 03:27:21.771055 | ubuntu-noble-large | changed 2026-02-11 03:27:21.782095 | 2026-02-11 03:27:21.782244 | PLAY RECAP 2026-02-11 03:27:21.782324 | ubuntu-noble-large | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-11 03:27:21.782406 | 2026-02-11 03:27:21.916865 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-11 03:27:21.923119 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-11 03:27:22.743497 | 2026-02-11 03:27:22.743691 | PLAY [Base post-logs] 2026-02-11 03:27:22.754757 | 2026-02-11 03:27:22.754929 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-11 03:27:23.216254 | localhost | changed 2026-02-11 03:27:23.233288 | 2026-02-11 03:27:23.233468 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-11 03:27:23.262138 | localhost | ok 2026-02-11 03:27:23.268856 | 2026-02-11 03:27:23.269055 | TASK [Set zuul-log-path fact] 2026-02-11 03:27:23.285802 | localhost | ok 2026-02-11 03:27:23.296025 | 2026-02-11 03:27:23.296148 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-11 03:27:23.324123 | localhost | ok 2026-02-11 03:27:23.331587 | 2026-02-11 03:27:23.331812 | TASK [upload-logs : Create log directories] 2026-02-11 03:27:23.853143 | localhost | changed 2026-02-11 03:27:23.857525 | 2026-02-11 03:27:23.857758 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-11 03:27:24.372073 | localhost -> localhost | ok: Runtime: 0:00:00.008210 2026-02-11 03:27:24.380858 | 2026-02-11 03:27:24.381033 | TASK [upload-logs : Upload logs to log server] 2026-02-11 03:27:24.963295 | localhost | Output suppressed because no_log was given 2026-02-11 03:27:24.965218 | 2026-02-11 03:27:24.965323 | LOOP [upload-logs : Compress console log and json output] 2026-02-11 03:27:25.018679 | localhost | skipping: Conditional result was False 2026-02-11 03:27:25.023906 | localhost | skipping: Conditional result was False 2026-02-11 03:27:25.035397 | 2026-02-11 03:27:25.035621 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-11 03:27:25.095315 | localhost | skipping: Conditional result was False 2026-02-11 03:27:25.095773 | 2026-02-11 03:27:25.100011 | localhost | skipping: Conditional result was False 2026-02-11 03:27:25.113642 | 2026-02-11 03:27:25.113894 | LOOP [upload-logs : Upload console log and json output]