[58.307954] Initializing watchdogs
[58.308010]   /dev/watchdog0
[58.322690] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.326748] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.328829] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.332130] [001/133] (960s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[58.439243] Starting subtest: yf-tiled-64bpp-rotate-270
[58.443577] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.002s)
[58.547219] [002/133] (960s left) kms_plane_lowres (tiling-yf)
[58.621908] Starting subtest: tiling-yf
[58.626500] Subtest tiling-yf: SKIP (0.000s)
[58.691709] [003/133] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[58.764920] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[58.767198] Starting dynamic subtest: pipe-A-eDP-1
[58.824114] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[58.830346] Starting dynamic subtest: pipe-B-eDP-1
[58.887061] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[58.895091] Starting dynamic subtest: pipe-C-eDP-1
[58.950242] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[58.958617] Starting dynamic subtest: pipe-D-eDP-1
[59.014182] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[59.019070] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[61.307123] [004/133] (957s left) kms_plane (pixel-format-yf-tiled-modifier)
[61.388017] Starting subtest: pixel-format-yf-tiled-modifier
[61.392495] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[61.466106] [005/133] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[61.547928] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[61.552319] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[61.639162] [006/133] (957s left) sw_sync (sync_busy_fork)
[61.684276] Starting subtest: sync_busy_fork
[62.697077] Subtest sync_busy_fork: SUCCESS (1.011s)
[62.769477] [007/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[62.842830] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[62.847227] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.940199] [008/133] (956s left) kms_setmode (invalid-clone-single-crtc)
[62.986888] Starting subtest: invalid-clone-single-crtc
[62.992958] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[63.069370] [009/133] (956s left) gem_exec_gttfill (multigpu-basic)
[63.246420] Starting subtest: multigpu-basic
[75.979633] Subtest multigpu-basic: SUCCESS (12.728s)
[76.021675] [010/133] (943s left) kms_psr (fbc-psr2-sprite-render)
[76.131491] Starting subtest: fbc-psr2-sprite-render
[76.133905] Starting dynamic subtest: eDP-1
[76.138470] Dynamic subtest eDP-1: SKIP (0.000s)
[76.143264] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[76.204873] [011/133] (942s left) perf (enable-disable)
[76.368591] Starting subtest: enable-disable
[76.370518] Starting dynamic subtest: 0-rcs0
[78.609824] Dynamic subtest 0-rcs0: SUCCESS (2.242s)
[78.618088] Starting dynamic subtest: 1-vcs1
[83.053640] Dynamic subtest 1-vcs1: SUCCESS (4.442s)
[83.055884] Subtest enable-disable: SUCCESS (6.684s)
[83.113069] [012/133] (936s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[83.192736] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[83.197191] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[83.296791] [013/133] (935s left) gem_mmap_gtt (basic-copy)
[83.356058] Subtest basic-copy: SKIP (0.000s)
[83.407516] [014/133] (935s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[83.484047] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[83.486364] Starting dynamic subtest: pipe-A-eDP-1
[83.509627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.519395] Starting dynamic subtest: pipe-B-eDP-1
[83.541076] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.549024] Starting dynamic subtest: pipe-C-eDP-1
[83.573242] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.581512] Starting dynamic subtest: pipe-D-eDP-1
[83.603778] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.608085] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[85.691442] [015/133] (933s left) kms_pipe_crc_basic (read-crc)
[85.761741] Starting subtest: read-crc
[85.763704] Starting dynamic subtest: pipe-A-eDP-1
[86.459082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[86.469643] Starting dynamic subtest: pipe-B-eDP-1
[87.861886] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[87.872224] Starting dynamic subtest: pipe-C-eDP-1
[89.135124] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.270s)
[89.144511] Starting dynamic subtest: pipe-D-eDP-1
[90.481959] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[90.484498] Subtest read-crc: SUCCESS (4.720s)
[91.304518] [016/133] (928s left) gem_exec_params (cliprects-invalid)
[91.374716] Starting subtest: cliprects-invalid
[91.377088] Subtest cliprects-invalid: SUCCESS (0.000s)
[91.479838] [017/133] (927s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[91.556307] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[91.558478] Starting dynamic subtest: pipe-A-eDP-1
[97.854705] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.300s)
[97.864256] Starting dynamic subtest: pipe-B-eDP-1
[104.487758] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.633s)
[104.490206] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.936s)
[105.363998] [018/133] (914s left) kms_properties (get_properties-sanity-non-atomic)
[105.439565] Starting subtest: get_properties-sanity-non-atomic
[105.441735] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[105.521903] [019/133] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[105.607421] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[112.390140] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.786s)
[112.521810] [020/133] (907s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[112.586274] Starting subtest: single-wait-for-submit-available-signaled
[112.588540] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[112.678719] [021/133] (906s left) gen9_exec_parse (bb-start-far)
[112.735889] Subtest bb-start-far: SKIP (0.000s)
[112.797031] [022/133] (906s left) gem_ctx_shared (exec-shared-gtt)
[112.876367] Starting subtest: exec-shared-gtt
[112.878816] Starting dynamic subtest: rcs0
[112.887785] Dynamic subtest rcs0: SUCCESS (0.011s)
[112.899031] Starting dynamic subtest: bcs0
[112.901359] Dynamic subtest bcs0: SUCCESS (0.006s)
[112.909190] Starting dynamic subtest: vcs0
[112.911067] Dynamic subtest vcs0: SUCCESS (0.006s)
[112.918554] Starting dynamic subtest: vcs1
[112.920835] Dynamic subtest vcs1: SUCCESS (0.006s)
[112.927876] Starting dynamic subtest: vecs0
[112.929790] Dynamic subtest vecs0: SUCCESS (0.006s)
[112.937126] Starting dynamic subtest: ccs0
[112.939031] Dynamic subtest ccs0: SUCCESS (0.006s)
[112.940938] Subtest exec-shared-gtt: SUCCESS (0.043s)
[113.113124] [023/133] (906s left) gem_ringfill (basic-all)
[118.874969] Starting subtest: basic-all
[120.035296] Subtest basic-all: SUCCESS (1.160s)
[120.153981] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[120.159758] [024/133] (899s left) kms_atomic_interruptible (legacy-setmode)
[120.236176] Starting subtest: legacy-setmode
[120.238393] Starting dynamic subtest: pipe-A-eDP-1
[127.144861] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.906s)
[127.147202] Subtest legacy-setmode: SUCCESS (6.908s)
[128.008778] [025/133] (891s left) gen3_render_tiledy_blits
[128.127918] [026/133] (891s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[128.197226] Starting subtest: etime-multi-wait-all-available-unsubmitted
[128.301124] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s)
[128.376130] [027/133] (891s left) gem_reg_read (timestamp-monotonic)
[128.444184] Starting subtest: timestamp-monotonic
[133.468921] Subtest timestamp-monotonic: SUCCESS (4.974s)
[133.509382] [028/133] (886s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[133.592148] Starting subtest: pr-cursor-plane-update-sf
[133.596442] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[133.657751] [029/133] (886s left) sysfs_heartbeat_interval (idempotent)
[133.728757] Starting subtest: idempotent
[133.731076] Starting dynamic subtest: vecs0
[133.733457] Dynamic subtest vecs0: SUCCESS (0.001s)
[133.743264] Starting dynamic subtest: ccs0
[133.745170] Dynamic subtest ccs0: SUCCESS (0.001s)
[133.752671] Starting dynamic subtest: vcs0
[133.754602] Dynamic subtest vcs0: SUCCESS (0.000s)
[133.761759] Starting dynamic subtest: bcs0
[133.763687] Dynamic subtest bcs0: SUCCESS (0.001s)
[133.770938] Starting dynamic subtest: rcs0
[133.773328] Dynamic subtest rcs0: SUCCESS (0.000s)
[133.780816] Starting dynamic subtest: vcs1
[133.783094] Dynamic subtest vcs1: SUCCESS (0.000s)
[133.785341] Subtest idempotent: SUCCESS (0.007s)
[133.829136] [030/133] (886s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[134.192139] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[135.013428] [031/133] (884s left) perf (missing-sample-flags)
[135.104252] Starting subtest: missing-sample-flags
[135.106589] Subtest missing-sample-flags: SUCCESS (0.000s)
[135.144683] [032/133] (884s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[135.240680] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[135.244997] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[135.328629] [033/133] (884s left) kms_flip (dpms-off-confusion-interruptible)
[135.397158] Starting subtest: dpms-off-confusion-interruptible
[135.399484] Starting dynamic subtest: A-eDP1
[144.076728] Dynamic subtest A-eDP1: SUCCESS (8.645s)
[144.087734] Starting dynamic subtest: B-eDP1
[152.693157] Dynamic subtest B-eDP1: SUCCESS (8.614s)
[152.702029] Starting dynamic subtest: C-eDP1
[161.317686] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[161.331219] Starting dynamic subtest: D-eDP1
[169.946919] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[169.949311] Subtest dpms-off-confusion-interruptible: SUCCESS (34.505s)
[171.060663] [034/133] (849s left) gem_ctx_isolation (preservation)
[171.126076] Starting subtest: preservation
[171.128412] Starting dynamic subtest: rcs0
[171.245887] Dynamic subtest rcs0: SUCCESS (0.120s)
[171.260947] Starting dynamic subtest: bcs0
[171.396393] Dynamic subtest bcs0: SUCCESS (0.148s)
[171.404633] Starting dynamic subtest: vcs0
[171.548486] Dynamic subtest vcs0: SUCCESS (0.152s)
[171.559820] Starting dynamic subtest: vcs1
[172.934633] Dynamic subtest vcs1: SUCCESS (1.386s)
[172.946833] Starting dynamic subtest: vecs0
[174.915958] Dynamic subtest vecs0: SUCCESS (1.981s)
[174.924460] Starting dynamic subtest: ccs0
[176.987061] Dynamic subtest ccs0: SUCCESS (2.070s)
[176.990230] Subtest preservation: SUCCESS (5.861s)
[177.221385] [035/133] (842s left) syncobj_wait (single-wait-all-for-submit-submitted)
[177.270830] Starting subtest: single-wait-all-for-submit-submitted
[177.373516] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[177.465018] [036/133] (842s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[177.557235] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[177.561790] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[177.639816] [037/133] (842s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[177.716890] Starting subtest: fbcpsr-tiling-linear
[184.255139] Subtest fbcpsr-tiling-linear: SUCCESS (6.543s)
[184.364255] [038/133] (835s left) i915_pm_rc6_residency (rc6-fence)
[184.424884] Starting subtest: rc6-fence
[184.445446] Starting dynamic subtest: gt0
[196.782474] Dynamic subtest gt0: SUCCESS (12.320s)
[196.794214] Starting dynamic subtest: gt1
[211.865254] Dynamic subtest gt1: SUCCESS (15.095s)
[211.868256] Subtest rc6-fence: SUCCESS (27.442s)
[211.941738] [039/133] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[212.022589] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[218.742642] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.723s)
[218.853247] [040/133] (801s left) gem_create (create-ext-placement-each)
[219.018016] Starting subtest: create-ext-placement-each
[219.021328] Subtest create-ext-placement-each: SUCCESS (0.000s)
[219.120919] [041/133] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[219.191756] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[226.593106] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.404s)
[226.703291] [042/133] (793s left) kms_hdr (brightness-with-hdr)
[226.784244] Starting subtest: brightness-with-hdr
[226.790078] Subtest brightness-with-hdr: SKIP (0.000s)
[226.864488] [043/133] (793s left) kms_psr (fbc-psr2-dpms)
[226.936627] Starting subtest: fbc-psr2-dpms
[226.938878] Starting dynamic subtest: eDP-1
[226.943335] Dynamic subtest eDP-1: SKIP (0.000s)
[226.947760] Subtest fbc-psr2-dpms: SKIP (0.001s)
[227.024310] [044/133] (793s left) kms_invalid_mode (bad-hsync-end)
[227.099499] Starting subtest: bad-hsync-end
[227.101741] Starting dynamic subtest: pipe-A-eDP-1
[227.385069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[227.394099] Starting dynamic subtest: pipe-B-eDP-1
[227.396067] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[227.404071] Starting dynamic subtest: pipe-C-eDP-1
[227.405950] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[227.414400] Starting dynamic subtest: pipe-D-eDP-1
[227.416705] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[227.419057] Subtest bad-hsync-end: SUCCESS (0.292s)
[228.246840] [045/133] (792s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[228.342487] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[232.603792] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.267s)
[233.765853] [046/133] (786s left) kms_psr (psr2-primary-mmap-cpu)
[233.839895] Starting subtest: psr2-primary-mmap-cpu
[233.842134] Starting dynamic subtest: eDP-1
[235.518572] Dynamic subtest eDP-1: SUCCESS (1.678s)
[235.520743] Subtest psr2-primary-mmap-cpu: SUCCESS (1.678s)
[236.399783] [047/133] (784s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[236.484446] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[236.486708] Starting dynamic subtest: pipe-A-eDP-1
[236.558378] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[236.568872] Starting dynamic subtest: pipe-B-eDP-1
[237.678984] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[237.683668] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.199s)
[238.874540] [048/133] (781s left) kms_color_pipeline (plane-lut1d-lut1d)
[238.957384] Starting subtest: plane-lut1d-lut1d
[239.138395] Starting dynamic subtest: pipe-A-plane-0
[239.478788] Dynamic subtest pipe-A-plane-0: FAIL (0.170s)
[239.490032] Starting dynamic subtest: pipe-A-plane-1
[239.705307] Dynamic subtest pipe-A-plane-1: FAIL (0.182s)
[239.715129] Starting dynamic subtest: pipe-A-plane-2
[239.939188] Dynamic subtest pipe-A-plane-2: FAIL (0.184s)
[240.871048] Starting dynamic subtest: pipe-B-plane-0
[241.321309] Dynamic subtest pipe-B-plane-0: FAIL (0.186s)
[241.329490] Starting dynamic subtest: pipe-B-plane-1
[241.614626] Dynamic subtest pipe-B-plane-1: FAIL (0.154s)
[241.623050] Starting dynamic subtest: pipe-B-plane-2
[241.901017] Dynamic subtest pipe-B-plane-2: FAIL (0.561s)
[242.975409] Starting dynamic subtest: pipe-C-plane-0
[243.472107] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[243.485349] Starting dynamic subtest: pipe-C-plane-1
[243.888468] Dynamic subtest pipe-C-plane-1: FAIL (0.611s)
[243.900149] Starting dynamic subtest: pipe-C-plane-2
[244.250255] Dynamic subtest pipe-C-plane-2: FAIL (0.182s)
[245.116016] Starting dynamic subtest: pipe-D-plane-0
[245.706278] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[245.717122] Starting dynamic subtest: pipe-D-plane-1
[246.169765] Dynamic subtest pipe-D-plane-1: FAIL (0.607s)
[246.179197] Starting dynamic subtest: pipe-D-plane-2
[246.620796] Dynamic subtest pipe-D-plane-2: FAIL (0.547s)
[246.718562] Subtest plane-lut1d-lut1d: FAIL (7.760s)
[247.589613] [049/133] (773s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[247.673885] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[247.676066] Starting dynamic subtest: pipe-A-eDP-1
[247.684613] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[247.694441] Starting dynamic subtest: pipe-B-eDP-1
[247.703195] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[247.710979] Starting dynamic subtest: pipe-C-eDP-1
[247.718272] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[247.725772] Starting dynamic subtest: pipe-D-eDP-1
[247.733735] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[247.737475] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[249.971555] [050/133] (770s left) gem_set_tiling_vs_pwrite
[250.099590] [051/133] (770s left) kms_vblank (query-forked-busy-hang)
[250.175801] Starting subtest: query-forked-busy-hang
[250.177931] Starting dynamic subtest: pipe-A-eDP-1
[277.679766] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.501s)
[277.692997] Starting dynamic subtest: pipe-D-eDP-1
[292.636795] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.949s)
[292.639146] Subtest query-forked-busy-hang: SUCCESS (42.455s)
[293.509402] [052/133] (727s left) gem_pxp (verify-pxp-stale-ctx-execution)
[293.637898] Starting subtest: verify-pxp-stale-ctx-execution
[294.700299] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s)
[294.833364] [053/133] (726s left) kms_cursor_crc (cursor-onscreen-32x32)
[294.949575] Starting subtest: cursor-onscreen-32x32
[294.994924] Subtest cursor-onscreen-32x32: SKIP (0.041s)
[295.237079] [054/133] (725s left) gem_spin_batch (user-each)
[295.296248] Starting subtest: user-each
[298.564671] Subtest user-each: SUCCESS (3.262s)
[298.917626] [055/133] (722s left) i915_query (engine-info-invalid)
[298.968798] Starting subtest: engine-info-invalid
[298.971064] Subtest engine-info-invalid: SUCCESS (0.000s)
[299.100082] [056/133] (721s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[299.182121] Starting subtest: yf-tiled-16bpp-rotate-180
[299.186294] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[299.280076] [057/133] (721s left) gem_busy (extended)
[299.468376] Starting subtest: extended
[299.470236] Starting dynamic subtest: rcs0
[299.541636] Dynamic subtest rcs0: SUCCESS (0.075s)
[299.553226] Starting dynamic subtest: bcs0
[299.584026] Dynamic subtest bcs0: SUCCESS (0.040s)
[299.594233] Starting dynamic subtest: vcs0
[300.825298] Dynamic subtest vcs0: SUCCESS (1.239s)
[300.833774] Starting dynamic subtest: vcs1
[302.872837] Dynamic subtest vcs1: SUCCESS (2.044s)
[302.884301] Starting dynamic subtest: vecs0
[304.856700] Dynamic subtest vecs0: SUCCESS (1.981s)
[304.868865] Starting dynamic subtest: ccs0
[304.902035] Dynamic subtest ccs0: SUCCESS (0.044s)
[304.904824] Subtest extended: SUCCESS (5.437s)
[305.136592] [058/133] (715s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[305.218367] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[305.220623] Starting dynamic subtest: pipe-A-eDP-1
[305.243594] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[305.254523] Starting dynamic subtest: pipe-B-eDP-1
[305.276046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[305.284458] Starting dynamic subtest: pipe-C-eDP-1
[305.306782] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[305.315158] Starting dynamic subtest: pipe-D-eDP-1
[305.337353] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[305.341451] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[307.396554] [059/133] (713s left) gem_exec_big (single)
[307.453688] Starting subtest: single
[308.339644] Subtest single: SUCCESS (0.883s)
[308.483272] [060/133] (712s left) api_intel_bb (object-reloc-keep-cache)
[308.588647] Starting subtest: object-reloc-keep-cache
[308.593673] Subtest object-reloc-keep-cache: SKIP (0.003s)
[308.689505] [061/133] (712s left) kms_lease (lease-invalid-crtc)
[308.770397] Starting subtest: lease-invalid-crtc
[308.772772] Starting dynamic subtest: pipe-A-eDP-1
[308.775134] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[308.788777] Starting dynamic subtest: pipe-B-eDP-1
[308.791110] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[308.805093] Starting dynamic subtest: pipe-C-eDP-1
[308.807284] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[308.818853] Starting dynamic subtest: pipe-D-eDP-1
[308.821117] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[308.823311] Subtest lease-invalid-crtc: SUCCESS (0.007s)
[308.860225] [062/133] (712s left) gem_userptr_blits (set-cache-level)
[308.923212] Starting subtest: set-cache-level
[308.926916] Subtest set-cache-level: SKIP (0.000s)
[309.061272] [063/133] (712s left) gem_userptr_blits (forbidden-operations)
[309.123370] Starting subtest: forbidden-operations
[309.127072] Subtest forbidden-operations: SKIP (0.000s)
[309.233895] [064/133] (712s left) gem_exec_fence (syncobj-invalid-flags)
[309.730954] Starting subtest: syncobj-invalid-flags
[309.733119] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[310.895916] [065/133] (710s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[310.975527] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[310.979970] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[311.089929] [066/133] (710s left) gem_mmap_gtt (medium-copy)
[311.140604] Subtest medium-copy: SKIP (0.000s)
[311.202806] [067/133] (710s left) gem_mmap_gtt (big-copy-odd)
[311.265510] Subtest big-copy-odd: SKIP (0.000s)
[311.328254] [068/133] (710s left) dmabuf_sync_file (import-multiple-read-only)
[311.372063] Starting subtest: import-multiple-read-only
[311.381646] Subtest import-multiple-read-only: SUCCESS (0.012s)
[311.441342] [069/133] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[311.518060] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[311.522343] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[311.626136] [070/133] (709s left) kms_flip (flip-vs-fences-interruptible)
[311.707619] Starting subtest: flip-vs-fences-interruptible
[311.711911] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[311.811637] [071/133] (709s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[311.894261] Starting subtest: fbc-1p-pri-indfb-multidraw
[324.904406] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.012s)
[326.322356] [072/133] (695s left) api_intel_allocator (reserve-simple)
[326.372987] Starting subtest: reserve-simple
[326.375230] Subtest reserve-simple: SUCCESS (0.004s)
[326.492690] [073/133] (695s left) i915_pm_freq_api (freq-suspend)
[326.564788] Starting subtest: freq-suspend
[326.567070] Starting dynamic subtest: gt0
[342.995736] Dynamic subtest gt0: SUCCESS (1.438s)
[343.007709] Starting dynamic subtest: gt1
[358.999611] Dynamic subtest gt1: SUCCESS (1.231s)
[359.001913] Subtest freq-suspend: SUCCESS (2.672s)
[359.087591] [074/133] (662s left) gem_render_linear_blits (basic)
[359.139669] Starting subtest: basic
[359.162931] Subtest basic: SUCCESS (0.024s)
[359.248742] [075/133] (662s left) kms_feature_discovery (display)
[359.346950] Starting subtest: display
[359.349241] Subtest display: SUCCESS (0.000s)
[359.428931] [076/133] (662s left) gem_ctx_persistence (saturated-hostile)
[359.487888] Starting subtest: saturated-hostile
[359.490226] Starting dynamic subtest: rcs0
[360.307588] Dynamic subtest rcs0: SUCCESS (0.814s)
[360.321487] Starting dynamic subtest: bcs0
[361.091063] Dynamic subtest bcs0: SUCCESS (0.777s)
[361.106461] Starting dynamic subtest: vcs0
[361.868862] Dynamic subtest vcs0: SUCCESS (0.771s)
[361.883879] Starting dynamic subtest: vcs1
[362.656963] Dynamic subtest vcs1: SUCCESS (0.782s)
[362.669854] Starting dynamic subtest: vecs0
[363.456254] Dynamic subtest vecs0: SUCCESS (0.793s)
[363.469755] Starting dynamic subtest: ccs0
[364.279939] Dynamic subtest ccs0: SUCCESS (0.819s)
[364.282757] Subtest saturated-hostile: SUCCESS (4.769s)
[364.390211] [077/133] (657s left) i915_drm_fdinfo (busy-hang)
[364.433600] Starting subtest: busy-hang
[364.435931] Starting dynamic subtest: rcs0
[364.467105] Dynamic subtest rcs0: SKIP (0.032s)
[364.479301] Starting dynamic subtest: bcs0
[364.483543] Dynamic subtest bcs0: SKIP (0.001s)
[364.492429] Starting dynamic subtest: vcs0
[364.496453] Dynamic subtest vcs0: SKIP (0.001s)
[364.505764] Starting dynamic subtest: vcs1
[364.509834] Dynamic subtest vcs1: SKIP (0.001s)
[364.518622] Starting dynamic subtest: vecs0
[364.522768] Dynamic subtest vecs0: SKIP (0.001s)
[364.531732] Starting dynamic subtest: ccs0
[364.535913] Dynamic subtest ccs0: SKIP (0.001s)
[364.540244] Subtest busy-hang: SKIP (0.041s)
[364.578716] [078/133] (657s left) kms_selftest (drm_cmdline_parser)
[364.637122] Starting subtest: drm_cmdline_parser
[364.653044] Starting dynamic subtest: drm_test_cmdline_force_d_only
[364.745855] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.091s)
[364.756313] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[364.847653] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.101s)
[364.858288] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[364.961726] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.112s)
[364.971571] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[365.065550] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.104s)
[365.075773] Starting dynamic subtest: drm_test_cmdline_force_e_only
[365.165668] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.099s)
[365.175537] Starting dynamic subtest: drm_test_cmdline_res
[365.273727] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.106s)
[365.284564] Starting dynamic subtest: drm_test_cmdline_res_vesa
[365.369944] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.097s)
[365.379981] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[365.454360] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.082s)
[365.464503] Starting dynamic subtest: drm_test_cmdline_res_rblank
[365.536938] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.081s)
[365.547837] Starting dynamic subtest: drm_test_cmdline_res_bpp
[365.622076] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.084s)
[365.632547] Starting dynamic subtest: drm_test_cmdline_res_refresh
[365.709391] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.087s)
[365.720841] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[365.811433] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.102s)
[365.820147] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[365.895302] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.082s)
[365.905536] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[365.986747] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.091s)
[365.995046] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[366.062722] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.076s)
[366.071054] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[366.145903] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.081s)
[366.154381] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[366.230369] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.083s)
[366.240887] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[366.325814] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.095s)
[366.336012] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[366.409098] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.083s)
[366.419736] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[366.510064] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.099s)
[366.520565] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[366.611340] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.100s)
[366.621605] Starting dynamic subtest: drm_test_cmdline_name
[366.711439] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.099s)
[366.721089] Starting dynamic subtest: drm_test_cmdline_name_bpp
[366.811086] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.098s)
[366.820830] Starting dynamic subtest: drm_test_cmdline_name_option
[366.899489] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.087s)
[366.908817] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[367.013749] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.114s)
[367.023896] Starting dynamic subtest: drm_test_cmdline_rotate_0
[367.108910] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.093s)
[367.119245] Starting dynamic subtest: drm_test_cmdline_rotate_90
[367.210191] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.099s)
[367.220593] Starting dynamic subtest: drm_test_cmdline_rotate_180
[367.304053] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.091s)
[367.314400] Starting dynamic subtest: drm_test_cmdline_rotate_270
[367.392671] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.089s)
[367.402615] Starting dynamic subtest: drm_test_cmdline_hmirror
[367.490928] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.097s)
[367.501104] Starting dynamic subtest: drm_test_cmdline_vmirror
[367.580726] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.088s)
[367.591005] Starting dynamic subtest: drm_test_cmdline_margin_options
[367.670601] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.090s)
[367.680860] Starting dynamic subtest: drm_test_cmdline_multiple_options
[367.760745] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.089s)
[367.770873] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[367.848751] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.086s)
[367.858983] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[367.933731] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.084s)
[367.943825] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[368.026249] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.093s)
[368.035948] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[368.111961] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.083s)
[368.121567] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[368.214076] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.101s)
[368.223771] Starting dynamic subtest: drm_test_cmdline_invalid
[368.302468] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.089s)
[368.311312] Starting dynamic subtest: drm_test_cmdline_tv_options
[368.408526] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.103s)
[368.410208] Subtest drm_cmdline_parser: SUCCESS (3.759s)
[368.551326] [079/133] (653s left) gem_exec_whisper (basic-fds-all)
[368.623841] Starting subtest: basic-fds-all
[380.528398] Subtest basic-fds-all: SUCCESS (11.885s)
[380.712880] [080/133] (641s left) gem_exec_schedule (u-semaphore-noskip)
[380.780041] Starting subtest: u-semaphore-noskip
[381.222137] Subtest u-semaphore-noskip: SUCCESS (0.446s)
[381.569734] [081/133] (640s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[381.624126] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[381.707046] [082/133] (640s left) gem_mmap_offset (perf)
[381.761511] Starting subtest: perf
[381.763734] Starting dynamic subtest: smem0
[382.077821] Dynamic subtest smem0: SUCCESS (0.316s)
[382.080309] Subtest perf: SUCCESS (0.317s)
[382.168761] [083/133] (639s left) gem_lmem_swapping (verify)
[382.218456] Subtest verify: SKIP (0.000s)
[382.264370] [084/133] (639s left) kms_psr (pr-dpms)
[382.342041] Starting subtest: pr-dpms
[382.346137] Subtest pr-dpms: SKIP (0.000s)
[382.417980] [085/133] (639s left) kms_addfb_basic (addfb25-bad-modifier)
[382.493044] Starting subtest: addfb25-bad-modifier
[382.494954] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[382.592851] [086/133] (639s left) perf_pmu (busy-idle-no-semaphores)
[382.637573] Starting subtest: busy-idle-no-semaphores
[382.639556] Starting dynamic subtest: rcs0
[383.326629] Dynamic subtest rcs0: SUCCESS (0.661s)
[383.340213] Starting dynamic subtest: bcs0
[383.953161] Dynamic subtest bcs0: SUCCESS (0.651s)
[383.965547] Starting dynamic subtest: vcs0
[384.604978] Dynamic subtest vcs0: SUCCESS (0.648s)
[384.616934] Starting dynamic subtest: vcs1
[386.230191] Dynamic subtest vcs1: SUCCESS (1.621s)
[386.243653] Starting dynamic subtest: vecs0
[388.218458] Dynamic subtest vecs0: SUCCESS (1.984s)
[388.229448] Starting dynamic subtest: ccs0
[390.200335] Dynamic subtest ccs0: SUCCESS (1.978s)
[390.203508] Subtest busy-idle-no-semaphores: SUCCESS (7.560s)
[390.332443] [087/133] (631s left) gem_pipe_control_store_loop (fresh-buffer)
[390.406349] Starting subtest: fresh-buffer
[392.615422] Subtest fresh-buffer: SUCCESS (2.155s)
[392.694952] [088/133] (629s left) kms_chamelium_color (degamma)
[392.789062] Subtest degamma: SKIP (0.000s)
[392.832676] [089/133] (629s left) kms_pm_rpm (pc8-residency)
[394.771734] Starting subtest: pc8-residency
[394.776951] Subtest pc8-residency: SKIP (0.000s)
[395.125401] [090/133] (627s left) gem_userptr_blits (dmabuf-sync)
[395.200809] Starting subtest: dmabuf-sync
[395.205365] Subtest dmabuf-sync: SKIP (0.002s)
[395.345734] [091/133] (627s left) kms_async_flips (invalid-async-flip)
[395.421094] Starting subtest: invalid-async-flip
[395.812969] Starting dynamic subtest: pipe-A-eDP-1
[396.656283] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.844s)
[397.013750] Starting dynamic subtest: pipe-B-eDP-1
[397.792535] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.788s)
[398.150466] Starting dynamic subtest: pipe-C-eDP-1
[398.918485] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[399.275095] Starting dynamic subtest: pipe-D-eDP-1
[400.045651] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.781s)
[400.048054] Subtest invalid-async-flip: SUCCESS (4.627s)
[401.209197] [092/133] (621s left) prime_vgem (busy)
[401.293149] Starting subtest: busy
[401.295571] Starting dynamic subtest: rcs0
[401.379948] Dynamic subtest rcs0: SUCCESS (0.087s)
[401.389453] Starting dynamic subtest: bcs0
[401.416516] Dynamic subtest bcs0: SUCCESS (0.036s)
[401.425865] Starting dynamic subtest: vcs0
[401.479478] Dynamic subtest vcs0: SUCCESS (0.062s)
[401.488800] Starting dynamic subtest: vcs1
[401.523715] Dynamic subtest vcs1: SUCCESS (0.041s)
[401.533002] Starting dynamic subtest: vecs0
[401.569615] Dynamic subtest vecs0: SUCCESS (0.045s)
[401.578892] Starting dynamic subtest: ccs0
[401.615142] Dynamic subtest ccs0: SUCCESS (0.045s)
[401.617366] Subtest busy: SUCCESS (0.323s)
[401.730262] [093/133] (620s left) gem_ctx_create (basic-files)
[401.792597] Starting subtest: basic-files
[403.836741] Subtest basic-files: SUCCESS (2.046s)
[404.021783] [094/133] (618s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[404.070437] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[404.138374] [095/133] (618s left) perf (gen12-unprivileged-single-ctx-counters)
[404.262927] Starting subtest: gen12-unprivileged-single-ctx-counters
[404.265191] Starting dynamic subtest: rcs0
[404.300652] Dynamic subtest rcs0: SUCCESS (0.037s)
[404.302997] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.038s)
[404.347224] [096/133] (618s left) gem_lmem_swapping (heavy-verify-random)
[404.394266] Subtest heavy-verify-random: SKIP (0.000s)
[404.440116] [097/133] (618s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[404.555711] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[405.557103] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.001s)
[405.679125] [098/133] (617s left) kms_content_protection (mei-interface)
[405.807102] Starting subtest: mei-interface
[405.811017] Subtest mei-interface: SKIP (0.001s)
[405.933334] [099/133] (616s left) kms_flip_event_leak (basic)
[406.010849] Starting subtest: basic
[406.012657] Starting dynamic subtest: pipe-A-eDP-1
[406.430594] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[406.440483] Starting dynamic subtest: pipe-B-eDP-1
[407.518530] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.087s)
[407.528489] Starting dynamic subtest: pipe-C-eDP-1
[408.644640] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[408.654761] Starting dynamic subtest: pipe-D-eDP-1
[409.774917] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[409.777282] Subtest basic: SUCCESS (3.764s)
[410.650482] [100/133] (612s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[410.732411] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[410.736374] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[410.823430] [101/133] (612s left) kms_pm_rpm (basic-rte)
[410.859025] Starting subtest: basic-rte
[414.203237] Subtest basic-rte: SUCCESS (3.345s)
[415.724129] [102/133] (607s left) kms_big_fb (x-tiled-addfb)
[415.807328] Starting subtest: x-tiled-addfb
[415.809369] Subtest x-tiled-addfb: SUCCESS (0.000s)
[415.891978] [103/133] (607s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[415.983604] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[422.830098] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.849s)
[422.979669] [104/133] (600s left) kms_busy (extended-pageflip-hang-newfb)
[423.062300] Starting subtest: extended-pageflip-hang-newfb
[423.064603] Starting dynamic subtest: pipe-A
[449.457859] Dynamic subtest pipe-A: SUCCESS (26.386s)
[449.468266] Starting dynamic subtest: pipe-D
[464.471332] Dynamic subtest pipe-D: SUCCESS (15.012s)
[464.473573] Subtest extended-pageflip-hang-newfb: SUCCESS (41.402s)
[465.307741] [105/133] (557s left) gem_exec_schedule (implicit-read-write)
[465.381869] Starting subtest: implicit-read-write
[465.384128] Starting dynamic subtest: rcs0
[465.478177] Dynamic subtest rcs0: SUCCESS (0.107s)
[465.490578] Starting dynamic subtest: vcs0
[465.564090] Dynamic subtest vcs0: SUCCESS (0.085s)
[465.576369] Starting dynamic subtest: vcs1
[465.648473] Dynamic subtest vcs1: SUCCESS (0.082s)
[465.663610] Starting dynamic subtest: vecs0
[465.722281] Dynamic subtest vecs0: SUCCESS (0.075s)
[465.734970] Starting dynamic subtest: ccs0
[465.809707] Dynamic subtest ccs0: SUCCESS (0.085s)
[465.812624] Subtest implicit-read-write: SUCCESS (0.439s)
[466.682236] [106/133] (556s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[466.770278] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[466.774739] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[466.864911] [107/133] (556s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[466.943785] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[470.894246] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.953s)
[472.020252] [108/133] (551s left) vgem_basic (sysfs)
[472.062732] Starting subtest: sysfs
[472.064561] Subtest sysfs: SUCCESS (0.000s)
[472.135865] [109/133] (551s left) kms_force_connector_basic (prune-stale-modes)
[472.192395] Subtest prune-stale-modes: SKIP (0.000s)
[472.255614] [110/133] (551s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[472.316736] Starting subtest: multi-wait-available-submitted-signaled
[472.318870] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[472.420641] [111/133] (550s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[472.498236] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[472.500544] Starting dynamic subtest: pipe-A
[472.560420] Dynamic subtest pipe-A: SUCCESS (0.065s)
[472.570092] Starting dynamic subtest: pipe-B
[473.729440] Dynamic subtest pipe-B: SUCCESS (1.168s)
[473.741210] Starting dynamic subtest: pipe-C
[474.838056] Dynamic subtest pipe-C: SUCCESS (1.107s)
[474.847558] Starting dynamic subtest: pipe-D
[475.976705] Dynamic subtest pipe-D: SUCCESS (1.138s)
[475.979264] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.484s)
[477.129487] [112/133] (546s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[477.247982] Starting subtest: 2x-flip-vs-cursor-legacy
[477.252490] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[477.396335] [113/133] (546s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[477.458934] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[477.461182] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[477.577113] [114/133] (545s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[477.636263] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[477.711639] [115/133] (545s left) intel_hwmon (hwmon-read)
[477.768003] Subtest hwmon-read: SKIP (0.000s)
[477.830991] [116/133] (545s left) gem_unfence_active_buffers
[477.980231] [117/133] (545s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[478.043466] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[478.047927] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[478.114949] [118/133] (545s left) kms_cursor_crc (cursor-tearing-position-change)
[478.217820] Starting subtest: cursor-tearing-position-change
[478.219317] Starting dynamic subtest: pipe-A-eDP-1
[478.772609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[478.782785] Starting dynamic subtest: pipe-D-eDP-1
[479.977930] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.204s)
[479.979811] Subtest cursor-tearing-position-change: SUCCESS (1.760s)
[480.830152] [119/133] (542s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[480.901702] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[480.903829] Starting dynamic subtest: pipe-A-eDP-1
[480.927645] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[480.938750] Starting dynamic subtest: pipe-B-eDP-1
[480.960826] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[480.970227] Starting dynamic subtest: pipe-C-eDP-1
[480.993422] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[481.002606] Starting dynamic subtest: pipe-D-eDP-1
[481.026267] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[481.030293] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[483.173259] [120/133] (540s left) kms_psr (psr-primary-mmap-cpu)
[483.240411] Starting subtest: psr-primary-mmap-cpu
[483.242534] Starting dynamic subtest: eDP-1
[484.975975] Dynamic subtest eDP-1: SUCCESS (1.734s)
[484.978317] Subtest psr-primary-mmap-cpu: SUCCESS (1.735s)
[485.830272] [121/133] (537s left) gem_exec_balancer (full)
[485.891078] Starting subtest: full
[490.460443] Subtest full: SUCCESS (4.572s)
[490.779024] [122/133] (532s left) gem_exec_reloc (basic-softpin)
[490.830819] Subtest basic-softpin: SKIP (0.000s)
[490.899674] [123/133] (532s left) gem_exec_reloc (basic-wc-read-noreloc)
[490.964346] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[491.033183] [124/133] (532s left) drm_read (fault-buffer)
[491.167296] Starting subtest: fault-buffer
[491.170171] Subtest fault-buffer: SUCCESS (0.001s)
[491.321668] [125/133] (532s left) gem_exec_create (basic)
[491.387270] Starting subtest: basic
[491.389670] Starting dynamic subtest: smem
[494.608930] Dynamic subtest smem: SUCCESS (3.219s)
[494.611711] Subtest basic: SUCCESS (3.222s)
[494.792790] [126/133] (529s left) kms_cursor_crc (cursor-size-hints)
[494.918428] Starting subtest: cursor-size-hints
[494.920276] Starting dynamic subtest: pipe-A-eDP-1
[495.526275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[495.536212] Starting dynamic subtest: pipe-D-eDP-1
[496.776637] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s)
[496.778942] Subtest cursor-size-hints: SUCCESS (1.861s)
[497.573561] [127/133] (526s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[497.662053] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[497.666393] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[497.755820] [128/133] (526s left) kms_plane_scaling (invalid-parameters)
[497.834729] Starting subtest: invalid-parameters
[497.836947] Starting dynamic subtest: less-than-1-height-src
[497.850789] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s)
[497.861724] Starting dynamic subtest: less-than-1-width-src
[497.869594] Dynamic subtest less-than-1-width-src: SUCCESS (0.017s)
[497.871743] Subtest invalid-parameters: SUCCESS (0.033s)
[497.967657] [129/133] (526s left) gem_pxp (display-protected-crc)
[498.067745] Starting subtest: display-protected-crc
[500.030789] Subtest display-protected-crc: SUCCESS (1.964s)
[500.134949] [130/133] (523s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[500.191728] Starting subtest: etime-multi-wait-for-submit-submitted
[500.298406] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[500.387462] [131/133] (523s left) gem_ppgtt (blt-vs-render-ctx0)
[500.446337] Starting subtest: blt-vs-render-ctx0
[533.256107] Subtest blt-vs-render-ctx0: SUCCESS (32.801s)
[533.388668] [132/133] (490s left) kms_cursor_legacy (torture-move)
[533.539243] Starting subtest: torture-move
[533.541435] Starting dynamic subtest: pipe-A
[539.365127] Dynamic subtest pipe-A: SUCCESS (5.821s)
[539.378777] Starting dynamic subtest: pipe-B
[546.529993] Dynamic subtest pipe-B: SUCCESS (7.161s)
[546.552776] Starting dynamic subtest: pipe-C
[553.869392] Dynamic subtest pipe-C: SUCCESS (7.332s)
[553.880605] Starting dynamic subtest: pipe-D
[561.259894] Dynamic subtest pipe-D: SUCCESS (7.389s)
[561.276766] Starting dynamic subtest: all-pipes
[567.932007] Dynamic subtest all-pipes: SUCCESS (6.668s)
[567.934539] Subtest torture-move: SUCCESS (34.383s)
[568.088116] [133/133] (456s left) kms_big_fb (linear-32bpp-rotate-180)
[568.189586] Starting subtest: linear-32bpp-rotate-180
[569.758105] Subtest linear-32bpp-rotate-180: SUCCESS (1.567s)
[569.890788] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_plane_lowres
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: sw_sync
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_setmode
results: parsing output: 8/ for test: gem_exec_gttfill
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_pipe_crc_basic
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: kms_properties
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gen9_exec_parse
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: gem_ringfill
results: parsing output: 23/ for test: kms_atomic_interruptible
results: parsing output: 24/ for test: gen3_render_tiledy_blits
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_reg_read
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: sysfs_heartbeat_interval
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_ctx_isolation
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_pm_rc6_residency
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_hdr
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_invalid_mode
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: gem_spin_batch
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_busy
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_exec_big
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: kms_lease
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: dmabuf_sync_file
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: api_intel_allocator
results: parsing output: 72/ for test: i915_pm_freq_api
results: parsing output: 73/ for test: gem_render_linear_blits
results: parsing output: 74/ for test: kms_feature_discovery
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_selftest
results: parsing output: 78/ for test: gem_exec_whisper
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: gem_lmem_swapping
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_pipe_control_store_loop
results: parsing output: 87/ for test: kms_chamelium_color
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: prime_vgem
results: parsing output: 92/ for test: gem_ctx_create
results: parsing output: 93/ for test: kms_pipe_b_c_ivb
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: gem_lmem_swapping
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: kms_flip_event_leak
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: vgem_basic
results: parsing output: 108/ for test: kms_force_connector_basic
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: intel_hwmon
results: parsing output: 115/ for test: gem_unfence_active_buffers
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: drm_read
results: parsing output: 124/ for test: gem_exec_create
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_ppgtt
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_big_fb
Done.