[54.804134] Initializing watchdogs
[54.804246]   /dev/watchdog0
[54.820867] [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]
[54.825499] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.827804] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.831042] [001/131] (960s left) drm_mm (drm_mm)
[54.876947] Starting subtest: drm_mm
[54.887060] Starting dynamic subtest: drm_test_mm_init
[54.999212] Dynamic subtest drm_test_mm_init: SUCCESS (0.112s)
[55.008275] Starting dynamic subtest: drm_test_mm_debug
[55.115322] Dynamic subtest drm_test_mm_debug: SUCCESS (0.115s)
[55.122284] Starting dynamic subtest: drm_test_mm_align32
[55.241593] Dynamic subtest drm_test_mm_align32: SUCCESS (0.128s)
[55.252581] Starting dynamic subtest: drm_test_mm_align64
[55.356607] Dynamic subtest drm_test_mm_align64: SUCCESS (0.115s)
[55.365227] Starting dynamic subtest: drm_test_mm_lowest
[55.434261] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.078s)
[55.441592] Starting dynamic subtest: drm_test_mm_highest
[55.537345] Dynamic subtest drm_test_mm_highest: SUCCESS (0.103s)
[55.539593] Subtest drm_mm: SUCCESS (0.663s)
[55.769096] [002/131] (959s left) syncobj_timeline (wait-for-submit-complex)
[55.819852] Starting subtest: wait-for-submit-complex
[55.880885] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[55.970572] [003/131] (959s left) gem_sync (basic-store-all)
[56.046981] Starting subtest: basic-store-all
[58.393297] Subtest basic-store-all: SUCCESS (2.369s)
[58.588639] [004/131] (956s left) kms_sharpness_filter (filter-suspend)
[58.692914] Starting subtest: filter-suspend
[58.705949] Subtest filter-suspend: SKIP (0.001s)
[58.772106] [005/131] (956s left) api_intel_bb (blit-reloc-keep-cache)
[58.829985] Starting subtest: blit-reloc-keep-cache
[58.834668] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[58.980838] [006/131] (956s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[59.081072] Starting subtest: psr-indfb-scaledprimary
[64.796090] Subtest psr-indfb-scaledprimary: SUCCESS (5.734s)
[64.917397] [007/131] (950s left) kms_pm_rpm (drm-resources-equal)
[67.071409] Starting subtest: drm-resources-equal
[72.058891] Subtest drm-resources-equal: SUCCESS (4.994s)
[72.189257] [008/131] (943s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[72.382045] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[72.384471] Starting dynamic subtest: pipe-A-default-mode
[72.679243] Dynamic subtest pipe-A-default-mode: SKIP (0.295s)
[72.683932] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.297s)
[73.526804] [009/131] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[73.632034] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[80.902173] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.276s)
[81.039555] [010/131] (934s left) prime_vgem (basic-fence-read)
[81.142576] Starting subtest: basic-fence-read
[81.150436] Subtest basic-fence-read: SKIP (0.006s)
[81.282077] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[81.285062] [011/131] (934s left) kms_chamelium_color (ctm-max)
[81.373254] Subtest ctm-max: SKIP (0.000s)
[81.417532] [012/131] (934s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[81.501354] Starting subtest: disable-crc-after-crtc
[81.503776] Starting dynamic subtest: pipe-A-eDP-1
[83.170827] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.670s)
[83.180649] Starting dynamic subtest: pipe-B-eDP-1
[85.463253] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.293s)
[85.473414] Starting dynamic subtest: pipe-C-eDP-1
[87.718327] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.254s)
[87.727105] Starting dynamic subtest: pipe-D-eDP-1
[89.985367] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.266s)
[89.987640] Subtest disable-crc-after-crtc: SUCCESS (8.486s)
[90.823098] [013/131] (924s left) kms_cursor_crc (cursor-sliding-512x512)
[91.094676] Starting subtest: cursor-sliding-512x512
[91.099055] Subtest cursor-sliding-512x512: SKIP (0.001s)
[91.289916] [014/131] (924s left) gem_exec_store (pages)
[91.344340] Starting subtest: pages
[91.346227] Starting dynamic subtest: rcs0
[91.461912] Dynamic subtest rcs0: SUCCESS (0.119s)
[91.470261] Starting dynamic subtest: bcs0
[91.535460] Dynamic subtest bcs0: SUCCESS (0.073s)
[91.545728] Starting dynamic subtest: vcs0
[91.618215] Dynamic subtest vcs0: SUCCESS (0.081s)
[91.628666] Starting dynamic subtest: vcs1
[91.688993] Dynamic subtest vcs1: SUCCESS (0.071s)
[91.699307] Starting dynamic subtest: vecs0
[91.757791] Dynamic subtest vecs0: SUCCESS (0.069s)
[91.765561] Starting dynamic subtest: ccs0
[91.829995] Dynamic subtest ccs0: SUCCESS (0.072s)
[91.832540] Subtest pages: SUCCESS (0.488s)
[92.040186] [015/131] (923s left) gem_ppgtt (shrink-vs-evict-any)
[92.100885] Starting subtest: shrink-vs-evict-any
[97.913727] Subtest shrink-vs-evict-any: SUCCESS (5.811s)
[98.028628] [016/131] (917s left) gem_ctx_persistence (legacy-engines-cleanup)
[98.091179] Starting subtest: legacy-engines-cleanup
[98.093511] Starting dynamic subtest: render
[98.190959] Dynamic subtest render: SUCCESS (0.099s)
[98.202506] Starting dynamic subtest: bsd1
[98.249916] Dynamic subtest bsd1: SUCCESS (0.057s)
[98.259138] Starting dynamic subtest: bsd2
[98.307621] Dynamic subtest bsd2: SUCCESS (0.056s)
[98.317873] Starting dynamic subtest: blt
[98.345385] Dynamic subtest blt: SUCCESS (0.036s)
[98.354076] Starting dynamic subtest: vebox
[98.471693] Dynamic subtest vebox: SUCCESS (0.124s)
[98.474522] Subtest legacy-engines-cleanup: SUCCESS (0.381s)
[98.568126] [017/131] (917s left) kms_flip (flip-vs-blocking-wf-vblank)
[98.669250] Starting subtest: flip-vs-blocking-wf-vblank
[98.671655] Starting dynamic subtest: A-eDP1
[107.549587] Dynamic subtest A-eDP1: SUCCESS (8.882s)
[107.559892] Starting dynamic subtest: B-eDP1
[116.479868] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[116.489921] Starting dynamic subtest: C-eDP1
[125.405697] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[125.414232] Starting dynamic subtest: D-eDP1
[134.339839] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[134.342211] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.675s)
[135.568525] [018/131] (880s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[135.630452] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[135.696973] [019/131] (880s left) syncobj_wait (invalid-signal-bad-pad)
[135.744926] Starting subtest: invalid-signal-bad-pad
[135.746859] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[135.845749] [020/131] (880s left) syncobj_wait (wait-all-complex)
[135.892057] Starting subtest: wait-all-complex
[136.105486] Subtest wait-all-complex: SUCCESS (0.213s)
[136.202635] [021/131] (879s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[136.298153] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[136.300490] Starting dynamic subtest: A-eDP1
[139.893116] Dynamic subtest A-eDP1: SUCCESS (3.591s)
[139.901073] Starting dynamic subtest: B-eDP1
[143.096276] Dynamic subtest B-eDP1: SUCCESS (3.204s)
[143.105509] Starting dynamic subtest: C-eDP1
[146.207742] Dynamic subtest C-eDP1: SUCCESS (3.109s)
[146.216151] Starting dynamic subtest: D-eDP1
[149.327216] Dynamic subtest D-eDP1: SUCCESS (3.117s)
[149.329498] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.029s)
[150.156090] [022/131] (866s left) kms_lease (cursor-implicit-plane)
[150.244884] Starting subtest: cursor-implicit-plane
[150.247169] Starting dynamic subtest: pipe-A-eDP-1
[150.707529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[150.717271] Starting dynamic subtest: pipe-B-eDP-1
[151.854141] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s)
[151.863748] Starting dynamic subtest: pipe-C-eDP-1
[152.982617] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[152.994697] Starting dynamic subtest: pipe-D-eDP-1
[154.108892] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[154.111385] Subtest cursor-implicit-plane: SUCCESS (3.865s)
[154.980251] [023/131] (861s left) intel_hwmon (hwmon-write)
[155.041913] Subtest hwmon-write: SKIP (0.000s)
[155.101314] [024/131] (861s left) kms_atomic_transition (plane-all-transition)
[155.196814] Starting subtest: plane-all-transition
[155.199124] Starting dynamic subtest: pipe-A-eDP-1
[157.695489] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[158.004598] Starting dynamic subtest: pipe-B-eDP-1
[161.206727] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.210s)
[161.502843] Subtest plane-all-transition: SUCCESS (6.307s)
[162.358755] [025/131] (853s left) kms_psr (fbc-psr-cursor-blt)
[162.467315] Starting subtest: fbc-psr-cursor-blt
[162.469537] Starting dynamic subtest: eDP-1
[162.473598] Dynamic subtest eDP-1: SKIP (0.000s)
[162.478156] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[162.549730] [026/131] (853s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[162.614412] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[162.680747] [027/131] (853s left) kms_psr (fbc-pr-primary-mmap-gtt)
[162.784309] Starting subtest: fbc-pr-primary-mmap-gtt
[162.788875] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[162.869868] [028/131] (853s left) gem_exec_balancer (parallel-balancer)
[163.132377] Starting subtest: parallel-balancer
[164.041083] Subtest parallel-balancer: SUCCESS (0.909s)
[164.186953] [029/131] (852s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[164.287687] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[168.485934] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.202s)
[169.658354] [030/131] (846s left) syncobj_wait (invalid-signal-illegal-handle)
[169.711869] Starting subtest: invalid-signal-illegal-handle
[169.714150] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[169.827623] [031/131] (846s left) kms_cursor_crc (cursor-offscreen-256x85)
[170.081584] Starting subtest: cursor-offscreen-256x85
[170.126123] Subtest cursor-offscreen-256x85: SKIP (0.040s)
[170.331295] [032/131] (846s left) gem_pread (snoop)
[170.394165] Subtest snoop: SKIP (0.000s)
[170.460558] [033/131] (846s left) kms_force_connector_basic (force-load-detect)
[170.534681] Starting subtest: force-load-detect
[170.539228] Subtest force-load-detect: SKIP (0.000s)
[170.672563] [034/131] (846s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[170.785514] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[188.015158] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.227s)
[188.834065] [035/131] (827s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[188.925356] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[188.927585] Starting dynamic subtest: pipe-A-default-mode
[189.216344] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[189.220769] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.290s)
[190.056444] [036/131] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[190.149490] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[190.153655] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[190.265663] [037/131] (826s left) vgem_basic (bad-handle)
[190.306375] Starting subtest: bad-handle
[190.308677] Subtest bad-handle: SUCCESS (0.000s)
[190.388527] [038/131] (826s left) fbdev (write)
[190.426627] Starting subtest: write
[190.788793] Subtest write: SUCCESS (0.360s)
[190.864036] [039/131] (826s left) i915_drm_fdinfo (busy)
[190.901910] Starting subtest: busy
[190.904424] Starting dynamic subtest: rcs0
[190.927116] Dynamic subtest rcs0: SKIP (0.022s)
[190.936913] Starting dynamic subtest: bcs0
[190.950930] Dynamic subtest bcs0: SKIP (0.023s)
[190.961079] Starting dynamic subtest: vcs0
[190.965037] Dynamic subtest vcs0: SKIP (0.000s)
[190.973170] Starting dynamic subtest: vcs1
[190.977394] Dynamic subtest vcs1: SKIP (0.000s)
[190.985259] Starting dynamic subtest: vecs0
[190.989281] Dynamic subtest vecs0: SKIP (0.000s)
[190.996832] Starting dynamic subtest: ccs0
[191.001039] Dynamic subtest ccs0: SKIP (0.000s)
[191.005142] Subtest busy: SKIP (0.051s)
[191.040353] [040/131] (825s left) gem_eio (hibernate)
[191.283177] Starting subtest: hibernate
[206.037551] Subtest hibernate: SUCCESS (14.751s)
[215.217764] [041/131] (810s left) gem_readwrite (read-write)
[215.307084] Subtest read-write: SKIP (0.000s)
[215.376925] [042/131] (810s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[215.479060] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[215.483243] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[215.607781] [043/131] (810s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[215.708224] Starting subtest: modeset-transition-nonblocking-fencing
[215.710408] Starting dynamic subtest: 1x-outputs
[226.559473] Dynamic subtest 1x-outputs: SUCCESS (10.852s)
[226.562040] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.853s)
[227.432537] [044/131] (798s left) kms_flip (flip-vs-panning-interruptible)
[227.533515] Starting subtest: flip-vs-panning-interruptible
[227.535876] Starting dynamic subtest: A-eDP1
[236.226156] Dynamic subtest A-eDP1: SUCCESS (8.691s)
[236.235520] Starting dynamic subtest: B-eDP1
[244.965929] Dynamic subtest B-eDP1: SUCCESS (8.738s)
[244.978090] Starting dynamic subtest: C-eDP1
[253.680965] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[253.691519] Starting dynamic subtest: D-eDP1
[262.417137] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[262.421406] Subtest flip-vs-panning-interruptible: SUCCESS (34.886s)
[263.590672] [045/131] (762s left) perf_pmu (interrupts-sync)
[263.631072] Starting subtest: interrupts-sync
[264.715097] Subtest interrupts-sync: SUCCESS (1.083s)
[264.848538] [046/131] (761s left) gem_exec_schedule (smoketest)
[265.013990] Starting subtest: smoketest
[265.016679] Starting dynamic subtest: rcs0
[270.559086] Dynamic subtest rcs0: SUCCESS (5.493s)
[270.571424] Starting dynamic subtest: bcs0
[276.085856] Dynamic subtest bcs0: SUCCESS (5.526s)
[276.100469] Starting dynamic subtest: vcs0
[281.585634] Dynamic subtest vcs0: SUCCESS (5.501s)
[281.608999] Starting dynamic subtest: vcs1
[287.075528] Dynamic subtest vcs1: SUCCESS (5.491s)
[287.092902] Starting dynamic subtest: vecs0
[292.582646] Dynamic subtest vecs0: SUCCESS (5.503s)
[292.594104] Starting dynamic subtest: ccs0
[298.081160] Dynamic subtest ccs0: SUCCESS (5.500s)
[298.083327] Subtest smoketest: SUCCESS (33.020s)
[298.303100] [047/131] (727s left) kms_color (invalid-degamma-lut-sizes)
[298.401316] Starting subtest: invalid-degamma-lut-sizes
[298.403584] Starting dynamic subtest: pipe-A
[298.689756] Dynamic subtest pipe-A: SUCCESS (0.286s)
[298.700973] Starting dynamic subtest: pipe-B
[298.703317] Dynamic subtest pipe-B: SUCCESS (0.001s)
[298.713639] Starting dynamic subtest: pipe-C
[298.715993] Dynamic subtest pipe-C: SUCCESS (0.001s)
[298.726428] Starting dynamic subtest: pipe-D
[298.728294] Dynamic subtest pipe-D: SUCCESS (0.001s)
[298.730177] Subtest invalid-degamma-lut-sizes: SUCCESS (0.291s)
[299.528911] [048/131] (726s left) kms_psr (fbc-psr-primary-blt)
[299.625160] Starting subtest: fbc-psr-primary-blt
[299.626932] Starting dynamic subtest: eDP-1
[299.630946] Dynamic subtest eDP-1: SKIP (0.000s)
[299.634919] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[299.709991] [049/131] (726s left) template (b)
[299.761073] Starting subtest: B
[299.763283] Subtest B: SUCCESS (0.000s)
[299.889336] [050/131] (726s left) i915_pm_rpm (gem-execbuf)
[302.121937] Starting subtest: gem-execbuf
[302.124776] Starting dynamic subtest: smem0
[303.857144] Dynamic subtest smem0: SUCCESS (1.738s)
[303.859219] Subtest gem-execbuf: SUCCESS (1.740s)
[303.967724] [051/131] (722s left) syncobj_timeline (single-wait-available-signaled)
[304.029489] Starting subtest: single-wait-available-signaled
[304.031827] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[304.156311] [052/131] (722s left) gem_exec_params (invalid-ring2)
[304.213405] Starting subtest: invalid-ring2
[304.215696] Subtest invalid-ring2: SUCCESS (0.000s)
[304.338255] [053/131] (722s left) kms_draw_crc (draw-method-pwrite)
[304.420793] Starting subtest: draw-method-pwrite
[304.423052] Starting dynamic subtest: xrgb8888-untiled
[304.964734] Dynamic subtest xrgb8888-untiled: SUCCESS (0.544s)
[304.983862] Starting dynamic subtest: rgb565-untiled
[305.409129] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[305.422253] Starting dynamic subtest: xrgb2101010-untiled
[305.942522] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.533s)
[305.955289] Starting dynamic subtest: xbgr16161616f-untiled
[306.709401] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.766s)
[306.719738] Starting dynamic subtest: xrgb8888-xtiled
[308.487594] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.777s)
[308.499825] Starting dynamic subtest: rgb565-xtiled
[309.587271] Dynamic subtest rgb565-xtiled: SUCCESS (1.099s)
[309.598999] Starting dynamic subtest: xrgb2101010-xtiled
[311.398394] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.810s)
[311.409869] Starting dynamic subtest: xbgr16161616f-xtiled
[314.664813] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.266s)
[314.675414] Starting dynamic subtest: xrgb8888-4tiled
[315.764893] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s)
[315.775610] Starting dynamic subtest: rgb565-4tiled
[316.342759] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s)
[316.356637] Starting dynamic subtest: xrgb2101010-4tiled
[317.442782] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s)
[317.454375] Starting dynamic subtest: xbgr16161616f-4tiled
[320.420450] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.977s)
[320.422635] Subtest draw-method-pwrite: SUCCESS (16.001s)
[320.548924] [054/131] (705s left) gen9_exec_parse (basic-rejected-ctx-param)
[320.618596] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[320.694946] [055/131] (705s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[320.790171] Starting subtest: fb-8bpc-vs-panel-6bpc
[320.792497] Starting dynamic subtest: pipe-A-eDP-1
[322.204608] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.415s)
[322.206987] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.417s)
[323.093433] [056/131] (703s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[323.218373] Starting subtest: 2x-flip-vs-cursor-atomic
[323.223053] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[323.374824] [057/131] (703s left) gem_exec_reloc (basic-gtt-read-noreloc)
[323.440622] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[323.537401] [058/131] (703s left) prime_busy (before)
[323.597738] Starting subtest: before
[323.600072] Starting dynamic subtest: rcs0
[323.640613] Dynamic subtest rcs0: SUCCESS (0.043s)
[323.652896] Starting dynamic subtest: bcs0
[323.697852] Dynamic subtest bcs0: SUCCESS (0.056s)
[323.710135] Starting dynamic subtest: vcs0
[323.738638] Dynamic subtest vcs0: SUCCESS (0.040s)
[323.748903] Starting dynamic subtest: vcs1
[323.777783] Dynamic subtest vcs1: SUCCESS (0.039s)
[323.788026] Starting dynamic subtest: vecs0
[323.817948] Dynamic subtest vecs0: SUCCESS (0.040s)
[323.828191] Starting dynamic subtest: ccs0
[323.858274] Dynamic subtest ccs0: SUCCESS (0.040s)
[323.965786] Subtest before: SUCCESS (0.369s)
[324.065936] [059/131] (702s left) api_intel_bb (lot-of-buffers)
[324.117723] Starting subtest: lot-of-buffers
[325.193949] Subtest lot-of-buffers: SUCCESS (1.078s)
[325.619780] [060/131] (701s left) kms_psr (psr2-sprite-plane-move)
[325.714029] Starting subtest: psr2-sprite-plane-move
[325.716331] Starting dynamic subtest: eDP-1
[327.519709] Dynamic subtest eDP-1: SUCCESS (1.805s)
[327.521999] Subtest psr2-sprite-plane-move: SUCCESS (1.806s)
[328.371797] [061/131] (698s left) kms_psr (pr-primary-mmap-gtt)
[328.463208] Starting subtest: pr-primary-mmap-gtt
[328.467722] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[328.560465] [062/131] (698s left) gem_watchdog (default-physical)
[328.627811] Starting subtest: default-physical
[330.383698] Subtest default-physical: SUCCESS (1.767s)
[330.508649] [063/131] (696s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[330.902956] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[331.670327] [064/131] (695s left) gem_exec_reloc (basic-cpu-read)
[331.730398] Subtest basic-cpu-read: SKIP (0.000s)
[331.826295] [065/131] (695s left) gem_cs_tlb (engines)
[331.877807] Starting subtest: engines
[331.880196] Starting dynamic subtest: rcs0
[334.034880] Dynamic subtest rcs0: SUCCESS (2.153s)
[334.045199] Starting dynamic subtest: bcs0
[336.187391] Dynamic subtest bcs0: SUCCESS (2.151s)
[336.198630] Starting dynamic subtest: vcs0
[338.341035] Dynamic subtest vcs0: SUCCESS (2.152s)
[338.354148] Starting dynamic subtest: vcs1
[340.494806] Dynamic subtest vcs1: SUCCESS (2.152s)
[340.511728] Starting dynamic subtest: vecs0
[342.648533] Dynamic subtest vecs0: SUCCESS (2.154s)
[342.658618] Starting dynamic subtest: ccs0
[344.802674] Dynamic subtest ccs0: SUCCESS (2.153s)
[344.804716] Subtest engines: SUCCESS (12.921s)
[344.964089] [066/131] (682s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[345.071541] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[345.075978] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[345.206746] [067/131] (681s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[345.307224] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[345.309504] Starting dynamic subtest: pipe-A-eDP-1
[345.318615] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[345.330101] Starting dynamic subtest: pipe-B-eDP-1
[345.339386] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[345.355104] Starting dynamic subtest: pipe-C-eDP-1
[345.363661] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[345.374451] Starting dynamic subtest: pipe-D-eDP-1
[345.382964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[345.387277] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[347.575487] [068/131] (679s left) gem_ctx_persistence (engines-persistence)
[347.635752] Starting subtest: engines-persistence
[347.638163] Starting dynamic subtest: rcs0
[348.470407] Dynamic subtest rcs0: SUCCESS (0.834s)
[348.484300] Starting dynamic subtest: bcs0
[349.293402] Dynamic subtest bcs0: SUCCESS (0.821s)
[349.306919] Starting dynamic subtest: vcs0
[350.114505] Dynamic subtest vcs0: SUCCESS (0.820s)
[350.127976] Starting dynamic subtest: vcs1
[350.904986] Dynamic subtest vcs1: SUCCESS (0.788s)
[350.918777] Starting dynamic subtest: vecs0
[351.734275] Dynamic subtest vecs0: SUCCESS (0.827s)
[351.747582] Starting dynamic subtest: ccs0
[352.522436] Dynamic subtest ccs0: SUCCESS (0.786s)
[352.525250] Subtest engines-persistence: SUCCESS (4.887s)
[352.683075] [069/131] (674s left) kms_pm_rpm (pm-tiling)
[354.210314] Starting subtest: pm-tiling
[354.215506] Subtest pm-tiling: SKIP (0.000s)
[355.003136] [070/131] (672s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[355.051855] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[355.156090] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[355.256798] [071/131] (672s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[355.315180] Starting subtest: multi-wait-all-for-submit-available-submitted
[355.317504] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[355.437147] [072/131] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[355.533789] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[364.846648] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.314s)
[365.013685] [073/131] (662s left) kms_big_fb (4-tiled-addfb)
[365.109071] Starting subtest: 4-tiled-addfb
[365.111385] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[365.233879] [074/131] (662s left) gem_exec_gttfill (engines)
[365.288887] Starting subtest: engines
[365.291139] Starting dynamic subtest: rcs0
[388.186486] Dynamic subtest rcs0: SUCCESS (22.896s)
[388.204334] Starting dynamic subtest: bcs0
[411.512367] Dynamic subtest bcs0: SUCCESS (23.323s)
[411.522996] Starting dynamic subtest: vcs0
[434.857486] Dynamic subtest vcs0: SUCCESS (23.342s)
[434.870702] Starting dynamic subtest: vcs1
[458.108308] Dynamic subtest vcs1: SUCCESS (23.251s)
[458.119859] Starting dynamic subtest: vecs0
[481.390890] Dynamic subtest vecs0: SUCCESS (23.279s)
[481.401687] Starting dynamic subtest: ccs0
[504.744461] Dynamic subtest ccs0: SUCCESS (23.353s)
[504.747263] Subtest engines: SUCCESS (139.453s)
[504.934020] [075/131] (522s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[505.090750] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[509.498053] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.412s)
[510.651548] [076/131] (516s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[510.749626] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[510.753727] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[510.867287] [077/131] (516s left) kms_vrr (negative-basic)
[510.967108] Starting subtest: negative-basic
[510.974055] Starting dynamic subtest: pipe-A-eDP-1
[516.400688] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.426s)
[516.700456] Subtest negative-basic: SUCCESS (5.736s)
[517.554071] [078/131] (510s left) gem_exec_capture (capture)
[517.612494] Starting subtest: capture
[517.614815] Starting dynamic subtest: rcs0-smem
[518.444339] Dynamic subtest rcs0-smem: SUCCESS (0.832s)
[518.456506] Starting dynamic subtest: bcs0-smem
[519.776939] Dynamic subtest bcs0-smem: SUCCESS (1.332s)
[519.786972] Starting dynamic subtest: vcs0-smem
[520.601950] Dynamic subtest vcs0-smem: SUCCESS (0.824s)
[520.620053] Starting dynamic subtest: vcs1-smem
[521.924695] Dynamic subtest vcs1-smem: SUCCESS (1.324s)
[521.937498] Starting dynamic subtest: vecs0-smem
[522.823757] Dynamic subtest vecs0-smem: FAIL (0.837s)
[522.835784] Starting dynamic subtest: ccs0-smem
[524.088075] Dynamic subtest ccs0-smem: SUCCESS (1.324s)
[524.089952] Subtest capture: FAIL (6.478s)
[524.256757] [079/131] (503s left) kms_rmfb (close-fd)
[524.359921] Starting subtest: close-fd
[524.362351] Starting dynamic subtest: pipe-A-eDP-1
[524.471136] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[524.482268] Starting dynamic subtest: pipe-B-eDP-1
[525.597216] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[525.610231] Starting dynamic subtest: pipe-C-eDP-1
[526.723504] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[526.735536] Starting dynamic subtest: pipe-D-eDP-1
[527.848096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[527.850320] Subtest close-fd: SUCCESS (3.488s)
[529.088447] [080/131] (498s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[529.190539] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[535.823929] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.635s)
[535.969144] [081/131] (491s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[536.060704] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[544.528832] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.470s)
[544.676555] [082/131] (483s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[544.786587] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[544.790704] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[544.924457] [083/131] (482s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[545.033450] Starting subtest: x-tiled-16bpp-rotate-0
[546.425253] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.392s)
[546.569499] [084/131] (481s left) gem_ringfill (basic-all)
[551.903142] Starting subtest: basic-all
[553.051901] Subtest basic-all: SUCCESS (1.150s)
[553.233833] [085/131] (474s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[553.346958] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[553.349288] Starting dynamic subtest: pipe-A
[554.394601] Dynamic subtest pipe-A: SUCCESS (1.050s)
[554.407487] Starting dynamic subtest: pipe-B
[556.531682] Dynamic subtest pipe-B: SUCCESS (2.136s)
[556.542064] Starting dynamic subtest: pipe-C
[557.734156] Dynamic subtest pipe-C: SUCCESS (1.201s)
[557.747831] Starting dynamic subtest: pipe-D
[558.877921] Dynamic subtest pipe-D: SUCCESS (1.143s)
[558.880307] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.533s)
[560.076091] [086/131] (467s left) gem_exec_schedule (pi-userfault)
[560.265089] Starting subtest: pi-userfault
[560.267245] Starting dynamic subtest: rcs0
[560.277718] Dynamic subtest rcs0: SUCCESS (0.014s)
[560.296800] Starting dynamic subtest: bcs0
[560.298786] Dynamic subtest bcs0: SUCCESS (0.007s)
[560.313108] Starting dynamic subtest: vcs0
[560.315352] Dynamic subtest vcs0: SUCCESS (0.006s)
[560.326361] Starting dynamic subtest: vcs1
[560.328263] Dynamic subtest vcs1: SUCCESS (0.006s)
[560.338780] Starting dynamic subtest: vecs0
[560.340662] Dynamic subtest vecs0: SUCCESS (0.008s)
[560.350759] Starting dynamic subtest: ccs0
[560.352671] Dynamic subtest ccs0: SUCCESS (0.008s)
[560.354607] Subtest pi-userfault: SUCCESS (0.055s)
[560.519969] [087/131] (467s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[560.612136] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[560.616524] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[560.713659] [088/131] (467s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[560.839042] Starting subtest: cursorB-vs-flipB-atomic
[560.843408] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[560.989424] [089/131] (467s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[561.080466] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[564.635952] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.559s)
[565.799497] [090/131] (462s left) kms_big_fb (linear-16bpp-rotate-270)
[565.909996] Starting subtest: linear-16bpp-rotate-270
[565.930168] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[566.081368] [091/131] (462s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[566.184980] Starting subtest: bad-aux-stride-y-tiled-ccs
[566.187281] Starting dynamic subtest: pipe-A-eDP-1
[566.209263] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[566.221603] Starting dynamic subtest: pipe-B-eDP-1
[566.242374] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[566.252422] Starting dynamic subtest: pipe-C-eDP-1
[566.273587] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[566.283559] Starting dynamic subtest: pipe-D-eDP-1
[566.304573] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[566.308664] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[568.454409] [092/131] (459s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[568.545437] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[568.547731] Starting dynamic subtest: pipe-A-eDP-1
[568.568304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[568.580267] Starting dynamic subtest: pipe-B-eDP-1
[568.599602] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[568.610587] Starting dynamic subtest: pipe-C-eDP-1
[568.630391] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[568.641521] Starting dynamic subtest: pipe-D-eDP-1
[568.660821] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[568.662805] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[570.817886] [093/131] (457s left) perf (gen12-unprivileged-single-ctx-counters)
[570.950697] Starting subtest: gen12-unprivileged-single-ctx-counters
[570.952610] Starting dynamic subtest: rcs0
[571.159266] Dynamic subtest rcs0: SUCCESS (0.210s)
[571.161535] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.212s)
[571.206028] [094/131] (457s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[571.296920] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[571.298790] Starting dynamic subtest: pipe-A-eDP-1
[572.649208] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.352s)
[572.934236] Starting dynamic subtest: pipe-B-eDP-1
[573.967787] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.043s)
[574.239617] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.944s)
[575.094282] [095/131] (453s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[575.190176] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[575.192281] Starting dynamic subtest: pipe-A-eDP-1
[575.213955] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[575.228333] Starting dynamic subtest: pipe-B-eDP-1
[575.249783] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[575.260310] Starting dynamic subtest: pipe-C-eDP-1
[575.281892] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[575.292722] Starting dynamic subtest: pipe-D-eDP-1
[575.315241] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[575.319312] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[577.383740] [096/131] (450s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[577.492500] Starting subtest: cursorA-vs-flipA-toggle
[588.616632] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.124s)
[589.447499] [097/131] (438s left) kms_flip (basic-flip-vs-dpms)
[589.542247] Starting subtest: basic-flip-vs-dpms
[589.544562] Starting dynamic subtest: A-eDP1
[592.116497] Dynamic subtest A-eDP1: SUCCESS (2.572s)
[592.127509] Starting dynamic subtest: B-eDP1
[594.287717] Dynamic subtest B-eDP1: SUCCESS (2.171s)
[594.299442] Starting dynamic subtest: C-eDP1
[596.356528] Dynamic subtest C-eDP1: SUCCESS (2.067s)
[596.367572] Starting dynamic subtest: D-eDP1
[598.454196] Dynamic subtest D-eDP1: SUCCESS (2.094s)
[598.456503] Subtest basic-flip-vs-dpms: SUCCESS (8.913s)
[599.278285] [098/131] (429s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[604.349687] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[604.354459] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[605.199811] [099/131] (423s left) gem_mmap_offset (isolation)
[605.247514] Starting subtest: isolation
[605.264272] Subtest isolation: SUCCESS (0.007s)
[605.373109] [100/131] (423s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[605.463605] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[605.467655] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[605.594485] [101/131] (422s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[605.693453] Starting subtest: y-tiled-addfb-size-offset-overflow
[605.697715] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[605.798471] [102/131] (422s left) i915_query (query-regions-garbage-items)
[605.865070] Starting subtest: query-regions-garbage-items
[605.867066] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[605.986256] [103/131] (422s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[606.081547] Starting subtest: yf-tiled-64bpp-rotate-180
[606.086063] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[606.189088] [104/131] (422s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[606.238452] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[606.347414] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[606.441142] [105/131] (422s left) kms_cursor_crc (cursor-onscreen-512x512)
[606.712829] Starting subtest: cursor-onscreen-512x512
[606.717278] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[606.904144] [106/131] (421s left) gem_ctx_param (invalid-ctx-set)
[606.962499] Starting subtest: invalid-ctx-set
[606.964874] Subtest invalid-ctx-set: SUCCESS (0.001s)
[607.066756] [107/131] (421s left) gem_softpin (zero)
[607.128891] Starting subtest: zero
[607.133644] Subtest zero: SUCCESS (0.004s)
[607.294495] [108/131] (421s left) kms_joiner (basic-ultra-joiner)
[607.404663] Subtest basic-ultra-joiner: SKIP (0.000s)
[607.481264] [109/131] (421s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[607.578262] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[614.596038] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.019s)
[614.745103] [110/131] (414s left) syncobj_eventfd (binary-wait-before-signal)
[614.804377] Starting subtest: binary-wait-before-signal
[614.834965] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[614.936991] [111/131] (414s left) kms_vblank (ts-continuation-dpms-suspend)
[615.026278] Starting subtest: ts-continuation-dpms-suspend
[615.028208] Starting dynamic subtest: pipe-A-eDP-1
[632.387697] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.842s)
[632.404034] Starting dynamic subtest: pipe-D-eDP-1
[650.103879] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.213s)
[650.106150] Subtest ts-continuation-dpms-suspend: SUCCESS (4.058s)
[650.924097] [112/131] (378s left) gem_exec_whisper (basic-queues-priority-all)
[650.998311] Starting subtest: basic-queues-priority-all
[671.424150] Subtest basic-queues-priority-all: SUCCESS (20.490s)
[671.635556] [113/131] (357s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[676.580815] Starting subtest: pr-primary-plane-update-sf-dmg-area
[676.585326] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[677.460718] [114/131] (351s left) kms_plane_lowres (tiling-yf)
[677.554809] Starting subtest: tiling-yf
[677.558768] Subtest tiling-yf: SKIP (0.000s)
[677.642866] [115/131] (351s left) kms_addfb_basic (too-high)
[677.741911] Starting subtest: too-high
[677.743832] Subtest too-high: SUCCESS (0.001s)
[677.871316] [116/131] (351s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[677.968932] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[677.971202] Starting dynamic subtest: pipe-A-eDP-1
[677.995322] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[678.009543] Starting dynamic subtest: pipe-B-eDP-1
[678.031473] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[678.042561] Starting dynamic subtest: pipe-C-eDP-1
[678.064506] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[678.075610] Starting dynamic subtest: pipe-D-eDP-1
[678.098247] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[678.102306] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[680.122775] [117/131] (349s left) gem_exec_parallel (basic)
[680.178635] Starting subtest: basic
[680.180978] Starting dynamic subtest: rcs0
[681.643233] Dynamic subtest rcs0: SUCCESS (1.468s)
[681.655729] Starting dynamic subtest: bcs0
[683.097948] Dynamic subtest bcs0: SUCCESS (1.454s)
[683.111984] Starting dynamic subtest: vcs0
[684.952773] Dynamic subtest vcs0: SUCCESS (1.849s)
[684.965486] Starting dynamic subtest: vcs1
[686.871953] Dynamic subtest vcs1: SUCCESS (1.915s)
[686.886258] Starting dynamic subtest: vecs0
[688.920159] Dynamic subtest vecs0: SUCCESS (2.044s)
[688.934381] Starting dynamic subtest: ccs0
[690.415328] Dynamic subtest ccs0: SUCCESS (1.493s)
[690.417920] Subtest basic: SUCCESS (10.237s)
[690.619406] [118/131] (338s left) kms_plane (plane-position-covered)
[690.713540] Starting subtest: plane-position-covered
[691.221259] Starting dynamic subtest: pipe-A-plane-1
[692.491309] Dynamic subtest pipe-A-plane-1: SUCCESS (1.271s)
[692.503757] Starting dynamic subtest: pipe-A-plane-2
[693.797820] Dynamic subtest pipe-A-plane-2: SUCCESS (1.304s)
[693.810887] Starting dynamic subtest: pipe-A-plane-3
[695.027250] Dynamic subtest pipe-A-plane-3: SUCCESS (1.228s)
[695.039860] Starting dynamic subtest: pipe-A-plane-4
[696.273063] Dynamic subtest pipe-A-plane-4: SUCCESS (1.245s)
[696.286017] Starting dynamic subtest: pipe-A-plane-5
[696.299872] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[697.447177] Starting dynamic subtest: pipe-B-plane-1
[698.669244] Dynamic subtest pipe-B-plane-1: SUCCESS (1.232s)
[698.682303] Starting dynamic subtest: pipe-B-plane-2
[699.919276] Dynamic subtest pipe-B-plane-2: SUCCESS (1.247s)
[699.933688] Starting dynamic subtest: pipe-B-plane-3
[701.244715] Dynamic subtest pipe-B-plane-3: SUCCESS (1.325s)
[701.257216] Starting dynamic subtest: pipe-B-plane-4
[702.554046] Dynamic subtest pipe-B-plane-4: SUCCESS (1.307s)
[702.565417] Starting dynamic subtest: pipe-B-plane-5
[702.580205] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[702.582456] Subtest plane-position-covered: SUCCESS (11.864s)
[703.379547] [119/131] (325s left) kms_flip (flip-vs-suspend-interruptible)
[703.479319] Starting subtest: flip-vs-suspend-interruptible
[703.481585] Starting dynamic subtest: A-eDP1
[752.813029] Dynamic subtest A-eDP1: SUCCESS (4.462s)
[752.825988] Starting dynamic subtest: B-eDP1
[801.809138] Dynamic subtest B-eDP1: SUCCESS (4.268s)
[801.821032] Starting dynamic subtest: C-eDP1
[850.803910] Dynamic subtest C-eDP1: SUCCESS (4.316s)
[850.821925] Starting dynamic subtest: D-eDP1
[899.807409] Dynamic subtest D-eDP1: SUCCESS (4.376s)
[899.810599] Subtest flip-vs-suspend-interruptible: SUCCESS (17.432s)
[901.054800] [120/131] (128s left) gem_flink_basic (double-flink)
[901.113211] Starting subtest: double-flink
[901.115719] Subtest double-flink: SUCCESS (0.000s)
[901.225074] [121/131] (128s left) kms_psr (psr-sprite-render)
[901.329401] Starting subtest: psr-sprite-render
[901.331764] Starting dynamic subtest: eDP-1
[903.061464] Dynamic subtest eDP-1: SUCCESS (1.739s)
[903.064147] Subtest psr-sprite-render: SUCCESS (1.740s)
[903.942132] [122/131] (125s left) gem_exec_reloc (basic-cpu-wc)
[904.157868] Subtest basic-cpu-wc: SKIP (0.000s)
[904.321134] [123/131] (125s left) gem_exec_fence (submit-chain)
[904.533678] Starting subtest: submit-chain
[904.555098] Subtest submit-chain: SUCCESS (0.025s)
[906.020350] [124/131] (123s left) gem_render_copy (yf-tiled-ccs-to-linear)
[906.089182] Starting subtest: yf-tiled-ccs-to-linear
[906.094664] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[906.286211] [125/131] (123s left) gem_ctx_shared (q-smoketest-all)
[906.344731] Starting subtest: Q-smoketest-all
[938.715871] Subtest Q-smoketest-all: SUCCESS (32.346s)
[939.999445] [126/131] ( 89s left) gem_ctx_param (invalid-param-get)
[940.047680] Starting subtest: invalid-param-get
[940.050412] Subtest invalid-param-get: SUCCESS (0.001s)
[940.182069] [127/131] ( 89s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[940.554456] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[941.364693] [128/131] ( 88s left) i915_pciid
[941.547294] [129/131] ( 88s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[941.645328] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[945.731135] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.092s)
[946.896077] [130/131] ( 82s left) gem_userptr_blits (process-exit)
[946.970133] Starting subtest: process-exit
[946.975819] Subtest process-exit: SUCCESS (0.006s)
[947.114817] [131/131] ( 82s left) gem_flink_race (flink_name)
[947.152681] Starting subtest: flink_name
[952.574292] Subtest flink_name: SUCCESS (5.426s)
[952.707048] Closing watchdogs
results: parsing output: 0/ for test: drm_mm
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_sync
results: parsing output: 3/ for test: kms_sharpness_filter
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_pm_rpm
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_chamelium_color
results: parsing output: 11/ for test: kms_pipe_crc_basic
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: gem_exec_store
results: parsing output: 14/ for test: gem_ppgtt
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_pipe_b_c_ivb
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: intel_hwmon
results: parsing output: 23/ for test: kms_atomic_transition
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_pread
results: parsing output: 32/ for test: kms_force_connector_basic
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: vgem_basic
results: parsing output: 37/ for test: fbdev
results: parsing output: 38/ for test: i915_drm_fdinfo
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: gem_readwrite
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_atomic_transition
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: kms_color
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: template
results: parsing output: 49/ for test: i915_pm_rpm
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: kms_draw_crc
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_dither
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: prime_busy
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_watchdog
results: parsing output: 62/ for test: kms_chamelium_edid
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: gem_cs_tlb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_exec_gttfill
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vrr
results: parsing output: 77/ for test: gem_exec_capture
results: parsing output: 78/ for test: kms_rmfb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_ringfill
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: kms_atomic_transition
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: gem_mmap_offset
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: i915_query
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: gem_softpin
results: parsing output: 107/ for test: kms_joiner
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_eventfd
results: parsing output: 110/ for test: kms_vblank
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_plane_lowres
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_exec_parallel
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: gem_flink_basic
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: gem_ctx_shared
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: i915_pciid
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: gem_flink_race
Done.