[59.756649] Initializing watchdogs
[59.756752]   /dev/watchdog0
[59.771012] [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.775262] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.777445] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.780556] [001/133] (960s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[59.906488] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[59.908717] Starting dynamic subtest: pipe-A-eDP-1
[71.278716] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.372s)
[71.286077] Starting dynamic subtest: pipe-B-eDP-1
[83.320422] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.036s)
[83.322744] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.409s)
[84.175637] [002/133] (936s left) kms_vrr (flip-basic)
[84.280057] Starting subtest: flip-basic
[84.286362] Subtest flip-basic: SKIP (0.000s)
[84.346943] [003/133] (936s left) gem_softpin (allocator-evict)
[84.409443] Starting subtest: allocator-evict
[84.416642] Starting dynamic subtest: rcs0
[108.066841] Dynamic subtest rcs0: SUCCESS (23.655s)
[108.075644] Starting dynamic subtest: bcs0
[131.977300] Dynamic subtest bcs0: SUCCESS (23.908s)
[131.987274] Starting dynamic subtest: vcs0
[155.487743] Dynamic subtest vcs0: SUCCESS (23.509s)
[155.495340] Starting dynamic subtest: vcs1
[179.070118] Dynamic subtest vcs1: SUCCESS (23.581s)
[179.078065] Starting dynamic subtest: vecs0
[202.637131] Dynamic subtest vecs0: SUCCESS (23.566s)
[202.644806] Starting dynamic subtest: ccs0
[226.491466] Dynamic subtest ccs0: SUCCESS (23.852s)
[226.493797] Subtest allocator-evict: SUCCESS (142.074s)
[226.573966] [004/133] (793s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[226.719577] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[226.723806] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[226.783817] [005/133] (793s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[226.893203] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[226.897066] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[226.999140] [006/133] (793s left) gem_busy (busy)
[227.066648] Starting subtest: busy
[227.068973] Starting dynamic subtest: all-engines
[227.125115] Dynamic subtest all-engines: SUCCESS (0.059s)
[227.132707] Starting dynamic subtest: rcs0
[228.895078] Dynamic subtest rcs0: SUCCESS (1.769s)
[228.904812] Starting dynamic subtest: bcs0
[228.948224] Dynamic subtest bcs0: SUCCESS (0.052s)
[228.957209] Starting dynamic subtest: vcs0
[228.986637] Dynamic subtest vcs0: SUCCESS (0.039s)
[228.994819] Starting dynamic subtest: vcs1
[230.938670] Dynamic subtest vcs1: SUCCESS (1.949s)
[230.948480] Starting dynamic subtest: vecs0
[232.923886] Dynamic subtest vecs0: SUCCESS (1.984s)
[232.933678] Starting dynamic subtest: ccs0
[234.907658] Dynamic subtest ccs0: SUCCESS (1.984s)
[234.910116] Subtest busy: SUCCESS (7.839s)
[235.256575] [007/133] (785s left) prime_busy (after-wait)
[235.304892] Starting subtest: after-wait
[235.307308] Starting dynamic subtest: rcs0
[235.340556] Dynamic subtest rcs0: SUCCESS (0.033s)
[235.351833] Starting dynamic subtest: bcs0
[235.381891] Dynamic subtest bcs0: SUCCESS (0.041s)
[235.389639] Starting dynamic subtest: vcs0
[235.422614] Dynamic subtest vcs0: SUCCESS (0.041s)
[235.431646] Starting dynamic subtest: vcs1
[235.464865] Dynamic subtest vcs1: SUCCESS (0.041s)
[235.473223] Starting dynamic subtest: vecs0
[235.506594] Dynamic subtest vecs0: SUCCESS (0.042s)
[235.517685] Starting dynamic subtest: ccs0
[235.550415] Dynamic subtest ccs0: SUCCESS (0.043s)
[235.659068] Subtest after-wait: SUCCESS (0.353s)
[235.746225] [008/133] (784s left) gem_ccs (suspend-resume)
[235.810556] Starting subtest: suspend-resume
[235.815331] Subtest suspend-resume: SKIP (0.000s)
[235.907764] [009/133] (784s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[235.991952] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[235.994400] Starting dynamic subtest: pipe-A
[236.056068] Dynamic subtest pipe-A: SUCCESS (0.064s)
[236.065990] Starting dynamic subtest: pipe-B
[237.167962] Dynamic subtest pipe-B: SUCCESS (1.111s)
[237.177737] Starting dynamic subtest: pipe-C
[238.282289] Dynamic subtest pipe-C: SUCCESS (1.114s)
[238.291307] Starting dynamic subtest: pipe-D
[239.423551] Dynamic subtest pipe-D: SUCCESS (1.141s)
[239.426568] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.433s)
[240.572098] [010/133] (780s left) gem_ppgtt (shrink-vs-evict-any)
[240.644707] Starting subtest: shrink-vs-evict-any
[245.879118] Subtest shrink-vs-evict-any: SUCCESS (5.233s)
[245.973343] [011/133] (774s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[246.076759] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[246.081078] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[246.162061] [012/133] (774s left) gem_render_copy_redux (flink-interruptible)
[246.224335] Starting subtest: flink-interruptible
[246.978233] Subtest flink-interruptible: SUCCESS (0.754s)
[247.086187] [013/133] (773s left) gem_wait (write-wait)
[247.152282] Starting subtest: write-wait
[247.154157] Starting dynamic subtest: all-engines
[248.330655] Dynamic subtest all-engines: SUCCESS (1.178s)
[248.345069] Starting dynamic subtest: rcs0
[249.387958] Dynamic subtest rcs0: SUCCESS (1.056s)
[249.403242] Starting dynamic subtest: bcs0
[250.446283] Dynamic subtest bcs0: SUCCESS (1.057s)
[250.461681] Starting dynamic subtest: vcs0
[251.499435] Dynamic subtest vcs0: SUCCESS (1.052s)
[251.513919] Starting dynamic subtest: vcs1
[252.552243] Dynamic subtest vcs1: SUCCESS (1.052s)
[252.567728] Starting dynamic subtest: vecs0
[253.604591] Dynamic subtest vecs0: SUCCESS (1.051s)
[253.619083] Starting dynamic subtest: ccs0
[254.661679] Dynamic subtest ccs0: SUCCESS (1.056s)
[254.664262] Subtest write-wait: SUCCESS (7.508s)
[254.859977] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[254.863068] [014/133] (765s left) gem_exec_reloc (basic-gtt)
[254.928759] Subtest basic-gtt: SKIP (0.000s)
[255.005161] [015/133] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[255.093081] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[255.097077] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[255.188364] [016/133] (765s left) syncobj_wait (invalid-reset-bad-pad)
[255.243338] Starting subtest: invalid-reset-bad-pad
[255.245628] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[255.334931] [017/133] (765s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[255.441162] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[255.445220] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[255.533538] [018/133] (765s left) kms_cursor_crc (cursor-offscreen-128x128)
[255.749733] Starting subtest: cursor-offscreen-128x128
[255.752405] Starting dynamic subtest: pipe-A-eDP-1
[257.707833] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.956s)
[257.736516] Starting dynamic subtest: pipe-D-eDP-1
[260.283241] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[260.285530] Subtest cursor-offscreen-128x128: SUCCESS (4.533s)
[261.141329] [019/133] (759s left) kms_dsc (dsc-with-formats)
[261.241145] Starting subtest: dsc-with-formats
[261.280285] Subtest dsc-with-formats: SKIP (0.001s)
[261.317613] [020/133] (759s left) gem_close_race (basic-threads)
[261.373403] Starting subtest: basic-threads
[262.837840] Subtest basic-threads: SUCCESS (1.463s)
[263.017486] [021/133] (758s left) gem_tiled_blits (basic)
[263.076272] Subtest basic: SKIP (0.000s)
[263.144182] [022/133] (757s left) kms_cursor_crc (cursor-sliding-256x256)
[263.359619] Starting subtest: cursor-sliding-256x256
[263.364766] Starting dynamic subtest: pipe-A-eDP-1
[266.600649] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.235s)
[266.631572] Starting dynamic subtest: pipe-D-eDP-1
[270.558924] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.937s)
[270.561205] Subtest cursor-sliding-256x256: SUCCESS (7.198s)
[271.411599] [023/133] (749s left) kms_psr (psr-primary-mmap-gtt)
[271.503174] Starting subtest: psr-primary-mmap-gtt
[271.505568] Starting dynamic subtest: eDP-1
[272.892512] Dynamic subtest eDP-1: SKIP (1.386s)
[272.897506] Subtest psr-primary-mmap-gtt: SKIP (1.388s)
[273.017603] [024/133] (748s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[273.111297] Starting subtest: basic-modeset-with-all-modifiers-formats
[273.488517] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[274.298728] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.810s)
[274.307096] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[274.319933] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[274.327812] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[274.342177] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[274.349694] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[274.497788] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[274.507257] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[274.519743] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[274.527833] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[274.542113] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[274.550332] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[274.564580] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[274.575198] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[274.586863] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[274.595481] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[274.608995] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[274.616994] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[274.631163] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[274.638723] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[274.653340] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[274.661115] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[274.675644] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[274.683622] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[274.831265] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[274.839645] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[274.853397] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[274.861138] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[274.875748] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[274.883590] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[274.897901] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[274.905741] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[274.920341] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[274.929062] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[274.942322] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[274.949824] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[274.964197] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[274.972078] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[274.986816] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[274.994247] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[275.008953] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[275.017321] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[275.154563] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.145s)
[275.164696] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[275.176081] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[275.183704] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[275.198228] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[275.205775] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[275.220498] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[275.228139] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[275.242747] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[275.250331] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[275.265079] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[275.272719] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[275.287099] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[275.294392] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[275.308916] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[275.316130] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[275.331210] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[275.721023] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.611s)
[276.515085] [025/133] (744s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[276.618684] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[283.789263] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.174s)
[283.936271] [026/133] (737s left) sw_sync (sync_expired_merge)
[283.972964] Starting subtest: sync_expired_merge
[285.047799] Subtest sync_expired_merge: SUCCESS (1.074s)
[285.108305] [027/133] (736s left) kms_properties (crtc-properties-legacy)
[285.209045] Starting subtest: crtc-properties-legacy
[285.212043] Starting dynamic subtest: pipe-A-eDP-1
[285.651705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[285.668061] Starting dynamic subtest: pipe-B-eDP-1
[286.798591] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[286.807929] Starting dynamic subtest: pipe-C-eDP-1
[287.917534] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[287.926985] Starting dynamic subtest: pipe-D-eDP-1
[289.060266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[289.062772] Subtest crtc-properties-legacy: SUCCESS (3.855s)
[289.860807] [028/133] (731s left) kms_vrr (max-min)
[289.954290] Starting subtest: max-min
[289.961088] Subtest max-min: SKIP (0.000s)
[290.043228] [029/133] (731s left) syncobj_wait (invalid-wait-illegal-handle)
[290.111155] Starting subtest: invalid-wait-illegal-handle
[290.113100] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[290.219677] [030/133] (731s left) i915_query (query-garbage)
[290.276616] Starting subtest: query-garbage
[290.278540] Subtest query-garbage: SUCCESS (0.000s)
[290.392748] [031/133] (731s left) kms_async_flips (test-time-stamp)
[290.485990] Starting subtest: test-time-stamp
[290.869348] Starting dynamic subtest: pipe-A-eDP-1
[291.669726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.797s)
[292.052763] Starting dynamic subtest: pipe-B-eDP-1
[292.805869] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.758s)
[293.181653] Starting dynamic subtest: pipe-C-eDP-1
[293.942984] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[294.309538] Starting dynamic subtest: pipe-D-eDP-1
[295.086092] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s)
[295.089069] Subtest test-time-stamp: SUCCESS (4.602s)
[296.255366] [032/133] (725s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[296.354324] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[296.365553] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[296.445788] [033/133] (725s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[296.531274] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[296.535779] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[297.685320] [034/133] (723s left) gem_exec_reloc (basic-gtt-read-active)
[297.751351] Subtest basic-gtt-read-active: SKIP (0.000s)
[297.821290] [035/133] (723s left) api_intel_bb (object-noreloc-purge-cache-simple)
[297.871614] Starting subtest: object-noreloc-purge-cache-simple
[297.879085] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s)
[298.014251] [036/133] (723s left) kms_pm_rpm (system-suspend-modeset)
[300.055931] Starting subtest: system-suspend-modeset
[319.666223] Subtest system-suspend-modeset: SUCCESS (4.764s)
[320.038707] [037/133] (701s left) gem_lmem_swapping (parallel-random-verify-ccs)
[320.094811] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[320.142775] [038/133] (701s left) gem_exec_params (sol-reset-invalid)
[320.201202] Starting subtest: sol-reset-invalid
[320.203445] Subtest sol-reset-invalid: SUCCESS (0.003s)
[321.789266] [039/133] (700s left) gem_lmem_swapping (heavy-verify-random-ccs)
[321.836942] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[321.874732] [040/133] (699s left) gem_exec_reloc (basic-cpu-active)
[321.927680] Subtest basic-cpu-active: SKIP (0.000s)
[321.995145] [041/133] (699s left) perf (polling)
[322.164644] Starting subtest: polling
[322.166540] Starting dynamic subtest: 0-rcs0
[332.195617] Dynamic subtest 0-rcs0: SUCCESS (10.013s)
[332.204932] Starting dynamic subtest: 1-vecs0
[342.224167] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[342.226840] Subtest polling: SUCCESS (20.036s)
[342.277813] [042/133] (679s left) gem_ctx_shared (q-in-order)
[342.340834] Starting subtest: Q-in-order
[342.343486] Starting dynamic subtest: rcs0
[342.511447] Dynamic subtest rcs0: SUCCESS (0.170s)
[342.524694] Starting dynamic subtest: vcs0
[342.631464] Dynamic subtest vcs0: SUCCESS (0.119s)
[342.640843] Starting dynamic subtest: vcs1
[342.747544] Dynamic subtest vcs1: SUCCESS (0.113s)
[342.756814] Starting dynamic subtest: vecs0
[342.863396] Dynamic subtest vecs0: SUCCESS (0.115s)
[342.878258] Starting dynamic subtest: ccs0
[342.993611] Dynamic subtest ccs0: SUCCESS (0.129s)
[342.996596] Subtest Q-in-order: SUCCESS (0.652s)
[343.864320] [043/133] (678s left) kms_psr (fbc-psr-primary-render)
[343.966180] Starting subtest: fbc-psr-primary-render
[343.968310] Starting dynamic subtest: eDP-1
[343.972232] Dynamic subtest eDP-1: SKIP (0.000s)
[343.976162] Subtest fbc-psr-primary-render: SKIP (0.001s)
[344.037542] [044/133] (677s left) gem_partial_pwrite_pread (writes-after-reads-display)
[344.101352] Subtest writes-after-reads-display: SKIP (0.000s)
[344.168534] [045/133] (677s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[344.260928] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[344.265403] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[344.359610] [046/133] (677s left) syncobj_wait (single-wait-all-signaled)
[344.407651] Starting subtest: single-wait-all-signaled
[344.409483] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[344.523356] [047/133] (677s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[344.582287] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[344.586696] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[344.762367] [048/133] (677s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[344.852485] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[344.854749] Starting dynamic subtest: pipe-A-eDP-1
[344.912448] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[344.923952] Starting dynamic subtest: pipe-B-eDP-1
[344.981298] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[344.991842] Starting dynamic subtest: pipe-C-eDP-1
[345.055616] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[345.067019] Starting dynamic subtest: pipe-D-eDP-1
[345.125375] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[345.129680] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[347.037163] [049/133] (675s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[347.097305] Starting subtest: single-wait-all-for-submit-available-signaled
[347.099567] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[347.190054] [050/133] (675s left) syncobj_timeline (reset-signaled)
[347.236438] Starting subtest: reset-signaled
[347.238750] Subtest reset-signaled: SUCCESS (0.000s)
[347.316262] [051/133] (674s left) prime_vgem (fence-flip-hang)
[347.379245] Subtest fence-flip-hang: SKIP (0.000s)
[347.474186] [052/133] (674s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[347.564147] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[348.177263] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.614s)
[348.360964] [053/133] (674s left) gem_exec_fence (submit67)
[348.549481] Starting subtest: submit67
[348.554245] Subtest submit67: SKIP (0.000s)
[350.811339] [054/133] (671s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[350.937387] Starting subtest: fbcpsr-rgb565-draw-pwrite
[357.971735] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.036s)
[358.100080] [055/133] (664s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[358.217772] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[358.222118] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[358.323221] [056/133] (664s left) kms_plane_scaling (invalid-num-scalers)
[358.413580] Starting subtest: invalid-num-scalers
[358.415861] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[358.431734] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[358.442506] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[358.461643] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[358.470756] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[358.491849] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[358.500688] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[358.523330] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[358.525488] Subtest invalid-num-scalers: SUCCESS (0.112s)
[358.634513] [057/133] (663s left) kms_chamelium_edid (dp-edid-read)
[359.014816] Subtest dp-edid-read: SKIP (0.000s)
[359.799318] [058/133] (662s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[359.886613] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[366.436510] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.550s)
[366.551997] [059/133] (656s left) gem_exec_balancer (bonded-sync)
[366.610375] Starting subtest: bonded-sync
[366.614884] Subtest bonded-sync: SKIP (0.000s)
[366.912242] [060/133] (655s left) kms_psr (fbc-psr2-cursor-plane-move)
[367.029474] Starting subtest: fbc-psr2-cursor-plane-move
[367.031738] Starting dynamic subtest: eDP-1
[367.036185] Dynamic subtest eDP-1: SKIP (0.000s)
[367.040446] Subtest fbc-psr2-cursor-plane-move: SKIP (0.002s)
[367.119652] [061/133] (655s left) perf (unprivileged-single-ctx-counters)
[367.218061] Starting subtest: unprivileged-single-ctx-counters
[367.223145] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[367.262640] [062/133] (655s left) gem_exec_flush (basic-wb-prw-default)
[367.318232] Starting subtest: basic-wb-prw-default
[372.820811] Subtest basic-wb-prw-default: SUCCESS (5.501s)
[373.012271] [063/133] (649s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[373.064532] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[373.067369] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[373.155966] [064/133] (649s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[373.255325] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[377.233888] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.979s)
[378.368926] [065/133] (644s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[378.473487] Starting subtest: 4-tiled-64bpp-rotate-90
[378.495378] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[378.606022] [066/133] (644s left) prime_mmap (test_correct_cpu_write)
[378.656439] Starting subtest: test_correct_cpu_write
[378.659168] Starting dynamic subtest: test_correct_cpu_write-smem
[378.661675] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[378.663671] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[378.777987] [067/133] (644s left) kms_cursor_crc (cursor-random-256x256)
[379.013535] Starting subtest: cursor-random-256x256
[379.018885] Starting dynamic subtest: pipe-A-eDP-1
[382.344259] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.324s)
[382.373722] Starting dynamic subtest: pipe-D-eDP-1
[386.380027] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.011s)
[386.382167] Subtest cursor-random-256x256: SUCCESS (7.360s)
[387.223121] [068/133] (635s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[387.338745] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[387.343026] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[387.434863] [069/133] (635s left) core_setmaster_vs_auth
[387.609076] [070/133] (635s left) sw_sync (sync_busy_fork)
[387.641977] Starting subtest: sync_busy_fork
[388.654215] Subtest sync_busy_fork: SUCCESS (1.011s)
[388.731438] [071/133] (634s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[388.822676] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[388.826688] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[388.916768] [072/133] (634s left) kms_flip (dpms-vs-vblank-race)
[389.011651] Starting subtest: dpms-vs-vblank-race
[389.013917] Starting dynamic subtest: A-eDP1
[394.045223] Dynamic subtest A-eDP1: SUCCESS (5.031s)
[394.056815] Starting dynamic subtest: B-eDP1
[398.652481] Dynamic subtest B-eDP1: SUCCESS (4.603s)
[398.662496] Starting dynamic subtest: C-eDP1
[403.283268] Dynamic subtest C-eDP1: SUCCESS (4.629s)
[403.295730] Starting dynamic subtest: D-eDP1
[407.915663] Dynamic subtest D-eDP1: SUCCESS (4.628s)
[407.917963] Subtest dpms-vs-vblank-race: SUCCESS (18.901s)
[408.791003] [073/133] (614s left) gem_exec_schedule (u-semaphore-user)
[408.883235] Starting subtest: u-semaphore-user
[408.933218] Subtest u-semaphore-user: SUCCESS (0.058s)
[410.820917] [074/133] (612s left) kms_psr (pr-dpms)
[410.920504] Starting subtest: pr-dpms
[410.924581] Subtest pr-dpms: SKIP (0.000s)
[410.992092] [075/133] (612s left) i915_module_load (reload-no-display)
[411.033736] Starting subtest: reload-no-display
[416.937309] Subtest reload-no-display: SUCCESS (5.909s)
[416.967513] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[416.968265] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[416.971806] [076/133] (606s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[418.521066] Starting subtest: etime-multi-wait-all-for-submit-submitted
[418.624880] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[418.676385] [FACT syncobj_timeline (etime-multi-wait-all-for-submit-submitted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[418.677693] [FACT syncobj_timeline (etime-multi-wait-all-for-submit-submitted)] new: kernel.kmod_is_loaded.i915: true
[418.681416] [077/133] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[418.774573] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[418.778592] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[418.877685] [078/133] (604s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[418.967545] Starting subtest: flip-vs-dpms-on-nop-interruptible
[418.969847] Starting dynamic subtest: A-eDP1
[420.871044] Dynamic subtest A-eDP1: SUCCESS (1.903s)
[420.882756] Starting dynamic subtest: B-eDP1
[422.692885] Dynamic subtest B-eDP1: SUCCESS (1.820s)
[422.706857] Starting dynamic subtest: C-eDP1
[424.510626] Dynamic subtest C-eDP1: SUCCESS (1.816s)
[424.519824] Starting dynamic subtest: D-eDP1
[426.331653] Dynamic subtest D-eDP1: SUCCESS (1.820s)
[426.334158] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.371s)
[427.496429] [079/133] (595s left) kms_chamelium_color (ctm-negative)
[427.599890] Subtest ctm-negative: SKIP (0.000s)
[427.643668] [080/133] (595s left) kms_lease (empty-lease)
[427.731754] Starting subtest: empty-lease
[427.734022] Starting dynamic subtest: pipe-A-eDP-1
[427.736275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[427.744797] Starting dynamic subtest: pipe-B-eDP-1
[427.746947] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[427.755009] Starting dynamic subtest: pipe-C-eDP-1
[427.757203] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[427.765159] Starting dynamic subtest: pipe-D-eDP-1
[427.767367] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[427.769555] Subtest empty-lease: SUCCESS (0.009s)
[427.832267] [081/133] (595s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[427.930334] Starting subtest: y-tiled-32bpp-rotate-180
[427.934746] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[428.024274] [082/133] (595s left) kms_psr (psr2-cursor-mmap-gtt)
[428.118528] Starting subtest: psr2-cursor-mmap-gtt
[428.120803] Starting dynamic subtest: eDP-1
[429.813215] Dynamic subtest eDP-1: SUCCESS (1.695s)
[429.815546] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.696s)
[430.689526] [083/133] (592s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[430.781609] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[430.810342] Starting dynamic subtest: pipe-A-plane-0
[431.098465] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[431.107867] Starting dynamic subtest: pipe-A-plane-3
[431.331775] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[432.481641] Starting dynamic subtest: pipe-B-plane-0
[432.774304] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[432.783831] Starting dynamic subtest: pipe-B-plane-3
[433.018920] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[433.329985] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.547s)
[434.169936] [084/133] (589s left) kms_big_fb (linear-32bpp-rotate-270)
[434.272270] Starting subtest: linear-32bpp-rotate-270
[434.291474] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[434.393952] [085/133] (589s left) i915_suspend (basic-s2idle-without-i915)
[434.437952] Starting subtest: basic-s2idle-without-i915
[455.515751] Subtest basic-s2idle-without-i915: SUCCESS (5.506s)
[455.601029] [086/133] (568s left) gem_exec_whisper (basic-fds-forked)
[455.686940] Starting subtest: basic-fds-forked
[480.343229] Subtest basic-fds-forked: SUCCESS (24.607s)
[480.527108] [087/133] (543s left) gem_exec_schedule (pi-common)
[480.715939] Starting subtest: pi-common
[480.717808] Starting dynamic subtest: rcs0
[480.759827] Dynamic subtest rcs0: SUCCESS (0.047s)
[480.769116] Starting dynamic subtest: bcs0
[480.811849] Dynamic subtest bcs0: SUCCESS (0.051s)
[480.821010] Starting dynamic subtest: vcs0
[480.853570] Dynamic subtest vcs0: SUCCESS (0.041s)
[480.862585] Starting dynamic subtest: vcs1
[480.890111] Dynamic subtest vcs1: SUCCESS (0.036s)
[480.899027] Starting dynamic subtest: vecs0
[480.923732] Dynamic subtest vecs0: SUCCESS (0.033s)
[480.932678] Starting dynamic subtest: ccs0
[480.958032] Dynamic subtest ccs0: SUCCESS (0.033s)
[480.960154] Subtest pi-common: SUCCESS (0.246s)
[481.195956] [088/133] (542s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[481.311020] Starting subtest: 2x-absolute-wf_vblank-interruptible
[481.322826] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[481.394104] [089/133] (542s left) kms_pm_rpm (fences)
[483.425209] Starting subtest: fences
[483.431981] Subtest fences: SKIP (0.000s)
[483.791363] [090/133] (540s left) gem_pxp (reject-modify-context-protection-off-1)
[483.917530] Starting subtest: reject-modify-context-protection-off-1
[483.920253] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[484.036789] [091/133] (539s left) syncobj_wait (reset-multiple-signaled)
[484.083783] Starting subtest: reset-multiple-signaled
[484.085970] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[484.186309] [092/133] (539s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[484.279955] Starting subtest: psr-rgb565-draw-mmap-cpu
[491.071946] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.791s)
[491.180057] [093/133] (532s left) sysfs_preempt_timeout (invalid)
[491.243006] Starting subtest: invalid
[491.245438] Starting dynamic subtest: vecs0
[491.247768] Dynamic subtest vecs0: SUCCESS (0.000s)
[491.260113] Starting dynamic subtest: ccs0
[491.262263] Dynamic subtest ccs0: SUCCESS (0.000s)
[491.271116] Starting dynamic subtest: vcs0
[491.273281] Dynamic subtest vcs0: SUCCESS (0.000s)
[491.282315] Starting dynamic subtest: bcs0
[491.284643] Dynamic subtest bcs0: SUCCESS (0.000s)
[491.293769] Starting dynamic subtest: rcs0
[491.295681] Dynamic subtest rcs0: SUCCESS (0.000s)
[491.304947] Starting dynamic subtest: vcs1
[491.307137] Dynamic subtest vcs1: SUCCESS (0.000s)
[491.309322] Subtest invalid: SUCCESS (0.006s)
[491.346833] [094/133] (532s left) kms_chamelium_hpd (dp-hpd)
[491.726164] Subtest dp-hpd: SKIP (0.000s)
[492.553041] [095/133] (531s left) kms_color (gamma)
[492.657220] Starting subtest: gamma
[492.659381] Starting dynamic subtest: pipe-A-eDP-1
[493.363094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[493.374135] Starting dynamic subtest: pipe-B-eDP-1
[494.776268] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s)
[494.787228] Starting dynamic subtest: pipe-C-eDP-1
[496.172954] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[496.183400] Starting dynamic subtest: pipe-D-eDP-1
[497.504081] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[497.506525] Subtest gamma: SUCCESS (4.850s)
[498.305285] [096/133] (525s left) kms_busy (extended-modeset-hang-oldfb)
[498.398613] Starting subtest: extended-modeset-hang-oldfb
[498.400488] Starting dynamic subtest: pipe-A
[510.083675] Dynamic subtest pipe-A: SUCCESS (11.685s)
[510.095312] Starting dynamic subtest: pipe-D
[522.347156] Dynamic subtest pipe-D: SUCCESS (12.259s)
[522.349657] Subtest extended-modeset-hang-oldfb: SUCCESS (23.948s)
[523.147485] [097/133] (501s left) gem_exec_params (readonly)
[523.212841] Starting subtest: readonly
[523.217631] Subtest readonly: SUCCESS (0.003s)
[523.348527] [098/133] (500s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[523.458503] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[523.462545] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[523.533898] [099/133] (500s left) kms_vblank (query-busy-hang)
[523.628223] Starting subtest: query-busy-hang
[523.630559] Starting dynamic subtest: pipe-A-eDP-1
[550.047534] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.410s)
[550.068812] Starting dynamic subtest: pipe-D-eDP-1
[575.064608] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.018s)
[575.067073] Subtest query-busy-hang: SUCCESS (51.432s)
[575.921018] [100/133] (448s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[576.040986] Starting subtest: cursorA-vs-flipA-atomic
[587.152199] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.111s)
[588.028384] [101/133] (436s left) kms_flip (flip-vs-wf_vblank-interruptible)
[588.124136] Starting subtest: flip-vs-wf_vblank-interruptible
[588.126917] Starting dynamic subtest: A-eDP1
[590.072715] Dynamic subtest A-eDP1: SUCCESS (1.949s)
[590.085183] Starting dynamic subtest: B-eDP1
[592.004475] Dynamic subtest B-eDP1: SUCCESS (1.930s)
[592.016551] Starting dynamic subtest: C-eDP1
[593.918213] Dynamic subtest C-eDP1: SUCCESS (1.911s)
[593.929827] Starting dynamic subtest: D-eDP1
[595.854143] Dynamic subtest D-eDP1: SUCCESS (1.934s)
[595.859346] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.737s)
[597.085618] [102/133] (427s left) kms_plane_multiple (tiling-4)
[597.185416] Starting subtest: tiling-4
[597.187583] Starting dynamic subtest: pipe-A-eDP-1
[601.034807] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.848s)
[601.044560] Starting dynamic subtest: pipe-B-eDP-1
[605.479810] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.442s)
[605.490939] Starting dynamic subtest: pipe-C-eDP-1
[609.799851] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.320s)
[609.814645] Starting dynamic subtest: pipe-D-eDP-1
[614.257644] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.454s)
[614.259770] Subtest tiling-4: SUCCESS (17.069s)
[615.063913] [103/133] (409s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[615.173681] Starting subtest: yf-tiled-8bpp-rotate-270
[615.177981] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[615.280995] [104/133] (409s left) gem_mmap_gtt (basic-wc)
[615.331859] Subtest basic-wc: SKIP (0.000s)
[615.388675] [105/133] (409s left) gem_ctx_isolation (clean)
[615.451053] Starting subtest: clean
[615.453336] Starting dynamic subtest: rcs0
[615.505589] Dynamic subtest rcs0: SUCCESS (0.054s)
[615.515999] Starting dynamic subtest: bcs0
[615.566023] Dynamic subtest bcs0: SUCCESS (0.059s)
[615.578357] Starting dynamic subtest: vcs0
[615.598793] Dynamic subtest vcs0: SUCCESS (0.032s)
[615.608461] Starting dynamic subtest: vcs1
[617.316663] Dynamic subtest vcs1: SUCCESS (1.716s)
[617.326202] Starting dynamic subtest: vecs0
[619.298211] Dynamic subtest vecs0: SUCCESS (1.980s)
[619.308133] Starting dynamic subtest: ccs0
[621.378460] Dynamic subtest ccs0: SUCCESS (2.079s)
[621.380843] Subtest clean: SUCCESS (5.927s)
[621.598288] [106/133] (402s left) perf_pmu (idle-no-semaphores)
[621.638694] Starting subtest: idle-no-semaphores
[621.640599] Starting dynamic subtest: rcs0
[622.189967] Dynamic subtest rcs0: SUCCESS (0.550s)
[622.202198] Starting dynamic subtest: bcs0
[622.713318] Dynamic subtest bcs0: SUCCESS (0.520s)
[622.725249] Starting dynamic subtest: vcs0
[623.249516] Dynamic subtest vcs0: SUCCESS (0.533s)
[623.261130] Starting dynamic subtest: vcs1
[623.765872] Dynamic subtest vcs1: SUCCESS (0.513s)
[623.778339] Starting dynamic subtest: vecs0
[624.280674] Dynamic subtest vecs0: SUCCESS (0.512s)
[624.292681] Starting dynamic subtest: ccs0
[624.801331] Dynamic subtest ccs0: SUCCESS (0.517s)
[624.804575] Subtest idle-no-semaphores: SUCCESS (3.164s)
[624.901543] [107/133] (399s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[625.000486] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[629.225701] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.227s)
[630.365996] [108/133] (394s left) gen9_exec_parse (bb-large)
[630.441373] Subtest bb-large: SKIP (0.000s)
[630.525343] [109/133] (394s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[630.620137] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[630.622472] Starting dynamic subtest: pipe-A-eDP-1
[630.744650] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[630.754424] Starting dynamic subtest: pipe-B-eDP-1
[631.929110] Dynamic subtest pipe-B-eDP-1: SKIP (1.184s)
[631.933606] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.312s)
[633.125265] [110/133] (391s left) kms_plane_alpha_blend (constant-alpha-mid)
[633.227592] Starting subtest: constant-alpha-mid
[633.537721] Starting dynamic subtest: pipe-A-eDP-1
[634.345790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[634.356055] Starting dynamic subtest: pipe-D-eDP-1
[635.794430] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.449s)
[635.796766] Subtest constant-alpha-mid: SUCCESS (2.569s)
[636.603203] [111/133] (388s left) syncobj_timeline (invalid-query-one-illegal-handle)
[636.654891] Starting subtest: invalid-query-one-illegal-handle
[636.656843] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[636.750277] [112/133] (388s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[636.847538] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[644.107192] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.261s)
[644.238282] [113/133] (380s left) gem_partial_pwrite_pread (write-uncached)
[644.302305] Subtest write-uncached: SKIP (0.000s)
[644.369012] [114/133] (380s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[644.463380] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[644.465564] Starting dynamic subtest: pipe-A-eDP-1
[644.487906] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[644.500241] Starting dynamic subtest: pipe-B-eDP-1
[644.521171] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[644.531059] Starting dynamic subtest: pipe-C-eDP-1
[644.552680] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[644.562255] Starting dynamic subtest: pipe-D-eDP-1
[644.583931] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[644.587982] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[646.620860] [115/133] (378s left) gem_gtt_cpu_tlb
[646.730018] [116/133] (378s left) kms_addfb_basic (size-max)
[646.816258] Starting subtest: size-max
[646.818150] Subtest size-max: SUCCESS (0.000s)
[646.912736] [117/133] (378s left) api_intel_allocator (execbuf-with-allocator)
[646.969637] Starting subtest: execbuf-with-allocator
[646.973393] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[647.088413] [118/133] (377s left) core_setmaster (master-drop-set-user)
[647.159389] Starting subtest: master-drop-set-user
[647.173085] Subtest master-drop-set-user: SUCCESS (0.013s)
[647.211790] [119/133] (377s left) i915_pm_rpm (gem-evict-pwrite)
[649.426065] Starting subtest: gem-evict-pwrite
[649.430805] Subtest gem-evict-pwrite: SKIP (0.000s)
[649.796536] [120/133] (375s left) kms_content_protection (dp-mst-type-1)
[649.937413] Starting subtest: dp-mst-type-1
[649.941962] Subtest dp-mst-type-1: SKIP (0.000s)
[650.051480] [121/133] (375s left) i915_drm_fdinfo (all-busy-check-all)
[650.093459] Starting subtest: all-busy-check-all
[650.101153] Subtest all-busy-check-all: SKIP (0.006s)
[650.172968] [122/133] (375s left) kms_getfb (getfb2-accept-nv12)
[650.289316] Starting subtest: getfb2-accept-nv12
[650.291505] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[650.396301] [123/133] (374s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[650.480410] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[650.482482] Starting dynamic subtest: pipe-A-eDP-1
[651.293808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[651.304288] Starting dynamic subtest: pipe-B-eDP-1
[652.795620] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.499s)
[652.806397] Starting dynamic subtest: pipe-C-eDP-1
[654.316053] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.517s)
[654.327034] Starting dynamic subtest: pipe-D-eDP-1
[655.821209] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.505s)
[655.823255] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.332s)
[657.005810] [124/133] (368s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[657.112438] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[663.793981] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.682s)
[663.919566] [125/133] (361s left) gem_exec_balancer (parallel-ordering)
[664.178115] Starting subtest: parallel-ordering
[665.129072] Subtest parallel-ordering: SUCCESS (0.951s)
[665.256231] [126/133] (360s left) kms_cursor_legacy (forked-move)
[665.383581] Starting subtest: forked-move
[665.385859] Starting dynamic subtest: pipe-A
[670.842778] Dynamic subtest pipe-A: SUCCESS (5.454s)
[670.855339] Starting dynamic subtest: pipe-B
[676.320860] Dynamic subtest pipe-B: SUCCESS (5.474s)
[676.333416] Starting dynamic subtest: pipe-C
[681.792130] Dynamic subtest pipe-C: SUCCESS (5.467s)
[681.804592] Starting dynamic subtest: pipe-D
[687.259851] Dynamic subtest pipe-D: SUCCESS (5.465s)
[687.272474] Starting dynamic subtest: all-pipes
[692.757318] Dynamic subtest all-pipes: SUCCESS (5.498s)
[692.759828] Subtest forked-move: SUCCESS (27.369s)
[692.904328] [127/133] (332s left) kms_hdr (static-toggle)
[692.989423] Starting subtest: static-toggle
[692.995857] Subtest static-toggle: SKIP (0.000s)
[693.073328] [128/133] (332s left) gem_mmap_gtt (hang-user)
[693.134594] Subtest hang-user: SKIP (0.000s)
[693.188254] [129/133] (332s left) kms_rotation_crc (sprite-rotation-180)
[693.278027] Starting subtest: sprite-rotation-180
[700.007332] Subtest sprite-rotation-180: SUCCESS (6.732s)
[701.186581] [130/133] (324s left) gem_linear_blits (normal)
[701.515288] Starting subtest: normal
[705.410526] Subtest normal: SUCCESS (3.895s)
[705.643644] [131/133] (319s left) kms_flip (nonexisting-fb)
[705.787760] Starting subtest: nonexisting-fb
[705.789782] Starting dynamic subtest: A-eDP1
[706.963980] Dynamic subtest A-eDP1: SUCCESS (1.178s)
[706.976040] Starting dynamic subtest: B-eDP1
[708.095012] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[708.110222] Starting dynamic subtest: C-eDP1
[709.221231] Dynamic subtest C-eDP1: SUCCESS (1.125s)
[709.233665] Starting dynamic subtest: D-eDP1
[710.356408] Dynamic subtest D-eDP1: SUCCESS (1.134s)
[710.358688] Subtest nonexisting-fb: SUCCESS (4.576s)
[711.546543] [132/133] (314s left) gem_ctx_param (basic)
[711.603423] Starting subtest: basic
[711.605670] Subtest basic: SUCCESS (0.001s)
[711.712576] [133/133] (313s left) gem_ctx_persistence (legacy-engines-hostile)
[711.763216] Starting subtest: legacy-engines-hostile
[711.765523] Starting dynamic subtest: render
[711.835394] Dynamic subtest render: SUCCESS (0.071s)
[711.847697] Starting dynamic subtest: bsd1
[711.928772] Dynamic subtest bsd1: SUCCESS (0.090s)
[711.941302] Starting dynamic subtest: bsd2
[712.024207] Dynamic subtest bsd2: SUCCESS (0.093s)
[712.037187] Starting dynamic subtest: blt
[712.119210] Dynamic subtest blt: SUCCESS (0.092s)
[712.131584] Starting dynamic subtest: vebox
[712.224556] Dynamic subtest vebox: SUCCESS (0.102s)
[712.227271] Subtest legacy-engines-hostile: SUCCESS (0.462s)
[712.304567] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: kms_vrr
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_busy
results: parsing output: 6/ for test: prime_busy
results: parsing output: 7/ for test: gem_ccs
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: gem_ppgtt
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_render_copy_redux
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_dsc
results: parsing output: 19/ for test: gem_close_race
results: parsing output: 20/ for test: gem_tiled_blits
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: sw_sync
results: parsing output: 26/ for test: kms_properties
results: parsing output: 27/ for test: kms_vrr
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: kms_async_flips
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: gem_lmem_swapping
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: gem_ctx_shared
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_partial_pwrite_pread
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: prime_vgem
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_chamelium_edid
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: gem_exec_flush
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: prime_mmap
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: core_setmaster_vs_auth
results: parsing output: 69/ for test: sw_sync
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: i915_module_load
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_chamelium_color
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: i915_suspend
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: gem_pxp
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: sysfs_preempt_timeout
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_busy
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: gem_ctx_isolation
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gen9_exec_parse
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_plane_alpha_blend
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_partial_pwrite_pread
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: gem_gtt_cpu_tlb
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: api_intel_allocator
results: parsing output: 117/ for test: core_setmaster
results: parsing output: 118/ for test: i915_pm_rpm
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: kms_getfb
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_hdr
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: gem_linear_blits
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: gem_ctx_param
results: parsing output: 132/ for test: gem_ctx_persistence
Done.