Skip to content
Failed

Console Output

Skipping 264 KB.. Full Log
18:11:34 [2025-10-30T18:11:34.159Z] Copying blob sha256:76e593ba6793fd0f61001957f47c80c3864a640d012b86fe78d7dc2bb230d4c5
18:11:34 [2025-10-30T18:11:34.415Z] Copying blob sha256:a8b529790aad69655807c41d884661b01ef39b38dd7a01e658dccd9395370a73
18:11:34 [2025-10-30T18:11:34.668Z] Copying blob sha256:e90fc7705f5e4a1667e308982ed7b9187755809c80eb361040d9e35a7b416fe3
18:11:35 [2025-10-30T18:11:35.228Z] Copying blob sha256:743621d81bf3043fe57611beff18807078441c7d970ca34a401f0ae05a15d81a
18:11:35 [2025-10-30T18:11:35.228Z] Copying blob sha256:e10ff4e68bd70e187deeb65edd323af3c0be0f4381844070cfa4e3f75bb71a97
18:11:35 [2025-10-30T18:11:35.786Z] Copying blob sha256:869f199bebc7836b07558fbdda9aeca1f32b05747c579c94c2baecc4e0d3c04d
18:11:35 [2025-10-30T18:11:35.786Z] Copying blob sha256:54af5d32a654efe747687ec0856fa0aa796b2d9f72f002dc9b4c5ca2f13bced0
18:11:36 [2025-10-30T18:11:36.040Z] Copying blob sha256:293d63066f936407ae34e65dfe5acf083d5ea875638e896125cd667017a5dee2
18:11:36 [2025-10-30T18:11:36.040Z] Copying blob sha256:cb68dee97b811bbc0fb053844a02e296d710cff5c8553960681a341b26561a91
18:11:36 [2025-10-30T18:11:36.297Z] Copying blob sha256:21b43e7aac50a844f401b7f85a86f74c06ba76b7ce581e4c9837392505975fe2
18:11:36 [2025-10-30T18:11:36.551Z] Copying blob sha256:d7db03dae7f9f257a3886604941f1d03d1b535fcedd65237d7f3fdb6c0a8f83b
18:11:36 [2025-10-30T18:11:36.551Z] Copying blob sha256:b81fc429f28d690517dd2de599dd7c699079b81d673e4bbe405bd37c99279cfe
18:11:36 [2025-10-30T18:11:36.804Z] Copying blob sha256:114e200dd2d395bc50c68d987a22cf5a746332a242429424d6b7460e5260123e
18:11:36 [2025-10-30T18:11:36.805Z] Copying blob sha256:6ccaf7a27e17e9b1246cb792d91e1ffa85c737e3ba16335c08f8843a59693f14
18:11:37 [2025-10-30T18:11:37.059Z] Copying blob sha256:6f7825e005c56a194eb230daefa445d366e303e315581caa4d74644be5d5c464
18:11:37 [2025-10-30T18:11:37.316Z] Copying blob sha256:693ab731a657a16a801872eab79b65e4d85dc5dfd1bba530d986781a948f5763
18:11:37 [2025-10-30T18:11:37.316Z] Copying blob sha256:3d9f6201fb9e11d5a762c0f4c83aa60720459d06beed51c5fc2bd5506374d78d
18:11:37 [2025-10-30T18:11:37.569Z] Copying blob sha256:1bcef82236a034d6e02759ae04d2d1a6c9f2325ae5869467129b86cd08576829
18:11:37 [2025-10-30T18:11:37.569Z] Copying blob sha256:a2ad9af9127bc15a20fffd54c82f95e441c2463ccc3ee43701c7df6db2a3a643
18:11:37 [2025-10-30T18:11:37.824Z] Copying blob sha256:aa53bac224ddd07d0b9d426076c25d349a1c13af24f15c7d7e507fb3257dbb17
18:11:38 [2025-10-30T18:11:38.079Z] Copying blob sha256:e745a6b0102c291f87767986134286b21ed3d12175b539c5c4e12502aabd2c3a
18:11:38 [2025-10-30T18:11:38.079Z] Copying blob sha256:9ae8f8e36722f6517287bfd40f2d2a9a41cd744c8bae737cdcbbe88837bbaa08
18:11:38 [2025-10-30T18:11:38.333Z] Copying blob sha256:ee36178b40cb16918af085b0118b63574e790473ef5234f932ed80a133b366b7
18:11:38 [2025-10-30T18:11:38.333Z] Copying blob sha256:cb547f4da77aa0018768094d727f99821d6321c0fce70a5720111aec8b902497
18:11:38 [2025-10-30T18:11:38.587Z] Copying blob sha256:bd92079967419dc19583fc807538b80bf660ab44af96f8314e5242bc93c97812
18:11:38 [2025-10-30T18:11:38.841Z] Copying blob sha256:f98b07245f2fa4388d5d297b33b3492b738b713c036dcd1c3b5e6c8f8dc817f9
18:11:39 [2025-10-30T18:11:39.095Z] Copying blob sha256:1544fb7e887562bdada1c58a982fb8647f39c2781b11a987f4fac48b1389eff3
18:11:39 [2025-10-30T18:11:39.349Z] Copying blob sha256:60298631d232f4553d64e7727539588e57bea601fb8f1860394ff196e81ea592
18:11:39 [2025-10-30T18:11:39.927Z] Copying blob sha256:9d464c49651e1e6f37b686403a2d33af55141e8413eae4a009baeb4ad53502e1
18:11:40 [2025-10-30T18:11:40.191Z] Copying blob sha256:7251353641314f32ab378c2e1d2e4f773921415a9fe6e89515d082a6eac2a3ab
18:11:40 [2025-10-30T18:11:40.445Z] Copying blob sha256:4c726ccfc26b37e31b7f88af4d07ebf30d2c8033eb211baa3f6f93bbd8beba99
18:11:40 [2025-10-30T18:11:40.445Z] Copying blob sha256:97cde0c59f12ca271651d73cd5234ca513ac6ff59a04161f4fe678b8bd2480fb
18:11:40 [2025-10-30T18:11:40.698Z] Copying blob sha256:e792ee44af212f36d6243a7ff42a4cb98bda88a3958a7374667e2aa39a280397
18:11:40 [2025-10-30T18:11:40.698Z] Copying blob sha256:8cee2557b9d536a7b95bc7d22baeb3af1cb4e318686a7085cb271828d1e2440f
18:11:40 [2025-10-30T18:11:40.952Z] Copying blob sha256:4d182b1e59f6bfc8d3c7281b7b78bed747b5098cc0c3e41e58d27b7a4f020648
18:11:40 [2025-10-30T18:11:40.952Z] Copying blob sha256:972899611ef2e2832acf476c1957edacf7f3d4ab048d23626bc3a75009888b13
18:11:41 [2025-10-30T18:11:41.205Z] Copying blob sha256:b47936fe91e7a9feef810d890a55aa88bb47b567db61c16d45545418cba37d7c
18:11:41 [2025-10-30T18:11:41.205Z] Copying blob sha256:b0e5f3ca621ecee7268c3699ad6a9d1158f7bcc7d7c9d66e90c09e3360840497
18:11:41 [2025-10-30T18:11:41.205Z] Copying blob sha256:f3fc12d09470cd8adfb7e9888216774c3986462ab8361e7e26ae570f84b9044a
18:11:41 [2025-10-30T18:11:41.459Z] Copying blob sha256:70df59f0f8a7239926f34b5e0fb585e020649a8711cc4aa523bfedbf2a2f0264
18:11:41 [2025-10-30T18:11:41.459Z] Copying blob sha256:846f3b4dd6a28337b4933f64215333941ad1fda02ea72263f3046fdc7e8d273d
18:11:41 [2025-10-30T18:11:41.712Z] Copying blob sha256:6afc0a76f3c2640f8064c5a989acdb6a89548678e10bc0870679b43155986d89
18:11:42 [2025-10-30T18:11:42.271Z] Copying blob sha256:192b416201c2fd7156f9e8fdc42eeec45adce6282f11b9d829e845f420c93375
18:11:42 [2025-10-30T18:11:42.525Z] Copying blob sha256:26f89200ae8824795a78f625cb5ded3e62f9f8e80c91043a7251cef64a9e4198
18:11:42 [2025-10-30T18:11:42.781Z] Copying blob sha256:32aadb7f7700ad3fbfdedc9be981f4b10840515cfea570bd4f28f30da09e90ec
18:11:43 [2025-10-30T18:11:43.702Z] Copying blob sha256:b50c9d923abcf22d2442b4e9992e5ee395823683a69701d9320dfbbb05e4d8c6
18:11:43 [2025-10-30T18:11:43.956Z] Copying blob sha256:ebe4fb959074f9b7228c75b66bf42828de96a3771a034a17b0b0261ce47ac7be
18:11:43 [2025-10-30T18:11:43.956Z] Copying blob sha256:477e890130641a0d8d6c0a2ddb69990aa623ba43687dad434ed6af1937285cba
18:11:44 [2025-10-30T18:11:44.209Z] Copying blob sha256:b4c99cf1cdd399084ba1e20e92ebe8f5d14bafb43fc9da3b6ee6d0db5fafbdd2
18:11:44 [2025-10-30T18:11:44.463Z] Copying blob sha256:1a3111599693f834a093346a5ee89bb31ebcdf22338f03e2456c325994a1a5f3
18:11:46 [2025-10-30T18:11:46.342Z] Copying blob sha256:9dad063a624b62064bf25dbbc2e802e472d636056f661f2a0be73efd8a4da98b
18:11:46 [2025-10-30T18:11:46.342Z] Copying config sha256:3c55da33aba79ab35fe1eb9c24c6d83fb589e5833a98f71ceeb2b07c0e2b1c64
18:11:46 [2025-10-30T18:11:46.342Z] Writing manifest to image destination
18:11:46 [2025-10-30T18:11:46.342Z] [2/2] STEP 2/9: ARG VERSION
18:11:46 [2025-10-30T18:11:46.342Z] --> 36ae942b2964
18:11:46 [2025-10-30T18:11:46.342Z] [2/2] STEP 3/9: ARG NAME=overridden
18:11:46 [2025-10-30T18:11:46.342Z] --> fe050301a04d
18:11:46 [2025-10-30T18:11:46.342Z] [2/2] STEP 4/9: ARG DESCRIPTION=overridden
18:11:46 [2025-10-30T18:11:46.342Z] --> 2c1273d8c77d
18:11:46 [2025-10-30T18:11:46.342Z] [2/2] STEP 5/9: RUN --mount=type=bind,from=builder,target=/var/tmp     --mount=type=bind,target=/run/src,rw       rm /run/src/out.ociarchive
18:11:54 [2025-10-30T18:11:54.408Z] --> 08bbfe718638
18:11:54 [2025-10-30T18:11:54.408Z] [2/2] STEP 6/9: LABEL containers.bootc=1       ostree.bootable=1       org.opencontainers.image.version=$VERSION       com.coreos.osname=$NAME       org.opencontainers.image.title=$DESCRIPTION       org.opencontainers.image.description=$DESCRIPTION
18:11:54 [2025-10-30T18:11:54.408Z] --> 2ccd3fa7e055
18:11:54 [2025-10-30T18:11:54.408Z] [2/2] STEP 7/9: STOPSIGNAL SIGRTMIN+3
18:11:54 [2025-10-30T18:11:54.408Z] --> 371ca1d3d098
18:11:54 [2025-10-30T18:11:54.408Z] [2/2] STEP 8/9: CMD ["/sbin/init"]
18:11:54 [2025-10-30T18:11:54.408Z] --> 7b45494c17f8
18:11:54 [2025-10-30T18:11:54.408Z] [2/2] STEP 9/9: LABEL "org.opencontainers.image.source"="https://github.com/coreos/fedora-coreos-config" "org.opencontainers.image.revision"="76896b7fc55efca9743a05797692b6695b66c3e5" "fedora-coreos.stream"="rawhide"
18:11:54 [2025-10-30T18:11:54.408Z] [2/2] COMMIT containers-storage:localhost/fedora-coreos:44.20251030.dev.0
18:11:54 [2025-10-30T18:11:54.410Z] --> f6368ecc4787
18:11:54 [2025-10-30T18:11:54.410Z] Successfully tagged localhost/fedora-coreos:44.20251030.dev.0
18:11:56 [2025-10-30T18:11:56.294Z] f6368ecc47879428fccd61aba97f2ce563d2e2fcdff1cf491db3ab5df18fde1a
18:11:56 [2025-10-30T18:11:56.295Z] ++ skopeo copy --quiet containers-storage:localhost/fedora-coreos:44.20251030.dev.0 oci-archive:/home/jenkins/agent/workspace/test-override/tmp/build-with-buildah/out.ociarchive
18:11:56 [2025-10-30T18:11:56.295Z] time="2025-10-30T18:11:55Z" level=info msg="Not using native diff for overlay, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled"
18:12:18 [2025-10-30T18:12:18.150Z] Copying /home/jenkins/agent/workspace/test-override/tmp/build-with-buildah/out.ociarchive to /home/jenkins/agent/workspace/test-override/tmp/cosa-import-q27yetup/out.ociarchive
18:12:20 [2025-10-30T18:12:20.030Z] layers already present: 0; layers needed: 66 (979.6 MB)
18:12:38 [2025-10-30T18:12:38.039Z] Image contains non-ostree compatible file paths: systemd: 3
18:12:38 [2025-10-30T18:12:38.039Z] Wrote: ostree-unverified-image:oci-archive:/home/jenkins/agent/workspace/test-override/tmp/cosa-import-q27yetup/out.ociarchive => 40d21d5106672773b1af7d0757fb26902ff7dda7a457993020e10a2a40155da7
18:12:44 [2025-10-30T18:12:44.560Z] 3785 metadata, 22079 content objects imported; 1.7 GB content written
18:12:45 [2025-10-30T18:12:45.919Z] 2636 metadata, 10665 content objects imported; 252.4 MB content written
18:12:48 [2025-10-30T18:12:48.434Z] Imported OCI image as build 44.20251030.dev.0
18:12:48 [2025-10-30T18:12:48.998Z] ostree diff commit from: 44.20251030.91.0 (b3be8a6c8ccb4baf6b6172e7c2e536a62280850e571ea53e813f598a7961b1d8)
18:12:48 [2025-10-30T18:12:48.998Z] ostree diff commit to:   44.20251030.dev.0 (40d21d5106672773b1af7d0757fb26902ff7dda7a457993020e10a2a40155da7)
18:12:48 [2025-10-30T18:12:48.998Z] Upgraded:
18:12:48 [2025-10-30T18:12:48.998Z]   kernel 6.18.0-0.rc3.251028gfd57572253bc3.31.fc44 -> 6.18.0-0.rc3.251030ge53642b87a4f4.33.fc44
18:12:48 [2025-10-30T18:12:48.998Z]   kernel-core 6.18.0-0.rc3.251028gfd57572253bc3.31.fc44 -> 6.18.0-0.rc3.251030ge53642b87a4f4.33.fc44
18:12:48 [2025-10-30T18:12:48.998Z]   kernel-modules 6.18.0-0.rc3.251028gfd57572253bc3.31.fc44 -> 6.18.0-0.rc3.251030ge53642b87a4f4.33.fc44
18:12:48 [2025-10-30T18:12:48.998Z]   kernel-modules-core 6.18.0-0.rc3.251028gfd57572253bc3.31.fc44 -> 6.18.0-0.rc3.251030ge53642b87a4f4.33.fc44
18:12:49 [2025-10-30T18:12:49.261Z] [Pipeline] }
18:12:49 [2025-10-30T18:12:49.266Z] [Pipeline] // withEnv
18:12:49 [2025-10-30T18:12:49.274Z] [Pipeline] }
18:12:49 [2025-10-30T18:12:49.279Z] [Pipeline] // stage
18:12:49 [2025-10-30T18:12:49.289Z] [Pipeline] stage
18:12:49 [2025-10-30T18:12:49.289Z] [Pipeline] { (x86_64:Build QEMU)
18:12:49 [2025-10-30T18:12:49.293Z] [Pipeline] withEnv
18:12:49 [2025-10-30T18:12:49.293Z] [Pipeline] {
18:12:49 [2025-10-30T18:12:49.299Z] [Pipeline] sh
18:12:49 [2025-10-30T18:12:49.786Z] + set -xeuo pipefail
18:12:49 [2025-10-30T18:12:49.786Z] ++ umask
18:12:49 [2025-10-30T18:12:49.786Z] + '[' 0022 = 0000 ']'
18:12:49 [2025-10-30T18:12:49.786Z] + cosa osbuild qemu
18:12:49 [2025-10-30T18:12:49.786Z] info: Missing CAP_SYS_ADMIN; using virt
18:12:50 [2025-10-30T18:12:50.040Z] Config commit: 76896b7fc55efca9743a05797692b6695b66c3e5
18:12:50 [2025-10-30T18:12:50.040Z] Using manifest: /home/jenkins/agent/workspace/test-override/src/config/manifest.yaml
18:12:50 [2025-10-30T18:12:50.597Z] Will build qemu
18:12:51 [2025-10-30T18:12:51.522Z] Estimating disk size...
18:12:52 [2025-10-30T18:12:52.445Z] Disk sizes: metal: 2847M (estimated), cloud: 10240M
18:13:07 [2025-10-30T18:13:07.283Z] ++ arch
18:13:07 [2025-10-30T18:13:07.283Z] + osbuild-mpp -D 'arch="x86_64"' -D 'artifact_name_prefix="fedora-coreos-44.20251030.dev.0"' -D 'build_version="44.20251030.dev.0"' -D 'ociarchive=""' -D 'osname="fedora-coreos"' -D 'container_imgref="ostree-image-signed:docker://quay.io/fedora/fedora-coreos:rawhide"' -D 'container_repo="localhost/fedora-coreos"' -D 'container_tag="44.20251030.dev.0"' -D 'extra_kargs="mitigations=auto,nosmt"' -D metal_image_size_mb=2847 -D cloud_image_size_mb=10240 -D rootfs_size_mb=2334 /usr/lib/coreos-assembler/osbuild-manifests/coreos.osbuild.x86_64.mpp.yaml /tmp/osbuild-u2jT.json
18:13:07 [2025-10-30T18:13:07.283Z] time="2025-10-30T18:13:04Z" level=info msg="Not using native diff for overlay, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled"
18:13:07 [2025-10-30T18:13:07.283Z] time="2025-10-30T18:13:04Z" level=info msg="Not using native diff for overlay, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled"
18:13:07 [2025-10-30T18:13:07.283Z] + set +x
18:13:07 [2025-10-30T18:13:07.283Z] + osbuild --out cache/osbuild/out --store cache/osbuild/store --cache-max-size 20GiB --checkpoint deployed-tree --checkpoint tree --checkpoint raw-image --checkpoint metal --checkpoint metal4k --export=qemu /tmp/osbuild-u2jT.json
18:13:07 [2025-10-30T18:13:07.283Z] starting /tmp/osbuild-u2jT.jsonPipeline source org.osbuild.curl: c0aaed6a935d625d9eb520665532bbadd399f0fd3d539c1f1e64a00d6beb8123
18:13:07 [2025-10-30T18:13:07.283Z] Build
18:13:07 [2025-10-30T18:13:07.283Z]   root: <host>
18:13:07 [2025-10-30T18:13:07.283Z] Pipeline source org.osbuild.containers-storage: 319b19ba029654ee408b68aae9a33bc918409c8c31cb34ba2be296929d0e2631
18:13:07 [2025-10-30T18:13:07.283Z] Build
18:13:07 [2025-10-30T18:13:07.283Z]   root: <host>
18:13:07 [2025-10-30T18:13:07.283Z] Pipeline deployed-tree: ec7f405defffa2ff60e981d3e0ba152fcfe44756fc9a09c8c62acd59d7ff4053
18:13:07 [2025-10-30T18:13:07.283Z] Build
18:13:07 [2025-10-30T18:13:07.283Z]   root: <host>
18:13:07 [2025-10-30T18:13:07.283Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
18:13:07 [2025-10-30T18:13:07.283Z] org.osbuild.container-deploy: ec7f405defffa2ff60e981d3e0ba152fcfe44756fc9a09c8c62acd59d7ff4053 {}
18:13:07 [2025-10-30T18:13:07.283Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:13:17 [2025-10-30T18:13:17.215Z] 
18:13:17 [2025-10-30T18:13:17.215Z] Filesystem      Size  Used Avail Use% Mounted on
18:13:17 [2025-10-30T18:13:17.215Z] /dev/vdb1        50G  8.9G   42G  18% /home/jenkins/agent/workspace/test-override/cache
18:13:17 [2025-10-30T18:13:17.215Z] 
18:13:21 [2025-10-30T18:13:21.368Z] f6368ecc47879428fccd61aba97f2ce563d2e2fcdff1cf491db3ab5df18fde1a
18:13:21 [2025-10-30T18:13:21.368Z] umount: /run/osbuild/containers/storage/overlay: not mounted.
18:13:21 [2025-10-30T18:13:21.368Z] WARNING: umount of overlay dir failed with an error: CompletedProcess(args=['umount', '-f', '--lazy', '/run/osbuild/containers/storage/overlay'], returncode=32)
18:13:21 [2025-10-30T18:13:21.928Z] 
18:13:21 [2025-10-30T18:13:21.928Z] ⏱  Duration: 15.79s
18:13:26 [2025-10-30T18:13:26.087Z] 
18:13:26 [2025-10-30T18:13:26.087Z] Filesystem      Size  Used Avail Use% Mounted on
18:13:26 [2025-10-30T18:13:26.087Z] /dev/vdb1        50G  8.9G   42G  18% /home/jenkins/agent/workspace/test-override/cache
18:13:26 [2025-10-30T18:13:26.087Z] 
18:13:26 [2025-10-30T18:13:26.087Z] Pipeline tree: 4903930679add41f13af12a78ab4170ee1499bf590617170d1d0db83a4271f60
18:13:26 [2025-10-30T18:13:26.087Z] Build
18:13:26 [2025-10-30T18:13:26.087Z]   root: <host>
18:13:26 [2025-10-30T18:13:26.087Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
18:13:26 [2025-10-30T18:13:26.087Z]   source-epoch: Mon Aug  1 23:42:11 2022 [1659397331]
18:13:26 [2025-10-30T18:13:26.087Z] org.osbuild.selinux: 99c8b46e58d7f4285e1cb73010eee27d0cace7f84fc33a8b26ad32ebac7d289b {
18:13:26 [2025-10-30T18:13:26.087Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
18:13:26 [2025-10-30T18:13:26.087Z]   "target": "tree:///"
18:13:26 [2025-10-30T18:13:26.087Z] }
18:13:26 [2025-10-30T18:13:26.087Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:13:26 [2025-10-30T18:13:26.087Z] 
18:13:26 [2025-10-30T18:13:26.087Z] ⏱  Duration: 0.29s
18:13:26 [2025-10-30T18:13:26.087Z] org.osbuild.ostree.init-fs: ecd28174c80683e062723ef0961a69d1a4fff4e92cd0c3a31a7cef139417f1bb {}
18:13:26 [2025-10-30T18:13:26.087Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:13:26 [2025-10-30T18:13:26.087Z] ostree admin init-fs --modern /run/osbuild/tree --sysroot=/run/osbuild/tree
18:13:26 [2025-10-30T18:13:26.341Z] 
18:13:26 [2025-10-30T18:13:26.341Z] ⏱  Duration: 0.19s
18:13:26 [2025-10-30T18:13:26.341Z] org.osbuild.ostree.os-init: 882ffa9b9bea8a8a14ede6b7a65bd2759e8da82b27786c41f31f6671f6f86790 {
18:13:26 [2025-10-30T18:13:26.341Z]   "osname": "fedora-coreos"
18:13:26 [2025-10-30T18:13:26.341Z] }
18:13:26 [2025-10-30T18:13:26.341Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:13:26 [2025-10-30T18:13:26.341Z] ostree admin os-init fedora-coreos --sysroot=/run/osbuild/tree
18:13:26 [2025-10-30T18:13:26.341Z] 
18:13:26 [2025-10-30T18:13:26.341Z] ⏱  Duration: 0.19s
18:13:26 [2025-10-30T18:13:26.341Z] org.osbuild.ostree.config: 9b774facef24e38b6838b5f4c2f7266ff98067e2ed48bc315b355b549724b87c {
18:13:26 [2025-10-30T18:13:26.341Z]   "repo": "/ostree/repo",
18:13:26 [2025-10-30T18:13:26.341Z]   "config": {
18:13:26 [2025-10-30T18:13:26.341Z]     "sysroot": {
18:13:26 [2025-10-30T18:13:26.341Z]       "readonly": true,
18:13:26 [2025-10-30T18:13:26.341Z]       "bootloader": "none",
18:13:26 [2025-10-30T18:13:26.341Z]       "bls-append-except-default": "grub_users=\"\"",
18:13:26 [2025-10-30T18:13:26.341Z]       "bootprefix": true
18:13:26 [2025-10-30T18:13:26.341Z]     }
18:13:26 [2025-10-30T18:13:26.341Z]   }
18:13:26 [2025-10-30T18:13:26.341Z] }
18:13:26 [2025-10-30T18:13:26.599Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:13:26 [2025-10-30T18:13:26.599Z] ostree config set sysroot.bootloader none --repo=/run/osbuild/tree/ostree/repo
18:13:26 [2025-10-30T18:13:26.599Z] ostree config set sysroot.bootprefix true --repo=/run/osbuild/tree/ostree/repo
18:13:26 [2025-10-30T18:13:26.599Z] ostree config set sysroot.readonly true --repo=/run/osbuild/tree/ostree/repo
18:13:26 [2025-10-30T18:13:26.599Z] ostree config set sysroot.bls-append-except-default grub_users="" --repo=/run/osbuild/tree/ostree/repo
18:13:26 [2025-10-30T18:13:26.599Z] 
18:13:26 [2025-10-30T18:13:26.599Z] ⏱  Duration: 0.22s
18:13:26 [2025-10-30T18:13:26.599Z] org.osbuild.mkdir: 5c8f655d221946cd883f79d9e689d3597ff329aaeeab72448cc9ce3c4f006a7a {
18:13:26 [2025-10-30T18:13:26.599Z]   "paths": [
18:13:26 [2025-10-30T18:13:26.599Z]     {
18:13:26 [2025-10-30T18:13:26.599Z]       "path": "/boot/efi",
18:13:26 [2025-10-30T18:13:26.599Z]       "mode": 493
18:13:26 [2025-10-30T18:13:26.599Z]     }
18:13:26 [2025-10-30T18:13:26.599Z]   ]
18:13:26 [2025-10-30T18:13:26.599Z] }
18:13:26 [2025-10-30T18:13:26.852Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:13:26 [2025-10-30T18:13:26.852Z] 
18:13:26 [2025-10-30T18:13:26.852Z] ⏱  Duration: 0.18s
18:13:26 [2025-10-30T18:13:26.852Z] org.osbuild.ignition: 8e1b0bbc77aebb0e2ee4aeac039ae8380ffa7099db0f2b9648c10772781eea75 {}
18:13:26 [2025-10-30T18:13:26.852Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:13:27 [2025-10-30T18:13:27.106Z] 
18:13:27 [2025-10-30T18:13:27.106Z] ⏱  Duration: 0.17s
18:13:27 [2025-10-30T18:13:27.106Z] org.osbuild.ostree.deploy.container: c91fc568bc205e4befec09a800b220389331859aa28cb8c7d719385cc4546629 {
18:13:27 [2025-10-30T18:13:27.106Z]   "osname": "fedora-coreos",
18:13:27 [2025-10-30T18:13:27.106Z]   "target_imgref": "ostree-image-signed:docker://quay.io/fedora/fedora-coreos:rawhide",
18:13:27 [2025-10-30T18:13:27.108Z]   "mounts": [
18:13:27 [2025-10-30T18:13:27.108Z]     "/boot",
18:13:27 [2025-10-30T18:13:27.108Z]     "/boot/efi"
18:13:27 [2025-10-30T18:13:27.108Z]   ],
18:13:27 [2025-10-30T18:13:27.108Z]   "kernel_opts": [
18:13:27 [2025-10-30T18:13:27.108Z]     "rw",
18:13:27 [2025-10-30T18:13:27.108Z]     "$ignition_firstboot",
18:13:27 [2025-10-30T18:13:27.108Z]     "mitigations=auto,nosmt"
18:13:27 [2025-10-30T18:13:27.108Z]   ]
18:13:27 [2025-10-30T18:13:27.108Z] }
18:13:27 [2025-10-30T18:13:27.108Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:13:27 [2025-10-30T18:13:27.108Z] ostree container image deploy --imgref=ostree-unverified-image:containers-storage:[overlay@/run/osbuild/containers/storage+/run/containers/storage]f6368ecc47879428fccd61aba97f2ce563d2e2fcdff1cf491db3ab5df18fde1a --stateroot=fedora-coreos --target-imgref=ostree-image-signed:docker://quay.io/fedora/fedora-coreos:rawhide --karg=rw --karg=$ignition_firstboot --karg=mitigations=auto,nosmt --sysroot=/run/osbuild/tree
18:13:37 [2025-10-30T18:13:37.033Z] 
18:13:37 [2025-10-30T18:13:37.034Z] Filesystem      Size  Used Avail Use% Mounted on
18:13:37 [2025-10-30T18:13:37.034Z] /dev/vdb1        50G  9.7G   41G  20% /home/jenkins/agent/workspace/test-override/cache
18:13:37 [2025-10-30T18:13:37.034Z] 
18:13:46 [2025-10-30T18:13:46.962Z] 
18:13:46 [2025-10-30T18:13:46.962Z] Filesystem      Size  Used Avail Use% Mounted on
18:13:46 [2025-10-30T18:13:46.962Z] /dev/vdb1        50G   11G   40G  21% /home/jenkins/agent/workspace/test-override/cache
18:13:46 [2025-10-30T18:13:46.962Z] 
18:13:56 [2025-10-30T18:13:56.904Z] 
18:13:56 [2025-10-30T18:13:56.904Z] Filesystem      Size  Used Avail Use% Mounted on
18:13:56 [2025-10-30T18:13:56.904Z] /dev/vdb1        50G   11G   40G  22% /home/jenkins/agent/workspace/test-override/cache
18:13:56 [2025-10-30T18:13:56.904Z] 
18:13:57 [2025-10-30T18:13:57.830Z] Image contains non-ostree compatible file paths: systemd: 3
18:13:57 [2025-10-30T18:13:57.830Z] 
18:13:57 [2025-10-30T18:13:57.830Z] ⏱  Duration: 30.95s
18:13:57 [2025-10-30T18:13:57.830Z] org.osbuild.ostree.aleph: 465afdfdddc9ee2b7d0c9a9c429c14db8c08b80648f3324e2291a783766d8064 {
18:13:57 [2025-10-30T18:13:57.830Z]   "coreos_compat": true,
18:13:57 [2025-10-30T18:13:57.830Z]   "deployment": {
18:13:57 [2025-10-30T18:13:57.830Z]     "default": true
18:13:57 [2025-10-30T18:13:57.830Z]   }
18:13:57 [2025-10-30T18:13:57.830Z] }
18:13:58 [2025-10-30T18:13:58.084Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:13:58 [2025-10-30T18:13:58.084Z] ostree container image metadata --repo=/run/osbuild/tree/ostree/repo docker://quay.io/fedora/fedora-coreos:rawhide
18:13:58 [2025-10-30T18:13:58.084Z] ostree container image metadata --repo=/run/osbuild/tree/ostree/repo docker://quay.io/fedora/fedora-coreos:rawhide --config
18:13:58 [2025-10-30T18:13:58.084Z] 
18:13:58 [2025-10-30T18:13:58.084Z] ⏱  Duration: 0.22s
18:13:58 [2025-10-30T18:13:58.084Z] org.osbuild.ostree.selinux: 4903930679add41f13af12a78ab4170ee1499bf590617170d1d0db83a4271f60 {
18:13:58 [2025-10-30T18:13:58.084Z]   "deployment": {
18:13:58 [2025-10-30T18:13:58.084Z]     "default": true
18:13:58 [2025-10-30T18:13:58.084Z]   }
18:13:58 [2025-10-30T18:13:58.084Z] }
18:13:58 [2025-10-30T18:13:58.341Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:13:58 [2025-10-30T18:13:58.341Z] 
18:13:58 [2025-10-30T18:13:58.341Z] ⏱  Duration: 0.26s
18:14:04 [2025-10-30T18:14:04.869Z] Pipeline raw-image: 04a34937e6a0e67823d79969a24233da5e37aaf54320e988c431879a6d635282
18:14:04 [2025-10-30T18:14:04.869Z] Build
18:14:04 [2025-10-30T18:14:04.869Z]   root: <host>
18:14:04 [2025-10-30T18:14:04.869Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
18:14:04 [2025-10-30T18:14:04.869Z] org.osbuild.truncate: 4df454e2907f08675cee31a3faf0818329d25c98a69898d6e4e1ae9ed077c861 {
18:14:04 [2025-10-30T18:14:04.869Z]   "filename": "disk.img",
18:14:04 [2025-10-30T18:14:04.869Z]   "size": "2985295872"
18:14:04 [2025-10-30T18:14:04.869Z] }
18:14:04 [2025-10-30T18:14:04.869Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:04 [2025-10-30T18:14:04.869Z] 
18:14:04 [2025-10-30T18:14:04.869Z] ⏱  Duration: 0.18s
18:14:04 [2025-10-30T18:14:04.869Z] org.osbuild.sfdisk: 3177ec9895f94e090a1291da1a1dd3f48b203f1e5bd14126926533d33f882985 {
18:14:04 [2025-10-30T18:14:04.869Z]   "uuid": "00000000-0000-4000-a000-000000000001",
18:14:04 [2025-10-30T18:14:04.869Z]   "label": "gpt",
18:14:04 [2025-10-30T18:14:04.869Z]   "partitions": [
18:14:04 [2025-10-30T18:14:04.869Z]     {
18:14:04 [2025-10-30T18:14:04.869Z]       "start": 2048,
18:14:04 [2025-10-30T18:14:04.869Z]       "partnum": 1,
18:14:04 [2025-10-30T18:14:04.869Z]       "size": 2048,
18:14:04 [2025-10-30T18:14:04.869Z]       "type": "21686148-6449-6E6F-744E-656564454649",
18:14:04 [2025-10-30T18:14:04.869Z]       "bootable": true,
18:14:04 [2025-10-30T18:14:04.869Z]       "name": "BIOS-BOOT"
18:14:04 [2025-10-30T18:14:04.869Z]     },
18:14:04 [2025-10-30T18:14:04.869Z]     {
18:14:04 [2025-10-30T18:14:04.869Z]       "start": 4096,
18:14:04 [2025-10-30T18:14:04.869Z]       "partnum": 2,
18:14:04 [2025-10-30T18:14:04.869Z]       "size": 260096,
18:14:04 [2025-10-30T18:14:04.869Z]       "type": "C12A7328-F81F-11D2-BA4B-00A0C93EC93B",
18:14:04 [2025-10-30T18:14:04.869Z]       "name": "EFI-SYSTEM"
18:14:04 [2025-10-30T18:14:04.869Z]     },
18:14:04 [2025-10-30T18:14:04.869Z]     {
18:14:04 [2025-10-30T18:14:04.869Z]       "start": 264192,
18:14:04 [2025-10-30T18:14:04.869Z]       "partnum": 3,
18:14:04 [2025-10-30T18:14:04.869Z]       "size": 786432,
18:14:04 [2025-10-30T18:14:04.869Z]       "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
18:14:04 [2025-10-30T18:14:04.869Z]       "name": "boot"
18:14:04 [2025-10-30T18:14:04.869Z]     },
18:14:04 [2025-10-30T18:14:04.869Z]     {
18:14:04 [2025-10-30T18:14:04.869Z]       "start": 1050624,
18:14:04 [2025-10-30T18:14:04.869Z]       "partnum": 4,
18:14:04 [2025-10-30T18:14:04.869Z]       "size": 4777984,
18:14:04 [2025-10-30T18:14:04.869Z]       "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
18:14:04 [2025-10-30T18:14:04.869Z]       "name": "root"
18:14:04 [2025-10-30T18:14:04.869Z]     }
18:14:04 [2025-10-30T18:14:04.869Z]   ]
18:14:04 [2025-10-30T18:14:04.869Z] }
18:14:04 [2025-10-30T18:14:04.869Z] device/device (org.osbuild.loopback): loop0 acquired (locked: False)
18:14:04 [2025-10-30T18:14:04.869Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:04 [2025-10-30T18:14:04.869Z] label: gpt
18:14:04 [2025-10-30T18:14:04.869Z] label-id: 00000000-0000-4000-a000-000000000001
18:14:04 [2025-10-30T18:14:04.869Z] /dev/loop0p1: start="2048", size="2048", type="21686148-6449-6E6F-744E-656564454649", name="BIOS-BOOT", bootable
18:14:04 [2025-10-30T18:14:04.869Z] /dev/loop0p2: start="4096", size="260096", type="C12A7328-F81F-11D2-BA4B-00A0C93EC93B", name="EFI-SYSTEM"
18:14:04 [2025-10-30T18:14:04.869Z] /dev/loop0p3: start="264192", size="786432", type="0FC63DAF-8483-4772-8E79-3D69D8477DE4", name="boot"
18:14:04 [2025-10-30T18:14:04.869Z] /dev/loop0p4: start="1050624", size="4777984", type="0FC63DAF-8483-4772-8E79-3D69D8477DE4", name="root"
18:14:04 [2025-10-30T18:14:04.869Z] {
18:14:04 [2025-10-30T18:14:04.869Z]    "partitiontable": {
18:14:04 [2025-10-30T18:14:04.869Z]       "label": "gpt",
18:14:04 [2025-10-30T18:14:04.869Z]       "id": "00000000-0000-4000-A000-000000000001",
18:14:04 [2025-10-30T18:14:04.869Z]       "device": "/dev/loop0",
18:14:04 [2025-10-30T18:14:04.869Z]       "unit": "sectors",
18:14:04 [2025-10-30T18:14:04.869Z]       "firstlba": 2048,
18:14:04 [2025-10-30T18:14:04.869Z]       "lastlba": 5830622,
18:14:04 [2025-10-30T18:14:04.869Z]       "sectorsize": 512,
18:14:04 [2025-10-30T18:14:04.869Z]       "partitions": [
18:14:04 [2025-10-30T18:14:04.869Z]          {
18:14:04 [2025-10-30T18:14:04.869Z]             "node": "/dev/loop0p1",
18:14:04 [2025-10-30T18:14:04.869Z]             "start": 2048,
18:14:04 [2025-10-30T18:14:04.869Z]             "size": 2048,
18:14:04 [2025-10-30T18:14:04.869Z]             "type": "21686148-6449-6E6F-744E-656564454649",
18:14:04 [2025-10-30T18:14:04.869Z]             "uuid": "3FA05B21-A825-4698-B7B7-B6616B357747",
18:14:04 [2025-10-30T18:14:04.869Z]             "name": "BIOS-BOOT"
18:14:04 [2025-10-30T18:14:04.869Z]          },{
18:14:04 [2025-10-30T18:14:04.869Z]             "node": "/dev/loop0p2",
18:14:04 [2025-10-30T18:14:04.869Z]             "start": 4096,
18:14:04 [2025-10-30T18:14:04.869Z]             "size": 260096,
18:14:04 [2025-10-30T18:14:04.869Z]             "type": "C12A7328-F81F-11D2-BA4B-00A0C93EC93B",
18:14:04 [2025-10-30T18:14:04.869Z]             "uuid": "CB104133-9B9F-411D-A011-B43DE8DE726B",
18:14:04 [2025-10-30T18:14:04.869Z]             "name": "EFI-SYSTEM"
18:14:04 [2025-10-30T18:14:04.869Z]          },{
18:14:04 [2025-10-30T18:14:04.869Z]             "node": "/dev/loop0p3",
18:14:04 [2025-10-30T18:14:04.869Z]             "start": 264192,
18:14:04 [2025-10-30T18:14:04.869Z]             "size": 786432,
18:14:04 [2025-10-30T18:14:04.869Z]             "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
18:14:04 [2025-10-30T18:14:04.869Z]             "uuid": "59B96C98-2C62-4310-B34A-3BED431DAE43",
18:14:04 [2025-10-30T18:14:04.869Z]             "name": "boot"
18:14:04 [2025-10-30T18:14:04.869Z]          },{
18:14:04 [2025-10-30T18:14:04.869Z]             "node": "/dev/loop0p4",
18:14:04 [2025-10-30T18:14:04.869Z]             "start": 1050624,
18:14:04 [2025-10-30T18:14:04.869Z]             "size": 4777984,
18:14:04 [2025-10-30T18:14:04.869Z]             "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
18:14:04 [2025-10-30T18:14:04.869Z]             "uuid": "C3EAA3A9-E655-472A-9633-44AEED989AC0",
18:14:04 [2025-10-30T18:14:04.869Z]             "name": "root"
18:14:04 [2025-10-30T18:14:04.869Z]          }
18:14:04 [2025-10-30T18:14:04.869Z]       ]
18:14:04 [2025-10-30T18:14:04.869Z]    }
18:14:04 [2025-10-30T18:14:04.869Z] }
18:14:04 [2025-10-30T18:14:04.869Z] 
18:14:04 [2025-10-30T18:14:04.869Z] ⏱  Duration: 0.35s
18:14:04 [2025-10-30T18:14:04.869Z] org.osbuild.mkfs.fat: 09222d823bdb48d8850b6d90f3b2f70b92a3f911db68d8d5ad9946c7ca33bcf8 {
18:14:04 [2025-10-30T18:14:04.869Z]   "label": "EFI-SYSTEM",
18:14:04 [2025-10-30T18:14:04.869Z]   "volid": "7B7795E7"
18:14:04 [2025-10-30T18:14:04.869Z] }
18:14:04 [2025-10-30T18:14:04.869Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
18:14:04 [2025-10-30T18:14:04.869Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:04 [2025-10-30T18:14:04.869Z] mkfs.fat 4.2 (2021-01-31)
18:14:04 [2025-10-30T18:14:04.869Z] 
18:14:04 [2025-10-30T18:14:04.869Z] ⏱  Duration: 0.26s
18:14:04 [2025-10-30T18:14:04.869Z] org.osbuild.mkfs.ext4: b32932cc3a87245cac42e585b90752ac1692124ed6df1fccb49f9e50b74026ed {
18:14:04 [2025-10-30T18:14:04.869Z]   "uuid": "96d15588-3596-4b3c-adca-a2ff7279ea63",
18:14:04 [2025-10-30T18:14:04.869Z]   "label": "boot",
18:14:04 [2025-10-30T18:14:04.869Z]   "metadata_csum_seed": true
18:14:04 [2025-10-30T18:14:04.869Z] }
18:14:04 [2025-10-30T18:14:04.869Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
18:14:04 [2025-10-30T18:14:04.869Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:04 [2025-10-30T18:14:04.869Z] mke2fs 1.47.2 (1-Jan-2025)
18:14:04 [2025-10-30T18:14:04.869Z] Discarding device blocks:      0/393216             done                            
18:14:04 [2025-10-30T18:14:04.869Z] Creating filesystem with 393216 1k blocks and 98304 inodes
18:14:04 [2025-10-30T18:14:04.869Z] Filesystem UUID: 96d15588-3596-4b3c-adca-a2ff7279ea63
18:14:04 [2025-10-30T18:14:04.869Z] Superblock backups stored on blocks: 
18:14:04 [2025-10-30T18:14:04.869Z] 	8193, 24577, 40961, 57345, 73729, 204801, 221185
18:14:04 [2025-10-30T18:14:04.869Z] 
18:14:04 [2025-10-30T18:14:04.869Z] Allocating group tables:  0/48     done                            
18:14:04 [2025-10-30T18:14:04.869Z] Writing inode tables:  0/48     done                            
18:14:04 [2025-10-30T18:14:04.869Z] Creating journal (8192 blocks): done
18:14:04 [2025-10-30T18:14:04.869Z] Writing superblocks and filesystem accounting information:  0/48     done
18:14:04 [2025-10-30T18:14:04.869Z] 
18:14:04 [2025-10-30T18:14:04.869Z] 
18:14:04 [2025-10-30T18:14:04.869Z] ⏱  Duration: 0.27s
18:14:04 [2025-10-30T18:14:04.869Z] org.osbuild.mkfs.xfs: d2b827a8ac228aa301fdf7c6466746a4d0bf90715bd6cc0a205ada72e7f119d5 {
18:14:04 [2025-10-30T18:14:04.869Z]   "uuid": "910678ff-f77e-4a7d-8d53-86f2ac47a823",
18:14:04 [2025-10-30T18:14:04.869Z]   "label": "root"
18:14:04 [2025-10-30T18:14:04.869Z] }
18:14:04 [2025-10-30T18:14:04.869Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
18:14:04 [2025-10-30T18:14:04.869Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:05 [2025-10-30T18:14:05.123Z] meta-data=/dev/loop0             isize=512    agcount=4, agsize=149312 blks
18:14:05 [2025-10-30T18:14:05.123Z]          =                       sectsz=512   attr=2, projid32bit=1
18:14:05 [2025-10-30T18:14:05.123Z]          =                       crc=1        finobt=1, sparse=1, rmapbt=1
18:14:05 [2025-10-30T18:14:05.123Z]          =                       reflink=1    bigtime=1 inobtcount=1 nrext64=1
18:14:05 [2025-10-30T18:14:05.123Z]          =                       exchange=0  
18:14:05 [2025-10-30T18:14:05.123Z] data     =                       bsize=4096   blocks=597248, imaxpct=25
18:14:05 [2025-10-30T18:14:05.123Z]          =                       sunit=0      swidth=0 blks
18:14:05 [2025-10-30T18:14:05.123Z] naming   =version 2              bsize=4096   ascii-ci=0, ftype=1, parent=0
18:14:05 [2025-10-30T18:14:05.123Z] log      =internal log           bsize=4096   blocks=16384, version=2
18:14:05 [2025-10-30T18:14:05.123Z]          =                       sectsz=512   sunit=0 blks, lazy-count=1
18:14:05 [2025-10-30T18:14:05.123Z] realtime =none                   extsz=4096   blocks=0, rtextents=0
18:14:05 [2025-10-30T18:14:05.123Z] Discarding blocks...Done.
18:14:05 [2025-10-30T18:14:05.123Z] 
18:14:05 [2025-10-30T18:14:05.123Z] ⏱  Duration: 0.27s
18:14:05 [2025-10-30T18:14:05.123Z] org.osbuild.mkdir: bd5d506048b9a919ae14315a75b05d2cceba7d94c007b135af71d802698b176a {
18:14:05 [2025-10-30T18:14:05.123Z]   "paths": [
18:14:05 [2025-10-30T18:14:05.123Z]     {
18:14:05 [2025-10-30T18:14:05.123Z]       "path": "mount://root/boot",
18:14:05 [2025-10-30T18:14:05.123Z]       "mode": 493
18:14:05 [2025-10-30T18:14:05.123Z]     },
18:14:05 [2025-10-30T18:14:05.123Z]     {
18:14:05 [2025-10-30T18:14:05.123Z]       "path": "mount://boot/efi",
18:14:05 [2025-10-30T18:14:05.123Z]       "mode": 493
18:14:05 [2025-10-30T18:14:05.123Z]     }
18:14:05 [2025-10-30T18:14:05.123Z]   ]
18:14:05 [2025-10-30T18:14:05.123Z] }
18:14:05 [2025-10-30T18:14:05.123Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:14:05 [2025-10-30T18:14:05.123Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t15ovwpn/mounts/root-mount-point
18:14:05 [2025-10-30T18:14:05.377Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t15ovwpn/mounts/boot-mount-point
18:14:05 [2025-10-30T18:14:05.377Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:05 [2025-10-30T18:14:05.377Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t15ovwpn/mounts/boot-mount-point unmounted
18:14:05 [2025-10-30T18:14:05.377Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t15ovwpn/mounts/root-mount-point unmounted
18:14:05 [2025-10-30T18:14:05.377Z] 
18:14:05 [2025-10-30T18:14:05.377Z] ⏱  Duration: 0.44s
18:14:05 [2025-10-30T18:14:05.630Z] org.osbuild.selinux: f047cb27ad1b11747ebec62a29b71b409267279537f61d210f81258ce0ce2f20 {
18:14:05 [2025-10-30T18:14:05.630Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
18:14:05 [2025-10-30T18:14:05.630Z]   "target": "mount://root/"
18:14:05 [2025-10-30T18:14:05.630Z] }
18:14:05 [2025-10-30T18:14:05.630Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:14:05 [2025-10-30T18:14:05.630Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-8ptv3dlg/mounts/
18:14:05 [2025-10-30T18:14:05.884Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:05 [2025-10-30T18:14:05.884Z] 
18:14:05 [2025-10-30T18:14:05.884Z] Filesystem      Size  Used Avail Use% Mounted on
18:14:05 [2025-10-30T18:14:05.884Z] /dev/vdb1        50G   11G   40G  22% /home/jenkins/agent/workspace/test-override/cache
18:14:05 [2025-10-30T18:14:05.884Z] 
18:14:05 [2025-10-30T18:14:05.884Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-8ptv3dlg/mounts/ unmounted
18:14:05 [2025-10-30T18:14:05.884Z] 
18:14:05 [2025-10-30T18:14:05.884Z] ⏱  Duration: 0.50s
18:14:05 [2025-10-30T18:14:05.884Z] org.osbuild.selinux: 18c3406d0bf6dc18a07b79fe0628d2c13f5e029e7392f6bb99cdb9332c79dbe2 {
18:14:05 [2025-10-30T18:14:05.884Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
18:14:05 [2025-10-30T18:14:05.884Z]   "target": "mount://root/boot/"
18:14:05 [2025-10-30T18:14:05.884Z] }
18:14:06 [2025-10-30T18:14:06.137Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:14:06 [2025-10-30T18:14:06.137Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1kk45vd8/mounts/
18:14:06 [2025-10-30T18:14:06.137Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1kk45vd8/mounts/boot
18:14:06 [2025-10-30T18:14:06.391Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:06 [2025-10-30T18:14:06.391Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1kk45vd8/mounts/boot unmounted
18:14:06 [2025-10-30T18:14:06.391Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1kk45vd8/mounts/ unmounted
18:14:06 [2025-10-30T18:14:06.647Z] 
18:14:06 [2025-10-30T18:14:06.647Z] ⏱  Duration: 0.53s
18:14:06 [2025-10-30T18:14:06.647Z] org.osbuild.copy: 18f8fb6e92ab13cb05e6c22cf7aed34652c90c6e6a8b42d3289f518d0ee3c033 {
18:14:06 [2025-10-30T18:14:06.647Z]   "paths": [
18:14:06 [2025-10-30T18:14:06.647Z]     {
18:14:06 [2025-10-30T18:14:06.647Z]       "from": "input://tree/",
18:14:06 [2025-10-30T18:14:06.647Z]       "to": "mount://root/"
18:14:06 [2025-10-30T18:14:06.647Z]     }
18:14:06 [2025-10-30T18:14:06.647Z]   ]
18:14:06 [2025-10-30T18:14:06.647Z] }
18:14:06 [2025-10-30T18:14:06.647Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:14:06 [2025-10-30T18:14:06.647Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-f0107jd8/mounts/
18:14:06 [2025-10-30T18:14:06.900Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-f0107jd8/mounts/boot
18:14:06 [2025-10-30T18:14:06.900Z] mount/efi (org.osbuild.fat): mounting /dev/loop0p2 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-f0107jd8/mounts/boot/efi
18:14:06 [2025-10-30T18:14:06.900Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:06 [2025-10-30T18:14:06.900Z] copying '/run/osbuild/inputs/tree/.' -> '/run/osbuild/mounts/.'
18:14:16 [2025-10-30T18:14:16.833Z] 
18:14:16 [2025-10-30T18:14:16.833Z] Filesystem      Size  Used Avail Use% Mounted on
18:14:16 [2025-10-30T18:14:16.833Z] /dev/vdb1        50G   13G   38G  25% /home/jenkins/agent/workspace/test-override/cache
18:14:16 [2025-10-30T18:14:16.833Z] 
18:14:19 [2025-10-30T18:14:19.335Z] mount/efi (org.osbuild.fat): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-f0107jd8/mounts/boot/efi unmounted
18:14:19 [2025-10-30T18:14:19.335Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-f0107jd8/mounts/boot unmounted
18:14:19 [2025-10-30T18:14:19.335Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-f0107jd8/mounts/ unmounted
18:14:19 [2025-10-30T18:14:19.335Z] 
18:14:19 [2025-10-30T18:14:19.335Z] ⏱  Duration: 12.92s
18:14:19 [2025-10-30T18:14:19.335Z] org.osbuild.bootupd: 0b1055d08eb2aba5a3b8b5fda448e316b68fae4ba0763fcdef51891f31cb983c {
18:14:19 [2025-10-30T18:14:19.335Z]   "bios": {
18:14:19 [2025-10-30T18:14:19.335Z]     "device": "disk"
18:14:19 [2025-10-30T18:14:19.335Z]   },
18:14:19 [2025-10-30T18:14:19.335Z]   "static-configs": true,
18:14:19 [2025-10-30T18:14:19.335Z]   "deployment": {
18:14:19 [2025-10-30T18:14:19.335Z]     "default": true
18:14:19 [2025-10-30T18:14:19.335Z]   }
18:14:19 [2025-10-30T18:14:19.335Z] }
18:14:19 [2025-10-30T18:14:19.589Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:14:19 [2025-10-30T18:14:19.589Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-c4h00pyl/mounts/
18:14:19 [2025-10-30T18:14:19.589Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-c4h00pyl/mounts/boot
18:14:19 [2025-10-30T18:14:19.842Z] mount/efi (org.osbuild.fat): mounting /dev/loop0p2 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-c4h00pyl/mounts/boot/efi
18:14:19 [2025-10-30T18:14:19.842Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:20 [2025-10-30T18:14:20.764Z] Added 01_users.cfg
18:14:20 [2025-10-30T18:14:20.764Z] Added 05_ignition.cfg
18:14:20 [2025-10-30T18:14:20.764Z] Added 10_blscfg.cfg
18:14:20 [2025-10-30T18:14:20.764Z] Added 14_menu_show_once.cfg
18:14:20 [2025-10-30T18:14:20.764Z] Added 30_uefi-firmware.cfg
18:14:20 [2025-10-30T18:14:20.764Z] Added 41_custom.cfg
18:14:20 [2025-10-30T18:14:20.764Z] Installed: grub.cfg
18:14:20 [2025-10-30T18:14:20.764Z] Installed: "fedora/grub.cfg"
18:14:20 [2025-10-30T18:14:20.764Z] mount/efi (org.osbuild.fat): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-c4h00pyl/mounts/boot/efi unmounted
18:14:20 [2025-10-30T18:14:20.764Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-c4h00pyl/mounts/boot unmounted
18:14:20 [2025-10-30T18:14:20.764Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-c4h00pyl/mounts/ unmounted
18:14:21 [2025-10-30T18:14:21.018Z] 
18:14:21 [2025-10-30T18:14:21.018Z] ⏱  Duration: 1.44s
18:14:21 [2025-10-30T18:14:21.018Z] org.osbuild.chattr: 04a34937e6a0e67823d79969a24233da5e37aaf54320e988c431879a6d635282 {
18:14:21 [2025-10-30T18:14:21.018Z]   "items": {
18:14:21 [2025-10-30T18:14:21.018Z]     "mount://root/": {
18:14:21 [2025-10-30T18:14:21.018Z]       "immutable": true
18:14:21 [2025-10-30T18:14:21.018Z]     }
18:14:21 [2025-10-30T18:14:21.018Z]   }
18:14:21 [2025-10-30T18:14:21.018Z] }
18:14:21 [2025-10-30T18:14:21.018Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:14:21 [2025-10-30T18:14:21.018Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-rvirwgh6/mounts/
18:14:21 [2025-10-30T18:14:21.018Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/d6829f04b5a7cda78589087ed569e1444c042e2e0bfb8db7a1857884207c3f4a.0'
18:14:21 [2025-10-30T18:14:21.272Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:21 [2025-10-30T18:14:21.272Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-rvirwgh6/mounts/ostree/deploy/fedora-coreos/deploy/d6829f04b5a7cda78589087ed569e1444c042e2e0bfb8db7a1857884207c3f4a.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-rvirwgh6/mounts
18:14:21 [2025-10-30T18:14:21.272Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-rvirwgh6/mounts/boot unmounted
18:14:21 [2025-10-30T18:14:21.272Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-rvirwgh6/mounts/var unmounted
18:14:21 [2025-10-30T18:14:21.272Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-rvirwgh6/mounts/sysroot unmounted
18:14:21 [2025-10-30T18:14:21.272Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-rvirwgh6/mounts unmounted
18:14:21 [2025-10-30T18:14:21.272Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-rvirwgh6/mounts unmounted
18:14:21 [2025-10-30T18:14:21.272Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-rvirwgh6/mounts unmounted
18:14:21 [2025-10-30T18:14:21.272Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-rvirwgh6/mounts/
18:14:21 [2025-10-30T18:14:21.272Z] 
18:14:21 [2025-10-30T18:14:21.272Z] ⏱  Duration: 0.47s
18:14:21 [2025-10-30T18:14:21.526Z] Pipeline raw-qemu-image: e6ee036e3204a4cf48f6616702f4269fe8ba5bed9ee14462dcbf1ae5bb300b15
18:14:21 [2025-10-30T18:14:21.526Z] Build
18:14:21 [2025-10-30T18:14:21.526Z]   root: <host>
18:14:21 [2025-10-30T18:14:21.526Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
18:14:21 [2025-10-30T18:14:21.526Z] org.osbuild.copy: 4a5035fe2962fc14ecb1a6f7896a0a033a4360311844fada20794ed6bc653a8c {
18:14:21 [2025-10-30T18:14:21.526Z]   "paths": [
18:14:21 [2025-10-30T18:14:21.526Z]     {
18:14:21 [2025-10-30T18:14:21.526Z]       "from": "input://tree/disk.img",
18:14:21 [2025-10-30T18:14:21.526Z]       "to": "tree:///disk.img"
18:14:21 [2025-10-30T18:14:21.526Z]     }
18:14:21 [2025-10-30T18:14:21.526Z]   ]
18:14:21 [2025-10-30T18:14:21.526Z] }
18:14:21 [2025-10-30T18:14:21.526Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:21 [2025-10-30T18:14:21.526Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/disk.img'
18:14:21 [2025-10-30T18:14:21.779Z] 
18:14:21 [2025-10-30T18:14:21.779Z] ⏱  Duration: 0.32s
18:14:21 [2025-10-30T18:14:21.779Z] org.osbuild.truncate: b4a3fa4f134a900903f9215c656249e61fb34facc0625a1fdfe5521ef6ec8e66 {
18:14:21 [2025-10-30T18:14:21.779Z]   "filename": "disk.img",
18:14:21 [2025-10-30T18:14:21.779Z]   "size": "10737418240"
18:14:21 [2025-10-30T18:14:21.779Z] }
18:14:21 [2025-10-30T18:14:21.779Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:22 [2025-10-30T18:14:22.033Z] 
18:14:22 [2025-10-30T18:14:22.033Z] ⏱  Duration: 0.18s
18:14:22 [2025-10-30T18:14:22.033Z] org.osbuild.coreos.platform: e6ee036e3204a4cf48f6616702f4269fe8ba5bed9ee14462dcbf1ae5bb300b15 {
18:14:22 [2025-10-30T18:14:22.033Z]   "platform": "qemu"
18:14:22 [2025-10-30T18:14:22.033Z] }
18:14:22 [2025-10-30T18:14:22.033Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:14:22 [2025-10-30T18:14:22.033Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts/
18:14:22 [2025-10-30T18:14:22.033Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/d6829f04b5a7cda78589087ed569e1444c042e2e0bfb8db7a1857884207c3f4a.0'
18:14:22 [2025-10-30T18:14:22.287Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts/boot
18:14:22 [2025-10-30T18:14:22.287Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:22 [2025-10-30T18:14:22.287Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts/boot unmounted
18:14:22 [2025-10-30T18:14:22.541Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts/ostree/deploy/fedora-coreos/deploy/d6829f04b5a7cda78589087ed569e1444c042e2e0bfb8db7a1857884207c3f4a.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts
18:14:22 [2025-10-30T18:14:22.541Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts/boot unmounted
18:14:22 [2025-10-30T18:14:22.541Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts/var unmounted
18:14:22 [2025-10-30T18:14:22.541Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts/sysroot unmounted
18:14:22 [2025-10-30T18:14:22.541Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts unmounted
18:14:22 [2025-10-30T18:14:22.541Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts unmounted
18:14:22 [2025-10-30T18:14:22.541Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts unmounted
18:14:22 [2025-10-30T18:14:22.541Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ivpf9vxj/mounts/
18:14:22 [2025-10-30T18:14:22.541Z] 
18:14:22 [2025-10-30T18:14:22.541Z] ⏱  Duration: 0.57s
18:14:22 [2025-10-30T18:14:22.541Z] Pipeline qemu: 1c2a58087eafb537da9d0c37a9cc825f4229c92c661b17cb775c9ca811f64d35
18:14:22 [2025-10-30T18:14:22.541Z] Build
18:14:22 [2025-10-30T18:14:22.541Z]   root: <host>
18:14:22 [2025-10-30T18:14:22.541Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
18:14:22 [2025-10-30T18:14:22.541Z] org.osbuild.qemu: 1c2a58087eafb537da9d0c37a9cc825f4229c92c661b17cb775c9ca811f64d35 {
18:14:22 [2025-10-30T18:14:22.541Z]   "filename": "fedora-coreos-44.20251030.dev.0-qemu.x86_64.qcow2",
18:14:22 [2025-10-30T18:14:22.541Z]   "format": {
18:14:22 [2025-10-30T18:14:22.541Z]     "type": "qcow2",
18:14:22 [2025-10-30T18:14:22.541Z]     "compression": false,
18:14:22 [2025-10-30T18:14:22.541Z]     "compat": "1.1"
18:14:22 [2025-10-30T18:14:22.541Z]   }
18:14:22 [2025-10-30T18:14:22.541Z] }
18:14:22 [2025-10-30T18:14:22.541Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:14:26 [2025-10-30T18:14:26.692Z] 
18:14:26 [2025-10-30T18:14:26.692Z] ⏱  Duration: 3.44s
18:14:26 [2025-10-30T18:14:26.692Z] manifest /tmp/osbuild-u2jT.json finished successfully
18:14:26 [2025-10-30T18:14:26.692Z] 
18:14:26 [2025-10-30T18:14:26.692Z] Filesystem      Size  Used Avail Use% Mounted on
18:14:26 [2025-10-30T18:14:26.692Z] /dev/vdb1        50G   15G   36G  30% /home/jenkins/agent/workspace/test-override/cache
18:14:26 [2025-10-30T18:14:26.692Z] 
18:14:30 [2025-10-30T18:14:30.843Z] oci-archive:	beda46704765a47e6d4f44aff22168ae36866c9c0e6e11552b775b77776b2969
18:14:30 [2025-10-30T18:14:30.843Z] deployed-tree:	ec7f405defffa2ff60e981d3e0ba152fcfe44756fc9a09c8c62acd59d7ff4053
18:14:30 [2025-10-30T18:14:30.843Z] tree:     	4903930679add41f13af12a78ab4170ee1499bf590617170d1d0db83a4271f60
18:14:30 [2025-10-30T18:14:30.843Z] raw-image:	04a34937e6a0e67823d79969a24233da5e37aaf54320e988c431879a6d635282
18:14:30 [2025-10-30T18:14:30.843Z] raw-4k-image:	5b6629cde8dd9637e53b8544af67854d1f7f7e825c4d43cf0c4a85232fff8f23
18:14:30 [2025-10-30T18:14:30.843Z] raw-aliyun-image:	d967688c1ebd74f5a2f5276ccaef4d100db78f8b05ed6cdee0e91489f632fd64
18:14:30 [2025-10-30T18:14:30.843Z] aliyun:   	9043c1afea816f1ddb65dba3855f759796444d24dd8261e0f5ee7ec2e4ea1173
18:14:30 [2025-10-30T18:14:30.843Z] raw-applehv-image:	b44464e5b5d800a95f0351a1586de73c63cefdc77226f014eff7bc3272c900ef
18:14:30 [2025-10-30T18:14:30.843Z] applehv:  	f7ad055e6e07803137546b164c7812d8712006382627128b7275e03874057a87
18:14:30 [2025-10-30T18:14:30.843Z] raw-aws-image:	e8a612aaf00f63d55b6791c1f08d88b12e89a567497e978ccc4a722a17a99194
18:14:30 [2025-10-30T18:14:30.843Z] aws:      	75bbe176d5ca27194956027802dfc57080f55e686ddf2a936a877a8557582672
18:14:30 [2025-10-30T18:14:30.843Z] raw-azure-image:	a5c63c5fb752dc833549ee5feef44394df55a3a7e2cd0185cf7cd3ea61fd948e
18:14:30 [2025-10-30T18:14:30.843Z] azure:    	c7f9fc42c2b7a35e06e7f42a154ca427ab397e27f6bbf6b674a12c9d5dc4ef73
18:14:30 [2025-10-30T18:14:30.843Z] raw-azurestack-image:	e39ec04c1051edf8fbb96a279465095eef9615d1670c767afef76857900e74db
18:14:30 [2025-10-30T18:14:30.843Z] azurestack:	6ef505d9efc46bb9479c813613e9ead59e7e77682e469b4c5f0cad0789518479
18:14:30 [2025-10-30T18:14:30.843Z] raw-digitalocean-image:	66e2e3261c82966579a002ce5fed3a6b51997f1dfd9ddfede60726724efb8e68
18:14:30 [2025-10-30T18:14:30.843Z] digitalocean:	ade57fd714ce46a1acce6618d3a3573b814435f7cd85fe78516ddd999ab1f739
18:14:30 [2025-10-30T18:14:30.843Z] raw-exoscale-image:	49922fa20d03402326ab327774503076fd3e758c8d5a27f844c56c905c967538
18:14:30 [2025-10-30T18:14:30.843Z] exoscale: 	b6ef1a9e7295a761559ac425b5e5f98719132ea39c9d48da393beea59166fbfb
18:14:30 [2025-10-30T18:14:30.843Z] raw-gcp-image:	f49a88e3b043492fcdabecb112ff437154140df05cf61f363939ec0f14ead8f5
18:14:30 [2025-10-30T18:14:30.843Z] raw-gcp-image-tar:	d3e9d17fcf909bb716173ade891eca5d87e5e4d6d6a8e9b0b8f5529d62f41d3c
18:14:30 [2025-10-30T18:14:30.843Z] gcp:      	111e1e2d03d1c550d306723a778835ddf3999980b67d6e29a5cc532b63ed7f64
18:14:30 [2025-10-30T18:14:30.843Z] raw-hetzner-image:	0e6c243f90c5fabb2b327f732e7020590a8d4ff21d9f9bc78697c483a958516a
18:14:30 [2025-10-30T18:14:30.843Z] hetzner:  	e53adf6b84b9c7baab96fd3aacd61e1ed75dc4a89a549ea9910817ca632f3b32
18:14:30 [2025-10-30T18:14:30.843Z] raw-hyperv-image:	841b35aa129b807fcf4b35353616556f14061cddb8780dbce5d1176e46fbe1d4
18:14:30 [2025-10-30T18:14:30.843Z] hyperv:   	7795de96afdc1f2d75e349106713715cf9a3a71b44d48cc1d0e5e77fc1f25879
18:14:30 [2025-10-30T18:14:30.843Z] raw-ibmcloud-image:	7ccc8b207505d7bae09d1f0e8a9f4c217ce7f704df5945d2221bc04b0c47c0eb
18:14:30 [2025-10-30T18:14:30.843Z] ibmcloud: 	2144422839fd7afc6fe93a9cf317e8c55286ab179fe714eaad6524f904737181
18:14:30 [2025-10-30T18:14:30.843Z] raw-kubevirt-image:	7cb29ec594d40a360c820b33a2d564dd6c2494f9caa9a9b762df03403064d4ea
18:14:30 [2025-10-30T18:14:30.843Z] qemu-kubevirt-image:	4d8587749c6fabbb5560669a054de303ed209a4ac21496bebc3230fa4ecace32
18:14:30 [2025-10-30T18:14:30.843Z] kubevirt: 	e620dd32aad9d622f2faed35afc019e0a308739fce544bc1f5c68477ce34229c
18:14:30 [2025-10-30T18:14:30.843Z] raw-openstack-image:	d0871f8b022c9ab1f0ff02f2f923d52b7ba1773423f82df8aab2892af6eedd41
18:14:30 [2025-10-30T18:14:30.843Z] openstack:	3a8b06f58f7844c8f1ea2a8419a2f0068c9ad822fbeee8f5e3d08261e9cd8d71
18:14:30 [2025-10-30T18:14:30.843Z] raw-oraclecloud-image:	54624b50372c00ce02b7fabc4df03e14a2a6d2fe4fd76ce0ab12e48d3e040eec
18:14:30 [2025-10-30T18:14:30.843Z] oraclecloud:	565eb93a20f6ef0f244c8f4831933fc495e712a064657e9e32d74bdcb3a06792
18:14:30 [2025-10-30T18:14:30.843Z] raw-proxmoxve-image:	d59ae4debe401d7180a200c56a5f149b0a4af872d24b2081967938f85fe8de8b
18:14:30 [2025-10-30T18:14:30.843Z] proxmoxve:	8e0c338ffb116c56454d6a7797a1553bbdebff2ff2bc451d88242ed10a28fec8
18:14:30 [2025-10-30T18:14:30.843Z] raw-metal-image:	bb6acd86e4a95fb2228f2422c5fd0d87e929ff633c75c9144e6e8e28a5ae05eb
18:14:30 [2025-10-30T18:14:30.843Z] metal:    	ef30cdd010c035eccdb8c06222842ee995975b88a21553a9723db03c679efdfb
18:14:30 [2025-10-30T18:14:30.843Z] raw-metal4k-image:	3bc983f7c3a8875be538535ec4ac283118635a48ea5947926f063458874035ba
18:14:30 [2025-10-30T18:14:30.843Z] metal4k:  	9424809e5c2f371ce2ed536d110595699a1bb606ff1da7df93dd604bc1ff1a44
18:14:30 [2025-10-30T18:14:30.843Z] raw-nutanix-image:	5e4021ba760c57637424878658a57e1ba329e6b085e98e82d8081edee30caa92
18:14:30 [2025-10-30T18:14:30.843Z] nutanix:  	fb6ba90b97af2ea810cc41aaa00f15a686b2fdeb30bb81f474f38b4044683550
18:14:30 [2025-10-30T18:14:30.843Z] raw-qemu-image:	e6ee036e3204a4cf48f6616702f4269fe8ba5bed9ee14462dcbf1ae5bb300b15
18:14:30 [2025-10-30T18:14:30.843Z] qemu:     	1c2a58087eafb537da9d0c37a9cc825f4229c92c661b17cb775c9ca811f64d35
18:14:30 [2025-10-30T18:14:30.843Z] raw-vultr-image:	e3b85be460732e678d73c59a97a4f84e1699d0e4207648bb57630299ad8c4bcb
18:14:30 [2025-10-30T18:14:30.843Z] vultr:    	0c028a118868754eb537524fd5d66fa8811a3425d4f0b494ae85b031858c588a
18:14:30 [2025-10-30T18:14:30.843Z] live:     	ccbb7e0cf7ae7e1aa6c11dd66ca104f6b87018c92e98a88ba4ac01b0c9ca333b
18:14:30 [2025-10-30T18:14:30.843Z] + set +x
18:14:34 [2025-10-30T18:14:34.096Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.qemu/tmp.h7VugjHUsB/qemu/fedora-coreos-44.20251030.dev.0-qemu.x86_64.qcow2': Operation not permitted
18:14:34 [2025-10-30T18:14:34.096Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.qemu/tmp.h7VugjHUsB/qemu': Operation not permitted
18:14:36 [2025-10-30T18:14:36.603Z] 
18:14:36 [2025-10-30T18:14:36.603Z] Filesystem      Size  Used Avail Use% Mounted on
18:14:36 [2025-10-30T18:14:36.603Z] /dev/vdb1        50G   13G   38G  26% /home/jenkins/agent/workspace/test-override/cache
18:14:36 [2025-10-30T18:14:36.603Z] 
18:14:40 [2025-10-30T18:14:40.753Z] /home/jenkins/agent/workspace/test-override/builds/44.20251030.dev.0/x86_64/meta.json wrote with version stamp 1761848080204787759
18:14:40 [2025-10-30T18:14:40.753Z] Successfully generated: fedora-coreos-44.20251030.dev.0-qemu.x86_64.qcow2
18:14:40 [2025-10-30T18:14:40.754Z] [Pipeline] }
18:14:40 [2025-10-30T18:14:40.764Z] [Pipeline] // withEnv
18:14:40 [2025-10-30T18:14:40.771Z] [Pipeline] }
18:14:40 [2025-10-30T18:14:40.777Z] [Pipeline] // stage
18:14:40 [2025-10-30T18:14:40.816Z] [Pipeline] withEnv
18:14:40 [2025-10-30T18:14:40.817Z] [Pipeline] {
18:14:40 [2025-10-30T18:14:40.822Z] [Pipeline] sh
18:14:41 [2025-10-30T18:14:41.319Z] + set -euo pipefail
18:14:41 [2025-10-30T18:14:41.322Z] ++ umask
18:14:41 [2025-10-30T18:14:41.322Z] + '[' 0022 = 0000 ']'
18:14:41 [2025-10-30T18:14:41.322Z] + uuidgen
18:14:41 [2025-10-30T18:14:41.322Z] + cut -f1 -d-
18:14:41 [2025-10-30T18:14:41.325Z] [Pipeline] }
18:14:41 [2025-10-30T18:14:41.330Z] [Pipeline] // withEnv
18:14:41 [2025-10-30T18:14:41.337Z] [Pipeline] withEnv
18:14:41 [2025-10-30T18:14:41.337Z] [Pipeline] {
18:14:41 [2025-10-30T18:14:41.340Z] [Pipeline] sh
18:14:41 [2025-10-30T18:14:41.821Z] + set -euo pipefail
18:14:41 [2025-10-30T18:14:41.821Z] ++ umask
18:14:41 [2025-10-30T18:14:41.821Z] + '[' 0022 = 0000 ']'
18:14:41 [2025-10-30T18:14:41.821Z] + cd /home/jenkins/agent/workspace/test-override
18:14:41 [2025-10-30T18:14:41.821Z] + cosa shell -- mktemp -d /home/jenkins/agent/workspace/test-override/tmp/kola-XXXXX
18:14:41 [2025-10-30T18:14:41.824Z] [Pipeline] }
18:14:41 [2025-10-30T18:14:41.829Z] [Pipeline] // withEnv
18:14:41 [2025-10-30T18:14:41.836Z] [Pipeline] parallel
18:14:41 [2025-10-30T18:14:41.836Z] [Pipeline] { (Branch: x86_64:kola)
18:14:41 [2025-10-30T18:14:41.836Z] [Pipeline] { (Branch: x86_64:kola:upgrade)
18:14:41 [2025-10-30T18:14:41.846Z] [Pipeline] withEnv
18:14:41 [2025-10-30T18:14:41.846Z] [Pipeline] {
18:14:41 [2025-10-30T18:14:41.847Z] [Pipeline] withEnv
18:14:41 [2025-10-30T18:14:41.847Z] [Pipeline] {
18:14:41 [2025-10-30T18:14:41.851Z] [Pipeline] sh
18:14:42 [2025-10-30T18:14:42.084Z] [Pipeline] sh
18:14:42 [2025-10-30T18:14:42.334Z] + set -xeuo pipefail
18:14:42 [2025-10-30T18:14:42.334Z] ++ umask
18:14:42 [2025-10-30T18:14:42.334Z] + '[' 0022 = 0000 ']'
18:14:42 [2025-10-30T18:14:42.334Z] + test -d /home/jenkins/agent/workspace/test-override/tests/kola
18:14:42 [2025-10-30T18:14:42.336Z] [Pipeline] }
18:14:42 [2025-10-30T18:14:42.340Z] [Pipeline] // withEnv
18:14:42 [2025-10-30T18:14:42.346Z] [Pipeline] withEnv
18:14:42 [2025-10-30T18:14:42.346Z] [Pipeline] {
18:14:42 [2025-10-30T18:14:42.351Z] [Pipeline] sh
18:14:42 [2025-10-30T18:14:42.566Z] + set -xeuo pipefail
18:14:42 [2025-10-30T18:14:42.566Z] ++ umask
18:14:42 [2025-10-30T18:14:42.566Z] + '[' 0022 = 0000 ']'
18:14:42 [2025-10-30T18:14:42.566Z] + cd /home/jenkins/agent/workspace/test-override
18:14:42 [2025-10-30T18:14:42.566Z] + cosa kola run-upgrade --rerun --allow-rerun-success=tags=needs-internet --build=latest --output-dir=/home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-upgrade-x86_64 --on-warn-failure-exit-77 --arch=x86_64 --upgrades
18:14:42 [2025-10-30T18:14:42.566Z] kola -p qemu --build latest run-upgrade --rerun --allow-rerun-success=tags=needs-internet --on-warn-failure-exit-77 --arch=x86_64 --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-upgrade-x86_64 --qemu-image-dir tmp/kola-qemu-cache -v --find-parent-image
18:14:42 [2025-10-30T18:14:42.566Z] 2025-10-30T18:14:42Z cli: Started logging at level INFO
18:14:42 [2025-10-30T18:14:42.566Z] 2025-10-30T18:14:42Z cli: Started logging at level INFO
18:14:42 [2025-10-30T18:14:42.828Z] + set -euo pipefail
18:14:42 [2025-10-30T18:14:42.828Z] ++ umask
18:14:42 [2025-10-30T18:14:42.828Z] + '[' 0022 = 0000 ']'
18:14:42 [2025-10-30T18:14:42.828Z] + kola list --json
18:14:42 [2025-10-30T18:14:42.828Z] + jq -r '.[].Name'
18:14:42 [2025-10-30T18:14:42.831Z] [Pipeline] }
18:14:42 [2025-10-30T18:14:42.836Z] [Pipeline] // withEnv
18:14:42 [2025-10-30T18:14:42.844Z] [Pipeline] withEnv
18:14:42 [2025-10-30T18:14:42.844Z] [Pipeline] {
18:14:42 [2025-10-30T18:14:42.848Z] [Pipeline] sh
18:14:43 [2025-10-30T18:14:43.326Z] + set -xeuo pipefail
18:14:43 [2025-10-30T18:14:43.326Z] ++ umask
18:14:43 [2025-10-30T18:14:43.326Z] + '[' 0022 = 0000 ']'
18:14:43 [2025-10-30T18:14:43.326Z] + cd /home/jenkins/agent/workspace/test-override
18:14:43 [2025-10-30T18:14:43.326Z] + cosa kola run --rerun --allow-rerun-success=tags=needs-internet --build=latest --output-dir=/home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-x86_64 --on-warn-failure-exit-77 --arch=x86_64 '--tag=!reprovision' --parallel=5
18:14:43 [2025-10-30T18:14:43.326Z] kola -p qemu --build latest run --rerun --allow-rerun-success=tags=needs-internet --on-warn-failure-exit-77 --arch=x86_64 --tag=!reprovision --parallel=5 --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-x86_64
18:14:43 [2025-10-30T18:14:43.326Z] 🕒  Snoozing kola test pattern "coreos.unique.boot.failure" until Nov 10 2025
18:14:43 [2025-10-30T18:14:43.326Z]   👉 https://github.com/coreos/fedora-coreos-tracker/issues/2019
18:14:43 [2025-10-30T18:14:43.486Z] Downloading image from https://builds.coreos.fedoraproject.org/prod/streams/rawhide/builds/44.20250911.91.0/x86_64/fedora-coreos-44.20250911.91.0-qemu.x86_64.qcow2.xz
18:14:43 [2025-10-30T18:14:43.486Z] Downloading signature from https://builds.coreos.fedoraproject.org/prod/streams/rawhide/builds/44.20250911.91.0/x86_64/fedora-coreos-44.20250911.91.0-qemu.x86_64.qcow2.xz.sig
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.bridge-static-via-kargs
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   basic.nvme
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ssh.custom-host-key-permissions
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.kdump.crash
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.ignition.failure
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.no-persist-ip
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.boot.install-bootloader-multipath
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.selinux.enforcing
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   fcos.users.shells
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.mtu-on-bond-kargs
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ostree.hotfix
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ntp.timesyncd.dhcp-propagation
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.multipath.custom-partition
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.misc.disk.varlibcontainers
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.ignition.once
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.var-mount.simple
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.rpm-ostree-countme
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.team-dhcp-via-ignition
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   basic.uefi
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   rootfs.uuid
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.boot.bootupd-validate
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.nameserver
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.ifname-karg.everyboot-systemd-link-file
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.ignition.mount.partitions
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ignition.kargs
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   basic
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.no-default-initramfs-net-propagation.bootif
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   multipath.day2
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.ignition.v2.users
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.swap.zram-generator
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.ignition.groups
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   kdump.crash.ssh
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ignition.systemd-enable-units
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.mtu-on-bond-ignition
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ignition.delete-config
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.disks.lvmdevices
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.docker.swarm-overlay-network
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.gshadow
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   podman.base
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.clhm.ignition-warnings
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.butane.grub-users
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   fcos.filesystem
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   kdump.crash.nfs
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.force-persist-ip
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.extensions.package
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.ignition.symlink
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.ifname-karg.udev-rule-firstboot-propagation
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   multipath.partition
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   podman.workflow
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.prefer-ignition-networking
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.rd-net-timeout-carrier
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.security.lockdown
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.files.alternatives
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   podman.network-single
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ignition.stable-boot
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.ignition.instantiated.enable-unit
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.var-mount.luks
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.auth.verify
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.podman.rootless-systemd
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.multipath.resilient
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.kargs-rd-net
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.reboot
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   rpmostree.upgrade-rollback
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.toolbox
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.ignition.sethostname
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.nmstate.policy
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   linux.nfs.client
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ostree.unlock
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.var-mount.scsi-id
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   multipath.day1
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.containers.quadlet
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.systemd.network-online
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   rhcos.selinux.boolean.persist
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   rpmostree.status
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.ignition.mount.disks
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.nmstate.state
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.boot.grub2-install
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.systemd.condition-needs-update
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.networking.hostname.fallback-hostname
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ntp.chrony.dhcp-propagation
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   fcos.network.listeners
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.unique.boot.ignition.failure
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ignition.systemd-unmasking
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   coreos.selinux.boolean
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   rpmostree.install-uninstall
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   non-exclusive-test-bucket-0
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.docker.basic
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ignition.systemd-disable
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ignition.remote
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   basic.uefi-secure
18:14:43 [2025-10-30T18:14:43.581Z] === RUN   ext.config.ignition.resource.remote
18:14:44 [2025-10-30T18:14:44.843Z] Read disk 69.3 MiB/939.8 MiB (7%)
18:14:45 [2025-10-30T18:14:45.765Z] Read disk 146.0 MiB/939.8 MiB (15%)
18:14:46 [2025-10-30T18:14:46.688Z] Read disk 210.7 MiB/939.8 MiB (22%)
18:14:47 [2025-10-30T18:14:47.608Z] Read disk 243.5 MiB/939.8 MiB (25%)
18:14:48 [2025-10-30T18:14:48.531Z] Read disk 271.4 MiB/939.8 MiB (28%)
18:14:49 [2025-10-30T18:14:49.452Z] Read disk 299.9 MiB/939.8 MiB (31%)
18:14:50 [2025-10-30T18:14:50.811Z] Read disk 328.6 MiB/939.8 MiB (34%)
18:14:51 [2025-10-30T18:14:51.733Z] Read disk 356.7 MiB/939.8 MiB (37%)
18:14:52 [2025-10-30T18:14:52.654Z] Read disk 387.0 MiB/939.8 MiB (41%)
18:14:53 [2025-10-30T18:14:53.577Z] Read disk 424.8 MiB/939.8 MiB (45%)
18:14:54 [2025-10-30T18:14:54.501Z] Read disk 450.0 MiB/939.8 MiB (47%)
18:14:55 [2025-10-30T18:14:55.861Z] Read disk 521.8 MiB/939.8 MiB (55%)
18:14:56 [2025-10-30T18:14:56.786Z] Read disk 578.4 MiB/939.8 MiB (61%)
18:14:57 [2025-10-30T18:14:57.713Z] Read disk 611.1 MiB/939.8 MiB (65%)
18:14:58 [2025-10-30T18:14:58.391Z] --- PASS: coreos.unique.boot.ignition.failure (13.43s)
18:14:58 [2025-10-30T18:14:58.641Z] Read disk 640.6 MiB/939.8 MiB (68%)
18:14:59 [2025-10-30T18:14:59.570Z] Read disk 692.7 MiB/939.8 MiB (73%)
18:15:00 [2025-10-30T18:15:00.497Z] Read disk 783.1 MiB/939.8 MiB (83%)
18:15:01 [2025-10-30T18:15:01.856Z] Read disk 871.9 MiB/939.8 MiB (92%)
18:15:02 [2025-10-30T18:15:02.779Z] Read disk 918.7 MiB/939.8 MiB (97%)
18:15:03 [2025-10-30T18:15:03.337Z] Read disk 939.8 MiB/939.8 MiB (100%)
18:15:03 [2025-10-30T18:15:03.337Z] Read disk 939.8 MiB/939.8 MiB (100%)
18:15:03 [2025-10-30T18:15:03.337Z] Read disk 939.8 MiB/939.8 MiB (100%)
18:15:03 [2025-10-30T18:15:03.337Z] gpg: Signature made Thu Sep 11 20:29:50 2025 UTC
18:15:03 [2025-10-30T18:15:03.337Z] gpg:                using RSA key 36F612DCF27F7D1A48A835E4DBFCF71C6D9F90A6
18:15:03 [2025-10-30T18:15:03.337Z] gpg: Good signature from "Fedora (44) <fedora-44-primary@fedoraproject.org>" [ultimate]
18:15:03 [2025-10-30T18:15:03.337Z] tmp/kola-qemu-cache/fedora-coreos-44.20250911.91.0-qemu.x86_64.qcow2
18:15:03 [2025-10-30T18:15:03.337Z] 🕒  Snoozing kola test pattern "coreos.unique.boot.failure" until Nov 10 2025
18:15:03 [2025-10-30T18:15:03.337Z]   👉 https://github.com/coreos/fedora-coreos-tracker/issues/2019
18:15:03 [2025-10-30T18:15:03.590Z] === RUN   fcos.upgrade.basic
18:15:13 [2025-10-30T18:15:13.219Z] --- PASS: ext.config.networking.bridge-static-via-kargs (28.15s)
18:15:25 [2025-10-30T18:15:25.445Z] === RUN   fcos.upgrade.basic/setup
18:15:28 [2025-10-30T18:15:28.031Z] systemctl status kola-runext.service:
18:15:28 [2025-10-30T18:15:28.031Z] × kola-runext.service
18:15:28 [2025-10-30T18:15:28.031Z]      Loaded: loaded (/etc/systemd/system/kola-runext.service; static)
18:15:28 [2025-10-30T18:15:28.031Z]     Drop-In: /usr/lib/systemd/system/service.d
18:15:28 [2025-10-30T18:15:28.031Z]              └─10-timeout-abort.conf
18:15:28 [2025-10-30T18:15:28.031Z]      Active: failed (Result: exit-code) since Thu 2025-10-30 18:15:25 UTC; 985ms ago
18:15:28 [2025-10-30T18:15:28.031Z]    Duration: 7.156s
18:15:28 [2025-10-30T18:15:28.031Z]  Invocation: 482f3652245f4ba6b958a229459760db
18:15:28 [2025-10-30T18:15:28.031Z]     Process: 2043 ExecStart=/usr/local/bin/kola-runext-alternatives (code=exited, status=1/FAILURE)
18:15:28 [2025-10-30T18:15:28.031Z]    Main PID: 2043 (code=exited, status=1/FAILURE)
18:15:28 [2025-10-30T18:15:28.031Z]    Mem peak: 9.5M
18:15:28 [2025-10-30T18:15:28.031Z]         CPU: 39ms
18:15:28 [2025-10-30T18:15:28.031Z] 
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ PRETTY_NAME='Fedora CoreOS 44.20251030.dev.0'
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ ANSI_COLOR='0;38;2;60;110;180'
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ LOGO=fedora-logo-icon
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ CPE_NAME=cpe:/o:fedoraproject:fedora:44
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ HOME_URL=https://getfedora.org/coreos/
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ DOCUMENTATION_URL=https://docs.fedoraproject.org/en-US/fedora-coreos/
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ SUPPORT_URL=https://github.com/coreos/fedora-coreos-tracker/
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ BUG_REPORT_URL=https://github.com/coreos/fedora-coreos-tracker/
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ REDHAT_BUGZILLA_PRODUCT=Fedora
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ REDHAT_BUGZILLA_PRODUCT_VERSION=rawhide
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ REDHAT_SUPPORT_PRODUCT=Fedora
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ REDHAT_SUPPORT_PRODUCT_VERSION=rawhide
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ SUPPORT_END=2027-05-19
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ VARIANT=CoreOS
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ VARIANT_ID=coreos
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ OSTREE_VERSION=44.20251030.dev.0
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: +++ IMAGE_VERSION=44.20251030.dev.0
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: ++ '[' fedora == fedora ']'
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: ++ '[' coreos == coreos ']'
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2044]: ++ echo 44
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2043]: + '[' 44 -le 43 ']'
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2043]: + [[ -e /var/lib/alternatives ]]
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2043]: + [[ ! -d /etc/alternatives ]]
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2043]: + [[ ! -d /etc/alternatives-admindir ]]
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2043]: + rpm-ostree install --apply-live iptables-legacy
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:18 qemu0 kola-runext-alternatives[2045]: notice: auto-inferring -y/--assumeyes when not run interactively; this will change in the future
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:21 qemu0 kola-runext-alternatives[2045]: Checking out tree d6829f0...done
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:21 qemu0 kola-runext-alternatives[2045]: Enabled rpm-md repositories: fedora-cisco-openh264 rawhide
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:22 qemu0 kola-runext-alternatives[2045]: Updating metadata for 'fedora-cisco-openh264'...done
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:22 qemu0 kola-runext-alternatives[2045]: Updating metadata for 'rawhide'...done
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:25 qemu0 kola-runext-alternatives[2045]: Importing rpm-md...done
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:25 qemu0 kola-runext-alternatives[2045]: rpm-md repo 'fedora-cisco-openh264'; generated: 2025-08-13T16:56:53Z solvables: 0
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:25 qemu0 kola-runext-alternatives[2045]: rpm-md repo 'rawhide'; generated: 2025-10-30T05:43:40Z solvables: 77355
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:25 qemu0 kola-runext-alternatives[2045]: Resolving dependencies...done
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:25 qemu0 kola-runext-alternatives[2045]: error: Could not depsolve transaction; 1 problem detected:
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:25 qemu0 kola-runext-alternatives[2045]:  Problem: cannot install both iptables-libs-1.8.11-12.fc44.x86_64 from rawhide and iptables-libs-1.8.11-11.fc43.x86_64 from @System
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:25 qemu0 kola-runext-alternatives[2045]:   - package iptables-legacy-1.8.11-12.fc44.x86_64 from rawhide requires iptables-libs(x86-64) = 1.8.11-12.fc44, but none of the providers can be installed
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:25 qemu0 kola-runext-alternatives[2045]:   - conflicting requests
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:25 qemu0 systemd[1]: kola-runext.service: Main process exited, code=exited, status=1/FAILURE
18:15:28 [2025-10-30T18:15:28.031Z] Oct 30 18:15:25 qemu0 systemd[1]: kola-runext.service: Failed with result 'exit-code'.
18:15:28 [2025-10-30T18:15:28.695Z] === RUN   fcos.upgrade.basic/upgrade-from-previous
18:15:28 [2025-10-30T18:15:28.956Z] --- PASS: ext.config.networking.ifname-karg.udev-rule-firstboot-propagation (45.41s)
18:15:30 [2025-10-30T18:15:30.311Z] --- PASS: ext.config.podman.rootless-systemd (46.78s)
18:15:30 [2025-10-30T18:15:30.311Z] --- FAIL: ext.config.files.alternatives (33.44s)
18:15:30 [2025-10-30T18:15:30.311Z]         harness.go:1309: kolet failed: : kolet run-test-unit failed:  Error: Unit kola-runext.service exited with code 1
18:15:30 [2025-10-30T18:15:30.311Z] 2025-10-30T18:15:26Z cli: Unit kola-runext.service exited with code 1: Process exited with status 1
18:15:35 [2025-10-30T18:15:35.545Z] --- PASS: coreos.auth.verify (23.62s)
18:15:38 [2025-10-30T18:15:38.805Z] --- PASS: multipath.day1 (54.81s)
18:15:56 [2025-10-30T18:15:56.827Z] --- PASS: coreos.ignition.instantiated.enable-unit (24.66s)
18:15:56 [2025-10-30T18:15:56.827Z] --- PASS: ext.config.ignition.stable-boot (26.11s)
18:16:18 [2025-10-30T18:16:18.698Z] --- PASS: fcos.network.listeners (23.63s)
18:16:22 [2025-10-30T18:16:22.855Z] --- PASS: ext.config.networking.nmstate.state (43.85s)
18:16:24 [2025-10-30T18:16:24.836Z] === RUN   fcos.upgrade.basic/upgrade-from-current
18:16:37 [2025-10-30T18:16:37.680Z] --- PASS: ext.config.var-mount.luks (67.41s)
18:16:45 [2025-10-30T18:16:45.755Z] --- PASS: ext.config.networking.hostname.fallback-hostname (25.91s)
18:16:45 [2025-10-30T18:16:45.755Z] --- PASS: ext.config.ntp.chrony.dhcp-propagation (49.12s)
18:17:03 [2025-10-30T18:17:03.469Z] --- PASS: fcos.upgrade.basic (115.71s)
18:17:03 [2025-10-30T18:17:03.469Z]     --- PASS: fcos.upgrade.basic/setup (3.73s)
18:17:03 [2025-10-30T18:17:03.469Z]     --- PASS: fcos.upgrade.basic/upgrade-from-previous (52.30s)
18:17:03 [2025-10-30T18:17:03.469Z]     --- PASS: fcos.upgrade.basic/upgrade-from-current (34.94s)
18:17:03 [2025-10-30T18:17:03.469Z] PASS, output in /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-upgrade-x86_64
18:17:03 [2025-10-30T18:17:03.474Z] [Pipeline] }
18:17:03 [2025-10-30T18:17:03.483Z] [Pipeline] // withEnv
18:17:03 [2025-10-30T18:17:03.491Z] [Pipeline] }
18:17:03 [2025-10-30T18:17:03.771Z] --- PASS: ext.config.boot.grub2-install (25.77s)
18:17:10 [2025-10-30T18:17:10.284Z] --- PASS: coreos.ignition.sethostname (23.88s)
18:17:28 [2025-10-30T18:17:28.300Z] --- PASS: coreos.ignition.symlink (23.65s)
18:17:28 [2025-10-30T18:17:28.300Z] --- PASS: coreos.ignition.mount.partitions (42.20s)
18:17:40 [2025-10-30T18:17:40.459Z] --- PASS: ext.config.systemd.condition-needs-update (76.32s)
18:17:55 [2025-10-30T18:17:55.291Z] --- PASS: ext.config.extensions.package (45.09s)
18:17:55 [2025-10-30T18:17:55.291Z] --- PASS: ext.config.networking.force-persist-ip (28.17s)
18:17:59 [2025-10-30T18:17:59.446Z] === RUN   ostree.unlock/unlock
18:17:59 [2025-10-30T18:17:59.446Z] === RUN   ostree.unlock/install
18:17:59 [2025-10-30T18:17:59.700Z] === RUN   ostree.unlock/uninstall
18:18:00 [2025-10-30T18:18:00.259Z] === RUN   ostree.unlock/discard
18:18:07 [2025-10-30T18:18:07.143Z] --- PASS: podman.network-single (151.83s)
18:18:11 [2025-10-30T18:18:11.305Z] --- PASS: ext.config.var-mount.scsi-id (45.42s)
18:18:23 [2025-10-30T18:18:23.448Z] --- PASS: ostree.unlock (43.17s)
18:18:23 [2025-10-30T18:18:23.448Z]     --- PASS: ostree.unlock/unlock (0.48s)
18:18:23 [2025-10-30T18:18:23.448Z]     --- PASS: ostree.unlock/install (0.62s)
18:18:23 [2025-10-30T18:18:23.448Z]     --- PASS: ostree.unlock/uninstall (0.35s)
18:18:23 [2025-10-30T18:18:23.448Z]     --- PASS: ostree.unlock/discard (18.30s)
18:18:27 [2025-10-30T18:18:27.600Z] === RUN   fcos.filesystem/writablefiles
18:18:28 [2025-10-30T18:18:28.158Z] === RUN   fcos.filesystem/writabledirs
18:18:28 [2025-10-30T18:18:28.158Z] === RUN   fcos.filesystem/stickydirs
18:18:28 [2025-10-30T18:18:28.411Z] === RUN   fcos.filesystem/denylist
18:18:29 [2025-10-30T18:18:29.335Z] --- PASS: linux.nfs.client (34.43s)
18:18:29 [2025-10-30T18:18:29.335Z]         nfs-client.go:128: NFS server booted
18:18:29 [2025-10-30T18:18:29.335Z]         nfs-client.go:139: Got NFSv4 mount.
18:18:29 [2025-10-30T18:18:29.335Z]         nfs-client.go:153: Got NFSv3 mount.
18:18:31 [2025-10-30T18:18:31.836Z] --- PASS: fcos.filesystem (24.82s)
18:18:31 [2025-10-30T18:18:31.836Z]     --- PASS: fcos.filesystem/writablefiles (0.65s)
18:18:31 [2025-10-30T18:18:31.836Z]     --- PASS: fcos.filesystem/writabledirs (0.20s)
18:18:31 [2025-10-30T18:18:31.836Z]     --- PASS: fcos.filesystem/stickydirs (0.23s)
18:18:31 [2025-10-30T18:18:31.836Z]     --- PASS: fcos.filesystem/denylist (0.28s)
18:18:58 [2025-10-30T18:18:58.294Z] --- PASS: ext.config.clhm.ignition-warnings (26.00s)
18:19:20 [2025-10-30T18:19:20.148Z] --- PASS: coreos.ignition.groups (23.93s)
18:19:21 [2025-10-30T18:19:21.073Z] --- PASS: ext.config.butane.grub-users (59.35s)
18:19:29 [2025-10-30T18:19:29.141Z] --- PASS: kdump.crash.nfs (94.62s)
18:19:29 [2025-10-30T18:19:29.141Z]         cluster.go:151: Running as unit: run-p4888-i4889.service; invocation ID: 9ced863b12a543b8b559c1fbedb1eee5
18:19:41 [2025-10-30T18:19:41.282Z] === RUN   podman.base/info
18:19:41 [2025-10-30T18:19:41.282Z] === RUN   podman.base/resources
18:19:46 [2025-10-30T18:19:46.518Z] --- PASS: podman.base (26.82s)
18:19:46 [2025-10-30T18:19:46.518Z]     --- PASS: podman.base/info (0.36s)
18:19:46 [2025-10-30T18:19:46.518Z]     --- PASS: podman.base/resources (3.03s)
18:19:47 [2025-10-30T18:19:47.076Z] --- PASS: ext.config.swap.zram-generator (25.95s)
18:19:55 [2025-10-30T18:19:55.146Z] --- PASS: ext.config.gshadow (25.83s)
18:20:05 [2025-10-30T18:20:05.082Z] --- PASS: ext.config.networking.nmstate.policy (113.72s)
18:20:05 [2025-10-30T18:20:05.339Z] --- PASS: kdump.crash.ssh (93.36s)
18:20:05 [2025-10-30T18:20:05.339Z]         cluster.go:151: Running as unit: run-p4558-i4559.service; invocation ID: 2392c5326c5b487ea7bfe529aae60367
18:20:10 [2025-10-30T18:20:10.578Z] --- PASS: coreos.ignition.v2.users (24.00s)
18:20:18 [2025-10-30T18:20:18.656Z] --- PASS: ext.config.docker.swarm-overlay-network (30.41s)
18:20:36 [2025-10-30T18:20:36.682Z] --- PASS: ext.config.multipath.custom-partition (39.66s)
18:20:46 [2025-10-30T18:20:46.598Z] --- PASS: ext.config.networking.no-default-initramfs-net-propagation.bootif (27.85s)
18:20:48 [2025-10-30T18:20:48.477Z] --- PASS: ext.config.disks.lvmdevices (43.59s)
18:21:06 [2025-10-30T18:21:06.495Z] --- PASS: multipath.day2 (58.72s)
18:21:06 [2025-10-30T18:21:06.495Z] === RUN   basic/DbusPerms
18:21:06 [2025-10-30T18:21:06.495Z] === RUN   basic/ServicesActive
18:21:06 [2025-10-30T18:21:06.495Z] === RUN   basic/ReadOnly
18:21:06 [2025-10-30T18:21:06.495Z] === RUN   basic/Useradd
18:21:06 [2025-10-30T18:21:06.495Z] === RUN   basic/MachineID
18:21:06 [2025-10-30T18:21:06.749Z] === RUN   basic/FCOSGrowpart
18:21:06 [2025-10-30T18:21:06.749Z] === RUN   basic/PortSSH
18:21:07 [2025-10-30T18:21:07.306Z] --- PASS: ext.config.networking.ifname-karg.everyboot-systemd-link-file (57.24s)
18:21:10 [2025-10-30T18:21:10.559Z] --- PASS: basic (24.85s)
18:21:10 [2025-10-30T18:21:10.559Z]     --- PASS: basic/DbusPerms (0.24s)
18:21:10 [2025-10-30T18:21:10.559Z]     --- PASS: basic/ServicesActive (0.09s)
18:21:10 [2025-10-30T18:21:10.559Z]     --- PASS: basic/ReadOnly (0.09s)
18:21:10 [2025-10-30T18:21:10.559Z]     --- PASS: basic/Useradd (0.15s)
18:21:10 [2025-10-30T18:21:10.559Z]     --- PASS: basic/MachineID (0.09s)
18:21:10 [2025-10-30T18:21:10.559Z]     --- PASS: basic/FCOSGrowpart (0.11s)
18:21:10 [2025-10-30T18:21:10.559Z]     --- PASS: basic/PortSSH (0.09s)
18:21:17 [2025-10-30T18:21:17.067Z] --- PASS: ext.config.networking.nameserver (27.61s)
18:21:31 [2025-10-30T18:21:31.882Z] --- PASS: ext.config.networking.mtu-on-bond-ignition (27.78s)
18:21:36 [2025-10-30T18:21:36.038Z] --- PASS: ext.config.boot.bootupd-validate (25.91s)
18:21:42 [2025-10-30T18:21:42.557Z] --- PASS: ext.config.ignition.systemd-enable-units (25.93s)
18:21:44 [2025-10-30T18:21:44.440Z] --- PASS: ext.config.ignition.kargs (37.23s)
18:21:54 [2025-10-30T18:21:54.368Z] === RUN   rootfs.uuid/RandomUUID
18:21:54 [2025-10-30T18:21:54.368Z] --- PASS: ext.config.ignition.delete-config (78.56s)
18:21:56 [2025-10-30T18:21:56.254Z] --- PASS: rootfs.uuid (24.23s)
18:21:56 [2025-10-30T18:21:56.254Z]     --- PASS: rootfs.uuid/RandomUUID (0.13s)
18:22:02 [2025-10-30T18:22:02.776Z] --- PASS: ext.config.ignition.systemd-disable (25.88s)
18:22:10 [2025-10-30T18:22:10.843Z] --- PASS: ext.config.networking.mtu-on-bond-kargs (27.67s)
18:22:14 [2025-10-30T18:22:14.096Z] === RUN   basic.uefi/MachineID
18:22:14 [2025-10-30T18:22:14.348Z] === RUN   basic.uefi/FCOSGrowpart
18:22:14 [2025-10-30T18:22:14.348Z] === RUN   basic.uefi/PortSSH
18:22:14 [2025-10-30T18:22:14.602Z] === RUN   basic.uefi/DbusPerms
18:22:14 [2025-10-30T18:22:14.855Z] === RUN   basic.uefi/ServicesActive
18:22:14 [2025-10-30T18:22:14.855Z] === RUN   basic.uefi/ReadOnly
18:22:14 [2025-10-30T18:22:14.855Z] === RUN   basic.uefi/Useradd
18:22:19 [2025-10-30T18:22:19.004Z] --- PASS: basic.uefi (25.09s)
18:22:19 [2025-10-30T18:22:19.004Z]     --- PASS: basic.uefi/MachineID (0.09s)
18:22:19 [2025-10-30T18:22:19.004Z]     --- PASS: basic.uefi/FCOSGrowpart (0.12s)
18:22:19 [2025-10-30T18:22:19.004Z]     --- PASS: basic.uefi/PortSSH (0.10s)
18:22:19 [2025-10-30T18:22:19.004Z]     --- PASS: basic.uefi/DbusPerms (0.27s)
18:22:19 [2025-10-30T18:22:19.004Z]     --- PASS: basic.uefi/ServicesActive (0.10s)
18:22:19 [2025-10-30T18:22:19.004Z]     --- PASS: basic.uefi/ReadOnly (0.10s)
18:22:19 [2025-10-30T18:22:19.004Z]     --- PASS: basic.uefi/Useradd (0.15s)
18:22:19 [2025-10-30T18:22:19.562Z] --- PASS: fcos.users.shells (23.62s)
18:22:31 [2025-10-30T18:22:31.701Z] --- PASS: ext.config.boot.install-bootloader-multipath (46.15s)
18:22:35 [2025-10-30T18:22:35.852Z] --- PASS: ext.config.ignition.resource.remote (26.07s)
18:22:41 [2025-10-30T18:22:41.077Z] === RUN   basic.uefi-secure/FCOSGrowpart
18:22:41 [2025-10-30T18:22:41.077Z] === RUN   basic.uefi-secure/PortSSH
18:22:41 [2025-10-30T18:22:41.077Z] === RUN   basic.uefi-secure/DbusPerms
18:22:41 [2025-10-30T18:22:41.077Z] === RUN   basic.uefi-secure/ServicesActive
18:22:41 [2025-10-30T18:22:41.077Z] === RUN   basic.uefi-secure/ReadOnly
18:22:41 [2025-10-30T18:22:41.331Z] === RUN   basic.uefi-secure/Useradd
18:22:41 [2025-10-30T18:22:41.331Z] === RUN   basic.uefi-secure/MachineID
18:22:44 [2025-10-30T18:22:44.587Z] --- PASS: ext.config.selinux.enforcing (42.36s)
18:22:44 [2025-10-30T18:22:44.841Z] --- PASS: basic.uefi-secure (25.08s)
18:22:44 [2025-10-30T18:22:44.841Z]     --- PASS: basic.uefi-secure/FCOSGrowpart (0.11s)
18:22:44 [2025-10-30T18:22:44.841Z]     --- PASS: basic.uefi-secure/PortSSH (0.09s)
18:22:44 [2025-10-30T18:22:44.841Z]     --- PASS: basic.uefi-secure/DbusPerms (0.26s)
18:22:44 [2025-10-30T18:22:44.841Z]     --- PASS: basic.uefi-secure/ServicesActive (0.09s)
18:22:44 [2025-10-30T18:22:44.841Z]     --- PASS: basic.uefi-secure/ReadOnly (0.09s)
18:22:44 [2025-10-30T18:22:44.841Z]     --- PASS: basic.uefi-secure/Useradd (0.16s)
18:22:44 [2025-10-30T18:22:44.841Z]     --- PASS: basic.uefi-secure/MachineID (0.09s)
18:22:59 [2025-10-30T18:22:59.659Z] --- PASS: coreos.ignition.failure (14.11s)
18:23:03 [2025-10-30T18:23:03.813Z] --- PASS: ext.config.networking.team-dhcp-via-ignition (27.82s)
18:23:21 [2025-10-30T18:23:21.847Z] --- PASS: ext.config.ignition.remote (50.29s)
18:23:24 [2025-10-30T18:23:24.353Z] === RUN   ostree.hotfix/unlock
18:23:30 [2025-10-30T18:23:30.873Z] === RUN   ostree.hotfix/install
18:23:31 [2025-10-30T18:23:31.434Z] === RUN   ostree.hotfix/uninstall
18:23:31 [2025-10-30T18:23:31.996Z] === RUN   ostree.hotfix/persist
18:23:35 [2025-10-30T18:23:35.257Z] --- PASS: ext.config.ntp.timesyncd.dhcp-propagation (51.08s)
18:23:35 [2025-10-30T18:23:35.257Z] --- PASS: ext.config.kdump.crash (77.03s)
18:23:40 [2025-10-30T18:23:40.490Z] --- PASS: coreos.ignition.once (40.87s)
18:23:52 [2025-10-30T18:23:52.647Z] === RUN   ostree.hotfix/rollback
18:24:02 [2025-10-30T18:24:02.570Z] --- PASS: ext.config.systemd.network-online (26.07s)
18:24:04 [2025-10-30T18:24:04.451Z] --- PASS: coreos.misc.disk.varlibcontainers (43.16s)
18:24:04 [2025-10-30T18:24:04.451Z]         cluster.go:151: Created symlink '/etc/systemd/system/var-lib-containers.mount.wants/systemd-mkfs@dev-disk-by-id-virtio-disk1.service' → '/etc/systemd/system/systemd-mkfs@dev-disk-by-id-virtio-disk1.service'.
18:24:04 [2025-10-30T18:24:04.451Z]         cluster.go:151: Created symlink '/etc/systemd/system/local-fs.target.wants/var-lib-containers.mount' → '/etc/systemd/system/var-lib-containers.mount'.
18:24:07 [2025-10-30T18:24:07.708Z] --- PASS: ext.config.networking.prefer-ignition-networking (27.66s)
18:24:12 [2025-10-30T18:24:12.938Z] --- PASS: ostree.hotfix (68.89s)
18:24:12 [2025-10-30T18:24:12.938Z]     --- PASS: ostree.hotfix/unlock (6.55s)
18:24:12 [2025-10-30T18:24:12.938Z]     --- PASS: ostree.hotfix/install (0.63s)
18:24:12 [2025-10-30T18:24:12.938Z]     --- PASS: ostree.hotfix/uninstall (0.35s)
18:24:12 [2025-10-30T18:24:12.938Z]     --- PASS: ostree.hotfix/persist (18.49s)
18:24:12 [2025-10-30T18:24:12.938Z]     --- PASS: ostree.hotfix/rollback (18.50s)
18:24:18 [2025-10-30T18:24:18.162Z] --- PASS: rhcos.selinux.boolean.persist (42.22s)
18:24:26 [2025-10-30T18:24:26.215Z] === RUN   basic.nvme/MachineID
18:24:26 [2025-10-30T18:24:26.215Z] === RUN   basic.nvme/FCOSGrowpart
18:24:26 [2025-10-30T18:24:26.215Z] === RUN   basic.nvme/PortSSH
18:24:26 [2025-10-30T18:24:26.215Z] === RUN   basic.nvme/DbusPerms
18:24:26 [2025-10-30T18:24:26.215Z] === RUN   basic.nvme/ServicesActive
18:24:26 [2025-10-30T18:24:26.215Z] === RUN   basic.nvme/ReadOnly
18:24:26 [2025-10-30T18:24:26.215Z] === RUN   basic.nvme/Useradd
18:24:29 [2025-10-30T18:24:29.464Z] --- PASS: basic.nvme (24.98s)
18:24:29 [2025-10-30T18:24:29.464Z]     --- PASS: basic.nvme/MachineID (0.09s)
18:24:29 [2025-10-30T18:24:29.464Z]     --- PASS: basic.nvme/FCOSGrowpart (0.12s)
18:24:29 [2025-10-30T18:24:29.464Z]     --- PASS: basic.nvme/PortSSH (0.09s)
18:24:29 [2025-10-30T18:24:29.464Z]     --- PASS: basic.nvme/DbusPerms (0.26s)
18:24:29 [2025-10-30T18:24:29.464Z]     --- PASS: basic.nvme/ServicesActive (0.10s)
18:24:29 [2025-10-30T18:24:29.464Z]     --- PASS: basic.nvme/ReadOnly (0.09s)
18:24:29 [2025-10-30T18:24:29.464Z]     --- PASS: basic.nvme/Useradd (0.14s)
18:24:35 [2025-10-30T18:24:35.973Z] --- PASS: ext.config.networking.no-persist-ip (27.97s)
18:24:36 [2025-10-30T18:24:36.854Z] --- PASS: rpmostree.status (24.30s)
18:24:54 [2025-10-30T18:24:54.858Z] --- PASS: ext.config.rpm-ostree-countme (25.85s)
18:24:55 [2025-10-30T18:24:55.417Z] --- PASS: coreos.ignition.mount.disks (53.90s)
18:25:01 [2025-10-30T18:25:01.924Z] --- PASS: ext.config.var-mount.simple (43.46s)
18:25:03 [2025-10-30T18:25:03.278Z] --- PASS: ext.config.containers.quadlet (27.76s)
18:25:06 [2025-10-30T18:25:06.526Z] --- PASS: ext.config.docker.basic (29.36s)
18:25:16 [2025-10-30T18:25:16.439Z] === RUN   podman.workflow/run
18:25:21 [2025-10-30T18:25:21.662Z] --- PASS: ext.config.ssh.custom-host-key-permissions (25.83s)
18:25:43 [2025-10-30T18:25:43.518Z] --- PASS: multipath.partition (42.33s)
18:25:44 [2025-10-30T18:25:44.442Z] --- PASS: coreos.selinux.boolean (41.21s)
18:25:46 [2025-10-30T18:25:46.957Z] --- PASS: ext.config.ignition.systemd-unmasking (26.02s)
18:25:53 [2025-10-30T18:25:53.484Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.rpmdb-sqlite
18:25:54 [2025-10-30T18:25:54.042Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.check-symlink
18:25:55 [2025-10-30T18:25:55.929Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.network-online-service
18:25:57 [2025-10-30T18:25:57.288Z] === RUN   non-exclusive-test-bucket-0/ext.config.selinux.unmodified-policy
18:25:59 [2025-10-30T18:25:59.170Z] === RUN   non-exclusive-test-bucket-0/ext.config.ntp.chrony.coreos-platform-chrony-config
18:26:00 [2025-10-30T18:26:00.536Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.remove-manifest-files
18:26:01 [2025-10-30T18:26:01.095Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.nm-ifcfg-rh-plugin
18:26:02 [2025-10-30T18:26:02.982Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.license
18:26:04 [2025-10-30T18:26:04.338Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.initrd.executables
18:26:09 [2025-10-30T18:26:09.561Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.tmpfs
18:26:09 [2025-10-30T18:26:09.561Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.dnsmasq-service
18:26:11 [2025-10-30T18:26:11.438Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.tls
18:26:12 [2025-10-30T18:26:12.360Z] --- PASS: ext.config.networking.kargs-rd-net (27.91s)
18:26:14 [2025-10-30T18:26:14.869Z] === RUN   non-exclusive-test-bucket-0/ext.config.selinux.stub-resolve-context
18:26:16 [2025-10-30T18:26:16.225Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.fwupd-refresh-timer
18:26:18 [2025-10-30T18:26:18.106Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.file-directory-permissions
18:26:19 [2025-10-30T18:26:19.466Z] === RUN   non-exclusive-test-bucket-0/ext.config.boot.bootupd
18:26:21 [2025-10-30T18:26:21.343Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.root-immutable-bit
18:26:22 [2025-10-30T18:26:22.698Z] === RUN   non-exclusive-test-bucket-0/ext.config.rpm-ostree.container-deps
18:26:24 [2025-10-30T18:26:24.577Z] === RUN   non-exclusive-test-bucket-0/ext.config.podman.dns
18:26:29 [2025-10-30T18:26:29.802Z] === RUN   non-exclusive-test-bucket-0/ext.config.systemd.default-unit-timeouts
18:26:30 [2025-10-30T18:26:30.723Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.fcos_groups
18:26:32 [2025-10-30T18:26:32.079Z] === RUN   non-exclusive-test-bucket-0/ext.config.logging.printk
18:26:32 [2025-10-30T18:26:32.333Z] --- PASS: ext.config.multipath.resilient (45.53s)
18:26:32 [2025-10-30T18:26:32.591Z] === RUN   rpmostree.install-uninstall/install
18:26:33 [2025-10-30T18:26:33.949Z] === RUN   non-exclusive-test-bucket-0/ext.config.security.passwd
18:26:35 [2025-10-30T18:26:35.305Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.no-google-device-links
18:26:35 [2025-10-30T18:26:35.864Z] === RUN   non-exclusive-test-bucket-0/ext.config.containers.cgroups-v2
18:26:37 [2025-10-30T18:26:37.748Z] === RUN   non-exclusive-test-bucket-0/ext.config.selinux.file-context-policy-match
18:26:40 [2025-10-30T18:26:40.257Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.aleph-version
18:26:42 [2025-10-30T18:26:42.138Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.amd-ucode-firmware
18:26:42 [2025-10-30T18:26:42.393Z] --- PASS: ext.config.networking.rd-net-timeout-carrier (59.03s)
18:26:42 [2025-10-30T18:26:42.393Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.setuid
18:26:44 [2025-10-30T18:26:44.282Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.kernel-headers
18:26:44 [2025-10-30T18:26:44.538Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.console-config
18:26:46 [2025-10-30T18:26:46.422Z] === RUN   non-exclusive-test-bucket-0/ext.config.kubernetes.kube-watch
18:26:48 [2025-10-30T18:26:48.936Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.nic-naming
18:26:50 [2025-10-30T18:26:50.825Z] === RUN   non-exclusive-test-bucket-0/ext.config.systemd.no-systemd-firstboot
18:26:52 [2025-10-30T18:26:52.190Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.systemd-repart-service
18:26:52 [2025-10-30T18:26:52.750Z] === RUN   rpmostree.upgrade-rollback/upgrade
18:26:53 [2025-10-30T18:26:53.679Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.nm-start
18:26:55 [2025-10-30T18:26:55.561Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.root-boot-ro
18:26:56 [2025-10-30T18:26:56.924Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.root-bash
18:26:57 [2025-10-30T18:26:57.481Z] === RUN   non-exclusive-test-bucket-0/ext.config.kubernetes.systemd-env-read
18:26:59 [2025-10-30T18:26:59.369Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.partition-scheme
18:27:00 [2025-10-30T18:27:00.727Z] === RUN   non-exclusive-test-bucket-0/ext.config.clhm.network-device-info
18:27:01 [2025-10-30T18:27:01.284Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.nm-dhcp-client
18:27:02 [2025-10-30T18:27:02.641Z] === RUN   rpmostree.install-uninstall/uninstall
18:27:02 [2025-10-30T18:27:02.894Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.default-network-behavior-change
18:27:04 [2025-10-30T18:27:04.777Z] === RUN   non-exclusive-test-bucket-0/ext.config.swap.zram-default
18:27:06 [2025-10-30T18:27:06.143Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.system-generators
18:27:08 [2025-10-30T18:27:08.028Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.sudoers
18:27:08 [2025-10-30T18:27:08.283Z] --- PASS: ext.config.security.lockdown (26.04s)
18:27:09 [2025-10-30T18:27:09.644Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.root-prjquota
18:27:11 [2025-10-30T18:27:11.000Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.fcos_users
18:27:12 [2025-10-30T18:27:12.882Z] === RUN   non-exclusive-test-bucket-0/ext.config.security.lockdown_no_sb
18:27:14 [2025-10-30T18:27:14.240Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.etc-permissions
18:27:15 [2025-10-30T18:27:15.599Z] === RUN   rpmostree.upgrade-rollback/rollback
18:27:15 [2025-10-30T18:27:15.852Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.initrd.compression
18:27:17 [2025-10-30T18:27:17.737Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.logrotate-service
18:27:19 [2025-10-30T18:27:19.093Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.growfs
18:27:19 [2025-10-30T18:27:19.649Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.setgid
18:27:21 [2025-10-30T18:27:21.533Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.yum-repo-dir
18:27:22 [2025-10-30T18:27:22.894Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.no-default-initramfs-net-propagation.default
18:27:24 [2025-10-30T18:27:24.775Z] === RUN   non-exclusive-test-bucket-0/ext.config.ignition.journald-log
18:27:26 [2025-10-30T18:27:26.140Z] === RUN   non-exclusive-test-bucket-0/ext.config.selinux.usrlocal-context
18:27:28 [2025-10-30T18:27:28.022Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.resolv.systemd-resolved
18:27:29 [2025-10-30T18:27:29.378Z] === RUN   non-exclusive-test-bucket-0/ext.config.content-origins
18:27:31 [2025-10-30T18:27:31.256Z] === RUN   non-exclusive-test-bucket-0/ext.config.security.coreos-update-ca-trust
18:27:32 [2025-10-30T18:27:32.612Z] === RUN   non-exclusive-test-bucket-0/ext.config.podman.rootless-pasta-networking
18:27:33 [2025-10-30T18:27:33.969Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.validate-symlinks
18:27:40 [2025-10-30T18:27:40.493Z] --- PASS: rpmostree.upgrade-rollback (67.58s)
18:27:40 [2025-10-30T18:27:40.493Z]     --- PASS: rpmostree.upgrade-rollback/upgrade (22.92s)
18:27:40 [2025-10-30T18:27:40.493Z]     --- PASS: rpmostree.upgrade-rollback/rollback (21.02s)
18:27:42 [2025-10-30T18:27:42.376Z] --- PASS: rpmostree.install-uninstall (90.21s)
18:27:42 [2025-10-30T18:27:42.376Z]     --- PASS: rpmostree.install-uninstall/install (30.08s)
18:27:42 [2025-10-30T18:27:42.376Z]     --- PASS: rpmostree.install-uninstall/uninstall (36.33s)
18:27:43 [2025-10-30T18:27:43.739Z] === RUN   non-exclusive-test-bucket-0/ext.config.composefs.enabled
18:27:45 [2025-10-30T18:27:45.629Z] === RUN   non-exclusive-test-bucket-0/ext.config.selinux.podman-tmpfs-context
18:27:50 [2025-10-30T18:27:50.869Z] === RUN   non-exclusive-test-bucket-0/ext.config.firewall.iptables
18:27:50 [2025-10-30T18:27:50.869Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.initrd.expected-contents
18:27:56 [2025-10-30T18:27:56.103Z] === RUN   non-exclusive-test-bucket-0/ext.config.kdump.service
18:28:00 [2025-10-30T18:28:00.254Z] --- PASS: non-exclusive-test-bucket-0 (174.15s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.rpmdb-sqlite (0.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.check-symlink (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.networking.network-online-service (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.selinux.unmodified-policy (1.58s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.ntp.chrony.coreos-platform-chrony-config (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.remove-manifest-files (0.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.networking.nm-ifcfg-rh-plugin (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.license (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.initrd.executables (4.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.disks.tmpfs (0.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.networking.dnsmasq-service (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.networking.tls (3.61s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.selinux.stub-resolve-context (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.fwupd-refresh-timer (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.file-directory-permissions (1.61s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.boot.bootupd (1.62s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.root-immutable-bit (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.rpm-ostree.container-deps (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.podman.dns (4.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.systemd.default-unit-timeouts (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.fcos_groups (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.logging.printk (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.security.passwd (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.disks.no-google-device-links (0.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.containers.cgroups-v2 (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.selinux.file-context-policy-match (2.66s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.aleph-version (1.61s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.amd-ucode-firmware (0.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.setuid (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.kernel-headers (0.64s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.console-config (1.63s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.kubernetes.kube-watch (2.61s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.networking.nic-naming (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.systemd.no-systemd-firstboot (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.disks.systemd-repart-service (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.networking.nm-start (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.disks.root-boot-ro (1.62s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.root-bash (0.62s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.kubernetes.systemd-env-read (1.61s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.disks.partition-scheme (1.61s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.clhm.network-device-info (0.61s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.networking.nm-dhcp-client (1.68s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.networking.default-network-behavior-change (1.62s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.swap.zram-default (1.62s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.system-generators (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.sudoers (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.disks.root-prjquota (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.fcos_users (1.69s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.security.lockdown_no_sb (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.etc-permissions (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.initrd.compression (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.logrotate-service (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.disks.growfs (0.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.setgid (1.62s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.yum-repo-dir (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.networking.no-default-initramfs-net-propagation.default (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.ignition.journald-log (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.selinux.usrlocal-context (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.networking.resolv.systemd-resolved (1.59s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.content-origins (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.security.coreos-update-ca-trust (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.podman.rootless-pasta-networking (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.validate-symlinks (9.76s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.composefs.enabled (1.60s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.selinux.podman-tmpfs-context (4.61s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.firewall.iptables (0.62s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.initrd.expected-contents (4.64s)
18:28:00 [2025-10-30T18:28:00.254Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.kdump.service (1.61s)
18:28:02 [2025-10-30T18:28:02.761Z] --- PASS: ext.config.toolbox (54.18s)
18:28:24 [2025-10-30T18:28:24.626Z] --- PASS: ext.config.reboot (43.38s)
18:30:30 [2025-10-30T18:30:30.987Z] === RUN   podman.workflow/exec
18:30:30 [2025-10-30T18:30:30.987Z] === RUN   podman.workflow/stop
18:30:31 [2025-10-30T18:30:31.908Z] === RUN   podman.workflow/remove
18:30:32 [2025-10-30T18:30:32.163Z] === RUN   podman.workflow/delete
18:30:36 [2025-10-30T18:30:36.312Z] --- PASS: podman.workflow (340.74s)
18:30:36 [2025-10-30T18:30:36.312Z]     --- PASS: podman.workflow/run (305.18s)
18:30:36 [2025-10-30T18:30:36.312Z]             cluster.go:151: Trying to pull quay.io/fedora/fedora:latest...
18:30:36 [2025-10-30T18:30:36.312Z]             cluster.go:151: Getting image source signatures
18:30:36 [2025-10-30T18:30:36.312Z]             cluster.go:151: Copying blob sha256:fca981865dd2a58760e8e166980035fc99050f175595e2ed56d9b060035845ca
18:30:36 [2025-10-30T18:30:36.312Z]             cluster.go:151: Copying config sha256:7c53670e6c3ba41c7ee4cc37fdd6a4ab6c7287cfbd9de3617db9e043664b9abc
18:30:36 [2025-10-30T18:30:36.312Z]             cluster.go:151: Writing manifest to image destination
18:30:36 [2025-10-30T18:30:36.312Z]     --- PASS: podman.workflow/exec (0.32s)
18:30:36 [2025-10-30T18:30:36.312Z]     --- PASS: podman.workflow/stop (10.53s)
18:30:36 [2025-10-30T18:30:36.312Z]     --- PASS: podman.workflow/remove (0.45s)
18:30:36 [2025-10-30T18:30:36.312Z]     --- PASS: podman.workflow/delete (0.54s)
18:30:36 [2025-10-30T18:30:36.312Z] FAIL, output in /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-x86_64
18:30:36 [2025-10-30T18:30:36.312Z] 
18:30:36 [2025-10-30T18:30:36.312Z] 
18:30:36 [2025-10-30T18:30:36.312Z] ======== Re-running failed tests (flake detection) ========
18:30:36 [2025-10-30T18:30:36.312Z] 
18:30:36 [2025-10-30T18:30:36.312Z] 🕒  Snoozing kola test pattern "coreos.unique.boot.failure" until Nov 10 2025
18:30:36 [2025-10-30T18:30:36.312Z]   👉 https://github.com/coreos/fedora-coreos-tracker/issues/2019
18:30:36 [2025-10-30T18:30:36.312Z] === RUN   ext.config.files.alternatives
18:31:08 [2025-10-30T18:31:08.304Z] systemctl status kola-runext.service:
18:31:08 [2025-10-30T18:31:08.304Z] × kola-runext.service
18:31:08 [2025-10-30T18:31:08.304Z]      Loaded: loaded (/etc/systemd/system/kola-runext.service; static)
18:31:08 [2025-10-30T18:31:08.304Z]     Drop-In: /usr/lib/systemd/system/service.d
18:31:08 [2025-10-30T18:31:08.304Z]              └─10-timeout-abort.conf
18:31:08 [2025-10-30T18:31:08.304Z]      Active: failed (Result: exit-code) since Thu 2025-10-30 18:31:04 UTC; 278ms ago
18:31:08 [2025-10-30T18:31:08.304Z]    Duration: 8.059s
18:31:08 [2025-10-30T18:31:08.304Z]  Invocation: 238a23bfb9504fd5b811bcb07b224955
18:31:08 [2025-10-30T18:31:08.304Z]     Process: 2046 ExecStart=/usr/local/bin/kola-runext-alternatives (code=exited, status=1/FAILURE)
18:31:08 [2025-10-30T18:31:08.304Z]    Main PID: 2046 (code=exited, status=1/FAILURE)
18:31:08 [2025-10-30T18:31:08.304Z]    Mem peak: 5.3M
18:31:08 [2025-10-30T18:31:08.304Z]         CPU: 36ms
18:31:08 [2025-10-30T18:31:08.304Z] 
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ PRETTY_NAME='Fedora CoreOS 44.20251030.dev.0'
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ ANSI_COLOR='0;38;2;60;110;180'
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ LOGO=fedora-logo-icon
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ CPE_NAME=cpe:/o:fedoraproject:fedora:44
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ HOME_URL=https://getfedora.org/coreos/
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ DOCUMENTATION_URL=https://docs.fedoraproject.org/en-US/fedora-coreos/
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ SUPPORT_URL=https://github.com/coreos/fedora-coreos-tracker/
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ BUG_REPORT_URL=https://github.com/coreos/fedora-coreos-tracker/
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ REDHAT_BUGZILLA_PRODUCT=Fedora
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ REDHAT_BUGZILLA_PRODUCT_VERSION=rawhide
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ REDHAT_SUPPORT_PRODUCT=Fedora
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ REDHAT_SUPPORT_PRODUCT_VERSION=rawhide
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ SUPPORT_END=2027-05-19
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ VARIANT=CoreOS
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ VARIANT_ID=coreos
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ OSTREE_VERSION=44.20251030.dev.0
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: +++ IMAGE_VERSION=44.20251030.dev.0
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: ++ '[' fedora == fedora ']'
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: ++ '[' coreos == coreos ']'
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2047]: ++ echo 44
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2046]: + '[' 44 -le 43 ']'
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2046]: + [[ -e /var/lib/alternatives ]]
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2046]: + [[ ! -d /etc/alternatives ]]
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2046]: + [[ ! -d /etc/alternatives-admindir ]]
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2046]: + rpm-ostree install --apply-live iptables-legacy
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:30:56 qemu0 kola-runext-alternatives[2048]: notice: auto-inferring -y/--assumeyes when not run interactively; this will change in the future
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:00 qemu0 kola-runext-alternatives[2048]: Checking out tree d6829f0...done
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:00 qemu0 kola-runext-alternatives[2048]: Enabled rpm-md repositories: fedora-cisco-openh264 rawhide
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:00 qemu0 kola-runext-alternatives[2048]: Updating metadata for 'fedora-cisco-openh264'...done
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:01 qemu0 kola-runext-alternatives[2048]: Updating metadata for 'rawhide'...done
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:04 qemu0 kola-runext-alternatives[2048]: Importing rpm-md...done
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:04 qemu0 kola-runext-alternatives[2048]: rpm-md repo 'fedora-cisco-openh264'; generated: 2025-08-13T16:56:53Z solvables: 0
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:04 qemu0 kola-runext-alternatives[2048]: rpm-md repo 'rawhide'; generated: 2025-10-30T05:43:40Z solvables: 77355
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:04 qemu0 kola-runext-alternatives[2048]: Resolving dependencies...done
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:04 qemu0 kola-runext-alternatives[2048]: error: Could not depsolve transaction; 1 problem detected:
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:04 qemu0 kola-runext-alternatives[2048]:  Problem: cannot install both iptables-libs-1.8.11-12.fc44.x86_64 from rawhide and iptables-libs-1.8.11-11.fc43.x86_64 from @System
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:04 qemu0 kola-runext-alternatives[2048]:   - package iptables-legacy-1.8.11-12.fc44.x86_64 from rawhide requires iptables-libs(x86-64) = 1.8.11-12.fc44, but none of the providers can be installed
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:04 qemu0 kola-runext-alternatives[2048]:   - conflicting requests
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:04 qemu0 systemd[1]: kola-runext.service: Main process exited, code=exited, status=1/FAILURE
18:31:08 [2025-10-30T18:31:08.304Z] Oct 30 18:31:04 qemu0 systemd[1]: kola-runext.service: Failed with result 'exit-code'.
18:31:08 [2025-10-30T18:31:08.304Z] --- FAIL: ext.config.files.alternatives (32.09s)
18:31:08 [2025-10-30T18:31:08.304Z]         harness.go:1309: kolet failed: : kolet run-test-unit failed:  Error: Unit kola-runext.service exited with code 1
18:31:08 [2025-10-30T18:31:08.304Z] 2025-10-30T18:31:04Z cli: Unit kola-runext.service exited with code 1: Process exited with status 1
18:31:08 [2025-10-30T18:31:08.304Z] FAIL, output in /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-x86_64/rerun
18:31:08 [2025-10-30T18:31:08.304Z] Error: harness: test suite failed
18:31:08 [2025-10-30T18:31:08.304Z] 2025-10-30T18:31:08Z cli: harness: test suite failed
18:31:08 [2025-10-30T18:31:08.304Z] failed to execute cmd-kola: exit status 1
18:31:08 [2025-10-30T18:31:08.561Z] [Pipeline] }
18:31:08 [2025-10-30T18:31:08.563Z] [Pipeline] // withEnv
18:31:08 [2025-10-30T18:31:08.567Z] [Pipeline] error
18:31:08 [2025-10-30T18:31:08.568Z] [Pipeline] }
18:31:08 [2025-10-30T18:31:08.568Z] Failed in branch x86_64:kola
18:31:08 [2025-10-30T18:31:08.570Z] [Pipeline] // parallel
18:31:08 [2025-10-30T18:31:08.573Z] [Pipeline] withEnv
18:31:08 [2025-10-30T18:31:08.573Z] [Pipeline] {
18:31:08 [2025-10-30T18:31:08.577Z] [Pipeline] sh
18:31:09 [2025-10-30T18:31:09.058Z] + set -xeuo pipefail
18:31:09 [2025-10-30T18:31:09.058Z] ++ umask
18:31:09 [2025-10-30T18:31:09.058Z] + '[' 0022 = 0000 ']'
18:31:09 [2025-10-30T18:31:09.058Z] + cd /home/jenkins/agent/workspace/test-override
18:31:09 [2025-10-30T18:31:09.058Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-upgrade-x86_64
18:31:09 [2025-10-30T18:31:09.059Z] [Pipeline] }
18:31:09 [2025-10-30T18:31:09.061Z] [Pipeline] // withEnv
18:31:09 [2025-10-30T18:31:09.066Z] [Pipeline] withEnv
18:31:09 [2025-10-30T18:31:09.066Z] [Pipeline] {
18:31:09 [2025-10-30T18:31:09.069Z] [Pipeline] sh
18:31:09 [2025-10-30T18:31:09.550Z] + set -xeuo pipefail
18:31:09 [2025-10-30T18:31:09.550Z] ++ umask
18:31:09 [2025-10-30T18:31:09.550Z] + '[' 0022 = 0000 ']'
18:31:09 [2025-10-30T18:31:09.551Z] + cd /home/jenkins/agent/workspace/test-override
18:31:09 [2025-10-30T18:31:09.551Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E -c --xz kola-upgrade-x86_64
18:31:09 [2025-10-30T18:31:09.806Z] [Pipeline] }
18:31:09 [2025-10-30T18:31:09.808Z] [Pipeline] // withEnv
18:31:09 [2025-10-30T18:31:09.813Z] [Pipeline] archiveArtifacts
18:31:09 [2025-10-30T18:31:09.815Z] Archiving artifacts
18:31:09 [2025-10-30T18:31:09.841Z] [Pipeline] withEnv
18:31:09 [2025-10-30T18:31:09.841Z] [Pipeline] {
18:31:09 [2025-10-30T18:31:09.843Z] [Pipeline] sh
18:31:10 [2025-10-30T18:31:10.332Z] + set -xeuo pipefail
18:31:10 [2025-10-30T18:31:10.332Z] ++ umask
18:31:10 [2025-10-30T18:31:10.332Z] + '[' 0022 = 0000 ']'
18:31:10 [2025-10-30T18:31:10.332Z] + cd /home/jenkins/agent/workspace/test-override
18:31:10 [2025-10-30T18:31:10.332Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-upgrade-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-upgrade-x86_64 --output -
18:31:10 [2025-10-30T18:31:10.333Z] [Pipeline] }
18:31:10 [2025-10-30T18:31:10.335Z] [Pipeline] // withEnv
18:31:10 [2025-10-30T18:31:10.340Z] [Pipeline] junit
18:31:10 [2025-10-30T18:31:10.341Z] Recording test results
18:31:10 [2025-10-30T18:31:10.795Z] None of the test reports contained any result
18:31:10 [2025-10-30T18:31:10.796Z] [Pipeline] withEnv
18:31:10 [2025-10-30T18:31:10.796Z] [Pipeline] {
18:31:10 [2025-10-30T18:31:10.798Z] [Pipeline] sh
18:31:11 [2025-10-30T18:31:11.320Z] + set -xeuo pipefail
18:31:11 [2025-10-30T18:31:11.320Z] ++ umask
18:31:11 [2025-10-30T18:31:11.320Z] + '[' 0022 = 0000 ']'
18:31:11 [2025-10-30T18:31:11.320Z] + cd /home/jenkins/agent/workspace/test-override
18:31:11 [2025-10-30T18:31:11.320Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-x86_64
18:31:11 [2025-10-30T18:31:11.322Z] [Pipeline] }
18:31:11 [2025-10-30T18:31:11.324Z] [Pipeline] // withEnv
18:31:11 [2025-10-30T18:31:11.329Z] [Pipeline] withEnv
18:31:11 [2025-10-30T18:31:11.329Z] [Pipeline] {
18:31:11 [2025-10-30T18:31:11.331Z] [Pipeline] sh
18:31:11 [2025-10-30T18:31:11.812Z] + set -xeuo pipefail
18:31:11 [2025-10-30T18:31:11.812Z] ++ umask
18:31:11 [2025-10-30T18:31:11.812Z] + '[' 0022 = 0000 ']'
18:31:11 [2025-10-30T18:31:11.812Z] + cd /home/jenkins/agent/workspace/test-override
18:31:11 [2025-10-30T18:31:11.812Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E -c --xz kola-x86_64
18:31:15 [2025-10-30T18:31:15.968Z] [Pipeline] }
18:31:15 [2025-10-30T18:31:15.970Z] [Pipeline] // withEnv
18:31:15 [2025-10-30T18:31:15.975Z] [Pipeline] archiveArtifacts
18:31:15 [2025-10-30T18:31:15.976Z] Archiving artifacts
18:31:17 [2025-10-30T18:31:17.475Z] [Pipeline] withEnv
18:31:17 [2025-10-30T18:31:17.476Z] [Pipeline] {
18:31:17 [2025-10-30T18:31:17.478Z] [Pipeline] sh
18:31:17 [2025-10-30T18:31:17.957Z] + set -xeuo pipefail
18:31:17 [2025-10-30T18:31:17.958Z] ++ umask
18:31:17 [2025-10-30T18:31:17.958Z] + '[' 0022 = 0000 ']'
18:31:17 [2025-10-30T18:31:17.958Z] + cd /home/jenkins/agent/workspace/test-override
18:31:17 [2025-10-30T18:31:17.958Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-eK10E/kola-x86_64 --output -
18:31:17 [2025-10-30T18:31:17.959Z] [Pipeline] }
18:31:17 [2025-10-30T18:31:17.961Z] [Pipeline] // withEnv
18:31:17 [2025-10-30T18:31:17.967Z] [Pipeline] junit
18:31:17 [2025-10-30T18:31:17.968Z] Recording test results
18:31:18 [2025-10-30T18:31:18.078Z] [Pipeline] }
18:31:18 [2025-10-30T18:31:18.078Z] Failed in branch x86_64
18:31:18 [2025-10-30T18:31:18.084Z] [Pipeline] // parallel
18:31:18 [2025-10-30T18:31:18.091Z] [Pipeline] stage
18:31:18 [2025-10-30T18:31:18.091Z] [Pipeline] { (Report Completion)
18:31:18 [2025-10-30T18:31:18.095Z] [Pipeline] withCredentials
18:31:18 [2025-10-30T18:31:18.100Z] Masking supported pattern matches of $RDB_PASSWORD
18:31:18 [2025-10-30T18:31:18.100Z] [Pipeline] {
18:31:18 [2025-10-30T18:31:18.105Z] [Pipeline] withEnv
18:31:18 [2025-10-30T18:31:18.105Z] [Pipeline] {
18:31:18 [2025-10-30T18:31:18.107Z] [Pipeline] sh
18:31:18 [2025-10-30T18:31:18.584Z] + set -xeuo pipefail
18:31:18 [2025-10-30T18:31:18.584Z] ++ umask
18:31:18 [2025-10-30T18:31:18.584Z] + '[' 0022 = 0000 ']'
18:31:18 [2025-10-30T18:31:18.584Z] + /usr/lib/coreos-assembler/resultsdb-report --testcase cosa.build-and-test --testcase-url https://jenkins-coreos-ci.apps.ocp.fedoraproject.org//job/test-override --testrun-url https://jenkins-coreos-ci.apps.ocp.fedoraproject.org/job/test-override/409/display/redirect --outcome FAILED --advisory FEDORA-2025-a5e17614c7 --stream rawhide
18:31:18 [2025-10-30T18:31:18.586Z] [Pipeline] }
18:31:18 [2025-10-30T18:31:18.591Z] [Pipeline] // withEnv
18:31:18 [2025-10-30T18:31:18.596Z] [Pipeline] }
18:31:18 [2025-10-30T18:31:18.598Z] [Pipeline] // withCredentials
18:31:18 [2025-10-30T18:31:18.604Z] [Pipeline] withCredentials
18:31:18 [2025-10-30T18:31:18.612Z] Masking supported pattern matches of $TOKEN
18:31:18 [2025-10-30T18:31:18.612Z] [Pipeline] {
18:31:18 [2025-10-30T18:31:18.615Z] [Pipeline] withEnv
18:31:18 [2025-10-30T18:31:18.615Z] [Pipeline] {
18:31:18 [2025-10-30T18:31:18.619Z] [Pipeline] sh
18:31:19 [2025-10-30T18:31:19.099Z] + set -xeuo pipefail
18:31:19 [2025-10-30T18:31:19.099Z] ++ umask
18:31:19 [2025-10-30T18:31:19.099Z] + '[' 0022 = 0000 ']'
18:31:19 [2025-10-30T18:31:19.099Z] + curl -X POST -H 'Content-Type: application/json' -u **** https://maubot.apps.ocp.fedoraproject.org/plugin/nonbot-coreos/send --silent -d '
18:31:19 [2025-10-30T18:31:19.099Z]            {
18:31:19 [2025-10-30T18:31:19.099Z]              "body": "🔴 kernel-6.18.0-0.rc3.251030ge53642b87a4f4.33.fc44 - [🌊](https://jenkins-coreos-ci.apps.ocp.fedoraproject.org/job/test-override/409/display/redirect) [🪷](https://bodhi.fedoraproject.org/updates/FEDORA-2025-a5e17614c7)"
18:31:19 [2025-10-30T18:31:19.099Z]             }'
18:31:19 [2025-10-30T18:31:19.660Z] [Pipeline] }
18:31:19 [2025-10-30T18:31:19.664Z] [Pipeline] // withEnv
18:31:19 [2025-10-30T18:31:19.668Z] [Pipeline] }
18:31:19 [2025-10-30T18:31:19.671Z] [Pipeline] // withCredentials
18:31:19 [2025-10-30T18:31:19.675Z] [Pipeline] }
18:31:19 [2025-10-30T18:31:19.678Z] [Pipeline] // stage
18:31:19 [2025-10-30T18:31:19.680Z] [Pipeline] }
18:31:19 [2025-10-30T18:31:19.684Z] [Pipeline] // timeout
18:31:19 [2025-10-30T18:31:19.688Z] [Pipeline] }
18:31:19 [2025-10-30T18:31:19.691Z] [Pipeline] // container
18:31:19 [2025-10-30T18:31:19.693Z] [Pipeline] }
18:31:19 [2025-10-30T18:31:19.696Z] [Pipeline] // node
18:31:19 [2025-10-30T18:31:19.698Z] [Pipeline] }
18:31:19 [2025-10-30T18:31:19.702Z] [Pipeline] // podTemplate
18:31:19 [2025-10-30T18:31:19.705Z] [Pipeline] End of Pipeline
18:31:19 [2025-10-30T18:31:19.715Z] ERROR: Script returned exit code 1
18:31:19 [2025-10-30T18:31:19.730Z] Finished: FAILURE