[55.691558] Initializing watchdogs
[55.691604]   /dev/watchdog0
[55.706679] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[55.710887] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.713353] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.716954] [001/133] (960s left) gem_busy (extended)
[55.919210] Starting subtest: extended
[55.921689] Starting dynamic subtest: rcs0
[56.000855] Dynamic subtest rcs0: SUCCESS (0.082s)
[56.012646] Starting dynamic subtest: bcs0
[56.044242] Dynamic subtest bcs0: SUCCESS (0.043s)
[56.053694] Starting dynamic subtest: vcs0
[57.283866] Dynamic subtest vcs0: SUCCESS (1.237s)
[57.293202] Starting dynamic subtest: vcs1
[59.332965] Dynamic subtest vcs1: SUCCESS (2.048s)
[59.341566] Starting dynamic subtest: vecs0
[61.317844] Dynamic subtest vecs0: SUCCESS (1.983s)
[61.328038] Starting dynamic subtest: ccs0
[61.365801] Dynamic subtest ccs0: SUCCESS (0.048s)
[61.368304] Subtest extended: SUCCESS (5.447s)
[61.628040] [002/133] (954s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[61.728672] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[61.730982] Starting dynamic subtest: pipe-A-eDP-1
[61.753785] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.761810] Starting dynamic subtest: pipe-B-eDP-1
[61.783736] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.790784] Starting dynamic subtest: pipe-C-eDP-1
[61.812153] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.819082] Starting dynamic subtest: pipe-D-eDP-1
[61.841081] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.845171] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[63.968606] [003/133] (952s left) kms_frontbuffer_tracking (psr-2p-rte)
[64.064160] Starting subtest: psr-2p-rte
[64.068694] Subtest psr-2p-rte: SKIP (0.000s)
[64.165485] [004/133] (952s left) syncobj_wait (reset-during-wait-for-submit)
[64.228878] Starting subtest: reset-during-wait-for-submit
[64.334534] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[64.407361] [005/133] (951s left) gem_fenced_exec_thrash (too-many-fences)
[64.467882] Subtest too-many-fences: SKIP (0.000s)
[64.533489] [006/133] (951s left) gem_tiled_fence_blits (basic)
[64.589786] Subtest basic: SKIP (0.000s)
[64.653607] [007/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[64.752169] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[72.115735] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.367s)
[72.325893] [008/133] (944s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[72.466408] Starting subtest: psr-rgb101010-draw-render
[79.785274] Subtest psr-rgb101010-draw-render: SUCCESS (7.321s)
[79.906756] [009/133] (936s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[80.001619] Starting subtest: x-tiled-64bpp-rotate-90
[80.020939] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[80.142343] [010/133] (936s left) gem_eio (wait-1us)
[80.305864] Starting subtest: wait-1us
[80.511987] Subtest wait-1us: SUCCESS (0.206s)
[80.625490] [011/133] (935s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[80.715512] Starting subtest: fbc-psr-sprite-mmap-cpu
[80.717210] Starting dynamic subtest: eDP-1
[80.720741] Dynamic subtest eDP-1: SKIP (0.000s)
[80.724275] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[80.786606] [012/133] (935s left) gem_exec_schedule (manyslice)
[80.850612] Starting subtest: manyslice
[80.852333] Starting dynamic subtest: rcs0
[85.979784] Dynamic subtest rcs0: SUCCESS (5.131s)
[85.994783] Starting dynamic subtest: bcs0
[92.120045] Dynamic subtest bcs0: SUCCESS (6.139s)
[92.133571] Starting dynamic subtest: vcs0
[98.216629] Dynamic subtest vcs0: SUCCESS (6.096s)
[98.232128] Starting dynamic subtest: vcs1
[104.301082] Dynamic subtest vcs1: SUCCESS (6.083s)
[104.314182] Starting dynamic subtest: vecs0
[110.888069] Dynamic subtest vecs0: SUCCESS (6.587s)
[110.900711] Starting dynamic subtest: ccs0
[117.588906] Dynamic subtest ccs0: SUCCESS (6.699s)
[117.591834] Subtest manyslice: SUCCESS (36.740s)
[117.890250] [013/133] (898s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[117.948303] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[117.950825] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[118.040392] [014/133] (898s left) gem_exec_schedule (wide)
[118.226395] Starting subtest: wide
[118.228916] Starting dynamic subtest: rcs0
[129.108876] Dynamic subtest rcs0: SUCCESS (10.883s)
[129.117595] Starting dynamic subtest: vcs0
[141.549068] Dynamic subtest vcs0: SUCCESS (12.439s)
[141.560300] Starting dynamic subtest: vcs1
[153.402423] Dynamic subtest vcs1: SUCCESS (11.853s)
[153.414127] Starting dynamic subtest: vecs0
[165.158690] Dynamic subtest vecs0: SUCCESS (11.757s)
[165.167790] Starting dynamic subtest: ccs0
[179.614345] Dynamic subtest ccs0: SUCCESS (14.457s)
[179.616883] Subtest wide: SUCCESS (61.391s)
[181.224530] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[181.227700] [015/133] (835s left) kms_addfb_basic (small-bo)
[181.332829] Starting subtest: small-bo
[181.334682] Subtest small-bo: SUCCESS (0.000s)
[181.457281] [016/133] (835s left) gem_exec_balancer (full-late)
[181.516374] Starting subtest: full-late
[186.113733] Subtest full-late: SUCCESS (4.597s)
[186.447114] [017/133] (830s left) kms_pm_backlight (brightness-with-dpms)
[186.540064] Starting subtest: brightness-with-dpms
[186.619438] Starting dynamic subtest: eDP-1
[189.091614] Dynamic subtest eDP-1: SUCCESS (2.471s)
[189.093965] Subtest brightness-with-dpms: SUCCESS (2.553s)
[189.947081] [018/133] (826s left) api_intel_allocator (fork-simple-once)
[190.000583] Starting subtest: fork-simple-once
[190.015478] Subtest fork-simple-once: SUCCESS (0.016s)
[190.136344] [019/133] (826s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[190.230904] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[190.235231] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[190.309911] [020/133] (826s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[190.411264] Starting subtest: psr2-plane-move-sf-dmg-area
[190.413597] Starting dynamic subtest: pipe-A-eDP-1
[194.918348] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.513s)
[194.928222] Starting dynamic subtest: pipe-B-eDP-1
[200.244174] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.325s)
[200.246843] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.840s)
[201.131065] [021/133] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[201.235187] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[204.822532] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.590s)
[206.058425] [022/133] (810s left) kms_frontbuffer_tracking (fbc-2p-rte)
[206.151844] Starting subtest: fbc-2p-rte
[206.156493] Subtest fbc-2p-rte: SKIP (0.000s)
[206.240918] [023/133] (810s left) gem_exec_reloc (basic-cpu-wc)
[206.297993] Subtest basic-cpu-wc: SKIP (0.000s)
[206.357647] [024/133] (810s left) gem_tiled_blits (normal)
[206.416634] Subtest normal: SKIP (0.000s)
[206.482437] [025/133] (810s left) syncobj_timeline (wait-all-for-submit-complex)
[206.533119] Starting subtest: wait-all-for-submit-complex
[206.749052] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[206.825148] [026/133] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[206.914301] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[206.918758] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[207.024063] [027/133] (810s left) kms_dsc (dsc-with-output-formats-with-bpc)
[207.106485] Starting subtest: dsc-with-output-formats-with-bpc
[207.163984] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[207.201470] [028/133] (810s left) gem_exec_flush (basic-wb-rw-default)
[207.253317] Starting subtest: basic-wb-rw-default
[212.702880] Subtest basic-wb-rw-default: SUCCESS (5.452s)
[212.889501] [029/133] (804s left) kms_joiner (basic-big-joiner)
[212.999873] Starting subtest: basic-big-joiner
[213.004087] Subtest basic-big-joiner: SKIP (0.000s)
[213.065964] [030/133] (804s left) perf_pmu (render-node-busy-idle)
[213.135823] Starting subtest: render-node-busy-idle
[213.138281] Starting dynamic subtest: rcs0
[213.829865] Dynamic subtest rcs0: SUCCESS (0.694s)
[213.842145] Starting dynamic subtest: bcs0
[214.494068] Dynamic subtest bcs0: SUCCESS (0.663s)
[214.506254] Starting dynamic subtest: vcs0
[216.325430] Dynamic subtest vcs0: SUCCESS (1.828s)
[216.339396] Starting dynamic subtest: vcs1
[218.308257] Dynamic subtest vcs1: SUCCESS (1.982s)
[218.320735] Starting dynamic subtest: vecs0
[220.292722] Dynamic subtest vecs0: SUCCESS (1.983s)
[220.304191] Starting dynamic subtest: ccs0
[220.970913] Dynamic subtest ccs0: SUCCESS (0.677s)
[220.974224] Subtest render-node-busy-idle: SUCCESS (7.835s)
[221.045894] [031/133] (796s left) kms_addfb_basic (invalid-get-prop)
[221.098260] Starting subtest: invalid-get-prop
[221.100303] Subtest invalid-get-prop: SUCCESS (0.000s)
[221.243799] [032/133] (796s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[221.342090] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[221.346150] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[221.441483] [033/133] (796s left) i915_pm_rps (thresholds)
[221.505304] Starting subtest: thresholds
[221.509853] Subtest thresholds: SKIP (0.001s)
[221.615429] [034/133] (795s left) gem_mmap_wc (bad-offset)
[221.677157] Subtest bad-offset: SKIP (0.000s)
[221.738095] [035/133] (795s left) kms_rotation_crc (multiplane-rotation)
[221.826349] Starting subtest: multiplane-rotation
[239.263065] Subtest multiplane-rotation: SUCCESS (17.437s)
[239.366982] [036/133] (778s left) gem_softpin (evict-prime-sanity-check)
[239.424702] Starting subtest: evict-prime-sanity-check
[239.427101] Starting dynamic subtest: rcs0
[240.572869] Dynamic subtest rcs0: SUCCESS (1.148s)
[240.584510] Starting dynamic subtest: bcs0
[241.688732] Dynamic subtest bcs0: SUCCESS (1.115s)
[241.701054] Starting dynamic subtest: vcs0
[243.326895] Dynamic subtest vcs0: SUCCESS (1.634s)
[243.339352] Starting dynamic subtest: vcs1
[245.247088] Dynamic subtest vcs1: SUCCESS (1.919s)
[245.258214] Starting dynamic subtest: vecs0
[247.302452] Dynamic subtest vecs0: SUCCESS (2.053s)
[247.314384] Starting dynamic subtest: ccs0
[248.424146] Dynamic subtest ccs0: SUCCESS (1.121s)
[248.434337] Starting dynamic subtest: all
[249.547083] Dynamic subtest all: SUCCESS (1.121s)
[249.549626] Subtest evict-prime-sanity-check: SUCCESS (10.124s)
[249.632942] [037/133] (768s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[249.732602] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[249.736937] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[249.803505] [038/133] (767s left) kms_flip (flip-vs-expired-vblank-interruptible)
[249.893637] Starting subtest: flip-vs-expired-vblank-interruptible
[249.896073] Starting dynamic subtest: A-eDP1
[258.527907] Dynamic subtest A-eDP1: SUCCESS (8.634s)
[258.541561] Starting dynamic subtest: B-eDP1
[267.163818] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[267.177160] Starting dynamic subtest: C-eDP1
[275.792586] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[275.803256] Starting dynamic subtest: D-eDP1
[284.420117] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[284.422631] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.531s)
[285.601152] [039/133] (732s left) gem_ctx_shared (disjoint-timelines)
[285.657592] Starting subtest: disjoint-timelines
[285.685479] Subtest disjoint-timelines: SUCCESS (0.028s)
[285.908813] [040/133] (731s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[286.009572] Starting subtest: fbcpsr-rgb101010-draw-render
[292.768383] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.760s)
[292.890768] [041/133] (724s left) gem_exec_parallel (fds)
[292.947580] Starting subtest: fds
[292.949864] Starting dynamic subtest: rcs0
[295.806392] Dynamic subtest rcs0: SUCCESS (2.856s)
[295.818772] Starting dynamic subtest: bcs0
[300.095468] Dynamic subtest bcs0: SUCCESS (4.289s)
[300.107728] Starting dynamic subtest: vcs0
[305.348722] Dynamic subtest vcs0: SUCCESS (5.252s)
[305.358300] Starting dynamic subtest: vcs1
[309.539448] Dynamic subtest vcs1: SUCCESS (4.189s)
[309.549343] Starting dynamic subtest: vecs0
[313.585973] Dynamic subtest vecs0: SUCCESS (4.044s)
[313.598064] Starting dynamic subtest: ccs0
[318.228539] Dynamic subtest ccs0: SUCCESS (4.641s)
[318.231248] Subtest fds: SUCCESS (25.280s)
[318.424467] [042/133] (699s left) gem_readwrite (new-obj)
[318.483221] Subtest new-obj: SKIP (0.000s)
[318.553546] [043/133] (699s left) gem_mmap_wc (fault-concurrent)
[318.600726] Subtest fault-concurrent: SKIP (0.000s)
[318.664917] [044/133] (699s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[318.755461] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[319.812264] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.057s)
[319.948974] [045/133] (698s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[320.003840] Starting subtest: multi-wait-for-submit-available-signaled
[320.006876] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[320.100853] [046/133] (697s left) gem_exec_fence (basic-busy-all)
[320.161393] Starting subtest: basic-busy-all
[320.264452] Subtest basic-busy-all: SUCCESS (0.103s)
[322.407067] [047/133] (695s left) gem_lmem_swapping (parallel-random-verify-ccs)
[322.443853] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[322.489212] [048/133] (695s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[322.576839] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[322.579105] Starting dynamic subtest: pipe-A-eDP-1
[322.601216] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[322.613465] Starting dynamic subtest: pipe-B-eDP-1
[322.634657] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[322.644269] Starting dynamic subtest: pipe-C-eDP-1
[322.665174] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.677424] Starting dynamic subtest: pipe-D-eDP-1
[322.699282] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.703461] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[324.883297] [049/133] (693s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[324.981869] Starting subtest: pr-plane-move-sf-dmg-area
[324.986108] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[325.050871] [050/133] (693s left) kms_psr (fbc-psr2-sprite-blt)
[325.148028] Starting subtest: fbc-psr2-sprite-blt
[325.150279] Starting dynamic subtest: eDP-1
[325.154316] Dynamic subtest eDP-1: SKIP (0.000s)
[325.158453] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[325.225333] [051/133] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[325.328374] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[331.995503] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.669s)
[332.169331] [052/133] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[332.263463] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[332.267525] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[332.374934] [053/133] (685s left) gem_eio (wait-10ms)
[332.595792] Starting subtest: wait-10ms
[332.935999] Subtest wait-10ms: SUCCESS (0.341s)
[333.068038] [054/133] (685s left) kms_prime (basic-crc-vgem)
[333.148278] Starting subtest: basic-crc-vgem
[333.150268] Starting dynamic subtest: second-to-first
[334.135374] Dynamic subtest second-to-first: SUCCESS (0.989s)
[334.137344] Subtest basic-crc-vgem: SUCCESS (0.990s)
[334.242313] [055/133] (684s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[334.386027] Starting subtest: extended-modeset-hang-newfb-with-reset
[334.388077] Starting dynamic subtest: pipe-A
[348.491352] Dynamic subtest pipe-A: SUCCESS (14.104s)
[348.501088] Starting dynamic subtest: pipe-D
[364.072819] Dynamic subtest pipe-D: SUCCESS (15.577s)
[364.075105] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.686s)
[364.883299] [056/133] (653s left) kms_hdr (static-swap)
[364.986998] Starting subtest: static-swap
[364.993609] Subtest static-swap: SKIP (0.000s)
[365.061292] [057/133] (653s left) kms_content_protection (type1)
[365.200693] Starting subtest: type1
[365.205254] Subtest type1: SKIP (0.000s)
[365.328505] [058/133] (653s left) gem_flink_basic (double-flink)
[365.386188] Starting subtest: double-flink
[365.388320] Subtest double-flink: SUCCESS (0.000s)
[365.501552] [059/133] (653s left) gem_tiled_swapping (non-threaded)
[365.553250] Subtest non-threaded: SKIP (0.000s)
[365.608877] [060/133] (653s left) gem_render_copy (yf-tiled)
[365.669710] Starting subtest: yf-tiled
[365.674508] Subtest yf-tiled: SKIP (0.000s)
[365.868265] [061/133] (652s left) gem_exec_balancer (semaphore)
[365.926597] Starting subtest: semaphore
[367.291844] Subtest semaphore: SUCCESS (1.363s)
[367.612431] [062/133] (651s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[367.666838] Starting subtest: y-tiled-to-vebox-x-tiled
[367.671168] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[367.853063] [063/133] (650s left) gem_exec_fence (syncobj-timeline-wait)
[368.392695] Starting subtest: syncobj-timeline-wait
[369.286035] Subtest syncobj-timeline-wait: SUCCESS (0.893s)
[371.331786] [064/133] (647s left) kms_flip (dpms-vs-vblank-race)
[371.429081] Starting subtest: dpms-vs-vblank-race
[371.431403] Starting dynamic subtest: A-eDP1
[375.248957] Dynamic subtest A-eDP1: SUCCESS (3.818s)
[375.258554] Starting dynamic subtest: B-eDP1
[379.880352] Dynamic subtest B-eDP1: SUCCESS (4.630s)
[379.890048] Starting dynamic subtest: C-eDP1
[384.513217] Dynamic subtest C-eDP1: SUCCESS (4.633s)
[384.523121] Starting dynamic subtest: D-eDP1
[389.155727] Dynamic subtest D-eDP1: SUCCESS (4.642s)
[389.157875] Subtest dpms-vs-vblank-race: SUCCESS (17.733s)
[390.046762] [065/133] (628s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[390.109465] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[390.216095] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[390.302146] [066/133] (628s left) syncobj_timeline (invalid-transfer-bad-pad)
[390.349792] Starting subtest: invalid-transfer-bad-pad
[390.352097] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[390.461887] [067/133] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[390.561439] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[397.134288] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.575s)
[397.275517] [068/133] (621s left) kms_color (ctm-max)
[397.369018] Starting subtest: ctm-max
[397.371284] Starting dynamic subtest: pipe-A-eDP-1
[398.080732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[398.092314] Starting dynamic subtest: pipe-B-eDP-1
[399.476964] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s)
[399.487025] Starting dynamic subtest: pipe-C-eDP-1
[400.860676] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[400.870316] Starting dynamic subtest: pipe-D-eDP-1
[402.190028] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[402.192327] Subtest ctm-max: SUCCESS (4.821s)
[402.988452] [069/133] (616s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[403.087183] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[403.091515] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[403.168056] [070/133] (615s left) gem_eio (hibernate)
[403.388179] Starting subtest: hibernate
[418.211129] Subtest hibernate: SUCCESS (14.822s)
[427.362454] [071/133] (600s left) gem_wait (write-wait)
[427.434585] Starting subtest: write-wait
[427.437057] Starting dynamic subtest: all-engines
[428.566971] Dynamic subtest all-engines: SUCCESS (1.132s)
[428.584880] Starting dynamic subtest: rcs0
[429.625417] Dynamic subtest rcs0: SUCCESS (1.056s)
[429.641265] Starting dynamic subtest: bcs0
[430.685599] Dynamic subtest bcs0: SUCCESS (1.058s)
[430.702372] Starting dynamic subtest: vcs0
[431.744557] Dynamic subtest vcs0: SUCCESS (1.056s)
[431.763891] Starting dynamic subtest: vcs1
[432.800795] Dynamic subtest vcs1: SUCCESS (1.054s)
[432.819498] Starting dynamic subtest: vecs0
[433.855290] Dynamic subtest vecs0: SUCCESS (1.053s)
[433.872721] Starting dynamic subtest: ccs0
[434.911541] Dynamic subtest ccs0: SUCCESS (1.054s)
[434.914318] Subtest write-wait: SUCCESS (7.478s)
[435.111594] [072/133] (593s left) kms_async_flips (async-flip-dpms)
[435.223543] Starting subtest: async-flip-dpms
[435.600066] Starting dynamic subtest: pipe-A-eDP-1
[439.394409] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.796s)
[439.792060] Starting dynamic subtest: pipe-B-eDP-1
[442.571347] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.788s)
[442.964801] Starting dynamic subtest: pipe-C-eDP-1
[445.740084] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.784s)
[446.134115] Starting dynamic subtest: pipe-D-eDP-1
[448.921280] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.794s)
[448.923984] Subtest async-flip-dpms: SUCCESS (13.701s)
[450.103053] [073/133] (578s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[450.193989] Starting subtest: primary-yf-tiled-reflect-x-270
[450.198479] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[450.288570] [074/133] (577s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[450.380515] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[450.384970] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[450.482872] [075/133] (577s left) gem_exec_fence (syncobj-invalid-flags)
[450.892020] Starting subtest: syncobj-invalid-flags
[450.894561] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[452.394180] [076/133] (575s left) perf (non-zero-reason)
[452.517941] Starting subtest: non-zero-reason
[452.520330] Starting dynamic subtest: 0-rcs0
[457.897754] Dynamic subtest 0-rcs0: SUCCESS (5.378s)
[457.913833] Starting dynamic subtest: 1-vcs1
[461.794321] Dynamic subtest 1-vcs1: SUCCESS (3.895s)
[461.797059] Subtest non-zero-reason: SUCCESS (9.275s)
[461.846029] [077/133] (566s left) i915_pm_freq_api (freq-basic-api)
[461.910792] Starting subtest: freq-basic-api
[461.913295] Starting dynamic subtest: gt0
[461.919296] Dynamic subtest gt0: SUCCESS (0.005s)
[461.931910] Starting dynamic subtest: gt1
[461.934180] Dynamic subtest gt1: SUCCESS (0.004s)
[461.936405] Subtest freq-basic-api: SUCCESS (0.010s)
[462.045209] [078/133] (566s left) gem_mmap_gtt (ptrace)
[462.104754] Subtest ptrace: SKIP (0.000s)
[462.170898] [079/133] (566s left) kms_pipe_crc_basic (suspend-read-crc)
[462.264117] Starting subtest: suspend-read-crc
[462.266482] Starting dynamic subtest: pipe-A-eDP-1
[480.142760] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.585s)
[480.154558] Starting dynamic subtest: pipe-B-eDP-1
[498.122955] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.125s)
[498.139324] Starting dynamic subtest: pipe-C-eDP-1
[516.078044] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.017s)
[516.090144] Starting dynamic subtest: pipe-D-eDP-1
[534.089448] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.047s)
[534.091799] Subtest suspend-read-crc: SUCCESS (11.780s)
[534.909058] [080/133] (493s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[535.014967] Starting subtest: 4-tiled-64bpp-rotate-90
[535.034173] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.018s)
[535.151167] [081/133] (493s left) gem_partial_pwrite_pread (reads-uncached)
[535.209515] Subtest reads-uncached: SKIP (0.000s)
[535.284196] [082/133] (493s left) sysfs_heartbeat_interval (precise)
[535.353097] Starting subtest: precise
[535.355260] Starting dynamic subtest: vecs0
[543.357018] Dynamic subtest vecs0: SUCCESS (7.992s)
[543.370073] Starting dynamic subtest: ccs0
[544.478757] Dynamic subtest ccs0: SUCCESS (1.121s)
[544.492851] Starting dynamic subtest: vcs0
[551.300474] Dynamic subtest vcs0: SUCCESS (6.814s)
[551.315446] Starting dynamic subtest: bcs0
[552.423473] Dynamic subtest bcs0: SUCCESS (1.119s)
[552.437243] Starting dynamic subtest: rcs0
[553.531780] Dynamic subtest rcs0: SUCCESS (1.107s)
[553.546180] Starting dynamic subtest: vcs1
[561.352603] Dynamic subtest vcs1: SUCCESS (7.816s)
[561.355830] Subtest precise: SUCCESS (25.980s)
[561.432611] [083/133] (467s left) gem_ctx_exec (basic-close-race)
[561.490670] Starting subtest: basic-close-race
[567.179043] Subtest basic-close-race: SUCCESS (5.688s)
[567.298787] [084/133] (461s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[567.616887] Starting subtest: cursor-rapid-movement-max-size
[567.623560] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[567.753622] [085/133] (460s left) kms_psr (pr-no-drrs)
[567.844406] Starting subtest: pr-no-drrs
[567.848971] Subtest pr-no-drrs: SKIP (0.000s)
[567.918833] [086/133] (460s left) gem_userptr_blits (process-exit-busy)
[567.980313] Starting subtest: process-exit-busy
[567.988521] Subtest process-exit-busy: SUCCESS (0.012s)
[568.111094] [087/133] (460s left) gem_ctx_persistence (engines-mixed-process)
[568.177011] Starting subtest: engines-mixed-process
[568.178928] Starting dynamic subtest: rcs0
[569.292832] Dynamic subtest rcs0: SUCCESS (1.118s)
[569.306883] Starting dynamic subtest: bcs0
[571.317055] Dynamic subtest bcs0: SUCCESS (2.020s)
[571.328348] Starting dynamic subtest: vcs0
[573.316114] Dynamic subtest vcs0: SUCCESS (2.001s)
[573.329549] Starting dynamic subtest: vcs1
[575.321847] Dynamic subtest vcs1: SUCCESS (2.004s)
[575.335294] Starting dynamic subtest: vecs0
[577.363745] Dynamic subtest vecs0: SUCCESS (2.040s)
[577.377724] Starting dynamic subtest: ccs0
[579.336798] Dynamic subtest ccs0: SUCCESS (1.971s)
[579.339339] Subtest engines-mixed-process: SUCCESS (11.164s)
[579.434645] [088/133] (449s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[579.538578] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[579.542682] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[579.630505] [089/133] (449s left) kms_psr (psr-cursor-mmap-cpu)
[579.725769] Starting subtest: psr-cursor-mmap-cpu
[579.728041] Starting dynamic subtest: eDP-1
[581.424065] Dynamic subtest eDP-1: SUCCESS (1.696s)
[581.426060] Subtest psr-cursor-mmap-cpu: SUCCESS (1.697s)
[582.289546] [090/133] (446s left) gem_exec_schedule (preempt-self)
[582.362585] Starting subtest: preempt-self
[582.364638] Starting dynamic subtest: rcs0
[582.374152] Dynamic subtest rcs0: SUCCESS (0.020s)
[582.385752] Starting dynamic subtest: bcs0
[582.402934] Dynamic subtest bcs0: SUCCESS (0.028s)
[582.413830] Starting dynamic subtest: vcs0
[582.422779] Dynamic subtest vcs0: SUCCESS (0.019s)
[582.433972] Starting dynamic subtest: vcs1
[582.442137] Dynamic subtest vcs1: SUCCESS (0.019s)
[582.456362] Starting dynamic subtest: vecs0
[582.469736] Dynamic subtest vecs0: SUCCESS (0.027s)
[582.481105] Starting dynamic subtest: ccs0
[582.492366] Dynamic subtest ccs0: SUCCESS (0.022s)
[582.494647] Subtest preempt-self: SUCCESS (0.139s)
[584.417638] [091/133] (444s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[584.476322] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[584.582263] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[584.658664] [092/133] (444s left) kms_flip (flip-vs-absolute-wf_vblank)
[584.758594] Starting subtest: flip-vs-absolute-wf_vblank
[584.760967] Starting dynamic subtest: A-eDP1
[593.650702] Dynamic subtest A-eDP1: SUCCESS (8.893s)
[593.663094] Starting dynamic subtest: B-eDP1
[602.584648] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[602.595781] Starting dynamic subtest: C-eDP1
[611.509750] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[611.523117] Starting dynamic subtest: D-eDP1
[620.447907] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[620.450231] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.685s)
[621.693645] [093/133] (407s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[621.794047] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[621.796226] Starting dynamic subtest: pipe-A
[622.957098] Dynamic subtest pipe-A: SUCCESS (1.164s)
[622.967831] Starting dynamic subtest: pipe-B
[625.199454] Dynamic subtest pipe-B: SUCCESS (2.240s)
[625.211906] Starting dynamic subtest: pipe-C
[626.385897] Dynamic subtest pipe-C: SUCCESS (1.184s)
[626.397657] Starting dynamic subtest: pipe-D
[627.519143] Dynamic subtest pipe-D: SUCCESS (1.133s)
[627.521481] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.725s)
[628.721883] [094/133] (400s left) sw_sync (sync_multi_consumer_producer)
[628.759078] Starting subtest: sync_multi_consumer_producer
[629.069533] Subtest sync_multi_consumer_producer: SUCCESS (0.310s)
[629.134872] [095/133] (399s left) gem_readwrite (write-bad-handle)
[629.185835] Subtest write-bad-handle: SKIP (0.000s)
[629.242418] [096/133] (399s left) kms_chamelium_color (ctm-limited-range)
[629.331171] Subtest ctm-limited-range: SKIP (0.000s)
[629.379250] [097/133] (399s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[629.473661] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[629.478041] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[629.593318] [098/133] (399s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[629.677226] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[629.679443] Starting dynamic subtest: pipe-A-eDP-1
[629.699897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[629.712374] Starting dynamic subtest: pipe-B-eDP-1
[629.732257] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[629.743288] Starting dynamic subtest: pipe-C-eDP-1
[629.762606] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[629.773354] Starting dynamic subtest: pipe-D-eDP-1
[629.793507] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[629.795472] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[632.080426] [099/133] (397s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[632.461764] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[633.286669] [100/133] (396s left) kms_sequence (get-forked)
[633.384678] Starting subtest: get-forked
[633.386810] Starting dynamic subtest: pipe-A-eDP-1
[635.265122] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[635.277866] Starting dynamic subtest: pipe-B-eDP-1
[637.845907] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.579s)
[637.857792] Starting dynamic subtest: pipe-C-eDP-1
[640.353581] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.505s)
[640.364894] Starting dynamic subtest: pipe-D-eDP-1
[642.902420] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s)
[642.904808] Subtest get-forked: SUCCESS (9.520s)
[643.733921] [101/133] (385s left) gem_lmem_swapping (heavy-verify-multi)
[643.783911] Subtest heavy-verify-multi: SKIP (0.000s)
[643.832803] [102/133] (385s left) api_intel_bb (intel-bb-blit-y)
[643.887581] Starting subtest: intel-bb-blit-y
[647.618229] Subtest intel-bb-blit-y: SUCCESS (3.731s)
[647.744395] [103/133] (381s left) kms_cursor_crc (cursor-tearing-position-change)
[647.851779] Starting subtest: cursor-tearing-position-change
[647.854221] Starting dynamic subtest: pipe-A-eDP-1
[648.412531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.559s)
[648.423793] Starting dynamic subtest: pipe-D-eDP-1
[649.651642] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[649.654103] Subtest cursor-tearing-position-change: SUCCESS (1.800s)
[650.481718] [104/133] (379s left) i915_suspend (fence-restore-untiled)
[650.548679] Starting subtest: fence-restore-untiled
[650.553325] Subtest fence-restore-untiled: SKIP (0.000s)
[650.638424] [105/133] (378s left) kms_addfb_basic (addfb25-modifier-no-flag)
[650.728935] Starting subtest: addfb25-modifier-no-flag
[650.731219] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[650.831437] [106/133] (378s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[650.933668] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[650.937920] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[651.044446] [107/133] (378s left) kms_chamelium_hpd (vga-hpd)
[651.427250] Subtest vga-hpd: SKIP (0.000s)
[652.206657] [108/133] (377s left) drm_read (short-buffer-wakeup)
[652.347643] Starting subtest: short-buffer-wakeup
[684.565118] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[684.716245] [109/133] (345s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[684.816284] Starting subtest: y-tiled-32bpp-rotate-90
[684.820296] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[684.937963] [110/133] (344s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[685.041072] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[685.045546] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[685.146192] [111/133] (344s left) i915_drm_fdinfo (most-busy-check-all)
[685.181846] Starting subtest: most-busy-check-all
[685.183852] Starting dynamic subtest: rcs0
[685.188622] Dynamic subtest rcs0: SKIP (0.004s)
[685.200525] Starting dynamic subtest: bcs0
[685.205161] Dynamic subtest bcs0: SKIP (0.000s)
[685.216166] Starting dynamic subtest: vcs0
[685.220197] Dynamic subtest vcs0: SKIP (0.000s)
[685.230318] Starting dynamic subtest: vcs1
[685.234487] Dynamic subtest vcs1: SKIP (0.000s)
[685.245979] Starting dynamic subtest: vecs0
[685.250142] Dynamic subtest vecs0: SKIP (0.000s)
[685.260287] Starting dynamic subtest: ccs0
[685.264297] Dynamic subtest ccs0: SKIP (0.000s)
[685.268252] Subtest most-busy-check-all: SKIP (0.009s)
[685.307450] [112/133] (344s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[685.439564] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[692.244067] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.806s)
[692.382280] [113/133] (337s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[692.481248] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[692.485095] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[692.575391] [114/133] (337s left) perf (polling-small-buf)
[692.657640] Starting subtest: polling-small-buf
[692.748454] Subtest polling-small-buf: SUCCESS (0.088s)
[692.797281] [115/133] (337s left) kms_plane_multiple (tiling-x)
[692.880802] Starting subtest: tiling-x
[692.883106] Starting dynamic subtest: pipe-A-eDP-1
[696.560390] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.679s)
[696.573367] Starting dynamic subtest: pipe-B-eDP-1
[700.998775] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.434s)
[701.009937] Starting dynamic subtest: pipe-C-eDP-1
[705.327078] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.327s)
[705.339497] Starting dynamic subtest: pipe-D-eDP-1
[709.682759] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.354s)
[709.685708] Subtest tiling-x: SUCCESS (16.799s)
[710.506671] [116/133] (319s left) gen9_exec_parse (bb-start-cmd)
[710.568522] Subtest bb-start-cmd: SKIP (0.000s)
[710.629235] [117/133] (319s left) kms_cursor_crc (cursor-offscreen-512x512)
[710.922372] Starting subtest: cursor-offscreen-512x512
[710.927027] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[711.076883] [118/133] (319s left) gem_ctx_shared (create-shared-gtt)
[711.137293] Starting subtest: create-shared-gtt
[713.291479] Subtest create-shared-gtt: SUCCESS (2.153s)
[713.615061] [119/133] (316s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[713.708349] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[713.721087] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[713.814449] [120/133] (316s left) kms_dp_linktrain_fallback (dsc-fallback)
[713.896128] Starting subtest: dsc-fallback
[713.902143] Subtest dsc-fallback: SKIP (0.000s)
[713.970972] [121/133] (316s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[714.068286] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[714.070567] Starting dynamic subtest: pipe-A-eDP-1
[714.093759] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[714.106669] Starting dynamic subtest: pipe-B-eDP-1
[714.129170] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[714.141781] Starting dynamic subtest: pipe-C-eDP-1
[714.162658] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[714.173293] Starting dynamic subtest: pipe-D-eDP-1
[714.195337] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[714.199384] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[716.357141] [122/133] (313s left) syncobj_wait (single-wait-all-submitted)
[716.413645] Starting subtest: single-wait-all-submitted
[716.517650] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[716.612285] [123/133] (313s left) kms_atomic (atomic-invalid-params)
[716.694183] Starting subtest: atomic-invalid-params
[716.696543] Starting dynamic subtest: pipe-A-eDP-1
[717.096724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[717.098871] Subtest atomic-invalid-params: SUCCESS (0.402s)
[717.897866] [124/133] (312s left) perf_pmu (all-busy-check-all)
[717.937672] Starting subtest: all-busy-check-all
[719.363501] Subtest all-busy-check-all: SUCCESS (1.423s)
[719.469269] [125/133] (310s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[719.560555] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[719.565066] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[719.682481] [126/133] (310s left) kms_lease (lease-invalid-connector)
[719.771335] Starting subtest: lease-invalid-connector
[719.773606] Starting dynamic subtest: pipe-A-eDP-1
[719.775904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[719.787921] Starting dynamic subtest: pipe-B-eDP-1
[719.789824] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[719.800831] Starting dynamic subtest: pipe-C-eDP-1
[719.803127] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[719.813779] Starting dynamic subtest: pipe-D-eDP-1
[719.815923] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[719.818044] Subtest lease-invalid-connector: SUCCESS (0.004s)
[719.856123] [127/133] (310s left) gem_madvise (dontneed-after-mmap)
[719.891108] Starting subtest: dontneed-after-mmap
[719.916840] Subtest dontneed-after-mmap: SUCCESS (0.028s)
[720.039474] [128/133] (310s left) kms_flip (flip-vs-suspend-interruptible)
[720.132261] Starting subtest: flip-vs-suspend-interruptible
[720.134669] Starting dynamic subtest: A-eDP1
[865.214497] Dynamic subtest A-eDP1: SUCCESS (11.182s)
[865.216860] Subtest flip-vs-suspend-interruptible: SUCCESS (11.184s)
[865.356505] [129/133] (165s left) kms_vblank (wait-forked-busy)
[865.468542] Starting subtest: wait-forked-busy
[865.470782] Starting dynamic subtest: pipe-A-eDP-1
[867.340261] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[867.356102] Starting dynamic subtest: pipe-D-eDP-1
[869.918277] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.579s)
[869.920703] Subtest wait-forked-busy: SUCCESS (4.459s)
[870.718351] [130/133] (159s left) kms_big_fb (linear-32bpp-rotate-180)
[870.829229] Starting subtest: linear-32bpp-rotate-180
[872.361592] Subtest linear-32bpp-rotate-180: SUCCESS (1.534s)
[872.519664] [131/133] (158s left) gen3_render_tiledx_blits
[872.643512] [132/133] (158s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[872.734430] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[879.803480] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.077s)
[879.923809] [133/133] (150s left) kms_plane_scaling (planes-scaler-unity-scaling)
[880.003243] Starting subtest: planes-scaler-unity-scaling
[880.005501] Starting dynamic subtest: pipe-A
[880.064706] Dynamic subtest pipe-A: SUCCESS (0.063s)
[880.077858] Starting dynamic subtest: pipe-B
[881.186878] Dynamic subtest pipe-B: SUCCESS (1.120s)
[881.201910] Starting dynamic subtest: pipe-C
[882.311324] Dynamic subtest pipe-C: SUCCESS (1.124s)
[882.325159] Starting dynamic subtest: pipe-D
[883.435052] Dynamic subtest pipe-D: SUCCESS (1.123s)
[883.437508] Subtest planes-scaler-unity-scaling: SUCCESS (3.435s)
[884.603637] Closing watchdogs
results: parsing output: 0/ for test: gem_busy
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_fenced_exec_thrash
results: parsing output: 5/ for test: gem_tiled_fence_blits
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: kms_pm_backlight
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: gem_tiled_blits
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_dsc
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_joiner
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rps
results: parsing output: 33/ for test: gem_mmap_wc
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_ctx_shared
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_parallel
results: parsing output: 41/ for test: gem_readwrite
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: kms_prime
results: parsing output: 54/ for test: kms_busy
results: parsing output: 55/ for test: kms_hdr
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: gem_flink_basic
results: parsing output: 58/ for test: gem_tiled_swapping
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_color
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: gem_wait
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: kms_rotation_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: i915_pm_freq_api
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_pipe_crc_basic
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: gem_ctx_exec
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: gem_readwrite
results: parsing output: 95/ for test: kms_chamelium_color
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: kms_sequence
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: i915_suspend
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: i915_drm_fdinfo
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_plane_multiple
results: parsing output: 115/ for test: gen9_exec_parse
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: gem_ctx_shared
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_dp_linktrain_fallback
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_atomic
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: gem_madvise
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gen3_render_tiledx_blits
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
Done.