[62.596436] Initializing watchdogs
[62.596517]   /dev/watchdog0
[62.626641] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[62.641608] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.646304] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.649400] [001/156] (960s left) kms_cursor_edge_walk (256x256-top-bottom)
[64.137913] Starting subtest: 256x256-top-bottom
[64.139991] Starting dynamic subtest: pipe-A-HDMI-A-3
[67.483688] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.344s)
[67.492894] Starting dynamic subtest: pipe-D-HDMI-A-3
[70.730967] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.245s)
[70.731844] Subtest 256x256-top-bottom: SUCCESS (6.592s)
[70.903453] [002/156] (952s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[72.388585] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[72.389436] Starting dynamic subtest: pipe-A
[73.209195] Dynamic subtest pipe-A: SUCCESS (0.820s)
[73.220329] Starting dynamic subtest: pipe-B
[73.999506] Dynamic subtest pipe-B: SUCCESS (0.790s)
[74.008154] Starting dynamic subtest: pipe-C
[74.757120] Dynamic subtest pipe-C: SUCCESS (0.757s)
[74.765186] Starting dynamic subtest: pipe-D
[75.514097] Dynamic subtest pipe-D: SUCCESS (0.757s)
[75.515134] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.126s)
[75.712284] [003/156] (947s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[77.197934] Starting subtest: drrs-dirtyfb-ioctl
[77.203494] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[77.387092] [004/156] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[78.878207] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[78.879926] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[79.033794] [005/156] (944s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[79.085665] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[79.157295] [006/156] (944s left) kms_chamelium_color (ctm-blue-to-red)
[80.642771] Subtest ctm-blue-to-red: SKIP (0.000s)
[80.712891] [007/156] (942s left) gem_eio (wait-immediate)
[80.863155] Starting subtest: wait-immediate
[81.222287] Subtest wait-immediate: SUCCESS (0.360s)
[82.793679] [008/156] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[84.296681] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[84.298450] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[84.447635] [009/156] (939s left) perf (invalid-oa-exponent)
[84.588683] Starting subtest: invalid-oa-exponent
[84.614890] Subtest invalid-oa-exponent: SUCCESS (0.026s)
[84.678530] [010/156] (939s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[86.170405] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[86.172049] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[86.361293] [011/156] (937s left) perf_pmu (render-node-busy)
[86.413864] Starting subtest: render-node-busy
[86.414876] Starting dynamic subtest: rcs0
[87.022212] Dynamic subtest rcs0: SUCCESS (0.607s)
[87.064925] Starting dynamic subtest: bcs0
[87.598933] Dynamic subtest bcs0: SUCCESS (0.576s)
[87.610319] Starting dynamic subtest: vcs0
[88.154265] Dynamic subtest vcs0: SUCCESS (0.555s)
[88.165485] Starting dynamic subtest: vcs1
[88.709952] Dynamic subtest vcs1: SUCCESS (0.555s)
[88.721389] Starting dynamic subtest: vecs0
[89.266973] Dynamic subtest vecs0: SUCCESS (0.557s)
[89.268061] Subtest render-node-busy: SUCCESS (2.854s)
[89.386636] [012/156] (934s left) kms_vrr (seamless-rr-switch-drrs)
[90.871120] Starting subtest: seamless-rr-switch-drrs
[90.873565] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[91.009768] [013/156] (933s left) kms_color (ctm-red-to-blue)
[92.504821] Starting subtest: ctm-red-to-blue
[92.505689] Starting dynamic subtest: pipe-A-HDMI-A-3
[93.226111] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.721s)
[93.235539] Starting dynamic subtest: pipe-B-HDMI-A-3
[93.755414] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.528s)
[93.766103] Starting dynamic subtest: pipe-C-HDMI-A-3
[94.279927] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.525s)
[94.289445] Starting dynamic subtest: pipe-D-HDMI-A-3
[94.812941] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.533s)
[94.813890] Subtest ctm-red-to-blue: SUCCESS (2.308s)
[94.986393] [014/156] (929s left) kms_plane_multiple (2x-tiling-4)
[96.473168] Starting subtest: 2x-tiling-4
[96.474924] Subtest 2x-tiling-4: SKIP (0.000s)
[96.575220] [015/156] (927s left) syncobj_wait (single-wait-for-submit-submitted)
[96.628023] Starting subtest: single-wait-for-submit-submitted
[96.736483] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[96.883706] [016/156] (927s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[98.393276] Starting subtest: yf-tiled-addfb-size-offset-overflow
[98.395153] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[98.530821] [017/156] (925s left) kms_flip (wf_vblank-ts-check)
[100.017396] Starting subtest: wf_vblank-ts-check
[100.024166] Starting dynamic subtest: A-HDMI-A3
[108.060173] Dynamic subtest A-HDMI-A3: SUCCESS (8.036s)
[108.072733] Starting dynamic subtest: B-HDMI-A3
[116.193261] Dynamic subtest B-HDMI-A3: SUCCESS (8.132s)
[116.203783] Starting dynamic subtest: C-HDMI-A3
[124.161468] Dynamic subtest C-HDMI-A3: SUCCESS (7.967s)
[124.171476] Starting dynamic subtest: D-HDMI-A3
[132.297534] Dynamic subtest D-HDMI-A3: SUCCESS (8.135s)
[132.299471] Subtest wf_vblank-ts-check: SUCCESS (32.282s)
[132.499258] [018/156] (892s left) gen7_exec_parse (oacontrol-tracking)
[132.560793] Subtest oacontrol-tracking: SKIP (0.000s)
[132.626989] [019/156] (891s left) kms_async_flips (invalid-async-flip-atomic)
[134.111891] Starting subtest: invalid-async-flip-atomic
[134.354022] Starting dynamic subtest: pipe-A-HDMI-A-3
[134.795756] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.442s)
[134.977452] Starting dynamic subtest: pipe-B-HDMI-A-3
[135.076959] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.108s)
[135.240263] Starting dynamic subtest: pipe-C-HDMI-A-3
[135.343384] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.111s)
[135.499112] Starting dynamic subtest: pipe-D-HDMI-A-3
[135.603332] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.113s)
[135.604219] Subtest invalid-async-flip-atomic: SUCCESS (1.492s)
[135.958554] [020/156] (888s left) gem_mmap_wc (pf-nonblock)
[136.006294] Subtest pf-nonblock: SKIP (0.000s)
[136.085695] [021/156] (888s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[137.575558] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[137.577187] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[137.722506] [022/156] (887s left) perf (mi-rpc)
[137.858588] Starting subtest: mi-rpc
[137.860441] Subtest mi-rpc: SKIP (0.000s)
[137.923709] [023/156] (886s left) kms_pm_backlight (fade-with-dpms)
[139.408632] Subtest fade-with-dpms: SKIP (0.000s)
[139.490789] [024/156] (885s left) gem_exec_schedule (u-semaphore-resolve)
[139.551584] Starting subtest: u-semaphore-resolve
[139.616433] Subtest u-semaphore-resolve: SUCCESS (0.065s)
[140.074405] [025/156] (884s left) kms_flip (2x-plain-flip)
[141.559909] Starting subtest: 2x-plain-flip
[141.578461] Subtest 2x-plain-flip: SKIP (0.019s)
[141.709754] [026/156] (883s left) gem_workarounds (basic-read-fd)
[141.785165] Starting subtest: basic-read-fd
[141.816042] Subtest basic-read-fd: SUCCESS (0.030s)
[141.991802] [027/156] (883s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[143.476905] Starting subtest: basic-busy-flip-before-cursor-legacy
[143.478534] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[143.583041] [028/156] (881s left) i915_pm_freq_api (freq-basic-api)
[143.645870] Starting subtest: freq-basic-api
[143.646799] Starting dynamic subtest: gt0
[143.650445] Dynamic subtest gt0: SUCCESS (0.004s)
[143.651273] Subtest freq-basic-api: SUCCESS (0.005s)
[143.806174] [029/156] (881s left) prime_busy (after-wait)
[143.855971] Starting subtest: after-wait
[143.862420] Starting dynamic subtest: rcs0
[143.910687] Dynamic subtest rcs0: SUCCESS (0.048s)
[143.921492] Starting dynamic subtest: bcs0
[143.955633] Dynamic subtest bcs0: SUCCESS (0.044s)
[143.969521] Starting dynamic subtest: vcs0
[143.997975] Dynamic subtest vcs0: SUCCESS (0.041s)
[144.021668] Starting dynamic subtest: vcs1
[144.043552] Dynamic subtest vcs1: SUCCESS (0.044s)
[144.066883] Starting dynamic subtest: vecs0
[144.086052] Dynamic subtest vecs0: SUCCESS (0.041s)
[144.197459] Subtest after-wait: SUCCESS (0.338s)
[144.384123] [030/156] (881s left) syncobj_wait (invalid-single-wait-unsubmitted)
[144.429498] Starting subtest: invalid-single-wait-unsubmitted
[144.430288] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[144.556856] [031/156] (880s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[146.047868] Starting subtest: hdr-rgb565-draw-mmap-wc
[146.049660] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[146.226093] [032/156] (879s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[147.712933] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[147.713836] Starting dynamic subtest: pipe-A-valid-mode
[148.553481] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.840s)
[148.554345] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.841s)
[148.730453] [033/156] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[150.221951] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[150.223863] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[150.378827] [034/156] (875s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[152.598315] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[152.671925] [035/156] (873s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[154.156980] Starting subtest: cursorA-vs-flipA-toggle
[165.090916] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.933s)
[165.267030] [036/156] (860s left) kms_getfb (getfb2-handle-zero)
[166.757108] Starting subtest: getfb2-handle-zero
[166.758033] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[166.935900] [037/156] (859s left) gem_busy (parallel)
[167.184126] Starting subtest: parallel
[167.185009] Starting dynamic subtest: rcs0
[167.279542] Dynamic subtest rcs0: SUCCESS (0.095s)
[167.297021] Starting dynamic subtest: bcs0
[167.340047] Dynamic subtest bcs0: SUCCESS (0.059s)
[167.354287] Starting dynamic subtest: vcs0
[167.397470] Dynamic subtest vcs0: SUCCESS (0.056s)
[167.411794] Starting dynamic subtest: vcs1
[167.456875] Dynamic subtest vcs1: SUCCESS (0.058s)
[167.483949] Starting dynamic subtest: vecs0
[167.527734] Dynamic subtest vecs0: SUCCESS (0.069s)
[167.528941] Subtest parallel: SUCCESS (0.345s)
[167.831520] [038/156] (858s left) gem_exec_reloc (basic-softpin)
[167.883083] Subtest basic-softpin: SKIP (0.000s)
[167.978733] [039/156] (858s left) tools_test (sysfs_l3_parity)
[168.026502] Starting subtest: sysfs_l3_parity
[168.093742] Subtest sysfs_l3_parity: SKIP (0.069s)
[168.197067] [040/156] (858s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[168.248855] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[168.249730] Starting dynamic subtest: smem
[168.353842] Dynamic subtest smem: SUCCESS (0.102s)
[168.363901] Starting dynamic subtest: lmem0
[169.466915] Dynamic subtest lmem0: SUCCESS (1.112s)
[169.468105] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SUCCESS (1.215s)
[169.738825] [041/156] (856s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[171.229723] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[174.279937] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.050s)
[174.467332] [042/156] (851s left) perf_pmu (all-busy-check-all)
[174.517295] Starting subtest: all-busy-check-all
[175.088501] Subtest all-busy-check-all: SUCCESS (0.571s)
[175.276584] [043/156] (851s left) sysfs_timeslice_duration (idempotent)
[175.325396] Starting subtest: idempotent
[175.327301] Starting dynamic subtest: vecs0
[175.328172] Dynamic subtest vecs0: SUCCESS (0.001s)
[175.338478] Starting dynamic subtest: vcs0
[175.339594] Dynamic subtest vcs0: SUCCESS (0.001s)
[175.349689] Starting dynamic subtest: bcs0
[175.350773] Dynamic subtest bcs0: SUCCESS (0.001s)
[175.360530] Starting dynamic subtest: rcs0
[175.361410] Dynamic subtest rcs0: SUCCESS (0.001s)
[175.371480] Starting dynamic subtest: vcs1
[175.372588] Dynamic subtest vcs1: SUCCESS (0.001s)
[175.373577] Subtest idempotent: SUCCESS (0.009s)
[175.457762] [044/156] (851s left) gem_exec_fence (keep-in-fence)
[175.630645] Starting subtest: keep-in-fence
[175.631513] Starting dynamic subtest: rcs0
[175.700925] Dynamic subtest rcs0: SUCCESS (0.070s)
[175.713615] Starting dynamic subtest: bcs0
[175.753849] Dynamic subtest bcs0: SUCCESS (0.052s)
[175.771059] Starting dynamic subtest: vcs0
[175.810494] Dynamic subtest vcs0: SUCCESS (0.055s)
[175.847207] Starting dynamic subtest: vcs1
[175.889065] Dynamic subtest vcs1: SUCCESS (0.076s)
[175.910834] Starting dynamic subtest: vecs0
[175.952486] Dynamic subtest vecs0: SUCCESS (0.061s)
[175.953942] Subtest keep-in-fence: SUCCESS (0.323s)
[176.678354] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[176.681203] [045/156] (849s left) gem_exec_schedule (preempt-other-chain)
[176.744120] Starting subtest: preempt-other-chain
[176.745106] Starting dynamic subtest: rcs0
[176.904422] Dynamic subtest rcs0: SUCCESS (0.158s)
[176.914940] Starting dynamic subtest: bcs0
[177.046403] Dynamic subtest bcs0: SUCCESS (0.141s)
[177.056652] Starting dynamic subtest: vcs0
[177.187793] Dynamic subtest vcs0: SUCCESS (0.140s)
[177.198231] Starting dynamic subtest: vcs1
[177.331811] Dynamic subtest vcs1: SUCCESS (0.143s)
[177.342178] Starting dynamic subtest: vecs0
[177.475605] Dynamic subtest vecs0: SUCCESS (0.143s)
[177.476792] Subtest preempt-other-chain: SUCCESS (0.730s)
[177.928854] [046/156] (848s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[179.421161] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[179.422942] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[179.626468] [047/156] (847s left) kms_cursor_crc (cursor-random-64x64)
[181.245545] Starting subtest: cursor-random-64x64
[181.252145] Starting dynamic subtest: pipe-A-HDMI-A-3
[185.852135] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.599s)
[185.887103] Starting dynamic subtest: pipe-D-HDMI-A-3
[190.351652] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.475s)
[190.352611] Subtest cursor-random-64x64: SUCCESS (9.107s)
[190.866279] [048/156] (836s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[192.352645] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[192.607853] Starting dynamic subtest: pipe-A-HDMI-A-3
[194.916983] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.305s)
[195.108985] Starting dynamic subtest: pipe-B-HDMI-A-3
[197.155754] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.053s)
[197.338938] Starting dynamic subtest: pipe-C-HDMI-A-3
[199.389063] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.056s)
[199.586426] Starting dynamic subtest: pipe-D-HDMI-A-3
[201.644527] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.065s)
[201.645379] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.289s)
[202.014262] [049/156] (825s left) gem_exec_create (madvise)
[202.070500] Starting subtest: madvise
[202.071371] Starting dynamic subtest: smem
[222.204879] Dynamic subtest smem: SUCCESS (20.134s)
[222.217174] Starting dynamic subtest: lmem0
[242.433920] Dynamic subtest lmem0: SUCCESS (20.228s)
[242.434812] Subtest madvise: SUCCESS (40.364s)
[243.592084] [050/156] (783s left) kms_joiner (basic-max-non-joiner)
[245.079959] Starting subtest: basic-max-non-joiner
[245.081875] Subtest basic-max-non-joiner: SKIP (0.000s)
[245.209402] [051/156] (781s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[246.712994] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[246.714757] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[246.880025] [052/156] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[248.399114] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[248.403444] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.589563] [053/156] (778s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[250.081659] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[250.083239] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[250.301237] [054/156] (777s left) gem_ctx_persistence (heartbeat-close)
[250.352515] Starting subtest: heartbeat-close
[250.354247] Subtest heartbeat-close: SKIP (0.000s)
[250.512859] [055/156] (777s left) kms_psr (psr-basic)
[251.995558] Subtest psr-basic: SKIP (0.000s)
[252.068167] [056/156] (775s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt)
[253.559712] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt
[253.561387] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[253.736612] [057/156] (774s left) kms_lease (lease-invalid-crtc)
[255.223323] Starting subtest: lease-invalid-crtc
[255.224276] Starting dynamic subtest: pipe-A-HDMI-A-3
[255.225193] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.000s)
[255.236251] Starting dynamic subtest: pipe-B-HDMI-A-3
[255.237541] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.000s)
[255.248141] Starting dynamic subtest: pipe-C-HDMI-A-3
[255.249451] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.000s)
[255.259829] Starting dynamic subtest: pipe-D-HDMI-A-3
[255.263441] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.000s)
[255.264552] Subtest lease-invalid-crtc: SUCCESS (0.008s)
[255.339905] [058/156] (772s left) kms_chamelium_hpd (dp-hpd-fast)
[256.866073] Subtest dp-hpd-fast: SKIP (0.000s)
[256.986804] [059/156] (771s left) kms_dsc (dsc-basic)
[258.472450] Starting subtest: dsc-basic
[258.478179] Subtest dsc-basic: SKIP (0.000s)
[258.613791] [060/156] (769s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[260.121337] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[260.123100] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[260.315690] [061/156] (767s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[261.808186] Starting subtest: fbcpsr-tiling-4
[261.810093] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[261.978618] [062/156] (766s left) kms_addfb_basic (unused-pitches)
[262.025070] Starting subtest: unused-pitches
[262.026027] Subtest unused-pitches: SUCCESS (0.000s)
[263.661213] [063/156] (764s left) kms_properties (crtc-properties-legacy)
[265.147669] Starting subtest: crtc-properties-legacy
[265.150962] Starting dynamic subtest: pipe-A-HDMI-A-3
[265.499016] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.350s)
[265.512728] Starting dynamic subtest: pipe-B-HDMI-A-3
[265.778380] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.278s)
[265.790579] Starting dynamic subtest: pipe-C-HDMI-A-3
[266.083639] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.303s)
[266.095605] Starting dynamic subtest: pipe-D-HDMI-A-3
[266.369594] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.284s)
[266.370509] Subtest crtc-properties-legacy: SUCCESS (1.224s)
[266.562683] [064/156] (761s left) gem_ctx_isolation (preservation-s3)
[266.620792] Starting subtest: preservation-S3
[266.621698] Starting dynamic subtest: rcs0
[293.413490] Dynamic subtest rcs0: SUCCESS (10.758s)
[293.425844] Starting dynamic subtest: bcs0
[320.324320] Dynamic subtest bcs0: SUCCESS (10.399s)
[320.336800] Starting dynamic subtest: vcs0
[347.366466] Dynamic subtest vcs0: SUCCESS (10.420s)
[347.378919] Starting dynamic subtest: vcs1
[374.367245] Dynamic subtest vcs1: SUCCESS (10.460s)
[374.380024] Starting dynamic subtest: vecs0
[401.360859] Dynamic subtest vecs0: SUCCESS (10.562s)
[401.361952] Subtest preservation-S3: SUCCESS (52.604s)
[406.741921] [065/156] (626s left) gem_mmap_offset (mmap-unmap)
[406.787858] Starting subtest: mmap-unmap
[406.788781] Starting dynamic subtest: lmem0
[408.053253] Dynamic subtest lmem0: SUCCESS (1.262s)
[408.066632] Starting dynamic subtest: smem0
[409.922256] Dynamic subtest smem0: SUCCESS (1.867s)
[409.923176] Subtest mmap-unmap: SUCCESS (3.132s)
[410.225863] [066/156] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[411.718570] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[414.995824] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.278s)
[415.210283] [067/156] (618s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[416.698079] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[416.773798] [068/156] (617s left) gem_exec_balancer (semaphore)
[416.830546] Starting subtest: semaphore
[418.906866] Subtest semaphore: SUCCESS (2.076s)
[419.369646] [069/156] (614s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[420.855350] Starting subtest: cursor-vs-flip-legacy
[452.596515] Subtest cursor-vs-flip-legacy: SUCCESS (31.745s)
[452.770958] [070/156] (581s left) gem_partial_pwrite_pread (write-display)
[452.822209] Subtest write-display: SKIP (0.000s)
[452.920347] [071/156] (581s left) i915_query (query-garbage)
[452.965084] Starting subtest: query-garbage
[452.965960] Subtest query-garbage: SUCCESS (0.000s)
[453.087743] [072/156] (581s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[454.573341] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[454.575084] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[454.714156] [073/156] (579s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[456.210612] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[456.212234] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[456.410747] [074/156] (577s left) prime_self_import (reimport-vs-gem_close-race)
[456.453962] Starting subtest: reimport-vs-gem_close-race
[461.486300] Subtest reimport-vs-gem_close-race: SUCCESS (5.033s)
[461.741361] [075/156] (572s left) sw_sync (timeline_closed)
[461.800349] Starting subtest: timeline_closed
[461.801205] Subtest timeline_closed: SUCCESS (0.000s)
[461.918833] [076/156] (572s left) gem_exec_schedule (fifo)
[461.977528] Starting subtest: fifo
[461.978399] Starting dynamic subtest: rcs0
[462.174572] Dynamic subtest rcs0: SUCCESS (0.193s)
[462.186878] Starting dynamic subtest: bcs0
[462.302472] Dynamic subtest bcs0: SUCCESS (0.130s)
[462.316589] Starting dynamic subtest: vcs0
[462.436552] Dynamic subtest vcs0: SUCCESS (0.133s)
[462.450881] Starting dynamic subtest: vcs1
[462.570784] Dynamic subtest vcs1: SUCCESS (0.133s)
[462.584873] Starting dynamic subtest: vecs0
[462.718314] Dynamic subtest vecs0: SUCCESS (0.146s)
[462.719223] Subtest fifo: SUCCESS (0.742s)
[463.154023] [077/156] (571s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[464.646021] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[464.648031] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[464.858107] [078/156] (569s left) api_intel_bb (delta-check)
[464.903818] Starting subtest: delta-check
[464.922811] Subtest delta-check: SUCCESS (0.019s)
[465.115439] [079/156] (569s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[466.608146] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[466.609923] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[466.859970] [080/156] (568s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[468.353891] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[468.355565] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[468.554351] [081/156] (566s left) gem_render_copy_redux (flink-interruptible)
[468.609465] Starting subtest: flink-interruptible
[470.637917] Subtest flink-interruptible: SUCCESS (2.028s)
[470.854351] [082/156] (564s left) gem_softpin (allocator-evict)
[470.906994] Starting subtest: allocator-evict
[470.908176] Starting dynamic subtest: rcs0
[499.287628] Dynamic subtest rcs0: SUCCESS (28.377s)
[499.300650] Starting dynamic subtest: bcs0
[527.374409] Dynamic subtest bcs0: SUCCESS (28.084s)
[527.387017] Starting dynamic subtest: vcs0
[555.982369] Dynamic subtest vcs0: SUCCESS (28.606s)
[555.995101] Starting dynamic subtest: vcs1
[584.175954] Dynamic subtest vcs1: SUCCESS (28.192s)
[584.190195] Starting dynamic subtest: vecs0
[612.484371] Dynamic subtest vecs0: SUCCESS (28.307s)
[612.485393] Subtest allocator-evict: SUCCESS (141.573s)
[612.675233] [083/156] (422s left) api_intel_bb (blit-reloc-keep-cache)
[612.768205] Starting subtest: blit-reloc-keep-cache
[612.769900] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[612.920580] [084/156] (422s left) gem_render_copy_redux (normal)
[612.974027] Starting subtest: normal
[613.788409] Subtest normal: SUCCESS (0.814s)
[613.976746] [085/156] (421s left) vgem_basic (sysfs)
[614.038283] Starting subtest: sysfs
[614.039158] Subtest sysfs: SUCCESS (0.001s)
[614.144383] [086/156] (421s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[614.198839] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[614.304351] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[614.431962] [087/156] (421s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[615.928208] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[615.930186] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[616.131425] [088/156] (419s left) gem_wait (write-busy)
[616.193758] Starting subtest: write-busy
[616.194723] Starting dynamic subtest: all-engines
[616.791549] Dynamic subtest all-engines: SUCCESS (0.597s)
[616.808880] Starting dynamic subtest: rcs0
[617.341796] Dynamic subtest rcs0: SUCCESS (0.549s)
[617.356566] Starting dynamic subtest: bcs0
[617.886785] Dynamic subtest bcs0: SUCCESS (0.544s)
[617.901452] Starting dynamic subtest: vcs0
[618.429650] Dynamic subtest vcs0: SUCCESS (0.542s)
[618.444312] Starting dynamic subtest: vcs1
[618.971853] Dynamic subtest vcs1: SUCCESS (0.541s)
[618.986565] Starting dynamic subtest: vecs0
[619.513835] Dynamic subtest vecs0: SUCCESS (0.541s)
[619.514692] Subtest write-busy: SUCCESS (3.321s)
[619.787729] [089/156] (416s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[621.280524] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[621.282475] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[621.440964] [090/156] (414s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[622.935026] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[622.937003] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[623.125397] [091/156] (413s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[624.617002] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[624.618683] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[624.806120] [092/156] (411s left) kms_big_fb (linear-64bpp-rotate-0)
[626.318259] Starting subtest: linear-64bpp-rotate-0
[628.939118] Subtest linear-64bpp-rotate-0: SUCCESS (2.619s)
[629.175851] [093/156] (407s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[629.223883] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[629.224787] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[629.344161] [094/156] (407s left) i915_drm_fdinfo (most-busy-idle-check-all)
[629.395429] Starting subtest: most-busy-idle-check-all
[629.396270] Starting dynamic subtest: rcs0
[629.414486] Dynamic subtest rcs0: SKIP (0.019s)
[629.428385] Starting dynamic subtest: bcs0
[629.430554] Dynamic subtest bcs0: SKIP (0.001s)
[629.443640] Starting dynamic subtest: vcs0
[629.445627] Dynamic subtest vcs0: SKIP (0.000s)
[629.458637] Starting dynamic subtest: vcs1
[629.460738] Dynamic subtest vcs1: SKIP (0.000s)
[629.475586] Starting dynamic subtest: vecs0
[629.477624] Dynamic subtest vecs0: SKIP (0.000s)
[629.479552] Subtest most-busy-idle-check-all: SKIP (0.028s)
[629.545172] [095/156] (406s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[631.075380] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[631.077301] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[631.282335] [096/156] (405s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[632.787672] Starting subtest: x-tiled-64bpp-rotate-0
[635.094100] Subtest x-tiled-64bpp-rotate-0: SUCCESS (2.303s)
[635.283903] [097/156] (401s left) kms_flip (nonblocking-read)
[636.771042] Starting subtest: nonblocking-read
[636.772088] Subtest nonblocking-read: SUCCESS (0.000s)
[636.919784] [098/156] (399s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[638.430475] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[638.432184] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[638.597853] [099/156] (398s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite)
[640.090124] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite
[640.092134] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[640.277563] [100/156] (396s left) kms_psr (fbc-pr-cursor-render)
[641.768202] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[641.856463] [101/156] (395s left) gem_eio (throttle)
[642.034599] Starting subtest: throttle
[642.304522] Subtest throttle: SUCCESS (0.270s)
[643.878003] [102/156] (393s left) kms_vblank (wait-forked-hang)
[645.374324] Starting subtest: wait-forked-hang
[645.375689] Starting dynamic subtest: pipe-A-HDMI-A-3
[647.846924] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.471s)
[647.864409] Starting dynamic subtest: pipe-D-HDMI-A-3
[650.093881] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.242s)
[650.094860] Subtest wait-forked-hang: SUCCESS (4.721s)
[650.293712] [103/156] (386s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[651.785323] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[651.879849] [104/156] (385s left) gem_close (many-handles-one-vma)
[651.931611] Starting subtest: many-handles-one-vma
[651.967956] Subtest many-handles-one-vma: SUCCESS (0.036s)
[652.172936] [105/156] (385s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[653.665246] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[653.667151] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[653.828502] [106/156] (383s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[655.321178] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[655.322828] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[655.508853] [107/156] (382s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[657.001509] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[657.003679] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[657.201657] [108/156] (380s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[658.693895] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[658.695540] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[658.906767] [109/156] (378s left) prime_mmap_coherency (ioctl-errors)
[658.958258] Starting subtest: ioctl-errors
[660.177299] Subtest ioctl-errors: SUCCESS (1.219s)
[660.379943] [110/156] (377s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[661.953364] Starting subtest: yf-tiled-32bpp-rotate-0
[661.955078] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[662.136292] [111/156] (376s left) kms_psr (fbc-psr-sprite-plane-onoff)
[663.622941] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[663.704678] [112/156] (374s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[665.192320] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[665.194007] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[665.332275] [113/156] (372s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[666.823503] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[666.824378] Starting dynamic subtest: pipe-A-HDMI-A-3
[666.833151] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[666.846973] Starting dynamic subtest: pipe-B-HDMI-A-3
[666.855944] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[666.869677] Starting dynamic subtest: pipe-C-HDMI-A-3
[666.878996] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[666.892309] Starting dynamic subtest: pipe-D-HDMI-A-3
[666.901675] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[666.903504] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.014s)
[667.090362] [114/156] (371s left) i915_suspend (debugfs-reader)
[667.135932] Starting subtest: debugfs-reader
[694.630558] Subtest debugfs-reader: SUCCESS (12.044s)
[699.819931] [115/156] (343s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[701.313809] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[701.315764] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[701.515995] [116/156] (342s left) kms_pm_dc (dc6-psr)
[704.035264] Starting subtest: dc6-psr
[704.036836] Subtest dc6-psr: SKIP (0.000s)
[704.177816] [117/156] (339s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[705.672488] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[705.674423] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[705.839389] [118/156] (338s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[707.347410] Starting subtest: y-tiled-64bpp-rotate-270
[707.423313] Subtest y-tiled-64bpp-rotate-270: SKIP (0.076s)
[707.620375] [119/156] (336s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[707.667326] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[707.788447] [120/156] (336s left) gem_mmap_gtt (big-copy-odd)
[707.833194] Subtest big-copy-odd: SKIP (0.000s)
[707.912868] [121/156] (336s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[709.398992] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[709.400143] Starting dynamic subtest: pipe-A-HDMI-A-3
[709.409256] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[709.423205] Starting dynamic subtest: pipe-B-HDMI-A-3
[709.437454] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[709.450746] Starting dynamic subtest: pipe-C-HDMI-A-3
[709.458164] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[709.471396] Starting dynamic subtest: pipe-D-HDMI-A-3
[709.479247] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[709.480722] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.011s)
[709.663366] [122/156] (334s left) kms_psr (pr-primary-blt)
[711.150856] Subtest pr-primary-blt: SKIP (0.000s)
[711.225990] [123/156] (333s left) gem_render_copy (yf-tiled-ccs-to-linear)
[711.280106] Starting subtest: yf-tiled-ccs-to-linear
[711.281000] Starting dynamic subtest: smem
[711.375200] Dynamic subtest smem: SUCCESS (0.094s)
[711.390564] Starting dynamic subtest: lmem0
[711.683962] Dynamic subtest lmem0: SUCCESS (0.304s)
[711.685179] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.401s)
[711.952583] [124/156] (332s left) gem_exec_balancer (bonded-dual)
[712.013423] Starting subtest: bonded-dual
[712.015509] Subtest bonded-dual: SKIP (0.000s)
[712.498659] [125/156] (331s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt)
[713.990120] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt
[713.991756] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[714.172431] [126/156] (330s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[715.666048] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[715.668152] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[715.842360] [127/156] (328s left) gem_softpin (softpin)
[715.897260] Starting subtest: softpin
[748.163281] Subtest softpin: SUCCESS (32.259s)
[748.301875] [128/156] (296s left) kms_pipe_crc_basic (nonblocking-crc)
[749.789019] Starting subtest: nonblocking-crc
[749.790065] Starting dynamic subtest: pipe-A-HDMI-A-3
[750.570506] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.781s)
[750.587090] Starting dynamic subtest: pipe-B-HDMI-A-3
[751.183706] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.609s)
[751.198775] Starting dynamic subtest: pipe-C-HDMI-A-3
[751.764762] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.578s)
[751.780347] Starting dynamic subtest: pipe-D-HDMI-A-3
[752.305819] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.539s)
[752.306663] Subtest nonblocking-crc: SUCCESS (2.519s)
[752.486224] [129/156] (292s left) kms_chamelium_edid (dp-edid-resolution-list)
[754.024627] Subtest dp-edid-resolution-list: SKIP (0.000s)
[754.147039] [130/156] (290s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-pgflip-blt)
[755.639014] Starting subtest: fbchdr-2p-scndscrn-indfb-pgflip-blt
[755.641006] Subtest fbchdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[755.801373] [131/156] (289s left) kms_cursor_crc (cursor-onscreen-32x10)
[757.396461] Starting subtest: cursor-onscreen-32x10
[757.452055] Subtest cursor-onscreen-32x10: SKIP (0.053s)
[757.882976] [132/156] (287s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[759.375565] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[761.830530] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.455s)
[762.030381] [133/156] (283s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[763.522396] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[763.524149] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[763.705928] [134/156] (281s left) kms_psr (psr-sprite-mmap-gtt)
[765.193689] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[765.277408] [135/156] (280s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[766.770027] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[766.771702] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[766.975403] [136/156] (278s left) kms_busy (extended-pageflip-hang-newfb)
[768.469017] Starting subtest: extended-pageflip-hang-newfb
[768.470457] Starting dynamic subtest: pipe-A
[776.302415] Dynamic subtest pipe-A: SUCCESS (7.832s)
[776.320700] Starting dynamic subtest: pipe-D
[784.093343] Dynamic subtest pipe-D: SUCCESS (7.784s)
[784.094167] Subtest extended-pageflip-hang-newfb: SUCCESS (15.625s)
[784.296153] [137/156] (261s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[784.343016] Starting subtest: etime-multi-wait-for-submit-submitted
[784.456020] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.109s)
[784.669428] [138/156] (261s left) gem_userptr_blits (sync-unmap)
[784.729437] Starting subtest: sync-unmap
[784.752568] Subtest sync-unmap: SUCCESS (0.022s)
[784.925713] [139/156] (260s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[786.417782] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[786.419677] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[786.590770] [140/156] (259s left) dmabuf_sync_file (export-before-signal)
[786.644607] Starting subtest: export-before-signal
[786.646832] Subtest export-before-signal: SUCCESS (0.001s)
[786.764250] [141/156] (259s left) i915_pm_rpm (debugfs-read)
[791.492473] Starting subtest: debugfs-read
[792.468790] Subtest debugfs-read: SUCCESS (0.969s)
[793.452807] [142/156] (252s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[793.498890] Starting subtest: single-wait-all-for-submit-available-signaled
[793.499770] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[793.640056] [143/156] (252s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[795.131685] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[795.133384] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[795.322194] [144/156] (251s left) gem_lmem_swapping (parallel-random-engines)
[799.720229] Starting subtest: parallel-random-engines
[799.721272] Starting dynamic subtest: lmem0
[829.249585] Dynamic subtest lmem0: SUCCESS (29.526s)
[829.250714] Subtest parallel-random-engines: SUCCESS (29.528s)
[830.193162] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[830.194288] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[830.196875] [145/156] (216s left) kms_flip (2x-absolute-wf_vblank)
[834.996805] Starting subtest: 2x-absolute-wf_vblank
[835.015795] Subtest 2x-absolute-wf_vblank: SKIP (0.019s)
[835.238638] [FACT kms_flip (2x-absolute-wf_vblank)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[835.242299] [FACT kms_flip (2x-absolute-wf_vblank)] new: kernel.kmod_is_loaded.i915: true
[835.249143] [146/156] (211s left) gem_create (create-ext-cpu-access-sanity-check)
[835.411231] Starting subtest: create-ext-cpu-access-sanity-check
[835.422208] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.014s)
[835.597957] [147/156] (211s left) gem_exec_whisper (basic-normal-all)
[835.661403] Starting subtest: basic-normal-all
[837.260360] Subtest basic-normal-all: SUCCESS (1.598s)
[837.546151] [148/156] (209s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[839.052071] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[839.053704] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[839.206105] [149/156] (207s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[840.693925] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[840.695689] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[840.812399] [150/156] (206s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[842.306366] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[842.308717] Starting dynamic subtest: pipe-A-HDMI-A-3
[842.316493] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[842.329094] Starting dynamic subtest: pipe-B-HDMI-A-3
[842.336802] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[842.349308] Starting dynamic subtest: pipe-C-HDMI-A-3
[842.356929] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[842.369393] Starting dynamic subtest: pipe-D-HDMI-A-3
[842.377427] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[842.379001] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.014s)
[842.584625] [151/156] (204s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[844.072996] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[844.146591] [152/156] (202s left) kms_content_protection (lic-type-0)
[845.691361] Starting subtest: lic-type-0
[845.695580] Subtest lic-type-0: SKIP (0.002s)
[845.893800] [153/156] (201s left) gem_eio (create-ext)
[846.094530] Starting subtest: create-ext
[846.408836] Subtest create-ext: SUCCESS (0.314s)
[847.992459] [154/156] (199s left) syncobj_timeline (invalid-signal-bad-pad)
[848.045071] Starting subtest: invalid-signal-bad-pad
[848.045961] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[848.158157] [155/156] (199s left) gem_exec_reloc (basic-gtt-read-noreloc)
[848.208901] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[848.314225] [156/156] (199s left) kms_prime (d3hot)
[849.820089] Subtest D3hot: SKIP (0.000s)
[850.054069] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: kms_dirtyfb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pipe_b_c_ivb
results: parsing output: 5/ for test: kms_chamelium_color
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_vrr
results: parsing output: 12/ for test: kms_color
results: parsing output: 13/ for test: kms_plane_multiple
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: gen7_exec_parse
results: parsing output: 18/ for test: kms_async_flips
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: kms_pm_backlight
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: gem_workarounds
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: i915_pm_freq_api
results: parsing output: 28/ for test: prime_busy
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_tiled_display
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: gem_busy
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: tools_test
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: sysfs_timeslice_duration
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: gem_exec_create
results: parsing output: 49/ for test: kms_joiner
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_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: kms_chamelium_hpd
results: parsing output: 58/ for test: kms_dsc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: kms_properties
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: gem_mmap_offset
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_partial_pwrite_pread
results: parsing output: 70/ for test: i915_query
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: prime_self_import
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_render_copy_redux
results: parsing output: 81/ for test: gem_softpin
results: parsing output: 82/ for test: api_intel_bb
results: parsing output: 83/ for test: gem_render_copy_redux
results: parsing output: 84/ for test: vgem_basic
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_wait
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_close
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: prime_mmap_coherency
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_pm_dc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: kms_pipe_crc_basic
results: parsing output: 128/ for test: kms_chamelium_edid
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_psr
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_busy
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: gem_userptr_blits
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: dmabuf_sync_file
results: parsing output: 140/ for test: i915_pm_rpm
results: parsing output: 141/ for test: syncobj_timeline
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_lmem_swapping
results: parsing output: 144/ for test: kms_flip
results: parsing output: 145/ for test: gem_create
results: parsing output: 146/ for test: gem_exec_whisper
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_flip_scaled_crc
results: parsing output: 149/ for test: kms_ccs
results: parsing output: 150/ for test: kms_psr2_sf
results: parsing output: 151/ for test: kms_content_protection
results: parsing output: 152/ for test: gem_eio
results: parsing output: 153/ for test: syncobj_timeline
results: parsing output: 154/ for test: gem_exec_reloc
results: parsing output: 155/ for test: kms_prime
Done.