[96.507510] Initializing watchdogs
[96.507683]   /dev/watchdog0
[96.547925] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[96.562594] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[96.569663] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[96.577631] [001/155] (960s left) gem_fenced_exec_thrash (2-spare-fences)
[96.724524] Starting subtest: 2-spare-fences
[98.905113] Subtest 2-spare-fences: SUCCESS (2.177s)
[99.076895] [002/155] (958s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[99.290143] Starting subtest: fbc-tiling-linear
[102.052251] Subtest fbc-tiling-linear: SUCCESS (2.765s)
[102.390910] [003/155] (954s left) perf_pmu (most-busy-idle-check-all)
[102.510689] Starting subtest: most-busy-idle-check-all
[102.514682] Starting dynamic subtest: rcs0
[103.144803] Dynamic subtest rcs0: SUCCESS (0.629s)
[103.169833] Starting dynamic subtest: bcs0
[103.767427] Dynamic subtest bcs0: SUCCESS (0.621s)
[103.791199] Starting dynamic subtest: vcs0
[104.395438] Dynamic subtest vcs0: SUCCESS (0.627s)
[104.417454] Starting dynamic subtest: vecs0
[105.014431] Dynamic subtest vecs0: SUCCESS (0.618s)
[105.019195] Subtest most-busy-idle-check-all: SUCCESS (2.498s)
[105.190255] [004/155] (952s left) kms_cursor_crc (cursor-offscreen-64x21)
[105.392672] Starting subtest: cursor-offscreen-64x21
[105.431511] Starting dynamic subtest: pipe-A-HDMI-A-1
[108.360318] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.924s)
[108.488714] Starting dynamic subtest: pipe-C-HDMI-A-1
[111.029904] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.588s)
[111.037425] Subtest cursor-offscreen-64x21: SUCCESS (5.634s)
[111.425081] [005/155] (946s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[111.639826] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc
[112.411051] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (0.763s)
[112.694883] [006/155] (944s left) kms_dp_link_training (non-uhbr-sst)
[112.882446] Starting subtest: non-uhbr-sst
[112.904952] Subtest non-uhbr-sst: SKIP (0.000s)
[113.027265] [007/155] (944s left) gem_ctx_persistence (engines-hostile-preempt)
[113.155531] Starting subtest: engines-hostile-preempt
[113.159903] Starting dynamic subtest: rcs0
[113.242971] Dynamic subtest rcs0: SUCCESS (0.090s)
[113.267353] Starting dynamic subtest: bcs0
[113.327631] Dynamic subtest bcs0: SUCCESS (0.082s)
[113.352216] Starting dynamic subtest: vcs0
[113.411135] Dynamic subtest vcs0: SUCCESS (0.083s)
[113.437293] Starting dynamic subtest: vecs0
[113.495960] Dynamic subtest vecs0: SUCCESS (0.084s)
[113.500214] Subtest engines-hostile-preempt: SUCCESS (0.344s)
[113.648843] [008/155] (944s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[113.856593] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[114.618273] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (0.763s)
[114.916493] [009/155] (942s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[115.134015] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[115.140647] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[115.286541] [010/155] (942s left) gem_exec_params (invalid-ring)
[115.405218] Starting subtest: invalid-ring
[115.409714] Subtest invalid-ring: SUCCESS (0.001s)
[115.550212] [011/155] (942s left) syncobj_timeline (multi-wait-available-signaled)
[115.662240] Starting subtest: multi-wait-available-signaled
[115.665450] Subtest multi-wait-available-signaled: SUCCESS (0.003s)
[115.828279] [012/155] (942s left) api_intel_bb (misplaced-blitter)
[115.936243] Starting subtest: misplaced-blitter
[115.949125] Subtest misplaced-blitter: SUCCESS (0.014s)
[116.097379] [013/155] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[116.303661] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[116.310148] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[116.453738] [014/155] (941s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[116.665098] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[117.720547] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.061s)
[117.910677] [015/155] (940s left) kms_chamelium_color (ctm-0-50)
[118.111117] Subtest ctm-0-50: SKIP (0.000s)
[118.218197] [016/155] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[118.433459] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[118.441434] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[118.576632] [017/155] (940s left) kms_addfb_basic (basic-x-tiled-legacy)
[118.692168] Starting subtest: basic-x-tiled-legacy
[118.696562] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[118.926636] [018/155] (939s left) sw_sync (sync_merge)
[119.039611] Starting subtest: sync_merge
[119.043142] Subtest sync_merge: SUCCESS (0.002s)
[119.159573] [019/155] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[119.370824] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[119.378378] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[119.509024] [020/155] (939s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[119.622529] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[119.625778] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[119.756760] [021/155] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[119.955704] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[119.963713] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[120.094781] [022/155] (938s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[120.214494] Starting subtest: multi-wait-for-submit-submitted-signaled
[120.219049] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.002s)
[120.359213] [023/155] (938s left) gem_exec_store (pages)
[120.490444] Starting subtest: pages
[120.493745] Starting dynamic subtest: rcs0
[120.574072] Dynamic subtest rcs0: SUCCESS (0.085s)
[120.601916] Starting dynamic subtest: bcs0
[120.656526] Dynamic subtest bcs0: SUCCESS (0.080s)
[120.683279] Starting dynamic subtest: vcs0
[120.745793] Dynamic subtest vcs0: SUCCESS (0.089s)
[120.769356] Starting dynamic subtest: vecs0
[120.825641] Dynamic subtest vecs0: SUCCESS (0.076s)
[120.829568] Subtest pages: SUCCESS (0.339s)
[121.104851] [024/155] (938s left) gem_exec_reloc (basic-cpu-read-noreloc)
[121.225886] Starting subtest: basic-cpu-read-noreloc
[121.238817] Subtest basic-cpu-read-noreloc: SUCCESS (0.012s)
[121.461442] [025/155] (937s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[121.667702] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[121.676285] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[121.812650] [026/155] (937s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[122.009291] Starting subtest: coverage-vs-premult-vs-constant
[122.168207] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.140669] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.970s)
[123.189509] Starting dynamic subtest: pipe-C-HDMI-A-1
[123.791113] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.636s)
[123.796753] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.782s)
[124.181159] [027/155] (935s left) api_intel_bb (delta-check)
[124.297288] Starting subtest: delta-check
[124.306473] Subtest delta-check: SUCCESS (0.013s)
[124.450754] [028/155] (935s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[124.665581] Starting subtest: x-tiled-8bpp-rotate-270
[125.027081] Subtest x-tiled-8bpp-rotate-270: SKIP (0.360s)
[125.318703] [029/155] (934s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[125.528876] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[125.627631] [030/155] (934s left) kms_draw_crc (fill-fb)
[125.825072] Starting subtest: fill-fb
[126.426268] Subtest fill-fb: SUCCESS (0.602s)
[126.698156] [031/155] (933s left) perf (non-system-wide-paranoid)
[126.915702] Starting subtest: non-system-wide-paranoid
[126.989381] Subtest non-system-wide-paranoid: SUCCESS (0.078s)
[127.102368] [032/155] (932s left) gem_spin_batch (resubmit)
[127.243528] Starting subtest: resubmit
[127.247319] Starting dynamic subtest: rcs0
[127.252184] Dynamic subtest rcs0: SUCCESS (0.007s)
[127.284667] Starting dynamic subtest: bcs0
[127.288594] Dynamic subtest bcs0: SUCCESS (0.010s)
[127.311093] Starting dynamic subtest: vcs0
[127.315052] Dynamic subtest vcs0: SUCCESS (0.005s)
[127.338075] Starting dynamic subtest: vecs0
[127.342586] Dynamic subtest vecs0: SUCCESS (0.006s)
[127.346841] Subtest resubmit: SUCCESS (0.033s)
[127.532926] [033/155] (932s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[127.658814] Starting subtest: y-tiled-ccs-to-y-tiled
[127.663351] Starting dynamic subtest: smem
[127.889525] Dynamic subtest smem: SUCCESS (0.231s)
[127.893369] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.233s)
[128.167075] [034/155] (932s left) prime_mmap_coherency (read)
[128.283258] Starting subtest: read
[133.684165] Subtest read: SUCCESS (5.392s)
[133.835378] [035/155] (926s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[134.044084] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[136.891132] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.852s)
[137.142859] [036/155] (923s left) kms_psr (psr2-cursor-render)
[137.335236] Subtest psr2-cursor-render: SKIP (0.000s)
[137.441022] [037/155] (923s left) gem_exec_capture (capture-invisible)
[137.573311] Starting subtest: capture-invisible
[137.576434] Starting dynamic subtest: smem0
[137.582670] Dynamic subtest smem0: SKIP (0.000s)
[137.591742] Subtest capture-invisible: SKIP (0.002s)
[137.710324] [038/155] (922s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[137.889596] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[137.897097] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[138.032989] [039/155] (922s left) sw_sync (sync_multi_consumer)
[138.141429] Starting subtest: sync_multi_consumer
[138.800478] Subtest sync_multi_consumer: SUCCESS (0.658s)
[138.960396] [040/155] (921s left) gem_exec_schedule (preempt-contexts)
[139.102109] Starting subtest: preempt-contexts
[139.105805] Starting dynamic subtest: rcs0
[139.216099] Dynamic subtest rcs0: SUCCESS (0.112s)
[139.256381] Starting dynamic subtest: bcs0
[139.358361] Dynamic subtest bcs0: SUCCESS (0.132s)
[139.388487] Starting dynamic subtest: vcs0
[139.469784] Dynamic subtest vcs0: SUCCESS (0.110s)
[139.494453] Starting dynamic subtest: vecs0
[139.571833] Dynamic subtest vecs0: SUCCESS (0.112s)
[139.576284] Subtest preempt-contexts: SUCCESS (0.471s)
[139.964629] [041/155] (920s left) gem_exec_fence (syncobj-channel)
[140.606719] Starting subtest: syncobj-channel
[141.679585] Subtest syncobj-channel: SUCCESS (1.070s)
[142.067852] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[142.074603] [042/155] (918s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite)
[142.284155] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite
[143.541370] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SUCCESS (1.262s)
[143.735402] [043/155] (917s left) kms_flip (2x-flip-vs-expired-vblank)
[143.921173] Starting subtest: 2x-flip-vs-expired-vblank
[143.925556] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[154.782407] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.845s)
[154.806159] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[165.564674] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.789s)
[165.593874] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[176.337265] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.766s)
[176.341938] Subtest 2x-flip-vs-expired-vblank: SUCCESS (32.418s)
[176.995477] [044/155] (884s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[177.214588] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[180.603370] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.391s)
[180.936647] [045/155] (880s left) i915_drm_fdinfo (busy)
[181.061467] Starting subtest: busy
[181.064815] Starting dynamic subtest: rcs0
[181.594100] Dynamic subtest rcs0: SUCCESS (0.536s)
[181.626172] Starting dynamic subtest: bcs0
[182.129670] Dynamic subtest bcs0: SUCCESS (0.534s)
[182.155809] Starting dynamic subtest: vcs0
[182.675112] Dynamic subtest vcs0: SUCCESS (0.541s)
[182.705240] Starting dynamic subtest: vecs0
[183.207196] Dynamic subtest vecs0: SUCCESS (0.530s)
[183.210892] Subtest busy: SUCCESS (2.151s)
[183.381773] [046/155] (877s left) i915_query (query-regions-sanity-check)
[183.496495] Starting subtest: query-regions-sanity-check
[183.521044] Subtest query-regions-sanity-check: SUCCESS (0.031s)
[183.668611] [047/155] (877s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[183.773337] Starting subtest: etime-multi-wait-for-submit-submitted
[183.878798] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[184.037723] [048/155] (877s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[184.243096] Starting subtest: y-tiled-32bpp-rotate-0
[189.716327] Subtest y-tiled-32bpp-rotate-0: SUCCESS (5.476s)
[190.137833] [049/155] (871s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[190.353090] Starting subtest: 4-tiled-32bpp-rotate-0
[190.360559] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[190.532467] [050/155] (871s left) syncobj_wait (single-wait-signaled)
[190.648608] Starting subtest: single-wait-signaled
[190.652679] Subtest single-wait-signaled: SUCCESS (0.001s)
[190.818092] [051/155] (871s left) kms_plane_scaling (planes-downscale-factor-0-5)
[191.010793] Starting subtest: planes-downscale-factor-0-5
[191.016718] Starting dynamic subtest: pipe-A
[191.366655] Dynamic subtest pipe-A: SUCCESS (0.358s)
[191.400957] Starting dynamic subtest: pipe-B
[191.796071] Dynamic subtest pipe-B: SUCCESS (0.427s)
[191.842077] Starting dynamic subtest: pipe-C
[191.883293] Dynamic subtest pipe-C: SUCCESS (0.086s)
[191.888743] Subtest planes-downscale-factor-0-5: SUCCESS (0.879s)
[192.438424] [052/155] (869s left) gem_bad_reloc (negative-reloc)
[192.566624] Starting subtest: negative-reloc
[192.577738] Subtest negative-reloc: SUCCESS (0.002s)
[192.745877] [053/155] (869s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[192.958264] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[192.964624] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[193.113466] [054/155] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[193.327863] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[193.336335] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[193.495381] [055/155] (868s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-render)
[193.712322] Starting subtest: psrhdr-rgb101010-draw-render
[193.718640] Subtest psrhdr-rgb101010-draw-render: SKIP (0.000s)
[193.865783] [056/155] (868s left) kms_cursor_edge_walk (128x128-top-bottom)
[194.066865] Starting subtest: 128x128-top-bottom
[194.072582] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.981821] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.914s)
[198.032297] Starting dynamic subtest: pipe-C-HDMI-A-1
[201.542842] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.440s)
[201.611185] Subtest 128x128-top-bottom: SUCCESS (7.364s)
[202.223636] [057/155] (860s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[202.938145] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[202.946213] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[203.047881] [058/155] (860s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[203.246712] Starting subtest: cursorB-vs-flipB-varying-size
[214.578612] Subtest cursorB-vs-flipB-varying-size: SUCCESS (11.328s)
[214.946634] [059/155] (848s left) syncobj_wait (wait-any-snapshot)
[215.076182] Starting subtest: wait-any-snapshot
[215.157075] Subtest wait-any-snapshot: SUCCESS (0.085s)
[215.306813] [060/155] (848s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[215.506366] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[216.650796] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.139s)
[216.859649] [061/155] (846s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[217.090714] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[217.101479] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[217.248579] [062/155] (846s left) gem_close_race (basic-threads)
[217.401081] Starting subtest: basic-threads
[218.601398] Subtest basic-threads: SUCCESS (1.200s)
[218.880318] [063/155] (844s left) sysfs_timeslice_duration (invalid)
[219.009287] Starting subtest: invalid
[219.013093] Starting dynamic subtest: vecs0
[219.017629] Dynamic subtest vecs0: SUCCESS (0.002s)
[219.049109] Starting dynamic subtest: vcs0
[219.053290] Dynamic subtest vcs0: SUCCESS (0.002s)
[219.077185] Starting dynamic subtest: bcs0
[219.082239] Dynamic subtest bcs0: SUCCESS (0.002s)
[219.106579] Starting dynamic subtest: rcs0
[219.110631] Dynamic subtest rcs0: SUCCESS (0.002s)
[219.114528] Subtest invalid: SUCCESS (0.024s)
[219.213219] [064/155] (844s left) kms_chamelium_frames (dp-crc-multiple)
[219.793027] Subtest dp-crc-multiple: SKIP (0.000s)
[220.132323] [065/155] (843s left) gem_madvise (dontneed-before-pwrite)
[220.247675] Starting subtest: dontneed-before-pwrite
[220.254906] Subtest dontneed-before-pwrite: SUCCESS (0.007s)
[220.410746] [066/155] (843s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[220.606229] Starting subtest: primary-4-tiled-reflect-x-0
[220.612952] Subtest primary-4-tiled-reflect-x-0: SKIP (0.006s)
[220.761456] [067/155] (843s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[220.959298] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[220.962671] Starting dynamic subtest: pipe-A-HDMI-A-1
[221.007463] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[221.052394] Starting dynamic subtest: pipe-A-HDMI-A-2
[221.101241] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[221.142387] Starting dynamic subtest: pipe-B-HDMI-A-1
[221.173667] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[221.199188] Starting dynamic subtest: pipe-B-HDMI-A-2
[221.229216] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[221.252589] Starting dynamic subtest: pipe-C-HDMI-A-1
[221.280024] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[221.304041] Starting dynamic subtest: pipe-C-HDMI-A-2
[221.333714] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[221.339330] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.037s)
[222.103321] [068/155] (842s left) kms_busy (extended-pageflip-hang-oldfb)
[222.331123] Starting subtest: extended-pageflip-hang-oldfb
[222.337433] Starting dynamic subtest: pipe-A
[222.939434] Dynamic subtest pipe-A: SUCCESS (0.611s)
[222.981417] Starting dynamic subtest: pipe-C
[223.353658] Dynamic subtest pipe-C: SUCCESS (0.402s)
[223.357909] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.038s)
[223.779817] [069/155] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[223.993114] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[224.000742] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[224.158928] [070/155] (840s left) syncobj_eventfd (binary-wait)
[224.275246] Starting subtest: binary-wait
[224.287741] Subtest binary-wait: SUCCESS (0.012s)
[224.450221] [071/155] (840s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[224.564569] Starting subtest: cpuset-basic-small-copy-XY
[230.591700] Subtest cpuset-basic-small-copy-XY: SUCCESS (6.033s)
[230.792186] [072/155] (833s left) i915_drm_fdinfo (virtual-busy-idle)
[231.103112] Starting subtest: virtual-busy-idle
[233.676111] Subtest virtual-busy-idle: SUCCESS (2.579s)
[233.825524] [073/155] (830s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[234.037335] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[238.146120] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (4.108s)
[238.559487] [074/155] (826s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[238.800624] Starting subtest: psrhdr-slowdraw
[238.807264] Subtest psrhdr-slowdraw: SKIP (0.000s)
[238.955666] [075/155] (825s left) gem_exec_schedule (reorder-wide)
[239.244757] Starting subtest: reorder-wide
[239.248471] Starting dynamic subtest: rcs0
[239.402569] Dynamic subtest rcs0: SUCCESS (0.154s)
[239.448623] Starting dynamic subtest: bcs0
[239.725948] Dynamic subtest bcs0: SUCCESS (0.312s)
[239.777225] Starting dynamic subtest: vcs0
[239.884545] Dynamic subtest vcs0: SUCCESS (0.155s)
[239.931612] Starting dynamic subtest: vecs0
[240.040876] Dynamic subtest vecs0: SUCCESS (0.153s)
[240.045886] Subtest reorder-wide: SUCCESS (0.793s)
[240.330895] [076/155] (824s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[240.520384] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[240.530373] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[240.673246] [077/155] (824s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[240.896991] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[240.904658] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[241.068904] [078/155] (824s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[241.285648] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[242.459191] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SUCCESS (1.168s)
[242.686286] [079/155] (822s left) gem_mmap_gtt (big-copy-xy)
[242.804657] Starting subtest: big-copy-XY
[253.270640] Subtest big-copy-XY: SUCCESS (10.465s)
[253.445457] [080/155] (812s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[253.706833] Starting subtest: basic-wc-gtt-noreloc
[253.716861] Subtest basic-wc-gtt-noreloc: SUCCESS (0.009s)
[253.959555] [081/155] (811s left) kms_big_fb (linear-64bpp-rotate-90)
[254.177499] Starting subtest: linear-64bpp-rotate-90
[254.748518] Subtest linear-64bpp-rotate-90: SKIP (0.560s)
[255.038670] [082/155] (810s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[255.262261] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[255.527933] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.259s)
[255.839707] [083/155] (810s left) gem_userptr_blits (probe)
[256.011885] Starting subtest: probe
[256.386200] Subtest probe: SUCCESS (0.366s)
[256.539702] [084/155] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[256.750126] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[259.517340] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SUCCESS (2.768s)
[259.726691] [085/155] (806s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[259.927684] Starting subtest: invalid-modeset-force-ultra-joiner
[259.934167] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[260.077380] [086/155] (806s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[260.277372] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[260.282619] Starting dynamic subtest: pipe-A-valid-mode
[261.386421] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.003s)
[261.453811] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (1.010s)
[262.080426] [087/155] (804s left) kms_prop_blob (invalid-get-prop)
[262.648408] Starting subtest: invalid-get-prop
[262.799022] Subtest invalid-get-prop: SUCCESS (0.000s)
[262.897433] [088/155] (803s left) kms_vblank (query-forked-hang)
[263.090633] Starting subtest: query-forked-hang
[263.102426] Starting dynamic subtest: pipe-A-HDMI-A-1
[270.921294] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.817s)
[270.974444] Starting dynamic subtest: pipe-A-HDMI-A-2
[277.815458] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.888s)
[277.865240] Starting dynamic subtest: pipe-C-HDMI-A-1
[284.847686] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.024s)
[284.906063] Starting dynamic subtest: pipe-C-HDMI-A-2
[291.824707] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.964s)
[291.829114] Subtest query-forked-hang: SUCCESS (28.730s)
[292.192710] [089/155] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[292.410063] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[294.485978] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.079s)
[294.723708] [090/155] (772s left) syncobj_timeline (wait-any-complex)
[294.857662] Starting subtest: wait-any-complex
[294.922858] Subtest wait-any-complex: SUCCESS (0.067s)
[295.104732] [091/155] (771s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[295.308652] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[295.315702] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[295.481592] [092/155] (771s left) gem_ctx_shared (q-in-order)
[295.616754] Starting subtest: Q-in-order
[295.621844] Starting dynamic subtest: rcs0
[295.710683] Dynamic subtest rcs0: SUCCESS (0.088s)
[295.748746] Starting dynamic subtest: bcs0
[295.814251] Dynamic subtest bcs0: SUCCESS (0.100s)
[295.846435] Starting dynamic subtest: vcs0
[295.905741] Dynamic subtest vcs0: SUCCESS (0.087s)
[295.938751] Starting dynamic subtest: vecs0
[296.004878] Dynamic subtest vecs0: SUCCESS (0.093s)
[296.009840] Subtest Q-in-order: SUCCESS (0.389s)
[296.292712] [093/155] (771s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[296.491731] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[296.501272] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[297.272807] [094/155] (770s left) gem_softpin (32b-excludes-last-page)
[297.409851] Starting subtest: 32b-excludes-last-page
[297.413867] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[297.568328] [095/155] (769s left) syncobj_basic (bad-fd-to-handle)
[297.678972] Starting subtest: bad-fd-to-handle
[297.685534] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[297.833383] [096/155] (769s left) vgem_basic (second-client)
[297.970756] Starting subtest: second-client
[298.002742] Subtest second-client: SUCCESS (0.036s)
[298.179326] [097/155] (769s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[298.370066] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[298.612092] Starting dynamic subtest: pipe-A-plane-0
[298.911777] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[298.938916] Starting dynamic subtest: pipe-A-plane-1
[299.210498] Dynamic subtest pipe-A-plane-1: SUCCESS (0.295s)
[299.237648] Starting dynamic subtest: pipe-A-plane-2
[299.478513] Dynamic subtest pipe-A-plane-2: SUCCESS (0.262s)
[299.504564] Starting dynamic subtest: pipe-A-plane-3
[299.743719] Dynamic subtest pipe-A-plane-3: SUCCESS (0.261s)
[299.780555] Starting dynamic subtest: pipe-A-plane-4
[299.787983] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[300.147081] Starting dynamic subtest: pipe-B-plane-0
[300.389888] Dynamic subtest pipe-B-plane-0: SUCCESS (0.266s)
[300.416152] Starting dynamic subtest: pipe-B-plane-1
[300.674058] Dynamic subtest pipe-B-plane-1: SUCCESS (0.281s)
[300.700317] Starting dynamic subtest: pipe-B-plane-2
[300.941082] Dynamic subtest pipe-B-plane-2: SUCCESS (0.262s)
[300.966603] Starting dynamic subtest: pipe-B-plane-3
[301.207825] Dynamic subtest pipe-B-plane-3: SUCCESS (0.263s)
[301.238375] Starting dynamic subtest: pipe-B-plane-4
[301.251182] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[301.432693] Subtest pixel-format-yf-tiled-ccs-modifier: SUCCESS (3.057s)
[301.800894] [098/155] (766s left) kms_psr (psr2-sprite-render)
[301.997112] Subtest psr2-sprite-render: SKIP (0.000s)
[302.129266] [099/155] (765s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[302.360978] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[302.382172] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[302.525501] [100/155] (765s left) kms_dsc (dsc-fractional-bpp)
[302.727888] Subtest dsc-fractional-bpp: SKIP (0.000s)
[302.850496] [101/155] (765s left) kms_psr (fbc-psr2-primary-blt)
[303.049445] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[303.166716] [102/155] (765s left) syncobj_wait (wait-delayed-signal)
[303.286063] Starting subtest: wait-delayed-signal
[303.388056] Subtest wait-delayed-signal: SUCCESS (0.106s)
[303.583982] [103/155] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[303.787491] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[303.794870] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[303.959510] [104/155] (764s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[304.175758] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[304.184122] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[304.369051] [105/155] (764s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[304.499098] Starting subtest: yf-tiled-ccs-to-yf-tiled
[304.502290] Starting dynamic subtest: smem
[304.856532] Dynamic subtest smem: SUCCESS (0.346s)
[304.860570] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.350s)
[305.119332] [106/155] (763s left) gem_exec_fence (syncobj-wait)
[305.677438] Starting subtest: syncobj-wait
[305.707533] Subtest syncobj-wait: SUCCESS (0.031s)
[306.103106] [107/155] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[306.314703] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[306.321299] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[306.474299] [108/155] (762s left) kms_chamelium_hpd (vga-hpd-fast)
[307.064495] Subtest vga-hpd-fast: SKIP (0.000s)
[307.423576] [109/155] (761s left) kms_cursor_crc (cursor-random-128x42)
[307.627692] Starting subtest: cursor-random-128x42
[307.675078] Starting dynamic subtest: pipe-A-HDMI-A-1
[311.896651] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.221s)
[312.001098] Starting dynamic subtest: pipe-C-HDMI-A-1
[315.883214] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.907s)
[315.886606] Subtest cursor-random-128x42: SUCCESS (8.257s)
[316.267680] [110/155] (752s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[316.484566] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[317.315297] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (0.831s)
[317.629870] [111/155] (751s left) kms_content_protection (dp-mst-type-0-hdcp14)
[317.842123] Starting subtest: dp-mst-type-0-hdcp14
[317.849796] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[318.031155] [112/155] (751s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[318.225126] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[318.229501] Starting dynamic subtest: pipe-A-HDMI-A-1
[318.274044] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[318.331986] Starting dynamic subtest: pipe-A-HDMI-A-2
[318.380371] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[318.405879] Starting dynamic subtest: pipe-B-HDMI-A-1
[318.433936] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[318.459892] Starting dynamic subtest: pipe-B-HDMI-A-2
[318.489427] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[318.514921] Starting dynamic subtest: pipe-C-HDMI-A-1
[318.545273] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[318.571691] Starting dynamic subtest: pipe-C-HDMI-A-2
[318.599829] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[318.605843] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.039s)
[319.259080] [113/155] (750s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[319.464921] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[319.595465] [114/155] (750s left) syncobj_wait (invalid-signal-one-illegal-handle)
[319.720590] Starting subtest: invalid-signal-one-illegal-handle
[319.723567] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[319.871862] [115/155] (749s left) kms_vblank (ts-continuation-dpms-suspend)
[320.058784] Starting subtest: ts-continuation-dpms-suspend
[320.068558] Starting dynamic subtest: pipe-A-HDMI-A-1