[74.184894] Initializing watchdogs
[74.184962]   /dev/watchdog0
[74.205055] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[74.216590] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[74.220584] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[74.223136] [001/131] (960s left) kms_flip (2x-dpms-vs-vblank-race)
[74.424450] Starting subtest: 2x-dpms-vs-vblank-race
[74.440540] Subtest 2x-dpms-vs-vblank-race: SKIP (0.016s)
[74.615631] [002/131] (960s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[74.801719] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[74.850546] [003/131] (959s left) prime_busy (after)
[74.937290] Starting subtest: after
[74.942281] Starting dynamic subtest: rcs0
[75.001984] Dynamic subtest rcs0: SUCCESS (0.060s)
[75.010640] Starting dynamic subtest: bcs0
[75.073355] Dynamic subtest bcs0: SUCCESS (0.071s)
[75.095165] Starting dynamic subtest: vcs0
[75.118349] Dynamic subtest vcs0: SUCCESS (0.044s)
[75.141314] Starting dynamic subtest: vcs1
[75.162382] Dynamic subtest vcs1: SUCCESS (0.043s)
[75.185318] Starting dynamic subtest: vecs0
[75.205277] Dynamic subtest vecs0: SUCCESS (0.042s)
[75.223213] Starting dynamic subtest: vecs1
[75.249016] Dynamic subtest vecs1: SUCCESS (0.043s)
[75.260166] Starting dynamic subtest: ccs0
[75.290362] Dynamic subtest ccs0: SUCCESS (0.041s)
[75.404186] Subtest after: SUCCESS (0.465s)
[75.571306] [004/131] (959s left) gem_exec_balancer (bonded-chain)
[75.662158] Starting subtest: bonded-chain
[89.547580] Subtest bonded-chain: SUCCESS (13.877s)
[89.998489] [005/131] (944s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[90.187582] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[90.189322] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[90.358092] [006/131] (944s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[90.560283] Starting subtest: x-tiled-64bpp-rotate-90
[90.624472] Subtest x-tiled-64bpp-rotate-90: SKIP (0.064s)
[90.866503] [007/131] (944s left) kms_vblank (accuracy-idle)
[91.046178] Starting subtest: accuracy-idle
[91.048167] Starting dynamic subtest: pipe-A-DP-3
[93.394821] Dynamic subtest pipe-A-DP-3: SUCCESS (2.345s)
[93.416797] Starting dynamic subtest: pipe-D-DP-3
[95.654604] Dynamic subtest pipe-D-DP-3: SUCCESS (2.252s)
[95.655585] Subtest accuracy-idle: SUCCESS (4.607s)
[95.893701] [008/131] (939s left) kms_cursor_crc (cursor-onscreen-128x42)
[96.292171] Starting subtest: cursor-onscreen-128x42
[96.296141] Starting dynamic subtest: pipe-A-DP-3
[98.983761] Dynamic subtest pipe-A-DP-3: SUCCESS (2.685s)
[99.019817] Starting dynamic subtest: pipe-D-DP-3
[101.705630] Dynamic subtest pipe-D-DP-3: SUCCESS (2.693s)
[101.706665] Subtest cursor-onscreen-128x42: SUCCESS (5.412s)
[102.181074] [009/131] (933s left) kms_chamelium_frames (hdmi-aspect-ratio)
[102.473886] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[102.625049] [010/131] (932s left) gem_ctx_param (invalid-get-ringsize)
[102.698449] Starting subtest: invalid-get-ringsize
[102.700382] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[102.883501] [011/131] (932s left) kms_psr (psr-primary-page-flip)
[103.064458] Subtest psr-primary-page-flip: SKIP (0.000s)
[103.127326] [012/131] (932s left) i915_query (test-query-geometry-subslices)
[103.197051] Starting subtest: test-query-geometry-subslices
[103.198019] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[103.340783] [013/131] (932s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[103.525595] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[103.527394] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[103.718338] [014/131] (931s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[103.799457] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[103.801442] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[104.049039] [015/131] (931s left) syncobj_timeline (wait-for-submit-snapshot)
[104.119888] Starting subtest: wait-for-submit-snapshot
[104.203585] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[104.371701] [016/131] (931s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[104.561241] Starting subtest: y-tiled-32bpp-rotate-270
[104.563046] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[104.751815] [017/131] (931s left) kms_plane (plane-position-hole-dpms)
[104.932550] Starting subtest: plane-position-hole-dpms
[105.374494] Starting dynamic subtest: pipe-A-plane-1
[106.058329] Dynamic subtest pipe-A-plane-1: SUCCESS (0.685s)
[106.067056] Starting dynamic subtest: pipe-A-plane-2
[106.728540] Dynamic subtest pipe-A-plane-2: SUCCESS (0.670s)
[106.737985] Starting dynamic subtest: pipe-A-plane-3
[107.417492] Dynamic subtest pipe-A-plane-3: SUCCESS (0.688s)
[107.427066] Starting dynamic subtest: pipe-A-plane-4
[108.111347] Dynamic subtest pipe-A-plane-4: SUCCESS (0.693s)
[108.120768] Starting dynamic subtest: pipe-A-plane-5
[108.132581] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s)
[108.473112] Starting dynamic subtest: pipe-B-plane-1
[109.095964] Dynamic subtest pipe-B-plane-1: SUCCESS (0.630s)
[109.104608] Starting dynamic subtest: pipe-B-plane-2
[109.707515] Dynamic subtest pipe-B-plane-2: SUCCESS (0.611s)
[109.716336] Starting dynamic subtest: pipe-B-plane-3
[110.333449] Dynamic subtest pipe-B-plane-3: SUCCESS (0.626s)
[110.341976] Starting dynamic subtest: pipe-B-plane-4
[110.958589] Dynamic subtest pipe-B-plane-4: SUCCESS (0.625s)
[110.967296] Starting dynamic subtest: pipe-B-plane-5
[110.980454] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s)
[110.981378] Subtest plane-position-hole-dpms: SUCCESS (6.046s)
[111.270329] [018/131] (924s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[111.347188] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[111.348189] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[111.537690] [019/131] (924s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[111.721618] Starting subtest: basic-flip-after-cursor-varying-size
[112.748550] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.026s)
[113.052036] [020/131] (922s left) syncobj_wait (multi-wait-all-submitted-signaled)
[113.126306] Starting subtest: multi-wait-all-submitted-signaled
[113.230351] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[113.365429] [021/131] (922s left) gem_ctx_persistence (engines-queued)
[113.446436] Starting subtest: engines-queued
[113.447437] Starting dynamic subtest: rcs0
[113.551497] Dynamic subtest rcs0: SUCCESS (0.105s)
[113.561285] Starting dynamic subtest: bcs0
[113.613412] Dynamic subtest bcs0: SUCCESS (0.061s)
[113.630071] Starting dynamic subtest: vcs0
[113.683236] Dynamic subtest vcs0: SUCCESS (0.069s)
[113.716951] Starting dynamic subtest: vcs1
[113.758372] Dynamic subtest vcs1: SUCCESS (0.074s)
[113.768011] Starting dynamic subtest: vecs0
[113.806342] Dynamic subtest vecs0: SUCCESS (0.048s)
[113.815770] Starting dynamic subtest: vecs1
[113.864488] Dynamic subtest vecs1: SUCCESS (0.058s)
[113.878988] Starting dynamic subtest: ccs0
[114.041141] Dynamic subtest ccs0: SUCCESS (0.176s)
[114.042155] Subtest engines-queued: SUCCESS (0.595s)
[114.198080] [022/131] (921s left) kms_rotation_crc (bad-tiling)
[114.377610] Starting subtest: bad-tiling
[114.380466] Subtest bad-tiling: SKIP (0.001s)
[114.533308] [023/131] (921s left) gem_exec_big (single)
[114.609288] Starting subtest: single
[120.359618] Subtest single: SUCCESS (5.749s)
[121.120769] [024/131] (915s left) gem_exec_reloc (basic-gtt-wc)
[121.245165] Subtest basic-gtt-wc: SKIP (0.000s)
[121.343501] [025/131] (914s left) vgem_basic (dmabuf-mmap)
[121.455370] Starting subtest: dmabuf-mmap
[121.463413] Subtest dmabuf-mmap: SUCCESS (0.009s)
[121.533922] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[121.535800] [026/131] (914s left) kms_cursor_edge_walk (128x128-top-bottom)
[121.733719] Starting subtest: 128x128-top-bottom
[121.735940] Starting dynamic subtest: pipe-A-DP-3
[125.182126] Dynamic subtest pipe-A-DP-3: SUCCESS (3.446s)
[125.195263] Starting dynamic subtest: pipe-D-DP-3
[128.495341] Dynamic subtest pipe-D-DP-3: SUCCESS (3.310s)
[128.496398] Subtest 128x128-top-bottom: SUCCESS (6.760s)
[128.831787] [027/131] (907s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[129.045483] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[129.091703] [028/131] (907s left) gem_tiled_fence_blits (basic)
[129.186451] Subtest basic: SKIP (0.000s)
[129.281506] [029/131] (907s left) gem_exec_reloc (basic-write-cpu-active)
[129.388031] Subtest basic-write-cpu-active: SKIP (0.000s)
[129.515693] [030/131] (907s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[129.714910] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[129.716804] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[129.896329] [031/131] (906s left) i915_drm_fdinfo (busy-idle-check-all)
[129.968381] Starting subtest: busy-idle-check-all
[129.969382] Starting dynamic subtest: rcs0
[130.000709] Dynamic subtest rcs0: SKIP (0.031s)
[130.010200] Starting dynamic subtest: bcs0
[130.012408] Dynamic subtest bcs0: SKIP (0.000s)
[130.021480] Starting dynamic subtest: vcs0
[130.023588] Dynamic subtest vcs0: SKIP (0.000s)
[130.032651] Starting dynamic subtest: vcs1
[130.034777] Dynamic subtest vcs1: SKIP (0.000s)
[130.043880] Starting dynamic subtest: vecs0
[130.046498] Dynamic subtest vecs0: SKIP (0.000s)
[130.055260] Starting dynamic subtest: vecs1
[130.057413] Dynamic subtest vecs1: SKIP (0.000s)
[130.068440] Starting dynamic subtest: ccs0
[130.070257] Dynamic subtest ccs0: SKIP (0.000s)
[130.072367] Subtest busy-idle-check-all: SKIP (0.037s)
[130.116468] [032/131] (906s left) syncobj_wait (wait-any-complex)
[130.225567] Starting subtest: wait-any-complex
[130.288444] Subtest wait-any-complex: SUCCESS (0.063s)
[130.449341] [033/131] (906s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[130.637166] Starting subtest: coverage-vs-premult-vs-constant
[130.900220] Starting dynamic subtest: pipe-A-DP-3
[131.390858] Dynamic subtest pipe-A-DP-3: SUCCESS (0.489s)
[131.401137] Starting dynamic subtest: pipe-D-DP-3
[131.887251] Dynamic subtest pipe-D-DP-3: SUCCESS (0.496s)
[131.888181] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.251s)
[132.194122] [034/131] (904s left) kms_flip (wf_vblank-ts-check)
[132.382072] Starting subtest: wf_vblank-ts-check
[132.386485] Starting dynamic subtest: A-DP3
[140.527083] Dynamic subtest A-DP3: SUCCESS (8.139s)
[140.538351] Starting dynamic subtest: B-DP3
[148.744200] Dynamic subtest B-DP3: SUCCESS (8.216s)
[148.754207] Starting dynamic subtest: C-DP3
[156.967378] Dynamic subtest C-DP3: SUCCESS (8.223s)
[156.977198] Starting dynamic subtest: D-DP3
[165.024583] Dynamic subtest D-DP3: SUCCESS (8.057s)
[165.026565] Subtest wf_vblank-ts-check: SUCCESS (32.645s)
[165.337882] [035/131] (871s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[165.427591] Starting subtest: y-tiled-ccs-to-x-tiled
[165.429862] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[165.686751] [036/131] (871s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[165.889336] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[167.188931] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.299s)
[167.409017] [037/131] (869s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[167.598156] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[167.600279] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[167.745694] [038/131] (869s left) prime_mmap_coherency (write)
[167.841238] Starting subtest: write
[173.269405] Subtest write: SUCCESS (5.428s)
[173.438444] [039/131] (863s left) gem_exec_suspend (basic)
[173.559526] Starting subtest: basic
[173.560446] Starting dynamic subtest: smem
[174.756541] Dynamic subtest smem: SUCCESS (1.197s)
[174.766233] Starting dynamic subtest: lmem0
[175.866673] Dynamic subtest lmem0: SUCCESS (1.110s)
[175.867763] Subtest basic: SUCCESS (2.307s)
[176.214882] [040/131] (861s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[176.408893] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[176.464952] [041/131] (860s left) kms_atomic (plane-invalid-params-fence)
[176.658802] Starting subtest: plane-invalid-params-fence
[176.661036] Starting dynamic subtest: pipe-A-DP-3
[177.169560] Dynamic subtest pipe-A-DP-3: SUCCESS (0.509s)
[177.170737] Subtest plane-invalid-params-fence: SUCCESS (0.511s)
[177.434237] [042/131] (859s left) kms_atomic_transition (plane-all-modeset-transition)
[177.625235] Starting subtest: plane-all-modeset-transition
[177.626199] Starting dynamic subtest: pipe-A-DP-3
[204.513518] Dynamic subtest pipe-A-DP-3: SUCCESS (26.886s)
[204.601373] Starting dynamic subtest: pipe-B-DP-3
[228.012044] Dynamic subtest pipe-B-DP-3: SUCCESS (23.421s)
[228.065424] Subtest plane-all-modeset-transition: SUCCESS (50.438s)
[228.369321] [043/131] (809s left) gem_exec_schedule (thriceslice)
[228.468189] Starting subtest: thriceslice
[228.469153] Starting dynamic subtest: rcs0
[228.521249] Dynamic subtest rcs0: SUCCESS (0.053s)
[228.534488] Starting dynamic subtest: bcs0
[228.576756] Dynamic subtest bcs0: SUCCESS (0.054s)
[228.614414] Starting dynamic subtest: vcs0
[228.633315] Dynamic subtest vcs0: SUCCESS (0.055s)
[228.652013] Starting dynamic subtest: vcs1
[228.674433] Dynamic subtest vcs1: SUCCESS (0.040s)
[228.686516] Starting dynamic subtest: vecs0
[228.707053] Dynamic subtest vecs0: SUCCESS (0.032s)
[228.716917] Starting dynamic subtest: vecs1
[228.759962] Dynamic subtest vecs1: SUCCESS (0.052s)
[228.781883] Starting dynamic subtest: ccs0
[228.803678] Dynamic subtest ccs0: SUCCESS (0.042s)
[228.805076] Subtest thriceslice: SUCCESS (0.336s)
[229.207642] [044/131] (808s left) gem_mmap_gtt (hang-busy)
[229.292152] Subtest hang-busy: SKIP (0.000s)
[229.384547] [045/131] (808s left) gem_softpin (evict-active)
[229.476482] Starting subtest: evict-active
[229.493470] Subtest evict-active: SUCCESS (0.017s)
[229.706190] [046/131] (808s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[229.898920] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[229.900617] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[230.106188] [047/131] (807s left) gem_softpin (32b-excludes-last-page)
[230.194750] Starting subtest: 32b-excludes-last-page
[230.199266] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[230.421184] [048/131] (807s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[230.630645] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[230.632478] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[230.821663] [049/131] (807s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[231.022012] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[231.023782] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[231.222018] [050/131] (806s left) kms_vblank (ts-continuation-suspend)
[231.410555] Starting subtest: ts-continuation-suspend
[231.412933] Starting dynamic subtest: pipe-A-DP-3
[250.672972] Dynamic subtest pipe-A-DP-3: SUCCESS (4.184s)
[250.687118] Starting dynamic subtest: pipe-D-DP-3
[269.589194] Dynamic subtest pipe-D-DP-3: SUCCESS (3.847s)
[269.590424] Subtest ts-continuation-suspend: SUCCESS (8.036s)
[269.856054] [051/131] (768s left) gem_exec_reloc (basic-concurrent16)
[269.947348] Subtest basic-concurrent16: SKIP (0.000s)
[270.040146] [052/131] (768s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[270.327675] Starting subtest: cursor-rapid-movement-32x32
[270.380056] Subtest cursor-rapid-movement-32x32: SKIP (0.050s)
[270.783320] [053/131] (767s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[270.987559] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[270.989244] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[271.125461] [054/131] (767s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[271.327422] Starting subtest: plane-primary-toggle-with-vblank-wait
[271.328369] Starting dynamic subtest: pipe-A-DP-3
[271.541399] Dynamic subtest pipe-A-DP-3: SUCCESS (0.212s)
[271.692578] Starting dynamic subtest: pipe-B-DP-3
[271.976317] Dynamic subtest pipe-B-DP-3: SUCCESS (0.302s)
[272.082768] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.755s)
[272.353483] [055/131] (766s left) i915_hangman (detector)
[272.452666] Starting subtest: detector
[272.453626] Starting dynamic subtest: rcs0
[282.371590] Dynamic subtest rcs0: SUCCESS (9.919s)
[282.383604] Starting dynamic subtest: bcs0
[292.311718] Dynamic subtest bcs0: SUCCESS (9.939s)
[292.323587] Starting dynamic subtest: vcs0
[302.357612] Dynamic subtest vcs0: SUCCESS (10.045s)
[302.369438] Starting dynamic subtest: vcs1
[312.379744] Dynamic subtest vcs1: SUCCESS (10.021s)
[312.393775] Starting dynamic subtest: vecs0
[322.335601] Dynamic subtest vecs0: SUCCESS (9.954s)
[322.347666] Starting dynamic subtest: vecs1
[332.328600] Dynamic subtest vecs1: SUCCESS (9.992s)
[332.340622] Starting dynamic subtest: ccs0
[342.341728] Dynamic subtest ccs0: SUCCESS (10.012s)
[342.342752] Subtest detector: SUCCESS (69.886s)
[342.509502] [056/131] (695s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[342.700404] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[342.702149] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[342.887652] [057/131] (695s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[343.085230] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[343.855113] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.770s)
[344.120463] [058/131] (694s left) gem_exec_whisper (basic-forked-all)
[344.214319] Starting subtest: basic-forked-all
[347.102660] Subtest basic-forked-all: SUCCESS (2.887s)
[347.406297] [059/131] (691s left) gem_tiled_wc
[347.601068] [060/131] (691s left) kms_psr (psr2-cursor-plane-onoff)
[347.793224] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[347.852475] [061/131] (690s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[347.940602] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[347.941581] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[348.140635] [062/131] (690s left) gem_create (create-ext-cpu-access-big)
[348.333826] Starting subtest: create-ext-cpu-access-big
[351.408601] Subtest create-ext-cpu-access-big: SUCCESS (3.076s)
[351.860968] [063/131] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[352.305384] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[352.307678] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[352.501516] [064/131] (686s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[352.582628] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[352.583634] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[352.790967] [065/131] (686s left) kms_psr (fbc-psr-primary-mmap-gtt)
[352.988660] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[353.052557] [066/131] (686s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[353.137606] Starting subtest: multi-wait-all-for-submit-signaled
[353.138565] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[353.289960] [067/131] (686s left) gen7_exec_parse (basic-offset)
[353.377789] Subtest basic-offset: SKIP (0.000s)
[353.453431] [068/131] (685s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[353.653159] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[353.704021] [069/131] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[353.900437] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[353.902271] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[354.088693] [070/131] (685s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[354.283397] Starting subtest: psr-2p-pri-indfb-multidraw
[354.285194] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[354.494141] [071/131] (685s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[354.684948] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[354.687189] Starting dynamic subtest: pipe-A-valid-mode
[354.766622] Dynamic subtest pipe-A-valid-mode: SKIP (0.080s)
[354.768511] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.081s)
[355.007980] [072/131] (684s left) gem_wait (write-wait)
[355.103714] Starting subtest: write-wait
[355.104673] Starting dynamic subtest: all-engines
[356.224846] Dynamic subtest all-engines: SUCCESS (1.120s)
[356.243670] Starting dynamic subtest: rcs0
[357.286982] Dynamic subtest rcs0: SUCCESS (1.059s)
[357.305682] Starting dynamic subtest: bcs0
[358.349783] Dynamic subtest bcs0: SUCCESS (1.059s)
[358.368789] Starting dynamic subtest: vcs0
[359.412768] Dynamic subtest vcs0: SUCCESS (1.059s)
[359.431408] Starting dynamic subtest: vcs1
[360.474851] Dynamic subtest vcs1: SUCCESS (1.058s)
[360.496425] Starting dynamic subtest: vecs0
[361.540013] Dynamic subtest vecs0: SUCCESS (1.061s)
[361.563328] Starting dynamic subtest: vecs1
[362.601763] Dynamic subtest vecs1: SUCCESS (1.058s)
[362.623415] Starting dynamic subtest: ccs0
[363.667713] Dynamic subtest ccs0: SUCCESS (1.062s)
[363.670090] Subtest write-wait: SUCCESS (8.564s)
[363.994365] [073/131] (675s left) sw_sync (alloc_merge_fence)
[364.044483] Starting subtest: alloc_merge_fence
[364.045400] Subtest alloc_merge_fence: SUCCESS (0.000s)
[364.168620] [074/131] (675s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[364.363245] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[364.365638] Starting dynamic subtest: pipe-A-DP-3
[366.124191] Dynamic subtest pipe-A-DP-3: SUCCESS (1.756s)
[366.136675] Starting dynamic subtest: pipe-B-DP-3
[366.145066] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[366.157590] Starting dynamic subtest: pipe-C-DP-3
[366.165963] Dynamic subtest pipe-C-DP-3: SUCCESS (0.003s)
[366.178269] Starting dynamic subtest: pipe-D-DP-3
[366.186045] Dynamic subtest pipe-D-DP-3: SUCCESS (0.003s)
[366.186958] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SUCCESS (1.770s)
[366.676053] [075/131] (673s left) api_intel_allocator (reserve-simple)
[366.758702] Starting subtest: reserve-simple
[366.786452] Subtest reserve-simple: SUCCESS (0.029s)
[366.971467] [076/131] (672s left) gem_ctx_shared (q-out-order)
[367.072591] Starting subtest: Q-out-order
[367.073581] Starting dynamic subtest: rcs0
[367.346330] Dynamic subtest rcs0: SUCCESS (0.273s)
[367.359368] Starting dynamic subtest: bcs0
[367.528036] Dynamic subtest bcs0: SUCCESS (0.181s)
[367.540632] Starting dynamic subtest: vcs0
[367.721618] Dynamic subtest vcs0: SUCCESS (0.193s)
[367.735266] Starting dynamic subtest: vcs1
[367.912184] Dynamic subtest vcs1: SUCCESS (0.190s)
[367.925121] Starting dynamic subtest: vecs0
[368.100149] Dynamic subtest vecs0: SUCCESS (0.187s)
[368.113050] Starting dynamic subtest: vecs1
[368.287136] Dynamic subtest vecs1: SUCCESS (0.186s)
[368.300002] Starting dynamic subtest: ccs0
[368.478146] Dynamic subtest ccs0: SUCCESS (0.190s)
[368.479148] Subtest Q-out-order: SUCCESS (1.406s)
[368.891904] [077/131] (671s left) kms_lease (invalid-create-leases)
[369.083744] Starting subtest: invalid-create-leases
[369.093510] Subtest invalid-create-leases: SUCCESS (0.009s)
[369.289586] [078/131] (670s left) kms_pm_backlight (basic-brightness)
[369.477409] Subtest basic-brightness: SKIP (0.000s)
[369.536697] [079/131] (670s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[369.624873] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[369.627165] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[369.910967] [080/131] (670s left) syncobj_eventfd (timeline-wait-signaled)
[369.993578] Starting subtest: timeline-wait-signaled
[369.994589] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[370.192281] [081/131] (670s left) gem_exec_whisper (basic-queues-forked-all)
[370.286765] Starting subtest: basic-queues-forked-all
[392.357047] Subtest basic-queues-forked-all: SUCCESS (22.069s)
[392.617772] [082/131] (647s left) gem_exec_suspend (basic-s3-devices)
[392.708051] Starting subtest: basic-S3-devices
[392.709076] Starting dynamic subtest: smem
[402.880686] Dynamic subtest smem: SUCCESS (10.172s)
[402.894275] Starting dynamic subtest: lmem0
[412.984171] Dynamic subtest lmem0: SUCCESS (10.102s)
[412.985361] Subtest basic-S3-devices: SUCCESS (20.276s)
[413.280321] [083/131] (627s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[413.471712] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[413.487729] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.015s)
[413.625237] [084/131] (626s left) kms_fb_coherency (memset-crc)
[413.816576] Starting subtest: memset-crc
[413.817515] Starting dynamic subtest: mmap-offset-fixed
[414.444066] Dynamic subtest mmap-offset-fixed: CRASH (0.265s)
[414.839406] Subtest memset-crc: CRASH (0.622s)
[414.923489] [085/131] (625s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[415.003927] Starting subtest: framebuffer-vs-set-tiling
[415.005659] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[415.322073] [086/131] (625s left) gem_softpin (evict-snoop-interruptible)
[415.413712] Starting subtest: evict-snoop-interruptible
[415.415755] Subtest evict-snoop-interruptible: SKIP (0.000s)
[415.567808] [087/131] (625s left) kms_pm_rpm (legacy-planes-dpms)
[417.198508] Starting subtest: legacy-planes-dpms
[417.200757] Starting dynamic subtest: plane-63
[420.030820] Dynamic subtest plane-63: SUCCESS (2.834s)
[420.079538] Starting dynamic subtest: plane-93
[422.819057] Dynamic subtest plane-93: SUCCESS (2.781s)
[422.864281] Starting dynamic subtest: plane-123
[425.669170] Dynamic subtest plane-123: SUCCESS (2.847s)
[425.714915] Starting dynamic subtest: plane-133
[428.842575] Dynamic subtest plane-133: SUCCESS (3.169s)
[428.847854] Subtest legacy-planes-dpms: SUCCESS (11.650s)
[429.288910] [088/131] (611s left) gem_exec_fence (syncobj-signal)
[429.907632] Starting subtest: syncobj-signal
[429.937665] Subtest syncobj-signal: SUCCESS (0.030s)
[430.405130] [089/131] (610s left) fbdev (unaligned-read)
[430.466680] Starting subtest: unaligned-read
[430.480602] Subtest unaligned-read: SUCCESS (0.014s)
[430.628592] [090/131] (610s left) gem_lmem_swapping (verify-random-ccs)
[433.792753] Starting subtest: verify-random-ccs
[433.793595] Starting dynamic subtest: lmem0
[440.987903] Dynamic subtest lmem0: SUCCESS (7.196s)
[440.988865] Subtest verify-random-ccs: SUCCESS (7.197s)
[442.329310] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[442.330295] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[442.332481] [091/131] (598s left) kms_color (ctm-green-to-red)
[444.064212] Starting subtest: ctm-green-to-red
[444.065123] Starting dynamic subtest: pipe-A-DP-3
[444.768398] Dynamic subtest pipe-A-DP-3: SUCCESS (0.703s)
[444.786390] Starting dynamic subtest: pipe-B-DP-3
[445.363478] Dynamic subtest pipe-B-DP-3: SUCCESS (0.591s)
[445.382268] Starting dynamic subtest: pipe-C-DP-3
[445.962322] Dynamic subtest pipe-C-DP-3: SUCCESS (0.598s)
[445.976786] Starting dynamic subtest: pipe-D-DP-3
[446.578378] Dynamic subtest pipe-D-DP-3: SUCCESS (0.613s)
[446.579420] Subtest ctm-green-to-red: SUCCESS (2.513s)
[446.877237] [FACT kms_color (ctm-green-to-red)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[446.879656] [FACT kms_color (ctm-green-to-red)] new: kernel.kmod_is_loaded.i915: true
[446.882745] [092/131] (594s left) kms_chamelium_hpd (hdmi-hpd)
[447.188430] Subtest hdmi-hpd: SKIP (0.000s)
[447.341477] [093/131] (593s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[447.423023] Starting subtest: multi-wait-all-for-submit-available-submitted
[447.423994] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[447.639911] [094/131] (593s left) api_intel_bb (full-batch)
[447.727014] Starting subtest: full-batch
[447.761018] Subtest full-batch: SUCCESS (0.035s)
[447.928598] [095/131] (593s left) perf_pmu (semaphore-wait)
[448.006780] Starting subtest: semaphore-wait
[448.007710] Starting dynamic subtest: rcs0
[448.552001] Dynamic subtest rcs0: SUCCESS (0.543s)
[448.568440] Starting dynamic subtest: bcs0
[449.066518] Dynamic subtest bcs0: SUCCESS (0.509s)
[449.082794] Starting dynamic subtest: vcs0
[449.580537] Dynamic subtest vcs0: SUCCESS (0.509s)
[449.596414] Starting dynamic subtest: vcs1
[450.094499] Dynamic subtest vcs1: SUCCESS (0.509s)
[450.110700] Starting dynamic subtest: vecs0
[450.608199] Dynamic subtest vecs0: SUCCESS (0.509s)
[450.624496] Starting dynamic subtest: vecs1
[451.122397] Dynamic subtest vecs1: SUCCESS (0.509s)
[451.138742] Starting dynamic subtest: ccs0
[451.636401] Dynamic subtest ccs0: SUCCESS (0.509s)
[451.640838] Subtest semaphore-wait: SUCCESS (3.631s)
[451.874917] [096/131] (589s left) kms_big_fb (linear-32bpp-rotate-270)
[452.076849] Starting subtest: linear-32bpp-rotate-270
[452.140648] Subtest linear-32bpp-rotate-270: SKIP (0.061s)
[452.378131] [097/131] (589s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[452.578116] Starting subtest: basic-modeset-with-all-modifiers-formats
[452.801560] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB8888
[453.110745] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB8888: SUCCESS (0.309s)
[453.133505] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB2101010
[453.143521] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB2101010: SUCCESS (0.031s)
[453.165452] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB16161616F
[453.176869] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB16161616F: SUCCESS (0.032s)
[453.195612] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[453.360015] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.182s)
[453.373906] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[453.393478] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.032s)
[453.410472] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[453.426850] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.032s)
[453.443929] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[453.460133] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.032s)
[453.477140] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[453.493500] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.032s)
[453.510549] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[453.526860] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.032s)
[453.543901] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[453.560232] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.032s)
[453.575719] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[453.593593] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.032s)
[453.611040] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[453.626903] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.032s)
[453.645304] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[453.810062] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.182s)
[453.822743] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[453.843446] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.032s)
[453.856296] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[453.876750] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.032s)
[453.891346] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[453.910140] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.032s)
[453.925680] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[453.943419] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.032s)
[453.958790] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[453.976711] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.032s)
[453.991506] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[454.010146] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.032s)
[454.024390] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[454.043376] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.032s)
[454.057977] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[454.076778] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.032s)
[454.091654] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[454.261440] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.184s)
[454.275923] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[454.295560] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.033s)
[454.312915] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[454.328835] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.032s)
[454.346071] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[454.362318] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.032s)
[454.379686] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[454.395453] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.032s)
[454.412629] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[454.428998] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.032s)
[454.446413] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[454.462234] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.032s)
[454.479187] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[454.495509] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.032s)
[454.512717] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[454.528868] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.032s)
[454.800436] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.222s)
[455.138310] [098/131] (586s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[455.330692] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[455.332420] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[455.533090] [099/131] (586s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[455.723607] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[455.724533] Starting dynamic subtest: pipe-A-DP-3
[459.268643] Dynamic subtest pipe-A-DP-3: SUCCESS (3.527s)
[459.296732] Starting dynamic subtest: pipe-B-DP-3
[459.866845] Dynamic subtest pipe-B-DP-3: SUCCESS (0.588s)
[459.895723] Starting dynamic subtest: pipe-C-DP-3
[460.462822] Dynamic subtest pipe-C-DP-3: SUCCESS (0.589s)
[460.490572] Starting dynamic subtest: pipe-D-DP-3
[461.061068] Dynamic subtest pipe-D-DP-3: SUCCESS (0.588s)
[461.063071] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SUCCESS (5.322s)
[461.436345] [100/131] (580s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[461.528645] Starting subtest: invalid-bsd1-flag-on-vebox
[461.529641] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[461.752243] [101/131] (580s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[461.940906] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[461.942684] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[462.268032] [102/131] (579s left) kms_getfb (getfb-repeated-different-handles)
[462.459827] Starting subtest: getfb-repeated-different-handles
[462.460738] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[462.668422] [103/131] (579s left) kms_psr (psr-dpms)
[462.867235] Subtest psr-dpms: SKIP (0.000s)
[462.929453] [104/131] (579s left) gem_exec_schedule (manyslice)
[463.027793] Starting subtest: manyslice
[463.028728] Starting dynamic subtest: rcs0
[468.963183] Dynamic subtest rcs0: SUCCESS (5.934s)
[468.976443] Starting dynamic subtest: bcs0
[474.886628] Dynamic subtest bcs0: SUCCESS (5.922s)
[474.901796] Starting dynamic subtest: vcs0
[481.479723] Dynamic subtest vcs0: SUCCESS (6.590s)
[481.494668] Starting dynamic subtest: vcs1
[488.572342] Dynamic subtest vcs1: SUCCESS (7.091s)
[488.585497] Starting dynamic subtest: vecs0
[495.165119] Dynamic subtest vecs0: SUCCESS (6.591s)
[495.181072] Starting dynamic subtest: vecs1
[501.256881] Dynamic subtest vecs1: SUCCESS (6.090s)
[501.270428] Starting dynamic subtest: ccs0
[507.689003] Dynamic subtest ccs0: SUCCESS (6.430s)
[507.691072] Subtest manyslice: SUCCESS (44.659s)
[508.056446] [105/131] (534s left) gem_exec_reloc (basic-cpu-active)
[508.141950] Subtest basic-cpu-active: SKIP (0.000s)
[508.269590] [106/131] (534s left) core_auth (basic-auth)
[508.356072] Starting subtest: basic-auth
[508.372786] Subtest basic-auth: SUCCESS (0.017s)
[508.511314] [107/131] (533s left) gem_exec_parallel (basic)
[508.603039] Starting subtest: basic
[508.604078] Starting dynamic subtest: rcs0
[510.139415] Dynamic subtest rcs0: SUCCESS (1.536s)
[510.154729] Starting dynamic subtest: bcs0
[511.652672] Dynamic subtest bcs0: SUCCESS (1.512s)
[511.670052] Starting dynamic subtest: vcs0
[513.149644] Dynamic subtest vcs0: SUCCESS (1.496s)
[513.163779] Starting dynamic subtest: vcs1
[514.650901] Dynamic subtest vcs1: SUCCESS (1.500s)
[514.668291] Starting dynamic subtest: vecs0
[516.146774] Dynamic subtest vecs0: SUCCESS (1.494s)
[516.163745] Starting dynamic subtest: vecs1
[517.652785] Dynamic subtest vecs1: SUCCESS (1.505s)
[517.667920] Starting dynamic subtest: ccs0
[519.142938] Dynamic subtest ccs0: SUCCESS (1.489s)
[519.143947] Subtest basic: SUCCESS (10.540s)
[519.455923] [108/131] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[519.651444] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[519.653197] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[519.858357] [109/131] (522s left) i915_pm_rps (basic-api)
[519.945703] Starting subtest: basic-api
[519.947734] Subtest basic-api: SKIP (0.000s)
[520.149960] [110/131] (522s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[520.336946] Starting subtest: primary-x-tiled-reflect-x-180
[530.757412] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.419s)
[531.173476] [111/131] (511s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[531.378970] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[531.380746] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[531.587973] [112/131] (511s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[531.775026] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[531.777629] Starting dynamic subtest: pipe-A-valid-mode
[531.858018] Dynamic subtest pipe-A-valid-mode: SKIP (0.080s)
[531.859791] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.082s)
[532.115816] [113/131] (510s left) kms_hdr (static-toggle-dpms)
[532.307111] Starting subtest: static-toggle-dpms
[532.851820] Starting dynamic subtest: pipe-A-DP-3
[534.074362] Dynamic subtest pipe-A-DP-3: SUCCESS (1.222s)
[534.075987] Subtest static-toggle-dpms: SUCCESS (1.768s)
[534.425179] [114/131] (508s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[534.630170] Starting subtest: disable-crc-after-crtc
[534.632581] Starting dynamic subtest: pipe-A-DP-3
[535.375738] Dynamic subtest pipe-A-DP-3: SUCCESS (0.743s)
[535.392759] Starting dynamic subtest: pipe-B-DP-3
[536.000669] Dynamic subtest pipe-B-DP-3: SUCCESS (0.622s)
[536.014403] Starting dynamic subtest: pipe-C-DP-3
[536.618642] Dynamic subtest pipe-C-DP-3: SUCCESS (0.617s)
[536.633873] Starting dynamic subtest: pipe-D-DP-3
[537.245863] Dynamic subtest pipe-D-DP-3: SUCCESS (0.624s)
[537.246970] Subtest disable-crc-after-crtc: SUCCESS (2.615s)
[537.560853] [115/131] (505s left) gem_userptr_blits (usage-restrictions)
[537.655515] Starting subtest: usage-restrictions
[537.656430] Subtest usage-restrictions: SUCCESS (0.000s)
[537.891722] [116/131] (505s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[538.084693] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[538.086548] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[538.445490] [117/131] (504s left) gem_mmap_wc (write-prefaulted)
[538.526626] Subtest write-prefaulted: SKIP (0.000s)
[538.608157] [118/131] (504s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[538.688588] Starting subtest: invalid-multi-wait-all-unsubmitted
[538.689565] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[538.873536] [119/131] (504s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[541.211286] Starting subtest: modeset-non-lpsp-stress-no-wait
[545.081630] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (3.870s)
[545.364024] [120/131] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[545.558933] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[545.560621] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[545.751113] [121/131] (497s left) vgem_basic (sysfs)
[545.830571] Starting subtest: sysfs
[545.831576] Subtest sysfs: SUCCESS (0.000s)
[545.939113] [122/131] (497s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[546.135569] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[546.137385] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[546.295717] [123/131] (497s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[546.485776] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[546.487566] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[546.648606] [124/131] (497s left) kms_chamelium_audio (hdmi-audio)
[546.947733] Subtest hdmi-audio: SKIP (0.000s)
[547.104525] [125/131] (496s left) core_getstats (basic)
[547.188026] Starting subtest: basic
[547.189280] Subtest basic: SUCCESS (0.000s)
[547.360143] [126/131] (496s left) syncobj_wait (wait-zero-handles)
[547.439711] Starting subtest: wait-zero-handles
[547.440676] Subtest wait-zero-handles: SUCCESS (0.000s)
[547.601437] [127/131] (496s left) prime_self_import (export-vs-gem_close-race)
[547.651022] Starting subtest: export-vs-gem_close-race
[552.743511] Subtest export-vs-gem_close-race: SUCCESS (5.093s)
[552.891051] [128/131] (491s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[553.120365] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[553.122254] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[553.315831] [129/131] (490s left) kms_cursor_edge_walk (64x64-right-edge)
[553.505710] Starting subtest: 64x64-right-edge
[553.506640] Starting dynamic subtest: pipe-A-DP-3
[556.973554] Dynamic subtest pipe-A-DP-3: SUCCESS (3.467s)
[556.992763] Starting dynamic subtest: pipe-D-DP-3
[560.310080] Dynamic subtest pipe-D-DP-3: SUCCESS (3.333s)
[560.311397] Subtest 64x64-right-edge: SUCCESS (6.805s)
[560.626796] [130/131] (483s left) perf_pmu (busy-double-start)
[560.700063] Starting subtest: busy-double-start
[560.701040] Starting dynamic subtest: rcs0
[564.312692] Dynamic subtest rcs0: SUCCESS (3.612s)
[564.328871] Starting dynamic subtest: bcs0
[567.904738] Dynamic subtest bcs0: SUCCESS (3.589s)
[567.921960] Starting dynamic subtest: vcs0
[571.523310] Dynamic subtest vcs0: SUCCESS (3.613s)
[571.539628] Starting dynamic subtest: vcs1
[575.123772] Dynamic subtest vcs1: SUCCESS (3.596s)
[575.141282] Starting dynamic subtest: vecs0
[578.738716] Dynamic subtest vecs0: SUCCESS (3.609s)
[578.755387] Starting dynamic subtest: vecs1
[582.344916] Dynamic subtest vecs1: SUCCESS (3.601s)
[582.362059] Starting dynamic subtest: ccs0
[585.944758] Dynamic subtest ccs0: SUCCESS (3.595s)
[585.945936] Subtest busy-double-start: SUCCESS (25.244s)
[586.125143] [131/131] (458s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[586.321704] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[586.323480] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[586.525577] 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.