[60.781809] Initializing watchdogs [60.781879] /dev/watchdog0 [60.802426] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [60.813740] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [60.817583] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.820620] [001/131] (960s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [62.357622] Starting subtest: yf-tiled-16bpp-rotate-270 [62.359815] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [62.546796] [002/131] (958s left) gem_ctx_shared (single-timeline) [62.647638] Starting subtest: single-timeline [62.686894] Subtest single-timeline: SUCCESS (0.037s) [62.987535] [003/131] (958s left) drm_read (empty-block) [64.615251] Starting subtest: empty-block [65.615938] Subtest empty-block: SUCCESS (1.000s) [65.889029] [004/131] (955s left) sw_sync (sync_expired_merge) [65.933649] Starting subtest: sync_expired_merge [67.008713] Subtest sync_expired_merge: SUCCESS (1.074s) [67.145895] [005/131] (954s left) kms_psr (fbc-psr-cursor-plane-onoff) [68.815345] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [68.868390] [006/131] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [70.383887] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [70.385676] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [70.591826] [007/131] (951s left) perf (buffer-fill) [71.049154] Starting subtest: buffer-fill [71.050078] Starting dynamic subtest: 0-rcs0 [73.222711] Dynamic subtest 0-rcs0: SUCCESS (2.173s) [73.223642] Subtest buffer-fill: SUCCESS (2.173s) [73.270547] [008/131] (948s left) gem_exec_schedule (preempt-engines) [73.355280] Starting subtest: preempt-engines [73.356232] Starting dynamic subtest: rcs0 [75.595749] Dynamic subtest rcs0: SUCCESS (2.239s) [75.606190] Starting dynamic subtest: bcs0 [77.778291] Dynamic subtest bcs0: SUCCESS (2.181s) [77.788287] Starting dynamic subtest: vcs0 [80.111330] Dynamic subtest vcs0: SUCCESS (2.331s) [80.123286] Starting dynamic subtest: vcs1 [82.442328] Dynamic subtest vcs1: SUCCESS (2.330s) [82.451864] Starting dynamic subtest: vecs0 [84.771764] Dynamic subtest vecs0: SUCCESS (2.329s) [84.801450] Starting dynamic subtest: vecs1 [87.137527] Dynamic subtest vecs1: SUCCESS (2.364s) [87.169386] Starting dynamic subtest: ccs0 [89.386344] Dynamic subtest ccs0: SUCCESS (2.247s) [89.388196] Subtest preempt-engines: SUCCESS (16.029s) [89.823538] [009/131] (932s left) prime_busy (hang) [89.903805] Starting subtest: hang [89.905645] Starting dynamic subtest: rcs0 [116.450252] Dynamic subtest rcs0: SUCCESS (26.543s) [116.458023] Starting dynamic subtest: bcs0 [123.622786] Dynamic subtest bcs0: SUCCESS (7.173s) [123.630574] Starting dynamic subtest: vcs0 [130.664031] Dynamic subtest vcs0: SUCCESS (7.041s) [130.671728] Starting dynamic subtest: vcs1 [137.631246] Dynamic subtest vcs1: SUCCESS (6.967s) [137.639077] Starting dynamic subtest: vecs0 [144.602595] Dynamic subtest vecs0: SUCCESS (6.970s) [144.610596] Starting dynamic subtest: vecs1 [151.649522] Dynamic subtest vecs1: SUCCESS (7.048s) [151.657395] Starting dynamic subtest: ccs0 [165.492142] Dynamic subtest ccs0: SUCCESS (13.842s) [165.493207] Subtest hang: SUCCESS (75.588s) [165.633211] [010/131] (856s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [165.704071] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [165.775374] [011/131] (856s left) i915_query (query-topology-known-pci-ids) [165.845894] Starting subtest: query-topology-known-pci-ids [165.847913] Subtest query-topology-known-pci-ids: SKIP (0.000s) [166.020988] [012/131] (856s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [167.541161] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [167.543144] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [167.773613] [013/131] (854s left) kms_flip (2x-flip-vs-panning-vs-hang) [169.279880] Starting subtest: 2x-flip-vs-panning-vs-hang [169.294102] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.014s) [169.468860] [014/131] (852s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [171.002835] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [171.004493] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [171.215899] [015/131] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [172.731495] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [175.500709] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.769s) [175.743435] [016/131] (846s left) gem_exec_schedule (semaphore-noskip) [175.830700] Starting subtest: semaphore-noskip [176.592632] Subtest semaphore-noskip: SUCCESS (0.762s) [176.962736] [017/131] (845s left) gem_render_copy (x-tiled) [177.047860] Starting subtest: x-tiled [177.048778] Starting dynamic subtest: smem [177.159586] Dynamic subtest smem: SUCCESS (0.112s) [177.167547] Starting dynamic subtest: lmem0 [178.432427] Dynamic subtest lmem0: SUCCESS (1.272s) [178.433398] Subtest x-tiled: SUCCESS (1.384s) [178.696637] [018/131] (843s left) syncobj_timeline (wait-delayed-signal) [178.771289] Starting subtest: wait-delayed-signal [178.874731] Subtest wait-delayed-signal: SUCCESS (0.102s) [179.044697] [019/131] (843s left) i915_pm_freq_api (freq-suspend) [179.120275] Starting subtest: freq-suspend [179.121238] Starting dynamic subtest: gt0 [197.332166] Dynamic subtest gt0: SUCCESS (4.002s) [197.333109] Subtest freq-suspend: SUCCESS (4.003s) [206.602891] [020/131] (825s left) syncobj_wait (single-wait-signaled) [206.676794] Starting subtest: single-wait-signaled [206.677758] Subtest single-wait-signaled: SUCCESS (0.000s) [206.818816] [021/131] (824s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [208.327283] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [208.328212] Starting dynamic subtest: pipe-A-valid-mode [208.383953] Dynamic subtest pipe-A-valid-mode: SKIP (0.055s) [208.385687] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.056s) [208.599100] [022/131] (823s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [210.107693] Starting subtest: cursorA-vs-flipA-toggle [221.042669] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.933s) [221.258025] [023/131] (810s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [221.339290] Subtest writes-after-reads-snoop: SKIP (0.000s) [221.418638] [024/131] (810s left) gem_ctx_exec (basic-nohangcheck) [221.493097] Starting subtest: basic-nohangcheck [221.794946] Subtest basic-nohangcheck: SUCCESS (0.302s) [221.993064] [025/131] (810s left) gem_lmem_swapping (massive) [226.800591] Starting subtest: massive [226.801495] Starting dynamic subtest: lmem0 [232.520453] Dynamic subtest lmem0: SUCCESS (5.720s) [232.521888] Subtest massive: SUCCESS (5.720s) [234.142700] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true [234.144323] [026/131] (797s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [239.176209] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [240.475342] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.298s) [240.715079] [FACT kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)] new: kernel.kmod_is_loaded.i915: true [240.717430] [027/131] (791s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [242.227349] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [242.228314] Starting dynamic subtest: pipe-A-HDMI-A-3 [242.236898] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [242.246074] Starting dynamic subtest: pipe-B-HDMI-A-3 [242.254522] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [242.263345] Starting dynamic subtest: pipe-C-HDMI-A-3 [242.271986] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [242.280798] Starting dynamic subtest: pipe-D-HDMI-A-3 [242.290450] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [242.292131] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.007s) [242.544395] [028/131] (789s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [244.058662] Starting subtest: fbc-shrfb-scaledprimary [245.693846] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.635s) [245.902992] [029/131] (786s left) kms_frontbuffer_tracking (fbc-tiling-4) [247.419866] Starting subtest: fbc-tiling-4 [250.144362] Subtest fbc-tiling-4: SUCCESS (2.724s) [250.391688] [030/131] (781s left) kms_plane_alpha_blend (constant-alpha-min) [251.899514] Starting subtest: constant-alpha-min [252.159595] Starting dynamic subtest: pipe-A-HDMI-A-3 [252.834051] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.674s) [252.843719] Starting dynamic subtest: pipe-D-HDMI-A-3 [253.508674] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.673s) [253.509529] Subtest constant-alpha-min: SUCCESS (1.609s) [253.754674] [031/131] (778s left) syncobj_timeline (invalid-signal-zero-handles) [253.826591] Starting subtest: invalid-signal-zero-handles [253.827576] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [254.012420] [032/131] (778s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [254.087860] Starting subtest: y-tiled-ccs-to-y-tiled [254.089892] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [254.347122] [033/131] (778s left) gem_exec_fence (syncobj-invalid-flags) [254.942936] Starting subtest: syncobj-invalid-flags [254.943854] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [255.328611] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true [255.330404] [034/131] (777s left) i915_pm_rpm (gem-pread) [259.284460] Starting subtest: gem-pread [260.577700] Subtest gem-pread: SUCCESS (1.295s) [261.479992] [035/131] (771s left) kms_psr2_su (frontbuffer-xrgb8888) [261.589185] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [261.686281] [036/131] (771s left) gem_create (create-ext-placement-all) [261.884320] Starting subtest: create-ext-placement-all [261.886209] Subtest create-ext-placement-all: SUCCESS (0.000s) [262.041134] [037/131] (770s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [263.572830] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [264.322818] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.750s) [264.622523] [038/131] (768s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [266.141084] Starting subtest: fbcpsr-indfb-scaledprimary [266.142731] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s) [266.363178] [039/131] (766s left) kms_universal_plane (universal-plane-functional) [267.884719] Starting subtest: universal-plane-functional [267.885641] Starting dynamic subtest: pipe-A-HDMI-A-3 [270.012807] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.128s) [270.022844] Starting dynamic subtest: pipe-B-HDMI-A-3 [272.009163] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.995s) [272.019340] Starting dynamic subtest: pipe-C-HDMI-A-3 [273.981246] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.970s) [273.991519] Starting dynamic subtest: pipe-D-HDMI-A-3 [275.954356] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.971s) [275.955408] Subtest universal-plane-functional: SUCCESS (8.070s) [276.207571] [040/131] (756s left) gem_ctx_persistence (process) [276.295739] Starting subtest: process [276.544818] Subtest process: SUCCESS (0.248s) [276.731178] [041/131] (756s left) gem_lmem_swapping (parallel-random-verify) [281.370218] Starting subtest: parallel-random-verify [281.371722] Starting dynamic subtest: lmem0 [339.130449] Dynamic subtest lmem0: SUCCESS (57.757s) [339.132033] Subtest parallel-random-verify: SUCCESS (57.758s) [340.199151] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [340.200540] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true [340.202267] [042/131] (693s left) gen9_exec_parse (unaligned-jump) [343.777035] Subtest unaligned-jump: SKIP (0.000s) [343.836688] [FACT gen9_exec_parse (unaligned-jump)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [343.839440] [FACT gen9_exec_parse (unaligned-jump)] new: kernel.kmod_is_loaded.i915: true [343.841967] [043/131] (689s left) i915_pm_rps (thresholds) [343.933119] Starting subtest: thresholds [343.934794] Subtest thresholds: SKIP (0.001s) [344.141115] [044/131] (689s left) kms_psr (fbc-psr2-basic) [345.657630] Subtest fbc-psr2-basic: SKIP (0.000s) [345.724799] [045/131] (687s left) kms_big_fb (y-tiled-64bpp-rotate-270) [347.261569] Starting subtest: y-tiled-64bpp-rotate-270 [347.263733] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [347.491178] [046/131] (686s left) api_intel_allocator (fork-simple-once) [347.580672] Starting subtest: fork-simple-once [347.627020] Subtest fork-simple-once: SUCCESS (0.048s) [347.816519] [047/131] (685s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [349.328183] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [349.329174] Starting dynamic subtest: pipe-A [351.280517] Dynamic subtest pipe-A: SUCCESS (1.953s) [351.296106] Starting dynamic subtest: pipe-B [353.274296] Dynamic subtest pipe-B: SUCCESS (1.992s) [353.289139] Starting dynamic subtest: pipe-C [353.516372] Dynamic subtest pipe-C: SUCCESS (0.241s) [353.537525] Starting dynamic subtest: pipe-D [353.758900] Dynamic subtest pipe-D: SUCCESS (0.241s) [353.760112] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.433s) [354.051010] [048/131] (679s left) gen9_exec_parse (batch-without-end) [354.150826] Subtest batch-without-end: SKIP (0.000s) [354.211157] [049/131] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [355.737563] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [355.739325] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [356.000628] [050/131] (677s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [357.544736] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [357.546585] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [357.800429] [051/131] (676s left) gem_set_tiling_vs_gtt [357.947223] [052/131] (676s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [359.468491] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [359.470176] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [359.713423] [053/131] (674s left) dmabuf_sync_file (export-basic) [359.767659] Starting subtest: export-basic [359.768528] Subtest export-basic: SUCCESS (0.001s) [359.900028] [054/131] (674s left) kms_cursor_crc (cursor-random-32x10) [361.543508] Starting subtest: cursor-random-32x10 [361.598153] Subtest cursor-random-32x10: SKIP (0.053s) [362.078900] [055/131] (672s left) kms_cursor_legacy (single-move) [363.591280] Starting subtest: single-move [363.592237] Starting dynamic subtest: pipe-A [368.972390] Dynamic subtest pipe-A: SUCCESS (5.380s) [368.982367] Starting dynamic subtest: pipe-B [374.352488] Dynamic subtest pipe-B: SUCCESS (5.379s) [374.362127] Starting dynamic subtest: pipe-C [379.732292] Dynamic subtest pipe-C: SUCCESS (5.379s) [379.741824] Starting dynamic subtest: pipe-D [385.111982] Dynamic subtest pipe-D: SUCCESS (5.379s) [385.121660] Starting dynamic subtest: all-pipes [390.492757] Dynamic subtest all-pipes: SUCCESS (5.380s) [390.493670] Subtest single-move: SUCCESS (26.900s) [390.620322] [056/131] (643s left) kms_addfb_basic (bo-too-small) [392.137255] Starting subtest: bo-too-small [392.138181] Subtest bo-too-small: SUCCESS (0.000s) [392.373275] [057/131] (642s left) gem_render_copy (linear-to-vebox-yf-tiled) [392.463188] Starting subtest: linear-to-vebox-yf-tiled [392.465426] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [392.750386] [058/131] (641s left) gem_ctx_param (basic) [392.828813] Starting subtest: basic [392.831025] Subtest basic: SUCCESS (0.002s) [392.985719] [059/131] (641s left) api_intel_bb (crc32) [393.071855] Starting subtest: crc32 [393.072756] Starting dynamic subtest: rcs0-lmem0 [393.329130] Dynamic subtest rcs0-lmem0: SUCCESS (0.255s) [393.369400] Starting dynamic subtest: rcs0-smem0 [393.681724] Dynamic subtest rcs0-smem0: SUCCESS (0.349s) [393.699471] Starting dynamic subtest: bcs0-lmem0 [393.925163] Dynamic subtest bcs0-lmem0: SUCCESS (0.239s) [393.967370] Starting dynamic subtest: bcs0-smem0 [394.287200] Dynamic subtest bcs0-smem0: SUCCESS (0.358s) [394.300695] Starting dynamic subtest: vcs0-lmem0 [394.708602] Dynamic subtest vcs0-lmem0: SUCCESS (0.417s) [394.721433] Starting dynamic subtest: vcs0-smem0 [395.260041] Dynamic subtest vcs0-smem0: SUCCESS (0.547s) [395.272447] Starting dynamic subtest: vcs1-lmem0 [395.689119] Dynamic subtest vcs1-lmem0: SUCCESS (0.425s) [395.706982] Starting dynamic subtest: vcs1-smem0 [396.245814] Dynamic subtest vcs1-smem0: SUCCESS (0.553s) [396.258487] Starting dynamic subtest: vecs0-lmem0 [396.669293] Dynamic subtest vecs0-lmem0: SUCCESS (0.419s) [396.682278] Starting dynamic subtest: vecs0-smem0 [397.222770] Dynamic subtest vecs0-smem0: SUCCESS (0.549s) [397.235662] Starting dynamic subtest: vecs1-lmem0 [397.652164] Dynamic subtest vecs1-lmem0: SUCCESS (0.425s) [397.665824] Starting dynamic subtest: vecs1-smem0 [398.208578] Dynamic subtest vecs1-smem0: SUCCESS (0.552s) [398.221597] Starting dynamic subtest: ccs0-lmem0 [398.458705] Dynamic subtest ccs0-lmem0: SUCCESS (0.246s) [398.500815] Starting dynamic subtest: ccs0-smem0 [398.833785] Dynamic subtest ccs0-smem0: SUCCESS (0.371s) [398.835939] Subtest crc32: SUCCESS (5.763s) [399.003144] [060/131] (635s left) kms_flip (flip-vs-rmfb) [400.527581] Starting subtest: flip-vs-rmfb [400.533782] Starting dynamic subtest: A-HDMI-A3 [408.294493] Dynamic subtest A-HDMI-A3: SUCCESS (7.760s) [408.325681] Starting dynamic subtest: B-HDMI-A3 [415.982619] Dynamic subtest B-HDMI-A3: SUCCESS (7.684s) [416.017117] Starting dynamic subtest: C-HDMI-A3 [423.688101] Dynamic subtest C-HDMI-A3: SUCCESS (7.700s) [423.722535] Starting dynamic subtest: D-HDMI-A3 [431.392220] Dynamic subtest D-HDMI-A3: SUCCESS (7.699s) [431.396329] Subtest flip-vs-rmfb: SUCCESS (30.864s) [431.690881] [061/131] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [433.211613] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [433.213461] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [433.456078] [062/131] (601s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [434.977158] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [435.027954] [063/131] (600s left) kms_cursor_crc (cursor-offscreen-128x42) [436.751848] Starting subtest: cursor-offscreen-128x42 [436.757186] Starting dynamic subtest: pipe-A-HDMI-A-3 [439.276521] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.519s) [439.320212] Starting dynamic subtest: pipe-D-HDMI-A-3 [441.700741] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.389s) [441.701759] Subtest cursor-offscreen-128x42: SUCCESS (4.948s) [442.078848] [064/131] (593s left) perf_pmu (interrupts-sync) [442.151195] Starting subtest: interrupts-sync [443.317758] Subtest interrupts-sync: SUCCESS (1.165s) [443.481603] [065/131] (591s left) gem_mmap_gtt (big-bo-tiledy) [443.565567] Subtest big-bo-tiledY: SKIP (0.000s) [443.653112] [066/131] (591s left) kms_vrr (lobf) [445.166451] Starting subtest: lobf [445.168399] Subtest lobf: SKIP (0.000s) [445.298131] [067/131] (590s left) gem_mmap_gtt (basic-read-write-distinct) [445.381483] Subtest basic-read-write-distinct: SKIP (0.000s) [445.460616] [068/131] (589s left) gem_softpin (evict-single-offset) [445.546473] Starting subtest: evict-single-offset [479.949851] Subtest evict-single-offset: SUCCESS (34.401s) [480.079360] [069/131] (555s left) kms_color (legacy-gamma-reset) [481.637366] Starting subtest: legacy-gamma-reset [481.638222] Starting dynamic subtest: pipe-A-HDMI-A-3 [481.858639] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.219s) [481.884422] Starting dynamic subtest: pipe-B-HDMI-A-3 [481.901731] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.042s) [481.920542] Starting dynamic subtest: pipe-C-HDMI-A-3 [481.934655] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.030s) [481.945548] Starting dynamic subtest: pipe-D-HDMI-A-3 [481.954798] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.020s) [481.955706] Subtest legacy-gamma-reset: SUCCESS (0.319s) [482.165601] [070/131] (553s left) kms_async_flips (alternate-sync-async-flip) [483.684508] Starting subtest: alternate-sync-async-flip [483.925426] Starting dynamic subtest: pipe-A-HDMI-A-3 [486.185679] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.260s) [486.387564] Starting dynamic subtest: pipe-B-HDMI-A-3 [488.461557] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.083s) [488.659951] Starting dynamic subtest: pipe-C-HDMI-A-3 [490.741682] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.092s) [490.918879] Starting dynamic subtest: pipe-D-HDMI-A-3 [492.992736] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.084s) [492.994054] Subtest alternate-sync-async-flip: SUCCESS (9.310s) [493.435625] [071/131] (542s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [494.953678] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [494.954663] Starting dynamic subtest: pipe-A-valid-mode [495.847445] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.893s) [495.848386] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (0.895s) [496.106456] [072/131] (539s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [497.625517] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [497.690003] [073/131] (538s left) kms_chamelium_color (ctm-green-to-red) [499.218945] Subtest ctm-green-to-red: SKIP (0.000s) [499.273907] [074/131] (536s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [499.360511] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [499.362490] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [499.627300] [075/131] (536s left) gem_exec_whisper (basic-fds-forked) [499.724731] Starting subtest: basic-fds-forked [522.362945] Subtest basic-fds-forked: SUCCESS (22.635s) [522.622914] [076/131] (513s left) gem_fence_thrash (bo-write-verify-threaded-none) [522.671639] Starting subtest: bo-write-verify-threaded-none [522.702558] Subtest bo-write-verify-threaded-none: SKIP (0.031s) [522.807437] [077/131] (513s left) kms_rmfb (rmfb-ioctl) [524.325430] Starting subtest: rmfb-ioctl [524.326391] Starting dynamic subtest: pipe-A-HDMI-A-3 [524.480286] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.154s) [524.535788] Starting dynamic subtest: pipe-B-HDMI-A-3 [524.775752] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.290s) [524.788912] Starting dynamic subtest: pipe-C-HDMI-A-3 [524.969012] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.191s) [524.983110] Starting dynamic subtest: pipe-D-HDMI-A-3 [525.161628] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.191s) [525.162640] Subtest rmfb-ioctl: SUCCESS (0.838s) [525.415517] [078/131] (510s left) gem_exec_reloc (basic-wc) [525.502971] Subtest basic-wc: SKIP (0.000s) [525.583918] [079/131] (510s left) gem_exec_balancer (full) [525.675473] Starting subtest: full [527.764648] Subtest full: SUCCESS (2.090s) [528.207761] [080/131] (508s left) kms_flip (blocking-absolute-wf_vblank) [529.727271] Starting subtest: blocking-absolute-wf_vblank [529.732724] Starting dynamic subtest: A-HDMI-A3 [537.508577] Dynamic subtest A-HDMI-A3: SUCCESS (7.775s) [537.524329] Starting dynamic subtest: B-HDMI-A3 [545.196436] Dynamic subtest B-HDMI-A3: SUCCESS (7.686s) [545.210009] Starting dynamic subtest: C-HDMI-A3 [552.884164] Dynamic subtest C-HDMI-A3: SUCCESS (7.686s) [552.898149] Starting dynamic subtest: D-HDMI-A3 [560.572747] Dynamic subtest D-HDMI-A3: SUCCESS (7.687s) [560.573700] Subtest blocking-absolute-wf_vblank: SUCCESS (30.846s) [560.924121] [081/131] (475s left) gem_partial_pwrite_pread (write) [561.011684] Subtest write: SKIP (0.000s) [561.100523] [082/131] (475s left) gem_exec_params (rs-invalid) [561.185213] Starting subtest: rs-invalid [561.189084] Subtest rs-invalid: SUCCESS (0.003s) [561.389065] [083/131] (475s left) gem_eio (wait-wedge-1us) [561.678388] Starting subtest: wait-wedge-1us [563.073780] Subtest wait-wedge-1us: SUCCESS (1.396s) [564.671364] [084/131] (471s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [566.226573] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [566.228398] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [566.460848] [085/131] (470s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [567.980223] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [572.834559] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.854s) [573.069719] [086/131] (463s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [574.592586] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [574.594515] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [574.808269] [087/131] (462s left) syncobj_timeline (wait-zero-handles) [574.897449] Starting subtest: wait-zero-handles [574.898387] Subtest wait-zero-handles: SUCCESS (0.000s) [575.069427] [088/131] (461s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [576.588423] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [576.589341] Starting dynamic subtest: pipe-A-HDMI-A-3 [576.611388] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s) [576.623548] Starting dynamic subtest: pipe-B-HDMI-A-3 [576.645998] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s) [576.657798] Starting dynamic subtest: pipe-C-HDMI-A-3 [576.682732] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s) [576.694622] Starting dynamic subtest: pipe-D-HDMI-A-3 [576.717283] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s) [576.719145] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.017s) [576.931213] [089/131] (460s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [578.494663] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [578.604273] [090/131] (458s left) kms_psr (psr2-cursor-render) [580.123781] Subtest psr2-cursor-render: SKIP (0.000s) [580.179640] [091/131] (457s left) gem_render_tiled_blits (basic) [580.270390] Subtest basic: SKIP (0.000s) [580.372642] [092/131] (456s left) perf (i915-ref-count) [580.504226] Starting subtest: i915-ref-count [580.833663] Subtest i915-ref-count: SUCCESS (0.329s) [580.999722] [093/131] (456s left) kms_invalid_mode (bad-hsync-end) [582.517703] Starting subtest: bad-hsync-end [582.518631] Starting dynamic subtest: pipe-A-HDMI-A-3 [582.572160] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.054s) [582.585867] Starting dynamic subtest: pipe-B-HDMI-A-3 [582.587011] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [582.598835] Starting dynamic subtest: pipe-C-HDMI-A-3 [582.599992] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [582.611704] Starting dynamic subtest: pipe-D-HDMI-A-3 [582.612631] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [582.613530] Subtest bad-hsync-end: SUCCESS (0.063s) [582.814632] [094/131] (454s left) gem_exec_reloc (basic-wc-read) [582.899716] Subtest basic-wc-read: SKIP (0.000s) [582.984364] [095/131] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [584.507207] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [584.508896] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [584.772006] [096/131] (452s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [586.294258] Starting subtest: fbc-rgb565-draw-mmap-wc [586.296095] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s) [586.536743] [097/131] (451s left) kms_pm_rpm (dpms-non-lpsp) [590.286108] Starting subtest: dpms-non-lpsp [590.404254] Subtest dpms-non-lpsp: SUCCESS (0.117s) [591.318041] [098/131] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [592.872518] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [592.874388] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [593.093778] [099/131] (444s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [594.612358] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [594.613262] Starting dynamic subtest: pipe-A-HDMI-A-3 [604.072028] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (9.454s) [604.087512] Starting dynamic subtest: pipe-B-HDMI-A-3 [604.768346] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.691s) [604.789246] Starting dynamic subtest: pipe-C-HDMI-A-3 [605.478355] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.702s) [605.518616] Starting dynamic subtest: pipe-D-HDMI-A-3 [606.204983] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.718s) [606.206851] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SUCCESS (11.589s) [606.464765] [100/131] (431s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [607.986727] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [607.988469] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [608.187505] [101/131] (429s left) gem_mmap_offset (isolation) [608.274744] Starting subtest: isolation [608.283599] Subtest isolation: SUCCESS (0.007s) [608.471849] [102/131] (429s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [609.998222] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [609.999995] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [610.253795] [103/131] (428s left) kms_joiner (invalid-modeset-ultra-joiner) [611.780442] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [611.963318] [104/131] (426s left) gem_wait (busy) [612.067022] Starting subtest: busy [612.067987] Starting dynamic subtest: all-engines [612.644285] Dynamic subtest all-engines: SUCCESS (0.577s) [612.658503] Starting dynamic subtest: rcs0 [613.183433] Dynamic subtest rcs0: SUCCESS (0.538s) [613.196807] Starting dynamic subtest: bcs0 [613.723399] Dynamic subtest bcs0: SUCCESS (0.539s) [613.735460] Starting dynamic subtest: vcs0 [614.262478] Dynamic subtest vcs0: SUCCESS (0.538s) [614.275721] Starting dynamic subtest: vcs1 [614.801336] Dynamic subtest vcs1: SUCCESS (0.538s) [614.813387] Starting dynamic subtest: vecs0 [615.340440] Dynamic subtest vecs0: SUCCESS (0.538s) [615.354187] Starting dynamic subtest: vecs1 [615.879421] Dynamic subtest vecs1: SUCCESS (0.538s) [615.892595] Starting dynamic subtest: ccs0 [616.418449] Dynamic subtest ccs0: SUCCESS (0.538s) [616.419430] Subtest busy: SUCCESS (4.352s) [616.741717] [105/131] (421s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [618.257413] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [618.259265] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [618.494923] [106/131] (420s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [620.026193] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [621.121267] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.095s) [621.374533] [107/131] (417s left) gem_exec_params (secure-non-root) [621.458286] Starting subtest: secure-non-root [621.460174] Subtest secure-non-root: SKIP (0.000s) [621.638390] [108/131] (417s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [623.158647] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [623.160498] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [623.392833] [109/131] (415s left) perf_pmu (idle) [623.465810] Starting subtest: idle [623.466737] Starting dynamic subtest: rcs0 [624.044916] Dynamic subtest rcs0: SUCCESS (0.577s) [624.059830] Starting dynamic subtest: bcs0 [624.563827] Dynamic subtest bcs0: SUCCESS (0.514s) [624.578337] Starting dynamic subtest: vcs0 [625.084875] Dynamic subtest vcs0: SUCCESS (0.517s) [625.099492] Starting dynamic subtest: vcs1 [625.613176] Dynamic subtest vcs1: SUCCESS (0.524s) [625.633733] Starting dynamic subtest: vecs0 [626.134068] Dynamic subtest vecs0: SUCCESS (0.515s) [626.148873] Starting dynamic subtest: vecs1 [626.654858] Dynamic subtest vecs1: SUCCESS (0.517s) [626.669790] Starting dynamic subtest: ccs0 [627.174876] Dynamic subtest ccs0: SUCCESS (0.516s) [627.178449] Subtest idle: SUCCESS (3.711s) [627.355614] [110/131] (411s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [628.932532] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [629.043756] [111/131] (410s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [630.570401] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [630.572347] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [630.810132] [112/131] (408s left) kms_atomic_interruptible (universal-setplane-cursor) [632.325618] Starting subtest: universal-setplane-cursor [632.327745] Starting dynamic subtest: pipe-A-HDMI-A-3 [638.503169] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.175s) [638.504138] Subtest universal-setplane-cursor: SUCCESS (6.177s) [638.775242] [113/131] (400s left) gem_ccs (block-multicopy-inplace) [638.863585] Starting subtest: block-multicopy-inplace [638.865966] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy [638.908277] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.043s) [638.921999] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy [639.023042] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.114s) [639.036464] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy [639.039749] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s) [639.053480] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy [639.154100] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.113s) [639.167666] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy [639.170685] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s) [639.184456] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy [639.285735] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.114s) [639.299381] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy [639.300825] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s) [639.314614] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy [639.416184] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.114s) [639.417121] Subtest block-multicopy-inplace: SUCCESS (0.553s) [639.587082] [114/131] (399s left) kms_cursor_crc (cursor-sliding-64x21) [641.282265] Starting subtest: cursor-sliding-64x21 [641.287657] Starting dynamic subtest: pipe-A-HDMI-A-3 [645.776304] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.488s) [645.815783] Starting dynamic subtest: pipe-D-HDMI-A-3 [650.073658] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.269s) [650.074571] Subtest cursor-sliding-64x21: SUCCESS (8.790s) [650.543142] [115/131] (388s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [650.621742] Starting subtest: etime-multi-wait-for-submit-unsubmitted [650.725791] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s) [650.825936] [116/131] (388s left) syncobj_timeline (signal-array) [650.911708] Starting subtest: signal-array [650.912804] Subtest signal-array: SUCCESS (0.000s) [651.078461] [117/131] (388s left) kms_dp_linktrain_fallback (dsc-fallback) [652.596814] Starting subtest: dsc-fallback [652.599486] Subtest dsc-fallback: SKIP (0.000s) [652.721632] [118/131] (386s left) gem_mmap_wc (pf-nonblock) [652.828379] Subtest pf-nonblock: SKIP (0.000s) [652.941276] [119/131] (386s left) kms_pm_rpm (system-suspend-idle) [657.203194] Starting subtest: system-suspend-idle