[60.865340] Initializing watchdogs
[60.865385]   /dev/watchdog0
[60.880039] [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.884479] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.887126] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.890723] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[61.037756] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[61.042551] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[61.151593] [002/133] (960s left) perf_pmu (init-busy)
[61.190448] Starting subtest: init-busy
[61.192770] Starting dynamic subtest: rcs0
[61.195143] Dynamic subtest rcs0: SUCCESS (0.002s)
[61.202398] Starting dynamic subtest: bcs0
[61.204297] Dynamic subtest bcs0: SUCCESS (0.001s)
[61.210978] Starting dynamic subtest: vcs0
[61.212962] Dynamic subtest vcs0: SUCCESS (0.001s)
[61.219390] Starting dynamic subtest: vcs1
[61.221309] Dynamic subtest vcs1: SUCCESS (0.001s)
[61.227898] Starting dynamic subtest: vecs0
[61.229816] Dynamic subtest vecs0: SUCCESS (0.001s)
[61.236045] Starting dynamic subtest: ccs0
[61.238406] Dynamic subtest ccs0: SUCCESS (0.000s)
[61.240612] Subtest init-busy: SUCCESS (0.006s)
[61.297933] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[61.394715] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[61.398979] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[61.498663] [004/133] (960s left) kms_flip (blocking-wf_vblank)
[61.590924] Starting subtest: blocking-wf_vblank
[61.592822] Starting dynamic subtest: A-eDP1
[70.539839] Dynamic subtest A-eDP1: SUCCESS (8.945s)
[70.548897] Starting dynamic subtest: B-eDP1
[79.478302] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[79.488673] Starting dynamic subtest: C-eDP1
[88.401623] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[88.411826] Starting dynamic subtest: D-eDP1
[97.336805] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[97.343627] Subtest blocking-wf_vblank: SUCCESS (35.746s)
[98.569665] [005/133] (922s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[98.681072] Starting subtest: short-flip-after-cursor-toggle
[99.606253] Subtest short-flip-after-cursor-toggle: SUCCESS (0.924s)
[100.412615] [006/133] (921s left) kms_hdr (bpc-switch)
[100.521082] Starting subtest: bpc-switch
[101.595503] Starting dynamic subtest: pipe-A-eDP-1
[105.078199] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s)
[105.080678] Subtest bpc-switch: SUCCESS (4.560s)
[105.186251] [007/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[105.298819] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[112.664055] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.369s)
[112.819907] [008/133] (908s left) kms_invalid_mode (zero-clock)
[112.919730] Starting subtest: zero-clock
[112.922207] Starting dynamic subtest: pipe-A-eDP-1
[113.201898] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[113.209659] Starting dynamic subtest: pipe-B-eDP-1
[113.211649] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[113.218532] Starting dynamic subtest: pipe-C-eDP-1
[113.220502] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[113.227724] Starting dynamic subtest: pipe-D-eDP-1
[113.229953] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[113.232323] Subtest zero-clock: SUCCESS (0.293s)
[114.068538] [009/133] (907s left) kms_frontbuffer_tracking (psr-suspend)
[114.178265] Starting subtest: psr-suspend
[152.470368] Subtest psr-suspend: SUCCESS (8.858s)
[162.636621] [010/133] (869s left) kms_atomic_transition (modeset-transition-fencing)
[162.745824] Starting subtest: modeset-transition-fencing
[162.747856] Starting dynamic subtest: 1x-outputs
[173.578313] Dynamic subtest 1x-outputs: SUCCESS (10.796s)
[173.580576] Subtest modeset-transition-fencing: SUCCESS (10.797s)
[174.418493] [011/133] (857s left) gem_mmap_gtt (basic-small-copy-xy)
[174.481333] Subtest basic-small-copy-XY: SKIP (0.000s)
[174.534481] [012/133] (857s left) gem_softpin (reverse)
[174.586353] Starting subtest: reverse
[174.593651] Subtest reverse: SUCCESS (0.007s)
[174.701270] [013/133] (857s left) kms_content_protection (lic-type-0-hdcp14)
[174.847459] Starting subtest: lic-type-0-hdcp14
[174.851830] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[174.956300] [014/133] (856s left) gem_exec_params (batch-first)
[175.024647] Starting subtest: batch-first
[175.031059] Subtest batch-first: SUCCESS (0.006s)
[175.145711] [015/133] (856s left) kms_chamelium_frames (dp-crc-multiple)
[175.546474] Subtest dp-crc-multiple: SKIP (0.000s)
[176.361300] [016/133] (855s left) api_intel_bb (misplaced-blitter)
[176.429534] Starting subtest: misplaced-blitter
[176.435078] Subtest misplaced-blitter: SUCCESS (0.007s)
[176.545538] [017/133] (855s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[176.627603] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[176.629554] Starting dynamic subtest: pipe-A-eDP-1
[178.811851] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.183s)
[178.819669] Starting dynamic subtest: pipe-B-eDP-1
[181.207222] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.391s)
[181.215839] Starting dynamic subtest: pipe-C-eDP-1
[183.345195] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.134s)
[183.352552] Starting dynamic subtest: pipe-D-eDP-1
[185.410938] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.065s)
[185.412843] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.777s)
[186.623086] [018/133] (845s left) gem_exec_schedule (noreorder-corked)
[186.799416] Starting subtest: noreorder-corked
[186.802003] Starting dynamic subtest: rcs0
[187.935306] Dynamic subtest rcs0: SUCCESS (1.135s)
[187.946792] Starting dynamic subtest: vcs0
[189.335921] Dynamic subtest vcs0: SUCCESS (1.396s)
[189.353861] Starting dynamic subtest: vcs1
[191.317101] Dynamic subtest vcs1: SUCCESS (1.978s)
[191.329983] Starting dynamic subtest: vecs0
[193.296988] Dynamic subtest vecs0: SUCCESS (1.976s)
[193.308265] Starting dynamic subtest: ccs0
[194.453827] Dynamic subtest ccs0: SUCCESS (1.155s)
[194.456727] Subtest noreorder-corked: SUCCESS (7.650s)
[194.636205] [019/133] (837s left) gem_userptr_blits (relocations)
[194.698046] Starting subtest: relocations
[194.702167] Subtest relocations: SKIP (0.000s)
[194.812974] [020/133] (837s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[194.906576] Starting subtest: fbcpsr-indfb-scaledprimary
[200.715226] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.807s)
[200.852558] [021/133] (831s left) gem_mmap_gtt (hang)
[200.911519] Subtest hang: SKIP (0.000s)
[200.974392] [022/133] (831s left) kms_feature_discovery (display-1x)
[201.073339] Starting subtest: display-1x
[201.075626] Subtest display-1x: SUCCESS (0.000s)
[201.145829] [023/133] (831s left) gem_mmap_offset (partial-unmap)
[201.201390] Starting subtest: partial-unmap
[201.203233] Starting dynamic subtest: smem0
[201.709488] Dynamic subtest smem0: SUCCESS (0.508s)
[201.712054] Subtest partial-unmap: SUCCESS (0.509s)
[201.820369] [024/133] (830s left) syncobj_wait (invalid-reset-bad-pad)
[201.870191] Starting subtest: invalid-reset-bad-pad
[201.872419] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[201.956982] [025/133] (830s left) kms_color (ctm-0-50)
[202.042654] Starting subtest: ctm-0-50
[202.044884] Starting dynamic subtest: pipe-A-eDP-1
[205.561444] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.513s)
[205.570139] Starting dynamic subtest: pipe-B-eDP-1
[209.817567] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.255s)
[209.826254] Starting dynamic subtest: pipe-C-eDP-1
[213.835492] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.016s)
[213.844480] Starting dynamic subtest: pipe-D-eDP-1
[217.829131] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.991s)
[217.831558] Subtest ctm-0-50: SUCCESS (15.778s)
[218.665015] [026/133] (813s left) kms_pm_rpm (pm-tiling)
[220.511524] Starting subtest: pm-tiling
[220.516586] Subtest pm-tiling: SKIP (0.000s)
[220.913267] [027/133] (811s left) kms_cursor_crc (cursor-sliding-128x42)
[221.140979] Starting subtest: cursor-sliding-128x42
[221.188857] Subtest cursor-sliding-128x42: SKIP (0.043s)
[221.389347] [028/133] (811s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[221.482891] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[225.474816] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.993s)
[226.621783] [029/133] (805s left) gem_exec_store (pages)
[226.693746] Starting subtest: pages
[226.695691] Starting dynamic subtest: rcs0
[226.781899] Dynamic subtest rcs0: SUCCESS (0.091s)
[226.791094] Starting dynamic subtest: bcs0
[226.858851] Dynamic subtest bcs0: SUCCESS (0.074s)
[226.869163] Starting dynamic subtest: vcs0
[226.928699] Dynamic subtest vcs0: SUCCESS (0.069s)
[226.939557] Starting dynamic subtest: vcs1
[227.002069] Dynamic subtest vcs1: SUCCESS (0.072s)
[227.015325] Starting dynamic subtest: vecs0
[227.073517] Dynamic subtest vecs0: SUCCESS (0.071s)
[227.083725] Starting dynamic subtest: ccs0
[227.144922] Dynamic subtest ccs0: SUCCESS (0.071s)
[227.147372] Subtest pages: SUCCESS (0.454s)
[227.331010] [030/133] (805s left) gem_eio (unwedge-stress)
[227.557273] Starting subtest: unwedge-stress
[227.559620] Starting dynamic subtest: render
[232.345537] Dynamic subtest render: SUCCESS (4.783s)
[232.360286] Starting dynamic subtest: bsd1
[250.799664] Dynamic subtest bsd1: SUCCESS (18.445s)
[250.815540] Starting dynamic subtest: bsd2
[268.779577] Dynamic subtest bsd2: SUCCESS (17.972s)
[268.793280] Starting dynamic subtest: blt
[268.797249] Dynamic subtest blt: SKIP (0.000s)
[268.805295] Starting dynamic subtest: vebox
[286.868581] Dynamic subtest vebox: SUCCESS (18.100s)
[286.871067] Subtest unwedge-stress: SUCCESS (59.303s)
[288.378021] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[288.381027] [031/133] (744s left) gem_fenced_exec_thrash (no-spare-fences)
[288.441481] Subtest no-spare-fences: SKIP (0.000s)
[288.519563] [032/133] (744s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[288.619113] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[288.623267] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[288.713610] [033/133] (743s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[288.815208] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[288.819664] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[288.885602] [034/133] (743s left) gem_sync (basic-store-each)
[288.969783] Starting subtest: basic-store-each
[291.513805] Subtest basic-store-each: SUCCESS (2.555s)
[291.744433] [035/133] (741s left) kms_pipe_crc_basic (suspend-read-crc)
[291.852026] Starting subtest: suspend-read-crc
[291.854280] Starting dynamic subtest: pipe-A-eDP-1
[309.832577] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.957s)
[309.843143] Starting dynamic subtest: pipe-B-eDP-1
[328.827404] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.570s)
[328.838664] Starting dynamic subtest: pipe-C-eDP-1
[347.797577] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.404s)
[347.807585] Starting dynamic subtest: pipe-D-eDP-1
[366.797363] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.454s)
[366.799769] Subtest suspend-read-crc: SUCCESS (13.392s)
[377.657142] [036/133] (665s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[377.744564] Starting subtest: y-tiled-to-vebox-y-tiled
[377.748971] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[377.924936] [037/133] (664s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[378.026177] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[378.028457] Starting dynamic subtest: pipe-A-eDP-1
[378.574667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.517s)
[378.585517] Starting dynamic subtest: pipe-B-eDP-1
[380.030912] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.442s)
[380.041935] Starting dynamic subtest: pipe-C-eDP-1
[381.424137] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[381.439168] Starting dynamic subtest: pipe-D-eDP-1
[382.862603] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.430s)
[382.864904] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.778s)
[384.039846] [038/133] (658s left) kms_cursor_crc (cursor-sliding-64x21)
[384.229428] Starting subtest: cursor-sliding-64x21
[384.280937] Subtest cursor-sliding-64x21: SKIP (0.046s)
[384.508406] [039/133] (658s left) gem_exec_balancer (hog)
[384.563812] Starting subtest: hog
[384.568109] Subtest hog: SKIP (0.000s)
[384.868932] [040/133] (658s left) gem_exec_suspend (basic-s3)
[384.933836] Starting subtest: basic-S3
[384.936296] Starting dynamic subtest: smem
[405.475717] Dynamic subtest smem: SUCCESS (6.929s)
[405.478667] Subtest basic-S3: SUCCESS (6.931s)
[409.676794] [041/133] (637s left) kms_psr (psr-cursor-plane-move)
[409.781376] Starting subtest: psr-cursor-plane-move
[409.783658] Starting dynamic subtest: eDP-1
[411.514845] Dynamic subtest eDP-1: SUCCESS (1.725s)
[411.517100] Subtest psr-cursor-plane-move: SUCCESS (1.726s)
[412.393553] [042/133] (634s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[412.502904] Starting subtest: yf-tiled-16bpp-rotate-0
[412.507409] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[412.601809] [043/133] (634s left) kms_cursor_crc (cursor-offscreen-max-size)
[412.916504] Starting subtest: cursor-offscreen-max-size
[412.923024] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[413.036338] [044/133] (634s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[413.138998] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[413.141182] Starting dynamic subtest: pipe-A
[413.161363] Dynamic subtest pipe-A: SKIP (0.018s)
[413.170212] Starting dynamic subtest: pipe-B
[413.192692] Dynamic subtest pipe-B: SKIP (0.032s)
[413.201884] Starting dynamic subtest: pipe-C
[413.226721] Dynamic subtest pipe-C: SKIP (0.033s)
[413.235261] Starting dynamic subtest: pipe-D
[413.259271] Dynamic subtest pipe-D: SKIP (0.032s)
[413.262986] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.118s)
[413.355483] [045/133] (633s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[413.453851] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[414.426631] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.968s)
[414.560436] [046/133] (632s left) kms_plane_multiple (2x-tiling-y)
[414.652715] Starting subtest: 2x-tiling-y
[414.656827] Subtest 2x-tiling-y: SKIP (0.000s)
[414.727320] [047/133] (632s left) gem_ccs (ctrl-surf-copy-new-ctx)
[414.790368] Starting subtest: ctrl-surf-copy-new-ctx
[414.794414] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[414.899342] [048/133] (632s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[414.984038] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[414.985856] Starting dynamic subtest: pipe-A-eDP-1
[415.006324] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[415.016367] Starting dynamic subtest: pipe-B-eDP-1
[415.034146] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[415.042542] Starting dynamic subtest: pipe-C-eDP-1
[415.059613] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[415.067733] Starting dynamic subtest: pipe-D-eDP-1
[415.085631] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[415.089013] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[417.273747] [049/133] (630s left) kms_vrr (seamless-rr-switch-drrs)
[417.369491] Starting subtest: seamless-rr-switch-drrs
[417.376032] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[417.488548] [050/133] (630s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[417.539264] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[417.647255] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[417.723457] [051/133] (629s left) gem_userptr_blits (access-control)
[417.800129] Starting subtest: access-control
[417.804276] Subtest access-control: SKIP (0.000s)
[417.908483] [052/133] (629s left) gem_ctx_persistence (legacy-engines-mixed-process)
[417.966630] Starting subtest: legacy-engines-mixed-process
[417.968825] Starting dynamic subtest: render
[419.494522] Dynamic subtest render: SUCCESS (1.524s)
[419.506712] Starting dynamic subtest: bsd1
[421.568329] Dynamic subtest bsd1: SUCCESS (2.068s)
[421.579598] Starting dynamic subtest: bsd2
[423.468278] Dynamic subtest bsd2: SUCCESS (1.895s)
[423.478794] Starting dynamic subtest: blt
[425.436112] Dynamic subtest blt: SUCCESS (1.964s)
[425.445416] Starting dynamic subtest: vebox
[427.497190] Dynamic subtest vebox: SUCCESS (2.058s)
[427.499619] Subtest legacy-engines-mixed-process: SUCCESS (9.519s)
[427.598522] [053/133] (620s left) kms_psr (psr-cursor-render)
[427.695503] Starting subtest: psr-cursor-render
[427.697772] Starting dynamic subtest: eDP-1
[429.383939] Dynamic subtest eDP-1: SUCCESS (1.685s)
[429.386205] Subtest psr-cursor-render: SUCCESS (1.686s)
[430.249323] [054/133] (617s left) gem_exercise_blt (fast-copy)
[430.315891] Starting subtest: fast-copy
[430.318218] Starting dynamic subtest: linear-smem-smem
[430.346200] Dynamic subtest linear-smem-smem: SUCCESS (0.030s)
[430.355225] Starting dynamic subtest: xmajor-smem-smem
[430.365632] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[430.373918] Starting dynamic subtest: tile4-smem-smem
[430.382923] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[430.391064] Starting dynamic subtest: tile64-smem-smem
[430.400928] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[430.403322] Subtest fast-copy: SUCCESS (0.085s)
[430.513283] [055/133] (617s left) perf (polling-small-buf)
[430.653183] Starting subtest: polling-small-buf
[430.743969] Subtest polling-small-buf: SUCCESS (0.090s)
[430.796094] [056/133] (616s left) gem_tiling_max_stride
[430.924965] [057/133] (616s left) gem_mmap_gtt (basic-write)
[430.972782] Subtest basic-write: SKIP (0.000s)
[431.032601] [058/133] (616s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[431.130541] Starting subtest: fbc-rgb101010-draw-blt
[435.763208] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.632s)
[436.885181] [059/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[436.982837] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[436.987072] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[437.086296] [060/133] (610s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[437.139710] Starting subtest: multi-wait-all-for-submit-available-signaled
[437.141588] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[437.229790] [061/133] (610s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[437.324641] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[437.326766] Starting dynamic subtest: pipe-A-eDP-1
[437.387332] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[437.396339] Starting dynamic subtest: pipe-B-eDP-1
[437.452375] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.063s)
[437.461621] Starting dynamic subtest: pipe-C-eDP-1
[437.517251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.063s)
[437.526183] Starting dynamic subtest: pipe-D-eDP-1
[437.578089] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[437.580157] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.255s)
[439.838447] [062/133] (608s left) gem_ctx_param (invalid-size-get)
[439.891354] Starting subtest: invalid-size-get
[439.893851] Subtest invalid-size-get: SUCCESS (0.001s)
[440.011240] [063/133] (608s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[440.105253] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[440.107566] Starting dynamic subtest: pipe-A-eDP-1
[440.201133] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[440.211969] Starting dynamic subtest: pipe-B-eDP-1
[441.319132] Dynamic subtest pipe-B-eDP-1: SKIP (1.117s)
[441.323582] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.219s)
[442.509164] [064/133] (605s left) gem_mmap_gtt (basic-short)
[442.560637] Subtest basic-short: SKIP (0.000s)
[442.615789] [065/133] (605s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[442.716557] Starting subtest: fbc-psr-cursor-mmap-gtt
[442.718829] Starting dynamic subtest: eDP-1
[442.723133] Dynamic subtest eDP-1: SKIP (0.000s)
[442.727463] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[442.794079] [066/133] (605s left) kms_sequence (queue-idle)
[442.882574] Starting subtest: queue-idle
[442.884849] Starting dynamic subtest: pipe-A-eDP-1
[444.700726] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[444.710298] Starting dynamic subtest: pipe-B-eDP-1
[447.191291] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.488s)
[447.200985] Starting dynamic subtest: pipe-C-eDP-1
[449.601332] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.411s)
[449.611458] Starting dynamic subtest: pipe-D-eDP-1
[452.042494] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s)
[452.044700] Subtest queue-idle: SUCCESS (9.159s)
[452.853208] [067/133] (595s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[452.982450] Starting subtest: cursorB-vs-flipB-atomic
[452.987119] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[453.137931] [068/133] (595s left) gem_eio (context-create)
[453.371580] Starting subtest: context-create
[453.709875] Subtest context-create: SUCCESS (0.336s)
[453.841562] [069/133] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[453.937465] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[460.660773] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.723s)
[460.792415] [070/133] (587s left) gen7_exec_parse (batch-without-end)
[460.858372] Subtest batch-without-end: SKIP (0.000s)
[460.937789] [071/133] (587s left) kms_prop_blob (blob-prop-lifetime)
[460.990316] Starting subtest: blob-prop-lifetime
[460.992502] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[461.093270] [072/133] (587s left) api_intel_bb (crc32)
[461.144478] Starting subtest: crc32
[461.146306] Starting dynamic subtest: rcs0-smem0
[461.463153] Dynamic subtest rcs0-smem0: SUCCESS (0.319s)
[461.475475] Starting dynamic subtest: bcs0-smem0
[461.825667] Dynamic subtest bcs0-smem0: SUCCESS (0.360s)
[461.838083] Starting dynamic subtest: vcs0-smem0
[462.220010] Dynamic subtest vcs0-smem0: SUCCESS (0.391s)
[462.231942] Starting dynamic subtest: vcs1-smem0
[462.588218] Dynamic subtest vcs1-smem0: SUCCESS (0.365s)
[462.599702] Starting dynamic subtest: vecs0-smem0
[462.981859] Dynamic subtest vecs0-smem0: SUCCESS (0.390s)
[462.994084] Starting dynamic subtest: ccs0-smem0
[463.328012] Dynamic subtest ccs0-smem0: SUCCESS (0.344s)
[463.330954] Subtest crc32: SUCCESS (2.186s)
[463.447708] [073/133] (585s left) kms_vblank (wait-forked-busy)
[463.551336] Starting subtest: wait-forked-busy
[463.553226] Starting dynamic subtest: pipe-A-eDP-1
[465.434742] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[465.448547] Starting dynamic subtest: pipe-D-eDP-1
[468.024841] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s)
[468.026649] Subtest wait-forked-busy: SUCCESS (4.472s)
[468.829083] [074/133] (579s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[468.921654] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[468.925653] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[468.992828] [075/133] (579s left) kms_psr2_su (page_flip-xrgb8888)
[469.053914] Subtest page_flip-XRGB8888: SKIP (0.000s)
[469.115482] [076/133] (579s left) kms_addfb_basic (too-wide)
[469.207571] Starting subtest: too-wide
[469.209683] Subtest too-wide: SUCCESS (0.000s)
[469.312523] [077/133] (579s left) kms_pm_backlight (basic-brightness)
[469.422741] Starting subtest: basic-brightness
[469.471163] Starting dynamic subtest: eDP-1
[469.782497] Dynamic subtest eDP-1: SUCCESS (0.308s)
[469.784441] Subtest basic-brightness: SUCCESS (0.359s)
[470.671388] [078/133] (578s left) i915_drm_fdinfo (virtual-busy-idle-all)
[470.707198] Starting subtest: virtual-busy-idle-all
[470.711728] Subtest virtual-busy-idle-all: SKIP (0.000s)
[470.789187] [079/133] (577s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[470.883767] Starting subtest: addfb25-y-tiled-legacy
[470.886025] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[470.990414] [080/133] (577s left) gem_pxp (create-regular-buffer)
[471.112807] Starting subtest: create-regular-buffer
[471.115295] Subtest create-regular-buffer: SUCCESS (0.000s)
[471.239860] [081/133] (577s left) gem_render_copy (yf-tiled)
[471.301881] Starting subtest: yf-tiled
[471.306351] Subtest yf-tiled: SKIP (0.000s)
[471.480146] [082/133] (577s left) gem_ctx_engines (none)
[471.544501] Starting subtest: none
[471.546841] Subtest none: SUCCESS (0.002s)
[471.744502] [083/133] (577s left) gem_exec_schedule (submit-late-slice)
[471.817364] Starting subtest: submit-late-slice
[471.819628] Starting dynamic subtest: rcs0
[471.847711] Dynamic subtest rcs0: SUCCESS (0.037s)
[471.859245] Starting dynamic subtest: bcs0
[471.898084] Dynamic subtest bcs0: SUCCESS (0.048s)
[471.908253] Starting dynamic subtest: vcs0
[471.937508] Dynamic subtest vcs0: SUCCESS (0.039s)
[471.951405] Starting dynamic subtest: vcs1
[471.969593] Dynamic subtest vcs1: SUCCESS (0.031s)
[471.978765] Starting dynamic subtest: vecs0
[472.000644] Dynamic subtest vecs0: SUCCESS (0.030s)
[472.010033] Starting dynamic subtest: ccs0
[472.042749] Dynamic subtest ccs0: SUCCESS (0.041s)
[472.045372] Subtest submit-late-slice: SUCCESS (0.233s)
[473.593296] [084/133] (575s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[473.698196] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[473.700391] Starting dynamic subtest: pipe-A-default-mode
[476.433933] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[476.436220] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.736s)
[477.281413] [085/133] (571s left) gem_set_tiling_vs_pwrite
[477.407699] [086/133] (571s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[477.509205] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[477.513379] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[477.603495] [087/133] (571s left) gem_lmem_swapping (verify-random-ccs)
[477.646609] Subtest verify-random-ccs: SKIP (0.000s)
[477.693337] [088/133] (571s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[477.746280] Starting subtest: multi-wait-available-unsubmitted-signaled
[477.748542] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[477.844274] [089/133] (571s left) kms_addfb_basic (addfb25-bad-modifier)
[477.936393] Starting subtest: addfb25-bad-modifier
[477.938592] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[478.034358] [090/133] (571s left) gen9_exec_parse (shadow-peek)
[478.088383] Subtest shadow-peek: SKIP (0.000s)
[478.157981] [091/133] (571s left) kms_rotation_crc (primary-rotation-180)
[478.249386] Starting subtest: primary-rotation-180
[485.208972] Subtest primary-rotation-180: SUCCESS (6.958s)
[486.363875] [092/133] (562s left) gem_exec_balancer (waits)
[486.426788] Starting subtest: waits
[492.958865] Subtest waits: SUCCESS (6.528s)
[493.258381] [093/133] (556s left) gem_tiled_blits (basic)
[493.317061] Subtest basic: SKIP (0.000s)
[493.379185] [094/133] (555s left) gen7_exec_parse (basic-allocation)
[493.446683] Subtest basic-allocation: SKIP (0.000s)
[493.531327] [095/133] (555s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[493.926392] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[494.783342] [096/133] (554s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[494.891472] Starting subtest: 4-tiled-32bpp-rotate-0
[496.371418] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.479s)
[496.513219] [097/133] (552s left) kms_chamelium_audio (hdmi-audio-edid)
[496.892556] Subtest hdmi-audio-edid: SKIP (0.000s)
[497.716719] [098/133] (551s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[497.772175] Starting subtest: y-tiled-ccs-to-x-tiled
[497.776637] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[497.969633] [099/133] (551s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[498.069600] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[498.073564] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[498.165090] [100/133] (551s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[498.260747] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[504.427167] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.167s)
[505.636878] [101/133] (544s left) syncobj_timeline (wait-any-interrupted)
[505.692206] Starting subtest: wait-any-interrupted
[505.799746] Subtest wait-any-interrupted: SUCCESS (0.107s)
[505.892614] [102/133] (543s left) kms_flip (2x-plain-flip-ts-check)
[505.983982] Starting subtest: 2x-plain-flip-ts-check
[505.992650] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[506.101653] [103/133] (543s left) syncobj_wait (multi-wait-for-submit-signaled)
[506.154356] Starting subtest: multi-wait-for-submit-signaled
[506.156547] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[506.273716] [104/133] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[506.369216] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[506.373524] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[506.487927] [105/133] (543s left) gem_exec_fence (nb-await)
[506.679633] Starting subtest: nb-await
[506.681618] Starting dynamic subtest: rcs0
[506.744961] Dynamic subtest rcs0: SUCCESS (0.067s)
[506.756339] Starting dynamic subtest: bcs0
[506.802141] Dynamic subtest bcs0: SUCCESS (0.056s)
[506.813582] Starting dynamic subtest: vcs0
[506.861845] Dynamic subtest vcs0: SUCCESS (0.058s)
[506.873133] Starting dynamic subtest: vcs1
[506.922039] Dynamic subtest vcs1: SUCCESS (0.058s)
[506.933502] Starting dynamic subtest: vecs0
[506.981637] Dynamic subtest vecs0: SUCCESS (0.057s)
[506.992817] Starting dynamic subtest: ccs0
[507.041367] Dynamic subtest ccs0: SUCCESS (0.058s)
[507.044211] Subtest nb-await: SUCCESS (0.366s)
[508.613508] [106/133] (541s left) gem_exec_gttfill (engines)
[508.682694] Starting subtest: engines
[508.684925] Starting dynamic subtest: rcs0
[532.342249] Dynamic subtest rcs0: SUCCESS (23.666s)
[532.355224] Starting dynamic subtest: bcs0
[555.734916] Dynamic subtest bcs0: SUCCESS (23.388s)
[555.744449] Starting dynamic subtest: vcs0
[579.119755] Dynamic subtest vcs0: SUCCESS (23.377s)
[579.131444] Starting dynamic subtest: vcs1
[602.494599] Dynamic subtest vcs1: SUCCESS (23.367s)
[602.514906] Starting dynamic subtest: vecs0
[625.886935] Dynamic subtest vecs0: SUCCESS (23.383s)
[625.901599] Starting dynamic subtest: ccs0
[649.275154] Dynamic subtest ccs0: SUCCESS (23.386s)
[649.277970] Subtest engines: SUCCESS (140.580s)
[649.467589] [107/133] (400s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[649.631068] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[649.635592] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[649.724124] [108/133] (400s left) gem_partial_pwrite_pread (write-snoop)
[649.786925] Subtest write-snoop: SKIP (0.000s)
[649.854202] [109/133] (400s left) i915_pm_rps (thresholds)
[649.911524] Starting subtest: thresholds
[649.915675] Subtest thresholds: SKIP (0.001s)
[650.014840] [110/133] (400s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[650.116619] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[650.120553] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[650.214243] [111/133] (399s left) kms_dp_linktrain_fallback (dsc-fallback)
[650.304902] Starting subtest: dsc-fallback
[650.311088] Subtest dsc-fallback: SKIP (0.000s)
[650.378369] [112/133] (399s left) gem_ctx_persistence (engines-persistence)
[650.436415] Starting subtest: engines-persistence
[650.437942] Starting dynamic subtest: rcs0
[651.239321] Dynamic subtest rcs0: SUCCESS (0.804s)
[651.251346] Starting dynamic subtest: bcs0
[651.977482] Dynamic subtest bcs0: SUCCESS (0.736s)
[651.988554] Starting dynamic subtest: vcs0
[652.747466] Dynamic subtest vcs0: SUCCESS (0.768s)
[652.758482] Starting dynamic subtest: vcs1
[653.530787] Dynamic subtest vcs1: SUCCESS (0.781s)
[653.543165] Starting dynamic subtest: vecs0
[654.315197] Dynamic subtest vecs0: SUCCESS (0.783s)
[654.326880] Starting dynamic subtest: ccs0
[655.048396] Dynamic subtest ccs0: SUCCESS (0.731s)
[655.050841] Subtest engines-persistence: SUCCESS (4.615s)
[655.175882] [113/133] (394s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[655.287149] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[661.924262] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.641s)
[662.040386] [114/133] (388s left) drm_buddy (drm_buddy)
[662.090227] Starting subtest: drm_buddy
[662.094274] Subtest drm_buddy: SKIP (0.000s)
[662.154841] [115/133] (388s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[662.255565] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[662.259517] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[662.370369] [116/133] (387s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[662.472438] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[662.476734] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[663.604542] [117/133] (386s left) gem_create (create-invalid-size)
[663.651574] Starting subtest: create-invalid-size
[663.653765] Subtest create-invalid-size: SUCCESS (0.000s)
[663.845149] [118/133] (386s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[663.946991] Starting subtest: fbc-rgb565-draw-blt
[668.070033] Subtest fbc-rgb565-draw-blt: SUCCESS (4.127s)
[669.216113] [119/133] (381s left) kms_psr (fbc-pr-sprite-plane-move)
[669.316643] Starting subtest: fbc-pr-sprite-plane-move
[669.320733] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[669.400407] [120/133] (381s left) sysfs_timeslice_duration (idempotent)
[669.463933] Starting subtest: idempotent
[669.466331] Starting dynamic subtest: vecs0
[669.468695] Dynamic subtest vecs0: SUCCESS (0.000s)
[669.479836] Starting dynamic subtest: ccs0
[669.481996] Dynamic subtest ccs0: SUCCESS (0.000s)
[669.491137] Starting dynamic subtest: vcs0
[669.493289] Dynamic subtest vcs0: SUCCESS (0.000s)
[669.502385] Starting dynamic subtest: bcs0
[669.504555] Dynamic subtest bcs0: SUCCESS (0.000s)
[669.513343] Starting dynamic subtest: rcs0
[669.515499] Dynamic subtest rcs0: SUCCESS (0.000s)
[669.525235] Starting dynamic subtest: vcs1
[669.527102] Dynamic subtest vcs1: SUCCESS (0.000s)
[669.529004] Subtest idempotent: SUCCESS (0.006s)
[669.578853] [121/133] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[669.693239] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[669.697463] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[669.786139] [122/133] (380s left) i915_pm_rpm (debugfs-forcewake-user)
[671.649240] Starting subtest: debugfs-forcewake-user
[683.050800] Subtest debugfs-forcewake-user: SUCCESS (11.401s)
[683.439294] [123/133] (367s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[683.548893] Starting subtest: y-tiled-32bpp-rotate-90
[683.553399] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[683.660340] [124/133] (366s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[683.714003] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[683.792739] [125/133] (366s left) kms_legacy_colorkey (invalid-plane)
[683.878560] Starting subtest: invalid-plane
[683.880818] Starting dynamic subtest: zero-id
[683.883000] Dynamic subtest zero-id: SUCCESS (0.000s)
[683.898887] Starting dynamic subtest: outrange-id
[683.900837] Dynamic subtest outrange-id: SUCCESS (0.000s)
[683.903087] Subtest invalid-plane: SUCCESS (0.001s)
[683.951828] [126/133] (366s left) syncobj_basic (bad-handle-to-fd)
[684.001374] Starting subtest: bad-handle-to-fd
[684.003661] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[684.113624] [127/133] (366s left) core_auth (many-magics)
[684.162227] Starting subtest: many-magics
[685.225163] Subtest many-magics: SUCCESS (1.065s)
[685.367103] [128/133] (365s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[685.428950] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[685.535040] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[685.615835] [129/133] (365s left) kms_flip (2x-busy-flip)
[685.715166] Starting subtest: 2x-busy-flip
[685.729449] Subtest 2x-busy-flip: SKIP (0.012s)
[685.811472] [130/133] (365s left) kms_plane (plane-position-hole-dpms)
[685.903084] Starting subtest: plane-position-hole-dpms
[686.483087] Starting dynamic subtest: pipe-A-plane-1
[688.925479] Dynamic subtest pipe-A-plane-1: SUCCESS (2.441s)
[688.935243] Starting dynamic subtest: pipe-A-plane-2
[691.299409] Dynamic subtest pipe-A-plane-2: SUCCESS (2.376s)
[691.309819] Starting dynamic subtest: pipe-A-plane-3
[693.637988] Dynamic subtest pipe-A-plane-3: SUCCESS (2.338s)
[693.647404] Starting dynamic subtest: pipe-A-plane-4
[696.010857] Dynamic subtest pipe-A-plane-4: SUCCESS (2.369s)
[696.021251] Starting dynamic subtest: pipe-A-plane-5
[696.034820] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[697.184754] Starting dynamic subtest: pipe-B-plane-1
[699.608861] Dynamic subtest pipe-B-plane-1: SUCCESS (2.433s)
[699.619464] Starting dynamic subtest: pipe-B-plane-2
[701.958848] Dynamic subtest pipe-B-plane-2: SUCCESS (2.348s)
[701.969916] Starting dynamic subtest: pipe-B-plane-3
[704.311563] Dynamic subtest pipe-B-plane-3: SUCCESS (2.352s)
[704.322902] Starting dynamic subtest: pipe-B-plane-4
[706.692064] Dynamic subtest pipe-B-plane-4: SUCCESS (2.378s)
[706.702082] Starting dynamic subtest: pipe-B-plane-5
[706.716462] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[706.718697] Subtest plane-position-hole-dpms: SUCCESS (20.811s)
[707.496161] [131/133] (343s left) kms_psr (pr-primary-page-flip)
[707.594311] Starting subtest: pr-primary-page-flip
[707.598842] Subtest pr-primary-page-flip: SKIP (0.000s)
[707.671150] [132/133] (343s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[707.770825] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[707.774872] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[707.873177] [133/133] (343s left) gem_eio (wait-immediate)
[708.080454] Starting subtest: wait-immediate
[708.413497] Subtest wait-immediate: SUCCESS (0.333s)
[708.569037] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_hdr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_invalid_mode
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_atomic_transition
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: gem_softpin
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_chamelium_frames
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: kms_feature_discovery
results: parsing output: 22/ for test: gem_mmap_offset
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_color
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_store
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: gem_fenced_exec_thrash
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: gem_sync
results: parsing output: 34/ for test: kms_pipe_crc_basic
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: gem_exec_suspend
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_plane_multiple
results: parsing output: 46/ for test: gem_ccs
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_vrr
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exercise_blt
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: gem_tiling_max_stride
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gem_ctx_param
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_sequence
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: gem_eio
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gen7_exec_parse
results: parsing output: 70/ for test: kms_prop_blob
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_psr2_su
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_pm_backlight
results: parsing output: 77/ for test: i915_drm_fdinfo
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: gem_pxp
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: gem_ctx_engines
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: kms_rotation_crc
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: gem_tiled_blits
results: parsing output: 93/ for test: gen7_exec_parse
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_chamelium_audio
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_exec_gttfill
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_partial_pwrite_pread
results: parsing output: 108/ for test: i915_pm_rps
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_dp_linktrain_fallback
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: drm_buddy
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_create
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: sysfs_timeslice_duration
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_legacy_colorkey
results: parsing output: 125/ for test: syncobj_basic
results: parsing output: 126/ for test: core_auth
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_eio
Done.