[57.885957] Initializing watchdogs
[57.886011]   /dev/watchdog0
[57.900060] [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.904549] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.906694] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.909914] [001/133] (960s left) kms_selftest (drm_damage_helper)
[57.969840] Starting subtest: drm_damage_helper
[57.978248] Starting dynamic subtest: drm_test_damage_iter_no_damage
[58.079624] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.103s)
[58.090617] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[58.157300] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.078s)
[58.165217] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[58.251954] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.093s)
[58.260735] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[58.341535] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.090s)
[58.348466] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[58.442874] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.101s)
[58.449447] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[58.547648] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.104s)
[58.553865] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[58.636189] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.088s)
[58.642337] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[58.724306] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.088s)
[58.730487] Starting dynamic subtest: drm_test_damage_iter_single_damage
[58.814404] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.091s)
[58.822530] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[58.913809] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.098s)
[58.921663] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[59.000531] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.088s)
[59.009099] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[59.094921] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.093s)
[59.100822] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[59.179567] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.085s)
[59.188105] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[59.282476] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.102s)
[59.290757] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[59.380629] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.099s)
[59.388929] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[59.479631] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.099s)
[59.487945] Starting dynamic subtest: drm_test_damage_iter_damage
[59.568653] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.089s)
[59.576817] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[59.671841] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.102s)
[59.682540] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[59.760678] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.089s)
[59.770354] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[59.849477] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.090s)
[59.857624] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[59.945981] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.096s)
[59.948159] Subtest drm_damage_helper: SUCCESS (1.980s)
[60.103844] [002/133] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[60.204438] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[60.207940] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[60.305116] [003/133] (958s left) prime_mmap (test_invalid_sync_flags)
[60.359440] Starting subtest: test_invalid_sync_flags
[60.361533] Starting dynamic subtest: test_invalid_sync_flags-smem
[60.363575] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[60.365294] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[60.457630] [004/133] (958s left) gem_exec_params (no-blt)
[60.520884] Starting subtest: no-blt
[60.524827] Subtest no-blt: SUCCESS (0.002s)
[60.642509] [005/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[60.737042] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[60.740496] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[60.841901] [006/133] (957s left) kms_atomic_interruptible (legacy-setmode)
[60.921967] Starting subtest: legacy-setmode
[60.924105] Starting dynamic subtest: pipe-A-eDP-1
[67.817481] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.899s)
[67.819968] Subtest legacy-setmode: SUCCESS (6.900s)
[68.681355] [007/133] (949s left) prime_self_import (basic-llseek-bad)
[68.724211] Starting subtest: basic-llseek-bad
[68.747755] Subtest basic-llseek-bad: SUCCESS (0.024s)
[68.844772] [008/133] (949s left) kms_atomic (plane-cursor-legacy)
[68.934137] Starting subtest: plane-cursor-legacy
[68.936492] Starting dynamic subtest: pipe-A-eDP-1
[69.328792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.394s)
[69.331273] Subtest plane-cursor-legacy: SUCCESS (0.395s)
[70.134195] [009/133] (948s left) syncobj_timeline (single-wait-all-signaled)
[70.184297] Starting subtest: single-wait-all-signaled
[70.186717] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[70.267190] [010/133] (948s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[70.366571] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[70.455338] [011/133] (948s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[70.523143] Starting subtest: yf-tiled-ccs-to-x-tiled
[70.527934] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[70.703476] [012/133] (948s left) prime_mmap (test_refcounting)
[70.755991] Starting subtest: test_refcounting
[70.758032] Starting dynamic subtest: test_refcounting-smem
[70.784537] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s)
[70.786992] Subtest test_refcounting: SUCCESS (0.031s)
[70.886033] [013/133] (947s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[70.966801] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[70.969145] Starting dynamic subtest: pipe-A-eDP-1
[70.991400] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.998704] Starting dynamic subtest: pipe-B-eDP-1
[71.019538] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[71.026106] Starting dynamic subtest: pipe-C-eDP-1
[71.046239] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[71.052527] Starting dynamic subtest: pipe-D-eDP-1
[71.071102] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[71.074493] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[73.291618] [014/133] (945s left) gem_ctx_persistence (heartbeat-many)
[73.362317] Starting subtest: heartbeat-many
[73.367129] Subtest heartbeat-many: SKIP (0.000s)
[73.476675] [015/133] (945s left) kms_chamelium_frames (hdmi-crc-fast)
[73.855824] Subtest hdmi-crc-fast: SKIP (0.000s)
[74.687558] [016/133] (944s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[74.794865] Starting subtest: x-tiled-64bpp-rotate-270
[74.813814] Subtest x-tiled-64bpp-rotate-270: SKIP (0.018s)
[74.943909] [017/133] (944s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[75.052401] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[82.110208] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.061s)
[82.233190] [018/133] (936s left) gem_userptr_blits (sync-overlap)
[82.305853] Starting subtest: sync-overlap
[82.307808] Subtest sync-overlap: SUCCESS (0.000s)
[82.441015] [019/133] (936s left) kms_vblank (ts-continuation-suspend)
[82.527459] Starting subtest: ts-continuation-suspend
[82.529477] Starting dynamic subtest: pipe-A-eDP-1
[98.660147] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.664s)
[98.674682] Starting dynamic subtest: pipe-D-eDP-1
[115.631125] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.189s)
[115.633381] Subtest ts-continuation-suspend: SUCCESS (3.856s)
[116.425249] [020/133] (902s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[116.527135] Starting subtest: y-tiled-16bpp-rotate-90
[116.531295] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[116.606884] [021/133] (902s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[116.696300] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[116.698609] Starting dynamic subtest: pipe-A-default-mode
[117.892967] Dynamic subtest pipe-A-default-mode: SKIP (1.201s)
[117.896907] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.202s)
[118.051578] [022/133] (901s left) kms_flip (wf_vblank-ts-check)
[118.145802] Starting subtest: wf_vblank-ts-check
[118.148129] Starting dynamic subtest: A-eDP1
[127.084840] Dynamic subtest A-eDP1: SUCCESS (8.970s)
[127.097545] Starting dynamic subtest: B-eDP1
[136.010377] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[136.020975] Starting dynamic subtest: C-eDP1
[144.932306] Dynamic subtest C-eDP1: SUCCESS (8.927s)
[144.943876] Starting dynamic subtest: D-eDP1
[153.873426] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[153.876206] Subtest wf_vblank-ts-check: SUCCESS (35.776s)
[155.107163] [023/133] (864s left) i915_query (engine-info)
[155.180283] Starting subtest: engine-info
[155.185318] Subtest engine-info: SUCCESS (0.006s)
[155.300977] [024/133] (863s left) core_getclient (basic)
[155.358754] Starting subtest: basic
[155.360775] Subtest basic: SUCCESS (0.000s)
[155.489298] [025/133] (863s left) kms_pm_rpm (cursor-dpms)
[157.310996] Starting subtest: cursor-dpms
[157.316394] Subtest cursor-dpms: SKIP (0.000s)
[157.751378] [026/133] (861s left) gem_exec_reloc (basic-write-gtt-noreloc)
[157.807964] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[157.885858] [027/133] (861s left) perf (disabled-read-error)
[158.013991] Starting subtest: disabled-read-error
[158.030475] Subtest disabled-read-error: SUCCESS (0.020s)
[158.069391] [028/133] (861s left) perf (enable-disable)
[158.151708] Starting subtest: enable-disable
[158.154138] Starting dynamic subtest: 0-rcs0
[160.398498] Dynamic subtest 0-rcs0: SUCCESS (2.244s)
[160.406794] Starting dynamic subtest: 1-vcs1
[164.834853] Dynamic subtest 1-vcs1: SUCCESS (4.435s)
[164.837169] Subtest enable-disable: SUCCESS (6.680s)
[164.871554] [029/133] (854s left) i915_hangman (gt-engine-error)
[164.936485] Starting subtest: gt-engine-error
[164.938956] Starting dynamic subtest: rcs0
[166.148769] Dynamic subtest rcs0: SUCCESS (1.211s)
[166.160838] Starting dynamic subtest: bcs0
[168.069952] Dynamic subtest bcs0: SUCCESS (1.920s)
[168.082202] Starting dynamic subtest: vcs0
[169.156526] Dynamic subtest vcs0: SUCCESS (1.085s)
[169.169778] Starting dynamic subtest: vcs1
[171.141068] Dynamic subtest vcs1: SUCCESS (1.983s)
[171.153293] Starting dynamic subtest: vecs0
[173.125477] Dynamic subtest vecs0: SUCCESS (1.983s)
[173.138188] Starting dynamic subtest: ccs0
[175.109735] Dynamic subtest ccs0: SUCCESS (1.983s)
[175.112706] Subtest gt-engine-error: SUCCESS (10.173s)
[175.203991] [030/133] (844s left) kms_flip (flip-vs-suspend)
[175.304071] Starting subtest: flip-vs-suspend
[175.306114] Starting dynamic subtest: A-eDP1
[224.373319] Dynamic subtest A-eDP1: SUCCESS (4.645s)
[224.382544] Starting dynamic subtest: B-eDP1
[273.375920] Dynamic subtest B-eDP1: SUCCESS (4.492s)
[273.385615] Starting dynamic subtest: C-eDP1
[322.384755] Dynamic subtest C-eDP1: SUCCESS (4.569s)
[322.402087] Starting dynamic subtest: D-eDP1
[371.368333] Dynamic subtest D-eDP1: SUCCESS (4.497s)
[371.373039] Subtest flip-vs-suspend: SUCCESS (18.212s)
[372.520903] [031/133] (647s left) gem_lmem_swapping (heavy-verify-random-ccs)
[372.575430] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[372.623317] [032/133] (647s left) gem_exec_balancer (bonded-semaphore)
[372.697912] Starting subtest: bonded-semaphore
[372.702447] Subtest bonded-semaphore: SKIP (0.000s)
[372.988171] [033/133] (646s left) gem_flink_basic (double-flink)
[373.041790] Starting subtest: double-flink
[373.043910] Subtest double-flink: SUCCESS (0.000s)
[373.134325] [034/133] (646s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[373.221335] Starting subtest: disable-crc-after-crtc
[373.223484] Starting dynamic subtest: pipe-A-eDP-1
[374.860897] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.643s)
[374.871121] Starting dynamic subtest: pipe-B-eDP-1
[377.118466] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.260s)
[377.130091] Starting dynamic subtest: pipe-C-eDP-1
[379.376071] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.263s)
[379.385833] Starting dynamic subtest: pipe-D-eDP-1
[381.641120] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.268s)
[381.643255] Subtest disable-crc-after-crtc: SUCCESS (8.442s)
[382.466628] [035/133] (637s left) gem_basic (create-close)
[382.533075] Starting subtest: create-close
[382.537227] Subtest create-close: SUCCESS (0.000s)
[382.628254] [036/133] (637s left) gen9_exec_parse (cmd-crossing-page)
[382.689022] Subtest cmd-crossing-page: SKIP (0.000s)
[382.757185] [037/133] (637s left) gem_exec_whisper (basic-normal-all)
[382.810134] Starting subtest: basic-normal-all
[385.206104] Subtest basic-normal-all: SUCCESS (2.399s)
[385.385695] [038/133] (634s left) gem_tiled_blits (basic)
[385.437980] Subtest basic: SKIP (0.000s)
[385.511282] [039/133] (634s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[385.633531] Starting subtest: cursor-vs-flip-atomic-transitions
[415.822110] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.205s)
[416.672279] [040/133] (603s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[416.792429] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[416.796454] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[416.883729] [041/133] (603s left) gem_unref_active_buffers
[417.084892] [042/133] (602s left) syncobj_timeline (host-signal-ordered)
[417.133001] Starting subtest: host-signal-ordered
[417.135303] Subtest host-signal-ordered: SUCCESS (0.000s)
[417.222776] [043/133] (602s left) kms_frontbuffer_tracking (fbc-tiling-y)
[417.333900] Starting subtest: fbc-tiling-y
[417.338229] Subtest fbc-tiling-y: SKIP (0.000s)
[417.439591] [044/133] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[417.535812] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[417.540471] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[417.634883] [045/133] (602s left) kms_busy (extended-modeset-hang-newfb)
[417.745963] Starting subtest: extended-modeset-hang-newfb
[417.747886] Starting dynamic subtest: pipe-A
[452.764247] Dynamic subtest pipe-A: SUCCESS (35.034s)
[452.773092] Starting dynamic subtest: pipe-D
[474.986299] Dynamic subtest pipe-D: SUCCESS (22.221s)
[474.988785] Subtest extended-modeset-hang-newfb: SUCCESS (57.259s)
[475.786606] [046/133] (544s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[475.884916] Starting subtest: multiplane-rotation-cropping-top
[493.279430] Subtest multiplane-rotation-cropping-top: SUCCESS (17.393s)
[493.382706] [047/133] (526s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[493.447236] Starting subtest: multi-wait-all-for-submit-available-signaled
[493.449113] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[493.571978] [048/133] (526s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[493.661867] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[493.663800] Starting dynamic subtest: pipe-A-eDP-1
[493.757392] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[493.766197] Starting dynamic subtest: pipe-B-eDP-1
[494.871197] Dynamic subtest pipe-B-eDP-1: SKIP (1.109s)
[494.875916] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.212s)
[496.076629] [049/133] (524s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[496.174529] Starting subtest: fbc-rgb101010-draw-render
[500.794921] Subtest fbc-rgb101010-draw-render: SUCCESS (4.623s)
[501.996860] [050/133] (518s left) perf_pmu (rc6-all-gts)
[502.040634] Starting subtest: rc6-all-gts
[508.414368] Subtest rc6-all-gts: SUCCESS (6.373s)
[509.284029] [051/133] (511s left) kms_plane_lowres (tiling-x)
[509.380096] Starting subtest: tiling-x
[509.382349] Starting dynamic subtest: pipe-A-eDP-1
[509.386594] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[509.676495] Starting dynamic subtest: pipe-B-eDP-1
[509.681104] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[509.690085] Starting dynamic subtest: pipe-C-eDP-1
[509.694500] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[509.703383] Starting dynamic subtest: pipe-D-eDP-1
[509.707814] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[509.712051] Subtest tiling-x: SKIP (0.294s)
[510.509043] [052/133] (509s left) kms_plane (plane-panning-bottom-right)
[510.602409] Starting subtest: plane-panning-bottom-right
[510.604579] Starting dynamic subtest: pipe-A
[512.263128] Dynamic subtest pipe-A: SUCCESS (1.660s)
[512.272947] Starting dynamic subtest: pipe-B
[514.660429] Dynamic subtest pipe-B: SUCCESS (2.395s)
[514.662552] Subtest plane-panning-bottom-right: SUCCESS (4.058s)
[515.453243] [053/133] (504s left) gem_exec_parallel (contexts)
[515.515137] Starting subtest: contexts
[515.517540] Starting dynamic subtest: rcs0
[518.472991] Dynamic subtest rcs0: SUCCESS (2.953s)
[518.485004] Starting dynamic subtest: bcs0
[522.120063] Dynamic subtest bcs0: SUCCESS (3.647s)
[522.132238] Starting dynamic subtest: vcs0
[526.518170] Dynamic subtest vcs0: SUCCESS (4.396s)
[526.530624] Starting dynamic subtest: vcs1
[530.587238] Dynamic subtest vcs1: SUCCESS (4.068s)
[530.596608] Starting dynamic subtest: vecs0
[534.611933] Dynamic subtest vecs0: SUCCESS (4.022s)
[534.624219] Starting dynamic subtest: ccs0
[538.286378] Dynamic subtest ccs0: SUCCESS (3.673s)
[538.289078] Subtest contexts: SUCCESS (22.775s)
[538.476065] [054/133] (481s left) prime_vgem (basic-gtt)
[538.654221] Starting subtest: basic-gtt
[538.658521] Subtest basic-gtt: SKIP (0.000s)
[538.752834] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[538.758704] [055/133] (481s left) gem_exec_schedule (submit-early-slice)
[538.827161] Starting subtest: submit-early-slice
[538.829369] Starting dynamic subtest: rcs0
[538.892708] Dynamic subtest rcs0: SUCCESS (0.073s)
[538.901754] Starting dynamic subtest: bcs0
[538.948522] Dynamic subtest bcs0: SUCCESS (0.054s)
[538.957151] Starting dynamic subtest: vcs0
[539.008016] Dynamic subtest vcs0: SUCCESS (0.058s)
[539.017352] Starting dynamic subtest: vcs1
[539.067986] Dynamic subtest vcs1: SUCCESS (0.059s)
[539.082944] Starting dynamic subtest: vecs0
[539.117420] Dynamic subtest vecs0: SUCCESS (0.049s)
[539.126294] Starting dynamic subtest: ccs0
[539.172368] Dynamic subtest ccs0: SUCCESS (0.054s)
[539.174641] Subtest submit-early-slice: SUCCESS (0.354s)
[540.166715] [056/133] (480s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[540.225378] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[540.333739] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[540.413920] [057/133] (480s left) gem_ctx_shared (detached-shared-gtt)
[540.481492] Starting subtest: detached-shared-gtt
[542.636463] Subtest detached-shared-gtt: SUCCESS (2.154s)
[542.906563] [058/133] (477s left) gem_exec_schedule (fairslice)
[542.978598] Starting subtest: fairslice
[542.980987] Starting dynamic subtest: rcs0
[545.001916] Dynamic subtest rcs0: SUCCESS (2.029s)
[545.011044] Starting dynamic subtest: bcs0
[547.023897] Dynamic subtest bcs0: SUCCESS (2.021s)
[547.033982] Starting dynamic subtest: vcs0
[549.043858] Dynamic subtest vcs0: SUCCESS (2.020s)
[549.057709] Starting dynamic subtest: vcs1
[551.064571] Dynamic subtest vcs1: SUCCESS (2.020s)
[551.075133] Starting dynamic subtest: vecs0
[553.088142] Dynamic subtest vecs0: SUCCESS (2.022s)
[553.098254] Starting dynamic subtest: ccs0
[555.110885] Dynamic subtest ccs0: SUCCESS (2.021s)
[555.112988] Subtest fairslice: SUCCESS (12.140s)
[555.403676] [059/133] (465s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[555.504102] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[555.508909] Starting dynamic subtest: pipe-A-eDP-1
[555.533959] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[555.543746] Starting dynamic subtest: pipe-B-eDP-1
[555.566988] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[555.575093] Starting dynamic subtest: pipe-C-eDP-1
[555.599284] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[555.607519] Starting dynamic subtest: pipe-D-eDP-1
[555.630395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[555.634542] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[557.726232] [060/133] (462s left) kms_flip (basic-flip-vs-wf_vblank)
[557.827518] Starting subtest: basic-flip-vs-wf_vblank
[557.829847] Starting dynamic subtest: A-eDP1
[559.769533] Dynamic subtest A-eDP1: SUCCESS (1.942s)
[559.779739] Starting dynamic subtest: B-eDP1
[561.708623] Dynamic subtest B-eDP1: SUCCESS (1.938s)
[561.720651] Starting dynamic subtest: C-eDP1
[563.628876] Dynamic subtest C-eDP1: SUCCESS (1.918s)
[563.639504] Starting dynamic subtest: D-eDP1
[565.569090] Dynamic subtest D-eDP1: SUCCESS (1.939s)
[565.571451] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.747s)
[566.793387] [061/133] (453s left) kms_feature_discovery (display-2x)
[566.894654] Starting subtest: display-2x
[566.899193] Subtest display-2x: SKIP (0.000s)
[566.967005] [062/133] (453s left) gem_exec_capture (capture)
[567.021871] Starting subtest: capture
[567.024156] Starting dynamic subtest: rcs0-smem
[567.852489] Dynamic subtest rcs0-smem: SUCCESS (0.830s)
[567.861766] Starting dynamic subtest: bcs0-smem
[569.171493] Dynamic subtest bcs0-smem: SUCCESS (1.317s)
[569.180210] Starting dynamic subtest: vcs0-smem
[569.985441] Dynamic subtest vcs0-smem: SUCCESS (0.815s)
[569.998363] Starting dynamic subtest: vcs1-smem
[570.794366] Dynamic subtest vcs1-smem: SUCCESS (0.809s)
[570.804130] Starting dynamic subtest: vecs0-smem
[572.186450] Dynamic subtest vecs0-smem: FAIL (1.324s)
[572.201627] Starting dynamic subtest: ccs0-smem
[573.438887] Dynamic subtest ccs0-smem: SUCCESS (1.318s)
[573.441113] Subtest capture: FAIL (6.418s)
[573.576759] [063/133] (447s left) syncobj_wait (multi-wait-all-signaled)
[573.634724] Starting subtest: multi-wait-all-signaled
[573.636581] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[573.729123] [064/133] (447s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[573.839247] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[573.865647] Starting dynamic subtest: pipe-A-plane-0
[574.154197] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[574.166054] Starting dynamic subtest: pipe-A-plane-3
[574.387528] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[574.397234] Starting dynamic subtest: pipe-A-plane-5
[574.401572] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[575.478767] Starting dynamic subtest: pipe-B-plane-0
[575.758382] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[575.767363] Starting dynamic subtest: pipe-B-plane-3
[575.991639] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[576.000417] Starting dynamic subtest: pipe-B-plane-5
[576.004566] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[576.315821] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.476s)
[577.173708] [065/133] (443s left) gem_exec_create (madvise)
[577.232786] Starting subtest: madvise
[577.235211] Starting dynamic subtest: smem
[597.401668] Dynamic subtest smem: SUCCESS (20.171s)
[597.407287] Subtest madvise: SUCCESS (20.173s)
[598.366950] [066/133] (422s left) i915_drm_fdinfo (all-busy-idle-check-all)
[598.409802] Starting subtest: all-busy-idle-check-all
[598.417350] Subtest all-busy-idle-check-all: SKIP (0.006s)
[598.496104] [067/133] (422s left) kms_hdr (static-toggle-suspend)
[598.625041] Starting subtest: static-toggle-suspend
[598.631410] Subtest static-toggle-suspend: SKIP (0.000s)
[598.710417] [068/133] (422s left) fbdev (unaligned-read)
[598.760233] Starting subtest: unaligned-read
[598.774657] Subtest unaligned-read: SUCCESS (0.014s)
[598.841543] [069/133] (422s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[598.939970] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[598.944363] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[599.042180] [070/133] (422s left) kms_big_fb (linear-32bpp-rotate-0)
[599.142715] Starting subtest: linear-32bpp-rotate-0
[600.544596] Subtest linear-32bpp-rotate-0: SUCCESS (1.401s)
[600.690192] [071/133] (420s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[600.790637] Starting subtest: fbcpsr-shrfb-scaledprimary
[606.544745] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.755s)
[606.695270] [072/133] (414s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[606.799644] Starting subtest: random-ccs-data-yf-tiled-ccs
[606.801998] Starting dynamic subtest: pipe-A-eDP-1
[606.827364] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[606.838439] Starting dynamic subtest: pipe-B-eDP-1
[606.862073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[606.871647] Starting dynamic subtest: pipe-C-eDP-1
[606.895571] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[606.904382] Starting dynamic subtest: pipe-D-eDP-1
[606.928895] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[606.934448] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[609.060348] [073/133] (412s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[609.167467] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[609.171435] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[609.248342] [074/133] (412s left) kms_psr (pr-sprite-plane-move)
[609.343264] Starting subtest: pr-sprite-plane-move
[609.347493] Subtest pr-sprite-plane-move: SKIP (0.000s)
[609.430589] [075/133] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[609.536425] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[609.540427] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[609.643857] [076/133] (411s left) kms_psr (fbc-psr-no-drrs)
[609.731798] Starting subtest: fbc-psr-no-drrs
[609.733702] Starting dynamic subtest: eDP-1
[609.737661] Dynamic subtest eDP-1: SKIP (0.000s)
[609.741699] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[609.801684] [077/133] (411s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[609.905095] Starting subtest: psr-rgb565-draw-render
[616.854687] Subtest psr-rgb565-draw-render: SUCCESS (6.950s)
[616.981950] [078/133] (404s left) gem_exec_schedule (noreorder-corked)
[617.164235] Starting subtest: noreorder-corked
[617.167372] Starting dynamic subtest: rcs0
[618.302018] Dynamic subtest rcs0: SUCCESS (1.139s)
[618.315235] Starting dynamic subtest: vcs0
[620.084966] Dynamic subtest vcs0: SUCCESS (1.779s)
[620.097664] Starting dynamic subtest: vcs1
[622.122907] Dynamic subtest vcs1: SUCCESS (2.035s)
[622.134263] Starting dynamic subtest: vecs0
[624.112898] Dynamic subtest vecs0: SUCCESS (1.987s)
[624.125547] Starting dynamic subtest: ccs0
[625.271287] Dynamic subtest ccs0: SUCCESS (1.157s)
[625.273977] Subtest noreorder-corked: SUCCESS (8.108s)
[625.461390] [079/133] (396s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[625.569984] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[626.339372] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.771s)
[626.517889] [080/133] (395s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[626.711245] Starting subtest: cursor-rapid-movement-128x128
[626.716239] Starting dynamic subtest: pipe-A-eDP-1
[627.272656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[627.302169] Starting dynamic subtest: pipe-D-eDP-1
[628.527516] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[628.529772] Subtest cursor-rapid-movement-128x128: SUCCESS (1.814s)
[629.365238] [081/133] (392s left) kms_lease (implicit-plane-lease)
[629.471331] Starting subtest: implicit-plane-lease
[629.473489] Subtest implicit-plane-lease: SUCCESS (0.003s)
[629.575218] [082/133] (392s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[629.684835] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[636.627275] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.945s)
[636.767248] [083/133] (384s left) gem_exec_reloc (basic-cpu-gtt-active)
[636.830785] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[636.904786] [084/133] (384s left) gem_close_race (multigpu-basic-process)
[636.965857] Starting subtest: multigpu-basic-process
[636.970116] Subtest multigpu-basic-process: SKIP (0.000s)
[637.190430] [085/133] (384s left) kms_content_protection (dp-mst-type-0-hdcp14)
[637.327691] Starting subtest: dp-mst-type-0-hdcp14
[637.332285] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[637.454114] [086/133] (384s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[637.523034] Starting subtest: etime-multi-wait-all-available-unsubmitted
[637.629392] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.106s)
[637.721818] [087/133] (384s left) core_getversion (all-cards)
[637.760882] Starting subtest: all-cards
[637.769488] Subtest all-cards: SUCCESS (0.012s)
[637.812528] [088/133] (384s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[637.868411] Starting subtest: yf-tiled-to-vebox-x-tiled
[637.872735] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[638.049463] [089/133] (383s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[638.145334] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[638.149591] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[638.243042] [090/133] (383s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[638.353527] Starting subtest: short-flip-after-cursor-atomic-transitions
[639.298595] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.946s)
[640.124216] [091/133] (381s left) prime_vgem (coherency-blt)
[640.186890] Starting subtest: coherency-blt
[641.235230] Subtest coherency-blt: SUCCESS (1.046s)
[641.363963] [092/133] (380s left) gem_userptr_blits (mmap-offset-banned)
[641.438199] Starting subtest: mmap-offset-banned
[641.440427] Starting dynamic subtest: wb
[641.442711] Dynamic subtest wb: SUCCESS (0.000s)
[641.452561] Starting dynamic subtest: wc
[641.454792] Dynamic subtest wc: SUCCESS (0.000s)
[641.464128] Starting dynamic subtest: uc
[641.466414] Dynamic subtest uc: SUCCESS (0.000s)
[641.468565] Subtest mmap-offset-banned: SUCCESS (0.002s)
[641.560694] [093/133] (380s left) kms_flip (flip-vs-expired-vblank-interruptible)
[641.653629] Starting subtest: flip-vs-expired-vblank-interruptible
[641.655911] Starting dynamic subtest: A-eDP1
[650.314808] Dynamic subtest A-eDP1: SUCCESS (8.659s)
[650.324761] Starting dynamic subtest: B-eDP1
[658.939580] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[658.960492] Starting dynamic subtest: C-eDP1
[667.652979] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[667.666918] Starting dynamic subtest: D-eDP1
[676.297015] Dynamic subtest D-eDP1: SUCCESS (8.642s)
[676.302178] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.648s)
[677.480792] [094/133] (344s left) kms_flip (flip-vs-panning-vs-hang)
[677.576643] Starting subtest: flip-vs-panning-vs-hang
[677.578579] Starting dynamic subtest: A-eDP1
[728.597381] Dynamic subtest A-eDP1: SUCCESS (51.029s)
[728.611551] Starting dynamic subtest: D-eDP1
[768.600103] Dynamic subtest D-eDP1: SUCCESS (40.007s)
[768.605425] Subtest flip-vs-panning-vs-hang: SUCCESS (91.043s)
[769.743784] [095/133] (252s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[769.849378] Starting subtest: yf-tiled-64bpp-rotate-90
[769.853927] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[769.963255] [096/133] (252s left) kms_properties (get_properties-sanity-non-atomic)
[770.063441] Starting subtest: get_properties-sanity-non-atomic
[770.065694] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[770.139948] [097/133] (252s left) gem_request_retire (retire-vma-not-inactive)
[770.218842] Starting subtest: retire-vma-not-inactive
[770.286024] Subtest retire-vma-not-inactive: SUCCESS (0.065s)
[770.407605] [098/133] (251s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[770.462019] Starting subtest: single-wait-for-submit-unsubmitted
[770.565363] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[770.653711] [099/133] (251s left) gem_exec_flush (basic-wb-ro-default)
[770.714143] Starting subtest: basic-wb-ro-default
[776.186359] Subtest basic-wb-ro-default: SUCCESS (5.474s)
[776.373199] [100/133] (246s left) syncobj_wait (single-wait-submitted)
[776.430937] Starting subtest: single-wait-submitted
[776.531957] Subtest single-wait-submitted: SUCCESS (0.102s)
[776.617227] [101/133] (245s left) kms_prop_blob (basic)
[776.674593] Starting subtest: basic
[776.676942] Subtest basic: SUCCESS (0.000s)
[776.788492] [102/133] (245s left) sysfs_preempt_timeout (timeout)
[776.847077] Starting subtest: timeout
[776.849534] Starting dynamic subtest: vecs0
[786.089112] Dynamic subtest vecs0: SUCCESS (9.240s)
[786.103934] Starting dynamic subtest: ccs0
[787.340980] Dynamic subtest ccs0: SUCCESS (1.253s)
[787.353104] Starting dynamic subtest: vcs0
[797.105712] Dynamic subtest vcs0: SUCCESS (9.761s)
[797.119482] Starting dynamic subtest: bcs0
[798.346526] Dynamic subtest bcs0: SUCCESS (1.239s)
[798.358781] Starting dynamic subtest: rcs0
[799.526056] Dynamic subtest rcs0: SUCCESS (1.180s)
[799.539010] Starting dynamic subtest: vcs1
[809.071621] Dynamic subtest vcs1: SUCCESS (9.543s)
[809.074701] Subtest timeout: SUCCESS (32.229s)
[809.151641] [103/133] (213s left) kms_cursor_crc (cursor-offscreen-512x512)
[809.440997] Starting subtest: cursor-offscreen-512x512
[809.445407] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[809.585074] [104/133] (213s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[809.650122] Starting subtest: invalid-bsd1-flag-on-blt
[809.652397] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[809.746122] [105/133] (212s left) i915_pm_rpm (sysfs-read)
[811.275893] Starting subtest: sysfs-read
[812.433980] Subtest sysfs-read: SUCCESS (1.159s)
[812.804948] [106/133] (209s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[812.918787] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[813.881560] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.962s)
[814.719180] [107/133] (207s left) gem_exec_fence (syncobj-signal)
[815.197559] Starting subtest: syncobj-signal
[815.199754] Subtest syncobj-signal: SUCCESS (0.005s)
[817.172552] [108/133] (205s left) gem_eio (in-flight-contexts-immediate)
[817.410454] Starting subtest: in-flight-contexts-immediate
[831.101128] Subtest in-flight-contexts-immediate: SUCCESS (13.694s)
[831.246564] [109/133] (191s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[831.351804] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[831.354065] Starting dynamic subtest: pipe-A-eDP-1
[831.378790] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[831.391368] Starting dynamic subtest: pipe-B-eDP-1
[831.412897] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[831.423671] Starting dynamic subtest: pipe-C-eDP-1
[831.445293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[831.455681] Starting dynamic subtest: pipe-D-eDP-1
[831.477693] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[831.481731] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[833.592327] [110/133] (189s left) kms_vrr (lobf)
[833.696519] Starting subtest: lobf
[833.700805] Subtest lobf: SKIP (0.000s)
[833.766111] [111/133] (189s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[833.868212] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[837.976364] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.113s)
[839.104918] [112/133] (183s left) api_intel_allocator (execbuf-with-allocator)
[839.157191] Starting subtest: execbuf-with-allocator
[839.160923] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[839.279138] [113/133] (183s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[839.374514] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[839.376825] Starting dynamic subtest: pipe-A-eDP-1
[840.182032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[840.192168] Starting dynamic subtest: pipe-B-eDP-1
[841.704851] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.521s)
[841.715853] Starting dynamic subtest: pipe-C-eDP-1
[843.207828] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s)
[843.218555] Starting dynamic subtest: pipe-D-eDP-1
[844.736189] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.526s)
[844.738092] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.356s)
[845.926942] [114/133] (177s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[846.035682] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[846.039666] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[846.137048] [115/133] (176s left) gem_ctx_persistence (engines-queued)
[846.201966] Starting subtest: engines-queued
[846.204123] Starting dynamic subtest: rcs0
[846.272751] Dynamic subtest rcs0: SUCCESS (0.070s)
[846.286229] Starting dynamic subtest: bcs0
[846.320892] Dynamic subtest bcs0: SUCCESS (0.046s)
[846.333176] Starting dynamic subtest: vcs0
[848.079875] Dynamic subtest vcs0: SUCCESS (1.756s)
[848.091335] Starting dynamic subtest: vcs1
[850.063687] Dynamic subtest vcs1: SUCCESS (1.981s)
[850.075504] Starting dynamic subtest: vecs0
[852.048153] Dynamic subtest vecs0: SUCCESS (1.980s)
[852.060383] Starting dynamic subtest: ccs0
[852.229367] Dynamic subtest ccs0: SUCCESS (0.180s)
[852.231765] Subtest engines-queued: SUCCESS (6.027s)
[852.341735] [116/133] (170s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[852.456620] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[852.460864] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[852.559107] [117/133] (170s left) kms_psr (fbc-psr2-no-drrs)
[852.648426] Starting subtest: fbc-psr2-no-drrs
[852.650713] Starting dynamic subtest: eDP-1
[852.655065] Dynamic subtest eDP-1: SKIP (0.000s)
[852.659519] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[852.736753] [118/133] (170s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[852.831472] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[852.833682] Starting dynamic subtest: pipe-A
[852.851827] Dynamic subtest pipe-A: SKIP (0.016s)
[852.863633] Starting dynamic subtest: pipe-B
[852.880694] Dynamic subtest pipe-B: SKIP (0.029s)
[852.890915] Starting dynamic subtest: pipe-C
[852.912253] Dynamic subtest pipe-C: SKIP (0.029s)
[852.921887] Starting dynamic subtest: pipe-D
[852.941863] Dynamic subtest pipe-D: SKIP (0.029s)
[852.945998] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.107s)
[853.033386] [119/133] (170s left) kms_color (ctm-0-25)
[853.126504] Starting subtest: ctm-0-25
[853.128365] Starting dynamic subtest: pipe-A-eDP-1
[856.558680] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s)
[856.568634] Starting dynamic subtest: pipe-B-eDP-1
[860.869410] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.304s)
[860.879669] Starting dynamic subtest: pipe-C-eDP-1
[864.875770] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.005s)
[864.885958] Starting dynamic subtest: pipe-D-eDP-1
[868.922619] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.040s)
[868.924530] Subtest ctm-0-25: SUCCESS (15.781s)
[869.753741] [120/133] (153s left) gem_mmap_offset (isolation)
[869.819503] Starting subtest: isolation
[869.837426] Subtest isolation: SUCCESS (0.005s)
[869.927887] [121/133] (153s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[869.990580] Starting subtest: y-tiled-ccs-to-x-tiled
[869.995163] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[870.175706] [122/133] (153s left) gem_pwrite (basic-exhaustion)
[870.228978] Subtest basic-exhaustion: SKIP (0.000s)
[870.285263] [123/133] (153s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[870.348195] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[870.350635] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[870.444919] [124/133] (152s left) kms_chamelium_hpd (dp-hpd)
[870.836478] Subtest dp-hpd: SKIP (0.000s)
[871.667418] [125/133] (151s left) gem_softpin (allocator-nopin-reserve)
[871.736748] Starting subtest: allocator-nopin-reserve
[871.828874] Subtest allocator-nopin-reserve: SUCCESS (0.092s)
[871.950409] [126/133] (151s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[872.017605] Starting subtest: map-fixed-invalidate-overlap-busy
[872.022026] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[872.128858] [127/133] (151s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[872.228500] Starting subtest: 4-tiled-8bpp-rotate-90
[872.249381] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[872.365536] [128/133] (151s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[872.461686] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[872.463889] Starting dynamic subtest: pipe-A-eDP-1
[878.361931] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.899s)
[878.372954] Starting dynamic subtest: pipe-B-eDP-1
[885.012915] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.646s)
[885.015287] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.547s)
[885.905217] [129/133] (137s left) kms_dirtyfb (default-dirtyfb-ioctl)
[885.999597] Starting subtest: default-dirtyfb-ioctl
[886.001799] Starting dynamic subtest: A-eDP-1
[887.587762] Dynamic subtest A-eDP-1: SUCCESS (1.586s)
[887.589960] Subtest default-dirtyfb-ioctl: SUCCESS (1.587s)
[888.424860] [130/133] (135s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[888.524486] Starting subtest: psr-2p-pri-indfb-multidraw
[888.528480] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[888.622583] [131/133] (135s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[888.674758] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[888.731954] [132/133] (135s left) kms_cursor_edge_walk (128x128-right-edge)
[888.826886] Starting subtest: 128x128-right-edge
[888.830073] Starting dynamic subtest: pipe-A-eDP-1
[892.296490] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[892.307357] Starting dynamic subtest: pipe-D-eDP-1
[895.407632] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.107s)
[895.409610] Subtest 128x128-right-edge: SUCCESS (6.579s)
[896.239216] [133/133] (127s left) kms_psr (psr-cursor-plane-move)
[896.340272] Starting subtest: psr-cursor-plane-move
[896.342441] Starting dynamic subtest: eDP-1
[898.006137] Dynamic subtest eDP-1: SUCCESS (1.664s)
[898.008637] Subtest psr-cursor-plane-move: SUCCESS (1.665s)
[898.872526] Closing watchdogs
results: parsing output: 0/ for test: kms_selftest
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_atomic_interruptible
results: parsing output: 6/ for test: prime_self_import
results: parsing output: 7/ for test: kms_atomic
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_addfb_basic
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: prime_mmap
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_ctx_persistence
results: parsing output: 14/ for test: kms_chamelium_frames
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: i915_query
results: parsing output: 23/ for test: core_getclient
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: i915_hangman
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_lmem_swapping
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: gem_flink_basic
results: parsing output: 33/ for test: kms_pipe_crc_basic
results: parsing output: 34/ for test: gem_basic
results: parsing output: 35/ for test: gen9_exec_parse
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: gem_tiled_blits
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_unref_active_buffers
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: kms_plane_lowres
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: gem_exec_parallel
results: parsing output: 53/ for test: prime_vgem
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_ctx_shared
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_feature_discovery
results: parsing output: 61/ for test: gem_exec_capture
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: gem_exec_create
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_hdr
results: parsing output: 67/ for test: fbdev
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: gem_close_race
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: core_getversion
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: prime_vgem
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_properties
results: parsing output: 96/ for test: gem_request_retire
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: gem_exec_flush
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_prop_blob
results: parsing output: 101/ for test: sysfs_preempt_timeout
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: gem_exec_params
results: parsing output: 104/ for test: i915_pm_rpm
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: gem_eio
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_vrr
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_color
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: gem_pwrite
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_chamelium_hpd
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_dirtyfb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: kms_cursor_edge_walk
results: parsing output: 132/ for test: kms_psr
Done.