[61.630871] Initializing watchdogs
[61.630918]   /dev/watchdog0
[61.650431] [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]
[61.654871] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.657693] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.659585] [001/132] (960s left) gem_mmap_wc (write-cpu-read-wc)
[61.711897] Subtest write-cpu-read-wc: SKIP (0.000s)
[61.765624] [002/132] (960s left) kms_content_protection (uevent-hdcp14)
[61.915424] Starting subtest: uevent-hdcp14
[61.917434] Subtest uevent-hdcp14: SKIP (0.000s)
[62.040949] [003/132] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[62.130359] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[69.069793] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.952s)
[69.198008] [004/132] (953s left) gem_exec_schedule (wide)
[69.380787] Starting subtest: wide
[69.381973] Starting dynamic subtest: rcs0
[79.725044] Dynamic subtest rcs0: SUCCESS (10.347s)
[79.733903] Starting dynamic subtest: vcs0
[91.769476] Dynamic subtest vcs0: SUCCESS (12.043s)
[91.779136] Starting dynamic subtest: vcs1
[103.544758] Dynamic subtest vcs1: SUCCESS (11.774s)
[103.552570] Starting dynamic subtest: vecs0
[113.655819] Dynamic subtest vecs0: SUCCESS (10.111s)
[113.665033] Starting dynamic subtest: ccs0
[127.153771] Dynamic subtest ccs0: SUCCESS (13.461s)
[127.155228] Subtest wide: SUCCESS (57.738s)
[128.792861] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[128.794634] [005/132] (893s left) api_intel_allocator (standalone)
[128.853266] Starting subtest: standalone
[128.871973] Subtest standalone: SUCCESS (0.020s)
[128.998403] [006/132] (893s left) kms_vrr (flipline)
[129.092517] Starting subtest: flipline
[129.105566] Subtest flipline: SKIP (0.000s)
[129.158931] [007/132] (893s left) gem_exec_flush (basic-wb-pro-default)
[129.222048] Starting subtest: basic-wb-pro-default
[134.682887] Subtest basic-wb-pro-default: SUCCESS (5.461s)
[134.871063] [008/132] (887s left) gem_exec_reloc (basic-cpu-noreloc)
[134.923181] Subtest basic-cpu-noreloc: SKIP (0.000s)
[134.983713] [009/132] (887s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[135.030568] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[135.147141] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[135.212576] [010/132] (887s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[135.320414] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[136.353893] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.034s)
[136.486481] [011/132] (886s left) gem_readwrite (write-bad-handle)
[136.533822] Subtest write-bad-handle: SKIP (0.000s)
[136.584955] [012/132] (885s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[136.674375] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[136.676289] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[136.763112] [013/132] (885s left) i915_drm_fdinfo (virtual-busy-all)
[136.798421] Starting subtest: virtual-busy-all
[136.800040] Subtest virtual-busy-all: SKIP (0.000s)
[136.870989] [014/132] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[136.968685] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[136.970613] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[137.068645] [015/132] (885s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[137.167509] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[138.202951] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.036s)
[138.332958] [016/132] (884s left) kms_chamelium_frames (dp-crc-fast)
[138.721014] Subtest dp-crc-fast: SKIP (0.000s)
[139.493956] [017/132] (883s left) prime_self_import (basic-with_two_bos)
[139.522594] Starting subtest: basic-with_two_bos
[139.546629] Subtest basic-with_two_bos: SUCCESS (0.025s)
[139.642965] [018/132] (883s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[139.692082] Starting subtest: framebuffer-vs-set-tiling
[139.693791] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[139.805123] [019/132] (882s left) kms_tv_load_detect (load-detect)
[139.862984] Subtest load-detect: SKIP (0.000s)
[139.915233] [020/132] (882s left) gem_mmap_gtt (basic-wc)
[139.954907] Subtest basic-wc: SKIP (0.000s)
[140.020283] [021/132] (882s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[140.123328] Starting subtest: basic-max-pipe-crc-check
[140.125095] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[140.163903] [022/132] (882s left) kms_plane (plane-position-hole-dpms)
[140.252954] Starting subtest: plane-position-hole-dpms
[140.776803] Starting dynamic subtest: pipe-A-plane-1
[143.240850] Dynamic subtest pipe-A-plane-1: SUCCESS (2.464s)
[143.247386] Starting dynamic subtest: pipe-A-plane-2
[145.677822] Dynamic subtest pipe-A-plane-2: SUCCESS (2.436s)
[145.684194] Starting dynamic subtest: pipe-A-plane-3
[148.040769] Dynamic subtest pipe-A-plane-3: SUCCESS (2.362s)
[148.050309] Starting dynamic subtest: pipe-A-plane-4
[150.408474] Dynamic subtest pipe-A-plane-4: SUCCESS (2.367s)
[150.414996] Starting dynamic subtest: pipe-A-plane-5
[150.435087] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[151.578501] Starting dynamic subtest: pipe-B-plane-1
[154.020203] Dynamic subtest pipe-B-plane-1: SUCCESS (2.448s)
[154.027324] Starting dynamic subtest: pipe-B-plane-2
[156.456050] Dynamic subtest pipe-B-plane-2: SUCCESS (2.435s)
[156.463529] Starting dynamic subtest: pipe-B-plane-3
[158.826479] Dynamic subtest pipe-B-plane-3: SUCCESS (2.370s)
[158.833265] Starting dynamic subtest: pipe-B-plane-4
[161.171847] Dynamic subtest pipe-B-plane-4: SUCCESS (2.344s)
[161.178505] Starting dynamic subtest: pipe-B-plane-5
[161.194225] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[161.195051] Subtest plane-position-hole-dpms: SUCCESS (20.940s)
[161.976874] [023/132] (860s left) perf_pmu (event-wait)
[162.017974] Starting subtest: event-wait
[162.018964] Starting dynamic subtest: rcs0
[162.020896] Dynamic subtest rcs0: SKIP (0.000s)
[162.022873] Subtest event-wait: SKIP (0.000s)
[162.138615] [024/132] (860s left) kms_psr (pr-cursor-plane-move)
[162.223186] Starting subtest: pr-cursor-plane-move
[162.224935] Subtest pr-cursor-plane-move: SKIP (0.000s)
[162.287738] [025/132] (860s left) kms_atomic (plane-cursor-legacy)
[162.373057] Starting subtest: plane-cursor-legacy
[162.373968] Starting dynamic subtest: pipe-A-eDP-1
[162.756640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.381s)
[162.757655] Subtest plane-cursor-legacy: SUCCESS (0.382s)
[163.612464] [026/132] (859s left) gem_softpin (evict-prime-sanity-check)
[163.669488] Starting subtest: evict-prime-sanity-check
[163.670459] Starting dynamic subtest: rcs0
[164.821833] Dynamic subtest rcs0: SUCCESS (1.151s)
[164.829796] Starting dynamic subtest: bcs0
[165.961372] Dynamic subtest bcs0: SUCCESS (1.138s)
[165.971502] Starting dynamic subtest: vcs0
[167.899767] Dynamic subtest vcs0: SUCCESS (1.929s)
[167.908813] Starting dynamic subtest: vcs1
[169.949727] Dynamic subtest vcs1: SUCCESS (2.049s)
[169.958799] Starting dynamic subtest: vecs0
[171.868782] Dynamic subtest vecs0: SUCCESS (1.917s)
[171.878504] Starting dynamic subtest: ccs0
[172.982619] Dynamic subtest ccs0: SUCCESS (1.121s)
[172.991879] Starting dynamic subtest: all
[174.097488] Dynamic subtest all: SUCCESS (1.114s)
[174.098523] Subtest evict-prime-sanity-check: SUCCESS (10.428s)
[174.170839] [027/132] (848s left) gem_ctx_shared (disjoint-timelines)
[174.228139] Starting subtest: disjoint-timelines
[174.274966] Subtest disjoint-timelines: SUCCESS (0.046s)
[174.521682] [028/132] (848s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[174.612745] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[174.614471] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[174.715876] [029/132] (848s left) syncobj_eventfd (timeline-wait)
[174.782408] Starting subtest: timeline-wait
[174.792775] Subtest timeline-wait: SUCCESS (0.010s)
[174.886286] [030/132] (848s left) gen9_exec_parse (bb-start-far)
[174.939912] Subtest bb-start-far: SKIP (0.000s)
[174.999270] [031/132] (848s left) kms_sequence (queue-idle)
[175.078500] Starting subtest: queue-idle
[175.079444] Starting dynamic subtest: pipe-A-eDP-1
[176.909180] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.830s)
[176.915596] Starting dynamic subtest: pipe-B-eDP-1
[179.404976] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.495s)
[179.411498] Starting dynamic subtest: pipe-C-eDP-1
[181.842668] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.436s)
[181.849918] Starting dynamic subtest: pipe-D-eDP-1
[184.271064] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.426s)
[184.272045] Subtest queue-idle: SUCCESS (9.192s)
[185.060180] [032/132] (838s left) kms_rotation_crc (bad-tiling)
[185.148848] Starting subtest: bad-tiling
[185.151899] Subtest bad-tiling: SKIP (0.001s)
[185.222297] [033/132] (838s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[185.588160] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[186.362633] [034/132] (836s left) gem_mmap_gtt (big-bo)
[186.420740] Subtest big-bo: SKIP (0.000s)
[186.496743] [035/132] (836s left) gem_eio (in-flight-contexts-1us)
[186.718851] Starting subtest: in-flight-contexts-1us
[197.923888] Subtest in-flight-contexts-1us: SUCCESS (11.205s)
[198.110314] [036/132] (825s left) gem_userptr_blits (dmabuf-unsync)
[198.176149] Subtest dmabuf-unsync: SKIP (0.000s)
[198.288138] [037/132] (825s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[198.392553] Starting subtest: 4-tiled-8bpp-rotate-90
[198.412786] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[198.509104] [038/132] (824s left) gem_pread (snoop)
[198.575787] Subtest snoop: SKIP (0.000s)
[198.630131] [039/132] (824s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[198.709113] Starting subtest: fbcpsr-rgb101010-draw-blt
[205.451638] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.743s)
[205.569824] [040/132] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[205.673349] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[212.488155] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.815s)
[212.619359] [041/132] (810s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[212.724320] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[212.725386] Starting dynamic subtest: pipe-A-eDP-1
[212.874135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[212.886596] Starting dynamic subtest: pipe-B-eDP-1
[212.894217] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[212.901197] Starting dynamic subtest: pipe-C-eDP-1
[212.908964] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[212.917193] Starting dynamic subtest: pipe-D-eDP-1
[212.924981] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[212.925978] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.182s)
[215.192323] [042/132] (808s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[215.298301] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[215.299211] Starting dynamic subtest: pipe-A-eDP-1
[215.321431] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[215.332399] Starting dynamic subtest: pipe-B-eDP-1
[215.353810] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[215.361143] Starting dynamic subtest: pipe-C-eDP-1
[215.381693] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[215.389693] Starting dynamic subtest: pipe-D-eDP-1
[215.409784] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[215.411387] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[217.549924] [043/132] (806s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[217.610968] Starting subtest: multi-wait-all-for-submit-signaled
[217.612015] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[217.705541] [044/132] (805s left) api_intel_bb (intel-bb-blit-y)
[217.760079] Starting subtest: intel-bb-blit-y
[221.537960] Subtest intel-bb-blit-y: SUCCESS (3.770s)
[221.645691] [045/132] (802s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[221.760201] Starting subtest: short-flip-before-cursor-toggle
[222.673142] Subtest short-flip-before-cursor-toggle: SUCCESS (0.912s)
[223.487763] [046/132] (800s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[223.620228] Starting subtest: multiplane-atomic-fence-wait
[223.938779] Subtest multiplane-atomic-fence-wait: SUCCESS (0.318s)
[225.104099] [047/132] (798s left) gem_mmap_gtt (basic-copy)
[225.171651] Subtest basic-copy: SKIP (0.000s)
[225.238957] [048/132] (798s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[225.322902] Starting subtest: pr-cursor-plane-update-sf
[225.324810] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[225.408250] [049/132] (798s left) kms_cursor_legacy (torture-bo)
[225.519865] Starting subtest: torture-bo
[225.520659] Starting dynamic subtest: pipe-A
[231.627931] Dynamic subtest pipe-A: SUCCESS (6.098s)
[231.637462] Starting dynamic subtest: pipe-B
[238.085268] Dynamic subtest pipe-B: SUCCESS (6.455s)
[238.097983] Starting dynamic subtest: pipe-C
[245.652868] Dynamic subtest pipe-C: SUCCESS (7.575s)
[245.660664] Starting dynamic subtest: pipe-D
[252.718244] Dynamic subtest pipe-D: SUCCESS (7.054s)
[252.727313] Starting dynamic subtest: all-pipes
[259.337982] Dynamic subtest all-pipes: SUCCESS (6.627s)
[259.338917] Subtest torture-bo: SUCCESS (33.818s)
[259.490107] [050/132] (764s left) gem_lmem_swapping (verify-random)
[259.541258] Subtest verify-random: SKIP (0.000s)
[259.589558] [051/132] (764s left) kms_psr2_su (frontbuffer-xrgb8888)
[259.632252] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[259.720953] [052/132] (764s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[259.803757] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[259.805616] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[259.910215] [053/132] (764s left) kms_3d (basic)
[259.961555] Starting subtest: basic
[261.997261] Subtest basic: SUCCESS (2.037s)
[262.470849] [054/132] (761s left) gem_exec_schedule (deep)
[262.660279] Starting subtest: deep
[262.661453] Starting dynamic subtest: rcs0
[268.614618] Dynamic subtest rcs0: SKIP (5.953s)
[268.624819] Starting dynamic subtest: vcs0
[279.657144] Dynamic subtest vcs0: SUCCESS (11.039s)
[279.669890] Starting dynamic subtest: vcs1
[291.883033] Dynamic subtest vcs1: SUCCESS (12.223s)
[291.892513] Starting dynamic subtest: vecs0
[303.418557] Dynamic subtest vecs0: SUCCESS (11.534s)
[303.428069] Starting dynamic subtest: ccs0
[316.689904] Dynamic subtest ccs0: SUCCESS (13.270s)
[316.691431] Subtest deep: SUCCESS (54.024s)
[317.666884] [055/132] (706s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[317.752931] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[317.754690] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[317.849790] [056/132] (706s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[317.904865] Starting subtest: multi-wait-all-for-submit-signaled
[317.905741] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[317.989686] [057/132] (706s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[318.076387] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[318.078128] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[318.165603] [058/132] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[318.249208] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[325.697093] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.440s)
[325.823207] [059/132] (698s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[325.884630] Starting subtest: yf-tiled-to-vebox-x-tiled
[325.886562] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[326.064578] [060/132] (698s left) kms_flip (flip-vs-absolute-wf_vblank)
[326.155994] Starting subtest: flip-vs-absolute-wf_vblank
[326.159308] Starting dynamic subtest: A-eDP1
[335.047244] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[335.056863] Starting dynamic subtest: B-eDP1
[343.950414] Dynamic subtest B-eDP1: SUCCESS (8.901s)
[343.960610] Starting dynamic subtest: C-eDP1
[352.866857] Dynamic subtest C-eDP1: SUCCESS (8.876s)
[352.875148] Starting dynamic subtest: D-eDP1
[361.772051] Dynamic subtest D-eDP1: SUCCESS (8.902s)
[361.772982] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.582s)
[362.943351] [061/132] (661s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[363.055115] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[363.056899] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[363.192860] [062/132] (661s left) kms_psr (fbc-psr2-cursor-plane-move)
[363.282373] Starting subtest: fbc-psr2-cursor-plane-move
[363.283427] Starting dynamic subtest: eDP-1
[363.285191] Dynamic subtest eDP-1: SKIP (0.000s)
[363.286851] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[363.349816] [063/132] (660s left) gem_exec_flush (basic-wb-ro-default)
[363.415614] Starting subtest: basic-wb-ro-default
[368.879013] Subtest basic-wb-ro-default: SUCCESS (5.463s)
[369.059617] [064/132] (655s left) gem_readwrite (beyond-eob)
[369.111299] Subtest beyond-EOB: SKIP (0.000s)
[369.167292] [065/132] (655s left) i915_selftest (perf)
[372.587374] Starting subtest: perf
[372.588869] Starting dynamic subtest: engine_cs
[376.969788] Dynamic subtest engine_cs: SUCCESS (4.382s)
[376.978169] Starting dynamic subtest: request
[382.339224] Dynamic subtest request: SUCCESS (5.369s)
[382.345360] Starting dynamic subtest: migrate
[385.176953] Dynamic subtest migrate: SUCCESS (2.835s)
[385.185024] Starting dynamic subtest: region
[391.545057] Dynamic subtest region: SUCCESS (6.365s)
[391.546495] Subtest perf: SUCCESS (18.959s)
[391.571184] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[391.571937] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[391.573611] [066/132] (632s left) gem_exec_balancer (waits)
[393.115734] Starting subtest: waits
[399.870855] Subtest waits: SUCCESS (6.706s)
[400.120493] [FACT gem_exec_balancer (waits)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[400.121752] [FACT gem_exec_balancer (waits)] new: kernel.kmod_is_loaded.i915: true
[400.124627] [067/132] (624s left) perf (create-destroy-userspace-config)
[400.255148] Starting subtest: create-destroy-userspace-config
[400.278233] Subtest create-destroy-userspace-config: SUCCESS (0.023s)
[400.313298] [068/132] (624s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[400.398986] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[400.400720] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[400.496453] [069/132] (624s left) gem_ctx_isolation (preservation-reset)
[400.679046] Starting subtest: preservation-reset
[400.680507] Starting dynamic subtest: rcs0
[400.931539] Dynamic subtest rcs0: SUCCESS (0.260s)
[400.940799] Starting dynamic subtest: bcs0
[401.248355] Dynamic subtest bcs0: SUCCESS (0.316s)
[401.258089] Starting dynamic subtest: vcs0
[401.533243] Dynamic subtest vcs0: SUCCESS (0.284s)
[401.543038] Starting dynamic subtest: vcs1
[403.171986] Dynamic subtest vcs1: SUCCESS (1.638s)
[403.181897] Starting dynamic subtest: vecs0
[405.138994] Dynamic subtest vecs0: SUCCESS (1.966s)
[405.146702] Starting dynamic subtest: ccs0
[407.235821] Dynamic subtest ccs0: SUCCESS (2.095s)
[407.239529] Subtest preservation-reset: SUCCESS (6.569s)
[407.386040] [070/132] (617s left) kms_legacy_colorkey (invalid-plane)
[407.475063] Starting subtest: invalid-plane
[407.476026] Starting dynamic subtest: zero-id
[407.476948] Dynamic subtest zero-id: SUCCESS (0.000s)
[407.483841] Starting dynamic subtest: outrange-id
[407.484846] Dynamic subtest outrange-id: SUCCESS (0.000s)
[407.485797] Subtest invalid-plane: SUCCESS (0.001s)
[407.547653] [071/132] (617s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[407.643314] Starting subtest: y-tiled-32bpp-rotate-90
[407.645154] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[407.730981] [072/132] (616s left) kms_cursor_crc (cursor-offscreen-512x512)
[408.006913] Starting subtest: cursor-offscreen-512x512
[408.008703] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[408.167870] [073/132] (616s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[408.255295] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[408.256254] Starting dynamic subtest: pipe-A
[408.275390] Dynamic subtest pipe-A: SKIP (0.020s)
[408.282773] Starting dynamic subtest: pipe-B
[408.324585] Dynamic subtest pipe-B: SKIP (0.048s)
[408.330851] Starting dynamic subtest: pipe-C
[408.365597] Dynamic subtest pipe-C: SKIP (0.040s)
[408.371653] Starting dynamic subtest: pipe-D
[408.410506] Dynamic subtest pipe-D: SKIP (0.044s)
[408.412352] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.156s)
[408.514022] [074/132] (616s left) kms_cursor_crc (cursor-sliding-32x32)
[408.646435] Starting subtest: cursor-sliding-32x32
[408.698435] Subtest cursor-sliding-32x32: SKIP (0.051s)
[408.998097] [075/132] (615s left) vgem_slow (nohang)
[409.031095] Starting subtest: nohang
[419.488468] Subtest nohang: SUCCESS (10.411s)
[419.519980] [076/132] (605s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[419.630381] Starting subtest: psr-rgb101010-draw-blt
[427.018568] Subtest psr-rgb101010-draw-blt: SUCCESS (7.388s)
[427.127353] [077/132] (597s left) i915_pm_rps (engine-order)
[427.183495] Starting subtest: engine-order
[433.587298] Subtest engine-order: SUCCESS (6.398s)
[433.713813] [078/132] (591s left) gem_mmap_gtt (hang)
[433.767530] Subtest hang: SKIP (0.000s)
[433.822786] [079/132] (591s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[433.923134] Starting subtest: x-tiled-32bpp-rotate-180
[435.336431] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.413s)
[435.500860] [080/132] (589s left) gem_ctx_persistence (userptr)
[435.557431] Starting subtest: userptr
[435.719821] Subtest userptr: SUCCESS (0.162s)
[435.792779] [081/132] (589s left) i915_hangman (gt-engine-error)
[435.854383] Starting subtest: gt-engine-error
[435.855319] Starting dynamic subtest: rcs0
[437.885745] Dynamic subtest rcs0: SUCCESS (2.022s)
[437.895832] Starting dynamic subtest: bcs0
[439.868085] Dynamic subtest bcs0: SUCCESS (1.979s)
[439.878461] Starting dynamic subtest: vcs0
[441.852051] Dynamic subtest vcs0: SUCCESS (1.981s)
[441.862565] Starting dynamic subtest: vcs1
[443.899860] Dynamic subtest vcs1: SUCCESS (2.045s)
[443.910885] Starting dynamic subtest: vecs0
[445.884416] Dynamic subtest vecs0: SUCCESS (1.981s)
[445.898218] Starting dynamic subtest: ccs0
[447.869191] Dynamic subtest ccs0: SUCCESS (1.981s)
[447.870872] Subtest gt-engine-error: SUCCESS (12.007s)
[447.936913] [082/132] (577s left) gem_pxp (create-regular-context-2)
[448.059953] Starting subtest: create-regular-context-2
[448.061359] Subtest create-regular-context-2: SUCCESS (0.001s)
[448.158898] [083/132] (576s left) gem_mmap_offset (basic-uaf)
[448.212905] Starting subtest: basic-uaf
[448.213988] Subtest basic-uaf: SUCCESS (0.001s)
[448.307453] [084/132] (576s left) gem_exec_reloc (basic-wc-active)
[448.365059] Subtest basic-wc-active: SKIP (0.000s)
[448.428153] [085/132] (576s left) kms_feature_discovery (psr2)
[448.509430] Starting subtest: psr2
[448.510219] Subtest psr2: SUCCESS (0.000s)
[448.576151] [086/132] (576s left) gem_exec_gttfill (basic)
[448.633408] Starting subtest: basic
[451.395322] Subtest basic: SUCCESS (2.761s)
[451.595390] [087/132] (573s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[451.735702] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[451.737663] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[451.836616] [088/132] (573s left) kms_pm_rpm (dpms-non-lpsp)
[454.094547] Starting subtest: dpms-non-lpsp
[454.098312] Subtest dpms-non-lpsp: SKIP (0.001s)
[454.470960] [089/132] (570s left) kms_getfb (getfb-handle-valid)
[454.573806] Starting subtest: getfb-handle-valid
[454.574741] Subtest getfb-handle-valid: SUCCESS (0.000s)
[454.669327] [090/132] (570s left) gem_exec_schedule (preempt-user)
[454.743878] Starting subtest: preempt-user
[454.744934] Starting dynamic subtest: rcs0
[454.767305] Dynamic subtest rcs0: SUCCESS (0.023s)
[454.778262] Starting dynamic subtest: bcs0
[454.786926] Dynamic subtest bcs0: SUCCESS (0.019s)
[454.795254] Starting dynamic subtest: vcs0
[454.806940] Dynamic subtest vcs0: SUCCESS (0.019s)
[454.814937] Starting dynamic subtest: vcs1
[454.831667] Dynamic subtest vcs1: SUCCESS (0.023s)
[454.840133] Starting dynamic subtest: vecs0
[454.852947] Dynamic subtest vecs0: SUCCESS (0.021s)
[454.860994] Starting dynamic subtest: ccs0
[454.877170] Dynamic subtest ccs0: SUCCESS (0.024s)
[454.878424] Subtest preempt-user: SUCCESS (0.134s)
[455.962176] [091/132] (569s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[456.046864] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[456.049022] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[456.133733] [092/132] (569s left) perf (short-reads)
[456.250689] Starting subtest: short-reads
[456.262332] Subtest short-reads: SUCCESS (0.013s)
[456.309034] [093/132] (569s left) gem_ctx_exec (basic-invalid-context)
[456.360387] Starting subtest: basic-invalid-context
[456.364798] Subtest basic-invalid-context: SUCCESS (0.005s)
[456.483229] [094/132] (568s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[456.579074] Starting subtest: fbc-rgb101010-draw-pwrite
[462.020185] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.441s)
[463.150687] [095/132] (562s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[463.267053] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[463.269048] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[463.359702] [096/132] (562s left) kms_prop_blob (blob-prop-core)
[463.414124] Starting subtest: blob-prop-core
[463.415127] Subtest blob-prop-core: SUCCESS (0.000s)
[463.498339] [097/132] (562s left) gem_gpgpu_fill (basic)
[463.540090] Starting subtest: basic
[463.541108] Starting dynamic subtest: smem
[463.546275] Dynamic subtest smem: SUCCESS (0.007s)
[463.547187] Subtest basic: SUCCESS (0.008s)
[463.668283] [098/132] (561s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[463.751411] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[463.753088] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[463.842621] [099/132] (561s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[463.925471] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[463.927248] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[464.008423] [100/132] (561s left) kms_pm_rpm (fences-dpms)
[466.039368] Starting subtest: fences-dpms
[466.042039] Subtest fences-dpms: SKIP (0.000s)
[466.462992] [101/132] (559s left) vgem_basic (bad-fence)
[466.514473] Starting subtest: bad-fence
[466.515508] Subtest bad-fence: SUCCESS (0.000s)
[466.570177] [102/132] (559s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[466.790050] Starting subtest: cursor-rapid-movement-64x64
[466.792146] Starting dynamic subtest: pipe-A-eDP-1
[467.335385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[467.372695] Starting dynamic subtest: pipe-D-eDP-1
[468.535851] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.170s)
[468.537354] Subtest cursor-rapid-movement-64x64: SUCCESS (1.746s)
[469.384957] [103/132] (556s left) syncobj_basic (illegal-fd-to-handle)
[469.435511] Starting subtest: illegal-fd-to-handle
[469.436610] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[469.550847] [104/132] (556s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[469.641768] Starting subtest: fbc-psr-cursor-mmap-cpu
[469.642719] Starting dynamic subtest: eDP-1
[469.644502] Dynamic subtest eDP-1: SKIP (0.000s)
[469.646237] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[469.710804] [105/132] (556s left) kms_psr (psr2-sprite-mmap-gtt)
[469.795507] Starting subtest: psr2-sprite-mmap-gtt
[469.796468] Starting dynamic subtest: eDP-1
[471.202243] Dynamic subtest eDP-1: SKIP (1.396s)
[471.204339] Subtest psr2-sprite-mmap-gtt: SKIP (1.399s)
[471.331747] [106/132] (554s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[471.429606] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[471.430481] Starting dynamic subtest: pipe-A-eDP-1
[471.439016] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[471.452445] Starting dynamic subtest: pipe-B-eDP-1
[471.461737] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[471.471092] Starting dynamic subtest: pipe-C-eDP-1
[471.479192] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[471.486487] Starting dynamic subtest: pipe-D-eDP-1
[471.495410] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[471.497104] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[473.671949] [107/132] (552s left) kms_scaling_modes (scaling-mode-full)
[473.753540] Starting subtest: scaling-mode-full
[473.754554] Starting dynamic subtest: pipe-A-eDP-1
[473.844849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s)
[473.854235] Starting dynamic subtest: pipe-B-eDP-1
[475.000775] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[475.012384] Starting dynamic subtest: pipe-C-eDP-1
[476.128658] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[476.139205] Starting dynamic subtest: pipe-D-eDP-1
[477.251280] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s)
[477.252195] Subtest scaling-mode-full: SUCCESS (3.499s)
[478.406351] [108/132] (547s left) kms_chamelium_audio (dp-audio-edid)
[478.784966] Subtest dp-audio-edid: SKIP (0.000s)
[479.603388] [109/132] (546s left) gem_bad_reloc (negative-reloc-lut)
[479.651920] Subtest negative-reloc-lut: SKIP (0.000s)
[479.710639] [110/132] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[479.795047] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[479.796909] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[479.893100] [111/132] (546s left) gem_exec_balancer (nohangcheck)
[480.157692] Starting subtest: nohangcheck
[481.182982] Subtest nohangcheck: SUCCESS (1.030s)
[481.328292] [112/132] (544s left) kms_flip (2x-plain-flip-ts-check)
[481.418443] Starting subtest: 2x-plain-flip-ts-check
[481.429136] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[481.508580] [113/132] (544s left) core_auth (many-magics)
[481.570792] Starting subtest: many-magics
[482.592280] Subtest many-magics: SUCCESS (1.021s)
[482.711120] [114/132] (543s left) kms_vrr (flip-basic)
[482.800055] Starting subtest: flip-basic
[482.802594] Subtest flip-basic: SKIP (0.000s)
[482.878057] [115/132] (543s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[482.926164] Starting subtest: yf-tiled-ccs-to-x-tiled
[482.927801] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[483.111756] [116/132] (543s left) prime_vgem (fence-wait)
[483.187184] Starting subtest: fence-wait
[483.188119] Starting dynamic subtest: rcs0
[484.243672] Dynamic subtest rcs0: SUCCESS (1.046s)
[484.254298] Starting dynamic subtest: bcs0
[485.301612] Dynamic subtest bcs0: SUCCESS (1.056s)
[485.311221] Starting dynamic subtest: vcs0
[486.350750] Dynamic subtest vcs0: SUCCESS (1.048s)
[486.361377] Starting dynamic subtest: vcs1
[487.394391] Dynamic subtest vcs1: SUCCESS (1.042s)
[487.405075] Starting dynamic subtest: vecs0
[488.915633] Dynamic subtest vecs0: SUCCESS (1.519s)
[488.926343] Starting dynamic subtest: ccs0
[489.954732] Dynamic subtest ccs0: SUCCESS (1.037s)
[489.956080] Subtest fence-wait: SUCCESS (6.759s)
[490.061873] [117/132] (536s left) gem_exec_fence (invalid-timeline-fence-array)
[490.610041] Starting subtest: invalid-timeline-fence-array
[490.611481] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[492.019646] [118/132] (534s left) gem_ctx_param (set-priority-invalid-size)
[492.080717] Starting subtest: set-priority-invalid-size
[492.081839] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[492.151049] [119/132] (534s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[492.202691] Starting subtest: multi-wait-all-for-submit-available-signaled
[492.203518] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[492.316028] [120/132] (534s left) gem_mmap_gtt (medium-copy)
[492.360858] Subtest medium-copy: SKIP (0.000s)
[492.409392] [121/132] (533s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[492.498230] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[492.499889] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[492.570270] [122/132] (533s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[492.666313] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[500.054380] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.388s)
[500.173751] [123/132] (526s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[500.279329] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[500.280456] Starting dynamic subtest: pipe-A-eDP-1
[500.283825] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[500.291807] Starting dynamic subtest: pipe-B-eDP-1
[500.295483] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[500.303665] Starting dynamic subtest: pipe-C-eDP-1
[500.307240] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[500.315109] Starting dynamic subtest: pipe-D-eDP-1
[500.318473] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[500.320133] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[502.510218] [124/132] (523s left) kms_plane_cursor (viewport)
[502.619353] Starting subtest: viewport
[502.621204] Starting dynamic subtest: pipe-A-eDP-1-size-64
[505.205648] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.586s)
[505.266358] Starting dynamic subtest: pipe-A-eDP-1-size-128
[507.827401] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[507.888919] Starting dynamic subtest: pipe-A-eDP-1-size-256
[510.395038] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.515s)
[510.744073] Starting dynamic subtest: pipe-B-eDP-1-size-64
[513.978350] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.242s)
[514.038577] Starting dynamic subtest: pipe-B-eDP-1-size-128
[516.566774] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[516.627358] Starting dynamic subtest: pipe-B-eDP-1-size-256
[519.190056] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[519.540357] Starting dynamic subtest: pipe-C-eDP-1-size-64
[522.429899] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.898s)
[522.470461] Starting dynamic subtest: pipe-C-eDP-1-size-128
[524.652569] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s)
[524.692876] Starting dynamic subtest: pipe-C-eDP-1-size-256
[526.852593] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[527.182815] Starting dynamic subtest: pipe-D-eDP-1-size-64
[530.091677] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.917s)
[530.131068] Starting dynamic subtest: pipe-D-eDP-1-size-128
[532.336229] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[532.375154] Starting dynamic subtest: pipe-D-eDP-1-size-256
[534.580881] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[534.910981] Subtest viewport: SUCCESS (32.290s)
[535.743317] [125/132] (490s left) gem_wait (await)
[535.803055] Starting subtest: await
[535.804077] Starting dynamic subtest: all-engines
[536.940526] Dynamic subtest all-engines: SUCCESS (1.137s)
[536.960569] Starting dynamic subtest: rcs0
[538.001572] Dynamic subtest rcs0: SUCCESS (1.059s)
[538.018647] Starting dynamic subtest: bcs0
[539.060330] Dynamic subtest bcs0: SUCCESS (1.056s)
[539.078101] Starting dynamic subtest: vcs0
[540.115217] Dynamic subtest vcs0: SUCCESS (1.052s)
[540.133043] Starting dynamic subtest: vcs1
[541.169882] Dynamic subtest vcs1: SUCCESS (1.053s)
[541.184784] Starting dynamic subtest: vecs0
[542.231552] Dynamic subtest vecs0: SUCCESS (1.059s)
[542.253340] Starting dynamic subtest: ccs0
[543.296132] Dynamic subtest ccs0: SUCCESS (1.061s)
[543.297750] Subtest await: SUCCESS (7.494s)
[543.491386] [126/132] (483s left) device_reset (cold-reset-bound)
[543.541903] Starting subtest: cold-reset-bound
[543.543764] Subtest cold-reset-bound: SKIP (0.000s)
[543.608649] [127/132] (482s left) kms_hdr (static-toggle)
[543.704125] Starting subtest: static-toggle
[543.706728] Subtest static-toggle: SKIP (0.000s)
[543.773111] [128/132] (482s left) syncobj_timeline (single-wait-all-available-signaled)
[543.838075] Starting subtest: single-wait-all-available-signaled
[543.839220] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[543.988381] [129/132] (482s left) gem_exec_schedule (pi-distinct-iova)
[544.167916] Starting subtest: pi-distinct-iova
[544.168937] Starting dynamic subtest: rcs0
[544.238668] Dynamic subtest rcs0: SUCCESS (0.076s)
[544.253558] Starting dynamic subtest: vcs0
[544.303656] Dynamic subtest vcs0: SUCCESS (0.065s)
[544.315359] Starting dynamic subtest: vcs1
[544.369583] Dynamic subtest vcs1: SUCCESS (0.065s)
[544.377931] Starting dynamic subtest: vecs0
[544.437720] Dynamic subtest vecs0: SUCCESS (0.067s)
[544.449234] Starting dynamic subtest: ccs0
[544.512465] Dynamic subtest ccs0: SUCCESS (0.074s)
[544.513824] Subtest pi-distinct-iova: SUCCESS (0.351s)
[545.988548] [130/132] (480s left) gem_exec_reloc (basic-write-gtt-active)
[546.037691] Subtest basic-write-gtt-active: SKIP (0.000s)
[546.097495] [131/132] (480s left) kms_color (ctm-blue-to-red)
[546.180536] Starting subtest: ctm-blue-to-red
[546.181386] Starting dynamic subtest: pipe-A-eDP-1
[546.869935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[546.878200] Starting dynamic subtest: pipe-B-eDP-1
[548.261947] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[548.270191] Starting dynamic subtest: pipe-C-eDP-1
[549.627872] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[549.635967] Starting dynamic subtest: pipe-D-eDP-1
[550.969438] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[550.971858] Subtest ctm-blue-to-red: SUCCESS (4.790s)
[551.782364] [132/132] (475s left) gem_softpin (evict-snoop)
[551.845377] Starting subtest: evict-snoop
[551.847273] Subtest evict-snoop: SKIP (0.000s)
[551.948677] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_wc
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: api_intel_allocator
results: parsing output: 5/ for test: kms_vrr
results: parsing output: 6/ for test: gem_exec_flush
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_readwrite
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: i915_drm_fdinfo
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_chamelium_frames
results: parsing output: 16/ for test: prime_self_import
results: parsing output: 17/ for test: kms_addfb_basic
results: parsing output: 18/ for test: kms_tv_load_detect
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_multipipe_modeset
results: parsing output: 21/ for test: kms_plane
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_atomic
results: parsing output: 25/ for test: gem_softpin
results: parsing output: 26/ for test: gem_ctx_shared
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_eventfd
results: parsing output: 29/ for test: gen9_exec_parse
results: parsing output: 30/ for test: kms_sequence
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_pread
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: api_intel_bb
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_explicit_fence
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gem_lmem_swapping
results: parsing output: 50/ for test: kms_psr2_su
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: kms_3d
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_exec_flush
results: parsing output: 63/ for test: gem_readwrite
results: parsing output: 64/ for test: i915_selftest
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_ctx_isolation
results: parsing output: 69/ for test: kms_legacy_colorkey
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: vgem_slow
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_pm_rps
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_ctx_persistence
results: parsing output: 80/ for test: i915_hangman
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: gem_mmap_offset
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_feature_discovery
results: parsing output: 85/ for test: gem_exec_gttfill
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: gem_ctx_exec
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: gem_gpgpu_fill
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_pm_rpm
results: parsing output: 100/ for test: vgem_basic
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_scaling_modes
results: parsing output: 107/ for test: kms_chamelium_audio
results: parsing output: 108/ for test: gem_bad_reloc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: core_auth
results: parsing output: 113/ for test: kms_vrr
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: prime_vgem
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: gem_ctx_param
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: kms_plane
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_plane_cursor
results: parsing output: 124/ for test: gem_wait
results: parsing output: 125/ for test: device_reset
results: parsing output: 126/ for test: kms_hdr
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_color
results: parsing output: 131/ for test: gem_softpin
Done.