[72.163146] Initializing watchdogs
[72.163246]   /dev/watchdog0
[72.203606] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[72.233816] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[72.241593] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.245430] [001/133] (960s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[73.909858] Starting subtest: cursor-rapid-movement-64x64
[73.925518] Starting dynamic subtest: pipe-A-HDMI-A-4
[74.409921] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.484s)
[74.440121] Starting dynamic subtest: pipe-D-HDMI-A-4
[74.719063] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.285s)
[74.720594] Subtest cursor-rapid-movement-64x64: SUCCESS (0.807s)
[75.233232] [002/133] (957s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[76.729292] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[76.804158] [003/133] (956s left) kms_draw_crc (draw-method-mmap-wc)
[78.296721] Starting subtest: draw-method-mmap-wc
[78.299875] Subtest draw-method-mmap-wc: SKIP (0.000s)
[78.479500] [004/133] (954s left) gem_partial_pwrite_pread (write-snoop)
[78.541041] Subtest write-snoop: SKIP (0.000s)
[78.639952] [005/133] (954s left) kms_addfb_basic (no-handle)
[78.686854] Starting subtest: no-handle
[78.688575] Subtest no-handle: SUCCESS (0.000s)
[80.293618] [006/133] (952s left) kms_psr (fbc-psr-primary-blt)
[81.799943] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[81.873627] [007/133] (951s left) drm_read (short-buffer-nonblock)
[83.435712] Starting subtest: short-buffer-nonblock
[83.437254] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[83.674609] [008/133] (949s left) gem_exec_store (dword)
[83.734625] Starting subtest: dword
[83.736558] Starting dynamic subtest: rcs0
[83.792046] Dynamic subtest rcs0: SUCCESS (0.057s)
[83.803188] Starting dynamic subtest: bcs0
[83.832566] Dynamic subtest bcs0: SUCCESS (0.040s)
[83.862830] Starting dynamic subtest: vcs0
[83.881087] Dynamic subtest vcs0: SUCCESS (0.048s)
[83.909950] Starting dynamic subtest: vcs1
[83.931063] Dynamic subtest vcs1: SUCCESS (0.050s)
[83.947596] Starting dynamic subtest: vecs0
[83.975163] Dynamic subtest vecs0: SUCCESS (0.044s)
[83.977274] Subtest dword: SUCCESS (0.241s)
[84.244340] [009/133] (949s left) kms_plane (pixel-format-yf-tiled-modifier)
[85.735764] Starting subtest: pixel-format-yf-tiled-modifier
[85.738992] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[85.836851] [010/133] (947s left) kms_atomic_interruptible (legacy-setmode)
[87.337740] Starting subtest: legacy-setmode
[87.339363] Starting dynamic subtest: pipe-A-HDMI-A-4
[93.477982] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.137s)
[93.479417] Subtest legacy-setmode: SUCCESS (6.138s)
[93.631402] [011/133] (939s left) gem_ctx_shared (exec-single-timeline)
[93.693104] Starting subtest: exec-single-timeline
[93.694561] Starting dynamic subtest: rcs0
[94.792120] Dynamic subtest rcs0: SUCCESS (1.095s)
[94.801895] Starting dynamic subtest: bcs0
[95.815699] Dynamic subtest bcs0: SUCCESS (1.022s)
[95.825592] Starting dynamic subtest: vcs0
[96.839476] Dynamic subtest vcs0: SUCCESS (1.022s)
[96.849687] Starting dynamic subtest: vcs1
[97.863687] Dynamic subtest vcs1: SUCCESS (1.022s)
[97.873487] Starting dynamic subtest: vecs0
[98.886778] Dynamic subtest vecs0: SUCCESS (1.022s)
[98.888820] Subtest exec-single-timeline: SUCCESS (5.190s)
[99.142499] [012/133] (934s left) gem_mmap_offset (perf)
[99.191468] Starting subtest: perf
[99.193036] Starting dynamic subtest: lmem0
[99.330840] Dynamic subtest lmem0: SUCCESS (0.140s)
[99.340772] Starting dynamic subtest: smem0
[99.349658] Dynamic subtest smem0: SUCCESS (0.004s)
[99.351394] Subtest perf: SUCCESS (0.145s)
[99.521412] [013/133] (934s left) kms_color (ctm-signed)
[101.008329] Starting subtest: ctm-signed
[101.009940] Starting dynamic subtest: pipe-A-HDMI-A-4
[102.174376] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.165s)
[102.183939] Starting dynamic subtest: pipe-B-HDMI-A-4
[103.019656] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.843s)
[103.029766] Starting dynamic subtest: pipe-C-HDMI-A-4
[103.856169] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.837s)
[103.866046] Starting dynamic subtest: pipe-D-HDMI-A-4
[104.751344] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.895s)
[104.752868] Subtest ctm-signed: SUCCESS (3.742s)
[104.924077] [014/133] (928s left) gem_pwrite (basic-exhaustion)
[104.979267] Subtest basic-exhaustion: SKIP (0.000s)
[105.072377] [015/133] (928s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[106.559174] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[106.560770] Starting dynamic subtest: pipe-A
[107.328947] Dynamic subtest pipe-A: SUCCESS (0.770s)
[107.340731] Starting dynamic subtest: pipe-B
[108.085808] Dynamic subtest pipe-B: SUCCESS (0.756s)
[108.097806] Starting dynamic subtest: pipe-C
[108.844125] Dynamic subtest pipe-C: SUCCESS (0.758s)
[108.855645] Starting dynamic subtest: pipe-D
[109.602299] Dynamic subtest pipe-D: SUCCESS (0.757s)
[109.604049] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (3.043s)
[109.767669] [016/133] (924s left) gem_lmem_swapping (heavy-multi)
[114.012221] Starting subtest: heavy-multi
[114.014260] Starting dynamic subtest: lmem0
[119.822403] Dynamic subtest lmem0: SUCCESS (5.806s)
[119.824156] Subtest heavy-multi: SUCCESS (5.807s)
[121.181987] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[121.184444] [017/133] (912s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[125.916474] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[125.919304] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[126.157653] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[126.164451] [018/133] (907s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[126.224999] Starting subtest: mixed-tiled-to-y-tiled-ccs
[126.226555] Starting dynamic subtest: smem
[126.345729] Dynamic subtest smem: SUCCESS (0.117s)
[126.355430] Starting dynamic subtest: lmem0
[127.337131] Dynamic subtest lmem0: SUCCESS (0.990s)
[127.338954] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (1.109s)
[127.611646] [019/133] (906s left) gem_exec_flush (basic-batch-kernel-default-uc)
[127.671486] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[127.776321] [020/133] (906s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[129.293198] Starting subtest: flip-vs-dpms-on-nop-interruptible
[129.300036] Starting dynamic subtest: A-HDMI-A4
[130.313057] Dynamic subtest A-HDMI-A4: SUCCESS (1.013s)
[130.328063] Starting dynamic subtest: B-HDMI-A4
[131.264061] Dynamic subtest B-HDMI-A4: SUCCESS (0.945s)
[131.297872] Starting dynamic subtest: C-HDMI-A4
[132.245267] Dynamic subtest C-HDMI-A4: SUCCESS (0.979s)
[132.258435] Starting dynamic subtest: D-HDMI-A4
[133.196198] Dynamic subtest D-HDMI-A4: SUCCESS (0.946s)
[133.199126] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (3.904s)
[133.452152] [021/133] (900s left) kms_pm_rpm (modeset-stress-extra-wait)
[136.983593] Starting subtest: modeset-stress-extra-wait
[191.093322] Subtest modeset-stress-extra-wait: SUCCESS (54.112s)
[191.243463] [022/133] (843s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[192.764368] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[192.766288] Starting dynamic subtest: pipe-A-HDMI-A-4
[192.780524] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[192.790906] Starting dynamic subtest: pipe-B-HDMI-A-4
[192.807350] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[192.817414] Starting dynamic subtest: pipe-C-HDMI-A-4
[192.831903] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[192.842181] Starting dynamic subtest: pipe-D-HDMI-A-4
[192.857499] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[192.860637] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[192.994281] [023/133] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[194.494182] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[194.497120] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[194.640403] [024/133] (839s left) gem_userptr_blits (sync-overlap)
[194.717257] Starting subtest: sync-overlap
[194.718852] Subtest sync-overlap: SUCCESS (0.000s)
[194.911596] [025/133] (839s left) kms_chamelium_hpd (hdmi-hpd-storm)
[196.442087] Subtest hdmi-hpd-storm: SKIP (0.000s)
[196.553215] [026/133] (838s left) gem_ctx_persistence (heartbeat-close)
[196.608178] Starting subtest: heartbeat-close
[196.611787] Subtest heartbeat-close: SKIP (0.000s)
[196.721152] [027/133] (838s left) perf (low-oa-exponent-permissions)
[196.858084] Starting subtest: low-oa-exponent-permissions
[196.922045] Subtest low-oa-exponent-permissions: SUCCESS (0.064s)
[197.002535] [028/133] (837s left) kms_pipe_crc_basic (hang-read-crc)
[198.494682] Starting subtest: hang-read-crc
[198.496350] Starting dynamic subtest: pipe-A-HDMI-A-4
[199.796677] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.300s)
[199.809094] Starting dynamic subtest: pipe-B-HDMI-A-4
[200.988738] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.192s)
[200.999974] Starting dynamic subtest: pipe-C-HDMI-A-4
[202.183582] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.193s)
[202.195176] Starting dynamic subtest: pipe-D-HDMI-A-4
[203.358388] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.173s)
[203.359839] Subtest hang-read-crc: SUCCESS (4.866s)
[203.533922] [029/133] (831s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[205.023452] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[205.026476] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[205.140440] [030/133] (829s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[205.202225] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[205.308929] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[205.520673] [031/133] (829s left) kms_cursor_crc (cursor-onscreen-128x42)
[207.255973] Starting subtest: cursor-onscreen-128x42
[207.263395] Starting dynamic subtest: pipe-A-HDMI-A-4
[209.759340] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.497s)
[209.793279] Starting dynamic subtest: pipe-D-HDMI-A-4
[212.367117] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.583s)
[212.368869] Subtest cursor-onscreen-128x42: SUCCESS (5.110s)
[212.744917] [032/133] (822s left) gem_tiled_partial_pwrite_pread (writes)
[212.799562] Subtest writes: SKIP (0.000s)
[212.871773] [033/133] (822s left) api_intel_bb (object-noreloc-purge-cache-simple)
[212.920324] Starting subtest: object-noreloc-purge-cache-simple
[212.939589] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.021s)
[213.152215] [034/133] (822s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[214.647611] Starting subtest: fbc-rgb565-draw-mmap-cpu
[217.230127] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.584s)
[217.401631] [035/133] (817s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[218.890502] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[218.892027] Starting dynamic subtest: pipe-A-HDMI-A-4
[218.907211] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[218.918508] Starting dynamic subtest: pipe-B-HDMI-A-4
[218.933620] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[218.944364] Starting dynamic subtest: pipe-C-HDMI-A-4
[218.961821] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[218.972944] Starting dynamic subtest: pipe-D-HDMI-A-4
[218.989861] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[218.993174] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.011s)
[219.138076] [036/133] (816s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[220.636219] Starting subtest: fbcpsr-suspend
[220.639535] Subtest fbcpsr-suspend: SKIP (0.000s)
[220.817294] [037/133] (814s left) gem_lmem_swapping (verify)
[225.011963] Starting subtest: verify
[225.013689] Starting dynamic subtest: lmem0
[266.097712] Dynamic subtest lmem0: SUCCESS (41.082s)
[266.099033] Subtest verify: SUCCESS (41.083s)
[267.510234] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[267.513084] [038/133] (768s left) perf_pmu (render-node-busy)
[270.791195] Starting subtest: render-node-busy
[270.792863] Starting dynamic subtest: rcs0
[271.414109] Dynamic subtest rcs0: SUCCESS (0.622s)
[271.429403] Starting dynamic subtest: bcs0
[271.973135] Dynamic subtest bcs0: SUCCESS (0.554s)
[271.988283] Starting dynamic subtest: vcs0
[272.537254] Dynamic subtest vcs0: SUCCESS (0.559s)
[272.552657] Starting dynamic subtest: vcs1
[273.100260] Dynamic subtest vcs1: SUCCESS (0.558s)
[273.115897] Starting dynamic subtest: vecs0
[273.660549] Dynamic subtest vecs0: SUCCESS (0.555s)
[273.663494] Subtest render-node-busy: SUCCESS (2.871s)
[273.729024] [FACT perf_pmu (render-node-busy)] new: kernel.kmod_is_loaded.i915: true
[273.732730] [039/133] (761s left) kms_psr2_su (frontbuffer-xrgb8888)
[273.797506] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[273.879419] [040/133] (761s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[275.371117] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[275.377987] Starting dynamic subtest: A-HDMI-A4
[276.094025] Dynamic subtest A-HDMI-A4: SUCCESS (0.716s)
[276.106072] Starting dynamic subtest: B-HDMI-A4
[276.800916] Dynamic subtest B-HDMI-A4: SUCCESS (0.695s)
[276.815500] Starting dynamic subtest: C-HDMI-A4
[277.501527] Dynamic subtest C-HDMI-A4: SUCCESS (0.709s)
[277.513535] Starting dynamic subtest: D-HDMI-A4
[278.212877] Dynamic subtest D-HDMI-A4: SUCCESS (0.710s)
[278.214565] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (2.843s)
[278.392499] [041/133] (757s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[279.914271] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[280.530619] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.616s)
[280.855728] [042/133] (755s left) gem_exec_balancer (full-pulse)
[280.916189] Starting subtest: full-pulse
[283.350809] Subtest full-pulse: SUCCESS (2.435s)
[283.812908] [043/133] (752s left) kms_chamelium_audio (dp-audio)
[285.372854] Subtest dp-audio: SKIP (0.000s)
[285.482703] [044/133] (750s left) kms_plane_scaling (planes-downscale-factor-0-75)
[286.972470] Starting subtest: planes-downscale-factor-0-75
[286.973830] Starting dynamic subtest: pipe-A
[287.084824] Dynamic subtest pipe-A: SUCCESS (0.112s)
[287.096591] Starting dynamic subtest: pipe-B
[287.224413] Dynamic subtest pipe-B: SUCCESS (0.138s)
[287.236154] Starting dynamic subtest: pipe-C
[287.364523] Dynamic subtest pipe-C: SUCCESS (0.139s)
[287.376307] Starting dynamic subtest: pipe-D
[287.505581] Dynamic subtest pipe-D: SUCCESS (0.140s)
[287.507385] Subtest planes-downscale-factor-0-75: SUCCESS (0.534s)
[287.729244] [045/133] (748s left) gem_exec_gttfill (basic)
[287.791845] Starting subtest: basic
[295.193105] Subtest basic: SUCCESS (7.401s)
[295.543648] [046/133] (740s left) gem_exec_parallel (basic)
[295.654978] Starting subtest: basic
[295.656537] Starting dynamic subtest: rcs0
[297.375592] Dynamic subtest rcs0: SUCCESS (1.720s)
[297.392679] Starting dynamic subtest: bcs0
[298.927644] Dynamic subtest bcs0: SUCCESS (1.550s)
[298.939963] Starting dynamic subtest: vcs0
[300.452543] Dynamic subtest vcs0: SUCCESS (1.523s)
[300.465044] Starting dynamic subtest: vcs1
[301.977619] Dynamic subtest vcs1: SUCCESS (1.524s)
[301.990582] Starting dynamic subtest: vecs0
[303.515696] Dynamic subtest vecs0: SUCCESS (1.537s)
[303.517408] Subtest basic: SUCCESS (7.862s)
[303.890404] [047/133] (732s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[303.966353] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[303.967977] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[304.095273] [048/133] (732s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[305.604287] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[305.607590] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[305.809798] [049/133] (730s left) gem_exec_reloc (basic-range-active)
[305.886228] Subtest basic-range-active: SKIP (0.000s)
[306.002081] [050/133] (730s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[307.538245] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[307.648958] [051/133] (729s left) kms_lease (lease-again)
[309.140321] Starting subtest: lease-again
[309.142130] Starting dynamic subtest: pipe-A-HDMI-A-4
[309.147690] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.003s)
[309.161449] Starting dynamic subtest: pipe-B-HDMI-A-4
[309.165476] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s)
[309.178094] Starting dynamic subtest: pipe-C-HDMI-A-4
[309.179908] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s)
[309.193125] Starting dynamic subtest: pipe-D-HDMI-A-4
[309.194906] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s)
[309.196788] Subtest lease-again: SUCCESS (0.020s)
[309.282302] [052/133] (727s left) kms_getfb (getfb2-accept-nv12)
[310.774016] Starting subtest: getfb2-accept-nv12
[310.778430] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[311.036977] [053/133] (725s left) syncobj_timeline (single-wait-all-available-signaled)
[311.089797] Starting subtest: single-wait-all-available-signaled
[311.091708] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[311.201737] [054/133] (725s left) syncobj_wait (single-wait-signaled)
[311.252387] Starting subtest: single-wait-signaled
[311.254700] Subtest single-wait-signaled: SUCCESS (0.000s)
[311.378346] [055/133] (725s left) kms_addfb_basic (basic-x-tiled-legacy)
[311.429521] Starting subtest: basic-x-tiled-legacy
[311.432844] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[312.999882] [056/133] (724s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[314.494810] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[314.496419] Starting dynamic subtest: pipe-A-HDMI-A-4
[314.510366] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[314.523155] Starting dynamic subtest: pipe-B-HDMI-A-4
[314.537163] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[314.549183] Starting dynamic subtest: pipe-C-HDMI-A-4
[314.563429] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[314.575798] Starting dynamic subtest: pipe-D-HDMI-A-4
[314.593162] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[314.594836] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.013s)
[314.744686] [057/133] (722s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[316.270499] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[316.274404] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[316.454241] [058/133] (720s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[317.943993] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[317.947905] Starting dynamic subtest: pipe-A-HDMI-A-4
[322.424911] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.468s)
[322.442235] Starting dynamic subtest: pipe-B-HDMI-A-4
[323.163605] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.728s)
[323.199835] Starting dynamic subtest: pipe-C-HDMI-A-4
[323.923311] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.745s)
[323.959727] Starting dynamic subtest: pipe-D-HDMI-A-4
[324.675613] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.745s)
[324.678487] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SUCCESS (6.728s)
[324.902212] [059/133] (712s left) syncobj_timeline (invalid-query-one-illegal-handle)
[324.952827] Starting subtest: invalid-query-one-illegal-handle
[324.954351] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[325.073016] [060/133] (712s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[326.571376] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[326.574378] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[326.744283] [061/133] (710s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[328.256942] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[329.390284] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.129s)
[329.621178] [062/133] (708s left) kms_force_connector_basic (force-edid)
[329.764049] Starting subtest: force-edid
[329.784833] Subtest force-edid: SUCCESS (0.021s)
[331.437253] [063/133] (706s left) kms_getfb (getfb-handle-zero)
[332.933730] Starting subtest: getfb-handle-zero
[332.935185] Subtest getfb-handle-zero: SUCCESS (0.000s)
[333.117897] [064/133] (704s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[333.180335] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[333.394757] [065/133] (704s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[334.891037] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[334.894154] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[335.059583] [066/133] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[336.564309] Starting subtest: fbcpsr-2p-rte
[336.567896] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[336.727800] [067/133] (701s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[338.226467] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[338.229727] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[338.379624] [068/133] (699s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[339.885578] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[339.888766] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[340.062991] [069/133] (698s left) gem_create (create-size-update)
[340.114793] Starting subtest: create-size-update
[340.116478] Subtest create-size-update: SUCCESS (0.000s)
[340.456735] [070/133] (698s left) kms_debugfs (display-on-read-all)
[341.962559] Starting subtest: display-on-read-all
[342.102694] Subtest display-on-read-all: SUCCESS (0.143s)
[342.397666] [071/133] (696s left) prime_udl
[342.533842] [072/133] (696s left) i915_drm_fdinfo (virtual-idle)
[342.615809] Starting subtest: virtual-idle
[345.199324] Subtest virtual-idle: SUCCESS (2.581s)
[345.301256] [073/133] (693s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[346.797563] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[346.880505] [074/133] (691s left) kms_universal_plane (disable-primary-vs-flip)
[348.373939] Starting subtest: disable-primary-vs-flip
[348.375758] Starting dynamic subtest: pipe-A-HDMI-A-4
[348.833616] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.459s)
[348.846912] Starting dynamic subtest: pipe-B-HDMI-A-4
[349.132779] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.297s)
[349.145593] Starting dynamic subtest: pipe-C-HDMI-A-4
[349.423874] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.289s)
[349.439098] Starting dynamic subtest: pipe-D-HDMI-A-4
[349.696157] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.270s)
[349.697778] Subtest disable-primary-vs-flip: SUCCESS (1.325s)
[349.908543] [075/133] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[351.412299] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[351.415867] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[351.605039] [076/133] (687s left) syncobj_basic (test-valid-cycle)
[351.657535] Starting subtest: test-valid-cycle
[351.659353] Subtest test-valid-cycle: SUCCESS (0.000s)
[351.770631] [077/133] (687s left) gem_render_copy_redux (flink-interruptible)
[351.825487] Starting subtest: flink-interruptible
[353.907680] Subtest flink-interruptible: SUCCESS (2.082s)
[354.123703] [078/133] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[355.635429] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[355.638590] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[355.805813] [079/133] (683s left) gem_userptr_blits (process-exit-busy)
[355.871790] Starting subtest: process-exit-busy
[355.890047] Subtest process-exit-busy: SUCCESS (0.019s)
[356.110578] [080/133] (683s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[357.607966] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[357.611266] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[357.766596] [081/133] (681s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[359.271897] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[359.290734] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.017s)
[359.447863] [082/133] (680s left) kms_prop_blob (blob-prop-core)
[359.497535] Starting subtest: blob-prop-core
[359.499293] Subtest blob-prop-core: SUCCESS (0.000s)
[359.652545] [083/133] (680s left) kms_vrr (negative-basic)
[361.143086] Starting subtest: negative-basic
[361.147863] Subtest negative-basic: SKIP (0.000s)
[361.256111] [084/133] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[362.764856] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[362.767850] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[362.910419] [085/133] (676s left) i915_pm_rc6_residency (rc6-idle)
[362.967779] Starting subtest: rc6-idle
[362.977887] Starting dynamic subtest: gt0-rcs0
[387.282598] Dynamic subtest gt0-rcs0: SUCCESS (24.305s)
[387.297921] Starting dynamic subtest: gt0-bcs0
[411.603270] Dynamic subtest gt0-bcs0: SUCCESS (24.317s)
[411.624589] Starting dynamic subtest: gt0-vcs0
[435.878181] Dynamic subtest gt0-vcs0: SUCCESS (24.269s)
[435.892124] Starting dynamic subtest: gt0-vecs0
[460.220798] Dynamic subtest gt0-vecs0: SUCCESS (24.339s)
[460.225660] Subtest rc6-idle: SUCCESS (97.256s)
[460.426403] [086/133] (579s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[461.924298] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[461.927419] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[462.043812] [087/133] (578s left) kms_psr (pr-sprite-plane-onoff)
[463.547367] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[463.630318] [088/133] (576s left) core_getversion (basic)
[463.678746] Starting subtest: basic
[463.682234] Subtest basic: SUCCESS (0.000s)
[463.803232] [089/133] (576s left) gem_softpin (allocator-nopin-reserve)
[463.873147] Starting subtest: allocator-nopin-reserve
[464.148409] Subtest allocator-nopin-reserve: SUCCESS (0.272s)
[464.348293] [090/133] (575s left) gem_mmap_gtt (basic-copy)
[464.408160] Subtest basic-copy: SKIP (0.000s)
[464.480595] [091/133] (575s left) kms_properties (crtc-properties-legacy)
[465.971848] Starting subtest: crtc-properties-legacy
[465.973423] Starting dynamic subtest: pipe-A-HDMI-A-4
[466.302249] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.329s)
[466.327200] Starting dynamic subtest: pipe-B-HDMI-A-4
[466.591135] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.283s)
[466.604489] Starting dynamic subtest: pipe-C-HDMI-A-4
[466.870611] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.278s)
[466.883833] Starting dynamic subtest: pipe-D-HDMI-A-4
[467.155867] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.283s)
[467.157579] Subtest crtc-properties-legacy: SUCCESS (1.184s)
[467.340101] [092/133] (573s left) gem_exec_schedule (fifo)
[467.407149] Starting subtest: fifo
[467.409107] Starting dynamic subtest: rcs0
[467.597118] Dynamic subtest rcs0: SUCCESS (0.188s)
[467.609897] Starting dynamic subtest: bcs0
[467.727011] Dynamic subtest bcs0: SUCCESS (0.131s)
[467.739997] Starting dynamic subtest: vcs0
[467.857512] Dynamic subtest vcs0: SUCCESS (0.129s)
[467.870351] Starting dynamic subtest: vcs1
[467.991685] Dynamic subtest vcs1: SUCCESS (0.133s)
[468.004682] Starting dynamic subtest: vecs0
[468.139799] Dynamic subtest vecs0: SUCCESS (0.147s)
[468.141515] Subtest fifo: SUCCESS (0.736s)
[468.605169] [093/133] (571s left) api_intel_allocator (open-vm)
[468.655535] Starting subtest: open-vm
[468.670802] Subtest open-vm: SUCCESS (0.016s)
[468.915715] [094/133] (571s left) gem_ctx_persistence (engines-cleanup)
[468.971970] Starting subtest: engines-cleanup
[468.973760] Starting dynamic subtest: rcs0
[469.040046] Dynamic subtest rcs0: SUCCESS (0.068s)
[469.054966] Starting dynamic subtest: bcs0
[469.082326] Dynamic subtest bcs0: SUCCESS (0.040s)
[469.099857] Starting dynamic subtest: vcs0
[469.104170] Dynamic subtest vcs0: SUCCESS (0.018s)
[469.116984] Starting dynamic subtest: vcs1
[469.159721] Dynamic subtest vcs1: SUCCESS (0.057s)
[469.180421] Starting dynamic subtest: vecs0
[469.182036] Dynamic subtest vecs0: SUCCESS (0.015s)
[469.183775] Subtest engines-cleanup: SUCCESS (0.206s)
[469.342366] [095/133] (571s left) kms_content_protection (dp-mst-type-1)
[470.892442] Starting subtest: dp-mst-type-1
[470.895418] Subtest dp-mst-type-1: SKIP (0.000s)
[471.104336] [096/133] (569s left) kms_cursor_edge_walk (64x64-top-bottom)
[472.597210] Starting subtest: 64x64-top-bottom
[472.598889] Starting dynamic subtest: pipe-A-HDMI-A-4
[475.935059] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.335s)
[475.953477] Starting dynamic subtest: pipe-D-HDMI-A-4
[479.155218] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.215s)
[479.156860] Subtest 64x64-top-bottom: SUCCESS (6.557s)
[479.327846] [097/133] (561s left) prime_vgem (busy)
[479.489353] Starting subtest: busy
[479.490705] Starting dynamic subtest: rcs0
[479.534387] Dynamic subtest rcs0: SUCCESS (0.044s)
[479.547504] Starting dynamic subtest: bcs0
[479.574371] Dynamic subtest bcs0: SUCCESS (0.038s)
[479.591180] Starting dynamic subtest: vcs0
[479.613968] Dynamic subtest vcs0: SUCCESS (0.038s)
[479.633778] Starting dynamic subtest: vcs1
[479.655348] Dynamic subtest vcs1: SUCCESS (0.039s)
[479.675161] Starting dynamic subtest: vecs0
[479.696533] Dynamic subtest vecs0: SUCCESS (0.039s)
[479.698016] Subtest busy: SUCCESS (0.208s)
[479.941870] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[479.945290] [098/133] (561s left) gem_exec_schedule (preempt-contexts)
[480.010330] Starting subtest: preempt-contexts
[480.011850] Starting dynamic subtest: rcs0
[480.102728] Dynamic subtest rcs0: SUCCESS (0.091s)
[480.116026] Starting dynamic subtest: bcs0
[480.176775] Dynamic subtest bcs0: SUCCESS (0.072s)
[480.190885] Starting dynamic subtest: vcs0
[480.249303] Dynamic subtest vcs0: SUCCESS (0.071s)
[480.262680] Starting dynamic subtest: vcs1
[480.320441] Dynamic subtest vcs1: SUCCESS (0.070s)
[480.333876] Starting dynamic subtest: vecs0
[480.393990] Dynamic subtest vecs0: SUCCESS (0.071s)
[480.395563] Subtest preempt-contexts: SUCCESS (0.383s)
[480.818956] [099/133] (560s left) gem_exec_fence (basic-busy)
[481.041499] Starting subtest: basic-busy
[481.043234] Starting dynamic subtest: rcs0
[481.139640] Dynamic subtest rcs0: SUCCESS (0.100s)
[481.157650] Starting dynamic subtest: bcs0
[481.201668] Dynamic subtest bcs0: SUCCESS (0.059s)
[481.235776] Starting dynamic subtest: vcs0
[481.255717] Dynamic subtest vcs0: SUCCESS (0.051s)
[481.284076] Starting dynamic subtest: vcs1
[481.311560] Dynamic subtest vcs1: SUCCESS (0.053s)
[481.332924] Starting dynamic subtest: vecs0
[481.369704] Dynamic subtest vecs0: SUCCESS (0.056s)
[481.371581] Subtest basic-busy: SUCCESS (0.333s)
[481.967592] [100/133] (559s left) gem_exec_fence (syncobj-timeline-repeat)
[482.506384] Starting subtest: syncobj-timeline-repeat
[483.070030] Subtest syncobj-timeline-repeat: SUCCESS (0.567s)
[483.338985] [101/133] (557s left) kms_pm_lpsp (screens-disabled)
[485.836802] Starting subtest: screens-disabled
[485.840146] Subtest screens-disabled: SKIP (0.000s)
[486.049560] [102/133] (555s left) gem_exec_suspend (basic-s4-devices)
[486.113114] Starting subtest: basic-S4-devices
[486.114695] Starting dynamic subtest: smem
[498.416277] Dynamic subtest smem: SUCCESS (12.304s)
[498.434063] Starting dynamic subtest: lmem0
[510.524842] Dynamic subtest lmem0: SUCCESS (12.107s)
[510.526855] Subtest basic-S4-devices: SUCCESS (24.414s)
[514.798973] [103/133] (530s left) i915_query (query-regions-sanity-check)
[514.855975] Starting subtest: query-regions-sanity-check
[514.885139] Subtest query-regions-sanity-check: SUCCESS (0.030s)
[515.063515] [104/133] (530s left) syncobj_basic (create-signaled)
[515.111892] Starting subtest: create-signaled
[515.113720] Subtest create-signaled: SUCCESS (0.000s)
[515.261441] [105/133] (530s left) kms_psr (psr2-cursor-mmap-gtt)
[516.753551] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[516.846961] [106/133] (528s left) gen9_exec_parse (bb-start-param)
[516.903553] Subtest bb-start-param: SKIP (0.000s)
[516.982114] [107/133] (528s left) gem_ctx_param (basic-default)
[517.032224] Starting subtest: basic-default
[517.034195] Subtest basic-default: SUCCESS (0.000s)
[517.174553] [108/133] (528s left) gem_exec_suspend (basic-s3)
[517.233462] Starting subtest: basic-S3
[517.235175] Starting dynamic subtest: smem
[541.753802] Dynamic subtest smem: SUCCESS (14.088s)
[541.769918] Starting dynamic subtest: lmem0
[566.771341] Dynamic subtest lmem0: SUCCESS (13.996s)
[566.782981] Subtest basic-S3: SUCCESS (28.090s)
[572.083994] [109/133] (478s left) gem_ccs (ctrl-surf-copy-new-ctx)
[572.147592] Starting subtest: ctrl-surf-copy-new-ctx
[572.150771] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[572.262704] [110/133] (478s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[574.416784] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[574.420109] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[574.577260] [111/133] (476s left) gem_readwrite (new-obj)
[574.633221] Subtest new-obj: SKIP (0.000s)
[574.725857] [112/133] (476s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[576.236969] Starting subtest: x-tiled-32bpp-rotate-270
[576.341765] Subtest x-tiled-32bpp-rotate-270: SKIP (0.103s)
[576.499682] [113/133] (474s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[576.556226] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[576.659510] [114/133] (474s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[578.170819] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[578.174632] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[578.353169] [115/133] (473s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[579.855173] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[579.858395] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[580.007439] [116/133] (471s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[580.063995] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[580.187739] [117/133] (471s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[580.237813] Starting subtest: etime-multi-wait-all-submitted-signaled
[580.343752] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[580.499787] [118/133] (471s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[582.010519] Starting subtest: 4-tiled-8bpp-rotate-0
[582.014057] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[582.184707] [119/133] (469s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[583.695964] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[583.699697] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[583.910824] [120/133] (468s left) gem_ctx_param (invalid-size-set)
[583.960287] Starting subtest: invalid-size-set
[583.962067] Subtest invalid-size-set: SUCCESS (0.001s)
[584.087083] [121/133] (468s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[584.145146] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[584.146906] Starting dynamic subtest: smem
[584.244112] Dynamic subtest smem: SUCCESS (0.100s)
[584.260514] Starting dynamic subtest: lmem0
[585.361766] Dynamic subtest lmem0: SUCCESS (1.116s)
[585.363190] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.220s)
[585.633697] [122/133] (466s left) kms_psr (psr-sprite-plane-onoff)
[587.125641] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[587.208893] [123/133] (465s left) i915_drm_fdinfo (basics)
[587.261653] Starting subtest: basics
[587.263330] Subtest basics: SUCCESS (0.000s)
[587.386833] [124/133] (465s left) kms_plane_multiple (2x-tiling-y)
[588.878470] Starting subtest: 2x-tiling-y
[588.881865] Subtest 2x-tiling-y: SKIP (0.000s)
[589.003607] [125/133] (463s left) gem_exec_schedule (u-submit-early-slice)
[589.076907] Starting subtest: u-submit-early-slice
[589.078265] Starting dynamic subtest: rcs0
[589.136703] Dynamic subtest rcs0: SUCCESS (0.060s)
[589.153580] Starting dynamic subtest: bcs0
[589.180406] Dynamic subtest bcs0: SUCCESS (0.042s)
[589.197386] Starting dynamic subtest: vcs0
[589.226904] Dynamic subtest vcs0: SUCCESS (0.045s)
[589.243833] Starting dynamic subtest: vcs1
[589.273123] Dynamic subtest vcs1: SUCCESS (0.045s)
[589.289844] Starting dynamic subtest: vecs0
[589.317214] Dynamic subtest vecs0: SUCCESS (0.043s)
[589.318638] Subtest u-submit-early-slice: SUCCESS (0.242s)
[589.800698] [126/133] (462s left) gem_mmap_wc (coherency)
[589.850204] Subtest coherency: SKIP (0.000s)
[589.941659] [127/133] (462s left) kms_invalid_mode (bad-vsync-start)
[591.443872] Starting subtest: bad-vsync-start
[591.445753] Starting dynamic subtest: pipe-A-HDMI-A-4
[591.479226] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.046s)
[591.499176] Starting dynamic subtest: pipe-B-HDMI-A-4
[591.500890] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[591.519188] Starting dynamic subtest: pipe-C-HDMI-A-4
[591.520705] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[591.537515] Starting dynamic subtest: pipe-D-HDMI-A-4
[591.538985] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[591.540509] Subtest bad-vsync-start: SUCCESS (0.058s)
[591.664708] [128/133] (461s left) gem_fenced_exec_thrash (2-spare-fences)
[591.719331] Subtest 2-spare-fences: SKIP (0.000s)
[591.807749] [129/133] (461s left) syncobj_timeline (wait-for-submit-snapshot)
[591.855752] Starting subtest: wait-for-submit-snapshot
[591.939617] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[592.174766] [130/133] (460s left) kms_vblank (ts-continuation-idle)
[593.667341] Starting subtest: ts-continuation-idle
[593.668824] Starting dynamic subtest: pipe-A-HDMI-A-4
[593.998891] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.330s)
[594.018753] Starting dynamic subtest: pipe-D-HDMI-A-4
[594.174728] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.169s)
[594.176430] Subtest ts-continuation-idle: SUCCESS (0.508s)
[594.344667] [131/133] (458s left) kms_atomic (plane-invalid-params-fence)
[595.837881] Starting subtest: plane-invalid-params-fence
[595.842117] Starting dynamic subtest: pipe-A-HDMI-A-4
[596.160756] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.321s)
[596.162342] Subtest plane-invalid-params-fence: SUCCESS (0.323s)
[596.349314] [132/133] (456s left) syncobj_wait (multi-wait-for-submit-signaled)
[596.402271] Starting subtest: multi-wait-for-submit-signaled
[596.404221] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[596.530579] [133/133] (456s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[598.028635] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[598.037206] Starting dynamic subtest: A-HDMI-A4
[606.064513] Dynamic subtest A-HDMI-A4: SUCCESS (8.027s)
[606.084670] Starting dynamic subtest: B-HDMI-A4
[614.176277] Dynamic subtest B-HDMI-A4: SUCCESS (8.109s)
[614.196353] Starting dynamic subtest: C-HDMI-A4
[622.120698] Dynamic subtest C-HDMI-A4: SUCCESS (7.942s)
[622.140045] Starting dynamic subtest: D-HDMI-A4
[630.048314] Dynamic subtest D-HDMI-A4: SUCCESS (7.925s)
[630.050112] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.021s)
[630.259406] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_draw_crc
results: parsing output: 3/ for test: gem_partial_pwrite_pread
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: drm_read
results: parsing output: 7/ for test: gem_exec_store
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: kms_atomic_interruptible
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_color
results: parsing output: 13/ for test: gem_pwrite
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: gem_lmem_swapping
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: gem_exec_flush
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: kms_pipe_crc_basic
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_lmem_swapping
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_psr2_su
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_chamelium_audio
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: gem_exec_gttfill
results: parsing output: 45/ for test: gem_exec_parallel
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: kms_lease
results: parsing output: 51/ for test: kms_getfb
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_force_connector_basic
results: parsing output: 62/ for test: kms_getfb
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_debugfs
results: parsing output: 70/ for test: prime_udl
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_universal_plane
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: syncobj_basic
results: parsing output: 76/ for test: gem_render_copy_redux
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_prop_blob
results: parsing output: 82/ for test: kms_vrr
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_pm_rc6_residency
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: core_getversion
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: kms_properties
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: api_intel_allocator
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_cursor_edge_walk
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: kms_pm_lpsp
results: parsing output: 101/ for test: gem_exec_suspend
results: parsing output: 102/ for test: i915_query
results: parsing output: 103/ for test: syncobj_basic
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: gem_exec_suspend
results: parsing output: 108/ for test: gem_ccs
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_readwrite
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_ctx_param
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_plane_multiple
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: kms_invalid_mode
results: parsing output: 127/ for test: gem_fenced_exec_thrash
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: kms_atomic
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: kms_flip
Done.