[57.231429] Initializing watchdogs
[57.231474]   /dev/watchdog0
[57.245183] [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]
[57.249553] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.251915] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.255469] [001/131] (960s left) syncobj_timeline (invalid-wait-illegal-handle)
[57.343817] Starting subtest: invalid-wait-illegal-handle
[57.346245] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[57.484611] [002/131] (960s left) kms_psr (psr2-sprite-blt)
[57.596530] Starting subtest: psr2-sprite-blt
[57.598788] Starting dynamic subtest: eDP-1
[59.294266] Dynamic subtest eDP-1: SUCCESS (1.711s)
[59.296141] Subtest psr2-sprite-blt: SUCCESS (1.712s)
[60.182710] [003/131] (957s left) gem_mmap_gtt (cpuset-medium-copy)
[60.243144] Subtest cpuset-medium-copy: SKIP (0.000s)
[60.301943] [004/131] (957s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[60.404838] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[60.407145] Starting dynamic subtest: pipe-A-eDP-1
[60.429897] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[60.437429] Starting dynamic subtest: pipe-B-eDP-1
[60.458703] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[60.465218] Starting dynamic subtest: pipe-C-eDP-1
[60.486797] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[60.494066] Starting dynamic subtest: pipe-D-eDP-1
[60.516185] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.520560] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[62.636402] [005/131] (955s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[62.683902] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[62.791653] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[62.882818] [006/131] (955s left) kms_addfb_basic (too-high)
[62.975889] Starting subtest: too-high
[62.978283] Subtest too-high: SUCCESS (0.001s)
[63.108191] [007/131] (954s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[63.210966] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[63.213279] Starting dynamic subtest: pipe-A-default-mode
[65.972944] Dynamic subtest pipe-A-default-mode: SUCCESS (2.775s)
[65.975356] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.776s)
[66.826249] [008/131] (951s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[66.956300] Starting subtest: flip-vs-cursor-busy-crc-legacy
[67.858559] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.904s)
[68.756637] [009/131] (949s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[68.853925] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[68.856230] Starting dynamic subtest: pipe-A-default-mode
[71.544453] Dynamic subtest pipe-A-default-mode: SUCCESS (2.694s)
[71.546698] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.695s)
[72.428372] [010/131] (945s left) sriov_basic (enable-vfs-autoprobe-on)
[72.493425] Starting subtest: enable-vfs-autoprobe-on
[72.495606] Starting dynamic subtest: numvfs-1
[72.578742] Dynamic subtest numvfs-1: FAIL (0.030s)
[72.586596] Starting dynamic subtest: numvfs-2
[72.666639] Dynamic subtest numvfs-2: FAIL (0.004s)
[72.675904] Starting dynamic subtest: numvfs-3
[72.749444] Dynamic subtest numvfs-3: FAIL (0.004s)
[72.759254] Starting dynamic subtest: numvfs-4
[72.832647] Dynamic subtest numvfs-4: FAIL (0.003s)
[72.841182] Starting dynamic subtest: numvfs-5
[72.913513] Dynamic subtest numvfs-5: FAIL (0.004s)
[72.921361] Starting dynamic subtest: numvfs-6
[72.995281] Dynamic subtest numvfs-6: FAIL (0.004s)
[73.004476] Starting dynamic subtest: numvfs-7
[73.077850] Dynamic subtest numvfs-7: FAIL (0.004s)
[73.085821] Starting dynamic subtest: numvfs-random
[73.157904] Dynamic subtest numvfs-random: FAIL (0.004s)
[73.166196] Starting dynamic subtest: numvfs-all
[73.238710] Dynamic subtest numvfs-all: FAIL (0.513s)
[73.241234] Subtest enable-vfs-autoprobe-on: FAIL (0.572s)
[73.275602] [011/131] (944s left) gem_pxp (fail-invalid-protected-context)
[73.410949] Starting subtest: fail-invalid-protected-context
[73.413055] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[73.538646] [012/131] (944s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[73.657628] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[74.619049] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.961s)
[75.453065] [013/131] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[75.558636] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[83.032254] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.479s)
[83.179759] [014/131] (935s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[83.301782] Starting subtest: short-flip-after-cursor-atomic-transitions
[84.264373] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.961s)
[85.101240] [015/131] (933s left) perf_pmu (busy-check-all)
[85.143147] Starting subtest: busy-check-all
[85.145491] Starting dynamic subtest: rcs0
[85.696645] Dynamic subtest rcs0: SUCCESS (0.554s)
[85.707394] Starting dynamic subtest: bcs0
[86.247721] Dynamic subtest bcs0: SUCCESS (0.550s)
[86.258320] Starting dynamic subtest: vcs0
[87.889268] Dynamic subtest vcs0: SUCCESS (1.640s)
[87.901018] Starting dynamic subtest: vcs1
[89.876551] Dynamic subtest vcs1: SUCCESS (1.985s)
[89.887473] Starting dynamic subtest: vecs0
[91.923919] Dynamic subtest vecs0: SUCCESS (2.045s)
[91.935553] Starting dynamic subtest: ccs0
[92.479141] Dynamic subtest ccs0: SUCCESS (0.556s)
[92.481494] Subtest busy-check-all: SUCCESS (7.337s)
[92.623193] [016/131] (925s left) kms_pm_rpm (modeset-stress-extra-wait)
[94.363209] Starting subtest: modeset-stress-extra-wait
[148.658723] Subtest modeset-stress-extra-wait: SUCCESS (54.291s)
[148.773553] [017/131] (869s left) kms_force_connector_basic (force-connector-state)
[148.871168] Starting subtest: force-connector-state
[149.486779] Subtest force-connector-state: SUCCESS (0.615s)
[150.479011] [018/131] (867s left) gem_exec_create (madvise)
[150.553373] Starting subtest: madvise
[150.555719] Starting dynamic subtest: smem
[171.991781] Dynamic subtest smem: SUCCESS (21.434s)
[171.994418] Subtest madvise: SUCCESS (21.435s)
[173.074897] [019/131] (845s left) kms_cursor_legacy (single-bo)
[173.208722] Starting subtest: single-bo
[173.211076] Starting dynamic subtest: pipe-A
[178.594021] Dynamic subtest pipe-A: SUCCESS (5.380s)
[178.604686] Starting dynamic subtest: pipe-B
[183.977262] Dynamic subtest pipe-B: SUCCESS (5.381s)
[183.986896] Starting dynamic subtest: pipe-C
[189.358736] Dynamic subtest pipe-C: SUCCESS (5.380s)
[189.368364] Starting dynamic subtest: pipe-D
[194.740761] Dynamic subtest pipe-D: SUCCESS (5.380s)
[194.750683] Starting dynamic subtest: all-pipes
[200.129885] Dynamic subtest all-pipes: SUCCESS (5.388s)
[200.132448] Subtest single-bo: SUCCESS (26.916s)
[200.296784] [020/131] (818s left) kms_big_fb (linear-16bpp-rotate-270)
[200.399989] Starting subtest: linear-16bpp-rotate-270
[200.420554] Subtest linear-16bpp-rotate-270: SKIP (0.020s)
[200.587269] [021/131] (817s left) kms_cursor_edge_walk (128x128-top-bottom)
[200.689260] Starting subtest: 128x128-top-bottom
[200.691641] Starting dynamic subtest: pipe-A-eDP-1
[204.163700] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[204.172542] Starting dynamic subtest: pipe-D-eDP-1
[207.349273] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.183s)
[207.351579] Subtest 128x128-top-bottom: SUCCESS (6.659s)
[208.171944] [022/131] (810s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[208.264789] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[208.267118] Starting dynamic subtest: pipe-A-eDP-1
[208.290446] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.299455] Starting dynamic subtest: pipe-B-eDP-1
[208.321221] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.329062] Starting dynamic subtest: pipe-C-eDP-1
[208.351055] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.359634] Starting dynamic subtest: pipe-D-eDP-1
[208.381258] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.385271] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[210.547143] [023/131] (808s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[210.675457] Starting subtest: basic-flip-after-cursor-legacy
[211.595069] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.921s)
[212.465847] [024/131] (806s left) gem_vm_create (execbuf)
[212.532850] Starting subtest: execbuf
[212.539656] Subtest execbuf: SUCCESS (0.007s)
[212.690315] [025/131] (805s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[212.798643] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[212.802917] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[212.926863] [026/131] (805s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[213.029593] Starting subtest: fbc-rgb565-draw-mmap-gtt
[213.033819] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[213.156370] [027/131] (805s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[213.267118] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[219.918704] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.655s)
[220.077416] [028/131] (798s left) kms_vrr (seamless-rr-switch-vrr)
[220.181747] Starting subtest: seamless-rr-switch-vrr
[220.188424] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[220.278149] [029/131] (798s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[220.386336] Starting subtest: yf-tiled-32bpp-rotate-0
[220.390841] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[220.507046] [030/131] (798s left) gem_ctx_engines (invalid-engines)
[220.568839] Starting subtest: invalid-engines
[220.576596] Subtest invalid-engines: SUCCESS (0.007s)
[220.848906] [031/131] (798s left) kms_flip (2x-flip-vs-rmfb)
[220.955186] Starting subtest: 2x-flip-vs-rmfb
[220.966445] Subtest 2x-flip-vs-rmfb: SKIP (0.013s)
[221.067725] [032/131] (797s left) syncobj_timeline (wait-any-complex)
[221.130939] Starting subtest: wait-any-complex
[221.193265] Subtest wait-any-complex: SUCCESS (0.062s)
[221.287700] [033/131] (797s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[221.884961] Starting subtest: syncobj-timeline-multiple-ext-nodes
[221.887773] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[223.055178] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[223.057942] [034/131] (795s left) gen9_exec_parse (bb-chained)
[223.132514] Subtest bb-chained: SKIP (0.000s)
[223.219675] [035/131] (795s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[223.323344] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[227.285815] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.964s)
[228.471209] [036/131] (790s left) api_intel_allocator (simple-allocator)
[228.525034] Starting subtest: simple-allocator
[228.527497] Starting dynamic subtest: basic
[228.529659] Dynamic subtest basic: SUCCESS (0.003s)
[228.541367] Starting dynamic subtest: parallel-one
[228.706762] Dynamic subtest parallel-one: SUCCESS (0.179s)
[228.714647] Starting dynamic subtest: print
[228.716583] Dynamic subtest print: SUCCESS (0.000s)
[228.724640] Starting dynamic subtest: reuse
[228.726833] Dynamic subtest reuse: SUCCESS (0.000s)
[228.734707] Starting dynamic subtest: reserve
[228.736840] Dynamic subtest reserve: SUCCESS (0.000s)
[228.744875] Starting dynamic subtest: fork-reopen-allocator
[228.747073] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[228.749187] Subtest simple-allocator: SUCCESS (0.196s)
[228.906716] [037/131] (790s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[229.011537] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[236.551371] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.542s)
[236.701303] [038/131] (782s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[236.797817] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[236.800083] Starting dynamic subtest: pipe-A-eDP-1
[236.820181] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[236.831047] Starting dynamic subtest: pipe-B-eDP-1
[236.849937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[236.859428] Starting dynamic subtest: pipe-C-eDP-1
[236.878181] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[236.885957] Starting dynamic subtest: pipe-D-eDP-1
[236.905601] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[236.907482] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[239.050290] [039/131] (780s left) gem_softpin (evict-prime-sanity-check)
[239.108687] Starting subtest: evict-prime-sanity-check
[239.111122] Starting dynamic subtest: rcs0
[240.275497] Dynamic subtest rcs0: SUCCESS (1.165s)
[240.290557] Starting dynamic subtest: bcs0
[241.412869] Dynamic subtest bcs0: SUCCESS (1.136s)
[241.422704] Starting dynamic subtest: vcs0
[242.899329] Dynamic subtest vcs0: SUCCESS (1.483s)
[242.910638] Starting dynamic subtest: vcs1
[244.868975] Dynamic subtest vcs1: SUCCESS (1.968s)
[244.878864] Starting dynamic subtest: vecs0
[246.850576] Dynamic subtest vecs0: SUCCESS (1.980s)
[246.861344] Starting dynamic subtest: ccs0
[248.031045] Dynamic subtest ccs0: SUCCESS (1.180s)
[248.040987] Starting dynamic subtest: all
[249.139654] Dynamic subtest all: SUCCESS (1.107s)
[249.142061] Subtest evict-prime-sanity-check: SUCCESS (10.031s)
[249.248096] [040/131] (770s left) i915_hangman (error-state-basic)
[249.315190] Starting subtest: error-state-basic
[249.474518] Subtest error-state-basic: SUCCESS (0.159s)
[249.583147] [041/131] (769s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[249.676059] Starting subtest: fbc-psr2-sprite-plane-onoff
[249.678252] Starting dynamic subtest: eDP-1
[249.682241] Dynamic subtest eDP-1: SKIP (0.000s)
[249.686331] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[249.774142] [042/131] (769s left) kms_content_protection (dp-mst-type-1)
[249.921939] Starting subtest: dp-mst-type-1
[249.926420] Subtest dp-mst-type-1: SKIP (0.000s)
[250.096092] [043/131] (769s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[250.197092] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[250.198897] Starting dynamic subtest: pipe-A-eDP-1
[250.217801] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.227823] Starting dynamic subtest: pipe-B-eDP-1
[250.244825] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.253078] Starting dynamic subtest: pipe-C-eDP-1
[250.270380] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.278771] Starting dynamic subtest: pipe-D-eDP-1
[250.297952] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.301548] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[252.449863] [044/131] (766s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[252.554575] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[252.558955] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[252.688213] [045/131] (766s left) perf_pmu (multi-client)
[252.730340] Starting subtest: multi-client
[252.732243] Starting dynamic subtest: rcs0
[253.797542] Dynamic subtest rcs0: SUCCESS (1.066s)
[253.808876] Starting dynamic subtest: bcs0
[254.848029] Dynamic subtest bcs0: SUCCESS (1.048s)
[254.859647] Starting dynamic subtest: vcs0
[255.899054] Dynamic subtest vcs0: SUCCESS (1.048s)
[255.910959] Starting dynamic subtest: vcs1
[257.931647] Dynamic subtest vcs1: SUCCESS (2.031s)
[257.943437] Starting dynamic subtest: vecs0
[259.914078] Dynamic subtest vecs0: SUCCESS (1.981s)
[259.925760] Starting dynamic subtest: ccs0
[261.899312] Dynamic subtest ccs0: SUCCESS (1.983s)
[261.902095] Subtest multi-client: SUCCESS (9.170s)
[262.038881] [046/131] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[262.134349] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[268.788037] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.658s)
[268.981031] [047/131] (750s left) kms_color_pipeline (plane-lut1d)
[269.075198] Starting subtest: plane-lut1d
[269.089655] Starting dynamic subtest: pipe-A-eDP-1
[269.780779] Dynamic subtest pipe-A-eDP-1: FAIL (0.305s)
[270.473517] Starting dynamic subtest: pipe-B-eDP-1
[271.320410] Dynamic subtest pipe-B-eDP-1: FAIL (0.335s)
[271.869270] Starting dynamic subtest: pipe-C-eDP-1
[272.732363] Dynamic subtest pipe-C-eDP-1: FAIL (0.279s)
[273.177596] Starting dynamic subtest: pipe-D-eDP-1
[274.048474] Dynamic subtest pipe-D-eDP-1: FAIL (0.291s)
[274.050671] Subtest plane-lut1d: FAIL (4.675s)
[274.651495] [048/131] (744s left) gem_ctx_isolation (preservation-s3)
[274.718230] Starting subtest: preservation-S3
[274.720711] Starting dynamic subtest: rcs0
[291.162986] Dynamic subtest rcs0: SUCCESS (5.126s)
[291.174332] Starting dynamic subtest: bcs0
[307.148038] Dynamic subtest bcs0: SUCCESS (1.356s)
[307.157785] Starting dynamic subtest: vcs0
[323.131707] Dynamic subtest vcs0: SUCCESS (2.839s)
[323.145496] Starting dynamic subtest: vcs1
[341.143072] Dynamic subtest vcs1: SUCCESS (5.196s)
[341.158134] Starting dynamic subtest: vecs0
[359.126868] Dynamic subtest vecs0: SUCCESS (5.134s)
[359.139251] Starting dynamic subtest: ccs0
[377.126211] Dynamic subtest ccs0: SUCCESS (3.336s)
[377.130483] Subtest preservation-S3: SUCCESS (22.994s)
[377.379913] [049/131] (642s left) gem_exec_async (concurrent-writes)
[377.455051] Starting subtest: concurrent-writes
[377.457861] Starting dynamic subtest: rcs0
[377.473156] Dynamic subtest rcs0: SUCCESS (0.018s)
[377.484036] Starting dynamic subtest: bcs0
[377.486120] Dynamic subtest bcs0: SUCCESS (0.007s)
[377.495418] Starting dynamic subtest: vcs0
[377.498340] Dynamic subtest vcs0: SUCCESS (0.006s)
[377.507839] Starting dynamic subtest: vcs1
[377.510353] Dynamic subtest vcs1: SUCCESS (0.005s)
[377.521379] Starting dynamic subtest: vecs0
[377.524239] Dynamic subtest vecs0: SUCCESS (0.005s)
[377.533412] Starting dynamic subtest: ccs0
[377.536142] Dynamic subtest ccs0: SUCCESS (0.005s)
[377.538604] Subtest concurrent-writes: SUCCESS (0.049s)
[377.760777] [050/131] (641s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[377.978483] Starting subtest: cursor-rapid-movement-128x42
[378.025338] Subtest cursor-rapid-movement-128x42: SKIP (0.042s)
[378.252668] [051/131] (641s left) gem_exec_create (basic)
[378.315585] Starting subtest: basic
[378.317983] Starting dynamic subtest: smem
[381.822077] Dynamic subtest smem: SUCCESS (3.621s)
[381.825122] Subtest basic: SUCCESS (3.623s)
[382.027731] [052/131] (637s left) gem_exec_fence (basic-wait-all)
[382.093990] Starting subtest: basic-wait-all
[382.222757] Subtest basic-wait-all: SUCCESS (0.135s)
[383.981521] [053/131] (635s left) perf (mi-rpc)
[384.141262] Starting subtest: mi-rpc
[384.146298] Subtest mi-rpc: SKIP (0.000s)
[384.190805] [054/131] (635s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[384.257422] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[384.260259] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[384.374485] [055/131] (635s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[384.470704] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[384.472862] Starting dynamic subtest: pipe-A
[384.491505] Dynamic subtest pipe-A: SKIP (0.017s)
[384.501289] Starting dynamic subtest: pipe-B
[384.520943] Dynamic subtest pipe-B: SKIP (0.029s)
[384.530488] Starting dynamic subtest: pipe-C
[384.550193] Dynamic subtest pipe-C: SKIP (0.029s)
[384.559493] Starting dynamic subtest: pipe-D
[384.580756] Dynamic subtest pipe-D: SKIP (0.029s)
[384.585786] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.107s)
[384.697311] [056/131] (635s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[384.796926] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[391.323500] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.607s)
[391.471023] [057/131] (628s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[391.854855] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[392.644425] [058/131] (627s left) gem_mmap_gtt (hang-user)
[392.708786] Subtest hang-user: SKIP (0.000s)
[392.776568] [059/131] (627s left) kms_joiner (invalid-modeset-ultra-joiner)
[392.877025] Starting subtest: invalid-modeset-ultra-joiner
[392.881809] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[392.968654] [060/131] (627s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[393.063911] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[393.069271] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[393.197184] [061/131] (626s left) gem_exec_schedule (fifo)
[393.276009] Starting subtest: fifo
[393.278208] Starting dynamic subtest: rcs0
[393.370068] Dynamic subtest rcs0: SUCCESS (0.105s)
[393.382359] Starting dynamic subtest: vcs0
[393.457398] Dynamic subtest vcs0: SUCCESS (0.087s)
[393.470224] Starting dynamic subtest: vcs1
[393.533794] Dynamic subtest vcs1: SUCCESS (0.075s)
[393.546489] Starting dynamic subtest: vecs0
[393.610377] Dynamic subtest vecs0: SUCCESS (0.076s)
[393.620283] Starting dynamic subtest: ccs0
[393.695233] Dynamic subtest ccs0: SUCCESS (0.084s)
[393.697674] Subtest fifo: SUCCESS (0.434s)
[395.023162] [062/131] (625s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[395.133741] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[395.138926] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[395.268578] [063/131] (624s left) i915_pm_rpm (gem-evict-pwrite)
[396.990132] Starting subtest: gem-evict-pwrite
[396.995991] Subtest gem-evict-pwrite: SKIP (0.000s)
[397.538079] [064/131] (622s left) kms_frontbuffer_tracking (psr-suspend)
[397.638424] Starting subtest: psr-suspend
[436.613969] Subtest psr-suspend: SUCCESS (7.982s)
[436.758603] [065/131] (583s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[436.873349] Starting subtest: x-tiled-32bpp-rotate-180
[438.233800] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.415s)
[438.419606] [066/131] (581s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[438.526450] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[438.529645] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[438.655174] [067/131] (581s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[438.724194] Starting subtest: multi-wait-for-submit-unsubmitted
[438.827819] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[438.924255] [068/131] (581s left) gen9_exec_parse (shadow-peek)
[438.976610] Subtest shadow-peek: SKIP (0.000s)
[439.063668] [069/131] (581s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[439.160560] Starting subtest: fbc-psr2-cursor-mmap-gtt
[439.162672] Starting dynamic subtest: eDP-1
[439.166670] Dynamic subtest eDP-1: SKIP (0.000s)
[439.170461] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[439.261085] [070/131] (581s left) syncobj_basic (illegal-fd-to-handle)
[439.325211] Starting subtest: illegal-fd-to-handle
[439.327238] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[439.454240] [071/131] (581s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[439.556885] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[439.559077] Starting dynamic subtest: pipe-A-eDP-1
[439.582770] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[439.598709] Starting dynamic subtest: pipe-B-eDP-1
[439.620991] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[439.630216] Starting dynamic subtest: pipe-C-eDP-1
[439.652631] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[439.662221] Starting dynamic subtest: pipe-D-eDP-1
[439.686022] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[439.689980] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[441.769017] [072/131] (578s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[441.866907] Starting subtest: addfb25-y-tiled-legacy
[441.869183] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[442.002048] [073/131] (578s left) kms_async_flips (test-cursor-atomic)
[442.099736] Starting subtest: test-cursor-atomic
[442.104062] Subtest test-cursor-atomic: SKIP (0.000s)
[443.334173] [074/131] (577s left) gem_userptr_blits (readonly-unsync)
[443.413881] Subtest readonly-unsync: SKIP (0.000s)
[443.563054] [075/131] (577s left) kms_sequence (queue-busy)
[443.662011] Starting subtest: queue-busy
[443.663927] Starting dynamic subtest: pipe-A-eDP-1
[445.569478] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[445.580029] Starting dynamic subtest: pipe-B-eDP-1
[448.126901] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.584s)
[448.137705] Starting dynamic subtest: pipe-C-eDP-1
[450.674404] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.566s)
[450.685096] Starting dynamic subtest: pipe-D-eDP-1
[453.248234] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[453.250533] Subtest queue-busy: SUCCESS (9.683s)
[454.141701] [076/131] (566s left) syncobj_wait (signal)
[454.211667] Starting subtest: signal
[454.213595] Subtest signal: SUCCESS (0.000s)
[454.356944] [077/131] (566s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[454.457246] Starting subtest: fbcpsr-shrfb-scaledprimary
[460.200661] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.763s)
[460.409431] [078/131] (560s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[460.487794] Starting subtest: y-tiled-to-vebox-x-tiled
[460.492247] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[460.699842] [079/131] (560s left) kms_addfb_basic (invalid-set-prop)
[460.758731] Starting subtest: invalid-set-prop
[460.761046] Subtest invalid-set-prop: SUCCESS (0.000s)
[460.948622] [080/131] (560s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[461.045904] Starting subtest: fbc-psr-sprite-mmap-gtt
[461.048180] Starting dynamic subtest: eDP-1
[461.052173] Dynamic subtest eDP-1: SKIP (0.000s)
[461.056203] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[461.152728] [081/131] (559s left) gem_exec_reloc (basic-write-cpu-active)
[461.212573] Subtest basic-write-cpu-active: SKIP (0.000s)
[461.307924] [082/131] (559s left) api_intel_bb (offset-control)
[461.368530] Starting subtest: offset-control
[461.374049] Subtest offset-control: SUCCESS (0.008s)
[461.529154] [083/131] (559s left) gem_exec_whisper (basic-queues-priority)
[461.592663] Starting subtest: basic-queues-priority
[486.040698] Subtest basic-queues-priority: SUCCESS (24.467s)
[486.249019] [084/131] (534s left) gem_ccs (ctrl-surf-copy)
[486.320936] Starting subtest: ctrl-surf-copy
[486.325591] Subtest ctrl-surf-copy: SKIP (0.000s)
[486.451601] [085/131] (534s left) gem_exec_parallel (contexts)
[486.512177] Starting subtest: contexts
[486.514609] Starting dynamic subtest: rcs0
[490.301509] Dynamic subtest rcs0: SUCCESS (3.789s)
[490.312175] Starting dynamic subtest: bcs0
[493.765833] Dynamic subtest bcs0: SUCCESS (3.464s)
[493.778378] Starting dynamic subtest: vcs0
[498.317258] Dynamic subtest vcs0: SUCCESS (4.553s)
[498.328343] Starting dynamic subtest: vcs1
[502.421700] Dynamic subtest vcs1: SUCCESS (4.105s)
[502.434465] Starting dynamic subtest: vecs0
[506.498230] Dynamic subtest vecs0: SUCCESS (4.076s)
[506.510768] Starting dynamic subtest: ccs0
[510.117388] Dynamic subtest ccs0: SUCCESS (3.619s)
[510.120016] Subtest contexts: SUCCESS (23.618s)
[510.334454] [086/131] (510s left) gem_create (create-invalid-size)
[510.398728] Starting subtest: create-invalid-size
[510.401098] Subtest create-invalid-size: SUCCESS (0.000s)
[510.622427] [087/131] (510s left) gem_exec_schedule (noreorder-corked)
[510.811020] Starting subtest: noreorder-corked
[510.813674] Starting dynamic subtest: rcs0
[511.971804] Dynamic subtest rcs0: SUCCESS (1.161s)
[511.985244] Starting dynamic subtest: vcs0
[514.007027] Dynamic subtest vcs0: SUCCESS (2.033s)
[514.020688] Starting dynamic subtest: vcs1
[515.976535] Dynamic subtest vcs1: SUCCESS (1.968s)
[515.990055] Starting dynamic subtest: vecs0
[517.945202] Dynamic subtest vecs0: SUCCESS (1.967s)
[517.957489] Starting dynamic subtest: ccs0
[519.100792] Dynamic subtest ccs0: SUCCESS (1.155s)
[519.103293] Subtest noreorder-corked: SUCCESS (8.295s)
[519.313911] [088/131] (502s left) gem_busy (close-race)
[519.380898] Starting subtest: close-race
[544.936998] Subtest close-race: SUCCESS (25.567s)
[545.303153] [089/131] (476s left) kms_plane_multiple (2x-tiling-x)
[545.445856] Starting subtest: 2x-tiling-x
[545.450241] Subtest 2x-tiling-x: SKIP (0.000s)
[545.542917] [090/131] (475s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[545.639486] Starting subtest: psr-farfromfence-mmap-gtt
[545.643774] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[545.785178] [091/131] (475s left) gem_basic (create-close)
[545.844537] Starting subtest: create-close
[545.849014] Subtest create-close: SUCCESS (0.000s)
[545.991930] [092/131] (475s left) kms_pm_rpm (universal-planes)
[548.147143] Starting subtest: universal-planes
[548.149668] Starting dynamic subtest: plane-33
[556.445358] Dynamic subtest plane-33: SUCCESS (8.306s)
[556.457622] Starting dynamic subtest: plane-63
[564.732649] Dynamic subtest plane-63: SUCCESS (8.289s)
[564.744007] Starting dynamic subtest: plane-93
[573.345103] Dynamic subtest plane-93: SUCCESS (8.614s)
[573.361929] Starting dynamic subtest: plane-123
[581.624135] Dynamic subtest plane-123: SUCCESS (8.280s)
[581.637995] Starting dynamic subtest: plane-133
[590.018660] Dynamic subtest plane-133: SUCCESS (8.395s)
[590.032481] Starting dynamic subtest: plane-143
[598.402342] Dynamic subtest plane-143: SUCCESS (8.384s)
[598.405377] Subtest universal-planes: SUCCESS (50.285s)
[598.797842] [093/131] (422s left) gem_exec_endless (dispatch)
[598.880498] Starting subtest: dispatch
[598.883008] Starting dynamic subtest: rcs0
[598.887695] Dynamic subtest rcs0: SUCCESS (0.005s)
[598.900738] Starting dynamic subtest: bcs0
[598.905349] Dynamic subtest bcs0: SUCCESS (0.004s)
[598.917057] Starting dynamic subtest: vcs0
[598.921214] Dynamic subtest vcs0: SUCCESS (0.004s)
[598.931618] Starting dynamic subtest: vcs1
[598.936028] Dynamic subtest vcs1: SUCCESS (0.005s)
[598.948042] Starting dynamic subtest: vecs0
[598.952192] Dynamic subtest vecs0: SUCCESS (0.005s)
[598.961997] Starting dynamic subtest: ccs0
[598.966301] Dynamic subtest ccs0: SUCCESS (0.004s)
[598.968477] Subtest dispatch: SUCCESS (0.031s)
[600.041053] [094/131] (421s left) kms_vblank (query-idle)
[600.144856] Starting subtest: query-idle
[600.147106] Starting dynamic subtest: pipe-A-eDP-1
[601.884484] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.741s)
[601.900139] Starting dynamic subtest: pipe-D-eDP-1
[604.284876] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.399s)
[604.287444] Subtest query-idle: SUCCESS (4.144s)
[605.105814] [095/131] (416s left) gem_exec_balancer (hog)
[605.168163] Starting subtest: hog
[605.172160] Subtest hog: SKIP (0.000s)
[605.489714] [096/131] (416s left) kms_flip (flip-vs-panning)
[605.590686] Starting subtest: flip-vs-panning
[605.592794] Starting dynamic subtest: A-eDP1
[614.265452] Dynamic subtest A-eDP1: SUCCESS (8.681s)
[614.277593] Starting dynamic subtest: B-eDP1
[622.957468] Dynamic subtest B-eDP1: SUCCESS (8.695s)
[622.972021] Starting dynamic subtest: C-eDP1
[631.634699] Dynamic subtest C-eDP1: SUCCESS (8.679s)
[631.646288] Starting dynamic subtest: D-eDP1
[640.326028] Dynamic subtest D-eDP1: SUCCESS (8.695s)
[640.330018] Subtest flip-vs-panning: SUCCESS (34.760s)
[641.579987] [097/131] (380s left) i915_query (query-topology-garbage-items)
[641.648340] Starting subtest: query-topology-garbage-items
[641.650457] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[641.770313] [098/131] (379s left) kms_dsc (dsc-basic)
[641.868725] Starting subtest: dsc-basic
[641.881819] Subtest dsc-basic: SKIP (0.000s)
[641.963474] [099/131] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[642.062347] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[642.066204] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[642.191875] [100/131] (379s left) dmabuf_sync_file (import-multiple-read-only)
[642.234294] Starting subtest: import-multiple-read-only
[642.243369] Subtest import-multiple-read-only: SUCCESS (0.012s)
[642.328548] [101/131] (379s left) sw_sync (sync_merge_same)
[642.362986] Starting subtest: sync_merge_same
[642.365371] Subtest sync_merge_same: SUCCESS (0.000s)
[642.449374] [102/131] (379s left) gem_exec_reloc (basic-gtt-cpu)
[642.514649] Subtest basic-gtt-cpu: SKIP (0.000s)
[642.590120] [103/131] (379s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[642.682922] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[642.686427] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[642.829160] [104/131] (379s left) gem_exec_schedule (u-independent)
[642.904756] Starting subtest: u-independent
[642.906287] Starting dynamic subtest: rcs0
[644.969003] Dynamic subtest rcs0: SUCCESS (2.068s)
[644.982729] Starting dynamic subtest: vcs0
[646.984530] Dynamic subtest vcs0: SUCCESS (2.014s)
[646.998020] Starting dynamic subtest: vcs1
[648.971989] Dynamic subtest vcs1: SUCCESS (1.986s)
[648.985003] Starting dynamic subtest: vecs0
[651.026342] Dynamic subtest vecs0: SUCCESS (2.054s)
[651.040009] Starting dynamic subtest: ccs0
[652.969010] Dynamic subtest ccs0: SUCCESS (1.941s)
[652.971883] Subtest u-independent: SUCCESS (10.074s)
[653.298165] [105/131] (368s left) gem_close (basic)
[653.365477] Starting subtest: basic
[653.367817] Subtest basic: SUCCESS (0.000s)
[653.524216] [106/131] (368s left) kms_psr (psr-sprite-mmap-cpu)
[653.630942] Starting subtest: psr-sprite-mmap-cpu
[653.633223] Starting dynamic subtest: eDP-1
[655.340613] Dynamic subtest eDP-1: SUCCESS (1.710s)
[655.342778] Subtest psr-sprite-mmap-cpu: SUCCESS (1.711s)
[656.170743] [107/131] (365s left) gem_eio (banned)
[656.403092] Starting subtest: banned
[657.062599] Subtest banned: SUCCESS (0.660s)
[657.241218] [108/131] (364s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[657.362006] Starting subtest: cursorB-vs-flipA-atomic-transitions
[657.365745] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[657.530290] [109/131] (364s left) kms_chamelium_frames (hdmi-crc-fast)
[657.925835] Subtest hdmi-crc-fast: SKIP (0.000s)
[658.735839] [110/131] (363s left) kms_big_fb (y-tiled-addfb)
[658.837899] Starting subtest: y-tiled-addfb
[658.842415] Subtest y-tiled-addfb: SKIP (0.000s)
[658.973558] [111/131] (363s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[659.067318] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[659.071321] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[659.189175] [112/131] (363s left) gem_exec_reloc (basic-wc-read-noreloc)
[659.245044] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[659.333220] [113/131] (363s left) kms_lease (lease-unleased-connector)
[659.437033] Starting subtest: lease-unleased-connector
[659.439243] Starting dynamic subtest: pipe-A-eDP-1
[659.446826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.009s)
[659.458303] Starting dynamic subtest: pipe-B-eDP-1
[659.460400] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[659.471835] Starting dynamic subtest: pipe-C-eDP-1
[659.474056] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[659.483888] Starting dynamic subtest: pipe-D-eDP-1
[659.485775] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[659.487654] Subtest lease-unleased-connector: SUCCESS (0.037s)
[659.607549] [114/131] (362s left) gem_eio (unwedge-stress)
[659.830081] Starting subtest: unwedge-stress
[659.832208] Starting dynamic subtest: render
[665.064680] Dynamic subtest render: SUCCESS (5.163s)
[665.081740] Starting dynamic subtest: bsd1
[685.551843] Dynamic subtest bsd1: SUCCESS (20.400s)
[685.569221] Starting dynamic subtest: bsd2
[703.444188] Dynamic subtest bsd2: SUCCESS (17.886s)
[703.461693] Starting dynamic subtest: blt
[703.465792] Dynamic subtest blt: SKIP (0.000s)
[703.476088] Starting dynamic subtest: vebox
[723.468666] Dynamic subtest vebox: SUCCESS (20.020s)
[723.470786] Subtest unwedge-stress: SUCCESS (63.474s)
[725.031960] [115/131] (297s left) gem_exec_whisper (basic-contexts)
[725.089819] Starting subtest: basic-contexts
[732.936909] Subtest basic-contexts: SUCCESS (7.841s)
[733.145622] [116/131] (289s left) kms_plane_cursor (primary)
[733.240983] Starting subtest: primary
[733.245480] Starting dynamic subtest: pipe-A-eDP-1-size-64
[735.871870] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.630s)
[735.899105] Starting dynamic subtest: pipe-A-eDP-1-size-128
[738.483005] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.592s)
[738.509509] Starting dynamic subtest: pipe-A-eDP-1-size-256
[741.086703] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.582s)
[741.404209] Starting dynamic subtest: pipe-B-eDP-1-size-64
[744.678593] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.285s)
[744.704684] Starting dynamic subtest: pipe-B-eDP-1-size-128
[747.235549] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.539s)
[747.268106] Starting dynamic subtest: pipe-B-eDP-1-size-256
[749.816378] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[750.128807] Starting dynamic subtest: pipe-C-eDP-1-size-64
[752.979239] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.862s)
[753.007869] Starting dynamic subtest: pipe-C-eDP-1-size-128
[755.167594] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.169s)
[755.195678] Starting dynamic subtest: pipe-C-eDP-1-size-256
[757.369394] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[757.685612] Starting dynamic subtest: pipe-D-eDP-1-size-64
[760.604087] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.933s)
[760.632179] Starting dynamic subtest: pipe-D-eDP-1-size-128
[762.758935] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.136s)
[762.787587] Starting dynamic subtest: pipe-D-eDP-1-size-256
[764.903218] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.125s)
[765.209781] Subtest primary: SUCCESS (31.965s)
[766.038283] [117/131] (256s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[766.146874] Starting subtest: yf-tiled-64bpp-rotate-90
[766.151314] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[766.293259] [118/131] (256s left) gem_mmap_gtt (basic-small-copy)
[766.365342] Subtest basic-small-copy: SKIP (0.000s)
[766.431717] [119/131] (256s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[771.488144] Starting subtest: psr2-overlay-plane-update-continuous-sf
[771.490483] Starting dynamic subtest: pipe-A-eDP-1
[773.207200] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.716s)
[773.218019] Starting dynamic subtest: pipe-B-eDP-1
[774.898779] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.690s)
[774.901186] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.410s)
[775.734452] [120/131] (246s left) gem_partial_pwrite_pread (writes-after-reads)
[775.799524] Subtest writes-after-reads: SKIP (0.000s)
[775.886063] [121/131] (246s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[775.983229] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[775.987924] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[776.114048] [122/131] (246s left) kms_pm_backlight (fade-with-suspend)
[776.210691] Starting subtest: fade-with-suspend
[792.117271] Starting dynamic subtest: eDP-1
[794.791735] Dynamic subtest eDP-1: SUCCESS (2.678s)
[794.794726] Subtest fade-with-suspend: SUCCESS (3.889s)
[795.619608] [123/131] (227s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[795.681695] Starting subtest: single-wait-for-submit-available-submitted
[795.683667] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[795.815167] [124/131] (227s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[795.924920] Starting subtest: 4-tiled-32bpp-rotate-90
[795.944151] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[796.130100] [125/131] (226s left) gem_exec_suspend (basic-s3-devices)
[796.195662] Starting subtest: basic-S3-devices
[796.198062] Starting dynamic subtest: smem
[807.630796] Dynamic subtest smem: SUCCESS (11.435s)
[807.633412] Subtest basic-S3-devices: SUCCESS (11.437s)
[807.838751] [126/131] (215s left) kms_cursor_crc (cursor-onscreen-64x64)
[808.021187] Starting subtest: cursor-onscreen-64x64
[808.026123] Starting dynamic subtest: pipe-A-eDP-1
[810.143365] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.118s)
[810.174282] Starting dynamic subtest: pipe-D-eDP-1
[812.920330] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.755s)
[812.922726] Subtest cursor-onscreen-64x64: SUCCESS (4.899s)
[813.805956] [127/131] (209s left) gem_ctx_persistence (legacy-engines-persistence)
[813.876342] Starting subtest: legacy-engines-persistence
[813.878568] Starting dynamic subtest: render
[814.692468] Dynamic subtest render: SUCCESS (0.818s)
[814.708829] Starting dynamic subtest: bsd1
[815.484398] Dynamic subtest bsd1: SUCCESS (0.789s)
[815.496876] Starting dynamic subtest: bsd2
[816.279455] Dynamic subtest bsd2: SUCCESS (0.792s)
[816.292939] Starting dynamic subtest: blt
[817.060534] Dynamic subtest blt: SUCCESS (0.778s)
[817.075116] Starting dynamic subtest: vebox
[817.884811] Dynamic subtest vebox: SUCCESS (0.821s)
[817.887726] Subtest legacy-engines-persistence: SUCCESS (4.011s)
[817.996668] [128/131] (205s left) gem_render_copy (y-tiled)
[818.055238] Starting subtest: y-tiled
[818.060010] Subtest y-tiled: SKIP (0.000s)
[818.274492] [129/131] (204s left) kms_getfb (getfb-repeated-different-handles)
[818.366385] Starting subtest: getfb-repeated-different-handles
[818.368672] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[818.514149] [130/131] (204s left) gem_pxp (create-valid-protected-context)
[818.623022] Starting subtest: create-valid-protected-context
[818.625465] Subtest create-valid-protected-context: SUCCESS (0.001s)
[818.754162] [131/131] (204s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[823.749125] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[823.753395] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[824.603783] 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.