[59.177511] Initializing watchdogs
[59.177564]   /dev/watchdog0
[59.191964] [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.196307] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.198481] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.201867] [001/133] (960s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[59.291841] Starting subtest: single-wait-all-for-submit-signaled
[59.294064] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[59.386237] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[59.498414] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[59.503007] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[59.640158] [003/133] (960s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[59.732712] Starting subtest: invalid-modeset-force-ultra-joiner
[59.737042] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[59.794166] [004/133] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[59.883827] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[59.886092] Starting dynamic subtest: pipe-A
[59.970644] Dynamic subtest pipe-A: SUCCESS (0.088s)
[59.980574] Starting dynamic subtest: pipe-B
[61.150434] Dynamic subtest pipe-B: SUCCESS (1.182s)
[61.159402] Starting dynamic subtest: pipe-C
[62.260494] Dynamic subtest pipe-C: SUCCESS (1.112s)
[62.269846] Starting dynamic subtest: pipe-D
[63.402866] Dynamic subtest pipe-D: SUCCESS (1.144s)
[63.405320] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.528s)
[64.550726] [005/133] (955s left) gem_exec_schedule (independent)
[64.619087] Starting subtest: independent
[64.620937] Starting dynamic subtest: rcs0
[65.878890] Dynamic subtest rcs0: SUCCESS (1.267s)
[65.887515] Starting dynamic subtest: vcs0
[68.054300] Dynamic subtest vcs0: SUCCESS (2.176s)
[68.065456] Starting dynamic subtest: vcs1
[69.919881] Dynamic subtest vcs1: SUCCESS (1.865s)
[69.931462] Starting dynamic subtest: vecs0
[71.904690] Dynamic subtest vecs0: SUCCESS (1.985s)
[71.916565] Starting dynamic subtest: ccs0
[73.878401] Dynamic subtest ccs0: SUCCESS (1.974s)
[73.881330] Subtest independent: SUCCESS (9.272s)
[74.178433] [006/133] (945s left) syncobj_timeline (reset-multiple-signaled)
[74.238640] Starting subtest: reset-multiple-signaled
[74.240901] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[74.346338] [007/133] (945s left) gem_eio (in-flight-internal-10ms)
[74.574729] Starting subtest: in-flight-internal-10ms
[76.012997] Subtest in-flight-internal-10ms: SUCCESS (1.436s)
[76.180594] [008/133] (943s left) gem_mmap_gtt (basic-small-copy-xy)
[76.239127] Subtest basic-small-copy-XY: SKIP (0.000s)
[76.291238] [009/133] (943s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[76.378968] Starting subtest: fbc-psr2-primary-mmap-gtt
[76.381314] Starting dynamic subtest: eDP-1
[76.385488] Dynamic subtest eDP-1: SKIP (0.000s)
[76.389687] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[76.452050] [010/133] (943s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[76.553795] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[76.558492] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[77.677212] [011/133] (942s left) i915_hangman (engine-engine-error)
[77.738091] Starting subtest: engine-engine-error
[77.740270] Starting dynamic subtest: rcs0
[78.835781] Dynamic subtest rcs0: SUCCESS (1.097s)
[78.846316] Starting dynamic subtest: bcs0
[80.884206] Dynamic subtest bcs0: SUCCESS (2.047s)
[80.895045] Starting dynamic subtest: vcs0
[82.867977] Dynamic subtest vcs0: SUCCESS (1.983s)
[82.878784] Starting dynamic subtest: vcs1
[84.852296] Dynamic subtest vcs1: SUCCESS (1.983s)
[84.862647] Starting dynamic subtest: vecs0
[86.900218] Dynamic subtest vecs0: SUCCESS (2.047s)
[86.911308] Starting dynamic subtest: ccs0
[88.885360] Dynamic subtest ccs0: SUCCESS (1.984s)
[88.888267] Subtest engine-engine-error: SUCCESS (11.147s)
[89.011659] [012/133] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[89.120518] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[93.517955] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.401s)
[94.701683] [013/133] (925s left) gem_exec_params (sol-reset-not-gen7)
[94.757203] Starting subtest: sol-reset-not-gen7
[94.759567] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[94.868500] [014/133] (925s left) kms_plane_alpha_blend (constant-alpha-mid)
[94.953355] Starting subtest: constant-alpha-mid
[95.252836] Starting dynamic subtest: pipe-A-eDP-1
[96.095969] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.843s)
[96.104914] Starting dynamic subtest: pipe-D-eDP-1
[97.582796] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.484s)
[97.585262] Subtest constant-alpha-mid: SUCCESS (2.628s)
[98.382930] [015/133] (921s left) kms_content_protection (atomic-dpms-hdcp14)
[98.531908] Starting subtest: atomic-dpms-hdcp14
[98.536267] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[98.640692] [016/133] (921s left) gem_lmem_swapping (massive-random)
[98.680887] Subtest massive-random: SKIP (0.000s)
[98.724872] [017/133] (921s left) kms_pm_rpm (modeset-lpsp)
[100.277277] Starting subtest: modeset-lpsp
[101.738554] Subtest modeset-lpsp: SUCCESS (1.464s)
[101.824350] [018/133] (918s left) kms_color (deep-color)
[101.918879] Starting subtest: deep-color
[102.978931] Starting dynamic subtest: pipe-A-eDP-1-gamma
[103.693532] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.717s)
[103.703337] Starting dynamic subtest: pipe-A-eDP-1-degamma
[105.184831] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.490s)
[105.194070] Starting dynamic subtest: pipe-A-eDP-1-ctm
[106.619193] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.435s)
[107.382474] Starting dynamic subtest: pipe-B-eDP-1-gamma
[108.127618] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.749s)
[108.137348] Starting dynamic subtest: pipe-B-eDP-1-degamma
[109.569809] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.445s)
[109.578689] Starting dynamic subtest: pipe-B-eDP-1-ctm
[111.030865] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.462s)
[111.783490] Starting dynamic subtest: pipe-C-eDP-1-gamma
[112.465734] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s)
[112.478704] Starting dynamic subtest: pipe-C-eDP-1-degamma
[113.846193] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.377s)
[113.857861] Starting dynamic subtest: pipe-C-eDP-1-ctm
[115.262951] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.418s)
[116.073847] Starting dynamic subtest: pipe-D-eDP-1-gamma
[116.759495] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.692s)
[116.768716] Starting dynamic subtest: pipe-D-eDP-1-degamma
[118.124814] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.366s)
[118.132972] Starting dynamic subtest: pipe-D-eDP-1-ctm
[119.573928] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.448s)
[119.576363] Subtest deep-color: SUCCESS (17.655s)
[120.436790] [019/133] (900s left) kms_flip (2x-busy-flip)
[120.525536] Starting subtest: 2x-busy-flip
[120.536727] Subtest 2x-busy-flip: SKIP (0.011s)
[120.614351] [020/133] (899s left) kms_busy (basic)
[120.710832] Starting subtest: basic
[120.713200] Starting dynamic subtest: flip
[121.336493] Dynamic subtest flip: SUCCESS (0.623s)
[121.346044] Starting dynamic subtest: modeset
[124.745552] Dynamic subtest modeset: SUCCESS (3.410s)
[124.747938] Subtest basic: SUCCESS (4.035s)
[125.542938] [021/133] (894s left) kms_vblank (ts-continuation-idle)
[125.641746] Starting subtest: ts-continuation-idle
[125.643881] Starting dynamic subtest: pipe-A-eDP-1
[126.048075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s)
[126.062000] Starting dynamic subtest: pipe-D-eDP-1
[127.138065] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.088s)
[127.140529] Subtest ts-continuation-idle: SUCCESS (1.498s)
[128.009774] [022/133] (892s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[128.120814] Starting subtest: pixel-format-linear-modifier-source-clamping
[128.146795] Starting dynamic subtest: pipe-A-plane-0
[131.790795] Dynamic subtest pipe-A-plane-0: SUCCESS (3.644s)
[131.799380] Starting dynamic subtest: pipe-A-plane-3
[133.513191] Dynamic subtest pipe-A-plane-3: SUCCESS (1.721s)
[134.598734] Starting dynamic subtest: pipe-B-plane-0
[138.246902] Dynamic subtest pipe-B-plane-0: SUCCESS (3.656s)
[138.254926] Starting dynamic subtest: pipe-B-plane-3
[139.935681] Dynamic subtest pipe-B-plane-3: SUCCESS (1.687s)
[140.247727] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.129s)
[141.069559] [023/133] (879s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[141.166469] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[141.168802] Starting dynamic subtest: pipe-A-eDP-1
[147.885913] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.721s)
[147.895110] Starting dynamic subtest: pipe-B-eDP-1
[154.926057] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.039s)
[154.928317] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.762s)
[155.807371] [024/133] (864s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[155.860160] Starting subtest: x-tiled-to-vebox-yf-tiled
[155.864401] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[156.065827] [025/133] (864s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[156.159732] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[156.162024] Starting dynamic subtest: pipe-A-eDP-1
[156.183651] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[156.192613] Starting dynamic subtest: pipe-B-eDP-1
[156.213537] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[156.221580] Starting dynamic subtest: pipe-C-eDP-1
[156.242401] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[156.250304] Starting dynamic subtest: pipe-D-eDP-1
[156.272231] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[156.276191] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[158.471087] [026/133] (862s left) kms_psr (psr-cursor-mmap-gtt)
[158.572019] Starting subtest: psr-cursor-mmap-gtt
[158.574352] Starting dynamic subtest: eDP-1
[160.270876] Dynamic subtest eDP-1: SUCCESS (1.699s)
[160.273082] Subtest psr-cursor-mmap-gtt: SUCCESS (1.700s)
[161.141327] [027/133] (859s left) gen9_exec_parse (unaligned-access)
[161.202183] Subtest unaligned-access: SKIP (0.000s)
[161.264410] [028/133] (859s left) gem_tiled_pread_pwrite
[161.383193] [029/133] (859s left) gem_ctx_persistence (legacy-engines-mixed)
[161.433425] Starting subtest: legacy-engines-mixed
[161.435611] Starting dynamic subtest: render
[161.521697] Dynamic subtest render: SUCCESS (0.087s)
[161.536148] Starting dynamic subtest: bsd1
[161.572670] Dynamic subtest bsd1: SUCCESS (0.048s)
[161.582932] Starting dynamic subtest: bsd2
[161.617531] Dynamic subtest bsd2: SUCCESS (0.042s)
[161.626320] Starting dynamic subtest: blt
[161.667441] Dynamic subtest blt: SUCCESS (0.048s)
[161.680802] Starting dynamic subtest: vebox
[161.727855] Dynamic subtest vebox: SUCCESS (0.057s)
[161.730586] Subtest legacy-engines-mixed: SUCCESS (0.295s)
[161.804899] [030/133] (859s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[161.894319] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[161.898664] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[161.989643] [031/133] (858s left) api_intel_bb (destroy-bb)
[162.039514] Starting subtest: destroy-bb
[162.043987] Subtest destroy-bb: SUCCESS (0.007s)
[162.159938] [032/133] (858s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[162.259106] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[162.262495] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[162.332218] [033/133] (858s left) gem_exec_balancer (bonded-false-hang)
[162.585026] Starting subtest: bonded-false-hang
[162.590124] Subtest bonded-false-hang: SKIP (0.000s)
[162.698604] [034/133] (858s left) kms_atomic_interruptible (legacy-setmode)
[162.800213] Starting subtest: legacy-setmode
[162.802334] Starting dynamic subtest: pipe-A-eDP-1
[169.681613] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.879s)
[169.683869] Subtest legacy-setmode: SUCCESS (6.880s)
[170.470967] [035/133] (850s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[170.539998] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[170.659439] [036/133] (850s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[170.778203] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[170.782573] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[170.937650] [037/133] (850s left) kms_cursor_edge_walk (128x128-right-edge)
[171.025945] Starting subtest: 128x128-right-edge
[171.028169] Starting dynamic subtest: pipe-A-eDP-1
[174.449468] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[174.459026] Starting dynamic subtest: pipe-D-eDP-1
[177.573051] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[177.575271] Subtest 128x128-right-edge: SUCCESS (6.548s)
[178.383602] [038/133] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[178.490628] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[185.020176] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.533s)
[185.146138] [039/133] (836s left) gem_spin_batch (spin-all-new)
[185.215034] Starting subtest: spin-all-new
[185.232878] Subtest spin-all-new: SUCCESS (0.018s)
[186.940986] [040/133] (834s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[187.048302] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[187.052795] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[187.142531] [041/133] (834s left) kms_chamelium_hpd (dp-hpd-storm)
[187.532402] Subtest dp-hpd-storm: SKIP (0.000s)
[188.313467] [042/133] (833s left) kms_chamelium_color (gamma)
[188.420119] Subtest gamma: SKIP (0.000s)
[188.465780] [043/133] (832s left) kms_flip (modeset-vs-vblank-race)
[188.557648] Starting subtest: modeset-vs-vblank-race
[188.559944] Starting dynamic subtest: A-eDP1
[193.279506] Dynamic subtest A-eDP1: SUCCESS (4.723s)
[193.291608] Starting dynamic subtest: B-eDP1
[198.000561] Dynamic subtest B-eDP1: SUCCESS (4.718s)
[198.014452] Starting dynamic subtest: C-eDP1
[202.642708] Dynamic subtest C-eDP1: SUCCESS (4.640s)
[202.651088] Starting dynamic subtest: D-eDP1
[207.207772] Dynamic subtest D-eDP1: SUCCESS (4.563s)
[207.213625] Subtest modeset-vs-vblank-race: SUCCESS (18.657s)
[208.381968] [044/133] (813s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[208.473951] Starting subtest: 4-tiled-32bpp-rotate-90
[208.494164] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[208.592233] [045/133] (812s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[208.685057] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[208.689279] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[208.786237] [046/133] (812s left) sriov_basic (enable-vfs-bind-unbind-each)
[208.853379] Starting subtest: enable-vfs-bind-unbind-each
[208.855761] Starting dynamic subtest: numvfs-1
[208.936932] Dynamic subtest numvfs-1: FAIL (0.032s)
[208.947078] Starting dynamic subtest: numvfs-2
[209.017180] Dynamic subtest numvfs-2: FAIL (0.004s)
[209.026918] Starting dynamic subtest: numvfs-3
[209.099725] Dynamic subtest numvfs-3: FAIL (0.004s)
[209.111133] Starting dynamic subtest: numvfs-4
[209.183572] Dynamic subtest numvfs-4: FAIL (0.004s)
[209.193242] Starting dynamic subtest: numvfs-5
[209.262118] Dynamic subtest numvfs-5: FAIL (0.004s)
[209.270601] Starting dynamic subtest: numvfs-6
[209.333403] Dynamic subtest numvfs-6: FAIL (0.005s)
[209.341225] Starting dynamic subtest: numvfs-7
[209.397925] Dynamic subtest numvfs-7: FAIL (0.004s)
[209.405638] Starting dynamic subtest: numvfs-random
[209.461398] Dynamic subtest numvfs-random: FAIL (0.004s)
[209.463133] Subtest enable-vfs-bind-unbind-each: FAIL (0.066s)
[209.496181] [047/133] (812s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[209.600385] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[209.602306] Starting dynamic subtest: pipe-A
[210.749645] Dynamic subtest pipe-A: SUCCESS (1.151s)
[210.757801] Starting dynamic subtest: pipe-B
[212.946606] Dynamic subtest pipe-B: SUCCESS (2.195s)
[212.954923] Starting dynamic subtest: pipe-C
[214.175882] Dynamic subtest pipe-C: SUCCESS (1.228s)
[214.184659] Starting dynamic subtest: pipe-D
[215.403060] Dynamic subtest pipe-D: SUCCESS (1.225s)
[215.405245] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.805s)
[216.602490] [048/133] (804s left) kms_async_flips (test-time-stamp)
[216.706876] Starting subtest: test-time-stamp
[217.088385] Starting dynamic subtest: pipe-A-eDP-1
[217.896828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[218.274652] Starting dynamic subtest: pipe-B-eDP-1
[219.030719] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[219.419572] Starting dynamic subtest: pipe-C-eDP-1
[220.182111] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[220.545869] Starting dynamic subtest: pipe-D-eDP-1
[221.318568] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[221.321053] Subtest test-time-stamp: SUCCESS (4.612s)
[222.485865] [049/133] (799s left) syncobj_eventfd (invalid-bad-pad)
[222.550323] Starting subtest: invalid-bad-pad
[222.552257] Subtest invalid-bad-pad: SUCCESS (0.000s)
[222.671363] [050/133] (799s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[222.761667] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[222.766053] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[222.832635] [051/133] (798s left) kms_flip (flip-vs-blocking-wf-vblank)
[222.929077] Starting subtest: flip-vs-blocking-wf-vblank
[222.931288] Starting dynamic subtest: A-eDP1
[231.814926] Dynamic subtest A-eDP1: SUCCESS (8.887s)
[231.822892] Starting dynamic subtest: B-eDP1
[240.744051] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[240.753390] Starting dynamic subtest: C-eDP1
[249.669632] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[249.678206] Starting dynamic subtest: D-eDP1
[258.602939] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[258.607291] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.680s)
[259.826984] [052/133] (761s left) gen9_exec_parse (batch-invalid-length)
[259.907815] Subtest batch-invalid-length: SKIP (0.000s)
[259.974838] [053/133] (761s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[260.089397] Starting subtest: y-tiled-16bpp-rotate-0
[260.093593] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[260.180156] [054/133] (761s left) kms_display_modes (extended-mode-basic)
[260.268674] Starting subtest: extended-mode-basic
[260.272839] Subtest extended-mode-basic: SKIP (0.000s)
[260.316817] [055/133] (761s left) gem_lmem_swapping (verify-random)
[260.363497] Subtest verify-random: SKIP (0.000s)
[260.402714] [056/133] (761s left) gem_ctx_param (basic-default)
[260.457207] Starting subtest: basic-default
[260.459520] Subtest basic-default: SUCCESS (0.000s)
[260.531340] [057/133] (761s left) gem_exec_gttfill (multigpu-basic)
[260.706070] Starting subtest: multigpu-basic
[273.030752] Subtest multigpu-basic: SUCCESS (12.327s)
[273.084711] [058/133] (748s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[273.227628] Starting subtest: plane-use-after-nonblocking-unbind
[273.229947] Starting dynamic subtest: pipe-A-eDP-1
[273.287977] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[273.581875] Starting dynamic subtest: pipe-B-eDP-1
[274.341407] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.768s)
[274.627810] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.402s)
[275.495580] [059/133] (746s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[275.555779] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[275.558196] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[275.654333] [060/133] (746s left) gem_exec_reloc (basic-wc-cpu)
[275.709536] Subtest basic-wc-cpu: SKIP (0.000s)
[275.786712] [061/133] (746s left) gem_mmap (bad-object)
[275.851473] Subtest bad-object: SKIP (0.000s)
[275.912181] [062/133] (746s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[275.991822] Starting subtest: map-fixed-invalidate-overlap-busy
[275.995935] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[276.119464] [063/133] (746s left) i915_suspend (debugfs-reader)
[276.176133] Starting subtest: debugfs-reader
[294.975380] Subtest debugfs-reader: SUCCESS (3.647s)
[301.079898] [064/133] (727s left) gem_fenced_exec_thrash (2-spare-fences)
[301.165810] Subtest 2-spare-fences: SKIP (0.000s)
[301.245688] [065/133] (727s left) prime_mmap_coherency (read)
[301.303465] Starting subtest: read
[306.625007] Subtest read: SUCCESS (5.375s)
[306.763228] [066/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[306.861722] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[306.866044] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[306.956237] [067/133] (721s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[307.045130] Starting subtest: primary-x-tiled-reflect-x-180
[313.925679] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.921s)
[315.120658] [068/133] (713s left) gem_pxp (display-protected-crc)
[315.250912] Starting subtest: display-protected-crc
[316.910137] Subtest display-protected-crc: SUCCESS (1.668s)
[317.014065] [069/133] (711s left) syncobj_timeline (multi-wait-all-available-signaled)
[317.067046] Starting subtest: multi-wait-all-available-signaled
[317.069230] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[317.148662] [070/133] (711s left) gem_exec_whisper (basic-fds)
[317.200966] Starting subtest: basic-fds
[323.217086] Subtest basic-fds: SUCCESS (6.024s)
[323.409628] [071/133] (705s left) gem_exec_reloc (basic-cpu-wc)
[323.467734] Subtest basic-cpu-wc: SKIP (0.000s)
[323.532462] [072/133] (705s left) kms_frontbuffer_tracking (fbc-tiling-4)
[323.634382] Starting subtest: fbc-tiling-4
[327.832185] Subtest fbc-tiling-4: SUCCESS (4.206s)
[329.005172] [073/133] (699s left) gem_ctx_param (set-priority-invalid-size)
[329.066708] Starting subtest: set-priority-invalid-size
[329.069082] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[329.141835] [074/133] (699s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[329.225370] Starting subtest: 2x-absolute-wf_vblank-interruptible
[329.236821] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[329.310359] [075/133] (699s left) kms_cursor_crc (cursor-onscreen-64x21)
[329.505434] Starting subtest: cursor-onscreen-64x21
[329.548322] Subtest cursor-onscreen-64x21: SKIP (0.041s)
[329.777318] [076/133] (698s left) kms_selftest (drm_dp_mst_helper)
[329.822367] Starting subtest: drm_dp_mst_helper
[329.866049] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[329.962458] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.095s)
[329.971696] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[330.055704] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.095s)
[330.065064] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[330.167710] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.110s)
[330.169482] Subtest drm_dp_mst_helper: SUCCESS (0.348s)
[330.329959] [077/133] (698s left) gem_exec_basic (basic)
[330.389815] Starting subtest: basic
[330.391644] Starting dynamic subtest: rcs0-smem
[330.393226] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[330.404243] Starting dynamic subtest: bcs0-smem
[330.406074] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[330.415433] Starting dynamic subtest: vcs0-smem
[330.417216] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[330.426244] Starting dynamic subtest: vcs1-smem
[330.428051] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[330.437080] Starting dynamic subtest: vecs0-smem
[330.438879] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[330.447819] Starting dynamic subtest: ccs0-smem
[330.449649] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[330.451455] Subtest basic: SUCCESS (0.017s)
[332.092250] [078/133] (696s left) gem_userptr_blits (stress-mm-invalidate-close)
[332.163590] Starting subtest: stress-mm-invalidate-close
[334.312723] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[334.427664] [079/133] (694s left) i915_pm_rpm (gem-mmap-type)
[336.170382] Starting subtest: gem-mmap-type
[336.172741] Starting dynamic subtest: wb-smem0
[340.159192] Dynamic subtest wb-smem0: SUCCESS (3.986s)
[340.170173] Starting dynamic subtest: wc-smem0
[343.304196] Dynamic subtest wc-smem0: SUCCESS (3.143s)
[343.314739] Starting dynamic subtest: uc-smem0
[346.464921] Dynamic subtest uc-smem0: SUCCESS (3.159s)
[346.467166] Subtest gem-mmap-type: SUCCESS (10.292s)
[346.549020] [080/133] (682s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[346.642039] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[346.646508] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[346.737297] [081/133] (682s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[346.829100] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[346.831375] Starting dynamic subtest: pipe-A-eDP-1
[346.854211] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[346.865824] Starting dynamic subtest: pipe-B-eDP-1
[346.887101] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[346.896931] Starting dynamic subtest: pipe-C-eDP-1
[346.918450] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[346.929467] Starting dynamic subtest: pipe-D-eDP-1
[346.951239] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[346.955280] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[349.073383] [082/133] (679s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[349.196977] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[366.498605] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.305s)
[367.282212] [083/133] (661s left) kms_scaling_modes (scaling-mode-full)
[367.375537] Starting subtest: scaling-mode-full
[367.377910] Starting dynamic subtest: pipe-A-eDP-1
[367.468046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[367.482012] Starting dynamic subtest: pipe-B-eDP-1
[368.702674] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.231s)
[368.712487] Starting dynamic subtest: pipe-C-eDP-1
[369.814259] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[369.824613] Starting dynamic subtest: pipe-D-eDP-1
[370.955060] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[370.957431] Subtest scaling-mode-full: SUCCESS (3.584s)
[372.116368] [084/133] (656s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[372.199649] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[372.203609] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[372.287316] [085/133] (656s left) kms_force_connector_basic (force-connector-state)
[372.359154] Starting subtest: force-connector-state
[372.964716] Subtest force-connector-state: SUCCESS (0.608s)
[373.962993] [086/133] (655s left) gem_userptr_blits (dmabuf-unsync)
[374.023701] Subtest dmabuf-unsync: SKIP (0.000s)
[374.148739] [087/133] (655s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[374.240869] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[382.882458] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.648s)
[382.983698] [088/133] (646s left) gem_exec_alignment (single)
[383.043163] Starting subtest: single
[383.048619] Subtest single: SUCCESS (0.003s)
[383.173615] [089/133] (646s left) prime_mmap (test_map_unmap)
[383.232288] Starting subtest: test_map_unmap
[383.234376] Starting dynamic subtest: test_map_unmap-smem
[383.265362] Dynamic subtest test_map_unmap-smem: SUCCESS (0.034s)
[383.267644] Subtest test_map_unmap: SUCCESS (0.035s)
[383.374221] [090/133] (645s left) gem_exec_reloc (basic-gtt-wc-active)
[383.428525] Subtest basic-gtt-wc-active: SKIP (0.000s)
[383.503116] [091/133] (645s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[383.594582] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[383.694130] [092/133] (645s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[383.813058] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[384.448629] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[384.598849] [093/133] (644s left) kms_psr (fbc-psr-dpms)
[384.694166] Starting subtest: fbc-psr-dpms
[384.696413] Starting dynamic subtest: eDP-1
[384.700464] Dynamic subtest eDP-1: SKIP (0.000s)
[384.704526] Subtest fbc-psr-dpms: SKIP (0.001s)
[384.766055] [094/133] (644s left) kms_getfb (getfb2-handle-protection)
[384.867141] Starting subtest: getfb2-handle-protection
[384.894003] Subtest getfb2-handle-protection: SUCCESS (0.028s)
[385.002978] [095/133] (644s left) api_intel_allocator (fork-simple-stress-signal)
[385.060872] Starting subtest: fork-simple-stress-signal
[390.463211] Subtest fork-simple-stress-signal: SUCCESS (5.406s)
[390.579320] [096/133] (639s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[390.893997] Starting subtest: cursor-rapid-movement-512x170
[390.898314] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[391.051499] [097/133] (638s left) kms_pm_rpm (basic-pci-d3-state)
[393.185467] Starting subtest: basic-pci-d3-state
[394.664765] Subtest basic-pci-d3-state: SUCCESS (1.481s)
[394.753590] [098/133] (634s left) perf_pmu (busy-accuracy-98)
[394.801741] Starting subtest: busy-accuracy-98
[394.803584] Starting dynamic subtest: rcs0
[397.836839] Dynamic subtest rcs0: SUCCESS (3.033s)
[397.848998] Starting dynamic subtest: bcs0
[400.888738] Dynamic subtest bcs0: SUCCESS (3.047s)
[400.899993] Starting dynamic subtest: vcs0
[403.930867] Dynamic subtest vcs0: SUCCESS (3.038s)
[403.942190] Starting dynamic subtest: vcs1
[406.974661] Dynamic subtest vcs1: SUCCESS (3.040s)
[406.986071] Starting dynamic subtest: vecs0
[410.013903] Dynamic subtest vecs0: SUCCESS (3.036s)
[410.028897] Starting dynamic subtest: ccs0
[413.059330] Dynamic subtest ccs0: SUCCESS (3.043s)
[413.061903] Subtest busy-accuracy-98: SUCCESS (18.251s)
[413.177870] [099/133] (616s left) gen3_render_tiledy_blits
[413.290795] [100/133] (616s left) perf_pmu (gt-awake)
[413.338464] Starting subtest: gt-awake
[422.089830] Subtest gt-awake: SUCCESS (8.751s)
[422.218041] [101/133] (607s left) kms_psr (pr-cursor-mmap-cpu)
[422.308227] Starting subtest: pr-cursor-mmap-cpu
[422.312677] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[422.381515] [102/133] (607s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[422.474215] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[429.513069] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.042s)
[429.650775] [103/133] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[429.749108] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[429.753462] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[429.832638] [104/133] (600s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[429.932822] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[429.935135] Starting dynamic subtest: pipe-A-eDP-1
[429.944110] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.954998] Starting dynamic subtest: pipe-B-eDP-1
[429.963879] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.973386] Starting dynamic subtest: pipe-C-eDP-1
[429.981993] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[429.991419] Starting dynamic subtest: pipe-D-eDP-1
[429.999796] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[430.004084] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[432.129068] [105/133] (597s left) gem_exec_alignment (pi)
[432.202974] Starting subtest: pi
[482.466341] Subtest pi: SUCCESS (50.269s)
[483.519309] [106/133] (546s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[483.681023] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[483.685568] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[483.759874] [107/133] (546s left) gem_exec_reloc (basic-write-cpu-noreloc)
[483.825532] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[483.897685] [108/133] (546s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[484.009973] Starting subtest: cursorA-vs-flipA-varying-size
[495.181149] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.172s)
[496.013275] [109/133] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[496.119568] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[496.123525] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[496.220335] [110/133] (533s left) kms_flip (bo-too-big-interruptible)
[496.311639] Starting subtest: bo-too-big-interruptible
[496.313903] Starting dynamic subtest: A-eDP1
[497.643680] Dynamic subtest A-eDP1: SUCCESS (1.332s)
[497.653800] Starting dynamic subtest: B-eDP1
[498.934476] Dynamic subtest B-eDP1: SUCCESS (1.290s)
[498.948310] Starting dynamic subtest: C-eDP1
[500.243906] Dynamic subtest C-eDP1: SUCCESS (1.307s)
[500.255794] Starting dynamic subtest: D-eDP1
[501.529631] Dynamic subtest D-eDP1: SUCCESS (1.285s)
[501.532042] Subtest bo-too-big-interruptible: SUCCESS (5.223s)
[502.708905] [111/133] (527s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[502.828651] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[502.832722] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[502.919094] [112/133] (527s left) sysfs_heartbeat_interval (idempotent)
[502.971467] Starting subtest: idempotent
[502.974181] Starting dynamic subtest: vecs0
[502.976660] Dynamic subtest vecs0: SUCCESS (0.001s)
[502.987904] Starting dynamic subtest: ccs0
[502.989810] Dynamic subtest ccs0: SUCCESS (0.001s)
[502.999496] Starting dynamic subtest: vcs0
[503.001558] Dynamic subtest vcs0: SUCCESS (0.000s)
[503.011599] Starting dynamic subtest: bcs0
[503.013746] Dynamic subtest bcs0: SUCCESS (0.001s)
[503.025261] Starting dynamic subtest: rcs0
[503.027131] Dynamic subtest rcs0: SUCCESS (0.001s)
[503.036417] Starting dynamic subtest: vcs1
[503.038283] Dynamic subtest vcs1: SUCCESS (0.000s)
[503.040155] Subtest idempotent: SUCCESS (0.009s)
[503.077061] [113/133] (527s left) gem_unfence_active_buffers
[503.220771] [114/133] (527s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[503.274876] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[503.382169] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[503.468985] [115/133] (526s left) gem_tiled_partial_pwrite_pread (writes)
[503.522058] Subtest writes: SKIP (0.000s)
[503.594661] [116/133] (526s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[503.690811] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[510.647696] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.962s)
[510.775022] [117/133] (519s left) gem_exec_schedule (preempt-self)
[510.844072] Starting subtest: preempt-self
[510.845982] Starting dynamic subtest: rcs0
[510.859654] Dynamic subtest rcs0: SUCCESS (0.021s)
[510.873208] Starting dynamic subtest: bcs0
[510.878123] Dynamic subtest bcs0: SUCCESS (0.016s)
[510.888704] Starting dynamic subtest: vcs0
[510.895135] Dynamic subtest vcs0: SUCCESS (0.017s)
[510.905141] Starting dynamic subtest: vcs1
[510.910065] Dynamic subtest vcs1: SUCCESS (0.014s)
[510.920352] Starting dynamic subtest: vecs0
[510.930312] Dynamic subtest vecs0: SUCCESS (0.019s)
[510.943306] Starting dynamic subtest: ccs0
[510.966768] Dynamic subtest ccs0: SUCCESS (0.033s)
[510.968912] Subtest preempt-self: SUCCESS (0.129s)
[512.161579] [118/133] (518s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[512.264137] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[513.044029] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[513.216815] [119/133] (517s left) gem_ctx_isolation (preservation)
[513.282030] Starting subtest: preservation
[513.284467] Starting dynamic subtest: rcs0
[513.417495] Dynamic subtest rcs0: SUCCESS (0.134s)
[513.430462] Starting dynamic subtest: bcs0
[513.564873] Dynamic subtest bcs0: SUCCESS (0.146s)
[513.576491] Starting dynamic subtest: vcs0
[513.716333] Dynamic subtest vcs0: SUCCESS (0.151s)
[513.727895] Starting dynamic subtest: vcs1
[515.190991] Dynamic subtest vcs1: SUCCESS (1.474s)
[515.204198] Starting dynamic subtest: vecs0
[517.182200] Dynamic subtest vecs0: SUCCESS (1.991s)
[517.195727] Starting dynamic subtest: ccs0
[519.185098] Dynamic subtest ccs0: SUCCESS (2.002s)
[519.188025] Subtest preservation: SUCCESS (5.904s)
[519.418125] [120/133] (511s left) perf (per-context-mode-unprivileged)
[519.555124] Starting subtest: per-context-mode-unprivileged
[519.559573] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[519.604462] [121/133] (511s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[519.702583] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[524.107960] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.411s)
[525.305220] [122/133] (505s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[525.363384] Starting subtest: y-tiled-to-vebox-x-tiled
[525.367636] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[525.546609] [123/133] (505s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[525.649585] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[525.653951] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[525.759480] [124/133] (505s left) gem_mmap_offset (partial-remap)
[525.828210] Starting subtest: partial-remap
[525.830438] Starting dynamic subtest: smem0
[525.839008] Dynamic subtest smem0: SUCCESS (0.004s)
[525.840974] Subtest partial-remap: SUCCESS (0.005s)
[525.942829] [125/133] (504s left) gem_ctx_engines (execute-one)
[525.996116] Starting subtest: execute-one
[528.476094] Subtest execute-one: SUCCESS (2.479s)
[528.662814] [126/133] (502s left) core_setmaster (master-drop-set-user)
[528.745193] Starting subtest: master-drop-set-user
[528.757693] Subtest master-drop-set-user: SUCCESS (0.013s)
[528.801411] [127/133] (502s left) gem_exec_fence (long-history)
[529.280135] Starting subtest: long-history
[536.802538] Subtest long-history: SUCCESS (7.519s)
[537.397472] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[537.401207] [128/133] (493s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[537.542625] Starting subtest: multiplane-atomic-fence-wait
[537.861627] Subtest multiplane-atomic-fence-wait: SUCCESS (0.317s)
[539.006024] [129/133] (492s left) gem_ccs (ctrl-surf-copy)
[539.055376] Starting subtest: ctrl-surf-copy
[539.059884] Subtest ctrl-surf-copy: SKIP (0.000s)
[539.186848] [130/133] (491s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[539.292039] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[539.296186] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[539.360121] [131/133] (491s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[539.449458] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[539.451825] Starting dynamic subtest: pipe-A-eDP-1
[539.512220] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[539.532446] Starting dynamic subtest: pipe-B-eDP-1
[539.593176] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[539.607583] Starting dynamic subtest: pipe-C-eDP-1
[539.665433] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[539.676581] Starting dynamic subtest: pipe-D-eDP-1
[539.734083] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[539.738697] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[541.697427] [132/133] (489s left) kms_lease (lease-unleased-connector)
[541.808806] Starting subtest: lease-unleased-connector
[541.811172] Starting dynamic subtest: pipe-A-eDP-1
[541.815994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[541.827314] Starting dynamic subtest: pipe-B-eDP-1
[541.829592] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[541.840258] Starting dynamic subtest: pipe-C-eDP-1
[541.842515] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[541.852339] Starting dynamic subtest: pipe-D-eDP-1
[541.854508] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[541.856666] Subtest lease-unleased-connector: SUCCESS (0.032s)
[541.972566] [133/133] (489s left) gem_mmap (short-mmap)
[542.037836] Subtest short-mmap: SKIP (0.000s)
[542.096767] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: i915_hangman
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: kms_plane_alpha_blend
results: parsing output: 14/ for test: kms_content_protection
results: parsing output: 15/ for test: gem_lmem_swapping
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_color
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_busy
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_plane
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gen9_exec_parse
results: parsing output: 27/ for test: gem_tiled_pread_pwrite
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: api_intel_bb
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: kms_atomic_interruptible
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_cursor_edge_walk
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_spin_batch
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: kms_chamelium_color
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: sriov_basic
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: syncobj_eventfd
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gen9_exec_parse
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_display_modes
results: parsing output: 54/ for test: gem_lmem_swapping
results: parsing output: 55/ for test: gem_ctx_param
results: parsing output: 56/ for test: gem_exec_gttfill
results: parsing output: 57/ for test: kms_atomic_transition
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: gem_mmap
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: i915_suspend
results: parsing output: 63/ for test: gem_fenced_exec_thrash
results: parsing output: 64/ for test: prime_mmap_coherency
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_rotation_crc
results: parsing output: 67/ for test: gem_pxp
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_selftest
results: parsing output: 76/ for test: gem_exec_basic
results: parsing output: 77/ for test: gem_userptr_blits
results: parsing output: 78/ for test: i915_pm_rpm
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_scaling_modes
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: kms_force_connector_basic
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_alignment
results: parsing output: 88/ for test: prime_mmap
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_getfb
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: gen3_render_tiledy_blits
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: gem_exec_alignment
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: sysfs_heartbeat_interval
results: parsing output: 112/ for test: gem_unfence_active_buffers
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_ctx_isolation
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_mmap_offset
results: parsing output: 124/ for test: gem_ctx_engines
results: parsing output: 125/ for test: core_setmaster
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_explicit_fence
results: parsing output: 128/ for test: gem_ccs
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_lease
results: parsing output: 132/ for test: gem_mmap
Done.