[62.879703] Initializing watchdogs
[62.879746]   /dev/watchdog0
[62.892243] [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]
[62.896571] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.898662] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.901828] [001/131] (960s left) kms_psr (fbc-psr-cursor-plane-onoff)
[63.067497] Starting subtest: fbc-psr-cursor-plane-onoff
[63.069766] Starting dynamic subtest: eDP-1
[63.073910] Dynamic subtest eDP-1: SKIP (0.000s)
[63.077992] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[63.128891] [002/131] (960s left) gem_exec_balancer (parallel)
[63.372884] Starting subtest: parallel
[64.095684] Subtest parallel: SUCCESS (0.727s)
[64.969921] [003/131] (958s left) gem_busy (busy)
[65.027218] Starting subtest: busy
[65.029538] Starting dynamic subtest: all-engines
[65.108074] Dynamic subtest all-engines: SUCCESS (0.081s)
[65.114980] Starting dynamic subtest: rcs0
[66.932818] Dynamic subtest rcs0: SUCCESS (1.829s)
[66.941782] Starting dynamic subtest: bcs0
[66.995088] Dynamic subtest bcs0: SUCCESS (0.062s)
[67.003057] Starting dynamic subtest: vcs0
[67.035428] Dynamic subtest vcs0: SUCCESS (0.040s)
[67.041272] Starting dynamic subtest: vcs1
[68.911242] Dynamic subtest vcs1: SUCCESS (1.878s)
[68.918907] Starting dynamic subtest: vecs0
[70.957576] Dynamic subtest vecs0: SUCCESS (2.050s)
[70.965542] Starting dynamic subtest: ccs0
[72.943671] Dynamic subtest ccs0: SUCCESS (1.987s)
[72.946290] Subtest busy: SUCCESS (7.929s)
[73.308971] [004/131] (950s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[73.437603] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[73.442140] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[73.547544] [005/131] (949s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[73.608599] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[73.662628] [006/131] (949s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[73.773286] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[73.777479] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[73.880320] [007/131] (949s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[73.989330] Starting subtest: fbcpsr-stridechange
[77.994459] Subtest fbcpsr-stridechange: SUCCESS (4.011s)
[78.111602] [008/131] (945s left) gem_userptr_blits (sync-unmap)
[78.184134] Starting subtest: sync-unmap
[78.202945] Subtest sync-unmap: SUCCESS (0.017s)
[78.352362] [009/131] (945s left) gem_ctx_param (non-root-set)
[78.406509] Starting subtest: non-root-set
[78.436497] Subtest non-root-set: SUCCESS (0.030s)
[78.521355] [010/131] (945s left) kms_scaling_modes (scaling-mode-full)
[78.620912] Starting subtest: scaling-mode-full
[78.623281] Starting dynamic subtest: pipe-A-eDP-1
[78.732465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.111s)
[78.739154] Starting dynamic subtest: pipe-B-eDP-1
[79.910791] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s)
[79.919840] Starting dynamic subtest: pipe-C-eDP-1
[81.109085] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[81.117615] Starting dynamic subtest: pipe-D-eDP-1
[82.234027] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[82.236339] Subtest scaling-mode-full: SUCCESS (3.615s)
[83.391604] [011/131] (940s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[83.487786] Starting subtest: fb-8bpc-vs-panel-8bpc
[83.490165] Starting dynamic subtest: pipe-A-eDP-1
[84.861676] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.372s)
[84.864106] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.373s)
[85.649142] [012/131] (938s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[85.753250] Starting subtest: x-tiled-8bpp-rotate-270
[85.773142] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[85.881742] [013/131] (937s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[86.262224] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[87.065412] [014/131] (936s left) kms_color (invalid-degamma-lut-sizes)
[87.160350] Starting subtest: invalid-degamma-lut-sizes
[87.162881] Starting dynamic subtest: pipe-A
[87.445132] Dynamic subtest pipe-A: SUCCESS (0.282s)
[87.453338] Starting dynamic subtest: pipe-B
[87.455677] Dynamic subtest pipe-B: SUCCESS (0.001s)
[87.462316] Starting dynamic subtest: pipe-C
[87.464723] Dynamic subtest pipe-C: SUCCESS (0.001s)
[87.471248] Starting dynamic subtest: pipe-D
[87.473167] Dynamic subtest pipe-D: SUCCESS (0.001s)
[87.475084] Subtest invalid-degamma-lut-sizes: SUCCESS (0.284s)
[88.299160] [015/131] (935s left) kms_async_flips (async-flip-with-page-flip-events)
[88.400956] Starting subtest: async-flip-with-page-flip-events
[88.759126] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs
[89.492291] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.730s)
[89.498659] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[91.726788] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.236s)
[91.758385] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc
[91.990918] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.262s)
[91.997789] Starting dynamic subtest: pipe-A-eDP-1-4
[94.238402] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.249s)
[94.250626] Starting dynamic subtest: pipe-A-eDP-1-x
[96.527016] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.289s)
[96.535464] Starting dynamic subtest: pipe-A-eDP-1-linear
[98.805586] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.278s)
[99.167683] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs
[99.917295] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.754s)
[99.924489] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[102.161945] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.247s)
[102.170117] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc
[102.428657] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.263s)
[102.436138] Starting dynamic subtest: pipe-B-eDP-1-4
[104.673686] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.247s)
[104.682080] Starting dynamic subtest: pipe-B-eDP-1-x
[106.962572] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.289s)
[106.972616] Starting dynamic subtest: pipe-B-eDP-1-linear
[109.251808] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.289s)
[109.612443] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs
[110.344063] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.735s)
[110.351602] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[112.589336] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.246s)
[112.602098] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc
[112.842211] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.251s)
[112.850670] Starting dynamic subtest: pipe-C-eDP-1-4
[115.100910] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.260s)
[115.111031] Starting dynamic subtest: pipe-C-eDP-1-x
[117.389288] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.289s)
[117.399102] Starting dynamic subtest: pipe-C-eDP-1-linear
[119.667275] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.278s)
[120.028927] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs
[120.767034] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.744s)
[120.774839] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[123.011774] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.246s)
[123.020123] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc
[123.264231] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.251s)
[123.271253] Starting dynamic subtest: pipe-D-eDP-1-4
[125.522544] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.260s)
[125.529895] Starting dynamic subtest: pipe-D-eDP-1-x
[127.822516] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.300s)
[127.829415] Starting dynamic subtest: pipe-D-eDP-1-linear
[130.111621] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.289s)
[130.113917] Subtest async-flip-with-page-flip-events: SUCCESS (41.709s)
[131.237662] [016/131] (892s left) gem_mmap_gtt (basic-copy)
[131.298703] Subtest basic-copy: SKIP (0.000s)
[131.354211] [017/131] (892s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[131.437810] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[131.543475] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.105s)
[131.610528] [018/131] (892s left) kms_cursor_crc (cursor-sliding-128x42)
[131.809715] Starting subtest: cursor-sliding-128x42
[131.849104] Subtest cursor-sliding-128x42: SKIP (0.035s)
[132.037242] [019/131] (891s left) i915_selftest (mock)
[135.518839] Starting subtest: mock
[135.521910] Starting dynamic subtest: sanitycheck
[136.081597] Dynamic subtest sanitycheck: SUCCESS (0.563s)
[136.089383] Starting dynamic subtest: shmem
[136.693088] Dynamic subtest shmem: SUCCESS (0.611s)
[136.699074] Starting dynamic subtest: fence
[144.104046] Dynamic subtest fence: SUCCESS (7.409s)
[144.112322] Starting dynamic subtest: scatterlist
[145.692775] Dynamic subtest scatterlist: SUCCESS (1.588s)
[145.701040] Starting dynamic subtest: syncmap
[149.118426] Dynamic subtest syncmap: SUCCESS (3.424s)
[149.126694] Starting dynamic subtest: uncore
[149.704315] Dynamic subtest uncore: SUCCESS (0.586s)
[149.712685] Starting dynamic subtest: ring
[150.266567] Dynamic subtest ring: SUCCESS (0.561s)
[150.275322] Starting dynamic subtest: engine
[150.881862] Dynamic subtest engine: SUCCESS (0.614s)
[150.890506] Starting dynamic subtest: timelines
[154.344382] Dynamic subtest timelines: SUCCESS (3.461s)
[154.352687] Starting dynamic subtest: requests
[157.648341] Dynamic subtest requests: SUCCESS (3.303s)
[157.656307] Starting dynamic subtest: objects
[158.383982] Dynamic subtest objects: SUCCESS (0.735s)
[158.392525] Starting dynamic subtest: phys
[159.086047] Dynamic subtest phys: SUCCESS (0.701s)
[159.094045] Starting dynamic subtest: dmabuf
[159.783244] Dynamic subtest dmabuf: SUCCESS (0.696s)
[159.791524] Starting dynamic subtest: vma
[164.666205] Dynamic subtest vma: SUCCESS (4.883s)
[164.673197] Starting dynamic subtest: evict
[165.907978] Dynamic subtest evict: SUCCESS (1.241s)
[165.914863] Starting dynamic subtest: gtt
[168.915251] Dynamic subtest gtt: SUCCESS (3.007s)
[168.923818] Starting dynamic subtest: hugepages
[169.703074] Dynamic subtest hugepages: SUCCESS (0.787s)
[169.711347] Starting dynamic subtest: memory_region
[173.229540] Dynamic subtest memory_region: SUCCESS (3.526s)
[173.232186] Subtest mock: SUCCESS (37.712s)
[173.252711] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[173.255819] [020/131] (850s left) kms_hdr (bpc-switch-suspend)
[176.588178] Starting subtest: bpc-switch-suspend
[177.646050] Starting dynamic subtest: pipe-A-eDP-1
[197.114580] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.610s)
[197.116998] Subtest bpc-switch-suspend: SUCCESS (5.668s)
[197.225164] [FACT kms_hdr (bpc-switch-suspend)] new: kernel.kmod_is_loaded.amdgpu: true
[197.225319] [FACT kms_hdr (bpc-switch-suspend)] new: kernel.kmod_is_loaded.i915: true
[197.225915] [FACT kms_hdr (bpc-switch-suspend)] new: kernel.kmod_is_loaded.xe: true
[197.229076] [021/131] (841s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[197.338555] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[197.342591] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[197.442622] [022/131] (841s left) api_intel_bb (intel-bb-blit-x)
[197.506505] Starting subtest: intel-bb-blit-x
[201.088052] Subtest intel-bb-blit-x: SUCCESS (3.629s)
[201.220038] [023/131] (837s left) kms_psr (pr-sprite-blt)
[201.320642] Starting subtest: pr-sprite-blt
[201.325082] Subtest pr-sprite-blt: SKIP (0.000s)
[201.426926] [024/131] (837s left) kms_cursor_crc (cursor-size-change)
[201.527257] Starting subtest: cursor-size-change
[201.529467] Starting dynamic subtest: pipe-A-eDP-1
[202.338966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s)
[202.348208] Starting dynamic subtest: pipe-D-eDP-1
[203.804934] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.475s)
[203.807386] Subtest cursor-size-change: SUCCESS (2.295s)
[204.642149] [025/131] (834s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[204.738300] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[204.740996] Starting dynamic subtest: pipe-A-eDP-1
[204.760710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[204.770246] Starting dynamic subtest: pipe-B-eDP-1
[204.788448] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[204.795589] Starting dynamic subtest: pipe-C-eDP-1
[204.813965] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[204.821072] Starting dynamic subtest: pipe-D-eDP-1
[204.840513] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[204.842355] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[206.878950] [026/131] (832s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[206.987844] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[211.922003] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.956s)
[212.040193] [027/131] (826s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[212.170179] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[212.301894] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.135s)
[212.421517] [028/131] (826s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[212.534440] Starting subtest: x-tiled-64bpp-rotate-180
[214.796156] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.268s)
[215.050460] [029/131] (824s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[215.155730] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[215.159976] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[215.247043] [030/131] (823s left) kms_vblank (ts-continuation-dpms-suspend)
[215.341242] Starting subtest: ts-continuation-dpms-suspend
[215.343614] Starting dynamic subtest: pipe-A-eDP-1
[232.539234] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.866s)
[232.552893] Starting dynamic subtest: pipe-D-eDP-1
[250.411086] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.316s)
[250.413801] Subtest ts-continuation-dpms-suspend: SUCCESS (4.186s)
[251.036480] [031/131] (818s left) prime_busy (hang-wait)
[251.097625] Starting subtest: hang-wait
[251.100137] Starting dynamic subtest: rcs0
[277.207913] Dynamic subtest rcs0: SUCCESS (26.244s)
[277.215818] Starting dynamic subtest: bcs0
[284.377971] Dynamic subtest bcs0: SUCCESS (7.162s)
[284.389270] Starting dynamic subtest: vcs0
[291.349998] Dynamic subtest vcs0: SUCCESS (6.968s)
[291.360913] Starting dynamic subtest: vcs1
[298.331261] Dynamic subtest vcs1: SUCCESS (6.976s)
[298.349250] Starting dynamic subtest: vecs0
[305.362441] Dynamic subtest vecs0: SUCCESS (7.031s)
[305.372872] Starting dynamic subtest: ccs0
[319.197991] Dynamic subtest ccs0: SUCCESS (13.838s)
[319.200971] Subtest hang-wait: SUCCESS (68.230s)
[319.316508] [032/131] (750s left) gem_exec_schedule (smoketest)
[319.506240] Starting subtest: smoketest
[319.508885] Starting dynamic subtest: rcs0
[325.111716] Dynamic subtest rcs0: SUCCESS (5.532s)
[325.121437] Starting dynamic subtest: bcs0
[330.624836] Dynamic subtest bcs0: SUCCESS (5.524s)
[330.634726] Starting dynamic subtest: vcs0
[336.169532] Dynamic subtest vcs0: SUCCESS (5.531s)
[336.179253] Starting dynamic subtest: vcs1
[341.666348] Dynamic subtest vcs1: SUCCESS (5.514s)
[341.676296] Starting dynamic subtest: vecs0
[347.214542] Dynamic subtest vecs0: SUCCESS (5.540s)
[347.223887] Starting dynamic subtest: ccs0
[352.704227] Dynamic subtest ccs0: SUCCESS (5.492s)
[352.706983] Subtest smoketest: SUCCESS (33.138s)
[352.820675] [033/131] (717s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[352.917699] Starting subtest: plane-primary-overlay-mutable-zpos
[356.324405] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.401s)
[357.496444] [034/131] (712s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[357.596218] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[357.601648] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[357.680016] [035/131] (712s left) kms_plane (plane-position-covered)
[357.766830] Starting subtest: plane-position-covered
[358.271821] Starting dynamic subtest: pipe-A-plane-1
[359.552773] Dynamic subtest pipe-A-plane-1: SUCCESS (1.279s)
[359.561164] Starting dynamic subtest: pipe-A-plane-2
[360.786573] Dynamic subtest pipe-A-plane-2: SUCCESS (1.233s)
[360.796275] Starting dynamic subtest: pipe-A-plane-3
[362.012901] Dynamic subtest pipe-A-plane-3: SUCCESS (1.226s)
[362.022942] Starting dynamic subtest: pipe-A-plane-4
[363.231095] Dynamic subtest pipe-A-plane-4: SUCCESS (1.219s)
[363.239920] Starting dynamic subtest: pipe-A-plane-5
[363.269150] Dynamic subtest pipe-A-plane-5: SUCCESS (0.036s)
[364.370902] Starting dynamic subtest: pipe-B-plane-1
[365.599061] Dynamic subtest pipe-B-plane-1: SUCCESS (1.234s)
[365.609169] Starting dynamic subtest: pipe-B-plane-2
[366.804985] Dynamic subtest pipe-B-plane-2: SUCCESS (1.205s)
[366.813091] Starting dynamic subtest: pipe-B-plane-3
[368.039126] Dynamic subtest pipe-B-plane-3: SUCCESS (1.232s)
[368.047224] Starting dynamic subtest: pipe-B-plane-4
[369.274665] Dynamic subtest pipe-B-plane-4: SUCCESS (1.237s)
[369.283735] Starting dynamic subtest: pipe-B-plane-5
[369.315672] Dynamic subtest pipe-B-plane-5: SUCCESS (0.039s)
[369.318213] Subtest plane-position-covered: SUCCESS (11.544s)
[370.060471] [036/131] (700s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[370.122685] Starting subtest: y-tiled-to-vebox-y-tiled
[370.128014] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[370.297225] [037/131] (699s left) syncobj_timeline (invalid-transfer-illegal-handle)
[370.347214] Starting subtest: invalid-transfer-illegal-handle
[370.350241] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[370.454359] [038/131] (699s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[370.559675] Starting subtest: flip-vs-cursor-atomic-transitions
[377.834260] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.274s)
[378.701514] [039/131] (691s left) gem_exec_parallel (basic)
[378.768269] Starting subtest: basic
[378.771148] Starting dynamic subtest: rcs0
[380.513057] Dynamic subtest rcs0: SUCCESS (1.744s)
[380.523572] Starting dynamic subtest: bcs0
[382.187584] Dynamic subtest bcs0: SUCCESS (1.674s)
[382.196476] Starting dynamic subtest: vcs0
[385.673540] Dynamic subtest vcs0: SUCCESS (3.483s)
[385.685095] Starting dynamic subtest: vcs1
[387.656599] Dynamic subtest vcs1: SUCCESS (1.982s)
[387.668027] Starting dynamic subtest: vecs0
[389.707322] Dynamic subtest vecs0: SUCCESS (2.048s)
[389.718263] Starting dynamic subtest: ccs0
[391.582899] Dynamic subtest ccs0: SUCCESS (1.875s)
[391.585945] Subtest basic: SUCCESS (12.815s)
[391.759176] [040/131] (678s left) kms_prime (basic-crc-vgem)
[391.890174] Starting subtest: basic-crc-vgem
[391.893294] Starting dynamic subtest: second-to-first
[392.824478] Dynamic subtest second-to-first: SUCCESS (0.937s)
[392.827055] Subtest basic-crc-vgem: SUCCESS (0.938s)
[392.899389] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[392.902735] [041/131] (677s left) i915_pm_rps (engine-order)
[393.005741] Starting subtest: engine-order
[397.498442] Subtest engine-order: SUCCESS (4.491s)
[397.579158] [042/131] (672s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[397.728935] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[397.731470] Starting dynamic subtest: pipe-A
[397.748722] Dynamic subtest pipe-A: SKIP (0.011s)
[397.757898] Starting dynamic subtest: pipe-B
[397.767727] Dynamic subtest pipe-B: SKIP (0.021s)
[397.779023] Starting dynamic subtest: pipe-C
[397.793686] Dynamic subtest pipe-C: SKIP (0.023s)
[397.802212] Starting dynamic subtest: pipe-D
[397.812681] Dynamic subtest pipe-D: SKIP (0.020s)
[397.816932] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.077s)
[397.918488] [043/131] (672s left) gem_exec_suspend (basic)
[397.989411] Starting subtest: basic
[397.992218] Starting dynamic subtest: smem
[399.691251] Dynamic subtest smem: SUCCESS (1.700s)
[399.694254] Subtest basic: SUCCESS (1.702s)
[399.872683] [044/131] (670s left) gem_readwrite (new-obj)
[399.928121] Subtest new-obj: SKIP (0.000s)
[399.985555] [045/131] (670s left) kms_big_fb (4-tiled-addfb-size-overflow)
[400.090940] Starting subtest: 4-tiled-addfb-size-overflow
[400.093074] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[400.194003] [046/131] (670s left) gem_exec_schedule (preempt-queue-contexts)
[400.276687] Subtest preempt-queue-contexts: SKIP (0.000s)
[400.550755] [047/131] (669s left) gem_exec_parallel (fds)
[400.622244] Starting subtest: fds
[400.624963] Starting dynamic subtest: rcs0
[404.137087] Dynamic subtest rcs0: SUCCESS (3.513s)
[404.147143] Starting dynamic subtest: bcs0
[408.724161] Dynamic subtest bcs0: SUCCESS (4.587s)
[408.736384] Starting dynamic subtest: vcs0
[412.967350] Dynamic subtest vcs0: SUCCESS (4.242s)
[412.979650] Starting dynamic subtest: vcs1
[416.946998] Dynamic subtest vcs1: SUCCESS (3.979s)
[416.955975] Starting dynamic subtest: vecs0
[420.998201] Dynamic subtest vecs0: SUCCESS (4.050s)
[421.007268] Starting dynamic subtest: ccs0
[425.495711] Dynamic subtest ccs0: SUCCESS (4.499s)
[425.498880] Subtest fds: SUCCESS (24.877s)
[425.685722] [048/131] (644s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[425.785625] Starting subtest: bad-rotation-90-y-tiled-ccs
[425.788234] Starting dynamic subtest: pipe-A-eDP-1
[425.814673] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[425.823237] Starting dynamic subtest: pipe-B-eDP-1
[425.849128] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[425.857341] Starting dynamic subtest: pipe-C-eDP-1
[425.883234] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[425.891154] Starting dynamic subtest: pipe-D-eDP-1
[425.917068] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[425.922205] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[427.929521] [049/131] (642s left) i915_pm_rc6_residency (rc6-fence)
[427.991960] Starting subtest: rc6-fence
[428.014109] Starting dynamic subtest: gt0
[440.338659] Dynamic subtest gt0: SUCCESS (12.327s)
[440.350230] Starting dynamic subtest: gt1
[454.665489] Dynamic subtest gt1: SUCCESS (14.326s)
[454.669633] Subtest rc6-fence: SUCCESS (26.680s)
[454.738968] [050/131] (615s left) kms_frontbuffer_tracking (psr-suspend)
[454.843687] Starting subtest: psr-suspend
[491.210008] Subtest psr-suspend: SUCCESS (5.472s)
[491.349524] [051/131] (610s left) kms_psr (psr-basic)
[491.459862] Starting subtest: psr-basic
[491.462278] Starting dynamic subtest: eDP-1
[493.081458] Dynamic subtest eDP-1: SUCCESS (1.649s)
[493.083725] Subtest psr-basic: SUCCESS (1.650s)
[493.936718] [052/131] (607s left) syncobj_timeline (single-wait-all-signaled)
[493.995200] Starting subtest: single-wait-all-signaled
[493.998065] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[494.084966] [053/131] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[494.188206] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[494.193140] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[494.291257] [054/131] (607s left) gem_mmap_gtt (basic-small-bo)
[494.353071] Subtest basic-small-bo: SKIP (0.000s)
[494.407059] [055/131] (607s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[494.495683] Starting subtest: primary-yf-tiled-reflect-x-90
[494.500812] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[494.562684] [056/131] (607s left) gem_ppgtt (blt-vs-render-ctxn)
[494.628117] Starting subtest: blt-vs-render-ctxN
[527.701966] Subtest blt-vs-render-ctxN: SUCCESS (33.154s)
[527.855586] [057/131] (573s left) gem_mmap_wc (read-write)
[527.958131] Subtest read-write: SKIP (0.000s)
[528.014586] [058/131] (573s left) prime_busy (after-wait)
[528.065335] Starting subtest: after-wait
[528.067928] Starting dynamic subtest: rcs0
[528.122600] Dynamic subtest rcs0: SUCCESS (0.054s)
[528.134267] Starting dynamic subtest: bcs0
[528.214291] Dynamic subtest bcs0: SUCCESS (0.092s)
[528.225857] Starting dynamic subtest: vcs0
[528.259306] Dynamic subtest vcs0: SUCCESS (0.044s)
[528.269280] Starting dynamic subtest: vcs1
[528.302039] Dynamic subtest vcs1: SUCCESS (0.042s)
[528.312184] Starting dynamic subtest: vecs0
[528.344177] Dynamic subtest vecs0: SUCCESS (0.040s)
[528.364145] Starting dynamic subtest: ccs0
[528.385785] Dynamic subtest ccs0: SUCCESS (0.042s)
[528.494838] Subtest after-wait: SUCCESS (0.429s)
[528.565772] [059/131] (573s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[528.682085] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[528.684766] Starting dynamic subtest: pipe-A-default-mode
[529.803187] Dynamic subtest pipe-A-default-mode: SKIP (1.116s)
[529.808723] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.118s)
[529.940886] [060/131] (571s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[530.044289] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[530.049319] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[530.127606] [061/131] (571s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[530.228700] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[530.233878] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[530.339166] [062/131] (571s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[530.437024] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[530.439662] Starting dynamic subtest: pipe-A
[530.450073] Dynamic subtest pipe-A: SKIP (0.005s)
[530.461072] Starting dynamic subtest: pipe-B
[530.471326] Dynamic subtest pipe-B: SKIP (0.015s)
[530.481098] Starting dynamic subtest: pipe-C
[530.491650] Dynamic subtest pipe-C: SKIP (0.015s)
[530.500813] Starting dynamic subtest: pipe-D
[530.509706] Dynamic subtest pipe-D: SKIP (0.016s)
[530.514140] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.052s)
[530.602786] [063/131] (571s left) sw_sync (sync_merge_same)
[530.654039] Starting subtest: sync_merge_same
[530.656776] Subtest sync_merge_same: SUCCESS (0.000s)
[530.710272] [064/131] (571s left) gem_create (hog-create)
[530.763936] Starting subtest: hog-create
[530.765961] Starting dynamic subtest: smem0
[563.672900] Dynamic subtest smem0: SUCCESS (32.923s)
[563.676043] Subtest hog-create: SUCCESS (32.924s)
[563.855155] [065/131] (538s left) gem_exec_params (invalid-bsd1-flag-on-render)
[563.929185] Starting subtest: invalid-bsd1-flag-on-render
[563.931977] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[564.038609] [066/131] (537s left) kms_flip (flip-vs-expired-vblank)
[564.148059] Starting subtest: flip-vs-expired-vblank
[564.150668] Starting dynamic subtest: A-eDP1
[572.844050] Dynamic subtest A-eDP1: SUCCESS (8.696s)
[572.857390] Starting dynamic subtest: B-eDP1
[581.574318] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[581.584889] Starting dynamic subtest: C-eDP1
[590.291451] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[590.301101] Starting dynamic subtest: D-eDP1
[599.015768] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[599.022178] Subtest flip-vs-expired-vblank: SUCCESS (34.864s)
[600.167855] [067/131] (501s left) gem_mmap_wc (coherency)
[600.231309] Subtest coherency: SKIP (0.000s)
[600.291062] [068/131] (501s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[600.392090] Starting subtest: yf-tiled-64bpp-rotate-270
[600.397138] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[600.485714] [069/131] (501s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[600.592881] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[600.598156] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[600.697572] [070/131] (501s left) kms_cursor_crc (cursor-random-256x85)
[600.946736] Starting subtest: cursor-random-256x85
[600.984647] Subtest cursor-random-256x85: SKIP (0.032s)
[601.170677] [071/131] (500s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[601.261345] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[601.263541] Starting dynamic subtest: pipe-A-eDP-1
[601.286046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[601.295425] Starting dynamic subtest: pipe-B-eDP-1
[601.320213] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[601.328882] Starting dynamic subtest: pipe-C-eDP-1
[601.351960] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[601.360451] Starting dynamic subtest: pipe-D-eDP-1
[601.384507] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[601.388930] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[603.431126] [072/131] (498s left) kms_rmfb (rmfb-ioctl)
[603.536334] Starting subtest: rmfb-ioctl
[603.538954] Starting dynamic subtest: pipe-A-eDP-1
[603.664213] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.126s)
[603.676089] Starting dynamic subtest: pipe-B-eDP-1
[604.783788] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.118s)
[604.794679] Starting dynamic subtest: pipe-C-eDP-1
[605.892544] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[605.902010] Starting dynamic subtest: pipe-D-eDP-1
[607.011625] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s)
[607.014299] Subtest rmfb-ioctl: SUCCESS (3.475s)
[608.125124] [073/131] (494s left) gem_flink_basic (flink-lifetime)
[608.192097] Starting subtest: flink-lifetime
[608.195152] Subtest flink-lifetime: SUCCESS (0.002s)
[608.279825] [074/131] (493s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[608.373794] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[608.376312] Starting dynamic subtest: pipe-A-eDP-1
[625.215398] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.456s)
[625.226906] Starting dynamic subtest: pipe-B-eDP-1
[642.083286] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.309s)
[642.092901] Starting dynamic subtest: pipe-C-eDP-1
[659.059450] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.290s)
[659.068871] Starting dynamic subtest: pipe-D-eDP-1
[676.072059] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s)
[676.074200] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.316s)
[677.258125] [075/131] (484s left) perf (polling)
[677.383485] Starting subtest: polling
[677.385748] Starting dynamic subtest: 0-rcs0
[687.490726] Dynamic subtest 0-rcs0: FAIL (10.142s)
[687.502020] Starting dynamic subtest: 1-vcs0
[697.463821] Dynamic subtest 1-vcs0: SUCCESS (10.049s)
[697.466987] Subtest polling: FAIL (20.193s)
[697.509143] [076/131] (464s left) kms_addfb_basic (size-max)
[697.622282] Starting subtest: size-max
[697.624596] Subtest size-max: SUCCESS (0.000s)
[697.730795] [077/131] (463s left) kms_psr2_su (frontbuffer-xrgb8888)
[697.779827] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[697.842342] [078/131] (463s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[697.934065] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[697.936389] Starting dynamic subtest: pipe-A-default-mode
[700.639431] Dynamic subtest pipe-A-default-mode: SUCCESS (2.706s)
[700.641692] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.708s)
[701.498134] [079/131] (460s left) kms_invalid_mode (int-max-clock)
[701.602221] Starting subtest: int-max-clock
[701.604948] Starting dynamic subtest: pipe-A-eDP-1
[701.882406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[701.891995] Starting dynamic subtest: pipe-B-eDP-1
[701.894170] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[701.903448] Starting dynamic subtest: pipe-C-eDP-1
[701.905781] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[701.914640] Starting dynamic subtest: pipe-D-eDP-1
[701.916637] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[701.918643] Subtest int-max-clock: SUCCESS (0.287s)
[702.722266] [080/131] (458s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[702.786309] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[702.858307] [081/131] (458s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[702.972858] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[702.977073] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[703.078782] [082/131] (458s left) kms_dirtyfb (default-dirtyfb-ioctl)
[703.180170] Starting subtest: default-dirtyfb-ioctl
[703.182294] Starting dynamic subtest: A-eDP-1
[704.802396] Dynamic subtest A-eDP-1: SUCCESS (1.621s)
[704.804743] Subtest default-dirtyfb-ioctl: SUCCESS (1.623s)
[705.645503] [083/131] (456s left) gem_exec_schedule (deep)
[705.833123] Starting subtest: deep
[705.835481] Starting dynamic subtest: rcs0
[710.012762] Dynamic subtest rcs0: SKIP (4.173s)
[710.026386] Starting dynamic subtest: vcs0
[719.552013] Dynamic subtest vcs0: SUCCESS (9.536s)
[719.564667] Starting dynamic subtest: vcs1
[729.887112] Dynamic subtest vcs1: SUCCESS (10.334s)
[729.899747] Starting dynamic subtest: vecs0
[739.945681] Dynamic subtest vecs0: SUCCESS (10.059s)
[739.960735] Starting dynamic subtest: ccs0
[750.644892] Dynamic subtest ccs0: SUCCESS (10.700s)
[750.647849] Subtest deep: SUCCESS (44.806s)
[752.491458] [084/131] (409s left) kms_pm_rpm (modeset-lpsp-stress)
[754.249977] Starting subtest: modeset-lpsp-stress
[770.540561] Subtest modeset-lpsp-stress: SUCCESS (16.293s)
[770.621368] [085/131] (391s left) gem_pxp (reject-modify-context-protection-on)
[770.735681] Starting subtest: reject-modify-context-protection-on
[770.738042] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[770.849937] [086/131] (391s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[771.241646] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[771.998361] [087/131] (389s left) syncobj_timeline (etime-single-wait-submitted)
[772.056308] Starting subtest: etime-single-wait-submitted
[772.158002] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[772.232638] [088/131] (389s left) kms_lease (master-vs-lease)
[772.330293] Starting subtest: master-vs-lease
[772.333517] Subtest master-vs-lease: SUCCESS (0.002s)
[772.444299] [089/131] (389s left) perf_pmu (busy-hang)
[772.488331] Starting subtest: busy-hang
[772.490304] Starting dynamic subtest: rcs0
[773.796901] Dynamic subtest rcs0: SUCCESS (1.307s)
[773.809442] Starting dynamic subtest: bcs0
[775.026459] Dynamic subtest bcs0: SUCCESS (1.227s)
[775.048652] Starting dynamic subtest: vcs0
[777.628019] Dynamic subtest vcs0: SUCCESS (2.599s)
[777.639684] Starting dynamic subtest: vcs1
[779.611994] Dynamic subtest vcs1: SUCCESS (1.982s)
[779.623669] Starting dynamic subtest: vecs0
[781.596225] Dynamic subtest vecs0: SUCCESS (1.982s)
[781.607786] Starting dynamic subtest: ccs0
[782.836640] Dynamic subtest ccs0: SUCCESS (1.238s)
[782.839304] Subtest busy-hang: SUCCESS (10.343s)
[782.934508] [090/131] (379s left) kms_rotation_crc (sprite-rotation-90)
[783.038760] Starting subtest: sprite-rotation-90
[783.043499] Subtest sprite-rotation-90: SKIP (0.001s)
[783.110009] [091/131] (378s left) gem_exec_gttfill (all-engines)
[783.185657] Starting subtest: all-engines
[807.876744] Subtest all-engines: SUCCESS (24.689s)
[808.059822] [092/131] (354s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[808.205418] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[808.218760] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[808.287978] [093/131] (353s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[808.342966] Starting subtest: saturated-hostile-nopreempt
[808.345384] Starting dynamic subtest: rcs0
[808.437641] Dynamic subtest rcs0: SKIP (0.091s)
[808.450518] Starting dynamic subtest: bcs0
[808.463742] Dynamic subtest bcs0: SKIP (0.025s)
[808.473792] Starting dynamic subtest: vcs0
[808.485951] Dynamic subtest vcs0: SKIP (0.021s)
[808.495839] Starting dynamic subtest: vcs1
[808.510621] Dynamic subtest vcs1: SKIP (0.023s)
[808.520591] Starting dynamic subtest: vecs0
[808.527888] Dynamic subtest vecs0: SKIP (0.015s)
[808.537744] Starting dynamic subtest: ccs0
[808.547549] Dynamic subtest ccs0: SKIP (0.019s)
[808.551772] Subtest saturated-hostile-nopreempt: SKIP (0.203s)
[808.618697] [094/131] (353s left) gem_mmap_wc (write-read-distinct)
[808.676769] Subtest write-read-distinct: SKIP (0.000s)
[808.735268] [095/131] (353s left) kms_flip (2x-flip-vs-suspend-interruptible)
[808.827600] Starting subtest: 2x-flip-vs-suspend-interruptible
[808.840158] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[808.910351] [096/131] (353s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[809.018804] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[809.022168] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[809.099407] [097/131] (353s left) gem_exec_create (legacy)
[809.158423] Starting subtest: legacy
[809.160451] Starting dynamic subtest: smem
[813.074831] Dynamic subtest smem: SUCCESS (3.913s)
[813.077831] Subtest legacy: SUCCESS (3.915s)
[813.261509] [098/131] (349s left) gem_mmap_wc (bad-object)
[813.342224] Subtest bad-object: SKIP (0.000s)
[813.403027] [099/131] (348s left) i915_query (query-topology-coherent-slice-mask)
[813.461460] Starting subtest: query-topology-coherent-slice-mask
[813.466083] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[813.569315] [100/131] (348s left) kms_psr (fbc-pr-primary-render)
[813.674228] Starting subtest: fbc-pr-primary-render
[813.678506] Subtest fbc-pr-primary-render: SKIP (0.000s)
[813.746624] [101/131] (348s left) syncobj_timeline (wait-for-submit-delayed-submit)
[813.821840] Starting subtest: wait-for-submit-delayed-submit
[813.925984] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[814.002482] [102/131] (348s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[814.100952] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[814.111658] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[814.213347] [103/131] (348s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[814.312321] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[814.316571] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[814.415631] [104/131] (348s left) gem_exec_flush (basic-wb-set-default)
[814.485383] Starting subtest: basic-wb-set-default
[819.956091] Subtest basic-wb-set-default: SUCCESS (5.471s)
[820.142443] [105/131] (342s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[820.246171] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[820.250531] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[820.338123] [106/131] (342s left) sysfs_heartbeat_interval (nopreempt)
[820.402115] Starting subtest: nopreempt
[820.404349] Starting dynamic subtest: vecs0
[830.179482] Dynamic subtest vecs0: SUCCESS (9.774s)
[830.192558] Starting dynamic subtest: ccs0
[834.230158] Dynamic subtest ccs0: SUCCESS (4.053s)
[834.241891] Starting dynamic subtest: vcs0
[844.140279] Dynamic subtest vcs0: SUCCESS (9.907s)
[844.150447] Starting dynamic subtest: bcs0
[848.087171] Dynamic subtest bcs0: SUCCESS (3.949s)
[848.098969] Starting dynamic subtest: rcs0
[852.107110] Dynamic subtest rcs0: SUCCESS (4.020s)
[852.120265] Starting dynamic subtest: vcs1
[862.031151] Dynamic subtest vcs1: SUCCESS (9.925s)
[862.033599] Subtest nopreempt: SUCCESS (41.636s)
[862.103934] [107/131] (300s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[862.210539] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[866.725402] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.519s)
[866.847401] [108/131] (295s left) gem_eio (wait-10ms)
[867.062524] Starting subtest: wait-10ms
[867.376549] Subtest wait-10ms: SUCCESS (0.315s)
[867.529840] [109/131] (295s left) gem_softpin (evict-active-interruptible)
[867.608637] Starting subtest: evict-active-interruptible
[867.616177] Subtest evict-active-interruptible: SUCCESS (0.007s)
[867.743525] [110/131] (294s left) kms_cursor_crc (cursor-offscreen-512x512)
[868.009220] Starting subtest: cursor-offscreen-512x512
[868.013164] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[868.189549] [111/131] (294s left) kms_addfb_basic (bad-pitch-63)
[868.245729] Starting subtest: bad-pitch-63
[868.247954] Subtest bad-pitch-63: SUCCESS (0.000s)
[868.392580] [112/131] (294s left) debugfs_test (basic-hwmon)
[868.448620] Starting subtest: basic-hwmon
[868.452136] Subtest basic-hwmon: SKIP (0.000s)
[868.559558] [113/131] (294s left) gem_lmem_evict (dontneed-evict-race)
[868.603090] Subtest dontneed-evict-race: SKIP (0.000s)
[868.646310] [114/131] (294s left) gen9_exec_parse (bb-large)
[868.699860] Subtest bb-large: SKIP (0.000s)
[868.762253] [115/131] (294s left) gem_ctx_persistence (engines-hang)
[868.812215] Starting subtest: engines-hang
[868.814045] Starting dynamic subtest: rcs0
[868.893958] Dynamic subtest rcs0: SUCCESS (0.081s)
[868.907061] Starting dynamic subtest: bcs0
[868.993346] Dynamic subtest bcs0: SUCCESS (0.097s)
[869.005620] Starting dynamic subtest: vcs0
[869.085446] Dynamic subtest vcs0: SUCCESS (0.090s)
[869.095532] Starting dynamic subtest: vcs1
[869.190224] Dynamic subtest vcs1: SUCCESS (0.103s)
[869.200730] Starting dynamic subtest: vecs0
[869.287107] Dynamic subtest vecs0: SUCCESS (0.095s)
[869.300025] Starting dynamic subtest: ccs0
[869.357160] Dynamic subtest ccs0: SUCCESS (0.068s)
[869.359271] Subtest engines-hang: SUCCESS (0.546s)
[869.499173] [116/131] (293s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[869.601947] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[869.605391] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[869.698967] [117/131] (293s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[869.756292] Starting subtest: framebuffer-vs-set-tiling
[869.760603] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[869.876589] [118/131] (293s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[869.972891] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[875.140661] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.170s)
[875.265866] [119/131] (287s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[875.375705] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[878.492292] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (3.122s)
[878.659369] [120/131] (284s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[878.732607] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[878.857699] [121/131] (284s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[878.946582] Starting subtest: disable-crc-after-crtc
[878.948557] Starting dynamic subtest: pipe-A-eDP-1
[880.551780] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.603s)
[880.562831] Starting dynamic subtest: pipe-B-eDP-1
[882.804047] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.251s)
[882.815025] Starting dynamic subtest: pipe-C-eDP-1
[885.059501] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.254s)
[885.070599] Starting dynamic subtest: pipe-D-eDP-1
[887.327991] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.268s)
[887.330545] Subtest disable-crc-after-crtc: SUCCESS (8.381s)
[888.143836] [122/131] (275s left) kms_psr (pr-cursor-plane-move)
[888.241859] Starting subtest: pr-cursor-plane-move
[888.245856] Subtest pr-cursor-plane-move: SKIP (0.000s)
[888.307904] [123/131] (274s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[893.311951] Starting subtest: pr-cursor-plane-update-sf
[893.316716] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[894.144029] [124/131] (269s left) drm_fdinfo (isolation)
[894.197006] Starting subtest: isolation
[894.199345] Starting dynamic subtest: rcs0
[894.220251] Dynamic subtest rcs0: SKIP (0.022s)
[894.237134] Starting dynamic subtest: bcs0
[894.244994] Dynamic subtest bcs0: SKIP (0.022s)
[894.256818] Starting dynamic subtest: vcs0
[894.261222] Dynamic subtest vcs0: SKIP (0.001s)
[894.270093] Starting dynamic subtest: vcs1
[894.274473] Dynamic subtest vcs1: SKIP (0.000s)
[894.283726] Starting dynamic subtest: vecs0
[894.288032] Dynamic subtest vecs0: SKIP (0.000s)
[894.297235] Starting dynamic subtest: ccs0
[894.301629] Dynamic subtest ccs0: SKIP (0.000s)
[894.305979] Subtest isolation: SKIP (0.052s)
[894.338037] [125/131] (268s left) drm_fdinfo (virtual-busy-idle-all)
[894.378831] Starting subtest: virtual-busy-idle-all
[894.383235] Subtest virtual-busy-idle-all: SKIP (0.000s)
[894.444812] [126/131] (268s left) kms_writeback (writeback-invalid-parameters)
[894.551179] Subtest writeback-invalid-parameters: SKIP (0.000s)
[894.592293] [127/131] (268s left) gem_eio (create)
[894.818677] Starting subtest: create
[895.163160] Subtest create: SUCCESS (0.345s)
[895.311144] [128/131] (268s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[895.413615] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[895.415543] Starting dynamic subtest: pipe-A-eDP-1
[928.176303] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.854s)
[928.186390] Starting dynamic subtest: pipe-B-eDP-1
[961.102634] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.507s)
[961.113067] Starting dynamic subtest: pipe-C-eDP-1
[994.079877] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.394s)
[994.091910] Starting dynamic subtest: pipe-D-eDP-1
[1027.089979] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.378s)
[1027.092613] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.137s)
[1028.308976] [129/131] (253s left) gem_wait (wait)
[1028.373023] Starting subtest: wait
[1028.375874] Starting dynamic subtest: all-engines
[1029.619180] Dynamic subtest all-engines: SUCCESS (1.240s)
[1029.632222] Starting dynamic subtest: rcs0
[1030.669648] Dynamic subtest rcs0: SUCCESS (1.047s)
[1030.681143] Starting dynamic subtest: bcs0
[1031.721781] Dynamic subtest bcs0: SUCCESS (1.047s)
[1031.734172] Starting dynamic subtest: vcs0
[1032.770597] Dynamic subtest vcs0: SUCCESS (1.045s)
[1032.780940] Starting dynamic subtest: vcs1
[1033.820464] Dynamic subtest vcs1: SUCCESS (1.045s)
[1033.833107] Starting dynamic subtest: vecs0
[1034.870308] Dynamic subtest vecs0: SUCCESS (1.046s)
[1034.883172] Starting dynamic subtest: ccs0
[1035.922601] Dynamic subtest ccs0: SUCCESS (1.049s)
[1035.925325] Subtest wait: SUCCESS (7.531s)
[1036.123431] [130/131] (245s left) gem_partial_pwrite_pread (writes-after-reads)
[1036.190959] Subtest writes-after-reads: SKIP (0.000s)
[1036.274851] [131/131] (245s left) gem_exec_whisper (basic-fds-all)
[1036.343880] Starting subtest: basic-fds-all
[1045.526650] Subtest basic-fds-all: SUCCESS (9.167s)
[1045.702968] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: gem_busy
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: kms_scaling_modes
results: parsing output: 10/ for test: kms_dither
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_color
results: parsing output: 14/ for test: kms_async_flips
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: i915_selftest
results: parsing output: 19/ for test: kms_hdr
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: api_intel_bb
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_pxp
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: prime_busy
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: kms_atomic
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: gem_exec_parallel
results: parsing output: 39/ for test: kms_prime
results: parsing output: 40/ for test: i915_pm_rps
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: gem_exec_suspend
results: parsing output: 43/ for test: gem_readwrite
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: gem_exec_parallel
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: i915_pm_rc6_residency
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: gem_ppgtt
results: parsing output: 56/ for test: gem_mmap_wc
results: parsing output: 57/ for test: prime_busy
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: sw_sync
results: parsing output: 63/ for test: gem_create
results: parsing output: 64/ for test: gem_exec_params
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: gem_mmap_wc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_rmfb
results: parsing output: 72/ for test: gem_flink_basic
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_psr2_su
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_dirtyfb
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: gem_pxp
results: parsing output: 85/ for test: kms_chamelium_edid
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_rotation_crc
results: parsing output: 90/ for test: gem_exec_gttfill
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_ctx_persistence
results: parsing output: 93/ for test: gem_mmap_wc
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_create
results: parsing output: 97/ for test: gem_mmap_wc
results: parsing output: 98/ for test: i915_query
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_flush
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_eio
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: debugfs_test
results: parsing output: 112/ for test: gem_lmem_evict
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_pipe_crc_basic
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: drm_fdinfo
results: parsing output: 124/ for test: drm_fdinfo
results: parsing output: 125/ for test: kms_writeback
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_wait
results: parsing output: 129/ for test: gem_partial_pwrite_pread
results: parsing output: 130/ for test: gem_exec_whisper
Done.