[64.127929] Initializing watchdogs
[64.128017]   /dev/watchdog0
[64.158463] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[64.174059] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.178925] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.181854] [001/133] (960s left) kms_cursor_crc (cursor-onscreen-512x512)
[65.959906] Starting subtest: cursor-onscreen-512x512
[65.962716] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[66.220656] [002/133] (958s left) syncobj_timeline (device-signal-unordered)
[66.265592] Starting subtest: device-signal-unordered
[66.267367] Subtest device-signal-unordered: SUCCESS (0.001s)
[66.373648] [003/133] (958s left) kms_pm_rpm (basic-pci-d3-state)
[69.939331] Starting subtest: basic-pci-d3-state
[70.954093] Subtest basic-pci-d3-state: SUCCESS (1.015s)
[71.861807] [004/133] (953s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[73.431245] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[73.542646] [005/133] (951s left) kms_flip (2x-busy-flip)
[75.030096] Starting subtest: 2x-busy-flip
[75.049427] Subtest 2x-busy-flip: SKIP (0.019s)
[75.186404] [006/133] (949s left) kms_plane_lowres (tiling-x)
[76.675595] Starting subtest: tiling-x
[76.677800] Starting dynamic subtest: pipe-A-HDMI-A-3
[86.197192] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (9.514s)
[86.277487] Starting dynamic subtest: pipe-B-HDMI-A-3
[95.475965] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (9.203s)
[95.557481] Starting dynamic subtest: pipe-C-HDMI-A-3
[104.889107] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (9.337s)
[104.969710] Starting dynamic subtest: pipe-D-HDMI-A-3
[114.365713] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (9.402s)
[114.421619] Subtest tiling-x: SUCCESS (37.734s)
[114.602963] [007/133] (910s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[116.095965] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[116.097610] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[116.260041] [008/133] (908s left) i915_suspend (fence-restore-untiled)
[116.313116] Starting subtest: fence-restore-untiled
[116.315025] Subtest fence-restore-untiled: SKIP (0.000s)
[116.425565] [009/133] (908s left) gem_userptr_blits (nohangcheck)
[116.497880] Starting subtest: nohangcheck
[116.635895] Subtest nohangcheck: SUCCESS (0.136s)
[116.837924] [010/133] (908s left) api_intel_allocator (reloc-allocator)
[116.883926] Starting subtest: reloc-allocator
[116.885141] Starting dynamic subtest: basic
[116.899527] Dynamic subtest basic: SUCCESS (0.016s)
[116.910180] Starting dynamic subtest: parallel-one
[116.911424] Dynamic subtest parallel-one: SUCCESS (0.005s)
[116.919523] Starting dynamic subtest: print
[116.920523] Dynamic subtest print: SUCCESS (0.000s)
[116.928912] Starting dynamic subtest: reuse
[116.930014] Dynamic subtest reuse: SUCCESS (0.000s)
[116.938043] Starting dynamic subtest: fork-reopen-allocator
[116.939302] Dynamic subtest fork-reopen-allocator: SUCCESS (0.017s)
[116.940372] Subtest reloc-allocator: SUCCESS (0.045s)
[117.110940] [011/133] (908s left) i915_pm_rpm (gem-execbuf)
[121.022943] Starting subtest: gem-execbuf
[121.024064] Starting dynamic subtest: lmem0
[126.147454] Dynamic subtest lmem0: SUCCESS (5.123s)
[126.158819] Starting dynamic subtest: smem0
[129.276909] Dynamic subtest smem0: SUCCESS (3.125s)
[129.280945] Subtest gem-execbuf: SUCCESS (8.256s)
[130.342902] [012/133] (895s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[131.845860] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[134.658413] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.812s)
[134.887395] [013/133] (890s left) vgem_basic (sysfs)
[135.024339] Starting subtest: sysfs
[135.025185] Subtest sysfs: SUCCESS (0.000s)
[135.124693] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[135.127779] [014/133] (890s left) perf (sysctl-defaults)
[135.232528] Starting subtest: sysctl-defaults
[135.233404] Subtest sysctl-defaults: SUCCESS (0.000s)
[135.337361] [015/133] (890s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[135.391271] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[135.392176] Starting dynamic subtest: smem
[135.485217] Dynamic subtest smem: SUCCESS (0.093s)
[135.495196] Starting dynamic subtest: lmem0
[136.424873] Dynamic subtest lmem0: SUCCESS (0.934s)
[136.426250] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (1.030s)
[136.695104] [016/133] (889s left) kms_hdr (bpc-switch-dpms)
[138.181296] Starting subtest: bpc-switch-dpms
[138.183838] Subtest bpc-switch-dpms: SKIP (0.001s)
[138.299842] [017/133] (887s left) i915_query (query-topology-matches-eu-total)
[138.355276] Starting subtest: query-topology-matches-eu-total
[138.356250] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[138.477956] [018/133] (887s left) perf (blocking-parameterized)
[138.604535] Starting subtest: blocking-parameterized
[158.650443] Subtest blocking-parameterized: SUCCESS (20.042s)
[158.720342] [019/133] (867s left) kms_prop_blob (blob-prop-lifetime)
[158.765889] Starting subtest: blob-prop-lifetime
[158.766751] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[158.886963] [020/133] (867s left) perf_pmu (rc6)
[158.936482] Starting subtest: rc6
[158.937355] Starting dynamic subtest: gt0
[165.281481] Dynamic subtest gt0: SUCCESS (6.340s)
[165.291120] Starting dynamic subtest: runtime-pm-gt0
[172.905985] Dynamic subtest runtime-pm-gt0: SUCCESS (7.620s)
[172.915630] Starting dynamic subtest: runtime-pm-long-gt0
[185.469128] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.563s)
[185.479496] Starting dynamic subtest: other-idle-gt0
[185.481429] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[185.482367] Subtest rc6: SUCCESS (26.532s)
[186.164526] [021/133] (840s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[187.651997] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[187.729020] [022/133] (838s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[189.218612] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[189.220273] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[189.322862] [023/133] (837s left) fbdev (unaligned-read)
[189.388975] Starting subtest: unaligned-read
[189.402963] Subtest unaligned-read: SUCCESS (0.016s)
[189.471431] [024/133] (836s left) gem_ctx_isolation (nonpriv)
[189.528647] Starting subtest: nonpriv
[189.529655] Starting dynamic subtest: rcs0
[190.489611] Dynamic subtest rcs0: SUCCESS (0.960s)
[190.501278] Starting dynamic subtest: bcs0
[191.505991] Dynamic subtest bcs0: SUCCESS (1.015s)
[191.517115] Starting dynamic subtest: vcs0
[192.534094] Dynamic subtest vcs0: SUCCESS (1.026s)
[192.546286] Starting dynamic subtest: vcs1
[193.561819] Dynamic subtest vcs1: SUCCESS (1.026s)
[193.573817] Starting dynamic subtest: vecs0
[194.638292] Dynamic subtest vecs0: SUCCESS (1.075s)
[194.639200] Subtest nonpriv: SUCCESS (5.111s)
[194.882529] [025/133] (831s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[196.386929] Starting subtest: yf-tiled-32bpp-rotate-180
[196.389030] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[196.489653] [026/133] (830s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[196.543259] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[196.613940] [027/133] (830s left) kms_psr (fbc-psr-suspend)
[198.099254] Subtest fbc-psr-suspend: SKIP (0.000s)
[198.179166] [028/133] (828s left) prime_self_import (basic-with_one_bo_two_files)
[198.221447] Starting subtest: basic-with_one_bo_two_files
[198.225090] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[198.316203] [029/133] (828s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[199.806119] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[199.807943] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[199.903079] [030/133] (826s left) gem_exec_params (invalid-flag)
[199.957317] Starting subtest: invalid-flag
[199.958223] Subtest invalid-flag: SUCCESS (0.000s)
[200.051496] [031/133] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[201.542803] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[201.544479] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[201.635029] [032/133] (825s left) sw_sync (sync_merge)
[201.680437] Starting subtest: sync_merge
[201.681274] Subtest sync_merge: SUCCESS (0.000s)
[201.746657] [033/133] (825s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[201.792361] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[201.793204] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[201.865920] [034/133] (825s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[203.351395] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[203.578212] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.223s)
[203.732818] [035/133] (823s left) drm_mm (drm_mm)
[203.776716] Starting subtest: drm_mm
[203.849554] Starting dynamic subtest: drm_test_mm_init
[203.870303] Dynamic subtest drm_test_mm_init: SUCCESS (0.069s)
[203.896289] Starting dynamic subtest: drm_test_mm_debug
[203.953107] Dynamic subtest drm_test_mm_debug: SUCCESS (0.078s)
[203.993620] Starting dynamic subtest: drm_test_mm_align32
[204.031498] Dynamic subtest drm_test_mm_align32: SUCCESS (0.071s)
[204.051900] Starting dynamic subtest: drm_test_mm_align64
[204.116546] Dynamic subtest drm_test_mm_align64: SUCCESS (0.078s)
[204.154830] Starting dynamic subtest: drm_test_mm_lowest
[204.186083] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.065s)
[204.200165] Starting dynamic subtest: drm_test_mm_highest
[204.267957] Dynamic subtest drm_test_mm_highest: SUCCESS (0.078s)
[204.275739] Subtest drm_mm: SUCCESS (0.493s)
[204.451752] [036/133] (822s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[205.938359] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[205.956963] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.019s)
[206.049448] [037/133] (821s left) gem_lmem_swapping (random-engines)
[210.181247] Starting subtest: random-engines
[210.182619] Starting dynamic subtest: lmem0
[211.414888] Dynamic subtest lmem0: SUCCESS (1.230s)
[211.415981] Subtest random-engines: SUCCESS (1.232s)
[213.276102] [FACT gem_lmem_swapping (random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[213.277468] [FACT gem_lmem_swapping (random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[213.279924] [038/133] (814s left) kms_content_protection (srm)
[217.996993] Starting subtest: srm
[218.003179] Subtest srm: SKIP (0.003s)
[218.131881] [FACT kms_content_protection (srm)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[218.135217] [FACT kms_content_protection (srm)] new: kernel.kmod_is_loaded.i915: true
[218.138978] [039/133] (809s left) kms_psr (fbc-psr2-no-drrs)
[219.625482] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[219.692704] [040/133] (807s left) syncobj_wait (multi-wait-for-submit-signaled)
[219.738723] Starting subtest: multi-wait-for-submit-signaled
[219.739557] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[219.813414] [041/133] (807s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[221.298433] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[221.300219] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[221.380577] [042/133] (806s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[222.873173] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[225.484748] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.612s)
[225.620033] [043/133] (802s left) kms_addfb_basic (legacy-format)
[225.665973] Starting subtest: legacy-format
[225.709448] Subtest legacy-format: SUCCESS (0.044s)
[227.233345] [044/133] (800s left) gem_mmap_wc (read)
[227.281424] Subtest read: SKIP (0.000s)
[227.393262] [045/133] (800s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[228.878217] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[228.880333] Starting dynamic subtest: pipe-A-valid-mode
[229.759501] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.879s)
[229.760522] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.882s)
[229.908456] [046/133] (798s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[231.419279] Starting subtest: 4-tiled-16bpp-rotate-90
[231.420908] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[231.530439] [047/133] (796s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[233.024500] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[233.026468] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[233.176790] [048/133] (794s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[234.663302] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[234.664241] Starting dynamic subtest: pipe-A-HDMI-A-3
[234.667595] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[234.677044] Starting dynamic subtest: pipe-B-HDMI-A-3
[234.680570] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[234.690041] Starting dynamic subtest: pipe-C-HDMI-A-3
[234.693808] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[234.703312] Starting dynamic subtest: pipe-D-HDMI-A-3
[234.706843] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[234.708531] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[234.888751] [049/133] (793s left) gem_ctx_persistence (hang)
[234.944329] Starting subtest: hang
[234.946339] Subtest hang: SKIP (0.000s)
[235.019604] [050/133] (793s left) kms_cursor_crc (cursor-random-128x42)
[236.708351] Starting subtest: cursor-random-128x42
[236.715524] Starting dynamic subtest: pipe-A-HDMI-A-3
[241.311798] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.597s)
[241.346417] Starting dynamic subtest: pipe-D-HDMI-A-3
[245.812109] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.474s)
[245.813160] Subtest cursor-random-128x42: SUCCESS (9.104s)
[246.126419] [051/133] (782s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[246.173052] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[246.174129] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[246.256605] [052/133] (782s left) kms_psr (psr-suspend)
[247.742505] Subtest psr-suspend: SKIP (0.000s)
[247.844481] [053/133] (780s left) kms_selftest (drm_damage_helper)
[247.895398] Starting subtest: drm_damage_helper
[247.935391] Starting dynamic subtest: drm_test_damage_iter_no_damage
[247.996194] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.061s)
[248.012320] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[248.075000] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.071s)
[248.117651] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[248.150548] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.073s)
[248.167072] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[248.226738] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.073s)
[248.262415] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[248.300020] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.067s)
[248.315962] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[248.372955] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.069s)
[248.384735] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[248.455625] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.077s)
[248.497888] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[248.543836] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.081s)
[248.577743] Starting dynamic subtest: drm_test_damage_iter_single_damage
[248.620867] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.073s)
[248.653985] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[248.702059] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.076s)
[248.736836] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[248.787765] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.079s)
[248.827841] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[248.873346] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.079s)
[248.900625] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[248.941114] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.064s)
[248.980580] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[249.023999] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.077s)
[249.035443] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[249.088685] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.061s)
[249.119657] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[249.175761] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.083s)
[249.215116] Starting dynamic subtest: drm_test_damage_iter_damage
[249.263751] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.081s)
[249.291468] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[249.334298] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.065s)
[249.369841] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[249.418414] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.080s)
[249.427986] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[249.496611] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.076s)
[249.526346] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[249.573736] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.073s)
[249.581273] Subtest drm_damage_helper: SUCCESS (1.680s)
[249.756604] [054/133] (778s left) gem_exec_balancer (parallel-ordering)
[250.129855] Starting subtest: parallel-ordering
[252.270905] Subtest parallel-ordering: SUCCESS (2.141s)
[252.372687] [055/133] (776s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[253.863254] Starting subtest: fbcpsr-rgb565-draw-pwrite
[253.865134] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[253.959088] [056/133] (774s left) gem_mmap_offset (oob-read)
[254.010093] Starting subtest: oob-read
[254.011360] Subtest oob-read: SUCCESS (0.000s)
[254.120555] [057/133] (774s left) perf_pmu (busy-idle)
[254.170417] Starting subtest: busy-idle
[254.171372] Starting dynamic subtest: rcs0
[254.854052] Dynamic subtest rcs0: SUCCESS (0.683s)
[254.868172] Starting dynamic subtest: bcs0
[255.528522] Dynamic subtest bcs0: SUCCESS (0.671s)
[255.549184] Starting dynamic subtest: vcs0
[256.201895] Dynamic subtest vcs0: SUCCESS (0.666s)
[256.223058] Starting dynamic subtest: vcs1
[256.873425] Dynamic subtest vcs1: SUCCESS (0.664s)
[256.893996] Starting dynamic subtest: vecs0
[257.541817] Dynamic subtest vecs0: SUCCESS (0.661s)
[257.550145] Subtest busy-idle: SUCCESS (3.374s)
[257.660651] [058/133] (771s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[259.152234] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[259.154037] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[259.241219] [059/133] (769s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[260.727295] Starting subtest: read-crc-frame-sequence
[260.728224] Starting dynamic subtest: pipe-A-HDMI-A-3
[261.416026] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.688s)
[261.427476] Starting dynamic subtest: pipe-B-HDMI-A-3
[261.964182] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.545s)
[261.975574] Starting dynamic subtest: pipe-C-HDMI-A-3
[262.531376] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.565s)
[262.542875] Starting dynamic subtest: pipe-D-HDMI-A-3
[263.088432] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.553s)
[263.089222] Subtest read-crc-frame-sequence: SUCCESS (2.362s)
[263.227487] [060/133] (765s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[264.714390] Starting subtest: cursorA-vs-flipA-atomic
[275.618050] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.904s)
[275.770479] [061/133] (753s left) kms_chamelium_color (ctm-limited-range)
[277.257097] Subtest ctm-limited-range: SKIP (0.000s)
[277.330891] [062/133] (751s left) kms_flip (2x-modeset-vs-vblank-race)
[278.816979] Starting subtest: 2x-modeset-vs-vblank-race
[278.835975] Subtest 2x-modeset-vs-vblank-race: SKIP (0.019s)
[278.918775] [063/133] (750s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[280.419474] Starting subtest: bad-aux-stride-y-tiled-ccs
[280.424408] Starting dynamic subtest: pipe-A-HDMI-A-3
[280.432199] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[280.441927] Starting dynamic subtest: pipe-B-HDMI-A-3
[280.449787] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[280.459342] Starting dynamic subtest: pipe-C-HDMI-A-3
[280.467253] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[280.476733] Starting dynamic subtest: pipe-D-HDMI-A-3
[280.484810] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[280.486353] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.010s)
[280.649054] [064/133] (748s left) gem_eio (in-flight-external)
[280.820179] Starting subtest: in-flight-external
[281.892614] Subtest in-flight-external: SUCCESS (1.072s)
[283.412970] [065/133] (745s left) kms_rotation_crc (sprite-rotation-180)
[284.900384] Starting subtest: sprite-rotation-180
[295.328950] Subtest sprite-rotation-180: SUCCESS (10.429s)
[295.529621] [066/133] (733s left) syncobj_timeline (wait-delayed-signal)
[295.587580] Starting subtest: wait-delayed-signal
[295.692434] Subtest wait-delayed-signal: SUCCESS (0.104s)
[295.839453] [067/133] (733s left) kms_flip (2x-flip-vs-dpms-on-nop)
[297.324818] Starting subtest: 2x-flip-vs-dpms-on-nop
[297.343386] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.019s)
[297.427944] [068/133] (732s left) kms_vrr (flip-dpms)
[298.913460] Starting subtest: flip-dpms
[298.916230] Subtest flip-dpms: SKIP (0.000s)
[298.994405] [069/133] (730s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[300.485901] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[300.487668] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[300.580047] [070/133] (729s left) gem_exec_schedule (preempt-self)
[300.644544] Starting subtest: preempt-self
[300.645454] Starting dynamic subtest: rcs0
[300.686448] Dynamic subtest rcs0: SUCCESS (0.041s)
[300.698834] Starting dynamic subtest: bcs0
[300.712803] Dynamic subtest bcs0: SUCCESS (0.025s)
[300.725161] Starting dynamic subtest: vcs0
[300.739176] Dynamic subtest vcs0: SUCCESS (0.025s)
[300.752148] Starting dynamic subtest: vcs1
[300.765017] Dynamic subtest vcs1: SUCCESS (0.024s)
[300.777242] Starting dynamic subtest: vecs0
[300.790691] Dynamic subtest vecs0: SUCCESS (0.024s)
[300.791588] Subtest preempt-self: SUCCESS (0.147s)
[301.219647] [071/133] (728s left) kms_cursor_legacy (forked-move)
[302.703481] Starting subtest: forked-move
[302.704492] Starting dynamic subtest: pipe-A
[308.126167] Dynamic subtest pipe-A: SUCCESS (5.416s)
[308.140517] Starting dynamic subtest: pipe-B
[313.561120] Dynamic subtest pipe-B: SUCCESS (5.433s)
[313.584049] Starting dynamic subtest: pipe-C
[319.019282] Dynamic subtest pipe-C: SUCCESS (5.455s)
[319.045563] Starting dynamic subtest: pipe-D
[324.456814] Dynamic subtest pipe-D: SUCCESS (5.434s)
[324.467518] Starting dynamic subtest: all-pipes
[329.876537] Dynamic subtest all-pipes: SUCCESS (5.419s)
[329.877417] Subtest forked-move: SUCCESS (27.170s)
[329.945590] [072/133] (699s left) prime_vgem (basic-fence-mmap)
[330.004608] Starting subtest: basic-fence-mmap
[330.006458] Subtest basic-fence-mmap: SKIP (0.000s)
[330.134378] [073/133] (699s left) gem_ctx_shared (detached-shared-gtt)
[330.191566] Starting subtest: detached-shared-gtt
[332.346823] Subtest detached-shared-gtt: SUCCESS (2.151s)
[333.278664] [074/133] (696s left) gem_create (create-ext-placement-each)
[333.441978] Starting subtest: create-ext-placement-each
[333.443195] Subtest create-ext-placement-each: SUCCESS (0.000s)
[333.582070] [075/133] (696s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[335.074215] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[335.076152] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[335.282713] [076/133] (695s left) kms_draw_crc (draw-method-mmap-gtt)
[336.769288] Starting subtest: draw-method-mmap-gtt
[336.771033] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[336.862618] [077/133] (693s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[338.350398] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[338.351374] Starting dynamic subtest: pipe-A
[338.461978] Dynamic subtest pipe-A: SUCCESS (0.112s)
[338.479552] Starting dynamic subtest: pipe-B
[338.621811] Dynamic subtest pipe-B: SUCCESS (0.158s)
[338.634979] Starting dynamic subtest: pipe-C
[338.762146] Dynamic subtest pipe-C: SUCCESS (0.139s)
[338.774526] Starting dynamic subtest: pipe-D
[338.902613] Dynamic subtest pipe-D: SUCCESS (0.139s)
[338.903465] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.554s)
[339.061536] [078/133] (691s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[340.565428] Starting subtest: y-tiled-16bpp-rotate-270
[342.381370] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.811s)
[342.512862] [079/133] (688s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[342.565840] Starting subtest: x-tiled-to-vebox-y-tiled
[342.566748] Starting dynamic subtest: smem
[342.648713] Dynamic subtest smem: SUCCESS (0.082s)
[342.661100] Starting dynamic subtest: lmem0
[343.403047] Dynamic subtest lmem0: SUCCESS (0.748s)
[343.404214] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.834s)
[343.646981] [080/133] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[345.136840] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[345.138477] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[345.256806] [081/133] (685s left) kms_plane (plane-position-hole)
[346.755263] Starting subtest: plane-position-hole
[347.215417] Starting dynamic subtest: pipe-A-plane-1
[347.613150] Dynamic subtest pipe-A-plane-1: SUCCESS (0.397s)
[347.625727] Starting dynamic subtest: pipe-A-plane-2
[347.979395] Dynamic subtest pipe-A-plane-2: SUCCESS (0.364s)
[347.990440] Starting dynamic subtest: pipe-A-plane-3
[348.346497] Dynamic subtest pipe-A-plane-3: SUCCESS (0.365s)
[348.357572] Starting dynamic subtest: pipe-A-plane-4
[348.710890] Dynamic subtest pipe-A-plane-4: SUCCESS (0.363s)
[348.723400] Starting dynamic subtest: pipe-A-plane-5
[349.074852] Dynamic subtest pipe-A-plane-5: SUCCESS (0.363s)
[349.087540] Starting dynamic subtest: pipe-A-plane-6
[349.473032] Dynamic subtest pipe-A-plane-6: SUCCESS (0.396s)
[349.484278] Starting dynamic subtest: pipe-A-plane-7
[349.496186] Dynamic subtest pipe-A-plane-7: SUCCESS (0.021s)
[349.788911] Starting dynamic subtest: pipe-B-plane-1
[350.159065] Dynamic subtest pipe-B-plane-1: SUCCESS (0.380s)
[350.170327] Starting dynamic subtest: pipe-B-plane-2
[350.552846] Dynamic subtest pipe-B-plane-2: SUCCESS (0.393s)
[350.563873] Starting dynamic subtest: pipe-B-plane-3
[350.944806] Dynamic subtest pipe-B-plane-3: SUCCESS (0.390s)
[350.955842] Starting dynamic subtest: pipe-B-plane-4
[351.308595] Dynamic subtest pipe-B-plane-4: SUCCESS (0.363s)
[351.322645] Starting dynamic subtest: pipe-B-plane-5
[351.673846] Dynamic subtest pipe-B-plane-5: SUCCESS (0.363s)
[351.687954] Starting dynamic subtest: pipe-B-plane-6
[352.038549] Dynamic subtest pipe-B-plane-6: SUCCESS (0.363s)
[352.052696] Starting dynamic subtest: pipe-B-plane-7
[352.068505] Dynamic subtest pipe-B-plane-7: SUCCESS (0.027s)
[352.069414] Subtest plane-position-hole: SUCCESS (5.313s)
[352.220843] [082/133] (678s left) gem_exec_flush (basic-uc-ro-default)
[352.273321] Subtest basic-uc-ro-default: SKIP (0.000s)
[352.364741] [083/133] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[353.854189] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[353.855948] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[353.956271] [084/133] (676s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[354.005908] Starting subtest: single-wait-all-for-submit-available-signaled
[354.006995] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[354.087436] [085/133] (676s left) gem_exec_fence (submit3)
[354.303182] Starting subtest: submit3
[354.305553] Subtest submit3: SKIP (0.000s)
[354.947978] [086/133] (676s left) kms_busy (basic)
[356.439357] Starting subtest: basic
[356.440277] Starting dynamic subtest: flip
[357.191983] Dynamic subtest flip: SUCCESS (0.751s)
[357.204711] Starting dynamic subtest: modeset
[357.800421] Dynamic subtest modeset: SUCCESS (0.602s)
[357.801253] Subtest basic: SUCCESS (1.358s)
[357.973209] [087/133] (673s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[359.460344] Starting subtest: crc-primary-basic-y-tiled-ccs
[359.461297] Starting dynamic subtest: pipe-A-HDMI-A-3
[359.470114] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[359.481321] Starting dynamic subtest: pipe-B-HDMI-A-3
[359.490092] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[359.501352] Starting dynamic subtest: pipe-C-HDMI-A-3
[359.510989] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[359.521756] Starting dynamic subtest: pipe-D-HDMI-A-3
[359.530975] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[359.532942] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.014s)
[359.705699] [088/133] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[361.197138] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[361.198949] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[361.321027] [089/133] (669s left) gem_softpin (evict-single-offset)
[361.383727] Starting subtest: evict-single-offset
[389.978809] Subtest evict-single-offset: SUCCESS (28.591s)
[390.058016] [090/133] (641s left) gem_sync (basic-each)
[390.150583] Starting subtest: basic-each
[392.511320] Subtest basic-each: SUCCESS (2.360s)
[392.759817] [091/133] (638s left) gem_ctx_param (invalid-param-set)
[392.806363] Starting subtest: invalid-param-set
[392.807331] Subtest invalid-param-set: SUCCESS (0.000s)
[392.886829] [092/133] (638s left) kms_color (ctm-0-25)
[394.381372] Starting subtest: ctm-0-25
[394.382248] Starting dynamic subtest: pipe-A-HDMI-A-3
[396.012374] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.630s)
[396.024340] Starting dynamic subtest: pipe-B-HDMI-A-3
[397.421101] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.407s)
[397.433165] Starting dynamic subtest: pipe-C-HDMI-A-3
[398.825940] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.404s)
[398.837724] Starting dynamic subtest: pipe-D-HDMI-A-3
[400.240923] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.412s)
[400.241899] Subtest ctm-0-25: SUCCESS (5.860s)
[400.389482] [093/133] (631s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[401.879195] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[401.949460] [094/133] (629s left) syncobj_timeline (invalid-transfer-illegal-handle)
[402.002496] Starting subtest: invalid-transfer-illegal-handle
[402.003332] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[402.123951] [095/133] (629s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[402.175208] Starting subtest: invalid-bsd1-flag-on-blt
[402.176197] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[402.268418] [096/133] (629s left) kms_async_flips (test-cursor-atomic)
[403.754702] Starting subtest: test-cursor-atomic
[404.028090] Starting dynamic subtest: pipe-A-HDMI-A-3
[404.403081] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.375s)
[404.618160] Starting dynamic subtest: pipe-B-HDMI-A-3
[404.674214] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.067s)
[404.868521] Starting dynamic subtest: pipe-C-HDMI-A-3
[404.928459] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.071s)
[405.132701] Starting dynamic subtest: pipe-D-HDMI-A-3
[405.192682] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.071s)
[405.193631] Subtest test-cursor-atomic: SUCCESS (1.440s)
[405.487020] [097/133] (626s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[406.983514] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[406.985141] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[407.091173] [098/133] (624s left) gem_eio (in-flight-internal-1us)
[407.297751] Starting subtest: in-flight-internal-1us
[408.867253] Subtest in-flight-internal-1us: SUCCESS (1.571s)
[410.389437] [099/133] (621s left) gem_lmem_swapping (heavy-multi)
[414.583878] Starting subtest: heavy-multi
[414.584883] Starting dynamic subtest: lmem0
[420.393947] Dynamic subtest lmem0: SUCCESS (5.806s)
[420.394915] Subtest heavy-multi: SUCCESS (5.808s)
[421.550535] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[421.551589] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[421.554128] [100/133] (610s left) kms_psr (psr2-cursor-plane-onoff)
[426.214562] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[427.019912] [FACT kms_psr (psr2-cursor-plane-onoff)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[427.023354] [FACT kms_psr (psr2-cursor-plane-onoff)] new: kernel.kmod_is_loaded.i915: true
[427.026766] [101/133] (605s left) kms_frontbuffer_tracking (fbc-stridechange)
[428.519247] Starting subtest: fbc-stridechange
[430.633797] Subtest fbc-stridechange: SUCCESS (2.115s)
[430.795653] [102/133] (601s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[432.283677] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[432.359906] [103/133] (599s left) i915_fb_tiling (basic-x-tiling)
[432.404482] Subtest basic-x-tiling: SKIP (0.000s)
[432.477017] [104/133] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[433.968246] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[433.970043] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[434.068319] [105/133] (598s left) gem_exec_schedule (preemptive-hang)
[434.273141] Starting subtest: preemptive-hang
[434.275133] Starting dynamic subtest: rcs0
[444.090379] Dynamic subtest rcs0: SUCCESS (9.818s)
[444.100931] Starting dynamic subtest: bcs0
[453.046595] Dynamic subtest bcs0: SUCCESS (8.954s)
[453.057242] Starting dynamic subtest: vcs0
[462.078113] Dynamic subtest vcs0: SUCCESS (9.030s)
[462.089983] Starting dynamic subtest: vcs1
[471.101711] Dynamic subtest vcs1: SUCCESS (9.021s)
[471.112363] Starting dynamic subtest: vecs0
[480.053545] Dynamic subtest vecs0: SUCCESS (8.950s)
[480.054411] Subtest preemptive-hang: SUCCESS (45.785s)
[480.325245] [106/133] (552s left) kms_prime (basic-modeset-hybrid)
[481.832236] Subtest basic-modeset-hybrid: SKIP (0.000s)
[481.899474] [107/133] (550s left) gem_exec_whisper (basic-forked-all)
[481.959500] Starting subtest: basic-forked-all
[484.355976] Subtest basic-forked-all: SUCCESS (2.397s)
[484.619683] [108/133] (548s left) gem_basic (create-close)
[484.664841] Starting subtest: create-close
[484.666504] Subtest create-close: SUCCESS (0.000s)
[484.780986] [109/133] (547s left) api_intel_bb (misplaced-blitter)
[484.826392] Starting subtest: misplaced-blitter
[484.848151] Subtest misplaced-blitter: SUCCESS (0.022s)
[484.969740] [110/133] (547s left) gen9_exec_parse (bb-start-cmd)
[485.020253] Subtest bb-start-cmd: SKIP (0.000s)
[485.094564] [111/133] (547s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[486.582926] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[489.102110] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.518s)
[489.270928] [112/133] (543s left) gem_eio (in-flight-contexts-10ms)
[489.473574] Starting subtest: in-flight-contexts-10ms
[502.908699] Subtest in-flight-contexts-10ms: SUCCESS (13.435s)
[504.435042] [113/133] (528s left) i915_drm_fdinfo (isolation)
[504.484978] Starting subtest: isolation
[504.486140] Starting dynamic subtest: rcs0
[504.488302] Dynamic subtest rcs0: SKIP (0.001s)
[504.500152] Starting dynamic subtest: bcs0
[504.502241] Dynamic subtest bcs0: SKIP (0.001s)
[504.514049] Starting dynamic subtest: vcs0
[504.522392] Dynamic subtest vcs0: SKIP (0.010s)
[504.534049] Starting dynamic subtest: vcs1
[504.536548] Dynamic subtest vcs1: SKIP (0.000s)
[504.547730] Starting dynamic subtest: vecs0
[504.550167] Dynamic subtest vecs0: SKIP (0.000s)
[504.552591] Subtest isolation: SKIP (0.020s)
[504.617285] [114/133] (528s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[504.662996] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[504.664122] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[504.750914] [115/133] (528s left) kms_legacy_colorkey (invalid-plane)
[506.237604] Starting subtest: invalid-plane
[506.238586] Starting dynamic subtest: zero-id
[506.239562] Dynamic subtest zero-id: SUCCESS (0.000s)
[506.251147] Starting dynamic subtest: outrange-id
[506.252208] Dynamic subtest outrange-id: SUCCESS (0.000s)
[506.253213] Subtest invalid-plane: SUCCESS (0.003s)
[506.317874] [116/133] (526s left) kms_invalid_mode (clock-too-high)
[507.803491] Starting subtest: clock-too-high
[507.806090] Starting dynamic subtest: pipe-A-HDMI-A-3
[507.848452] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.043s)
[507.861694] Starting dynamic subtest: pipe-B-HDMI-A-3
[507.862477] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.009s)
[507.875652] Starting dynamic subtest: pipe-C-HDMI-A-3
[507.877391] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.010s)
[507.888725] Starting dynamic subtest: pipe-D-HDMI-A-3
[507.889511] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.012s)
[507.890357] Subtest clock-too-high: SUCCESS (0.084s)
[508.026669] [117/133] (525s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[509.536215] Starting subtest: x-tiled-8bpp-rotate-0
[511.277240] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.739s)
[511.437316] [118/133] (521s left) kms_frontbuffer_tracking (psr-slowdraw)
[512.927934] Starting subtest: psr-slowdraw
[512.929653] Subtest psr-slowdraw: SKIP (0.000s)
[513.026216] [119/133] (520s left) gem_exec_balancer (hang)
[513.451928] Starting subtest: hang
[516.375569] Subtest hang: SUCCESS (2.929s)
[516.495250] [120/133] (517s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[517.986578] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[517.988704] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[518.109793] [121/133] (515s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[519.613530] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[519.615464] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[519.746182] [122/133] (513s left) gem_mmap_wc (bad-object)
[519.807483] Subtest bad-object: SKIP (0.000s)
[519.887499] [123/133] (513s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[521.391681] Starting subtest: yf-tiled-64bpp-rotate-180
[521.393467] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[521.501799] [124/133] (512s left) gem_busy (close-race)
[521.566888] Starting subtest: close-race
[543.521529] Subtest close-race: SUCCESS (21.957s)
[544.107270] [125/133] (489s left) drm_read (empty-nonblock)
[545.743825] Starting subtest: empty-nonblock
[545.744792] Subtest empty-nonblock: SUCCESS (0.000s)
[545.967998] [126/133] (488s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[547.459247] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[547.461085] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[547.565473] [127/133] (486s left) kms_cursor_edge_walk (256x256-left-edge)
[549.060347] Starting subtest: 256x256-left-edge
[549.061809] Starting dynamic subtest: pipe-A-HDMI-A-3
[552.390656] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.329s)
[552.404451] Starting dynamic subtest: pipe-D-HDMI-A-3
[555.608151] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.214s)
[555.609121] Subtest 256x256-left-edge: SUCCESS (6.549s)
[555.784666] [128/133] (478s left) gem_exec_schedule (fifo)
[555.852591] Starting subtest: fifo
[555.853468] Starting dynamic subtest: rcs0
[556.040693] Dynamic subtest rcs0: SUCCESS (0.183s)
[556.052509] Starting dynamic subtest: bcs0
[556.167925] Dynamic subtest bcs0: SUCCESS (0.130s)
[556.181324] Starting dynamic subtest: vcs0
[556.300934] Dynamic subtest vcs0: SUCCESS (0.131s)
[556.313989] Starting dynamic subtest: vcs1
[556.436370] Dynamic subtest vcs1: SUCCESS (0.134s)
[556.449859] Starting dynamic subtest: vecs0
[556.584664] Dynamic subtest vecs0: SUCCESS (0.147s)
[556.585552] Subtest fifo: SUCCESS (0.733s)
[557.011806] [129/133] (477s left) kms_fbcon_fbt (psr)
[557.059044] Starting subtest: psr
[557.060837] Subtest psr: SKIP (0.000s)
[557.139281] [130/133] (477s left) kms_chamelium_frames (hdmi-aspect-ratio)
[558.665071] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[558.780197] [131/133] (475s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[560.266386] Starting subtest: 2x-long-cursor-vs-flip-legacy
[560.270146] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.003s)
[560.347286] [132/133] (474s left) kms_big_fb (linear-64bpp-rotate-270)
[561.857641] Starting subtest: linear-64bpp-rotate-270
[561.922745] Subtest linear-64bpp-rotate-270: SKIP (0.065s)
[562.049179] [133/133] (472s left) testdisplay
[568.303365] 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.