[60.626525] Initializing watchdogs
[60.626569]   /dev/watchdog0
[60.640397] [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]
[60.644657] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.646834] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.650426] [001/133] (960s left) gem_eio (reset-stress)
[60.809741] Starting subtest: reset-stress
[60.811708] Starting dynamic subtest: render
[64.452710] Dynamic subtest render: SUCCESS (3.659s)
[64.465446] Starting dynamic subtest: bsd1
[82.231814] Dynamic subtest bsd1: SUCCESS (17.801s)
[82.245998] Starting dynamic subtest: bsd2
[100.287839] Dynamic subtest bsd2: SUCCESS (18.053s)
[100.301760] Starting dynamic subtest: blt
[100.305707] Dynamic subtest blt: SKIP (0.000s)
[100.312746] Starting dynamic subtest: vebox
[118.309060] Dynamic subtest vebox: SUCCESS (18.020s)
[118.311196] Subtest reset-stress: SUCCESS (57.536s)
[119.939969] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true
[119.943330] [002/133] (901s left) gem_exec_whisper (basic-queues-forked-all)
[120.007071] Starting subtest: basic-queues-forked-all
[142.157046] Subtest basic-queues-forked-all: SUCCESS (22.147s)
[142.364092] [003/133] (878s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[142.467959] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[142.472512] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[142.561445] [004/133] (878s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[142.661395] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[142.663623] Starting dynamic subtest: pipe-A-eDP-1
[175.067052] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.023s)
[175.075339] Starting dynamic subtest: pipe-B-eDP-1
[208.003438] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.630s)
[208.012998] Starting dynamic subtest: pipe-C-eDP-1
[241.023838] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.678s)
[241.033214] Starting dynamic subtest: pipe-D-eDP-1
[274.040991] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.662s)
[274.043418] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.998s)
[275.221446] [005/133] (746s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[275.321362] Starting subtest: psr-shrfb-scaledprimary
[280.949417] Subtest psr-shrfb-scaledprimary: SUCCESS (5.781s)
[281.101852] [006/133] (740s left) kms_psr (psr-sprite-plane-move)
[281.198314] Starting subtest: psr-sprite-plane-move
[281.200568] Starting dynamic subtest: eDP-1
[282.997568] Dynamic subtest eDP-1: SUCCESS (1.827s)
[282.999753] Subtest psr-sprite-plane-move: SUCCESS (1.828s)
[283.818014] [007/133] (737s left) api_intel_bb (blit-noreloc-keep-cache)
[283.866521] Starting subtest: blit-noreloc-keep-cache
[283.874030] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[284.017522] [008/133] (737s left) kms_flip (modeset-vs-vblank-race)
[284.120765] Starting subtest: modeset-vs-vblank-race
[284.123024] Starting dynamic subtest: A-eDP1
[288.757188] Dynamic subtest A-eDP1: SUCCESS (4.677s)
[288.768113] Starting dynamic subtest: B-eDP1
[293.450758] Dynamic subtest B-eDP1: SUCCESS (4.716s)
[293.460151] Starting dynamic subtest: C-eDP1
[298.140404] Dynamic subtest C-eDP1: SUCCESS (4.701s)
[298.154481] Starting dynamic subtest: D-eDP1
[302.773929] Dynamic subtest D-eDP1: SUCCESS (4.640s)
[302.776107] Subtest modeset-vs-vblank-race: SUCCESS (18.744s)
[303.955850] [009/133] (717s left) kms_pm_rpm (basic-pci-d3-state)
[305.879283] Starting subtest: basic-pci-d3-state
[307.354621] Subtest basic-pci-d3-state: SUCCESS (1.478s)
[307.463926] [010/133] (714s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[307.524571] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[307.527024] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[307.657265] [011/133] (713s left) gem_mmap_wc (write-prefaulted)
[307.719503] Subtest write-prefaulted: SKIP (0.000s)
[307.787597] [012/133] (713s left) i915_pm_rpm (system-suspend)
[309.922224] Starting subtest: system-suspend
[328.682945] Subtest system-suspend: SUCCESS (2.883s)
[329.084096] [013/133] (692s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[329.193277] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[329.195909] Starting dynamic subtest: pipe-A-eDP-1
[329.221282] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[329.234645] Starting dynamic subtest: pipe-B-eDP-1
[329.258603] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[329.267177] Starting dynamic subtest: pipe-C-eDP-1
[329.290432] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[329.298540] Starting dynamic subtest: pipe-D-eDP-1
[329.323568] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[329.328242] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[331.436133] [014/133] (690s left) gem_pxp (hw-rejects-pxp-context)
[331.562063] Starting subtest: hw-rejects-pxp-context
[331.567108] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[331.710288] [015/133] (690s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[331.816209] Starting subtest: fbc-rgb101010-draw-mmap-wc
[336.320813] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.610s)
[337.432903] [016/133] (684s left) gem_tiled_pread_pwrite
[337.569041] [017/133] (684s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[337.949450] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[338.729494] [018/133] (683s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[338.799149] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[338.805080] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[338.998089] [019/133] (682s left) gem_ctx_exec (basic-invalid-context)
[339.062391] Starting subtest: basic-invalid-context
[339.067334] Subtest basic-invalid-context: SUCCESS (0.005s)
[339.217043] [020/133] (682s left) gem_exec_balancer (parallel-keep-in-fence)
[339.467515] Starting subtest: parallel-keep-in-fence
[340.663178] Subtest parallel-keep-in-fence: SUCCESS (1.208s)
[340.771943] [021/133] (681s left) kms_async_flips (async-flip-suspend-resume)
[340.870429] Starting subtest: async-flip-suspend-resume
[341.244918] Starting dynamic subtest: pipe-A-eDP-1
[359.905233] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.987s)
[360.282324] Starting dynamic subtest: pipe-B-eDP-1
[377.848998] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.974s)
[378.240825] Starting dynamic subtest: pipe-C-eDP-1
[395.887434] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.972s)
[396.276646] Starting dynamic subtest: pipe-D-eDP-1
[413.883281] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.978s)
[413.886118] Subtest async-flip-suspend-resume: SUCCESS (13.458s)
[415.040591] [022/133] (606s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[415.154899] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[421.711172] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.732s)
[421.891597] [023/133] (600s left) gem_exec_capture (userptr)
[421.958281] Starting subtest: userptr
[422.787269] Subtest userptr: SUCCESS (0.839s)
[422.920135] [024/133] (599s left) gem_render_copy_redux (flink-interruptible)
[422.983811] Starting subtest: flink-interruptible
[423.773964] Subtest flink-interruptible: SUCCESS (0.801s)
[423.937735] [025/133] (598s left) gem_workarounds (reset)
[424.003264] Starting subtest: reset
[424.186998] Subtest reset: SUCCESS (0.184s)
[424.357465] [026/133] (597s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[424.459686] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[424.463806] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[424.571326] [027/133] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[424.676986] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[431.947437] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.326s)
[432.140805] [028/133] (590s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[432.270550] Starting subtest: short-flip-before-cursor-toggle
[433.178110] Subtest short-flip-before-cursor-toggle: SUCCESS (0.913s)
[434.063178] [029/133] (588s left) kms_big_fb (linear-8bpp-rotate-180)
[434.156866] Starting subtest: linear-8bpp-rotate-180
[435.501503] Subtest linear-8bpp-rotate-180: SUCCESS (1.347s)
[435.655669] [030/133] (586s left) kms_flip (2x-flip-vs-panning)
[435.753265] Starting subtest: 2x-flip-vs-panning
[435.761899] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[435.860516] [031/133] (586s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[435.968106] Starting subtest: cursor-tearing-framebuffer-change
[435.970485] Starting dynamic subtest: pipe-A-eDP-1
[436.537468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[436.546325] Starting dynamic subtest: pipe-D-eDP-1
[437.768864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[437.771115] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.802s)
[438.608998] [032/133] (583s left) gen9_exec_parse (bb-start-out)
[438.677857] Subtest bb-start-out: SKIP (0.000s)
[438.765758] [033/133] (583s left) i915_pm_rps (waitboost)
[438.819952] Starting subtest: waitboost
[444.911886] Subtest waitboost: SUCCESS (6.100s)
[445.062578] [034/133] (577s left) gem_ctx_persistence (legacy-engines-mixed)
[445.118301] Starting subtest: legacy-engines-mixed
[445.121435] Starting dynamic subtest: render
[445.226622] Dynamic subtest render: SUCCESS (0.108s)
[445.238604] Starting dynamic subtest: bsd1
[445.299805] Dynamic subtest bsd1: SUCCESS (0.070s)
[445.311307] Starting dynamic subtest: bsd2
[445.363611] Dynamic subtest bsd2: SUCCESS (0.061s)
[445.375082] Starting dynamic subtest: blt
[445.424396] Dynamic subtest blt: SUCCESS (0.058s)
[445.442926] Starting dynamic subtest: vebox
[445.490586] Dynamic subtest vebox: SUCCESS (0.063s)
[445.493616] Subtest legacy-engines-mixed: SUCCESS (0.374s)
[445.587036] [035/133] (576s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[445.672149] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[445.698305] Starting dynamic subtest: pipe-A-plane-0
[445.704013] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[445.714726] Starting dynamic subtest: pipe-A-plane-3
[445.719918] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[445.729087] Starting dynamic subtest: pipe-A-plane-5
[445.734224] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[446.766650] Starting dynamic subtest: pipe-B-plane-0
[446.771588] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[446.780138] Starting dynamic subtest: pipe-B-plane-3
[446.785607] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[446.794421] Starting dynamic subtest: pipe-B-plane-5
[446.799845] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[447.071339] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (1.396s)
[447.967725] [036/133] (574s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[448.070208] Starting subtest: coverage-vs-premult-vs-constant
[448.355719] Starting dynamic subtest: pipe-A-eDP-1
[448.924968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[448.935323] Starting dynamic subtest: pipe-D-eDP-1
[450.267453] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[450.270107] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.195s)
[451.129856] [037/133] (571s left) gem_readwrite (beyond-eob)
[451.193074] Subtest beyond-EOB: SKIP (0.000s)
[451.262276] [038/133] (571s left) kms_chamelium_frames (dp-crc-fast)
[451.643297] Subtest dp-crc-fast: SKIP (0.000s)
[452.442853] [039/133] (570s left) gem_exec_schedule (fifo)
[452.528353] Starting subtest: fifo
[452.531330] Starting dynamic subtest: rcs0
[452.619201] Dynamic subtest rcs0: SUCCESS (0.107s)
[452.630203] Starting dynamic subtest: vcs0
[452.699622] Dynamic subtest vcs0: SUCCESS (0.079s)
[452.712095] Starting dynamic subtest: vcs1
[452.789650] Dynamic subtest vcs1: SUCCESS (0.089s)
[452.801375] Starting dynamic subtest: vecs0
[452.863278] Dynamic subtest vecs0: SUCCESS (0.072s)
[452.874926] Starting dynamic subtest: ccs0
[452.960270] Dynamic subtest ccs0: SUCCESS (0.096s)
[452.963170] Subtest fifo: SUCCESS (0.448s)
[454.650717] [040/133] (568s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[454.751540] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[454.756659] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[454.863986] [041/133] (567s left) gem_ccs (ctrl-surf-copy-new-ctx)
[454.917173] Starting subtest: ctrl-surf-copy-new-ctx
[454.922845] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[455.044098] [042/133] (567s left) syncobj_timeline (invalid-transfer-non-existent-point)
[455.101124] Starting subtest: invalid-transfer-non-existent-point
[455.103482] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[455.212036] [043/133] (567s left) gem_basic (create-close)
[455.274081] Starting subtest: create-close
[455.278862] Subtest create-close: SUCCESS (0.000s)
[455.391291] [044/133] (567s left) gem_exec_reloc (basic-gtt-wc-active)
[455.444104] Subtest basic-gtt-wc-active: SKIP (0.000s)
[455.513982] [045/133] (567s left) kms_cursor_legacy (torture-move)
[455.630081] Starting subtest: torture-move
[455.632077] Starting dynamic subtest: pipe-A
[461.889818] Dynamic subtest pipe-A: SUCCESS (6.255s)
[461.899669] Starting dynamic subtest: pipe-B
[469.318283] Dynamic subtest pipe-B: SUCCESS (7.427s)
[469.327866] Starting dynamic subtest: pipe-C
[476.273286] Dynamic subtest pipe-C: SUCCESS (6.951s)
[476.286214] Starting dynamic subtest: pipe-D
[483.569636] Dynamic subtest pipe-D: SUCCESS (7.295s)
[483.582924] Starting dynamic subtest: all-pipes
[491.219576] Dynamic subtest all-pipes: SUCCESS (7.649s)
[491.222208] Subtest torture-move: SUCCESS (35.588s)
[491.389662] [046/133] (531s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[491.504495] Starting subtest: invalid-modeset-force-ultra-joiner
[491.508998] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[491.582502] [047/133] (531s left) kms_rotation_crc (primary-rotation-90)
[491.673639] Starting subtest: primary-rotation-90
[491.679058] Subtest primary-rotation-90: SKIP (0.001s)
[491.776589] [048/133] (531s left) gem_exec_balancer (full-late)
[491.836957] Starting subtest: full-late
[496.385581] Subtest full-late: SUCCESS (4.552s)
[496.732588] [049/133] (526s left) kms_plane (planar-pixel-format-settings)
[496.823838] Starting subtest: planar-pixel-format-settings
[496.888913] Subtest planar-pixel-format-settings: SUCCESS (0.064s)
[497.028587] [050/133] (526s left) kms_flip (2x-dpms-vs-vblank-race)
[497.131122] Starting subtest: 2x-dpms-vs-vblank-race
[497.140163] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[497.268340] [051/133] (525s left) gem_exec_whisper (basic-contexts)
[497.334721] Starting subtest: basic-contexts
[504.035357] Subtest basic-contexts: SUCCESS (6.701s)
[504.233062] [052/133] (519s left) kms_vblank (wait-busy)
[504.341087] Starting subtest: wait-busy
[504.343830] Starting dynamic subtest: pipe-A-eDP-1
[506.217710] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[506.234930] Starting dynamic subtest: pipe-D-eDP-1
[508.807114] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.585s)
[508.810013] Subtest wait-busy: SUCCESS (4.468s)
[509.618087] [053/133] (513s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[509.719810] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[509.722255] Starting dynamic subtest: pipe-A-default-mode
[510.874139] Dynamic subtest pipe-A-default-mode: SKIP (1.152s)
[510.878944] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.154s)
[511.055712] [054/133] (512s left) kms_psr (pr-cursor-plane-move)
[511.154891] Starting subtest: pr-cursor-plane-move
[511.159850] Subtest pr-cursor-plane-move: SKIP (0.000s)
[511.240857] [055/133] (512s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[511.312537] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[511.314888] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[511.417446] [056/133] (512s left) kms_cursor_crc (cursor-offscreen-128x42)
[511.676279] Starting subtest: cursor-offscreen-128x42
[511.724127] Subtest cursor-offscreen-128x42: SKIP (0.042s)
[511.968367] [057/133] (511s left) perf (global-sseu-config-invalid)
[512.110825] Starting subtest: global-sseu-config-invalid
[512.114439] Subtest global-sseu-config-invalid: SKIP (0.000s)
[512.154425] [058/133] (511s left) kms_draw_crc (draw-method-mmap-cpu)
[512.249515] Starting subtest: draw-method-mmap-cpu
[512.251556] Starting dynamic subtest: xrgb8888-untiled
[512.468711] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[512.477899] Starting dynamic subtest: rgb565-untiled
[512.680283] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[512.691505] Starting dynamic subtest: xrgb2101010-untiled
[512.891483] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[512.907260] Starting dynamic subtest: xbgr16161616f-untiled
[513.136146] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.243s)
[513.145784] Starting dynamic subtest: xrgb8888-xtiled
[513.281874] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[513.293029] Starting dynamic subtest: rgb565-xtiled
[513.413618] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[513.422757] Starting dynamic subtest: xrgb2101010-xtiled
[513.548670] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[513.563878] Starting dynamic subtest: xbgr16161616f-xtiled
[513.669864] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[513.679323] Starting dynamic subtest: xrgb8888-4tiled
[513.802918] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[513.812610] Starting dynamic subtest: rgb565-4tiled
[513.936593] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[513.946398] Starting dynamic subtest: xrgb2101010-4tiled
[514.058902] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[514.068637] Starting dynamic subtest: xbgr16161616f-4tiled
[514.191817] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[514.194035] Subtest draw-method-mmap-cpu: SUCCESS (1.944s)
[514.320659] [059/133] (509s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[514.427554] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[521.200033] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.770s)
[521.327637] [060/133] (502s left) syncobj_timeline (device-signal-unordered)
[521.388133] Starting subtest: device-signal-unordered
[521.390574] Subtest device-signal-unordered: SUCCESS (0.001s)
[521.507288] [061/133] (502s left) vgem_basic (setversion)
[521.558058] Starting subtest: setversion
[521.562991] Subtest setversion: SUCCESS (0.000s)
[521.638556] [062/133] (502s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[521.734131] Starting subtest: psr-1p-primscrn-spr-indfb-move
[529.227979] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.495s)
[529.397178] [063/133] (494s left) kms_properties (crtc-properties-legacy)
[529.491254] Starting subtest: crtc-properties-legacy
[529.493966] Starting dynamic subtest: pipe-A-eDP-1
[529.946313] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[529.957033] Starting dynamic subtest: pipe-B-eDP-1
[531.079208] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[531.090071] Starting dynamic subtest: pipe-C-eDP-1
[532.197133] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[532.207308] Starting dynamic subtest: pipe-D-eDP-1
[533.320225] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[533.323196] Subtest crtc-properties-legacy: SUCCESS (3.831s)
[534.144090] [064/133] (489s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[534.251261] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[537.897808] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.652s)
[539.044796] [065/133] (484s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[539.139803] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[539.165522] Starting dynamic subtest: pipe-A-plane-0
[539.171151] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[539.181197] Starting dynamic subtest: pipe-A-plane-3
[539.185905] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[539.194927] Starting dynamic subtest: pipe-A-plane-5
[539.199335] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[540.304562] Starting dynamic subtest: pipe-B-plane-0
[540.309685] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[540.319307] Starting dynamic subtest: pipe-B-plane-3
[540.324854] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[540.334313] Starting dynamic subtest: pipe-B-plane-5
[540.339084] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[540.618081] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (1.478s)
[541.509115] [066/133] (482s left) prime_mmap (test_aperture_limit)
[541.568705] Starting subtest: test_aperture_limit
[541.571217] Starting dynamic subtest: test_aperture_limit-smem
[541.576989] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[541.582282] Subtest test_aperture_limit: SKIP (0.008s)
[541.701810] [067/133] (482s left) kms_color (ctm-0-50)
[541.797053] Starting subtest: ctm-0-50
[541.799108] Starting dynamic subtest: pipe-A-eDP-1
[545.208288] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.412s)
[545.218836] Starting dynamic subtest: pipe-B-eDP-1
[549.325089] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.116s)
[549.334904] Starting dynamic subtest: pipe-C-eDP-1
[553.273945] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.950s)
[553.283923] Starting dynamic subtest: pipe-D-eDP-1
[557.280917] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.004s)
[557.283278] Subtest ctm-0-50: SUCCESS (15.484s)
[558.111428] [068/133] (465s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[558.218172] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[558.223885] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[558.314104] [069/133] (465s left) kms_rotation_crc (sprite-rotation-180)
[558.403122] Starting subtest: sprite-rotation-180
[565.463729] Subtest sprite-rotation-180: SUCCESS (7.061s)
[566.661345] [070/133] (457s left) kms_psr (psr2-suspend)
[566.754454] Starting subtest: psr2-suspend
[566.757208] Starting dynamic subtest: eDP-1
[585.295344] Dynamic subtest eDP-1: SUCCESS (2.842s)
[585.297695] Subtest psr2-suspend: SUCCESS (2.843s)
[586.091915] [071/133] (438s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[586.198365] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[586.200966] Starting dynamic subtest: pipe-A-eDP-1
[586.258081] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[586.272437] Starting dynamic subtest: pipe-B-eDP-1
[586.314905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[586.324185] Starting dynamic subtest: pipe-C-eDP-1
[586.372146] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s)
[586.381070] Starting dynamic subtest: pipe-D-eDP-1
[586.428051] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[586.430296] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.243s)
[588.665672] [072/133] (435s left) gem_fence_thrash (bo-write-verify-y)
[588.702835] Starting subtest: bo-write-verify-y
[588.720481] Subtest bo-write-verify-y: SKIP (0.012s)
[588.791851] [073/133] (435s left) kms_content_protection (dp-mst-type-1)
[588.936414] Starting subtest: dp-mst-type-1
[588.942010] Subtest dp-mst-type-1: SKIP (0.000s)
[589.084940] [074/133] (435s left) gem_ctx_shared (disjoint-timelines)
[589.155169] Starting subtest: disjoint-timelines
[589.187209] Subtest disjoint-timelines: SUCCESS (0.033s)
[589.451982] [075/133] (434s left) kms_flip (absolute-wf_vblank-interruptible)
[589.546155] Starting subtest: absolute-wf_vblank-interruptible
[589.548844] Starting dynamic subtest: A-eDP1
[598.253064] Dynamic subtest A-eDP1: SUCCESS (8.842s)
[598.266013] Starting dynamic subtest: B-eDP1
[606.926186] Dynamic subtest B-eDP1: SUCCESS (8.715s)
[606.935838] Starting dynamic subtest: C-eDP1
[615.617006] Dynamic subtest C-eDP1: SUCCESS (8.706s)
[615.626722] Starting dynamic subtest: D-eDP1
[624.343455] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[624.346317] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.995s)
[625.566763] [076/133] (398s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[625.666402] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[625.669232] Starting dynamic subtest: pipe-A-eDP-1
[636.651313] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.993s)
[636.662206] Starting dynamic subtest: pipe-B-eDP-1
[648.358286] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.709s)
[648.361056] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.705s)
[649.224703] [077/133] (375s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[649.351077] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[649.356340] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[649.478348] [078/133] (374s left) gem_exec_schedule (thriceslice)
[649.565145] Starting subtest: thriceslice
[649.567903] Starting dynamic subtest: rcs0
[649.593042] Dynamic subtest rcs0: SUCCESS (0.034s)
[649.604183] Starting dynamic subtest: bcs0
[649.624086] Dynamic subtest bcs0: SUCCESS (0.030s)
[649.633507] Starting dynamic subtest: vcs0
[649.653514] Dynamic subtest vcs0: SUCCESS (0.029s)
[649.663060] Starting dynamic subtest: vcs1
[649.682762] Dynamic subtest vcs1: SUCCESS (0.028s)
[649.694466] Starting dynamic subtest: vecs0
[649.731336] Dynamic subtest vecs0: SUCCESS (0.048s)
[649.742382] Starting dynamic subtest: ccs0
[649.782465] Dynamic subtest ccs0: SUCCESS (0.049s)
[649.785467] Subtest thriceslice: SUCCESS (0.225s)
[651.275543] [079/133] (373s left) syncobj_wait (single-wait-submitted)
[651.334331] Starting subtest: single-wait-submitted
[651.440622] Subtest single-wait-submitted: SUCCESS (0.107s)
[651.528928] [080/133] (372s left) kms_addfb_basic (bad-pitch-32)
[651.599124] Starting subtest: bad-pitch-32
[651.601460] Subtest bad-pitch-32: SUCCESS (0.000s)
[651.761783] [081/133] (372s left) gem_eio (hibernate)
[651.994789] Starting subtest: hibernate
[666.744390] Subtest hibernate: SUCCESS (14.755s)
[674.886596] [082/133] (357s left) gem_userptr_blits (huge-split)
[674.974463] Starting subtest: huge-split
[674.980623] Subtest huge-split: SUCCESS (0.006s)
[675.125605] [083/133] (357s left) gem_ctx_persistence (engines-cleanup)
[675.192467] Starting subtest: engines-cleanup
[675.195287] Starting dynamic subtest: rcs0
[675.308457] Dynamic subtest rcs0: SUCCESS (0.116s)
[675.322243] Starting dynamic subtest: bcs0
[675.374827] Dynamic subtest bcs0: SUCCESS (0.064s)
[675.388031] Starting dynamic subtest: vcs0
[675.406678] Dynamic subtest vcs0: SUCCESS (0.030s)
[675.417167] Starting dynamic subtest: vcs1
[675.512815] Dynamic subtest vcs1: SUCCESS (0.105s)
[675.525760] Starting dynamic subtest: vecs0
[675.575758] Dynamic subtest vecs0: SUCCESS (0.061s)
[675.587776] Starting dynamic subtest: ccs0
[675.649754] Dynamic subtest ccs0: SUCCESS (0.072s)
[675.652484] Subtest engines-cleanup: SUCCESS (0.458s)
[675.748843] [084/133] (356s left) gem_mmap_offset (clear-via-pagefault)
[675.821455] Starting subtest: clear-via-pagefault
[675.823959] Starting dynamic subtest: smem0
[710.735626] Dynamic subtest smem0: SUCCESS (34.911s)
[710.738083] Subtest clear-via-pagefault: SUCCESS (34.913s)
[710.857956] [085/133] (321s left) kms_psr (fbc-psr2-sprite-plane-move)
[710.955292] Starting subtest: fbc-psr2-sprite-plane-move
[710.958210] Starting dynamic subtest: eDP-1
[710.963336] Dynamic subtest eDP-1: SKIP (0.000s)
[710.968690] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[711.041820] [086/133] (321s left) kms_pm_rpm (package-g7)
[712.569407] Starting subtest: package-g7
[712.575291] Subtest package-g7: SKIP (0.000s)
[713.335256] [087/133] (319s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[713.443313] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[713.445726] Starting dynamic subtest: pipe-A-eDP-1
[714.172604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[714.188733] Starting dynamic subtest: pipe-B-eDP-1
[715.928286] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.752s)
[715.939312] Starting dynamic subtest: pipe-C-eDP-1
[717.669371] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.743s)
[717.680354] Starting dynamic subtest: pipe-D-eDP-1
[719.516451] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.845s)
[719.519344] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.067s)
[720.646290] [088/133] (312s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[720.739394] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[720.742132] Starting dynamic subtest: pipe-A-eDP-1
[720.769837] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[720.780006] Starting dynamic subtest: pipe-B-eDP-1
[720.808204] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[720.818258] Starting dynamic subtest: pipe-C-eDP-1
[720.846299] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[720.856369] Starting dynamic subtest: pipe-D-eDP-1
[720.884958] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[720.889942] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[722.931837] [089/133] (309s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[723.044286] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[723.049318] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[723.178546] [090/133] (309s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[723.233869] Starting subtest: etime-single-wait-all-for-submit-submitted
[723.335802] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[723.425827] [091/133] (309s left) prime_busy (before)
[723.496332] Starting subtest: before
[723.503095] Starting dynamic subtest: rcs0
[723.555300] Dynamic subtest rcs0: SUCCESS (0.056s)
[723.567279] Starting dynamic subtest: bcs0
[723.617184] Dynamic subtest bcs0: SUCCESS (0.061s)
[723.628468] Starting dynamic subtest: vcs0
[723.658482] Dynamic subtest vcs0: SUCCESS (0.040s)
[723.668648] Starting dynamic subtest: vcs1
[723.700297] Dynamic subtest vcs1: SUCCESS (0.041s)
[723.710506] Starting dynamic subtest: vecs0
[723.741750] Dynamic subtest vecs0: SUCCESS (0.041s)
[723.752139] Starting dynamic subtest: ccs0
[723.782839] Dynamic subtest ccs0: SUCCESS (0.040s)
[723.890992] Subtest before: SUCCESS (0.394s)
[723.986859] [092/133] (309s left) i915_drm_fdinfo (virtual-busy-idle-all)
[724.040229] Starting subtest: virtual-busy-idle-all
[724.046041] Subtest virtual-busy-idle-all: SKIP (0.000s)
[724.136023] [093/133] (308s left) kms_cursor_crc (cursor-random-256x85)
[724.404863] Starting subtest: cursor-random-256x85
[724.447341] Subtest cursor-random-256x85: SKIP (0.040s)
[724.653685] [094/133] (308s left) kms_properties (crtc-properties-atomic)
[724.746029] Starting subtest: crtc-properties-atomic
[724.748458] Starting dynamic subtest: pipe-A-eDP-1
[725.203318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s)
[725.214222] Starting dynamic subtest: pipe-B-eDP-1
[726.396271] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s)
[726.406864] Starting dynamic subtest: pipe-C-eDP-1
[727.517075] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[727.528391] Starting dynamic subtest: pipe-D-eDP-1
[728.652786] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[728.655624] Subtest crtc-properties-atomic: SUCCESS (3.909s)
[729.477802] [095/133] (303s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[729.582278] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[729.587529] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[729.702205] [096/133] (303s left) perf_pmu (rc6)
[729.742367] Starting subtest: rc6
[729.745260] Starting dynamic subtest: gt0
[736.093678] Dynamic subtest gt0: SUCCESS (6.352s)
[736.107284] Starting dynamic subtest: runtime-pm-gt0
[743.888211] Dynamic subtest runtime-pm-gt0: SUCCESS (7.794s)
[743.901218] Starting dynamic subtest: runtime-pm-long-gt0
[756.391390] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.503s)
[756.404278] Starting dynamic subtest: other-idle-gt0
[762.735660] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[762.749187] Starting dynamic subtest: gt1
[769.077704] Dynamic subtest gt1: SUCCESS (6.341s)
[769.091100] Starting dynamic subtest: runtime-pm-gt1
[776.513045] Dynamic subtest runtime-pm-gt1: SUCCESS (7.434s)
[776.526572] Starting dynamic subtest: runtime-pm-long-gt1
[788.946492] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.434s)
[788.960465] Starting dynamic subtest: other-idle-gt1
[795.288718] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[795.291298] Subtest rc6: SUCCESS (65.561s)
[796.461583] [097/133] (236s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[796.582184] Starting subtest: flip-vs-cursor-crc-legacy
[797.275321] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.691s)
[798.061918] [098/133] (235s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[798.167365] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[798.170079] Starting dynamic subtest: pipe-A
[798.229639] Dynamic subtest pipe-A: SUCCESS (0.064s)
[798.240995] Starting dynamic subtest: pipe-B
[799.393355] Dynamic subtest pipe-B: SUCCESS (1.163s)
[799.405620] Starting dynamic subtest: pipe-C
[800.498403] Dynamic subtest pipe-C: SUCCESS (1.105s)
[800.509016] Starting dynamic subtest: pipe-D
[801.629296] Dynamic subtest pipe-D: SUCCESS (1.130s)
[801.632332] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.465s)
[802.771379] [099/133] (230s left) syncobj_timeline (single-wait-all-available-submitted)
[802.828288] Starting subtest: single-wait-all-available-submitted
[802.830865] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[802.895515] [100/133] (230s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[803.001272] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[803.003919] Starting dynamic subtest: pipe-A-eDP-1
[803.030327] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[803.040175] Starting dynamic subtest: pipe-B-eDP-1
[803.065752] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[803.075264] Starting dynamic subtest: pipe-C-eDP-1
[803.100355] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[803.109621] Starting dynamic subtest: pipe-D-eDP-1
[803.135318] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[803.140489] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[805.147021] [101/133] (228s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[805.255221] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[805.260400] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[805.327374] [102/133] (228s left) api_intel_bb (object-noreloc-keep-cache-simple)
[805.386133] Starting subtest: object-noreloc-keep-cache-simple
[805.391078] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[805.508865] [103/133] (227s left) perf_pmu (invalid-open)
[805.544299] Starting subtest: invalid-open
[805.547313] Subtest invalid-open: SUCCESS (0.000s)
[805.629008] [104/133] (227s left) kms_force_connector_basic (force-load-detect)
[805.716882] Starting subtest: force-load-detect
[805.721981] Subtest force-load-detect: SKIP (0.000s)
[805.807844] [105/133] (227s left) kms_lease (simple-lease)
[805.904383] Starting subtest: simple-lease
[805.907128] Starting dynamic subtest: pipe-A-eDP-1
[806.404475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.501s)
[806.415519] Starting dynamic subtest: pipe-B-eDP-1
[807.904499] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.496s)
[807.917139] Starting dynamic subtest: pipe-C-eDP-1
[809.294301] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[809.305288] Starting dynamic subtest: pipe-D-eDP-1
[810.688173] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.393s)
[810.690812] Subtest simple-lease: SUCCESS (4.788s)
[811.485320] [106/133] (222s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[811.596733] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[811.601937] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[811.680300] [107/133] (221s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[811.793612] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[818.312612] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.523s)
[818.404031] [108/133] (215s left) gem_spin_batch (legacy)
[818.467659] Starting subtest: legacy
[818.470460] Starting dynamic subtest: default
[821.709491] Dynamic subtest default: SUCCESS (3.238s)
[821.722487] Starting dynamic subtest: render
[824.943793] Dynamic subtest render: SUCCESS (3.232s)
[824.956110] Starting dynamic subtest: bsd
[828.180048] Dynamic subtest bsd: SUCCESS (3.234s)
[828.192478] Starting dynamic subtest: bsd1
[831.411992] Dynamic subtest bsd1: SUCCESS (3.230s)
[831.424937] Starting dynamic subtest: bsd2
[834.669447] Dynamic subtest bsd2: SUCCESS (3.232s)
[834.686446] Starting dynamic subtest: blt
[837.885589] Dynamic subtest blt: SUCCESS (3.238s)
[837.899083] Starting dynamic subtest: vebox
[841.122773] Dynamic subtest vebox: SUCCESS (3.235s)
[841.125330] Subtest legacy: SUCCESS (22.658s)
[841.289200] [109/133] (192s left) kms_flip (dpms-vs-vblank-race)
[841.389295] Starting subtest: dpms-vs-vblank-race
[841.392386] Starting dynamic subtest: A-eDP1
[846.401281] Dynamic subtest A-eDP1: SUCCESS (5.016s)
[846.413524] Starting dynamic subtest: B-eDP1
[849.997482] Dynamic subtest B-eDP1: SUCCESS (3.596s)
[850.007741] Starting dynamic subtest: C-eDP1
[853.501082] Dynamic subtest C-eDP1: SUCCESS (3.502s)
[853.512465] Starting dynamic subtest: D-eDP1
[858.104353] Dynamic subtest D-eDP1: SUCCESS (4.605s)
[858.107304] Subtest dpms-vs-vblank-race: SUCCESS (16.726s)
[858.972249] [110/133] (174s left) gem_eio (banned)
[859.148372] Starting subtest: banned
[859.773387] Subtest banned: SUCCESS (0.625s)
[859.930600] [111/133] (173s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[860.026159] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[864.415218] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.397s)
[865.544365] [112/133] (168s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[865.607063] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[865.690849] [113/133] (168s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[865.791003] Starting subtest: pipe-fbc-rte
[865.797544] Starting dynamic subtest: pipe-B-eDP-1
[871.233447] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.448s)
[871.242192] Subtest pipe-fbc-rte: SUCCESS (5.451s)
[873.543263] [114/133] (160s left) kms_big_fb (x-tiled-addfb)
[873.644990] Starting subtest: x-tiled-addfb
[873.647292] Subtest x-tiled-addfb: SUCCESS (0.000s)
[873.736221] [115/133] (160s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[873.823368] Starting subtest: psr-farfromfence-mmap-gtt
[873.828358] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[873.926463] [116/133] (160s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[874.031098] Starting subtest: 4-tiled-8bpp-rotate-0
[875.265555] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.236s)
[875.386711] [117/133] (158s left) gem_eio (in-flight-external)
[875.600469] Starting subtest: in-flight-external
[877.329772] Subtest in-flight-external: SUCCESS (1.730s)
[877.456628] [118/133] (156s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[877.573069] Starting subtest: y-tiled-addfb-size-offset-overflow
[877.577708] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[877.674997] [119/133] (156s left) prime_self_import (basic-with_fd_dup)
[877.718742] Starting subtest: basic-with_fd_dup
[877.746238] Subtest basic-with_fd_dup: SUCCESS (0.025s)
[877.829152] [120/133] (156s left) i915_drm_fdinfo (busy-idle-check-all)
[877.864842] Starting subtest: busy-idle-check-all
[877.867396] Starting dynamic subtest: rcs0
[877.873184] Dynamic subtest rcs0: SKIP (0.003s)
[877.890404] Starting dynamic subtest: bcs0
[877.896289] Dynamic subtest bcs0: SKIP (0.000s)
[877.906501] Starting dynamic subtest: vcs0
[877.911336] Dynamic subtest vcs0: SKIP (0.000s)
[877.921116] Starting dynamic subtest: vcs1
[877.926133] Dynamic subtest vcs1: SKIP (0.000s)
[877.935818] Starting dynamic subtest: vecs0
[877.940608] Dynamic subtest vecs0: SKIP (0.000s)
[877.951065] Starting dynamic subtest: ccs0
[877.955893] Dynamic subtest ccs0: SKIP (0.000s)
[877.960214] Subtest busy-idle-check-all: SKIP (0.008s)
[877.998125] [121/133] (156s left) kms_getfb (getfb-handle-valid)
[878.146117] Starting subtest: getfb-handle-valid
[878.148462] Subtest getfb-handle-valid: SUCCESS (0.000s)
[878.223632] [122/133] (156s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[878.785160] Starting subtest: syncobj-timeline-multiple-ext-nodes
[878.787890] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[880.361640] [123/133] (154s left) gem_exec_params (no-vebox)
[880.434961] Starting subtest: no-vebox
[880.437637] Subtest no-vebox: SUCCESS (0.002s)
[882.336084] [124/133] (152s left) sysfs_timeslice_duration (idempotent)
[882.403613] Starting subtest: idempotent
[882.406226] Starting dynamic subtest: vecs0
[882.409129] Dynamic subtest vecs0: SUCCESS (0.000s)
[882.420639] Starting dynamic subtest: ccs0
[882.423051] Dynamic subtest ccs0: SUCCESS (0.000s)
[882.433038] Starting dynamic subtest: vcs0
[882.435315] Dynamic subtest vcs0: SUCCESS (0.000s)
[882.445508] Starting dynamic subtest: bcs0
[882.448068] Dynamic subtest bcs0: SUCCESS (0.000s)
[882.458486] Starting dynamic subtest: rcs0
[882.460892] Dynamic subtest rcs0: SUCCESS (0.000s)
[882.470461] Starting dynamic subtest: vcs1
[882.472897] Dynamic subtest vcs1: SUCCESS (0.000s)
[882.475162] Subtest idempotent: SUCCESS (0.006s)
[882.514247] [125/133] (151s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[882.639288] Starting subtest: fbc-farfromfence-mmap-gtt
[882.644011] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[882.744317] [126/133] (151s left) kms_async_flips (test-time-stamp)
[882.846039] Starting subtest: test-time-stamp
[883.219059] Starting dynamic subtest: pipe-A-eDP-1
[884.057461] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.837s)
[884.434610] Starting dynamic subtest: pipe-B-eDP-1
[885.187680] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[885.552510] Starting dynamic subtest: pipe-C-eDP-1
[886.314115] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[886.678025] Starting dynamic subtest: pipe-D-eDP-1
[887.447506] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s)
[887.450379] Subtest test-time-stamp: SUCCESS (4.603s)
[888.597858] [127/133] (145s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[888.709022] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[889.709146] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.001s)
[889.832865] [128/133] (144s left) gem_exec_schedule (out-order)
[889.897536] Starting subtest: out-order
[889.899968] Starting dynamic subtest: rcs0
[889.997993] Dynamic subtest rcs0: SUCCESS (0.108s)
[890.007979] Starting dynamic subtest: vcs0
[890.084347] Dynamic subtest vcs0: SUCCESS (0.086s)
[890.095283] Starting dynamic subtest: vcs1
[890.174419] Dynamic subtest vcs1: SUCCESS (0.089s)
[890.187505] Starting dynamic subtest: vecs0
[890.257852] Dynamic subtest vecs0: SUCCESS (0.081s)
[890.270389] Starting dynamic subtest: ccs0
[890.352345] Dynamic subtest ccs0: SUCCESS (0.094s)
[890.355375] Subtest out-order: SUCCESS (0.463s)
[891.347462] [129/133] (143s left) kms_psr (fbc-pr-cursor-plane-move)
[891.465813] Starting subtest: fbc-pr-cursor-plane-move
[891.470968] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[891.518390] [130/133] (143s left) kms_selftest (drm_format)
[891.556239] Starting subtest: drm_format
[891.567596] Starting dynamic subtest: drm_test_format_block_width_invalid
[891.710800] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.142s)
[891.721806] Starting dynamic subtest: drm_test_format_block_width_one_plane
[891.850128] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.138s)
[891.860944] Starting dynamic subtest: drm_test_format_block_width_two_plane
[891.985152] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.135s)
[891.995417] Starting dynamic subtest: drm_test_format_block_width_three_plane
[892.117084] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.132s)
[892.127204] Starting dynamic subtest: drm_test_format_block_width_tiled
[892.271077] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.153s)
[892.282917] Starting dynamic subtest: drm_test_format_block_height_invalid
[892.408511] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.136s)
[892.419738] Starting dynamic subtest: drm_test_format_block_height_one_plane
[892.561003] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.153s)
[892.571902] Starting dynamic subtest: drm_test_format_block_height_two_plane
[892.702633] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.139s)
[892.719236] Starting dynamic subtest: drm_test_format_block_height_three_plane
[892.829268] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.126s)
[892.841364] Starting dynamic subtest: drm_test_format_block_height_tiled
[892.976275] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.144s)
[892.986328] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[893.113027] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.136s)
[893.124210] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[893.248103] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.134s)
[893.258300] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[893.386470] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.136s)
[893.398373] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[893.527269] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.139s)
[893.538189] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[893.667493] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.139s)
[893.678249] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[893.807324] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.138s)
[893.819552] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[893.934245] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.127s)
[893.944043] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[894.088306] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.153s)
[894.090863] Subtest drm_format: SUCCESS (2.537s)
[894.271374] [131/133] (140s left) kms_psr (fbc-pr-primary-render)
[894.361450] Starting subtest: fbc-pr-primary-render
[894.367126] Subtest fbc-pr-primary-render: SKIP (0.000s)
[894.419910] [132/133] (140s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[894.512911] Starting subtest: fbc-psr2-cursor-plane-update-sf
[894.515148] Starting dynamic subtest: pipe-A-eDP-1
[894.599151] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[894.615907] Starting dynamic subtest: pipe-B-eDP-1
[895.791833] Dynamic subtest pipe-B-eDP-1: SKIP (1.190s)
[895.796083] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.282s)
[897.058137] [133/133] (137s left) dmabuf (all-tests)
[897.093773] Starting subtest: all-tests
[897.095999] Starting dynamic subtest: sanitycheck
[897.195746] Dynamic subtest sanitycheck: SUCCESS (0.102s)
[897.210167] Starting dynamic subtest: dma_fence
[897.456248] Dynamic subtest dma_fence: SUCCESS (0.257s)
[897.470907] Starting dynamic subtest: dma_fence_chain
[905.708329] Dynamic subtest dma_fence_chain: SUCCESS (8.252s)
[905.723116] Starting dynamic subtest: dma_fence_unwrap
[905.826110] Dynamic subtest dma_fence_unwrap: SUCCESS (0.115s)
[905.840033] Starting dynamic subtest: dma_resv
[905.924067] Dynamic subtest dma_resv: SUCCESS (0.097s)
[905.926660] Subtest all-tests: SUCCESS (8.835s)
[905.964644] Closing watchdogs
results: parsing output: 0/ for test: gem_eio
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_mmap_wc
results: parsing output: 11/ for test: i915_pm_rpm
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_pxp
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_tiled_pread_pwrite
results: parsing output: 16/ for test: kms_chamelium_hpd
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: gem_ctx_exec
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: kms_async_flips
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_capture
results: parsing output: 23/ for test: gem_render_copy_redux
results: parsing output: 24/ for test: gem_workarounds
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gen9_exec_parse
results: parsing output: 32/ for test: i915_pm_rps
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_plane_alpha_blend
results: parsing output: 36/ for test: gem_readwrite
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_ccs
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: gem_basic
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_joiner
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_plane
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: gem_exec_whisper
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: kms_draw_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: vgem_basic
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_properties
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: prime_mmap
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_fence_thrash
results: parsing output: 72/ for test: kms_content_protection
results: parsing output: 73/ for test: gem_ctx_shared
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: prime_busy
results: parsing output: 91/ for test: i915_drm_fdinfo
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_properties
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_force_connector_basic
results: parsing output: 104/ for test: kms_lease
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_spin_batch
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: prime_self_import
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: sysfs_timeslice_duration
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_selftest
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: dmabuf
Done.