[57.510994] Initializing watchdogs
[57.511157]   /dev/watchdog0
[57.524746] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.528733] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.531124] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.534384] [001/131] (960s left) kms_cursor_crc (cursor-random-128x128)
[57.768791] Starting subtest: cursor-random-128x128
[57.782440] Starting dynamic subtest: pipe-A-eDP-1
[61.489579] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.698s)
[61.521076] Starting dynamic subtest: pipe-D-eDP-1
[65.843620] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.321s)
[65.845660] Subtest cursor-random-128x128: SUCCESS (8.058s)
[66.626780] [002/131] (951s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[67.191400] Starting subtest: syncobj-timeline-multiple-ext-nodes
[67.196497] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[69.012315] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[69.014893] [003/131] (949s left) gem_ctx_isolation (preservation)
[69.085706] Starting subtest: preservation
[69.088168] Starting dynamic subtest: rcs0
[69.374299] Dynamic subtest rcs0: SUCCESS (0.287s)
[69.383208] Starting dynamic subtest: bcs0
[69.695442] Dynamic subtest bcs0: SUCCESS (0.321s)
[69.704790] Starting dynamic subtest: vcs0
[70.015989] Dynamic subtest vcs0: SUCCESS (0.321s)
[70.024647] Starting dynamic subtest: vcs1
[71.301999] Dynamic subtest vcs1: SUCCESS (1.285s)
[71.310675] Starting dynamic subtest: vecs0
[73.212571] Dynamic subtest vecs0: SUCCESS (1.909s)
[73.222568] Starting dynamic subtest: ccs0
[75.207599] Dynamic subtest ccs0: SUCCESS (1.994s)
[75.210400] Subtest preservation: SUCCESS (6.117s)
[75.458061] [004/131] (942s left) kms_pm_dc (dc5-dpms)
[76.564896] Starting subtest: dc5-dpms
[78.602249] Subtest dc5-dpms: SUCCESS (2.037s)
[78.671143] [005/131] (939s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[78.740019] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[78.847482] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[78.914404] [006/131] (939s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[79.022059] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[82.091056] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (3.071s)
[82.208363] [007/131] (936s left) kms_atomic_interruptible (legacy-cursor)
[82.314884] Starting subtest: legacy-cursor
[82.317275] Starting dynamic subtest: pipe-A-eDP-1
[89.705411] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.389s)
[89.707453] Subtest legacy-cursor: SUCCESS (7.390s)
[90.539625] [008/131] (927s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[90.638171] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[90.642341] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[90.726269] [009/131] (927s left) kms_psr (pr-primary-mmap-gtt)
[90.830144] Starting subtest: pr-primary-mmap-gtt
[90.834618] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[90.898492] [010/131] (927s left) syncobj_wait (invalid-reset-bad-pad)
[90.950890] Starting subtest: invalid-reset-bad-pad
[90.952869] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[91.029724] [011/131] (927s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[91.126476] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[95.956614] Subtest psr-1p-offscren-pri-indfb-draw-render: SUCCESS (4.833s)
[96.088246] [012/131] (922s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[98.026702] Starting subtest: dpms-mode-unset-non-lpsp
[99.177886] Subtest dpms-mode-unset-non-lpsp: SKIP (1.148s)
[99.525527] [013/131] (918s left) gem_exec_flush (basic-wb-prw-default)
[99.594695] Starting subtest: basic-wb-prw-default
[105.081204] Subtest basic-wb-prw-default: SUCCESS (5.487s)
[105.261367] [014/131] (913s left) gem_ctx_bad_destroy (invalid-pad)
[105.323160] Starting subtest: invalid-pad
[105.325685] Subtest invalid-pad: SUCCESS (0.000s)
[105.391986] [015/131] (913s left) kms_psr (psr-cursor-blt)
[105.499890] Starting subtest: psr-cursor-blt
[105.502201] Starting dynamic subtest: eDP-1
[107.201116] Dynamic subtest eDP-1: SUCCESS (1.697s)
[107.203495] Subtest psr-cursor-blt: SUCCESS (1.698s)
[108.055177] [016/131] (910s left) kms_flip (flip-vs-panning)
[108.164434] Starting subtest: flip-vs-panning
[108.166718] Starting dynamic subtest: A-eDP1
[116.968338] Dynamic subtest A-eDP1: SUCCESS (8.804s)
[116.977069] Starting dynamic subtest: B-eDP1
[125.697486] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[125.707199] Starting dynamic subtest: C-eDP1
[134.510765] Dynamic subtest C-eDP1: SUCCESS (8.813s)
[134.519900] Starting dynamic subtest: D-eDP1
[143.241059] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[143.243217] Subtest flip-vs-panning: SUCCESS (35.081s)
[144.388629] [017/131] (874s left) kms_psr (fbc-psr2-sprite-render)
[144.493679] Starting subtest: fbc-psr2-sprite-render
[144.495757] Starting dynamic subtest: eDP-1
[144.499929] Dynamic subtest eDP-1: SKIP (0.000s)
[144.504169] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[144.555840] [018/131] (874s left) kms_vrr (flip-basic-fastset)
[144.652631] Starting subtest: flip-basic-fastset
[144.659165] Subtest flip-basic-fastset: SKIP (0.000s)
[144.725778] [019/131] (873s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[144.823245] Starting subtest: y-tiled-32bpp-rotate-90
[144.827598] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[144.915584] [020/131] (873s left) kms_fence_pin_leak
[145.095428] [021/131] (873s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[145.160768] Starting subtest: multi-wait-for-submit-available-signaled
[145.163205] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[145.236074] [022/131] (873s left) kms_setmode (invalid-clone-exclusive-crtc)
[145.286065] Starting subtest: invalid-clone-exclusive-crtc
[145.292671] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[145.376561] [023/131] (873s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[145.464079] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[145.467743] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[145.553426] [024/131] (873s left) kms_getfb (getfb-handle-valid)
[145.613096] Starting subtest: getfb-handle-valid
[145.615086] Subtest getfb-handle-valid: SUCCESS (0.000s)
[145.719229] [025/131] (873s left) kms_flip (plain-flip-interruptible)
[145.822818] Starting subtest: plain-flip-interruptible
[145.826765] Starting dynamic subtest: A-eDP1
[147.486991] Dynamic subtest A-eDP1: SUCCESS (1.662s)
[147.496159] Starting dynamic subtest: B-eDP1
[149.119323] Dynamic subtest B-eDP1: SUCCESS (1.631s)
[149.127883] Starting dynamic subtest: C-eDP1
[150.750249] Dynamic subtest C-eDP1: SUCCESS (1.630s)
[150.758487] Starting dynamic subtest: D-eDP1
[152.370271] Dynamic subtest D-eDP1: SUCCESS (1.618s)
[152.372756] Subtest plain-flip-interruptible: SUCCESS (6.548s)
[153.523690] [026/131] (865s left) gem_exec_schedule (pi-shared-iova)
[153.709870] Starting subtest: pi-shared-iova
[153.712172] Starting dynamic subtest: rcs0
[153.774852] Dynamic subtest rcs0: SUCCESS (0.067s)
[153.784804] Starting dynamic subtest: vcs0
[153.822432] Dynamic subtest vcs0: SUCCESS (0.047s)
[153.830073] Starting dynamic subtest: vcs1
[153.870950] Dynamic subtest vcs1: SUCCESS (0.049s)
[153.877985] Starting dynamic subtest: vecs0
[153.920620] Dynamic subtest vecs0: SUCCESS (0.049s)
[153.929389] Starting dynamic subtest: ccs0
[153.969278] Dynamic subtest ccs0: SUCCESS (0.048s)
[153.971906] Subtest pi-shared-iova: SUCCESS (0.261s)
[155.032628] [027/131] (863s left) kms_fbcon_fbt (fbc)
[155.090975] Starting subtest: fbc
[160.399840] Subtest fbc: SUCCESS (5.307s)
[160.472377] [028/131] (858s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[160.558492] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[160.560862] Starting dynamic subtest: pipe-A-default-mode
[160.848322] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[160.853107] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.285s)
[161.700253] [029/131] (857s left) gem_exec_balancer (bonded-pair)
[161.757750] Starting subtest: bonded-pair
[161.762068] Subtest bonded-pair: SKIP (0.000s)
[162.027072] [030/131] (856s left) syncobj_timeline (invalid-query-illegal-handle)
[162.078561] Starting subtest: invalid-query-illegal-handle
[162.080950] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[162.169910] [031/131] (856s left) gem_ctx_shared (q-independent)
[162.237412] Starting subtest: Q-independent
[162.239891] Starting dynamic subtest: rcs0
[162.299056] Dynamic subtest rcs0: SUCCESS (0.061s)
[162.306353] Starting dynamic subtest: vcs0
[162.336977] Dynamic subtest vcs0: SUCCESS (0.038s)
[162.344982] Starting dynamic subtest: vcs1
[162.375549] Dynamic subtest vcs1: SUCCESS (0.038s)
[162.385365] Starting dynamic subtest: vecs0
[162.407647] Dynamic subtest vecs0: SUCCESS (0.032s)
[162.414858] Starting dynamic subtest: ccs0
[162.440373] Dynamic subtest ccs0: SUCCESS (0.032s)
[162.442928] Subtest Q-independent: SUCCESS (0.203s)
[164.056490] [032/131] (855s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[164.168228] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[167.046923] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.882s)
[167.199421] [033/131] (851s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[167.304798] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[167.308353] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[167.404755] [034/131] (851s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[167.506995] Starting subtest: yf-tiled-addfb-size-offset-overflow
[167.510780] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[167.636931] [035/131] (851s left) sw_sync (timeline_closed_signaled)
[167.673621] Starting subtest: timeline_closed_signaled
[167.675624] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[167.731208] [036/131] (851s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[167.850072] Starting subtest: 2x-long-cursor-vs-flip-legacy
[167.853968] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[167.951857] [037/131] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[168.058090] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[171.594022] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.539s)
[171.724816] [038/131] (847s left) i915_query (query-topology-garbage-items)
[171.780711] Starting subtest: query-topology-garbage-items
[171.782722] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[171.873197] [039/131] (847s left) gem_softpin (allocator-basic)
[171.925128] Starting subtest: allocator-basic
[171.989829] Subtest allocator-basic: SUCCESS (0.064s)
[172.125262] [040/131] (847s left) gem_vm_create (invalid-destroy)
[172.184247] Starting subtest: invalid-destroy
[172.188847] Subtest invalid-destroy: SUCCESS (0.002s)
[172.291428] [041/131] (847s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[172.407891] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[176.936172] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.530s)
[177.077087] [042/131] (842s left) gem_userptr_blits (forbidden-operations)
[177.146081] Starting subtest: forbidden-operations
[177.150456] Subtest forbidden-operations: SKIP (0.000s)
[177.251458] [043/131] (842s left) kms_universal_plane (universal-plane-pageflip-windowed)
[177.340995] Starting subtest: universal-plane-pageflip-windowed
[177.343273] Starting dynamic subtest: pipe-A-eDP-1
[177.944433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[177.952777] Starting dynamic subtest: pipe-B-eDP-1
[179.126992] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s)
[179.135148] Starting dynamic subtest: pipe-C-eDP-1
[180.343928] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s)
[180.353297] Starting dynamic subtest: pipe-D-eDP-1
[181.574714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[181.577085] Subtest universal-plane-pageflip-windowed: SUCCESS (4.233s)
[182.418279] [044/131] (837s left) gem_spin_batch (resubmit-new-all)
[182.495769] Starting subtest: resubmit-new-all
[182.498300] Starting dynamic subtest: rcs0
[182.510538] Dynamic subtest rcs0: SUCCESS (0.014s)
[182.519901] Starting dynamic subtest: bcs0
[182.522264] Dynamic subtest bcs0: SUCCESS (0.009s)
[182.529630] Starting dynamic subtest: vcs0
[182.531559] Dynamic subtest vcs0: SUCCESS (0.008s)
[182.538779] Starting dynamic subtest: vcs1
[182.541068] Dynamic subtest vcs1: SUCCESS (0.007s)
[182.549677] Starting dynamic subtest: vecs0
[182.552143] Dynamic subtest vecs0: SUCCESS (0.007s)
[182.559157] Starting dynamic subtest: ccs0
[182.561421] Dynamic subtest ccs0: SUCCESS (0.007s)
[182.563668] Subtest resubmit-new-all: SUCCESS (0.055s)
[183.947764] [045/131] (835s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[184.061851] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[188.348864] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.288s)
[188.493609] [046/131] (831s left) kms_atomic_transition (modeset-transition-fencing)
[188.604258] Starting subtest: modeset-transition-fencing
[188.606496] Starting dynamic subtest: 1x-outputs
[199.098937] Dynamic subtest 1x-outputs: SUCCESS (10.492s)
[199.370910] Subtest modeset-transition-fencing: SUCCESS (10.765s)
[200.220638] [047/131] (819s left) syncobj_wait (wait-all-delayed-signal)
[200.280307] Starting subtest: wait-all-delayed-signal
[200.381252] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[200.456183] [048/131] (819s left) gem_exec_schedule (fairslice-all)
[200.532044] Starting subtest: fairslice-all
[202.589812] Subtest fairslice-all: SUCCESS (2.062s)
[203.993023] [049/131] (815s left) i915_query (engine-info)
[204.055915] Starting subtest: engine-info
[204.062042] Subtest engine-info: SUCCESS (0.005s)
[204.199817] [050/131] (815s left) kms_setmode (basic)
[204.247761] Starting subtest: basic
[204.579926] Starting dynamic subtest: pipe-A-eDP-1
[206.636971] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.053s)
[206.997971] Starting dynamic subtest: pipe-B-eDP-1
[209.067905] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.072s)
[209.371321] Subtest basic: SUCCESS (5.124s)
[210.195235] [051/131] (809s left) gem_mmap_gtt (basic-read)
[210.259085] Subtest basic-read: SKIP (0.000s)
[210.318643] [052/131] (809s left) kms_dsc (dsc-with-formats)
[210.419875] Starting subtest: dsc-with-formats
[210.460204] Subtest dsc-with-formats: SKIP (0.001s)
[210.491676] [053/131] (809s left) sysfs_timeslice_duration (duration)
[210.555531] Starting subtest: duration
[210.557807] Starting dynamic subtest: vecs0
[223.816210] Dynamic subtest vecs0: SUCCESS (13.257s)
[223.826632] Starting dynamic subtest: ccs0
[236.989930] Dynamic subtest ccs0: SUCCESS (13.173s)
[237.000385] Starting dynamic subtest: vcs0
[250.823521] Dynamic subtest vcs0: SUCCESS (13.831s)
[250.833200] Starting dynamic subtest: bcs0
[263.976067] Dynamic subtest bcs0: SUCCESS (13.153s)
[263.986577] Starting dynamic subtest: rcs0
[277.124873] Dynamic subtest rcs0: SUCCESS (13.146s)
[277.136747] Starting dynamic subtest: vcs1
[291.848813] Dynamic subtest vcs1: SUCCESS (14.721s)
[291.851733] Subtest duration: SUCCESS (81.290s)
[291.920329] [054/131] (727s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[292.019255] Starting subtest: plane-all-transition-nonblocking-fencing
[292.021559] Starting dynamic subtest: pipe-A-eDP-1
[294.525453] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[294.812473] Starting dynamic subtest: pipe-B-eDP-1
[298.025220] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.220s)
[298.303639] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.281s)
[299.131498] [055/131] (720s left) gen9_exec_parse (cmd-crossing-page)
[299.201269] Subtest cmd-crossing-page: SKIP (0.000s)
[299.281111] [056/131] (720s left) kms_selftest (drm_damage_helper)
[299.317076] Starting subtest: drm_damage_helper
[299.340574] Starting dynamic subtest: drm_test_damage_iter_no_damage
[299.482513] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.143s)
[299.491356] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[299.618116] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.135s)
[299.627159] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[299.755163] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.137s)
[299.764276] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[299.839881] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.086s)
[299.847799] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[299.948955] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.107s)
[299.957611] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[300.052897] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.104s)
[300.061590] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[300.185707] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.131s)
[300.192634] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[300.321826] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.135s)
[300.331207] Starting dynamic subtest: drm_test_damage_iter_single_damage
[300.470948] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.147s)
[300.478181] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[300.607839] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.136s)
[300.615063] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[300.750034] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.141s)
[300.757537] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[300.897353] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.146s)
[300.904286] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[301.032743] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.135s)
[301.039596] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[301.152942] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.119s)
[301.159947] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[301.285880] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.132s)
[301.292712] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[301.428720] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.142s)
[301.436946] Starting dynamic subtest: drm_test_damage_iter_damage
[301.562783] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.133s)
[301.571074] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[301.657434] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.094s)
[301.664342] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[301.760952] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.102s)
[301.768609] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[301.875074] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.112s)
[301.882285] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[301.981195] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.107s)
[301.983553] Subtest drm_damage_helper: SUCCESS (2.665s)
[302.167005] [057/131] (717s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[302.271377] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[302.273621] Starting dynamic subtest: pipe-A-default-mode
[302.559522] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[302.563999] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.284s)
[303.359835] [058/131] (716s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[303.460351] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[304.538668] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.078s)
[304.686179] [059/131] (715s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[304.795305] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[304.797588] Starting dynamic subtest: pipe-A
[304.806793] Dynamic subtest pipe-A: SKIP (0.006s)
[304.817030] Starting dynamic subtest: pipe-B
[304.826250] Dynamic subtest pipe-B: SKIP (0.019s)
[304.833677] Starting dynamic subtest: pipe-C
[304.842587] Dynamic subtest pipe-C: SKIP (0.017s)
[304.849775] Starting dynamic subtest: pipe-D
[304.862733] Dynamic subtest pipe-D: SKIP (0.017s)
[304.867080] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.060s)
[304.941856] [060/131] (715s left) kms_async_flips (async-flip-with-page-flip-events-atomic)
[305.037043] Starting subtest: async-flip-with-page-flip-events-atomic
[305.409541] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs
[306.144631] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.733s)
[306.152781] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[308.398386] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.256s)
[308.409170] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc
[308.674439] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.273s)
[308.683101] Starting dynamic subtest: pipe-A-eDP-1-4
[310.965723] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.292s)
[310.975775] Starting dynamic subtest: pipe-A-eDP-1-x
[313.276852] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.310s)
[313.284656] Starting dynamic subtest: pipe-A-eDP-1-linear
[315.576847] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.300s)
[315.954330] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs
[316.680302] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.730s)
[316.687865] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[318.947896] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.269s)
[318.957293] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc
[319.222922] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.274s)
[319.230263] Starting dynamic subtest: pipe-B-eDP-1-4
[321.513925] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.291s)
[321.527228] Starting dynamic subtest: pipe-B-eDP-1-x
[323.814464] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.300s)
[323.825029] Starting dynamic subtest: pipe-B-eDP-1-linear
[326.104121] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.289s)
[326.475494] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs
[327.208222] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.737s)
[327.215440] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[329.453501] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.245s)
[329.463787] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc
[329.719414] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.263s)
[329.726936] Starting dynamic subtest: pipe-C-eDP-1-4
[332.019785] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.302s)
[332.027741] Starting dynamic subtest: pipe-C-eDP-1-x
[334.308922] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.288s)
[334.317653] Starting dynamic subtest: pipe-C-eDP-1-linear
[336.609061] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.300s)
[336.971605] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs
[337.736803] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.771s)
[337.744677] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[340.003024] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.268s)
[340.012367] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc
[340.279627] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.274s)
[340.287712] Starting dynamic subtest: pipe-D-eDP-1-4
[342.581469] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.302s)
[342.589648] Starting dynamic subtest: pipe-D-eDP-1-x
[344.880897] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.299s)
[344.888347] Starting dynamic subtest: pipe-D-eDP-1-linear
[347.182631] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.300s)
[347.185447] Subtest async-flip-with-page-flip-events-atomic: SUCCESS (42.142s)
[348.402912] [061/131] (671s left) gem_pxp (reject-modify-context-protection-off-1)
[348.525925] Starting subtest: reject-modify-context-protection-off-1
[348.528440] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[348.625787] [062/131] (671s left) gem_exec_balancer (individual)
[348.685542] Starting subtest: individual
[349.957240] Subtest individual: SUCCESS (1.270s)
[350.259916] [063/131] (669s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[350.319074] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[350.321445] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[350.419689] [064/131] (669s left) gem_exec_reloc (basic-wc-noreloc)
[350.487212] Subtest basic-wc-noreloc: SKIP (0.000s)
[350.569551] [065/131] (669s left) prime_self_import (basic-with_one_bo_two_files)
[350.609217] Starting subtest: basic-with_one_bo_two_files
[350.625819] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[350.713553] [066/131] (669s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[350.819598] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[356.093717] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.278s)
[356.257937] [067/131] (664s left) perf_pmu (init-wait)
[356.302026] Starting subtest: init-wait
[356.304369] Starting dynamic subtest: rcs0
[356.306684] Dynamic subtest rcs0: SUCCESS (0.002s)
[356.315713] Starting dynamic subtest: bcs0
[356.317608] Dynamic subtest bcs0: SUCCESS (0.001s)
[356.325349] Starting dynamic subtest: vcs0
[356.327268] Dynamic subtest vcs0: SUCCESS (0.001s)
[356.334583] Starting dynamic subtest: vcs1
[356.336476] Dynamic subtest vcs1: SUCCESS (0.001s)
[356.343940] Starting dynamic subtest: vecs0
[356.345894] Dynamic subtest vecs0: SUCCESS (0.001s)
[356.353143] Starting dynamic subtest: ccs0
[356.355493] Dynamic subtest ccs0: SUCCESS (0.001s)
[356.357752] Subtest init-wait: SUCCESS (0.008s)
[356.406923] [068/131] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[356.514808] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[356.518700] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[356.614264] [069/131] (663s left) gem_exec_balancer (waits)
[356.679107] Starting subtest: waits
[363.036700] Subtest waits: SUCCESS (6.356s)
[363.331390] [070/131] (657s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[363.441255] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[363.443541] Starting dynamic subtest: pipe-A-eDP-1
[363.466171] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[363.474804] Starting dynamic subtest: pipe-B-eDP-1
[363.496620] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[363.504269] Starting dynamic subtest: pipe-C-eDP-1
[363.525625] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[363.534550] Starting dynamic subtest: pipe-D-eDP-1
[363.556733] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[363.560780] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[365.593435] [071/131] (654s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[365.701996] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[365.706145] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[365.805879] [072/131] (654s left) gem_create (create-ext-placement-each)
[365.981920] Starting subtest: create-ext-placement-each
[365.984554] Subtest create-ext-placement-each: SUCCESS (0.000s)
[366.087222] [073/131] (654s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[366.182535] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[366.186779] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[366.293434] [074/131] (654s left) api_intel_bb (reset-flags)
[366.355097] Starting subtest: reset-flags
[366.362469] Subtest reset-flags: SUCCESS (0.009s)
[366.498854] [075/131] (654s left) gem_mmap_gtt (cpuset-medium-copy)
[366.558020] Subtest cpuset-medium-copy: SKIP (0.000s)
[366.622253] [076/131] (653s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[366.685992] Starting subtest: multi-wait-all-for-submit-available-submitted
[366.687854] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[366.789978] [077/131] (653s left) gem_pread (snoop)
[366.859837] Subtest snoop: SKIP (0.000s)
[366.920042] [078/131] (653s left) kms_psr (fbc-pr-sprite-render)
[367.013042] Starting subtest: fbc-pr-sprite-render
[367.016876] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[367.079825] [079/131] (653s left) i915_module_load (reload-no-display)
[367.116594] Starting subtest: reload-no-display
[373.299763] Subtest reload-no-display: SUCCESS (6.185s)
[373.322142] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[373.322858] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[373.325927] [080/131] (647s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[379.877999] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[379.880929] Starting dynamic subtest: pipe-A-eDP-1
[391.610181] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.730s)
[391.619936] Starting dynamic subtest: pipe-B-eDP-1
[403.344772] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.734s)
[403.347186] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.468s)
[404.194468] [FACT kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[404.196250] [FACT kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)] new: kernel.kmod_is_loaded.i915: true
[404.196825] [FACT kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)] new: kernel.kmod_is_loaded.xe: true
[404.199557] [081/131] (616s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[404.310648] Starting subtest: x-tiled-16bpp-rotate-270
[404.331057] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[404.448636] [082/131] (616s left) kms_flip (2x-wf_vblank-ts-check)
[404.553209] Starting subtest: 2x-wf_vblank-ts-check
[404.564876] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[404.640313] [083/131] (616s left) kms_chamelium_hpd (dp-hpd-storm)
[405.026705] Subtest dp-hpd-storm: SKIP (0.000s)
[405.794652] [084/131] (615s left) kms_chamelium_color (ctm-0-25)
[405.894079] Subtest ctm-0-25: SKIP (0.000s)
[405.934758] [085/131] (614s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[406.038650] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[407.273164] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.233s)
[407.454646] [086/131] (613s left) kms_color (ctm-0-75)
[407.558172] Starting subtest: ctm-0-75
[407.560537] Starting dynamic subtest: pipe-A-eDP-1
[412.235748] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.675s)
[412.244816] Starting dynamic subtest: pipe-B-eDP-1
[417.514079] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.277s)
[417.522047] Starting dynamic subtest: pipe-C-eDP-1
[422.770501] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.257s)
[422.779191] Starting dynamic subtest: pipe-D-eDP-1
[428.104073] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.333s)
[428.106485] Subtest ctm-0-75: SUCCESS (20.544s)
[428.930939] [087/131] (592s left) gem_render_copy (yf-tiled-ccs-to-linear)
[428.997654] Starting subtest: yf-tiled-ccs-to-linear
[429.002269] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[429.176010] [088/131] (591s left) kms_lease (multimaster-lease)
[429.278256] Starting subtest: multimaster-lease
[429.285959] Subtest multimaster-lease: SUCCESS (0.003s)
[429.376378] [089/131] (591s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[429.468233] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[429.470522] Starting dynamic subtest: pipe-A-eDP-1
[429.493722] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.500998] Starting dynamic subtest: pipe-B-eDP-1
[429.522686] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.529713] Starting dynamic subtest: pipe-C-eDP-1
[429.551948] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[429.558835] Starting dynamic subtest: pipe-D-eDP-1
[429.580810] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[429.585288] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[431.585089] [090/131] (589s left) syncobj_timeline (wait-any-snapshot)
[431.651553] Starting subtest: wait-any-snapshot
[431.733726] Subtest wait-any-snapshot: SUCCESS (0.081s)
[431.802727] [091/131] (589s left) kms_fb_coherency (memset-crc)
[431.909922] Starting subtest: memset-crc
[431.911880] Starting dynamic subtest: mmap-offset-wc
[432.286388] Dynamic subtest mmap-offset-wc: SUCCESS (0.376s)
[432.586651] Starting dynamic subtest: mmap-offset-uc
[438.767765] Dynamic subtest mmap-offset-uc: SUCCESS (6.190s)
[439.051108] Subtest memset-crc: SUCCESS (7.142s)
[439.839560] [092/131] (581s left) kms_cursor_legacy (single-move)
[439.967885] Starting subtest: single-move
[439.969903] Starting dynamic subtest: pipe-A
[445.351037] Dynamic subtest pipe-A: SUCCESS (5.380s)
[445.360811] Starting dynamic subtest: pipe-B
[450.736977] Dynamic subtest pipe-B: SUCCESS (5.382s)
[450.745624] Starting dynamic subtest: pipe-C
[456.118546] Dynamic subtest pipe-C: SUCCESS (5.381s)
[456.127646] Starting dynamic subtest: pipe-D
[461.501738] Dynamic subtest pipe-D: SUCCESS (5.381s)
[461.510823] Starting dynamic subtest: all-pipes
[466.891356] Dynamic subtest all-pipes: SUCCESS (5.388s)
[466.893841] Subtest single-move: SUCCESS (26.922s)
[467.016676] [093/131] (554s left) gem_mmap_offset (blt-coherency)
[467.071032] Starting subtest: blt-coherency
[467.079430] Subtest blt-coherency: SUCCESS (0.009s)
[467.204698] [094/131] (553s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[467.300262] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[467.302739] Starting dynamic subtest: pipe-A-eDP-1
[467.588570] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.253s)
[467.598112] Starting dynamic subtest: pipe-B-eDP-1
[468.823412] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.225s)
[468.833146] Starting dynamic subtest: pipe-C-eDP-1
[470.001088] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.186s)
[470.010123] Starting dynamic subtest: pipe-D-eDP-1
[471.234273] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[471.236707] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.901s)
[472.351792] [095/131] (548s left) gem_ccs (block-copy-compressed)
[472.419187] Starting subtest: block-copy-compressed
[472.423973] Subtest block-copy-compressed: SKIP (0.000s)
[472.558658] [096/131] (548s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[472.608956] Subtest untiled-to-tiled: SKIP (0.000s)
[472.676844] [097/131] (548s left) syncobj_wait (wait-for-submit-delayed-submit)
[472.729502] Starting subtest: wait-for-submit-delayed-submit
[472.831362] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[472.905055] [098/131] (548s left) dmabuf_sync_file (import-multiple-read-write)
[472.948722] Starting subtest: import-multiple-read-write
[472.950906] Subtest import-multiple-read-write: SUCCESS (0.004s)
[472.998792] [099/131] (548s left) kms_getfb (getfb2-handle-not-fb)
[473.052877] Starting subtest: getfb2-handle-not-fb
[473.092829] Subtest getfb2-handle-not-fb: SUCCESS (0.042s)
[473.195044] [100/131] (548s left) perf_pmu (busy-double-start)
[473.234392] Starting subtest: busy-double-start
[473.236728] Starting dynamic subtest: rcs0
[476.873089] Dynamic subtest rcs0: FAIL (3.573s)
[476.882183] Starting dynamic subtest: bcs0
[480.420085] Dynamic subtest bcs0: SUCCESS (3.611s)
[480.430456] Starting dynamic subtest: vcs0
[484.467053] Dynamic subtest vcs0: SUCCESS (4.045s)
[484.477676] Starting dynamic subtest: vcs1
[488.470774] Dynamic subtest vcs1: SUCCESS (4.002s)
[488.480979] Starting dynamic subtest: vecs0
[492.457938] Dynamic subtest vecs0: SUCCESS (3.985s)
[492.467349] Starting dynamic subtest: ccs0
[496.099204] Dynamic subtest ccs0: FAIL (3.566s)
[496.101474] Subtest busy-double-start: FAIL (22.792s)
[496.138012] [101/131] (525s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[496.189196] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[496.295738] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[496.365279] [102/131] (525s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[496.417900] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[496.473466] [103/131] (525s left) kms_plane (plane-position-covered)
[496.577821] Starting subtest: plane-position-covered
[497.076921] Starting dynamic subtest: pipe-A-plane-1
[498.323761] Dynamic subtest pipe-A-plane-1: SUCCESS (1.244s)
[498.330964] Starting dynamic subtest: pipe-A-plane-2
[499.623981] Dynamic subtest pipe-A-plane-2: SUCCESS (1.300s)
[499.631797] Starting dynamic subtest: pipe-A-plane-3
[500.852381] Dynamic subtest pipe-A-plane-3: SUCCESS (1.227s)
[500.864787] Starting dynamic subtest: pipe-A-plane-4
[502.087546] Dynamic subtest pipe-A-plane-4: SUCCESS (1.236s)
[502.095802] Starting dynamic subtest: pipe-A-plane-5
[502.124791] Dynamic subtest pipe-A-plane-5: SUCCESS (0.035s)
[503.216445] Starting dynamic subtest: pipe-B-plane-1
[504.433264] Dynamic subtest pipe-B-plane-1: SUCCESS (1.222s)
[504.442757] Starting dynamic subtest: pipe-B-plane-2
[505.651632] Dynamic subtest pipe-B-plane-2: SUCCESS (1.216s)
[505.660098] Starting dynamic subtest: pipe-B-plane-3
[506.877224] Dynamic subtest pipe-B-plane-3: SUCCESS (1.226s)
[506.885122] Starting dynamic subtest: pipe-B-plane-4
[508.109753] Dynamic subtest pipe-B-plane-4: SUCCESS (1.233s)
[508.118305] Starting dynamic subtest: pipe-B-plane-5
[508.147197] Dynamic subtest pipe-B-plane-5: SUCCESS (0.036s)
[508.149027] Subtest plane-position-covered: SUCCESS (11.570s)
[508.888727] [104/131] (512s left) gem_exec_reloc (basic-gtt-cpu-active)
[508.954778] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[509.018213] [105/131] (512s left) kms_invalid_mode (bad-vtotal)
[509.108417] Starting subtest: bad-vtotal
[509.110799] Starting dynamic subtest: pipe-A-eDP-1
[509.390600] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[509.398494] Starting dynamic subtest: pipe-B-eDP-1
[509.400490] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[509.407305] Starting dynamic subtest: pipe-C-eDP-1
[509.409274] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[509.416607] Starting dynamic subtest: pipe-D-eDP-1
[509.418928] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[509.421239] Subtest bad-vtotal: SUCCESS (0.290s)
[510.207533] [106/131] (511s left) kms_psr (psr2-primary-page-flip)
[510.307352] Starting subtest: psr2-primary-page-flip
[510.309735] Starting dynamic subtest: eDP-1
[512.108711] Dynamic subtest eDP-1: SUCCESS (1.798s)
[512.111149] Subtest psr2-primary-page-flip: SUCCESS (1.799s)
[512.972602] [107/131] (508s left) dumb_buffer (map-valid)
[513.021567] Starting subtest: map-valid
[513.023659] Subtest map-valid: SUCCESS (0.000s)
[513.105139] [108/131] (508s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[513.201605] Starting subtest: psr-rgb565-draw-mmap-wc
[517.841622] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (4.642s)
[517.936644] [109/131] (503s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[517.994678] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[518.066124] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.004s)
[518.099948] [110/131] (503s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[518.139056] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[518.176631] [111/131] (503s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[518.282155] Starting subtest: fbcpsr-rgb101010-draw-blt
[522.957029] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.677s)
[523.076326] [112/131] (498s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[523.281342] Starting subtest: cursor-rapid-movement-256x256
[523.287169] Starting dynamic subtest: pipe-A-eDP-1
[523.850743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[523.885724] Starting dynamic subtest: pipe-D-eDP-1
[525.089086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[525.091471] Subtest cursor-rapid-movement-256x256: SUCCESS (1.807s)
[525.922839] [113/131] (495s left) kms_chamelium_color (ctm-green-to-red)
[526.025202] Subtest ctm-green-to-red: SKIP (0.000s)
[526.064990] [114/131] (495s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[526.169086] Starting subtest: bad-aux-stride-yf-tiled-ccs
[526.171344] Starting dynamic subtest: pipe-A-eDP-1
[526.194871] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[526.204205] Starting dynamic subtest: pipe-B-eDP-1
[526.225148] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[526.232993] Starting dynamic subtest: pipe-C-eDP-1
[526.254105] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[526.261795] Starting dynamic subtest: pipe-D-eDP-1
[526.283769] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[526.287833] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[528.375474] [115/131] (493s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[528.482080] Starting subtest: extended-modeset-hang-newfb-with-reset
[528.484321] Starting dynamic subtest: pipe-A
[543.909307] Dynamic subtest pipe-A: SUCCESS (15.425s)
[543.918330] Starting dynamic subtest: pipe-D
[559.762927] Dynamic subtest pipe-D: SUCCESS (15.850s)
[559.765596] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.279s)
[560.556912] [116/131] (461s left) kms_prop_blob (blob-multiple)
[560.616686] Starting subtest: blob-multiple
[560.618918] Subtest blob-multiple: SUCCESS (0.002s)
[560.749494] [117/131] (461s left) gem_exec_suspend (basic-s0)
[560.814786] Starting subtest: basic-S0
[560.817096] Starting dynamic subtest: smem
[581.370527] Dynamic subtest smem: SUCCESS (7.085s)
[581.373608] Subtest basic-S0: SUCCESS (7.087s)
[581.551892] [118/131] (453s left) kms_frontbuffer_tracking (fbc-1p-rte)
[581.661530] Starting subtest: fbc-1p-rte
[586.070185] Subtest fbc-1p-rte: SUCCESS (4.387s)
[586.249795] [119/131] (449s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[586.354588] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[586.358683] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[586.458826] [120/131] (449s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[586.577702] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[591.611027] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (5.020s)
[591.753261] [121/131] (443s left) gem_softpin (noreloc)
[591.811953] Starting subtest: noreloc
[597.233390] Subtest noreloc: SUCCESS (5.410s)
[597.377024] [122/131] (438s left) kms_plane_lowres (tiling-x)
[597.478536] Starting subtest: tiling-x
[597.480947] Starting dynamic subtest: pipe-A-eDP-1
[597.485727] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[597.783746] Starting dynamic subtest: pipe-B-eDP-1
[597.788314] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[597.797193] Starting dynamic subtest: pipe-C-eDP-1
[597.801793] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[597.810420] Starting dynamic subtest: pipe-D-eDP-1
[597.814780] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[597.819275] Subtest tiling-x: SKIP (0.302s)
[598.600831] [123/131] (437s left) kms_content_protection (lic-type-1)
[598.778962] Starting subtest: lic-type-1
[602.142349] Subtest lic-type-1: SKIP (3.358s)
[603.306235] [124/131] (432s left) vgem_basic (setversion)
[603.351500] Starting subtest: setversion
[603.355654] Subtest setversion: SUCCESS (0.000s)
[603.403651] [125/131] (432s left) gem_linear_blits (basic)
[603.870157] Starting subtest: basic
[603.877249] Subtest basic: SUCCESS (0.007s)
[604.032642] [126/131] (431s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[609.052092] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[609.054308] Starting dynamic subtest: pipe-A-eDP-1
[609.860456] Dynamic subtest pipe-A-eDP-1: SKIP (0.805s)
[609.870394] Starting dynamic subtest: pipe-B-eDP-1
[610.986041] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[610.990346] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.932s)
[612.158722] [127/131] (423s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[612.269366] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[612.273929] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[612.351475] [128/131] (423s left) gem_exec_whisper (basic-contexts-forked-all)
[612.415501] Starting subtest: basic-contexts-forked-all
[631.361951] Subtest basic-contexts-forked-all: SUCCESS (18.934s)
[631.544115] [129/131] (404s left) i915_query (query-topology-kernel-writes)
[631.611893] Starting subtest: query-topology-kernel-writes
[631.614147] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[631.722942] [130/131] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[631.842757] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[631.846892] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[631.942803] [131/131] (404s left) api_intel_bb (destroy-bb)
[632.006884] Starting subtest: destroy-bb
[632.014926] Subtest destroy-bb: SUCCESS (0.009s)
[632.137507] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: gem_ctx_isolation
results: parsing output: 3/ for test: kms_pm_dc
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_atomic_interruptible
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: gem_exec_flush
results: parsing output: 13/ for test: gem_ctx_bad_destroy
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_vrr
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_fence_pin_leak
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_setmode
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_getfb
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_fbcon_fbt
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_ctx_shared
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: sw_sync
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: gem_vm_create
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: kms_universal_plane
results: parsing output: 43/ for test: gem_spin_batch
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_atomic_transition
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: i915_query
results: parsing output: 49/ for test: kms_setmode
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: kms_dsc
results: parsing output: 52/ for test: sysfs_timeslice_duration
results: parsing output: 53/ for test: kms_atomic_transition
results: parsing output: 54/ for test: gen9_exec_parse
results: parsing output: 55/ for test: kms_selftest
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: prime_self_import
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_balancer
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_create
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_pread
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: i915_module_load
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: kms_chamelium_color
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_color
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_fb_coherency
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_mmap_offset
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_ccs
results: parsing output: 95/ for test: gem_set_tiling_vs_blt
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: dmabuf_sync_file
results: parsing output: 98/ for test: kms_getfb
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_pipe_b_c_ivb
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_invalid_mode
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: dumb_buffer
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: sriov_basic
results: parsing output: 109/ for test: gem_lmem_swapping
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_busy
results: parsing output: 115/ for test: kms_prop_blob
results: parsing output: 116/ for test: gem_exec_suspend
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: kms_plane_lowres
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: vgem_basic
results: parsing output: 124/ for test: gem_linear_blits
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: i915_query
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: api_intel_bb
Done.