[28.406602] Initializing watchdogs [28.406659] /dev/watchdog0 [28.411492] [001/142] (960s left) syncobj_timeline (invalid-single-wait-all-available-unsubmitted) [28.463755] Starting subtest: invalid-single-wait-all-available-unsubmitted [28.464553] Subtest invalid-single-wait-all-available-unsubmitted: SUCCESS (0.000s) [28.501476] [002/142] (960s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_ccs) [28.673221] Starting subtest: pipe-A-random-ccs-data-y_tiled_ccs [28.675286] Subtest pipe-A-random-ccs-data-y_tiled_ccs: SKIP (0.000s) [28.952996] [003/142] (959s left) perf_pmu (rc6) [29.004510] Starting subtest: rc6 [29.005438] Starting dynamic subtest: gt0 [35.348593] Dynamic subtest gt0: SUCCESS (6.335s) [35.351796] Starting dynamic subtest: runtime-pm-gt0 [42.811713] Dynamic subtest runtime-pm-gt0: SUCCESS (7.463s) [42.815109] Starting dynamic subtest: runtime-pm-long-gt0 [55.224034] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.412s) [55.228424] Starting dynamic subtest: other-idle-gt0 [55.230069] Dynamic subtest other-idle-gt0: SKIP (0.000s) [55.230893] Subtest rc6: SUCCESS (26.211s) [55.275177] [004/142] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [55.377068] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [55.378560] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [55.415355] [005/142] (933s left) i915_pm_rpm (pm-tiling) [56.994640] Starting subtest: pm-tiling [58.456460] Subtest pm-tiling: SUCCESS (1.462s) [58.516173] [006/142] (930s left) gem_ppgtt (blt-vs-render-ctxn) [58.571558] Starting subtest: blt-vs-render-ctxN [91.202941] Subtest blt-vs-render-ctxN: SUCCESS (32.631s) [91.264300] [007/142] (897s left) perf (stress-open-close) [91.401764] Starting subtest: stress-open-close [91.402579] Starting dynamic subtest: 0-rcs0 [93.570045] Dynamic subtest 0-rcs0: SUCCESS (2.169s) [93.570828] Subtest stress-open-close: SUCCESS (2.169s) [93.587902] [008/142] (895s left) drm_fdinfo (busy-idle-check-all) [93.641612] Starting subtest: busy-idle-check-all [93.642415] Starting dynamic subtest: rcs0 [94.262591] Dynamic subtest rcs0: SUCCESS (0.620s) [94.269486] Starting dynamic subtest: bcs0 [94.881786] Dynamic subtest bcs0: SUCCESS (0.616s) [94.887504] Starting dynamic subtest: vcs0 [95.499222] Dynamic subtest vcs0: SUCCESS (0.620s) [95.505663] Starting dynamic subtest: vcs1 [96.117592] Dynamic subtest vcs1: SUCCESS (0.615s) [96.122208] Starting dynamic subtest: vecs0 [96.734283] Dynamic subtest vecs0: SUCCESS (0.620s) [96.735410] Subtest busy-idle-check-all: SUCCESS (3.092s) [96.760152] [009/142] (892s left) i915_hangman (detector) [96.820324] Starting subtest: detector [96.821123] Starting dynamic subtest: rcs0 [106.317904] Dynamic subtest rcs0: SUCCESS (9.497s) [106.327125] Starting dynamic subtest: bcs0 [116.368845] Dynamic subtest bcs0: SUCCESS (10.051s) [116.378658] Starting dynamic subtest: vcs0 [126.353941] Dynamic subtest vcs0: SUCCESS (9.985s) [126.364289] Starting dynamic subtest: vcs1 [136.329908] Dynamic subtest vcs1: SUCCESS (9.976s) [136.341291] Starting dynamic subtest: vecs0 [146.320912] Dynamic subtest vecs0: SUCCESS (9.991s) [146.322446] Subtest detector: SUCCESS (49.501s) [146.351958] [010/142] (842s left) kms_big_fb (4-tiled-64bpp-rotate-0) [146.462616] Starting subtest: 4-tiled-64bpp-rotate-0 [146.464175] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s) [146.494840] [011/142] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [146.594619] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [146.596014] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [146.628845] [012/142] (842s left) sw_sync (timeline_closed_signaled) [146.675653] Starting subtest: timeline_closed_signaled [146.676454] Subtest timeline_closed_signaled: SUCCESS (0.000s) [146.686124] [013/142] (842s left) core_setmaster (master-drop-set-shared-fd) [147.244927] Starting subtest: master-drop-set-shared-fd [147.259846] Subtest master-drop-set-shared-fd: SUCCESS (0.015s) [147.269714] [014/142] (841s left) gem_exec_params (invalid-bsd1-flag-on-blt) [147.316170] Starting subtest: invalid-bsd1-flag-on-blt [147.317023] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [147.356162] [015/142] (841s left) kms_color (ctm-0-50) [147.459216] Starting subtest: ctm-0-50 [147.460149] Starting dynamic subtest: pipe-A [148.218909] Dynamic subtest pipe-A: SUCCESS (0.760s) [148.223394] Starting dynamic subtest: pipe-B [148.956784] Dynamic subtest pipe-B: SUCCESS (0.738s) [148.962437] Starting dynamic subtest: pipe-C [149.659364] Dynamic subtest pipe-C: SUCCESS (0.703s) [149.663789] Starting dynamic subtest: pipe-D [150.345024] Dynamic subtest pipe-D: SUCCESS (0.685s) [150.345806] Subtest ctm-0-50: SUCCESS (2.886s) [150.420995] [016/142] (838s left) syncobj_basic (bad-pad-fd-to-handle) [150.483668] Starting subtest: bad-pad-fd-to-handle [150.484757] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [150.504717] [017/142] (838s left) kms_big_fb (y-tiled-16bpp-rotate-90) [150.610459] Starting subtest: y-tiled-16bpp-rotate-90 [151.492150] Subtest y-tiled-16bpp-rotate-90: SUCCESS (0.882s) [151.560511] [018/142] (837s left) vc4/vc4_wait_bo (used-bo) [151.617369] Subtest used-bo: SKIP (0.000s) [151.626144] [019/142] (837s left) i915_pm_backlight (fade) [151.720435] Subtest fade: SKIP (0.000s) [151.730879] [020/142] (837s left) gem_exec_reloc (basic-scanout) [151.830352] Starting subtest: basic-scanout [151.831178] Starting dynamic subtest: rcs0 [151.966571] Dynamic subtest rcs0: SUCCESS (0.137s) [151.972102] Starting dynamic subtest: bcs0 [152.075167] Dynamic subtest bcs0: SUCCESS (0.108s) [152.081388] Starting dynamic subtest: vcs0 [152.191858] Dynamic subtest vcs0: SUCCESS (0.117s) [152.196865] Starting dynamic subtest: vcs1 [152.300048] Dynamic subtest vcs1: SUCCESS (0.108s) [152.305658] Starting dynamic subtest: vecs0 [152.416913] Dynamic subtest vecs0: SUCCESS (0.116s) [152.417771] Subtest basic-scanout: SUCCESS (0.587s) [152.472567] [021/142] (836s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs_cc) [152.793544] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc [152.794939] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [152.905037] [022/142] (836s left) kms_vblank (pipe-b-wait-idle) [153.001291] Starting subtest: pipe-B-wait-idle [154.247104] Subtest pipe-B-wait-idle: SUCCESS (1.246s) [154.312585] [023/142] (834s left) kms_big_fb (4-tiled-16bpp-rotate-270) [154.415497] Starting subtest: 4-tiled-16bpp-rotate-270 [154.416988] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s) [154.460577] [024/142] (834s left) kms_addfb_basic (bo-too-small) [154.560385] Starting subtest: bo-too-small [154.561347] Subtest bo-too-small: SUCCESS (0.000s) [154.594041] [025/142] (834s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs) [154.799969] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs [154.894435] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SUCCESS (0.094s) [155.171294] [026/142] (834s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [155.276150] Starting subtest: yf-tiled-8bpp-rotate-270 [155.277545] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [155.309817] [027/142] (833s left) gem_exec_balancer (hang) [155.559699] Starting subtest: hang [156.342100] Subtest hang: SUCCESS (0.790s) [156.358884] [028/142] (832s left) syncobj_wait (wait-for-submit-snapshot) [156.410394] Starting subtest: wait-for-submit-snapshot [156.492517] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [156.517449] [029/142] (832s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_ccs) [156.722851] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_ccs [156.724436] Subtest pipe-B-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s) [156.942311] [030/142] (832s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [156.991975] Starting subtest: etime-multi-wait-all-submitted-signaled [157.098020] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s) [157.115348] [031/142] (832s left) vc4/vc4_perfmon (destroy-valid-perfmon) [157.172593] Subtest destroy-valid-perfmon: SKIP (0.000s) [157.182305] [032/142] (832s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs) [157.511532] Starting subtest: pipe-D-random-ccs-data-yf_tiled_ccs [157.513616] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s) [157.601551] [033/142] (831s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs) [157.881977] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs [157.882775] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SUCCESS (0.000s) [158.027209] [034/142] (831s left) kms_psr (cursor_render) [158.074603] Subtest cursor_render: SKIP (0.000s) [158.088296] [035/142] (831s left) kms_rotation_crc (primary-rotation-90) [158.182859] Starting subtest: primary-rotation-90 [162.960355] Subtest primary-rotation-90: SUCCESS (4.777s) [163.093916] [036/142] (826s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [163.193807] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [163.195199] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [163.225686] [037/142] (826s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [163.325080] Starting subtest: psr-2p-scndscrn-spr-indfb-move [163.326557] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [163.359463] [038/142] (826s left) gem_exec_fair (basic-none-rrul) [163.414303] Starting subtest: basic-none-rrul [163.415078] Starting dynamic subtest: rcs0 [168.215203] Dynamic subtest rcs0: FAIL (4.782s) [168.215898] Subtest basic-none-rrul: FAIL (4.783s) [168.338664] [039/142] (821s left) kms_cursor_crc (cursor-random-32x32) [168.445691] Starting subtest: cursor-random-32x32 [168.490025] Subtest cursor-random-32x32: SKIP (0.042s) [168.535268] [040/142] (820s left) gem_ctx_sseu (mmap-args) [168.586657] Subtest mmap-args: SKIP (0.000s) [168.605666] [041/142] (820s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [168.705944] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [168.707442] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [168.743213] [042/142] (820s left) gem_exec_params (batch-first) [168.794096] Starting subtest: batch-first [168.796296] Subtest batch-first: SUCCESS (0.002s) [168.843481] [043/142] (820s left) vgem_basic (create) [168.916603] Starting subtest: create [168.917446] Subtest create: SUCCESS (0.000s) [168.928165] [044/142] (820s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc) [169.025752] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc [169.027096] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [169.068236] [045/142] (820s left) gem_pxp (create-regular-context-1) [171.666750] Subtest create-regular-context-1: SKIP (0.000s) [171.681468] [046/142] (817s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear) [171.781768] Starting subtest: fbcpsr-tiling-linear [171.783159] Subtest fbcpsr-tiling-linear: SKIP (0.000s) [171.810489] [047/142] (817s left) kms_big_fb (x-tiled-8bpp-rotate-90) [171.912640] Starting subtest: x-tiled-8bpp-rotate-90 [171.974552] Subtest x-tiled-8bpp-rotate-90: SKIP (0.061s) [172.027518] [048/142] (817s left) gem_spin_batch (legacy) [172.081269] Starting subtest: legacy [172.082119] Starting dynamic subtest: default [175.430729] Dynamic subtest default: SUCCESS (3.314s) [175.438572] Starting dynamic subtest: render [178.745802] Dynamic subtest render: SUCCESS (3.314s) [178.753431] Starting dynamic subtest: bsd [182.061508] Dynamic subtest bsd: SUCCESS (3.315s) [182.068754] Starting dynamic subtest: bsd1 [185.377534] Dynamic subtest bsd1: SUCCESS (3.315s) [185.384758] Starting dynamic subtest: bsd2 [188.666363] Dynamic subtest bsd2: SUCCESS (3.314s) [188.673798] Starting dynamic subtest: blt [192.007658] Dynamic subtest blt: SUCCESS (3.314s) [192.015545] Starting dynamic subtest: vebox [195.323583] Dynamic subtest vebox: SUCCESS (3.315s) [195.324792] Subtest legacy: SUCCESS (23.207s) [195.419220] [049/142] (794s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_mc_ccs) [195.781355] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs [195.782972] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s) [195.853090] [050/142] (793s left) gem_exec_schedule (preempt-engines) [195.910713] Starting subtest: preempt-engines [195.911488] Starting dynamic subtest: rcs0 [195.972092] Dynamic subtest rcs0: SUCCESS (0.061s) [195.979353] Starting dynamic subtest: bcs0 [196.034224] Dynamic subtest bcs0: SUCCESS (0.062s) [196.041037] Starting dynamic subtest: vcs0 [196.096396] Dynamic subtest vcs0: SUCCESS (0.062s) [196.103327] Starting dynamic subtest: vcs1 [196.160403] Dynamic subtest vcs1: SUCCESS (0.063s) [196.165549] Starting dynamic subtest: vecs0 [196.222655] Dynamic subtest vecs0: SUCCESS (0.062s) [196.223551] Subtest preempt-engines: SUCCESS (0.312s) [196.478157] [051/142] (793s left) gem_mmap_gtt (big-copy-xy) [196.533269] Starting subtest: big-copy-XY [207.000973] Subtest big-copy-XY: SUCCESS (10.467s) [207.019217] [052/142] (782s left) kms_chamelium_color (ctm-red-to-blue) [207.154974] Subtest ctm-red-to-blue: SKIP (0.000s) [207.172528] [053/142] (782s left) kms_cursor_crc (cursor-onscreen-512x170) [207.278807] Starting subtest: cursor-onscreen-512x170 [207.281201] Subtest cursor-onscreen-512x170: SKIP (0.001s) [207.316583] [054/142] (782s left) kms_vblank (pipe-b-ts-continuation-idle) [207.412182] Starting subtest: pipe-B-ts-continuation-idle [207.706241] Subtest pipe-B-ts-continuation-idle: SUCCESS (0.294s) [207.801768] [055/142] (781s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs) [208.025657] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs [208.027232] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s) [208.245112] [056/142] (781s left) gem_exec_suspend (basic-s0) [208.300677] Starting subtest: basic-S0 [208.301492] Starting dynamic subtest: smem [226.569060] Dynamic subtest smem: SUCCESS (2.337s) [226.569895] Subtest basic-S0: SUCCESS (2.338s) [229.698145] [057/142] (778s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs) [230.036128] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs [230.037870] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s) [230.148338] [058/142] (778s left) v3d/v3d_submit_cl (multisync-out-syncs) [230.219434] Subtest multisync-out-syncs: SKIP (0.000s) [230.231430] [059/142] (778s left) vc4/vc4_label_bo (set-bad-handle) [230.302795] Subtest set-bad-handle: SKIP (0.000s) [230.313982] [060/142] (778s left) gem_ctx_persistence (hang) [230.363039] Starting subtest: hang [230.364875] Subtest hang: SUCCESS (0.001s) [230.388161] [061/142] (778s left) gem_exec_await (wide-contexts) [230.465745] Starting subtest: wide-contexts [252.116945] Subtest wide-contexts: SUCCESS (21.651s) [252.268291] [062/142] (756s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [252.412301] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [252.413737] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [252.450512] [063/142] (756s left) kms_psr2_sf (primary-plane-update-sf-dmg-area) [252.500219] Subtest primary-plane-update-sf-dmg-area: SKIP (0.000s) [252.512255] [064/142] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [252.610821] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [252.612328] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [252.642483] [065/142] (756s left) gem_flink_basic (flink-lifetime) [252.690666] Starting subtest: flink-lifetime [252.691489] Subtest flink-lifetime: SUCCESS (0.001s) [252.727277] [066/142] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [252.831817] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [252.833216] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [252.867362] [067/142] (755s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [252.968722] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [252.970309] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [253.008902] [068/142] (755s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [253.192752] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [253.195602] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.002s) [253.452663] [069/142] (755s left) kms_setmode (basic-clone-single-crtc) [253.501993] Starting subtest: basic-clone-single-crtc [253.504250] Subtest basic-clone-single-crtc: SKIP (0.000s) [253.523837] [070/142] (755s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_mc_ccs) [253.781765] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs [253.783160] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s) [253.955834] [071/142] (754s left) kms_invalid_mode (zero-clock) [254.053296] Starting subtest: zero-clock [254.054069] Starting dynamic subtest: HDMI-A-1-pipe-A [254.110592] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.056s) [254.116103] Starting dynamic subtest: HDMI-A-1-pipe-B [254.116859] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.001s) [254.123921] Starting dynamic subtest: HDMI-A-1-pipe-C [254.124762] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.001s) [254.129968] Starting dynamic subtest: HDMI-A-1-pipe-D [254.130721] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (0.001s) [254.131466] Subtest zero-clock: SUCCESS (0.063s) [254.185047] [072/142] (754s left) gem_reg_read (timestamp-monotonic) [254.233944] Starting subtest: timestamp-monotonic [258.445156] Subtest timestamp-monotonic: SUCCESS (4.211s) [258.464568] [073/142] (750s left) kms_color (ctm-signed) [258.559037] Starting subtest: ctm-signed [258.559857] Starting dynamic subtest: pipe-A [259.071245] Dynamic subtest pipe-A: SUCCESS (0.512s) [259.078427] Starting dynamic subtest: pipe-B [259.582776] Dynamic subtest pipe-B: SUCCESS (0.511s) [259.589891] Starting dynamic subtest: pipe-C [260.068511] Dynamic subtest pipe-C: SUCCESS (0.485s) [260.074074] Starting dynamic subtest: pipe-D [260.539574] Dynamic subtest pipe-D: SUCCESS (0.470s) [260.540448] Subtest ctm-signed: SUCCESS (1.981s) [260.623420] [074/142] (748s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [260.729106] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [260.730587] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [260.763970] [075/142] (748s left) kms_ccs (pipe-a-bad-pixel-format-yf_tiled_ccs) [260.860200] Starting subtest: pipe-A-bad-pixel-format-yf_tiled_ccs [260.861842] Subtest pipe-A-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s) [261.195533] [076/142] (747s left) kms_rotation_crc (sprite-rotation-180) [261.291991] Starting subtest: sprite-rotation-180 [263.951648] Subtest sprite-rotation-180: SUCCESS (2.659s) [264.078088] [077/142] (744s left) gen9_exec_parse (basic-rejected) [264.128723] Subtest basic-rejected: SKIP (0.000s) [264.147311] [078/142] (744s left) gem_exec_balancer (parallel) [264.402042] Starting subtest: parallel [265.203247] Subtest parallel: SUCCESS (0.805s) [265.218985] [079/142] (743s left) gem_exec_params (no-vebox) [265.268449] Starting subtest: no-vebox [265.269197] Subtest no-vebox: SUCCESS (0.001s) [265.342209] [080/142] (743s left) gem_busy (close-race) [265.403639] Starting subtest: close-race [287.087916] Subtest close-race: SUCCESS (21.684s) [287.377013] [081/142] (721s left) gem_ctx_create (basic) [287.478227] Starting subtest: basic [287.478953] Subtest basic: SUCCESS (0.000s) [287.617946] [082/142] (721s left) fbdev (nullptr) [287.677581] Starting subtest: nullptr [287.678508] Subtest nullptr: SUCCESS (0.000s) [287.692551] [083/142] (721s left) syncobj_timeline (single-wait-for-submit-available-submitted) [287.744944] Starting subtest: single-wait-for-submit-available-submitted [287.745837] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [287.762637] [084/142] (721s left) v3d/v3d_get_param (get-bad-param) [287.828225] Subtest get-bad-param: SKIP (0.000s) [287.839111] [085/142] (721s left) api_intel_allocator (default-alignment) [287.891361] Starting subtest: default-alignment [287.892176] Subtest default-alignment: SUCCESS (0.001s) [287.947346] [086/142] (721s left) i915_query (query-regions-sanity-check) [288.001228] Starting subtest: query-regions-sanity-check [288.010470] Subtest query-regions-sanity-check: SUCCESS (0.009s) [288.077034] [087/142] (720s left) gem_ctx_isolation (dirty-switch) [288.134488] Starting subtest: dirty-switch [288.135245] Starting dynamic subtest: rcs0 [288.252904] Dynamic subtest rcs0: SUCCESS (0.118s) [288.259405] Starting dynamic subtest: bcs0 [288.420877] Dynamic subtest bcs0: SUCCESS (0.167s) [288.426770] Starting dynamic subtest: vcs0 [288.574245] Dynamic subtest vcs0: SUCCESS (0.153s) [288.579994] Starting dynamic subtest: vcs1 [288.732530] Dynamic subtest vcs1: SUCCESS (0.158s) [288.738080] Starting dynamic subtest: vecs0 [288.897987] Dynamic subtest vecs0: SUCCESS (0.165s) [288.898882] Subtest dirty-switch: SUCCESS (0.763s) [289.035264] [088/142] (719s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [289.147118] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [289.148597] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [289.181981] [089/142] (719s left) syncobj_timeline (wait-delayed-signal) [289.233812] Starting subtest: wait-delayed-signal [289.336160] Subtest wait-delayed-signal: SUCCESS (0.102s) [289.365390] [090/142] (719s left) gem_exec_reloc (basic-gtt-cpu) [289.421697] Starting subtest: basic-gtt-cpu [289.427086] Subtest basic-gtt-cpu: SUCCESS (0.005s) [289.497670] [091/142] (719s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_mc_ccs) [289.689931] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_mc_ccs [289.691461] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s) [289.968876] [092/142] (719s left) kms_flip (2x-nonexisting-fb) [290.048898] Starting subtest: 2x-nonexisting-fb [290.061080] Subtest 2x-nonexisting-fb: SKIP (0.012s) [290.089142] [093/142] (718s left) kms_flip (2x-plain-flip-fb-recreate) [290.169949] Starting subtest: 2x-plain-flip-fb-recreate [290.183214] Subtest 2x-plain-flip-fb-recreate: SKIP (0.013s) [290.205615] [094/142] (718s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [290.302313] Starting subtest: cursorA-vs-flipB-varying-size [290.304921] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [290.322778] [095/142] (718s left) api_intel_bb (intel-bb-blit-none) [290.371056] Starting subtest: intel-bb-blit-none [293.459518] Subtest intel-bb-blit-none: SUCCESS (3.088s) [293.512109] [096/142] (715s left) i915_pm_rc6_residency (rc6-idle) [293.563330] Starting subtest: rc6-idle [293.566802] Starting dynamic subtest: rcs0 [305.818651] Dynamic subtest rcs0: FAIL (12.231s) [305.827155] Starting dynamic subtest: bcs0 [318.050545] Dynamic subtest bcs0: SUCCESS (12.253s) [318.059586] Starting dynamic subtest: vcs0 [330.263538] Dynamic subtest vcs0: SUCCESS (12.212s) [330.272299] Starting dynamic subtest: vecs0 [342.473570] Dynamic subtest vecs0: SUCCESS (12.209s) [342.474394] Subtest rc6-idle: FAIL (48.911s) [342.693346] [097/142] (666s left) kms_lease (multimaster-lease) [342.793047] Starting subtest: multimaster-lease [342.795188] Subtest multimaster-lease: SUCCESS (0.002s) [342.814054] [098/142] (666s left) gem_exec_schedule (u-submit-early-slice) [342.872639] Starting subtest: u-submit-early-slice [342.873425] Starting dynamic subtest: rcs0 [342.899317] Dynamic subtest rcs0: SUCCESS (0.026s) [342.905297] Starting dynamic subtest: bcs0 [342.927474] Dynamic subtest bcs0: SUCCESS (0.028s) [342.933403] Starting dynamic subtest: vcs0 [342.955484] Dynamic subtest vcs0: SUCCESS (0.027s) [342.961438] Starting dynamic subtest: vcs1 [342.981497] Dynamic subtest vcs1: SUCCESS (0.025s) [342.987244] Starting dynamic subtest: vecs0 [343.007937] Dynamic subtest vecs0: SUCCESS (0.026s) [343.008745] Subtest u-submit-early-slice: SUCCESS (0.136s) [343.269287] [099/142] (665s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [343.323247] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [343.429543] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s) [343.459254] [100/142] (665s left) perf (short-reads) [343.534650] Starting subtest: short-reads [343.545602] Subtest short-reads: SUCCESS (0.011s) [343.564578] [101/142] (665s left) kms_chamelium_hpd (common-hpd-after-suspend) [343.713368] Subtest common-hpd-after-suspend: SKIP (0.000s) [343.784082] [102/142] (665s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [343.886369] Starting subtest: psr-2p-primscrn-cur-indfb-move [343.887887] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [343.927457] [103/142] (665s left) gem_exec_reloc (basic-cpu-wc-noreloc) [343.980706] Starting subtest: basic-cpu-wc-noreloc [343.983657] Subtest basic-cpu-wc-noreloc: SUCCESS (0.003s) [344.052485] [104/142] (665s left) gem_lmem_swapping (verify-random) [344.103537] Subtest verify-random: SKIP (0.000s) [344.123229] [105/142] (665s left) syncobj_timeline (reset-during-wait-for-submit) [344.173131] Starting subtest: reset-during-wait-for-submit [344.273523] Subtest reset-during-wait-for-submit: SUCCESS (0.101s) [344.293098] [106/142] (665s left) gem_mmap_wc (write-prefaulted) [344.339315] Starting subtest: write-prefaulted [344.374516] Subtest write-prefaulted: SUCCESS (0.036s) [344.399753] [107/142] (664s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [344.452899] Starting subtest: addfb25-x-tiled-mismatch-legacy [344.453687] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [344.534131] [108/142] (664s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf) [344.587321] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [344.596378] [109/142] (664s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs) [344.747798] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs [344.749287] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s) [345.023276] [110/142] (664s left) gen3_render_linear_blits [345.091097] [111/142] (664s left) kms_vblank (pipe-d-ts-continuation-modeset-hang) [345.192184] Starting subtest: pipe-D-ts-continuation-modeset-hang [358.942720] Subtest pipe-D-ts-continuation-modeset-hang: SUCCESS (13.751s) [359.028996] [112/142] (650s left) gem_lmem_swapping (parallel-random-verify-ccs) [359.079884] Subtest parallel-random-verify-ccs: SKIP (0.000s) [359.098740] [113/142] (650s left) kms_selftest (drm_cmdline) [359.144414] Starting subtest: drm_cmdline [359.146169] Subtest drm_cmdline: SKIP (0.001s) [359.157693] [114/142] (650s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [359.210323] Starting subtest: mixed-tiled-to-yf-tiled-ccs [359.211194] Starting dynamic subtest: smem [359.284372] Dynamic subtest smem: SUCCESS (0.073s) [359.285254] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.074s) [359.425284] [115/142] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [359.528319] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [359.529991] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [359.571073] [116/142] (649s left) kms_atomic_interruptible (universal-setplane-cursor) [359.676431] Starting subtest: universal-setplane-cursor [359.678227] Starting dynamic subtest: HDMI-A-1-pipe-A [365.871460] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (6.193s) [365.872238] Subtest universal-setplane-cursor: SUCCESS (6.195s) [365.955238] [117/142] (643s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [366.054499] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [366.056060] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [366.079107] [118/142] (643s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [366.176098] Starting subtest: basic-flip-before-cursor-varying-size [366.759039] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.584s) [366.836111] [119/142] (642s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [367.246623] Starting subtest: syncobj-stationary-timeline-chain-engines [367.306334] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.061s) [367.447046] [120/142] (642s left) syncobj_wait (wait-all-delayed-signal) [367.498007] Starting subtest: wait-all-delayed-signal [367.599827] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [367.626605] [121/142] (641s left) perf_pmu (busy) [367.682444] Starting subtest: busy [367.683230] Starting dynamic subtest: rcs0 [368.214504] Dynamic subtest rcs0: SUCCESS (0.531s) [368.223743] Starting dynamic subtest: bcs0 [368.748185] Dynamic subtest bcs0: SUCCESS (0.533s) [368.756966] Starting dynamic subtest: vcs0 [369.280297] Dynamic subtest vcs0: SUCCESS (0.531s) [369.292894] Starting dynamic subtest: vcs1 [369.819361] Dynamic subtest vcs1: SUCCESS (0.538s) [369.828355] Starting dynamic subtest: vecs0 [370.353506] Dynamic subtest vecs0: SUCCESS (0.533s) [370.354917] Subtest busy: SUCCESS (2.671s) [370.388874] [122/142] (639s left) gem_eio (in-flight-internal-1us) [370.446446] Starting subtest: in-flight-internal-1us [370.698995] Subtest in-flight-internal-1us: SUCCESS (0.251s) [370.768897] [123/142] (638s left) kms_vblank (pipe-a-query-idle-hang) [370.864924] Starting subtest: pipe-A-query-idle-hang [372.289740] Subtest pipe-A-query-idle-hang: SUCCESS (1.425s) [372.378305] [124/142] (637s left) gem_ringfill (legacy-basic) [372.562286] Starting subtest: legacy-basic [372.563084] Starting dynamic subtest: default [372.592896] Dynamic subtest default: SUCCESS (0.030s) [372.598959] Starting dynamic subtest: render [372.608814] Dynamic subtest render: SUCCESS (0.015s) [372.614856] Starting dynamic subtest: bsd [372.630936] Dynamic subtest bsd: SUCCESS (0.021s) [372.637471] Starting dynamic subtest: bsd1 [372.646799] Dynamic subtest bsd1: SUCCESS (0.015s) [372.652482] Starting dynamic subtest: bsd2 [372.665120] Dynamic subtest bsd2: SUCCESS (0.017s) [372.671486] Starting dynamic subtest: blt [372.685386] Dynamic subtest blt: SUCCESS (0.019s) [372.698095] Starting dynamic subtest: vebox [372.705946] Dynamic subtest vebox: SUCCESS (0.019s) [372.707023] Subtest legacy-basic: SUCCESS (0.144s) [372.735400] [125/142] (636s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [372.832749] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [372.833489] Starting dynamic subtest: pipe-A-valid-mode [373.616244] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.782s) [373.617050] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.784s) [373.696847] [126/142] (635s left) kms_cursor_legacy (torture-bo) [373.798124] Starting subtest: torture-bo [373.798948] Starting dynamic subtest: pipe-A [379.253758] Dynamic subtest pipe-A: SUCCESS (5.455s) [379.260199] Starting dynamic subtest: pipe-B [384.746611] Dynamic subtest pipe-B: SUCCESS (5.492s) [384.753923] Starting dynamic subtest: pipe-C [390.332175] Dynamic subtest pipe-C: SUCCESS (5.585s) [390.338557] Starting dynamic subtest: pipe-D [396.345065] Dynamic subtest pipe-D: SUCCESS (6.012s) [396.359122] Starting dynamic subtest: all-pipes [401.860975] Dynamic subtest all-pipes: SUCCESS (5.515s) [401.861786] Subtest torture-bo: SUCCESS (28.063s) [401.889676] [127/142] (607s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [402.004937] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [402.006366] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [402.024718] [128/142] (607s left) gem_exec_params (rel-constants-invalid) [402.074203] Starting subtest: rel-constants-invalid [402.075044] Subtest rel-constants-invalid: SUCCESS (0.000s) [402.120572] [129/142] (607s left) kms_big_fb (linear-32bpp-rotate-90) [402.230300] Starting subtest: linear-32bpp-rotate-90 [402.283189] Subtest linear-32bpp-rotate-90: SKIP (0.052s) [402.334502] [130/142] (607s left) kms_flip (2x-modeset-vs-vblank-race) [402.418976] Starting subtest: 2x-modeset-vs-vblank-race [402.430555] Subtest 2x-modeset-vs-vblank-race: SKIP (0.012s) [402.459630] [131/142] (607s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [402.545944] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [402.559055] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.012s) [402.601328] [132/142] (607s left) gem_eio (in-flight-10ms) [402.659049] Starting subtest: in-flight-10ms [404.841610] Subtest in-flight-10ms: SUCCESS (2.181s) [404.918526] [133/142] (604s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [405.019744] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [405.271264] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.252s) [405.344638] [134/142] (604s left) kms_plane_lowres (tiling-x) [405.439258] Starting subtest: tiling-x [405.440057] Starting dynamic subtest: pipe-A-HDMI-A-1 [410.093613] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.654s) [410.163749] Starting dynamic subtest: pipe-B-HDMI-A-1 [414.681664] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.523s) [414.731683] Starting dynamic subtest: pipe-C-HDMI-A-1 [419.297368] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (4.571s) [419.367599] Starting dynamic subtest: pipe-D-HDMI-A-1 [423.947586] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.585s) [423.986477] Subtest tiling-x: SUCCESS (18.547s) [424.107811] [135/142] (585s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [424.215186] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [424.216027] Starting dynamic subtest: pipe-A-valid-mode [424.264711] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s) [424.266278] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.050s) [424.326028] [136/142] (585s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [424.425760] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [424.427255] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [424.474374] [137/142] (585s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs) [424.749416] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs [424.750933] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s) [424.914519] [138/142] (584s left) perf (blocking) [424.978210] Starting subtest: blocking [424.978949] Starting dynamic subtest: 0-rcs0 [435.006390] Dynamic subtest 0-rcs0: SUCCESS (10.026s) [435.007272] Subtest blocking: SUCCESS (10.027s) [435.021996] [139/142] (574s left) kms_sequence (get-forked) [435.121235] Starting subtest: get-forked [435.122020] Starting dynamic subtest: HDMI-A-1-pipe-A [436.340789] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (1.219s) [436.348569] Starting dynamic subtest: HDMI-A-1-pipe-B [437.557997] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (1.216s) [437.566571] Starting dynamic subtest: HDMI-A-1-pipe-C [438.805129] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (1.245s) [438.812034] Starting dynamic subtest: HDMI-A-1-pipe-D [440.020156] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (1.213s) [440.021086] Subtest get-forked: SUCCESS (4.900s) [440.078700] [140/142] (569s left) kms_plane (plane-position-hole-dpms) [440.177397] Starting subtest: plane-position-hole-dpms [440.178228] Starting dynamic subtest: pipe-A-planes [442.157248] Dynamic subtest pipe-A-planes: SUCCESS (1.979s) [442.164100] Starting dynamic subtest: pipe-B-planes [444.085035] Dynamic subtest pipe-B-planes: SUCCESS (1.926s) [444.085808] Subtest plane-position-hole-dpms: SUCCESS (3.909s) [444.165447] [141/142] (565s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25) [444.263992] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25 [444.265841] Starting dynamic subtest: pipe-A-HDMI-A-1 [444.278875] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s) [444.284795] Starting dynamic subtest: pipe-B-HDMI-A-1 [444.306986] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.027s) [444.312759] Starting dynamic subtest: pipe-C-HDMI-A-1 [444.335792] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.027s) [444.341647] Starting dynamic subtest: pipe-D-HDMI-A-1 [444.363877] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.026s) [444.365379] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.099s) [444.397710] [142/142] (565s left) gem_busy (parallel) [444.573102] Starting subtest: parallel [444.574151] Starting dynamic subtest: rcs0 [444.608870] Dynamic subtest rcs0: SUCCESS (0.046s) [444.616177] Starting dynamic subtest: bcs0 [444.624980] Dynamic subtest bcs0: SUCCESS (0.015s) [444.632313] Starting dynamic subtest: vcs0 [444.641898] Dynamic subtest vcs0: SUCCESS (0.016s) [444.649322] Starting dynamic subtest: vcs1 [444.666124] Dynamic subtest vcs1: SUCCESS (0.023s) [444.673526] Starting dynamic subtest: vecs0 [444.687792] Dynamic subtest vecs0: SUCCESS (0.021s) [444.688717] Subtest parallel: SUCCESS (0.125s) [444.837667] Closing watchdogs Done.