[65.470663] Initializing watchdogs
[65.470703]   /dev/watchdog0
[65.484403] [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]
[65.488898] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[65.491157] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.494406] [001/132] (960s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[65.610340] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[65.614772] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[65.685668] [002/132] (960s left) gem_exec_store (cachelines)
[65.756718] Starting subtest: cachelines
[65.759082] Starting dynamic subtest: rcs0
[65.825964] Dynamic subtest rcs0: SUCCESS (0.070s)
[65.835075] Starting dynamic subtest: bcs0
[65.884271] Dynamic subtest bcs0: SUCCESS (0.058s)
[65.893480] Starting dynamic subtest: vcs0
[65.951532] Dynamic subtest vcs0: SUCCESS (0.066s)
[65.961637] Starting dynamic subtest: vcs1
[66.008504] Dynamic subtest vcs1: SUCCESS (0.056s)
[66.018132] Starting dynamic subtest: vecs0
[66.059338] Dynamic subtest vecs0: SUCCESS (0.049s)
[66.068784] Starting dynamic subtest: ccs0
[66.109509] Dynamic subtest ccs0: SUCCESS (0.051s)
[66.114470] Subtest cachelines: SUCCESS (0.354s)
[66.295090] [003/132] (959s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[66.682692] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[67.515710] [004/132] (958s left) api_intel_bb (crc32)
[67.635185] Starting subtest: crc32
[67.637633] Starting dynamic subtest: rcs0-smem0
[67.922335] Dynamic subtest rcs0-smem0: SUCCESS (0.286s)
[67.935254] Starting dynamic subtest: bcs0-smem0
[68.223886] Dynamic subtest bcs0-smem0: SUCCESS (0.300s)
[68.234331] Starting dynamic subtest: vcs0-smem0
[68.538666] Dynamic subtest vcs0-smem0: SUCCESS (0.315s)
[68.551808] Starting dynamic subtest: vcs1-smem0
[68.887048] Dynamic subtest vcs1-smem0: SUCCESS (0.347s)
[68.895558] Starting dynamic subtest: vecs0-smem0
[69.210391] Dynamic subtest vecs0-smem0: SUCCESS (0.322s)
[69.221046] Starting dynamic subtest: ccs0-smem0
[69.529595] Dynamic subtest ccs0-smem0: SUCCESS (0.318s)
[69.532561] Subtest crc32: SUCCESS (1.894s)
[69.652174] [005/132] (956s left) kms_fence_pin_leak
[69.823882] [006/132] (956s left) perf_pmu (init-busy)
[69.874714] Starting subtest: init-busy
[69.877147] Starting dynamic subtest: rcs0
[69.879691] Dynamic subtest rcs0: SUCCESS (0.002s)
[69.889721] Starting dynamic subtest: bcs0
[69.891950] Dynamic subtest bcs0: SUCCESS (0.000s)
[69.903626] Starting dynamic subtest: vcs0
[69.905706] Dynamic subtest vcs0: SUCCESS (0.000s)
[69.911919] Starting dynamic subtest: vcs1
[69.914294] Dynamic subtest vcs1: SUCCESS (0.001s)
[69.920917] Starting dynamic subtest: vecs0
[69.922858] Dynamic subtest vecs0: SUCCESS (0.001s)
[69.929578] Starting dynamic subtest: ccs0
[69.931806] Dynamic subtest ccs0: SUCCESS (0.000s)
[69.934078] Subtest init-busy: SUCCESS (0.005s)
[69.969676] [007/132] (956s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[70.016761] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[70.018708] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[70.098691] [008/132] (956s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[70.196054] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[71.199312] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.005s)
[71.292381] [009/132] (955s left) gem_ctx_param (invalid-param-get)
[71.342638] Starting subtest: invalid-param-get
[71.345082] Subtest invalid-param-get: SUCCESS (0.001s)
[71.458506] [010/132] (954s left) kms_flip (plain-flip-ts-check)
[71.563576] Starting subtest: plain-flip-ts-check
[71.565504] Starting dynamic subtest: A-eDP1
[80.659805] Dynamic subtest A-eDP1: SUCCESS (9.095s)
[80.667982] Starting dynamic subtest: B-eDP1
[89.497540] Dynamic subtest B-eDP1: SUCCESS (8.836s)
[89.505945] Starting dynamic subtest: C-eDP1
[98.317108] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[98.326192] Starting dynamic subtest: D-eDP1
[107.152062] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[107.157033] Subtest plain-flip-ts-check: SUCCESS (35.591s)
[108.336184] [011/132] (918s left) gem_exec_fence (expired-history)
[108.793657] Starting subtest: expired-history
[115.619692] Subtest expired-history: SUCCESS (6.826s)
[116.226412] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[116.229616] [012/132] (910s left) gem_exec_schedule (semaphore-power)
[116.411392] Subtest semaphore-power: SKIP (0.000s)
[116.589709] [013/132] (909s left) kms_cursor_edge_walk (128x128-right-edge)
[116.686714] Starting subtest: 128x128-right-edge
[116.688999] Starting dynamic subtest: pipe-A-eDP-1
[120.103457] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.416s)
[120.112440] Starting dynamic subtest: pipe-D-eDP-1
[123.237408] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[123.239770] Subtest 128x128-right-edge: SUCCESS (6.552s)
[124.051698] [014/132] (902s left) kms_mmap_write_crc (main)
[124.151431] Starting subtest: main
[124.153680] Starting dynamic subtest: pipe-A-eDP-1
[127.599530] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[127.601821] Subtest main: SUCCESS (3.449s)
[128.477919] [015/132] (898s left) gem_ctx_persistence (engines-hostile-preempt)
[128.533960] Starting subtest: engines-hostile-preempt
[128.536224] Starting dynamic subtest: rcs0
[128.579408] Dynamic subtest rcs0: SUCCESS (0.045s)
[128.586771] Starting dynamic subtest: bcs0
[128.679520] Dynamic subtest bcs0: SUCCESS (0.100s)
[128.689212] Starting dynamic subtest: vcs0
[129.929805] Dynamic subtest vcs0: SUCCESS (1.247s)
[129.943767] Starting dynamic subtest: vcs1
[131.898821] Dynamic subtest vcs1: SUCCESS (1.968s)
[131.908252] Starting dynamic subtest: vecs0
[133.818896] Dynamic subtest vecs0: SUCCESS (1.919s)
[133.828797] Starting dynamic subtest: ccs0
[133.875324] Dynamic subtest ccs0: SUCCESS (0.057s)
[133.878194] Subtest engines-hostile-preempt: SUCCESS (5.342s)
[134.005930] [016/132] (892s left) kms_color (ctm-blue-to-red)
[134.102926] Starting subtest: ctm-blue-to-red
[134.105174] Starting dynamic subtest: pipe-A-eDP-1
[134.788110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[134.796317] Starting dynamic subtest: pipe-B-eDP-1
[136.182529] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[136.191263] Starting dynamic subtest: pipe-C-eDP-1
[137.572972] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[137.582095] Starting dynamic subtest: pipe-D-eDP-1
[138.861905] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.285s)
[138.864311] Subtest ctm-blue-to-red: SUCCESS (4.758s)
[139.720578] [017/132] (886s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[139.811360] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[139.813391] Starting dynamic subtest: pipe-A-eDP-1
[140.218483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[140.226265] Starting dynamic subtest: pipe-B-eDP-1
[140.245804] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[140.254699] Starting dynamic subtest: pipe-C-eDP-1
[140.272745] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[140.279105] Starting dynamic subtest: pipe-D-eDP-1
[140.297245] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[140.299060] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.425s)
[142.487931] [018/132] (884s left) kms_fbcon_fbt (fbc-suspend)
[142.547967] Starting subtest: fbc-suspend
[191.654978] Subtest fbc-suspend: SUCCESS (20.107s)
[192.995882] [019/132] (833s left) kms_pm_dc (dc5-retention-flops)
[194.092629] Starting subtest: dc5-retention-flops
[194.097098] Subtest dc5-retention-flops: SKIP (0.000s)
[194.163005] [020/132] (832s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[194.251894] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[194.256133] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[194.348102] [021/132] (832s left) syncobj_eventfd (invalid-bad-flags)
[194.396240] Starting subtest: invalid-bad-flags
[194.398738] Subtest invalid-bad-flags: SUCCESS (0.000s)
[194.486420] [022/132] (832s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[194.583605] Starting subtest: multiplane-rotation-cropping-bottom
[212.035010] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.449s)
[212.150809] [023/132] (814s left) kms_async_flips (crc)
[212.261102] Starting subtest: crc
[212.656725] Starting dynamic subtest: pipe-A-eDP-1
[215.551556] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.893s)
[215.924333] Starting dynamic subtest: pipe-B-eDP-1
[218.866411] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.947s)
[219.242140] Starting dynamic subtest: pipe-C-eDP-1
[222.158484] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.926s)
[222.531640] Starting dynamic subtest: pipe-D-eDP-1
[225.400054] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.876s)
[225.402284] Subtest crc: SUCCESS (13.138s)
[226.583073] [024/132] (800s left) kms_content_protection (lic-type-0-hdcp14)
[226.729314] Starting subtest: lic-type-0-hdcp14
[226.733885] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[226.858915] [025/132] (800s left) i915_hangman (error-state-basic)
[226.935327] Starting subtest: error-state-basic
[227.091800] Subtest error-state-basic: SUCCESS (0.157s)
[227.163727] [026/132] (799s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[227.253748] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[227.257843] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[227.353882] [027/132] (799s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[227.450014] Starting subtest: x-tiled-64bpp-rotate-90
[227.473125] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[227.575670] [028/132] (799s left) gem_mmap (pf-nonblock)
[227.630019] Subtest pf-nonblock: SKIP (0.000s)
[227.687039] [029/132] (799s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[227.782845] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[227.784424] Starting dynamic subtest: pipe-A-eDP-1
[227.841928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[227.850629] Starting dynamic subtest: pipe-B-eDP-1
[227.902618] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[227.910402] Starting dynamic subtest: pipe-C-eDP-1
[227.961073] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.057s)
[227.968932] Starting dynamic subtest: pipe-D-eDP-1
[228.021649] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[228.023369] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.241s)
[230.245356] [030/132] (796s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[230.363123] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[230.367579] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[230.458838] [031/132] (796s left) gem_ctx_persistence (smoketest)
[230.532357] Starting subtest: smoketest
[270.837159] Subtest smoketest: SUCCESS (40.299s)
[270.927528] [032/132] (756s left) gem_exec_parallel (contexts)
[270.989187] Starting subtest: contexts
[270.991516] Starting dynamic subtest: rcs0
[274.876424] Dynamic subtest rcs0: SUCCESS (3.884s)
[274.886601] Starting dynamic subtest: bcs0
[278.811998] Dynamic subtest bcs0: SUCCESS (3.932s)
[278.821345] Starting dynamic subtest: vcs0
[283.247102] Dynamic subtest vcs0: SUCCESS (4.433s)
[283.256023] Starting dynamic subtest: vcs1
[287.363848] Dynamic subtest vcs1: SUCCESS (4.114s)
[287.373320] Starting dynamic subtest: vecs0
[291.358228] Dynamic subtest vecs0: SUCCESS (3.993s)
[291.367291] Starting dynamic subtest: ccs0
[295.574487] Dynamic subtest ccs0: SUCCESS (4.215s)
[295.576937] Subtest contexts: SUCCESS (24.586s)
[295.762560] [033/132] (731s left) gem_mmap_offset (partial-remap)
[295.811578] Starting subtest: partial-remap
[295.813716] Starting dynamic subtest: smem0
[295.822869] Dynamic subtest smem0: SUCCESS (0.007s)
[295.825085] Subtest partial-remap: SUCCESS (0.008s)
[295.939452] [034/132] (731s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[296.052069] Starting subtest: verify-pxp-stale-buf-optout-execution
[297.115374] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.063s)
[297.235587] [035/132] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[297.328430] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[297.332727] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[297.421308] [036/132] (729s left) kms_sequence (get-forked)
[297.512747] Starting subtest: get-forked
[297.514918] Starting dynamic subtest: pipe-A-eDP-1
[299.403584] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[299.412795] Starting dynamic subtest: pipe-B-eDP-1
[302.010945] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.607s)
[302.020011] Starting dynamic subtest: pipe-C-eDP-1
[304.493216] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.481s)
[304.502604] Starting dynamic subtest: pipe-D-eDP-1
[307.022550] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.527s)
[307.024857] Subtest get-forked: SUCCESS (9.511s)
[307.876771] [037/132] (719s left) sysfs_preempt_timeout (idempotent)
[307.937875] Starting subtest: idempotent
[307.940328] Starting dynamic subtest: vecs0
[307.942695] Dynamic subtest vecs0: SUCCESS (0.000s)
[307.952569] Starting dynamic subtest: ccs0
[307.954851] Dynamic subtest ccs0: SUCCESS (0.000s)
[307.963243] Starting dynamic subtest: vcs0
[307.965546] Dynamic subtest vcs0: SUCCESS (0.000s)
[307.973765] Starting dynamic subtest: bcs0
[307.975998] Dynamic subtest bcs0: SUCCESS (0.000s)
[307.984111] Starting dynamic subtest: rcs0
[307.986372] Dynamic subtest rcs0: SUCCESS (0.000s)
[307.994793] Starting dynamic subtest: vcs1
[307.996734] Dynamic subtest vcs1: SUCCESS (0.000s)
[307.998658] Subtest idempotent: SUCCESS (0.006s)
[308.047198] [038/132] (719s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[308.143669] Starting subtest: fb-8bpc-vs-panel-8bpc
[308.145856] Starting dynamic subtest: pipe-A-eDP-1
[309.540442] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.398s)
[309.542671] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.400s)
[310.420839] [039/132] (717s left) kms_big_fb (4-tiled-addfb-size-overflow)
[310.536268] Starting subtest: 4-tiled-addfb-size-overflow
[310.538575] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[310.662930] [040/132] (716s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[310.794787] Starting subtest: basic-busy-flip-before-cursor-legacy
[310.799345] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[310.947147] [041/132] (716s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[311.047887] Starting subtest: modeset-transition-nonblocking-fencing
[311.050145] Starting dynamic subtest: 1x-outputs
[322.046539] Dynamic subtest 1x-outputs: SUCCESS (10.998s)
[322.049461] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.000s)
[322.929472] [042/132] (704s left) kms_plane_scaling (planes-downscale-factor-0-75)
[323.018604] Starting subtest: planes-downscale-factor-0-75
[323.020886] Starting dynamic subtest: pipe-A
[323.039915] Dynamic subtest pipe-A: SKIP (0.018s)
[323.050091] Starting dynamic subtest: pipe-B
[323.070369] Dynamic subtest pipe-B: SKIP (0.030s)
[323.083914] Starting dynamic subtest: pipe-C
[323.102341] Dynamic subtest pipe-C: SKIP (0.031s)
[323.111991] Starting dynamic subtest: pipe-D
[323.132672] Dynamic subtest pipe-D: SKIP (0.030s)
[323.136932] Subtest planes-downscale-factor-0-75: SKIP (0.111s)
[323.230064] [043/132] (704s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[323.340575] Starting subtest: cursorA-vs-flipA-atomic-transitions
[334.510910] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.169s)
[335.328098] [044/132] (692s left) syncobj_wait (wait-for-submit-delayed-submit)
[335.392011] Starting subtest: wait-for-submit-delayed-submit
[335.492994] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[335.574365] [045/132] (692s left) i915_pm_rps (thresholds-idle-park)
[335.627619] Starting subtest: thresholds-idle-park
[335.632082] Subtest thresholds-idle-park: SKIP (0.001s)
[335.727699] [046/132] (692s left) gem_gpgpu_fill (offset-16x16)
[335.777911] Starting subtest: offset-16x16
[335.784574] Subtest offset-16x16: SUCCESS (0.009s)
[335.914168] [047/132] (691s left) gem_softpin (evict-prime)
[335.981200] Starting subtest: evict-prime
[335.983559] Starting dynamic subtest: rcs0
[337.138244] Dynamic subtest rcs0: SUCCESS (1.156s)
[337.149146] Starting dynamic subtest: bcs0
[338.263209] Dynamic subtest bcs0: SUCCESS (1.123s)
[338.273916] Starting dynamic subtest: vcs0
[339.866935] Dynamic subtest vcs0: SUCCESS (1.600s)
[339.878826] Starting dynamic subtest: vcs1
[341.848859] Dynamic subtest vcs1: SUCCESS (1.980s)
[341.861222] Starting dynamic subtest: vecs0
[343.837039] Dynamic subtest vecs0: SUCCESS (1.986s)
[343.849280] Starting dynamic subtest: ccs0
[344.961393] Dynamic subtest ccs0: SUCCESS (1.124s)
[344.972325] Starting dynamic subtest: all
[346.841303] Dynamic subtest all: SUCCESS (1.876s)
[346.844012] Subtest evict-prime: SUCCESS (10.860s)
[346.934278] [048/132] (680s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[347.046117] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[347.051213] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[347.150908] [049/132] (680s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[347.273022] Starting subtest: cursorA-vs-flipB-toggle
[347.277604] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[347.416827] [050/132] (680s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[347.515107] Starting subtest: psr-rgb101010-draw-mmap-cpu
[354.631611] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.120s)
[354.730899] [051/132] (673s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[354.835440] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[354.839666] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[354.943981] [052/132] (673s left) kms_flip (2x-modeset-vs-vblank-race)
[355.048547] Starting subtest: 2x-modeset-vs-vblank-race
[355.061086] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[355.142329] [053/132] (672s left) kms_flip (flip-vs-dpms-on-nop)
[355.231149] Starting subtest: flip-vs-dpms-on-nop
[355.233486] Starting dynamic subtest: A-eDP1
[357.062049] Dynamic subtest A-eDP1: SUCCESS (1.833s)
[357.073021] Starting dynamic subtest: B-eDP1
[358.901487] Dynamic subtest B-eDP1: SUCCESS (1.838s)
[358.915192] Starting dynamic subtest: C-eDP1
[360.721766] Dynamic subtest C-eDP1: SUCCESS (1.818s)
[360.730329] Starting dynamic subtest: D-eDP1
[362.556309] Dynamic subtest D-eDP1: SUCCESS (1.832s)
[362.561991] Subtest flip-vs-dpms-on-nop: SUCCESS (7.332s)
[363.732033] [054/132] (664s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[363.845122] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[370.559992] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.717s)
[370.675931] [055/132] (657s left) kms_feature_discovery (dp-mst)
[370.790445] Starting subtest: dp-mst
[370.794921] Subtest dp-mst: SKIP (0.000s)
[370.862921] [056/132] (657s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[370.974185] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[378.441782] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.470s)
[378.584967] [057/132] (649s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[378.686636] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[378.688960] Starting dynamic subtest: pipe-A
[379.823135] Dynamic subtest pipe-A: SUCCESS (1.139s)
[379.831569] Starting dynamic subtest: pipe-B
[382.058069] Dynamic subtest pipe-B: SUCCESS (2.233s)
[382.067297] Starting dynamic subtest: pipe-C
[383.495264] Dynamic subtest pipe-C: SUCCESS (1.435s)
[383.505684] Starting dynamic subtest: pipe-D
[384.731173] Dynamic subtest pipe-D: SUCCESS (1.236s)
[384.733605] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.047s)
[385.921444] [058/132] (642s left) kms_chamelium_edid (dp-mode-timings)
[386.312589] Subtest dp-mode-timings: SKIP (0.000s)
[387.132387] [059/132] (641s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[387.223235] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[387.227322] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[387.321248] [060/132] (641s left) kms_big_fb (linear-64bpp-rotate-270)
[387.415419] Starting subtest: linear-64bpp-rotate-270
[387.436090] Subtest linear-64bpp-rotate-270: SKIP (0.020s)
[387.541087] [061/132] (640s left) gem_exec_reloc (basic-gtt-read)
[387.605271] Subtest basic-gtt-read: SKIP (0.000s)
[387.690303] [062/132] (640s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[387.743322] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[387.793149] [063/132] (640s left) prime_self_import (basic-llseek-size)
[387.828169] Starting subtest: basic-llseek-size
[387.839553] Subtest basic-llseek-size: SUCCESS (0.013s)
[387.934908] [064/132] (640s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[388.020835] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[388.024793] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[388.090803] [065/132] (640s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[388.182786] Starting subtest: y-tiled-64bpp-rotate-90
[388.186569] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[388.268673] [066/132] (640s left) kms_pm_rpm (system-suspend-idle)
[390.098353] Starting subtest: system-suspend-idle
[409.927185] Subtest system-suspend-idle: SUCCESS (4.595s)
[410.318254] [067/132] (618s left) drm_buddy (drm_buddy)
[410.359374] Starting subtest: drm_buddy
[410.364257] Subtest drm_buddy: SKIP (0.001s)
[410.419956] [068/132] (618s left) gem_mmap_gtt (fault-concurrent)
[410.468644] Subtest fault-concurrent: SKIP (0.000s)
[410.530233] [069/132] (618s left) gem_exec_async (forked-writes)
[410.582605] Starting subtest: forked-writes
[410.585367] Starting dynamic subtest: rcs0
[410.610482] Dynamic subtest rcs0: SUCCESS (0.028s)
[410.621278] Starting dynamic subtest: bcs0
[410.636650] Dynamic subtest bcs0: SUCCESS (0.024s)
[410.646427] Starting dynamic subtest: vcs0
[410.662425] Dynamic subtest vcs0: SUCCESS (0.025s)
[410.672298] Starting dynamic subtest: vcs1
[410.687235] Dynamic subtest vcs1: SUCCESS (0.023s)
[410.696530] Starting dynamic subtest: vecs0
[410.709229] Dynamic subtest vecs0: SUCCESS (0.021s)
[410.718311] Starting dynamic subtest: ccs0
[410.729939] Dynamic subtest ccs0: SUCCESS (0.020s)
[410.732661] Subtest forked-writes: SUCCESS (0.148s)
[410.946913] [070/132] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[411.041580] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[411.046948] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[411.138868] [071/132] (617s left) gem_reg_read (timestamp-moving)
[411.196428] Starting subtest: timestamp-moving
[412.196268] Subtest timestamp-moving: SUCCESS (1.000s)
[412.273983] [072/132] (616s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[412.378345] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[412.382949] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[412.450225] [073/132] (616s left) gem_create (create-ext-placement-each)
[412.624458] Starting subtest: create-ext-placement-each
[412.627587] Subtest create-ext-placement-each: SUCCESS (0.000s)
[412.714568] [074/132] (616s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[412.832544] Starting subtest: flip-vs-cursor-crc-atomic
[413.512131] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.681s)
[414.345791] [075/132] (614s left) vgem_basic (sysfs)
[414.410093] Starting subtest: sysfs
[414.412534] Subtest sysfs: SUCCESS (0.000s)
[414.470198] [076/132] (614s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[414.590729] Starting subtest: flip-vs-cursor-varying-size
[423.296382] Subtest flip-vs-cursor-varying-size: SUCCESS (8.703s)
[424.178635] [077/132] (604s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[424.281498] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[431.319692] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.040s)
[431.431746] [078/132] (597s left) gem_exec_balancer (fairslice)
[431.504736] Starting subtest: fairslice
[434.412544] Subtest fairslice: SUCCESS (2.905s)
[435.168844] [079/132] (594s left) gem_softpin (evict-active)
[435.229561] Starting subtest: evict-active
[435.238486] Subtest evict-active: SUCCESS (0.009s)
[435.363252] [080/132] (593s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[435.453146] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[435.455539] Starting dynamic subtest: pipe-A-eDP-1
[436.648199] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.196s)
[436.657369] Starting dynamic subtest: pipe-B-eDP-1
[438.912023] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.262s)
[438.921346] Starting dynamic subtest: pipe-C-eDP-1
[441.173276] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.259s)
[441.183154] Starting dynamic subtest: pipe-D-eDP-1
[443.507043] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.323s)
[443.509604] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.046s)
[444.681010] [081/132] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[444.777271] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[467.414430] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.637s)
[467.540398] [082/132] (561s left) prime_mmap (test_aperture_limit)
[467.596983] Starting subtest: test_aperture_limit
[467.599026] Starting dynamic subtest: test_aperture_limit-smem
[467.606024] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[467.610338] Subtest test_aperture_limit: SKIP (0.008s)
[467.680221] [083/132] (561s left) prime_mmap_coherency (ioctl-errors)
[467.731605] Starting subtest: ioctl-errors
[489.097319] Subtest ioctl-errors: SUCCESS (21.361s)
[489.258297] [084/132] (540s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[489.398422] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[493.277421] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.881s)
[494.471050] [085/132] (535s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[494.560544] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[494.565498] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[494.632269] [086/132] (534s left) syncobj_timeline (signal-point-0)
[494.693461] Starting subtest: signal-point-0
[494.696319] Subtest signal-point-0: SUCCESS (0.000s)
[494.770286] [087/132] (534s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[494.866311] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[494.868719] Starting dynamic subtest: pipe-A-eDP-1
[494.993638] Dynamic subtest pipe-A-eDP-1: SKIP (0.133s)
[495.003577] Starting dynamic subtest: pipe-B-eDP-1
[496.137361] Dynamic subtest pipe-B-eDP-1: SKIP (1.141s)
[496.142649] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.277s)
[497.323165] [088/132] (532s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[497.426734] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[501.541409] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.117s)
[502.708895] [089/132] (526s left) kms_invalid_mode (overflow-vrefresh)
[502.801728] Starting subtest: overflow-vrefresh
[502.804475] Starting dynamic subtest: pipe-A-eDP-1
[503.097766] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[503.113843] Starting dynamic subtest: pipe-B-eDP-1
[503.116603] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[503.126352] Starting dynamic subtest: pipe-C-eDP-1
[503.129055] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[503.138656] Starting dynamic subtest: pipe-D-eDP-1
[503.141394] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[503.144260] Subtest overflow-vrefresh: SUCCESS (0.303s)
[503.953557] [090/132] (525s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[504.047882] Starting subtest: primary-y-tiled-reflect-x-90
[504.053108] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[504.134853] [091/132] (525s left) i915_drm_fdinfo (memory-info-purgeable)
[504.181983] Starting subtest: memory-info-purgeable
[504.184628] Starting dynamic subtest: smem0
[506.837946] Dynamic subtest smem0: SUCCESS (2.658s)
[506.840369] Subtest memory-info-purgeable: SUCCESS (2.659s)
[506.921509] [092/132] (522s left) kms_psr (fbc-pr-cursor-blt)
[507.021951] Starting subtest: fbc-pr-cursor-blt
[507.025863] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[507.094586] [093/132] (522s left) syncobj_timeline (reset-during-wait-for-submit)
[507.143481] Starting subtest: reset-during-wait-for-submit
[507.243630] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[507.333109] [094/132] (522s left) kms_psr (psr2-primary-render)
[507.428133] Starting subtest: psr2-primary-render
[507.430268] Starting dynamic subtest: eDP-1
[509.143694] Dynamic subtest eDP-1: SUCCESS (1.715s)
[509.146712] Subtest psr2-primary-render: SUCCESS (1.716s)
[509.999900] [095/132] (519s left) kms_psr (fbc-psr2-no-drrs)
[510.099740] Starting subtest: fbc-psr2-no-drrs
[510.102561] Starting dynamic subtest: eDP-1
[510.107917] Dynamic subtest eDP-1: SKIP (0.000s)
[510.112949] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[510.182494] [096/132] (519s left) gem_exec_reloc (basic-gtt-wc)
[510.244280] Subtest basic-gtt-wc: SKIP (0.000s)
[510.321874] [097/132] (519s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[510.422722] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[510.425351] Starting dynamic subtest: pipe-A-eDP-1
[510.435727] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[510.446581] Starting dynamic subtest: pipe-B-eDP-1
[510.457203] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[510.466863] Starting dynamic subtest: pipe-C-eDP-1
[510.477208] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[510.486852] Starting dynamic subtest: pipe-D-eDP-1
[510.497414] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[510.502655] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[512.703979] [098/132] (517s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[512.802493] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[512.807278] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[512.893644] [099/132] (517s left) kms_flip (2x-flip-vs-fences)
[512.986863] Starting subtest: 2x-flip-vs-fences
[512.991721] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[513.091324] [100/132] (517s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[513.147996] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[513.150539] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[513.238712] [101/132] (516s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[513.288880] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[513.294358] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[513.485626] [102/132] (516s left) kms_cursor_crc (cursor-alpha-opaque)
[513.580574] Starting subtest: cursor-alpha-opaque
[513.583103] Starting dynamic subtest: pipe-A-eDP-1
[514.234753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s)
[514.244876] Starting dynamic subtest: pipe-D-eDP-1
[515.479722] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[515.482219] Subtest cursor-alpha-opaque: SUCCESS (1.901s)
[516.292044] [103/132] (513s left) gen9_exec_parse (bb-oversize)
[516.348513] Subtest bb-oversize: SKIP (0.000s)
[516.407920] [104/132] (513s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[516.503497] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[516.508603] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[516.618143] [105/132] (513s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[516.714363] Starting subtest: fbc-rgb101010-draw-render
[521.300697] Subtest fbc-rgb101010-draw-render: SUCCESS (4.591s)
[522.508608] [106/132] (507s left) kms_vrr (seamless-rr-switch-drrs)
[522.595532] Starting subtest: seamless-rr-switch-drrs
[522.603345] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[522.683341] [107/132] (507s left) gem_ccs (block-copy-compressed)
[522.751151] Starting subtest: block-copy-compressed
[522.756534] Subtest block-copy-compressed: SKIP (0.000s)
[522.857909] [108/132] (507s left) kms_psr (fbc-psr-primary-blt)
[522.946556] Starting subtest: fbc-psr-primary-blt
[522.948961] Starting dynamic subtest: eDP-1
[522.953767] Dynamic subtest eDP-1: SKIP (0.000s)
[522.958651] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[523.019721] [109/132] (507s left) gen3_render_tiledy_blits
[523.140756] [110/132] (507s left) kms_lease (lease-revoke)
[523.227654] Starting subtest: lease-revoke
[523.230451] Starting dynamic subtest: pipe-A-eDP-1
[523.256564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[523.268440] Starting dynamic subtest: pipe-B-eDP-1
[523.289243] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[523.298745] Starting dynamic subtest: pipe-C-eDP-1
[523.317455] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[523.327098] Starting dynamic subtest: pipe-D-eDP-1
[523.340267] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.025s)
[523.342725] Subtest lease-revoke: SUCCESS (0.116s)
[523.467063] [111/132] (507s left) perf (non-system-wide-paranoid)
[523.606531] Starting subtest: non-system-wide-paranoid
[523.636113] Subtest non-system-wide-paranoid: SUCCESS (0.030s)
[523.686070] [112/132] (506s left) gem_exec_fence (syncobj-timeline-unused-fence)
[524.264317] Starting subtest: syncobj-timeline-unused-fence
[524.272532] Subtest syncobj-timeline-unused-fence: SUCCESS (0.009s)
[525.236370] [113/132] (505s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[525.323710] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[525.326011] Starting dynamic subtest: pipe-A-eDP-1
[525.349743] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[525.360123] Starting dynamic subtest: pipe-B-eDP-1
[525.384660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[525.393737] Starting dynamic subtest: pipe-C-eDP-1
[525.418559] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[525.427631] Starting dynamic subtest: pipe-D-eDP-1
[525.453113] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[525.458117] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[527.488509] [114/132] (503s left) kms_psr (pr-cursor-mmap-gtt)
[527.581488] Starting subtest: pr-cursor-mmap-gtt
[527.586360] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[527.653113] [115/132] (503s left) perf (stress-open-close)
[527.742595] Starting subtest: stress-open-close
[527.745252] Starting dynamic subtest: 0-rcs0
[529.911439] Dynamic subtest 0-rcs0: SUCCESS (2.169s)
[529.921401] Starting dynamic subtest: 1-vcs1
[532.071473] Dynamic subtest 1-vcs1: SUCCESS (2.159s)
[532.073584] Subtest stress-open-close: SUCCESS (4.330s)
[532.112034] [116/132] (498s left) kms_cursor_crc (cursor-random-64x21)
[532.310252] Starting subtest: cursor-random-64x21
[532.353059] Subtest cursor-random-64x21: SKIP (0.039s)
[532.585629] [117/132] (498s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[532.673325] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[532.675387] Starting dynamic subtest: pipe-A-eDP-1
[532.697375] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[532.707632] Starting dynamic subtest: pipe-B-eDP-1
[532.730377] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[532.740496] Starting dynamic subtest: pipe-C-eDP-1
[532.762657] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[532.771714] Starting dynamic subtest: pipe-D-eDP-1
[532.795965] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[532.800235] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[534.940527] [118/132] (495s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[535.001523] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[535.004137] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[535.091549] [119/132] (495s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[535.189376] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[541.762741] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.574s)
[541.878759] [120/132] (489s left) gem_mmap_gtt (medium-copy)
[541.941468] Subtest medium-copy: SKIP (0.000s)
[542.004098] [121/132] (489s left) gem_exec_params (invalid-ring2)
[542.060418] Starting subtest: invalid-ring2
[542.063234] Subtest invalid-ring2: SUCCESS (0.000s)
[542.158833] [122/132] (488s left) i915_pm_rpm (gem-idle)
[544.289127] Starting subtest: gem-idle
[550.478740] Subtest gem-idle: SUCCESS (6.192s)
[550.818292] [123/132] (480s left) syncobj_timeline (invalid-transfer-bad-pad)
[552.061700] Starting subtest: invalid-transfer-bad-pad
[552.064707] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[552.169530] [124/132] (478s left) syncobj_wait (invalid-reset-zero-handles)
[552.234382] Starting subtest: invalid-reset-zero-handles
[552.236753] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[552.334777] [125/132] (478s left) perf (buffer-fill)
[552.429339] Starting subtest: buffer-fill
[552.431919] Starting dynamic subtest: 0-rcs0
[554.702214] Dynamic subtest 0-rcs0: SUCCESS (2.271s)
[554.712633] Starting dynamic subtest: 1-vcs1
[559.093427] Dynamic subtest 1-vcs1: SUCCESS (4.389s)
[559.096037] Subtest buffer-fill: SUCCESS (6.663s)
[559.135502] [126/132] (472s left) gem_exec_schedule (preempt-queue-chain)
[559.212545] Subtest preempt-queue-chain: SKIP (0.000s)
[559.497010] [127/132] (471s left) gem_userptr_blits (map-fixed-invalidate)
[559.573490] Starting subtest: map-fixed-invalidate
[559.578363] Subtest map-fixed-invalidate: SKIP (0.000s)
[559.706762] [128/132] (471s left) gen7_exec_parse (basic-allowed)
[559.770997] Subtest basic-allowed: SKIP (0.000s)
[559.848951] [129/132] (471s left) api_intel_bb (lot-of-buffers)
[559.901436] Starting subtest: lot-of-buffers
[560.921559] Subtest lot-of-buffers: SUCCESS (1.021s)
[561.254341] [130/132] (470s left) gem_exec_fence (syncobj-channel)
[561.721001] Starting subtest: syncobj-channel
[562.739762] Subtest syncobj-channel: SUCCESS (1.018s)
[563.265760] [131/132] (468s left) kms_vblank (ts-continuation-modeset-rpm)
[563.361652] Starting subtest: ts-continuation-modeset-rpm
[563.364372] Starting dynamic subtest: pipe-A-eDP-1
[565.903285] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.540s)
[565.917732] Starting dynamic subtest: pipe-D-eDP-1
[568.155568] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.249s)
[568.158511] Subtest ts-continuation-modeset-rpm: SUCCESS (4.793s)
[568.955124] [132/132] (462s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[569.014579] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[569.017593] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[569.108012] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: gem_exec_store
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: api_intel_bb
results: parsing output: 4/ for test: kms_fence_pin_leak
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_cursor_edge_walk
results: parsing output: 13/ for test: kms_mmap_write_crc
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_color
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_fbcon_fbt
results: parsing output: 18/ for test: kms_pm_dc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_eventfd
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: kms_async_flips
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: i915_hangman
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_mmap
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: gem_exec_parallel
results: parsing output: 32/ for test: gem_mmap_offset
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_sequence
results: parsing output: 36/ for test: sysfs_preempt_timeout
results: parsing output: 37/ for test: kms_dither
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_atomic_transition
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: i915_pm_rps
results: parsing output: 45/ for test: gem_gpgpu_fill
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_feature_discovery
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_plane_scaling
results: parsing output: 57/ for test: kms_chamelium_edid
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: prime_self_import
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_pm_rpm
results: parsing output: 66/ for test: drm_buddy
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: gem_exec_async
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_reg_read
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: gem_create
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: prime_mmap
results: parsing output: 82/ for test: prime_mmap_coherency
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_invalid_mode
results: parsing output: 89/ for test: kms_rotation_crc
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gen9_exec_parse
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_vrr
results: parsing output: 106/ for test: gem_ccs
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gen3_render_tiledy_blits
results: parsing output: 109/ for test: kms_lease
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: gen7_exec_parse
results: parsing output: 128/ for test: api_intel_bb
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: kms_vblank
results: parsing output: 131/ for test: syncobj_timeline
Done.