[56.856093] Initializing watchdogs
[56.856141]   /dev/watchdog0
[56.870109] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.874304] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.876901] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.880433] [001/131] (960s left) i915_hangman (gt-engine-hang)
[56.960362] Starting subtest: gt-engine-hang
[56.962620] Starting dynamic subtest: rcs0
[58.872858] Dynamic subtest rcs0: SUCCESS (1.889s)
[58.879271] Starting dynamic subtest: bcs0
[60.854716] Dynamic subtest bcs0: SUCCESS (1.966s)
[60.863907] Starting dynamic subtest: vcs0
[62.899784] Dynamic subtest vcs0: SUCCESS (2.032s)
[62.907908] Starting dynamic subtest: vcs1
[64.883820] Dynamic subtest vcs1: SUCCESS (1.973s)
[64.893273] Starting dynamic subtest: vecs0
[66.866982] Dynamic subtest vecs0: SUCCESS (1.976s)
[66.876353] Starting dynamic subtest: ccs0
[68.851617] Dynamic subtest ccs0: SUCCESS (1.977s)
[68.854484] Subtest gt-engine-hang: SUCCESS (11.822s)
[68.943592] [002/131] (948s left) gem_exec_schedule (submit-golden-slice)
[69.017232] Starting subtest: submit-golden-slice
[69.019552] Starting dynamic subtest: rcs0
[69.071799] Dynamic subtest rcs0: SUCCESS (0.059s)
[69.079868] Starting dynamic subtest: bcs0
[69.118799] Dynamic subtest bcs0: SUCCESS (0.047s)
[69.128352] Starting dynamic subtest: vcs0
[69.159733] Dynamic subtest vcs0: SUCCESS (0.040s)
[69.168976] Starting dynamic subtest: vcs1
[69.201409] Dynamic subtest vcs1: SUCCESS (0.042s)
[69.210760] Starting dynamic subtest: vecs0
[69.245738] Dynamic subtest vecs0: SUCCESS (0.044s)
[69.254565] Starting dynamic subtest: ccs0
[69.288068] Dynamic subtest ccs0: SUCCESS (0.042s)
[69.290663] Subtest submit-golden-slice: SUCCESS (0.275s)
[71.268959] [003/131] (946s left) kms_vblank (wait-forked)
[71.439118] Starting subtest: wait-forked
[71.441430] Starting dynamic subtest: pipe-A-eDP-1
[73.316994] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[73.330981] Starting dynamic subtest: pipe-D-eDP-1
[75.863058] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[75.865165] Subtest wait-forked: SUCCESS (4.418s)
[76.741686] [004/131] (940s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[76.854207] Starting subtest: cursorA-vs-flipB-toggle
[76.858762] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[77.005222] [005/131] (940s left) gem_exec_flush (basic-uc-pro-default)
[77.071696] Starting subtest: basic-uc-pro-default
[82.560420] Subtest basic-uc-pro-default: SUCCESS (5.450s)
[82.716099] [006/131] (934s left) api_intel_allocator (fork-simple-stress-signal)
[82.765790] Starting subtest: fork-simple-stress-signal
[88.222170] Subtest fork-simple-stress-signal: SUCCESS (5.401s)
[88.307811] [007/131] (929s left) gem_exec_balancer (invalid-balancer)
[88.373927] Starting subtest: invalid-balancer
[89.428255] Subtest invalid-balancer: SUCCESS (1.023s)
[89.753156] [008/131] (927s left) kms_psr (pr-primary-mmap-cpu)
[89.855185] Starting subtest: pr-primary-mmap-cpu
[89.859377] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[89.938111] [009/131] (927s left) perf (i915-ref-count)
[90.008070] Starting subtest: i915-ref-count
[90.080528] Subtest i915-ref-count: SUCCESS (0.070s)
[90.138977] [010/131] (927s left) gem_linear_blits (interruptible)
[90.447272] Starting subtest: interruptible
[94.465084] Subtest interruptible: SUCCESS (4.016s)
[94.684701] [011/131] (923s left) gem_pxp (create-protected-buffer)
[94.852537] Starting subtest: create-protected-buffer
[94.854976] Subtest create-protected-buffer: SUCCESS (0.000s)
[94.985169] [012/131] (922s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[95.088205] Starting subtest: psr-indfb-scaledprimary
[100.832557] Subtest psr-indfb-scaledprimary: SUCCESS (5.744s)
[100.952373] [013/131] (916s left) prime_mmap (test_correct_cpu_write)
[101.011363] Starting subtest: test_correct_cpu_write
[101.013699] Starting dynamic subtest: test_correct_cpu_write-smem
[101.015681] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[101.017734] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[101.137557] [014/131] (916s left) gem_ctx_param (invalid-ctx-set)
[101.192914] Starting subtest: invalid-ctx-set
[101.195227] Subtest invalid-ctx-set: SUCCESS (0.001s)
[101.301981] [015/131] (916s left) syncobj_timeline (wait-delayed-signal)
[101.360268] Starting subtest: wait-delayed-signal
[101.464606] Subtest wait-delayed-signal: SUCCESS (0.102s)
[101.546654] [016/131] (916s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[101.605956] Starting subtest: etime-multi-wait-for-submit-submitted
[101.712875] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[101.797355] [017/131] (916s left) sw_sync (alloc_timeline)
[101.834584] Starting subtest: alloc_timeline
[101.836966] Subtest alloc_timeline: SUCCESS (0.000s)
[101.909199] [018/131] (916s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[102.004861] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[102.007330] Starting dynamic subtest: A-eDP1
[105.564536] Dynamic subtest A-eDP1: SUCCESS (3.559s)
[105.574216] Starting dynamic subtest: B-eDP1
[108.760547] Dynamic subtest B-eDP1: SUCCESS (3.197s)
[108.769866] Starting dynamic subtest: C-eDP1
[111.857205] Dynamic subtest C-eDP1: SUCCESS (3.093s)
[111.864605] Starting dynamic subtest: D-eDP1
[114.956070] Dynamic subtest D-eDP1: SUCCESS (3.099s)
[114.958392] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.954s)
[115.779905] [019/131] (902s left) kms_flip (2x-absolute-wf_vblank)
[115.872768] Starting subtest: 2x-absolute-wf_vblank
[115.881442] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[116.020087] [020/131] (902s left) gem_mmap_gtt (medium-copy)
[116.091040] Subtest medium-copy: SKIP (0.000s)
[116.155902] [021/131] (902s left) perf (stress-open-close)
[116.266588] Starting subtest: stress-open-close
[116.269529] Starting dynamic subtest: 0-rcs0
[118.434631] Dynamic subtest 0-rcs0: SUCCESS (2.168s)
[118.442201] Starting dynamic subtest: 1-vecs0
[120.598452] Dynamic subtest 1-vecs0: SUCCESS (2.163s)
[120.600582] Subtest stress-open-close: SUCCESS (4.332s)
[120.643713] [022/131] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[120.758719] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[120.762181] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[120.889239] [023/131] (897s left) kms_addfb_basic (master-rmfb)
[120.945714] Starting subtest: master-rmfb
[120.947746] Subtest master-rmfb: SUCCESS (0.001s)
[121.090178] [024/131] (897s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[121.144217] Starting subtest: multi-wait-available-unsubmitted-signaled
[121.146074] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[121.249217] [025/131] (897s left) kms_vblank (ts-continuation-idle-hang)
[121.340086] Starting subtest: ts-continuation-idle-hang
[121.341902] Starting dynamic subtest: pipe-A-eDP-1
[148.691093] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.345s)
[148.704333] Starting dynamic subtest: pipe-D-eDP-1
[163.681344] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.988s)
[163.683845] Subtest ts-continuation-idle-hang: SUCCESS (42.337s)
[164.526601] [026/131] (853s left) kms_feature_discovery (chamelium)
[164.618027] Starting subtest: chamelium
[164.622575] Subtest chamelium: SKIP (0.000s)
[164.700100] [027/131] (853s left) kms_plane_cursor (primary)
[164.800241] Starting subtest: primary
[164.804430] Starting dynamic subtest: pipe-A-eDP-1-size-64
[167.501499] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.701s)
[167.525913] Starting dynamic subtest: pipe-A-eDP-1-size-128
[170.214525] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.693s)
[170.237862] Starting dynamic subtest: pipe-A-eDP-1-size-256
[172.915185] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.682s)
[173.236795] Starting dynamic subtest: pipe-B-eDP-1-size-64
[176.595941] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.367s)
[176.619764] Starting dynamic subtest: pipe-B-eDP-1-size-128
[179.264061] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.651s)
[179.286708] Starting dynamic subtest: pipe-B-eDP-1-size-256
[181.964801] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.682s)
[182.286747] Starting dynamic subtest: pipe-C-eDP-1-size-64
[185.308314] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.030s)
[185.334545] Starting dynamic subtest: pipe-C-eDP-1-size-128
[187.632671] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.302s)
[187.655748] Starting dynamic subtest: pipe-C-eDP-1-size-256
[189.854929] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.204s)
[190.167940] Starting dynamic subtest: pipe-D-eDP-1-size-64
[193.130038] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.972s)
[193.155212] Starting dynamic subtest: pipe-D-eDP-1-size-128
[195.296723] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s)
[195.322814] Starting dynamic subtest: pipe-D-eDP-1-size-256
[197.587168] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.269s)
[197.893698] Subtest primary: SUCCESS (33.092s)
[198.743428] [028/131] (819s left) gem_exec_params (secure-non-root)
[198.795192] Starting subtest: secure-non-root
[198.799606] Subtest secure-non-root: SKIP (0.000s)
[198.909649] [029/131] (819s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[199.008132] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[199.010628] Starting dynamic subtest: pipe-A-eDP-1
[199.068840] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[199.076174] Starting dynamic subtest: pipe-B-eDP-1
[199.133482] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[199.142483] Starting dynamic subtest: pipe-C-eDP-1
[199.200175] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[199.208671] Starting dynamic subtest: pipe-D-eDP-1
[199.265446] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[199.269620] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[201.214517] [030/131] (817s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[206.173575] Starting subtest: fbc-psr2-cursor-plane-update-sf
[206.175946] Starting dynamic subtest: pipe-A-eDP-1
[206.970056] Dynamic subtest pipe-A-eDP-1: SKIP (0.791s)
[206.979766] Starting dynamic subtest: pipe-B-eDP-1
[208.093488] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[208.097910] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.919s)
[209.298311] [031/131] (809s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[209.403464] Starting subtest: yf-tiled-16bpp-rotate-0
[209.407811] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[209.526624] [032/131] (809s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[209.621858] Starting subtest: 4-tiled-64bpp-rotate-0
[211.167640] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.545s)
[211.356250] [033/131] (807s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[211.479436] Starting subtest: short-flip-before-cursor-atomic-transitions
[212.424854] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.947s)
[213.232068] [034/131] (805s left) api_intel_bb (delta-check)
[213.290598] Starting subtest: delta-check
[213.295811] Subtest delta-check: SUCCESS (0.006s)
[213.452286] [035/131] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[213.554663] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[213.558773] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[213.674571] [036/131] (805s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[213.780042] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[213.782332] Starting dynamic subtest: pipe-A-default-mode
[214.067267] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[214.071930] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.286s)
[214.884931] [037/131] (803s left) gem_softpin (evict-prime-sanity-check)
[214.941854] Starting subtest: evict-prime-sanity-check
[214.944665] Starting dynamic subtest: rcs0
[216.135873] Dynamic subtest rcs0: SUCCESS (1.192s)
[216.143404] Starting dynamic subtest: bcs0
[217.291734] Dynamic subtest bcs0: SUCCESS (1.154s)
[217.299359] Starting dynamic subtest: vcs0
[218.879341] Dynamic subtest vcs0: SUCCESS (1.586s)
[218.887784] Starting dynamic subtest: vcs1
[220.911327] Dynamic subtest vcs1: SUCCESS (2.029s)
[220.921501] Starting dynamic subtest: vecs0
[222.960488] Dynamic subtest vecs0: SUCCESS (2.046s)
[222.970969] Starting dynamic subtest: ccs0
[224.089673] Dynamic subtest ccs0: SUCCESS (1.128s)
[224.097566] Starting dynamic subtest: all
[225.249351] Dynamic subtest all: SUCCESS (1.157s)
[225.251891] Subtest evict-prime-sanity-check: SUCCESS (10.308s)
[225.354319] [038/131] (793s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[225.405906] Subtest writes-after-reads-snoop: SKIP (0.000s)
[225.470631] [039/131] (793s left) kms_psr (fbc-psr2-primary-page-flip)
[225.569863] Starting subtest: fbc-psr2-primary-page-flip
[225.572137] Starting dynamic subtest: eDP-1
[225.576316] Dynamic subtest eDP-1: SKIP (0.000s)
[225.580645] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[225.655976] [040/131] (793s left) kms_cursor_crc (cursor-random-128x42)
[225.877245] Starting subtest: cursor-random-128x42
[225.923713] Subtest cursor-random-128x42: SKIP (0.042s)
[226.131835] [041/131] (792s left) gem_set_tiling_vs_gtt
[226.250708] [042/131] (792s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[226.341116] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[226.342968] Starting dynamic subtest: pipe-A-eDP-1
[226.361893] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[226.370853] Starting dynamic subtest: pipe-B-eDP-1
[226.388954] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[226.396175] Starting dynamic subtest: pipe-C-eDP-1
[226.414071] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[226.421474] Starting dynamic subtest: pipe-D-eDP-1
[226.439668] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[226.443304] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[228.550366] [043/131] (790s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[233.595427] Starting subtest: pr-overlay-plane-move-continuous-sf
[233.599904] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.003s)
[234.464249] [044/131] (784s left) kms_fbcon_fbt (psr-suspend)
[234.535918] Starting subtest: psr-suspend
[283.767548] Subtest psr-suspend: SUCCESS (19.655s)
[283.807476] [045/131] (735s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[283.928261] Starting subtest: cursorA-vs-flipA-toggle
[295.155557] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.126s)
[296.029423] [046/131] (723s left) i915_pm_rpm (system-suspend)
[298.265612] Starting subtest: system-suspend
[319.313934] Subtest system-suspend: SUCCESS (5.668s)
[320.067384] [047/131] (699s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[320.183738] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[320.188194] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[320.288772] [048/131] (698s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[320.389261] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[320.393511] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[320.525608] [049/131] (698s left) perf_pmu (busy)
[320.563909] Starting subtest: busy
[320.566265] Starting dynamic subtest: rcs0
[321.171026] Dynamic subtest rcs0: SUCCESS (0.606s)
[321.181377] Starting dynamic subtest: bcs0
[321.729753] Dynamic subtest bcs0: SUCCESS (0.556s)
[321.741889] Starting dynamic subtest: vcs0
[323.544063] Dynamic subtest vcs0: SUCCESS (1.808s)
[323.556524] Starting dynamic subtest: vcs1
[325.528005] Dynamic subtest vcs1: SUCCESS (1.979s)
[325.540843] Starting dynamic subtest: vecs0
[327.512302] Dynamic subtest vecs0: SUCCESS (1.979s)
[327.523073] Starting dynamic subtest: ccs0
[328.088664] Dynamic subtest ccs0: SUCCESS (0.574s)
[328.091176] Subtest busy: SUCCESS (7.518s)
[328.223975] [050/131] (691s left) kms_psr (psr2-sprite-plane-onoff)
[328.318542] Starting subtest: psr2-sprite-plane-onoff
[328.320861] Starting dynamic subtest: eDP-1
[330.080075] Dynamic subtest eDP-1: SUCCESS (1.758s)
[330.082381] Subtest psr2-sprite-plane-onoff: SUCCESS (1.760s)
[330.934767] [051/131] (688s left) kms_chamelium_frames (dp-frame-dump)
[331.324937] Subtest dp-frame-dump: SKIP (0.000s)
[332.131536] [052/131] (687s left) syncobj_wait (multi-wait-for-submit-submitted)
[332.191326] Starting subtest: multi-wait-for-submit-submitted
[332.299713] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[332.396913] [053/131] (687s left) kms_properties (invalid-properties-atomic)
[332.498800] Starting subtest: invalid-properties-atomic
[332.749274] Subtest invalid-properties-atomic: SUCCESS (0.250s)
[332.843570] [054/131] (686s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[332.939546] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[332.943993] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[333.043560] [055/131] (686s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[333.146626] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[337.640345] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.481s)
[338.824944] [056/131] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[338.937301] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[338.941769] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[339.074539] [057/131] (680s left) kms_busy (extended-modeset-hang-newfb)
[339.174115] Starting subtest: extended-modeset-hang-newfb
[339.176483] Starting dynamic subtest: pipe-A
[373.443503] Dynamic subtest pipe-A: SUCCESS (34.091s)
[373.455921] Starting dynamic subtest: pipe-D
[396.364942] Dynamic subtest pipe-D: SUCCESS (22.913s)
[396.367800] Subtest extended-modeset-hang-newfb: SUCCESS (57.009s)
[397.166799] [058/131] (622s left) gem_exec_fence (basic-wait)
[397.363061] Starting subtest: basic-wait
[397.366015] Starting dynamic subtest: rcs0
[397.478858] Dynamic subtest rcs0: SUCCESS (0.116s)
[397.490943] Starting dynamic subtest: bcs0
[397.545550] Dynamic subtest bcs0: SUCCESS (0.065s)
[397.557005] Starting dynamic subtest: vcs0
[397.611377] Dynamic subtest vcs0: SUCCESS (0.064s)
[397.623018] Starting dynamic subtest: vcs1
[397.677216] Dynamic subtest vcs1: SUCCESS (0.064s)
[397.688540] Starting dynamic subtest: vecs0
[397.740172] Dynamic subtest vecs0: SUCCESS (0.061s)
[397.751348] Starting dynamic subtest: ccs0
[397.804997] Dynamic subtest ccs0: SUCCESS (0.062s)
[397.807521] Subtest basic-wait: SUCCESS (0.444s)
[399.638655] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[399.642102] [059/131] (620s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[399.749344] Starting subtest: x-tiled-8bpp-rotate-0
[400.863880] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.114s)
[401.024547] [060/131] (618s left) kms_invalid_mode (int-max-clock)
[401.119548] Starting subtest: int-max-clock
[401.121432] Starting dynamic subtest: pipe-A-eDP-1
[401.405222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[401.414510] Starting dynamic subtest: pipe-B-eDP-1
[401.416363] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[401.424809] Starting dynamic subtest: pipe-C-eDP-1
[401.427044] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[401.436045] Starting dynamic subtest: pipe-D-eDP-1
[401.438169] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[401.440367] Subtest int-max-clock: SUCCESS (0.291s)
[402.224109] [061/131] (617s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[402.311051] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[402.313440] Starting dynamic subtest: pipe-A-eDP-1
[402.336541] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[402.346952] Starting dynamic subtest: pipe-B-eDP-1
[402.369555] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[402.379044] Starting dynamic subtest: pipe-C-eDP-1
[402.401569] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[402.410550] Starting dynamic subtest: pipe-D-eDP-1
[402.432131] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[402.436041] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[404.486533] [062/131] (615s left) gem_exec_whisper (basic-sync)
[404.570325] Starting subtest: basic-sync
[410.894947] Subtest basic-sync: SUCCESS (6.298s)
[411.084432] [063/131] (608s left) gem_mmap_wc (copy)
[411.144086] Subtest copy: SKIP (0.000s)
[411.209513] [064/131] (608s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[411.316237] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[411.327049] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[411.427296] [065/131] (608s left) perf (invalid-oa-metric-set-id)
[411.524972] Starting subtest: invalid-oa-metric-set-id
[411.532401] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[411.569392] [066/131] (608s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[411.660952] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[411.663084] Starting dynamic subtest: pipe-A-default-mode
[411.954312] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[411.958682] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.293s)
[412.813391] [067/131] (607s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[412.913023] Starting subtest: plane-upscale-20x20-with-pixel-format
[412.915171] Starting dynamic subtest: pipe-A
[413.960986] Dynamic subtest pipe-A: SUCCESS (1.050s)
[413.971279] Starting dynamic subtest: pipe-B
[416.109132] Dynamic subtest pipe-B: SUCCESS (2.146s)
[416.117570] Starting dynamic subtest: pipe-C
[417.303823] Dynamic subtest pipe-C: SUCCESS (1.193s)
[417.312703] Starting dynamic subtest: pipe-D
[418.450564] Dynamic subtest pipe-D: SUCCESS (1.146s)
[418.452941] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.537s)
[419.670570] [068/131] (600s left) kms_flip (modeset-vs-vblank-race)
[419.785130] Starting subtest: modeset-vs-vblank-race
[419.787438] Starting dynamic subtest: A-eDP1
[424.496575] Dynamic subtest A-eDP1: SUCCESS (4.710s)
[424.506349] Starting dynamic subtest: B-eDP1
[429.225484] Dynamic subtest B-eDP1: SUCCESS (4.725s)
[429.239327] Starting dynamic subtest: C-eDP1
[433.871733] Dynamic subtest C-eDP1: SUCCESS (4.642s)
[433.882089] Starting dynamic subtest: D-eDP1
[438.408016] Dynamic subtest D-eDP1: SUCCESS (4.537s)
[438.410394] Subtest modeset-vs-vblank-race: SUCCESS (18.626s)
[439.591762] [069/131] (580s left) vgem_basic (dmabuf-fence-before)
[439.634808] Starting subtest: dmabuf-fence-before
[439.636905] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[439.713682] [070/131] (580s left) kms_plane_alpha_blend (constant-alpha-max)
[439.809280] Starting subtest: constant-alpha-max
[440.088400] Starting dynamic subtest: pipe-A-eDP-1
[440.974083] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.884s)
[440.984492] Starting dynamic subtest: pipe-D-eDP-1
[442.579260] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.605s)
[442.581617] Subtest constant-alpha-max: SUCCESS (2.772s)
[443.447395] [071/131] (576s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[443.547444] Starting subtest: psr-2p-primscrn-spr-indfb-move
[443.551788] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[443.678609] [072/131] (576s left) kms_pm_rpm (modeset-stress-extra-wait)
[445.701016] Starting subtest: modeset-stress-extra-wait
[500.000972] Subtest modeset-stress-extra-wait: SUCCESS (54.248s)
[500.062636] [073/131] (520s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[500.160177] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[507.499767] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.339s)
[507.647135] [074/131] (512s left) kms_psr (fbc-psr-sprite-plane-onoff)
[507.748252] Starting subtest: fbc-psr-sprite-plane-onoff
[507.750600] Starting dynamic subtest: eDP-1
[507.754848] Dynamic subtest eDP-1: SKIP (0.000s)
[507.759169] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[507.833678] [075/131] (512s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[507.928047] Starting subtest: fbcpsr-indfb-scaledprimary
[513.702825] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.775s)
[513.838135] [076/131] (506s left) gem_mmap_gtt (isolation)
[513.906072] Subtest isolation: SKIP (0.000s)
[513.977242] [077/131] (506s left) perf_pmu (idle)
[514.014266] Starting subtest: idle
[514.016496] Starting dynamic subtest: rcs0
[514.577495] Dynamic subtest rcs0: SUCCESS (0.563s)
[514.594449] Starting dynamic subtest: bcs0
[515.099375] Dynamic subtest bcs0: SUCCESS (0.520s)
[515.110809] Starting dynamic subtest: vcs0
[515.628561] Dynamic subtest vcs0: SUCCESS (0.526s)
[515.639071] Starting dynamic subtest: vcs1
[516.157681] Dynamic subtest vcs1: SUCCESS (0.526s)
[516.168820] Starting dynamic subtest: vecs0
[516.687611] Dynamic subtest vecs0: SUCCESS (0.527s)
[516.700036] Starting dynamic subtest: ccs0
[517.207793] Dynamic subtest ccs0: SUCCESS (0.518s)
[517.210586] Subtest idle: SUCCESS (3.195s)
[517.330989] [078/131] (503s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[517.437738] Starting subtest: y-tiled-64bpp-rotate-90
[517.441892] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[517.548406] [079/131] (502s left) kms_psr (fbc-pr-sprite-render)
[517.642974] Starting subtest: fbc-pr-sprite-render
[517.647349] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[517.732159] [080/131] (502s left) kms_cursor_legacy (single-move)
[517.854800] Starting subtest: single-move
[517.856697] Starting dynamic subtest: pipe-A
[523.290498] Dynamic subtest pipe-A: SUCCESS (5.379s)
[523.301943] Starting dynamic subtest: pipe-B
[528.673073] Dynamic subtest pipe-B: SUCCESS (5.380s)
[528.684257] Starting dynamic subtest: pipe-C
[534.056545] Dynamic subtest pipe-C: SUCCESS (5.379s)
[534.068220] Starting dynamic subtest: pipe-D
[539.433401] Dynamic subtest pipe-D: SUCCESS (5.379s)
[539.443114] Starting dynamic subtest: all-pipes
[544.825822] Dynamic subtest all-pipes: SUCCESS (5.384s)
[544.828194] Subtest single-move: SUCCESS (26.911s)
[544.946028] [081/131] (475s left) kms_tv_load_detect (load-detect)
[545.009111] Subtest load-detect: SKIP (0.000s)
[545.082624] [082/131] (475s left) gem_exec_schedule (preempt)
[545.159806] Starting subtest: preempt
[545.162131] Starting dynamic subtest: rcs0
[545.174790] Dynamic subtest rcs0: SUCCESS (0.022s)
[545.186038] Starting dynamic subtest: bcs0
[545.193707] Dynamic subtest bcs0: SUCCESS (0.018s)
[545.202364] Starting dynamic subtest: vcs0
[545.214682] Dynamic subtest vcs0: SUCCESS (0.020s)
[545.223487] Starting dynamic subtest: vcs1
[545.235459] Dynamic subtest vcs1: SUCCESS (0.020s)
[545.244748] Starting dynamic subtest: vecs0
[545.256491] Dynamic subtest vecs0: SUCCESS (0.020s)
[545.266491] Starting dynamic subtest: ccs0
[545.276621] Dynamic subtest ccs0: SUCCESS (0.019s)
[545.278948] Subtest preempt: SUCCESS (0.125s)
[546.605269] [083/131] (474s left) gem_exec_whisper (basic-forked-all)
[546.666158] Starting subtest: basic-forked-all
[559.285974] Subtest basic-forked-all: SUCCESS (12.613s)
[559.489771] [084/131] (461s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[559.591786] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[566.767846] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.179s)
[566.920142] [085/131] (453s left) i915_drm_fdinfo (busy-idle-check-all)
[566.960702] Starting subtest: busy-idle-check-all
[566.962991] Starting dynamic subtest: rcs0
[566.967780] Dynamic subtest rcs0: SKIP (0.004s)
[566.979541] Starting dynamic subtest: bcs0
[566.984056] Dynamic subtest bcs0: SKIP (0.000s)
[566.993522] Starting dynamic subtest: vcs0
[566.997942] Dynamic subtest vcs0: SKIP (0.000s)
[567.006686] Starting dynamic subtest: vcs1
[567.011174] Dynamic subtest vcs1: SKIP (0.000s)
[567.019785] Starting dynamic subtest: vecs0
[567.024165] Dynamic subtest vecs0: SKIP (0.000s)
[567.032663] Starting dynamic subtest: ccs0
[567.037096] Dynamic subtest ccs0: SKIP (0.001s)
[567.041543] Subtest busy-idle-check-all: SKIP (0.010s)
[567.079394] [086/131] (453s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[567.214789] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[567.218829] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[567.356385] [087/131] (453s left) gem_ctx_persistence (heartbeat-many)
[567.418359] Starting subtest: heartbeat-many
[567.423043] Subtest heartbeat-many: SKIP (0.000s)
[567.552779] [088/131] (453s left) i915_query (test-query-geometry-subslices)
[567.602614] Starting subtest: test-query-geometry-subslices
[567.604506] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[567.711484] [089/131] (453s left) gem_ctx_shared (q-promotion)
[567.773452] Starting subtest: Q-promotion
[567.775229] Starting dynamic subtest: rcs0
[567.882827] Dynamic subtest rcs0: SUCCESS (0.109s)
[567.900614] Starting dynamic subtest: vcs0
[567.972649] Dynamic subtest vcs0: SUCCESS (0.088s)
[567.990465] Starting dynamic subtest: vcs1
[568.056685] Dynamic subtest vcs1: SUCCESS (0.084s)
[568.074679] Starting dynamic subtest: vecs0
[568.128976] Dynamic subtest vecs0: SUCCESS (0.071s)
[568.145149] Starting dynamic subtest: ccs0
[568.207160] Dynamic subtest ccs0: SUCCESS (0.077s)
[568.209782] Subtest Q-promotion: SUCCESS (0.436s)
[569.627397] [090/131] (451s left) kms_chamelium_audio (dp-audio-edid)
[570.011747] Subtest dp-audio-edid: SKIP (0.000s)
[570.796537] [091/131] (450s left) gem_eio (in-flight-immediate)
[571.036061] Starting subtest: in-flight-immediate
[579.542894] Subtest in-flight-immediate: SUCCESS (8.508s)
[579.750121] [092/131] (441s left) perf_pmu (interrupts)
[579.787317] Starting subtest: interrupts
[580.882824] Subtest interrupts: SUCCESS (1.096s)
[581.025463] [093/131] (440s left) drm_read (short-buffer-wakeup)
[581.180028] Starting subtest: short-buffer-wakeup
[613.392759] Subtest short-buffer-wakeup: SUCCESS (32.217s)
[613.560205] [094/131] (407s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[613.630093] Starting subtest: yf-tiled-to-vebox-y-tiled
[613.634386] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[613.834382] [095/131] (407s left) kms_color (legacy-gamma)
[613.937245] Starting subtest: legacy-gamma
[613.939085] Starting dynamic subtest: pipe-A-eDP-1
[614.622208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[614.634684] Starting dynamic subtest: pipe-B-eDP-1
[615.975977] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.352s)
[615.987544] Starting dynamic subtest: pipe-C-eDP-1
[617.269610] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.292s)
[617.279199] Starting dynamic subtest: pipe-D-eDP-1
[618.603827] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[618.606005] Subtest legacy-gamma: SUCCESS (4.667s)
[619.456450] [096/131] (401s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[619.561529] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[620.507342] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.945s)
[620.666237] [097/131] (400s left) kms_pm_dc (dc9-dpms)
[621.760065] Starting subtest: dc9-dpms
[623.183712] Subtest dc9-dpms: SUCCESS (1.422s)
[623.269503] [098/131] (398s left) gem_exec_fence (keep-in-fence)
[623.436873] Starting subtest: keep-in-fence
[623.439144] Starting dynamic subtest: rcs0
[623.492801] Dynamic subtest rcs0: SUCCESS (0.055s)
[623.502804] Starting dynamic subtest: bcs0
[623.546725] Dynamic subtest bcs0: SUCCESS (0.052s)
[623.558514] Starting dynamic subtest: vcs0
[625.496517] Dynamic subtest vcs0: SUCCESS (1.945s)
[625.509601] Starting dynamic subtest: vcs1
[627.544743] Dynamic subtest vcs1: SUCCESS (2.046s)
[627.557234] Starting dynamic subtest: vecs0
[629.529476] Dynamic subtest vecs0: SUCCESS (1.980s)
[629.551715] Starting dynamic subtest: ccs0
[629.769933] Dynamic subtest ccs0: SUCCESS (0.243s)
[629.772694] Subtest keep-in-fence: SUCCESS (6.334s)
[631.619520] [099/131] (389s left) gem_exec_schedule (fifo)
[631.691808] Starting subtest: fifo
[631.694053] Starting dynamic subtest: rcs0
[631.847005] Dynamic subtest rcs0: SUCCESS (0.162s)
[631.859106] Starting dynamic subtest: vcs0
[631.955703] Dynamic subtest vcs0: SUCCESS (0.107s)
[631.969209] Starting dynamic subtest: vcs1
[632.064667] Dynamic subtest vcs1: SUCCESS (0.106s)
[632.077096] Starting dynamic subtest: vecs0
[632.165200] Dynamic subtest vecs0: SUCCESS (0.100s)
[632.176219] Starting dynamic subtest: ccs0
[632.301264] Dynamic subtest ccs0: SUCCESS (0.135s)
[632.303604] Subtest fifo: SUCCESS (0.618s)
[633.606422] [100/131] (387s left) kms_addfb_basic (bad-pitch-32)
[633.672929] Starting subtest: bad-pitch-32
[633.675476] Subtest bad-pitch-32: SUCCESS (0.000s)
[633.852489] [101/131] (387s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[633.953804] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[640.740473] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.788s)
[640.925802] [102/131] (380s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[641.307477] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[642.089484] [103/131] (379s left) kms_cursor_crc (cursor-size-hints)
[642.212949] Starting subtest: cursor-size-hints
[642.214847] Starting dynamic subtest: pipe-A-eDP-1
[642.824366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s)
[642.835130] Starting dynamic subtest: pipe-D-eDP-1
[644.070882] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[644.072999] Subtest cursor-size-hints: SUCCESS (1.858s)
[644.895728] [104/131] (376s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[644.988399] Starting subtest: plane-primary-overlay-mutable-zpos
[648.414924] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.423s)
[649.609825] [105/131] (371s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[649.705332] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[649.707679] Starting dynamic subtest: pipe-A
[649.943353] Dynamic subtest pipe-A: SUCCESS (0.241s)
[649.953609] Starting dynamic subtest: pipe-B
[651.285035] Dynamic subtest pipe-B: SUCCESS (1.340s)
[651.294444] Starting dynamic subtest: pipe-C
[652.629588] Dynamic subtest pipe-C: SUCCESS (1.344s)
[652.639213] Starting dynamic subtest: pipe-D
[653.946376] Dynamic subtest pipe-D: SUCCESS (1.316s)
[653.948691] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.244s)
[655.137821] [106/131] (366s left) gem_ctx_persistence (engines-mixed)
[655.190709] Starting subtest: engines-mixed
[655.193134] Starting dynamic subtest: rcs0
[655.304622] Dynamic subtest rcs0: SUCCESS (0.113s)
[655.317370] Starting dynamic subtest: bcs0
[655.384570] Dynamic subtest bcs0: SUCCESS (0.078s)
[655.396662] Starting dynamic subtest: vcs0
[655.447237] Dynamic subtest vcs0: SUCCESS (0.061s)
[655.458364] Starting dynamic subtest: vcs1
[655.522247] Dynamic subtest vcs1: SUCCESS (0.073s)
[655.538489] Starting dynamic subtest: vecs0
[655.601217] Dynamic subtest vecs0: SUCCESS (0.076s)
[655.613140] Starting dynamic subtest: ccs0
[655.686746] Dynamic subtest ccs0: SUCCESS (0.082s)
[655.689881] Subtest engines-mixed: SUCCESS (0.497s)
[655.776451] [107/131] (365s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[655.896617] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[686.928572] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.028s)
[687.781506] [108/131] (333s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[687.886954] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[692.001429] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.119s)
[693.177490] [109/131] (328s left) kms_cursor_crc (cursor-offscreen-max-size)
[693.497227] Starting subtest: cursor-offscreen-max-size
[693.504022] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[693.665184] [110/131] (328s left) gem_exec_params (no-vebox)
[693.723973] Starting subtest: no-vebox
[693.726321] Subtest no-vebox: SUCCESS (0.002s)
[695.620529] [111/131] (326s left) gem_wait (busy)
[695.690177] Starting subtest: busy
[695.692604] Starting dynamic subtest: all-engines
[697.495623] Dynamic subtest all-engines: SUCCESS (1.803s)
[697.508842] Starting dynamic subtest: rcs0
[698.038904] Dynamic subtest rcs0: SUCCESS (0.542s)
[698.048944] Starting dynamic subtest: bcs0
[698.579247] Dynamic subtest bcs0: SUCCESS (0.540s)
[698.590084] Starting dynamic subtest: vcs0
[700.503617] Dynamic subtest vcs0: SUCCESS (1.921s)
[700.515729] Starting dynamic subtest: vcs1
[702.487483] Dynamic subtest vcs1: SUCCESS (1.981s)
[702.500097] Starting dynamic subtest: vecs0
[704.534809] Dynamic subtest vecs0: SUCCESS (2.045s)
[704.547166] Starting dynamic subtest: ccs0
[705.074828] Dynamic subtest ccs0: SUCCESS (0.540s)
[705.077216] Subtest busy: SUCCESS (9.383s)
[705.282661] [112/131] (316s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[705.380434] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[705.382360] Starting dynamic subtest: pipe-A-eDP-1
[705.402537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[705.414010] Starting dynamic subtest: pipe-B-eDP-1
[705.434093] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[705.443780] Starting dynamic subtest: pipe-C-eDP-1
[705.463807] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[705.473161] Starting dynamic subtest: pipe-D-eDP-1
[705.493690] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[705.495985] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[707.742810] [113/131] (314s left) gem_ccs (block-multicopy-inplace)
[707.804623] Starting subtest: block-multicopy-inplace
[707.809250] Subtest block-multicopy-inplace: SKIP (0.000s)
[707.939526] [114/131] (313s left) gem_tiled_wb
[708.072673] [115/131] (313s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[708.172838] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[711.716350] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.548s)
[712.859517] [116/131] (309s left) prime_mmap (test_errors)
[712.918144] Starting subtest: test_errors
[712.920238] Starting dynamic subtest: test_errors-smem
[713.006686] Dynamic subtest test_errors-smem: SUCCESS (0.091s)
[713.009280] Subtest test_errors: SUCCESS (0.092s)
[713.157418] [117/131] (308s left) gen9_exec_parse (bb-chained)
[713.211777] Subtest bb-chained: SKIP (0.000s)
[713.280531] [118/131] (308s left) gem_eio (throttle)
[713.467075] Starting subtest: throttle
[713.716328] Subtest throttle: SUCCESS (0.249s)
[713.881064] [119/131] (308s left) gem_render_copy (linear-to-vebox-y-tiled)
[713.926837] Starting subtest: linear-to-vebox-y-tiled
[713.930540] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[714.118334] [120/131] (308s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[714.218099] Starting subtest: fbc-rgb565-draw-render
[718.425119] Subtest fbc-rgb565-draw-render: SUCCESS (4.210s)
[719.634791] [121/131] (302s left) gem_cs_tlb (engines)
[719.696599] Starting subtest: engines
[719.698975] Starting dynamic subtest: rcs0
[721.907325] Dynamic subtest rcs0: SUCCESS (2.152s)
[721.920243] Starting dynamic subtest: bcs0
[724.006791] Dynamic subtest bcs0: SUCCESS (2.151s)
[724.018299] Starting dynamic subtest: vcs0
[726.213403] Dynamic subtest vcs0: SUCCESS (2.154s)
[726.222921] Starting dynamic subtest: vcs1
[728.369249] Dynamic subtest vcs1: SUCCESS (2.154s)
[728.379134] Starting dynamic subtest: vecs0
[730.524153] Dynamic subtest vecs0: SUCCESS (2.153s)
[730.534063] Starting dynamic subtest: ccs0
[732.679411] Dynamic subtest ccs0: SUCCESS (2.155s)
[732.681966] Subtest engines: SUCCESS (12.926s)
[732.751441] [122/131] (289s left) syncobj_timeline (wait-zero-handles)
[732.806120] Starting subtest: wait-zero-handles
[732.808569] Subtest wait-zero-handles: SUCCESS (0.000s)
[732.931655] [123/131] (289s left) syncobj_timeline (invalid-transfer-bad-pad)
[732.984325] Starting subtest: invalid-transfer-bad-pad
[732.986781] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[733.083963] [124/131] (289s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[733.173645] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[740.054931] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.882s)
[740.233549] [125/131] (282s left) gem_exec_flush (basic-batch-kernel-default-wb)
[740.300607] Starting subtest: basic-batch-kernel-default-wb
[746.986460] Subtest basic-batch-kernel-default-wb: SUCCESS (6.685s)
[747.189815] [126/131] (275s left) kms_lease (lease-unleased-connector)
[747.281528] Starting subtest: lease-unleased-connector
[747.283956] Starting dynamic subtest: pipe-A-eDP-1
[747.289161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[747.299447] Starting dynamic subtest: pipe-B-eDP-1
[747.302337] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[747.312907] Starting dynamic subtest: pipe-C-eDP-1
[747.315135] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[747.324476] Starting dynamic subtest: pipe-D-eDP-1
[747.326403] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[747.328261] Subtest lease-unleased-connector: SUCCESS (0.039s)
[747.465910] [127/131] (274s left) kms_psr (psr-sprite-mmap-gtt)
[747.567414] Starting subtest: psr-sprite-mmap-gtt
[747.569685] Starting dynamic subtest: eDP-1
[748.989193] Dynamic subtest eDP-1: SKIP (1.419s)
[748.994778] Subtest psr-sprite-mmap-gtt: SKIP (1.421s)
[749.174443] [128/131] (273s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[749.231903] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[749.340946] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.109s)
[749.426833] [129/131] (273s left) gem_media_fill (media-fill)
[749.485602] Subtest media-fill: SKIP (0.000s)
[749.617890] [130/131] (272s left) prime_mmap_kms (buffer-sharing)
[749.719406] Starting subtest: buffer-sharing
[750.169237] Subtest buffer-sharing: SUCCESS (0.449s)
[751.059622] [131/131] (271s left) gem_userptr_blits (create-destroy-unsync)
[751.136250] Subtest create-destroy-unsync: SKIP (0.000s)
[751.289978] Closing watchdogs
results: parsing output: 0/ for test: i915_hangman
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_exec_flush
results: parsing output: 5/ for test: api_intel_allocator
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: gem_linear_blits
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: prime_mmap
results: parsing output: 13/ for test: gem_ctx_param
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: sw_sync
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_vblank
results: parsing output: 25/ for test: kms_feature_discovery
results: parsing output: 26/ for test: kms_plane_cursor
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: gem_partial_pwrite_pread
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: gem_set_tiling_vs_gtt
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_fbcon_fbt
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: i915_pm_rpm
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_chamelium_frames
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_properties
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_busy
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_invalid_mode
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: gem_mmap_wc
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: kms_plane_alpha_blend
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_tv_load_detect
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: i915_query
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: kms_chamelium_audio
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: drm_read
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_pm_dc
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_atomic
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: gem_ctx_persistence
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: gem_wait
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gem_ccs
results: parsing output: 113/ for test: gem_tiled_wb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: prime_mmap
results: parsing output: 116/ for test: gen9_exec_parse
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_cs_tlb
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: gem_media_fill
results: parsing output: 129/ for test: prime_mmap_kms
results: parsing output: 130/ for test: gem_userptr_blits
Done.