[54.370969] Initializing watchdogs
[54.371022]   /dev/watchdog0
[54.385455] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[54.389517] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.391749] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.395233] [001/133] (960s left) gem_exec_reloc (basic-write-read)
[54.482632] Subtest basic-write-read: SKIP (0.000s)
[54.547673] [002/133] (960s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[54.605709] Starting subtest: invalid-multi-wait-unsubmitted
[54.608119] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[54.719296] [003/133] (960s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[54.803097] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[54.805375] Starting dynamic subtest: pipe-A-eDP-1
[54.814347] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[54.821411] Starting dynamic subtest: pipe-B-eDP-1
[54.830528] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[54.838641] Starting dynamic subtest: pipe-C-eDP-1
[54.846808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[54.852995] Starting dynamic subtest: pipe-D-eDP-1
[54.861449] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[54.865513] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[57.040173] [004/133] (957s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[57.094885] Starting subtest: y-tiled-ccs-to-yf-tiled
[57.099581] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[57.288412] [005/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[57.373298] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[57.377849] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[57.461293] [006/133] (957s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[57.538117] Starting subtest: 4-tiled-64bpp-rotate-180
[59.183360] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.636s)
[59.361403] [007/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[59.437312] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[59.440967] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[59.537951] [008/133] (955s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[59.615337] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[59.618687] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[59.680993] [009/133] (955s left) gem_exec_balancer (fairslice)
[59.745191] Starting subtest: fairslice
[62.632367] Subtest fairslice: SUCCESS (2.873s)
[63.895914] [010/133] (951s left) kms_invalid_mode (bad-htotal)
[63.977405] Starting subtest: bad-htotal
[63.979710] Starting dynamic subtest: pipe-A-eDP-1
[64.263417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[64.272653] Starting dynamic subtest: pipe-B-eDP-1
[64.275065] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[64.282084] Starting dynamic subtest: pipe-C-eDP-1
[64.284286] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[64.290988] Starting dynamic subtest: pipe-D-eDP-1
[64.292873] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[64.294807] Subtest bad-htotal: SUCCESS (0.291s)
[65.104084] [011/133] (950s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[65.199233] Starting subtest: yf-tiled-32bpp-rotate-180
[65.203229] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[65.292614] [012/133] (950s left) kms_content_protection (atomic-hdcp14)
[65.406977] Starting subtest: atomic-hdcp14
[65.411611] Subtest atomic-hdcp14: SKIP (0.000s)
[65.519232] [013/133] (949s left) i915_selftest (mock)
[68.092033] Starting subtest: mock
[68.094728] Starting dynamic subtest: sanitycheck
[68.752576] Dynamic subtest sanitycheck: SUCCESS (0.660s)
[68.762270] Starting dynamic subtest: shmem
[69.404347] Dynamic subtest shmem: SUCCESS (0.650s)
[69.413221] Starting dynamic subtest: fence
[76.935283] Dynamic subtest fence: SUCCESS (7.523s)
[76.943632] Starting dynamic subtest: scatterlist
[78.605237] Dynamic subtest scatterlist: SUCCESS (1.668s)
[78.614482] Starting dynamic subtest: syncmap
[81.732651] Dynamic subtest syncmap: SUCCESS (3.124s)
[81.741247] Starting dynamic subtest: uncore
[82.413945] Dynamic subtest uncore: SUCCESS (0.681s)
[82.423249] Starting dynamic subtest: ring
[83.060333] Dynamic subtest ring: SUCCESS (0.645s)
[83.069315] Starting dynamic subtest: engine
[83.707243] Dynamic subtest engine: SUCCESS (0.646s)
[83.716385] Starting dynamic subtest: timelines
[87.558943] Dynamic subtest timelines: SUCCESS (3.848s)
[87.567516] Starting dynamic subtest: requests
[91.057948] Dynamic subtest requests: SUCCESS (3.497s)
[91.066725] Starting dynamic subtest: objects
[91.772131] Dynamic subtest objects: SUCCESS (0.714s)
[91.780020] Starting dynamic subtest: phys
[92.556043] Dynamic subtest phys: SUCCESS (0.782s)
[92.564643] Starting dynamic subtest: dmabuf
[93.293115] Dynamic subtest dmabuf: SUCCESS (0.737s)
[93.301788] Starting dynamic subtest: vma
[98.830784] Dynamic subtest vma: SUCCESS (5.535s)
[98.838023] Starting dynamic subtest: evict
[100.198866] Dynamic subtest evict: SUCCESS (1.367s)
[100.207307] Starting dynamic subtest: gtt
[103.781467] Dynamic subtest gtt: SUCCESS (3.581s)
[103.790128] Starting dynamic subtest: hugepages
[104.638596] Dynamic subtest hugepages: SUCCESS (0.857s)
[104.647049] Starting dynamic subtest: memory_region
[107.049666] Dynamic subtest memory_region: SUCCESS (2.409s)
[107.052517] Subtest mock: SUCCESS (38.938s)
[107.093882] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[107.096884] [014/133] (908s left) fbdev (unaligned-read)
[108.531766] Starting subtest: unaligned-read
[108.546230] Subtest unaligned-read: SUCCESS (0.016s)
[108.579758] [FACT fbdev (unaligned-read)] new: kernel.kmod_is_loaded.i915: true
[108.583290] [015/133] (906s left) perf_pmu (busy-accuracy-50)
[108.629773] Starting subtest: busy-accuracy-50
[108.632125] Starting dynamic subtest: rcs0
[110.167089] Dynamic subtest rcs0: SUCCESS (1.534s)
[110.177528] Starting dynamic subtest: bcs0
[111.709702] Dynamic subtest bcs0: SUCCESS (1.542s)
[111.719632] Starting dynamic subtest: vcs0
[113.249507] Dynamic subtest vcs0: SUCCESS (1.539s)
[113.257858] Starting dynamic subtest: vcs1
[114.797145] Dynamic subtest vcs1: SUCCESS (1.546s)
[114.805765] Starting dynamic subtest: vecs0
[116.338609] Dynamic subtest vecs0: SUCCESS (1.539s)
[116.349185] Starting dynamic subtest: ccs0
[117.882331] Dynamic subtest ccs0: SUCCESS (1.543s)
[117.884745] Subtest busy-accuracy-50: SUCCESS (9.249s)
[117.995719] [016/133] (897s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[118.081784] Starting subtest: plane-upscale-factor-0-25-with-rotation
[118.084117] Starting dynamic subtest: pipe-A
[118.321476] Dynamic subtest pipe-A: SUCCESS (0.241s)
[118.331847] Starting dynamic subtest: pipe-B
[119.597452] Dynamic subtest pipe-B: SUCCESS (1.275s)
[119.607672] Starting dynamic subtest: pipe-C
[120.929379] Dynamic subtest pipe-C: SUCCESS (1.332s)
[120.939456] Starting dynamic subtest: pipe-D
[122.256255] Dynamic subtest pipe-D: SUCCESS (1.327s)
[122.258694] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.176s)
[123.437603] [017/133] (892s left) gem_userptr_blits (sync-unmap-cycles)
[123.503429] Starting subtest: sync-unmap-cycles
[128.871826] Subtest sync-unmap-cycles: SUCCESS (5.369s)
[129.000034] [018/133] (886s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[129.085903] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[129.089626] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[129.165090] [019/133] (886s left) gem_ctx_param (basic-default)
[129.218197] Starting subtest: basic-default
[129.220081] Subtest basic-default: SUCCESS (0.000s)
[129.280239] [020/133] (886s left) syncobj_basic (bad-pad-handle-to-fd)
[129.328120] Starting subtest: bad-pad-handle-to-fd
[129.329964] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[129.421120] [021/133] (886s left) perf_pmu (render-node-busy-idle)
[129.489264] Starting subtest: render-node-busy-idle
[129.491267] Starting dynamic subtest: rcs0
[130.167831] Dynamic subtest rcs0: SUCCESS (0.678s)
[130.178388] Starting dynamic subtest: bcs0
[130.835097] Dynamic subtest bcs0: SUCCESS (0.666s)
[130.846104] Starting dynamic subtest: vcs0
[132.824718] Dynamic subtest vcs0: SUCCESS (1.987s)
[132.835864] Starting dynamic subtest: vcs1
[134.874240] Dynamic subtest vcs1: SUCCESS (2.048s)
[134.885380] Starting dynamic subtest: vecs0
[136.856619] Dynamic subtest vecs0: SUCCESS (1.981s)
[136.867700] Starting dynamic subtest: ccs0
[137.520633] Dynamic subtest ccs0: SUCCESS (0.664s)
[137.523093] Subtest render-node-busy-idle: SUCCESS (8.031s)
[137.593243] [022/133] (878s left) kms_cursor_edge_walk (128x128-left-edge)
[137.685988] Starting subtest: 128x128-left-edge
[137.688192] Starting dynamic subtest: pipe-A-eDP-1
[141.108065] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[141.117150] Starting dynamic subtest: pipe-D-eDP-1
[144.240445] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[144.242897] Subtest 128x128-left-edge: SUCCESS (6.555s)
[145.037426] [023/133] (870s left) kms_addfb_basic (unused-modifier)
[145.102698] Starting subtest: unused-modifier
[145.104857] Subtest unused-modifier: SUCCESS (0.000s)
[145.218445] [024/133] (870s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[145.306161] Starting subtest: fbc-farfromfence-mmap-gtt
[145.310202] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[145.399413] [025/133] (870s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[145.478823] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[146.247694] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s)
[146.416101] [026/133] (869s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[146.480690] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[146.485312] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[146.675628] [027/133] (869s left) kms_lease (lease-revoke)
[146.739191] Starting subtest: lease-revoke
[146.741506] Starting dynamic subtest: pipe-A-eDP-1
[146.770121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[146.780185] Starting dynamic subtest: pipe-B-eDP-1
[146.796986] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[146.805695] Starting dynamic subtest: pipe-C-eDP-1
[146.824340] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[146.833251] Starting dynamic subtest: pipe-D-eDP-1
[146.855673] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[146.857989] Subtest lease-revoke: SUCCESS (0.118s)
[146.974209] [028/133] (868s left) kms_properties (colorop-properties-atomic)
[147.035876] Starting subtest: colorop-properties-atomic
[147.038133] Starting dynamic subtest: pipe-A-eDP-1
[147.373068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.336s)
[147.382399] Starting dynamic subtest: pipe-B-eDP-1
[148.438071] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.065s)
[148.447080] Starting dynamic subtest: pipe-C-eDP-1
[149.545663] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[149.554895] Starting dynamic subtest: pipe-D-eDP-1
[150.582788] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.036s)
[150.585173] Subtest colorop-properties-atomic: SUCCESS (3.548s)
[151.398538] [029/133] (864s left) gem_exec_whisper (basic-forked-all)
[151.464781] Starting subtest: basic-forked-all
[164.795232] Subtest basic-forked-all: SUCCESS (13.328s)
[164.973336] [030/133] (851s left) syncobj_timeline (signal-array)
[165.038769] Starting subtest: signal-array
[165.041056] Subtest signal-array: SUCCESS (0.000s)
[165.162266] [031/133] (850s left) kms_flip (2x-busy-flip)
[165.234647] Starting subtest: 2x-busy-flip
[165.241528] Subtest 2x-busy-flip: SKIP (0.008s)
[165.317394] [032/133] (850s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[165.387645] Starting subtest: fbc-rgb565-draw-mmap-gtt
[165.391983] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[165.480450] [033/133] (850s left) kms_psr (psr2-primary-render)
[165.554842] Starting subtest: psr2-primary-render
[165.557086] Starting dynamic subtest: eDP-1
[167.272962] Dynamic subtest eDP-1: SUCCESS (1.718s)
[167.275309] Subtest psr2-primary-render: SUCCESS (1.718s)
[168.137101] [034/133] (848s left) gem_exec_reloc (basic-wc-cpu)
[168.201473] Subtest basic-wc-cpu: SKIP (0.000s)
[168.272411] [035/133] (847s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[168.368170] Starting subtest: flip-vs-cursor-toggle
[176.856400] Subtest flip-vs-cursor-toggle: SUCCESS (8.488s)
[177.663961] [036/133] (838s left) kms_getfb (getfb-reject-nv12)
[177.739804] Starting subtest: getfb-reject-nv12
[177.742238] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[177.829722] [037/133] (838s left) kms_sequence (get-forked-busy)
[177.912680] Starting subtest: get-forked-busy
[177.915030] Starting dynamic subtest: pipe-A-eDP-1
[179.847369] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[179.856671] Starting dynamic subtest: pipe-B-eDP-1
[182.495092] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.645s)
[182.504533] Starting dynamic subtest: pipe-C-eDP-1
[185.101377] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.606s)
[185.110995] Starting dynamic subtest: pipe-D-eDP-1
[187.724610] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[187.726615] Subtest get-forked-busy: SUCCESS (9.812s)
[188.517100] [038/133] (827s left) gen7_exec_parse (basic-rejected)
[188.580671] Subtest basic-rejected: SKIP (0.000s)
[188.647803] [039/133] (827s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[188.743184] Starting subtest: cursorA-vs-flipA-varying-size
[199.894127] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.147s)
[200.768254] [040/133] (815s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[200.828457] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[200.933471] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[201.018298] [041/133] (815s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[201.119691] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[212.281131] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.159s)
[213.083321] [042/133] (803s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[213.378661] Starting subtest: cursor-rapid-movement-max-size
[213.385823] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[213.505818] [043/133] (802s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[213.568136] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[213.595745] Starting dynamic subtest: pipe-A-plane-0
[214.253548] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[214.262498] Starting dynamic subtest: pipe-A-plane-3
[214.683765] Dynamic subtest pipe-A-plane-3: SUCCESS (0.431s)
[215.773079] Starting dynamic subtest: pipe-B-plane-0
[216.454771] Dynamic subtest pipe-B-plane-0: SUCCESS (0.688s)
[216.463089] Starting dynamic subtest: pipe-B-plane-3
[216.865414] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[217.174464] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.606s)
[218.047452] [044/133] (798s left) i915_drm_fdinfo (virtual-busy-all)
[218.088193] Starting subtest: virtual-busy-all
[218.092662] Subtest virtual-busy-all: SKIP (0.000s)
[218.161877] [045/133] (798s left) syncobj_basic (bad-fd-to-handle)
[218.209538] Starting subtest: bad-fd-to-handle
[218.211479] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[218.307506] [046/133] (798s left) sriov_basic (enable-vfs-bind-unbind-each)
[218.366923] Starting subtest: enable-vfs-bind-unbind-each
[218.368868] Starting dynamic subtest: numvfs-1
[218.443829] Dynamic subtest numvfs-1: FAIL (0.011s)
[218.454510] Starting dynamic subtest: numvfs-2
[218.527727] Dynamic subtest numvfs-2: FAIL (0.004s)
[218.537066] Starting dynamic subtest: numvfs-3
[218.610279] Dynamic subtest numvfs-3: FAIL (0.003s)
[218.621122] Starting dynamic subtest: numvfs-4
[218.693624] Dynamic subtest numvfs-4: FAIL (0.003s)
[218.703187] Starting dynamic subtest: numvfs-5
[218.776375] Dynamic subtest numvfs-5: FAIL (0.003s)
[218.786810] Starting dynamic subtest: numvfs-6
[218.859507] Dynamic subtest numvfs-6: FAIL (0.003s)
[218.869105] Starting dynamic subtest: numvfs-7
[218.942283] Dynamic subtest numvfs-7: FAIL (0.003s)
[218.952739] Starting dynamic subtest: numvfs-random
[219.019945] Dynamic subtest numvfs-random: FAIL (0.004s)
[219.021800] Subtest enable-vfs-bind-unbind-each: FAIL (0.041s)
[219.055788] [047/133] (797s left) kms_chamelium_hpd (dp-hpd)
[219.423943] Subtest dp-hpd: SKIP (0.000s)
[220.254391] [048/133] (796s left) gem_exec_whisper (basic-queues-priority)
[220.318191] Starting subtest: basic-queues-priority
[244.807087] Subtest basic-queues-priority: SUCCESS (24.483s)
[244.985447] [049/133] (771s left) api_intel_allocator (reserve-simple)
[245.047557] Starting subtest: reserve-simple
[245.052023] Subtest reserve-simple: SUCCESS (0.007s)
[245.163442] [050/133] (771s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[245.243128] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[245.245285] Starting dynamic subtest: pipe-A-eDP-1
[245.264785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[245.274706] Starting dynamic subtest: pipe-B-eDP-1
[245.292896] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[245.301324] Starting dynamic subtest: pipe-C-eDP-1
[245.319598] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[245.331659] Starting dynamic subtest: pipe-D-eDP-1
[245.350753] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[245.352654] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[247.448205] [051/133] (769s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[247.536374] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[247.540265] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[247.627489] [052/133] (769s left) gem_exec_fence (basic-await)
[247.804961] Starting subtest: basic-await
[247.807442] Starting dynamic subtest: rcs0
[247.881323] Dynamic subtest rcs0: SUCCESS (0.077s)
[247.891125] Starting dynamic subtest: bcs0
[247.957699] Dynamic subtest bcs0: SUCCESS (0.074s)
[247.967759] Starting dynamic subtest: vcs0
[248.030473] Dynamic subtest vcs0: SUCCESS (0.072s)
[248.041827] Starting dynamic subtest: vcs1
[248.107947] Dynamic subtest vcs1: SUCCESS (0.075s)
[248.118831] Starting dynamic subtest: vecs0
[248.182441] Dynamic subtest vecs0: SUCCESS (0.072s)
[248.192947] Starting dynamic subtest: ccs0
[248.256040] Dynamic subtest ccs0: SUCCESS (0.072s)
[248.258586] Subtest basic-await: SUCCESS (0.452s)
[249.973783] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[249.977177] [053/133] (766s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[250.065566] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[257.055066] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.993s)
[257.169229] [054/133] (759s left) kms_psr (pr-suspend)
[257.247148] Starting subtest: pr-suspend
[257.251628] Subtest pr-suspend: SKIP (0.000s)
[257.318378] [055/133] (759s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[257.396165] Starting subtest: multiplane-rotation-cropping-bottom
[274.766934] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.371s)
[274.894713] [056/133] (742s left) kms_vblank (ts-continuation-dpms-suspend)
[274.977040] Starting subtest: ts-continuation-dpms-suspend
[274.978656] Starting dynamic subtest: pipe-A-eDP-1
[291.444608] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.053s)
[291.460175] Starting dynamic subtest: pipe-D-eDP-1
[309.455207] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.484s)
[309.457751] Subtest ts-continuation-dpms-suspend: SUCCESS (4.540s)
[310.278605] [057/133] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[310.370898] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[317.085329] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.594s)
[317.210639] [058/133] (699s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[317.284806] Starting subtest: compare-crc-sanitycheck-nv12
[317.286789] Starting dynamic subtest: pipe-A-eDP-1
[317.998187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[318.008399] Starting dynamic subtest: pipe-B-eDP-1
[319.231922] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.219s)
[319.241895] Starting dynamic subtest: pipe-C-eDP-1
[320.455375] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s)
[320.466810] Starting dynamic subtest: pipe-D-eDP-1
[321.691147] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[321.693428] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.369s)
[322.522157] [059/133] (694s left) gem_media_fill (media-fill)
[322.588874] Subtest media-fill: SKIP (0.000s)
[322.709984] [060/133] (694s left) gem_pread (self)
[322.761528] Subtest self: SKIP (0.000s)
[322.817388] [061/133] (694s left) kms_color_pipeline (plane-ctm3x4)
[322.894296] Starting subtest: plane-ctm3x4
[323.019067] Starting dynamic subtest: pipe-A-plane-0
[323.142066] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s)
[323.152072] Starting dynamic subtest: pipe-A-plane-1
[323.253743] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s)
[323.263357] Starting dynamic subtest: pipe-A-plane-2
[323.365840] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s)
[324.524754] Starting dynamic subtest: pipe-B-plane-0
[324.662056] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[324.672310] Starting dynamic subtest: pipe-B-plane-1
[324.818409] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[324.828354] Starting dynamic subtest: pipe-B-plane-2
[324.952956] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[326.154521] Starting dynamic subtest: pipe-C-plane-0
[326.258276] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[326.268331] Starting dynamic subtest: pipe-C-plane-1
[326.403483] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[326.413238] Starting dynamic subtest: pipe-C-plane-2
[326.516094] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[327.699172] Starting dynamic subtest: pipe-D-plane-0
[327.801220] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[327.811010] Starting dynamic subtest: pipe-D-plane-1
[327.912959] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[327.923521] Starting dynamic subtest: pipe-D-plane-2
[328.046912] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[328.347383] Subtest plane-ctm3x4: SUCCESS (5.430s)
[329.184614] [062/133] (688s left) gem_exec_alignment (many)
[329.245402] Starting subtest: many
[352.408411] Subtest many: SUCCESS (23.146s)
[355.378249] [063/133] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[355.493705] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[355.497832] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[355.594283] [064/133] (661s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[355.665501] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[355.667778] Starting dynamic subtest: pipe-A
[356.058604] Dynamic subtest pipe-A: SUCCESS (0.393s)
[356.068025] Starting dynamic subtest: pipe-B
[357.473506] Dynamic subtest pipe-B: SUCCESS (1.413s)
[357.486005] Starting dynamic subtest: pipe-C
[358.906353] Dynamic subtest pipe-C: SUCCESS (1.429s)
[358.916946] Starting dynamic subtest: pipe-D
[360.347144] Dynamic subtest pipe-D: SUCCESS (1.440s)
[360.349488] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.682s)
[361.515732] [065/133] (655s left) gem_exec_schedule (preemptive-hang)
[361.707611] Starting subtest: preemptive-hang
[361.709697] Starting dynamic subtest: rcs0
[370.860485] Dynamic subtest rcs0: SUCCESS (9.154s)
[370.871916] Starting dynamic subtest: bcs0
[379.880288] Dynamic subtest bcs0: SUCCESS (9.015s)
[379.892944] Starting dynamic subtest: vcs0
[388.916910] Dynamic subtest vcs0: SUCCESS (9.031s)
[388.928703] Starting dynamic subtest: vcs1
[397.860197] Dynamic subtest vcs1: SUCCESS (8.940s)
[397.870471] Starting dynamic subtest: vecs0
[406.820384] Dynamic subtest vecs0: SUCCESS (8.956s)
[406.830424] Starting dynamic subtest: ccs0
[415.914648] Dynamic subtest ccs0: SUCCESS (9.096s)
[415.917088] Subtest preemptive-hang: SUCCESS (54.200s)
[416.177613] [066/133] (601s left) gem_ctx_persistence (engines-hang)
[416.243237] Starting subtest: engines-hang
[416.245118] Starting dynamic subtest: rcs0
[416.295773] Dynamic subtest rcs0: SUCCESS (0.055s)
[416.307853] Starting dynamic subtest: bcs0
[416.421525] Dynamic subtest bcs0: SUCCESS (0.125s)
[416.433841] Starting dynamic subtest: vcs0
[416.522817] Dynamic subtest vcs0: SUCCESS (0.099s)
[416.535835] Starting dynamic subtest: vcs1
[416.633880] Dynamic subtest vcs1: SUCCESS (0.109s)
[416.646943] Starting dynamic subtest: vecs0
[416.746431] Dynamic subtest vecs0: SUCCESS (0.110s)
[416.760008] Starting dynamic subtest: ccs0
[416.820720] Dynamic subtest ccs0: SUCCESS (0.072s)
[416.823001] Subtest engines-hang: SUCCESS (0.582s)
[416.987700] [067/133] (600s left) gem_exec_schedule (deep)
[417.175566] Starting subtest: deep
[417.178230] Starting dynamic subtest: rcs0
[423.039493] Dynamic subtest rcs0: SKIP (5.861s)
[423.052039] Starting dynamic subtest: vcs0
[433.399363] Dynamic subtest vcs0: SUCCESS (10.362s)
[433.416167] Starting dynamic subtest: vcs1
[445.154133] Dynamic subtest vcs1: SUCCESS (11.753s)
[445.164632] Starting dynamic subtest: vecs0
[457.161271] Dynamic subtest vecs0: SUCCESS (12.004s)
[457.175180] Starting dynamic subtest: ccs0
[469.494883] Dynamic subtest ccs0: SUCCESS (12.330s)
[469.497820] Subtest deep: SUCCESS (52.315s)
[470.812393] [068/133] (546s left) gem_wait (busy)
[470.879644] Starting subtest: busy
[470.882065] Starting dynamic subtest: all-engines
[472.701621] Dynamic subtest all-engines: SUCCESS (1.819s)
[472.715566] Starting dynamic subtest: rcs0
[473.245902] Dynamic subtest rcs0: SUCCESS (0.542s)
[473.259246] Starting dynamic subtest: bcs0
[473.785372] Dynamic subtest bcs0: SUCCESS (0.539s)
[473.796830] Starting dynamic subtest: vcs0
[475.709315] Dynamic subtest vcs0: SUCCESS (1.921s)
[475.721331] Starting dynamic subtest: vcs1
[477.693279] Dynamic subtest vcs1: SUCCESS (1.981s)
[477.706576] Starting dynamic subtest: vecs0
[479.741678] Dynamic subtest vecs0: SUCCESS (2.045s)
[479.755129] Starting dynamic subtest: ccs0
[480.283918] Dynamic subtest ccs0: SUCCESS (0.540s)
[480.286553] Subtest busy: SUCCESS (9.402s)
[480.499128] [069/133] (537s left) gem_madvise (dontneed-before-mmap)
[480.539965] Starting subtest: dontneed-before-mmap
[480.556127] Subtest dontneed-before-mmap: SUCCESS (0.016s)
[480.663745] [070/133] (536s left) gem_exec_flush (basic-uc-rw-default)
[480.725136] Starting subtest: basic-uc-rw-default
[486.189557] Subtest basic-uc-rw-default: SUCCESS (5.465s)
[486.373400] [071/133] (531s left) gem_mmap_gtt (basic)
[486.416916] Subtest basic: SKIP (0.000s)
[486.477170] [072/133] (531s left) kms_tv_load_detect (load-detect)
[486.529713] Subtest load-detect: SKIP (0.000s)
[486.585238] [073/133] (531s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[486.659283] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[486.663626] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[486.759847] [074/133] (531s left) gem_wait (invalid-buf)
[486.813805] Starting subtest: invalid-buf
[486.816815] Subtest invalid-buf: SUCCESS (0.000s)
[487.013510] [075/133] (530s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[487.083807] Starting subtest: bad-aux-stride-y-tiled-ccs
[487.086134] Starting dynamic subtest: pipe-A-eDP-1
[487.108916] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[487.119368] Starting dynamic subtest: pipe-B-eDP-1
[487.140569] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[487.150172] Starting dynamic subtest: pipe-C-eDP-1
[487.172390] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[487.183765] Starting dynamic subtest: pipe-D-eDP-1
[487.206730] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[487.211286] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[489.380774] [076/133] (528s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[489.466372] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[489.470508] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[489.590670] [077/133] (528s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[489.668114] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[489.672444] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[489.761326] [078/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[489.841149] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[496.442662] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.602s)
[496.554155] [079/133] (521s left) kms_properties (invalid-properties-legacy)
[496.635479] Starting subtest: invalid-properties-legacy
[496.729635] Subtest invalid-properties-legacy: SUCCESS (0.095s)
[496.808649] [080/133] (521s left) gem_mmap_gtt (basic-read-write-distinct)
[496.867863] Subtest basic-read-write-distinct: SKIP (0.000s)
[496.933618] [081/133] (521s left) kms_display_modes (extended-mode-basic)
[497.016393] Starting subtest: extended-mode-basic
[497.020897] Subtest extended-mode-basic: SKIP (0.000s)
[497.068830] [082/133] (521s left) kms_flip (blocking-absolute-wf_vblank)
[497.140169] Starting subtest: blocking-absolute-wf_vblank
[497.142451] Starting dynamic subtest: A-eDP1
[505.957236] Dynamic subtest A-eDP1: SUCCESS (8.816s)
[505.975180] Starting dynamic subtest: B-eDP1
[514.688242] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[514.703097] Starting dynamic subtest: C-eDP1
[523.412521] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[523.424016] Starting dynamic subtest: D-eDP1
[532.147536] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[532.150037] Subtest blocking-absolute-wf_vblank: SUCCESS (35.003s)
[533.371654] [083/133] (484s left) kms_psr2_su (page_flip-xrgb8888)
[533.417726] Subtest page_flip-XRGB8888: SKIP (0.000s)
[533.482295] [084/133] (484s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[533.550033] Starting subtest: multi-wait-for-submit-available-submitted
[533.552371] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[533.654802] [085/133] (484s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[533.731196] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[533.738417] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.008s)
[533.848497] [086/133] (484s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[533.915028] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[533.919356] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[533.993995] [087/133] (484s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[534.074117] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[534.076321] Starting dynamic subtest: pipe-A-eDP-1
[534.100083] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[534.112473] Starting dynamic subtest: pipe-B-eDP-1
[534.136166] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[534.147604] Starting dynamic subtest: pipe-C-eDP-1
[534.170354] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[534.179357] Starting dynamic subtest: pipe-D-eDP-1
[534.203728] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[534.208043] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[536.313625] [088/133] (482s left) kms_chamelium_frames (hdmi-frame-dump)
[536.694656] Subtest hdmi-frame-dump: SKIP (0.000s)
[537.530583] [089/133] (480s left) gem_mmap_offset (mmap-unmap)
[537.583668] Starting subtest: mmap-unmap
[537.585888] Starting dynamic subtest: smem0
[559.619087] Dynamic subtest smem0: SUCCESS (22.039s)
[559.621927] Subtest mmap-unmap: SUCCESS (22.040s)
[559.729048] [090/133] (458s left) i915_module_load (reload)
[559.769648] Starting subtest: reload
[565.826974] Subtest reload: SUCCESS (6.060s)
[565.873917] [091/133] (452s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[567.761823] Starting subtest: flip-vs-cursor-busy-crc-atomic
[568.603407] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.841s)
[569.415329] [092/133] (449s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[569.479054] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[569.481183] Starting dynamic subtest: pipe-A-eDP-1
[569.538457] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[569.547325] Starting dynamic subtest: pipe-B-eDP-1
[569.604296] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[569.614329] Starting dynamic subtest: pipe-C-eDP-1
[569.670475] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[569.680317] Starting dynamic subtest: pipe-D-eDP-1
[569.737065] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[569.741138] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[571.777890] [093/133] (446s left) kms_psr (fbc-psr-cursor-render)
[571.852804] Starting subtest: fbc-psr-cursor-render
[571.855090] Starting dynamic subtest: eDP-1
[571.859463] Dynamic subtest eDP-1: SKIP (0.000s)
[571.863909] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[571.925771] [094/133] (446s left) kms_dsc (dsc-basic)
[571.996097] Starting subtest: dsc-basic
[572.009065] Subtest dsc-basic: SKIP (0.001s)
[572.069203] [095/133] (446s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[572.159073] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[581.360016] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.206s)
[581.496354] [096/133] (437s left) kms_flip (flip-vs-dpms-on-nop)
[581.583463] Starting subtest: flip-vs-dpms-on-nop
[581.585818] Starting dynamic subtest: A-eDP1
[583.491988] Dynamic subtest A-eDP1: SUCCESS (1.910s)
[583.502418] Starting dynamic subtest: B-eDP1
[585.419854] Dynamic subtest B-eDP1: SUCCESS (1.926s)
[585.432971] Starting dynamic subtest: C-eDP1
[587.236062] Dynamic subtest C-eDP1: SUCCESS (1.814s)
[587.249288] Starting dynamic subtest: D-eDP1
[589.074966] Dynamic subtest D-eDP1: SUCCESS (1.835s)
[589.077302] Subtest flip-vs-dpms-on-nop: SUCCESS (7.497s)
[590.265374] [097/133] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[590.342438] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[590.346452] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[590.430920] [098/133] (428s left) gem_exec_schedule (promotion)
[590.512477] Starting subtest: promotion
[590.514440] Starting dynamic subtest: rcs0
[590.613958] Dynamic subtest rcs0: SUCCESS (0.106s)
[590.625000] Starting dynamic subtest: vcs0
[590.712960] Dynamic subtest vcs0: SUCCESS (0.097s)
[590.723389] Starting dynamic subtest: vcs1
[590.791149] Dynamic subtest vcs1: SUCCESS (0.078s)
[590.803123] Starting dynamic subtest: vecs0
[590.868383] Dynamic subtest vecs0: SUCCESS (0.076s)
[590.881942] Starting dynamic subtest: ccs0
[590.952982] Dynamic subtest ccs0: SUCCESS (0.084s)
[590.955392] Subtest promotion: SUCCESS (0.446s)
[591.763210] [099/133] (427s left) syncobj_wait (multi-wait-all-signaled)
[591.817457] Starting subtest: multi-wait-all-signaled
[591.819839] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[591.915375] [100/133] (426s left) gem_mmap_gtt (basic-write-gtt)
[591.979199] Subtest basic-write-gtt: SKIP (0.000s)
[592.047683] [101/133] (426s left) gem_sync (basic-store-all)
[592.117688] Starting subtest: basic-store-all
[595.504355] Subtest basic-store-all: SUCCESS (3.397s)
[595.711818] [102/133] (423s left) kms_addfb_basic (legacy-format)
[595.776324] Starting subtest: legacy-format
[595.804844] Subtest legacy-format: SUCCESS (0.024s)
[595.929176] [103/133] (423s left) syncobj_timeline (32bits-limit)
[595.984297] Starting subtest: 32bits-limit
[595.986457] Subtest 32bits-limit: SUCCESS (0.001s)
[596.089195] [104/133] (422s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[596.168826] Starting subtest: fbcpsr-stridechange
[602.353400] Subtest fbcpsr-stridechange: SUCCESS (6.187s)
[602.490540] [105/133] (416s left) kms_prime (basic-modeset-hybrid)
[602.565225] Subtest basic-modeset-hybrid: SKIP (0.000s)
[602.672493] [106/133] (416s left) kms_pm_rpm (dpms-lpsp)
[604.882530] Starting subtest: dpms-lpsp
[605.186845] Subtest dpms-lpsp: SUCCESS (0.306s)
[605.276376] [107/133] (413s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[605.399553] Starting subtest: cursor-vs-flip-varying-size
[636.134038] Subtest cursor-vs-flip-varying-size: SUCCESS (30.728s)
[636.972544] [108/133] (382s left) kms_addfb_basic (clobberred-modifier)
[637.034096] Starting subtest: clobberred-modifier
[637.038335] Subtest clobberred-modifier: SKIP (0.000s)
[637.151643] [109/133] (382s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[637.233380] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[637.237518] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[637.335227] [110/133] (381s left) kms_cursor_crc (cursor-onscreen-32x10)
[637.489500] Starting subtest: cursor-onscreen-32x10
[637.534126] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[637.777696] [111/133] (381s left) api_intel_bb (object-reloc-keep-cache)
[637.830387] Starting subtest: object-reloc-keep-cache
[637.834929] Subtest object-reloc-keep-cache: SKIP (0.003s)
[637.940530] [112/133] (381s left) gem_exec_create (basic)
[638.000207] Starting subtest: basic
[638.002286] Starting dynamic subtest: smem
[641.727082] Dynamic subtest smem: SUCCESS (3.724s)
[641.729913] Subtest basic: SUCCESS (3.726s)
[641.932652] [113/133] (377s left) gem_exec_fence (parallel)
[642.123558] Starting subtest: parallel
[642.125546] Starting dynamic subtest: rcs0
[644.269846] Dynamic subtest rcs0: SUCCESS (2.149s)
[644.279587] Starting dynamic subtest: bcs0
[646.420712] Dynamic subtest bcs0: SUCCESS (2.150s)
[646.430709] Starting dynamic subtest: vcs0
[648.575432] Dynamic subtest vcs0: SUCCESS (2.154s)
[648.587125] Starting dynamic subtest: vcs1
[650.725464] Dynamic subtest vcs1: SUCCESS (2.149s)
[650.735393] Starting dynamic subtest: vecs0
[652.882097] Dynamic subtest vecs0: SUCCESS (2.156s)
[652.893267] Starting dynamic subtest: ccs0
[655.031888] Dynamic subtest ccs0: SUCCESS (2.149s)
[655.033847] Subtest parallel: SUCCESS (12.910s)
[655.847847] [114/133] (363s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[655.945865] Starting subtest: pr-primary-plane-update-sf-dmg-area
[655.950303] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[656.013810] [115/133] (363s left) kms_psr (fbc-pr-sprite-render)
[656.091948] Starting subtest: fbc-pr-sprite-render
[656.095848] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[656.161816] [116/133] (363s left) i915_pm_rpm (gem-evict-pwrite)
[657.869084] Starting subtest: gem-evict-pwrite
[657.873603] Subtest gem-evict-pwrite: SKIP (0.000s)
[658.405672] [117/133] (361s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[658.484702] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[658.488546] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[658.587692] [118/133] (361s left) core_getversion (all-cards)
[658.630557] Starting subtest: all-cards
[658.637680] Subtest all-cards: SUCCESS (0.011s)
[658.679725] [119/133] (361s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[658.766607] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[658.770898] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[658.871193] [120/133] (360s left) gem_eio (wait-10ms)
[659.101876] Starting subtest: wait-10ms
[659.467249] Subtest wait-10ms: SUCCESS (0.366s)
[659.587655] [121/133] (360s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[659.664435] Starting subtest: y-tiled-8bpp-rotate-90
[659.668037] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[659.758588] [122/133] (360s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[659.859703] Starting subtest: 2x-long-cursor-vs-flip-atomic
[659.863372] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[660.001870] [123/133] (359s left) gem_eio (throttle)
[660.227103] Starting subtest: throttle
[660.562814] Subtest throttle: SUCCESS (0.335s)
[660.693688] [124/133] (359s left) gem_ctx_exec (basic-invalid-context)
[660.741699] Starting subtest: basic-invalid-context
[660.745654] Subtest basic-invalid-context: SUCCESS (0.005s)
[660.854478] [125/133] (359s left) gem_softpin (allocator-evict)
[660.906811] Starting subtest: allocator-evict
[660.908827] Starting dynamic subtest: rcs0
[684.366708] Dynamic subtest rcs0: SUCCESS (23.454s)
[684.379551] Starting dynamic subtest: bcs0
[708.026952] Dynamic subtest bcs0: SUCCESS (23.653s)
[708.036991] Starting dynamic subtest: vcs0
[731.895623] Dynamic subtest vcs0: SUCCESS (23.861s)
[731.908769] Starting dynamic subtest: vcs1
[755.806354] Dynamic subtest vcs1: SUCCESS (23.903s)
[755.819957] Starting dynamic subtest: vecs0
[779.755286] Dynamic subtest vecs0: SUCCESS (23.942s)
[779.768463] Starting dynamic subtest: ccs0
[804.118402] Dynamic subtest ccs0: SUCCESS (24.369s)
[804.120777] Subtest allocator-evict: SUCCESS (143.193s)
[804.222222] [126/133] (215s left) gem_mmap_wc (read)
[804.316943] Subtest read: SKIP (0.000s)
[804.373931] [127/133] (215s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[804.464623] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[804.469095] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[804.559335] [128/133] (215s left) gem_linear_blits (normal)
[804.716291] Starting subtest: normal
[808.392589] Subtest normal: SUCCESS (3.676s)
[808.662876] [129/133] (211s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[808.775780] Starting subtest: modeset-transition-nonblocking-fencing
[808.778303] Starting dynamic subtest: 1x-outputs
[819.674001] Dynamic subtest 1x-outputs: SUCCESS (10.905s)
[819.676406] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.907s)
[820.534206] [130/133] (199s left) gen3_render_tiledx_blits
[820.658871] [131/133] (199s left) gem_gtt_cpu_tlb
[820.768859] [132/133] (199s left) sysfs_timeslice_duration (duration)
[820.817549] Starting subtest: duration
[820.819842] Starting dynamic subtest: vecs0
[835.675619] Dynamic subtest vecs0: SUCCESS (14.860s)
[835.688921] Starting dynamic subtest: ccs0
[848.825462] Dynamic subtest ccs0: SUCCESS (13.152s)
[848.837965] Starting dynamic subtest: vcs0
[863.643302] Dynamic subtest vcs0: SUCCESS (14.816s)
[863.657066] Starting dynamic subtest: bcs0
[876.799643] Dynamic subtest bcs0: SUCCESS (13.156s)
[876.812684] Starting dynamic subtest: rcs0
[889.947159] Dynamic subtest rcs0: SUCCESS (13.146s)
[889.959473] Starting dynamic subtest: vcs1
[903.643471] Dynamic subtest vcs1: SUCCESS (13.692s)
[903.646917] Subtest duration: SUCCESS (82.836s)
[903.725761] [133/133] (116s left) gem_ctx_persistence (legacy-engines-queued)
[903.783527] Starting subtest: legacy-engines-queued
[903.785817] Starting dynamic subtest: render
[903.848363] Dynamic subtest render: SUCCESS (0.063s)
[903.860646] Starting dynamic subtest: bsd1
[905.692484] Dynamic subtest bsd1: SUCCESS (1.840s)
[905.710338] Starting dynamic subtest: bsd2
[907.675736] Dynamic subtest bsd2: SUCCESS (1.980s)
[907.689309] Starting dynamic subtest: blt
[907.711304] Dynamic subtest blt: SUCCESS (0.034s)
[907.721106] Starting dynamic subtest: vebox
[909.659601] Dynamic subtest vebox: SUCCESS (1.945s)
[909.662577] Subtest legacy-engines-queued: SUCCESS (5.875s)
[909.739422] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: i915_selftest
results: parsing output: 13/ for test: fbdev
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_cursor_edge_walk
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: gem_exec_whisper
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: kms_sequence
results: parsing output: 37/ for test: gen7_exec_parse
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: i915_drm_fdinfo
results: parsing output: 44/ for test: syncobj_basic
results: parsing output: 45/ for test: sriov_basic
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: gem_exec_whisper
results: parsing output: 48/ for test: api_intel_allocator
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_vblank
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pipe_crc_basic
results: parsing output: 58/ for test: gem_media_fill
results: parsing output: 59/ for test: gem_pread
results: parsing output: 60/ for test: kms_color_pipeline
results: parsing output: 61/ for test: gem_exec_alignment
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_wait
results: parsing output: 68/ for test: gem_madvise
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_tv_load_detect
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_wait
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: kms_display_modes
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_psr2_su
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_chamelium_frames
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: i915_module_load
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_dsc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: gem_sync
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_prime
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: gem_exec_create
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: core_getversion
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_eio
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: gem_ctx_exec
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_linear_blits
results: parsing output: 128/ for test: kms_atomic_transition
results: parsing output: 129/ for test: gen3_render_tiledx_blits
results: parsing output: 130/ for test: gem_gtt_cpu_tlb
results: parsing output: 131/ for test: sysfs_timeslice_duration
results: parsing output: 132/ for test: gem_ctx_persistence
Done.