[57.501102] Initializing watchdogs
[57.501147]   /dev/watchdog0
[57.515848] [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.520222] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.522766] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.525816] [001/132] (960s left) gem_eio (in-flight-10ms)
[57.698349] Starting subtest: in-flight-10ms
[64.648225] Subtest in-flight-10ms: SUCCESS (6.997s)
[64.814999] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[64.818192] [002/132] (953s left) kms_async_flips (test-time-stamp)
[64.910179] Starting subtest: test-time-stamp
[65.296300] Starting dynamic subtest: pipe-A-eDP-1
[66.086559] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s)
[66.477020] Starting dynamic subtest: pipe-B-eDP-1
[67.223199] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.755s)
[67.618683] Starting dynamic subtest: pipe-C-eDP-1
[68.364670] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.753s)
[68.729271] Starting dynamic subtest: pipe-D-eDP-1
[69.492748] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[69.495346] Subtest test-time-stamp: SUCCESS (4.595s)
[70.648186] [003/132] (947s left) prime_mmap (test_aperture_limit)
[70.715928] Starting subtest: test_aperture_limit
[70.718380] Starting dynamic subtest: test_aperture_limit-smem
[70.729097] Dynamic subtest test_aperture_limit-smem: SKIP (0.011s)
[70.733316] Subtest test_aperture_limit: SKIP (0.011s)
[70.799455] [004/132] (947s left) gem_ccs (block-multicopy-inplace)
[70.869724] Starting subtest: block-multicopy-inplace
[70.874194] Subtest block-multicopy-inplace: SKIP (0.000s)
[70.988880] [005/132] (947s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[71.101748] Starting subtest: cursorA-vs-flipB-legacy
[71.106151] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[71.248931] [006/132] (946s left) kms_joiner (basic-big-joiner)
[71.343263] Starting subtest: basic-big-joiner
[71.347623] Subtest basic-big-joiner: SKIP (0.000s)
[71.413847] [007/132] (946s left) gen9_exec_parse (bb-start-far)
[71.480386] Subtest bb-start-far: SKIP (0.000s)
[71.558670] [008/132] (946s left) gem_exec_gttfill (all-engines)
[71.645404] Starting subtest: all-engines
[94.628842] Subtest all-engines: SUCCESS (22.985s)
[94.814629] [009/132] (923s left) prime_mmap (test_dup)
[94.916686] Starting subtest: test_dup
[94.918606] Starting dynamic subtest: test_dup-smem
[94.949445] Dynamic subtest test_dup-smem: SUCCESS (0.034s)
[94.952167] Subtest test_dup: SUCCESS (0.034s)
[95.037179] [010/132] (923s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[95.150049] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[101.773608] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.624s)
[101.886518] [011/132] (916s left) gem_userptr_blits (unsync-unmap)
[101.952241] Subtest unsync-unmap: SKIP (0.000s)
[102.066642] [012/132] (916s left) gem_userptr_blits (stress-purge)
[102.146024] Starting subtest: stress-purge
[107.519215] Subtest stress-purge: SUCCESS (5.376s)
[107.636837] [013/132] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[107.779117] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[107.782886] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[107.915813] [014/132] (910s left) kms_psr (pr-cursor-mmap-gtt)
[108.012129] Starting subtest: pr-cursor-mmap-gtt
[108.015841] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[108.083042] [015/132] (910s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[108.136986] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[108.139126] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[108.235415] [016/132] (910s left) kms_psr (fbc-psr-cursor-plane-onoff)
[108.331187] Starting subtest: fbc-psr-cursor-plane-onoff
[108.332740] Starting dynamic subtest: eDP-1
[108.336097] Dynamic subtest eDP-1: SKIP (0.000s)
[108.339456] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[108.400873] [017/132] (910s left) syncobj_timeline (single-wait-signaled)
[108.459906] Starting subtest: single-wait-signaled
[108.462123] Subtest single-wait-signaled: SUCCESS (0.001s)
[108.559343] [018/132] (910s left) gem_exec_whisper (basic-normal)
[108.615181] Starting subtest: basic-normal
[113.634588] Subtest basic-normal: SUCCESS (5.002s)
[113.854765] [019/132] (904s left) kms_pm_dc (dc6-psr)
[114.960171] Starting subtest: dc6-psr
[117.851099] Subtest dc6-psr: SUCCESS (2.891s)
[118.692652] [020/132] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[118.789667] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[122.879048] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.093s)
[124.020031] [021/132] (894s left) gem_softpin (noreloc-interruptible)
[124.089069] Starting subtest: noreloc-interruptible
[129.562249] Subtest noreloc-interruptible: SUCCESS (5.420s)
[129.622457] [022/132] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[129.719761] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[136.476905] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.760s)
[136.610535] [023/132] (882s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[136.725081] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[137.758346] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.034s)
[137.891942] [024/132] (881s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[137.987044] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[137.989335] Starting dynamic subtest: pipe-A-eDP-1
[138.010557] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[138.020957] Starting dynamic subtest: pipe-B-eDP-1
[138.038561] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[138.046145] Starting dynamic subtest: pipe-C-eDP-1
[138.063642] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[138.071540] Starting dynamic subtest: pipe-D-eDP-1
[138.089156] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[138.092710] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[140.213782] [025/132] (878s left) syncobj_timeline (invalid-wait-bad-flags)
[140.270731] Starting subtest: invalid-wait-bad-flags
[140.272932] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[140.356877] [026/132] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[140.460427] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[140.464675] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[140.578539] [027/132] (878s left) kms_content_protection (legacy-hdcp14)
[140.719903] Starting subtest: legacy-hdcp14
[140.724285] Subtest legacy-hdcp14: SKIP (0.000s)
[140.825484] [028/132] (878s left) kms_plane (pixel-format-x-tiled-modifier)
[140.920314] Starting subtest: pixel-format-x-tiled-modifier
[140.945849] Starting dynamic subtest: pipe-A-plane-0
[141.611927] Dynamic subtest pipe-A-plane-0: SUCCESS (0.667s)
[141.622540] Starting dynamic subtest: pipe-A-plane-3
[142.067407] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[142.078503] Starting dynamic subtest: pipe-A-plane-5
[142.082175] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[143.208027] Starting dynamic subtest: pipe-B-plane-0
[143.855775] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[143.865963] Starting dynamic subtest: pipe-B-plane-3
[144.344233] Dynamic subtest pipe-B-plane-3: SUCCESS (0.488s)
[144.352726] Starting dynamic subtest: pipe-B-plane-5
[144.356384] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[144.653234] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.733s)
[145.500150] [029/132] (873s left) kms_plane (plane-position-covered)
[145.586376] Starting subtest: plane-position-covered
[146.123969] Starting dynamic subtest: pipe-A-plane-1
[147.409138] Dynamic subtest pipe-A-plane-1: SUCCESS (1.285s)
[147.421597] Starting dynamic subtest: pipe-A-plane-2
[148.714884] Dynamic subtest pipe-A-plane-2: SUCCESS (1.303s)
[148.724843] Starting dynamic subtest: pipe-A-plane-3
[150.041662] Dynamic subtest pipe-A-plane-3: SUCCESS (1.326s)
[150.051862] Starting dynamic subtest: pipe-A-plane-4
[151.395436] Dynamic subtest pipe-A-plane-4: SUCCESS (1.353s)
[151.404271] Starting dynamic subtest: pipe-A-plane-5
[151.422054] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[152.629517] Starting dynamic subtest: pipe-B-plane-1
[153.934363] Dynamic subtest pipe-B-plane-1: SUCCESS (1.314s)
[153.946874] Starting dynamic subtest: pipe-B-plane-2
[155.279799] Dynamic subtest pipe-B-plane-2: SUCCESS (1.344s)
[155.290048] Starting dynamic subtest: pipe-B-plane-3
[156.622153] Dynamic subtest pipe-B-plane-3: SUCCESS (1.344s)
[156.634679] Starting dynamic subtest: pipe-B-plane-4
[157.957500] Dynamic subtest pipe-B-plane-4: SUCCESS (1.333s)
[157.966328] Starting dynamic subtest: pipe-B-plane-5
[157.994142] Dynamic subtest pipe-B-plane-5: SUCCESS (0.034s)
[157.996518] Subtest plane-position-covered: SUCCESS (12.406s)
[158.805934] [030/132] (860s left) kms_color (invalid-degamma-lut-sizes)
[158.893085] Starting subtest: invalid-degamma-lut-sizes
[158.895372] Starting dynamic subtest: pipe-A
[159.182513] Dynamic subtest pipe-A: SUCCESS (0.291s)
[159.192434] Starting dynamic subtest: pipe-B
[159.194729] Dynamic subtest pipe-B: SUCCESS (0.000s)
[159.202865] Starting dynamic subtest: pipe-C
[159.205125] Dynamic subtest pipe-C: SUCCESS (0.000s)
[159.213623] Starting dynamic subtest: pipe-D
[159.215890] Dynamic subtest pipe-D: SUCCESS (0.000s)
[159.218157] Subtest invalid-degamma-lut-sizes: SUCCESS (0.294s)
[160.033450] [031/132] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[160.140979] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[164.619815] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.482s)
[165.757658] [032/132] (853s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[165.886849] Starting subtest: cursorB-vs-flipB-atomic-transitions
[165.891428] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[166.044544] [033/132] (853s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[166.152263] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[166.237356] [034/132] (853s left) kms_cursor_edge_walk (256x256-top-bottom)
[166.345150] Starting subtest: 256x256-top-bottom
[166.347411] Starting dynamic subtest: pipe-A-eDP-1
[169.807499] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.460s)
[169.822879] Starting dynamic subtest: pipe-D-eDP-1
[172.933117] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[172.935350] Subtest 256x256-top-bottom: SUCCESS (6.587s)
[173.736761] [035/132] (845s left) api_intel_allocator (gem-pool)
[173.807293] Starting subtest: gem-pool
[173.815636] Subtest gem-pool: SUCCESS (0.010s)
[173.930017] [036/132] (845s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[174.026483] Starting subtest: 2x-absolute-wf_vblank-interruptible
[174.038760] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[174.113095] [037/132] (845s left) kms_psr (psr-sprite-blt)
[174.210887] Starting subtest: psr-sprite-blt
[174.213190] Starting dynamic subtest: eDP-1
[175.968725] Dynamic subtest eDP-1: SUCCESS (1.757s)
[175.970677] Subtest psr-sprite-blt: SUCCESS (1.758s)
[176.813864] [038/132] (842s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[176.906797] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[176.911053] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[176.975612] [039/132] (842s left) i915_pm_rps (thresholds-park)
[177.038128] Starting subtest: thresholds-park
[177.042447] Subtest thresholds-park: SKIP (0.001s)
[177.133354] [040/132] (842s left) core_getversion (all-cards)
[177.168692] Starting subtest: all-cards
[177.176411] Subtest all-cards: SUCCESS (0.011s)
[177.217024] [041/132] (842s left) gem_ctx_exec (basic-norecovery)
[177.289090] Starting subtest: basic-norecovery
[177.656085] Subtest basic-norecovery: SUCCESS (0.366s)
[177.760553] [042/132] (842s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[177.910113] Starting subtest: cursor-rapid-movement-32x32
[177.954755] Subtest cursor-rapid-movement-32x32: SKIP (0.043s)
[178.260943] [043/132] (841s left) kms_setmode (invalid-clone-single-crtc-stealing)
[178.315322] Starting subtest: invalid-clone-single-crtc-stealing
[178.320438] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[178.445759] [044/132] (841s left) kms_flip (2x-flip-vs-expired-vblank)
[178.539453] Starting subtest: 2x-flip-vs-expired-vblank
[178.551636] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[178.626426] [045/132] (841s left) gem_mmap_gtt (isolation)
[178.678495] Subtest isolation: SKIP (0.000s)
[178.743235] [046/132] (841s left) gem_close (many-handles-one-vma)
[178.793098] Starting subtest: many-handles-one-vma
[178.817599] Subtest many-handles-one-vma: SUCCESS (0.025s)
[178.927773] [047/132] (841s left) gem_workarounds (suspend-resume)
[178.988687] Starting subtest: suspend-resume
[195.731958] Subtest suspend-resume: SUCCESS (1.680s)
[205.939077] [048/132] (824s left) perf (i915-ref-count)
[206.049013] Starting subtest: i915-ref-count
[206.119073] Subtest i915-ref-count: SUCCESS (0.069s)
[206.176506] [049/132] (823s left) kms_flip (blocking-wf_vblank)
[206.285063] Starting subtest: blocking-wf_vblank
[206.287338] Starting dynamic subtest: A-eDP1
[227.661394] Dynamic subtest A-eDP1: FAIL (21.502s)
[227.672474] Starting dynamic subtest: B-eDP1
[236.388913] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[236.401356] Starting dynamic subtest: C-eDP1
[245.324200] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[245.335726] Starting dynamic subtest: D-eDP1
[254.248345] Dynamic subtest D-eDP1: SUCCESS (8.920s)
[254.251131] Subtest blocking-wf_vblank: FAIL (48.276s)
[255.437459] [050/132] (774s left) kms_plane_multiple (tiling-yf)
[255.535409] Starting subtest: tiling-yf
[255.539375] Subtest tiling-yf: SKIP (0.000s)
[255.608238] [051/132] (774s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[255.708747] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[256.354958] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[256.513196] [052/132] (773s left) kms_addfb_basic (bad-pitch-256)
[256.578560] Starting subtest: bad-pitch-256
[256.580412] Subtest bad-pitch-256: SUCCESS (0.000s)
[256.710150] [053/132] (773s left) kms_addfb_basic (unused-handle)
[256.766346] Starting subtest: unused-handle
[256.768539] Subtest unused-handle: SUCCESS (0.000s)
[256.900269] [054/132] (773s left) sysfs_timeslice_duration (invalid)
[256.946856] Starting subtest: invalid
[256.949099] Starting dynamic subtest: vecs0
[256.951402] Dynamic subtest vecs0: SUCCESS (0.000s)
[256.962121] Starting dynamic subtest: ccs0
[256.963943] Dynamic subtest ccs0: SUCCESS (0.000s)
[256.973073] Starting dynamic subtest: vcs0
[256.975346] Dynamic subtest vcs0: SUCCESS (0.000s)
[256.984369] Starting dynamic subtest: bcs0
[256.986452] Dynamic subtest bcs0: SUCCESS (0.000s)
[256.995474] Starting dynamic subtest: rcs0
[256.997279] Dynamic subtest rcs0: SUCCESS (0.000s)
[257.006319] Starting dynamic subtest: vcs1
[257.008389] Dynamic subtest vcs1: SUCCESS (0.000s)
[257.010490] Subtest invalid: SUCCESS (0.006s)
[257.070277] [055/132] (773s left) gem_exec_fence (submit-chain)
[257.249676] Starting subtest: submit-chain
[257.268391] Subtest submit-chain: SUCCESS (0.018s)
[259.068008] [056/132] (771s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[259.162059] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[259.164381] Starting dynamic subtest: pipe-A-eDP-1
[259.376570] Dynamic subtest pipe-A-eDP-1: SKIP (0.212s)
[259.388240] Starting dynamic subtest: pipe-B-eDP-1
[260.609380] Dynamic subtest pipe-B-eDP-1: SKIP (1.230s)
[260.613547] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.449s)
[261.936532] [057/132] (768s left) gem_exec_balancer (parallel-keep-submit-fence)
[262.190594] Starting subtest: parallel-keep-submit-fence
[263.389241] Subtest parallel-keep-submit-fence: SUCCESS (1.199s)
[263.487599] [058/132] (767s left) kms_feature_discovery (psr1)
[263.576359] Starting subtest: psr1
[263.578566] Subtest psr1: SUCCESS (0.000s)
[263.649586] [059/132] (766s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[263.698190] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[263.700526] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[263.792721] [060/132] (766s left) gem_mmap_gtt (coherency)
[263.841137] Subtest coherency: SKIP (0.000s)
[263.903376] [061/132] (766s left) perf_pmu (busy-hang)
[263.942485] Starting subtest: busy-hang
[263.944715] Starting dynamic subtest: rcs0
[265.205237] Dynamic subtest rcs0: SUCCESS (1.266s)
[265.217017] Starting dynamic subtest: bcs0
[266.459454] Dynamic subtest bcs0: SUCCESS (1.249s)
[266.470837] Starting dynamic subtest: vcs0
[268.465695] Dynamic subtest vcs0: SUCCESS (2.008s)
[268.477943] Starting dynamic subtest: vcs1
[270.514210] Dynamic subtest vcs1: SUCCESS (2.047s)
[270.526245] Starting dynamic subtest: vecs0
[272.488548] Dynamic subtest vecs0: SUCCESS (1.973s)
[272.500814] Starting dynamic subtest: ccs0
[273.737851] Dynamic subtest ccs0: SUCCESS (1.245s)
[273.740227] Subtest busy-hang: SUCCESS (9.798s)
[273.828763] [062/132] (756s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[273.921299] Starting subtest: bad-pixel-format-yf-tiled-ccs
[273.923709] Starting dynamic subtest: pipe-A-eDP-1
[273.946738] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[273.957681] Starting dynamic subtest: pipe-B-eDP-1
[273.979165] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[273.988252] Starting dynamic subtest: pipe-C-eDP-1
[274.009491] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[274.018106] Starting dynamic subtest: pipe-D-eDP-1
[274.038755] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[274.042885] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[276.167764] [063/132] (754s left) gem_softpin (zero)
[276.223539] Starting subtest: zero
[276.227934] Subtest zero: SUCCESS (0.004s)
[276.337330] [064/132] (754s left) kms_lease (simple-lease)
[276.449408] Starting subtest: simple-lease
[276.451664] Starting dynamic subtest: pipe-A-eDP-1
[276.957718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s)
[276.968201] Starting dynamic subtest: pipe-B-eDP-1
[278.412111] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.454s)
[278.421920] Starting dynamic subtest: pipe-C-eDP-1
[279.810729] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[279.820299] Starting dynamic subtest: pipe-D-eDP-1
[281.203027] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.392s)
[281.205183] Subtest simple-lease: SUCCESS (4.757s)
[282.012831] [065/132] (748s left) i915_drm_fdinfo (busy)
[282.058821] Starting subtest: busy
[282.061118] Starting dynamic subtest: rcs0
[282.087129] Dynamic subtest rcs0: SKIP (0.028s)
[282.098383] Starting dynamic subtest: bcs0
[282.102557] Dynamic subtest bcs0: SKIP (0.000s)
[282.111429] Starting dynamic subtest: vcs0
[282.115553] Dynamic subtest vcs0: SKIP (0.000s)
[282.124373] Starting dynamic subtest: vcs1
[282.128372] Dynamic subtest vcs1: SKIP (0.000s)
[282.136984] Starting dynamic subtest: vecs0
[282.140995] Dynamic subtest vecs0: SKIP (0.000s)
[282.149425] Starting dynamic subtest: ccs0
[282.153393] Dynamic subtest ccs0: SKIP (0.000s)
[282.157349] Subtest busy: SKIP (0.033s)
[282.194794] [066/132] (748s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[282.290913] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[282.293169] Starting dynamic subtest: pipe-A-eDP-1
[289.154752] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.866s)
[289.164997] Starting dynamic subtest: pipe-B-eDP-1
[296.347387] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.195s)
[296.349593] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.064s)
[297.232034] [067/132] (733s left) gem_exec_schedule (u-fairslice-all)
[297.309124] Starting subtest: u-fairslice-all
[299.413074] Subtest u-fairslice-all: SUCCESS (2.055s)
[299.667071] [068/132] (731s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[299.765888] Starting subtest: y-tiled-16bpp-rotate-180
[299.770369] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[299.867927] [069/132] (731s left) prime_busy (hang)
[299.931922] Starting subtest: hang
[299.934116] Starting dynamic subtest: rcs0
[326.482810] Dynamic subtest rcs0: SUCCESS (26.531s)
[326.494772] Starting dynamic subtest: bcs0
[333.632483] Dynamic subtest bcs0: SUCCESS (7.146s)
[333.648090] Starting dynamic subtest: vcs0
[340.598384] Dynamic subtest vcs0: SUCCESS (6.976s)
[340.608023] Starting dynamic subtest: vcs1
[347.647506] Dynamic subtest vcs1: SUCCESS (7.036s)
[347.660260] Starting dynamic subtest: vecs0
[354.614102] Dynamic subtest vecs0: SUCCESS (6.977s)
[354.623233] Starting dynamic subtest: ccs0
[368.522845] Dynamic subtest ccs0: SUCCESS (13.900s)
[368.525165] Subtest hang: SUCCESS (68.573s)
[368.631215] [070/132] (662s left) kms_vblank (crtc-id)
[368.738346] Starting subtest: crtc-id
[368.740201] Starting dynamic subtest: pipe-A-eDP-1
[369.181186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[369.195919] Starting dynamic subtest: pipe-D-eDP-1
[370.341682] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.161s)
[370.343972] Subtest crtc-id: SUCCESS (1.606s)
[371.194816] [071/132] (659s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[371.290602] Starting subtest: drrs-dirtyfb-ioctl
[371.303690] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[371.383995] [072/132] (659s left) gem_softpin (evict-active-interruptible)
[371.447544] Starting subtest: evict-active-interruptible
[371.450030] Subtest evict-active-interruptible: SUCCESS (0.006s)
[371.562805] [073/132] (659s left) gem_ctx_persistence (legacy-engines-cleanup)
[371.617621] Starting subtest: legacy-engines-cleanup
[371.619813] Starting dynamic subtest: render
[371.692295] Dynamic subtest render: SUCCESS (0.074s)
[371.705193] Starting dynamic subtest: bsd1
[371.711567] Dynamic subtest bsd1: SUCCESS (0.017s)
[371.720755] Starting dynamic subtest: bsd2
[371.773031] Dynamic subtest bsd2: SUCCESS (0.060s)
[371.784344] Starting dynamic subtest: blt
[371.810680] Dynamic subtest blt: SUCCESS (0.035s)
[371.823274] Starting dynamic subtest: vebox
[371.843653] Dynamic subtest vebox: SUCCESS (0.030s)
[371.845898] Subtest legacy-engines-cleanup: SUCCESS (0.227s)
[371.934585] [074/132] (659s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[372.032588] Starting subtest: x-tiled-8bpp-rotate-180
[373.278828] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.247s)
[373.404929] [075/132] (657s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[373.497275] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[377.455079] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.961s)
[378.582417] [076/132] (652s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[378.642947] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[378.749794] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[378.829578] [077/132] (652s left) kms_vblank (ts-continuation-idle-hang)
[378.928399] Starting subtest: ts-continuation-idle-hang
[378.930586] Starting dynamic subtest: pipe-A-eDP-1
[405.806185] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.881s)
[405.823099] Starting dynamic subtest: pipe-D-eDP-1
[420.769551] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.964s)
[420.771768] Subtest ts-continuation-idle-hang: SUCCESS (41.850s)
[421.624133] [078/132] (609s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[421.724765] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[421.728813] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[421.821386] [079/132] (609s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[421.909631] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[421.911931] Starting dynamic subtest: pipe-A-default-mode
[424.688831] Dynamic subtest pipe-A-default-mode: SUCCESS (2.780s)
[424.691286] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.782s)
[425.525065] [080/132] (605s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[425.620793] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[425.623109] Starting dynamic subtest: pipe-A
[425.956473] Dynamic subtest pipe-A: SUCCESS (0.338s)
[425.968980] Starting dynamic subtest: pipe-B
[427.328223] Dynamic subtest pipe-B: SUCCESS (1.371s)
[427.339175] Starting dynamic subtest: pipe-C
[428.760722] Dynamic subtest pipe-C: SUCCESS (1.431s)
[428.770768] Starting dynamic subtest: pipe-D
[430.197549] Dynamic subtest pipe-D: SUCCESS (1.435s)
[430.200070] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.580s)
[431.385692] [081/132] (600s left) syncobj_basic (bad-pad-handle-to-fd)
[431.449146] Starting subtest: bad-pad-handle-to-fd
[431.451119] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[431.544070] [082/132] (600s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[431.598159] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[431.702743] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[431.792692] [083/132] (599s left) gem_lmem_swapping (parallel-random-verify-ccs)
[431.836816] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[431.878785] [084/132] (599s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[432.268058] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[433.077672] [085/132] (598s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[433.178456] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[440.709210] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.532s)
[440.836938] [086/132] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[440.938416] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[440.942606] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[441.023839] [087/132] (590s left) core_auth (getclient-simple)
[441.065133] Starting subtest: getclient-simple
[441.095347] Subtest getclient-simple: SUCCESS (0.030s)
[441.221173] [088/132] (590s left) kms_cursor_crc (cursor-offscreen-256x256)
[441.452833] Starting subtest: cursor-offscreen-256x256
[441.454962] Starting dynamic subtest: pipe-A-eDP-1
[443.410575] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.955s)
[443.448883] Starting dynamic subtest: pipe-D-eDP-1
[446.052807] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[446.055176] Subtest cursor-offscreen-256x256: SUCCESS (4.600s)
[446.896494] [089/132] (584s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[446.955468] Starting subtest: multi-wait-for-submit-unsubmitted
[447.062358] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[447.139870] [090/132] (584s left) i915_pm_freq_api (freq-basic-api)
[447.204099] Starting subtest: freq-basic-api
[447.206621] Starting dynamic subtest: gt0
[447.208986] Dynamic subtest gt0: SUCCESS (0.003s)
[447.221594] Starting dynamic subtest: gt1
[447.223764] Dynamic subtest gt1: SUCCESS (0.003s)
[447.225945] Subtest freq-basic-api: SUCCESS (0.007s)
[447.312682] [091/132] (584s left) gem_render_copy (y-tiled-ccs-to-linear)
[447.364447] Starting subtest: y-tiled-ccs-to-linear
[447.368679] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[447.550657] [092/132] (584s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[447.649736] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[447.652051] Starting dynamic subtest: pipe-A-eDP-1
[447.661395] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[447.672267] Starting dynamic subtest: pipe-B-eDP-1
[447.681590] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[447.691524] Starting dynamic subtest: pipe-C-eDP-1
[447.700016] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[447.709562] Starting dynamic subtest: pipe-D-eDP-1
[447.718003] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[447.722178] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[449.954843] [093/132] (582s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[450.049933] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[450.054368] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[450.147992] [094/132] (581s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[450.249731] Starting subtest: yf-tiled-8bpp-rotate-0
[450.254117] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[450.344098] [095/132] (581s left) gem_exec_balancer (bonded-sync)
[450.416120] Starting subtest: bonded-sync
[450.420060] Subtest bonded-sync: SKIP (0.000s)
[450.721826] [096/132] (581s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[450.798973] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[450.803712] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[450.983089] [097/132] (581s left) kms_vrr (lobf)
[451.076651] Starting subtest: lobf
[451.080663] Subtest lobf: SKIP (0.000s)
[451.148279] [098/132] (581s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[451.241944] Starting subtest: extended-modeset-hang-oldfb-with-reset
[451.244310] Starting dynamic subtest: pipe-A
[463.029229] Dynamic subtest pipe-A: SUCCESS (11.781s)
[463.040184] Starting dynamic subtest: pipe-D
[475.317154] Dynamic subtest pipe-D: SUCCESS (12.286s)
[475.319653] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.071s)
[476.121795] [099/132] (556s left) gem_pxp (reject-modify-context-protection-on)
[476.258915] Starting subtest: reject-modify-context-protection-on
[476.261464] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[476.376427] [100/132] (555s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[476.473660] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[476.478140] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[476.572135] [101/132] (555s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[476.991162] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[477.887065] [102/132] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[478.009968] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[478.014388] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[478.106121] [103/132] (554s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[478.207203] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[478.209380] Starting dynamic subtest: pipe-A-eDP-1
[478.265813] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[478.275103] Starting dynamic subtest: pipe-B-eDP-1
[478.331426] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[478.342595] Starting dynamic subtest: pipe-C-eDP-1
[478.398555] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[478.408967] Starting dynamic subtest: pipe-D-eDP-1
[478.465234] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[478.469768] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[480.548143] [104/132] (552s left) syncobj_wait (invalid-signal-one-illegal-handle)
[480.600810] Starting subtest: invalid-signal-one-illegal-handle
[480.602789] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[480.697191] [105/132] (551s left) kms_pm_rpm (modeset-non-lpsp-stress)
[482.219836] Starting subtest: modeset-non-lpsp-stress
[483.383957] Subtest modeset-non-lpsp-stress: SKIP (1.162s)
[483.754998] [106/132] (548s left) kms_atomic_transition (plane-all-transition)
[483.840544] Starting subtest: plane-all-transition
[483.842814] Starting dynamic subtest: pipe-A-eDP-1
[486.334067] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[486.643895] Starting dynamic subtest: pipe-B-eDP-1
[489.882530] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.250s)
[490.179186] Subtest plane-all-transition: SUCCESS (6.340s)
[491.015247] [107/132] (541s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[491.110264] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[491.112436] Starting dynamic subtest: pipe-A-default-mode
[492.272832] Dynamic subtest pipe-A-default-mode: SKIP (1.161s)
[492.277300] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.163s)
[492.419691] [108/132] (540s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[492.514079] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[499.325829] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.814s)
[499.465741] [109/132] (533s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[499.564137] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[499.568366] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[499.680967] [110/132] (533s left) kms_psr (fbc-psr2-dpms)
[499.781482] Starting subtest: fbc-psr2-dpms
[499.783784] Starting dynamic subtest: eDP-1
[499.787908] Dynamic subtest eDP-1: SKIP (0.000s)
[499.792084] Subtest fbc-psr2-dpms: SKIP (0.001s)
[499.856133] [111/132] (533s left) i915_pm_rps (fence-order)
[499.904131] Starting subtest: fence-order
[503.322869] Subtest fence-order: SUCCESS (3.417s)
[503.453813] [112/132] (529s left) kms_plane_alpha_blend (constant-alpha-mid)
[503.557243] Starting subtest: constant-alpha-mid
[503.853439] Starting dynamic subtest: pipe-A-eDP-1
[504.705193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s)
[504.716158] Starting dynamic subtest: pipe-D-eDP-1
[506.213451] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.504s)
[506.215792] Subtest constant-alpha-mid: SUCCESS (2.656s)
[507.047768] [113/132] (525s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[507.143311] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[507.145462] Starting dynamic subtest: pipe-A-eDP-1
[507.887182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[507.898537] Starting dynamic subtest: pipe-B-eDP-1
[509.663468] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.775s)
[509.673342] Starting dynamic subtest: pipe-C-eDP-1
[511.491539] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.827s)
[511.501038] Starting dynamic subtest: pipe-D-eDP-1
[513.330745] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.837s)
[513.332748] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.181s)
[514.470495] [114/132] (518s left) kms_psr (psr2-sprite-plane-onoff)
[514.567470] Starting subtest: psr2-sprite-plane-onoff
[514.569852] Starting dynamic subtest: eDP-1
[516.291183] Dynamic subtest eDP-1: SUCCESS (1.722s)
[516.293394] Subtest psr2-sprite-plane-onoff: SUCCESS (1.723s)
[517.136250] [115/132] (515s left) gem_create (create-ext-placement-each)
[517.309227] Starting subtest: create-ext-placement-each
[517.311773] Subtest create-ext-placement-each: SUCCESS (0.000s)
[517.431910] [116/132] (515s left) gem_fenced_exec_thrash (no-spare-fences)
[517.498116] Subtest no-spare-fences: SKIP (0.000s)
[517.573063] [117/132] (515s left) gem_eio (in-flight-internal-immediate)
[517.770425] Starting subtest: in-flight-internal-immediate
[519.017745] Subtest in-flight-internal-immediate: SUCCESS (1.250s)
[519.173444] [118/132] (514s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[519.280716] Starting subtest: psr-2p-primscrn-cur-indfb-move
[519.284769] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[519.381807] [119/132] (513s left) kms_big_fb (linear-8bpp-rotate-270)
[519.480568] Starting subtest: linear-8bpp-rotate-270
[519.501563] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[519.613914] [120/132] (513s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[519.701877] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[519.704127] Starting dynamic subtest: A-eDP1
[523.254144] Dynamic subtest A-eDP1: SUCCESS (3.551s)
[523.265262] Starting dynamic subtest: B-eDP1
[526.489282] Dynamic subtest B-eDP1: SUCCESS (3.233s)
[526.499530] Starting dynamic subtest: C-eDP1
[529.663735] Dynamic subtest C-eDP1: SUCCESS (3.173s)
[529.675254] Starting dynamic subtest: D-eDP1
[532.781841] Dynamic subtest D-eDP1: SUCCESS (3.118s)
[532.784275] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.083s)
[533.592785] [121/132] (499s left) gem_mmap_gtt (basic-write)
[533.654846] Subtest basic-write: SKIP (0.000s)
[533.714618] [122/132] (499s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[533.833816] Starting subtest: cursorB-vs-flipA-atomic-transitions
[533.838544] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[534.002736] [123/132] (499s left) kms_frontbuffer_tracking (psr-slowdraw)
[534.100005] Starting subtest: psr-slowdraw
[559.316872] Subtest psr-slowdraw: SUCCESS (25.221s)
[559.448419] [124/132] (474s left) gem_exec_schedule (pi-ringfull)
[559.627433] Starting subtest: pi-ringfull
[559.629829] Starting dynamic subtest: rcs0
[559.661343] Dynamic subtest rcs0: SUCCESS (0.037s)
[559.676694] Starting dynamic subtest: bcs0
[559.693425] Dynamic subtest bcs0: SUCCESS (0.031s)
[559.707002] Starting dynamic subtest: vcs0
[559.725535] Dynamic subtest vcs0: SUCCESS (0.031s)
[559.739729] Starting dynamic subtest: vcs1
[559.755387] Dynamic subtest vcs1: SUCCESS (0.029s)
[559.769715] Starting dynamic subtest: vecs0
[559.784387] Dynamic subtest vecs0: SUCCESS (0.028s)
[559.799419] Starting dynamic subtest: ccs0
[559.812061] Dynamic subtest ccs0: SUCCESS (0.027s)
[559.814200] Subtest pi-ringfull: SUCCESS (0.189s)
[560.047940] [125/132] (473s left) i915_query (query-topology-unsupported)
[560.101884] Starting subtest: query-topology-unsupported
[560.106125] Subtest query-topology-unsupported: SKIP (0.000s)
[560.216580] [126/132] (473s left) gem_exec_whisper (basic-queues-forked)
[560.275102] Starting subtest: basic-queues-forked
[583.314800] Subtest basic-queues-forked: SUCCESS (23.039s)
[583.501799] [127/132] (450s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[583.612607] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[583.616833] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[583.716752] [128/132] (449s left) gem_sync (basic-store-all)
[583.779631] Starting subtest: basic-store-all
[587.993134] Subtest basic-store-all: SUCCESS (4.224s)
[588.181751] [129/132] (445s left) gem_ctx_shared (detached-shared-gtt)
[588.250984] Starting subtest: detached-shared-gtt
[590.454779] Subtest detached-shared-gtt: SUCCESS (2.152s)
[590.697374] [130/132] (443s left) kms_selftest (drm_framebuffer)
[590.742023] Starting subtest: drm_framebuffer
[590.768023] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[590.873902] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.106s)
[590.884173] Starting dynamic subtest: drm_test_framebuffer_cleanup
[590.988961] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.112s)
[591.001136] Starting dynamic subtest: drm_test_framebuffer_create
[591.213736] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.225s)
[591.225126] Starting dynamic subtest: drm_test_framebuffer_free
[591.411220] Dynamic subtest drm_test_framebuffer_free: FAIL (0.135s)
[591.415480] Subtest drm_framebuffer: FAIL (0.607s)
[591.505285] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[591.524008] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[591.525084] Closing watchdogs
results: parsing output: 0/ for test: gem_eio
results: parsing output: 1/ for test: kms_async_flips
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: gem_ccs
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_joiner
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: gem_exec_gttfill
results: parsing output: 8/ for test: prime_mmap
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: kms_pm_dc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_softpin
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: kms_color
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_cursor_edge_walk
results: parsing output: 34/ for test: api_intel_allocator
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: core_getversion
results: parsing output: 40/ for test: gem_ctx_exec
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_setmode
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: gem_close
results: parsing output: 46/ for test: gem_workarounds
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: sysfs_timeslice_duration
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_feature_discovery
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_softpin
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: prime_busy
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_dirtyfb
results: parsing output: 71/ for test: gem_softpin
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: syncobj_basic
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_lmem_swapping
results: parsing output: 83/ for test: kms_chamelium_edid
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: core_auth
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: i915_pm_freq_api
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: kms_vrr
results: parsing output: 97/ for test: kms_busy
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_chamelium_hpd
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_pm_rpm
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: i915_pm_rps
results: parsing output: 111/ for test: kms_plane_alpha_blend
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: gem_fenced_exec_thrash
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: i915_query
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_sync
results: parsing output: 128/ for test: gem_ctx_shared
results: parsing output: 129/ for test: kms_selftest
results: parsing output: 130/ for test: gem_pread
results: no output, setting notrun
results: parsing output: 131/ for test: gem_fenced_exec_thrash
results: no output, setting notrun
Done.