[56.638660] Initializing watchdogs
[56.638704]   /dev/watchdog0
[56.652157] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.656281] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.658433] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.661891] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[56.779652] Starting subtest: psr-2p-primscrn-cur-indfb-move
[56.783930] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[56.891568] [002/133] (960s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[56.943296] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[57.049295] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[57.120675] [003/133] (960s left) gen9_exec_parse (shadow-peek)
[57.182897] Subtest shadow-peek: SKIP (0.000s)
[57.239189] [004/133] (960s left) syncobj_timeline (single-wait-all-available-signaled)
[57.290781] Starting subtest: single-wait-all-available-signaled
[57.292922] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[57.383238] [005/133] (959s left) kms_vblank (ts-continuation-modeset-rpm)
[57.465552] Starting subtest: ts-continuation-modeset-rpm
[57.467440] Starting dynamic subtest: pipe-A-eDP-1
[60.741136] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.291s)
[60.753080] Starting dynamic subtest: pipe-D-eDP-1
[62.980951] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s)
[62.983209] Subtest ts-continuation-modeset-rpm: SUCCESS (5.538s)
[63.773589] [006/133] (953s left) i915_suspend (sysfs-reader)
[63.841734] Starting subtest: sysfs-reader
[81.923294] Subtest sysfs-reader: SUCCESS (3.243s)
[82.066577] [007/133] (935s left) kms_pm_lpsp (kms-lpsp)
[83.386447] Starting subtest: kms-lpsp
[83.388610] Starting dynamic subtest: pipe-A-eDP-1
[83.559428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.180s)
[83.846613] Subtest kms-lpsp: SUCCESS (0.471s)
[84.656777] [008/133] (932s left) kms_chamelium_color (degamma)
[84.737990] Subtest degamma: SKIP (0.000s)
[84.778164] [009/133] (932s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[84.874522] Starting subtest: compare-crc-sanitycheck-nv12
[84.876435] Starting dynamic subtest: pipe-A-eDP-1
[85.540032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s)
[85.548985] Starting dynamic subtest: pipe-B-eDP-1
[86.782152] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[86.791283] Starting dynamic subtest: pipe-C-eDP-1
[88.025958] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.255s)
[88.036554] Starting dynamic subtest: pipe-D-eDP-1
[89.200126] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.186s)
[89.202488] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.379s)
[90.045526] [010/133] (927s left) kms_atomic_transition (modeset-transition)
[90.133431] Starting subtest: modeset-transition
[90.135458] Starting dynamic subtest: 1x-outputs
[100.967521] Dynamic subtest 1x-outputs: SUCCESS (10.884s)
[100.970023] Subtest modeset-transition: SUCCESS (10.885s)
[101.827547] [011/133] (915s left) sw_sync (timeline_closed_signaled)
[101.871236] Starting subtest: timeline_closed_signaled
[101.873597] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[101.925299] [012/133] (915s left) gem_render_copy (y-tiled)
[101.970360] Starting subtest: y-tiled
[101.974736] Subtest y-tiled: SKIP (0.000s)
[102.149588] [013/133] (915s left) kms_flip (dpms-off-confusion)
[102.263801] Starting subtest: dpms-off-confusion
[102.266111] Starting dynamic subtest: A-eDP1
[110.915515] Dynamic subtest A-eDP1: SUCCESS (8.665s)
[110.923461] Starting dynamic subtest: B-eDP1
[119.632412] Dynamic subtest B-eDP1: SUCCESS (8.714s)
[119.642742] Starting dynamic subtest: C-eDP1
[128.265026] Dynamic subtest C-eDP1: SUCCESS (8.632s)
[128.275416] Starting dynamic subtest: D-eDP1
[136.898076] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[136.903196] Subtest dpms-off-confusion: SUCCESS (34.654s)
[138.061040] [014/133] (879s left) gem_exec_balancer (full-late)
[138.128072] Starting subtest: full-late
[142.598917] Subtest full-late: SUCCESS (4.474s)
[142.909827] [015/133] (874s left) perf_pmu (busy-hang)
[142.950602] Starting subtest: busy-hang
[142.952962] Starting dynamic subtest: rcs0
[144.160754] Dynamic subtest rcs0: SUCCESS (1.209s)
[144.171676] Starting dynamic subtest: bcs0
[145.342108] Dynamic subtest bcs0: SUCCESS (1.183s)
[145.353304] Starting dynamic subtest: vcs0
[147.294149] Dynamic subtest vcs0: SUCCESS (1.952s)
[147.305233] Starting dynamic subtest: vcs1
[149.296286] Dynamic subtest vcs1: SUCCESS (2.000s)
[149.307933] Starting dynamic subtest: vecs0
[151.265253] Dynamic subtest vecs0: SUCCESS (1.971s)
[151.276311] Starting dynamic subtest: ccs0
[152.453248] Dynamic subtest ccs0: SUCCESS (1.185s)
[152.455302] Subtest busy-hang: SUCCESS (9.505s)
[152.558963] [016/133] (865s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[152.675711] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[153.354786] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[153.514428] [017/133] (864s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[153.609805] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[153.613960] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[153.700485] [018/133] (864s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[153.756552] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[153.760534] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[153.933661] [019/133] (864s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[154.021235] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[154.025400] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[154.086802] [020/133] (863s left) kms_big_fb (linear-32bpp-rotate-180)
[154.179876] Starting subtest: linear-32bpp-rotate-180
[155.668369] Subtest linear-32bpp-rotate-180: SUCCESS (1.489s)
[155.811112] [021/133] (862s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[155.900886] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[155.904266] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[156.000770] [022/133] (862s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[156.057098] Starting subtest: invalid-multi-wait-unsubmitted
[156.059309] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[156.151801] [023/133] (861s left) kms_psr (psr-primary-render)
[156.242630] Starting subtest: psr-primary-render
[156.245072] Starting dynamic subtest: eDP-1
[157.951975] Dynamic subtest eDP-1: SUCCESS (1.711s)
[157.954268] Subtest psr-primary-render: SUCCESS (1.711s)
[158.815646] [024/133] (859s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[158.919900] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[158.924013] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[158.992611] [025/133] (859s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[159.050783] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[159.053256] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[159.148246] [026/133] (859s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[159.250088] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[159.275515] Starting dynamic subtest: pipe-A-plane-0
[159.708627] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[159.718100] Starting dynamic subtest: pipe-A-plane-3
[159.974857] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[161.111575] Starting dynamic subtest: pipe-B-plane-0
[161.547916] Dynamic subtest pipe-B-plane-0: SUCCESS (0.445s)
[161.558711] Starting dynamic subtest: pipe-B-plane-3
[161.803529] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[162.111360] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.864s)
[162.987057] [027/133] (855s left) kms_chamelium_audio (dp-audio)
[163.364477] Subtest dp-audio: SKIP (0.000s)
[164.200238] [028/133] (854s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[164.317295] Starting subtest: basic-flip-after-cursor-legacy
[165.254816] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.936s)
[166.046623] [029/133] (852s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[166.106752] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[166.211191] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[166.297764] [030/133] (852s left) kms_legacy_colorkey (basic)
[166.397019] Starting subtest: basic
[166.399170] Starting dynamic subtest: pipe-A
[166.438609] Dynamic subtest pipe-A: SUCCESS (0.045s)
[166.450780] Starting dynamic subtest: pipe-B
[166.453095] Dynamic subtest pipe-B: SUCCESS (0.001s)
[166.461618] Starting dynamic subtest: pipe-C
[166.463575] Dynamic subtest pipe-C: SUCCESS (0.000s)
[166.471920] Starting dynamic subtest: pipe-D
[166.473802] Dynamic subtest pipe-D: SUCCESS (0.000s)
[166.475748] Subtest basic: SUCCESS (0.049s)
[166.509460] [031/133] (851s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[166.622152] Starting subtest: cursorB-vs-flipA-toggle
[166.626722] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[166.773621] [032/133] (851s left) kms_flip (flip-vs-suspend)
[166.869279] Starting subtest: flip-vs-suspend
[166.871659] Starting dynamic subtest: A-eDP1
[215.933738] Dynamic subtest A-eDP1: SUCCESS (4.606s)
[215.948692] Starting dynamic subtest: B-eDP1
[264.934356] Dynamic subtest B-eDP1: SUCCESS (4.458s)
[264.944884] Starting dynamic subtest: C-eDP1
[313.944365] Dynamic subtest C-eDP1: SUCCESS (4.508s)
[313.959686] Starting dynamic subtest: D-eDP1
[362.934617] Dynamic subtest D-eDP1: SUCCESS (4.533s)
[362.937683] Subtest flip-vs-suspend: SUCCESS (18.115s)
[364.102226] [033/133] (654s left) kms_flip (2x-plain-flip-interruptible)
[364.205643] Starting subtest: 2x-plain-flip-interruptible
[364.215616] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[364.287666] [034/133] (654s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[364.407479] Starting subtest: verify-pxp-stale-buf-optout-execution
[365.468769] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.081s)
[365.592200] [035/133] (652s left) gem_exec_params (secure-non-root)
[365.643338] Starting subtest: secure-non-root
[365.648541] Subtest secure-non-root: SKIP (0.000s)
[365.744832] [036/133] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[365.849568] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[365.854425] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[365.931057] [037/133] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[366.027683] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[366.032474] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[366.104179] [038/133] (652s left) gem_mmap_gtt (basic-write)
[366.154150] Subtest basic-write: SKIP (0.000s)
[366.220578] [039/133] (652s left) gem_close_race (multigpu-basic-process)
[366.279744] Starting subtest: multigpu-basic-process
[366.284780] Subtest multigpu-basic-process: SKIP (0.000s)
[366.494483] [040/133] (652s left) api_intel_bb (object-noreloc-keep-cache-simple)
[366.554197] Starting subtest: object-noreloc-keep-cache-simple
[366.561657] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.009s)
[366.663911] [041/133] (652s left) gem_softpin (noreloc-interruptible)
[366.721524] Starting subtest: noreloc-interruptible
[372.069712] Subtest noreloc-interruptible: SUCCESS (5.404s)
[372.264057] [042/133] (646s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[372.320712] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[372.364198] [043/133] (646s left) kms_addfb_basic (bad-pitch-999)
[372.422742] Starting subtest: bad-pitch-999
[372.425651] Subtest bad-pitch-999: SUCCESS (0.000s)
[372.544083] [044/133] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[372.633065] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[377.017840] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.414s)
[378.205253] [045/133] (640s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[378.300816] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[378.303667] Starting dynamic subtest: pipe-A-default-mode
[379.432922] Dynamic subtest pipe-A-default-mode: SKIP (1.135s)
[379.438186] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.137s)
[379.581923] [046/133] (639s left) gem_mmap_offset (close-race)
[379.637615] Starting subtest: close-race
[399.740252] Subtest close-race: SUCCESS (20.121s)
[399.856659] [047/133] (619s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[399.962147] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[399.964590] Starting dynamic subtest: pipe-A-eDP-1
[399.984829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[399.993648] Starting dynamic subtest: pipe-B-eDP-1
[400.013549] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[400.022265] Starting dynamic subtest: pipe-C-eDP-1
[400.042255] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[400.050920] Starting dynamic subtest: pipe-D-eDP-1
[400.071478] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[400.073595] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[402.258305] [048/133] (616s left) kms_flip (plain-flip-fb-recreate-interruptible)
[402.355259] Starting subtest: plain-flip-fb-recreate-interruptible
[402.357789] Starting dynamic subtest: A-eDP1
[411.163517] Dynamic subtest A-eDP1: SUCCESS (8.806s)
[411.174205] Starting dynamic subtest: B-eDP1
[419.999108] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[420.015578] Starting dynamic subtest: C-eDP1
[428.832361] Dynamic subtest C-eDP1: SUCCESS (8.833s)
[428.844445] Starting dynamic subtest: D-eDP1
[437.666246] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[437.671151] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.317s)
[438.822404] [049/133] (580s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[438.921949] Starting subtest: fbcpsr-rgb101010-draw-render
[445.692835] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.776s)
[445.818616] [050/133] (573s left) kms_selftest (drm_damage_helper)
[445.859329] Starting subtest: drm_damage_helper
[445.898757] Starting dynamic subtest: drm_test_damage_iter_no_damage
[445.991678] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.092s)
[446.000911] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[446.083854] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.092s)
[446.094182] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[446.179413] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.092s)
[446.190453] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[446.273740] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.094s)
[446.283787] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[446.356893] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.081s)
[446.367496] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[446.440933] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.084s)
[446.456408] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[446.523685] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.082s)
[446.538765] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[446.620087] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.096s)
[446.630249] Starting dynamic subtest: drm_test_damage_iter_single_damage
[446.707906] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.085s)
[446.717851] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[446.799399] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.094s)
[446.809674] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[446.899219] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.095s)
[446.908807] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[446.985787] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.087s)
[446.995247] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[447.072912] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.089s)
[447.083445] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[447.161904] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.088s)
[447.172154] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[447.264102] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.102s)
[447.274711] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[447.349683] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.084s)
[447.358791] Starting dynamic subtest: drm_test_damage_iter_damage
[447.432769] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.081s)
[447.441674] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[447.513274] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.080s)
[447.521814] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[447.596477] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.082s)
[447.605179] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[447.687682] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.090s)
[447.696128] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[447.771240] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.081s)
[447.773703] Subtest drm_damage_helper: SUCCESS (1.913s)
[447.909595] [051/133] (571s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[447.962489] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[448.094682] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.132s)
[448.216785] [052/133] (571s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[448.316905] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[448.321671] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[449.477179] [053/133] (569s left) syncobj_timeline (wait-zero-handles)
[449.540767] Starting subtest: wait-zero-handles
[449.543607] Subtest wait-zero-handles: SUCCESS (0.000s)
[449.627937] [054/133] (569s left) gem_exec_reloc (basic-wc-read)
[449.689080] Subtest basic-wc-read: SKIP (0.000s)
[449.755431] [055/133] (569s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[449.851333] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[449.856254] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[449.950351] [056/133] (569s left) kms_invalid_mode (zero-vdisplay)
[450.050270] Starting subtest: zero-vdisplay
[450.052743] Starting dynamic subtest: pipe-A-eDP-1
[450.334789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[450.344801] Starting dynamic subtest: pipe-B-eDP-1
[450.347110] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[450.356537] Starting dynamic subtest: pipe-C-eDP-1
[450.359029] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[450.368553] Starting dynamic subtest: pipe-D-eDP-1
[450.371195] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[450.373693] Subtest zero-vdisplay: SUCCESS (0.291s)
[451.201646] [057/133] (568s left) syncobj_timeline (multi-wait-submitted-signaled)
[451.259151] Starting subtest: multi-wait-submitted-signaled
[451.261832] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[451.364631] [058/133] (568s left) gem_ctx_persistence (legacy-engines-mixed-process)
[451.425821] Starting subtest: legacy-engines-mixed-process
[451.428760] Starting dynamic subtest: render
[452.828052] Dynamic subtest render: SUCCESS (1.402s)
[452.842938] Starting dynamic subtest: bsd1
[454.778443] Dynamic subtest bsd1: SUCCESS (1.946s)
[454.790198] Starting dynamic subtest: bsd2
[456.764172] Dynamic subtest bsd2: SUCCESS (1.984s)
[456.774262] Starting dynamic subtest: blt
[458.771817] Dynamic subtest blt: SUCCESS (2.008s)
[458.781822] Starting dynamic subtest: vebox
[460.816514] Dynamic subtest vebox: SUCCESS (2.041s)
[460.819358] Subtest legacy-engines-mixed-process: SUCCESS (9.393s)
[460.902766] [059/133] (558s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[461.004663] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[467.243902] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.240s)
[468.402255] [060/133] (551s left) gen9_exec_parse (cmd-crossing-page)
[468.473602] Subtest cmd-crossing-page: SKIP (0.000s)
[468.536136] [061/133] (551s left) i915_pm_freq_api (freq-reset)
[468.600761] Starting subtest: freq-reset
[468.603476] Starting dynamic subtest: gt0
[468.785568] Dynamic subtest gt0: SUCCESS (0.184s)
[468.797157] Starting dynamic subtest: gt1
[468.955049] Dynamic subtest gt1: SUCCESS (0.163s)
[468.957936] Subtest freq-reset: SUCCESS (0.350s)
[469.027462] [062/133] (550s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[469.129698] Starting subtest: yf-tiled-8bpp-rotate-0
[469.134949] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[469.229021] [063/133] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[469.325075] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[476.032740] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.710s)
[476.153719] [064/133] (543s left) syncobj_basic (create-signaled)
[476.207748] Starting subtest: create-signaled
[476.210415] Subtest create-signaled: SUCCESS (0.000s)
[476.303471] [065/133] (543s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[476.407355] Starting subtest: fbcpsr-2p-rte
[476.412203] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[476.512947] [066/133] (543s left) gem_exec_params (sol-reset-invalid)
[476.571071] Starting subtest: sol-reset-invalid
[476.573666] Subtest sol-reset-invalid: SUCCESS (0.003s)
[477.833258] [067/133] (542s left) gem_wait (write-busy)
[477.896964] Starting subtest: write-busy
[477.899782] Starting dynamic subtest: all-engines
[478.510291] Dynamic subtest all-engines: SUCCESS (0.612s)
[478.525762] Starting dynamic subtest: rcs0
[479.057828] Dynamic subtest rcs0: SUCCESS (0.547s)
[479.072210] Starting dynamic subtest: bcs0
[479.607667] Dynamic subtest bcs0: SUCCESS (0.548s)
[479.622114] Starting dynamic subtest: vcs0
[480.779242] Dynamic subtest vcs0: SUCCESS (1.169s)
[480.794801] Starting dynamic subtest: vcs1
[482.763645] Dynamic subtest vcs1: SUCCESS (1.981s)
[482.780929] Starting dynamic subtest: vecs0
[484.811186] Dynamic subtest vecs0: SUCCESS (2.045s)
[484.828042] Starting dynamic subtest: ccs0
[485.361761] Dynamic subtest ccs0: SUCCESS (0.549s)
[485.364667] Subtest write-busy: SUCCESS (7.464s)
[485.558202] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[485.562407] [068/133] (534s left) gem_exec_async (concurrent-writes)
[485.622621] Starting subtest: concurrent-writes
[485.625893] Starting dynamic subtest: rcs0
[485.654787] Dynamic subtest rcs0: SUCCESS (0.031s)
[485.669382] Starting dynamic subtest: bcs0
[485.672259] Dynamic subtest bcs0: SUCCESS (0.014s)
[485.682426] Starting dynamic subtest: vcs0
[485.685747] Dynamic subtest vcs0: SUCCESS (0.008s)
[485.696081] Starting dynamic subtest: vcs1
[485.698732] Dynamic subtest vcs1: SUCCESS (0.011s)
[485.708612] Starting dynamic subtest: vecs0
[485.711824] Dynamic subtest vecs0: SUCCESS (0.011s)
[485.721778] Starting dynamic subtest: ccs0
[485.724393] Dynamic subtest ccs0: SUCCESS (0.013s)
[485.726953] Subtest concurrent-writes: SUCCESS (0.097s)
[485.949891] [069/133] (534s left) gem_softpin (allocator-fork)
[486.011941] Starting subtest: allocator-fork
[488.229949] Subtest allocator-fork: SUCCESS (2.217s)
[488.363955] [070/133] (531s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[488.470757] Starting subtest: x-tiled-32bpp-rotate-0
[489.860979] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.389s)
[489.993318] [071/133] (530s left) kms_psr (fbc-pr-primary-render)
[490.086493] Starting subtest: fbc-pr-primary-render
[490.091274] Subtest fbc-pr-primary-render: SKIP (0.000s)
[490.158298] [072/133] (529s left) gem_workarounds (basic-read-context)
[490.235645] Starting subtest: basic-read-context
[490.247504] Subtest basic-read-context: SUCCESS (0.012s)
[490.376056] [073/133] (529s left) kms_psr (psr-cursor-plane-move)
[490.469602] Starting subtest: psr-cursor-plane-move
[490.471555] Starting dynamic subtest: eDP-1
[492.213818] Dynamic subtest eDP-1: SUCCESS (1.742s)
[492.216382] Subtest psr-cursor-plane-move: SUCCESS (1.743s)
[493.071331] [074/133] (527s left) gem_softpin (noreloc-s3)
[493.132048] Starting subtest: noreloc-S3
[513.944713] Subtest noreloc-S3: SUCCESS (5.380s)
[514.065207] [075/133] (506s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[514.184866] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[514.192105] Starting dynamic subtest: pipe-A
[514.247224] Dynamic subtest pipe-A: SUCCESS (0.065s)
[514.256564] Starting dynamic subtest: pipe-B
[515.348147] Dynamic subtest pipe-B: SUCCESS (1.114s)
[515.357716] Starting dynamic subtest: pipe-C
[516.671589] Dynamic subtest pipe-C: SUCCESS (1.337s)
[516.680503] Starting dynamic subtest: pipe-D
[517.784311] Dynamic subtest pipe-D: SUCCESS (1.123s)
[517.786763] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.644s)
[518.934740] [076/133] (501s left) i915_pm_rc6_residency (media-rc6-accuracy)
[518.986798] Starting subtest: media-rc6-accuracy
[518.991088] Subtest media-rc6-accuracy: SKIP (0.000s)
[519.090667] [077/133] (501s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[519.200311] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[519.204826] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[519.342099] [078/133] (500s left) gem_exec_schedule (noreorder)
[519.518863] Starting subtest: noreorder
[519.521365] Starting dynamic subtest: rcs0
[519.589695] Dynamic subtest rcs0: SUCCESS (0.071s)
[519.602180] Starting dynamic subtest: vcs0
[521.303803] Dynamic subtest vcs0: SUCCESS (1.723s)
[521.320698] Starting dynamic subtest: vcs1
[523.283869] Dynamic subtest vcs1: SUCCESS (1.988s)
[523.297837] Starting dynamic subtest: vecs0
[525.271267] Dynamic subtest vecs0: SUCCESS (1.992s)
[525.283132] Starting dynamic subtest: ccs0
[525.356825] Dynamic subtest ccs0: SUCCESS (0.084s)
[525.359666] Subtest noreorder: SUCCESS (5.870s)
[525.543800] [079/133] (494s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[525.653052] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[532.600793] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.968s)
[532.717731] [080/133] (487s left) kms_force_connector_basic (force-connector-state)
[532.792555] Starting subtest: force-connector-state
[533.400240] Subtest force-connector-state: SUCCESS (0.611s)
[534.385524] [081/133] (486s left) kms_psr (pr-no-drrs)
[534.473967] Starting subtest: pr-no-drrs
[534.478172] Subtest pr-no-drrs: SKIP (0.000s)
[534.545979] [082/133] (485s left) gem_exec_balancer (persistence)
[534.823699] Starting subtest: persistence
[535.710302] Subtest persistence: SUCCESS (0.887s)
[535.846957] [083/133] (484s left) prime_vgem (basic-fence-mmap)
[535.919385] Starting subtest: basic-fence-mmap
[535.923495] Subtest basic-fence-mmap: SKIP (0.000s)
[536.018269] [084/133] (484s left) kms_cursor_crc (cursor-onscreen-max-size)
[536.345046] Starting subtest: cursor-onscreen-max-size
[536.351459] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[536.482721] [085/133] (484s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[536.542498] Starting subtest: invalid-bsd1-flag-on-blt
[536.544770] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[536.641598] [086/133] (484s left) gem_exec_whisper (basic-normal-all)
[536.704268] Starting subtest: basic-normal-all
[539.091657] Subtest basic-normal-all: SUCCESS (2.387s)
[539.285958] [087/133] (481s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[539.388864] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[543.493844] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.113s)
[544.665170] [088/133] (476s left) gem_exec_fence (submit)
[544.842048] Starting subtest: submit
[544.846896] Subtest submit: SKIP (0.000s)
[546.363685] [089/133] (474s left) kms_setmode (invalid-clone-single-crtc-stealing)
[546.422492] Starting subtest: invalid-clone-single-crtc-stealing
[546.429027] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[546.525456] [090/133] (474s left) gem_exec_fence (syncobj-unused-fence)
[546.938599] Starting subtest: syncobj-unused-fence
[546.944317] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[548.399596] [091/133] (472s left) kms_psr (fbc-psr-cursor-plane-move)
[548.494742] Starting subtest: fbc-psr-cursor-plane-move
[548.497006] Starting dynamic subtest: eDP-1
[548.501239] Dynamic subtest eDP-1: SKIP (0.000s)
[548.505450] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[548.566586] [092/133] (472s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[548.659937] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[548.662232] Starting dynamic subtest: pipe-A-eDP-1
[548.807055] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[548.817587] Starting dynamic subtest: pipe-B-eDP-1
[548.837000] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[548.848403] Starting dynamic subtest: pipe-C-eDP-1
[548.867503] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[548.876672] Starting dynamic subtest: pipe-D-eDP-1
[548.895219] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.014s)
[548.897097] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.178s)
[551.061194] [093/133] (469s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[551.154567] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[551.158670] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[551.253762] [094/133] (469s left) syncobj_timeline (multi-wait-all-available-signaled)
[551.315378] Starting subtest: multi-wait-all-available-signaled
[551.317346] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[551.413695] [095/133] (469s left) gem_ccs (block-copy-compressed)
[551.476173] Starting subtest: block-copy-compressed
[551.481155] Subtest block-copy-compressed: SKIP (0.000s)
[551.567045] [096/133] (469s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[551.669423] Starting subtest: y-tiled-8bpp-rotate-270
[551.673792] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[551.789698] [097/133] (469s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[551.889616] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[551.893721] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[552.007200] [098/133] (469s left) gem_eio (in-flight-10ms)
[552.232194] Starting subtest: in-flight-10ms
[561.187342] Subtest in-flight-10ms: SUCCESS (8.954s)
[561.372926] [099/133] (459s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[561.503609] Starting subtest: short-flip-after-cursor-atomic-transitions
[562.455898] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.951s)
[563.259609] [100/133] (458s left) gem_lmem_swapping (verify)
[563.304519] Subtest verify: SKIP (0.000s)
[563.344830] [101/133] (457s left) kms_vrr (seamless-rr-switch-drrs)
[563.450934] Starting subtest: seamless-rr-switch-drrs
[563.457504] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[563.526018] [102/133] (457s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[563.632994] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[563.636977] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[563.735904] [103/133] (457s left) gem_exec_schedule (u-semaphore-user)
[563.803407] Starting subtest: u-semaphore-user
[563.853012] Subtest u-semaphore-user: SUCCESS (0.058s)
[565.317424] [104/133] (456s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[565.418590] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[566.422011] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.002s)
[566.557563] [105/133] (454s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[566.652114] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[566.654304] Starting dynamic subtest: pipe-A-eDP-1
[577.349453] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.702s)
[577.363583] Starting dynamic subtest: pipe-B-eDP-1
[588.719086] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.372s)
[588.721433] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.077s)
[589.560610] [106/133] (431s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[589.661426] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[596.452040] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.796s)
[596.599578] [107/133] (424s left) sriov_basic (enable-vfs-autoprobe-off)
[596.655927] Starting subtest: enable-vfs-autoprobe-off
[596.658392] Starting dynamic subtest: numvfs-1
[596.737480] Dynamic subtest numvfs-1: FAIL (0.028s)
[596.747467] Starting dynamic subtest: numvfs-2
[596.818819] Dynamic subtest numvfs-2: FAIL (0.004s)
[596.829955] Starting dynamic subtest: numvfs-3
[596.902929] Dynamic subtest numvfs-3: FAIL (0.004s)
[596.913693] Starting dynamic subtest: numvfs-4
[596.987334] Dynamic subtest numvfs-4: FAIL (0.008s)
[596.997784] Starting dynamic subtest: numvfs-5
[597.070350] Dynamic subtest numvfs-5: FAIL (0.010s)
[597.081774] Starting dynamic subtest: numvfs-6
[597.152262] Dynamic subtest numvfs-6: FAIL (0.010s)
[597.161461] Starting dynamic subtest: numvfs-7
[597.230098] Dynamic subtest numvfs-7: FAIL (0.010s)
[597.239826] Starting dynamic subtest: numvfs-random
[597.309060] Dynamic subtest numvfs-random: FAIL (0.005s)
[597.320397] Starting dynamic subtest: numvfs-all
[597.392747] Dynamic subtest numvfs-all: FAIL (0.004s)
[597.394843] Subtest enable-vfs-autoprobe-off: FAIL (0.096s)
[597.435168] [108/133] (424s left) kms_addfb_basic (invalid-get-prop-any)
[597.494044] Starting subtest: invalid-get-prop-any
[597.495994] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[597.635602] [109/133] (424s left) dmabuf_sync_file (export-basic)
[597.674106] Starting subtest: export-basic
[597.675643] Subtest export-basic: SUCCESS (0.001s)
[597.732832] [110/133] (423s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[597.783310] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[597.838509] [111/133] (423s left) api_intel_bb (crc32)
[597.900734] Starting subtest: crc32
[597.902916] Starting dynamic subtest: rcs0-smem0
[598.191585] Dynamic subtest rcs0-smem0: SUCCESS (0.289s)
[598.205314] Starting dynamic subtest: bcs0-smem0
[598.505791] Dynamic subtest bcs0-smem0: SUCCESS (0.312s)
[598.518894] Starting dynamic subtest: vcs0-smem0
[598.888354] Dynamic subtest vcs0-smem0: SUCCESS (0.380s)
[598.901073] Starting dynamic subtest: vcs1-smem0
[599.267536] Dynamic subtest vcs1-smem0: SUCCESS (0.376s)
[599.278065] Starting dynamic subtest: vecs0-smem0
[599.674228] Dynamic subtest vecs0-smem0: SUCCESS (0.404s)
[599.686999] Starting dynamic subtest: ccs0-smem0
[600.034572] Dynamic subtest ccs0-smem0: SUCCESS (0.357s)
[600.037468] Subtest crc32: SUCCESS (2.135s)
[600.152791] [112/133] (421s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[600.243934] Starting subtest: primary-y-tiled-reflect-x-270
[600.248404] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[600.320892] [113/133] (421s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[600.410171] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[600.414703] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[600.498793] [114/133] (421s left) kms_chamelium_hpd (vga-hpd)
[600.876983] Subtest vga-hpd: SKIP (0.000s)
[601.722258] [115/133] (420s left) kms_fbcon_fbt (fbc)
[601.783291] Starting subtest: fbc
[608.282267] Subtest fbc: SUCCESS (6.501s)
[609.464630] [116/133] (412s left) kms_dsc (dsc-with-bpc-formats)
[609.558999] Starting subtest: dsc-with-bpc-formats
[609.673517] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[609.715878] [117/133] (412s left) kms_async_flips (alternate-sync-async-flip-atomic)
[609.820820] Starting subtest: alternate-sync-async-flip-atomic
[610.191491] Starting dynamic subtest: pipe-A-eDP-1
[613.004320] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.812s)
[613.387042] Starting dynamic subtest: pipe-B-eDP-1
[616.203375] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.825s)
[616.587209] Starting dynamic subtest: pipe-C-eDP-1
[619.408065] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.827s)
[619.772593] Starting dynamic subtest: pipe-D-eDP-1
[622.604143] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.839s)
[622.606038] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.781s)
[623.755686] [118/133] (398s left) syncobj_wait (multi-wait-signaled)
[623.820465] Starting subtest: multi-wait-signaled
[623.822897] Subtest multi-wait-signaled: SUCCESS (0.000s)
[623.948978] [119/133] (398s left) kms_cursor_crc (cursor-sliding-64x21)
[624.155818] Starting subtest: cursor-sliding-64x21
[624.202636] Subtest cursor-sliding-64x21: SKIP (0.042s)
[624.449669] [120/133] (397s left) gem_exec_params (rel-constants-invalid)
[624.508447] Starting subtest: rel-constants-invalid
[624.510755] Subtest rel-constants-invalid: SUCCESS (0.000s)
[624.606185] [121/133] (397s left) kms_cursor_crc (cursor-random-256x256)
[624.863432] Starting subtest: cursor-random-256x256
[624.870733] Starting dynamic subtest: pipe-A-eDP-1
[628.251968] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.378s)
[628.293267] Starting dynamic subtest: pipe-D-eDP-1
[632.202176] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.922s)
[632.204900] Subtest cursor-random-256x256: SUCCESS (7.338s)
[633.044453] [122/133] (389s left) kms_content_protection (legacy)
[633.200177] Starting subtest: legacy
[633.204789] Subtest legacy: SKIP (0.000s)
[633.335273] [123/133] (388s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[633.425200] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[633.427512] Starting dynamic subtest: A-eDP1
[637.106743] Dynamic subtest A-eDP1: SUCCESS (3.677s)
[637.116926] Starting dynamic subtest: B-eDP1
[640.383738] Dynamic subtest B-eDP1: SUCCESS (3.274s)
[640.394176] Starting dynamic subtest: C-eDP1
[643.680105] Dynamic subtest C-eDP1: SUCCESS (3.295s)
[643.690559] Starting dynamic subtest: D-eDP1
[646.980713] Dynamic subtest D-eDP1: SUCCESS (3.302s)
[646.983026] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.557s)
[647.855975] [124/133] (374s left) kms_prime (basic-crc-vgem)
[647.949268] Starting subtest: basic-crc-vgem
[647.951458] Starting dynamic subtest: second-to-first
[648.927921] Dynamic subtest second-to-first: SUCCESS (0.982s)
[648.929838] Subtest basic-crc-vgem: SUCCESS (0.983s)
[649.037801] [125/133] (373s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[649.161597] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[649.163471] Starting dynamic subtest: pipe-A-eDP-1
[649.180257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[649.195884] Starting dynamic subtest: pipe-B-eDP-1
[649.212117] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[649.221253] Starting dynamic subtest: pipe-C-eDP-1
[649.236763] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[649.245353] Starting dynamic subtest: pipe-D-eDP-1
[649.261105] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[649.262682] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[651.444904] [126/133] (370s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[651.544487] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[651.548745] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[651.631891] [127/133] (370s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[651.722270] Starting subtest: crc-primary-suspend-y-tiled-ccs
[651.724514] Starting dynamic subtest: pipe-A-eDP-1
[651.733449] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[651.749335] Starting dynamic subtest: pipe-B-eDP-1
[651.758305] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[651.771544] Starting dynamic subtest: pipe-C-eDP-1
[651.780539] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[651.790029] Starting dynamic subtest: pipe-D-eDP-1
[651.798898] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[651.803214] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[653.939348] [128/133] (368s left) gem_basic (bad-close)
[653.994579] Starting subtest: bad-close
[653.999041] Subtest bad-close: SUCCESS (0.000s)
[654.081054] [129/133] (368s left) gem_ctx_exec (basic-nohangcheck)
[654.140232] Starting subtest: basic-nohangcheck
[654.376325] Subtest basic-nohangcheck: SUCCESS (0.238s)
[654.494519] [130/133] (368s left) kms_flip (2x-flip-vs-panning)
[654.596041] Starting subtest: 2x-flip-vs-panning
[654.604416] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[654.684229] [131/133] (367s left) gem_fence_thrash (bo-write-verify-threaded-x)
[654.719730] Starting subtest: bo-write-verify-threaded-x
[654.756018] Subtest bo-write-verify-threaded-x: SKIP (0.034s)
[654.827742] [132/133] (367s left) kms_psr (fbc-pr-cursor-plane-move)
[654.920824] Starting subtest: fbc-pr-cursor-plane-move
[654.925172] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[654.997339] [133/133] (367s left) kms_color (ctm-green-to-red)
[655.084014] Starting subtest: ctm-green-to-red
[655.086270] Starting dynamic subtest: pipe-A-eDP-1
[655.772773] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[655.783535] Starting dynamic subtest: pipe-B-eDP-1
[657.173431] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[657.184292] Starting dynamic subtest: pipe-C-eDP-1
[658.547522] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[658.558082] Starting dynamic subtest: pipe-D-eDP-1
[659.822225] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.274s)
[659.824462] Subtest ctm-green-to-red: SUCCESS (4.738s)
[660.644878] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: i915_suspend
results: parsing output: 6/ for test: kms_pm_lpsp
results: parsing output: 7/ for test: kms_chamelium_color
results: parsing output: 8/ for test: kms_pipe_crc_basic
results: parsing output: 9/ for test: kms_atomic_transition
results: parsing output: 10/ for test: sw_sync
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_chamelium_audio
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_legacy_colorkey
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: gem_close_race
results: parsing output: 39/ for test: api_intel_bb
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: gem_mmap_offset
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_selftest
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: i915_pm_freq_api
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: gem_wait
results: parsing output: 67/ for test: gem_exec_async
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_workarounds
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: i915_pm_rc6_residency
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_force_connector_basic
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: prime_vgem
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_setmode
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: gem_ccs
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_lmem_swapping
results: parsing output: 100/ for test: kms_vrr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: sriov_basic
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: dmabuf_sync_file
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: kms_fbcon_fbt
results: parsing output: 115/ for test: kms_dsc
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_content_protection
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_prime
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_basic
results: parsing output: 128/ for test: gem_ctx_exec
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: gem_fence_thrash
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_color
Done.