[56.874984] Initializing watchdogs
[56.875054]   /dev/watchdog0
[56.891911] [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]
[56.896199] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.898391] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.901700] [001/155] (960s left) kms_addfb_basic (bad-pitch-0)
[56.987703] Starting subtest: bad-pitch-0
[56.989583] Subtest bad-pitch-0: SUCCESS (0.000s)
[57.134865] [002/155] (960s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[57.233581] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[57.235962] Starting dynamic subtest: pipe-A-eDP-1
[57.364461] Dynamic subtest pipe-A-eDP-1: SKIP (0.137s)
[57.372916] Starting dynamic subtest: pipe-B-eDP-1
[58.782367] Dynamic subtest pipe-B-eDP-1: SKIP (1.442s)
[58.787019] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.581s)
[59.969572] [003/155] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[60.067621] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[60.071680] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[60.156944] [004/155] (957s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[60.206812] Starting subtest: multi-wait-for-submit-submitted-signaled
[60.209219] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[60.287902] [005/155] (957s left) kms_vblank (wait-forked-busy-hang)
[60.371087] Starting subtest: wait-forked-busy-hang
[60.373350] Starting dynamic subtest: pipe-A-eDP-1
[87.050931] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.769s)
[87.063846] Starting dynamic subtest: pipe-D-eDP-1
[102.086419] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.029s)
[102.088683] Subtest wait-forked-busy-hang: SUCCESS (41.801s)
[102.948943] [006/155] (914s left) gem_readwrite (read-write)
[103.025944] Subtest read-write: SKIP (0.000s)
[103.089952] [007/155] (914s left) gem_fenced_exec_thrash (no-spare-fences)
[103.163642] Subtest no-spare-fences: SKIP (0.000s)
[103.231649] [008/155] (914s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[103.335604] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[103.339767] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[103.426964] [009/155] (914s left) kms_universal_plane (disable-primary-vs-flip)
[103.522629] Starting subtest: disable-primary-vs-flip
[103.524986] Starting dynamic subtest: pipe-A-eDP-1
[105.104316] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.582s)
[105.112255] Starting dynamic subtest: pipe-B-eDP-1
[107.281134] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.175s)
[107.289865] Starting dynamic subtest: pipe-C-eDP-1
[109.462728] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.180s)
[109.471677] Starting dynamic subtest: pipe-D-eDP-1
[111.642412] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.178s)
[111.644638] Subtest disable-primary-vs-flip: SUCCESS (8.119s)
[112.514894] [010/155] (905s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[112.625621] Starting subtest: fbcpsrhdr-modesetfrombusy
[112.630067] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[112.718073] [011/155] (905s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[112.810939] Starting subtest: yf-tiled-64bpp-rotate-90
[112.815352] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[112.908443] [012/155] (904s left) prime_vgem (sync)
[112.998689] Starting subtest: sync
[113.001040] Starting dynamic subtest: rcs0
[113.033722] Dynamic subtest rcs0: SUCCESS (0.035s)
[113.042299] Starting dynamic subtest: bcs0
[113.081734] Dynamic subtest bcs0: SUCCESS (0.047s)
[113.089752] Starting dynamic subtest: vcs0
[113.129864] Dynamic subtest vcs0: SUCCESS (0.048s)
[113.137875] Starting dynamic subtest: vcs1
[113.176089] Dynamic subtest vcs1: SUCCESS (0.046s)
[113.184312] Starting dynamic subtest: vecs0
[113.220345] Dynamic subtest vecs0: SUCCESS (0.044s)
[113.228518] Starting dynamic subtest: ccs0
[113.265784] Dynamic subtest ccs0: SUCCESS (0.045s)
[113.268126] Subtest sync: SUCCESS (0.268s)
[113.391568] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[113.395075] [013/155] (904s left) kms_flip (2x-flip-vs-panning-vs-hang)
[113.478535] Starting subtest: 2x-flip-vs-panning-vs-hang
[113.482326] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.003s)
[113.587671] [014/155] (904s left) gem_softpin (32b-excludes-last-page)
[113.646218] Starting subtest: 32b-excludes-last-page
[113.650488] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[113.771683] [015/155] (904s left) gem_ctx_engines (execute-one)
[113.827805] Starting subtest: execute-one
[116.233191] Subtest execute-one: SUCCESS (2.405s)
[116.433837] [016/155] (901s left) gem_mmap_gtt (medium-copy)
[116.492149] Subtest medium-copy: SKIP (0.000s)
[116.553145] [017/155] (901s left) perf_pmu (render-node-busy)
[116.622562] Starting subtest: render-node-busy
[116.625031] Starting dynamic subtest: rcs0
[117.225641] Dynamic subtest rcs0: SUCCESS (0.603s)
[117.237273] Starting dynamic subtest: bcs0
[117.792879] Dynamic subtest bcs0: SUCCESS (0.566s)
[117.804345] Starting dynamic subtest: vcs0
[119.300115] Dynamic subtest vcs0: SUCCESS (1.505s)
[119.311547] Starting dynamic subtest: vcs1
[121.283211] Dynamic subtest vcs1: SUCCESS (1.982s)
[121.294530] Starting dynamic subtest: vecs0
[123.331130] Dynamic subtest vecs0: SUCCESS (2.047s)
[123.341848] Starting dynamic subtest: ccs0
[123.891614] Dynamic subtest ccs0: SUCCESS (0.561s)
[123.894273] Subtest render-node-busy: SUCCESS (7.269s)
[123.968538] [018/155] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[124.073418] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[124.077447] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[124.184870] [019/155] (893s left) perf (non-zero-reason)
[124.317910] Starting subtest: non-zero-reason
[124.320295] Starting dynamic subtest: 0-rcs0
[129.610954] Dynamic subtest 0-rcs0: SUCCESS (5.291s)
[129.621594] Starting dynamic subtest: 1-vcs1
[133.479082] Dynamic subtest 1-vcs1: SUCCESS (3.867s)
[133.481938] Subtest non-zero-reason: SUCCESS (9.159s)
[133.529817] [020/155] (884s left) gem_mmap_wc (write-wc-read-gtt)
[133.575660] Subtest write-wc-read-gtt: SKIP (0.000s)
[133.639176] [021/155] (884s left) gem_set_tiling_vs_gtt
[133.747962] [022/155] (884s left) perf (per-context-mode-unprivileged)
[133.841980] Starting subtest: per-context-mode-unprivileged
[133.847566] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[133.885398] [023/155] (884s left) i915_pm_rpm (system-suspend-execbuf)
[135.427226] Starting subtest: system-suspend-execbuf
[196.219730] Subtest system-suspend-execbuf: SUCCESS (45.372s)
[196.611292] [024/155] (821s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[196.710088] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[196.714150] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[196.812396] [025/155] (821s left) prime_mmap_coherency (write)
[196.861713] Starting subtest: write
[202.239223] Subtest write: SUCCESS (5.378s)
[202.401426] [026/155] (815s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[202.503405] Starting subtest: fbcpsr-modesetfrombusy
[208.889667] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.393s)
[209.029136] [027/155] (809s left) gem_exec_schedule (pi-shared-iova)
[209.210709] Starting subtest: pi-shared-iova
[209.212757] Starting dynamic subtest: rcs0
[209.286054] Dynamic subtest rcs0: SUCCESS (0.079s)
[209.297608] Starting dynamic subtest: vcs0
[209.339755] Dynamic subtest vcs0: SUCCESS (0.054s)
[209.351837] Starting dynamic subtest: vcs1
[209.396424] Dynamic subtest vcs1: SUCCESS (0.056s)
[209.412128] Starting dynamic subtest: vecs0
[209.441408] Dynamic subtest vecs0: SUCCESS (0.046s)
[209.454231] Starting dynamic subtest: ccs0
[209.505699] Dynamic subtest ccs0: SUCCESS (0.064s)
[209.508472] Subtest pi-shared-iova: SUCCESS (0.300s)
[211.181261] [028/155] (807s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[211.286170] Starting subtest: hdr-2p-pri-indfb-multidraw
[211.290481] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[211.385323] [029/155] (807s left) kms_psr (fbc-pr-primary-blt)
[211.475459] Starting subtest: fbc-pr-primary-blt
[211.479930] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[211.547057] [030/155] (806s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[211.644155] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[211.648627] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[211.727632] [031/155] (806s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[211.828154] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[221.270268] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.449s)
[221.417524] [032/155] (797s left) kms_rotation_crc (sprite-rotation-90)
[221.512899] Starting subtest: sprite-rotation-90
[221.517300] Subtest sprite-rotation-90: SKIP (0.001s)
[221.586043] [033/155] (797s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[221.634724] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[221.735044] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.102s)
[221.829611] [034/155] (796s left) kms_cursor_crc (cursor-offscreen-32x32)
[221.974559] Starting subtest: cursor-offscreen-32x32
[222.019993] Subtest cursor-offscreen-32x32: SKIP (0.042s)
[222.307545] [035/155] (796s left) kms_addfb_basic (too-wide)
[222.397756] Starting subtest: too-wide
[222.399594] Subtest too-wide: SUCCESS (0.000s)
[222.500831] [036/155] (796s left) syncobj_wait (single-wait-all-signaled)
[222.556159] Starting subtest: single-wait-all-signaled
[222.557820] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[222.647887] [037/155] (796s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[222.743315] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[222.746623] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[222.835641] [038/155] (796s left) i915_drm_fdinfo (busy-idle-check-all)
[222.873718] Starting subtest: busy-idle-check-all
[222.875602] Starting dynamic subtest: rcs0
[222.879539] Dynamic subtest rcs0: SKIP (0.004s)
[222.889135] Starting dynamic subtest: bcs0
[222.892594] Dynamic subtest bcs0: SKIP (0.000s)
[222.902399] Starting dynamic subtest: vcs0
[222.906103] Dynamic subtest vcs0: SKIP (0.000s)
[222.915355] Starting dynamic subtest: vcs1
[222.918749] Dynamic subtest vcs1: SKIP (0.000s)
[222.927768] Starting dynamic subtest: vecs0
[222.931122] Dynamic subtest vecs0: SKIP (0.000s)
[222.940232] Starting dynamic subtest: ccs0
[222.943719] Dynamic subtest ccs0: SKIP (0.000s)
[222.947151] Subtest busy-idle-check-all: SKIP (0.007s)
[222.987695] [039/155] (795s left) syncobj_timeline (single-wait-available-submitted)
[223.069924] Starting subtest: single-wait-available-submitted
[223.071995] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[223.185148] [040/155] (795s left) api_intel_bb (crc32)
[223.238046] Starting subtest: crc32
[223.240233] Starting dynamic subtest: rcs0-smem0
[223.527506] Dynamic subtest rcs0-smem0: SUCCESS (0.290s)
[223.542585] Starting dynamic subtest: bcs0-smem0
[223.832263] Dynamic subtest bcs0-smem0: SUCCESS (0.304s)
[223.844339] Starting dynamic subtest: vcs0-smem0
[224.187445] Dynamic subtest vcs0-smem0: SUCCESS (0.352s)
[224.200778] Starting dynamic subtest: vcs1-smem0
[224.544625] Dynamic subtest vcs1-smem0: SUCCESS (0.355s)
[224.557112] Starting dynamic subtest: vecs0-smem0
[224.898456] Dynamic subtest vecs0-smem0: SUCCESS (0.352s)
[224.910527] Starting dynamic subtest: ccs0-smem0
[225.258981] Dynamic subtest ccs0-smem0: SUCCESS (0.360s)
[225.261463] Subtest crc32: SUCCESS (2.025s)
[225.364844] [041/155] (793s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[225.415426] Starting subtest: single-wait-all-for-submit-unsubmitted
[225.521068] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[225.602154] [042/155] (793s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[225.702628] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[225.704933] Starting dynamic subtest: pipe-A-default-mode
[226.856395] Dynamic subtest pipe-A-default-mode: SKIP (1.151s)
[226.860826] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.152s)
[227.001018] [043/155] (792s left) kms_dp_link_training (uhbr-mst)
[227.094269] Starting subtest: uhbr-mst
[227.103076] Subtest uhbr-mst: SKIP (0.000s)
[227.171927] [044/155] (791s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[227.277007] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[227.281014] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[227.383626] [045/155] (791s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render)
[227.488269] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render
[227.492537] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[227.621247] [046/155] (791s left) gem_partial_pwrite_pread (reads-snoop)
[227.681352] Subtest reads-snoop: SKIP (0.000s)
[227.751172] [047/155] (791s left) gen9_exec_parse (basic-rejected-ctx-param)
[227.818878] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[227.882493] [048/155] (791s left) kms_psr (psr-primary-render)
[227.973225] Starting subtest: psr-primary-render
[227.975178] Starting dynamic subtest: eDP-1
[229.728784] Dynamic subtest eDP-1: SUCCESS (1.756s)
[229.731095] Subtest psr-primary-render: SUCCESS (1.757s)
[230.586743] [049/155] (788s left) gem_ctx_bad_destroy (double-destroy)
[230.636384] Starting subtest: double-destroy
[230.638724] Subtest double-destroy: SUCCESS (0.000s)
[230.708209] [050/155] (788s left) gem_ctx_persistence (hang)
[230.765759] Starting subtest: hang
[230.770510] Subtest hang: SKIP (0.000s)
[230.886774] [051/155] (788s left) kms_psr (psr2-cursor-blt)
[230.968358] Starting subtest: psr2-cursor-blt
[230.970672] Starting dynamic subtest: eDP-1
[232.666202] Dynamic subtest eDP-1: SUCCESS (1.697s)
[232.668473] Subtest psr2-cursor-blt: SUCCESS (1.698s)
[233.557825] [052/155] (785s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[233.815418] Starting subtest: cursor-rapid-movement-256x85
[233.860221] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[234.041474] [053/155] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[234.144427] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[234.148949] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[234.233261] [054/155] (785s left) gem_eio (create-ext)
[234.433427] Starting subtest: create-ext
[234.727815] Subtest create-ext: SUCCESS (0.297s)
[234.854749] [055/155] (784s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[234.946721] Starting subtest: x-tiled-8bpp-rotate-0
[236.173153] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.227s)
[236.282972] [056/155] (783s left) kms_flip (flip-vs-rmfb-interruptible)
[236.371696] Starting subtest: flip-vs-rmfb-interruptible
[236.373641] Starting dynamic subtest: A-eDP1
[245.038490] Dynamic subtest A-eDP1: SUCCESS (8.669s)
[245.051761] Starting dynamic subtest: B-eDP1
[253.671138] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[253.682725] Starting dynamic subtest: C-eDP1
[262.302767] Dynamic subtest C-eDP1: SUCCESS (8.627s)
[262.316051] Starting dynamic subtest: D-eDP1
[270.929588] Dynamic subtest D-eDP1: SUCCESS (8.623s)
[270.933737] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.559s)
[272.118613] [057/155] (747s left) kms_pm_backlight (brightness-with-dpms)
[272.217624] Starting subtest: brightness-with-dpms
[272.265465] Starting dynamic subtest: eDP-1
[274.807914] Dynamic subtest eDP-1: SUCCESS (2.541s)
[274.810249] Subtest brightness-with-dpms: SUCCESS (2.592s)
[275.670175] [058/155] (744s left) kms_plane_multiple (2x-tiling-4)
[275.774911] Starting subtest: 2x-tiling-4
[275.778959] Subtest 2x-tiling-4: SKIP (0.000s)
[275.862843] [059/155] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[275.963992] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[275.967999] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[276.082231] [060/155] (743s left) kms_async_flips (alternate-sync-async-flip)
[276.177374] Starting subtest: alternate-sync-async-flip
[276.548708] Starting dynamic subtest: pipe-A-eDP-1
[279.362731] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.814s)
[279.734875] Starting dynamic subtest: pipe-B-eDP-1
[282.492883] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[282.861472] Starting dynamic subtest: pipe-C-eDP-1
[285.618545] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[285.990688] Starting dynamic subtest: pipe-D-eDP-1
[288.743315] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[288.745183] Subtest alternate-sync-async-flip: SUCCESS (12.568s)
[289.926295] [061/155] (729s left) gem_exec_store (basic)
[289.982610] Starting subtest: basic
[290.084193] Subtest basic: SUCCESS (0.103s)
[290.265118] [062/155] (729s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[290.352704] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[290.356752] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[290.437592] [063/155] (729s left) gem_unref_active_buffers
[290.647545] [064/155] (729s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[290.747229] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[290.751707] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[290.864040] [065/155] (729s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[290.959699] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[298.298193] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.344s)
[298.448338] [066/155] (721s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[298.539360] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[298.543740] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[298.650005] [067/155] (721s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[298.753206] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[302.762161] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.015s)
[303.941587] [068/155] (716s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[304.044933] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[304.048886] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[304.139047] [069/155] (716s left) kms_invalid_mode (bad-vsync-start)
[304.227927] Starting subtest: bad-vsync-start
[304.230318] Starting dynamic subtest: pipe-A-eDP-1
[304.527355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[304.538445] Starting dynamic subtest: pipe-B-eDP-1
[304.540716] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[304.551607] Starting dynamic subtest: pipe-C-eDP-1
[304.553428] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[304.564343] Starting dynamic subtest: pipe-D-eDP-1
[304.566485] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[304.568770] Subtest bad-vsync-start: SUCCESS (0.305s)
[305.363719] [070/155] (714s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[305.459491] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[306.504576] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.046s)
[306.613713] [071/155] (713s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[306.717330] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[306.721384] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[306.828296] [072/155] (713s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[306.933393] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[306.935198] Starting dynamic subtest: pipe-A-eDP-1
[307.011648] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[307.025129] Starting dynamic subtest: pipe-B-eDP-1
[308.133356] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[308.137484] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.202s)
[309.310753] [073/155] (711s left) gem_exec_balancer (parallel-bb-first)
[309.560191] Starting subtest: parallel-bb-first
[310.479687] Subtest parallel-bb-first: SUCCESS (0.919s)
[311.093259] [074/155] (709s left) gem_mmap_gtt (fault-concurrent-y)
[311.140938] Subtest fault-concurrent-Y: SKIP (0.000s)
[311.210136] [075/155] (709s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[311.581882] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[312.422687] [076/155] (708s left) gem_softpin (allocator-evict)
[312.489508] Starting subtest: allocator-evict
[312.492000] Starting dynamic subtest: rcs0
[335.925639] Dynamic subtest rcs0: SUCCESS (23.440s)
[335.937084] Starting dynamic subtest: bcs0
[359.824386] Dynamic subtest bcs0: SUCCESS (23.903s)
[359.836349] Starting dynamic subtest: vcs0
[383.362009] Dynamic subtest vcs0: SUCCESS (23.538s)
[383.374507] Starting dynamic subtest: vcs1
[407.280783] Dynamic subtest vcs1: SUCCESS (23.911s)
[407.292367] Starting dynamic subtest: vecs0
[430.938932] Dynamic subtest vecs0: SUCCESS (23.653s)
[430.950753] Starting dynamic subtest: ccs0
[454.989935] Dynamic subtest ccs0: SUCCESS (24.048s)
[454.992912] Subtest allocator-evict: SUCCESS (142.500s)
[455.072626] [077/155] (565s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[455.233645] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[455.238068] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[455.336597] [078/155] (565s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[455.435018] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[455.438976] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[455.527045] [079/155] (565s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[455.625140] Starting subtest: 4-tiled-32bpp-rotate-270
[455.647431] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[455.773004] [080/155] (564s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[455.869731] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[455.873884] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[455.973628] [081/155] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[456.074671] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[462.678690] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.612s)
[462.794809] [082/155] (557s left) drm_read (short-buffer-wakeup)
[462.973625] Starting subtest: short-buffer-wakeup
[495.185569] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[495.321636] [083/155] (525s left) kms_pm_dc (dc5-dpms-negative)
[496.426509] Starting subtest: dc5-dpms-negative
[496.430914] Subtest dc5-dpms-negative: SKIP (0.000s)
[496.501849] [084/155] (524s left) kms_fbcon_fbt (psr)
[496.560516] Starting subtest: psr
[503.962329] Subtest psr: SUCCESS (7.398s)
[504.042804] [085/155] (516s left) gem_render_copy (yf-tiled-ccs-to-linear)
[504.103751] Starting subtest: yf-tiled-ccs-to-linear
[504.108408] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[504.294877] [086/155] (516s left) kms_getfb (getfb-handle-protection)
[504.381522] Starting subtest: getfb-handle-protection
[504.413748] Subtest getfb-handle-protection: SUCCESS (0.033s)
[504.551120] [087/155] (516s left) gem_bad_reloc (negative-reloc-lut)
[504.621939] Subtest negative-reloc-lut: SKIP (0.000s)
[504.705938] [088/155] (516s left) syncobj_basic (test-valid-cycle)
[504.752922] Starting subtest: test-valid-cycle
[504.754765] Subtest test-valid-cycle: SUCCESS (0.000s)
[504.856086] [089/155] (516s left) kms_prop_blob (invalid-get-prop-any)
[504.904549] Starting subtest: invalid-get-prop-any
[504.906766] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[505.030916] [090/155] (516s left) kms_flip (busy-flip)
[505.136796] Starting subtest: busy-flip
[505.139004] Starting dynamic subtest: A-eDP1
[506.797953] Dynamic subtest A-eDP1: SUCCESS (1.662s)
[506.810386] Starting dynamic subtest: B-eDP1
[508.535444] Dynamic subtest B-eDP1: SUCCESS (1.735s)
[508.553104] Starting dynamic subtest: C-eDP1
[510.248672] Dynamic subtest C-eDP1: SUCCESS (1.710s)
[510.262405] Starting dynamic subtest: D-eDP1
[511.983548] Dynamic subtest D-eDP1: SUCCESS (1.733s)
[511.986001] Subtest busy-flip: SUCCESS (6.853s)
[513.244358] [091/155] (507s left) gem_exec_schedule (u-submit-golden-slice)
[513.312970] Starting subtest: u-submit-golden-slice
[513.314944] Starting dynamic subtest: rcs0
[513.344884] Dynamic subtest rcs0: SUCCESS (0.038s)
[513.357803] Starting dynamic subtest: bcs0
[513.384388] Dynamic subtest bcs0: SUCCESS (0.039s)
[513.395073] Starting dynamic subtest: vcs0
[513.421620] Dynamic subtest vcs0: SUCCESS (0.036s)
[513.433553] Starting dynamic subtest: vcs1
[513.458255] Dynamic subtest vcs1: SUCCESS (0.035s)
[513.470231] Starting dynamic subtest: vecs0
[513.492750] Dynamic subtest vecs0: SUCCESS (0.034s)
[513.504093] Starting dynamic subtest: ccs0
[513.533728] Dynamic subtest ccs0: SUCCESS (0.040s)
[513.536050] Subtest u-submit-golden-slice: SUCCESS (0.227s)
[515.101051] [092/155] (506s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[515.260727] Starting subtest: dp-mst-lic-type-0-hdcp14
[515.265234] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[515.400353] [093/155] (505s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[515.499944] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[515.504138] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[515.597373] [094/155] (505s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[515.699024] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[515.703330] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[515.803059] [095/155] (505s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[515.884567] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[515.888999] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[515.956634] [096/155] (505s left) kms_frontbuffer_tracking (fbc-stridechange)
[516.048829] Starting subtest: fbc-stridechange
[519.311747] Subtest fbc-stridechange: SUCCESS (3.268s)
[520.456748] [097/155] (500s left) kms_chamelium_color (ctm-0-25)
[520.553267] Subtest ctm-0-25: SKIP (0.000s)
[520.600565] [098/155] (500s left) i915_query (query-topology-known-pci-ids)
[520.651786] Starting subtest: query-topology-known-pci-ids
[520.655872] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[520.757862] [099/155] (500s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[520.848130] Starting subtest: stress-xrgb8888-yftiled
[520.852739] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[520.933596] [100/155] (500s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[521.031062] Starting subtest: y-tiled-64bpp-rotate-90
[521.035585] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[521.119112] [101/155] (500s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[521.217412] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[521.219694] Starting dynamic subtest: pipe-A-eDP-1
[521.242359] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[521.255159] Starting dynamic subtest: pipe-B-eDP-1
[521.276675] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[521.287398] Starting dynamic subtest: pipe-C-eDP-1
[521.307924] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[521.318300] Starting dynamic subtest: pipe-D-eDP-1
[521.339893] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[521.343886] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[523.504443] [102/155] (498s left) gem_exec_flush (basic-wb-set-default)
[523.566724] Starting subtest: basic-wb-set-default
[529.023954] Subtest basic-wb-set-default: SUCCESS (5.459s)
[529.216413] [103/155] (492s left) kms_psr (fbc-psr-sprite-render)
[529.305500] Starting subtest: fbc-psr-sprite-render
[529.307814] Starting dynamic subtest: eDP-1
[529.312050] Dynamic subtest eDP-1: SKIP (0.000s)
[529.316302] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[529.382279] [104/155] (492s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[529.473779] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[529.478537] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[530.641155] [105/155] (491s left) gem_flink_basic (double-flink)
[530.706757] Starting subtest: double-flink
[530.709032] Subtest double-flink: SUCCESS (0.000s)
[530.832039] [106/155] (490s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[530.933802] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[530.938060] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[531.038550] [107/155] (490s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[531.144333] Starting subtest: psrhdr-farfromfence-mmap-gtt
[531.148802] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[531.251311] [108/155] (490s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[531.355724] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[531.359871] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[531.443104] [109/155] (490s left) gem_exec_reloc (basic-concurrent16)
[531.497184] Subtest basic-concurrent16: SKIP (0.000s)
[531.574920] [110/155] (490s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[531.664264] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[531.667519] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[531.765663] [111/155] (490s left) kms_flip (plain-flip-fb-recreate)
[531.855377] Starting subtest: plain-flip-fb-recreate
[531.857375] Starting dynamic subtest: A-eDP1
[540.735724] Dynamic subtest A-eDP1: SUCCESS (8.881s)
[540.746758] Starting dynamic subtest: B-eDP1
[549.665207] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[549.676578] Starting dynamic subtest: C-eDP1
[558.484643] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[558.498144] Starting dynamic subtest: D-eDP1
[567.325393] Dynamic subtest D-eDP1: SUCCESS (8.841s)
[567.329533] Subtest plain-flip-fb-recreate: SUCCESS (35.478s)
[568.521247] [112/155] (453s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[568.620040] Starting subtest: extended-pageflip-modeset-hang-oldfb
[568.621906] Starting dynamic subtest: pipe-A
[576.511219] Dynamic subtest pipe-A: SUCCESS (7.891s)
[576.522377] Starting dynamic subtest: pipe-D
[585.088351] Dynamic subtest pipe-D: SUCCESS (8.578s)
[585.090478] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.475s)
[585.943560] [113/155] (436s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[586.048853] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[586.052739] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[586.153391] [114/155] (436s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[586.248645] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[586.253077] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[586.354385] [115/155] (435s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[586.454253] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[586.458278] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[586.543948] [116/155] (435s left) kms_psr (fbc-pr-sprite-plane-move)
[586.636484] Starting subtest: fbc-pr-sprite-plane-move
[586.640469] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[586.727737] [117/155] (435s left) kms_psr (psr2-suspend)
[586.822643] Starting subtest: psr2-suspend
[586.825053] Starting dynamic subtest: eDP-1
[604.802459] Dynamic subtest eDP-1: SUCCESS (2.862s)
[604.804865] Subtest psr2-suspend: SUCCESS (2.863s)
[605.621728] [118/155] (416s left) i915_module_load (resize-bar)
[605.658869] Starting subtest: resize-bar
[605.665373] Subtest resize-bar: SKIP (0.005s)
[605.706619] [119/155] (416s left) syncobj_timeline (etime-single-wait-all-submitted)
[605.767335] Starting subtest: etime-single-wait-all-submitted
[605.873264] Subtest etime-single-wait-all-submitted: SUCCESS (0.109s)
[605.952248] [120/155] (416s left) kms_draw_crc (draw-method-mmap-wc)
[606.037737] Starting subtest: draw-method-mmap-wc
[606.039645] Starting dynamic subtest: xrgb8888-untiled
[606.271847] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[606.282529] Starting dynamic subtest: rgb565-untiled
[606.486830] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[606.497487] Starting dynamic subtest: xrgb2101010-untiled
[606.701969] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[606.716135] Starting dynamic subtest: xbgr16161616f-untiled
[606.905301] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.208s)
[606.918075] Starting dynamic subtest: xrgb8888-xtiled
[607.034823] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[607.047166] Starting dynamic subtest: rgb565-xtiled
[607.153167] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[607.163418] Starting dynamic subtest: xrgb2101010-xtiled
[607.260868] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[607.271675] Starting dynamic subtest: xbgr16161616f-xtiled
[607.368999] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[607.379537] Starting dynamic subtest: xrgb8888-4tiled
[607.519918] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.154s)
[607.531628] Starting dynamic subtest: rgb565-4tiled
[607.649112] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[607.660463] Starting dynamic subtest: xrgb2101010-4tiled
[607.790127] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[607.800847] Starting dynamic subtest: xbgr16161616f-4tiled
[607.973251] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.187s)
[607.975173] Subtest draw-method-mmap-wc: SUCCESS (2.000s)
[608.075165] [121/155] (414s left) syncobj_timeline (invalid-transfer-non-existent-point)
[608.128479] Starting subtest: invalid-transfer-non-existent-point
[608.130384] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[608.230217] [122/155] (414s left) gem_exec_flush (basic-wb-ro-default)
[608.288356] Starting subtest: basic-wb-ro-default
[613.642019] Subtest basic-wb-ro-default: SUCCESS (5.458s)
[613.845384] [123/155] (408s left) gem_exec_fence (concurrent)
[614.036296] Starting subtest: concurrent
[614.040594] Subtest concurrent: SKIP (0.000s)
[616.207096] [124/155] (406s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[616.301543] Starting subtest: plane-lut1d-ctm3x4
[616.447277] Starting dynamic subtest: pipe-A-plane-0
[616.633893] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[616.648280] Starting dynamic subtest: pipe-A-plane-1
[616.765329] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[616.777320] Starting dynamic subtest: pipe-A-plane-2
[616.897635] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[618.061022] Starting dynamic subtest: pipe-B-plane-0
[618.234842] Dynamic subtest pipe-B-plane-0: SUCCESS (0.188s)
[618.248312] Starting dynamic subtest: pipe-B-plane-1
[618.399177] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[618.410699] Starting dynamic subtest: pipe-B-plane-2
[618.589345] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[619.775168] Starting dynamic subtest: pipe-C-plane-0
[619.897858] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[619.909768] Starting dynamic subtest: pipe-C-plane-1
[620.041526] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[620.053820] Starting dynamic subtest: pipe-C-plane-2
[620.207515] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[621.414404] Starting dynamic subtest: pipe-D-plane-0
[621.547878] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[621.559363] Starting dynamic subtest: pipe-D-plane-1
[621.691410] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[621.702862] Starting dynamic subtest: pipe-D-plane-2
[621.824605] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[622.115661] Subtest plane-lut1d-ctm3x4: SUCCESS (5.853s)
[622.965591] [125/155] (399s left) gem_exec_params (sol-reset-invalid)
[623.032042] Starting subtest: sol-reset-invalid
[623.036712] Subtest sol-reset-invalid: SUCCESS (0.003s)
[624.200330] [126/155] (398s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[624.309380] Starting subtest: bad-rotation-90-yf-tiled-ccs
[624.311520] Starting dynamic subtest: pipe-A-eDP-1
[624.333967] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[624.347418] Starting dynamic subtest: pipe-B-eDP-1
[624.368550] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[624.379427] Starting dynamic subtest: pipe-C-eDP-1
[624.400952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[624.411600] Starting dynamic subtest: pipe-D-eDP-1
[624.433566] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[624.437685] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[626.609376] [127/155] (396s left) syncobj_basic (bad-destroy)
[626.657520] Starting subtest: bad-destroy
[626.659901] Subtest bad-destroy: SUCCESS (0.000s)
[626.759549] [128/155] (396s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt)
[626.846504] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt
[626.850441] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[626.948906] [129/155] (395s left) kms_cursor_edge_walk (128x128-top-edge)
[627.043912] Starting subtest: 128x128-top-edge
[627.046205] Starting dynamic subtest: pipe-A-eDP-1
[630.476015] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[630.488515] Starting dynamic subtest: pipe-D-eDP-1
[633.604714] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s)
[633.607070] Subtest 128x128-top-edge: SUCCESS (6.575s)
[634.436267] [130/155] (388s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[634.530115] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[634.534525] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[634.618638] [131/155] (388s left) gen7_exec_parse (basic-allocation)
[634.690045] Subtest basic-allocation: SKIP (0.000s)
[634.749622] [132/155] (388s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[634.845464] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[634.847536] Starting dynamic subtest: pipe-A-eDP-1
[637.034735] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.191s)
[637.046481] Starting dynamic subtest: pipe-B-eDP-1
[639.207286] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.172s)
[639.219932] Starting dynamic subtest: pipe-C-eDP-1
[641.331868] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.122s)
[641.342813] Starting dynamic subtest: pipe-D-eDP-1
[643.435250] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.101s)
[643.437225] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.591s)
[644.693704] [133/155] (378s left) kms_async_flips (invalid-async-flip-atomic)
[644.795855] Starting subtest: invalid-async-flip-atomic
[645.180508] Starting dynamic subtest: pipe-A-eDP-1
[646.012212] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.832s)
[646.373858] Starting dynamic subtest: pipe-B-eDP-1
[647.242740] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.878s)
[647.614604] Starting dynamic subtest: pipe-C-eDP-1
[648.489954] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.886s)
[648.851482] Starting dynamic subtest: pipe-D-eDP-1
[649.695707] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.857s)
[649.698002] Subtest invalid-async-flip-atomic: SUCCESS (4.901s)
[650.840669] [134/155] (372s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[650.936857] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[650.940965] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[651.036292] [135/155] (372s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[651.144276] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[652.626866] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.480s)
[653.505653] [136/155] (369s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[654.043516] Starting subtest: syncobj-timeline-invalid-wait
[654.046580] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[655.286608] [137/155] (367s left) gem_ctx_persistence (engines-persistence)
[655.340403] Starting subtest: engines-persistence
[655.342750] Starting dynamic subtest: rcs0
[656.170245] Dynamic subtest rcs0: SUCCESS (0.829s)
[656.183924] Starting dynamic subtest: bcs0
[656.988142] Dynamic subtest bcs0: SUCCESS (0.816s)
[657.002921] Starting dynamic subtest: vcs0
[657.722858] Dynamic subtest vcs0: SUCCESS (0.733s)
[657.734752] Starting dynamic subtest: vcs1
[658.513771] Dynamic subtest vcs1: SUCCESS (0.789s)
[658.527717] Starting dynamic subtest: vecs0
[659.283398] Dynamic subtest vecs0: SUCCESS (0.767s)
[659.297429] Starting dynamic subtest: ccs0
[660.050571] Dynamic subtest ccs0: SUCCESS (0.765s)
[660.053824] Subtest engines-persistence: SUCCESS (4.710s)
[660.135586] [138/155] (363s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[660.235517] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[663.920318] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.691s)
[665.119254] [139/155] (358s left) kms_frontbuffer_tracking (fbchdr-tiling-y)
[665.230559] Starting subtest: fbchdr-tiling-y
[665.234642] Subtest fbchdr-tiling-y: SKIP (0.000s)
[665.330686] [140/155] (357s left) gem_exec_whisper (basic-queues-priority-all)
[665.389625] Starting subtest: basic-queues-priority-all
[687.487530] Subtest basic-queues-priority-all: SUCCESS (22.099s)
[687.673476] [141/155] (335s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[687.760921] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[687.763218] Starting dynamic subtest: pipe-A
[687.780683] Dynamic subtest pipe-A: SKIP (0.016s)
[687.793395] Starting dynamic subtest: pipe-B
[687.810680] Dynamic subtest pipe-B: SKIP (0.030s)
[687.822720] Starting dynamic subtest: pipe-C
[687.841219] Dynamic subtest pipe-C: SKIP (0.029s)
[687.853867] Starting dynamic subtest: pipe-D
[687.871009] Dynamic subtest pipe-D: SKIP (0.029s)
[687.875221] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.107s)
[687.979402] [142/155] (335s left) gem_mmap_gtt (coherency)
[688.035837] Subtest coherency: SKIP (0.000s)
[688.102087] [143/155] (335s left) kms_chamelium_edid (dp-edid-read)
[688.482914] Subtest dp-edid-read: SKIP (0.000s)
[689.309833] [144/155] (334s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[689.408832] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[689.412922] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[689.531974] [145/155] (333s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[689.632817] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[694.179466] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.554s)
[695.340321] [146/155] (328s left) gem_exec_reloc (basic-cpu)
[695.395846] Subtest basic-cpu: SKIP (0.000s)
[695.467985] [147/155] (328s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[695.566057] Starting subtest: psr-rgb565-draw-render
[702.663187] Subtest psr-rgb565-draw-render: SUCCESS (7.104s)
[702.789838] [148/155] (320s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[702.902260] Starting subtest: flip-vs-cursor-atomic-transitions
[710.851480] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.945s)
[711.661266] [149/155] (312s left) sysfs_timeslice_duration (invalid)
[711.725780] Starting subtest: invalid
[711.728199] Starting dynamic subtest: vecs0
[711.730600] Dynamic subtest vecs0: SUCCESS (0.000s)
[711.744466] Starting dynamic subtest: ccs0
[711.746751] Dynamic subtest ccs0: SUCCESS (0.000s)
[711.757879] Starting dynamic subtest: vcs0
[711.760063] Dynamic subtest vcs0: SUCCESS (0.000s)
[711.771114] Starting dynamic subtest: bcs0
[711.773286] Dynamic subtest bcs0: SUCCESS (0.000s)
[711.784675] Starting dynamic subtest: rcs0
[711.786994] Dynamic subtest rcs0: SUCCESS (0.000s)
[711.798021] Starting dynamic subtest: vcs1
[711.800313] Dynamic subtest vcs1: SUCCESS (0.000s)
[711.802416] Subtest invalid: SUCCESS (0.005s)
[711.843209] [150/155] (311s left) gem_mmap_offset (pf-nonblock)
[711.890913] Starting subtest: pf-nonblock
[711.895426] Subtest pf-nonblock: SUCCESS (0.006s)
[712.025310] [151/155] (311s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[712.118421] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[719.518614] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.405s)
[719.671268] [152/155] (304s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[719.770489] Starting subtest: compare-crc-sanitycheck-nv12
[719.772775] Starting dynamic subtest: pipe-A-eDP-1
[720.452976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.683s)
[720.466111] Starting dynamic subtest: pipe-B-eDP-1
[721.765221] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.309s)
[721.777338] Starting dynamic subtest: pipe-C-eDP-1
[723.043539] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.276s)
[723.058062] Starting dynamic subtest: pipe-D-eDP-1
[724.291912] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[724.293839] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.520s)
[725.111253] [153/155] (298s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[725.212117] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[726.268973] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.057s)
[726.471920] [154/155] (297s left) api_intel_bb (reset-flags)
[726.556485] Starting subtest: reset-flags
[726.568229] Subtest reset-flags: SUCCESS (0.012s)
[726.790868] [155/155] (297s left) i915_query (query-regions-unallocated)
[726.842403] Starting subtest: query-regions-unallocated
[726.844703] Subtest query-regions-unallocated: SUCCESS (0.000s)
[726.956163] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: gem_readwrite
results: parsing output: 6/ for test: gem_fenced_exec_thrash
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_universal_plane
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: prime_vgem
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: gem_ctx_engines
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: gem_set_tiling_vs_gtt
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: i915_pm_rpm
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: prime_mmap_coherency
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: api_intel_bb
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_dp_link_training
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_partial_pwrite_pread
results: parsing output: 46/ for test: gen9_exec_parse
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_ctx_bad_destroy
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_eio
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_pm_backlight
results: parsing output: 57/ for test: kms_plane_multiple
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_exec_store
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_unref_active_buffers
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_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_invalid_mode
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: gem_mmap_gtt
results: parsing output: 74/ for test: kms_chamelium_hpd
results: parsing output: 75/ for test: gem_softpin
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: drm_read
results: parsing output: 82/ for test: kms_pm_dc
results: parsing output: 83/ for test: kms_fbcon_fbt
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_getfb
results: parsing output: 86/ for test: gem_bad_reloc
results: parsing output: 87/ for test: syncobj_basic
results: parsing output: 88/ for test: kms_prop_blob
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_content_protection
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_chamelium_color
results: parsing output: 97/ for test: i915_query
results: parsing output: 98/ for test: kms_pipe_stress
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: gem_flink_basic
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: gem_exec_reloc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: i915_module_load
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_draw_crc
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_color_pipeline
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_basic
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_edge_walk
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gen7_exec_parse
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_async_flips
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_cursor_legacy
results: parsing output: 135/ for test: gem_exec_fence
results: parsing output: 136/ for test: gem_ctx_persistence
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_exec_whisper
results: parsing output: 140/ for test: kms_plane_scaling
results: parsing output: 141/ for test: gem_mmap_gtt
results: parsing output: 142/ for test: kms_chamelium_edid
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_exec_reloc
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_cursor_legacy
results: parsing output: 148/ for test: sysfs_timeslice_duration
results: parsing output: 149/ for test: gem_mmap_offset
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_pipe_crc_basic
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: api_intel_bb
results: parsing output: 154/ for test: i915_query
Done.