[54.447886] Initializing watchdogs
[54.448122]   /dev/watchdog0
[54.461439] [001/141] (960s left) kms_vblank (pipe-c-query-forked-hang)
[54.891956] Starting subtest: pipe-C-query-forked-hang
[69.436468] Subtest pipe-C-query-forked-hang: SUCCESS (14.542s)
[69.663164] [002/141] (945s left) kms_universal_plane (universal-plane-pipe-c-functional)
[69.900933] Starting subtest: universal-plane-pipe-C-functional
[76.076094] Subtest universal-plane-pipe-C-functional: SUCCESS (6.176s)
[76.316936] [003/141] (938s left) gem_ctx_isolation (clean)
[76.493247] Starting subtest: clean
[76.496687] Starting dynamic subtest: rcs0
[76.615715] Dynamic subtest rcs0: SUCCESS (0.119s)
[76.633068] Starting dynamic subtest: bcs0
[76.793879] Dynamic subtest bcs0: SUCCESS (0.177s)
[76.820985] Starting dynamic subtest: vcs0
[76.938880] Dynamic subtest vcs0: SUCCESS (0.130s)
[76.953142] Starting dynamic subtest: vecs0
[77.064455] Dynamic subtest vecs0: SUCCESS (0.123s)
[77.067552] Subtest clean: SUCCESS (0.570s)
[77.249330] [004/141] (937s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[77.483730] Starting subtest: plane-all-modeset-transition-fencing
[77.486882] Starting dynamic subtest: pipe-A-HDMI-A-1
[129.576260] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (52.087s)
[129.841301] Starting dynamic subtest: pipe-A-HDMI-A-2
[182.853387] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (52.924s)
[183.117606] Starting dynamic subtest: pipe-B-HDMI-A-1
[232.612763] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (49.502s)
[232.817101] Starting dynamic subtest: pipe-B-HDMI-A-2
[282.251731] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (49.531s)
[282.512744] Subtest plane-all-modeset-transition-fencing: SUCCESS (205.026s)
[282.786083] [005/141] (732s left) sw_sync (alloc_timeline)
[282.945398] Starting subtest: alloc_timeline
[282.948940] Subtest alloc_timeline: SUCCESS (0.000s)
[283.016957] [006/141] (732s left) kms_flip (2x-modeset-vs-vblank-race)
[283.237409] Starting subtest: 2x-modeset-vs-vblank-race
[283.247334] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[287.856816] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (4.607s)
[287.873801] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[292.300834] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (4.437s)
[292.318693] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[296.906067] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (4.607s)
[296.908935] Subtest 2x-modeset-vs-vblank-race: SUCCESS (13.669s)
[297.507640] [007/141] (717s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[298.291306] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[298.542448] [008/141] (716s left) gem_mmap_wc (close)
[298.691899] Starting subtest: close
[298.701442] Subtest close: SUCCESS (0.011s)
[298.786279] [009/141] (716s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[299.052152] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[299.058314] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[299.136225] [010/141] (716s left) i915_pm_rps (min-max-config-idle)
[299.302210] Starting subtest: min-max-config-idle
[299.644142] Subtest min-max-config-idle: SUCCESS (0.342s)
[299.727102] [011/141] (715s left) perf_pmu (most-busy-idle-check-all)
[299.884361] Starting subtest: most-busy-idle-check-all
[299.891965] Starting dynamic subtest: rcs0
[300.513320] Dynamic subtest rcs0: SUCCESS (0.620s)
[300.526759] Starting dynamic subtest: bcs0
[301.134533] Dynamic subtest bcs0: SUCCESS (0.623s)
[301.151969] Starting dynamic subtest: vcs0
[301.763934] Dynamic subtest vcs0: SUCCESS (0.623s)
[301.776120] Starting dynamic subtest: vecs0
[302.380024] Dynamic subtest vecs0: SUCCESS (0.618s)
[302.383085] Subtest most-busy-idle-check-all: SUCCESS (2.491s)
[302.461257] [012/141] (712s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[302.619305] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[302.622907] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[302.715574] [013/141] (712s left) kms_vblank (pipe-a-wait-idle-hang)
[302.957533] Starting subtest: pipe-A-wait-idle-hang
[317.463877] Subtest pipe-A-wait-idle-hang: SUCCESS (14.502s)
[317.713990] [014/141] (697s left) gem_ctx_shared (create-shared-gtt)
[317.882814] Starting subtest: create-shared-gtt
[320.033746] Subtest create-shared-gtt: SUCCESS (2.151s)
[320.248503] [015/141] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[320.508297] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[320.515055] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[320.592445] [016/141] (694s left) kms_frontbuffer_tracking (fbc-badstride)
[320.859690] Starting subtest: fbc-badstride
[329.099656] Subtest fbc-badstride: SUCCESS (8.242s)
[329.311903] [017/141] (686s left) gem_exec_schedule (promotion)
[329.499662] Starting subtest: promotion
[329.503063] Starting dynamic subtest: rcs0
[329.616315] Dynamic subtest rcs0: SUCCESS (0.119s)
[329.640996] Starting dynamic subtest: bcs0
[329.749923] Dynamic subtest bcs0: SUCCESS (0.124s)
[329.780811] Starting dynamic subtest: vcs0
[329.867796] Dynamic subtest vcs0: SUCCESS (0.115s)
[329.885061] Starting dynamic subtest: vecs0
[329.978481] Dynamic subtest vecs0: SUCCESS (0.110s)
[329.982148] Subtest promotion: SUCCESS (0.482s)
[330.312407] [018/141] (685s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[330.549857] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[330.553461] Starting dynamic subtest: pipe-A-valid-mode
[331.589323] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.035s)
[331.592992] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SUCCESS (1.038s)
[331.883622] [019/141] (683s left) i915_pm_rpm (drm-resources-equal)
[334.050948] Starting subtest: drm-resources-equal
[335.231685] Subtest drm-resources-equal: SUCCESS (1.180s)
[335.555233] [020/141] (680s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[335.823239] Starting subtest: fbcpsr-stridechange
[335.829450] Subtest fbcpsr-stridechange: SKIP (0.000s)
[335.902209] [021/141] (679s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[336.149726] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[373.987701] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (37.834s)
[374.300172] [022/141] (641s left) gem_pipe_control_store_loop (fresh-buffer)
[374.458843] Starting subtest: fresh-buffer
[376.613663] Subtest fresh-buffer: SUCCESS (2.154s)
[376.710196] [023/141] (638s left) v3d/v3d_submit_csd (bad-bo)
[376.923196] Subtest bad-bo: SKIP (0.000s)
[376.983708] [024/141] (638s left) perf_pmu (busy)
[377.143115] Starting subtest: busy
[377.147138] Starting dynamic subtest: rcs0
[377.671262] Dynamic subtest rcs0: SUCCESS (0.531s)
[377.688532] Starting dynamic subtest: bcs0
[378.199265] Dynamic subtest bcs0: SUCCESS (0.525s)
[378.218199] Starting dynamic subtest: vcs0
[378.732162] Dynamic subtest vcs0: SUCCESS (0.530s)
[378.746149] Starting dynamic subtest: vecs0
[379.264052] Dynamic subtest vecs0: SUCCESS (0.532s)
[379.268169] Subtest busy: SUCCESS (2.123s)
[379.351945] [025/141] (636s left) kms_mmap_write_crc (main)
[379.592240] Starting subtest: main
[379.599815] Starting dynamic subtest: pipe-A-HDMI-A-1
[383.120567] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.520s)
[383.123795] Subtest main: SUCCESS (3.524s)
[383.434100] [026/141] (632s left) kms_psr (primary_mmap_cpu)
[383.605352] Subtest primary_mmap_cpu: SKIP (0.000s)
[383.649452] [027/141] (632s left) prime_vgem (basic-fence-flip)
[383.907566] Starting subtest: basic-fence-flip
[384.411142] Subtest basic-fence-flip: SUCCESS (0.502s)
[384.512725] [028/141] (631s left) i915_module_load (reload)
[384.661590] Starting subtest: reload
[387.223628] Subtest reload: SUCCESS (2.557s)
[387.309077] [029/141] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[387.778385] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[387.784773] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[387.860466] [030/141] (628s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[388.102443] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[388.111946] Starting dynamic subtest: pipe-A-valid-mode
[389.191406] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.075s)
[389.194705] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.083s)
[389.491887] [031/141] (626s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25)
[389.735982] Starting subtest: plane-downscale-with-modifiers-factor-0-25
[389.739742] Starting dynamic subtest: pipe-A-HDMI-A-1
[389.819462] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.074s)
[389.837962] Starting dynamic subtest: pipe-B-HDMI-A-1
[389.914870] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.089s)
[389.935344] Starting dynamic subtest: pipe-C-HDMI-A-1
[390.082539] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.161s)
[390.089091] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (0.343s)
[390.173907] [032/141] (625s left) gem_ctx_persistence (heartbeat-hostile)
[390.337415] Starting subtest: heartbeat-hostile
[391.476426] Subtest heartbeat-hostile: SUCCESS (1.139s)
[391.579953] [033/141] (624s left) v3d/v3d_mmap (mmap-bo)
[391.842685] Subtest mmap-bo: SKIP (0.000s)
[391.907630] [034/141] (624s left) gem_fence_thrash (bo-write-verify-y)
[392.076246] Starting subtest: bo-write-verify-y
[393.281287] Subtest bo-write-verify-y: SUCCESS (1.198s)
[393.366075] [035/141] (622s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_ccs)
[394.144813] Starting subtest: pipe-C-bad-rotation-90-y_tiled_ccs
[394.151205] Subtest pipe-C-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[394.478889] [036/141] (621s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[395.177795] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[395.183977] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[395.621084] [037/141] (620s left) kms_universal_plane (universal-plane-pipe-a-sanity)
[395.866180] Starting subtest: universal-plane-pipe-A-sanity
[397.296777] Subtest universal-plane-pipe-A-sanity: SUCCESS (1.431s)
[397.571492] [038/141] (618s left) gen7_exec_parse (oacontrol-tracking)
[397.734066] Subtest oacontrol-tracking: SKIP (0.000s)
[397.789201] [039/141] (618s left) api_intel_bb (blit-noreloc-keep-cache)
[397.942868] Starting subtest: blit-noreloc-keep-cache
[397.961081] Subtest blit-noreloc-keep-cache: SUCCESS (0.020s)
[398.052710] [040/141] (618s left) gem_lmem_swapping (parallel-random-verify)
[398.211639] Subtest parallel-random-verify: SKIP (0.000s)
[398.266794] [041/141] (618s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[399.062685] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[399.348644] [042/141] (617s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs)
[400.178541] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs
[400.184648] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.001s)
[400.509734] [043/141] (615s left) perf (mi-rpc)
[400.764105] Starting subtest: mi-rpc
[400.793649] Subtest mi-rpc: SUCCESS (0.029s)
[400.841594] [044/141] (615s left) gem_exec_params (invalid-fence-in-submit)
[401.002172] Starting subtest: invalid-fence-in-submit
[401.010357] Subtest invalid-fence-in-submit: SUCCESS (0.006s)
[401.109468] [045/141] (615s left) prime_vgem (basic-fence-read)
[401.280977] Starting subtest: basic-fence-read
[401.381071] Subtest basic-fence-read: SUCCESS (0.099s)
[401.468828] [046/141] (615s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_mc_ccs)
[402.265165] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[402.482732] [047/141] (614s left) vc4/vc4_wait_bo (bad-pad)
[402.699182] Subtest bad-pad: SKIP (0.000s)
[402.767973] [048/141] (613s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[402.943737] Starting subtest: y-tiled-to-vebox-x-tiled
[402.950870] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[403.134943] [049/141] (613s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[403.837816] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[403.848914] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.008s)
[404.210136] [050/141] (612s left) gem_exec_big (single)
[404.375995] Starting subtest: single
[422.364990] Subtest single: SUCCESS (17.984s)
[423.022389] [051/141] (593s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs)
[423.907352] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs
[423.913554] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[424.204898] [052/141] (592s left) v3d/v3d_submit_cl (bad-multisync-extension)
[424.419679] Subtest bad-multisync-extension: SKIP (0.000s)
[424.485574] [053/141] (592s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[424.757255] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[426.765795] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (2.016s)
[427.006774] [054/141] (589s left) kms_psr (psr2_primary_mmap_gtt)
[427.163492] Subtest psr2_primary_mmap_gtt: SKIP (0.000s)
[427.217967] [055/141] (589s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs)
[428.049454] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[428.328944] [056/141] (588s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[428.607338] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[428.614288] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[428.695347] [057/141] (588s left) kms_frontbuffer_tracking (psr-slowdraw)
[428.956872] Starting subtest: psr-slowdraw
[428.963276] Subtest psr-slowdraw: SKIP (0.000s)
[429.045805] [058/141] (587s left) prime_self_import (reimport-vs-gem_close-race)
[429.196507] Starting subtest: reimport-vs-gem_close-race
[434.215435] Subtest reimport-vs-gem_close-race: SUCCESS (5.016s)
[434.300976] [059/141] (582s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[434.544854] Starting subtest: yf-tiled-16bpp-rotate-180
[440.255860] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (5.709s)
[440.596525] [060/141] (576s left) kms_dp_tiled_display (basic-test-pattern-with-chamelium)
[440.849218] Starting subtest: basic-test-pattern-with-chamelium
[440.855804] Subtest basic-test-pattern-with-chamelium: SKIP (0.001s)
[440.940135] [061/141] (576s left) vc4/vc4_label_bo (set-label)
[441.144282] Subtest set-label: SKIP (0.000s)
[441.210741] [062/141] (575s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_mc_ccs)
[441.914879] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs
[441.921273] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[442.246012] [063/141] (574s left) kms_color (ctm-0-75)
[442.490633] Starting subtest: ctm-0-75
[442.493584] Starting dynamic subtest: pipe-A
[445.289474] Dynamic subtest pipe-A: SUCCESS (2.796s)
[445.315240] Starting dynamic subtest: pipe-B
[448.207354] Dynamic subtest pipe-B: SUCCESS (2.903s)
[448.229820] Starting dynamic subtest: pipe-C
[451.182858] Dynamic subtest pipe-C: SUCCESS (2.969s)
[451.186957] Subtest ctm-0-75: SUCCESS (8.688s)
[451.486331] [064/141] (565s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[451.753616] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[452.025252] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.267s)
[452.223278] [065/141] (565s left) gem_softpin (evict-active-interruptible)
[452.384826] Starting subtest: evict-active-interruptible
[452.410226] Subtest evict-active-interruptible: SUCCESS (0.025s)
[452.506013] [066/141] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[452.773135] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[452.779380] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[452.856436] [067/141] (564s left) kms_ccs (pipe-a-bad-aux-stride-yf_tiled_ccs)
[453.564594] Starting subtest: pipe-A-bad-aux-stride-yf_tiled_ccs
[453.567798] Subtest pipe-A-bad-aux-stride-yf_tiled_ccs: SUCCESS (0.002s)
[453.909104] [068/141] (563s left) dmabuf_sync_file (import-multiple-read-write)
[454.075065] Starting subtest: import-multiple-read-write
[454.086779] Subtest import-multiple-read-write: SUCCESS (0.013s)
[454.159197] [069/141] (563s left) gem_mmap_gtt (bad-object)
[454.311899] Starting subtest: bad-object
[454.315398] Subtest bad-object: SUCCESS (0.000s)
[454.409129] [070/141] (563s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[454.569913] Starting subtest: no-spare-fences-busy-interruptible
[456.756163] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.183s)
[456.857669] [071/141] (560s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[457.111709] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[457.375287] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.260s)
[457.592087] [072/141] (559s left) prime_vgem (fence-read-hang)
[457.772346] Subtest fence-read-hang: SKIP (0.000s)
[457.859778] [073/141] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[458.115551] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[458.121366] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[458.202583] [074/141] (559s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[458.356807] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[458.459297] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[458.540998] [075/141] (559s left) gem_mmap_gtt (medium-copy)
[458.691924] Starting subtest: medium-copy
[462.777739] Subtest medium-copy: SUCCESS (4.085s)
[462.860518] [076/141] (554s left) kms_getfb (getfb-repeated-different-handles)
[463.099565] Starting subtest: getfb-repeated-different-handles
[463.103051] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[463.190794] [077/141] (554s left) gen9_exec_parse (batch-zero-length)
[463.360813] Starting subtest: batch-zero-length
[463.364599] Subtest batch-zero-length: SUCCESS (0.002s)
[463.577204] [078/141] (554s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted)
[463.746368] Starting subtest: invalid-multi-wait-available-unsubmitted
[463.751094] Subtest invalid-multi-wait-available-unsubmitted: SUCCESS (0.000s)
[463.842341] [079/141] (553s left) gem_exec_whisper (basic-queues-forked-all)
[464.012795] Starting subtest: basic-queues-forked-all
[485.297608] Subtest basic-queues-forked-all: SUCCESS (21.282s)
[485.491890] [080/141] (532s left) kms_sequence (queue-busy)
[485.740239] Starting subtest: queue-busy
[485.743570] Starting dynamic subtest: HDMI-A-1-pipe-A
[488.622419] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (2.877s)
[488.652233] Starting dynamic subtest: HDMI-A-2-pipe-A
[491.318333] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (2.679s)
[491.350669] Starting dynamic subtest: HDMI-A-1-pipe-B
[494.135597] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (2.808s)
[494.166918] Starting dynamic subtest: HDMI-A-2-pipe-B
[496.998911] Dynamic subtest HDMI-A-2-pipe-B: SUCCESS (2.851s)
[497.022890] Starting dynamic subtest: HDMI-A-1-pipe-C
[500.112914] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (3.110s)
[500.144930] Starting dynamic subtest: HDMI-A-2-pipe-C
[503.203508] Dynamic subtest HDMI-A-2-pipe-C: SUCCESS (3.080s)
[503.207772] Subtest queue-busy: SUCCESS (17.462s)
[503.450336] [081/141] (514s left) gem_mmap (short-mmap)
[503.607849] Starting subtest: short-mmap
[503.611306] Subtest short-mmap: SUCCESS (0.000s)
[503.698828] [082/141] (514s left) kms_big_fb (linear-64bpp-rotate-270)
[503.956730] Starting subtest: linear-64bpp-rotate-270
[504.279020] Subtest linear-64bpp-rotate-270: SKIP (0.317s)
[504.481411] [083/141] (513s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[504.666972] Starting subtest: map-fixed-invalidate-overlap
[504.670434] Starting dynamic subtest: gtt
[504.935933] Dynamic subtest gtt: SUCCESS (0.269s)
[504.960093] Starting dynamic subtest: wb
[505.156290] Dynamic subtest wb: SUCCESS (0.218s)
[505.180872] Starting dynamic subtest: wc
[505.376544] Dynamic subtest wc: SUCCESS (0.219s)
[505.401408] Starting dynamic subtest: uc
[505.596816] Dynamic subtest uc: SUCCESS (0.219s)
[505.600044] Subtest map-fixed-invalidate-overlap: SUCCESS (0.932s)
[505.715842] [084/141] (512s left) kms_lease (lease_get)
[505.959945] Starting subtest: lease_get
[505.967201] Starting dynamic subtest: pipe-A-HDMI-A-1
[505.972487] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.006s)
[506.003182] Starting dynamic subtest: pipe-A-HDMI-A-2
[506.006359] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[506.033956] Starting dynamic subtest: pipe-B-HDMI-A-1
[506.037260] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[506.054075] Starting dynamic subtest: pipe-B-HDMI-A-2
[506.057458] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[506.073546] Starting dynamic subtest: pipe-C-HDMI-A-1
[506.077068] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.003s)
[506.103045] Starting dynamic subtest: pipe-C-HDMI-A-2
[506.106288] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.007s)
[506.109626] Subtest lease_get: SUCCESS (0.080s)
[506.141746] [085/141] (511s left) gem_reg_read (timestamp-monotonic)
[506.294692] Starting subtest: timestamp-monotonic
[510.514571] Subtest timestamp-monotonic: SUCCESS (4.220s)
[510.598701] [086/141] (507s left) kms_flip (plain-flip-interruptible)
[510.832293] Starting subtest: plain-flip-interruptible
[510.839952] Starting dynamic subtest: A-HDMI-A1
[512.158353] Dynamic subtest A-HDMI-A1: SUCCESS (1.319s)
[512.183852] Starting dynamic subtest: B-HDMI-A1
[513.092066] Dynamic subtest B-HDMI-A1: SUCCESS (0.930s)
[513.117850] Starting dynamic subtest: C-HDMI-A1
[513.991278] Dynamic subtest C-HDMI-A1: SUCCESS (0.887s)
[514.018808] Starting dynamic subtest: A-HDMI-A2
[514.946242] Dynamic subtest A-HDMI-A2: SUCCESS (0.942s)
[514.979294] Starting dynamic subtest: B-HDMI-A2
[515.873113] Dynamic subtest B-HDMI-A2: SUCCESS (0.920s)
[515.891342] Starting dynamic subtest: C-HDMI-A2
[516.775558] Dynamic subtest C-HDMI-A2: SUCCESS (0.888s)
[516.780763] Subtest plain-flip-interruptible: SUCCESS (5.944s)
[517.194130] [087/141] (500s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_ccs)
[517.446584] Starting subtest: pipe-A-bad-pixel-format-y_tiled_ccs
[517.449844] Subtest pipe-A-bad-pixel-format-y_tiled_ccs: SUCCESS (0.002s)
[518.278421] [088/141] (499s left) kms_chamelium_frames (dp-crc-fast)
[518.951553] Subtest dp-crc-fast: SKIP (0.000s)
[519.175514] [089/141] (498s left) api_intel_bb (reset-bb)
[519.334586] Starting subtest: reset-bb
[519.342853] Subtest reset-bb: SUCCESS (0.008s)
[519.440931] [090/141] (498s left) kms_concurrent (pipe-d)
[519.694516] Subtest pipe-D: SKIP (0.000s)
[519.780539] [091/141] (498s left) kms_vblank (pipe-a-query-busy-hang)
[520.023762] Starting subtest: pipe-A-query-busy-hang
[534.430045] Subtest pipe-A-query-busy-hang: SUCCESS (14.406s)
[534.673131] [092/141] (483s left) kms_vblank (pipe-b-accuracy-idle)
[534.906833] Starting subtest: pipe-B-accuracy-idle
[540.425980] Subtest pipe-B-accuracy-idle: SUCCESS (5.516s)
[540.705757] [093/141] (477s left) gem_eio (in-flight-contexts-1us)
[540.898646] Starting subtest: in-flight-contexts-1us
[552.553055] Subtest in-flight-contexts-1us: SUCCESS (11.650s)
[552.726270] [094/141] (465s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[552.993342] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[552.999612] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[553.073328] [095/141] (465s left) gem_exec_params (rel-constants-invalid-ring)
[553.243415] Starting subtest: rel-constants-invalid-ring
[553.246703] Subtest rel-constants-invalid-ring: SUCCESS (0.001s)
[553.340066] [096/141] (465s left) kms_async_flips (crc)
[553.587397] Starting subtest: crc
[554.577620] Starting dynamic subtest: pipe-A-HDMI-A-1
[556.872163] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.295s)
[557.865976] Starting dynamic subtest: pipe-A-HDMI-A-2
[560.102283] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.279s)
[560.983116] Starting dynamic subtest: pipe-B-HDMI-A-1
[563.209345] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.258s)
[564.074092] Starting dynamic subtest: pipe-B-HDMI-A-2
[566.360164] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.328s)
[567.187985] Starting dynamic subtest: pipe-C-HDMI-A-1
[569.452788] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.289s)
[570.090921] Starting dynamic subtest: pipe-C-HDMI-A-2
[572.343750] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.294s)
[572.347101] Subtest crc: SUCCESS (18.766s)
[573.106661] [097/141] (445s left) syncobj_timeline (signal-point-0)
[573.267813] Starting subtest: signal-point-0
[573.271219] Subtest signal-point-0: SUCCESS (0.001s)
[573.361472] [098/141] (445s left) fbdev (unaligned-read)
[573.525161] Starting subtest: unaligned-read
[573.538677] Subtest unaligned-read: SUCCESS (0.013s)
[573.613241] [099/141] (444s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_ccs)
[574.381320] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_ccs
[574.387574] Subtest pipe-C-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.002s)
[574.648999] [100/141] (443s left) kms_cursor_crc (cursor-random-512x170)
[574.908472] Starting subtest: cursor-random-512x170
[574.918875] Subtest cursor-random-512x170: SKIP (0.005s)
[575.012299] [101/141] (443s left) kms_content_protection (lic)
[575.278220] Starting subtest: LIC
[577.212303] Subtest LIC: SKIP (1.917s)
[577.685148] [102/141] (440s left) gem_eio (throttle)
[577.872082] Starting subtest: throttle
[577.946832] Subtest throttle: SUCCESS (0.079s)
[578.132056] [103/141] (440s left) gem_userptr_blits (input-checking)
[578.295778] Starting subtest: input-checking
[578.299215] Subtest input-checking: SUCCESS (0.000s)
[578.430222] [104/141] (440s left) i915_pm_rpm (pm-caching)
[580.484020] Starting subtest: pm-caching
[582.081329] Subtest pm-caching: SUCCESS (1.605s)
[582.552033] [105/141] (436s left) gem_ctx_param (invalid-ctx-set)
[582.711441] Starting subtest: invalid-ctx-set
[582.714476] Subtest invalid-ctx-set: SUCCESS (0.001s)
[582.800545] [106/141] (435s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_mc_ccs)
[583.550124] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_mc_ccs
[583.556384] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[583.862579] [107/141] (434s left) gem_create (create-ext-set-pat)
[584.392455] Starting subtest: create-ext-set-pat
[584.530297] Subtest create-ext-set-pat: SKIP (0.000s)
[584.837102] [108/141] (434s left) perf_pmu (semaphore-busy)
[585.389964] Starting subtest: semaphore-busy
[585.521038] Starting dynamic subtest: rcs0
[586.807849] Dynamic subtest rcs0: SUCCESS (1.538s)
[586.830583] Starting dynamic subtest: bcs0
[588.355556] Dynamic subtest bcs0: SUCCESS (1.547s)
[588.377323] Starting dynamic subtest: vcs0
[589.903652] Dynamic subtest vcs0: SUCCESS (1.546s)
[589.921236] Starting dynamic subtest: vecs0
[591.442982] Dynamic subtest vecs0: SUCCESS (1.539s)
[591.446502] Subtest semaphore-busy: SUCCESS (6.175s)
[591.546360] [109/141] (427s left) kms_chamelium_edid (dp-edid-read)
[592.163487] Subtest dp-edid-read: SKIP (0.000s)
[592.415523] [110/141] (426s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[593.142830] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[593.153601] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.007s)
[593.660340] [111/141] (425s left) gem_exec_balancer (hang)
[596.793783] Starting subtest: hang
[599.503664] Subtest hang: SUCCESS (2.710s)
[599.611720] [112/141] (419s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[599.872429] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[602.393340] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.526s)
[602.615487] [113/141] (416s left) kms_cursor_legacy (single-bo)
[602.853360] Starting subtest: single-bo
[602.856686] Starting dynamic subtest: pipe-A
[624.389672] Dynamic subtest pipe-A: SUCCESS (21.527s)
[624.421524] Starting dynamic subtest: pipe-B
[645.891169] Dynamic subtest pipe-B: SUCCESS (21.504s)
[645.908848] Starting dynamic subtest: pipe-C
[667.394800] Dynamic subtest pipe-C: SUCCESS (21.502s)
[667.412362] Starting dynamic subtest: all-pipes
[688.901400] Dynamic subtest all-pipes: SUCCESS (21.503s)
[688.905017] Subtest single-bo: SUCCESS (86.042s)
[688.981180] [114/141] (330s left) kms_prime (basic-crc-vgem)
[690.756987] Starting subtest: basic-crc-vgem
[690.760469] Starting dynamic subtest: second-to-first
[692.309282] Dynamic subtest second-to-first: SUCCESS (1.552s)
[692.313870] Subtest basic-crc-vgem: SUCCESS (1.553s)
[692.516493] [115/141] (326s left) kms_plane_lowres (tiling-4)
[692.765291] Starting subtest: tiling-4
[692.771721] Subtest tiling-4: SKIP (0.000s)
[692.848627] [116/141] (326s left) gem_render_copy (linear-to-vebox-yf-tiled)
[693.018124] Starting subtest: linear-to-vebox-yf-tiled
[693.024816] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[693.216463] [117/141] (326s left) gem_exec_schedule (semaphore-power)
[693.520176] Starting subtest: semaphore-power
[694.389850] Subtest semaphore-power: SUCCESS (0.862s)
[694.603696] [118/141] (324s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[694.853537] Starting subtest: 4-tiled-32bpp-rotate-0
[694.860054] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[694.948160] [119/141] (324s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[695.216954] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[695.223222] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[695.297971] [120/141] (324s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[695.559738] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[695.566295] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[695.660299] [121/141] (323s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[695.925221] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[698.592467] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SUCCESS (2.674s)
[698.730480] [122/141] (320s left) kms_cursor_crc (cursor-sliding-128x128)
[698.980912] Starting subtest: cursor-sliding-128x128
[699.043257] Starting dynamic subtest: pipe-A-HDMI-A-1
[703.053118] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.020s)
[703.174875] Starting dynamic subtest: pipe-C-HDMI-A-1
[707.182275] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (4.033s)
[707.185402] Subtest cursor-sliding-128x128: SUCCESS (8.203s)
[707.468024] [123/141] (312s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[707.724673] Starting subtest: fbcpsr-tiling-4
[707.731434] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[707.810438] [124/141] (311s left) gem_mmap_offset (basic-uaf)
[707.962954] Starting subtest: basic-uaf
[707.966321] Subtest basic-uaf: SUCCESS (0.004s)
[708.065432] [125/141] (311s left) kms_vblank (pipe-d-wait-forked-busy)
[708.309528] Subtest pipe-D-wait-forked-busy: SKIP (0.000s)
[708.393854] [126/141] (311s left) drm_read (empty-block)
[708.942940] Starting subtest: empty-block
[709.943837] Subtest empty-block: SUCCESS (1.001s)
[710.165913] [127/141] (309s left) sysfs_heartbeat_interval (nopreempt)
[710.327719] Starting subtest: nopreempt
[710.331394] Starting dynamic subtest: vecs0
[713.776795] Dynamic subtest vecs0: SUCCESS (3.445s)
[713.808815] Starting dynamic subtest: vcs0
[717.225265] Dynamic subtest vcs0: SUCCESS (3.446s)
[717.252651] Starting dynamic subtest: bcs0
[720.665545] Dynamic subtest bcs0: SUCCESS (3.440s)
[720.700513] Starting dynamic subtest: rcs0
[724.145578] Dynamic subtest rcs0: SUCCESS (3.474s)
[724.148823] Subtest nopreempt: SUCCESS (13.811s)
[724.232976] [128/141] (295s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[724.388247] Starting subtest: write-cpu-read-wc-unflushed
[724.537729] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.150s)
[724.630654] [129/141] (295s left) gem_reg_read (bad-register)
[724.779236] Starting subtest: bad-register
[724.782479] Subtest bad-register: SUCCESS (0.000s)
[724.862324] [130/141] (294s left) gem_userptr_blits (vma-merge)
[725.058603] Starting subtest: vma-merge
[745.534950] Subtest vma-merge: FAIL (20.425s)
[745.566572] [131/141] (274s left) gem_pwrite (basic-random)
[745.720623] Starting subtest: basic-random
[751.790750] Subtest basic-random: SUCCESS (6.069s)
[751.913127] [132/141] (268s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[752.277747] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[752.283998] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[752.363213] [133/141] (267s left) syncobj_wait (reset-during-wait-for-submit)
[752.536514] Starting subtest: reset-during-wait-for-submit
[752.640216] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[752.727637] [134/141] (267s left) gem_exec_fence (keep-in-fence)
[753.025982] Starting subtest: keep-in-fence
[753.029193] Starting dynamic subtest: rcs0
[753.048705] Dynamic subtest rcs0: SUCCESS (0.023s)
[753.066221] Starting dynamic subtest: bcs0
[753.169152] Dynamic subtest bcs0: SUCCESS (0.115s)
[753.189230] Starting dynamic subtest: vcs0
[753.198182] Dynamic subtest vcs0: SUCCESS (0.028s)
[753.216564] Starting dynamic subtest: vecs0
[753.226320] Dynamic subtest vecs0: SUCCESS (0.030s)
[753.230942] Subtest keep-in-fence: SUCCESS (0.202s)
[753.813492] [135/141] (266s left) kms_flip (2x-flip-vs-panning-interruptible)
[754.033359] Starting subtest: 2x-flip-vs-panning-interruptible
[754.040763] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[765.070947] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.018s)
[765.093366] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[775.792780] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.716s)
[775.823061] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[786.437073] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.653s)
[786.440141] Subtest 2x-flip-vs-panning-interruptible: SUCCESS (32.401s)
[787.034218] [136/141] (233s left) gem_exec_fence (syncobj-timeline-unused-fence)
[787.725457] Starting subtest: syncobj-timeline-unused-fence
[787.732813] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[787.938284] [137/141] (232s left) gem_ctx_param (basic-default)
[788.092842] Starting subtest: basic-default
[788.096081] Subtest basic-default: SUCCESS (0.000s)
[788.172627] [138/141] (231s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[788.425353] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[788.431655] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[788.515341] [139/141] (231s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[788.669509] Starting subtest: multi-wait-all-for-submit-available-submitted
[788.672938] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.002s)
[788.755273] [140/141] (231s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[789.008223] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[791.362097] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.364s)
[791.568225] [141/141] (228s left) kms_plane_scaling (plane-upscale-with-rotation-factor-0-25)
[791.800556] Starting subtest: plane-upscale-with-rotation-factor-0-25
[791.803856] Starting dynamic subtest: pipe-A-HDMI-A-1
[792.068970] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.262s)
[792.097551] Starting dynamic subtest: pipe-B-HDMI-A-1
[792.416527] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.342s)
[792.446445] Starting dynamic subtest: pipe-C-HDMI-A-1
[792.710846] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.290s)
[792.718667] Subtest plane-upscale-with-rotation-factor-0-25: SKIP (0.908s)
[793.149924] Closing watchdogs
Done.