[59.841678] Initializing watchdogs
[59.841818]   /dev/watchdog0
[59.856469] [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]
[59.860558] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.862633] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.865946] [001/130] (960s left) gem_exec_balancer (parallel-keep-submit-fence)
[60.186720] Starting subtest: parallel-keep-submit-fence
[61.097698] Subtest parallel-keep-submit-fence: SUCCESS (0.911s)
[61.173324] [002/130] (959s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[61.275058] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[61.277494] Starting dynamic subtest: pipe-A-default-mode
[62.377462] Dynamic subtest pipe-A-default-mode: SKIP (1.098s)
[62.382472] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.099s)
[62.532307] [003/130] (957s left) kms_cursor_legacy (torture-bo)
[62.659673] Starting subtest: torture-bo
[62.661696] Starting dynamic subtest: pipe-A
[68.480060] Dynamic subtest pipe-A: SUCCESS (5.817s)
[68.489870] Starting dynamic subtest: pipe-B
[74.803326] Dynamic subtest pipe-B: SUCCESS (6.323s)
[74.812148] Starting dynamic subtest: pipe-C
[81.295919] Dynamic subtest pipe-C: SUCCESS (6.492s)
[81.305524] Starting dynamic subtest: pipe-D
[87.623614] Dynamic subtest pipe-D: SUCCESS (6.326s)
[87.632765] Starting dynamic subtest: all-pipes
[93.381865] Dynamic subtest all-pipes: SUCCESS (5.758s)
[93.384465] Subtest torture-bo: SUCCESS (30.718s)
[93.518345] [004/130] (926s left) gem_ctx_shared (q-out-order)
[93.580836] Starting subtest: Q-out-order
[93.583282] Starting dynamic subtest: rcs0
[93.696517] Dynamic subtest rcs0: SUCCESS (0.115s)
[93.710415] Starting dynamic subtest: vcs0
[93.769373] Dynamic subtest vcs0: SUCCESS (0.073s)
[93.783327] Starting dynamic subtest: vcs1
[93.839220] Dynamic subtest vcs1: SUCCESS (0.070s)
[93.854140] Starting dynamic subtest: vecs0
[93.912852] Dynamic subtest vecs0: SUCCESS (0.073s)
[93.926510] Starting dynamic subtest: ccs0
[93.983970] Dynamic subtest ccs0: SUCCESS (0.071s)
[93.986866] Subtest Q-out-order: SUCCESS (0.402s)
[95.069335] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[95.072400] [005/130] (925s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[95.178601] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[100.388508] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (5.211s)
[100.516717] [006/130] (920s left) perf (rc6-disable)
[100.625842] Starting subtest: rc6-disable
[100.820281] Subtest rc6-disable: SUCCESS (0.197s)
[100.866497] [007/130] (919s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[100.973677] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[100.978273] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[101.080720] [008/130] (919s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[101.187610] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[101.192100] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[101.278954] [009/130] (919s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[101.380665] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[101.382491] Starting dynamic subtest: pipe-A-eDP-1
[101.403047] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.411069] Starting dynamic subtest: pipe-B-eDP-1
[101.430198] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.436220] Starting dynamic subtest: pipe-C-eDP-1
[101.455789] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.462074] Starting dynamic subtest: pipe-D-eDP-1
[101.482210] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.486374] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s)
[103.565201] [010/130] (917s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[103.661927] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[103.663910] Starting dynamic subtest: pipe-A-eDP-1
[104.087380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[104.095360] Starting dynamic subtest: pipe-B-eDP-1
[105.458849] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s)
[105.467768] Starting dynamic subtest: pipe-C-eDP-1
[106.865243] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.407s)
[106.874571] Starting dynamic subtest: pipe-D-eDP-1
[108.189126] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[108.191060] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.500s)
[109.370908] [011/130] (911s left) gem_exec_reloc (basic-write-read)
[109.442873] Subtest basic-write-read: SKIP (0.000s)
[109.521798] [012/130] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[109.628462] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[115.115021] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.491s)
[115.232874] [013/130] (905s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[115.338204] Starting subtest: fbc-psr2-cursor-plane-onoff
[115.340446] Starting dynamic subtest: eDP-1
[115.344533] Dynamic subtest eDP-1: SKIP (0.000s)
[115.348700] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[115.411345] [014/130] (905s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[115.503937] Starting subtest: coverage-vs-premult-vs-constant
[115.947643] Starting dynamic subtest: pipe-A-eDP-1
[116.481292] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.532s)
[116.488548] Starting dynamic subtest: pipe-D-eDP-1
[117.727537] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[117.729472] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.221s)
[118.592544] [015/130] (902s left) kms_cursor_crc (cursor-offscreen-64x21)
[118.762399] Starting subtest: cursor-offscreen-64x21
[118.799989] Subtest cursor-offscreen-64x21: SKIP (0.034s)
[119.025202] [016/130] (901s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[119.131894] Starting subtest: fbcpsr-suspend
[157.306089] Subtest fbcpsr-suspend: SUCCESS (7.603s)
[157.416701] [017/130] (894s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[157.529299] Starting subtest: yf-tiled-64bpp-rotate-180
[157.534523] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[157.611854] [018/130] (893s left) i915_pm_freq_api (freq-suspend)
[157.668477] Starting subtest: freq-suspend
[157.671257] Starting dynamic subtest: gt0
[173.900757] Dynamic subtest gt0: SUCCESS (1.123s)
[173.915461] Starting dynamic subtest: gt1
[189.908203] Dynamic subtest gt1: SUCCESS (1.166s)
[189.910223] Subtest freq-suspend: SUCCESS (2.290s)
[190.984602] [019/130] (891s left) gem_exec_whisper (basic-contexts)
[191.047807] Starting subtest: basic-contexts
[196.937068] Subtest basic-contexts: SUCCESS (5.892s)
[197.119207] [020/130] (885s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[197.176052] Starting subtest: invalid-single-wait-unsubmitted
[197.179029] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[197.273576] [021/130] (885s left) kms_dp_link_training (non-uhbr-sst)
[197.384797] Starting subtest: non-uhbr-sst
[197.394917] Subtest non-uhbr-sst: SKIP (0.000s)
[197.451434] [022/130] (885s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[202.482881] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[202.485558] Starting dynamic subtest: pipe-A-eDP-1
[209.080926] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.601s)
[209.090954] Starting dynamic subtest: pipe-B-eDP-1
[215.697624] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.616s)
[215.700013] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.220s)
[216.561071] [023/130] (866s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[216.670497] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[216.675624] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.777471] [024/130] (865s left) kms_psr (psr-dpms)
[216.874348] Starting subtest: psr-dpms
[216.876765] Starting dynamic subtest: eDP-1
[219.892293] Dynamic subtest eDP-1: SUCCESS (3.017s)
[219.895347] Subtest psr-dpms: SUCCESS (3.018s)
[220.734779] [025/130] (861s left) syncobj_eventfd (timeline-wait-signaled)
[220.794974] Starting subtest: timeline-wait-signaled
[220.797626] Subtest timeline-wait-signaled: SUCCESS (0.001s)
[220.887514] [026/130] (861s left) gem_tiling_max_stride
[220.997353] [027/130] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[221.111757] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[221.116986] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[221.218774] [028/130] (861s left) kms_flip (flip-vs-fences-interruptible)
[221.320705] Starting subtest: flip-vs-fences-interruptible
[221.325893] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[221.425322] [029/130] (861s left) gen9_exec_parse (bb-start-out)
[221.487039] Subtest bb-start-out: SKIP (0.000s)
[221.551464] [030/130] (861s left) syncobj_timeline (wait-all-delayed-signal)
[221.611629] Starting subtest: wait-all-delayed-signal
[221.711934] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[221.786651] [031/130] (861s left) gem_mmap_gtt (cpuset-big-copy-odd)
[221.845973] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[221.903766] [032/130] (861s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[221.959324] Starting subtest: y-tiled-to-vebox-y-tiled
[221.963968] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[222.139453] [033/130] (860s left) kms_big_fb (linear-32bpp-rotate-0)
[222.238082] Starting subtest: linear-32bpp-rotate-0
[224.248617] Subtest linear-32bpp-rotate-0: SUCCESS (2.012s)
[224.410330] [034/130] (858s left) i915_selftest (live)
[226.359120] Starting subtest: live
[226.362040] Starting dynamic subtest: sanitycheck
[231.032827] Dynamic subtest sanitycheck: SUCCESS (4.673s)
[231.041740] Starting dynamic subtest: uncore
[235.651477] Dynamic subtest uncore: SUCCESS (4.617s)
[235.661313] Starting dynamic subtest: workarounds
[239.024326] Dynamic subtest workarounds: SUCCESS (3.372s)
[239.033669] Starting dynamic subtest: gt_engines
[242.477385] Dynamic subtest gt_engines: SUCCESS (3.452s)
[242.486847] Starting dynamic subtest: gt_timelines
[257.933575] Dynamic subtest gt_timelines: SUCCESS (15.459s)
[257.941767] Starting dynamic subtest: gt_contexts
[261.005364] Dynamic subtest gt_contexts: SUCCESS (3.072s)
[261.014919] Starting dynamic subtest: gt_lrc
[265.566599] Dynamic subtest gt_lrc: SUCCESS (4.561s)
[265.575755] Starting dynamic subtest: gt_mocs
[268.851478] Dynamic subtest gt_mocs: SUCCESS (3.285s)
[268.858844] Starting dynamic subtest: gt_pm
[273.970316] Dynamic subtest gt_pm: SUCCESS (5.119s)
[273.979070] Starting dynamic subtest: gt_heartbeat
[278.560212] Dynamic subtest gt_heartbeat: SUCCESS (4.590s)
[278.574176] Starting dynamic subtest: gt_tlb
[287.070509] Dynamic subtest gt_tlb: SUCCESS (8.510s)
[287.079874] Starting dynamic subtest: requests
[298.867332] Dynamic subtest requests: SUCCESS (11.790s)
[298.876321] Starting dynamic subtest: migrate
[307.051806] Dynamic subtest migrate: SUCCESS (8.182s)
[307.083823] Starting dynamic subtest: active
[310.054203] Dynamic subtest active: SUCCESS (3.000s)
[310.062856] Starting dynamic subtest: objects
[313.555544] Dynamic subtest objects: SUCCESS (3.499s)
[313.564984] Starting dynamic subtest: mman
[318.697476] Dynamic subtest mman: SUCCESS (5.140s)
[318.707195] Starting dynamic subtest: dmabuf
[321.776927] Dynamic subtest dmabuf: SUCCESS (3.078s)
[321.784091] Starting dynamic subtest: vma
[326.393434] Dynamic subtest vma: SUCCESS (4.616s)
[326.403072] Starting dynamic subtest: coherency
[330.156551] Dynamic subtest coherency: SUCCESS (3.761s)
[330.166065] Starting dynamic subtest: gtt
[340.317032] Dynamic subtest gtt: SUCCESS (10.160s)
[340.326281] Starting dynamic subtest: gem
[346.293497] Dynamic subtest gem: SUCCESS (5.977s)
[346.302939] Starting dynamic subtest: evict
[350.503678] Dynamic subtest evict: SUCCESS (4.210s)
[350.513715] Starting dynamic subtest: hugepages
[359.664722] Dynamic subtest hugepages: SUCCESS (9.161s)
[359.674686] Starting dynamic subtest: gem_contexts
[386.177490] Dynamic subtest gem_contexts: SUCCESS (26.518s)
[386.184784] Starting dynamic subtest: client
[390.788608] Dynamic subtest client: SUCCESS (4.611s)
[390.798388] Starting dynamic subtest: gem_migrate
[393.770794] Dynamic subtest gem_migrate: SUCCESS (2.981s)
[393.784524] Starting dynamic subtest: reset
[398.438289] Dynamic subtest reset: SUCCESS (4.667s)
[398.446651] Starting dynamic subtest: memory_region
[403.077755] Dynamic subtest memory_region: SUCCESS (4.639s)
[403.087053] Starting dynamic subtest: hangcheck
[416.804204] Dynamic subtest hangcheck: SUCCESS (13.726s)
[416.814057] Starting dynamic subtest: execlists
[421.445540] Dynamic subtest execlists: SUCCESS (4.638s)
[421.454915] Starting dynamic subtest: ring_submission
[424.473569] Dynamic subtest ring_submission: SUCCESS (3.025s)
[424.487794] Starting dynamic subtest: perf
[427.688435] Dynamic subtest perf: SUCCESS (3.212s)
[427.698055] Starting dynamic subtest: slpc
[440.145656] Dynamic subtest slpc: SUCCESS (12.452s)
[440.153687] Starting dynamic subtest: guc
[444.358666] Dynamic subtest guc: SUCCESS (4.210s)
[444.369027] Starting dynamic subtest: guc_multi_lrc
[447.379662] Dynamic subtest guc_multi_lrc: SUCCESS (3.019s)
[447.390228] Starting dynamic subtest: guc_hang
[451.105501] Dynamic subtest guc_hang: SUCCESS (3.723s)
[451.115396] Starting dynamic subtest: late_gt_pm
[454.148355] Dynamic subtest late_gt_pm: SUCCESS (3.041s)
[454.151711] Subtest live: SUCCESS (227.804s)
[454.175632] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[454.176418] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[454.180299] [035/130] (628s left) kms_fb_coherency (memset-crc)
[456.106460] Starting subtest: memset-crc
[456.108509] Starting dynamic subtest: mmap-offset-wc
[456.498648] Dynamic subtest mmap-offset-wc: SUCCESS (0.391s)
[456.784038] Starting dynamic subtest: mmap-offset-uc
[462.881922] Dynamic subtest mmap-offset-uc: SUCCESS (6.102s)
[463.162892] Subtest memset-crc: SUCCESS (7.055s)
[463.959043] [FACT kms_fb_coherency (memset-crc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[463.960765] [FACT kms_fb_coherency (memset-crc)] new: kernel.kmod_is_loaded.i915: true
[463.961400] [FACT kms_fb_coherency (memset-crc)] new: kernel.kmod_is_loaded.xe: true
[463.966011] [036/130] (619s left) syncobj_wait (single-wait-all-submitted)
[464.024407] Starting subtest: single-wait-all-submitted
[464.128954] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[464.202891] [037/130] (618s left) gem_caching (read-writes)
[464.268866] Subtest read-writes: SKIP (0.000s)
[464.347446] [038/130] (618s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[464.458832] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[464.463924] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[464.532551] [039/130] (618s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[464.631842] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[464.636856] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[464.731247] [040/130] (618s left) gem_tiled_wc
[464.846472] [041/130] (618s left) kms_chamelium_color (ctm-green-to-red)
[464.940611] Subtest ctm-green-to-red: SKIP (0.000s)
[464.981421] [042/130] (618s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[465.080454] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[465.083023] Starting dynamic subtest: pipe-A-eDP-1
[465.110242] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[465.120866] Starting dynamic subtest: pipe-B-eDP-1
[465.145071] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[465.152519] Starting dynamic subtest: pipe-C-eDP-1
[465.175410] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[465.182569] Starting dynamic subtest: pipe-D-eDP-1
[465.205757] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[465.209884] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[467.208092] [043/130] (616s left) core_hotunplug (unbind-rebind)
[467.302919] Starting subtest: unbind-rebind
[473.280788] Subtest unbind-rebind: SUCCESS (5.981s)
[473.313351] [044/130] (610s left) kms_getfb (getfb-repeated-different-handles)
[474.435274] Starting subtest: getfb-repeated-different-handles
[474.438332] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[474.553405] [045/130] (608s left) gen3_render_mixed_blits
[474.680915] [046/130] (608s left) kms_flip (2x-flip-vs-rmfb)
[474.779738] Starting subtest: 2x-flip-vs-rmfb
[474.790806] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[474.888403] [047/130] (608s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[474.995909] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[475.000892] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[475.088711] [048/130] (608s left) syncobj_timeline (single-wait-all-available-submitted)
[475.156872] Starting subtest: single-wait-all-available-submitted
[475.159978] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[475.259255] [049/130] (608s left) gem_mmap_offset (blt-coherency)
[475.320818] Starting subtest: blt-coherency
[475.327393] Subtest blt-coherency: SUCCESS (0.009s)
[475.453099] [050/130] (608s left) gem_exec_schedule (u-lateslice)
[475.532766] Starting subtest: u-lateslice
[475.535078] Starting dynamic subtest: rcs0
[475.547535] Dynamic subtest rcs0: SUCCESS (0.022s)
[475.556764] Starting dynamic subtest: bcs0
[475.562554] Dynamic subtest bcs0: SUCCESS (0.015s)
[475.570399] Starting dynamic subtest: vcs0
[475.579406] Dynamic subtest vcs0: SUCCESS (0.016s)
[475.587714] Starting dynamic subtest: vcs1
[475.597895] Dynamic subtest vcs1: SUCCESS (0.018s)
[475.605984] Starting dynamic subtest: vecs0
[475.615047] Dynamic subtest vecs0: SUCCESS (0.016s)
[475.624312] Starting dynamic subtest: ccs0
[475.630850] Dynamic subtest ccs0: SUCCESS (0.016s)
[475.633367] Subtest u-lateslice: SUCCESS (0.106s)
[477.554397] [051/130] (606s left) gem_partial_pwrite_pread (write-uncached)
[477.616924] Subtest write-uncached: SKIP (0.000s)
[477.683123] [052/130] (605s left) kms_content_protection (type1)
[477.857201] Starting subtest: type1
[481.194184] Subtest type1: SKIP (3.334s)
[482.357729] [053/130] (601s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[482.421951] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[482.487652] [054/130] (601s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[482.616685] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[482.621441] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[482.709231] [055/130] (601s left) gen7_exec_parse (bitmasks)
[482.776307] Subtest bitmasks: SKIP (0.000s)
[482.856837] [056/130] (600s left) gem_ctx_persistence (heartbeat-many)
[482.930203] Starting subtest: heartbeat-many
[482.935684] Subtest heartbeat-many: SKIP (0.000s)
[483.040871] [057/130] (600s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[483.241097] Starting subtest: cursor-rapid-movement-128x42
[483.282745] Subtest cursor-rapid-movement-128x42: SKIP (0.034s)
[483.465535] [058/130] (600s left) gem_ctx_exec (basic-invalid-context)
[483.526439] Starting subtest: basic-invalid-context
[483.528526] Subtest basic-invalid-context: SUCCESS (0.005s)
[483.664801] [059/130] (600s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[483.722871] Starting subtest: mixed-tiled-to-y-tiled-ccs
[483.727680] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[483.903228] [060/130] (600s left) kms_pm_rpm (dpms-lpsp)
[485.658771] Starting subtest: dpms-lpsp
[486.140821] Subtest dpms-lpsp: SUCCESS (0.489s)
[486.221334] [061/130] (597s left) syncobj_basic (illegal-fd-to-handle)
[486.285342] Starting subtest: illegal-fd-to-handle
[486.288026] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[486.389426] [062/130] (597s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[486.502471] Starting subtest: 4-tiled-64bpp-rotate-180
[488.762888] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (2.261s)
[489.012981] [063/130] (595s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[489.115491] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[489.117933] Starting dynamic subtest: pipe-A-default-mode
[491.804202] Dynamic subtest pipe-A-default-mode: SUCCESS (2.686s)
[491.806922] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.688s)
[492.666419] [064/130] (591s left) gem_ctx_bad_destroy (invalid-ctx)
[492.724825] Starting subtest: invalid-ctx
[492.727485] Subtest invalid-ctx: SUCCESS (0.000s)
[492.793414] [065/130] (591s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[492.855880] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[492.918029] [066/130] (591s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[493.029372] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[493.033938] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[493.137234] [067/130] (591s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[493.192754] Starting subtest: invalid-bsd2-flag-on-vebox
[493.195273] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[493.271429] [068/130] (590s left) gem_exec_reloc (basic-write-read-active)
[493.326949] Subtest basic-write-read-active: SKIP (0.000s)
[493.408404] [069/130] (590s left) gem_exec_balancer (bonded-sync)
[493.474677] Starting subtest: bonded-sync
[493.480080] Subtest bonded-sync: SKIP (0.000s)
[493.754409] [070/130] (590s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[493.855858] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[493.858723] Starting dynamic subtest: pipe-A-eDP-1
[494.019817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.163s)
[494.029284] Starting dynamic subtest: pipe-B-eDP-1
[494.177953] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.157s)
[494.187430] Starting dynamic subtest: pipe-C-eDP-1
[494.334836] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.156s)
[494.344049] Starting dynamic subtest: pipe-D-eDP-1
[494.498621] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.163s)
[494.500921] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.643s)
[496.620529] [071/130] (587s left) kms_plane (pixel-format-source-clamping)
[496.716846] Starting subtest: pixel-format-source-clamping
[496.753708] Starting dynamic subtest: pipe-A-plane-0
[501.807297] Dynamic subtest pipe-A-plane-0: SUCCESS (5.055s)
[501.817949] Starting dynamic subtest: pipe-A-plane-3
[504.185726] Dynamic subtest pipe-A-plane-3: SUCCESS (2.377s)
[504.194338] Starting dynamic subtest: pipe-A-plane-5
[504.196699] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[505.311581] Starting dynamic subtest: pipe-B-plane-0
[510.225455] Dynamic subtest pipe-B-plane-0: SUCCESS (4.922s)
[510.233688] Starting dynamic subtest: pipe-B-plane-3
[512.547646] Dynamic subtest pipe-B-plane-3: SUCCESS (2.322s)
[512.556479] Starting dynamic subtest: pipe-B-plane-5
[512.558231] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[512.870190] Subtest pixel-format-source-clamping: SUCCESS (16.154s)
[513.680021] [072/130] (570s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[513.783072] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[513.897275] [073/130] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[514.011813] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[518.850073] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.841s)
[518.990291] [074/130] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[519.098708] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[519.103275] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[519.185691] [075/130] (565s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[519.286881] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[519.289557] Starting dynamic subtest: pipe-A-eDP-1
[519.299789] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[519.308946] Starting dynamic subtest: pipe-B-eDP-1
[519.319086] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[519.328079] Starting dynamic subtest: pipe-C-eDP-1
[519.338858] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[519.347658] Starting dynamic subtest: pipe-D-eDP-1
[519.358288] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[519.363447] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[521.495083] [076/130] (563s left) prime_vgem (basic-read)
[521.558637] Starting subtest: basic-read
[521.571697] Subtest basic-read: SKIP (0.012s)
[521.690340] [077/130] (562s left) kms_psr (fbc-pr-sprite-render)
[521.799676] Starting subtest: fbc-pr-sprite-render
[521.804679] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[521.863963] [078/130] (562s left) perf (gen8-unprivileged-single-ctx-counters)
[521.974841] Starting subtest: gen8-unprivileged-single-ctx-counters
[521.979897] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[522.012448] [079/130] (562s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[522.137259] Starting subtest: basic-busy-flip-before-cursor-legacy
[522.142107] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[522.230614] [080/130] (562s left) kms_properties (crtc-properties-atomic)
[522.328616] Starting subtest: crtc-properties-atomic
[522.331034] Starting dynamic subtest: pipe-A-eDP-1
[522.799035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s)
[522.808604] Starting dynamic subtest: pipe-B-eDP-1
[523.952627] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s)
[523.962789] Starting dynamic subtest: pipe-C-eDP-1
[525.063949] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[525.073941] Starting dynamic subtest: pipe-D-eDP-1
[526.192809] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[526.195155] Subtest crtc-properties-atomic: SUCCESS (3.861s)
[526.996508] [081/130] (557s left) perf_pmu (render-node-busy-idle)
[527.095782] Starting subtest: render-node-busy-idle
[527.098557] Starting dynamic subtest: rcs0
[527.801029] Dynamic subtest rcs0: SUCCESS (0.704s)
[527.812899] Starting dynamic subtest: bcs0
[528.462207] Dynamic subtest bcs0: SUCCESS (0.659s)
[528.474699] Starting dynamic subtest: vcs0
[530.460415] Dynamic subtest vcs0: SUCCESS (1.996s)
[530.471065] Starting dynamic subtest: vcs1
[532.444556] Dynamic subtest vcs1: SUCCESS (1.982s)
[532.455852] Starting dynamic subtest: vecs0
[534.493559] Dynamic subtest vecs0: SUCCESS (2.048s)
[534.505900] Starting dynamic subtest: ccs0
[535.173329] Dynamic subtest ccs0: SUCCESS (0.679s)
[535.176176] Subtest render-node-busy-idle: SUCCESS (8.079s)
[535.245713] [082/130] (549s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[540.250471] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[540.252880] Starting dynamic subtest: pipe-A-eDP-1
[541.040686] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[541.050205] Starting dynamic subtest: pipe-B-eDP-1
[542.266629] Dynamic subtest pipe-B-eDP-1: SKIP (1.222s)
[542.271968] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (2.015s)
[543.443542] [083/130] (541s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[543.569327] Starting subtest: 2x-long-flip-vs-cursor-legacy
[543.574172] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[543.662710] [084/130] (541s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[543.761710] Starting subtest: plane-downscale-factor-0-75-with-rotation
[543.764033] Starting dynamic subtest: pipe-A
[544.112530] Dynamic subtest pipe-A: SUCCESS (0.351s)
[544.121866] Starting dynamic subtest: pipe-B
[545.540342] Dynamic subtest pipe-B: SUCCESS (1.427s)
[545.550332] Starting dynamic subtest: pipe-C
[546.982505] Dynamic subtest pipe-C: SUCCESS (1.442s)
[546.994123] Starting dynamic subtest: pipe-D
[548.414481] Dynamic subtest pipe-D: SUCCESS (1.432s)
[548.417047] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.654s)
[549.554268] [085/130] (535s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[549.669477] Starting subtest: y-tiled-16bpp-rotate-90
[549.674882] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[549.756294] [086/130] (535s left) gem_exec_reloc (basic-cpu-gtt-active)
[549.817298] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[549.879869] [087/130] (535s left) gem_mmap_gtt (hang)
[549.945746] Subtest hang: SKIP (0.000s)
[550.010918] [088/130] (534s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[550.143677] Starting subtest: cursorA-vs-flipA-atomic-transitions
[561.354492] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.212s)
[562.176841] [089/130] (522s left) kms_psr (psr2-cursor-plane-onoff)
[562.288819] Starting subtest: psr2-cursor-plane-onoff
[562.291676] Starting dynamic subtest: eDP-1
[563.940429] Dynamic subtest eDP-1: SUCCESS (1.649s)
[563.943043] Subtest psr2-cursor-plane-onoff: SUCCESS (1.650s)
[564.726973] [090/130] (520s left) prime_vgem (wait)
[564.799856] Starting subtest: wait
[564.802485] Starting dynamic subtest: rcs0
[564.851071] Dynamic subtest rcs0: SUCCESS (0.051s)
[564.861036] Starting dynamic subtest: bcs0
[564.937976] Dynamic subtest bcs0: SUCCESS (0.086s)
[564.947393] Starting dynamic subtest: vcs0
[564.985556] Dynamic subtest vcs0: SUCCESS (0.047s)
[564.994803] Starting dynamic subtest: vcs1
[565.031951] Dynamic subtest vcs1: SUCCESS (0.046s)
[565.041056] Starting dynamic subtest: vecs0
[565.077633] Dynamic subtest vecs0: SUCCESS (0.045s)
[565.087307] Starting dynamic subtest: ccs0
[565.126283] Dynamic subtest ccs0: SUCCESS (0.048s)
[565.128544] Subtest wait: SUCCESS (0.327s)
[565.263224] [091/130] (519s left) gem_exec_fence (syncobj-timeline-export)
[565.789243] Starting subtest: syncobj-timeline-export
[565.796659] Subtest syncobj-timeline-export: SUCCESS (0.009s)
[567.534124] [092/130] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[567.634919] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[567.640072] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[567.722264] [093/130] (517s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[567.785052] Starting subtest: invalid-single-wait-all-unsubmitted
[567.788042] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[567.879323] [094/130] (517s left) gem_mmap_gtt (basic-write-gtt)
[567.952081] Subtest basic-write-gtt: SKIP (0.000s)
[568.007925] [095/130] (517s left) gem_exec_schedule (preempt-self)
[568.079066] Starting subtest: preempt-self
[568.081472] Starting dynamic subtest: rcs0
[568.097508] Dynamic subtest rcs0: SUCCESS (0.026s)
[568.106912] Starting dynamic subtest: bcs0
[568.116523] Dynamic subtest bcs0: SUCCESS (0.019s)
[568.127757] Starting dynamic subtest: vcs0
[568.134102] Dynamic subtest vcs0: SUCCESS (0.015s)
[568.144922] Starting dynamic subtest: vcs1
[568.147807] Dynamic subtest vcs1: SUCCESS (0.014s)
[568.157411] Starting dynamic subtest: vecs0
[568.168726] Dynamic subtest vecs0: SUCCESS (0.021s)
[568.178071] Starting dynamic subtest: ccs0
[568.184013] Dynamic subtest ccs0: SUCCESS (0.015s)
[568.186839] Subtest preempt-self: SUCCESS (0.114s)
[569.545685] [096/130] (515s left) gem_pxp (hw-rejects-pxp-buffer)
[569.676825] Starting subtest: hw-rejects-pxp-buffer
[569.682651] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[569.798265] [097/130] (515s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[569.916840] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[569.921837] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[570.000520] [098/130] (515s left) kms_fence_pin_leak
[570.182057] [099/130] (515s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[570.242068] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[570.245056] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[570.347837] [100/130] (515s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[570.725972] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[571.524550] [101/130] (513s left) kms_prop_blob (blob-prop-validate)
[571.586264] Starting subtest: blob-prop-validate
[571.588867] Subtest blob-prop-validate: SUCCESS (0.000s)
[571.687350] [102/130] (513s left) kms_selftest (drm_plane_helper)
[571.728923] Starting subtest: drm_plane_helper
[571.740674] Starting dynamic subtest: drm_test_check_plane_state
[571.851187] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.111s)
[571.867265] Starting dynamic subtest: drm_test_check_invalid_plane_state
[571.972775] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.121s)
[571.975823] Subtest drm_plane_helper: SUCCESS (0.244s)
[572.156377] [103/130] (513s left) gem_mmap_gtt (big-bo)
[572.215926] Subtest big-bo: SKIP (0.000s)
[572.267491] [104/130] (513s left) kms_vblank (ts-continuation-modeset)
[572.358583] Starting subtest: ts-continuation-modeset
[572.361273] Starting dynamic subtest: pipe-A-eDP-1
[573.797020] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.433s)
[573.812064] Starting dynamic subtest: pipe-D-eDP-1
[575.942195] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.145s)
[575.944614] Subtest ts-continuation-modeset: SUCCESS (3.582s)
[576.737328] [105/130] (508s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[576.843910] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[578.134339] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.292s)
[578.358800] [106/130] (507s left) i915_pm_rps (engine-order)
[578.420323] Starting subtest: engine-order
[583.240064] Subtest engine-order: SUCCESS (4.820s)
[583.324558] [107/130] (502s left) gem_exec_balancer (sequential)
[583.435038] Starting subtest: sequential
[586.377614] Subtest sequential: SUCCESS (2.942s)
[586.680292] [108/130] (498s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[586.793835] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[586.798725] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[586.912892] [109/130] (498s left) dumb_buffer (create-clear)
[586.961918] Starting subtest: create-clear
[627.104450] Subtest create-clear: SUCCESS (40.146s)
[627.186790] [110/130] (458s left) kms_psr (fbc-psr-sprite-blt)
[627.284899] Starting subtest: fbc-psr-sprite-blt
[627.287260] Starting dynamic subtest: eDP-1
[627.292310] Dynamic subtest eDP-1: SKIP (0.000s)
[627.296879] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[627.353200] [111/130] (458s left) kms_addfb_basic (invalid-get-prop)
[627.411070] Starting subtest: invalid-get-prop
[627.414078] Subtest invalid-get-prop: SUCCESS (0.000s)
[627.537551] [112/130] (458s left) dmabuf_sync_file (import-basic)
[627.585940] Starting subtest: import-basic
[627.588334] Subtest import-basic: SUCCESS (0.003s)
[627.638122] [113/130] (458s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[627.696194] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[627.699103] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[627.788030] [114/130] (458s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[627.895046] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[627.907267] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.012s)
[627.995594] [115/130] (457s left) gem_spin_batch (resubmit)
[628.067848] Starting subtest: resubmit
[628.070914] Starting dynamic subtest: rcs0
[628.077595] Dynamic subtest rcs0: SUCCESS (0.008s)
[628.088744] Starting dynamic subtest: bcs0
[628.091579] Dynamic subtest bcs0: SUCCESS (0.002s)
[628.101288] Starting dynamic subtest: vcs0
[628.103640] Dynamic subtest vcs0: SUCCESS (0.002s)
[628.112354] Starting dynamic subtest: vcs1
[628.114331] Dynamic subtest vcs1: SUCCESS (0.002s)
[628.122603] Starting dynamic subtest: vecs0
[628.124861] Dynamic subtest vecs0: SUCCESS (0.003s)
[628.133983] Starting dynamic subtest: ccs0
[628.136367] Dynamic subtest ccs0: SUCCESS (0.003s)
[628.138723] Subtest resubmit: SUCCESS (0.023s)
[628.322311] [116/130] (457s left) fbdev (unaligned-write)
[628.362640] Starting subtest: unaligned-write
[628.483726] Subtest unaligned-write: SUCCESS (0.119s)
[628.547912] [117/130] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[628.645886] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[628.651313] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[628.737392] [118/130] (457s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[628.839850] Starting subtest: x-tiled-32bpp-rotate-90
[628.860895] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[628.982681] [119/130] (457s left) kms_color (legacy-gamma)
[629.076346] Starting subtest: legacy-gamma
[629.078835] Starting dynamic subtest: pipe-A-eDP-1
[629.808332] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.729s)
[629.819515] Starting dynamic subtest: pipe-B-eDP-1
[631.248819] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[631.261294] Starting dynamic subtest: pipe-C-eDP-1
[632.596741] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.348s)
[632.608872] Starting dynamic subtest: pipe-D-eDP-1
[633.925660] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[633.927806] Subtest legacy-gamma: SUCCESS (4.848s)
[634.733651] [120/130] (451s left) kms_atomic_transition (plane-all-transition-fencing)
[634.828603] Starting subtest: plane-all-transition-fencing
[634.831030] Starting dynamic subtest: pipe-A-eDP-1
[637.334093] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[637.621977] Starting dynamic subtest: pipe-B-eDP-1
[640.858950] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.247s)
[641.138332] Subtest plane-all-transition-fencing: SUCCESS (6.307s)
[641.977559] [121/130] (444s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[642.072483] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[642.074971] Starting dynamic subtest: pipe-A
[642.091874] Dynamic subtest pipe-A: SKIP (0.011s)
[642.101420] Starting dynamic subtest: pipe-B
[642.111361] Dynamic subtest pipe-B: SKIP (0.021s)
[642.121054] Starting dynamic subtest: pipe-C
[642.134492] Dynamic subtest pipe-C: SKIP (0.020s)
[642.143548] Starting dynamic subtest: pipe-D
[642.153524] Dynamic subtest pipe-D: SKIP (0.021s)
[642.157804] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.075s)
[642.227862] [122/130] (443s left) gem_lmem_swapping (parallel-random)
[642.275082] Subtest parallel-random: SKIP (0.000s)
[642.318359] [123/130] (443s left) kms_invalid_mode (bad-vsync-start)
[642.411243] Starting subtest: bad-vsync-start
[642.414015] Starting dynamic subtest: pipe-A-eDP-1
[642.691807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[642.701844] Starting dynamic subtest: pipe-B-eDP-1
[642.703853] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[642.713687] Starting dynamic subtest: pipe-C-eDP-1
[642.716514] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[642.725828] Starting dynamic subtest: pipe-D-eDP-1
[642.728675] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[642.731402] Subtest bad-vsync-start: SUCCESS (0.286s)
[643.497164] [124/130] (442s left) kms_lease (setcrtc-implicit-plane)
[643.593175] Starting subtest: setcrtc-implicit-plane
[643.595925] Starting dynamic subtest: pipe-A-eDP-1
[644.068027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s)
[644.078734] Starting dynamic subtest: pipe-B-eDP-1
[645.212373] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s)
[645.229517] Starting dynamic subtest: pipe-C-eDP-1
[646.341838] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[646.353043] Starting dynamic subtest: pipe-D-eDP-1
[647.466086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[647.468845] Subtest setcrtc-implicit-plane: SUCCESS (3.872s)
[648.311576] [125/130] (437s left) kms_getfb (getfb2-handle-not-fb)
[648.391034] Starting subtest: getfb2-handle-not-fb
[648.429893] Subtest getfb2-handle-not-fb: SUCCESS (0.041s)
[648.543249] [126/130] (437s left) kms_vrr (flip-basic-fastset)
[648.641699] Starting subtest: flip-basic-fastset
[648.649582] Subtest flip-basic-fastset: SKIP (0.000s)
[648.712814] [127/130] (437s left) gem_exec_schedule (lateslice)
[648.790676] Starting subtest: lateslice
[648.792890] Starting dynamic subtest: rcs0
[648.801778] Dynamic subtest rcs0: SUCCESS (0.022s)
[648.811697] Starting dynamic subtest: bcs0
[648.819634] Dynamic subtest bcs0: SUCCESS (0.018s)
[648.828912] Starting dynamic subtest: vcs0
[648.837101] Dynamic subtest vcs0: SUCCESS (0.017s)
[648.846047] Starting dynamic subtest: vcs1
[648.853805] Dynamic subtest vcs1: SUCCESS (0.016s)
[648.862714] Starting dynamic subtest: vecs0
[648.869895] Dynamic subtest vecs0: SUCCESS (0.016s)
[648.880291] Starting dynamic subtest: ccs0
[648.889629] Dynamic subtest ccs0: SUCCESS (0.019s)
[648.892485] Subtest lateslice: SUCCESS (0.110s)
[650.556174] [128/130] (435s left) api_intel_allocator (reopen)
[650.611836] Starting subtest: reopen
[650.617033] Subtest reopen: SUCCESS (0.007s)
[650.744479] [129/130] (435s left) kms_atomic (crtc-invalid-params)
[650.838342] Starting subtest: crtc-invalid-params
[650.840897] Starting dynamic subtest: pipe-A-eDP-1
[651.200063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[651.203022] Subtest crtc-invalid-params: SUCCESS (0.359s)
[652.034028] [130/130] (434s left) perf_pmu (busy-idle-no-semaphores)
[652.077328] Starting subtest: busy-idle-no-semaphores
[652.079808] Starting dynamic subtest: rcs0
[652.704570] Dynamic subtest rcs0: SUCCESS (0.629s)
[652.716070] Starting dynamic subtest: bcs0
[653.356253] Dynamic subtest bcs0: SUCCESS (0.650s)
[653.368171] Starting dynamic subtest: vcs0
[654.006364] Dynamic subtest vcs0: SUCCESS (0.648s)
[654.018942] Starting dynamic subtest: vcs1
[656.073223] Dynamic subtest vcs1: SUCCESS (2.066s)
[656.086191] Starting dynamic subtest: vecs0
[658.057283] Dynamic subtest vecs0: SUCCESS (1.982s)
[658.069097] Starting dynamic subtest: ccs0
[660.106177] Dynamic subtest ccs0: SUCCESS (2.047s)
[660.108965] Subtest busy-idle-no-semaphores: SUCCESS (8.034s)
[660.213710] Closing watchdogs
Done.