[64.264471] Initializing watchdogs
[64.264518]   /dev/watchdog0
[64.279728] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[64.284638] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.286980] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.289178] [001/133] (960s left) gem_exec_balancer (bonded-pair)
[64.355414] Starting subtest: bonded-pair
[64.357266] Subtest bonded-pair: SKIP (0.000s)
[64.670010] [002/133] (960s left) sysfs_heartbeat_interval (nopreempt)
[64.735977] Starting subtest: nopreempt
[64.736977] Starting dynamic subtest: vecs0
[73.886202] Dynamic subtest vecs0: SUCCESS (9.140s)
[73.894757] Starting dynamic subtest: ccs0
[77.767747] Dynamic subtest ccs0: SUCCESS (3.890s)
[77.775427] Starting dynamic subtest: vcs0
[86.934484] Dynamic subtest vcs0: SUCCESS (9.155s)
[86.942806] Starting dynamic subtest: bcs0
[90.793593] Dynamic subtest bcs0: SUCCESS (3.868s)
[90.801062] Starting dynamic subtest: rcs0
[94.707514] Dynamic subtest rcs0: SUCCESS (3.913s)
[94.716566] Starting dynamic subtest: vcs1
[103.904239] Dynamic subtest vcs1: SUCCESS (9.186s)
[103.905362] Subtest nopreempt: SUCCESS (39.158s)
[103.976876] [003/133] (920s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[104.079519] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[105.170531] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.091s)
[105.276526] [004/133] (919s left) gem_exec_fence (keep-in-fence)
[105.451068] Starting subtest: keep-in-fence
[105.452012] Starting dynamic subtest: rcs0
[105.502496] Dynamic subtest rcs0: SUCCESS (0.056s)
[105.512670] Starting dynamic subtest: bcs0
[105.555875] Dynamic subtest bcs0: SUCCESS (0.053s)
[105.564072] Starting dynamic subtest: vcs0
[106.911840] Dynamic subtest vcs0: SUCCESS (1.345s)
[106.918691] Starting dynamic subtest: vcs1
[108.893754] Dynamic subtest vcs1: SUCCESS (1.981s)
[108.901837] Starting dynamic subtest: vecs0
[110.942253] Dynamic subtest vecs0: SUCCESS (2.047s)
[110.949696] Starting dynamic subtest: ccs0
[111.159323] Dynamic subtest ccs0: SUCCESS (0.225s)
[111.160789] Subtest keep-in-fence: SUCCESS (5.713s)
[112.986874] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[112.988489] [005/133] (911s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[113.102787] Starting subtest: cursor-tearing-framebuffer-change
[113.103700] Starting dynamic subtest: pipe-A-eDP-1
[113.671181] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[113.677886] Starting dynamic subtest: pipe-D-eDP-1
[114.861848] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.191s)
[114.862817] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.758s)
[115.712636] [006/133] (909s left) gem_create (create-clear)
[115.778067] Starting subtest: create-clear
[115.779153] Starting dynamic subtest: smem0
[148.607088] Dynamic subtest smem0: SUCCESS (32.827s)
[148.608046] Subtest create-clear: SUCCESS (32.827s)
[148.788180] [007/133] (876s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[148.908181] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[148.909898] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[149.060277] [008/133] (875s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[149.168471] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[156.196913] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (7.029s)
[156.330982] [009/133] (868s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[156.427858] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[156.430047] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[156.509390] [010/133] (868s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[156.567070] Starting subtest: single-wait-all-for-submit-available-submitted
[156.568198] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[156.649205] [011/133] (868s left) kms_psr (pr-suspend)
[156.731911] Starting subtest: pr-suspend
[156.733920] Subtest pr-suspend: SKIP (0.000s)
[156.815749] [012/133] (868s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[156.908770] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[156.910684] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[156.975125] [013/133] (868s left) gem_exec_reloc (basic-write-read-active)
[157.027094] Subtest basic-write-read-active: SKIP (0.000s)
[157.100657] [014/133] (868s left) kms_setmode (basic-clone-single-crtc)
[157.151813] Starting subtest: basic-clone-single-crtc
[157.154389] Subtest basic-clone-single-crtc: SKIP (0.000s)
[157.250219] [015/133] (868s left) sw_sync (sync_busy)
[157.281944] Starting subtest: sync_busy
[157.284012] Subtest sync_busy: SUCCESS (0.002s)
[157.344998] [016/133] (867s left) gem_exec_reloc (basic-gtt-wc-active)
[157.401204] Subtest basic-gtt-wc-active: SKIP (0.000s)
[157.481182] [017/133] (867s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[157.599067] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[175.620445] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.020s)
[176.419385] [018/133] (848s left) gem_exec_schedule (out-order)
[176.496920] Starting subtest: out-order
[176.497916] Starting dynamic subtest: rcs0
[176.616662] Dynamic subtest rcs0: SUCCESS (0.119s)
[176.626648] Starting dynamic subtest: vcs0
[176.710114] Dynamic subtest vcs0: SUCCESS (0.093s)
[176.719740] Starting dynamic subtest: vcs1
[176.803428] Dynamic subtest vcs1: SUCCESS (0.092s)
[176.813581] Starting dynamic subtest: vecs0
[176.896508] Dynamic subtest vecs0: SUCCESS (0.093s)
[176.906706] Starting dynamic subtest: ccs0
[176.991237] Dynamic subtest ccs0: SUCCESS (0.093s)
[176.992704] Subtest out-order: SUCCESS (0.495s)
[177.950043] [019/133] (847s left) syncobj_timeline (multi-wait-for-submit-signaled)
[178.009918] Starting subtest: multi-wait-for-submit-signaled
[178.010834] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[178.114115] [020/133] (847s left) kms_feature_discovery (display)
[178.215889] Starting subtest: display
[178.216780] Subtest display: SUCCESS (0.000s)
[178.286958] [021/133] (847s left) gen7_exec_parse (basic-allowed)
[178.349783] Subtest basic-allowed: SKIP (0.000s)
[178.409296] [022/133] (847s left) gem_ctx_persistence (engines-cleanup)
[178.468452] Starting subtest: engines-cleanup
[178.477368] Starting dynamic subtest: rcs0
[178.554431] Dynamic subtest rcs0: SUCCESS (0.085s)
[178.565229] Starting dynamic subtest: bcs0
[178.605332] Dynamic subtest bcs0: SUCCESS (0.049s)
[178.613976] Starting dynamic subtest: vcs0
[178.647331] Dynamic subtest vcs0: SUCCESS (0.041s)
[178.655299] Starting dynamic subtest: vcs1
[178.693345] Dynamic subtest vcs1: SUCCESS (0.045s)
[178.701755] Starting dynamic subtest: vecs0
[178.748230] Dynamic subtest vecs0: SUCCESS (0.054s)
[178.758406] Starting dynamic subtest: ccs0
[178.794244] Dynamic subtest ccs0: SUCCESS (0.044s)
[178.795543] Subtest engines-cleanup: SUCCESS (0.327s)
[178.866496] [023/133] (846s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[178.954176] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[178.955107] Starting dynamic subtest: pipe-A-eDP-1
[179.710047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s)
[179.717852] Starting dynamic subtest: pipe-B-eDP-1
[181.568363] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.857s)
[181.576078] Starting dynamic subtest: pipe-C-eDP-1
[183.404208] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.835s)
[183.412085] Starting dynamic subtest: pipe-D-eDP-1
[185.234956] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.829s)
[185.235934] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.277s)
[186.356222] [024/133] (839s left) kms_cursor_crc (cursor-random-256x256)
[186.615303] Starting subtest: cursor-random-256x256
[186.618268] Starting dynamic subtest: pipe-A-eDP-1
[189.936423] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.318s)
[189.965656] Starting dynamic subtest: pipe-D-eDP-1
[193.968719] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.010s)
[193.969526] Subtest cursor-random-256x256: SUCCESS (7.354s)
[194.859142] [025/133] (830s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[194.957887] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[194.959524] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[195.052022] [026/133] (830s left) gen9_exec_parse (batch-without-end)
[195.115368] Subtest batch-without-end: SKIP (0.000s)
[195.181899] [027/133] (830s left) kms_content_protection (lic-type-0-hdcp14)
[195.314633] Starting subtest: lic-type-0-hdcp14
[195.316552] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[195.425746] [028/133] (830s left) kms_flip (flip-vs-fences-interruptible)
[195.516910] Starting subtest: flip-vs-fences-interruptible
[195.518587] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[195.614579] [029/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[195.709238] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[195.711114] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[195.802668] [030/133] (830s left) i915_drm_fdinfo (memory-info-idle)
[195.843029] Starting subtest: memory-info-idle
[195.843940] Starting dynamic subtest: smem0
[195.890069] Dynamic subtest smem0: SUCCESS (0.046s)
[195.891593] Subtest memory-info-idle: SUCCESS (0.047s)
[195.963766] [031/133] (829s left) gem_exec_big (single)
[196.009497] Starting subtest: single
[198.853646] Subtest single: SUCCESS (2.836s)
[199.099230] [032/133] (826s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[199.230384] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[199.231417] Starting dynamic subtest: pipe-A-eDP-1
[210.222103] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.991s)
[210.229680] Starting dynamic subtest: pipe-B-eDP-1
[221.935482] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.711s)
[221.936467] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.705s)
[222.778722] [033/133] (803s left) i915_pm_rc6_residency (rc6-idle)
[222.837875] Starting subtest: rc6-idle
[222.862790] Starting dynamic subtest: gt0-rcs0
[247.223840] Dynamic subtest gt0-rcs0: SUCCESS (24.360s)
[247.231158] Starting dynamic subtest: gt0-bcs0
[271.566083] Dynamic subtest gt0-bcs0: SUCCESS (24.341s)
[271.576328] Starting dynamic subtest: gt0-ccs0
[295.865525] Dynamic subtest gt0-ccs0: SUCCESS (24.296s)
[295.880702] Starting dynamic subtest: gt1-vcs0
[302.084959] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[302.095567] Starting dynamic subtest: gt1-vecs0
[308.220448] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[308.221701] Subtest rc6-idle: SUCCESS (85.374s)
[308.300589] [034/133] (717s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[308.361189] Starting subtest: etime-single-wait-all-for-submit-submitted
[308.464720] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[308.550366] [035/133] (717s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[308.639067] Starting subtest: bad-rotation-90-y-tiled-ccs
[308.639909] Starting dynamic subtest: pipe-A-eDP-1
[308.648397] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[308.656075] Starting dynamic subtest: pipe-B-eDP-1
[308.664538] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.671956] Starting dynamic subtest: pipe-C-eDP-1
[308.680431] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[308.687439] Starting dynamic subtest: pipe-D-eDP-1
[308.695731] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[308.697373] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[310.921814] [036/133] (715s left) syncobj_wait (wait-all-delayed-signal)
[310.965241] Starting subtest: wait-all-delayed-signal
[311.070874] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[311.151643] [037/133] (714s left) gem_exec_whisper (basic-contexts-priority-all)
[311.199278] Starting subtest: basic-contexts-priority-all
[334.238060] Subtest basic-contexts-priority-all: SUCCESS (23.026s)
[334.411291] [038/133] (691s left) kms_vblank (ts-continuation-idle-hang)
[334.522516] Starting subtest: ts-continuation-idle-hang
[334.523622] Starting dynamic subtest: pipe-A-eDP-1
[360.730842] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.206s)
[360.741082] Starting dynamic subtest: pipe-D-eDP-1
[375.711025] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.976s)
[375.712227] Subtest ts-continuation-idle-hang: SUCCESS (41.186s)
[376.496979] [039/133] (649s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[376.600264] Starting subtest: stress-xrgb8888-xtiled
[382.487440] Subtest stress-xrgb8888-xtiled: SUCCESS (5.887s)
[382.535369] [040/133] (643s left) gem_softpin (allocator-fork)
[382.591146] Starting subtest: allocator-fork
[384.848654] Subtest allocator-fork: SUCCESS (2.212s)
[384.923569] [041/133] (641s left) gem_exec_reloc (basic-active)
[384.972251] Subtest basic-active: SKIP (0.000s)
[385.035809] [042/133] (641s left) kms_flip (2x-blocking-absolute-wf_vblank)
[385.132920] Starting subtest: 2x-blocking-absolute-wf_vblank
[385.144650] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[385.233459] [043/133] (641s left) kms_psr (psr-cursor-render)
[385.317272] Starting subtest: psr-cursor-render
[385.318094] Starting dynamic subtest: eDP-1
[386.999083] Dynamic subtest eDP-1: SUCCESS (1.682s)
[387.000158] Subtest psr-cursor-render: SUCCESS (1.682s)
[387.871675] [044/133] (638s left) kms_vrr (negative-basic)
[387.958142] Starting subtest: negative-basic
[387.960937] Starting dynamic subtest: pipe-A-eDP-1
[393.439528] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.434s)
[393.701643] Subtest negative-basic: SUCCESS (5.742s)
[394.495388] [045/133] (631s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[394.586378] Starting subtest: primary-y-tiled-reflect-x-270
[394.588247] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[394.658275] [046/133] (631s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[394.738446] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[398.849817] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.111s)
[400.013804] [047/133] (626s left) gem_ctx_persistence (file)
[400.065767] Starting subtest: file
[400.172859] Subtest file: SUCCESS (0.107s)
[400.273866] [048/133] (626s left) kms_cursor_crc (cursor-offscreen-512x170)
[400.586071] Starting subtest: cursor-offscreen-512x170
[400.587778] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[400.731724] [049/133] (625s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[400.810103] Starting subtest: fbc-psr2-cursor-plane-onoff
[400.810997] Starting dynamic subtest: eDP-1
[400.813497] Dynamic subtest eDP-1: SKIP (0.000s)
[400.815794] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.002s)
[400.892452] [050/133] (625s left) kms_psr (psr-sprite-mmap-gtt)
[400.988373] Starting subtest: psr-sprite-mmap-gtt
[400.989382] Starting dynamic subtest: eDP-1
[402.448696] Dynamic subtest eDP-1: SKIP (1.449s)
[402.450844] Subtest psr-sprite-mmap-gtt: SKIP (1.451s)
[402.581219] [051/133] (623s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[402.672668] Starting subtest: psr-rgb101010-draw-mmap-cpu
[409.861386] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.189s)
[409.958297] [052/133] (616s left) prime_mmap (test_correct_cpu_write)
[410.007380] Starting subtest: test_correct_cpu_write
[410.008452] Starting dynamic subtest: test_correct_cpu_write-smem
[410.009441] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[410.010415] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[410.106196] [053/133] (616s left) kms_flip (flip-vs-expired-vblank)
[410.209537] Starting subtest: flip-vs-expired-vblank
[410.212036] Starting dynamic subtest: A-eDP1
[418.900513] Dynamic subtest A-eDP1: SUCCESS (8.662s)
[418.908231] Starting dynamic subtest: B-eDP1
[427.543025] Dynamic subtest B-eDP1: SUCCESS (8.640s)
[427.554062] Starting dynamic subtest: C-eDP1
[436.170433] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[436.180604] Starting dynamic subtest: D-eDP1
[444.800241] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[444.801401] Subtest flip-vs-expired-vblank: SUCCESS (34.554s)
[445.922231] [054/133] (580s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[446.041472] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[446.180246] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.139s)
[446.295895] [055/133] (580s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[446.405978] Starting subtest: x-tiled-64bpp-rotate-180
[448.073355] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.668s)
[448.212755] [056/133] (578s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[448.266953] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[448.368114] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.101s)
[448.454987] [057/133] (578s left) kms_plane_cursor (viewport)
[448.541287] Starting subtest: viewport
[448.543069] Starting dynamic subtest: pipe-A-eDP-1-size-64
[451.103445] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.562s)
[451.165272] Starting dynamic subtest: pipe-A-eDP-1-size-128
[453.726764] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[453.789058] Starting dynamic subtest: pipe-A-eDP-1-size-256
[456.361098] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.582s)
[456.718255] Starting dynamic subtest: pipe-B-eDP-1-size-64
[460.020840] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.321s)
[460.082959] Starting dynamic subtest: pipe-B-eDP-1-size-128
[462.721653] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.649s)
[462.784277] Starting dynamic subtest: pipe-B-eDP-1-size-256
[465.389833] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.616s)
[465.748319] Starting dynamic subtest: pipe-C-eDP-1-size-64
[468.763823] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.023s)
[468.801304] Starting dynamic subtest: pipe-C-eDP-1-size-128
[470.986260] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[471.024930] Starting dynamic subtest: pipe-C-eDP-1-size-256
[473.175222] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[473.506064] Starting dynamic subtest: pipe-D-eDP-1-size-64
[476.416906] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.919s)
[476.455604] Starting dynamic subtest: pipe-D-eDP-1-size-128
[478.650150] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[478.688941] Starting dynamic subtest: pipe-D-eDP-1-size-256
[480.861555] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[481.183303] Subtest viewport: SUCCESS (32.641s)
[482.025635] [058/133] (544s left) kms_color (ctm-0-50)
[482.109556] Starting subtest: ctm-0-50
[482.110407] Starting dynamic subtest: pipe-A-eDP-1
[485.571991] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.460s)
[485.580667] Starting dynamic subtest: pipe-B-eDP-1
[489.831090] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.260s)
[489.839258] Starting dynamic subtest: pipe-C-eDP-1
[493.793413] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.961s)
[493.801122] Starting dynamic subtest: pipe-D-eDP-1
[497.781197] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.986s)
[497.782081] Subtest ctm-0-50: SUCCESS (15.671s)
[498.609781] [059/133] (528s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[498.706674] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[498.708187] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[498.799212] [060/133] (528s left) gem_basic (multigpu-create-close)
[498.856141] Starting subtest: multigpu-create-close
[498.857923] Subtest multigpu-create-close: SKIP (0.000s)
[498.962275] [061/133] (527s left) kms_lease (setcrtc-implicit-plane)
[499.049056] Starting subtest: setcrtc-implicit-plane
[499.049855] Starting dynamic subtest: pipe-A-eDP-1
[499.515806] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.464s)
[499.523833] Starting dynamic subtest: pipe-B-eDP-1
[500.662357] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[500.673333] Starting dynamic subtest: pipe-C-eDP-1
[501.772586] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[501.782180] Starting dynamic subtest: pipe-D-eDP-1
[502.898042] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[502.899103] Subtest setcrtc-implicit-plane: SUCCESS (3.849s)
[503.736200] [062/133] (523s left) kms_prop_blob (blob-prop-validate)
[503.797351] Starting subtest: blob-prop-validate
[503.798256] Subtest blob-prop-validate: SUCCESS (0.000s)
[503.884883] [063/133] (523s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[503.949396] Starting subtest: invalid-bsd2-flag-on-vebox
[503.950220] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[504.039352] [064/133] (522s left) prime_self_import (export-vs-gem_close-race)
[504.071704] Starting subtest: export-vs-gem_close-race
[509.165040] Subtest export-vs-gem_close-race: SUCCESS (5.093s)
[509.238475] [065/133] (517s left) kms_universal_plane (cursor-fb-leak)
[509.344999] Starting subtest: cursor-fb-leak
[509.345896] Starting dynamic subtest: pipe-A-eDP-1
[509.721738] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s)
[509.738467] Starting dynamic subtest: pipe-B-eDP-1
[511.158489] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.434s)
[511.169716] Starting dynamic subtest: pipe-C-eDP-1
[512.577368] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.416s)
[512.589377] Starting dynamic subtest: pipe-D-eDP-1
[513.907262] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[513.908419] Subtest cursor-fb-leak: SUCCESS (4.563s)
[515.065952] [066/133] (511s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[515.160944] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[522.094574] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.934s)
[522.217353] [067/133] (504s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[522.326395] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[522.327999] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[522.394745] [068/133] (504s left) syncobj_wait (single-wait-all-for-submit-submitted)
[522.443061] Starting subtest: single-wait-all-for-submit-submitted
[522.544430] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[522.618697] [069/133] (504s left) vgem_basic (mmap)
[522.649678] Starting subtest: mmap
[522.690102] Subtest mmap: SUCCESS (0.041s)
[522.748186] [070/133] (504s left) kms_plane_scaling (planes-downscale-factor-0-75)
[522.844590] Starting subtest: planes-downscale-factor-0-75
[522.845466] Starting dynamic subtest: pipe-A
[522.865881] Dynamic subtest pipe-A: SKIP (0.020s)
[522.873925] Starting dynamic subtest: pipe-B
[522.902028] Dynamic subtest pipe-B: SKIP (0.034s)
[522.914594] Starting dynamic subtest: pipe-C
[522.935044] Dynamic subtest pipe-C: SKIP (0.034s)
[522.946992] Starting dynamic subtest: pipe-D
[522.969881] Dynamic subtest pipe-D: SKIP (0.035s)
[522.971523] Subtest planes-downscale-factor-0-75: SKIP (0.125s)
[523.079412] [071/133] (504s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[523.176822] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[523.179181] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[523.269808] [072/133] (504s left) prime_busy (hang-wait)
[523.323144] Starting subtest: hang-wait
[523.323980] Starting dynamic subtest: rcs0
[549.426375] Dynamic subtest rcs0: SUCCESS (26.098s)
[549.436474] Starting dynamic subtest: bcs0
[556.516520] Dynamic subtest bcs0: SUCCESS (7.089s)
[556.526823] Starting dynamic subtest: vcs0
[563.559243] Dynamic subtest vcs0: SUCCESS (7.039s)
[563.568809] Starting dynamic subtest: vcs1
[570.598162] Dynamic subtest vcs1: SUCCESS (7.036s)
[570.606180] Starting dynamic subtest: vecs0
[577.505701] Dynamic subtest vecs0: SUCCESS (6.904s)
[577.515454] Starting dynamic subtest: ccs0
[591.407885] Dynamic subtest ccs0: SUCCESS (13.900s)
[591.411048] Subtest hang-wait: SUCCESS (68.083s)
[591.516794] [073/133] (435s left) gem_mmap (short-mmap)
[591.575701] Subtest short-mmap: SKIP (0.000s)
[591.634617] [074/133] (435s left) kms_chamelium_hpd (vga-hpd)
[592.025534] Subtest vga-hpd: SKIP (0.000s)
[592.818761] [075/133] (434s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[592.915910] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[594.028861] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.113s)
[594.145796] [076/133] (433s left) kms_dp_link_training (uhbr-mst)
[594.250363] Starting subtest: uhbr-mst
[594.253901] Subtest uhbr-mst: SKIP (0.000s)
[594.322760] [077/133] (433s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[594.436376] Starting subtest: cursorB-vs-flipB-toggle
[594.438059] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[594.579227] [078/133] (432s left) kms_big_fb (y-tiled-addfb)
[594.672909] Starting subtest: y-tiled-addfb
[594.674803] Subtest y-tiled-addfb: SKIP (0.000s)
[594.759369] [079/133] (432s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[594.845480] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[594.847211] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[594.939624] [080/133] (432s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[595.030333] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[595.032113] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[595.126281] [081/133] (432s left) gem_exec_nop (basic-sequential)
[595.186617] Starting subtest: basic-sequential
[609.363423] Subtest basic-sequential: SUCCESS (14.177s)
[609.594603] [082/133] (418s left) kms_addfb_basic (master-rmfb)
[609.657406] Starting subtest: master-rmfb
[609.658283] Subtest master-rmfb: SUCCESS (0.001s)
[609.793871] [083/133] (417s left) gem_render_copy (yf-tiled)
[609.844262] Starting subtest: yf-tiled
[609.845906] Subtest yf-tiled: SKIP (0.000s)
[610.025734] [084/133] (417s left) gem_sync (basic-many-each)
[610.097356] Starting subtest: basic-many-each
[612.414713] Subtest basic-many-each: SUCCESS (2.318s)
[612.593462] [085/133] (415s left) api_intel_allocator (fork-simple-stress-signal)
[612.633732] Starting subtest: fork-simple-stress-signal
[618.084207] Subtest fork-simple-stress-signal: SUCCESS (5.405s)
[618.163334] [086/133] (409s left) i915_drm_fdinfo (virtual-idle)
[618.198306] Starting subtest: virtual-idle
[621.266648] Subtest virtual-idle: SUCCESS (3.058s)
[621.334069] [087/133] (406s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[621.428304] Starting subtest: plane-use-after-nonblocking-unbind
[621.429163] Starting dynamic subtest: pipe-A-eDP-1
[621.490735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[621.804507] Starting dynamic subtest: pipe-B-eDP-1
[622.565790] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.769s)
[622.861945] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.433s)
[623.750324] [088/133] (404s left) kms_atomic_transition (plane-all-transition-fencing)
[623.829268] Starting subtest: plane-all-transition-fencing
[623.830154] Starting dynamic subtest: pipe-A-eDP-1
[626.327844] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[626.645377] Starting dynamic subtest: pipe-B-eDP-1
[629.873115] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.237s)
[630.169204] Subtest plane-all-transition-fencing: SUCCESS (6.340s)
[630.993900] [089/133] (396s left) syncobj_basic (test-valid-cycle)
[631.044810] Starting subtest: test-valid-cycle
[631.045825] Subtest test-valid-cycle: SUCCESS (0.000s)
[631.151150] [090/133] (396s left) kms_psr (fbc-psr-no-drrs)
[631.241380] Starting subtest: fbc-psr-no-drrs
[631.242414] Starting dynamic subtest: eDP-1
[631.244056] Dynamic subtest eDP-1: SKIP (0.000s)
[631.245663] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[631.309331] [091/133] (396s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[631.397148] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[631.397977] Starting dynamic subtest: pipe-A-eDP-1
[631.406443] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[631.415507] Starting dynamic subtest: pipe-B-eDP-1
[631.427264] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[631.438051] Starting dynamic subtest: pipe-C-eDP-1
[631.446703] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[631.454356] Starting dynamic subtest: pipe-D-eDP-1
[631.462961] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[631.464670] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[633.653447] [092/133] (394s left) kms_chamelium_edid (dp-edid-read)
[634.049818] Subtest dp-edid-read: SKIP (0.000s)
[634.866390] [093/133] (393s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[634.963128] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[634.964801] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[635.060489] [094/133] (393s left) syncobj_wait (invalid-reset-illegal-handle)
[635.117242] Starting subtest: invalid-reset-illegal-handle
[635.118046] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[635.214237] [095/133] (392s left) gem_exec_schedule (timeslicing)
[635.275256] Starting subtest: timeslicing
[635.276102] Starting dynamic subtest: rcs0
[635.295036] Dynamic subtest rcs0: SUCCESS (0.020s)
[635.305605] Starting dynamic subtest: bcs0
[635.316266] Dynamic subtest bcs0: SUCCESS (0.021s)
[635.324756] Starting dynamic subtest: vcs0
[635.338364] Dynamic subtest vcs0: SUCCESS (0.021s)
[635.347912] Starting dynamic subtest: vcs1
[635.359838] Dynamic subtest vcs1: SUCCESS (0.020s)
[635.369228] Starting dynamic subtest: vecs0
[635.380633] Dynamic subtest vecs0: SUCCESS (0.020s)
[635.388598] Starting dynamic subtest: ccs0
[635.402184] Dynamic subtest ccs0: SUCCESS (0.021s)
[635.403113] Subtest timeslicing: SUCCESS (0.129s)
[636.922829] [096/133] (391s left) gem_lmem_swapping (parallel-random)
[636.960306] Subtest parallel-random: SKIP (0.000s)
[637.007835] [097/133] (391s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[637.051055] Starting subtest: invalid-single-wait-all-unsubmitted
[637.051962] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[637.149990] [098/133] (391s left) gem_mmap_gtt (big-bo-tiledx)
[637.199168] Subtest big-bo-tiledX: SKIP (0.000s)
[637.251894] [099/133] (390s left) gem_mmap_offset (partial-mmap)
[637.303316] Starting subtest: partial-mmap
[637.304289] Starting dynamic subtest: smem0
[637.305801] Dynamic subtest smem0: SUCCESS (0.004s)
[637.306752] Subtest partial-mmap: SUCCESS (0.004s)
[637.384504] [100/133] (390s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[637.488881] Starting subtest: flip-vs-cursor-legacy
[644.925343] Subtest flip-vs-cursor-legacy: SUCCESS (7.436s)
[645.718935] [101/133] (382s left) device_reset (unbind-cold-reset-rebind)
[645.770826] Starting subtest: unbind-cold-reset-rebind
[645.772659] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[645.829345] [102/133] (382s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[645.924767] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[652.780022] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.856s)
[652.911291] [103/133] (375s left) syncobj_timeline (invalid-query-bad-pad)
[652.975670] Starting subtest: invalid-query-bad-pad
[652.976593] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[653.067469] [104/133] (375s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[653.159316] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[653.160067] Starting dynamic subtest: pipe-A-default-mode
[655.907415] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s)
[655.908334] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.748s)
[656.777975] [105/133] (371s left) gem_exec_reloc (basic-gtt-noreloc)
[656.833694] Subtest basic-gtt-noreloc: SKIP (0.000s)
[656.904959] [106/133] (371s left) kms_psr2_su (page_flip-p010)
[656.950808] Subtest page_flip-P010: SKIP (0.000s)
[657.009939] [107/133] (371s left) gem_eio (in-flight-10ms)
[657.244840] Starting subtest: in-flight-10ms
[666.012441] Subtest in-flight-10ms: SUCCESS (8.767s)
[666.184281] [108/133] (362s left) gem_exec_reloc (basic-wc-cpu-active)
[666.229508] Subtest basic-wc-cpu-active: SKIP (0.000s)
[666.295073] [109/133] (362s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[666.405018] Starting subtest: flip-vs-cursor-toggle
[675.440735] Subtest flip-vs-cursor-toggle: SUCCESS (9.035s)
[676.300884] [110/133] (352s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[676.390852] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[683.377836] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.988s)
[683.508969] [111/133] (345s left) i915_selftest (live)
[685.200707] Starting subtest: live
[685.202228] Starting dynamic subtest: sanitycheck
[689.582640] Dynamic subtest sanitycheck: SUCCESS (4.373s)
[689.591266] Starting dynamic subtest: uncore
[694.607691] Dynamic subtest uncore: SUCCESS (5.023s)
[694.618667] Starting dynamic subtest: workarounds
[697.728851] Dynamic subtest workarounds: SUCCESS (3.120s)
[697.738620] Starting dynamic subtest: gt_engines
[700.775971] Dynamic subtest gt_engines: SUCCESS (3.046s)
[700.784830] Starting dynamic subtest: gt_timelines
[718.391428] Dynamic subtest gt_timelines: SUCCESS (17.613s)
[718.399748] Starting dynamic subtest: gt_contexts
[722.743827] Dynamic subtest gt_contexts: SUCCESS (4.351s)
[722.752036] Starting dynamic subtest: gt_lrc
[727.095381] Dynamic subtest gt_lrc: SUCCESS (4.350s)
[727.101443] Starting dynamic subtest: gt_mocs
[730.079423] Dynamic subtest gt_mocs: SUCCESS (2.982s)
[730.088517] Starting dynamic subtest: gt_pm
[736.861133] Dynamic subtest gt_pm: SUCCESS (6.780s)
[736.870067] Starting dynamic subtest: gt_heartbeat
[739.641313] Dynamic subtest gt_heartbeat: SUCCESS (2.779s)
[739.649777] Starting dynamic subtest: gt_tlb
[749.028860] Dynamic subtest gt_tlb: SUCCESS (9.386s)
[749.037424] Starting dynamic subtest: requests
[762.388047] Dynamic subtest requests: SUCCESS (13.357s)
[762.396940] Starting dynamic subtest: migrate
[770.202572] Dynamic subtest migrate: SUCCESS (7.812s)
[770.211455] Starting dynamic subtest: active
[774.542583] Dynamic subtest active: SUCCESS (4.338s)
[774.551741] Starting dynamic subtest: objects
[779.468712] Dynamic subtest objects: SUCCESS (4.923s)
[779.477653] Starting dynamic subtest: mman
[782.841091] Dynamic subtest mman: SUCCESS (3.370s)
[782.850078] Starting dynamic subtest: dmabuf
[787.185953] Dynamic subtest dmabuf: SUCCESS (4.343s)
[787.192242] Starting dynamic subtest: vma
[791.520062] Dynamic subtest vma: SUCCESS (4.331s)
[791.528751] Starting dynamic subtest: coherency
[796.698938] Dynamic subtest coherency: SUCCESS (5.177s)
[796.708445] Starting dynamic subtest: gtt
[806.966435] Dynamic subtest gtt: SUCCESS (10.266s)
[806.975602] Starting dynamic subtest: gem
[814.587840] Dynamic subtest gem: SUCCESS (7.620s)
[814.596988] Starting dynamic subtest: evict
[818.691640] Dynamic subtest evict: SUCCESS (4.102s)
[818.700178] Starting dynamic subtest: hugepages
[827.553998] Dynamic subtest hugepages: SUCCESS (8.860s)
[827.562562] Starting dynamic subtest: gem_contexts
[856.906945] Dynamic subtest gem_contexts: SUCCESS (29.351s)
[856.914672] Starting dynamic subtest: client
[861.307980] Dynamic subtest client: SUCCESS (4.399s)
[861.317624] Starting dynamic subtest: gem_migrate
[865.676014] Dynamic subtest gem_migrate: SUCCESS (4.366s)
[865.681792] Starting dynamic subtest: reset
[868.456076] Dynamic subtest reset: SUCCESS (2.778s)
[868.464701] Starting dynamic subtest: memory_region
[872.814886] Dynamic subtest memory_region: SUCCESS (4.356s)
[872.824063] Starting dynamic subtest: hangcheck
[886.296023] Dynamic subtest hangcheck: SUCCESS (13.479s)
[886.304928] Starting dynamic subtest: execlists
[890.720981] Dynamic subtest execlists: SUCCESS (4.422s)
[890.730056] Starting dynamic subtest: ring_submission
[895.096743] Dynamic subtest ring_submission: SUCCESS (4.374s)
[895.105585] Starting dynamic subtest: perf
[899.429675] Dynamic subtest perf: SUCCESS (4.331s)
[899.435948] Starting dynamic subtest: slpc
[913.529791] Dynamic subtest slpc: SUCCESS (14.097s)
[913.539346] Starting dynamic subtest: guc
[917.477815] Dynamic subtest guc: SUCCESS (3.945s)
[917.486333] Starting dynamic subtest: guc_multi_lrc
[921.885383] Dynamic subtest guc_multi_lrc: SUCCESS (4.406s)
[921.893437] Starting dynamic subtest: guc_hang
[926.758588] Dynamic subtest guc_hang: SUCCESS (4.873s)
[926.766627] Starting dynamic subtest: late_gt_pm
[931.128776] Dynamic subtest late_gt_pm: SUCCESS (4.367s)
[931.130362] Subtest live: SUCCESS (245.914s)
[931.151739] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[931.152551] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[931.154241] [112/133] ( 97s left) gem_lmem_swapping (random-engines)
[932.695340] Subtest random-engines: SKIP (0.000s)
[932.732254] [FACT gem_lmem_swapping (random-engines)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[932.734032] [FACT gem_lmem_swapping (random-engines)] new: kernel.kmod_is_loaded.i915: true
[932.736524] [113/133] ( 95s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[932.839761] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[940.145099] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.294s)
[940.254297] [114/133] ( 88s left) kms_invalid_mode (zero-vdisplay)
[940.334554] Starting subtest: zero-vdisplay
[940.335567] Starting dynamic subtest: pipe-A-eDP-1
[940.621271] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[940.628363] Starting dynamic subtest: pipe-B-eDP-1
[940.629211] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[940.635836] Starting dynamic subtest: pipe-C-eDP-1
[940.636838] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[940.643339] Starting dynamic subtest: pipe-D-eDP-1
[940.644075] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[940.644811] Subtest zero-vdisplay: SUCCESS (0.292s)
[941.447921] [115/133] ( 87s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[941.538915] Starting subtest: psr-2p-primscrn-spr-indfb-move
[941.540524] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[941.632876] [116/133] ( 87s left) gem_basic (create-close)
[941.688631] Starting subtest: create-close
[941.690331] Subtest create-close: SUCCESS (0.000s)
[941.784841] [117/133] ( 87s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[941.872379] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[951.507625] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (9.635s)
[951.618434] [118/133] ( 77s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[951.709491] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[951.710461] Starting dynamic subtest: pipe-A-eDP-1
[951.719443] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[951.726453] Starting dynamic subtest: pipe-B-eDP-1
[951.735277] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[951.742127] Starting dynamic subtest: pipe-C-eDP-1
[951.753211] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[951.762972] Starting dynamic subtest: pipe-D-eDP-1
[951.772065] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[951.773880] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[953.945304] [119/133] ( 74s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[954.009709] Starting subtest: invalid-bsd1-flag-on-blt
[954.010723] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[954.114614] [120/133] ( 74s left) gem_ctx_shared (exec-shared-gtt)
[954.188605] Starting subtest: exec-shared-gtt
[954.189512] Starting dynamic subtest: rcs0
[954.202943] Dynamic subtest rcs0: SUCCESS (0.014s)
[954.212702] Starting dynamic subtest: bcs0
[954.213653] Dynamic subtest bcs0: SUCCESS (0.008s)
[954.222998] Starting dynamic subtest: vcs0
[954.223867] Dynamic subtest vcs0: SUCCESS (0.008s)
[954.231405] Starting dynamic subtest: vcs1
[954.232285] Dynamic subtest vcs1: SUCCESS (0.006s)
[954.239350] Starting dynamic subtest: vecs0
[954.240187] Dynamic subtest vecs0: SUCCESS (0.005s)
[954.247222] Starting dynamic subtest: ccs0
[954.248065] Dynamic subtest ccs0: SUCCESS (0.004s)
[954.249060] Subtest exec-shared-gtt: SUCCESS (0.049s)
[954.422155] [121/133] ( 74s left) kms_pm_rpm (basic-rte)
[954.453356] Starting subtest: basic-rte
[957.504413] Subtest basic-rte: SUCCESS (3.050s)
[959.307585] [122/133] ( 69s left) kms_big_fb (linear-32bpp-rotate-270)
[959.404155] Starting subtest: linear-32bpp-rotate-270
[959.423111] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[959.533177] [123/133] ( 69s left) kms_atomic (plane-invalid-params)
[959.615279] Starting subtest: plane-invalid-params
[959.616106] Starting dynamic subtest: pipe-A-eDP-1
[960.011959] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[960.012885] Subtest plane-invalid-params: SUCCESS (0.397s)
[960.831818] [124/133] ( 68s left) kms_addfb_basic (invalid-get-prop-any)
[960.875042] Starting subtest: invalid-get-prop-any
[960.875982] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[960.988836] [125/133] ( 68s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[961.099117] Starting subtest: 2x-long-cursor-vs-flip-legacy
[961.101947] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[961.270706] [126/133] ( 67s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[961.362234] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[961.363786] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[961.451135] [127/133] ( 67s left) kms_pm_rpm (system-suspend-idle)
[963.074317] Starting subtest: system-suspend-idle
[983.590699] Subtest system-suspend-idle: SUCCESS (5.015s)
[989.022531] [128/133] ( 45s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[989.118471] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[989.119600] Starting dynamic subtest: pipe-A-eDP-1
[989.124010] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[989.132315] Starting dynamic subtest: pipe-B-eDP-1
[989.136349] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[989.144605] Starting dynamic subtest: pipe-C-eDP-1
[989.148840] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[989.157129] Starting dynamic subtest: pipe-D-eDP-1
[989.161936] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[989.163818] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[991.427388] [129/133] ( 42s left) core_getstats (basic)
[991.480621] Starting subtest: basic
[991.482018] Subtest basic: SUCCESS (0.000s)
[991.572316] [130/133] ( 42s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[991.672266] Starting subtest: yf-tiled-8bpp-rotate-270
[991.674882] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[991.770008] [131/133] ( 42s left) perf_pmu (busy-no-semaphores)
[991.814293] Starting subtest: busy-no-semaphores
[991.815609] Starting dynamic subtest: rcs0
[992.384996] Dynamic subtest rcs0: SUCCESS (0.559s)
[992.396416] Starting dynamic subtest: bcs0
[992.938186] Dynamic subtest bcs0: SUCCESS (0.549s)
[992.949180] Starting dynamic subtest: vcs0
[993.490205] Dynamic subtest vcs0: SUCCESS (0.548s)
[993.501856] Starting dynamic subtest: vcs1
[994.927912] Dynamic subtest vcs1: SUCCESS (1.432s)
[994.939668] Starting dynamic subtest: vecs0
[996.911974] Dynamic subtest vecs0: SUCCESS (1.979s)
[996.922450] Starting dynamic subtest: ccs0
[998.959936] Dynamic subtest ccs0: SUCCESS (2.042s)
[998.961450] Subtest busy-no-semaphores: SUCCESS (7.128s)
[999.065406] [132/133] ( 35s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[999.113294] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[999.115898] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[999.293322] [133/133] ( 35s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[999.409229] Starting subtest: extended-modeset-hang-newfb-with-reset
[999.410671] Starting dynamic subtest: pipe-A
[1013.333059] Dynamic subtest pipe-A: SUCCESS (13.915s)
[1013.341977] Starting dynamic subtest: pipe-D
[1029.429224] Dynamic subtest pipe-D: SUCCESS (16.095s)
[1029.430507] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.016s)
[1030.266545] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: sysfs_heartbeat_interval
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_exec_fence
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_create
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_setmode
results: parsing output: 14/ for test: sw_sync
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_feature_discovery
results: parsing output: 20/ for test: gen7_exec_parse
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gen9_exec_parse
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: gem_exec_big
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: i915_pm_rc6_residency
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pipe_stress
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_vrr
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: gem_pxp
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_plane_cursor
results: parsing output: 57/ for test: kms_color
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_basic
results: parsing output: 60/ for test: kms_lease
results: parsing output: 61/ for test: kms_prop_blob
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: prime_self_import
results: parsing output: 64/ for test: kms_universal_plane
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_plane
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: prime_busy
results: parsing output: 72/ for test: gem_mmap
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_dp_link_training
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_nop
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: gem_sync
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: kms_atomic_transition
results: parsing output: 87/ for test: kms_atomic_transition
results: parsing output: 88/ for test: syncobj_basic
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_chamelium_edid
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: gem_lmem_swapping
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_mmap_offset
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: device_reset
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: kms_psr2_su
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: i915_selftest
results: parsing output: 111/ for test: gem_lmem_swapping
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_invalid_mode
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_basic
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_exec_params
results: parsing output: 119/ for test: gem_ctx_shared
results: parsing output: 120/ for test: kms_pm_rpm
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_atomic
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: core_getstats
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: kms_busy
Done.