[63.612548] Initializing watchdogs
[63.612607]   /dev/watchdog0
[63.626706] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750]
[63.631633] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.633808] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.635586] [001/130] (960s left) kms_chamelium_color (ctm-max)
[63.830166] Subtest ctm-max: SKIP (0.000s)
[63.867162] [002/130] (960s left) gem_ctx_persistence (userptr)
[63.906779] Starting subtest: userptr
[64.000980] Subtest userptr: SUCCESS (0.093s)
[64.093394] [003/130] (960s left) gem_mmap_offset (ptrace)
[64.126818] Starting subtest: ptrace
[64.128264] Starting dynamic subtest: smem0-gtt
[64.153491] Dynamic subtest smem0-gtt: SUCCESS (0.026s)
[64.157952] Starting dynamic subtest: smem0-wb
[64.169649] Dynamic subtest smem0-wb: SUCCESS (0.016s)
[64.174201] Starting dynamic subtest: smem0-wc
[64.187140] Dynamic subtest smem0-wc: SUCCESS (0.017s)
[64.191494] Starting dynamic subtest: smem0-uc
[64.205309] Dynamic subtest smem0-uc: SUCCESS (0.018s)
[64.206034] Subtest ptrace: SUCCESS (0.079s)
[64.342195] [004/130] (959s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[64.451038] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[64.452354] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[64.596851] [005/130] (959s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[64.704337] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[64.747991] [006/130] (959s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[64.853148] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[64.854052] Starting dynamic subtest: pipe-A-HDMI-A-2
[64.861422] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[64.865906] Starting dynamic subtest: pipe-B-HDMI-A-2
[64.873045] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[64.874456] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[65.054271] [007/130] (959s left) kms_invalid_mode (bad-vsync-end)
[65.158743] Starting subtest: bad-vsync-end
[65.159466] Starting dynamic subtest: pipe-A-HDMI-A-2
[65.206406] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.048s)
[65.212140] Starting dynamic subtest: pipe-B-HDMI-A-2
[65.212902] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s)
[65.213683] Subtest bad-vsync-end: SUCCESS (0.050s)
[65.369584] [008/130] (959s left) kms_lease (lease-invalid-connector)
[65.473820] Starting subtest: lease-invalid-connector
[65.474494] Starting dynamic subtest: pipe-A-HDMI-A-2
[65.475194] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.000s)
[65.479686] Starting dynamic subtest: pipe-B-HDMI-A-2
[65.480356] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s)
[65.481026] Subtest lease-invalid-connector: SUCCESS (0.001s)
[65.578439] [009/130] (958s left) kms_psr (psr2-cursor-plane-move)
[65.682660] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[65.732493] [010/130] (958s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[65.835896] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[65.836589] Starting dynamic subtest: pipe-A
[67.901469] Dynamic subtest pipe-A: SUCCESS (2.065s)
[67.910217] Starting dynamic subtest: pipe-B
[69.955215] Dynamic subtest pipe-B: SUCCESS (2.053s)
[69.956431] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.119s)
[70.158604] [011/130] (954s left) kms_vblank (query-busy)
[70.261923] Starting subtest: query-busy
[70.263464] Starting dynamic subtest: pipe-A-HDMI-A-2
[73.041034] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.777s)
[73.048287] Starting dynamic subtest: pipe-B-HDMI-A-2
[75.693281] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.652s)
[75.693976] Subtest query-busy: SUCCESS (5.431s)
[75.871585] [012/130] (948s left) gem_pxp (regular-baseline-src-copy-readible)
[256.313696] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[265.835489] Closing watchdogs
[265.839881] Initializing watchdogs
[265.839922]   /dev/watchdog0
[265.852430] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750]
[265.857207] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[265.858397] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[265.860191] [013/130] (758s left) i915_pm_rps (engine-order)
[265.895820] Starting subtest: engine-order
[269.214790] Subtest engine-order: SUCCESS (3.317s)
[269.356206] [014/130] (755s left) drm_fdinfo (busy-idle)
[269.392631] Starting subtest: busy-idle
[269.393400] Starting dynamic subtest: rcs0
[270.017412] Dynamic subtest rcs0: SUCCESS (0.625s)
[270.026457] Starting dynamic subtest: bcs0
[270.648517] Dynamic subtest bcs0: SUCCESS (0.630s)
[270.657964] Starting dynamic subtest: vcs0
[271.272423] Dynamic subtest vcs0: SUCCESS (0.623s)
[271.281365] Starting dynamic subtest: vecs0
[271.888381] Dynamic subtest vecs0: SUCCESS (0.615s)
[271.890022] Subtest busy-idle: SUCCESS (2.497s)
[271.993348] [015/130] (752s left) gem_mmap_gtt (ptrace)
[272.026680] Starting subtest: ptrace
[272.119753] Subtest ptrace: SUCCESS (0.094s)
[272.264118] [016/130] (752s left) gem_exec_reloc (basic-write-read)
[272.300251] Subtest basic-write-read: SKIP (0.000s)
[272.383986] [017/130] (752s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[272.492386] Starting subtest: 2x-flip-vs-rmfb-interruptible
[272.494492] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.001s)
[272.625577] [018/130] (752s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[272.735719] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[275.174508] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.440s)
[275.368866] [019/130] (749s left) gem_exec_gttfill (multigpu-basic)
[275.522146] Starting subtest: multigpu-basic
[292.942668] Subtest multigpu-basic: SUCCESS (17.421s)
[292.980900] [020/130] (731s left) prime_mmap (test_dup)
[293.047046] Starting subtest: test_dup
[293.047729] Starting dynamic subtest: test_dup-smem
[293.093588] Dynamic subtest test_dup-smem: SUCCESS (0.047s)
[293.094297] Subtest test_dup: SUCCESS (0.047s)
[293.168863] [021/130] (731s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[293.273312] Starting subtest: basic-flip-after-cursor-atomic
[294.321103] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.047s)
[294.477720] [022/130] (730s left) gem_render_copy_redux (interruptible)
[294.515791] Starting subtest: interruptible
[294.899637] Subtest interruptible: SUCCESS (0.384s)
[295.058142] [023/130] (729s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[295.167505] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[297.325563] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.159s)
[297.496477] [024/130] (727s left) i915_query (hwconfig_table)
[297.529136] Starting subtest: hwconfig_table
[297.530577] Subtest hwconfig_table: SKIP (0.000s)
[297.640952] [025/130] (727s left) kms_feature_discovery (chamelium)
[297.745520] Starting subtest: chamelium
[297.746897] Subtest chamelium: SKIP (0.000s)
[297.847798] [026/130] (727s left) kms_psr (psr-cursor-mmap-gtt)
[297.952704] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[297.996642] [027/130] (727s left) kms_flip (2x-flip-vs-fences)
[298.101737] Starting subtest: 2x-flip-vs-fences
[298.104030] Subtest 2x-flip-vs-fences: SKIP (0.001s)
[298.240022] [028/130] (726s left) kms_flip (2x-blocking-wf_vblank)
[298.343449] Starting subtest: 2x-blocking-wf_vblank
[298.344827] Subtest 2x-blocking-wf_vblank: SKIP (0.001s)
[298.493286] [029/130] (726s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[298.598224] Starting subtest: cursorA-vs-flipA-atomic-transitions
[309.450049] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.851s)
[309.623298] [030/130] (715s left) gem_exec_fence (nb-await)
[309.789576] Starting subtest: nb-await
[309.790601] Starting dynamic subtest: rcs0
[309.851118] Dynamic subtest rcs0: SUCCESS (0.061s)
[309.868661] Starting dynamic subtest: bcs0
[309.913623] Dynamic subtest bcs0: SUCCESS (0.061s)
[309.932773] Starting dynamic subtest: vcs0
[309.976296] Dynamic subtest vcs0: SUCCESS (0.062s)
[309.994619] Starting dynamic subtest: vecs0
[310.038156] Dynamic subtest vecs0: SUCCESS (0.061s)
[310.039528] Subtest nb-await: SUCCESS (0.249s)
[310.551066] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[310.552492] [031/130] (714s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[310.658104] Starting subtest: plane-upscale-factor-0-25-with-rotation
[310.658859] Starting dynamic subtest: pipe-A
[311.075247] Dynamic subtest pipe-A: SKIP (0.415s)
[311.081198] Starting dynamic subtest: pipe-B
[311.501961] Dynamic subtest pipe-B: SKIP (0.427s)
[311.503303] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (0.842s)
[311.668053] [032/130] (713s left) vgem_basic (debugfs)
[311.714815] Starting subtest: debugfs
[311.715485] Subtest debugfs: SUCCESS (0.000s)
[311.782017] [033/130] (713s left) vgem_basic (second-client)
[311.828584] Starting subtest: second-client
[311.866519] Subtest second-client: SUCCESS (0.038s)
[311.933563] [034/130] (713s left) kms_color (ctm-signed)
[312.037019] Starting subtest: ctm-signed
[312.037727] Starting dynamic subtest: pipe-A-HDMI-A-2
[313.081154] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.043s)
[313.091464] Starting dynamic subtest: pipe-B-HDMI-A-2
[313.943729] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.861s)
[313.944401] Subtest ctm-signed: SUCCESS (1.906s)
[314.117405] [035/130] (711s left) kms_plane_multiple (tiling-x)
[314.221076] Starting subtest: tiling-x
[314.222823] Starting dynamic subtest: pipe-A-HDMI-A-2
[314.887325] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.665s)
[314.897686] Starting dynamic subtest: pipe-B-HDMI-A-2
[315.462756] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.573s)
[315.463429] Subtest tiling-x: SUCCESS (1.242s)
[315.640386] [036/130] (709s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[315.746739] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[318.339602] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.593s)
[318.527046] [037/130] (706s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[318.562033] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[318.562739] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[318.657497] [038/130] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[318.765837] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[318.767177] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[318.904702] [039/130] (706s left) gem_exec_store (dword)
[318.945112] Starting subtest: dword
[318.945830] Starting dynamic subtest: rcs0
[318.997708] Dynamic subtest rcs0: SUCCESS (0.052s)
[319.018349] Starting dynamic subtest: bcs0
[319.023114] Dynamic subtest bcs0: SUCCESS (0.024s)
[319.033191] Starting dynamic subtest: vcs0
[319.047230] Dynamic subtest vcs0: SUCCESS (0.023s)
[319.060233] Starting dynamic subtest: vecs0
[319.073206] Dynamic subtest vecs0: SUCCESS (0.024s)
[319.074281] Subtest dword: SUCCESS (0.129s)
[319.284824] [040/130] (706s left) kms_chamelium_hpd (dp-hpd-fast)
[319.429009] Subtest dp-hpd-fast: SKIP (0.000s)
[319.500231] [041/130] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[319.609790] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[319.611148] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[319.754811] [042/130] (705s left) gem_exec_whisper (basic-sync-all)
[319.798591] Starting subtest: basic-sync-all
[320.910054] Subtest basic-sync-all: SUCCESS (1.111s)
[321.119501] [043/130] (704s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[321.231010] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[321.232329] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[321.374104] [044/130] (704s left) sw_sync (timeline_closed)
[321.409650] Starting subtest: timeline_closed
[321.410322] Subtest timeline_closed: SUCCESS (0.000s)
[321.493722] [045/130] (704s left) kms_big_fb (yf-tiled-addfb)
[321.611953] Starting subtest: yf-tiled-addfb
[321.613302] Subtest yf-tiled-addfb: SKIP (0.000s)
[321.725461] [046/130] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[321.835672] Starting subtest: fbc-rgb101010-draw-blt
[324.633652] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.799s)
[324.812580] [047/130] (701s left) sw_sync (sync_merge)
[324.846260] Starting subtest: sync_merge
[324.846944] Subtest sync_merge: SUCCESS (0.000s)
[324.932862] [048/130] (700s left) gem_ctx_isolation (dirty-create)
[324.972267] Starting subtest: dirty-create
[324.972966] Starting dynamic subtest: rcs0
[325.364425] Dynamic subtest rcs0: SUCCESS (0.392s)
[325.371804] Starting dynamic subtest: bcs0
[325.846144] Dynamic subtest bcs0: SUCCESS (0.481s)
[325.852799] Starting dynamic subtest: vcs0
[326.347533] Dynamic subtest vcs0: SUCCESS (0.501s)
[326.353630] Starting dynamic subtest: vecs0
[326.797435] Dynamic subtest vecs0: SUCCESS (0.449s)
[326.798169] Subtest dirty-create: SUCCESS (1.825s)
[327.004909] [049/130] (698s left) syncobj_timeline (invalid-transfer-illegal-handle)
[327.037664] Starting subtest: invalid-transfer-illegal-handle
[327.038353] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[327.123799] [050/130] (698s left) kms_vblank (wait-busy-hang)
[327.231391] Starting subtest: wait-busy-hang
[327.233477] Starting dynamic subtest: pipe-A-HDMI-A-2
[341.642298] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (14.408s)
[341.651685] Starting dynamic subtest: pipe-B-HDMI-A-2
[355.454799] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (13.811s)
[355.455590] Subtest wait-busy-hang: SUCCESS (28.224s)
[355.669299] [051/130] (670s left) gem_pwrite_snooped
[355.808618] [052/130] (670s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[355.916338] Starting subtest: extended-pageflip-modeset-hang-oldfb
[355.918309] Starting dynamic subtest: pipe-A
[375.432877] Dynamic subtest pipe-A: SUCCESS (19.515s)
[375.439271] Starting dynamic subtest: pipe-B
[395.889034] Dynamic subtest pipe-B: SUCCESS (20.455s)
[395.889812] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.973s)
[396.093305] [053/130] (629s left) perf (mi-rpc)
[396.202099] Starting subtest: mi-rpc
[396.203428] Subtest mi-rpc: SKIP (0.000s)
[396.241300] [054/130] (629s left) perf_pmu (event-wait)
[396.277051] Starting subtest: event-wait
[396.277816] Starting dynamic subtest: rcs0
[396.279292] Dynamic subtest rcs0: SKIP (0.000s)
[396.280686] Subtest event-wait: SKIP (0.001s)
[396.374772] [055/130] (629s left) core_auth (basic-auth)
[396.407521] Starting subtest: basic-auth
[396.408464] Subtest basic-auth: SUCCESS (0.000s)
[396.512940] [056/130] (629s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[396.616333] Starting subtest: plane-all-transition-nonblocking-fencing
[396.618101] Starting dynamic subtest: pipe-A-HDMI-A-2
[400.860466] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.242s)
[400.909094] Starting dynamic subtest: pipe-B-HDMI-A-2
[405.150880] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.248s)
[405.171398] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (8.555s)
[405.335844] [057/130] (620s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[405.448496] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[405.449819] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[405.602956] [058/130] (620s left) gem_exec_params (mmapped)
[405.638786] Starting subtest: mmapped
[405.640463] Subtest mmapped: SUCCESS (0.001s)
[405.777590] [059/130] (620s left) gem_exec_balancer (busy)
[405.818863] Starting subtest: busy
[406.354714] Subtest busy: SUCCESS (0.536s)
[406.572014] [060/130] (619s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[406.679113] Starting subtest: cursorA-vs-flipA-legacy
[417.506836] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.828s)
[417.698072] [061/130] (608s left) kms_psr (fbc-psr2-dpms)
[417.802516] Subtest fbc-psr2-dpms: SKIP (0.000s)
[417.844961] [062/130] (608s left) api_intel_bb (bb-with-allocator)
[417.880118] Starting subtest: bb-with-allocator
[417.881489] Subtest bb-with-allocator: SUCCESS (0.002s)
[418.029296] [063/130] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[418.138725] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[418.140060] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[418.267705] [064/130] (608s left) syncobj_eventfd (binary-wait)
[418.301742] Starting subtest: binary-wait
[418.311984] Subtest binary-wait: SUCCESS (0.010s)
[418.418649] [065/130] (608s left) gem_wait (busy)
[418.464367] Starting subtest: busy
[418.465082] Starting dynamic subtest: all-engines
[419.042378] Dynamic subtest all-engines: SUCCESS (0.577s)
[419.053734] Starting dynamic subtest: rcs0
[419.565787] Dynamic subtest rcs0: SUCCESS (0.522s)
[419.572078] Starting dynamic subtest: bcs0
[420.087880] Dynamic subtest bcs0: SUCCESS (0.521s)
[420.096354] Starting dynamic subtest: vcs0
[420.612946] Dynamic subtest vcs0: SUCCESS (0.524s)
[420.623041] Starting dynamic subtest: vecs0
[421.132787] Dynamic subtest vecs0: SUCCESS (0.519s)
[421.133491] Subtest busy: SUCCESS (2.669s)
[421.345229] [066/130] (605s left) kms_big_fb (x-tiled-addfb-size-overflow)
[421.454819] Starting subtest: x-tiled-addfb-size-overflow
[421.455492] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[421.607208] [067/130] (605s left) kms_cursor_legacy (forked-move)
[421.717622] Starting subtest: forked-move
[421.718369] Starting dynamic subtest: pipe-A
[427.157278] Dynamic subtest pipe-A: SUCCESS (5.439s)
[427.163679] Starting dynamic subtest: pipe-B
[432.622081] Dynamic subtest pipe-B: SUCCESS (5.464s)
[432.633165] Starting dynamic subtest: all-pipes
[438.081754] Dynamic subtest all-pipes: SUCCESS (5.458s)
[438.082628] Subtest forked-move: SUCCESS (16.364s)
[438.190581] [068/130] (588s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[438.295431] Starting subtest: fb-8bpc-vs-panel-6bpc
[438.297062] Starting dynamic subtest: pipe-A-HDMI-A-2
[438.352731] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.055s)
[438.354033] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.057s)
[438.527862] [069/130] (588s left) kms_frontbuffer_tracking (psr-1p-rte)
[438.636076] Starting subtest: psr-1p-rte
[438.637391] Subtest psr-1p-rte: SKIP (0.000s)
[438.778587] [070/130] (588s left) kms_psr (pr-dpms)
[438.883477] Subtest pr-dpms: SKIP (0.000s)
[438.923610] [071/130] (587s left) kms_flip (bo-too-big-interruptible)
[439.033052] Starting subtest: bo-too-big-interruptible
[439.034708] Starting dynamic subtest: A-HDMI-A2
[439.877214] Dynamic subtest A-HDMI-A2: SUCCESS (0.842s)
[439.890134] Starting dynamic subtest: B-HDMI-A2
[440.658275] Dynamic subtest B-HDMI-A2: SUCCESS (0.778s)
[440.661966] Subtest bo-too-big-interruptible: SUCCESS (1.627s)
[440.861579] [072/130] (586s left) kms_content_protection (dp-mst-type-1)
[440.975436] Starting subtest: dp-mst-type-1
[440.976823] Subtest dp-mst-type-1: SKIP (0.000s)
[441.112717] [073/130] (585s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[441.218787] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[441.220990] Starting dynamic subtest: pipe-A-HDMI-A-2
[441.887897] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.657s)
[441.896973] Starting dynamic subtest: pipe-B-HDMI-A-2
[442.403742] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.514s)
[442.404876] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (1.177s)
[442.619349] [074/130] (584s left) kms_addfb_basic (invalid-get-prop-any)
[442.652305] Starting subtest: invalid-get-prop-any
[442.652993] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[442.869122] [075/130] (584s left) gem_caching (writes)
[442.906103] Starting subtest: writes
[450.877780] Subtest writes: SUCCESS (7.972s)
[451.037785] [076/130] (576s left) kms_big_fb (linear-16bpp-rotate-90)
[451.147997] Starting subtest: linear-16bpp-rotate-90
[451.221324] Subtest linear-16bpp-rotate-90: SKIP (0.072s)
[451.367944] [077/130] (575s left) gem_exec_schedule (preempt-queue-contexts-chain)
[451.413149] Starting subtest: preempt-queue-contexts-chain
[451.413860] Starting dynamic subtest: rcs0
[451.610574] Dynamic subtest rcs0: SUCCESS (0.197s)
[451.618330] Starting dynamic subtest: bcs0
[451.812526] Dynamic subtest bcs0: SUCCESS (0.201s)
[451.819679] Starting dynamic subtest: vcs0
[452.001564] Dynamic subtest vcs0: SUCCESS (0.188s)
[452.007969] Starting dynamic subtest: vecs0
[452.199201] Dynamic subtest vecs0: SUCCESS (0.197s)
[452.199948] Subtest preempt-queue-contexts-chain: SUCCESS (0.786s)
[452.554900] [078/130] (574s left) kms_scaling_modes (scaling-mode-full-aspect)
[452.659222] Starting subtest: scaling-mode-full-aspect
[452.661926] Subtest scaling-mode-full-aspect: SKIP (0.000s)
[452.771813] [079/130] (574s left) gem_lmem_swapping (heavy-verify-random)
[452.808029] Subtest heavy-verify-random: SKIP (0.000s)
[452.869738] [080/130] (574s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[452.974583] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[453.011535] [081/130] (574s left) syncobj_basic (test-valid-cycle)
[453.045395] Starting subtest: test-valid-cycle
[453.046072] Subtest test-valid-cycle: SUCCESS (0.000s)
[453.148689] [082/130] (574s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[453.257012] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[453.299173] [083/130] (574s left) gem_exec_reloc (basic-cpu-active)
[453.335689] Subtest basic-cpu-active: SKIP (0.000s)
[453.419320] [084/130] (573s left) syncobj_timeline (wait-all-complex)
[453.452414] Starting subtest: wait-all-complex
[453.665822] Subtest wait-all-complex: SUCCESS (0.213s)
[453.775643] [085/130] (573s left) kms_atomic (atomic-plane-damage)
[453.880082] Starting subtest: atomic-plane-damage
[453.954554] Starting dynamic subtest: pipe-A-HDMI-A-2
[454.248699] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.294s)
[454.251799] Subtest atomic-plane-damage: SUCCESS (0.370s)
[454.429058] [086/130] (573s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[454.534480] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[454.536329] Starting dynamic subtest: pipe-A-valid-mode
[454.579553] Dynamic subtest pipe-A-valid-mode: SKIP (0.043s)
[454.580896] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.044s)
[454.800473] [087/130] (572s left) kms_plane_alpha_blend (coverage-7efc)
[454.905116] Starting subtest: coverage-7efc
[454.994299] Starting dynamic subtest: pipe-A-HDMI-A-2
[455.453068] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.458s)
[455.474318] Starting dynamic subtest: pipe-B-HDMI-A-2
[456.019092] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.549s)
[456.019810] Subtest coverage-7efc: SUCCESS (1.114s)
[456.223431] [088/130] (571s left) api_intel_bb (simple-bb-ctx)
[456.257514] Starting subtest: simple-bb-ctx
[456.259630] Subtest simple-bb-ctx: SUCCESS (0.003s)
[456.434919] [089/130] (571s left) gem_userptr_blits (mmap-offset-banned)
[456.479837] Starting subtest: mmap-offset-banned
[456.480526] Starting dynamic subtest: gtt
[456.481226] Dynamic subtest gtt: SUCCESS (0.000s)
[456.487527] Starting dynamic subtest: wb
[456.488214] Dynamic subtest wb: SUCCESS (0.000s)
[456.494510] Starting dynamic subtest: wc
[456.495191] Dynamic subtest wc: SUCCESS (0.000s)
[456.501496] Starting dynamic subtest: uc
[456.502173] Dynamic subtest uc: SUCCESS (0.000s)
[456.502852] Subtest mmap-offset-banned: SUCCESS (0.004s)
[456.654575] [090/130] (570s left) gem_userptr_blits (unsync-unmap)
[456.690845] Subtest unsync-unmap: SKIP (0.000s)
[456.890673] [091/130] (570s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[456.997807] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[456.999152] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[457.139342] [092/130] (570s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[457.251175] Starting subtest: 4-tiled-32bpp-rotate-0
[457.252472] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[457.394822] [093/130] (570s left) gen9_exec_parse (bb-oversize)
[457.430369] Subtest bb-oversize: SKIP (0.000s)
[457.471843] [094/130] (570s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[457.579979] Starting subtest: cursor-rapid-movement-64x64
[457.582790] Starting dynamic subtest: pipe-A-HDMI-A-2
[458.005107] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.421s)
[458.031475] Starting dynamic subtest: pipe-B-HDMI-A-2
[458.323360] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.297s)
[458.324215] Subtest cursor-rapid-movement-64x64: SUCCESS (0.744s)
[458.514444] [095/130] (569s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[458.554561] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[458.555327] Starting dynamic subtest: smem
[458.695123] Dynamic subtest smem: SUCCESS (0.140s)
[458.695842] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.141s)
[458.913371] [096/130] (568s left) gem_unref_active_buffers
[459.122446] [097/130] (568s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[459.233772] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[459.656369] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.422s)
[459.841344] [098/130] (568s left) core_getclient
[459.965459] [099/130] (568s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[460.077286] Starting subtest: y-tiled-64bpp-rotate-180
[462.749714] Subtest y-tiled-64bpp-rotate-180: SUCCESS (2.672s)
[463.007177] [100/130] (565s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[463.116285] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[463.117643] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[463.235162] [101/130] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[463.344269] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[463.345619] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[463.475114] [102/130] (564s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[463.581161] Starting subtest: primary-yf-tiled-reflect-x-180
[463.698921] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.116s)
[463.815685] [103/130] (564s left) kms_cursor_crc (cursor-random-64x64)
[463.926130] Starting subtest: cursor-random-64x64
[463.928839] Starting dynamic subtest: pipe-A-HDMI-A-2
[468.109583] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.180s)
[468.137840] Starting dynamic subtest: pipe-B-HDMI-A-2
[472.203927] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.072s)
[472.204608] Subtest cursor-random-64x64: SUCCESS (8.278s)
[472.398712] [104/130] (555s left) perf_pmu (init-busy)
[472.433676] Starting subtest: init-busy
[472.434357] Starting dynamic subtest: rcs0
[472.435039] Dynamic subtest rcs0: SUCCESS (0.001s)
[472.441504] Starting dynamic subtest: bcs0
[472.442202] Dynamic subtest bcs0: SUCCESS (0.000s)
[472.448517] Starting dynamic subtest: vcs0
[472.449191] Dynamic subtest vcs0: SUCCESS (0.000s)
[472.455233] Starting dynamic subtest: vecs0
[472.455901] Dynamic subtest vecs0: SUCCESS (0.000s)
[472.457025] Subtest init-busy: SUCCESS (0.004s)
[472.526125] [105/130] (555s left) perf (per-context-mode-unprivileged)
[472.614008] Starting subtest: per-context-mode-unprivileged
[472.615384] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[472.667107] [106/130] (555s left) gem_ctx_persistence (engines-mixed-process)
[472.701989] Starting subtest: engines-mixed-process
[472.702701] Starting dynamic subtest: rcs0
[473.103762] Dynamic subtest rcs0: SUCCESS (0.401s)
[473.116792] Starting dynamic subtest: bcs0
[473.505982] Dynamic subtest bcs0: SUCCESS (0.399s)
[473.526536] Starting dynamic subtest: vcs0
[473.886942] Dynamic subtest vcs0: SUCCESS (0.378s)
[473.896202] Starting dynamic subtest: vecs0
[474.287899] Dynamic subtest vecs0: SUCCESS (0.398s)
[474.291785] Subtest engines-mixed-process: SUCCESS (1.587s)
[474.393153] [107/130] (553s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[474.500731] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[474.502061] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[474.639714] [108/130] (553s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[474.749811] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[474.751135] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[474.886909] [109/130] (553s left) i915_pm_freq_api (freq-suspend)
[474.925104] Subtest freq-suspend: SKIP (0.000s)
[474.975712] [110/130] (553s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[475.009967] Starting subtest: multi-wait-for-submit-available-submitted
[475.010675] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[475.114617] [111/130] (553s left) kms_chamelium_audio (dp-audio-edid)
[475.253857] Subtest dp-audio-edid: SKIP (0.000s)
[475.322175] [112/130] (553s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[475.435282] Starting subtest: x-tiled-32bpp-rotate-0
[477.648652] Subtest x-tiled-32bpp-rotate-0: SUCCESS (2.213s)
[477.868413] [113/130] (550s left) gem_ccs (ctrl-surf-copy-new-ctx)
[477.906727] Starting subtest: ctrl-surf-copy-new-ctx
[477.908217] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[477.982245] [114/130] (550s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[478.091168] Starting subtest: fbcpsr-tiling-4
[478.092493] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[478.247130] [115/130] (550s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[478.352682] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[478.354159] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[478.460939] [116/130] (550s left) kms_pm_rpm (cursor)
[479.898462] Starting subtest: cursor
[481.394110] Subtest cursor: SUCCESS (1.499s)
[481.565545] [117/130] (547s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[481.671537] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[481.673571] Starting dynamic subtest: pipe-A-HDMI-A-2
[481.680293] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[481.686932] Starting dynamic subtest: pipe-B-HDMI-A-2
[481.693427] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[481.694756] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[481.913298] [118/130] (546s left) kms_addfb_basic (unused-handle)
[481.945692] Starting subtest: unused-handle
[481.946468] Subtest unused-handle: SUCCESS (0.000s)
[482.160206] [119/130] (546s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[482.268259] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[482.269617] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[482.410503] [120/130] (546s left) gem_mmap_gtt (basic-write)
[482.445566] Starting subtest: basic-write
[482.663344] Subtest basic-write: SUCCESS (0.218s)
[482.815341] [121/130] (546s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[482.923181] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[482.924615] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[483.070922] [122/130] (545s left) prime_mmap_coherency (read)
[483.107405] Starting subtest: read
[488.481732] Subtest read: SUCCESS (5.373s)
[488.621773] [123/130] (540s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[488.654258] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[488.756695] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s)
[488.837405] [124/130] (540s left) gem_exec_flush (basic-batch-kernel-default-uc)
[488.878943] Starting subtest: basic-batch-kernel-default-uc
[494.670901] Subtest basic-batch-kernel-default-uc: SUCCESS (5.792s)
[494.918559] [125/130] (534s left) syncobj_wait (multi-wait-submitted)
[494.951562] Starting subtest: multi-wait-submitted
[495.070110] Subtest multi-wait-submitted: SUCCESS (0.108s)
[495.175895] [126/130] (533s left) kms_setmode (invalid-clone-exclusive-crtc)
[495.209777] Starting subtest: invalid-clone-exclusive-crtc
[495.211791] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[495.308261] [127/130] (533s left) gem_softpin (allocator-basic-reserve)
[495.344091] Starting subtest: allocator-basic-reserve
[495.407311] Subtest allocator-basic-reserve: SUCCESS (0.063s)
[495.555575] [128/130] (533s left) fbdev (nullptr)
[495.596382] Starting subtest: nullptr
[495.597068] Subtest nullptr: SUCCESS (0.000s)
[495.682337] [129/130] (533s left) kms_prop_blob (blob-prop-core)
[495.715751] Starting subtest: blob-prop-core
[495.716444] Subtest blob-prop-core: SUCCESS (0.000s)
[495.819190] [130/130] (533s left) gem_exec_balancer (parallel)
[495.983085] Subtest parallel: SKIP (0.000s)
[496.084387] Closing watchdogs
Done.