[46.388639] Initializing watchdogs
[46.388706]   /dev/watchdog0
[46.402432] [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]
[46.407351] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[46.409901] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[46.411778] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[46.577720] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[46.578410] Starting dynamic subtest: pipe-A-valid-mode
[46.649362] Dynamic subtest pipe-A-valid-mode: SKIP (0.070s)
[46.650861] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.071s)
[46.749808] [002/133] (960s left) gem_exec_schedule (out-order)
[46.807258] Starting subtest: out-order
[46.808038] Starting dynamic subtest: rcs0
[46.866374] Dynamic subtest rcs0: SUCCESS (0.059s)
[46.874164] Starting dynamic subtest: bcs0
[46.927062] Dynamic subtest bcs0: SUCCESS (0.060s)
[46.935282] Starting dynamic subtest: vcs0
[46.984839] Dynamic subtest vcs0: SUCCESS (0.058s)
[46.993515] Starting dynamic subtest: vcs1
[47.043340] Dynamic subtest vcs1: SUCCESS (0.058s)
[47.051814] Starting dynamic subtest: vecs0
[47.101823] Dynamic subtest vecs0: SUCCESS (0.058s)
[47.102810] Subtest out-order: SUCCESS (0.294s)
[47.402358] [003/133] (959s left) kms_flip (dpms-off-confusion)
[47.489217] Starting subtest: dpms-off-confusion
[47.490908] Starting dynamic subtest: A-HDMI-A1
[55.210777] Dynamic subtest A-HDMI-A1: SUCCESS (7.808s)
[55.219438] Starting dynamic subtest: B-HDMI-A1
[62.907548] Dynamic subtest B-HDMI-A1: SUCCESS (7.715s)
[62.912009] Starting dynamic subtest: C-HDMI-A1
[70.576418] Dynamic subtest C-HDMI-A1: SUCCESS (7.682s)
[70.581270] Starting dynamic subtest: D-HDMI-A1
[78.229603] Dynamic subtest D-HDMI-A1: SUCCESS (7.654s)
[78.230656] Subtest dpms-off-confusion: SUCCESS (30.865s)
[78.388114] [004/133] (928s left) gem_ctx_engines (execute-allforone)
[78.437575] Starting subtest: execute-allforone
[78.442271] Subtest execute-allforone: SUCCESS (0.005s)
[78.620891] [005/133] (928s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[78.708785] Starting subtest: fb-8bpc-vs-panel-8bpc
[78.709503] Starting dynamic subtest: pipe-A-HDMI-A-1
[78.934329] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.225s)
[78.935097] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.226s)
[79.047411] [006/133] (927s left) i915_pm_rc6_residency (rc6-accuracy)
[79.088598] Starting subtest: rc6-accuracy
[79.089318] Starting dynamic subtest: gt0
[82.292597] Dynamic subtest gt0: SUCCESS (3.168s)
[82.293492] Subtest rc6-accuracy: SUCCESS (3.169s)
[82.324067] [007/133] (924s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[82.418156] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[82.448984] [008/133] (924s left) kms_plane_scaling (planes-upscale-20x20)
[82.536778] Starting subtest: planes-upscale-20x20
[82.537886] Starting dynamic subtest: pipe-A
[82.609293] Dynamic subtest pipe-A: SUCCESS (0.073s)
[82.620433] Starting dynamic subtest: pipe-B
[82.745068] Dynamic subtest pipe-B: SUCCESS (0.136s)
[82.751554] Starting dynamic subtest: pipe-C
[82.894660] Dynamic subtest pipe-C: SUCCESS (0.149s)
[82.901230] Starting dynamic subtest: pipe-D
[83.028037] Dynamic subtest pipe-D: SUCCESS (0.133s)
[83.029136] Subtest planes-upscale-20x20: SUCCESS (0.492s)
[83.210798] [009/133] (923s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[83.314380] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[83.315782] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[83.396533] [010/133] (923s left) kms_chamelium_hpd (hdmi-hpd)
[83.537833] Subtest hdmi-hpd: SKIP (0.000s)
[83.632919] [011/133] (923s left) kms_feature_discovery (display)
[83.722657] Starting subtest: display
[83.723423] Subtest display: SUCCESS (0.000s)
[83.779508] [012/133] (923s left) kms_psr (pr-sprite-blt)
[83.868305] Subtest pr-sprite-blt: SKIP (0.000s)
[83.906785] [013/133] (923s left) gem_exec_whisper (basic-contexts)
[83.953253] Starting subtest: basic-contexts
[86.121933] Subtest basic-contexts: SUCCESS (2.167s)
[86.296151] [014/133] (920s left) gem_exec_schedule (thriceslice)
[86.342735] Starting subtest: thriceslice
[86.343462] Starting dynamic subtest: rcs0
[86.347379] Dynamic subtest rcs0: SUCCESS (0.004s)
[86.354564] Starting dynamic subtest: bcs0
[86.355277] Dynamic subtest bcs0: SUCCESS (0.004s)
[86.362218] Starting dynamic subtest: vcs0
[86.362972] Dynamic subtest vcs0: SUCCESS (0.004s)
[86.368722] Starting dynamic subtest: vcs1
[86.369443] Dynamic subtest vcs1: SUCCESS (0.005s)
[86.374605] Starting dynamic subtest: vecs0
[86.375311] Dynamic subtest vecs0: SUCCESS (0.003s)
[86.376032] Subtest thriceslice: SUCCESS (0.022s)
[86.668361] [015/133] (920s left) gem_exec_gttfill (engines)
[86.711887] Starting subtest: engines
[86.712601] Starting dynamic subtest: rcs0
[111.991085] Dynamic subtest rcs0: SUCCESS (25.268s)
[111.997075] Starting dynamic subtest: bcs0
[137.481835] Dynamic subtest bcs0: SUCCESS (25.489s)
[137.487933] Starting dynamic subtest: vcs0
[163.337989] Dynamic subtest vcs0: SUCCESS (25.856s)
[163.343981] Starting dynamic subtest: vcs1
[188.884795] Dynamic subtest vcs1: SUCCESS (25.546s)
[188.890934] Starting dynamic subtest: vecs0
[214.159731] Dynamic subtest vecs0: SUCCESS (25.274s)
[214.160519] Subtest engines: SUCCESS (127.435s)
[214.317436] [016/133] (792s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[214.467034] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[214.873761] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.407s)
[215.026640] [017/133] (792s left) kms_getfb (getfb-handle-protection)
[215.065475] Starting subtest: getfb-handle-protection
[215.095506] Subtest getfb-handle-protection: SUCCESS (0.030s)
[215.216628] [018/133] (792s left) vkms/vkms_configfs (enable-plane-no-crtcs)
[215.300890] Subtest enable-plane-no-crtcs: SKIP (0.000s)
[215.347775] [019/133] (792s left) syncobj_wait (single-wait-for-submit-submitted)
[215.385439] Starting subtest: single-wait-for-submit-submitted
[215.487324] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[215.562791] [020/133] (791s left) dumb_buffer (map-uaf)
[215.599216] Starting subtest: map-uaf
[215.618063] Subtest map-uaf: SUCCESS (0.019s)
[215.718081] [021/133] (791s left) kms_psr (fbc-psr-sprite-plane-move)
[215.812490] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[215.850980] [022/133] (791s left) perf_pmu (multi-client)
[215.891841] Starting subtest: multi-client
[215.892668] Starting dynamic subtest: rcs0
[216.930669] Dynamic subtest rcs0: SUCCESS (1.039s)
[216.939876] Starting dynamic subtest: bcs0
[217.962999] Dynamic subtest bcs0: SUCCESS (1.023s)
[217.972188] Starting dynamic subtest: vcs0
[218.982596] Dynamic subtest vcs0: SUCCESS (1.019s)
[218.991746] Starting dynamic subtest: vcs1
[220.017086] Dynamic subtest vcs1: SUCCESS (1.034s)
[220.025874] Starting dynamic subtest: vecs0
[221.048075] Dynamic subtest vecs0: SUCCESS (1.031s)
[221.049096] Subtest multi-client: SUCCESS (5.148s)
[221.114523] [023/133] (786s left) kms_psr (psr-cursor-mmap-cpu)
[221.208190] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[221.242828] [024/133] (786s left) gem_basic (create-close)
[221.279581] Starting subtest: create-close
[221.280958] Subtest create-close: SUCCESS (0.000s)
[221.370487] [025/133] (786s left) gem_userptr_blits (readonly-pwrite-unsync)
[221.414045] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[221.517291] [026/133] (786s left) i915_query (hwconfig_table)
[221.552532] Starting subtest: hwconfig_table
[221.553930] Subtest hwconfig_table: SKIP (0.000s)
[221.616570] [027/133] (786s left) gem_userptr_blits (map-fixed-invalidate-busy)
[221.664336] Starting subtest: map-fixed-invalidate-busy
[221.665127] Starting dynamic subtest: gtt
[223.169695] Dynamic subtest gtt: SUCCESS (1.497s)
[223.175906] Starting dynamic subtest: wb
[224.645278] Dynamic subtest wb: SUCCESS (1.475s)
[224.651453] Starting dynamic subtest: wc
[226.089244] Dynamic subtest wc: SUCCESS (1.443s)
[226.096130] Starting dynamic subtest: uc
[227.535435] Dynamic subtest uc: SUCCESS (1.446s)
[227.536181] Subtest map-fixed-invalidate-busy: SUCCESS (5.863s)
[227.655919] [028/133] (780s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[227.753810] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[228.976934] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.224s)
[229.100686] [029/133] (778s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[229.195483] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[229.228753] [030/133] (778s left) kms_flip (plain-flip-interruptible)
[229.323347] Starting subtest: plain-flip-interruptible
[229.325825] Starting dynamic subtest: A-HDMI-A1
[229.985116] Dynamic subtest A-HDMI-A1: SUCCESS (0.659s)
[229.998455] Starting dynamic subtest: B-HDMI-A1
[230.635948] Dynamic subtest B-HDMI-A1: SUCCESS (0.646s)
[230.642486] Starting dynamic subtest: C-HDMI-A1
[231.273383] Dynamic subtest C-HDMI-A1: SUCCESS (0.639s)
[231.284327] Starting dynamic subtest: D-HDMI-A1
[231.911552] Dynamic subtest D-HDMI-A1: SUCCESS (0.637s)
[231.914270] Subtest plain-flip-interruptible: SUCCESS (2.590s)
[232.059626] [031/133] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[232.156615] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[232.158038] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[232.252751] [032/133] (775s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[232.346913] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[233.568246] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.222s)
[233.678198] [033/133] (774s left) gem_userptr_blits (coherency-unsync)
[233.721069] Subtest coherency-unsync: SKIP (0.000s)
[233.863065] [034/133] (774s left) gem_madvise (dontneed-before-exec)
[233.897720] Starting subtest: dontneed-before-exec
[233.901511] Subtest dontneed-before-exec: SUCCESS (0.004s)
[234.020101] [035/133] (773s left) syncobj_wait (wait-all-delayed-signal)
[234.055969] Starting subtest: wait-all-delayed-signal
[234.159711] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[234.223581] [036/133] (773s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[234.315860] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[234.316567] Starting dynamic subtest: pipe-A-HDMI-A-1
[234.323306] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[234.329813] Starting dynamic subtest: pipe-B-HDMI-A-1
[234.336645] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[234.342783] Starting dynamic subtest: pipe-C-HDMI-A-1
[234.349492] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[234.355354] Starting dynamic subtest: pipe-D-HDMI-A-1
[234.362121] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[234.363483] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[234.549249] [037/133] (773s left) gem_softpin (evict-snoop-interruptible)
[234.592263] Starting subtest: evict-snoop-interruptible
[234.593641] Subtest evict-snoop-interruptible: SKIP (0.000s)
[234.659025] [038/133] (773s left) kms_chamelium_audio (dp-audio-edid)
[234.795321] Subtest dp-audio-edid: SKIP (0.000s)
[234.880415] [039/133] (773s left) kms_psr (fbc-pr-sprite-blt)
[234.971434] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[235.010174] [040/133] (773s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[235.052090] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[235.052833] Starting dynamic subtest: smem
[235.126381] Dynamic subtest smem: SUCCESS (0.074s)
[235.127114] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (0.074s)
[235.303870] [041/133] (772s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[235.396482] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[235.397894] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[235.503520] [042/133] (772s left) gem_pxp (display-protected-crc)
[235.606742] Starting subtest: display-protected-crc
[236.159368] Subtest display-protected-crc: SUCCESS (0.554s)
[236.275672] [043/133] (771s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[236.364820] Starting subtest: basic-flip-after-cursor-varying-size
[236.860413] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.488s)
[236.979918] [044/133] (771s left) gem_exec_reloc (basic-wc)
[237.023095] Starting subtest: basic-wc
[237.027347] Subtest basic-wc: SUCCESS (0.004s)
[237.135665] [045/133] (771s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[237.227434] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[237.228389] Starting dynamic subtest: pipe-A-valid-mode
[237.287315] Dynamic subtest pipe-A-valid-mode: SKIP (0.058s)
[237.288781] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.060s)
[237.383215] [046/133] (770s left) kms_plane (plane-position-hole)
[237.473720] Starting subtest: plane-position-hole
[237.684298] Starting dynamic subtest: pipe-A-plane-1
[237.919626] Dynamic subtest pipe-A-plane-1: SUCCESS (0.235s)
[237.927870] Starting dynamic subtest: pipe-A-plane-2
[238.166342] Dynamic subtest pipe-A-plane-2: SUCCESS (0.246s)
[238.172568] Starting dynamic subtest: pipe-A-plane-3
[238.408455] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s)
[238.414727] Starting dynamic subtest: pipe-A-plane-4
[238.641392] Dynamic subtest pipe-A-plane-4: SUCCESS (0.232s)
[238.647763] Starting dynamic subtest: pipe-A-plane-5
[238.884591] Dynamic subtest pipe-A-plane-5: SUCCESS (0.243s)
[238.890869] Starting dynamic subtest: pipe-A-plane-6
[239.118795] Dynamic subtest pipe-A-plane-6: SUCCESS (0.233s)
[239.125152] Starting dynamic subtest: pipe-A-plane-7
[239.126640] Dynamic subtest pipe-A-plane-7: SUCCESS (0.006s)
[239.305827] Starting dynamic subtest: pipe-B-plane-1
[239.534647] Dynamic subtest pipe-B-plane-1: SUCCESS (0.235s)
[239.541668] Starting dynamic subtest: pipe-B-plane-2
[239.768624] Dynamic subtest pipe-B-plane-2: SUCCESS (0.233s)
[239.775585] Starting dynamic subtest: pipe-B-plane-3
[240.003718] Dynamic subtest pipe-B-plane-3: SUCCESS (0.235s)
[240.010910] Starting dynamic subtest: pipe-B-plane-4
[240.237760] Dynamic subtest pipe-B-plane-4: SUCCESS (0.234s)
[240.243996] Starting dynamic subtest: pipe-B-plane-5
[240.450742] Dynamic subtest pipe-B-plane-5: SUCCESS (0.212s)
[240.456955] Starting dynamic subtest: pipe-B-plane-6
[240.669772] Dynamic subtest pipe-B-plane-6: SUCCESS (0.219s)
[240.676015] Starting dynamic subtest: pipe-B-plane-7
[240.677386] Dynamic subtest pipe-B-plane-7: SUCCESS (0.006s)
[240.678079] Subtest plane-position-hole: SUCCESS (3.203s)
[240.805145] [047/133] (767s left) kms_flip (flip-vs-expired-vblank)
[240.901782] Starting subtest: flip-vs-expired-vblank
[240.903619] Starting dynamic subtest: A-HDMI-A1
[248.594173] Dynamic subtest A-HDMI-A1: SUCCESS (7.671s)
[248.600355] Starting dynamic subtest: B-HDMI-A1
[256.264887] Dynamic subtest B-HDMI-A1: SUCCESS (7.659s)
[256.270961] Starting dynamic subtest: C-HDMI-A1
[263.928360] Dynamic subtest C-HDMI-A1: SUCCESS (7.661s)
[263.934438] Starting dynamic subtest: D-HDMI-A1
[271.563808] Dynamic subtest D-HDMI-A1: SUCCESS (7.663s)
[271.567161] Subtest flip-vs-expired-vblank: SUCCESS (30.666s)
[271.726436] [048/133] (736s left) kms_vrr (max-min)
[271.820016] Starting subtest: max-min
[271.822062] Subtest max-min: SKIP (0.000s)
[271.871894] [049/133] (736s left) kms_color (legacy-gamma)
[271.962244] Starting subtest: legacy-gamma
[271.963023] Starting dynamic subtest: pipe-A-HDMI-A-1
[272.288616] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.327s)
[272.296280] Starting dynamic subtest: pipe-B-HDMI-A-1
[272.577594] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.288s)
[272.585081] Starting dynamic subtest: pipe-C-HDMI-A-1
[272.889362] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.310s)
[272.897074] Starting dynamic subtest: pipe-D-HDMI-A-1
[273.174046] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.284s)
[273.174830] Subtest legacy-gamma: SUCCESS (1.212s)
[273.300922] [050/133] (735s left) kms_psr (fbc-psr-no-drrs)
[273.394840] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[273.434606] [051/133] (735s left) kms_flip (wf_vblank-ts-check)
[273.525723] Starting subtest: wf_vblank-ts-check
[273.527440] Starting dynamic subtest: A-HDMI-A1
[281.372215] Dynamic subtest A-HDMI-A1: SUCCESS (7.825s)
[281.378342] Starting dynamic subtest: B-HDMI-A1
[289.148856] Dynamic subtest B-HDMI-A1: SUCCESS (7.791s)
[289.156052] Starting dynamic subtest: C-HDMI-A1
[296.948198] Dynamic subtest C-HDMI-A1: SUCCESS (7.798s)
[296.955233] Starting dynamic subtest: D-HDMI-A1
[304.746225] Dynamic subtest D-HDMI-A1: SUCCESS (7.796s)
[304.746999] Subtest wf_vblank-ts-check: SUCCESS (31.219s)
[304.893206] [052/133] (703s left) gem_exec_fence (basic-wait)
[305.069666] Starting subtest: basic-wait
[305.070639] Starting dynamic subtest: rcs0
[305.118727] Dynamic subtest rcs0: SUCCESS (0.048s)
[305.133891] Starting dynamic subtest: bcs0
[305.154701] Dynamic subtest bcs0: SUCCESS (0.034s)
[305.168329] Starting dynamic subtest: vcs0
[305.181634] Dynamic subtest vcs0: SUCCESS (0.025s)
[305.195160] Starting dynamic subtest: vcs1
[305.215712] Dynamic subtest vcs1: SUCCESS (0.032s)
[305.228352] Starting dynamic subtest: vecs0
[305.256629] Dynamic subtest vecs0: SUCCESS (0.039s)
[305.257767] Subtest basic-wait: SUCCESS (0.188s)
[305.822365] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[305.825498] [053/133] (702s left) gem_userptr_blits (mmap-offset-banned)
[305.873364] Starting subtest: mmap-offset-banned
[305.874110] Starting dynamic subtest: gtt
[305.874821] Dynamic subtest gtt: SUCCESS (0.000s)
[305.881245] Starting dynamic subtest: wb
[305.881978] Dynamic subtest wb: SUCCESS (0.000s)
[305.888216] Starting dynamic subtest: wc
[305.888983] Dynamic subtest wc: SUCCESS (0.000s)
[305.895624] Starting dynamic subtest: uc
[305.896339] Dynamic subtest uc: SUCCESS (0.000s)
[305.897032] Subtest mmap-offset-banned: SUCCESS (0.003s)
[306.005771] [054/133] (702s left) kms_legacy_colorkey (invalid-plane)
[306.096523] Starting subtest: invalid-plane
[306.097288] Starting dynamic subtest: zero-id
[306.098058] Dynamic subtest zero-id: SUCCESS (0.000s)
[306.104366] Starting dynamic subtest: outrange-id
[306.105074] Dynamic subtest outrange-id: SUCCESS (0.000s)
[306.105765] Subtest invalid-plane: SUCCESS (0.001s)
[306.152556] [055/133] (702s left) api_intel_allocator (reopen)
[306.189034] Starting subtest: reopen
[306.190856] Subtest reopen: SUCCESS (0.002s)
[306.308006] [056/133] (702s left) gem_ctx_persistence (engines-mixed)
[306.348368] Starting subtest: engines-mixed
[306.349147] Starting dynamic subtest: rcs0
[306.397716] Dynamic subtest rcs0: SUCCESS (0.048s)
[306.413819] Starting dynamic subtest: bcs0
[306.451500] Dynamic subtest bcs0: SUCCESS (0.052s)
[306.468185] Starting dynamic subtest: vcs0
[306.500692] Dynamic subtest vcs0: SUCCESS (0.047s)
[306.517218] Starting dynamic subtest: vcs1
[306.549579] Dynamic subtest vcs1: SUCCESS (0.047s)
[306.565725] Starting dynamic subtest: vecs0
[306.608518] Dynamic subtest vecs0: SUCCESS (0.057s)
[306.609540] Subtest engines-mixed: SUCCESS (0.261s)
[306.688191] [057/133] (702s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[306.780491] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[307.852795] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (1.072s)
[307.981891] [058/133] (700s left) kms_big_fb (linear-8bpp-rotate-90)
[308.082292] Starting subtest: linear-8bpp-rotate-90
[308.153734] Subtest linear-8bpp-rotate-90: SKIP (0.070s)
[308.284449] [059/133] (700s left) kms_addfb_basic (basic)
[308.325057] Starting subtest: basic
[308.325791] Subtest basic: SUCCESS (0.000s)
[308.461278] [060/133] (700s left) perf_pmu (busy-start)
[308.500904] Starting subtest: busy-start
[308.501675] Starting dynamic subtest: rcs0
[311.019268] Dynamic subtest rcs0: SUCCESS (2.518s)
[311.030669] Starting dynamic subtest: bcs0
[313.563991] Dynamic subtest bcs0: SUCCESS (2.518s)
[313.573736] Starting dynamic subtest: vcs0
[316.082265] Dynamic subtest vcs0: SUCCESS (2.515s)
[316.091729] Starting dynamic subtest: vcs1
[318.597979] Dynamic subtest vcs1: SUCCESS (2.529s)
[318.607397] Starting dynamic subtest: vecs0
[321.130203] Dynamic subtest vecs0: SUCCESS (2.520s)
[321.131198] Subtest busy-start: SUCCESS (12.607s)
[321.182184] [061/133] (687s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[321.283112] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[321.324562] [062/133] (687s left) gem_mmap_gtt (medium-copy-odd)
[321.360922] Starting subtest: medium-copy-odd
[324.994123] Subtest medium-copy-odd: SUCCESS (3.634s)
[325.059905] [063/133] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[325.206394] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[325.207832] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[325.301717] [064/133] (683s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[325.392683] Starting subtest: addfb25-framebuffer-vs-set-tiling
[325.393465] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[325.463858] [065/133] (683s left) gen9_exec_parse (batch-zero-length)
[325.505097] Subtest batch-zero-length: SKIP (0.000s)
[325.553535] [066/133] (683s left) kms_content_protection (uevent)
[325.666892] Starting subtest: uevent
[326.009324] Subtest uevent: SKIP (0.342s)
[326.174707] [067/133] (682s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[326.224141] Starting subtest: etime-single-wait-all-for-submit-submitted
[326.328665] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[326.402650] [068/133] (682s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[326.439227] Starting subtest: etime-multi-wait-all-for-submit-submitted
[326.547039] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[326.612396] [069/133] (682s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[326.704426] Starting subtest: primary-x-tiled-reflect-x-180
[330.291813] Subtest primary-x-tiled-reflect-x-180: SUCCESS (3.588s)
[330.471201] [070/133] (678s left) vkms/vkms_configfs (encoder-default-files)
[330.520446] Subtest encoder-default-files: SKIP (0.000s)
[330.581310] [071/133] (678s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[330.678519] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[330.679270] Starting dynamic subtest: pipe-A-HDMI-A-1
[330.686335] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[330.694535] Starting dynamic subtest: pipe-B-HDMI-A-1
[330.701481] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[330.707859] Starting dynamic subtest: pipe-C-HDMI-A-1
[330.714809] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[330.720956] Starting dynamic subtest: pipe-D-HDMI-A-1
[330.727740] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[330.729063] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[330.923820] [072/133] (678s left) gem_ctx_persistence (legacy-engines-mixed-process)
[330.965493] Starting subtest: legacy-engines-mixed-process
[330.966216] Starting dynamic subtest: render
[331.348877] Dynamic subtest render: SUCCESS (0.382s)
[331.363136] Starting dynamic subtest: bsd1
[331.727705] Dynamic subtest bsd1: SUCCESS (0.376s)
[331.737337] Starting dynamic subtest: bsd2
[332.087838] Dynamic subtest bsd2: SUCCESS (0.357s)
[332.102361] Starting dynamic subtest: blt
[332.458754] Dynamic subtest blt: SUCCESS (0.368s)
[332.473200] Starting dynamic subtest: vebox
[332.840283] Dynamic subtest vebox: SUCCESS (0.379s)
[332.841428] Subtest legacy-engines-mixed-process: SUCCESS (1.875s)
[332.924612] [073/133] (676s left) gem_mmap_gtt (hang-busy)
[332.963815] Starting subtest: hang-busy
[369.307460] Subtest hang-busy: SUCCESS (36.339s)
[369.417739] [074/133] (640s left) kms_flip (2x-nonexisting-fb)
[369.509732] Starting subtest: 2x-nonexisting-fb
[369.518360] Subtest 2x-nonexisting-fb: SKIP (0.009s)
[369.584657] [075/133] (639s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[369.676748] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[369.678123] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[369.788047] [076/133] (639s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[369.879574] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[369.881069] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[369.985699] [077/133] (639s left) i915_query (query-topology-kernel-writes)
[370.022713] Starting subtest: query-topology-kernel-writes
[370.023452] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[370.094074] [078/133] (639s left) gem_eio (wait-immediate)
[370.138892] Starting subtest: wait-immediate
[370.284857] Subtest wait-immediate: SUCCESS (0.145s)
[370.400587] [079/133] (639s left) gem_linear_blits (basic)
[370.491023] Starting subtest: basic
[370.495955] Subtest basic: SUCCESS (0.005s)
[370.623120] [080/133] (639s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[370.762809] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[370.764226] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[370.863301] [081/133] (638s left) i915_pm_rps (thresholds-idle)
[370.905229] Starting subtest: thresholds-idle
[370.905987] Starting dynamic subtest: gt0
[381.405018] Dynamic subtest gt0: SUCCESS (10.499s)
[381.406267] Subtest thresholds-idle: SUCCESS (10.500s)
[381.477699] [082/133] (628s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[381.579722] Starting subtest: yf-tiled-64bpp-rotate-90
[381.581127] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[381.679340] [083/133] (628s left) kms_chamelium_color (degamma)
[381.767159] Subtest degamma: SKIP (0.000s)
[381.814726] [084/133] (628s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[381.858857] Starting subtest: single-wait-all-for-submit-available-signaled
[381.859630] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[381.927639] [085/133] (627s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[382.023547] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[382.025020] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[382.106728] [086/133] (627s left) gem_lmem_swapping (verify-ccs)
[382.147576] Subtest verify-ccs: SKIP (0.000s)
[382.188647] [087/133] (627s left) kms_vblank (invalid)
[382.274969] Starting subtest: invalid
[382.276778] Starting dynamic subtest: pipe-A-HDMI-A-1
[382.462803] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.186s)
[382.463557] Subtest invalid: SUCCESS (0.188s)
[382.610548] [088/133] (627s left) kms_selftest (drm_cmdline_parser)
[382.656037] Starting subtest: drm_cmdline_parser
[382.666181] Starting dynamic subtest: drm_test_cmdline_force_d_only
[382.771284] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.104s)
[382.788169] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[382.884288] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.111s)
[382.901371] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[382.987796] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.101s)
[383.001548] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[383.088034] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.098s)
[383.105877] Starting dynamic subtest: drm_test_cmdline_force_e_only
[383.184924] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.093s)
[383.200811] Starting dynamic subtest: drm_test_cmdline_res
[383.291588] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.105s)
[383.305879] Starting dynamic subtest: drm_test_cmdline_res_vesa
[383.396548] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.102s)
[383.412594] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[383.501425] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.102s)
[383.519863] Starting dynamic subtest: drm_test_cmdline_res_rblank
[383.594529] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.090s)
[383.609438] Starting dynamic subtest: drm_test_cmdline_res_bpp
[383.708264] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.110s)
[383.724195] Starting dynamic subtest: drm_test_cmdline_res_refresh
[383.819467] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.110s)
[383.832033] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[383.917227] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.095s)
[383.934797] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[384.015513] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.094s)
[384.032350] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[384.110994] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.093s)
[384.129606] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[384.208472] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.092s)
[384.226521] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[384.322420] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.110s)
[384.338431] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[384.422135] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.097s)
[384.438121] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[384.517569] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.092s)
[384.533541] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[384.613074] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.094s)
[384.629643] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[384.714750] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.098s)
[384.731227] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[384.797750] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.083s)
[384.813979] Starting dynamic subtest: drm_test_cmdline_name
[384.919785] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.119s)
[384.936068] Starting dynamic subtest: drm_test_cmdline_name_bpp
[385.008198] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.085s)
[385.024549] Starting dynamic subtest: drm_test_cmdline_name_option
[385.119133] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.109s)
[385.135522] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[385.220853] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.100s)
[385.237352] Starting dynamic subtest: drm_test_cmdline_rotate_0
[385.317140] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.094s)
[385.333246] Starting dynamic subtest: drm_test_cmdline_rotate_90
[385.436918] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.117s)
[385.453720] Starting dynamic subtest: drm_test_cmdline_rotate_180
[385.548528] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.109s)
[385.565131] Starting dynamic subtest: drm_test_cmdline_rotate_270
[385.645932] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.095s)
[385.662537] Starting dynamic subtest: drm_test_cmdline_hmirror
[385.743453] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.096s)
[385.759179] Starting dynamic subtest: drm_test_cmdline_vmirror
[385.847106] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.100s)
[385.864280] Starting dynamic subtest: drm_test_cmdline_margin_options
[385.956608] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.110s)
[385.972167] Starting dynamic subtest: drm_test_cmdline_multiple_options
[386.037489] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.078s)
[386.053984] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[386.134357] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.094s)
[386.153177] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[386.238538] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.100s)
[386.254934] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[386.349374] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.108s)
[386.365797] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[386.456742] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.105s)
[386.475259] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[386.547079] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.087s)
[386.565079] Starting dynamic subtest: drm_test_cmdline_invalid
[386.673431] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.122s)
[386.683956] Starting dynamic subtest: drm_test_cmdline_tv_options
[386.783348] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.104s)
[386.784451] Subtest drm_cmdline_parser: SUCCESS (4.123s)
[386.951135] [089/133] (623s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[386.993956] Starting subtest: basic-cpu-wc-noreloc
[386.996024] Subtest basic-cpu-wc-noreloc: SUCCESS (0.002s)
[387.117643] [090/133] (622s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[387.211834] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[387.213320] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[387.300239] [091/133] (622s left) gem_eio (create)
[387.344528] Starting subtest: create
[387.370876] Subtest create: SUCCESS (0.025s)
[387.491984] [092/133] (622s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[387.585701] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[387.587162] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[387.686995] [093/133] (622s left) kms_cursor_edge_walk (256x256-left-edge)
[387.778732] Starting subtest: 256x256-left-edge
[387.779688] Starting dynamic subtest: pipe-A-HDMI-A-1
[389.570822] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.791s)
[389.578749] Starting dynamic subtest: pipe-D-HDMI-A-1
[391.261470] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.689s)
[391.262155] Subtest 256x256-left-edge: SUCCESS (3.484s)
[391.370805] [094/133] (618s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[391.469554] Starting subtest: flip-vs-cursor-legacy
[397.292723] Subtest flip-vs-cursor-legacy: SUCCESS (5.790s)
[397.387185] [095/133] (612s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[397.485498] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[397.486971] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[397.577293] [096/133] (612s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[397.671279] Starting subtest: psr-rgb565-draw-blt
[397.672772] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[397.761700] [097/133] (612s left) gem_mmap (pf-nonblock)
[397.798620] Starting subtest: pf-nonblock
[397.800427] Subtest pf-nonblock: SUCCESS (0.002s)
[397.921516] [098/133] (612s left) gem_tiled_partial_pwrite_pread (reads)
[397.963221] Starting subtest: reads
[398.317894] Subtest reads: SUCCESS (0.354s)
[398.431286] [099/133] (612s left) kms_async_flips (test-cursor-atomic)
[398.520886] Starting subtest: test-cursor-atomic
[398.650725] Starting dynamic subtest: pipe-A-HDMI-A-1
[398.743478] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.093s)
[398.878039] Starting dynamic subtest: pipe-B-HDMI-A-1
[398.942682] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.073s)
[399.052827] Starting dynamic subtest: pipe-C-HDMI-A-1
[399.109770] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.065s)
[399.225174] Starting dynamic subtest: pipe-D-HDMI-A-1
[399.285141] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.066s)
[399.285896] Subtest test-cursor-atomic: SUCCESS (0.765s)
[399.514483] [100/133] (610s left) gem_exec_reloc (basic-wc-cpu-active)
[399.556270] Starting subtest: basic-wc-cpu-active
[399.683736] Subtest basic-wc-cpu-active: SUCCESS (0.118s)
[399.795524] [101/133] (610s left) syncobj_timeline (multi-wait-available-submitted)
[399.833093] Starting subtest: multi-wait-available-submitted
[399.833836] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[399.902884] [102/133] (610s left) kms_cursor_crc (cursor-random-128x128)
[399.997278] Starting subtest: cursor-random-128x128
[400.003477] Starting dynamic subtest: pipe-A-HDMI-A-1
[401.924811] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.921s)
[401.956958] Starting dynamic subtest: pipe-D-HDMI-A-1
[403.829260] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.879s)
[403.829973] Subtest cursor-random-128x128: SUCCESS (3.832s)
[403.961772] [103/133] (606s left) gem_exec_schedule (implicit-write-read)
[404.013828] Starting subtest: implicit-write-read
[404.014543] Starting dynamic subtest: rcs0
[404.069939] Dynamic subtest rcs0: SUCCESS (0.056s)
[404.080951] Starting dynamic subtest: bcs0
[404.126176] Dynamic subtest bcs0: SUCCESS (0.054s)
[404.138837] Starting dynamic subtest: vcs0
[404.185185] Dynamic subtest vcs0: SUCCESS (0.057s)
[404.197344] Starting dynamic subtest: vcs1
[404.243265] Dynamic subtest vcs1: SUCCESS (0.056s)
[404.255840] Starting dynamic subtest: vecs0
[404.305119] Dynamic subtest vecs0: SUCCESS (0.060s)
[404.306319] Subtest implicit-write-read: SUCCESS (0.293s)
[404.621831] [104/133] (606s left) gem_bad_reloc (negative-reloc-lut)
[404.662363] Starting subtest: negative-reloc-lut
[404.664485] Subtest negative-reloc-lut: SUCCESS (0.000s)
[404.766664] [105/133] (605s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[404.865740] Starting subtest: x-tiled-addfb-size-offset-overflow
[404.866483] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[404.948744] [106/133] (605s left) kms_hdmi_inject (inject-4k)
[405.039528] Starting subtest: inject-4k
[405.270482] Subtest inject-4k: SUCCESS (0.231s)
[405.403557] [107/133] (605s left) kms_pm_backlight (fade)
[405.494544] Subtest fade: SKIP (0.000s)
[405.538653] [108/133] (605s left) prime_vgem (sync)
[405.604564] Starting subtest: sync
[405.605323] Starting dynamic subtest: rcs0
[405.650582] Dynamic subtest rcs0: SUCCESS (0.045s)
[405.661189] Starting dynamic subtest: bcs0
[405.687116] Dynamic subtest bcs0: SUCCESS (0.034s)
[405.698778] Starting dynamic subtest: vcs0
[405.703305] Dynamic subtest vcs0: SUCCESS (0.015s)
[405.711947] Starting dynamic subtest: vcs1
[405.727355] Dynamic subtest vcs1: SUCCESS (0.023s)
[405.737490] Starting dynamic subtest: vecs0
[405.747679] Dynamic subtest vecs0: SUCCESS (0.019s)
[405.748524] Subtest sync: SUCCESS (0.144s)
[405.868221] [109/133] (604s left) kms_pm_rpm (fences)
[407.271688] Starting subtest: fences
[412.100908] Subtest fences: SUCCESS (4.821s)
[412.176181] [110/133] (598s left) sw_sync (sync_busy_fork_unixsocket)
[412.217308] Starting subtest: sync_busy_fork_unixsocket
[412.232296] Subtest sync_busy_fork_unixsocket: SUCCESS (0.015s)
[412.292408] [111/133] (598s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[412.387678] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[412.388443] Starting dynamic subtest: pipe-A-HDMI-A-1
[412.391342] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[412.400456] Starting dynamic subtest: pipe-B-HDMI-A-1
[412.403354] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[412.413094] Starting dynamic subtest: pipe-C-HDMI-A-1
[412.416571] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[412.424647] Starting dynamic subtest: pipe-D-HDMI-A-1
[412.427408] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[412.428807] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[412.645450] [112/133] (598s left) device_reset (cold-reset-bound)
[412.697390] Starting subtest: cold-reset-bound
[412.698793] Subtest cold-reset-bound: SKIP (0.000s)
[412.757828] [113/133] (598s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[412.846870] Starting subtest: plane-all-transition-nonblocking-fencing
[412.848712] Starting dynamic subtest: pipe-A-HDMI-A-1
[414.771190] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.914s)
[414.808680] Starting dynamic subtest: pipe-B-HDMI-A-1
[416.740262] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.932s)
[416.757576] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (3.911s)
[416.909332] [114/133] (594s left) gem_partial_pwrite_pread (write-uncached)
[416.959176] Starting subtest: write-uncached
[426.805223] Subtest write-uncached: SUCCESS (9.846s)
[426.944851] [115/133] (584s left) kms_cursor_crc (cursor-sliding-512x170)
[427.040572] Starting subtest: cursor-sliding-512x170
[427.042086] Subtest cursor-sliding-512x170: SKIP (0.001s)
[427.143637] [116/133] (584s left) kms_invalid_mode (int-max-clock)
[427.232601] Starting subtest: int-max-clock
[427.233326] Starting dynamic subtest: pipe-A-HDMI-A-1
[427.294371] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.061s)
[427.302748] Starting dynamic subtest: pipe-B-HDMI-A-1
[427.303510] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[427.310406] Starting dynamic subtest: pipe-C-HDMI-A-1
[427.311087] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[427.317886] Starting dynamic subtest: pipe-D-HDMI-A-1
[427.318573] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[427.319247] Subtest int-max-clock: SUCCESS (0.069s)
[427.436161] [117/133] (583s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[427.531010] Starting subtest: disable-crc-after-crtc
[427.532855] Starting dynamic subtest: pipe-A-HDMI-A-1
[427.859157] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.327s)
[427.867509] Starting dynamic subtest: pipe-B-HDMI-A-1
[428.162220] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.301s)
[428.170503] Starting dynamic subtest: pipe-C-HDMI-A-1
[428.478969] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.314s)
[428.489796] Starting dynamic subtest: pipe-D-HDMI-A-1
[428.792511] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.311s)
[428.793224] Subtest disable-crc-after-crtc: SUCCESS (1.261s)
[428.924481] [118/133] (582s left) gem_mmap_wc (close)
[428.963638] Starting subtest: close
[428.967221] Subtest close: SUCCESS (0.003s)
[429.057823] [119/133] (582s left) vgem_basic (bad-fence)
[429.121732] Starting subtest: bad-fence
[429.122865] Subtest bad-fence: SUCCESS (0.000s)
[429.183764] [120/133] (582s left) syncobj_timeline (transfer-timeline-point)
[429.220044] Starting subtest: transfer-timeline-point
[429.220826] Subtest transfer-timeline-point: SUCCESS (0.000s)
[429.289080] [121/133] (582s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[429.331889] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[429.332797] Starting dynamic subtest: smem
[429.417445] Dynamic subtest smem: SUCCESS (0.085s)
[429.418195] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.086s)
[429.592960] [122/133] (581s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[429.685068] Starting subtest: flip-vs-cursor-busy-crc-legacy
[430.031321] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.337s)
[430.182293] [123/133] (581s left) gem_wait (busy)
[430.248128] Starting subtest: busy
[430.248873] Starting dynamic subtest: all-engines
[430.771126] Dynamic subtest all-engines: SUCCESS (0.522s)
[430.778645] Starting dynamic subtest: rcs0
[431.293907] Dynamic subtest rcs0: SUCCESS (0.522s)
[431.301706] Starting dynamic subtest: bcs0
[431.815163] Dynamic subtest bcs0: SUCCESS (0.520s)
[431.822423] Starting dynamic subtest: vcs0
[432.336018] Dynamic subtest vcs0: SUCCESS (0.520s)
[432.343582] Starting dynamic subtest: vcs1
[432.853924] Dynamic subtest vcs1: SUCCESS (0.517s)
[432.861123] Starting dynamic subtest: vecs0
[433.369982] Dynamic subtest vecs0: SUCCESS (0.515s)
[433.370725] Subtest busy: SUCCESS (3.122s)
[433.569739] [124/133] (577s left) kms_big_fb (linear-16bpp-rotate-270)
[433.670424] Starting subtest: linear-16bpp-rotate-270
[433.748342] Subtest linear-16bpp-rotate-270: SKIP (0.077s)
[433.885309] [125/133] (577s left) gem_exec_reloc (basic-write-read-noreloc)
[433.926076] Starting subtest: basic-write-read-noreloc
[433.928197] Subtest basic-write-read-noreloc: SUCCESS (0.002s)
[434.047119] [126/133] (577s left) gem_exec_balancer (hang)
[434.215644] Starting subtest: hang
[435.256445] Subtest hang: SUCCESS (1.049s)
[435.328095] [127/133] (576s left) gem_ctx_bad_destroy (invalid-ctx)
[435.365765] Starting subtest: invalid-ctx
[435.366461] Subtest invalid-ctx: SUCCESS (0.000s)
[435.429508] [128/133] (576s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[435.525046] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[435.526380] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[435.618705] [129/133] (576s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[435.718101] Starting subtest: 4-tiled-64bpp-rotate-270
[435.719559] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[435.817121] [130/133] (575s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[435.906073] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[435.908069] Starting dynamic subtest: pipe-A-HDMI-A-1
[435.915160] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[435.922304] Starting dynamic subtest: pipe-B-HDMI-A-1
[435.929419] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[435.936689] Starting dynamic subtest: pipe-C-HDMI-A-1
[435.943762] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[435.950625] Starting dynamic subtest: pipe-D-HDMI-A-1
[435.957440] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[435.958792] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[436.139065] [131/133] (575s left) gem_render_copy_redux (flink-interruptible)
[436.181964] Starting subtest: flink-interruptible
[437.120638] Subtest flink-interruptible: SUCCESS (0.938s)
[437.235867] [132/133] (574s left) device_reset (unbind-reset-rebind)
[437.284228] Starting subtest: unbind-reset-rebind
[439.095099] Subtest unbind-reset-rebind: SUCCESS (1.802s)
[439.132349] [133/133] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[439.226660] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[439.228155] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[439.354838] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: gem_ctx_engines
results: parsing output: 4/ for test: kms_dither
results: parsing output: 5/ for test: i915_pm_rc6_residency
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: kms_feature_discovery
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_exec_whisper
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: gem_exec_gttfill
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: vkms/vkms_configfs
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: dumb_buffer
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_basic
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: i915_query
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_madvise
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: kms_chamelium_audio
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_vrr
results: parsing output: 48/ for test: kms_color
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: kms_legacy_colorkey
results: parsing output: 54/ for test: api_intel_allocator
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: perf_pmu
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: vkms/vkms_configfs
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: gem_eio
results: parsing output: 78/ for test: gem_linear_blits
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: i915_pm_rps
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_chamelium_color
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_selftest
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_edge_walk
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_mmap
results: parsing output: 97/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 98/ for test: kms_async_flips
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: gem_bad_reloc
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_hdmi_inject
results: parsing output: 106/ for test: kms_pm_backlight
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: kms_pm_rpm
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: device_reset
results: parsing output: 112/ for test: kms_atomic_transition
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_invalid_mode
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: gem_mmap_wc
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: gem_wait
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gem_ctx_bad_destroy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: gem_render_copy_redux
results: parsing output: 131/ for test: device_reset
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.