[56.981397] Initializing watchdogs
[56.981442]   /dev/watchdog0
[56.994589] [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.998804] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.001105] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.004462] [001/131] (960s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[57.133636] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[58.156404] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.022s)
[58.309909] [002/131] (959s left) gem_eio (in-flight-contexts-immediate)
[58.480066] Starting subtest: in-flight-contexts-immediate
[68.919042] Subtest in-flight-contexts-immediate: SUCCESS (10.440s)
[69.107520] [003/131] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[69.205304] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[69.209592] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[69.324427] [004/131] (948s left) kms_async_flips (crc)
[69.424831] Starting subtest: crc
[69.799704] Starting dynamic subtest: pipe-A-eDP-1
[72.691513] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.891s)
[73.065217] Starting dynamic subtest: pipe-B-eDP-1
[76.010842] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.954s)
[76.384871] Starting dynamic subtest: pipe-C-eDP-1
[79.223660] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.847s)
[79.603866] Starting dynamic subtest: pipe-D-eDP-1
[82.446061] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.857s)
[82.448512] Subtest crc: SUCCESS (13.022s)
[83.643197] [005/131] (934s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[83.744759] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[90.761631] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.021s)
[91.947278] [006/131] (925s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[92.059289] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[92.064084] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[93.166614] [007/131] (924s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[93.233897] Starting subtest: etime-single-wait-for-submit-submitted
[93.337090] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.101s)
[93.432137] [008/131] (924s left) kms_dp_link_training (uhbr-sst)
[93.529290] Starting subtest: uhbr-sst
[93.538071] Subtest uhbr-sst: SKIP (0.000s)
[93.622746] [009/131] (924s left) api_intel_bb (object-reloc-purge-cache)
[93.683847] Starting subtest: object-reloc-purge-cache
[93.690635] Subtest object-reloc-purge-cache: SKIP (0.003s)
[93.822367] [010/131] (924s left) kms_vblank (invalid)
[93.913051] Starting subtest: invalid
[93.915356] Starting dynamic subtest: pipe-A-eDP-1
[94.336090] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[94.338511] Subtest invalid: SUCCESS (0.421s)
[95.199152] [011/131] (922s left) gem_exec_schedule (submit-early-slice)
[95.274730] Starting subtest: submit-early-slice
[95.276997] Starting dynamic subtest: rcs0
[95.307994] Dynamic subtest rcs0: SUCCESS (0.041s)
[95.317887] Starting dynamic subtest: bcs0
[95.348619] Dynamic subtest bcs0: SUCCESS (0.040s)
[95.357620] Starting dynamic subtest: vcs0
[95.406201] Dynamic subtest vcs0: SUCCESS (0.057s)
[95.416210] Starting dynamic subtest: vcs1
[95.444437] Dynamic subtest vcs1: SUCCESS (0.037s)
[95.455172] Starting dynamic subtest: vecs0
[95.480764] Dynamic subtest vecs0: SUCCESS (0.037s)
[95.489187] Starting dynamic subtest: ccs0
[95.520510] Dynamic subtest ccs0: SUCCESS (0.039s)
[95.522826] Subtest submit-early-slice: SUCCESS (0.254s)
[97.042950] [012/131] (920s left) kms_plane_cursor (primary)
[97.134772] Starting subtest: primary
[97.139073] Starting dynamic subtest: pipe-A-eDP-1-size-64
[99.684616] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.550s)
[99.712662] Starting dynamic subtest: pipe-A-eDP-1-size-128
[102.240185] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[102.265822] Starting dynamic subtest: pipe-A-eDP-1-size-256
[104.786799] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s)
[105.108156] Starting dynamic subtest: pipe-B-eDP-1-size-64
[108.347838] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.247s)
[108.371567] Starting dynamic subtest: pipe-B-eDP-1-size-128
[110.904206] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[110.927781] Starting dynamic subtest: pipe-B-eDP-1-size-256
[113.493669] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[113.816982] Starting dynamic subtest: pipe-C-eDP-1-size-64
[116.656387] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.850s)
[116.684705] Starting dynamic subtest: pipe-C-eDP-1-size-128
[118.801231] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.125s)
[118.827322] Starting dynamic subtest: pipe-C-eDP-1-size-256
[120.956067] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.136s)
[121.277740] Starting dynamic subtest: pipe-D-eDP-1-size-64
[124.103432] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.835s)
[124.128712] Starting dynamic subtest: pipe-D-eDP-1-size-128
[126.236654] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.113s)
[126.262131] Starting dynamic subtest: pipe-D-eDP-1-size-256
[128.347527] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.090s)
[128.668911] Subtest primary: SUCCESS (31.535s)
[129.533239] [013/131] (888s left) kms_pm_rpm (fences)
[131.061378] Starting subtest: fences
[131.066584] Subtest fences: SKIP (0.000s)
[131.787301] [014/131] (886s left) gem_eio (in-flight-contexts-1us)
[132.014827] Starting subtest: in-flight-contexts-1us
[145.969543] Subtest in-flight-contexts-1us: SUCCESS (13.953s)
[146.106359] [015/131] (871s left) kms_psr (pr-dpms)
[146.201857] Starting subtest: pr-dpms
[146.205718] Subtest pr-dpms: SKIP (0.000s)
[146.283449] [016/131] (871s left) kms_rotation_crc (bad-pixel-format)
[146.392064] Starting subtest: bad-pixel-format
[146.396715] Subtest bad-pixel-format: SKIP (0.001s)
[146.495125] [017/131] (871s left) kms_flip (flip-vs-fences)
[146.600096] Starting subtest: flip-vs-fences
[146.604080] Subtest flip-vs-fences: SKIP (0.000s)
[146.745879] [018/131] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[146.847589] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[146.852059] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[146.971380] [019/131] (871s left) syncobj_wait (single-wait-for-submit-submitted)
[147.027599] Starting subtest: single-wait-for-submit-submitted
[147.136806] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[147.239940] [020/131] (870s left) gem_ctx_sseu (invalid-sseu)
[147.291696] Subtest invalid-sseu: SKIP (0.000s)
[147.369061] [021/131] (870s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[147.463154] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[147.465320] Starting dynamic subtest: pipe-A-eDP-1
[147.486874] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.496522] Starting dynamic subtest: pipe-B-eDP-1
[147.514609] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.521991] Starting dynamic subtest: pipe-C-eDP-1
[147.542790] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.549502] Starting dynamic subtest: pipe-D-eDP-1
[147.571196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.575559] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[149.661230] [022/131] (868s left) gem_mmap_offset (bad-extensions)
[149.723880] Starting subtest: bad-extensions
[149.726204] Subtest bad-extensions: SUCCESS (0.000s)
[149.841053] [023/131] (868s left) gem_tiled_blits (normal)
[149.908171] Subtest normal: SKIP (0.000s)
[149.991555] [024/131] (868s left) syncobj_timeline (32bits-limit)
[150.054457] Starting subtest: 32bits-limit
[150.056776] Subtest 32bits-limit: SUCCESS (0.001s)
[150.194245] [025/131] (868s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[150.303165] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[150.305353] Starting dynamic subtest: pipe-A-eDP-1
[151.511720] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.210s)
[151.520073] Starting dynamic subtest: pipe-B-eDP-1
[153.766656] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.252s)
[153.775092] Starting dynamic subtest: pipe-C-eDP-1
[156.077682] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.309s)
[156.085724] Starting dynamic subtest: pipe-D-eDP-1
[158.340896] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.262s)
[158.343208] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.039s)
[159.510920] [026/131] (858s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[159.624448] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[159.626715] Starting dynamic subtest: pipe-A-default-mode
[159.915691] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[159.920111] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.290s)
[160.737250] [027/131] (857s left) gem_mmap_wc (bad-offset)
[160.801231] Subtest bad-offset: SKIP (0.000s)
[160.858341] [028/131] (857s left) syncobj_wait (reset-multiple-signaled)
[160.918290] Starting subtest: reset-multiple-signaled
[160.920740] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[161.050640] [029/131] (857s left) prime_mmap (test_forked_cpu_write)
[161.097097] Starting subtest: test_forked_cpu_write
[161.098931] Starting dynamic subtest: test_forked_cpu_write-smem
[161.104908] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[161.107238] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[161.229497] [030/131] (857s left) gem_render_copy (y-tiled-ccs-to-linear)
[161.283532] Starting subtest: y-tiled-ccs-to-linear
[161.287984] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[161.488118] [031/131] (857s left) syncobj_wait (reset-during-wait-for-submit)
[161.555534] Starting subtest: reset-during-wait-for-submit
[161.657545] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[161.764777] [032/131] (856s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[164.084198] Starting subtest: dpms-mode-unset-lpsp
[168.144210] Subtest dpms-mode-unset-lpsp: SUCCESS (4.063s)
[168.516446] [033/131] (850s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[168.830036] Starting subtest: cursor-rapid-movement-max-size
[168.836608] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[168.997460] [034/131] (849s left) kms_joiner (invalid-modeset-force-big-joiner)
[169.107522] Starting subtest: invalid-modeset-force-big-joiner
[169.109811] Starting dynamic subtest: big_joiner_on_last_pipe
[169.442232] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.341s)
[169.444672] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.342s)
[170.250160] [035/131] (848s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[170.349246] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[170.351632] Starting dynamic subtest: pipe-A
[171.520479] Dynamic subtest pipe-A: SUCCESS (1.174s)
[171.528106] Starting dynamic subtest: pipe-B
[173.674807] Dynamic subtest pipe-B: SUCCESS (2.153s)
[173.690140] Starting dynamic subtest: pipe-C
[174.846058] Dynamic subtest pipe-C: SUCCESS (1.168s)
[174.855550] Starting dynamic subtest: pipe-D
[176.068585] Dynamic subtest pipe-D: SUCCESS (1.221s)
[176.071186] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.722s)
[177.297643] [036/131] (841s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[177.401753] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[177.406138] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[177.540870] [037/131] (841s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[177.631326] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[177.633690] Starting dynamic subtest: pipe-A-default-mode
[177.926751] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[177.931348] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.294s)
[178.812122] [038/131] (840s left) gem_ccs (block-copy-uncompressed)
[178.881619] Starting subtest: block-copy-uncompressed
[178.884096] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[178.902949] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[178.912679] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[178.919393] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[178.926933] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[178.935993] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[178.943443] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[178.952831] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[178.955179] Subtest block-copy-uncompressed: SUCCESS (0.072s)
[179.111269] [039/131] (839s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[179.171394] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[179.249494] [040/131] (839s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[179.368604] Starting subtest: flip-vs-cursor-legacy
[186.396825] Subtest flip-vs-cursor-legacy: SUCCESS (7.029s)
[187.241457] [041/131] (831s left) gem_watchdog (default-physical)
[187.317706] Starting subtest: default-physical
[189.072783] Subtest default-physical: SUCCESS (1.767s)
[189.191423] [042/131] (829s left) gem_pxp (hw-rejects-pxp-context)
[189.321050] Starting subtest: hw-rejects-pxp-context
[189.325681] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[189.458721] [043/131] (829s left) gem_ctx_isolation (preservation-s3)
[189.521370] Starting subtest: preservation-S3
[189.523736] Starting dynamic subtest: rcs0
[205.841449] Dynamic subtest rcs0: SUCCESS (4.929s)
[205.849770] Starting dynamic subtest: bcs0
[221.800805] Dynamic subtest bcs0: SUCCESS (1.325s)
[221.811655] Starting dynamic subtest: vcs0
[237.817400] Dynamic subtest vcs0: SUCCESS (3.204s)
[237.829986] Starting dynamic subtest: vcs1
[255.812774] Dynamic subtest vcs1: SUCCESS (4.975s)
[255.821102] Starting dynamic subtest: vecs0
[273.807758] Dynamic subtest vecs0: SUCCESS (4.985s)
[273.816907] Starting dynamic subtest: ccs0
[291.819745] Dynamic subtest ccs0: SUCCESS (3.236s)
[291.822403] Subtest preservation-S3: SUCCESS (22.660s)
[292.077548] [044/131] (727s left) gen7_exec_parse (batch-without-end)
[292.143461] Subtest batch-without-end: SKIP (0.000s)
[292.239068] [045/131] (726s left) gem_close_race (basic-threads)
[292.315333] Starting subtest: basic-threads
[293.626497] Subtest basic-threads: SUCCESS (1.310s)
[293.837514] [046/131] (725s left) kms_cursor_edge_walk (128x128-top-bottom)
[293.939011] Starting subtest: 128x128-top-bottom
[293.941945] Starting dynamic subtest: pipe-A-eDP-1
[297.425727] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s)
[297.434137] Starting dynamic subtest: pipe-D-eDP-1
[300.551437] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[300.553826] Subtest 128x128-top-bottom: SUCCESS (6.608s)
[301.378455] [047/131] (717s left) kms_chamelium_audio (dp-audio-edid)
[301.766666] Subtest dp-audio-edid: SKIP (0.000s)
[302.586582] [048/131] (716s left) gem_exec_params (rel-constants-invalid)
[302.643632] Starting subtest: rel-constants-invalid
[302.646209] Subtest rel-constants-invalid: SUCCESS (0.000s)
[302.766567] [049/131] (716s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[307.768516] Starting subtest: pr-plane-move-sf-dmg-area
[307.774000] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[308.634414] [050/131] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[308.728696] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[308.733619] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[308.867880] [051/131] (710s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[308.930391] Starting subtest: invalid-multi-wait-unsubmitted
[308.932848] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[309.043174] [052/131] (710s left) gem_create (create-ext-set-pat)
[309.220798] Starting subtest: create-ext-set-pat
[309.223552] Subtest create-ext-set-pat: SUCCESS (0.001s)
[309.356478] [053/131] (710s left) gem_mmap_gtt (big-copy-odd)
[309.410798] Subtest big-copy-odd: SKIP (0.000s)
[309.479950] [054/131] (710s left) i915_query (query-regions-sanity-check)
[309.544601] Starting subtest: query-regions-sanity-check
[309.554183] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[309.696500] [055/131] (709s left) gem_mmap_wc (write-read-distinct)
[309.758836] Subtest write-read-distinct: SKIP (0.000s)
[309.812068] [056/131] (709s left) kms_content_protection (atomic)
[309.952321] Starting subtest: atomic
[309.957942] Subtest atomic: SKIP (0.000s)
[310.121030] [057/131] (709s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[310.187968] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[310.191004] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[310.302620] [058/131] (709s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[310.407908] Starting subtest: yf-tiled-8bpp-rotate-180
[310.412602] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[310.545578] [059/131] (709s left) sw_sync (sync_busy_fork_unixsocket)
[310.583784] Starting subtest: sync_busy_fork_unixsocket
[310.592413] Subtest sync_busy_fork_unixsocket: SUCCESS (0.010s)
[310.666942] [060/131] (709s left) gem_partial_pwrite_pread (writes-after-reads)
[310.728888] Subtest writes-after-reads: SKIP (0.000s)
[310.816756] [061/131] (709s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[311.202987] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[312.029915] [062/131] (707s left) kms_psr2_su (page_flip-p010)
[312.097381] Subtest page_flip-P010: SKIP (0.000s)
[312.160081] [063/131] (707s left) syncobj_timeline (transfer-timeline-point)
[312.220739] Starting subtest: transfer-timeline-point
[312.223392] Subtest transfer-timeline-point: SUCCESS (0.000s)
[312.358158] [064/131] (707s left) gem_exec_fence (syncobj-timeline-wait)
[312.939122] Starting subtest: syncobj-timeline-wait
[314.526952] Subtest syncobj-timeline-wait: SUCCESS (1.587s)
[314.807055] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[314.811138] [065/131] (705s left) gem_lmem_swapping (verify-random)
[314.870243] Subtest verify-random: SKIP (0.000s)
[314.914884] [066/131] (705s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[315.040450] Starting subtest: cursorB-vs-flipB-atomic
[315.045557] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[315.208808] [067/131] (704s left) kms_content_protection (mei-interface)
[315.348953] Starting subtest: mei-interface
[315.354063] Subtest mei-interface: SKIP (0.001s)
[315.517027] [068/131] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[315.623032] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[315.627970] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[315.748821] [069/131] (704s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[315.868472] Starting subtest: cursor-vs-flip-varying-size
[346.607611] Subtest cursor-vs-flip-varying-size: SUCCESS (30.718s)
[347.419643] [070/131] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[347.523808] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[354.007037] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.482s)
[354.163712] [071/131] (666s left) i915_pm_freq_api (freq-suspend)
[354.230019] Starting subtest: freq-suspend
[354.232799] Starting dynamic subtest: gt0
[370.768573] Dynamic subtest gt0: SUCCESS (1.200s)
[370.779968] Starting dynamic subtest: gt1
[386.791819] Dynamic subtest gt1: SUCCESS (1.230s)
[386.794320] Subtest freq-suspend: SUCCESS (2.434s)
[387.900921] [072/131] (633s left) tools_test (sysfs_l3_parity)
[387.963218] Starting subtest: sysfs_l3_parity
[388.041182] Subtest sysfs_l3_parity: SKIP (0.091s)
[388.117792] [073/131] (633s left) gem_spin_batch (resubmit)
[388.179389] Starting subtest: resubmit
[388.182306] Starting dynamic subtest: rcs0
[388.188980] Dynamic subtest rcs0: SUCCESS (0.007s)
[388.199552] Starting dynamic subtest: bcs0
[388.202477] Dynamic subtest bcs0: SUCCESS (0.003s)
[388.218362] Starting dynamic subtest: vcs0
[388.220774] Dynamic subtest vcs0: SUCCESS (0.003s)
[388.229152] Starting dynamic subtest: vcs1
[388.231464] Dynamic subtest vcs1: SUCCESS (0.003s)
[388.239357] Starting dynamic subtest: vecs0
[388.241847] Dynamic subtest vecs0: SUCCESS (0.003s)
[388.250148] Starting dynamic subtest: ccs0
[388.252567] Dynamic subtest ccs0: SUCCESS (0.003s)
[388.254866] Subtest resubmit: SUCCESS (0.026s)
[388.461792] [074/131] (632s left) prime_mmap (test_dup)
[388.526199] Starting subtest: test_dup
[388.528812] Starting dynamic subtest: test_dup-smem
[388.554869] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[388.557651] Subtest test_dup: SUCCESS (0.033s)
[388.652045] [075/131] (632s left) gen9_exec_parse (unaligned-access)
[388.709706] Subtest unaligned-access: SKIP (0.000s)
[388.782501] [076/131] (632s left) kms_cursor_crc (cursor-offscreen-64x64)
[388.963089] Starting subtest: cursor-offscreen-64x64
[388.965641] Starting dynamic subtest: pipe-A-eDP-1
[390.910054] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[390.937229] Starting dynamic subtest: pipe-D-eDP-1
[393.553165] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[393.556110] Subtest cursor-offscreen-64x64: SUCCESS (4.587s)
[394.419865] [077/131] (627s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[394.521121] Starting subtest: psr-farfromfence-mmap-gtt
[394.526022] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[394.666718] [078/131] (626s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[394.765236] Starting subtest: 4-tiled-32bpp-rotate-0
[396.100395] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.334s)
[396.276824] [079/131] (625s left) gem_exec_balancer (bonded-false-hang)
[396.561188] Starting subtest: bonded-false-hang
[396.566756] Subtest bonded-false-hang: SKIP (0.000s)
[396.687102] [080/131] (624s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[396.788105] Starting subtest: psr-modesetfrombusy
[403.053569] Subtest psr-modesetfrombusy: SUCCESS (6.266s)
[403.228615] [081/131] (618s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[403.335031] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[403.339684] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[403.468628] [082/131] (618s left) kms_psr (psr-sprite-plane-move)
[403.570255] Starting subtest: psr-sprite-plane-move
[403.572807] Starting dynamic subtest: eDP-1
[405.377437] Dynamic subtest eDP-1: SUCCESS (1.802s)
[405.380389] Subtest psr-sprite-plane-move: SUCCESS (1.805s)
[406.217691] [083/131] (615s left) gem_lmem_swapping (heavy-multi)
[406.263697] Subtest heavy-multi: SKIP (0.000s)
[406.301331] [084/131] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[406.391270] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[406.396572] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[406.507723] [085/131] (615s left) sysfs_preempt_timeout (idempotent)
[406.584207] Starting subtest: idempotent
[406.587311] Starting dynamic subtest: vecs0
[406.590369] Dynamic subtest vecs0: SUCCESS (0.000s)
[406.601320] Starting dynamic subtest: ccs0
[406.604224] Dynamic subtest ccs0: SUCCESS (0.000s)
[406.613188] Starting dynamic subtest: vcs0
[406.616021] Dynamic subtest vcs0: SUCCESS (0.000s)
[406.625148] Starting dynamic subtest: bcs0
[406.627095] Dynamic subtest bcs0: SUCCESS (0.000s)
[406.634898] Starting dynamic subtest: rcs0
[406.637329] Dynamic subtest rcs0: SUCCESS (0.000s)
[406.645816] Starting dynamic subtest: vcs1
[406.647961] Dynamic subtest vcs1: SUCCESS (0.000s)
[406.650154] Subtest idempotent: SUCCESS (0.007s)
[406.709270] [086/131] (615s left) gem_close (basic)
[406.769843] Starting subtest: basic
[406.772126] Subtest basic: SUCCESS (0.000s)
[406.888560] [087/131] (615s left) perf (global-sseu-config-invalid)
[407.031040] Starting subtest: global-sseu-config-invalid
[407.035795] Subtest global-sseu-config-invalid: SKIP (0.000s)
[407.082145] [088/131] (614s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[407.168739] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[407.172656] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[407.312657] [089/131] (614s left) perf (non-sampling-read-error)
[407.436805] Starting subtest: non-sampling-read-error
[407.448870] Subtest non-sampling-read-error: SUCCESS (0.010s)
[407.490706] [090/131] (614s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[407.595002] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[407.599642] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[407.745650] [091/131] (614s left) prime_vgem (sync)
[407.823851] Starting subtest: sync
[407.826228] Starting dynamic subtest: rcs0
[407.866683] Dynamic subtest rcs0: SUCCESS (0.043s)
[407.875813] Starting dynamic subtest: bcs0
[407.946532] Dynamic subtest bcs0: SUCCESS (0.079s)
[407.954995] Starting dynamic subtest: vcs0
[407.994893] Dynamic subtest vcs0: SUCCESS (0.048s)
[408.003725] Starting dynamic subtest: vcs1
[408.040671] Dynamic subtest vcs1: SUCCESS (0.045s)
[408.050081] Starting dynamic subtest: vecs0
[408.087770] Dynamic subtest vecs0: SUCCESS (0.047s)
[408.097417] Starting dynamic subtest: ccs0
[408.134682] Dynamic subtest ccs0: SUCCESS (0.045s)
[408.136904] Subtest sync: SUCCESS (0.311s)
[408.300165] [092/131] (613s left) kms_invalid_mode (bad-hsync-end)
[408.403298] Starting subtest: bad-hsync-end
[408.405798] Starting dynamic subtest: pipe-A-eDP-1
[408.688006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[408.697680] Starting dynamic subtest: pipe-B-eDP-1
[408.700378] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[408.709339] Starting dynamic subtest: pipe-C-eDP-1
[408.712362] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[408.720470] Starting dynamic subtest: pipe-D-eDP-1
[408.722810] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[408.724967] Subtest bad-hsync-end: SUCCESS (0.292s)
[409.549576] [093/131] (612s left) kms_async_flips (invalid-async-flip-atomic)
[409.646603] Starting subtest: invalid-async-flip-atomic
[410.018679] Starting dynamic subtest: pipe-A-eDP-1
[410.840479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.823s)
[411.198313] Starting dynamic subtest: pipe-B-eDP-1
[411.973143] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s)
[412.332518] Starting dynamic subtest: pipe-C-eDP-1
[413.091344] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[413.451266] Starting dynamic subtest: pipe-D-eDP-1
[414.222104] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[414.224744] Subtest invalid-async-flip-atomic: SUCCESS (4.574s)
[415.415210] [094/131] (606s left) gem_exec_schedule (manyslice)
[415.488135] Starting subtest: manyslice
[415.491092] Starting dynamic subtest: rcs0
[421.120303] Dynamic subtest rcs0: SUCCESS (5.639s)
[421.132173] Starting dynamic subtest: bcs0
[428.793046] Dynamic subtest bcs0: SUCCESS (7.667s)
[428.804718] Starting dynamic subtest: vcs0
[434.393807] Dynamic subtest vcs0: SUCCESS (5.596s)
[434.409443] Starting dynamic subtest: vcs1
[440.007038] Dynamic subtest vcs1: SUCCESS (5.608s)
[440.022176] Starting dynamic subtest: vecs0
[446.111939] Dynamic subtest vecs0: SUCCESS (6.101s)
[446.127921] Starting dynamic subtest: ccs0
[452.808449] Dynamic subtest ccs0: SUCCESS (6.691s)
[452.811609] Subtest manyslice: SUCCESS (37.312s)
[453.142060] [095/131] (569s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[453.249939] Starting subtest: fbc-rgb565-draw-render
[457.382210] Subtest fbc-rgb565-draw-render: SUCCESS (4.135s)
[458.531783] [096/131] (563s left) syncobj_wait (wait-all-snapshot)
[458.605323] Starting subtest: wait-all-snapshot
[458.684469] Subtest wait-all-snapshot: SUCCESS (0.082s)
[458.786748] [097/131] (563s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[458.877385] Starting subtest: primary-yf-tiled-reflect-x-180
[458.938104] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[459.065388] [098/131] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[459.179268] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[459.185380] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[459.325060] [099/131] (563s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[459.388209] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[459.445761] [100/131] (563s left) kms_scaling_modes (scaling-mode-center)
[459.531799] Starting subtest: scaling-mode-center
[459.534591] Starting dynamic subtest: pipe-A-eDP-1
[459.627877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s)
[459.638023] Starting dynamic subtest: pipe-B-eDP-1
[460.832040] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.202s)
[460.841098] Starting dynamic subtest: pipe-C-eDP-1
[461.936704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[461.946146] Starting dynamic subtest: pipe-D-eDP-1
[463.054992] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s)
[463.057615] Subtest scaling-mode-center: SUCCESS (3.525s)
[464.356051] [101/131] (558s left) perf_pmu (faulting-read)
[464.402262] Starting subtest: faulting-read
[464.405223] Starting dynamic subtest: wb
[464.408207] Dynamic subtest wb: SUCCESS (0.001s)
[464.418121] Starting dynamic subtest: wc
[464.420506] Dynamic subtest wc: SUCCESS (0.000s)
[464.429878] Starting dynamic subtest: uc
[464.432159] Dynamic subtest uc: SUCCESS (0.000s)
[464.434739] Subtest faulting-read: SUCCESS (0.003s)
[464.554004] [102/131] (558s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[464.612752] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[464.618077] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[464.827089] [103/131] (557s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[464.943319] Starting subtest: cursorB-vs-flipA-varying-size
[464.948008] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[465.112498] [104/131] (557s left) kms_properties (colorop-properties-legacy)
[465.209015] Starting subtest: colorop-properties-legacy
[465.211630] Starting dynamic subtest: pipe-A-eDP-1
[465.547043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.337s)
[465.557813] Starting dynamic subtest: pipe-B-eDP-1
[466.587304] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.038s)
[466.604710] Starting dynamic subtest: pipe-C-eDP-1
[467.630204] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.039s)
[467.640583] Starting dynamic subtest: pipe-D-eDP-1
[468.657232] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.028s)
[468.660152] Subtest colorop-properties-legacy: SUCCESS (3.446s)
[469.491425] [105/131] (553s left) kms_big_fb (linear-32bpp-rotate-270)
[469.602236] Starting subtest: linear-32bpp-rotate-270
[469.621494] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[469.761390] [106/131] (553s left) gem_mmap_gtt (basic-small-copy-xy)
[469.819192] Subtest basic-small-copy-XY: SKIP (0.000s)
[469.882858] [107/131] (552s left) gem_exec_fence (keep-in-fence)
[470.066079] Starting subtest: keep-in-fence
[470.068843] Starting dynamic subtest: rcs0
[470.133342] Dynamic subtest rcs0: SUCCESS (0.070s)
[470.145880] Starting dynamic subtest: bcs0
[470.188785] Dynamic subtest bcs0: SUCCESS (0.053s)
[470.200977] Starting dynamic subtest: vcs0
[471.622118] Dynamic subtest vcs0: SUCCESS (1.429s)
[471.634323] Starting dynamic subtest: vcs1
[473.670167] Dynamic subtest vcs1: SUCCESS (2.044s)
[473.682509] Starting dynamic subtest: vecs0
[475.653594] Dynamic subtest vecs0: SUCCESS (1.980s)
[475.666336] Starting dynamic subtest: ccs0
[475.895370] Dynamic subtest ccs0: SUCCESS (0.240s)
[475.898467] Subtest keep-in-fence: SUCCESS (5.830s)
[477.743684] [108/131] (545s left) gem_ctx_persistence (engines-queued)
[477.811614] Starting subtest: engines-queued
[477.814369] Starting dynamic subtest: rcs0
[477.898167] Dynamic subtest rcs0: SUCCESS (0.087s)
[477.909341] Starting dynamic subtest: bcs0
[477.935751] Dynamic subtest bcs0: SUCCESS (0.036s)
[477.945104] Starting dynamic subtest: vcs0
[479.650820] Dynamic subtest vcs0: SUCCESS (1.712s)
[479.662047] Starting dynamic subtest: vcs1
[481.570656] Dynamic subtest vcs1: SUCCESS (1.916s)
[481.583897] Starting dynamic subtest: vecs0
[482.595995] Dynamic subtest vecs0: SUCCESS (1.022s)
[482.608319] Starting dynamic subtest: ccs0
[482.774476] Dynamic subtest ccs0: SUCCESS (0.177s)
[482.777341] Subtest engines-queued: SUCCESS (4.961s)
[482.930407] [109/131] (539s left) prime_vgem (basic-write)
[482.997734] Starting subtest: basic-write
[483.011227] Subtest basic-write: SKIP (0.011s)
[483.164968] [110/131] (539s left) gem_sync (basic-each)
[483.245105] Starting subtest: basic-each
[486.021254] Subtest basic-each: SUCCESS (2.791s)
[486.237324] [111/131] (536s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[486.350272] Starting subtest: y-tiled-8bpp-rotate-0
[486.355308] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[486.467603] [112/131] (536s left) kms_psr (fbc-psr-primary-render)
[486.566227] Starting subtest: fbc-psr-primary-render
[486.568593] Starting dynamic subtest: eDP-1
[486.573306] Dynamic subtest eDP-1: SKIP (0.000s)
[486.578192] Subtest fbc-psr-primary-render: SKIP (0.001s)
[486.661823] [113/131] (536s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[486.765759] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[486.770819] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[486.891644] [114/131] (536s left) kms_dsc (dsc-with-output-formats)
[486.978591] Starting subtest: dsc-with-output-formats
[487.004155] Subtest dsc-with-output-formats: SKIP (0.000s)
[487.075804] [115/131] (536s left) gem_exec_store (basic)
[487.133309] Starting subtest: basic
[487.257351] Subtest basic: SUCCESS (0.125s)
[487.469386] [116/131] (535s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[487.569892] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[491.193786] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.627s)
[492.384642] [117/131] (530s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[492.491401] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[493.137158] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[493.345736] [118/131] (529s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[493.407181] Starting subtest: invalid-signal-one-illegal-handle
[493.410025] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[493.521719] [119/131] (529s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[493.621175] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[493.623911] Starting dynamic subtest: pipe-A
[493.685950] Dynamic subtest pipe-A: SUCCESS (0.065s)
[493.698103] Starting dynamic subtest: pipe-B
[494.777239] Dynamic subtest pipe-B: SUCCESS (1.090s)
[494.788192] Starting dynamic subtest: pipe-C
[495.892666] Dynamic subtest pipe-C: SUCCESS (1.114s)
[495.901898] Starting dynamic subtest: pipe-D
[497.022097] Dynamic subtest pipe-D: SUCCESS (1.128s)
[497.024830] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.400s)
[498.202972] [120/131] (525s left) kms_psr (fbc-psr2-cursor-blt)
[498.293851] Starting subtest: fbc-psr2-cursor-blt
[498.296345] Starting dynamic subtest: eDP-1
[498.301189] Dynamic subtest eDP-1: SKIP (0.000s)
[498.306033] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[498.389344] [121/131] (525s left) gem_exec_balancer (parallel-bb-first)
[498.650639] Starting subtest: parallel-bb-first
[499.542039] Subtest parallel-bb-first: SUCCESS (0.891s)
[500.674379] [122/131] (522s left) i915_pm_freq_mult (media-freq)
[500.743329] Starting subtest: media-freq
[500.746220] Starting dynamic subtest: gt0
[500.752002] Dynamic subtest gt0: SKIP (0.000s)
[500.763048] Starting dynamic subtest: gt1
[500.768335] Dynamic subtest gt1: SKIP (0.000s)
[500.774040] Subtest media-freq: SKIP (0.002s)
[500.865016] [123/131] (522s left) drm_buddy (drm_buddy)
[500.903480] Starting subtest: drm_buddy
[500.916926] Starting dynamic subtest: drm_test_buddy_alloc_limit
[501.056970] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.138s)
[501.066338] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[501.213901] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.156s)
[501.225160] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[501.352168] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.136s)
[501.363768] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[501.488081] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.135s)
[501.498496] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[501.615101] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.127s)
[501.625709] Starting dynamic subtest: drm_test_buddy_alloc_clear
[501.809724] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.191s)
[501.820069] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[501.952257] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.144s)
[501.962541] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[506.043996] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.084s)
[506.046349] Subtest drm_buddy: SUCCESS (5.138s)
[506.275395] [124/131] (517s left) kms_atomic_interruptible (universal-setplane-cursor)
[506.372022] Starting subtest: universal-setplane-cursor
[506.374678] Starting dynamic subtest: pipe-A-eDP-1
[513.794153] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.417s)
[513.797145] Subtest universal-setplane-cursor: SUCCESS (7.418s)
[514.669058] [125/131] (508s left) kms_chamelium_frames (hdmi-crc-fast)
[515.047837] Subtest hdmi-crc-fast: SKIP (0.000s)
[515.846984] [126/131] (507s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[515.948133] Starting subtest: nonblocking-crc-frame-sequence
[515.951007] Starting dynamic subtest: pipe-A-eDP-1
[516.675336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s)
[516.686345] Starting dynamic subtest: pipe-B-eDP-1
[518.065901] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[518.077753] Starting dynamic subtest: pipe-C-eDP-1
[519.465172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[519.476299] Starting dynamic subtest: pipe-D-eDP-1
[520.813163] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[520.816182] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.861s)
[521.631707] [127/131] (502s left) kms_psr (psr2-cursor-plane-onoff)
[521.733951] Starting subtest: psr2-cursor-plane-onoff
[521.736514] Starting dynamic subtest: eDP-1
[523.403748] Dynamic subtest eDP-1: SUCCESS (1.670s)
[523.406348] Subtest psr2-cursor-plane-onoff: SUCCESS (1.671s)
[524.317421] [128/131] (499s left) kms_flip (2x-flip-vs-panning-interruptible)
[524.423937] Starting subtest: 2x-flip-vs-panning-interruptible
[524.435493] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[524.558513] [129/131] (499s left) gem_eio (in-flight-internal-10ms)
[524.796015] Starting subtest: in-flight-internal-10ms
[526.755887] Subtest in-flight-internal-10ms: SUCCESS (1.958s)
[526.919009] [130/131] (496s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[527.025328] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[527.028094] Starting dynamic subtest: pipe-A-eDP-1
[527.051343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[527.062314] Starting dynamic subtest: pipe-B-eDP-1
[527.085798] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[527.094708] Starting dynamic subtest: pipe-C-eDP-1
[527.118028] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[527.126697] Starting dynamic subtest: pipe-D-eDP-1
[527.149365] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[527.151702] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[529.201653] [131/131] (494s left) api_intel_bb (bb-with-allocator)
[529.255293] Starting subtest: bb-with-allocator
[529.258835] Subtest bb-with-allocator: SUCCESS (0.007s)
[529.374700] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_dp_link_training
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: kms_vblank
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_plane_cursor
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: gem_ctx_sseu
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_mmap_offset
results: parsing output: 22/ for test: gem_tiled_blits
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_joiner
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: gem_ccs
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: gem_watchdog
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: gem_ctx_isolation
results: parsing output: 43/ for test: gen7_exec_parse
results: parsing output: 44/ for test: gem_close_race
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_chamelium_audio
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: gem_create
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: i915_query
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_content_protection
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: kms_psr2_su
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: gem_lmem_swapping
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: i915_pm_freq_api
results: parsing output: 71/ for test: tools_test
results: parsing output: 72/ for test: gem_spin_batch
results: parsing output: 73/ for test: prime_mmap
results: parsing output: 74/ for test: gen9_exec_parse
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_balancer
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_lmem_swapping
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: sysfs_preempt_timeout
results: parsing output: 85/ for test: gem_close
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: prime_vgem
results: parsing output: 91/ for test: kms_invalid_mode
results: parsing output: 92/ for test: kms_async_flips
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_scaling_modes
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_properties
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: prime_vgem
results: parsing output: 109/ for test: gem_sync
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_dsc
results: parsing output: 114/ for test: gem_exec_store
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: i915_pm_freq_mult
results: parsing output: 122/ for test: drm_buddy
results: parsing output: 123/ for test: kms_atomic_interruptible
results: parsing output: 124/ for test: kms_chamelium_frames
results: parsing output: 125/ for test: kms_pipe_crc_basic
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_eio
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: api_intel_bb
Done.