[69.228208] Initializing watchdogs
[69.228275]   /dev/watchdog0
[69.249015] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[69.261051] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[69.264873] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.267279] [001/131] (960s left) kms_flip (2x-dpms-vs-vblank-race)
[69.455063] Starting subtest: 2x-dpms-vs-vblank-race
[69.470676] Subtest 2x-dpms-vs-vblank-race: SKIP (0.015s)
[69.636336] [002/131] (960s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[69.820747] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[69.873733] [003/131] (960s left) prime_busy (after)
[69.953055] Starting subtest: after
[69.957616] Starting dynamic subtest: rcs0
[70.035048] Dynamic subtest rcs0: SUCCESS (0.077s)
[70.043640] Starting dynamic subtest: bcs0
[70.074068] Dynamic subtest bcs0: SUCCESS (0.039s)
[70.082426] Starting dynamic subtest: vcs0
[70.115141] Dynamic subtest vcs0: SUCCESS (0.041s)
[70.137075] Starting dynamic subtest: vcs1
[70.159240] Dynamic subtest vcs1: SUCCESS (0.043s)
[70.182217] Starting dynamic subtest: vecs0
[70.203671] Dynamic subtest vecs0: SUCCESS (0.044s)
[70.214779] Starting dynamic subtest: vecs1
[70.244358] Dynamic subtest vecs1: SUCCESS (0.040s)
[70.256573] Starting dynamic subtest: ccs0
[70.291339] Dynamic subtest ccs0: SUCCESS (0.046s)
[70.413294] Subtest after: SUCCESS (0.451s)
[70.596495] [004/131] (959s left) gem_exec_balancer (bonded-chain)
[70.689291] Starting subtest: bonded-chain
[84.593844] Subtest bonded-chain: SUCCESS (13.910s)
[85.010463] [005/131] (945s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[85.195799] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[85.197586] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[85.392196] [006/131] (944s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[85.591379] Starting subtest: x-tiled-64bpp-rotate-90
[85.664625] Subtest x-tiled-64bpp-rotate-90: SKIP (0.073s)
[85.873536] [007/131] (944s left) kms_vblank (accuracy-idle)
[86.055170] Starting subtest: accuracy-idle
[86.057249] Starting dynamic subtest: pipe-A-DP-3
[88.402441] Dynamic subtest pipe-A-DP-3: SUCCESS (2.344s)
[88.423318] Starting dynamic subtest: pipe-D-DP-3
[90.680942] Dynamic subtest pipe-D-DP-3: SUCCESS (2.270s)
[90.682071] Subtest accuracy-idle: SUCCESS (4.625s)
[90.966666] [008/131] (939s left) kms_cursor_crc (cursor-onscreen-128x42)
[91.367166] Starting subtest: cursor-onscreen-128x42
[91.370123] Starting dynamic subtest: pipe-A-DP-3
[94.119883] Dynamic subtest pipe-A-DP-3: SUCCESS (2.749s)
[94.169882] Starting dynamic subtest: pipe-D-DP-3
[96.886425] Dynamic subtest pipe-D-DP-3: SUCCESS (2.724s)
[96.887427] Subtest cursor-onscreen-128x42: SUCCESS (5.520s)
[97.369370] [009/131] (932s left) kms_chamelium_frames (hdmi-aspect-ratio)
[97.666597] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[97.815297] [010/131] (932s left) gem_ctx_param (invalid-get-ringsize)
[97.888404] Starting subtest: invalid-get-ringsize
[97.890371] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[98.050276] [011/131] (932s left) kms_psr (psr-primary-page-flip)
[98.234779] Subtest psr-primary-page-flip: SKIP (0.000s)
[98.286730] [012/131] (932s left) i915_query (test-query-geometry-subslices)
[98.357965] Starting subtest: test-query-geometry-subslices
[98.359033] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[98.530082] [013/131] (932s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[98.713565] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[98.715243] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[98.884180] [014/131] (931s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[98.961635] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[98.963430] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[99.220393] [015/131] (931s left) syncobj_timeline (wait-for-submit-snapshot)
[99.290394] Starting subtest: wait-for-submit-snapshot
[99.375862] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[99.543250] [016/131] (931s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[99.736439] Starting subtest: y-tiled-32bpp-rotate-270
[99.738202] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[99.899615] [017/131] (931s left) kms_plane (plane-position-hole-dpms)
[100.080776] Starting subtest: plane-position-hole-dpms
[100.534831] Starting dynamic subtest: pipe-A-plane-1
[101.206437] Dynamic subtest pipe-A-plane-1: SUCCESS (0.673s)
[101.218352] Starting dynamic subtest: pipe-A-plane-2
[101.880417] Dynamic subtest pipe-A-plane-2: SUCCESS (0.673s)
[101.889394] Starting dynamic subtest: pipe-A-plane-3
[102.570071] Dynamic subtest pipe-A-plane-3: SUCCESS (0.689s)
[102.580171] Starting dynamic subtest: pipe-A-plane-4
[103.291688] Dynamic subtest pipe-A-plane-4: SUCCESS (0.722s)
[103.301227] Starting dynamic subtest: pipe-A-plane-5
[103.313407] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s)
[103.673535] Starting dynamic subtest: pipe-B-plane-1
[104.291561] Dynamic subtest pipe-B-plane-1: SUCCESS (0.626s)
[104.300117] Starting dynamic subtest: pipe-B-plane-2
[104.919514] Dynamic subtest pipe-B-plane-2: SUCCESS (0.628s)
[104.928358] Starting dynamic subtest: pipe-B-plane-3
[105.577295] Dynamic subtest pipe-B-plane-3: SUCCESS (0.657s)
[105.585952] Starting dynamic subtest: pipe-B-plane-4
[106.223879] Dynamic subtest pipe-B-plane-4: SUCCESS (0.647s)
[106.232447] Starting dynamic subtest: pipe-B-plane-5
[106.246194] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s)
[106.247116] Subtest plane-position-hole-dpms: SUCCESS (6.164s)
[106.486179] [018/131] (924s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[106.562193] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[106.563218] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[106.718010] [019/131] (924s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[106.900986] Starting subtest: basic-flip-after-cursor-varying-size
[107.933248] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.032s)
[108.277450] [020/131] (922s left) syncobj_wait (multi-wait-all-submitted-signaled)
[108.350225] Starting subtest: multi-wait-all-submitted-signaled
[108.454512] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[108.570892] [021/131] (922s left) gem_ctx_persistence (engines-queued)
[108.648913] Starting subtest: engines-queued
[108.649868] Starting dynamic subtest: rcs0
[108.767359] Dynamic subtest rcs0: SUCCESS (0.118s)
[108.780391] Starting dynamic subtest: bcs0
[108.806394] Dynamic subtest bcs0: SUCCESS (0.039s)
[108.819857] Starting dynamic subtest: vcs0
[108.866430] Dynamic subtest vcs0: SUCCESS (0.060s)
[108.875887] Starting dynamic subtest: vcs1
[108.932384] Dynamic subtest vcs1: SUCCESS (0.065s)
[108.947367] Starting dynamic subtest: vecs0
[109.008665] Dynamic subtest vecs0: SUCCESS (0.075s)
[109.025022] Starting dynamic subtest: vecs1
[109.069510] Dynamic subtest vecs1: SUCCESS (0.060s)
[109.085839] Starting dynamic subtest: ccs0
[109.285628] Dynamic subtest ccs0: SUCCESS (0.215s)
[109.286693] Subtest engines-queued: SUCCESS (0.637s)
[109.485425] [022/131] (921s left) kms_rotation_crc (bad-tiling)
[109.666597] Starting subtest: bad-tiling
[109.672048] Subtest bad-tiling: SKIP (0.001s)
[109.816297] [023/131] (921s left) gem_exec_big (single)
[109.893046] Starting subtest: single
[115.637589] Subtest single: SUCCESS (5.744s)
[116.424309] [024/131] (914s left) gem_exec_reloc (basic-gtt-wc)
[116.553265] Subtest basic-gtt-wc: SKIP (0.000s)
[116.696146] [025/131] (914s left) vgem_basic (dmabuf-mmap)
[116.808265] Starting subtest: dmabuf-mmap
[116.815750] Subtest dmabuf-mmap: SUCCESS (0.009s)
[116.903186] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[116.904988] [026/131] (914s left) kms_cursor_edge_walk (128x128-top-bottom)
[117.093433] Starting subtest: 128x128-top-bottom
[117.095514] Starting dynamic subtest: pipe-A-DP-3
[120.549042] Dynamic subtest pipe-A-DP-3: SUCCESS (3.454s)
[120.561525] Starting dynamic subtest: pipe-D-DP-3
[123.859499] Dynamic subtest pipe-D-DP-3: SUCCESS (3.308s)
[123.860393] Subtest 128x128-top-bottom: SUCCESS (6.766s)
[124.170579] [027/131] (907s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[124.368455] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[124.421098] [028/131] (907s left) gem_tiled_fence_blits (basic)
[124.510833] Subtest basic: SKIP (0.000s)
[124.587193] [029/131] (907s left) gem_exec_reloc (basic-write-cpu-active)
[124.675019] Subtest basic-write-cpu-active: SKIP (0.000s)
[124.753829] [030/131] (906s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[124.958041] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[124.959808] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[125.176417] [031/131] (906s left) i915_drm_fdinfo (busy-idle-check-all)
[125.249189] Starting subtest: busy-idle-check-all
[125.250170] Starting dynamic subtest: rcs0
[125.280459] Dynamic subtest rcs0: SKIP (0.030s)
[125.289933] Starting dynamic subtest: bcs0
[125.292173] Dynamic subtest bcs0: SKIP (0.001s)
[125.301221] Starting dynamic subtest: vcs0
[125.303470] Dynamic subtest vcs0: SKIP (0.001s)
[125.312175] Starting dynamic subtest: vcs1
[125.314296] Dynamic subtest vcs1: SKIP (0.001s)
[125.323355] Starting dynamic subtest: vecs0
[125.325611] Dynamic subtest vecs0: SKIP (0.000s)
[125.334191] Starting dynamic subtest: vecs1
[125.336424] Dynamic subtest vecs1: SKIP (0.000s)
[125.347376] Starting dynamic subtest: ccs0
[125.349315] Dynamic subtest ccs0: SKIP (0.000s)
[125.351402] Subtest busy-idle-check-all: SKIP (0.036s)
[125.394913] [032/131] (906s left) syncobj_wait (wait-any-complex)
[125.502646] Starting subtest: wait-any-complex
[125.566238] Subtest wait-any-complex: SUCCESS (0.063s)
[125.729115] [033/131] (906s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[125.919225] Starting subtest: coverage-vs-premult-vs-constant
[126.183573] Starting dynamic subtest: pipe-A-DP-3
[126.668209] Dynamic subtest pipe-A-DP-3: SUCCESS (0.484s)
[126.678071] Starting dynamic subtest: pipe-D-DP-3
[127.198057] Dynamic subtest pipe-D-DP-3: SUCCESS (0.529s)
[127.198978] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.280s)
[127.544477] [034/131] (904s left) kms_flip (wf_vblank-ts-check)
[127.739876] Starting subtest: wf_vblank-ts-check
[127.744215] Starting dynamic subtest: A-DP3
[135.864112] Dynamic subtest A-DP3: SUCCESS (8.120s)
[135.874683] Starting dynamic subtest: B-DP3
[143.915065] Dynamic subtest B-DP3: SUCCESS (8.050s)
[143.924782] Starting dynamic subtest: C-DP3
[151.958489] Dynamic subtest C-DP3: SUCCESS (8.042s)
[151.968393] Starting dynamic subtest: D-DP3
[160.001246] Dynamic subtest D-DP3: SUCCESS (8.041s)
[160.003340] Subtest wf_vblank-ts-check: SUCCESS (32.262s)
[160.384066] [035/131] (871s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[160.471969] Starting subtest: y-tiled-ccs-to-x-tiled
[160.474470] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[160.710478] [036/131] (871s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[160.915277] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[162.199633] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.284s)
[162.430426] [037/131] (869s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[162.615973] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[162.619023] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[162.753746] [038/131] (869s left) prime_mmap_coherency (write)
[162.841466] Starting subtest: write
[168.261575] Subtest write: SUCCESS (5.420s)
[168.428811] [039/131] (863s left) gem_exec_suspend (basic)
[168.521305] Starting subtest: basic
[168.522245] Starting dynamic subtest: smem
[169.720047] Dynamic subtest smem: SUCCESS (1.198s)
[169.729207] Starting dynamic subtest: lmem0
[170.857813] Dynamic subtest lmem0: SUCCESS (1.137s)
[170.858922] Subtest basic: SUCCESS (2.337s)
[171.111200] [040/131] (861s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[171.301242] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[171.358500] [041/131] (861s left) kms_atomic (plane-invalid-params-fence)
[171.545624] Starting subtest: plane-invalid-params-fence
[171.547587] Starting dynamic subtest: pipe-A-DP-3
[172.058293] Dynamic subtest pipe-A-DP-3: SUCCESS (0.511s)
[172.059168] Subtest plane-invalid-params-fence: SUCCESS (0.512s)
[172.400893] [042/131] (860s left) kms_atomic_transition (plane-all-modeset-transition)
[172.588247] Starting subtest: plane-all-modeset-transition
[172.589152] Starting dynamic subtest: pipe-A-DP-3
[199.465552] Dynamic subtest pipe-A-DP-3: SUCCESS (26.875s)
[199.573992] Starting dynamic subtest: pipe-B-DP-3
[222.993590] Dynamic subtest pipe-B-DP-3: SUCCESS (23.451s)
[223.046063] Subtest plane-all-modeset-transition: SUCCESS (50.456s)
[223.367499] [043/131] (809s left) gem_exec_schedule (thriceslice)
[223.461462] Starting subtest: thriceslice
[223.462433] Starting dynamic subtest: rcs0
[223.493354] Dynamic subtest rcs0: SUCCESS (0.031s)
[223.502658] Starting dynamic subtest: bcs0
[223.545924] Dynamic subtest bcs0: SUCCESS (0.052s)
[223.560359] Starting dynamic subtest: vcs0
[223.582042] Dynamic subtest vcs0: SUCCESS (0.035s)
[223.604163] Starting dynamic subtest: vcs1
[223.648886] Dynamic subtest vcs1: SUCCESS (0.065s)
[223.669553] Starting dynamic subtest: vecs0
[223.712325] Dynamic subtest vecs0: SUCCESS (0.061s)
[223.728545] Starting dynamic subtest: vecs1
[223.748933] Dynamic subtest vecs1: SUCCESS (0.036s)
[223.768175] Starting dynamic subtest: ccs0
[223.812631] Dynamic subtest ccs0: SUCCESS (0.062s)
[223.814586] Subtest thriceslice: SUCCESS (0.352s)
[224.248548] [044/131] (808s left) gem_mmap_gtt (hang-busy)
[224.329067] Subtest hang-busy: SKIP (0.000s)
[224.410206] [045/131] (808s left) gem_softpin (evict-active)
[224.499570] Starting subtest: evict-active
[224.516660] Subtest evict-active: SUCCESS (0.017s)
[224.682712] [046/131] (808s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[224.876911] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[224.878570] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[225.083127] [047/131] (807s left) gem_softpin (32b-excludes-last-page)
[225.175987] Starting subtest: 32b-excludes-last-page
[225.180402] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[225.363180] [048/131] (807s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[225.572377] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[225.574174] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[225.765225] [049/131] (807s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[225.965793] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[225.967451] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[226.169314] [050/131] (806s left) kms_vblank (ts-continuation-suspend)
[226.358923] Starting subtest: ts-continuation-suspend
[226.361110] Starting dynamic subtest: pipe-A-DP-3
[245.729736] Dynamic subtest pipe-A-DP-3: SUCCESS (4.180s)
[245.743115] Starting dynamic subtest: pipe-D-DP-3
[265.135801] Dynamic subtest pipe-D-DP-3: SUCCESS (3.827s)
[265.136607] Subtest ts-continuation-suspend: SUCCESS (8.012s)
[265.398462] [051/131] (767s left) gem_exec_reloc (basic-concurrent16)
[265.484767] Subtest basic-concurrent16: SKIP (0.000s)
[265.568352] [052/131] (767s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[265.857877] Starting subtest: cursor-rapid-movement-32x32
[265.911200] Subtest cursor-rapid-movement-32x32: SKIP (0.051s)
[266.339391] [053/131] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[266.538010] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[266.539731] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[266.741672] [054/131] (766s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[266.933204] Starting subtest: plane-primary-toggle-with-vblank-wait
[266.935523] Starting dynamic subtest: pipe-A-DP-3
[267.155870] Dynamic subtest pipe-A-DP-3: SUCCESS (0.221s)
[267.279588] Starting dynamic subtest: pipe-B-DP-3
[267.564325] Dynamic subtest pipe-B-DP-3: SUCCESS (0.298s)
[267.670330] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.737s)
[267.956651] [055/131] (765s left) i915_hangman (detector)
[268.055460] Starting subtest: detector
[268.056492] Starting dynamic subtest: rcs0
[278.003642] Dynamic subtest rcs0: SUCCESS (9.949s)
[278.015591] Starting dynamic subtest: bcs0
[288.006664] Dynamic subtest bcs0: SUCCESS (10.002s)
[288.018604] Starting dynamic subtest: vcs0
[297.931668] Dynamic subtest vcs0: SUCCESS (9.924s)
[297.943651] Starting dynamic subtest: vcs1
[307.923361] Dynamic subtest vcs1: SUCCESS (9.991s)
[307.935973] Starting dynamic subtest: vecs0
[318.006039] Dynamic subtest vecs0: SUCCESS (10.083s)
[318.032080] Starting dynamic subtest: vecs1
[327.955931] Dynamic subtest vecs1: SUCCESS (9.949s)
[327.967518] Starting dynamic subtest: ccs0
[337.925651] Dynamic subtest ccs0: SUCCESS (9.969s)
[337.926640] Subtest detector: SUCCESS (69.872s)
[338.103724] [056/131] (695s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[338.303228] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[338.304972] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[338.505144] [057/131] (695s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[338.707197] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[339.435329] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.728s)
[339.725074] [058/131] (693s left) gem_exec_whisper (basic-forked-all)
[339.820472] Starting subtest: basic-forked-all
[342.665484] Subtest basic-forked-all: SUCCESS (2.844s)
[342.968813] [059/131] (690s left) gem_tiled_wc
[343.145336] [060/131] (690s left) kms_psr (psr2-cursor-plane-onoff)
[343.335621] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[343.398754] [061/131] (690s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[343.480575] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[343.481519] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[343.637658] [062/131] (690s left) gem_create (create-ext-cpu-access-big)
[343.849706] Starting subtest: create-ext-cpu-access-big
[346.918647] Subtest create-ext-cpu-access-big: SUCCESS (3.069s)
[347.372137] [063/131] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[347.799188] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[347.800841] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[347.984043] [064/131] (686s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[348.063741] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[348.064676] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[348.234812] [065/131] (685s left) kms_psr (fbc-psr-primary-mmap-gtt)
[348.424088] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[348.481657] [066/131] (685s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[348.565666] Starting subtest: multi-wait-all-for-submit-signaled
[348.566617] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[348.723945] [067/131] (685s left) gen7_exec_parse (basic-offset)
[348.808313] Subtest basic-offset: SKIP (0.000s)
[348.882172] [068/131] (685s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[349.080861] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[349.132366] [069/131] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[349.326190] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[349.327874] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[349.485944] [070/131] (684s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[349.679373] Starting subtest: psr-2p-pri-indfb-multidraw
[349.681210] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[349.870011] [071/131] (684s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[350.077716] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[350.078693] Starting dynamic subtest: pipe-A-valid-mode
[350.164737] Dynamic subtest pipe-A-valid-mode: SKIP (0.085s)
[350.166664] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.086s)
[350.406305] [072/131] (684s left) gem_wait (write-wait)
[350.500889] Starting subtest: write-wait
[350.501847] Starting dynamic subtest: all-engines
[351.621664] Dynamic subtest all-engines: SUCCESS (1.120s)
[351.650755] Starting dynamic subtest: rcs0
[352.685011] Dynamic subtest rcs0: SUCCESS (1.061s)
[352.702877] Starting dynamic subtest: bcs0
[353.745964] Dynamic subtest bcs0: SUCCESS (1.057s)
[353.763706] Starting dynamic subtest: vcs0
[354.809849] Dynamic subtest vcs0: SUCCESS (1.060s)
[354.827644] Starting dynamic subtest: vcs1
[355.872052] Dynamic subtest vcs1: SUCCESS (1.058s)
[355.892930] Starting dynamic subtest: vecs0
[356.936963] Dynamic subtest vecs0: SUCCESS (1.061s)
[356.953495] Starting dynamic subtest: vecs1
[357.999885] Dynamic subtest vecs1: SUCCESS (1.059s)
[358.020336] Starting dynamic subtest: ccs0
[359.064193] Dynamic subtest ccs0: SUCCESS (1.061s)
[359.065242] Subtest write-wait: SUCCESS (8.564s)
[359.388786] [073/131] (675s left) sw_sync (alloc_merge_fence)
[359.438298] Starting subtest: alloc_merge_fence
[359.439287] Subtest alloc_merge_fence: SUCCESS (0.000s)
[359.601610] [074/131] (675s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[359.793855] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[359.796062] Starting dynamic subtest: pipe-A-DP-3
[361.310577] Dynamic subtest pipe-A-DP-3: SUCCESS (1.512s)
[361.322843] Starting dynamic subtest: pipe-B-DP-3
[361.331038] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[361.343137] Starting dynamic subtest: pipe-C-DP-3
[361.351113] Dynamic subtest pipe-C-DP-3: SUCCESS (0.003s)
[361.362945] Starting dynamic subtest: pipe-D-DP-3
[361.370555] Dynamic subtest pipe-D-DP-3: SUCCESS (0.003s)
[361.371437] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SUCCESS (1.527s)
[361.872181] [075/131] (673s left) api_intel_allocator (reserve-simple)
[361.954731] Starting subtest: reserve-simple
[361.981657] Subtest reserve-simple: SUCCESS (0.028s)
[362.217076] [076/131] (672s left) gem_ctx_shared (q-out-order)
[362.319898] Starting subtest: Q-out-order
[362.320800] Starting dynamic subtest: rcs0
[362.594782] Dynamic subtest rcs0: SUCCESS (0.274s)
[362.607504] Starting dynamic subtest: bcs0
[362.774680] Dynamic subtest bcs0: SUCCESS (0.179s)
[362.787464] Starting dynamic subtest: vcs0
[362.964695] Dynamic subtest vcs0: SUCCESS (0.189s)
[362.977553] Starting dynamic subtest: vcs1
[363.152418] Dynamic subtest vcs1: SUCCESS (0.187s)
[363.165104] Starting dynamic subtest: vecs0
[363.340447] Dynamic subtest vecs0: SUCCESS (0.187s)
[363.352911] Starting dynamic subtest: vecs1
[363.527683] Dynamic subtest vecs1: SUCCESS (0.186s)
[363.540873] Starting dynamic subtest: ccs0
[363.763658] Dynamic subtest ccs0: SUCCESS (0.235s)
[363.764596] Subtest Q-out-order: SUCCESS (1.444s)
[364.084095] [077/131] (670s left) kms_lease (invalid-create-leases)
[364.274275] Starting subtest: invalid-create-leases
[364.283989] Subtest invalid-create-leases: SUCCESS (0.010s)
[364.503768] [078/131] (670s left) kms_pm_backlight (basic-brightness)
[364.697300] Subtest basic-brightness: SKIP (0.000s)
[364.764286] [079/131] (670s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[364.856286] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[364.858678] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[365.152129] [080/131] (670s left) syncobj_eventfd (timeline-wait-signaled)
[365.232713] Starting subtest: timeline-wait-signaled
[365.233638] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[365.384729] [081/131] (669s left) gem_exec_whisper (basic-queues-forked-all)
[365.481695] Starting subtest: basic-queues-forked-all
[387.451534] Subtest basic-queues-forked-all: SUCCESS (21.968s)
[387.740178] [082/131] (647s left) gem_exec_suspend (basic-s3-devices)
[387.832575] Starting subtest: basic-S3-devices
[387.833516] Starting dynamic subtest: smem
[397.955360] Dynamic subtest smem: SUCCESS (10.122s)
[397.967892] Starting dynamic subtest: lmem0
[408.040480] Dynamic subtest lmem0: SUCCESS (10.084s)
[408.041664] Subtest basic-S3-devices: SUCCESS (20.208s)
[408.356679] [083/131] (627s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[408.557929] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[408.574422] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.016s)
[408.752926] [084/131] (626s left) kms_fb_coherency (memset-crc)
[408.942594] Starting subtest: memset-crc
[408.943525] Starting dynamic subtest: mmap-offset-fixed
[409.550302] Dynamic subtest mmap-offset-fixed: CRASH (0.277s)
[409.891561] Subtest memset-crc: CRASH (0.602s)
[409.972871] [085/131] (625s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[410.076836] Starting subtest: framebuffer-vs-set-tiling
[410.078649] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[410.364105] [086/131] (625s left) gem_softpin (evict-snoop-interruptible)
[410.452922] Starting subtest: evict-snoop-interruptible
[410.454774] Subtest evict-snoop-interruptible: SKIP (0.000s)
[410.581625] [087/131] (625s left) kms_pm_rpm (legacy-planes-dpms)
[412.817188] Starting subtest: legacy-planes-dpms
[412.819159] Starting dynamic subtest: plane-63
[415.747329] Dynamic subtest plane-63: SUCCESS (2.928s)
[415.794452] Starting dynamic subtest: plane-93
[418.613028] Dynamic subtest plane-93: SUCCESS (2.860s)
[418.628938] Starting dynamic subtest: plane-123
[421.419592] Dynamic subtest plane-123: SUCCESS (2.802s)
[421.467186] Starting dynamic subtest: plane-133
[424.289172] Dynamic subtest plane-133: SUCCESS (2.865s)
[424.295468] Subtest legacy-planes-dpms: SUCCESS (11.475s)
[424.739861] [088/131] (611s left) gem_exec_fence (syncobj-signal)
[425.316304] Starting subtest: syncobj-signal
[425.348111] Subtest syncobj-signal: SUCCESS (0.032s)
[425.803885] [089/131] (610s left) fbdev (unaligned-read)
[425.869056] Starting subtest: unaligned-read
[425.883183] Subtest unaligned-read: SUCCESS (0.014s)
[426.041705] [090/131] (610s left) gem_lmem_swapping (verify-random-ccs)
[429.230679] Starting subtest: verify-random-ccs
[429.231717] Starting dynamic subtest: lmem0
[436.130256] Dynamic subtest lmem0: SUCCESS (6.900s)
[436.131424] Subtest verify-random-ccs: SUCCESS (6.901s)
[437.384534] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[437.385506] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[437.387383] [091/131] (598s left) kms_color (ctm-green-to-red)
[439.089587] Starting subtest: ctm-green-to-red
[439.090509] Starting dynamic subtest: pipe-A-DP-3
[439.786880] Dynamic subtest pipe-A-DP-3: SUCCESS (0.697s)
[439.801909] Starting dynamic subtest: pipe-B-DP-3
[440.377319] Dynamic subtest pipe-B-DP-3: SUCCESS (0.590s)
[440.394333] Starting dynamic subtest: pipe-C-DP-3
[440.987590] Dynamic subtest pipe-C-DP-3: SUCCESS (0.608s)
[440.999032] Starting dynamic subtest: pipe-D-DP-3
[441.594959] Dynamic subtest pipe-D-DP-3: SUCCESS (0.607s)
[441.595993] Subtest ctm-green-to-red: SUCCESS (2.506s)
[441.846710] [FACT kms_color (ctm-green-to-red)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[441.849199] [FACT kms_color (ctm-green-to-red)] new: kernel.kmod_is_loaded.i915: true
[441.852350] [092/131] (594s left) kms_chamelium_hpd (hdmi-hpd)
[442.132750] Subtest hdmi-hpd: SKIP (0.000s)
[442.291932] [093/131] (593s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[442.373276] Starting subtest: multi-wait-all-for-submit-available-submitted
[442.374272] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[442.533667] [094/131] (593s left) api_intel_bb (full-batch)
[442.615043] Starting subtest: full-batch
[442.646688] Subtest full-batch: SUCCESS (0.032s)
[442.838166] [095/131] (593s left) perf_pmu (semaphore-wait)
[442.917756] Starting subtest: semaphore-wait
[442.918625] Starting dynamic subtest: rcs0
[443.462510] Dynamic subtest rcs0: SUCCESS (0.543s)
[443.478351] Starting dynamic subtest: bcs0
[443.976344] Dynamic subtest bcs0: SUCCESS (0.509s)
[443.992692] Starting dynamic subtest: vcs0
[444.490422] Dynamic subtest vcs0: SUCCESS (0.509s)
[444.506695] Starting dynamic subtest: vcs1
[445.004082] Dynamic subtest vcs1: SUCCESS (0.509s)
[445.020824] Starting dynamic subtest: vecs0
[445.518121] Dynamic subtest vecs0: SUCCESS (0.509s)
[445.534762] Starting dynamic subtest: vecs1
[446.032275] Dynamic subtest vecs1: SUCCESS (0.509s)
[446.048635] Starting dynamic subtest: ccs0
[446.546288] Dynamic subtest ccs0: SUCCESS (0.509s)
[446.550780] Subtest semaphore-wait: SUCCESS (3.630s)
[446.738044] [096/131] (589s left) kms_big_fb (linear-32bpp-rotate-270)
[446.942133] Starting subtest: linear-32bpp-rotate-270
[446.999547] Subtest linear-32bpp-rotate-270: SKIP (0.057s)
[447.221852] [097/131] (589s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[447.414704] Starting subtest: basic-modeset-with-all-modifiers-formats
[447.650050] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB8888
[447.953678] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB8888: SUCCESS (0.304s)
[447.973481] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB2101010
[447.986677] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB2101010: SUCCESS (0.032s)
[448.007834] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB16161616F
[448.019914] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB16161616F: SUCCESS (0.032s)
[448.039700] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[448.203351] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.182s)
[448.216072] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[448.236542] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.032s)
[448.251849] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[448.269864] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.032s)
[448.285214] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[448.303360] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.032s)
[448.318956] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[448.336563] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.032s)
[448.351863] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[448.369887] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.032s)
[448.385237] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[448.403278] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.032s)
[448.418678] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[448.436583] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.032s)
[448.451922] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[448.469922] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.032s)
[448.485421] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[448.653108] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.182s)
[448.667226] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[448.686680] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.032s)
[448.704497] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[448.719914] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.032s)
[448.737883] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[448.753278] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.032s)
[448.771088] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[448.786561] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.032s)
[448.804407] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[448.819854] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.032s)
[448.837728] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[448.853239] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.032s)
[448.871060] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[448.886594] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.032s)
[448.904519] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[448.919897] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.032s)
[448.938169] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[449.104461] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.183s)
[449.118553] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[449.138638] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.033s)
[449.156456] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[449.171970] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.032s)
[449.192470] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[449.205351] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.032s)
[449.225410] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[449.238513] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.032s)
[449.254432] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[449.271868] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.032s)
[449.286388] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[449.305229] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.032s)
[449.319999] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[449.338470] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.032s)
[449.354793] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[449.371966] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.032s)
[449.642466] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.228s)
[449.971369] [098/131] (586s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[450.167304] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[450.169083] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[450.336892] [099/131] (586s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[450.527692] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[450.528604] Starting dynamic subtest: pipe-A-DP-3
[453.554227] Dynamic subtest pipe-A-DP-3: SUCCESS (3.010s)
[453.571454] Starting dynamic subtest: pipe-B-DP-3
[454.118882] Dynamic subtest pipe-B-DP-3: SUCCESS (0.555s)
[454.149354] Starting dynamic subtest: pipe-C-DP-3
[454.698269] Dynamic subtest pipe-C-DP-3: SUCCESS (0.571s)
[454.728351] Starting dynamic subtest: pipe-D-DP-3
[455.278806] Dynamic subtest pipe-D-DP-3: SUCCESS (0.572s)
[455.280645] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SUCCESS (4.737s)
[455.641461] [100/131] (581s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[455.734662] Starting subtest: invalid-bsd1-flag-on-vebox
[455.735614] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[455.929087] [101/131] (580s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[456.117728] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[456.119522] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[456.437866] [102/131] (580s left) kms_getfb (getfb-repeated-different-handles)
[456.633753] Starting subtest: getfb-repeated-different-handles
[456.634683] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[456.827588] [103/131] (580s left) kms_psr (psr-dpms)
[457.015548] Subtest psr-dpms: SKIP (0.000s)
[457.082046] [104/131] (579s left) gem_exec_schedule (manyslice)
[457.183436] Starting subtest: manyslice
[457.184347] Starting dynamic subtest: rcs0
[463.609475] Dynamic subtest rcs0: SUCCESS (6.425s)
[463.628223] Starting dynamic subtest: bcs0
[470.030470] Dynamic subtest bcs0: SUCCESS (6.418s)
[470.046108] Starting dynamic subtest: vcs0
[476.117244] Dynamic subtest vcs0: SUCCESS (6.081s)
[476.130190] Starting dynamic subtest: vcs1
[482.198781] Dynamic subtest vcs1: SUCCESS (6.082s)
[482.214688] Starting dynamic subtest: vecs0
[488.289983] Dynamic subtest vecs0: SUCCESS (6.088s)
[488.305298] Starting dynamic subtest: vecs1
[494.376126] Dynamic subtest vecs1: SUCCESS (6.083s)
[494.391407] Starting dynamic subtest: ccs0
[500.313686] Dynamic subtest ccs0: SUCCESS (5.935s)
[500.314800] Subtest manyslice: SUCCESS (43.130s)
[500.690166] [105/131] (536s left) gem_exec_reloc (basic-cpu-active)
[500.776697] Subtest basic-cpu-active: SKIP (0.000s)
[500.850852] [106/131] (536s left) core_auth (basic-auth)
[500.935726] Starting subtest: basic-auth
[500.952731] Subtest basic-auth: SUCCESS (0.017s)
[501.109656] [107/131] (536s left) gem_exec_parallel (basic)
[501.200923] Starting subtest: basic
[501.201805] Starting dynamic subtest: rcs0
[502.772880] Dynamic subtest rcs0: SUCCESS (1.571s)
[502.790560] Starting dynamic subtest: bcs0
[504.289540] Dynamic subtest bcs0: SUCCESS (1.515s)
[504.303489] Starting dynamic subtest: vcs0
[505.781679] Dynamic subtest vcs0: SUCCESS (1.491s)
[505.796321] Starting dynamic subtest: vcs1
[507.280479] Dynamic subtest vcs1: SUCCESS (1.498s)
[507.294470] Starting dynamic subtest: vecs0
[508.740567] Dynamic subtest vecs0: SUCCESS (1.459s)
[508.759206] Starting dynamic subtest: vecs1
[510.266841] Dynamic subtest vecs1: SUCCESS (1.525s)
[510.282481] Starting dynamic subtest: ccs0
[511.759495] Dynamic subtest ccs0: SUCCESS (1.491s)
[511.760551] Subtest basic: SUCCESS (10.559s)
[512.065021] [108/131] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[512.259580] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[512.261347] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[512.473271] [109/131] (524s left) i915_pm_rps (basic-api)
[512.566174] Starting subtest: basic-api
[512.568251] Subtest basic-api: SKIP (0.001s)
[512.750611] [110/131] (524s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[512.947747] Starting subtest: primary-x-tiled-reflect-x-180
[523.272470] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.325s)
[523.667981] [111/131] (513s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[523.869921] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[523.871702] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[524.061265] [112/131] (513s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[524.248100] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[524.250717] Starting dynamic subtest: pipe-A-valid-mode
[524.344002] Dynamic subtest pipe-A-valid-mode: SKIP (0.092s)
[524.345922] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.094s)
[524.608653] [113/131] (513s left) kms_hdr (static-toggle-dpms)
[524.801652] Starting subtest: static-toggle-dpms
[525.329482] Starting dynamic subtest: pipe-A-DP-3
[526.537366] Dynamic subtest pipe-A-DP-3: SUCCESS (1.208s)
[526.538788] Subtest static-toggle-dpms: SUCCESS (1.738s)
[526.922507] [114/131] (510s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[527.115777] Starting subtest: disable-crc-after-crtc
[527.116712] Starting dynamic subtest: pipe-A-DP-3
[527.832006] Dynamic subtest pipe-A-DP-3: SUCCESS (0.715s)
[527.849505] Starting dynamic subtest: pipe-B-DP-3
[528.459600] Dynamic subtest pipe-B-DP-3: SUCCESS (0.624s)
[528.473465] Starting dynamic subtest: pipe-C-DP-3
[529.071587] Dynamic subtest pipe-C-DP-3: SUCCESS (0.611s)
[529.086676] Starting dynamic subtest: pipe-D-DP-3
[529.689442] Dynamic subtest pipe-D-DP-3: SUCCESS (0.616s)
[529.690398] Subtest disable-crc-after-crtc: SUCCESS (2.575s)
[530.001733] [115/131] (507s left) gem_userptr_blits (usage-restrictions)
[530.093777] Starting subtest: usage-restrictions
[530.094647] Subtest usage-restrictions: SUCCESS (0.000s)
[530.329737] [116/131] (507s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[530.519765] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[530.521591] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[530.851800] [117/131] (507s left) gem_mmap_wc (write-prefaulted)
[530.931506] Subtest write-prefaulted: SKIP (0.000s)
[531.016496] [118/131] (507s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[531.097708] Starting subtest: invalid-multi-wait-all-unsubmitted
[531.098724] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[531.284185] [119/131] (506s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[532.774886] Starting subtest: modeset-non-lpsp-stress-no-wait
[534.791762] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (2.016s)
[534.996362] [120/131] (503s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[535.188808] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[535.190490] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[535.396467] [121/131] (503s left) vgem_basic (sysfs)
[535.464054] Starting subtest: sysfs
[535.466016] Subtest sysfs: SUCCESS (0.002s)
[535.583447] [122/131] (502s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[535.776748] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[535.778468] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[535.943821] [123/131] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[536.135874] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[536.137592] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[536.347100] [124/131] (502s left) kms_chamelium_audio (hdmi-audio)
[536.615691] Subtest hdmi-audio: SKIP (0.000s)
[536.767879] [125/131] (501s left) core_getstats (basic)
[536.847696] Starting subtest: basic
[536.848652] Subtest basic: SUCCESS (0.000s)
[537.001547] [126/131] (501s left) syncobj_wait (wait-zero-handles)
[537.089713] Starting subtest: wait-zero-handles
[537.090610] Subtest wait-zero-handles: SUCCESS (0.000s)
[537.266227] [127/131] (501s left) prime_self_import (export-vs-gem_close-race)
[537.315595] Starting subtest: export-vs-gem_close-race
[542.427727] Subtest export-vs-gem_close-race: SUCCESS (5.112s)
[542.635850] [128/131] (496s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[542.832699] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[542.834505] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[543.002334] [129/131] (496s left) kms_cursor_edge_walk (64x64-right-edge)
[543.194263] Starting subtest: 64x64-right-edge
[543.196692] Starting dynamic subtest: pipe-A-DP-3
[546.672194] Dynamic subtest pipe-A-DP-3: SUCCESS (3.476s)
[546.689355] Starting dynamic subtest: pipe-D-DP-3
[550.002654] Dynamic subtest pipe-D-DP-3: SUCCESS (3.326s)
[550.003572] Subtest 64x64-right-edge: SUCCESS (6.808s)
[550.326118] [130/131] (488s left) perf_pmu (busy-double-start)
[550.398255] Starting subtest: busy-double-start
[550.399252] Starting dynamic subtest: rcs0
[554.020843] Dynamic subtest rcs0: SUCCESS (3.621s)
[554.038041] Starting dynamic subtest: bcs0
[557.624898] Dynamic subtest bcs0: SUCCESS (3.599s)
[557.643304] Starting dynamic subtest: vcs0
[561.242829] Dynamic subtest vcs0: SUCCESS (3.615s)
[561.259883] Starting dynamic subtest: vcs1
[564.841792] Dynamic subtest vcs1: SUCCESS (3.594s)
[564.858420] Starting dynamic subtest: vecs0
[568.436411] Dynamic subtest vecs0: SUCCESS (3.590s)
[568.453857] Starting dynamic subtest: vecs1
[572.049612] Dynamic subtest vecs1: SUCCESS (3.608s)
[572.066935] Starting dynamic subtest: ccs0
[575.656596] Dynamic subtest ccs0: SUCCESS (3.602s)
[575.661623] Subtest busy-double-start: SUCCESS (25.260s)
[575.823801] [131/131] (463s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[576.024763] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[576.026544] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[576.227187] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: prime_busy
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_chamelium_frames
results: parsing output: 9/ for test: gem_ctx_param
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: i915_query
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: gem_exec_big
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: kms_cursor_edge_walk
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: gem_tiled_fence_blits
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: i915_drm_fdinfo
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: prime_mmap_coherency
results: parsing output: 38/ for test: gem_exec_suspend
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_atomic
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_atomic_transition
results: parsing output: 54/ for test: i915_hangman
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: gem_tiled_wc
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_create
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: gem_wait
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: gem_ctx_shared
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: kms_pm_backlight
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: syncobj_eventfd
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: gem_exec_suspend
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: kms_fb_coherency
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: gem_softpin
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: fbdev
results: parsing output: 89/ for test: gem_lmem_swapping
results: parsing output: 90/ for test: kms_color
results: parsing output: 91/ for test: kms_chamelium_hpd
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_getfb
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: core_auth
results: parsing output: 106/ for test: gem_exec_parallel
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: i915_pm_rps
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: kms_hdr
results: parsing output: 113/ for test: kms_pipe_crc_basic
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: vgem_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_chamelium_audio
results: parsing output: 124/ for test: core_getstats
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: prime_self_import
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_edge_walk
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.