[58.359642] Initializing watchdogs
[58.359694]   /dev/watchdog0
[58.374364] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.378735] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.381152] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.384941] [001/156] (960s left) prime_vgem (basic-read)
[58.516299] Starting subtest: basic-read
[58.524886] Subtest basic-read: SKIP (0.006s)
[58.628369] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[58.631642] [002/156] (960s left) gem_ctx_isolation (clean)
[58.691895] Starting subtest: clean
[58.694222] Starting dynamic subtest: rcs0
[58.745721] Dynamic subtest rcs0: SUCCESS (0.056s)
[58.755474] Starting dynamic subtest: bcs0
[58.816278] Dynamic subtest bcs0: SUCCESS (0.071s)
[58.825615] Starting dynamic subtest: vcs0
[58.875773] Dynamic subtest vcs0: SUCCESS (0.058s)
[58.883733] Starting dynamic subtest: vcs1
[60.332808] Dynamic subtest vcs1: SUCCESS (1.460s)
[60.342579] Starting dynamic subtest: vecs0
[62.317737] Dynamic subtest vecs0: SUCCESS (1.988s)
[62.325978] Starting dynamic subtest: ccs0
[64.336064] Dynamic subtest ccs0: SUCCESS (2.022s)
[64.338499] Subtest clean: SUCCESS (5.657s)
[64.566560] [003/156] (954s left) sw_sync (sync_merge_same)
[64.599720] Starting subtest: sync_merge_same
[64.602364] Subtest sync_merge_same: SUCCESS (0.000s)
[64.651583] [004/156] (954s left) syncobj_timeline (wait-for-submit-delayed-submit)
[64.702855] Starting subtest: wait-for-submit-delayed-submit
[64.807603] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[64.890512] [005/156] (954s left) gem_workarounds (reset-fd)
[64.964793] Starting subtest: reset-fd
[65.091121] Subtest reset-fd: SUCCESS (0.127s)
[65.219826] [006/156] (953s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[65.321144] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[65.325299] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[65.426182] [007/156] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[65.534520] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[65.538640] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[65.624433] [008/156] (953s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[65.680251] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[65.781445] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[65.857807] [009/156] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[65.947270] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[73.664860] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.732s)
[73.791256] [010/156] (945s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[73.849811] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[73.914787] [011/156] (945s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[74.007202] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[74.009468] Starting dynamic subtest: pipe-A-eDP-1
[74.747572] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[74.758088] Starting dynamic subtest: pipe-B-eDP-1
[76.531275] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.784s)
[76.539333] Starting dynamic subtest: pipe-C-eDP-1
[78.356214] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.824s)
[78.364778] Starting dynamic subtest: pipe-D-eDP-1
[80.200701] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.844s)
[80.202822] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.191s)
[81.344897] [012/156] (937s left) perf_pmu (rc6)
[81.383111] Starting subtest: rc6
[81.385327] Starting dynamic subtest: gt0
[87.746567] Dynamic subtest gt0: SUCCESS (6.366s)
[87.758599] Starting dynamic subtest: runtime-pm-gt0
[95.541969] Dynamic subtest runtime-pm-gt0: SUCCESS (7.797s)
[95.551532] Starting dynamic subtest: runtime-pm-long-gt0
[108.010953] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.470s)
[108.023027] Starting dynamic subtest: other-idle-gt0
[114.353534] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[114.362301] Starting dynamic subtest: gt1
[120.693823] Dynamic subtest gt1: SUCCESS (6.339s)
[120.704030] Starting dynamic subtest: runtime-pm-gt1
[128.204315] Dynamic subtest runtime-pm-gt1: SUCCESS (7.509s)
[128.215634] Starting dynamic subtest: runtime-pm-long-gt1
[140.710904] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.504s)
[140.722805] Starting dynamic subtest: other-idle-gt1
[147.055042] Dynamic subtest other-idle-gt1: SUCCESS (6.343s)
[147.057993] Subtest rc6: SUCCESS (65.678s)
[148.241224] [013/156] (871s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[148.347516] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[148.351457] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[148.417730] [014/156] (870s left) syncobj_timeline (multi-wait-all-available-signaled)
[148.457905] Starting subtest: multi-wait-all-available-signaled
[148.459952] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[148.532821] [015/156] (870s left) kms_pm_rpm (dpms-non-lpsp)
[150.378878] Starting subtest: dpms-non-lpsp
[150.384143] Subtest dpms-non-lpsp: SKIP (0.001s)
[150.770240] [016/156] (868s left) kms_flip (flip-vs-panning)
[150.871051] Starting subtest: flip-vs-panning
[150.873474] Starting dynamic subtest: A-eDP1
[159.589323] Dynamic subtest A-eDP1: SUCCESS (8.717s)
[159.599075] Starting dynamic subtest: B-eDP1
[168.318438] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[168.329125] Starting dynamic subtest: C-eDP1
[177.034167] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[177.044758] Starting dynamic subtest: D-eDP1
[185.760214] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[185.762291] Subtest flip-vs-panning: SUCCESS (34.892s)
[186.904261] [017/156] (832s left) fbdev (eof)
[186.957268] Starting subtest: eof
[186.959591] Subtest eof: SUCCESS (0.000s)
[186.997707] [018/156] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[187.097558] Starting subtest: compare-crc-sanitycheck-xr24
[187.099886] Starting dynamic subtest: pipe-A-eDP-1
[187.770873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s)
[187.782223] Starting dynamic subtest: pipe-B-eDP-1
[189.102631] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.329s)
[189.112389] Starting dynamic subtest: pipe-C-eDP-1
[190.382908] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s)
[190.393057] Starting dynamic subtest: pipe-D-eDP-1
[191.605495] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[191.608102] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.509s)
[192.440704] [019/156] (827s left) api_intel_bb (blit-noreloc-keep-cache)
[192.497853] Starting subtest: blit-noreloc-keep-cache
[192.505494] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[192.617163] [020/156] (827s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[192.710900] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[192.715383] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[192.768056] [021/156] (826s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[192.864543] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[192.868599] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[192.953455] [022/156] (826s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[193.061865] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[193.066091] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[193.132955] [023/156] (826s left) gem_softpin (evict-active-interruptible)
[193.187271] Starting subtest: evict-active-interruptible
[193.194265] Subtest evict-active-interruptible: SUCCESS (0.007s)
[193.290921] [024/156] (826s left) gem_mmap_gtt (medium-copy-odd)
[193.344334] Subtest medium-copy-odd: SKIP (0.000s)
[193.401646] [025/156] (826s left) vgem_basic (bad-fence)
[193.447979] Starting subtest: bad-fence
[193.450233] Subtest bad-fence: SUCCESS (0.000s)
[193.490487] [026/156] (826s left) syncobj_wait (wait-any-interrupted)
[193.555374] Starting subtest: wait-any-interrupted
[193.662697] Subtest wait-any-interrupted: SUCCESS (0.105s)
[193.714339] [027/156] (826s left) kms_psr (psr-sprite-plane-move)
[193.817977] Starting subtest: psr-sprite-plane-move
[193.820371] Starting dynamic subtest: eDP-1
[195.581687] Dynamic subtest eDP-1: SUCCESS (1.763s)
[195.584103] Subtest psr-sprite-plane-move: SUCCESS (1.764s)
[196.405095] [028/156] (823s left) kms_rotation_crc (primary-rotation-180)
[196.509215] Starting subtest: primary-rotation-180
[203.518632] Subtest primary-rotation-180: SUCCESS (7.012s)
[204.669683] [029/156] (815s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[204.792851] Starting subtest: short-flip-before-cursor-atomic-transitions
[205.753678] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.957s)
[206.593252] [030/156] (813s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[206.695307] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[206.699578] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[206.775116] [031/156] (813s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[206.835059] Starting subtest: invalid-smem-bo-on-discrete
[206.839372] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[206.973808] [032/156] (813s left) kms_flip (basic-flip-vs-modeset)
[207.066178] Starting subtest: basic-flip-vs-modeset
[207.068622] Starting dynamic subtest: A-eDP1
[209.608875] Dynamic subtest A-eDP1: SUCCESS (2.539s)
[209.618518] Starting dynamic subtest: B-eDP1
[211.793098] Dynamic subtest B-eDP1: SUCCESS (2.184s)
[211.803075] Starting dynamic subtest: C-eDP1
[213.959028] Dynamic subtest C-eDP1: SUCCESS (2.165s)
[213.969751] Starting dynamic subtest: D-eDP1
[216.123691] Dynamic subtest D-eDP1: SUCCESS (2.162s)
[216.125650] Subtest basic-flip-vs-modeset: SUCCESS (9.058s)
[216.999751] [033/156] (803s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[217.100693] Starting subtest: fbc-rgb101010-draw-render
[219.623047] Subtest fbc-rgb101010-draw-render: SUCCESS (2.526s)
[220.805945] [034/156] (799s left) syncobj_wait (wait-any-complex)
[220.852876] Starting subtest: wait-any-complex
[220.913467] Subtest wait-any-complex: SUCCESS (0.062s)
[220.968381] [035/156] (799s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[221.020635] Starting subtest: multi-wait-for-submit-submitted-signaled
[221.022844] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[221.090465] [036/156] (799s left) gem_exec_fence (syncobj-timeline-export)
[221.644129] Starting subtest: syncobj-timeline-export
[221.651554] Subtest syncobj-timeline-export: SUCCESS (0.009s)
[223.382195] [037/156] (796s left) prime_vgem (shrink)
[223.451870] Starting subtest: shrink
[223.464615] Subtest shrink: SUCCESS (0.012s)
[223.532640] [038/156] (796s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[223.650814] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[223.655134] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[223.728937] [039/156] (796s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite)
[223.827996] Starting subtest: fbchdr-rgb101010-draw-pwrite
[223.832486] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s)
[223.894406] [040/156] (796s left) syncobj_timeline (signal-point-0)
[223.955251] Starting subtest: signal-point-0
[223.957568] Subtest signal-point-0: SUCCESS (0.000s)
[224.040112] [041/156] (796s left) gem_exec_reloc (basic-write-wc-active)
[224.094050] Subtest basic-write-wc-active: SKIP (0.000s)
[224.173034] [042/156] (796s left) i915_pm_rpm (system-suspend-devices)
[226.504954] Starting subtest: system-suspend-devices
[234.296649] Subtest system-suspend-devices: SUCCESS (7.797s)
[234.661749] [043/156] (785s left) perf_pmu (most-busy-check-all)
[234.717686] Starting subtest: most-busy-check-all
[234.719684] Starting dynamic subtest: rcs0
[236.300377] Dynamic subtest rcs0: SUCCESS (1.581s)
[236.311767] Starting dynamic subtest: bcs0
[238.282619] Dynamic subtest bcs0: SUCCESS (1.979s)
[238.295381] Starting dynamic subtest: vcs0
[240.329625] Dynamic subtest vcs0: SUCCESS (2.043s)
[240.341550] Starting dynamic subtest: vcs1
[242.314389] Dynamic subtest vcs1: SUCCESS (1.982s)
[242.327634] Starting dynamic subtest: vecs0
[244.298627] Dynamic subtest vecs0: SUCCESS (1.982s)
[244.311800] Starting dynamic subtest: ccs0
[246.282743] Dynamic subtest ccs0: SUCCESS (1.981s)
[246.286122] Subtest most-busy-check-all: SUCCESS (11.563s)
[246.364061] [044/156] (774s left) kms_color (ctm-signed)
[246.470860] Starting subtest: ctm-signed
[246.473082] Starting dynamic subtest: pipe-A-eDP-1
[248.547074] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.078s)
[248.557174] Starting dynamic subtest: pipe-B-eDP-1
[251.421791] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.873s)
[251.432653] Starting dynamic subtest: pipe-C-eDP-1
[254.131643] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.708s)
[254.141912] Starting dynamic subtest: pipe-D-eDP-1
[256.809921] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.677s)
[256.812328] Subtest ctm-signed: SUCCESS (10.340s)
[257.609208] [045/156] (763s left) i915_drm_fdinfo (memory-info-active)
[257.654780] Starting subtest: memory-info-active
[257.657203] Starting dynamic subtest: smem0
[260.373901] Dynamic subtest smem0: SUCCESS (2.718s)
[260.376566] Subtest memory-info-active: SUCCESS (2.720s)
[260.430902] [046/156] (760s left) kms_flip (2x-flip-vs-wf_vblank)
[260.533200] Starting subtest: 2x-flip-vs-wf_vblank
[260.542999] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[260.599721] [047/156] (760s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[260.682935] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[260.684950] Starting dynamic subtest: pipe-A-default-mode
[263.483384] Dynamic subtest pipe-A-default-mode: SUCCESS (2.797s)
[263.485951] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.799s)
[264.326975] [048/156] (756s left) kms_frontbuffer_tracking (fbchdr-1p-shrfb-fliptrack-mmap-gtt)
[264.435250] Starting subtest: fbchdr-1p-shrfb-fliptrack-mmap-gtt
[264.439855] Subtest fbchdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[264.525730] [049/156] (756s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[264.615926] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[264.618268] Starting dynamic subtest: pipe-A-eDP-1
[264.642419] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[264.654032] Starting dynamic subtest: pipe-B-eDP-1
[264.676543] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[264.685712] Starting dynamic subtest: pipe-C-eDP-1
[264.708206] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[264.717506] Starting dynamic subtest: pipe-D-eDP-1
[264.741368] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[264.745763] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[266.899432] [050/156] (754s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[266.999201] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[267.003257] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[267.068468] [051/156] (753s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[267.164384] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[267.168438] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[267.209979] [052/156] (753s left) kms_cursor_edge_walk (256x256-left-edge)
[267.313214] Starting subtest: 256x256-left-edge
[267.315453] Starting dynamic subtest: pipe-A-eDP-1
[270.750248] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[270.760871] Starting dynamic subtest: pipe-D-eDP-1
[273.969768] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.219s)
[273.972070] Subtest 256x256-left-edge: SUCCESS (6.659s)
[274.770324] [053/156] (746s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-render)
[274.873129] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-render
[274.877648] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[274.941614] [054/156] (746s left) gem_fenced_exec_thrash (2-spare-fences)
[275.009416] Subtest 2-spare-fences: SKIP (0.000s)
[275.091591] [055/156] (746s left) gem_render_copy (yf-tiled-to-vebox-linear)
[275.150029] Starting subtest: yf-tiled-to-vebox-linear
[275.154573] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[275.309880] [056/156] (745s left) gem_pxp (create-regular-buffer)
[275.433369] Starting subtest: create-regular-buffer
[275.435675] Subtest create-regular-buffer: SUCCESS (0.000s)
[275.517776] [057/156] (745s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[275.624076] Starting subtest: x-tiled-32bpp-rotate-180
[277.116014] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.492s)
[277.227419] [058/156] (744s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[277.343034] Starting subtest: cursorA-vs-flipB-atomic
[277.346814] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[277.465883] [059/156] (743s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[277.561308] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[277.565152] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[277.616014] [060/156] (743s left) gen3_render_mixed_blits
[277.731721] [061/156] (743s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[277.840715] Starting subtest: y-tiled-64bpp-rotate-180
[277.844634] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[277.914190] [062/156] (743s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[277.967134] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[278.036015] [063/156] (743s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[278.133947] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[278.135939] Starting dynamic subtest: pipe-A-eDP-1
[284.060850] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.928s)
[284.071475] Starting dynamic subtest: pipe-B-eDP-1
[290.724822] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.660s)
[290.727126] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.591s)
[291.579388] [064/156] (729s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[291.683889] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[291.688130] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[291.774705] [065/156] (729s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[291.874264] Starting subtest: fbcpsrhdr-slowdraw
[291.878435] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[291.935517] [066/156] (729s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[291.990318] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[292.047876] [067/156] (729s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[292.139448] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[292.141636] Starting dynamic subtest: pipe-A
[293.209452] Dynamic subtest pipe-A: SUCCESS (1.072s)
[293.219845] Starting dynamic subtest: pipe-B
[295.308557] Dynamic subtest pipe-B: SUCCESS (2.098s)
[295.318515] Starting dynamic subtest: pipe-C
[296.510742] Dynamic subtest pipe-C: SUCCESS (1.201s)
[296.523439] Starting dynamic subtest: pipe-D
[297.744793] Dynamic subtest pipe-D: SUCCESS (1.233s)
[297.747158] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.607s)
[298.921086] [068/156] (722s left) kms_plane_lowres (tiling-y)
[299.011654] Starting subtest: tiling-y
[299.016056] Subtest tiling-y: SKIP (0.000s)
[299.061818] [069/156] (722s left) kms_sequence (get-forked-busy)
[299.162254] Starting subtest: get-forked-busy
[299.164573] Starting dynamic subtest: pipe-A-eDP-1
[301.113174] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s)
[301.124091] Starting dynamic subtest: pipe-B-eDP-1
[303.749110] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.634s)
[303.760131] Starting dynamic subtest: pipe-C-eDP-1
[306.350315] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.600s)
[306.361705] Starting dynamic subtest: pipe-D-eDP-1
[308.966073] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.614s)
[308.968492] Subtest get-forked-busy: SUCCESS (9.805s)
[309.855206] [070/156] (711s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[309.953107] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[309.957337] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[310.004646] [071/156] (711s left) kms_psr (psr2-dpms)
[310.099254] Starting subtest: psr2-dpms
[310.101538] Starting dynamic subtest: eDP-1
[313.084165] Dynamic subtest eDP-1: SUCCESS (2.984s)
[313.086494] Subtest psr2-dpms: SUCCESS (2.986s)
[313.941187] [072/156] (707s left) kms_chamelium_frames (dp-crc-fast)
[314.334574] Subtest dp-crc-fast: SKIP (0.000s)
[315.172431] [073/156] (706s left) kms_psr (psr-primary-blt)
[315.265080] Starting subtest: psr-primary-blt
[315.267407] Starting dynamic subtest: eDP-1
[316.990477] Dynamic subtest eDP-1: SUCCESS (1.725s)
[316.992811] Subtest psr-primary-blt: SUCCESS (1.726s)
[317.839633] [074/156] (704s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[317.937853] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[317.942261] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[318.030322] [075/156] (703s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[318.138958] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[318.143253] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[318.215967] [076/156] (703s left) gem_exec_whisper (basic-fds-priority)
[318.272479] Starting subtest: basic-fds-priority
[342.044637] Subtest basic-fds-priority: SUCCESS (23.765s)
[342.206060] [077/156] (679s left) kms_hdr (static-toggle-dpms)
[342.311220] Starting subtest: static-toggle-dpms
[342.313537] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[342.317988] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[342.329251] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[342.333292] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[342.337305] Subtest static-toggle-dpms: SKIP (0.003s)
[342.376414] [078/156] (679s left) prime_mmap (test_correct_cpu_write)
[342.432099] Starting subtest: test_correct_cpu_write
[342.434514] Starting dynamic subtest: test_correct_cpu_write-smem
[342.436779] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[342.439121] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[342.521864] [079/156] (679s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[342.624482] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[342.628689] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[342.699500] [080/156] (679s left) gem_ctx_shared (disjoint-timelines)
[342.765613] Starting subtest: disjoint-timelines
[342.805645] Subtest disjoint-timelines: SUCCESS (0.040s)
[343.010925] [081/156] (679s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[343.106056] Starting subtest: hdr-rgb565-draw-mmap-wc
[343.110484] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[343.207259] [082/156] (679s left) gem_exec_schedule (submit-late-slice)
[343.287634] Starting subtest: submit-late-slice
[343.289954] Starting dynamic subtest: rcs0
[343.321368] Dynamic subtest rcs0: SUCCESS (0.042s)
[343.331660] Starting dynamic subtest: bcs0
[343.350667] Dynamic subtest bcs0: SUCCESS (0.029s)
[343.362128] Starting dynamic subtest: vcs0
[343.383226] Dynamic subtest vcs0: SUCCESS (0.032s)
[343.398797] Starting dynamic subtest: vcs1
[343.417259] Dynamic subtest vcs1: SUCCESS (0.033s)
[343.428856] Starting dynamic subtest: vecs0
[343.446886] Dynamic subtest vecs0: SUCCESS (0.029s)
[343.457195] Starting dynamic subtest: ccs0
[343.480750] Dynamic subtest ccs0: SUCCESS (0.032s)
[343.483093] Subtest submit-late-slice: SUCCESS (0.203s)
[345.363039] [083/156] (676s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[345.490700] Starting subtest: flip-vs-cursor-varying-size
[354.585814] Subtest flip-vs-cursor-varying-size: SUCCESS (9.092s)
[355.459162] [084/156] (666s left) kms_big_fb (linear-32bpp-rotate-270)
[355.560917] Starting subtest: linear-32bpp-rotate-270
[355.581081] Subtest linear-32bpp-rotate-270: SKIP (0.020s)
[355.667214] [085/156] (666s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[355.777665] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[360.780389] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.007s)
[361.966875] [086/156] (660s left) api_intel_bb (destroy-bb)
[362.018241] Starting subtest: destroy-bb
[362.026533] Subtest destroy-bb: SUCCESS (0.008s)
[362.143371] [087/156] (660s left) i915_query (query-topology-garbage-items)
[362.196842] Starting subtest: query-topology-garbage-items
[362.199133] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[362.278243] [088/156] (660s left) gem_exec_reloc (basic-write-gtt)
[362.340654] Subtest basic-write-gtt: SKIP (0.000s)
[362.416532] [089/156] (660s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[362.796618] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[363.593467] [090/156] (659s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[363.649206] Subtest no-spare-fences-busy: SKIP (0.000s)
[363.721452] [091/156] (658s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[363.817219] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[363.821614] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[363.906130] [092/156] (658s left) gem_sync (basic-store-each)
[363.979256] Starting subtest: basic-store-each
[366.353140] Subtest basic-store-each: SUCCESS (2.384s)
[366.518469] [093/156] (656s left) gem_exec_whisper (basic-sync-all)
[366.585048] Starting subtest: basic-sync-all
[373.928128] Subtest basic-sync-all: SUCCESS (7.340s)
[374.091349] [094/156] (648s left) gem_userptr_blits (nohangcheck)
[374.156842] Starting subtest: nohangcheck
[374.490982] Subtest nohangcheck: SUCCESS (0.331s)
[374.584399] [095/156] (648s left) kms_cursor_crc (cursor-offscreen-64x64)
[374.762089] Starting subtest: cursor-offscreen-64x64
[374.767117] Starting dynamic subtest: pipe-A-eDP-1
[376.697383] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[376.726055] Starting dynamic subtest: pipe-D-eDP-1
[379.328262] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s)
[379.330648] Subtest cursor-offscreen-64x64: SUCCESS (4.566s)
[380.139375] [096/156] (642s left) kms_prop_blob (blob-multiple)
[380.200719] Starting subtest: blob-multiple
[380.203105] Subtest blob-multiple: SUCCESS (0.002s)
[380.275348] [097/156] (642s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[380.377443] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[381.179714] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s)
[381.322477] [098/156] (641s left) gem_exec_params (invalid-fence-in-submit)
[381.379388] Starting subtest: invalid-fence-in-submit
[381.384596] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[381.464577] [099/156] (641s left) gem_mmap_gtt (pf-nonblock)
[381.513158] Subtest pf-nonblock: SKIP (0.000s)
[381.613767] [100/156] (641s left) syncobj_wait (multi-wait-all-submitted)
[381.659067] Starting subtest: multi-wait-all-submitted
[381.766082] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[381.823395] [101/156] (641s left) gem_create (busy-create)
[381.878909] Starting subtest: busy-create
[381.881353] Starting dynamic subtest: smem0
[415.308538] Dynamic subtest smem0: SUCCESS (33.426s)
[415.311097] Subtest busy-create: SUCCESS (33.428s)
[415.472196] [102/156] (607s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[415.582337] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[415.584488] Starting dynamic subtest: pipe-A-eDP-1
[426.289347] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.711s)
[426.300138] Starting dynamic subtest: pipe-B-eDP-1
[437.669895] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.378s)
[437.672166] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.092s)
[438.513557] [103/156] (584s left) kms_feature_discovery (display-2x)
[438.611205] Starting subtest: display-2x
[438.615625] Subtest display-2x: SKIP (0.000s)
[438.665572] [104/156] (584s left) gem_exec_balancer (busy)
[438.725209] Starting subtest: busy
[440.330291] Subtest busy: SUCCESS (1.603s)
[440.648668] [105/156] (582s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[440.695661] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[440.798794] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s)
[440.852803] [106/156] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[440.958133] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[440.962412] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[441.051320] [107/156] (582s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[441.154627] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[441.158986] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[441.243233] [108/156] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[441.343200] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[441.347875] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[441.423510] [109/156] (582s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[441.520699] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[441.524921] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[441.591952] [110/156] (581s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[441.715716] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[441.719156] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[441.796995] [111/156] (581s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[441.893480] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[441.895400] Starting dynamic subtest: pipe-A-eDP-1
[441.914543] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[441.925628] Starting dynamic subtest: pipe-B-eDP-1
[441.943799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[441.956416] Starting dynamic subtest: pipe-C-eDP-1
[441.974831] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[441.984504] Starting dynamic subtest: pipe-D-eDP-1
[442.002827] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[442.006274] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[444.162226] [112/156] (579s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[444.211498] Starting subtest: legacy-engines-hostile-preempt
[444.213942] Starting dynamic subtest: render
[444.290028] Dynamic subtest render: SUCCESS (0.077s)
[444.304710] Starting dynamic subtest: bsd1
[446.256936] Dynamic subtest bsd1: SUCCESS (1.964s)
[446.270090] Starting dynamic subtest: bsd2
[448.304859] Dynamic subtest bsd2: SUCCESS (2.044s)
[448.318203] Starting dynamic subtest: blt
[448.387976] Dynamic subtest blt: SUCCESS (0.081s)
[448.400552] Starting dynamic subtest: vebox
[450.287881] Dynamic subtest vebox: SUCCESS (1.895s)
[450.290715] Subtest legacy-engines-hostile-preempt: SUCCESS (6.076s)
[450.391810] [113/156] (573s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[450.510745] Starting subtest: fbc-modesetfrombusy
[454.251699] Subtest fbc-modesetfrombusy: SUCCESS (3.748s)
[455.408926] [114/156] (568s left) kms_atomic (plane-primary-legacy)
[455.519830] Starting subtest: plane-primary-legacy
[455.522078] Starting dynamic subtest: pipe-A-eDP-1
[455.951712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.432s)
[455.954021] Subtest plane-primary-legacy: SUCCESS (0.433s)
[456.832280] [115/156] (566s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[456.930755] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[456.934759] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[457.017348] [116/156] (566s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[457.105954] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[457.108128] Starting dynamic subtest: pipe-A-eDP-1
[489.359160] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.886s)
[489.370564] Starting dynamic subtest: pipe-B-eDP-1
[522.291122] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.677s)
[522.302365] Starting dynamic subtest: pipe-C-eDP-1
[555.277336] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.742s)
[555.288227] Starting dynamic subtest: pipe-D-eDP-1
[588.276442] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.641s)
[588.278837] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.950s)
[589.486707] [117/156] (434s left) gem_softpin (evict-prime)
[589.551147] Starting subtest: evict-prime
[589.553507] Starting dynamic subtest: rcs0
[590.694608] Dynamic subtest rcs0: SUCCESS (1.148s)
[590.707889] Starting dynamic subtest: bcs0
[591.811499] Dynamic subtest bcs0: SUCCESS (1.118s)
[591.823871] Starting dynamic subtest: vcs0
[593.571752] Dynamic subtest vcs0: SUCCESS (1.762s)
[593.591133] Starting dynamic subtest: vcs1
[595.556233] Dynamic subtest vcs1: SUCCESS (1.987s)
[595.569702] Starting dynamic subtest: vecs0
[597.539324] Dynamic subtest vecs0: SUCCESS (1.984s)
[597.554524] Starting dynamic subtest: ccs0
[598.671447] Dynamic subtest ccs0: SUCCESS (1.133s)
[598.684834] Starting dynamic subtest: all
[600.541508] Dynamic subtest all: SUCCESS (1.869s)
[600.543835] Subtest evict-prime: SUCCESS (11.015s)
[600.598903] [118/156] (423s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[600.665451] Starting subtest: map-fixed-invalidate-overlap
[600.669468] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[600.771962] [119/156] (423s left) gem_exec_capture (capture-recoverable)
[600.841515] Starting subtest: capture-recoverable
[600.846571] Subtest capture-recoverable: SUCCESS (0.005s)
[600.953394] [120/156] (423s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt)
[601.061954] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt
[601.066432] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[601.130242] [121/156] (422s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[601.231695] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[608.071144] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.851s)
[608.152108] [122/156] (415s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[608.252348] Starting subtest: fbc-psr2-cursor-plane-onoff
[608.254604] Starting dynamic subtest: eDP-1
[608.258831] Dynamic subtest eDP-1: SKIP (0.000s)
[608.262920] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[608.302702] [123/156] (415s left) kms_psr (pr-cursor-mmap-cpu)
[608.391430] Starting subtest: pr-cursor-mmap-cpu
[608.395927] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[608.442446] [124/156] (415s left) gem_exec_await (wide-all)
[608.701010] Starting subtest: wide-all
[633.542513] Subtest wide-all: SUCCESS (24.842s)
[633.722032] [125/156] (390s left) kms_content_protection (dp-mst-type-1)
[633.920141] Starting subtest: dp-mst-type-1
[633.924638] Subtest dp-mst-type-1: SKIP (0.000s)
[634.011047] [126/156] (390s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite)
[634.123636] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite
[634.127758] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[634.193083] [127/156] (390s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[634.291110] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[634.295651] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[634.373667] [128/156] (389s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[634.426052] Starting subtest: multi-wait-all-for-submit-submitted
[634.530765] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[634.584944] [129/156] (389s left) gem_exec_schedule (preempt-other-chain)
[634.660042] Starting subtest: preempt-other-chain
[634.662487] Starting dynamic subtest: rcs0
[634.741716] Dynamic subtest rcs0: SUCCESS (0.085s)
[634.758793] Starting dynamic subtest: bcs0
[634.823838] Dynamic subtest bcs0: SUCCESS (0.080s)
[634.835704] Starting dynamic subtest: vcs0
[634.905471] Dynamic subtest vcs0: SUCCESS (0.081s)
[634.921989] Starting dynamic subtest: vcs1
[634.983939] Dynamic subtest vcs1: SUCCESS (0.078s)
[635.000081] Starting dynamic subtest: vecs0
[635.061612] Dynamic subtest vecs0: SUCCESS (0.077s)
[635.076826] Starting dynamic subtest: ccs0
[635.145053] Dynamic subtest ccs0: SUCCESS (0.083s)
[635.147609] Subtest preempt-other-chain: SUCCESS (0.489s)
[636.655848] [130/156] (387s left) perf_pmu (busy-accuracy-2)
[636.699402] Starting subtest: busy-accuracy-2
[636.701316] Starting dynamic subtest: rcs0
[639.748688] Dynamic subtest rcs0: SUCCESS (3.048s)
[639.763691] Starting dynamic subtest: bcs0
[642.806974] Dynamic subtest bcs0: SUCCESS (3.058s)
[642.818950] Starting dynamic subtest: vcs0
[645.855058] Dynamic subtest vcs0: SUCCESS (3.046s)
[645.867080] Starting dynamic subtest: vcs1
[648.904245] Dynamic subtest vcs1: SUCCESS (3.047s)
[648.924360] Starting dynamic subtest: vecs0
[651.952459] Dynamic subtest vecs0: SUCCESS (3.047s)
[651.964885] Starting dynamic subtest: ccs0
[655.009514] Dynamic subtest ccs0: SUCCESS (3.057s)
[655.011939] Subtest busy-accuracy-2: SUCCESS (18.315s)
[655.108739] [131/156] (369s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[655.215890] Starting subtest: 4-tiled-8bpp-rotate-270
[655.236854] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[655.321400] [132/156] (369s left) i915_pciid
[655.470084] [133/156] (369s left) gem_eio (in-flight-1us)
[655.693932] Starting subtest: in-flight-1us
[664.498346] Subtest in-flight-1us: SUCCESS (8.805s)
[664.599175] [134/156] (359s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[664.697085] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[669.270676] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.580s)
[670.458776] [135/156] (354s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[670.549645] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[670.551911] Starting dynamic subtest: pipe-A-eDP-1
[670.574466] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[670.588023] Starting dynamic subtest: pipe-B-eDP-1
[670.609159] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[670.620279] Starting dynamic subtest: pipe-C-eDP-1
[670.640892] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[670.651624] Starting dynamic subtest: pipe-D-eDP-1
[670.672500] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[670.677061] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[672.809916] [136/156] (351s left) kms_cursor_crc (cursor-sliding-256x256)
[673.074325] Starting subtest: cursor-sliding-256x256
[673.079442] Starting dynamic subtest: pipe-A-eDP-1
[676.354283] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.278s)
[676.388544] Starting dynamic subtest: pipe-D-eDP-1
[680.226781] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.848s)
[680.228895] Subtest cursor-sliding-256x256: SUCCESS (7.152s)
[681.070583] [137/156] (343s left) gem_linear_blits (interruptible)
[681.210965] Starting subtest: interruptible
[685.315048] Subtest interruptible: SUCCESS (4.106s)
[685.462597] [138/156] (339s left) gen9_exec_parse (batch-invalid-length)
[685.561769] Subtest batch-invalid-length: SKIP (0.000s)
[685.632901] [139/156] (339s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[685.740647] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[685.744918] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[685.791901] [140/156] (339s left) drm_buddy (drm_buddy)
[685.835409] Starting subtest: drm_buddy
[685.839971] Subtest drm_buddy: SKIP (0.001s)
[685.883682] [141/156] (338s left) kms_invalid_mode (bad-vsync-end)
[685.970979] Starting subtest: bad-vsync-end
[685.973332] Starting dynamic subtest: pipe-A-eDP-1
[686.264108] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[686.276237] Starting dynamic subtest: pipe-B-eDP-1
[686.278189] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[686.289978] Starting dynamic subtest: pipe-C-eDP-1
[686.292296] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[686.303479] Starting dynamic subtest: pipe-D-eDP-1
[686.305834] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[686.308208] Subtest bad-vsync-end: SUCCESS (0.302s)
[687.104279] [142/156] (337s left) kms_plane (plane-position-covered)
[687.196639] Starting subtest: plane-position-covered
[687.721360] Starting dynamic subtest: pipe-A-plane-1
[689.014951] Dynamic subtest pipe-A-plane-1: SUCCESS (1.293s)
[689.027965] Starting dynamic subtest: pipe-A-plane-2
[690.335228] Dynamic subtest pipe-A-plane-2: SUCCESS (1.318s)
[690.347395] Starting dynamic subtest: pipe-A-plane-3
[691.637978] Dynamic subtest pipe-A-plane-3: SUCCESS (1.301s)
[691.650221] Starting dynamic subtest: pipe-A-plane-4
[692.888333] Dynamic subtest pipe-A-plane-4: SUCCESS (1.248s)
[692.900325] Starting dynamic subtest: pipe-A-plane-5
[692.914683] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[694.158455] Starting dynamic subtest: pipe-B-plane-1
[695.475045] Dynamic subtest pipe-B-plane-1: SUCCESS (1.325s)
[695.486904] Starting dynamic subtest: pipe-B-plane-2
[696.785035] Dynamic subtest pipe-B-plane-2: SUCCESS (1.308s)
[696.796791] Starting dynamic subtest: pipe-B-plane-3
[698.022953] Dynamic subtest pipe-B-plane-3: SUCCESS (1.237s)
[698.034535] Starting dynamic subtest: pipe-B-plane-4
[699.251495] Dynamic subtest pipe-B-plane-4: SUCCESS (1.228s)
[699.263590] Starting dynamic subtest: pipe-B-plane-5
[699.275999] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[699.278302] Subtest plane-position-covered: SUCCESS (12.076s)
[700.050316] [143/156] (324s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[700.101440] Starting subtest: single-wait-all-for-submit-unsubmitted
[700.201506] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[700.256518] [144/156] (324s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[700.365118] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[707.182047] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.821s)
[707.309327] [145/156] (317s left) perf (oa-exponents)
[707.426225] Starting subtest: oa-exponents
[707.428614] Starting dynamic subtest: 0-rcs0
[709.215349] Dynamic subtest 0-rcs0: SUCCESS (1.787s)
[709.228029] Starting dynamic subtest: 1-vcs0
[711.043598] Dynamic subtest 1-vcs0: SUCCESS (1.827s)
[711.046188] Subtest oa-exponents: SUCCESS (3.617s)
[711.096830] [146/156] (313s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[711.198354] Starting subtest: fb-8bpc-vs-panel-8bpc
[711.200636] Starting dynamic subtest: pipe-A-eDP-1
[712.571520] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.374s)
[712.573892] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.375s)
[713.437238] [147/156] (311s left) kms_vrr (flip-dpms)
[713.529466] Starting subtest: flip-dpms
[713.535672] Subtest flip-dpms: SKIP (0.000s)
[713.580273] [148/156] (311s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-render)
[713.684605] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-render
[713.688755] Subtest psrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[713.771739] [149/156] (311s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[713.828312] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[713.938348] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[713.994187] [150/156] (311s left) kms_plane_cursor (viewport)
[714.093125] Starting subtest: viewport
[714.097782] Starting dynamic subtest: pipe-A-eDP-1-size-64
[716.730582] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.638s)
[716.792589] Starting dynamic subtest: pipe-A-eDP-1-size-128
[719.353020] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[719.414182] Starting dynamic subtest: pipe-A-eDP-1-size-256
[721.976917] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[722.325584] Starting dynamic subtest: pipe-B-eDP-1-size-64
[725.625580] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.312s)
[725.686941] Starting dynamic subtest: pipe-B-eDP-1-size-128
[728.293463] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.618s)
[728.354840] Starting dynamic subtest: pipe-B-eDP-1-size-256
[730.927574] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.582s)
[731.281196] Starting dynamic subtest: pipe-C-eDP-1-size-64
[734.201042] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.934s)
[734.241696] Starting dynamic subtest: pipe-C-eDP-1-size-128
[736.421637] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[736.465910] Starting dynamic subtest: pipe-C-eDP-1-size-256
[738.665969] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[739.000558] Starting dynamic subtest: pipe-D-eDP-1-size-64
[741.966892] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.984s)
[742.007728] Starting dynamic subtest: pipe-D-eDP-1-size-128
[744.221855] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s)
[744.262720] Starting dynamic subtest: pipe-D-eDP-1-size-256
[746.466728] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[746.789874] Subtest viewport: SUCCESS (32.699s)
[747.663706] [151/156] (277s left) syncobj_basic (bad-destroy)
[747.724554] Starting subtest: bad-destroy
[747.726534] Subtest bad-destroy: SUCCESS (0.000s)
[747.812320] [152/156] (277s left) gem_pxp (regular-baseline-src-copy-readible)
[747.919954] Starting subtest: regular-baseline-src-copy-readible
[747.989708] Subtest regular-baseline-src-copy-readible: SUCCESS (0.071s)
[748.091639] [153/156] (277s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[748.186006] Starting subtest: psr-2p-primscrn-spr-indfb-move
[748.190020] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[748.255414] [154/156] (277s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[748.357096] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[748.361113] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[748.445737] [155/156] (277s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[748.555039] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[748.559495] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[748.616554] [156/156] (276s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[748.726844] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[748.730547] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[748.800849] Closing watchdogs
results: parsing output: 0/ for test: prime_vgem
results: parsing output: 1/ for test: gem_ctx_isolation
results: parsing output: 2/ for test: sw_sync
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_workarounds
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: kms_pipe_crc_basic
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_rotation_crc
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: prime_vgem
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: kms_color
results: parsing output: 44/ for test: i915_drm_fdinfo
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_cursor_edge_walk
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_fenced_exec_thrash
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gen3_render_mixed_blits
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_pipe_b_c_ivb
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_plane_lowres
results: parsing output: 68/ for test: kms_sequence
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_chamelium_frames
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_hdr
results: parsing output: 77/ for test: prime_mmap
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: i915_query
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_chamelium_hpd
results: parsing output: 89/ for test: gem_fenced_exec_thrash
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_sync
results: parsing output: 92/ for test: gem_exec_whisper
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: gem_create
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_atomic
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: gem_exec_capture
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_exec_await
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: i915_pciid
results: parsing output: 132/ for test: gem_eio
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_ccs
results: parsing output: 135/ for test: kms_cursor_crc
results: parsing output: 136/ for test: gem_linear_blits
results: parsing output: 137/ for test: gen9_exec_parse
results: parsing output: 138/ for test: kms_plane
results: parsing output: 139/ for test: drm_buddy
results: parsing output: 140/ for test: kms_invalid_mode
results: parsing output: 141/ for test: kms_plane
results: parsing output: 142/ for test: syncobj_wait
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: perf
results: parsing output: 145/ for test: kms_dither
results: parsing output: 146/ for test: kms_vrr
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: syncobj_wait
results: parsing output: 149/ for test: kms_plane_cursor
results: parsing output: 150/ for test: syncobj_basic
results: parsing output: 151/ for test: gem_pxp
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_big_fb
Done.