[58.622963] Initializing watchdogs
[58.623034]   /dev/watchdog0
[58.642670] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[58.653790] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[58.657700] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.660227] [001/132] (960s left) core_auth (many-magics)
[58.732363] Starting subtest: many-magics
[60.583153] Subtest many-magics: SUCCESS (1.841s)
[60.908797] [002/132] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[61.107831] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[61.109489] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[61.277963] [003/132] (958s left) kms_cursor_crc (cursor-offscreen-128x42)
[61.679247] Starting subtest: cursor-offscreen-128x42
[61.694680] Starting dynamic subtest: pipe-A-DP-3
[64.256991] Dynamic subtest pipe-A-DP-3: SUCCESS (2.561s)
[64.303373] Starting dynamic subtest: pipe-D-DP-3
[66.718270] Dynamic subtest pipe-D-DP-3: SUCCESS (2.422s)
[66.719215] Subtest cursor-offscreen-128x42: SUCCESS (5.039s)
[67.171864] [004/132] (952s left) kms_cursor_crc (cursor-onscreen-64x21)
[67.784994] Starting subtest: cursor-onscreen-64x21
[67.789264] Starting dynamic subtest: pipe-A-DP-3
[70.502571] Dynamic subtest pipe-A-DP-3: SUCCESS (2.712s)
[70.554561] Starting dynamic subtest: pipe-D-DP-3
[73.253609] Dynamic subtest pipe-D-DP-3: SUCCESS (2.707s)
[73.254598] Subtest cursor-onscreen-64x21: SUCCESS (5.469s)
[73.732356] [005/132] (945s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[73.919395] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[73.921144] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[74.107600] [006/132] (945s left) sysfs_preempt_timeout (timeout)
[74.187173] Starting subtest: timeout
[74.188171] Starting dynamic subtest: vecs0
[76.030278] Dynamic subtest vecs0: SUCCESS (1.842s)
[76.039197] Starting dynamic subtest: ccs0
[77.830192] Dynamic subtest ccs0: SUCCESS (1.800s)
[77.838518] Starting dynamic subtest: vcs0
[79.542137] Dynamic subtest vcs0: SUCCESS (1.712s)
[79.550630] Starting dynamic subtest: bcs0
[81.199153] Dynamic subtest bcs0: SUCCESS (1.657s)
[81.207697] Starting dynamic subtest: vecs1
[82.888247] Dynamic subtest vecs1: SUCCESS (1.689s)
[82.896991] Starting dynamic subtest: rcs0
[84.562396] Dynamic subtest rcs0: SUCCESS (1.674s)
[84.571264] Starting dynamic subtest: vcs1
[86.183555] Dynamic subtest vcs1: SUCCESS (1.621s)
[86.184623] Subtest timeout: SUCCESS (11.997s)
[86.374562] [007/132] (933s left) gen3_render_mixed_blits
[86.520376] [008/132] (933s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[86.718215] Starting subtest: yf-tiled-16bpp-rotate-270
[86.720130] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[86.907240] [009/132] (932s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[87.097434] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[87.099229] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[87.308954] [010/132] (932s left) dmabuf_sync_file (export-multiwait)
[87.432272] Starting subtest: export-multiwait
[87.433227] Subtest export-multiwait: SUCCESS (0.001s)
[87.570462] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[87.572121] [011/132] (932s left) kms_fbcon_fbt (psr-suspend)
[87.656184] Starting subtest: psr-suspend
[87.658021] Subtest psr-suspend: SKIP (0.000s)
[87.841819] [012/132] (932s left) gem_vm_create (invalid-create)
[87.937428] Starting subtest: invalid-create
[87.942428] Subtest invalid-create: SUCCESS (0.005s)
[88.110512] [013/132] (931s left) kms_pm_dc (dc5-retention-flops)
[89.309843] Starting subtest: dc5-retention-flops
[89.311636] Subtest dc5-retention-flops: SKIP (0.000s)
[89.463161] [014/132] (930s left) kms_vblank (wait-forked)
[89.652343] Starting subtest: wait-forked
[89.653298] Starting dynamic subtest: pipe-A-DP-3
[92.023250] Dynamic subtest pipe-A-DP-3: SUCCESS (2.369s)
[92.046128] Starting dynamic subtest: pipe-D-DP-3
[94.352920] Dynamic subtest pipe-D-DP-3: SUCCESS (2.320s)
[94.354076] Subtest wait-forked: SUCCESS (4.700s)
[94.661452] [015/132] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[94.861829] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[94.870955] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[95.058963] [016/132] (925s left) kms_sequence (get-forked)
[95.248983] Starting subtest: get-forked
[95.249940] Starting dynamic subtest: pipe-A-DP-3
[97.701391] Dynamic subtest pipe-A-DP-3: SUCCESS (2.451s)
[97.710421] Starting dynamic subtest: pipe-B-DP-3
[100.060479] Dynamic subtest pipe-B-DP-3: SUCCESS (2.358s)
[100.069939] Starting dynamic subtest: pipe-C-DP-3
[102.425409] Dynamic subtest pipe-C-DP-3: SUCCESS (2.365s)
[102.436691] Starting dynamic subtest: pipe-D-DP-3
[104.780507] Dynamic subtest pipe-D-DP-3: SUCCESS (2.354s)
[104.781485] Subtest get-forked: SUCCESS (9.532s)
[105.083051] [017/132] (915s left) syncobj_timeline (single-wait-available-submitted)
[105.163146] Starting subtest: single-wait-available-submitted
[105.164200] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[105.344893] [018/132] (915s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[105.540820] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[105.542492] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[105.748492] [019/132] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[105.942598] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[105.944298] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[106.127939] [020/132] (914s left) gem_exec_params (invalid-bsd2-flag-on-render)
[106.212827] Starting subtest: invalid-bsd2-flag-on-render
[106.213780] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[106.397057] [021/132] (914s left) gem_exec_params (secure-non-root)
[106.480656] Starting subtest: secure-non-root
[106.482449] Subtest secure-non-root: SKIP (0.000s)
[106.661542] [022/132] (914s left) gem_pxp (hw-rejects-pxp-context)
[109.271253] Starting subtest: hw-rejects-pxp-context
[109.273190] Subtest hw-rejects-pxp-context: SUCCESS (0.005s)
[109.421816] [023/132] (911s left) kms_vrr (max-min)
[109.611446] Starting subtest: max-min
[109.614165] Subtest max-min: SKIP (0.000s)
[109.772223] [024/132] (911s left) gem_mmap_gtt (zero-extend)
[109.851166] Subtest zero-extend: SKIP (0.000s)
[109.931152] [025/132] (911s left) gem_ctx_persistence (legacy-engines-mixed)
[110.016931] Starting subtest: legacy-engines-mixed
[110.017845] Starting dynamic subtest: render
[110.127406] Dynamic subtest render: SUCCESS (0.110s)
[110.137066] Starting dynamic subtest: bsd1
[110.187413] Dynamic subtest bsd1: SUCCESS (0.059s)
[110.203579] Starting dynamic subtest: bsd2
[110.254393] Dynamic subtest bsd2: SUCCESS (0.065s)
[110.287590] Starting dynamic subtest: blt
[110.323354] Dynamic subtest blt: SUCCESS (0.068s)
[110.335397] Starting dynamic subtest: vebox
[110.393197] Dynamic subtest vebox: SUCCESS (0.068s)
[110.395253] Subtest legacy-engines-mixed: SUCCESS (0.376s)
[110.615071] [026/132] (910s left) gem_ctx_persistence (engines-hostile)
[110.704437] Starting subtest: engines-hostile
[110.705385] Starting dynamic subtest: rcs0
[110.859438] Dynamic subtest rcs0: SUCCESS (0.154s)
[110.870469] Starting dynamic subtest: bcs0
[110.956281] Dynamic subtest bcs0: SUCCESS (0.096s)
[110.992029] Starting dynamic subtest: vcs0
[111.022874] Dynamic subtest vcs0: SUCCESS (0.066s)
[111.047633] Starting dynamic subtest: vcs1
[111.077860] Dynamic subtest vcs1: SUCCESS (0.054s)
[111.100924] Starting dynamic subtest: vecs0
[111.137375] Dynamic subtest vecs0: SUCCESS (0.059s)
[111.147620] Starting dynamic subtest: vecs1
[111.157227] Dynamic subtest vecs1: SUCCESS (0.020s)
[111.168663] Starting dynamic subtest: ccs0
[111.274387] Dynamic subtest ccs0: SUCCESS (0.116s)
[111.276269] Subtest engines-hostile: SUCCESS (0.570s)
[111.482603] [027/132] (909s left) gem_exec_reloc (basic-gtt)
[111.565498] Subtest basic-gtt: SKIP (0.000s)
[111.629219] [028/132] (909s left) gem_mmap_gtt (basic-read-write)
[111.707969] Subtest basic-read-write: SKIP (0.000s)
[111.778938] [029/132] (909s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[111.976438] Starting subtest: psr-rgb565-draw-mmap-cpu
[111.978238] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[112.169391] [030/132] (909s left) syncobj_timeline (invalid-signal-illegal-handle)
[112.256538] Starting subtest: invalid-signal-illegal-handle
[112.257489] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[112.417650] [031/132] (908s left) gem_pxp (create-regular-context-2)
[115.020101] Starting subtest: create-regular-context-2
[115.023137] Subtest create-regular-context-2: SKIP (0.000s)
[115.164924] [032/132] (906s left) kms_flip (2x-plain-flip-fb-recreate)
[115.355064] Starting subtest: 2x-plain-flip-fb-recreate
[115.370135] Subtest 2x-plain-flip-fb-recreate: SKIP (0.015s)
[115.511188] [033/132] (905s left) gem_busy (semaphore)
[115.754434] Subtest semaphore: SKIP (0.000s)
[116.049428] [034/132] (905s left) gem_lmem_swapping (verify)
[118.861022] Starting subtest: verify
[118.861854] Starting dynamic subtest: lmem0
[155.616345] Dynamic subtest lmem0: SUCCESS (36.755s)
[155.617308] Subtest verify: SUCCESS (36.756s)
[157.038121] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[157.039192] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[157.041179] [035/132] (864s left) gem_exec_params (mmapped)
[158.637871] Starting subtest: mmapped
[158.640589] Subtest mmapped: SUCCESS (0.005s)
[158.754963] [FACT gem_exec_params (mmapped)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[158.757330] [FACT gem_exec_params (mmapped)] new: kernel.kmod_is_loaded.i915: true
[158.759950] [036/132] (862s left) gem_exec_balancer (sliced)
[158.847333] Starting subtest: sliced
[158.849388] Subtest sliced: SKIP (0.000s)
[159.289607] [037/132] (862s left) kms_async_flips (async-flip-hang)
[159.480433] Starting subtest: async-flip-hang
[159.697752] Starting dynamic subtest: pipe-A-DP-3
[174.511374] Dynamic subtest pipe-A-DP-3: SUCCESS (14.812s)
[174.725815] Starting dynamic subtest: pipe-B-DP-3
[189.489367] Dynamic subtest pipe-B-DP-3: SUCCESS (14.771s)
[189.658445] Starting dynamic subtest: pipe-C-DP-3
[214.511420] Dynamic subtest pipe-C-DP-3: SUCCESS (24.860s)
[214.692239] Starting dynamic subtest: pipe-D-DP-3
[229.486341] Dynamic subtest pipe-D-DP-3: SUCCESS (14.803s)
[229.487355] Subtest async-flip-hang: SUCCESS (70.002s)
[229.961626] [038/132] (791s left) gem_exec_schedule (u-semaphore-noskip)
[230.054168] Starting subtest: u-semaphore-noskip
[230.952355] Subtest u-semaphore-noskip: SUCCESS (0.899s)
[231.378616] [039/132] (790s left) kms_flip (plain-flip-fb-recreate)
[231.567938] Starting subtest: plain-flip-fb-recreate
[231.571168] Starting dynamic subtest: A-DP3
[239.689514] Dynamic subtest A-DP3: SUCCESS (8.117s)
[239.727737] Starting dynamic subtest: B-DP3
[247.776276] Dynamic subtest B-DP3: SUCCESS (8.083s)
[247.814064] Starting dynamic subtest: C-DP3
[255.864180] Dynamic subtest C-DP3: SUCCESS (8.084s)
[255.898948] Starting dynamic subtest: D-DP3
[263.935116] Dynamic subtest D-DP3: SUCCESS (8.067s)
[263.942545] Subtest plain-flip-fb-recreate: SUCCESS (32.374s)
[264.331696] [040/132] (757s left) gen7_exec_parse (basic-rejected)
[264.416042] Subtest basic-rejected: SKIP (0.000s)
[264.509125] [041/132] (757s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[264.704285] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[264.705212] Starting dynamic subtest: pipe-A-DP-3
[264.726991] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[264.736230] Starting dynamic subtest: pipe-B-DP-3
[264.758396] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[264.767533] Starting dynamic subtest: pipe-C-DP-3
[264.794531] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[264.803496] Starting dynamic subtest: pipe-D-DP-3
[264.826042] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[264.827462] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.013s)
[265.223338] [042/132] (756s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[265.308531] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[265.310480] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[265.530900] [043/132] (756s left) perf (per-context-mode-unprivileged)
[265.957936] Starting subtest: per-context-mode-unprivileged
[265.959702] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[266.006848] [044/132] (756s left) gem_exec_fence (syncobj-channel)
[266.555461] Starting subtest: syncobj-channel
[267.576160] Subtest syncobj-channel: SUCCESS (1.020s)
[267.993723] [045/132] (754s left) kms_addfb_basic (addfb25-modifier-no-flag)
[268.185922] Starting subtest: addfb25-modifier-no-flag
[268.186860] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[268.389391] [046/132] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[268.597008] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[268.598761] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[268.810721] [047/132] (753s left) gem_ctx_bad_destroy (invalid-pad)
[268.884597] Starting subtest: invalid-pad
[268.885554] Subtest invalid-pad: SUCCESS (0.000s)
[269.027958] [048/132] (753s left) kms_chamelium_color (ctm-0-25)
[269.217394] Subtest ctm-0-25: SKIP (0.000s)
[269.271629] [049/132] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[269.472998] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[269.474817] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[269.658227] [050/132] (752s left) gem_exec_reloc (basic-cpu-wc)
[269.747620] Subtest basic-cpu-wc: SKIP (0.000s)
[269.851895] [051/132] (752s left) kms_flip (2x-flip-vs-dpms-on-nop)
[270.041820] Starting subtest: 2x-flip-vs-dpms-on-nop
[270.057028] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.015s)
[270.202719] [052/132] (752s left) kms_prime (basic-crc-hybrid)
[270.396166] Subtest basic-crc-hybrid: SKIP (0.000s)
[270.608163] [053/132] (752s left) kms_content_protection (content-type-change)
[270.867714] Starting subtest: content-type-change
[270.874120] Subtest content-type-change: SKIP (0.003s)
[271.094323] [054/132] (751s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[271.287320] Starting subtest: cursorB-vs-flipA-atomic-transitions
[271.290209] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[271.443560] [055/132] (751s left) kms_cursor_edge_walk (64x64-right-edge)
[271.633563] Starting subtest: 64x64-right-edge
[271.635936] Starting dynamic subtest: pipe-A-DP-3
[275.125014] Dynamic subtest pipe-A-DP-3: SUCCESS (3.489s)
[275.138269] Starting dynamic subtest: pipe-D-DP-3
[278.457186] Dynamic subtest pipe-D-DP-3: SUCCESS (3.329s)
[278.458219] Subtest 64x64-right-edge: SUCCESS (6.823s)
[278.758878] [056/132] (744s left) kms_busy (extended-pageflip-hang-newfb)
[278.957952] Starting subtest: extended-pageflip-hang-newfb
[278.960148] Starting dynamic subtest: pipe-A
[286.859412] Dynamic subtest pipe-A: SUCCESS (7.896s)
[286.881452] Starting dynamic subtest: pipe-D
[294.747364] Dynamic subtest pipe-D: SUCCESS (7.880s)
[294.748326] Subtest extended-pageflip-hang-newfb: SUCCESS (15.789s)
[295.012402] [057/132] (728s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[295.215927] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[295.268242] [058/132] (727s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[295.353990] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[295.455642] [059/132] (727s left) kms_psr (psr2-primary-mmap-cpu)
[295.649440] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[295.717148] [060/132] (727s left) kms_fbcon_fbt (fbc-suspend)
[295.803007] Starting subtest: fbc-suspend
[347.538973] Subtest fbc-suspend: SUCCESS (21.453s)
[347.619091] [061/132] (675s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[347.812095] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[347.908089] [062/132] (675s left) i915_drm_fdinfo (isolation)
[347.978785] Starting subtest: isolation
[347.979774] Starting dynamic subtest: rcs0
[347.981672] Dynamic subtest rcs0: SKIP (0.000s)
[347.992739] Starting dynamic subtest: bcs0
[347.995036] Dynamic subtest bcs0: SKIP (0.000s)
[348.006104] Starting dynamic subtest: vcs0
[348.008436] Dynamic subtest vcs0: SKIP (0.000s)
[348.019087] Starting dynamic subtest: vcs1
[348.021125] Dynamic subtest vcs1: SKIP (0.000s)
[348.032101] Starting dynamic subtest: vecs0
[348.034500] Dynamic subtest vecs0: SKIP (0.000s)
[348.045070] Starting dynamic subtest: vecs1
[348.046923] Dynamic subtest vecs1: SKIP (0.000s)
[348.060543] Starting dynamic subtest: ccs0
[348.062925] Dynamic subtest ccs0: SKIP (0.001s)
[348.065234] Subtest isolation: SKIP (0.009s)
[348.110715] [063/132] (675s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[348.314057] Starting subtest: fbc-shrfb-scaledprimary
[349.838342] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.525s)
[350.071793] [064/132] (673s left) kms_big_fb (linear-8bpp-rotate-90)
[350.275198] Starting subtest: linear-8bpp-rotate-90
[350.338656] Subtest linear-8bpp-rotate-90: SKIP (0.062s)
[350.604375] [065/132] (673s left) gem_exec_schedule (preempt-engines)
[350.697435] Starting subtest: preempt-engines
[350.698384] Starting dynamic subtest: rcs0
[352.927639] Dynamic subtest rcs0: SUCCESS (2.228s)
[352.944527] Starting dynamic subtest: bcs0
[355.103015] Dynamic subtest bcs0: SUCCESS (2.171s)
[355.122448] Starting dynamic subtest: vcs0
[357.386090] Dynamic subtest vcs0: SUCCESS (2.279s)
[357.402639] Starting dynamic subtest: vcs1
[359.664225] Dynamic subtest vcs1: SUCCESS (2.274s)
[359.680408] Starting dynamic subtest: vecs0
[361.942400] Dynamic subtest vecs0: SUCCESS (2.274s)
[361.960920] Starting dynamic subtest: vecs1
[364.216342] Dynamic subtest vecs1: SUCCESS (2.271s)
[364.228064] Starting dynamic subtest: ccs0
[366.450401] Dynamic subtest ccs0: SUCCESS (2.232s)
[366.452358] Subtest preempt-engines: SUCCESS (15.754s)
[366.840871] [066/132] (656s left) kms_async_flips (test-cursor-atomic)
[367.034115] Starting subtest: test-cursor-atomic
[367.258885] Starting dynamic subtest: pipe-A-DP-3
[367.547082] Dynamic subtest pipe-A-DP-3: SUCCESS (0.288s)
[367.791183] Starting dynamic subtest: pipe-B-DP-3
[367.907743] Dynamic subtest pipe-B-DP-3: SUCCESS (0.128s)
[368.119818] Starting dynamic subtest: pipe-C-DP-3
[368.227904] Dynamic subtest pipe-C-DP-3: SUCCESS (0.118s)
[368.436513] Starting dynamic subtest: pipe-D-DP-3
[368.552963] Dynamic subtest pipe-D-DP-3: SUCCESS (0.127s)
[368.553964] Subtest test-cursor-atomic: SUCCESS (1.520s)
[369.061896] [067/132] (654s left) gem_exec_balancer (nop)
[369.151710] Starting subtest: nop
[418.652246] Subtest nop: SUCCESS (49.501s)
[419.052079] [068/132] (604s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[419.251030] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[420.527920] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.276s)
[420.740733] [069/132] (603s left) kms_plane_alpha_blend (alpha-basic)
[420.938263] Starting subtest: alpha-basic
[421.195723] Starting dynamic subtest: pipe-A-DP-3
[423.766276] Dynamic subtest pipe-A-DP-3: SUCCESS (2.570s)
[423.800058] Starting dynamic subtest: pipe-D-DP-3
[426.491826] Dynamic subtest pipe-D-DP-3: SUCCESS (2.701s)
[426.492794] Subtest alpha-basic: SUCCESS (5.554s)
[426.783273] [070/132] (597s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[426.980862] Starting subtest: flip-vs-cursor-legacy
[436.628168] Subtest flip-vs-cursor-legacy: SUCCESS (9.646s)
[436.945281] [071/132] (587s left) kms_psr (fbc-pr-sprite-plane-move)
[437.137376] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[437.197959] [072/132] (586s left) gem_create (create-ext-placement-all)
[437.396688] Starting subtest: create-ext-placement-all
[437.398312] Subtest create-ext-placement-all: SUCCESS (0.000s)
[437.580421] [073/132] (586s left) i915_pm_rpm (gem-mmap-type)
[439.301542] Starting subtest: gem-mmap-type
[439.303524] Starting dynamic subtest: fixed-lmem0
[440.531839] Dynamic subtest fixed-lmem0: SUCCESS (1.232s)
[440.569679] Starting dynamic subtest: fixed-smem0
[441.671073] Dynamic subtest fixed-smem0: SUCCESS (1.134s)
[441.672389] Subtest gem-mmap-type: SUCCESS (2.373s)
[441.964752] [074/132] (582s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[442.159354] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[442.160147] Starting dynamic subtest: pipe-A
[442.264960] Dynamic subtest pipe-A: SUCCESS (0.106s)
[442.293108] Starting dynamic subtest: pipe-B
[442.480159] Dynamic subtest pipe-B: SUCCESS (0.213s)
[442.498906] Starting dynamic subtest: pipe-C
[442.696139] Dynamic subtest pipe-C: SUCCESS (0.214s)
[442.727924] Starting dynamic subtest: pipe-D
[442.910074] Dynamic subtest pipe-D: SUCCESS (0.212s)
[442.911185] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.753s)
[443.295681] [075/132] (581s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[443.491008] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[446.011374] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.520s)
[446.212108] [076/132] (578s left) kms_psr (psr-cursor-mmap-gtt)
[446.404762] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[446.473346] [077/132] (578s left) gem_softpin (evict-single-offset)
[446.558261] Starting subtest: evict-single-offset
[480.968058] Subtest evict-single-offset: SUCCESS (34.407s)
[481.100347] [078/132] (543s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[481.335097] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[481.336990] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[481.497972] [079/132] (543s left) kms_cursor_edge_walk (128x128-left-edge)
[481.690360] Starting subtest: 128x128-left-edge
[481.691286] Starting dynamic subtest: pipe-A-DP-3
[485.198795] Dynamic subtest pipe-A-DP-3: SUCCESS (3.507s)
[485.216068] Starting dynamic subtest: pipe-D-DP-3
[488.532317] Dynamic subtest pipe-D-DP-3: SUCCESS (3.329s)
[488.533415] Subtest 128x128-left-edge: SUCCESS (6.842s)
[488.857260] [080/132] (535s left) gem_exec_reloc (basic-gtt-wc-active)
[488.947690] Subtest basic-gtt-wc-active: SKIP (0.000s)
[489.071424] [081/132] (535s left) kms_feature_discovery (display-1x)
[489.261364] Starting subtest: display-1x
[489.262299] Subtest display-1x: SUCCESS (0.000s)
[489.387640] [082/132] (535s left) i915_hangman (engine-engine-error)
[489.484645] Starting subtest: engine-engine-error
[489.485674] Starting dynamic subtest: rcs0
[490.319604] Dynamic subtest rcs0: SUCCESS (0.835s)
[490.337361] Starting dynamic subtest: bcs0
[491.129243] Dynamic subtest bcs0: SUCCESS (0.808s)
[491.143102] Starting dynamic subtest: vcs0
[491.964427] Dynamic subtest vcs0: SUCCESS (0.834s)
[491.980632] Starting dynamic subtest: vcs1
[492.732323] Dynamic subtest vcs1: SUCCESS (0.766s)
[492.752005] Starting dynamic subtest: vecs0
[493.570633] Dynamic subtest vecs0: SUCCESS (0.837s)
[493.588744] Starting dynamic subtest: vecs1
[494.398236] Dynamic subtest vecs1: SUCCESS (0.825s)
[494.413077] Starting dynamic subtest: ccs0
[495.244650] Dynamic subtest ccs0: SUCCESS (0.845s)
[495.245714] Subtest engine-engine-error: SUCCESS (5.762s)
[495.424018] [083/132] (529s left) sw_sync (sync_merge_invalid)
[495.481685] Starting subtest: sync_merge_invalid
[495.530329] Subtest sync_merge_invalid: SUCCESS (0.048s)
[495.613016] [084/132] (529s left) gem_exec_schedule (u-submit-golden-slice)
[495.708748] Starting subtest: u-submit-golden-slice
[495.709818] Starting dynamic subtest: rcs0
[495.787111] Dynamic subtest rcs0: SUCCESS (0.077s)
[495.801057] Starting dynamic subtest: bcs0
[495.836519] Dynamic subtest bcs0: SUCCESS (0.048s)
[495.850519] Starting dynamic subtest: vcs0
[495.889817] Dynamic subtest vcs0: SUCCESS (0.052s)
[495.903834] Starting dynamic subtest: vcs1
[495.938600] Dynamic subtest vcs1: SUCCESS (0.048s)
[495.952437] Starting dynamic subtest: vecs0
[495.989939] Dynamic subtest vecs0: SUCCESS (0.050s)
[496.004060] Starting dynamic subtest: vecs1
[496.038421] Dynamic subtest vecs1: SUCCESS (0.047s)
[496.052389] Starting dynamic subtest: ccs0
[496.090056] Dynamic subtest ccs0: SUCCESS (0.050s)
[496.091064] Subtest u-submit-golden-slice: SUCCESS (0.382s)
[496.566768] [085/132] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[496.767027] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[496.768934] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[496.903379] [086/132] (528s left) kms_selftest (drm_plane_helper)
[496.966435] Starting subtest: drm_plane_helper
[497.001355] Starting dynamic subtest: drm_test_check_plane_state
[497.072727] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.071s)
[497.085252] Starting dynamic subtest: drm_test_check_invalid_plane_state
[497.164835] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.088s)
[497.166804] Subtest drm_plane_helper: SUCCESS (0.196s)
[497.384309] [087/132] (527s left) perf_pmu (busy-accuracy-98)
[497.455325] Starting subtest: busy-accuracy-98
[497.456357] Starting dynamic subtest: rcs0
[500.513101] Dynamic subtest rcs0: SUCCESS (3.056s)
[500.526122] Starting dynamic subtest: bcs0
[503.570100] Dynamic subtest bcs0: SUCCESS (3.056s)
[503.583127] Starting dynamic subtest: vcs0
[506.627241] Dynamic subtest vcs0: SUCCESS (3.056s)
[506.640384] Starting dynamic subtest: vcs1
[509.684353] Dynamic subtest vcs1: SUCCESS (3.056s)
[509.697294] Starting dynamic subtest: vecs0
[512.738345] Dynamic subtest vecs0: SUCCESS (3.053s)
[512.751539] Starting dynamic subtest: vecs1
[515.793507] Dynamic subtest vecs1: SUCCESS (3.054s)
[515.806657] Starting dynamic subtest: ccs0
[518.847738] Dynamic subtest ccs0: SUCCESS (3.053s)
[518.848741] Subtest busy-accuracy-98: SUCCESS (21.391s)
[519.043346] [088/132] (506s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[519.249764] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[519.251640] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[519.455839] [089/132] (505s left) perf (buffer-fill)
[519.713405] Starting subtest: buffer-fill
[519.714405] Starting dynamic subtest: 0-rcs0
[521.882081] Dynamic subtest 0-rcs0: SUCCESS (2.168s)
[521.883077] Subtest buffer-fill: SUCCESS (2.169s)
[521.934822] [090/132] (503s left) kms_invalid_mode (overflow-vrefresh)
[522.130264] Starting subtest: overflow-vrefresh
[522.131261] Starting dynamic subtest: pipe-A-DP-3
[522.211268] Dynamic subtest pipe-A-DP-3: SUCCESS (0.079s)
[522.226305] Starting dynamic subtest: pipe-B-DP-3
[522.227516] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[522.242209] Starting dynamic subtest: pipe-C-DP-3
[522.243455] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[522.257242] Starting dynamic subtest: pipe-D-DP-3
[522.258232] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[522.259228] Subtest overflow-vrefresh: SUCCESS (0.089s)
[522.500495] [091/132] (502s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[522.692365] Starting subtest: cursorB-vs-flipB-legacy
[522.694136] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[522.864018] [092/132] (502s left) syncobj_timeline (wait-any-complex)
[522.945308] Starting subtest: wait-any-complex
[523.008021] Subtest wait-any-complex: SUCCESS (0.062s)
[523.127655] [093/132] (502s left) syncobj_timeline (etime-multi-wait-submitted)
[523.208318] Starting subtest: etime-multi-wait-submitted
[523.311509] Subtest etime-multi-wait-submitted: SUCCESS (0.102s)
[523.484925] [094/132] (502s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[523.683822] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[523.750068] [095/132] (501s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[523.838376] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[523.943408] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[524.138596] [096/132] (501s left) syncobj_wait (wait-all-for-submit-complex)
[524.219327] Starting subtest: wait-all-for-submit-complex
[524.437805] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[524.555939] [097/132] (501s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[524.752370] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[524.753313] Starting dynamic subtest: pipe-A-valid-mode
[526.609843] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.853s)
[526.611508] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.857s)
[526.934403] [098/132] (499s left) prime_vgem (sync)
[527.039246] Starting subtest: sync
[527.040309] Starting dynamic subtest: rcs0
[527.097905] Dynamic subtest rcs0: SUCCESS (0.058s)
[527.111379] Starting dynamic subtest: bcs0
[527.139020] Dynamic subtest bcs0: SUCCESS (0.040s)
[527.154319] Starting dynamic subtest: vcs0
[527.179810] Dynamic subtest vcs0: SUCCESS (0.039s)
[527.197367] Starting dynamic subtest: vcs1
[527.222531] Dynamic subtest vcs1: SUCCESS (0.041s)
[527.245344] Starting dynamic subtest: vecs0
[527.264408] Dynamic subtest vecs0: SUCCESS (0.040s)
[527.287335] Starting dynamic subtest: vecs1
[527.307953] Dynamic subtest vecs1: SUCCESS (0.042s)
[527.328043] Starting dynamic subtest: ccs0
[527.348689] Dynamic subtest ccs0: SUCCESS (0.039s)
[527.350387] Subtest sync: SUCCESS (0.310s)
[527.547795] [099/132] (498s left) testdisplay
[546.252599] [100/132] (479s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[546.443514] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[546.446060] Starting dynamic subtest: pipe-A-DP-3
[550.456255] Dynamic subtest pipe-A-DP-3: SUCCESS (4.007s)
[550.474037] Starting dynamic subtest: pipe-B-DP-3
[551.190646] Dynamic subtest pipe-B-DP-3: SUCCESS (0.728s)
[551.233844] Starting dynamic subtest: pipe-C-DP-3
[551.961195] Dynamic subtest pipe-C-DP-3: SUCCESS (0.762s)
[551.986134] Starting dynamic subtest: pipe-D-DP-3
[552.709780] Dynamic subtest pipe-D-DP-3: SUCCESS (0.740s)
[552.711968] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SUCCESS (6.263s)
[553.107452] [101/132] (473s left) syncobj_wait (reset-unsignaled)
[553.190651] Starting subtest: reset-unsignaled
[553.191593] Subtest reset-unsignaled: SUCCESS (0.000s)
[553.401447] [102/132] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[553.597597] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[553.599407] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[553.781922] [103/132] (472s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[554.067934] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[554.248399] [104/132] (472s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[554.458357] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[554.459286] Starting dynamic subtest: pipe-A-DP-3
[554.468006] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[554.480965] Starting dynamic subtest: pipe-B-DP-3
[554.489653] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[554.502324] Starting dynamic subtest: pipe-C-DP-3
[554.511159] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[554.523900] Starting dynamic subtest: pipe-D-DP-3
[554.535430] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[554.537767] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.010s)
[554.926996] [105/132] (471s left) syncobj_timeline (multi-wait-all-available-submitted)
[555.003297] Starting subtest: multi-wait-all-available-submitted
[555.004278] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[555.158669] [106/132] (471s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[555.352308] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[558.108147] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.757s)
[558.301691] [107/132] (468s left) kms_addfb_basic (tile-pitch-mismatch)
[558.382818] Starting subtest: tile-pitch-mismatch
[558.384740] Subtest tile-pitch-mismatch: SKIP (0.000s)
[558.693194] [108/132] (468s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[558.883818] Starting subtest: primary-y-tiled-reflect-x-90
[558.885813] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[559.046554] [109/132] (467s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[559.240740] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[562.125263] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.885s)
[562.325106] [110/132] (464s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[562.526172] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[562.528030] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[562.677248] [111/132] (464s left) kms_plane_cursor (viewport)
[562.869798] Starting subtest: viewport
[562.871737] Starting dynamic subtest: pipe-A-DP-3-size-64
[566.407464] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.536s)
[566.494854] Starting dynamic subtest: pipe-A-DP-3-size-128
[569.991276] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.516s)
[570.095295] Starting dynamic subtest: pipe-A-DP-3-size-256
[573.591379] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.532s)
[573.768117] Starting dynamic subtest: pipe-B-DP-3-size-64
[577.365387] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.613s)
[577.432023] Starting dynamic subtest: pipe-B-DP-3-size-128
[580.982163] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.565s)
[581.049003] Starting dynamic subtest: pipe-B-DP-3-size-256
[584.548886] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.514s)
[584.710214] Starting dynamic subtest: pipe-C-DP-3-size-64
[588.278275] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.585s)
[588.361261] Starting dynamic subtest: pipe-C-DP-3-size-128
[591.844940] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.515s)
[591.941385] Starting dynamic subtest: pipe-C-DP-3-size-256
[595.395267] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.499s)
[595.525429] Starting dynamic subtest: pipe-D-DP-3-size-64
[599.080303] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.572s)
[599.176270] Starting dynamic subtest: pipe-D-DP-3-size-128
[602.664067] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.532s)
[602.731133] Starting dynamic subtest: pipe-D-DP-3-size-256
[606.231255] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.515s)
[606.341822] Subtest viewport: SUCCESS (43.470s)
[606.645627] [112/132] (420s left) gem_exec_fence (basic-wait-all)
[606.738797] Starting subtest: basic-wait-all
[606.890550] Subtest basic-wait-all: SUCCESS (0.152s)
[607.799473] [113/132] (419s left) kms_psr (pr-cursor-mmap-gtt)
[608.010201] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[608.074401] [114/132] (419s left) gem_madvise (dontneed-before-mmap)
[608.124302] Starting subtest: dontneed-before-mmap
[608.172247] Subtest dontneed-before-mmap: SUCCESS (0.049s)
[608.349660] [115/132] (418s left) api_intel_allocator (reopen)
[608.427912] Starting subtest: reopen
[608.454099] Subtest reopen: SUCCESS (0.028s)
[608.632807] [116/132] (418s left) api_intel_bb (misplaced-blitter)
[608.709671] Starting subtest: misplaced-blitter
[608.743453] Subtest misplaced-blitter: SUCCESS (0.034s)
[608.959462] [117/132] (418s left) kms_flip (dpms-vs-vblank-race)
[609.153027] Starting subtest: dpms-vs-vblank-race
[609.157768] Starting dynamic subtest: A-DP3
[612.430765] Dynamic subtest A-DP3: SUCCESS (3.272s)
[612.454585] Starting dynamic subtest: B-DP3
[615.530928] Dynamic subtest B-DP3: SUCCESS (3.099s)
[615.551245] Starting dynamic subtest: C-DP3
[618.620496] Dynamic subtest C-DP3: SUCCESS (3.087s)
[618.635448] Starting dynamic subtest: D-DP3
[621.651533] Dynamic subtest D-DP3: SUCCESS (3.029s)
[621.654488] Subtest dpms-vs-vblank-race: SUCCESS (12.500s)
[622.002668] [118/132] (405s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[622.199402] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[622.200344] Starting dynamic subtest: pipe-A-DP-3
[622.209084] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[622.222245] Starting dynamic subtest: pipe-B-DP-3
[622.230843] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[622.243829] Starting dynamic subtest: pipe-C-DP-3
[622.252899] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[622.265941] Starting dynamic subtest: pipe-D-DP-3
[622.276268] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[622.278320] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[622.707663] [119/132] (404s left) gem_ctx_sseu (invalid-sseu)
[622.799301] Subtest invalid-sseu: SKIP (0.000s)
[622.883988] [120/132] (404s left) kms_plane (plane-position-hole)
[623.079211] Starting subtest: plane-position-hole
[623.522582] Starting dynamic subtest: pipe-A-plane-1
[623.995267] Dynamic subtest pipe-A-plane-1: SUCCESS (0.473s)
[624.011447] Starting dynamic subtest: pipe-A-plane-2
[624.458827] Dynamic subtest pipe-A-plane-2: SUCCESS (0.463s)
[624.476666] Starting dynamic subtest: pipe-A-plane-3
[624.924213] Dynamic subtest pipe-A-plane-3: SUCCESS (0.463s)
[624.940628] Starting dynamic subtest: pipe-A-plane-4
[625.389116] Dynamic subtest pipe-A-plane-4: SUCCESS (0.464s)
[625.406171] Starting dynamic subtest: pipe-A-plane-5
[625.412697] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[625.762040] Starting dynamic subtest: pipe-B-plane-1
[626.188294] Dynamic subtest pipe-B-plane-1: SUCCESS (0.441s)
[626.209419] Starting dynamic subtest: pipe-B-plane-2
[626.643693] Dynamic subtest pipe-B-plane-2: SUCCESS (0.455s)
[626.657678] Starting dynamic subtest: pipe-B-plane-3
[627.104321] Dynamic subtest pipe-B-plane-3: SUCCESS (0.459s)
[627.117729] Starting dynamic subtest: pipe-B-plane-4
[627.564136] Dynamic subtest pipe-B-plane-4: SUCCESS (0.459s)
[627.577832] Starting dynamic subtest: pipe-B-plane-5
[627.584013] Dynamic subtest pipe-B-plane-5: SUCCESS (0.019s)
[627.585028] Subtest plane-position-hole: SUCCESS (4.505s)
[627.909457] [121/132] (399s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[628.106513] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[628.108312] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[628.323318] [122/132] (399s left) gem_exec_whisper (basic-queues-priority-all)
[628.414203] Starting subtest: basic-queues-priority-all
[650.434113] Subtest basic-queues-priority-all: SUCCESS (22.018s)
[650.717453] [123/132] (377s left) kms_lease (lease-get)
[650.908633] Starting subtest: lease-get
[650.911190] Starting dynamic subtest: pipe-A-DP-3
[650.913192] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[650.927675] Starting dynamic subtest: pipe-B-DP-3
[650.928542] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[650.942766] Starting dynamic subtest: pipe-C-DP-3
[650.943694] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[650.956603] Starting dynamic subtest: pipe-D-DP-3
[650.957488] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[650.958885] Subtest lease-get: SUCCESS (0.017s)
[651.127502] [124/132] (376s left) perf_pmu (most-busy-check-all)
[651.198226] Starting subtest: most-busy-check-all
[651.199217] Starting dynamic subtest: rcs0
[651.779658] Dynamic subtest rcs0: SUCCESS (0.581s)
[651.795166] Starting dynamic subtest: bcs0
[652.332221] Dynamic subtest bcs0: SUCCESS (0.550s)
[652.350421] Starting dynamic subtest: vcs0
[652.890251] Dynamic subtest vcs0: SUCCESS (0.554s)
[652.905462] Starting dynamic subtest: vcs1
[653.443422] Dynamic subtest vcs1: SUCCESS (0.551s)
[653.461420] Starting dynamic subtest: vecs0
[653.998456] Dynamic subtest vecs0: SUCCESS (0.550s)
[654.016328] Starting dynamic subtest: vecs1
[654.556198] Dynamic subtest vecs1: SUCCESS (0.554s)
[654.571431] Starting dynamic subtest: ccs0
[655.107201] Dynamic subtest ccs0: SUCCESS (0.550s)
[655.108215] Subtest most-busy-check-all: SUCCESS (3.909s)
[655.289795] [125/132] (372s left) gem_bad_reloc (negative-reloc-bltcopy)
[655.375789] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[655.483077] [126/132] (372s left) kms_flip (flip-vs-rmfb-interruptible)
[655.678142] Starting subtest: flip-vs-rmfb-interruptible
[655.683114] Starting dynamic subtest: A-DP3
[663.496053] Dynamic subtest A-DP3: SUCCESS (7.812s)
[663.541143] Starting dynamic subtest: B-DP3
[671.260360] Dynamic subtest B-DP3: SUCCESS (7.758s)
[671.301448] Starting dynamic subtest: C-DP3
[679.003134] Dynamic subtest C-DP3: SUCCESS (7.737s)
[679.042917] Starting dynamic subtest: D-DP3
[686.746333] Dynamic subtest D-DP3: SUCCESS (7.738s)
[686.753692] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.074s)
[687.131709] [127/132] (341s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[687.403276] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[687.580694] [128/132] (340s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[687.779844] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[687.781708] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[687.985317] [129/132] (340s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[688.186367] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[689.517668] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.330s)
[689.803300] [130/132] (338s left) i915_suspend (debugfs-reader)
[689.900347] Starting subtest: debugfs-reader
[710.494084] Subtest debugfs-reader: SUCCESS (5.764s)
[710.785931] [131/132] (318s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[710.998580] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[713.998477] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.001s)
[714.199059] [132/132] (314s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[714.395819] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[714.405195] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[714.583906] Closing watchdogs
results: parsing output: 0/ for test: core_auth
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: sysfs_preempt_timeout
results: parsing output: 6/ for test: gen3_render_mixed_blits
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: dmabuf_sync_file
results: parsing output: 10/ for test: kms_fbcon_fbt
results: parsing output: 11/ for test: gem_vm_create
results: parsing output: 12/ for test: kms_pm_dc
results: parsing output: 13/ for test: kms_vblank
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_sequence
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: gem_exec_params
results: parsing output: 21/ for test: gem_pxp
results: parsing output: 22/ for test: kms_vrr
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_busy
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: gem_exec_balancer
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: gen7_exec_parse
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_bad_destroy
results: parsing output: 47/ for test: kms_chamelium_color
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_prime
results: parsing output: 52/ for test: kms_content_protection
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_cursor_edge_walk
results: parsing output: 55/ for test: kms_busy
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: gem_fenced_exec_thrash
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_fbcon_fbt
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_async_flips
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_plane_alpha_blend
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_create
results: parsing output: 72/ for test: i915_pm_rpm
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_softpin
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_cursor_edge_walk
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_feature_discovery
results: parsing output: 81/ for test: i915_hangman
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_selftest
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_invalid_mode
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: prime_vgem
results: parsing output: 98/ for test: testdisplay
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_addfb_basic
results: parsing output: 107/ for test: kms_rotation_crc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_plane_cursor
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_madvise
results: parsing output: 114/ for test: api_intel_allocator
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_ctx_sseu
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_whisper
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: gem_bad_reloc
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_chamelium_edid
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: i915_suspend
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.