[61.113882] Initializing watchdogs
[61.113950]   /dev/watchdog0
[61.134112] [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]
[61.138414] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.140362] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.147156] [001/131] (960s left) gem_exec_balancer (bonded-pair)
[61.216186] Starting subtest: bonded-pair
[62.378573] Subtest bonded-pair: SUCCESS (1.183s)
[62.535464] [002/131] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[62.634600] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[62.689707] [003/131] (959s left) kms_getfb (getfb-handle-valid)
[62.786774] Starting subtest: getfb-handle-valid
[62.794404] Subtest getfb-handle-valid: SUCCESS (0.000s)
[62.872918] [004/131] (958s left) kms_psr (psr2-suspend)
[62.980817] Subtest psr2-suspend: SKIP (0.000s)
[63.032443] [005/131] (958s left) syncobj_eventfd (binary-wait)
[63.092660] Starting subtest: binary-wait
[63.098302] Subtest binary-wait: SUCCESS (0.011s)
[63.157212] [006/131] (958s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[63.302724] Subtest cursorA-vs-flipB-toggle: SKIP (0.000s)
[63.362486] [007/131] (958s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[63.419447] Starting subtest: yf-tiled-to-vebox-y-tiled
[63.425022] Starting dynamic subtest: smem
[63.550912] Dynamic subtest smem: SUCCESS (0.133s)
[63.556600] Subtest yf-tiled-to-vebox-y-tiled: SUCCESS (0.133s)
[63.723523] [008/131] (958s left) kms_plane (planar-pixel-format-settings)
[63.810100] Starting subtest: planar-pixel-format-settings
[63.823564] Subtest planar-pixel-format-settings: SKIP (0.000s)
[63.865955] [009/131] (958s left) dumb_buffer (create-clear)
[63.922379] Starting subtest: create-clear
[101.639088] Subtest create-clear: SUCCESS (37.832s)
[101.699527] [010/131] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[101.863653] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[101.920715] [011/131] (920s left) gen7_exec_parse (oacontrol-tracking)
[101.982911] Subtest oacontrol-tracking: SKIP (0.000s)
[102.045922] [012/131] (920s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[102.144214] Subtest x-tiled-64bpp-rotate-180: SKIP (0.000s)
[102.195657] [013/131] (920s left) kms_frontbuffer_tracking (psr-1p-rte)
[102.314027] Subtest psr-1p-rte: SKIP (0.000s)
[102.375693] [014/131] (920s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[102.431064] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[102.526402] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[102.587485] [015/131] (919s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[102.687198] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[102.704331] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[102.766165] [016/131] (919s left) syncobj_wait (invalid-reset-illegal-handle)
[102.822781] Starting subtest: invalid-reset-illegal-handle
[102.828685] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[102.878174] [017/131] (919s left) kms_psr (pr-sprite-blt)
[102.985254] Subtest pr-sprite-blt: SKIP (0.000s)
[103.027792] [018/131] (919s left) syncobj_wait (single-wait-submitted)
[103.078660] Starting subtest: single-wait-submitted
[103.178615] Subtest single-wait-submitted: SUCCESS (0.108s)
[103.236145] [019/131] (919s left) kms_pipe_crc_basic (read-crc)
[103.337163] Subtest read-crc: SKIP (0.000s)
[103.388179] [020/131] (919s left) syncobj_timeline (invalid-query-bad-pad)
[103.439266] Starting subtest: invalid-query-bad-pad
[103.444830] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[103.500332] [021/131] (919s left) kms_psr (fbc-psr-sprite-render)
[103.592938] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[103.643553] [022/131] (919s left) kms_psr (psr-sprite-render)
[103.739220] Subtest psr-sprite-render: SKIP (0.000s)
[103.791617] [023/131] (919s left) kms_atomic_interruptible (legacy-setmode)
[103.888855] Subtest legacy-setmode: SKIP (0.000s)
[103.938572] [024/131] (918s left) kms_flip (2x-flip-vs-dpms-on-nop)
[104.036726] Starting subtest: 2x-flip-vs-dpms-on-nop
[104.048145] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.000s)
[104.098374] [025/131] (918s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[104.194152] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[104.199814] Starting dynamic subtest: pipe-A
[104.211157] Dynamic subtest pipe-A: SKIP (0.000s)
[104.223277] Starting dynamic subtest: pipe-B
[104.235160] Dynamic subtest pipe-B: SKIP (0.000s)
[104.247033] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.000s)
[104.310192] [026/131] (918s left) kms_cursor_crc (cursor-random-32x10)
[104.408268] Subtest cursor-random-32x10: SKIP (0.000s)
[104.460455] [027/131] (918s left) kms_vblank (crtc-id)
[104.559317] Subtest crtc-id: SKIP (0.000s)
[104.610569] [028/131] (918s left) kms_addfb_basic (master-rmfb)
[104.661230] Starting subtest: master-rmfb
[104.666711] Subtest master-rmfb: SUCCESS (0.001s)
[104.778555] [029/131] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[104.874347] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[104.935305] [030/131] (918s left) sw_sync (sync_multi_consumer_producer)
[104.980938] Starting subtest: sync_multi_consumer_producer
[105.295305] Subtest sync_multi_consumer_producer: SUCCESS (0.310s)
[105.344256] [031/131] (917s left) gem_spin_batch (spin-all)
[105.395950] Starting subtest: spin-all
[105.407821] Subtest spin-all: SUCCESS (0.008s)
[105.573712] [032/131] (917s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[105.674555] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[105.734489] [033/131] (917s left) kms_chamelium_frames (vga-frame-dump)
[105.834217] Subtest vga-frame-dump: SKIP (0.000s)
[105.875058] [034/131] (917s left) i915_getparams_basic (basic-subslice-total)
[105.927206] Starting subtest: basic-subslice-total
[105.938402] Subtest basic-subslice-total: SUCCESS (0.000s)
[105.979326] [035/131] (917s left) gem_gpgpu_fill (basic)
[106.026689] Starting subtest: basic
[106.032267] Starting dynamic subtest: smem
[106.037856] Dynamic subtest smem: SUCCESS (0.004s)
[106.043435] Subtest basic: SUCCESS (0.004s)
[106.142516] [036/131] (917s left) prime_mmap (test_map_unmap)
[106.194758] Starting subtest: test_map_unmap
[106.200262] Starting dynamic subtest: test_map_unmap-smem
[106.232932] Dynamic subtest test_map_unmap-smem: SUCCESS (0.047s)
[106.238679] Subtest test_map_unmap: SUCCESS (0.047s)
[106.293896] [037/131] (917s left) gem_busy (parallel)
[106.466460] Starting subtest: parallel
[106.472288] Starting dynamic subtest: rcs0
[106.546758] Dynamic subtest rcs0: SUCCESS (0.063s)
[106.575211] Starting dynamic subtest: bcs0
[106.588406] Dynamic subtest bcs0: SUCCESS (0.028s)
[106.606981] Starting dynamic subtest: vcs0
[106.620543] Dynamic subtest vcs0: SUCCESS (0.025s)
[106.640621] Starting dynamic subtest: vecs0
[106.646682] Dynamic subtest vecs0: SUCCESS (0.030s)
[106.653094] Subtest parallel: SUCCESS (0.148s)
[106.832557] [038/131] (916s left) kms_content_protection (uevent)
[106.935363] Subtest uevent: SKIP (0.000s)
[106.987477] [039/131] (916s left) api_intel_allocator (simple-allocator)
[107.039250] Starting subtest: simple-allocator
[107.044757] Starting dynamic subtest: basic
[107.050253] Dynamic subtest basic: SUCCESS (0.002s)
[107.059759] Starting dynamic subtest: parallel-one
[107.187857] Dynamic subtest parallel-one: SUCCESS (0.155s)
[107.197659] Starting dynamic subtest: print
[107.203267] Dynamic subtest print: SUCCESS (0.000s)
[107.212917] Starting dynamic subtest: reuse
[107.218769] Dynamic subtest reuse: SUCCESS (0.000s)
[107.230866] Starting dynamic subtest: reserve
[107.236492] Dynamic subtest reserve: SUCCESS (0.000s)
[107.250275] Starting dynamic subtest: fork-reopen-allocator
[107.256258] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[107.262294] Subtest simple-allocator: SUCCESS (0.169s)
[107.317688] [040/131] (916s left) gem_userptr_blits (forbidden-operations)
[107.386537] Starting subtest: forbidden-operations
[107.398112] Subtest forbidden-operations: SKIP (0.000s)
[107.471131] [041/131] (916s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[107.577804] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[107.628775] [042/131] (916s left) kms_joiner (basic-force-ultra-joiner)
[107.734600] Starting subtest: basic-force-ultra-joiner
[107.745951] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[107.796499] [043/131] (916s left) kms_psr (fbc-psr2-suspend)
[107.896880] Subtest fbc-psr2-suspend: SKIP (0.000s)
[107.945410] [044/131] (916s left) gem_ringfill (engines-basic)
[108.158354] Starting subtest: engines-basic
[108.164185] Starting dynamic subtest: rcs0
[108.204053] Dynamic subtest rcs0: SUCCESS (0.049s)
[108.226837] Starting dynamic subtest: bcs0
[108.232915] Dynamic subtest bcs0: SUCCESS (0.021s)
[108.251833] Starting dynamic subtest: vcs0
[108.257870] Dynamic subtest vcs0: SUCCESS (0.024s)
[108.275287] Starting dynamic subtest: vecs0
[108.280947] Dynamic subtest vecs0: SUCCESS (0.024s)
[108.286838] Subtest engines-basic: SUCCESS (0.121s)
[108.338809] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[108.345331] [045/131] (915s left) kms_pm_rpm (legacy-planes)
[109.642254] Starting subtest: legacy-planes
[109.654868] Subtest legacy-planes: SKIP (0.000s)
[109.708570] [046/131] (914s left) kms_flip (2x-flip-vs-rmfb)
[109.858870] Starting subtest: 2x-flip-vs-rmfb
[109.869883] Subtest 2x-flip-vs-rmfb: SKIP (0.000s)
[109.932519] [047/131] (914s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[109.984895] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[109.990765] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[110.057380] [048/131] (914s left) vgem_basic (mmap)
[110.109492] Starting subtest: mmap
[110.115065] Subtest mmap: SUCCESS (0.008s)
[110.173429] [049/131] (914s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[110.273892] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s)
[110.326705] [050/131] (914s left) gem_userptr_blits (sync-unmap)
[110.401262] Starting subtest: sync-unmap
[110.406652] Subtest sync-unmap: SUCCESS (0.013s)
[110.477523] [051/131] (913s left) core_setmaster (master-drop-set-root)
[110.532919] Starting subtest: master-drop-set-root
[110.544133] Subtest master-drop-set-root: SUCCESS (0.001s)
[110.602269] [052/131] (913s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[110.697803] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[110.759479] [053/131] (913s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[110.852485] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[110.863570] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[110.906650] [054/131] (913s left) gem_exec_schedule (submit-golden-slice)
[111.002185] Starting subtest: submit-golden-slice
[111.007796] Starting dynamic subtest: rcs0
[111.013187] Dynamic subtest rcs0: SUCCESS (0.019s)
[111.023062] Starting dynamic subtest: bcs0
[111.028593] Dynamic subtest bcs0: SUCCESS (0.018s)
[111.038336] Starting dynamic subtest: vcs0
[111.043870] Dynamic subtest vcs0: SUCCESS (0.020s)
[111.053457] Starting dynamic subtest: vecs0
[111.059261] Dynamic subtest vecs0: SUCCESS (0.018s)
[111.065073] Subtest submit-golden-slice: SUCCESS (0.075s)
[111.329562] [055/131] (913s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[292.139391] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[303.301802] Closing watchdogs
[303.305679] Initializing watchdogs
[303.305741]   /dev/watchdog0
[303.319900] [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]
[303.326507] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[303.327571] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[303.328427] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[303.334576] [056/131] (721s left) kms_big_fb (linear-32bpp-rotate-180)
[303.445799] Subtest linear-32bpp-rotate-180: SKIP (0.000s)
[303.500490] [057/131] (721s left) gem_ctx_persistence (heartbeat-stop)
[303.564877] Starting subtest: heartbeat-stop
[303.780662] Subtest heartbeat-stop: SUCCESS (0.223s)
[303.844671] [058/131] (720s left) sysfs_preempt_timeout (idempotent)
[303.907660] Starting subtest: idempotent
[303.913181] Starting dynamic subtest: vecs0
[303.918941] Dynamic subtest vecs0: SUCCESS (0.000s)
[303.942856] Starting dynamic subtest: vcs0
[303.952366] Dynamic subtest vcs0: SUCCESS (0.000s)
[303.976232] Starting dynamic subtest: bcs0
[303.982272] Dynamic subtest bcs0: SUCCESS (0.000s)
[304.001212] Starting dynamic subtest: rcs0
[304.007067] Dynamic subtest rcs0: SUCCESS (0.000s)
[304.013362] Subtest idempotent: SUCCESS (0.003s)
[304.078456] [059/131] (720s left) kms_flip (2x-dpms-vs-vblank-race)
[304.188017] Starting subtest: 2x-dpms-vs-vblank-race
[304.202832] Subtest 2x-dpms-vs-vblank-race: SKIP (0.000s)
[304.287170] [060/131] (720s left) gem_eio (suspend)
[304.372984] Starting subtest: suspend
[350.012060] Subtest suspend: SUCCESS (45.642s)
[357.124261] [061/131] (674s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[357.227334] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s)
[357.284810] [062/131] (674s left) gem_userptr_blits (unsync-unmap)
[357.364650] Subtest unsync-unmap: SKIP (0.000s)
[357.448621] [063/131] (674s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[357.550369] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[357.611150] [064/131] (674s left) kms_pm_rpm (pm-caching)
[358.915226] Starting subtest: pm-caching
[360.240464] Subtest pm-caching: SUCCESS (1.327s)
[360.303511] [065/131] (671s left) gem_exec_balancer (full-pulse)
[360.359874] Starting subtest: full-pulse
[361.941697] Subtest full-pulse: SUCCESS (1.587s)
[362.106438] [066/131] (670s left) kms_dp_link_training (uhbr-mst)
[362.206326] Subtest uhbr-mst: SKIP (0.000s)
[362.277493] [067/131] (670s left) kms_psr (fbc-pr-sprite-blt)
[362.378806] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[362.425710] [068/131] (670s left) gen9_exec_parse (batch-zero-length)
[362.483850] Subtest batch-zero-length: SKIP (0.000s)
[362.550363] [069/131] (669s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[362.651901] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[362.657673] Starting dynamic subtest: pipe-A
[362.668689] Dynamic subtest pipe-A: SKIP (0.000s)
[362.689180] Starting dynamic subtest: pipe-B
[362.701265] Dynamic subtest pipe-B: SKIP (0.000s)
[362.713814] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.000s)
[362.784549] [070/131] (669s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[362.886267] Subtest fbc-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[362.959513] [071/131] (669s left) gem_exec_params (invalid-batch-start-offset)
[363.014612] Starting subtest: invalid-batch-start-offset
[363.020125] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[363.138815] [072/131] (669s left) kms_getfb (getfb2-handle-closed)
[363.235324] Starting subtest: getfb2-handle-closed
[363.244340] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[363.312600] [073/131] (669s left) gem_userptr_blits (map-fixed-invalidate-busy)
[363.393546] Starting subtest: map-fixed-invalidate-busy
[363.398949] Starting dynamic subtest: gtt
[364.288809] Dynamic subtest gtt: SUCCESS (0.913s)
[364.300269] Starting dynamic subtest: wb
[365.174770] Dynamic subtest wb: SUCCESS (0.886s)
[365.187254] Starting dynamic subtest: wc
[366.058411] Dynamic subtest wc: SUCCESS (0.886s)
[366.069653] Starting dynamic subtest: uc
[366.958499] Dynamic subtest uc: SUCCESS (0.902s)
[366.967555] Subtest map-fixed-invalidate-busy: SUCCESS (3.588s)
[367.074650] [074/131] (665s left) gem_eio (throttle)
[367.154928] Starting subtest: throttle
[367.248666] Subtest throttle: SUCCESS (0.093s)
[367.363740] [075/131] (665s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[367.470144] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[367.545655] [076/131] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[367.640839] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[367.701509] [077/131] (665s left) gem_userptr_blits (stress-mm)
[367.784419] Starting subtest: stress-mm
[373.138452] Subtest stress-mm: SUCCESS (5.369s)
[373.236434] [078/131] (659s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[373.347988] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[373.405889] [079/131] (659s left) gem_fence_thrash (bo-write-verify-threaded-none)
[373.460053] Starting subtest: bo-write-verify-threaded-none
[380.496656] Subtest bo-write-verify-threaded-none: SUCCESS (7.035s)
[380.609442] [080/131] (652s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[380.730952] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[380.794498] [081/131] (652s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[380.903874] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[380.972097] [082/131] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[381.074811] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[381.152285] [083/131] (652s left) gem_ctx_persistence (legacy-engines-mixed-process)
[381.210128] Starting subtest: legacy-engines-mixed-process
[381.215735] Starting dynamic subtest: render
[381.605948] Dynamic subtest render: SUCCESS (0.392s)
[381.618120] Starting dynamic subtest: bsd
[381.987350] Dynamic subtest bsd: SUCCESS (0.390s)
[381.999427] Starting dynamic subtest: blt
[382.391498] Dynamic subtest blt: SUCCESS (0.400s)
[382.409138] Starting dynamic subtest: vebox
[382.812727] Dynamic subtest vebox: SUCCESS (0.419s)
[382.820896] Subtest legacy-engines-mixed-process: SUCCESS (1.606s)
[382.885861] [084/131] (650s left) gen3_render_linear_blits
[383.016564] [085/131] (650s left) gem_exec_suspend (basic-s3)
[383.079362] Starting subtest: basic-S3
[383.085053] Starting dynamic subtest: smem
[401.850382] Dynamic subtest smem: SUCCESS (4.012s)
[401.861781] Subtest basic-S3: SUCCESS (4.013s)
[408.062728] [086/131] (631s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[408.140475] Starting subtest: map-fixed-invalidate-overlap-busy
[408.146146] Starting dynamic subtest: gtt
[409.088973] Dynamic subtest gtt: SUCCESS (0.969s)
[409.100803] Starting dynamic subtest: wb
[410.039188] Dynamic subtest wb: SUCCESS (0.949s)
[410.050904] Starting dynamic subtest: wc
[410.999536] Dynamic subtest wc: SUCCESS (0.957s)
[411.011427] Starting dynamic subtest: uc
[411.932669] Dynamic subtest uc: SUCCESS (0.945s)
[411.938004] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (3.821s)
[412.050209] [087/131] (627s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[412.157315] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[412.212827] [088/131] (627s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[412.268242] Starting subtest: multi-wait-for-submit-available-signaled
[412.273583] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[412.320958] [089/131] (627s left) gem_tiling_max_stride
[412.483003] [090/131] (627s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[412.585212] Subtest cursor-rapid-movement-128x128: SKIP (0.000s)
[412.636138] [091/131] (627s left) gem_mmap_offset (mmap-boundaries)
[412.694774] Starting subtest: mmap-boundaries
[412.700095] Starting dynamic subtest: smem0
[413.838992] Dynamic subtest smem0: SUCCESS (1.178s)
[413.846884] Subtest mmap-boundaries: SUCCESS (1.178s)
[413.993067] [092/131] (626s left) gem_exec_schedule (semaphore-noskip)
[414.092926] Starting subtest: semaphore-noskip
[414.198847] Subtest semaphore-noskip: SUCCESS (0.155s)
[414.458211] [093/131] (625s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[414.561420] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[414.626916] [094/131] (625s left) kms_lease (atomic-implicit-crtc)
[414.731414] Subtest atomic-implicit-crtc: SKIP (0.000s)
[414.792781] [095/131] (625s left) kms_cursor_edge_walk (64x64-right-edge)
[414.904269] Subtest 64x64-right-edge: SKIP (0.000s)
[414.972914] [096/131] (625s left) api_intel_allocator (open-vm)
[415.030333] Starting subtest: open-vm
[415.036103] Subtest open-vm: SUCCESS (0.002s)
[415.143355] [097/131] (625s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[415.201710] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[415.269982] [098/131] (625s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[415.368417] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s)
[415.436514] [099/131] (625s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[415.495568] Starting subtest: invalid-multi-wait-unsubmitted
[415.503969] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[415.566959] [100/131] (625s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[415.673384] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.000s)
[415.740433] [101/131] (624s left) kms_chamelium_color (gamma)
[415.853309] Subtest gamma: SKIP (0.000s)
[415.914845] [102/131] (624s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[416.030980] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[416.082180] [103/131] (624s left) kms_atomic (plane-cursor-legacy)
[416.185586] Subtest plane-cursor-legacy: SKIP (0.000s)
[416.247679] [104/131] (624s left) gem_fence_thrash (bo-copy)
[416.294008] Starting subtest: bo-copy
[417.530555] Subtest bo-copy: SUCCESS (1.252s)
[417.643086] [105/131] (623s left) gem_ctx_param (invalid-ctx-get)
[417.701311] Starting subtest: invalid-ctx-get
[417.707207] Subtest invalid-ctx-get: SUCCESS (0.000s)
[417.767702] [106/131] (623s left) i915_query (engine-info-invalid)
[417.821199] Starting subtest: engine-info-invalid
[417.826830] Subtest engine-info-invalid: SUCCESS (0.000s)
[417.890809] [107/131] (623s left) i915_pm_rpm (debugfs-forcewake-user)
[419.197308] Starting subtest: debugfs-forcewake-user
[429.569594] Subtest debugfs-forcewake-user: SUCCESS (10.447s)
[429.623056] [108/131] (611s left) gem_exec_reloc (basic-cpu-active)
[429.718281] Subtest basic-cpu-active: SKIP (0.000s)
[429.796812] [109/131] (611s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[429.915368] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[429.967601] [110/131] (611s left) kms_universal_plane (universal-plane-pageflip-windowed)
[430.073790] Subtest universal-plane-pageflip-windowed: SKIP (0.000s)
[430.136765] [111/131] (611s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[430.241461] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[430.303038] [112/131] (611s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[430.413327] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[430.482831] [113/131] (610s left) kms_flip (flip-vs-absolute-wf_vblank)
[430.589359] Starting subtest: flip-vs-absolute-wf_vblank
[430.600571] Subtest flip-vs-absolute-wf_vblank: SKIP (0.001s)
[430.687243] [114/131] (610s left) gem_userptr_blits (usage-restrictions)
[430.765032] Starting subtest: usage-restrictions
[430.771004] Subtest usage-restrictions: SUCCESS (0.000s)
[430.868102] [115/131] (610s left) kms_properties (invalid-properties-atomic)
[430.965004] Starting subtest: invalid-properties-atomic
[431.034263] Subtest invalid-properties-atomic: SUCCESS (0.077s)
[431.095469] [116/131] (610s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[431.202131] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[431.260234] [117/131] (610s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[431.314033] Starting subtest: cpuset-basic-small-copy-XY
[438.785915] Subtest cpuset-basic-small-copy-XY: SUCCESS (7.494s)
[438.855436] [118/131] (602s left) gem_close_race (basic-threads)
[438.941545] Starting subtest: basic-threads
[440.157307] Subtest basic-threads: SUCCESS (1.224s)
[440.347066] [119/131] (601s left) kms_flip (2x-blocking-absolute-wf_vblank)
[440.451521] Starting subtest: 2x-blocking-absolute-wf_vblank
[440.462718] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.000s)
[440.525980] [120/131] (601s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[440.624716] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[440.669827] [121/131] (601s left) gem_exec_create (legacy)
[440.721297] Starting subtest: legacy
[440.726729] Starting dynamic subtest: smem
[442.868334] Dynamic subtest smem: SUCCESS (2.148s)
[442.873948] Subtest legacy: SUCCESS (2.149s)
[443.035791] [122/131] (598s left) kms_vrr (seamless-rr-switch-virtual)
[443.135305] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[443.189996] [123/131] (598s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[443.287541] Subtest plane-use-after-nonblocking-unbind-fencing: SKIP (0.000s)
[443.348364] [124/131] (598s left) gem_exec_schedule (pi-common)
[443.525127] Starting subtest: pi-common
[443.530896] Starting dynamic subtest: rcs0
[443.612389] Dynamic subtest rcs0: SUCCESS (0.084s)
[443.632225] Starting dynamic subtest: bcs0
[443.910736] Dynamic subtest bcs0: SUCCESS (0.292s)
[443.926722] Starting dynamic subtest: vcs0
[443.986331] Dynamic subtest vcs0: SUCCESS (0.081s)
[444.008344] Starting dynamic subtest: vecs0
[444.069616] Dynamic subtest vecs0: SUCCESS (0.081s)
[444.075921] Subtest pi-common: SUCCESS (0.543s)
[444.245083] [125/131] (597s left) gem_eio (in-flight-contexts-immediate)
[444.305815] Starting subtest: in-flight-contexts-immediate
[455.628070] Subtest in-flight-contexts-immediate: SUCCESS (11.325s)
[455.735472] [126/131] (586s left) syncobj_timeline (wait-all-snapshot)
[455.793326] Starting subtest: wait-all-snapshot
[455.866903] Subtest wait-all-snapshot: SUCCESS (0.082s)
[455.936181] [127/131] (586s left) kms_setmode (basic-clone-single-crtc)
[455.989656] Starting subtest: basic-clone-single-crtc
[456.014329] Subtest basic-clone-single-crtc: SKIP (0.000s)
[456.083166] [128/131] (586s left) perf_pmu (busy-check-all)
[456.140576] Starting subtest: busy-check-all
[456.146253] Starting dynamic subtest: rcs0
[456.844838] Dynamic subtest rcs0: SUCCESS (0.702s)
[456.857396] Starting dynamic subtest: bcs0
[457.365655] Dynamic subtest bcs0: SUCCESS (0.524s)
[457.389224] Starting dynamic subtest: vcs0
[457.885946] Dynamic subtest vcs0: SUCCESS (0.525s)
[457.902415] Starting dynamic subtest: vecs0
[458.418576] Dynamic subtest vecs0: SUCCESS (0.524s)
[458.424824] Subtest busy-check-all: SUCCESS (2.278s)
[458.496920] [129/131] (583s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[458.606748] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[458.672885] [130/131] (583s left) perf_pmu (module-unload)
[458.734618] Starting subtest: module-unload
[463.996723] Subtest module-unload: FAIL (4.920s)
[464.052060] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[464.052828] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[464.059066] [131/131] (578s left) gem_ctx_engines (none)
[466.815699] Starting subtest: none
[466.821269] Subtest none: SUCCESS (0.002s)
[466.991175] [FACT gem_ctx_engines (none)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[466.992216] [FACT gem_ctx_engines (none)] new: kernel.kmod_is_loaded.i915: true
[466.992904] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: dumb_buffer
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gen7_exec_parse
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_pipe_crc_basic
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_atomic_interruptible
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: sw_sync
results: parsing output: 30/ for test: gem_spin_batch
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_chamelium_frames
results: parsing output: 33/ for test: i915_getparams_basic
results: parsing output: 34/ for test: gem_gpgpu_fill
results: parsing output: 35/ for test: prime_mmap
results: parsing output: 36/ for test: gem_busy
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_joiner
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_ringfill
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: core_setmaster
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: sysfs_preempt_timeout
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_dp_link_training
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_getfb
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_fence_thrash
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: gen3_render_linear_blits
results: parsing output: 84/ for test: gem_exec_suspend
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_tiling_max_stride
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: gem_mmap_offset
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: kms_lease
results: parsing output: 94/ for test: kms_cursor_edge_walk
results: parsing output: 95/ for test: api_intel_allocator
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_chamelium_color
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: kms_atomic
results: parsing output: 103/ for test: gem_fence_thrash
results: parsing output: 104/ for test: gem_ctx_param
results: parsing output: 105/ for test: i915_query
results: parsing output: 106/ for test: i915_pm_rpm
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_universal_plane
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_properties
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: gem_close_race
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_create
results: parsing output: 121/ for test: kms_vrr
results: parsing output: 122/ for test: kms_atomic_transition
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: gem_eio
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_setmode
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: gem_ctx_engines
Done.