[56.697734] Initializing watchdogs
[56.697885]   /dev/watchdog0
[56.715079] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[56.719045] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.721043] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.724822] [001/133] (960s left) device_reset (unbind-reset-rebind)
[56.801131] Starting subtest: unbind-reset-rebind
[60.160038] Subtest unbind-reset-rebind: SUCCESS (3.355s)
[60.203845] [002/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[60.310640] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[60.315020] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[60.408128] [003/133] (956s left) gem_partial_pwrite_pread (write-snoop)
[60.463463] Subtest write-snoop: SKIP (0.000s)
[60.534014] [004/133] (956s left) gem_userptr_blits (stress-mm)
[60.597113] Starting subtest: stress-mm
[65.964653] Subtest stress-mm: SUCCESS (5.369s)
[66.084167] [005/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[66.169832] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[66.174366] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[66.266116] [006/133] (951s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[66.338654] Starting subtest: fbc-psr2-cursor-mmap-gtt
[66.340924] Starting dynamic subtest: eDP-1
[66.345141] Dynamic subtest eDP-1: SKIP (0.000s)
[66.349217] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[66.406403] [007/133] (951s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[66.465677] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[66.468030] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[66.558471] [008/133] (950s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[66.634500] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[66.636566] Starting dynamic subtest: pipe-A-eDP-1
[66.657555] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.666607] Starting dynamic subtest: pipe-B-eDP-1
[66.687890] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.695388] Starting dynamic subtest: pipe-C-eDP-1
[66.716072] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.723161] Starting dynamic subtest: pipe-D-eDP-1
[66.743499] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.747356] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[68.856985] [009/133] (948s left) kms_frontbuffer_tracking (psr-slowdraw)
[68.951389] Starting subtest: psr-slowdraw
[94.220810] Subtest psr-slowdraw: SUCCESS (25.273s)
[94.342673] [010/133] (923s left) kms_cursor_crc (cursor-suspend)
[94.468328] Starting subtest: cursor-suspend
[94.470566] Starting dynamic subtest: pipe-A-eDP-1
[127.366291] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.348s)
[127.374896] Starting dynamic subtest: pipe-D-eDP-1
[161.367873] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.839s)
[161.370113] Subtest cursor-suspend: SUCCESS (7.189s)
[162.177950] [011/133] (855s left) gem_ccs (suspend-resume)
[162.248581] Starting subtest: suspend-resume
[162.252993] Subtest suspend-resume: SKIP (0.000s)
[162.389728] [012/133] (855s left) perf (polling)
[162.519761] Starting subtest: polling
[162.522259] Starting dynamic subtest: 0-rcs0
[172.549098] Dynamic subtest 0-rcs0: SUCCESS (10.024s)
[172.561795] Starting dynamic subtest: 1-vcs0
[182.575795] Dynamic subtest 1-vcs0: SUCCESS (10.023s)
[182.578522] Subtest polling: SUCCESS (20.048s)
[182.622753] [013/133] (835s left) gem_mmap_gtt (bad-object)
[182.695581] Subtest bad-object: SKIP (0.000s)
[182.761571] [014/133] (834s left) gem_exec_fence (syncobj-invalid-flags)
[183.208917] Starting subtest: syncobj-invalid-flags
[183.211450] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[184.635294] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[184.638519] [015/133] (833s left) kms_invalid_mode (bad-hsync-start)
[184.731783] Starting subtest: bad-hsync-start
[184.734100] Starting dynamic subtest: pipe-A-eDP-1
[185.016363] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[185.026470] Starting dynamic subtest: pipe-B-eDP-1
[185.028661] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[185.037260] Starting dynamic subtest: pipe-C-eDP-1
[185.039578] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[185.051566] Starting dynamic subtest: pipe-D-eDP-1
[185.054041] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[185.056472] Subtest bad-hsync-start: SUCCESS (0.291s)
[185.835616] [016/133] (832s left) kms_cursor_crc (cursor-random-64x21)
[186.011282] Starting subtest: cursor-random-64x21
[186.054986] Subtest cursor-random-64x21: SKIP (0.039s)
[186.276185] [017/133] (831s left) kms_color (ctm-0-50)
[186.370299] Starting subtest: ctm-0-50
[186.372214] Starting dynamic subtest: pipe-A-eDP-1
[189.924877] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.555s)
[189.933953] Starting dynamic subtest: pipe-B-eDP-1
[194.126457] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.199s)
[194.136266] Starting dynamic subtest: pipe-C-eDP-1
[198.080031] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.953s)
[198.089836] Starting dynamic subtest: pipe-D-eDP-1
[202.064299] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.979s)
[202.066380] Subtest ctm-0-50: SUCCESS (15.689s)
[202.890356] [018/133] (815s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[202.983355] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[209.984118] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.005s)
[210.084744] [019/133] (807s left) gem_softpin (allocator-basic-reserve)
[210.149786] Starting subtest: allocator-basic-reserve
[210.221115] Subtest allocator-basic-reserve: SUCCESS (0.070s)
[210.342086] [020/133] (807s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[210.421001] Subtest writes-after-reads-snoop: SKIP (0.000s)
[210.487788] [021/133] (807s left) kms_psr (fbc-psr-cursor-plane-onoff)
[210.561448] Starting subtest: fbc-psr-cursor-plane-onoff
[210.563635] Starting dynamic subtest: eDP-1
[210.567607] Dynamic subtest eDP-1: SKIP (0.000s)
[210.571571] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[210.635055] [022/133] (807s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[210.693697] Starting subtest: mixed-tiled-to-y-tiled-ccs
[210.698138] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[210.897588] [023/133] (807s left) kms_flip (2x-nonexisting-fb-interruptible)
[210.967656] Starting subtest: 2x-nonexisting-fb-interruptible
[210.976716] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.008s)
[211.052896] [024/133] (807s left) perf_pmu (busy-no-semaphores)
[211.092825] Starting subtest: busy-no-semaphores
[211.095115] Starting dynamic subtest: rcs0
[211.669965] Dynamic subtest rcs0: SUCCESS (0.576s)
[211.682208] Starting dynamic subtest: bcs0
[212.219818] Dynamic subtest bcs0: SUCCESS (0.547s)
[212.231827] Starting dynamic subtest: vcs0
[212.768738] Dynamic subtest vcs0: SUCCESS (0.546s)
[212.780496] Starting dynamic subtest: vcs1
[214.040661] Dynamic subtest vcs1: SUCCESS (1.269s)
[214.053676] Starting dynamic subtest: vecs0
[216.090706] Dynamic subtest vecs0: SUCCESS (2.047s)
[216.101483] Starting dynamic subtest: ccs0
[218.075233] Dynamic subtest ccs0: SUCCESS (1.982s)
[218.078215] Subtest busy-no-semaphores: SUCCESS (6.982s)
[218.192783] [025/133] (800s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[218.296341] Starting subtest: short-busy-flip-before-cursor-toggle
[218.301204] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[218.442600] [026/133] (799s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[218.521712] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[225.689321] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.170s)
[225.805222] [027/133] (792s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[225.887256] Starting subtest: bad-aux-stride-y-tiled-ccs
[225.889457] Starting dynamic subtest: pipe-A-eDP-1
[225.911055] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[225.921577] Starting dynamic subtest: pipe-B-eDP-1
[225.942510] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[225.951299] Starting dynamic subtest: pipe-C-eDP-1
[225.972103] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[225.980668] Starting dynamic subtest: pipe-D-eDP-1
[226.002312] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[226.006365] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[228.165632] [028/133] (790s left) gem_create (create-invalid-size)
[228.217407] Starting subtest: create-invalid-size
[228.219762] Subtest create-invalid-size: SUCCESS (0.000s)
[228.431806] [029/133] (789s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[228.524812] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[228.529206] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[228.642148] [030/133] (789s left) kms_busy (extended-pageflip-hang-newfb)
[228.720455] Starting subtest: extended-pageflip-hang-newfb
[228.722767] Starting dynamic subtest: pipe-A
[255.360564] Dynamic subtest pipe-A: SUCCESS (26.632s)
[255.371061] Starting dynamic subtest: pipe-D
[270.391337] Dynamic subtest pipe-D: SUCCESS (15.034s)
[270.393710] Subtest extended-pageflip-hang-newfb: SUCCESS (41.671s)
[271.239339] [031/133] (747s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[271.314801] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[271.317225] Starting dynamic subtest: pipe-A-default-mode
[272.495229] Dynamic subtest pipe-A-default-mode: SKIP (1.178s)
[272.499081] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.180s)
[272.639650] [032/133] (745s left) kms_addfb_basic (addfb25-modifier-no-flag)
[272.724080] Starting subtest: addfb25-modifier-no-flag
[272.726183] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[272.827204] [033/133] (745s left) gem_exec_balancer (noheartbeat)
[273.090447] Starting subtest: noheartbeat
[273.095841] Subtest noheartbeat: SKIP (0.000s)
[273.189668] [034/133] (745s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[273.259936] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[273.266706] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.008s)
[273.342168] [035/133] (745s left) i915_pm_rpm (system-suspend)
[274.850118] Starting subtest: system-suspend
[292.674795] Subtest system-suspend: SUCCESS (2.882s)
[293.049063] [036/133] (725s left) kms_vblank (ts-continuation-dpms-rpm)
[293.136265] Starting subtest: ts-continuation-dpms-rpm
[293.138557] Starting dynamic subtest: pipe-A-eDP-1
[295.623668] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.483s)
[295.642813] Starting dynamic subtest: pipe-D-eDP-1
[297.790617] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.161s)
[297.792641] Subtest ts-continuation-dpms-rpm: SUCCESS (4.648s)
[298.574306] [037/133] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[298.653824] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[298.658312] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[298.761412] [038/133] (720s left) gem_userptr_blits (process-exit)
[298.826391] Starting subtest: process-exit
[298.831247] Subtest process-exit: SUCCESS (0.009s)
[298.950003] [039/133] (719s left) gem_ctx_persistence (engines-hang)
[299.000530] Starting subtest: engines-hang
[299.002837] Starting dynamic subtest: rcs0
[299.064377] Dynamic subtest rcs0: SUCCESS (0.062s)
[299.076218] Starting dynamic subtest: bcs0
[299.156502] Dynamic subtest bcs0: SUCCESS (0.091s)
[299.168966] Starting dynamic subtest: vcs0
[299.250526] Dynamic subtest vcs0: SUCCESS (0.092s)
[299.262885] Starting dynamic subtest: vcs1
[299.342452] Dynamic subtest vcs1: SUCCESS (0.091s)
[299.355609] Starting dynamic subtest: vecs0
[299.439608] Dynamic subtest vecs0: SUCCESS (0.095s)
[299.452474] Starting dynamic subtest: ccs0
[299.531256] Dynamic subtest ccs0: SUCCESS (0.090s)
[299.533534] Subtest engines-hang: SUCCESS (0.532s)
[299.610254] [040/133] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[299.703865] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[307.165771] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.459s)
[307.290106] [041/133] (711s left) kms_chamelium_color (ctm-0-75)
[307.367722] Subtest ctm-0-75: SKIP (0.000s)
[307.414489] [042/133] (711s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[307.467850] Starting subtest: multi-wait-all-available-submitted-signaled
[307.469998] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[307.566420] [043/133] (711s left) kms_psr (psr-cursor-blt)
[307.636428] Starting subtest: psr-cursor-blt
[307.638557] Starting dynamic subtest: eDP-1
[309.409058] Dynamic subtest eDP-1: SUCCESS (1.770s)
[309.411451] Subtest psr-cursor-blt: SUCCESS (1.771s)
[310.264683] [044/133] (708s left) i915_query (engine-info)
[310.318816] Starting subtest: engine-info
[310.324556] Subtest engine-info: SUCCESS (0.006s)
[310.444482] [045/133] (708s left) kms_pm_rpm (system-suspend-idle)
[312.646230] Starting subtest: system-suspend-idle
[332.100369] Subtest system-suspend-idle: SUCCESS (4.286s)
[332.475026] [046/133] (686s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[332.560770] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[332.562999] Starting dynamic subtest: pipe-A-eDP-1
[349.108248] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.450s)
[349.117966] Starting dynamic subtest: pipe-B-eDP-1
[366.081002] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.465s)
[366.094076] Starting dynamic subtest: pipe-C-eDP-1
[383.059981] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.359s)
[383.069913] Starting dynamic subtest: pipe-D-eDP-1
[400.073087] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.399s)
[400.075242] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.678s)
[401.308637] [047/133] (617s left) gem_exec_async (concurrent-writes)
[401.369933] Starting subtest: concurrent-writes
[401.371777] Starting dynamic subtest: rcs0
[401.384543] Dynamic subtest rcs0: SUCCESS (0.017s)
[401.398358] Starting dynamic subtest: bcs0
[401.400632] Dynamic subtest bcs0: SUCCESS (0.007s)
[401.410622] Starting dynamic subtest: vcs0
[401.413026] Dynamic subtest vcs0: SUCCESS (0.005s)
[401.422762] Starting dynamic subtest: vcs1
[401.424590] Dynamic subtest vcs1: SUCCESS (0.006s)
[401.433741] Starting dynamic subtest: vecs0
[401.435590] Dynamic subtest vecs0: SUCCESS (0.006s)
[401.445026] Starting dynamic subtest: ccs0
[401.446890] Dynamic subtest ccs0: SUCCESS (0.006s)
[401.448825] Subtest concurrent-writes: SUCCESS (0.050s)
[401.651568] [048/133] (617s left) kms_selftest (drm_format)
[401.689054] Starting subtest: drm_format
[401.713212] Starting dynamic subtest: drm_test_format_block_width_invalid
[401.789912] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.076s)
[401.799399] Starting dynamic subtest: drm_test_format_block_width_one_plane
[401.882887] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.092s)
[401.892202] Starting dynamic subtest: drm_test_format_block_width_two_plane
[401.970379] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.085s)
[401.979321] Starting dynamic subtest: drm_test_format_block_width_three_plane
[402.060876] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.089s)
[402.073474] Starting dynamic subtest: drm_test_format_block_width_tiled
[402.154412] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.093s)
[402.166985] Starting dynamic subtest: drm_test_format_block_height_invalid
[402.246478] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.090s)
[402.257048] Starting dynamic subtest: drm_test_format_block_height_one_plane
[402.320399] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.074s)
[402.333166] Starting dynamic subtest: drm_test_format_block_height_two_plane
[402.414674] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.090s)
[402.425052] Starting dynamic subtest: drm_test_format_block_height_three_plane
[402.501570] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.086s)
[402.513138] Starting dynamic subtest: drm_test_format_block_height_tiled
[402.618464] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.117s)
[402.627761] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[402.722030] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.102s)
[402.733677] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[402.821867] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.099s)
[402.832610] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[402.910749] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.088s)
[402.921632] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[403.008784] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.098s)
[403.020533] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[403.100108] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.089s)
[403.111244] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[403.190988] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.090s)
[403.202461] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[403.281778] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.090s)
[403.290914] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[403.386756] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.104s)
[403.388875] Subtest drm_format: SUCCESS (1.697s)
[403.537200] [049/133] (615s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[403.909580] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[404.721729] [050/133] (614s left) gem_mmap_gtt (basic-small-copy-odd)
[404.787439] Subtest basic-small-copy-odd: SKIP (0.000s)
[404.856116] [051/133] (614s left) kms_feature_discovery (psr1)
[404.930010] Starting subtest: psr1
[404.932220] Subtest psr1: SUCCESS (0.000s)
[405.006341] [052/133] (614s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[405.128376] Starting subtest: basic-flip-after-cursor-legacy
[406.056761] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.925s)
[406.892652] [053/133] (612s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[406.966680] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[406.968819] Starting dynamic subtest: pipe-A-eDP-1
[407.448043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[407.457531] Starting dynamic subtest: pipe-B-eDP-1
[408.940702] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s)
[408.951374] Starting dynamic subtest: pipe-C-eDP-1
[410.312508] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[410.325036] Starting dynamic subtest: pipe-D-eDP-1
[411.635557] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[411.637561] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.637s)
[412.817296] [054/133] (606s left) kms_psr (pr-cursor-plane-onoff)
[412.889898] Starting subtest: pr-cursor-plane-onoff
[412.894140] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[412.969362] [055/133] (606s left) gem_ctx_persistence (legacy-engines-persistence)
[413.029504] Starting subtest: legacy-engines-persistence
[413.031395] Starting dynamic subtest: render
[413.829641] Dynamic subtest render: SUCCESS (0.801s)
[413.842820] Starting dynamic subtest: bsd1
[414.578702] Dynamic subtest bsd1: SUCCESS (0.746s)
[414.593411] Starting dynamic subtest: bsd2
[415.349791] Dynamic subtest bsd2: SUCCESS (0.768s)
[415.362617] Starting dynamic subtest: blt
[416.115655] Dynamic subtest blt: SUCCESS (0.763s)
[416.130817] Starting dynamic subtest: vebox
[416.880756] Dynamic subtest vebox: SUCCESS (0.761s)
[416.883276] Subtest legacy-engines-persistence: SUCCESS (3.852s)
[416.965129] [056/133] (602s left) gem_exec_capture (pi)
[417.019410] Starting subtest: pi
[417.021332] Starting dynamic subtest: rcs0
[421.112897] Dynamic subtest rcs0: SUCCESS (4.093s)
[421.127212] Starting dynamic subtest: bcs0
[424.974645] Dynamic subtest bcs0: SUCCESS (3.857s)
[424.987995] Starting dynamic subtest: vcs0
[428.809459] Dynamic subtest vcs0: SUCCESS (3.829s)
[428.831912] Starting dynamic subtest: vcs1
[432.666248] Dynamic subtest vcs1: SUCCESS (3.853s)
[432.676875] Starting dynamic subtest: vecs0
[436.504386] Dynamic subtest vecs0: SUCCESS (3.838s)
[436.514678] Starting dynamic subtest: ccs0
[440.311292] Dynamic subtest ccs0: SUCCESS (3.806s)
[440.314500] Subtest pi: SUCCESS (23.289s)
[440.391795] [057/133] (579s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[440.521264] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[440.525596] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[440.619593] [058/133] (579s left) kms_atomic_interruptible (legacy-setmode)
[440.700313] Starting subtest: legacy-setmode
[440.702510] Starting dynamic subtest: pipe-A-eDP-1
[447.598509] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.896s)
[447.600846] Subtest legacy-setmode: SUCCESS (6.897s)
[448.466876] [059/133] (571s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[448.528476] Starting subtest: y-tiled-ccs-to-y-tiled
[448.532355] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[448.768916] [060/133] (570s left) vgem_slow (nohang)
[448.827034] Starting subtest: nohang
[458.964789] Subtest nohang: SUCCESS (10.136s)
[459.033567] [061/133] (560s left) gem_exec_schedule (pi-ringfull)
[459.216175] Starting subtest: pi-ringfull
[459.218266] Starting dynamic subtest: rcs0
[459.251777] Dynamic subtest rcs0: SUCCESS (0.038s)
[459.262130] Starting dynamic subtest: bcs0
[459.292502] Dynamic subtest bcs0: SUCCESS (0.040s)
[459.302454] Starting dynamic subtest: vcs0
[459.327204] Dynamic subtest vcs0: SUCCESS (0.034s)
[459.337204] Starting dynamic subtest: vcs1
[459.361152] Dynamic subtest vcs1: SUCCESS (0.033s)
[459.375389] Starting dynamic subtest: vecs0
[459.392498] Dynamic subtest vecs0: SUCCESS (0.031s)
[459.406478] Starting dynamic subtest: ccs0
[459.421950] Dynamic subtest ccs0: SUCCESS (0.029s)
[459.424193] Subtest pi-ringfull: SUCCESS (0.209s)
[459.654646] [062/133] (560s left) kms_flip (plain-flip-interruptible)
[459.742845] Starting subtest: plain-flip-interruptible
[459.745187] Starting dynamic subtest: A-eDP1
[461.474780] Dynamic subtest A-eDP1: SUCCESS (1.730s)
[461.487253] Starting dynamic subtest: B-eDP1
[463.105260] Dynamic subtest B-eDP1: SUCCESS (1.629s)
[463.121534] Starting dynamic subtest: C-eDP1
[464.732887] Dynamic subtest C-eDP1: SUCCESS (1.624s)
[464.747377] Starting dynamic subtest: D-eDP1
[466.453143] Dynamic subtest D-eDP1: SUCCESS (1.717s)
[466.458032] Subtest plain-flip-interruptible: SUCCESS (6.713s)
[467.618315] [063/133] (552s left) gem_pxp (create-protected-buffer)
[467.747542] Starting subtest: create-protected-buffer
[467.750050] Subtest create-protected-buffer: SUCCESS (0.000s)
[467.859101] [064/133] (552s left) prime_vgem (fence-read-hang)
[467.942530] Subtest fence-read-hang: SKIP (0.000s)
[468.064583] [065/133] (551s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[468.149740] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[472.537616] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.391s)
[473.723380] [066/133] (546s left) kms_cursor_crc (cursor-onscreen-128x128)
[473.908698] Starting subtest: cursor-onscreen-128x128
[473.910908] Starting dynamic subtest: pipe-A-eDP-1
[476.021364] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s)
[476.049506] Starting dynamic subtest: pipe-D-eDP-1
[478.783444] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.739s)
[478.785762] Subtest cursor-onscreen-128x128: SUCCESS (4.873s)
[479.570306] [067/133] (540s left) gem_readwrite (new-obj)
[479.632246] Subtest new-obj: SKIP (0.000s)
[479.697141] [068/133] (540s left) kms_prop_blob (blob-prop-lifetime)
[479.751346] Starting subtest: blob-prop-lifetime
[479.753691] Subtest blob-prop-lifetime: SUCCESS (0.002s)
[479.859925] [069/133] (540s left) sysfs_heartbeat_interval (idempotent)
[479.928757] Starting subtest: idempotent
[479.931073] Starting dynamic subtest: vecs0
[479.933404] Dynamic subtest vecs0: SUCCESS (0.001s)
[479.944741] Starting dynamic subtest: ccs0
[479.946666] Dynamic subtest ccs0: SUCCESS (0.001s)
[479.955759] Starting dynamic subtest: vcs0
[479.957688] Dynamic subtest vcs0: SUCCESS (0.000s)
[479.967157] Starting dynamic subtest: bcs0
[479.969027] Dynamic subtest bcs0: SUCCESS (0.001s)
[479.978295] Starting dynamic subtest: rcs0
[479.980192] Dynamic subtest rcs0: SUCCESS (0.001s)
[479.989671] Starting dynamic subtest: vcs1
[479.992018] Dynamic subtest vcs1: SUCCESS (0.000s)
[479.994169] Subtest idempotent: SUCCESS (0.007s)
[480.050247] [070/133] (540s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[480.138284] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[480.142249] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[480.230405] [071/133] (539s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[480.282020] Starting subtest: multi-wait-for-submit-submitted-signaled
[480.284307] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[480.388555] [072/133] (539s left) perf (polling-parameterized)
[480.499746] Starting subtest: polling-parameterized
[500.518031] Subtest polling-parameterized: SUCCESS (20.012s)
[500.567494] [073/133] (519s left) kms_pm_dc (dc6-dpms)
[501.652537] Starting subtest: dc6-dpms
[503.739440] Subtest dc6-dpms: SUCCESS (2.087s)
[503.815831] [074/133] (516s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[503.894032] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[503.896385] Starting dynamic subtest: pipe-A-default-mode
[506.640663] Dynamic subtest pipe-A-default-mode: SUCCESS (2.748s)
[506.643151] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.750s)
[507.509312] [075/133] (512s left) kms_lease (simple-lease)
[507.594912] Starting subtest: simple-lease
[507.597333] Starting dynamic subtest: pipe-A-eDP-1
[508.104476] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s)
[508.116868] Starting dynamic subtest: pipe-B-eDP-1
[509.561924] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.455s)
[509.572234] Starting dynamic subtest: pipe-C-eDP-1
[510.955469] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[510.966066] Starting dynamic subtest: pipe-D-eDP-1
[512.363358] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.408s)
[512.365662] Subtest simple-lease: SUCCESS (4.772s)
[513.175604] [076/133] (507s left) gem_eio (throttle)
[513.393605] Starting subtest: throttle
[513.711928] Subtest throttle: SUCCESS (0.319s)
[513.842635] [077/133] (506s left) gem_gpgpu_fill (basic)
[513.897345] Starting subtest: basic
[513.899635] Starting dynamic subtest: smem
[513.904737] Dynamic subtest smem: SUCCESS (0.008s)
[513.907113] Subtest basic: SUCCESS (0.008s)
[514.057206] [078/133] (506s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[514.157204] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[514.160833] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[514.245754] [079/133] (506s left) gem_softpin (evict-active)
[514.310327] Starting subtest: evict-active
[514.316562] Subtest evict-active: SUCCESS (0.006s)
[514.443367] [080/133] (506s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[514.519600] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[515.166525] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[515.319398] [081/133] (505s left) gen9_exec_parse (unaligned-jump)
[515.375296] Subtest unaligned-jump: SKIP (0.000s)
[515.449005] [082/133] (505s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[515.534614] Starting subtest: yf-tiled-32bpp-rotate-0
[515.539139] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[515.635971] [083/133] (505s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[515.717928] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[515.722308] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[515.819568] [084/133] (504s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[515.909544] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[515.913939] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[516.021004] [085/133] (504s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[516.088815] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[516.194863] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[516.284397] [086/133] (504s left) gem_userptr_blits (readonly-unsync)
[516.341680] Subtest readonly-unsync: SKIP (0.000s)
[516.448827] [087/133] (504s left) kms_getfb (getfb2-handle-closed)
[516.524896] Starting subtest: getfb2-handle-closed
[516.527115] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[516.622207] [088/133] (504s left) syncobj_timeline (wait-all-complex)
[516.675993] Starting subtest: wait-all-complex
[516.889461] Subtest wait-all-complex: SUCCESS (0.213s)
[516.971390] [089/133] (504s left) kms_async_flips (test-cursor)
[517.040621] Starting subtest: test-cursor
[517.419110] Starting dynamic subtest: pipe-A-eDP-1
[518.165122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[518.557284] Starting dynamic subtest: pipe-B-eDP-1
[519.298295] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.750s)
[519.667333] Starting dynamic subtest: pipe-C-eDP-1
[520.423112] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[520.796318] Starting dynamic subtest: pipe-D-eDP-1
[521.553240] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[521.555635] Subtest test-cursor: SUCCESS (4.515s)
[522.721854] [090/133] (498s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[522.809267] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[522.813179] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[522.898060] [091/133] (498s left) syncobj_timeline (host-signal-ordered)
[522.953111] Starting subtest: host-signal-ordered
[522.955456] Subtest host-signal-ordered: SUCCESS (0.000s)
[523.050775] [092/133] (498s left) core_getclient (basic)
[523.101031] Starting subtest: basic
[523.102942] Subtest basic: SUCCESS (0.000s)
[523.214546] [093/133] (497s left) i915_hangman (engine-error-state-capture)
[523.282247] Starting subtest: engine-error-state-capture
[523.284457] Starting dynamic subtest: rcs0
[526.484742] Dynamic subtest rcs0: SUCCESS (3.203s)
[526.499025] Starting dynamic subtest: bcs0
[532.436542] Dynamic subtest bcs0: SUCCESS (5.950s)
[532.455015] Starting dynamic subtest: vcs0
[538.388571] Dynamic subtest vcs0: SUCCESS (5.950s)
[538.401147] Starting dynamic subtest: vcs1
[543.380421] Dynamic subtest vcs1: SUCCESS (4.988s)
[543.394024] Starting dynamic subtest: vecs0
[548.373438] Dynamic subtest vecs0: SUCCESS (4.990s)
[548.387133] Starting dynamic subtest: ccs0
[553.429778] Dynamic subtest ccs0: SUCCESS (5.053s)
[553.432846] Subtest engine-error-state-capture: SUCCESS (30.150s)
[553.579295] [094/133] (467s left) tools_test (sysfs_l3_parity)
[553.647701] Starting subtest: sysfs_l3_parity
[553.743252] Subtest sysfs_l3_parity: SKIP (0.107s)
[553.802161] [095/133] (467s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[553.884439] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[553.888514] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[553.998194] [096/133] (467s left) syncobj_wait (multi-wait-for-submit-submitted)
[554.056749] Starting subtest: multi-wait-for-submit-submitted
[554.163046] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s)
[554.241900] [097/133] (467s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[554.324238] Starting subtest: x-tiled-32bpp-rotate-90
[554.348656] Subtest x-tiled-32bpp-rotate-90: SKIP (0.021s)
[554.449154] [098/133] (466s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[554.534014] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[558.418871] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.886s)
[559.621102] [099/133] (461s left) gem_ccs (block-multicopy-compressed)
[559.686207] Starting subtest: block-multicopy-compressed
[559.690946] Subtest block-multicopy-compressed: SKIP (0.000s)
[559.794490] [100/133] (461s left) kms_content_protection (dp-mst-type-1)
[559.903018] Starting subtest: dp-mst-type-1
[559.907638] Subtest dp-mst-type-1: SKIP (0.000s)
[560.032488] [101/133] (461s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[560.388835] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[561.222678] [102/133] (460s left) kms_psr (psr-sprite-blt)
[561.291407] Starting subtest: psr-sprite-blt
[561.293684] Starting dynamic subtest: eDP-1
[563.061396] Dynamic subtest eDP-1: SUCCESS (1.768s)
[563.063701] Subtest psr-sprite-blt: SUCCESS (1.769s)
[563.908837] [103/133] (457s left) gem_partial_pwrite_pread (writes-after-reads)
[563.970650] Subtest writes-after-reads: SKIP (0.000s)
[564.040855] [104/133] (457s left) gem_userptr_blits (mmap-offset-banned)
[564.107849] Starting subtest: mmap-offset-banned
[564.110353] Starting dynamic subtest: wb
[564.112666] Dynamic subtest wb: SUCCESS (0.000s)
[564.125619] Starting dynamic subtest: wc
[564.127526] Dynamic subtest wc: SUCCESS (0.000s)
[564.137369] Starting dynamic subtest: uc
[564.139274] Dynamic subtest uc: SUCCESS (0.000s)
[564.141189] Subtest mmap-offset-banned: SUCCESS (0.003s)
[564.225691] [105/133] (457s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[564.306999] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[565.120074] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[565.297421] [106/133] (456s left) kms_flip (bo-too-big-interruptible)
[565.380942] Starting subtest: bo-too-big-interruptible
[565.387028] Starting dynamic subtest: A-eDP1
[566.638227] Dynamic subtest A-eDP1: SUCCESS (1.250s)
[566.651790] Starting dynamic subtest: B-eDP1
[567.874839] Dynamic subtest B-eDP1: SUCCESS (1.234s)
[567.887621] Starting dynamic subtest: C-eDP1
[569.112392] Dynamic subtest C-eDP1: SUCCESS (1.237s)
[569.124378] Starting dynamic subtest: D-eDP1
[570.450876] Dynamic subtest D-eDP1: SUCCESS (1.337s)
[570.453269] Subtest bo-too-big-interruptible: SUCCESS (5.071s)
[571.667406] [107/133] (450s left) gem_eio (in-flight-internal-10ms)
[571.885355] Starting subtest: in-flight-internal-10ms
[573.554011] Subtest in-flight-internal-10ms: SUCCESS (1.667s)
[573.676428] [108/133] (448s left) gen7_exec_parse (load-register-reg)
[573.746913] Subtest load-register-reg: SKIP (0.000s)
[573.820078] [109/133] (448s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[573.922399] Starting subtest: cursorA-vs-flipA-legacy
[585.041493] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.116s)
[585.905830] [110/133] (435s left) gem_exec_schedule (thriceslice)
[585.978449] Starting subtest: thriceslice
[585.980609] Starting dynamic subtest: rcs0
[585.998121] Dynamic subtest rcs0: SUCCESS (0.031s)
[586.009576] Starting dynamic subtest: bcs0
[586.049937] Dynamic subtest bcs0: SUCCESS (0.051s)
[586.065042] Starting dynamic subtest: vcs0
[586.102892] Dynamic subtest vcs0: SUCCESS (0.050s)
[586.115756] Starting dynamic subtest: vcs1
[586.132394] Dynamic subtest vcs1: SUCCESS (0.028s)
[586.143126] Starting dynamic subtest: vecs0
[586.160350] Dynamic subtest vecs0: SUCCESS (0.027s)
[586.170772] Starting dynamic subtest: ccs0
[586.190064] Dynamic subtest ccs0: SUCCESS (0.029s)
[586.192313] Subtest thriceslice: SUCCESS (0.224s)
[587.551540] [111/133] (434s left) gem_set_tiling_vs_gtt
[587.656914] [112/133] (434s left) gem_exec_schedule (deep)
[587.839996] Starting subtest: deep
[587.842981] Starting dynamic subtest: rcs0
[593.933253] Dynamic subtest rcs0: SKIP (6.089s)
[593.944399] Starting dynamic subtest: vcs0
[604.988900] Dynamic subtest vcs0: SUCCESS (11.054s)
[605.004385] Starting dynamic subtest: vcs1
[616.877712] Dynamic subtest vcs1: SUCCESS (11.885s)
[616.891330] Starting dynamic subtest: vecs0
[628.672253] Dynamic subtest vecs0: SUCCESS (11.792s)
[628.688670] Starting dynamic subtest: ccs0
[641.557037] Dynamic subtest ccs0: SUCCESS (12.883s)
[641.559496] Subtest deep: SUCCESS (53.709s)
[642.516856] [113/133] (379s left) gem_exec_whisper (basic-contexts-forked)
[642.582423] Starting subtest: basic-contexts-forked
[665.925890] Subtest basic-contexts-forked: SUCCESS (23.338s)
[666.109992] [114/133] (355s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[666.165566] Starting subtest: multi-wait-available-unsubmitted-submitted
[666.168034] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[666.268481] [115/133] (355s left) gem_mmap_gtt (isolation)
[666.319478] Subtest isolation: SKIP (0.000s)
[666.381881] [116/133] (355s left) gem_userptr_blits (dmabuf-sync)
[666.444515] Starting subtest: dmabuf-sync
[666.449152] Subtest dmabuf-sync: SKIP (0.002s)
[666.591734] [117/133] (355s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[666.670525] Starting subtest: pr-cursor-plane-update-sf
[666.675040] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[666.742609] [118/133] (355s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[666.823979] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[666.828059] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[666.904027] [119/133] (355s left) gem_exec_reloc (basic-write-read-active)
[666.971264] Subtest basic-write-read-active: SKIP (0.000s)
[667.048877] [120/133] (355s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[667.125795] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[667.129517] Starting dynamic subtest: pipe-A-eDP-1
[678.451532] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.329s)
[678.462476] Starting dynamic subtest: pipe-B-eDP-1
[690.425938] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.969s)
[690.428316] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.301s)
[691.275761] [121/133] (331s left) prime_mmap (test_map_unmap)
[691.336043] Starting subtest: test_map_unmap
[691.338337] Starting dynamic subtest: test_map_unmap-smem
[691.364995] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s)
[691.367579] Subtest test_map_unmap: SUCCESS (0.031s)
[691.462396] [122/133] (330s left) perf_pmu (all-busy-idle-check-all)
[691.506168] Starting subtest: all-busy-idle-check-all
[693.431673] Subtest all-busy-idle-check-all: SUCCESS (1.924s)
[693.544800] [123/133] (328s left) perf (gen12-group-concurrent-oa-buffer-read)
[693.626608] Starting subtest: gen12-group-concurrent-oa-buffer-read
[703.659118] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.029s)
[703.699023] [124/133] (318s left) kms_plane_lowres (tiling-4)
[703.780009] Starting subtest: tiling-4
[703.782133] Starting dynamic subtest: pipe-A-eDP-1
[703.786448] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[704.091212] Starting dynamic subtest: pipe-B-eDP-1
[704.095490] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[704.106124] Starting dynamic subtest: pipe-C-eDP-1
[704.110439] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[704.122341] Starting dynamic subtest: pipe-D-eDP-1
[704.126312] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[704.130175] Subtest tiling-4: SKIP (0.308s)
[704.908375] [125/133] (317s left) kms_properties (plane-properties-legacy)
[704.992006] Starting subtest: plane-properties-legacy
[704.993855] Starting dynamic subtest: pipe-A-eDP-1
[705.569398] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[705.580393] Starting dynamic subtest: pipe-B-eDP-1
[706.903638] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.333s)
[706.914703] Starting dynamic subtest: pipe-C-eDP-1
[708.205793] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[708.216520] Starting dynamic subtest: pipe-D-eDP-1
[709.441938] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[709.444160] Subtest plane-properties-legacy: SUCCESS (4.451s)
[710.241760] [126/133] (312s left) kms_addfb_basic (too-wide)
[710.319891] Starting subtest: too-wide
[710.322090] Subtest too-wide: SUCCESS (0.000s)
[710.424458] [127/133] (312s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[710.480076] Starting subtest: yf-tiled-to-vebox-y-tiled
[710.484437] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[710.677370] [128/133] (311s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[710.748072] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[710.752279] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[710.824450] [129/133] (311s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[710.905910] Starting subtest: addfb25-y-tiled-legacy
[710.907747] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[711.012530] [130/133] (311s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[711.089660] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[711.091848] Starting dynamic subtest: pipe-A
[711.153709] Dynamic subtest pipe-A: SUCCESS (0.065s)
[711.164725] Starting dynamic subtest: pipe-B
[712.272603] Dynamic subtest pipe-B: SUCCESS (1.117s)
[712.285815] Starting dynamic subtest: pipe-C
[713.381624] Dynamic subtest pipe-C: SUCCESS (1.107s)
[713.393840] Starting dynamic subtest: pipe-D
[714.513073] Dynamic subtest pipe-D: SUCCESS (1.131s)
[714.515459] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.424s)
[715.677552] [131/133] (307s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[715.751495] Starting subtest: read-crc-frame-sequence
[715.753815] Starting dynamic subtest: pipe-A-eDP-1
[716.453502] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[716.465471] Starting dynamic subtest: pipe-B-eDP-1
[717.843393] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s)
[717.855621] Starting dynamic subtest: pipe-C-eDP-1
[719.143710] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.299s)
[719.155218] Starting dynamic subtest: pipe-D-eDP-1
[720.458694] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[720.460993] Subtest read-crc-frame-sequence: SUCCESS (4.705s)
[721.296071] [132/133] (301s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[721.384183] Starting subtest: y-tiled-16bpp-rotate-90
[721.388577] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[721.490183] [133/133] (301s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[721.565866] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[728.384979] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.821s)
[728.521059] Closing watchdogs
results: parsing output: 0/ for test: device_reset
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_partial_pwrite_pread
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: gem_ccs
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: kms_invalid_mode
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_softpin
results: parsing output: 19/ for test: gem_partial_pwrite_pread
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_busy
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: i915_pm_rpm
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_chamelium_color
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: i915_query
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_exec_async
results: parsing output: 47/ for test: kms_selftest
results: parsing output: 48/ for test: kms_chamelium_hpd
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_feature_discovery
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: gem_exec_capture
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_atomic_interruptible
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: vgem_slow
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: prime_vgem
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: gem_readwrite
results: parsing output: 67/ for test: kms_prop_blob
results: parsing output: 68/ for test: sysfs_heartbeat_interval
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: kms_pm_dc
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: gem_gpgpu_fill
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gen9_exec_parse
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_getfb
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: core_getclient
results: parsing output: 92/ for test: i915_hangman
results: parsing output: 93/ for test: tools_test
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_ccs
results: parsing output: 99/ for test: kms_content_protection
results: parsing output: 100/ for test: kms_chamelium_edid
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_partial_pwrite_pread
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: gen7_exec_parse
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gem_set_tiling_vs_gtt
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: prime_mmap
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_plane_lowres
results: parsing output: 124/ for test: kms_properties
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_pipe_crc_basic
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.