[58.739414] Initializing watchdogs
[58.739520]   /dev/watchdog0
[58.755473] [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]
[58.759943] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.762351] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.765847] [001/156] (960s left) gem_exec_balancer (sliced)
[58.855817] Starting subtest: sliced
[58.860561] Subtest sliced: SKIP (0.000s)
[59.180915] [002/156] (960s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[59.292043] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[59.294434] Starting dynamic subtest: pipe-A-eDP-1
[59.317335] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.326927] Starting dynamic subtest: pipe-B-eDP-1
[59.348429] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.356446] Starting dynamic subtest: pipe-C-eDP-1
[59.377920] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.385708] Starting dynamic subtest: pipe-D-eDP-1
[59.408489] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[59.412578] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[61.810579] [003/156] (957s left) kms_busy (extended-pageflip-hang-oldfb)
[61.908056] Starting subtest: extended-pageflip-hang-oldfb
[61.910416] Starting dynamic subtest: pipe-A
[62.347666] Dynamic subtest pipe-A: SUCCESS (0.445s)
[62.359208] Starting dynamic subtest: pipe-D
[63.497449] Dynamic subtest pipe-D: SUCCESS (1.162s)
[63.499739] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.610s)
[64.328562] [004/156] (955s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[64.439177] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[64.443602] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[64.524083] [005/156] (954s left) gem_exec_async (concurrent-writes)
[64.586592] Starting subtest: concurrent-writes
[64.589064] Starting dynamic subtest: rcs0
[64.606421] Dynamic subtest rcs0: SUCCESS (0.020s)
[64.615649] Starting dynamic subtest: bcs0
[64.617941] Dynamic subtest bcs0: SUCCESS (0.006s)
[64.628824] Starting dynamic subtest: vcs0
[64.630910] Dynamic subtest vcs0: SUCCESS (0.006s)
[64.639639] Starting dynamic subtest: vcs1
[64.641756] Dynamic subtest vcs1: SUCCESS (0.007s)
[64.649160] Starting dynamic subtest: vecs0
[64.651090] Dynamic subtest vecs0: SUCCESS (0.006s)
[64.658509] Starting dynamic subtest: ccs0
[64.660423] Dynamic subtest ccs0: SUCCESS (0.007s)
[64.662315] Subtest concurrent-writes: SUCCESS (0.054s)
[64.878188] [006/156] (954s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[64.945171] Starting subtest: yf-tiled-to-vebox-x-tiled
[64.949694] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[65.141828] [007/156] (954s left) gem_pxp (regular-baseline-src-copy-readible)
[65.274819] Starting subtest: regular-baseline-src-copy-readible
[65.332275] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[65.469841] [008/156] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[65.567425] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[72.428592] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.905s)
[72.712745] [009/156] (946s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render)
[72.874704] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render
[72.879319] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[73.207286] [010/156] (946s left) kms_psr (psr2-primary-render)
[73.332324] Starting subtest: psr2-primary-render
[73.334833] Starting dynamic subtest: eDP-1
[75.114269] Dynamic subtest eDP-1: SUCCESS (1.787s)
[75.116642] Subtest psr2-primary-render: SUCCESS (1.788s)
[75.973981] [011/156] (943s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[76.073045] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[76.075441] Starting dynamic subtest: pipe-A-eDP-1
[76.157136] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s)
[76.167114] Starting dynamic subtest: pipe-B-eDP-1
[77.358464] Dynamic subtest pipe-B-eDP-1: SKIP (1.202s)
[77.363247] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.293s)
[78.558949] [012/156] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[78.665732] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[78.670163] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[78.771218] [013/156] (940s left) kms_chamelium_frames (hdmi-crc-fast)
[79.166361] Subtest hdmi-crc-fast: SKIP (0.000s)
[79.960263] [014/156] (939s left) gen7_exec_parse (oacontrol-tracking)
[80.025240] Subtest oacontrol-tracking: SKIP (0.000s)
[80.087311] [015/156] (939s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[80.187339] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[84.915631] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.736s)
[85.025690] [016/156] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[85.138128] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[85.142314] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[85.243839] [017/156] (934s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[85.351797] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[85.356077] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[85.452314] [018/156] (934s left) gem_exec_schedule (semaphore-codependency)
[85.527176] Starting subtest: semaphore-codependency
[85.531839] Subtest semaphore-codependency: SUCCESS (0.013s)
[85.879686] [019/156] (934s left) gem_gtt_cpu_tlb
[85.988522] [020/156] (934s left) sw_sync (sync_expired_merge)
[86.021348] Starting subtest: sync_expired_merge
[87.095575] Subtest sync_expired_merge: SUCCESS (1.074s)
[87.154042] [021/156] (932s left) kms_vblank (query-busy)
[87.255997] Starting subtest: query-busy
[87.258020] Starting dynamic subtest: pipe-A-eDP-1
[89.142314] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[89.158751] Starting dynamic subtest: pipe-D-eDP-1
[91.772310] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.628s)
[91.774602] Subtest query-busy: SUCCESS (4.516s)
[92.581464] [022/156] (927s left) gem_userptr_blits (set-cache-level)
[92.655581] Starting subtest: set-cache-level
[92.659666] Subtest set-cache-level: SKIP (0.000s)
[92.795840] [023/156] (927s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-blt)
[92.897237] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-blt
[92.901738] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[93.018594] [024/156] (927s left) kms_addfb_basic (invalid-set-prop)
[93.065546] Starting subtest: invalid-set-prop
[93.067733] Subtest invalid-set-prop: SUCCESS (0.000s)
[93.186375] [025/156] (927s left) kms_pm_rpm (pm-tiling)
[95.416577] Starting subtest: pm-tiling
[95.421604] Subtest pm-tiling: SKIP (0.000s)
[95.815761] [026/156] (924s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[95.919639] Starting subtest: 4-tiled-64bpp-rotate-90
[95.942887] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[96.037042] [027/156] (924s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[96.130051] Starting subtest: hdr-rgb101010-draw-blt
[96.134400] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s)
[96.221716] [028/156] (924s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[96.329654] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[96.334488] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[96.431330] [029/156] (923s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-blt)
[96.527797] Starting subtest: fbcpsrhdr-rgb101010-draw-blt
[96.531748] Subtest fbcpsrhdr-rgb101010-draw-blt: SKIP (0.000s)
[96.619098] [030/156] (923s left) gem_exec_reloc (basic-write-read-noreloc)
[96.672978] Subtest basic-write-read-noreloc: SKIP (0.000s)
[96.743557] [031/156] (923s left) syncobj_timeline (invalid-query-illegal-handle)
[96.803224] Starting subtest: invalid-query-illegal-handle
[96.805180] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[96.916395] [032/156] (923s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[97.021029] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[97.024517] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[97.111092] [033/156] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[97.203554] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[104.568111] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.369s)
[104.718926] [034/156] (915s left) core_hotunplug (unbind-rebind)
[104.804649] Starting subtest: unbind-rebind
[110.739938] Subtest unbind-rebind: SUCCESS (5.935s)
[110.784071] [035/156] (909s left) gem_create (busy-create)
[112.294238] Starting subtest: busy-create
[112.297516] Starting dynamic subtest: smem0
[146.317065] Dynamic subtest smem0: SUCCESS (34.019s)
[146.319578] Subtest busy-create: SUCCESS (34.021s)
[146.499609] [036/156] (874s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-fullscreen)
[146.617308] Starting subtest: fbchdr-1p-primscrn-spr-indfb-fullscreen
[146.621939] Subtest fbchdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[146.718293] [037/156] (873s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[146.770807] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[146.773091] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[146.869091] [038/156] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[146.966062] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[146.970272] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[147.082687] [039/156] (873s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[147.187399] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[148.322447] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.135s)
[148.424883] [040/156] (872s left) kms_flip (2x-wf_vblank-ts-check)
[148.522099] Starting subtest: 2x-wf_vblank-ts-check
[148.531277] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[148.638289] [041/156] (872s left) api_intel_allocator (simple-allocator)
[148.692573] Starting subtest: simple-allocator
[148.694678] Starting dynamic subtest: basic
[148.696760] Dynamic subtest basic: SUCCESS (0.003s)
[148.709942] Starting dynamic subtest: parallel-one
[148.861982] Dynamic subtest parallel-one: SUCCESS (0.166s)
[148.872260] Starting dynamic subtest: print
[148.874522] Dynamic subtest print: SUCCESS (0.000s)
[148.884126] Starting dynamic subtest: reuse
[148.886083] Dynamic subtest reuse: SUCCESS (0.000s)
[148.894728] Starting dynamic subtest: reserve
[148.896694] Dynamic subtest reserve: SUCCESS (0.000s)
[148.905382] Starting dynamic subtest: fork-reopen-allocator
[148.907359] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[148.909360] Subtest simple-allocator: SUCCESS (0.186s)
[149.001727] [042/156] (871s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[149.084882] Starting subtest: bad-aux-stride-y-tiled-ccs
[149.087077] Starting dynamic subtest: pipe-A-eDP-1
[149.109217] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.119128] Starting dynamic subtest: pipe-B-eDP-1
[149.140323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.149157] Starting dynamic subtest: pipe-C-eDP-1
[149.170460] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.180243] Starting dynamic subtest: pipe-D-eDP-1
[149.203043] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.207484] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[151.401389] [043/156] (869s left) gem_eio (suspend)
[151.638155] Starting subtest: suspend
[163.922309] Subtest suspend: SUCCESS (12.282s)
[164.037555] [044/156] (856s left) kms_frontbuffer_tracking (fbchdr-suspend)
[164.139849] Starting subtest: fbchdr-suspend
[164.143918] Subtest fbchdr-suspend: SKIP (0.000s)
[164.232287] [045/156] (856s left) kms_cursor_crc (cursor-onscreen-256x256)
[164.490108] Starting subtest: cursor-onscreen-256x256
[164.494936] Starting dynamic subtest: pipe-A-eDP-1
[166.644071] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.148s)
[166.681207] Starting dynamic subtest: pipe-D-eDP-1
[169.409819] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.739s)
[169.412118] Subtest cursor-onscreen-256x256: SUCCESS (4.918s)
[170.279347] [046/156] (850s left) gem_exec_fence (syncobj-timeline-unused-fence)
[170.860883] Starting subtest: syncobj-timeline-unused-fence
[170.867127] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[172.394308] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[172.397912] [047/156] (848s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[172.502359] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[176.222822] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.727s)
[177.395114] [048/156] (843s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[177.784225] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[178.592807] [049/156] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[178.691723] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[178.696094] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[178.815744] [050/156] (842s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[178.911561] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[178.915793] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[179.003975] [051/156] (842s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-render)
[179.105328] Starting subtest: psrhdr-rgb101010-draw-render
[179.109618] Subtest psrhdr-rgb101010-draw-render: SKIP (0.000s)
[179.209492] [052/156] (842s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[179.306117] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[182.939451] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.640s)
[184.125354] [053/156] (837s left) kms_force_connector_basic (prune-stale-modes)
[184.209827] Starting subtest: prune-stale-modes
[184.654343] Subtest prune-stale-modes: SUCCESS (0.445s)
[184.795679] [054/156] (836s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[184.900738] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[184.905254] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[184.998408] [055/156] (836s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-render)
[185.102601] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-render
[185.106085] Subtest psrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[185.198906] [056/156] (836s left) gem_exec_reloc (basic-wc-gtt)
[185.247763] Subtest basic-wc-gtt: SKIP (0.000s)
[185.322845] [057/156] (836s left) i915_pm_rpm (reg-read-ioctl)
[187.450771] Starting subtest: reg-read-ioctl
[189.743986] Subtest reg-read-ioctl: SUCCESS (2.295s)
[190.135736] [058/156] (831s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[190.252482] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[191.220700] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.966s)
[192.042686] [059/156] (829s left) gem_mmap_gtt (basic-read-write)
[192.111651] Subtest basic-read-write: SKIP (0.000s)
[192.176543] [060/156] (829s left) kms_content_protection (mei-interface)
[192.326848] Starting subtest: mei-interface
[192.331427] Subtest mei-interface: SKIP (0.001s)
[192.441866] [061/156] (829s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[192.498795] Starting subtest: legacy-engines-hostile-preempt
[192.501118] Starting dynamic subtest: render
[192.574566] Dynamic subtest render: SUCCESS (0.074s)
[192.586224] Starting dynamic subtest: bsd1
[194.302229] Dynamic subtest bsd1: SUCCESS (1.724s)
[194.314923] Starting dynamic subtest: bsd2
[196.262656] Dynamic subtest bsd2: SUCCESS (1.958s)
[196.279459] Starting dynamic subtest: blt
[196.339062] Dynamic subtest blt: SUCCESS (0.075s)
[196.353266] Starting dynamic subtest: vebox
[198.247360] Dynamic subtest vebox: SUCCESS (1.904s)
[198.249998] Subtest legacy-engines-hostile-preempt: SUCCESS (5.748s)
[198.390245] [062/156] (823s left) kms_cursor_legacy (torture-bo)
[198.532596] Starting subtest: torture-bo
[198.534776] Starting dynamic subtest: pipe-A
[204.454640] Dynamic subtest pipe-A: SUCCESS (5.865s)
[204.469647] Starting dynamic subtest: pipe-B
[210.729514] Dynamic subtest pipe-B: SUCCESS (6.324s)
[210.741792] Starting dynamic subtest: pipe-C
[218.138278] Dynamic subtest pipe-C: SUCCESS (7.406s)
[218.152489] Starting dynamic subtest: pipe-D
[225.625824] Dynamic subtest pipe-D: SUCCESS (7.487s)
[225.636644] Starting dynamic subtest: all-pipes
[232.327741] Dynamic subtest all-pipes: SUCCESS (6.697s)
[232.330691] Subtest torture-bo: SUCCESS (33.787s)
[232.491350] [063/156] (789s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[232.549672] Starting subtest: etime-single-wait-for-submit-unsubmitted
[232.650508] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[232.743382] [064/156] (789s left) api_intel_bb (full-batch)
[232.800553] Starting subtest: full-batch
[232.805702] Subtest full-batch: SUCCESS (0.006s)
[232.930676] [065/156] (788s left) kms_atomic (plane-invalid-params)
[233.028118] Starting subtest: plane-invalid-params
[233.030699] Starting dynamic subtest: pipe-A-eDP-1
[233.435075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s)
[233.437216] Subtest plane-invalid-params: SUCCESS (0.408s)
[234.259940] [066/156] (787s left) gem_mmap_wc (invalid-flags)
[234.312098] Subtest invalid-flags: SKIP (0.000s)
[234.378179] [067/156] (787s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[234.480578] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[234.484716] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[234.599904] [068/156] (787s left) sw_sync (sync_multi_consumer_producer)
[234.638343] Starting subtest: sync_multi_consumer_producer
[234.899493] Subtest sync_multi_consumer_producer: SUCCESS (0.265s)
[234.963398] [069/156] (787s left) gen3_render_tiledx_blits
[235.073665] [070/156] (787s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[235.173519] Starting subtest: x-tiled-16bpp-rotate-270
[235.193525] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[235.321870] [071/156] (786s left) gem_pread (bench)
[235.382256] Subtest bench: SKIP (0.000s)
[235.446184] [072/156] (786s left) prime_vgem (basic-fence-flip)
[235.527951] Starting subtest: basic-fence-flip
[235.818713] Subtest basic-fence-flip: SUCCESS (0.293s)
[235.924355] [073/156] (786s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[236.021714] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[239.923501] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.907s)
[241.154015] [074/156] (781s left) perf (blocking-parameterized)
[241.275938] Starting subtest: blocking-parameterized
[261.349090] Subtest blocking-parameterized: SUCCESS (20.021s)
[261.393892] [075/156] (760s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[261.443429] Starting subtest: etime-multi-wait-all-available-unsubmitted
[261.546080] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.103s)
[261.628563] [076/156] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[261.732759] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[261.736697] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[261.834414] [077/156] (760s left) kms_psr (psr2-cursor-plane-onoff)
[261.920929] Starting subtest: psr2-cursor-plane-onoff
[261.923271] Starting dynamic subtest: eDP-1
[263.663844] Dynamic subtest eDP-1: SUCCESS (1.741s)
[263.665881] Subtest psr2-cursor-plane-onoff: SUCCESS (1.742s)
[264.539168] [078/156] (757s left) i915_query (hwconfig_table)
[264.591066] Starting subtest: hwconfig_table
[264.879690] Subtest hwconfig_table: SUCCESS (0.001s)
[264.920586] [079/156] (757s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[265.023792] Starting subtest: psrhdr-shrfb-scaledprimary
[265.027840] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[265.142340] [080/156] (757s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[265.200518] Subtest untiled-to-tiled: SKIP (0.000s)
[265.276892] [081/156] (757s left) kms_concurrent (multi-plane-atomic-lowres)
[265.373527] Starting subtest: multi-plane-atomic-lowres
[265.375816] Starting dynamic subtest: pipe-A-eDP-1
[265.893350] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.519s)
[265.906768] Starting dynamic subtest: pipe-B-eDP-1
[267.148787] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s)
[267.160682] Starting dynamic subtest: pipe-C-eDP-1
[268.441153] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.290s)
[268.452409] Starting dynamic subtest: pipe-D-eDP-1
[269.723367] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.280s)
[269.726270] Subtest multi-plane-atomic-lowres: SUCCESS (4.349s)
[270.522463] [082/156] (752s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[270.806680] Starting subtest: cursor-rapid-movement-256x85
[270.858252] Subtest cursor-rapid-movement-256x85: SKIP (0.047s)
[271.076515] [083/156] (751s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[271.174542] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[271.176764] Starting dynamic subtest: pipe-A
[272.220855] Dynamic subtest pipe-A: SUCCESS (1.049s)
[272.231488] Starting dynamic subtest: pipe-B
[274.309500] Dynamic subtest pipe-B: SUCCESS (2.088s)
[274.322194] Starting dynamic subtest: pipe-C
[275.480810] Dynamic subtest pipe-C: SUCCESS (1.170s)
[275.497110] Starting dynamic subtest: pipe-D
[276.678572] Dynamic subtest pipe-D: SUCCESS (1.197s)
[276.680931] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.507s)
[277.831159] [084/156] (744s left) gem_ctx_persistence (engines-persistence)
[277.888845] Starting subtest: engines-persistence
[277.891269] Starting dynamic subtest: rcs0
[278.659905] Dynamic subtest rcs0: SUCCESS (0.770s)
[278.673457] Starting dynamic subtest: bcs0
[279.425237] Dynamic subtest bcs0: SUCCESS (0.763s)
[279.438830] Starting dynamic subtest: vcs0
[280.186903] Dynamic subtest vcs0: SUCCESS (0.760s)
[280.199921] Starting dynamic subtest: vcs1
[280.969258] Dynamic subtest vcs1: SUCCESS (0.780s)
[280.982091] Starting dynamic subtest: vecs0
[281.702055] Dynamic subtest vecs0: SUCCESS (0.729s)
[281.714962] Starting dynamic subtest: ccs0
[282.500088] Dynamic subtest ccs0: SUCCESS (0.797s)
[282.503087] Subtest engines-persistence: SUCCESS (4.612s)
[282.612597] [085/156] (740s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[282.714646] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[282.719057] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[282.793207] [086/156] (740s left) kms_psr (psr-sprite-mmap-cpu)
[282.883378] Starting subtest: psr-sprite-mmap-cpu
[282.885682] Starting dynamic subtest: eDP-1
[284.597465] Dynamic subtest eDP-1: SUCCESS (1.713s)
[284.599343] Subtest psr-sprite-mmap-cpu: SUCCESS (1.714s)
[285.428541] [087/156] (737s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[285.532669] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[285.536862] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[285.617346] [088/156] (737s left) kms_pm_lpsp (screens-disabled)
[286.720649] Starting subtest: screens-disabled
[286.724998] Subtest screens-disabled: SKIP (0.000s)
[286.805104] [089/156] (736s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[286.908613] Starting subtest: y-tiled-addfb-size-offset-overflow
[286.912861] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[287.001517] [090/156] (735s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[287.046972] Starting subtest: invalid-smem-bo-on-discrete
[287.051185] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[287.177586] [091/156] (735s left) gem_exec_whisper (basic-contexts-priority)
[287.247916] Starting subtest: basic-contexts-priority
[310.751923] Subtest basic-contexts-priority: SUCCESS (23.499s)
[310.939368] [092/156] (712s left) vgem_basic (bad-fence)
[310.988079] Starting subtest: bad-fence
[310.990238] Subtest bad-fence: SUCCESS (0.000s)
[311.046619] [093/156] (712s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[311.138712] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[311.141231] Starting dynamic subtest: pipe-A-eDP-1
[311.898932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.754s)
[311.911707] Starting dynamic subtest: pipe-B-eDP-1
[313.733336] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.833s)
[313.744518] Starting dynamic subtest: pipe-C-eDP-1
[315.551092] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.816s)
[315.562261] Starting dynamic subtest: pipe-D-eDP-1
[317.338590] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.786s)
[317.340924] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.194s)
[318.539557] [094/156] (704s left) kms_addfb_basic (unused-handle)
[318.604392] Starting subtest: unused-handle
[318.606903] Subtest unused-handle: SUCCESS (0.000s)
[318.767142] [095/156] (704s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[318.859607] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[318.863596] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[318.950302] [096/156] (704s left) gem_exec_reloc (basic-write-gtt)
[319.011918] Subtest basic-write-gtt: SKIP (0.000s)
[319.096483] [097/156] (704s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[319.220585] Starting subtest: 2x-long-flip-vs-cursor-atomic
[319.225116] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[319.371433] [098/156] (703s left) gem_exec_fence (syncobj-timeline-repeat)
[319.938669] Starting subtest: syncobj-timeline-repeat
[320.195490] Subtest syncobj-timeline-repeat: SUCCESS (0.257s)
[321.357448] [099/156] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[321.455629] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[321.459994] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[321.558229] [100/156] (701s left) kms_psr (fbc-pr-primary-page-flip)
[321.656250] Starting subtest: fbc-pr-primary-page-flip
[321.660571] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[321.732199] [101/156] (701s left) kms_vblank (crtc-id)
[321.822421] Starting subtest: crtc-id
[321.824574] Starting dynamic subtest: pipe-A-eDP-1
[322.278565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[322.297789] Starting dynamic subtest: pipe-D-eDP-1
[323.413124] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[323.415155] Subtest crtc-id: SUCCESS (1.590s)
[324.235277] [102/156] (699s left) i915_drm_fdinfo (busy-check-all)
[324.275340] Starting subtest: busy-check-all
[324.277683] Starting dynamic subtest: rcs0
[324.284391] Dynamic subtest rcs0: SKIP (0.006s)
[324.297208] Starting dynamic subtest: bcs0
[324.301200] Dynamic subtest bcs0: SKIP (0.001s)
[324.312294] Starting dynamic subtest: vcs0
[324.316736] Dynamic subtest vcs0: SKIP (0.000s)
[324.327204] Starting dynamic subtest: vcs1
[324.331241] Dynamic subtest vcs1: SKIP (0.000s)
[324.341435] Starting dynamic subtest: vecs0
[324.345574] Dynamic subtest vecs0: SKIP (0.000s)
[324.355778] Starting dynamic subtest: ccs0
[324.359965] Dynamic subtest ccs0: SKIP (0.000s)
[324.364427] Subtest busy-check-all: SKIP (0.015s)
[324.407150] [103/156] (699s left) kms_cursor_crc (cursor-sliding-512x170)
[324.743746] Starting subtest: cursor-sliding-512x170
[324.748142] Subtest cursor-sliding-512x170: SKIP (0.001s)
[324.887639] [104/156] (698s left) kms_big_fb (linear-16bpp-rotate-90)
[324.990402] Starting subtest: linear-16bpp-rotate-90
[325.009828] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[325.129089] [105/156] (698s left) kms_flip (plain-flip-fb-recreate-interruptible)
[325.222374] Starting subtest: plain-flip-fb-recreate-interruptible
[325.224220] Starting dynamic subtest: A-eDP1
[334.089690] Dynamic subtest A-eDP1: SUCCESS (8.865s)
[334.105598] Starting dynamic subtest: B-eDP1
[342.984012] Dynamic subtest B-eDP1: SUCCESS (8.891s)
[342.995548] Starting dynamic subtest: C-eDP1
[351.796501] Dynamic subtest C-eDP1: SUCCESS (8.810s)
[351.808915] Starting dynamic subtest: D-eDP1
[360.673291] Dynamic subtest D-eDP1: SUCCESS (8.875s)
[360.677517] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.453s)
[361.952216] [106/156] (661s left) syncobj_wait (multi-wait-for-submit-submitted)
[362.005748] Starting subtest: multi-wait-for-submit-submitted
[362.106222] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[362.199216] [107/156] (661s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[362.291678] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[362.295957] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[362.389896] [108/156] (661s left) perf_pmu (most-busy-check-all)
[362.430183] Starting subtest: most-busy-check-all
[362.432334] Starting dynamic subtest: rcs0
[364.288810] Dynamic subtest rcs0: SUCCESS (1.857s)
[364.300956] Starting dynamic subtest: bcs0
[366.272054] Dynamic subtest bcs0: SUCCESS (1.980s)
[366.287041] Starting dynamic subtest: vcs0
[368.319579] Dynamic subtest vcs0: SUCCESS (2.045s)
[368.334116] Starting dynamic subtest: vcs1
[370.303815] Dynamic subtest vcs1: SUCCESS (1.981s)
[370.318333] Starting dynamic subtest: vecs0
[372.287856] Dynamic subtest vecs0: SUCCESS (1.981s)
[372.302804] Starting dynamic subtest: ccs0
[374.271681] Dynamic subtest ccs0: SUCCESS (1.981s)
[374.274558] Subtest most-busy-check-all: SUCCESS (11.841s)
[374.376717] [109/156] (649s left) kms_plane (pixel-format-y-tiled-modifier)
[374.473070] Starting subtest: pixel-format-y-tiled-modifier
[374.477083] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[374.548171] [110/156] (649s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte)
[374.638902] Starting subtest: fbcpsrhdr-2p-rte
[374.643257] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s)
[374.742575] [111/156] (649s left) kms_atomic_interruptible (universal-setplane-cursor)
[374.841719] Starting subtest: universal-setplane-cursor
[374.843977] Starting dynamic subtest: pipe-A-eDP-1
[382.316444] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.474s)
[382.318904] Subtest universal-setplane-cursor: SUCCESS (7.476s)
[383.124342] [112/156] (640s left) gem_eio (in-flight-contexts-immediate)
[383.320067] Starting subtest: in-flight-contexts-immediate
[395.291211] Subtest in-flight-contexts-immediate: SUCCESS (11.968s)
[395.414187] [113/156] (628s left) kms_psr (fbc-psr-primary-render)
[395.502088] Starting subtest: fbc-psr-primary-render
[395.504341] Starting dynamic subtest: eDP-1
[395.508393] Dynamic subtest eDP-1: SKIP (0.000s)
[395.512424] Subtest fbc-psr-primary-render: SKIP (0.002s)
[395.581122] [114/156] (628s left) kms_vrr (lobf)
[395.676149] Starting subtest: lobf
[395.680624] Subtest lobf: SKIP (0.000s)
[395.757175] [115/156] (628s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[395.886494] Starting subtest: cursorB-vs-flipA-toggle
[395.891085] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[396.036844] [116/156] (628s left) gem_mmap_offset (clear-via-pagefault)
[396.094419] Starting subtest: clear-via-pagefault
[396.096767] Starting dynamic subtest: smem0
[427.360523] Dynamic subtest smem0: SUCCESS (31.256s)
[427.362819] Subtest clear-via-pagefault: SUCCESS (31.258s)
[427.473244] [117/156] (596s left) gem_softpin (allocator-evict)
[427.530715] Starting subtest: allocator-evict
[427.533432] Starting dynamic subtest: rcs0
[451.910720] Dynamic subtest rcs0: SUCCESS (24.378s)
[451.923724] Starting dynamic subtest: bcs0
[476.128935] Dynamic subtest bcs0: SUCCESS (24.216s)
[476.142332] Starting dynamic subtest: vcs0
[499.854383] Dynamic subtest vcs0: SUCCESS (23.722s)
[499.867261] Starting dynamic subtest: vcs1
[523.481557] Dynamic subtest vcs1: SUCCESS (23.625s)
[523.493749] Starting dynamic subtest: vecs0
[547.350349] Dynamic subtest vecs0: SUCCESS (23.867s)
[547.362703] Starting dynamic subtest: ccs0
[570.969034] Dynamic subtest ccs0: SUCCESS (23.616s)
[570.971947] Subtest allocator-evict: SUCCESS (143.432s)
[571.067269] [118/156] (453s left) kms_psr (fbc-psr2-cursor-plane-move)
[571.226753] Starting subtest: fbc-psr2-cursor-plane-move
[571.229086] Starting dynamic subtest: eDP-1
[571.233169] Dynamic subtest eDP-1: SKIP (0.000s)
[571.237179] Subtest fbc-psr2-cursor-plane-move: SKIP (0.002s)
[571.304454] [119/156] (452s left) gem_exec_balancer (invalid-bonds)
[571.366549] Starting subtest: invalid-bonds
[571.370975] Subtest invalid-bonds: SKIP (0.000s)
[571.689705] [120/156] (452s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[571.790423] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[571.795046] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[571.888510] [121/156] (452s left) kms_draw_crc (draw-method-mmap-gtt)
[571.983070] Starting subtest: draw-method-mmap-gtt
[571.987559] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[572.067269] [122/156] (452s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[572.164102] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[572.168266] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[572.268197] [123/156] (452s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[572.362645] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[572.366798] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[572.459917] [124/156] (452s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[572.556076] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-pwrite
[572.560457] Subtest psrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[572.645121] [125/156] (451s left) gem_exec_reloc (basic-write-wc)
[572.694099] Subtest basic-write-wc: SKIP (0.000s)
[572.770846] [126/156] (451s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[572.869469] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[572.873213] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[572.943110] [127/156] (451s left) i915_pciid
[573.104572] [128/156] (451s left) gem_mmap_gtt (cpuset-big-copy-odd)
[573.158670] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[573.227323] [129/156] (451s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[573.331112] Starting subtest: primary-y-tiled-reflect-x-270
[573.334781] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[573.408985] [130/156] (451s left) syncobj_timeline (single-wait-available-submitted)
[573.456813] Starting subtest: single-wait-available-submitted
[573.458807] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[573.564183] [131/156] (451s left) kms_flip (2x-flip-vs-panning-vs-hang)
[573.652699] Starting subtest: 2x-flip-vs-panning-vs-hang
[573.656418] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[573.763552] [132/156] (451s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[573.861921] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[573.865480] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[573.958412] [133/156] (450s left) kms_plane_multiple (2x-tiling-none)
[574.046477] Starting subtest: 2x-tiling-none
[574.050031] Subtest 2x-tiling-none: SKIP (0.000s)
[574.120760] [134/156] (450s left) gem_lmem_swapping (heavy-multi)
[574.158268] Subtest heavy-multi: SKIP (0.000s)
[574.207672] [135/156] (450s left) gem_userptr_blits (create-destroy-sync)
[574.270816] Starting subtest: create-destroy-sync
[579.334075] Subtest create-destroy-sync: SUCCESS (5.009s)
[579.433183] [136/156] (445s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[579.532055] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[579.536499] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[579.643827] [137/156] (445s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[579.743732] Starting subtest: fbcpsrhdr-stridechange
[579.748214] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[579.842351] [138/156] (445s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[579.943961] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[579.948437] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[580.042307] [139/156] (445s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[580.137674] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[580.149988] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[580.231175] [140/156] (444s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[580.324293] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[580.327591] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[580.404081] [141/156] (444s left) gem_exec_schedule (manyslice)
[580.472707] Starting subtest: manyslice
[580.474647] Starting dynamic subtest: rcs0
[585.657610] Dynamic subtest rcs0: SUCCESS (5.139s)
[585.673679] Starting dynamic subtest: bcs0
[592.298745] Dynamic subtest bcs0: SUCCESS (6.640s)
[592.311420] Starting dynamic subtest: vcs0
[597.888051] Dynamic subtest vcs0: SUCCESS (5.587s)
[597.901112] Starting dynamic subtest: vcs1
[603.473293] Dynamic subtest vcs1: SUCCESS (5.583s)
[603.486076] Starting dynamic subtest: vecs0
[608.992854] Dynamic subtest vecs0: SUCCESS (5.568s)
[609.007541] Starting dynamic subtest: ccs0
[616.201456] Dynamic subtest ccs0: SUCCESS (7.207s)
[616.203906] Subtest manyslice: SUCCESS (35.734s)
[616.505234] [142/156] (408s left) kms_flip (plain-flip-interruptible)
[616.595277] Starting subtest: plain-flip-interruptible
[616.597584] Starting dynamic subtest: A-eDP1
[618.280393] Dynamic subtest A-eDP1: SUCCESS (1.683s)
[618.295175] Starting dynamic subtest: B-eDP1
[619.984799] Dynamic subtest B-eDP1: SUCCESS (1.702s)
[619.997712] Starting dynamic subtest: C-eDP1
[621.668645] Dynamic subtest C-eDP1: SUCCESS (1.683s)
[621.683421] Starting dynamic subtest: D-eDP1
[623.359708] Dynamic subtest D-eDP1: SUCCESS (1.689s)
[623.364985] Subtest plain-flip-interruptible: SUCCESS (6.769s)
[624.625899] [143/156] (400s left) gem_eio (execbuf)
[624.853085] Starting subtest: execbuf
[625.185994] Subtest execbuf: SUCCESS (0.333s)
[625.315389] [144/156] (400s left) kms_invalid_mode (overflow-vrefresh)
[625.417674] Starting subtest: overflow-vrefresh
[625.419907] Starting dynamic subtest: pipe-A-eDP-1
[625.707452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[625.719223] Starting dynamic subtest: pipe-B-eDP-1
[625.721147] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[625.732919] Starting dynamic subtest: pipe-C-eDP-1
[625.735142] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[625.748453] Starting dynamic subtest: pipe-D-eDP-1
[625.750818] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[625.753227] Subtest overflow-vrefresh: SUCCESS (0.296s)
[626.516454] [145/156] (398s left) kms_plane_alpha_blend (constant-alpha-min)
[626.606099] Starting subtest: constant-alpha-min
[626.910390] Starting dynamic subtest: pipe-A-eDP-1
[627.716745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.803s)
[627.729654] Starting dynamic subtest: pipe-D-eDP-1
[629.372424] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.655s)
[629.374835] Subtest constant-alpha-min: SUCCESS (2.766s)
[630.196919] [146/156] (395s left) gem_ctx_param (invalid-size-get)
[630.256785] Starting subtest: invalid-size-get
[630.259174] Subtest invalid-size-get: SUCCESS (0.001s)
[630.366687] [147/156] (395s left) kms_plane_scaling (planes-downscale-factor-0-5)
[630.462838] Starting subtest: planes-downscale-factor-0-5
[630.465136] Starting dynamic subtest: pipe-A
[630.486612] Dynamic subtest pipe-A: SKIP (0.020s)
[630.500244] Starting dynamic subtest: pipe-B
[630.521454] Dynamic subtest pipe-B: SKIP (0.034s)
[630.533221] Starting dynamic subtest: pipe-C
[630.557806] Dynamic subtest pipe-C: SKIP (0.033s)
[630.569359] Starting dynamic subtest: pipe-D
[630.592103] Dynamic subtest pipe-D: SKIP (0.037s)
[630.596232] Subtest planes-downscale-factor-0-5: SKIP (0.127s)
[630.685488] [148/156] (394s left) kms_mmap_write_crc (main)
[630.779144] Starting subtest: main
[630.781540] Starting dynamic subtest: pipe-A-eDP-1
[634.427997] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.645s)
[634.430500] Subtest main: SUCCESS (3.646s)
[635.315612] [149/156] (390s left) syncobj_eventfd (binary-wait)
[635.365657] Starting subtest: binary-wait
[635.373968] Subtest binary-wait: SUCCESS (0.011s)
[635.489652] [150/156] (390s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[635.595216] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[642.165364] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.576s)
[642.304862] [151/156] (383s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[642.403013] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[642.405310] Starting dynamic subtest: pipe-A-eDP-1
[642.428127] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[642.441777] Starting dynamic subtest: pipe-B-eDP-1
[642.462253] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[642.473608] Starting dynamic subtest: pipe-C-eDP-1
[642.495189] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[642.507588] Starting dynamic subtest: pipe-D-eDP-1
[642.528871] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[642.533168] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[644.692149] [152/156] (381s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt)
[644.797566] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt
[644.802185] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[644.891336] [153/156] (380s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[644.984298] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[644.986630] Starting dynamic subtest: pipe-A-eDP-1
[644.996032] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[645.010381] Starting dynamic subtest: pipe-B-eDP-1
[645.019281] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[645.030825] Starting dynamic subtest: pipe-C-eDP-1
[645.039615] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[645.050812] Starting dynamic subtest: pipe-D-eDP-1
[645.059376] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[645.063477] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[647.202543] [154/156] (378s left) gem_busy (extended)
[647.390692] Starting subtest: extended
[647.392841] Starting dynamic subtest: rcs0
[647.462927] Dynamic subtest rcs0: SUCCESS (0.075s)
[647.476912] Starting dynamic subtest: bcs0
[647.504167] Dynamic subtest bcs0: SUCCESS (0.040s)
[647.519075] Starting dynamic subtest: vcs0
[649.279344] Dynamic subtest vcs0: SUCCESS (1.771s)
[649.294786] Starting dynamic subtest: vcs1
[651.326517] Dynamic subtest vcs1: SUCCESS (2.044s)
[651.342582] Starting dynamic subtest: vecs0
[653.310812] Dynamic subtest vecs0: SUCCESS (1.980s)
[653.325239] Starting dynamic subtest: ccs0
[653.356084] Dynamic subtest ccs0: SUCCESS (0.044s)
[653.358417] Subtest extended: SUCCESS (5.971s)
[653.596450] [155/156] (372s left) gem_flink_basic (flink-lifetime)
[653.651093] Starting subtest: flink-lifetime
[653.653399] Subtest flink-lifetime: SUCCESS (0.002s)
[653.776038] [156/156] (372s left) gem_mmap_gtt (big-copy)
[653.826783] Subtest big-copy: SKIP (0.000s)
[653.882783] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_busy
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_async
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_chamelium_frames
results: parsing output: 13/ for test: gen7_exec_parse
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_gtt_cpu_tlb
results: parsing output: 19/ for test: sw_sync
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: core_hotunplug
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: api_intel_allocator
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_force_connector_basic
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: i915_pm_rpm
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: kms_atomic
results: parsing output: 65/ for test: gem_mmap_wc
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: sw_sync
results: parsing output: 68/ for test: gen3_render_tiledx_blits
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: gem_pread
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: i915_query
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_set_tiling_vs_blt
results: parsing output: 80/ for test: kms_concurrent
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_pm_lpsp
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: vgem_basic
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_vblank
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_atomic_interruptible
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_vrr
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: gem_mmap_offset
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_draw_crc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: i915_pciid
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_multiple
results: parsing output: 133/ for test: gem_lmem_swapping
results: parsing output: 134/ for test: gem_userptr_blits
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_flip
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_exec_schedule
results: parsing output: 141/ for test: kms_flip
results: parsing output: 142/ for test: gem_eio
results: parsing output: 143/ for test: kms_invalid_mode
results: parsing output: 144/ for test: kms_plane_alpha_blend
results: parsing output: 145/ for test: gem_ctx_param
results: parsing output: 146/ for test: kms_plane_scaling
results: parsing output: 147/ for test: kms_mmap_write_crc
results: parsing output: 148/ for test: syncobj_eventfd
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_ccs
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_ccs
results: parsing output: 153/ for test: gem_busy
results: parsing output: 154/ for test: gem_flink_basic
results: parsing output: 155/ for test: gem_mmap_gtt
Done.