[59.780775] Initializing watchdogs
[59.780818]   /dev/watchdog0
[59.794782] [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]
[59.799204] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.801548] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.804892] [001/131] (960s left) syncobj_timeline (invalid-wait-illegal-handle)
[59.892852] Starting subtest: invalid-wait-illegal-handle
[59.895197] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[60.028876] [002/131] (960s left) kms_psr (psr2-sprite-blt)
[60.119543] Starting subtest: psr2-sprite-blt
[60.121771] Starting dynamic subtest: eDP-1
[61.884308] Dynamic subtest eDP-1: SUCCESS (1.758s)
[61.886716] Subtest psr2-sprite-blt: SUCCESS (1.758s)
[62.775030] [003/131] (957s left) gem_mmap_gtt (cpuset-medium-copy)
[62.834589] Subtest cpuset-medium-copy: SKIP (0.000s)
[62.893403] [004/131] (957s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[62.989643] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[62.991839] Starting dynamic subtest: pipe-A-eDP-1
[63.013862] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.022464] Starting dynamic subtest: pipe-B-eDP-1
[63.043509] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.050679] Starting dynamic subtest: pipe-C-eDP-1
[63.072775] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.080233] Starting dynamic subtest: pipe-D-eDP-1
[63.102189] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.106226] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[65.255383] [005/131] (955s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[65.313965] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[65.416092] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s)
[65.511550] [006/131] (954s left) kms_addfb_basic (too-high)
[65.596271] Starting subtest: too-high
[65.598546] Subtest too-high: SUCCESS (0.001s)
[65.766635] [007/131] (954s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[65.868483] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[65.870787] Starting dynamic subtest: pipe-A-default-mode
[68.589744] Dynamic subtest pipe-A-default-mode: SUCCESS (2.715s)
[68.591690] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.717s)
[69.444877] [008/131] (951s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[69.573878] Starting subtest: flip-vs-cursor-busy-crc-legacy
[70.422187] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.847s)
[71.269091] [009/131] (949s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[71.366827] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[71.369230] Starting dynamic subtest: pipe-A-default-mode
[74.078736] Dynamic subtest pipe-A-default-mode: SUCCESS (2.709s)
[74.081074] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.710s)
[74.966492] [010/131] (945s left) sriov_basic (enable-vfs-autoprobe-on)
[75.019716] Starting subtest: enable-vfs-autoprobe-on
[75.022198] Starting dynamic subtest: numvfs-1
[75.100799] Dynamic subtest numvfs-1: FAIL (0.033s)
[75.109307] Starting dynamic subtest: numvfs-2
[75.182875] Dynamic subtest numvfs-2: FAIL (0.004s)
[75.191624] Starting dynamic subtest: numvfs-3
[75.264225] Dynamic subtest numvfs-3: FAIL (0.003s)
[75.272830] Starting dynamic subtest: numvfs-4
[75.346296] Dynamic subtest numvfs-4: FAIL (0.004s)
[75.354914] Starting dynamic subtest: numvfs-5
[75.427677] Dynamic subtest numvfs-5: FAIL (0.005s)
[75.435967] Starting dynamic subtest: numvfs-6
[75.511676] Dynamic subtest numvfs-6: FAIL (0.004s)
[75.521319] Starting dynamic subtest: numvfs-7
[75.595069] Dynamic subtest numvfs-7: FAIL (0.003s)
[75.602668] Starting dynamic subtest: numvfs-random
[75.677587] Dynamic subtest numvfs-random: FAIL (0.003s)
[75.686338] Starting dynamic subtest: numvfs-all
[75.760736] Dynamic subtest numvfs-all: FAIL (0.507s)
[75.763108] Subtest enable-vfs-autoprobe-on: FAIL (0.570s)
[75.797194] [011/131] (944s left) gem_pxp (fail-invalid-protected-context)
[75.938583] Starting subtest: fail-invalid-protected-context
[75.940828] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[76.071951] [012/131] (944s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[76.198963] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[77.180619] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.980s)
[78.004366] [013/131] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[78.122369] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[85.510810] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.388s)
[85.662850] [014/131] (935s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[85.791554] Starting subtest: short-flip-after-cursor-atomic-transitions
[86.744425] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.952s)
[87.570812] [015/131] (933s left) perf_pmu (busy-check-all)
[87.613564] Starting subtest: busy-check-all
[87.615897] Starting dynamic subtest: rcs0
[88.192421] Dynamic subtest rcs0: SUCCESS (0.580s)
[88.203301] Starting dynamic subtest: bcs0
[88.739600] Dynamic subtest bcs0: SUCCESS (0.547s)
[88.750168] Starting dynamic subtest: vcs0
[89.940530] Dynamic subtest vcs0: SUCCESS (1.197s)
[89.951479] Starting dynamic subtest: vcs1
[91.926386] Dynamic subtest vcs1: SUCCESS (1.984s)
[91.937066] Starting dynamic subtest: vecs0
[93.910477] Dynamic subtest vecs0: SUCCESS (1.982s)
[93.920236] Starting dynamic subtest: ccs0
[94.462191] Dynamic subtest ccs0: SUCCESS (0.552s)
[94.464701] Subtest busy-check-all: SUCCESS (6.849s)
[94.602755] [016/131] (926s left) kms_pm_rpm (modeset-stress-extra-wait)
[96.138514] Starting subtest: modeset-stress-extra-wait
[150.405456] Subtest modeset-stress-extra-wait: SUCCESS (54.263s)
[150.520480] [017/131] (870s left) kms_force_connector_basic (force-connector-state)
[150.604706] Starting subtest: force-connector-state
[151.228450] Subtest force-connector-state: SUCCESS (0.626s)
[152.235293] [018/131] (868s left) gem_exec_create (madvise)
[152.311464] Starting subtest: madvise
[152.313823] Starting dynamic subtest: smem
[173.975846] Dynamic subtest smem: SUCCESS (21.662s)
[173.978169] Subtest madvise: SUCCESS (21.663s)
[174.903317] [019/131] (846s left) kms_cursor_legacy (single-bo)
[175.062164] Starting subtest: single-bo
[175.064070] Starting dynamic subtest: pipe-A
[180.444968] Dynamic subtest pipe-A: SUCCESS (5.380s)
[180.454315] Starting dynamic subtest: pipe-B
[185.826611] Dynamic subtest pipe-B: SUCCESS (5.380s)
[185.836114] Starting dynamic subtest: pipe-C
[191.208865] Dynamic subtest pipe-C: SUCCESS (5.380s)
[191.218342] Starting dynamic subtest: pipe-D
[196.590503] Dynamic subtest pipe-D: SUCCESS (5.380s)
[196.600049] Starting dynamic subtest: all-pipes
[201.979669] Dynamic subtest all-pipes: SUCCESS (5.387s)
[201.982098] Subtest single-bo: SUCCESS (26.914s)
[202.148470] [020/131] (818s left) kms_big_fb (linear-16bpp-rotate-270)
[202.257656] Starting subtest: linear-16bpp-rotate-270
[202.277197] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[202.436070] [021/131] (818s left) kms_cursor_edge_walk (128x128-top-bottom)
[202.531706] Starting subtest: 128x128-top-bottom
[202.533990] Starting dynamic subtest: pipe-A-eDP-1
[206.016744] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s)
[206.025088] Starting dynamic subtest: pipe-D-eDP-1
[209.219372] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.200s)
[209.221303] Subtest 128x128-top-bottom: SUCCESS (6.688s)
[210.106256] [022/131] (811s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[210.201553] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[210.203811] Starting dynamic subtest: pipe-A-eDP-1
[210.226251] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.234691] Starting dynamic subtest: pipe-B-eDP-1
[210.255897] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.263371] Starting dynamic subtest: pipe-C-eDP-1
[210.285714] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.293413] Starting dynamic subtest: pipe-D-eDP-1
[210.316064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.320224] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[212.404201] [023/131] (808s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[212.518024] Starting subtest: basic-flip-after-cursor-legacy
[213.443238] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.925s)
[214.308409] [024/131] (806s left) gem_vm_create (execbuf)
[214.378854] Starting subtest: execbuf
[214.386454] Subtest execbuf: SUCCESS (0.008s)
[214.560260] [025/131] (806s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[214.674865] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[214.679041] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[214.793268] [026/131] (806s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[214.904887] Starting subtest: fbc-rgb565-draw-mmap-gtt
[214.909232] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[215.041715] [027/131] (806s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[215.155583] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[221.865924] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.712s)
[222.015124] [028/131] (799s left) kms_vrr (seamless-rr-switch-vrr)
[222.100855] Starting subtest: seamless-rr-switch-vrr
[222.107616] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[222.194341] [029/131] (799s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[222.297262] Starting subtest: yf-tiled-32bpp-rotate-0
[222.301364] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[222.409680] [030/131] (799s left) gem_ctx_engines (invalid-engines)
[222.484322] Starting subtest: invalid-engines
[222.492103] Subtest invalid-engines: SUCCESS (0.008s)
[222.748327] [031/131] (798s left) kms_flip (2x-flip-vs-rmfb)
[222.839945] Starting subtest: 2x-flip-vs-rmfb
[222.849702] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[222.948520] [032/131] (798s left) syncobj_timeline (wait-any-complex)
[223.008131] Starting subtest: wait-any-complex
[223.069315] Subtest wait-any-complex: SUCCESS (0.061s)
[223.164536] [033/131] (798s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[223.762067] Starting subtest: syncobj-timeline-multiple-ext-nodes
[223.764957] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[224.996950] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[225.000248] [034/131] (796s left) gen9_exec_parse (bb-chained)
[225.075981] Subtest bb-chained: SKIP (0.000s)
[225.154664] [035/131] (796s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[225.261690] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[229.249531] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.991s)
[230.428749] [036/131] (791s left) api_intel_allocator (simple-allocator)
[230.491451] Starting subtest: simple-allocator
[230.493496] Starting dynamic subtest: basic
[230.495945] Dynamic subtest basic: SUCCESS (0.006s)
[230.508721] Starting dynamic subtest: parallel-one
[230.687592] Dynamic subtest parallel-one: SUCCESS (0.191s)
[230.697408] Starting dynamic subtest: print
[230.699547] Dynamic subtest print: SUCCESS (0.000s)
[230.707482] Starting dynamic subtest: reuse
[230.709672] Dynamic subtest reuse: SUCCESS (0.000s)
[230.717562] Starting dynamic subtest: reserve
[230.719706] Dynamic subtest reserve: SUCCESS (0.000s)
[230.727080] Starting dynamic subtest: fork-reopen-allocator
[230.729236] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[230.731391] Subtest simple-allocator: SUCCESS (0.211s)
[230.835937] [037/131] (790s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[230.925727] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[238.556886] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.634s)
[238.732657] [038/131] (783s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[238.842077] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[238.844420] Starting dynamic subtest: pipe-A-eDP-1
[238.864585] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[238.874541] Starting dynamic subtest: pipe-B-eDP-1
[238.893606] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[238.901330] Starting dynamic subtest: pipe-C-eDP-1
[238.920704] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[238.927917] Starting dynamic subtest: pipe-D-eDP-1
[238.947212] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[238.949353] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[241.109289] [039/131] (780s left) gem_softpin (evict-prime-sanity-check)
[241.176595] Starting subtest: evict-prime-sanity-check
[241.178982] Starting dynamic subtest: rcs0
[242.351291] Dynamic subtest rcs0: SUCCESS (1.173s)
[242.361040] Starting dynamic subtest: bcs0
[243.496757] Dynamic subtest bcs0: SUCCESS (1.144s)
[243.508356] Starting dynamic subtest: vcs0
[244.900747] Dynamic subtest vcs0: SUCCESS (1.400s)
[244.911794] Starting dynamic subtest: vcs1
[246.935761] Dynamic subtest vcs1: SUCCESS (2.033s)
[246.946953] Starting dynamic subtest: vecs0
[248.906466] Dynamic subtest vecs0: SUCCESS (1.969s)
[248.917894] Starting dynamic subtest: ccs0
[250.094596] Dynamic subtest ccs0: SUCCESS (1.187s)
[250.105099] Starting dynamic subtest: all
[251.245636] Dynamic subtest all: SUCCESS (1.149s)
[251.248316] Subtest evict-prime-sanity-check: SUCCESS (10.068s)
[251.351295] [040/131] (770s left) i915_hangman (error-state-basic)
[251.408921] Starting subtest: error-state-basic
[251.573038] Subtest error-state-basic: SUCCESS (0.164s)
[251.678146] [041/131] (770s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[251.781933] Starting subtest: fbc-psr2-sprite-plane-onoff
[251.784232] Starting dynamic subtest: eDP-1
[251.788326] Dynamic subtest eDP-1: SKIP (0.000s)
[251.792442] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[251.877486] [042/131] (770s left) kms_content_protection (dp-mst-type-1)
[252.024063] Starting subtest: dp-mst-type-1
[252.028557] Subtest dp-mst-type-1: SKIP (0.000s)
[252.195243] [043/131] (769s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[252.299069] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[252.300818] Starting dynamic subtest: pipe-A-eDP-1
[252.319481] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[252.329076] Starting dynamic subtest: pipe-B-eDP-1
[252.346504] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[252.354099] Starting dynamic subtest: pipe-C-eDP-1
[252.371971] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[252.380399] Starting dynamic subtest: pipe-D-eDP-1
[252.398586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[252.402109] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[254.604694] [044/131] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[254.711408] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[254.715618] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[254.841115] [045/131] (767s left) perf_pmu (multi-client)
[254.888699] Starting subtest: multi-client
[254.890778] Starting dynamic subtest: rcs0
[255.965285] Dynamic subtest rcs0: SUCCESS (1.076s)
[255.974801] Starting dynamic subtest: bcs0
[257.015385] Dynamic subtest bcs0: SUCCESS (1.047s)
[257.024774] Starting dynamic subtest: vcs0
[258.068141] Dynamic subtest vcs0: SUCCESS (1.050s)
[258.077888] Starting dynamic subtest: vcs1
[259.916836] Dynamic subtest vcs1: SUCCESS (1.846s)
[259.927750] Starting dynamic subtest: vecs0
[261.900375] Dynamic subtest vecs0: SUCCESS (1.982s)
[261.911587] Starting dynamic subtest: ccs0
[263.947427] Dynamic subtest ccs0: SUCCESS (2.045s)
[263.950085] Subtest multi-client: SUCCESS (9.060s)
[264.111582] [046/131] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[264.212544] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[270.891156] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.682s)
[271.083445] [047/131] (751s left) kms_color_pipeline (plane-lut1d)
[271.178758] Starting subtest: plane-lut1d
[271.191941] Starting dynamic subtest: pipe-A-eDP-1
[271.873913] Dynamic subtest pipe-A-eDP-1: FAIL (0.293s)
[272.527598] Starting dynamic subtest: pipe-B-eDP-1
[273.344107] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[273.936487] Starting dynamic subtest: pipe-C-eDP-1
[274.783529] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s)
[275.233049] Starting dynamic subtest: pipe-D-eDP-1
[276.057466] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[276.059456] Subtest plane-lut1d: FAIL (4.575s)
[276.614019] [048/131] (745s left) gem_ctx_isolation (preservation-s3)
[276.693633] Starting subtest: preservation-S3
[276.696066] Starting dynamic subtest: rcs0
[293.128625] Dynamic subtest rcs0: SUCCESS (5.078s)
[293.138363] Starting dynamic subtest: bcs0
[309.120572] Dynamic subtest bcs0: SUCCESS (1.332s)
[309.129990] Starting dynamic subtest: vcs0
[325.100934] Dynamic subtest vcs0: SUCCESS (2.743s)
[325.111299] Starting dynamic subtest: vcs1
[343.122272] Dynamic subtest vcs1: SUCCESS (4.924s)
[343.134609] Starting dynamic subtest: vecs0
[361.113083] Dynamic subtest vecs0: SUCCESS (4.988s)
[361.123496] Starting dynamic subtest: ccs0
[379.114216] Dynamic subtest ccs0: SUCCESS (3.064s)
[379.116437] Subtest preservation-S3: SUCCESS (22.135s)
[379.393280] [049/131] (642s left) gem_exec_async (concurrent-writes)
[379.472536] Starting subtest: concurrent-writes
[379.474808] Starting dynamic subtest: rcs0
[379.490396] Dynamic subtest rcs0: SUCCESS (0.017s)
[379.502118] Starting dynamic subtest: bcs0
[379.504575] Dynamic subtest bcs0: SUCCESS (0.007s)
[379.518176] Starting dynamic subtest: vcs0
[379.520488] Dynamic subtest vcs0: SUCCESS (0.006s)
[379.529484] Starting dynamic subtest: vcs1
[379.531687] Dynamic subtest vcs1: SUCCESS (0.006s)
[379.540398] Starting dynamic subtest: vecs0
[379.542650] Dynamic subtest vecs0: SUCCESS (0.005s)
[379.551381] Starting dynamic subtest: ccs0
[379.553667] Dynamic subtest ccs0: SUCCESS (0.005s)
[379.555935] Subtest concurrent-writes: SUCCESS (0.050s)
[379.780283] [050/131] (642s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[379.995317] Starting subtest: cursor-rapid-movement-128x42
[380.043370] Subtest cursor-rapid-movement-128x42: SKIP (0.041s)
[380.283558] [051/131] (642s left) gem_exec_create (basic)
[380.347297] Starting subtest: basic
[380.349270] Starting dynamic subtest: smem
[383.820138] Dynamic subtest smem: SUCCESS (3.396s)
[383.823236] Subtest basic: SUCCESS (3.398s)
[384.034034] [052/131] (638s left) gem_exec_fence (basic-wait-all)
[384.097427] Starting subtest: basic-wait-all
[384.194113] Subtest basic-wait-all: SUCCESS (0.096s)
[385.932685] [053/131] (636s left) perf (mi-rpc)
[386.092702] Starting subtest: mi-rpc
[386.096858] Subtest mi-rpc: SKIP (0.000s)
[386.133946] [054/131] (636s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[386.197278] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[386.200117] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[386.338135] [055/131] (636s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[386.445576] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[386.447874] Starting dynamic subtest: pipe-A
[386.467736] Dynamic subtest pipe-A: SKIP (0.018s)
[386.477375] Starting dynamic subtest: pipe-B
[386.500028] Dynamic subtest pipe-B: SKIP (0.031s)
[386.509291] Starting dynamic subtest: pipe-C
[386.533199] Dynamic subtest pipe-C: SKIP (0.031s)
[386.542136] Starting dynamic subtest: pipe-D
[386.565454] Dynamic subtest pipe-D: SKIP (0.031s)
[386.569118] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.115s)
[386.705087] [056/131] (635s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[386.815516] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[393.455615] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.588s)
[393.596339] [057/131] (628s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[393.991564] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[394.855663] [058/131] (627s left) gem_mmap_gtt (hang-user)
[394.925623] Subtest hang-user: SKIP (0.000s)
[395.000134] [059/131] (627s left) kms_joiner (invalid-modeset-ultra-joiner)
[395.110018] Starting subtest: invalid-modeset-ultra-joiner
[395.113996] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[395.197629] [060/131] (627s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[395.312249] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[395.316250] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[395.448827] [061/131] (627s left) gem_exec_schedule (fifo)
[395.525805] Starting subtest: fifo
[395.527699] Starting dynamic subtest: rcs0
[395.619387] Dynamic subtest rcs0: SUCCESS (0.102s)
[395.631284] Starting dynamic subtest: vcs0
[395.697212] Dynamic subtest vcs0: SUCCESS (0.077s)
[395.708682] Starting dynamic subtest: vcs1
[395.774543] Dynamic subtest vcs1: SUCCESS (0.077s)
[395.785632] Starting dynamic subtest: vecs0
[395.845714] Dynamic subtest vecs0: SUCCESS (0.070s)
[395.856202] Starting dynamic subtest: ccs0
[395.924823] Dynamic subtest ccs0: SUCCESS (0.078s)
[395.926880] Subtest fifo: SUCCESS (0.408s)
[396.956298] [062/131] (625s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[397.058021] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[397.062517] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[397.198932] [063/131] (625s left) i915_pm_rpm (gem-evict-pwrite)
[399.030315] Starting subtest: gem-evict-pwrite
[399.036046] Subtest gem-evict-pwrite: SKIP (0.000s)
[399.523881] [064/131] (623s left) kms_frontbuffer_tracking (psr-suspend)
[399.623954] Starting subtest: psr-suspend
[437.620426] Subtest psr-suspend: SUCCESS (7.819s)
[437.771362] [065/131] (585s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[437.884517] Starting subtest: x-tiled-32bpp-rotate-180
[439.352978] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.436s)
[439.516155] [066/131] (583s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[439.623832] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[439.628123] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[439.768589] [067/131] (583s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[439.836394] Starting subtest: multi-wait-for-submit-unsubmitted
[439.938233] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.100s)
[440.044885] [068/131] (582s left) gen9_exec_parse (shadow-peek)
[440.107855] Subtest shadow-peek: SKIP (0.000s)
[440.191985] [069/131] (582s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[440.293918] Starting subtest: fbc-psr2-cursor-mmap-gtt
[440.296183] Starting dynamic subtest: eDP-1
[440.301029] Dynamic subtest eDP-1: SKIP (0.000s)
[440.305144] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[440.392627] [070/131] (582s left) syncobj_basic (illegal-fd-to-handle)
[440.456353] Starting subtest: illegal-fd-to-handle
[440.458690] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[440.574587] [071/131] (582s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[440.663726] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[440.665931] Starting dynamic subtest: pipe-A-eDP-1
[440.688598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[440.698620] Starting dynamic subtest: pipe-B-eDP-1
[440.723122] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[440.732294] Starting dynamic subtest: pipe-C-eDP-1
[440.755631] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[440.764186] Starting dynamic subtest: pipe-D-eDP-1
[440.788783] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[440.793182] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[443.002880] [072/131] (580s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[443.104666] Starting subtest: addfb25-y-tiled-legacy
[443.107185] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[443.234177] [073/131] (580s left) kms_async_flips (test-cursor-atomic)
[443.335183] Starting subtest: test-cursor-atomic
[443.340127] Subtest test-cursor-atomic: SKIP (0.000s)
[444.618717] [074/131] (578s left) gem_userptr_blits (readonly-unsync)
[444.692532] Subtest readonly-unsync: SKIP (0.000s)
[444.864697] [075/131] (578s left) kms_sequence (queue-busy)
[444.957065] Starting subtest: queue-busy
[444.959660] Starting dynamic subtest: pipe-A-eDP-1
[446.906183] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[446.917105] Starting dynamic subtest: pipe-B-eDP-1
[449.498074] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.573s)
[449.509401] Starting dynamic subtest: pipe-C-eDP-1
[452.087915] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.576s)
[452.098791] Starting dynamic subtest: pipe-D-eDP-1
[454.737056] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.635s)
[454.740230] Subtest queue-busy: SUCCESS (9.719s)
[455.591756] [076/131] (567s left) syncobj_wait (signal)
[455.646280] Starting subtest: signal
[455.649234] Subtest signal: SUCCESS (0.000s)
[455.781609] [077/131] (567s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[455.875867] Starting subtest: fbcpsr-shrfb-scaledprimary
[461.573247] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.688s)
[461.732351] [078/131] (561s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[461.803647] Starting subtest: y-tiled-to-vebox-x-tiled
[461.809184] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[462.013059] [079/131] (561s left) kms_addfb_basic (invalid-set-prop)
[462.065854] Starting subtest: invalid-set-prop
[462.068011] Subtest invalid-set-prop: SUCCESS (0.000s)
[462.249896] [080/131] (561s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[462.349359] Starting subtest: fbc-psr-sprite-mmap-gtt
[462.351770] Starting dynamic subtest: eDP-1
[462.356243] Dynamic subtest eDP-1: SKIP (0.000s)
[462.360861] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[462.445519] [081/131] (561s left) gem_exec_reloc (basic-write-cpu-active)
[462.512489] Subtest basic-write-cpu-active: SKIP (0.000s)
[462.592333] [082/131] (561s left) api_intel_bb (offset-control)
[462.651666] Starting subtest: offset-control
[462.657370] Subtest offset-control: SUCCESS (0.008s)
[462.822980] [083/131] (560s left) gem_exec_whisper (basic-queues-priority)
[462.894776] Starting subtest: basic-queues-priority
[486.150225] Subtest basic-queues-priority: SUCCESS (23.234s)
[486.362186] [084/131] (537s left) gem_ccs (ctrl-surf-copy)
[486.429349] Starting subtest: ctrl-surf-copy
[486.434281] Subtest ctrl-surf-copy: SKIP (0.000s)
[486.552836] [085/131] (537s left) gem_exec_parallel (contexts)
[486.627231] Starting subtest: contexts
[486.630109] Starting dynamic subtest: rcs0
[491.705866] Dynamic subtest rcs0: SUCCESS (5.074s)
[491.715417] Starting dynamic subtest: bcs0
[496.266688] Dynamic subtest bcs0: SUCCESS (4.558s)
[496.279013] Starting dynamic subtest: vcs0
[502.304748] Dynamic subtest vcs0: SUCCESS (6.034s)
[502.317408] Starting dynamic subtest: vcs1
[508.245377] Dynamic subtest vcs1: SUCCESS (5.934s)
[508.257210] Starting dynamic subtest: vecs0
[512.473771] Dynamic subtest vecs0: SUCCESS (4.225s)
[512.484015] Starting dynamic subtest: ccs0
[517.291552] Dynamic subtest ccs0: SUCCESS (4.815s)
[517.294369] Subtest contexts: SUCCESS (30.649s)
[517.498855] [086/131] (506s left) gem_create (create-invalid-size)
[517.563182] Starting subtest: create-invalid-size
[517.565890] Subtest create-invalid-size: SUCCESS (0.000s)
[517.778778] [087/131] (506s left) gem_exec_schedule (noreorder-corked)
[517.973114] Starting subtest: noreorder-corked
[517.976098] Starting dynamic subtest: rcs0
[519.154113] Dynamic subtest rcs0: SUCCESS (1.179s)
[519.166538] Starting dynamic subtest: vcs0
[520.969485] Dynamic subtest vcs0: SUCCESS (1.811s)
[520.981100] Starting dynamic subtest: vcs1
[522.918017] Dynamic subtest vcs1: SUCCESS (1.945s)
[522.931383] Starting dynamic subtest: vecs0
[524.942316] Dynamic subtest vecs0: SUCCESS (2.021s)
[524.955352] Starting dynamic subtest: ccs0
[526.117774] Dynamic subtest ccs0: SUCCESS (1.174s)
[526.120637] Subtest noreorder-corked: SUCCESS (8.142s)
[526.331696] [088/131] (497s left) gem_busy (close-race)
[526.398810] Starting subtest: close-race
[549.953073] Subtest close-race: SUCCESS (23.563s)
[550.338136] [089/131] (473s left) kms_plane_multiple (2x-tiling-x)
[550.483088] Starting subtest: 2x-tiling-x
[550.488062] Subtest 2x-tiling-x: SKIP (0.000s)
[550.580108] [090/131] (473s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[550.679567] Starting subtest: psr-farfromfence-mmap-gtt
[550.684961] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[550.811212] [091/131] (473s left) gem_basic (create-close)
[550.869143] Starting subtest: create-close
[550.874114] Subtest create-close: SUCCESS (0.000s)
[551.006527] [092/131] (473s left) kms_pm_rpm (universal-planes)
[553.165780] Starting subtest: universal-planes
[553.168279] Starting dynamic subtest: plane-33
[561.453982] Dynamic subtest plane-33: SUCCESS (8.294s)
[561.465275] Starting dynamic subtest: plane-63
[570.024317] Dynamic subtest plane-63: SUCCESS (8.569s)
[570.042167] Starting dynamic subtest: plane-93
[578.356479] Dynamic subtest plane-93: SUCCESS (8.329s)
[578.375489] Starting dynamic subtest: plane-123
[586.948328] Dynamic subtest plane-123: SUCCESS (8.588s)
[586.961910] Starting dynamic subtest: plane-133
[595.542890] Dynamic subtest plane-133: SUCCESS (8.591s)
[595.556460] Starting dynamic subtest: plane-143
[603.837710] Dynamic subtest plane-143: SUCCESS (8.291s)
[603.840496] Subtest universal-planes: SUCCESS (50.678s)
[604.230252] [093/131] (419s left) gem_exec_endless (dispatch)
[604.314944] Starting subtest: dispatch
[604.317916] Starting dynamic subtest: rcs0
[604.324137] Dynamic subtest rcs0: SUCCESS (0.005s)
[604.337393] Starting dynamic subtest: bcs0
[604.343368] Dynamic subtest bcs0: SUCCESS (0.004s)
[604.355007] Starting dynamic subtest: vcs0
[604.360007] Dynamic subtest vcs0: SUCCESS (0.004s)
[604.370047] Starting dynamic subtest: vcs1
[604.375200] Dynamic subtest vcs1: SUCCESS (0.004s)
[604.384495] Starting dynamic subtest: vecs0
[604.389377] Dynamic subtest vecs0: SUCCESS (0.005s)
[604.398813] Starting dynamic subtest: ccs0
[604.403834] Dynamic subtest ccs0: SUCCESS (0.004s)
[604.406117] Subtest dispatch: SUCCESS (0.031s)
[606.011056] [094/131] (418s left) kms_vblank (query-idle)
[606.107864] Starting subtest: query-idle
[606.110343] Starting dynamic subtest: pipe-A-eDP-1
[607.848246] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.741s)
[607.863790] Starting dynamic subtest: pipe-D-eDP-1
[610.285023] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.432s)
[610.287512] Subtest query-idle: SUCCESS (4.177s)
[611.105474] [095/131] (413s left) gem_exec_balancer (hog)
[611.173340] Starting subtest: hog
[611.178415] Subtest hog: SKIP (0.000s)
[611.490215] [096/131] (412s left) kms_flip (flip-vs-panning)
[611.582040] Starting subtest: flip-vs-panning
[611.584370] Starting dynamic subtest: A-eDP1
[620.271970] Dynamic subtest A-eDP1: SUCCESS (8.687s)
[620.282197] Starting dynamic subtest: B-eDP1
[628.965747] Dynamic subtest B-eDP1: SUCCESS (8.691s)
[628.976158] Starting dynamic subtest: C-eDP1
[637.660993] Dynamic subtest C-eDP1: SUCCESS (8.692s)
[637.671643] Starting dynamic subtest: D-eDP1
[646.360024] Dynamic subtest D-eDP1: SUCCESS (8.695s)
[646.364353] Subtest flip-vs-panning: SUCCESS (34.773s)
[647.612809] [097/131] (376s left) i915_query (query-topology-garbage-items)
[647.673693] Starting subtest: query-topology-garbage-items
[647.676180] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[647.806503] [098/131] (376s left) kms_dsc (dsc-basic)
[647.904878] Starting subtest: dsc-basic
[647.922908] Subtest dsc-basic: SKIP (0.000s)
[648.004232] [099/131] (376s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[648.101343] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[648.106538] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[648.228476] [100/131] (376s left) dmabuf_sync_file (import-multiple-read-only)
[648.278369] Starting subtest: import-multiple-read-only
[648.289886] Subtest import-multiple-read-only: SUCCESS (0.013s)
[648.372567] [101/131] (376s left) sw_sync (sync_merge_same)
[648.411159] Starting subtest: sync_merge_same
[648.413934] Subtest sync_merge_same: SUCCESS (0.000s)
[648.482186] [102/131] (376s left) gem_exec_reloc (basic-gtt-cpu)
[648.539347] Subtest basic-gtt-cpu: SKIP (0.000s)
[648.605002] [103/131] (375s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[648.713960] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[648.717750] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[648.849110] [104/131] (375s left) gem_exec_schedule (u-independent)
[648.935987] Starting subtest: u-independent
[648.938172] Starting dynamic subtest: rcs0
[650.937619] Dynamic subtest rcs0: SUCCESS (2.008s)
[650.950380] Starting dynamic subtest: vcs0
[652.962699] Dynamic subtest vcs0: SUCCESS (2.022s)
[652.973896] Starting dynamic subtest: vcs1
[654.992316] Dynamic subtest vcs1: SUCCESS (2.026s)
[655.005956] Starting dynamic subtest: vecs0
[656.974619] Dynamic subtest vecs0: SUCCESS (1.980s)
[656.987023] Starting dynamic subtest: ccs0
[658.935361] Dynamic subtest ccs0: SUCCESS (1.957s)
[658.938530] Subtest u-independent: SUCCESS (10.005s)
[659.264680] [105/131] (365s left) gem_close (basic)
[659.328070] Starting subtest: basic
[659.330836] Subtest basic: SUCCESS (0.000s)
[659.474946] [106/131] (365s left) kms_psr (psr-sprite-mmap-cpu)
[659.575804] Starting subtest: psr-sprite-mmap-cpu
[659.578067] Starting dynamic subtest: eDP-1
[661.275850] Dynamic subtest eDP-1: SUCCESS (1.701s)
[661.278631] Subtest psr-sprite-mmap-cpu: SUCCESS (1.702s)
[662.105883] [107/131] (362s left) gem_eio (banned)
[662.331936] Starting subtest: banned
[662.971290] Subtest banned: SUCCESS (0.640s)
[663.155832] [108/131] (361s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[663.272843] Starting subtest: cursorB-vs-flipA-atomic-transitions
[663.276725] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[663.440515] [109/131] (361s left) kms_chamelium_frames (hdmi-crc-fast)
[663.823024] Subtest hdmi-crc-fast: SKIP (0.000s)
[664.673501] [110/131] (360s left) kms_big_fb (y-tiled-addfb)
[664.784237] Starting subtest: y-tiled-addfb
[664.789204] Subtest y-tiled-addfb: SKIP (0.000s)
[664.900834] [111/131] (359s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[664.999106] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[665.003794] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[665.130618] [112/131] (359s left) gem_exec_reloc (basic-wc-read-noreloc)
[665.198821] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[665.287248] [113/131] (359s left) kms_lease (lease-unleased-connector)
[665.391346] Starting subtest: lease-unleased-connector
[665.393642] Starting dynamic subtest: pipe-A-eDP-1
[665.399048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[665.409280] Starting dynamic subtest: pipe-B-eDP-1
[665.411843] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[665.422362] Starting dynamic subtest: pipe-C-eDP-1
[665.425112] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[665.435344] Starting dynamic subtest: pipe-D-eDP-1
[665.437923] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[665.440198] Subtest lease-unleased-connector: SUCCESS (0.038s)
[665.550586] [114/131] (359s left) gem_eio (unwedge-stress)
[665.773609] Starting subtest: unwedge-stress
[665.775606] Starting dynamic subtest: render
[670.784265] Dynamic subtest render: SUCCESS (5.009s)
[670.801690] Starting dynamic subtest: bsd1
[688.515208] Dynamic subtest bsd1: SUCCESS (17.733s)
[688.533157] Starting dynamic subtest: bsd2
[706.494804] Dynamic subtest bsd2: SUCCESS (17.980s)
[706.511230] Starting dynamic subtest: blt
[706.516380] Dynamic subtest blt: SKIP (0.000s)
[706.525900] Starting dynamic subtest: vebox
[724.473741] Dynamic subtest vebox: SUCCESS (17.978s)
[724.476248] Subtest unwedge-stress: SUCCESS (58.706s)
[726.005808] [115/131] (299s left) gem_exec_whisper (basic-contexts)
[726.067805] Starting subtest: basic-contexts
[733.912124] Subtest basic-contexts: SUCCESS (7.841s)
[734.118313] [116/131] (290s left) kms_plane_cursor (primary)
[734.221757] Starting subtest: primary
[734.226828] Starting dynamic subtest: pipe-A-eDP-1-size-64
[736.798894] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.576s)
[736.820991] Starting dynamic subtest: pipe-A-eDP-1-size-128
[739.386156] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[739.410689] Starting dynamic subtest: pipe-A-eDP-1-size-256
[741.965900] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.561s)
[742.283671] Starting dynamic subtest: pipe-B-eDP-1-size-64
[745.510115] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.238s)
[745.543346] Starting dynamic subtest: pipe-B-eDP-1-size-128
[748.089168] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s)
[748.116182] Starting dynamic subtest: pipe-B-eDP-1-size-256
[750.694226] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[751.026064] Starting dynamic subtest: pipe-C-eDP-1-size-64
[753.935715] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.927s)
[753.962981] Starting dynamic subtest: pipe-C-eDP-1-size-128
[756.169238] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.213s)
[756.195650] Starting dynamic subtest: pipe-C-eDP-1-size-256
[758.391507] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.202s)
[758.712529] Starting dynamic subtest: pipe-D-eDP-1-size-64
[761.633683] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.935s)
[761.661658] Starting dynamic subtest: pipe-D-eDP-1-size-128
[763.867831] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.213s)
[763.894973] Starting dynamic subtest: pipe-D-eDP-1-size-256
[766.077733] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[766.401483] Subtest primary: SUCCESS (32.178s)
[767.292414] [117/131] (257s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[767.389091] Starting subtest: yf-tiled-64bpp-rotate-90
[767.394133] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[767.536050] [118/131] (257s left) gem_mmap_gtt (basic-small-copy)
[767.596088] Subtest basic-small-copy: SKIP (0.000s)
[767.662820] [119/131] (257s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[772.645130] Starting subtest: psr2-overlay-plane-update-continuous-sf
[772.647728] Starting dynamic subtest: pipe-A-eDP-1
[774.384638] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.736s)
[774.396062] Starting dynamic subtest: pipe-B-eDP-1
[776.116339] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.731s)
[776.119408] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.471s)
[777.038880] [120/131] (248s left) gem_partial_pwrite_pread (writes-after-reads)
[777.122208] Subtest writes-after-reads: SKIP (0.000s)
[777.204641] [121/131] (248s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[777.298879] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[777.304053] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[777.430212] [122/131] (247s left) kms_pm_backlight (fade-with-suspend)
[777.535377] Starting subtest: fade-with-suspend
[794.065326] Starting dynamic subtest: eDP-1
[796.732789] Dynamic subtest eDP-1: SUCCESS (2.675s)
[796.735340] Subtest fade-with-suspend: SUCCESS (3.923s)
[797.588066] [123/131] (227s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[797.648409] Starting subtest: single-wait-for-submit-available-submitted
[797.651010] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[797.780624] [124/131] (227s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[797.878943] Starting subtest: 4-tiled-32bpp-rotate-90
[797.898350] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[798.048547] [125/131] (227s left) gem_exec_suspend (basic-s3-devices)
[798.115504] Starting subtest: basic-S3-devices
[798.117737] Starting dynamic subtest: smem
[809.255829] Dynamic subtest smem: SUCCESS (11.152s)
[809.259033] Subtest basic-S3-devices: SUCCESS (11.156s)
[809.467365] [126/131] (216s left) kms_cursor_crc (cursor-onscreen-64x64)
[809.651951] Starting subtest: cursor-onscreen-64x64
[809.654480] Starting dynamic subtest: pipe-A-eDP-1
[811.737748] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.085s)
[811.767012] Starting dynamic subtest: pipe-D-eDP-1
[814.489476] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.727s)
[814.491936] Subtest cursor-onscreen-64x64: SUCCESS (4.837s)
[815.588060] [127/131] (210s left) gem_ctx_persistence (legacy-engines-persistence)
[815.657761] Starting subtest: legacy-engines-persistence
[815.660103] Starting dynamic subtest: render
[816.513533] Dynamic subtest render: SUCCESS (0.857s)
[816.527889] Starting dynamic subtest: bsd1
[817.303199] Dynamic subtest bsd1: SUCCESS (0.786s)
[817.313724] Starting dynamic subtest: bsd2
[818.164343] Dynamic subtest bsd2: SUCCESS (0.858s)
[818.178686] Starting dynamic subtest: blt
[819.110526] Dynamic subtest blt: SUCCESS (0.942s)
[819.122993] Starting dynamic subtest: vebox
[819.898370] Dynamic subtest vebox: SUCCESS (0.785s)
[819.901006] Subtest legacy-engines-persistence: SUCCESS (4.243s)
[820.005261] [128/131] (205s left) gem_render_copy (y-tiled)
[820.066913] Starting subtest: y-tiled
[820.071924] Subtest y-tiled: SKIP (0.000s)
[820.285671] [129/131] (205s left) kms_getfb (getfb-repeated-different-handles)
[820.385033] Starting subtest: getfb-repeated-different-handles
[820.387895] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[820.520656] [130/131] (205s left) gem_pxp (create-valid-protected-context)
[820.640177] Starting subtest: create-valid-protected-context
[820.643164] Subtest create-valid-protected-context: SUCCESS (0.001s)
[820.787103] [131/131] (205s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[825.828044] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[825.833067] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[826.660540] 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.