[60.372795] Initializing watchdogs
[60.372840]   /dev/watchdog0
[60.386981] [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]
[60.391324] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.393465] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.396754] [001/133] (960s left) gem_spin_batch (spin-all)
[60.482741] Starting subtest: spin-all
[60.502660] Subtest spin-all: SUCCESS (0.021s)
[61.967995] [002/133] (958s left) i915_power (sanity)
[62.025037] Starting subtest: sanity
[66.081895] Subtest sanity: SUCCESS (4.045s)
[68.009630] [003/133] (952s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[68.105586] Starting subtest: basic-modeset-with-all-modifiers-formats
[68.477095] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[69.224266] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.747s)
[69.233252] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[69.245191] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[69.252390] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[69.267358] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[69.275647] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[69.422847] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[69.431205] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[69.445288] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[69.452777] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[69.467815] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[69.474917] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[69.489830] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[69.496804] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[69.512085] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[69.519185] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[69.534451] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[69.541539] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[69.556589] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[69.563670] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[69.578925] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[69.586076] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[69.601751] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[69.614738] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[69.745616] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[69.755071] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[69.767590] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[69.775159] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[69.790128] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[69.797338] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[69.812809] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[69.825229] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[69.834486] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[69.843055] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[69.856658] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[69.863984] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[69.878643] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[69.886064] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[69.901259] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[69.908488] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[69.923331] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[69.930690] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[70.068086] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.145s)
[70.075320] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[70.090090] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[70.097111] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[70.112423] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[70.119379] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[70.134677] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[70.144153] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[70.156638] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[70.163913] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[70.178983] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[70.188099] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[70.201476] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[70.209576] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[70.223673] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[70.231682] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[70.245550] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[70.625883] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.520s)
[71.425087] [004/133] (949s left) gem_wait (invalid-buf)
[71.492283] Starting subtest: invalid-buf
[71.494616] Subtest invalid-buf: SUCCESS (0.000s)
[71.751503] [005/133] (949s left) gem_ppgtt (blt-vs-render-ctx0)
[71.805132] Starting subtest: blt-vs-render-ctx0
[104.775237] Subtest blt-vs-render-ctx0: SUCCESS (32.964s)
[104.939347] [006/133] (916s left) kms_addfb_basic (unused-offsets)
[105.041056] Starting subtest: unused-offsets
[105.043047] Subtest unused-offsets: SUCCESS (0.000s)
[105.225866] [007/133] (915s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[105.343952] Starting subtest: 4-tiled-64bpp-rotate-0
[106.823364] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.480s)
[107.035842] [008/133] (914s left) kms_addfb_basic (bad-pitch-63)
[107.093840] Starting subtest: bad-pitch-63
[107.095808] Subtest bad-pitch-63: SUCCESS (0.000s)
[107.276739] [009/133] (913s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[107.384315] Starting subtest: y-tiled-8bpp-rotate-90
[107.388860] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[107.536073] [010/133] (913s left) device_reset (unbind-reset-rebind)
[107.591295] Starting subtest: unbind-reset-rebind
[110.692611] Subtest unbind-reset-rebind: SUCCESS (3.096s)
[110.731961] [011/133] (910s left) perf_pmu (init-sema)
[110.776505] Starting subtest: init-sema
[110.778834] Starting dynamic subtest: rcs0
[110.781086] Dynamic subtest rcs0: SUCCESS (0.002s)
[110.791906] Starting dynamic subtest: bcs0
[110.794402] Dynamic subtest bcs0: SUCCESS (0.000s)
[110.802744] Starting dynamic subtest: vcs0
[110.804887] Dynamic subtest vcs0: SUCCESS (0.000s)
[110.812708] Starting dynamic subtest: vcs1
[110.814895] Dynamic subtest vcs1: SUCCESS (0.000s)
[110.822853] Starting dynamic subtest: vecs0
[110.825111] Dynamic subtest vecs0: SUCCESS (0.000s)
[110.832954] Starting dynamic subtest: ccs0
[110.835121] Dynamic subtest ccs0: SUCCESS (0.000s)
[110.837205] Subtest init-sema: SUCCESS (0.005s)
[110.925168] [012/133] (910s left) api_intel_allocator (gem-pool)
[110.975600] Starting subtest: gem-pool
[110.980174] Subtest gem-pool: SUCCESS (0.007s)
[111.134198] [013/133] (910s left) gem_close_race (multigpu-basic-threads)
[111.201017] Starting subtest: multigpu-basic-threads
[111.205833] Subtest multigpu-basic-threads: SKIP (0.000s)
[111.456392] [014/133] (909s left) gem_exec_whisper (basic-queues-forked-all)
[111.519459] Starting subtest: basic-queues-forked-all
[132.855835] Subtest basic-queues-forked-all: SUCCESS (21.332s)
[133.064008] [015/133] (888s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[133.176430] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[134.144103] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.966s)
[134.305674] [016/133] (887s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[134.405500] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[134.409781] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[134.543202] [017/133] (886s left) kms_psr (pr-sprite-plane-move)
[134.642063] Starting subtest: pr-sprite-plane-move
[134.645489] Subtest pr-sprite-plane-move: SKIP (0.000s)
[134.734920] [018/133] (886s left) api_intel_bb (intel-bb-blit-x)
[134.800147] Starting subtest: intel-bb-blit-x
[138.184095] Subtest intel-bb-blit-x: SUCCESS (3.382s)
[138.340474] [019/133] (883s left) kms_chamelium_frames (dp-crc-fast)
[138.726846] Subtest dp-crc-fast: SKIP (0.000s)
[139.530451] [020/133] (882s left) gem_render_copy_redux (normal)
[139.592481] Starting subtest: normal
[139.847779] Subtest normal: SUCCESS (0.254s)
[140.013545] [021/133] (881s left) gem_vm_create (isolation)
[140.086848] Starting subtest: isolation
[140.104587] Subtest isolation: SUCCESS (0.017s)
[140.279532] [022/133] (881s left) kms_psr (fbc-psr2-cursor-plane-move)
[140.393262] Starting subtest: fbc-psr2-cursor-plane-move
[140.395187] Starting dynamic subtest: eDP-1
[140.399254] Dynamic subtest eDP-1: SKIP (0.000s)
[140.403371] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[140.488664] [023/133] (881s left) gem_exec_whisper (basic-normal)
[140.550871] Starting subtest: basic-normal
[144.469075] Subtest basic-normal: SUCCESS (3.915s)
[144.673047] [024/133] (877s left) gem_sync (basic-store-all)
[144.752528] Starting subtest: basic-store-all
[147.116715] Subtest basic-store-all: SUCCESS (2.373s)
[147.322587] [025/133] (874s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[147.428784] Starting subtest: plane-upscale-20x20-with-modifiers
[147.431130] Starting dynamic subtest: pipe-A
[147.778245] Dynamic subtest pipe-A: SUCCESS (0.349s)
[147.787786] Starting dynamic subtest: pipe-B
[149.139348] Dynamic subtest pipe-B: SUCCESS (1.361s)
[149.147330] Starting dynamic subtest: pipe-C
[150.573661] Dynamic subtest pipe-C: SUCCESS (1.433s)
[150.590502] Starting dynamic subtest: pipe-D
[152.021435] Dynamic subtest pipe-D: SUCCESS (1.447s)
[152.024065] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.592s)
[153.198015] [026/133] (868s left) gem_exec_balancer (sequential)
[153.273653] Starting subtest: sequential
[156.373623] Subtest sequential: SUCCESS (3.100s)
[156.729852] [027/133] (865s left) gem_exec_params (invalid-ring)
[156.783930] Starting subtest: invalid-ring
[156.786372] Subtest invalid-ring: SUCCESS (0.000s)
[156.907228] [028/133] (865s left) kms_chamelium_color (ctm-0-50)
[157.009414] Subtest ctm-0-50: SKIP (0.000s)
[157.054996] [029/133] (864s left) kms_plane (plane-panning-bottom-right)
[157.149817] Starting subtest: plane-panning-bottom-right
[157.152161] Starting dynamic subtest: pipe-A
[158.852829] Dynamic subtest pipe-A: SUCCESS (1.702s)
[158.862817] Starting dynamic subtest: pipe-B
[161.306320] Dynamic subtest pipe-B: SUCCESS (2.453s)
[161.308681] Subtest plane-panning-bottom-right: SUCCESS (4.157s)
[162.126403] [030/133] (859s left) gem_exec_params (secure-non-root)
[162.187469] Starting subtest: secure-non-root
[162.192694] Subtest secure-non-root: SKIP (0.000s)
[162.322606] [031/133] (859s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[162.422246] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[162.424532] Starting dynamic subtest: pipe-A-default-mode
[165.170522] Dynamic subtest pipe-A-default-mode: SUCCESS (2.746s)
[165.173204] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.748s)
[166.033504] [032/133] (856s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[166.147706] Starting subtest: yf-tiled-addfb-size-overflow
[166.152215] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[166.267277] [033/133] (855s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[171.283483] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[171.285766] Starting dynamic subtest: pipe-A-eDP-1
[177.814206] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.529s)
[177.822761] Starting dynamic subtest: pipe-B-eDP-1
[184.385242] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.569s)
[184.387575] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.102s)
[185.274886] [034/133] (836s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[185.340591] Starting subtest: wait-all-for-submit-delayed-submit
[185.445453] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[185.541808] [035/133] (836s left) sw_sync (alloc_fence_invalid_timeline)
[185.581944] Starting subtest: alloc_fence_invalid_timeline
[185.584744] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[185.665306] [036/133] (836s left) gem_exec_params (secure-non-master)
[185.736981] Starting subtest: secure-non-master
[185.741663] Subtest secure-non-master: SKIP (0.000s)
[185.876067] [037/133] (836s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[185.976984] Starting subtest: psr-rgb101010-draw-render
[193.164988] Subtest psr-rgb101010-draw-render: SUCCESS (7.193s)
[193.334488] [038/133] (828s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[193.443981] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[193.448998] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[194.553976] [039/133] (827s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[199.640237] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[199.644886] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[200.507782] [040/133] (821s left) kms_lease (implicit-plane-lease)
[200.607132] Starting subtest: implicit-plane-lease
[200.609417] Subtest implicit-plane-lease: SUCCESS (0.003s)
[200.743404] [041/133] (821s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[200.845738] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[200.849859] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[200.984580] [042/133] (821s left) gem_exec_schedule (lateslice)
[201.061992] Starting subtest: lateslice
[201.064351] Starting dynamic subtest: rcs0
[201.071161] Dynamic subtest rcs0: SUCCESS (0.020s)
[201.081100] Starting dynamic subtest: bcs0
[201.093149] Dynamic subtest bcs0: SUCCESS (0.021s)
[201.101835] Starting dynamic subtest: vcs0
[201.112368] Dynamic subtest vcs0: SUCCESS (0.019s)
[201.120776] Starting dynamic subtest: vcs1
[201.130745] Dynamic subtest vcs1: SUCCESS (0.018s)
[201.139195] Starting dynamic subtest: vecs0
[201.147664] Dynamic subtest vecs0: SUCCESS (0.016s)
[201.155914] Starting dynamic subtest: ccs0
[201.163988] Dynamic subtest ccs0: SUCCESS (0.016s)
[201.166263] Subtest lateslice: SUCCESS (0.114s)
[203.025506] [043/133] (819s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[203.136207] Starting subtest: fb-8bpc-vs-panel-8bpc
[203.138567] Starting dynamic subtest: pipe-A-eDP-1
[204.558470] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.421s)
[204.560676] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.423s)
[205.381265] [044/133] (817s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[205.490772] Starting subtest: x-tiled-64bpp-rotate-270
[205.512122] Subtest x-tiled-64bpp-rotate-270: SKIP (0.021s)
[205.681580] [045/133] (816s left) syncobj_timeline (multi-wait-available-submitted)
[205.734370] Starting subtest: multi-wait-available-submitted
[205.736610] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[205.866375] [046/133] (816s left) kms_atomic_transition (modeset-transition-nonblocking)
[205.958641] Starting subtest: modeset-transition-nonblocking
[205.961058] Starting dynamic subtest: 1x-outputs
[216.879452] Dynamic subtest 1x-outputs: SUCCESS (10.921s)
[216.882018] Subtest modeset-transition-nonblocking: SUCCESS (10.922s)
[217.755351] [047/133] (804s left) kms_psr (psr-primary-mmap-cpu)
[217.859150] Starting subtest: psr-primary-mmap-cpu
[217.861523] Starting dynamic subtest: eDP-1
[219.630894] Dynamic subtest eDP-1: SUCCESS (1.772s)
[219.633079] Subtest psr-primary-mmap-cpu: SUCCESS (1.773s)
[220.514806] [048/133] (802s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[220.617347] Starting subtest: 2x-flip-vs-rmfb-interruptible
[220.628498] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[220.727794] [049/133] (802s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[220.814967] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[220.826079] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[220.922679] [050/133] (801s left) kms_cursor_crc (cursor-alpha-transparent)
[221.013265] Starting subtest: cursor-alpha-transparent
[221.015453] Starting dynamic subtest: pipe-A-eDP-1
[221.611937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[221.621534] Starting dynamic subtest: pipe-D-eDP-1
[222.852976] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[222.855185] Subtest cursor-alpha-transparent: SUCCESS (1.840s)
[223.682211] [051/133] (799s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[223.806798] Starting subtest: flip-vs-cursor-atomic
[230.851243] Subtest flip-vs-cursor-atomic: SUCCESS (7.047s)
[231.708061] [052/133] (791s left) perf (non-zero-reason)
[231.848490] Starting subtest: non-zero-reason
[231.850730] Starting dynamic subtest: 0-rcs0
[237.237758] Dynamic subtest 0-rcs0: SUCCESS (5.389s)
[237.248943] Starting dynamic subtest: 1-vcs1
[241.137045] Dynamic subtest 1-vcs1: SUCCESS (3.898s)
[241.140066] Subtest non-zero-reason: SUCCESS (9.289s)
[241.181842] [053/133] (781s left) kms_flip (2x-plain-flip-fb-recreate)
[241.305375] Starting subtest: 2x-plain-flip-fb-recreate
[241.314294] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[241.459105] [054/133] (781s left) gem_bad_reloc (negative-reloc-bltcopy)
[241.536142] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[241.598800] [055/133] (781s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[241.659512] Starting subtest: saturated-hostile-nopreempt
[241.661769] Starting dynamic subtest: rcs0
[241.782046] Dynamic subtest rcs0: SKIP (0.119s)
[241.791827] Starting dynamic subtest: bcs0
[241.807668] Dynamic subtest bcs0: SKIP (0.025s)
[241.816052] Starting dynamic subtest: vcs0
[241.830605] Dynamic subtest vcs0: SKIP (0.021s)
[241.838993] Starting dynamic subtest: vcs1
[241.855583] Dynamic subtest vcs1: SKIP (0.023s)
[241.863876] Starting dynamic subtest: vecs0
[241.879675] Dynamic subtest vecs0: SKIP (0.022s)
[241.888019] Starting dynamic subtest: ccs0
[241.903708] Dynamic subtest ccs0: SKIP (0.022s)
[241.908257] Subtest saturated-hostile-nopreempt: SKIP (0.243s)
[242.001228] [056/133] (781s left) kms_pm_rpm (modeset-lpsp)
[244.132569] Starting subtest: modeset-lpsp
[245.600629] Subtest modeset-lpsp: SUCCESS (1.469s)
[245.711489] [057/133] (777s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[245.808201] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[245.812473] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[246.924956] [058/133] (776s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[247.025023] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[247.029271] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[247.146523] [059/133] (776s left) gem_userptr_blits (map-fixed-invalidate)
[247.214391] Starting subtest: map-fixed-invalidate
[247.218276] Subtest map-fixed-invalidate: SKIP (0.000s)
[247.377655] [060/133] (775s left) kms_selftest (drm_plane_helper)
[247.423815] Starting subtest: drm_plane_helper
[247.465023] Starting dynamic subtest: drm_test_check_plane_state
[247.626148] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.159s)
[247.635313] Starting dynamic subtest: drm_test_check_invalid_plane_state
[247.767413] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.141s)
[247.769426] Subtest drm_plane_helper: SUCCESS (0.342s)
[247.982503] [061/133] (775s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[248.088322] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[248.092770] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[248.214374] [062/133] (775s left) gem_exec_fence (submit-chain)
[248.401872] Starting subtest: submit-chain
[248.420085] Subtest submit-chain: SUCCESS (0.018s)
[249.996277] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[249.999948] [063/133] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[250.106189] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[250.110125] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[250.234562] [064/133] (773s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[250.298499] Starting subtest: etime-single-wait-all-for-submit-submitted
[250.402517] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[250.502325] [065/133] (772s left) i915_drm_fdinfo (memory-info-shared)
[250.546266] Starting subtest: memory-info-shared
[250.548634] Starting dynamic subtest: smem0
[250.611585] Dynamic subtest smem0: SUCCESS (0.066s)
[250.614072] Subtest memory-info-shared: SUCCESS (0.067s)
[250.708742] [066/133] (772s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[250.807143] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[250.811269] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[250.935340] [067/133] (772s left) kms_psr (fbc-psr-cursor-blt)
[251.022974] Starting subtest: fbc-psr-cursor-blt
[251.025250] Starting dynamic subtest: eDP-1
[251.029466] Dynamic subtest eDP-1: SKIP (0.000s)
[251.033727] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[251.120073] [068/133] (772s left) gem_ctx_param (invalid-get-ringsize)
[251.182445] Starting subtest: invalid-get-ringsize
[251.184724] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[251.302553] [069/133] (772s left) sysfs_timeslice_duration (timeout)
[251.367398] Starting subtest: timeout
[251.369772] Starting dynamic subtest: vecs0
[260.910205] Dynamic subtest vecs0: SUCCESS (9.539s)
[260.922212] Starting dynamic subtest: ccs0
[262.255766] Dynamic subtest ccs0: SUCCESS (1.345s)
[262.268778] Starting dynamic subtest: vcs0
[271.922433] Dynamic subtest vcs0: SUCCESS (9.664s)
[271.933568] Starting dynamic subtest: bcs0
[272.638802] Dynamic subtest bcs0: SUCCESS (0.717s)
[272.651665] Starting dynamic subtest: rcs0
[273.830809] Dynamic subtest rcs0: SUCCESS (1.189s)
[273.842216] Starting dynamic subtest: vcs1
[283.934942] Dynamic subtest vcs1: SUCCESS (10.101s)
[283.937457] Subtest timeout: SUCCESS (32.568s)
[284.078712] [070/133] (739s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[284.195711] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[291.253433] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.060s)
[291.399468] [071/133] (732s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[291.504985] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[292.769839] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.698s)
[292.808017] [072/133] (730s left) gem_pwrite_snooped
[292.945949] [073/133] (730s left) gem_eio (in-flight-1us)
[293.163056] Starting subtest: in-flight-1us
[301.720773] Subtest in-flight-1us: SUCCESS (8.556s)
[301.922135] [074/133] (721s left) kms_getfb (getfb-handle-closed)
[302.019054] Starting subtest: getfb-handle-closed
[302.021330] Subtest getfb-handle-closed: SUCCESS (0.000s)
[302.141432] [075/133] (721s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[302.236335] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[302.240600] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[302.370086] [076/133] (721s left) kms_frontbuffer_tracking (fbc-argb161616f-draw-pwrite)
[302.478557] Starting subtest: fbc-argb161616f-draw-pwrite
[302.481875] Subtest fbc-argb161616f-draw-pwrite: SKIP (0.000s)
[302.596791] [077/133] (721s left) dumb_buffer (map-uaf)
[302.652387] Starting subtest: map-uaf
[302.654667] Subtest map-uaf: SUCCESS (0.004s)
[302.791302] [078/133] (721s left) gem_exec_flush (basic-wb-ro-before-default)
[302.849564] Starting subtest: basic-wb-ro-before-default
[308.300658] Subtest basic-wb-ro-before-default: SUCCESS (5.449s)
[308.523408] [079/133] (715s left) kms_plane_cursor (overlay)
[308.619070] Starting subtest: overlay
[308.623756] Starting dynamic subtest: pipe-A-eDP-1-size-64
[311.059673] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.441s)
[311.124618] Starting dynamic subtest: pipe-A-eDP-1-size-128
[313.572876] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.462s)
[313.633210] Starting dynamic subtest: pipe-A-eDP-1-size-256
[316.150892] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.526s)
[316.515997] Starting dynamic subtest: pipe-B-eDP-1-size-64
[319.711559] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.206s)
[319.772453] Starting dynamic subtest: pipe-B-eDP-1-size-128
[322.312963] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.548s)
[322.375951] Starting dynamic subtest: pipe-B-eDP-1-size-256
[324.903472] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.537s)
[325.265920] Starting dynamic subtest: pipe-C-eDP-1-size-64
[328.092452] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.835s)
[328.131564] Starting dynamic subtest: pipe-C-eDP-1-size-128
[330.226456] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.102s)
[330.264770] Starting dynamic subtest: pipe-C-eDP-1-size-256
[332.404294] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s)
[332.738890] Starting dynamic subtest: pipe-D-eDP-1-size-64
[335.504484] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.776s)
[335.541304] Starting dynamic subtest: pipe-D-eDP-1-size-128
[337.759106] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.224s)
[337.797060] Starting dynamic subtest: pipe-D-eDP-1-size-256
[339.948336] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[340.266998] Subtest overlay: SUCCESS (31.647s)
[341.089159] [080/133] (682s left) gem_mmap (big-bo)
[341.166332] Subtest big-bo: SKIP (0.000s)
[341.232242] [081/133] (682s left) kms_feature_discovery (psr2)
[341.317073] Starting subtest: psr2
[341.319331] Subtest psr2: SUCCESS (0.000s)
[341.417300] [082/133] (682s left) gem_mmap_gtt (coherency)
[341.485769] Subtest coherency: SKIP (0.000s)
[341.547086] [083/133] (682s left) prime_mmap (test_correct_cpu_write)
[341.603993] Starting subtest: test_correct_cpu_write
[341.606283] Starting dynamic subtest: test_correct_cpu_write-smem
[341.608524] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[341.610805] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[341.718111] [084/133] (682s left) kms_flip (flip-vs-dpms-on-nop)
[341.815069] Starting subtest: flip-vs-dpms-on-nop
[341.817229] Starting dynamic subtest: A-eDP1
[343.650221] Dynamic subtest A-eDP1: SUCCESS (1.836s)
[343.662882] Starting dynamic subtest: B-eDP1
[345.497711] Dynamic subtest B-eDP1: SUCCESS (1.845s)
[345.510041] Starting dynamic subtest: C-eDP1
[347.312301] Dynamic subtest C-eDP1: SUCCESS (1.813s)
[347.323895] Starting dynamic subtest: D-eDP1
[349.149788] Dynamic subtest D-eDP1: SUCCESS (1.836s)
[349.152104] Subtest flip-vs-dpms-on-nop: SUCCESS (7.340s)
[350.350683] [085/133] (673s left) gem_render_linear_blits (basic)
[350.420411] Starting subtest: basic
[350.441151] Subtest basic: SUCCESS (0.021s)
[350.549896] [086/133] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[350.652976] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[350.657168] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[350.800467] [087/133] (673s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[350.864178] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[350.928128] [088/133] (673s left) gem_exec_params (readonly)
[350.991325] Starting subtest: readonly
[350.993565] Subtest readonly: SUCCESS (0.002s)
[351.181054] [089/133] (673s left) gem_exec_reloc (basic-write-cpu)
[351.269252] Subtest basic-write-cpu: SKIP (0.000s)
[351.356586] [090/133] (673s left) kms_pm_dc (dc6-dpms)
[352.454797] Starting subtest: dc6-dpms
[354.508850] Subtest dc6-dpms: SUCCESS (2.053s)
[354.609881] [091/133] (669s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[354.667050] Starting subtest: invalid-single-wait-unsubmitted
[354.669357] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[354.787252] [092/133] (669s left) gem_exec_balancer (noheartbeat)
[355.034558] Starting subtest: noheartbeat
[355.039396] Subtest noheartbeat: SKIP (0.000s)
[355.193267] [093/133] (669s left) gem_ctx_sseu (invalid-args)
[355.259076] Subtest invalid-args: SKIP (0.000s)
[355.337910] [094/133] (669s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[355.427378] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[355.431747] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[355.549569] [095/133] (669s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[355.672737] Starting subtest: cursorB-vs-flipB-legacy
[355.677180] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[355.854223] [096/133] (668s left) syncobj_eventfd (invalid-bad-pad)
[355.921665] Starting subtest: invalid-bad-pad
[355.924321] Subtest invalid-bad-pad: SUCCESS (0.000s)
[356.066649] [097/133] (668s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[356.167147] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[356.170373] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[356.288102] [098/133] (668s left) gen7_exec_parse (cmd-crossing-page)
[356.345739] Subtest cmd-crossing-page: SKIP (0.000s)
[356.419659] [099/133] (668s left) gem_reg_read (timestamp-moving)
[356.473370] Starting subtest: timestamp-moving
[357.473938] Subtest timestamp-moving: SUCCESS (1.001s)
[357.572468] [100/133] (667s left) kms_cursor_crc (cursor-sliding-64x21)
[357.777243] Starting subtest: cursor-sliding-64x21
[357.823862] Subtest cursor-sliding-64x21: SKIP (0.043s)
[358.110854] [101/133] (666s left) gem_mmap_offset (partial-remap)
[358.170960] Starting subtest: partial-remap
[358.173085] Starting dynamic subtest: smem0
[358.181011] Dynamic subtest smem0: SUCCESS (0.004s)
[358.182838] Subtest partial-remap: SUCCESS (0.005s)
[358.331920] [102/133] (666s left) kms_lease (lease-revoke)
[358.426162] Starting subtest: lease-revoke
[358.428528] Starting dynamic subtest: pipe-A-eDP-1
[358.456263] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[358.466940] Starting dynamic subtest: pipe-B-eDP-1
[358.490301] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.031s)
[358.499334] Starting dynamic subtest: pipe-C-eDP-1
[358.515945] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[358.525066] Starting dynamic subtest: pipe-D-eDP-1
[358.543369] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[358.545174] Subtest lease-revoke: SUCCESS (0.121s)
[358.710870] [103/133] (666s left) kms_color_pipeline (plane-lut1d)
[358.806815] Starting subtest: plane-lut1d
[358.821110] Starting dynamic subtest: pipe-A-eDP-1
[359.440240] Dynamic subtest pipe-A-eDP-1: FAIL (0.304s)
[360.156926] Starting dynamic subtest: pipe-B-eDP-1
[360.964122] Dynamic subtest pipe-B-eDP-1: FAIL (0.301s)
[361.486528] Starting dynamic subtest: pipe-C-eDP-1
[362.345406] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[362.817030] Starting dynamic subtest: pipe-D-eDP-1
[363.644073] Dynamic subtest pipe-D-eDP-1: FAIL (0.233s)
[363.646411] Subtest plane-lut1d: FAIL (4.547s)
[364.223441] [104/133] (660s left) kms_getfb (getfb-handle-protection)
[364.324082] Starting subtest: getfb-handle-protection
[364.349663] Subtest getfb-handle-protection: SUCCESS (0.027s)
[364.500765] [105/133] (660s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[364.567693] Starting subtest: y-tiled-ccs-to-x-tiled
[364.572241] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[364.775451] [106/133] (660s left) gem_exec_schedule (u-fairslice-all)
[364.853499] Starting subtest: u-fairslice-all
[366.906486] Subtest u-fairslice-all: SUCCESS (2.060s)
[367.243332] [107/133] (657s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[367.342043] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[367.344334] Starting dynamic subtest: pipe-A-eDP-1
[367.367022] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.379703] Starting dynamic subtest: pipe-B-eDP-1
[367.401063] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.409792] Starting dynamic subtest: pipe-C-eDP-1
[367.432254] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.452962] Starting dynamic subtest: pipe-D-eDP-1
[367.475992] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.480530] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[369.607067] [108/133] (655s left) gem_pread (self)
[369.673075] Subtest self: SKIP (0.000s)
[369.732755] [109/133] (655s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[369.794278] Starting subtest: invalid-bsd2-flag-on-blt
[369.796671] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[369.964915] [110/133] (655s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[370.023112] Starting subtest: y-tiled-ccs-to-yf-tiled
[370.027657] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[370.230765] [111/133] (655s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[370.322608] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[374.387999] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.068s)
[375.603374] [112/133] (649s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[375.705573] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[380.252479] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.550s)
[381.404923] [113/133] (644s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[381.729158] Starting subtest: cursor-rapid-movement-max-size
[381.735900] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[381.876404] [114/133] (643s left) kms_flip (flip-vs-panning)
[381.966218] Starting subtest: flip-vs-panning
[381.968530] Starting dynamic subtest: A-eDP1
[390.675220] Dynamic subtest A-eDP1: SUCCESS (8.708s)
[390.691090] Starting dynamic subtest: B-eDP1
[399.409089] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[399.420226] Starting dynamic subtest: C-eDP1
[408.117583] Dynamic subtest C-eDP1: SUCCESS (8.707s)
[408.129639] Starting dynamic subtest: D-eDP1
[416.851960] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[416.856027] Subtest flip-vs-panning: SUCCESS (34.889s)
[418.140607] [115/133] (607s left) kms_content_protection (content-type-change)
[418.302410] Starting subtest: content-type-change
[418.306532] Subtest content-type-change: SKIP (0.000s)
[418.442245] [116/133] (607s left) kms_panel_fitting (atomic-fastset)
[418.549457] Starting subtest: atomic-fastset
[418.551746] Starting dynamic subtest: pipe-A-eDP-1
[418.684129] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[418.696185] Starting dynamic subtest: pipe-B-eDP-1
[419.876054] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.191s)
[419.889445] Starting dynamic subtest: pipe-C-eDP-1
[421.063899] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.186s)
[421.074087] Starting dynamic subtest: pipe-D-eDP-1
[422.210076] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s)
[422.212414] Subtest atomic-fastset: SUCCESS (3.663s)
[423.377338] [117/133] (602s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[423.761709] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[424.559996] [118/133] (601s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[424.662582] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[428.730497] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.071s)
[429.893905] [119/133] (595s left) i915_pm_rps (engine-order)
[429.976550] Starting subtest: engine-order
[434.922389] Subtest engine-order: SUCCESS (4.945s)
[435.083618] [120/133] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[435.190202] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[435.194159] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[435.297810] [121/133] (590s left) gem_userptr_blits (forbidden-operations)
[435.363618] Starting subtest: forbidden-operations
[435.367664] Subtest forbidden-operations: SKIP (0.000s)
[435.530676] [122/133] (590s left) gem_userptr_blits (coherency-unsync)
[435.602086] Subtest coherency-unsync: SKIP (0.000s)
[435.769405] [123/133] (590s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[435.863744] Starting subtest: bad-rotation-90-yf-tiled-ccs
[435.866024] Starting dynamic subtest: pipe-A-eDP-1
[435.887960] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[435.900224] Starting dynamic subtest: pipe-B-eDP-1
[435.920780] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[435.929288] Starting dynamic subtest: pipe-C-eDP-1
[435.946486] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[435.954720] Starting dynamic subtest: pipe-D-eDP-1
[435.972602] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[435.976147] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[438.145151] [124/133] (587s left) kms_vblank (query-idle-hang)
[438.246060] Starting subtest: query-idle-hang
[438.247972] Starting dynamic subtest: pipe-A-eDP-1
[464.656318] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.407s)
[464.671901] Starting dynamic subtest: pipe-D-eDP-1
[479.632524] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s)
[479.634464] Subtest query-idle-hang: SUCCESS (41.384s)
[480.517937] [125/133] (545s left) perf_pmu (render-node-busy)
[480.601389] Starting subtest: render-node-busy
[480.603608] Starting dynamic subtest: rcs0
[481.209041] Dynamic subtest rcs0: SUCCESS (0.609s)
[481.221385] Starting dynamic subtest: bcs0
[481.774436] Dynamic subtest bcs0: SUCCESS (0.564s)
[481.787064] Starting dynamic subtest: vcs0
[482.903591] Dynamic subtest vcs0: SUCCESS (1.125s)
[482.916878] Starting dynamic subtest: vcs1
[484.886836] Dynamic subtest vcs1: SUCCESS (1.980s)
[484.899939] Starting dynamic subtest: vecs0
[486.934286] Dynamic subtest vecs0: SUCCESS (2.043s)
[486.946574] Starting dynamic subtest: ccs0
[487.500153] Dynamic subtest ccs0: SUCCESS (0.565s)
[487.502579] Subtest render-node-busy: SUCCESS (6.903s)
[487.600491] [126/133] (538s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[487.710341] Starting subtest: psr-1p-pri-indfb-multidraw
[510.358164] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.651s)
[510.495287] [127/133] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[510.593912] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[510.597686] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[510.721117] [128/133] (515s left) i915_module_load (resize-bar)
[510.758901] Starting subtest: resize-bar
[510.764712] Subtest resize-bar: SKIP (0.005s)
[510.813989] [129/133] (515s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[510.921208] Starting subtest: fbcpsr-abgr161616f-draw-render
[510.924827] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[511.043559] [130/133] (515s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[511.098660] Starting subtest: x-tiled-to-vebox-yf-tiled
[511.102427] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[511.306290] [131/133] (514s left) kms_psr (psr-basic)
[511.405012] Starting subtest: psr-basic
[511.407243] Starting dynamic subtest: eDP-1
[512.994475] Dynamic subtest eDP-1: SUCCESS (1.588s)
[512.996382] Subtest psr-basic: SUCCESS (1.589s)
[513.896121] [132/133] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[513.986331] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[513.990899] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[514.101398] [133/133] (512s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[519.053574] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[519.058079] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[519.912131] Closing watchdogs
results: parsing output: 0/ for test: gem_spin_batch
results: parsing output: 1/ for test: i915_power
results: parsing output: 2/ for test: kms_async_flips
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: gem_ppgtt
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: device_reset
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: gem_close_race
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: api_intel_bb
results: parsing output: 18/ for test: kms_chamelium_frames
results: parsing output: 19/ for test: gem_render_copy_redux
results: parsing output: 20/ for test: gem_vm_create
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: gem_exec_whisper
results: parsing output: 23/ for test: gem_sync
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: kms_chamelium_color
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: sw_sync
results: parsing output: 35/ for test: gem_exec_params
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_dither
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_atomic_transition
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: gem_bad_reloc
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: kms_selftest
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_ctx_param
results: parsing output: 68/ for test: sysfs_timeslice_duration
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_pwrite_snooped
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: kms_getfb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: dumb_buffer
results: parsing output: 77/ for test: gem_exec_flush
results: parsing output: 78/ for test: kms_plane_cursor
results: parsing output: 79/ for test: gem_mmap
results: parsing output: 80/ for test: kms_feature_discovery
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: prime_mmap
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_render_linear_blits
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_pm_dc
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: gem_ctx_sseu
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: syncobj_eventfd
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gen7_exec_parse
results: parsing output: 98/ for test: gem_reg_read
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: gem_mmap_offset
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: kms_color_pipeline
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: gem_pread
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_content_protection
results: parsing output: 115/ for test: kms_panel_fitting
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: i915_pm_rps
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: i915_module_load
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_psr2_sf
Done.