[23.024014] Initializing watchdogs [23.024064] /dev/watchdog0 [23.028425] [001/144] (960s left) kms_flip (flip-vs-blocking-wf-vblank) [23.110836] Starting subtest: flip-vs-blocking-wf-vblank [23.113807] Starting dynamic subtest: A-HDMI-A1 [30.985891] Dynamic subtest A-HDMI-A1: SUCCESS (7.871s) [30.991316] Starting dynamic subtest: B-HDMI-A1 [38.814955] Dynamic subtest B-HDMI-A1: SUCCESS (7.798s) [38.820915] Starting dynamic subtest: C-HDMI-A1 [46.598218] Dynamic subtest C-HDMI-A1: SUCCESS (7.784s) [46.604267] Starting dynamic subtest: D-HDMI-A1 [54.355808] Dynamic subtest D-HDMI-A1: SUCCESS (7.784s) [54.356939] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.245s) [54.473260] [002/144] (929s left) i915_hangman (engine-engine-error) [54.515982] Starting subtest: engine-engine-error [54.516731] Starting dynamic subtest: rcs0 [54.574264] Dynamic subtest rcs0: SUCCESS (0.058s) [54.581850] Starting dynamic subtest: bcs0 [54.633932] Dynamic subtest bcs0: SUCCESS (0.059s) [54.641735] Starting dynamic subtest: vcs0 [54.707038] Dynamic subtest vcs0: SUCCESS (0.073s) [54.715464] Starting dynamic subtest: vcs1 [54.762907] Dynamic subtest vcs1: SUCCESS (0.056s) [54.770448] Starting dynamic subtest: vecs0 [54.824798] Dynamic subtest vecs0: SUCCESS (0.062s) [54.825930] Subtest engine-engine-error: SUCCESS (0.309s) [54.905508] [003/144] (928s left) kms_psr (fbc-psr-cursor-mmap-gtt) [55.000438] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s) [55.015100] [004/144] (928s left) kms_async_flips (test-cursor) [55.092522] Starting subtest: test-cursor [55.217736] Starting dynamic subtest: pipe-A-HDMI-A-1 [55.307708] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.089s) [55.419637] Starting dynamic subtest: pipe-B-HDMI-A-1 [55.480593] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.063s) [55.588349] Starting dynamic subtest: pipe-C-HDMI-A-1 [55.661257] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.075s) [55.769971] Starting dynamic subtest: pipe-D-HDMI-A-1 [55.832155] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.064s) [55.833024] Subtest test-cursor: SUCCESS (0.740s) [56.026459] [005/144] (927s left) kms_ccs (pipe-b-missing-ccs-buffer-yf-tiled-ccs) [56.189274] Starting subtest: pipe-B-missing-ccs-buffer-yf-tiled-ccs [56.190913] Subtest pipe-B-missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s) [56.322278] [006/144] (927s left) kms_big_fb (linear-8bpp-rotate-0) [56.407334] Starting subtest: linear-8bpp-rotate-0 [57.384672] Subtest linear-8bpp-rotate-0: SUCCESS (0.977s) [57.469583] [007/144] (926s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [57.561657] Starting subtest: 2x-long-flip-vs-cursor-legacy [57.564053] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s) [57.595205] [008/144] (926s left) kms_ccs (pipe-d-bad-aux-stride-4-tiled-mtl-mc-ccs) [57.816277] Starting subtest: pipe-D-bad-aux-stride-4-tiled-mtl-mc-ccs [57.817812] Subtest pipe-D-bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.000s) [57.898224] [009/144] (925s left) syncobj_wait (wait-all-for-submit-snapshot) [57.930881] Starting subtest: wait-all-for-submit-snapshot [58.013848] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [58.058241] [010/144] (925s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [58.153237] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [58.154874] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [58.198635] [011/144] (925s left) kms_frontbuffer_tracking (psr-2p-rte) [58.283160] Starting subtest: psr-2p-rte [58.284782] Subtest psr-2p-rte: SKIP (0.000s) [58.332047] [012/144] (925s left) perf (short-reads) [58.414971] Starting subtest: short-reads [58.425998] Subtest short-reads: SUCCESS (0.012s) [58.437872] [013/144] (925s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt) [58.517490] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt [58.518964] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [58.570262] [014/144] (925s left) v3d/v3d_submit_csd (bad-multisync-pad) [58.630136] Subtest bad-multisync-pad: SKIP (0.000s) [58.658050] [015/144] (925s left) vc4/vc4_label_bo (set-label) [58.704655] Subtest set-label: SKIP (0.000s) [58.732340] [016/144] (924s left) perf (polling) [58.803976] Starting subtest: polling [58.804729] Starting dynamic subtest: 0-rcs0 [68.865903] Dynamic subtest 0-rcs0: SUCCESS (10.027s) [68.866993] Subtest polling: SUCCESS (10.027s) [68.881467] [017/144] (914s left) gem_exec_schedule (semaphore-resolve) [68.964276] Starting subtest: semaphore-resolve [68.977626] Subtest semaphore-resolve: SUCCESS (0.013s) [69.252995] [018/144] (914s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [69.395159] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-mtl-mc-ccs [69.396758] Subtest pipe-A-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s) [69.554369] [019/144] (914s left) v3d/v3d_get_bo_offset (get-bad-handle) [69.602359] Subtest get-bad-handle: SKIP (0.000s) [69.633697] [020/144] (914s left) kms_ccs (pipe-a-random-ccs-data-y-tiled-gen12-rc-ccs-cc) [69.784180] Starting subtest: pipe-A-random-ccs-data-y-tiled-gen12-rc-ccs-cc [69.877428] Subtest pipe-A-random-ccs-data-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.093s) [70.098093] [021/144] (913s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [70.135667] Starting subtest: y-tiled-to-vebox-yf-tiled [70.136482] Starting dynamic subtest: smem [70.202093] Dynamic subtest smem: SUCCESS (0.066s) [70.202914] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.066s) [70.356330] [022/144] (913s left) syncobj_wait (wait-all-snapshot) [70.403276] Starting subtest: wait-all-snapshot [70.485052] Subtest wait-all-snapshot: SUCCESS (0.082s) [70.532141] [023/144] (913s left) gem_basic (bad-close) [70.578705] Starting subtest: bad-close [70.580547] Subtest bad-close: SUCCESS (0.000s) [70.615684] [024/144] (913s left) kms_cursor_crc (cursor-rapid-movement-32x10) [70.699276] Starting subtest: cursor-rapid-movement-32x10 [70.743493] Subtest cursor-rapid-movement-32x10: SKIP (0.043s) [70.797588] [025/144] (913s left) kms_big_fb (4-tiled-16bpp-rotate-90) [70.885632] Starting subtest: 4-tiled-16bpp-rotate-90 [70.887441] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s) [70.922906] [026/144] (912s left) gem_spin_batch (resubmit-new-all) [70.965079] Starting subtest: resubmit-new-all [70.965926] Starting dynamic subtest: rcs0 [70.968712] Dynamic subtest rcs0: SUCCESS (0.003s) [70.972683] Starting dynamic subtest: bcs0 [70.973535] Dynamic subtest bcs0: SUCCESS (0.003s) [70.977656] Starting dynamic subtest: vcs0 [70.978514] Dynamic subtest vcs0: SUCCESS (0.003s) [70.982802] Starting dynamic subtest: vcs1 [70.983576] Dynamic subtest vcs1: SUCCESS (0.003s) [70.987020] Starting dynamic subtest: vecs0 [70.987821] Dynamic subtest vecs0: SUCCESS (0.003s) [70.988571] Subtest resubmit-new-all: SUCCESS (0.016s) [71.141226] [027/144] (912s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [71.230676] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [71.231582] Starting dynamic subtest: pipe-A-valid-mode [71.278532] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s) [71.279949] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.048s) [71.347134] [028/144] (912s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [71.432754] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [71.434147] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [71.484458] [029/144] (912s left) vc4/vc4_wait_bo (unused-bo-0ns) [71.544865] Subtest unused-bo-0ns: SKIP (0.000s) [71.572816] [030/144] (912s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [71.656834] Starting subtest: psr-rgb565-draw-mmap-cpu [71.658445] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s) [71.698727] [031/144] (912s left) kms_cursor_crc (cursor-offscreen-32x32) [71.782642] Starting subtest: cursor-offscreen-32x32 [71.828819] Subtest cursor-offscreen-32x32: SKIP (0.045s) [71.871961] [032/144] (912s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [74.454182] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [74.464570] [033/144] (909s left) gem_exec_reloc (basic-cpu-wc) [74.501365] Starting subtest: basic-cpu-wc [74.506325] Subtest basic-cpu-wc: SUCCESS (0.004s) [74.581171] [034/144] (909s left) gem_exec_reloc (basic-wc-read) [74.618845] Starting subtest: basic-wc-read [74.623181] Subtest basic-wc-read: SUCCESS (0.004s) [74.705902] [035/144] (909s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [74.921885] Starting subtest: pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs-cc [75.080255] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.158s) [75.220501] [036/144] (908s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [75.260255] Starting subtest: y-tiled-ccs-to-x-tiled [75.261042] Starting dynamic subtest: smem [75.361829] Dynamic subtest smem: SUCCESS (0.101s) [75.362667] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.102s) [75.512257] [037/144] (908s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [75.606785] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [75.608388] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [75.654170] [038/144] (908s left) kms_psr (psr-primary-page-flip) [75.743310] Subtest psr-primary-page-flip: SKIP (0.000s) [75.762855] [039/144] (908s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [75.839728] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [75.840545] Starting dynamic subtest: pipe-A-valid-mode [75.897479] Dynamic subtest pipe-A-valid-mode: SKIP (0.057s) [75.898994] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.058s) [75.999321] [040/144] (908s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-mc-ccs) [76.202779] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-mc-ccs [76.204333] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s) [76.324901] [041/144] (907s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [76.415973] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [76.417532] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [76.470863] [042/144] (907s left) kms_sequence (get-busy) [76.556226] Starting subtest: get-busy [76.556983] Starting dynamic subtest: pipe-A-HDMI-A-1 [77.825245] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.268s) [77.829570] Starting dynamic subtest: pipe-B-HDMI-A-1 [79.081279] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.255s) [79.085802] Starting dynamic subtest: pipe-C-HDMI-A-1 [80.322321] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.240s) [80.326777] Starting dynamic subtest: pipe-D-HDMI-A-1 [81.577602] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.254s) [81.578437] Subtest get-busy: SUCCESS (5.021s) [81.646413] [043/144] (902s left) gem_exec_reloc (basic-write-cpu-noreloc) [81.682116] Starting subtest: basic-write-cpu-noreloc [81.683805] Subtest basic-write-cpu-noreloc: SUCCESS (0.002s) [81.767757] [044/144] (902s left) gen9_exec_parse (bb-secure) [81.802941] Subtest bb-secure: SKIP (0.000s) [81.825731] [045/144] (902s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [81.914999] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [81.916486] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [81.976868] [046/144] (902s left) kms_force_connector_basic (prune-stale-modes) [82.106907] Starting subtest: prune-stale-modes [82.260224] Subtest prune-stale-modes: SUCCESS (0.151s) [82.412864] [047/144] (901s left) gem_render_copy_redux (interruptible) [82.449212] Starting subtest: interruptible [82.847921] Subtest interruptible: SUCCESS (0.390s) [82.913335] [048/144] (901s left) gem_exec_store (basic) [82.962833] Starting subtest: basic [83.011526] Subtest basic: SUCCESS (0.048s) [83.163883] [049/144] (900s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [83.211699] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [83.212533] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [83.248910] [050/144] (900s left) syncobj_timeline (invalid-transfer-bad-pad) [83.294012] Starting subtest: invalid-transfer-bad-pad [83.294830] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [83.336955] [051/144] (900s left) kms_dsc (dsc-fractional-bpp-with-bpc) [83.427540] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.000s) [83.440015] [052/144] (900s left) prime_self_import (basic-with_fd_dup) [83.471455] Starting subtest: basic-with_fd_dup [83.473119] Subtest basic-with_fd_dup: SUCCESS (0.003s) [83.536839] [053/144] (900s left) gem_exec_create (madvise) [83.582878] Starting subtest: madvise [83.583763] Starting dynamic subtest: smem [103.730263] Dynamic subtest smem: SUCCESS (20.145s) [103.731076] Subtest madvise: SUCCESS (20.146s) [105.274974] [054/144] (878s left) gem_workarounds (suspend-resume-fd) [105.322398] Starting subtest: suspend-resume-fd [122.016686] Subtest suspend-resume-fd: SUCCESS (1.187s) [128.090373] [055/144] (877s left) api_intel_allocator (execbuf-with-allocator) [128.130267] Starting subtest: execbuf-with-allocator [128.132116] Subtest execbuf-with-allocator: SUCCESS (0.002s) [128.206620] [056/144] (877s left) v3d/v3d_perfmon (create-perfmon-0) [128.260853] Subtest create-perfmon-0: SKIP (0.000s) [128.289177] [057/144] (877s left) vc4/vc4_wait_bo (used-bo) [128.344638] Subtest used-bo: SKIP (0.000s) [128.376516] [058/144] (877s left) dumb_buffer (create-clear) [128.419881] Starting subtest: create-clear [161.284731] Subtest create-clear: SUCCESS (32.864s) [161.362052] [059/144] (844s left) kms_pm_dc (dc5-dpms-negative) [162.449598] Starting subtest: dc5-dpms-negative [166.672159] Subtest dc5-dpms-negative: SUCCESS (4.221s) [166.720657] [060/144] (839s left) gem_exec_schedule (independent) [166.765506] Starting subtest: independent [166.766291] Starting dynamic subtest: rcs0 [166.856867] Dynamic subtest rcs0: SUCCESS (0.091s) [166.866852] Starting dynamic subtest: bcs0 [166.949732] Dynamic subtest bcs0: SUCCESS (0.092s) [166.961088] Starting dynamic subtest: vcs0 [167.042845] Dynamic subtest vcs0: SUCCESS (0.092s) [167.053718] Starting dynamic subtest: vcs1 [167.136762] Dynamic subtest vcs1: SUCCESS (0.093s) [167.147723] Starting dynamic subtest: vecs0 [167.233815] Dynamic subtest vecs0: SUCCESS (0.096s) [167.235073] Subtest independent: SUCCESS (0.469s) [167.511681] [061/144] (838s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [167.599881] Starting subtest: 4-tiled-addfb-size-offset-overflow [167.601407] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s) [167.660985] [062/144] (838s left) kms_psr (pr-sprite-plane-move) [167.741740] Subtest pr-sprite-plane-move: SKIP (0.000s) [167.765082] [063/144] (838s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [167.797660] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [167.798483] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [167.839828] [064/144] (837s left) gem_ccs (ctrl-surf-copy-new-ctx) [167.884880] Starting subtest: ctrl-surf-copy-new-ctx [167.886520] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [167.929538] [065/144] (837s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-mc-ccs) [168.094294] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs [168.095834] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s) [168.233819] [066/144] (837s left) gem_ctx_persistence (legacy-engines-hostile) [168.269430] Starting subtest: legacy-engines-hostile [168.270249] Starting dynamic subtest: render [168.350395] Dynamic subtest render: SUCCESS (0.080s) [168.360528] Starting dynamic subtest: bsd1 [168.432445] Dynamic subtest bsd1: SUCCESS (0.081s) [168.442731] Starting dynamic subtest: bsd2 [168.514246] Dynamic subtest bsd2: SUCCESS (0.080s) [168.524510] Starting dynamic subtest: blt [168.608408] Dynamic subtest blt: SUCCESS (0.093s) [168.619502] Starting dynamic subtest: vebox [168.692239] Dynamic subtest vebox: SUCCESS (0.083s) [168.693543] Subtest legacy-engines-hostile: SUCCESS (0.423s) [168.743567] [067/144] (837s left) perf (non-system-wide-paranoid) [168.810556] Starting subtest: non-system-wide-paranoid [168.834005] Subtest non-system-wide-paranoid: SUCCESS (0.023s) [168.850429] [068/144] (837s left) syncobj_wait (wait-for-submit-complex) [168.886573] Starting subtest: wait-for-submit-complex [168.949439] Subtest wait-for-submit-complex: SUCCESS (0.062s) [168.991010] [069/144] (836s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [169.073705] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [169.075242] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [169.131765] [070/144] (836s left) kms_psr2_su (page_flip-nv12) [169.171378] Subtest page_flip-NV12: SKIP (0.000s) [169.186084] [071/144] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [169.273455] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [169.275029] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [169.318720] [072/144] (836s left) sw_sync (alloc_fence_invalid_timeline) [169.362179] Starting subtest: alloc_fence_invalid_timeline [169.363164] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [169.401859] [073/144] (836s left) syncobj_eventfd (binary-wait-signaled) [169.444882] Starting subtest: binary-wait-signaled [169.445728] Subtest binary-wait-signaled: SUCCESS (0.000s) [169.476147] [074/144] (836s left) gem_exec_fence (basic-await) [169.639707] Starting subtest: basic-await [169.641006] Starting dynamic subtest: rcs0 [169.717792] Dynamic subtest rcs0: SUCCESS (0.078s) [169.729117] Starting dynamic subtest: bcs0 [169.800486] Dynamic subtest bcs0: SUCCESS (0.081s) [169.810808] Starting dynamic subtest: vcs0 [169.883123] Dynamic subtest vcs0: SUCCESS (0.082s) [169.894337] Starting dynamic subtest: vcs1 [169.964513] Dynamic subtest vcs1: SUCCESS (0.080s) [169.974056] Starting dynamic subtest: vecs0 [170.045541] Dynamic subtest vecs0: SUCCESS (0.080s) [170.046862] Subtest basic-await: SUCCESS (0.407s) [170.485892] [075/144] (835s left) kms_invalid_mode (uint-max-clock) [170.574291] Starting subtest: uint-max-clock [170.575126] Starting dynamic subtest: pipe-A-HDMI-A-1 [170.619420] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.045s) [170.626293] Starting dynamic subtest: pipe-B-HDMI-A-1 [170.627064] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [170.631791] Starting dynamic subtest: pipe-C-HDMI-A-1 [170.632550] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [170.636626] Starting dynamic subtest: pipe-D-HDMI-A-1 [170.637487] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [170.638262] Subtest uint-max-clock: SUCCESS (0.052s) [170.725314] [076/144] (835s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-dg2-rc-ccs) [170.876276] Starting subtest: pipe-B-bad-pixel-format-4-tiled-dg2-rc-ccs [170.877765] Subtest pipe-B-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s) [171.022703] [077/144] (835s left) kms_ccs (pipe-a-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [171.171335] Starting subtest: pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [171.172909] Subtest pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [171.327568] [078/144] (834s left) gem_exec_fair (basic-pace) [171.371110] Starting subtest: basic-pace [171.371971] Starting dynamic subtest: rcs0 [177.008817] Dynamic subtest rcs0: FAIL (5.618s) [177.013296] Starting dynamic subtest: bcs0 [182.614637] Dynamic subtest bcs0: FAIL (5.596s) [182.621667] Starting dynamic subtest: vcs0 [187.003448] Dynamic subtest vcs0: FAIL (4.398s) [187.007618] Starting dynamic subtest: vcs1 [192.611566] Dynamic subtest vcs1: FAIL (5.606s) [192.615686] Starting dynamic subtest: vecs0 [198.219024] Dynamic subtest vecs0: FAIL (5.608s) [198.219727] Subtest basic-pace: FAIL (26.828s) [198.357266] [079/144] (807s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [198.451624] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [198.453221] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [198.511194] [080/144] (807s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [198.601189] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [198.602682] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [198.659506] [081/144] (807s left) i915_pm_rpm (gem-execbuf) [200.155557] Starting subtest: gem-execbuf [200.157029] Starting dynamic subtest: smem0 [201.237241] Dynamic subtest smem0: SUCCESS (1.081s) [201.238567] Subtest gem-execbuf: SUCCESS (1.083s) [201.385141] [082/144] (804s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area) [201.419821] Subtest overlay-primary-update-sf-dmg-area: SKIP (0.000s) [201.435413] [083/144] (804s left) sysfs_heartbeat_interval (invalid) [201.469617] Starting subtest: invalid [201.470401] Starting dynamic subtest: vecs0 [201.471178] Dynamic subtest vecs0: SUCCESS (0.000s) [201.475588] Starting dynamic subtest: vcs0 [201.476366] Dynamic subtest vcs0: SUCCESS (0.000s) [201.480552] Starting dynamic subtest: bcs0 [201.481313] Dynamic subtest bcs0: SUCCESS (0.000s) [201.486294] Starting dynamic subtest: rcs0 [201.487014] Dynamic subtest rcs0: SUCCESS (0.000s) [201.491115] Starting dynamic subtest: vcs1 [201.491816] Dynamic subtest vcs1: SUCCESS (0.000s) [201.492508] Subtest invalid: SUCCESS (0.003s) [201.513513] [084/144] (804s left) gem_exec_reloc (basic-range-active) [201.549748] Starting subtest: basic-range-active [201.580662] Subtest basic-range-active: SUCCESS (0.031s) [201.668039] [085/144] (804s left) perf_pmu (rc6) [201.712393] Starting subtest: rc6 [201.713290] Starting dynamic subtest: gt0 [208.048907] Dynamic subtest gt0: SUCCESS (6.335s) [208.055475] Starting dynamic subtest: runtime-pm-gt0 [215.556282] Dynamic subtest runtime-pm-gt0: SUCCESS (7.506s) [215.562197] Starting dynamic subtest: runtime-pm-long-gt0 [228.003808] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.447s) [228.009227] Starting dynamic subtest: other-idle-gt0 [228.010873] Dynamic subtest other-idle-gt0: SKIP (0.000s) [228.011611] Subtest rc6: SUCCESS (26.292s) [228.259718] [086/144] (777s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [228.351922] Starting subtest: fbc-2p-primscrn-cur-indfb-move [228.353480] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [228.386433] [087/144] (777s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [228.555756] Starting subtest: pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs-cc [228.557304] Subtest pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [228.657664] [088/144] (777s left) kms_cursor_edge_walk (256x256-top-bottom) [228.735258] Starting subtest: 256x256-top-bottom [228.737395] Starting dynamic subtest: pipe-A-HDMI-A-1 [230.471859] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.735s) [230.478841] Starting dynamic subtest: pipe-D-HDMI-A-1 [232.139505] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.666s) [232.140266] Subtest 256x256-top-bottom: SUCCESS (3.404s) [232.195219] [089/144] (773s left) gem_userptr_blits (invalid-mmap-offset-unsync) [232.231869] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [232.303797] [090/144] (773s left) kms_chamelium_color (ctm-negative) [232.390104] Subtest ctm-negative: SKIP (0.000s) [232.403660] [091/144] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [232.484290] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [232.485874] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [232.507803] [092/144] (773s left) prime_vgem (fence-read-hang) [232.551092] Subtest fence-read-hang: SKIP (0.000s) [232.605740] [093/144] (773s left) perf (invalid-oa-exponent) [232.661085] Starting subtest: invalid-oa-exponent [232.670395] Subtest invalid-oa-exponent: SUCCESS (0.008s) [232.683240] [094/144] (773s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [232.713652] Starting subtest: etime-single-wait-for-submit-unsubmitted [232.819289] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s) [232.855541] [095/144] (773s left) kms_atomic_transition (plane-all-transition-fencing) [232.939527] Starting subtest: plane-all-transition-fencing [232.941420] Starting dynamic subtest: pipe-A-HDMI-A-1 [234.865022] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.924s) [234.926015] Starting dynamic subtest: pipe-B-HDMI-A-1 [236.953778] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.031s) [237.011616] Subtest plane-all-transition-fencing: SUCCESS (4.071s) [237.081992] [096/144] (769s left) kms_color (deep-color) [237.168187] Starting subtest: deep-color [237.174167] Subtest deep-color: SKIP (0.003s) [237.189249] [097/144] (769s left) kms_flip (2x-plain-flip-fb-recreate) [237.267162] Starting subtest: 2x-plain-flip-fb-recreate [237.278856] Subtest 2x-plain-flip-fb-recreate: SKIP (0.012s) [237.305850] [098/144] (769s left) kms_ccs (pipe-d-ccs-on-another-bo-4-tiled-mtl-rc-ccs) [237.525909] Starting subtest: pipe-D-ccs-on-another-bo-4-tiled-mtl-rc-ccs [237.527515] Subtest pipe-D-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s) [237.591490] [099/144] (768s left) gem_exec_suspend (basic-s3-devices) [237.634523] Starting subtest: basic-S3-devices [237.635361] Starting dynamic subtest: smem [243.990765] Dynamic subtest smem: SUCCESS (6.356s) [243.991551] Subtest basic-S3-devices: SUCCESS (6.357s) [250.182243] [100/144] (762s left) gem_partial_pwrite_pread (reads-display) [250.225918] Starting subtest: reads-display [251.595573] Subtest reads-display: SUCCESS (1.369s) [251.652622] [101/144] (760s left) gem_partial_pwrite_pread (writes-after-reads-display) [251.695193] Starting subtest: writes-after-reads-display [262.804966] Subtest writes-after-reads-display: SUCCESS (11.110s) [262.859718] [102/144] (749s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [262.949262] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [263.208441] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.259s) [263.294739] [103/144] (749s left) kms_cursor_crc (cursor-offscreen-256x85) [263.377442] Starting subtest: cursor-offscreen-256x85 [263.382765] Starting dynamic subtest: pipe-A-HDMI-A-1 [264.642025] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.259s) [264.671949] Starting dynamic subtest: pipe-D-HDMI-A-1 [265.871985] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.206s) [265.872813] Subtest cursor-offscreen-256x85: SUCCESS (2.495s) [265.959992] [104/144] (746s left) perf_pmu (most-busy-idle-check-all) [265.998739] Starting subtest: most-busy-idle-check-all [266.000467] Starting dynamic subtest: rcs0 [266.615320] Dynamic subtest rcs0: SUCCESS (0.616s) [266.622783] Starting dynamic subtest: bcs0 [267.231237] Dynamic subtest bcs0: SUCCESS (0.615s) [267.240407] Starting dynamic subtest: vcs0 [267.845164] Dynamic subtest vcs0: SUCCESS (0.612s) [267.854834] Starting dynamic subtest: vcs1 [268.464577] Dynamic subtest vcs1: SUCCESS (0.618s) [268.472187] Starting dynamic subtest: vecs0 [269.083412] Dynamic subtest vecs0: SUCCESS (0.617s) [269.084823] Subtest most-busy-idle-check-all: SUCCESS (3.085s) [269.115870] [105/144] (743s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-mtl-rc-ccs) [269.329062] Starting subtest: pipe-D-random-ccs-data-4-tiled-mtl-rc-ccs [269.331749] Subtest pipe-D-random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.000s) [269.397827] [106/144] (743s left) kms_psr (fbc-psr-sprite-mmap-cpu) [269.480351] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [269.498942] [107/144] (743s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [269.577803] Starting subtest: plane-downscale-factor-0-75-with-rotation [269.589348] Starting dynamic subtest: pipe-A-HDMI-A-1 [269.627736] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.037s) [269.641710] Starting dynamic subtest: pipe-B-HDMI-A-1 [269.734229] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.096s) [269.750447] Starting dynamic subtest: pipe-C-HDMI-A-1 [269.843691] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.096s) [269.859021] Starting dynamic subtest: pipe-D-HDMI-A-1 [269.950960] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.095s) [269.954032] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (0.373s) [270.061456] [108/144] (742s left) kms_sequence (get-idle) [270.138615] Starting subtest: get-idle [270.140542] Starting dynamic subtest: pipe-A-HDMI-A-1 [271.330180] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.190s) [271.337766] Starting dynamic subtest: pipe-B-HDMI-A-1 [272.490423] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.159s) [272.497227] Starting dynamic subtest: pipe-C-HDMI-A-1 [273.651433] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.159s) [273.661050] Starting dynamic subtest: pipe-D-HDMI-A-1 [274.806041] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.153s) [274.806953] Subtest get-idle: SUCCESS (4.667s) [274.872297] [109/144] (737s left) syncobj_timeline (etime-multi-wait-submitted) [274.907447] Starting subtest: etime-multi-wait-submitted [275.011484] Subtest etime-multi-wait-submitted: SUCCESS (0.104s) [275.044419] [110/144] (737s left) gem_close_race (basic-threads) [275.091651] Starting subtest: basic-threads [276.372335] Subtest basic-threads: SUCCESS (1.280s) [276.520787] [111/144] (736s left) kms_vrr (flip-dpms) [276.606594] Starting subtest: flip-dpms [276.608209] Subtest flip-dpms: SKIP (0.000s) [276.624123] [112/144] (735s left) kms_prime (d3hot) [277.279501] Subtest D3hot: SKIP (0.000s) [277.297060] [113/144] (735s left) kms_hdr (bpc-switch) [277.374803] Starting subtest: bpc-switch [277.376405] Subtest bpc-switch: SKIP (0.000s) [277.388927] [114/144] (735s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [277.469667] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [277.471361] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [277.496423] [115/144] (735s left) core_auth (getclient-master-drop) [277.530296] Starting subtest: getclient-master-drop [277.531957] Subtest getclient-master-drop: SUCCESS (0.001s) [277.551656] [116/144] (735s left) gem_linear_blits (basic) [278.089583] Starting subtest: basic [278.094920] Subtest basic: SUCCESS (0.005s) [278.176553] [117/144] (734s left) gem_exec_fence (syncobj-timeline-signal) [278.644044] Starting subtest: syncobj-timeline-signal [278.650550] Subtest syncobj-timeline-signal: SUCCESS (0.007s) [278.791444] [118/144] (733s left) gem_exec_balancer (fairslice) [278.830628] Starting subtest: fairslice [281.598048] Subtest fairslice: SUCCESS (2.767s) [281.806346] [119/144] (730s left) drm_fdinfo (busy-hang) [281.841668] Starting subtest: busy-hang [281.842634] Starting dynamic subtest: rcs0 [282.858683] Dynamic subtest rcs0: SUCCESS (1.016s) [282.866958] Starting dynamic subtest: bcs0 [283.890700] Dynamic subtest bcs0: SUCCESS (1.030s) [283.898485] Starting dynamic subtest: vcs0 [284.907587] Dynamic subtest vcs0: SUCCESS (1.016s) [284.916144] Starting dynamic subtest: vcs1 [285.925754] Dynamic subtest vcs1: SUCCESS (1.016s) [285.933373] Starting dynamic subtest: vecs0 [286.943637] Dynamic subtest vecs0: SUCCESS (1.016s) [286.944939] Subtest busy-hang: SUCCESS (5.103s) [286.971171] [120/144] (725s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [287.187339] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [287.188916] Subtest pipe-C-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [287.284687] [121/144] (725s left) gem_mmap_offset (open-flood) [287.319922] Starting subtest: open-flood [308.816440] Subtest open-flood: SUCCESS (21.497s) [308.869511] [122/144] (703s left) gem_ctx_freq (sysfs) [308.947312] Starting subtest: sysfs [308.948177] Starting dynamic subtest: gt0 [313.866398] Dynamic subtest gt0: SUCCESS (4.917s) [313.867697] Subtest sysfs: SUCCESS (4.918s) [313.912598] [123/144] (698s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [314.000271] Starting subtest: cursorB-vs-flipB-toggle [314.002741] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [314.025425] [124/144] (698s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [314.149263] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [314.211731] [125/144] (698s left) gem_exec_reloc (basic-gtt-active) [314.255550] Starting subtest: basic-gtt-active [314.374940] Subtest basic-gtt-active: SUCCESS (0.119s) [314.447962] [126/144] (698s left) kms_pipe_crc_basic (suspend-read-crc) [314.531441] Starting subtest: suspend-read-crc [314.532252] Starting dynamic subtest: pipe-A-HDMI-A-1 [331.266407] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.754s) [331.273247] Starting dynamic subtest: pipe-B-HDMI-A-1 [348.258109] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.585s) [348.273412] Starting dynamic subtest: pipe-C-HDMI-A-1 [365.256181] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.550s) [365.272167] Starting dynamic subtest: pipe-D-HDMI-A-1 [382.255314] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.558s) [382.256088] Subtest suspend-read-crc: SUCCESS (6.454s) [388.442387] [127/144] (691s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [388.670673] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [388.673496] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.002s) [388.754723] [128/144] (691s left) gem_exec_whisper (basic-sync-all) [388.795791] Starting subtest: basic-sync-all [391.578501] Subtest basic-sync-all: SUCCESS (2.781s) [391.720963] [129/144] (688s left) gem_ctx_param (invalid-get-ringsize) [391.762847] Starting subtest: invalid-get-ringsize [391.763752] Subtest invalid-get-ringsize: SUCCESS (0.000s) [391.777481] [130/144] (688s left) gem_mmap_offset (pf-nonblock) [391.808670] Starting subtest: pf-nonblock [391.813131] Subtest pf-nonblock: SUCCESS (0.005s) [391.873404] [131/144] (688s left) perf (oa-formats) [391.949300] Starting subtest: oa-formats [391.950180] Starting dynamic subtest: 0-rcs0 [391.960254] Dynamic subtest 0-rcs0: SUCCESS (0.011s) [391.961113] Subtest oa-formats: SUCCESS (0.011s) [391.978862] [132/144] (688s left) kms_pm_backlight (basic-brightness) [392.057773] Subtest basic-brightness: SKIP (0.000s) [392.073745] [133/144] (688s left) gem_exec_balancer (bonded-chain) [392.111395] Starting subtest: bonded-chain [398.945518] Subtest bonded-chain: SUCCESS (6.834s) [399.154860] [134/144] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [399.239598] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [399.241108] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [399.271188] [135/144] (681s left) i915_pm_rps (waitboost) [399.310434] Starting subtest: waitboost [401.832068] Subtest waitboost: SUCCESS (2.522s) [401.888106] [136/144] (678s left) kms_ccs (pipe-a-bad-aux-stride-yf-tiled-ccs) [402.035867] Starting subtest: pipe-A-bad-aux-stride-yf-tiled-ccs [402.037477] Subtest pipe-A-bad-aux-stride-yf-tiled-ccs: SKIP (0.000s) [402.170052] [137/144] (678s left) perf_pmu (busy-idle-check-all) [402.205716] Starting subtest: busy-idle-check-all [402.206443] Starting dynamic subtest: rcs0 [402.832297] Dynamic subtest rcs0: SUCCESS (0.626s) [402.839773] Starting dynamic subtest: bcs0 [403.455157] Dynamic subtest bcs0: SUCCESS (0.621s) [403.463284] Starting dynamic subtest: vcs0 [404.083112] Dynamic subtest vcs0: SUCCESS (0.627s) [404.091237] Starting dynamic subtest: vcs1 [404.703215] Dynamic subtest vcs1: SUCCESS (0.619s) [404.710997] Starting dynamic subtest: vecs0 [405.324229] Dynamic subtest vecs0: SUCCESS (0.620s) [405.325349] Subtest busy-idle-check-all: SUCCESS (3.118s) [405.352231] [138/144] (675s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [405.442402] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [406.100971] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.658s) [406.176815] [139/144] (674s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [406.253747] Starting subtest: 2x-long-flip-vs-cursor-atomic [406.256346] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.003s) [406.270107] [140/144] (674s left) kms_plane (plane-position-hole-dpms) [406.348032] Starting subtest: plane-position-hole-dpms [406.349901] Starting dynamic subtest: pipe-A [408.508412] Dynamic subtest pipe-A: SUCCESS (2.159s) [408.515222] Starting dynamic subtest: pipe-B [410.460016] Dynamic subtest pipe-B: SUCCESS (1.950s) [410.460794] Subtest plane-position-hole-dpms: SUCCESS (4.113s) [410.551138] [141/144] (669s left) gem_mmap (bad-offset) [410.587954] Starting subtest: bad-offset [410.588712] Subtest bad-offset: SUCCESS (0.000s) [410.624637] [142/144] (669s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [410.714685] Starting subtest: yf-tiled-8bpp-rotate-90 [410.716305] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [410.741623] [143/144] (669s left) kms_getfb (getfb-handle-closed) [410.774801] Starting subtest: getfb-handle-closed [410.775586] Subtest getfb-handle-closed: SUCCESS (0.000s) [410.830478] [144/144] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [410.919149] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [410.920680] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [410.948850] Closing watchdogs Done.