[38.349854] Initializing watchdogs
[38.349939]   /dev/watchdog0
[38.356170] [001/137] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[40.327425] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[40.329809] Starting dynamic subtest: pipe-A-valid-mode
[41.338233] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.009s)
[41.339117] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SUCCESS (1.010s)
[41.459851] [002/137] (957s left) gem_softpin (softpin)
[41.537013] Starting subtest: softpin
[73.955965] Subtest softpin: SUCCESS (32.415s)
[74.055166] [003/137] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[76.034957] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[76.036944] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[76.104622] [004/137] (922s left) feature_discovery (psr1)
[78.100609] Starting subtest: psr1
[78.102226] Subtest psr1: SKIP (0.000s)
[78.154536] [005/137] (920s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[80.148121] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[81.391416] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.242s)
[81.489493] [006/137] (917s left) gen9_exec_parse (allowed-single)
[81.564525] Subtest allowed-single: SKIP (0.000s)
[81.595954] [007/137] (917s left) kms_vblank (pipe-d-wait-idle-hang)
[83.571497] Starting subtest: pipe-D-wait-idle-hang
[98.852643] Subtest pipe-D-wait-idle-hang: SUCCESS (15.279s)
[98.954305] [008/137] (899s left) kms_addfb_basic (bo-too-small)
[100.930289] Starting subtest: bo-too-small
[100.931358] Subtest bo-too-small: SUCCESS (0.000s)
[101.004693] [009/137] (897s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs)
[103.181919] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs
[103.184628] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[103.510528] [010/137] (895s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[105.486013] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[105.487927] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[105.986652] [011/137] (892s left) kms_lease (possible-crtcs-filtering)
[107.962463] Starting subtest: possible-crtcs-filtering
[107.966784] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[108.020432] [012/137] (890s left) kms_properties (invalid-properties-legacy)
[109.997373] Starting subtest: invalid-properties-legacy
[110.502358] Subtest invalid-properties-legacy: SUCCESS (0.502s)
[110.554201] [013/137] (888s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[112.537862] Starting subtest: x-tiled-64bpp-rotate-180
[114.641285] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.101s)
[114.755386] [014/137] (884s left) gem_eio (wait-wedge-10ms)
[114.957013] Starting subtest: wait-wedge-10ms
[116.278471] Subtest wait-wedge-10ms: SUCCESS (1.322s)
[118.328389] [015/137] (880s left) kms_cursor_crc (cursor-offscreen-128x128)
[120.417770] Starting subtest: cursor-offscreen-128x128
[120.425144] Starting dynamic subtest: pipe-A-HDMI-A-4
[122.876738] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.453s)
[122.899986] Starting dynamic subtest: pipe-D-HDMI-A-4
[126.365767] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.471s)
[126.366741] Subtest cursor-offscreen-128x128: SUCCESS (5.948s)
[126.693513] [016/137] (872s left) v3d/v3d_submit_csd (job-perfmon)
[126.811602] Subtest job-perfmon: SKIP (0.000s)
[126.861895] [017/137] (872s left) kms_pipe_crc_basic (read-crc)
[128.834860] Starting subtest: read-crc
[128.835800] Starting dynamic subtest: pipe-A-HDMI-A-4
[129.450274] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.615s)
[129.457353] Starting dynamic subtest: pipe-B-HDMI-A-4
[130.291883] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.838s)
[130.299410] Starting dynamic subtest: pipe-C-HDMI-A-4
[131.500828] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.206s)
[131.509407] Starting dynamic subtest: pipe-D-HDMI-A-4
[133.085590] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.578s)
[133.086557] Subtest read-crc: SUCCESS (4.249s)
[133.203947] [018/137] (865s left) api_intel_bb (reset-flags)
[133.275036] Starting subtest: reset-flags
[133.294810] Subtest reset-flags: SUCCESS (0.020s)
[133.404069] [019/137] (865s left) gem_exec_schedule (preempt-engines)
[133.484413] Starting subtest: preempt-engines
[133.485251] Starting dynamic subtest: rcs0
[135.723312] Dynamic subtest rcs0: SUCCESS (2.236s)
[135.728965] Starting dynamic subtest: bcs0
[137.903535] Dynamic subtest bcs0: SUCCESS (2.178s)
[137.910963] Starting dynamic subtest: vcs0
[140.146376] Dynamic subtest vcs0: SUCCESS (2.241s)
[140.156270] Starting dynamic subtest: vcs1
[142.393104] Dynamic subtest vcs1: SUCCESS (2.245s)
[142.403266] Starting dynamic subtest: vecs0
[144.621238] Dynamic subtest vecs0: SUCCESS (2.227s)
[144.623612] Subtest preempt-engines: SUCCESS (11.132s)
[144.938331] [020/137] (854s left) gem_exec_whisper (basic-normal-all)
[145.017855] Starting subtest: basic-normal-all
[147.169108] Subtest basic-normal-all: SUCCESS (2.150s)
[147.397257] [021/137] (851s left) kms_hdr (static-toggle-dpms)
[149.395830] Starting subtest: static-toggle-dpms
[149.397840] Subtest static-toggle-dpms: SKIP (0.000s)
[149.452872] [022/137] (849s left) kms_vblank (pipe-b-query-forked-hang)
[151.435559] Starting subtest: pipe-B-query-forked-hang
[165.851822] Subtest pipe-B-query-forked-hang: SUCCESS (14.417s)
[165.956776] [023/137] (833s left) gem_tiled_fence_blits (basic)
[166.028898] Subtest basic: SKIP (0.000s)
[166.048856] [024/137] (833s left) kms_properties (connector-properties-legacy)
[168.023531] Starting subtest: connector-properties-legacy
[168.673887] Subtest connector-properties-legacy: SUCCESS (0.652s)
[168.790154] [025/137] (830s left) gem_exec_fair (basic-none-solo)
[168.867566] Subtest basic-none-solo: SKIP (0.000s)
[168.915082] [026/137] (830s left) i915_hangman (error-state-basic)
[168.992955] Starting subtest: error-state-basic
[169.099184] Subtest error-state-basic: SUCCESS (0.106s)
[169.156264] [027/137] (830s left) kms_flip (plain-flip-fb-recreate-interruptible)
[170.184762] Starting subtest: plain-flip-fb-recreate-interruptible
[170.196081] Starting dynamic subtest: A-HDMI-A4
[178.217966] Dynamic subtest A-HDMI-A4: SUCCESS (8.021s)
[178.231398] Starting dynamic subtest: B-HDMI-A4
[186.178127] Dynamic subtest B-HDMI-A4: SUCCESS (7.957s)
[186.198301] Starting dynamic subtest: C-HDMI-A4
[194.149302] Dynamic subtest C-HDMI-A4: SUCCESS (7.968s)
[194.168733] Starting dynamic subtest: D-HDMI-A4
[202.112094] Dynamic subtest D-HDMI-A4: SUCCESS (7.959s)
[202.114288] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (31.926s)
[202.264760] [028/137] (796s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[204.246592] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[204.248780] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[204.331301] [029/137] (794s left) gem_exec_params (invalid-flag)
[204.423360] Starting subtest: invalid-flag
[204.424454] Subtest invalid-flag: SUCCESS (0.000s)
[204.503377] [030/137] (794s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[206.503389] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[206.505321] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[206.581100] [031/137] (792s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[208.574535] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[208.576593] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[208.647639] [032/137] (790s left) kms_vblank (pipe-a-wait-busy)
[210.640838] Starting subtest: pipe-A-wait-busy
[213.053902] Subtest pipe-A-wait-busy: SUCCESS (2.415s)
[213.150364] [033/137] (786s left) gem_pread (snoop)
[213.218754] Subtest snoop: SKIP (0.000s)
[213.259188] [034/137] (786s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs)
[215.560154] Starting subtest: pipe-D-bad-pixel-format-yf_tiled_ccs
[215.561992] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[215.748171] [035/137] (783s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[217.730462] Starting subtest: y-tiled-16bpp-rotate-90
[219.453173] Subtest y-tiled-16bpp-rotate-90: SUCCESS (1.719s)
[219.554778] [036/137] (779s left) drm_fdinfo (virtual-busy-all)
[219.630357] Subtest virtual-busy-all: SKIP (0.000s)
[219.656943] [037/137] (779s left) kms_ccs (pipe-d-missing-ccs-buffer-yf_tiled_ccs)
[222.007376] Starting subtest: pipe-D-missing-ccs-buffer-yf_tiled_ccs
[222.009136] Subtest pipe-D-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[222.134416] [038/137] (777s left) kms_vblank (pipe-a-ts-continuation-modeset-rpm)
[224.101809] Starting subtest: pipe-A-ts-continuation-modeset-rpm
[226.773808] Subtest pipe-A-ts-continuation-modeset-rpm: SUCCESS (2.674s)
[227.046449] [039/137] (772s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[227.119624] Starting subtest: saturated-hostile-nopreempt
[227.120519] Starting dynamic subtest: rcs0
[227.210090] Dynamic subtest rcs0: SUCCESS (0.090s)
[227.222075] Starting dynamic subtest: bcs0
[227.303656] Dynamic subtest bcs0: SUCCESS (0.093s)
[227.310968] Starting dynamic subtest: vcs0
[227.392538] Dynamic subtest vcs0: SUCCESS (0.087s)
[227.425798] Starting dynamic subtest: vcs1
[227.486488] Dynamic subtest vcs1: SUCCESS (0.092s)
[227.498526] Starting dynamic subtest: vecs0
[227.589674] Dynamic subtest vecs0: SUCCESS (0.101s)
[227.591881] Subtest saturated-hostile-nopreempt: SUCCESS (0.469s)
[227.729688] [040/137] (771s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-25)
[229.736763] Starting subtest: plane-downscale-with-rotation-factor-0-25
[229.739772] Starting dynamic subtest: pipe-A-HDMI-A-4
[229.783761] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.042s)
[229.789752] Starting dynamic subtest: pipe-B-HDMI-A-4
[229.823602] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.038s)
[229.829498] Starting dynamic subtest: pipe-C-HDMI-A-4
[229.862283] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.037s)
[229.868165] Starting dynamic subtest: pipe-D-HDMI-A-4
[229.901059] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.036s)
[229.903042] Subtest plane-downscale-with-rotation-factor-0-25: SKIP (0.162s)
[229.995722] [041/137] (769s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[231.971549] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[234.813925] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.843s)
[234.912515] [042/137] (764s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[236.938294] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[236.994747] [043/137] (762s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[238.975499] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[238.977374] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[239.066842] [044/137] (760s left) i915_hangman (engine-engine-hang)
[239.167775] Starting subtest: engine-engine-hang
[239.168830] Starting dynamic subtest: rcs0
[239.851245] Dynamic subtest rcs0: SUCCESS (0.683s)
[239.857122] Starting dynamic subtest: bcs0
[240.509319] Dynamic subtest bcs0: SUCCESS (0.657s)
[240.515555] Starting dynamic subtest: vcs0
[241.162267] Dynamic subtest vcs0: SUCCESS (0.652s)
[241.168854] Starting dynamic subtest: vcs1
[241.808247] Dynamic subtest vcs1: SUCCESS (0.645s)
[241.814106] Starting dynamic subtest: vecs0
[242.458235] Dynamic subtest vecs0: SUCCESS (0.649s)
[242.459145] Subtest engine-engine-hang: SUCCESS (3.291s)
[242.573975] [045/137] (756s left) kms_vblank (pipe-a-wait-forked-hang)
[244.551907] Starting subtest: pipe-A-wait-forked-hang
[258.871862] Subtest pipe-A-wait-forked-hang: SUCCESS (14.321s)
[258.971974] [046/137] (740s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[259.041840] Starting subtest: invalid-single-wait-all-unsubmitted
[259.042701] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[259.104882] [047/137] (740s left) gem_exec_schedule (semaphore-power)
[259.304549] Subtest semaphore-power: SKIP (0.000s)
[259.521399] [048/137] (740s left) gem_mmap_wc (write-read)
[259.616436] Subtest write-read: SKIP (0.000s)
[259.647615] [049/137] (739s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[261.632129] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[262.172231] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.540s)
[262.273882] [050/137] (737s left) kms_ccs (pipe-c-missing-ccs-buffer-yf_tiled_ccs)
[264.527779] Starting subtest: pipe-C-missing-ccs-buffer-yf_tiled_ccs
[264.529657] Subtest pipe-C-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[264.761280] [051/137] (734s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[264.833175] Starting subtest: multi-wait-all-for-submit-available-submitted
[264.834015] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[264.894596] [052/137] (734s left) kms_atomic (crtc-invalid-params-fence)
[267.091454] Starting subtest: crtc-invalid-params-fence
[267.212449] Subtest crtc-invalid-params-fence: SUCCESS (0.122s)
[267.388474] [053/137] (732s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[269.366101] Starting subtest: short-flip-before-cursor-toggle
[270.343988] Subtest short-flip-before-cursor-toggle: SUCCESS (0.980s)
[270.478346] [054/137] (729s left) prime_vgem (coherency-gtt)
[270.614159] Starting subtest: coherency-gtt
[270.616020] Subtest coherency-gtt: SKIP (0.000s)
[270.708811] [055/137] (728s left) vc4/vc4_wait_bo (used-bo-0ns)
[270.812844] Subtest used-bo-0ns: SKIP (0.000s)
[270.862519] [056/137] (728s left) kms_ccs (pipe-a-ccs-on-another-bo-yf_tiled_ccs)
[272.938768] Starting subtest: pipe-A-ccs-on-another-bo-yf_tiled_ccs
[272.940987] Subtest pipe-A-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[273.348665] [057/137] (726s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[275.324161] Starting subtest: cursorB-vs-flipA-atomic-transitions
[275.327437] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.004s)
[275.382090] [058/137] (724s left) kms_psr (psr2_no_drrs)
[275.462295] Subtest psr2_no_drrs: SKIP (0.000s)
[275.493777] [059/137] (724s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[275.588360] Starting subtest: rel-constants-invalid-rel-gen5
[275.590074] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[275.700719] [060/137] (724s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[276.027998] Starting subtest: parallel-dmabuf-import-out-fence
[277.555148] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.527s)
[277.616321] [061/137] (722s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[277.688314] Subtest writes-after-reads: SKIP (0.000s)
[277.724279] [062/137] (722s left) kms_prop_blob (invalid-set-prop-any)
[277.794500] Starting subtest: invalid-set-prop-any
[277.795468] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[277.857555] [063/137] (721s left) gem_mmap_gtt (basic-wc)
[277.972695] Subtest basic-wc: SKIP (0.000s)
[278.007467] [064/137] (721s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[279.987477] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[279.989570] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[280.065169] [065/137] (719s left) api_intel_allocator (standalone)
[280.157988] Starting subtest: standalone
[280.189335] Subtest standalone: SUCCESS (0.032s)
[280.314624] [066/137] (719s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[282.330874] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[282.332956] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[282.415785] [067/137] (717s left) perf (global-sseu-config-invalid)
[282.582401] Starting subtest: global-sseu-config-invalid
[282.583381] Starting dynamic subtest: 0-rcs0
[282.594454] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[282.595444] Subtest global-sseu-config-invalid: SUCCESS (0.015s)
[282.613278] [068/137] (717s left) v3d/v3d_perfmon (get-values-valid-perfmon)
[282.715990] Subtest get-values-valid-perfmon: SKIP (0.000s)
[282.765533] [069/137] (717s left) gem_exec_params (invalid-bsd2-flag-on-render)
[282.839901] Starting subtest: invalid-bsd2-flag-on-render
[282.840777] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[282.925526] [070/137] (717s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[285.049288] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[285.053616] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.003s)
[285.441050] [071/137] (714s left) gem_exec_reloc (basic-cpu-gtt-active)
[285.514659] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[285.550321] [072/137] (714s left) prime_vgem (coherency-blt)
[285.630927] Starting subtest: coherency-blt
[287.888966] Subtest coherency-blt: SUCCESS (2.255s)
[287.979149] [073/137] (712s left) sw_sync (sync_merge_same)
[288.051397] Starting subtest: sync_merge_same
[288.052333] Subtest sync_merge_same: SUCCESS (0.000s)
[288.091106] [074/137] (711s left) kms_vblank (pipe-d-accuracy-idle)
[290.066146] Starting subtest: pipe-D-accuracy-idle
[293.432499] Subtest pipe-D-accuracy-idle: SUCCESS (3.367s)
[293.554137] [075/137] (706s left) i915_pm_rpm (system-suspend)
[298.455873] Starting subtest: system-suspend
[321.875147] Subtest system-suspend: SUCCESS (11.988s)
[325.993546] [076/137] (688s left) gem_ctx_create (basic-files)
[326.073917] Starting subtest: basic-files
[328.087024] Subtest basic-files: SUCCESS (2.013s)
[328.404546] [077/137] (686s left) kms_psr (dpms)
[328.474482] Subtest dpms: SKIP (0.000s)
[328.504109] [078/137] (686s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[330.479885] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[330.482663] Starting dynamic subtest: pipe-A-valid-mode
[331.394825] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.907s)
[331.395887] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.908s)
[331.524531] [079/137] (683s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_mc_ccs)
[333.743493] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs
[333.745297] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[334.026881] [080/137] (680s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[336.008745] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[336.010522] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[336.094224] [081/137] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[338.105106] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[338.107000] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[338.193868] [082/137] (676s left) kms_async_flips (test-time-stamp)
[340.195851] Starting subtest: test-time-stamp
[340.199207] Starting dynamic subtest: pipe-A-HDMI-A-4
[342.183970] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.986s)
[342.191311] Starting dynamic subtest: pipe-B-HDMI-A-4
[343.992068] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.806s)
[343.999547] Starting dynamic subtest: pipe-C-HDMI-A-4
[345.403558] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.410s)
[345.411064] Starting dynamic subtest: pipe-D-HDMI-A-4
[346.440654] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.036s)
[346.441495] Subtest test-time-stamp: SUCCESS (6.245s)
[347.134947] [083/137] (667s left) gem_busy (busy)
[347.218719] Starting subtest: busy
[347.219687] Starting dynamic subtest: all-engines
[347.272182] Dynamic subtest all-engines: SUCCESS (0.053s)
[347.280312] Starting dynamic subtest: rcs0
[347.331884] Dynamic subtest rcs0: SUCCESS (0.059s)
[347.339425] Starting dynamic subtest: bcs0
[347.375701] Dynamic subtest bcs0: SUCCESS (0.042s)
[347.383284] Starting dynamic subtest: vcs0
[347.412627] Dynamic subtest vcs0: SUCCESS (0.037s)
[347.419881] Starting dynamic subtest: vcs1
[347.449705] Dynamic subtest vcs1: SUCCESS (0.036s)
[347.456941] Starting dynamic subtest: vecs0
[347.487646] Dynamic subtest vecs0: SUCCESS (0.036s)
[347.488794] Subtest busy: SUCCESS (0.268s)
[347.818545] [084/137] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[349.801036] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[349.803042] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[349.885274] [085/137] (664s left) gem_mmap_gtt (hang-busy)
[349.953629] Subtest hang-busy: SKIP (0.000s)
[349.977126] [086/137] (664s left) i915_pm_rpm (drm-resources-equal)
[354.927432] Starting subtest: drm-resources-equal
[372.364826] Subtest drm-resources-equal: SUCCESS (17.437s)
[372.710955] [087/137] (642s left) gem_ctx_persistence (engines-persistence)
[372.973912] Starting subtest: engines-persistence
[372.982467] Starting dynamic subtest: rcs0
[373.744265] Dynamic subtest rcs0: SUCCESS (0.804s)
[373.754382] Starting dynamic subtest: bcs0
[374.501146] Dynamic subtest bcs0: SUCCESS (0.755s)
[374.510149] Starting dynamic subtest: vcs0
[375.251151] Dynamic subtest vcs0: SUCCESS (0.749s)
[375.258637] Starting dynamic subtest: vcs1
[376.039137] Dynamic subtest vcs1: SUCCESS (0.787s)
[376.047865] Starting dynamic subtest: vecs0
[376.789445] Dynamic subtest vecs0: SUCCESS (0.749s)
[376.791624] Subtest engines-persistence: SUCCESS (3.850s)
[376.902374] [088/137] (637s left) gem_exec_schedule (implicit-write-read)
[376.987454] Starting subtest: implicit-write-read
[376.988262] Starting dynamic subtest: rcs0
[377.170653] Dynamic subtest rcs0: SUCCESS (0.179s)
[377.178154] Starting dynamic subtest: bcs0
[377.289346] Dynamic subtest bcs0: SUCCESS (0.121s)
[377.296811] Starting dynamic subtest: vcs0
[377.411261] Dynamic subtest vcs0: SUCCESS (0.121s)
[377.418741] Starting dynamic subtest: vcs1
[377.533970] Dynamic subtest vcs1: SUCCESS (0.122s)
[377.541314] Starting dynamic subtest: vecs0
[377.668878] Dynamic subtest vecs0: SUCCESS (0.134s)
[377.670085] Subtest implicit-write-read: SUCCESS (0.681s)
[378.057618] [089/137] (636s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[378.135583] Starting subtest: invalid-multi-wait-unsubmitted
[378.136539] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[378.195714] [090/137] (636s left) syncobj_timeline (reset-signaled)
[378.278405] Starting subtest: reset-signaled
[378.279258] Subtest reset-signaled: SUCCESS (0.000s)
[378.342107] [091/137] (636s left) kms_vblank (pipe-b-query-busy-hang)
[380.316423] Starting subtest: pipe-B-query-busy-hang
[394.311617] Subtest pipe-B-query-busy-hang: SUCCESS (13.996s)
[394.427484] [092/137] (620s left) kms_cursor_crc (cursor-sliding-64x64)
[396.484826] Starting subtest: cursor-sliding-64x64
[396.491464] Starting dynamic subtest: pipe-A-HDMI-A-4
[400.998145] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.507s)
[401.025099] Starting dynamic subtest: pipe-D-HDMI-A-4
[406.231396] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (5.214s)
[406.232585] Subtest cursor-sliding-64x64: SUCCESS (9.746s)
[406.632962] [093/137] (608s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[406.709279] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[406.710186] Starting dynamic subtest: smem
[406.806181] Dynamic subtest smem: SUCCESS (0.096s)
[406.813822] Starting dynamic subtest: lmem0
[407.757020] Dynamic subtest lmem0: SUCCESS (0.947s)
[407.757957] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (1.045s)
[407.972241] [094/137] (606s left) i915_query (query-topology-garbage-items)
[408.043193] Starting subtest: query-topology-garbage-items
[408.044064] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[408.103754] [095/137] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[410.083086] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[410.085365] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[410.172577] [096/137] (604s left) kms_chamelium_hpd (vga-hpd-fast)
[412.206347] Subtest vga-hpd-fast: SKIP (0.000s)
[412.264274] [097/137] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[414.241363] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[414.243414] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[414.320870] [098/137] (600s left) kms_flip (2x-blocking-absolute-wf_vblank)
[415.377953] Starting subtest: 2x-blocking-absolute-wf_vblank
[415.400089] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.025s)
[415.470802] [099/137] (599s left) gem_ringfill (engines-basic)
[415.907606] Starting subtest: engines-basic
[415.909059] Starting dynamic subtest: rcs0
[415.993203] Dynamic subtest rcs0: SUCCESS (0.087s)
[416.003960] Starting dynamic subtest: bcs0
[416.036865] Dynamic subtest bcs0: SUCCESS (0.042s)
[416.050091] Starting dynamic subtest: vcs0
[416.084118] Dynamic subtest vcs0: SUCCESS (0.046s)
[416.095889] Starting dynamic subtest: vcs1
[416.128781] Dynamic subtest vcs1: SUCCESS (0.043s)
[416.157011] Starting dynamic subtest: vecs0
[416.180596] Dynamic subtest vecs0: SUCCESS (0.050s)
[416.182020] Subtest engines-basic: SUCCESS (0.276s)
[416.320492] [100/137] (598s left) gem_mmap_gtt (big-copy)
[416.414806] Subtest big-copy: SKIP (0.000s)
[416.445735] [101/137] (598s left) kms_cursor_crc (cursor-random-128x42)
[418.548963] Starting subtest: cursor-random-128x42
[418.557081] Starting dynamic subtest: pipe-A-HDMI-A-4
[423.042552] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.487s)
[423.068248] Starting dynamic subtest: pipe-D-HDMI-A-4
[428.492942] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (5.431s)
[428.494021] Subtest cursor-random-128x42: SUCCESS (9.944s)
[428.785910] [102/137] (586s left) gem_exec_whisper (basic-queues-priority-all)
[428.865927] Starting subtest: basic-queues-priority-all
[451.708970] Subtest basic-queues-priority-all: SUCCESS (22.839s)
[451.903244] [103/137] (563s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[453.886712] Starting subtest: short-flip-after-cursor-atomic-transitions
[454.892636] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.008s)
[455.020146] [104/137] (560s left) sysfs_timeslice_duration (idempotent)
[455.093494] Starting subtest: idempotent
[455.095923] Starting dynamic subtest: vecs0
[455.096906] Dynamic subtest vecs0: SUCCESS (0.000s)
[455.104782] Starting dynamic subtest: vcs0
[455.105702] Dynamic subtest vcs0: SUCCESS (0.001s)
[455.113366] Starting dynamic subtest: bcs0
[455.114246] Dynamic subtest bcs0: SUCCESS (0.001s)
[455.121790] Starting dynamic subtest: rcs0
[455.122744] Dynamic subtest rcs0: SUCCESS (0.000s)
[455.130224] Starting dynamic subtest: vcs1
[455.131157] Dynamic subtest vcs1: SUCCESS (0.001s)
[455.132090] Subtest idempotent: SUCCESS (0.006s)
[455.169711] [105/137] (559s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[455.794121] Starting subtest: syncobj-stationary-timeline-chain-engines
[455.894318] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.104s)
[456.157127] [106/137] (558s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[456.224838] Starting subtest: single-wait-all-for-submit-unsubmitted
[456.330038] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[456.430174] [107/137] (558s left) perf (polling-small-buf)
[456.558872] Starting subtest: polling-small-buf
[456.659371] Subtest polling-small-buf: SUCCESS (0.100s)
[456.686127] [108/137] (558s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[458.670385] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[458.672396] Subtest psr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[458.753712] [109/137] (556s left) api_intel_allocator (gem-pool)
[458.852245] Starting subtest: gem-pool
[458.872984] Subtest gem-pool: SUCCESS (0.022s)
[459.026744] [110/137] (556s left) perf (sysctl-defaults)
[459.167344] Starting subtest: sysctl-defaults
[459.168392] Subtest sysctl-defaults: SUCCESS (0.000s)
[459.201399] [111/137] (556s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[459.273436] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[459.274453] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[459.349356] [112/137] (555s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[461.360623] Starting subtest: x-tiled-32bpp-rotate-0
[463.438640] Subtest x-tiled-32bpp-rotate-0: SUCCESS (2.074s)
[463.553850] [113/137] (551s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[465.541898] Starting subtest: 4-tiled-8bpp-rotate-90
[465.543825] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[465.637540] [114/137] (549s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs)
[467.790285] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs
[467.917612] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SUCCESS (0.127s)
[468.376442] [115/137] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[470.359182] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[470.361339] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[470.426328] [116/137] (544s left) v3d/v3d_submit_csd (bad-in-sync)
[470.542492] Subtest bad-in-sync: SKIP (0.000s)
[470.596750] [117/137] (544s left) gem_userptr_blits (vma-merge)
[470.703915] Starting subtest: vma-merge
[490.946960] Subtest vma-merge: FAIL (20.230s)
[491.054191] [118/137] (524s left) vc4/vc4_mmap (mmap-bad-handle)
[491.139376] Subtest mmap-bad-handle: SKIP (0.000s)
[491.190469] [119/137] (524s left) core_getclient
[491.325565] [120/137] (524s left) kms_ccs (pipe-b-missing-ccs-buffer-yf_tiled_ccs)
[493.488485] Starting subtest: pipe-B-missing-ccs-buffer-yf_tiled_ccs
[493.490711] Subtest pipe-B-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[493.818732] [121/137] (521s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[495.842196] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[495.902159] [122/137] (519s left) syncobj_wait (invalid-signal-one-illegal-handle)
[495.972573] Starting subtest: invalid-signal-one-illegal-handle
[495.973555] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[496.040129] [123/137] (519s left) kms_plane_multiple (tiling-y)
[498.013595] Starting subtest: tiling-y
[498.016607] Starting dynamic subtest: pipe-A-HDMI-A-4
[498.775680] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.759s)
[498.783651] Starting dynamic subtest: pipe-B-HDMI-A-4
[499.422943] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.646s)
[499.435478] Starting dynamic subtest: pipe-C-HDMI-A-4
[500.043480] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.614s)
[500.057381] Starting dynamic subtest: pipe-D-HDMI-A-4
[500.676030] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.632s)
[500.677044] Subtest tiling-y: SUCCESS (2.663s)
[500.807703] [124/137] (514s left) kms_plane_scaling (planes-upscale-20x20)
[502.781483] Starting subtest: planes-upscale-20x20
[502.784144] Starting dynamic subtest: pipe-A-HDMI-A-4
[502.889347] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.106s)
[502.898411] Starting dynamic subtest: pipe-B-HDMI-A-4
[503.012495] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.121s)
[503.021407] Starting dynamic subtest: pipe-C-HDMI-A-4
[503.135554] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.121s)
[503.144524] Starting dynamic subtest: pipe-D-HDMI-A-4
[503.257278] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.120s)
[503.258143] Subtest planes-upscale-20x20: SUCCESS (0.476s)
[503.381156] [125/137] (512s left) gem_eio (kms)
[505.458087] Starting subtest: kms
[521.063317] Subtest kms: FAIL (15.548s)
[521.278943] [126/137] (494s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[523.264220] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[523.266076] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[523.333711] [127/137] (492s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[525.310844] Starting subtest: plane-use-after-nonblocking-unbind
[525.311926] Starting dynamic subtest: pipe-A-HDMI-A-4
[525.398499] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.087s)
[525.447808] Starting dynamic subtest: pipe-B-HDMI-A-4
[525.586533] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.145s)
[525.611536] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.300s)
[525.715289] [128/137] (489s left) kms_draw_crc (draw-method-pwrite)
[527.690950] Starting subtest: draw-method-pwrite
[527.691946] Starting dynamic subtest: xrgb8888-untiled
[528.179754] Dynamic subtest xrgb8888-untiled: SUCCESS (0.488s)
[528.188091] Starting dynamic subtest: rgb565-untiled
[528.646325] Dynamic subtest rgb565-untiled: SUCCESS (0.466s)
[528.654265] Starting dynamic subtest: xrgb2101010-untiled
[529.112826] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.466s)
[529.120923] Starting dynamic subtest: xrgb8888-xtiled
[529.962831] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.849s)
[529.970644] Starting dynamic subtest: rgb565-xtiled
[530.862743] Dynamic subtest rgb565-xtiled: SUCCESS (0.899s)
[530.870734] Starting dynamic subtest: xrgb2101010-xtiled
[531.695951] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.833s)
[531.703904] Starting dynamic subtest: xrgb8888-ytiled
[532.412525] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.716s)
[532.420472] Starting dynamic subtest: rgb565-ytiled
[532.862462] Dynamic subtest rgb565-ytiled: SUCCESS (0.449s)
[532.870483] Starting dynamic subtest: xrgb2101010-ytiled
[533.562341] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.699s)
[533.563392] Subtest draw-method-pwrite: SUCCESS (5.872s)
[533.647790] [129/137] (481s left) kms_universal_plane (universal-plane-pipe-a-sanity)
[535.626761] Starting subtest: universal-plane-pipe-A-sanity
[536.170042] Subtest universal-plane-pipe-A-sanity: SUCCESS (0.544s)
[536.318211] [130/137] (479s left) gem_ctx_param (invalid-get-no-zeromap)
[536.387940] Starting subtest: invalid-get-no-zeromap
[536.388790] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[536.451393] [131/137] (479s left) kms_vblank (pipe-b-ts-continuation-suspend)
[538.427412] Starting subtest: pipe-B-ts-continuation-suspend
[559.767641] Subtest pipe-B-ts-continuation-suspend: SUCCESS (9.556s)
[563.899844] [132/137] (467s left) gem_pwrite (basic-self)
[563.972948] Subtest basic-self: SKIP (0.000s)
[564.011626] [133/137] (467s left) vgem_basic (mmap)
[564.084428] Starting subtest: mmap
[564.094521] Subtest mmap: SUCCESS (0.010s)
[564.135573] [134/137] (467s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[566.116226] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[566.118330] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[566.185860] [135/137] (465s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[568.600858] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[568.605058] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.003s)
[568.703334] [136/137] (462s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[570.679536] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[570.680584] Starting dynamic subtest: pipe-A-valid-mode
[570.729871] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s)
[570.731887] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.049s)
[570.818647] [137/137] (460s left) gem_mmap (pf-nonblock)
[570.887854] Subtest pf-nonblock: SKIP (0.000s)
[570.909012] Closing watchdogs
Done.