[65.474733] Initializing watchdogs
[65.474803]   /dev/watchdog0
[65.493999] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[65.504553] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.508200] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.510968] [001/133] (960s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[65.687876] Starting subtest: nonblocking-crc-frame-sequence
[65.688765] Starting dynamic subtest: pipe-A-DP-3
[66.434543] Dynamic subtest pipe-A-DP-3: SUCCESS (0.745s)
[66.452831] Starting dynamic subtest: pipe-B-DP-3
[67.035974] Dynamic subtest pipe-B-DP-3: SUCCESS (0.597s)
[67.046967] Starting dynamic subtest: pipe-C-DP-3
[67.728456] Dynamic subtest pipe-C-DP-3: SUCCESS (0.689s)
[67.736387] Starting dynamic subtest: pipe-D-DP-3
[68.331954] Dynamic subtest pipe-D-DP-3: SUCCESS (0.602s)
[68.332845] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.644s)
[68.612365] [002/133] (957s left) i915_module_load (reload)
[68.654298] Starting subtest: reload
[71.433467] Subtest reload: SUCCESS (2.780s)
[71.473704] [003/133] (954s left) gem_eio (in-flight-1us)
[71.766052] Starting subtest: in-flight-1us
[76.220450] Subtest in-flight-1us: SUCCESS (4.455s)
[76.488222] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[76.489946] [004/133] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[76.686765] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[77.985263] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.298s)
[78.198614] [005/133] (948s left) kms_addfb_basic (bad-pitch-1024)
[78.284042] Starting subtest: bad-pitch-1024
[78.284963] Subtest bad-pitch-1024: SUCCESS (0.000s)
[78.579513] [006/133] (947s left) kms_getfb (getfb2-handle-zero)
[78.770899] Starting subtest: getfb2-handle-zero
[78.771788] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[78.954540] [007/133] (947s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[79.031116] Starting subtest: single-wait-all-for-submit-signaled
[79.032041] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[79.229157] [008/133] (947s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[79.304928] Starting subtest: invalid-multi-wait-all-unsubmitted
[79.305815] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[79.490520] [009/133] (947s left) kms_atomic_interruptible (universal-setplane-cursor)
[79.679868] Starting subtest: universal-setplane-cursor
[79.680690] Starting dynamic subtest: pipe-A-DP-3
[85.992971] Dynamic subtest pipe-A-DP-3: SUCCESS (6.312s)
[85.993945] Subtest universal-setplane-cursor: SUCCESS (6.313s)
[86.287070] [010/133] (940s left) gem_exec_reloc (basic-wc-cpu)
[86.371150] Subtest basic-wc-cpu: SKIP (0.000s)
[86.445521] [011/133] (940s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[86.638405] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[86.640111] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[86.809873] [012/133] (940s left) gem_pxp (hw-rejects-pxp-buffer)
[89.414381] Starting subtest: hw-rejects-pxp-buffer
[89.415431] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[89.564770] [013/133] (937s left) gem_exec_balancer (invalid-bonds)
[89.650319] Starting subtest: invalid-bonds
[89.652070] Subtest invalid-bonds: SKIP (0.000s)
[90.019939] [014/133] (936s left) gem_exec_whisper (basic-forked-all)
[90.111192] Starting subtest: basic-forked-all
[92.934458] Subtest basic-forked-all: SUCCESS (2.822s)
[93.210280] [015/133] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[93.398556] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[93.400199] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[93.581512] [016/133] (933s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[93.786338] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[93.788127] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[93.982969] [017/133] (933s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[94.174243] Starting subtest: psr-rgb565-draw-render
[94.175924] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[94.336847] [018/133] (932s left) kms_psr (pr-cursor-mmap-cpu)
[94.524781] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[94.578989] [019/133] (932s left) gem_close_race (basic-process)
[94.696382] Starting subtest: basic-process
[94.773522] Subtest basic-process: SUCCESS (0.077s)
[95.070619] [020/133] (932s left) syncobj_timeline (etime-single-wait-all-submitted)
[95.148064] Starting subtest: etime-single-wait-all-submitted
[95.255106] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[95.400262] [021/133] (932s left) kms_cursor_crc (cursor-random-128x42)
[95.790867] Starting subtest: cursor-random-128x42
[95.795468] Starting dynamic subtest: pipe-A-DP-3
[100.307605] Dynamic subtest pipe-A-DP-3: SUCCESS (4.511s)
[100.360112] Starting dynamic subtest: pipe-D-DP-3
[104.574437] Dynamic subtest pipe-D-DP-3: SUCCESS (4.223s)
[104.575356] Subtest cursor-random-128x42: SUCCESS (8.783s)
[105.006739] [022/133] (922s left) syncobj_timeline (invalid-wait-bad-flags)
[105.085969] Starting subtest: invalid-wait-bad-flags
[105.086878] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[105.267553] [023/133] (922s left) gem_sync (basic-all)
[105.358537] Starting subtest: basic-all
[108.453284] Subtest basic-all: SUCCESS (3.094s)
[108.693421] [024/133] (918s left) kms_big_fb (linear-16bpp-rotate-90)
[108.888400] Starting subtest: linear-16bpp-rotate-90
[108.955341] Subtest linear-16bpp-rotate-90: SKIP (0.067s)
[109.172141] [025/133] (918s left) gem_flink_basic (bad-flink)
[109.247874] Starting subtest: bad-flink
[109.248644] Subtest bad-flink: SUCCESS (0.000s)
[109.453967] [026/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[109.640447] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[109.642170] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[109.818119] [027/133] (918s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[110.081618] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[110.230582] [028/133] (917s left) gem_exec_fence (syncobj-invalid-wait)
[110.772183] Starting subtest: syncobj-invalid-wait
[110.773050] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[111.169916] [029/133] (916s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[111.363403] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[112.439606] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.077s)
[112.670212] [030/133] (915s left) gem_exec_schedule (implicit-boths)
[112.757743] Starting subtest: implicit-boths
[112.758575] Starting dynamic subtest: rcs0
[113.046305] Dynamic subtest rcs0: SUCCESS (0.288s)
[113.056398] Starting dynamic subtest: bcs0
[113.251379] Dynamic subtest bcs0: SUCCESS (0.205s)
[113.261661] Starting dynamic subtest: vcs0
[113.467674] Dynamic subtest vcs0: SUCCESS (0.216s)
[113.477803] Starting dynamic subtest: vcs1
[113.680773] Dynamic subtest vcs1: SUCCESS (0.213s)
[113.690780] Starting dynamic subtest: vecs0
[113.891973] Dynamic subtest vecs0: SUCCESS (0.211s)
[113.903220] Starting dynamic subtest: vecs1
[114.112553] Dynamic subtest vecs1: SUCCESS (0.220s)
[114.122683] Starting dynamic subtest: ccs0
[114.322210] Dynamic subtest ccs0: SUCCESS (0.209s)
[114.323339] Subtest implicit-boths: SUCCESS (1.564s)
[114.769567] [031/133] (913s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[114.967507] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[116.241373] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.273s)
[116.471557] [032/133] (911s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[116.670453] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[116.672121] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[116.869928] [033/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[117.060322] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[117.062008] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[117.236510] [034/133] (911s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[117.422508] Starting subtest: fbc-rgb101010-draw-blt
[120.307576] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.886s)
[120.558731] [035/133] (907s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[120.743041] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[120.743879] Starting dynamic subtest: pipe-A
[120.823324] Dynamic subtest pipe-A: SUCCESS (0.081s)
[120.835450] Starting dynamic subtest: pipe-B
[121.022463] Dynamic subtest pipe-B: SUCCESS (0.199s)
[121.038643] Starting dynamic subtest: pipe-C
[121.234895] Dynamic subtest pipe-C: SUCCESS (0.212s)
[121.251469] Starting dynamic subtest: pipe-D
[121.449070] Dynamic subtest pipe-D: SUCCESS (0.213s)
[121.449999] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.707s)
[121.795769] [036/133] (906s left) gem_userptr_blits (probe)
[121.893731] Starting subtest: probe
[122.011352] Subtest probe: SUCCESS (0.117s)
[122.164974] [037/133] (906s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[122.357400] Starting subtest: yf-tiled-8bpp-rotate-270
[122.359152] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[122.542462] [038/133] (906s left) gem_eio (wait-wedge-1us)
[122.871424] Starting subtest: wait-wedge-1us
[123.907527] Subtest wait-wedge-1us: SUCCESS (1.037s)
[124.158139] [039/133] (904s left) syncobj_wait (invalid-signal-one-illegal-handle)
[124.233991] Starting subtest: invalid-signal-one-illegal-handle
[124.235084] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[124.411118] [040/133] (904s left) gem_exec_parallel (basic)
[124.494291] Starting subtest: basic
[124.495225] Starting dynamic subtest: rcs0
[126.024540] Dynamic subtest rcs0: SUCCESS (1.530s)
[126.035697] Starting dynamic subtest: bcs0
[127.470741] Dynamic subtest bcs0: SUCCESS (1.446s)
[127.482139] Starting dynamic subtest: vcs0
[128.938431] Dynamic subtest vcs0: SUCCESS (1.467s)
[128.949609] Starting dynamic subtest: vcs1
[130.418568] Dynamic subtest vcs1: SUCCESS (1.480s)
[130.429714] Starting dynamic subtest: vecs0
[131.898654] Dynamic subtest vecs0: SUCCESS (1.480s)
[131.909498] Starting dynamic subtest: vecs1
[133.345636] Dynamic subtest vecs1: SUCCESS (1.446s)
[133.357847] Starting dynamic subtest: ccs0
[134.792415] Dynamic subtest ccs0: SUCCESS (1.446s)
[134.793535] Subtest basic: SUCCESS (10.298s)
[135.127651] [041/133] (893s left) gem_ccs (ctrl-surf-copy)
[135.219055] Starting subtest: ctrl-surf-copy
[135.219897] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[135.272377] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.053s)
[135.282777] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[135.466954] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.184s)
[135.477240] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[135.483351] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[135.493786] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[135.682374] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.198s)
[135.692980] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[135.708348] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[135.721032] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[135.926355] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.217s)
[135.936642] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[135.952511] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[135.963123] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[136.171755] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.218s)
[136.172710] Subtest ctrl-surf-copy: SUCCESS (0.953s)
[136.340554] [042/133] (892s left) gem_exec_fence (basic-busy-all)
[136.425188] Starting subtest: basic-busy-all
[136.540492] Subtest basic-busy-all: SUCCESS (0.115s)
[137.409275] [043/133] (891s left) kms_psr (psr2-primary-blt)
[137.595972] Subtest psr2-primary-blt: SKIP (0.000s)
[137.655030] [044/133] (891s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[137.731488] Starting subtest: single-wait-for-submit-unsubmitted
[137.838398] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[137.990219] [045/133] (891s left) kms_flip (flip-vs-rmfb-interruptible)
[138.180113] Starting subtest: flip-vs-rmfb-interruptible
[138.184538] Starting dynamic subtest: A-DP3
[145.999803] Dynamic subtest A-DP3: SUCCESS (7.814s)
[146.039904] Starting dynamic subtest: B-DP3
[153.761231] Dynamic subtest B-DP3: SUCCESS (7.758s)
[153.796067] Starting dynamic subtest: C-DP3
[161.503076] Dynamic subtest C-DP3: SUCCESS (7.738s)
[161.538406] Starting dynamic subtest: D-DP3
[169.242121] Dynamic subtest D-DP3: SUCCESS (7.735s)
[169.250402] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.069s)
[169.653522] [046/133] (859s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[169.836920] Starting subtest: cursor-vs-flip-varying-size
[202.691956] Subtest cursor-vs-flip-varying-size: SUCCESS (32.853s)
[202.984326] [047/133] (826s left) i915_query (hwconfig_table)
[203.057176] Starting subtest: hwconfig_table
[203.224024] Subtest hwconfig_table: SUCCESS (0.001s)
[203.297443] [048/133] (826s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[203.487978] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[203.489703] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[203.663941] [049/133] (825s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[203.847391] Starting subtest: cursorB-vs-flipB-atomic
[203.849146] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[204.009561] [050/133] (825s left) gen9_exec_parse (valid-registers)
[204.091196] Subtest valid-registers: SKIP (0.000s)
[204.189218] [051/133] (825s left) kms_addfb_basic (bo-too-small)
[204.373270] Starting subtest: bo-too-small
[204.374146] Subtest bo-too-small: SUCCESS (0.000s)
[204.513703] [052/133] (825s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[204.707430] Starting subtest: y-tiled-8bpp-rotate-0
[204.709197] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[204.897855] [053/133] (824s left) gem_linear_blits (interruptible)
[205.379724] Starting subtest: interruptible
[212.532264] Subtest interruptible: SUCCESS (7.152s)
[212.806610] [054/133] (817s left) gem_create (hog-create)
[212.923579] Starting subtest: hog-create
[212.924441] Starting dynamic subtest: lmem0
[245.230363] Dynamic subtest lmem0: SUCCESS (32.306s)
[245.242517] Starting dynamic subtest: smem0
[277.514399] Dynamic subtest smem0: SUCCESS (32.283s)
[277.515397] Subtest hog-create: SUCCESS (64.591s)
[277.804793] [055/133] (752s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[277.887600] Starting subtest: multi-wait-all-for-submit-submitted
[277.989104] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[278.159316] [056/133] (751s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[278.359182] Starting subtest: fbcpsr-rgb565-draw-pwrite
[278.360973] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[278.534927] [057/133] (751s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[278.718678] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[278.721253] Starting dynamic subtest: pipe-A-DP-3
[278.729660] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[278.740522] Starting dynamic subtest: pipe-B-DP-3
[278.749117] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[278.759887] Starting dynamic subtest: pipe-C-DP-3
[278.768196] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[278.779254] Starting dynamic subtest: pipe-D-DP-3
[278.788328] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[278.790125] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[279.196974] [058/133] (750s left) gem_exec_balancer (parallel-ordering)
[279.537514] Starting subtest: parallel-ordering
[281.190707] Subtest parallel-ordering: SUCCESS (1.653s)
[281.348452] [059/133] (748s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[281.535928] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[284.469710] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.934s)
[284.717785] [060/133] (745s left) kms_addfb_basic (basic-x-tiled-legacy)
[284.797667] Starting subtest: basic-x-tiled-legacy
[284.799403] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[285.090097] [061/133] (745s left) perf (polling)
[285.541392] Starting subtest: polling
[285.542234] Starting dynamic subtest: 0-rcs0
[295.570371] Dynamic subtest 0-rcs0: SUCCESS (10.029s)
[295.571354] Subtest polling: SUCCESS (10.030s)
[295.633354] [062/133] (734s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[295.820322] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[295.821255] Starting dynamic subtest: pipe-A-DP-3
[295.829433] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[295.840509] Starting dynamic subtest: pipe-B-DP-3
[295.849088] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[295.860022] Starting dynamic subtest: pipe-C-DP-3
[295.868317] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[295.879485] Starting dynamic subtest: pipe-D-DP-3
[295.889986] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[295.891853] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[296.307849] [063/133] (734s left) api_intel_bb (simple-bb-ctx)
[296.386580] Starting subtest: simple-bb-ctx
[296.419180] Subtest simple-bb-ctx: SUCCESS (0.034s)
[296.596290] [064/133] (733s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[296.782984] Starting subtest: plane-primary-overlay-mutable-zpos
[298.881697] Subtest plane-primary-overlay-mutable-zpos: SKIP (2.097s)
[299.278657] [065/133] (731s left) kms_pm_rpm (pm-caching)
[301.106874] Starting subtest: pm-caching
[301.109057] Subtest pm-caching: SKIP (0.000s)
[301.546416] [066/133] (729s left) gem_ctx_persistence (engines-hang)
[301.631491] Starting subtest: engines-hang
[301.632554] Starting dynamic subtest: rcs0
[301.759453] Dynamic subtest rcs0: SUCCESS (0.129s)
[301.775571] Starting dynamic subtest: bcs0
[301.862527] Dynamic subtest bcs0: SUCCESS (0.100s)
[301.910793] Starting dynamic subtest: vcs0
[301.931343] Dynamic subtest vcs0: SUCCESS (0.065s)
[301.952973] Starting dynamic subtest: vcs1
[301.987551] Dynamic subtest vcs1: SUCCESS (0.054s)
[302.010634] Starting dynamic subtest: vecs0
[302.046805] Dynamic subtest vecs0: SUCCESS (0.057s)
[302.086762] Starting dynamic subtest: vecs1
[302.113545] Dynamic subtest vecs1: SUCCESS (0.064s)
[302.133391] Starting dynamic subtest: ccs0
[302.202098] Dynamic subtest ccs0: SUCCESS (0.086s)
[302.208077] Subtest engines-hang: SUCCESS (0.574s)
[302.406939] [067/133] (728s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[302.592247] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[302.592989] Starting dynamic subtest: pipe-A
[304.573874] Dynamic subtest pipe-A: SUCCESS (1.982s)
[304.598304] Starting dynamic subtest: pipe-B
[306.586829] Dynamic subtest pipe-B: SUCCESS (2.011s)
[306.602297] Starting dynamic subtest: pipe-C
[306.884977] Dynamic subtest pipe-C: SUCCESS (0.297s)
[306.903470] Starting dynamic subtest: pipe-D
[307.183532] Dynamic subtest pipe-D: SUCCESS (0.297s)
[307.184993] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (4.593s)
[307.546967] [068/133] (723s left) api_intel_allocator (fork-simple-once)
[307.626943] Starting subtest: fork-simple-once
[307.663773] Subtest fork-simple-once: SUCCESS (0.038s)
[307.878316] [069/133] (723s left) gem_pread (self)
[307.954204] Subtest self: SKIP (0.000s)
[308.022531] [070/133] (723s left) gem_exec_schedule (preempt-other-chain)
[308.112760] Starting subtest: preempt-other-chain
[308.113628] Starting dynamic subtest: rcs0
[308.755141] Dynamic subtest rcs0: SUCCESS (0.641s)
[308.766969] Starting dynamic subtest: bcs0
[309.382764] Dynamic subtest bcs0: SUCCESS (0.626s)
[309.394489] Starting dynamic subtest: vcs0
[310.019010] Dynamic subtest vcs0: SUCCESS (0.635s)
[310.030552] Starting dynamic subtest: vcs1
[310.637867] Dynamic subtest vcs1: SUCCESS (0.618s)
[310.649387] Starting dynamic subtest: vecs0
[311.480058] Dynamic subtest vecs0: SUCCESS (0.841s)
[311.491505] Starting dynamic subtest: vecs1
[312.113161] Dynamic subtest vecs1: SUCCESS (0.632s)
[312.125143] Starting dynamic subtest: ccs0
[312.730825] Dynamic subtest ccs0: SUCCESS (0.617s)
[312.731652] Subtest preempt-other-chain: SUCCESS (4.618s)
[313.175483] [071/133] (717s left) gem_ctx_persistence (legacy-engines-mixed)
[313.261877] Starting subtest: legacy-engines-mixed
[313.262978] Starting dynamic subtest: render
[313.381434] Dynamic subtest render: SUCCESS (0.119s)
[313.400499] Starting dynamic subtest: bsd1
[313.445098] Dynamic subtest bsd1: SUCCESS (0.061s)
[313.485253] Starting dynamic subtest: bsd2
[313.527729] Dynamic subtest bsd2: SUCCESS (0.078s)
[313.556906] Starting dynamic subtest: blt
[313.592667] Dynamic subtest blt: SUCCESS (0.062s)
[313.622657] Starting dynamic subtest: vebox
[313.660627] Dynamic subtest vebox: SUCCESS (0.065s)
[313.661918] Subtest legacy-engines-mixed: SUCCESS (0.400s)
[313.875139] [072/133] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[314.063301] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[314.065063] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[314.240906] [073/133] (717s left) gem_mmap_gtt (bad-object)
[314.318243] Subtest bad-object: SKIP (0.000s)
[314.388258] [074/133] (716s left) kms_psr (fbc-psr-basic)
[314.573254] Subtest fbc-psr-basic: SKIP (0.000s)
[314.639556] [075/133] (716s left) gem_userptr_blits (access-control)
[314.734430] Starting subtest: access-control
[314.736298] Subtest access-control: SKIP (0.000s)
[314.927035] [076/133] (716s left) gem_ctx_param (non-root-set)
[315.002013] Starting subtest: non-root-set
[315.019188] Subtest non-root-set: SUCCESS (0.017s)
[315.161260] [077/133] (716s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[315.351093] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[315.352828] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[315.518579] [078/133] (716s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[315.705481] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[315.706424] Starting dynamic subtest: pipe-A-DP-3
[315.714969] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[315.726389] Starting dynamic subtest: pipe-B-DP-3
[315.734846] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[315.746056] Starting dynamic subtest: pipe-C-DP-3
[315.754404] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[315.765790] Starting dynamic subtest: pipe-D-DP-3
[315.777024] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[315.778987] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[316.172711] [079/133] (715s left) core_setmaster (master-drop-set-user)
[316.323389] Starting subtest: master-drop-set-user
[316.359005] Subtest master-drop-set-user: SUCCESS (0.036s)
[316.410991] [080/133] (715s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[316.591979] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[316.622383] Starting dynamic subtest: pipe-A-plane-0
[316.624201] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[316.635483] Starting dynamic subtest: pipe-A-plane-3
[316.637436] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[316.648491] Starting dynamic subtest: pipe-A-plane-5
[316.650321] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[316.858929] Starting dynamic subtest: pipe-B-plane-0
[316.861157] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[316.880437] Starting dynamic subtest: pipe-B-plane-3
[316.882442] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[316.895369] Starting dynamic subtest: pipe-B-plane-5
[316.897162] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[316.948200] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.354s)
[317.211249] [081/133] (714s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[317.397958] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[317.400423] Starting dynamic subtest: pipe-A-valid-mode
[319.288512] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.887s)
[319.290054] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.890s)
[319.591886] [082/133] (712s left) syncobj_timeline (reset-unsignaled)
[319.671329] Starting subtest: reset-unsignaled
[319.672234] Subtest reset-unsignaled: SUCCESS (0.000s)
[319.857075] [083/133] (712s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[319.940569] Starting subtest: yf-tiled-to-vebox-x-tiled
[319.942795] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[320.224540] [084/133] (711s left) perf_pmu (busy-idle-check-all)
[320.293785] Starting subtest: busy-idle-check-all
[320.294737] Starting dynamic subtest: rcs0
[320.977463] Dynamic subtest rcs0: SUCCESS (0.682s)
[320.998712] Starting dynamic subtest: bcs0
[321.640738] Dynamic subtest bcs0: SUCCESS (0.658s)
[321.687177] Starting dynamic subtest: vcs0
[322.328449] Dynamic subtest vcs0: SUCCESS (0.683s)
[322.349701] Starting dynamic subtest: vcs1
[322.990521] Dynamic subtest vcs1: SUCCESS (0.657s)
[323.011611] Starting dynamic subtest: vecs0
[323.652528] Dynamic subtest vecs0: SUCCESS (0.657s)
[323.673599] Starting dynamic subtest: vecs1
[324.314614] Dynamic subtest vecs1: SUCCESS (0.657s)
[324.335716] Starting dynamic subtest: ccs0
[324.977456] Dynamic subtest ccs0: SUCCESS (0.658s)
[324.983508] Subtest busy-idle-check-all: SUCCESS (4.685s)
[325.161018] [085/133] (707s left) kms_draw_crc (draw-method-mmap-cpu)
[325.347338] Starting subtest: draw-method-mmap-cpu
[325.348255] Starting dynamic subtest: xrgb8888-untiled
[325.672635] Dynamic subtest xrgb8888-untiled: SUCCESS (0.324s)
[325.716653] Starting dynamic subtest: rgb565-untiled
[326.006328] Dynamic subtest rgb565-untiled: SUCCESS (0.329s)
[326.051115] Starting dynamic subtest: xrgb2101010-untiled
[326.338168] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.328s)
[326.354236] Starting dynamic subtest: xbgr16161616f-untiled
[326.622650] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.282s)
[326.666206] Starting dynamic subtest: xrgb8888-xtiled
[326.822876] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.195s)
[326.839057] Starting dynamic subtest: rgb565-xtiled
[326.971878] Dynamic subtest rgb565-xtiled: SUCCESS (0.145s)
[326.995696] Starting dynamic subtest: xrgb2101010-xtiled
[327.121495] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.148s)
[327.138603] Starting dynamic subtest: xbgr16161616f-xtiled
[327.271426] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.149s)
[327.287446] Starting dynamic subtest: xrgb8888-4tiled
[327.439584] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[327.485548] Starting dynamic subtest: rgb565-4tiled
[327.639540] Dynamic subtest rgb565-4tiled: SUCCESS (0.195s)
[327.660396] Starting dynamic subtest: xrgb2101010-4tiled
[327.789556] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.145s)
[327.832601] Starting dynamic subtest: xbgr16161616f-4tiled
[327.988246] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.195s)
[327.989177] Subtest draw-method-mmap-cpu: SUCCESS (2.642s)
[328.187010] [086/133] (704s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[328.375462] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[328.405249] Starting dynamic subtest: pipe-A-plane-0
[328.407066] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[328.419378] Starting dynamic subtest: pipe-A-plane-3
[328.421402] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[328.433342] Starting dynamic subtest: pipe-A-plane-5
[328.435137] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[328.637645] Starting dynamic subtest: pipe-B-plane-0
[328.639699] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[328.658384] Starting dynamic subtest: pipe-B-plane-3
[328.660353] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[328.673566] Starting dynamic subtest: pipe-B-plane-5
[328.675284] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[328.727265] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.351s)
[329.014934] [087/133] (703s left) kms_joiner (invalid-modeset-force-big-joiner)
[329.203416] Starting subtest: invalid-modeset-force-big-joiner
[329.204276] Starting dynamic subtest: big_joiner_on_last_pipe
[329.404491] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.203s)
[329.405368] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.204s)
[329.691882] [088/133] (702s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[329.877463] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[329.878335] Starting dynamic subtest: pipe-A-valid-mode
[335.698631] Dynamic subtest pipe-A-valid-mode: SUCCESS (5.819s)
[335.700236] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SUCCESS (5.822s)
[336.008894] [089/133] (696s left) gem_ctx_shared (single-timeline)
[336.096795] Starting subtest: single-timeline
[336.136700] Subtest single-timeline: SUCCESS (0.038s)
[336.430163] [090/133] (696s left) vgem_basic (unload)
[336.478961] Starting subtest: unload
[365.499636] Subtest unload: SUCCESS (29.020s)
[365.678490] [091/133] (666s left) gem_spin_batch (legacy-resubmit-new)
[365.774104] Starting subtest: legacy-resubmit-new
[365.775051] Starting dynamic subtest: default
[365.812156] Dynamic subtest default: SUCCESS (0.037s)
[365.826404] Starting dynamic subtest: render
[365.827346] Dynamic subtest render: SUCCESS (0.004s)
[365.840097] Starting dynamic subtest: bsd
[365.840993] Dynamic subtest bsd: SUCCESS (0.005s)
[365.853822] Starting dynamic subtest: bsd1
[365.854717] Dynamic subtest bsd1: SUCCESS (0.004s)
[365.866879] Starting dynamic subtest: bsd2
[365.867757] Dynamic subtest bsd2: SUCCESS (0.004s)
[365.879899] Starting dynamic subtest: blt
[365.881033] Dynamic subtest blt: SUCCESS (0.005s)
[365.893131] Starting dynamic subtest: vebox
[365.894210] Dynamic subtest vebox: SUCCESS (0.006s)
[365.895131] Subtest legacy-resubmit-new: SUCCESS (0.075s)
[366.182193] [092/133] (666s left) kms_psr (fbc-pr-dpms)
[366.376632] Subtest fbc-pr-dpms: SKIP (0.000s)
[366.442752] [093/133] (666s left) kms_cursor_crc (cursor-offscreen-128x128)
[366.814360] Starting subtest: cursor-offscreen-128x128
[366.818762] Starting dynamic subtest: pipe-A-DP-3
[369.340735] Dynamic subtest pipe-A-DP-3: SUCCESS (2.522s)
[369.377244] Starting dynamic subtest: pipe-D-DP-3
[371.807242] Dynamic subtest pipe-D-DP-3: SUCCESS (2.440s)
[371.808178] Subtest cursor-offscreen-128x128: SUCCESS (4.994s)
[372.266094] [094/133] (660s left) gem_exec_reloc (basic-cpu)
[372.349566] Subtest basic-cpu: SKIP (0.000s)
[372.445576] [095/133] (660s left) syncobj_wait (invalid-wait-illegal-handle)
[372.548054] Starting subtest: invalid-wait-illegal-handle
[372.549064] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[372.706805] [096/133] (660s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[372.896587] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[376.392664] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (3.497s)
[376.626868] [097/133] (656s left) gem_ctx_param (set-priority-not-supported)
[376.710825] Starting subtest: set-priority-not-supported
[376.712517] Subtest set-priority-not-supported: SKIP (0.000s)
[376.891780] [098/133] (656s left) kms_chamelium_color (ctm-max)
[377.078512] Subtest ctm-max: SKIP (0.000s)
[377.137667] [099/133] (656s left) sriov_basic (enable-vfs-autoprobe-on)
[377.215304] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[377.287878] [100/133] (655s left) kms_frontbuffer_tracking (fbc-tiling-y)
[377.477275] Starting subtest: fbc-tiling-y
[377.479039] Subtest fbc-tiling-y: SKIP (0.000s)
[377.653855] [101/133] (655s left) kms_cursor_edge_walk (128x128-left-edge)
[377.838451] Starting subtest: 128x128-left-edge
[377.839284] Starting dynamic subtest: pipe-A-DP-3
[381.294890] Dynamic subtest pipe-A-DP-3: SUCCESS (3.456s)
[381.313225] Starting dynamic subtest: pipe-D-DP-3
[384.611418] Dynamic subtest pipe-D-DP-3: SUCCESS (3.313s)
[384.612484] Subtest 128x128-left-edge: SUCCESS (6.774s)
[384.930495] [102/133] (648s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[385.121653] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[388.194825] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (3.074s)
[388.462786] [103/133] (645s left) kms_debugfs (display-on-read-all)
[388.664744] Starting subtest: display-on-read-all
[388.828139] Subtest display-on-read-all: SUCCESS (0.163s)
[389.112587] [104/133] (644s left) kms_flip (2x-plain-flip-fb-recreate)
[389.298053] Starting subtest: 2x-plain-flip-fb-recreate
[389.313409] Subtest 2x-plain-flip-fb-recreate: SKIP (0.015s)
[389.449640] [105/133] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[389.639037] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[389.640750] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[389.792842] [106/133] (643s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[389.873302] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[389.874302] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[390.062682] [107/133] (643s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[390.249434] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[390.264684] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s)
[390.400390] [108/133] (643s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[390.583794] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[390.586141] Starting dynamic subtest: pipe-A-DP-3
[390.594476] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[390.606560] Starting dynamic subtest: pipe-B-DP-3
[390.615746] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[390.627561] Starting dynamic subtest: pipe-C-DP-3
[390.635919] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[390.647868] Starting dynamic subtest: pipe-D-DP-3
[390.658595] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[390.660285] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[391.075144] [109/133] (642s left) kms_lease (invalid-create-leases)
[391.268758] Starting subtest: invalid-create-leases
[391.278569] Subtest invalid-create-leases: SUCCESS (0.010s)
[391.432762] [110/133] (642s left) kms_selftest (drm_dp_mst_helper)
[391.483704] Starting subtest: drm_dp_mst_helper
[391.498335] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[391.587618] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.089s)
[391.601669] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[391.710799] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.117s)
[391.742620] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[391.797187] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.086s)
[391.798181] Subtest drm_dp_mst_helper: SUCCESS (0.313s)
[392.040045] [111/133] (642s left) gen7_exec_parse (oacontrol-tracking)
[392.123362] Subtest oacontrol-tracking: SKIP (0.000s)
[392.184626] [112/133] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[392.373303] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[392.375079] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[392.552880] [113/133] (641s left) gem_exec_schedule (thriceslice)
[392.638368] Starting subtest: thriceslice
[392.639289] Starting dynamic subtest: rcs0
[392.669783] Dynamic subtest rcs0: SUCCESS (0.031s)
[392.684191] Starting dynamic subtest: bcs0
[392.723510] Dynamic subtest bcs0: SUCCESS (0.052s)
[392.755645] Starting dynamic subtest: vcs0
[392.766403] Dynamic subtest vcs0: SUCCESS (0.041s)
[392.791368] Starting dynamic subtest: vcs1
[392.828203] Dynamic subtest vcs1: SUCCESS (0.060s)
[392.851796] Starting dynamic subtest: vecs0
[392.867689] Dynamic subtest vecs0: SUCCESS (0.038s)
[392.891155] Starting dynamic subtest: vecs1
[392.905334] Dynamic subtest vecs1: SUCCESS (0.036s)
[392.925530] Starting dynamic subtest: ccs0
[392.963131] Dynamic subtest ccs0: SUCCESS (0.056s)
[392.964266] Subtest thriceslice: SUCCESS (0.326s)
[393.344017] [114/133] (641s left) syncobj_eventfd (invalid-illegal-eventfd)
[393.420653] Starting subtest: invalid-illegal-eventfd
[393.421562] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[393.591682] [115/133] (640s left) kms_psr (psr-sprite-plane-move)
[393.777210] Subtest psr-sprite-plane-move: SKIP (0.000s)
[393.835390] [116/133] (640s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[394.023392] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[394.024307] Starting dynamic subtest: pipe-A-DP-3
[394.032857] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[394.044798] Starting dynamic subtest: pipe-B-DP-3
[394.053373] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[394.065190] Starting dynamic subtest: pipe-C-DP-3
[394.073394] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[394.085338] Starting dynamic subtest: pipe-D-DP-3
[394.095047] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[394.097167] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[394.521449] [117/133] (640s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[396.027530] Starting subtest: gem-execbuf-stress-pc8
[396.156539] Subtest gem-execbuf-stress-pc8: SKIP (0.128s)
[396.453579] [118/133] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[396.644031] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[396.645903] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[396.836588] [119/133] (637s left) sysfs_timeslice_duration (duration)
[396.921221] Starting subtest: duration
[396.923491] Starting dynamic subtest: vecs0
[410.070896] Dynamic subtest vecs0: SUCCESS (13.148s)
[410.087235] Starting dynamic subtest: ccs0
[423.216946] Dynamic subtest ccs0: SUCCESS (13.141s)
[423.233210] Starting dynamic subtest: vcs0
[436.368822] Dynamic subtest vcs0: SUCCESS (13.148s)
[436.384640] Starting dynamic subtest: bcs0
[449.528946] Dynamic subtest bcs0: SUCCESS (13.157s)
[449.544881] Starting dynamic subtest: vecs1
[462.681930] Dynamic subtest vecs1: SUCCESS (13.148s)
[462.698597] Starting dynamic subtest: rcs0
[475.823234] Dynamic subtest rcs0: SUCCESS (13.138s)
[475.838305] Starting dynamic subtest: vcs1
[488.987370] Dynamic subtest vcs1: SUCCESS (13.163s)
[488.988333] Subtest duration: SUCCESS (92.067s)
[489.108682] [120/133] (545s left) gem_gpgpu_fill (basic)
[489.192284] Starting subtest: basic
[489.193198] Starting dynamic subtest: smem
[489.223401] Dynamic subtest smem: SUCCESS (0.031s)
[489.238582] Starting dynamic subtest: lmem0
[489.239482] Dynamic subtest lmem0: SUCCESS (0.012s)
[489.240398] Subtest basic: SUCCESS (0.045s)
[489.442183] [121/133] (545s left) perf (gen12-group-concurrent-oa-buffer-read)
[489.701140] Starting subtest: gen12-group-concurrent-oa-buffer-read
[499.726527] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.025s)
[499.788583] [122/133] (535s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[499.988785] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[500.063561] [123/133] (534s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[500.253670] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[500.319396] [124/133] (534s left) kms_content_protection (dp-mst-type-1)
[500.574315] Starting subtest: dp-mst-type-1
[500.576196] Subtest dp-mst-type-1: SKIP (0.000s)
[500.803996] [125/133] (534s left) kms_pm_lpsp (screens-disabled)
[501.993167] Starting subtest: screens-disabled
[501.995054] Subtest screens-disabled: SKIP (0.000s)
[502.133936] [126/133] (533s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[502.321958] Starting subtest: plane-lut1d-pre-ctm3x4
[502.358254] Starting dynamic subtest: pipe-A-DP-3
[502.756448] Dynamic subtest pipe-A-DP-3: SUCCESS (0.399s)
[502.941592] Starting dynamic subtest: pipe-B-DP-3
[503.295624] Dynamic subtest pipe-B-DP-3: SUCCESS (0.365s)
[503.501285] Starting dynamic subtest: pipe-C-DP-3
[503.832849] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[504.019523] Starting dynamic subtest: pipe-D-DP-3
[504.356980] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[504.464193] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (2.141s)
[504.808460] [127/133] (530s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[505.007154] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[505.069900] [128/133] (530s left) kms_vblank (wait-idle-hang)
[505.255525] Starting subtest: wait-idle-hang
[505.258060] Starting dynamic subtest: pipe-A-DP-3
[531.626239] Dynamic subtest pipe-A-DP-3: SUCCESS (26.366s)
[531.658825] Starting dynamic subtest: pipe-D-DP-3
[556.539585] Dynamic subtest pipe-D-DP-3: SUCCESS (24.902s)
[556.540493] Subtest wait-idle-hang: SUCCESS (51.282s)
[556.855948] [129/133] (478s left) gem_mmap_gtt (flink-race)
[556.931389] Subtest flink-race: SKIP (0.000s)
[557.010944] [130/133] (478s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[557.208178] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[557.209907] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[557.417604] [131/133] (478s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[557.695206] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[557.850178] [132/133] (477s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[558.034425] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[558.036202] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[558.159050] [133/133] (477s left) kms_addfb_basic (basic)
[558.240736] Starting subtest: basic
[558.241576] Subtest basic: SUCCESS (0.000s)
[558.538174] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_crc_basic
results: parsing output: 1/ for test: i915_module_load
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_atomic_interruptible
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: gem_exec_whisper
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: kms_psr
results: parsing output: 18/ for test: gem_close_race
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_sync
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_flink_basic
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_parallel
results: parsing output: 40/ for test: gem_ccs
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_linear_blits
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_atomic
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: gem_pread
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: core_setmaster
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_draw_crc
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: vgem_basic
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_param
results: parsing output: 97/ for test: kms_chamelium_color
results: parsing output: 98/ for test: sriov_basic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_debugfs
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_lease
results: parsing output: 109/ for test: kms_selftest
results: parsing output: 110/ for test: gen7_exec_parse
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_eventfd
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: i915_pm_rpm
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: sysfs_timeslice_duration
results: parsing output: 119/ for test: gem_gpgpu_fill
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_content_protection
results: parsing output: 124/ for test: kms_pm_lpsp
results: parsing output: 125/ for test: kms_color_pipeline
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_chamelium_edid
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_addfb_basic
Done.