[56.436137] Initializing watchdogs
[56.436181]   /dev/watchdog0
[56.449749] [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]
[56.454084] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.456203] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.459338] [001/133] (960s left) gem_exec_reloc (basic-wc-read-noreloc)
[56.541783] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[56.610284] [002/133] (960s left) kms_flip (flip-vs-modeset-vs-hang)
[56.708253] Starting subtest: flip-vs-modeset-vs-hang
[56.710674] Starting dynamic subtest: A-eDP1
[96.366827] Dynamic subtest A-eDP1: SUCCESS (39.658s)
[96.376491] Starting dynamic subtest: D-eDP1
[146.348054] Dynamic subtest D-eDP1: SUCCESS (49.981s)
[146.350754] Subtest flip-vs-modeset-vs-hang: SUCCESS (89.644s)
[146.748155] [003/133] (870s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[146.843119] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[146.845455] Starting dynamic subtest: pipe-A-eDP-1
[146.855028] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.864057] Starting dynamic subtest: pipe-B-eDP-1
[146.873816] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[146.882744] Starting dynamic subtest: pipe-C-eDP-1
[146.891390] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[146.897845] Starting dynamic subtest: pipe-D-eDP-1
[146.906467] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[146.910632] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[149.106511] [004/133] (867s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[149.215440] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[149.828063] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.614s)
[150.008760] [005/133] (867s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[150.124868] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[150.129102] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[150.227559] [006/133] (866s left) gem_mmap_wc (write)
[150.282096] Subtest write: SKIP (0.000s)
[150.350369] [007/133] (866s left) gem_exec_whisper (basic-forked)
[150.420394] Starting subtest: basic-forked
[156.805154] Subtest basic-forked: SUCCESS (6.382s)
[156.995860] [008/133] (860s left) i915_drm_fdinfo (memory-info-resident)
[157.038381] Starting subtest: memory-info-resident
[157.040709] Starting dynamic subtest: smem0
[159.691977] Dynamic subtest smem0: SUCCESS (2.653s)
[159.694227] Subtest memory-info-resident: SUCCESS (2.654s)
[159.775439] [009/133] (857s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[159.890040] Starting subtest: fbcpsr-rgb101010-draw-blt
[166.666897] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.778s)
[166.836228] [010/133] (850s left) syncobj_wait (invalid-wait-bad-flags)
[166.893528] Starting subtest: invalid-wait-bad-flags
[166.895878] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[167.037144] [011/133] (850s left) kms_flip (2x-dpms-vs-vblank-race)
[167.153283] Starting subtest: 2x-dpms-vs-vblank-race
[167.162265] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[167.297734] [012/133] (850s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[167.405593] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[174.946032] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.542s)
[175.122651] [013/133] (842s left) gem_ctx_param (invalid-set-no-zeromap)
[175.177394] Starting subtest: invalid-set-no-zeromap
[175.179663] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[175.260910] [014/133] (842s left) gem_lmem_swapping (parallel-random)
[175.305544] Subtest parallel-random: SKIP (0.000s)
[175.351428] [015/133] (842s left) kms_scaling_modes (scaling-mode-none)
[175.441877] Starting subtest: scaling-mode-none
[175.444280] Starting dynamic subtest: pipe-A-eDP-1
[175.540772] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[175.551026] Starting dynamic subtest: pipe-B-eDP-1
[175.575228] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[175.583723] Starting dynamic subtest: pipe-C-eDP-1
[175.612509] Dynamic subtest pipe-C-eDP-1: SKIP (0.036s)
[175.625661] Starting dynamic subtest: pipe-D-eDP-1
[175.647604] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s)
[175.651749] Subtest scaling-mode-none: SKIP (0.203s)
[175.796614] [016/133] (841s left) kms_flip (busy-flip)
[175.891981] Starting subtest: busy-flip
[175.893942] Starting dynamic subtest: A-eDP1
[177.639552] Dynamic subtest A-eDP1: SUCCESS (1.748s)
[177.649711] Starting dynamic subtest: B-eDP1
[179.290579] Dynamic subtest B-eDP1: SUCCESS (1.650s)
[179.301022] Starting dynamic subtest: C-eDP1
[181.004299] Dynamic subtest C-eDP1: SUCCESS (1.712s)
[181.014051] Starting dynamic subtest: D-eDP1
[182.630448] Dynamic subtest D-eDP1: SUCCESS (1.626s)
[182.632813] Subtest busy-flip: SUCCESS (6.743s)
[183.898893] [017/133] (833s left) gem_spin_batch (legacy-resubmit-new)
[183.963021] Starting subtest: legacy-resubmit-new
[183.965533] Starting dynamic subtest: default
[183.971128] Dynamic subtest default: SUCCESS (0.007s)
[183.981450] Starting dynamic subtest: render
[183.983373] Dynamic subtest render: SUCCESS (0.003s)
[183.991332] Starting dynamic subtest: bsd
[183.993565] Dynamic subtest bsd: SUCCESS (0.004s)
[184.000783] Starting dynamic subtest: bsd1
[184.003187] Dynamic subtest bsd1: SUCCESS (0.005s)
[184.010218] Starting dynamic subtest: bsd2
[184.012477] Dynamic subtest bsd2: SUCCESS (0.003s)
[184.019724] Starting dynamic subtest: blt
[184.022055] Dynamic subtest blt: SUCCESS (0.007s)
[184.032979] Starting dynamic subtest: vebox
[184.035262] Dynamic subtest vebox: SUCCESS (0.006s)
[184.037493] Subtest legacy-resubmit-new: SUCCESS (0.038s)
[185.928052] [018/133] (831s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[186.027556] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[186.031841] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[186.135065] [019/133] (831s left) syncobj_wait (single-wait-all-for-submit-submitted)
[186.199683] Starting subtest: single-wait-all-for-submit-submitted
[186.306070] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[186.392134] [020/133] (831s left) i915_pm_rc6_residency (rc6-accuracy)
[186.448262] Starting subtest: rc6-accuracy
[186.450528] Starting dynamic subtest: gt0
[189.621210] Dynamic subtest gt0: SUCCESS (3.170s)
[189.631141] Starting dynamic subtest: gt1
[192.791934] Dynamic subtest gt1: SUCCESS (3.169s)
[192.794563] Subtest rc6-accuracy: SUCCESS (6.342s)
[192.885127] [021/133] (824s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[192.998556] Starting subtest: 4-tiled-16bpp-rotate-270
[193.016804] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.018s)
[193.150229] [022/133] (824s left) fbdev (write)
[193.203848] Starting subtest: write
[193.565435] Subtest write: SUCCESS (0.360s)
[193.655206] [023/133] (824s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[193.872914] Starting subtest: cursor-rapid-movement-128x128
[193.877396] Starting dynamic subtest: pipe-A-eDP-1
[194.424659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[194.451167] Starting dynamic subtest: pipe-D-eDP-1
[195.612328] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.166s)
[195.614770] Subtest cursor-rapid-movement-128x128: SUCCESS (1.738s)
[196.455909] [024/133] (821s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[196.571643] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[203.882702] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.315s)
[204.030269] [025/133] (813s left) kms_sequence (get-forked)
[204.114128] Starting subtest: get-forked
[204.116449] Starting dynamic subtest: pipe-A-eDP-1
[206.004631] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s)
[206.014816] Starting dynamic subtest: pipe-B-eDP-1
[208.586814] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.581s)
[208.602569] Starting dynamic subtest: pipe-C-eDP-1
[211.143274] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.556s)
[211.151850] Starting dynamic subtest: pipe-D-eDP-1
[213.636534] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.492s)
[213.638883] Subtest get-forked: SUCCESS (9.521s)
[214.502468] [026/133] (803s left) core_auth (getclient-simple)
[214.535073] Starting subtest: getclient-simple
[214.564096] Subtest getclient-simple: SUCCESS (0.028s)
[214.681624] [027/133] (803s left) gem_vm_create (isolation)
[214.736033] Starting subtest: isolation
[214.745417] Subtest isolation: SUCCESS (0.009s)
[214.881880] [028/133] (803s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[215.020564] Starting subtest: verify-pxp-key-change-after-suspend-resume
[222.339164] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.319s)
[222.501322] [029/133] (795s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[222.627600] Starting subtest: fbc-pr-cursor-plane-update-sf
[222.631642] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[222.705282] [030/133] (795s left) gem_userptr_blits (sync-overlap)
[222.773930] Starting subtest: sync-overlap
[222.776853] Subtest sync-overlap: SUCCESS (0.000s)
[222.916848] [031/133] (795s left) kms_big_fb (linear-32bpp-rotate-90)
[223.022197] Starting subtest: linear-32bpp-rotate-90
[223.041830] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[223.178564] [032/133] (794s left) kms_dp_link_training (uhbr-sst)
[223.294508] Starting subtest: uhbr-sst
[223.301539] Subtest uhbr-sst: SKIP (0.000s)
[223.376173] [033/133] (794s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[223.472459] Starting subtest: fbc-pr-cursor-mmap-gtt
[223.475814] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[223.554993] [034/133] (794s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[223.649939] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[223.651784] Starting dynamic subtest: pipe-A-eDP-1
[223.745461] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[223.755548] Starting dynamic subtest: pipe-B-eDP-1
[224.899730] Dynamic subtest pipe-B-eDP-1: SKIP (1.152s)
[224.904345] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.254s)
[226.123835] [035/133] (792s left) gem_exec_fence (syncobj-repeat)
[226.593135] Starting subtest: syncobj-repeat
[226.766741] Subtest syncobj-repeat: SUCCESS (0.172s)
[228.013972] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[228.016839] [036/133] (790s left) syncobj_timeline (transfer-timeline-point)
[228.072959] Starting subtest: transfer-timeline-point
[228.075307] Subtest transfer-timeline-point: SUCCESS (0.000s)
[228.183841] [037/133] (790s left) kms_addfb_basic (bad-pitch-0)
[228.238618] Starting subtest: bad-pitch-0
[228.240996] Subtest bad-pitch-0: SUCCESS (0.000s)
[228.380219] [038/133] (790s left) dmabuf_sync_file (import-multiple-read-write)
[228.421567] Starting subtest: import-multiple-read-write
[228.423928] Subtest import-multiple-read-write: SUCCESS (0.003s)
[228.490072] [039/133] (789s left) kms_plane (plane-position-covered)
[228.587302] Starting subtest: plane-position-covered
[229.102699] Starting dynamic subtest: pipe-A-plane-1
[230.382728] Dynamic subtest pipe-A-plane-1: SUCCESS (1.280s)
[230.393561] Starting dynamic subtest: pipe-A-plane-2
[231.669712] Dynamic subtest pipe-A-plane-2: SUCCESS (1.285s)
[231.678095] Starting dynamic subtest: pipe-A-plane-3
[232.913797] Dynamic subtest pipe-A-plane-3: SUCCESS (1.241s)
[232.923902] Starting dynamic subtest: pipe-A-plane-4
[234.146928] Dynamic subtest pipe-A-plane-4: SUCCESS (1.234s)
[234.156752] Starting dynamic subtest: pipe-A-plane-5
[234.171840] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[235.326967] Starting dynamic subtest: pipe-B-plane-1
[236.655364] Dynamic subtest pipe-B-plane-1: SUCCESS (1.334s)
[236.667084] Starting dynamic subtest: pipe-B-plane-2
[237.956505] Dynamic subtest pipe-B-plane-2: SUCCESS (1.300s)
[237.965919] Starting dynamic subtest: pipe-B-plane-3
[239.184997] Dynamic subtest pipe-B-plane-3: SUCCESS (1.229s)
[239.196570] Starting dynamic subtest: pipe-B-plane-4
[240.422848] Dynamic subtest pipe-B-plane-4: SUCCESS (1.235s)
[240.431989] Starting dynamic subtest: pipe-B-plane-5
[240.447219] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[240.449482] Subtest plane-position-covered: SUCCESS (11.860s)
[241.241786] [040/133] (777s left) kms_addfb_basic (invalid-get-prop)
[241.314906] Starting subtest: invalid-get-prop
[241.317254] Subtest invalid-get-prop: SUCCESS (0.000s)
[241.488646] [041/133] (777s left) kms_plane_alpha_blend (coverage-7efc)
[241.593544] Starting subtest: coverage-7efc
[241.884560] Starting dynamic subtest: pipe-A-eDP-1
[242.460973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[242.487765] Starting dynamic subtest: pipe-D-eDP-1
[243.737908] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[243.740362] Subtest coverage-7efc: SUCCESS (2.147s)
[244.605410] [042/133] (773s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[244.704394] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[244.708671] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[244.843779] [043/133] (773s left) kms_flip (flip-vs-expired-vblank)
[244.939016] Starting subtest: flip-vs-expired-vblank
[244.940815] Starting dynamic subtest: A-eDP1
[253.587305] Dynamic subtest A-eDP1: SUCCESS (8.649s)
[253.598088] Starting dynamic subtest: B-eDP1
[262.320232] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[262.329485] Starting dynamic subtest: C-eDP1
[270.944838] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[270.954766] Starting dynamic subtest: D-eDP1
[279.562670] Dynamic subtest D-eDP1: SUCCESS (8.615s)
[279.565085] Subtest flip-vs-expired-vblank: SUCCESS (34.627s)
[280.761624] [044/133] (737s left) perf_pmu (pmu-read)
[280.798699] Starting subtest: pmu-read
[280.801056] Subtest pmu-read: SUCCESS (0.002s)
[280.930335] [045/133] (737s left) kms_lease (master-vs-lease)
[281.033163] Starting subtest: master-vs-lease
[281.035296] Subtest master-vs-lease: SUCCESS (0.001s)
[281.163545] [046/133] (737s left) kms_prime (basic-modeset-hybrid)
[281.247207] Subtest basic-modeset-hybrid: SKIP (0.000s)
[281.361778] [047/133] (737s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[281.487975] Starting subtest: cursor-vs-flip-toggle
[312.182592] Subtest cursor-vs-flip-toggle: SUCCESS (30.693s)
[313.071518] [048/133] (705s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[313.136802] Starting subtest: multi-wait-all-for-submit-signaled
[313.139120] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[313.259192] [049/133] (705s left) kms_atomic_interruptible (legacy-pageflip)
[313.365256] Starting subtest: legacy-pageflip
[313.367533] Starting dynamic subtest: pipe-A-eDP-1
[320.783074] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.416s)
[320.785379] Subtest legacy-pageflip: SUCCESS (7.418s)
[321.621442] [050/133] (697s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[321.722810] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[321.725082] Starting dynamic subtest: pipe-A-eDP-1
[321.781622] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[321.790972] Starting dynamic subtest: pipe-B-eDP-1
[321.844791] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[321.852993] Starting dynamic subtest: pipe-C-eDP-1
[321.906846] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[321.915329] Starting dynamic subtest: pipe-D-eDP-1
[321.968687] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[321.972974] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[323.911471] [051/133] (695s left) kms_flip (2x-plain-flip-interruptible)
[324.016966] Starting subtest: 2x-plain-flip-interruptible
[324.027998] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[324.159221] [052/133] (694s left) kms_psr (psr2-cursor-mmap-cpu)
[324.248163] Starting subtest: psr2-cursor-mmap-cpu
[324.250394] Starting dynamic subtest: eDP-1
[325.987135] Dynamic subtest eDP-1: SUCCESS (1.739s)
[325.989484] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.740s)
[326.805982] [053/133] (692s left) gem_fence_thrash (bo-write-verify-y)
[326.845533] Starting subtest: bo-write-verify-y
[326.880432] Subtest bo-write-verify-y: SKIP (0.030s)
[326.948781] [054/133] (692s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[327.054834] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[327.059026] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[327.188268] [055/133] (691s left) gem_exec_balancer (bonded-pair)
[327.269843] Starting subtest: bonded-pair
[327.274430] Subtest bonded-pair: SKIP (0.000s)
[327.605394] [056/133] (691s left) kms_invalid_mode (clock-too-high)
[327.696573] Starting subtest: clock-too-high
[327.699019] Starting dynamic subtest: pipe-A-eDP-1
[327.703627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[327.717058] Starting dynamic subtest: pipe-B-eDP-1
[327.721340] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.730487] Starting dynamic subtest: pipe-C-eDP-1
[327.734914] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.742977] Starting dynamic subtest: pipe-D-eDP-1
[327.747340] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.751678] Subtest clock-too-high: SKIP (0.004s)
[327.788524] [057/133] (691s left) kms_cdclk (mode-transition)
[327.882974] Starting subtest: mode-transition
[327.885295] Starting dynamic subtest: pipe-A-eDP-1
[328.177566] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[328.186823] Starting dynamic subtest: pipe-B-eDP-1
[328.191507] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[328.200477] Starting dynamic subtest: pipe-C-eDP-1
[328.205115] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[328.213771] Starting dynamic subtest: pipe-D-eDP-1
[328.218120] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[328.222334] Subtest mode-transition: SKIP (0.300s)
[329.023251] [058/133] (690s left) gen9_exec_parse (batch-zero-length)
[329.093303] Subtest batch-zero-length: SKIP (0.000s)
[329.193207] [059/133] (690s left) kms_flip (plain-flip-ts-check)
[329.298359] Starting subtest: plain-flip-ts-check
[329.300737] Starting dynamic subtest: A-eDP1
[338.198703] Dynamic subtest A-eDP1: SUCCESS (8.902s)
[338.211744] Starting dynamic subtest: B-eDP1
[347.021764] Dynamic subtest B-eDP1: SUCCESS (8.821s)
[347.032061] Starting dynamic subtest: C-eDP1
[355.848079] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[355.857648] Starting dynamic subtest: D-eDP1
[364.676168] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[364.680875] Subtest plain-flip-ts-check: SUCCESS (35.384s)
[365.865937] [060/133] (653s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[365.967366] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[365.971377] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[366.097085] [061/133] (653s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[366.159181] Starting subtest: invalid-bsd1-flag-on-blt
[366.161477] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[366.279948] [062/133] (653s left) perf (gen8-unprivileged-single-ctx-counters)
[366.424201] Starting subtest: gen8-unprivileged-single-ctx-counters
[366.427870] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[366.469999] [063/133] (652s left) kms_vrr (lobf)
[366.568190] Starting subtest: lobf
[366.572503] Subtest lobf: SKIP (0.000s)
[366.671550] [064/133] (652s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[366.771149] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[366.775111] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[366.886837] [065/133] (652s left) kms_psr (psr-cursor-blt)
[366.977123] Starting subtest: psr-cursor-blt
[366.978986] Starting dynamic subtest: eDP-1
[368.674254] Dynamic subtest eDP-1: SUCCESS (1.698s)
[368.676567] Subtest psr-cursor-blt: SUCCESS (1.699s)
[369.539474] [066/133] (650s left) syncobj_timeline (etime-multi-wait-all-submitted)
[369.615634] Starting subtest: etime-multi-wait-all-submitted
[369.721987] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[369.813171] [067/133] (649s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[369.903208] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[369.905486] Starting dynamic subtest: pipe-A-eDP-1
[369.929110] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[369.939236] Starting dynamic subtest: pipe-B-eDP-1
[369.961122] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[369.969919] Starting dynamic subtest: pipe-C-eDP-1
[369.992455] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[370.002273] Starting dynamic subtest: pipe-D-eDP-1
[370.024430] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[370.028527] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[372.207455] [068/133] (647s left) i915_getparams_basic (basic-eu-total)
[372.273509] Starting subtest: basic-eu-total
[372.277751] Subtest basic-eu-total: SUCCESS (0.000s)
[372.383978] [069/133] (647s left) kms_cursor_edge_walk (128x128-top-edge)
[372.472989] Starting subtest: 128x128-top-edge
[372.475399] Starting dynamic subtest: pipe-A-eDP-1
[375.942947] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s)
[375.952544] Starting dynamic subtest: pipe-D-eDP-1
[379.068858] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[379.070829] Subtest 128x128-top-edge: SUCCESS (6.595s)
[379.906618] [070/133] (639s left) gen3_render_linear_blits
[380.022783] [071/133] (639s left) kms_flip (flip-vs-wf_vblank-interruptible)
[380.121272] Starting subtest: flip-vs-wf_vblank-interruptible
[380.123579] Starting dynamic subtest: A-eDP1
[382.031248] Dynamic subtest A-eDP1: SUCCESS (1.908s)
[382.042077] Starting dynamic subtest: B-eDP1
[383.962841] Dynamic subtest B-eDP1: SUCCESS (1.930s)
[383.977932] Starting dynamic subtest: C-eDP1
[385.876903] Dynamic subtest C-eDP1: SUCCESS (1.913s)
[385.885511] Starting dynamic subtest: D-eDP1
[387.796959] Dynamic subtest D-eDP1: SUCCESS (1.919s)
[387.799290] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.679s)
[389.030161] [072/133] (630s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[389.127785] Starting subtest: fbc-shrfb-scaledprimary
[392.142869] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.019s)
[393.332308] [073/133] (626s left) kms_vblank (query-idle-hang)
[393.434924] Starting subtest: query-idle-hang
[393.437256] Starting dynamic subtest: pipe-A-eDP-1
[419.670253] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.235s)
[419.684245] Starting dynamic subtest: pipe-D-eDP-1
[445.669773] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.994s)
[445.671982] Subtest query-idle-hang: SUCCESS (52.233s)
[446.481393] [074/133] (573s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[446.578018] Starting subtest: y-tiled-64bpp-rotate-0
[446.582143] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[446.715028] [075/133] (573s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[446.775242] Starting subtest: multi-wait-all-available-submitted-signaled
[446.777350] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[446.895125] [076/133] (573s left) syncobj_basic (bad-flags-handle-to-fd)
[446.952957] Starting subtest: bad-flags-handle-to-fd
[446.954975] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[447.072103] [077/133] (572s left) gem_pread (self)
[447.139628] Subtest self: SKIP (0.000s)
[447.209820] [078/133] (572s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[447.321979] Starting subtest: basic-flip-after-cursor-legacy
[448.235448] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s)
[449.110440] [079/133] (570s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[449.203993] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[449.206302] Starting dynamic subtest: pipe-A-default-mode
[451.969006] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[451.971440] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.768s)
[452.826694] [080/133] (567s left) syncobj_basic (bad-destroy-pad)
[452.893741] Starting subtest: bad-destroy-pad
[452.896017] Subtest bad-destroy-pad: SUCCESS (0.000s)
[453.018989] [081/133] (567s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[453.115753] Starting subtest: psr-dirtyfb-ioctl
[453.117883] Starting dynamic subtest: A-eDP-1
[457.081630] Dynamic subtest A-eDP-1: SUCCESS (3.966s)
[457.084052] Subtest psr-dirtyfb-ioctl: SUCCESS (3.968s)
[457.883900] [082/133] (562s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[457.979202] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[461.915704] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.939s)
[463.059551] [083/133] (557s left) sysfs_preempt_timeout (idempotent)
[463.124415] Starting subtest: idempotent
[463.126631] Starting dynamic subtest: vecs0
[463.128920] Dynamic subtest vecs0: SUCCESS (0.000s)
[463.139304] Starting dynamic subtest: ccs0
[463.141161] Dynamic subtest ccs0: SUCCESS (0.000s)
[463.149366] Starting dynamic subtest: vcs0
[463.151533] Dynamic subtest vcs0: SUCCESS (0.000s)
[463.159558] Starting dynamic subtest: bcs0
[463.161470] Dynamic subtest bcs0: SUCCESS (0.000s)
[463.169217] Starting dynamic subtest: rcs0
[463.171066] Dynamic subtest rcs0: SUCCESS (0.000s)
[463.178822] Starting dynamic subtest: vcs1
[463.180751] Dynamic subtest vcs1: SUCCESS (0.000s)
[463.182640] Subtest idempotent: SUCCESS (0.006s)
[463.218715] [084/133] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[463.317244] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[463.321593] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[463.451503] [085/133] (556s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[463.540130] Starting subtest: fbc-psr2-sprite-mmap-cpu
[463.542206] Starting dynamic subtest: eDP-1
[463.546121] Dynamic subtest eDP-1: SKIP (0.000s)
[463.550039] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[463.624120] [086/133] (556s left) prime_self_import (export-vs-gem_close-race)
[463.667682] Starting subtest: export-vs-gem_close-race
[468.758407] Subtest export-vs-gem_close-race: SUCCESS (5.092s)
[468.847991] [087/133] (551s left) kms_content_protection (srm)
[469.009596] Starting subtest: srm
[469.017755] Subtest srm: SKIP (0.003s)
[469.185865] [088/133] (551s left) gem_exec_async (concurrent-writes)
[469.247192] Starting subtest: concurrent-writes
[469.249402] Starting dynamic subtest: rcs0
[469.265331] Dynamic subtest rcs0: SUCCESS (0.018s)
[469.276297] Starting dynamic subtest: bcs0
[469.278569] Dynamic subtest bcs0: SUCCESS (0.005s)
[469.287584] Starting dynamic subtest: vcs0
[469.289801] Dynamic subtest vcs0: SUCCESS (0.005s)
[469.298344] Starting dynamic subtest: vcs1
[469.300608] Dynamic subtest vcs1: SUCCESS (0.007s)
[469.308955] Starting dynamic subtest: vecs0
[469.311085] Dynamic subtest vecs0: SUCCESS (0.005s)
[469.319350] Starting dynamic subtest: ccs0
[469.321484] Dynamic subtest ccs0: SUCCESS (0.005s)
[469.323607] Subtest concurrent-writes: SUCCESS (0.051s)
[469.544461] [089/133] (550s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[469.924845] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[470.755072] [090/133] (549s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[470.854048] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[470.856215] Starting dynamic subtest: pipe-A-eDP-1
[471.267321] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[471.275779] Starting dynamic subtest: pipe-B-eDP-1
[471.295652] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[471.304062] Starting dynamic subtest: pipe-C-eDP-1
[471.323764] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[471.332000] Starting dynamic subtest: pipe-D-eDP-1
[471.351267] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[471.353442] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.428s)
[473.542183] [091/133] (547s left) gem_create (create-size-update)
[473.599195] Starting subtest: create-size-update
[473.601317] Subtest create-size-update: SUCCESS (0.000s)
[473.830165] [092/133] (546s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[473.913360] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[473.915582] Starting dynamic subtest: A-eDP1
[477.554730] Dynamic subtest A-eDP1: SUCCESS (3.639s)
[477.565224] Starting dynamic subtest: B-eDP1
[480.739059] Dynamic subtest B-eDP1: SUCCESS (3.182s)
[480.748791] Starting dynamic subtest: C-eDP1
[483.817714] Dynamic subtest C-eDP1: SUCCESS (3.078s)
[483.830704] Starting dynamic subtest: D-eDP1
[486.917531] Dynamic subtest D-eDP1: SUCCESS (3.098s)
[486.919447] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.005s)
[487.745148] [093/133] (532s left) kms_cursor_crc (cursor-alpha-transparent)
[487.833951] Starting subtest: cursor-alpha-transparent
[487.836102] Starting dynamic subtest: pipe-A-eDP-1
[488.445488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s)
[488.456304] Starting dynamic subtest: pipe-D-eDP-1
[489.708132] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.259s)
[489.709956] Subtest cursor-alpha-transparent: SUCCESS (1.874s)
[490.514481] [094/133] (530s left) kms_plane_multiple (tiling-yf)
[490.606115] Starting subtest: tiling-yf
[490.610181] Subtest tiling-yf: SKIP (0.000s)
[490.704433] [095/133] (530s left) i915_query (query-topology-garbage-items)
[490.757755] Starting subtest: query-topology-garbage-items
[490.759730] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[490.867843] [096/133] (529s left) gem_mmap_gtt (bad-object)
[490.925635] Subtest bad-object: SKIP (0.000s)
[490.993399] [097/133] (529s left) gem_exec_schedule (preempt-queue-contexts-chain)
[491.070579] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[491.368871] [098/133] (529s left) gem_exec_reloc (basic-write-read-noreloc)
[491.428585] Subtest basic-write-read-noreloc: SKIP (0.000s)
[491.514304] [099/133] (529s left) kms_atomic (plane-primary-legacy)
[491.612110] Starting subtest: plane-primary-legacy
[491.614410] Starting dynamic subtest: pipe-A-eDP-1
[492.056880] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[492.059196] Subtest plane-primary-legacy: SUCCESS (0.446s)
[492.951996] [100/133] (528s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[493.045299] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[500.245927] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.203s)
[500.403616] [101/133] (520s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[500.506390] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[500.510339] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[500.644464] [102/133] (520s left) prime_vgem (basic-fence-flip)
[500.734820] Starting subtest: basic-fence-flip
[501.034012] Subtest basic-fence-flip: SUCCESS (0.302s)
[501.155935] [103/133] (519s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[501.259323] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[501.272474] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[501.342463] [104/133] (519s left) gem_ctx_persistence (userptr)
[501.409550] Starting subtest: userptr
[501.614649] Subtest userptr: SUCCESS (0.208s)
[501.722406] [105/133] (519s left) sw_sync (sync_busy_fork_unixsocket)
[501.755906] Starting subtest: sync_busy_fork_unixsocket
[501.762578] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[501.823979] [106/133] (519s left) gem_userptr_blits (sync-unmap-cycles)
[501.891351] Starting subtest: sync-unmap-cycles
[507.260280] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[507.440370] [107/133] (513s left) gem_mmap_gtt (zero-extend)
[507.498993] Subtest zero-extend: SKIP (0.000s)
[507.568141] [108/133] (513s left) kms_properties (plane-properties-atomic)
[507.663761] Starting subtest: plane-properties-atomic
[507.665734] Starting dynamic subtest: pipe-A-eDP-1
[508.216228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[508.226082] Starting dynamic subtest: pipe-B-eDP-1
[509.523647] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.306s)
[509.532225] Starting dynamic subtest: pipe-C-eDP-1
[510.767487] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.243s)
[510.776844] Starting dynamic subtest: pipe-D-eDP-1
[512.007254] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[512.009534] Subtest plane-properties-atomic: SUCCESS (4.342s)
[512.833406] [109/133] (508s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[512.942021] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[512.946274] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[513.096375] [110/133] (508s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[513.192844] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[513.572749] Starting dynamic subtest: pipe-A-eDP-1
[516.377755] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.803s)
[516.750039] Starting dynamic subtest: pipe-B-eDP-1
[519.504072] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[519.872633] Starting dynamic subtest: pipe-C-eDP-1
[522.636250] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[522.994364] Starting dynamic subtest: pipe-D-eDP-1
[525.777185] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.789s)
[525.779563] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.585s)
[526.980809] [111/133] (494s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[527.086835] Starting subtest: pipe-fbc-rte
[527.093597] Starting dynamic subtest: pipe-B-eDP-1
[532.537068] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.454s)
[532.545152] Subtest pipe-fbc-rte: SUCCESS (5.457s)
[534.803476] [112/133] (486s left) api_intel_allocator (execbuf-with-allocator)
[534.857291] Starting subtest: execbuf-with-allocator
[534.868566] Subtest execbuf-with-allocator: SUCCESS (0.011s)
[535.064824] [113/133] (486s left) gem_exec_reloc (basic-gtt-noreloc)
[535.135772] Subtest basic-gtt-noreloc: SKIP (0.000s)
[535.208877] [114/133] (486s left) gem_exec_params (invalid-batch-start-offset)
[535.276408] Starting subtest: invalid-batch-start-offset
[535.281907] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[535.445109] [115/133] (486s left) kms_color (legacy-gamma-reset)
[535.534177] Starting subtest: legacy-gamma-reset
[535.536342] Starting dynamic subtest: pipe-A-eDP-1
[535.919769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s)
[535.928261] Starting dynamic subtest: pipe-B-eDP-1
[535.933131] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[535.941281] Starting dynamic subtest: pipe-C-eDP-1
[535.943591] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[535.951768] Starting dynamic subtest: pipe-D-eDP-1
[535.956963] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[535.959153] Subtest legacy-gamma-reset: SUCCESS (0.423s)
[536.738460] [116/133] (484s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[536.801538] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[536.806106] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[536.997603] [117/133] (484s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[537.101092] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[537.105286] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[537.198905] [118/133] (484s left) prime_busy (hang-wait)
[537.253595] Starting subtest: hang-wait
[537.255853] Starting dynamic subtest: rcs0
[563.380081] Dynamic subtest rcs0: SUCCESS (26.123s)
[563.390303] Starting dynamic subtest: bcs0
[570.534487] Dynamic subtest bcs0: SUCCESS (7.152s)
[570.544748] Starting dynamic subtest: vcs0
[577.509747] Dynamic subtest vcs0: SUCCESS (6.972s)
[577.517991] Starting dynamic subtest: vcs1
[584.481824] Dynamic subtest vcs1: SUCCESS (6.969s)
[584.492248] Starting dynamic subtest: vecs0
[591.523741] Dynamic subtest vecs0: SUCCESS (7.040s)
[591.532205] Starting dynamic subtest: ccs0
[605.362370] Dynamic subtest ccs0: SUCCESS (13.836s)
[605.364675] Subtest hang-wait: SUCCESS (68.107s)
[605.516130] [119/133] (416s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[607.153618] Starting subtest: dpms-mode-unset-lpsp
[611.191387] Subtest dpms-mode-unset-lpsp: SUCCESS (4.042s)
[611.591726] [120/133] (410s left) gem_exec_balancer (waits)
[611.651760] Starting subtest: waits
[618.116120] Subtest waits: SUCCESS (6.464s)
[618.438435] [121/133] (403s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[618.536237] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[622.998768] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.466s)
[624.177346] [122/133] (397s left) syncobj_eventfd (timeline-wait-signaled)
[624.239870] Starting subtest: timeline-wait-signaled
[624.242274] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[624.375862] [123/133] (397s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[624.472600] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[624.477055] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[624.600602] [124/133] (397s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[624.660586] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[624.730710] [125/133] (397s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[624.830173] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[624.834126] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[624.945476] [126/133] (397s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[625.334311] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[626.168388] [127/133] (396s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[626.232403] Starting subtest: invalid-bsd2-flag-on-blt
[626.234754] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[626.363920] [128/133] (395s left) gem_exec_schedule (in-order)
[626.428403] Starting subtest: in-order
[626.430588] Starting dynamic subtest: rcs0
[626.512975] Dynamic subtest rcs0: SUCCESS (0.092s)
[626.524831] Starting dynamic subtest: vcs0
[626.593053] Dynamic subtest vcs0: SUCCESS (0.079s)
[626.603525] Starting dynamic subtest: vcs1
[626.679599] Dynamic subtest vcs1: SUCCESS (0.085s)
[626.690736] Starting dynamic subtest: vecs0
[626.757157] Dynamic subtest vecs0: SUCCESS (0.077s)
[626.770267] Starting dynamic subtest: ccs0
[626.846910] Dynamic subtest ccs0: SUCCESS (0.089s)
[626.849070] Subtest in-order: SUCCESS (0.427s)
[628.036213] [129/133] (394s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[628.137754] Starting subtest: fbc-psr2-sprite-plane-onoff
[628.139999] Starting dynamic subtest: eDP-1
[628.144171] Dynamic subtest eDP-1: SKIP (0.000s)
[628.148148] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[628.234137] [130/133] (394s left) gem_exec_reloc (basic-write-cpu)
[628.293144] Subtest basic-write-cpu: SKIP (0.000s)
[628.378838] [131/133] (393s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[628.479021] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[628.481142] Starting dynamic subtest: pipe-A
[628.497606] Dynamic subtest pipe-A: SKIP (0.016s)
[628.507202] Starting dynamic subtest: pipe-B
[628.530096] Dynamic subtest pipe-B: SKIP (0.030s)
[628.538847] Starting dynamic subtest: pipe-C
[628.559700] Dynamic subtest pipe-C: SKIP (0.028s)
[628.570664] Starting dynamic subtest: pipe-D
[628.587062] Dynamic subtest pipe-D: SKIP (0.029s)
[628.590782] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.106s)
[628.707727] [132/133] (393s left) kms_hdr (brightness-with-hdr)
[628.815163] Starting subtest: brightness-with-hdr
[628.821533] Subtest brightness-with-hdr: SKIP (0.000s)
[628.900647] [133/133] (393s left) gem_close_race (basic-process)
[628.973327] Starting subtest: basic-process
[629.049077] Subtest basic-process: SUCCESS (0.076s)
[629.240292] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_mmap_wc
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_param
results: parsing output: 13/ for test: gem_lmem_swapping
results: parsing output: 14/ for test: kms_scaling_modes
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_spin_batch
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: i915_pm_rc6_residency
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: fbdev
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_sequence
results: parsing output: 25/ for test: core_auth
results: parsing output: 26/ for test: gem_vm_create
results: parsing output: 27/ for test: gem_pxp
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_dp_link_training
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_plane_alpha_blend
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_lease
results: parsing output: 45/ for test: kms_prime
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_atomic_interruptible
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_fence_thrash
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_cdclk
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: i915_getparams_basic
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: gen3_render_linear_blits
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_basic
results: parsing output: 76/ for test: gem_pread
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: kms_dirtyfb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: sysfs_preempt_timeout
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: prime_self_import
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: gem_exec_async
results: parsing output: 88/ for test: kms_chamelium_hpd
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_create
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_plane_multiple
results: parsing output: 94/ for test: i915_query
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_atomic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: sw_sync
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_properties
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_async_flips
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_eventfd
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pipe_b_c_ivb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_frames
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: kms_hdr
results: parsing output: 132/ for test: gem_close_race
Done.