[52.314731] Initializing watchdogs
[52.314776]   /dev/watchdog0
[52.330564] [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]
[52.334681] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.336872] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.340159] [001/133] (960s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[52.465771] Starting subtest: basic-modeset-with-all-modifiers-formats
[52.844489] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[53.598187] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.766s)
[53.604843] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[53.619515] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[53.630642] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[53.641184] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[53.648616] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[53.805346] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.166s)
[53.811962] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[53.827316] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[53.833738] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[53.849183] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[53.855563] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[53.870915] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[53.877440] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[53.893084] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[53.902040] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[53.915304] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[53.926980] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[53.937053] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[53.945881] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[53.958870] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[53.965724] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[53.980822] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[53.987498] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[54.123243] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[54.131827] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[54.144855] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[54.151776] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[54.167062] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[54.173873] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[54.189062] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[54.195823] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[54.210524] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[54.217369] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[54.232718] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[54.239579] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[54.254336] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[54.261362] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[54.276508] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[54.286274] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[54.298793] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[54.305231] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[54.452015] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[54.459977] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[54.473620] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[54.479965] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[54.495473] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[54.504464] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[54.517560] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[54.523927] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[54.539553] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[54.546056] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[54.561471] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[54.568192] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[54.583210] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[54.589917] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[54.605361] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[54.611837] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[54.627334] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[55.013658] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.587s)
[55.843668] [002/133] (957s left) syncobj_timeline (wait-all-snapshot)
[55.905162] Starting subtest: wait-all-snapshot
[55.985926] Subtest wait-all-snapshot: SUCCESS (0.083s)
[56.070386] [003/133] (956s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[56.179214] Starting subtest: basic-busy-flip-before-cursor-legacy
[56.183718] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[56.343652] [004/133] (956s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[56.460967] Starting subtest: flip-vs-cursor-varying-size
[64.868905] Subtest flip-vs-cursor-varying-size: SUCCESS (8.458s)
[65.711024] [005/133] (947s left) kms_psr (fbc-psr2-suspend)
[65.803275] Starting subtest: fbc-psr2-suspend
[65.805658] Starting dynamic subtest: eDP-1
[65.809890] Dynamic subtest eDP-1: SKIP (0.000s)
[65.814243] Subtest fbc-psr2-suspend: SKIP (0.000s)
[65.885305] [006/133] (947s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[65.994184] Starting subtest: yf-tiled-8bpp-rotate-0
[65.998077] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[66.111214] [007/133] (946s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[66.177188] Subtest writes-after-reads-uncached: SKIP (0.000s)
[66.259860] [008/133] (946s left) gem_exec_whisper (basic-contexts-priority-all)
[66.324960] Starting subtest: basic-contexts-priority-all
[90.854754] Subtest basic-contexts-priority-all: SUCCESS (24.489s)
[90.994750] [009/133] (922s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[91.094919] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[91.099126] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[91.200400] [010/133] (921s left) kms_flip (wf_vblank-ts-check-interruptible)
[91.302627] Starting subtest: wf_vblank-ts-check-interruptible
[91.304773] Starting dynamic subtest: A-eDP1
[100.261389] Dynamic subtest A-eDP1: SUCCESS (8.924s)
[100.270557] Starting dynamic subtest: B-eDP1
[109.185831] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[109.193791] Starting dynamic subtest: C-eDP1
[118.123525] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[118.134430] Starting dynamic subtest: D-eDP1
[127.063073] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[127.065667] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.716s)
[128.256385] [011/133] (884s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[128.357616] Starting subtest: stress-xrgb8888-ytiled
[128.362324] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[128.443507] [012/133] (884s left) api_intel_allocator (reserve-simple)
[128.500951] Starting subtest: reserve-simple
[128.504247] Subtest reserve-simple: SUCCESS (0.005s)
[128.631328] [013/133] (884s left) kms_content_protection (atomic-dpms-hdcp14)
[128.774133] Starting subtest: atomic-dpms-hdcp14
[128.778853] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[128.926910] [014/133] (884s left) kms_pm_rpm (legacy-planes)
[131.055707] Starting subtest: legacy-planes
[131.058632] Starting dynamic subtest: plane-64
[139.373409] Dynamic subtest plane-64: SUCCESS (8.317s)
[139.384346] Starting dynamic subtest: plane-94
[147.650682] Dynamic subtest plane-94: SUCCESS (8.276s)
[147.661813] Starting dynamic subtest: plane-124
[155.968340] Dynamic subtest plane-124: SUCCESS (8.316s)
[155.979865] Starting dynamic subtest: plane-134
[164.241763] Dynamic subtest plane-134: SUCCESS (8.273s)
[164.244376] Subtest legacy-planes: SUCCESS (33.187s)
[164.632375] [015/133] (848s left) kms_pm_lpsp (kms-lpsp)
[165.734986] Starting subtest: kms-lpsp
[165.736918] Starting dynamic subtest: pipe-A-eDP-1
[165.873392] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[166.171876] Subtest kms-lpsp: SUCCESS (0.436s)
[167.046025] [016/133] (846s left) kms_addfb_basic (no-handle)
[167.112192] Starting subtest: no-handle
[167.114541] Subtest no-handle: SUCCESS (0.000s)
[167.294684] [017/133] (846s left) perf_pmu (init-sema)
[167.335206] Starting subtest: init-sema
[167.337563] Starting dynamic subtest: rcs0
[167.339768] Dynamic subtest rcs0: SUCCESS (0.002s)
[167.349110] Starting dynamic subtest: bcs0
[167.351198] Dynamic subtest bcs0: SUCCESS (0.000s)
[167.358949] Starting dynamic subtest: vcs0
[167.361148] Dynamic subtest vcs0: SUCCESS (0.001s)
[167.369286] Starting dynamic subtest: vcs1
[167.371134] Dynamic subtest vcs1: SUCCESS (0.000s)
[167.378079] Starting dynamic subtest: vecs0
[167.379954] Dynamic subtest vecs0: SUCCESS (0.000s)
[167.386870] Starting dynamic subtest: ccs0
[167.388773] Dynamic subtest ccs0: SUCCESS (0.000s)
[167.390653] Subtest init-sema: SUCCESS (0.006s)
[167.480941] [018/133] (845s left) gem_fenced_exec_thrash (no-spare-fences)
[167.552245] Subtest no-spare-fences: SKIP (0.000s)
[167.629243] [019/133] (845s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[167.691144] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[167.760599] [020/133] (845s left) kms_hdr (bpc-switch-dpms)
[167.860647] Starting subtest: bpc-switch-dpms
[168.909833] Starting dynamic subtest: pipe-A-eDP-1
[173.339157] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.431s)
[173.341584] Subtest bpc-switch-dpms: SUCCESS (5.479s)
[173.493736] [021/133] (840s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[173.607704] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[180.988870] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.381s)
[181.135101] [022/133] (832s left) syncobj_timeline (reset-multiple-signaled)
[181.188991] Starting subtest: reset-multiple-signaled
[181.191412] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[181.289827] [023/133] (832s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[181.401664] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[181.403554] Starting dynamic subtest: pipe-A-eDP-1
[181.463161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[181.471999] Starting dynamic subtest: pipe-B-eDP-1
[181.523422] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[181.531588] Starting dynamic subtest: pipe-C-eDP-1
[181.586478] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[181.594262] Starting dynamic subtest: pipe-D-eDP-1
[181.646739] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.057s)
[181.648914] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.245s)
[183.904490] [024/133] (829s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[184.005259] Starting subtest: pr-plane-move-sf-dmg-area
[184.009138] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[184.081206] [025/133] (829s left) gem_mmap_gtt (medium-copy-odd)
[184.140278] Subtest medium-copy-odd: SKIP (0.000s)
[184.205718] [026/133] (829s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[184.318263] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[184.322268] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[184.438209] [027/133] (829s left) sw_sync (sync_busy_fork_unixsocket)
[184.471164] Starting subtest: sync_busy_fork_unixsocket
[184.477783] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[184.570887] [028/133] (829s left) kms_async_flips (crc-atomic)
[184.665925] Starting subtest: crc-atomic
[185.046428] Starting dynamic subtest: pipe-A-eDP-1
[187.921630] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.874s)
[188.312477] Starting dynamic subtest: pipe-B-eDP-1
[191.257636] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.951s)
[191.633395] Starting dynamic subtest: pipe-C-eDP-1
[194.474202] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.849s)
[194.850790] Starting dynamic subtest: pipe-D-eDP-1
[197.725669] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.883s)
[197.727814] Subtest crc-atomic: SUCCESS (13.060s)
[198.888651] [029/133] (815s left) gem_exec_balancer (hog)
[198.951642] Starting subtest: hog
[198.956122] Subtest hog: SKIP (0.000s)
[199.264504] [030/133] (814s left) gem_exec_whisper (basic-sync)
[199.336218] Starting subtest: basic-sync
[206.450448] Subtest basic-sync: SUCCESS (7.090s)
[206.632050] [031/133] (807s left) kms_cursor_crc (cursor-onscreen-256x256)
[206.882699] Starting subtest: cursor-onscreen-256x256
[206.884839] Starting dynamic subtest: pipe-A-eDP-1
[208.997407] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s)
[209.021885] Starting dynamic subtest: pipe-D-eDP-1
[211.749073] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.731s)
[211.751345] Subtest cursor-onscreen-256x256: SUCCESS (4.866s)
[212.563575] [032/133] (801s left) i915_drm_fdinfo (memory-info-purgeable)
[212.611649] Starting subtest: memory-info-purgeable
[212.613929] Starting dynamic subtest: smem0
[215.419598] Dynamic subtest smem0: SUCCESS (2.808s)
[215.421667] Subtest memory-info-purgeable: SUCCESS (2.808s)
[215.502592] [033/133] (798s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[215.597951] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[215.599914] Starting dynamic subtest: A-eDP1
[219.180833] Dynamic subtest A-eDP1: SUCCESS (3.580s)
[219.191215] Starting dynamic subtest: B-eDP1
[222.369342] Dynamic subtest B-eDP1: SUCCESS (3.187s)
[222.378952] Starting dynamic subtest: C-eDP1
[225.487085] Dynamic subtest C-eDP1: SUCCESS (3.117s)
[225.496113] Starting dynamic subtest: D-eDP1
[228.587250] Dynamic subtest D-eDP1: SUCCESS (3.101s)
[228.589658] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.991s)
[229.423991] [034/133] (784s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[229.519054] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[229.521210] Starting dynamic subtest: pipe-A-eDP-1
[229.543164] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[229.553605] Starting dynamic subtest: pipe-B-eDP-1
[229.573919] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[229.581796] Starting dynamic subtest: pipe-C-eDP-1
[229.602108] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[229.609705] Starting dynamic subtest: pipe-D-eDP-1
[229.631619] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[229.635712] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[231.680364] [035/133] (782s left) kms_chamelium_hpd (hdmi-hpd-storm)
[232.078622] Subtest hdmi-hpd-storm: SKIP (0.000s)
[232.875793] [036/133] (781s left) kms_vrr (seamless-rr-switch-drrs)
[232.981902] Starting subtest: seamless-rr-switch-drrs
[232.988649] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[233.051608] [037/133] (781s left) kms_cursor_crc (cursor-size-hints)
[233.180649] Starting subtest: cursor-size-hints
[233.182988] Starting dynamic subtest: pipe-A-eDP-1
[233.788895] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[233.797677] Starting dynamic subtest: pipe-D-eDP-1
[235.056608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.268s)
[235.059085] Subtest cursor-size-hints: SUCCESS (1.876s)
[235.880478] [038/133] (778s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[235.991328] Starting subtest: fbcpsr-tiling-y
[235.995659] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[236.121906] [039/133] (778s left) kms_psr (pr-cursor-blt)
[236.225923] Starting subtest: pr-cursor-blt
[236.230377] Subtest pr-cursor-blt: SKIP (0.000s)
[236.305655] [040/133] (778s left) kms_cursor_crc (cursor-sliding-32x32)
[236.447851] Starting subtest: cursor-sliding-32x32
[236.492168] Subtest cursor-sliding-32x32: SKIP (0.039s)
[236.785162] [041/133] (777s left) gem_exec_params (secure-non-master)
[236.842344] Starting subtest: secure-non-master
[236.845950] Subtest secure-non-master: SKIP (0.000s)
[236.951722] [042/133] (777s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[237.053323] Starting subtest: psr-rgb101010-draw-mmap-gtt
[237.056879] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[237.190430] [043/133] (777s left) kms_universal_plane (universal-plane-functional)
[237.284804] Starting subtest: universal-plane-functional
[237.286715] Starting dynamic subtest: pipe-A-eDP-1
[241.218592] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.932s)
[241.227391] Starting dynamic subtest: pipe-B-eDP-1
[245.818034] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.600s)
[245.829948] Starting dynamic subtest: pipe-C-eDP-1
[250.065240] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.244s)
[250.073775] Starting dynamic subtest: pipe-D-eDP-1
[254.473754] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.403s)
[254.476063] Subtest universal-plane-functional: SUCCESS (17.187s)
[255.361462] [044/133] (759s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[255.459400] Starting subtest: plane-downscale-factor-0-5-with-rotation
[255.461855] Starting dynamic subtest: pipe-A
[255.479990] Dynamic subtest pipe-A: SKIP (0.016s)
[255.488845] Starting dynamic subtest: pipe-B
[255.508963] Dynamic subtest pipe-B: SKIP (0.028s)
[255.517245] Starting dynamic subtest: pipe-C
[255.537523] Dynamic subtest pipe-C: SKIP (0.028s)
[255.545494] Starting dynamic subtest: pipe-D
[255.566131] Dynamic subtest pipe-D: SKIP (0.027s)
[255.570438] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.101s)
[255.679134] [045/133] (758s left) i915_pm_freq_api (freq-reset-multiple)
[255.748442] Starting subtest: freq-reset-multiple
[255.750835] Starting dynamic subtest: gt0
[265.568346] Dynamic subtest gt0: SUCCESS (9.818s)
[265.576206] Starting dynamic subtest: gt1
[273.959287] Dynamic subtest gt1: SUCCESS (8.385s)
[273.961784] Subtest freq-reset-multiple: SUCCESS (18.204s)
[274.042189] [046/133] (740s left) gem_wait (write-wait)
[274.115582] Starting subtest: write-wait
[274.117569] Starting dynamic subtest: all-engines
[275.372755] Dynamic subtest all-engines: SUCCESS (1.259s)
[275.389885] Starting dynamic subtest: rcs0
[276.429204] Dynamic subtest rcs0: SUCCESS (1.055s)
[276.445181] Starting dynamic subtest: bcs0
[277.487151] Dynamic subtest bcs0: SUCCESS (1.055s)
[277.503139] Starting dynamic subtest: vcs0
[278.542272] Dynamic subtest vcs0: SUCCESS (1.052s)
[278.558062] Starting dynamic subtest: vcs1
[279.598279] Dynamic subtest vcs1: SUCCESS (1.054s)
[279.614502] Starting dynamic subtest: vecs0
[280.652155] Dynamic subtest vecs0: SUCCESS (1.051s)
[280.668462] Starting dynamic subtest: ccs0
[281.707047] Dynamic subtest ccs0: SUCCESS (1.053s)
[281.709619] Subtest write-wait: SUCCESS (7.595s)
[281.914426] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[281.917782] [047/133] (732s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[281.979590] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[281.984084] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[282.176432] [048/133] (732s left) kms_invalid_mode (clock-too-high)
[282.274192] Starting subtest: clock-too-high
[282.276610] Starting dynamic subtest: pipe-A-eDP-1
[282.280964] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[282.290936] Starting dynamic subtest: pipe-B-eDP-1
[282.295583] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[282.306158] Starting dynamic subtest: pipe-C-eDP-1
[282.310568] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[282.318449] Starting dynamic subtest: pipe-D-eDP-1
[282.322733] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.327105] Subtest clock-too-high: SKIP (0.004s)
[282.362901] [049/133] (732s left) gem_sync (basic-many-each)
[282.442357] Starting subtest: basic-many-each
[284.732849] Subtest basic-many-each: SUCCESS (2.301s)
[284.960130] [050/133] (729s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[285.072892] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[285.076995] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[285.155203] [051/133] (729s left) perf (unprivileged-single-ctx-counters)
[285.284677] Starting subtest: unprivileged-single-ctx-counters
[285.288630] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[285.331145] [052/133] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[285.424022] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[285.428473] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[285.533944] [053/133] (729s left) kms_psr (psr-cursor-plane-move)
[285.628221] Starting subtest: psr-cursor-plane-move
[285.630366] Starting dynamic subtest: eDP-1
[287.343566] Dynamic subtest eDP-1: SUCCESS (1.715s)
[287.345768] Subtest psr-cursor-plane-move: SUCCESS (1.716s)
[288.226122] [054/133] (726s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[288.324172] Starting subtest: 4-tiled-64bpp-rotate-270
[288.346796] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[288.502054] [055/133] (726s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[288.602174] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[289.580345] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.978s)
[289.752844] [056/133] (725s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[289.807342] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[289.913494] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[290.014067] [057/133] (725s left) gen9_exec_parse (secure-batches)
[290.081283] Subtest secure-batches: SKIP (0.000s)
[290.137662] [058/133] (724s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[290.244356] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[290.248676] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[290.396922] [059/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[290.492418] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[297.255499] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.765s)
[297.424704] [060/133] (717s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[297.541584] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[297.545964] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[297.683070] [061/133] (717s left) syncobj_timeline (invalid-transfer-illegal-handle)
[297.746976] Starting subtest: invalid-transfer-illegal-handle
[297.749158] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[297.868961] [062/133] (717s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[297.965324] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[297.976350] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[298.095311] [063/133] (717s left) gem_ctx_exec (basic-nohangcheck)
[298.149612] Starting subtest: basic-nohangcheck
[298.408933] Subtest basic-nohangcheck: SUCCESS (0.261s)
[298.556100] [064/133] (716s left) syncobj_wait (wait-for-submit-snapshot)
[298.612545] Starting subtest: wait-for-submit-snapshot
[298.694657] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[298.781648] [065/133] (716s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[298.882136] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[298.908232] Starting dynamic subtest: pipe-A-plane-0
[299.197434] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[299.208443] Starting dynamic subtest: pipe-A-plane-3
[299.429785] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[299.439481] Starting dynamic subtest: pipe-A-plane-5
[299.443155] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[300.532274] Starting dynamic subtest: pipe-B-plane-0
[300.797907] Dynamic subtest pipe-B-plane-0: SUCCESS (0.277s)
[300.808705] Starting dynamic subtest: pipe-B-plane-3
[301.031845] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[301.049237] Starting dynamic subtest: pipe-B-plane-5
[301.053984] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[301.339210] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.458s)
[302.213140] [066/133] (713s left) gem_softpin (allocator-evict)
[302.274242] Starting subtest: allocator-evict
[302.276640] Starting dynamic subtest: rcs0
[325.944878] Dynamic subtest rcs0: SUCCESS (23.669s)
[325.956792] Starting dynamic subtest: bcs0
[350.087308] Dynamic subtest bcs0: SUCCESS (24.141s)
[350.099482] Starting dynamic subtest: vcs0
[374.040400] Dynamic subtest vcs0: SUCCESS (23.950s)
[374.054642] Starting dynamic subtest: vcs1
[397.645033] Dynamic subtest vcs1: SUCCESS (23.603s)
[397.653750] Starting dynamic subtest: vecs0
[421.389182] Dynamic subtest vecs0: SUCCESS (23.742s)
[421.400869] Starting dynamic subtest: ccs0
[444.913387] Dynamic subtest ccs0: SUCCESS (23.523s)
[444.916156] Subtest allocator-evict: SUCCESS (142.635s)
[445.003925] [067/133] (570s left) gem_mmap_gtt (isolation)
[445.116164] Subtest isolation: SKIP (0.000s)
[445.179591] [068/133] (570s left) drm_read (short-buffer-nonblock)
[445.362077] Starting subtest: short-buffer-nonblock
[445.364460] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[445.565603] [069/133] (569s left) i915_pm_rc6_residency (media-rc6-accuracy)
[445.625567] Starting subtest: media-rc6-accuracy
[445.629751] Subtest media-rc6-accuracy: SKIP (0.000s)
[445.744474] [070/133] (569s left) syncobj_wait (multi-wait-for-submit-signaled)
[445.816653] Starting subtest: multi-wait-for-submit-signaled
[445.818788] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[445.941130] [071/133] (569s left) perf (oa-formats)
[446.052125] Starting subtest: oa-formats
[446.054171] Starting dynamic subtest: 0-rcs0
[446.064750] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[446.075245] Starting dynamic subtest: 1-vcs0
[446.087171] Dynamic subtest 1-vcs0: SUCCESS (0.021s)
[446.089163] Subtest oa-formats: SUCCESS (0.038s)
[446.128728] [072/133] (569s left) kms_lease (empty-lease)
[446.222922] Starting subtest: empty-lease
[446.224930] Starting dynamic subtest: pipe-A-eDP-1
[446.226949] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[446.236116] Starting dynamic subtest: pipe-B-eDP-1
[446.237766] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[446.245948] Starting dynamic subtest: pipe-C-eDP-1
[446.247695] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[446.255647] Starting dynamic subtest: pipe-D-eDP-1
[446.257312] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[446.258915] Subtest empty-lease: SUCCESS (0.009s)
[446.365219] [073/133] (569s left) kms_vblank (wait-busy-hang)
[446.466610] Starting subtest: wait-busy-hang
[446.468247] Starting dynamic subtest: pipe-A-eDP-1
[472.655573] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.185s)
[472.678846] Starting dynamic subtest: pipe-D-eDP-1
[497.691422] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.035s)
[497.693922] Subtest wait-busy-hang: SUCCESS (51.225s)
[498.558632] [074/133] (517s left) kms_flip (2x-flip-vs-wf_vblank)
[498.643430] Starting subtest: 2x-flip-vs-wf_vblank
[498.653952] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[498.743850] [075/133] (517s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[498.840698] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[498.844950] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[498.918244] [076/133] (516s left) api_intel_bb (full-batch)
[498.969706] Starting subtest: full-batch
[498.975027] Subtest full-batch: SUCCESS (0.006s)
[499.093181] [077/133] (516s left) kms_chamelium_color (ctm-0-25)
[499.194298] Subtest ctm-0-25: SKIP (0.000s)
[499.241910] [078/133] (516s left) gem_ctx_persistence (legacy-engines-cleanup)
[499.306762] Starting subtest: legacy-engines-cleanup
[499.309061] Starting dynamic subtest: render
[499.391500] Dynamic subtest render: SUCCESS (0.084s)
[499.406361] Starting dynamic subtest: bsd1
[499.452951] Dynamic subtest bsd1: SUCCESS (0.058s)
[499.463155] Starting dynamic subtest: bsd2
[499.515448] Dynamic subtest bsd2: SUCCESS (0.060s)
[499.529815] Starting dynamic subtest: blt
[499.571248] Dynamic subtest blt: SUCCESS (0.054s)
[499.584939] Starting dynamic subtest: vebox
[499.636304] Dynamic subtest vebox: SUCCESS (0.062s)
[499.638680] Subtest legacy-engines-cleanup: SUCCESS (0.331s)
[499.772361] [079/133] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[499.884065] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[499.887478] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[500.023957] [080/133] (515s left) kms_plane_lowres (tiling-y)
[500.131553] Starting subtest: tiling-y
[500.135041] Subtest tiling-y: SKIP (0.000s)
[500.219460] [081/133] (515s left) gem_exec_gttfill (all-engines)
[500.280473] Starting subtest: all-engines
[523.157501] Subtest all-engines: SUCCESS (22.874s)
[523.372059] [082/133] (492s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[523.535889] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[523.538106] Starting dynamic subtest: pipe-A-eDP-1
[523.560711] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[523.570050] Starting dynamic subtest: pipe-B-eDP-1
[523.591764] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[523.600624] Starting dynamic subtest: pipe-C-eDP-1
[523.623252] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[523.632271] Starting dynamic subtest: pipe-D-eDP-1
[523.654627] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[523.658720] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[525.737300] [083/133] (490s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[525.835662] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[525.839755] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[525.940656] [084/133] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[526.037659] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[526.041778] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[526.167720] [085/133] (490s left) syncobj_timeline (device-submit-unordered)
[526.233295] Starting subtest: device-submit-unordered
[526.235629] Subtest device-submit-unordered: SUCCESS (0.000s)
[526.320403] [086/133] (489s left) kms_setmode (clone-exclusive-crtc)
[526.378184] Starting subtest: clone-exclusive-crtc
[526.384787] Subtest clone-exclusive-crtc: SKIP (0.000s)
[526.499701] [087/133] (489s left) kms_chamelium_frames (hdmi-aspect-ratio)
[526.871765] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[527.646943] [088/133] (488s left) core_setmaster (master-drop-set-shared-fd)
[527.761597] Starting subtest: master-drop-set-shared-fd
[527.780784] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[527.818820] [089/133] (488s left) kms_dp_linktrain_fallback (dp-fallback)
[527.911155] Starting subtest: dp-fallback
[527.917846] Subtest dp-fallback: SKIP (0.000s)
[527.997180] [090/133] (488s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[528.097574] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[528.099887] Starting dynamic subtest: pipe-A-eDP-1
[528.123337] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[528.134975] Starting dynamic subtest: pipe-B-eDP-1
[528.157057] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[528.166040] Starting dynamic subtest: pipe-C-eDP-1
[528.187910] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[528.196870] Starting dynamic subtest: pipe-D-eDP-1
[528.218541] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[528.222631] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[530.357780] [091/133] (486s left) sw_sync (sync_multi_consumer)
[530.398052] Starting subtest: sync_multi_consumer
[530.824772] Subtest sync_multi_consumer: SUCCESS (0.426s)
[530.899948] [092/133] (485s left) kms_psr (psr-primary-mmap-gtt)
[530.996141] Starting subtest: psr-primary-mmap-gtt
[530.998489] Starting dynamic subtest: eDP-1
[532.445693] Dynamic subtest eDP-1: SKIP (1.446s)
[532.450514] Subtest psr-primary-mmap-gtt: SKIP (1.448s)
[532.652851] [093/133] (483s left) vgem_basic (dmabuf-fence)
[532.700415] Starting subtest: dmabuf-fence
[532.702655] Subtest dmabuf-fence: SUCCESS (0.000s)
[532.778338] [094/133] (483s left) kms_flip_event_leak (basic)
[532.876515] Starting subtest: basic
[532.878437] Starting dynamic subtest: pipe-A-eDP-1
[533.296772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[533.308534] Starting dynamic subtest: pipe-B-eDP-1
[534.392622] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.096s)
[534.411902] Starting dynamic subtest: pipe-C-eDP-1
[535.529167] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[535.540833] Starting dynamic subtest: pipe-D-eDP-1
[536.643550] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.113s)
[536.645699] Subtest basic: SUCCESS (3.767s)
[537.520535] [095/133] (479s left) gem_exec_schedule (out-order)
[537.590881] Starting subtest: out-order
[537.593086] Starting dynamic subtest: rcs0
[537.687449] Dynamic subtest rcs0: SUCCESS (0.103s)
[537.700050] Starting dynamic subtest: vcs0
[537.764688] Dynamic subtest vcs0: SUCCESS (0.077s)
[537.773953] Starting dynamic subtest: vcs1
[537.851220] Dynamic subtest vcs1: SUCCESS (0.086s)
[537.863595] Starting dynamic subtest: vecs0
[537.936569] Dynamic subtest vecs0: SUCCESS (0.085s)
[537.948098] Starting dynamic subtest: ccs0
[538.017430] Dynamic subtest ccs0: SUCCESS (0.079s)
[538.020045] Subtest out-order: SUCCESS (0.435s)
[539.039320] [096/133] (477s left) gem_userptr_blits (process-exit-busy)
[539.117833] Starting subtest: process-exit-busy
[539.137570] Subtest process-exit-busy: SUCCESS (0.020s)
[539.291199] [097/133] (477s left) kms_psr (fbc-psr2-primary-blt)
[539.387271] Starting subtest: fbc-psr2-primary-blt
[539.389189] Starting dynamic subtest: eDP-1
[539.393277] Dynamic subtest eDP-1: SKIP (0.000s)
[539.397273] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[539.488414] [098/133] (477s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[539.597105] Starting subtest: plane-upscale-20x20-with-rotation
[539.599416] Starting dynamic subtest: pipe-A
[539.821097] Dynamic subtest pipe-A: SUCCESS (0.226s)
[539.832244] Starting dynamic subtest: pipe-B
[541.088695] Dynamic subtest pipe-B: SUCCESS (1.267s)
[541.097214] Starting dynamic subtest: pipe-C
[542.432454] Dynamic subtest pipe-C: SUCCESS (1.343s)
[542.442320] Starting dynamic subtest: pipe-D
[543.753232] Dynamic subtest pipe-D: SUCCESS (1.320s)
[543.755643] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.159s)
[544.954728] [099/133] (471s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[545.054275] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[545.056576] Starting dynamic subtest: pipe-A-eDP-1
[545.080299] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[545.089454] Starting dynamic subtest: pipe-B-eDP-1
[545.111227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[545.120595] Starting dynamic subtest: pipe-C-eDP-1
[545.142076] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[545.151613] Starting dynamic subtest: pipe-D-eDP-1
[545.176063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[545.180277] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[547.207822] [100/133] (469s left) gem_userptr_blits (sync-unmap-cycles)
[547.276214] Starting subtest: sync-unmap-cycles
[552.644915] Subtest sync-unmap-cycles: SUCCESS (5.371s)
[552.801231] [101/133] (464s left) syncobj_basic (bad-handle-to-fd)
[552.864833] Starting subtest: bad-handle-to-fd
[552.866909] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[553.012093] [102/133] (463s left) gem_exec_fence (concurrent)
[553.189026] Starting subtest: concurrent
[553.194064] Subtest concurrent: SKIP (0.000s)
[554.992185] [103/133] (461s left) kms_dsc (dsc-with-output-formats)
[555.092118] Starting subtest: dsc-with-output-formats
[555.113292] Subtest dsc-with-output-formats: SKIP (0.000s)
[555.177892] [104/133] (461s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[555.273857] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[555.276081] Starting dynamic subtest: pipe-A-default-mode
[558.032180] Dynamic subtest pipe-A-default-mode: SUCCESS (2.756s)
[558.034531] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.758s)
[558.906200] [105/133] (458s left) i915_suspend (sysfs-reader)
[558.974157] Starting subtest: sysfs-reader
[577.044771] Subtest sysfs-reader: SUCCESS (3.232s)
[577.115906] [106/133] (440s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[577.217907] Starting subtest: primary-yf-tiled-reflect-x-90
[577.222204] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[577.301311] [107/133] (439s left) gem_bad_reloc (negative-reloc)
[577.368807] Subtest negative-reloc: SKIP (0.000s)
[577.429928] [108/133] (439s left) gem_madvise (dontneed-after-mmap)
[577.462044] Starting subtest: dontneed-after-mmap
[577.485129] Subtest dontneed-after-mmap: SUCCESS (0.025s)
[577.597179] [109/133] (439s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[577.710479] Starting subtest: basic-flip-after-cursor-legacy
[578.632349] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.945s)
[579.459402] [110/133] (437s left) gem_exec_schedule (semaphore-resolve)
[579.529937] Starting subtest: semaphore-resolve
[579.568175] Subtest semaphore-resolve: SUCCESS (0.039s)
[579.939817] [111/133] (437s left) sysfs_heartbeat_interval (nopreempt)
[579.996541] Starting subtest: nopreempt
[579.999008] Starting dynamic subtest: vecs0
[588.788509] Dynamic subtest vecs0: SUCCESS (8.909s)
[588.800115] Starting dynamic subtest: ccs0
[592.781857] Dynamic subtest ccs0: SUCCESS (4.015s)
[592.794528] Starting dynamic subtest: vcs0
[602.800577] Dynamic subtest vcs0: SUCCESS (10.045s)
[602.813546] Starting dynamic subtest: bcs0
[606.779410] Dynamic subtest bcs0: SUCCESS (3.981s)
[606.793006] Starting dynamic subtest: rcs0
[610.814303] Dynamic subtest rcs0: SUCCESS (4.031s)
[610.826290] Starting dynamic subtest: vcs1
[620.776362] Dynamic subtest vcs1: SUCCESS (9.956s)
[620.779408] Subtest nopreempt: SUCCESS (40.950s)
[620.867913] [112/133] (396s left) prime_vgem (shrink)
[620.949220] Starting subtest: shrink
[620.990476] Subtest shrink: SUCCESS (0.038s)
[621.110429] [113/133] (396s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[621.168154] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[621.173270] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[621.374438] [114/133] (396s left) gem_ctx_shared (q-independent)
[621.448844] Starting subtest: Q-independent
[621.451697] Starting dynamic subtest: rcs0
[621.586187] Dynamic subtest rcs0: SUCCESS (0.136s)
[621.598959] Starting dynamic subtest: vcs0
[621.668583] Dynamic subtest vcs0: SUCCESS (0.083s)
[621.681943] Starting dynamic subtest: vcs1
[621.737817] Dynamic subtest vcs1: SUCCESS (0.069s)
[621.750952] Starting dynamic subtest: vecs0
[621.818632] Dynamic subtest vecs0: SUCCESS (0.080s)
[621.830549] Starting dynamic subtest: ccs0
[621.913843] Dynamic subtest ccs0: SUCCESS (0.095s)
[621.916444] Subtest Q-independent: SUCCESS (0.465s)
[622.876020] [115/133] (394s left) gem_create (create-ext-set-pat)
[623.053802] Starting subtest: create-ext-set-pat
[623.056231] Subtest create-ext-set-pat: SUCCESS (0.001s)
[623.170637] [116/133] (394s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[623.279430] Starting subtest: y-tiled-64bpp-rotate-90
[623.285297] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[623.400882] [117/133] (394s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[623.504876] Starting subtest: x-tiled-16bpp-rotate-0
[624.761547] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.257s)
[624.913060] [118/133] (392s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[625.005839] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[625.007837] Starting dynamic subtest: pipe-A-eDP-1
[626.310772] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.304s)
[626.589809] Starting dynamic subtest: pipe-B-eDP-1
[627.632569] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.051s)
[627.900810] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.893s)
[628.757246] [119/133] (388s left) gem_exec_fence (submit67)
[628.942591] Starting subtest: submit67
[628.948563] Subtest submit67: SKIP (0.000s)
[630.873980] [120/133] (386s left) gem_pxp (create-regular-context-2)
[630.995541] Starting subtest: create-regular-context-2
[630.998455] Subtest create-regular-context-2: SUCCESS (0.001s)
[631.112648] [121/133] (386s left) kms_color (gamma)
[631.213470] Starting subtest: gamma
[631.215769] Starting dynamic subtest: pipe-A-eDP-1
[631.978716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.764s)
[631.989469] Starting dynamic subtest: pipe-B-eDP-1
[633.372302] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s)
[633.385345] Starting dynamic subtest: pipe-C-eDP-1
[634.725180] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[634.737066] Starting dynamic subtest: pipe-D-eDP-1
[636.036612] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[636.039435] Subtest gamma: SUCCESS (4.827s)
[636.883817] [122/133] (380s left) kms_psr (fbc-pr-cursor-render)
[636.992454] Starting subtest: fbc-pr-cursor-render
[636.997741] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[637.077937] [123/133] (380s left) perf_pmu (all-busy-check-all)
[637.122541] Starting subtest: all-busy-check-all
[638.753797] Subtest all-busy-check-all: SUCCESS (1.632s)
[638.890944] [124/133] (379s left) gem_exec_capture (userptr)
[638.951978] Starting subtest: userptr
[639.775424] Subtest userptr: SUCCESS (0.821s)
[639.926313] [125/133] (378s left) kms_big_fb (linear-64bpp-rotate-90)
[640.038604] Starting subtest: linear-64bpp-rotate-90
[640.058362] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[640.211527] [126/133] (377s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[640.314626] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[640.319360] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[640.424757] [127/133] (377s left) syncobj_wait (multi-wait-signaled)
[640.484399] Starting subtest: multi-wait-signaled
[640.486780] Subtest multi-wait-signaled: SUCCESS (0.000s)
[640.599224] [128/133] (377s left) gem_exec_suspend (basic-s3)
[640.672073] Starting subtest: basic-S3
[640.674452] Starting dynamic subtest: smem
[662.019531] Dynamic subtest smem: SUCCESS (7.154s)
[662.022142] Subtest basic-S3: SUCCESS (7.155s)
[662.214607] [129/133] (355s left) template (b)
[662.272719] Starting subtest: B
[662.275046] Subtest B: SUCCESS (0.000s)
[662.391549] [130/133] (355s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[662.490544] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[662.494601] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[662.599157] [131/133] (355s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[662.682790] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[669.914378] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.359s)
[670.062991] [132/133] (348s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[670.128985] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[670.232438] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[670.322538] [133/133] (347s left) kms_fbcon_fbt (fbc-suspend)
[670.393544] Starting subtest: fbc-suspend
[720.319096] Subtest fbc-suspend: SUCCESS (19.491s)
[721.636020] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_partial_pwrite_pread
results: parsing output: 7/ for test: gem_exec_whisper
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_pipe_stress
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: kms_pm_rpm
results: parsing output: 14/ for test: kms_pm_lpsp
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_fenced_exec_thrash
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: kms_hdr
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: kms_async_flips
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: gem_exec_whisper
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: i915_drm_fdinfo
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_chamelium_hpd
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_universal_plane
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: i915_pm_freq_api
results: parsing output: 45/ for test: gem_wait
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_sync
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gem_ctx_exec
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: drm_read
results: parsing output: 68/ for test: i915_pm_rc6_residency
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: kms_lease
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_chamelium_color
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane_lowres
results: parsing output: 80/ for test: gem_exec_gttfill
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_setmode
results: parsing output: 86/ for test: kms_chamelium_frames
results: parsing output: 87/ for test: core_setmaster
results: parsing output: 88/ for test: kms_dp_linktrain_fallback
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: sw_sync
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: vgem_basic
results: parsing output: 93/ for test: kms_flip_event_leak
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: kms_dsc
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: i915_suspend
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: gem_bad_reloc
results: parsing output: 107/ for test: gem_madvise
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: sysfs_heartbeat_interval
results: parsing output: 111/ for test: prime_vgem
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: gem_ctx_shared
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: gem_exec_fence
results: parsing output: 119/ for test: gem_pxp
results: parsing output: 120/ for test: kms_color
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: gem_exec_capture
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: gem_exec_suspend
results: parsing output: 128/ for test: template
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_fbcon_fbt
Done.