[58.467386] Initializing watchdogs
[58.467431]   /dev/watchdog0
[58.480688] [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]
[58.485710] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.487877] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.491269] [001/131] (960s left) syncobj_timeline (invalid-wait-illegal-handle)
[58.582118] Starting subtest: invalid-wait-illegal-handle
[58.584141] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[58.720886] [002/131] (960s left) kms_psr (psr2-sprite-blt)
[58.814885] Starting subtest: psr2-sprite-blt
[58.817272] Starting dynamic subtest: eDP-1
[60.518267] Dynamic subtest eDP-1: SUCCESS (1.689s)
[60.520434] Subtest psr2-sprite-blt: SUCCESS (1.690s)
[61.410342] [003/131] (957s left) gem_mmap_gtt (cpuset-medium-copy)
[61.477269] Subtest cpuset-medium-copy: SKIP (0.000s)
[61.546163] [004/131] (957s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[61.647719] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[61.650107] Starting dynamic subtest: pipe-A-eDP-1
[61.673714] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.682785] Starting dynamic subtest: pipe-B-eDP-1
[61.704875] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.711642] Starting dynamic subtest: pipe-C-eDP-1
[61.734051] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.741758] Starting dynamic subtest: pipe-D-eDP-1
[61.763862] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.768276] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[63.889956] [005/131] (955s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[63.963632] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[64.064826] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s)
[64.162300] [006/131] (955s left) kms_addfb_basic (too-high)
[64.253122] Starting subtest: too-high
[64.255395] Subtest too-high: SUCCESS (0.001s)
[64.382729] [007/131] (954s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[64.486032] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[64.488353] Starting dynamic subtest: pipe-A-default-mode
[67.238504] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s)
[67.240876] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.744s)
[68.097481] [008/131] (951s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[68.226541] Starting subtest: flip-vs-cursor-busy-crc-legacy
[69.074553] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.844s)
[69.937829] [009/131] (949s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[70.039053] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[70.041433] Starting dynamic subtest: pipe-A-default-mode
[72.734075] Dynamic subtest pipe-A-default-mode: SUCCESS (2.692s)
[72.736505] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.693s)
[73.625394] [010/131] (945s left) sriov_basic (enable-vfs-autoprobe-on)
[73.686822] Starting subtest: enable-vfs-autoprobe-on
[73.689142] Starting dynamic subtest: numvfs-1
[73.762138] Dynamic subtest numvfs-1: FAIL (0.017s)
[73.770839] Starting dynamic subtest: numvfs-2
[73.844414] Dynamic subtest numvfs-2: FAIL (0.004s)
[73.852628] Starting dynamic subtest: numvfs-3
[73.927447] Dynamic subtest numvfs-3: FAIL (0.003s)
[73.935874] Starting dynamic subtest: numvfs-4
[74.009084] Dynamic subtest numvfs-4: FAIL (0.006s)
[74.017278] Starting dynamic subtest: numvfs-5
[74.090443] Dynamic subtest numvfs-5: FAIL (0.003s)
[74.098321] Starting dynamic subtest: numvfs-6
[74.171113] Dynamic subtest numvfs-6: FAIL (0.003s)
[74.179439] Starting dynamic subtest: numvfs-7
[74.251771] Dynamic subtest numvfs-7: FAIL (0.003s)
[74.262076] Starting dynamic subtest: numvfs-random
[74.332887] Dynamic subtest numvfs-random: FAIL (0.003s)
[74.340397] Starting dynamic subtest: numvfs-all
[74.412396] Dynamic subtest numvfs-all: FAIL (0.502s)
[74.414693] Subtest enable-vfs-autoprobe-on: FAIL (0.548s)
[74.447944] [011/131] (944s left) gem_pxp (fail-invalid-protected-context)
[74.579772] Starting subtest: fail-invalid-protected-context
[74.581933] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[74.702706] [012/131] (944s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[74.814101] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[75.787621] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.971s)
[76.661120] [013/131] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[76.764641] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[83.967097] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.201s)
[84.137328] [014/131] (935s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[84.261307] Starting subtest: short-flip-after-cursor-atomic-transitions
[85.221599] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.961s)
[86.041960] [015/131] (933s left) perf_pmu (busy-check-all)
[86.088245] Starting subtest: busy-check-all
[86.090073] Starting dynamic subtest: rcs0
[86.670948] Dynamic subtest rcs0: SUCCESS (0.583s)
[86.681667] Starting dynamic subtest: bcs0
[87.221428] Dynamic subtest bcs0: SUCCESS (0.549s)
[87.231745] Starting dynamic subtest: vcs0
[88.918382] Dynamic subtest vcs0: SUCCESS (1.693s)
[88.928573] Starting dynamic subtest: vcs1
[90.902437] Dynamic subtest vcs1: SUCCESS (1.981s)
[90.912565] Starting dynamic subtest: vecs0
[92.885991] Dynamic subtest vecs0: SUCCESS (1.981s)
[92.896175] Starting dynamic subtest: ccs0
[93.440178] Dynamic subtest ccs0: SUCCESS (0.554s)
[93.442645] Subtest busy-check-all: SUCCESS (7.350s)
[93.572501] [016/131] (925s left) kms_pm_rpm (modeset-stress-extra-wait)
[95.112160] Starting subtest: modeset-stress-extra-wait
[149.371056] Subtest modeset-stress-extra-wait: SUCCESS (54.251s)
[149.487255] [017/131] (870s left) kms_force_connector_basic (force-connector-state)
[149.569561] Starting subtest: force-connector-state
[150.180074] Subtest force-connector-state: SUCCESS (0.610s)
[151.204638] [018/131] (868s left) gem_exec_create (madvise)
[151.273819] Starting subtest: madvise
[151.276233] Starting dynamic subtest: smem
[171.991659] Dynamic subtest smem: SUCCESS (20.718s)
[171.994091] Subtest madvise: SUCCESS (20.719s)
[173.137107] [019/131] (846s left) kms_cursor_legacy (single-bo)
[173.275142] Starting subtest: single-bo
[173.277321] Starting dynamic subtest: pipe-A
[178.657251] Dynamic subtest pipe-A: SUCCESS (5.379s)
[178.667301] Starting dynamic subtest: pipe-B
[184.039202] Dynamic subtest pipe-B: SUCCESS (5.380s)
[184.048977] Starting dynamic subtest: pipe-C
[189.419783] Dynamic subtest pipe-C: SUCCESS (5.380s)
[189.429071] Starting dynamic subtest: pipe-D
[194.801841] Dynamic subtest pipe-D: SUCCESS (5.380s)
[194.811645] Starting dynamic subtest: all-pipes
[200.190604] Dynamic subtest all-pipes: SUCCESS (5.387s)
[200.193129] Subtest single-bo: SUCCESS (26.913s)
[200.354965] [020/131] (819s left) kms_big_fb (linear-16bpp-rotate-270)
[200.463633] Starting subtest: linear-16bpp-rotate-270
[200.483379] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[200.640273] [021/131] (819s left) kms_cursor_edge_walk (128x128-top-bottom)
[200.738122] Starting subtest: 128x128-top-bottom
[200.740429] Starting dynamic subtest: pipe-A-eDP-1
[204.189226] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[204.198071] Starting dynamic subtest: pipe-D-eDP-1
[207.374733] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.183s)
[207.377139] Subtest 128x128-top-bottom: SUCCESS (6.637s)
[208.275373] [022/131] (811s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[208.368608] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[208.370865] Starting dynamic subtest: pipe-A-eDP-1
[208.393409] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.403019] Starting dynamic subtest: pipe-B-eDP-1
[208.424302] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.431912] Starting dynamic subtest: pipe-C-eDP-1
[208.453271] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.461067] Starting dynamic subtest: pipe-D-eDP-1
[208.484436] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.488594] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[210.667233] [023/131] (809s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[210.782404] Starting subtest: basic-flip-after-cursor-legacy
[211.698248] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.915s)
[212.570904] [024/131] (807s left) gem_vm_create (execbuf)
[212.644051] Starting subtest: execbuf
[212.648447] Subtest execbuf: SUCCESS (0.007s)
[212.810667] [025/131] (807s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[212.910226] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[212.914599] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[213.022608] [026/131] (806s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[213.120045] Starting subtest: fbc-rgb565-draw-mmap-gtt
[213.124210] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[213.259028] [027/131] (806s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[213.366670] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[219.904534] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.540s)
[220.062509] [028/131] (799s left) kms_vrr (seamless-rr-switch-vrr)
[220.161620] Starting subtest: seamless-rr-switch-vrr
[220.167944] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[220.253469] [029/131] (799s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[220.355167] Starting subtest: yf-tiled-32bpp-rotate-0
[220.359452] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[220.493853] [030/131] (799s left) gem_ctx_engines (invalid-engines)
[220.561356] Starting subtest: invalid-engines
[220.569807] Subtest invalid-engines: SUCCESS (0.008s)
[220.836945] [031/131] (799s left) kms_flip (2x-flip-vs-rmfb)
[220.931226] Starting subtest: 2x-flip-vs-rmfb
[220.941617] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[221.089333] [032/131] (799s left) syncobj_timeline (wait-any-complex)
[221.151090] Starting subtest: wait-any-complex
[221.213674] Subtest wait-any-complex: SUCCESS (0.063s)
[221.310255] [033/131] (798s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[221.904718] Starting subtest: syncobj-timeline-multiple-ext-nodes
[221.907252] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[222.987980] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[222.991015] [034/131] (797s left) gen9_exec_parse (bb-chained)
[223.048337] Subtest bb-chained: SKIP (0.000s)
[223.119810] [035/131] (797s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[223.214472] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[227.145683] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.934s)
[228.304255] [036/131] (792s left) api_intel_allocator (simple-allocator)
[228.361746] Starting subtest: simple-allocator
[228.363633] Starting dynamic subtest: basic
[228.366098] Dynamic subtest basic: SUCCESS (0.004s)
[228.378795] Starting dynamic subtest: parallel-one
[228.562135] Dynamic subtest parallel-one: SUCCESS (0.196s)
[228.573035] Starting dynamic subtest: print
[228.575713] Dynamic subtest print: SUCCESS (0.000s)
[228.583301] Starting dynamic subtest: reuse
[228.585527] Dynamic subtest reuse: SUCCESS (0.000s)
[228.592803] Starting dynamic subtest: reserve
[228.594918] Dynamic subtest reserve: SUCCESS (0.000s)
[228.602200] Starting dynamic subtest: fork-reopen-allocator
[228.604327] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[228.606491] Subtest simple-allocator: SUCCESS (0.215s)
[228.739549] [037/131] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[228.851686] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[236.310957] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.463s)
[236.472107] [038/131] (783s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[236.577919] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[236.580178] Starting dynamic subtest: pipe-A-eDP-1
[236.599679] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[236.608813] Starting dynamic subtest: pipe-B-eDP-1
[236.627144] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[236.634770] Starting dynamic subtest: pipe-C-eDP-1
[236.653403] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[236.661132] Starting dynamic subtest: pipe-D-eDP-1
[236.680473] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[236.682611] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[238.863364] [039/131] (781s left) gem_softpin (evict-prime-sanity-check)
[238.927507] Starting subtest: evict-prime-sanity-check
[238.929809] Starting dynamic subtest: rcs0
[240.104997] Dynamic subtest rcs0: SUCCESS (1.177s)
[240.115341] Starting dynamic subtest: bcs0
[241.224830] Dynamic subtest bcs0: SUCCESS (1.118s)
[241.233196] Starting dynamic subtest: vcs0
[242.920813] Dynamic subtest vcs0: SUCCESS (1.692s)
[242.933311] Starting dynamic subtest: vcs1
[244.867795] Dynamic subtest vcs1: SUCCESS (1.945s)
[244.877098] Starting dynamic subtest: vecs0
[246.888392] Dynamic subtest vecs0: SUCCESS (2.017s)
[246.899199] Starting dynamic subtest: ccs0
[248.012557] Dynamic subtest ccs0: SUCCESS (1.124s)
[248.022370] Starting dynamic subtest: all
[249.158943] Dynamic subtest all: SUCCESS (1.145s)
[249.161735] Subtest evict-prime-sanity-check: SUCCESS (10.231s)
[249.260310] [040/131] (771s left) i915_hangman (error-state-basic)
[249.327807] Starting subtest: error-state-basic
[249.480415] Subtest error-state-basic: SUCCESS (0.153s)
[249.580705] [041/131] (770s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[249.680578] Starting subtest: fbc-psr2-sprite-plane-onoff
[249.682654] Starting dynamic subtest: eDP-1
[249.686581] Dynamic subtest eDP-1: SKIP (0.000s)
[249.690605] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[249.774793] [042/131] (770s left) kms_content_protection (dp-mst-type-1)
[249.920901] Starting subtest: dp-mst-type-1
[249.925037] Subtest dp-mst-type-1: SKIP (0.000s)
[250.072825] [043/131] (770s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[250.178071] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[250.180037] Starting dynamic subtest: pipe-A-eDP-1
[250.199352] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.209469] Starting dynamic subtest: pipe-B-eDP-1
[250.227745] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.234812] Starting dynamic subtest: pipe-C-eDP-1
[250.253017] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.259943] Starting dynamic subtest: pipe-D-eDP-1
[250.278224] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.281699] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[252.466118] [044/131] (768s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[252.562751] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[252.567198] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[252.697612] [045/131] (767s left) perf_pmu (multi-client)
[252.739068] Starting subtest: multi-client
[252.741462] Starting dynamic subtest: rcs0
[253.817766] Dynamic subtest rcs0: SUCCESS (1.077s)
[253.828397] Starting dynamic subtest: bcs0
[254.868055] Dynamic subtest bcs0: SUCCESS (1.048s)
[254.877301] Starting dynamic subtest: vcs0
[255.920217] Dynamic subtest vcs0: SUCCESS (1.049s)
[255.931284] Starting dynamic subtest: vcs1
[257.933480] Dynamic subtest vcs1: SUCCESS (2.012s)
[257.944191] Starting dynamic subtest: vecs0
[259.912875] Dynamic subtest vecs0: SUCCESS (1.978s)
[259.922082] Starting dynamic subtest: ccs0
[261.902156] Dynamic subtest ccs0: SUCCESS (1.987s)
[261.904786] Subtest multi-client: SUCCESS (9.162s)
[262.041570] [046/131] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[262.141601] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[268.800770] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.662s)
[268.979264] [047/131] (751s left) kms_color_pipeline (plane-lut1d)
[269.083959] Starting subtest: plane-lut1d
[269.097361] Starting dynamic subtest: pipe-A-eDP-1
[269.779494] Dynamic subtest pipe-A-eDP-1: FAIL (0.293s)
[270.495979] Starting dynamic subtest: pipe-B-eDP-1
[271.312180] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[271.894046] Starting dynamic subtest: pipe-C-eDP-1
[272.716950] Dynamic subtest pipe-C-eDP-1: FAIL (0.237s)
[273.187252] Starting dynamic subtest: pipe-D-eDP-1
[274.034352] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[274.036753] Subtest plane-lut1d: FAIL (4.633s)
[274.568227] [048/131] (746s left) gem_ctx_isolation (preservation-s3)
[274.639685] Starting subtest: preservation-S3
[274.641937] Starting dynamic subtest: rcs0
[291.082184] Dynamic subtest rcs0: SUCCESS (4.983s)
[291.091450] Starting dynamic subtest: bcs0
[307.062050] Dynamic subtest bcs0: SUCCESS (1.318s)
[307.071052] Starting dynamic subtest: vcs0
[323.092119] Dynamic subtest vcs0: SUCCESS (2.954s)
[323.107695] Starting dynamic subtest: vcs1
[341.078510] Dynamic subtest vcs1: SUCCESS (4.827s)
[341.089232] Starting dynamic subtest: vecs0
[359.088294] Dynamic subtest vecs0: SUCCESS (4.864s)
[359.098851] Starting dynamic subtest: ccs0
[377.073298] Dynamic subtest ccs0: SUCCESS (3.054s)
[377.076147] Subtest preservation-S3: SUCCESS (22.006s)
[377.351193] [049/131] (643s left) gem_exec_async (concurrent-writes)
[377.424989] Starting subtest: concurrent-writes
[377.427716] Starting dynamic subtest: rcs0
[377.440718] Dynamic subtest rcs0: SUCCESS (0.018s)
[377.450726] Starting dynamic subtest: bcs0
[377.453360] Dynamic subtest bcs0: SUCCESS (0.007s)
[377.463349] Starting dynamic subtest: vcs0
[377.466012] Dynamic subtest vcs0: SUCCESS (0.007s)
[377.476772] Starting dynamic subtest: vcs1
[377.480697] Dynamic subtest vcs1: SUCCESS (0.008s)
[377.490804] Starting dynamic subtest: vecs0
[377.493224] Dynamic subtest vecs0: SUCCESS (0.006s)
[377.502560] Starting dynamic subtest: ccs0
[377.504846] Dynamic subtest ccs0: SUCCESS (0.007s)
[377.507523] Subtest concurrent-writes: SUCCESS (0.057s)
[377.761805] [050/131] (643s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[377.969792] Starting subtest: cursor-rapid-movement-128x42
[378.014827] Subtest cursor-rapid-movement-128x42: SKIP (0.038s)
[378.238935] [051/131] (642s left) gem_exec_create (basic)
[378.303703] Starting subtest: basic
[378.305837] Starting dynamic subtest: smem
[381.771343] Dynamic subtest smem: SUCCESS (3.370s)
[381.774415] Subtest basic: SUCCESS (3.372s)
[381.988401] [052/131] (638s left) gem_exec_fence (basic-wait-all)
[382.053460] Starting subtest: basic-wait-all
[382.174181] Subtest basic-wait-all: SUCCESS (0.119s)
[383.946392] [053/131] (637s left) perf (mi-rpc)
[384.083785] Starting subtest: mi-rpc
[384.088662] Subtest mi-rpc: SKIP (0.000s)
[384.134796] [054/131] (636s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[384.191919] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[384.194868] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[384.333648] [055/131] (636s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[384.444561] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[384.447237] Starting dynamic subtest: pipe-A
[384.465742] Dynamic subtest pipe-A: SKIP (0.017s)
[384.476455] Starting dynamic subtest: pipe-B
[384.494950] Dynamic subtest pipe-B: SKIP (0.028s)
[384.503774] Starting dynamic subtest: pipe-C
[384.522740] Dynamic subtest pipe-C: SKIP (0.028s)
[384.531592] Starting dynamic subtest: pipe-D
[384.550417] Dynamic subtest pipe-D: SKIP (0.028s)
[384.554467] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.102s)
[384.684232] [056/131] (636s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[384.790726] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[391.485362] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.630s)
[391.622645] [057/131] (629s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[392.012400] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[392.885225] [058/131] (628s left) gem_mmap_gtt (hang-user)
[392.948690] Subtest hang-user: SKIP (0.000s)
[393.020261] [059/131] (628s left) kms_joiner (invalid-modeset-ultra-joiner)
[393.127912] Starting subtest: invalid-modeset-ultra-joiner
[393.132753] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[393.221555] [060/131] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[393.319702] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[393.324683] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[393.435204] [061/131] (627s left) gem_exec_schedule (fifo)
[393.509900] Starting subtest: fifo
[393.512437] Starting dynamic subtest: rcs0
[393.618908] Dynamic subtest rcs0: SUCCESS (0.121s)
[393.630862] Starting dynamic subtest: vcs0
[393.697509] Dynamic subtest vcs0: SUCCESS (0.077s)
[393.708841] Starting dynamic subtest: vcs1
[393.780692] Dynamic subtest vcs1: SUCCESS (0.082s)
[393.792572] Starting dynamic subtest: vecs0
[393.860228] Dynamic subtest vecs0: SUCCESS (0.078s)
[393.871542] Starting dynamic subtest: ccs0
[393.942476] Dynamic subtest ccs0: SUCCESS (0.081s)
[393.945254] Subtest fifo: SUCCESS (0.444s)
[394.960033] [062/131] (626s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[395.067693] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[395.072685] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[395.205373] [063/131] (626s left) i915_pm_rpm (gem-evict-pwrite)
[396.939054] Starting subtest: gem-evict-pwrite
[396.944736] Subtest gem-evict-pwrite: SKIP (0.000s)
[397.533678] [064/131] (623s left) kms_frontbuffer_tracking (psr-suspend)
[397.628897] Starting subtest: psr-suspend
[435.600592] Subtest psr-suspend: SUCCESS (7.809s)
[435.745021] [065/131] (585s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[435.875708] Starting subtest: x-tiled-32bpp-rotate-180
[437.280545] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.357s)
[437.453898] [066/131] (584s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[437.559499] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[437.564815] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[437.686430] [067/131] (583s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[437.742594] Starting subtest: multi-wait-for-submit-unsubmitted
[437.844688] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.100s)
[437.950248] [068/131] (583s left) gen9_exec_parse (shadow-peek)
[438.006707] Subtest shadow-peek: SKIP (0.000s)
[438.083523] [069/131] (583s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[438.171248] Starting subtest: fbc-psr2-cursor-mmap-gtt
[438.173572] Starting dynamic subtest: eDP-1
[438.178501] Dynamic subtest eDP-1: SKIP (0.000s)
[438.183283] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[438.278135] [070/131] (583s left) syncobj_basic (illegal-fd-to-handle)
[438.335259] Starting subtest: illegal-fd-to-handle
[438.337680] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[438.467663] [071/131] (583s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[438.561575] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[438.563921] Starting dynamic subtest: pipe-A-eDP-1
[438.584876] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[438.595154] Starting dynamic subtest: pipe-B-eDP-1
[438.618728] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[438.627553] Starting dynamic subtest: pipe-C-eDP-1
[438.653438] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[438.661557] Starting dynamic subtest: pipe-D-eDP-1
[438.685488] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[438.690049] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[440.908288] [072/131] (580s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[441.015655] Starting subtest: addfb25-y-tiled-legacy
[441.018723] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[441.128305] [073/131] (580s left) kms_async_flips (test-cursor-atomic)
[441.238456] Starting subtest: test-cursor-atomic
[441.243560] Subtest test-cursor-atomic: SKIP (0.000s)
[442.438036] [074/131] (579s left) gem_userptr_blits (readonly-unsync)
[442.512404] Subtest readonly-unsync: SKIP (0.000s)
[442.668892] [075/131] (579s left) kms_sequence (queue-busy)
[442.762772] Starting subtest: queue-busy
[442.765068] Starting dynamic subtest: pipe-A-eDP-1
[444.731825] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[444.745251] Starting dynamic subtest: pipe-B-eDP-1
[447.341589] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s)
[447.353028] Starting dynamic subtest: pipe-C-eDP-1
[449.940048] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.578s)
[449.951035] Starting dynamic subtest: pipe-D-eDP-1
[452.554508] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.599s)
[452.557538] Subtest queue-busy: SUCCESS (9.708s)
[453.438035] [076/131] (568s left) syncobj_wait (signal)
[453.505533] Starting subtest: signal
[453.508263] Subtest signal: SUCCESS (0.000s)
[453.636243] [077/131] (568s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[453.730116] Starting subtest: fbcpsr-shrfb-scaledprimary
[459.415358] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.671s)
[459.591342] [078/131] (562s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[459.661700] Starting subtest: y-tiled-to-vebox-x-tiled
[459.667524] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[459.867878] [079/131] (562s left) kms_addfb_basic (invalid-set-prop)
[459.924032] Starting subtest: invalid-set-prop
[459.926182] Subtest invalid-set-prop: SUCCESS (0.000s)
[460.089501] [080/131] (562s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[460.189431] Starting subtest: fbc-psr-sprite-mmap-gtt
[460.192027] Starting dynamic subtest: eDP-1
[460.197096] Dynamic subtest eDP-1: SKIP (0.000s)
[460.202443] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[460.289090] [081/131] (561s left) gem_exec_reloc (basic-write-cpu-active)
[460.362579] Subtest basic-write-cpu-active: SKIP (0.000s)
[460.429103] [082/131] (561s left) api_intel_bb (offset-control)
[460.490509] Starting subtest: offset-control
[460.496932] Subtest offset-control: SUCCESS (0.009s)
[460.658014] [083/131] (561s left) gem_exec_whisper (basic-queues-priority)
[460.725699] Starting subtest: basic-queues-priority
[484.923509] Subtest basic-queues-priority: SUCCESS (24.172s)
[485.171614] [084/131] (537s left) gem_ccs (ctrl-surf-copy)
[485.251955] Starting subtest: ctrl-surf-copy
[485.257405] Subtest ctrl-surf-copy: SKIP (0.000s)
[485.393154] [085/131] (537s left) gem_exec_parallel (contexts)
[485.459756] Starting subtest: contexts
[485.462628] Starting dynamic subtest: rcs0
[490.113221] Dynamic subtest rcs0: SUCCESS (4.650s)
[490.125529] Starting dynamic subtest: bcs0
[494.892029] Dynamic subtest bcs0: SUCCESS (4.773s)
[494.904661] Starting dynamic subtest: vcs0
[499.383617] Dynamic subtest vcs0: SUCCESS (4.486s)
[499.395924] Starting dynamic subtest: vcs1
[503.446961] Dynamic subtest vcs1: SUCCESS (4.059s)
[503.459303] Starting dynamic subtest: vecs0
[507.514225] Dynamic subtest vecs0: SUCCESS (4.062s)
[507.525805] Starting dynamic subtest: ccs0
[511.791045] Dynamic subtest ccs0: SUCCESS (4.272s)
[511.793973] Subtest contexts: SUCCESS (26.319s)
[512.006510] [086/131] (510s left) gem_create (create-invalid-size)
[512.070329] Starting subtest: create-invalid-size
[512.073090] Subtest create-invalid-size: SUCCESS (0.000s)
[512.284023] [087/131] (510s left) gem_exec_schedule (noreorder-corked)
[512.464674] Starting subtest: noreorder-corked
[512.467540] Starting dynamic subtest: rcs0
[513.621017] Dynamic subtest rcs0: SUCCESS (1.156s)
[513.633921] Starting dynamic subtest: vcs0
[514.905300] Dynamic subtest vcs0: SUCCESS (1.281s)
[514.918196] Starting dynamic subtest: vcs1
[516.966713] Dynamic subtest vcs1: SUCCESS (2.058s)
[516.979576] Starting dynamic subtest: vecs0
[518.959421] Dynamic subtest vecs0: SUCCESS (1.989s)
[518.972098] Starting dynamic subtest: ccs0
[520.124673] Dynamic subtest ccs0: SUCCESS (1.163s)
[520.127657] Subtest noreorder-corked: SUCCESS (7.659s)
[520.336497] [088/131] (502s left) gem_busy (close-race)
[520.406133] Starting subtest: close-race
[545.937531] Subtest close-race: SUCCESS (25.540s)
[546.351306] [089/131] (476s left) kms_plane_multiple (2x-tiling-x)
[546.502139] Starting subtest: 2x-tiling-x
[546.506731] Subtest 2x-tiling-x: SKIP (0.000s)
[546.599519] [090/131] (476s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[546.704417] Starting subtest: psr-farfromfence-mmap-gtt
[546.709549] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[546.842876] [091/131] (475s left) gem_basic (create-close)
[546.906501] Starting subtest: create-close
[546.912281] Subtest create-close: SUCCESS (0.000s)
[547.040954] [092/131] (475s left) kms_pm_rpm (universal-planes)
[549.004796] Starting subtest: universal-planes
[549.007810] Starting dynamic subtest: plane-33
[557.418680] Dynamic subtest plane-33: SUCCESS (8.415s)
[557.440529] Starting dynamic subtest: plane-63
[566.002135] Dynamic subtest plane-63: SUCCESS (8.583s)
[566.015277] Starting dynamic subtest: plane-93
[574.403478] Dynamic subtest plane-93: SUCCESS (8.400s)
[574.416480] Starting dynamic subtest: plane-123
[582.990610] Dynamic subtest plane-123: SUCCESS (8.585s)
[583.001619] Starting dynamic subtest: plane-133
[591.344827] Dynamic subtest plane-133: SUCCESS (8.350s)
[591.358043] Starting dynamic subtest: plane-143
[599.626840] Dynamic subtest plane-143: SUCCESS (8.278s)
[599.629532] Subtest universal-planes: SUCCESS (50.631s)
[600.030316] [093/131] (422s left) gem_exec_endless (dispatch)
[600.103709] Starting subtest: dispatch
[600.106722] Starting dynamic subtest: rcs0
[600.112818] Dynamic subtest rcs0: SUCCESS (0.005s)
[600.125527] Starting dynamic subtest: bcs0
[600.131729] Dynamic subtest bcs0: SUCCESS (0.004s)
[600.142392] Starting dynamic subtest: vcs0
[600.147579] Dynamic subtest vcs0: SUCCESS (0.004s)
[600.156468] Starting dynamic subtest: vcs1
[600.161456] Dynamic subtest vcs1: SUCCESS (0.005s)
[600.170456] Starting dynamic subtest: vecs0
[600.175406] Dynamic subtest vecs0: SUCCESS (0.005s)
[600.184154] Starting dynamic subtest: ccs0
[600.189278] Dynamic subtest ccs0: SUCCESS (0.004s)
[600.191451] Subtest dispatch: SUCCESS (0.031s)
[602.004201] [094/131] (420s left) kms_vblank (query-idle)
[602.125379] Starting subtest: query-idle
[602.128216] Starting dynamic subtest: pipe-A-eDP-1
[603.877438] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[603.893193] Starting dynamic subtest: pipe-D-eDP-1
[606.331664] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.450s)
[606.334249] Subtest query-idle: SUCCESS (4.206s)
[607.152922] [095/131] (415s left) gem_exec_balancer (hog)
[607.230682] Starting subtest: hog
[607.236152] Subtest hog: SKIP (0.000s)
[607.565619] [096/131] (415s left) kms_flip (flip-vs-panning)
[607.660413] Starting subtest: flip-vs-panning
[607.663419] Starting dynamic subtest: A-eDP1
[616.416228] Dynamic subtest A-eDP1: SUCCESS (8.754s)
[616.434363] Starting dynamic subtest: B-eDP1
[625.115513] Dynamic subtest B-eDP1: SUCCESS (8.697s)
[625.130025] Starting dynamic subtest: C-eDP1
[633.808525] Dynamic subtest C-eDP1: SUCCESS (8.689s)
[633.818905] Starting dynamic subtest: D-eDP1
[642.519254] Dynamic subtest D-eDP1: SUCCESS (8.707s)
[642.524440] Subtest flip-vs-panning: SUCCESS (34.859s)
[643.771334] [097/131] (379s left) i915_query (query-topology-garbage-items)
[643.833298] Starting subtest: query-topology-garbage-items
[643.835966] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[643.973339] [098/131] (379s left) kms_dsc (dsc-basic)
[644.088487] Starting subtest: dsc-basic
[644.104229] Subtest dsc-basic: SKIP (0.000s)
[644.184503] [099/131] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[644.293482] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[644.298678] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[644.435893] [100/131] (378s left) dmabuf_sync_file (import-multiple-read-only)
[644.485897] Starting subtest: import-multiple-read-only
[644.497229] Subtest import-multiple-read-only: SUCCESS (0.014s)
[644.577897] [101/131] (378s left) sw_sync (sync_merge_same)
[644.627129] Starting subtest: sync_merge_same
[644.629765] Subtest sync_merge_same: SUCCESS (0.000s)
[644.698330] [102/131] (378s left) gem_exec_reloc (basic-gtt-cpu)
[644.765381] Subtest basic-gtt-cpu: SKIP (0.000s)
[644.856206] [103/131] (378s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[644.959388] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[644.963667] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[645.070960] [104/131] (378s left) gem_exec_schedule (u-independent)
[645.149614] Starting subtest: u-independent
[645.151927] Starting dynamic subtest: rcs0
[646.932087] Dynamic subtest rcs0: SUCCESS (1.781s)
[646.945239] Starting dynamic subtest: vcs0
[648.967304] Dynamic subtest vcs0: SUCCESS (2.010s)
[648.979927] Starting dynamic subtest: vcs1
[650.929421] Dynamic subtest vcs1: SUCCESS (1.981s)
[650.942259] Starting dynamic subtest: vecs0
[652.981691] Dynamic subtest vecs0: SUCCESS (2.049s)
[652.999138] Starting dynamic subtest: ccs0
[654.929630] Dynamic subtest ccs0: SUCCESS (1.944s)
[654.932480] Subtest u-independent: SUCCESS (9.779s)
[655.255075] [105/131] (368s left) gem_close (basic)
[655.326656] Starting subtest: basic
[655.329381] Subtest basic: SUCCESS (0.000s)
[655.469034] [106/131] (367s left) kms_psr (psr-sprite-mmap-cpu)
[655.573185] Starting subtest: psr-sprite-mmap-cpu
[655.575595] Starting dynamic subtest: eDP-1
[657.320627] Dynamic subtest eDP-1: SUCCESS (1.748s)
[657.323613] Subtest psr-sprite-mmap-cpu: SUCCESS (1.749s)
[658.173271] [107/131] (365s left) gem_eio (banned)
[658.397271] Starting subtest: banned
[659.016370] Subtest banned: SUCCESS (0.621s)
[659.220335] [108/131] (364s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[659.343672] Starting subtest: cursorB-vs-flipA-atomic-transitions
[659.347614] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[659.510706] [109/131] (363s left) kms_chamelium_frames (hdmi-crc-fast)
[659.906506] Subtest hdmi-crc-fast: SKIP (0.000s)
[660.714950] [110/131] (362s left) kms_big_fb (y-tiled-addfb)
[660.829648] Starting subtest: y-tiled-addfb
[660.835041] Subtest y-tiled-addfb: SKIP (0.000s)
[660.949287] [111/131] (362s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[661.062472] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[661.067778] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[661.191971] [112/131] (362s left) gem_exec_reloc (basic-wc-read-noreloc)
[661.252448] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[661.332097] [113/131] (362s left) kms_lease (lease-unleased-connector)
[661.444978] Starting subtest: lease-unleased-connector
[661.447561] Starting dynamic subtest: pipe-A-eDP-1
[661.454638] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[661.465044] Starting dynamic subtest: pipe-B-eDP-1
[661.467639] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[661.478692] Starting dynamic subtest: pipe-C-eDP-1
[661.481671] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[661.491152] Starting dynamic subtest: pipe-D-eDP-1
[661.493437] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[661.495699] Subtest lease-unleased-connector: SUCCESS (0.034s)
[661.609667] [114/131] (362s left) gem_eio (unwedge-stress)
[661.832551] Starting subtest: unwedge-stress
[661.834730] Starting dynamic subtest: render
[666.740181] Dynamic subtest render: SUCCESS (4.907s)
[666.756227] Starting dynamic subtest: bsd1
[684.441622] Dynamic subtest bsd1: SUCCESS (17.703s)
[684.458508] Starting dynamic subtest: bsd2
[702.403537] Dynamic subtest bsd2: SUCCESS (17.962s)
[702.420450] Starting dynamic subtest: blt
[702.425440] Dynamic subtest blt: SKIP (0.000s)
[702.435457] Starting dynamic subtest: vebox
[720.451501] Dynamic subtest vebox: SUCCESS (18.045s)
[720.454334] Subtest unwedge-stress: SUCCESS (58.622s)
[722.000575] [115/131] (301s left) gem_exec_whisper (basic-contexts)
[722.062551] Starting subtest: basic-contexts
[729.040012] Subtest basic-contexts: SUCCESS (6.974s)
[729.254324] [116/131] (294s left) kms_plane_cursor (primary)
[729.357074] Starting subtest: primary
[729.361451] Starting dynamic subtest: pipe-A-eDP-1-size-64
[731.906189] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.551s)
[731.929771] Starting dynamic subtest: pipe-A-eDP-1-size-128
[734.517481] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.593s)
[734.541054] Starting dynamic subtest: pipe-A-eDP-1-size-256
[737.096444] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.560s)
[737.414645] Starting dynamic subtest: pipe-B-eDP-1-size-64
[740.635549] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.234s)
[740.660270] Starting dynamic subtest: pipe-B-eDP-1-size-128
[743.258556] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.604s)
[743.283871] Starting dynamic subtest: pipe-B-eDP-1-size-256
[745.780557] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.503s)
[746.113827] Starting dynamic subtest: pipe-C-eDP-1-size-64
[749.002237] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.896s)
[749.028704] Starting dynamic subtest: pipe-C-eDP-1-size-128
[751.223052] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s)
[751.249818] Starting dynamic subtest: pipe-C-eDP-1-size-256
[753.411452] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[753.733719] Starting dynamic subtest: pipe-D-eDP-1-size-64
[756.581935] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.863s)
[756.610200] Starting dynamic subtest: pipe-D-eDP-1-size-128
[758.793107] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.189s)
[758.819336] Starting dynamic subtest: pipe-D-eDP-1-size-256
[761.005259] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[761.310445] Subtest primary: SUCCESS (31.953s)
[762.148997] [117/131] (261s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[762.254643] Starting subtest: yf-tiled-64bpp-rotate-90
[762.259675] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[762.393277] [118/131] (261s left) gem_mmap_gtt (basic-small-copy)
[762.456812] Subtest basic-small-copy: SKIP (0.000s)
[762.527337] [119/131] (261s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[767.593397] Starting subtest: psr2-overlay-plane-update-continuous-sf
[767.596413] Starting dynamic subtest: pipe-A-eDP-1
[769.352522] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.757s)
[769.364622] Starting dynamic subtest: pipe-B-eDP-1
[771.135258] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.781s)
[771.137890] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.541s)
[771.953636] [120/131] (251s left) gem_partial_pwrite_pread (writes-after-reads)
[772.020762] Subtest writes-after-reads: SKIP (0.000s)
[772.093148] [121/131] (251s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[772.201122] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[772.206309] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[772.349249] [122/131] (251s left) kms_pm_backlight (fade-with-suspend)
[772.454387] Starting subtest: fade-with-suspend
[789.009877] Starting dynamic subtest: eDP-1
[791.683940] Dynamic subtest eDP-1: SUCCESS (2.680s)
[791.686283] Subtest fade-with-suspend: SUCCESS (3.888s)
[792.526633] [123/131] (231s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[792.585471] Starting subtest: single-wait-for-submit-available-submitted
[792.587679] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[792.709185] [124/131] (231s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[792.812702] Starting subtest: 4-tiled-32bpp-rotate-90
[792.832725] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[792.985698] [125/131] (231s left) gem_exec_suspend (basic-s3-devices)
[793.047413] Starting subtest: basic-S3-devices
[793.050053] Starting dynamic subtest: smem
[804.292430] Dynamic subtest smem: SUCCESS (11.254s)
[804.295649] Subtest basic-S3-devices: SUCCESS (11.257s)
[804.500037] [126/131] (219s left) kms_cursor_crc (cursor-onscreen-64x64)
[804.691843] Starting subtest: cursor-onscreen-64x64
[804.697932] Starting dynamic subtest: pipe-A-eDP-1
[806.819873] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.123s)
[806.852763] Starting dynamic subtest: pipe-D-eDP-1
[809.636686] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[809.639586] Subtest cursor-onscreen-64x64: SUCCESS (4.946s)
[810.518240] [127/131] (213s left) gem_ctx_persistence (legacy-engines-persistence)
[810.579533] Starting subtest: legacy-engines-persistence
[810.582435] Starting dynamic subtest: render
[811.429507] Dynamic subtest render: SUCCESS (0.849s)
[811.444182] Starting dynamic subtest: bsd1
[812.246914] Dynamic subtest bsd1: SUCCESS (0.815s)
[812.260081] Starting dynamic subtest: bsd2
[813.021958] Dynamic subtest bsd2: SUCCESS (0.772s)
[813.034713] Starting dynamic subtest: blt
[813.860708] Dynamic subtest blt: SUCCESS (0.836s)
[813.875753] Starting dynamic subtest: vebox
[814.672165] Dynamic subtest vebox: SUCCESS (0.808s)
[814.675342] Subtest legacy-engines-persistence: SUCCESS (4.095s)
[814.785161] [128/131] (209s left) gem_render_copy (y-tiled)
[814.859133] Starting subtest: y-tiled
[814.864563] Subtest y-tiled: SKIP (0.000s)
[815.073874] [129/131] (209s left) kms_getfb (getfb-repeated-different-handles)
[815.172831] Starting subtest: getfb-repeated-different-handles
[815.175368] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[815.299529] [130/131] (209s left) gem_pxp (create-valid-protected-context)
[815.417030] Starting subtest: create-valid-protected-context
[815.419686] Subtest create-valid-protected-context: SUCCESS (0.001s)
[815.565472] [131/131] (208s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[820.656419] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[820.661578] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[821.508720] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: sriov_basic
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: kms_force_connector_basic
results: parsing output: 17/ for test: gem_exec_create
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_cursor_edge_walk
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: gem_vm_create
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_vrr
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_ctx_engines
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: i915_hangman
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_content_protection
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_color_pipeline
results: parsing output: 47/ for test: gem_ctx_isolation
results: parsing output: 48/ for test: gem_exec_async
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: gem_exec_create
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_chamelium_hpd
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_joiner
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: i915_pm_rpm
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: kms_sequence
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: api_intel_bb
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: gem_ccs
results: parsing output: 84/ for test: gem_exec_parallel
results: parsing output: 85/ for test: gem_create
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: gem_busy
results: parsing output: 88/ for test: kms_plane_multiple
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_basic
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: gem_exec_endless
results: parsing output: 93/ for test: kms_vblank
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: i915_query
results: parsing output: 97/ for test: kms_dsc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: dmabuf_sync_file
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: gem_close
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_chamelium_frames
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_lease
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_plane_cursor
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: gem_partial_pwrite_pread
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_pm_backlight
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_suspend
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: kms_getfb
results: parsing output: 129/ for test: gem_pxp
results: parsing output: 130/ for test: kms_psr2_sf
Done.