[60.011596] Initializing watchdogs
[60.011645]   /dev/watchdog0
[60.024905] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.028984] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.031185] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.034675] [001/133] (960s left) gem_exec_endless (dispatch)
[60.122058] Starting subtest: dispatch
[60.124330] Starting dynamic subtest: rcs0
[60.128823] Dynamic subtest rcs0: SUCCESS (0.005s)
[60.138073] Starting dynamic subtest: bcs0
[60.142489] Dynamic subtest bcs0: SUCCESS (0.004s)
[60.153289] Starting dynamic subtest: vcs0
[60.157866] Dynamic subtest vcs0: SUCCESS (0.009s)
[60.164291] Starting dynamic subtest: vcs1
[60.168624] Dynamic subtest vcs1: SUCCESS (0.006s)
[60.174941] Starting dynamic subtest: vecs0
[60.179232] Dynamic subtest vecs0: SUCCESS (0.004s)
[60.185778] Starting dynamic subtest: ccs0
[60.190157] Dynamic subtest ccs0: SUCCESS (0.004s)
[60.192278] Subtest dispatch: SUCCESS (0.036s)
[61.958358] [002/133] (958s left) i915_drm_fdinfo (most-busy-check-all)
[62.002672] Starting subtest: most-busy-check-all
[62.004695] Starting dynamic subtest: rcs0
[62.009574] Dynamic subtest rcs0: SKIP (0.004s)
[62.016898] Starting dynamic subtest: bcs0
[62.021530] Dynamic subtest bcs0: SKIP (0.000s)
[62.028019] Starting dynamic subtest: vcs0
[62.032184] Dynamic subtest vcs0: SKIP (0.000s)
[62.038252] Starting dynamic subtest: vcs1
[62.042267] Dynamic subtest vcs1: SKIP (0.000s)
[62.048264] Starting dynamic subtest: vecs0
[62.052444] Dynamic subtest vecs0: SKIP (0.000s)
[62.058737] Starting dynamic subtest: ccs0
[62.063118] Dynamic subtest ccs0: SKIP (0.000s)
[62.067359] Subtest most-busy-check-all: SKIP (0.008s)
[62.099667] [003/133] (958s left) gem_exec_balancer (invalid-bonds)
[62.177325] Starting subtest: invalid-bonds
[62.181945] Subtest invalid-bonds: SKIP (0.001s)
[62.491028] [004/133] (958s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[62.591467] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[62.596077] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.002s)
[62.703567] [005/133] (957s left) kms_plane_multiple (2x-tiling-y)
[62.809423] Starting subtest: 2x-tiling-y
[62.813730] Subtest 2x-tiling-y: SKIP (0.000s)
[62.891715] [006/133] (957s left) dmabuf_sync_file (import-basic)
[62.957414] Starting subtest: import-basic
[62.959842] Subtest import-basic: SUCCESS (0.002s)
[63.016052] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[63.018814] [007/133] (957s left) gen9_exec_parse (bb-start-param)
[63.070051] Subtest bb-start-param: SKIP (0.000s)
[63.139818] [008/133] (957s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[63.244064] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[63.248125] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[63.337835] [009/133] (957s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[63.428139] Starting subtest: psr-rgb565-draw-blt
[70.479017] Subtest psr-rgb565-draw-blt: SUCCESS (7.077s)
[70.603914] [010/133] (950s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[70.655965] Starting subtest: yf-tiled-to-vebox-y-tiled
[70.660603] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[70.839096] [011/133] (950s left) kms_pm_dc (dc5-retention-flops)
[71.950311] Starting subtest: dc5-retention-flops
[71.954416] Subtest dc5-retention-flops: SKIP (0.000s)
[72.019759] [012/133] (948s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[72.078725] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[72.081269] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[72.181447] [013/133] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[72.279567] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[79.619531] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.348s)
[79.753848] [014/133] (941s left) kms_dp_linktrain_fallback (dp-fallback)
[79.856071] Starting subtest: dp-fallback
[79.862622] Subtest dp-fallback: SKIP (0.000s)
[79.926631] [015/133] (941s left) kms_color (ctm-0-50)
[80.022499] Starting subtest: ctm-0-50
[80.024711] Starting dynamic subtest: pipe-A-eDP-1
[83.443226] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.418s)
[83.451072] Starting dynamic subtest: pipe-B-eDP-1
[87.649644] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.202s)
[87.658063] Starting dynamic subtest: pipe-C-eDP-1
[91.685854] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.036s)
[91.693783] Starting dynamic subtest: pipe-D-eDP-1
[95.683822] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.995s)
[95.685784] Subtest ctm-0-50: SUCCESS (15.653s)
[96.511744] [016/133] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[96.623613] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[96.627973] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[96.741025] [017/133] (924s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[96.847355] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[96.851730] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[96.912317] [018/133] (924s left) api_intel_bb (intel-bb-blit-y)
[96.962116] Starting subtest: intel-bb-blit-y
[101.102940] Subtest intel-bb-blit-y: SUCCESS (4.140s)
[101.217250] [019/133] (920s left) i915_hangman (engine-engine-hang)
[101.297310] Starting subtest: engine-engine-hang
[101.299761] Starting dynamic subtest: rcs0
[102.903911] Dynamic subtest rcs0: SUCCESS (1.604s)
[102.916990] Starting dynamic subtest: bcs0
[104.886492] Dynamic subtest bcs0: SUCCESS (1.981s)
[104.897778] Starting dynamic subtest: vcs0
[106.870429] Dynamic subtest vcs0: SUCCESS (1.981s)
[106.881592] Starting dynamic subtest: vcs1
[108.853396] Dynamic subtest vcs1: SUCCESS (1.981s)
[108.864354] Starting dynamic subtest: vecs0
[110.902389] Dynamic subtest vecs0: SUCCESS (2.047s)
[110.913031] Starting dynamic subtest: ccs0
[112.886359] Dynamic subtest ccs0: SUCCESS (1.982s)
[112.889333] Subtest engine-engine-hang: SUCCESS (11.588s)
[112.970324] [020/133] (908s left) kms_flip (2x-flip-vs-dpms-on-nop)
[113.063967] Starting subtest: 2x-flip-vs-dpms-on-nop
[113.074906] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[113.152360] [021/133] (908s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[113.247058] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[114.037714] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.792s)
[114.198269] [022/133] (907s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[114.289162] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[114.293667] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[114.367693] [023/133] (907s left) kms_psr (fbc-pr-sprite-blt)
[114.454875] Starting subtest: fbc-pr-sprite-blt
[114.459163] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[114.541262] [024/133] (906s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[114.602098] Starting subtest: multi-wait-all-available-submitted-signaled
[114.604331] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[114.710478] [025/133] (906s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[114.810262] Starting subtest: crc-primary-suspend-y-tiled-ccs
[114.812429] Starting dynamic subtest: pipe-A-eDP-1
[114.821594] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[114.829776] Starting dynamic subtest: pipe-B-eDP-1
[114.838899] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[114.846094] Starting dynamic subtest: pipe-C-eDP-1
[114.854349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[114.861042] Starting dynamic subtest: pipe-D-eDP-1
[114.869365] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[114.873391] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[117.087109] [026/133] (904s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[117.198908] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[118.276867] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.078s)
[118.383069] [027/133] (903s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[118.438442] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[118.514450] [028/133] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[118.613212] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[122.920287] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.309s)
[124.085159] [029/133] (897s left) i915_query (engine-info-invalid)
[124.141894] Starting subtest: engine-info-invalid
[124.144070] Subtest engine-info-invalid: SUCCESS (0.000s)
[124.241690] [030/133] (897s left) kms_psr (fbc-pr-primary-mmap-cpu)
[124.334366] Starting subtest: fbc-pr-primary-mmap-cpu
[124.338720] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[124.402251] [031/133] (897s left) gem_ctx_persistence (legacy-engines-queued)
[124.464073] Starting subtest: legacy-engines-queued
[124.466131] Starting dynamic subtest: render
[124.520743] Dynamic subtest render: SUCCESS (0.059s)
[124.530220] Starting dynamic subtest: bsd1
[125.877454] Dynamic subtest bsd1: SUCCESS (1.354s)
[125.888716] Starting dynamic subtest: bsd2
[127.861239] Dynamic subtest bsd2: SUCCESS (1.980s)
[127.871945] Starting dynamic subtest: blt
[127.896621] Dynamic subtest blt: SUCCESS (0.035s)
[127.904734] Starting dynamic subtest: vebox
[129.909579] Dynamic subtest vebox: SUCCESS (2.010s)
[129.912405] Subtest legacy-engines-queued: SUCCESS (5.447s)
[129.985104] [032/133] (891s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[130.121606] Starting subtest: verify-pxp-execution-after-suspend-resume
[137.281467] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.162s)
[137.426277] [033/133] (884s left) kms_pm_rpm (pc8-residency)
[138.962311] Starting subtest: pc8-residency
[138.967450] Subtest pc8-residency: SKIP (0.000s)
[139.664801] [034/133] (882s left) prime_vgem (wait)
[139.763315] Starting subtest: wait
[139.765623] Starting dynamic subtest: rcs0
[139.828539] Dynamic subtest rcs0: SUCCESS (0.065s)
[139.837163] Starting dynamic subtest: bcs0
[139.898036] Dynamic subtest bcs0: SUCCESS (0.069s)
[139.906374] Starting dynamic subtest: vcs0
[139.945038] Dynamic subtest vcs0: SUCCESS (0.046s)
[139.953141] Starting dynamic subtest: vcs1
[139.987300] Dynamic subtest vcs1: SUCCESS (0.042s)
[139.994873] Starting dynamic subtest: vecs0
[140.034260] Dynamic subtest vecs0: SUCCESS (0.046s)
[140.041932] Starting dynamic subtest: ccs0
[140.082217] Dynamic subtest ccs0: SUCCESS (0.047s)
[140.084323] Subtest wait: SUCCESS (0.320s)
[140.211882] [035/133] (881s left) prime_mmap (test_dup)
[140.271204] Starting subtest: test_dup
[140.273115] Starting dynamic subtest: test_dup-smem
[140.301285] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[140.303625] Subtest test_dup: SUCCESS (0.033s)
[140.380271] [036/133] (881s left) gem_mmap_wc (write-prefaulted)
[140.432803] Subtest write-prefaulted: SKIP (0.000s)
[140.503306] [037/133] (881s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[140.588943] Starting subtest: async-flip-with-page-flip-events-tiled
[140.960275] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[143.732478] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.772s)
[143.742057] Starting dynamic subtest: pipe-A-eDP-1-4
[145.907536] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[145.918176] Starting dynamic subtest: pipe-A-eDP-1-4
[147.916069] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[147.924392] Starting dynamic subtest: pipe-A-eDP-1-x
[150.117030] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[150.487723] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[153.256608] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[153.268072] Starting dynamic subtest: pipe-B-eDP-1-4
[155.453322] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[155.462497] Starting dynamic subtest: pipe-B-eDP-1-4
[157.462979] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[157.473806] Starting dynamic subtest: pipe-B-eDP-1-x
[159.652184] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[160.018398] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[162.775768] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.764s)
[162.786591] Starting dynamic subtest: pipe-C-eDP-1-4
[164.950296] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[164.958571] Starting dynamic subtest: pipe-C-eDP-1-4
[166.960636] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[166.972824] Starting dynamic subtest: pipe-C-eDP-1-x
[169.138775] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[169.507464] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[172.313071] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.815s)
[172.324692] Starting dynamic subtest: pipe-D-eDP-1-4
[174.487828] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[174.498503] Starting dynamic subtest: pipe-D-eDP-1-4
[176.498337] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[176.506801] Starting dynamic subtest: pipe-D-eDP-1-x
[178.677382] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[178.679779] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.093s)
[179.894336] [038/133] (842s left) kms_frontbuffer_tracking (basic)
[180.007222] Starting subtest: basic
[183.251584] Subtest basic: SUCCESS (3.248s)
[183.333639] [039/133] (838s left) gem_ctx_exec (basic-close-race)
[183.393066] Starting subtest: basic-close-race
[189.007131] Subtest basic-close-race: SUCCESS (5.614s)
[189.126739] [040/133] (832s left) kms_dp_link_training (uhbr-sst)
[189.225206] Starting subtest: uhbr-sst
[189.233998] Subtest uhbr-sst: SKIP (0.000s)
[189.298017] [041/133] (832s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[189.388288] Starting subtest: plane-downscale-factor-0-5-with-rotation
[189.390599] Starting dynamic subtest: pipe-A
[189.408891] Dynamic subtest pipe-A: SKIP (0.015s)
[189.422716] Starting dynamic subtest: pipe-B
[189.436599] Dynamic subtest pipe-B: SKIP (0.029s)
[189.444668] Starting dynamic subtest: pipe-C
[189.465893] Dynamic subtest pipe-C: SKIP (0.029s)
[189.478654] Starting dynamic subtest: pipe-D
[189.498152] Dynamic subtest pipe-D: SKIP (0.029s)
[189.502186] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.106s)
[189.585196] [042/133] (832s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[189.683341] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[189.685658] Starting dynamic subtest: pipe-A-eDP-1
[189.706358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[189.716968] Starting dynamic subtest: pipe-B-eDP-1
[189.737064] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[189.744875] Starting dynamic subtest: pipe-C-eDP-1
[189.764458] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[189.773885] Starting dynamic subtest: pipe-D-eDP-1
[189.793309] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[189.795217] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[191.853708] [043/133] (830s left) kms_flip (2x-blocking-absolute-wf_vblank)
[191.960347] Starting subtest: 2x-blocking-absolute-wf_vblank
[191.968910] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[192.047270] [044/133] (830s left) kms_vrr (lobf)
[192.136344] Starting subtest: lobf
[192.140756] Subtest lobf: SKIP (0.000s)
[192.221834] [045/133] (830s left) prime_mmap (test_errors)
[192.275544] Starting subtest: test_errors
[192.277587] Starting dynamic subtest: test_errors-smem
[192.372529] Dynamic subtest test_errors-smem: SUCCESS (0.098s)
[192.375229] Subtest test_errors: SUCCESS (0.099s)
[192.472926] [046/133] (829s left) gem_exec_whisper (basic-fds-priority-all)
[192.536675] Starting subtest: basic-fds-priority-all
[214.302398] Subtest basic-fds-priority-all: SUCCESS (21.760s)
[214.485628] [047/133] (807s left) perf_pmu (interrupts)
[214.529957] Starting subtest: interrupts
[215.651865] Subtest interrupts: SUCCESS (1.120s)
[215.759873] [048/133] (806s left) kms_vblank (wait-idle)
[215.850641] Starting subtest: wait-idle
[215.852688] Starting dynamic subtest: pipe-A-eDP-1
[217.619582] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.767s)
[217.639528] Starting dynamic subtest: pipe-D-eDP-1
[220.091691] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.471s)
[220.096056] Subtest wait-idle: SUCCESS (4.241s)
[220.918567] [049/133] (801s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[221.015373] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[221.019361] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[221.121314] [050/133] (801s left) kms_cursor_crc (cursor-onscreen-64x64)
[221.309350] Starting subtest: cursor-onscreen-64x64
[221.311518] Starting dynamic subtest: pipe-A-eDP-1
[223.445406] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.134s)
[223.476702] Starting dynamic subtest: pipe-D-eDP-1
[226.197229] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.728s)
[226.199647] Subtest cursor-onscreen-64x64: SUCCESS (4.890s)
[227.071686] [051/133] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[227.181811] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[227.186181] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[227.274583] [052/133] (795s left) kms_content_protection (suspend-resume)
[227.431758] Starting subtest: suspend-resume
[227.436417] Subtest suspend-resume: SKIP (0.000s)
[227.558247] [053/133] (795s left) kms_properties (invalid-properties-legacy)
[227.641862] Starting subtest: invalid-properties-legacy
[227.744576] Subtest invalid-properties-legacy: SUCCESS (0.103s)
[227.830584] [054/133] (794s left) kms_selftest (drm_dp_mst_helper)
[227.876487] Starting subtest: drm_dp_mst_helper
[227.927849] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[228.053880] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.127s)
[228.062155] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[228.161863] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.109s)
[228.170783] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[228.298282] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.136s)
[228.300593] Subtest drm_dp_mst_helper: SUCCESS (0.422s)
[228.454443] [055/133] (794s left) gem_mmap_offset (clear-via-pagefault)
[228.500639] Starting subtest: clear-via-pagefault
[228.502635] Starting dynamic subtest: smem0
[264.138245] Dynamic subtest smem0: SUCCESS (35.631s)
[264.140465] Subtest clear-via-pagefault: SUCCESS (35.632s)
[264.240653] [056/133] (758s left) gem_userptr_blits (stress-purge)
[264.316787] Starting subtest: stress-purge
[269.713079] Subtest stress-purge: SUCCESS (5.396s)
[269.838809] [057/133] (752s left) kms_cursor_edge_walk (128x128-left-edge)
[269.966798] Starting subtest: 128x128-left-edge
[269.968690] Starting dynamic subtest: pipe-A-eDP-1
[273.427465] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[273.437211] Starting dynamic subtest: pipe-D-eDP-1
[276.551347] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[276.553675] Subtest 128x128-left-edge: SUCCESS (6.585s)
[277.354757] [058/133] (745s left) gem_ctx_sseu (mmap-args)
[277.417163] Subtest mmap-args: SKIP (0.000s)
[277.486480] [059/133] (745s left) dumb_buffer (map-valid)
[277.544059] Starting subtest: map-valid
[277.546579] Subtest map-valid: SUCCESS (0.000s)
[277.649540] [060/133] (745s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[277.749421] Starting subtest: 2x-plain-flip-ts-check-interruptible
[277.760119] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[277.838337] [061/133] (745s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[277.935667] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[285.318852] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.385s)
[285.447573] [062/133] (737s left) i915_pm_rpm (system-suspend-execbuf)
[287.085962] Starting subtest: system-suspend-execbuf
[345.457160] Subtest system-suspend-execbuf: SUCCESS (43.375s)
[345.830808] [063/133] (677s left) sysfs_preempt_timeout (timeout)
[345.880271] Starting subtest: timeout
[345.882575] Starting dynamic subtest: vecs0
[355.291133] Dynamic subtest vecs0: SUCCESS (9.407s)
[355.302979] Starting dynamic subtest: ccs0
[356.570400] Dynamic subtest ccs0: SUCCESS (1.281s)
[356.582961] Starting dynamic subtest: vcs0
[366.298746] Dynamic subtest vcs0: SUCCESS (9.723s)
[366.310956] Starting dynamic subtest: bcs0
[367.562274] Dynamic subtest bcs0: SUCCESS (1.262s)
[367.573725] Starting dynamic subtest: rcs0
[368.801840] Dynamic subtest rcs0: SUCCESS (1.239s)
[368.814339] Starting dynamic subtest: vcs1
[378.266861] Dynamic subtest vcs1: SUCCESS (9.465s)
[378.269201] Subtest timeout: SUCCESS (32.388s)
[378.342311] [064/133] (644s left) gem_unfence_active_buffers
[378.510098] [065/133] (644s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[378.604134] Starting subtest: fbcpsr-tiling-y
[378.608284] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[378.705754] [066/133] (644s left) kms_flip (modeset-vs-vblank-race-interruptible)
[378.803118] Starting subtest: modeset-vs-vblank-race-interruptible
[378.805354] Starting dynamic subtest: A-eDP1
[383.451497] Dynamic subtest A-eDP1: SUCCESS (4.649s)
[383.465914] Starting dynamic subtest: B-eDP1
[388.082793] Dynamic subtest B-eDP1: SUCCESS (4.630s)
[388.109354] Starting dynamic subtest: C-eDP1
[393.029686] Dynamic subtest C-eDP1: SUCCESS (4.946s)
[393.042110] Starting dynamic subtest: D-eDP1
[397.564703] Dynamic subtest D-eDP1: SUCCESS (4.533s)
[397.569746] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.772s)
[398.743043] [067/133] (624s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[398.861505] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[398.865928] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[398.954642] [068/133] (624s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[399.078251] Starting subtest: y-tiled-addfb-size-offset-overflow
[399.082719] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[399.165114] [069/133] (624s left) gem_exec_reloc (basic-wc-gtt-active)
[399.224857] Subtest basic-wc-gtt-active: SKIP (0.000s)
[399.295571] [070/133] (623s left) syncobj_wait (multi-wait-all-submitted)
[399.352063] Starting subtest: multi-wait-all-submitted
[399.461601] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[399.550722] [071/133] (623s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[399.660774] Starting subtest: 2x-flip-vs-rmfb-interruptible
[399.671610] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[399.782798] [072/133] (623s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[399.887245] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[406.663380] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.778s)
[406.780583] [073/133] (616s left) api_intel_allocator (two-level-inception)
[406.837129] Starting subtest: two-level-inception
[412.239782] Subtest two-level-inception: SUCCESS (5.402s)
[412.358062] [074/133] (611s left) kms_flip (2x-dpms-vs-vblank-race)
[412.451224] Starting subtest: 2x-dpms-vs-vblank-race
[412.462155] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[412.543221] [075/133] (610s left) gem_fence_thrash (bo-write-verify-threaded-y)
[412.581900] Starting subtest: bo-write-verify-threaded-y
[412.601796] Subtest bo-write-verify-threaded-y: SKIP (0.019s)
[412.662373] [076/133] (610s left) kms_cursor_crc (cursor-random-64x21)
[412.852706] Starting subtest: cursor-random-64x21
[412.899430] Subtest cursor-random-64x21: SKIP (0.042s)
[413.115200] [077/133] (610s left) kms_async_flips (invalid-async-flip)
[413.219839] Starting subtest: invalid-async-flip
[413.592463] Starting dynamic subtest: pipe-A-eDP-1
[414.398626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[414.773983] Starting dynamic subtest: pipe-B-eDP-1
[415.541989] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.775s)
[415.912981] Starting dynamic subtest: pipe-C-eDP-1
[416.668823] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[417.027932] Starting dynamic subtest: pipe-D-eDP-1
[417.805314] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.785s)
[417.807732] Subtest invalid-async-flip: SUCCESS (4.588s)
[418.940762] [078/133] (604s left) perf_pmu (init-wait)
[418.982461] Starting subtest: init-wait
[418.984755] Starting dynamic subtest: rcs0
[418.987034] Dynamic subtest rcs0: SUCCESS (0.002s)
[418.997177] Starting dynamic subtest: bcs0
[418.999139] Dynamic subtest bcs0: SUCCESS (0.001s)
[419.007725] Starting dynamic subtest: vcs0
[419.009697] Dynamic subtest vcs0: SUCCESS (0.001s)
[419.018224] Starting dynamic subtest: vcs1
[419.020183] Dynamic subtest vcs1: SUCCESS (0.001s)
[419.030834] Starting dynamic subtest: vecs0
[419.032738] Dynamic subtest vecs0: SUCCESS (0.001s)
[419.047730] Starting dynamic subtest: ccs0
[419.049845] Dynamic subtest ccs0: SUCCESS (0.000s)
[419.051925] Subtest init-wait: SUCCESS (0.010s)
[419.092727] [079/133] (604s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[419.190368] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[419.194740] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[419.291540] [080/133] (604s left) gem_mmap_gtt (hang)
[419.348841] Subtest hang: SKIP (0.000s)
[419.409343] [081/133] (604s left) gem_exec_parallel (contexts)
[419.478318] Starting subtest: contexts
[419.480745] Starting dynamic subtest: rcs0
[422.415981] Dynamic subtest rcs0: SUCCESS (2.935s)
[422.428157] Starting dynamic subtest: bcs0
[425.735727] Dynamic subtest bcs0: SUCCESS (3.318s)
[425.745593] Starting dynamic subtest: vcs0
[429.716561] Dynamic subtest vcs0: SUCCESS (3.977s)
[429.726878] Starting dynamic subtest: vcs1
[433.758844] Dynamic subtest vcs1: SUCCESS (4.040s)
[433.770447] Starting dynamic subtest: vecs0
[437.820002] Dynamic subtest vecs0: SUCCESS (4.058s)
[437.832078] Starting dynamic subtest: ccs0
[441.177501] Dynamic subtest ccs0: SUCCESS (3.354s)
[441.180294] Subtest contexts: SUCCESS (21.696s)
[441.386836] [082/133] (582s left) kms_pipe_crc_basic (nonblocking-crc)
[441.488355] Starting subtest: nonblocking-crc
[441.490696] Starting dynamic subtest: pipe-A-eDP-1
[442.222930] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[442.233221] Starting dynamic subtest: pipe-B-eDP-1
[443.700737] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.475s)
[443.713247] Starting dynamic subtest: pipe-C-eDP-1
[445.042728] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s)
[445.055310] Starting dynamic subtest: pipe-D-eDP-1
[446.390049] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.348s)
[446.392447] Subtest nonblocking-crc: SUCCESS (4.905s)
[447.191699] [083/133] (576s left) gem_busy (close-race)
[447.245004] Starting subtest: close-race
[471.266186] Subtest close-race: SUCCESS (24.021s)
[471.658242] [084/133] (552s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[471.806546] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[471.808900] Starting dynamic subtest: pipe-A
[471.832908] Dynamic subtest pipe-A: SKIP (0.018s)
[471.854242] Starting dynamic subtest: pipe-B
[471.863858] Dynamic subtest pipe-B: SKIP (0.030s)
[471.885103] Starting dynamic subtest: pipe-C
[471.895471] Dynamic subtest pipe-C: SKIP (0.030s)
[471.911240] Starting dynamic subtest: pipe-D
[471.923672] Dynamic subtest pipe-D: SKIP (0.030s)
[471.927464] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.112s)
[472.034307] [085/133] (551s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[472.127930] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[475.992648] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.870s)
[477.185813] [086/133] (546s left) perf (missing-sample-flags)
[477.330735] Starting subtest: missing-sample-flags
[477.332594] Subtest missing-sample-flags: SUCCESS (0.000s)
[477.373029] [087/133] (546s left) kms_invalid_mode (bad-hsync-start)
[477.462197] Starting subtest: bad-hsync-start
[477.464486] Starting dynamic subtest: pipe-A-eDP-1
[477.748278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[477.758597] Starting dynamic subtest: pipe-B-eDP-1
[477.760979] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[477.770012] Starting dynamic subtest: pipe-C-eDP-1
[477.771935] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[477.782297] Starting dynamic subtest: pipe-D-eDP-1
[477.784648] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[477.787322] Subtest bad-hsync-start: SUCCESS (0.292s)
[478.623785] [088/133] (545s left) gem_exec_fence (submit3)
[478.802210] Starting subtest: submit3
[478.806446] Subtest submit3: SKIP (0.000s)
[480.374099] [089/133] (543s left) perf_pmu (all-busy-idle-check-all)
[480.421828] Starting subtest: all-busy-idle-check-all
[482.273985] Subtest all-busy-idle-check-all: SUCCESS (1.852s)
[482.378005] [090/133] (541s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[482.475042] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[489.142065] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.671s)
[489.301826] [091/133] (534s left) gem_exec_capture (userptr)
[489.375835] Starting subtest: userptr
[490.209068] Subtest userptr: SUCCESS (0.834s)
[490.338766] [092/133] (533s left) kms_properties (plane-properties-legacy)
[490.428954] Starting subtest: plane-properties-legacy
[490.431088] Starting dynamic subtest: pipe-A-eDP-1
[491.023199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[491.032803] Starting dynamic subtest: pipe-B-eDP-1
[492.284170] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.260s)
[492.295351] Starting dynamic subtest: pipe-C-eDP-1
[493.526102] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[493.535711] Starting dynamic subtest: pipe-D-eDP-1
[494.752720] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[494.754746] Subtest plane-properties-legacy: SUCCESS (4.325s)
[495.546327] [093/133] (528s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[495.631746] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[495.635760] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[495.717850] [094/133] (528s left) kms_psr (fbc-psr-sprite-plane-onoff)
[495.828866] Starting subtest: fbc-psr-sprite-plane-onoff
[495.831103] Starting dynamic subtest: eDP-1
[495.835305] Dynamic subtest eDP-1: SKIP (0.000s)
[495.839478] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[495.902298] [095/133] (528s left) gem_exec_schedule (preempt-queue-contexts)
[495.988622] Subtest preempt-queue-contexts: SKIP (0.000s)
[496.290917] [096/133] (528s left) gem_render_copy (y-tiled-ccs-to-linear)
[496.356141] Starting subtest: y-tiled-ccs-to-linear
[496.360974] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[496.544102] [097/133] (527s left) gem_mmap_wc (write-read-distinct)
[496.604176] Subtest write-read-distinct: SKIP (0.000s)
[496.670595] [098/133] (527s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[496.760450] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[500.771134] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.015s)
[501.970632] [099/133] (522s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[502.057850] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[502.060181] Starting dynamic subtest: pipe-A-eDP-1
[502.083748] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[502.095252] Starting dynamic subtest: pipe-B-eDP-1
[502.117796] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[502.126719] Starting dynamic subtest: pipe-C-eDP-1
[502.148240] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[502.156861] Starting dynamic subtest: pipe-D-eDP-1
[502.179428] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[502.183886] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[504.312927] [100/133] (520s left) kms_chamelium_color (gamma)
[504.413144] Subtest gamma: SKIP (0.000s)
[504.460837] [101/133] (520s left) gem_mmap_gtt (basic-write-read)
[504.521792] Subtest basic-write-read: SKIP (0.000s)
[504.584489] [102/133] (520s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[504.656206] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[504.756877] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[504.835065] [103/133] (519s left) kms_psr (pr-primary-blt)
[504.930568] Starting subtest: pr-primary-blt
[504.934793] Subtest pr-primary-blt: SKIP (0.000s)
[505.009194] [104/133] (519s left) gem_exec_flush (basic-uc-prw-default)
[505.074063] Starting subtest: basic-uc-prw-default
[510.531641] Subtest basic-uc-prw-default: SUCCESS (5.459s)
[510.730466] [105/133] (514s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[510.824734] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[510.826959] Starting dynamic subtest: pipe-A-eDP-1
[511.527137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[511.538077] Starting dynamic subtest: pipe-B-eDP-1
[513.310603] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.783s)
[513.319534] Starting dynamic subtest: pipe-C-eDP-1
[515.054135] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.743s)
[515.065289] Starting dynamic subtest: pipe-D-eDP-1
[516.799868] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.744s)
[516.801795] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.970s)
[517.961764] [106/133] (506s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[518.054822] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[524.750066] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.698s)
[524.898211] [107/133] (499s left) prime_vgem (basic-read)
[524.978284] Starting subtest: basic-read
[524.985480] Subtest basic-read: SKIP (0.007s)
[525.087298] [108/133] (499s left) syncobj_timeline (device-submit-unordered)
[525.142459] Starting subtest: device-submit-unordered
[525.144364] Subtest device-submit-unordered: SUCCESS (0.000s)
[525.238607] [109/133] (499s left) gem_eio (wait-1us)
[525.456548] Starting subtest: wait-1us
[525.778885] Subtest wait-1us: SUCCESS (0.322s)
[525.909076] [110/133] (499s left) gem_ctx_isolation (preservation)
[525.978501] Starting subtest: preservation
[525.980706] Starting dynamic subtest: rcs0
[526.116647] Dynamic subtest rcs0: SUCCESS (0.138s)
[526.126398] Starting dynamic subtest: bcs0
[526.245708] Dynamic subtest bcs0: SUCCESS (0.128s)
[526.259136] Starting dynamic subtest: vcs0
[526.414308] Dynamic subtest vcs0: SUCCESS (0.168s)
[526.427025] Starting dynamic subtest: vcs1
[528.401912] Dynamic subtest vcs1: SUCCESS (1.986s)
[528.415071] Starting dynamic subtest: vecs0
[530.387583] Dynamic subtest vecs0: SUCCESS (1.984s)
[530.397472] Starting dynamic subtest: ccs0
[532.446223] Dynamic subtest ccs0: SUCCESS (2.057s)
[532.448829] Subtest preservation: SUCCESS (6.467s)
[532.678332] [111/133] (492s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[532.785804] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[532.790404] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[532.862427] [112/133] (492s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[532.956987] Starting subtest: fbcpsr-rgb565-draw-blt
[540.087110] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.131s)
[540.220845] [113/133] (484s left) kms_prop_blob (invalid-set-prop)
[540.274239] Starting subtest: invalid-set-prop
[540.276448] Subtest invalid-set-prop: SUCCESS (0.000s)
[540.359213] [114/133] (484s left) kms_psr (psr2-sprite-blt)
[540.446465] Starting subtest: psr2-sprite-blt
[540.448733] Starting dynamic subtest: eDP-1
[542.183439] Dynamic subtest eDP-1: SUCCESS (1.737s)
[542.185882] Subtest psr2-sprite-blt: SUCCESS (1.738s)
[543.068134] [115/133] (482s left) gem_exec_schedule (timeslicing)
[543.145026] Starting subtest: timeslicing
[543.147136] Starting dynamic subtest: rcs0
[543.154164] Dynamic subtest rcs0: SUCCESS (0.020s)
[543.164409] Starting dynamic subtest: bcs0
[543.175176] Dynamic subtest bcs0: SUCCESS (0.020s)
[543.186981] Starting dynamic subtest: vcs0
[543.195446] Dynamic subtest vcs0: SUCCESS (0.020s)
[543.205049] Starting dynamic subtest: vcs1
[543.217355] Dynamic subtest vcs1: SUCCESS (0.021s)
[543.235076] Starting dynamic subtest: vecs0
[543.240435] Dynamic subtest vecs0: SUCCESS (0.022s)
[543.251034] Starting dynamic subtest: ccs0
[543.262560] Dynamic subtest ccs0: SUCCESS (0.021s)
[543.264763] Subtest timeslicing: SUCCESS (0.130s)
[544.332179] [116/133] (480s left) kms_scaling_modes (scaling-mode-full-aspect)
[544.423777] Starting subtest: scaling-mode-full-aspect
[544.425951] Starting dynamic subtest: pipe-A-eDP-1
[544.517722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[544.531137] Starting dynamic subtest: pipe-B-eDP-1
[545.684333] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s)
[545.699994] Starting dynamic subtest: pipe-C-eDP-1
[546.798319] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[546.811121] Starting dynamic subtest: pipe-D-eDP-1
[547.942476] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[547.944757] Subtest scaling-mode-full-aspect: SUCCESS (3.520s)
[549.116677] [117/133] (476s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[549.216298] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[549.220402] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[549.337073] [118/133] (476s left) gem_mmap_gtt (cpuset-big-copy)
[549.397715] Subtest cpuset-big-copy: SKIP (0.000s)
[549.472002] [119/133] (475s left) kms_atomic_interruptible (legacy-pageflip)
[549.562683] Starting subtest: legacy-pageflip
[549.564951] Starting dynamic subtest: pipe-A-eDP-1
[557.033861] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.468s)
[557.036125] Subtest legacy-pageflip: SUCCESS (7.470s)
[557.857020] [120/133] (467s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[557.952423] Starting subtest: crc-primary-basic-yf-tiled-ccs
[557.954750] Starting dynamic subtest: pipe-A-eDP-1
[557.976714] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[557.986619] Starting dynamic subtest: pipe-B-eDP-1
[558.008617] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[558.018345] Starting dynamic subtest: pipe-C-eDP-1
[558.039481] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[558.049958] Starting dynamic subtest: pipe-D-eDP-1
[558.071357] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[558.075387] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[560.133106] [121/133] (465s left) syncobj_timeline (wait-all-snapshot)
[560.187960] Starting subtest: wait-all-snapshot
[560.268360] Subtest wait-all-snapshot: SUCCESS (0.081s)
[560.345245] [122/133] (465s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[560.437448] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[560.441809] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[560.547249] [123/133] (465s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[560.647125] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[560.651323] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[560.744648] [124/133] (464s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[560.811162] Starting subtest: multi-wait-for-submit-submitted-signaled
[560.813575] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[560.921948] [125/133] (464s left) i915_query (query-topology-coherent-slice-mask)
[560.978344] Starting subtest: query-topology-coherent-slice-mask
[560.983490] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[561.097279] [126/133] (464s left) gem_exec_reloc (basic-concurrent0)
[561.143431] Subtest basic-concurrent0: SKIP (0.000s)
[561.230423] [127/133] (464s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[561.617552] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[562.442179] [128/133] (463s left) gem_lmem_evict (dontneed-evict-race)
[562.487592] Subtest dontneed-evict-race: SKIP (0.000s)
[562.535285] [129/133] (463s left) kms_addfb_basic (bad-pitch-999)
[562.587663] Starting subtest: bad-pitch-999
[562.589848] Subtest bad-pitch-999: SUCCESS (0.000s)
[562.727048] [130/133] (463s left) kms_lease (implicit-plane-lease)
[562.818689] Starting subtest: implicit-plane-lease
[562.820934] Subtest implicit-plane-lease: SUCCESS (0.002s)
[562.936987] [131/133] (462s left) gen3_render_tiledy_blits
[563.057835] [132/133] (462s left) gem_softpin (zero)
[563.107436] Starting subtest: zero
[563.114725] Subtest zero: SUCCESS (0.007s)
[563.225575] [133/133] (462s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[563.326325] Starting subtest: 4-tiled-64bpp-rotate-0
[564.882157] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.556s)
[565.054788] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_endless
results: parsing output: 1/ for test: i915_drm_fdinfo
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_plane_multiple
results: parsing output: 5/ for test: dmabuf_sync_file
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_render_copy
results: parsing output: 10/ for test: kms_pm_dc
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_dp_linktrain_fallback
results: parsing output: 14/ for test: kms_color
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: api_intel_bb
results: parsing output: 18/ for test: i915_hangman
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_pipe_b_c_ivb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: i915_query
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_exec
results: parsing output: 39/ for test: kms_dp_link_training
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_vrr
results: parsing output: 44/ for test: prime_mmap
results: parsing output: 45/ for test: gem_exec_whisper
results: parsing output: 46/ for test: perf_pmu
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: kms_properties
results: parsing output: 53/ for test: kms_selftest
results: parsing output: 54/ for test: gem_mmap_offset
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: kms_cursor_edge_walk
results: parsing output: 57/ for test: gem_ctx_sseu
results: parsing output: 58/ for test: dumb_buffer
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: sysfs_preempt_timeout
results: parsing output: 63/ for test: gem_unfence_active_buffers
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: api_intel_allocator
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_fence_thrash
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_async_flips
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: gem_exec_parallel
results: parsing output: 81/ for test: kms_pipe_crc_basic
results: parsing output: 82/ for test: gem_busy
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: kms_invalid_mode
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_capture
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_chamelium_color
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_exec_flush
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: prime_vgem
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: gem_ctx_isolation
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_prop_blob
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_scaling_modes
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: kms_atomic_interruptible
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: i915_query
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: gem_lmem_evict
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_lease
results: parsing output: 130/ for test: gen3_render_tiledy_blits
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: kms_big_fb
Done.