[71.298860] Initializing watchdogs
[71.299027]   /dev/watchdog0
[71.342130] [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]
[71.363735] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.371452] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.376248] [001/130] (960s left) gem_softpin (allocator-fork)
[71.550375] Starting subtest: allocator-fork
[73.853066] Subtest allocator-fork: SUCCESS (2.228s)
[73.933720] [002/130] (957s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[74.044442] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[74.885742] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[75.086221] [003/130] (956s left) kms_properties (plane-properties-legacy)
[75.180984] Starting subtest: plane-properties-legacy
[75.183452] Starting dynamic subtest: pipe-A-eDP-1
[75.730633] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[75.739079] Starting dynamic subtest: pipe-B-eDP-1
[77.044392] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.302s)
[77.053682] Starting dynamic subtest: pipe-C-eDP-1
[78.273629] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[78.282999] Starting dynamic subtest: pipe-D-eDP-1
[79.505752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[79.507817] Subtest plane-properties-legacy: SUCCESS (4.301s)
[80.317385] [004/130] (951s left) kms_vblank (ts-continuation-idle-hang)
[80.408340] Starting subtest: ts-continuation-idle-hang
[80.410612] Starting dynamic subtest: pipe-A-eDP-1
[106.716438] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.282s)
[106.730058] Starting dynamic subtest: pipe-D-eDP-1
[121.682423] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.959s)
[121.684632] Subtest ts-continuation-idle-hang: SUCCESS (41.245s)
[122.484578] [005/130] (909s left) kms_content_protection (dp-mst-lic-type-1)
[122.625540] Starting subtest: dp-mst-lic-type-1
[122.630082] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[122.782371] [006/130] (909s left) i915_drm_fdinfo (busy)
[122.822313] Starting subtest: busy
[122.824612] Starting dynamic subtest: rcs0
[122.835766] Dynamic subtest rcs0: SKIP (0.013s)
[122.843101] Starting dynamic subtest: bcs0
[122.847173] Dynamic subtest bcs0: SKIP (0.008s)
[122.854184] Starting dynamic subtest: vcs0
[122.858634] Dynamic subtest vcs0: SKIP (0.000s)
[122.865201] Starting dynamic subtest: vcs1
[122.869276] Dynamic subtest vcs1: SKIP (0.000s)
[122.876228] Starting dynamic subtest: vecs0
[122.880452] Dynamic subtest vecs0: SKIP (0.000s)
[122.887401] Starting dynamic subtest: ccs0
[122.891673] Dynamic subtest ccs0: SKIP (0.000s)
[122.895877] Subtest busy: SKIP (0.023s)
[122.938142] [007/130] (909s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[123.025987] Starting subtest: addfb25-y-tiled-small-legacy
[123.030214] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[123.149212] [008/130] (908s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[123.248067] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[123.252256] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[123.364238] [009/130] (908s left) gem_exec_capture (capture)
[123.413677] Starting subtest: capture
[123.415662] Starting dynamic subtest: rcs0-smem
[124.233559] Dynamic subtest rcs0-smem: SUCCESS (0.817s)
[124.243469] Starting dynamic subtest: bcs0-smem
[125.148817] Dynamic subtest bcs0-smem: SUCCESS (0.915s)
[125.157831] Starting dynamic subtest: vcs0-smem
[125.961545] Dynamic subtest vcs0-smem: SUCCESS (0.811s)
[125.970801] Starting dynamic subtest: vcs1-smem
[126.784447] Dynamic subtest vcs1-smem: SUCCESS (0.822s)
[126.792554] Starting dynamic subtest: vecs0-smem
[128.172647] Dynamic subtest vecs0-smem: FAIL (1.335s)
[128.181374] Starting dynamic subtest: ccs0-smem
[129.438162] Dynamic subtest ccs0-smem: SUCCESS (1.319s)
[129.440471] Subtest capture: FAIL (6.022s)
[129.591394] [010/130] (902s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[129.697934] Starting subtest: fbc-psr-cursor-mmap-cpu
[129.700284] Starting dynamic subtest: eDP-1
[129.704449] Dynamic subtest eDP-1: SKIP (0.000s)
[129.708616] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[129.779037] [011/130] (902s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[129.835127] Starting subtest: yf-tiled-ccs-to-y-tiled
[129.839693] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[130.027423] [012/130] (902s left) kms_cursor_crc (cursor-random-256x85)
[130.268162] Starting subtest: cursor-random-256x85
[130.312629] Subtest cursor-random-256x85: SKIP (0.040s)
[130.509478] [013/130] (901s left) gem_exec_balancer (nohangcheck)
[130.770663] Starting subtest: nohangcheck
[131.652111] Subtest nohangcheck: SUCCESS (0.881s)
[131.815520] [014/130] (900s left) gem_exec_create (basic)
[131.875070] Starting subtest: basic
[131.877450] Starting dynamic subtest: smem
[133.968775] Dynamic subtest smem: SUCCESS (2.093s)
[133.971290] Subtest basic: SUCCESS (2.094s)
[134.158787] [015/130] (898s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[134.258610] Starting subtest: random-ccs-data-yf-tiled-ccs
[134.260829] Starting dynamic subtest: pipe-A-eDP-1
[134.284974] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[134.292456] Starting dynamic subtest: pipe-B-eDP-1
[134.315878] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[134.323400] Starting dynamic subtest: pipe-C-eDP-1
[134.347750] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[134.354996] Starting dynamic subtest: pipe-D-eDP-1
[134.379251] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[134.383312] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[136.470046] [016/130] (895s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[136.563596] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[136.567865] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[136.700164] [017/130] (895s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[136.800975] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[137.790522] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.989s)
[137.943772] [018/130] (894s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[138.053059] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[138.056797] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[138.184571] [019/130] (894s left) kms_frontbuffer_tracking (psr-1p-rte)
[138.288824] Starting subtest: psr-1p-rte
[143.627766] Subtest psr-1p-rte: SUCCESS (5.343s)
[143.759376] [020/130] (888s left) kms_chamelium_edid (dp-mode-timings)
[144.141961] Subtest dp-mode-timings: SKIP (0.000s)
[144.980872] [021/130] (887s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[145.367529] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[146.207559] [022/130] (886s left) kms_cursor_crc (cursor-sliding-512x512)
[146.461155] Starting subtest: cursor-sliding-512x512
[146.465823] Subtest cursor-sliding-512x512: SKIP (0.001s)
[146.646422] [023/130] (886s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[146.737045] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[150.888909] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.156s)
[152.047229] [024/130] (880s left) gem_exec_reloc (basic-cpu-read-noreloc)
[152.107833] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[152.165733] [025/130] (880s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[152.290954] Starting subtest: 2x-cursor-vs-flip-legacy
[152.295299] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.003s)
[152.460790] [026/130] (880s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[152.564464] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[152.568869] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[152.691859] [027/130] (880s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[152.791831] Starting subtest: bad-rotation-90-yf-tiled-ccs
[152.794245] Starting dynamic subtest: pipe-A-eDP-1
[152.816771] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.824627] Starting dynamic subtest: pipe-B-eDP-1
[152.845159] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[152.851868] Starting dynamic subtest: pipe-C-eDP-1
[152.872300] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.878913] Starting dynamic subtest: pipe-D-eDP-1
[152.899621] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.903698] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[155.098780] [028/130] (877s left) gem_mmap (basic)
[155.154944] Subtest basic: SKIP (0.000s)
[155.219702] [029/130] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[155.311071] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[155.315255] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[155.417057] [030/130] (877s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[155.517203] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[155.519533] Starting dynamic subtest: pipe-A-default-mode
[155.805177] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[155.810434] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.287s)
[156.639059] [031/130] (876s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[156.730843] Starting subtest: crc-primary-basic-y-tiled-ccs
[156.733186] Starting dynamic subtest: pipe-A-eDP-1
[156.756537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[156.765859] Starting dynamic subtest: pipe-B-eDP-1
[156.787452] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[156.794224] Starting dynamic subtest: pipe-C-eDP-1
[156.815763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[156.822746] Starting dynamic subtest: pipe-D-eDP-1
[156.844788] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[156.849183] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s)
[158.979187] [032/130] (874s left) i915_suspend (fence-restore-tiled2untiled)
[159.036739] Starting subtest: fence-restore-tiled2untiled
[159.041074] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[159.164463] [033/130] (873s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[159.215949] Starting subtest: invalid-single-wait-unsubmitted
[159.218279] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[159.335967] [034/130] (873s left) perf_pmu (event-wait)
[159.378250] Starting subtest: event-wait
[159.380348] Starting dynamic subtest: rcs0
[159.384675] Dynamic subtest rcs0: SKIP (0.000s)
[159.388841] Subtest event-wait: SKIP (0.000s)
[159.490831] [035/130] (873s left) kms_plane_scaling (invalid-num-scalers)
[159.583145] Starting subtest: invalid-num-scalers
[159.585492] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[159.601408] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[159.609238] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[159.631887] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[159.639355] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[159.664451] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[159.671609] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[159.696637] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[159.698931] Subtest invalid-num-scalers: SUCCESS (0.116s)
[159.820939] [036/130] (873s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[159.915450] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[160.884662] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.967s)
[161.049228] [037/130] (872s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[161.155255] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[161.158887] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[161.298536] [038/130] (872s left) gem_exec_fence (syncobj-unused-fence)
[161.770952] Starting subtest: syncobj-unused-fence
[161.776255] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[162.966164] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[162.969261] [039/130] (870s left) gen3_mixed_blits
[163.093342] [040/130] (870s left) gem_ctx_engines (execute-oneforall)
[163.147834] Starting subtest: execute-oneforall
[163.669428] Subtest execute-oneforall: SUCCESS (0.521s)
[165.017126] [041/130] (868s left) gem_exec_fence (expired-history)
[165.450061] Starting subtest: expired-history
[172.667995] Subtest expired-history: SUCCESS (7.217s)
[173.207356] [042/130] (860s left) gem_mmap_gtt (cpuset-medium-copy)
[173.255112] Subtest cpuset-medium-copy: SKIP (0.000s)
[173.316248] [043/130] (860s left) kms_pm_rpm (cursor-dpms)
[175.049417] Starting subtest: cursor-dpms
[175.054248] Subtest cursor-dpms: SKIP (0.000s)
[175.626852] [044/130] (857s left) syncobj_wait (wait-zero-handles)
[175.681797] Starting subtest: wait-zero-handles
[175.683642] Subtest wait-zero-handles: SUCCESS (0.000s)
[175.800189] [045/130] (857s left) kms_addfb_basic (bo-too-small)
[175.895335] Starting subtest: bo-too-small
[175.897481] Subtest bo-too-small: SUCCESS (0.000s)
[176.031259] [046/130] (857s left) kms_selftest (drm_damage_helper)
[176.066019] Starting subtest: drm_damage_helper
[176.082709] Starting dynamic subtest: drm_test_damage_iter_no_damage
[176.187564] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.104s)
[176.195719] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[176.303107] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.114s)
[176.310433] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[176.430464] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.127s)
[176.437762] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[176.563072] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.132s)
[176.570082] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[176.689487] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.126s)
[176.696518] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[176.830357] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.140s)
[176.839621] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[176.905208] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.076s)
[176.914440] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[177.013515] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.106s)
[177.022731] Starting dynamic subtest: drm_test_damage_iter_single_damage
[177.132339] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.117s)
[177.141682] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[177.265508] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.133s)
[177.274604] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[177.400345] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.134s)
[177.409603] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[177.524640] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.122s)
[177.533825] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[177.646299] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.121s)
[177.653820] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[177.781268] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.135s)
[177.788843] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[177.908542] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.126s)
[177.917956] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[178.022509] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.114s)
[178.031662] Starting dynamic subtest: drm_test_damage_iter_damage
[178.172193] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.149s)
[178.179245] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[178.293110] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.121s)
[178.300056] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[178.414426] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.120s)
[178.422351] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[178.552253] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.137s)
[178.559196] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[178.688667] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.137s)
[178.690676] Subtest drm_damage_helper: SUCCESS (2.624s)
[178.848773] [047/130] (854s left) kms_flip (flip-vs-wf_vblank-interruptible)
[178.944207] Starting subtest: flip-vs-wf_vblank-interruptible
[178.946528] Starting dynamic subtest: A-eDP1
[180.837831] Dynamic subtest A-eDP1: SUCCESS (1.893s)
[180.848049] Starting dynamic subtest: B-eDP1
[182.768711] Dynamic subtest B-eDP1: SUCCESS (1.930s)
[182.778694] Starting dynamic subtest: C-eDP1
[184.687749] Dynamic subtest C-eDP1: SUCCESS (1.918s)
[184.696750] Starting dynamic subtest: D-eDP1
[186.607182] Dynamic subtest D-eDP1: SUCCESS (1.917s)
[186.609670] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.666s)
[187.861761] [048/130] (845s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[192.935664] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[192.937742] Starting dynamic subtest: pipe-A-eDP-1
[204.647763] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.712s)
[204.657841] Starting dynamic subtest: pipe-B-eDP-1
[216.387807] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.736s)
[216.390186] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.452s)
[217.293236] [049/130] (816s left) fbdev (nullptr)
[217.343403] Starting subtest: nullptr
[217.345719] Subtest nullptr: SUCCESS (0.000s)
[217.427850] [050/130] (816s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[217.519081] Starting subtest: fb-8bpc-vs-panel-8bpc
[217.521277] Starting dynamic subtest: pipe-A-eDP-1
[218.936583] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.416s)
[218.938939] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.418s)
[219.813919] [051/130] (814s left) kms_flip (2x-plain-flip-fb-recreate)
[219.926238] Starting subtest: 2x-plain-flip-fb-recreate
[219.935543] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[220.066474] [052/130] (813s left) gem_lmem_swapping (massive)
[220.107067] Subtest massive: SKIP (0.000s)
[220.150798] [053/130] (813s left) gem_ctx_isolation (nonpriv)
[220.213395] Starting subtest: nonpriv
[220.215780] Starting dynamic subtest: rcs0
[220.464231] Dynamic subtest rcs0: SUCCESS (0.250s)
[220.474456] Starting dynamic subtest: bcs0
[220.731197] Dynamic subtest bcs0: SUCCESS (0.267s)
[220.740146] Starting dynamic subtest: vcs0
[220.992894] Dynamic subtest vcs0: SUCCESS (0.261s)
[221.000115] Starting dynamic subtest: vcs1
[222.123920] Dynamic subtest vcs1: SUCCESS (1.130s)
[222.132049] Starting dynamic subtest: vecs0
[224.138507] Dynamic subtest vecs0: SUCCESS (2.014s)
[224.148805] Starting dynamic subtest: ccs0
[226.221082] Dynamic subtest ccs0: SUCCESS (2.081s)
[226.223723] Subtest nonpriv: SUCCESS (6.007s)
[226.502144] [054/130] (807s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[226.598189] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[233.943472] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.348s)
[234.114145] [055/130] (799s left) gem_ctx_shared (q-promotion)
[234.179277] Starting subtest: Q-promotion
[234.181580] Starting dynamic subtest: rcs0
[234.284219] Dynamic subtest rcs0: SUCCESS (0.107s)
[234.299911] Starting dynamic subtest: vcs0
[234.380973] Dynamic subtest vcs0: SUCCESS (0.097s)
[234.393042] Starting dynamic subtest: vcs1
[234.459972] Dynamic subtest vcs1: SUCCESS (0.076s)
[234.475826] Starting dynamic subtest: vecs0
[234.539029] Dynamic subtest vecs0: SUCCESS (0.078s)
[234.554866] Starting dynamic subtest: ccs0
[234.615670] Dynamic subtest ccs0: SUCCESS (0.074s)
[234.618368] Subtest Q-promotion: SUCCESS (0.439s)
[236.050011] [056/130] (797s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[236.158424] Starting subtest: psr-modesetfrombusy
[242.280472] Subtest psr-modesetfrombusy: SUCCESS (6.126s)
[242.448885] [057/130] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[242.551891] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[242.555270] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[242.675323] [058/130] (791s left) perf_pmu (semaphore-busy)
[242.713857] Starting subtest: semaphore-busy
[242.715965] Starting dynamic subtest: rcs0
[244.383614] Dynamic subtest rcs0: SUCCESS (1.666s)
[244.394478] Starting dynamic subtest: bcs0
[246.013733] Dynamic subtest bcs0: SUCCESS (1.627s)
[246.024610] Starting dynamic subtest: vcs0
[250.435176] Dynamic subtest vcs0: SUCCESS (4.367s)
[250.445437] Starting dynamic subtest: vcs1
[255.440069] Dynamic subtest vcs1: SUCCESS (5.054s)
[255.451274] Starting dynamic subtest: vecs0
[261.441044] Dynamic subtest vecs0: SUCCESS (5.949s)
[261.451867] Starting dynamic subtest: ccs0
[264.528114] Dynamic subtest ccs0: SUCCESS (3.134s)
[264.531092] Subtest semaphore-busy: SUCCESS (21.812s)
[264.674893] [059/130] (769s left) vgem_basic (setversion)
[264.716689] Starting subtest: setversion
[264.720726] Subtest setversion: SUCCESS (0.000s)
[264.784305] [060/130] (769s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[264.842267] Starting subtest: etime-multi-wait-for-submit-submitted
[264.945268] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[265.048431] [061/130] (769s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[265.153509] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[265.158111] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[265.267266] [062/130] (769s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[265.377443] Starting subtest: flip-vs-cursor-legacy
[272.421979] Subtest flip-vs-cursor-legacy: SUCCESS (7.045s)
[273.326360] [063/130] (760s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[273.387065] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[273.457019] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[273.528337] [064/130] (760s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[273.625934] Starting subtest: bo-too-small-due-to-tiling
[273.630649] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[273.737153] [065/130] (760s left) gem_exec_reloc (basic-write-cpu)
[273.801540] Subtest basic-write-cpu: SKIP (0.000s)
[273.892997] [066/130] (760s left) gem_exec_whisper (basic-contexts-priority-all)
[273.969842] Starting subtest: basic-contexts-priority-all
[296.736493] Subtest basic-contexts-priority-all: SUCCESS (22.715s)
[296.883819] [067/130] (737s left) gem_mmap_gtt (basic)
[296.943579] Subtest basic: SKIP (0.000s)
[297.012599] [068/130] (737s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[297.108484] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[297.112831] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[297.231789] [069/130] (737s left) api_intel_bb (lot-of-buffers)
[297.286580] Starting subtest: lot-of-buffers
[298.363657] Subtest lot-of-buffers: SUCCESS (1.076s)
[298.894635] [070/130] (735s left) kms_dsc (dsc-with-output-formats-with-bpc)
[298.982077] Starting subtest: dsc-with-output-formats-with-bpc
[299.039197] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[299.076730] [071/130] (735s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[299.171989] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[299.174429] Starting dynamic subtest: pipe-A
[300.230697] Dynamic subtest pipe-A: SUCCESS (1.061s)
[300.238815] Starting dynamic subtest: pipe-B
[302.306611] Dynamic subtest pipe-B: SUCCESS (2.076s)
[302.314844] Starting dynamic subtest: pipe-C
[303.505932] Dynamic subtest pipe-C: SUCCESS (1.198s)
[303.514322] Starting dynamic subtest: pipe-D
[304.661191] Dynamic subtest pipe-D: SUCCESS (1.153s)
[304.663533] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.493s)
[305.882583] [072/130] (728s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[305.939326] Starting subtest: wait-all-for-submit-delayed-submit
[306.040871] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[306.141940] [073/130] (728s left) gen9_exec_parse (allowed-all)
[306.205904] Subtest allowed-all: SKIP (0.000s)
[306.270162] [074/130] (728s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[306.379918] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[306.424735] [075/130] (728s left) kms_plane_multiple (2x-tiling-y)
[306.510220] Starting subtest: 2x-tiling-y
[306.514580] Subtest 2x-tiling-y: SKIP (0.000s)
[306.596330] [076/130] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[306.704122] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[313.294725] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.590s)
[313.456188] [077/130] (721s left) gem_exec_reloc (basic-write-read-active)
[313.511483] Subtest basic-write-read-active: SKIP (0.000s)
[313.604556] [078/130] (721s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[313.701385] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[313.705328] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[313.774224] [079/130] (721s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[313.872106] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[313.874531] Starting dynamic subtest: pipe-A-eDP-1
[313.883597] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[313.892461] Starting dynamic subtest: pipe-B-eDP-1
[313.901617] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[313.910129] Starting dynamic subtest: pipe-C-eDP-1
[313.918744] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[313.927046] Starting dynamic subtest: pipe-D-eDP-1
[313.935621] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[313.940020] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[316.168765] [080/130] (718s left) kms_psr (psr-dpms)
[316.267040] Starting subtest: psr-dpms
[316.269176] Starting dynamic subtest: eDP-1
[319.286252] Dynamic subtest eDP-1: SUCCESS (3.020s)
[319.288584] Subtest psr-dpms: SUCCESS (3.021s)
[320.171075] [081/130] (714s left) gem_exec_schedule (u-fairslice-all)
[320.245696] Starting subtest: u-fairslice-all
[322.343177] Subtest u-fairslice-all: SUCCESS (2.057s)
[323.979164] [082/130] (711s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[324.086112] Starting subtest: fbc-pr-cursor-mmap-gtt
[324.090134] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[324.181049] [083/130] (710s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[324.266972] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[324.269247] Starting dynamic subtest: pipe-A-default-mode
[325.402392] Dynamic subtest pipe-A-default-mode: SKIP (1.133s)
[325.406550] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.135s)
[325.609453] [084/130] (709s left) kms_cursor_crc (cursor-size-change)
[325.704164] Starting subtest: cursor-size-change
[325.706311] Starting dynamic subtest: pipe-A-eDP-1
[326.491299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s)
[326.500784] Starting dynamic subtest: pipe-D-eDP-1
[327.954289] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.460s)
[327.956699] Subtest cursor-size-change: SUCCESS (2.251s)
[328.765560] [085/130] (706s left) dmabuf_sync_file (import-basic)
[328.814715] Starting subtest: import-basic
[328.816989] Subtest import-basic: SUCCESS (0.002s)
[328.881929] [086/130] (706s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[328.938569] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[328.940899] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[329.104866] [087/130] (706s left) api_intel_allocator (two-level-inception)
[329.163513] Starting subtest: two-level-inception
[334.616118] Subtest two-level-inception: SUCCESS (5.402s)
[334.711163] [088/130] (700s left) syncobj_basic (bad-fd-to-handle)
[334.769411] Starting subtest: bad-fd-to-handle
[334.771682] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[334.893524] [089/130] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[335.001305] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[335.005990] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[335.136648] [090/130] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[335.240756] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[335.245035] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[335.372473] [091/130] (700s left) gem_mmap_wc (set-cache-level)
[335.434789] Subtest set-cache-level: SKIP (0.000s)
[335.502704] [092/130] (700s left) gem_render_copy_redux (flink-interruptible)
[335.577057] Starting subtest: flink-interruptible
[336.323259] Subtest flink-interruptible: SUCCESS (0.746s)
[336.505650] [093/130] (699s left) kms_cursor_crc (cursor-onscreen-32x32)
[336.655390] Starting subtest: cursor-onscreen-32x32
[336.699670] Subtest cursor-onscreen-32x32: SKIP (0.042s)
[337.049006] [094/130] (698s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[337.164198] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[343.818103] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.658s)
[343.992428] [095/130] (691s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[344.041210] Subtest untiled-to-tiled: SKIP (0.000s)
[344.119552] [096/130] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[344.214784] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[347.907510] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.696s)
[349.114074] [097/130] (686s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[349.176842] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[349.178922] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[349.286129] [098/130] (686s left) gem_render_copy (y-tiled-ccs-to-linear)
[349.338108] Starting subtest: y-tiled-ccs-to-linear
[349.342581] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[349.538316] [099/130] (686s left) gem_wait (wait)
[349.591787] Starting subtest: wait
[349.594171] Starting dynamic subtest: all-engines
[350.932771] Dynamic subtest all-engines: SUCCESS (1.339s)
[350.944599] Starting dynamic subtest: rcs0
[351.978288] Dynamic subtest rcs0: SUCCESS (1.044s)
[351.992619] Starting dynamic subtest: bcs0
[353.026089] Dynamic subtest bcs0: SUCCESS (1.045s)
[353.036347] Starting dynamic subtest: vcs0
[354.072330] Dynamic subtest vcs0: SUCCESS (1.044s)
[354.083480] Starting dynamic subtest: vcs1
[355.116732] Dynamic subtest vcs1: SUCCESS (1.042s)
[355.127898] Starting dynamic subtest: vecs0
[356.161672] Dynamic subtest vecs0: SUCCESS (1.043s)
[356.172958] Starting dynamic subtest: ccs0
[357.208367] Dynamic subtest ccs0: SUCCESS (1.044s)
[357.211076] Subtest wait: SUCCESS (7.617s)
[357.418845] [100/130] (678s left) kms_vrr (max-min)
[357.507036] Starting subtest: max-min
[357.513346] Subtest max-min: SKIP (0.000s)
[357.606081] [101/130] (678s left) gem_eio (in-flight-suspend)
[357.798983] Starting subtest: in-flight-suspend
[401.695491] Subtest in-flight-suspend: SUCCESS (14.439s)
[409.919784] [102/130] (634s left) prime_mmap (test_errors)
[409.997847] Starting subtest: test_errors
[410.000169] Starting dynamic subtest: test_errors-smem
[410.091406] Dynamic subtest test_errors-smem: SUCCESS (0.095s)
[410.094478] Subtest test_errors: SUCCESS (0.096s)
[410.234768] [103/130] (633s left) i915_pm_freq_api (freq-suspend)
[410.300697] Starting subtest: freq-suspend
[410.303728] Starting dynamic subtest: gt0
[426.456549] Dynamic subtest gt0: SUCCESS (1.626s)
[426.479254] Starting dynamic subtest: gt1
[443.411464] Dynamic subtest gt1: SUCCESS (1.550s)
[443.413904] Subtest freq-suspend: SUCCESS (3.179s)
[449.528706] [104/130] (600s left) gem_linear_blits (normal)
[449.944619] Starting subtest: normal
[455.285868] Subtest normal: SUCCESS (5.344s)
[455.441335] [105/130] (594s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[455.633379] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[456.635282] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.003s)
[457.470829] [106/130] (592s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[457.575181] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[457.580144] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[457.690590] [107/130] (592s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[457.779390] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[457.782270] Starting dynamic subtest: pipe-A-eDP-1
[457.851033] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[457.862265] Starting dynamic subtest: pipe-B-eDP-1
[457.930282] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[457.941152] Starting dynamic subtest: pipe-C-eDP-1
[458.012119] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[458.024007] Starting dynamic subtest: pipe-D-eDP-1
[458.092199] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[458.097893] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[459.953664] [108/130] (590s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[464.967700] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[464.970395] Starting dynamic subtest: pipe-A-eDP-1
[465.773624] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s)
[465.784041] Starting dynamic subtest: pipe-B-eDP-1
[466.907214] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[466.912673] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.924s)
[468.148408] [109/130] (582s left) gem_ctx_persistence (heartbeat-close)
[468.213265] Starting subtest: heartbeat-close
[468.218821] Subtest heartbeat-close: SKIP (0.000s)
[468.358644] [110/130] (582s left) kms_pipe_crc_basic (nonblocking-crc)
[468.458767] Starting subtest: nonblocking-crc
[468.461312] Starting dynamic subtest: pipe-A-eDP-1
[469.211107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[469.223026] Starting dynamic subtest: pipe-B-eDP-1
[470.608993] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s)
[470.619721] Starting dynamic subtest: pipe-C-eDP-1
[472.009994] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s)
[472.021149] Starting dynamic subtest: pipe-D-eDP-1
[473.350759] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[473.353300] Subtest nonblocking-crc: SUCCESS (4.873s)
[474.170688] [111/130] (576s left) kms_psr (pr-sprite-render)
[474.269148] Starting subtest: pr-sprite-render
[474.274213] Subtest pr-sprite-render: SKIP (0.000s)
[474.380169] [112/130] (576s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[474.435352] Subtest writes-after-reads-snoop: SKIP (0.000s)
[474.515272] [113/130] (576s left) syncobj_timeline (reset-during-wait-for-submit)
[474.577110] Starting subtest: reset-during-wait-for-submit
[474.681390] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[474.783986] [114/130] (575s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[474.896257] Starting subtest: 4-tiled-64bpp-rotate-270
[474.919212] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[475.066738] [115/130] (575s left) perf (non-system-wide-paranoid)
[475.214087] Starting subtest: non-system-wide-paranoid
[475.243926] Subtest non-system-wide-paranoid: SUCCESS (0.031s)
[475.294253] [116/130] (575s left) kms_invalid_mode (bad-vtotal)
[475.390844] Starting subtest: bad-vtotal
[475.393307] Starting dynamic subtest: pipe-A-eDP-1
[475.677582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[475.689279] Starting dynamic subtest: pipe-B-eDP-1
[475.692371] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[475.703486] Starting dynamic subtest: pipe-C-eDP-1
[475.705950] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[475.715384] Starting dynamic subtest: pipe-D-eDP-1
[475.717827] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[475.719973] Subtest bad-vtotal: SUCCESS (0.297s)
[476.517982] [117/130] (574s left) i915_pm_rpm (debugfs-read)
[478.440354] Starting subtest: debugfs-read
[479.613737] Subtest debugfs-read: SUCCESS (1.165s)
[479.994035] [118/130] (570s left) kms_atomic_transition (modeset-transition-fencing)
[480.093135] Starting subtest: modeset-transition-fencing
[480.095421] Starting dynamic subtest: 1x-outputs
[490.927697] Dynamic subtest 1x-outputs: SUCCESS (10.825s)
[490.930520] Subtest modeset-transition-fencing: SUCCESS (10.827s)
[491.797685] [119/130] (559s left) gem_pipe_control_store_loop (fresh-buffer)
[491.867367] Starting subtest: fresh-buffer
[494.019043] Subtest fresh-buffer: SUCCESS (2.151s)
[494.159144] [120/130] (556s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[494.264100] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[494.269216] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[494.381473] [121/130] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[494.489928] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[494.495182] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[494.610112] [122/130] (556s left) perf_pmu (all-busy-check-all)
[494.653899] Starting subtest: all-busy-check-all
[496.271590] Subtest all-busy-check-all: SUCCESS (1.620s)
[496.405324] [123/130] (554s left) sw_sync (alloc_fence)
[496.438716] Starting subtest: alloc_fence
[496.441282] Subtest alloc_fence: SUCCESS (0.000s)
[496.498713] [124/130] (554s left) kms_psr (fbc-psr-primary-mmap-cpu)
[496.591200] Starting subtest: fbc-psr-primary-mmap-cpu
[496.594076] Starting dynamic subtest: eDP-1
[496.599208] Dynamic subtest eDP-1: SKIP (0.000s)
[496.604076] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[496.689030] [125/130] (554s left) kms_getfb (getfb2-handle-protection)
[496.782682] Starting subtest: getfb2-handle-protection
[496.798361] Subtest getfb2-handle-protection: SUCCESS (0.017s)
[496.930664] [126/130] (554s left) gem_pxp (reject-modify-context-protection-on)
[497.054951] Starting subtest: reject-modify-context-protection-on
[497.058038] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[497.194702] [127/130] (553s left) kms_frontbuffer_tracking (psr-suspend)
[497.285757] Starting subtest: psr-suspend
[535.869364] Subtest psr-suspend: SUCCESS (8.766s)
[542.031100] [128/130] (515s left) gem_exec_schedule (manyslice)
[542.126066] Starting subtest: manyslice
[542.128335] Starting dynamic subtest: rcs0
[547.368149] Dynamic subtest rcs0: SUCCESS (5.147s)
[547.380598] Starting dynamic subtest: bcs0
[554.007444] Dynamic subtest bcs0: SUCCESS (6.601s)
[554.020557] Starting dynamic subtest: vcs0
[559.104016] Dynamic subtest vcs0: SUCCESS (5.084s)
[559.116703] Starting dynamic subtest: vcs1
[565.205195] Dynamic subtest vcs1: SUCCESS (6.090s)
[565.220726] Starting dynamic subtest: vecs0
[571.295988] Dynamic subtest vecs0: SUCCESS (6.084s)
[571.308887] Starting dynamic subtest: ccs0
[576.951663] Dynamic subtest ccs0: SUCCESS (5.652s)
[576.954239] Subtest manyslice: SUCCESS (34.667s)
[577.215645] [129/130] (480s left) gem_ppgtt (shrink-vs-evict-pinned)
[577.288904] Starting subtest: shrink-vs-evict-pinned
[583.188528] Subtest shrink-vs-evict-pinned: SUCCESS (5.848s)
[583.231299] [130/130] (474s left) gem_mmap_gtt (fault-concurrent-y)
[583.286727] Subtest fault-concurrent-Y: SKIP (0.000s)
[583.349984] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_properties
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_capture
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: gem_exec_create
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_edid
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_reloc
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_mmap
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_flip_scaled_crc
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: i915_suspend
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: gen3_mixed_blits
results: parsing output: 39/ for test: gem_ctx_engines
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: kms_pm_rpm
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: kms_selftest
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: fbdev
results: parsing output: 49/ for test: kms_dither
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: gem_ctx_isolation
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_ctx_shared
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: vgem_basic
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: sriov_basic
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: kms_dsc
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: kms_tiled_display
results: parsing output: 74/ for test: kms_plane_multiple
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_joiner
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: dmabuf_sync_file
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: syncobj_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_mmap_wc
results: parsing output: 91/ for test: gem_render_copy_redux
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_set_tiling_vs_blt
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: gem_wait
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: prime_mmap
results: parsing output: 102/ for test: i915_pm_freq_api
results: parsing output: 103/ for test: gem_linear_blits
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: kms_pipe_crc_basic
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_partial_pwrite_pread
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_invalid_mode
results: parsing output: 116/ for test: i915_pm_rpm
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: gem_pipe_control_store_loop
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_getfb
results: parsing output: 125/ for test: gem_pxp
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: gem_ppgtt
results: parsing output: 129/ for test: gem_mmap_gtt
Done.