[33.100965] Initializing watchdogs
[33.101036]   /dev/watchdog0
[33.105228] [001/142] (960s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[33.193898] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[35.097511] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (1.905s)
[35.222366] [002/142] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[35.309482] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[35.310934] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[35.373188] [003/142] (958s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[35.460750] Starting subtest: y-tiled-16bpp-rotate-270
[36.879696] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.419s)
[36.994830] [004/142] (956s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[37.079543] Subtest bad-multisync-out-sync: SKIP (0.000s)
[37.143278] [005/142] (956s left) gem_lmem_swapping (verify-ccs)
[37.208931] Subtest verify-ccs: SKIP (0.000s)
[37.233429] [006/142] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[37.329280] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[37.330669] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[37.409799] [007/142] (956s left) gem_mmap_wc (invalid-flags)
[37.461589] Starting subtest: invalid-flags
[37.462335] Subtest invalid-flags: SUCCESS (0.000s)
[37.556353] [008/142] (956s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[37.613494] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[37.614192] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[37.684994] [009/142] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[37.780018] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[37.781358] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[37.859314] [010/142] (955s left) kms_flip (2x-wf_vblank-ts-check)
[37.951566] Starting subtest: 2x-wf_vblank-ts-check
[37.952905] Subtest 2x-wf_vblank-ts-check: SKIP (0.001s)
[38.022709] [011/142] (955s left) gem_mmap_wc (write-cpu-read-wc)
[38.082110] Starting subtest: write-cpu-read-wc
[38.162718] Subtest write-cpu-read-wc: SUCCESS (0.081s)
[38.235295] [012/142] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[38.326728] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[38.328094] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[38.415131] [013/142] (955s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[38.626436] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[38.628519] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[38.788129] [014/142] (955s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[38.864880] Starting subtest: cursorA-vs-flipA-atomic-transitions
[49.733559] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.870s)
[49.864093] [015/142] (943s left) gem_exec_schedule (semaphore-noskip)
[49.918812] Starting subtest: semaphore-noskip
[50.117266] Subtest semaphore-noskip: SUCCESS (0.188s)
[50.404858] [016/142] (943s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs)
[50.668994] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[50.765267] [017/142] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[50.845183] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[50.846520] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[50.931453] [018/142] (942s left) gem_eio (wait-wedge-immediate)
[50.983639] Starting subtest: wait-wedge-immediate
[51.223584] Subtest wait-wedge-immediate: SUCCESS (0.240s)
[51.360220] [019/142] (942s left) gem_pxp (reject-modify-context-protection-off-1)
[53.924284] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[53.987388] [020/142] (939s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[54.074026] Starting subtest: fbc-rgb565-draw-blt
[56.288503] Subtest fbc-rgb565-draw-blt: SUCCESS (2.216s)
[56.430430] [021/142] (937s left) kms_color (invalid-ctm-matrix-sizes)
[56.523989] Starting subtest: invalid-ctm-matrix-sizes
[56.524717] Starting dynamic subtest: pipe-A
[56.525410] Dynamic subtest pipe-A: SUCCESS (0.002s)
[56.528834] Starting dynamic subtest: pipe-B
[56.529547] Dynamic subtest pipe-B: SUCCESS (0.004s)
[56.530274] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.006s)
[56.581588] [022/142] (937s left) i915_pm_freq_mult (media-freq)
[56.626055] Starting subtest: media-freq
[56.626782] Starting dynamic subtest: gt0
[56.628130] Dynamic subtest gt0: SKIP (0.000s)
[56.629450] Subtest media-freq: SKIP (0.000s)
[56.697099] [023/142] (937s left) gem_exec_parallel (fds)
[56.753901] Starting subtest: fds
[56.754669] Starting dynamic subtest: rcs0
[58.711168] Dynamic subtest rcs0: SUCCESS (1.956s)
[58.724433] Starting dynamic subtest: bcs0
[60.580608] Dynamic subtest bcs0: SUCCESS (1.869s)
[60.595102] Starting dynamic subtest: vcs0
[62.457474] Dynamic subtest vcs0: SUCCESS (1.876s)
[62.468674] Starting dynamic subtest: vecs0
[64.342800] Dynamic subtest vecs0: SUCCESS (1.885s)
[64.344084] Subtest fds: SUCCESS (7.589s)
[64.547331] [024/142] (929s left) kms_hdr (static-swap)
[64.631533] Starting subtest: static-swap
[64.633159] Subtest static-swap: SKIP (0.000s)
[64.682260] [025/142] (929s left) gem_userptr_blits (set-cache-level)
[64.734327] Starting subtest: set-cache-level
[64.735017] Subtest set-cache-level: SUCCESS (0.000s)
[64.831539] [026/142] (929s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[64.915814] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[64.917166] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[65.013407] [027/142] (928s left) kms_vblank (pipe-b-wait-idle)
[65.106045] Starting subtest: pipe-B-wait-idle
[67.691310] Subtest pipe-B-wait-idle: SUCCESS (2.587s)
[67.809352] [028/142] (926s left) kms_psr (primary_render)
[67.853575] Subtest primary_render: SKIP (0.000s)
[67.869589] [029/142] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[67.948974] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[67.950386] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[68.027425] [030/142] (926s left) gem_exec_capture (userptr)
[68.085482] Starting subtest: userptr
[69.353727] Subtest userptr: SUCCESS (1.268s)
[69.449174] [031/142] (924s left) kms_vblank (pipe-b-query-forked-hang)
[69.542015] Starting subtest: pipe-B-query-forked-hang
[83.951022] Subtest pipe-B-query-forked-hang: SUCCESS (14.410s)
[84.083324] [032/142] (909s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[84.162838] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[84.163547] Starting dynamic subtest: pipe-A-valid-mode
[85.627647] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.464s)
[85.628422] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (1.465s)
[85.753169] [033/142] (908s left) kms_chamelium_hpd (vga-hpd-fast)
[85.899541] Subtest vga-hpd-fast: SKIP (0.000s)
[85.966832] [034/142] (908s left) kms_psr2_sf (cursor-plane-update-sf)
[86.011665] Subtest cursor-plane-update-sf: SKIP (0.000s)
[86.031561] [035/142] (908s left) gem_create (create-ext-placement-each)
[86.184159] Starting subtest: create-ext-placement-each
[86.184913] Subtest create-ext-placement-each: SUCCESS (0.000s)
[86.273590] [036/142] (907s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_mc_ccs)
[86.489894] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_mc_ccs
[86.491268] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[86.629592] [037/142] (907s left) perf_pmu (interrupts-sync)
[86.673221] Starting subtest: interrupts-sync
[87.751545] Subtest interrupts-sync: SUCCESS (1.077s)
[87.846171] [038/142] (906s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[87.932141] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[87.933662] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[88.205798] [039/142] (905s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[88.408447] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[88.682441] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.274s)
[88.872716] [040/142] (905s left) gem_exec_schedule (implicit-read-write)
[88.922761] Starting subtest: implicit-read-write
[88.923488] Starting dynamic subtest: rcs0
[88.966108] Dynamic subtest rcs0: SUCCESS (0.044s)
[88.970499] Starting dynamic subtest: bcs0
[89.007758] Dynamic subtest bcs0: SUCCESS (0.041s)
[89.012191] Starting dynamic subtest: vcs0
[89.051402] Dynamic subtest vcs0: SUCCESS (0.043s)
[89.061473] Starting dynamic subtest: vecs0
[89.102445] Dynamic subtest vecs0: SUCCESS (0.050s)
[89.103886] Subtest implicit-read-write: SUCCESS (0.180s)
[89.396635] [041/142] (904s left) kms_cursor_legacy (torture-bo)
[89.482949] Starting subtest: torture-bo
[89.483671] Starting dynamic subtest: pipe-A
[94.976370] Dynamic subtest pipe-A: SUCCESS (5.492s)
[94.985059] Starting dynamic subtest: pipe-B
[100.473655] Dynamic subtest pipe-B: SUCCESS (5.497s)
[100.478641] Starting dynamic subtest: all-pipes
[106.087540] Dynamic subtest all-pipes: SUCCESS (5.612s)
[106.088976] Subtest torture-bo: SUCCESS (16.604s)
[106.155769] [042/142] (888s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted)
[106.209793] Starting subtest: invalid-multi-wait-all-available-unsubmitted
[106.210494] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.000s)
[106.267436] [043/142] (887s left) gem_basic (multigpu-create-close)
[106.324450] Starting subtest: multigpu-create-close
[106.325914] Subtest multigpu-create-close: SKIP (0.000s)
[106.387281] [044/142] (887s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[106.451011] Starting subtest: yf-tiled-ccs-to-yf-tiled
[106.451793] Starting dynamic subtest: smem
[106.522611] Dynamic subtest smem: SUCCESS (0.071s)
[106.523362] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.072s)
[106.709891] [045/142] (887s left) i915_pm_rpm (legacy-planes)
[108.233233] Starting subtest: legacy-planes
[108.234741] Starting dynamic subtest: plane-40
[112.694529] Dynamic subtest plane-40: SUCCESS (4.460s)
[112.705195] Starting dynamic subtest: plane-49
[114.604895] Dynamic subtest plane-49: SUCCESS (1.909s)
[114.615445] Starting dynamic subtest: plane-58
[116.414087] Dynamic subtest plane-58: SUCCESS (1.807s)
[116.425349] Starting dynamic subtest: plane-67
[119.379392] Dynamic subtest plane-67: SUCCESS (2.964s)
[119.380758] Subtest legacy-planes: SUCCESS (11.147s)
[119.601654] [046/142] (874s left) syncobj_timeline (wait-all-for-submit-complex)
[119.646107] Starting subtest: wait-all-for-submit-complex
[119.868858] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[119.933576] [047/142] (874s left) gem_wait (busy)
[119.996872] Starting subtest: busy
[119.997561] Starting dynamic subtest: all-engines
[120.523893] Dynamic subtest all-engines: SUCCESS (0.527s)
[120.530231] Starting dynamic subtest: rcs0
[121.035751] Dynamic subtest rcs0: SUCCESS (0.511s)
[121.039914] Starting dynamic subtest: bcs0
[121.543741] Dynamic subtest bcs0: SUCCESS (0.508s)
[121.547933] Starting dynamic subtest: vcs0
[122.051718] Dynamic subtest vcs0: SUCCESS (0.508s)
[122.055888] Starting dynamic subtest: vecs0
[122.559727] Dynamic subtest vecs0: SUCCESS (0.508s)
[122.560403] Subtest busy: SUCCESS (2.563s)
[122.748855] [048/142] (871s left) gem_exec_flush (basic-batch-kernel-default-wb)
[122.812258] Starting subtest: basic-batch-kernel-default-wb
[128.390816] Subtest basic-batch-kernel-default-wb: SUCCESS (5.579s)
[128.596289] [049/142] (865s left) gem_create (create-valid-nonaligned)
[128.676738] Starting subtest: create-valid-nonaligned
[128.677439] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[128.873904] [050/142] (865s left) i915_query (query-regions-unallocated)
[128.930834] Starting subtest: query-regions-unallocated
[128.931592] Subtest query-regions-unallocated: SUCCESS (0.000s)
[128.999835] [051/142] (865s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[129.089269] Starting subtest: cursor-rapid-movement-64x64
[129.090965] Starting dynamic subtest: pipe-A-HDMI-A-2
[129.478131] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.387s)
[129.498495] Starting dynamic subtest: pipe-B-HDMI-A-2
[130.006577] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.512s)
[130.007301] Subtest cursor-rapid-movement-64x64: SUCCESS (0.918s)
[130.128527] [052/142] (864s left) gem_exec_reloc (basic-cpu-gtt)
[130.173793] Subtest basic-cpu-gtt: SKIP (0.000s)
[130.221937] [053/142] (864s left) gem_exec_reloc (basic-wc-cpu)
[130.266732] Subtest basic-wc-cpu: SKIP (0.000s)
[130.305270] [054/142] (864s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[130.348141] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[130.348885] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[130.409972] [055/142] (864s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[130.496392] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[130.497770] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[130.591051] [056/142] (863s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[130.677567] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[130.678951] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[130.769805] [057/142] (863s left) kms_big_fb (linear-8bpp-rotate-0)
[130.852792] Starting subtest: linear-8bpp-rotate-0
[132.533040] Subtest linear-8bpp-rotate-0: SUCCESS (1.680s)
[132.663287] [058/142] (861s left) kms_rotation_crc (sprite-rotation-270)
[132.750994] Starting subtest: sprite-rotation-270
[139.187474] Subtest sprite-rotation-270: SUCCESS (6.437s)
[139.386329] [059/142] (855s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[139.463430] Starting subtest: basic-busy-flip-before-cursor-atomic
[139.464835] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[139.518653] [060/142] (855s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[139.567006] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[139.567756] Starting dynamic subtest: smem
[139.648998] Dynamic subtest smem: SUCCESS (0.082s)
[139.649744] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (0.082s)
[139.839276] [061/142] (854s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[139.899666] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[140.011869] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[140.092997] [062/142] (854s left) gem_exec_big (single)
[140.148656] Starting subtest: single
[141.084823] Subtest single: SUCCESS (0.936s)
[141.277244] [063/142] (853s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[141.392418] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[141.393789] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[141.452738] [064/142] (853s left) perf (non-zero-reason)
[141.564975] Starting subtest: non-zero-reason
[141.565722] Starting dynamic subtest: 0-rcs0
[150.112451] Dynamic subtest 0-rcs0: SUCCESS (8.548s)
[150.113179] Subtest non-zero-reason: SUCCESS (8.548s)
[150.134488] [065/142] (844s left) kms_rotation_crc (sprite-rotation-180)
[150.214117] Starting subtest: sprite-rotation-180
[155.445401] Subtest sprite-rotation-180: SUCCESS (5.232s)
[155.627654] [066/142] (838s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[155.705593] Starting subtest: cursorB-vs-flipA-toggle
[155.707011] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[155.760242] [067/142] (838s left) api_intel_allocator (standalone)
[155.805191] Starting subtest: standalone
[155.819612] Subtest standalone: SUCCESS (0.015s)
[155.915507] [068/142] (838s left) kms_psr (psr2_sprite_mmap_cpu)
[155.963190] Subtest psr2_sprite_mmap_cpu: SKIP (0.000s)
[155.989036] [069/142] (838s left) vgem_basic (bad-fence)
[156.049188] Starting subtest: bad-fence
[156.049914] Subtest bad-fence: SUCCESS (0.000s)
[156.108600] [070/142] (838s left) gem_huc_copy (huc-copy)
[156.166797] Starting subtest: huc-copy
[156.168175] Subtest huc-copy: SKIP (0.000s)
[156.258509] [071/142] (838s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[156.314362] Starting subtest: invalid-smem-bo-on-discrete
[156.315787] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[156.431890] [072/142] (838s left) syncobj_timeline (invalid-query-bad-pad)
[156.490803] Starting subtest: invalid-query-bad-pad
[156.491509] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[156.560998] [073/142] (838s left) kms_chamelium_color (gamma)
[156.650688] Subtest gamma: SKIP (0.000s)
[156.672063] [074/142] (838s left) kms_plane (plane-position-hole)
[156.749386] Starting subtest: plane-position-hole
[156.750121] Starting dynamic subtest: pipe-A-planes
[158.482412] Dynamic subtest pipe-A-planes: SUCCESS (1.733s)
[158.488066] Starting dynamic subtest: pipe-B-planes
[160.306738] Dynamic subtest pipe-B-planes: SUCCESS (1.823s)
[160.307439] Subtest plane-position-hole: SUCCESS (3.559s)
[160.445006] [075/142] (834s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs)
[160.673263] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs
[160.675347] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[160.802247] [076/142] (833s left) i915_hwmon (hwmon-write)
[160.845687] Subtest hwmon-write: SKIP (0.000s)
[160.863333] [077/142] (833s left) kms_chamelium_frames (hdmi-crc-fast)
[161.015870] Subtest hdmi-crc-fast: SKIP (0.000s)
[161.085607] [078/142] (833s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[161.163215] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[161.163922] Starting dynamic subtest: pipe-A-valid-mode
[162.738158] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.574s)
[162.739230] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SUCCESS (1.576s)
[162.884958] [079/142] (831s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[162.967944] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[164.006873] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.038s)
[164.132827] [080/142] (830s left) syncobj_wait (signal)
[164.186093] Starting subtest: signal
[164.186820] Subtest signal: SUCCESS (0.000s)
[164.248992] [081/142] (830s left) kms_addfb_basic (unused-offsets)
[164.305878] Starting subtest: unused-offsets
[164.306589] Subtest unused-offsets: SUCCESS (0.000s)
[164.425430] [082/142] (830s left) syncobj_wait (wait-all-for-submit-complex)
[164.473795] Starting subtest: wait-all-for-submit-complex
[164.687529] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[164.766820] [083/142] (830s left) kms_big_fb (y-tiled-addfb-size-overflow)
[164.858003] Starting subtest: y-tiled-addfb-size-overflow
[164.858727] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.000s)
[164.944443] [084/142] (829s left) drm_fdinfo (virtual-busy-idle-all)
[165.000264] Starting subtest: virtual-busy-idle-all
[165.001913] Subtest virtual-busy-idle-all: SUCCESS (0.000s)
[165.065698] [085/142] (829s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_ccs)
[165.276670] Starting subtest: pipe-B-bad-pixel-format-y_tiled_ccs
[165.278056] Subtest pipe-B-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[165.428752] [086/142] (829s left) kms_vblank (pipe-d-wait-idle-hang)
[165.506352] Subtest pipe-D-wait-idle-hang: SKIP (0.000s)
[165.563764] [087/142] (829s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_ccs)
[165.825821] Subtest pipe-C-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[165.925335] [088/142] (829s left) gem_ctx_persistence (idempotent)
[165.971736] Starting subtest: idempotent
[165.972438] Subtest idempotent: SUCCESS (0.000s)
[166.024637] [089/142] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[166.106298] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[166.107694] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[166.174069] [090/142] (828s left) v3d/v3d_submit_csd (multiple-job-submission)
[166.246497] Subtest multiple-job-submission: SKIP (0.000s)
[166.309185] [091/142] (828s left) kms_lease (atomic_implicit_crtc)
[166.396061] Starting subtest: atomic_implicit_crtc
[166.396921] Starting dynamic subtest: pipe-A-HDMI-A-2
[166.397808] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[166.402527] Starting dynamic subtest: pipe-B-HDMI-A-2
[166.403255] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.005s)
[166.403957] Subtest atomic_implicit_crtc: SUCCESS (0.008s)
[166.458037] [092/142] (828s left) kms_universal_plane (cursor-fb-leak-pipe-c)
[166.536867] Subtest cursor-fb-leak-pipe-C: SKIP (0.000s)
[166.591182] [093/142] (828s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[166.669347] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[166.670069] Starting dynamic subtest: pipe-A-HDMI-A-2
[166.745945] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.077s)
[166.751795] Starting dynamic subtest: pipe-B-HDMI-A-2
[166.900256] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.153s)
[166.900968] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.232s)
[167.066494] [094/142] (827s left) kms_vblank (pipe-c-query-forked-busy-hang)
[167.142537] Subtest pipe-C-query-forked-busy-hang: SKIP (0.000s)
[167.199669] [095/142] (827s left) gem_mmap_wc (write-wc-read-gtt)
[167.242310] Starting subtest: write-wc-read-gtt
[167.506131] Subtest write-wc-read-gtt: SUCCESS (0.264s)
[167.592201] [096/142] (827s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[167.671284] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[167.672603] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[167.759615] [097/142] (827s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[168.027489] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[168.125822] [098/142] (826s left) gem_ppgtt (blt-vs-render-ctx0)
[168.171014] Starting subtest: blt-vs-render-ctx0
[200.585222] Subtest blt-vs-render-ctx0: SUCCESS (32.414s)
[200.706043] [099/142] (794s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[200.862661] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[203.164259] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.304s)
[203.307764] [100/142] (791s left) kms_dsc (dsc-with-formats)
[203.394276] Starting subtest: dsc-with-formats
[203.395651] Subtest dsc-with-formats: SKIP (0.000s)
[203.442992] [101/142] (791s left) gem_exec_schedule (preempt-queue-contexts-chain)
[203.499578] Starting subtest: preempt-queue-contexts-chain
[203.500294] Starting dynamic subtest: rcs0
[203.669153] Dynamic subtest rcs0: SUCCESS (0.169s)
[203.674340] Starting dynamic subtest: bcs0
[203.831601] Dynamic subtest bcs0: SUCCESS (0.162s)
[203.836609] Starting dynamic subtest: vcs0
[204.000296] Dynamic subtest vcs0: SUCCESS (0.168s)
[204.005318] Starting dynamic subtest: vecs0
[204.167243] Dynamic subtest vecs0: SUCCESS (0.166s)
[204.167951] Subtest preempt-queue-contexts-chain: SUCCESS (0.668s)
[204.474096] [102/142] (790s left) prime_self_import (basic-with_one_bo_two_files)
[204.527658] Starting subtest: basic-with_one_bo_two_files
[204.529075] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[204.630642] [103/142] (790s left) gem_exec_fair (basic-pace-solo)
[204.686248] Starting subtest: basic-pace-solo
[204.686988] Starting dynamic subtest: rcs0
[209.072093] Dynamic subtest rcs0: FAIL (4.368s)
[209.073183] Subtest basic-pace-solo: FAIL (4.369s)
[209.241562] [104/142] (785s left) kms_busy (extended-pageflip-hang-oldfb)
[209.329855] Starting subtest: extended-pageflip-hang-oldfb
[209.332117] Starting dynamic subtest: pipe-A
[209.618923] Dynamic subtest pipe-A: SUCCESS (0.288s)
[209.624836] Starting dynamic subtest: pipe-B
[209.793299] Dynamic subtest pipe-B: SUCCESS (0.173s)
[209.794004] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.464s)
[209.929202] [105/142] (785s left) kms_vblank (pipe-d-query-forked-hang)
[210.007563] Subtest pipe-D-query-forked-hang: SKIP (0.000s)
[210.061981] [106/142] (785s left) kms_pipe_crc_basic (hang-read-crc)
[210.140597] Starting subtest: hang-read-crc
[210.141384] Starting dynamic subtest: pipe-A-HDMI-A-2
[211.166334] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.027s)
[211.172194] Starting dynamic subtest: pipe-B-HDMI-A-2
[212.566331] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.399s)
[212.567060] Subtest hang-read-crc: SUCCESS (2.428s)
[212.667073] [107/142] (782s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[212.713265] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[212.764747] [108/142] (782s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[212.855379] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[212.856726] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[212.940724] [109/142] (782s left) gem_ctx_engines (independent)
[213.000600] Starting subtest: independent
[213.001376] Starting dynamic subtest: rcs0
[213.044402] Dynamic subtest rcs0: SUCCESS (0.043s)
[213.049332] Starting dynamic subtest: bcs0
[213.091032] Dynamic subtest bcs0: SUCCESS (0.046s)
[213.096088] Starting dynamic subtest: vcs0
[213.135962] Dynamic subtest vcs0: SUCCESS (0.044s)
[213.140851] Starting dynamic subtest: vecs0
[213.181755] Dynamic subtest vecs0: SUCCESS (0.045s)
[213.186812] Starting dynamic subtest: all-engines
[213.251188] Dynamic subtest all-engines: SUCCESS (0.069s)
[213.251952] Subtest independent: SUCCESS (0.251s)
[213.441807] [110/142] (781s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[213.535095] Starting subtest: cursorB-vs-flipB-varying-size
[213.536443] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[213.583383] [111/142] (781s left) kms_scaling_modes (scaling-mode-full)
[213.660405] Starting subtest: scaling-mode-full
[213.661762] Subtest scaling-mode-full: SKIP (0.000s)
[213.716491] [112/142] (781s left) i915_getparams_basic (basic-eu-total)
[213.761771] Starting subtest: basic-eu-total
[213.763091] Subtest basic-eu-total: SUCCESS (0.000s)
[213.835510] [113/142] (781s left) gem_caching (read-writes)
[213.884473] Starting subtest: read-writes
[224.100735] Subtest read-writes: SUCCESS (10.216s)
[224.203267] [114/142] (771s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[224.286772] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[224.288247] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[224.371911] [115/142] (771s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[224.467660] Starting subtest: 4-tiled-32bpp-rotate-270
[224.469172] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[224.568206] [116/142] (770s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[224.638486] Subtest mark-purgeable-twice: SKIP (0.000s)
[224.701329] [117/142] (770s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs)
[224.878475] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs
[224.880497] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[225.060844] [118/142] (770s left) gem_mmap_wc (read-write)
[225.105882] Starting subtest: read-write
[225.106590] Subtest read-write: SUCCESS (0.001s)
[225.193924] [119/142] (770s left) gem_exec_balancer (bonded-false-hang)
[226.121203] Starting subtest: bonded-false-hang
[226.853241] Subtest bonded-false-hang: SUCCESS (0.732s)
[226.919642] [120/142] (768s left) v3d/v3d_create_bo (create-bo-4096)
[226.998949] Subtest create-bo-4096: SKIP (0.000s)
[227.054564] [121/142] (768s left) gem_partial_pwrite_pread (reads-snoop)
[227.108472] Subtest reads-snoop: SKIP (0.000s)
[227.164392] [122/142] (768s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[227.254393] Starting subtest: fbcpsr-modesetfrombusy
[227.255761] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[227.365453] [123/142] (768s left) gem_exec_whisper (basic-contexts-all)
[227.424974] Starting subtest: basic-contexts-all
[228.967518] Subtest basic-contexts-all: SUCCESS (1.542s)
[229.164894] [124/142] (766s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[229.420417] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[229.519121] [125/142] (766s left) kms_ccs (pipe-c-crc-primary-basic-yf_tiled_ccs)
[229.763555] Subtest pipe-C-crc-primary-basic-yf_tiled_ccs: SKIP (0.000s)
[229.863611] [126/142] (765s left) kms_universal_plane (cursor-fb-leak-pipe-a)
[229.940494] Starting subtest: cursor-fb-leak-pipe-A
[230.278328] Subtest cursor-fb-leak-pipe-A: SUCCESS (0.339s)
[230.402982] [127/142] (765s left) perf_pmu (all-busy-idle-check-all)
[230.448561] Starting subtest: all-busy-idle-check-all
[231.067243] Subtest all-busy-idle-check-all: SUCCESS (0.618s)
[231.133153] [128/142] (764s left) core_setmaster (master-drop-set-root)
[231.702196] Starting subtest: master-drop-set-root
[231.707058] Subtest master-drop-set-root: SUCCESS (0.005s)
[231.717943] [129/142] (763s left) kms_cursor_crc (cursor-random-256x85)
[231.804427] Starting subtest: cursor-random-256x85
[231.807102] Starting dynamic subtest: pipe-A-HDMI-A-2
[235.530522] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.722s)
[235.564172] Starting dynamic subtest: pipe-B-HDMI-A-2
[239.413404] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.864s)
[239.414146] Subtest cursor-random-256x85: SUCCESS (7.609s)
[239.536794] [130/142] (756s left) perf_pmu (module-unload)
[239.589924] Starting subtest: module-unload
[276.437486] Subtest module-unload: SUCCESS (36.847s)
[276.452603] [131/142] (719s left) gem_ctx_persistence (userptr)
[277.995426] Starting subtest: userptr
[278.092051] Subtest userptr: SUCCESS (0.097s)
[278.118495] [132/142] (717s left) gem_exec_fence (syncobj-timeline-unused-fence)
[278.540941] Starting subtest: syncobj-timeline-unused-fence
[278.547268] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[278.740532] [133/142] (716s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[278.825953] Starting subtest: primary-y-tiled-reflect-x-90
[287.363806] Subtest primary-y-tiled-reflect-x-90: SUCCESS (8.537s)
[287.579845] [134/142] (708s left) kms_plane (pixel-format)
[287.656860] Starting subtest: pixel-format
[287.657578] Starting dynamic subtest: pipe-A-planes
[297.806614] Dynamic subtest pipe-A-planes: SUCCESS (10.149s)
[297.812146] Starting dynamic subtest: pipe-B-planes
[307.852267] Dynamic subtest pipe-B-planes: SUCCESS (10.045s)
[307.853067] Subtest pixel-format: SUCCESS (20.196s)
[307.980020] [135/142] (687s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_ccs)
[308.223910] Subtest pipe-C-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[308.322798] [136/142] (687s left) syncobj_wait (multi-wait-for-submit-submitted)
[308.367426] Starting subtest: multi-wait-for-submit-submitted
[308.473522] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[308.538829] [137/142] (687s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[308.636342] Starting subtest: psr-rgb565-draw-render
[308.637781] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[308.705820] [138/142] (687s left) v3d/v3d_submit_csd (valid-submission)
[308.777890] Subtest valid-submission: SKIP (0.000s)
[308.839861] [139/142] (686s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[308.925926] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[308.927351] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[309.021875] [140/142] (686s left) kms_frontbuffer_tracking (fbc-1p-rte)
[309.111453] Starting subtest: fbc-1p-rte
[312.730419] Subtest fbc-1p-rte: SUCCESS (3.620s)
[312.864919] [141/142] (682s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[312.949908] Starting subtest: x-tiled-8bpp-rotate-90
[313.004549] Subtest x-tiled-8bpp-rotate-90: SKIP (0.054s)
[313.092308] [142/142] (682s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[313.335458] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[313.432975] Closing watchdogs
Done.