[57.525418] Initializing watchdogs
[57.525465]   /dev/watchdog0
[57.540244] [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]
[57.544742] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.547063] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.550316] [001/133] (960s left) gem_eio (reset-stress)
[57.731082] Starting subtest: reset-stress
[57.733105] Starting dynamic subtest: render
[61.542268] Dynamic subtest render: SUCCESS (3.796s)
[61.555478] Starting dynamic subtest: bsd1
[79.324803] Dynamic subtest bsd1: SUCCESS (17.763s)
[79.339601] Starting dynamic subtest: bsd2
[97.181555] Dynamic subtest bsd2: SUCCESS (17.853s)
[97.195781] Starting dynamic subtest: blt
[97.199759] Dynamic subtest blt: SKIP (0.000s)
[97.207143] Starting dynamic subtest: vebox
[115.310598] Dynamic subtest vebox: SUCCESS (18.126s)
[115.312673] Subtest reset-stress: SUCCESS (57.541s)
[116.940114] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true
[116.943177] [002/133] (901s left) gem_exec_whisper (basic-queues-forked-all)
[117.006779] Starting subtest: basic-queues-forked-all
[139.195485] Subtest basic-queues-forked-all: SUCCESS (22.183s)
[139.388845] [003/133] (878s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[139.501644] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[139.506208] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[139.611395] [004/133] (878s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[139.706135] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[139.708498] Starting dynamic subtest: pipe-A-eDP-1
[172.352521] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.019s)
[172.366597] Starting dynamic subtest: pipe-B-eDP-1
[205.277400] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.632s)
[205.287782] Starting dynamic subtest: pipe-C-eDP-1
[240.590130] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.897s)
[240.601202] Starting dynamic subtest: pipe-D-eDP-1
[274.246723] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.644s)
[274.248957] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (16.198s)
[275.454237] [005/133] (742s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[275.578400] Starting subtest: psr-shrfb-scaledprimary
[281.456548] Subtest psr-shrfb-scaledprimary: SUCCESS (5.806s)
[281.617804] [006/133] (736s left) kms_psr (psr-sprite-plane-move)
[281.731298] Starting subtest: psr-sprite-plane-move
[281.733643] Starting dynamic subtest: eDP-1
[283.516130] Dynamic subtest eDP-1: SUCCESS (1.771s)
[283.518525] Subtest psr-sprite-plane-move: SUCCESS (1.772s)
[284.354142] [007/133] (733s left) api_intel_bb (blit-noreloc-keep-cache)
[284.418278] Starting subtest: blit-noreloc-keep-cache
[284.427835] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[284.573661] [008/133] (733s left) kms_flip (modeset-vs-vblank-race)
[284.671470] Starting subtest: modeset-vs-vblank-race
[284.673908] Starting dynamic subtest: A-eDP1
[289.370919] Dynamic subtest A-eDP1: SUCCESS (4.677s)
[289.383349] Starting dynamic subtest: B-eDP1
[294.096425] Dynamic subtest B-eDP1: SUCCESS (4.712s)
[294.107731] Starting dynamic subtest: C-eDP1
[298.799836] Dynamic subtest C-eDP1: SUCCESS (4.695s)
[298.811191] Starting dynamic subtest: D-eDP1
[303.428066] Dynamic subtest D-eDP1: SUCCESS (4.622s)
[303.433150] Subtest modeset-vs-vblank-race: SUCCESS (18.716s)
[304.615119] [009/133] (713s left) kms_pm_rpm (basic-pci-d3-state)
[306.163605] Starting subtest: basic-pci-d3-state
[307.633527] Subtest basic-pci-d3-state: SUCCESS (1.472s)
[307.773417] [010/133] (710s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[307.834276] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[307.836265] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[307.934233] [011/133] (710s left) gem_mmap_wc (write-prefaulted)
[308.006705] Subtest write-prefaulted: SKIP (0.000s)
[308.076923] [012/133] (710s left) i915_pm_rpm (system-suspend)
[310.190185] Starting subtest: system-suspend
[327.884438] Subtest system-suspend: SUCCESS (2.843s)
[328.278872] [013/133] (690s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[328.387877] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[328.390276] Starting dynamic subtest: pipe-A-eDP-1
[328.416043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[328.427880] Starting dynamic subtest: pipe-B-eDP-1
[328.449594] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.458988] Starting dynamic subtest: pipe-C-eDP-1
[328.481643] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[328.491226] Starting dynamic subtest: pipe-D-eDP-1
[328.514974] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[328.519306] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[330.570606] [014/133] (688s left) gem_pxp (hw-rejects-pxp-context)
[330.701348] Starting subtest: hw-rejects-pxp-context
[330.706203] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[330.846353] [015/133] (687s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[330.937106] Starting subtest: fbc-rgb101010-draw-mmap-wc
[335.619725] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.635s)
[336.782766] [016/133] (681s left) gem_tiled_pread_pwrite
[336.911762] [017/133] (681s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[337.289272] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[338.161793] [018/133] (680s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[338.224816] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[338.229263] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[338.424395] [019/133] (680s left) gem_ctx_exec (basic-invalid-context)
[338.489079] Starting subtest: basic-invalid-context
[338.496583] Subtest basic-invalid-context: SUCCESS (0.009s)
[338.620513] [020/133] (680s left) gem_exec_balancer (parallel-keep-in-fence)
[338.885349] Starting subtest: parallel-keep-in-fence
[340.012025] Subtest parallel-keep-in-fence: SUCCESS (1.121s)
[340.161559] [021/133] (678s left) kms_async_flips (async-flip-suspend-resume)
[340.262900] Starting subtest: async-flip-suspend-resume
[340.635669] Starting dynamic subtest: pipe-A-eDP-1
[358.106785] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.862s)
[358.487736] Starting dynamic subtest: pipe-B-eDP-1
[376.120943] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.864s)
[376.518178] Starting dynamic subtest: pipe-C-eDP-1
[394.121687] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.843s)
[394.495120] Starting dynamic subtest: pipe-D-eDP-1
[412.117112] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.867s)
[412.121844] Subtest async-flip-suspend-resume: SUCCESS (12.930s)
[413.337227] [022/133] (605s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[413.452228] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[420.285401] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.754s)
[420.461398] [023/133] (598s left) gem_exec_capture (userptr)
[420.532397] Starting subtest: userptr
[421.371754] Subtest userptr: SUCCESS (0.833s)
[421.520823] [024/133] (597s left) gem_render_copy_redux (flink-interruptible)
[421.593986] Starting subtest: flink-interruptible
[422.386767] Subtest flink-interruptible: SUCCESS (0.789s)
[422.542685] [025/133] (596s left) gem_workarounds (reset)
[422.613617] Starting subtest: reset
[422.802050] Subtest reset: SUCCESS (0.187s)
[422.958143] [026/133] (596s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[423.058126] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[423.062994] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[423.182175] [027/133] (596s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[423.278070] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[430.631270] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.327s)
[430.792566] [028/133] (588s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[430.922964] Starting subtest: short-flip-before-cursor-toggle
[431.836878] Subtest short-flip-before-cursor-toggle: SUCCESS (0.913s)
[432.654384] [029/133] (586s left) kms_big_fb (linear-8bpp-rotate-180)
[432.760886] Starting subtest: linear-8bpp-rotate-180
[434.132665] Subtest linear-8bpp-rotate-180: SUCCESS (1.369s)
[434.256874] [030/133] (585s left) kms_flip (2x-flip-vs-panning)
[434.344912] Starting subtest: 2x-flip-vs-panning
[434.353899] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[434.461877] [031/133] (584s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[434.581810] Starting subtest: cursor-tearing-framebuffer-change
[434.583787] Starting dynamic subtest: pipe-A-eDP-1
[435.149218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[435.162033] Starting dynamic subtest: pipe-D-eDP-1
[436.387957] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[436.390639] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.804s)
[437.237735] [032/133] (582s left) gen9_exec_parse (bb-start-out)
[437.306794] Subtest bb-start-out: SKIP (0.000s)
[437.396473] [033/133] (582s left) i915_pm_rps (waitboost)
[437.462339] Starting subtest: waitboost
[443.556940] Subtest waitboost: SUCCESS (6.089s)
[443.720265] [034/133] (575s left) gem_ctx_persistence (legacy-engines-mixed)
[443.789162] Starting subtest: legacy-engines-mixed
[443.792197] Starting dynamic subtest: render
[443.915342] Dynamic subtest render: SUCCESS (0.126s)
[443.928252] Starting dynamic subtest: bsd1
[443.995383] Dynamic subtest bsd1: SUCCESS (0.077s)
[444.007773] Starting dynamic subtest: bsd2
[444.081408] Dynamic subtest bsd2: SUCCESS (0.083s)
[444.098348] Starting dynamic subtest: blt
[444.127046] Dynamic subtest blt: SUCCESS (0.043s)
[444.137192] Starting dynamic subtest: vebox
[444.223394] Dynamic subtest vebox: SUCCESS (0.094s)
[444.226566] Subtest legacy-engines-mixed: SUCCESS (0.436s)
[444.338356] [035/133] (575s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[444.443540] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[444.470181] Starting dynamic subtest: pipe-A-plane-0
[444.475155] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[444.485538] Starting dynamic subtest: pipe-A-plane-3
[444.490298] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[444.499784] Starting dynamic subtest: pipe-A-plane-5
[444.504422] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[445.628532] Starting dynamic subtest: pipe-B-plane-0
[445.633947] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[445.646793] Starting dynamic subtest: pipe-B-plane-3
[445.652351] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[445.662457] Starting dynamic subtest: pipe-B-plane-5
[445.668452] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[445.936226] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (1.492s)
[446.822394] [036/133] (572s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[446.926071] Starting subtest: coverage-vs-premult-vs-constant
[447.214704] Starting dynamic subtest: pipe-A-eDP-1
[447.780831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[447.791932] Starting dynamic subtest: pipe-D-eDP-1
[449.107671] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[449.110490] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.185s)
[449.973404] [037/133] (569s left) gem_readwrite (beyond-eob)
[450.040146] Subtest beyond-EOB: SKIP (0.000s)
[450.101597] [038/133] (569s left) kms_chamelium_frames (dp-crc-fast)
[450.490044] Subtest dp-crc-fast: SKIP (0.000s)
[451.279087] [039/133] (568s left) gem_exec_schedule (fifo)
[451.357827] Starting subtest: fifo
[451.360403] Starting dynamic subtest: rcs0
[451.444366] Dynamic subtest rcs0: SUCCESS (0.101s)
[451.455973] Starting dynamic subtest: vcs0
[451.528019] Dynamic subtest vcs0: SUCCESS (0.083s)
[451.543234] Starting dynamic subtest: vcs1
[451.609956] Dynamic subtest vcs1: SUCCESS (0.081s)
[451.623336] Starting dynamic subtest: vecs0
[451.686774] Dynamic subtest vecs0: SUCCESS (0.076s)
[451.699608] Starting dynamic subtest: ccs0
[451.785246] Dynamic subtest ccs0: SUCCESS (0.098s)
[451.788346] Subtest fifo: SUCCESS (0.443s)
[452.783375] [040/133] (566s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[452.894013] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[452.898865] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[453.014972] [041/133] (566s left) gem_ccs (ctrl-surf-copy-new-ctx)
[453.077923] Starting subtest: ctrl-surf-copy-new-ctx
[453.083180] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[453.190719] [042/133] (566s left) syncobj_timeline (invalid-transfer-non-existent-point)
[453.250097] Starting subtest: invalid-transfer-non-existent-point
[453.252353] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[453.372587] [043/133] (566s left) gem_basic (create-close)
[453.429274] Starting subtest: create-close
[453.434754] Subtest create-close: SUCCESS (0.000s)
[453.546129] [044/133] (566s left) gem_exec_reloc (basic-gtt-wc-active)
[453.615921] Subtest basic-gtt-wc-active: SKIP (0.000s)
[453.707219] [045/133] (566s left) kms_cursor_legacy (torture-move)
[453.826983] Starting subtest: torture-move
[453.829178] Starting dynamic subtest: pipe-A
[459.761368] Dynamic subtest pipe-A: SUCCESS (5.930s)
[459.774269] Starting dynamic subtest: pipe-B
[466.094104] Dynamic subtest pipe-B: SUCCESS (6.331s)
[466.106402] Starting dynamic subtest: pipe-C
[473.142371] Dynamic subtest pipe-C: SUCCESS (7.043s)
[473.152643] Starting dynamic subtest: pipe-D
[479.661341] Dynamic subtest pipe-D: SUCCESS (6.516s)
[479.679557] Starting dynamic subtest: all-pipes
[486.058219] Dynamic subtest all-pipes: SUCCESS (6.385s)
[486.061177] Subtest torture-move: SUCCESS (32.213s)
[486.219146] [046/133] (533s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[486.332059] Starting subtest: invalid-modeset-force-ultra-joiner
[486.336922] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[486.436292] [047/133] (533s left) kms_rotation_crc (primary-rotation-90)
[486.541446] Starting subtest: primary-rotation-90
[486.547114] Subtest primary-rotation-90: SKIP (0.001s)
[486.658436] [048/133] (533s left) gem_exec_balancer (full-late)
[486.727191] Starting subtest: full-late
[491.590907] Subtest full-late: SUCCESS (4.861s)
[491.943696] [049/133] (528s left) kms_plane (planar-pixel-format-settings)
[492.048080] Starting subtest: planar-pixel-format-settings
[492.125206] Subtest planar-pixel-format-settings: SUCCESS (0.077s)
[492.266661] [050/133] (527s left) kms_flip (2x-dpms-vs-vblank-race)
[492.367081] Starting subtest: 2x-dpms-vs-vblank-race
[492.376149] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[492.471647] [051/133] (527s left) gem_exec_whisper (basic-contexts)
[492.554474] Starting subtest: basic-contexts
[499.396368] Subtest basic-contexts: SUCCESS (6.835s)
[499.596364] [052/133] (520s left) kms_vblank (wait-busy)
[499.697090] Starting subtest: wait-busy
[499.699913] Starting dynamic subtest: pipe-A-eDP-1
[501.571241] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[501.588227] Starting dynamic subtest: pipe-D-eDP-1
[504.156494] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.581s)
[504.159365] Subtest wait-busy: SUCCESS (4.459s)
[504.977496] [053/133] (515s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[505.067209] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[505.069618] Starting dynamic subtest: pipe-A-default-mode
[506.236527] Dynamic subtest pipe-A-default-mode: SKIP (1.165s)
[506.241934] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.167s)
[506.405910] [054/133] (514s left) kms_psr (pr-cursor-plane-move)
[506.504372] Starting subtest: pr-cursor-plane-move
[506.509370] Subtest pr-cursor-plane-move: SKIP (0.000s)
[506.592241] [055/133] (513s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[506.652250] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[506.655167] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[506.783595] [056/133] (513s left) kms_cursor_crc (cursor-offscreen-128x42)
[507.012267] Starting subtest: cursor-offscreen-128x42
[507.059889] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[507.297942] [057/133] (513s left) perf (global-sseu-config-invalid)
[507.423077] Starting subtest: global-sseu-config-invalid
[507.426722] Subtest global-sseu-config-invalid: SKIP (0.000s)
[507.469150] [058/133] (513s left) kms_draw_crc (draw-method-mmap-cpu)
[507.565113] Starting subtest: draw-method-mmap-cpu
[507.567012] Starting dynamic subtest: xrgb8888-untiled
[507.785184] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[507.794787] Starting dynamic subtest: rgb565-untiled
[507.996416] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[508.006372] Starting dynamic subtest: xrgb2101010-untiled
[508.207077] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[508.217133] Starting dynamic subtest: xbgr16161616f-untiled
[508.429196] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[508.438867] Starting dynamic subtest: xrgb8888-xtiled
[508.562929] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[508.572854] Starting dynamic subtest: rgb565-xtiled
[508.696513] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[508.712537] Starting dynamic subtest: xrgb2101010-xtiled
[508.818347] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.119s)
[508.833366] Starting dynamic subtest: xbgr16161616f-xtiled
[508.951187] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[508.961182] Starting dynamic subtest: xrgb8888-4tiled
[509.084494] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[509.094257] Starting dynamic subtest: rgb565-4tiled
[509.217995] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[509.228375] Starting dynamic subtest: xrgb2101010-4tiled
[509.339839] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[509.350243] Starting dynamic subtest: xbgr16161616f-4tiled
[509.484141] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[509.486334] Subtest draw-method-mmap-cpu: SUCCESS (1.922s)
[509.602601] [059/133] (511s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[509.704480] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[516.535954] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.836s)
[516.676750] [060/133] (503s left) syncobj_timeline (device-signal-unordered)
[516.740057] Starting subtest: device-signal-unordered
[516.742779] Subtest device-signal-unordered: SUCCESS (0.000s)
[516.834671] [061/133] (503s left) vgem_basic (setversion)
[516.885494] Starting subtest: setversion
[516.890498] Subtest setversion: SUCCESS (0.000s)
[516.959855] [062/133] (503s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[517.068721] Starting subtest: psr-1p-primscrn-spr-indfb-move
[524.547552] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.483s)
[524.733802] [063/133] (496s left) kms_properties (crtc-properties-legacy)
[524.827123] Starting subtest: crtc-properties-legacy
[524.829656] Starting dynamic subtest: pipe-A-eDP-1
[525.275965] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[525.297411] Starting dynamic subtest: pipe-B-eDP-1
[526.411969] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.135s)
[526.422365] Starting dynamic subtest: pipe-C-eDP-1
[527.536949] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[527.548645] Starting dynamic subtest: pipe-D-eDP-1
[528.679207] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[528.681683] Subtest crtc-properties-legacy: SUCCESS (3.853s)
[529.511217] [064/133] (491s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[529.619171] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[533.227260] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.614s)
[534.422667] [065/133] (486s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[534.513246] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[534.538667] Starting dynamic subtest: pipe-A-plane-0
[534.544423] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[534.556922] Starting dynamic subtest: pipe-A-plane-3
[534.561777] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[534.574371] Starting dynamic subtest: pipe-A-plane-5
[534.579386] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[535.685980] Starting dynamic subtest: pipe-B-plane-0
[535.690834] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[535.701224] Starting dynamic subtest: pipe-B-plane-3
[535.706200] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[535.716424] Starting dynamic subtest: pipe-B-plane-5
[535.722008] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[536.006849] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (1.494s)
[536.886221] [066/133] (484s left) prime_mmap (test_aperture_limit)
[536.945132] Starting subtest: test_aperture_limit
[536.948063] Starting dynamic subtest: test_aperture_limit-smem
[536.953914] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[536.959357] Subtest test_aperture_limit: SKIP (0.008s)
[537.079713] [067/133] (483s left) kms_color (ctm-0-50)
[537.173359] Starting subtest: ctm-0-50
[537.175651] Starting dynamic subtest: pipe-A-eDP-1
[540.596018] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[540.606426] Starting dynamic subtest: pipe-B-eDP-1
[544.779200] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.182s)
[544.794257] Starting dynamic subtest: pipe-C-eDP-1
[548.765644] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.986s)
[548.775583] Starting dynamic subtest: pipe-D-eDP-1
[552.751352] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.983s)
[552.753933] Subtest ctm-0-50: SUCCESS (15.578s)
[553.585354] [068/133] (467s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[553.693157] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[553.698239] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[553.779411] [069/133] (467s left) kms_rotation_crc (sprite-rotation-180)
[553.872733] Starting subtest: sprite-rotation-180
[560.919913] Subtest sprite-rotation-180: SUCCESS (7.050s)
[562.144636] [070/133] (458s left) kms_psr (psr2-suspend)
[562.237521] Starting subtest: psr2-suspend
[562.239971] Starting dynamic subtest: eDP-1
[579.503735] Dynamic subtest eDP-1: SUCCESS (2.858s)
[579.506460] Subtest psr2-suspend: SUCCESS (2.860s)
[580.328000] [071/133] (440s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[580.439406] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[580.441732] Starting dynamic subtest: pipe-A-eDP-1
[580.500912] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[580.511605] Starting dynamic subtest: pipe-B-eDP-1
[580.563528] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[580.573580] Starting dynamic subtest: pipe-C-eDP-1
[580.636877] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.068s)
[580.652640] Starting dynamic subtest: pipe-D-eDP-1
[580.702016] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.065s)
[580.704539] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.260s)
[582.951982] [072/133] (438s left) gem_fence_thrash (bo-write-verify-y)
[583.003723] Starting subtest: bo-write-verify-y
[583.021945] Subtest bo-write-verify-y: SKIP (0.016s)
[583.109397] [073/133] (438s left) kms_content_protection (dp-mst-type-1)
[583.257179] Starting subtest: dp-mst-type-1
[583.262694] Subtest dp-mst-type-1: SKIP (0.000s)
[583.417143] [074/133] (437s left) gem_ctx_shared (disjoint-timelines)
[583.477606] Starting subtest: disjoint-timelines
[583.509625] Subtest disjoint-timelines: SUCCESS (0.031s)
[583.775808] [075/133] (437s left) kms_flip (absolute-wf_vblank-interruptible)
[583.873900] Starting subtest: absolute-wf_vblank-interruptible
[583.876547] Starting dynamic subtest: A-eDP1
[592.562605] Dynamic subtest A-eDP1: SUCCESS (8.617s)
[592.577607] Starting dynamic subtest: B-eDP1
[601.329598] Dynamic subtest B-eDP1: SUCCESS (8.738s)
[601.340676] Starting dynamic subtest: C-eDP1
[610.063278] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[610.075469] Starting dynamic subtest: D-eDP1
[618.788566] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[618.791390] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.813s)
[620.019224] [076/133] (401s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[620.122631] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[620.125367] Starting dynamic subtest: pipe-A-eDP-1
[631.124619] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.007s)
[631.136489] Starting dynamic subtest: pipe-B-eDP-1
[642.836920] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.707s)
[642.839743] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.716s)
[643.693916] [077/133] (377s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[643.797163] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[643.802475] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[643.921242] [078/133] (377s left) gem_exec_schedule (thriceslice)
[644.010704] Starting subtest: thriceslice
[644.013252] Starting dynamic subtest: rcs0
[644.027065] Dynamic subtest rcs0: SUCCESS (0.031s)
[644.037861] Starting dynamic subtest: bcs0
[644.080889] Dynamic subtest bcs0: SUCCESS (0.053s)
[644.094343] Starting dynamic subtest: vcs0
[644.113686] Dynamic subtest vcs0: SUCCESS (0.031s)
[644.123983] Starting dynamic subtest: vcs1
[644.143750] Dynamic subtest vcs1: SUCCESS (0.029s)
[644.154108] Starting dynamic subtest: vecs0
[644.173878] Dynamic subtest vecs0: SUCCESS (0.030s)
[644.183846] Starting dynamic subtest: ccs0
[644.227985] Dynamic subtest ccs0: SUCCESS (0.053s)
[644.230613] Subtest thriceslice: SUCCESS (0.233s)
[646.122223] [079/133] (375s left) syncobj_wait (single-wait-submitted)
[646.186892] Starting subtest: single-wait-submitted
[646.288649] Subtest single-wait-submitted: SUCCESS (0.104s)
[646.385867] [080/133] (375s left) kms_addfb_basic (bad-pitch-32)
[646.441783] Starting subtest: bad-pitch-32
[646.444278] Subtest bad-pitch-32: SUCCESS (0.000s)
[646.581684] [081/133] (375s left) gem_eio (hibernate)
[646.817267] Starting subtest: hibernate
[661.618268] Subtest hibernate: SUCCESS (14.794s)
[669.807293] [082/133] (359s left) gem_userptr_blits (huge-split)
[669.908613] Starting subtest: huge-split
[669.916163] Subtest huge-split: SUCCESS (0.008s)
[670.073276] [083/133] (359s left) gem_ctx_persistence (engines-cleanup)
[670.137857] Starting subtest: engines-cleanup
[670.140879] Starting dynamic subtest: rcs0
[670.250795] Dynamic subtest rcs0: SUCCESS (0.110s)
[670.263893] Starting dynamic subtest: bcs0
[670.283788] Dynamic subtest bcs0: SUCCESS (0.033s)
[670.294883] Starting dynamic subtest: vcs0
[670.388129] Dynamic subtest vcs0: SUCCESS (0.103s)
[670.400896] Starting dynamic subtest: vcs1
[670.454209] Dynamic subtest vcs1: SUCCESS (0.064s)
[670.467860] Starting dynamic subtest: vecs0
[670.528041] Dynamic subtest vecs0: SUCCESS (0.072s)
[670.541386] Starting dynamic subtest: ccs0
[670.600856] Dynamic subtest ccs0: SUCCESS (0.071s)
[670.603765] Subtest engines-cleanup: SUCCESS (0.465s)
[670.700187] [084/133] (359s left) gem_mmap_offset (clear-via-pagefault)
[670.756417] Starting subtest: clear-via-pagefault
[670.758581] Starting dynamic subtest: smem0
[706.486753] Dynamic subtest smem0: SUCCESS (35.721s)
[706.489461] Subtest clear-via-pagefault: SUCCESS (35.723s)
[706.623997] [085/133] (323s left) kms_psr (fbc-psr2-sprite-plane-move)
[706.718785] Starting subtest: fbc-psr2-sprite-plane-move
[706.721299] Starting dynamic subtest: eDP-1
[706.726424] Dynamic subtest eDP-1: SKIP (0.000s)
[706.731353] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[706.812413] [086/133] (323s left) kms_pm_rpm (package-g7)
[708.338902] Starting subtest: package-g7
[708.344458] Subtest package-g7: SKIP (0.000s)
[709.131261] [087/133] (320s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[709.237796] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[709.240119] Starting dynamic subtest: pipe-A-eDP-1
[709.985583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[709.996300] Starting dynamic subtest: pipe-B-eDP-1
[711.751780] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.767s)
[711.763853] Starting dynamic subtest: pipe-C-eDP-1
[713.579497] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.826s)
[713.591435] Starting dynamic subtest: pipe-D-eDP-1
[715.417771] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.836s)
[715.420472] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.171s)
[716.570334] [088/133] (313s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[716.679666] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[716.682516] Starting dynamic subtest: pipe-A-eDP-1
[716.709905] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[716.721706] Starting dynamic subtest: pipe-B-eDP-1
[716.747553] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[716.758589] Starting dynamic subtest: pipe-C-eDP-1
[716.785801] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[716.796511] Starting dynamic subtest: pipe-D-eDP-1
[716.824891] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[716.830446] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[718.946950] [089/133] (311s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[719.056902] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[719.062669] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[719.161675] [090/133] (310s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[719.219747] Starting subtest: etime-single-wait-all-for-submit-submitted
[719.321139] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[719.414399] [091/133] (310s left) prime_busy (before)
[719.483750] Starting subtest: before
[719.486745] Starting dynamic subtest: rcs0
[719.529847] Dynamic subtest rcs0: SUCCESS (0.045s)
[719.542706] Starting dynamic subtest: bcs0
[719.590425] Dynamic subtest bcs0: SUCCESS (0.060s)
[719.602787] Starting dynamic subtest: vcs0
[719.633149] Dynamic subtest vcs0: SUCCESS (0.042s)
[719.644242] Starting dynamic subtest: vcs1
[719.675000] Dynamic subtest vcs1: SUCCESS (0.041s)
[719.686386] Starting dynamic subtest: vecs0
[719.717253] Dynamic subtest vecs0: SUCCESS (0.041s)
[719.728734] Starting dynamic subtest: ccs0
[719.758895] Dynamic subtest ccs0: SUCCESS (0.041s)
[719.867102] Subtest before: SUCCESS (0.385s)
[719.957980] [092/133] (310s left) i915_drm_fdinfo (virtual-busy-idle-all)
[720.009115] Starting subtest: virtual-busy-idle-all
[720.014848] Subtest virtual-busy-idle-all: SKIP (0.000s)
[720.098416] [093/133] (310s left) kms_cursor_crc (cursor-random-256x85)
[720.368612] Starting subtest: cursor-random-256x85
[720.412889] Subtest cursor-random-256x85: SKIP (0.040s)
[720.625883] [094/133] (309s left) kms_properties (crtc-properties-atomic)
[720.715534] Starting subtest: crtc-properties-atomic
[720.718061] Starting dynamic subtest: pipe-A-eDP-1
[721.164193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[721.176683] Starting dynamic subtest: pipe-B-eDP-1
[722.300313] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.133s)
[722.312658] Starting dynamic subtest: pipe-C-eDP-1
[723.404025] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[723.416996] Starting dynamic subtest: pipe-D-eDP-1
[724.534800] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[724.537720] Subtest crtc-properties-atomic: SUCCESS (3.819s)
[725.359463] [095/133] (304s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[725.467676] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[725.472628] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[725.590550] [096/133] (304s left) perf_pmu (rc6)
[725.635143] Starting subtest: rc6
[725.637573] Starting dynamic subtest: gt0
[731.994573] Dynamic subtest gt0: SUCCESS (6.358s)
[732.007851] Starting dynamic subtest: runtime-pm-gt0
[739.706511] Dynamic subtest runtime-pm-gt0: SUCCESS (7.708s)
[739.719058] Starting dynamic subtest: runtime-pm-long-gt0
[752.214851] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.504s)
[752.229033] Starting dynamic subtest: other-idle-gt0
[758.559426] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[758.573787] Starting dynamic subtest: gt1
[764.900897] Dynamic subtest gt1: SUCCESS (6.338s)
[764.913193] Starting dynamic subtest: runtime-pm-gt1
[772.338880] Dynamic subtest runtime-pm-gt1: SUCCESS (7.434s)
[772.352160] Starting dynamic subtest: runtime-pm-long-gt1
[784.765391] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.422s)
[784.777551] Starting dynamic subtest: other-idle-gt1
[791.109724] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[791.112500] Subtest rc6: SUCCESS (65.465s)
[792.377274] [097/133] (237s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[792.503569] Starting subtest: flip-vs-cursor-crc-legacy
[793.159022] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.657s)
[793.991464] [098/133] (236s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[794.090023] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[794.092721] Starting dynamic subtest: pipe-A
[794.152891] Dynamic subtest pipe-A: SUCCESS (0.065s)
[794.165739] Starting dynamic subtest: pipe-B
[795.327044] Dynamic subtest pipe-B: SUCCESS (1.173s)
[795.340839] Starting dynamic subtest: pipe-C
[796.423869] Dynamic subtest pipe-C: SUCCESS (1.096s)
[796.435349] Starting dynamic subtest: pipe-D
[797.554425] Dynamic subtest pipe-D: SUCCESS (1.128s)
[797.557109] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.466s)
[798.703229] [099/133] (231s left) syncobj_timeline (single-wait-all-available-submitted)
[798.764735] Starting subtest: single-wait-all-available-submitted
[798.767316] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[798.843622] [100/133] (231s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[798.940437] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[798.942805] Starting dynamic subtest: pipe-A-eDP-1
[798.967368] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[798.979770] Starting dynamic subtest: pipe-B-eDP-1
[799.004068] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[799.015317] Starting dynamic subtest: pipe-C-eDP-1
[799.040629] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[799.051204] Starting dynamic subtest: pipe-D-eDP-1
[799.077090] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[799.082198] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[801.173088] [101/133] (229s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[801.282894] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[801.288914] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[801.378125] [102/133] (229s left) api_intel_bb (object-noreloc-keep-cache-simple)
[801.440054] Starting subtest: object-noreloc-keep-cache-simple
[801.445461] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[801.567791] [103/133] (229s left) perf_pmu (invalid-open)
[801.615711] Starting subtest: invalid-open
[801.618798] Subtest invalid-open: SUCCESS (0.000s)
[801.711311] [104/133] (228s left) kms_force_connector_basic (force-load-detect)
[801.801770] Starting subtest: force-load-detect
[801.806946] Subtest force-load-detect: SKIP (0.000s)
[801.897701] [105/133] (228s left) kms_lease (simple-lease)
[801.984506] Starting subtest: simple-lease
[801.986880] Starting dynamic subtest: pipe-A-eDP-1
[802.493551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.507s)
[802.505663] Starting dynamic subtest: pipe-B-eDP-1
[803.935935] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.442s)
[803.946889] Starting dynamic subtest: pipe-C-eDP-1
[805.337514] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.400s)
[805.350162] Starting dynamic subtest: pipe-D-eDP-1
[806.742109] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.402s)
[806.744708] Subtest simple-lease: SUCCESS (4.759s)
[807.539226] [106/133] (223s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[807.642572] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[807.647636] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[807.734692] [107/133] (223s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[807.826577] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[814.347865] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.524s)
[814.428443] [108/133] (216s left) gem_spin_batch (legacy)
[814.503029] Starting subtest: legacy
[814.505460] Starting dynamic subtest: default
[817.746691] Dynamic subtest default: SUCCESS (3.236s)
[817.764872] Starting dynamic subtest: render
[820.980395] Dynamic subtest render: SUCCESS (3.230s)
[820.994234] Starting dynamic subtest: bsd
[824.218006] Dynamic subtest bsd: SUCCESS (3.234s)
[824.231861] Starting dynamic subtest: bsd1
[827.466667] Dynamic subtest bsd1: SUCCESS (3.232s)
[827.484436] Starting dynamic subtest: bsd2
[830.692750] Dynamic subtest bsd2: SUCCESS (3.234s)
[830.704235] Starting dynamic subtest: blt
[833.932151] Dynamic subtest blt: SUCCESS (3.237s)
[833.946738] Starting dynamic subtest: vebox
[837.170223] Dynamic subtest vebox: SUCCESS (3.233s)
[837.173132] Subtest legacy: SUCCESS (22.658s)
[839.067305] [109/133] (191s left) kms_flip (dpms-vs-vblank-race)
[839.167337] Starting subtest: dpms-vs-vblank-race
[839.169807] Starting dynamic subtest: A-eDP1
[843.047260] Dynamic subtest A-eDP1: SUCCESS (3.878s)
[843.058574] Starting dynamic subtest: B-eDP1
[846.565263] Dynamic subtest B-eDP1: SUCCESS (3.513s)
[846.576855] Starting dynamic subtest: C-eDP1
[851.192882] Dynamic subtest C-eDP1: SUCCESS (4.625s)
[851.205304] Starting dynamic subtest: D-eDP1
[855.801131] Dynamic subtest D-eDP1: SUCCESS (4.606s)
[855.803684] Subtest dpms-vs-vblank-race: SUCCESS (16.630s)
[856.659130] [110/133] (174s left) gem_eio (banned)
[856.856389] Starting subtest: banned
[857.384349] Subtest banned: SUCCESS (0.527s)
[857.524762] [111/133] (173s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[857.622416] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[862.401619] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.780s)
[863.553853] [112/133] (167s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[863.626158] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[863.685612] [113/133] (167s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[863.791697] Starting subtest: pipe-fbc-rte
[863.799405] Starting dynamic subtest: pipe-B-eDP-1
[869.249050] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.460s)
[869.257709] Subtest pipe-fbc-rte: SUCCESS (5.462s)
[871.578269] [114/133] (159s left) kms_big_fb (x-tiled-addfb)
[871.698662] Starting subtest: x-tiled-addfb
[871.701254] Subtest x-tiled-addfb: SUCCESS (0.000s)
[871.796628] [115/133] (159s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[871.896729] Starting subtest: psr-farfromfence-mmap-gtt
[871.901642] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[871.970300] [116/133] (159s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[872.081200] Starting subtest: 4-tiled-8bpp-rotate-0
[873.351500] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.270s)
[873.476934] [117/133] (157s left) gem_eio (in-flight-external)
[873.698328] Starting subtest: in-flight-external
[875.127874] Subtest in-flight-external: SUCCESS (1.427s)
[875.258374] [118/133] (156s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[875.368155] Starting subtest: y-tiled-addfb-size-offset-overflow
[875.373653] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[875.429230] [119/133] (155s left) prime_self_import (basic-with_fd_dup)
[875.464400] Starting subtest: basic-with_fd_dup
[875.495742] Subtest basic-with_fd_dup: SUCCESS (0.030s)
[875.589347] [120/133] (155s left) i915_drm_fdinfo (busy-idle-check-all)
[875.630568] Starting subtest: busy-idle-check-all
[875.632910] Starting dynamic subtest: rcs0
[875.637928] Dynamic subtest rcs0: SKIP (0.004s)
[875.649133] Starting dynamic subtest: bcs0
[875.653699] Dynamic subtest bcs0: SKIP (0.000s)
[875.664674] Starting dynamic subtest: vcs0
[875.669638] Dynamic subtest vcs0: SKIP (0.000s)
[875.680334] Starting dynamic subtest: vcs1
[875.685498] Dynamic subtest vcs1: SKIP (0.000s)
[875.696779] Starting dynamic subtest: vecs0
[875.701857] Dynamic subtest vecs0: SKIP (0.000s)
[875.712808] Starting dynamic subtest: ccs0
[875.718496] Dynamic subtest ccs0: SKIP (0.000s)
[875.723587] Subtest busy-idle-check-all: SKIP (0.009s)
[875.764066] [121/133] (155s left) kms_getfb (getfb-handle-valid)
[875.913757] Starting subtest: getfb-handle-valid
[875.916685] Subtest getfb-handle-valid: SUCCESS (0.000s)
[875.990317] [122/133] (155s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[876.549242] Starting subtest: syncobj-timeline-multiple-ext-nodes
[876.556391] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[878.169281] [123/133] (153s left) gem_exec_params (no-vebox)
[878.234804] Starting subtest: no-vebox
[878.240754] Subtest no-vebox: SUCCESS (0.003s)
[880.145455] [124/133] (151s left) sysfs_timeslice_duration (idempotent)
[880.210487] Starting subtest: idempotent
[880.213162] Starting dynamic subtest: vecs0
[880.215653] Dynamic subtest vecs0: SUCCESS (0.000s)
[880.228090] Starting dynamic subtest: ccs0
[880.230493] Dynamic subtest ccs0: SUCCESS (0.000s)
[880.241674] Starting dynamic subtest: vcs0
[880.243661] Dynamic subtest vcs0: SUCCESS (0.000s)
[880.254581] Starting dynamic subtest: bcs0
[880.256790] Dynamic subtest bcs0: SUCCESS (0.000s)
[880.268005] Starting dynamic subtest: rcs0
[880.270533] Dynamic subtest rcs0: SUCCESS (0.000s)
[880.281024] Starting dynamic subtest: vcs1
[880.283540] Dynamic subtest vcs1: SUCCESS (0.000s)
[880.285846] Subtest idempotent: SUCCESS (0.006s)
[880.326575] [125/133] (151s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[880.442255] Starting subtest: fbc-farfromfence-mmap-gtt
[880.447097] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[880.531626] [126/133] (151s left) kms_async_flips (test-time-stamp)
[880.614670] Starting subtest: test-time-stamp
[881.005011] Starting dynamic subtest: pipe-A-eDP-1
[881.801667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.793s)
[882.172537] Starting dynamic subtest: pipe-B-eDP-1
[882.932480] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[883.313526] Starting dynamic subtest: pipe-C-eDP-1
[884.073509] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[884.441677] Starting dynamic subtest: pipe-D-eDP-1
[885.204159] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[885.207181] Subtest test-time-stamp: SUCCESS (4.588s)
[886.350519] [127/133] (145s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[886.459609] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[887.461719] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.001s)
[887.599604] [128/133] (144s left) gem_exec_schedule (out-order)
[887.667182] Starting subtest: out-order
[887.669387] Starting dynamic subtest: rcs0
[887.774790] Dynamic subtest rcs0: SUCCESS (0.118s)
[887.788851] Starting dynamic subtest: vcs0
[887.858170] Dynamic subtest vcs0: SUCCESS (0.082s)
[887.871351] Starting dynamic subtest: vcs1
[887.941690] Dynamic subtest vcs1: SUCCESS (0.083s)
[887.955679] Starting dynamic subtest: vecs0
[888.041689] Dynamic subtest vecs0: SUCCESS (0.099s)
[888.055132] Starting dynamic subtest: ccs0
[888.185541] Dynamic subtest ccs0: SUCCESS (0.142s)
[888.188294] Subtest out-order: SUCCESS (0.529s)
[889.175974] [129/133] (142s left) kms_psr (fbc-pr-cursor-plane-move)
[889.283864] Starting subtest: fbc-pr-cursor-plane-move
[889.288888] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[889.333916] [130/133] (142s left) kms_selftest (drm_format)
[889.371508] Starting subtest: drm_format
[889.388288] Starting dynamic subtest: drm_test_format_block_width_invalid
[889.529802] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.142s)
[889.541340] Starting dynamic subtest: drm_test_format_block_width_one_plane
[889.667904] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.137s)
[889.678909] Starting dynamic subtest: drm_test_format_block_width_two_plane
[889.794700] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.125s)
[889.807353] Starting dynamic subtest: drm_test_format_block_width_three_plane
[889.885735] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.091s)
[889.897715] Starting dynamic subtest: drm_test_format_block_width_tiled
[890.017166] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.129s)
[890.030174] Starting dynamic subtest: drm_test_format_block_height_invalid
[890.110903] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.095s)
[890.122543] Starting dynamic subtest: drm_test_format_block_height_one_plane
[890.231913] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.119s)
[890.242503] Starting dynamic subtest: drm_test_format_block_height_two_plane
[890.380674] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.146s)
[890.391568] Starting dynamic subtest: drm_test_format_block_height_three_plane
[890.512365] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.131s)
[890.523598] Starting dynamic subtest: drm_test_format_block_height_tiled
[890.623599] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.111s)
[890.634836] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[890.767698] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.142s)
[890.779499] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[890.923108] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.154s)
[890.934330] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[891.063538] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.139s)
[891.075462] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[891.214787] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.150s)
[891.227681] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[891.350625] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.134s)
[891.363032] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[891.499702] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.148s)
[891.512394] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[891.615473] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.116s)
[891.626657] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[891.736236] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.119s)
[891.738760] Subtest drm_format: SUCCESS (2.363s)
[891.890618] [131/133] (139s left) kms_psr (fbc-pr-primary-render)
[891.998562] Starting subtest: fbc-pr-primary-render
[892.003631] Subtest fbc-pr-primary-render: SKIP (0.000s)
[892.052223] [132/133] (139s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[892.159664] Starting subtest: fbc-psr2-cursor-plane-update-sf
[892.162672] Starting dynamic subtest: pipe-A-eDP-1
[892.231630] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[892.243046] Starting dynamic subtest: pipe-B-eDP-1
[893.346687] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s)
[893.351457] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.192s)
[894.517641] [133/133] (137s left) dmabuf (all-tests)
[894.552657] Starting subtest: all-tests
[894.555245] Starting dynamic subtest: sanitycheck
[894.673024] Dynamic subtest sanitycheck: SUCCESS (0.119s)
[894.688372] Starting dynamic subtest: dma_fence
[894.950665] Dynamic subtest dma_fence: SUCCESS (0.275s)
[894.966009] Starting dynamic subtest: dma_fence_chain
[903.332315] Dynamic subtest dma_fence_chain: SUCCESS (8.376s)
[903.347744] Starting dynamic subtest: dma_fence_unwrap
[903.466526] Dynamic subtest dma_fence_unwrap: SUCCESS (0.133s)
[903.482468] Starting dynamic subtest: dma_resv
[903.599037] Dynamic subtest dma_resv: SUCCESS (0.130s)
[903.601881] Subtest all-tests: SUCCESS (9.044s)
[903.642660] 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.