[64.870982] Initializing watchdogs
[64.871045]   /dev/watchdog0
[64.886244] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[64.890744] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.893439] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.895916] [001/133] (960s left) perf (rc6-disable)
[65.028530] Starting subtest: rc6-disable
[65.206857] Subtest rc6-disable: SUCCESS (0.177s)
[65.247909] [002/133] (960s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[65.308219] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[65.310100] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[65.483428] [003/133] (959s left) gem_workarounds (reset)
[65.555802] Starting subtest: reset
[65.668443] Subtest reset: SUCCESS (0.113s)
[65.786980] [004/133] (959s left) perf_pmu (most-busy-check-all)
[65.827383] Starting subtest: most-busy-check-all
[65.828256] Starting dynamic subtest: rcs0
[66.910938] Dynamic subtest rcs0: SUCCESS (1.072s)
[66.918440] Starting dynamic subtest: bcs0
[68.895452] Dynamic subtest bcs0: SUCCESS (1.981s)
[68.904813] Starting dynamic subtest: vcs0
[70.941705] Dynamic subtest vcs0: SUCCESS (2.043s)
[70.950859] Starting dynamic subtest: vcs1
[72.926428] Dynamic subtest vcs1: SUCCESS (1.982s)
[72.935622] Starting dynamic subtest: vecs0
[74.909915] Dynamic subtest vecs0: SUCCESS (1.981s)
[74.919072] Starting dynamic subtest: ccs0
[76.893917] Dynamic subtest ccs0: SUCCESS (1.982s)
[76.895115] Subtest most-busy-check-all: SUCCESS (11.049s)
[76.999802] [005/133] (948s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[77.052382] Subtest tiled-to-tiled: SKIP (0.000s)
[77.101110] [006/133] (948s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[77.192460] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[77.567860] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[80.311590] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.733s)
[80.318437] Starting dynamic subtest: pipe-A-eDP-1-4
[82.497454] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[82.506786] Starting dynamic subtest: pipe-A-eDP-1-4
[84.508400] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[84.516988] Starting dynamic subtest: pipe-A-eDP-1-x
[86.699251] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[87.073911] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[89.848057] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.772s)
[89.860079] Starting dynamic subtest: pipe-B-eDP-1-4
[92.034573] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[92.044029] Starting dynamic subtest: pipe-B-eDP-1-4
[94.045543] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[94.052820] Starting dynamic subtest: pipe-B-eDP-1-x
[96.247056] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[96.603035] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[99.375958] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.771s)
[99.390392] Starting dynamic subtest: pipe-C-eDP-1-4
[101.561932] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[101.571830] Starting dynamic subtest: pipe-C-eDP-1-4
[103.572358] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[103.581210] Starting dynamic subtest: pipe-C-eDP-1-x
[105.763300] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.190s)
[106.135199] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[108.911814] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[108.922504] Starting dynamic subtest: pipe-D-eDP-1-4
[111.086647] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[111.093787] Starting dynamic subtest: pipe-D-eDP-1-4
[113.096082] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[113.103442] Starting dynamic subtest: pipe-D-eDP-1-x
[115.275778] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.179s)
[115.277494] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.067s)
[116.490857] [007/133] (909s left) kms_psr (fbc-psr2-suspend)
[116.570339] Starting subtest: fbc-psr2-suspend
[116.571296] Starting dynamic subtest: eDP-1
[116.573222] Dynamic subtest eDP-1: SKIP (0.000s)
[116.574995] Subtest fbc-psr2-suspend: SKIP (0.000s)
[116.635177] [008/133] (909s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[116.730493] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[123.827550] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.098s)
[123.987870] [009/133] (901s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[124.083019] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[124.084689] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[124.186225] [010/133] (901s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[124.272054] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[124.274417] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[124.355301] [011/133] (901s left) syncobj_timeline (invalid-transfer-illegal-handle)
[124.412064] Starting subtest: invalid-transfer-illegal-handle
[124.414246] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[124.500422] [012/133] (901s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[124.590204] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[124.591851] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[124.681117] [013/133] (901s left) gem_pread (snoop)
[124.728481] Subtest snoop: SKIP (0.000s)
[124.783399] [014/133] (901s left) kms_flip (2x-flip-vs-rmfb)
[124.865786] Starting subtest: 2x-flip-vs-rmfb
[124.876786] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[124.949505] [015/133] (900s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[124.999931] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[125.114111] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[125.177799] [016/133] (900s left) gem_mmap (basic-small-bo)
[125.219857] Subtest basic-small-bo: SKIP (0.000s)
[125.270363] [017/133] (900s left) kms_big_fb (x-tiled-addfb-size-overflow)
[125.370248] Starting subtest: x-tiled-addfb-size-overflow
[125.371201] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[125.458606] [018/133] (900s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[125.555298] Starting subtest: pr-cursor-plane-update-sf
[125.557038] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[125.621998] [019/133] (900s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[125.710857] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[125.711712] Starting dynamic subtest: pipe-A
[125.831841] Dynamic subtest pipe-A: SKIP (0.119s)
[125.839379] Starting dynamic subtest: pipe-B
[126.992472] Dynamic subtest pipe-B: SKIP (1.161s)
[127.000061] Starting dynamic subtest: pipe-C
[128.213688] Dynamic subtest pipe-C: SUCCESS (1.222s)
[128.222316] Starting dynamic subtest: pipe-D
[129.442165] Dynamic subtest pipe-D: SUCCESS (1.228s)
[129.443122] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.732s)
[130.626220] [020/133] (895s left) gem_mmap_wc (write-prefaulted)
[130.675849] Subtest write-prefaulted: SKIP (0.000s)
[130.724261] [021/133] (895s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[130.819525] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[130.821157] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[130.884881] [022/133] (895s left) kms_color_pipeline (plane-lut1d)
[130.975266] Starting subtest: plane-lut1d
[131.111182] Starting dynamic subtest: pipe-A-plane-0
[131.289092] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[131.297210] Starting dynamic subtest: pipe-A-plane-1
[131.477952] Dynamic subtest pipe-A-plane-1: SUCCESS (0.189s)
[131.486568] Starting dynamic subtest: pipe-A-plane-2
[131.644461] Dynamic subtest pipe-A-plane-2: SUCCESS (0.165s)
[132.873340] Starting dynamic subtest: pipe-B-plane-0
[133.040336] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[133.052317] Starting dynamic subtest: pipe-B-plane-1
[133.233051] Dynamic subtest pipe-B-plane-1: SUCCESS (0.187s)
[133.241356] Starting dynamic subtest: pipe-B-plane-2
[133.395182] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[134.564604] Starting dynamic subtest: pipe-C-plane-0
[134.723942] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[134.731066] Starting dynamic subtest: pipe-C-plane-1
[134.879211] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s)
[134.887389] Starting dynamic subtest: pipe-C-plane-2
[135.057042] Dynamic subtest pipe-C-plane-2: SUCCESS (0.177s)
[136.283035] Starting dynamic subtest: pipe-D-plane-0
[136.432210] Dynamic subtest pipe-D-plane-0: SUCCESS (0.156s)
[136.440642] Starting dynamic subtest: pipe-D-plane-1
[136.587829] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[136.596194] Starting dynamic subtest: pipe-D-plane-2
[136.731997] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[137.019038] Subtest plane-lut1d: SUCCESS (6.044s)
[137.862281] [023/133] (888s left) gem_softpin (allocator-nopin-reserve)
[137.923168] Starting subtest: allocator-nopin-reserve
[138.022888] Subtest allocator-nopin-reserve: SUCCESS (0.099s)
[138.147991] [024/133] (888s left) gem_ctx_bad_destroy (invalid-pad)
[138.200543] Starting subtest: invalid-pad
[138.201583] Subtest invalid-pad: SUCCESS (0.000s)
[138.256485] [025/133] (887s left) kms_psr (psr-cursor-plane-onoff)
[138.348222] Starting subtest: psr-cursor-plane-onoff
[138.349135] Starting dynamic subtest: eDP-1
[140.060382] Dynamic subtest eDP-1: SUCCESS (1.712s)
[140.061240] Subtest psr-cursor-plane-onoff: SUCCESS (1.713s)
[140.925043] [026/133] (885s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[141.021353] Starting subtest: 4-tiled-16bpp-rotate-180
[142.299931] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.279s)
[142.412766] [027/133] (883s left) api_intel_allocator (open-vm)
[142.456320] Starting subtest: open-vm
[142.458185] Subtest open-vm: SUCCESS (0.003s)
[142.591427] [028/133] (883s left) gem_fence_thrash (bo-write-verify-none)
[142.620549] Starting subtest: bo-write-verify-none
[142.633869] Subtest bo-write-verify-none: SKIP (0.012s)
[142.687154] [029/133] (883s left) gem_exec_reloc (basic-active)
[142.746874] Subtest basic-active: SKIP (0.000s)
[142.805480] [030/133] (883s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[142.887612] Starting subtest: psr2-cursor-plane-update-sf
[142.888435] Starting dynamic subtest: pipe-A-eDP-1
[143.455886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[143.463502] Starting dynamic subtest: pipe-B-eDP-1
[144.713441] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.256s)
[144.714338] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.826s)
[145.581283] [031/133] (880s left) i915_pm_freq_api (freq-reset)
[145.632636] Starting subtest: freq-reset
[145.633617] Starting dynamic subtest: gt0
[145.832106] Dynamic subtest gt0: SUCCESS (0.198s)
[145.840823] Starting dynamic subtest: gt1
[146.004812] Dynamic subtest gt1: SUCCESS (0.163s)
[146.006088] Subtest freq-reset: SUCCESS (0.364s)
[146.065183] [032/133] (880s left) gem_linear_blits (interruptible)
[146.456964] Starting subtest: interruptible
[151.121020] Subtest interruptible: SUCCESS (4.649s)
[151.235897] [033/133] (875s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[151.381137] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[151.382144] Starting dynamic subtest: pipe-A-eDP-1
[151.390437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[151.399503] Starting dynamic subtest: pipe-B-eDP-1
[151.407316] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[151.414596] Starting dynamic subtest: pipe-C-eDP-1
[151.422232] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[151.429386] Starting dynamic subtest: pipe-D-eDP-1
[151.436605] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[151.437447] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[153.651557] [034/133] (872s left) kms_addfb_basic (bad-pitch-63)
[153.712876] Starting subtest: bad-pitch-63
[153.713888] Subtest bad-pitch-63: SUCCESS (0.000s)
[153.859500] [035/133] (872s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[153.938982] Starting subtest: wait-all-for-submit-delayed-submit
[154.042445] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[154.123411] [036/133] (872s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[154.193644] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[154.297377] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[154.364525] [037/133] (872s left) kms_plane_alpha_blend (constant-alpha-mid)
[154.457048] Starting subtest: constant-alpha-mid
[154.741921] Starting dynamic subtest: pipe-A-eDP-1
[155.705242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.963s)
[155.712924] Starting dynamic subtest: pipe-D-eDP-1
[157.250246] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.543s)
[157.251073] Subtest constant-alpha-mid: SUCCESS (2.793s)
[158.108334] [038/133] (868s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[158.205047] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[162.280943] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.076s)
[163.413754] [039/133] (863s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[163.511177] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[163.512912] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[163.606903] [040/133] (863s left) kms_prime (basic-crc-hybrid)
[163.684214] Subtest basic-crc-hybrid: SKIP (0.000s)
[163.852490] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[163.855123] [041/133] (862s left) prime_vgem (busy)
[163.931947] Starting subtest: busy
[163.933122] Starting dynamic subtest: rcs0
[163.977659] Dynamic subtest rcs0: SUCCESS (0.045s)
[163.986544] Starting dynamic subtest: bcs0
[164.043124] Dynamic subtest bcs0: SUCCESS (0.064s)
[164.051872] Starting dynamic subtest: vcs0
[164.089515] Dynamic subtest vcs0: SUCCESS (0.044s)
[164.097988] Starting dynamic subtest: vcs1
[164.135029] Dynamic subtest vcs1: SUCCESS (0.045s)
[164.143584] Starting dynamic subtest: vecs0
[164.181476] Dynamic subtest vecs0: SUCCESS (0.046s)
[164.189304] Starting dynamic subtest: ccs0
[164.228349] Dynamic subtest ccs0: SUCCESS (0.046s)
[164.229411] Subtest busy: SUCCESS (0.297s)
[164.367190] [042/133] (862s left) kms_psr (pr-sprite-mmap-cpu)
[164.456382] Starting subtest: pr-sprite-mmap-cpu
[164.458095] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[164.523702] [043/133] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[164.634521] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[164.636721] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[164.754077] [044/133] (862s left) kms_cursor_edge_walk (128x128-right-edge)
[164.858044] Starting subtest: 128x128-right-edge
[164.861023] Starting dynamic subtest: pipe-A-eDP-1
[168.387882] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.527s)
[168.398737] Starting dynamic subtest: pipe-D-eDP-1
[171.523239] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[171.524094] Subtest 128x128-right-edge: SUCCESS (6.665s)
[172.308891] [045/133] (854s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[172.391568] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[180.213390] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.822s)
[180.341434] [046/133] (846s left) syncobj_eventfd (timeline-wait-signaled)
[180.400289] Starting subtest: timeline-wait-signaled
[180.401550] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[180.495194] [047/133] (846s left) gem_ctx_param (basic-default)
[180.555588] Starting subtest: basic-default
[180.556655] Subtest basic-default: SUCCESS (0.000s)
[180.643742] [048/133] (846s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[180.752196] Starting subtest: protected-encrypted-src-copy-not-readible
[180.869160] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s)
[180.987546] [049/133] (845s left) gen9_exec_parse (batch-invalid-length)
[181.032351] Subtest batch-invalid-length: SKIP (0.000s)
[181.094506] [050/133] (845s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[181.180481] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[181.182485] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[181.268580] [051/133] (845s left) perf (gen12-group-exclusive-stream-sample-oa)
[181.365548] Starting subtest: gen12-group-exclusive-stream-sample-oa
[181.381642] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.018s)
[181.419952] [052/133] (845s left) gem_busy (close-race)
[181.476893] Starting subtest: close-race
[204.958053] Subtest close-race: SUCCESS (23.470s)
[205.309757] [053/133] (821s left) device_reset (cold-reset-bound)
[205.405237] Starting subtest: cold-reset-bound
[205.407110] Subtest cold-reset-bound: SKIP (0.000s)
[205.474139] [054/133] (821s left) kms_psr (fbc-psr2-cursor-render)
[205.564290] Starting subtest: fbc-psr2-cursor-render
[205.565235] Starting dynamic subtest: eDP-1
[205.567123] Dynamic subtest eDP-1: SKIP (0.000s)
[205.568944] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[205.634587] [055/133] (821s left) gem_exec_params (invalid-bsd2-flag-on-render)
[205.687201] Starting subtest: invalid-bsd2-flag-on-render
[205.688107] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[205.777672] [056/133] (821s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[205.864091] Starting subtest: invalidate-primary-flip-overlay
[216.641909] Subtest invalidate-primary-flip-overlay: SUCCESS (10.778s)
[216.730077] [057/133] (810s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[216.778933] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[216.829256] [058/133] (810s left) gem_exec_whisper (basic-fds-forked)
[216.891173] Starting subtest: basic-fds-forked
[240.998987] Subtest basic-fds-forked: SUCCESS (24.059s)
[241.131742] [059/133] (786s left) gem_userptr_blits (dmabuf-unsync)
[241.188222] Subtest dmabuf-unsync: SKIP (0.000s)
[241.320322] [060/133] (786s left) gem_mmap_gtt (basic-small-bo-tiledy)
[241.367890] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[241.426628] [061/133] (785s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[241.534551] Starting subtest: flip-vs-cursor-busy-crc-legacy
[242.391021] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.855s)
[243.274413] [062/133] (784s left) kms_pm_rpm (cursor)
[245.012038] Starting subtest: cursor
[245.014133] Subtest cursor: SKIP (0.000s)
[245.517438] [063/133] (781s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[245.607048] Starting subtest: y-tiled-32bpp-rotate-90
[245.608959] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[245.698997] [064/133] (781s left) kms_plane_scaling (planes-downscale-factor-0-75)
[245.776279] Starting subtest: planes-downscale-factor-0-75
[245.777290] Starting dynamic subtest: pipe-A
[245.797129] Dynamic subtest pipe-A: SKIP (0.019s)
[245.805215] Starting dynamic subtest: pipe-B
[245.831089] Dynamic subtest pipe-B: SKIP (0.033s)
[245.839181] Starting dynamic subtest: pipe-C
[245.863535] Dynamic subtest pipe-C: SKIP (0.033s)
[245.871453] Starting dynamic subtest: pipe-D
[245.900190] Dynamic subtest pipe-D: SKIP (0.035s)
[245.901768] Subtest planes-downscale-factor-0-75: SKIP (0.123s)
[245.992357] [065/133] (781s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[246.074839] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[246.076357] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[246.144814] [066/133] (781s left) syncobj_wait (wait-delayed-signal)
[246.214860] Starting subtest: wait-delayed-signal
[246.317759] Subtest wait-delayed-signal: SUCCESS (0.102s)
[246.395036] [067/133] (781s left) kms_frontbuffer_tracking (fbc-2p-rte)
[246.477044] Starting subtest: fbc-2p-rte
[246.478902] Subtest fbc-2p-rte: SKIP (0.000s)
[246.564191] [068/133] (781s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[246.698734] Starting subtest: dp-mst-type-1-suspend-resume
[246.700670] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[246.826122] [069/133] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[246.921195] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[246.922795] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[247.022795] [070/133] (780s left) kms_flip (dpms-off-confusion)
[247.119539] Starting subtest: dpms-off-confusion
[247.120476] Starting dynamic subtest: A-eDP1
[255.825071] Dynamic subtest A-eDP1: SUCCESS (8.677s)
[255.835245] Starting dynamic subtest: B-eDP1
[264.561848] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[264.572567] Starting dynamic subtest: C-eDP1
[273.200631] Dynamic subtest C-eDP1: SUCCESS (8.625s)
[273.210612] Starting dynamic subtest: D-eDP1
[281.820884] Dynamic subtest D-eDP1: SUCCESS (8.619s)
[281.821949] Subtest dpms-off-confusion: SUCCESS (34.665s)
[282.949360] [071/133] (744s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[283.044899] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[283.046576] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[283.131097] [072/133] (744s left) kms_dsc (dsc-with-bpc)
[283.210438] Starting subtest: dsc-with-bpc
[283.222592] Subtest dsc-with-bpc: SKIP (0.001s)
[283.291922] [073/133] (744s left) gem_tiled_pread_basic (basic)
[283.350656] Subtest basic: SKIP (0.000s)
[283.408708] [074/133] (744s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[283.506355] Starting subtest: 4-tiled-addfb-size-offset-overflow
[283.507360] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[283.590999] [075/133] (744s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[283.677547] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[283.678625] Starting dynamic subtest: pipe-A-eDP-1
[283.686951] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[283.700477] Starting dynamic subtest: pipe-B-eDP-1
[283.708790] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[283.716816] Starting dynamic subtest: pipe-C-eDP-1
[283.724802] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[283.733568] Starting dynamic subtest: pipe-D-eDP-1
[283.742667] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[283.744405] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[285.935895] [076/133] (741s left) gem_exec_flush (basic-uc-pro-default)
[285.999592] Starting subtest: basic-uc-pro-default
[291.455505] Subtest basic-uc-pro-default: SUCCESS (5.455s)
[291.651834] [077/133] (736s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[291.744294] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[298.967060] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.223s)
[299.077119] [078/133] (728s left) gem_exec_capture (capture-invisible)
[299.129552] Starting subtest: capture-invisible
[299.130468] Starting dynamic subtest: smem0
[299.132145] Dynamic subtest smem0: SKIP (0.000s)
[299.133667] Subtest capture-invisible: SKIP (0.001s)
[299.242583] [079/133] (728s left) gem_exec_create (madvise)
[299.301794] Starting subtest: madvise
[299.302999] Starting dynamic subtest: smem
[319.451271] Dynamic subtest smem: SUCCESS (20.149s)
[319.452410] Subtest madvise: SUCCESS (20.151s)
[320.258722] [080/133] (707s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[320.350172] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[320.351065] Starting dynamic subtest: pipe-A-eDP-1
[320.827464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[320.838579] Starting dynamic subtest: pipe-B-eDP-1
[320.846402] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[320.856147] Starting dynamic subtest: pipe-C-eDP-1
[320.864396] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[320.873857] Starting dynamic subtest: pipe-D-eDP-1
[320.880861] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[320.881828] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.494s)
[323.121014] [081/133] (704s left) sysfs_timeslice_duration (idempotent)
[323.178481] Starting subtest: idempotent
[323.179490] Starting dynamic subtest: vecs0
[323.180430] Dynamic subtest vecs0: SUCCESS (0.000s)
[323.189524] Starting dynamic subtest: ccs0
[323.190395] Dynamic subtest ccs0: SUCCESS (0.000s)
[323.198084] Starting dynamic subtest: vcs0
[323.198899] Dynamic subtest vcs0: SUCCESS (0.000s)
[323.206342] Starting dynamic subtest: bcs0
[323.207363] Dynamic subtest bcs0: SUCCESS (0.000s)
[323.214880] Starting dynamic subtest: rcs0
[323.215759] Dynamic subtest rcs0: SUCCESS (0.000s)
[323.223231] Starting dynamic subtest: vcs1
[323.224072] Dynamic subtest vcs1: SUCCESS (0.000s)
[323.225075] Subtest idempotent: SUCCESS (0.006s)
[323.257273] [082/133] (704s left) gem_mmap_wc (close)
[323.301346] Subtest close: SKIP (0.000s)
[323.351759] [083/133] (704s left) i915_drm_fdinfo (memory-info-purgeable)
[323.386555] Starting subtest: memory-info-purgeable
[323.387621] Starting dynamic subtest: smem0
[326.086709] Dynamic subtest smem0: SUCCESS (2.699s)
[326.088065] Subtest memory-info-purgeable: SUCCESS (2.700s)
[326.162879] [084/133] (702s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[326.244991] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[326.246046] Starting dynamic subtest: pipe-A-eDP-1
[326.254225] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[326.262429] Starting dynamic subtest: pipe-B-eDP-1
[326.272840] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[326.281349] Starting dynamic subtest: pipe-C-eDP-1
[326.289835] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[326.297740] Starting dynamic subtest: pipe-D-eDP-1
[326.306789] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[326.308381] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[328.487138] [085/133] (699s left) syncobj_timeline (multi-wait-available-submitted)
[328.538062] Starting subtest: multi-wait-available-submitted
[328.539085] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[328.622445] [086/133] (699s left) kms_big_fb (linear-32bpp-rotate-0)
[328.725427] Starting subtest: linear-32bpp-rotate-0
[330.385169] Subtest linear-32bpp-rotate-0: SUCCESS (1.659s)
[330.514097] [087/133] (697s left) gem_exec_reloc (basic-cpu-wc-active)
[330.573849] Subtest basic-cpu-wc-active: SKIP (0.000s)
[330.637867] [088/133] (697s left) kms_flip_event_leak (basic)
[330.726634] Starting subtest: basic
[330.727633] Starting dynamic subtest: pipe-A-eDP-1
[331.179187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s)
[331.193862] Starting dynamic subtest: pipe-B-eDP-1
[332.326507] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s)
[332.334693] Starting dynamic subtest: pipe-C-eDP-1
[333.425068] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.098s)
[333.434824] Starting dynamic subtest: pipe-D-eDP-1
[334.558531] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[334.559407] Subtest basic: SUCCESS (3.832s)
[335.410357] [089/133] (692s left) kms_lease (lease-invalid-connector)
[335.503086] Starting subtest: lease-invalid-connector
[335.504104] Starting dynamic subtest: pipe-A-eDP-1
[335.505061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[335.513454] Starting dynamic subtest: pipe-B-eDP-1
[335.514392] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[335.522716] Starting dynamic subtest: pipe-C-eDP-1
[335.523626] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[335.531617] Starting dynamic subtest: pipe-D-eDP-1
[335.532490] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[335.533357] Subtest lease-invalid-connector: SUCCESS (0.005s)
[335.584863] [090/133] (692s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[335.686156] Starting subtest: x-tiled-64bpp-rotate-180
[337.320474] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.635s)
[337.483462] [091/133] (690s left) kms_vblank (wait-forked)
[337.581454] Starting subtest: wait-forked
[337.582459] Starting dynamic subtest: pipe-A-eDP-1
[339.407405] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.824s)
[339.418542] Starting dynamic subtest: pipe-D-eDP-1
[341.909953] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.500s)
[341.910877] Subtest wait-forked: SUCCESS (4.329s)
[342.764425] [092/133] (685s left) gem_exec_schedule (semaphore-user)
[342.814974] Starting subtest: semaphore-user
[342.873385] Subtest semaphore-user: SUCCESS (0.058s)
[343.927998] [093/133] (684s left) kms_chamelium_hpd (hdmi-hpd-storm)
[344.314056] Subtest hdmi-hpd-storm: SKIP (0.000s)
[345.087410] [094/133] (683s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[345.221320] Starting subtest: short-flip-before-cursor-toggle
[346.138433] Subtest short-flip-before-cursor-toggle: SUCCESS (0.915s)
[346.954073] [095/133] (681s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[347.048777] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[347.050279] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[347.147511] [096/133] (681s left) gem_ctx_persistence (legacy-engines-cleanup)
[347.208459] Starting subtest: legacy-engines-cleanup
[347.209544] Starting dynamic subtest: render
[347.275557] Dynamic subtest render: SUCCESS (0.066s)
[347.287338] Starting dynamic subtest: bsd1
[347.318098] Dynamic subtest bsd1: SUCCESS (0.040s)
[347.334289] Starting dynamic subtest: bsd2
[347.359346] Dynamic subtest bsd2: SUCCESS (0.038s)
[347.372358] Starting dynamic subtest: blt
[347.398297] Dynamic subtest blt: SUCCESS (0.036s)
[347.410375] Starting dynamic subtest: vebox
[347.419031] Dynamic subtest vebox: SUCCESS (0.019s)
[347.420443] Subtest legacy-engines-cleanup: SUCCESS (0.211s)
[347.532613] [097/133] (681s left) gem_exercise_blt (fast-copy)
[347.583258] Starting subtest: fast-copy
[347.584115] Starting dynamic subtest: linear-smem-smem
[347.606505] Dynamic subtest linear-smem-smem: SUCCESS (0.024s)
[347.617357] Starting dynamic subtest: xmajor-smem-smem
[347.628303] Dynamic subtest xmajor-smem-smem: SUCCESS (0.021s)
[347.638448] Starting dynamic subtest: tile4-smem-smem
[347.674262] Dynamic subtest tile4-smem-smem: SUCCESS (0.045s)
[347.684462] Starting dynamic subtest: tile64-smem-smem
[347.697571] Dynamic subtest tile64-smem-smem: SUCCESS (0.021s)
[347.698825] Subtest fast-copy: SUCCESS (0.116s)
[347.807342] [098/133] (680s left) kms_flip (flip-vs-absolute-wf_vblank)
[347.883660] Starting subtest: flip-vs-absolute-wf_vblank
[347.886092] Starting dynamic subtest: A-eDP1
[356.787384] Dynamic subtest A-eDP1: SUCCESS (8.901s)
[356.797334] Starting dynamic subtest: B-eDP1
[365.716346] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[365.724670] Starting dynamic subtest: C-eDP1
[374.684504] Dynamic subtest C-eDP1: SUCCESS (8.929s)
[374.694841] Starting dynamic subtest: D-eDP1
[383.621420] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[383.622283] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.704s)
[384.815040] [099/133] (643s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[384.935089] Starting subtest: modeset-atomic-cursor-hotspot
[384.936771] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[385.087270] [100/133] (643s left) kms_cursor_crc (cursor-onscreen-256x256)
[385.334972] Starting subtest: cursor-onscreen-256x256
[385.336913] Starting dynamic subtest: pipe-A-eDP-1
[387.435923] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.098s)
[387.465075] Starting dynamic subtest: pipe-D-eDP-1
[390.213468] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.756s)
[390.214383] Subtest cursor-onscreen-256x256: SUCCESS (4.880s)
[391.097017] [101/133] (637s left) gem_ctx_isolation (clean)
[391.152119] Starting subtest: clean
[391.153065] Starting dynamic subtest: rcs0
[391.203924] Dynamic subtest rcs0: SUCCESS (0.051s)
[391.214350] Starting dynamic subtest: bcs0
[391.264366] Dynamic subtest bcs0: SUCCESS (0.060s)
[391.274164] Starting dynamic subtest: vcs0
[391.347301] Dynamic subtest vcs0: SUCCESS (0.082s)
[391.357830] Starting dynamic subtest: vcs1
[392.853480] Dynamic subtest vcs1: SUCCESS (1.505s)
[392.863412] Starting dynamic subtest: vecs0
[393.948779] Dynamic subtest vecs0: SUCCESS (1.094s)
[393.961182] Starting dynamic subtest: ccs0
[395.950789] Dynamic subtest ccs0: SUCCESS (2.001s)
[395.951761] Subtest clean: SUCCESS (4.799s)
[396.172132] [102/133] (632s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[396.266627] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[403.935545] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.669s)
[405.099878] [103/133] (623s left) gem_ctx_shared (exec-single-timeline)
[405.161281] Starting subtest: exec-single-timeline
[405.162361] Starting dynamic subtest: rcs0
[406.204278] Dynamic subtest rcs0: SUCCESS (1.032s)
[406.213120] Starting dynamic subtest: bcs0
[407.292701] Dynamic subtest bcs0: SUCCESS (1.086s)
[407.302273] Starting dynamic subtest: vcs0
[408.381129] Dynamic subtest vcs0: SUCCESS (1.086s)
[408.395982] Starting dynamic subtest: vcs1
[409.468978] Dynamic subtest vcs1: SUCCESS (1.086s)
[409.481585] Starting dynamic subtest: vecs0
[410.556628] Dynamic subtest vecs0: SUCCESS (1.084s)
[410.569520] Starting dynamic subtest: ccs0
[411.644951] Dynamic subtest ccs0: SUCCESS (1.086s)
[411.646254] Subtest exec-single-timeline: SUCCESS (6.475s)
[411.838174] [104/133] (617s left) api_intel_bb (reset-flags)
[411.889429] Starting subtest: reset-flags
[411.898831] Subtest reset-flags: SUCCESS (0.010s)
[412.007502] [105/133] (616s left) gem_request_retire (retire-vma-not-inactive)
[412.070629] Starting subtest: retire-vma-not-inactive
[412.133376] Subtest retire-vma-not-inactive: SUCCESS (0.061s)
[412.234269] [106/133] (616s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[412.342849] Starting subtest: fbcpsr-tiling-y
[412.344563] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[412.439869] [107/133] (616s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[412.521338] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[412.522873] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[412.590630] [108/133] (616s left) syncobj_wait (wait-all-delayed-signal)
[412.644026] Starting subtest: wait-all-delayed-signal
[412.747241] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[412.820869] [109/133] (616s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[412.914232] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[412.915820] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[413.013476] [110/133] (616s left) gem_exec_reloc (basic-wc-gtt)
[413.072326] Subtest basic-wc-gtt: SKIP (0.000s)
[413.132803] [111/133] (616s left) gem_exec_balancer (full-pulse)
[413.194379] Starting subtest: full-pulse
[417.864865] Subtest full-pulse: SUCCESS (4.670s)
[418.178477] [112/133] (611s left) i915_query (query-regions-sanity-check)
[418.227543] Starting subtest: query-regions-sanity-check
[418.247194] Subtest query-regions-sanity-check: SUCCESS (0.019s)
[418.374157] [113/133] (610s left) kms_cursor_crc (cursor-random-256x256)
[418.621296] Starting subtest: cursor-random-256x256
[418.624592] Starting dynamic subtest: pipe-A-eDP-1
[422.013792] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.388s)
[422.063715] Starting dynamic subtest: pipe-D-eDP-1
[426.008059] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.952s)
[426.008911] Subtest cursor-random-256x256: SUCCESS (7.386s)
[426.853150] [114/133] (602s left) gem_ctx_exec (basic-invalid-context)
[426.902617] Starting subtest: basic-invalid-context
[426.906706] Subtest basic-invalid-context: SUCCESS (0.005s)
[427.014927] [115/133] (602s left) drm_read (short-buffer-block)
[427.168476] Starting subtest: short-buffer-block
[427.169596] Subtest short-buffer-block: SUCCESS (0.000s)
[427.293182] [116/133] (602s left) syncobj_timeline (wait-all-delayed-signal)
[427.351955] Starting subtest: wait-all-delayed-signal
[427.454782] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[427.530714] [117/133] (601s left) kms_invalid_mode (clock-too-high)
[427.627396] Starting subtest: clock-too-high
[427.628278] Starting dynamic subtest: pipe-A-eDP-1
[427.629837] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.638101] Starting dynamic subtest: pipe-B-eDP-1
[427.639834] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.648051] Starting dynamic subtest: pipe-C-eDP-1
[427.649750] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.657964] Starting dynamic subtest: pipe-D-eDP-1
[427.659742] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.661525] Subtest clock-too-high: SKIP (0.005s)
[427.696879] [118/133] (601s left) kms_fbcon_fbt (psr)
[427.761591] Starting subtest: psr
[435.088511] Subtest psr: SUCCESS (7.316s)
[435.152311] [119/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[435.242753] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[435.244651] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[435.348867] [120/133] (594s left) i915_pm_rpm (debugfs-forcewake-user)
[437.071248] Starting subtest: debugfs-forcewake-user
[448.462612] Subtest debugfs-forcewake-user: SUCCESS (11.393s)
[448.844284] [121/133] (580s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[449.410882] Starting subtest: syncobj-timeline-multiple-ext-nodes
[449.412315] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[450.988323] [122/133] (578s left) prime_vgem (fence-flip-hang)
[451.060198] Subtest fence-flip-hang: SKIP (0.000s)
[451.172838] [123/133] (578s left) gem_mmap_gtt (fault-concurrent-y)
[451.228623] Subtest fault-concurrent-Y: SKIP (0.000s)
[451.278701] [124/133] (578s left) kms_vblank (query-busy-hang)
[451.372066] Starting subtest: query-busy-hang
[451.372989] Starting dynamic subtest: pipe-A-eDP-1
[477.725922] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.352s)
[477.736723] Starting dynamic subtest: pipe-D-eDP-1
[492.698845] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.969s)
[492.699658] Subtest query-busy-hang: SUCCESS (41.326s)
[493.513614] [125/133] (536s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[493.602358] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[493.604175] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[493.695158] [126/133] (535s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[493.788442] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[493.790103] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[493.881854] [127/133] (535s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[493.966363] Starting subtest: random-ccs-data-yf-tiled-ccs
[493.967339] Starting dynamic subtest: pipe-A-eDP-1
[493.976313] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[493.984608] Starting dynamic subtest: pipe-B-eDP-1
[493.993746] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[494.001949] Starting dynamic subtest: pipe-C-eDP-1
[494.010765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[494.018774] Starting dynamic subtest: pipe-D-eDP-1
[494.027673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[494.029386] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[496.259532] [128/133] (533s left) kms_addfb_basic (bad-pitch-256)
[496.310438] Starting subtest: bad-pitch-256
[496.311305] Subtest bad-pitch-256: SUCCESS (0.000s)
[496.459768] [129/133] (533s left) gem_ccs (block-multicopy-compressed)
[496.514198] Starting subtest: block-multicopy-compressed
[496.516205] Subtest block-multicopy-compressed: SKIP (0.000s)
[496.613161] [130/133] (533s left) kms_chamelium_color (ctm-red-to-blue)
[496.708334] Subtest ctm-red-to-blue: SKIP (0.000s)
[496.750469] [131/133] (533s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[496.840826] Starting subtest: psr-rgb565-draw-mmap-wc
[503.857448] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (7.017s)
[503.970295] [132/133] (525s left) gem_exec_schedule (pi-common)
[504.150849] Starting subtest: pi-common
[504.156682] Starting dynamic subtest: rcs0
[504.169905] Dynamic subtest rcs0: SUCCESS (0.027s)
[504.182017] Starting dynamic subtest: bcs0
[504.196890] Dynamic subtest bcs0: SUCCESS (0.026s)
[504.210252] Starting dynamic subtest: vcs0
[504.222834] Dynamic subtest vcs0: SUCCESS (0.025s)
[504.235620] Starting dynamic subtest: vcs1
[504.249392] Dynamic subtest vcs1: SUCCESS (0.026s)
[504.261248] Starting dynamic subtest: vecs0
[504.275884] Dynamic subtest vecs0: SUCCESS (0.026s)
[504.287811] Starting dynamic subtest: ccs0
[504.302869] Dynamic subtest ccs0: SUCCESS (0.026s)
[504.303700] Subtest pi-common: SUCCESS (0.161s)
[504.518786] [133/133] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[504.606704] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[511.329706] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.723s)
[511.469581] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: gem_workarounds
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: gem_set_tiling_vs_blt
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_pread
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_mmap
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_color_pipeline
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: gem_ctx_bad_destroy
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: gem_fence_thrash
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: i915_pm_freq_api
results: parsing output: 31/ for test: gem_linear_blits
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_plane_alpha_blend
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_prime
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_edge_walk
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_eventfd
results: parsing output: 46/ for test: gem_ctx_param
results: parsing output: 47/ for test: gem_pxp
results: parsing output: 48/ for test: gen9_exec_parse
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: gem_busy
results: parsing output: 52/ for test: device_reset
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_psr_stress_test
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_content_protection
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_dsc
results: parsing output: 72/ for test: gem_tiled_pread_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_exec_flush
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_capture
results: parsing output: 78/ for test: gem_exec_create
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: sysfs_timeslice_duration
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: i915_drm_fdinfo
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_flip_event_leak
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_vblank
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_chamelium_hpd
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: gem_exercise_blt
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: gem_ctx_isolation
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_ctx_shared
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: gem_request_retire
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: i915_query
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: gem_ctx_exec
results: parsing output: 114/ for test: drm_read
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_invalid_mode
results: parsing output: 117/ for test: kms_fbcon_fbt
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: gem_ccs
results: parsing output: 129/ for test: kms_chamelium_color
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.