[58.581447] Initializing watchdogs
[58.581491]   /dev/watchdog0
[58.595697] [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]
[58.600025] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.602303] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.605662] [001/133] (960s left) i915_pm_rps (basic-api)
[58.700467] Starting subtest: basic-api
[58.705194] Subtest basic-api: SKIP (0.001s)
[58.819633] [002/133] (960s left) kms_invalid_mode (bad-hsync-end)
[58.922208] Starting subtest: bad-hsync-end
[58.924580] Starting dynamic subtest: pipe-A-eDP-1
[59.205191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[59.215442] Starting dynamic subtest: pipe-B-eDP-1
[59.217399] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[59.223429] Starting dynamic subtest: pipe-C-eDP-1
[59.225417] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[59.231704] Starting dynamic subtest: pipe-D-eDP-1
[59.233984] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[59.236278] Subtest bad-hsync-end: SUCCESS (0.290s)
[60.085438] [003/133] (959s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[60.177235] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[60.179601] Starting dynamic subtest: pipe-A-eDP-1
[60.203605] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[60.214872] Starting dynamic subtest: pipe-B-eDP-1
[60.237622] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[60.245840] Starting dynamic subtest: pipe-C-eDP-1
[60.267462] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[60.274223] Starting dynamic subtest: pipe-D-eDP-1
[60.296169] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.300588] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[62.453102] [004/133] (956s left) kms_cursor_edge_walk (64x64-top-edge)
[62.546100] Starting subtest: 64x64-top-edge
[62.548481] Starting dynamic subtest: pipe-A-eDP-1
[66.022549] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[66.032583] Starting dynamic subtest: pipe-D-eDP-1
[69.153839] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[69.156189] Subtest 64x64-top-edge: SUCCESS (6.610s)
[69.963123] [005/133] (949s left) kms_plane (plane-position-hole)
[70.063105] Starting subtest: plane-position-hole
[70.594668] Starting dynamic subtest: pipe-A-plane-1
[71.867281] Dynamic subtest pipe-A-plane-1: SUCCESS (1.271s)
[71.876351] Starting dynamic subtest: pipe-A-plane-2
[73.156707] Dynamic subtest pipe-A-plane-2: SUCCESS (1.290s)
[73.166452] Starting dynamic subtest: pipe-A-plane-3
[74.408104] Dynamic subtest pipe-A-plane-3: SUCCESS (1.252s)
[74.416073] Starting dynamic subtest: pipe-A-plane-4
[75.641814] Dynamic subtest pipe-A-plane-4: SUCCESS (1.232s)
[75.650274] Starting dynamic subtest: pipe-A-plane-5
[75.666224] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[76.798525] Starting dynamic subtest: pipe-B-plane-1
[78.032735] Dynamic subtest pipe-B-plane-1: SUCCESS (1.239s)
[78.039886] Starting dynamic subtest: pipe-B-plane-2
[79.265053] Dynamic subtest pipe-B-plane-2: SUCCESS (1.233s)
[79.272242] Starting dynamic subtest: pipe-B-plane-3
[80.502050] Dynamic subtest pipe-B-plane-3: SUCCESS (1.234s)
[80.510461] Starting dynamic subtest: pipe-B-plane-4
[81.744547] Dynamic subtest pipe-B-plane-4: SUCCESS (1.244s)
[81.753075] Starting dynamic subtest: pipe-B-plane-5
[81.770603] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[81.772514] Subtest plane-position-hole: SUCCESS (11.706s)
[82.544566] [006/133] (936s left) kms_prop_blob (basic)
[82.617212] Starting subtest: basic
[82.619648] Subtest basic: SUCCESS (0.000s)
[82.744261] [007/133] (936s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[82.881951] Starting subtest: dp-mst-lic-type-0-hdcp14
[82.886500] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[83.049756] [008/133] (936s left) dumb_buffer (create-clear)
[83.110729] Starting subtest: create-clear
[117.406662] Subtest create-clear: SUCCESS (34.289s)
[117.527248] [009/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[117.638600] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[117.642922] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[117.749602] [010/133] (901s left) kms_addfb_basic (bad-pitch-63)
[117.814114] Starting subtest: bad-pitch-63
[117.816085] Subtest bad-pitch-63: SUCCESS (0.000s)
[117.969602] [011/133] (901s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[118.093650] Starting subtest: cursorA-vs-flipB-toggle
[118.098329] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[118.258706] [012/133] (901s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[118.315027] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[118.317289] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[118.449908] [013/133] (901s left) api_intel_bb (offset-control)
[118.502709] Starting subtest: offset-control
[118.508676] Subtest offset-control: SUCCESS (0.008s)
[118.602772] [014/133] (900s left) gem_wait (invalid-buf)
[118.664955] Starting subtest: invalid-buf
[118.666949] Subtest invalid-buf: SUCCESS (0.000s)
[118.925590] [015/133] (900s left) kms_flip (flip-vs-fences-interruptible)
[119.020591] Starting subtest: flip-vs-fences-interruptible
[119.025065] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[119.140358] [016/133] (900s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[119.233089] Starting subtest: primary-y-tiled-reflect-x-270
[119.237918] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[119.316715] [017/133] (900s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[119.416395] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[119.418626] Starting dynamic subtest: pipe-A-eDP-1
[119.475775] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[119.483946] Starting dynamic subtest: pipe-B-eDP-1
[119.542101] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[119.551518] Starting dynamic subtest: pipe-C-eDP-1
[119.609701] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[119.618250] Starting dynamic subtest: pipe-D-eDP-1
[119.674742] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[119.678681] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[121.721203] [018/133] (898s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[121.836584] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[128.803886] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.972s)
[128.940403] [019/133] (890s left) syncobj_wait (invalid-reset-illegal-handle)
[129.003788] Starting subtest: invalid-reset-illegal-handle
[129.006440] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[129.127356] [020/133] (890s left) gem_lmem_swapping (massive-random)
[129.167390] Subtest massive-random: SKIP (0.000s)
[129.212074] [021/133] (890s left) syncobj_timeline (etime-multi-wait-all-submitted)
[129.272627] Starting subtest: etime-multi-wait-all-submitted
[129.376447] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[129.462684] [022/133] (890s left) gem_userptr_blits (sync-unmap)
[129.536551] Starting subtest: sync-unmap
[129.548474] Subtest sync-unmap: SUCCESS (0.014s)
[129.731900] [023/133] (890s left) gem_pxp (create-protected-buffer)
[129.852485] Starting subtest: create-protected-buffer
[129.854951] Subtest create-protected-buffer: SUCCESS (0.000s)
[129.979998] [024/133] (889s left) prime_mmap (test_refcounting)
[130.035063] Starting subtest: test_refcounting
[130.037016] Starting dynamic subtest: test_refcounting-smem
[130.064299] Dynamic subtest test_refcounting-smem: SUCCESS (0.030s)
[130.066698] Subtest test_refcounting: SUCCESS (0.031s)
[130.190846] [025/133] (889s left) gem_exec_schedule (pi-shared-iova)
[130.375795] Starting subtest: pi-shared-iova
[130.378146] Starting dynamic subtest: rcs0
[130.443051] Dynamic subtest rcs0: SUCCESS (0.069s)
[130.452997] Starting dynamic subtest: vcs0
[130.492617] Dynamic subtest vcs0: SUCCESS (0.049s)
[130.502610] Starting dynamic subtest: vcs1
[130.542632] Dynamic subtest vcs1: SUCCESS (0.050s)
[130.551658] Starting dynamic subtest: vecs0
[130.588061] Dynamic subtest vecs0: SUCCESS (0.045s)
[130.597726] Starting dynamic subtest: ccs0
[130.646117] Dynamic subtest ccs0: SUCCESS (0.058s)
[130.648672] Subtest pi-shared-iova: SUCCESS (0.273s)
[132.051361] [026/133] (887s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[132.162236] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[133.361976] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.615s)
[133.397520] [027/133] (886s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[133.484045] Starting subtest: flip-primary-invalidate-overlay
[145.064462] Subtest flip-primary-invalidate-overlay: SUCCESS (11.581s)
[145.256768] [028/133] (874s left) kms_psr (fbc-psr-dpms)
[145.355434] Starting subtest: fbc-psr-dpms
[145.357334] Starting dynamic subtest: eDP-1
[145.362834] Dynamic subtest eDP-1: SKIP (0.000s)
[145.366246] Subtest fbc-psr-dpms: SKIP (0.001s)
[145.437667] [029/133] (874s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[145.548554] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[145.559293] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[145.630524] [030/133] (874s left) gem_softpin (evict-prime)
[145.700698] Starting subtest: evict-prime
[145.702644] Starting dynamic subtest: rcs0
[146.914853] Dynamic subtest rcs0: SUCCESS (1.213s)
[146.928043] Starting dynamic subtest: bcs0
[148.067993] Dynamic subtest bcs0: SUCCESS (1.152s)
[148.080899] Starting dynamic subtest: vcs0
[149.855736] Dynamic subtest vcs0: SUCCESS (1.785s)
[149.865845] Starting dynamic subtest: vcs1
[151.920730] Dynamic subtest vcs1: SUCCESS (2.063s)
[151.931732] Starting dynamic subtest: vecs0
[153.889624] Dynamic subtest vecs0: SUCCESS (1.968s)
[153.901216] Starting dynamic subtest: ccs0
[155.040607] Dynamic subtest ccs0: SUCCESS (1.150s)
[155.051046] Starting dynamic subtest: all
[156.905688] Dynamic subtest all: SUCCESS (1.862s)
[156.908835] Subtest evict-prime: SUCCESS (11.203s)
[156.996826] [031/133] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[157.099609] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[157.104106] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[157.240763] [032/133] (863s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[157.352029] Starting subtest: x-tiled-32bpp-rotate-0
[158.686707] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.334s)
[158.883493] [033/133] (861s left) kms_psr (psr2-sprite-plane-onoff)
[158.969224] Starting subtest: psr2-sprite-plane-onoff
[158.971145] Starting dynamic subtest: eDP-1
[160.662708] Dynamic subtest eDP-1: SUCCESS (1.693s)
[160.665101] Subtest psr2-sprite-plane-onoff: SUCCESS (1.694s)
[161.547255] [034/133] (858s left) kms_chamelium_frames (hdmi-aspect-ratio)
[161.927759] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[162.732727] [035/133] (857s left) gem_fence_thrash (bo-write-verify-none)
[162.773373] Starting subtest: bo-write-verify-none
[162.799138] Subtest bo-write-verify-none: SKIP (0.024s)
[162.861410] [036/133] (857s left) api_intel_bb (blit-noreloc-purge-cache)
[162.920053] Starting subtest: blit-noreloc-purge-cache
[162.927955] Subtest blit-noreloc-purge-cache: SUCCESS (0.009s)
[163.075362] [037/133] (857s left) gem_exec_reloc (basic-cpu-read-noreloc)
[163.136810] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[163.228817] [038/133] (857s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[163.340442] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[170.211460] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.873s)
[170.384121] [039/133] (850s left) gem_reg_read (timestamp-monotonic)
[170.449536] Starting subtest: timestamp-monotonic
[174.820370] Subtest timestamp-monotonic: SUCCESS (4.371s)
[174.904313] [040/133] (845s left) kms_color (degamma)
[175.008986] Starting subtest: degamma
[175.010909] Starting dynamic subtest: pipe-A-eDP-1
[175.723403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[175.731107] Starting dynamic subtest: pipe-B-eDP-1
[177.197058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.471s)
[177.205143] Starting dynamic subtest: pipe-C-eDP-1
[178.542588] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.344s)
[178.550858] Starting dynamic subtest: pipe-D-eDP-1
[179.880411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[179.882289] Subtest degamma: SUCCESS (4.872s)
[180.686470] [041/133] (839s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[180.775998] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[180.778305] Starting dynamic subtest: pipe-A-default-mode
[181.936466] Dynamic subtest pipe-A-default-mode: SKIP (1.159s)
[181.941302] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.161s)
[182.138201] [042/133] (838s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[182.257302] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[188.727127] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.474s)
[188.854319] [043/133] (831s left) gem_exec_alignment (pi)
[188.928698] Starting subtest: pi
[241.761624] Subtest pi: SUCCESS (52.828s)
[242.783976] [044/133] (777s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[242.927818] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[242.932325] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[243.049079] [045/133] (777s left) gem_ctx_persistence (heartbeat-hostile)
[243.128155] Starting subtest: heartbeat-hostile
[243.132825] Subtest heartbeat-hostile: SKIP (0.000s)
[243.234613] [046/133] (777s left) perf_pmu (semaphore-wait)
[243.277271] Starting subtest: semaphore-wait
[243.279494] Starting dynamic subtest: rcs0
[243.794655] Dynamic subtest rcs0: SUCCESS (0.515s)
[243.805275] Starting dynamic subtest: bcs0
[244.308419] Dynamic subtest bcs0: SUCCESS (0.511s)
[244.320345] Starting dynamic subtest: vcs0
[244.822496] Dynamic subtest vcs0: SUCCESS (0.511s)
[244.834441] Starting dynamic subtest: vcs1
[245.335616] Dynamic subtest vcs1: SUCCESS (0.510s)
[245.346704] Starting dynamic subtest: vecs0
[245.851839] Dynamic subtest vecs0: SUCCESS (0.513s)
[245.863563] Starting dynamic subtest: ccs0
[246.368241] Dynamic subtest ccs0: SUCCESS (0.514s)
[246.371047] Subtest semaphore-wait: SUCCESS (3.091s)
[246.497304] [047/133] (774s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[246.596023] Starting subtest: fbc-pr-sprite-mmap-cpu
[246.600251] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[246.693033] [048/133] (774s left) kms_chamelium_color (ctm-0-25)
[246.791094] Subtest ctm-0-25: SKIP (0.000s)
[246.834298] [049/133] (774s left) gem_tiled_blits (normal)
[246.902141] Subtest normal: SKIP (0.000s)
[246.981111] [050/133] (773s left) gem_exec_fence (syncobj-timeline-unused-fence)
[247.645647] Starting subtest: syncobj-timeline-unused-fence
[247.652117] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s)
[249.008700] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[249.012316] [051/133] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[249.114718] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[249.119222] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[249.252317] [052/133] (771s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[249.360473] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[253.526052] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.169s)
[254.727792] [053/133] (766s left) kms_draw_crc (draw-method-mmap-gtt)
[254.829515] Starting subtest: draw-method-mmap-gtt
[254.834134] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[254.950624] [054/133] (766s left) i915_drm_fdinfo (virtual-busy)
[254.993228] Starting subtest: virtual-busy
[254.997555] Subtest virtual-busy: SKIP (0.000s)
[255.073146] [055/133] (766s left) sysfs_heartbeat_interval (invalid)
[255.138091] Starting subtest: invalid
[255.140410] Starting dynamic subtest: vecs0
[255.142758] Dynamic subtest vecs0: SUCCESS (0.000s)
[255.152323] Starting dynamic subtest: ccs0
[255.154212] Dynamic subtest ccs0: SUCCESS (0.000s)
[255.161841] Starting dynamic subtest: vcs0
[255.163777] Dynamic subtest vcs0: SUCCESS (0.000s)
[255.171815] Starting dynamic subtest: bcs0
[255.173761] Dynamic subtest bcs0: SUCCESS (0.000s)
[255.181476] Starting dynamic subtest: rcs0
[255.183404] Dynamic subtest rcs0: SUCCESS (0.000s)
[255.191622] Starting dynamic subtest: vcs1
[255.193818] Dynamic subtest vcs1: SUCCESS (0.000s)
[255.196071] Subtest invalid: SUCCESS (0.005s)
[255.272814] [056/133] (765s left) gen9_exec_parse (cmd-crossing-page)
[255.340566] Subtest cmd-crossing-page: SKIP (0.000s)
[255.415533] [057/133] (765s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[255.508638] Starting subtest: stress-xrgb8888-4tiled
[261.393538] Subtest stress-xrgb8888-4tiled: SUCCESS (5.886s)
[261.442953] [058/133] (759s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[261.835417] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[262.613325] [059/133] (758s left) kms_cursor_crc (cursor-onscreen-64x64)
[262.787891] Starting subtest: cursor-onscreen-64x64
[262.792786] Starting dynamic subtest: pipe-A-eDP-1
[264.890639] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s)
[264.918814] Starting dynamic subtest: pipe-D-eDP-1
[267.693529] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.779s)
[267.695630] Subtest cursor-onscreen-64x64: SUCCESS (4.904s)
[268.505884] [060/133] (752s left) i915_getparams_basic (basic-subslice-total)
[268.564684] Starting subtest: basic-subslice-total
[268.568849] Subtest basic-subslice-total: SUCCESS (0.000s)
[268.675170] [061/133] (752s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[268.737461] Starting subtest: invalid-multi-wait-unsubmitted
[268.739770] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[268.857062] [062/133] (752s left) gem_exec_fence (syncobj-export)
[269.314256] Starting subtest: syncobj-export
[269.320361] Subtest syncobj-export: SUCCESS (0.007s)
[271.065318] [063/133] (750s left) gem_exec_fence (basic-wait)
[271.259699] Starting subtest: basic-wait
[271.261840] Starting dynamic subtest: rcs0
[271.350100] Dynamic subtest rcs0: SUCCESS (0.089s)
[271.360211] Starting dynamic subtest: bcs0
[271.418841] Dynamic subtest bcs0: SUCCESS (0.067s)
[271.429604] Starting dynamic subtest: vcs0
[271.485946] Dynamic subtest vcs0: SUCCESS (0.065s)
[271.496166] Starting dynamic subtest: vcs1
[271.547837] Dynamic subtest vcs1: SUCCESS (0.060s)
[271.558087] Starting dynamic subtest: vecs0
[271.613105] Dynamic subtest vecs0: SUCCESS (0.063s)
[271.623234] Starting dynamic subtest: ccs0
[271.678775] Dynamic subtest ccs0: SUCCESS (0.064s)
[271.681160] Subtest basic-wait: SUCCESS (0.420s)
[273.036963] [064/133] (748s left) gem_partial_pwrite_pread (reads-uncached)
[273.086420] Subtest reads-uncached: SKIP (0.000s)
[273.178047] [065/133] (748s left) gem_media_fill (media-fill)
[273.246810] Subtest media-fill: SKIP (0.000s)
[273.385141] [066/133] (748s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[273.493308] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[273.495587] Starting dynamic subtest: A-eDP1
[277.130660] Dynamic subtest A-eDP1: SUCCESS (3.633s)
[277.140449] Starting dynamic subtest: B-eDP1
[280.326331] Dynamic subtest B-eDP1: SUCCESS (3.196s)
[280.335087] Starting dynamic subtest: C-eDP1
[283.447430] Dynamic subtest C-eDP1: SUCCESS (3.117s)
[283.456512] Starting dynamic subtest: D-eDP1
[286.567778] Dynamic subtest D-eDP1: SUCCESS (3.120s)
[286.570063] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.075s)
[287.378412] [067/133] (734s left) syncobj_wait (wait-any-complex)
[287.443737] Starting subtest: wait-any-complex
[287.506729] Subtest wait-any-complex: SUCCESS (0.062s)
[287.597069] [068/133] (734s left) kms_rotation_crc (primary-rotation-180)
[287.683193] Starting subtest: primary-rotation-180
[294.785639] Subtest primary-rotation-180: SUCCESS (7.102s)
[296.049378] [069/133] (725s left) gem_workarounds (suspend-resume-context)
[296.126498] Starting subtest: suspend-resume-context
[312.389640] Subtest suspend-resume-context: SUCCESS (1.363s)
[313.560589] [070/133] (709s left) gem_pxp (reject-modify-context-protection-off-3)
[313.674550] Starting subtest: reject-modify-context-protection-off-3
[313.677548] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[313.793873] [071/133] (709s left) kms_lease (lease-unleased-crtc)
[313.892820] Starting subtest: lease-unleased-crtc
[313.895400] Starting dynamic subtest: pipe-A-eDP-1
[314.192427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[314.203377] Starting dynamic subtest: pipe-B-eDP-1
[314.915915] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.720s)
[314.927059] Starting dynamic subtest: pipe-C-eDP-1
[314.929594] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[314.939309] Starting dynamic subtest: pipe-D-eDP-1
[314.941593] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[314.944061] Subtest lease-unleased-crtc: SUCCESS (1.042s)
[315.309035] [072/133] (707s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[315.412518] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[315.417337] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[315.526024] [073/133] (707s left) gem_exec_reloc (basic-gtt-wc)
[315.582318] Subtest basic-gtt-wc: SKIP (0.000s)
[315.670004] [074/133] (707s left) gem_exec_reloc (basic-cpu)
[315.729355] Subtest basic-cpu: SKIP (0.000s)
[315.812709] [075/133] (707s left) kms_atomic_interruptible (legacy-pageflip)
[315.910680] Starting subtest: legacy-pageflip
[315.913319] Starting dynamic subtest: pipe-A-eDP-1
[323.321262] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.410s)
[323.324205] Subtest legacy-pageflip: SUCCESS (7.412s)
[324.162403] [076/133] (698s left) kms_atomic_interruptible (universal-setplane-cursor)
[324.274512] Starting subtest: universal-setplane-cursor
[324.277256] Starting dynamic subtest: pipe-A-eDP-1
[331.659575] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.381s)
[331.662434] Subtest universal-setplane-cursor: SUCCESS (7.383s)
[332.516839] [077/133] (690s left) gem_mmap_gtt (hang-busy)
[332.582377] Subtest hang-busy: SKIP (0.000s)
[332.672581] [078/133] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[332.777121] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[332.782091] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[332.896081] [079/133] (690s left) perf_pmu (module-unload)
[332.964246] Starting subtest: module-unload
[340.999310] Subtest module-unload: FAIL (7.904s)
[341.031678] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[341.032385] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[341.035878] [080/133] (682s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[343.863392] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[343.866787] Starting dynamic subtest: pipe-A-default-mode
[346.690667] Dynamic subtest pipe-A-default-mode: SUCCESS (2.828s)
[346.693464] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.829s)
[347.571669] [FACT kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[347.572886] [FACT kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)] new: kernel.kmod_is_loaded.i915: true
[347.577380] [081/133] (675s left) gem_exec_schedule (u-semaphore-resolve)
[347.673374] Starting subtest: u-semaphore-resolve
[347.703439] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[348.060290] [082/133] (675s left) i915_selftest (live)
[351.439790] Starting subtest: live
[351.442195] Starting dynamic subtest: sanitycheck
[357.137717] Dynamic subtest sanitycheck: SUCCESS (5.697s)
[357.148044] Starting dynamic subtest: uncore
[361.220071] Dynamic subtest uncore: SUCCESS (4.081s)
[361.236163] Starting dynamic subtest: workarounds
[365.894788] Dynamic subtest workarounds: SUCCESS (4.672s)
[365.905394] Starting dynamic subtest: gt_engines
[370.383873] Dynamic subtest gt_engines: SUCCESS (4.486s)
[370.399049] Starting dynamic subtest: gt_timelines
[387.091709] Dynamic subtest gt_timelines: SUCCESS (16.705s)
[387.102014] Starting dynamic subtest: gt_contexts
[391.332329] Dynamic subtest gt_contexts: SUCCESS (4.239s)
[391.342660] Starting dynamic subtest: gt_lrc
[396.978958] Dynamic subtest gt_lrc: SUCCESS (5.644s)
[396.988784] Starting dynamic subtest: gt_mocs
[401.398070] Dynamic subtest gt_mocs: SUCCESS (4.417s)
[401.408514] Starting dynamic subtest: gt_pm
[407.654104] Dynamic subtest gt_pm: SUCCESS (6.253s)
[407.663917] Starting dynamic subtest: gt_heartbeat
[413.354232] Dynamic subtest gt_heartbeat: SUCCESS (5.698s)
[413.364538] Starting dynamic subtest: gt_tlb
[424.210204] Dynamic subtest gt_tlb: SUCCESS (10.853s)
[424.220645] Starting dynamic subtest: requests
[439.214290] Dynamic subtest requests: SUCCESS (15.002s)
[439.224787] Starting dynamic subtest: migrate
[446.617946] Dynamic subtest migrate: SUCCESS (7.402s)
[446.628356] Starting dynamic subtest: active
[450.700034] Dynamic subtest active: SUCCESS (4.079s)
[450.709556] Starting dynamic subtest: objects
[455.445439] Dynamic subtest objects: SUCCESS (4.743s)
[455.455522] Starting dynamic subtest: mman
[460.260719] Dynamic subtest mman: SUCCESS (4.813s)
[460.271046] Starting dynamic subtest: dmabuf
[464.487082] Dynamic subtest dmabuf: SUCCESS (4.224s)
[464.497433] Starting dynamic subtest: vma
[470.204073] Dynamic subtest vma: SUCCESS (5.715s)
[470.214023] Starting dynamic subtest: coherency
[475.050907] Dynamic subtest coherency: SUCCESS (4.845s)
[475.061271] Starting dynamic subtest: gtt
[486.430061] Dynamic subtest gtt: SUCCESS (11.376s)
[486.438514] Starting dynamic subtest: gem
[495.638812] Dynamic subtest gem: SUCCESS (9.205s)
[495.648978] Starting dynamic subtest: evict
[500.978820] Dynamic subtest evict: SUCCESS (5.337s)
[500.994897] Starting dynamic subtest: hugepages
[511.197892] Dynamic subtest hugepages: SUCCESS (10.216s)
[511.207445] Starting dynamic subtest: gem_contexts
[539.645309] Dynamic subtest gem_contexts: SUCCESS (28.444s)
[539.655814] Starting dynamic subtest: client
[543.882290] Dynamic subtest client: SUCCESS (4.236s)
[543.892437] Starting dynamic subtest: gem_migrate
[548.076835] Dynamic subtest gem_migrate: SUCCESS (4.193s)
[548.087748] Starting dynamic subtest: reset
[553.861848] Dynamic subtest reset: SUCCESS (5.783s)
[553.870268] Starting dynamic subtest: memory_region
[559.601856] Dynamic subtest memory_region: SUCCESS (5.738s)
[559.612049] Starting dynamic subtest: hangcheck
[574.239763] Dynamic subtest hangcheck: SUCCESS (14.634s)
[574.249845] Starting dynamic subtest: execlists
[579.961315] Dynamic subtest execlists: SUCCESS (5.720s)
[579.971990] Starting dynamic subtest: ring_submission
[583.993847] Dynamic subtest ring_submission: SUCCESS (4.030s)
[584.004048] Starting dynamic subtest: perf
[588.204782] Dynamic subtest perf: SUCCESS (4.209s)
[588.214318] Starting dynamic subtest: slpc
[603.739997] Dynamic subtest slpc: SUCCESS (15.533s)
[603.755368] Starting dynamic subtest: guc
[609.144304] Dynamic subtest guc: SUCCESS (5.402s)
[609.154815] Starting dynamic subtest: guc_multi_lrc
[613.266958] Dynamic subtest guc_multi_lrc: SUCCESS (4.121s)
[613.280450] Starting dynamic subtest: guc_hang
[618.200029] Dynamic subtest guc_hang: SUCCESS (4.931s)
[618.210668] Starting dynamic subtest: late_gt_pm
[623.924411] Dynamic subtest late_gt_pm: SUCCESS (5.723s)
[623.928172] Subtest live: SUCCESS (272.475s)
[623.961707] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[623.962406] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[623.965969] [083/133] (399s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[626.815101] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[630.984140] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.175s)
[632.193560] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[632.194805] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[632.198908] [084/133] (391s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[632.313675] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[640.842369] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.531s)
[641.009906] [085/133] (382s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[641.076349] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[641.082161] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[641.289293] [086/133] (382s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[641.417380] Starting subtest: flip-vs-cursor-busy-crc-legacy
[642.230250] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.814s)
[643.046242] [087/133] (380s left) kms_pm_rpm (fences)
[644.980359] Starting subtest: fences
[644.985564] Subtest fences: SKIP (0.000s)
[645.358067] [088/133] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[645.456773] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[645.462118] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[645.559611] [089/133] (378s left) dumb_buffer (map-valid)
[645.622311] Starting subtest: map-valid
[645.624514] Subtest map-valid: SUCCESS (0.000s)
[645.727872] [090/133] (377s left) gem_exec_suspend (basic-s0)
[645.789033] Starting subtest: basic-S0
[645.791337] Starting dynamic subtest: smem
[666.317010] Dynamic subtest smem: SUCCESS (7.014s)
[666.320152] Subtest basic-S0: SUCCESS (7.016s)
[666.516570] [091/133] (357s left) gem_render_copy_redux (normal)
[666.591608] Starting subtest: normal
[666.878925] Subtest normal: SUCCESS (0.289s)
[667.020987] [092/133] (356s left) kms_psr (pr-sprite-plane-move)
[667.135427] Starting subtest: pr-sprite-plane-move
[667.139859] Subtest pr-sprite-plane-move: SKIP (0.000s)
[667.219016] [093/133] (356s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[667.313991] Starting subtest: fbcpsr-tiling-y
[667.318365] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[667.434191] [094/133] (356s left) gem_ctx_exec (basic-invalid-context)
[667.489416] Starting subtest: basic-invalid-context
[667.493090] Subtest basic-invalid-context: SUCCESS (0.004s)
[667.648592] [095/133] (356s left) sw_sync (sync_merge_same)
[667.690701] Starting subtest: sync_merge_same
[667.692504] Subtest sync_merge_same: SUCCESS (0.000s)
[667.762301] [096/133] (356s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[667.857449] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[667.859299] Starting dynamic subtest: pipe-A
[667.878315] Dynamic subtest pipe-A: SKIP (0.017s)
[667.887264] Starting dynamic subtest: pipe-B
[667.912715] Dynamic subtest pipe-B: SKIP (0.034s)
[667.921682] Starting dynamic subtest: pipe-C
[667.949712] Dynamic subtest pipe-C: SKIP (0.036s)
[667.958021] Starting dynamic subtest: pipe-D
[667.984102] Dynamic subtest pipe-D: SKIP (0.035s)
[667.987516] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.124s)
[668.110615] [097/133] (355s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[668.206799] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[668.208499] Starting dynamic subtest: pipe-A-eDP-1
[669.073023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.858s)
[669.082338] Starting dynamic subtest: pipe-B-eDP-1
[670.566848] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s)
[670.576659] Starting dynamic subtest: pipe-C-eDP-1
[672.059704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s)
[672.069838] Starting dynamic subtest: pipe-D-eDP-1
[673.602431] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.541s)
[673.605078] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.384s)
[674.781243] [098/133] (349s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[674.850886] Starting subtest: invalid-single-wait-all-unsubmitted
[674.853141] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[674.971653] [099/133] (349s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[675.083748] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[675.707837] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.625s)
[675.919589] [100/133] (348s left) gem_ctx_freq (sysfs)
[675.992936] Starting subtest: sysfs
[675.994940] Starting dynamic subtest: gt0
[681.500855] Dynamic subtest gt0: SUCCESS (5.508s)
[681.510188] Starting dynamic subtest: gt1
[723.339914] Dynamic subtest gt1: SUCCESS (41.827s)
[723.342846] Subtest sysfs: SUCCESS (47.338s)
[723.503002] [101/133] (300s left) perf (gen12-group-concurrent-oa-buffer-read)
[723.645354] Starting subtest: gen12-group-concurrent-oa-buffer-read
[733.687819] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.041s)
[733.736093] [102/133] (290s left) kms_cursor_legacy (forked-bo)
[733.860689] Starting subtest: forked-bo
[733.862565] Starting dynamic subtest: pipe-A
[739.315658] Dynamic subtest pipe-A: SUCCESS (5.451s)
[739.329419] Starting dynamic subtest: pipe-B
[744.783139] Dynamic subtest pipe-B: SUCCESS (5.465s)
[744.794687] Starting dynamic subtest: pipe-C
[750.256553] Dynamic subtest pipe-C: SUCCESS (5.470s)
[750.267491] Starting dynamic subtest: pipe-D
[755.718465] Dynamic subtest pipe-D: SUCCESS (5.459s)
[755.730067] Starting dynamic subtest: all-pipes
[761.200198] Dynamic subtest all-pipes: SUCCESS (5.478s)
[761.202745] Subtest forked-bo: SUCCESS (27.334s)
[761.366499] [103/133] (262s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[761.479188] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[765.217690] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.743s)
[766.389820] [104/133] (257s left) kms_vblank (query-forked-busy)
[766.492800] Starting subtest: query-forked-busy
[766.495180] Starting dynamic subtest: pipe-A-eDP-1
[768.372655] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[768.386799] Starting dynamic subtest: pipe-D-eDP-1
[770.936590] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s)
[770.942254] Subtest query-forked-busy: SUCCESS (4.446s)
[771.761138] [105/133] (252s left) gem_eio (execbuf)
[771.976096] Starting subtest: execbuf
[772.278290] Subtest execbuf: SUCCESS (0.301s)
[772.456106] [106/133] (251s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[772.573310] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[772.585081] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[772.720058] [107/133] (251s left) syncobj_basic (bad-destroy)
[772.779495] Starting subtest: bad-destroy
[772.781359] Subtest bad-destroy: SUCCESS (0.000s)
[772.905561] [108/133] (251s left) gem_exec_balancer (bonded-true-hang)
[773.168947] Starting subtest: bonded-true-hang
[773.173679] Subtest bonded-true-hang: SKIP (0.000s)
[773.290919] [109/133] (251s left) kms_pwrite_crc
[774.885802] [110/133] (249s left) kms_cursor_crc (cursor-random-32x32)
[775.048308] Starting subtest: cursor-random-32x32
[775.103155] Subtest cursor-random-32x32: SKIP (0.052s)
[775.442484] [111/133] (249s left) kms_async_flips (async-flip-hang)
[775.541091] Starting subtest: async-flip-hang
[775.913163] Starting dynamic subtest: pipe-A-eDP-1
[790.764159] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.850s)
[791.134669] Starting dynamic subtest: pipe-B-eDP-1
[806.761415] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.630s)
[807.130518] Starting dynamic subtest: pipe-C-eDP-1
[822.757593] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.631s)
[823.134449] Starting dynamic subtest: pipe-D-eDP-1
[838.755220] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.623s)
[838.757741] Subtest async-flip-hang: SUCCESS (63.211s)
[839.935801] [112/133] (184s left) gem_userptr_blits (probe)
[840.020013] Starting subtest: probe
[840.097362] Subtest probe: SUCCESS (0.079s)
[840.246169] [113/133] (184s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[840.335451] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[840.348407] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[840.418789] [114/133] (184s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[840.479993] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[840.582419] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[840.677812] [115/133] (184s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[840.775272] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[847.819524] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.046s)
[848.021206] [116/133] (176s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[848.140463] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[848.142698] Starting dynamic subtest: pipe-A-eDP-1
[859.122217] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.983s)
[859.133463] Starting dynamic subtest: pipe-B-eDP-1
[870.856015] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.731s)
[870.858437] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.717s)
[871.758922] [117/133] (153s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[871.834012] Starting subtest: multi-wait-available-submitted-signaled
[871.836235] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[871.948994] [118/133] (152s left) kms_selftest (drm_cmdline_parser)
[871.986942] Starting subtest: drm_cmdline_parser
[872.029453] Starting dynamic subtest: drm_test_cmdline_force_d_only
[872.158486] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.127s)
[872.168438] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[872.291264] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.133s)
[872.301728] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[872.423213] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.130s)
[872.434189] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[872.576278] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.152s)
[872.585570] Starting dynamic subtest: drm_test_cmdline_force_e_only
[872.702220] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.126s)
[872.711890] Starting dynamic subtest: drm_test_cmdline_res
[872.860707] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.159s)
[872.870203] Starting dynamic subtest: drm_test_cmdline_res_vesa
[872.965553] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.105s)
[872.974877] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[873.106197] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.137s)
[873.115827] Starting dynamic subtest: drm_test_cmdline_res_rblank
[873.240529] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.133s)
[873.250051] Starting dynamic subtest: drm_test_cmdline_res_bpp
[873.384756] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.145s)
[873.394057] Starting dynamic subtest: drm_test_cmdline_res_refresh
[873.524362] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.138s)
[873.534039] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[873.651769] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.127s)
[873.661634] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[873.797765] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.146s)
[873.806798] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[873.954039] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.155s)
[873.963517] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[874.098901] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.144s)
[874.108183] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[874.257575] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.159s)
[874.267159] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[874.404797] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.146s)
[874.415212] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[874.493218] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.088s)
[874.513169] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[874.628187] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.133s)
[874.648553] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[874.786973] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.157s)
[874.806575] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[874.902728] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.115s)
[874.922039] Starting dynamic subtest: drm_test_cmdline_name
[875.035960] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.130s)
[875.055193] Starting dynamic subtest: drm_test_cmdline_name_bpp
[875.169376] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.133s)
[875.189194] Starting dynamic subtest: drm_test_cmdline_name_option
[875.305972] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.134s)
[875.322555] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[875.446599] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.141s)
[875.457488] Starting dynamic subtest: drm_test_cmdline_rotate_0
[875.581457] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.134s)
[875.591996] Starting dynamic subtest: drm_test_cmdline_rotate_90
[875.712748] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.130s)
[875.728078] Starting dynamic subtest: drm_test_cmdline_rotate_180
[875.850088] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.137s)
[875.859482] Starting dynamic subtest: drm_test_cmdline_rotate_270
[875.994795] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.143s)
[876.005137] Starting dynamic subtest: drm_test_cmdline_hmirror
[876.139204] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.141s)
[876.149510] Starting dynamic subtest: drm_test_cmdline_vmirror
[876.240697] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.102s)
[876.256048] Starting dynamic subtest: drm_test_cmdline_margin_options
[876.343245] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.102s)
[876.352825] Starting dynamic subtest: drm_test_cmdline_multiple_options
[876.490907] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.147s)
[876.500122] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[876.593438] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.102s)
[876.602496] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[876.747442] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.153s)
[876.756729] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[876.897252] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.149s)
[876.906900] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[877.024800] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.126s)
[877.035866] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[877.151639] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.126s)
[877.162056] Starting dynamic subtest: drm_test_cmdline_invalid
[877.288196] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.136s)
[877.297179] Starting dynamic subtest: drm_test_cmdline_tv_options
[877.424010] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.134s)
[877.426175] Subtest drm_cmdline_parser: SUCCESS (5.436s)
[877.629359] [119/133] (147s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[877.726654] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[877.730921] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[877.840025] [120/133] (147s left) gem_render_copy (x-tiled)
[877.906658] Starting subtest: x-tiled
[877.908810] Starting dynamic subtest: smem
[877.945528] Dynamic subtest smem: SUCCESS (0.041s)
[877.947816] Subtest x-tiled: SUCCESS (0.042s)
[878.202217] [121/133] (146s left) kms_prop_blob (blob-prop-core)
[878.260703] Starting subtest: blob-prop-core
[878.262625] Subtest blob-prop-core: SUCCESS (0.000s)
[878.365224] [122/133] (146s left) vgem_basic (second-client)
[878.413255] Starting subtest: second-client
[878.435504] Subtest second-client: SUCCESS (0.022s)
[878.507204] [123/133] (146s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[878.567753] Starting subtest: single-wait-all-for-submit-available-submitted
[878.569972] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[878.700359] [124/133] (146s left) syncobj_timeline (invalid-query-zero-handles)
[878.755913] Starting subtest: invalid-query-zero-handles
[878.757856] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[878.864508] [125/133] (146s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[878.970200] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[878.974377] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[879.092946] [126/133] (146s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[879.194642] Starting subtest: fbc-pr-cursor-mmap-cpu
[879.198193] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[879.283847] [127/133] (145s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[879.376412] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[879.379797] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[879.501114] [128/133] (145s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[879.595321] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[879.597110] Starting dynamic subtest: pipe-A-eDP-1
[879.615277] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[879.625038] Starting dynamic subtest: pipe-B-eDP-1
[879.642284] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[879.650886] Starting dynamic subtest: pipe-C-eDP-1
[879.668074] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[879.676947] Starting dynamic subtest: pipe-D-eDP-1
[879.694552] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[879.698063] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[881.793125] [129/133] (143s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[881.900855] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[881.905188] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[882.023683] [130/133] (143s left) kms_async_flips (test-time-stamp-atomic)
[882.122477] Starting subtest: test-time-stamp-atomic
[882.500265] Starting dynamic subtest: pipe-A-eDP-1
[883.290535] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s)
[883.683204] Starting dynamic subtest: pipe-B-eDP-1
[884.424088] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.754s)
[884.790097] Starting dynamic subtest: pipe-C-eDP-1
[885.558177] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[885.925096] Starting dynamic subtest: pipe-D-eDP-1
[886.696208] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[886.698981] Subtest test-time-stamp-atomic: SUCCESS (4.573s)
[887.873810] [131/133] (137s left) gem_partial_pwrite_pread (writes-after-reads)
[887.937435] Subtest writes-after-reads: SKIP (0.000s)
[888.055040] [132/133] (137s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[888.188050] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[889.288412] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.098s)
[889.436694] [133/133] (136s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[889.546538] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[889.558347] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[889.643958] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rps
results: parsing output: 1/ for test: kms_invalid_mode
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_cursor_edge_walk
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_prop_blob
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: dumb_buffer
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_addfb_basic
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: api_intel_bb
results: parsing output: 13/ for test: gem_wait
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: gem_lmem_swapping
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: gem_pxp
results: parsing output: 23/ for test: prime_mmap
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_psr_stress_test
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: gem_softpin
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: gem_fence_thrash
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_reg_read
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_alignment
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_persistence
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_chamelium_color
results: parsing output: 48/ for test: gem_tiled_blits
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_draw_crc
results: parsing output: 53/ for test: i915_drm_fdinfo
results: parsing output: 54/ for test: sysfs_heartbeat_interval
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: kms_pipe_stress
results: parsing output: 57/ for test: kms_chamelium_hpd
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: i915_getparams_basic
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: gem_partial_pwrite_pread
results: parsing output: 64/ for test: gem_media_fill
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: gem_workarounds
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_atomic_interruptible
results: parsing output: 75/ for test: kms_atomic_interruptible
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: i915_selftest
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: dumb_buffer
results: parsing output: 89/ for test: gem_exec_suspend
results: parsing output: 90/ for test: gem_render_copy_redux
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_ctx_exec
results: parsing output: 94/ for test: sw_sync
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_ctx_freq
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_vblank
results: parsing output: 104/ for test: gem_eio
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: syncobj_basic
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: kms_pwrite_crc
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_selftest
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: kms_prop_blob
results: parsing output: 121/ for test: vgem_basic
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_async_flips
results: parsing output: 130/ for test: gem_partial_pwrite_pread
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_flip
Done.