[60.841682] Initializing watchdogs
[60.841766]   /dev/watchdog0
[60.855911] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.860264] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.862803] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.866114] [001/134] (960s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[60.992822] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[60.995082] Starting dynamic subtest: pipe-A-eDP-1
[61.017876] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.026931] Starting dynamic subtest: pipe-B-eDP-1
[61.048603] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.055746] Starting dynamic subtest: pipe-C-eDP-1
[61.077563] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.085196] Starting dynamic subtest: pipe-D-eDP-1
[61.107195] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.111747] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[63.413055] [002/134] (957s left) gem_mmap_gtt (basic-small-bo-tiledy)
[63.469205] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[63.533148] [003/134] (957s left) kms_pm_rpm (universal-planes-dpms)
[65.093399] Starting subtest: universal-planes-dpms
[65.095605] Starting dynamic subtest: plane-34
[73.584781] Dynamic subtest plane-34: SUCCESS (8.481s)
[73.594530] Starting dynamic subtest: plane-64
[82.007602] Dynamic subtest plane-64: SUCCESS (8.419s)
[82.016766] Starting dynamic subtest: plane-94
[90.617531] Dynamic subtest plane-94: SUCCESS (8.605s)
[90.627247] Starting dynamic subtest: plane-124
[98.935064] Dynamic subtest plane-124: SUCCESS (8.314s)
[98.945409] Starting dynamic subtest: plane-134
[107.599053] Dynamic subtest plane-134: SUCCESS (8.662s)
[107.608526] Starting dynamic subtest: plane-144
[116.168828] Dynamic subtest plane-144: SUCCESS (8.566s)
[116.171819] Subtest universal-planes-dpms: SUCCESS (51.054s)
[116.560212] [004/134] (904s left) kms_async_flips (alternate-sync-async-flip)
[116.652245] Starting subtest: alternate-sync-async-flip
[117.028336] Starting dynamic subtest: pipe-A-eDP-1
[119.828058] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.800s)
[120.224578] Starting dynamic subtest: pipe-B-eDP-1
[122.968237] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.750s)
[123.343114] Starting dynamic subtest: pipe-C-eDP-1
[126.107785] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s)
[126.479379] Starting dynamic subtest: pipe-D-eDP-1
[129.240779] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[129.242809] Subtest alternate-sync-async-flip: SUCCESS (12.587s)
[130.414177] [005/134] (891s left) drm_read (empty-nonblock)
[130.570583] Starting subtest: empty-nonblock
[130.572815] Subtest empty-nonblock: SUCCESS (0.000s)
[130.728164] [006/134] (890s left) sysfs_timeslice_duration (invalid)
[130.798619] Starting subtest: invalid
[130.800951] Starting dynamic subtest: vecs0
[130.803273] Dynamic subtest vecs0: SUCCESS (0.000s)
[130.809752] Starting dynamic subtest: ccs0
[130.811623] Dynamic subtest ccs0: SUCCESS (0.000s)
[130.817811] Starting dynamic subtest: vcs0
[130.819719] Dynamic subtest vcs0: SUCCESS (0.000s)
[130.825904] Starting dynamic subtest: bcs0
[130.827830] Dynamic subtest bcs0: SUCCESS (0.000s)
[130.833933] Starting dynamic subtest: rcs0
[130.835856] Dynamic subtest rcs0: SUCCESS (0.000s)
[130.842273] Starting dynamic subtest: vcs1
[130.844181] Dynamic subtest vcs1: SUCCESS (0.000s)
[130.846059] Subtest invalid: SUCCESS (0.004s)
[130.916656] [007/134] (890s left) kms_psr (pr-cursor-render)
[131.018129] Starting subtest: pr-cursor-render
[131.022369] Subtest pr-cursor-render: SKIP (0.000s)
[131.101108] [008/134] (890s left) gem_wait (write-busy)
[131.173800] Starting subtest: write-busy
[131.176555] Starting dynamic subtest: all-engines
[131.818756] Dynamic subtest all-engines: SUCCESS (0.644s)
[131.834676] Starting dynamic subtest: rcs0
[132.370701] Dynamic subtest rcs0: SUCCESS (0.550s)
[132.385171] Starting dynamic subtest: bcs0
[132.917641] Dynamic subtest bcs0: SUCCESS (0.546s)
[132.930458] Starting dynamic subtest: vcs0
[134.932957] Dynamic subtest vcs0: SUCCESS (2.013s)
[134.946238] Starting dynamic subtest: vcs1
[136.916949] Dynamic subtest vcs1: SUCCESS (1.982s)
[136.931369] Starting dynamic subtest: vecs0
[138.901030] Dynamic subtest vecs0: SUCCESS (1.982s)
[138.914781] Starting dynamic subtest: ccs0
[139.451330] Dynamic subtest ccs0: SUCCESS (0.550s)
[139.453801] Subtest write-busy: SUCCESS (8.277s)
[139.655380] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[139.658450] [009/134] (882s left) gem_fence_thrash (bo-copy)
[139.699679] Starting subtest: bo-copy
[139.722760] Subtest bo-copy: SKIP (0.020s)
[139.784457] [010/134] (881s left) gem_softpin (evict-active)
[139.838611] Starting subtest: evict-active
[139.848110] Subtest evict-active: SUCCESS (0.010s)
[140.016804] [011/134] (881s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[140.120458] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[140.124740] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[140.222662] [012/134] (881s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[140.324835] Starting subtest: plane-lut1d-ctm3x4-lut1d
[140.337977] Starting dynamic subtest: pipe-A-eDP-1
[140.988194] Dynamic subtest pipe-A-eDP-1: FAIL (0.315s)
[141.678824] Starting dynamic subtest: pipe-B-eDP-1
[142.506519] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[143.007738] Starting dynamic subtest: pipe-C-eDP-1
[143.840304] Dynamic subtest pipe-C-eDP-1: FAIL (0.251s)
[144.348232] Starting dynamic subtest: pipe-D-eDP-1
[145.211441] Dynamic subtest pipe-D-eDP-1: FAIL (0.280s)
[145.213375] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.595s)
[145.741458] [013/134] (876s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[145.839133] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[145.843310] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[145.954203] [014/134] (875s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[146.049060] Starting subtest: plane-primary-overlay-mutable-zpos
[149.454974] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.405s)
[150.657106] [015/134] (871s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[150.769711] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[150.774255] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[150.897161] [016/134] (871s left) kms_cursor_crc (cursor-sliding-32x10)
[151.047968] Starting subtest: cursor-sliding-32x10
[151.103360] Subtest cursor-sliding-32x10: SKIP (0.050s)
[151.397329] [017/134] (870s left) gem_softpin (overlap)
[151.461827] Starting subtest: overlap
[152.315252] Subtest overlap: SUCCESS (0.852s)
[152.447506] [018/134] (869s left) gem_mmap_gtt (isolation)
[152.510473] Subtest isolation: SKIP (0.000s)
[152.573512] [019/134] (869s left) syncobj_timeline (wait-all-delayed-signal)
[152.637272] Starting subtest: wait-all-delayed-signal
[152.741104] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[152.826827] [020/134] (869s left) gem_exec_balancer (hang)
[153.094101] Starting subtest: hang
[154.884471] Subtest hang: SUCCESS (1.791s)
[155.032275] [021/134] (867s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[155.129117] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[156.118143] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.991s)
[156.282423] [022/134] (865s left) kms_plane (plane-panning-bottom-right-suspend)
[156.371058] Starting subtest: plane-panning-bottom-right-suspend
[156.372931] Starting dynamic subtest: pipe-A
[174.704758] Dynamic subtest pipe-A: SUCCESS (3.273s)
[174.714552] Starting dynamic subtest: pipe-B
[193.450949] Dynamic subtest pipe-B: SUCCESS (3.398s)
[193.453199] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.674s)
[194.275327] [023/134] (827s left) api_intel_bb (object-reloc-keep-cache)
[194.347256] Starting subtest: object-reloc-keep-cache
[194.351655] Subtest object-reloc-keep-cache: SKIP (0.003s)
[194.510974] [024/134] (827s left) gem_exec_schedule (u-semaphore-codependency)
[194.593196] Starting subtest: u-semaphore-codependency
[194.598604] Subtest u-semaphore-codependency: SUCCESS (0.012s)
[194.968433] [025/134] (827s left) kms_vblank (wait-forked-busy-hang)
[195.068907] Starting subtest: wait-forked-busy-hang
[195.070805] Starting dynamic subtest: pipe-A-eDP-1
[223.027244] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.780s)
[223.041074] Starting dynamic subtest: pipe-D-eDP-1
[237.977426] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.949s)
[237.979376] Subtest wait-forked-busy-hang: SUCCESS (42.733s)
[238.835801] [026/134] (783s left) kms_lease (invalid-create-leases)
[238.934723] Starting subtest: invalid-create-leases
[238.937647] Subtest invalid-create-leases: SUCCESS (0.005s)
[239.058885] [027/134] (783s left) gem_userptr_blits (stress-mm)
[239.128763] Starting subtest: stress-mm
[244.550896] Subtest stress-mm: SUCCESS (5.369s)
[244.659122] [028/134] (777s left) kms_chamelium_frames (dp-crc-fast)
[245.045097] Subtest dp-crc-fast: SKIP (0.000s)
[245.835081] [029/134] (776s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[245.896715] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[246.003827] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[246.093093] [030/134] (776s left) gem_softpin (evict-prime)
[246.153199] Starting subtest: evict-prime
[246.155561] Starting dynamic subtest: rcs0
[247.350017] Dynamic subtest rcs0: SUCCESS (1.196s)
[247.362324] Starting dynamic subtest: bcs0
[248.513258] Dynamic subtest bcs0: SUCCESS (1.161s)
[248.524855] Starting dynamic subtest: vcs0
[250.276199] Dynamic subtest vcs0: SUCCESS (1.760s)
[250.287557] Starting dynamic subtest: vcs1
[252.243182] Dynamic subtest vcs1: SUCCESS (1.964s)
[252.254501] Starting dynamic subtest: vecs0
[254.254091] Dynamic subtest vecs0: SUCCESS (2.008s)
[254.265447] Starting dynamic subtest: ccs0
[255.389590] Dynamic subtest ccs0: SUCCESS (1.135s)
[255.400777] Starting dynamic subtest: all
[257.269844] Dynamic subtest all: SUCCESS (1.876s)
[257.272690] Subtest evict-prime: SUCCESS (11.114s)
[257.363373] [031/134] (765s left) gem_render_copy (y-tiled-ccs-to-linear)
[257.425531] Starting subtest: y-tiled-ccs-to-linear
[257.429956] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[257.623677] [032/134] (764s left) gem_ctx_sseu (invalid-args)
[257.683933] Subtest invalid-args: SKIP (0.000s)
[257.752115] [033/134] (764s left) template (b)
[257.810256] Starting subtest: B
[257.812569] Subtest B: SUCCESS (0.000s)
[257.932524] [034/134] (764s left) perf_pmu (all-busy-check-all)
[257.973694] Starting subtest: all-busy-check-all
[259.225262] Subtest all-busy-check-all: SUCCESS (1.252s)
[259.349172] [035/134] (763s left) kms_cursor_crc (cursor-alpha-transparent)
[259.446712] Starting subtest: cursor-alpha-transparent
[259.448916] Starting dynamic subtest: pipe-A-eDP-1
[260.055286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[260.064797] Starting dynamic subtest: pipe-D-eDP-1
[261.316262] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[261.318261] Subtest cursor-alpha-transparent: SUCCESS (1.870s)
[262.136498] [036/134] (760s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[262.237888] Starting subtest: psr-rgb565-draw-blt
[269.253023] Subtest psr-rgb565-draw-blt: SUCCESS (7.015s)
[269.437049] [037/134] (753s left) kms_hdr (bpc-switch)
[269.549391] Starting subtest: bpc-switch
[270.596075] Starting dynamic subtest: pipe-A-eDP-1
[274.096537] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s)
[274.098830] Subtest bpc-switch: SUCCESS (4.549s)
[274.241541] [038/134] (748s left) gem_userptr_blits (map-fixed-invalidate-busy)
[274.298243] Starting subtest: map-fixed-invalidate-busy
[274.302882] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[274.462568] [039/134] (748s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[274.521150] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[274.523092] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[274.641710] [040/134] (748s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[274.736862] Starting subtest: yf-tiled-64bpp-rotate-270
[274.741341] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[274.860008] [041/134] (748s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[274.953814] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[274.979098] Starting dynamic subtest: pipe-A-plane-0
[274.983488] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[274.993975] Starting dynamic subtest: pipe-A-plane-3
[274.998309] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[275.006732] Starting dynamic subtest: pipe-A-plane-5
[275.010706] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[276.037797] Starting dynamic subtest: pipe-B-plane-0
[276.041917] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[276.050249] Starting dynamic subtest: pipe-B-plane-3
[276.054595] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[276.062880] Starting dynamic subtest: pipe-B-plane-5
[276.067062] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[276.359798] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (1.404s)
[277.224180] [042/134] (745s left) kms_flip (dpms-off-confusion)
[277.329892] Starting subtest: dpms-off-confusion
[277.332152] Starting dynamic subtest: A-eDP1
[286.058998] Dynamic subtest A-eDP1: SUCCESS (8.690s)
[286.071053] Starting dynamic subtest: B-eDP1
[294.681853] Dynamic subtest B-eDP1: SUCCESS (8.648s)
[294.694288] Starting dynamic subtest: C-eDP1
[303.349329] Dynamic subtest C-eDP1: SUCCESS (8.632s)
[303.360662] Starting dynamic subtest: D-eDP1
[312.028628] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[312.034104] Subtest dpms-off-confusion: SUCCESS (34.707s)
[313.289131] [043/134] (709s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[313.383882] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[320.613480] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.231s)
[320.756978] [044/134] (702s left) prime_self_import (basic-llseek-bad)
[320.802446] Starting subtest: basic-llseek-bad
[320.814469] Subtest basic-llseek-bad: SUCCESS (0.013s)
[320.948345] [045/134] (702s left) gem_ctx_param (invalid-get-no-zeromap)
[321.000768] Starting subtest: invalid-get-no-zeromap
[321.003526] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[321.129636] [046/134] (702s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[321.272504] Starting subtest: cursor-rapid-movement-32x32
[321.318957] Subtest cursor-rapid-movement-32x32: SKIP (0.041s)
[321.615902] [047/134] (701s left) gem_exec_fence (syncobj-timeline-signal)
[322.196427] Starting subtest: syncobj-timeline-signal
[322.202786] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[323.365282] [048/134] (699s left) kms_cursor_legacy (torture-move)
[323.480077] Starting subtest: torture-move
[323.482332] Starting dynamic subtest: pipe-A
[329.709796] Dynamic subtest pipe-A: SUCCESS (6.173s)
[329.719026] Starting dynamic subtest: pipe-B
[335.285563] Dynamic subtest pipe-B: SUCCESS (5.626s)
[335.297102] Starting dynamic subtest: pipe-C
[341.152711] Dynamic subtest pipe-C: SUCCESS (5.864s)
[341.167197] Starting dynamic subtest: pipe-D
[347.666038] Dynamic subtest pipe-D: SUCCESS (6.508s)
[347.677965] Starting dynamic subtest: all-pipes
[354.428079] Dynamic subtest all-pipes: SUCCESS (6.758s)
[354.430665] Subtest torture-move: SUCCESS (30.942s)
[354.597220] [049/134] (668s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[354.693613] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[354.695722] Starting dynamic subtest: pipe-A-default-mode
[354.995333] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[354.999728] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.300s)
[355.852343] [050/134] (667s left) gen9_exec_parse (bb-start-cmd)
[355.916472] Subtest bb-start-cmd: SKIP (0.000s)
[355.985728] [051/134] (667s left) gem_partial_pwrite_pread (reads)
[356.045457] Subtest reads: SKIP (0.000s)
[356.128766] [052/134] (667s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[356.256952] Starting subtest: basic-flip-after-cursor-varying-size
[357.176932] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.922s)
[357.986563] [053/134] (665s left) kms_chamelium_hpd (vga-hpd)
[358.401671] Subtest vga-hpd: SKIP (0.000s)
[359.182540] [054/134] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[359.285800] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[359.290025] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[359.408964] [055/134] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[359.508128] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[359.512506] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[359.621894] [056/134] (663s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[359.674873] Starting subtest: single-wait-for-submit-unsubmitted
[359.779510] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[359.869053] [057/134] (663s left) gem_userptr_blits (map-fixed-invalidate)
[359.944163] Starting subtest: map-fixed-invalidate
[359.948432] Subtest map-fixed-invalidate: SKIP (0.000s)
[360.090102] [058/134] (663s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[360.145951] Subtest writes-after-reads: SKIP (0.000s)
[360.229511] [059/134] (663s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[360.321857] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[360.347725] Starting dynamic subtest: pipe-A-plane-0
[360.636460] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[360.645416] Starting dynamic subtest: pipe-A-plane-3
[360.869517] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[360.878337] Starting dynamic subtest: pipe-A-plane-5
[360.881804] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[361.994389] Starting dynamic subtest: pipe-B-plane-0
[362.309361] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s)
[362.319104] Starting dynamic subtest: pipe-B-plane-3
[362.542588] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[362.551814] Starting dynamic subtest: pipe-B-plane-5
[362.556422] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[362.862112] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.540s)
[363.687046] [060/134] (660s left) gem_lmem_swapping (parallel-random)
[363.733591] Subtest parallel-random: SKIP (0.000s)
[363.774823] [061/134] (659s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[363.864510] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[363.866725] Starting dynamic subtest: pipe-A-default-mode
[364.151108] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[364.155499] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.286s)
[365.010735] [062/134] (658s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[365.117705] Starting subtest: fbcpsr-tiling-y
[365.121929] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[365.249331] [063/134] (658s left) gem_ctx_param (set-priority-range)
[365.303632] Starting subtest: set-priority-range
[365.319077] Subtest set-priority-range: SUCCESS (0.016s)
[365.452411] [064/134] (658s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[365.562845] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[372.858511] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.295s)
[373.019663] [065/134] (650s left) prime_vgem (basic-fence-blt)
[373.119693] Starting subtest: basic-fence-blt
[373.197840] Subtest basic-fence-blt: SUCCESS (0.078s)
[373.357864] [066/134] (650s left) testdisplay
[373.683994] [067/134] (650s left) i915_selftest (live)
[377.139986] Starting subtest: live
[377.142617] Starting dynamic subtest: sanitycheck
[381.564355] Dynamic subtest sanitycheck: SUCCESS (4.423s)
[381.573795] Starting dynamic subtest: uncore
[386.136842] Dynamic subtest uncore: SUCCESS (4.569s)
[386.150353] Starting dynamic subtest: workarounds
[389.454702] Dynamic subtest workarounds: SUCCESS (3.314s)
[389.464402] Starting dynamic subtest: gt_engines
[394.116656] Dynamic subtest gt_engines: SUCCESS (4.658s)
[394.125831] Starting dynamic subtest: gt_timelines
[410.078724] Dynamic subtest gt_timelines: SUCCESS (15.955s)
[410.087653] Starting dynamic subtest: gt_contexts
[414.602215] Dynamic subtest gt_contexts: SUCCESS (4.519s)
[414.612439] Starting dynamic subtest: gt_lrc
[419.017084] Dynamic subtest gt_lrc: SUCCESS (4.413s)
[419.026703] Starting dynamic subtest: gt_mocs
[422.028812] Dynamic subtest gt_mocs: SUCCESS (3.011s)
[422.036342] Starting dynamic subtest: gt_pm
[428.962981] Dynamic subtest gt_pm: SUCCESS (6.934s)
[428.977848] Starting dynamic subtest: gt_heartbeat
[433.456197] Dynamic subtest gt_heartbeat: SUCCESS (4.492s)
[433.466152] Starting dynamic subtest: gt_tlb
[442.913908] Dynamic subtest gt_tlb: SUCCESS (9.457s)
[442.923681] Starting dynamic subtest: requests
[456.813372] Dynamic subtest requests: SUCCESS (13.898s)
[456.822787] Starting dynamic subtest: migrate
[462.973392] Dynamic subtest migrate: SUCCESS (6.158s)
[462.983299] Starting dynamic subtest: active
[467.414911] Dynamic subtest active: SUCCESS (4.439s)
[467.425777] Starting dynamic subtest: objects
[472.208361] Dynamic subtest objects: SUCCESS (4.791s)
[472.218208] Starting dynamic subtest: mman
[477.259975] Dynamic subtest mman: SUCCESS (5.049s)
[477.269857] Starting dynamic subtest: dmabuf
[481.686029] Dynamic subtest dmabuf: SUCCESS (4.424s)
[481.695479] Starting dynamic subtest: vma
[486.164217] Dynamic subtest vma: SUCCESS (4.476s)
[486.173720] Starting dynamic subtest: coherency
[491.299123] Dynamic subtest coherency: SUCCESS (5.133s)
[491.309170] Starting dynamic subtest: gtt
[503.409362] Dynamic subtest gtt: SUCCESS (12.107s)
[503.418939] Starting dynamic subtest: gem
[511.119466] Dynamic subtest gem: SUCCESS (7.708s)
[511.135090] Starting dynamic subtest: evict
[515.231311] Dynamic subtest evict: SUCCESS (4.108s)
[515.240429] Starting dynamic subtest: hugepages
[524.435962] Dynamic subtest hugepages: SUCCESS (9.202s)
[524.450557] Starting dynamic subtest: gem_contexts
[553.381183] Dynamic subtest gem_contexts: SUCCESS (28.939s)
[553.390546] Starting dynamic subtest: client
[556.308564] Dynamic subtest client: SUCCESS (2.926s)
[556.318475] Starting dynamic subtest: gem_migrate
[560.771656] Dynamic subtest gem_migrate: SUCCESS (4.461s)
[560.781846] Starting dynamic subtest: reset
[563.648820] Dynamic subtest reset: SUCCESS (2.874s)
[563.659164] Starting dynamic subtest: memory_region
[568.139798] Dynamic subtest memory_region: SUCCESS (4.488s)
[568.148903] Starting dynamic subtest: hangcheck
[581.350131] Dynamic subtest hangcheck: SUCCESS (13.205s)
[581.364873] Starting dynamic subtest: execlists
[585.791661] Dynamic subtest execlists: SUCCESS (4.439s)
[585.801531] Starting dynamic subtest: ring_submission
[590.272759] Dynamic subtest ring_submission: SUCCESS (4.478s)
[590.282543] Starting dynamic subtest: perf
[594.774648] Dynamic subtest perf: SUCCESS (4.491s)
[594.785642] Starting dynamic subtest: slpc
[606.990730] Dynamic subtest slpc: SUCCESS (12.219s)
[607.000677] Starting dynamic subtest: guc
[611.051329] Dynamic subtest guc: SUCCESS (4.057s)
[611.061026] Starting dynamic subtest: guc_multi_lrc
[615.500200] Dynamic subtest guc_multi_lrc: SUCCESS (4.446s)
[615.509472] Starting dynamic subtest: guc_hang
[620.583299] Dynamic subtest guc_hang: SUCCESS (5.079s)
[620.592931] Starting dynamic subtest: late_gt_pm
[625.118317] Dynamic subtest late_gt_pm: SUCCESS (4.532s)
[625.120993] Subtest live: SUCCESS (247.952s)
[625.147700] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[625.148433] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[625.151687] [068/134] (398s left) kms_getfb (getfb-addfb-different-handles)
[626.761872] Starting subtest: getfb-addfb-different-handles
[626.764373] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[626.840670] [FACT kms_getfb (getfb-addfb-different-handles)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[626.841850] [FACT kms_getfb (getfb-addfb-different-handles)] new: kernel.kmod_is_loaded.i915: true
[626.845757] [069/134] (397s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[626.903899] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[626.973499] [070/134] (397s left) prime_mmap_coherency (write)
[627.035470] Starting subtest: write
[632.480419] Subtest write: SUCCESS (5.392s)
[632.599732] [071/134] (391s left) api_intel_allocator (reserve-simple)
[632.659106] Starting subtest: reserve-simple
[632.666878] Subtest reserve-simple: SUCCESS (0.010s)
[632.837448] [072/134] (391s left) gem_exec_big (single)
[632.890563] Starting subtest: single
[635.566341] Subtest single: SUCCESS (2.675s)
[635.795199] [073/134] (388s left) core_hotunplug (unbind-rebind)
[635.936666] Starting subtest: unbind-rebind
[642.122551] Subtest unbind-rebind: SUCCESS (6.186s)
[642.158846] [074/134] (382s left) kms_properties (plane-properties-atomic)
[643.243098] Starting subtest: plane-properties-atomic
[643.245372] Starting dynamic subtest: pipe-A-eDP-1
[643.848136] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[643.857970] Starting dynamic subtest: pipe-B-eDP-1
[645.087678] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.239s)
[645.098900] Starting dynamic subtest: pipe-C-eDP-1
[646.324364] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[646.337235] Starting dynamic subtest: pipe-D-eDP-1
[647.561307] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[647.563468] Subtest plane-properties-atomic: SUCCESS (4.319s)
[648.371044] [075/134] (375s left) i915_pm_freq_api (freq-reset)
[648.442668] Starting subtest: freq-reset
[648.444713] Starting dynamic subtest: gt0
[648.588991] Dynamic subtest gt0: SUCCESS (0.149s)
[648.603796] Starting dynamic subtest: gt1
[648.721783] Dynamic subtest gt1: SUCCESS (0.130s)
[648.724834] Subtest freq-reset: SUCCESS (0.281s)
[648.808039] [076/134] (375s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[648.919934] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[648.924212] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[649.067705] [077/134] (375s left) kms_pm_rpm (cursor-dpms)
[650.600077] Starting subtest: cursor-dpms
[650.605166] Subtest cursor-dpms: SKIP (0.000s)
[651.318056] [078/134] (373s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[651.411994] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[651.416218] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[651.551803] [079/134] (372s left) kms_universal_plane (universal-plane-pageflip-windowed)
[651.653164] Starting subtest: universal-plane-pageflip-windowed
[651.655623] Starting dynamic subtest: pipe-A-eDP-1
[652.233360] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[652.243418] Starting dynamic subtest: pipe-B-eDP-1
[653.426733] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.189s)
[653.438757] Starting dynamic subtest: pipe-C-eDP-1
[654.638242] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[654.650111] Starting dynamic subtest: pipe-D-eDP-1
[655.878507] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[655.880926] Subtest universal-plane-pageflip-windowed: SUCCESS (4.224s)
[656.731550] [080/134] (367s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[656.837994] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[656.840267] Starting dynamic subtest: pipe-A-eDP-1
[656.861222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[656.871952] Starting dynamic subtest: pipe-B-eDP-1
[656.891926] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[656.900985] Starting dynamic subtest: pipe-C-eDP-1
[656.921583] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[656.930925] Starting dynamic subtest: pipe-D-eDP-1
[656.951182] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[656.953467] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.009s)
[659.095433] [081/134] (365s left) gem_exec_params (secure-non-master)
[659.160207] Starting subtest: secure-non-master
[659.164823] Subtest secure-non-master: SKIP (0.000s)
[659.281860] [082/134] (365s left) gem_pwrite (basic-random)
[659.341456] Subtest basic-random: SKIP (0.000s)
[659.411790] [083/134] (365s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[659.507639] Starting subtest: fbcpsr-shrfb-scaledprimary
[665.297136] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.791s)
[665.467162] [084/134] (359s left) gem_workarounds (basic-read-context)
[665.553327] Starting subtest: basic-read-context
[665.561609] Subtest basic-read-context: SUCCESS (0.011s)
[665.724147] [085/134] (359s left) kms_flip (2x-nonexisting-fb-interruptible)
[665.818731] Starting subtest: 2x-nonexisting-fb-interruptible
[665.829782] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[665.919146] [086/134] (358s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[666.007797] Starting subtest: random-ccs-data-yf-tiled-ccs
[666.010025] Starting dynamic subtest: pipe-A-eDP-1
[666.036232] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[666.052635] Starting dynamic subtest: pipe-B-eDP-1
[666.077070] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[666.087905] Starting dynamic subtest: pipe-C-eDP-1
[666.111927] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[666.121862] Starting dynamic subtest: pipe-D-eDP-1
[666.147629] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[666.152303] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[668.297947] [087/134] (356s left) gem_userptr_blits (sync-unmap-cycles)
[668.379150] Starting subtest: sync-unmap-cycles
[673.754609] Subtest sync-unmap-cycles: SUCCESS (5.375s)
[673.932432] [088/134] (350s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[674.060263] Starting subtest: extended-pageflip-modeset-hang-oldfb
[674.062218] Starting dynamic subtest: pipe-A
[681.973138] Dynamic subtest pipe-A: SUCCESS (7.912s)
[681.983704] Starting dynamic subtest: pipe-D
[690.591299] Dynamic subtest pipe-D: SUCCESS (8.618s)
[690.593518] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.534s)
[691.445953] [089/134] (333s left) vgem_basic (unload)
[691.487701] Starting subtest: unload
[720.679918] Subtest unload: SUCCESS (29.199s)
[720.790668] [090/134] (304s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[720.900377] Starting subtest: y-tiled-64bpp-rotate-180
[720.904468] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[721.022899] [091/134] (303s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[721.104597] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[721.106956] Starting dynamic subtest: pipe-A-eDP-1
[721.127373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[721.139805] Starting dynamic subtest: pipe-B-eDP-1
[721.158801] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[721.168346] Starting dynamic subtest: pipe-C-eDP-1
[721.187871] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[721.198161] Starting dynamic subtest: pipe-D-eDP-1
[721.218183] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[721.220592] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[723.401138] [092/134] (301s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[728.442410] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[728.447122] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[729.321156] [093/134] (295s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[729.398203] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[729.473319] [094/134] (295s left) kms_dsc (dsc-fractional-bpp)
[729.582802] Starting subtest: dsc-fractional-bpp
[729.596809] Subtest dsc-fractional-bpp: SKIP (0.000s)
[729.669043] [095/134] (295s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[729.767121] Starting subtest: stress-xrgb8888-xtiled
[735.646626] Subtest stress-xrgb8888-xtiled: SUCCESS (5.880s)
[735.699264] [096/134] (289s left) gem_userptr_blits (unsync-unmap-cycles)
[735.762799] Subtest unsync-unmap-cycles: SKIP (0.000s)
[735.892016] [097/134] (289s left) kms_psr (fbc-psr-cursor-plane-move)
[735.982231] Starting subtest: fbc-psr-cursor-plane-move
[735.984284] Starting dynamic subtest: eDP-1
[735.988023] Dynamic subtest eDP-1: SKIP (0.000s)
[735.991559] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[736.080612] [098/134] (289s left) gem_ctx_persistence (heartbeat-hostile)
[736.146629] Starting subtest: heartbeat-hostile
[736.150347] Subtest heartbeat-hostile: SKIP (0.000s)
[736.266326] [099/134] (289s left) kms_big_fb (linear-8bpp-rotate-0)
[736.370366] Starting subtest: linear-8bpp-rotate-0
[737.683942] Subtest linear-8bpp-rotate-0: SUCCESS (1.313s)
[737.808785] [100/134] (287s left) perf_pmu (busy-idle)
[737.845698] Starting subtest: busy-idle
[737.847697] Starting dynamic subtest: rcs0
[738.532387] Dynamic subtest rcs0: SUCCESS (0.687s)
[738.544611] Starting dynamic subtest: bcs0
[739.198406] Dynamic subtest bcs0: SUCCESS (0.664s)
[739.210689] Starting dynamic subtest: vcs0
[741.271778] Dynamic subtest vcs0: SUCCESS (2.070s)
[741.284674] Starting dynamic subtest: vcs1
[743.255760] Dynamic subtest vcs1: SUCCESS (1.981s)
[743.268416] Starting dynamic subtest: vecs0
[745.240175] Dynamic subtest vecs0: SUCCESS (1.981s)
[745.251806] Starting dynamic subtest: ccs0
[745.915308] Dynamic subtest ccs0: SUCCESS (0.674s)
[745.917925] Subtest busy-idle: SUCCESS (8.071s)
[746.052896] [101/134] (279s left) kms_rotation_crc (exhaust-fences)
[746.154584] Starting subtest: exhaust-fences
[746.158934] Subtest exhaust-fences: SKIP (0.000s)
[746.239649] [102/134] (279s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[746.338654] Starting subtest: fbc-psr2-cursor-plane-onoff
[746.340928] Starting dynamic subtest: eDP-1
[746.345096] Dynamic subtest eDP-1: SKIP (0.000s)
[746.349467] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[746.424176] [103/134] (279s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[746.529372] Starting subtest: 4-tiled-addfb-size-offset-overflow
[746.531330] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[746.638315] [104/134] (278s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[746.727614] Starting subtest: plane-upscale-20x20-with-rotation
[746.729850] Starting dynamic subtest: pipe-A
[746.951604] Dynamic subtest pipe-A: SUCCESS (0.227s)
[746.961217] Starting dynamic subtest: pipe-B
[748.288744] Dynamic subtest pipe-B: SUCCESS (1.336s)
[748.300818] Starting dynamic subtest: pipe-C
[749.616557] Dynamic subtest pipe-C: SUCCESS (1.327s)
[749.628251] Starting dynamic subtest: pipe-D
[750.943810] Dynamic subtest pipe-D: SUCCESS (1.327s)
[750.946230] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.220s)
[752.118541] [105/134] (273s left) syncobj_timeline (multi-wait-all-available-submitted)
[752.176383] Starting subtest: multi-wait-all-available-submitted
[752.178611] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[752.283893] [106/134] (273s left) gem_exec_reloc (basic-wc-cpu)
[752.341467] Subtest basic-wc-cpu: SKIP (0.000s)
[752.441101] [107/134] (273s left) kms_invalid_mode (clock-too-high)
[752.537970] Starting subtest: clock-too-high
[752.540247] Starting dynamic subtest: pipe-A-eDP-1
[752.544959] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[752.555256] Starting dynamic subtest: pipe-B-eDP-1
[752.559723] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[752.569505] Starting dynamic subtest: pipe-C-eDP-1
[752.573633] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[752.584868] Starting dynamic subtest: pipe-D-eDP-1
[752.589148] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[752.593392] Subtest clock-too-high: SKIP (0.004s)
[752.630934] [108/134] (273s left) gem_exec_whisper (basic-fds-forked-all)
[752.697232] Starting subtest: basic-fds-forked-all
[774.203500] Subtest basic-fds-forked-all: SUCCESS (21.504s)
[774.395524] [109/134] (251s left) gem_ringfill (legacy-basic)
[780.249800] Starting subtest: legacy-basic
[780.252428] Starting dynamic subtest: default
[780.325063] Dynamic subtest default: SUCCESS (0.075s)
[780.338721] Starting dynamic subtest: render
[780.367587] Dynamic subtest render: SUCCESS (0.041s)
[780.381126] Starting dynamic subtest: bsd
[780.410612] Dynamic subtest bsd: SUCCESS (0.040s)
[780.421230] Starting dynamic subtest: bsd1
[780.450952] Dynamic subtest bsd1: SUCCESS (0.038s)
[780.463632] Starting dynamic subtest: bsd2
[780.493705] Dynamic subtest bsd2: SUCCESS (0.041s)
[780.505609] Starting dynamic subtest: blt
[780.537464] Dynamic subtest blt: SUCCESS (0.041s)
[780.552986] Starting dynamic subtest: vebox
[780.579848] Dynamic subtest vebox: SUCCESS (0.040s)
[780.582338] Subtest legacy-basic: SUCCESS (0.333s)
[780.674457] [110/134] (245s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[780.779875] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[785.076356] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.299s)
[786.241766] [111/134] (239s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[786.304389] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[786.412354] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s)
[786.504098] [112/134] (239s left) kms_psr (psr-primary-render)
[786.603361] Starting subtest: psr-primary-render
[786.605828] Starting dynamic subtest: eDP-1
[788.326607] Dynamic subtest eDP-1: SUCCESS (1.724s)
[788.328913] Subtest psr-primary-render: SUCCESS (1.725s)
[789.203115] [113/134] (236s left) kms_properties (invalid-properties-legacy)
[789.296026] Starting subtest: invalid-properties-legacy
[789.402495] Subtest invalid-properties-legacy: SUCCESS (0.107s)
[789.487292] [114/134] (236s left) perf_pmu (render-node-busy)
[789.588924] Starting subtest: render-node-busy
[789.591102] Starting dynamic subtest: rcs0
[790.201309] Dynamic subtest rcs0: SUCCESS (0.615s)
[790.214219] Starting dynamic subtest: bcs0
[790.773392] Dynamic subtest bcs0: SUCCESS (0.570s)
[790.784722] Starting dynamic subtest: vcs0
[792.214982] Dynamic subtest vcs0: SUCCESS (1.438s)
[792.226771] Starting dynamic subtest: vcs1
[794.263764] Dynamic subtest vcs1: SUCCESS (2.045s)
[794.275815] Starting dynamic subtest: vecs0
[796.249928] Dynamic subtest vecs0: SUCCESS (1.983s)
[796.262827] Starting dynamic subtest: ccs0
[796.824038] Dynamic subtest ccs0: SUCCESS (0.573s)
[796.826617] Subtest render-node-busy: SUCCESS (7.239s)
[796.915538] [115/134] (229s left) fbdev (write)
[796.954672] Starting subtest: write
[797.605625] Subtest write: SUCCESS (0.650s)
[797.686877] [116/134] (228s left) gem_eio (in-flight-contexts-1us)
[797.902800] Starting subtest: in-flight-contexts-1us
[811.256622] Subtest in-flight-contexts-1us: SUCCESS (13.350s)
[811.448900] [117/134] (214s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[811.539055] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[811.541323] Starting dynamic subtest: pipe-A-eDP-1
[811.600284] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[811.611541] Starting dynamic subtest: pipe-B-eDP-1
[811.670126] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[811.680905] Starting dynamic subtest: pipe-C-eDP-1
[811.739384] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[811.750798] Starting dynamic subtest: pipe-D-eDP-1
[811.808139] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[811.812539] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[813.854906] [118/134] (212s left) kms_content_protection (atomic-dpms-hdcp14)
[814.006507] Starting subtest: atomic-dpms-hdcp14
[814.011248] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[814.141904] [119/134] (212s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[814.236057] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[814.238423] Starting dynamic subtest: pipe-A-default-mode
[817.029623] Dynamic subtest pipe-A-default-mode: SUCCESS (2.793s)
[817.032217] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.795s)
[817.834830] [120/134] (208s left) gem_pxp (verify-pxp-stale-ctx-execution)
[817.961321] Starting subtest: verify-pxp-stale-ctx-execution
[819.021794] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s)
[819.180145] [121/134] (207s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[819.286519] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[820.354235] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.067s)
[820.509511] [122/134] (205s left) gem_ccs (suspend-resume)
[820.564093] Starting subtest: suspend-resume
[820.567639] Subtest suspend-resume: SKIP (0.000s)
[820.687714] [123/134] (205s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[820.788094] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[820.791578] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[820.909934] [124/134] (205s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[820.970994] Starting subtest: stress-mm-invalidate-close-overlap
[823.120229] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[823.270130] [125/134] (203s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[828.381979] Starting subtest: psr2-plane-move-sf-dmg-area
[828.384404] Starting dynamic subtest: pipe-A-eDP-1
[833.694163] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.307s)
[833.706081] Starting dynamic subtest: pipe-B-eDP-1
[839.032386] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.337s)
[839.034685] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.649s)
[839.913103] [126/134] (186s left) i915_drm_fdinfo (virtual-busy)
[839.955420] Starting subtest: virtual-busy
[839.959436] Subtest virtual-busy: SKIP (0.000s)
[840.035627] [127/134] (186s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[845.073533] Starting subtest: psr2-overlay-plane-move-continuous-sf
[845.075807] Starting dynamic subtest: pipe-A-eDP-1
[851.755427] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.680s)
[851.769549] Starting dynamic subtest: pipe-B-eDP-1
[858.405395] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.644s)
[858.407823] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.332s)
[859.303088] [128/134] (167s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[859.403017] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[859.411459] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[859.546009] [129/134] (167s left) i915_pm_rpm (gem-mmap-type)
[861.475959] Starting subtest: gem-mmap-type
[861.478723] Starting dynamic subtest: wb-smem0
[864.974712] Dynamic subtest wb-smem0: SUCCESS (3.501s)
[864.985303] Starting dynamic subtest: wc-smem0
[868.132020] Dynamic subtest wc-smem0: SUCCESS (3.157s)
[868.142188] Starting dynamic subtest: uc-smem0
[871.276484] Dynamic subtest uc-smem0: SUCCESS (3.143s)
[871.278640] Subtest gem-mmap-type: SUCCESS (9.805s)
[871.400362] [130/134] (155s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[871.951891] Starting subtest: syncobj-timeline-multiple-ext-nodes
[871.954768] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[873.381925] [131/134] (153s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[873.434020] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[873.497019] [132/134] (153s left) kms_psr (psr2-primary-mmap-gtt)
[873.595248] Starting subtest: psr2-primary-mmap-gtt
[873.597654] Starting dynamic subtest: eDP-1
[875.027800] Dynamic subtest eDP-1: SKIP (1.429s)
[875.033108] Subtest psr2-primary-mmap-gtt: SKIP (1.430s)
[875.191378] [133/134] (151s left) kms_getfb (getfb-handle-valid)
[875.301230] Starting subtest: getfb-handle-valid
[875.303555] Subtest getfb-handle-valid: SUCCESS (0.000s)
[875.431960] [134/134] (151s left) gem_exec_schedule (preempt-other)
[875.508089] Starting subtest: preempt-other
[875.510492] Starting dynamic subtest: rcs0
[875.567779] Dynamic subtest rcs0: SUCCESS (0.069s)
[875.583285] Starting dynamic subtest: bcs0
[875.637412] Dynamic subtest bcs0: SUCCESS (0.069s)
[875.654909] Starting dynamic subtest: vcs0
[875.707877] Dynamic subtest vcs0: SUCCESS (0.068s)
[875.722759] Starting dynamic subtest: vcs1
[875.775480] Dynamic subtest vcs1: SUCCESS (0.067s)
[875.789755] Starting dynamic subtest: vecs0
[875.840785] Dynamic subtest vecs0: SUCCESS (0.065s)
[875.856419] Starting dynamic subtest: ccs0
[875.907811] Dynamic subtest ccs0: SUCCESS (0.066s)
[875.910973] Subtest preempt-other: SUCCESS (0.409s)
[877.412486] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: drm_read
results: parsing output: 5/ for test: sysfs_timeslice_duration
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_wait
results: parsing output: 8/ for test: gem_fence_thrash
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_color_pipeline
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_atomic
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: gem_softpin
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_plane
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_vblank
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_chamelium_frames
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_softpin
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: gem_ctx_sseu
results: parsing output: 32/ for test: template
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_hdr
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: prime_self_import
results: parsing output: 44/ for test: gem_ctx_param
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_exec_fence
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 58/ for test: kms_plane
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: prime_vgem
results: parsing output: 65/ for test: testdisplay
results: parsing output: 66/ for test: i915_selftest
results: parsing output: 67/ for test: kms_getfb
results: parsing output: 68/ for test: kms_pipe_b_c_ivb
results: parsing output: 69/ for test: prime_mmap_coherency
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: gem_exec_big
results: parsing output: 72/ for test: core_hotunplug
results: parsing output: 73/ for test: kms_properties
results: parsing output: 74/ for test: i915_pm_freq_api
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_pm_rpm
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_universal_plane
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: gem_pwrite
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_workarounds
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_busy
results: parsing output: 88/ for test: vgem_basic
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_dsc
results: parsing output: 94/ for test: kms_pipe_stress
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_rotation_crc
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: gem_ringfill
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: fbdev
results: parsing output: 115/ for test: gem_eio
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_content_protection
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_pxp
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_ccs
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: i915_pm_rpm
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: gem_mmap_wc
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_getfb
results: parsing output: 133/ for test: gem_exec_schedule
Done.