[64.215382] Initializing watchdogs
[64.215448]   /dev/watchdog0
[64.235565] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[64.246582] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.250626] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.252820] [001/133] (960s left) kms_cursor_crc (cursor-onscreen-512x512)
[66.058998] Starting subtest: cursor-onscreen-512x512
[66.062056] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[66.316367] [002/133] (958s left) syncobj_timeline (device-signal-unordered)
[66.387155] Starting subtest: device-signal-unordered
[66.389057] Subtest device-signal-unordered: SUCCESS (0.001s)
[66.586562] [003/133] (958s left) kms_pm_rpm (basic-pci-d3-state)
[71.062846] Starting subtest: basic-pci-d3-state
[72.290173] Subtest basic-pci-d3-state: SUCCESS (1.228s)
[73.144580] [004/133] (951s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[74.711753] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[74.811385] [005/133] (950s left) kms_flip (2x-busy-flip)
[76.326999] Starting subtest: 2x-busy-flip
[76.340207] Subtest 2x-busy-flip: SKIP (0.013s)
[76.455742] [006/133] (948s left) kms_plane_lowres (tiling-x)
[77.983960] Starting subtest: tiling-x
[77.984930] Starting dynamic subtest: pipe-A-HDMI-A-3
[86.563552] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (8.577s)
[86.661237] Starting dynamic subtest: pipe-B-HDMI-A-3
[95.482550] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (8.827s)
[95.580360] Starting dynamic subtest: pipe-C-HDMI-A-3
[104.418598] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (8.843s)
[104.497844] Starting dynamic subtest: pipe-D-HDMI-A-3
[113.492564] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (9.001s)
[113.564466] Subtest tiling-x: SUCCESS (35.578s)
[113.757223] [007/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[115.270887] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[115.272560] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[115.474493] [008/133] (909s left) i915_suspend (fence-restore-untiled)
[115.565065] Starting subtest: fence-restore-untiled
[115.566883] Subtest fence-restore-untiled: SKIP (0.000s)
[115.757389] [009/133] (909s left) gem_userptr_blits (nohangcheck)
[115.853408] Starting subtest: nohangcheck
[116.169481] Subtest nohangcheck: SUCCESS (0.315s)
[116.361581] [010/133] (909s left) api_intel_allocator (reloc-allocator)
[116.436218] Starting subtest: reloc-allocator
[116.437129] Starting dynamic subtest: basic
[116.464631] Dynamic subtest basic: SUCCESS (0.029s)
[116.473169] Starting dynamic subtest: parallel-one
[116.474096] Dynamic subtest parallel-one: SUCCESS (0.004s)
[116.482028] Starting dynamic subtest: print
[116.482938] Dynamic subtest print: SUCCESS (0.000s)
[116.491073] Starting dynamic subtest: reuse
[116.492148] Dynamic subtest reuse: SUCCESS (0.000s)
[116.499864] Starting dynamic subtest: fork-reopen-allocator
[116.500730] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[116.501735] Subtest reloc-allocator: SUCCESS (0.051s)
[116.638555] [011/133] (908s left) i915_pm_rpm (gem-execbuf)
[121.083453] Starting subtest: gem-execbuf
[121.084582] Starting dynamic subtest: lmem0
[125.177986] Dynamic subtest lmem0: SUCCESS (4.092s)
[125.226315] Starting dynamic subtest: smem0
[128.279532] Dynamic subtest smem0: SUCCESS (3.099s)
[128.280642] Subtest gem-execbuf: SUCCESS (7.199s)
[129.322718] [012/133] (896s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[130.835282] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[133.514112] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.679s)
[133.720589] [013/133] (891s left) vgem_basic (sysfs)
[133.848198] Starting subtest: sysfs
[133.849197] Subtest sysfs: SUCCESS (0.001s)
[133.948896] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[133.950761] [014/133] (891s left) perf (sysctl-defaults)
[134.046135] Starting subtest: sysctl-defaults
[134.047054] Subtest sysctl-defaults: SUCCESS (0.000s)
[134.392828] [015/133] (891s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[134.479906] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[134.482177] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[134.729971] [016/133] (891s left) kms_hdr (bpc-switch-dpms)
[136.246314] Starting subtest: bpc-switch-dpms
[136.249014] Subtest bpc-switch-dpms: SKIP (0.000s)
[136.349992] [017/133] (889s left) i915_query (query-topology-matches-eu-total)
[136.449297] Starting subtest: query-topology-matches-eu-total
[136.450196] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[136.590713] [018/133] (889s left) perf (blocking-parameterized)
[136.794550] Starting subtest: blocking-parameterized
[156.829375] Subtest blocking-parameterized: SUCCESS (20.034s)
[156.893240] [019/133] (869s left) kms_prop_blob (blob-prop-lifetime)
[156.973294] Starting subtest: blob-prop-lifetime
[156.989400] Subtest blob-prop-lifetime: SUCCESS (0.017s)
[157.111241] [020/133] (868s left) perf_pmu (rc6)
[157.184149] Starting subtest: rc6
[157.185162] Starting dynamic subtest: gt0
[163.543372] Dynamic subtest gt0: SUCCESS (6.357s)
[163.555375] Starting dynamic subtest: runtime-pm-gt0
[171.633829] Dynamic subtest runtime-pm-gt0: SUCCESS (8.088s)
[171.642933] Starting dynamic subtest: runtime-pm-long-gt0
[184.330882] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.695s)
[184.339996] Starting dynamic subtest: other-idle-gt0
[184.341931] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[184.342858] Subtest rc6: SUCCESS (27.147s)
[185.051720] [021/133] (841s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[186.571261] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[186.636187] [022/133] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[188.158943] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[188.160587] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[188.242274] [023/133] (837s left) fbdev (unaligned-read)
[188.310014] Starting subtest: unaligned-read
[188.323902] Subtest unaligned-read: SUCCESS (0.014s)
[188.373187] [024/133] (837s left) gem_ctx_isolation (nonpriv)
[188.462164] Starting subtest: nonpriv
[188.463012] Starting dynamic subtest: rcs0
[189.228356] Dynamic subtest rcs0: SUCCESS (0.767s)
[189.237507] Starting dynamic subtest: bcs0
[190.036230] Dynamic subtest bcs0: SUCCESS (0.807s)
[190.045375] Starting dynamic subtest: vcs0
[190.847634] Dynamic subtest vcs0: SUCCESS (0.811s)
[190.856877] Starting dynamic subtest: vcs1
[191.671682] Dynamic subtest vcs1: SUCCESS (0.823s)
[191.680963] Starting dynamic subtest: vecs0
[192.471946] Dynamic subtest vecs0: SUCCESS (0.799s)
[192.481220] Starting dynamic subtest: vecs1
[193.274603] Dynamic subtest vecs1: SUCCESS (0.802s)
[193.283762] Starting dynamic subtest: ccs0
[194.065451] Dynamic subtest ccs0: SUCCESS (0.790s)
[194.066403] Subtest nonpriv: SUCCESS (5.605s)
[194.338101] [025/133] (832s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[195.867368] Starting subtest: yf-tiled-32bpp-rotate-180
[195.869197] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[196.025505] [026/133] (830s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[196.163553] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[196.243633] [027/133] (830s left) kms_psr (fbc-psr-suspend)
[197.759836] Subtest fbc-psr-suspend: SKIP (0.000s)
[197.819145] [028/133] (828s left) prime_self_import (basic-with_one_bo_two_files)
[197.869578] Starting subtest: basic-with_one_bo_two_files
[197.917595] Subtest basic-with_one_bo_two_files: SUCCESS (0.049s)
[197.988865] [029/133] (828s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[199.506894] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[199.508532] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[199.594439] [030/133] (827s left) gem_exec_params (invalid-flag)
[199.690585] Starting subtest: invalid-flag
[199.691510] Subtest invalid-flag: SUCCESS (0.000s)
[199.779078] [031/133] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[201.297543] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[201.299255] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[201.373751] [032/133] (825s left) sw_sync (sync_merge)
[201.427912] Starting subtest: sync_merge
[201.428860] Subtest sync_merge: SUCCESS (0.000s)
[201.490923] [033/133] (825s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[201.570361] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[201.571270] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[201.679205] [034/133] (825s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[203.194862] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[203.423355] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.230s)
[203.575167] [035/133] (823s left) drm_mm (drm_mm)
[203.626310] Starting subtest: drm_mm
[203.648230] Starting dynamic subtest: drm_test_mm_init
[203.713891] Dynamic subtest drm_test_mm_init: SUCCESS (0.065s)
[203.725818] Starting dynamic subtest: drm_test_mm_debug
[203.779266] Dynamic subtest drm_test_mm_debug: SUCCESS (0.065s)
[203.815087] Starting dynamic subtest: drm_test_mm_align32
[203.856642] Dynamic subtest drm_test_mm_align32: SUCCESS (0.074s)
[203.893017] Starting dynamic subtest: drm_test_mm_align64
[203.926518] Dynamic subtest drm_test_mm_align64: SUCCESS (0.068s)
[203.939989] Starting dynamic subtest: drm_test_mm_lowest
[203.992903] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.065s)
[204.033579] Starting dynamic subtest: drm_test_mm_highest
[204.067065] Dynamic subtest drm_test_mm_highest: SUCCESS (0.071s)
[204.068266] Subtest drm_mm: SUCCESS (0.442s)
[204.230014] [036/133] (822s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[205.744262] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[205.757293] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.013s)
[205.823912] [037/133] (821s left) gem_lmem_swapping (random-engines)
[210.290133] Starting subtest: random-engines
[210.292061] Starting dynamic subtest: lmem0
[211.271784] Dynamic subtest lmem0: SUCCESS (0.982s)
[211.272678] Subtest random-engines: SUCCESS (0.983s)
[213.368447] [FACT gem_lmem_swapping (random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[213.369391] [FACT gem_lmem_swapping (random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[213.371620] [038/133] (813s left) kms_content_protection (srm)
[218.331660] Starting subtest: srm
[218.336978] Subtest srm: SKIP (0.003s)
[218.463957] [FACT kms_content_protection (srm)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[218.467361] [FACT kms_content_protection (srm)] new: kernel.kmod_is_loaded.i915: true
[218.470751] [039/133] (808s left) kms_psr (fbc-psr2-no-drrs)
[219.991973] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[220.051871] [040/133] (807s left) syncobj_wait (multi-wait-for-submit-signaled)
[220.133517] Starting subtest: multi-wait-for-submit-signaled
[220.134488] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[220.236740] [041/133] (807s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[221.749384] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[221.751287] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[221.804238] [042/133] (805s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[223.328618] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[225.942519] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.614s)
[226.090062] [043/133] (801s left) kms_addfb_basic (legacy-format)
[226.173402] Starting subtest: legacy-format
[226.207281] Subtest legacy-format: SUCCESS (0.033s)
[227.723040] [044/133] (799s left) gem_mmap_wc (read)
[227.810148] Subtest read: SKIP (0.000s)
[227.885405] [045/133] (799s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[229.400125] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[229.401838] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[229.454878] [046/133] (798s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[230.984384] Starting subtest: 4-tiled-16bpp-rotate-90
[231.042521] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.057s)
[231.166820] [047/133] (796s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[232.687412] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[232.689348] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[232.833021] [048/133] (794s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[234.350918] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[234.351834] Starting dynamic subtest: pipe-A-HDMI-A-3
[234.355149] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[234.364421] Starting dynamic subtest: pipe-B-HDMI-A-3
[234.367998] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[234.377113] Starting dynamic subtest: pipe-C-HDMI-A-3
[234.380788] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[234.389769] Starting dynamic subtest: pipe-D-HDMI-A-3
[234.393160] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[234.394955] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[234.581520] [049/133] (793s left) gem_ctx_persistence (hang)
[234.676221] Starting subtest: hang
[234.678608] Subtest hang: SKIP (0.000s)
[234.778147] [050/133] (793s left) kms_cursor_crc (cursor-random-128x42)
[236.510274] Starting subtest: cursor-random-128x42
[236.515211] Starting dynamic subtest: pipe-A-HDMI-A-3
[241.061918] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.546s)
[241.100211] Starting dynamic subtest: pipe-D-HDMI-A-3
[245.576562] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.485s)
[245.577427] Subtest cursor-random-128x42: SUCCESS (9.066s)
[245.866075] [051/133] (782s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[245.945792] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[245.946840] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[246.034738] [052/133] (781s left) kms_psr (psr-suspend)
[247.557385] Subtest psr-suspend: SKIP (0.000s)
[247.611475] [053/133] (780s left) kms_selftest (drm_damage_helper)
[247.662319] Starting subtest: drm_damage_helper
[247.689921] Starting dynamic subtest: drm_test_damage_iter_no_damage
[247.753558] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.063s)
[247.767888] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[247.825796] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.070s)
[247.865780] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[247.907565] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.078s)
[247.939187] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[247.984633] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.074s)
[248.022170] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[248.058343] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.069s)
[248.078592] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[248.145433] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.082s)
[248.182980] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[248.220440] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.074s)
[248.247792] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[248.292370] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.069s)
[248.331143] Starting dynamic subtest: drm_test_damage_iter_single_damage
[248.368478] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.071s)
[248.388563] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[248.442831] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.072s)
[248.481425] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[248.518343] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.071s)
[248.538583] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[248.594720] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.074s)
[248.633157] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[248.670323] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.070s)
[248.690184] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[248.760670] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.088s)
[248.801048] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[248.846626] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.081s)
[248.879163] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[248.915320] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.065s)
[248.938617] Starting dynamic subtest: drm_test_damage_iter_damage
[248.987808] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.070s)
[249.025365] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[249.057198] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.066s)
[249.082093] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[249.132708] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.073s)
[249.172584] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[249.218507] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.081s)
[249.258049] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[249.292450] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.069s)
[249.293586] Subtest drm_damage_helper: SUCCESS (1.630s)
[249.468266] [054/133] (778s left) gem_exec_balancer (parallel-ordering)
[249.824986] Starting subtest: parallel-ordering
[251.638213] Subtest parallel-ordering: SUCCESS (1.813s)
[251.758687] [055/133] (776s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[253.277189] Starting subtest: fbcpsr-rgb565-draw-pwrite
[253.278906] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[253.347545] [056/133] (774s left) gem_mmap_offset (oob-read)
[253.430514] Starting subtest: oob-read
[253.431475] Subtest oob-read: SUCCESS (0.000s)
[253.529907] [057/133] (774s left) perf_pmu (busy-idle)
[253.603280] Starting subtest: busy-idle
[253.604200] Starting dynamic subtest: rcs0
[254.304094] Dynamic subtest rcs0: SUCCESS (0.699s)
[254.317392] Starting dynamic subtest: bcs0
[254.967908] Dynamic subtest bcs0: SUCCESS (0.659s)
[254.981298] Starting dynamic subtest: vcs0
[255.632758] Dynamic subtest vcs0: SUCCESS (0.660s)
[255.647693] Starting dynamic subtest: vcs1
[256.301928] Dynamic subtest vcs1: SUCCESS (0.665s)
[256.315701] Starting dynamic subtest: vecs0
[256.969781] Dynamic subtest vecs0: SUCCESS (0.663s)
[256.984730] Starting dynamic subtest: vecs1
[257.640701] Dynamic subtest vecs1: SUCCESS (0.666s)
[257.654686] Starting dynamic subtest: ccs0
[258.307060] Dynamic subtest ccs0: SUCCESS (0.661s)
[258.313246] Subtest busy-idle: SUCCESS (4.706s)
[258.447416] [058/133] (769s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[259.973036] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[259.974892] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[260.049521] [059/133] (768s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[261.573176] Starting subtest: read-crc-frame-sequence
[261.574150] Starting dynamic subtest: pipe-A-HDMI-A-3
[262.276505] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.702s)
[262.288613] Starting dynamic subtest: pipe-B-HDMI-A-3
[262.758668] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.481s)
[262.769867] Starting dynamic subtest: pipe-C-HDMI-A-3
[263.249405] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.489s)
[263.260809] Starting dynamic subtest: pipe-D-HDMI-A-3
[263.773252] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.522s)
[263.774145] Subtest read-crc-frame-sequence: SUCCESS (2.202s)
[263.914046] [060/133] (764s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[265.428171] Starting subtest: cursorA-vs-flipA-atomic
[276.337468] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.910s)
[276.478740] [061/133] (752s left) kms_chamelium_color (ctm-limited-range)
[278.000102] Subtest ctm-limited-range: SKIP (0.000s)
[278.058513] [062/133] (750s left) kms_flip (2x-modeset-vs-vblank-race)
[279.575877] Starting subtest: 2x-modeset-vs-vblank-race
[279.588161] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[279.660348] [063/133] (748s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[281.172909] Starting subtest: bad-aux-stride-y-tiled-ccs
[281.173909] Starting dynamic subtest: pipe-A-HDMI-A-3
[281.182327] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[281.192402] Starting dynamic subtest: pipe-B-HDMI-A-3
[281.200937] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[281.210779] Starting dynamic subtest: pipe-C-HDMI-A-3
[281.219223] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[281.228665] Starting dynamic subtest: pipe-D-HDMI-A-3
[281.240134] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[281.242448] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[281.405061] [064/133] (747s left) gem_eio (in-flight-external)
[281.754384] Starting subtest: in-flight-external
[282.887490] Subtest in-flight-external: SUCCESS (1.133s)
[284.393516] [065/133] (744s left) kms_rotation_crc (sprite-rotation-180)
[285.911150] Starting subtest: sprite-rotation-180
[296.308191] Subtest sprite-rotation-180: SUCCESS (10.397s)
[296.515079] [066/133] (732s left) syncobj_timeline (wait-delayed-signal)
[296.596394] Starting subtest: wait-delayed-signal
[296.698712] Subtest wait-delayed-signal: SUCCESS (0.102s)
[296.772619] [067/133] (732s left) kms_flip (2x-flip-vs-dpms-on-nop)
[298.296230] Starting subtest: 2x-flip-vs-dpms-on-nop
[298.302547] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.013s)
[298.363264] [068/133] (730s left) kms_vrr (flip-dpms)
[299.878357] Starting subtest: flip-dpms
[299.880955] Subtest flip-dpms: SKIP (0.000s)
[299.952713] [069/133] (728s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[301.486994] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[301.488776] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[301.564823] [070/133] (727s left) gem_exec_schedule (preempt-self)
[301.669502] Starting subtest: preempt-self
[301.670463] Starting dynamic subtest: rcs0
[301.733507] Dynamic subtest rcs0: SUCCESS (0.063s)
[301.745622] Starting dynamic subtest: bcs0
[301.769382] Dynamic subtest bcs0: SUCCESS (0.035s)
[301.781494] Starting dynamic subtest: vcs0
[301.801263] Dynamic subtest vcs0: SUCCESS (0.031s)
[301.813088] Starting dynamic subtest: vcs1
[301.831512] Dynamic subtest vcs1: SUCCESS (0.029s)
[301.843757] Starting dynamic subtest: vecs0
[301.862893] Dynamic subtest vecs0: SUCCESS (0.030s)
[301.875143] Starting dynamic subtest: vecs1
[301.893340] Dynamic subtest vecs1: SUCCESS (0.029s)
[301.904169] Starting dynamic subtest: ccs0
[301.925333] Dynamic subtest ccs0: SUCCESS (0.031s)
[301.926249] Subtest preempt-self: SUCCESS (0.257s)
[302.294962] [071/133] (726s left) kms_cursor_legacy (forked-move)
[303.810201] Starting subtest: forked-move
[303.811126] Starting dynamic subtest: pipe-A
[309.226972] Dynamic subtest pipe-A: SUCCESS (5.414s)
[309.245427] Starting dynamic subtest: pipe-B
[314.667587] Dynamic subtest pipe-B: SUCCESS (5.440s)
[314.689290] Starting dynamic subtest: pipe-C
[320.108438] Dynamic subtest pipe-C: SUCCESS (5.437s)
[320.134033] Starting dynamic subtest: pipe-D
[325.547682] Dynamic subtest pipe-D: SUCCESS (5.438s)
[325.573858] Starting dynamic subtest: all-pipes
[330.986430] Dynamic subtest all-pipes: SUCCESS (5.437s)
[330.987329] Subtest forked-move: SUCCESS (27.176s)
[331.046778] [072/133] (698s left) prime_vgem (basic-fence-mmap)
[331.137180] Starting subtest: basic-fence-mmap
[331.138989] Subtest basic-fence-mmap: SKIP (0.000s)
[331.213387] [073/133] (697s left) gem_ctx_shared (detached-shared-gtt)
[331.308222] Starting subtest: detached-shared-gtt
[333.461777] Subtest detached-shared-gtt: SUCCESS (2.153s)
[335.481096] [074/133] (693s left) gem_create (create-ext-placement-each)
[335.673771] Starting subtest: create-ext-placement-each
[335.675531] Subtest create-ext-placement-each: SUCCESS (0.000s)
[335.812241] [075/133] (693s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[337.335959] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[337.337793] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[337.414115] [076/133] (691s left) kms_draw_crc (draw-method-mmap-gtt)
[338.934124] Starting subtest: draw-method-mmap-gtt
[338.935909] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[339.041851] [077/133] (690s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[340.577170] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[340.578038] Starting dynamic subtest: pipe-A
[340.664741] Dynamic subtest pipe-A: SUCCESS (0.088s)
[340.681058] Starting dynamic subtest: pipe-B
[340.809978] Dynamic subtest pipe-B: SUCCESS (0.144s)
[340.829126] Starting dynamic subtest: pipe-C
[340.968506] Dynamic subtest pipe-C: SUCCESS (0.157s)
[340.980788] Starting dynamic subtest: pipe-D
[341.093280] Dynamic subtest pipe-D: SUCCESS (0.124s)
[341.094193] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.518s)
[341.253570] [078/133] (688s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[342.779833] Starting subtest: y-tiled-16bpp-rotate-270
[342.781576] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[342.850684] [079/133] (686s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[342.940992] Starting subtest: x-tiled-to-vebox-y-tiled
[342.943218] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[343.132924] [080/133] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[344.650422] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[344.652232] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[344.736674] [081/133] (684s left) kms_plane (plane-position-hole)
[346.263122] Starting subtest: plane-position-hole
[346.710943] Starting dynamic subtest: pipe-A-plane-1
[347.111380] Dynamic subtest pipe-A-plane-1: SUCCESS (0.401s)
[347.122399] Starting dynamic subtest: pipe-A-plane-2
[347.480885] Dynamic subtest pipe-A-plane-2: SUCCESS (0.369s)
[347.492608] Starting dynamic subtest: pipe-A-plane-3
[347.854220] Dynamic subtest pipe-A-plane-3: SUCCESS (0.372s)
[347.865127] Starting dynamic subtest: pipe-A-plane-4
[348.225893] Dynamic subtest pipe-A-plane-4: SUCCESS (0.371s)
[348.237174] Starting dynamic subtest: pipe-A-plane-5
[348.246441] Dynamic subtest pipe-A-plane-5: SUCCESS (0.018s)
[348.504674] Starting dynamic subtest: pipe-B-plane-1
[348.878043] Dynamic subtest pipe-B-plane-1: SUCCESS (0.384s)
[348.889066] Starting dynamic subtest: pipe-B-plane-2
[349.232667] Dynamic subtest pipe-B-plane-2: SUCCESS (0.354s)
[349.244723] Starting dynamic subtest: pipe-B-plane-3
[349.607250] Dynamic subtest pipe-B-plane-3: SUCCESS (0.373s)
[349.618464] Starting dynamic subtest: pipe-B-plane-4
[349.979779] Dynamic subtest pipe-B-plane-4: SUCCESS (0.372s)
[349.990678] Starting dynamic subtest: pipe-B-plane-5
[350.000264] Dynamic subtest pipe-B-plane-5: SUCCESS (0.019s)
[350.001156] Subtest plane-position-hole: SUCCESS (3.738s)
[350.131970] [082/133] (679s left) gem_exec_flush (basic-uc-ro-default)
[350.217452] Subtest basic-uc-ro-default: SKIP (0.000s)
[350.294247] [083/133] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[351.813247] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[351.815109] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[351.901470] [084/133] (677s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[351.992476] Starting subtest: single-wait-all-for-submit-available-signaled
[351.993443] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[352.091401] [085/133] (677s left) gem_exec_fence (submit3)
[352.307581] Starting subtest: submit3
[352.310184] Subtest submit3: SKIP (0.000s)
[352.959433] [086/133] (676s left) kms_busy (basic)
[354.481039] Starting subtest: basic
[354.481916] Starting dynamic subtest: flip
[355.122703] Dynamic subtest flip: SUCCESS (0.641s)
[355.134967] Starting dynamic subtest: modeset
[355.773898] Dynamic subtest modeset: SUCCESS (0.650s)
[355.774793] Subtest basic: SUCCESS (1.294s)
[355.910369] [087/133] (674s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[357.430076] Starting subtest: crc-primary-basic-y-tiled-ccs
[357.431063] Starting dynamic subtest: pipe-A-HDMI-A-3
[357.439763] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[357.451106] Starting dynamic subtest: pipe-B-HDMI-A-3
[357.459844] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[357.470875] Starting dynamic subtest: pipe-C-HDMI-A-3
[357.479419] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[357.490670] Starting dynamic subtest: pipe-D-HDMI-A-3
[357.499606] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[357.501559] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.010s)
[357.660295] [088/133] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[359.187263] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[359.188996] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[359.259110] [089/133] (670s left) gem_softpin (evict-single-offset)
[359.348128] Starting subtest: evict-single-offset
[395.864534] Subtest evict-single-offset: SUCCESS (36.515s)
[395.933477] [090/133] (634s left) gem_sync (basic-each)
[396.078140] Starting subtest: basic-each
[399.067441] Subtest basic-each: SUCCESS (2.989s)
[399.297126] [091/133] (630s left) gem_ctx_param (invalid-param-set)
[399.376923] Starting subtest: invalid-param-set
[399.377895] Subtest invalid-param-set: SUCCESS (0.000s)
[399.443962] [092/133] (630s left) kms_color (ctm-0-25)
[400.965207] Starting subtest: ctm-0-25
[400.966137] Starting dynamic subtest: pipe-A-HDMI-A-3
[402.621094] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.655s)
[402.635024] Starting dynamic subtest: pipe-B-HDMI-A-3
[404.002872] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.381s)
[404.014246] Starting dynamic subtest: pipe-C-HDMI-A-3
[405.422957] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.418s)
[405.435126] Starting dynamic subtest: pipe-D-HDMI-A-3
[406.828421] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.404s)
[406.829363] Subtest ctm-0-25: SUCCESS (5.864s)
[406.990198] [093/133] (623s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[408.507040] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[408.569132] [094/133] (621s left) syncobj_timeline (invalid-transfer-illegal-handle)
[408.656580] Starting subtest: invalid-transfer-illegal-handle
[408.657648] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[408.747106] [095/133] (621s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[408.834365] Starting subtest: invalid-bsd1-flag-on-blt
[408.835363] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[408.930228] [096/133] (621s left) kms_async_flips (test-cursor-atomic)
[410.446355] Starting subtest: test-cursor-atomic
[410.697839] Starting dynamic subtest: pipe-A-HDMI-A-3
[410.977726] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.281s)
[411.180128] Starting dynamic subtest: pipe-B-HDMI-A-3
[411.244133] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.073s)
[411.426576] Starting dynamic subtest: pipe-C-HDMI-A-3
[411.516164] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.100s)
[411.695965] Starting dynamic subtest: pipe-D-HDMI-A-3
[411.758188] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.073s)
[411.759143] Subtest test-cursor-atomic: SUCCESS (1.313s)
[412.048756] [097/133] (618s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[413.574309] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[413.576112] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[413.672788] [098/133] (616s left) gem_eio (in-flight-internal-1us)
[414.076512] Starting subtest: in-flight-internal-1us
[414.915857] Subtest in-flight-internal-1us: SUCCESS (0.840s)
[416.421060] [099/133] (614s left) gem_lmem_swapping (heavy-multi)
[420.907370] Starting subtest: heavy-multi
[420.908331] Starting dynamic subtest: lmem0
[425.439652] Dynamic subtest lmem0: SUCCESS (4.531s)
[425.440550] Subtest heavy-multi: SUCCESS (4.533s)
[426.596129] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[426.597348] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[426.599262] [100/133] (604s left) kms_psr (psr2-cursor-plane-onoff)
[431.490261] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[431.550822] [FACT kms_psr (psr2-cursor-plane-onoff)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[431.553386] [FACT kms_psr (psr2-cursor-plane-onoff)] new: kernel.kmod_is_loaded.i915: true
[431.556202] [101/133] (599s left) kms_frontbuffer_tracking (fbc-stridechange)
[433.072937] Starting subtest: fbc-stridechange
[435.210407] Subtest fbc-stridechange: SUCCESS (2.137s)
[435.388393] [102/133] (595s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[436.914947] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[436.971121] [103/133] (593s left) i915_fb_tiling (basic-x-tiling)
[437.051439] Subtest basic-x-tiling: SKIP (0.000s)
[437.123387] [104/133] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[438.640873] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[438.642558] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[438.727330] [105/133] (592s left) gem_exec_schedule (preemptive-hang)
[438.964915] Starting subtest: preemptive-hang
[438.966674] Starting dynamic subtest: rcs0
[448.128387] Dynamic subtest rcs0: SUCCESS (9.162s)
[448.138787] Starting dynamic subtest: bcs0
[457.153762] Dynamic subtest bcs0: SUCCESS (9.023s)
[457.164734] Starting dynamic subtest: vcs0
[466.123823] Dynamic subtest vcs0: SUCCESS (8.969s)
[466.134492] Starting dynamic subtest: vcs1
[475.140704] Dynamic subtest vcs1: SUCCESS (9.016s)
[475.151200] Starting dynamic subtest: vecs0
[484.156750] Dynamic subtest vecs0: SUCCESS (9.015s)
[484.167331] Starting dynamic subtest: vecs1
[493.126892] Dynamic subtest vecs1: SUCCESS (8.970s)
[493.137357] Starting dynamic subtest: ccs0
[502.139643] Dynamic subtest ccs0: SUCCESS (9.011s)
[502.140453] Subtest preemptive-hang: SUCCESS (63.175s)
[502.361989] [106/133] (528s left) kms_prime (basic-modeset-hybrid)
[503.880361] Subtest basic-modeset-hybrid: SKIP (0.000s)
[503.944416] [107/133] (527s left) gem_exec_whisper (basic-forked-all)
[504.042740] Starting subtest: basic-forked-all
[506.814200] Subtest basic-forked-all: SUCCESS (2.770s)
[507.039089] [108/133] (524s left) gem_basic (create-close)
[507.120836] Starting subtest: create-close
[507.122886] Subtest create-close: SUCCESS (0.000s)
[507.244945] [109/133] (524s left) api_intel_bb (misplaced-blitter)
[507.329731] Starting subtest: misplaced-blitter
[507.364093] Subtest misplaced-blitter: SUCCESS (0.034s)
[507.469452] [110/133] (523s left) gen9_exec_parse (bb-start-cmd)
[507.556569] Subtest bb-start-cmd: SKIP (0.000s)
[507.645452] [111/133] (523s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[509.167413] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[511.629561] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.463s)
[511.781967] [112/133] (519s left) gem_eio (in-flight-contexts-10ms)
[512.105450] Starting subtest: in-flight-contexts-10ms
[525.951599] Subtest in-flight-contexts-10ms: SUCCESS (13.846s)
[527.446116] [113/133] (504s left) i915_drm_fdinfo (isolation)
[527.518724] Starting subtest: isolation
[527.519622] Starting dynamic subtest: rcs0
[527.521308] Dynamic subtest rcs0: SKIP (0.001s)
[527.532664] Starting dynamic subtest: bcs0
[527.535396] Dynamic subtest bcs0: SKIP (0.001s)
[527.546666] Starting dynamic subtest: vcs0
[527.548900] Dynamic subtest vcs0: SKIP (0.000s)
[527.560081] Starting dynamic subtest: vcs1
[527.562113] Dynamic subtest vcs1: SKIP (0.000s)
[527.573659] Starting dynamic subtest: vecs0
[527.575936] Dynamic subtest vecs0: SKIP (0.000s)
[527.586854] Starting dynamic subtest: vecs1
[527.589109] Dynamic subtest vecs1: SKIP (0.001s)
[527.599957] Starting dynamic subtest: ccs0
[527.602446] Dynamic subtest ccs0: SKIP (0.014s)
[527.604615] Subtest isolation: SKIP (0.024s)
[527.653224] [114/133] (503s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[527.734567] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[527.735459] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[527.824661] [115/133] (503s left) kms_legacy_colorkey (invalid-plane)
[529.337073] Starting subtest: invalid-plane
[529.337916] Starting dynamic subtest: zero-id
[529.338874] Dynamic subtest zero-id: SUCCESS (0.000s)
[529.350638] Starting dynamic subtest: outrange-id
[529.351872] Dynamic subtest outrange-id: SUCCESS (0.000s)
[529.353102] Subtest invalid-plane: SUCCESS (0.002s)
[529.400408] [116/133] (502s left) kms_invalid_mode (clock-too-high)
[530.914826] Starting subtest: clock-too-high
[530.915600] Starting dynamic subtest: pipe-A-HDMI-A-3
[530.954321] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.039s)
[530.965870] Starting dynamic subtest: pipe-B-HDMI-A-3
[530.967792] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[530.978850] Starting dynamic subtest: pipe-C-HDMI-A-3
[530.980816] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[530.991871] Starting dynamic subtest: pipe-D-HDMI-A-3
[530.993569] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[530.994433] Subtest clock-too-high: SUCCESS (0.049s)
[531.091955] [117/133] (500s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[532.627483] Starting subtest: x-tiled-8bpp-rotate-0
[534.316317] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.688s)
[534.469424] [118/133] (497s left) kms_frontbuffer_tracking (psr-slowdraw)
[535.989175] Starting subtest: psr-slowdraw
[535.991104] Subtest psr-slowdraw: SKIP (0.000s)
[536.069180] [119/133] (495s left) gem_exec_balancer (hang)
[536.486551] Starting subtest: hang
[540.153458] Subtest hang: SUCCESS (3.668s)
[540.248825] [120/133] (491s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[541.766157] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[541.767939] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[541.852712] [121/133] (490s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[543.386158] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[543.387984] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[543.467165] [122/133] (488s left) gem_mmap_wc (bad-object)
[543.550172] Subtest bad-object: SKIP (0.000s)
[543.633804] [123/133] (488s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[545.163966] Starting subtest: yf-tiled-64bpp-rotate-180
[545.166160] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[545.251335] [124/133] (486s left) gem_busy (close-race)
[545.350301] Starting subtest: close-race
[567.406675] Subtest close-race: SUCCESS (22.056s)
[567.884383] [125/133] (464s left) drm_read (empty-nonblock)
[569.552451] Starting subtest: empty-nonblock
[569.553403] Subtest empty-nonblock: SUCCESS (0.000s)
[569.755376] [126/133] (462s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[571.274984] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[571.276631] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[571.351240] [127/133] (460s left) kms_cursor_edge_walk (256x256-left-edge)
[572.870123] Starting subtest: 256x256-left-edge
[572.870980] Starting dynamic subtest: pipe-A-HDMI-A-3
[576.216531] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.345s)
[576.230170] Starting dynamic subtest: pipe-D-HDMI-A-3
[579.446141] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.228s)
[579.447101] Subtest 256x256-left-edge: SUCCESS (6.577s)
[579.580484] [128/133] (452s left) gem_exec_schedule (fifo)
[579.680968] Starting subtest: fifo
[579.681996] Starting dynamic subtest: rcs0
[579.976772] Dynamic subtest rcs0: SUCCESS (0.295s)
[579.988580] Starting dynamic subtest: bcs0
[580.181439] Dynamic subtest bcs0: SUCCESS (0.204s)
[580.193370] Starting dynamic subtest: vcs0
[580.393176] Dynamic subtest vcs0: SUCCESS (0.210s)
[580.405057] Starting dynamic subtest: vcs1
[580.604948] Dynamic subtest vcs1: SUCCESS (0.211s)
[580.616604] Starting dynamic subtest: vecs0
[580.819380] Dynamic subtest vecs0: SUCCESS (0.213s)
[580.831281] Starting dynamic subtest: vecs1
[581.042527] Dynamic subtest vecs1: SUCCESS (0.222s)
[581.054623] Starting dynamic subtest: ccs0
[581.254980] Dynamic subtest ccs0: SUCCESS (0.211s)
[581.255823] Subtest fifo: SUCCESS (1.575s)
[581.600458] [129/133] (450s left) kms_fbcon_fbt (psr)
[581.689352] Starting subtest: psr
[581.691212] Subtest psr: SKIP (0.000s)
[581.745261] [130/133] (450s left) kms_chamelium_frames (hdmi-aspect-ratio)
[583.305835] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[583.412286] [131/133] (449s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[584.935176] Starting subtest: 2x-long-cursor-vs-flip-legacy
[584.938492] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[585.001153] [132/133] (447s left) kms_big_fb (linear-64bpp-rotate-270)
[586.536877] Starting subtest: linear-64bpp-rotate-270
[586.593707] Subtest linear-64bpp-rotate-270: SKIP (0.057s)
[586.755890] [133/133] (445s left) testdisplay
[594.548857] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_plane_lowres
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_suspend
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: i915_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: vgem_basic
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_hdr
results: parsing output: 16/ for test: i915_query
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_prop_blob
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: fbdev
results: parsing output: 23/ for test: gem_ctx_isolation
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: sriov_basic
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: prime_self_import
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: sw_sync
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: drm_mm
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_lmem_swapping
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_selftest
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_mmap_offset
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_pipe_crc_basic
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_eio
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_vrr
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: gem_ctx_shared
results: parsing output: 73/ for test: gem_create
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_draw_crc
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: gem_exec_flush
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: gem_sync
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: kms_color
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_async_flips
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: gem_lmem_swapping
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: i915_fb_tiling
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_prime
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: gem_basic
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: gen9_exec_parse
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_legacy_colorkey
results: parsing output: 115/ for test: kms_invalid_mode
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_mmap_wc
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_busy
results: parsing output: 124/ for test: drm_read
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_edge_walk
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: kms_fbcon_fbt
results: parsing output: 129/ for test: kms_chamelium_frames
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: testdisplay
Done.