[61.439907] Initializing watchdogs
[61.439954]   /dev/watchdog0
[61.453569] [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]
[61.459453] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.462454] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.465761] [001/130] (960s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[61.591111] Starting subtest: multi-wait-all-for-submit-available-submitted
[61.593443] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[61.664892] [002/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[61.786198] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[61.790124] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[61.871126] [003/130] (960s left) kms_flip (dpms-off-confusion)
[61.965111] Starting subtest: dpms-off-confusion
[61.967332] Starting dynamic subtest: A-eDP1
[70.750472] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[70.758193] Starting dynamic subtest: B-eDP1
[79.411313] Dynamic subtest B-eDP1: SUCCESS (8.647s)
[79.420201] Starting dynamic subtest: C-eDP1
[88.131205] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[88.139035] Starting dynamic subtest: D-eDP1
[96.862460] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[96.864929] Subtest dpms-off-confusion: SUCCESS (34.840s)
[98.016589] [004/130] (924s left) gem_render_copy (yf-tiled)
[98.076573] Starting subtest: yf-tiled
[98.081267] Subtest yf-tiled: SKIP (0.000s)
[98.254191] [005/130] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[98.363411] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[98.367692] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[98.446288] [006/130] (923s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[98.547059] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[98.549404] Starting dynamic subtest: pipe-A
[99.603898] Dynamic subtest pipe-A: SUCCESS (1.057s)
[99.615438] Starting dynamic subtest: pipe-B
[101.728701] Dynamic subtest pipe-B: SUCCESS (2.124s)
[101.734989] Starting dynamic subtest: pipe-C
[102.927329] Dynamic subtest pipe-C: SUCCESS (1.198s)
[102.934747] Starting dynamic subtest: pipe-D
[104.059888] Dynamic subtest pipe-D: SUCCESS (1.133s)
[104.062235] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.512s)
[105.227929] [007/130] (916s left) gem_eio (wait-wedge-1us)
[105.395399] Starting subtest: wait-wedge-1us
[106.966734] Subtest wait-wedge-1us: SUCCESS (1.570s)
[107.114240] [008/130] (915s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[107.310749] Starting subtest: cursor-rapid-movement-128x42
[107.350473] Subtest cursor-rapid-movement-128x42: SKIP (0.034s)
[107.534299] [009/130] (914s left) gem_exec_reloc (basic-wc-gtt-active)
[107.597393] Subtest basic-wc-gtt-active: SKIP (0.000s)
[107.671931] [010/130] (914s left) kms_getfb (getfb-handle-protection)
[107.735060] Starting subtest: getfb-handle-protection
[107.762061] Subtest getfb-handle-protection: SUCCESS (0.027s)
[107.889122] [011/130] (914s left) kms_cursor_crc (cursor-onscreen-512x512)
[108.140543] Starting subtest: cursor-onscreen-512x512
[108.144283] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[108.288731] [012/130] (914s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[108.387606] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[108.389609] Starting dynamic subtest: pipe-A-eDP-1
[108.397184] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[108.404046] Starting dynamic subtest: pipe-B-eDP-1
[108.411796] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[108.418929] Starting dynamic subtest: pipe-C-eDP-1
[108.426812] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[108.435302] Starting dynamic subtest: pipe-D-eDP-1
[108.442470] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[108.446064] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[110.569947] [013/130] (911s left) kms_display_modes (extended-mode-basic)
[110.673042] Starting subtest: extended-mode-basic
[110.677413] Subtest extended-mode-basic: SKIP (0.000s)
[110.710848] [014/130] (911s left) kms_psr (psr-sprite-mmap-gtt)
[110.809720] Starting subtest: psr-sprite-mmap-gtt
[110.811924] Starting dynamic subtest: eDP-1
[112.296272] Dynamic subtest eDP-1: SKIP (1.481s)
[112.301232] Subtest psr-sprite-mmap-gtt: SKIP (1.482s)
[112.455603] [015/130] (910s left) kms_chamelium_color (ctm-red-to-blue)
[112.553288] Subtest ctm-red-to-blue: SKIP (0.000s)
[112.590875] [016/130] (909s left) gem_exec_balancer (individual)
[112.643163] Starting subtest: individual
[113.980578] Subtest individual: SUCCESS (1.335s)
[114.284649] [017/130] (908s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[114.394452] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[114.398914] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[114.488643] [018/130] (908s left) kms_vrr (flip-dpms)
[114.587048] Starting subtest: flip-dpms
[114.593812] Subtest flip-dpms: SKIP (0.000s)
[114.652902] [019/130] (907s left) gem_exec_schedule (u-submit-golden-slice)
[114.722100] Starting subtest: u-submit-golden-slice
[114.724334] Starting dynamic subtest: rcs0
[114.752666] Dynamic subtest rcs0: SUCCESS (0.038s)
[114.762815] Starting dynamic subtest: bcs0
[114.792355] Dynamic subtest bcs0: SUCCESS (0.039s)
[114.802032] Starting dynamic subtest: vcs0
[114.824683] Dynamic subtest vcs0: SUCCESS (0.032s)
[114.832984] Starting dynamic subtest: vcs1
[114.854403] Dynamic subtest vcs1: SUCCESS (0.029s)
[114.863182] Starting dynamic subtest: vecs0
[114.883889] Dynamic subtest vecs0: SUCCESS (0.029s)
[114.891677] Starting dynamic subtest: ccs0
[114.915223] Dynamic subtest ccs0: SUCCESS (0.031s)
[114.917489] Subtest u-submit-golden-slice: SUCCESS (0.200s)
[116.037451] [020/130] (906s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[116.144559] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[117.311366] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.167s)
[117.525621] [021/130] (905s left) kms_pm_rpm (basic-rte)
[117.559685] Starting subtest: basic-rte
[120.605485] Subtest basic-rte: SUCCESS (3.044s)
[122.075727] [022/130] (900s left) syncobj_timeline (etime-multi-wait-all-submitted)
[122.131561] Starting subtest: etime-multi-wait-all-submitted
[122.238989] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[122.310634] [023/130] (900s left) perf_pmu (init-busy)
[122.349338] Starting subtest: init-busy
[122.351774] Starting dynamic subtest: rcs0
[122.354266] Dynamic subtest rcs0: SUCCESS (0.001s)
[122.363512] Starting dynamic subtest: bcs0
[122.365684] Dynamic subtest bcs0: SUCCESS (0.001s)
[122.373095] Starting dynamic subtest: vcs0
[122.375224] Dynamic subtest vcs0: SUCCESS (0.001s)
[122.381893] Starting dynamic subtest: vcs1
[122.383751] Dynamic subtest vcs1: SUCCESS (0.000s)
[122.390533] Starting dynamic subtest: vecs0
[122.392430] Dynamic subtest vecs0: SUCCESS (0.001s)
[122.399734] Starting dynamic subtest: ccs0
[122.402052] Dynamic subtest ccs0: SUCCESS (0.000s)
[122.404310] Subtest init-busy: SUCCESS (0.005s)
[122.457839] [024/130] (900s left) kms_psr (fbc-pr-cursor-render)
[122.561276] Starting subtest: fbc-pr-cursor-render
[122.565833] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[122.626123] [025/130] (900s left) kms_psr (pr-cursor-mmap-gtt)
[122.725673] Starting subtest: pr-cursor-mmap-gtt
[122.730093] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[122.787248] [026/130] (900s left) gen9_exec_parse (cmd-crossing-page)
[122.846913] Subtest cmd-crossing-page: SKIP (0.000s)
[122.922627] [027/130] (899s left) gem_create (create-valid-nonaligned)
[122.984715] Starting subtest: create-valid-nonaligned
[122.987200] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[123.163530] [028/130] (899s left) kms_cursor_crc (cursor-offscreen-512x170)
[123.426594] Starting subtest: cursor-offscreen-512x170
[123.431082] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[123.586099] [029/130] (899s left) gem_mmap_offset (clear)
[123.639790] Starting subtest: clear
[123.642425] Starting dynamic subtest: smem0
[154.382588] Dynamic subtest smem0: SUCCESS (30.739s)
[154.384730] Subtest clear: SUCCESS (30.739s)
[154.564120] [030/130] (868s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[154.710060] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[154.712153] Starting dynamic subtest: pipe-A-default-mode
[157.382899] Dynamic subtest pipe-A-default-mode: SUCCESS (2.671s)
[157.384985] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.672s)
[158.246843] [031/130] (864s left) gem_exec_capture (pi)
[158.306120] Starting subtest: pi
[158.308627] Starting dynamic subtest: rcs0
[163.144939] Dynamic subtest rcs0: SUCCESS (4.838s)
[163.155318] Starting dynamic subtest: bcs0
[167.933797] Dynamic subtest bcs0: SUCCESS (4.787s)
[167.946262] Starting dynamic subtest: vcs0
[172.845370] Dynamic subtest vcs0: SUCCESS (4.911s)
[172.855584] Starting dynamic subtest: vcs1
[177.612884] Dynamic subtest vcs1: SUCCESS (4.768s)
[177.623391] Starting dynamic subtest: vecs0
[182.646627] Dynamic subtest vecs0: SUCCESS (5.029s)
[182.655283] Starting dynamic subtest: ccs0
[187.531726] Dynamic subtest ccs0: SUCCESS (4.887s)
[187.534273] Subtest pi: SUCCESS (29.223s)
[187.600532] [032/130] (835s left) kms_frontbuffer_tracking (fbc-stridechange)
[187.751504] Starting subtest: fbc-stridechange
[190.056339] Subtest fbc-stridechange: SUCCESS (2.308s)
[190.175422] [033/130] (832s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[190.276324] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[190.278704] Starting dynamic subtest: pipe-A-eDP-1
[190.302193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[190.312080] Starting dynamic subtest: pipe-B-eDP-1
[190.333884] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[190.342014] Starting dynamic subtest: pipe-C-eDP-1
[190.363762] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[190.371849] Starting dynamic subtest: pipe-D-eDP-1
[190.395763] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[190.400082] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[192.415575] [034/130] (830s left) kms_big_fb (linear-32bpp-rotate-180)
[192.528775] Starting subtest: linear-32bpp-rotate-180
[194.418568] Subtest linear-32bpp-rotate-180: SUCCESS (1.889s)
[194.633310] [035/130] (828s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[194.733917] Starting subtest: primary-x-tiled-reflect-x-180
[201.753574] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.020s)
[202.979455] [036/130] (820s left) i915_suspend (debugfs-reader)
[203.044887] Starting subtest: debugfs-reader
[220.611134] Subtest debugfs-reader: SUCCESS (3.186s)
[220.788590] [037/130] (816s left) gem_ctx_persistence (processes)
[220.866783] Starting subtest: processes
[222.306830] Subtest processes: SUCCESS (1.429s)
[222.380680] [038/130] (815s left) gem_exec_gttfill (multigpu-basic)
[222.554179] Starting subtest: multigpu-basic
[241.995298] Subtest multigpu-basic: SUCCESS (19.390s)
[242.035709] [039/130] (795s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[242.197063] Starting subtest: basic-flip-before-cursor-varying-size
[243.152517] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.955s)
[243.948662] [040/130] (793s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[244.037029] Starting subtest: drrs-dirtyfb-ioctl
[244.050089] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[244.150220] [041/130] (793s left) syncobj_eventfd (invalid-illegal-eventfd)
[244.212681] Starting subtest: invalid-illegal-eventfd
[244.215053] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[244.322584] [042/130] (793s left) gem_pxp (protected-raw-src-copy-not-readible)
[244.454458] Starting subtest: protected-raw-src-copy-not-readible
[244.511855] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[244.613034] [043/130] (793s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[244.716286] Starting subtest: fbc-indfb-scaledprimary
[248.713873] Subtest fbc-indfb-scaledprimary: SUCCESS (3.998s)
[248.868441] [044/130] (789s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[248.975183] Starting subtest: fbc-rgb101010-draw-render
[252.577443] Subtest fbc-rgb101010-draw-render: SUCCESS (3.605s)
[252.688655] [045/130] (785s left) i915_pm_rpm (system-suspend)
[254.435463] Starting subtest: system-suspend
[272.399845] Subtest system-suspend: SUCCESS (2.885s)
[272.763903] [046/130] (780s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[272.864962] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[272.867571] Starting dynamic subtest: pipe-A-default-mode
[273.157790] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[273.163168] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.288s)
[273.994738] [047/130] (779s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[274.385693] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[275.208246] [048/130] (778s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[275.311224] Starting subtest: compare-crc-sanitycheck-nv12
[275.313587] Starting dynamic subtest: pipe-A-eDP-1
[275.986651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.669s)
[275.997810] Starting dynamic subtest: pipe-B-eDP-1
[277.187799] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s)
[277.196607] Starting dynamic subtest: pipe-C-eDP-1
[278.363669] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.169s)
[278.373836] Starting dynamic subtest: pipe-D-eDP-1
[279.591590] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[279.593973] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.258s)
[280.445914] [049/130] (772s left) kms_psr (fbc-psr2-sprite-render)
[280.558716] Starting subtest: fbc-psr2-sprite-render
[280.560612] Starting dynamic subtest: eDP-1
[280.564736] Dynamic subtest eDP-1: SKIP (0.000s)
[280.568885] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[280.626852] [050/130] (772s left) gem_exec_reloc (basic-cpu-gtt-active)
[280.693064] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[280.764708] [051/130] (772s left) kms_rotation_crc (primary-rotation-270)
[280.861097] Starting subtest: primary-rotation-270
[280.865512] Subtest primary-rotation-270: SKIP (0.001s)
[280.929001] [052/130] (772s left) syncobj_wait (wait-any-snapshot)
[280.984475] Starting subtest: wait-any-snapshot
[281.066332] Subtest wait-any-snapshot: SUCCESS (0.082s)
[281.136911] [053/130] (772s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[281.244196] Starting subtest: psr-indfb-scaledprimary
[284.941150] Subtest psr-indfb-scaledprimary: SUCCESS (3.690s)
[285.070354] [054/130] (768s left) syncobj_wait (single-wait-all-for-submit-signaled)
[285.137336] Starting subtest: single-wait-all-for-submit-signaled
[285.139785] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[285.252908] [055/130] (768s left) kms_pipe_crc_basic (bad-source)
[285.357609] Starting subtest: bad-source
[285.359891] Subtest bad-source: SUCCESS (0.000s)
[285.424769] [056/130] (768s left) gen7_exec_parse (basic-offset)
[285.491205] Subtest basic-offset: SKIP (0.000s)
[285.571182] [057/130] (768s left) gem_ctx_persistence (heartbeat-stop)
[285.640833] Starting subtest: heartbeat-stop
[285.645423] Subtest heartbeat-stop: SKIP (0.000s)
[285.760059] [058/130] (767s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[285.867034] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[285.871378] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[286.933621] [059/130] (766s left) gem_ctx_param (basic)
[286.997358] Starting subtest: basic
[286.999753] Subtest basic: SUCCESS (0.002s)
[287.111470] [060/130] (766s left) perf (global-sseu-config-invalid)
[287.236185] Starting subtest: global-sseu-config-invalid
[287.240716] Subtest global-sseu-config-invalid: SKIP (0.000s)
[287.270993] [061/130] (766s left) drm_fdinfo (busy-check-all)
[287.319425] Starting subtest: busy-check-all
[287.321611] Starting dynamic subtest: rcs0
[287.326280] Dynamic subtest rcs0: SKIP (0.004s)
[287.335112] Starting dynamic subtest: bcs0
[287.339267] Dynamic subtest bcs0: SKIP (0.000s)
[287.347884] Starting dynamic subtest: vcs0
[287.352144] Dynamic subtest vcs0: SKIP (0.000s)
[287.360438] Starting dynamic subtest: vcs1
[287.364807] Dynamic subtest vcs1: SKIP (0.000s)
[287.373123] Starting dynamic subtest: vecs0
[287.377139] Dynamic subtest vecs0: SKIP (0.000s)
[287.385436] Starting dynamic subtest: ccs0
[287.389605] Dynamic subtest ccs0: SKIP (0.000s)
[287.393746] Subtest busy-check-all: SKIP (0.008s)
[287.422980] [062/130] (766s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[287.578875] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[291.069258] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (3.490s)
[291.246846] [063/130] (762s left) gem_exec_params (rs-invalid)
[291.309581] Starting subtest: rs-invalid
[291.314568] Subtest rs-invalid: SUCCESS (0.003s)
[291.428570] [064/130] (762s left) gem_flink_race (flink_name)
[291.458428] Starting subtest: flink_name
[296.857531] Subtest flink_name: SUCCESS (5.391s)
[296.957148] [065/130] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[297.060964] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[297.065406] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[297.169370] [066/130] (756s left) kms_chamelium_frames (hdmi-crc-single)
[297.561104] Subtest hdmi-crc-single: SKIP (0.000s)
[298.393746] [067/130] (755s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[298.503421] Starting subtest: psr-1p-primscrn-cur-indfb-move
[303.632148] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.128s)
[303.771277] [068/130] (750s left) gem_exec_whisper (basic-forked)
[303.842574] Starting subtest: basic-forked
[310.767201] Subtest basic-forked: SUCCESS (6.925s)
[310.944189] [069/130] (743s left) gem_ctx_param (set-priority-not-supported)
[310.996095] Starting subtest: set-priority-not-supported
[311.000695] Subtest set-priority-not-supported: SKIP (0.000s)
[311.066114] [070/130] (743s left) gem_caching (reads)
[311.112701] Subtest reads: SKIP (0.000s)
[311.195698] [071/130] (742s left) kms_atomic_interruptible (universal-setplane-primary)
[311.298519] Starting subtest: universal-setplane-primary
[311.300764] Starting dynamic subtest: pipe-A-eDP-1
[318.667430] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.367s)
[318.669455] Subtest universal-setplane-primary: SUCCESS (7.370s)
[319.500034] [072/130] (734s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[319.601608] Starting subtest: bad-aux-stride-y-tiled-ccs
[319.603921] Starting dynamic subtest: pipe-A-eDP-1
[319.626356] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.638233] Starting dynamic subtest: pipe-B-eDP-1
[319.661533] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.670005] Starting dynamic subtest: pipe-C-eDP-1
[319.691790] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.700256] Starting dynamic subtest: pipe-D-eDP-1
[319.722274] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.726635] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[321.747990] [073/130] (732s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[326.813442] Starting subtest: pr-overlay-plane-move-continuous-sf
[326.818408] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[327.647244] [074/130] (726s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[327.756225] Starting subtest: plane-all-modeset-transition-internal-panels
[327.758480] Starting dynamic subtest: pipe-A-eDP-1
[328.657465] Dynamic subtest pipe-A-eDP-1: FAIL (0.298s)
[328.668794] Starting dynamic subtest: pipe-B-eDP-1
[329.089662] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.032s)
[329.352841] Subtest plane-all-modeset-transition-internal-panels: FAIL (1.598s)
[330.186879] [075/130] (724s left) gem_softpin (evict-prime-sanity-check)
[330.250703] Starting subtest: evict-prime-sanity-check
[330.253083] Starting dynamic subtest: rcs0
[331.436924] Dynamic subtest rcs0: SUCCESS (1.185s)
[331.448841] Starting dynamic subtest: bcs0
[332.577239] Dynamic subtest bcs0: SUCCESS (1.138s)
[332.587079] Starting dynamic subtest: vcs0
[334.372588] Dynamic subtest vcs0: SUCCESS (1.792s)
[334.389318] Starting dynamic subtest: vcs1
[336.372118] Dynamic subtest vcs1: SUCCESS (1.997s)
[336.383749] Starting dynamic subtest: vecs0
[338.382261] Dynamic subtest vecs0: SUCCESS (2.007s)
[338.393792] Starting dynamic subtest: ccs0
[339.523800] Dynamic subtest ccs0: SUCCESS (1.140s)
[339.535171] Starting dynamic subtest: all
[340.671195] Dynamic subtest all: SUCCESS (1.145s)
[340.674171] Subtest evict-prime-sanity-check: SUCCESS (10.419s)
[340.748249] [076/130] (713s left) gem_exec_reloc (basic-cpu-gtt)
[340.810363] Subtest basic-cpu-gtt: SKIP (0.000s)
[340.879760] [077/130] (713s left) fbdev (unaligned-read)
[340.931211] Starting subtest: unaligned-read
[340.946977] Subtest unaligned-read: SUCCESS (0.016s)
[340.995872] [078/130] (713s left) gem_userptr_blits (unsync-unmap)
[341.064465] Subtest unsync-unmap: SKIP (0.000s)
[341.180393] [079/130] (713s left) gem_lmem_swapping (smem-oom)
[341.226128] Subtest smem-oom: SKIP (0.000s)
[341.263327] [080/130] (713s left) gem_exec_async (concurrent-writes)
[341.328605] Starting subtest: concurrent-writes
[341.330953] Starting dynamic subtest: rcs0
[341.357354] Dynamic subtest rcs0: SUCCESS (0.029s)
[341.367046] Starting dynamic subtest: bcs0
[341.369345] Dynamic subtest bcs0: SUCCESS (0.010s)
[341.379189] Starting dynamic subtest: vcs0
[341.381397] Dynamic subtest vcs0: SUCCESS (0.009s)
[341.390415] Starting dynamic subtest: vcs1
[341.392335] Dynamic subtest vcs1: SUCCESS (0.008s)
[341.401538] Starting dynamic subtest: vecs0
[341.403892] Dynamic subtest vecs0: SUCCESS (0.006s)
[341.412390] Starting dynamic subtest: ccs0
[341.414332] Dynamic subtest ccs0: SUCCESS (0.009s)
[341.416264] Subtest concurrent-writes: SUCCESS (0.074s)
[341.641570] [081/130] (712s left) api_intel_allocator (two-level-inception-interruptible)
[341.697056] Starting subtest: two-level-inception-interruptible
[347.121066] Subtest two-level-inception-interruptible: SUCCESS (5.421s)
[347.234906] [082/130] (707s left) kms_plane (planar-pixel-format-settings)
[347.336202] Starting subtest: planar-pixel-format-settings
[347.364979] Subtest planar-pixel-format-settings: SUCCESS (0.028s)
[347.485844] [083/130] (707s left) kms_atomic_transition (plane-all-transition)
[347.582056] Starting subtest: plane-all-transition
[347.584304] Starting dynamic subtest: pipe-A-eDP-1
[350.085232] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s)
[350.372836] Starting dynamic subtest: pipe-B-eDP-1
[353.620980] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.258s)
[353.895588] Subtest plane-all-transition: SUCCESS (6.313s)
[354.726295] [084/130] (699s left) gem_exec_schedule (preempt-contexts)
[354.815912] Starting subtest: preempt-contexts
[354.817796] Starting dynamic subtest: rcs0
[354.863234] Dynamic subtest rcs0: SUCCESS (0.052s)
[354.877535] Starting dynamic subtest: bcs0
[354.909170] Dynamic subtest bcs0: SUCCESS (0.045s)
[354.919005] Starting dynamic subtest: vcs0
[354.949181] Dynamic subtest vcs0: SUCCESS (0.038s)
[354.959006] Starting dynamic subtest: vcs1
[354.990147] Dynamic subtest vcs1: SUCCESS (0.041s)
[354.999567] Starting dynamic subtest: vecs0
[355.029581] Dynamic subtest vecs0: SUCCESS (0.038s)
[355.039530] Starting dynamic subtest: ccs0
[355.070782] Dynamic subtest ccs0: SUCCESS (0.040s)
[355.072628] Subtest preempt-contexts: SUCCESS (0.259s)
[356.495173] [085/130] (698s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[356.614173] Starting subtest: x-tiled-8bpp-rotate-180
[357.804225] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.190s)
[357.951839] [086/130] (696s left) gem_userptr_blits (unsync-overlap)
[358.026468] Subtest unsync-overlap: SKIP (0.000s)
[358.164359] [087/130] (696s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[358.277458] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[358.280841] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[358.375710] [088/130] (696s left) kms_vblank (query-forked-hang)
[358.477512] Starting subtest: query-forked-hang
[358.479525] Starting dynamic subtest: pipe-A-eDP-1
[385.147446] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.665s)
[385.162666] Starting dynamic subtest: pipe-D-eDP-1
[400.103858] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.953s)
[400.106271] Subtest query-forked-hang: SUCCESS (41.623s)
[400.978203] [089/130] (653s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[401.084895] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[407.664705] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.583s)
[407.783006] [090/130] (647s left) kms_atomic (crtc-invalid-params-fence)
[407.877929] Starting subtest: crtc-invalid-params-fence
[407.880091] Starting dynamic subtest: pipe-A-eDP-1
[408.286075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s)
[408.288033] Subtest crtc-invalid-params-fence: SUCCESS (0.406s)
[409.097009] [091/130] (645s left) sysfs_defaults (readonly)
[409.173713] Starting subtest: readonly
[409.176176] Starting dynamic subtest: vecs0
[409.178535] Dynamic subtest vecs0: SUCCESS (0.000s)
[409.189946] Starting dynamic subtest: ccs0
[409.192129] Dynamic subtest ccs0: SUCCESS (0.000s)
[409.201139] Starting dynamic subtest: vcs0
[409.203351] Dynamic subtest vcs0: SUCCESS (0.000s)
[409.212083] Starting dynamic subtest: bcs0
[409.214309] Dynamic subtest bcs0: SUCCESS (0.000s)
[409.223528] Starting dynamic subtest: rcs0
[409.225798] Dynamic subtest rcs0: SUCCESS (0.000s)
[409.235087] Starting dynamic subtest: vcs1
[409.237677] Dynamic subtest vcs1: SUCCESS (0.000s)
[409.240018] Subtest readonly: SUCCESS (0.005s)
[409.289181] [092/130] (645s left) gem_exec_reloc (basic-wc-active)
[409.355764] Subtest basic-wc-active: SKIP (0.000s)
[409.446632] [093/130] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[409.551866] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[409.555801] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[409.664068] [094/130] (645s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[409.769475] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[414.593681] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.826s)
[414.736615] [095/130] (640s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[414.851263] Starting subtest: y-tiled-8bpp-rotate-90
[414.855403] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[414.944726] [096/130] (640s left) gem_userptr_blits (unsync-unmap-cycles)
[415.007114] Subtest unsync-unmap-cycles: SKIP (0.000s)
[415.129633] [097/130] (639s left) i915_pm_freq_api (freq-suspend)
[415.211989] Starting subtest: freq-suspend
[415.214439] Starting dynamic subtest: gt0
[431.603887] Dynamic subtest gt0: SUCCESS (1.244s)
[431.625421] Starting dynamic subtest: gt1
[447.520664] Dynamic subtest gt1: SUCCESS (1.140s)
[447.522949] Subtest freq-suspend: SUCCESS (2.386s)
[448.596493] [098/130] (637s left) perf (i915-ref-count)
[448.659844] Starting subtest: i915-ref-count
[448.701627] Subtest i915-ref-count: SUCCESS (0.039s)
[448.754750] [099/130] (637s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[448.869735] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[454.074468] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.174s)
[454.218880] [100/130] (631s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[454.278240] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[454.384556] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[454.454998] [101/130] (631s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[454.569603] Starting subtest: cursorB-vs-flipA-varying-size
[454.574168] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[454.716702] [102/130] (631s left) perf (invalid-create-userspace-config)
[454.797176] Starting subtest: invalid-create-userspace-config
[454.799356] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[454.841376] [103/130] (631s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[454.895224] Starting subtest: multi-wait-for-submit-available-signaled
[454.897505] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[454.993355] [104/130] (631s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[455.115845] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[455.120253] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[455.174884] [105/130] (631s left) core_auth (getclient-simple)
[455.213447] Starting subtest: getclient-simple
[455.237123] Subtest getclient-simple: SUCCESS (0.022s)
[455.341586] [106/130] (630s left) gem_create (create-ext-placement-sanity-check)
[455.514384] Starting subtest: create-ext-placement-sanity-check
[455.517084] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[455.633921] [107/130] (630s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[455.729447] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[455.731688] Starting dynamic subtest: pipe-A
[456.235054] Dynamic subtest pipe-A: SUCCESS (0.504s)
[456.245703] Starting dynamic subtest: pipe-B
[457.807980] Dynamic subtest pipe-B: SUCCESS (1.567s)
[457.823922] Starting dynamic subtest: pipe-C
[459.332157] Dynamic subtest pipe-C: SUCCESS (1.519s)
[459.342985] Starting dynamic subtest: pipe-D
[460.855770] Dynamic subtest pipe-D: SUCCESS (1.520s)
[460.858095] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (5.112s)
[462.054818] [108/130] (624s left) gem_eio (suspend)
[462.279196] Starting subtest: suspend
[474.121732] Subtest suspend: SUCCESS (11.828s)
[474.266246] [109/130] (612s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[474.376872] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[474.381331] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[474.471664] [110/130] (612s left) kms_prop_blob (invalid-set-prop-any)
[474.544036] Starting subtest: invalid-set-prop-any
[474.546290] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[474.647189] [111/130] (611s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[479.716245] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[479.718617] Starting dynamic subtest: pipe-A-eDP-1
[480.506372] Dynamic subtest pipe-A-eDP-1: SKIP (0.784s)
[480.517749] Starting dynamic subtest: pipe-B-eDP-1
[481.628072] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[481.632389] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.909s)
[482.807583] [112/130] (603s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[482.917146] Starting subtest: random-ccs-data-yf-tiled-ccs
[482.919363] Starting dynamic subtest: pipe-A-eDP-1
[482.943894] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[482.959968] Starting dynamic subtest: pipe-B-eDP-1
[482.983426] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[482.993775] Starting dynamic subtest: pipe-C-eDP-1
[483.017283] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[483.026170] Starting dynamic subtest: pipe-D-eDP-1
[483.051225] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[483.055758] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[485.061943] [113/130] (601s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[485.170212] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[485.172414] Starting dynamic subtest: pipe-A-default-mode
[487.884760] Dynamic subtest pipe-A-default-mode: SUCCESS (2.711s)
[487.886751] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.713s)
[488.748251] [114/130] (597s left) vgem_basic (dmabuf-mmap)
[488.876121] Starting subtest: dmabuf-mmap
[488.890542] Subtest dmabuf-mmap: SUCCESS (0.016s)
[488.937649] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[488.940690] [115/130] (597s left) i915_query (query-topology-matches-eu-total)
[488.991436] Starting subtest: query-topology-matches-eu-total
[488.993381] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[489.099412] [116/130] (597s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[489.223349] Starting subtest: flip-vs-cursor-busy-crc-atomic
[489.978457] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.756s)
[490.772990] [117/130] (595s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[490.884080] Starting subtest: yf-tiled-8bpp-rotate-0
[490.888351] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[490.995592] [118/130] (595s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[491.092678] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[491.097094] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[491.200060] [119/130] (595s left) kms_psr (psr2-primary-mmap-gtt)
[491.301678] Starting subtest: psr2-primary-mmap-gtt
[491.304060] Starting dynamic subtest: eDP-1
[493.695419] Dynamic subtest eDP-1: FAIL (1.800s)
[493.697773] Subtest psr2-primary-mmap-gtt: FAIL (1.801s)
[493.734761] [120/130] (593s left) gem_mmap_gtt (ptrace)
[493.795390] Subtest ptrace: SKIP (0.000s)
[493.852283] [121/130] (593s left) gem_ccs (block-copy-compressed)
[493.907013] Starting subtest: block-copy-compressed
[493.911180] Subtest block-copy-compressed: SKIP (0.000s)
[494.001911] [122/130] (592s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[494.095161] Starting subtest: multiplane-rotation-cropping-top
[501.273970] Subtest multiplane-rotation-cropping-top: SUCCESS (7.176s)
[501.383575] [123/130] (585s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[501.508613] Starting subtest: disable-crc-after-crtc
[501.510232] Starting dynamic subtest: pipe-A-eDP-1
[503.131047] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.622s)
[503.141095] Starting dynamic subtest: pipe-B-eDP-1
[505.379924] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.247s)
[505.389084] Starting dynamic subtest: pipe-C-eDP-1
[507.619454] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.238s)
[507.629579] Starting dynamic subtest: pipe-D-eDP-1
[509.862210] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s)
[509.864473] Subtest disable-crc-after-crtc: SUCCESS (8.353s)
[510.700109] [124/130] (576s left) prime_mmap_coherency (ioctl-errors)
[510.764918] Starting subtest: ioctl-errors
[527.510178] Subtest ioctl-errors: SUCCESS (16.741s)
[527.705318] [125/130] (559s left) gem_spin_batch (resubmit-all)
[527.800481] Starting subtest: resubmit-all
[527.803118] Starting dynamic subtest: rcs0
[527.820160] Dynamic subtest rcs0: SUCCESS (0.019s)
[527.838217] Starting dynamic subtest: bcs0
[527.840700] Dynamic subtest bcs0: SUCCESS (0.002s)
[527.852389] Starting dynamic subtest: vcs0
[527.854670] Dynamic subtest vcs0: SUCCESS (0.003s)
[527.863863] Starting dynamic subtest: vcs1
[527.866143] Dynamic subtest vcs1: SUCCESS (0.002s)
[527.875375] Starting dynamic subtest: vecs0
[527.877679] Dynamic subtest vecs0: SUCCESS (0.002s)
[527.886500] Starting dynamic subtest: ccs0
[527.888753] Dynamic subtest ccs0: SUCCESS (0.003s)
[527.891004] Subtest resubmit-all: SUCCESS (0.034s)
[529.335843] [126/130] (557s left) kms_flip (dpms-vs-vblank-race)
[529.431356] Starting subtest: dpms-vs-vblank-race
[529.433712] Starting dynamic subtest: A-eDP1
[534.457939] Dynamic subtest A-eDP1: SUCCESS (5.024s)
[534.468397] Starting dynamic subtest: B-eDP1
[539.065096] Dynamic subtest B-eDP1: SUCCESS (4.605s)
[539.074984] Starting dynamic subtest: C-eDP1
[543.652417] Dynamic subtest C-eDP1: SUCCESS (4.584s)
[543.662589] Starting dynamic subtest: D-eDP1
[548.243944] Dynamic subtest D-eDP1: SUCCESS (4.589s)
[548.246362] Subtest dpms-vs-vblank-race: SUCCESS (18.808s)
[549.113490] [127/130] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[549.232394] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[549.236665] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[549.345285] [128/130] (537s left) kms_busy (basic)
[549.453178] Starting subtest: basic
[549.455503] Starting dynamic subtest: flip
[550.080231] Dynamic subtest flip: SUCCESS (0.625s)
[550.090970] Starting dynamic subtest: modeset
[553.540796] Dynamic subtest modeset: SUCCESS (3.458s)
[553.543387] Subtest basic: SUCCESS (4.085s)
[554.342005] [129/130] (532s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[554.441628] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[554.453817] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[554.525430] [130/130] (532s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[554.626870] Starting subtest: 4-tiled-16bpp-rotate-90
[554.646442] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[554.779934] Closing watchdogs
Done.