[38.853629] Initializing watchdogs [38.853697] /dev/watchdog0 [38.860223] [001/142] (960s left) kms_async_flips (test-time-stamp) [40.816640] Starting subtest: test-time-stamp [40.964591] Starting dynamic subtest: pipe-A-HDMI-A-4 [41.334751] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.370s) [41.512887] Starting dynamic subtest: pipe-B-HDMI-A-4 [41.583315] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.073s) [41.744931] Starting dynamic subtest: pipe-C-HDMI-A-4 [41.820268] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.078s) [41.978206] Starting dynamic subtest: pipe-D-HDMI-A-4 [42.056397] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.081s) [42.057236] Subtest test-time-stamp: SUCCESS (1.240s) [42.293360] [002/142] (957s left) kms_vblank (pipe-a-wait-busy) [44.250513] Starting subtest: pipe-A-wait-busy [46.683389] Subtest pipe-A-wait-busy: SUCCESS (2.433s) [46.787726] [003/142] (952s left) gem_exec_store (basic) [46.848822] Starting subtest: basic [46.923771] Subtest basic: SUCCESS (0.075s) [47.194545] [004/142] (952s left) gem_media_fill (media-fill) [47.265075] Starting subtest: media-fill [47.265905] Starting dynamic subtest: smem [47.281412] Dynamic subtest smem: SUCCESS (0.016s) [47.288331] Starting dynamic subtest: lmem0 [47.290982] Dynamic subtest lmem0: SUCCESS (0.009s) [47.291941] Subtest media-fill: SUCCESS (0.026s) [47.532341] [005/142] (951s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [49.483824] Starting subtest: cursorB-vs-flipB-toggle [49.485889] Subtest cursorB-vs-flipB-toggle: SKIP (0.002s) [49.537936] [006/142] (949s left) gem_flink_basic (flink-lifetime) [49.614987] Starting subtest: flink-lifetime [49.617468] Subtest flink-lifetime: SUCCESS (0.003s) [49.743701] [007/142] (949s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [51.733507] Starting subtest: planes-downscale-factor-0-5-unity-scaling [51.734609] Starting dynamic subtest: pipe-A-HDMI-A-4 [51.877731] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.143s) [51.884977] Starting dynamic subtest: pipe-B-HDMI-A-4 [52.019743] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.140s) [52.025574] Starting dynamic subtest: pipe-C-HDMI-A-4 [52.141732] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.120s) [52.147593] Starting dynamic subtest: pipe-D-HDMI-A-4 [52.263483] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.120s) [52.264288] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.531s) [52.382234] [008/142] (947s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf) [52.432356] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [52.458989] [009/142] (947s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [54.598312] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs [56.514786] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SUCCESS (1.918s) [56.703429] [010/142] (942s left) vc4/vc4_tiling (get-bad-handle) [56.774434] Subtest get-bad-handle: SKIP (0.000s) [56.819209] [011/142] (942s left) kms_vblank (pipe-b-wait-busy-hang) [58.774508] Starting subtest: pipe-B-wait-busy-hang [72.855631] Subtest pipe-B-wait-busy-hang: SUCCESS (14.081s) [72.954106] [012/142] (926s left) kms_big_fb (4-tiled-addfb) [74.920901] Starting subtest: 4-tiled-addfb [74.923097] Subtest 4-tiled-addfb: SKIP (0.000s) [75.009500] [013/142] (924s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [77.060335] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [77.062454] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [77.121902] [014/142] (922s left) gem_flink_basic (bad-flink) [77.212657] Starting subtest: bad-flink [77.214221] Subtest bad-flink: SUCCESS (0.000s) [77.285325] [015/142] (922s left) kms_vblank (pipe-d-query-forked-busy-hang) [79.282583] Starting subtest: pipe-D-query-forked-busy-hang [92.826459] Subtest pipe-D-query-forked-busy-hang: SUCCESS (13.550s) [92.943063] [016/142] (906s left) gem_mmap_gtt (cpuset-big-copy) [92.989775] Subtest cpuset-big-copy: SKIP (0.000s) [93.020026] [017/142] (906s left) gem_exec_balancer (parallel-bb-first) [93.377079] Starting subtest: parallel-bb-first [94.668765] Subtest parallel-bb-first: SUCCESS (1.292s) [94.726220] [018/142] (904s left) v3d/v3d_submit_cl (bad-bo) [94.796409] Subtest bad-bo: SKIP (0.000s) [94.864230] [019/142] (904s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_mc_ccs) [96.956838] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs [96.958669] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s) [97.107701] [020/142] (902s left) i915_hangman (hangcheck-unterminated) [97.168923] Starting subtest: hangcheck-unterminated [106.432380] Subtest hangcheck-unterminated: SUCCESS (9.264s) [106.553640] [021/142] (893s left) gem_softpin (allocator-evict) [106.604428] Starting subtest: allocator-evict [106.605395] Starting dynamic subtest: rcs0 [134.713491] Dynamic subtest rcs0: SUCCESS (28.106s) [134.719615] Starting dynamic subtest: bcs0 [162.899409] Dynamic subtest bcs0: SUCCESS (28.184s) [162.905545] Starting dynamic subtest: vcs0 [190.999282] Dynamic subtest vcs0: SUCCESS (28.102s) [191.005635] Starting dynamic subtest: vcs1 [219.137218] Dynamic subtest vcs1: SUCCESS (28.138s) [219.143531] Starting dynamic subtest: vecs0 [247.352258] Dynamic subtest vecs0: SUCCESS (28.215s) [247.353199] Subtest allocator-evict: SUCCESS (140.745s) [247.607982] [022/142] (752s left) gem_mmap_wc (write-read) [247.699615] Subtest write-read: SKIP (0.000s) [247.716268] [023/142] (752s left) kms_rotation_crc (sprite-rotation-180) [249.671457] Starting subtest: sprite-rotation-180 [257.588171] Subtest sprite-rotation-180: SUCCESS (7.915s) [257.750764] [024/142] (742s left) kms_cursor_edge_walk (128x128-left-edge) [259.706551] Starting subtest: 128x128-left-edge [259.707593] Starting dynamic subtest: pipe-A-HDMI-A-4 [263.124541] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.418s) [263.131817] Starting dynamic subtest: pipe-D-HDMI-A-4 [266.324463] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.198s) [266.325269] Subtest 128x128-left-edge: SUCCESS (6.619s) [266.446388] [025/142] (733s left) syncobj_timeline (invalid-query-zero-handles) [266.498593] Starting subtest: invalid-query-zero-handles [266.499523] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [266.572464] [026/142] (733s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [266.629548] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [266.654660] [027/142] (733s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs) [268.784014] Starting subtest: pipe-D-ccs-on-another-bo-yf_tiled_ccs [268.786059] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s) [268.876187] [028/142] (730s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [270.832627] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [270.837029] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s) [270.894034] [029/142] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt) [272.886139] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt [272.888178] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [272.967136] [030/142] (726s left) vgem_basic (dmabuf-mmap) [273.144114] Starting subtest: dmabuf-mmap [273.156234] Subtest dmabuf-mmap: SUCCESS (0.013s) [273.191228] [031/142] (726s left) kms_flip (2x-flip-vs-panning) [274.198044] Starting subtest: 2x-flip-vs-panning [274.223408] Subtest 2x-flip-vs-panning: SKIP (0.025s) [274.294799] [032/142] (725s left) i915_pm_rpm (system-suspend) [279.453368] Starting subtest: system-suspend [301.859450] Subtest system-suspend: SUCCESS (11.831s) [306.011190] [033/142] (707s left) perf_pmu (event-wait) [306.065839] Starting subtest: event-wait [306.066625] Starting dynamic subtest: rcs0 [306.068374] Dynamic subtest rcs0: SKIP (0.000s) [306.070308] Subtest event-wait: SKIP (0.000s) [306.136647] [034/142] (707s left) perf (invalid-create-userspace-config) [306.267259] Starting subtest: invalid-create-userspace-config [306.268085] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [306.296495] [035/142] (707s left) kms_addfb_basic (unused-pitches) [306.342127] Starting subtest: unused-pitches [306.342970] Subtest unused-pitches: SUCCESS (0.000s) [308.339422] [036/142] (705s left) perf (blocking-parameterized) [308.538995] Starting subtest: blocking-parameterized [328.583700] Subtest blocking-parameterized: SUCCESS (20.042s) [328.612401] [037/142] (684s left) drm_fdinfo (basics) [328.660074] Starting subtest: basics [328.661326] Subtest basics: SUCCESS (0.000s) [328.743150] [038/142] (684s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs) [330.865198] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs [330.867339] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s) [331.012560] [039/142] (682s left) gem_exec_params (invalid-fence-in-submit) [331.066097] Starting subtest: invalid-fence-in-submit [331.068664] Subtest invalid-fence-in-submit: SUCCESS (0.002s) [331.201963] [040/142] (682s left) kms_plane (plane-position-hole) [333.181705] Starting subtest: plane-position-hole [333.184085] Starting dynamic subtest: pipe-A-planes [335.754929] Dynamic subtest pipe-A-planes: SUCCESS (2.572s) [335.764339] Starting dynamic subtest: pipe-B-planes [338.163160] Dynamic subtest pipe-B-planes: SUCCESS (2.404s) [338.164010] Subtest plane-position-hole: SUCCESS (4.982s) [338.292252] [041/142] (675s left) kms_rotation_crc (multiplane-rotation) [340.251182] Starting subtest: multiplane-rotation [360.074122] Subtest multiplane-rotation: SUCCESS (19.825s) [360.214348] [042/142] (653s left) gem_softpin (noreloc) [360.280919] Starting subtest: noreloc [365.734365] Subtest noreloc: SUCCESS (5.450s) [365.828313] [043/142] (647s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_mc_ccs) [367.864388] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs [367.866091] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s) [368.056846] [044/142] (645s left) kms_vblank (pipe-c-query-forked-busy-hang) [370.011188] Starting subtest: pipe-C-query-forked-busy-hang [384.433577] Subtest pipe-C-query-forked-busy-hang: SUCCESS (14.423s) [384.541080] [045/142] (629s left) gem_exec_fence (submit67) [384.722424] Starting subtest: submit67 [384.724424] Subtest submit67: SKIP (0.000s) [385.314994] [046/142] (628s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs_cc) [387.388666] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc [387.390821] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [387.540852] [047/142] (626s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [389.503061] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [389.504995] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [389.601752] [048/142] (624s left) gem_userptr_blits (usage-restrictions) [389.745491] Starting subtest: usage-restrictions [389.746485] Subtest usage-restrictions: SUCCESS (0.000s) [389.898088] [049/142] (623s left) gem_cs_tlb (engines) [389.970207] Starting subtest: engines [389.971329] Starting dynamic subtest: rcs0 [392.127984] Dynamic subtest rcs0: SUCCESS (2.154s) [392.136150] Starting dynamic subtest: bcs0 [394.281621] Dynamic subtest bcs0: SUCCESS (2.152s) [394.289641] Starting dynamic subtest: vcs0 [396.434860] Dynamic subtest vcs0: SUCCESS (2.152s) [396.442864] Starting dynamic subtest: vcs1 [398.588189] Dynamic subtest vcs1: SUCCESS (2.152s) [398.596266] Starting dynamic subtest: vecs0 [400.740925] Dynamic subtest vecs0: SUCCESS (2.152s) [400.741760] Subtest engines: SUCCESS (10.768s) [400.867784] [050/142] (613s left) kms_psr (primary_mmap_cpu) [400.917597] Subtest primary_mmap_cpu: SKIP (0.000s) [400.948257] [051/142] (612s left) dmabuf_sync_file (export-multiwait) [401.005664] Starting subtest: export-multiwait [401.006633] Subtest export-multiwait: SUCCESS (0.000s) [401.057327] [052/142] (612s left) gem_create (create-valid-nonaligned) [401.106311] Starting subtest: create-valid-nonaligned [401.107286] Subtest create-valid-nonaligned: SUCCESS (0.000s) [401.337133] [053/142] (612s left) prime_busy (hang-wait) [401.394522] Starting subtest: hang-wait [401.396930] Starting dynamic subtest: rcs0 [415.384761] Dynamic subtest rcs0: SUCCESS (13.988s) [415.393034] Starting dynamic subtest: bcs0 [422.534793] Dynamic subtest bcs0: SUCCESS (7.150s) [422.544549] Starting dynamic subtest: vcs0 [429.576707] Dynamic subtest vcs0: SUCCESS (7.040s) [429.584885] Starting dynamic subtest: vcs1 [436.552462] Dynamic subtest vcs1: SUCCESS (6.975s) [436.560868] Starting dynamic subtest: vecs0 [443.529558] Dynamic subtest vecs0: SUCCESS (6.975s) [443.530522] Subtest hang-wait: SUCCESS (42.134s) [443.619300] [054/142] (570s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [445.624175] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [445.678767] [055/142] (568s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs) [447.634258] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs [447.636575] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s) [447.901305] [056/142] (566s left) kms_rotation_crc (primary-rotation-270) [449.863032] Starting subtest: primary-rotation-270 [460.525677] Subtest primary-rotation-270: SUCCESS (10.661s) [460.706769] [057/142] (553s left) syncobj_timeline (single-wait-available-submitted) [460.756974] Starting subtest: single-wait-available-submitted [460.757833] Subtest single-wait-available-submitted: SUCCESS (0.000s) [460.836288] [058/142] (553s left) gem_ctx_persistence (engines-mixed-process) [460.893537] Starting subtest: engines-mixed-process [460.894475] Starting dynamic subtest: rcs0 [462.862283] Dynamic subtest rcs0: SUCCESS (1.968s) [462.873371] Starting dynamic subtest: bcs0 [464.848379] Dynamic subtest bcs0: SUCCESS (1.984s) [464.859333] Starting dynamic subtest: vcs0 [466.829320] Dynamic subtest vcs0: SUCCESS (1.979s) [466.840372] Starting dynamic subtest: vcs1 [468.874288] Dynamic subtest vcs1: SUCCESS (2.043s) [468.885421] Starting dynamic subtest: vecs0 [470.861484] Dynamic subtest vecs0: SUCCESS (1.984s) [470.864443] Subtest engines-mixed-process: SUCCESS (9.970s) [470.931413] [059/142] (543s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [472.886106] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [472.888778] Starting dynamic subtest: pipe-A-valid-mode [473.638682] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.751s) [473.639666] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.753s) [473.760830] [060/142] (540s left) kms_content_protection (mei-interface) [475.761770] Starting subtest: mei-interface [476.031480] Subtest mei-interface: SKIP (0.267s) [476.185156] [061/142] (537s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [478.147782] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [478.149784] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [478.245559] [062/142] (535s left) kms_addfb_basic (bad-pitch-0) [478.384728] Starting subtest: bad-pitch-0 [478.385600] Subtest bad-pitch-0: SUCCESS (0.000s) [480.375075] [063/142] (533s left) gem_ctx_bad_destroy (invalid-ctx) [480.513488] Starting subtest: invalid-ctx [480.514447] Subtest invalid-ctx: SUCCESS (0.000s) [480.567399] [064/142] (533s left) kms_vblank (pipe-d-wait-forked-busy-hang) [482.512336] Starting subtest: pipe-D-wait-forked-busy-hang [496.428283] Subtest pipe-D-wait-forked-busy-hang: SUCCESS (13.915s) [496.543027] [065/142] (517s left) kms_big_fb (linear-64bpp-rotate-180) [498.510485] Starting subtest: linear-64bpp-rotate-180 [500.928372] Subtest linear-64bpp-rotate-180: SUCCESS (2.413s) [501.049296] [066/142] (513s left) gem_pxp (regular-baseline-src-copy-readible) [503.617098] Subtest regular-baseline-src-copy-readible: SKIP (0.000s) [503.687107] [067/142] (510s left) kms_force_connector_basic (force-load-detect) [503.794866] Starting subtest: force-load-detect [503.796655] Subtest force-load-detect: SKIP (0.000s) [504.912803] [068/142] (509s left) gem_exec_reloc (basic-write-cpu) [504.998179] Subtest basic-write-cpu: SKIP (0.000s) [505.050706] [069/142] (509s left) vc4/vc4_perfmon (create-perfmon-0) [505.141050] Subtest create-perfmon-0: SKIP (0.000s) [505.208531] [070/142] (509s left) sw_sync (sync_merge_invalid) [505.265834] Starting subtest: sync_merge_invalid [505.269363] Subtest sync_merge_invalid: SUCCESS (0.003s) [505.302913] [071/142] (509s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [507.265054] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [507.267548] Starting dynamic subtest: pipe-A-HDMI-A-4 [507.281154] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.013s) [507.290928] Starting dynamic subtest: pipe-B-HDMI-A-4 [507.306624] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.023s) [507.316347] Starting dynamic subtest: pipe-C-HDMI-A-4 [507.331913] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.023s) [507.342037] Starting dynamic subtest: pipe-D-HDMI-A-4 [507.357723] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.023s) [507.359359] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.092s) [507.424942] [072/142] (506s left) gem_userptr_blits (map-fixed-invalidate-busy) [507.486567] Starting subtest: map-fixed-invalidate-busy [507.488399] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [507.608819] [073/142] (506s left) gem_ctx_param (invalid-set-no-zeromap) [507.670095] Starting subtest: invalid-set-no-zeromap [507.671170] Subtest invalid-set-no-zeromap: SUCCESS (0.000s) [507.751050] [074/142] (506s left) i915_selftest (perf) [509.197797] Starting subtest: perf [509.199349] Starting dynamic subtest: engine_cs [510.352962] Dynamic subtest engine_cs: SUCCESS (1.151s) [510.360248] Starting dynamic subtest: request [514.363006] Dynamic subtest request: SUCCESS (4.009s) [514.370071] Starting dynamic subtest: migrate [515.439995] Dynamic subtest migrate: SUCCESS (1.076s) [515.447050] Starting dynamic subtest: region [528.747089] Dynamic subtest region: SUCCESS (13.306s) [528.748131] Subtest perf: SUCCESS (19.548s) [528.763492] [075/142] (485s left) gem_exec_flush (basic-batch-kernel-default-cmd) [531.218068] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [532.157298] [076/142] (482s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs) [534.289555] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs [534.291505] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s) [534.381378] [077/142] (480s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k) [536.371451] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s) [536.425783] [078/142] (478s left) i915_pm_rc6_residency (rc6-idle) [536.472977] Starting subtest: rc6-idle [536.477015] Starting dynamic subtest: rcs0 [548.795834] Dynamic subtest rcs0: FAIL (12.293s) [548.812809] Starting dynamic subtest: bcs0 [561.032351] Dynamic subtest bcs0: SUCCESS (12.261s) [561.041838] Starting dynamic subtest: vcs0 [573.295328] Dynamic subtest vcs0: SUCCESS (12.262s) [573.304766] Starting dynamic subtest: vecs0 [585.556591] Dynamic subtest vecs0: SUCCESS (12.260s) [585.557625] Subtest rc6-idle: FAIL (49.084s) [585.863884] [079/142] (428s left) kms_invalid_mode (bad-vsync-end) [587.820212] Starting subtest: bad-vsync-end [587.821302] Starting dynamic subtest: HDMI-A-4-pipe-A [587.865260] Dynamic subtest HDMI-A-4-pipe-A: SUCCESS (0.043s) [587.874509] Starting dynamic subtest: HDMI-A-4-pipe-B [587.875414] Dynamic subtest HDMI-A-4-pipe-B: SUCCESS (0.001s) [587.882962] Starting dynamic subtest: HDMI-A-4-pipe-C [587.883870] Dynamic subtest HDMI-A-4-pipe-C: SUCCESS (0.001s) [587.891421] Starting dynamic subtest: HDMI-A-4-pipe-D [587.892344] Dynamic subtest HDMI-A-4-pipe-D: SUCCESS (0.001s) [587.893346] Subtest bad-vsync-end: SUCCESS (0.054s) [587.968958] [080/142] (426s left) gem_ctx_shared (single-timeline) [588.035089] Starting subtest: single-timeline [588.060142] Subtest single-timeline: SUCCESS (0.022s) [588.352586] [081/142] (426s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [590.310534] Starting subtest: fbc-1p-primscrn-spr-indfb-move [593.584349] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.276s) [593.747735] [082/142] (420s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [593.797362] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [593.798294] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [593.873698] [083/142] (420s left) gem_userptr_blits (vma-merge) [593.947362] Starting subtest: vma-merge [614.034469] Subtest vma-merge: FAIL (20.072s) [614.121409] [084/142] (400s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs) [616.161375] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs [616.163592] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.000s) [616.351392] [085/142] (398s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs) [618.383322] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs [618.387397] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.003s) [618.586051] [086/142] (396s left) gem_render_copy (x-tiled) [618.643209] Starting subtest: x-tiled [618.644158] Starting dynamic subtest: smem [618.724655] Dynamic subtest smem: SUCCESS (0.081s) [618.734290] Starting dynamic subtest: lmem0 [619.483452] Dynamic subtest lmem0: SUCCESS (0.754s) [619.484664] Subtest x-tiled: SUCCESS (0.837s) [619.700291] [087/142] (394s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [621.659612] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [621.661336] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [621.741208] [088/142] (392s left) kms_plane_alpha_blend (alpha-basic) [623.762372] Starting subtest: alpha-basic [623.994321] Starting dynamic subtest: pipe-A-HDMI-A-4 [626.524422] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.528s) [626.549173] Starting dynamic subtest: pipe-D-HDMI-A-4 [629.173936] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.632s) [629.174738] Subtest alpha-basic: SUCCESS (5.413s) [629.297673] [089/142] (385s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [631.265332] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [631.267338] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [631.354896] [090/142] (383s left) kms_cursor_crc (cursor-rapid-movement-512x512) [633.594382] Starting subtest: cursor-rapid-movement-512x512 [633.597848] Subtest cursor-rapid-movement-512x512: SKIP (0.002s) [633.778043] [091/142] (381s left) kms_cursor_crc (cursor-offscreen-32x10) [635.826651] Starting subtest: cursor-offscreen-32x10 [635.870945] Subtest cursor-offscreen-32x10: SKIP (0.041s) [636.177741] [092/142] (378s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [638.157265] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [638.160552] Starting dynamic subtest: pipe-A-valid-mode [638.890350] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.732s) [638.891299] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.734s) [639.011058] [093/142] (375s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [640.971369] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [640.973605] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [641.072110] [094/142] (373s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [643.124657] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [643.126610] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [643.218795] [095/142] (371s left) gem_fenced_exec_thrash (too-many-fences) [643.354769] Subtest too-many-fences: SKIP (0.000s) [643.387559] [096/142] (371s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs) [645.497795] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs [645.499723] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s) [645.611114] [097/142] (369s left) gem_blits (basic) [645.673739] Starting subtest: basic [651.920273] Subtest basic: SUCCESS (6.243s) [652.042096] [098/142] (362s left) gem_exec_fence (syncobj-export) [652.439556] Starting subtest: syncobj-export [652.457708] Subtest syncobj-export: SUCCESS (0.018s) [652.847695] [099/142] (362s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt) [654.815211] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt [654.817100] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [654.922491] [100/142] (360s left) kms_psr2_sf (plane-move-sf-dmg-area) [655.058465] Subtest plane-move-sf-dmg-area: SKIP (0.000s) [655.085910] [101/142] (360s left) api_intel_allocator (fork-simple-stress) [655.133111] Starting subtest: fork-simple-stress [660.556995] Subtest fork-simple-stress: SUCCESS (5.421s) [660.659499] [102/142] (354s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs) [662.735490] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs [662.737403] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s) [662.960364] [103/142] (352s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [664.920174] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [667.859309] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.941s) [668.052607] [104/142] (347s left) kms_big_fb (y-tiled-32bpp-rotate-270) [670.027753] Starting subtest: y-tiled-32bpp-rotate-270 [671.811645] Subtest y-tiled-32bpp-rotate-270: SUCCESS (1.780s) [671.976136] [105/142] (343s left) syncobj_wait (wait-any-snapshot) [672.039193] Starting subtest: wait-any-snapshot [672.121723] Subtest wait-any-snapshot: SUCCESS (0.082s) [672.234040] [106/142] (343s left) gem_tiled_blits (basic) [672.295370] Subtest basic: SKIP (0.000s) [672.318402] [107/142] (342s left) gem_exec_balancer (bonded-chain) [672.374465] Starting subtest: bonded-chain [679.702270] Subtest bonded-chain: SUCCESS (7.324s) [680.035839] [108/142] (335s left) sysfs_preempt_timeout (invalid) [680.085140] Starting subtest: invalid [680.086058] Starting dynamic subtest: vecs0 [680.087013] Dynamic subtest vecs0: SUCCESS (0.000s) [680.095752] Starting dynamic subtest: vcs0 [680.096910] Dynamic subtest vcs0: SUCCESS (0.000s) [680.105252] Starting dynamic subtest: bcs0 [680.106279] Dynamic subtest bcs0: SUCCESS (0.000s) [680.114785] Starting dynamic subtest: rcs0 [680.115985] Dynamic subtest rcs0: SUCCESS (0.000s) [680.124195] Starting dynamic subtest: vcs1 [680.125464] Dynamic subtest vcs1: SUCCESS (0.000s) [680.127682] Subtest invalid: SUCCESS (0.008s) [680.199905] [109/142] (335s left) kms_chamelium_audio (dp-audio) [682.213753] Subtest dp-audio: SKIP (0.000s) [682.268648] [110/142] (333s left) v3d/v3d_perfmon (create-single-perfmon) [682.339720] Subtest create-single-perfmon: SKIP (0.000s) [682.390982] [111/142] (333s left) i915_pm_rpm (fences) [687.104142] Starting subtest: fences [687.108404] Subtest fences: SKIP (0.000s) [688.330942] [112/142] (327s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_mc_ccs) [690.364048] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs [690.367250] Subtest pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s) [690.580986] [113/142] (324s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [692.539750] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [692.541736] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [692.621608] [114/142] (322s left) gem_pwrite (basic-self) [692.746287] Subtest basic-self: SKIP (0.000s) [692.793934] [115/142] (322s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [694.766395] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [694.768497] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [694.866666] [116/142] (320s left) syncobj_timeline (etime-multi-wait-all-submitted) [695.011922] Starting subtest: etime-multi-wait-all-submitted [695.118121] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s) [695.221957] [117/142] (320s left) api_intel_bb (destroy-bb) [695.277384] Starting subtest: destroy-bb [695.298875] Subtest destroy-bb: SUCCESS (0.021s) [695.443205] [118/142] (320s left) gen9_exec_parse (batch-invalid-length) [695.516162] Subtest batch-invalid-length: SKIP (0.000s) [695.540347] [119/142] (320s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs_cc) [697.585061] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc [697.588278] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [697.765519] [120/142] (317s left) gem_exec_parallel (fds) [697.823602] Starting subtest: fds [697.824521] Starting dynamic subtest: rcs0 [702.649617] Dynamic subtest rcs0: SUCCESS (4.822s) [702.658817] Starting dynamic subtest: bcs0 [707.001485] Dynamic subtest bcs0: SUCCESS (4.351s) [707.010438] Starting dynamic subtest: vcs0 [711.719357] Dynamic subtest vcs0: SUCCESS (4.717s) [711.727960] Starting dynamic subtest: vcs1 [716.494242] Dynamic subtest vcs1: SUCCESS (4.774s) [716.502977] Starting dynamic subtest: vecs0 [720.659842] Dynamic subtest vecs0: SUCCESS (4.160s) [720.660770] Subtest fds: SUCCESS (22.829s) [720.949861] [121/142] (294s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu) [722.996332] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu [722.998318] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [723.090709] [122/142] (292s left) gem_exec_schedule (semaphore-codependency) [723.219354] Starting subtest: semaphore-codependency [723.244601] Subtest semaphore-codependency: SUCCESS (0.025s) [723.641870] [123/142] (292s left) gem_softpin (softpin) [723.693282] Starting subtest: softpin [756.008017] Subtest softpin: SUCCESS (32.311s) [756.169126] [124/142] (259s left) kms_lease (lease-unleased-crtc) [758.132341] Starting subtest: lease-unleased-crtc [758.135829] Starting dynamic subtest: pipe-A-HDMI-A-4 [758.196145] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.063s) [758.206856] Starting dynamic subtest: pipe-B-HDMI-A-4 [758.233441] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.036s) [758.243933] Starting dynamic subtest: pipe-C-HDMI-A-4 [758.284948] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.049s) [758.295636] Starting dynamic subtest: pipe-D-HDMI-A-4 [758.335571] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.049s) [758.336495] Subtest lease-unleased-crtc: SUCCESS (0.206s) [758.426812] [125/142] (257s left) gem_mmap_gtt (big-copy) [758.474486] Subtest big-copy: SKIP (0.000s) [758.502243] [126/142] (257s left) gem_gpgpu_fill (basic) [758.552156] Starting subtest: basic [758.553150] Starting dynamic subtest: smem [758.570434] Dynamic subtest smem: SUCCESS (0.018s) [758.580822] Starting dynamic subtest: lmem0 [758.581735] Dynamic subtest lmem0: SUCCESS (0.008s) [758.582700] Subtest basic: SUCCESS (0.028s) [758.675983] [127/142] (257s left) kms_setmode (invalid-clone-single-crtc-stealing) [758.751491] Starting subtest: invalid-clone-single-crtc-stealing [758.754875] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [758.815471] [128/142] (257s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [760.788508] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [760.790782] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [760.887829] [129/142] (255s left) kms_flip (bo-too-big) [761.974495] Starting subtest: bo-too-big [761.985544] Starting dynamic subtest: A-HDMI-A4 [762.197416] Dynamic subtest A-HDMI-A4: SUCCESS (0.212s) [762.207458] Starting dynamic subtest: B-HDMI-A4 [762.336384] Dynamic subtest B-HDMI-A4: SUCCESS (0.138s) [762.346609] Starting dynamic subtest: C-HDMI-A4 [762.476551] Dynamic subtest C-HDMI-A4: SUCCESS (0.139s) [762.487204] Starting dynamic subtest: D-HDMI-A4 [762.615914] Dynamic subtest D-HDMI-A4: SUCCESS (0.138s) [762.616983] Subtest bo-too-big: SUCCESS (0.642s) [762.775795] [130/142] (253s left) gem_ctx_param (set-priority-invalid-size) [762.825097] Starting subtest: set-priority-invalid-size [762.825894] Subtest set-priority-invalid-size: SUCCESS (0.000s) [762.913778] [131/142] (253s left) kms_feature_discovery (display-4x) [764.894189] Starting subtest: display-4x [764.896095] Subtest display-4x: SKIP (0.000s) [764.959485] [132/142] (251s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [766.974339] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [767.472951] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.498s) [767.609433] [133/142] (248s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [769.577418] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [769.579330] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [769.664534] [134/142] (246s left) gem_exec_reloc (basic-write-wc) [769.790216] Subtest basic-write-wc: SKIP (0.000s) [769.849645] [135/142] (246s left) v3d/v3d_wait_bo (map-bo-0ns) [769.922277] Subtest map-bo-0ns: SKIP (0.000s) [769.973397] [136/142] (246s left) kms_big_joiner (2x-modeset) [771.927266] Subtest 2x-modeset: SKIP (0.000s) [771.949206] [137/142] (244s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [773.904396] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [773.906353] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [774.001098] [138/142] (242s left) kms_big_fb (x-tiled-16bpp-rotate-180) [776.041568] Starting subtest: x-tiled-16bpp-rotate-180 [777.741410] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.696s) [777.874656] [139/142] (238s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [779.833638] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [779.835630] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [779.912476] [140/142] (236s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [780.041078] Starting subtest: x-tiled-to-vebox-y-tiled [780.042107] Starting dynamic subtest: smem [780.125418] Dynamic subtest smem: SUCCESS (0.083s) [780.135711] Starting dynamic subtest: lmem0 [780.881428] Dynamic subtest lmem0: SUCCESS (0.752s) [780.882400] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.838s) [781.101299] [141/142] (235s left) kms_dp_aux_dev [783.981073] [142/142] (232s left) gem_userptr_blits (unsync-unmap) [784.038622] Subtest unsync-unmap: SKIP (0.000s) [784.150567] Closing watchdogs Done.