[58.271619] Initializing watchdogs
[58.271664]   /dev/watchdog0
[58.285286] [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.289448] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.291819] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.295672] [001/131] (960s left) syncobj_timeline (invalid-wait-illegal-handle)
[58.376919] Starting subtest: invalid-wait-illegal-handle
[58.379360] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[58.513638] [002/131] (960s left) kms_psr (psr2-sprite-blt)
[58.611795] Starting subtest: psr2-sprite-blt
[58.614108] Starting dynamic subtest: eDP-1
[60.303450] Dynamic subtest eDP-1: SUCCESS (1.692s)
[60.305760] Subtest psr2-sprite-blt: SUCCESS (1.693s)
[61.194324] [003/131] (957s left) gem_mmap_gtt (cpuset-medium-copy)
[61.253790] Subtest cpuset-medium-copy: SKIP (0.000s)
[61.323082] [004/131] (957s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[61.416450] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[61.418742] Starting dynamic subtest: pipe-A-eDP-1
[61.442050] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.451253] Starting dynamic subtest: pipe-B-eDP-1
[61.472970] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.479699] Starting dynamic subtest: pipe-C-eDP-1
[61.500829] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.508408] Starting dynamic subtest: pipe-D-eDP-1
[61.530037] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.534081] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[63.664544] [005/131] (955s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[63.730266] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[63.831754] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s)
[63.929306] [006/131] (955s left) kms_addfb_basic (too-high)
[64.023287] Starting subtest: too-high
[64.025608] Subtest too-high: SUCCESS (0.001s)
[64.154264] [007/131] (954s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[64.252754] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[64.254908] Starting dynamic subtest: pipe-A-default-mode
[67.013544] Dynamic subtest pipe-A-default-mode: SUCCESS (2.761s)
[67.016431] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.763s)
[67.875738] [008/131] (951s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[68.031983] Starting subtest: flip-vs-cursor-busy-crc-legacy
[68.871432] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.837s)
[69.697570] [009/131] (949s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[69.791900] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[69.794086] Starting dynamic subtest: pipe-A-default-mode
[72.514584] Dynamic subtest pipe-A-default-mode: SUCCESS (2.723s)
[72.516929] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.724s)
[73.393388] [010/131] (945s left) sriov_basic (enable-vfs-autoprobe-on)
[73.450052] Starting subtest: enable-vfs-autoprobe-on
[73.452526] Starting dynamic subtest: numvfs-1
[73.532233] Dynamic subtest numvfs-1: FAIL (0.032s)
[73.540696] Starting dynamic subtest: numvfs-2
[73.614936] Dynamic subtest numvfs-2: FAIL (0.004s)
[73.623823] Starting dynamic subtest: numvfs-3
[73.697382] Dynamic subtest numvfs-3: FAIL (0.004s)
[73.705145] Starting dynamic subtest: numvfs-4
[73.779677] Dynamic subtest numvfs-4: FAIL (0.003s)
[73.787786] Starting dynamic subtest: numvfs-5
[73.859974] Dynamic subtest numvfs-5: FAIL (0.003s)
[73.868264] Starting dynamic subtest: numvfs-6
[73.941053] Dynamic subtest numvfs-6: FAIL (0.004s)
[73.948392] Starting dynamic subtest: numvfs-7
[74.022177] Dynamic subtest numvfs-7: FAIL (0.003s)
[74.030681] Starting dynamic subtest: numvfs-random
[74.100553] Dynamic subtest numvfs-random: FAIL (0.003s)
[74.108718] Starting dynamic subtest: numvfs-all
[74.181056] Dynamic subtest numvfs-all: FAIL (0.503s)
[74.183066] Subtest enable-vfs-autoprobe-on: FAIL (0.563s)
[74.227620] [011/131] (944s left) gem_pxp (fail-invalid-protected-context)
[74.358293] Starting subtest: fail-invalid-protected-context
[74.360379] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[74.496716] [012/131] (944s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[74.623128] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[75.593091] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.969s)
[76.432562] [013/131] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[76.538440] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[83.912166] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.376s)
[84.070565] [014/131] (935s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[84.186185] Starting subtest: short-flip-after-cursor-atomic-transitions
[85.134829] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.947s)
[85.980428] [015/131] (933s left) perf_pmu (busy-check-all)
[86.017809] Starting subtest: busy-check-all
[86.020170] Starting dynamic subtest: rcs0
[86.587035] Dynamic subtest rcs0: SUCCESS (0.570s)
[86.597025] Starting dynamic subtest: bcs0
[87.139632] Dynamic subtest bcs0: SUCCESS (0.551s)
[87.149961] Starting dynamic subtest: vcs0
[88.917428] Dynamic subtest vcs0: SUCCESS (1.774s)
[88.927615] Starting dynamic subtest: vcs1
[90.901479] Dynamic subtest vcs1: SUCCESS (1.982s)
[90.911877] Starting dynamic subtest: vecs0
[92.885041] Dynamic subtest vecs0: SUCCESS (1.982s)
[92.895333] Starting dynamic subtest: ccs0
[93.438360] Dynamic subtest ccs0: SUCCESS (0.553s)
[93.440753] Subtest busy-check-all: SUCCESS (7.423s)
[93.574361] [016/131] (925s left) kms_pm_rpm (modeset-stress-extra-wait)
[95.097580] Starting subtest: modeset-stress-extra-wait
[149.326109] Subtest modeset-stress-extra-wait: SUCCESS (54.228s)
[149.436592] [017/131] (869s left) kms_force_connector_basic (force-connector-state)
[149.524073] Starting subtest: force-connector-state
[150.147284] Subtest force-connector-state: SUCCESS (0.623s)
[151.054238] [018/131] (868s left) gem_exec_create (madvise)
[151.133855] Starting subtest: madvise
[151.136219] Starting dynamic subtest: smem
[171.996029] Dynamic subtest smem: SUCCESS (20.861s)
[171.998997] Subtest madvise: SUCCESS (20.862s)
[172.799170] [019/131] (846s left) kms_cursor_legacy (single-bo)
[172.929299] Starting subtest: single-bo
[172.931681] Starting dynamic subtest: pipe-A
[178.312828] Dynamic subtest pipe-A: SUCCESS (5.379s)
[178.323037] Starting dynamic subtest: pipe-B
[183.692966] Dynamic subtest pipe-B: SUCCESS (5.380s)
[183.702509] Starting dynamic subtest: pipe-C
[189.070914] Dynamic subtest pipe-C: SUCCESS (5.378s)
[189.080928] Starting dynamic subtest: pipe-D
[194.453068] Dynamic subtest pipe-D: SUCCESS (5.380s)
[194.463223] Starting dynamic subtest: all-pipes
[199.842022] Dynamic subtest all-pipes: SUCCESS (5.387s)
[199.844918] Subtest single-bo: SUCCESS (26.910s)
[200.005659] [020/131] (819s left) kms_big_fb (linear-16bpp-rotate-270)
[200.115431] Starting subtest: linear-16bpp-rotate-270
[200.134556] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[200.291847] [021/131] (819s left) kms_cursor_edge_walk (128x128-top-bottom)
[200.401926] Starting subtest: 128x128-top-bottom
[200.404352] Starting dynamic subtest: pipe-A-eDP-1
[203.844541] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.442s)
[203.853863] Starting dynamic subtest: pipe-D-eDP-1
[207.028874] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.185s)
[207.031191] Subtest 128x128-top-bottom: SUCCESS (6.629s)
[207.918062] [022/131] (811s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[208.026038] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[208.028246] Starting dynamic subtest: pipe-A-eDP-1
[208.050562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.062411] Starting dynamic subtest: pipe-B-eDP-1
[208.083431] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.091551] Starting dynamic subtest: pipe-C-eDP-1
[208.113388] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.122139] Starting dynamic subtest: pipe-D-eDP-1
[208.143614] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.147600] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[210.317627] [023/131] (809s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[210.431374] Starting subtest: basic-flip-after-cursor-legacy
[211.345437] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s)
[212.223208] [024/131] (807s left) gem_vm_create (execbuf)
[212.292020] Starting subtest: execbuf
[212.296888] Subtest execbuf: SUCCESS (0.007s)
[212.448325] [025/131] (807s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[212.545682] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[212.550159] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[212.683311] [026/131] (807s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[212.784594] Starting subtest: fbc-rgb565-draw-mmap-gtt
[212.789073] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[212.910334] [027/131] (806s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[213.019353] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[219.571695] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.554s)
[219.706431] [028/131] (800s left) kms_vrr (seamless-rr-switch-vrr)
[219.810227] Starting subtest: seamless-rr-switch-vrr
[219.816394] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[219.901324] [029/131] (799s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[220.016309] Starting subtest: yf-tiled-32bpp-rotate-0
[220.021320] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[220.143314] [030/131] (799s left) gem_ctx_engines (invalid-engines)
[220.209961] Starting subtest: invalid-engines
[220.217127] Subtest invalid-engines: SUCCESS (0.007s)
[220.480394] [031/131] (799s left) kms_flip (2x-flip-vs-rmfb)
[220.569325] Starting subtest: 2x-flip-vs-rmfb
[220.580070] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[220.712667] [032/131] (799s left) syncobj_timeline (wait-any-complex)
[220.776448] Starting subtest: wait-any-complex
[220.836352] Subtest wait-any-complex: SUCCESS (0.062s)
[220.935166] [033/131] (799s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[221.513930] Starting subtest: syncobj-timeline-multiple-ext-nodes
[221.516766] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[223.018367] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[223.022435] [034/131] (797s left) gen9_exec_parse (bb-chained)
[223.083837] Subtest bb-chained: SKIP (0.000s)
[223.174855] [035/131] (796s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[223.294503] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[227.165915] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.875s)
[228.330791] [036/131] (791s left) api_intel_allocator (simple-allocator)
[228.381590] Starting subtest: simple-allocator
[228.383759] Starting dynamic subtest: basic
[228.385979] Dynamic subtest basic: SUCCESS (0.004s)
[228.394143] Starting dynamic subtest: parallel-one
[228.561634] Dynamic subtest parallel-one: SUCCESS (0.176s)
[228.569113] Starting dynamic subtest: print
[228.571381] Dynamic subtest print: SUCCESS (0.000s)
[228.578752] Starting dynamic subtest: reuse
[228.580643] Dynamic subtest reuse: SUCCESS (0.000s)
[228.587561] Starting dynamic subtest: reserve
[228.589449] Dynamic subtest reserve: SUCCESS (0.000s)
[228.596312] Starting dynamic subtest: fork-reopen-allocator
[228.598248] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[228.600066] Subtest simple-allocator: SUCCESS (0.196s)
[228.730271] [037/131] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[228.845437] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[236.404852] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.562s)
[236.544971] [038/131] (783s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[236.650996] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[236.653231] Starting dynamic subtest: pipe-A-eDP-1
[236.673367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[236.683262] Starting dynamic subtest: pipe-B-eDP-1
[236.702087] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[236.708957] Starting dynamic subtest: pipe-C-eDP-1
[236.726758] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[236.734309] Starting dynamic subtest: pipe-D-eDP-1
[236.753556] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[236.755507] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[238.916153] [039/131] (781s left) gem_softpin (evict-prime-sanity-check)
[238.978077] Starting subtest: evict-prime-sanity-check
[238.980322] Starting dynamic subtest: rcs0
[240.164561] Dynamic subtest rcs0: SUCCESS (1.186s)
[240.175245] Starting dynamic subtest: bcs0
[241.291876] Dynamic subtest bcs0: SUCCESS (1.125s)
[241.301977] Starting dynamic subtest: vcs0
[242.880043] Dynamic subtest vcs0: SUCCESS (1.585s)
[242.888175] Starting dynamic subtest: vcs1
[244.897046] Dynamic subtest vcs1: SUCCESS (2.015s)
[244.906486] Starting dynamic subtest: vecs0
[246.959273] Dynamic subtest vecs0: SUCCESS (2.060s)
[246.968731] Starting dynamic subtest: ccs0
[248.092522] Dynamic subtest ccs0: SUCCESS (1.133s)
[248.103104] Starting dynamic subtest: all
[249.233934] Dynamic subtest all: SUCCESS (1.139s)
[249.236418] Subtest evict-prime-sanity-check: SUCCESS (10.257s)
[249.338319] [040/131] (770s left) i915_hangman (error-state-basic)
[249.404684] Starting subtest: error-state-basic
[249.559379] Subtest error-state-basic: SUCCESS (0.156s)
[249.658827] [041/131] (770s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[249.751111] Starting subtest: fbc-psr2-sprite-plane-onoff
[249.753421] Starting dynamic subtest: eDP-1
[249.757570] Dynamic subtest eDP-1: SKIP (0.000s)
[249.761760] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[249.848664] [042/131] (770s left) kms_content_protection (dp-mst-type-1)
[249.995081] Starting subtest: dp-mst-type-1
[249.999277] Subtest dp-mst-type-1: SKIP (0.000s)
[250.145543] [043/131] (770s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[250.236393] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[250.238365] Starting dynamic subtest: pipe-A-eDP-1
[250.258100] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.268086] Starting dynamic subtest: pipe-B-eDP-1
[250.286105] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.293094] Starting dynamic subtest: pipe-C-eDP-1
[250.311348] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.318558] Starting dynamic subtest: pipe-D-eDP-1
[250.337676] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.341093] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[252.519988] [044/131] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[252.619110] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[252.623403] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[252.749371] [045/131] (767s left) perf_pmu (multi-client)
[252.792386] Starting subtest: multi-client
[252.794838] Starting dynamic subtest: rcs0
[253.867217] Dynamic subtest rcs0: SUCCESS (1.075s)
[253.876543] Starting dynamic subtest: bcs0
[254.915823] Dynamic subtest bcs0: SUCCESS (1.046s)
[254.926383] Starting dynamic subtest: vcs0
[255.968214] Dynamic subtest vcs0: SUCCESS (1.050s)
[255.979231] Starting dynamic subtest: vcs1
[257.930574] Dynamic subtest vcs1: SUCCESS (1.960s)
[257.941328] Starting dynamic subtest: vecs0
[259.919770] Dynamic subtest vecs0: SUCCESS (1.987s)
[259.930317] Starting dynamic subtest: ccs0
[261.900593] Dynamic subtest ccs0: SUCCESS (1.979s)
[261.903268] Subtest multi-client: SUCCESS (9.110s)
[262.041214] [046/131] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[262.141597] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[268.826520] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.688s)
[269.000523] [047/131] (751s left) kms_color_pipeline (plane-lut1d)
[269.107956] Starting subtest: plane-lut1d
[269.121366] Starting dynamic subtest: pipe-A-eDP-1
[269.829105] Dynamic subtest pipe-A-eDP-1: FAIL (0.327s)
[270.544022] Starting dynamic subtest: pipe-B-eDP-1
[271.335949] Dynamic subtest pipe-B-eDP-1: FAIL (0.278s)
[271.850652] Starting dynamic subtest: pipe-C-eDP-1
[272.667615] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[273.143306] Starting dynamic subtest: pipe-D-eDP-1
[273.981535] Dynamic subtest pipe-D-eDP-1: FAIL (0.245s)
[273.983548] Subtest plane-lut1d: FAIL (4.573s)
[274.513996] [048/131] (746s left) gem_ctx_isolation (preservation-s3)
[274.579850] Starting subtest: preservation-S3
[274.582168] Starting dynamic subtest: rcs0
[291.027248] Dynamic subtest rcs0: SUCCESS (4.872s)
[291.037006] Starting dynamic subtest: bcs0
[307.019315] Dynamic subtest bcs0: SUCCESS (1.316s)
[307.029778] Starting dynamic subtest: vcs0
[323.019491] Dynamic subtest vcs0: SUCCESS (2.256s)
[323.032375] Starting dynamic subtest: vcs1
[341.027375] Dynamic subtest vcs1: SUCCESS (5.007s)
[341.039290] Starting dynamic subtest: vecs0
[359.042260] Dynamic subtest vecs0: SUCCESS (5.043s)
[359.051332] Starting dynamic subtest: ccs0
[377.024121] Dynamic subtest ccs0: SUCCESS (3.152s)
[377.026386] Subtest preservation-S3: SUCCESS (21.652s)
[377.309624] [049/131] (643s left) gem_exec_async (concurrent-writes)
[377.376857] Starting subtest: concurrent-writes
[377.379233] Starting dynamic subtest: rcs0
[377.392236] Dynamic subtest rcs0: SUCCESS (0.015s)
[377.403420] Starting dynamic subtest: bcs0
[377.405606] Dynamic subtest bcs0: SUCCESS (0.005s)
[377.414104] Starting dynamic subtest: vcs0
[377.416179] Dynamic subtest vcs0: SUCCESS (0.005s)
[377.424649] Starting dynamic subtest: vcs1
[377.426752] Dynamic subtest vcs1: SUCCESS (0.005s)
[377.435022] Starting dynamic subtest: vecs0
[377.437100] Dynamic subtest vecs0: SUCCESS (0.005s)
[377.445323] Starting dynamic subtest: ccs0
[377.447461] Dynamic subtest ccs0: SUCCESS (0.005s)
[377.449504] Subtest concurrent-writes: SUCCESS (0.045s)
[377.681677] [050/131] (643s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[377.889140] Starting subtest: cursor-rapid-movement-128x42
[377.932498] Subtest cursor-rapid-movement-128x42: SKIP (0.039s)
[378.167261] [051/131] (642s left) gem_exec_create (basic)
[378.227956] Starting subtest: basic
[378.230067] Starting dynamic subtest: smem
[381.821569] Dynamic subtest smem: SUCCESS (3.607s)
[381.824082] Subtest basic: SUCCESS (3.609s)
[382.033599] [052/131] (638s left) gem_exec_fence (basic-wait-all)
[382.090801] Starting subtest: basic-wait-all
[382.223289] Subtest basic-wait-all: SUCCESS (0.134s)
[383.930624] [053/131] (636s left) perf (mi-rpc)
[384.087619] Starting subtest: mi-rpc
[384.091468] Subtest mi-rpc: SKIP (0.000s)
[384.131013] [054/131] (636s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[384.186726] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[384.188903] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[384.313964] [055/131] (636s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[384.416275] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[384.418435] Starting dynamic subtest: pipe-A
[384.437968] Dynamic subtest pipe-A: SKIP (0.017s)
[384.446441] Starting dynamic subtest: pipe-B
[384.466589] Dynamic subtest pipe-B: SKIP (0.029s)
[384.475040] Starting dynamic subtest: pipe-C
[384.494690] Dynamic subtest pipe-C: SKIP (0.028s)
[384.503048] Starting dynamic subtest: pipe-D
[384.522303] Dynamic subtest pipe-D: SKIP (0.028s)
[384.526459] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.104s)
[384.645604] [056/131] (636s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[384.754085] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[391.369414] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.634s)
[391.517819] [057/131] (629s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[391.902467] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[392.677677] [058/131] (628s left) gem_mmap_gtt (hang-user)
[392.737711] Subtest hang-user: SKIP (0.000s)
[392.801884] [059/131] (628s left) kms_joiner (invalid-modeset-ultra-joiner)
[392.908180] Starting subtest: invalid-modeset-ultra-joiner
[392.912144] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[393.001641] [060/131] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[393.095014] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[393.099091] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[393.232122] [061/131] (627s left) gem_exec_schedule (fifo)
[393.307111] Starting subtest: fifo
[393.309420] Starting dynamic subtest: rcs0
[393.396486] Dynamic subtest rcs0: SUCCESS (0.100s)
[393.407372] Starting dynamic subtest: vcs0
[393.474742] Dynamic subtest vcs0: SUCCESS (0.077s)
[393.487286] Starting dynamic subtest: vcs1
[393.549081] Dynamic subtest vcs1: SUCCESS (0.074s)
[393.560750] Starting dynamic subtest: vecs0
[393.619344] Dynamic subtest vecs0: SUCCESS (0.070s)
[393.630539] Starting dynamic subtest: ccs0
[393.694755] Dynamic subtest ccs0: SUCCESS (0.075s)
[393.697222] Subtest fifo: SUCCESS (0.400s)
[394.959106] [062/131] (626s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[395.067641] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[395.071902] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[395.189069] [063/131] (626s left) i915_pm_rpm (gem-evict-pwrite)
[396.912908] Starting subtest: gem-evict-pwrite
[396.917386] Subtest gem-evict-pwrite: SKIP (0.000s)
[397.498916] [064/131] (623s left) kms_frontbuffer_tracking (psr-suspend)
[397.587985] Starting subtest: psr-suspend
[435.504069] Subtest psr-suspend: SUCCESS (7.750s)
[435.682086] [065/131] (585s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[435.795545] Starting subtest: x-tiled-32bpp-rotate-180
[437.176262] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.389s)
[437.343790] [066/131] (584s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[437.445151] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[437.449921] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[437.574379] [067/131] (583s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[437.646143] Starting subtest: multi-wait-for-submit-unsubmitted
[437.754197] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[437.859209] [068/131] (583s left) gen9_exec_parse (shadow-peek)
[437.921661] Subtest shadow-peek: SKIP (0.000s)
[438.007037] [069/131] (583s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[438.099983] Starting subtest: fbc-psr2-cursor-mmap-gtt
[438.102879] Starting dynamic subtest: eDP-1
[438.108344] Dynamic subtest eDP-1: SKIP (0.000s)
[438.113541] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[438.200393] [070/131] (583s left) syncobj_basic (illegal-fd-to-handle)
[438.260297] Starting subtest: illegal-fd-to-handle
[438.263224] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[438.385089] [071/131] (583s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[438.501122] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[438.504067] Starting dynamic subtest: pipe-A-eDP-1
[438.536212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[438.545071] Starting dynamic subtest: pipe-B-eDP-1
[438.576222] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[438.584856] Starting dynamic subtest: pipe-C-eDP-1
[438.616161] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[438.625092] Starting dynamic subtest: pipe-D-eDP-1
[438.658157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[438.663314] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[440.722762] [072/131] (580s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[440.827884] Starting subtest: addfb25-y-tiled-legacy
[440.830206] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[440.961794] [073/131] (580s left) kms_async_flips (test-cursor-atomic)
[441.063018] Starting subtest: test-cursor-atomic
[441.068138] Subtest test-cursor-atomic: SKIP (0.000s)
[442.322071] [074/131] (579s left) gem_userptr_blits (readonly-unsync)
[442.394276] Subtest readonly-unsync: SKIP (0.000s)
[442.542519] [075/131] (579s left) kms_sequence (queue-busy)
[442.636531] Starting subtest: queue-busy
[442.638537] Starting dynamic subtest: pipe-A-eDP-1
[444.554812] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.924s)
[444.564981] Starting dynamic subtest: pipe-B-eDP-1
[447.164671] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.612s)
[447.174202] Starting dynamic subtest: pipe-C-eDP-1
[449.724161] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.561s)
[449.733852] Starting dynamic subtest: pipe-D-eDP-1
[452.319480] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.599s)
[452.322515] Subtest queue-busy: SUCCESS (9.701s)
[453.198403] [076/131] (568s left) syncobj_wait (signal)
[453.255316] Starting subtest: signal
[453.257607] Subtest signal: SUCCESS (0.000s)
[453.389831] [077/131] (568s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[453.487642] Starting subtest: fbcpsr-shrfb-scaledprimary
[459.127116] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.648s)
[459.320643] [078/131] (562s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[459.376038] Starting subtest: y-tiled-to-vebox-x-tiled
[459.381276] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[459.576729] [079/131] (562s left) kms_addfb_basic (invalid-set-prop)
[459.642291] Starting subtest: invalid-set-prop
[459.644319] Subtest invalid-set-prop: SUCCESS (0.000s)
[459.822250] [080/131] (562s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[459.917436] Starting subtest: fbc-psr-sprite-mmap-gtt
[459.920156] Starting dynamic subtest: eDP-1
[459.925226] Dynamic subtest eDP-1: SKIP (0.000s)
[459.930560] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[460.013255] [081/131] (561s left) gem_exec_reloc (basic-write-cpu-active)
[460.081102] Subtest basic-write-cpu-active: SKIP (0.000s)
[460.143605] [082/131] (561s left) api_intel_bb (offset-control)
[460.204547] Starting subtest: offset-control
[460.212179] Subtest offset-control: SUCCESS (0.010s)
[460.377514] [083/131] (561s left) gem_exec_whisper (basic-queues-priority)
[460.446795] Starting subtest: basic-queues-priority
[485.044658] Subtest basic-queues-priority: SUCCESS (24.610s)
[485.254068] [084/131] (536s left) gem_ccs (ctrl-surf-copy)
[485.325143] Starting subtest: ctrl-surf-copy
[485.331035] Subtest ctrl-surf-copy: SKIP (0.000s)
[485.474158] [085/131] (536s left) gem_exec_parallel (contexts)
[485.549900] Starting subtest: contexts
[485.552564] Starting dynamic subtest: rcs0
[490.252698] Dynamic subtest rcs0: SUCCESS (4.708s)
[490.262923] Starting dynamic subtest: bcs0
[494.766279] Dynamic subtest bcs0: SUCCESS (4.513s)
[494.778086] Starting dynamic subtest: vcs0
[500.330618] Dynamic subtest vcs0: SUCCESS (5.564s)
[500.347257] Starting dynamic subtest: vcs1
[504.521713] Dynamic subtest vcs1: SUCCESS (4.191s)
[504.533810] Starting dynamic subtest: vecs0
[510.250572] Dynamic subtest vecs0: SUCCESS (5.729s)
[510.262298] Starting dynamic subtest: ccs0
[514.590604] Dynamic subtest ccs0: SUCCESS (4.339s)
[514.593578] Subtest contexts: SUCCESS (29.059s)
[514.805925] [086/131] (507s left) gem_create (create-invalid-size)
[514.861299] Starting subtest: create-invalid-size
[514.864489] Subtest create-invalid-size: SUCCESS (0.000s)
[515.078254] [087/131] (507s left) gem_exec_schedule (noreorder-corked)
[515.256131] Starting subtest: noreorder-corked
[515.259262] Starting dynamic subtest: rcs0
[516.432757] Dynamic subtest rcs0: SUCCESS (1.177s)
[516.445114] Starting dynamic subtest: vcs0
[518.012873] Dynamic subtest vcs0: SUCCESS (1.577s)
[518.024865] Starting dynamic subtest: vcs1
[519.996709] Dynamic subtest vcs1: SUCCESS (1.983s)
[520.013042] Starting dynamic subtest: vecs0
[521.979931] Dynamic subtest vecs0: SUCCESS (1.981s)
[521.992304] Starting dynamic subtest: ccs0
[523.148562] Dynamic subtest ccs0: SUCCESS (1.168s)
[523.151407] Subtest noreorder-corked: SUCCESS (7.898s)
[523.363840] [088/131] (498s left) gem_busy (close-race)
[523.425727] Starting subtest: close-race
[548.965485] Subtest close-race: SUCCESS (25.506s)
[549.376046] [089/131] (472s left) kms_plane_multiple (2x-tiling-x)
[549.523134] Starting subtest: 2x-tiling-x
[549.528048] Subtest 2x-tiling-x: SKIP (0.000s)
[549.619738] [090/131] (472s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[549.726120] Starting subtest: psr-farfromfence-mmap-gtt
[549.732052] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[549.874043] [091/131] (472s left) gem_basic (create-close)
[549.941221] Starting subtest: create-close
[549.946077] Subtest create-close: SUCCESS (0.000s)
[550.079888] [092/131] (472s left) kms_pm_rpm (universal-planes)
[552.140490] Starting subtest: universal-planes
[552.143617] Starting dynamic subtest: plane-33
[560.729630] Dynamic subtest plane-33: SUCCESS (8.583s)
[560.741586] Starting dynamic subtest: plane-63
[569.022321] Dynamic subtest plane-63: SUCCESS (8.288s)
[569.035073] Starting dynamic subtest: plane-93
[577.696191] Dynamic subtest plane-93: SUCCESS (8.670s)
[577.707756] Starting dynamic subtest: plane-123
[586.272309] Dynamic subtest plane-123: SUCCESS (8.573s)
[586.284560] Starting dynamic subtest: plane-133
[594.836592] Dynamic subtest plane-133: SUCCESS (8.561s)
[594.849303] Starting dynamic subtest: plane-143
[603.452021] Dynamic subtest plane-143: SUCCESS (8.610s)
[603.455171] Subtest universal-planes: SUCCESS (51.302s)
[603.832082] [093/131] (418s left) gem_exec_endless (dispatch)
[603.916677] Starting subtest: dispatch
[603.919225] Starting dynamic subtest: rcs0
[603.926762] Dynamic subtest rcs0: SUCCESS (0.007s)
[603.936434] Starting dynamic subtest: bcs0
[603.942443] Dynamic subtest bcs0: SUCCESS (0.004s)
[603.953319] Starting dynamic subtest: vcs0
[603.958287] Dynamic subtest vcs0: SUCCESS (0.004s)
[603.967521] Starting dynamic subtest: vcs1
[603.971911] Dynamic subtest vcs1: SUCCESS (0.005s)
[603.980901] Starting dynamic subtest: vecs0
[603.985280] Dynamic subtest vecs0: SUCCESS (0.005s)
[603.994144] Starting dynamic subtest: ccs0
[603.999097] Dynamic subtest ccs0: SUCCESS (0.006s)
[604.001277] Subtest dispatch: SUCCESS (0.035s)
[606.055509] [094/131] (416s left) kms_vblank (query-idle)
[606.161304] Starting subtest: query-idle
[606.163636] Starting dynamic subtest: pipe-A-eDP-1
[607.902477] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s)
[607.919034] Starting dynamic subtest: pipe-D-eDP-1
[610.362178] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.455s)
[610.365159] Subtest query-idle: SUCCESS (4.201s)
[611.182818] [095/131] (411s left) gem_exec_balancer (hog)
[611.254312] Starting subtest: hog
[611.260110] Subtest hog: SKIP (0.000s)
[611.576152] [096/131] (411s left) kms_flip (flip-vs-panning)
[611.675947] Starting subtest: flip-vs-panning
[611.678296] Starting dynamic subtest: A-eDP1
[620.441845] Dynamic subtest A-eDP1: SUCCESS (8.765s)
[620.451188] Starting dynamic subtest: B-eDP1
[629.138306] Dynamic subtest B-eDP1: SUCCESS (8.695s)
[629.147507] Starting dynamic subtest: C-eDP1
[637.828314] Dynamic subtest C-eDP1: SUCCESS (8.688s)
[637.841632] Starting dynamic subtest: D-eDP1
[646.530458] Dynamic subtest D-eDP1: SUCCESS (8.701s)
[646.534765] Subtest flip-vs-panning: SUCCESS (34.857s)
[647.785531] [097/131] (374s left) i915_query (query-topology-garbage-items)
[647.866163] Starting subtest: query-topology-garbage-items
[647.868709] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[647.991968] [098/131] (374s left) kms_dsc (dsc-basic)
[648.094717] Starting subtest: dsc-basic
[648.109877] Subtest dsc-basic: SKIP (0.000s)
[648.193589] [099/131] (374s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[648.295311] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[648.300063] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[648.429666] [100/131] (374s left) dmabuf_sync_file (import-multiple-read-only)
[648.477957] Starting subtest: import-multiple-read-only
[648.489325] Subtest import-multiple-read-only: SUCCESS (0.013s)
[648.569343] [101/131] (374s left) sw_sync (sync_merge_same)
[648.608932] Starting subtest: sync_merge_same
[648.611652] Subtest sync_merge_same: SUCCESS (0.000s)
[648.681049] [102/131] (374s left) gem_exec_reloc (basic-gtt-cpu)
[648.745105] Subtest basic-gtt-cpu: SKIP (0.000s)
[648.824121] [103/131] (374s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[648.915857] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[648.919776] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[649.032979] [104/131] (373s left) gem_exec_schedule (u-independent)
[649.110151] Starting subtest: u-independent
[649.112158] Starting dynamic subtest: rcs0
[650.981583] Dynamic subtest rcs0: SUCCESS (1.876s)
[650.994755] Starting dynamic subtest: vcs0
[652.996046] Dynamic subtest vcs0: SUCCESS (2.013s)
[653.008832] Starting dynamic subtest: vcs1
[654.987052] Dynamic subtest vcs1: SUCCESS (1.990s)
[654.999302] Starting dynamic subtest: vecs0
[657.027902] Dynamic subtest vecs0: SUCCESS (2.039s)
[657.040985] Starting dynamic subtest: ccs0
[658.981556] Dynamic subtest ccs0: SUCCESS (1.952s)
[658.984471] Subtest u-independent: SUCCESS (9.878s)
[659.309752] [105/131] (363s left) gem_close (basic)
[659.380267] Starting subtest: basic
[659.383300] Subtest basic: SUCCESS (0.000s)
[659.525835] [106/131] (363s left) kms_psr (psr-sprite-mmap-cpu)
[659.632523] Starting subtest: psr-sprite-mmap-cpu
[659.634880] Starting dynamic subtest: eDP-1
[661.346227] Dynamic subtest eDP-1: SUCCESS (1.712s)
[661.349150] Subtest psr-sprite-mmap-cpu: SUCCESS (1.712s)
[662.191069] [107/131] (360s left) gem_eio (banned)
[662.407177] Starting subtest: banned
[663.003707] Subtest banned: SUCCESS (0.594s)
[663.194536] [108/131] (359s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[663.316856] Starting subtest: cursorB-vs-flipA-atomic-transitions
[663.321303] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[663.485496] [109/131] (359s left) kms_chamelium_frames (hdmi-crc-fast)
[663.859569] Subtest hdmi-crc-fast: SKIP (0.000s)
[664.633551] [110/131] (358s left) kms_big_fb (y-tiled-addfb)
[664.751278] Starting subtest: y-tiled-addfb
[664.756921] Subtest y-tiled-addfb: SKIP (0.000s)
[664.888068] [111/131] (358s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[664.990116] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[664.995098] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[665.126332] [112/131] (358s left) gem_exec_reloc (basic-wc-read-noreloc)
[665.185075] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[665.276866] [113/131] (358s left) kms_lease (lease-unleased-connector)
[665.371612] Starting subtest: lease-unleased-connector
[665.374051] Starting dynamic subtest: pipe-A-eDP-1
[665.376698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[665.395116] Starting dynamic subtest: pipe-B-eDP-1
[665.397889] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[665.408273] Starting dynamic subtest: pipe-C-eDP-1
[665.411122] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[665.420998] Starting dynamic subtest: pipe-D-eDP-1
[665.423812] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[665.426121] Subtest lease-unleased-connector: SUCCESS (0.038s)
[665.545870] [114/131] (357s left) gem_eio (unwedge-stress)
[665.770009] Starting subtest: unwedge-stress
[665.772099] Starting dynamic subtest: render
[670.673180] Dynamic subtest render: SUCCESS (4.901s)
[670.689801] Starting dynamic subtest: bsd1
[688.515308] Dynamic subtest bsd1: SUCCESS (17.842s)
[688.531912] Starting dynamic subtest: bsd2
[706.468764] Dynamic subtest bsd2: SUCCESS (17.952s)
[706.485268] Starting dynamic subtest: blt
[706.490171] Dynamic subtest blt: SKIP (0.000s)
[706.500046] Starting dynamic subtest: vebox
[724.474441] Dynamic subtest vebox: SUCCESS (18.005s)
[724.477307] Subtest unwedge-stress: SUCCESS (58.705s)
[726.053522] [115/131] (297s left) gem_exec_whisper (basic-contexts)
[726.126040] Starting subtest: basic-contexts
[733.013524] Subtest basic-contexts: SUCCESS (6.885s)
[733.222379] [116/131] (290s left) kms_plane_cursor (primary)
[733.316003] Starting subtest: primary
[733.320975] Starting dynamic subtest: pipe-A-eDP-1-size-64
[735.848960] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.532s)
[735.872478] Starting dynamic subtest: pipe-A-eDP-1-size-128
[738.405289] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[738.430602] Starting dynamic subtest: pipe-A-eDP-1-size-256
[740.949755] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s)
[741.265289] Starting dynamic subtest: pipe-B-eDP-1-size-64
[744.478749] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.224s)
[744.503745] Starting dynamic subtest: pipe-B-eDP-1-size-128
[747.091160] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.592s)
[747.115071] Starting dynamic subtest: pipe-B-eDP-1-size-256
[749.659553] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[749.974814] Starting dynamic subtest: pipe-C-eDP-1-size-64
[752.850034] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.885s)
[752.876721] Starting dynamic subtest: pipe-C-eDP-1-size-128
[755.038331] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.169s)
[755.065092] Starting dynamic subtest: pipe-C-eDP-1-size-256
[757.217080] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[757.540005] Starting dynamic subtest: pipe-D-eDP-1-size-64
[760.409906] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.885s)
[760.438641] Starting dynamic subtest: pipe-D-eDP-1-size-128
[762.644748] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.213s)
[762.671899] Starting dynamic subtest: pipe-D-eDP-1-size-256
[764.911167] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.247s)
[765.220829] Subtest primary: SUCCESS (31.901s)
[766.078964] [117/131] (257s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[766.196264] Starting subtest: yf-tiled-64bpp-rotate-90
[766.200987] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[766.330643] [118/131] (257s left) gem_mmap_gtt (basic-small-copy)
[766.398039] Subtest basic-small-copy: SKIP (0.000s)
[766.468837] [119/131] (257s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[771.542071] Starting subtest: psr2-overlay-plane-update-continuous-sf
[771.544830] Starting dynamic subtest: pipe-A-eDP-1
[773.259124] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.716s)
[773.270286] Starting dynamic subtest: pipe-B-eDP-1
[774.966870] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.706s)
[774.969554] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.427s)
[775.876985] [120/131] (247s left) gem_partial_pwrite_pread (writes-after-reads)
[775.948200] Subtest writes-after-reads: SKIP (0.000s)
[776.027767] [121/131] (247s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[776.125255] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[776.129558] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[776.246795] [122/131] (247s left) kms_pm_backlight (fade-with-suspend)
[776.343291] Starting subtest: fade-with-suspend
[792.977313] Starting dynamic subtest: eDP-1
[795.650090] Dynamic subtest eDP-1: SUCCESS (2.673s)
[795.652391] Subtest fade-with-suspend: SUCCESS (3.899s)
[796.468576] [123/131] (227s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[796.537250] Starting subtest: single-wait-for-submit-available-submitted
[796.539489] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[796.663560] [124/131] (227s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[796.776407] Starting subtest: 4-tiled-32bpp-rotate-90
[796.796150] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[796.937123] [125/131] (226s left) gem_exec_suspend (basic-s3-devices)
[796.997155] Starting subtest: basic-S3-devices
[796.999532] Starting dynamic subtest: smem
[808.341790] Dynamic subtest smem: SUCCESS (11.327s)
[808.344912] Subtest basic-S3-devices: SUCCESS (11.330s)
[808.564277] [126/131] (215s left) kms_cursor_crc (cursor-onscreen-64x64)
[808.743695] Starting subtest: cursor-onscreen-64x64
[808.748558] Starting dynamic subtest: pipe-A-eDP-1
[810.831857] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.084s)
[810.861301] Starting dynamic subtest: pipe-D-eDP-1
[813.588594] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.732s)
[813.590712] Subtest cursor-onscreen-64x64: SUCCESS (4.840s)
[814.482781] [127/131] (209s left) gem_ctx_persistence (legacy-engines-persistence)
[814.563316] Starting subtest: legacy-engines-persistence
[814.565242] Starting dynamic subtest: render
[815.408744] Dynamic subtest render: SUCCESS (0.847s)
[815.424511] Starting dynamic subtest: bsd1
[816.231758] Dynamic subtest bsd1: SUCCESS (0.819s)
[816.244850] Starting dynamic subtest: bsd2
[816.990608] Dynamic subtest bsd2: SUCCESS (0.756s)
[817.008362] Starting dynamic subtest: blt
[817.758596] Dynamic subtest blt: SUCCESS (0.765s)
[817.774095] Starting dynamic subtest: vebox
[818.537884] Dynamic subtest vebox: SUCCESS (0.776s)
[818.540637] Subtest legacy-engines-persistence: SUCCESS (3.977s)
[818.645940] [128/131] (205s left) gem_render_copy (y-tiled)
[818.721709] Starting subtest: y-tiled
[818.726749] Subtest y-tiled: SKIP (0.000s)
[818.938521] [129/131] (205s left) kms_getfb (getfb-repeated-different-handles)
[819.040909] Starting subtest: getfb-repeated-different-handles
[819.043259] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[819.185004] [130/131] (204s left) gem_pxp (create-valid-protected-context)
[819.302866] Starting subtest: create-valid-protected-context
[819.305155] Subtest create-valid-protected-context: SUCCESS (0.001s)
[819.455808] [131/131] (204s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[824.418861] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[824.423501] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s)
[825.276558] 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.