[45.005762] Initializing watchdogs
[45.005820]   /dev/watchdog0
[45.020967] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[45.026459] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.028942] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[45.030780] [001/133] (960s left) gen9_exec_parse (unaligned-jump)
[45.073965] Subtest unaligned-jump: SKIP (0.000s)
[45.113137] [002/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[45.203715] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[46.576577] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (1.373s)
[46.730352] [003/133] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[46.821552] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[47.943907] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (1.107s)
[48.103171] [004/133] (957s left) gem_spin_batch (legacy)
[48.143246] Starting subtest: legacy
[48.144005] Starting dynamic subtest: default
[51.491463] Dynamic subtest default: SUCCESS (3.264s)
[51.499889] Starting dynamic subtest: render
[54.863967] Dynamic subtest render: SUCCESS (3.298s)
[54.872463] Starting dynamic subtest: bsd
[58.199434] Dynamic subtest bsd: SUCCESS (3.304s)
[58.207866] Starting dynamic subtest: bsd1
[61.523632] Dynamic subtest bsd1: SUCCESS (3.304s)
[61.531556] Starting dynamic subtest: bsd2
[64.844622] Dynamic subtest bsd2: SUCCESS (3.308s)
[64.853030] Starting dynamic subtest: blt
[68.164642] Dynamic subtest blt: SUCCESS (3.311s)
[68.173446] Starting dynamic subtest: vebox
[71.485066] Dynamic subtest vebox: SUCCESS (3.314s)
[71.486000] Subtest legacy: SUCCESS (23.109s)
[71.638307] [005/133] (934s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[71.726442] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[72.282234] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.555s)
[72.426045] [006/133] (933s left) gem_exec_fence (syncobj-signal)
[72.776101] Starting subtest: syncobj-signal
[72.778545] Subtest syncobj-signal: SUCCESS (0.002s)
[73.089649] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[73.091713] [007/133] (932s left) drm_buddy (drm_buddy)
[73.122180] Starting subtest: drm_buddy
[73.127837] Starting dynamic subtest: drm_test_buddy_alloc_limit
[73.207426] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.079s)
[73.222954] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[73.294088] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.086s)
[73.309695] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[73.380460] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.085s)
[73.396234] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[73.480143] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.099s)
[73.495952] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[73.580513] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.099s)
[73.595240] Starting dynamic subtest: drm_test_buddy_alloc_clear
[73.716652] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.137s)
[73.722721] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[73.809210] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.092s)
[73.819752] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[79.579346] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (5.756s)
[79.580067] Subtest drm_buddy: SUCCESS (6.443s)
[79.712311] [008/133] (926s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[79.801692] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[79.803068] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[79.915071] [009/133] (925s left) gem_mmap (basic)
[79.946456] Starting subtest: basic
[79.949746] Subtest basic: SUCCESS (0.000s)
[80.056783] [010/133] (925s left) gem_exec_fence (syncobj-unused-fence)
[80.371319] Starting subtest: syncobj-unused-fence
[80.373582] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[80.681562] [011/133] (925s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[80.781499] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[80.880081] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.100s)
[81.017068] [012/133] (924s left) gem_exec_params (secure-non-root)
[81.051013] Starting subtest: secure-non-root
[81.052370] Subtest secure-non-root: SKIP (0.000s)
[81.175731] [013/133] (924s left) kms_psr (psr-primary-mmap-cpu)
[81.262211] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[81.303476] [014/133] (924s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[81.437411] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[81.524506] [015/133] (924s left) gem_mmap_gtt (basic-short)
[81.559324] Starting subtest: basic-short
[81.579518] Subtest basic-short: SUCCESS (0.020s)
[81.687826] [016/133] (924s left) kms_getfb (getfb-handle-valid)
[81.770635] Starting subtest: getfb-handle-valid
[81.771331] Subtest getfb-handle-valid: SUCCESS (0.000s)
[81.888500] [017/133] (924s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[81.972540] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[81.973219] Starting dynamic subtest: pipe-A
[82.383412] Dynamic subtest pipe-A: SUCCESS (0.411s)
[82.390227] Starting dynamic subtest: pipe-B
[82.817744] Dynamic subtest pipe-B: SUCCESS (0.434s)
[82.825991] Starting dynamic subtest: pipe-C
[83.253315] Dynamic subtest pipe-C: SUCCESS (0.435s)
[83.259982] Starting dynamic subtest: pipe-D
[83.714251] Dynamic subtest pipe-D: SUCCESS (0.460s)
[83.714951] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (1.741s)
[83.921868] [018/133] (922s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[84.010300] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[84.010990] Starting dynamic subtest: pipe-A-valid-mode
[84.066664] Dynamic subtest pipe-A-valid-mode: SKIP (0.055s)
[84.068076] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.057s)
[84.193649] [019/133] (922s left) i915_hangman (engine-engine-error)
[84.236129] Starting subtest: engine-engine-error
[84.236814] Starting dynamic subtest: rcs0
[84.330979] Dynamic subtest rcs0: SUCCESS (0.094s)
[84.345647] Starting dynamic subtest: bcs0
[84.430101] Dynamic subtest bcs0: SUCCESS (0.098s)
[84.444390] Starting dynamic subtest: vcs0
[84.508977] Dynamic subtest vcs0: SUCCESS (0.078s)
[84.522319] Starting dynamic subtest: vcs1
[84.602290] Dynamic subtest vcs1: SUCCESS (0.092s)
[84.619216] Starting dynamic subtest: vecs0
[84.682201] Dynamic subtest vecs0: SUCCESS (0.079s)
[84.683207] Subtest engine-engine-error: SUCCESS (0.446s)
[84.780754] [020/133] (921s left) gem_exec_nop (basic-parallel)
[84.822384] Starting subtest: basic-parallel
[88.135949] Subtest basic-parallel: SUCCESS (3.312s)
[88.376582] [021/133] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[88.465535] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[88.466887] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[88.583727] [022/133] (917s left) gem_exec_reloc (basic-cpu-active)
[88.620954] Starting subtest: basic-cpu-active
[88.748775] Subtest basic-cpu-active: SUCCESS (0.119s)
[88.874329] [023/133] (917s left) kms_busy (basic-hang)
[88.961788] Starting subtest: basic-hang
[88.963276] Starting dynamic subtest: flip-pipe-A
[89.297919] Dynamic subtest flip-pipe-A: SUCCESS (0.335s)
[89.305104] Starting dynamic subtest: modeset-pipe-A
[89.833302] Dynamic subtest modeset-pipe-A: SUCCESS (0.535s)
[89.844402] Starting dynamic subtest: flip-pipe-D
[90.125707] Dynamic subtest flip-pipe-D: SUCCESS (0.286s)
[90.131999] Starting dynamic subtest: modeset-pipe-D
[90.624968] Dynamic subtest modeset-pipe-D: SUCCESS (0.499s)
[90.625775] Subtest basic-hang: SUCCESS (1.663s)
[90.762546] [024/133] (915s left) api_intel_allocator (default-alignment)
[90.798610] Starting subtest: default-alignment
[90.799353] Subtest default-alignment: SUCCESS (0.001s)
[90.952194] [025/133] (915s left) syncobj_basic (create-signaled)
[90.983508] Starting subtest: create-signaled
[90.984268] Subtest create-signaled: SUCCESS (0.000s)
[91.073396] [026/133] (915s left) kms_cursor_crc (cursor-random-512x512)
[91.163886] Starting subtest: cursor-random-512x512
[91.165280] Subtest cursor-random-512x512: SKIP (0.001s)
[91.282598] [027/133] (915s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[91.314916] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[91.316401] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[91.399026] [028/133] (915s left) kms_hdr (bpc-switch)
[91.482826] Starting subtest: bpc-switch
[91.484842] Subtest bpc-switch: SKIP (0.001s)
[91.560574] [029/133] (915s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[91.644452] Starting subtest: cursor-vs-flip-atomic
[121.279704] Subtest cursor-vs-flip-atomic: SUCCESS (29.629s)
[121.443415] [030/133] (885s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[121.541398] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[121.542796] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[121.662039] [031/133] (885s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-blt)
[121.749437] Starting subtest: fbcpsr-abgr161616f-draw-blt
[121.750836] Subtest fbcpsr-abgr161616f-draw-blt: SKIP (0.000s)
[121.870453] [032/133] (884s left) syncobj_timeline (reset-during-wait-for-submit)
[121.903158] Starting subtest: reset-during-wait-for-submit
[122.005519] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[122.096038] [033/133] (884s left) kms_async_flips (alternate-sync-async-flip)
[122.178425] Starting subtest: alternate-sync-async-flip
[122.305775] Starting dynamic subtest: pipe-A-HDMI-A-1
[124.411243] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.097s)
[124.549424] Starting dynamic subtest: pipe-B-HDMI-A-1
[126.625540] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.073s)
[126.744974] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.832717] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.085s)
[128.954857] Starting dynamic subtest: pipe-D-HDMI-A-1
[131.045518] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.088s)
[131.046691] Subtest alternate-sync-async-flip: SUCCESS (8.858s)
[131.279216] [034/133] (875s left) perf (invalid-oa-metric-set-id)
[131.389575] Starting subtest: invalid-oa-metric-set-id
[131.398435] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[131.433415] [035/133] (875s left) gem_userptr_blits (unsync-overlap)
[131.470667] Subtest unsync-overlap: SKIP (0.000s)
[131.607402] [036/133] (875s left) kms_plane_lowres (tiling-y)
[131.691591] Starting subtest: tiling-y
[131.692299] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.694746] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.002s)
[136.753716] Starting dynamic subtest: pipe-B-HDMI-A-1
[141.633305] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.886s)
[141.707706] Starting dynamic subtest: pipe-C-HDMI-A-1
[146.546539] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (4.847s)
[146.596660] Starting dynamic subtest: pipe-D-HDMI-A-1
[151.418445] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.829s)
[151.492763] Subtest tiling-y: SUCCESS (19.801s)
[151.678290] [037/133] (855s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[151.777459] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[151.778899] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[151.899783] [038/133] (855s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[151.986710] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[151.988111] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[152.108182] [039/133] (854s left) gem_ctx_persistence (heartbeat-close)
[152.144261] Starting subtest: heartbeat-close
[152.446659] Subtest heartbeat-close: SUCCESS (0.302s)
[152.541761] [040/133] (854s left) kms_pipe_crc_basic (read-crc)
[152.625924] Starting subtest: read-crc
[152.627729] Starting dynamic subtest: pipe-A-HDMI-A-1
[152.952400] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.325s)
[152.960395] Starting dynamic subtest: pipe-B-HDMI-A-1
[153.236121] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.280s)
[153.242770] Starting dynamic subtest: pipe-C-HDMI-A-1
[153.528509] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.291s)
[153.536647] Starting dynamic subtest: pipe-D-HDMI-A-1
[153.828332] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.298s)
[153.829085] Subtest read-crc: SUCCESS (1.203s)
[153.952012] [041/133] (853s left) kms_properties (plane-properties-atomic)
[154.041300] Starting subtest: plane-properties-atomic
[154.043591] Starting dynamic subtest: pipe-A-HDMI-A-1
[154.296109] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.253s)
[154.305868] Starting dynamic subtest: pipe-B-HDMI-A-1
[154.560382] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.263s)
[154.568720] Starting dynamic subtest: pipe-C-HDMI-A-1
[154.845404] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.282s)
[154.852706] Starting dynamic subtest: pipe-D-HDMI-A-1
[155.112574] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.265s)
[155.113265] Subtest plane-properties-atomic: SUCCESS (1.071s)
[155.277168] [042/133] (851s left) kms_flip (2x-flip-vs-fences)
[155.368659] Starting subtest: 2x-flip-vs-fences
[155.383994] Subtest 2x-flip-vs-fences: SKIP (0.016s)
[155.480194] [043/133] (851s left) kms_psr (psr2-sprite-plane-onoff)
[155.566233] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[155.606961] [044/133] (851s left) gem_exec_store (dword)
[155.648900] Starting subtest: dword
[155.649610] Starting dynamic subtest: rcs0
[155.704864] Dynamic subtest rcs0: SUCCESS (0.055s)
[155.720500] Starting dynamic subtest: bcs0
[155.736618] Dynamic subtest bcs0: SUCCESS (0.029s)
[155.750979] Starting dynamic subtest: vcs0
[155.768730] Dynamic subtest vcs0: SUCCESS (0.029s)
[155.782521] Starting dynamic subtest: vcs1
[155.798480] Dynamic subtest vcs1: SUCCESS (0.027s)
[155.811949] Starting dynamic subtest: vecs0
[155.827886] Dynamic subtest vecs0: SUCCESS (0.020s)
[155.828908] Subtest dword: SUCCESS (0.172s)
[156.015749] [045/133] (851s left) kms_chamelium_color (ctm-green-to-red)
[156.099720] Subtest ctm-green-to-red: SKIP (0.000s)
[156.139444] [046/133] (851s left) gem_readwrite (beyond-eob)
[156.172696] Starting subtest: beyond-EOB
[156.174028] Subtest beyond-EOB: SUCCESS (0.000s)
[156.283984] [047/133] (851s left) vgem_basic (mmap)
[156.317580] Starting subtest: mmap
[156.334164] Subtest mmap: SUCCESS (0.016s)
[156.405555] [048/133] (850s left) gem_exec_balancer (sliced)
[156.447267] Starting subtest: sliced
[157.856502] Subtest sliced: SUCCESS (1.401s)
[158.060601] [049/133] (849s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[158.154478] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[158.155829] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[158.282789] [050/133] (849s left) i915_selftest (live)
[159.318530] Starting subtest: live
[159.319395] Starting dynamic subtest: sanitycheck
[160.540450] Dynamic subtest sanitycheck: SUCCESS (1.221s)
[160.547847] Starting dynamic subtest: uncore
[161.797679] Dynamic subtest uncore: SUCCESS (1.255s)
[161.805560] Starting dynamic subtest: workarounds
[163.386627] Dynamic subtest workarounds: SUCCESS (1.587s)
[163.394298] Starting dynamic subtest: gt_engines
[165.157506] Dynamic subtest gt_engines: SUCCESS (1.769s)
[165.167455] Starting dynamic subtest: gt_timelines
[173.618321] Dynamic subtest gt_timelines: SUCCESS (8.459s)
[173.623729] Starting dynamic subtest: gt_contexts
[174.999360] Dynamic subtest gt_contexts: SUCCESS (1.379s)
[175.004448] Starting dynamic subtest: gt_lrc
[179.255435] Dynamic subtest gt_lrc: SUCCESS (4.254s)
[179.264458] Starting dynamic subtest: gt_mocs
[180.691423] Dynamic subtest gt_mocs: SUCCESS (1.434s)
[180.696667] Starting dynamic subtest: gt_pm
[202.168480] Dynamic subtest gt_pm: SUCCESS (21.475s)
[202.177989] Starting dynamic subtest: gt_heartbeat
[203.396718] Dynamic subtest gt_heartbeat: SUCCESS (1.226s)
[203.409147] Starting dynamic subtest: gt_tlb
[206.879438] Dynamic subtest gt_tlb: SUCCESS (3.481s)
[206.887645] Starting dynamic subtest: requests
[215.448559] Dynamic subtest requests: SUCCESS (8.567s)
[215.456587] Starting dynamic subtest: migrate
[219.908638] Dynamic subtest migrate: SUCCESS (4.458s)
[219.921059] Starting dynamic subtest: active
[221.128653] Dynamic subtest active: SUCCESS (1.218s)
[221.136827] Starting dynamic subtest: objects
[222.860639] Dynamic subtest objects: SUCCESS (1.730s)
[222.868994] Starting dynamic subtest: mman
[227.636428] Dynamic subtest mman: SUCCESS (4.773s)
[227.644710] Starting dynamic subtest: dmabuf
[228.938376] Dynamic subtest dmabuf: SUCCESS (1.300s)
[228.947392] Starting dynamic subtest: vma
[230.206538] Dynamic subtest vma: SUCCESS (1.266s)
[230.214493] Starting dynamic subtest: coherency
[233.139476] Dynamic subtest coherency: SUCCESS (2.931s)
[233.147690] Starting dynamic subtest: gtt
[242.105464] Dynamic subtest gtt: SUCCESS (8.964s)
[242.113158] Starting dynamic subtest: gem
[244.337487] Dynamic subtest gem: SUCCESS (2.229s)
[244.349057] Starting dynamic subtest: evict
[246.589347] Dynamic subtest evict: SUCCESS (2.250s)
[246.594791] Starting dynamic subtest: hugepages
[254.388566] Dynamic subtest hugepages: SUCCESS (7.797s)
[254.395949] Starting dynamic subtest: gem_contexts
[269.917487] Dynamic subtest gem_contexts: SUCCESS (15.526s)
[269.925871] Starting dynamic subtest: client
[271.200649] Dynamic subtest client: SUCCESS (1.281s)
[271.214755] Starting dynamic subtest: gem_migrate
[272.449555] Dynamic subtest gem_migrate: SUCCESS (1.247s)
[272.463189] Starting dynamic subtest: reset
[277.349745] Dynamic subtest reset: SUCCESS (4.899s)
[277.359119] Starting dynamic subtest: memory_region
[278.581634] Dynamic subtest memory_region: SUCCESS (1.230s)
[278.594470] Starting dynamic subtest: hangcheck
[308.794394] Dynamic subtest hangcheck: SUCCESS (30.213s)
[308.799710] Starting dynamic subtest: execlists
[322.724529] Dynamic subtest execlists: SUCCESS (13.929s)
[322.738223] Starting dynamic subtest: ring_submission
[323.984394] Dynamic subtest ring_submission: SUCCESS (1.258s)
[323.991801] Starting dynamic subtest: perf
[325.295281] Dynamic subtest perf: SUCCESS (1.309s)
[325.300612] Starting dynamic subtest: slpc
[326.555704] Dynamic subtest slpc: SUCCESS (1.258s)
[326.564421] Starting dynamic subtest: guc
[327.748627] Dynamic subtest guc: SUCCESS (1.191s)
[327.757898] Starting dynamic subtest: guc_multi_lrc
[328.949376] Dynamic subtest guc_multi_lrc: SUCCESS (1.199s)
[328.957728] Starting dynamic subtest: guc_hang
[330.182471] Dynamic subtest guc_hang: SUCCESS (1.231s)
[330.190655] Starting dynamic subtest: late_gt_pm
[331.473563] Dynamic subtest late_gt_pm: SUCCESS (1.289s)
[331.474501] Subtest live: SUCCESS (172.158s)
[331.503844] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[331.504649] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[331.507792] [051/133] (675s left) kms_cursor_crc (cursor-onscreen-128x128)
[332.589669] Starting subtest: cursor-onscreen-128x128
[332.604284] Starting dynamic subtest: pipe-A-HDMI-A-1
[333.780349] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.173s)
[333.847213] Starting dynamic subtest: pipe-D-HDMI-A-1
[334.940173] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.137s)
[334.940862] Subtest cursor-onscreen-128x128: SUCCESS (2.351s)
[335.082620] [FACT kms_cursor_crc (cursor-onscreen-128x128)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[335.083995] [FACT kms_cursor_crc (cursor-onscreen-128x128)] new: kernel.kmod_is_loaded.i915: true
[335.086222] [052/133] (672s left) gem_mmap_offset (open-flood)
[335.118803] Starting subtest: open-flood
[356.617984] Subtest open-flood: SUCCESS (21.500s)
[356.753770] [053/133] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[356.846587] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[356.847933] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[356.967199] [054/133] (650s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[357.051731] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[357.052395] Starting dynamic subtest: pipe-A-valid-mode
[357.104541] Dynamic subtest pipe-A-valid-mode: SKIP (0.051s)
[357.105915] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.053s)
[357.229321] [055/133] (650s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[357.267494] Starting subtest: invalid-bsd1-flag-on-vebox
[357.268211] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[357.391925] [056/133] (650s left) gem_flink_basic (bad-open)
[357.423284] Starting subtest: bad-open
[357.423971] Subtest bad-open: SUCCESS (0.000s)
[357.507266] [057/133] (650s left) gem_ccs (suspend-resume)
[357.542918] Starting subtest: suspend-resume
[357.544288] Subtest suspend-resume: SKIP (0.000s)
[357.630946] [058/133] (650s left) gem_ringfill (legacy-basic)
[357.866450] Starting subtest: legacy-basic
[357.867308] Starting dynamic subtest: default
[357.915488] Dynamic subtest default: SUCCESS (0.049s)
[357.931952] Starting dynamic subtest: render
[357.943451] Dynamic subtest render: SUCCESS (0.026s)
[357.957266] Starting dynamic subtest: bsd
[357.966164] Dynamic subtest bsd: SUCCESS (0.021s)
[357.976163] Starting dynamic subtest: bsd1
[357.989527] Dynamic subtest bsd1: SUCCESS (0.022s)
[358.000869] Starting dynamic subtest: bsd2
[358.009053] Dynamic subtest bsd2: SUCCESS (0.018s)
[358.018405] Starting dynamic subtest: blt
[358.024962] Dynamic subtest blt: SUCCESS (0.015s)
[358.034310] Starting dynamic subtest: vebox
[358.046078] Dynamic subtest vebox: SUCCESS (0.020s)
[358.046856] Subtest legacy-basic: SUCCESS (0.182s)
[358.132386] [059/133] (649s left) kms_frontbuffer_tracking (psr-slowdraw)
[358.224609] Starting subtest: psr-slowdraw
[358.226012] Subtest psr-slowdraw: SKIP (0.000s)
[358.349644] [060/133] (649s left) kms_pm_rpm (fences-dpms)
[369.783328] Starting subtest: fences-dpms
[374.409673] Subtest fences-dpms: SUCCESS (4.619s)
[374.508168] [061/133] (633s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[374.602981] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[374.643354] [062/133] (633s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[374.739839] Starting subtest: y-tiled-8bpp-rotate-180
[375.763221] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.023s)
[375.913906] [063/133] (632s left) gem_pread (snoop)
[375.946889] Starting subtest: snoop
[376.776032] Subtest snoop: SUCCESS (0.821s)
[376.875437] [064/133] (631s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[376.964477] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[376.965806] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[377.086337] [065/133] (631s left) api_intel_bb (offset-control)
[377.118214] Starting subtest: offset-control
[377.124671] Subtest offset-control: SUCCESS (0.006s)
[377.255340] [066/133] (630s left) perf (oa-formats)
[377.349666] Starting subtest: oa-formats
[377.350403] Starting dynamic subtest: 0-rcs0
[377.363714] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[377.364409] Subtest oa-formats: SUCCESS (0.015s)
[377.403398] [067/133] (630s left) gem_ctx_isolation (preservation)
[377.443277] Starting subtest: preservation
[377.443989] Starting dynamic subtest: rcs0
[377.570409] Dynamic subtest rcs0: SUCCESS (0.118s)
[377.576852] Starting dynamic subtest: bcs0
[377.747039] Dynamic subtest bcs0: SUCCESS (0.176s)
[377.753276] Starting dynamic subtest: vcs0
[377.936633] Dynamic subtest vcs0: SUCCESS (0.189s)
[377.943183] Starting dynamic subtest: vcs1
[378.113555] Dynamic subtest vcs1: SUCCESS (0.185s)
[378.120389] Starting dynamic subtest: vecs0
[378.290439] Dynamic subtest vecs0: SUCCESS (0.168s)
[378.291169] Subtest preservation: SUCCESS (0.839s)
[378.523309] [068/133] (629s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[378.613638] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[378.615074] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[378.744782] [069/133] (629s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[378.834177] Starting subtest: fbc-rgb101010-draw-blt
[381.322246] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.488s)
[381.472939] [070/133] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[381.564754] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[381.566172] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[381.694331] [071/133] (626s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[381.782763] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[381.784186] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[381.894149] [072/133] (626s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[381.929047] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[381.929760] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[382.013392] [073/133] (626s left) kms_atomic_interruptible (universal-setplane-primary)
[382.100925] Starting subtest: universal-setplane-primary
[382.101654] Starting dynamic subtest: pipe-A-HDMI-A-1
[388.343988] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.242s)
[388.344706] Subtest universal-setplane-primary: SUCCESS (6.244s)
[388.495919] [074/133] (619s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[388.593553] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[388.594884] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[388.707757] [075/133] (619s left) kms_color (invalid-degamma-lut-sizes)
[388.791057] Starting subtest: invalid-degamma-lut-sizes
[388.791759] Starting dynamic subtest: pipe-A
[388.842320] Dynamic subtest pipe-A: SUCCESS (0.051s)
[388.850136] Starting dynamic subtest: pipe-B
[388.850889] Dynamic subtest pipe-B: SUCCESS (0.001s)
[388.857482] Starting dynamic subtest: pipe-C
[388.858195] Dynamic subtest pipe-C: SUCCESS (0.000s)
[388.864596] Starting dynamic subtest: pipe-D
[388.865312] Dynamic subtest pipe-D: SUCCESS (0.000s)
[388.866039] Subtest invalid-degamma-lut-sizes: SUCCESS (0.055s)
[388.974384] [076/133] (619s left) gem_exec_reloc (basic-write-read-noreloc)
[389.010485] Starting subtest: basic-write-read-noreloc
[389.012305] Subtest basic-write-read-noreloc: SUCCESS (0.002s)
[389.145022] [077/133] (619s left) gem_exec_balancer (fairslice)
[389.184447] Starting subtest: fairslice
[392.461973] Subtest fairslice: SUCCESS (3.269s)
[392.656272] [078/133] (615s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[392.755254] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[393.061366] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.307s)
[393.210805] [079/133] (615s left) kms_chamelium_frames (hdmi-crc-single)
[393.354145] Subtest hdmi-crc-single: SKIP (0.000s)
[393.439669] [080/133] (615s left) perf_pmu (multi-client)
[393.474980] Starting subtest: multi-client
[393.475688] Starting dynamic subtest: rcs0
[394.525651] Dynamic subtest rcs0: SUCCESS (1.041s)
[394.535314] Starting dynamic subtest: bcs0
[395.553162] Dynamic subtest bcs0: SUCCESS (1.026s)
[395.563099] Starting dynamic subtest: vcs0
[396.583631] Dynamic subtest vcs0: SUCCESS (1.028s)
[396.593395] Starting dynamic subtest: vcs1
[397.615872] Dynamic subtest vcs1: SUCCESS (1.030s)
[397.625480] Starting dynamic subtest: vecs0
[398.646768] Dynamic subtest vecs0: SUCCESS (1.029s)
[398.647731] Subtest multi-client: SUCCESS (5.164s)
[398.744339] [081/133] (609s left) kms_addfb_basic (bad-pitch-65536)
[398.777636] Starting subtest: bad-pitch-65536
[398.778398] Subtest bad-pitch-65536: SUCCESS (0.000s)
[398.951032] [082/133] (609s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[399.043840] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[399.045197] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[399.157156] [083/133] (609s left) i915_pm_rpm (gem-pread)
[410.598876] Starting subtest: gem-pread
[411.987025] Subtest gem-pread: SUCCESS (1.388s)
[412.115652] [084/133] (596s left) syncobj_timeline (invalid-wait-illegal-handle)
[412.151737] Starting subtest: invalid-wait-illegal-handle
[412.152449] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[412.235972] [085/133] (596s left) gem_vm_create (invalid-create)
[412.271718] Starting subtest: invalid-create
[412.272399] Subtest invalid-create: SUCCESS (0.001s)
[412.379521] [086/133] (596s left) kms_vblank (accuracy-idle)
[412.465101] Starting subtest: accuracy-idle
[412.465801] Starting dynamic subtest: pipe-A-HDMI-A-1
[413.650453] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.184s)
[413.659713] Starting dynamic subtest: pipe-D-HDMI-A-1
[414.808098] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.155s)
[414.808765] Subtest accuracy-idle: SUCCESS (2.344s)
[414.963947] [087/133] (594s left) kms_plane (plane-panning-bottom-right)
[415.053064] Starting subtest: plane-panning-bottom-right
[415.053783] Starting dynamic subtest: pipe-A
[415.424408] Dynamic subtest pipe-A: SUCCESS (0.370s)
[415.432817] Starting dynamic subtest: pipe-B
[415.748251] Dynamic subtest pipe-B: SUCCESS (0.322s)
[415.748923] Subtest plane-panning-bottom-right: SUCCESS (0.697s)
[415.922571] [088/133] (593s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[416.006483] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[416.008653] Starting dynamic subtest: pipe-A-HDMI-A-1
[416.026262] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[416.035593] Starting dynamic subtest: pipe-B-HDMI-A-1
[416.059833] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[416.066394] Starting dynamic subtest: pipe-C-HDMI-A-1
[416.083182] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[416.090033] Starting dynamic subtest: pipe-D-HDMI-A-1
[416.107541] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[416.108841] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.014s)
[416.273893] [089/133] (592s left) gem_exec_await (wide-all)
[416.342258] Starting subtest: wide-all
[438.538411] Subtest wide-all: SUCCESS (22.161s)
[438.709722] [090/133] (570s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[438.844143] Starting subtest: bad-aux-stride-y-tiled-ccs
[438.844861] Starting dynamic subtest: pipe-A-HDMI-A-1
[438.851691] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[438.859560] Starting dynamic subtest: pipe-B-HDMI-A-1
[438.866331] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[438.874086] Starting dynamic subtest: pipe-C-HDMI-A-1
[438.880855] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[438.888275] Starting dynamic subtest: pipe-D-HDMI-A-1
[438.895075] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[438.896383] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.008s)
[439.106641] [091/133] (570s left) gem_busy (busy)
[439.152821] Starting subtest: busy
[439.153537] Starting dynamic subtest: all-engines
[439.180156] Dynamic subtest all-engines: SUCCESS (0.027s)
[439.189694] Starting dynamic subtest: rcs0
[439.199633] Dynamic subtest rcs0: SUCCESS (0.018s)
[439.208675] Starting dynamic subtest: bcs0
[439.216238] Dynamic subtest bcs0: SUCCESS (0.016s)
[439.225193] Starting dynamic subtest: vcs0
[439.242548] Dynamic subtest vcs0: SUCCESS (0.025s)
[439.255777] Starting dynamic subtest: vcs1
[439.265112] Dynamic subtest vcs1: SUCCESS (0.021s)
[439.276323] Starting dynamic subtest: vecs0
[439.291950] Dynamic subtest vecs0: SUCCESS (0.025s)
[439.295021] Subtest busy: SUCCESS (0.140s)
[439.661647] [092/133] (569s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[439.704381] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[439.705135] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[439.790607] [093/133] (569s left) syncobj_timeline (etime-multi-wait-submitted)
[439.823371] Starting subtest: etime-multi-wait-submitted
[439.926673] Subtest etime-multi-wait-submitted: SUCCESS (0.103s)
[440.016630] [094/133] (569s left) gem_exec_schedule (timeslicing)
[440.058180] Starting subtest: timeslicing
[440.058904] Starting dynamic subtest: rcs0
[440.063331] Dynamic subtest rcs0: SUCCESS (0.005s)
[440.073269] Starting dynamic subtest: bcs0
[440.073993] Dynamic subtest bcs0: SUCCESS (0.003s)
[440.081947] Starting dynamic subtest: vcs0
[440.082647] Dynamic subtest vcs0: SUCCESS (0.002s)
[440.090233] Starting dynamic subtest: vcs1
[440.090904] Dynamic subtest vcs1: SUCCESS (0.002s)
[440.097982] Starting dynamic subtest: vecs0
[440.098679] Dynamic subtest vecs0: SUCCESS (0.002s)
[440.099339] Subtest timeslicing: SUCCESS (0.020s)
[440.391908] [095/133] (568s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[440.491041] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[440.492403] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[440.607231] [096/133] (568s left) gem_exec_alignment (pi)
[440.645123] Starting subtest: pi
[503.559587] Subtest pi: SUCCESS (62.909s)
[504.576312] [097/133] (504s left) gem_flink_race (flink_name)
[504.641685] Starting subtest: flink_name
[510.049709] Subtest flink_name: SUCCESS (5.373s)
[510.134084] [098/133] (499s left) syncobj_eventfd (invalid-illegal-handle)
[510.177286] Starting subtest: invalid-illegal-handle
[510.178040] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[510.270535] [099/133] (499s left) gem_fence_thrash (bo-write-verify-none)
[510.301109] Starting subtest: bo-write-verify-none
[511.489445] Subtest bo-write-verify-none: SUCCESS (1.180s)
[511.581266] [100/133] (497s left) gem_ppgtt (blt-vs-render-ctxn)
[511.618906] Starting subtest: blt-vs-render-ctxN
[544.101377] Subtest blt-vs-render-ctxN: SUCCESS (32.474s)
[544.246625] [101/133] (465s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[544.383906] Starting subtest: plane-upscale-factor-0-25-with-rotation
[544.384599] Starting dynamic subtest: pipe-A
[545.446412] Dynamic subtest pipe-A: SKIP (1.061s)
[545.454405] Starting dynamic subtest: pipe-B
[546.563156] Dynamic subtest pipe-B: SKIP (1.116s)
[546.573780] Starting dynamic subtest: pipe-C
[547.686879] Dynamic subtest pipe-C: SKIP (1.122s)
[547.694644] Starting dynamic subtest: pipe-D
[548.818743] Dynamic subtest pipe-D: SKIP (1.130s)
[548.820372] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (4.433s)
[548.997077] [102/133] (460s left) perf_pmu (busy)
[549.044849] Starting subtest: busy
[549.045587] Starting dynamic subtest: rcs0
[549.602945] Dynamic subtest rcs0: SUCCESS (0.559s)
[549.611857] Starting dynamic subtest: bcs0
[550.146895] Dynamic subtest bcs0: SUCCESS (0.543s)
[550.155755] Starting dynamic subtest: vcs0
[550.685019] Dynamic subtest vcs0: SUCCESS (0.537s)
[550.694147] Starting dynamic subtest: vcs1
[551.213447] Dynamic subtest vcs1: SUCCESS (0.527s)
[551.225800] Starting dynamic subtest: vecs0
[551.750953] Dynamic subtest vecs0: SUCCESS (0.535s)
[551.751938] Subtest busy: SUCCESS (2.707s)
[551.842872] [103/133] (457s left) kms_color_pipeline (plane-lut3d-green-only)
[551.934034] Starting subtest: plane-lut3d-green-only
[551.953934] Starting dynamic subtest: pipe-A-HDMI-A-1
[551.955323] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[552.071499] Starting dynamic subtest: pipe-B-HDMI-A-1
[552.072921] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[552.210269] Starting dynamic subtest: pipe-C-HDMI-A-1
[552.211599] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[552.350296] Starting dynamic subtest: pipe-D-HDMI-A-1
[552.351712] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[552.406124] Subtest plane-lut3d-green-only: SKIP (0.472s)
[552.524408] [104/133] (457s left) gem_lmem_swapping (parallel-multi)
[552.569946] Subtest parallel-multi: SKIP (0.000s)
[552.611629] [105/133] (457s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[552.699827] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[552.701202] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[552.811891] [106/133] (456s left) kms_dp_link_training (non-uhbr-sst)
[552.895915] Starting subtest: non-uhbr-sst
[552.898508] Subtest non-uhbr-sst: SKIP (0.000s)
[552.984608] [107/133] (456s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[553.072898] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[553.110614] [108/133] (456s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[553.196096] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[553.196772] Starting dynamic subtest: pipe-A-HDMI-A-1
[553.203284] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[553.210925] Starting dynamic subtest: pipe-B-HDMI-A-1
[553.217515] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[553.225285] Starting dynamic subtest: pipe-C-HDMI-A-1
[553.231930] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[553.239661] Starting dynamic subtest: pipe-D-HDMI-A-1
[553.246446] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[553.247759] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[553.471441] [109/133] (456s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-wc)
[553.558892] Starting subtest: fbc-abgr161616f-draw-mmap-wc
[553.560286] Subtest fbc-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[553.674579] [110/133] (456s left) kms_psr (fbc-pr-primary-page-flip)
[553.759553] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[553.798174] [111/133] (456s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[553.887809] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[553.889196] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[553.998664] [112/133] (456s left) kms_psr (fbc-pr-basic)
[554.083525] Subtest fbc-pr-basic: SKIP (0.000s)
[554.123760] [113/133] (455s left) perf_pmu (rc6)
[554.158121] Starting subtest: rc6
[554.158857] Starting dynamic subtest: gt0
[560.529724] Dynamic subtest gt0: SUCCESS (6.337s)
[560.539329] Starting dynamic subtest: runtime-pm-gt0
[578.054777] Dynamic subtest runtime-pm-gt0: SUCCESS (17.549s)
[578.065071] Starting dynamic subtest: runtime-pm-long-gt0
[600.564332] Dynamic subtest runtime-pm-long-gt0: SUCCESS (22.508s)
[600.572149] Starting dynamic subtest: other-idle-gt0
[600.573590] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[600.574301] Subtest rc6: SUCCESS (46.402s)
[600.875274] [114/133] (409s left) vgem_basic (second-client)
[600.910598] Starting subtest: second-client
[600.926309] Subtest second-client: SUCCESS (0.016s)
[600.968505] [115/133] (409s left) kms_psr (fbc-psr2-sprite-blt)
[601.053533] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[601.090372] [116/133] (409s left) kms_psr (pr-sprite-mmap-gtt)
[601.175781] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[601.216715] [117/133] (409s left) gem_userptr_blits (forbidden-operations)
[601.254035] Starting subtest: forbidden-operations
[601.254757] Subtest forbidden-operations: SUCCESS (0.001s)
[601.365673] [118/133] (408s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[601.402939] Starting subtest: yf-tiled-ccs-to-x-tiled
[601.403707] Starting dynamic subtest: smem
[601.504227] Dynamic subtest smem: SUCCESS (0.101s)
[601.504970] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.102s)
[601.665513] [119/133] (408s left) kms_big_fb (x-tiled-addfb)
[601.761663] Starting subtest: x-tiled-addfb
[601.762337] Subtest x-tiled-addfb: SUCCESS (0.000s)
[601.845525] [120/133] (408s left) gem_media_fill (media-fill)
[601.883439] Starting subtest: media-fill
[601.884130] Starting dynamic subtest: smem
[601.888416] Dynamic subtest smem: SUCCESS (0.005s)
[601.889114] Subtest media-fill: SUCCESS (0.006s)
[602.099982] [121/133] (408s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[602.188776] Starting subtest: fbcpsr-slowdraw
[602.190121] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[602.278447] [122/133] (408s left) kms_flip (flip-vs-expired-vblank)
[602.364582] Starting subtest: flip-vs-expired-vblank
[602.367348] Starting dynamic subtest: A-HDMI-A1
[610.056727] Dynamic subtest A-HDMI-A1: SUCCESS (7.689s)
[610.070328] Starting dynamic subtest: B-HDMI-A1
[617.746607] Dynamic subtest B-HDMI-A1: SUCCESS (7.657s)
[617.753919] Starting dynamic subtest: C-HDMI-A1
[625.400024] Dynamic subtest C-HDMI-A1: SUCCESS (7.653s)
[625.407277] Starting dynamic subtest: D-HDMI-A1
[633.027866] Dynamic subtest D-HDMI-A1: SUCCESS (7.653s)
[633.031743] Subtest flip-vs-expired-vblank: SUCCESS (30.668s)
[633.224376] [123/133] (377s left) kms_cursor_edge_walk (64x64-left-edge)
[633.311893] Starting subtest: 64x64-left-edge
[633.312645] Starting dynamic subtest: pipe-A-HDMI-A-1
[635.029801] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.717s)
[635.038941] Starting dynamic subtest: pipe-D-HDMI-A-1
[636.688812] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.656s)
[636.689475] Subtest 64x64-left-edge: SUCCESS (3.378s)
[636.774507] [124/133] (373s left) kms_selftest (drm_format_helper)
[636.812398] Starting subtest: drm_format_helper
[636.825256] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[636.916859] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.089s)
[636.933540] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[637.001224] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.082s)
[637.016263] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[637.088362] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.084s)
[637.104753] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[637.178508] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.087s)
[637.197398] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[637.268207] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.087s)
[637.286863] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[637.358494] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.087s)
[637.376890] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[637.443620] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.081s)
[637.458846] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[637.521106] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.078s)
[637.538683] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[637.612957] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.089s)
[637.631562] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[637.698651] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.082s)
[637.716845] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[637.796951] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.097s)
[637.816048] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[637.886046] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.086s)
[637.904745] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[637.970881] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.080s)
[637.987842] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[638.064413] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.092s)
[638.082890] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[638.160122] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.093s)
[638.178346] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[638.238885] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.075s)
[638.254323] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[638.327159] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.086s)
[638.328112] Subtest drm_format_helper: SUCCESS (1.515s)
[638.454434] [125/133] (372s left) kms_draw_crc (draw-method-blt)
[638.542274] Starting subtest: draw-method-blt
[638.542974] Starting dynamic subtest: xrgb8888-untiled
[638.698223] Dynamic subtest xrgb8888-untiled: SUCCESS (0.155s)
[638.714527] Starting dynamic subtest: rgb565-untiled
[638.865080] Dynamic subtest rgb565-untiled: SUCCESS (0.164s)
[638.884245] Starting dynamic subtest: xrgb2101010-untiled
[639.014885] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.147s)
[639.032929] Starting dynamic subtest: xbgr16161616f-untiled
[639.173150] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.156s)
[639.189683] Starting dynamic subtest: xrgb8888-xtiled
[639.256604] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.081s)
[639.274257] Starting dynamic subtest: rgb565-xtiled
[639.339979] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[639.359354] Starting dynamic subtest: xrgb2101010-xtiled
[639.423299] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.080s)
[639.438426] Starting dynamic subtest: xbgr16161616f-xtiled
[639.514967] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.090s)
[639.530551] Starting dynamic subtest: xrgb8888-ytiled
[639.598305] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.081s)
[639.613980] Starting dynamic subtest: rgb565-ytiled
[639.681838] Dynamic subtest rgb565-ytiled: SUCCESS (0.081s)
[639.698808] Starting dynamic subtest: xrgb2101010-ytiled
[639.773321] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.089s)
[639.789822] Starting dynamic subtest: xbgr16161616f-ytiled
[639.873285] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.098s)
[639.876199] Subtest draw-method-blt: SUCCESS (1.332s)
[639.977702] [126/133] (370s left) gem_exec_schedule (pi-ringfull)
[640.142414] Starting subtest: pi-ringfull
[640.143274] Starting dynamic subtest: rcs0
[640.176834] Dynamic subtest rcs0: SUCCESS (0.036s)
[640.185956] Starting dynamic subtest: bcs0
[640.201626] Dynamic subtest bcs0: SUCCESS (0.024s)
[640.210831] Starting dynamic subtest: vcs0
[640.226576] Dynamic subtest vcs0: SUCCESS (0.024s)
[640.235686] Starting dynamic subtest: vcs1
[640.251119] Dynamic subtest vcs1: SUCCESS (0.023s)
[640.260550] Starting dynamic subtest: vecs0
[640.275835] Dynamic subtest vecs0: SUCCESS (0.024s)
[640.276555] Subtest pi-ringfull: SUCCESS (0.136s)
[640.433265] [127/133] (370s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[640.521855] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[640.523682] Starting dynamic subtest: pipe-A-HDMI-A-1
[640.530229] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[640.538107] Starting dynamic subtest: pipe-B-HDMI-A-1
[640.544630] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[640.552298] Starting dynamic subtest: pipe-C-HDMI-A-1
[640.558829] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[640.566323] Starting dynamic subtest: pipe-D-HDMI-A-1
[640.572988] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[640.574314] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.009s)
[640.736740] [128/133] (369s left) kms_vrr (seamless-rr-switch-virtual)
[640.820935] Starting subtest: seamless-rr-switch-virtual
[640.822961] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[640.859250] [129/133] (369s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[640.946421] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[640.947754] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[641.021409] [130/133] (369s left) kms_invalid_mode (clock-too-high)
[641.107227] Starting subtest: clock-too-high
[641.107963] Starting dynamic subtest: pipe-A-HDMI-A-1
[641.167957] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.060s)
[641.180492] Starting dynamic subtest: pipe-B-HDMI-A-1
[641.182838] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.012s)
[641.190755] Starting dynamic subtest: pipe-C-HDMI-A-1
[641.193089] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.008s)
[641.200880] Starting dynamic subtest: pipe-D-HDMI-A-1
[641.203365] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.008s)
[641.204060] Subtest clock-too-high: SUCCESS (0.096s)
[641.339351] [131/133] (369s left) gen9_exec_parse (cmd-crossing-page)
[641.375582] Subtest cmd-crossing-page: SKIP (0.000s)
[641.418497] [132/133] (369s left) kms_atomic_transition (modeset-transition-fencing)
[641.502040] Starting subtest: modeset-transition-fencing
[641.502730] Starting dynamic subtest: 1x-outputs
[642.697761] Dynamic subtest 1x-outputs: SUCCESS (1.195s)
[642.702042] Subtest modeset-transition-fencing: SUCCESS (1.197s)
[642.832075] [133/133] (368s left) syncobj_timeline (wait-zero-handles)
[642.865769] Starting subtest: wait-zero-handles
[642.866449] Subtest wait-zero-handles: SUCCESS (0.000s)
[642.902323] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_spin_batch
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: drm_buddy
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_mmap
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_getfb
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: i915_hangman
results: parsing output: 19/ for test: gem_exec_nop
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_busy
results: parsing output: 23/ for test: api_intel_allocator
results: parsing output: 24/ for test: syncobj_basic
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_hdr
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_async_flips
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: kms_plane_lowres
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: kms_properties
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_exec_store
results: parsing output: 44/ for test: kms_chamelium_color
results: parsing output: 45/ for test: gem_readwrite
results: parsing output: 46/ for test: vgem_basic
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: i915_selftest
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: gem_mmap_offset
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: gem_flink_basic
results: parsing output: 56/ for test: gem_ccs
results: parsing output: 57/ for test: gem_ringfill
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_pread
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: api_intel_bb
results: parsing output: 65/ for test: perf
results: parsing output: 66/ for test: gem_ctx_isolation
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: kms_atomic_interruptible
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_color
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_chamelium_frames
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: i915_pm_rpm
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_vm_create
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: gem_exec_await
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_busy
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_exec_alignment
results: parsing output: 96/ for test: gem_flink_race
results: parsing output: 97/ for test: syncobj_eventfd
results: parsing output: 98/ for test: gem_fence_thrash
results: parsing output: 99/ for test: gem_ppgtt
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: kms_color_pipeline
results: parsing output: 103/ for test: gem_lmem_swapping
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_dp_link_training
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: vgem_basic
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_media_fill
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_cursor_edge_walk
results: parsing output: 123/ for test: kms_selftest
results: parsing output: 124/ for test: kms_draw_crc
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_vrr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_invalid_mode
results: parsing output: 130/ for test: gen9_exec_parse
results: parsing output: 131/ for test: kms_atomic_transition
results: parsing output: 132/ for test: syncobj_timeline
Done.