[59.348213] Initializing watchdogs
[59.348263]   /dev/watchdog0
[59.363564] [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.368757] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.371013] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.374361] [001/155] (960s left) kms_pipe_crc_basic (read-crc)
[59.487918] Starting subtest: read-crc
[59.490321] Starting dynamic subtest: pipe-A-eDP-1
[60.974898] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.497s)
[60.984281] Starting dynamic subtest: pipe-B-eDP-1
[61.898631] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.935s)
[61.908240] Starting dynamic subtest: pipe-C-eDP-1
[63.270861] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[63.282030] Starting dynamic subtest: pipe-D-eDP-1
[64.580634] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[64.582680] Subtest read-crc: SUCCESS (5.133s)
[65.411908] [002/155] (954s left) kms_setmode (basic)
[65.467605] Starting subtest: basic
[65.834732] Starting dynamic subtest: pipe-A-eDP-1
[69.388492] Dynamic subtest pipe-A-eDP-1: FAIL (3.445s)
[69.605282] Starting dynamic subtest: pipe-B-eDP-1
[73.215116] Dynamic subtest pipe-B-eDP-1: FAIL (3.492s)
[73.394629] Subtest basic: FAIL (7.949s)
[74.278942] [003/155] (945s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[74.394307] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[74.398628] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[74.477132] [004/155] (945s left) gem_exec_whisper (basic-sync-all)
[74.541061] Starting subtest: basic-sync-all
[81.186902] Subtest basic-sync-all: SUCCESS (6.650s)
[81.364791] [005/155] (938s left) core_auth (getclient-simple)
[81.398162] Starting subtest: getclient-simple
[81.422776] Subtest getclient-simple: SUCCESS (0.024s)
[81.548792] [006/155] (938s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[81.660939] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[81.664951] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[81.744641] [007/155] (938s left) gem_flink_basic (double-flink)
[81.808983] Starting subtest: double-flink
[81.811221] Subtest double-flink: SUCCESS (0.000s)
[81.912649] [008/155] (938s left) i915_pm_rpm (system-suspend-devices)
[83.439068] Starting subtest: system-suspend-devices
[91.254529] Subtest system-suspend-devices: SUCCESS (7.814s)
[91.652331] [009/155] (928s left) gem_ctx_persistence (legacy-engines-mixed-process)
[91.716798] Starting subtest: legacy-engines-mixed-process
[91.719058] Starting dynamic subtest: render
[93.333923] Dynamic subtest render: SUCCESS (1.618s)
[93.343989] Starting dynamic subtest: bsd1
[95.301461] Dynamic subtest bsd1: SUCCESS (1.966s)
[95.311499] Starting dynamic subtest: bsd2
[97.310052] Dynamic subtest bsd2: SUCCESS (2.007s)
[97.321763] Starting dynamic subtest: blt
[99.354864] Dynamic subtest blt: SUCCESS (2.044s)
[99.364930] Starting dynamic subtest: vebox
[101.343707] Dynamic subtest vebox: SUCCESS (1.987s)
[101.346129] Subtest legacy-engines-mixed-process: SUCCESS (9.628s)
[101.437966] [010/155] (918s left) gem_spin_batch (user-each)
[101.501066] Starting subtest: user-each
[104.872893] Subtest user-each: SUCCESS (3.371s)
[105.372609] [011/155] (914s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[105.478890] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[105.483122] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[105.586216] [012/155] (914s left) gem_userptr_blits (sd-probe)
[105.647816] Starting subtest: sd-probe
[105.649732] Subtest sd-probe: SUCCESS (0.000s)
[105.776230] [013/155] (914s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render)
[105.873858] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render
[105.878044] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[105.981330] [014/155] (914s left) i915_pciid
[106.128434] [015/155] (914s left) kms_psr (psr-cursor-blt)
[106.231109] Starting subtest: psr-cursor-blt
[106.233556] Starting dynamic subtest: eDP-1
[107.939720] Dynamic subtest eDP-1: SUCCESS (1.710s)
[107.943362] Subtest psr-cursor-blt: SUCCESS (1.711s)
[108.800223] [016/155] (911s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[108.898084] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[108.902677] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[108.988122] [017/155] (911s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc)
[109.086067] Starting subtest: psrhdr-rgb101010-draw-mmap-wc
[109.090688] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[109.173847] [018/155] (911s left) kms_big_fb (linear-8bpp-rotate-90)
[109.289196] Starting subtest: linear-8bpp-rotate-90
[109.310373] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[109.436756] [019/155] (911s left) perf_pmu (render-node-busy-idle)
[109.507866] Starting subtest: render-node-busy-idle
[109.510761] Starting dynamic subtest: rcs0
[110.195834] Dynamic subtest rcs0: SUCCESS (0.688s)
[110.208180] Starting dynamic subtest: bcs0
[110.862765] Dynamic subtest bcs0: SUCCESS (0.666s)
[110.874877] Starting dynamic subtest: vcs0
[112.325255] Dynamic subtest vcs0: SUCCESS (1.460s)
[112.338604] Starting dynamic subtest: vcs1
[114.309601] Dynamic subtest vcs1: SUCCESS (1.983s)
[114.322712] Starting dynamic subtest: vecs0
[116.293802] Dynamic subtest vecs0: SUCCESS (1.983s)
[116.306449] Starting dynamic subtest: ccs0
[116.959745] Dynamic subtest ccs0: SUCCESS (0.666s)
[116.962935] Subtest render-node-busy-idle: SUCCESS (7.451s)
[117.036342] [020/155] (903s left) gem_exec_reloc (basic-gtt)
[117.095799] Subtest basic-gtt: SKIP (0.000s)
[117.181208] [021/155] (903s left) gen7_exec_parse (batch-without-end)
[117.248404] Subtest batch-without-end: SKIP (0.000s)
[117.321819] [022/155] (903s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[117.419394] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[117.424115] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[117.495636] [023/155] (903s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[117.602418] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[117.604715] Starting dynamic subtest: pipe-A-eDP-1
[117.694610] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[117.704814] Starting dynamic subtest: pipe-B-eDP-1
[118.886810] Dynamic subtest pipe-B-eDP-1: SKIP (1.188s)
[118.891070] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.286s)
[120.170578] [024/155] (900s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-blt)
[120.269372] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-blt
[120.274113] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[120.379895] [025/155] (900s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[120.489899] Starting subtest: psr-farfromfence-mmap-gtt
[120.494441] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[120.577481] [026/155] (900s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[120.641105] Starting subtest: multi-wait-for-submit-submitted-signaled
[120.643407] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[120.748190] [027/155] (900s left) gem_exec_reloc (basic-write-cpu-active)
[120.809714] Subtest basic-write-cpu-active: SKIP (0.000s)
[120.884773] [028/155] (900s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt)
[120.986195] Starting subtest: fbchdr-rgb101010-draw-blt
[120.990574] Subtest fbchdr-rgb101010-draw-blt: SKIP (0.000s)
[121.074883] [029/155] (899s left) gem_exec_params (cliprects_ptr-dirt)
[121.130464] Starting subtest: cliprects_ptr-dirt
[121.132078] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[121.227754] [030/155] (899s left) kms_psr (fbc-psr-sprite-plane-move)
[121.327568] Starting subtest: fbc-psr-sprite-plane-move
[121.329574] Starting dynamic subtest: eDP-1
[121.333239] Dynamic subtest eDP-1: SKIP (0.000s)
[121.336838] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[121.400504] [031/155] (899s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[121.500943] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[121.502822] Starting dynamic subtest: pipe-A-eDP-1
[121.622132] Dynamic subtest pipe-A-eDP-1: SKIP (0.123s)
[121.633487] Starting dynamic subtest: pipe-B-eDP-1
[122.843316] Dynamic subtest pipe-B-eDP-1: SKIP (1.219s)
[122.848153] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.344s)
[124.129852] [032/155] (897s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[124.222379] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[125.323246] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.101s)
[125.449170] [033/155] (895s left) gem_exec_schedule (out-order)
[125.525191] Starting subtest: out-order
[125.527105] Starting dynamic subtest: rcs0
[125.625770] Dynamic subtest rcs0: SUCCESS (0.108s)
[125.638490] Starting dynamic subtest: vcs0
[125.709051] Dynamic subtest vcs0: SUCCESS (0.083s)
[125.720586] Starting dynamic subtest: vcs1
[125.788287] Dynamic subtest vcs1: SUCCESS (0.079s)
[125.804058] Starting dynamic subtest: vecs0
[125.867048] Dynamic subtest vecs0: SUCCESS (0.078s)
[125.879967] Starting dynamic subtest: ccs0
[125.963630] Dynamic subtest ccs0: SUCCESS (0.095s)
[125.966094] Subtest out-order: SUCCESS (0.446s)
[127.395852] [034/155] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[127.500488] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[134.369027] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.873s)
[134.529621] [035/155] (886s left) gem_userptr_blits (stress-mm)
[134.594084] Starting subtest: stress-mm
[140.015306] Subtest stress-mm: SUCCESS (5.369s)
[140.077937] [036/155] (881s left) kms_vblank (query-idle-hang)
[140.175423] Starting subtest: query-idle-hang
[140.177793] Starting dynamic subtest: pipe-A-eDP-1
[167.046258] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.870s)
[167.062763] Starting dynamic subtest: pipe-D-eDP-1
[182.102902] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.052s)
[182.105193] Subtest query-idle-hang: SUCCESS (41.927s)
[182.933232] [037/155] (838s left) gem_exec_reloc (basic-wc-read-active)
[182.994066] Subtest basic-wc-read-active: SKIP (0.000s)
[183.051458] [038/155] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[183.150904] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[183.155167] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[183.248947] [039/155] (838s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[183.349207] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[183.351328] Starting dynamic subtest: pipe-A-eDP-1
[183.373533] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[183.384595] Starting dynamic subtest: pipe-B-eDP-1
[183.405170] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[183.414985] Starting dynamic subtest: pipe-C-eDP-1
[183.435713] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[183.445164] Starting dynamic subtest: pipe-D-eDP-1
[183.466044] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[183.469820] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[185.676335] [040/155] (835s left) kms_frontbuffer_tracking (psrhdr-2p-pri-indfb-multidraw)
[185.784733] Starting subtest: psrhdr-2p-pri-indfb-multidraw
[185.789273] Subtest psrhdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[185.878259] [041/155] (835s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[185.929540] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[185.933705] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[186.111302] [042/155] (835s left) gem_tiled_fence_blits (basic)
[186.166293] Subtest basic: SKIP (0.000s)
[186.238046] [043/155] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[186.339128] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[186.343312] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[186.435425] [044/155] (835s left) vgem_basic (bad-pad)
[186.529702] Starting subtest: bad-pad
[186.532078] Subtest bad-pad: SUCCESS (0.000s)
[186.589717] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[186.593684] [045/155] (835s left) kms_vblank (query-forked-hang)
[186.691927] Starting subtest: query-forked-hang
[186.694079] Starting dynamic subtest: pipe-A-eDP-1
[213.129695] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.437s)
[213.145230] Starting dynamic subtest: pipe-D-eDP-1
[228.057486] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.925s)
[228.059751] Subtest query-forked-hang: SUCCESS (41.365s)
[228.941187] [046/155] (792s left) kms_psr (psr2-cursor-plane-onoff)
[229.053105] Starting subtest: psr2-cursor-plane-onoff
[229.055307] Starting dynamic subtest: eDP-1
[230.825763] Dynamic subtest eDP-1: SUCCESS (1.773s)
[230.828061] Subtest psr2-cursor-plane-onoff: SUCCESS (1.774s)
[231.709904] [047/155] (790s left) kms_pm_rpm (system-suspend-modeset)
[233.447824] Starting subtest: system-suspend-modeset
[253.466993] Subtest system-suspend-modeset: SUCCESS (4.622s)
[253.849777] [048/155] (767s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[253.970322] Starting subtest: yf-tiled-64bpp-rotate-270
[253.974520] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[254.067489] [049/155] (767s left) gem_exec_params (rel-constants-invalid-ring)
[254.120692] Starting subtest: rel-constants-invalid-ring
[254.123024] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[254.238163] [050/155] (767s left) i915_query (query-regions-sanity-check)
[254.283567] Starting subtest: query-regions-sanity-check
[254.291969] Subtest query-regions-sanity-check: SUCCESS (0.010s)
[254.397547] [051/155] (767s left) gem_mmap_gtt (fault-concurrent-y)
[254.445224] Subtest fault-concurrent-Y: SKIP (0.000s)
[254.505070] [052/155] (767s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[254.605588] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[254.610029] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[254.692917] [053/155] (767s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[254.819739] Starting subtest: cursorB-vs-flipB-legacy
[254.823408] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[254.962866] [054/155] (767s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[255.049578] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[255.051510] Starting dynamic subtest: pipe-A-default-mode
[257.771398] Dynamic subtest pipe-A-default-mode: SUCCESS (2.763s)
[257.773347] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.764s)
[258.582596] [055/155] (763s left) gem_exec_params (secure-non-root)
[258.640276] Starting subtest: secure-non-root
[258.644719] Subtest secure-non-root: SKIP (0.000s)
[258.740418] [056/155] (763s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[258.847773] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[258.851759] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[258.982921] [057/155] (763s left) gem_exec_gttfill (all-engines)
[259.036418] Starting subtest: all-engines
[283.748229] Subtest all-engines: SUCCESS (24.797s)
[283.941346] [058/155] (738s left) gem_exec_schedule (u-fairslice-all)
[284.067384] Starting subtest: u-fairslice-all
[286.189633] Subtest u-fairslice-all: SUCCESS (2.085s)
[287.806641] [059/155] (734s left) gem_render_copy_redux (interruptible)
[287.860568] Starting subtest: interruptible
[288.238097] Subtest interruptible: SUCCESS (0.377s)
[288.382287] [060/155] (733s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[288.443326] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[288.447912] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[288.645756] [061/155] (733s left) perf_pmu (busy-double-start)
[288.689287] Starting subtest: busy-double-start
[288.691280] Starting dynamic subtest: rcs0
[292.333277] Dynamic subtest rcs0: FAIL (3.590s)
[292.345225] Starting dynamic subtest: bcs0
[295.851805] Dynamic subtest bcs0: SUCCESS (3.572s)
[295.865038] Starting dynamic subtest: vcs0
[300.257011] Dynamic subtest vcs0: SUCCESS (4.403s)
[300.269756] Starting dynamic subtest: vcs1
[304.312223] Dynamic subtest vcs1: SUCCESS (4.053s)
[304.323872] Starting dynamic subtest: vecs0
[308.286197] Dynamic subtest vecs0: SUCCESS (3.973s)
[308.299812] Starting dynamic subtest: ccs0
[311.925525] Dynamic subtest ccs0: FAIL (3.568s)
[311.927536] Subtest busy-double-start: FAIL (23.167s)
[311.970103] [062/155] (710s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[312.074793] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[312.079200] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[312.188989] [063/155] (710s left) gem_mmap_wc (write-read)
[312.241532] Subtest write-read: SKIP (0.000s)
[312.298042] [064/155] (710s left) gem_exec_params (batch-first)
[312.363597] Starting subtest: batch-first
[312.369623] Subtest batch-first: SUCCESS (0.006s)
[312.500300] [065/155] (710s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt)
[312.602735] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt
[312.607165] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[312.698377] [066/155] (709s left) core_setmaster (master-drop-set-shared-fd)
[312.793316] Starting subtest: master-drop-set-shared-fd
[312.812192] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[312.850769] [067/155] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[312.958654] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[312.962172] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[313.055525] [068/155] (709s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[313.145049] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[313.146914] Starting dynamic subtest: pipe-A-eDP-1
[313.166150] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[313.178467] Starting dynamic subtest: pipe-B-eDP-1
[313.196705] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[313.206765] Starting dynamic subtest: pipe-C-eDP-1
[313.224435] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[313.233581] Starting dynamic subtest: pipe-D-eDP-1
[313.251716] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[313.255299] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[315.434822] [069/155] (707s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[315.543363] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[316.688176] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.146s)
[316.824559] [070/155] (705s left) gem_exec_parallel (basic)
[316.886522] Starting subtest: basic
[316.888391] Starting dynamic subtest: rcs0
[318.327022] Dynamic subtest rcs0: SUCCESS (1.442s)
[318.338637] Starting dynamic subtest: bcs0
[319.815002] Dynamic subtest bcs0: SUCCESS (1.487s)
[319.831413] Starting dynamic subtest: vcs0
[321.763132] Dynamic subtest vcs0: SUCCESS (1.946s)
[321.776308] Starting dynamic subtest: vcs1
[323.747596] Dynamic subtest vcs1: SUCCESS (1.983s)
[323.760622] Starting dynamic subtest: vecs0
[325.731158] Dynamic subtest vecs0: SUCCESS (1.982s)
[325.745015] Starting dynamic subtest: ccs0
[327.224139] Dynamic subtest ccs0: SUCCESS (1.493s)
[327.226690] Subtest basic: SUCCESS (10.344s)
[327.426290] [071/155] (695s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[327.521532] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[327.525588] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[327.630432] [072/155] (695s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render)
[327.728555] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render
[327.732728] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[327.834938] [073/155] (695s left) gem_exec_fence (syncobj-timeline-repeat)
[328.429988] Starting subtest: syncobj-timeline-repeat
[328.676763] Subtest syncobj-timeline-repeat: SUCCESS (0.247s)
[329.841639] [074/155] (693s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[329.891159] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[329.893333] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[329.990833] [075/155] (692s left) kms_cursor_crc (cursor-onscreen-32x32)
[330.142120] Starting subtest: cursor-onscreen-32x32
[330.193556] Subtest cursor-onscreen-32x32: SKIP (0.046s)
[330.469188] [076/155] (692s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[330.513675] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[330.569276] [077/155] (692s left) gem_softpin (overlap)
[330.627417] Starting subtest: overlap
[331.533196] Subtest overlap: SUCCESS (0.905s)
[331.685434] [078/155] (691s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[331.795499] Starting subtest: y-tiled-64bpp-rotate-180
[331.799545] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[331.902967] [079/155] (691s left) gem_busy (parallel)
[332.083565] Starting subtest: parallel
[332.085932] Starting dynamic subtest: rcs0
[333.732316] Dynamic subtest rcs0: SUCCESS (1.647s)
[333.747599] Starting dynamic subtest: bcs0
[335.780515] Dynamic subtest bcs0: SUCCESS (2.047s)
[335.794472] Starting dynamic subtest: vcs0
[337.764309] Dynamic subtest vcs0: SUCCESS (1.981s)
[337.777782] Starting dynamic subtest: vcs1
[339.747982] Dynamic subtest vcs1: SUCCESS (1.982s)
[339.762044] Starting dynamic subtest: vecs0
[341.732021] Dynamic subtest vecs0: SUCCESS (1.983s)
[341.746270] Starting dynamic subtest: ccs0
[343.834287] Dynamic subtest ccs0: SUCCESS (2.046s)
[343.837272] Subtest parallel: SUCCESS (11.700s)
[344.016807] [080/155] (679s left) syncobj_timeline (wait-all-snapshot)
[344.065990] Starting subtest: wait-all-snapshot
[344.146878] Subtest wait-all-snapshot: SUCCESS (0.082s)
[344.231729] [081/155] (679s left) kms_chamelium_edid (dp-mode-timings)
[344.616786] Subtest dp-mode-timings: SKIP (0.000s)
[345.432140] [082/155] (677s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[345.527835] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[345.531822] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[345.631362] [083/155] (677s left) gem_exec_balancer (persistence)
[345.902584] Starting subtest: persistence
[346.851703] Subtest persistence: SUCCESS (0.950s)
[346.963467] [084/155] (676s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[347.019462] Starting subtest: invalid-signal-one-illegal-handle
[347.021793] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[347.128877] [085/155] (676s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[347.229129] Starting subtest: fbc-shrfb-scaledprimary
[350.154508] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.932s)
[351.350342] [086/155] (672s left) kms_chamelium_hpd (dp-hpd-storm)
[351.736418] Subtest dp-hpd-storm: SKIP (0.000s)
[352.550326] [087/155] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[352.653007] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[352.657041] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[352.745863] [088/155] (670s left) kms_psr (psr-primary-render)
[352.831837] Starting subtest: psr-primary-render
[352.834045] Starting dynamic subtest: eDP-1
[354.570005] Dynamic subtest eDP-1: SUCCESS (1.738s)
[354.572470] Subtest psr-primary-render: SUCCESS (1.739s)
[355.438520] [089/155] (668s left) kms_addfb_basic (master-rmfb)
[355.493684] Starting subtest: master-rmfb
[355.495939] Subtest master-rmfb: SUCCESS (0.001s)
[355.626051] [090/155] (667s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[355.715713] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[355.719792] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[355.830309] [091/155] (667s left) kms_joiner (basic-ultra-joiner)
[355.927548] Starting subtest: basic-ultra-joiner
[355.931854] Subtest basic-ultra-joiner: SKIP (0.000s)
[356.003187] [092/155] (667s left) kms_feature_discovery (dp-mst)
[356.098715] Starting subtest: dp-mst
[356.103070] Subtest dp-mst: SKIP (0.000s)
[356.176896] [093/155] (667s left) gem_exec_schedule (smoketest-all)
[356.250229] Starting subtest: smoketest-all
[388.622571] Subtest smoketest-all: SUCCESS (32.325s)
[389.782414] [094/155] (634s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[389.892318] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[389.896398] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[389.995925] [095/155] (633s left) kms_dp_linktrain_fallback (dsc-fallback)
[390.089856] Starting subtest: dsc-fallback
[390.096193] Subtest dsc-fallback: SKIP (0.000s)
[390.164402] [096/155] (633s left) gem_ctx_sseu (engines)
[390.224918] Subtest engines: SKIP (0.000s)
[390.288075] [097/155] (633s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[390.383970] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[390.386117] Starting dynamic subtest: pipe-A-eDP-1
[390.699549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[390.712902] Starting dynamic subtest: pipe-B-eDP-1
[392.047146] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.347s)
[392.060645] Starting dynamic subtest: pipe-C-eDP-1
[393.339807] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.293s)
[393.351231] Starting dynamic subtest: pipe-D-eDP-1
[394.562700] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[394.565113] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.149s)
[395.772308] [098/155] (628s left) kms_cursor_edge_walk (64x64-left-edge)
[395.871207] Starting subtest: 64x64-left-edge
[395.873518] Starting dynamic subtest: pipe-A-eDP-1
[399.357249] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s)
[399.368905] Starting dynamic subtest: pipe-D-eDP-1
[402.561265] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.203s)
[402.563479] Subtest 64x64-left-edge: SUCCESS (6.691s)
[403.394084] [099/155] (620s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[404.930792] Starting subtest: dpms-mode-unset-lpsp
[409.026986] Subtest dpms-mode-unset-lpsp: SUCCESS (4.099s)
[409.429552] [100/155] (614s left) api_intel_allocator (gem-pool)
[409.483012] Starting subtest: gem-pool
[409.491372] Subtest gem-pool: SUCCESS (0.010s)
[409.625939] [101/155] (614s left) i915_query (query-garbage)
[409.671767] Starting subtest: query-garbage
[409.674003] Subtest query-garbage: SUCCESS (0.000s)
[409.796542] [102/155] (614s left) syncobj_basic (bad-pad-handle-to-fd)
[409.848558] Starting subtest: bad-pad-handle-to-fd
[409.850745] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[409.938574] [103/155] (614s left) kms_content_protection (dp-mst-lic-type-1)
[410.090003] Starting subtest: dp-mst-lic-type-1
[410.094327] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[410.235082] [104/155] (613s left) kms_atomic_interruptible (legacy-dpms)
[410.326138] Starting subtest: legacy-dpms
[410.328339] Starting dynamic subtest: pipe-A-eDP-1
[417.756260] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.429s)
[417.758648] Subtest legacy-dpms: SUCCESS (7.430s)
[418.587715] [105/155] (605s left) gem_mmap_offset (bad-object)
[418.649558] Starting subtest: bad-object
[418.651505] Subtest bad-object: SUCCESS (0.001s)
[418.747232] [106/155] (605s left) syncobj_wait (single-wait-all-for-submit-signaled)
[418.809018] Starting subtest: single-wait-all-for-submit-signaled
[418.811267] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[418.902409] [107/155] (605s left) prime_mmap (test_userptr)
[418.954411] Starting subtest: test_userptr
[418.956541] Starting dynamic subtest: test_userptr-smem
[418.958745] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[418.960902] Subtest test_userptr: SUCCESS (0.001s)
[419.062962] [108/155] (605s left) gem_mmap_gtt (coherency)
[419.120532] Subtest coherency: SKIP (0.000s)
[419.189185] [109/155] (605s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[419.279281] Starting subtest: bad-aux-stride-yf-tiled-ccs
[419.281776] Starting dynamic subtest: pipe-A-eDP-1
[419.305286] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[419.320003] Starting dynamic subtest: pipe-B-eDP-1
[419.341821] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[419.352712] Starting dynamic subtest: pipe-C-eDP-1
[419.374644] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[419.390109] Starting dynamic subtest: pipe-D-eDP-1
[419.412397] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[419.416557] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[421.553815] [110/155] (602s left) gem_ppgtt (flink-and-close-vma-leak)
[421.604239] Starting subtest: flink-and-close-vma-leak
[421.646971] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[421.789174] [111/155] (602s left) gem_exec_balancer (hog)
[421.847160] Starting subtest: hog
[421.851524] Subtest hog: SKIP (0.000s)
[422.165158] [112/155] (602s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[422.288003] Starting subtest: cursorA-vs-flipB-varying-size
[422.292299] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[422.435967] [113/155] (602s left) syncobj_wait (reset-multiple-signaled)
[422.498013] Starting subtest: reset-multiple-signaled
[422.499955] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[422.619492] [114/155] (602s left) kms_atomic_transition (plane-all-transition)
[422.713226] Starting subtest: plane-all-transition
[422.715590] Starting dynamic subtest: pipe-A-eDP-1
[425.207484] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[425.515180] Starting dynamic subtest: pipe-B-eDP-1
[428.784474] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.280s)
[429.086019] Subtest plane-all-transition: SUCCESS (6.375s)
[429.925709] [115/155] (594s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[430.020598] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[430.046189] Starting dynamic subtest: pipe-A-plane-0
[430.323686] Dynamic subtest pipe-A-plane-0: SUCCESS (0.277s)
[430.334659] Starting dynamic subtest: pipe-A-plane-3
[430.534527] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[430.545786] Starting dynamic subtest: pipe-A-plane-5
[430.550500] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[431.605172] Starting dynamic subtest: pipe-B-plane-0
[431.884416] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[431.895769] Starting dynamic subtest: pipe-B-plane-3
[432.095838] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[432.107466] Starting dynamic subtest: pipe-B-plane-5
[432.112092] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[432.410257] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.393s)
[433.284436] [116/155] (591s left) kms_flip (2x-flip-vs-modeset)
[433.379184] Starting subtest: 2x-flip-vs-modeset
[433.388380] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[433.494169] [117/155] (591s left) gem_exec_whisper (basic-normal-all)
[433.558408] Starting subtest: basic-normal-all
[435.822648] Subtest basic-normal-all: SUCCESS (2.262s)
[436.016064] [118/155] (588s left) kms_color (invalid-gamma-lut-sizes)
[436.118809] Starting subtest: invalid-gamma-lut-sizes
[436.121005] Starting dynamic subtest: pipe-A
[436.405880] Dynamic subtest pipe-A: SUCCESS (0.287s)
[436.417728] Starting dynamic subtest: pipe-B
[436.420227] Dynamic subtest pipe-B: SUCCESS (0.000s)
[436.439985] Starting dynamic subtest: pipe-C
[436.442677] Dynamic subtest pipe-C: SUCCESS (0.000s)
[436.453074] Starting dynamic subtest: pipe-D
[436.455019] Dynamic subtest pipe-D: SUCCESS (0.000s)
[436.456969] Subtest invalid-gamma-lut-sizes: SUCCESS (0.291s)
[437.217271] [119/155] (587s left) gem_create (create-ext-placement-each)
[437.379678] Starting subtest: create-ext-placement-each
[437.381973] Subtest create-ext-placement-each: SUCCESS (0.000s)
[437.478460] [120/155] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[437.573271] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[437.577771] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[437.682579] [121/155] (587s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[437.790096] Starting subtest: fbchdr-2p-rte
[437.794468] Subtest fbchdr-2p-rte: SKIP (0.000s)
[437.895138] [122/155] (587s left) gem_ctx_isolation (clean)
[437.957516] Starting subtest: clean
[437.959766] Starting dynamic subtest: rcs0
[438.007625] Dynamic subtest rcs0: SUCCESS (0.050s)
[438.021183] Starting dynamic subtest: bcs0
[438.084922] Dynamic subtest bcs0: SUCCESS (0.076s)
[438.098672] Starting dynamic subtest: vcs0
[438.156211] Dynamic subtest vcs0: SUCCESS (0.070s)
[438.168841] Starting dynamic subtest: vcs1
[439.796964] Dynamic subtest vcs1: SUCCESS (1.640s)
[439.807795] Starting dynamic subtest: vecs0
[441.764387] Dynamic subtest vecs0: SUCCESS (1.966s)
[441.777122] Starting dynamic subtest: ccs0
[443.774283] Dynamic subtest ccs0: SUCCESS (2.009s)
[443.777083] Subtest clean: SUCCESS (5.818s)
[444.015502] [123/155] (581s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[444.108894] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[444.120850] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[444.210634] [124/155] (580s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[444.298094] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[444.323606] Starting dynamic subtest: pipe-A-plane-0
[444.624530] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[444.636752] Starting dynamic subtest: pipe-A-plane-3
[444.856656] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[444.867302] Starting dynamic subtest: pipe-A-plane-5
[444.872104] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[446.010211] Starting dynamic subtest: pipe-B-plane-0
[446.300641] Dynamic subtest pipe-B-plane-0: SUCCESS (0.299s)
[446.315867] Starting dynamic subtest: pipe-B-plane-3
[446.535477] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[446.546656] Starting dynamic subtest: pipe-B-plane-5
[446.551086] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[446.848003] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.551s)
[447.689653] [125/155] (577s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt)
[447.787744] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt
[447.792123] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[447.898615] [126/155] (577s left) kms_big_fb (4-tiled-addfb-size-overflow)
[448.002529] Starting subtest: 4-tiled-addfb-size-overflow
[448.004752] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[448.103233] [127/155] (577s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[448.205044] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[448.209172] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[448.300368] [128/155] (576s left) kms_pm_backlight (fade-with-suspend)
[448.392113] Starting subtest: fade-with-suspend
[464.915438] Starting dynamic subtest: eDP-1
[467.940344] Dynamic subtest eDP-1: SUCCESS (3.094s)
[467.942724] Subtest fade-with-suspend: SUCCESS (4.996s)
[468.768627] [129/155] (556s left) syncobj_eventfd (binary-wait)
[468.830588] Starting subtest: binary-wait
[468.839333] Subtest binary-wait: SUCCESS (0.011s)
[468.918076] [130/155] (556s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[469.024527] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[469.028411] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[469.113559] [131/155] (556s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[469.202744] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[469.206567] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[469.307817] [132/155] (556s left) i915_drm_fdinfo (all-busy-idle-check-all)
[469.350419] Starting subtest: all-busy-idle-check-all
[469.358487] Subtest all-busy-idle-check-all: SKIP (0.004s)
[469.425952] [133/155] (556s left) perf_pmu (all-busy-idle-check-all)
[469.466649] Starting subtest: all-busy-idle-check-all
[470.160488] Subtest all-busy-idle-check-all: FAIL (0.634s)
[471.430242] [134/155] (554s left) kms_psr (fbc-pr-cursor-blt)
[471.530372] Starting subtest: fbc-pr-cursor-blt
[471.534561] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[471.612743] [135/155] (553s left) kms_getfb (getfb2-handle-closed)
[471.706426] Starting subtest: getfb2-handle-closed
[471.708587] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[471.820498] [136/155] (553s left) kms_flip (wf_vblank-ts-check)
[471.909473] Starting subtest: wf_vblank-ts-check
[471.911755] Starting dynamic subtest: A-eDP1
[492.633009] Dynamic subtest A-eDP1: SUCCESS (20.786s)
[492.646663] Starting dynamic subtest: B-eDP1
[501.560777] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[501.574089] Starting dynamic subtest: C-eDP1
[510.494027] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[510.508871] Starting dynamic subtest: D-eDP1
[519.375922] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[519.378400] Subtest wf_vblank-ts-check: SUCCESS (47.565s)
[520.608581] [137/155] (505s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[520.718343] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[520.723011] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[521.855131] [138/155] (503s left) gem_exec_flush (basic-batch-kernel-default-wb)
[521.914182] Starting subtest: basic-batch-kernel-default-wb
[529.071663] Subtest basic-batch-kernel-default-wb: SUCCESS (7.160s)
[529.275715] [139/155] (496s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[529.385957] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[529.390088] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[529.485285] [140/155] (496s left) kms_lease (lease-revoke)
[529.580306] Starting subtest: lease-revoke
[529.582678] Starting dynamic subtest: pipe-A-eDP-1
[529.613586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[529.626088] Starting dynamic subtest: pipe-B-eDP-1
[529.644090] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[529.661058] Starting dynamic subtest: pipe-C-eDP-1
[529.670155] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[529.683401] Starting dynamic subtest: pipe-D-eDP-1
[529.697586] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[529.699981] Subtest lease-revoke: SUCCESS (0.119s)
[529.842266] [141/155] (496s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[529.905180] Starting subtest: invalid-multi-wait-unsubmitted
[529.907095] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[530.022448] [142/155] (495s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[530.115141] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[530.119530] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[530.237732] [143/155] (495s left) gem_mmap_wc (bad-offset)
[530.294101] Subtest bad-offset: SKIP (0.000s)
[530.359592] [144/155] (495s left) kms_async_flips (test-time-stamp)
[530.447346] Starting subtest: test-time-stamp
[530.826001] Starting dynamic subtest: pipe-A-eDP-1
[531.633063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[532.008423] Starting dynamic subtest: pipe-B-eDP-1
[532.767331] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[533.152119] Starting dynamic subtest: pipe-C-eDP-1
[533.987174] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.842s)
[534.357097] Starting dynamic subtest: pipe-D-eDP-1
[535.128364] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[535.130795] Subtest test-time-stamp: SUCCESS (4.681s)
[536.328473] [145/155] (489s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[536.420370] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[536.422679] Starting dynamic subtest: pipe-A-eDP-1
[536.446411] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[536.460021] Starting dynamic subtest: pipe-B-eDP-1
[536.481815] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[536.493355] Starting dynamic subtest: pipe-C-eDP-1
[536.515243] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[536.526196] Starting dynamic subtest: pipe-D-eDP-1
[536.548416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[536.552421] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[538.682668] [146/155] (487s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[538.793833] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[546.168604] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.382s)
[546.306736] [147/155] (479s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[546.411451] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[546.415430] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[546.511794] [148/155] (479s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[546.600625] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[546.603003] Starting dynamic subtest: pipe-A
[547.758829] Dynamic subtest pipe-A: SUCCESS (1.161s)
[547.770034] Starting dynamic subtest: pipe-B
[549.969184] Dynamic subtest pipe-B: SUCCESS (2.210s)
[549.980511] Starting dynamic subtest: pipe-C
[551.134203] Dynamic subtest pipe-C: SUCCESS (1.164s)
[551.146892] Starting dynamic subtest: pipe-D
[552.362118] Dynamic subtest pipe-D: SUCCESS (1.226s)
[552.364702] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.767s)
[553.562092] [149/155] (472s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[553.666099] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[553.670184] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[553.773982] [150/155] (472s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[553.820053] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[553.929382] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[554.007564] [151/155] (472s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[554.312904] Starting subtest: cursor-rapid-movement-max-size
[554.319569] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[554.446711] [152/155] (471s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[554.546129] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[554.550507] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[554.645017] [153/155] (471s left) kms_psr (fbc-pr-sprite-plane-move)
[554.735514] Starting subtest: fbc-pr-sprite-plane-move
[554.739916] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[554.826146] [154/155] (471s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)
[554.922959] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff
[554.927254] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[555.031191] [155/155] (471s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[555.121644] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[555.125102] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[555.230204] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_crc_basic
results: parsing output: 1/ for test: kms_setmode
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_whisper
results: parsing output: 4/ for test: core_auth
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_flink_basic
results: parsing output: 7/ for test: i915_pm_rpm
results: parsing output: 8/ for test: gem_ctx_persistence
results: parsing output: 9/ for test: gem_spin_batch
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: i915_pciid
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: gen7_exec_parse
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: gem_tiled_fence_blits
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: vgem_basic
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_exec_params
results: parsing output: 49/ for test: i915_query
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_gttfill
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: gem_render_copy_redux
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_mmap_wc
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: core_setmaster
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_exec_parallel
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_fence
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_pipe_b_c_ivb
results: parsing output: 76/ for test: gem_softpin
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_busy
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_chamelium_edid
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_chamelium_hpd
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_joiner
results: parsing output: 91/ for test: kms_feature_discovery
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_dp_linktrain_fallback
results: parsing output: 95/ for test: gem_ctx_sseu
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_cursor_edge_walk
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: i915_query
results: parsing output: 101/ for test: syncobj_basic
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: kms_atomic_interruptible
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: prime_mmap
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_ppgtt
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_atomic_transition
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: gem_create
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_ctx_isolation
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_pm_backlight
results: parsing output: 128/ for test: syncobj_eventfd
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_drm_fdinfo
results: parsing output: 132/ for test: perf_pmu
results: parsing output: 133/ for test: kms_psr
results: parsing output: 134/ for test: kms_getfb
results: parsing output: 135/ for test: kms_flip
results: parsing output: 136/ for test: kms_ccs
results: parsing output: 137/ for test: gem_exec_flush
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_lease
results: parsing output: 140/ for test: syncobj_timeline
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: gem_mmap_wc
results: parsing output: 143/ for test: kms_async_flips
results: parsing output: 144/ for test: kms_ccs
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_plane_scaling
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: syncobj_timeline
results: parsing output: 150/ for test: kms_cursor_crc
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_psr
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.