[57.930324] Initializing watchdogs
[57.930373]   /dev/watchdog0
[57.944367] [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]
[57.949212] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.951393] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.955048] [001/134] (960s left) kms_content_protection (type1)
[58.131738] Starting subtest: type1
[58.136108] Subtest type1: SKIP (0.000s)
[58.292233] [002/134] (960s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[58.407469] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[58.411871] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[58.496843] [003/134] (960s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[58.565629] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[58.569980] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[58.769634] [004/134] (959s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[58.866792] Starting subtest: flip-vs-dpms-off-vs-modeset
[58.869207] Starting dynamic subtest: A-eDP1
[62.541822] Dynamic subtest A-eDP1: SUCCESS (3.676s)
[62.552100] Starting dynamic subtest: B-eDP1
[65.756276] Dynamic subtest B-eDP1: SUCCESS (3.214s)
[65.765232] Starting dynamic subtest: C-eDP1
[68.839213] Dynamic subtest C-eDP1: SUCCESS (3.084s)
[68.847356] Starting dynamic subtest: D-eDP1
[72.048075] Dynamic subtest D-eDP1: SUCCESS (3.206s)
[72.050294] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.185s)
[72.860492] [005/134] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[72.960293] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[72.964391] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[73.086345] [006/134] (945s left) kms_big_fb (linear-64bpp-rotate-270)
[73.191440] Starting subtest: linear-64bpp-rotate-270
[73.228284] Subtest linear-64bpp-rotate-270: SKIP (0.036s)
[73.360510] [007/134] (945s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[73.469396] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[73.473308] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[73.585176] [008/134] (945s left) sysfs_heartbeat_interval (idempotent)
[73.637641] Starting subtest: idempotent
[73.639938] Starting dynamic subtest: vecs0
[73.642293] Dynamic subtest vecs0: SUCCESS (0.001s)
[73.649084] Starting dynamic subtest: ccs0
[73.651180] Dynamic subtest ccs0: SUCCESS (0.001s)
[73.657698] Starting dynamic subtest: vcs0
[73.659837] Dynamic subtest vcs0: SUCCESS (0.000s)
[73.666275] Starting dynamic subtest: bcs0
[73.668448] Dynamic subtest bcs0: SUCCESS (0.000s)
[73.674998] Starting dynamic subtest: rcs0
[73.677215] Dynamic subtest rcs0: SUCCESS (0.001s)
[73.683791] Starting dynamic subtest: vcs1
[73.685961] Dynamic subtest vcs1: SUCCESS (0.000s)
[73.688130] Subtest idempotent: SUCCESS (0.005s)
[73.780735] [009/134] (944s left) perf (per-context-mode-unprivileged)
[73.898170] Starting subtest: per-context-mode-unprivileged
[73.901492] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[73.937576] [010/134] (944s left) kms_plane_multiple (tiling-y)
[74.033027] Starting subtest: tiling-y
[74.036658] Subtest tiling-y: SKIP (0.000s)
[74.112914] [011/134] (944s left) gem_exec_capture (userptr)
[74.169039] Starting subtest: userptr
[74.988543] Subtest userptr: SUCCESS (0.819s)
[75.122209] [012/134] (943s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[75.246486] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[76.047918] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s)
[76.219223] [013/134] (942s left) core_debugfs (read-all-entries)
[76.282533] Starting subtest: read-all-entries
[76.378727] Subtest read-all-entries: SUCCESS (0.096s)
[76.451203] [014/134] (942s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[81.437819] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[81.440248] Starting dynamic subtest: pipe-A-eDP-1
[82.233384] Dynamic subtest pipe-A-eDP-1: SKIP (0.791s)
[82.241898] Starting dynamic subtest: pipe-B-eDP-1
[83.366751] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[83.371306] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.926s)
[84.556389] [015/134] (934s left) gem_exec_fence (basic-wait)
[84.744780] Starting subtest: basic-wait
[84.747609] Starting dynamic subtest: rcs0
[84.840381] Dynamic subtest rcs0: SUCCESS (0.096s)
[84.850294] Starting dynamic subtest: bcs0
[84.899470] Dynamic subtest bcs0: SUCCESS (0.059s)
[84.909062] Starting dynamic subtest: vcs0
[84.956069] Dynamic subtest vcs0: SUCCESS (0.055s)
[84.965530] Starting dynamic subtest: vcs1
[85.019947] Dynamic subtest vcs1: SUCCESS (0.063s)
[85.030044] Starting dynamic subtest: vecs0
[85.084069] Dynamic subtest vecs0: SUCCESS (0.063s)
[85.093619] Starting dynamic subtest: ccs0
[85.150014] Dynamic subtest ccs0: SUCCESS (0.065s)
[85.152571] Subtest basic-wait: SUCCESS (0.407s)
[87.057356] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[87.060382] [016/134] (931s left) gen9_exec_parse (unaligned-jump)
[87.121320] Subtest unaligned-jump: SKIP (0.000s)
[87.185161] [017/134] (931s left) gem_exec_store (basic)
[87.244586] Starting subtest: basic
[87.352190] Subtest basic: SUCCESS (0.109s)
[87.548854] [018/134] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[87.644376] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[87.646683] Starting dynamic subtest: pipe-A-eDP-1
[88.575769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.926s)
[88.583929] Starting dynamic subtest: pipe-B-eDP-1
[90.122811] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.543s)
[90.130914] Starting dynamic subtest: pipe-C-eDP-1
[91.601590] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.478s)
[91.610749] Starting dynamic subtest: pipe-D-eDP-1
[93.172322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.570s)
[93.174634] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.522s)
[94.322727] [019/134] (924s left) gem_wait (write-busy)
[94.396728] Starting subtest: write-busy
[94.399077] Starting dynamic subtest: all-engines
[95.018389] Dynamic subtest all-engines: SUCCESS (0.622s)
[95.034456] Starting dynamic subtest: rcs0
[95.573621] Dynamic subtest rcs0: SUCCESS (0.554s)
[95.588847] Starting dynamic subtest: bcs0
[96.121524] Dynamic subtest bcs0: SUCCESS (0.547s)
[96.136225] Starting dynamic subtest: vcs0
[97.879717] Dynamic subtest vcs0: SUCCESS (1.755s)
[97.893949] Starting dynamic subtest: vcs1
[99.926241] Dynamic subtest vcs1: SUCCESS (2.045s)
[99.940038] Starting dynamic subtest: vecs0
[101.911471] Dynamic subtest vecs0: SUCCESS (1.984s)
[101.925935] Starting dynamic subtest: ccs0
[102.460744] Dynamic subtest ccs0: SUCCESS (0.549s)
[102.463311] Subtest write-busy: SUCCESS (8.064s)
[102.682483] [020/134] (916s left) perf_pmu (interrupts-sync)
[102.729629] Starting subtest: interrupts-sync
[103.828641] Subtest interrupts-sync: SUCCESS (1.097s)
[103.976410] [021/134] (915s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[104.084877] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[111.023266] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.942s)
[111.170920] [022/134] (908s left) gem_fence_thrash (bo-write-verify-threaded-y)
[111.208958] Starting subtest: bo-write-verify-threaded-y
[111.226619] Subtest bo-write-verify-threaded-y: SKIP (0.016s)
[111.288614] [023/134] (907s left) kms_cursor_crc (cursor-sliding-256x256)
[111.543024] Starting subtest: cursor-sliding-256x256
[111.551403] Starting dynamic subtest: pipe-A-eDP-1
[114.782816] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.231s)
[114.810257] Starting dynamic subtest: pipe-D-eDP-1
[118.639844] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.836s)
[118.642199] Subtest cursor-sliding-256x256: SUCCESS (7.096s)
[119.523195] [024/134] (899s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[119.623294] Starting subtest: compare-crc-sanitycheck-xr24
[119.625571] Starting dynamic subtest: pipe-A-eDP-1
[120.271611] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.647s)
[120.281144] Starting dynamic subtest: pipe-B-eDP-1
[121.626160] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.352s)
[121.635407] Starting dynamic subtest: pipe-C-eDP-1
[122.873404] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.245s)
[122.885668] Starting dynamic subtest: pipe-D-eDP-1
[124.119043] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s)
[124.121075] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.493s)
[124.962484] [025/134] (894s left) kms_setmode (clone-exclusive-crtc)
[125.026709] Starting subtest: clone-exclusive-crtc
[125.033051] Subtest clone-exclusive-crtc: SKIP (0.000s)
[125.153168] [026/134] (894s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[125.254848] Starting subtest: fbc-psr-cursor-mmap-gtt
[125.257051] Starting dynamic subtest: eDP-1
[125.261194] Dynamic subtest eDP-1: SKIP (0.000s)
[125.265445] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[125.341967] [027/134] (894s left) perf (invalid-create-userspace-config)
[125.439250] Starting subtest: invalid-create-userspace-config
[125.441644] Subtest invalid-create-userspace-config: SUCCESS (0.002s)
[125.484166] [028/134] (894s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[125.581866] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[125.584037] Starting dynamic subtest: pipe-A-eDP-1
[125.643589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[125.652089] Starting dynamic subtest: pipe-B-eDP-1
[125.704821] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[125.713060] Starting dynamic subtest: pipe-C-eDP-1
[125.765611] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[125.773759] Starting dynamic subtest: pipe-D-eDP-1
[125.841680] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.073s)
[125.843996] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.260s)
[128.117123] [029/134] (891s left) syncobj_wait (invalid-reset-one-illegal-handle)
[128.190547] Starting subtest: invalid-reset-one-illegal-handle
[128.192362] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[128.331606] [030/134] (891s left) gem_partial_pwrite_pread (writes-after-reads-display)
[128.394999] Subtest writes-after-reads-display: SKIP (0.000s)
[128.475064] [031/134] (891s left) kms_color (deep-color)
[128.573737] Starting subtest: deep-color
[129.682861] Starting dynamic subtest: pipe-A-eDP-1-gamma
[130.387671] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.702s)
[130.396884] Starting dynamic subtest: pipe-A-eDP-1-degamma
[131.893857] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.506s)
[131.904101] Starting dynamic subtest: pipe-A-eDP-1-ctm
[133.310451] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.416s)
[134.083310] Starting dynamic subtest: pipe-B-eDP-1-gamma
[134.814609] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.738s)
[134.824707] Starting dynamic subtest: pipe-B-eDP-1-degamma
[136.290783] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.475s)
[136.301231] Starting dynamic subtest: pipe-B-eDP-1-ctm
[137.736144] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.444s)
[138.488628] Starting dynamic subtest: pipe-C-eDP-1-gamma
[139.164262] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.684s)
[139.172889] Starting dynamic subtest: pipe-C-eDP-1-degamma
[140.550769] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.383s)
[140.559329] Starting dynamic subtest: pipe-C-eDP-1-ctm
[141.970438] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.419s)
[142.783666] Starting dynamic subtest: pipe-D-eDP-1-gamma
[143.480835] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.703s)
[143.493743] Starting dynamic subtest: pipe-D-eDP-1-degamma
[144.946814] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.468s)
[144.955639] Starting dynamic subtest: pipe-D-eDP-1-ctm
[146.358812] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.409s)
[146.361081] Subtest deep-color: SUCCESS (17.784s)
[147.247920] [032/134] (872s left) kms_flip (2x-flip-vs-wf_vblank)
[147.338248] Starting subtest: 2x-flip-vs-wf_vblank
[147.352351] Subtest 2x-flip-vs-wf_vblank: SKIP (0.013s)
[147.489241] [033/134] (872s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[147.616292] Starting subtest: cursorB-vs-flipA-varying-size
[147.622960] Subtest cursorB-vs-flipA-varying-size: SKIP (0.004s)
[147.789077] [034/134] (871s left) i915_query (query-regions-garbage-items)
[147.845409] Starting subtest: query-regions-garbage-items
[147.847572] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[147.967131] [035/134] (871s left) kms_cursor_legacy (forked-bo)
[148.095207] Starting subtest: forked-bo
[148.097306] Starting dynamic subtest: pipe-A
[153.600169] Dynamic subtest pipe-A: SUCCESS (5.448s)
[153.609387] Starting dynamic subtest: pipe-B
[159.057099] Dynamic subtest pipe-B: SUCCESS (5.455s)
[159.067993] Starting dynamic subtest: pipe-C
[164.523725] Dynamic subtest pipe-C: SUCCESS (5.464s)
[164.532910] Starting dynamic subtest: pipe-D
[169.985943] Dynamic subtest pipe-D: SUCCESS (5.458s)
[169.999976] Starting dynamic subtest: all-pipes
[175.490930] Dynamic subtest all-pipes: SUCCESS (5.504s)
[175.493464] Subtest forked-bo: SUCCESS (27.341s)
[175.611607] [036/134] (844s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[175.708759] Starting subtest: y-tiled-64bpp-rotate-180
[175.712848] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[175.838553] [037/134] (844s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[175.937679] Starting subtest: fbcpsr-1p-rte
[183.203309] Subtest fbcpsr-1p-rte: SUCCESS (7.270s)
[183.335755] [038/134] (836s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[183.394997] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[183.498090] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[183.584419] [039/134] (836s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[183.697061] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[190.831119] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.137s)
[190.999939] [040/134] (828s left) gem_lmem_swapping (parallel-random-verify-ccs)
[191.037118] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[191.085904] [041/134] (828s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[191.194887] Starting subtest: 4-tiled-8bpp-rotate-90
[191.219795] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.024s)
[191.363678] [042/134] (828s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[191.462147] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[191.466405] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[191.542446] [043/134] (828s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[191.640369] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[191.642654] Starting dynamic subtest: pipe-A
[191.664245] Dynamic subtest pipe-A: SKIP (0.020s)
[191.674745] Starting dynamic subtest: pipe-B
[191.704696] Dynamic subtest pipe-B: SKIP (0.039s)
[191.712463] Starting dynamic subtest: pipe-C
[191.770320] Dynamic subtest pipe-C: SKIP (0.060s)
[191.777756] Starting dynamic subtest: pipe-D
[191.830780] Dynamic subtest pipe-D: SKIP (0.061s)
[191.834498] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.190s)
[191.960653] [044/134] (828s left) gem_exec_reloc (basic-range-active)
[192.025559] Subtest basic-range-active: SKIP (0.000s)
[192.094480] [045/134] (828s left) kms_flip (blocking-wf_vblank)
[192.190491] Starting subtest: blocking-wf_vblank
[192.192304] Starting dynamic subtest: A-eDP1
[201.188586] Dynamic subtest A-eDP1: SUCCESS (8.962s)
[201.201177] Starting dynamic subtest: B-eDP1
[210.124835] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[210.138536] Starting dynamic subtest: C-eDP1
[219.051982] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[219.064847] Starting dynamic subtest: D-eDP1
[227.981767] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[227.983820] Subtest blocking-wf_vblank: SUCCESS (35.748s)
[229.185337] [046/134] (791s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[229.291017] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[229.293190] Starting dynamic subtest: pipe-A-eDP-1
[229.315237] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[229.324586] Starting dynamic subtest: pipe-B-eDP-1
[229.346962] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[229.355324] Starting dynamic subtest: pipe-C-eDP-1
[229.376810] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[229.384721] Starting dynamic subtest: pipe-D-eDP-1
[229.406446] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[229.410795] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.017s)
[231.652380] [047/134] (788s left) gem_mmap_offset (mmap-unmap)
[231.718510] Starting subtest: mmap-unmap
[231.720473] Starting dynamic subtest: smem0
[254.752120] Dynamic subtest smem0: SUCCESS (22.984s)
[254.754769] Subtest mmap-unmap: SUCCESS (22.986s)
[254.814908] [048/134] (765s left) kms_chamelium_hpd (dp-hpd)
[255.201062] Subtest dp-hpd: SKIP (0.000s)
[256.030301] [049/134] (764s left) fbdev (nullptr)
[256.082070] Starting subtest: nullptr
[256.084327] Subtest nullptr: SUCCESS (0.000s)
[256.153166] [050/134] (764s left) gem_exec_params (dr1-dirt)
[256.227696] Starting subtest: DR1-dirt
[256.229926] Subtest DR1-dirt: SUCCESS (0.000s)
[256.367044] [051/134] (764s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[256.464679] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[256.466943] Starting dynamic subtest: pipe-A-default-mode
[257.614538] Dynamic subtest pipe-A-default-mode: SKIP (1.149s)
[257.618502] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.150s)
[257.817220] [052/134] (762s left) kms_cursor_crc (cursor-size-hints)
[257.945752] Starting subtest: cursor-size-hints
[257.948022] Starting dynamic subtest: pipe-A-eDP-1
[258.564044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s)
[258.572829] Starting dynamic subtest: pipe-D-eDP-1
[259.844513] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s)
[259.846825] Subtest cursor-size-hints: SUCCESS (1.899s)
[260.658366] [053/134] (759s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[260.761266] Starting subtest: fbc-shrfb-scaledprimary
[263.766926] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.008s)
[264.978046] [054/134] (755s left) kms_pm_dc (dc6-psr)
[266.091399] Starting subtest: dc6-psr
[268.972749] Subtest dc6-psr: SUCCESS (2.883s)
[269.796510] [055/134] (750s left) kms_chamelium_color (gamma)
[269.894885] Subtest gamma: SKIP (0.000s)
[269.941439] [056/134] (750s left) gem_softpin (allocator-basic)
[270.004572] Starting subtest: allocator-basic
[270.074600] Subtest allocator-basic: SUCCESS (0.069s)
[270.231599] [057/134] (750s left) kms_vblank (query-busy)
[270.324159] Starting subtest: query-busy
[270.326386] Starting dynamic subtest: pipe-A-eDP-1
[272.208407] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[272.221688] Starting dynamic subtest: pipe-D-eDP-1
[274.755422] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[274.757863] Subtest query-busy: SUCCESS (4.434s)
[275.561771] [058/134] (745s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[275.666330] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[275.804615] [059/134] (744s left) gem_exec_whisper (basic-queues-all)
[275.872187] Starting subtest: basic-queues-all
[286.701565] Subtest basic-queues-all: SUCCESS (10.827s)
[286.897867] [060/134] (733s left) kms_async_flips (invalid-async-flip-atomic)
[287.002065] Starting subtest: invalid-async-flip-atomic
[287.373330] Starting dynamic subtest: pipe-A-eDP-1
[288.177311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.804s)
[288.540811] Starting dynamic subtest: pipe-B-eDP-1
[289.313392] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.779s)
[289.669368] Starting dynamic subtest: pipe-C-eDP-1
[290.451888] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.789s)
[290.806796] Starting dynamic subtest: pipe-D-eDP-1
[291.574498] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s)
[291.576842] Subtest invalid-async-flip-atomic: SUCCESS (4.575s)
[292.745674] [061/134] (728s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[292.851521] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[299.643524] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.794s)
[299.759030] [062/134] (721s left) gem_exec_schedule (preempt-queue-chain)
[299.834857] Subtest preempt-queue-chain: SKIP (0.000s)
[300.127969] [063/134] (720s left) gem_exec_fence (expired-history)
[300.570481] Starting subtest: expired-history
[307.697809] Subtest expired-history: SUCCESS (7.127s)
[308.258217] [064/134] (712s left) gem_pread (bench)
[308.320219] Subtest bench: SKIP (0.000s)
[308.401226] [065/134] (712s left) kms_hdr (invalid-metadata-sizes)
[308.503067] Starting subtest: invalid-metadata-sizes
[308.509686] Subtest invalid-metadata-sizes: SKIP (0.000s)
[308.588076] [066/134] (712s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[308.694223] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[308.706345] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[308.808087] [067/134] (712s left) kms_pm_backlight (bad-brightness)
[308.892415] Starting subtest: bad-brightness
[308.941150] Starting dynamic subtest: eDP-1
[309.257714] Dynamic subtest eDP-1: SUCCESS (0.316s)
[309.260114] Subtest bad-brightness: SUCCESS (0.368s)
[310.157661] [068/134] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[310.274561] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[310.278845] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[310.394291] [069/134] (710s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[310.458306] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[310.460591] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[310.587854] [070/134] (710s left) drm_buddy (drm_buddy)
[310.621965] Starting subtest: drm_buddy
[310.646230] Starting dynamic subtest: drm_test_buddy_alloc_limit
[310.779419] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.133s)
[310.793518] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[310.909176] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.126s)
[310.919057] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[311.046046] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.136s)
[311.055724] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[311.177551] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.131s)
[311.185435] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[311.299716] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.123s)
[311.308835] Starting dynamic subtest: drm_test_buddy_alloc_clear
[311.427725] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.126s)
[311.437553] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[311.551126] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.120s)
[311.560526] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[315.735200] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.182s)
[315.745641] Starting dynamic subtest: drm_test_buddy_alloc_exceeds_max_order
[315.864226] Dynamic subtest drm_test_buddy_alloc_exceeds_max_order: SUCCESS (0.128s)
[315.866326] Subtest drm_buddy: SUCCESS (5.242s)
[316.073157] [071/134] (705s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[316.142583] Starting subtest: basic-batch-kernel-default-cmd
[316.146945] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[316.340140] [072/134] (704s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[316.478810] Starting subtest: verify-pxp-key-change-after-suspend-resume
[324.547692] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (8.070s)
[330.714644] [073/134] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[330.837110] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[337.548698] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.712s)
[337.700395] [074/134] (689s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[337.793656] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[337.795979] Starting dynamic subtest: pipe-A-eDP-1
[337.851065] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[337.860061] Starting dynamic subtest: pipe-B-eDP-1
[337.915702] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[337.925546] Starting dynamic subtest: pipe-C-eDP-1
[337.981936] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[337.991688] Starting dynamic subtest: pipe-D-eDP-1
[338.048041] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[338.052109] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[340.126155] [075/134] (687s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[340.223780] Starting subtest: stress-xrgb8888-yftiled
[340.228058] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[340.303082] [076/134] (687s left) gem_ccs (ctrl-surf-copy-new-ctx)
[340.355784] Starting subtest: ctrl-surf-copy-new-ctx
[340.360318] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[340.496601] [077/134] (686s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[340.577309] Starting subtest: fbc-psr2-cursor-plane-onoff
[340.579493] Starting dynamic subtest: eDP-1
[340.583653] Dynamic subtest eDP-1: SKIP (0.000s)
[340.587819] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[340.664918] [078/134] (686s left) i915_pm_rpm (sysfs-read)
[342.191845] Starting subtest: sysfs-read
[343.336832] Subtest sysfs-read: SUCCESS (1.146s)
[343.724011] [079/134] (683s left) vgem_basic (second-client)
[343.767226] Starting subtest: second-client
[343.787578] Subtest second-client: SUCCESS (0.022s)
[343.858334] [080/134] (683s left) gem_mmap_gtt (basic-write-gtt)
[343.919434] Subtest basic-write-gtt: SKIP (0.000s)
[343.986900] [081/134] (683s left) prime_self_import (basic-llseek-size)
[344.022304] Starting subtest: basic-llseek-size
[344.049701] Subtest basic-llseek-size: SUCCESS (0.028s)
[344.172643] [082/134] (683s left) gem_eio (in-flight-internal-1us)
[344.412730] Starting subtest: in-flight-internal-1us
[346.025421] Subtest in-flight-internal-1us: SUCCESS (1.611s)
[346.189486] [083/134] (681s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[346.264594] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[346.336209] [084/134] (681s left) perf (global-sseu-config)
[346.423129] Starting subtest: global-sseu-config
[346.427118] Subtest global-sseu-config: SKIP (0.000s)
[346.466287] [085/134] (681s left) kms_invalid_mode (bad-vsync-end)
[346.580029] Starting subtest: bad-vsync-end
[346.582214] Starting dynamic subtest: pipe-A-eDP-1
[346.865282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[346.874213] Starting dynamic subtest: pipe-B-eDP-1
[346.876070] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[346.884339] Starting dynamic subtest: pipe-C-eDP-1
[346.886224] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[346.894701] Starting dynamic subtest: pipe-D-eDP-1
[346.896851] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[346.899053] Subtest bad-vsync-end: SUCCESS (0.292s)
[347.740613] [086/134] (680s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[352.816669] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[352.818566] Starting dynamic subtest: pipe-A-eDP-1
[353.604575] Dynamic subtest pipe-A-eDP-1: SKIP (0.784s)
[353.614650] Starting dynamic subtest: pipe-B-eDP-1
[354.734330] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[354.738573] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.917s)
[355.931229] [087/134] (671s left) gen9_exec_parse (bb-secure)
[355.988477] Subtest bb-secure: SKIP (0.000s)
[356.079487] [088/134] (671s left) gem_basic (create-close)
[356.146603] Starting subtest: create-close
[356.151146] Subtest create-close: SUCCESS (0.000s)
[356.274219] [089/134] (671s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[356.375397] Starting subtest: psr-rgb565-draw-mmap-cpu
[363.260798] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.890s)
[363.411940] [090/134] (664s left) gem_ctx_persistence (engines-persistence)
[363.494356] Starting subtest: engines-persistence
[363.496638] Starting dynamic subtest: rcs0
[364.317842] Dynamic subtest rcs0: SUCCESS (0.823s)
[364.330377] Starting dynamic subtest: bcs0
[365.108025] Dynamic subtest bcs0: SUCCESS (0.788s)
[365.120792] Starting dynamic subtest: vcs0
[365.923792] Dynamic subtest vcs0: SUCCESS (0.814s)
[365.935884] Starting dynamic subtest: vcs1
[366.661937] Dynamic subtest vcs1: SUCCESS (0.736s)
[366.673278] Starting dynamic subtest: vecs0
[367.467051] Dynamic subtest vecs0: SUCCESS (0.803s)
[367.483605] Starting dynamic subtest: ccs0
[368.254028] Dynamic subtest ccs0: SUCCESS (0.784s)
[368.256657] Subtest engines-persistence: SUCCESS (4.761s)
[368.414360] [091/134] (659s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[368.523110] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[368.549587] Starting dynamic subtest: pipe-A-plane-0
[368.554608] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[368.566039] Starting dynamic subtest: pipe-A-plane-3
[368.570504] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[368.579456] Starting dynamic subtest: pipe-A-plane-5
[368.584292] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[369.651577] Starting dynamic subtest: pipe-B-plane-0
[369.655785] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[369.664770] Starting dynamic subtest: pipe-B-plane-3
[369.669305] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[369.680706] Starting dynamic subtest: pipe-B-plane-5
[369.684794] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[369.958904] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (1.433s)
[370.833307] [092/134] (657s left) kms_async_flips (async-flip-suspend-resume)
[370.920976] Starting subtest: async-flip-suspend-resume
[371.293368] Starting dynamic subtest: pipe-A-eDP-1
[389.163735] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.338s)
[389.543723] Starting dynamic subtest: pipe-B-eDP-1
[408.145748] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.334s)
[408.523279] Starting dynamic subtest: pipe-C-eDP-1
[427.181528] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.299s)
[427.548674] Starting dynamic subtest: pipe-D-eDP-1
[446.158083] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.287s)
[446.171142] Subtest async-flip-suspend-resume: SUCCESS (14.735s)
[458.445440] [093/134] (580s left) gem_pwrite_snooped
[458.602579] [094/134] (580s left) kms_flip (2x-flip-vs-modeset)
[458.711985] Starting subtest: 2x-flip-vs-modeset
[458.723091] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[458.859407] [095/134] (580s left) kms_cursor_crc (cursor-onscreen-512x170)
[459.150246] Starting subtest: cursor-onscreen-512x170
[459.154611] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[459.313878] [096/134] (580s left) kms_psr (psr-sprite-mmap-cpu)
[459.426011] Starting subtest: psr-sprite-mmap-cpu
[459.427812] Starting dynamic subtest: eDP-1
[461.184723] Dynamic subtest eDP-1: SUCCESS (1.758s)
[461.186976] Subtest psr-sprite-mmap-cpu: SUCCESS (1.760s)
[462.053872] [097/134] (577s left) kms_flip (2x-blocking-absolute-wf_vblank)
[462.157377] Starting subtest: 2x-blocking-absolute-wf_vblank
[462.166113] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[462.265124] [098/134] (577s left) kms_fbcon_fbt (fbc-suspend)
[462.326044] Starting subtest: fbc-suspend
[512.241736] Subtest fbc-suspend: SUCCESS (19.804s)
[514.567246] [099/134] (525s left) kms_vblank (wait-idle)
[514.682787] Starting subtest: wait-idle
[514.685136] Starting dynamic subtest: pipe-A-eDP-1
[516.440080] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[516.455120] Starting dynamic subtest: pipe-D-eDP-1
[518.922789] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.478s)
[518.924607] Subtest wait-idle: SUCCESS (4.236s)
[519.750060] [100/134] (520s left) kms_psr (fbc-pr-primary-page-flip)
[519.844865] Starting subtest: fbc-pr-primary-page-flip
[519.848830] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[519.928906] [101/134] (520s left) perf_pmu (most-busy-idle-check-all)
[519.972558] Starting subtest: most-busy-idle-check-all
[519.974737] Starting dynamic subtest: rcs0
[520.674951] Dynamic subtest rcs0: FAIL (0.645s)
[520.686574] Starting dynamic subtest: bcs0
[521.541202] Dynamic subtest bcs0: SUCCESS (0.922s)
[521.554014] Starting dynamic subtest: vcs0
[523.525274] Dynamic subtest vcs0: SUCCESS (1.980s)
[523.536939] Starting dynamic subtest: vcs1
[525.508712] Dynamic subtest vcs1: SUCCESS (1.980s)
[525.520460] Starting dynamic subtest: vecs0
[527.493212] Dynamic subtest vecs0: SUCCESS (1.981s)
[527.505744] Starting dynamic subtest: ccs0
[529.541212] Dynamic subtest ccs0: SUCCESS (2.045s)
[529.543859] Subtest most-busy-idle-check-all: FAIL (9.566s)
[529.683188] [102/134] (510s left) kms_dsc (dsc-with-output-formats-with-bpc)
[529.787779] Starting subtest: dsc-with-output-formats-with-bpc
[529.844558] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[529.887207] [103/134] (510s left) gem_ctx_sseu (engines)
[529.949014] Subtest engines: SKIP (0.000s)
[530.021961] [104/134] (510s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[530.103554] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[530.105818] Starting dynamic subtest: pipe-A-eDP-1
[530.127640] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[530.137818] Starting dynamic subtest: pipe-B-eDP-1
[530.158490] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[530.167452] Starting dynamic subtest: pipe-C-eDP-1
[530.187930] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[530.196748] Starting dynamic subtest: pipe-D-eDP-1
[530.217358] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[530.221268] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[532.416522] [105/134] (508s left) gem_exec_gttfill (engines)
[532.495348] Starting subtest: engines
[532.497383] Starting dynamic subtest: rcs0
[555.485808] Dynamic subtest rcs0: SUCCESS (22.986s)
[555.498190] Starting dynamic subtest: bcs0
[578.806486] Dynamic subtest bcs0: SUCCESS (23.314s)
[578.819248] Starting dynamic subtest: vcs0
[602.163479] Dynamic subtest vcs0: SUCCESS (23.347s)
[602.175321] Starting dynamic subtest: vcs1
[625.429776] Dynamic subtest vcs1: SUCCESS (23.271s)
[625.439330] Starting dynamic subtest: vecs0
[648.750522] Dynamic subtest vecs0: SUCCESS (23.318s)
[648.760324] Starting dynamic subtest: ccs0
[671.986714] Dynamic subtest ccs0: SUCCESS (23.232s)
[671.989514] Subtest engines: SUCCESS (139.481s)
[672.187738] [106/134] (368s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[672.352281] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[679.029693] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.679s)
[679.163036] [107/134] (361s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[679.267382] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[683.150425] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.886s)
[684.342427] [108/134] (356s left) kms_chamelium_color (ctm-blue-to-red)
[684.433821] Subtest ctm-blue-to-red: SKIP (0.000s)
[684.483067] [109/134] (356s left) gem_ctx_persistence (processes)
[684.549125] Starting subtest: processes
[686.492219] Subtest processes: SUCCESS (1.946s)
[686.604432] [110/134] (354s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[686.668167] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[686.777544] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[686.868438] [111/134] (354s left) prime_busy (after-wait)
[686.932622] Starting subtest: after-wait
[686.937729] Starting dynamic subtest: rcs0
[686.992907] Dynamic subtest rcs0: SUCCESS (0.057s)
[687.005053] Starting dynamic subtest: bcs0
[687.054604] Dynamic subtest bcs0: SUCCESS (0.060s)
[687.065103] Starting dynamic subtest: vcs0
[687.097196] Dynamic subtest vcs0: SUCCESS (0.042s)
[687.107276] Starting dynamic subtest: vcs1
[687.138950] Dynamic subtest vcs1: SUCCESS (0.041s)
[687.149222] Starting dynamic subtest: vecs0
[687.181165] Dynamic subtest vecs0: SUCCESS (0.042s)
[687.190570] Starting dynamic subtest: ccs0
[687.223744] Dynamic subtest ccs0: SUCCESS (0.042s)
[687.331747] Subtest after-wait: SUCCESS (0.398s)
[687.434062] [112/134] (353s left) syncobj_wait (reset-unsignaled)
[687.494951] Starting subtest: reset-unsignaled
[687.497132] Subtest reset-unsignaled: SUCCESS (0.000s)
[687.620267] [113/134] (353s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[687.736724] Starting subtest: psr-2p-primscrn-spr-indfb-move
[687.740807] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[687.836917] [114/134] (353s left) syncobj_timeline (invalid-wait-illegal-handle)
[687.898587] Starting subtest: invalid-wait-illegal-handle
[687.900881] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[688.034929] [115/134] (353s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[688.150162] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[695.210166] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.062s)
[695.361647] [116/134] (345s left) api_intel_allocator (reopen)
[695.429901] Starting subtest: reopen
[695.434774] Subtest reopen: SUCCESS (0.004s)
[695.592811] [117/134] (345s left) kms_prime (d3hot)
[695.677183] Subtest D3hot: SKIP (0.000s)
[695.774815] [118/134] (345s left) gem_eio (in-flight-1us)
[696.008146] Starting subtest: in-flight-1us
[704.455697] Subtest in-flight-1us: SUCCESS (8.444s)
[704.650687] [119/134] (336s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[704.746491] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[709.047420] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.304s)
[710.266879] [120/134] (331s left) gem_render_copy (x-tiled)
[710.336928] Starting subtest: x-tiled
[710.339577] Starting dynamic subtest: smem
[710.387142] Dynamic subtest smem: SUCCESS (0.050s)
[710.389598] Subtest x-tiled: SUCCESS (0.050s)
[710.655468] [121/134] (330s left) i915_pciid
[710.862356] [122/134] (330s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[710.930848] Starting subtest: single-wait-for-submit-available-signaled
[710.933085] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[711.059860] [123/134] (330s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[711.157917] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[711.161880] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[711.256283] [124/134] (330s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[711.357381] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[711.361322] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[711.485914] [125/134] (330s left) gem_exec_reloc (basic-write-gtt-noreloc)
[711.557891] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[711.644550] [126/134] (330s left) gem_exec_create (basic)
[711.707781] Starting subtest: basic
[711.710043] Starting dynamic subtest: smem
[713.800786] Dynamic subtest smem: SUCCESS (2.092s)
[713.803478] Subtest basic: SUCCESS (2.094s)
[714.002212] [127/134] (327s left) gem_exec_params (no-bsd)
[714.067256] Starting subtest: no-bsd
[714.071935] Subtest no-bsd: SUCCESS (0.003s)
[715.594137] [128/134] (326s left) gem_exec_params (batch-first)
[715.669692] Starting subtest: batch-first
[715.680089] Subtest batch-first: SUCCESS (0.013s)
[715.833533] [129/134] (325s left) kms_plane_scaling (2x-scaler-multi-pipe)
[715.939428] Starting subtest: 2x-scaler-multi-pipe
[715.943724] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[716.078613] [130/134] (325s left) kms_psr (psr-cursor-mmap-gtt)
[716.176904] Starting subtest: psr-cursor-mmap-gtt
[716.178997] Starting dynamic subtest: eDP-1
[717.931871] Dynamic subtest eDP-1: SUCCESS (1.753s)
[717.933801] Subtest psr-cursor-mmap-gtt: SUCCESS (1.754s)
[718.830697] [131/134] (323s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[718.933027] Starting subtest: fbc-rgb565-draw-mmap-gtt
[718.937207] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[719.050037] [132/134] (322s left) kms_psr (pr-primary-mmap-gtt)
[719.150903] Starting subtest: pr-primary-mmap-gtt
[719.154928] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[719.249179] [133/134] (322s left) gem_exec_schedule (preempt-queue-contexts-chain)
[719.328850] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[719.625933] [134/134] (322s left) gem_exec_balancer (full-late)
[719.692544] Starting subtest: full-late
[724.351597] Subtest full-late: SUCCESS (4.660s)
[724.694196] 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.