[61.037479] Initializing watchdogs
[61.037530]   /dev/watchdog0
[61.052106] [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]
[61.056666] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.059312] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.062533] [001/156] (960s left) kms_content_protection (mei-interface)
[61.240506] Starting subtest: mei-interface
[61.248124] Subtest mei-interface: SKIP (0.003s)
[61.381901] [002/156] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[61.466301] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[61.470885] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[61.546793] [003/156] (960s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw)
[61.659991] Starting subtest: fbchdr-1p-pri-indfb-multidraw
[61.664142] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[61.754046] [004/156] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-blt)
[61.850557] Starting subtest: fbcpsrhdr-rgb565-draw-blt
[61.854347] Subtest fbcpsrhdr-rgb565-draw-blt: SKIP (0.000s)
[61.944088] [005/156] (959s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[62.054676] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[62.058489] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[62.172347] [006/156] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render)
[62.273251] Starting subtest: fbcpsrhdr-rgb565-draw-render
[62.276917] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s)
[62.361376] [007/156] (959s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[62.466510] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[62.470266] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[62.579748] [008/156] (959s left) kms_hdmi_inject (inject-audio)
[62.930432] Starting subtest: inject-audio
[63.225375] Subtest inject-audio: SUCCESS (0.297s)
[63.844422] [009/156] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[63.953345] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[68.137375] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.189s)
[69.332604] [010/156] (952s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[69.378807] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[69.485086] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[69.569318] [011/156] (952s left) dmabuf_sync_file (import-basic)
[69.644844] Starting subtest: import-basic
[69.647086] Subtest import-basic: SUCCESS (0.001s)
[69.696719] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[69.699778] [012/156] (952s left) i915_pm_rpm (system-suspend)
[71.465620] Starting subtest: system-suspend
[89.524419] Subtest system-suspend: SUCCESS (3.316s)
[89.915147] [013/156] (932s left) gem_ctx_isolation (dirty-create)
[89.987911] Starting subtest: dirty-create
[89.990580] Starting dynamic subtest: rcs0
[90.186107] Dynamic subtest rcs0: SUCCESS (0.198s)
[90.196742] Starting dynamic subtest: bcs0
[90.405915] Dynamic subtest bcs0: SUCCESS (0.219s)
[90.418068] Starting dynamic subtest: vcs0
[90.638148] Dynamic subtest vcs0: SUCCESS (0.232s)
[90.651050] Starting dynamic subtest: vcs1
[92.208715] Dynamic subtest vcs1: SUCCESS (1.570s)
[92.217280] Starting dynamic subtest: vecs0
[94.247246] Dynamic subtest vecs0: SUCCESS (2.038s)
[94.259565] Starting dynamic subtest: ccs0
[96.238877] Dynamic subtest ccs0: SUCCESS (1.990s)
[96.241402] Subtest dirty-create: SUCCESS (6.250s)
[96.483601] [014/156] (925s left) gen9_exec_parse (unaligned-access)
[96.549619] Subtest unaligned-access: SKIP (0.000s)
[96.626323] [015/156] (925s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[96.734614] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[96.738996] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[96.803842] [016/156] (925s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[96.916749] Starting subtest: psr-farfromfence-mmap-gtt
[96.920973] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[97.000288] [017/156] (925s left) i915_hangman (engine-engine-hang)
[97.065612] Starting subtest: engine-engine-hang
[97.067847] Starting dynamic subtest: rcs0
[99.004429] Dynamic subtest rcs0: SUCCESS (1.938s)
[99.014181] Starting dynamic subtest: bcs0
[100.984168] Dynamic subtest bcs0: SUCCESS (1.978s)
[100.996266] Starting dynamic subtest: vcs0
[103.030711] Dynamic subtest vcs0: SUCCESS (2.046s)
[103.040956] Starting dynamic subtest: vcs1
[105.016260] Dynamic subtest vcs1: SUCCESS (1.983s)
[105.027453] Starting dynamic subtest: vecs0
[106.998864] Dynamic subtest vecs0: SUCCESS (1.982s)
[107.011968] Starting dynamic subtest: ccs0
[108.982540] Dynamic subtest ccs0: SUCCESS (1.983s)
[108.985012] Subtest engine-engine-hang: SUCCESS (11.918s)
[109.112371] [018/156] (913s left) kms_cursor_legacy (torture-bo)
[109.248908] Starting subtest: torture-bo
[109.251330] Starting dynamic subtest: pipe-A
[115.864318] Dynamic subtest pipe-A: SUCCESS (6.562s)
[115.874669] Starting dynamic subtest: pipe-B
[122.132471] Dynamic subtest pipe-B: SUCCESS (6.320s)
[122.145252] Starting dynamic subtest: pipe-C
[128.388125] Dynamic subtest pipe-C: SUCCESS (6.254s)
[128.403867] Starting dynamic subtest: pipe-D
[134.889846] Dynamic subtest pipe-D: SUCCESS (6.502s)
[134.898783] Starting dynamic subtest: all-pipes
[143.298566] Dynamic subtest all-pipes: SUCCESS (8.408s)
[143.301122] Subtest torture-bo: SUCCESS (34.050s)
[143.477909] [019/156] (878s left) kms_setmode (invalid-clone-exclusive-crtc)
[143.535364] Starting subtest: invalid-clone-exclusive-crtc
[143.542351] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[143.638609] [020/156] (878s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[143.736591] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[143.740626] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[143.825016] [021/156] (878s left) gem_mmap_wc (set-cache-level)
[143.887319] Subtest set-cache-level: SKIP (0.000s)
[143.950652] [022/156] (878s left) gem_ctx_sseu (invalid-sseu)
[144.011668] Subtest invalid-sseu: SKIP (0.000s)
[144.087697] [023/156] (878s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[144.186341] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[144.190568] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[144.282258] [024/156] (878s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[144.385535] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[144.389199] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[144.485841] [025/156] (878s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[144.590376] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[145.604493] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.014s)
[145.736874] [026/156] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[145.851137] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[145.854782] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[145.936875] [027/156] (876s left) api_intel_bb (purge-bb)
[145.986080] Starting subtest: purge-bb
[145.990457] Subtest purge-bb: SUCCESS (0.004s)
[146.115147] [028/156] (876s left) gem_userptr_blits (unsync-unmap-after-close)
[146.180114] Subtest unsync-unmap-after-close: SKIP (0.000s)
[146.309062] [029/156] (876s left) gem_exec_reloc (basic-cpu-read)
[146.360482] Subtest basic-cpu-read: SKIP (0.000s)
[146.423155] [030/156] (876s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[146.480336] Starting subtest: yf-tiled-ccs-to-x-tiled
[146.483999] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[146.660024] [031/156] (876s left) kms_cursor_crc (cursor-onscreen-128x42)
[146.864996] Starting subtest: cursor-onscreen-128x42
[146.918395] Subtest cursor-onscreen-128x42: SKIP (0.048s)
[147.126537] [032/156] (875s left) i915_pm_sseu (full-enable)
[147.179606] Subtest full-enable: SKIP (0.000s)
[147.287182] [033/156] (875s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[147.384277] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[147.389006] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[148.506414] [034/156] (874s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[148.617249] Starting subtest: fbcpsr-rgb565-draw-blt
[155.752590] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.142s)
[155.884470] [035/156] (867s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[155.986561] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[155.990894] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[156.069051] [036/156] (866s left) kms_psr (psr2-sprite-mmap-gtt)
[156.159377] Starting subtest: psr2-sprite-mmap-gtt
[156.161664] Starting dynamic subtest: eDP-1
[157.568195] Dynamic subtest eDP-1: SKIP (1.406s)
[157.572806] Subtest psr2-sprite-mmap-gtt: SKIP (1.407s)
[157.734707] [037/156] (865s left) gem_exec_balancer (sequential)
[157.805979] Starting subtest: sequential
[160.892685] Subtest sequential: SUCCESS (3.086s)
[161.229479] [038/156] (861s left) kms_lease (implicit-plane-lease)
[161.325312] Starting subtest: implicit-plane-lease
[161.327667] Subtest implicit-plane-lease: SUCCESS (0.004s)
[161.431005] [039/156] (861s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[161.538315] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[161.542179] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[161.624100] [040/156] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[161.733240] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[161.737485] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[161.814298] [041/156] (861s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[161.906900] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[161.911467] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[161.999306] [042/156] (861s left) gem_exec_schedule (implicit-read-write)
[162.067098] Starting subtest: implicit-read-write
[162.069368] Starting dynamic subtest: rcs0
[162.177308] Dynamic subtest rcs0: SUCCESS (0.115s)
[162.189391] Starting dynamic subtest: vcs0
[162.261905] Dynamic subtest vcs0: SUCCESS (0.084s)
[162.273714] Starting dynamic subtest: vcs1
[162.337665] Dynamic subtest vcs1: SUCCESS (0.075s)
[162.351893] Starting dynamic subtest: vecs0
[162.413040] Dynamic subtest vecs0: SUCCESS (0.075s)
[162.429727] Starting dynamic subtest: ccs0
[162.497570] Dynamic subtest ccs0: SUCCESS (0.084s)
[162.499808] Subtest implicit-read-write: SUCCESS (0.435s)
[164.139761] [043/156] (859s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[164.257840] Starting subtest: cursorA-vs-flipA-legacy
[175.393711] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.135s)
[176.206449] [044/156] (847s left) kms_flip (dpms-off-confusion-interruptible)
[176.305380] Starting subtest: dpms-off-confusion-interruptible
[176.307626] Starting dynamic subtest: A-eDP1
[185.020527] Dynamic subtest A-eDP1: SUCCESS (8.682s)
[185.031993] Starting dynamic subtest: B-eDP1
[193.714737] Dynamic subtest B-eDP1: SUCCESS (8.692s)
[193.725482] Starting dynamic subtest: C-eDP1
[202.415784] Dynamic subtest C-eDP1: SUCCESS (8.687s)
[202.428442] Starting dynamic subtest: D-eDP1
[211.065601] Dynamic subtest D-eDP1: SUCCESS (8.694s)
[211.068086] Subtest dpms-off-confusion-interruptible: SUCCESS (34.764s)
[212.295456] [045/156] (811s left) kms_vblank (query-busy)
[212.402508] Starting subtest: query-busy
[212.404381] Starting dynamic subtest: pipe-A-eDP-1
[214.291592] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[214.306884] Starting dynamic subtest: pipe-D-eDP-1
[216.838450] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s)
[216.840863] Subtest query-busy: SUCCESS (4.437s)
[217.705696] [046/156] (805s left) kms_async_flips (crc-atomic)
[217.793727] Starting subtest: crc-atomic
[218.170750] Starting dynamic subtest: pipe-A-eDP-1
[221.097915] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.905s)
[221.463134] Starting dynamic subtest: pipe-B-eDP-1
[224.397601] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.927s)
[224.772525] Starting dynamic subtest: pipe-C-eDP-1
[227.688204] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.898s)
[228.019736] Starting dynamic subtest: pipe-D-eDP-1
[230.988774] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.948s)
[230.990908] Subtest crc-atomic: SUCCESS (13.166s)
[232.190940] [047/156] (791s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render)
[232.291860] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render
[232.296509] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[232.401796] [048/156] (791s left) gem_fence_thrash (bo-write-verify-none)
[232.436059] Starting subtest: bo-write-verify-none
[232.461194] Subtest bo-write-verify-none: SKIP (0.023s)
[232.533683] [049/156] (790s left) kms_pm_rpm (basic-pci-d3-state)
[234.272898] Starting subtest: basic-pci-d3-state
[235.768042] Subtest basic-pci-d3-state: SUCCESS (1.500s)
[235.882489] [050/156] (787s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[235.999831] Starting subtest: flip-vs-cursor-varying-size
[244.869118] Subtest flip-vs-cursor-varying-size: SUCCESS (8.868s)
[245.702672] [051/156] (777s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-onoff)
[245.800742] Starting subtest: hdr-2p-scndscrn-cur-indfb-onoff
[245.804974] Subtest hdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[245.894374] [052/156] (777s left) gem_render_tiled_blits (basic)
[245.955275] Subtest basic: SKIP (0.000s)
[246.036105] [053/156] (777s left) gem_workarounds (reset-fd)
[246.104054] Starting subtest: reset-fd
[246.280401] Subtest reset-fd: SUCCESS (0.176s)
[246.404026] [054/156] (777s left) kms_feature_discovery (display-2x)
[246.504059] Starting subtest: display-2x
[246.508375] Subtest display-2x: SKIP (0.000s)
[246.586499] [055/156] (777s left) gem_exec_schedule (noreorder)
[246.772051] Starting subtest: noreorder
[246.774274] Starting dynamic subtest: rcs0
[246.840846] Dynamic subtest rcs0: SUCCESS (0.071s)
[246.855891] Starting dynamic subtest: vcs0
[248.023521] Dynamic subtest vcs0: SUCCESS (1.180s)
[248.036705] Starting dynamic subtest: vcs1
[250.068426] Dynamic subtest vcs1: SUCCESS (2.043s)
[250.082259] Starting dynamic subtest: vecs0
[252.038069] Dynamic subtest vecs0: SUCCESS (1.967s)
[252.049200] Starting dynamic subtest: ccs0
[252.102486] Dynamic subtest ccs0: SUCCESS (0.064s)
[252.105120] Subtest noreorder: SUCCESS (5.333s)
[252.290576] [056/156] (771s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[252.349362] Starting subtest: y-tiled-ccs-to-x-tiled
[252.353794] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[252.558263] [057/156] (771s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[252.672695] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[252.677067] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[252.776804] [058/156] (771s left) kms_cursor_crc (cursor-random-512x170)
[253.090308] Starting subtest: cursor-random-512x170
[253.094505] Subtest cursor-random-512x170: SKIP (0.001s)
[253.249663] [059/156] (770s left) gem_exec_fence (nb-await)
[253.419146] Starting subtest: nb-await
[253.422609] Starting dynamic subtest: rcs0
[253.483797] Dynamic subtest rcs0: SUCCESS (0.067s)
[253.495866] Starting dynamic subtest: bcs0
[253.544139] Dynamic subtest bcs0: SUCCESS (0.059s)
[253.555697] Starting dynamic subtest: vcs0
[253.605161] Dynamic subtest vcs0: SUCCESS (0.059s)
[253.615356] Starting dynamic subtest: vcs1
[253.665270] Dynamic subtest vcs1: SUCCESS (0.059s)
[253.675536] Starting dynamic subtest: vecs0
[253.724484] Dynamic subtest vecs0: SUCCESS (0.057s)
[253.735459] Starting dynamic subtest: ccs0
[253.783978] Dynamic subtest ccs0: SUCCESS (0.058s)
[253.786759] Subtest nb-await: SUCCESS (0.369s)
[255.148734] [060/156] (768s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[255.201261] Starting subtest: invalid-bsd2-flag-on-blt
[255.203672] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[255.311437] [061/156] (768s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[255.438489] Starting subtest: 2x-long-cursor-vs-flip-legacy
[255.443032] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[255.597019] [062/156] (768s left) kms_busy (basic)
[255.692377] Starting subtest: basic
[255.694687] Starting dynamic subtest: flip
[256.272332] Dynamic subtest flip: SUCCESS (0.577s)
[256.282471] Starting dynamic subtest: modeset
[259.718592] Dynamic subtest modeset: SUCCESS (3.446s)
[259.720801] Subtest basic: SUCCESS (4.025s)
[260.582791] [063/156] (763s left) gem_exec_whisper (basic-fds-priority)
[260.644443] Starting subtest: basic-fds-priority
[285.001497] Subtest basic-fds-priority: SUCCESS (24.347s)
[285.178155] [064/156] (738s left) kms_addfb_basic (bo-too-small)
[285.282204] Starting subtest: bo-too-small
[285.284490] Subtest bo-too-small: SUCCESS (0.000s)
[285.381918] [065/156] (738s left) gem_userptr_blits (create-destroy-sync)
[285.448170] Starting subtest: create-destroy-sync
[290.519833] Subtest create-destroy-sync: SUCCESS (5.018s)
[290.582622] [066/156] (733s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[290.703461] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[290.707865] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[290.827652] [067/156] (733s left) gem_ctx_persistence (heartbeat-many)
[290.874784] Starting subtest: heartbeat-many
[290.879446] Subtest heartbeat-many: SKIP (0.000s)
[290.984852] [068/156] (733s left) kms_psr2_su (page_flip-p010)
[291.040005] Subtest page_flip-P010: SKIP (0.000s)
[291.100859] [069/156] (733s left) kms_flip (nonexisting-fb)
[291.189589] Starting subtest: nonexisting-fb
[291.191875] Starting dynamic subtest: A-eDP1
[292.341575] Dynamic subtest A-eDP1: SUCCESS (1.154s)
[292.354289] Starting dynamic subtest: B-eDP1
[293.543272] Dynamic subtest B-eDP1: SUCCESS (1.201s)
[293.556430] Starting dynamic subtest: C-eDP1
[294.738756] Dynamic subtest C-eDP1: SUCCESS (1.195s)
[294.751810] Starting dynamic subtest: D-eDP1
[295.932779] Dynamic subtest D-eDP1: SUCCESS (1.193s)
[295.935196] Subtest nonexisting-fb: SUCCESS (4.750s)
[297.184020] [070/156] (727s left) syncobj_timeline (multi-wait-submitted-signaled)
[297.245335] Starting subtest: multi-wait-submitted-signaled
[297.247569] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[297.363499] [071/156] (727s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-pwrite)
[297.451632] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-pwrite
[297.455950] Subtest fbchdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[297.549410] [072/156] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[297.649268] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[297.653532] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[297.766302] [073/156] (726s left) gem_exec_balancer (hog)
[297.826047] Starting subtest: hog
[297.830572] Subtest hog: SKIP (0.000s)
[298.118716] [074/156] (726s left) api_intel_allocator (reloc-allocator)
[298.165021] Starting subtest: reloc-allocator
[298.166893] Starting dynamic subtest: basic
[298.169135] Dynamic subtest basic: SUCCESS (0.004s)
[298.180588] Starting dynamic subtest: parallel-one
[298.182490] Dynamic subtest parallel-one: SUCCESS (0.009s)
[298.195424] Starting dynamic subtest: print
[298.197592] Dynamic subtest print: SUCCESS (0.000s)
[298.209279] Starting dynamic subtest: reuse
[298.211428] Dynamic subtest reuse: SUCCESS (0.000s)
[298.221057] Starting dynamic subtest: fork-reopen-allocator
[298.223249] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[298.225378] Subtest reloc-allocator: SUCCESS (0.027s)
[298.322813] [075/156] (726s left) syncobj_timeline (invalid-transfer-bad-pad)
[298.376477] Starting subtest: invalid-transfer-bad-pad
[298.378841] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[298.486124] [076/156] (726s left) syncobj_timeline (invalid-query-bad-pad)
[298.531579] Starting subtest: invalid-query-bad-pad
[298.533966] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[298.621785] [077/156] (726s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[298.718957] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[303.299713] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.587s)
[304.490171] [078/156] (720s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[304.593476] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[311.692644] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (7.106s)
[311.842018] [079/156] (712s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[311.941016] Starting subtest: psr-rgb101010-draw-mmap-wc
[318.964948] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.027s)
[319.083604] [080/156] (705s left) gem_wait (write-wait)
[319.148627] Starting subtest: write-wait
[319.150968] Starting dynamic subtest: all-engines
[320.264580] Dynamic subtest all-engines: SUCCESS (1.115s)
[320.279256] Starting dynamic subtest: rcs0
[321.335773] Dynamic subtest rcs0: SUCCESS (1.068s)
[321.354029] Starting dynamic subtest: bcs0
[322.396353] Dynamic subtest bcs0: SUCCESS (1.058s)
[322.415393] Starting dynamic subtest: vcs0
[323.453427] Dynamic subtest vcs0: SUCCESS (1.055s)
[323.472105] Starting dynamic subtest: vcs1
[324.508449] Dynamic subtest vcs1: SUCCESS (1.053s)
[324.526613] Starting dynamic subtest: vecs0
[325.562682] Dynamic subtest vecs0: SUCCESS (1.051s)
[325.581979] Starting dynamic subtest: ccs0
[326.620176] Dynamic subtest ccs0: SUCCESS (1.055s)
[326.622840] Subtest write-wait: SUCCESS (7.471s)
[326.817923] [081/156] (698s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[327.226895] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[328.059452] [082/156] (696s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[328.156085] Starting subtest: modeset-transition-nonblocking-fencing
[328.158469] Starting dynamic subtest: 1x-outputs
[339.051095] Dynamic subtest 1x-outputs: SUCCESS (10.896s)
[339.054366] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.898s)
[339.873589] [083/156] (685s left) gem_eio (wait-wedge-1us)
[340.065283] Starting subtest: wait-wedge-1us
[341.080960] Subtest wait-wedge-1us: SUCCESS (1.015s)
[341.194480] [084/156] (683s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[341.305181] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[359.443943] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.136s)
[360.323917] [085/156] (664s left) kms_lease (possible-crtcs-filtering)
[360.432288] Starting subtest: possible-crtcs-filtering
[360.437155] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[360.577095] [086/156] (664s left) kms_vblank (ts-continuation-modeset-rpm)
[360.675527] Starting subtest: ts-continuation-modeset-rpm
[360.677693] Starting dynamic subtest: pipe-A-eDP-1
[363.166250] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.492s)
[363.182783] Starting dynamic subtest: pipe-D-eDP-1
[365.334876] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.166s)
[365.337312] Subtest ts-continuation-modeset-rpm: SUCCESS (4.661s)
[366.175497] [087/156] (658s left) kms_pipe_crc_basic (suspend-read-crc)
[366.270648] Starting subtest: suspend-read-crc
[366.272984] Starting dynamic subtest: pipe-A-eDP-1
[383.620678] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.555s)
[383.634448] Starting dynamic subtest: pipe-B-eDP-1
[401.617220] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.214s)
[401.631151] Starting dynamic subtest: pipe-C-eDP-1
[419.581223] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.142s)
[419.592664] Starting dynamic subtest: pipe-D-eDP-1
[437.600320] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.098s)
[437.603369] Subtest suspend-read-crc: SUCCESS (12.015s)
[438.475508] [088/156] (586s left) kms_selftest (drm_damage_helper)
[438.526185] Starting subtest: drm_damage_helper
[438.535099] Starting dynamic subtest: drm_test_damage_iter_no_damage
[438.642430] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.104s)
[438.655034] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[438.744743] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.101s)
[438.758095] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[438.851048] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.107s)
[438.864610] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[438.939391] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.085s)
[438.956421] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[439.021570] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.080s)
[439.034411] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[439.126712] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.101s)
[439.138378] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[439.200145] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.075s)
[439.212304] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[439.313303] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.111s)
[439.326686] Starting dynamic subtest: drm_test_damage_iter_single_damage
[439.402609] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.088s)
[439.415275] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[439.492332] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.087s)
[439.505172] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[439.578211] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.084s)
[439.590603] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[439.671566] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.092s)
[439.683130] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[439.767699] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.095s)
[439.778677] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[439.850700] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.082s)
[439.861432] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[439.936966] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.085s)
[439.947824] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[440.024714] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.087s)
[440.034925] Starting dynamic subtest: drm_test_damage_iter_damage
[440.109005] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.084s)
[440.120434] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[440.211038] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.100s)
[440.221927] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[440.317679] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.104s)
[440.328708] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[440.418570] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.102s)
[440.430395] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[440.525056] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.105s)
[440.527189] Subtest drm_damage_helper: SUCCESS (1.998s)
[440.669272] [089/156] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[440.758849] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[447.363798] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.601s)
[447.491298] [090/156] (577s left) gem_spin_batch (spin-all-new)
[447.543964] Starting subtest: spin-all-new
[447.566113] Subtest spin-all-new: SUCCESS (0.021s)
[449.384104] [091/156] (575s left) gem_exec_schedule (smoketest)
[449.562168] Starting subtest: smoketest
[449.564905] Starting dynamic subtest: rcs0
[455.170063] Dynamic subtest rcs0: SUCCESS (5.492s)
[455.184749] Starting dynamic subtest: bcs0
[460.724381] Dynamic subtest bcs0: SUCCESS (5.544s)
[460.738010] Starting dynamic subtest: vcs0
[466.253263] Dynamic subtest vcs0: SUCCESS (5.513s)
[466.272416] Starting dynamic subtest: vcs1
[471.774283] Dynamic subtest vcs1: SUCCESS (5.522s)
[471.787039] Starting dynamic subtest: vecs0
[477.287039] Dynamic subtest vecs0: SUCCESS (5.509s)
[477.299555] Starting dynamic subtest: ccs0
[482.806720] Dynamic subtest ccs0: SUCCESS (5.524s)
[482.809806] Subtest smoketest: SUCCESS (33.110s)
[482.883872] [092/156] (542s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[482.996295] Starting subtest: x-tiled-16bpp-rotate-90
[483.016434] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[483.119762] [093/156] (542s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[483.204412] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[483.207229] Starting dynamic subtest: pipe-A
[484.408950] Dynamic subtest pipe-A: SUCCESS (1.206s)
[484.423639] Starting dynamic subtest: pipe-B
[486.728979] Dynamic subtest pipe-B: SUCCESS (2.318s)
[486.740163] Starting dynamic subtest: pipe-C
[487.941409] Dynamic subtest pipe-C: SUCCESS (1.211s)
[487.952447] Starting dynamic subtest: pipe-D
[489.154180] Dynamic subtest pipe-D: SUCCESS (1.211s)
[489.157100] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.950s)
[490.328739] [094/156] (535s left) kms_plane_multiple (tiling-none)
[490.437170] Starting subtest: tiling-none
[490.439901] Starting dynamic subtest: pipe-A-eDP-1
[494.243020] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.802s)
[494.258255] Starting dynamic subtest: pipe-B-eDP-1
[498.855037] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.609s)
[498.866543] Starting dynamic subtest: pipe-C-eDP-1
[503.433196] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.575s)
[503.445643] Starting dynamic subtest: pipe-D-eDP-1
[508.045203] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.607s)
[508.048158] Subtest tiling-none: SUCCESS (17.598s)
[508.916936] [095/156] (516s left) gen9_exec_parse (shadow-peek)
[508.981389] Subtest shadow-peek: SKIP (0.000s)
[509.044192] [096/156] (516s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[509.142079] Starting subtest: pr-plane-move-sf-dmg-area
[509.147268] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[509.212402] [097/156] (516s left) gem_mmap_wc (fault-concurrent)
[509.278645] Subtest fault-concurrent: SKIP (0.000s)
[509.367385] [098/156] (516s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[509.458279] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[509.463927] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[509.560469] [099/156] (516s left) syncobj_wait (invalid-wait-illegal-handle)
[509.620158] Starting subtest: invalid-wait-illegal-handle
[509.622817] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[509.725283] [100/156] (516s left) core_auth (basic-auth)
[509.778302] Starting subtest: basic-auth
[509.781002] Subtest basic-auth: SUCCESS (0.001s)
[509.874404] [101/156] (515s left) kms_cursor_edge_walk (128x128-right-edge)
[509.964017] Starting subtest: 128x128-right-edge
[509.966049] Starting dynamic subtest: pipe-A-eDP-1
[513.446277] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s)
[513.457233] Starting dynamic subtest: pipe-D-eDP-1
[516.642675] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.196s)
[516.645284] Subtest 128x128-right-edge: SUCCESS (6.676s)
[517.511602] [102/156] (508s left) perf_pmu (busy-double-start)
[517.558921] Starting subtest: busy-double-start
[517.561242] Starting dynamic subtest: rcs0
[521.208023] Dynamic subtest rcs0: FAIL (3.593s)
[521.221264] Starting dynamic subtest: bcs0
[524.743727] Dynamic subtest bcs0: SUCCESS (3.590s)
[524.758667] Starting dynamic subtest: vcs0
[528.834681] Dynamic subtest vcs0: SUCCESS (4.087s)
[528.848554] Starting dynamic subtest: vcs1
[532.863407] Dynamic subtest vcs1: SUCCESS (4.026s)
[532.877063] Starting dynamic subtest: vecs0
[536.839623] Dynamic subtest vecs0: SUCCESS (3.977s)
[536.853303] Starting dynamic subtest: ccs0
[540.494085] Dynamic subtest ccs0: FAIL (3.569s)
[540.496438] Subtest busy-double-start: FAIL (22.853s)
[540.550323] [103/156] (485s left) gem_tiled_blits (normal)
[540.616972] Subtest normal: SKIP (0.000s)
[540.710258] [104/156] (485s left) sriov_basic (enable-vfs-autoprobe-off)
[540.759881] Starting subtest: enable-vfs-autoprobe-off
[540.762230] Starting dynamic subtest: numvfs-1
[540.850234] Dynamic subtest numvfs-1: FAIL (0.007s)
[540.862619] Starting dynamic subtest: numvfs-2
[540.954947] Dynamic subtest numvfs-2: FAIL (0.003s)
[540.966660] Starting dynamic subtest: numvfs-3
[541.053145] Dynamic subtest numvfs-3: FAIL (0.003s)
[541.065384] Starting dynamic subtest: numvfs-4
[541.153139] Dynamic subtest numvfs-4: FAIL (0.003s)
[541.165165] Starting dynamic subtest: numvfs-5
[541.251484] Dynamic subtest numvfs-5: FAIL (0.004s)
[541.262412] Starting dynamic subtest: numvfs-6
[541.346321] Dynamic subtest numvfs-6: FAIL (0.004s)
[541.358002] Starting dynamic subtest: numvfs-7
[541.439470] Dynamic subtest numvfs-7: FAIL (0.003s)
[541.449839] Starting dynamic subtest: numvfs-random
[541.519980] Dynamic subtest numvfs-random: FAIL (0.003s)
[541.531186] Starting dynamic subtest: numvfs-all
[541.607232] Dynamic subtest numvfs-all: FAIL (0.610s)
[541.609396] Subtest enable-vfs-autoprobe-off: FAIL (0.649s)
[541.652537] [105/156] (484s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[541.751070] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[541.753166] Starting dynamic subtest: pipe-A-eDP-1
[557.883265] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.140s)
[557.895075] Starting dynamic subtest: pipe-B-eDP-1
[574.883509] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.437s)
[574.903011] Starting dynamic subtest: pipe-C-eDP-1
[591.874610] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.436s)
[591.889474] Starting dynamic subtest: pipe-D-eDP-1
[608.876749] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.424s)
[608.878956] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (9.441s)
[610.060907] [106/156] (415s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[610.172427] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[610.176849] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[610.264543] [107/156] (415s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[610.357092] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[610.359530] Starting dynamic subtest: pipe-A-default-mode
[611.494441] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[611.499461] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.135s)
[611.661803] [108/156] (414s left) prime_vgem (fence-read-hang)
[611.753077] Subtest fence-read-hang: SKIP (0.000s)
[611.855726] [109/156] (414s left) sw_sync (timeline_closed)
[611.886940] Starting subtest: timeline_closed
[611.889443] Subtest timeline_closed: SUCCESS (0.000s)
[611.958366] [110/156] (414s left) gem_lmem_swapping (parallel-random)
[611.998028] Subtest parallel-random: SKIP (0.000s)
[612.051209] [111/156] (414s left) perf (low-oa-exponent-permissions)
[612.181613] Starting subtest: low-oa-exponent-permissions
[612.215285] Subtest low-oa-exponent-permissions: SUCCESS (0.034s)
[612.265832] [112/156] (413s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[612.356502] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[612.360735] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[612.453311] [113/156] (413s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[612.550760] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[612.552690] Starting dynamic subtest: pipe-A
[612.574807] Dynamic subtest pipe-A: SKIP (0.021s)
[612.587899] Starting dynamic subtest: pipe-B
[612.609568] Dynamic subtest pipe-B: SKIP (0.033s)
[612.620767] Starting dynamic subtest: pipe-C
[612.643198] Dynamic subtest pipe-C: SKIP (0.033s)
[612.653855] Starting dynamic subtest: pipe-D
[612.676457] Dynamic subtest pipe-D: SKIP (0.033s)
[612.680041] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.121s)
[612.775120] [114/156] (413s left) gem_mmap_gtt (basic-read-write-distinct)
[612.825520] Subtest basic-read-write-distinct: SKIP (0.000s)
[612.886969] [115/156] (413s left) kms_chamelium_frames (hdmi-crc-multiple)
[613.261782] Subtest hdmi-crc-multiple: SKIP (0.000s)
[614.052900] [116/156] (412s left) gem_mmap_wc (read-write-distinct)
[614.107631] Subtest read-write-distinct: SKIP (0.000s)
[614.166008] [117/156] (412s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[614.259960] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[614.264384] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[614.349861] [118/156] (412s left) gem_ctx_exec (basic-invalid-context)
[614.406999] Starting subtest: basic-invalid-context
[614.412120] Subtest basic-invalid-context: SUCCESS (0.005s)
[614.527225] [119/156] (412s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-onoff)
[614.630492] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-onoff
[614.634843] Subtest fbchdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[614.744191] [120/156] (411s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[614.845896] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[614.848088] Starting dynamic subtest: pipe-A-eDP-1
[614.867348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[614.880544] Starting dynamic subtest: pipe-B-eDP-1
[614.900287] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[614.911329] Starting dynamic subtest: pipe-C-eDP-1
[614.931070] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[614.941874] Starting dynamic subtest: pipe-D-eDP-1
[614.961801] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[614.963640] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[617.160584] [121/156] (409s left) gem_mmap_gtt (hang-busy)
[617.219302] Subtest hang-busy: SKIP (0.000s)
[617.286310] [122/156] (409s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[617.385156] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[617.389236] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[617.491160] [123/156] (409s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[617.585801] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[617.590484] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[618.773321] [124/156] (408s left) kms_color (ctm-red-to-blue)
[618.868956] Starting subtest: ctm-red-to-blue
[618.871226] Starting dynamic subtest: pipe-A-eDP-1
[619.580802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[619.592582] Starting dynamic subtest: pipe-B-eDP-1
[621.060622] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.477s)
[621.072111] Starting dynamic subtest: pipe-C-eDP-1
[622.411443] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s)
[622.422439] Starting dynamic subtest: pipe-D-eDP-1
[623.804834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.392s)
[623.806997] Subtest ctm-red-to-blue: SUCCESS (4.933s)
[624.682058] [125/156] (402s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-gtt)
[624.791420] Starting subtest: hdr-rgb565-draw-mmap-gtt
[624.795728] Subtest hdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[624.895655] [126/156] (401s left) syncobj_timeline (wait-any-interrupted)
[624.967041] Starting subtest: wait-any-interrupted
[625.071226] Subtest wait-any-interrupted: SUCCESS (0.104s)
[625.167543] [127/156] (401s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt)
[625.277488] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt
[625.281783] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[625.404831] [128/156] (401s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[625.501626] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[625.505981] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[625.609085] [129/156] (401s left) kms_chamelium_color (ctm-max)
[625.696900] Subtest ctm-max: SKIP (0.000s)
[625.745064] [130/156] (401s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[625.838504] Starting subtest: yf-tiled-32bpp-rotate-0
[625.843028] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[625.950626] [131/156] (401s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[626.003998] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[626.008489] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[626.189280] [132/156] (400s left) kms_psr (pr-cursor-render)
[626.281057] Starting subtest: pr-cursor-render
[626.285567] Subtest pr-cursor-render: SKIP (0.000s)
[626.360701] [133/156] (400s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[626.452192] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[626.456489] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[626.546312] [134/156] (400s left) sysfs_heartbeat_interval (idempotent)
[626.603328] Starting subtest: idempotent
[626.605721] Starting dynamic subtest: vecs0
[626.608137] Dynamic subtest vecs0: SUCCESS (0.001s)
[626.620652] Starting dynamic subtest: ccs0
[626.622852] Dynamic subtest ccs0: SUCCESS (0.001s)
[626.633386] Starting dynamic subtest: vcs0
[626.635358] Dynamic subtest vcs0: SUCCESS (0.000s)
[626.645624] Starting dynamic subtest: bcs0
[626.647745] Dynamic subtest bcs0: SUCCESS (0.001s)
[626.658133] Starting dynamic subtest: rcs0
[626.660149] Dynamic subtest rcs0: SUCCESS (0.000s)
[626.675456] Starting dynamic subtest: vcs1
[626.677738] Dynamic subtest vcs1: SUCCESS (0.000s)
[626.680121] Subtest idempotent: SUCCESS (0.007s)
[626.724479] [135/156] (400s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[626.826758] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[626.828919] Starting dynamic subtest: pipe-A-default-mode
[628.001370] Dynamic subtest pipe-A-default-mode: SKIP (1.173s)
[628.005635] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.174s)
[628.169083] [136/156] (399s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[628.271098] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[628.917759] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[629.069015] [137/156] (398s left) gem_ppgtt (flink-and-close-vma-leak)
[629.123568] Starting subtest: flink-and-close-vma-leak
[629.165512] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[629.283417] [138/156] (398s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[629.412424] Starting subtest: cursorB-vs-flipB-atomic
[629.417037] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[629.572657] [139/156] (397s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[629.703119] Starting subtest: basic-busy-flip-before-cursor-legacy
[629.707734] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[629.848119] [140/156] (397s left) perf (polling)
[629.925087] Starting subtest: polling
[629.927163] Starting dynamic subtest: 0-rcs0
[639.941600] Dynamic subtest 0-rcs0: SUCCESS (10.010s)
[639.954151] Starting dynamic subtest: 1-vecs0
[649.960918] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[649.963469] Subtest polling: SUCCESS (20.033s)
[650.015133] [141/156] (377s left) gem_mmap_wc (pf-nonblock)
[650.069724] Subtest pf-nonblock: SKIP (0.000s)
[650.126873] [142/156] (377s left) perf_pmu (gt-awake)
[650.163883] Starting subtest: gt-awake
[659.014035] Subtest gt-awake: SUCCESS (8.850s)
[659.116300] [143/156] (368s left) fbdev (unaligned-read)
[659.165373] Starting subtest: unaligned-read
[659.179983] Subtest unaligned-read: SUCCESS (0.015s)
[659.247159] [144/156] (368s left) syncobj_wait (multi-wait-submitted-signaled)
[659.304772] Starting subtest: multi-wait-submitted-signaled
[659.307118] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[659.434230] [145/156] (368s left) kms_flip (flip-vs-panning)
[659.530743] Starting subtest: flip-vs-panning
[659.533078] Starting dynamic subtest: A-eDP1
[668.254226] Dynamic subtest A-eDP1: SUCCESS (8.721s)
[668.269391] Starting dynamic subtest: B-eDP1
[676.959094] Dynamic subtest B-eDP1: SUCCESS (8.700s)
[676.971194] Starting dynamic subtest: C-eDP1
[685.646185] Dynamic subtest C-eDP1: SUCCESS (8.683s)
[685.657196] Starting dynamic subtest: D-eDP1
[694.351596] Dynamic subtest D-eDP1: SUCCESS (8.701s)
[694.355933] Subtest flip-vs-panning: SUCCESS (34.815s)
[695.591962] [146/156] (332s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[695.690763] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[695.695056] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[695.790284] [147/156] (331s left) kms_prop_blob (blob-prop-validate)
[695.835766] Starting subtest: blob-prop-validate
[695.837918] Subtest blob-prop-validate: SUCCESS (0.000s)
[695.933415] [148/156] (331s left) gem_lmem_swapping (verify-random-ccs)
[695.978736] Subtest verify-random-ccs: SKIP (0.000s)
[696.019273] [149/156] (331s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-render)
[696.114000] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-render
[696.118261] Subtest hdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[696.213131] [150/156] (331s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[696.305273] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[696.309437] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[696.413501] [151/156] (331s left) kms_frontbuffer_tracking (fbchdr-tiling-y)
[696.510220] Starting subtest: fbchdr-tiling-y
[696.513758] Subtest fbchdr-tiling-y: SKIP (0.000s)
[696.607485] [152/156] (331s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[696.687814] Starting subtest: fbc-psr-sprite-mmap-cpu
[696.689765] Starting dynamic subtest: eDP-1
[696.693316] Dynamic subtest eDP-1: SKIP (0.000s)
[696.696871] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[696.763805] [153/156] (331s left) kms_hdr (static-toggle-suspend)
[696.854377] Starting subtest: static-toggle-suspend
[696.859924] Subtest static-toggle-suspend: SKIP (0.000s)
[696.931172] [154/156] (331s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[697.023557] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[697.027134] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[697.124635] [155/156] (330s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[697.206043] Starting subtest: fbc-psr2-cursor-mmap-cpu
[697.208037] Starting dynamic subtest: eDP-1
[697.211515] Dynamic subtest eDP-1: SKIP (0.000s)
[697.215091] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[697.283771] [156/156] (330s left) gem_softpin (noreloc)
[697.334073] Starting subtest: noreloc
[702.801487] Subtest noreloc: SUCCESS (5.410s)
[702.901398] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_hdmi_inject
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: dmabuf_sync_file
results: parsing output: 11/ for test: i915_pm_rpm
results: parsing output: 12/ for test: gem_ctx_isolation
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_hangman
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_setmode
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: gem_ctx_sseu
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: gem_userptr_blits
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: i915_pm_sseu
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_fence_thrash
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_render_tiled_blits
results: parsing output: 52/ for test: gem_workarounds
results: parsing output: 53/ for test: kms_feature_discovery
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_exec_params
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_busy
results: parsing output: 62/ for test: gem_exec_whisper
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: kms_psr2_su
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: api_intel_allocator
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_wait
results: parsing output: 80/ for test: kms_chamelium_hpd
results: parsing output: 81/ for test: kms_atomic_transition
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_lease
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: kms_pipe_crc_basic
results: parsing output: 87/ for test: kms_selftest
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: kms_plane_multiple
results: parsing output: 94/ for test: gen9_exec_parse
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: core_auth
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: gem_tiled_blits
results: parsing output: 103/ for test: sriov_basic
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: sw_sync
results: parsing output: 109/ for test: gem_lmem_swapping
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_chamelium_frames
results: parsing output: 115/ for test: gem_mmap_wc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_ctx_exec
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_color
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: sysfs_heartbeat_interval
results: parsing output: 134/ for test: kms_flip_scaled_crc
results: parsing output: 135/ for test: kms_big_fb
results: parsing output: 136/ for test: gem_ppgtt
results: parsing output: 137/ for test: kms_cursor_legacy
results: parsing output: 138/ for test: kms_cursor_legacy
results: parsing output: 139/ for test: perf
results: parsing output: 140/ for test: gem_mmap_wc
results: parsing output: 141/ for test: perf_pmu
results: parsing output: 142/ for test: fbdev
results: parsing output: 143/ for test: syncobj_wait
results: parsing output: 144/ for test: kms_flip
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_prop_blob
results: parsing output: 147/ for test: gem_lmem_swapping
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: kms_hdr
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_psr
results: parsing output: 155/ for test: gem_softpin
Done.