[59.249853] Initializing watchdogs
[59.249904]   /dev/watchdog0
[59.264951] [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]
[59.269616] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.271947] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.275158] [001/133] (960s left) kms_scaling_modes (scaling-mode-center)
[59.386951] Starting subtest: scaling-mode-center
[59.389195] Starting dynamic subtest: pipe-A-eDP-1
[59.506732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.120s)
[59.515740] Starting dynamic subtest: pipe-B-eDP-1
[60.735319] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.228s)
[60.742352] Starting dynamic subtest: pipe-C-eDP-1
[61.858450] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[61.866731] Starting dynamic subtest: pipe-D-eDP-1
[62.995836] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[62.998133] Subtest scaling-mode-center: SUCCESS (3.611s)
[64.169432] [002/133] (955s left) gem_exec_gttfill (engines)
[64.247268] Starting subtest: engines
[64.249646] Starting dynamic subtest: rcs0
[87.036839] Dynamic subtest rcs0: SUCCESS (22.788s)
[87.047318] Starting dynamic subtest: bcs0
[110.268934] Dynamic subtest bcs0: SUCCESS (23.232s)
[110.278936] Starting dynamic subtest: vcs0
[133.561655] Dynamic subtest vcs0: SUCCESS (23.291s)
[133.578229] Starting dynamic subtest: vcs1
[156.833498] Dynamic subtest vcs1: SUCCESS (23.269s)
[156.843821] Starting dynamic subtest: vecs0
[180.087375] Dynamic subtest vecs0: SUCCESS (23.251s)
[180.098032] Starting dynamic subtest: ccs0
[203.428210] Dynamic subtest ccs0: SUCCESS (23.340s)
[203.430930] Subtest engines: SUCCESS (139.179s)
[203.616287] [003/133] (816s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[203.760873] Starting subtest: plane-primary-overlay-mutable-zpos
[207.203169] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.440s)
[208.381193] [004/133] (811s left) gem_partial_pwrite_pread (write-snoop)
[208.441291] Subtest write-snoop: SKIP (0.000s)
[208.504353] [005/133] (811s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[208.810552] Starting subtest: cursor-rapid-movement-512x170
[208.814530] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[208.959160] [006/133] (811s left) kms_plane_scaling (planes-upscale-20x20)
[209.064763] Starting subtest: planes-upscale-20x20
[209.067062] Starting dynamic subtest: pipe-A
[209.125095] Dynamic subtest pipe-A: SUCCESS (0.062s)
[209.134439] Starting dynamic subtest: pipe-B
[210.299621] Dynamic subtest pipe-B: SUCCESS (1.174s)
[210.308543] Starting dynamic subtest: pipe-C
[211.428565] Dynamic subtest pipe-C: SUCCESS (1.128s)
[211.437267] Starting dynamic subtest: pipe-D
[212.553147] Dynamic subtest pipe-D: SUCCESS (1.124s)
[212.555469] Subtest planes-upscale-20x20: SUCCESS (3.490s)
[213.738158] [007/133] (806s left) kms_cursor_crc (cursor-offscreen-32x32)
[213.886057] Starting subtest: cursor-offscreen-32x32
[213.931393] Subtest cursor-offscreen-32x32: SKIP (0.043s)
[214.222160] [008/133] (805s left) syncobj_wait (invalid-reset-illegal-handle)
[214.281809] Starting subtest: invalid-reset-illegal-handle
[214.283789] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[214.364878] [009/133] (805s left) gen9_exec_parse (basic-rejected)
[214.418924] Subtest basic-rejected: SKIP (0.000s)
[214.482639] [010/133] (805s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[214.533375] Starting subtest: single-wait-all-for-submit-available-submitted
[214.535367] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[214.621109] [011/133] (805s left) gem_pwrite_snooped
[214.741841] [012/133] (805s left) kms_color (ctm-0-25)
[214.828050] Starting subtest: ctm-0-25
[214.829629] Starting dynamic subtest: pipe-A-eDP-1
[218.343170] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.514s)
[218.354772] Starting dynamic subtest: pipe-B-eDP-1
[222.554662] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.212s)
[222.566145] Starting dynamic subtest: pipe-C-eDP-1
[226.597557] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.043s)
[226.606183] Starting dynamic subtest: pipe-D-eDP-1
[230.568204] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.968s)
[230.570465] Subtest ctm-0-25: SUCCESS (15.739s)
[231.393609] [013/133] (788s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[231.794722] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[232.593450] [014/133] (787s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[232.695044] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[232.697283] Starting dynamic subtest: pipe-A-eDP-1
[232.722105] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.733509] Starting dynamic subtest: pipe-B-eDP-1
[232.756963] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.765211] Starting dynamic subtest: pipe-C-eDP-1
[232.788357] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.795633] Starting dynamic subtest: pipe-D-eDP-1
[232.820226] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.824676] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[234.884332] [015/133] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[234.979390] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[239.413684] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.439s)
[240.589439] [016/133] (779s left) gem_exec_schedule (promotion)
[240.660608] Starting subtest: promotion
[240.662870] Starting dynamic subtest: rcs0
[240.776638] Dynamic subtest rcs0: SUCCESS (0.121s)
[240.788487] Starting dynamic subtest: vcs0
[240.860635] Dynamic subtest vcs0: SUCCESS (0.083s)
[240.872024] Starting dynamic subtest: vcs1
[240.943542] Dynamic subtest vcs1: SUCCESS (0.083s)
[240.954936] Starting dynamic subtest: vecs0
[241.033512] Dynamic subtest vecs0: SUCCESS (0.089s)
[241.044855] Starting dynamic subtest: ccs0
[241.132212] Dynamic subtest ccs0: SUCCESS (0.097s)
[241.134646] Subtest promotion: SUCCESS (0.478s)
[241.983775] [017/133] (778s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[242.042260] Starting subtest: yf-tiled-to-vebox-y-tiled
[242.046562] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[242.227442] [018/133] (778s left) gem_mmap_gtt (big-copy-xy)
[242.282430] Subtest big-copy-XY: SKIP (0.000s)
[242.334540] [019/133] (778s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[242.389058] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[242.497099] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[242.570100] [020/133] (777s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[242.670349] Starting subtest: psr-rgb565-draw-pwrite
[249.821537] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.154s)
[249.945849] [021/133] (770s left) kms_flip (plain-flip-ts-check-interruptible)
[250.049493] Starting subtest: plain-flip-ts-check-interruptible
[250.051799] Starting dynamic subtest: A-eDP1
[258.908621] Dynamic subtest A-eDP1: SUCCESS (8.857s)
[258.918736] Starting dynamic subtest: B-eDP1
[267.743268] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[267.753493] Starting dynamic subtest: C-eDP1
[276.567849] Dynamic subtest C-eDP1: SUCCESS (8.823s)
[276.576636] Starting dynamic subtest: D-eDP1
[285.399594] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[285.404415] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.354s)
[286.581371] [022/133] (734s left) kms_flip (flip-vs-rmfb-interruptible)
[286.684267] Starting subtest: flip-vs-rmfb-interruptible
[286.686759] Starting dynamic subtest: A-eDP1
[295.369714] Dynamic subtest A-eDP1: SUCCESS (8.684s)
[295.381118] Starting dynamic subtest: B-eDP1
[304.010659] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[304.021533] Starting dynamic subtest: C-eDP1
[312.732123] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[312.742637] Starting dynamic subtest: D-eDP1
[321.361144] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[321.366461] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.682s)
[322.567635] [023/133] (698s left) i915_pm_rps (reset)
[322.641807] Starting subtest: reset
[331.086447] Subtest reset: SUCCESS (8.442s)
[331.195593] [024/133] (689s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[331.293296] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[331.295720] Starting dynamic subtest: pipe-A-eDP-1
[331.316723] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[331.329598] Starting dynamic subtest: pipe-B-eDP-1
[331.349233] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[331.357573] Starting dynamic subtest: pipe-C-eDP-1
[331.376981] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[331.385076] Starting dynamic subtest: pipe-D-eDP-1
[331.404420] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[331.406339] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[333.535266] [025/133] (687s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[333.592166] Starting subtest: basic-batch-kernel-default-cmd
[333.596391] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[333.777519] [026/133] (686s left) sysfs_heartbeat_interval (idempotent)
[333.832963] Starting subtest: idempotent
[333.835342] Starting dynamic subtest: vecs0
[333.837702] Dynamic subtest vecs0: SUCCESS (0.001s)
[333.848019] Starting dynamic subtest: ccs0
[333.849869] Dynamic subtest ccs0: SUCCESS (0.001s)
[333.857776] Starting dynamic subtest: vcs0
[333.859683] Dynamic subtest vcs0: SUCCESS (0.000s)
[333.867553] Starting dynamic subtest: bcs0
[333.869535] Dynamic subtest bcs0: SUCCESS (0.001s)
[333.877564] Starting dynamic subtest: rcs0
[333.879582] Dynamic subtest rcs0: SUCCESS (0.001s)
[333.887862] Starting dynamic subtest: vcs1
[333.890051] Dynamic subtest vcs1: SUCCESS (0.001s)
[333.892180] Subtest idempotent: SUCCESS (0.009s)
[333.952692] [027/133] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[334.059403] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[340.967991] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.909s)
[341.128272] [028/133] (679s left) gem_mmap_gtt (close-race)
[341.188503] Subtest close-race: SKIP (0.000s)
[341.244631] [029/133] (679s left) perf (invalid-remove-userspace-config)
[341.394338] Starting subtest: invalid-remove-userspace-config
[341.405240] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[341.443230] [030/133] (679s left) gem_ccs (suspend-resume)
[341.498379] Starting subtest: suspend-resume
[341.502905] Subtest suspend-resume: SKIP (0.000s)
[341.594525] [031/133] (679s left) kms_chamelium_color (ctm-red-to-blue)
[341.684791] Subtest ctm-red-to-blue: SKIP (0.000s)
[341.733418] [032/133] (679s left) gem_mmap_gtt (big-bo-tiledy)
[341.785696] Subtest big-bo-tiledY: SKIP (0.000s)
[341.839479] [033/133] (679s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[341.955583] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[341.958038] Starting dynamic subtest: pipe-A-eDP-1
[347.843431] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.895s)
[347.851894] Starting dynamic subtest: pipe-B-eDP-1
[354.487780] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.642s)
[354.490199] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.540s)
[355.349483] [034/133] (665s left) kms_draw_crc (draw-method-blt)
[355.443762] Starting subtest: draw-method-blt
[355.446051] Starting dynamic subtest: xrgb8888-untiled
[355.708960] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[355.720341] Starting dynamic subtest: rgb565-untiled
[355.943641] Dynamic subtest rgb565-untiled: SUCCESS (0.231s)
[355.952378] Starting dynamic subtest: xrgb2101010-untiled
[356.153297] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[356.162505] Starting dynamic subtest: xbgr16161616f-untiled
[356.375444] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[356.383641] Starting dynamic subtest: xrgb8888-xtiled
[356.497747] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[356.505995] Starting dynamic subtest: rgb565-xtiled
[356.619952] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[356.628361] Starting dynamic subtest: xrgb2101010-xtiled
[356.720024] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[356.730723] Starting dynamic subtest: xbgr16161616f-xtiled
[356.830962] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.108s)
[356.839153] Starting dynamic subtest: xrgb8888-4tiled
[356.953192] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[356.966448] Starting dynamic subtest: rgb565-4tiled
[357.064445] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[357.072270] Starting dynamic subtest: xrgb2101010-4tiled
[357.164471] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[357.172766] Starting dynamic subtest: xbgr16161616f-4tiled
[357.264490] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[357.266400] Subtest draw-method-blt: SUCCESS (1.824s)
[357.367112] [035/133] (663s left) kms_psr (fbc-psr-no-drrs)
[357.464720] Starting subtest: fbc-psr-no-drrs
[357.466696] Starting dynamic subtest: eDP-1
[357.470296] Dynamic subtest eDP-1: SKIP (0.000s)
[357.473885] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[357.535732] [036/133] (663s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[357.599206] Subtest untiled-to-tiled: SKIP (0.000s)
[357.662983] [037/133] (663s left) gem_ctx_param (invalid-get-no-zeromap)
[357.705400] Starting subtest: invalid-get-no-zeromap
[357.707256] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[357.799662] [038/133] (663s left) i915_drm_fdinfo (virtual-busy-hang-all)
[357.847064] Starting subtest: virtual-busy-hang-all
[357.850360] Subtest virtual-busy-hang-all: SKIP (0.000s)
[357.930253] [039/133] (663s left) syncobj_timeline (invalid-signal-zero-handles)
[357.988423] Starting subtest: invalid-signal-zero-handles
[357.990322] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[358.082607] [040/133] (663s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[358.173982] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[358.178077] Starting dynamic subtest: A-eDP1
[361.778801] Dynamic subtest A-eDP1: SUCCESS (3.601s)
[361.787923] Starting dynamic subtest: B-eDP1
[364.989381] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[365.000518] Starting dynamic subtest: C-eDP1
[368.099646] Dynamic subtest C-eDP1: SUCCESS (3.110s)
[368.111722] Starting dynamic subtest: D-eDP1
[371.200366] Dynamic subtest D-eDP1: SUCCESS (3.097s)
[371.202649] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.024s)
[371.996459] [041/133] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[372.096382] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[372.100789] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[372.193428] [042/133] (649s left) perf_pmu (most-busy-idle-check-all)
[372.244576] Starting subtest: most-busy-idle-check-all
[372.246808] Starting dynamic subtest: rcs0
[373.909733] Dynamic subtest rcs0: SUCCESS (1.663s)
[373.921960] Starting dynamic subtest: bcs0
[375.894071] Dynamic subtest bcs0: SUCCESS (1.981s)
[375.905454] Starting dynamic subtest: vcs0
[377.941274] Dynamic subtest vcs0: SUCCESS (2.044s)
[377.954076] Starting dynamic subtest: vcs1
[379.924947] Dynamic subtest vcs1: SUCCESS (1.980s)
[379.937313] Starting dynamic subtest: vecs0
[381.908898] Dynamic subtest vecs0: SUCCESS (1.981s)
[381.921068] Starting dynamic subtest: ccs0
[383.893398] Dynamic subtest ccs0: SUCCESS (1.981s)
[383.896202] Subtest most-busy-idle-check-all: SUCCESS (11.649s)
[384.001289] [043/133] (637s left) gem_eio (in-flight-contexts-10ms)
[384.199623] Starting subtest: in-flight-contexts-10ms
[397.929464] Subtest in-flight-contexts-10ms: SUCCESS (13.729s)
[398.097962] [044/133] (623s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[398.215925] Starting subtest: psr-rgb565-draw-mmap-cpu
[405.222668] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (7.011s)
[405.324430] [045/133] (616s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[405.424144] Starting subtest: fbc-farfromfence-mmap-gtt
[405.428181] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[405.518119] [046/133] (616s left) gem_busy (busy)
[405.600607] Starting subtest: busy
[405.602665] Starting dynamic subtest: all-engines
[405.636879] Dynamic subtest all-engines: SUCCESS (0.039s)
[405.648425] Starting dynamic subtest: rcs0
[406.940862] Dynamic subtest rcs0: SUCCESS (1.302s)
[406.951061] Starting dynamic subtest: bcs0
[406.981052] Dynamic subtest bcs0: SUCCESS (0.038s)
[406.989904] Starting dynamic subtest: vcs0
[407.019743] Dynamic subtest vcs0: SUCCESS (0.039s)
[407.028739] Starting dynamic subtest: vcs1
[408.921807] Dynamic subtest vcs1: SUCCESS (1.897s)
[408.933293] Starting dynamic subtest: vecs0
[410.905876] Dynamic subtest vecs0: SUCCESS (1.982s)
[410.916829] Starting dynamic subtest: ccs0
[412.890081] Dynamic subtest ccs0: SUCCESS (1.984s)
[412.892191] Subtest busy: SUCCESS (7.291s)
[413.259926] [047/133] (608s left) gem_spin_batch (legacy-resubmit)
[413.318914] Starting subtest: legacy-resubmit
[413.321311] Starting dynamic subtest: default
[413.329941] Dynamic subtest default: SUCCESS (0.010s)
[413.340671] Starting dynamic subtest: render
[413.342890] Dynamic subtest render: SUCCESS (0.001s)
[413.351441] Starting dynamic subtest: bsd
[413.353393] Dynamic subtest bsd: SUCCESS (0.003s)
[413.362075] Starting dynamic subtest: bsd1
[413.364194] Dynamic subtest bsd1: SUCCESS (0.004s)
[413.372716] Starting dynamic subtest: bsd2
[413.374936] Dynamic subtest bsd2: SUCCESS (0.001s)
[413.383553] Starting dynamic subtest: blt
[413.385719] Dynamic subtest blt: SUCCESS (0.005s)
[413.394287] Starting dynamic subtest: vebox
[413.396454] Dynamic subtest vebox: SUCCESS (0.003s)
[413.398632] Subtest legacy-resubmit: SUCCESS (0.035s)
[413.609163] [048/133] (608s left) gem_vm_create (invalid-destroy)
[413.658438] Starting subtest: invalid-destroy
[413.660792] Subtest invalid-destroy: SUCCESS (0.002s)
[413.764362] [049/133] (607s left) vgem_basic (setversion)
[413.894470] Starting subtest: setversion
[413.898601] Subtest setversion: SUCCESS (0.000s)
[413.949235] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[413.952496] [050/133] (607s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[414.055817] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[414.058110] Starting dynamic subtest: pipe-A-eDP-1
[414.066676] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[414.076438] Starting dynamic subtest: pipe-B-eDP-1
[414.085119] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[414.093968] Starting dynamic subtest: pipe-C-eDP-1
[414.102082] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[414.110590] Starting dynamic subtest: pipe-D-eDP-1
[414.118745] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[414.122897] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[416.289273] [051/133] (605s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[416.401241] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[416.405632] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[416.532234] [052/133] (605s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[416.671637] Starting subtest: dp-mst-lic-type-0-hdcp14
[416.676204] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[416.805648] [053/133] (605s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[416.909251] Starting subtest: fbc-psr2-cursor-mmap-cpu
[416.911542] Starting dynamic subtest: eDP-1
[416.915865] Dynamic subtest eDP-1: SKIP (0.000s)
[416.920207] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[416.985727] [054/133] (604s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[417.092087] Starting subtest: yf-tiled-addfb-size-offset-overflow
[417.096583] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[417.184313] [055/133] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[417.287836] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[417.291360] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[417.388823] [056/133] (604s left) dumb_buffer (invalid-bpp)
[417.451127] Starting subtest: invalid-bpp
[417.453065] Subtest invalid-bpp: SUCCESS (0.000s)
[417.557270] [057/133] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[417.654502] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[417.657930] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[417.750661] [058/133] (604s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[417.804893] Starting subtest: etime-single-wait-all-available-unsubmitted
[417.912758] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s)
[418.003440] [059/133] (604s left) gem_reg_read (bad-register)
[418.063793] Starting subtest: bad-register
[418.066127] Subtest bad-register: SUCCESS (0.000s)
[418.163750] [060/133] (603s left) gem_ctx_persistence (legacy-engines-cleanup)
[418.217676] Starting subtest: legacy-engines-cleanup
[418.219515] Starting dynamic subtest: render
[418.280534] Dynamic subtest render: SUCCESS (0.065s)
[418.295161] Starting dynamic subtest: bsd1
[418.314565] Dynamic subtest bsd1: SUCCESS (0.031s)
[418.326066] Starting dynamic subtest: bsd2
[418.347279] Dynamic subtest bsd2: SUCCESS (0.032s)
[418.355931] Starting dynamic subtest: blt
[418.380342] Dynamic subtest blt: SUCCESS (0.031s)
[418.389312] Starting dynamic subtest: vebox
[418.417622] Dynamic subtest vebox: SUCCESS (0.035s)
[418.419840] Subtest legacy-engines-cleanup: SUCCESS (0.203s)
[418.508570] [061/133] (603s left) gem_ctx_shared (q-in-order)
[418.574695] Starting subtest: Q-in-order
[418.577107] Starting dynamic subtest: rcs0
[418.681526] Dynamic subtest rcs0: SUCCESS (0.097s)
[418.690571] Starting dynamic subtest: vcs0
[418.749859] Dynamic subtest vcs0: SUCCESS (0.076s)
[418.767081] Starting dynamic subtest: vcs1
[418.826353] Dynamic subtest vcs1: SUCCESS (0.075s)
[418.843044] Starting dynamic subtest: vecs0
[418.915371] Dynamic subtest vecs0: SUCCESS (0.088s)
[418.931993] Starting dynamic subtest: ccs0
[419.020404] Dynamic subtest ccs0: SUCCESS (0.103s)
[419.022387] Subtest Q-in-order: SUCCESS (0.446s)
[420.010146] [062/133] (602s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[420.109043] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[420.113496] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[420.216404] [063/133] (602s left) kms_properties (connector-properties-legacy)
[420.308030] Starting subtest: connector-properties-legacy
[420.310227] Starting dynamic subtest: pipe-A-eDP-1
[428.292561] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.983s)
[428.310331] Starting dynamic subtest: pipe-None-DP-1
[428.315120] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[428.332117] Starting dynamic subtest: pipe-None-HDMI-A-1
[428.336189] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[428.344820] Starting dynamic subtest: pipe-None-DP-2
[428.348968] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[428.357959] Starting dynamic subtest: pipe-None-HDMI-A-2
[428.362492] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[428.374824] Starting dynamic subtest: pipe-None-DP-3
[428.380306] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[428.394609] Starting dynamic subtest: pipe-None-DP-4
[428.398958] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[428.401435] Subtest connector-properties-legacy: SUCCESS (7.995s)
[429.174836] [064/133] (593s left) kms_dp_link_training (non-uhbr-sst)
[429.276713] Starting subtest: non-uhbr-sst
[429.285601] Subtest non-uhbr-sst: SKIP (0.000s)
[429.353123] [065/133] (593s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[429.458460] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[429.462567] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[429.541647] [066/133] (592s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[429.639377] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[429.641345] Starting dynamic subtest: pipe-A
[429.987361] Dynamic subtest pipe-A: SUCCESS (0.350s)
[429.997694] Starting dynamic subtest: pipe-B
[431.369082] Dynamic subtest pipe-B: SUCCESS (1.380s)
[431.378984] Starting dynamic subtest: pipe-C
[432.815180] Dynamic subtest pipe-C: SUCCESS (1.445s)
[432.824878] Starting dynamic subtest: pipe-D
[434.240429] Dynamic subtest pipe-D: SUCCESS (1.424s)
[434.242655] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.605s)
[435.387110] [067/133] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[435.492120] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[435.496451] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[435.587554] [068/133] (586s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[435.673562] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[435.677934] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[436.825863] [069/133] (585s left) gem_exec_schedule (u-submit-golden-slice)
[436.890492] Starting subtest: u-submit-golden-slice
[436.892385] Starting dynamic subtest: rcs0
[436.916877] Dynamic subtest rcs0: SUCCESS (0.033s)
[436.927399] Starting dynamic subtest: bcs0
[436.953216] Dynamic subtest bcs0: SUCCESS (0.036s)
[436.964804] Starting dynamic subtest: vcs0
[436.987962] Dynamic subtest vcs0: SUCCESS (0.034s)
[436.997183] Starting dynamic subtest: vcs1
[437.026024] Dynamic subtest vcs1: SUCCESS (0.037s)
[437.035784] Starting dynamic subtest: vecs0
[437.059129] Dynamic subtest vecs0: SUCCESS (0.032s)
[437.068922] Starting dynamic subtest: ccs0
[437.092294] Dynamic subtest ccs0: SUCCESS (0.032s)
[437.094485] Subtest u-submit-golden-slice: SUCCESS (0.209s)
[439.022554] [070/133] (583s left) kms_prime (basic-crc-hybrid)
[439.109593] Subtest basic-crc-hybrid: SKIP (0.000s)
[439.204754] [071/133] (583s left) kms_psr (pr-primary-mmap-gtt)
[439.296703] Starting subtest: pr-primary-mmap-gtt
[439.300935] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[439.383085] [072/133] (583s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[439.440415] Starting subtest: multi-wait-available-unsubmitted-signaled
[439.442337] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[439.540428] [073/133] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[439.640759] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[439.644981] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[439.733886] [074/133] (583s left) gem_exec_flush (basic-wb-ro-before-default)
[439.804543] Starting subtest: basic-wb-ro-before-default
[445.264199] Subtest basic-wb-ro-before-default: SUCCESS (5.460s)
[445.453453] [075/133] (577s left) gem_userptr_blits (dmabuf-unsync)
[445.527655] Subtest dmabuf-unsync: SKIP (0.000s)
[445.666626] [076/133] (577s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[445.782930] Starting subtest: verify-pxp-stale-buf-optout-execution
[446.848883] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.066s)
[446.981329] [077/133] (575s left) prime_self_import (basic-llseek-bad)
[447.014284] Starting subtest: basic-llseek-bad
[447.028440] Subtest basic-llseek-bad: SUCCESS (0.013s)
[447.118564] [078/133] (575s left) kms_plane_multiple (tiling-4)
[447.220056] Starting subtest: tiling-4
[447.222407] Starting dynamic subtest: pipe-A-eDP-1
[450.972093] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.752s)
[450.982151] Starting dynamic subtest: pipe-B-eDP-1
[455.425115] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.450s)
[455.434786] Starting dynamic subtest: pipe-C-eDP-1
[459.918547] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.494s)
[459.927555] Starting dynamic subtest: pipe-D-eDP-1
[464.270186] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.351s)
[464.272493] Subtest tiling-4: SUCCESS (17.052s)
[465.094144] [079/133] (557s left) kms_pipe_crc_basic (read-crc)
[465.187739] Starting subtest: read-crc
[465.189971] Starting dynamic subtest: pipe-A-eDP-1
[465.909353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[465.921075] Starting dynamic subtest: pipe-B-eDP-1
[467.265298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.355s)
[467.275629] Starting dynamic subtest: pipe-C-eDP-1
[468.641309] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[468.651364] Starting dynamic subtest: pipe-D-eDP-1
[469.981515] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[469.983879] Subtest read-crc: SUCCESS (4.794s)
[470.807751] [080/133] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[470.907413] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[478.299073] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.393s)
[478.437063] [081/133] (544s left) gem_exec_reloc (basic-wc-gtt)
[478.501126] Subtest basic-wc-gtt: SKIP (0.000s)
[478.584405] [082/133] (544s left) gem_ppgtt (shrink-vs-evict-pinned)
[478.650045] Starting subtest: shrink-vs-evict-pinned
[483.879989] Subtest shrink-vs-evict-pinned: SUCCESS (5.230s)
[483.967454] [083/133] (539s left) gem_exec_fence (basic-busy)
[484.150807] Starting subtest: basic-busy
[484.153711] Starting dynamic subtest: rcs0
[484.255997] Dynamic subtest rcs0: SUCCESS (0.105s)
[484.265839] Starting dynamic subtest: bcs0
[484.322144] Dynamic subtest bcs0: SUCCESS (0.064s)
[484.331599] Starting dynamic subtest: vcs0
[484.383196] Dynamic subtest vcs0: SUCCESS (0.059s)
[484.392676] Starting dynamic subtest: vcs1
[484.450285] Dynamic subtest vcs1: SUCCESS (0.065s)
[484.460230] Starting dynamic subtest: vecs0
[484.509385] Dynamic subtest vecs0: SUCCESS (0.057s)
[484.518967] Starting dynamic subtest: ccs0
[484.572079] Dynamic subtest ccs0: SUCCESS (0.061s)
[484.574514] Subtest basic-busy: SUCCESS (0.423s)
[485.995410] [084/133] (537s left) kms_invalid_mode (bad-vtotal)
[486.089972] Starting subtest: bad-vtotal
[486.092177] Starting dynamic subtest: pipe-A-eDP-1
[486.374316] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[486.383444] Starting dynamic subtest: pipe-B-eDP-1
[486.385322] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[486.393758] Starting dynamic subtest: pipe-C-eDP-1
[486.396075] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[486.405667] Starting dynamic subtest: pipe-D-eDP-1
[486.407585] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[486.409461] Subtest bad-vtotal: SUCCESS (0.292s)
[487.173943] [085/133] (536s left) kms_vblank (query-idle)
[487.277069] Starting subtest: query-idle
[487.278999] Starting dynamic subtest: pipe-A-eDP-1
[489.016923] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.741s)
[489.031914] Starting dynamic subtest: pipe-D-eDP-1
[491.417984] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.398s)
[491.420192] Subtest query-idle: SUCCESS (4.143s)
[492.240480] [086/133] (531s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[492.339845] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[492.342127] Starting dynamic subtest: pipe-A-eDP-1
[492.367624] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[492.379242] Starting dynamic subtest: pipe-B-eDP-1
[492.402977] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[492.411905] Starting dynamic subtest: pipe-C-eDP-1
[492.435581] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[492.444633] Starting dynamic subtest: pipe-D-eDP-1
[492.468742] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[492.473119] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[494.610013] [087/133] (528s left) sw_sync (sync_multi_consumer)
[494.648560] Starting subtest: sync_multi_consumer
[495.087466] Subtest sync_multi_consumer: SUCCESS (0.438s)
[495.149530] [088/133] (528s left) gem_exec_fence (long-history)
[495.559120] Starting subtest: long-history
[502.613506] Subtest long-history: SUCCESS (7.054s)
[503.083209] [089/133] (520s left) gem_eio (wait-10ms)
[503.350878] Starting subtest: wait-10ms
[503.772770] Subtest wait-10ms: SUCCESS (0.421s)
[503.939202] [090/133] (519s left) gem_exec_reloc (basic-cpu-read-active)
[504.004508] Subtest basic-cpu-read-active: SKIP (0.000s)
[504.089938] [091/133] (519s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[504.180495] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[504.184587] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[504.299204] [092/133] (519s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[504.366058] Starting subtest: invalid-single-wait-all-unsubmitted
[504.368689] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[504.481136] [093/133] (519s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[504.577300] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[504.580857] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[504.649232] [094/133] (518s left) api_intel_bb (crc32)
[504.699979] Starting subtest: crc32
[504.701849] Starting dynamic subtest: rcs0-smem0
[504.981060] Dynamic subtest rcs0-smem0: SUCCESS (0.279s)
[504.994118] Starting dynamic subtest: bcs0-smem0
[505.343232] Dynamic subtest bcs0-smem0: SUCCESS (0.359s)
[505.355682] Starting dynamic subtest: vcs0-smem0
[505.676064] Dynamic subtest vcs0-smem0: SUCCESS (0.331s)
[505.688782] Starting dynamic subtest: vcs1-smem0
[506.004674] Dynamic subtest vcs1-smem0: SUCCESS (0.324s)
[506.017135] Starting dynamic subtest: vecs0-smem0
[506.340895] Dynamic subtest vecs0-smem0: SUCCESS (0.313s)
[506.354428] Starting dynamic subtest: ccs0-smem0
[506.658642] Dynamic subtest ccs0-smem0: SUCCESS (0.337s)
[506.661557] Subtest crc32: SUCCESS (1.958s)
[506.785955] [095/133] (516s left) kms_psr (psr2-dpms)
[506.881848] Starting subtest: psr2-dpms
[506.884224] Starting dynamic subtest: eDP-1
[509.728994] Dynamic subtest eDP-1: SUCCESS (2.846s)
[509.731306] Subtest psr2-dpms: SUCCESS (2.847s)
[510.607994] [096/133] (513s left) kms_cursor_edge_walk (64x64-top-bottom)
[510.690454] Starting subtest: 64x64-top-bottom
[510.692588] Starting dynamic subtest: pipe-A-eDP-1
[514.190929] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[514.200778] Starting dynamic subtest: pipe-D-eDP-1
[517.317630] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[517.319814] Subtest 64x64-top-bottom: SUCCESS (6.628s)
[518.125081] [097/133] (505s left) syncobj_wait (wait-for-submit-delayed-submit)
[518.180313] Starting subtest: wait-for-submit-delayed-submit
[518.284075] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[518.359393] [098/133] (505s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[518.416918] Starting subtest: invalid-bsd1-flag-on-blt
[518.419708] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[518.532378] [099/133] (505s left) perf (whitelisted-registers-userspace-config)
[518.619586] Starting subtest: whitelisted-registers-userspace-config
[518.621968] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[518.663583] [100/133] (505s left) api_intel_bb (delta-check)
[518.712234] Starting subtest: delta-check
[518.720440] Subtest delta-check: SUCCESS (0.010s)
[518.854194] [101/133] (505s left) kms_flip (flip-vs-panning-vs-hang)
[518.943940] Starting subtest: flip-vs-panning-vs-hang
[518.946318] Starting dynamic subtest: A-eDP1
[570.367183] Dynamic subtest A-eDP1: SUCCESS (51.420s)
[570.379709] Starting dynamic subtest: D-eDP1
[620.415530] Dynamic subtest D-eDP1: SUCCESS (50.045s)
[620.420802] Subtest flip-vs-panning-vs-hang: SUCCESS (101.470s)
[621.624873] [102/133] (402s left) kms_rotation_crc (primary-rotation-270)
[621.730396] Starting subtest: primary-rotation-270
[621.734696] Subtest primary-rotation-270: SKIP (0.001s)
[621.817661] [103/133] (402s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[621.933325] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[622.602209] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[622.788109] [104/133] (401s left) kms_sequence (queue-busy)
[622.884714] Starting subtest: queue-busy
[622.886943] Starting dynamic subtest: pipe-A-eDP-1
[624.827681] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[624.837651] Starting dynamic subtest: pipe-B-eDP-1
[627.428351] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.600s)
[627.439321] Starting dynamic subtest: pipe-C-eDP-1
[630.020829] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.592s)
[630.039985] Starting dynamic subtest: pipe-D-eDP-1
[632.568299] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[632.570191] Subtest queue-busy: SUCCESS (9.683s)
[633.363915] [105/133] (390s left) i915_drm_fdinfo (virtual-busy-all)
[633.405631] Starting subtest: virtual-busy-all
[633.410137] Subtest virtual-busy-all: SKIP (0.000s)
[633.471432] [106/133] (390s left) gem_exec_whisper (basic-sync-all)
[633.524345] Starting subtest: basic-sync-all
[641.123170] Subtest basic-sync-all: SUCCESS (7.600s)
[641.314804] [107/133] (382s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[641.415655] Starting subtest: pr-cursor-plane-update-sf
[641.419868] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[641.487363] [108/133] (382s left) prime_vgem (sync)
[641.553833] Starting subtest: sync
[641.556196] Starting dynamic subtest: rcs0
[641.604699] Dynamic subtest rcs0: SUCCESS (0.051s)
[641.613909] Starting dynamic subtest: bcs0
[641.663085] Dynamic subtest bcs0: SUCCESS (0.057s)
[641.672577] Starting dynamic subtest: vcs0
[641.710513] Dynamic subtest vcs0: SUCCESS (0.047s)
[641.719888] Starting dynamic subtest: vcs1
[641.760393] Dynamic subtest vcs1: SUCCESS (0.049s)
[641.769840] Starting dynamic subtest: vecs0
[641.805056] Dynamic subtest vecs0: SUCCESS (0.043s)
[641.814522] Starting dynamic subtest: ccs0
[641.854619] Dynamic subtest ccs0: SUCCESS (0.049s)
[641.856816] Subtest sync: SUCCESS (0.301s)
[642.005986] [109/133] (382s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[642.095599] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[642.099703] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[642.197822] [110/133] (382s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[642.307463] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[642.311176] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[642.411885] [111/133] (381s left) gem_exec_schedule (preemptive-hang)
[642.583642] Starting subtest: preemptive-hang
[642.585755] Starting dynamic subtest: rcs0
[652.033588] Dynamic subtest rcs0: SUCCESS (9.453s)
[652.044802] Starting dynamic subtest: bcs0
[661.054614] Dynamic subtest bcs0: SUCCESS (9.018s)
[661.066898] Starting dynamic subtest: vcs0
[670.013771] Dynamic subtest vcs0: SUCCESS (8.957s)
[670.022978] Starting dynamic subtest: vcs1
[679.038618] Dynamic subtest vcs1: SUCCESS (9.023s)
[679.048759] Starting dynamic subtest: vecs0
[688.061191] Dynamic subtest vecs0: SUCCESS (9.023s)
[688.070383] Starting dynamic subtest: ccs0
[697.088706] Dynamic subtest ccs0: SUCCESS (9.024s)
[697.091528] Subtest preemptive-hang: SUCCESS (54.507s)
[697.382352] [112/133] (327s left) gem_exec_suspend (basic-s4-devices)
[697.451933] Starting subtest: basic-S4-devices
[697.454379] Starting dynamic subtest: smem
[708.885788] Dynamic subtest smem: SUCCESS (11.431s)
[708.889812] Subtest basic-S4-devices: SUCCESS (11.433s)
[714.087498] [113/133] (315s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[714.208039] Starting subtest: y-tiled-8bpp-rotate-90
[714.212616] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[714.330668] [114/133] (315s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[714.386079] Starting subtest: single-wait-all-for-submit-unsubmitted
[714.488447] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[714.579416] [115/133] (314s left) perf (gen12-mi-rpc)
[714.683536] Starting subtest: gen12-mi-rpc
[714.685970] Starting dynamic subtest: rcs0
[714.706457] Dynamic subtest rcs0: SUCCESS (0.020s)
[714.708413] Subtest gen12-mi-rpc: SUCCESS (0.022s)
[714.754304] [116/133] (314s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[714.869057] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[718.460697] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.595s)
[719.663142] [117/133] (309s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[721.195469] Starting subtest: dpms-mode-unset-non-lpsp
[722.365544] Subtest dpms-mode-unset-non-lpsp: SKIP (1.167s)
[722.741473] [118/133] (306s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[722.833094] Starting subtest: addfb25-yf-tiled-legacy
[722.835037] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[722.944441] [119/133] (306s left) kms_big_fb (x-tiled-addfb-size-overflow)
[723.048413] Starting subtest: x-tiled-addfb-size-overflow
[723.050656] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[723.142406] [120/133] (306s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[723.238795] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[723.243261] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[723.384345] [121/133] (306s left) kms_big_fb (linear-32bpp-rotate-90)
[723.485672] Starting subtest: linear-32bpp-rotate-90
[723.505387] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[723.608768] [122/133] (306s left) syncobj_wait (single-wait-all-submitted)
[723.670049] Starting subtest: single-wait-all-submitted
[723.776724] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[723.855998] [123/133] (306s left) gem_exec_balancer (full-late)
[723.925703] Starting subtest: full-late
[728.782040] Subtest full-late: SUCCESS (4.856s)
[729.111719] [124/133] (300s left) gem_mmap_gtt (ptrace)
[729.172053] Subtest ptrace: SKIP (0.000s)
[729.243494] [125/133] (300s left) i915_pm_rps (waitboost)
[729.319853] Starting subtest: waitboost
[735.667360] Subtest waitboost: SUCCESS (6.347s)
[735.762900] [126/133] (294s left) prime_vgem (basic-gtt)
[735.839126] Starting subtest: basic-gtt
[735.843808] Subtest basic-gtt: SKIP (0.000s)
[735.945933] [127/133] (294s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[736.044921] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[736.049489] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[736.146174] [128/133] (293s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[736.260783] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[742.773370] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.517s)
[742.906990] [129/133] (287s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[743.011525] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[749.987569] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.977s)
[750.127189] [130/133] (280s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[750.234933] Starting subtest: fbcpsr-slowdraw
[775.491327] Subtest fbcpsr-slowdraw: SUCCESS (25.259s)
[775.619529] [131/133] (254s left) kms_lease (lease-get)
[775.719597] Starting subtest: lease-get
[775.722031] Starting dynamic subtest: pipe-A-eDP-1
[775.724416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[775.737223] Starting dynamic subtest: pipe-B-eDP-1
[775.739055] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[775.749202] Starting dynamic subtest: pipe-C-eDP-1
[775.751065] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[775.760882] Starting dynamic subtest: pipe-D-eDP-1
[775.762728] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[775.764622] Subtest lease-get: SUCCESS (0.009s)
[775.831779] [132/133] (254s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[775.920798] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[775.925204] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[775.999497] [133/133] (254s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[776.087797] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[776.092190] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[776.159524] Closing watchdogs
results: parsing output: 0/ for test: kms_scaling_modes
results: parsing output: 1/ for test: gem_exec_gttfill
results: parsing output: 2/ for test: kms_atomic
results: parsing output: 3/ for test: gem_partial_pwrite_pread
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_pwrite_snooped
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: i915_pm_rps
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: sysfs_heartbeat_interval
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: gem_ccs
results: parsing output: 30/ for test: kms_chamelium_color
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_draw_crc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_set_tiling_vs_blt
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_busy
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: gem_vm_create
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: dumb_buffer
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_reg_read
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_properties
results: parsing output: 63/ for test: kms_dp_link_training
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_prime
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_flush
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: prime_self_import
results: parsing output: 77/ for test: kms_plane_multiple
results: parsing output: 78/ for test: kms_pipe_crc_basic
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: gem_ppgtt
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_invalid_mode
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: sw_sync
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: gem_eio
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_cursor_edge_walk
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_sequence
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: gem_exec_suspend
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: i915_pm_rps
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_lease
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_flip_scaled_crc
Done.