[57.727327] Initializing watchdogs
[57.727376]   /dev/watchdog0
[57.741957] [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.746475] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.748958] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.752555] [001/133] (960s left) vgem_basic (second-client)
[57.850550] Starting subtest: second-client
[57.871962] Subtest second-client: SUCCESS (0.021s)
[57.936626] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[57.939919] [002/133] (960s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[58.110883] Starting subtest: cursorA-vs-flipB-atomic-transitions
[58.115473] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[58.255837] [003/133] (960s left) syncobj_timeline (multi-wait-available-submitted)
[58.318033] Starting subtest: multi-wait-available-submitted
[58.320447] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[58.429452] [004/133] (959s left) kms_invalid_mode (bad-vsync-end)
[58.517068] Starting subtest: bad-vsync-end
[58.519419] Starting dynamic subtest: pipe-A-eDP-1
[58.807515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[58.816190] Starting dynamic subtest: pipe-B-eDP-1
[58.818498] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[58.827737] Starting dynamic subtest: pipe-C-eDP-1
[58.830083] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[58.838995] Starting dynamic subtest: pipe-D-eDP-1
[58.841488] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[58.843854] Subtest bad-vsync-end: SUCCESS (0.297s)
[59.693079] [005/133] (958s left) kms_pm_backlight (fade-with-dpms)
[59.797818] Starting subtest: fade-with-dpms
[61.987059] Starting dynamic subtest: eDP-1
[64.487254] Dynamic subtest eDP-1: SUCCESS (2.488s)
[64.489781] Subtest fade-with-dpms: SUCCESS (4.670s)
[65.290794] [006/133] (953s left) kms_flip (bo-too-big-interruptible)
[65.381772] Starting subtest: bo-too-big-interruptible
[65.384061] Starting dynamic subtest: A-eDP1
[66.638501] Dynamic subtest A-eDP1: SUCCESS (1.253s)
[66.646459] Starting dynamic subtest: B-eDP1
[67.895602] Dynamic subtest B-eDP1: SUCCESS (1.253s)
[67.905404] Starting dynamic subtest: C-eDP1
[69.145863] Dynamic subtest C-eDP1: SUCCESS (1.247s)
[69.158693] Starting dynamic subtest: D-eDP1
[70.462075] Dynamic subtest D-eDP1: SUCCESS (1.313s)
[70.464531] Subtest bo-too-big-interruptible: SUCCESS (5.074s)
[71.674080] [007/133] (946s left) gem_mmap_gtt (basic-read)
[71.744433] Subtest basic-read: SKIP (0.000s)
[71.813852] [008/133] (946s left) gem_softpin (allocator-evict)
[71.871752] Starting subtest: allocator-evict
[71.873949] Starting dynamic subtest: rcs0
[94.841348] Dynamic subtest rcs0: SUCCESS (22.957s)
[94.851150] Starting dynamic subtest: bcs0
[118.831121] Dynamic subtest bcs0: SUCCESS (23.984s)
[118.841422] Starting dynamic subtest: vcs0
[142.486252] Dynamic subtest vcs0: SUCCESS (23.652s)
[142.496387] Starting dynamic subtest: vcs1
[166.159506] Dynamic subtest vcs1: SUCCESS (23.672s)
[166.170382] Starting dynamic subtest: vecs0
[189.993840] Dynamic subtest vecs0: SUCCESS (23.831s)
[190.002126] Starting dynamic subtest: ccs0
[213.491650] Dynamic subtest ccs0: SUCCESS (23.498s)
[213.493783] Subtest allocator-evict: SUCCESS (141.599s)
[213.569853] [009/133] (804s left) gem_render_linear_blits (basic)
[213.675255] Starting subtest: basic
[213.702903] Subtest basic: SUCCESS (0.030s)
[213.790434] [010/133] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[213.891833] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[213.896219] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[214.002445] [011/133] (804s left) kms_psr (psr-primary-mmap-cpu)
[214.088759] Starting subtest: psr-primary-mmap-cpu
[214.091134] Starting dynamic subtest: eDP-1
[215.875477] Dynamic subtest eDP-1: SUCCESS (1.787s)
[215.877727] Subtest psr-primary-mmap-cpu: SUCCESS (1.788s)
[216.740302] [012/133] (801s left) kms_chamelium_edid (hdmi-mode-timings)
[217.128076] Subtest hdmi-mode-timings: SKIP (0.000s)
[217.958922] [013/133] (800s left) gen7_exec_parse (load-register-reg)
[218.023113] Subtest load-register-reg: SKIP (0.000s)
[218.075287] [014/133] (800s left) syncobj_eventfd (invalid-bad-flags)
[218.138894] Starting subtest: invalid-bad-flags
[218.141339] Subtest invalid-bad-flags: SUCCESS (0.000s)
[218.232435] [015/133] (800s left) gem_ctx_exec (basic-invalid-context)
[218.283580] Starting subtest: basic-invalid-context
[218.285967] Subtest basic-invalid-context: SUCCESS (0.004s)
[218.394415] [016/133] (800s left) gem_exec_reloc (basic-write-read-active)
[218.445638] Subtest basic-write-read-active: SKIP (0.000s)
[218.507672] [017/133] (800s left) kms_vblank (wait-busy-hang)
[218.597292] Starting subtest: wait-busy-hang
[218.599624] Starting dynamic subtest: pipe-A-eDP-1
[244.693452] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.093s)
[244.707976] Starting dynamic subtest: pipe-D-eDP-1
[259.679357] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.982s)
[259.681704] Subtest wait-busy-hang: SUCCESS (41.079s)
[260.538532] [018/133] (758s left) kms_chamelium_color (ctm-0-50)
[260.625304] Subtest ctm-0-50: SKIP (0.000s)
[260.674633] [019/133] (758s left) gem_exec_flush (basic-uc-prw-default)
[260.734188] Starting subtest: basic-uc-prw-default
[266.195039] Subtest basic-uc-prw-default: SUCCESS (5.461s)
[266.391179] [020/133] (752s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[266.487408] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[273.054710] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.570s)
[273.179770] [021/133] (745s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[273.273888] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[273.278081] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[273.357944] [022/133] (745s left) kms_plane_scaling (planes-upscale-factor-0-25)
[273.453596] Starting subtest: planes-upscale-factor-0-25
[273.455928] Starting dynamic subtest: pipe-A
[273.515836] Dynamic subtest pipe-A: SUCCESS (0.064s)
[273.526030] Starting dynamic subtest: pipe-B
[274.612895] Dynamic subtest pipe-B: SUCCESS (1.097s)
[274.622983] Starting dynamic subtest: pipe-C
[275.718756] Dynamic subtest pipe-C: SUCCESS (1.105s)
[275.726802] Starting dynamic subtest: pipe-D
[276.860574] Dynamic subtest pipe-D: SUCCESS (1.141s)
[276.862804] Subtest planes-upscale-factor-0-25: SUCCESS (3.409s)
[278.015652] [023/133] (741s left) i915_selftest (perf)
[279.717198] Starting subtest: perf
[279.720470] Starting dynamic subtest: engine_cs
[284.135419] Dynamic subtest engine_cs: SUCCESS (4.417s)
[284.143730] Starting dynamic subtest: request
[291.409586] Dynamic subtest request: SUCCESS (7.272s)
[291.418971] Starting dynamic subtest: migrate
[295.737953] Dynamic subtest migrate: SUCCESS (4.327s)
[295.746894] Starting dynamic subtest: region
[301.963065] Dynamic subtest region: SUCCESS (6.224s)
[301.966059] Subtest perf: SUCCESS (22.245s)
[301.996478] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[301.997206] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[302.000246] [024/133] (717s left) kms_color (legacy-gamma)
[303.580908] Starting subtest: legacy-gamma
[303.582815] Starting dynamic subtest: pipe-A-eDP-1
[304.362789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s)
[304.372188] Starting dynamic subtest: pipe-B-eDP-1
[305.833468] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s)
[305.849717] Starting dynamic subtest: pipe-C-eDP-1
[307.202926] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[307.211433] Starting dynamic subtest: pipe-D-eDP-1
[308.533388] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[308.535799] Subtest legacy-gamma: SUCCESS (4.952s)
[309.378247] [FACT kms_color (legacy-gamma)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[309.379565] [FACT kms_color (legacy-gamma)] new: kernel.kmod_is_loaded.i915: true
[309.383800] [025/133] (709s left) perf (gen12-mi-rpc)
[309.533323] Starting subtest: gen12-mi-rpc
[309.535572] Starting dynamic subtest: rcs0
[309.553138] Dynamic subtest rcs0: SUCCESS (0.018s)
[309.555295] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[309.601282] [026/133] (709s left) syncobj_timeline (invalid-wait-bad-flags)
[309.686205] Starting subtest: invalid-wait-bad-flags
[309.688751] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[309.797021] [027/133] (709s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[309.911581] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[309.915986] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[310.055409] [028/133] (709s left) gem_eio (kms)
[310.244318] Starting subtest: kms
[326.825864] Subtest kms: SUCCESS (16.579s)
[328.226504] [029/133] (691s left) gem_exec_fence (long-history)
[328.646775] Starting subtest: long-history
[335.692593] Subtest long-history: SUCCESS (7.046s)
[336.584058] [030/133] (682s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[336.686362] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[336.690507] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[336.783324] [031/133] (682s left) gem_render_copy (y-tiled)
[336.837429] Starting subtest: y-tiled
[336.841706] Subtest y-tiled: SKIP (0.000s)
[337.023758] [032/133] (682s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[337.132832] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[337.135212] Starting dynamic subtest: pipe-A-default-mode
[338.285928] Dynamic subtest pipe-A-default-mode: SKIP (1.150s)
[338.290040] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.151s)
[338.444302] [033/133] (681s left) sw_sync (sync_multi_consumer)
[338.485127] Starting subtest: sync_multi_consumer
[338.917869] Subtest sync_multi_consumer: SUCCESS (0.433s)
[338.978770] [034/133] (680s left) gem_exec_schedule (noreorder-priority)
[339.156044] Starting subtest: noreorder-priority
[339.158768] Starting dynamic subtest: rcs0
[340.278788] Dynamic subtest rcs0: SUCCESS (1.123s)
[340.289782] Starting dynamic subtest: vcs0
[341.915361] Dynamic subtest vcs0: SUCCESS (1.634s)
[341.927617] Starting dynamic subtest: vcs1
[343.888230] Dynamic subtest vcs1: SUCCESS (1.971s)
[343.901837] Starting dynamic subtest: vecs0
[345.878334] Dynamic subtest vecs0: SUCCESS (1.988s)
[345.889522] Starting dynamic subtest: ccs0
[347.037416] Dynamic subtest ccs0: SUCCESS (1.158s)
[347.040336] Subtest noreorder-priority: SUCCESS (7.882s)
[347.221416] [035/133] (672s left) gem_tiled_fence_blits (basic)
[347.296935] Subtest basic: SKIP (0.000s)
[347.368327] [036/133] (672s left) i915_pm_rpm (gem-execbuf-stress)
[348.992400] Starting subtest: gem-execbuf-stress
[348.994475] Starting dynamic subtest: smem0
[361.929878] Dynamic subtest smem0: SUCCESS (12.939s)
[361.941290] Starting dynamic subtest: extra-wait-smem0
[423.581235] Dynamic subtest extra-wait-smem0: SUCCESS (61.644s)
[423.583719] Subtest gem-execbuf-stress: SUCCESS (74.587s)
[423.957385] [037/133] (595s left) kms_addfb_basic (basic-y-tiled-legacy)
[424.013812] Starting subtest: basic-y-tiled-legacy
[424.018124] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[424.133595] [038/133] (595s left) kms_concurrent (multi-plane-atomic-lowres)
[424.227049] Starting subtest: multi-plane-atomic-lowres
[424.229275] Starting dynamic subtest: pipe-A-eDP-1
[424.718709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.492s)
[424.728732] Starting dynamic subtest: pipe-B-eDP-1
[425.996276] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.274s)
[426.005887] Starting dynamic subtest: pipe-C-eDP-1
[427.226658] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.230s)
[427.235909] Starting dynamic subtest: pipe-D-eDP-1
[428.434654] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[428.437115] Subtest multi-plane-atomic-lowres: SUCCESS (4.210s)
[429.272156] [039/133] (590s left) gem_exec_balancer (bonded-true-hang)
[429.541440] Starting subtest: bonded-true-hang
[429.545647] Subtest bonded-true-hang: SKIP (0.000s)
[429.647375] [040/133] (590s left) prime_self_import (basic-with_two_bos)
[429.686951] Starting subtest: basic-with_two_bos
[429.715219] Subtest basic-with_two_bos: SUCCESS (0.030s)
[429.838393] [041/133] (590s left) gem_partial_pwrite_pread (reads)
[429.899640] Subtest reads: SKIP (0.000s)
[429.959938] [042/133] (589s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[430.015426] Starting subtest: invalid-multi-wait-unsubmitted
[430.017701] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[430.133067] [043/133] (589s left) sysfs_timeslice_duration (idempotent)
[430.195650] Starting subtest: idempotent
[430.197957] Starting dynamic subtest: vecs0
[430.200168] Dynamic subtest vecs0: SUCCESS (0.000s)
[430.209164] Starting dynamic subtest: ccs0
[430.211235] Dynamic subtest ccs0: SUCCESS (0.000s)
[430.219816] Starting dynamic subtest: vcs0
[430.221959] Dynamic subtest vcs0: SUCCESS (0.000s)
[430.230592] Starting dynamic subtest: bcs0
[430.232473] Dynamic subtest bcs0: SUCCESS (0.000s)
[430.241696] Starting dynamic subtest: rcs0
[430.243676] Dynamic subtest rcs0: SUCCESS (0.000s)
[430.252400] Starting dynamic subtest: vcs1
[430.254574] Dynamic subtest vcs1: SUCCESS (0.000s)
[430.256732] Subtest idempotent: SUCCESS (0.006s)
[430.306329] [044/133] (589s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[430.407440] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[430.411209] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[430.512925] [045/133] (589s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[430.609419] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[437.657227] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.049s)
[437.772481] [046/133] (582s left) kms_vblank (query-busy)
[437.869201] Starting subtest: query-busy
[437.871049] Starting dynamic subtest: pipe-A-eDP-1
[439.759469] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s)
[439.773849] Starting dynamic subtest: pipe-D-eDP-1
[442.374098] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.613s)
[442.376375] Subtest query-busy: SUCCESS (4.506s)
[443.174348] [047/133] (576s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[443.236608] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[443.238926] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[443.345289] [048/133] (576s left) gem_render_copy (y-tiled-to-vebox-linear)
[443.410565] Starting subtest: y-tiled-to-vebox-linear
[443.415208] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[443.596444] [049/133] (576s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[443.693473] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[443.697838] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[443.790744] [050/133] (576s left) perf_pmu (interrupts)
[443.835864] Starting subtest: interrupts
[444.913455] Subtest interrupts: SUCCESS (1.079s)
[445.028053] [051/133] (575s left) gem_mmap (basic)
[445.091037] Subtest basic: SKIP (0.000s)
[445.146726] [052/133] (575s left) syncobj_timeline (single-wait-all-available-submitted)
[445.213681] Starting subtest: single-wait-all-available-submitted
[445.216043] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[445.324959] [053/133] (575s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[447.051364] Starting subtest: modeset-lpsp-stress-no-wait
[456.960617] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.908s)
[457.054553] [054/133] (563s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[457.114917] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[457.183607] [055/133] (563s left) gem_exec_fence (syncobj-unused-fence)
[457.609813] Starting subtest: syncobj-unused-fence
[457.615391] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[458.979972] [056/133] (561s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[459.086260] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[459.090519] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[459.176089] [057/133] (561s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[459.277968] Starting subtest: yf-tiled-16bpp-rotate-270
[459.282529] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[459.382261] [058/133] (561s left) gem_exec_fence (basic-wait)
[459.564485] Starting subtest: basic-wait
[459.566693] Starting dynamic subtest: rcs0
[459.646254] Dynamic subtest rcs0: SUCCESS (0.084s)
[459.658088] Starting dynamic subtest: bcs0
[459.713383] Dynamic subtest bcs0: SUCCESS (0.065s)
[459.725589] Starting dynamic subtest: vcs0
[459.773764] Dynamic subtest vcs0: SUCCESS (0.058s)
[459.787716] Starting dynamic subtest: vcs1
[459.840920] Dynamic subtest vcs1: SUCCESS (0.063s)
[459.854906] Starting dynamic subtest: vecs0
[459.905923] Dynamic subtest vecs0: SUCCESS (0.062s)
[459.917785] Starting dynamic subtest: ccs0
[459.966239] Dynamic subtest ccs0: SUCCESS (0.058s)
[459.968643] Subtest basic-wait: SUCCESS (0.406s)
[462.007664] [059/133] (558s left) prime_mmap_coherency (ioctl-errors)
[462.078015] Starting subtest: ioctl-errors
[479.877521] Subtest ioctl-errors: SUCCESS (17.799s)
[480.035065] [060/133] (540s left) kms_busy (basic)
[480.179182] Starting subtest: basic
[480.181190] Starting dynamic subtest: flip
[480.802177] Dynamic subtest flip: SUCCESS (0.623s)
[480.814389] Starting dynamic subtest: modeset
[484.242565] Dynamic subtest modeset: SUCCESS (3.439s)
[484.244883] Subtest basic: SUCCESS (4.064s)
[485.053249] [061/133] (535s left) gem_exec_store (cachelines)
[485.118390] Starting subtest: cachelines
[485.120670] Starting dynamic subtest: rcs0
[485.201354] Dynamic subtest rcs0: SUCCESS (0.085s)
[485.213675] Starting dynamic subtest: bcs0
[485.270591] Dynamic subtest bcs0: SUCCESS (0.068s)
[485.281565] Starting dynamic subtest: vcs0
[485.331169] Dynamic subtest vcs0: SUCCESS (0.059s)
[485.342962] Starting dynamic subtest: vcs1
[485.390449] Dynamic subtest vcs1: SUCCESS (0.058s)
[485.401812] Starting dynamic subtest: vecs0
[485.445576] Dynamic subtest vecs0: SUCCESS (0.053s)
[485.456946] Starting dynamic subtest: ccs0
[485.508326] Dynamic subtest ccs0: SUCCESS (0.061s)
[485.510718] Subtest cachelines: SUCCESS (0.393s)
[485.692846] [062/133] (535s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[485.804112] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[486.794942] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.990s)
[486.918284] [063/133] (533s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[487.023966] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[487.026278] Starting dynamic subtest: pipe-A-eDP-1
[487.049150] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[487.059991] Starting dynamic subtest: pipe-B-eDP-1
[487.078565] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[487.087706] Starting dynamic subtest: pipe-C-eDP-1
[487.105065] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[487.114095] Starting dynamic subtest: pipe-D-eDP-1
[487.131544] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[487.134944] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[489.289118] [064/133] (531s left) prime_busy (hang-wait)
[489.348244] Starting subtest: hang-wait
[489.350516] Starting dynamic subtest: rcs0
[515.382745] Dynamic subtest rcs0: SUCCESS (26.028s)
[515.393878] Starting dynamic subtest: bcs0
[522.600936] Dynamic subtest bcs0: SUCCESS (7.217s)
[522.610414] Starting dynamic subtest: vcs0
[529.516098] Dynamic subtest vcs0: SUCCESS (6.912s)
[529.527844] Starting dynamic subtest: vcs1
[536.483834] Dynamic subtest vcs1: SUCCESS (6.965s)
[536.493241] Starting dynamic subtest: vecs0
[543.526943] Dynamic subtest vecs0: SUCCESS (7.041s)
[543.538275] Starting dynamic subtest: ccs0
[557.358587] Dynamic subtest ccs0: SUCCESS (13.830s)
[557.361062] Subtest hang-wait: SUCCESS (68.004s)
[557.495264] [065/133] (463s left) kms_flip (flip-vs-panning-vs-hang)
[557.602391] Starting subtest: flip-vs-panning-vs-hang
[557.604692] Starting dynamic subtest: A-eDP1
[608.384866] Dynamic subtest A-eDP1: SUCCESS (50.783s)
[608.396388] Starting dynamic subtest: D-eDP1
[658.368340] Dynamic subtest D-eDP1: SUCCESS (49.981s)
[658.373642] Subtest flip-vs-panning-vs-hang: SUCCESS (100.770s)
[659.559557] [066/133] (361s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[659.649092] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[659.651425] Starting dynamic subtest: pipe-A-eDP-1
[659.938510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.259s)
[659.949293] Starting dynamic subtest: pipe-B-eDP-1
[661.271339] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.332s)
[661.282432] Starting dynamic subtest: pipe-C-eDP-1
[662.533022] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.260s)
[662.544540] Starting dynamic subtest: pipe-D-eDP-1
[663.759285] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[663.761311] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.082s)
[664.980396] [067/133] (356s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[665.054034] Subtest tiled-to-tiled: SKIP (0.000s)
[665.127820] [068/133] (355s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[665.220575] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[665.224911] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[665.293689] [069/133] (355s left) gem_ctx_isolation (clean)
[665.354242] Starting subtest: clean
[665.356491] Starting dynamic subtest: rcs0
[665.400892] Dynamic subtest rcs0: SUCCESS (0.046s)
[665.410609] Starting dynamic subtest: bcs0
[665.441512] Dynamic subtest bcs0: SUCCESS (0.039s)
[665.451127] Starting dynamic subtest: vcs0
[665.527504] Dynamic subtest vcs0: SUCCESS (0.085s)
[665.536904] Starting dynamic subtest: vcs1
[666.898040] Dynamic subtest vcs1: SUCCESS (1.369s)
[666.909286] Starting dynamic subtest: vecs0
[668.913949] Dynamic subtest vecs0: SUCCESS (2.015s)
[668.927313] Starting dynamic subtest: ccs0
[670.958622] Dynamic subtest ccs0: SUCCESS (2.041s)
[670.961254] Subtest clean: SUCCESS (5.604s)
[671.217337] [070/133] (349s left) perf_pmu (init-sema)
[671.254147] Starting subtest: init-sema
[671.256356] Starting dynamic subtest: rcs0
[671.258704] Dynamic subtest rcs0: SUCCESS (0.002s)
[671.272887] Starting dynamic subtest: bcs0
[671.274815] Dynamic subtest bcs0: SUCCESS (0.000s)
[671.284035] Starting dynamic subtest: vcs0
[671.285840] Dynamic subtest vcs0: SUCCESS (0.001s)
[671.294718] Starting dynamic subtest: vcs1
[671.296578] Dynamic subtest vcs1: SUCCESS (0.001s)
[671.306064] Starting dynamic subtest: vecs0
[671.308093] Dynamic subtest vecs0: SUCCESS (0.001s)
[671.317518] Starting dynamic subtest: ccs0
[671.319404] Dynamic subtest ccs0: SUCCESS (0.000s)
[671.321286] Subtest init-sema: SUCCESS (0.009s)
[671.372049] [071/133] (349s left) kms_force_connector_basic (prune-stale-modes)
[671.445280] Starting subtest: prune-stale-modes
[671.916823] Subtest prune-stale-modes: SUCCESS (0.472s)
[672.071737] [072/133] (349s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[672.141685] Subtest no-spare-fences-busy: SKIP (0.000s)
[672.222426] [073/133] (349s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[672.321737] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[672.325346] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[673.412853] [074/133] (347s left) i915_pm_freq_api (freq-suspend)
[673.493945] Starting subtest: freq-suspend
[673.496276] Starting dynamic subtest: gt0
[689.424048] Dynamic subtest gt0: SUCCESS (1.348s)
[689.438606] Starting dynamic subtest: gt1
[705.416095] Dynamic subtest gt1: SUCCESS (1.197s)
[705.418884] Subtest freq-suspend: SUCCESS (2.547s)
[705.485348] [075/133] (315s left) kms_cursor_edge_walk (256x256-top-bottom)
[705.593171] Starting subtest: 256x256-top-bottom
[705.595401] Starting dynamic subtest: pipe-A-eDP-1
[709.392595] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.698s)
[709.404936] Starting dynamic subtest: pipe-D-eDP-1
[712.615588] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.165s)
[712.618046] Subtest 256x256-top-bottom: SUCCESS (6.866s)
[713.501425] [076/133] (307s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[713.619755] Starting subtest: psr-rgb565-draw-pwrite
[720.634400] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.957s)
[720.742127] [077/133] (300s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[720.922860] Starting subtest: cursor-rapid-movement-64x64
[720.925526] Starting dynamic subtest: pipe-A-eDP-1
[721.471977] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[721.504300] Starting dynamic subtest: pipe-D-eDP-1
[722.645834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s)
[722.648155] Subtest cursor-rapid-movement-64x64: SUCCESS (1.715s)
[723.494165] [078/133] (297s left) gem_ctx_persistence (legacy-engines-queued)
[723.641528] Starting subtest: legacy-engines-queued
[723.644142] Starting dynamic subtest: render
[723.888971] Dynamic subtest render: SUCCESS (0.245s)
[723.903955] Starting dynamic subtest: bsd1
[725.227145] Dynamic subtest bsd1: SUCCESS (1.329s)
[725.240921] Starting dynamic subtest: bsd2
[727.208878] Dynamic subtest bsd2: SUCCESS (1.972s)
[727.222535] Starting dynamic subtest: blt
[727.247520] Dynamic subtest blt: SUCCESS (0.037s)
[727.258166] Starting dynamic subtest: vebox
[729.255340] Dynamic subtest vebox: SUCCESS (2.001s)
[729.258181] Subtest legacy-engines-queued: SUCCESS (5.599s)
[729.365380] [079/133] (292s left) kms_flip (2x-flip-vs-fences-interruptible)
[729.468147] Starting subtest: 2x-flip-vs-fences-interruptible
[729.472553] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[729.559900] [080/133] (292s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[729.661179] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[729.663418] Starting dynamic subtest: pipe-A-eDP-1
[729.756849] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[729.768357] Starting dynamic subtest: pipe-B-eDP-1
[730.928860] Dynamic subtest pipe-B-eDP-1: SKIP (1.168s)
[730.933269] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.270s)
[732.188094] [081/133] (289s left) syncobj_timeline (etime-multi-wait-submitted)
[732.258939] Starting subtest: etime-multi-wait-submitted
[732.365685] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[732.444735] [082/133] (289s left) gem_render_copy (linear-to-vebox-yf-tiled)
[732.513915] Starting subtest: linear-to-vebox-yf-tiled
[732.518542] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[732.713569] [083/133] (289s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[732.807470] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[732.809396] Starting dynamic subtest: pipe-A-eDP-1
[732.829890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[732.841702] Starting dynamic subtest: pipe-B-eDP-1
[732.862170] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[732.873064] Starting dynamic subtest: pipe-C-eDP-1
[732.892208] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.024s)
[732.902682] Starting dynamic subtest: pipe-D-eDP-1
[732.923022] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[732.925436] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.097s)
[735.201725] [084/133] (286s left) kms_psr (psr-cursor-render)
[735.287613] Starting subtest: psr-cursor-render
[735.289739] Starting dynamic subtest: eDP-1
[736.959450] Dynamic subtest eDP-1: SUCCESS (1.669s)
[736.961344] Subtest psr-cursor-render: SUCCESS (1.670s)
[737.800775] [085/133] (284s left) kms_atomic (atomic-invalid-params)
[737.891030] Starting subtest: atomic-invalid-params
[737.893386] Starting dynamic subtest: pipe-A-eDP-1
[738.296866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s)
[738.299669] Subtest atomic-invalid-params: SUCCESS (0.409s)
[739.090672] [086/133] (282s left) gem_exec_schedule (semaphore-power)
[739.283886] Subtest semaphore-power: SKIP (0.000s)
[739.478322] [087/133] (282s left) api_intel_allocator (default-alignment)
[739.542068] Starting subtest: default-alignment
[739.544434] Subtest default-alignment: SUCCESS (0.003s)
[739.664705] [088/133] (282s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[739.759231] Starting subtest: yf-tiled-32bpp-rotate-90
[739.763716] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[739.869436] [089/133] (282s left) gem_mmap_wc (copy)
[739.923842] Subtest copy: SKIP (0.000s)
[739.983745] [090/133] (282s left) gem_exec_whisper (basic-queues-forked-all)
[740.036867] Starting subtest: basic-queues-forked-all
[759.421947] Subtest basic-queues-forked-all: SUCCESS (19.374s)
[759.617405] [091/133] (262s left) kms_plane_scaling (intel-max-src-size)
[759.715036] Starting subtest: intel-max-src-size
[759.721402] Subtest intel-max-src-size: SKIP (0.000s)
[759.820384] [092/133] (262s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[759.918452] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[766.896394] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.978s)
[767.057155] [093/133] (255s left) kms_psr (fbc-psr2-sprite-render)
[767.155548] Starting subtest: fbc-psr2-sprite-render
[767.157711] Starting dynamic subtest: eDP-1
[767.161733] Dynamic subtest eDP-1: SKIP (0.000s)
[767.165875] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[767.230037] [094/133] (254s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[767.332563] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[767.336683] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[767.429434] [095/133] (254s left) gem_pread (self)
[767.495855] Subtest self: SKIP (0.000s)
[767.557317] [096/133] (254s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[767.660254] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[767.664520] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[767.759645] [097/133] (254s left) kms_prop_blob (invalid-set-prop)
[767.817057] Starting subtest: invalid-set-prop
[767.819272] Subtest invalid-set-prop: SUCCESS (0.000s)
[767.926253] [098/133] (254s left) fbdev (unaligned-write)
[767.974676] Starting subtest: unaligned-write
[768.073892] Subtest unaligned-write: SUCCESS (0.101s)
[768.144612] [099/133] (254s left) kms_plane (pixel-format-x-tiled-modifier)
[768.233246] Starting subtest: pixel-format-x-tiled-modifier
[768.260591] Starting dynamic subtest: pipe-A-plane-0
[768.904859] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[768.916237] Starting dynamic subtest: pipe-A-plane-3
[769.371528] Dynamic subtest pipe-A-plane-3: SUCCESS (0.466s)
[769.383725] Starting dynamic subtest: pipe-A-plane-5
[769.387580] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[770.460228] Starting dynamic subtest: pipe-B-plane-0
[771.095740] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[771.109801] Starting dynamic subtest: pipe-B-plane-3
[771.517586] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[771.533127] Starting dynamic subtest: pipe-B-plane-5
[771.536806] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[771.828321] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.594s)
[772.710650] [100/133] (249s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[772.766100] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[772.834260] [101/133] (249s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[772.925476] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[776.579492] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.656s)
[777.722234] [102/133] (244s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[777.834401] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[777.847171] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[777.963868] [103/133] (244s left) core_getversion (all-cards)
[777.999645] Starting subtest: all-cards
[778.007739] Subtest all-cards: SUCCESS (0.011s)
[778.055976] [104/133] (244s left) gem_exec_reloc (basic-wc-read-noreloc)
[778.108741] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[778.181698] [105/133] (244s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[778.283470] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[778.287345] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[778.379256] [106/133] (244s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[778.485620] Starting subtest: x-tiled-16bpp-rotate-90
[778.506352] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[778.616461] [107/133] (244s left) kms_feature_discovery (display-1x)
[778.704713] Starting subtest: display-1x
[778.706712] Subtest display-1x: SUCCESS (0.000s)
[778.783304] [108/133] (244s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[778.928517] Starting subtest: cursorA-vs-flipB-varying-size
[778.933541] Subtest cursorA-vs-flipB-varying-size: SKIP (0.002s)
[779.121593] [109/133] (243s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[779.223273] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[779.226866] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[779.297172] [110/133] (243s left) kms_psr2_su (page_flip-xrgb8888)
[779.352551] Subtest page_flip-XRGB8888: SKIP (0.000s)
[779.425386] [111/133] (243s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[779.513992] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[779.517371] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[779.608147] [112/133] (243s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[779.698366] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[784.177511] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.479s)
[785.325966] [113/133] (237s left) i915_drm_fdinfo (isolation)
[785.365873] Starting subtest: isolation
[785.367766] Starting dynamic subtest: rcs0
[785.387626] Dynamic subtest rcs0: SKIP (0.020s)
[785.399011] Starting dynamic subtest: bcs0
[785.403268] Dynamic subtest bcs0: SKIP (0.000s)
[785.414215] Starting dynamic subtest: vcs0
[785.418637] Dynamic subtest vcs0: SKIP (0.000s)
[785.429142] Starting dynamic subtest: vcs1
[785.433364] Dynamic subtest vcs1: SKIP (0.000s)
[785.443789] Starting dynamic subtest: vecs0
[785.447996] Dynamic subtest vecs0: SKIP (0.000s)
[785.458086] Starting dynamic subtest: ccs0
[785.462317] Dynamic subtest ccs0: SKIP (0.000s)
[785.466489] Subtest isolation: SKIP (0.026s)
[785.505220] [114/133] (237s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[785.607725] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[785.612138] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[785.724017] [115/133] (237s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[785.824806] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[790.210655] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.388s)
[791.342424] [116/133] (231s left) kms_big_fb (4-tiled-addfb)
[791.439092] Starting subtest: 4-tiled-addfb
[791.441330] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[791.545486] [117/133] (231s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[791.632832] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[791.637274] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[791.724070] [118/133] (231s left) kms_cursor_crc (cursor-offscreen-512x512)
[792.003692] Starting subtest: cursor-offscreen-512x512
[792.008343] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[792.176271] [119/133] (231s left) gem_mmap (bad-size)
[792.237707] Subtest bad-size: SKIP (0.000s)
[792.296302] [120/133] (231s left) gem_mmap_offset (blt-coherency)
[792.349206] Starting subtest: blt-coherency
[792.353416] Subtest blt-coherency: SUCCESS (0.007s)
[792.494447] [121/133] (230s left) api_intel_bb (simple-bb-ctx)
[792.545089] Starting subtest: simple-bb-ctx
[792.552274] Subtest simple-bb-ctx: SUCCESS (0.009s)
[792.680756] [122/133] (230s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[792.768552] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[792.772268] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[792.867209] [123/133] (230s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[792.972214] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[792.975445] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[793.055621] [124/133] (230s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[793.157587] Starting subtest: fbc-pr-sprite-mmap-gtt
[793.160929] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[793.240534] [125/133] (230s left) kms_psr (pr-primary-mmap-gtt)
[793.335230] Starting subtest: pr-primary-mmap-gtt
[793.338845] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[793.412123] [126/133] (230s left) kms_pipe_crc_basic (suspend-read-crc)
[793.499414] Starting subtest: suspend-read-crc
[793.501021] Starting dynamic subtest: pipe-A-eDP-1
[811.351369] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s)
[811.363931] Starting dynamic subtest: pipe-B-eDP-1
[829.372600] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.117s)
[829.384054] Starting dynamic subtest: pipe-C-eDP-1
[847.347931] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.009s)
[847.361059] Starting dynamic subtest: pipe-D-eDP-1
[865.315337] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.048s)
[865.318144] Subtest suspend-read-crc: SUCCESS (11.686s)
[866.205847] [127/133] (157s left) kms_chamelium_hpd (hdmi-hpd-storm)
[866.608752] Subtest hdmi-hpd-storm: SKIP (0.000s)
[867.391231] [128/133] (156s left) gem_wait (write-busy)
[867.449041] Starting subtest: write-busy
[867.451970] Starting dynamic subtest: all-engines
[868.050421] Dynamic subtest all-engines: SUCCESS (0.588s)
[868.070894] Starting dynamic subtest: rcs0
[868.609496] Dynamic subtest rcs0: SUCCESS (0.546s)
[868.628888] Starting dynamic subtest: bcs0
[869.169728] Dynamic subtest bcs0: SUCCESS (0.549s)
[869.189953] Starting dynamic subtest: vcs0
[871.138525] Dynamic subtest vcs0: SUCCESS (1.935s)
[871.157610] Starting dynamic subtest: vcs1
[873.124548] Dynamic subtest vcs1: SUCCESS (1.959s)
[873.143781] Starting dynamic subtest: vecs0
[875.106635] Dynamic subtest vecs0: SUCCESS (1.959s)
[875.125796] Starting dynamic subtest: ccs0
[875.658951] Dynamic subtest ccs0: SUCCESS (0.546s)
[875.661920] Subtest write-busy: SUCCESS (8.093s)
[875.859861] [129/133] (147s left) gem_userptr_blits (relocations)
[875.932347] Starting subtest: relocations
[875.937081] Subtest relocations: SKIP (0.001s)
[876.056552] [130/133] (147s left) gem_eio (wait-immediate)
[876.256836] Starting subtest: wait-immediate
[876.610925] Subtest wait-immediate: SUCCESS (0.351s)
[876.731535] [131/133] (147s left) gem_userptr_blits (create-destroy-unsync)
[876.801081] Subtest create-destroy-unsync: SKIP (0.000s)
[876.917500] [132/133] (146s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[877.014208] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[884.342199] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.298s)
[884.459953] [133/133] (139s left) gem_exec_reloc (basic-wc)
[884.525097] Subtest basic-wc: SKIP (0.000s)
[884.611823] Closing watchdogs
results: parsing output: 0/ for test: vgem_basic
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_invalid_mode
results: parsing output: 4/ for test: kms_pm_backlight
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: gem_render_linear_blits
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_chamelium_edid
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: syncobj_eventfd
results: parsing output: 14/ for test: gem_ctx_exec
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: kms_chamelium_color
results: parsing output: 18/ for test: gem_exec_flush
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: i915_selftest
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_tiled_fence_blits
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_concurrent
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: prime_self_import
results: parsing output: 40/ for test: gem_partial_pwrite_pread
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: sysfs_timeslice_duration
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_mmap
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: prime_mmap_coherency
results: parsing output: 59/ for test: kms_busy
results: parsing output: 60/ for test: gem_exec_store
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: prime_busy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_set_tiling_vs_blt
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: gem_ctx_isolation
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_force_connector_basic
results: parsing output: 71/ for test: gem_fenced_exec_thrash
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: i915_pm_freq_api
results: parsing output: 74/ for test: kms_cursor_edge_walk
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_pread
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_prop_blob
results: parsing output: 97/ for test: fbdev
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: core_getversion
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_feature_discovery
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_psr2_su
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: gem_mmap
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: api_intel_bb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_joiner
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_pipe_crc_basic
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: gem_wait
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_reloc
Done.