[58.290802] Initializing watchdogs [58.290864] /dev/watchdog0 [58.308594] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [58.318864] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [58.322752] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.325261] [001/130] (960s left) api_intel_allocator (reopen) [58.402072] Starting subtest: reopen [58.428884] Subtest reopen: SUCCESS (0.027s) [58.598841] [002/130] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [58.807294] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [58.809015] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [58.947506] [003/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [59.153445] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [59.155129] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [59.269906] [004/130] (959s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [59.561764] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [59.707811] [005/130] (959s left) gem_mmap_wc (write-wc-read-gtt) [59.781905] Subtest write-wc-read-gtt: SKIP (0.000s) [59.867119] [006/130] (959s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [60.075922] Starting subtest: yf-tiled-addfb-size-offset-overflow [60.077691] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [60.198737] [007/130] (958s left) gem_exec_reloc (basic-cpu-wc-active) [60.286138] Subtest basic-cpu-wc-active: SKIP (0.000s) [60.383232] [008/130] (958s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [60.588420] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [60.637093] [009/130] (958s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [60.847833] Starting subtest: extended-modeset-hang-oldfb-with-reset [60.848632] Starting dynamic subtest: pipe-A [71.626971] Dynamic subtest pipe-A: SUCCESS (10.762s) [71.638876] Starting dynamic subtest: pipe-D [82.297179] Dynamic subtest pipe-D: SUCCESS (10.662s) [82.298368] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.429s) [82.572253] [010/130] (936s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [82.780669] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [82.782342] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [82.904370] [011/130] (936s left) gem_madvise (dontneed-before-pwrite) [82.951038] Starting subtest: dontneed-before-pwrite [82.974989] Subtest dontneed-before-pwrite: SKIP (0.024s) [83.051031] [012/130] (936s left) kms_pm_dc (dc5-dpms) [84.258928] Starting subtest: dc5-dpms [86.592599] Subtest dc5-dpms: SUCCESS (2.332s) [86.699664] [013/130] (932s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [86.902312] Starting subtest: fbc-rgb565-draw-render [89.764315] Subtest fbc-rgb565-draw-render: SUCCESS (2.862s) [89.930505] [014/130] (929s left) gem_partial_pwrite_pread (reads-snoop) [90.009324] Subtest reads-snoop: SKIP (0.000s) [90.081894] [015/130] (929s left) gem_exec_whisper (basic-queues-forked-all) [90.165199] Starting subtest: basic-queues-forked-all [112.162375] Subtest basic-queues-forked-all: SUCCESS (21.993s) [112.363619] [016/130] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [112.565491] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [112.567247] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [112.706100] [017/130] (907s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [112.907520] Starting subtest: flip-vs-cursor-busy-crc-legacy [113.620920] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.712s) [113.882498] [018/130] (905s left) fbdev (write) [113.940233] Starting subtest: write [115.420467] Subtest write: SUCCESS (1.480s) [115.496582] [019/130] (904s left) gem_softpin (invalid) [115.568268] Starting subtest: invalid [115.578378] Subtest invalid: SUCCESS (0.010s) [115.762396] [020/130] (904s left) gem_create (create-invalid-size) [115.830971] Starting subtest: create-invalid-size [115.831909] Subtest create-invalid-size: SUCCESS (0.000s) [116.047210] [021/130] (903s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [116.252415] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [116.254060] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [116.393677] [022/130] (903s left) kms_legacy_colorkey (basic) [116.590182] Starting subtest: basic [116.591170] Starting dynamic subtest: pipe-A [116.656646] Dynamic subtest pipe-A: SUCCESS (0.066s) [116.671465] Starting dynamic subtest: pipe-B [116.672672] Dynamic subtest pipe-B: SUCCESS (0.001s) [116.689076] Starting dynamic subtest: pipe-C [116.690386] Dynamic subtest pipe-C: SUCCESS (0.000s) [116.704154] Starting dynamic subtest: pipe-D [116.705349] Dynamic subtest pipe-D: SUCCESS (0.000s) [116.706230] Subtest basic: SUCCESS (0.069s) [116.805546] [023/130] (903s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [117.005181] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [117.006132] Starting dynamic subtest: pipe-A-DP-3 [157.022206] Dynamic subtest pipe-A-DP-3: SUCCESS (8.606s) [157.034726] Starting dynamic subtest: pipe-B-DP-3 [196.664658] Dynamic subtest pipe-B-DP-3: SUCCESS (7.421s) [196.690479] Starting dynamic subtest: pipe-C-DP-3 [235.691274] Dynamic subtest pipe-C-DP-3: SUCCESS (7.512s) [235.703925] Starting dynamic subtest: pipe-D-DP-3 [274.688918] Dynamic subtest pipe-D-DP-3: SUCCESS (7.493s) [274.689793] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SUCCESS (31.041s) [275.105526] [024/130] (871s left) kms_color (legacy-gamma-reset) [275.320551] Starting subtest: legacy-gamma-reset [275.321583] Starting dynamic subtest: pipe-A-DP-3 [275.545722] Dynamic subtest pipe-A-DP-3: SUCCESS (0.225s) [275.556994] Starting dynamic subtest: pipe-B-DP-3 [275.564895] Dynamic subtest pipe-B-DP-3: SUCCESS (0.019s) [275.574711] Starting dynamic subtest: pipe-C-DP-3 [275.582684] Dynamic subtest pipe-C-DP-3: SUCCESS (0.017s) [275.592764] Starting dynamic subtest: pipe-D-DP-3 [275.600015] Dynamic subtest pipe-D-DP-3: SUCCESS (0.017s) [275.600896] Subtest legacy-gamma-reset: SUCCESS (0.280s) [275.789788] [025/130] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [275.996931] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [275.998616] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [276.128217] [026/130] (870s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [276.338300] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [276.353508] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.014s) [276.439412] [027/130] (870s left) kms_selftest (drm_damage_helper) [276.487012] Starting subtest: drm_damage_helper [276.498489] Starting dynamic subtest: drm_test_damage_iter_no_damage [276.630920] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.123s) [276.669885] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [276.762936] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.140s) [276.800889] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [276.912882] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.146s) [276.923494] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [277.025513] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.114s) [277.037046] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [277.164732] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.131s) [277.175742] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [277.278785] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.120s) [277.289133] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [277.412821] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.117s) [277.452922] Starting dynamic subtest: drm_test_damage_iter_simple_damage [277.530413] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.130s) [277.541419] Starting dynamic subtest: drm_test_damage_iter_single_damage [277.635313] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.103s) [277.674698] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [277.754603] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.118s) [277.791465] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [277.855300] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.101s) [277.891880] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [277.955014] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.098s) [277.967968] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [278.058291] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.101s) [278.098598] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [278.165490] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.103s) [278.204865] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [278.287461] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.120s) [278.298846] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [278.389476] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.100s) [278.428697] Starting dynamic subtest: drm_test_damage_iter_damage [278.495429] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.104s) [278.534300] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [278.616248] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.118s) [278.630412] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [278.724228] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.107s) [278.763914] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [278.827549] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.101s) [278.867916] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [278.928955] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.102s) [278.930693] Subtest drm_damage_helper: SUCCESS (2.442s) [279.151901] [028/130] (867s left) gem_softpin (softpin) [279.230829] Starting subtest: softpin [311.670607] Subtest softpin: SUCCESS (32.437s) [311.807752] [029/130] (835s left) gem_exec_params (rel-constants-invalid-ring) [311.886799] Starting subtest: rel-constants-invalid-ring [311.887741] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [312.059563] [030/130] (835s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [312.132088] Starting subtest: etime-multi-wait-all-submitted-signaled [312.238836] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s) [312.356120] [031/130] (834s left) gem_eio (unwedge-stress) [312.652714] Starting subtest: unwedge-stress [354.636899] Subtest unwedge-stress: SUCCESS (41.984s) [354.934045] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true [354.936048] [032/130] (792s left) kms_cursor_crc (cursor-size-change) [355.142704] Starting subtest: cursor-size-change [355.144636] Starting dynamic subtest: pipe-A-DP-3 [356.013241] Dynamic subtest pipe-A-DP-3: SUCCESS (0.868s) [356.041223] Starting dynamic subtest: pipe-D-DP-3 [356.809618] Dynamic subtest pipe-D-DP-3: SUCCESS (0.793s) [356.810549] Subtest cursor-size-change: SUCCESS (1.667s) [357.347511] [033/130] (790s left) gem_ctx_persistence (legacy-engines-hang) [357.433739] Starting subtest: legacy-engines-hang [357.434654] Starting dynamic subtest: render [357.530673] Dynamic subtest render: SUCCESS (0.097s) [357.544513] Starting dynamic subtest: bsd1 [357.629535] Dynamic subtest bsd1: SUCCESS (0.097s) [357.671767] Starting dynamic subtest: bsd2 [357.686587] Dynamic subtest bsd2: SUCCESS (0.055s) [357.703522] Starting dynamic subtest: blt [357.750971] Dynamic subtest blt: SUCCESS (0.063s) [357.780627] Starting dynamic subtest: vebox [357.816557] Dynamic subtest vebox: SUCCESS (0.063s) [357.818422] Subtest legacy-engines-hang: SUCCESS (0.383s) [357.983387] [034/130] (789s left) gem_flink_basic (double-flink) [358.065500] Starting subtest: double-flink [358.066388] Subtest double-flink: SUCCESS (0.000s) [358.177025] [035/130] (789s left) perf_pmu (idle-no-semaphores) [358.246778] Starting subtest: idle-no-semaphores [358.247689] Starting dynamic subtest: rcs0 [358.827857] Dynamic subtest rcs0: SUCCESS (0.580s) [358.843591] Starting dynamic subtest: bcs0 [359.346688] Dynamic subtest bcs0: SUCCESS (0.517s) [359.362268] Starting dynamic subtest: vcs0 [359.861540] Dynamic subtest vcs0: SUCCESS (0.513s) [359.876598] Starting dynamic subtest: vcs1 [360.375732] Dynamic subtest vcs1: SUCCESS (0.512s) [360.388746] Starting dynamic subtest: vecs0 [360.892665] Dynamic subtest vecs0: SUCCESS (0.515s) [360.907574] Starting dynamic subtest: vecs1 [361.407657] Dynamic subtest vecs1: SUCCESS (0.513s) [361.421171] Starting dynamic subtest: ccs0 [361.921710] Dynamic subtest ccs0: SUCCESS (0.512s) [361.923477] Subtest idle-no-semaphores: SUCCESS (3.675s) [362.053722] [036/130] (785s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [362.269986] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [362.271667] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [362.437646] [037/130] (785s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [362.523667] Starting subtest: x-tiled-to-vebox-yf-tiled [362.525812] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [362.746063] [038/130] (784s left) kms_flip (2x-flip-vs-suspend-interruptible) [362.960563] Starting subtest: 2x-flip-vs-suspend-interruptible [362.975650] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.014s) [363.082801] [039/130] (784s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [363.408481] Starting subtest: parallel-dmabuf-import-out-fence [365.349729] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.941s) [365.477383] [040/130] (782s left) kms_pm_rpm (basic-rte) [365.526339] Starting subtest: basic-rte [368.841911] Subtest basic-rte: SUCCESS (3.314s) [370.649828] [041/130] (777s left) kms_setmode (basic-clone-single-crtc) [370.726421] Starting subtest: basic-clone-single-crtc [370.729285] Subtest basic-clone-single-crtc: SKIP (0.000s) [370.905707] [042/130] (777s left) api_intel_allocator (fork-simple-once) [370.984719] Starting subtest: fork-simple-once [371.023672] Subtest fork-simple-once: SUCCESS (0.039s) [371.171564] [043/130] (776s left) gem_exec_balancer (bonded-semaphore) [371.258727] Starting subtest: bonded-semaphore [371.260869] Subtest bonded-semaphore: SKIP (0.000s) [371.605458] [044/130] (776s left) gem_ctx_create (basic-files) [371.692176] Starting subtest: basic-files [373.708262] Subtest basic-files: SUCCESS (2.016s) [374.361506] [045/130] (773s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [374.578133] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [375.203071] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.624s) [375.452024] [046/130] (772s left) kms_big_fb (x-tiled-16bpp-rotate-180) [375.672620] Starting subtest: x-tiled-16bpp-rotate-180 [377.320578] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.647s) [377.521010] [047/130] (770s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [377.737919] Starting subtest: flip-vs-cursor-crc-legacy [378.290026] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.551s) [378.595813] [048/130] (769s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [378.811235] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [378.812917] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [378.947368] [049/130] (769s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [379.153657] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [379.154583] Starting dynamic subtest: pipe-A-DP-3 [379.163221] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [379.174435] Starting dynamic subtest: pipe-B-DP-3 [379.182786] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [379.193712] Starting dynamic subtest: pipe-C-DP-3 [379.202113] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [379.213233] Starting dynamic subtest: pipe-D-DP-3 [379.223229] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [379.225320] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s) [379.614512] [050/130] (768s left) kms_flip (flip-vs-panning) [379.821397] Starting subtest: flip-vs-panning [379.825469] Starting dynamic subtest: A-DP3 [387.691032] Dynamic subtest A-DP3: SUCCESS (7.865s) [387.708810] Starting dynamic subtest: B-DP3 [395.517018] Dynamic subtest B-DP3: SUCCESS (7.824s) [395.558056] Starting dynamic subtest: C-DP3 [403.368545] Dynamic subtest C-DP3: SUCCESS (7.849s) [403.381969] Starting dynamic subtest: D-DP3 [411.197689] Dynamic subtest D-DP3: SUCCESS (7.828s) [411.199821] Subtest flip-vs-panning: SUCCESS (31.378s) [411.540360] [051/130] (737s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers) [411.743705] Starting subtest: plane-downscale-factor-0-25-with-modifiers [411.744592] Starting dynamic subtest: pipe-A [412.500295] Dynamic subtest pipe-A: SKIP (0.755s) [412.512142] Starting dynamic subtest: pipe-B [413.644029] Dynamic subtest pipe-B: SKIP (1.142s) [413.655327] Starting dynamic subtest: pipe-C [414.789524] Dynamic subtest pipe-C: SKIP (1.144s) [414.801501] Starting dynamic subtest: pipe-D [415.932082] Dynamic subtest pipe-D: SKIP (1.143s) [415.933491] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (4.187s) [416.065889] [052/130] (732s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [416.282334] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [416.284101] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [416.398506] [053/130] (732s left) kms_dp_aux_dev [417.048986] [054/130] (731s left) kms_chamelium_color (ctm-0-50) [417.254643] Subtest ctm-0-50: SKIP (0.000s) [417.309405] [055/130] (731s left) gem_exec_params (larger-than-life-batch) [417.399876] Starting subtest: larger-than-life-batch [425.365651] Subtest larger-than-life-batch: SUCCESS (7.965s) [425.782646] [056/130] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [426.045387] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [426.047226] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [426.183414] [057/130] (722s left) kms_cursor_legacy (single-move) [426.401280] Starting subtest: single-move [426.402229] Starting dynamic subtest: pipe-A [431.784303] Dynamic subtest pipe-A: SUCCESS (5.381s) [431.796457] Starting dynamic subtest: pipe-B [437.166757] Dynamic subtest pipe-B: SUCCESS (5.381s) [437.178545] Starting dynamic subtest: pipe-C [442.549256] Dynamic subtest pipe-C: SUCCESS (5.381s) [442.560922] Starting dynamic subtest: pipe-D [447.931589] Dynamic subtest pipe-D: SUCCESS (5.381s) [447.943637] Starting dynamic subtest: all-pipes [453.314503] Dynamic subtest all-pipes: SUCCESS (5.381s) [453.315592] Subtest single-move: SUCCESS (26.912s) [453.402697] [058/130] (695s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [453.619917] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [453.679283] [059/130] (695s left) kms_content_protection (lic-type-1) [453.944354] Starting subtest: lic-type-1 [454.488511] Subtest lic-type-1: SKIP (0.541s) [454.869902] [060/130] (694s left) kms_big_fb (4-tiled-32bpp-rotate-90) [455.090621] Starting subtest: 4-tiled-32bpp-rotate-90 [455.137943] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.047s) [455.325965] [061/130] (693s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [455.540771] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [455.542522] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [455.715424] [062/130] (693s left) gem_exec_schedule (u-semaphore-noskip) [455.836559] Starting subtest: u-semaphore-noskip [456.672780] Subtest u-semaphore-noskip: SUCCESS (0.836s) [457.057513] [063/130] (692s left) gem_mmap_gtt (basic-copy) [457.136812] Subtest basic-copy: SKIP (0.000s) [457.212606] [064/130] (692s left) i915_pm_rps (engine-order) [457.301620] Starting subtest: engine-order [467.735903] Subtest engine-order: SUCCESS (10.432s) [467.953452] [065/130] (681s left) kms_chamelium_frames (dp-crc-multiple) [468.251071] Subtest dp-crc-multiple: SKIP (0.000s) [468.412027] [066/130] (681s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [468.494380] Starting subtest: multi-wait-all-for-submit-available-submitted [468.495318] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [468.680601] [067/130] (680s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [468.887881] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [468.890261] Starting dynamic subtest: pipe-A-DP-3 [468.898645] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [468.910847] Starting dynamic subtest: pipe-B-DP-3 [468.919499] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [468.931072] Starting dynamic subtest: pipe-C-DP-3 [468.939316] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [468.950981] Starting dynamic subtest: pipe-D-DP-3 [468.961823] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [468.963866] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s) [469.393587] [068/130] (680s left) perf (non-zero-reason) [469.756470] Starting subtest: non-zero-reason [469.757381] Starting dynamic subtest: 0-rcs0 [472.817579] Dynamic subtest 0-rcs0: FAIL (2.750s) [472.819210] Subtest non-zero-reason: FAIL (2.751s) [472.892655] [069/130] (676s left) kms_psr (psr-primary-mmap-cpu) [473.099482] Subtest psr-primary-mmap-cpu: SKIP (0.000s) [473.154171] [070/130] (676s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [473.365219] Starting subtest: psr-rgb101010-draw-pwrite [473.367021] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s) [473.496804] [071/130] (676s left) gem_mmap_wc (write-read) [473.575760] Subtest write-read: SKIP (0.000s) [473.658834] [072/130] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [473.873170] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [473.874766] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [474.023088] [073/130] (675s left) syncobj_timeline (wait-zero-handles) [474.099298] Starting subtest: wait-zero-handles [474.100240] Subtest wait-zero-handles: SUCCESS (0.000s) [474.249316] [074/130] (675s left) kms_psr (fbc-psr2-cursor-plane-move) [474.458430] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s) [474.519161] [075/130] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [474.741193] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [474.742956] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [474.852060] [076/130] (675s left) dumb_buffer (invalid-bpp) [474.932714] Starting subtest: invalid-bpp [474.933609] Subtest invalid-bpp: SUCCESS (0.000s) [475.100705] [077/130] (675s left) prime_vgem (basic-fence-mmap) [475.194853] Starting subtest: basic-fence-mmap [475.196950] Subtest basic-fence-mmap: SKIP (0.000s) [475.351894] [078/130] (674s left) kms_pipe_crc_basic (disable-crc-after-crtc) [475.561927] Starting subtest: disable-crc-after-crtc [475.564253] Starting dynamic subtest: pipe-A-DP-3 [476.280389] Dynamic subtest pipe-A-DP-3: SUCCESS (0.716s) [476.302568] Starting dynamic subtest: pipe-B-DP-3 [476.887667] Dynamic subtest pipe-B-DP-3: SUCCESS (0.605s) [476.903865] Starting dynamic subtest: pipe-C-DP-3 [477.491834] Dynamic subtest pipe-C-DP-3: SUCCESS (0.602s) [477.507411] Starting dynamic subtest: pipe-D-DP-3 [478.142747] Dynamic subtest pipe-D-DP-3: SUCCESS (0.649s) [478.143618] Subtest disable-crc-after-crtc: SUCCESS (2.581s) [478.392275] [079/130] (672s left) gem_workarounds (basic-read-context) [478.486173] Starting subtest: basic-read-context [478.519595] Subtest basic-read-context: SUCCESS (0.033s) [478.684965] [080/130] (671s left) prime_busy (hang) [478.771300] Starting subtest: hang [478.773658] Starting dynamic subtest: rcs0 [505.167407] Dynamic subtest rcs0: SUCCESS (26.393s) [505.180018] Starting dynamic subtest: bcs0 [512.319962] Dynamic subtest bcs0: SUCCESS (7.151s) [512.332503] Starting dynamic subtest: vcs0 [519.297441] Dynamic subtest vcs0: SUCCESS (6.978s) [519.310020] Starting dynamic subtest: vcs1 [526.342971] Dynamic subtest vcs1: SUCCESS (7.043s) [526.355388] Starting dynamic subtest: vecs0 [533.318921] Dynamic subtest vecs0: SUCCESS (6.975s) [533.331404] Starting dynamic subtest: vecs1 [540.294672] Dynamic subtest vecs1: SUCCESS (6.975s) [540.307011] Starting dynamic subtest: ccs0 [554.191831] Dynamic subtest ccs0: SUCCESS (13.896s) [554.192848] Subtest hang: SUCCESS (75.419s) [554.349888] [081/130] (596s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [554.568506] Starting subtest: fbc-1p-primscrn-cur-indfb-move [558.854189] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.285s) [559.069191] [082/130] (591s left) syncobj_wait (wait-all-for-submit-delayed-submit) [559.146403] Starting subtest: wait-all-for-submit-delayed-submit [559.249818] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [559.368995] [083/130] (591s left) kms_addfb_basic (unused-pitches) [559.447808] Starting subtest: unused-pitches [559.448745] Subtest unused-pitches: SUCCESS (0.000s) [559.732704] [084/130] (590s left) gem_exec_schedule (pi-common) [559.941918] Starting subtest: pi-common [559.942842] Starting dynamic subtest: rcs0 [560.040105] Dynamic subtest rcs0: SUCCESS (0.097s) [560.061306] Starting dynamic subtest: bcs0 [560.137019] Dynamic subtest bcs0: SUCCESS (0.093s) [560.155180] Starting dynamic subtest: vcs0 [560.224972] Dynamic subtest vcs0: SUCCESS (0.087s) [560.242208] Starting dynamic subtest: vcs1 [560.306701] Dynamic subtest vcs1: SUCCESS (0.080s) [560.324198] Starting dynamic subtest: vecs0 [560.388667] Dynamic subtest vecs0: SUCCESS (0.080s) [560.410089] Starting dynamic subtest: vecs1 [560.473940] Dynamic subtest vecs1: SUCCESS (0.084s) [560.493539] Starting dynamic subtest: ccs0 [560.556011] Dynamic subtest ccs0: SUCCESS (0.080s) [560.557190] Subtest pi-common: SUCCESS (0.615s) [560.821900] [085/130] (589s left) kms_vrr (flipline) [561.028881] Starting subtest: flipline [561.031609] Subtest flipline: SKIP (0.000s) [561.120531] [086/130] (589s left) gem_ringfill (legacy-basic) [561.553614] Starting subtest: legacy-basic [561.559541] Starting dynamic subtest: default [561.661696] Dynamic subtest default: SUCCESS (0.106s) [561.677147] Starting dynamic subtest: render [561.702722] Dynamic subtest render: SUCCESS (0.039s) [561.721964] Starting dynamic subtest: bsd [561.743967] Dynamic subtest bsd: SUCCESS (0.040s) [561.766054] Starting dynamic subtest: bsd1 [561.786033] Dynamic subtest bsd1: SUCCESS (0.040s) [561.807938] Starting dynamic subtest: bsd2 [561.828713] Dynamic subtest bsd2: SUCCESS (0.041s) [561.847808] Starting dynamic subtest: blt [561.869858] Dynamic subtest blt: SUCCESS (0.039s) [561.889118] Starting dynamic subtest: vebox [561.911762] Dynamic subtest vebox: SUCCESS (0.040s) [561.912775] Subtest legacy-basic: SUCCESS (0.360s) [562.055191] [087/130] (588s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [562.260842] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [562.263117] Starting dynamic subtest: pipe-A-DP-3 [562.271597] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [562.283718] Starting dynamic subtest: pipe-B-DP-3 [562.292336] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [562.304286] Starting dynamic subtest: pipe-C-DP-3 [562.312588] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [562.324868] Starting dynamic subtest: pipe-D-DP-3 [562.335569] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [562.337468] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [562.714493] [088/130] (588s left) i915_query (query-regions-garbage-items) [562.790674] Starting subtest: query-regions-garbage-items [562.791556] Subtest query-regions-garbage-items: SUCCESS (0.000s) [562.918131] [089/130] (588s left) i915_pm_rpm (gem-evict-pwrite) [565.589635] Starting subtest: gem-evict-pwrite [565.593884] Subtest gem-evict-pwrite: SKIP (0.000s) [566.068847] [090/130] (585s left) gem_mmap_offset (mmap-boundaries) [566.157711] Starting subtest: mmap-boundaries [566.163905] Starting dynamic subtest: lmem0 [566.275889] Dynamic subtest lmem0: SUCCESS (0.116s) [566.288507] Starting dynamic subtest: smem0 [567.558335] Dynamic subtest smem0: SUCCESS (1.281s) [567.559323] Subtest mmap-boundaries: SUCCESS (1.402s) [568.219364] [091/130] (582s left) gen9_exec_parse (bb-chained) [568.304645] Subtest bb-chained: SKIP (0.000s) [568.379369] [092/130] (582s left) sysfs_timeslice_duration (duration) [568.464316] Starting subtest: duration [568.465283] Starting dynamic subtest: vecs0 [581.617759] Dynamic subtest vecs0: SUCCESS (13.152s) [581.633264] Starting dynamic subtest: ccs0 [594.748954] Dynamic subtest ccs0: SUCCESS (13.128s) [594.765520] Starting dynamic subtest: vcs0 [607.875954] Dynamic subtest vcs0: SUCCESS (13.122s) [607.892562] Starting dynamic subtest: bcs0 [621.014007] Dynamic subtest bcs0: SUCCESS (13.133s) [621.029472] Starting dynamic subtest: vecs1 [634.165124] Dynamic subtest vecs1: SUCCESS (13.148s) [634.180867] Starting dynamic subtest: rcs0 [647.305992] Dynamic subtest rcs0: SUCCESS (13.136s) [647.322192] Starting dynamic subtest: vcs1 [660.460266] Dynamic subtest vcs1: SUCCESS (13.149s) [660.464764] Subtest duration: SUCCESS (91.995s) [660.556715] [093/130] (490s left) kms_psr (psr2-primary-render) [660.763732] Subtest psr2-primary-render: SKIP (0.000s) [660.819263] [094/130] (490s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [661.044087] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [661.059348] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.014s) [661.164479] [095/130] (490s left) gem_exec_fence (syncobj-channel) [661.657625] Starting subtest: syncobj-channel [662.681868] Subtest syncobj-channel: SUCCESS (1.023s) [663.077423] [096/130] (488s left) api_intel_bb (object-noreloc-keep-cache-simple) [663.157723] Starting subtest: object-noreloc-keep-cache-simple [663.183508] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.026s) [663.395691] [097/130] (488s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [663.473253] Starting subtest: invalid-multi-wait-unsubmitted-signaled [663.474178] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [663.646352] [098/130] (488s left) syncobj_timeline (etime-single-wait-all-submitted) [663.728372] Starting subtest: etime-single-wait-all-submitted [663.838568] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s) [663.987432] [099/130] (487s left) gem_ctx_persistence (hostile) [664.073150] Starting subtest: hostile [672.939690] Subtest hostile: SUCCESS (8.862s) [673.075553] [100/130] (478s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [673.293173] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [673.294803] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [673.429055] [101/130] (478s left) kms_cursor_crc (cursor-onscreen-128x42) [673.784920] Starting subtest: cursor-onscreen-128x42 [673.789820] Starting dynamic subtest: pipe-A-DP-3 [676.208759] Dynamic subtest pipe-A-DP-3: SUCCESS (2.418s) [676.261302] Starting dynamic subtest: pipe-D-DP-3 [678.910108] Dynamic subtest pipe-D-DP-3: SUCCESS (2.660s) [678.911007] Subtest cursor-onscreen-128x42: SUCCESS (5.125s) [679.350490] [102/130] (472s left) kms_atomic_interruptible (legacy-setmode) [679.564755] Starting subtest: legacy-setmode [679.565613] Starting dynamic subtest: pipe-A-DP-3 [685.927510] Dynamic subtest pipe-A-DP-3: SUCCESS (6.361s) [685.928397] Subtest legacy-setmode: SUCCESS (6.363s) [686.181426] [103/130] (465s left) kms_cursor_crc (cursor-sliding-256x85) [686.573625] Starting subtest: cursor-sliding-256x85 [686.578780] Starting dynamic subtest: pipe-A-DP-3 [690.805952] Dynamic subtest pipe-A-DP-3: SUCCESS (4.228s) [690.855014] Starting dynamic subtest: pipe-D-DP-3 [695.122175] Dynamic subtest pipe-D-DP-3: SUCCESS (4.278s) [695.123141] Subtest cursor-sliding-256x85: SUCCESS (8.547s) [695.455915] [104/130] (456s left) kms_big_fb (x-tiled-64bpp-rotate-90) [695.669504] Starting subtest: x-tiled-64bpp-rotate-90 [695.720713] Subtest x-tiled-64bpp-rotate-90: SKIP (0.051s) [695.932760] [105/130] (456s left) gem_exec_fence (nb-await) [696.140773] Starting subtest: nb-await [696.141705] Starting dynamic subtest: rcs0 [696.233248] Dynamic subtest rcs0: SUCCESS (0.092s) [696.252695] Starting dynamic subtest: bcs0 [696.297492] Dynamic subtest bcs0: SUCCESS (0.062s) [696.341943] Starting dynamic subtest: vcs0 [696.384852] Dynamic subtest vcs0: SUCCESS (0.084s) [696.411839] Starting dynamic subtest: vcs1 [696.454556] Dynamic subtest vcs1: SUCCESS (0.067s) [696.497832] Starting dynamic subtest: vecs0 [696.540761] Dynamic subtest vecs0: SUCCESS (0.083s) [696.564780] Starting dynamic subtest: vecs1 [696.607741] Dynamic subtest vecs1: SUCCESS (0.065s) [696.647676] Starting dynamic subtest: ccs0 [696.688389] Dynamic subtest ccs0: SUCCESS (0.078s) [696.689547] Subtest nb-await: SUCCESS (0.548s) [697.457132] [106/130] (454s left) perf (create-destroy-userspace-config) [697.651917] Starting subtest: create-destroy-userspace-config [697.680694] Subtest create-destroy-userspace-config: SUCCESS (0.028s) [697.735327] [107/130] (454s left) kms_psr (pr-cursor-plane-onoff) [697.953530] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [698.013455] [108/130] (454s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [698.228258] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [698.229949] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [698.386806] [109/130] (454s left) gem_pread (snoop) [698.470910] Subtest snoop: SKIP (0.000s) [698.553794] [110/130] (453s left) drm_fdinfo (memory-info-idle) [698.624738] Starting subtest: memory-info-idle [698.625644] Starting dynamic subtest: lmem0 [698.710478] Dynamic subtest lmem0: SUCCESS (0.085s) [698.726610] Starting dynamic subtest: smem0 [698.771603] Dynamic subtest smem0: SUCCESS (0.060s) [698.772477] Subtest memory-info-idle: SUCCESS (0.147s) [698.898884] [111/130] (453s left) syncobj_timeline (single-wait-all-signaled) [698.980260] Starting subtest: single-wait-all-signaled [698.981198] Subtest single-wait-all-signaled: SUCCESS (0.000s) [699.149128] [112/130] (453s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [699.367335] Starting subtest: 2x-cursor-vs-flip-legacy [699.370528] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s) [699.475970] [113/130] (453s left) gem_huc_copy (huc-copy) [699.584185] Starting subtest: huc-copy [699.589518] Subtest huc-copy: SUCCESS (0.005s) [699.769120] [114/130] (453s left) gem_mmap_gtt (hang-user) [699.849619] Subtest hang-user: SKIP (0.000s) [699.937161] [115/130] (452s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [700.016774] Subtest no-spare-fences-interruptible: SKIP (0.000s) [700.131707] [116/130] (452s left) kms_addfb_basic (basic-y-tiled-legacy) [700.213173] Starting subtest: basic-y-tiled-legacy [700.214888] Subtest basic-y-tiled-legacy: SKIP (0.000s) [700.472901] [117/130] (452s left) gem_cs_tlb (engines) [700.557144] Starting subtest: engines [700.558031] Starting dynamic subtest: rcs0 [702.711076] Dynamic subtest rcs0: SUCCESS (2.153s) [702.723930] Starting dynamic subtest: bcs0 [704.867607] Dynamic subtest bcs0: SUCCESS (2.155s) [704.880332] Starting dynamic subtest: vcs0 [707.020561] Dynamic subtest vcs0: SUCCESS (2.152s) [707.033472] Starting dynamic subtest: vcs1 [709.173787] Dynamic subtest vcs1: SUCCESS (2.152s) [709.186315] Starting dynamic subtest: vecs0 [711.326637] Dynamic subtest vecs0: SUCCESS (2.152s) [711.339101] Starting dynamic subtest: vecs1 [713.479997] Dynamic subtest vecs1: SUCCESS (2.152s) [713.492631] Starting dynamic subtest: ccs0 [715.632588] Dynamic subtest ccs0: SUCCESS (2.152s) [715.633583] Subtest engines: SUCCESS (15.075s) [715.784271] [118/130] (437s left) kms_universal_plane (universal-plane-sanity) [715.994791] Starting subtest: universal-plane-sanity [715.996887] Starting dynamic subtest: pipe-A-DP-3 [716.566092] Dynamic subtest pipe-A-DP-3: SUCCESS (0.570s) [716.587579] Starting dynamic subtest: pipe-B-DP-3 [717.047759] Dynamic subtest pipe-B-DP-3: SUCCESS (0.478s) [717.067532] Starting dynamic subtest: pipe-C-DP-3 [717.509647] Dynamic subtest pipe-C-DP-3: SUCCESS (0.460s) [717.526858] Starting dynamic subtest: pipe-D-DP-3 [717.989006] Dynamic subtest pipe-D-DP-3: SUCCESS (0.478s) [717.989930] Subtest universal-plane-sanity: SUCCESS (1.995s) [718.243205] [119/130] (434s left) syncobj_wait (multi-wait-signaled) [718.328268] Starting subtest: multi-wait-signaled [718.329236] Subtest multi-wait-signaled: SUCCESS (0.000s) [718.474722] [120/130] (434s left) kms_invalid_mode (overflow-vrefresh) [718.682444] Starting subtest: overflow-vrefresh [718.683414] Starting dynamic subtest: pipe-A-DP-3 [718.766537] Dynamic subtest pipe-A-DP-3: SUCCESS (0.083s) [718.784733] Starting dynamic subtest: pipe-B-DP-3 [718.785897] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s) [718.801927] Starting dynamic subtest: pipe-C-DP-3 [718.802880] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s) [718.815703] Starting dynamic subtest: pipe-D-DP-3 [718.816635] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s) [718.817568] Subtest overflow-vrefresh: SUCCESS (0.093s) [719.024919] [121/130] (434s left) kms_fbcon_fbt (fbc-suspend) [719.111676] Starting subtest: fbc-suspend [770.981741] Subtest fbc-suspend: SUCCESS (21.506s) [771.096801] [122/130] (412s left) kms_hdr (static-toggle-dpms) [771.304277] Starting subtest: static-toggle-dpms [774.531000] Starting dynamic subtest: pipe-A-DP-3 [775.835971] Dynamic subtest pipe-A-DP-3: SUCCESS (1.304s) [775.837121] Subtest static-toggle-dpms: SUCCESS (4.532s) [776.176898] [123/130] (407s left) gem_userptr_blits (sync-unmap-cycles) [776.270761] Starting subtest: sync-unmap-cycles [781.640089] Subtest sync-unmap-cycles: SUCCESS (5.369s) [781.841562] [124/130] (401s left) gem_spin_batch (user-each) [781.940407] Starting subtest: user-each [785.367073] Subtest user-each: SUCCESS (3.426s) [785.705068] [125/130] (398s left) gem_exec_reloc (basic-wc-cpu-noreloc) [785.795071] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [785.880965] [126/130] (398s left) template (b) [785.959143] Starting subtest: B [785.960038] Subtest B: SUCCESS (0.000s) [786.109133] [127/130] (397s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [786.320367] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [786.322700] Starting dynamic subtest: pipe-A-valid-mode [788.126867] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.803s) [788.128348] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (1.807s) [788.409915] [128/130] (395s left) kms_psr (fbc-psr2-primary-blt) [788.617102] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [788.683782] [129/130] (395s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [788.891284] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [788.892153] Starting dynamic subtest: pipe-A [791.008523] Dynamic subtest pipe-A: SUCCESS (2.117s) [791.033367] Starting dynamic subtest: pipe-B [793.262029] Dynamic subtest pipe-B: SUCCESS (2.252s) [793.288242] Starting dynamic subtest: pipe-C [793.631402] Dynamic subtest pipe-C: SUCCESS (0.367s) [793.661025] Starting dynamic subtest: pipe-D [794.001548] Dynamic subtest pipe-D: SUCCESS (0.368s) [794.002689] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.111s) [794.328308] [130/130] (389s left) gem_wait (busy) [794.427823] Starting subtest: busy [794.428793] Starting dynamic subtest: all-engines [794.999391] Dynamic subtest all-engines: SUCCESS (0.571s) [795.013734] Starting dynamic subtest: rcs0 [795.538167] Dynamic subtest rcs0: SUCCESS (0.538s) [795.550953] Starting dynamic subtest: bcs0 [796.077140] Dynamic subtest bcs0: SUCCESS (0.538s) [796.089941] Starting dynamic subtest: vcs0 [796.616178] Dynamic subtest vcs0: SUCCESS (0.538s) [796.628960] Starting dynamic subtest: vcs1 [797.155052] Dynamic subtest vcs1: SUCCESS (0.538s) [797.167755] Starting dynamic subtest: vecs0 [797.694128] Dynamic subtest vecs0: SUCCESS (0.538s) [797.706925] Starting dynamic subtest: vecs1 [798.233139] Dynamic subtest vecs1: SUCCESS (0.538s) [798.245900] Starting dynamic subtest: ccs0 [798.772022] Dynamic subtest ccs0: SUCCESS (0.538s) [798.772962] Subtest busy: SUCCESS (4.345s) [799.019284] Closing watchdogs results: parsing output: 0/ for test: api_intel_allocator results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_chamelium_hpd results: parsing output: 4/ for test: gem_mmap_wc results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: gem_exec_reloc results: parsing output: 7/ for test: kms_psr2_sf results: parsing output: 8/ for test: kms_busy results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_madvise results: parsing output: 11/ for test: kms_pm_dc results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gem_partial_pwrite_pread results: parsing output: 14/ for test: gem_exec_whisper results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_cursor_legacy results: parsing output: 17/ for test: fbdev results: parsing output: 18/ for test: gem_softpin results: parsing output: 19/ for test: gem_create results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_legacy_colorkey results: parsing output: 22/ for test: kms_ccs results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: kms_selftest results: parsing output: 27/ for test: gem_softpin results: parsing output: 28/ for test: gem_exec_params results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: gem_eio results: parsing output: 31/ for test: kms_cursor_crc results: parsing output: 32/ for test: gem_ctx_persistence results: parsing output: 33/ for test: gem_flink_basic results: parsing output: 34/ for test: perf_pmu results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_render_copy results: parsing output: 37/ for test: kms_flip results: parsing output: 38/ for test: gem_exec_balancer results: parsing output: 39/ for test: kms_pm_rpm results: parsing output: 40/ for test: kms_setmode results: parsing output: 41/ for test: api_intel_allocator results: parsing output: 42/ for test: gem_exec_balancer results: parsing output: 43/ for test: gem_ctx_create results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_cursor_legacy results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_flip results: parsing output: 50/ for test: kms_plane_scaling results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_dp_aux_dev results: parsing output: 53/ for test: kms_chamelium_color results: parsing output: 54/ for test: gem_exec_params results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: kms_psr2_sf results: parsing output: 58/ for test: kms_content_protection results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: gem_exec_schedule results: parsing output: 62/ for test: gem_mmap_gtt results: parsing output: 63/ for test: i915_pm_rps results: parsing output: 64/ for test: kms_chamelium_frames results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: perf results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_mmap_wc results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: dumb_buffer results: parsing output: 76/ for test: prime_vgem results: parsing output: 77/ for test: kms_pipe_crc_basic results: parsing output: 78/ for test: gem_workarounds results: parsing output: 79/ for test: prime_busy results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: syncobj_wait results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: gem_exec_schedule results: parsing output: 84/ for test: kms_vrr results: parsing output: 85/ for test: gem_ringfill results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: i915_query results: parsing output: 88/ for test: i915_pm_rpm results: parsing output: 89/ for test: gem_mmap_offset results: parsing output: 90/ for test: gen9_exec_parse results: parsing output: 91/ for test: sysfs_timeslice_duration results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: gem_exec_fence results: parsing output: 95/ for test: api_intel_bb results: parsing output: 96/ for test: syncobj_wait results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: gem_ctx_persistence results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_cursor_crc results: parsing output: 101/ for test: kms_atomic_interruptible results: parsing output: 102/ for test: kms_cursor_crc results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: gem_exec_fence results: parsing output: 105/ for test: perf results: parsing output: 106/ for test: kms_psr results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_pread results: parsing output: 109/ for test: drm_fdinfo results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: kms_cursor_legacy results: parsing output: 112/ for test: gem_huc_copy results: parsing output: 113/ for test: gem_mmap_gtt results: parsing output: 114/ for test: gem_fenced_exec_thrash results: parsing output: 115/ for test: kms_addfb_basic results: parsing output: 116/ for test: gem_cs_tlb results: parsing output: 117/ for test: kms_universal_plane results: parsing output: 118/ for test: syncobj_wait results: parsing output: 119/ for test: kms_invalid_mode results: parsing output: 120/ for test: kms_fbcon_fbt results: parsing output: 121/ for test: kms_hdr results: parsing output: 122/ for test: gem_userptr_blits results: parsing output: 123/ for test: gem_spin_batch results: parsing output: 124/ for test: gem_exec_reloc results: parsing output: 125/ for test: template results: parsing output: 126/ for test: kms_flip_scaled_crc results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_plane_scaling results: parsing output: 129/ for test: gem_wait Done.