[67.185678] Initializing watchdogs
[67.185757]   /dev/watchdog0
[67.215199] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.229511] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[67.234265] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.238166] [001/130] (960s left) i915_drm_fdinfo (virtual-busy-idle-all)
[67.298263] Starting subtest: virtual-busy-idle-all
[67.301197] Subtest virtual-busy-idle-all: SKIP (0.000s)
[67.408659] [002/130] (960s left) gem_eio (create)
[67.541903] Starting subtest: create
[67.711120] Subtest create: SUCCESS (0.170s)
[69.805994] [003/130] (958s left) gem_softpin (evict-prime-sanity-check)
[69.879618] Starting subtest: evict-prime-sanity-check
[69.881038] Starting dynamic subtest: rcs0
[71.720113] Dynamic subtest rcs0: SUCCESS (1.839s)
[71.729286] Starting dynamic subtest: bcs0
[72.833836] Dynamic subtest bcs0: SUCCESS (1.117s)
[72.842685] Starting dynamic subtest: vcs0
[73.951827] Dynamic subtest vcs0: SUCCESS (1.118s)
[73.961348] Starting dynamic subtest: vcs1
[75.073848] Dynamic subtest vcs1: SUCCESS (1.122s)
[75.083546] Starting dynamic subtest: vecs0
[76.197863] Dynamic subtest vecs0: SUCCESS (1.124s)
[76.207895] Starting dynamic subtest: all
[77.305919] Dynamic subtest all: SUCCESS (1.108s)
[77.307609] Subtest evict-prime-sanity-check: SUCCESS (7.431s)
[77.418374] [004/130] (950s left) gem_eio (in-flight-internal-immediate)
[77.604896] Starting subtest: in-flight-internal-immediate
[78.879506] Subtest in-flight-internal-immediate: SUCCESS (1.275s)
[80.942116] [005/130] (947s left) gem_readwrite (read-write)
[81.000808] Subtest read-write: SKIP (0.000s)
[81.100831] [006/130] (947s left) gem_exec_fence (invalid-fence-array)
[81.622428] Starting subtest: invalid-fence-array
[81.625738] Subtest invalid-fence-array: SUCCESS (0.003s)
[82.018286] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[82.021344] [007/130] (946s left) dumb_buffer (map-invalid-size)
[82.069049] Starting subtest: map-invalid-size
[82.071209] Subtest map-invalid-size: SUCCESS (0.000s)
[82.236295] [008/130] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[84.244305] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[84.248695] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[84.471643] [009/130] (943s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[86.462136] Starting subtest: async-flip-with-page-flip-events-tiled
[86.703276] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs
[89.002626] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs: SUCCESS (2.295s)
[89.034639] Starting dynamic subtest: pipe-A-HDMI-A-4-y
[91.234431] Dynamic subtest pipe-A-HDMI-A-4-y: SUCCESS (2.231s)
[91.267532] Starting dynamic subtest: pipe-A-HDMI-A-4-y
[93.252280] Dynamic subtest pipe-A-HDMI-A-4-y: SUCCESS (2.016s)
[93.277811] Starting dynamic subtest: pipe-A-HDMI-A-4-x
[95.482795] Dynamic subtest pipe-A-HDMI-A-4-x: SUCCESS (2.231s)
[95.685938] Starting dynamic subtest: pipe-B-HDMI-A-4-y-rc-ccs
[97.910603] Dynamic subtest pipe-B-HDMI-A-4-y-rc-ccs: SUCCESS (2.229s)
[97.920864] Starting dynamic subtest: pipe-B-HDMI-A-4-y
[100.092648] Dynamic subtest pipe-B-HDMI-A-4-y: SUCCESS (2.181s)
[100.106381] Starting dynamic subtest: pipe-B-HDMI-A-4-y
[102.109371] Dynamic subtest pipe-B-HDMI-A-4-y: SUCCESS (2.016s)
[102.119367] Starting dynamic subtest: pipe-B-HDMI-A-4-x
[104.307137] Dynamic subtest pipe-B-HDMI-A-4-x: SUCCESS (2.198s)
[104.470472] Starting dynamic subtest: pipe-C-HDMI-A-4-y-rc-ccs
[106.716797] Dynamic subtest pipe-C-HDMI-A-4-y-rc-ccs: SUCCESS (2.250s)
[106.730840] Starting dynamic subtest: pipe-C-HDMI-A-4-y
[108.900057] Dynamic subtest pipe-C-HDMI-A-4-y: SUCCESS (2.182s)
[108.913934] Starting dynamic subtest: pipe-C-HDMI-A-4-y
[110.916859] Dynamic subtest pipe-C-HDMI-A-4-y: SUCCESS (2.016s)
[110.944987] Starting dynamic subtest: pipe-C-HDMI-A-4-x
[113.147493] Dynamic subtest pipe-C-HDMI-A-4-x: SUCCESS (2.231s)
[113.304893] Starting dynamic subtest: pipe-D-HDMI-A-4-y-rc-ccs
[115.560864] Dynamic subtest pipe-D-HDMI-A-4-y-rc-ccs: SUCCESS (2.259s)
[115.574776] Starting dynamic subtest: pipe-D-HDMI-A-4-y
[117.742283] Dynamic subtest pipe-D-HDMI-A-4-y: SUCCESS (2.181s)
[117.755930] Starting dynamic subtest: pipe-D-HDMI-A-4-y
[119.757652] Dynamic subtest pipe-D-HDMI-A-4-y: SUCCESS (2.014s)
[119.767239] Starting dynamic subtest: pipe-D-HDMI-A-4-x
[121.974150] Dynamic subtest pipe-D-HDMI-A-4-x: SUCCESS (2.216s)
[121.976174] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (35.510s)
[122.329947] [010/130] (906s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[122.386410] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[122.387699] Starting dynamic subtest: smem
[122.485981] Dynamic subtest smem: SUCCESS (0.100s)
[122.495388] Starting dynamic subtest: lmem0
[123.608253] Dynamic subtest lmem0: SUCCESS (1.119s)
[123.609817] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (1.219s)
[123.864327] [011/130] (904s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[125.881346] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[125.885053] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[126.088605] [012/130] (902s left) kms_color (ctm-negative)
[128.086093] Starting subtest: ctm-negative
[128.087780] Starting dynamic subtest: pipe-A-HDMI-A-4
[128.804863] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.721s)
[128.814353] Starting dynamic subtest: pipe-B-HDMI-A-4
[129.294481] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.489s)
[129.303956] Starting dynamic subtest: pipe-C-HDMI-A-4
[129.814695] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.521s)
[129.825114] Starting dynamic subtest: pipe-D-HDMI-A-4
[130.318362] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.504s)
[130.319743] Subtest ctm-negative: SUCCESS (2.235s)
[130.493633] [013/130] (898s left) gem_set_tiling_vs_pwrite
[130.621762] [014/130] (898s left) kms_addfb_basic (bad-pitch-32)
[130.667040] Starting subtest: bad-pitch-32
[130.668630] Subtest bad-pitch-32: SUCCESS (0.000s)
[132.797620] [015/130] (896s left) kms_pm_backlight (fade-with-suspend)
[134.799249] Subtest fade-with-suspend: SKIP (0.000s)
[134.871990] [016/130] (894s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[134.919488] Starting subtest: multi-wait-available-unsubmitted-submitted
[134.921015] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[135.060826] [017/130] (894s left) gem_pwrite (basic-self)
[135.108238] Subtest basic-self: SKIP (0.000s)
[135.198370] [018/130] (893s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[137.201811] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[137.271128] [019/130] (891s left) gem_cs_tlb (engines)
[137.323691] Starting subtest: engines
[137.325164] Starting dynamic subtest: rcs0
[139.482415] Dynamic subtest rcs0: SUCCESS (2.154s)
[139.492103] Starting dynamic subtest: bcs0
[141.637371] Dynamic subtest bcs0: SUCCESS (2.155s)
[141.647887] Starting dynamic subtest: vcs0
[143.790582] Dynamic subtest vcs0: SUCCESS (2.153s)
[143.800768] Starting dynamic subtest: vcs1
[145.945232] Dynamic subtest vcs1: SUCCESS (2.154s)
[145.955115] Starting dynamic subtest: vecs0
[148.097856] Dynamic subtest vecs0: SUCCESS (2.152s)
[148.099556] Subtest engines: SUCCESS (10.770s)
[148.230760] [020/130] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[150.231551] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[150.234497] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[150.426342] [021/130] (878s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[152.428895] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[152.431763] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[152.626330] [022/130] (876s left) i915_pm_rpm (system-suspend-devices)
[157.129857] Starting subtest: system-suspend-devices
[165.786460] Subtest system-suspend-devices: SUCCESS (8.663s)
[172.100827] [023/130] (862s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[174.132927] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[174.720251] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.587s)
[174.990025] [024/130] (859s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[175.035474] Starting subtest: framebuffer-vs-set-tiling
[175.038395] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[177.129456] [025/130] (857s left) gem_wait (invalid-buf)
[177.207565] Starting subtest: invalid-buf
[177.209244] Subtest invalid-buf: SUCCESS (0.000s)
[177.562660] [026/130] (857s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[179.589609] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[179.593827] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[179.832674] [027/130] (855s left) gem_lmem_swapping (verify-random-ccs)
[184.983254] Starting subtest: verify-random-ccs
[184.984682] Starting dynamic subtest: lmem0
[184.987648] Dynamic subtest lmem0: SKIP (0.000s)
[184.990459] Subtest verify-random-ccs: SKIP (0.000s)
[185.990474] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[185.991635] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[185.994205] [028/130] (849s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[191.895591] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[191.897454] Starting dynamic subtest: pipe-A-HDMI-A-4
[191.914364] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[191.923938] Starting dynamic subtest: pipe-B-HDMI-A-4
[191.938151] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[191.946800] Starting dynamic subtest: pipe-C-HDMI-A-4
[191.959667] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[191.968630] Starting dynamic subtest: pipe-D-HDMI-A-4
[191.982092] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[191.985041] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[192.174293] [FACT kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[192.177571] [FACT kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)] new: kernel.kmod_is_loaded.i915: true
[192.180789] [029/130] (843s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[194.174300] Starting subtest: 2x-long-flip-vs-cursor-legacy
[194.179169] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.003s)
[194.323291] [030/130] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[196.348625] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[196.351349] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[196.519812] [031/130] (838s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[198.521344] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[198.522756] Starting dynamic subtest: pipe-A-valid-mode
[198.570670] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s)
[198.573532] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.048s)
[198.715831] [032/130] (836s left) gem_exec_whisper (basic-fds-priority-all)
[198.777974] Starting subtest: basic-fds-priority-all
[210.294060] Subtest basic-fds-priority-all: SUCCESS (11.511s)
[210.528721] [033/130] (825s left) gem_sync (basic-store-each)
[210.591765] Starting subtest: basic-store-each
[212.706276] Subtest basic-store-each: SUCCESS (2.120s)
[213.013050] [034/130] (822s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[213.064989] Subtest no-spare-fences-busy: SKIP (0.000s)
[213.136201] [035/130] (822s left) kms_concurrent (multi-plane-atomic-lowres)
[215.131870] Starting subtest: multi-plane-atomic-lowres
[215.133495] Starting dynamic subtest: pipe-A-HDMI-A-4
[215.509653] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.378s)
[215.511219] Subtest multi-plane-atomic-lowres: SUCCESS (0.380s)
[215.721252] [036/130] (820s left) kms_chamelium_color (ctm-0-75)
[217.735118] Subtest ctm-0-75: SKIP (0.000s)
[217.934861] [037/130] (818s left) i915_pm_freq_api (freq-suspend)
[217.989649] Starting subtest: freq-suspend
[217.991592] Starting dynamic subtest: gt0
[234.469998] Dynamic subtest gt0: SUCCESS (1.590s)
[234.471583] Subtest freq-suspend: SUCCESS (1.591s)
[241.008784] [038/130] (801s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[243.026384] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[244.117709] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.097s)
[244.333358] [039/130] (797s left) api_intel_allocator (simple-allocator)
[244.379221] Starting subtest: simple-allocator
[244.380717] Starting dynamic subtest: basic
[244.397384] Dynamic subtest basic: SUCCESS (0.019s)
[244.408069] Starting dynamic subtest: parallel-one
[244.602143] Dynamic subtest parallel-one: SUCCESS (0.203s)
[244.613040] Starting dynamic subtest: print
[244.614542] Dynamic subtest print: SUCCESS (0.000s)
[244.625749] Starting dynamic subtest: reuse
[244.627278] Dynamic subtest reuse: SUCCESS (0.000s)
[244.638095] Starting dynamic subtest: reserve
[244.639765] Dynamic subtest reserve: SUCCESS (0.000s)
[244.650514] Starting dynamic subtest: fork-reopen-allocator
[244.652260] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[244.654009] Subtest simple-allocator: SUCCESS (0.240s)
[244.797259] [040/130] (797s left) kms_draw_crc (draw-method-mmap-wc)
[246.811426] Starting subtest: draw-method-mmap-wc
[246.814220] Subtest draw-method-mmap-wc: SKIP (0.000s)
[246.957639] [041/130] (795s left) perf (mi-rpc)
[247.087697] Starting subtest: mi-rpc
[247.090790] Subtest mi-rpc: SKIP (0.000s)
[247.198918] [042/130] (795s left) perf_pmu (most-busy-idle-check-all)
[247.248598] Starting subtest: most-busy-idle-check-all
[247.250296] Starting dynamic subtest: rcs0
[247.984185] Dynamic subtest rcs0: FAIL (0.690s)
[248.027093] Starting dynamic subtest: bcs0
[248.587456] Dynamic subtest bcs0: SUCCESS (0.654s)
[248.601276] Starting dynamic subtest: vcs0
[249.236812] Dynamic subtest vcs0: SUCCESS (0.652s)
[249.250261] Starting dynamic subtest: vcs1
[249.886692] Dynamic subtest vcs1: SUCCESS (0.652s)
[249.900370] Starting dynamic subtest: vecs0
[250.536646] Dynamic subtest vecs0: SUCCESS (0.652s)
[250.538234] Subtest most-busy-idle-check-all: FAIL (3.302s)
[250.653956] [043/130] (791s left) gem_ctx_persistence (engines-mixed-process)
[250.706045] Starting subtest: engines-mixed-process
[250.707624] Starting dynamic subtest: rcs0
[252.759843] Dynamic subtest rcs0: SUCCESS (2.059s)
[252.772684] Starting dynamic subtest: bcs0
[254.735029] Dynamic subtest bcs0: SUCCESS (1.979s)
[254.749716] Starting dynamic subtest: vcs0
[256.783586] Dynamic subtest vcs0: SUCCESS (2.052s)
[256.796557] Starting dynamic subtest: vcs1
[258.771795] Dynamic subtest vcs1: SUCCESS (1.991s)
[258.784918] Starting dynamic subtest: vecs0
[260.766056] Dynamic subtest vecs0: SUCCESS (1.996s)
[260.767917] Subtest engines-mixed-process: SUCCESS (10.081s)
[260.893299] [044/130] (781s left) gem_tiled_blits (interruptible)
[260.947383] Subtest interruptible: SKIP (0.000s)
[261.020194] [045/130] (781s left) kms_cursor_crc (cursor-onscreen-128x128)
[263.176925] Starting subtest: cursor-onscreen-128x128
[263.182425] Starting dynamic subtest: pipe-A-HDMI-A-4
[265.941978] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.763s)
[265.985632] Starting dynamic subtest: pipe-D-HDMI-A-4
[268.616431] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.652s)
[268.617981] Subtest cursor-onscreen-128x128: SUCCESS (5.445s)
[268.979971] [046/130] (773s left) kms_flip (flip-vs-blocking-wf-vblank)
[270.974234] Starting subtest: flip-vs-blocking-wf-vblank
[270.981165] Starting dynamic subtest: A-HDMI-A4
[279.157056] Dynamic subtest A-HDMI-A4: SUCCESS (8.180s)
[279.171720] Starting dynamic subtest: B-HDMI-A4
[287.280638] Dynamic subtest B-HDMI-A4: SUCCESS (8.127s)
[287.293614] Starting dynamic subtest: C-HDMI-A4
[295.410310] Dynamic subtest C-HDMI-A4: SUCCESS (8.133s)
[295.424304] Starting dynamic subtest: D-HDMI-A4
[303.536015] Dynamic subtest D-HDMI-A4: SUCCESS (8.129s)
[303.537658] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.581s)
[303.741499] [047/130] (739s left) kms_big_fb (linear-addfb)
[305.755343] Starting subtest: linear-addfb
[305.757188] Subtest linear-addfb: SUCCESS (0.000s)
[305.968908] [048/130] (737s left) sw_sync (sync_multi_consumer_producer)
[306.013328] Starting subtest: sync_multi_consumer_producer
[306.293896] Subtest sync_multi_consumer_producer: SUCCESS (0.278s)
[306.400140] [049/130] (736s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[308.402867] Starting subtest: psr-rgb565-draw-pwrite
[308.406305] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[308.623407] [050/130] (734s left) prime_vgem (shrink)
[308.674391] Starting subtest: shrink
[308.696983] Subtest shrink: SUCCESS (0.021s)
[308.929366] [051/130] (734s left) gem_spin_batch (resubmit-new)
[308.984393] Starting subtest: resubmit-new
[308.985772] Starting dynamic subtest: rcs0
[309.005843] Dynamic subtest rcs0: SUCCESS (0.021s)
[309.018731] Starting dynamic subtest: bcs0
[309.020025] Dynamic subtest bcs0: SUCCESS (0.004s)
[309.032952] Starting dynamic subtest: vcs0
[309.034449] Dynamic subtest vcs0: SUCCESS (0.005s)
[309.046769] Starting dynamic subtest: vcs1
[309.048327] Dynamic subtest vcs1: SUCCESS (0.006s)
[309.060241] Starting dynamic subtest: vecs0
[309.061821] Dynamic subtest vecs0: SUCCESS (0.004s)
[309.063135] Subtest resubmit-new: SUCCESS (0.044s)
[309.292751] [052/130] (734s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[311.307066] Starting subtest: yf-tiled-8bpp-rotate-270
[311.311873] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[311.561224] [053/130] (731s left) gem_partial_pwrite_pread (write-display)
[311.611725] Subtest write-display: SKIP (0.000s)
[311.716855] [054/130] (731s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[313.711077] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[313.714296] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[313.917805] [055/130] (729s left) prime_mmap (test_map_unmap)
[313.963948] Starting subtest: test_map_unmap
[313.965392] Starting dynamic subtest: test_map_unmap-smem
[314.109363] Dynamic subtest test_map_unmap-smem: SUCCESS (0.143s)
[314.121896] Starting dynamic subtest: test_map_unmap-lmem0
[314.252010] Dynamic subtest test_map_unmap-lmem0: SUCCESS (0.142s)
[314.253494] Subtest test_map_unmap: SUCCESS (0.286s)
[314.409827] [056/130] (729s left) kms_addfb_basic (unused-pitches)
[314.455454] Starting subtest: unused-pitches
[314.456948] Subtest unused-pitches: SUCCESS (0.000s)
[316.660249] [057/130] (727s left) gem_exec_suspend (basic)
[316.716986] Starting subtest: basic
[316.718468] Starting dynamic subtest: smem
[317.984497] Dynamic subtest smem: SUCCESS (1.268s)
[317.996877] Starting dynamic subtest: lmem0
[319.248584] Dynamic subtest lmem0: SUCCESS (1.264s)
[319.250193] Subtest basic: SUCCESS (2.533s)
[319.486058] [058/130] (724s left) kms_pm_dc (dc5-dpms)
[322.490547] Starting subtest: dc5-dpms
[323.763319] Subtest dc5-dpms: SUCCESS (1.270s)
[323.890292] [059/130] (720s left) kms_atomic (test-only)
[325.884584] Starting subtest: test-only
[326.130509] Starting dynamic subtest: pipe-A-HDMI-A-4
[326.592085] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.456s)
[326.593515] Subtest test-only: SUCCESS (0.701s)
[326.797476] [060/130] (717s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[328.796104] Starting subtest: fbcpsr-modesetfrombusy
[328.798873] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[328.971032] [061/130] (715s left) gen9_exec_parse (batch-without-end)
[329.028156] Subtest batch-without-end: SKIP (0.000s)
[329.114205] [062/130] (715s left) gem_tiled_wc
[329.290790] [063/130] (715s left) gem_mmap (basic-small-bo)
[329.339276] Subtest basic-small-bo: SKIP (0.000s)
[329.414550] [064/130] (715s left) kms_psr (fbc-psr2-sprite-plane-move)
[331.410527] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[331.482284] [065/130] (713s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[333.485027] Starting subtest: 2x-long-cursor-vs-flip-atomic
[333.497437] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.011s)
[333.698347] [066/130] (711s left) gem_exec_schedule (preempt-engines)
[333.759850] Starting subtest: preempt-engines
[333.761357] Starting dynamic subtest: rcs0
[336.029922] Dynamic subtest rcs0: SUCCESS (2.266s)
[336.043860] Starting dynamic subtest: bcs0
[338.233034] Dynamic subtest bcs0: SUCCESS (2.198s)
[338.249683] Starting dynamic subtest: vcs0
[340.494359] Dynamic subtest vcs0: SUCCESS (2.251s)
[340.508697] Starting dynamic subtest: vcs1
[342.752109] Dynamic subtest vcs1: SUCCESS (2.248s)
[342.766238] Starting dynamic subtest: vecs0
[344.990532] Dynamic subtest vecs0: SUCCESS (2.229s)
[344.993002] Subtest preempt-engines: SUCCESS (11.212s)
[345.376516] [067/130] (699s left) kms_psr (pr-cursor-plane-move)
[347.373222] Subtest pr-cursor-plane-move: SKIP (0.000s)
[347.447981] [068/130] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[349.448592] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[349.451327] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[349.630413] [069/130] (695s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[351.878437] Starting subtest: cursor-rapid-movement-512x512
[351.881678] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[352.165196] [070/130] (692s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[354.167102] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[354.170181] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[354.400100] [071/130] (690s left) kms_psr (pr-no-drrs)
[356.396080] Subtest pr-no-drrs: SKIP (0.000s)
[356.475535] [072/130] (688s left) gem_exec_balancer (smoke)
[356.533774] Starting subtest: smoke
[380.311302] Subtest smoke: SUCCESS (23.765s)
[381.205402] [073/130] (664s left) gen3_mixed_blits
[381.341655] [074/130] (664s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[383.342272] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[383.361673] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.018s)
[383.509508] [075/130] (662s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[383.571934] Starting subtest: y-tiled-ccs-to-y-tiled
[383.573549] Starting dynamic subtest: smem
[383.664085] Dynamic subtest smem: SUCCESS (0.092s)
[383.676711] Starting dynamic subtest: lmem0
[384.608664] Dynamic subtest lmem0: SUCCESS (0.940s)
[384.610406] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (1.034s)
[384.862029] [076/130] (660s left) api_intel_allocator (execbuf-with-allocator)
[384.906242] Starting subtest: execbuf-with-allocator
[384.927460] Subtest execbuf-with-allocator: SUCCESS (0.021s)
[385.090267] [077/130] (660s left) gem_mmap_offset (oob-read)
[385.135654] Starting subtest: oob-read
[385.137631] Subtest oob-read: SUCCESS (0.000s)
[385.334857] [078/130] (660s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[385.385352] Starting subtest: etime-multi-wait-all-for-submit-submitted
[385.491379] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[385.639471] [079/130] (660s left) api_intel_bb (simple-bb-ctx)
[385.685398] Starting subtest: simple-bb-ctx
[385.704899] Subtest simple-bb-ctx: SUCCESS (0.021s)
[385.931981] [080/130] (660s left) gem_exec_reloc (basic-active)
[385.983157] Subtest basic-active: SKIP (0.000s)
[386.086424] [081/130] (660s left) syncobj_wait (single-wait-signaled)
[386.131984] Starting subtest: single-wait-signaled
[386.133449] Subtest single-wait-signaled: SUCCESS (0.000s)
[386.241509] [082/130] (660s left) gem_eio (in-flight-internal-1us)
[386.432567] Starting subtest: in-flight-internal-1us
[387.718766] Subtest in-flight-internal-1us: SUCCESS (1.286s)
[389.820489] [083/130] (656s left) i915_drm_fdinfo (busy-idle)
[389.914497] Starting subtest: busy-idle
[389.916525] Starting dynamic subtest: rcs0
[389.923376] Dynamic subtest rcs0: SKIP (0.003s)
[389.949655] Starting dynamic subtest: bcs0
[389.953240] Dynamic subtest bcs0: SKIP (0.001s)
[389.974722] Starting dynamic subtest: vcs0
[389.977975] Dynamic subtest vcs0: SKIP (0.001s)
[389.992817] Starting dynamic subtest: vcs1
[389.995938] Dynamic subtest vcs1: SKIP (0.013s)
[390.008042] Starting dynamic subtest: vecs0
[390.011325] Dynamic subtest vecs0: SKIP (0.001s)
[390.014766] Subtest busy-idle: SKIP (0.030s)
[390.079689] [084/130] (656s left) kms_cursor_legacy (torture-bo)
[392.092955] Starting subtest: torture-bo
[392.094472] Starting dynamic subtest: pipe-A
[397.603014] Dynamic subtest pipe-A: SUCCESS (5.506s)
[397.616734] Starting dynamic subtest: pipe-B
[403.069082] Dynamic subtest pipe-B: SUCCESS (5.466s)
[403.082274] Starting dynamic subtest: pipe-C
[408.541850] Dynamic subtest pipe-C: SUCCESS (5.473s)
[408.555013] Starting dynamic subtest: pipe-D
[414.032696] Dynamic subtest pipe-D: SUCCESS (5.490s)
[414.047197] Starting dynamic subtest: all-pipes
[419.495378] Dynamic subtest all-pipes: SUCCESS (5.462s)
[419.497071] Subtest torture-bo: SUCCESS (27.402s)
[419.658571] [085/130] (626s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[421.666974] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[421.668477] Starting dynamic subtest: pipe-A-HDMI-A-4
[421.683038] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[421.695705] Starting dynamic subtest: pipe-B-HDMI-A-4
[421.710587] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[421.723067] Starting dynamic subtest: pipe-C-HDMI-A-4
[421.738240] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[421.750695] Starting dynamic subtest: pipe-D-HDMI-A-4
[421.766384] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[421.769585] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.008s)
[421.900828] [086/130] (624s left) perf (gen12-group-exclusive-stream-ctx-handle)
[422.026298] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[422.058264] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.030s)
[422.133896] [087/130] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[424.134827] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[424.138161] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[424.343722] [088/130] (622s left) gem_eio (in-flight-immediate)
[424.540616] Starting subtest: in-flight-immediate
[429.059230] Subtest in-flight-immediate: SUCCESS (4.519s)
[431.141091] [089/130] (615s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[433.157655] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[433.160689] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[433.355776] [090/130] (613s left) kms_scaling_modes (scaling-mode-center)
[435.369825] Starting subtest: scaling-mode-center
[435.378753] Subtest scaling-mode-center: SKIP (0.002s)
[435.546328] [091/130] (611s left) gem_ctx_shared (q-out-order)
[435.611080] Starting subtest: Q-out-order
[435.612715] Starting dynamic subtest: rcs0
[435.788934] Dynamic subtest rcs0: SUCCESS (0.174s)
[435.801685] Starting dynamic subtest: bcs0
[435.907530] Dynamic subtest bcs0: SUCCESS (0.120s)
[435.920488] Starting dynamic subtest: vcs0
[436.031417] Dynamic subtest vcs0: SUCCESS (0.120s)
[436.044283] Starting dynamic subtest: vcs1
[436.163222] Dynamic subtest vcs1: SUCCESS (0.131s)
[436.176172] Starting dynamic subtest: vecs0
[436.296221] Dynamic subtest vecs0: SUCCESS (0.132s)
[436.298101] Subtest Q-out-order: SUCCESS (0.682s)
[436.631738] [092/130] (610s left) gem_exec_fence (syncobj-timeline-repeat)
[437.143600] Starting subtest: syncobj-timeline-repeat
[437.656266] Subtest syncobj-timeline-repeat: SUCCESS (0.512s)
[437.917770] [093/130] (609s left) gem_mmap_wc (read-write-distinct)
[437.963989] Subtest read-write-distinct: SKIP (0.000s)
[438.046499] [094/130] (609s left) gem_exec_parallel (basic)
[438.102755] Starting subtest: basic
[438.104161] Starting dynamic subtest: rcs0
[439.746528] Dynamic subtest rcs0: SUCCESS (1.643s)
[439.760220] Starting dynamic subtest: bcs0
[441.286520] Dynamic subtest bcs0: SUCCESS (1.539s)
[441.299339] Starting dynamic subtest: vcs0
[442.836705] Dynamic subtest vcs0: SUCCESS (1.549s)
[442.851666] Starting dynamic subtest: vcs1
[444.380522] Dynamic subtest vcs1: SUCCESS (1.543s)
[444.393336] Starting dynamic subtest: vecs0
[445.920541] Dynamic subtest vecs0: SUCCESS (1.539s)
[445.922211] Subtest basic: SUCCESS (7.819s)
[446.287236] [095/130] (601s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[446.335783] Starting subtest: single-wait-all-for-submit-available-submitted
[446.337286] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[446.469894] [096/130] (601s left) kms_plane_lowres (tiling-y)
[448.464814] Starting subtest: tiling-y
[448.466296] Starting dynamic subtest: pipe-A-HDMI-A-4
[457.739121] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.274s)
[457.807776] Starting dynamic subtest: pipe-B-HDMI-A-4
[466.923419] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (9.128s)
[467.008964] Starting dynamic subtest: pipe-C-HDMI-A-4
[476.018181] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (9.022s)
[476.088895] Starting dynamic subtest: pipe-D-HDMI-A-4
[485.208803] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.133s)
[485.278741] Subtest tiling-y: SUCCESS (36.818s)
[485.485814] [097/130] (562s left) gem_reg_read (timestamp-moving)
[485.550211] Starting subtest: timestamp-moving
[486.552678] Subtest timestamp-moving: SUCCESS (1.001s)
[486.676796] [098/130] (561s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[488.677568] Starting subtest: fbcpsr-shrfb-scaledprimary
[488.680466] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[488.915867] [099/130] (559s left) kms_plane (plane-panning-bottom-right-suspend)
[490.910661] Starting subtest: plane-panning-bottom-right-suspend
[490.914615] Starting dynamic subtest: pipe-A
[511.984823] Dynamic subtest pipe-A: SUCCESS (10.467s)
[512.001087] Starting dynamic subtest: pipe-B
[533.943485] Dynamic subtest pipe-B: SUCCESS (9.867s)
[533.944929] Subtest plane-panning-bottom-right-suspend: SUCCESS (20.340s)
[539.136106] [100/130] (513s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[541.153391] Starting subtest: y-tiled-64bpp-rotate-270
[541.230391] Subtest y-tiled-64bpp-rotate-270: SKIP (0.075s)
[541.377785] [101/130] (511s left) syncobj_timeline (invalid-signal-bad-pad)
[541.429372] Starting subtest: invalid-signal-bad-pad
[541.430869] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[541.547979] [102/130] (511s left) kms_vrr (flip-dpms)
[543.951226] Starting subtest: flip-dpms
[543.956843] Subtest flip-dpms: SKIP (0.000s)
[544.081543] [103/130] (509s left) gem_ctx_param (invalid-size-set)
[544.143793] Starting subtest: invalid-size-set
[544.145319] Subtest invalid-size-set: SUCCESS (0.001s)
[544.289988] [104/130] (509s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[546.303455] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[546.305278] Starting dynamic subtest: pipe-A-HDMI-A-4
[546.356349] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[546.370108] Starting dynamic subtest: pipe-B-HDMI-A-4
[546.406215] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[546.420089] Starting dynamic subtest: pipe-C-HDMI-A-4
[546.458406] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[546.472365] Starting dynamic subtest: pipe-D-HDMI-A-4
[546.514154] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[546.517620] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.020s)
[546.589451] [105/130] (506s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[549.128781] Starting subtest: basic-flip-before-cursor-varying-size
[550.112687] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.983s)
[550.306075] [106/130] (503s left) kms_flip (basic-flip-vs-dpms)
[552.302758] Starting subtest: basic-flip-vs-dpms
[552.309590] Starting dynamic subtest: A-HDMI-A4
[553.051681] Dynamic subtest A-HDMI-A4: SUCCESS (0.741s)
[553.065678] Starting dynamic subtest: B-HDMI-A4
[553.773078] Dynamic subtest B-HDMI-A4: SUCCESS (0.719s)
[553.794375] Starting dynamic subtest: C-HDMI-A4
[554.505491] Dynamic subtest C-HDMI-A4: SUCCESS (0.729s)
[554.519927] Starting dynamic subtest: D-HDMI-A4
[555.219780] Dynamic subtest D-HDMI-A4: SUCCESS (0.714s)
[555.221262] Subtest basic-flip-vs-dpms: SUCCESS (2.919s)
[555.430318] [107/130] (498s left) kms_prop_blob (invalid-set-prop)
[555.482517] Starting subtest: invalid-set-prop
[555.484352] Subtest invalid-set-prop: SUCCESS (0.000s)
[555.619722] [108/130] (498s left) gem_ccs (ctrl-surf-copy)
[555.671846] Starting subtest: ctrl-surf-copy
[555.675402] Subtest ctrl-surf-copy: SKIP (0.000s)
[555.779252] [109/130] (498s left) kms_plane_alpha_blend (alpha-transparent-fb)
[557.789755] Starting subtest: alpha-transparent-fb
[558.102930] Starting dynamic subtest: pipe-A-HDMI-A-4
[558.569972] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.465s)
[558.584966] Starting dynamic subtest: pipe-D-HDMI-A-4
[559.103117] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.531s)
[559.104611] Subtest alpha-transparent-fb: SUCCESS (1.319s)
[559.292780] [110/130] (494s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[561.363722] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[561.476962] [111/130] (492s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[563.473738] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[563.476767] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[563.679660] [112/130] (490s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[565.698924] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[568.558337] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.860s)
[568.833414] [113/130] (485s left) kms_psr (psr-cursor-plane-onoff)
[570.848697] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[571.014303] [114/130] (483s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[573.001715] Starting subtest: flip-vs-cursor-crc-atomic
[573.544783] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.545s)
[573.738164] [115/130] (480s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[575.734544] Starting subtest: random-ccs-data-yf-tiled-ccs
[575.736203] Starting dynamic subtest: pipe-A-HDMI-A-4
[575.753756] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[575.768239] Starting dynamic subtest: pipe-B-HDMI-A-4
[575.786406] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[575.800426] Starting dynamic subtest: pipe-C-HDMI-A-4
[575.818783] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[575.833083] Starting dynamic subtest: pipe-D-HDMI-A-4
[575.848338] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[575.850996] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.010s)
[575.978148] [116/130] (478s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[576.027072] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[576.028696] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[576.172505] [117/130] (478s left) gem_exec_whisper (basic-contexts-forked-all)
[576.230608] Starting subtest: basic-contexts-forked-all
[589.068807] Subtest basic-contexts-forked-all: SUCCESS (12.840s)
[589.330730] [118/130] (465s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[591.344733] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[591.416962] [119/130] (463s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[593.415674] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[593.499664] [120/130] (461s left) kms_lease (lease-invalid-crtc)
[595.495571] Starting subtest: lease-invalid-crtc
[595.497027] Starting dynamic subtest: pipe-A-HDMI-A-4
[595.498436] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.000s)
[595.512821] Starting dynamic subtest: pipe-B-HDMI-A-4
[595.514478] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.000s)
[595.528736] Starting dynamic subtest: pipe-C-HDMI-A-4
[595.530420] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.000s)
[595.544474] Starting dynamic subtest: pipe-D-HDMI-A-4
[595.546225] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.000s)
[595.547786] Subtest lease-invalid-crtc: SUCCESS (0.010s)
[595.647223] [121/130] (459s left) gem_mmap_gtt (basic)
[595.716795] Subtest basic: SKIP (0.000s)
[595.797967] [122/130] (459s left) gem_mmap_gtt (bad-object)
[595.847565] Subtest bad-object: SKIP (0.000s)
[595.932313] [123/130] (459s left) kms_addfb_basic (addfb25-4-tiled)
[597.927739] Starting subtest: addfb25-4-tiled
[597.929137] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[598.137746] [124/130] (457s left) kms_invalid_mode (bad-vsync-start)
[600.134522] Starting subtest: bad-vsync-start
[600.136233] Starting dynamic subtest: pipe-A-HDMI-A-4
[600.171180] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.037s)
[600.187396] Starting dynamic subtest: pipe-B-HDMI-A-4
[600.188981] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[600.202738] Starting dynamic subtest: pipe-C-HDMI-A-4
[600.204086] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[600.219462] Starting dynamic subtest: pipe-D-HDMI-A-4
[600.220810] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[600.222171] Subtest bad-vsync-start: SUCCESS (0.049s)
[600.355539] [125/130] (454s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[600.404214] Starting subtest: single-wait-all-for-submit-unsubmitted
[600.505376] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[600.682897] [126/130] (454s left) gem_exec_suspend (basic-s3-devices)
[600.738261] Starting subtest: basic-S3-devices
[600.739712] Starting dynamic subtest: smem
[610.635491] Dynamic subtest smem: SUCCESS (9.899s)
[610.649930] Starting dynamic subtest: lmem0
[620.373039] Dynamic subtest lmem0: SUCCESS (9.738s)
[620.374431] Subtest basic-S3-devices: SUCCESS (19.639s)
[627.639651] [127/130] (434s left) kms_universal_plane (universal-plane-sanity)
[629.749110] Starting subtest: universal-plane-sanity
[629.750653] Starting dynamic subtest: pipe-A-HDMI-A-4
[630.378975] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.630s)
[630.397004] Starting dynamic subtest: pipe-B-HDMI-A-4
[630.779392] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.396s)
[630.798379] Starting dynamic subtest: pipe-C-HDMI-A-4
[631.194637] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.411s)
[631.212863] Starting dynamic subtest: pipe-D-HDMI-A-4
[631.616260] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.418s)
[631.617755] Subtest universal-plane-sanity: SUCCESS (1.868s)
[631.799812] [128/130] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[633.841673] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[633.844726] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[634.054413] [129/130] (428s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[636.050471] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[636.068678] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.018s)
[636.252860] [130/130] (426s left) prime_vgem (basic-read)
[636.305227] Starting subtest: basic-read
[636.334800] Subtest basic-read: SKIP (0.028s)
[636.528483] Closing watchdogs
results: parsing output: 0/ for test: i915_drm_fdinfo
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: gem_eio
results: parsing output: 4/ for test: gem_readwrite
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: dumb_buffer
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_async_flips
results: parsing output: 9/ for test: gem_render_copy
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: kms_pm_backlight
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_pwrite
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: gem_cs_tlb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: i915_pm_rpm
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: gem_wait
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: gem_exec_whisper
results: parsing output: 32/ for test: gem_sync
results: parsing output: 33/ for test: gem_fenced_exec_thrash
results: parsing output: 34/ for test: kms_concurrent
results: parsing output: 35/ for test: kms_chamelium_color
results: parsing output: 36/ for test: i915_pm_freq_api
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: kms_draw_crc
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: gem_tiled_blits
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: sw_sync
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: prime_vgem
results: parsing output: 50/ for test: gem_spin_batch
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_partial_pwrite_pread
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: prime_mmap
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: gem_exec_suspend
results: parsing output: 57/ for test: kms_pm_dc
results: parsing output: 58/ for test: kms_atomic
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gen9_exec_parse
results: parsing output: 61/ for test: gem_tiled_wc
results: parsing output: 62/ for test: gem_mmap
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: gen3_mixed_blits
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: api_intel_allocator
results: parsing output: 76/ for test: gem_mmap_offset
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: i915_drm_fdinfo
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_scaling_modes
results: parsing output: 90/ for test: gem_ctx_shared
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: gem_mmap_wc
results: parsing output: 93/ for test: gem_exec_parallel
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_plane_lowres
results: parsing output: 96/ for test: gem_reg_read
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_vrr
results: parsing output: 102/ for test: gem_ctx_param
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_prop_blob
results: parsing output: 107/ for test: gem_ccs
results: parsing output: 108/ for test: kms_plane_alpha_blend
results: parsing output: 109/ for test: kms_chamelium_hpd
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_invalid_mode
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: gem_exec_suspend
results: parsing output: 126/ for test: kms_universal_plane
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: prime_vgem
Done.