[57.386848] Initializing watchdogs
[57.386892]   /dev/watchdog0
[57.402439] [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]
[57.406919] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.409500] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.413273] [001/133] (960s left) kms_scaling_modes (scaling-mode-center)
[57.536044] Starting subtest: scaling-mode-center
[57.538433] Starting dynamic subtest: pipe-A-eDP-1
[57.653570] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.120s)
[57.663138] Starting dynamic subtest: pipe-B-eDP-1
[58.794440] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s)
[58.804081] Starting dynamic subtest: pipe-C-eDP-1
[59.913773] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[59.923686] Starting dynamic subtest: pipe-D-eDP-1
[61.028682] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[61.031070] Subtest scaling-mode-center: SUCCESS (3.526s)
[62.186191] [002/133] (955s left) gem_exec_gttfill (engines)
[62.251454] Starting subtest: engines
[62.253872] Starting dynamic subtest: rcs0
[84.940373] Dynamic subtest rcs0: SUCCESS (22.725s)
[84.954630] Starting dynamic subtest: bcs0
[108.216669] Dynamic subtest bcs0: SUCCESS (23.272s)
[108.224637] Starting dynamic subtest: vcs0
[131.477439] Dynamic subtest vcs0: SUCCESS (23.258s)
[131.486307] Starting dynamic subtest: vcs1
[154.756854] Dynamic subtest vcs1: SUCCESS (23.278s)
[154.766989] Starting dynamic subtest: vecs0
[178.088443] Dynamic subtest vecs0: SUCCESS (23.328s)
[178.097777] Starting dynamic subtest: ccs0
[201.401253] Dynamic subtest ccs0: SUCCESS (23.312s)
[201.403883] Subtest engines: SUCCESS (139.180s)
[201.588138] [003/133] (816s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[201.733776] Starting subtest: plane-primary-overlay-mutable-zpos
[205.188219] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.452s)
[206.370127] [004/133] (811s left) gem_partial_pwrite_pread (write-snoop)
[206.428528] Subtest write-snoop: SKIP (0.000s)
[206.504892] [005/133] (811s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[206.805526] Starting subtest: cursor-rapid-movement-512x170
[206.809720] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[206.961040] [006/133] (811s left) kms_plane_scaling (planes-upscale-20x20)
[207.048872] Starting subtest: planes-upscale-20x20
[207.051206] Starting dynamic subtest: pipe-A
[207.109212] Dynamic subtest pipe-A: SUCCESS (0.062s)
[207.120785] Starting dynamic subtest: pipe-B
[208.298614] Dynamic subtest pipe-B: SUCCESS (1.188s)
[208.309837] Starting dynamic subtest: pipe-C
[209.420282] Dynamic subtest pipe-C: SUCCESS (1.122s)
[209.430080] Starting dynamic subtest: pipe-D
[210.548947] Dynamic subtest pipe-D: SUCCESS (1.129s)
[210.551228] Subtest planes-upscale-20x20: SUCCESS (3.502s)
[211.692267] [007/133] (806s left) kms_cursor_crc (cursor-offscreen-32x32)
[211.827036] Starting subtest: cursor-offscreen-32x32
[211.874630] Subtest cursor-offscreen-32x32: SKIP (0.043s)
[212.162871] [008/133] (806s left) syncobj_wait (invalid-reset-illegal-handle)
[212.226592] Starting subtest: invalid-reset-illegal-handle
[212.229073] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[212.300058] [009/133] (805s left) gen9_exec_parse (basic-rejected)
[212.356678] Subtest basic-rejected: SKIP (0.000s)
[212.429704] [010/133] (805s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[212.490747] Starting subtest: single-wait-all-for-submit-available-submitted
[212.493053] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[212.591767] [011/133] (805s left) gem_pwrite_snooped
[212.714265] [012/133] (805s left) kms_color (ctm-0-25)
[212.813137] Starting subtest: ctm-0-25
[212.815149] Starting dynamic subtest: pipe-A-eDP-1
[216.325569] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.510s)
[216.334976] Starting dynamic subtest: pipe-B-eDP-1
[220.536648] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.210s)
[220.545941] Starting dynamic subtest: pipe-C-eDP-1
[224.553253] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.017s)
[224.562355] Starting dynamic subtest: pipe-D-eDP-1
[228.558284] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.004s)
[228.560625] Subtest ctm-0-25: SUCCESS (15.743s)
[229.381914] [013/133] (789s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[229.797368] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[230.587036] [014/133] (787s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[230.686016] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[230.688354] Starting dynamic subtest: pipe-A-eDP-1
[230.713064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.722212] Starting dynamic subtest: pipe-B-eDP-1
[230.745019] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.752497] Starting dynamic subtest: pipe-C-eDP-1
[230.775683] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.783651] Starting dynamic subtest: pipe-D-eDP-1
[230.807967] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.812073] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[232.972205] [015/133] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[233.076924] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[237.521575] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.448s)
[238.686762] [016/133] (779s left) gem_exec_schedule (promotion)
[238.764043] Starting subtest: promotion
[238.766127] Starting dynamic subtest: rcs0
[238.857965] Dynamic subtest rcs0: SUCCESS (0.102s)
[238.869930] Starting dynamic subtest: vcs0
[238.952312] Dynamic subtest vcs0: SUCCESS (0.094s)
[238.963560] Starting dynamic subtest: vcs1
[239.032864] Dynamic subtest vcs1: SUCCESS (0.079s)
[239.045011] Starting dynamic subtest: vecs0
[239.110803] Dynamic subtest vecs0: SUCCESS (0.078s)
[239.121333] Starting dynamic subtest: ccs0
[239.215697] Dynamic subtest ccs0: SUCCESS (0.104s)
[239.218187] Subtest promotion: SUCCESS (0.460s)
[241.006271] [017/133] (777s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[241.072627] Starting subtest: yf-tiled-to-vebox-y-tiled
[241.077527] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[241.273466] [018/133] (777s left) gem_mmap_gtt (big-copy-xy)
[241.332059] Subtest big-copy-XY: SKIP (0.000s)
[241.396750] [019/133] (777s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[241.460042] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[241.563303] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[241.639605] [020/133] (777s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[241.758649] Starting subtest: psr-rgb565-draw-pwrite
[249.047948] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.293s)
[249.148323] [021/133] (769s left) kms_flip (plain-flip-ts-check-interruptible)
[249.242369] Starting subtest: plain-flip-ts-check-interruptible
[249.244740] Starting dynamic subtest: A-eDP1
[258.129865] Dynamic subtest A-eDP1: SUCCESS (8.886s)
[258.138109] Starting dynamic subtest: B-eDP1
[266.962163] Dynamic subtest B-eDP1: SUCCESS (8.831s)
[266.975229] Starting dynamic subtest: C-eDP1
[275.784765] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[275.793287] Starting dynamic subtest: D-eDP1
[284.615525] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[284.620612] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.377s)
[285.796300] [022/133] (732s left) kms_flip (flip-vs-rmfb-interruptible)
[285.888186] Starting subtest: flip-vs-rmfb-interruptible
[285.890592] Starting dynamic subtest: A-eDP1
[294.492901] Dynamic subtest A-eDP1: SUCCESS (8.604s)
[294.502653] Starting dynamic subtest: B-eDP1
[303.134706] Dynamic subtest B-eDP1: SUCCESS (8.640s)
[303.144022] Starting dynamic subtest: C-eDP1
[311.752814] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[311.769039] Starting dynamic subtest: D-eDP1
[320.382508] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[320.387219] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.499s)
[321.567762] [023/133] (697s left) i915_pm_rps (reset)
[321.634040] Starting subtest: reset
[330.093802] Subtest reset: SUCCESS (8.459s)
[330.205387] [024/133] (688s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[330.304476] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[330.306753] Starting dynamic subtest: pipe-A-eDP-1
[330.326610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[330.335981] Starting dynamic subtest: pipe-B-eDP-1
[330.354816] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[330.362953] Starting dynamic subtest: pipe-C-eDP-1
[330.381566] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[330.393446] Starting dynamic subtest: pipe-D-eDP-1
[330.411852] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[330.413761] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[332.621326] [025/133] (686s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[332.679187] Starting subtest: basic-batch-kernel-default-cmd
[332.683527] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[332.873135] [026/133] (686s left) sysfs_heartbeat_interval (idempotent)
[332.942073] Starting subtest: idempotent
[332.944425] Starting dynamic subtest: vecs0
[332.946841] Dynamic subtest vecs0: SUCCESS (0.001s)
[332.960060] Starting dynamic subtest: ccs0
[332.961946] Dynamic subtest ccs0: SUCCESS (0.001s)
[332.969956] Starting dynamic subtest: vcs0
[332.971887] Dynamic subtest vcs0: SUCCESS (0.000s)
[332.979658] Starting dynamic subtest: bcs0
[332.981570] Dynamic subtest bcs0: SUCCESS (0.001s)
[332.989411] Starting dynamic subtest: rcs0
[332.991364] Dynamic subtest rcs0: SUCCESS (0.000s)
[332.999694] Starting dynamic subtest: vcs1
[333.001889] Dynamic subtest vcs1: SUCCESS (0.000s)
[333.004116] Subtest idempotent: SUCCESS (0.009s)
[333.058199] [027/133] (685s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[333.149444] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[340.090469] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.940s)
[340.223064] [028/133] (678s left) gem_mmap_gtt (close-race)
[340.291818] Subtest close-race: SKIP (0.000s)
[340.346171] [029/133] (678s left) perf (invalid-remove-userspace-config)
[340.482337] Starting subtest: invalid-remove-userspace-config
[340.490052] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[340.537361] [030/133] (678s left) gem_ccs (suspend-resume)
[340.590930] Starting subtest: suspend-resume
[340.595066] Subtest suspend-resume: SKIP (0.000s)
[340.683849] [031/133] (678s left) kms_chamelium_color (ctm-red-to-blue)
[340.776062] Subtest ctm-red-to-blue: SKIP (0.000s)
[340.823983] [032/133] (678s left) gem_mmap_gtt (big-bo-tiledy)
[340.885805] Subtest big-bo-tiledY: SKIP (0.000s)
[340.939232] [033/133] (678s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[341.034802] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[341.037103] Starting dynamic subtest: pipe-A-eDP-1
[346.887494] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.856s)
[346.897573] Starting dynamic subtest: pipe-B-eDP-1
[353.536622] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.646s)
[353.538759] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.505s)
[354.407639] [034/133] (664s left) kms_draw_crc (draw-method-blt)
[354.506229] Starting subtest: draw-method-blt
[354.508520] Starting dynamic subtest: xrgb8888-untiled
[354.760324] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[354.769452] Starting dynamic subtest: rgb565-untiled
[354.993929] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[355.003797] Starting dynamic subtest: xrgb2101010-untiled
[355.215705] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[355.227330] Starting dynamic subtest: xbgr16161616f-untiled
[355.426520] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.209s)
[355.434844] Starting dynamic subtest: xrgb8888-xtiled
[355.537714] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[355.546055] Starting dynamic subtest: rgb565-xtiled
[355.637570] Dynamic subtest rgb565-xtiled: SUCCESS (0.099s)
[355.646024] Starting dynamic subtest: xrgb2101010-xtiled
[355.748827] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[355.757085] Starting dynamic subtest: xbgr16161616f-xtiled
[355.859770] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[355.868054] Starting dynamic subtest: xrgb8888-4tiled
[355.982140] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[355.992631] Starting dynamic subtest: rgb565-4tiled
[356.105537] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[356.113541] Starting dynamic subtest: xrgb2101010-4tiled
[356.227298] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.120s)
[356.235631] Starting dynamic subtest: xbgr16161616f-4tiled
[356.337761] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[356.339686] Subtest draw-method-blt: SUCCESS (1.834s)
[356.440304] [035/133] (662s left) kms_psr (fbc-psr-no-drrs)
[356.544321] Starting subtest: fbc-psr-no-drrs
[356.546209] Starting dynamic subtest: eDP-1
[356.549679] Dynamic subtest eDP-1: SKIP (0.000s)
[356.553228] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[356.617170] [036/133] (662s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[356.687159] Subtest untiled-to-tiled: SKIP (0.000s)
[356.757910] [037/133] (662s left) gem_ctx_param (invalid-get-no-zeromap)
[356.821466] Starting subtest: invalid-get-no-zeromap
[356.823437] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[356.938672] [038/133] (662s left) i915_drm_fdinfo (virtual-busy-hang-all)
[356.979610] Starting subtest: virtual-busy-hang-all
[356.983310] Subtest virtual-busy-hang-all: SKIP (0.000s)
[357.057850] [039/133] (662s left) syncobj_timeline (invalid-signal-zero-handles)
[357.112847] Starting subtest: invalid-signal-zero-handles
[357.114825] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[357.226217] [040/133] (662s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[357.322425] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[357.324290] Starting dynamic subtest: A-eDP1
[360.938875] Dynamic subtest A-eDP1: SUCCESS (3.612s)
[360.948150] Starting dynamic subtest: B-eDP1
[364.151153] Dynamic subtest B-eDP1: SUCCESS (3.212s)
[364.160171] Starting dynamic subtest: C-eDP1
[367.279514] Dynamic subtest C-eDP1: SUCCESS (3.126s)
[367.289272] Starting dynamic subtest: D-eDP1
[370.401140] Dynamic subtest D-eDP1: SUCCESS (3.118s)
[370.403075] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.077s)
[371.198815] [041/133] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[371.315588] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[371.319800] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.404805] [042/133] (648s left) perf_pmu (most-busy-idle-check-all)
[371.448866] Starting subtest: most-busy-idle-check-all
[371.451132] Starting dynamic subtest: rcs0
[372.887366] Dynamic subtest rcs0: SUCCESS (1.437s)
[372.902518] Starting dynamic subtest: bcs0
[374.936061] Dynamic subtest bcs0: SUCCESS (2.043s)
[374.945741] Starting dynamic subtest: vcs0
[376.918777] Dynamic subtest vcs0: SUCCESS (1.981s)
[376.929708] Starting dynamic subtest: vcs1
[378.902955] Dynamic subtest vcs1: SUCCESS (1.981s)
[378.914491] Starting dynamic subtest: vecs0
[380.886582] Dynamic subtest vecs0: SUCCESS (1.981s)
[380.898532] Starting dynamic subtest: ccs0
[382.934669] Dynamic subtest ccs0: SUCCESS (2.045s)
[382.937719] Subtest most-busy-idle-check-all: SUCCESS (11.486s)
[383.044132] [043/133] (636s left) gem_eio (in-flight-contexts-10ms)
[383.248894] Starting subtest: in-flight-contexts-10ms
[396.898116] Subtest in-flight-contexts-10ms: SUCCESS (13.649s)
[397.016088] [044/133] (622s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[397.113816] Starting subtest: psr-rgb565-draw-mmap-cpu
[404.003269] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.893s)
[404.090332] [045/133] (615s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[404.193974] Starting subtest: fbc-farfromfence-mmap-gtt
[404.198182] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[404.300407] [046/133] (615s left) gem_busy (busy)
[404.382218] Starting subtest: busy
[404.384540] Starting dynamic subtest: all-engines
[404.420906] Dynamic subtest all-engines: SUCCESS (0.038s)
[404.435378] Starting dynamic subtest: rcs0
[405.854770] Dynamic subtest rcs0: SUCCESS (1.432s)
[405.865450] Starting dynamic subtest: bcs0
[405.905926] Dynamic subtest bcs0: SUCCESS (0.049s)
[405.917974] Starting dynamic subtest: vcs0
[405.946328] Dynamic subtest vcs0: SUCCESS (0.040s)
[405.955577] Starting dynamic subtest: vcs1
[407.899307] Dynamic subtest vcs1: SUCCESS (1.950s)
[407.909058] Starting dynamic subtest: vecs0
[409.884015] Dynamic subtest vecs0: SUCCESS (1.982s)
[409.894068] Starting dynamic subtest: ccs0
[411.931460] Dynamic subtest ccs0: SUCCESS (2.047s)
[411.933479] Subtest busy: SUCCESS (7.547s)
[412.286398] [047/133] (607s left) gem_spin_batch (legacy-resubmit)
[412.351223] Starting subtest: legacy-resubmit
[412.353634] Starting dynamic subtest: default
[412.361068] Dynamic subtest default: SUCCESS (0.010s)
[412.371062] Starting dynamic subtest: render
[412.372889] Dynamic subtest render: SUCCESS (0.002s)
[412.382035] Starting dynamic subtest: bsd
[412.384414] Dynamic subtest bsd: SUCCESS (0.003s)
[412.395770] Starting dynamic subtest: bsd1
[412.397653] Dynamic subtest bsd1: SUCCESS (0.003s)
[412.405948] Starting dynamic subtest: bsd2
[412.407835] Dynamic subtest bsd2: SUCCESS (0.001s)
[412.416183] Starting dynamic subtest: blt
[412.418048] Dynamic subtest blt: SUCCESS (0.004s)
[412.426395] Starting dynamic subtest: vebox
[412.428268] Dynamic subtest vebox: SUCCESS (0.004s)
[412.430095] Subtest legacy-resubmit: SUCCESS (0.035s)
[412.624712] [048/133] (607s left) gem_vm_create (invalid-destroy)
[412.695274] Starting subtest: invalid-destroy
[412.697480] Subtest invalid-destroy: SUCCESS (0.002s)
[412.790443] [049/133] (607s left) vgem_basic (setversion)
[412.887980] Starting subtest: setversion
[412.892312] Subtest setversion: SUCCESS (0.000s)
[412.945228] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[412.948634] [050/133] (606s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[413.042105] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[413.044450] Starting dynamic subtest: pipe-A-eDP-1
[413.053560] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.068753] Starting dynamic subtest: pipe-B-eDP-1
[413.077576] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[413.086872] Starting dynamic subtest: pipe-C-eDP-1
[413.095088] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[413.103606] Starting dynamic subtest: pipe-D-eDP-1
[413.111720] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[413.115779] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[415.195014] [051/133] (604s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[415.315446] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[415.319502] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[415.418199] [052/133] (604s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[415.562862] Starting subtest: dp-mst-lic-type-0-hdcp14
[415.567296] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[415.686971] [053/133] (604s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[415.785916] Starting subtest: fbc-psr2-cursor-mmap-cpu
[415.788125] Starting dynamic subtest: eDP-1
[415.792298] Dynamic subtest eDP-1: SKIP (0.000s)
[415.796493] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[415.861737] [054/133] (604s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[415.955963] Starting subtest: yf-tiled-addfb-size-offset-overflow
[415.960541] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[416.070965] [055/133] (603s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[416.173163] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[416.176546] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[416.272976] [056/133] (603s left) dumb_buffer (invalid-bpp)
[416.333759] Starting subtest: invalid-bpp
[416.335741] Subtest invalid-bpp: SUCCESS (0.000s)
[416.439934] [057/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[416.535955] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[416.539462] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[416.639418] [058/133] (603s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[416.695622] Starting subtest: etime-single-wait-all-available-unsubmitted
[416.802383] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s)
[416.880934] [059/133] (603s left) gem_reg_read (bad-register)
[416.941530] Starting subtest: bad-register
[416.943507] Subtest bad-register: SUCCESS (0.000s)
[417.043876] [060/133] (603s left) gem_ctx_persistence (legacy-engines-cleanup)
[417.105646] Starting subtest: legacy-engines-cleanup
[417.108164] Starting dynamic subtest: render
[417.162528] Dynamic subtest render: SUCCESS (0.057s)
[417.173617] Starting dynamic subtest: bsd1
[417.227474] Dynamic subtest bsd1: SUCCESS (0.064s)
[417.241065] Starting dynamic subtest: bsd2
[417.264304] Dynamic subtest bsd2: SUCCESS (0.034s)
[417.273591] Starting dynamic subtest: blt
[417.309445] Dynamic subtest blt: SUCCESS (0.043s)
[417.322027] Starting dynamic subtest: vebox
[417.354445] Dynamic subtest vebox: SUCCESS (0.042s)
[417.356686] Subtest legacy-engines-cleanup: SUCCESS (0.251s)
[417.435789] [061/133] (602s left) gem_ctx_shared (q-in-order)
[417.506705] Starting subtest: Q-in-order
[417.509070] Starting dynamic subtest: rcs0
[417.606290] Dynamic subtest rcs0: SUCCESS (0.102s)
[417.622647] Starting dynamic subtest: vcs0
[417.688361] Dynamic subtest vcs0: SUCCESS (0.081s)
[417.704574] Starting dynamic subtest: vcs1
[417.763696] Dynamic subtest vcs1: SUCCESS (0.074s)
[417.781364] Starting dynamic subtest: vecs0
[417.841730] Dynamic subtest vecs0: SUCCESS (0.077s)
[417.857799] Starting dynamic subtest: ccs0
[417.927914] Dynamic subtest ccs0: SUCCESS (0.086s)
[417.930324] Subtest Q-in-order: SUCCESS (0.425s)
[419.000577] [062/133] (601s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[419.096670] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[419.101084] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[419.199367] [063/133] (601s left) kms_properties (connector-properties-legacy)
[419.304155] Starting subtest: connector-properties-legacy
[419.306582] Starting dynamic subtest: pipe-A-eDP-1
[427.112078] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.806s)
[427.123691] Starting dynamic subtest: pipe-None-DP-1
[427.128212] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[427.136963] Starting dynamic subtest: pipe-None-HDMI-A-1
[427.141351] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[427.150015] Starting dynamic subtest: pipe-None-DP-2
[427.154197] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[427.162444] Starting dynamic subtest: pipe-None-HDMI-A-2
[427.166590] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[427.174939] Starting dynamic subtest: pipe-None-DP-3
[427.179225] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[427.191071] Starting dynamic subtest: pipe-None-DP-4
[427.195892] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[427.198043] Subtest connector-properties-legacy: SUCCESS (7.821s)
[427.976740] [064/133] (592s left) kms_dp_link_training (non-uhbr-sst)
[428.066948] Starting subtest: non-uhbr-sst
[428.075082] Subtest non-uhbr-sst: SKIP (0.000s)
[428.138592] [065/133] (592s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[428.237113] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[428.241072] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[428.304493] [066/133] (592s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[428.392225] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[428.394090] Starting dynamic subtest: pipe-A
[428.740446] Dynamic subtest pipe-A: SUCCESS (0.350s)
[428.749880] Starting dynamic subtest: pipe-B
[430.197891] Dynamic subtest pipe-B: SUCCESS (1.456s)
[430.207227] Starting dynamic subtest: pipe-C
[431.637915] Dynamic subtest pipe-C: SUCCESS (1.439s)
[431.648970] Starting dynamic subtest: pipe-D
[433.065985] Dynamic subtest pipe-D: SUCCESS (1.427s)
[433.068383] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.677s)
[434.242467] [067/133] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[434.337584] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[434.341630] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[434.436202] [068/133] (586s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[434.525973] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[434.530221] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[435.665067] [069/133] (584s left) gem_exec_schedule (u-submit-golden-slice)
[435.745158] Starting subtest: u-submit-golden-slice
[435.747592] Starting dynamic subtest: rcs0
[435.773435] Dynamic subtest rcs0: SUCCESS (0.036s)
[435.783116] Starting dynamic subtest: bcs0
[435.814105] Dynamic subtest bcs0: SUCCESS (0.040s)
[435.824163] Starting dynamic subtest: vcs0
[435.850015] Dynamic subtest vcs0: SUCCESS (0.035s)
[435.859099] Starting dynamic subtest: vcs1
[435.887353] Dynamic subtest vcs1: SUCCESS (0.037s)
[435.896428] Starting dynamic subtest: vecs0
[435.918316] Dynamic subtest vecs0: SUCCESS (0.030s)
[435.927740] Starting dynamic subtest: ccs0
[435.959678] Dynamic subtest ccs0: SUCCESS (0.040s)
[435.961917] Subtest u-submit-golden-slice: SUCCESS (0.223s)
[436.972640] [070/133] (583s left) kms_prime (basic-crc-hybrid)
[437.061746] Subtest basic-crc-hybrid: SKIP (0.000s)
[437.169020] [071/133] (583s left) kms_psr (pr-primary-mmap-gtt)
[437.274164] Starting subtest: pr-primary-mmap-gtt
[437.278353] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[437.350650] [072/133] (583s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[437.400545] Starting subtest: multi-wait-available-unsubmitted-signaled
[437.402670] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[437.507434] [073/133] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[437.609429] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[437.613547] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[437.712954] [074/133] (583s left) gem_exec_flush (basic-wb-ro-before-default)
[437.785051] Starting subtest: basic-wb-ro-before-default
[443.248080] Subtest basic-wb-ro-before-default: SUCCESS (5.466s)
[443.434788] [075/133] (577s left) gem_userptr_blits (dmabuf-unsync)
[443.499433] Subtest dmabuf-unsync: SKIP (0.000s)
[443.612920] [076/133] (577s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[443.736869] Starting subtest: verify-pxp-stale-buf-optout-execution
[444.800903] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.066s)
[444.909467] [077/133] (576s left) prime_self_import (basic-llseek-bad)
[444.948915] Starting subtest: basic-llseek-bad
[444.961686] Subtest basic-llseek-bad: SUCCESS (0.013s)
[445.051246] [078/133] (575s left) kms_plane_multiple (tiling-4)
[445.144763] Starting subtest: tiling-4
[445.146894] Starting dynamic subtest: pipe-A-eDP-1
[448.956587] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.812s)
[448.966254] Starting dynamic subtest: pipe-B-eDP-1
[453.359121] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.400s)
[453.375840] Starting dynamic subtest: pipe-C-eDP-1
[457.704838] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.342s)
[457.715532] Starting dynamic subtest: pipe-D-eDP-1
[462.014250] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.308s)
[462.016107] Subtest tiling-4: SUCCESS (16.868s)
[462.828365] [079/133] (558s left) kms_pipe_crc_basic (read-crc)
[462.934223] Starting subtest: read-crc
[462.936640] Starting dynamic subtest: pipe-A-eDP-1
[463.648342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[463.658646] Starting dynamic subtest: pipe-B-eDP-1
[465.002215] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.354s)
[465.014727] Starting dynamic subtest: pipe-C-eDP-1
[466.303531] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.299s)
[466.316291] Starting dynamic subtest: pipe-D-eDP-1
[467.642450] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[467.644711] Subtest read-crc: SUCCESS (4.708s)
[468.475075] [080/133] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[468.572688] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[475.997724] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.425s)
[476.157921] [081/133] (545s left) gem_exec_reloc (basic-wc-gtt)
[476.226847] Subtest basic-wc-gtt: SKIP (0.000s)
[476.296140] [082/133] (544s left) gem_ppgtt (shrink-vs-evict-pinned)
[476.359289] Starting subtest: shrink-vs-evict-pinned
[481.904317] Subtest shrink-vs-evict-pinned: SUCCESS (5.543s)
[482.007776] [083/133] (539s left) gem_exec_fence (basic-busy)
[482.198602] Starting subtest: basic-busy
[482.200804] Starting dynamic subtest: rcs0
[482.289904] Dynamic subtest rcs0: SUCCESS (0.093s)
[482.301584] Starting dynamic subtest: bcs0
[482.351794] Dynamic subtest bcs0: SUCCESS (0.060s)
[482.363189] Starting dynamic subtest: vcs0
[482.416403] Dynamic subtest vcs0: SUCCESS (0.062s)
[482.431279] Starting dynamic subtest: vcs1
[482.475906] Dynamic subtest vcs1: SUCCESS (0.058s)
[482.487551] Starting dynamic subtest: vecs0
[482.534447] Dynamic subtest vecs0: SUCCESS (0.056s)
[482.547675] Starting dynamic subtest: ccs0
[482.603156] Dynamic subtest ccs0: SUCCESS (0.066s)
[482.605704] Subtest basic-busy: SUCCESS (0.408s)
[484.005627] [084/133] (537s left) kms_invalid_mode (bad-vtotal)
[484.102086] Starting subtest: bad-vtotal
[484.104383] Starting dynamic subtest: pipe-A-eDP-1
[484.385111] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[484.398777] Starting dynamic subtest: pipe-B-eDP-1
[484.401654] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[484.422331] Starting dynamic subtest: pipe-C-eDP-1
[484.425014] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[484.443859] Starting dynamic subtest: pipe-D-eDP-1
[484.446029] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[484.448104] Subtest bad-vtotal: SUCCESS (0.292s)
[485.255156] [085/133] (536s left) kms_vblank (query-idle)
[485.354397] Starting subtest: query-idle
[485.356349] Starting dynamic subtest: pipe-A-eDP-1
[487.109162] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s)
[487.123995] Starting dynamic subtest: pipe-D-eDP-1
[489.576434] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.464s)
[489.578867] Subtest query-idle: SUCCESS (4.224s)
[490.408598] [086/133] (531s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[490.511816] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[490.514566] Starting dynamic subtest: pipe-A-eDP-1
[490.540734] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[490.550987] Starting dynamic subtest: pipe-B-eDP-1
[490.575214] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[490.584409] Starting dynamic subtest: pipe-C-eDP-1
[490.608442] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[490.617521] Starting dynamic subtest: pipe-D-eDP-1
[490.641809] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[490.645986] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[492.757779] [087/133] (528s left) sw_sync (sync_multi_consumer)
[492.799951] Starting subtest: sync_multi_consumer
[493.231891] Subtest sync_multi_consumer: SUCCESS (0.433s)
[493.295474] [088/133] (528s left) gem_exec_fence (long-history)
[493.701257] Starting subtest: long-history
[500.654341] Subtest long-history: SUCCESS (6.954s)
[501.120365] [089/133] (520s left) gem_eio (wait-10ms)
[501.379952] Starting subtest: wait-10ms
[501.820425] Subtest wait-10ms: SUCCESS (0.441s)
[501.970437] [090/133] (519s left) gem_exec_reloc (basic-cpu-read-active)
[502.026893] Subtest basic-cpu-read-active: SKIP (0.000s)
[502.105967] [091/133] (519s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[502.199059] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[502.203571] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[502.304429] [092/133] (519s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[502.368564] Starting subtest: invalid-single-wait-all-unsubmitted
[502.370826] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[502.461862] [093/133] (519s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[502.552128] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[502.555844] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[502.624418] [094/133] (519s left) api_intel_bb (crc32)
[502.689217] Starting subtest: crc32
[502.691102] Starting dynamic subtest: rcs0-smem0
[502.994670] Dynamic subtest rcs0-smem0: SUCCESS (0.306s)
[503.006106] Starting dynamic subtest: bcs0-smem0
[503.337699] Dynamic subtest bcs0-smem0: SUCCESS (0.340s)
[503.350350] Starting dynamic subtest: vcs0-smem0
[503.703058] Dynamic subtest vcs0-smem0: SUCCESS (0.364s)
[503.716111] Starting dynamic subtest: vcs1-smem0
[504.052481] Dynamic subtest vcs1-smem0: SUCCESS (0.345s)
[504.065072] Starting dynamic subtest: vecs0-smem0
[504.425519] Dynamic subtest vecs0-smem0: SUCCESS (0.370s)
[504.435825] Starting dynamic subtest: ccs0-smem0
[504.801979] Dynamic subtest ccs0-smem0: SUCCESS (0.374s)
[504.804612] Subtest crc32: SUCCESS (2.115s)
[504.920179] [095/133] (516s left) kms_psr (psr2-dpms)
[505.013150] Starting subtest: psr2-dpms
[505.015348] Starting dynamic subtest: eDP-1
[507.883415] Dynamic subtest eDP-1: SUCCESS (2.871s)
[507.885761] Subtest psr2-dpms: SUCCESS (2.872s)
[508.767396] [096/133] (513s left) kms_cursor_edge_walk (64x64-top-bottom)
[508.864065] Starting subtest: 64x64-top-bottom
[508.866407] Starting dynamic subtest: pipe-A-eDP-1
[512.334254] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[512.344212] Starting dynamic subtest: pipe-D-eDP-1
[515.467375] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[515.469734] Subtest 64x64-top-bottom: SUCCESS (6.604s)
[516.269109] [097/133] (505s left) syncobj_wait (wait-for-submit-delayed-submit)
[516.326964] Starting subtest: wait-for-submit-delayed-submit
[516.432353] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[516.512657] [098/133] (505s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[516.565508] Starting subtest: invalid-bsd1-flag-on-blt
[516.567919] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[516.668850] [099/133] (505s left) perf (whitelisted-registers-userspace-config)
[516.766604] Starting subtest: whitelisted-registers-userspace-config
[516.769058] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[516.810930] [100/133] (505s left) api_intel_bb (delta-check)
[516.868566] Starting subtest: delta-check
[516.871977] Subtest delta-check: SUCCESS (0.006s)
[516.999068] [101/133] (505s left) kms_flip (flip-vs-panning-vs-hang)
[517.095833] Starting subtest: flip-vs-panning-vs-hang
[517.098082] Starting dynamic subtest: A-eDP1
[568.384236] Dynamic subtest A-eDP1: SUCCESS (51.286s)
[568.396607] Starting dynamic subtest: D-eDP1
[608.390519] Dynamic subtest D-eDP1: SUCCESS (40.000s)
[608.392782] Subtest flip-vs-panning-vs-hang: SUCCESS (91.293s)
[609.563738] [102/133] (412s left) kms_rotation_crc (primary-rotation-270)
[609.665256] Starting subtest: primary-rotation-270
[609.669569] Subtest primary-rotation-270: SKIP (0.001s)
[609.750170] [103/133] (412s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[609.854331] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[610.512176] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[610.679769] [104/133] (411s left) kms_sequence (queue-busy)
[610.784155] Starting subtest: queue-busy
[610.786470] Starting dynamic subtest: pipe-A-eDP-1
[612.722357] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[612.732177] Starting dynamic subtest: pipe-B-eDP-1
[615.365062] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.642s)
[615.383429] Starting dynamic subtest: pipe-C-eDP-1
[617.973658] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s)
[617.984152] Starting dynamic subtest: pipe-D-eDP-1
[620.597187] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[620.599489] Subtest queue-busy: SUCCESS (9.814s)
[621.395939] [105/133] (400s left) i915_drm_fdinfo (virtual-busy-all)
[621.444474] Starting subtest: virtual-busy-all
[621.449404] Subtest virtual-busy-all: SKIP (0.000s)
[621.509692] [106/133] (400s left) gem_exec_whisper (basic-sync-all)
[621.564946] Starting subtest: basic-sync-all
[629.078197] Subtest basic-sync-all: SUCCESS (7.512s)
[629.267576] [107/133] (393s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[629.371625] Starting subtest: pr-cursor-plane-update-sf
[629.375827] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[629.442059] [108/133] (392s left) prime_vgem (sync)
[629.520597] Starting subtest: sync
[629.522756] Starting dynamic subtest: rcs0
[629.566398] Dynamic subtest rcs0: SUCCESS (0.047s)
[629.576447] Starting dynamic subtest: bcs0
[629.635134] Dynamic subtest bcs0: SUCCESS (0.068s)
[629.645843] Starting dynamic subtest: vcs0
[629.683354] Dynamic subtest vcs0: SUCCESS (0.048s)
[629.693696] Starting dynamic subtest: vcs1
[629.730278] Dynamic subtest vcs1: SUCCESS (0.046s)
[629.739926] Starting dynamic subtest: vecs0
[629.777032] Dynamic subtest vecs0: SUCCESS (0.046s)
[629.786363] Starting dynamic subtest: ccs0
[629.825493] Dynamic subtest ccs0: SUCCESS (0.048s)
[629.827732] Subtest sync: SUCCESS (0.307s)
[629.955139] [109/133] (392s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[630.053488] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[630.057639] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[630.152535] [110/133] (392s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[630.261295] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[630.264918] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[630.343882] [111/133] (392s left) gem_exec_schedule (preemptive-hang)
[630.516040] Starting subtest: preemptive-hang
[630.518425] Starting dynamic subtest: rcs0
[640.001788] Dynamic subtest rcs0: SUCCESS (9.489s)
[640.013376] Starting dynamic subtest: bcs0
[649.021967] Dynamic subtest bcs0: SUCCESS (9.017s)
[649.033834] Starting dynamic subtest: vcs0
[658.046692] Dynamic subtest vcs0: SUCCESS (9.023s)
[658.061705] Starting dynamic subtest: vcs1
[667.006096] Dynamic subtest vcs1: SUCCESS (8.956s)
[667.016909] Starting dynamic subtest: vecs0
[676.028881] Dynamic subtest vecs0: SUCCESS (9.022s)
[676.038381] Starting dynamic subtest: ccs0
[685.062598] Dynamic subtest ccs0: SUCCESS (9.031s)
[685.065032] Subtest preemptive-hang: SUCCESS (54.550s)
[685.316434] [112/133] (337s left) gem_exec_suspend (basic-s4-devices)
[685.379518] Starting subtest: basic-S4-devices
[685.381656] Starting dynamic subtest: smem
[696.919863] Dynamic subtest smem: SUCCESS (11.540s)
[696.923729] Subtest basic-S4-devices: SUCCESS (11.542s)
[705.136256] [113/133] (325s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[705.261103] Starting subtest: y-tiled-8bpp-rotate-90
[705.265806] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[705.357507] [114/133] (325s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[705.413388] Starting subtest: single-wait-all-for-submit-unsubmitted
[705.513831] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[705.641616] [115/133] (325s left) perf (gen12-mi-rpc)
[705.752812] Starting subtest: gen12-mi-rpc
[705.755263] Starting dynamic subtest: rcs0
[705.773766] Dynamic subtest rcs0: SUCCESS (0.021s)
[705.776120] Subtest gen12-mi-rpc: SUCCESS (0.022s)
[705.826052] [116/133] (324s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[705.946102] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[709.460697] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.518s)
[710.607569] [117/133] (320s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[712.137083] Starting subtest: dpms-mode-unset-non-lpsp
[713.282798] Subtest dpms-mode-unset-non-lpsp: SKIP (1.146s)
[713.679962] [118/133] (317s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[713.768681] Starting subtest: addfb25-yf-tiled-legacy
[713.771071] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[713.885504] [119/133] (317s left) kms_big_fb (x-tiled-addfb-size-overflow)
[713.982221] Starting subtest: x-tiled-addfb-size-overflow
[713.984655] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[714.080968] [120/133] (316s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[714.189761] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[714.194289] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[714.290740] [121/133] (316s left) kms_big_fb (linear-32bpp-rotate-90)
[714.388883] Starting subtest: linear-32bpp-rotate-90
[714.408530] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[714.527529] [122/133] (316s left) syncobj_wait (single-wait-all-submitted)
[714.588043] Starting subtest: single-wait-all-submitted
[714.689583] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[714.769791] [123/133] (316s left) gem_exec_balancer (full-late)
[714.832631] Starting subtest: full-late
[719.817937] Subtest full-late: SUCCESS (4.984s)
[720.150276] [124/133] (310s left) gem_mmap_gtt (ptrace)
[720.207516] Subtest ptrace: SKIP (0.000s)
[720.273469] [125/133] (310s left) i915_pm_rps (waitboost)
[720.337668] Starting subtest: waitboost
[726.669488] Subtest waitboost: SUCCESS (6.329s)
[726.762607] [126/133] (304s left) prime_vgem (basic-gtt)
[726.833669] Starting subtest: basic-gtt
[726.838673] Subtest basic-gtt: SKIP (0.000s)
[726.944585] [127/133] (304s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[727.044307] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[727.048553] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[727.137804] [128/133] (304s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[727.241777] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[733.829954] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.591s)
[733.961255] [129/133] (297s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[734.071260] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[741.020609] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.952s)
[741.162564] [130/133] (290s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[741.258746] Starting subtest: fbcpsr-slowdraw
[766.474405] Subtest fbcpsr-slowdraw: SUCCESS (25.219s)
[766.622549] [131/133] (264s left) kms_lease (lease-get)
[766.722390] Starting subtest: lease-get
[766.724772] Starting dynamic subtest: pipe-A-eDP-1
[766.727125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[766.738590] Starting dynamic subtest: pipe-B-eDP-1
[766.740455] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[766.750461] Starting dynamic subtest: pipe-C-eDP-1
[766.752313] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[766.762094] Starting dynamic subtest: pipe-D-eDP-1
[766.763949] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[766.766122] Subtest lease-get: SUCCESS (0.009s)
[766.844325] [132/133] (264s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[766.936081] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[766.940237] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[767.012488] [133/133] (264s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[767.108764] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[767.112671] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[767.193615] 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.