[56.493772] Initializing watchdogs
[56.493823]   /dev/watchdog0
[56.508881] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.513262] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.515670] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.519173] [001/131] (960s left) kms_psr (fbc-psr-cursor-plane-onoff)
[56.643619] Starting subtest: fbc-psr-cursor-plane-onoff
[56.645722] Starting dynamic subtest: eDP-1
[56.650120] Dynamic subtest eDP-1: SKIP (0.000s)
[56.654444] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[56.713183] [002/131] (960s left) gem_readwrite (write-bad-handle)
[56.777621] Subtest write-bad-handle: SKIP (0.000s)
[56.845739] [003/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[56.941048] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[56.945153] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.040226] [004/131] (960s left) kms_cdclk (mode-transition)
[57.128566] Starting subtest: mode-transition
[57.130602] Starting dynamic subtest: pipe-A-eDP-1
[57.420439] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[57.428410] Starting dynamic subtest: pipe-B-eDP-1
[57.433058] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[57.440209] Starting dynamic subtest: pipe-C-eDP-1
[57.444766] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[57.453196] Starting dynamic subtest: pipe-D-eDP-1
[57.457295] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[57.461306] Subtest mode-transition: SKIP (0.293s)
[58.228639] [005/131] (958s left) gem_exec_reloc (basic-wc-cpu)
[58.291641] Subtest basic-wc-cpu: SKIP (0.000s)
[58.363402] [006/131] (958s left) kms_psr (psr-sprite-plane-move)
[58.456311] Starting subtest: psr-sprite-plane-move
[58.458678] Starting dynamic subtest: eDP-1
[60.261257] Dynamic subtest eDP-1: SUCCESS (1.804s)
[60.263546] Subtest psr-sprite-plane-move: SUCCESS (1.804s)
[61.072256] [007/131] (956s left) api_intel_allocator (fork-simple-stress-signal)
[61.125835] Starting subtest: fork-simple-stress-signal
[66.530369] Subtest fork-simple-stress-signal: SUCCESS (5.405s)
[66.654407] [008/131] (950s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[66.706605] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[66.815300] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[66.891741] [009/131] (950s left) kms_joiner (invalid-modeset-big-joiner)
[66.996890] Starting subtest: invalid-modeset-big-joiner
[67.001244] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[67.061133] [010/131] (950s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[67.116116] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[67.118715] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[67.227816] [011/131] (950s left) syncobj_wait (wait-all-for-submit-snapshot)
[67.286979] Starting subtest: wait-all-for-submit-snapshot
[67.369220] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[67.440224] [012/131] (949s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[67.551947] Starting subtest: y-tiled-8bpp-rotate-270
[67.556305] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[67.667643] [013/131] (949s left) gem_ctx_isolation (nonpriv-switch)
[67.736050] Starting subtest: nonpriv-switch
[67.738971] Starting dynamic subtest: rcs0
[68.333106] Dynamic subtest rcs0: SUCCESS (0.597s)
[68.342087] Starting dynamic subtest: bcs0
[68.965844] Dynamic subtest bcs0: SUCCESS (0.633s)
[68.973122] Starting dynamic subtest: vcs0
[69.605534] Dynamic subtest vcs0: SUCCESS (0.639s)
[69.614407] Starting dynamic subtest: vcs1
[71.677631] Dynamic subtest vcs1: SUCCESS (2.072s)
[71.687930] Starting dynamic subtest: vecs0
[73.549800] Dynamic subtest vecs0: SUCCESS (1.872s)
[73.559951] Starting dynamic subtest: ccs0
[75.559099] Dynamic subtest ccs0: SUCCESS (2.009s)
[75.561437] Subtest nonpriv-switch: SUCCESS (7.823s)
[75.805089] [014/131] (941s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[75.900978] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[75.903354] Starting dynamic subtest: pipe-A-eDP-1
[75.926365] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[75.936108] Starting dynamic subtest: pipe-B-eDP-1
[75.957153] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[75.964116] Starting dynamic subtest: pipe-C-eDP-1
[75.984756] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[75.991740] Starting dynamic subtest: pipe-D-eDP-1
[76.013768] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.017871] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[78.125142] [015/131] (939s left) kms_psr (fbc-pr-cursor-plane-move)
[78.218733] Starting subtest: fbc-pr-cursor-plane-move
[78.223286] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[78.321036] [016/131] (939s left) kms_flip (bo-too-big)
[78.428469] Starting subtest: bo-too-big
[78.430671] Starting dynamic subtest: A-eDP1
[80.213181] Dynamic subtest A-eDP1: SUCCESS (1.784s)
[80.221615] Starting dynamic subtest: B-eDP1
[82.132787] Dynamic subtest B-eDP1: SUCCESS (1.919s)
[82.141903] Starting dynamic subtest: C-eDP1
[83.862495] Dynamic subtest C-eDP1: SUCCESS (1.729s)
[83.871633] Starting dynamic subtest: D-eDP1
[85.588126] Dynamic subtest D-eDP1: SUCCESS (1.726s)
[85.590466] Subtest bo-too-big: SUCCESS (7.163s)
[86.755038] [017/131] (930s left) gem_exec_balancer (bonded-pair)
[86.806497] Starting subtest: bonded-pair
[86.811151] Subtest bonded-pair: SKIP (0.000s)
[87.105847] [018/131] (930s left) gem_mmap_offset (open-flood)
[87.165136] Starting subtest: open-flood
[108.652300] Subtest open-flood: SUCCESS (21.489s)
[108.767709] [019/131] (908s left) gem_exec_schedule (semaphore-power)
[108.962501] Subtest semaphore-power: SKIP (0.000s)
[109.140227] [020/131] (908s left) kms_cursor_crc (cursor-random-max-size)
[109.415472] Starting subtest: cursor-random-max-size
[109.422072] Subtest cursor-random-max-size: SKIP (0.000s)
[109.564045] [021/131] (908s left) gem_sync (basic-each)
[109.641056] Starting subtest: basic-each
[112.067387] Subtest basic-each: SUCCESS (2.439s)
[112.248035] [022/131] (905s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[112.361528] Starting subtest: 4-tiled-16bpp-rotate-90
[112.382281] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[112.523217] [023/131] (905s left) gem_exec_fence (invalid-timeline-fence-array)
[113.105330] Starting subtest: invalid-timeline-fence-array
[113.111537] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[114.989388] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[114.994904] [024/131] (902s left) gem_userptr_blits (sd-probe)
[115.065538] Starting subtest: sd-probe
[115.067495] Subtest sd-probe: SUCCESS (0.000s)
[115.218459] [025/131] (902s left) kms_prop_blob (blob-prop-validate)
[115.265839] Starting subtest: blob-prop-validate
[115.268063] Subtest blob-prop-validate: SUCCESS (0.000s)
[115.359912] [026/131] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[115.461936] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[115.466085] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[115.568907] [027/131] (902s left) kms_legacy_colorkey (invalid-plane)
[115.664138] Starting subtest: invalid-plane
[115.666495] Starting dynamic subtest: zero-id
[115.668798] Dynamic subtest zero-id: SUCCESS (0.000s)
[115.677186] Starting dynamic subtest: outrange-id
[115.679486] Dynamic subtest outrange-id: SUCCESS (0.000s)
[115.681396] Subtest invalid-plane: SUCCESS (0.000s)
[115.734893] [028/131] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[115.830504] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[115.834969] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[115.943654] [029/131] (902s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[116.331721] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[117.152867] [030/131] (900s left) gem_exec_reloc (basic-softpin)
[117.218232] Subtest basic-softpin: SKIP (0.000s)
[117.323161] [031/131] (900s left) syncobj_timeline (etime-single-wait-all-submitted)
[117.377820] Starting subtest: etime-single-wait-all-submitted
[117.488374] Subtest etime-single-wait-all-submitted: SUCCESS (0.109s)
[117.563952] [032/131] (900s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[117.663135] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[117.665490] Starting dynamic subtest: pipe-A-default-mode
[117.951787] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[117.956290] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.286s)
[118.805239] [033/131] (899s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[118.907112] Starting subtest: plane-downscale-factor-0-75-with-rotation
[118.909477] Starting dynamic subtest: pipe-A
[119.246313] Dynamic subtest pipe-A: SUCCESS (0.339s)
[119.254388] Starting dynamic subtest: pipe-B
[120.677657] Dynamic subtest pipe-B: SUCCESS (1.431s)
[120.686074] Starting dynamic subtest: pipe-C
[122.114451] Dynamic subtest pipe-C: SUCCESS (1.436s)
[122.122326] Starting dynamic subtest: pipe-D
[123.526179] Dynamic subtest pipe-D: SUCCESS (1.411s)
[123.528467] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.619s)
[124.703693] [034/131] (893s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[124.806465] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[124.817664] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[124.924168] [035/131] (893s left) i915_drm_fdinfo (busy-idle)
[124.964479] Starting subtest: busy-idle
[124.966676] Starting dynamic subtest: rcs0
[125.002368] Dynamic subtest rcs0: SKIP (0.036s)
[125.011606] Starting dynamic subtest: bcs0
[125.015800] Dynamic subtest bcs0: SKIP (0.001s)
[125.023026] Starting dynamic subtest: vcs0
[125.026980] Dynamic subtest vcs0: SKIP (0.001s)
[125.034384] Starting dynamic subtest: vcs1
[125.038742] Dynamic subtest vcs1: SKIP (0.000s)
[125.047068] Starting dynamic subtest: vecs0
[125.051170] Dynamic subtest vecs0: SKIP (0.000s)
[125.058083] Starting dynamic subtest: ccs0
[125.062353] Dynamic subtest ccs0: SKIP (0.000s)
[125.066581] Subtest busy-idle: SKIP (0.041s)
[125.100323] [036/131] (893s left) kms_flip (2x-modeset-vs-vblank-race)
[125.200150] Starting subtest: 2x-modeset-vs-vblank-race
[125.211312] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[125.331544] [037/131] (893s left) api_intel_allocator (reserve-simple)
[125.384623] Starting subtest: reserve-simple
[125.387065] Subtest reserve-simple: SUCCESS (0.004s)
[125.503773] [038/131] (892s left) gem_mmap_gtt (cpuset-big-copy-xy)
[125.553599] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[125.615021] [039/131] (892s left) syncobj_wait (wait-all-snapshot)
[125.672880] Starting subtest: wait-all-snapshot
[125.752648] Subtest wait-all-snapshot: SUCCESS (0.081s)
[125.828076] [040/131] (892s left) fbdev (write)
[125.868261] Starting subtest: write
[126.405387] Subtest write: SUCCESS (0.535s)
[126.466844] [041/131] (892s left) syncobj_timeline (multi-wait-for-submit-signaled)
[126.517330] Starting subtest: multi-wait-for-submit-signaled
[126.519639] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[126.626233] [042/131] (892s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[126.755422] Starting subtest: basic-flip-after-cursor-varying-size
[127.703306] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.946s)
[128.527370] [043/131] (890s left) kms_dp_link_training (uhbr-sst)
[128.630170] Starting subtest: uhbr-sst
[128.639149] Subtest uhbr-sst: SKIP (0.000s)
[128.702356] [044/131] (890s left) kms_psr (fbc-psr-sprite-render)
[128.790356] Starting subtest: fbc-psr-sprite-render
[128.792617] Starting dynamic subtest: eDP-1
[128.796693] Dynamic subtest eDP-1: SKIP (0.000s)
[128.800785] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[128.866078] [045/131] (889s left) gem_barrier_race (remote-request)
[128.926612] Starting subtest: remote-request
[128.928898] Starting dynamic subtest: rcs0
[134.094392] Dynamic subtest rcs0: SUCCESS (5.170s)
[134.096318] Subtest remote-request: SUCCESS (5.170s)
[134.247091] [046/131] (884s left) sysfs_defaults (readonly)
[134.312159] Starting subtest: readonly
[134.313984] Starting dynamic subtest: vecs0
[134.316122] Dynamic subtest vecs0: SUCCESS (0.000s)
[134.323152] Starting dynamic subtest: ccs0
[134.324673] Dynamic subtest ccs0: SUCCESS (0.000s)
[134.331373] Starting dynamic subtest: vcs0
[134.332961] Dynamic subtest vcs0: SUCCESS (0.000s)
[134.339721] Starting dynamic subtest: bcs0
[134.341335] Dynamic subtest bcs0: SUCCESS (0.000s)
[134.348027] Starting dynamic subtest: rcs0
[134.349666] Dynamic subtest rcs0: SUCCESS (0.000s)
[134.356246] Starting dynamic subtest: vcs1
[134.357819] Dynamic subtest vcs1: SUCCESS (0.000s)
[134.359413] Subtest readonly: SUCCESS (0.005s)
[134.444886] [047/131] (884s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[134.555295] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[135.823954] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.268s)
[135.960597] [048/131] (882s left) kms_cursor_crc (cursor-random-128x128)
[136.162219] Starting subtest: cursor-random-128x128
[136.166768] Starting dynamic subtest: pipe-A-eDP-1
[140.066513] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.899s)
[140.098183] Starting dynamic subtest: pipe-D-eDP-1
[144.566342] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.480s)
[144.568769] Subtest cursor-random-128x128: SUCCESS (8.404s)
[145.374052] [049/131] (873s left) perf (polling)
[145.464193] Starting subtest: polling
[145.466616] Starting dynamic subtest: 0-rcs0
[155.487101] Dynamic subtest 0-rcs0: SUCCESS (10.020s)
[155.495331] Starting dynamic subtest: 1-vcs0
[165.504160] Dynamic subtest 1-vcs0: SUCCESS (10.015s)
[165.507065] Subtest polling: SUCCESS (20.037s)
[165.551907] [050/131] (853s left) gem_exercise_blt (fast-copy)
[165.609880] Starting subtest: fast-copy
[165.612230] Starting dynamic subtest: linear-smem-smem
[165.640516] Dynamic subtest linear-smem-smem: SUCCESS (0.032s)
[165.650293] Starting dynamic subtest: xmajor-smem-smem
[165.661758] Dynamic subtest xmajor-smem-smem: SUCCESS (0.021s)
[165.669462] Starting dynamic subtest: tile4-smem-smem
[165.683252] Dynamic subtest tile4-smem-smem: SUCCESS (0.021s)
[165.690754] Starting dynamic subtest: tile64-smem-smem
[165.705363] Dynamic subtest tile64-smem-smem: SUCCESS (0.022s)
[165.707681] Subtest fast-copy: SUCCESS (0.097s)
[165.830448] [051/131] (853s left) kms_async_flips (async-flip-suspend-resume)
[165.924676] Starting subtest: async-flip-suspend-resume
[166.303809] Starting dynamic subtest: pipe-A-eDP-1
[184.621943] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.967s)
[185.000938] Starting dynamic subtest: pipe-B-eDP-1
[187.748686] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[188.135503] Starting dynamic subtest: pipe-C-eDP-1
[190.878097] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.747s)
[191.239745] Starting dynamic subtest: pipe-D-eDP-1
[194.002458] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[194.005389] Subtest async-flip-suspend-resume: SUCCESS (12.722s)
[195.182903] [052/131] (823s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[200.226827] Starting subtest: pr-primary-plane-update-sf-dmg-area
[200.234874] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.003s)
[201.086822] [053/131] (817s left) kms_pm_rpm (fences-dpms)
[203.436830] Starting subtest: fences-dpms
[203.441979] Subtest fences-dpms: SKIP (0.000s)
[203.805634] [054/131] (815s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[203.915366] Starting subtest: fbcpsr-modesetfrombusy
[210.111228] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.200s)
[210.246658] [055/131] (808s left) gem_pwrite (basic-self)
[210.307026] Subtest basic-self: SKIP (0.000s)
[210.376161] [056/131] (808s left) kms_getfb (getfb-addfb-different-handles)
[210.484118] Starting subtest: getfb-addfb-different-handles
[210.486081] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[210.610745] [057/131] (808s left) kms_cursor_legacy (torture-bo)
[210.726541] Starting subtest: torture-bo
[210.728337] Starting dynamic subtest: pipe-A
[216.872041] Dynamic subtest pipe-A: SUCCESS (6.141s)
[216.883165] Starting dynamic subtest: pipe-B
[222.894274] Dynamic subtest pipe-B: SUCCESS (6.009s)
[222.904464] Starting dynamic subtest: pipe-C
[229.438461] Dynamic subtest pipe-C: SUCCESS (6.554s)
[229.448109] Starting dynamic subtest: pipe-D
[236.376280] Dynamic subtest pipe-D: SUCCESS (6.935s)
[236.391433] Starting dynamic subtest: all-pipes
[242.287384] Dynamic subtest all-pipes: SUCCESS (5.909s)
[242.290058] Subtest torture-bo: SUCCESS (31.557s)
[242.440013] [058/131] (776s left) kms_setmode (invalid-clone-single-crtc)
[242.497465] Starting subtest: invalid-clone-single-crtc
[242.503837] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[242.594818] [059/131] (776s left) i915_pm_rpm (gem-execbuf)
[244.333563] Starting subtest: gem-execbuf
[244.335865] Starting dynamic subtest: smem0
[246.170582] Dynamic subtest smem0: SUCCESS (1.835s)
[246.172669] Subtest gem-execbuf: SUCCESS (1.835s)
[246.257994] [060/131] (773s left) gem_lmem_swapping (massive)
[246.299008] Subtest massive: SKIP (0.000s)
[246.343558] [061/131] (773s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[246.449682] Starting subtest: psr-rgb101010-draw-mmap-cpu
[253.476954] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.030s)
[253.582508] [062/131] (765s left) kms_lease (invalid-create-leases)
[253.681533] Starting subtest: invalid-create-leases
[253.688592] Subtest invalid-create-leases: SUCCESS (0.005s)
[253.793114] [063/131] (765s left) gen3_mixed_blits
[253.917774] [064/131] (765s left) syncobj_timeline (wait-all-delayed-signal)
[253.966024] Starting subtest: wait-all-delayed-signal
[254.067608] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[254.149715] [065/131] (765s left) kms_getfb (getfb2-accept-nv12)
[254.244266] Starting subtest: getfb2-accept-nv12
[254.246564] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[254.358985] [066/131] (765s left) prime_busy (before-wait)
[254.414173] Starting subtest: before-wait
[254.419172] Starting dynamic subtest: rcs0
[254.447486] Dynamic subtest rcs0: SUCCESS (0.031s)
[254.457340] Starting dynamic subtest: bcs0
[254.488252] Dynamic subtest bcs0: SUCCESS (0.040s)
[254.496676] Starting dynamic subtest: vcs0
[254.528764] Dynamic subtest vcs0: SUCCESS (0.040s)
[254.536780] Starting dynamic subtest: vcs1
[254.568477] Dynamic subtest vcs1: SUCCESS (0.039s)
[254.578483] Starting dynamic subtest: vecs0
[254.608779] Dynamic subtest vecs0: SUCCESS (0.040s)
[254.617644] Starting dynamic subtest: ccs0
[254.653779] Dynamic subtest ccs0: SUCCESS (0.044s)
[254.761369] Subtest before-wait: SUCCESS (0.345s)
[254.837277] [067/131] (764s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[254.941482] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[254.945698] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[255.051044] [068/131] (764s left) kms_chamelium_color (ctm-negative)
[255.155704] Subtest ctm-negative: SKIP (0.000s)
[255.201656] [069/131] (764s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[255.305392] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[262.100576] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.798s)
[262.199708] [070/131] (757s left) gem_wait (busy)
[262.256476] Starting subtest: busy
[262.258792] Starting dynamic subtest: all-engines
[264.266527] Dynamic subtest all-engines: SUCCESS (2.008s)
[264.277673] Starting dynamic subtest: rcs0
[264.807724] Dynamic subtest rcs0: SUCCESS (0.540s)
[264.817199] Starting dynamic subtest: bcs0
[265.347629] Dynamic subtest bcs0: SUCCESS (0.539s)
[265.357243] Starting dynamic subtest: vcs0
[267.274849] Dynamic subtest vcs0: SUCCESS (1.925s)
[267.286890] Starting dynamic subtest: vcs1
[269.258763] Dynamic subtest vcs1: SUCCESS (1.982s)
[269.269064] Starting dynamic subtest: vecs0
[271.242492] Dynamic subtest vecs0: SUCCESS (1.982s)
[271.253997] Starting dynamic subtest: ccs0
[271.783936] Dynamic subtest ccs0: SUCCESS (0.541s)
[271.786590] Subtest busy: SUCCESS (9.527s)
[271.981066] [071/131] (747s left) gem_exec_schedule (thriceslice)
[272.043524] Starting subtest: thriceslice
[272.045735] Starting dynamic subtest: rcs0
[272.094307] Dynamic subtest rcs0: SUCCESS (0.058s)
[272.105889] Starting dynamic subtest: bcs0
[272.150514] Dynamic subtest bcs0: SUCCESS (0.055s)
[272.161987] Starting dynamic subtest: vcs0
[272.207461] Dynamic subtest vcs0: SUCCESS (0.055s)
[272.218821] Starting dynamic subtest: vcs1
[272.240014] Dynamic subtest vcs1: SUCCESS (0.031s)
[272.250761] Starting dynamic subtest: vecs0
[272.269525] Dynamic subtest vecs0: SUCCESS (0.029s)
[272.278088] Starting dynamic subtest: ccs0
[272.329144] Dynamic subtest ccs0: SUCCESS (0.059s)
[272.331609] Subtest thriceslice: SUCCESS (0.294s)
[272.635226] [072/131] (747s left) perf (short-reads)
[272.717331] Starting subtest: short-reads
[272.737602] Subtest short-reads: SUCCESS (0.021s)
[272.787626] [073/131] (747s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[272.902774] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[272.907016] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[273.019922] [074/131] (746s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[273.121616] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[279.628934] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.510s)
[279.763728] [075/131] (740s left) gem_softpin (evict-active)
[279.822678] Starting subtest: evict-active
[279.829023] Subtest evict-active: SUCCESS (0.006s)
[279.959038] [076/131] (740s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[285.009195] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[285.013827] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[285.846775] [077/131] (734s left) gem_sync (basic-store-each)
[285.927725] Starting subtest: basic-store-each
[288.244115] Subtest basic-store-each: SUCCESS (2.329s)
[288.444885] [078/131] (731s left) gem_userptr_blits (stress-mm-invalidate-close)
[288.507109] Starting subtest: stress-mm-invalidate-close
[290.654852] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[290.796408] [079/131] (729s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[290.901689] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[290.904132] Starting dynamic subtest: pipe-A-eDP-1
[291.812462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.901s)
[291.821734] Starting dynamic subtest: pipe-B-eDP-1
[293.384606] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.570s)
[293.395488] Starting dynamic subtest: pipe-C-eDP-1
[294.853981] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.465s)
[294.864291] Starting dynamic subtest: pipe-D-eDP-1
[296.397491] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.545s)
[296.399879] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.486s)
[297.633756] [080/131] (722s left) gem_ctx_shared (q-smoketest)
[297.692891] Starting subtest: Q-smoketest
[297.695186] Starting dynamic subtest: rcs0
[303.250377] Dynamic subtest rcs0: SUCCESS (5.506s)
[303.259893] Starting dynamic subtest: bcs0
[308.749842] Dynamic subtest bcs0: SUCCESS (5.500s)
[308.760273] Starting dynamic subtest: vcs0
[314.228147] Dynamic subtest vcs0: SUCCESS (5.477s)
[314.242733] Starting dynamic subtest: vcs1
[319.719227] Dynamic subtest vcs1: SUCCESS (5.496s)
[319.729724] Starting dynamic subtest: vecs0
[325.212562] Dynamic subtest vecs0: SUCCESS (5.490s)
[325.226574] Starting dynamic subtest: ccs0
[330.716393] Dynamic subtest ccs0: SUCCESS (5.500s)
[330.718574] Subtest Q-smoketest: SUCCESS (32.975s)
[330.852792] [081/131] (689s left) kms_pm_dc (dc5-dpms-negative)
[331.961438] Starting subtest: dc5-dpms-negative
[331.965824] Subtest dc5-dpms-negative: SKIP (0.000s)
[332.031996] [082/131] (688s left) vgem_basic (mmap)
[332.075350] Starting subtest: mmap
[332.093560] Subtest mmap: SUCCESS (0.020s)
[332.159207] [083/131] (688s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[332.263399] Starting subtest: extended-modeset-hang-newfb-with-reset
[332.265719] Starting dynamic subtest: pipe-A
[346.257636] Dynamic subtest pipe-A: SUCCESS (13.991s)
[346.269149] Starting dynamic subtest: pipe-D
[362.106604] Dynamic subtest pipe-D: SUCCESS (15.846s)
[362.109485] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.841s)
[362.920605] [084/131] (657s left) kms_plane_multiple (2x-tiling-none)
[363.026700] Starting subtest: 2x-tiling-none
[363.031303] Subtest 2x-tiling-none: SKIP (0.000s)
[363.099872] [085/131] (657s left) kms_frontbuffer_tracking (psr-1p-rte)
[363.200210] Starting subtest: psr-1p-rte
[368.547870] Subtest psr-1p-rte: SUCCESS (5.351s)
[368.693902] [086/131] (651s left) gem_exec_balancer (semaphore)
[368.749928] Starting subtest: semaphore
[370.274386] Subtest semaphore: SUCCESS (1.522s)
[370.554859] [087/131] (649s left) kms_sequence (get-idle)
[370.655626] Starting subtest: get-idle
[370.657861] Starting dynamic subtest: pipe-A-eDP-1
[372.474031] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[372.484153] Starting dynamic subtest: pipe-B-eDP-1
[374.954694] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.480s)
[374.964479] Starting dynamic subtest: pipe-C-eDP-1
[377.367818] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.408s)
[377.378309] Starting dynamic subtest: pipe-D-eDP-1
[379.788371] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.422s)
[379.790682] Subtest get-idle: SUCCESS (9.131s)
[380.585668] [088/131] (639s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[380.719489] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[380.724198] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[380.866915] [089/131] (639s left) gem_exec_suspend (basic-s4-devices)
[380.924745] Starting subtest: basic-S4-devices
[380.927055] Starting dynamic subtest: smem
[392.266927] Dynamic subtest smem: SUCCESS (11.339s)
[392.269558] Subtest basic-S4-devices: SUCCESS (11.341s)
[398.467519] [090/131] (628s left) syncobj_basic (bad-pad-fd-to-handle)
[398.544629] Starting subtest: bad-pad-fd-to-handle
[398.546564] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[398.653864] [091/131] (627s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[398.753996] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[403.206499] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.456s)
[404.390707] [092/131] (622s left) gem_ctx_persistence (heartbeat-hostile)
[404.442151] Starting subtest: heartbeat-hostile
[404.446781] Subtest heartbeat-hostile: SKIP (0.000s)
[404.550503] [093/131] (622s left) gem_tiled_swapping (non-threaded)
[404.605411] Subtest non-threaded: SKIP (0.000s)
[404.673067] [094/131] (622s left) kms_busy (extended-pageflip-hang-oldfb)
[404.774784] Starting subtest: extended-pageflip-hang-oldfb
[404.776965] Starting dynamic subtest: pipe-A
[405.205816] Dynamic subtest pipe-A: SUCCESS (0.427s)
[405.216434] Starting dynamic subtest: pipe-D
[406.295619] Dynamic subtest pipe-D: SUCCESS (1.090s)
[406.297908] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.521s)
[407.114580] [095/131] (619s left) gem_eio (in-flight-immediate)
[407.363126] Starting subtest: in-flight-immediate
[416.404341] Subtest in-flight-immediate: SUCCESS (9.040s)
[416.525130] [096/131] (610s left) kms_frontbuffer_tracking (fbc-stridechange)
[416.629743] Starting subtest: fbc-stridechange
[419.922000] Subtest fbc-stridechange: SUCCESS (3.293s)
[421.095490] [097/131] (605s left) kms_addfb_basic (invalid-get-prop-any)
[421.146378] Starting subtest: invalid-get-prop-any
[421.148717] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[421.300972] [098/131] (605s left) i915_selftest (live)
[424.768465] Starting subtest: live
[424.770595] Starting dynamic subtest: sanitycheck
[429.234896] Dynamic subtest sanitycheck: SUCCESS (4.465s)
[429.244396] Starting dynamic subtest: uncore
[433.692202] Dynamic subtest uncore: SUCCESS (4.455s)
[433.702673] Starting dynamic subtest: workarounds
[438.473762] Dynamic subtest workarounds: SUCCESS (4.780s)
[438.484164] Starting dynamic subtest: gt_engines
[441.721657] Dynamic subtest gt_engines: SUCCESS (3.246s)
[441.732124] Starting dynamic subtest: gt_timelines
[457.500353] Dynamic subtest gt_timelines: SUCCESS (15.776s)
[457.510544] Starting dynamic subtest: gt_contexts
[461.931452] Dynamic subtest gt_contexts: SUCCESS (4.429s)
[461.941688] Starting dynamic subtest: gt_lrc
[468.249208] Dynamic subtest gt_lrc: SUCCESS (6.315s)
[468.259694] Starting dynamic subtest: gt_mocs
[471.639495] Dynamic subtest gt_mocs: SUCCESS (3.389s)
[471.654780] Starting dynamic subtest: gt_pm
[478.494382] Dynamic subtest gt_pm: SUCCESS (6.853s)
[478.504317] Starting dynamic subtest: gt_heartbeat
[481.336083] Dynamic subtest gt_heartbeat: SUCCESS (2.840s)
[481.344837] Starting dynamic subtest: gt_tlb
[490.809488] Dynamic subtest gt_tlb: SUCCESS (9.471s)
[490.817035] Starting dynamic subtest: requests
[504.239046] Dynamic subtest requests: SUCCESS (13.426s)
[504.249398] Starting dynamic subtest: migrate
[510.248913] Dynamic subtest migrate: SUCCESS (6.008s)
[510.259705] Starting dynamic subtest: active
[514.757582] Dynamic subtest active: SUCCESS (4.508s)
[514.772748] Starting dynamic subtest: objects
[519.850775] Dynamic subtest objects: SUCCESS (5.090s)
[519.859293] Starting dynamic subtest: mman
[524.848735] Dynamic subtest mman: SUCCESS (4.996s)
[524.858786] Starting dynamic subtest: dmabuf
[529.307367] Dynamic subtest dmabuf: SUCCESS (4.457s)
[529.317080] Starting dynamic subtest: vma
[533.706559] Dynamic subtest vma: SUCCESS (4.397s)
[533.716459] Starting dynamic subtest: coherency
[537.345186] Dynamic subtest coherency: SUCCESS (3.636s)
[537.355744] Starting dynamic subtest: gtt
[547.332053] Dynamic subtest gtt: SUCCESS (9.985s)
[547.342010] Starting dynamic subtest: gem
[553.215106] Dynamic subtest gem: SUCCESS (5.882s)
[553.224997] Starting dynamic subtest: evict
[557.351364] Dynamic subtest evict: SUCCESS (4.134s)
[557.361674] Starting dynamic subtest: hugepages
[568.387137] Dynamic subtest hugepages: SUCCESS (11.034s)
[568.397351] Starting dynamic subtest: gem_contexts
[596.931092] Dynamic subtest gem_contexts: SUCCESS (28.541s)
[596.941378] Starting dynamic subtest: client
[601.334480] Dynamic subtest client: SUCCESS (4.403s)
[601.344136] Starting dynamic subtest: gem_migrate
[605.774773] Dynamic subtest gem_migrate: SUCCESS (4.439s)
[605.784579] Starting dynamic subtest: reset
[610.336738] Dynamic subtest reset: SUCCESS (4.559s)
[610.346965] Starting dynamic subtest: memory_region
[614.820386] Dynamic subtest memory_region: SUCCESS (4.482s)
[614.831031] Starting dynamic subtest: hangcheck
[628.096455] Dynamic subtest hangcheck: SUCCESS (13.273s)
[628.106996] Starting dynamic subtest: execlists
[632.579746] Dynamic subtest execlists: SUCCESS (4.482s)
[632.590125] Starting dynamic subtest: ring_submission
[635.395517] Dynamic subtest ring_submission: SUCCESS (2.814s)
[635.411065] Starting dynamic subtest: perf
[639.854204] Dynamic subtest perf: SUCCESS (4.457s)
[639.864213] Starting dynamic subtest: slpc
[654.107122] Dynamic subtest slpc: SUCCESS (14.249s)
[654.117487] Starting dynamic subtest: guc
[658.189986] Dynamic subtest guc: SUCCESS (4.081s)
[658.205296] Starting dynamic subtest: guc_multi_lrc
[662.620690] Dynamic subtest guc_multi_lrc: SUCCESS (4.429s)
[662.631036] Starting dynamic subtest: guc_hang
[667.701412] Dynamic subtest guc_hang: SUCCESS (5.079s)
[667.711489] Starting dynamic subtest: late_gt_pm
[672.058476] Dynamic subtest late_gt_pm: SUCCESS (4.354s)
[672.060953] Subtest live: SUCCESS (247.274s)
[672.088257] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[672.088964] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[672.092422] [099/131] (354s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[673.599529] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[673.603699] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[673.677943] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[673.679285] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)] new: kernel.kmod_is_loaded.i915: true
[673.682923] [100/131] (353s left) gem_exec_reloc (basic-concurrent0)
[673.759069] Subtest basic-concurrent0: SKIP (0.000s)
[673.830162] [101/131] (353s left) kms_flip (flip-vs-panning-vs-hang)
[673.926810] Starting subtest: flip-vs-panning-vs-hang
[673.929062] Starting dynamic subtest: A-eDP1
[724.722456] Dynamic subtest A-eDP1: SUCCESS (50.792s)
[724.731790] Starting dynamic subtest: D-eDP1
[774.712196] Dynamic subtest D-eDP1: SUCCESS (49.984s)
[774.715026] Subtest flip-vs-panning-vs-hang: SUCCESS (100.781s)
[775.892892] [102/131] (251s left) perf (sysctl-defaults)
[775.951204] Starting subtest: sysctl-defaults
[775.954177] Subtest sysctl-defaults: SUCCESS (0.000s)
[776.045814] [103/131] (251s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[776.144193] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[776.148589] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[776.246468] [104/131] (250s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[776.343482] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[776.347468] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[776.457625] [105/131] (250s left) kms_universal_plane (universal-plane-functional)
[776.554534] Starting subtest: universal-plane-functional
[776.556460] Starting dynamic subtest: pipe-A-eDP-1
[780.422019] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.868s)
[780.431376] Starting dynamic subtest: pipe-B-eDP-1
[784.898858] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.477s)
[784.908585] Starting dynamic subtest: pipe-C-eDP-1
[789.144049] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.241s)
[789.153102] Starting dynamic subtest: pipe-D-eDP-1
[793.433039] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.289s)
[793.435203] Subtest universal-plane-functional: SUCCESS (16.880s)
[794.305828] [106/131] (232s left) i915_drm_fdinfo (virtual-busy)
[794.351343] Starting subtest: virtual-busy
[794.355844] Subtest virtual-busy: SKIP (0.000s)
[794.425947] [107/131] (232s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[794.526022] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[794.530540] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[794.622056] [108/131] (232s left) perf_pmu (init-busy)
[794.661405] Starting subtest: init-busy
[794.663840] Starting dynamic subtest: rcs0
[794.666233] Dynamic subtest rcs0: SUCCESS (0.002s)
[794.677171] Starting dynamic subtest: bcs0
[794.679123] Dynamic subtest bcs0: SUCCESS (0.000s)
[794.688063] Starting dynamic subtest: vcs0
[794.690290] Dynamic subtest vcs0: SUCCESS (0.001s)
[794.698885] Starting dynamic subtest: vcs1
[794.701121] Dynamic subtest vcs1: SUCCESS (0.001s)
[794.709623] Starting dynamic subtest: vecs0
[794.711874] Dynamic subtest vecs0: SUCCESS (0.001s)
[794.720277] Starting dynamic subtest: ccs0
[794.722663] Dynamic subtest ccs0: SUCCESS (0.000s)
[794.725134] Subtest init-busy: SUCCESS (0.008s)
[794.780224] [109/131] (232s left) core_hotunplug (unbind-rebind)
[794.863237] Starting subtest: unbind-rebind
[800.960616] Subtest unbind-rebind: SUCCESS (6.099s)
[801.000221] [110/131] (226s left) perf_pmu (busy)
[801.044952] Starting subtest: busy
[801.046926] Starting dynamic subtest: rcs0
[802.767850] Dynamic subtest rcs0: SUCCESS (1.723s)
[802.780233] Starting dynamic subtest: bcs0
[803.330700] Dynamic subtest bcs0: SUCCESS (0.561s)
[803.343082] Starting dynamic subtest: vcs0
[805.261008] Dynamic subtest vcs0: SUCCESS (1.927s)
[805.275124] Starting dynamic subtest: vcs1
[807.242162] Dynamic subtest vcs1: SUCCESS (1.979s)
[807.254789] Starting dynamic subtest: vecs0
[809.226898] Dynamic subtest vecs0: SUCCESS (1.982s)
[809.238297] Starting dynamic subtest: ccs0
[809.800504] Dynamic subtest ccs0: SUCCESS (0.573s)
[809.803350] Subtest busy: SUCCESS (8.757s)
[809.927638] [111/131] (217s left) kms_psr (psr2-no-drrs)
[810.026297] Starting subtest: psr2-no-drrs
[810.028586] Starting dynamic subtest: eDP-1
[811.612069] Dynamic subtest eDP-1: SUCCESS (1.587s)
[811.614461] Subtest psr2-no-drrs: SUCCESS (1.588s)
[812.396146] [112/131] (215s left) gem_exec_reloc (basic-cpu-wc-active)
[812.452487] Subtest basic-cpu-wc-active: SKIP (0.000s)
[812.532939] [113/131] (214s left) kms_content_protection (uevent)
[812.715167] Starting subtest: uevent
[816.118142] Subtest uevent: SKIP (3.401s)
[817.290818] [114/131] (210s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[817.343823] Starting subtest: yf-tiled-ccs-to-x-tiled
[817.348201] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[817.529757] [115/131] (210s left) gem_exec_fence (syncobj-invalid-wait)
[817.945959] Starting subtest: syncobj-invalid-wait
[817.948561] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[819.373471] [116/131] (208s left) i915_pm_rps (reset)
[819.437511] Starting subtest: reset
[819.522478] Subtest reset: FAIL (0.028s)
[819.599650] [117/131] (208s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[819.647392] Starting subtest: multi-wait-all-for-submit-signaled
[819.649668] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[819.747727] [118/131] (207s left) kms_chamelium_frames (hdmi-frame-dump)
[820.148726] Subtest hdmi-frame-dump: SKIP (0.000s)
[821.010782] [119/131] (206s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[821.107841] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[822.230960] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.122s)
[822.397060] [120/131] (205s left) gem_exec_nop (basic-parallel)
[822.476698] Starting subtest: basic-parallel
[838.219839] Subtest basic-parallel: SUCCESS (15.752s)
[838.452410] [121/131] (189s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[838.550608] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[838.552898] Starting dynamic subtest: pipe-A-eDP-1
[838.562064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[838.573370] Starting dynamic subtest: pipe-B-eDP-1
[838.582730] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[838.594332] Starting dynamic subtest: pipe-C-eDP-1
[838.602486] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[838.611902] Starting dynamic subtest: pipe-D-eDP-1
[838.620220] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[838.624129] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[840.675592] [122/131] (187s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[840.770335] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[847.033289] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.268s)
[848.172406] [123/131] (179s left) kms_big_fb (linear-8bpp-rotate-90)
[848.275832] Starting subtest: linear-8bpp-rotate-90
[848.297384] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[848.422932] [124/131] (179s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[848.471632] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[848.476120] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[848.657488] [125/131] (179s left) kms_dsc (dsc-with-output-formats-with-bpc)
[848.749748] Starting subtest: dsc-with-output-formats-with-bpc
[848.807767] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[848.847891] [126/131] (179s left) kms_vrr (lobf)
[848.945647] Starting subtest: lobf
[848.950055] Subtest lobf: SKIP (0.000s)
[849.023959] [127/131] (179s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[849.116011] Starting subtest: plane-primary-toggle-with-vblank-wait
[849.118444] Starting dynamic subtest: pipe-A-eDP-1
[849.299230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.182s)
[849.617368] Starting dynamic subtest: pipe-B-eDP-1
[850.546024] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.939s)
[850.841471] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.725s)
[851.698565] [128/131] (176s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[851.749018] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[851.750967] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[851.860192] [129/131] (176s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[851.959010] Starting subtest: yf-tiled-32bpp-rotate-90
[851.963114] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[852.045956] [130/131] (176s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[852.151057] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[852.155328] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[852.263232] [131/131] (176s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[852.362323] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[859.265043] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.902s)
[859.370870] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_readwrite
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cdclk
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_joiner
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_ctx_isolation
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: gem_mmap_offset
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: gem_sync
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: kms_prop_blob
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_legacy_colorkey
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: fbdev
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_dp_link_training
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_barrier_race
results: parsing output: 45/ for test: sysfs_defaults
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_exercise_blt
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_pwrite
results: parsing output: 55/ for test: kms_getfb
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_setmode
results: parsing output: 58/ for test: i915_pm_rpm
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_lease
results: parsing output: 62/ for test: gen3_mixed_blits
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_getfb
results: parsing output: 65/ for test: prime_busy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_chamelium_color
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: gem_sync
results: parsing output: 77/ for test: gem_userptr_blits
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_pm_dc
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: kms_busy
results: parsing output: 83/ for test: kms_plane_multiple
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: kms_sequence
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_exec_suspend
results: parsing output: 89/ for test: syncobj_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: gem_tiled_swapping
results: parsing output: 93/ for test: kms_busy
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: i915_selftest
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_universal_plane
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: core_hotunplug
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_chamelium_frames
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_exec_nop
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: kms_dsc
results: parsing output: 125/ for test: kms_vrr
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.