[103.991349] Initializing watchdogs
[103.991492]   /dev/watchdog0
[104.008105] [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]
[104.012698] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[104.015252] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[104.018950] [001/156] (960s left) kms_psr (psr-cursor-render)
[104.142965] Starting subtest: psr-cursor-render
[104.145439] Starting dynamic subtest: eDP-1
[105.940105] Dynamic subtest eDP-1: SUCCESS (1.797s)
[105.942542] Subtest psr-cursor-render: SUCCESS (1.797s)
[106.835883] [002/156] (957s left) syncobj_timeline (wait-zero-handles)
[106.895157] Starting subtest: wait-zero-handles
[106.897483] Subtest wait-zero-handles: SUCCESS (0.000s)
[106.982618] [003/156] (957s left) gem_exec_capture (capture)
[107.043861] Starting subtest: capture
[107.046271] Starting dynamic subtest: rcs0-smem
[107.843345] Dynamic subtest rcs0-smem: SUCCESS (0.799s)
[107.853258] Starting dynamic subtest: bcs0-smem
[109.149278] Dynamic subtest bcs0-smem: SUCCESS (1.304s)
[109.157198] Starting dynamic subtest: vcs0-smem
[109.952322] Dynamic subtest vcs0-smem: SUCCESS (0.800s)
[109.959032] Starting dynamic subtest: vcs1-smem
[111.272958] Dynamic subtest vcs1-smem: SUCCESS (1.321s)
[111.280965] Starting dynamic subtest: vecs0-smem
[112.170109] Dynamic subtest vecs0-smem: FAIL (0.839s)
[112.178996] Starting dynamic subtest: ccs0-smem
[113.430105] Dynamic subtest ccs0-smem: SUCCESS (1.315s)
[113.432652] Subtest capture: FAIL (6.380s)
[113.552553] [004/156] (951s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[113.658452] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[113.662745] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[113.748997] [005/156] (950s left) gem_partial_pwrite_pread (write-uncached)
[113.802884] Subtest write-uncached: SKIP (0.000s)
[113.863099] [006/156] (950s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[113.973240] Starting subtest: 4-tiled-64bpp-rotate-180
[115.608408] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.635s)
[115.763109] [007/156] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[115.859149] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[123.714896] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.856s)
[123.822740] [008/156] (940s left) kms_cursor_crc (cursor-offscreen-128x42)
[124.055353] Starting subtest: cursor-offscreen-128x42
[124.104253] Subtest cursor-offscreen-128x42: SKIP (0.046s)
[124.308522] [009/156] (940s left) syncobj_timeline (single-wait-all-signaled)
[124.367152] Starting subtest: single-wait-all-signaled
[124.369387] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[124.462365] [010/156] (940s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[124.551200] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[124.553476] Starting dynamic subtest: pipe-A-eDP-1
[124.617470] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[124.627153] Starting dynamic subtest: pipe-B-eDP-1
[124.675689] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[124.684492] Starting dynamic subtest: pipe-C-eDP-1
[124.733266] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[124.741932] Starting dynamic subtest: pipe-D-eDP-1
[124.790692] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[124.794536] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.007s)
[126.898069] [011/156] (938s left) perf_pmu (rc6)
[126.941180] Starting subtest: rc6
[126.943219] Starting dynamic subtest: gt0
[133.368940] Dynamic subtest gt0: SUCCESS (6.374s)
[133.377532] Starting dynamic subtest: runtime-pm-gt0
[141.052431] Dynamic subtest runtime-pm-gt0: SUCCESS (7.733s)
[141.063090] Starting dynamic subtest: runtime-pm-long-gt0
[153.541769] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.486s)
[153.553291] Starting dynamic subtest: other-idle-gt0
[159.936734] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[159.948774] Starting dynamic subtest: gt1
[166.225032] Dynamic subtest gt1: SUCCESS (6.339s)
[166.235232] Starting dynamic subtest: runtime-pm-gt1
[173.730524] Dynamic subtest runtime-pm-gt1: SUCCESS (7.503s)
[173.741755] Starting dynamic subtest: runtime-pm-long-gt1
[186.207778] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.478s)
[186.216905] Starting dynamic subtest: other-idle-gt1
[192.605572] Dynamic subtest other-idle-gt1: SUCCESS (6.345s)
[192.608099] Subtest rc6: SUCCESS (65.607s)
[193.723187] [012/156] (871s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[193.825607] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[193.829712] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[193.907173] [013/156] (871s left) gem_softpin (full)
[193.970026] Starting subtest: full
[193.976937] Subtest full: SUCCESS (0.007s)
[194.075168] [014/156] (870s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[194.167867] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[194.171650] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[194.232807] [015/156] (870s left) kms_psr (fbc-psr-cursor-plane-onoff)
[194.320408] Starting subtest: fbc-psr-cursor-plane-onoff
[194.322203] Starting dynamic subtest: eDP-1
[194.325827] Dynamic subtest eDP-1: SKIP (0.000s)
[194.329809] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[194.362276] [016/156] (870s left) kms_vblank (query-forked-hang)
[194.446312] Starting subtest: query-forked-hang
[194.448214] Starting dynamic subtest: pipe-A-eDP-1
[221.065242] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.618s)
[221.078064] Starting dynamic subtest: pipe-D-eDP-1
[246.080481] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.012s)
[246.082777] Subtest query-forked-hang: SUCCESS (51.634s)
[246.886824] [017/156] (818s left) kms_dsc (dsc-with-bpc)
[246.978315] Starting subtest: dsc-with-bpc
[247.010599] Subtest dsc-with-bpc: SKIP (0.001s)
[247.072445] [018/156] (818s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[247.171257] Starting subtest: psr-rgb101010-draw-pwrite
[254.911810] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.746s)
[255.014297] [019/156] (810s left) gem_tiled_swapping (non-threaded)
[255.069669] Subtest non-threaded: SKIP (0.000s)
[255.136937] [020/156] (810s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[255.241588] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[255.246069] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[255.308996] [021/156] (810s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[255.407338] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[255.411773] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[255.477384] [022/156] (809s left) api_intel_allocator (execbuf-with-allocator)
[255.531196] Starting subtest: execbuf-with-allocator
[255.537808] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[255.631445] [023/156] (809s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[255.733381] Starting subtest: fbcpsr-indfb-scaledprimary
[261.517896] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.790s)
[261.615780] [024/156] (803s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[261.717680] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[261.730087] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[261.776106] [025/156] (803s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[261.878944] Starting subtest: fbc-psr2-primary-mmap-cpu
[261.881522] Starting dynamic subtest: eDP-1
[261.885823] Dynamic subtest eDP-1: SKIP (0.000s)
[261.890090] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[261.929306] [026/156] (803s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[262.018450] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[262.020829] Starting dynamic subtest: pipe-A
[263.068194] Dynamic subtest pipe-A: SUCCESS (1.050s)
[263.076954] Starting dynamic subtest: pipe-B
[265.189559] Dynamic subtest pipe-B: SUCCESS (2.122s)
[265.203403] Starting dynamic subtest: pipe-C
[266.393143] Dynamic subtest pipe-C: SUCCESS (1.202s)
[266.403345] Starting dynamic subtest: pipe-D
[267.627078] Dynamic subtest pipe-D: SUCCESS (1.233s)
[267.629382] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.612s)
[268.794733] [027/156] (796s left) gem_readwrite (beyond-eob)
[268.853843] Subtest beyond-EOB: SKIP (0.000s)
[268.918641] [028/156] (796s left) gen9_exec_parse (basic-rejected-ctx-param)
[268.972514] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[269.051486] [029/156] (796s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[269.150090] Starting subtest: psr2-cursor-plane-update-sf
[269.152402] Starting dynamic subtest: pipe-A-eDP-1
[269.718938] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[269.728217] Starting dynamic subtest: pipe-B-eDP-1
[270.996223] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.275s)
[270.998730] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.848s)
[271.859326] [030/156] (793s left) kms_flip (flip-vs-expired-vblank-interruptible)
[271.955080] Starting subtest: flip-vs-expired-vblank-interruptible
[271.957376] Starting dynamic subtest: A-eDP1
[280.616771] Dynamic subtest A-eDP1: SUCCESS (8.627s)
[280.628350] Starting dynamic subtest: B-eDP1
[289.243852] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[289.255233] Starting dynamic subtest: C-eDP1
[297.879997] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[297.892072] Starting dynamic subtest: D-eDP1
[306.514821] Dynamic subtest D-eDP1: SUCCESS (8.643s)
[306.517334] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.515s)
[307.620767] [031/156] (758s left) kms_flip (flip-vs-suspend-interruptible)
[307.714420] Starting subtest: flip-vs-suspend-interruptible
[307.716810] Starting dynamic subtest: A-eDP1
[453.078284] Dynamic subtest A-eDP1: SUCCESS (12.051s)
[453.080709] Subtest flip-vs-suspend-interruptible: SUCCESS (12.053s)
[453.176823] [032/156] (612s left) gem_wait (wait)
[453.246011] Starting subtest: wait
[453.248677] Starting dynamic subtest: all-engines
[454.592648] Dynamic subtest all-engines: SUCCESS (1.302s)
[454.605016] Starting dynamic subtest: rcs0
[455.648073] Dynamic subtest rcs0: SUCCESS (1.016s)
[455.659859] Starting dynamic subtest: bcs0
[456.695857] Dynamic subtest bcs0: SUCCESS (1.018s)
[456.708850] Starting dynamic subtest: vcs0
[457.745833] Dynamic subtest vcs0: SUCCESS (1.021s)
[457.758514] Starting dynamic subtest: vcs1
[458.795491] Dynamic subtest vcs1: SUCCESS (1.024s)
[458.808915] Starting dynamic subtest: vecs0
[459.843488] Dynamic subtest vecs0: SUCCESS (1.025s)
[459.857252] Starting dynamic subtest: ccs0
[460.893996] Dynamic subtest ccs0: SUCCESS (1.030s)
[460.896993] Subtest wait: SUCCESS (7.449s)
[461.069526] [033/156] (604s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[461.161672] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[461.167731] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[461.212457] [034/156] (604s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[461.328375] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[468.460821] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.066s)
[468.575933] [035/156] (597s left) gem_exec_balancer (full-late-pulse)
[468.642590] Starting subtest: full-late-pulse
[473.542439] Subtest full-late-pulse: SUCCESS (4.876s)
[473.845797] [036/156] (592s left) kms_big_fb (linear-16bpp-rotate-180)
[473.940578] Starting subtest: linear-16bpp-rotate-180
[475.334871] Subtest linear-16bpp-rotate-180: SUCCESS (1.390s)
[475.435987] [037/156] (590s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[475.816494] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[476.692150] [038/156] (589s left) gem_exec_params (no-blt)
[476.755366] Starting subtest: no-blt
[476.757897] Subtest no-blt: SUCCESS (0.002s)
[476.843370] [039/156] (589s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[476.942420] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[476.947585] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[477.010609] [040/156] (589s left) kms_pm_rpm (cursor-dpms)
[478.739486] Starting subtest: cursor-dpms
[478.744426] Subtest cursor-dpms: SKIP (0.000s)
[479.227880] [041/156] (586s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[479.605664] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[480.454323] [042/156] (585s left) kms_properties (colorop-properties-atomic)
[480.544702] Starting subtest: colorop-properties-atomic
[480.547469] Starting dynamic subtest: pipe-A-eDP-1
[480.906933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s)
[480.916845] Starting dynamic subtest: pipe-B-eDP-1
[481.956893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.049s)
[481.969835] Starting dynamic subtest: pipe-C-eDP-1
[483.089363] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[483.100609] Starting dynamic subtest: pipe-D-eDP-1
[484.130074] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[484.132475] Subtest colorop-properties-atomic: SUCCESS (3.581s)
[484.927182] [043/156] (581s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[485.045760] Starting subtest: short-flip-before-cursor-toggle
[485.975531] Subtest short-flip-before-cursor-toggle: SUCCESS (0.929s)
[486.755081] [044/156] (579s left) kms_cursor_legacy (forked-move)
[486.882624] Starting subtest: forked-move
[486.885589] Starting dynamic subtest: pipe-A
[492.415024] Dynamic subtest pipe-A: SUCCESS (5.476s)
[492.427512] Starting dynamic subtest: pipe-B
[497.901134] Dynamic subtest pipe-B: SUCCESS (5.482s)
[497.916309] Starting dynamic subtest: pipe-C
[503.392570] Dynamic subtest pipe-C: SUCCESS (5.488s)
[503.402933] Starting dynamic subtest: pipe-D
[508.878485] Dynamic subtest pipe-D: SUCCESS (5.479s)
[508.896381] Starting dynamic subtest: all-pipes
[514.330862] Dynamic subtest all-pipes: SUCCESS (5.499s)
[514.333876] Subtest forked-move: SUCCESS (27.434s)
[514.450145] [045/156] (551s left) gem_exec_parallel (engines)
[514.534381] Starting subtest: engines
[514.537185] Starting dynamic subtest: basic
[516.609036] Dynamic subtest basic: SUCCESS (2.072s)
[516.622582] Starting dynamic subtest: contexts
[521.007266] Dynamic subtest contexts: SUCCESS (4.392s)
[521.017473] Starting dynamic subtest: fds
[524.898326] Dynamic subtest fds: SUCCESS (3.886s)
[524.911289] Starting dynamic subtest: userptr
[528.577298] Dynamic subtest userptr: SUCCESS (3.677s)
[528.580250] Subtest engines: SUCCESS (14.036s)
[528.747245] [046/156] (537s left) gem_exec_schedule (preempt-self)
[528.821011] Starting subtest: preempt-self
[528.823510] Starting dynamic subtest: rcs0
[528.853641] Dynamic subtest rcs0: SUCCESS (0.040s)
[528.865128] Starting dynamic subtest: bcs0
[528.885268] Dynamic subtest bcs0: SUCCESS (0.031s)
[528.895279] Starting dynamic subtest: vcs0
[528.917015] Dynamic subtest vcs0: SUCCESS (0.030s)
[528.927242] Starting dynamic subtest: vcs1
[528.944231] Dynamic subtest vcs1: SUCCESS (0.027s)
[528.954150] Starting dynamic subtest: vecs0
[528.986535] Dynamic subtest vecs0: SUCCESS (0.042s)
[528.996609] Starting dynamic subtest: ccs0
[529.015410] Dynamic subtest ccs0: SUCCESS (0.028s)
[529.017849] Subtest preempt-self: SUCCESS (0.202s)
[530.689403] [047/156] (535s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[530.793122] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[530.797668] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[530.874052] [048/156] (535s left) gem_eio (wait-wedge-immediate)
[531.107252] Starting subtest: wait-wedge-immediate
[532.681835] Subtest wait-wedge-immediate: SUCCESS (1.575s)
[532.787030] [049/156] (533s left) gem_ctx_persistence (file)
[532.842864] Starting subtest: file
[532.960230] Subtest file: SUCCESS (0.117s)
[533.049099] [050/156] (533s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[533.143605] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[533.148736] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[533.221122] [051/156] (533s left) syncobj_timeline (etime-multi-wait-submitted)
[533.279584] Starting subtest: etime-multi-wait-submitted
[533.388885] Subtest etime-multi-wait-submitted: SUCCESS (0.109s)
[533.442347] [052/156] (533s left) kms_async_flips (crc-atomic)
[533.534864] Starting subtest: crc-atomic
[533.909573] Starting dynamic subtest: pipe-A-eDP-1
[536.826531] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.886s)
[537.185500] Starting dynamic subtest: pipe-B-eDP-1
[540.163781] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.968s)
[540.524432] Starting dynamic subtest: pipe-C-eDP-1
[543.486749] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.939s)
[543.831765] Starting dynamic subtest: pipe-D-eDP-1
[546.724560] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.862s)
[546.727073] Subtest crc-atomic: SUCCESS (13.145s)
[547.842311] [053/156] (518s left) gem_lmem_swapping (heavy-verify-random-ccs)
[547.881870] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[547.924007] [054/156] (518s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[548.021590] Starting subtest: pipe-fbc-rte
[548.029688] Starting dynamic subtest: pipe-B-eDP-1
[553.501252] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.489s)
[553.509109] Subtest pipe-fbc-rte: SUCCESS (5.492s)
[555.767973] [055/156] (510s left) gem_exec_whisper (basic-contexts-priority-all)
[555.829793] Starting subtest: basic-contexts-priority-all
[580.198306] Subtest basic-contexts-priority-all: SUCCESS (24.318s)
[580.307717] [056/156] (486s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[580.404091] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[580.408855] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[581.488523] [057/156] (485s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[581.582632] Starting subtest: fbc-1p-pri-indfb-multidraw
[594.541100] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.964s)
[595.951049] [058/156] (470s left) kms_atomic (crtc-invalid-params-fence)
[596.043227] Starting subtest: crtc-invalid-params-fence
[596.045704] Starting dynamic subtest: pipe-A-eDP-1
[596.462442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[596.465154] Subtest crtc-invalid-params-fence: SUCCESS (0.420s)
[597.254448] [059/156] (469s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[597.354154] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[601.072796] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.724s)
[602.261201] [060/156] (464s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[602.368723] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[602.374222] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[602.437426] [061/156] (464s left) gem_lmem_swapping (verify-random)
[602.476634] Subtest verify-random: SKIP (0.000s)
[602.525337] [062/156] (464s left) kms_cursor_crc (cursor-random-32x10)
[602.684305] Starting subtest: cursor-random-32x10
[602.732870] Subtest cursor-random-32x10: SKIP (0.042s)
[602.978748] [063/156] (464s left) kms_lease (lease-get)
[603.065333] Starting subtest: lease-get
[603.067680] Starting dynamic subtest: pipe-A-eDP-1
[603.070180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[603.081010] Starting dynamic subtest: pipe-B-eDP-1
[603.083511] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[603.094420] Starting dynamic subtest: pipe-C-eDP-1
[603.096776] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[603.107497] Starting dynamic subtest: pipe-D-eDP-1
[603.109867] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[603.112662] Subtest lease-get: SUCCESS (0.009s)
[603.157107] [064/156] (463s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-rte)
[603.264745] Starting subtest: fbcpsrhdr-1p-rte
[603.269141] Subtest fbcpsrhdr-1p-rte: SKIP (0.000s)
[603.344488] [065/156] (463s left) gem_exec_fence (syncobj-import)
[603.844837] Starting subtest: syncobj-import
[603.847742] Subtest syncobj-import: SUCCESS (0.007s)
[605.686732] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[605.691040] [066/156] (461s left) kms_properties (crtc-properties-atomic)
[605.785161] Starting subtest: crtc-properties-atomic
[605.787453] Starting dynamic subtest: pipe-A-eDP-1
[606.225520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[606.237670] Starting dynamic subtest: pipe-B-eDP-1
[607.446643] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.220s)
[607.458391] Starting dynamic subtest: pipe-C-eDP-1
[608.570714] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[608.583658] Starting dynamic subtest: pipe-D-eDP-1
[609.693855] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s)
[609.696843] Subtest crtc-properties-atomic: SUCCESS (3.906s)
[610.493755] [067/156] (456s left) api_intel_bb (object-noreloc-keep-cache-simple)
[610.549245] Starting subtest: object-noreloc-keep-cache-simple
[610.555322] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[610.646511] [068/156] (456s left) drm_read (short-buffer-wakeup)
[610.791076] Starting subtest: short-buffer-wakeup
[643.012786] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[643.125944] [069/156] (424s left) kms_frontbuffer_tracking (psrhdr-suspend)
[643.237669] Starting subtest: psrhdr-suspend
[643.242794] Subtest psrhdr-suspend: SKIP (0.000s)
[643.319330] [070/156] (423s left) kms_vrr (seamless-rr-switch-vrr)
[643.407619] Starting subtest: seamless-rr-switch-vrr
[643.415996] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[643.458072] [071/156] (423s left) sriov_basic (enable-vfs-autoprobe-on)
[643.510764] Starting subtest: enable-vfs-autoprobe-on
[643.513577] Starting dynamic subtest: numvfs-1
[643.518706] Dynamic subtest numvfs-1: SKIP (0.001s)
[643.530746] Starting dynamic subtest: numvfs-2
[643.535859] Dynamic subtest numvfs-2: SKIP (0.001s)
[643.546439] Starting dynamic subtest: numvfs-3
[643.551578] Dynamic subtest numvfs-3: SKIP (0.001s)
[643.562499] Starting dynamic subtest: numvfs-4
[643.567517] Dynamic subtest numvfs-4: SKIP (0.001s)
[643.577888] Starting dynamic subtest: numvfs-5
[643.583684] Dynamic subtest numvfs-5: SKIP (0.001s)
[643.594646] Starting dynamic subtest: numvfs-6
[643.599415] Dynamic subtest numvfs-6: SKIP (0.000s)
[643.609843] Starting dynamic subtest: numvfs-7
[643.615559] Dynamic subtest numvfs-7: SKIP (0.001s)
[643.625968] Starting dynamic subtest: numvfs-random
[643.631639] Dynamic subtest numvfs-random: SKIP (0.001s)
[643.641780] Starting dynamic subtest: numvfs-all
[643.647641] Dynamic subtest numvfs-all: SKIP (0.001s)
[643.652834] Subtest enable-vfs-autoprobe-on: SKIP (0.011s)
[643.692245] [072/156] (423s left) kms_psr (psr2-cursor-mmap-gtt)
[643.785440] Starting subtest: psr2-cursor-mmap-gtt
[643.787876] Starting dynamic subtest: eDP-1
[645.504775] Dynamic subtest eDP-1: SUCCESS (1.719s)
[645.507640] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.720s)
[646.373169] [073/156] (421s left) gem_workarounds (basic-read-fd)
[646.435864] Starting subtest: basic-read-fd
[646.447379] Subtest basic-read-fd: SUCCESS (0.014s)
[646.542574] [074/156] (420s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[646.635445] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[647.348413] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.714s)
[647.506756] [075/156] (420s left) gem_exec_reloc (basic-cpu-wc-active)
[647.563672] Subtest basic-cpu-wc-active: SKIP (0.000s)
[647.637505] [076/156] (419s left) kms_cursor_edge_walk (256x256-right-edge)
[647.730580] Starting subtest: 256x256-right-edge
[647.733291] Starting dynamic subtest: pipe-A-eDP-1
[651.157396] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.424s)
[651.169581] Starting dynamic subtest: pipe-D-eDP-1
[654.380573] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.221s)
[654.383471] Subtest 256x256-right-edge: SUCCESS (6.648s)
[655.186077] [077/156] (412s left) gem_mmap_wc (bad-offset)
[655.253443] Subtest bad-offset: SKIP (0.000s)
[655.320934] [078/156] (412s left) kms_psr (psr-primary-render)
[655.413107] Starting subtest: psr-primary-render
[655.415460] Starting dynamic subtest: eDP-1
[657.199633] Dynamic subtest eDP-1: SUCCESS (1.787s)
[657.202586] Subtest psr-primary-render: SUCCESS (1.788s)
[658.045793] [079/156] (409s left) prime_vgem (basic-fence-read)
[658.115482] Starting subtest: basic-fence-read
[658.139573] Subtest basic-fence-read: SKIP (0.025s)
[658.211241] [080/156] (409s left) gem_exec_schedule (out-order)
[658.278586] Starting subtest: out-order
[658.281346] Starting dynamic subtest: rcs0
[658.372615] Dynamic subtest rcs0: SUCCESS (0.103s)
[658.386613] Starting dynamic subtest: vcs0
[658.472110] Dynamic subtest vcs0: SUCCESS (0.099s)
[658.485539] Starting dynamic subtest: vcs1
[658.554110] Dynamic subtest vcs1: SUCCESS (0.081s)
[658.572456] Starting dynamic subtest: vecs0
[658.641095] Dynamic subtest vecs0: SUCCESS (0.086s)
[658.657584] Starting dynamic subtest: ccs0
[658.749178] Dynamic subtest ccs0: SUCCESS (0.107s)
[658.752701] Subtest out-order: SUCCESS (0.481s)
[659.649846] [081/156] (408s left) syncobj_timeline (device-signal-unordered)
[659.699767] Starting subtest: device-signal-unordered
[659.702637] Subtest device-signal-unordered: SUCCESS (0.001s)
[659.783274] [082/156] (408s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[659.889773] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[664.153986] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.269s)
[665.342766] [083/156] (402s left) sw_sync (alloc_merge_fence)
[665.375920] Starting subtest: alloc_merge_fence
[665.378690] Subtest alloc_merge_fence: SUCCESS (0.000s)
[665.419081] [084/156] (402s left) gem_ctx_create (basic-files)
[665.481862] Starting subtest: basic-files
[667.493739] Subtest basic-files: SUCCESS (2.011s)
[668.696419] [085/156] (399s left) kms_color (deep-color)
[668.789603] Starting subtest: deep-color
[669.851730] Starting dynamic subtest: pipe-A-eDP-1-gamma
[670.579143] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.729s)
[670.591308] Starting dynamic subtest: pipe-A-eDP-1-degamma
[672.059870] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.477s)
[672.071197] Starting dynamic subtest: pipe-A-eDP-1-ctm
[673.481892] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.423s)
[674.252702] Starting dynamic subtest: pipe-B-eDP-1-gamma
[674.960650] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.717s)
[674.971659] Starting dynamic subtest: pipe-B-eDP-1-degamma
[676.446791] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.479s)
[676.459526] Starting dynamic subtest: pipe-B-eDP-1-ctm
[677.871287] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.426s)
[678.639897] Starting dynamic subtest: pipe-C-eDP-1-gamma
[679.323860] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s)
[679.336841] Starting dynamic subtest: pipe-C-eDP-1-degamma
[680.790634] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.467s)
[680.802548] Starting dynamic subtest: pipe-C-eDP-1-ctm
[682.237684] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.447s)
[683.025592] Starting dynamic subtest: pipe-D-eDP-1-gamma
[683.731078] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.717s)
[683.743062] Starting dynamic subtest: pipe-D-eDP-1-degamma
[685.180441] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.452s)
[685.191577] Starting dynamic subtest: pipe-D-eDP-1-ctm
[686.628121] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.447s)
[686.630682] Subtest deep-color: SUCCESS (17.841s)
[687.449996] [086/156] (380s left) gem_exec_reloc (basic-wc-cpu)
[687.506585] Subtest basic-wc-cpu: SKIP (0.000s)
[687.588464] [087/156] (380s left) gem_exec_reloc (basic-cpu-gtt)
[687.640103] Subtest basic-cpu-gtt: SKIP (0.000s)
[687.708777] [088/156] (380s left) syncobj_timeline (multi-wait-available-signaled)
[687.751320] Starting subtest: multi-wait-available-signaled
[687.753674] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[687.823346] [089/156] (380s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[687.915673] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[687.920904] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[687.967080] [090/156] (380s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[688.020782] Starting subtest: y-tiled-to-vebox-yf-tiled
[688.026756] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[688.182045] [091/156] (380s left) kms_joiner (invalid-modeset-force-big-joiner)
[688.275620] Starting subtest: invalid-modeset-force-big-joiner
[688.280853] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[688.322675] [092/156] (379s left) i915_suspend (sysfs-reader)
[688.373885] Starting subtest: sysfs-reader
[706.044263] Subtest sysfs-reader: SUCCESS (3.110s)
[706.129651] [093/156] (362s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[706.227597] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[706.232632] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[706.300014] [094/156] (362s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[706.396583] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[706.398613] Starting dynamic subtest: pipe-A-eDP-1
[706.420413] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[706.432675] Starting dynamic subtest: pipe-B-eDP-1
[706.455674] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[706.467306] Starting dynamic subtest: pipe-C-eDP-1
[706.490758] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[706.502485] Starting dynamic subtest: pipe-D-eDP-1
[706.526267] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[706.530640] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[708.703573] [095/156] (359s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[708.807805] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[708.812820] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[708.866758] [096/156] (359s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[708.958308] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[708.960725] Starting dynamic subtest: pipe-A-default-mode
[710.119317] Dynamic subtest pipe-A-default-mode: SKIP (1.131s)
[710.124345] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.132s)
[710.241003] [097/156] (358s left) syncobj_wait (invalid-reset-bad-pad)
[710.296890] Starting subtest: invalid-reset-bad-pad
[710.299727] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[710.383693] [098/156] (358s left) kms_chamelium_color (ctm-0-50)
[710.478983] Subtest ctm-0-50: SKIP (0.000s)
[710.529903] [099/156] (358s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[710.632337] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[710.637089] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[710.708182] [100/156] (357s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[710.800549] Starting subtest: primary-yf-tiled-reflect-x-270
[710.805833] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[710.850930] [101/156] (357s left) gem_ctx_shared (exec-shared-gtt)
[710.911760] Starting subtest: exec-shared-gtt
[710.914200] Starting dynamic subtest: rcs0
[710.919815] Dynamic subtest rcs0: SUCCESS (0.007s)
[710.932678] Starting dynamic subtest: bcs0
[710.935607] Dynamic subtest bcs0: SUCCESS (0.006s)
[710.946542] Starting dynamic subtest: vcs0
[710.949497] Dynamic subtest vcs0: SUCCESS (0.007s)
[710.961218] Starting dynamic subtest: vcs1
[710.963449] Dynamic subtest vcs1: SUCCESS (0.007s)
[710.974382] Starting dynamic subtest: vecs0
[710.976607] Dynamic subtest vecs0: SUCCESS (0.006s)
[710.987304] Starting dynamic subtest: ccs0
[710.989824] Dynamic subtest ccs0: SUCCESS (0.007s)
[710.992412] Subtest exec-shared-gtt: SUCCESS (0.044s)
[711.129642] [102/156] (357s left) gem_mmap_gtt (basic-small-copy-xy)
[711.181532] Subtest basic-small-copy-XY: SKIP (0.000s)
[711.245531] [103/156] (357s left) gem_mmap (big-bo)
[711.299836] Subtest big-bo: SKIP (0.000s)
[711.365529] [104/156] (357s left) gem_basic (create-fd-close)
[711.409321] Starting subtest: create-fd-close
[711.413710] Subtest create-fd-close: SUCCESS (0.000s)
[711.486266] [105/156] (357s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[711.577152] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[711.582083] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[711.662219] [106/156] (357s left) gem_render_copy (y-tiled-ccs-to-linear)
[711.715507] Starting subtest: y-tiled-ccs-to-linear
[711.720509] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[711.883349] [107/156] (357s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[711.970700] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[711.973995] Starting dynamic subtest: pipe-A-eDP-1
[711.998734] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[712.011364] Starting dynamic subtest: pipe-B-eDP-1
[712.038157] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[712.048688] Starting dynamic subtest: pipe-C-eDP-1
[712.075664] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[712.086214] Starting dynamic subtest: pipe-D-eDP-1
[712.112702] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[712.118000] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[714.309127] [108/156] (354s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[714.365351] Starting subtest: multi-wait-available-unsubmitted-submitted
[714.367828] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[714.431319] [109/156] (354s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[714.530664] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[714.535522] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[714.609681] [110/156] (354s left) gem_eio (throttle)
[714.836755] Starting subtest: throttle
[715.167290] Subtest throttle: SUCCESS (0.327s)
[715.292289] [111/156] (353s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[715.382877] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[722.390827] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.954s)
[722.493355] [112/156] (346s left) kms_vrr (lobf)
[722.592457] Starting subtest: lobf
[722.597723] Subtest lobf: SKIP (0.000s)
[722.647966] [113/156] (346s left) fbdev (read)
[722.685035] Starting subtest: read
[723.305178] Subtest read: SUCCESS (0.616s)
[723.349528] [114/156] (345s left) i915_fb_tiling (basic-x-tiling)
[723.405517] Subtest basic-x-tiling: SKIP (0.000s)
[723.472992] [115/156] (345s left) gem_pxp (reject-modify-context-protection-off-2)
[723.593155] Starting subtest: reject-modify-context-protection-off-2
[723.596192] Subtest reject-modify-context-protection-off-2: SUCCESS (0.001s)
[723.678671] [116/156] (345s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[723.782679] Starting subtest: y-tiled-64bpp-rotate-270
[723.787683] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[723.867248] [117/156] (345s left) gem_userptr_blits (sync-overlap)
[723.935073] Starting subtest: sync-overlap
[723.937862] Subtest sync-overlap: SUCCESS (0.000s)
[724.034613] [118/156] (345s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[724.132605] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[724.137987] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[724.217210] [119/156] (345s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-render)
[724.327644] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-render
[724.332191] Subtest hdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[724.389749] [120/156] (345s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[724.492772] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[724.497217] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[724.552650] [121/156] (345s left) kms_pm_rpm (modeset-pc8-residency-stress)
[726.283067] Starting subtest: modeset-pc8-residency-stress
[726.288596] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[726.854075] [122/156] (342s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[726.944717] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[726.949515] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[727.022193] [123/156] (342s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[727.163628] Starting subtest: dp-mst-lic-type-0-hdcp14
[727.169599] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[727.269883] [124/156] (342s left) gem_tiled_blits (interruptible)
[727.329616] Subtest interruptible: SKIP (0.000s)
[727.398607] [125/156] (342s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[727.501663] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[734.666600] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.157s)
[734.786292] [126/156] (335s left) perf_pmu (most-busy-check-all)
[734.827078] Starting subtest: most-busy-check-all
[734.829716] Starting dynamic subtest: rcs0
[736.141823] Dynamic subtest rcs0: SUCCESS (1.313s)
[736.155698] Starting dynamic subtest: bcs0
[738.126684] Dynamic subtest bcs0: SUCCESS (1.980s)
[738.140877] Starting dynamic subtest: vcs0
[740.173630] Dynamic subtest vcs0: SUCCESS (2.042s)
[740.187560] Starting dynamic subtest: vcs1
[742.158842] Dynamic subtest vcs1: SUCCESS (1.982s)
[742.173184] Starting dynamic subtest: vecs0
[744.141516] Dynamic subtest vecs0: SUCCESS (1.979s)
[744.156675] Starting dynamic subtest: ccs0
[746.126990] Dynamic subtest ccs0: SUCCESS (1.982s)
[746.129846] Subtest most-busy-check-all: SUCCESS (11.296s)
[746.220360] [127/156] (323s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[746.329441] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[746.334519] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[746.403359] [128/156] (323s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[746.497686] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[746.502724] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[746.560593] [129/156] (323s left) gem_ctx_persistence (userptr)
[746.626102] Starting subtest: userptr
[746.801129] Subtest userptr: SUCCESS (0.175s)
[746.861033] [130/156] (323s left) kms_atomic_interruptible (universal-setplane-primary)
[746.948634] Starting subtest: universal-setplane-primary
[746.951582] Starting dynamic subtest: pipe-A-eDP-1
[754.388408] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.437s)
[754.390822] Subtest universal-setplane-primary: SUCCESS (7.438s)
[755.224723] [131/156] (314s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[755.319678] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[755.324609] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[755.376507] [132/156] (314s left) i915_pm_rps (min-max-config-idle)
[755.441640] Starting subtest: min-max-config-idle
[755.447073] Subtest min-max-config-idle: SKIP (0.001s)
[755.495079] [133/156] (314s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[755.596547] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[763.061831] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.468s)
[763.154989] [134/156] (307s left) gem_create (create-clear)
[763.204898] Starting subtest: create-clear
[763.208385] Starting dynamic subtest: smem0
[796.102665] Dynamic subtest smem0: SUCCESS (32.878s)
[796.105671] Subtest create-clear: SUCCESS (32.879s)
[796.267954] [135/156] (273s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[796.371143] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[796.373578] Starting dynamic subtest: pipe-A
[796.393765] Dynamic subtest pipe-A: SKIP (0.019s)
[796.405242] Starting dynamic subtest: pipe-B
[796.425557] Dynamic subtest pipe-B: SKIP (0.030s)
[796.437640] Starting dynamic subtest: pipe-C
[796.457453] Dynamic subtest pipe-C: SKIP (0.030s)
[796.469442] Starting dynamic subtest: pipe-D
[796.486480] Dynamic subtest pipe-D: SKIP (0.030s)
[796.491579] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.111s)
[796.580355] [136/156] (273s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[796.687643] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[796.692545] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[796.755918] [137/156] (273s left) gem_ctx_bad_destroy (invalid-ctx)
[796.812810] Starting subtest: invalid-ctx
[796.815754] Subtest invalid-ctx: SUCCESS (0.000s)
[796.866364] [138/156] (273s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[796.965417] Starting subtest: fbc-modesetfrombusy
[800.779960] Subtest fbc-modesetfrombusy: SUCCESS (3.820s)
[801.932115] [139/156] (268s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[802.033703] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[802.038498] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[802.108718] [140/156] (268s left) kms_pipe_crc_basic (suspend-read-crc)
[802.198017] Starting subtest: suspend-read-crc
[802.200453] Starting dynamic subtest: pipe-A-eDP-1
[819.954676] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.507s)
[819.967823] Starting dynamic subtest: pipe-B-eDP-1
[837.974703] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.197s)
[837.986010] Starting dynamic subtest: pipe-C-eDP-1
[855.922681] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.109s)
[855.936465] Starting dynamic subtest: pipe-D-eDP-1
[873.920133] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.076s)
[873.922642] Subtest suspend-read-crc: SUCCESS (11.895s)
[874.747543] [141/156] (195s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[874.863373] Starting subtest: psr2-plane-move-sf-dmg-area
[874.865749] Starting dynamic subtest: pipe-A-eDP-1
[879.428601] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.564s)
[879.443013] Starting dynamic subtest: pipe-B-eDP-1
[884.765837] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.328s)
[884.768290] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.896s)
[885.609431] [142/156] (184s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[885.727269] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[917.507699] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.769s)
[918.350224] [143/156] (152s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[918.463024] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[922.505034] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.047s)
[923.856835] [144/156] (146s left) kms_flip (2x-flip-vs-expired-vblank)
[923.954754] Starting subtest: 2x-flip-vs-expired-vblank
[923.963342] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[924.076872] [145/156] (146s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[924.173825] Starting subtest: x-tiled-64bpp-rotate-180
[925.786784] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.612s)
[925.926158] [146/156] (144s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[926.019414] Starting subtest: fbcpsrhdr-modesetfrombusy
[926.023622] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[926.104840] [147/156] (144s left) i915_drm_fdinfo (memory-info-shared)
[926.138928] Starting subtest: memory-info-shared
[926.140933] Starting dynamic subtest: smem0
[926.176925] Dynamic subtest smem0: SUCCESS (0.037s)
[926.179106] Subtest memory-info-shared: SUCCESS (0.038s)
[926.231329] [148/156] (144s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[926.323009] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[926.326678] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[926.401975] [149/156] (144s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[926.499684] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[926.503133] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[926.586587] [150/156] (144s left) gem_mmap_gtt (basic-short)
[926.628449] Subtest basic-short: SKIP (0.000s)
[926.695067] [151/156] (144s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[926.802364] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[926.805663] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[926.886827] [152/156] (144s left) syncobj_wait (wait-any-interrupted)
[926.941206] Starting subtest: wait-any-interrupted
[927.042593] Subtest wait-any-interrupted: SUCCESS (0.101s)
[927.099516] [153/156] (143s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[927.205001] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[927.209138] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[927.283364] [154/156] (143s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[927.373532] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[927.375866] Starting dynamic subtest: pipe-A-eDP-1
[927.430634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.059s)
[927.441895] Starting dynamic subtest: pipe-B-eDP-1
[927.492178] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[927.503456] Starting dynamic subtest: pipe-C-eDP-1
[927.551699] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s)
[927.562928] Starting dynamic subtest: pipe-D-eDP-1
[927.612650] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[927.614737] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.241s)
[929.919325] [155/156] (141s left) gem_mmap_gtt (pf-nonblock)
[929.978185] Subtest pf-nonblock: SKIP (0.000s)
[930.061419] [156/156] (141s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[930.164689] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[930.168779] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[930.252357] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_exec_capture
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_partial_pwrite_pread
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: kms_dsc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_tiled_swapping
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: api_intel_allocator
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: gem_readwrite
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_wait
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_chamelium_edid
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: kms_properties
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_exec_parallel
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_async_flips
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_whisper
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_atomic
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: kms_lease
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_properties
results: parsing output: 66/ for test: api_intel_bb
results: parsing output: 67/ for test: drm_read
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_vrr
results: parsing output: 70/ for test: sriov_basic
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_cursor_edge_walk
results: parsing output: 76/ for test: gem_mmap_wc
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: prime_vgem
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: gem_ctx_create
results: parsing output: 84/ for test: kms_color
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_joiner
results: parsing output: 91/ for test: i915_suspend
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_chamelium_color
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: gem_ctx_shared
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: gem_mmap
results: parsing output: 103/ for test: gem_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_vrr
results: parsing output: 112/ for test: fbdev
results: parsing output: 113/ for test: i915_fb_tiling
results: parsing output: 114/ for test: gem_pxp
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_pm_rpm
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: gem_tiled_blits
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_atomic_interruptible
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_pm_rps
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_create
results: parsing output: 134/ for test: kms_plane_scaling
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_ctx_bad_destroy
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_pipe_crc_basic
results: parsing output: 140/ for test: kms_psr2_sf
results: parsing output: 141/ for test: kms_cursor_legacy
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_flip
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: i915_drm_fdinfo
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_mmap_gtt
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: syncobj_wait
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: gem_mmap_gtt
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.