[59.529786] Initializing watchdogs
[59.529830]   /dev/watchdog0
[59.544261] [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]
[59.548710] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.550863] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.554196] [001/134] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[59.630839] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[59.633103] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[59.737470] [002/134] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[59.834989] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[59.837353] Starting dynamic subtest: pipe-A-default-mode
[60.125772] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[60.130450] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.289s)
[60.971167] [003/134] (959s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[61.044083] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[61.046563] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[61.142192] [004/134] (959s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[61.234816] Starting subtest: plane-downscale-factor-0-75-with-rotation
[61.237135] Starting dynamic subtest: pipe-A
[61.464824] Dynamic subtest pipe-A: SUCCESS (0.232s)
[61.472942] Starting dynamic subtest: pipe-B
[62.747059] Dynamic subtest pipe-B: SUCCESS (1.282s)
[62.754948] Starting dynamic subtest: pipe-C
[64.078680] Dynamic subtest pipe-C: SUCCESS (1.331s)
[64.087566] Starting dynamic subtest: pipe-D
[65.410684] Dynamic subtest pipe-D: SUCCESS (1.332s)
[65.413195] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.178s)
[66.611150] [005/134] (953s left) kms_psr (fbc-psr2-cursor-render)
[66.706870] Starting subtest: fbc-psr2-cursor-render
[66.708808] Starting dynamic subtest: eDP-1
[66.712874] Dynamic subtest eDP-1: SKIP (0.000s)
[66.716988] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[66.794940] [006/134] (953s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[66.870617] Starting subtest: invalid-bsd1-flag-on-vebox
[66.872908] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.001s)
[66.995348] [007/134] (953s left) i915_hangman (error-state-basic)
[67.166135] Starting subtest: error-state-basic
[67.243124] Subtest error-state-basic: SUCCESS (0.075s)
[67.442591] [008/134] (952s left) perf_pmu (busy-idle-check-all)
[67.511454] Starting subtest: busy-idle-check-all
[67.513983] Starting dynamic subtest: rcs0
[68.193076] Dynamic subtest rcs0: SUCCESS (0.681s)
[68.204429] Starting dynamic subtest: bcs0
[68.843427] Dynamic subtest bcs0: SUCCESS (0.650s)
[68.854205] Starting dynamic subtest: vcs0
[70.933615] Dynamic subtest vcs0: SUCCESS (2.088s)
[70.945281] Starting dynamic subtest: vcs1
[72.917513] Dynamic subtest vcs1: SUCCESS (1.982s)
[72.929029] Starting dynamic subtest: vecs0
[74.901930] Dynamic subtest vecs0: SUCCESS (1.983s)
[74.912640] Starting dynamic subtest: ccs0
[75.558300] Dynamic subtest ccs0: SUCCESS (0.657s)
[75.560966] Subtest busy-idle-check-all: SUCCESS (8.047s)
[75.674069] [009/134] (944s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[80.717194] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[80.721660] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[81.563982] [010/134] (938s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[81.663992] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[81.668239] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[81.786417] [011/134] (938s left) kms_psr (psr2-primary-mmap-cpu)
[81.882801] Starting subtest: psr2-primary-mmap-cpu
[81.885097] Starting dynamic subtest: eDP-1
[83.657450] Dynamic subtest eDP-1: SUCCESS (1.776s)
[83.659895] Subtest psr2-primary-mmap-cpu: SUCCESS (1.776s)
[84.535233] [012/134] (935s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[84.595819] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[84.600534] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[84.784189] [013/134] (935s left) i915_suspend (basic-s2idle-without-i915)
[84.824885] Starting subtest: basic-s2idle-without-i915
[105.721467] Subtest basic-s2idle-without-i915: SUCCESS (6.260s)
[115.861102] [014/134] (914s left) gem_fence_thrash (bo-write-verify-none)
[115.911438] Starting subtest: bo-write-verify-none
[115.935966] Subtest bo-write-verify-none: SKIP (0.023s)
[116.005815] [015/134] (914s left) prime_self_import (basic-llseek-size)
[116.040563] Starting subtest: basic-llseek-size
[116.063609] Subtest basic-llseek-size: SUCCESS (0.023s)
[116.204616] [016/134] (914s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[116.319737] Starting subtest: 2x-plain-flip-ts-check-interruptible
[116.332061] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[116.416324] [017/134] (914s left) gem_exec_alignment (pi)
[116.480123] Starting subtest: pi
[164.995102] Subtest pi: SUCCESS (48.502s)
[166.083197] [018/134] (864s left) prime_vgem (basic-blt)
[166.310434] Starting subtest: basic-blt
[166.342195] Subtest basic-blt: SUCCESS (0.031s)
[166.514421] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[166.517548] [019/134] (864s left) kms_big_fb (yf-tiled-addfb)
[166.640024] Starting subtest: yf-tiled-addfb
[166.644618] Subtest yf-tiled-addfb: SKIP (0.000s)
[166.752271] [020/134] (864s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[166.853451] Starting subtest: bad-pixel-format-yf-tiled-ccs
[166.855790] Starting dynamic subtest: pipe-A-eDP-1
[166.879510] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[166.891580] Starting dynamic subtest: pipe-B-eDP-1
[166.913224] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[166.921162] Starting dynamic subtest: pipe-C-eDP-1
[166.942640] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[166.950445] Starting dynamic subtest: pipe-D-eDP-1
[166.972543] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[166.976855] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[169.118610] [021/134] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[169.221835] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[177.980291] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.764s)
[178.109061] [022/134] (852s left) gem_spin_batch (engines)
[178.176955] Starting subtest: engines
[178.179164] Starting dynamic subtest: rcs0
[181.415503] Dynamic subtest rcs0: SUCCESS (3.233s)
[181.426380] Starting dynamic subtest: bcs0
[184.650465] Dynamic subtest bcs0: SUCCESS (3.234s)
[184.661555] Starting dynamic subtest: vcs0
[187.883444] Dynamic subtest vcs0: SUCCESS (3.231s)
[187.892303] Starting dynamic subtest: vcs1
[191.119317] Dynamic subtest vcs1: SUCCESS (3.235s)
[191.133048] Starting dynamic subtest: vecs0
[194.355705] Dynamic subtest vecs0: SUCCESS (3.234s)
[194.366635] Starting dynamic subtest: ccs0
[197.591951] Dynamic subtest ccs0: SUCCESS (3.235s)
[197.594356] Subtest engines: SUCCESS (19.410s)
[197.861902] [023/134] (833s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[197.989838] Starting subtest: flip-vs-cursor-busy-crc-atomic
[198.855465] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.865s)
[199.684629] [024/134] (831s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[199.792263] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[199.796423] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[199.925705] [025/134] (831s left) gem_exec_schedule (semaphore-power)
[200.114392] Subtest semaphore-power: SKIP (0.000s)
[200.300004] [026/134] (830s left) gem_mmap_offset (partial-unmap)
[200.367633] Starting subtest: partial-unmap
[200.369935] Starting dynamic subtest: smem0
[200.873981] Dynamic subtest smem0: SUCCESS (0.506s)
[200.876992] Subtest partial-unmap: SUCCESS (0.507s)
[201.007677] [027/134] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[201.101561] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[207.615415] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.516s)
[207.774527] [028/134] (823s left) kms_cursor_edge_walk (64x64-top-edge)
[207.875603] Starting subtest: 64x64-top-edge
[207.877938] Starting dynamic subtest: pipe-A-eDP-1
[211.349141] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[211.359409] Starting dynamic subtest: pipe-D-eDP-1
[214.467232] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[214.469495] Subtest 64x64-top-edge: SUCCESS (6.591s)
[215.294429] [029/134] (815s left) gem_exec_whisper (basic-fds-forked)
[215.351116] Starting subtest: basic-fds-forked
[239.120427] Subtest basic-fds-forked: SUCCESS (23.764s)
[239.319518] [030/134] (791s left) gem_basic (create-fd-close)
[239.387461] Starting subtest: create-fd-close
[239.391947] Subtest create-fd-close: SUCCESS (0.000s)
[239.499577] [031/134] (791s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[239.599487] Starting subtest: plane-primary-toggle-with-vblank-wait
[239.601761] Starting dynamic subtest: pipe-A-eDP-1
[239.776231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.178s)
[240.088308] Starting dynamic subtest: pipe-B-eDP-1
[240.982923] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.904s)
[241.280281] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.681s)
[242.151763] [032/134] (789s left) vgem_basic (dmabuf-fence)
[242.191560] Starting subtest: dmabuf-fence
[242.193428] Subtest dmabuf-fence: SUCCESS (0.000s)
[242.260192] [033/134] (789s left) syncobj_timeline (wait-for-submit-delayed-submit)
[242.320443] Starting subtest: wait-for-submit-delayed-submit
[242.425596] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[242.514031] [034/134] (788s left) prime_mmap (test_invalid_sync_flags)
[242.561512] Starting subtest: test_invalid_sync_flags
[242.563485] Starting dynamic subtest: test_invalid_sync_flags-smem
[242.565450] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[242.567394] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[242.674570] [035/134] (788s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[242.768405] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[242.797756] Starting dynamic subtest: pipe-A-plane-0
[242.802253] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[242.813352] Starting dynamic subtest: pipe-A-plane-3
[242.817859] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[242.827043] Starting dynamic subtest: pipe-A-plane-5
[242.831595] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[243.938817] Starting dynamic subtest: pipe-B-plane-0
[243.943401] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[243.954532] Starting dynamic subtest: pipe-B-plane-3
[243.959094] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[243.968081] Starting dynamic subtest: pipe-B-plane-5
[243.972515] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[244.253454] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (1.482s)
[245.133390] [036/134] (786s left) gem_exec_fence (submit)
[245.318332] Starting subtest: submit
[245.322746] Subtest submit: SKIP (0.000s)
[247.683472] [037/134] (783s left) syncobj_wait (reset-during-wait-for-submit)
[247.750118] Starting subtest: reset-during-wait-for-submit
[247.854616] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[247.962943] [038/134] (783s left) gem_vm_create (invalid-create)
[248.038611] Starting subtest: invalid-create
[248.041385] Subtest invalid-create: SUCCESS (0.002s)
[248.166618] [039/134] (783s left) gem_exec_balancer (hog)
[248.232758] Starting subtest: hog
[248.237425] Subtest hog: SKIP (0.000s)
[248.562026] [040/134] (783s left) gem_mmap_wc (read-write)
[248.624369] Subtest read-write: SKIP (0.000s)
[248.694899] [041/134] (783s left) gem_exec_parallel (contexts)
[248.762595] Starting subtest: contexts
[248.764949] Starting dynamic subtest: rcs0
[252.741526] Dynamic subtest rcs0: SUCCESS (3.977s)
[252.753346] Starting dynamic subtest: bcs0
[256.209837] Dynamic subtest bcs0: SUCCESS (3.466s)
[256.219227] Starting dynamic subtest: vcs0
[260.151511] Dynamic subtest vcs0: SUCCESS (3.939s)
[260.162931] Starting dynamic subtest: vcs1
[264.078017] Dynamic subtest vcs1: SUCCESS (3.924s)
[264.089878] Starting dynamic subtest: vecs0
[268.073361] Dynamic subtest vecs0: SUCCESS (3.993s)
[268.084722] Starting dynamic subtest: ccs0
[271.566519] Dynamic subtest ccs0: SUCCESS (3.491s)
[271.568930] Subtest contexts: SUCCESS (22.803s)
[271.776821] [042/134] (760s left) gem_exec_reloc (basic-cpu-gtt-active)
[271.827163] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[271.918406] [043/134] (759s left) kms_cursor_crc (cursor-random-128x128)
[272.125528] Starting subtest: cursor-random-128x128
[272.130098] Starting dynamic subtest: pipe-A-eDP-1
[275.499299] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.366s)
[275.530040] Starting dynamic subtest: pipe-D-eDP-1
[279.553698] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.034s)
[279.556252] Subtest cursor-random-128x128: SUCCESS (7.428s)
[280.398450] [044/134] (751s left) kms_lease (empty-lease)
[280.503686] Starting subtest: empty-lease
[280.506005] Starting dynamic subtest: pipe-A-eDP-1
[280.508261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[280.518508] Starting dynamic subtest: pipe-B-eDP-1
[280.520714] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[280.529964] Starting dynamic subtest: pipe-C-eDP-1
[280.532182] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[280.541146] Starting dynamic subtest: pipe-D-eDP-1
[280.543309] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[280.545448] Subtest empty-lease: SUCCESS (0.008s)
[280.657840] [045/134] (751s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[280.751946] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[280.756433] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[281.928020] [046/134] (750s left) gem_mmap_gtt (basic-small-copy-xy)
[281.993558] Subtest basic-small-copy-XY: SKIP (0.000s)
[282.057106] [047/134] (749s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[282.150191] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[289.154894] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.007s)
[289.338102] [048/134] (742s left) kms_flip (bo-too-big-interruptible)
[289.431454] Starting subtest: bo-too-big-interruptible
[289.433723] Starting dynamic subtest: A-eDP1
[290.771564] Dynamic subtest A-eDP1: SUCCESS (1.339s)
[290.780887] Starting dynamic subtest: B-eDP1
[292.005238] Dynamic subtest B-eDP1: SUCCESS (1.232s)
[292.016416] Starting dynamic subtest: C-eDP1
[293.332397] Dynamic subtest C-eDP1: SUCCESS (1.326s)
[293.342728] Starting dynamic subtest: D-eDP1
[294.677723] Dynamic subtest D-eDP1: SUCCESS (1.345s)
[294.683396] Subtest bo-too-big-interruptible: SUCCESS (5.253s)
[295.875909] [049/134] (736s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[295.942253] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[296.046952] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[296.134195] [050/134] (736s left) kms_flip_scaled_crc (flip-32bpp-linear-to-32bpp-linear-reflect-x)
[296.232577] Starting subtest: flip-32bpp-linear-to-32bpp-linear-reflect-x
[296.235060] Starting dynamic subtest: pipe-A-default-mode
[297.424388] Dynamic subtest pipe-A-default-mode: SKIP (1.190s)
[297.429010] Subtest flip-32bpp-linear-to-32bpp-linear-reflect-x: SKIP (1.191s)
[297.587366] [051/134] (734s left) kms_vblank (query-busy-hang)
[297.685690] Starting subtest: query-busy-hang
[297.687931] Starting dynamic subtest: pipe-A-eDP-1
[324.356797] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.668s)
[324.370872] Starting dynamic subtest: pipe-D-eDP-1
[339.338391] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.980s)
[339.340764] Subtest query-busy-hang: SUCCESS (41.652s)
[340.172310] [052/134] (692s left) gen7_exec_parse (oacontrol-tracking)
[340.249315] Subtest oacontrol-tracking: SKIP (0.000s)
[340.311740] [053/134] (691s left) kms_dp_linktrain_fallback (dp-fallback)
[340.420844] Starting subtest: dp-fallback
[340.427305] Subtest dp-fallback: SKIP (0.000s)
[340.502275] [054/134] (691s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[340.594256] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[340.596488] Starting dynamic subtest: pipe-A-eDP-1
[342.800079] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.206s)
[342.811209] Starting dynamic subtest: pipe-B-eDP-1
[345.272241] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.470s)
[345.286228] Starting dynamic subtest: pipe-C-eDP-1
[347.395715] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.122s)
[347.406695] Starting dynamic subtest: pipe-D-eDP-1
[349.511905] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.116s)
[349.513899] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.920s)
[350.786498] [055/134] (681s left) perf_pmu (frequency)
[350.840056] Starting subtest: frequency
[350.842241] Starting dynamic subtest: gt0
[352.990447] Dynamic subtest gt0: SUCCESS (2.143s)
[353.002310] Starting dynamic subtest: idle-gt0
[353.496325] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[353.506977] Starting dynamic subtest: gt1
[358.515258] Dynamic subtest gt1: SUCCESS (5.014s)
[358.525006] Starting dynamic subtest: idle-gt1
[359.052762] Dynamic subtest idle-gt1: SUCCESS (0.537s)
[359.055462] Subtest frequency: SUCCESS (8.216s)
[359.176434] [056/134] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[359.292179] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[359.296528] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[359.405667] [057/134] (673s left) kms_feature_discovery (psr1)
[359.507382] Starting subtest: psr1
[359.509880] Subtest psr1: SUCCESS (0.000s)
[359.606356] [058/134] (672s left) sysfs_heartbeat_interval (nopreempt)
[359.677301] Starting subtest: nopreempt
[359.679600] Starting dynamic subtest: vecs0
[369.558472] Dynamic subtest vecs0: SUCCESS (9.878s)
[369.570973] Starting dynamic subtest: ccs0
[373.621376] Dynamic subtest ccs0: SUCCESS (4.063s)
[373.633740] Starting dynamic subtest: vcs0
[383.569010] Dynamic subtest vcs0: SUCCESS (9.945s)
[383.581611] Starting dynamic subtest: bcs0
[387.504650] Dynamic subtest bcs0: SUCCESS (3.931s)
[387.515298] Starting dynamic subtest: rcs0
[391.542962] Dynamic subtest rcs0: SUCCESS (4.039s)
[391.555900] Starting dynamic subtest: vcs1
[401.554676] Dynamic subtest vcs1: SUCCESS (10.007s)
[401.557416] Subtest nopreempt: SUCCESS (41.875s)
[401.655244] [059/134] (630s left) syncobj_basic (bad-flags-fd-to-handle)
[401.733247] Starting subtest: bad-flags-fd-to-handle
[401.735691] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[401.873921] [060/134] (630s left) kms_flip (2x-blocking-absolute-wf_vblank)
[401.977351] Starting subtest: 2x-blocking-absolute-wf_vblank
[401.988329] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s)
[402.121464] [061/134] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[402.217188] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[409.505985] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.293s)
[409.617079] [062/134] (623s left) syncobj_basic (bad-pad-fd-to-handle)
[409.682517] Starting subtest: bad-pad-fd-to-handle
[409.684746] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[409.805085] [063/134] (622s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[409.870747] Subtest no-spare-fences-busy: SKIP (0.000s)
[409.960214] [064/134] (622s left) kms_flip (2x-plain-flip)
[410.061684] Starting subtest: 2x-plain-flip
[410.071681] Subtest 2x-plain-flip: SKIP (0.011s)
[410.165760] [065/134] (622s left) kms_psr (psr2-cursor-plane-onoff)
[410.262972] Starting subtest: psr2-cursor-plane-onoff
[410.265257] Starting dynamic subtest: eDP-1
[411.971118] Dynamic subtest eDP-1: SUCCESS (1.708s)
[411.973330] Subtest psr2-cursor-plane-onoff: SUCCESS (1.709s)
[412.794219] [066/134] (620s left) kms_chamelium_color (ctm-0-50)
[412.897710] Subtest ctm-0-50: SKIP (0.000s)
[412.985989] [067/134] (619s left) perf (buffer-fill)
[413.135380] Starting subtest: buffer-fill
[413.137329] Starting dynamic subtest: 0-rcs0
[415.400005] Dynamic subtest 0-rcs0: SUCCESS (2.265s)
[415.410448] Starting dynamic subtest: 1-vcs0
[419.838516] Dynamic subtest 1-vcs0: SUCCESS (4.435s)
[419.841253] Subtest buffer-fill: SUCCESS (6.703s)
[419.898963] [068/134] (613s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[424.980280] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[424.982197] Starting dynamic subtest: pipe-A-eDP-1
[425.758642] Dynamic subtest pipe-A-eDP-1: SKIP (0.776s)
[425.770761] Starting dynamic subtest: pipe-B-eDP-1
[426.899888] Dynamic subtest pipe-B-eDP-1: SKIP (1.139s)
[426.904090] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.919s)
[428.097482] [069/134] (604s left) kms_hdr (invalid-hdr)
[428.200753] Starting subtest: invalid-hdr
[430.299422] Starting dynamic subtest: pipe-A-eDP-1
[433.292840] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.994s)
[433.295095] Subtest invalid-hdr: SUCCESS (5.095s)
[433.466109] [070/134] (599s left) kms_addfb_basic (master-rmfb)
[433.538309] Starting subtest: master-rmfb
[433.540268] Subtest master-rmfb: SUCCESS (0.001s)
[433.705768] [071/134] (599s left) kms_atomic_interruptible (universal-setplane-primary)
[433.806448] Starting subtest: universal-setplane-primary
[433.808671] Starting dynamic subtest: pipe-A-eDP-1
[441.250285] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.443s)
[441.252785] Subtest universal-setplane-primary: SUCCESS (7.445s)
[442.099413] [072/134] (591s left) kms_cursor_crc (cursor-onscreen-32x10)
[442.258211] Starting subtest: cursor-onscreen-32x10
[442.308502] Subtest cursor-onscreen-32x10: SKIP (0.045s)
[442.616915] [073/134] (590s left) kms_color (ctm-blue-to-red)
[442.711469] Starting subtest: ctm-blue-to-red
[442.713620] Starting dynamic subtest: pipe-A-eDP-1
[443.399145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[443.410857] Starting dynamic subtest: pipe-B-eDP-1
[444.839356] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.440s)
[444.850232] Starting dynamic subtest: pipe-C-eDP-1
[446.184692] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.342s)
[446.194604] Starting dynamic subtest: pipe-D-eDP-1
[447.521600] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[447.523855] Subtest ctm-blue-to-red: SUCCESS (4.811s)
[448.336485] [074/134] (584s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[448.467285] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[449.280994] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[449.488192] [075/134] (583s left) gem_exec_balancer (sliced)
[449.553861] Starting subtest: sliced
[449.558389] Subtest sliced: SKIP (0.000s)
[449.854664] [076/134] (583s left) kms_atomic_transition (plane-all-transition)
[449.951699] Starting subtest: plane-all-transition
[449.953963] Starting dynamic subtest: pipe-A-eDP-1
[452.447642] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[452.751159] Starting dynamic subtest: pipe-B-eDP-1
[455.955260] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.215s)
[456.266769] Subtest plane-all-transition: SUCCESS (6.313s)
[457.103792] [077/134] (576s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[457.209990] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[458.256273] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[458.388573] [078/134] (574s left) gem_pwrite (basic-exhaustion)
[458.439458] Subtest basic-exhaustion: SKIP (0.000s)
[458.510232] [079/134] (574s left) kms_flip (2x-flip-vs-panning-interruptible)
[458.615622] Starting subtest: 2x-flip-vs-panning-interruptible
[458.627633] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[458.740084] [080/134] (574s left) syncobj_timeline (etime-single-wait-all-submitted)
[458.789397] Starting subtest: etime-single-wait-all-submitted
[458.895089] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[458.984383] [081/134] (574s left) sw_sync (sync_merge)
[459.021329] Starting subtest: sync_merge
[459.023311] Subtest sync_merge: SUCCESS (0.000s)
[459.101569] [082/134] (574s left) gem_pxp (protected-raw-src-copy-not-readible)
[459.223488] Starting subtest: protected-raw-src-copy-not-readible
[459.280392] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[459.438952] [083/134] (574s left) prime_vgem (basic-fence-mmap)
[459.521344] Starting subtest: basic-fence-mmap
[459.525788] Subtest basic-fence-mmap: SKIP (0.000s)
[459.646943] [084/134] (573s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[459.743198] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[459.745298] Starting dynamic subtest: pipe-A-eDP-1
[460.245562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s)
[460.256848] Starting dynamic subtest: pipe-B-eDP-1
[461.751451] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.497s)
[461.763364] Starting dynamic subtest: pipe-C-eDP-1
[463.114570] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[463.126482] Starting dynamic subtest: pipe-D-eDP-1
[464.465160] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.348s)
[464.467147] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.694s)
[465.645871] [085/134] (568s left) gem_busy (busy)
[465.717701] Starting subtest: busy
[465.720029] Starting dynamic subtest: all-engines
[465.791224] Dynamic subtest all-engines: SUCCESS (0.073s)
[465.801504] Starting dynamic subtest: rcs0
[467.528550] Dynamic subtest rcs0: SUCCESS (1.736s)
[467.540158] Starting dynamic subtest: bcs0
[467.586911] Dynamic subtest bcs0: SUCCESS (0.055s)
[467.597725] Starting dynamic subtest: vcs0
[467.625639] Dynamic subtest vcs0: SUCCESS (0.039s)
[467.635450] Starting dynamic subtest: vcs1
[469.575695] Dynamic subtest vcs1: SUCCESS (1.946s)
[469.587373] Starting dynamic subtest: vecs0
[471.561025] Dynamic subtest vecs0: SUCCESS (1.984s)
[471.572386] Starting dynamic subtest: ccs0
[473.545182] Dynamic subtest ccs0: SUCCESS (1.983s)
[473.547692] Subtest busy: SUCCESS (7.824s)
[473.941903] [086/134] (559s left) gem_exec_params (rel-constants-invalid-ring)
[474.013050] Starting subtest: rel-constants-invalid-ring
[474.015243] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[474.124083] [087/134] (559s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[474.512008] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[475.349117] [088/134] (558s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[475.449593] Starting subtest: flip-primary-invalidate-overlay
[487.116795] Subtest flip-primary-invalidate-overlay: SUCCESS (11.668s)
[487.300936] [089/134] (546s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[487.406109] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[487.409381] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[487.515317] [090/134] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[487.613343] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[487.616868] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[487.743218] [091/134] (546s left) gem_exec_schedule (preempt-engines)
[487.816127] Starting subtest: preempt-engines
[487.817820] Starting dynamic subtest: rcs0
[490.059758] Dynamic subtest rcs0: SUCCESS (2.245s)
[490.075477] Starting dynamic subtest: bcs0
[492.285581] Dynamic subtest bcs0: SUCCESS (2.223s)
[492.299129] Starting dynamic subtest: vcs0
[494.581049] Dynamic subtest vcs0: SUCCESS (2.293s)
[494.597934] Starting dynamic subtest: vcs1
[496.863100] Dynamic subtest vcs1: SUCCESS (2.280s)
[496.875698] Starting dynamic subtest: vecs0
[499.118142] Dynamic subtest vecs0: SUCCESS (2.253s)
[499.130460] Starting dynamic subtest: ccs0
[501.458965] Dynamic subtest ccs0: SUCCESS (2.339s)
[501.461856] Subtest preempt-engines: SUCCESS (13.645s)
[501.770577] [092/134] (532s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[501.881146] Starting subtest: primary-yf-tiled-reflect-x-180
[501.952540] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.070s)
[502.068853] [093/134] (531s left) gem_exec_params (sol-reset-not-gen7)
[502.144234] Starting subtest: sol-reset-not-gen7
[502.146280] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[502.304059] [094/134] (531s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[502.400426] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[503.080302] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[503.246960] [095/134] (530s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[503.375885] Starting subtest: cursorA-vs-flipB-atomic-transitions
[503.380704] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[503.570792] [096/134] (530s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[503.683846] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[503.709465] Starting dynamic subtest: pipe-A-plane-0
[503.713696] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[503.725293] Starting dynamic subtest: pipe-A-plane-3
[503.729861] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[503.739629] Starting dynamic subtest: pipe-A-plane-5
[503.744151] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[504.859600] Starting dynamic subtest: pipe-B-plane-0
[504.863802] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[504.873439] Starting dynamic subtest: pipe-B-plane-3
[504.877945] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[504.887677] Starting dynamic subtest: pipe-B-plane-5
[504.892331] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[505.172120] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (1.488s)
[506.049461] [097/134] (528s left) kms_invalid_mode (uint-max-clock)
[506.153775] Starting subtest: uint-max-clock
[506.156143] Starting dynamic subtest: pipe-A-eDP-1
[506.443983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[506.455183] Starting dynamic subtest: pipe-B-eDP-1
[506.457209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[506.467078] Starting dynamic subtest: pipe-C-eDP-1
[506.469276] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[506.478777] Starting dynamic subtest: pipe-D-eDP-1
[506.480957] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[506.483160] Subtest uint-max-clock: SUCCESS (0.296s)
[507.281153] [098/134] (526s left) kms_vrr (lobf)
[507.389504] Starting subtest: lobf
[507.393917] Subtest lobf: SKIP (0.000s)
[507.474745] [099/134] (526s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[507.575395] Starting subtest: fbcpsr-rgb101010-draw-blt
[514.360910] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.788s)
[514.529094] [100/134] (519s left) kms_plane_alpha_blend (alpha-basic)
[514.625772] Starting subtest: alpha-basic
[514.941948] Starting dynamic subtest: pipe-A-eDP-1
[516.860760] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.918s)
[516.889973] Starting dynamic subtest: pipe-D-eDP-1
[519.571869] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.689s)
[519.574226] Subtest alpha-basic: SUCCESS (4.948s)
[520.463147] [101/134] (513s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[520.583273] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[520.587623] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[520.709853] [102/134] (513s left) kms_psr (fbc-psr-dpms)
[520.814519] Starting subtest: fbc-psr-dpms
[520.816786] Starting dynamic subtest: eDP-1
[520.820857] Dynamic subtest eDP-1: SKIP (0.000s)
[520.825019] Subtest fbc-psr-dpms: SKIP (0.001s)
[520.908490] [103/134] (513s left) kms_busy (extended-modeset-hang-oldfb)
[521.004551] Starting subtest: extended-modeset-hang-oldfb
[521.006747] Starting dynamic subtest: pipe-A
[532.725544] Dynamic subtest pipe-A: SUCCESS (11.717s)
[532.745388] Starting dynamic subtest: pipe-D
[544.987084] Dynamic subtest pipe-D: SUCCESS (12.261s)
[544.989340] Subtest extended-modeset-hang-oldfb: SUCCESS (23.983s)
[545.791930] [104/134] (488s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[545.898234] Starting subtest: x-tiled-64bpp-rotate-270
[545.917619] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[546.078590] [105/134] (488s left) gem_mmap_gtt (cpuset-big-copy-odd)
[546.142879] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[546.209797] [106/134] (488s left) api_intel_bb (render-ccs)
[546.262732] Starting subtest: render-ccs
[546.623739] Subtest render-ccs: SUCCESS (0.361s)
[546.732100] [107/134] (487s left) gem_create (create-ext-cpu-access-big)
[546.906548] Starting subtest: create-ext-cpu-access-big
[546.911440] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[546.992338] [108/134] (487s left) i915_drm_fdinfo (idle)
[547.051815] Starting subtest: idle
[547.054170] Starting dynamic subtest: rcs0
[547.667324] Dynamic subtest rcs0: SUCCESS (0.615s)
[547.682952] Starting dynamic subtest: bcs0
[548.178374] Dynamic subtest bcs0: SUCCESS (0.506s)
[548.190851] Starting dynamic subtest: vcs0
[548.686076] Dynamic subtest vcs0: SUCCESS (0.504s)
[548.698755] Starting dynamic subtest: vcs1
[549.192649] Dynamic subtest vcs1: SUCCESS (0.503s)
[549.204992] Starting dynamic subtest: vecs0
[549.699017] Dynamic subtest vecs0: SUCCESS (0.503s)
[549.711270] Starting dynamic subtest: ccs0
[550.204792] Dynamic subtest ccs0: SUCCESS (0.503s)
[550.207316] Subtest idle: SUCCESS (3.153s)
[550.294972] [109/134] (484s left) gem_exec_params (mmapped)
[550.362842] Starting subtest: mmapped
[550.368630] Subtest mmapped: SUCCESS (0.004s)
[550.520030] [110/134] (484s left) kms_chamelium_edid (dp-mode-timings)
[550.911481] Subtest dp-mode-timings: SKIP (0.000s)
[551.689422] [111/134] (483s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[551.793307] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[551.797721] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[551.933712] [112/134] (482s left) api_intel_allocator (execbuf-with-allocator)
[551.996459] Starting subtest: execbuf-with-allocator
[552.001955] Subtest execbuf-with-allocator: SUCCESS (0.008s)
[552.128610] [113/134] (482s left) kms_atomic (plane-primary-legacy)
[552.224334] Starting subtest: plane-primary-legacy
[552.226584] Starting dynamic subtest: pipe-A-eDP-1
[552.668829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[552.671075] Subtest plane-primary-legacy: SUCCESS (0.445s)
[553.553510] [114/134] (481s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[555.683143] Starting subtest: dpms-mode-unset-lpsp
[559.717696] Subtest dpms-mode-unset-lpsp: SUCCESS (4.037s)
[560.103598] [115/134] (474s left) perf_pmu (module-unload)
[560.204379] Starting subtest: module-unload
[567.198986] Subtest module-unload: FAIL (6.895s)
[567.229394] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[567.230142] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[567.233170] [116/134] (467s left) kms_content_protection (dp-mst-type-0)
[568.886447] Starting subtest: dp-mst-type-0
[568.890991] Subtest dp-mst-type-0: SKIP (0.000s)
[568.998009] [FACT kms_content_protection (dp-mst-type-0)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[568.999244] [FACT kms_content_protection (dp-mst-type-0)] new: kernel.kmod_is_loaded.i915: true
[569.003021] [117/134] (466s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[569.109780] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[569.113860] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[569.222061] [118/134] (465s left) syncobj_wait (single-wait-for-submit-signaled)
[569.282247] Starting subtest: single-wait-for-submit-signaled
[569.284189] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[569.409242] [119/134] (465s left) gem_ctx_param (invalid-set-no-zeromap)
[569.468618] Starting subtest: invalid-set-no-zeromap
[569.470970] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[569.557486] [120/134] (465s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[569.661582] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[576.364688] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.705s)
[576.516608] [121/134] (458s left) kms_prop_blob (basic)
[576.586772] Starting subtest: basic
[576.588650] Subtest basic: SUCCESS (0.000s)
[576.707894] [122/134] (458s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[576.803958] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[576.806295] Starting dynamic subtest: pipe-A
[577.151179] Dynamic subtest pipe-A: SUCCESS (0.349s)
[577.164559] Starting dynamic subtest: pipe-B
[578.590542] Dynamic subtest pipe-B: SUCCESS (1.438s)
[578.604293] Starting dynamic subtest: pipe-C
[580.022200] Dynamic subtest pipe-C: SUCCESS (1.429s)
[580.031430] Starting dynamic subtest: pipe-D
[581.457819] Dynamic subtest pipe-D: SUCCESS (1.435s)
[581.460148] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.656s)
[582.646044] [123/134] (452s left) kms_psr (fbc-pr-cursor-render)
[582.759644] Starting subtest: fbc-pr-cursor-render
[582.764103] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[582.843288] [124/134] (452s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[582.942385] Starting subtest: fbc-rgb565-draw-pwrite
[587.483968] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.545s)
[588.641462] [125/134] (446s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[588.699346] Starting subtest: multi-wait-available-unsubmitted-signaled
[588.701726] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[588.843045] [126/134] (446s left) gem_ctx_persistence (userptr)
[588.914039] Starting subtest: userptr
[589.102271] Subtest userptr: SUCCESS (0.188s)
[589.197713] [127/134] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[589.310426] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[589.314811] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[589.445939] [128/134] (446s left) gem_gpgpu_fill (basic)
[589.516686] Starting subtest: basic
[589.519106] Starting dynamic subtest: smem
[589.524594] Dynamic subtest smem: SUCCESS (0.007s)
[589.526892] Subtest basic: SUCCESS (0.008s)
[589.689351] [129/134] (445s left) dmabuf_sync_file (export-wait-after-attach)
[589.733314] Starting subtest: export-wait-after-attach
[589.734891] Subtest export-wait-after-attach: SUCCESS (0.001s)
[589.800643] [130/134] (445s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[589.853767] Starting subtest: invalid-single-wait-all-unsubmitted
[589.855701] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[589.979793] [131/134] (445s left) gem_exec_nop (basic-parallel)
[590.055720] Starting subtest: basic-parallel
[606.534207] Subtest basic-parallel: SUCCESS (16.484s)
[606.780565] [132/134] (428s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[606.899050] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[606.903042] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[607.006981] [133/134] (428s left) i915_pm_rc6_residency (media-rc6-accuracy)
[607.075073] Starting subtest: media-rc6-accuracy
[607.079497] Subtest media-rc6-accuracy: SKIP (0.000s)
[607.209144] [134/134] (428s left) gem_userptr_blits (invalid-null-pointer)
[607.285824] Starting subtest: invalid-null-pointer
[607.288071] Subtest invalid-null-pointer: SUCCESS (0.001s)
[607.413046] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: i915_hangman
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: i915_suspend
results: parsing output: 13/ for test: gem_fence_thrash
results: parsing output: 14/ for test: prime_self_import
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_exec_alignment
results: parsing output: 17/ for test: prime_vgem
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_spin_batch
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: gem_mmap_offset
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: gem_exec_whisper
results: parsing output: 29/ for test: gem_basic
results: parsing output: 30/ for test: kms_atomic_transition
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: gem_vm_create
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: gem_exec_parallel
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_lease
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gen7_exec_parse
results: parsing output: 52/ for test: kms_dp_linktrain_fallback
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_feature_discovery
results: parsing output: 57/ for test: sysfs_heartbeat_interval
results: parsing output: 58/ for test: syncobj_basic
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_basic
results: parsing output: 62/ for test: gem_fenced_exec_thrash
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_chamelium_color
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_hdr
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_atomic_interruptible
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: kms_atomic_transition
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: gem_pwrite
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: prime_vgem
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_busy
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: kms_chamelium_hpd
results: parsing output: 87/ for test: kms_psr_stress_test
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: kms_invalid_mode
results: parsing output: 97/ for test: kms_vrr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_plane_alpha_blend
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_busy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: i915_drm_fdinfo
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_chamelium_edid
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: kms_atomic
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_content_protection
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_ctx_param
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_prop_blob
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_gpgpu_fill
results: parsing output: 128/ for test: dmabuf_sync_file
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_exec_nop
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: i915_pm_rc6_residency
results: parsing output: 133/ for test: gem_userptr_blits
Done.