[59.329822] Initializing watchdogs
[59.329870]   /dev/watchdog0
[59.343083] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.347042] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.349244] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.352647] [001/134] (960s left) kms_content_protection (type1)
[59.534162] Starting subtest: type1
[59.538739] Subtest type1: SKIP (0.000s)
[59.672220] [002/134] (960s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[59.777957] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[59.782146] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[59.880830] [003/134] (960s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[59.943752] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[59.948399] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[60.147141] [004/134] (959s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[60.242891] Starting subtest: flip-vs-dpms-off-vs-modeset
[60.245172] Starting dynamic subtest: A-eDP1
[63.931068] Dynamic subtest A-eDP1: SUCCESS (3.691s)
[63.937930] Starting dynamic subtest: B-eDP1
[67.377451] Dynamic subtest B-eDP1: SUCCESS (3.447s)
[67.385935] Starting dynamic subtest: C-eDP1
[70.567621] Dynamic subtest C-eDP1: SUCCESS (3.191s)
[70.576279] Starting dynamic subtest: D-eDP1
[73.678080] Dynamic subtest D-eDP1: SUCCESS (3.111s)
[73.680498] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.446s)
[74.522149] [005/134] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[74.632371] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[74.636666] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[74.752326] [006/134] (945s left) kms_big_fb (linear-64bpp-rotate-270)
[74.851597] Starting subtest: linear-64bpp-rotate-270
[74.883143] Subtest linear-64bpp-rotate-270: SKIP (0.031s)
[75.011947] [007/134] (945s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[75.118565] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[75.123062] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[75.240506] [008/134] (944s left) sysfs_heartbeat_interval (idempotent)
[75.319054] Starting subtest: idempotent
[75.321693] Starting dynamic subtest: vecs0
[75.324289] Dynamic subtest vecs0: SUCCESS (0.001s)
[75.332863] Starting dynamic subtest: ccs0
[75.334790] Dynamic subtest ccs0: SUCCESS (0.001s)
[75.340857] Starting dynamic subtest: vcs0
[75.342748] Dynamic subtest vcs0: SUCCESS (0.000s)
[75.349108] Starting dynamic subtest: bcs0
[75.350966] Dynamic subtest bcs0: SUCCESS (0.000s)
[75.357241] Starting dynamic subtest: rcs0
[75.359109] Dynamic subtest rcs0: SUCCESS (0.001s)
[75.365124] Starting dynamic subtest: vcs1
[75.366870] Dynamic subtest vcs1: SUCCESS (0.000s)
[75.368688] Subtest idempotent: SUCCESS (0.005s)
[75.440471] [009/134] (944s left) perf (per-context-mode-unprivileged)
[75.566768] Starting subtest: per-context-mode-unprivileged
[75.570460] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[75.604198] [010/134] (944s left) kms_plane_multiple (tiling-y)
[75.686688] Starting subtest: tiling-y
[75.690358] Subtest tiling-y: SKIP (0.000s)
[75.769083] [011/134] (944s left) gem_exec_capture (userptr)
[75.833456] Starting subtest: userptr
[76.645938] Subtest userptr: SUCCESS (0.809s)
[76.780587] [012/134] (943s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[76.884735] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[77.685904] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s)
[77.909329] [013/134] (942s left) core_debugfs (read-all-entries)
[77.978877] Starting subtest: read-all-entries
[78.073421] Subtest read-all-entries: SUCCESS (0.095s)
[78.149693] [014/134] (942s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[83.159534] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[83.161735] Starting dynamic subtest: pipe-A-eDP-1
[83.951078] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s)
[83.963265] Starting dynamic subtest: pipe-B-eDP-1
[85.084911] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[85.089538] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.926s)
[86.299701] [015/134] (934s left) gem_exec_fence (basic-wait)
[86.506437] Starting subtest: basic-wait
[86.508769] Starting dynamic subtest: rcs0
[86.593699] Dynamic subtest rcs0: SUCCESS (0.087s)
[86.603459] Starting dynamic subtest: bcs0
[86.659260] Dynamic subtest bcs0: SUCCESS (0.066s)
[86.668810] Starting dynamic subtest: vcs0
[86.727257] Dynamic subtest vcs0: SUCCESS (0.067s)
[86.736785] Starting dynamic subtest: vcs1
[86.785860] Dynamic subtest vcs1: SUCCESS (0.058s)
[86.794861] Starting dynamic subtest: vecs0
[86.845201] Dynamic subtest vecs0: SUCCESS (0.058s)
[86.854617] Starting dynamic subtest: ccs0
[86.908069] Dynamic subtest ccs0: SUCCESS (0.062s)
[86.910549] Subtest basic-wait: SUCCESS (0.402s)
[89.049025] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[89.052046] [016/134] (931s left) gen9_exec_parse (unaligned-jump)
[89.111628] Subtest unaligned-jump: SKIP (0.000s)
[89.184463] [017/134] (931s left) gem_exec_store (basic)
[89.250360] Starting subtest: basic
[89.384886] Subtest basic: SUCCESS (0.136s)
[89.577195] [018/134] (930s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[89.676316] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[89.678657] Starting dynamic subtest: pipe-A-eDP-1
[90.499428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[90.508101] Starting dynamic subtest: pipe-B-eDP-1
[91.994577] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s)
[92.001848] Starting dynamic subtest: pipe-C-eDP-1
[93.518278] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.521s)
[93.537208] Starting dynamic subtest: pipe-D-eDP-1
[95.049032] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.529s)
[95.051274] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.364s)
[96.304638] [019/134] (924s left) gem_wait (write-busy)
[96.375533] Starting subtest: write-busy
[96.378086] Starting dynamic subtest: all-engines
[96.973066] Dynamic subtest all-engines: SUCCESS (0.597s)
[96.987102] Starting dynamic subtest: rcs0
[97.520730] Dynamic subtest rcs0: SUCCESS (0.547s)
[97.535953] Starting dynamic subtest: bcs0
[98.070556] Dynamic subtest bcs0: SUCCESS (0.549s)
[98.086039] Starting dynamic subtest: vcs0
[99.925973] Dynamic subtest vcs0: SUCCESS (1.853s)
[99.940334] Starting dynamic subtest: vcs1
[101.909088] Dynamic subtest vcs1: SUCCESS (1.981s)
[101.922871] Starting dynamic subtest: vecs0
[103.893598] Dynamic subtest vecs0: SUCCESS (1.982s)
[103.908855] Starting dynamic subtest: ccs0
[104.443674] Dynamic subtest ccs0: SUCCESS (0.550s)
[104.446140] Subtest write-busy: SUCCESS (8.068s)
[104.659675] [020/134] (915s left) perf_pmu (interrupts-sync)
[104.711589] Starting subtest: interrupts-sync
[105.816933] Subtest interrupts-sync: SUCCESS (1.106s)
[105.980478] [021/134] (914s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[106.080286] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[112.998071] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.920s)
[113.148799] [022/134] (907s left) gem_fence_thrash (bo-write-verify-threaded-y)
[113.182505] Starting subtest: bo-write-verify-threaded-y
[113.216169] Subtest bo-write-verify-threaded-y: SKIP (0.030s)
[113.303944] [023/134] (907s left) kms_cursor_crc (cursor-sliding-256x256)
[113.541856] Starting subtest: cursor-sliding-256x256
[113.546828] Starting dynamic subtest: pipe-A-eDP-1
[116.759805] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.213s)
[116.788062] Starting dynamic subtest: pipe-D-eDP-1
[120.598432] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.814s)
[120.600747] Subtest cursor-sliding-256x256: SUCCESS (7.053s)
[121.426084] [024/134] (899s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[121.532938] Starting subtest: compare-crc-sanitycheck-xr24
[121.535239] Starting dynamic subtest: pipe-A-eDP-1
[122.159452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[122.168326] Starting dynamic subtest: pipe-B-eDP-1
[123.508510] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.348s)
[123.517712] Starting dynamic subtest: pipe-C-eDP-1
[124.761938] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.255s)
[124.769823] Starting dynamic subtest: pipe-D-eDP-1
[125.999890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[126.002163] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.466s)
[126.845209] [025/134] (893s left) kms_setmode (clone-exclusive-crtc)
[126.911074] Starting subtest: clone-exclusive-crtc
[126.917372] Subtest clone-exclusive-crtc: SKIP (0.000s)
[127.023016] [026/134] (893s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[127.117016] Starting subtest: fbc-psr-cursor-mmap-gtt
[127.119330] Starting dynamic subtest: eDP-1
[127.123640] Dynamic subtest eDP-1: SKIP (0.000s)
[127.128024] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[127.201958] [027/134] (893s left) perf (invalid-create-userspace-config)
[127.302984] Starting subtest: invalid-create-userspace-config
[127.305301] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[127.343773] [028/134] (893s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[127.446193] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[127.448476] Starting dynamic subtest: pipe-A-eDP-1
[127.505699] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[127.513680] Starting dynamic subtest: pipe-B-eDP-1
[127.564072] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[127.571915] Starting dynamic subtest: pipe-C-eDP-1
[127.626496] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[127.634315] Starting dynamic subtest: pipe-D-eDP-1
[127.689969] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[127.692139] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.244s)
[129.925127] [029/134] (891s left) syncobj_wait (invalid-reset-one-illegal-handle)
[129.988708] Starting subtest: invalid-reset-one-illegal-handle
[129.990986] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[130.103150] [030/134] (890s left) gem_partial_pwrite_pread (writes-after-reads-display)
[130.159381] Subtest writes-after-reads-display: SKIP (0.000s)
[130.221437] [031/134] (890s left) kms_color (deep-color)
[130.316243] Starting subtest: deep-color
[131.383282] Starting dynamic subtest: pipe-A-eDP-1-gamma
[132.100068] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.714s)
[132.111768] Starting dynamic subtest: pipe-A-eDP-1-degamma
[133.592916] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.493s)
[133.601309] Starting dynamic subtest: pipe-A-eDP-1-ctm
[135.070966] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.477s)
[135.883398] Starting dynamic subtest: pipe-B-eDP-1-gamma
[136.584251] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.704s)
[136.592757] Starting dynamic subtest: pipe-B-eDP-1-degamma
[138.070313] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.487s)
[138.079063] Starting dynamic subtest: pipe-B-eDP-1-ctm
[139.472650] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.400s)
[140.284256] Starting dynamic subtest: pipe-C-eDP-1-gamma
[140.963488] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.686s)
[140.971659] Starting dynamic subtest: pipe-C-eDP-1-degamma
[142.422074] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.455s)
[142.435182] Starting dynamic subtest: pipe-C-eDP-1-ctm
[143.877499] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.455s)
[144.692470] Starting dynamic subtest: pipe-D-eDP-1-gamma
[145.378724] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.691s)
[145.389135] Starting dynamic subtest: pipe-D-eDP-1-degamma
[146.748718] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.367s)
[146.757088] Starting dynamic subtest: pipe-D-eDP-1-ctm
[148.162731] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.416s)
[148.165297] Subtest deep-color: SUCCESS (17.846s)
[149.055818] [032/134] (872s left) kms_flip (2x-flip-vs-wf_vblank)
[149.163580] Starting subtest: 2x-flip-vs-wf_vblank
[149.171751] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[149.307209] [033/134] (871s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[149.421492] Starting subtest: cursorB-vs-flipA-varying-size
[149.426086] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[149.580076] [034/134] (871s left) i915_query (query-regions-garbage-items)
[149.643670] Starting subtest: query-regions-garbage-items
[149.645663] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[149.766422] [035/134] (871s left) kms_cursor_legacy (forked-bo)
[149.895427] Starting subtest: forked-bo
[149.897736] Starting dynamic subtest: pipe-A
[155.400159] Dynamic subtest pipe-A: SUCCESS (5.501s)
[155.411070] Starting dynamic subtest: pipe-B
[160.871856] Dynamic subtest pipe-B: SUCCESS (5.469s)
[160.882188] Starting dynamic subtest: pipe-C
[166.363873] Dynamic subtest pipe-C: SUCCESS (5.488s)
[166.373851] Starting dynamic subtest: pipe-D
[171.836557] Dynamic subtest pipe-D: SUCCESS (5.472s)
[171.846721] Starting dynamic subtest: all-pipes
[177.362092] Dynamic subtest all-pipes: SUCCESS (5.522s)
[177.364482] Subtest forked-bo: SUCCESS (27.463s)
[177.522986] [036/134] (843s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[177.645636] Starting subtest: y-tiled-64bpp-rotate-180
[177.651565] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[177.782873] [037/134] (843s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[177.887800] Starting subtest: fbcpsr-1p-rte
[184.887343] Subtest fbcpsr-1p-rte: SUCCESS (7.003s)
[185.045170] [038/134] (836s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[185.106607] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[185.209545] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[185.307113] [039/134] (836s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[185.413407] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[192.521189] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.111s)
[192.681756] [040/134] (828s left) gem_lmem_swapping (parallel-random-verify-ccs)
[192.721251] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[192.764658] [041/134] (828s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[192.867890] Starting subtest: 4-tiled-8bpp-rotate-90
[192.890988] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s)
[193.026454] [042/134] (828s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[193.108275] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[193.112467] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[193.189401] [043/134] (828s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[193.291793] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[193.293990] Starting dynamic subtest: pipe-A
[193.314361] Dynamic subtest pipe-A: SKIP (0.021s)
[193.322800] Starting dynamic subtest: pipe-B
[193.350300] Dynamic subtest pipe-B: SKIP (0.033s)
[193.358080] Starting dynamic subtest: pipe-C
[193.379975] Dynamic subtest pipe-C: SKIP (0.031s)
[193.387465] Starting dynamic subtest: pipe-D
[193.412986] Dynamic subtest pipe-D: SKIP (0.032s)
[193.416568] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.120s)
[193.543432] [044/134] (828s left) gem_exec_reloc (basic-range-active)
[193.601919] Subtest basic-range-active: SKIP (0.000s)
[193.654330] [045/134] (827s left) kms_flip (blocking-wf_vblank)
[193.749388] Starting subtest: blocking-wf_vblank
[193.751408] Starting dynamic subtest: A-eDP1
[202.666334] Dynamic subtest A-eDP1: SUCCESS (8.915s)
[202.674391] Starting dynamic subtest: B-eDP1
[211.586473] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[211.593969] Starting dynamic subtest: C-eDP1
[220.503859] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[220.514065] Starting dynamic subtest: D-eDP1
[229.440640] Dynamic subtest D-eDP1: SUCCESS (8.938s)
[229.445821] Subtest blocking-wf_vblank: SUCCESS (35.693s)
[230.665019] [046/134] (790s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[230.773105] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[230.775809] Starting dynamic subtest: pipe-A-eDP-1
[230.799776] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.809784] Starting dynamic subtest: pipe-B-eDP-1
[230.831144] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.838477] Starting dynamic subtest: pipe-C-eDP-1
[230.859706] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.866786] Starting dynamic subtest: pipe-D-eDP-1
[230.889328] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.893734] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[233.037146] [047/134] (788s left) gem_mmap_offset (mmap-unmap)
[233.098058] Starting subtest: mmap-unmap
[233.100247] Starting dynamic subtest: smem0
[255.561422] Dynamic subtest smem0: SUCCESS (22.463s)
[255.563977] Subtest mmap-unmap: SUCCESS (22.463s)
[255.725682] [048/134] (766s left) kms_chamelium_hpd (dp-hpd)
[256.123582] Subtest dp-hpd: SKIP (0.000s)
[256.914128] [049/134] (764s left) fbdev (nullptr)
[256.961113] Starting subtest: nullptr
[256.963463] Subtest nullptr: SUCCESS (0.000s)
[257.031809] [050/134] (764s left) gem_exec_params (dr1-dirt)
[257.086453] Starting subtest: DR1-dirt
[257.088736] Subtest DR1-dirt: SUCCESS (0.000s)
[257.207922] [051/134] (764s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[257.298314] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[257.300639] Starting dynamic subtest: pipe-A-default-mode
[258.494261] Dynamic subtest pipe-A-default-mode: SKIP (1.195s)
[258.498318] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.196s)
[258.685898] [052/134] (763s left) kms_cursor_crc (cursor-size-hints)
[258.817436] Starting subtest: cursor-size-hints
[258.819676] Starting dynamic subtest: pipe-A-eDP-1
[259.437851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s)
[259.446051] Starting dynamic subtest: pipe-D-eDP-1
[260.719570] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.282s)
[260.721810] Subtest cursor-size-hints: SUCCESS (1.903s)
[261.532381] [053/134] (760s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[261.632909] Starting subtest: fbc-shrfb-scaledprimary
[264.659352] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.029s)
[265.838113] [054/134] (756s left) kms_pm_dc (dc6-psr)
[266.946266] Starting subtest: dc6-psr
[269.810991] Subtest dc6-psr: SUCCESS (2.863s)
[270.658940] [055/134] (751s left) kms_chamelium_color (gamma)
[270.768558] Subtest gamma: SKIP (0.000s)
[270.810468] [056/134] (751s left) gem_softpin (allocator-basic)
[270.865335] Starting subtest: allocator-basic
[270.934244] Subtest allocator-basic: SUCCESS (0.068s)
[271.089632] [057/134] (751s left) kms_vblank (query-busy)
[271.184849] Starting subtest: query-busy
[271.186648] Starting dynamic subtest: pipe-A-eDP-1
[273.060307] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[273.074916] Starting dynamic subtest: pipe-D-eDP-1
[275.609931] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s)
[275.612294] Subtest query-busy: SUCCESS (4.426s)
[276.414099] [058/134] (745s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[276.516210] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[276.625438] [059/134] (745s left) gem_exec_whisper (basic-queues-all)
[276.690497] Starting subtest: basic-queues-all
[287.557030] Subtest basic-queues-all: SUCCESS (10.862s)
[287.752303] [060/134] (734s left) kms_async_flips (invalid-async-flip-atomic)
[287.856026] Starting subtest: invalid-async-flip-atomic
[288.227396] Starting dynamic subtest: pipe-A-eDP-1
[289.029941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[289.385327] Starting dynamic subtest: pipe-B-eDP-1
[290.160952] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[290.522131] Starting dynamic subtest: pipe-C-eDP-1
[291.293724] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.777s)
[291.651216] Starting dynamic subtest: pipe-D-eDP-1
[292.419778] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[292.422128] Subtest invalid-async-flip-atomic: SUCCESS (4.566s)
[293.573700] [061/134] (728s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[293.686779] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[300.501728] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.817s)
[300.612906] [062/134] (721s left) gem_exec_schedule (preempt-queue-chain)
[300.676769] Subtest preempt-queue-chain: SKIP (0.000s)
[300.990341] [063/134] (721s left) gem_exec_fence (expired-history)
[301.429558] Starting subtest: expired-history
[308.680947] Subtest expired-history: SUCCESS (7.250s)
[309.216041] [064/134] (713s left) gem_pread (bench)
[309.281261] Subtest bench: SKIP (0.000s)
[309.353042] [065/134] (713s left) kms_hdr (invalid-metadata-sizes)
[309.457022] Starting subtest: invalid-metadata-sizes
[309.463373] Subtest invalid-metadata-sizes: SKIP (0.000s)
[309.555492] [066/134] (712s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[309.666937] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[309.678073] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[309.815198] [067/134] (712s left) kms_pm_backlight (bad-brightness)
[309.921173] Starting subtest: bad-brightness
[309.972902] Starting dynamic subtest: eDP-1
[310.294304] Dynamic subtest eDP-1: SUCCESS (0.319s)
[310.296176] Subtest bad-brightness: SUCCESS (0.372s)
[311.128822] [068/134] (711s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[311.232283] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[311.236270] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[311.366423] [069/134] (711s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[311.423127] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[311.425437] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[311.549264] [070/134] (711s left) drm_buddy (drm_buddy)
[311.589444] Starting subtest: drm_buddy
[311.606436] Starting dynamic subtest: drm_test_buddy_alloc_limit
[311.749576] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.142s)
[311.762423] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[311.903058] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.152s)
[311.911708] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[312.047136] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.144s)
[312.056640] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[312.181715] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.134s)
[312.191080] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[312.319094] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.138s)
[312.327928] Starting dynamic subtest: drm_test_buddy_alloc_clear
[312.446926] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.126s)
[312.455202] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[312.591284] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.143s)
[312.600675] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[316.734285] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.142s)
[316.742591] Starting dynamic subtest: drm_test_buddy_alloc_exceeds_max_order
[316.876178] Dynamic subtest drm_test_buddy_alloc_exceeds_max_order: SUCCESS (0.139s)
[316.878509] Subtest drm_buddy: SUCCESS (5.290s)
[317.109650] [071/134] (705s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[317.189809] Starting subtest: basic-batch-kernel-default-cmd
[317.194362] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[317.388603] [072/134] (705s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[317.504860] Starting subtest: verify-pxp-key-change-after-suspend-resume
[325.508053] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (8.004s)
[325.653761] [073/134] (697s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[325.770478] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[332.398596] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.630s)
[332.569329] [074/134] (690s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[332.667387] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[332.669710] Starting dynamic subtest: pipe-A-eDP-1
[332.728167] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[332.739057] Starting dynamic subtest: pipe-B-eDP-1
[332.796251] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[332.806113] Starting dynamic subtest: pipe-C-eDP-1
[332.863428] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[332.872894] Starting dynamic subtest: pipe-D-eDP-1
[332.935332] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[332.939397] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[334.868388] [075/134] (687s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[334.970261] Starting subtest: stress-xrgb8888-yftiled
[334.974650] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[335.045491] [076/134] (687s left) gem_ccs (ctrl-surf-copy-new-ctx)
[335.093163] Starting subtest: ctrl-surf-copy-new-ctx
[335.097624] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[335.225560] [077/134] (687s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[335.320968] Starting subtest: fbc-psr2-cursor-plane-onoff
[335.323228] Starting dynamic subtest: eDP-1
[335.327242] Dynamic subtest eDP-1: SKIP (0.000s)
[335.331458] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[335.420245] [078/134] (687s left) i915_pm_rpm (sysfs-read)
[337.039178] Starting subtest: sysfs-read
[338.204943] Subtest sysfs-read: SUCCESS (1.160s)
[338.573423] [079/134] (684s left) vgem_basic (second-client)
[338.616969] Starting subtest: second-client
[338.639042] Subtest second-client: SUCCESS (0.022s)
[338.720590] [080/134] (684s left) gem_mmap_gtt (basic-write-gtt)
[338.786620] Subtest basic-write-gtt: SKIP (0.000s)
[338.854617] [081/134] (684s left) prime_self_import (basic-llseek-size)
[338.888800] Starting subtest: basic-llseek-size
[338.914181] Subtest basic-llseek-size: SUCCESS (0.026s)
[339.042651] [082/134] (684s left) gem_eio (in-flight-internal-1us)
[339.277470] Starting subtest: in-flight-internal-1us
[340.963662] Subtest in-flight-internal-1us: SUCCESS (1.686s)
[341.158352] [083/134] (681s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[341.216740] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[341.283361] [084/134] (681s left) perf (global-sseu-config)
[341.370586] Starting subtest: global-sseu-config
[341.375759] Subtest global-sseu-config: SKIP (0.000s)
[341.416031] [085/134] (681s left) kms_invalid_mode (bad-vsync-end)
[341.517808] Starting subtest: bad-vsync-end
[341.520185] Starting dynamic subtest: pipe-A-eDP-1
[341.800819] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[341.809980] Starting dynamic subtest: pipe-B-eDP-1
[341.812227] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[341.820292] Starting dynamic subtest: pipe-C-eDP-1
[341.822456] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[341.831207] Starting dynamic subtest: pipe-D-eDP-1
[341.833310] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[341.835419] Subtest bad-vsync-end: SUCCESS (0.291s)
[342.610239] [086/134] (680s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[347.684739] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[347.686886] Starting dynamic subtest: pipe-A-eDP-1
[348.468059] Dynamic subtest pipe-A-eDP-1: SKIP (0.778s)
[348.477887] Starting dynamic subtest: pipe-B-eDP-1
[349.604219] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[349.608848] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.916s)
[350.801190] [087/134] (672s left) gen9_exec_parse (bb-secure)
[350.863511] Subtest bb-secure: SKIP (0.000s)
[350.937917] [088/134] (672s left) gem_basic (create-close)
[350.987612] Starting subtest: create-close
[350.991644] Subtest create-close: SUCCESS (0.000s)
[351.107918] [089/134] (672s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[351.201502] Starting subtest: psr-rgb565-draw-mmap-cpu
[357.948873] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.750s)
[358.084577] [090/134] (665s left) gem_ctx_persistence (engines-persistence)
[358.160331] Starting subtest: engines-persistence
[358.162594] Starting dynamic subtest: rcs0
[359.031279] Dynamic subtest rcs0: SUCCESS (0.870s)
[359.043107] Starting dynamic subtest: bcs0
[359.812944] Dynamic subtest bcs0: SUCCESS (0.780s)
[359.823476] Starting dynamic subtest: vcs0
[360.643713] Dynamic subtest vcs0: SUCCESS (0.829s)
[360.654073] Starting dynamic subtest: vcs1
[361.440820] Dynamic subtest vcs1: SUCCESS (0.795s)
[361.451738] Starting dynamic subtest: vecs0
[362.229332] Dynamic subtest vecs0: SUCCESS (0.786s)
[362.240941] Starting dynamic subtest: ccs0
[363.011984] Dynamic subtest ccs0: SUCCESS (0.781s)
[363.014974] Subtest engines-persistence: SUCCESS (4.853s)
[363.165062] [091/134] (660s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[363.257883] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[363.283849] Starting dynamic subtest: pipe-A-plane-0
[363.288163] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[363.297090] Starting dynamic subtest: pipe-A-plane-3
[363.301448] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[363.309625] Starting dynamic subtest: pipe-A-plane-5
[363.314054] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[364.409790] Starting dynamic subtest: pipe-B-plane-0
[364.414045] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[364.422716] Starting dynamic subtest: pipe-B-plane-3
[364.427289] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[364.436256] Starting dynamic subtest: pipe-B-plane-5
[364.441036] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[364.715596] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (1.458s)
[365.587122] [092/134] (657s left) kms_async_flips (async-flip-suspend-resume)
[365.691053] Starting subtest: async-flip-suspend-resume
[366.062532] Starting dynamic subtest: pipe-A-eDP-1
[384.075042] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.912s)
[384.451788] Starting dynamic subtest: pipe-B-eDP-1
[402.306985] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.108s)
[402.702358] Starting dynamic subtest: pipe-C-eDP-1
[421.099287] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.927s)
[421.469302] Starting dynamic subtest: pipe-D-eDP-1
[439.312586] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[439.314832] Subtest async-flip-suspend-resume: SUCCESS (13.561s)
[440.495761] [093/134] (583s left) gem_pwrite_snooped
[440.630211] [094/134] (582s left) kms_flip (2x-flip-vs-modeset)
[440.724882] Starting subtest: 2x-flip-vs-modeset
[440.733616] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[440.847395] [095/134] (582s left) kms_cursor_crc (cursor-onscreen-512x170)
[441.129990] Starting subtest: cursor-onscreen-512x170
[441.134485] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[441.288986] [096/134] (582s left) kms_psr (psr-sprite-mmap-cpu)
[441.388344] Starting subtest: psr-sprite-mmap-cpu
[441.390648] Starting dynamic subtest: eDP-1
[443.109653] Dynamic subtest eDP-1: SUCCESS (1.731s)
[443.111813] Subtest psr-sprite-mmap-cpu: SUCCESS (1.733s)
[443.963646] [097/134] (579s left) kms_flip (2x-blocking-absolute-wf_vblank)
[444.060239] Starting subtest: 2x-blocking-absolute-wf_vblank
[444.068793] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[444.195848] [098/134] (579s left) kms_fbcon_fbt (fbc-suspend)
[444.262787] Starting subtest: fbc-suspend
[493.529902] Subtest fbc-suspend: SUCCESS (19.470s)
[494.905338] [099/134] (528s left) kms_vblank (wait-idle)
[495.009853] Starting subtest: wait-idle
[495.011958] Starting dynamic subtest: pipe-A-eDP-1
[496.758371] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[496.771635] Starting dynamic subtest: pipe-D-eDP-1
[499.142195] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.390s)
[499.144503] Subtest wait-idle: SUCCESS (4.147s)
[499.975117] [100/134] (523s left) kms_psr (fbc-pr-primary-page-flip)
[500.082667] Starting subtest: fbc-pr-primary-page-flip
[500.087014] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[500.165529] [101/134] (523s left) perf_pmu (most-busy-idle-check-all)
[500.209997] Starting subtest: most-busy-idle-check-all
[500.212046] Starting dynamic subtest: rcs0
[500.911009] Dynamic subtest rcs0: FAIL (0.645s)
[500.921845] Starting dynamic subtest: bcs0
[501.932071] Dynamic subtest bcs0: SUCCESS (1.080s)
[501.944113] Starting dynamic subtest: vcs0
[503.915944] Dynamic subtest vcs0: SUCCESS (1.984s)
[503.929468] Starting dynamic subtest: vcs1
[505.900589] Dynamic subtest vcs1: SUCCESS (1.984s)
[505.913137] Starting dynamic subtest: vecs0
[507.884151] Dynamic subtest vecs0: SUCCESS (1.983s)
[507.896388] Starting dynamic subtest: ccs0
[509.932988] Dynamic subtest ccs0: SUCCESS (2.048s)
[509.935927] Subtest most-busy-idle-check-all: FAIL (9.739s)
[510.070286] [102/134] (513s left) kms_dsc (dsc-with-output-formats-with-bpc)
[510.175250] Starting subtest: dsc-with-output-formats-with-bpc
[510.231497] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[510.273860] [103/134] (513s left) gem_ctx_sseu (engines)
[510.330329] Subtest engines: SKIP (0.000s)
[510.396486] [104/134] (513s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[510.490162] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[510.492356] Starting dynamic subtest: pipe-A-eDP-1
[510.514883] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[510.526059] Starting dynamic subtest: pipe-B-eDP-1
[510.547093] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[510.555648] Starting dynamic subtest: pipe-C-eDP-1
[510.576853] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[510.585459] Starting dynamic subtest: pipe-D-eDP-1
[510.607192] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[510.611474] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[512.755498] [105/134] (511s left) gem_exec_gttfill (engines)
[512.830918] Starting subtest: engines
[512.833318] Starting dynamic subtest: rcs0
[535.610940] Dynamic subtest rcs0: SUCCESS (22.780s)
[535.632314] Starting dynamic subtest: bcs0
[558.859676] Dynamic subtest bcs0: SUCCESS (23.248s)
[558.872109] Starting dynamic subtest: vcs0
[582.082632] Dynamic subtest vcs0: SUCCESS (23.230s)
[582.092260] Starting dynamic subtest: vcs1
[605.299564] Dynamic subtest vcs1: SUCCESS (23.210s)
[605.310732] Starting dynamic subtest: vecs0
[628.558318] Dynamic subtest vecs0: SUCCESS (23.255s)
[628.568120] Starting dynamic subtest: ccs0
[651.834973] Dynamic subtest ccs0: SUCCESS (23.278s)
[651.837801] Subtest engines: SUCCESS (139.010s)
[652.034549] [106/134] (372s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[652.190769] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[658.916548] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.730s)
[659.056472] [107/134] (365s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[659.168922] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[663.038752] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.873s)
[664.233569] [108/134] (359s left) kms_chamelium_color (ctm-blue-to-red)
[664.330464] Subtest ctm-blue-to-red: SKIP (0.000s)
[664.376342] [109/134] (359s left) gem_ctx_persistence (processes)
[664.441066] Starting subtest: processes
[665.935034] Subtest processes: SUCCESS (1.494s)
[666.026115] [110/134] (358s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[666.095622] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[666.201985] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[666.299710] [111/134] (357s left) prime_busy (after-wait)
[666.366244] Starting subtest: after-wait
[666.368670] Starting dynamic subtest: rcs0
[666.402101] Dynamic subtest rcs0: SUCCESS (0.036s)
[666.419889] Starting dynamic subtest: bcs0
[666.466053] Dynamic subtest bcs0: SUCCESS (0.064s)
[666.476502] Starting dynamic subtest: vcs0
[666.507197] Dynamic subtest vcs0: SUCCESS (0.040s)
[666.516118] Starting dynamic subtest: vcs1
[666.548342] Dynamic subtest vcs1: SUCCESS (0.040s)
[666.557706] Starting dynamic subtest: vecs0
[666.587862] Dynamic subtest vecs0: SUCCESS (0.039s)
[666.596868] Starting dynamic subtest: ccs0
[666.628666] Dynamic subtest ccs0: SUCCESS (0.040s)
[666.735815] Subtest after-wait: SUCCESS (0.373s)
[666.824329] [112/134] (357s left) syncobj_wait (reset-unsignaled)
[666.888437] Starting subtest: reset-unsignaled
[666.890727] Subtest reset-unsignaled: SUCCESS (0.000s)
[667.025123] [113/134] (357s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[667.128521] Starting subtest: psr-2p-primscrn-spr-indfb-move
[667.132793] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[667.247026] [114/134] (357s left) syncobj_timeline (invalid-wait-illegal-handle)
[667.293827] Starting subtest: invalid-wait-illegal-handle
[667.295599] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[667.412871] [115/134] (357s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[667.508331] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[674.615679] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.110s)
[674.761564] [116/134] (349s left) api_intel_allocator (reopen)
[674.815447] Starting subtest: reopen
[674.817864] Subtest reopen: SUCCESS (0.004s)
[674.974140] [117/134] (349s left) kms_prime (d3hot)
[675.057538] Subtest D3hot: SKIP (0.000s)
[675.156608] [118/134] (349s left) gem_eio (in-flight-1us)
[675.386913] Starting subtest: in-flight-1us
[684.033124] Subtest in-flight-1us: SUCCESS (8.650s)
[684.230265] [119/134] (340s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[684.330628] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[688.587243] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.261s)
[689.739448] [120/134] (334s left) gem_render_copy (x-tiled)
[689.802946] Starting subtest: x-tiled
[689.805779] Starting dynamic subtest: smem
[689.852611] Dynamic subtest smem: SUCCESS (0.050s)
[689.855057] Subtest x-tiled: SUCCESS (0.051s)
[690.049319] [121/134] (334s left) i915_pciid
[690.219942] [122/134] (334s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[690.283317] Starting subtest: single-wait-for-submit-available-signaled
[690.285635] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[690.400554] [123/134] (334s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[690.502519] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[690.506486] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[690.586542] [124/134] (334s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[690.682910] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[690.686965] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[690.804433] [125/134] (334s left) gem_exec_reloc (basic-write-gtt-noreloc)
[690.863064] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[690.938749] [126/134] (333s left) gem_exec_create (basic)
[691.010105] Starting subtest: basic
[691.012071] Starting dynamic subtest: smem
[694.893477] Dynamic subtest smem: SUCCESS (3.884s)
[694.896360] Subtest basic: SUCCESS (3.886s)
[695.098210] [127/134] (329s left) gem_exec_params (no-bsd)
[695.158979] Starting subtest: no-bsd
[695.164573] Subtest no-bsd: SUCCESS (0.004s)
[697.009519] [128/134] (327s left) gem_exec_params (batch-first)
[697.075118] Starting subtest: batch-first
[697.084906] Subtest batch-first: SUCCESS (0.010s)
[697.252855] [129/134] (327s left) kms_plane_scaling (2x-scaler-multi-pipe)
[697.353322] Starting subtest: 2x-scaler-multi-pipe
[697.357915] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[697.489795] [130/134] (327s left) kms_psr (psr-cursor-mmap-gtt)
[697.591619] Starting subtest: psr-cursor-mmap-gtt
[697.593856] Starting dynamic subtest: eDP-1
[699.302757] Dynamic subtest eDP-1: SUCCESS (1.710s)
[699.305076] Subtest psr-cursor-mmap-gtt: SUCCESS (1.712s)
[700.182078] [131/134] (324s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[700.277662] Starting subtest: fbc-rgb565-draw-mmap-gtt
[700.282068] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[700.405707] [132/134] (324s left) kms_psr (pr-primary-mmap-gtt)
[700.497812] Starting subtest: pr-primary-mmap-gtt
[700.501920] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[700.592574] [133/134] (324s left) gem_exec_schedule (preempt-queue-contexts-chain)
[700.677354] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[700.998984] [134/134] (324s left) gem_exec_balancer (full-late)
[701.068468] Starting subtest: full-late
[705.790598] Subtest full-late: SUCCESS (4.726s)
[706.138319] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: sysfs_heartbeat_interval
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: kms_plane_multiple
results: parsing output: 10/ for test: gem_exec_capture
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: core_debugfs
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: gen9_exec_parse
results: parsing output: 16/ for test: gem_exec_store
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_wait
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_fence_thrash
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_pipe_crc_basic
results: parsing output: 24/ for test: kms_setmode
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: gem_partial_pwrite_pread
results: parsing output: 30/ for test: kms_color
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: i915_query
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_lmem_swapping
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_mmap_offset
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: fbdev
results: parsing output: 49/ for test: gem_exec_params
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_pm_dc
results: parsing output: 54/ for test: kms_chamelium_color
results: parsing output: 55/ for test: gem_softpin
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: gem_pread
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_pm_backlight
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: drm_buddy
results: parsing output: 70/ for test: gem_exec_flush
results: parsing output: 71/ for test: gem_pxp
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_pipe_stress
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: i915_pm_rpm
results: parsing output: 78/ for test: vgem_basic
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: prime_self_import
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: kms_pipe_b_c_ivb
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: kms_invalid_mode
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: gen9_exec_parse
results: parsing output: 87/ for test: gem_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: gem_pwrite_snooped
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_fbcon_fbt
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_dsc
results: parsing output: 102/ for test: gem_ctx_sseu
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: gem_exec_gttfill
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_chamelium_color
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: prime_busy
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: api_intel_allocator
results: parsing output: 116/ for test: kms_prime
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: i915_pciid
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: gem_exec_create
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: gem_exec_params
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: gem_exec_schedule
results: parsing output: 133/ for test: gem_exec_balancer
Done.