[51.529162] Initializing watchdogs
[51.529410]   /dev/watchdog0
[51.569185] [001/137] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[52.005926] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[52.025956] Starting dynamic subtest: pipe-A-valid-mode
[52.219329] Dynamic subtest pipe-A-valid-mode: SKIP (0.211s)
[52.262275] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.216s)
[52.608799] [002/137] (959s left) gem_softpin (softpin)
[53.062236] Starting subtest: softpin
[85.539505] Subtest softpin: SUCCESS (32.440s)
[85.637612] [003/137] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[86.085892] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[86.122867] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[86.214875] [004/137] (926s left) feature_discovery (psr1)
[86.591444] Starting subtest: psr1
[86.628410] Subtest psr1: SKIP (0.000s)
[86.718048] [005/137] (925s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[87.141969] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[88.807415] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.706s)
[89.027779] [006/137] (923s left) gen9_exec_parse (allowed-single)
[89.320594] Starting subtest: allowed-single
[89.342230] Subtest allowed-single: SUCCESS (0.010s)
[89.571336] [007/137] (922s left) kms_vblank (pipe-d-wait-idle-hang)
[89.974365] Subtest pipe-D-wait-idle-hang: SKIP (0.000s)
[90.143822] [008/137] (922s left) kms_addfb_basic (bo-too-small)
[90.524063] Starting subtest: bo-too-small
[90.543535] Subtest bo-too-small: SUCCESS (0.001s)
[90.637075] [009/137] (922s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs)
[91.234689] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs
[91.291519] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[91.743583] [010/137] (921s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[92.119200] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[92.158038] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[92.839354] [011/137] (920s left) kms_lease (possible-crtcs-filtering)
[93.198484] Starting subtest: possible-crtcs-filtering
[93.217250] Subtest possible-crtcs-filtering: SUCCESS (0.008s)
[93.322813] [012/137] (919s left) kms_properties (invalid-properties-legacy)
[93.724425] Starting subtest: invalid-properties-legacy
[93.853251] Subtest invalid-properties-legacy: SUCCESS (0.155s)
[93.976915] [013/137] (919s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[94.416446] Starting subtest: x-tiled-64bpp-rotate-180
[102.206412] Subtest x-tiled-64bpp-rotate-180: SUCCESS (7.809s)
[103.170900] [014/137] (909s left) gem_eio (wait-wedge-10ms)
[103.474565] Starting subtest: wait-wedge-10ms
[103.590951] Subtest wait-wedge-10ms: SUCCESS (0.134s)
[103.854936] [015/137] (909s left) kms_cursor_crc (cursor-offscreen-128x128)
[104.226417] Starting subtest: cursor-offscreen-128x128
[104.244726] Starting dynamic subtest: pipe-A-DP-1
[106.700595] Dynamic subtest pipe-A-DP-1: SUCCESS (2.468s)
[106.781785] Starting dynamic subtest: pipe-C-DP-1
[109.572032] Dynamic subtest pipe-C-DP-1: SUCCESS (2.814s)
[109.590524] Subtest cursor-offscreen-128x128: SUCCESS (5.356s)
[109.946957] [016/137] (903s left) v3d/v3d_submit_csd (job-perfmon)
[110.293153] Subtest job-perfmon: SKIP (0.000s)
[110.382829] [017/137] (903s left) kms_pipe_crc_basic (read-crc)
[110.733248] Starting subtest: read-crc
[110.751540] Starting dynamic subtest: pipe-A-DP-1
[111.307421] Dynamic subtest pipe-A-DP-1: SUCCESS (0.554s)
[111.348144] Starting dynamic subtest: pipe-B-DP-1
[112.131870] Dynamic subtest pipe-B-DP-1: SUCCESS (0.822s)
[112.166425] Starting dynamic subtest: pipe-C-DP-1
[113.067952] Dynamic subtest pipe-C-DP-1: SUCCESS (0.929s)
[113.087074] Subtest read-crc: SUCCESS (2.319s)
[113.386140] [018/137] (900s left) api_intel_bb (reset-flags)
[113.686237] Starting subtest: reset-flags
[113.704851] Subtest reset-flags: SUCCESS (0.022s)
[113.845279] [019/137] (899s left) gem_exec_schedule (preempt-engines)
[114.325908] Starting subtest: preempt-engines
[114.354206] Starting dynamic subtest: rcs0
[114.454444] Dynamic subtest rcs0: SUCCESS (0.305s)
[114.488089] Starting dynamic subtest: bcs0
[114.844190] Dynamic subtest bcs0: SUCCESS (0.393s)
[114.881841] Starting dynamic subtest: vcs0
[115.116465] Dynamic subtest vcs0: SUCCESS (0.269s)
[115.151877] Starting dynamic subtest: vecs0
[115.412542] Dynamic subtest vecs0: SUCCESS (0.299s)
[115.431611] Subtest preempt-engines: SUCCESS (1.268s)
[115.813418] [020/137] (897s left) gem_exec_whisper (basic-normal-all)
[116.121903] Starting subtest: basic-normal-all
[123.733727] Subtest basic-normal-all: SUCCESS (7.613s)
[123.939624] [021/137] (889s left) kms_hdr (static-toggle-dpms)
[124.295210] Starting subtest: static-toggle-dpms
[124.332608] Subtest static-toggle-dpms: SKIP (0.000s)
[124.429259] [022/137] (889s left) kms_vblank (pipe-b-query-forked-hang)
[124.781544] Starting subtest: pipe-B-query-forked-hang
[132.152077] Subtest pipe-B-query-forked-hang: SUCCESS (7.245s)
[132.399949] [023/137] (881s left) gem_tiled_fence_blits (basic)
[133.789494] Starting subtest: basic
[133.827154] Subtest basic: SUCCESS (0.037s)
[133.995080] [024/137] (880s left) kms_properties (connector-properties-legacy)
[134.531309] Starting subtest: connector-properties-legacy
[136.933192] Subtest connector-properties-legacy: SUCCESS (2.397s)
[137.267040] [025/137] (876s left) gem_exec_fair (basic-none-solo)
[137.753380] Starting subtest: basic-none-solo
[137.775173] Starting dynamic subtest: rcs0
[145.099961] Dynamic subtest rcs0: FAIL (7.025s)
[145.121100] Subtest basic-none-solo: FAIL (7.026s)
[145.216252] [026/137] (868s left) i915_hangman (error-state-basic)
[145.507232] Starting subtest: error-state-basic
[145.528642] Subtest error-state-basic: SUCCESS (0.008s)
[145.628775] [027/137] (868s left) kms_flip (plain-flip-fb-recreate-interruptible)
[146.004334] Starting subtest: plain-flip-fb-recreate-interruptible
[146.026209] Starting dynamic subtest: A-DP1
[156.796649] Dynamic subtest A-DP1: SUCCESS (10.788s)
[156.833908] Starting dynamic subtest: B-DP1
[167.503404] Dynamic subtest B-DP1: SUCCESS (10.714s)
[167.538183] Starting dynamic subtest: C-DP1
[178.226977] Dynamic subtest C-DP1: SUCCESS (10.721s)
[178.245636] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.229s)
[178.675431] [028/137] (835s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[179.143825] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[179.183049] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[179.272231] [029/137] (835s left) gem_exec_params (invalid-flag)
[179.547551] Starting subtest: invalid-flag
[179.566269] Subtest invalid-flag: SUCCESS (0.001s)
[179.672183] [030/137] (834s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[180.105587] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[180.142440] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[180.241682] [031/137] (834s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[180.674233] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[180.716719] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[180.810639] [032/137] (833s left) kms_vblank (pipe-a-wait-busy)
[181.167566] Starting subtest: pipe-A-wait-busy
[183.631608] Subtest pipe-A-wait-busy: SUCCESS (2.455s)
[183.985477] [033/137] (830s left) gem_pread (snoop)
[184.262166] Starting subtest: snoop
[189.659278] Subtest snoop: SUCCESS (5.209s)
[189.753145] [034/137] (825s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs)
[190.569478] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[190.867809] [035/137] (824s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[191.302530] Starting subtest: y-tiled-16bpp-rotate-90
[191.378832] Subtest y-tiled-16bpp-rotate-90: SKIP (0.071s)
[191.493940] [036/137] (823s left) drm_fdinfo (virtual-busy-all)
[191.769136] Starting subtest: virtual-busy-all
[191.787723] Subtest virtual-busy-all: SUCCESS (0.001s)
[191.892916] [037/137] (823s left) kms_ccs (pipe-d-missing-ccs-buffer-yf_tiled_ccs)
[192.697546] Subtest pipe-D-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[192.982615] [038/137] (822s left) kms_vblank (pipe-a-ts-continuation-modeset-rpm)
[193.373786] Starting subtest: pipe-A-ts-continuation-modeset-rpm
[195.398718] Subtest pipe-A-ts-continuation-modeset-rpm: SUCCESS (2.027s)
[195.858588] [039/137] (819s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[196.142812] Starting subtest: saturated-hostile-nopreempt
[196.161639] Starting dynamic subtest: rcs0
[196.272731] Dynamic subtest rcs0: SUCCESS (0.124s)
[196.313074] Starting dynamic subtest: bcs0
[196.390943] Dynamic subtest bcs0: SUCCESS (0.121s)
[196.431333] Starting dynamic subtest: vcs0
[196.518402] Dynamic subtest vcs0: SUCCESS (0.113s)
[196.557265] Starting dynamic subtest: vecs0
[196.640854] Dynamic subtest vecs0: SUCCESS (0.133s)
[196.661488] Subtest saturated-hostile-nopreempt: SUCCESS (0.494s)
[196.792859] [040/137] (818s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-25)
[197.154186] Starting subtest: plane-downscale-with-rotation-factor-0-25
[197.175644] Starting dynamic subtest: pipe-A-DP-1
[197.250271] Dynamic subtest pipe-A-DP-1: SKIP (0.044s)
[197.291531] Starting dynamic subtest: pipe-B-DP-1
[197.329719] Dynamic subtest pipe-B-DP-1: SKIP (0.089s)
[197.370779] Starting dynamic subtest: pipe-C-DP-1
[197.414094] Dynamic subtest pipe-C-DP-1: SKIP (0.091s)
[197.454956] Subtest plane-downscale-with-rotation-factor-0-25: SKIP (0.234s)
[197.557628] [041/137] (818s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[198.010238] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[200.699284] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.653s)
[200.795605] [042/137] (814s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[201.284495] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[201.588071] [043/137] (814s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[202.035205] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[202.073412] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[202.165914] [044/137] (813s left) i915_hangman (engine-engine-hang)
[202.494841] Starting subtest: engine-engine-hang
[202.515438] Starting dynamic subtest: rcs0
[203.078074] Dynamic subtest rcs0: SUCCESS (0.593s)
[203.115999] Starting dynamic subtest: bcs0
[203.671972] Dynamic subtest bcs0: SUCCESS (0.593s)
[203.710916] Starting dynamic subtest: vcs0
[204.260121] Dynamic subtest vcs0: SUCCESS (0.590s)
[204.300604] Starting dynamic subtest: vecs0
[204.850187] Dynamic subtest vecs0: SUCCESS (0.591s)
[204.870352] Subtest engine-engine-hang: SUCCESS (2.371s)
[204.995803] [045/137] (810s left) kms_vblank (pipe-a-wait-forked-hang)
[205.351352] Starting subtest: pipe-A-wait-forked-hang
[212.148248] Subtest pipe-A-wait-forked-hang: SUCCESS (6.677s)
[212.386187] [046/137] (803s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[212.669584] Starting subtest: invalid-single-wait-all-unsubmitted
[212.690934] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[212.781326] [047/137] (803s left) gem_exec_schedule (semaphore-power)
[213.233755] Starting subtest: semaphore-power
[214.125768] Subtest semaphore-power: SUCCESS (0.872s)
[214.354988] [048/137] (801s left) gem_mmap_wc (write-read)
[214.625034] Starting subtest: write-read
[214.646264] Subtest write-read: SUCCESS (0.031s)
[214.801418] [049/137] (801s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[215.195428] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[216.265116] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.094s)
[216.619163] [050/137] (799s left) kms_ccs (pipe-c-missing-ccs-buffer-yf_tiled_ccs)
[217.339202] Starting subtest: pipe-C-missing-ccs-buffer-yf_tiled_ccs
[217.382749] Subtest pipe-C-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[217.717771] [051/137] (798s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[218.016213] Starting subtest: multi-wait-all-for-submit-available-submitted
[218.034777] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.002s)
[218.138080] [052/137] (798s left) kms_atomic (crtc-invalid-params-fence)
[218.627109] Starting subtest: crtc-invalid-params-fence
[218.794239] Subtest crtc-invalid-params-fence: SUCCESS (0.167s)
[219.250104] [053/137] (797s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[219.610299] Starting subtest: short-flip-before-cursor-toggle
[220.707816] Subtest short-flip-before-cursor-toggle: SUCCESS (1.084s)
[221.053485] [054/137] (795s left) prime_vgem (coherency-gtt)
[221.452880] Starting subtest: coherency-gtt
[221.496312] Subtest coherency-gtt: SKIP (0.000s)
[221.610761] [055/137] (795s left) vc4/vc4_wait_bo (used-bo-0ns)
[221.971821] Subtest used-bo-0ns: SKIP (0.000s)
[222.067614] [056/137] (794s left) kms_ccs (pipe-a-ccs-on-another-bo-yf_tiled_ccs)
[222.590066] Starting subtest: pipe-A-ccs-on-another-bo-yf_tiled_ccs
[222.608883] Subtest pipe-A-ccs-on-another-bo-yf_tiled_ccs: SUCCESS (0.001s)
[223.189493] [057/137] (793s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[223.592234] Starting subtest: cursorB-vs-flipA-atomic-transitions
[223.642777] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.005s)
[223.760303] [058/137] (793s left) kms_psr (psr2_no_drrs)
[224.067448] Subtest psr2_no_drrs: SKIP (0.000s)
[224.158448] [059/137] (793s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[224.428084] Starting subtest: rel-constants-invalid-rel-gen5
[224.446912] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[224.577592] [060/137] (792s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[228.911179] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[229.005753] [061/137] (788s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[229.277241] Starting subtest: writes-after-reads
[232.819633] Subtest writes-after-reads: SUCCESS (3.538s)
[232.959465] [062/137] (784s left) kms_prop_blob (invalid-set-prop-any)
[233.234787] Starting subtest: invalid-set-prop-any
[233.253661] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[233.350534] [063/137] (784s left) gem_mmap_gtt (basic-wc)
[233.622771] Starting subtest: basic-wc
[234.244903] Subtest basic-wc: SUCCESS (0.631s)
[234.375757] [064/137] (783s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[234.809402] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[234.848849] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[234.939412] [065/137] (782s left) api_intel_allocator (standalone)
[235.219335] Starting subtest: standalone
[235.259328] Subtest standalone: SUCCESS (0.055s)
[235.378297] [066/137] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[235.793528] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[235.831762] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[235.930320] [067/137] (782s left) perf (global-sseu-config-invalid)
[236.358837] Starting subtest: global-sseu-config-invalid
[236.377358] Starting dynamic subtest: 0-rcs0
[236.395828] Dynamic subtest 0-rcs0: SUCCESS (0.039s)
[236.414166] Subtest global-sseu-config-invalid: SUCCESS (0.040s)
[236.515210] [068/137] (781s left) v3d/v3d_perfmon (get-values-valid-perfmon)
[236.848403] Subtest get-values-valid-perfmon: SKIP (0.000s)
[236.943378] [069/137] (781s left) gem_exec_params (invalid-bsd2-flag-on-render)
[237.191993] Starting subtest: invalid-bsd2-flag-on-render
[237.212845] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.001s)
[237.327100] [070/137] (780s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[237.869555] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[237.913929] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[238.449084] [071/137] (779s left) gem_exec_reloc (basic-cpu-gtt-active)
[238.727412] Starting subtest: basic-cpu-gtt-active
[238.865160] Subtest basic-cpu-gtt-active: SUCCESS (0.143s)
[239.082528] [072/137] (779s left) prime_vgem (coherency-blt)
[239.373637] Starting subtest: coherency-blt
[242.984653] Subtest coherency-blt: SUCCESS (3.437s)
[243.104235] [073/137] (775s left) sw_sync (sync_merge_same)
[243.374780] Starting subtest: sync_merge_same
[243.396079] Subtest sync_merge_same: SUCCESS (0.000s)
[243.494837] [074/137] (775s left) kms_vblank (pipe-d-accuracy-idle)
[243.850292] Subtest pipe-D-accuracy-idle: SKIP (0.000s)
[244.028858] [075/137] (774s left) i915_pm_rpm (system-suspend)
[245.875839] Starting subtest: system-suspend
[262.160542] Subtest system-suspend: SUCCESS (2.143s)
[268.858562] [076/137] (770s left) gem_ctx_create (basic-files)
[269.172006] Starting subtest: basic-files
[271.203947] Subtest basic-files: SUCCESS (2.034s)
[271.462234] [077/137] (767s left) kms_psr (dpms)
[271.748721] Subtest dpms: SKIP (0.000s)
[271.847870] [078/137] (767s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[272.236671] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[272.258140] Starting dynamic subtest: pipe-A-valid-mode
[272.894487] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.659s)
[272.917237] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.662s)
[273.247658] [079/137] (765s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_mc_ccs)
[273.940051] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs
[273.985255] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[274.373322] [080/137] (764s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[274.802809] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[274.839387] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[274.940760] [081/137] (764s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[275.372492] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[275.413547] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[275.515299] [082/137] (764s left) kms_async_flips (test-time-stamp)
[275.878929] Starting subtest: test-time-stamp
[275.897603] Starting dynamic subtest: pipe-A-DP-1
[276.696502] Dynamic subtest pipe-A-DP-1: SUCCESS (0.809s)
[276.736698] Starting dynamic subtest: pipe-B-DP-1
[277.449821] Dynamic subtest pipe-B-DP-1: SUCCESS (0.749s)
[277.488830] Starting dynamic subtest: pipe-C-DP-1
[278.096624] Dynamic subtest pipe-C-DP-1: SUCCESS (0.638s)
[278.118578] Subtest test-time-stamp: SUCCESS (2.206s)
[278.668246] [083/137] (760s left) gem_busy (busy)
[278.965603] Starting subtest: busy
[278.985118] Starting dynamic subtest: all-engines
[279.049729] Dynamic subtest all-engines: SUCCESS (0.085s)
[279.096239] Starting dynamic subtest: rcs0
[279.116806] Dynamic subtest rcs0: SUCCESS (0.015s)
[279.157207] Starting dynamic subtest: bcs0
[279.175838] Dynamic subtest bcs0: SUCCESS (0.021s)
[279.214973] Starting dynamic subtest: vcs0
[279.233782] Dynamic subtest vcs0: SUCCESS (0.013s)
[279.274490] Starting dynamic subtest: vecs0
[279.295732] Dynamic subtest vecs0: SUCCESS (0.013s)
[279.316591] Subtest busy: SUCCESS (0.153s)
[279.518044] [084/137] (760s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[279.953648] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[279.990443] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[280.093228] [085/137] (759s left) gem_mmap_gtt (hang-busy)
[280.358695] Starting subtest: hang-busy
[295.524859] Subtest hang-busy: SUCCESS (14.996s)
[295.633411] [086/137] (744s left) i915_pm_rpm (drm-resources-equal)
[297.455558] Starting subtest: drm-resources-equal
[299.255266] Subtest drm-resources-equal: SUCCESS (1.795s)
[299.523936] [087/137] (740s left) gem_ctx_persistence (engines-persistence)
[299.818256] Starting subtest: engines-persistence
[299.843279] Starting dynamic subtest: rcs0
[300.612304] Dynamic subtest rcs0: SUCCESS (0.797s)
[300.659113] Starting dynamic subtest: bcs0
[301.378585] Dynamic subtest bcs0: SUCCESS (0.763s)
[301.424643] Starting dynamic subtest: vcs0
[302.142944] Dynamic subtest vcs0: SUCCESS (0.761s)
[302.189538] Starting dynamic subtest: vecs0
[302.911827] Dynamic subtest vecs0: SUCCESS (0.768s)
[302.939992] Subtest engines-persistence: SUCCESS (3.093s)
[303.065696] [088/137] (737s left) gem_exec_schedule (implicit-write-read)
[303.566114] Starting subtest: implicit-write-read
[303.593272] Starting dynamic subtest: rcs0
[303.616432] Dynamic subtest rcs0: SUCCESS (0.140s)
[303.667598] Starting dynamic subtest: bcs0
[303.690163] Dynamic subtest bcs0: SUCCESS (0.140s)
[303.737993] Starting dynamic subtest: vcs0
[303.791919] Dynamic subtest vcs0: SUCCESS (0.125s)
[303.838521] Starting dynamic subtest: vecs0
[303.901688] Dynamic subtest vecs0: SUCCESS (0.125s)
[303.925259] Subtest implicit-write-read: SUCCESS (0.536s)
[304.296461] [089/137] (735s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[304.559157] Starting subtest: invalid-multi-wait-unsubmitted
[304.585788] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[304.710229] [090/137] (735s left) syncobj_timeline (reset-signaled)
[304.979020] Starting subtest: reset-signaled
[305.000458] Subtest reset-signaled: SUCCESS (0.001s)
[305.109530] [091/137] (735s left) kms_vblank (pipe-b-query-busy-hang)
[305.465634] Starting subtest: pipe-B-query-busy-hang
[313.275844] Subtest pipe-B-query-busy-hang: SUCCESS (7.686s)
[313.529149] [092/137] (727s left) kms_cursor_crc (cursor-sliding-64x64)
[313.891940] Starting subtest: cursor-sliding-64x64
[313.910674] Starting dynamic subtest: pipe-A-DP-1
[317.599839] Dynamic subtest pipe-A-DP-1: SUCCESS (3.676s)
[317.674056] Starting dynamic subtest: pipe-C-DP-1
[321.637434] Dynamic subtest pipe-C-DP-1: SUCCESS (3.986s)
[321.656512] Subtest cursor-sliding-64x64: SUCCESS (7.735s)
[322.016417] [093/137] (718s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[322.310957] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[322.331197] Starting dynamic subtest: smem
[322.721200] Dynamic subtest smem: SUCCESS (0.425s)
[322.739931] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.427s)
[322.967175] [094/137] (717s left) i915_query (query-topology-garbage-items)
[323.240974] Starting subtest: query-topology-garbage-items
[323.259914] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[323.365151] [095/137] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[323.785185] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[323.825544] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[323.933068] [096/137] (717s left) kms_chamelium_hpd (vga-hpd-fast)
[324.378670] Subtest vga-hpd-fast: SKIP (0.000s)
[324.677896] [097/137] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[325.116866] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[325.158639] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[325.257657] [098/137] (715s left) kms_flip (2x-blocking-absolute-wf_vblank)
[325.618339] Starting subtest: 2x-blocking-absolute-wf_vblank
[325.660051] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.003s)
[325.765853] [099/137] (715s left) gem_ringfill (engines-basic)
[326.329083] Starting subtest: engines-basic
[326.350079] Starting dynamic subtest: rcs0
[326.369067] Dynamic subtest rcs0: SUCCESS (0.024s)
[326.409922] Starting dynamic subtest: bcs0
[326.428504] Dynamic subtest bcs0: SUCCESS (0.036s)
[326.468032] Starting dynamic subtest: vcs0
[326.489363] Dynamic subtest vcs0: SUCCESS (0.021s)
[326.531139] Starting dynamic subtest: vecs0
[326.551582] Dynamic subtest vecs0: SUCCESS (0.022s)
[326.572623] Subtest engines-basic: SUCCESS (0.107s)
[326.670246] [100/137] (714s left) gem_mmap_gtt (big-copy)
[326.947871] Starting subtest: big-copy
[337.909199] Subtest big-copy: SUCCESS (10.976s)
[338.034898] [101/137] (703s left) kms_cursor_crc (cursor-random-128x42)
[338.585816] Starting subtest: cursor-random-128x42
[338.604349] Starting dynamic subtest: pipe-A-DP-1
[342.587480] Dynamic subtest pipe-A-DP-1: SUCCESS (3.977s)
[342.667014] Starting dynamic subtest: pipe-C-DP-1
[346.742403] Dynamic subtest pipe-C-DP-1: SUCCESS (4.107s)
[346.761556] Subtest cursor-random-128x42: SUCCESS (8.156s)
[347.127944] [102/137] (694s left) gem_exec_whisper (basic-queues-priority-all)
[347.447094] Starting subtest: basic-queues-priority-all
[370.195490] Subtest basic-queues-priority-all: SUCCESS (22.758s)
[370.428904] [103/137] (671s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[370.793897] Starting subtest: short-flip-after-cursor-atomic-transitions
[371.949651] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.143s)
[372.305684] [104/137] (669s left) sysfs_timeslice_duration (idempotent)
[372.581536] Starting subtest: idempotent
[372.603316] Starting dynamic subtest: vecs0
[372.623900] Dynamic subtest vecs0: SUCCESS (0.001s)
[372.666458] Starting dynamic subtest: vcs0
[372.685155] Dynamic subtest vcs0: SUCCESS (0.001s)
[372.724908] Starting dynamic subtest: bcs0
[372.743271] Dynamic subtest bcs0: SUCCESS (0.001s)
[372.782734] Starting dynamic subtest: rcs0
[372.803881] Dynamic subtest rcs0: SUCCESS (0.002s)
[372.824975] Subtest idempotent: SUCCESS (0.013s)
[372.927803] [105/137] (668s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[373.783177] Starting subtest: syncobj-stationary-timeline-chain-engines
[373.908804] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.126s)
[374.182583] [106/137] (667s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[374.490879] Starting subtest: single-wait-all-for-submit-unsubmitted
[374.593921] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[374.722562] [107/137] (667s left) perf (polling-small-buf)
[375.132085] Starting subtest: polling-small-buf
[375.289263] Subtest polling-small-buf: SUCCESS (0.138s)
[375.414890] [108/137] (666s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[375.816094] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[375.856052] Subtest psr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[375.965069] [109/137] (666s left) api_intel_allocator (gem-pool)
[376.219665] Starting subtest: gem-pool
[376.241921] Subtest gem-pool: SUCCESS (0.018s)
[376.383638] [110/137] (665s left) perf (sysctl-defaults)
[376.732434] Starting subtest: sysctl-defaults
[376.753515] Subtest sysctl-defaults: SUCCESS (0.000s)
[376.870250] [111/137] (665s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[377.150091] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[377.169165] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[377.270524] [112/137] (665s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[377.685441] Starting subtest: x-tiled-32bpp-rotate-0
[382.707328] Subtest x-tiled-32bpp-rotate-0: SUCCESS (5.066s)
[383.272907] [113/137] (659s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[383.681733] Starting subtest: 4-tiled-8bpp-rotate-90
[383.722095] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[383.828733] [114/137] (658s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs)
[384.424795] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs
[384.464761] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[384.964031] [115/137] (657s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[385.380848] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[385.421543] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[385.523473] [116/137] (657s left) v3d/v3d_submit_csd (bad-in-sync)
[385.872862] Subtest bad-in-sync: SKIP (0.000s)
[385.976520] [117/137] (657s left) gem_userptr_blits (vma-merge)
[386.329589] Starting subtest: vma-merge
[407.265069] Subtest vma-merge: FAIL (20.652s)
[407.365591] [118/137] (635s left) vc4/vc4_mmap (mmap-bad-handle)
[407.708808] Subtest mmap-bad-handle: SKIP (0.000s)
[407.810464] [119/137] (635s left) core_getclient
[408.195996] [120/137] (635s left) kms_ccs (pipe-b-missing-ccs-buffer-yf_tiled_ccs)
[408.796908] Starting subtest: pipe-B-missing-ccs-buffer-yf_tiled_ccs
[408.816300] Subtest pipe-B-missing-ccs-buffer-yf_tiled_ccs: SUCCESS (0.001s)
[409.327142] [121/137] (634s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[409.810914] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[410.141823] [122/137] (633s left) syncobj_wait (invalid-signal-one-illegal-handle)
[410.404165] Starting subtest: invalid-signal-one-illegal-handle
[410.424108] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[410.530056] [123/137] (633s left) kms_plane_multiple (tiling-y)
[410.898952] Starting subtest: tiling-y
[410.917780] Starting dynamic subtest: pipe-A-DP-1
[412.718376] Dynamic subtest pipe-A-DP-1: SUCCESS (1.810s)
[412.763478] Starting dynamic subtest: pipe-B-DP-1
[414.690676] Dynamic subtest pipe-B-DP-1: SUCCESS (1.970s)
[414.736289] Starting dynamic subtest: pipe-C-DP-1
[416.639131] Dynamic subtest pipe-C-DP-1: SUCCESS (1.939s)
[416.660142] Subtest tiling-y: SUCCESS (5.732s)
[417.020551] [124/137] (626s left) kms_plane_scaling (planes-upscale-20x20)
[417.390951] Starting subtest: planes-upscale-20x20
[417.411857] Starting dynamic subtest: pipe-A-DP-1
[417.457621] Dynamic subtest pipe-A-DP-1: SUCCESS (0.071s)
[417.511799] Starting dynamic subtest: pipe-B-DP-1
[417.838857] Dynamic subtest pipe-B-DP-1: SUCCESS (0.353s)
[417.880667] Starting dynamic subtest: pipe-C-DP-1
[417.950044] Dynamic subtest pipe-C-DP-1: SKIP (0.084s)
[417.971075] Subtest planes-upscale-20x20: SUCCESS (0.520s)
[418.326693] [125/137] (625s left) gem_eio (kms)
[418.696999] Starting subtest: kms
[431.126074] Subtest kms: SUCCESS (12.429s)
[431.543759] [126/137] (612s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[431.973213] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[432.014306] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[432.125844] [127/137] (611s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[432.478274] Starting subtest: plane-use-after-nonblocking-unbind
[432.498221] Starting dynamic subtest: pipe-A-DP-1
[432.623388] Dynamic subtest pipe-A-DP-1: SUCCESS (0.148s)
[432.759019] Starting dynamic subtest: pipe-B-DP-1
[433.269869] Dynamic subtest pipe-B-DP-1: SUCCESS (0.551s)
[433.338038] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.870s)
[433.696725] [128/137] (610s left) kms_draw_crc (draw-method-pwrite)
[434.069796] Starting subtest: draw-method-pwrite
[434.089433] Starting dynamic subtest: xrgb8888-untiled
[434.347371] Dynamic subtest xrgb8888-untiled: SUCCESS (0.281s)
[434.389814] Starting dynamic subtest: rgb565-untiled
[434.614978] Dynamic subtest rgb565-untiled: SUCCESS (0.264s)
[434.657467] Starting dynamic subtest: xrgb2101010-untiled
[434.896862] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.282s)
[434.938850] Starting dynamic subtest: xrgb8888-xtiled
[435.216062] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.315s)
[435.259615] Starting dynamic subtest: rgb565-xtiled
[435.529426] Dynamic subtest rgb565-xtiled: SUCCESS (0.315s)
[435.574319] Starting dynamic subtest: xrgb2101010-xtiled
[435.845097] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.315s)
[435.887964] Starting dynamic subtest: xrgb8888-ytiled
[436.164918] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.315s)
[436.206708] Starting dynamic subtest: rgb565-ytiled
[436.449416] Dynamic subtest rgb565-ytiled: SUCCESS (0.282s)
[436.493351] Starting dynamic subtest: xrgb2101010-ytiled
[436.764413] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.315s)
[436.786647] Subtest draw-method-pwrite: SUCCESS (2.699s)
[436.905834] [129/137] (607s left) kms_universal_plane (universal-plane-pipe-a-sanity)
[437.278618] Starting subtest: universal-plane-pipe-A-sanity
[437.681499] Subtest universal-plane-pipe-A-sanity: SUCCESS (0.408s)
[438.014341] [130/137] (606s left) gem_ctx_param (invalid-get-no-zeromap)
[438.296190] Starting subtest: invalid-get-no-zeromap
[438.315684] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[438.419005] [131/137] (606s left) kms_vblank (pipe-b-ts-continuation-suspend)
[438.788121] Starting subtest: pipe-B-ts-continuation-suspend
[457.351144] Subtest pipe-B-ts-continuation-suspend: SUCCESS (2.169s)
[462.484204] [132/137] (603s left) gem_pwrite (basic-self)
[462.787170] Starting subtest: basic-self
[463.058103] Subtest basic-self: SUCCESS (0.287s)
[463.193752] [133/137] (602s left) vgem_basic (mmap)
[463.474240] Starting subtest: mmap
[463.493450] Subtest mmap: SUCCESS (0.026s)
[463.596600] [134/137] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[464.023115] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[464.060694] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[464.165979] [135/137] (601s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[464.943250] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[465.276315] [136/137] (600s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[465.645240] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[465.665437] Starting dynamic subtest: pipe-A-valid-mode
[465.778429] Dynamic subtest pipe-A-valid-mode: SKIP (0.115s)
[465.820871] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.119s)
[466.114139] [137/137] (600s left) gem_mmap (pf-nonblock)
[466.392380] Starting subtest: pf-nonblock
[466.413355] Subtest pf-nonblock: SUCCESS (0.005s)
[466.496991] Closing watchdogs
Done.