[60.307940] Initializing watchdogs
[60.308014]   /dev/watchdog0
[60.328091] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.339238] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.343244] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.345798] [001/131] (960s left) gem_exec_balancer (bonded-true-hang)
[60.748612] Starting subtest: bonded-true-hang
[60.750777] Subtest bonded-true-hang: SKIP (0.000s)
[60.901150] [002/131] (959s left) kms_psr (fbc-pr-basic)
[61.092168] Subtest fbc-pr-basic: SKIP (0.000s)
[61.141079] [003/131] (959s left) kms_content_protection (dp-mst-type-1)
[61.401410] Starting subtest: dp-mst-type-1
[61.403197] Subtest dp-mst-type-1: SKIP (0.000s)
[61.592799] [004/131] (959s left) kms_rotation_crc (exhaust-fences)
[61.773580] Starting subtest: exhaust-fences
[61.775462] Subtest exhaust-fences: SKIP (0.000s)
[61.934132] [005/131] (959s left) gem_lmem_swapping (basic)
[64.669990] Starting subtest: basic
[64.671010] Starting dynamic subtest: lmem0
[86.634339] Dynamic subtest lmem0: SUCCESS (21.965s)
[86.635307] Subtest basic: SUCCESS (21.965s)
[88.819690] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[88.821866] [006/131] (932s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[90.528612] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[90.530330] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[90.701606] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[90.704066] [007/131] (930s left) kms_cursor_crc (cursor-sliding-512x170)
[91.206791] Starting subtest: cursor-sliding-512x170
[91.209515] Subtest cursor-sliding-512x170: SKIP (0.001s)
[91.449089] [008/131] (929s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[91.531145] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[91.533525] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[91.767895] [009/131] (929s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[91.963879] Starting subtest: yf-tiled-32bpp-rotate-90
[91.966027] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[92.149115] [010/131] (929s left) perf_pmu (init-sema)
[92.219284] Starting subtest: init-sema
[92.220240] Starting dynamic subtest: rcs0
[92.222115] Dynamic subtest rcs0: SUCCESS (0.003s)
[92.230848] Starting dynamic subtest: bcs0
[92.231771] Dynamic subtest bcs0: SUCCESS (0.000s)
[92.240405] Starting dynamic subtest: vcs0
[92.241334] Dynamic subtest vcs0: SUCCESS (0.000s)
[92.250248] Starting dynamic subtest: vcs1
[92.251535] Dynamic subtest vcs1: SUCCESS (0.000s)
[92.260081] Starting dynamic subtest: vecs0
[92.261223] Dynamic subtest vecs0: SUCCESS (0.000s)
[92.269448] Starting dynamic subtest: vecs1
[92.270400] Dynamic subtest vecs1: SUCCESS (0.001s)
[92.279249] Starting dynamic subtest: ccs0
[92.280538] Dynamic subtest ccs0: SUCCESS (0.000s)
[92.281654] Subtest init-sema: SUCCESS (0.007s)
[92.378219] [011/131] (929s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[92.448351] Starting subtest: wait-all-for-submit-delayed-submit
[92.549977] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.101s)
[92.716248] [012/131] (928s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[92.788196] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[92.900688] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[93.069401] [013/131] (928s left) gen9_exec_parse (shadow-peek)
[93.152189] Subtest shadow-peek: SKIP (0.000s)
[93.227142] [014/131] (928s left) perf_pmu (busy-hang)
[93.291493] Starting subtest: busy-hang
[93.292434] Starting dynamic subtest: rcs0
[94.595570] Dynamic subtest rcs0: SUCCESS (1.302s)
[94.605701] Starting dynamic subtest: bcs0
[95.826789] Dynamic subtest bcs0: SUCCESS (1.231s)
[95.837568] Starting dynamic subtest: vcs0
[97.067865] Dynamic subtest vcs0: SUCCESS (1.240s)
[97.078911] Starting dynamic subtest: vcs1
[98.305726] Dynamic subtest vcs1: SUCCESS (1.237s)
[98.316611] Starting dynamic subtest: vecs0
[99.538674] Dynamic subtest vecs0: SUCCESS (1.232s)
[99.552820] Starting dynamic subtest: vecs1
[100.781956] Dynamic subtest vecs1: SUCCESS (1.241s)
[100.792264] Starting dynamic subtest: ccs0
[102.015045] Dynamic subtest ccs0: SUCCESS (1.232s)
[102.015990] Subtest busy-hang: SUCCESS (8.722s)
[102.183617] [015/131] (919s left) gem_exec_fence (syncobj-timeline-repeat)
[102.879143] Starting subtest: syncobj-timeline-repeat
[103.310112] Subtest syncobj-timeline-repeat: SUCCESS (0.432s)
[103.635742] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[103.637441] [016/131] (918s left) kms_plane_cursor (primary)
[103.830401] Starting subtest: primary
[103.832253] Starting dynamic subtest: pipe-A-DP-3-size-64
[107.337347] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.506s)
[107.399488] Starting dynamic subtest: pipe-A-DP-3-size-128
[110.887461] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.499s)
[110.948639] Starting dynamic subtest: pipe-A-DP-3-size-256
[114.404365] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.467s)
[114.553510] Starting dynamic subtest: pipe-B-DP-3-size-64
[118.079965] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.543s)
[118.123258] Starting dynamic subtest: pipe-B-DP-3-size-128
[121.597115] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.483s)
[121.639949] Starting dynamic subtest: pipe-B-DP-3-size-256
[125.080064] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.450s)
[125.193863] Starting dynamic subtest: pipe-C-DP-3-size-64
[128.770898] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.593s)
[128.818396] Starting dynamic subtest: pipe-C-DP-3-size-128
[132.287433] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.483s)
[132.334646] Starting dynamic subtest: pipe-C-DP-3-size-256
[135.787589] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.466s)
[135.891495] Starting dynamic subtest: pipe-D-DP-3-size-64
[139.452403] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.572s)
[139.496401] Starting dynamic subtest: pipe-D-DP-3-size-128
[142.935694] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.450s)
[142.979440] Starting dynamic subtest: pipe-D-DP-3-size-256
[146.469328] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.500s)
[146.595111] Subtest primary: SUCCESS (42.764s)
[146.930874] [017/131] (874s left) gem_exec_schedule (u-semaphore-noskip)
[147.025388] Starting subtest: u-semaphore-noskip
[147.835487] Subtest u-semaphore-noskip: SUCCESS (0.810s)
[148.228863] [018/131] (873s left) gem_mmap (bad-object)
[148.310219] Subtest bad-object: SKIP (0.000s)
[148.391881] [019/131] (873s left) kms_flip (2x-flip-vs-panning)
[148.586233] Starting subtest: 2x-flip-vs-panning
[148.602065] Subtest 2x-flip-vs-panning: SKIP (0.015s)
[148.731756] [020/131] (873s left) gem_ctx_param (set-priority-invalid-size)
[148.815446] Starting subtest: set-priority-invalid-size
[148.816372] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[148.937189] [021/131] (873s left) i915_pm_rps (reset)
[149.026929] Starting subtest: reset
[154.110233] Subtest reset: SUCCESS (5.081s)
[154.302261] [022/131] (867s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[154.504888] Starting subtest: primary-yf-tiled-reflect-x-180
[154.597405] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.091s)
[154.799212] [023/131] (867s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[154.994163] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[154.995092] Starting dynamic subtest: pipe-A-DP-3
[155.003784] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[155.014261] Starting dynamic subtest: pipe-B-DP-3
[155.023194] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[155.033496] Starting dynamic subtest: pipe-C-DP-3
[155.042054] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[155.052216] Starting dynamic subtest: pipe-D-DP-3
[155.061975] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[155.063847] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[155.482269] [024/131] (866s left) kms_cursor_crc (cursor-alpha-transparent)
[155.679973] Starting subtest: cursor-alpha-transparent
[155.680897] Starting dynamic subtest: pipe-A-DP-3
[156.288167] Dynamic subtest pipe-A-DP-3: SUCCESS (0.608s)
[156.302201] Starting dynamic subtest: pipe-D-DP-3
[156.781041] Dynamic subtest pipe-D-DP-3: SUCCESS (0.490s)
[156.782071] Subtest cursor-alpha-transparent: SUCCESS (1.101s)
[157.422449] [025/131] (865s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[157.623194] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[157.676344] [026/131] (864s left) kms_prop_blob (invalid-get-prop-any)
[157.759163] Starting subtest: invalid-get-prop-any
[157.760109] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[157.933128] [027/131] (864s left) kms_pipe_crc_basic (bad-source)
[158.127215] Starting subtest: bad-source
[158.128162] Subtest bad-source: SUCCESS (0.000s)
[158.284488] [028/131] (864s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[158.481568] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[162.333561] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (3.852s)
[162.568068] [029/131] (860s left) gem_exec_create (legacy)
[162.660775] Starting subtest: legacy
[162.661643] Starting dynamic subtest: smem
[164.758341] Dynamic subtest smem: SUCCESS (2.097s)
[164.769672] Starting dynamic subtest: lmem0
[166.854765] Dynamic subtest lmem0: SUCCESS (2.096s)
[166.855921] Subtest legacy: SUCCESS (4.194s)
[167.080579] [030/131] (855s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[167.276680] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[167.292599] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.015s)
[167.445630] [031/131] (855s left) gem_exec_nop (basic-series)
[167.551967] Starting subtest: basic-series
[171.896687] Subtest basic-series: SUCCESS (4.344s)
[172.147048] [032/131] (850s left) gem_wait (invalid-flags)
[172.230610] Starting subtest: invalid-flags
[172.231539] Subtest invalid-flags: SUCCESS (0.000s)
[172.524205] [033/131] (850s left) syncobj_wait (single-wait-for-submit-signaled)
[172.604241] Starting subtest: single-wait-for-submit-signaled
[172.605239] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[172.800483] [034/131] (850s left) gem_render_copy (y-tiled)
[172.887648] Starting subtest: y-tiled
[172.889926] Subtest y-tiled: SKIP (0.000s)
[173.115270] [035/131] (850s left) gem_fenced_exec_thrash (no-spare-fences)
[173.205343] Subtest no-spare-fences: SKIP (0.000s)
[173.276706] [036/131] (849s left) gem_softpin (evict-active-interruptible)
[173.368532] Starting subtest: evict-active-interruptible
[173.387790] Subtest evict-active-interruptible: SUCCESS (0.019s)
[173.619475] [037/131] (849s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[173.700149] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[173.701188] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[173.865448] [038/131] (849s left) gem_tiled_partial_pwrite_pread (reads)
[173.951481] Subtest reads: SKIP (0.000s)
[174.028321] [039/131] (849s left) kms_flip (flip-vs-expired-vblank-interruptible)
[174.226487] Starting subtest: flip-vs-expired-vblank-interruptible
[174.231302] Starting dynamic subtest: A-DP3
[182.081144] Dynamic subtest A-DP3: SUCCESS (7.849s)
[182.121370] Starting dynamic subtest: B-DP3
[189.838456] Dynamic subtest B-DP3: SUCCESS (7.755s)
[189.851210] Starting dynamic subtest: C-DP3
[197.588992] Dynamic subtest C-DP3: SUCCESS (7.749s)
[197.602883] Starting dynamic subtest: D-DP3
[205.335669] Dynamic subtest D-DP3: SUCCESS (7.743s)
[205.343394] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.116s)
[205.708234] [040/131] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[205.905155] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[205.906879] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[206.069842] [041/131] (817s left) i915_query (query-regions-sanity-check)
[206.156045] Starting subtest: query-regions-sanity-check
[206.180328] Subtest query-regions-sanity-check: SUCCESS (0.024s)
[206.349639] [042/131] (817s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[206.556939] Starting subtest: y-tiled-64bpp-rotate-90
[206.558734] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[206.772052] [043/131] (816s left) gem_pread (exhaustion)
[206.852060] Subtest exhaustion: SKIP (0.000s)
[206.926021] [044/131] (816s left) syncobj_timeline (invalid-signal-illegal-handle)
[207.007178] Starting subtest: invalid-signal-illegal-handle
[207.008110] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[207.140478] [045/131] (816s left) syncobj_wait (wait-any-snapshot)
[207.226775] Starting subtest: wait-any-snapshot
[207.308922] Subtest wait-any-snapshot: SUCCESS (0.082s)
[207.471636] [046/131] (816s left) kms_properties (crtc-properties-atomic)
[207.666294] Starting subtest: crtc-properties-atomic
[207.667251] Starting dynamic subtest: pipe-A-DP-3
[208.007408] Dynamic subtest pipe-A-DP-3: SUCCESS (0.339s)
[208.020545] Starting dynamic subtest: pipe-B-DP-3
[208.350985] Dynamic subtest pipe-B-DP-3: SUCCESS (0.343s)
[208.362203] Starting dynamic subtest: pipe-C-DP-3
[208.707868] Dynamic subtest pipe-C-DP-3: SUCCESS (0.355s)
[208.718763] Starting dynamic subtest: pipe-D-DP-3
[209.046163] Dynamic subtest pipe-D-DP-3: SUCCESS (0.337s)
[209.047179] Subtest crtc-properties-atomic: SUCCESS (1.380s)
[209.351852] [047/131] (814s left) kms_invalid_mode (bad-vsync-end)
[209.547144] Starting subtest: bad-vsync-end
[209.548055] Starting dynamic subtest: pipe-A-DP-3
[209.626646] Dynamic subtest pipe-A-DP-3: SUCCESS (0.078s)
[209.638959] Starting dynamic subtest: pipe-B-DP-3
[209.640071] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[209.652165] Starting dynamic subtest: pipe-C-DP-3
[209.653163] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[209.665009] Starting dynamic subtest: pipe-D-DP-3
[209.665922] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[209.666875] Subtest bad-vsync-end: SUCCESS (0.086s)
[209.909575] [048/131] (814s left) gen7_exec_parse (chained-batch)
[209.995949] Subtest chained-batch: SKIP (0.000s)
[210.084611] [049/131] (813s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[210.280936] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[210.282765] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[210.476424] [050/131] (813s left) kms_prop_blob (invalid-set-prop)
[210.556361] Starting subtest: invalid-set-prop
[210.557338] Subtest invalid-set-prop: SUCCESS (0.000s)
[210.695904] [051/131] (813s left) gem_ctx_sseu (mmap-args)
[210.783330] Subtest mmap-args: SKIP (0.000s)
[210.849605] [052/131] (813s left) gem_exec_reloc (basic-wc-read-noreloc)
[210.939065] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[211.018835] [053/131] (813s left) gem_mmap_offset (bad-object)
[211.105386] Starting subtest: bad-object
[211.106483] Subtest bad-object: SUCCESS (0.000s)
[211.290780] [054/131] (813s left) gem_ctx_persistence (engines-persistence)
[211.380371] Starting subtest: engines-persistence
[211.381293] Starting dynamic subtest: rcs0
[212.226414] Dynamic subtest rcs0: SUCCESS (0.846s)
[212.239545] Starting dynamic subtest: bcs0
[213.000690] Dynamic subtest bcs0: SUCCESS (0.773s)
[213.014676] Starting dynamic subtest: vcs0
[213.764478] Dynamic subtest vcs0: SUCCESS (0.763s)
[213.777557] Starting dynamic subtest: vcs1
[214.542551] Dynamic subtest vcs1: SUCCESS (0.776s)
[214.556931] Starting dynamic subtest: vecs0
[215.298465] Dynamic subtest vecs0: SUCCESS (0.754s)
[215.311367] Starting dynamic subtest: vecs1
[216.049302] Dynamic subtest vecs1: SUCCESS (0.750s)
[216.061549] Starting dynamic subtest: ccs0
[216.837387] Dynamic subtest ccs0: SUCCESS (0.786s)
[216.839412] Subtest engines-persistence: SUCCESS (5.458s)
[217.072900] [055/131] (807s left) syncobj_wait (multi-wait-all-submitted)
[217.152471] Starting subtest: multi-wait-all-submitted
[217.254664] Subtest multi-wait-all-submitted: SUCCESS (0.101s)
[217.437804] [056/131] (807s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[217.632807] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[217.633729] Starting dynamic subtest: pipe-A-valid-mode
[219.384303] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.748s)
[219.385825] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SUCCESS (1.750s)
[219.695331] [057/131] (804s left) kms_psr (psr-cursor-render)
[219.888747] Subtest psr-cursor-render: SKIP (0.000s)
[219.954381] [058/131] (804s left) kms_atomic (plane-immutable-zpos)
[220.148515] Starting subtest: plane-immutable-zpos
[220.150602] Starting dynamic subtest: pipe-A-DP-3
[221.101860] Dynamic subtest pipe-A-DP-3: SUCCESS (0.951s)
[221.102787] Subtest plane-immutable-zpos: SUCCESS (0.952s)
[221.448841] [059/131] (803s left) api_intel_allocator (reopen)
[221.528357] Starting subtest: reopen
[221.560558] Subtest reopen: SUCCESS (0.032s)
[221.798380] [060/131] (803s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[222.004588] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[222.006437] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[222.163467] [061/131] (802s left) kms_async_flips (async-flip-hang)
[222.356779] Starting subtest: async-flip-hang
[222.578514] Starting dynamic subtest: pipe-A-DP-3
[237.491472] Dynamic subtest pipe-A-DP-3: SUCCESS (14.912s)
[237.706567] Starting dynamic subtest: pipe-B-DP-3
[252.493427] Dynamic subtest pipe-B-DP-3: SUCCESS (14.797s)
[252.665072] Starting dynamic subtest: pipe-C-DP-3
[277.507504] Dynamic subtest pipe-C-DP-3: SUCCESS (24.852s)
[277.689274] Starting dynamic subtest: pipe-D-DP-3
[302.541468] Dynamic subtest pipe-D-DP-3: SUCCESS (24.860s)
[302.542415] Subtest async-flip-hang: SUCCESS (80.183s)
[303.025045] [062/131] (722s left) gem_pipe_control_store_loop (reused-buffer)
[303.115487] Starting subtest: reused-buffer
[305.294069] Subtest reused-buffer: SUCCESS (2.178s)
[305.492461] [063/131] (719s left) gem_exec_fence (invalid-fence-array)
[306.113151] Starting subtest: invalid-fence-array
[306.116483] Subtest invalid-fence-array: SUCCESS (0.002s)
[306.522875] [064/131] (718s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[306.719270] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[306.723918] Starting dynamic subtest: A-DP3
[307.742184] Dynamic subtest A-DP3: SUCCESS (1.015s)
[307.765833] Starting dynamic subtest: B-DP3
[308.506163] Dynamic subtest B-DP3: SUCCESS (0.763s)
[308.530048] Starting dynamic subtest: C-DP3
[309.282063] Dynamic subtest C-DP3: SUCCESS (0.773s)
[309.301917] Starting dynamic subtest: D-DP3
[310.069053] Dynamic subtest D-DP3: SUCCESS (0.785s)
[310.071624] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.352s)
[310.401356] [065/131] (714s left) syncobj_timeline (single-wait-available-submitted)
[310.483437] Starting subtest: single-wait-available-submitted
[310.484439] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[310.624895] [066/131] (714s left) kms_chamelium_frames (hdmi-crc-single)
[310.893798] Subtest hdmi-crc-single: SKIP (0.000s)
[311.043486] [067/131] (714s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[311.247199] Starting subtest: x-tiled-8bpp-rotate-180
[312.899922] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.653s)
[313.150793] [068/131] (712s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[313.346127] Starting subtest: psr-rgb101010-draw-render
[313.347918] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[313.541143] [069/131] (712s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[316.146467] Starting subtest: verify-pxp-stale-buf-optout-execution
[316.148541] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[316.302023] [070/131] (709s left) kms_vblank (ts-continuation-modeset-hang)
[316.504855] Starting subtest: ts-continuation-modeset-hang
[316.507202] Starting dynamic subtest: pipe-A-DP-3
[342.596969] Dynamic subtest pipe-A-DP-3: SUCCESS (26.090s)
[342.611329] Starting dynamic subtest: pipe-D-DP-3
[367.544968] Dynamic subtest pipe-D-DP-3: SUCCESS (24.944s)
[367.545935] Subtest ts-continuation-modeset-hang: SUCCESS (51.040s)
[367.811705] [071/131] (657s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[367.897231] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[367.972329] [072/131] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[368.168886] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[368.170515] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[368.378953] [073/131] (657s left) kms_pwrite_crc
[369.548399] [074/131] (656s left) gem_softpin (evict-snoop-interruptible)
[369.636820] Starting subtest: evict-snoop-interruptible
[369.638570] Subtest evict-snoop-interruptible: SKIP (0.000s)
[369.824027] [075/131] (656s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[370.020395] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[370.021294] Starting dynamic subtest: pipe-A-DP-3
[370.029858] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[370.040988] Starting dynamic subtest: pipe-B-DP-3
[370.049681] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[370.060376] Starting dynamic subtest: pipe-C-DP-3
[370.068963] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[370.079662] Starting dynamic subtest: pipe-D-DP-3
[370.088500] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[370.090087] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[370.473347] [076/131] (655s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[370.679407] Starting subtest: y-tiled-16bpp-rotate-0
[370.681208] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[370.888865] [077/131] (655s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[370.977498] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[370.978437] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[371.154201] [078/131] (655s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[371.346903] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[371.349397] Starting dynamic subtest: pipe-A-DP-3
[371.922460] Dynamic subtest pipe-A-DP-3: SUCCESS (0.571s)
[371.933361] Starting dynamic subtest: pipe-B-DP-3
[372.604991] Dynamic subtest pipe-B-DP-3: SUCCESS (0.681s)
[372.616130] Starting dynamic subtest: pipe-C-DP-3
[373.287937] Dynamic subtest pipe-C-DP-3: SUCCESS (0.681s)
[373.299007] Starting dynamic subtest: pipe-D-DP-3
[373.954137] Dynamic subtest pipe-D-DP-3: SUCCESS (0.664s)
[373.955140] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SUCCESS (2.604s)
[374.290025] [079/131] (652s left) i915_hangman (detector)
[374.388688] Starting subtest: detector
[374.389576] Starting dynamic subtest: rcs0
[384.204973] Dynamic subtest rcs0: SUCCESS (9.816s)
[384.217850] Starting dynamic subtest: bcs0
[394.156385] Dynamic subtest bcs0: SUCCESS (9.950s)
[394.167776] Starting dynamic subtest: vcs0
[404.193398] Dynamic subtest vcs0: SUCCESS (10.036s)
[404.206175] Starting dynamic subtest: vcs1
[414.171599] Dynamic subtest vcs1: SUCCESS (9.977s)
[414.184157] Starting dynamic subtest: vecs0
[424.200543] Dynamic subtest vecs0: SUCCESS (10.028s)
[424.215755] Starting dynamic subtest: vecs1
[434.211190] Dynamic subtest vecs1: SUCCESS (10.009s)
[434.223816] Starting dynamic subtest: ccs0
[444.195420] Dynamic subtest ccs0: SUCCESS (9.983s)
[444.196370] Subtest detector: SUCCESS (69.807s)
[444.375248] [080/131] (582s left) gem_spin_batch (resubmit-new)
[444.473501] Starting subtest: resubmit-new
[444.474433] Starting dynamic subtest: rcs0
[444.511470] Dynamic subtest rcs0: SUCCESS (0.037s)
[444.524554] Starting dynamic subtest: bcs0
[444.525431] Dynamic subtest bcs0: SUCCESS (0.005s)
[444.536833] Starting dynamic subtest: vcs0
[444.537735] Dynamic subtest vcs0: SUCCESS (0.005s)
[444.549265] Starting dynamic subtest: vcs1
[444.550222] Dynamic subtest vcs1: SUCCESS (0.005s)
[444.561488] Starting dynamic subtest: vecs0
[444.562532] Dynamic subtest vecs0: SUCCESS (0.005s)
[444.573512] Starting dynamic subtest: vecs1
[444.574553] Dynamic subtest vecs1: SUCCESS (0.007s)
[444.585520] Starting dynamic subtest: ccs0
[444.586766] Dynamic subtest ccs0: SUCCESS (0.007s)
[444.587804] Subtest resubmit-new: SUCCESS (0.079s)
[444.829919] [081/131] (581s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[444.917216] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[445.000446] [082/131] (581s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[445.198829] Starting subtest: stress-xrgb8888-xtiled
[452.928244] Subtest stress-xrgb8888-xtiled: SUCCESS (7.729s)
[453.207666] [083/131] (573s left) kms_joiner (invalid-modeset-ultra-joiner)
[453.405729] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[453.526417] [084/131] (573s left) gem_lmem_swapping (random-engines)
[456.227274] Starting subtest: random-engines
[456.228193] Starting dynamic subtest: lmem0
[457.260978] Dynamic subtest lmem0: SUCCESS (1.034s)
[457.261930] Subtest random-engines: SUCCESS (1.035s)
[460.287939] [FACT gem_lmem_swapping (random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[460.288993] [FACT gem_lmem_swapping (random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[460.290957] [085/131] (566s left) gem_exec_schedule (independent)
[461.904673] Starting subtest: independent
[461.905435] Starting dynamic subtest: rcs0
[462.349364] Dynamic subtest rcs0: SUCCESS (0.445s)
[462.362141] Starting dynamic subtest: bcs0
[462.735410] Dynamic subtest bcs0: SUCCESS (0.385s)
[462.747522] Starting dynamic subtest: vcs0
[463.164936] Dynamic subtest vcs0: SUCCESS (0.428s)
[463.182663] Starting dynamic subtest: vcs1
[463.566507] Dynamic subtest vcs1: SUCCESS (0.398s)
[463.585362] Starting dynamic subtest: vecs0
[464.006556] Dynamic subtest vecs0: SUCCESS (0.438s)
[464.019145] Starting dynamic subtest: vecs1
[464.394948] Dynamic subtest vecs1: SUCCESS (0.386s)
[464.411385] Starting dynamic subtest: ccs0
[464.745493] Dynamic subtest ccs0: SUCCESS (0.348s)
[464.746502] Subtest independent: SUCCESS (2.843s)
[465.103634] [FACT gem_exec_schedule (independent)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[465.106017] [FACT gem_exec_schedule (independent)] new: kernel.kmod_is_loaded.i915: true
[465.108799] [086/131] (561s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[465.313428] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[465.315200] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[465.510012] [087/131] (561s left) gem_exec_flush (basic-wb-set-default)
[465.602507] Subtest basic-wb-set-default: SKIP (0.000s)
[465.689505] [088/131] (561s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[465.973319] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[466.127359] [089/131] (560s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[466.322583] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[466.384254] [090/131] (560s left) gem_vm_create (invalid-create)
[466.471949] Starting subtest: invalid-create
[466.476782] Subtest invalid-create: SUCCESS (0.005s)
[466.653025] [091/131] (560s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[466.851480] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[466.853162] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[467.032808] [092/131] (560s left) kms_psr (fbc-psr-primary-mmap-cpu)
[467.224400] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[467.283567] [093/131] (559s left) kms_vblank (query-idle)
[467.478421] Starting subtest: query-idle
[467.479313] Starting dynamic subtest: pipe-A-DP-3
[469.781612] Dynamic subtest pipe-A-DP-3: SUCCESS (2.302s)
[469.798288] Starting dynamic subtest: pipe-D-DP-3
[472.028138] Dynamic subtest pipe-D-DP-3: SUCCESS (2.240s)
[472.029026] Subtest query-idle: SUCCESS (4.550s)
[472.246129] [094/131] (555s left) gem_softpin (noreloc)
[472.346545] Starting subtest: noreloc
[477.849927] Subtest noreloc: SUCCESS (5.503s)
[478.016135] [095/131] (549s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[478.209991] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[478.210977] Starting dynamic subtest: pipe-A
[478.762476] Dynamic subtest pipe-A: SUCCESS (0.552s)
[478.804999] Starting dynamic subtest: pipe-B
[479.427652] Dynamic subtest pipe-B: SUCCESS (0.662s)
[479.441453] Starting dynamic subtest: pipe-C
[480.061656] Dynamic subtest pipe-C: SUCCESS (0.632s)
[480.090610] Starting dynamic subtest: pipe-D
[480.743155] Dynamic subtest pipe-D: SUCCESS (0.679s)
[480.744158] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (2.534s)
[481.095114] [096/131] (546s left) gem_ctx_persistence (legacy-engines-persistence)
[481.185348] Starting subtest: legacy-engines-persistence
[481.186293] Starting dynamic subtest: render
[482.064991] Dynamic subtest render: SUCCESS (0.878s)
[482.082211] Starting dynamic subtest: bsd1
[482.882591] Dynamic subtest bsd1: SUCCESS (0.814s)
[482.897112] Starting dynamic subtest: bsd2
[483.672293] Dynamic subtest bsd2: SUCCESS (0.786s)
[483.686504] Starting dynamic subtest: blt
[484.497434] Dynamic subtest blt: SUCCESS (0.820s)
[484.511553] Starting dynamic subtest: vebox
[485.321581] Dynamic subtest vebox: SUCCESS (0.819s)
[485.326843] Subtest legacy-engines-persistence: SUCCESS (4.138s)
[485.521242] [097/131] (542s left) prime_busy (hang)
[485.607947] Starting subtest: hang
[485.610354] Starting dynamic subtest: rcs0
[511.464764] Dynamic subtest rcs0: SUCCESS (25.854s)
[511.474953] Starting dynamic subtest: bcs0
[518.627913] Dynamic subtest bcs0: SUCCESS (7.162s)
[518.638227] Starting dynamic subtest: vcs0
[525.605880] Dynamic subtest vcs0: SUCCESS (6.977s)
[525.616155] Starting dynamic subtest: vcs1
[532.642666] Dynamic subtest vcs1: SUCCESS (7.036s)
[532.652880] Starting dynamic subtest: vecs0
[539.621942] Dynamic subtest vecs0: SUCCESS (6.977s)
[539.632402] Starting dynamic subtest: vecs1
[546.652943] Dynamic subtest vecs1: SUCCESS (7.031s)
[546.663135] Starting dynamic subtest: ccs0
[560.495375] Dynamic subtest ccs0: SUCCESS (13.841s)
[560.496311] Subtest hang: SUCCESS (74.887s)
[560.715470] [098/131] (466s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[560.907444] Starting subtest: short-busy-flip-before-cursor-toggle
[560.909277] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[561.063355] [099/131] (466s left) kms_feature_discovery (display)
[561.256839] Starting subtest: display
[561.257719] Subtest display: SUCCESS (0.000s)
[561.410822] [100/131] (466s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[561.498507] Starting subtest: multi-wait-all-for-submit-unsubmitted
[561.606806] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[561.776987] [101/131] (466s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[561.978508] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[561.980183] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[562.154342] [102/131] (465s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[562.356480] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[562.358226] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[562.561466] [103/131] (465s left) kms_addfb_basic (small-bo)
[562.757396] Starting subtest: small-bo
[562.758330] Subtest small-bo: SUCCESS (0.000s)
[562.939145] [104/131] (465s left) api_intel_bb (object-reloc-purge-cache)
[563.019650] Starting subtest: object-reloc-purge-cache
[563.024046] Subtest object-reloc-purge-cache: SKIP (0.003s)
[563.179860] [105/131] (464s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[563.379903] Starting subtest: fbcpsr-rgb101010-draw-blt
[563.381575] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[563.549875] [106/131] (464s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[563.743464] Starting subtest: basic-flip-after-cursor-varying-size
[564.771660] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.027s)
[565.140797] [107/131] (463s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[565.342419] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[565.344272] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[565.528997] [108/131] (462s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[565.726466] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[565.727399] Starting dynamic subtest: pipe-A-valid-mode
[567.503073] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.776s)
[567.504566] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SUCCESS (1.779s)
[567.830665] [109/131] (460s left) gem_exec_whisper (basic-contexts)
[567.921930] Starting subtest: basic-contexts
[577.982190] Subtest basic-contexts: SUCCESS (10.053s)
[578.271449] [110/131] (450s left) kms_chamelium_color (ctm-max)
[578.461192] Subtest ctm-max: SKIP (0.000s)
[578.520554] [111/131] (450s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[578.718533] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[578.719433] Starting dynamic subtest: pipe-A-DP-3
[578.723054] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[578.733523] Starting dynamic subtest: pipe-B-DP-3
[578.737171] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[578.747374] Starting dynamic subtest: pipe-C-DP-3
[578.750991] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[578.761136] Starting dynamic subtest: pipe-D-DP-3
[578.764634] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[578.766334] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.008s)
[579.174642] [112/131] (449s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[579.375379] Starting subtest: cursor-vs-flip-varying-size
[612.768309] Subtest cursor-vs-flip-varying-size: SUCCESS (33.393s)
[613.031090] [113/131] (415s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[613.230646] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[613.232388] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[613.425253] [114/131] (415s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[613.624780] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[613.626418] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[613.814493] [115/131] (415s left) kms_pm_backlight (bad-brightness)
[614.004913] Subtest bad-brightness: SKIP (0.000s)
[614.074648] [116/131] (414s left) kms_getfb (getfb2-handle-zero)
[614.270462] Starting subtest: getfb2-handle-zero
[614.271393] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[614.495857] [117/131] (414s left) kms_pm_rpm (modeset-lpsp)
[616.017426] Starting subtest: modeset-lpsp
[616.430114] Subtest modeset-lpsp: SKIP (0.407s)
[616.885452] [118/131] (412s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[617.086540] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[617.088274] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[617.264510] [119/131] (412s left) gem_close_race (multigpu-basic-process)
[617.387583] Starting subtest: multigpu-basic-process
[617.389524] Subtest multigpu-basic-process: SKIP (0.000s)
[617.716391] [120/131] (411s left) gem_ctx_param (invalid-ctx-set)
[617.795939] Starting subtest: invalid-ctx-set
[617.798374] Subtest invalid-ctx-set: SUCCESS (0.001s)
[617.950989] [121/131] (411s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[618.153493] Starting subtest: 4-tiled-32bpp-rotate-0
[619.935855] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.782s)
[620.187463] [122/131] (409s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[620.385492] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[622.820742] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.435s)
[623.072131] [123/131] (406s left) kms_psr (psr2-cursor-mmap-gtt)
[623.265604] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[623.332066] [124/131] (406s left) kms_cursor_crc (cursor-onscreen-512x512)
[623.812545] Starting subtest: cursor-onscreen-512x512
[623.815839] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[624.091601] [125/131] (405s left) dmabuf (all-tests)
[624.141429] Starting subtest: all-tests
[624.142365] Starting dynamic subtest: sanitycheck
[624.263053] Dynamic subtest sanitycheck: SUCCESS (0.120s)
[624.283635] Starting dynamic subtest: dma_fence
[624.510862] Dynamic subtest dma_fence: SUCCESS (0.237s)
[624.549906] Starting dynamic subtest: dma_fence_chain
[634.503555] Dynamic subtest dma_fence_chain: SUCCESS (9.992s)
[634.522160] Starting dynamic subtest: dma_fence_unwrap
[634.601379] Dynamic subtest dma_fence_unwrap: SUCCESS (0.094s)
[634.626803] Starting dynamic subtest: dma_resv
[634.696966] Dynamic subtest dma_resv: SUCCESS (0.092s)
[634.701426] Subtest all-tests: SUCCESS (10.557s)
[634.850579] [126/131] (394s left) sysfs_heartbeat_interval (invalid)
[634.939522] Starting subtest: invalid
[634.941985] Starting dynamic subtest: vecs0
[634.942960] Dynamic subtest vecs0: SUCCESS (0.000s)
[634.953559] Starting dynamic subtest: ccs0
[634.954644] Dynamic subtest ccs0: SUCCESS (0.000s)
[634.965498] Starting dynamic subtest: vcs0
[634.966763] Dynamic subtest vcs0: SUCCESS (0.000s)
[634.977686] Starting dynamic subtest: bcs0
[634.978893] Dynamic subtest bcs0: SUCCESS (0.000s)
[634.989570] Starting dynamic subtest: vecs1
[634.990779] Dynamic subtest vecs1: SUCCESS (0.000s)
[635.001236] Starting dynamic subtest: rcs0
[635.002652] Dynamic subtest rcs0: SUCCESS (0.000s)
[635.015896] Starting dynamic subtest: vcs1
[635.017134] Dynamic subtest vcs1: SUCCESS (0.000s)
[635.018255] Subtest invalid: SUCCESS (0.010s)
[635.066391] [127/131] (394s left) fbdev (unaligned-read)
[635.121396] Starting subtest: unaligned-read
[635.135772] Subtest unaligned-read: SUCCESS (0.014s)
[635.291458] [128/131] (394s left) kms_big_fb (linear-8bpp-rotate-90)
[635.494591] Starting subtest: linear-8bpp-rotate-90
[635.558134] Subtest linear-8bpp-rotate-90: SKIP (0.060s)
[635.811184] [129/131] (394s left) kms_flip (blocking-wf_vblank)
[636.010214] Starting subtest: blocking-wf_vblank
[636.015288] Starting dynamic subtest: A-DP3
[644.160118] Dynamic subtest A-DP3: SUCCESS (8.144s)
[644.173911] Starting dynamic subtest: B-DP3
[652.217119] Dynamic subtest B-DP3: SUCCESS (8.055s)
[652.230176] Starting dynamic subtest: C-DP3
[660.268974] Dynamic subtest C-DP3: SUCCESS (8.050s)
[660.282513] Starting dynamic subtest: D-DP3
[668.312353] Dynamic subtest D-DP3: SUCCESS (8.042s)
[668.314727] Subtest blocking-wf_vblank: SUCCESS (32.304s)
[668.637804] [130/131] (361s left) gem_mmap_wc (invalid-flags)
[668.719162] Subtest invalid-flags: SKIP (0.000s)
[668.796694] [131/131] (361s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[668.993090] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[668.994924] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[669.144235] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: kms_rotation_crc
results: parsing output: 4/ for test: gem_lmem_swapping
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: kms_plane_cursor
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: gem_mmap
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_prop_blob
results: parsing output: 26/ for test: kms_pipe_crc_basic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_create
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_exec_nop
results: parsing output: 31/ for test: gem_wait
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: gem_fenced_exec_thrash
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: i915_query
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_pread
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_properties
results: parsing output: 46/ for test: kms_invalid_mode
results: parsing output: 47/ for test: gen7_exec_parse
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_prop_blob
results: parsing output: 50/ for test: gem_ctx_sseu
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: gem_mmap_offset
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_atomic
results: parsing output: 58/ for test: api_intel_allocator
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_async_flips
results: parsing output: 61/ for test: gem_pipe_control_store_loop
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_chamelium_frames
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_pxp
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_psr_stress_test
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_pwrite_crc
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: i915_hangman
results: parsing output: 79/ for test: gem_spin_batch
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_pipe_stress
results: parsing output: 82/ for test: kms_joiner
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: kms_chamelium_hpd
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_vm_create
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: prime_busy
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_feature_discovery
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_pm_backlight
results: parsing output: 115/ for test: kms_getfb
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_close_race
results: parsing output: 119/ for test: gem_ctx_param
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: dmabuf
results: parsing output: 125/ for test: sysfs_heartbeat_interval
results: parsing output: 126/ for test: fbdev
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.