[91.975802] Initializing watchdogs
[91.976056]   /dev/watchdog0
[92.016716] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[92.030227] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[92.037419] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[92.042649] [001/155] (960s left) gem_fenced_exec_thrash (2-spare-fences)
[92.176375] Starting subtest: 2-spare-fences
[94.338959] Subtest 2-spare-fences: SUCCESS (2.163s)
[94.566810] [002/155] (958s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[94.757786] Starting subtest: fbc-tiling-linear
[97.569169] Subtest fbc-tiling-linear: SUCCESS (2.808s)
[97.859121] [003/155] (954s left) perf_pmu (most-busy-idle-check-all)
[97.964162] Starting subtest: most-busy-idle-check-all
[97.966712] Starting dynamic subtest: rcs0
[98.597309] Dynamic subtest rcs0: SUCCESS (0.632s)
[98.620480] Starting dynamic subtest: bcs0
[99.226566] Dynamic subtest bcs0: SUCCESS (0.629s)
[99.246402] Starting dynamic subtest: vcs0
[99.859997] Dynamic subtest vcs0: SUCCESS (0.631s)
[99.883131] Starting dynamic subtest: vecs0
[100.484033] Dynamic subtest vecs0: SUCCESS (0.626s)
[100.485030] Subtest most-busy-idle-check-all: SUCCESS (2.520s)
[100.645389] [004/155] (952s left) kms_cursor_crc (cursor-offscreen-64x21)
[100.827644] Starting subtest: cursor-offscreen-64x21
[100.865575] Starting dynamic subtest: pipe-A-HDMI-A-1
[103.749865] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.880s)
[103.829841] Starting dynamic subtest: pipe-C-HDMI-A-1
[106.373685] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.558s)
[106.375193] Subtest cursor-offscreen-64x21: SUCCESS (5.540s)
[106.703334] [005/155] (946s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[106.888865] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc
[107.632753] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (0.744s)
[107.898580] [006/155] (945s left) kms_dp_link_training (non-uhbr-sst)
[108.067960] Starting subtest: non-uhbr-sst
[108.073537] Subtest non-uhbr-sst: SKIP (0.000s)
[108.197331] [007/155] (944s left) gem_ctx_persistence (engines-hostile-preempt)
[108.304235] Starting subtest: engines-hostile-preempt
[108.305282] Starting dynamic subtest: rcs0
[108.409889] Dynamic subtest rcs0: SUCCESS (0.104s)
[108.429841] Starting dynamic subtest: bcs0
[108.512836] Dynamic subtest bcs0: SUCCESS (0.100s)
[108.532640] Starting dynamic subtest: vcs0
[108.607792] Dynamic subtest vcs0: SUCCESS (0.095s)
[108.628078] Starting dynamic subtest: vecs0
[108.699995] Dynamic subtest vecs0: SUCCESS (0.090s)
[108.701230] Subtest engines-hostile-preempt: SUCCESS (0.396s)
[108.834182] [008/155] (944s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[109.020504] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[109.742317] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (0.721s)
[110.022639] [009/155] (943s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[110.208966] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[110.210801] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[110.356806] [010/155] (942s left) gem_exec_params (invalid-ring)
[110.461980] Starting subtest: invalid-ring
[110.463025] Subtest invalid-ring: SUCCESS (0.001s)
[110.606944] [011/155] (942s left) syncobj_timeline (multi-wait-available-signaled)
[110.707414] Starting subtest: multi-wait-available-signaled
[110.710382] Subtest multi-wait-available-signaled: SUCCESS (0.003s)
[110.853382] [012/155] (942s left) api_intel_bb (misplaced-blitter)
[110.953215] Starting subtest: misplaced-blitter
[110.965640] Subtest misplaced-blitter: SUCCESS (0.013s)
[111.120325] [013/155] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[111.303369] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[111.306921] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[111.483735] [014/155] (942s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[111.668505] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[112.915277] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.247s)
[113.124427] [015/155] (940s left) kms_chamelium_color (ctm-0-50)
[113.296529] Subtest ctm-0-50: SKIP (0.000s)
[113.385816] [016/155] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[113.568850] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[113.570703] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[113.710756] [017/155] (940s left) kms_addfb_basic (basic-x-tiled-legacy)
[113.807497] Starting subtest: basic-x-tiled-legacy
[113.808431] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[114.026311] [018/155] (939s left) sw_sync (sync_merge)
[114.120157] Starting subtest: sync_merge
[114.121125] Subtest sync_merge: SUCCESS (0.001s)
[114.226615] [019/155] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[114.407964] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[114.409877] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[114.543960] [020/155] (939s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[114.640659] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[114.642801] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[114.758530] [021/155] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[114.941651] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[114.943501] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[115.076205] [022/155] (939s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[115.173903] Starting subtest: multi-wait-for-submit-submitted-signaled
[115.177115] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[115.296526] [023/155] (938s left) gem_exec_store (pages)
[115.415705] Starting subtest: pages
[115.416667] Starting dynamic subtest: rcs0
[115.507514] Dynamic subtest rcs0: SUCCESS (0.091s)
[115.527117] Starting dynamic subtest: bcs0
[115.593250] Dynamic subtest bcs0: SUCCESS (0.085s)
[115.612436] Starting dynamic subtest: vcs0
[115.688549] Dynamic subtest vcs0: SUCCESS (0.093s)
[115.707113] Starting dynamic subtest: vecs0
[115.780109] Dynamic subtest vecs0: SUCCESS (0.091s)
[115.781142] Subtest pages: SUCCESS (0.365s)
[116.028261] [024/155] (938s left) gem_exec_reloc (basic-cpu-read-noreloc)
[116.134217] Starting subtest: basic-cpu-read-noreloc
[116.147632] Subtest basic-cpu-read-noreloc: SUCCESS (0.013s)
[116.343435] [025/155] (938s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[116.527832] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[116.529791] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[116.677878] [026/155] (937s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[116.848428] Starting subtest: coverage-vs-premult-vs-constant
[117.094153] Starting dynamic subtest: pipe-A-HDMI-A-1
[118.042554] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.946s)
[118.061956] Starting dynamic subtest: pipe-C-HDMI-A-1
[118.682742] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.635s)
[118.683843] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.834s)
[119.056527] [027/155] (935s left) api_intel_bb (delta-check)
[119.152949] Starting subtest: delta-check
[119.162302] Subtest delta-check: SUCCESS (0.009s)
[119.329289] [028/155] (935s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[119.527136] Starting subtest: x-tiled-8bpp-rotate-270
[119.817780] Subtest x-tiled-8bpp-rotate-270: SKIP (0.289s)
[120.077380] [029/155] (934s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[120.257967] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[120.351661] [030/155] (934s left) kms_draw_crc (fill-fb)
[120.521690] Starting subtest: fill-fb
[121.149520] Subtest fill-fb: SUCCESS (0.626s)
[121.392136] [031/155] (933s left) perf (non-system-wide-paranoid)
[121.637336] Starting subtest: non-system-wide-paranoid
[121.733821] Subtest non-system-wide-paranoid: SUCCESS (0.096s)
[121.833530] [032/155] (933s left) gem_spin_batch (resubmit)
[121.957998] Starting subtest: resubmit
[121.959116] Starting dynamic subtest: rcs0
[121.964936] Dynamic subtest rcs0: SUCCESS (0.007s)
[121.988895] Starting dynamic subtest: bcs0
[121.989991] Dynamic subtest bcs0: SUCCESS (0.008s)
[122.009040] Starting dynamic subtest: vcs0
[122.010419] Dynamic subtest vcs0: SUCCESS (0.006s)
[122.031364] Starting dynamic subtest: vecs0
[122.032702] Dynamic subtest vecs0: SUCCESS (0.005s)
[122.034065] Subtest resubmit: SUCCESS (0.031s)
[122.245941] [033/155] (932s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[122.357225] Starting subtest: y-tiled-ccs-to-y-tiled
[122.358366] Starting dynamic subtest: smem
[122.591836] Dynamic subtest smem: SUCCESS (0.235s)
[122.592893] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.236s)
[122.829382] [034/155] (932s left) prime_mmap_coherency (read)
[122.935149] Starting subtest: read
[128.329075] Subtest read: SUCCESS (5.393s)
[128.477622] [035/155] (926s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[128.662433] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[131.515545] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.851s)
[131.727391] [036/155] (923s left) kms_psr (psr2-cursor-render)
[131.898314] Subtest psr2-cursor-render: SKIP (0.000s)
[131.982870] [037/155] (923s left) gem_exec_capture (capture-invisible)
[132.088326] Starting subtest: capture-invisible
[132.089569] Starting dynamic subtest: smem0
[132.091591] Dynamic subtest smem0: SKIP (0.000s)
[132.093514] Subtest capture-invisible: SKIP (0.001s)
[132.241694] [038/155] (923s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[132.413175] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[132.415157] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[132.542875] [039/155] (923s left) sw_sync (sync_multi_consumer)
[132.640499] Starting subtest: sync_multi_consumer
[133.592906] Subtest sync_multi_consumer: SUCCESS (0.954s)
[133.709689] [040/155] (921s left) gem_exec_schedule (preempt-contexts)
[133.842676] Starting subtest: preempt-contexts
[133.843758] Starting dynamic subtest: rcs0
[133.959805] Dynamic subtest rcs0: SUCCESS (0.116s)
[133.987735] Starting dynamic subtest: bcs0
[134.090791] Dynamic subtest bcs0: SUCCESS (0.130s)
[134.119120] Starting dynamic subtest: vcs0
[134.197416] Dynamic subtest vcs0: SUCCESS (0.105s)
[134.223080] Starting dynamic subtest: vecs0
[134.295587] Dynamic subtest vecs0: SUCCESS (0.098s)
[134.296898] Subtest preempt-contexts: SUCCESS (0.456s)
[134.711332] [041/155] (921s left) gem_exec_fence (syncobj-channel)
[135.296844] Starting subtest: syncobj-channel
[136.349139] Subtest syncobj-channel: SUCCESS (1.050s)
[136.749523] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[136.753731] [042/155] (919s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite)
[136.936584] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite
[137.962042] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SUCCESS (1.025s)
[138.151698] [043/155] (917s left) kms_flip (2x-flip-vs-expired-vblank)
[138.319426] Starting subtest: 2x-flip-vs-expired-vblank
[138.324176] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[149.087362] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.763s)
[149.111230] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[159.804217] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.711s)
[159.826403] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[170.498236] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.691s)
[170.499218] Subtest 2x-flip-vs-expired-vblank: SUCCESS (32.180s)
[171.124391] [044/155] (884s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[171.310709] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[174.729128] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.417s)
[175.015708] [045/155] (881s left) i915_drm_fdinfo (busy)
[175.122747] Starting subtest: busy
[175.123844] Starting dynamic subtest: rcs0
[175.657292] Dynamic subtest rcs0: SUCCESS (0.534s)
[175.678959] Starting dynamic subtest: bcs0
[176.195567] Dynamic subtest bcs0: SUCCESS (0.535s)
[176.215956] Starting dynamic subtest: vcs0
[176.732402] Dynamic subtest vcs0: SUCCESS (0.536s)
[176.754694] Starting dynamic subtest: vecs0
[177.264414] Dynamic subtest vecs0: SUCCESS (0.530s)
[177.265736] Subtest busy: SUCCESS (2.143s)
[177.401480] [046/155] (878s left) i915_query (query-regions-sanity-check)
[177.495506] Starting subtest: query-regions-sanity-check
[177.521286] Subtest query-regions-sanity-check: SUCCESS (0.026s)
[177.684814] [047/155] (878s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[177.785656] Starting subtest: etime-multi-wait-for-submit-submitted
[177.889462] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[178.033766] [048/155] (878s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[178.224275] Starting subtest: y-tiled-32bpp-rotate-0
[183.444842] Subtest y-tiled-32bpp-rotate-0: SUCCESS (5.221s)
[184.001911] [049/155] (872s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[184.186611] Starting subtest: 4-tiled-32bpp-rotate-0
[184.188439] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[184.364495] [050/155] (872s left) syncobj_wait (single-wait-signaled)
[184.463628] Starting subtest: single-wait-signaled
[184.464639] Subtest single-wait-signaled: SUCCESS (0.001s)
[184.614670] [051/155] (872s left) kms_plane_scaling (planes-downscale-factor-0-5)
[184.782429] Starting subtest: planes-downscale-factor-0-5
[184.783475] Starting dynamic subtest: pipe-A
[185.112294] Dynamic subtest pipe-A: SUCCESS (0.330s)
[185.134764] Starting dynamic subtest: pipe-B
[185.522469] Dynamic subtest pipe-B: SUCCESS (0.411s)
[185.545186] Starting dynamic subtest: pipe-C
[185.574861] Dynamic subtest pipe-C: SUCCESS (0.050s)
[185.577646] Subtest planes-downscale-factor-0-5: SUCCESS (0.797s)
[186.059836] [052/155] (870s left) gem_bad_reloc (negative-reloc)
[186.167261] Starting subtest: negative-reloc
[186.169921] Subtest negative-reloc: SUCCESS (0.001s)
[186.327758] [053/155] (870s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[186.511486] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[186.513461] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[186.677667] [054/155] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[186.860947] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[186.862894] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[187.027691] [055/155] (869s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-render)
[187.215178] Starting subtest: psrhdr-rgb101010-draw-render
[187.216958] Subtest psrhdr-rgb101010-draw-render: SKIP (0.000s)
[187.377807] [056/155] (869s left) kms_cursor_edge_walk (128x128-top-bottom)
[187.546582] Starting subtest: 128x128-top-bottom
[187.549805] Starting dynamic subtest: pipe-A-HDMI-A-1
[191.398618] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.849s)
[191.424848] Starting dynamic subtest: pipe-C-HDMI-A-1
[194.816257] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.414s)
[194.817369] Subtest 128x128-top-bottom: SUCCESS (7.272s)
[195.127132] [057/155] (862s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[195.309688] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[195.311456] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[195.460820] [058/155] (861s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[195.629667] Starting subtest: cursorB-vs-flipB-varying-size
[206.889918] Subtest cursorB-vs-flipB-varying-size: SUCCESS (11.257s)
[207.202956] [059/155] (850s left) syncobj_wait (wait-any-snapshot)
[207.313033] Starting subtest: wait-any-snapshot
[207.396232] Subtest wait-any-snapshot: SUCCESS (0.084s)
[207.535840] [060/155] (849s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[207.723725] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[208.805177] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.081s)
[209.000138] [061/155] (848s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[209.185815] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[209.187647] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[209.333601] [062/155] (848s left) gem_close_race (basic-threads)
[209.456228] Starting subtest: basic-threads
[210.771352] Subtest basic-threads: SUCCESS (1.315s)
[211.017043] [063/155] (846s left) sysfs_timeslice_duration (invalid)
[211.126888] Starting subtest: invalid
[211.127890] Starting dynamic subtest: vecs0
[211.128778] Dynamic subtest vecs0: SUCCESS (0.001s)
[211.152947] Starting dynamic subtest: vcs0
[211.153907] Dynamic subtest vcs0: SUCCESS (0.001s)
[211.173902] Starting dynamic subtest: bcs0
[211.174873] Dynamic subtest bcs0: SUCCESS (0.001s)
[211.195423] Starting dynamic subtest: rcs0
[211.196310] Dynamic subtest rcs0: SUCCESS (0.001s)
[211.197205] Subtest invalid: SUCCESS (0.019s)
[211.283649] [064/155] (846s left) kms_chamelium_frames (dp-crc-multiple)
[211.812478] Subtest dp-crc-multiple: SKIP (0.000s)
[212.098228] [065/155] (845s left) gem_madvise (dontneed-before-pwrite)
[212.187872] Starting subtest: dontneed-before-pwrite
[212.192477] Subtest dontneed-before-pwrite: SUCCESS (0.004s)
[212.353638] [066/155] (845s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[212.522083] Starting subtest: primary-4-tiled-reflect-x-0
[212.523902] Subtest primary-4-tiled-reflect-x-0: SKIP (0.002s)
[212.667174] [067/155] (845s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[212.835203] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[212.836164] Starting dynamic subtest: pipe-A-HDMI-A-1
[212.844843] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[212.866980] Starting dynamic subtest: pipe-A-HDMI-A-2
[212.875877] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[212.896403] Starting dynamic subtest: pipe-B-HDMI-A-1
[212.905310] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[212.925739] Starting dynamic subtest: pipe-B-HDMI-A-2
[212.935266] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[212.955834] Starting dynamic subtest: pipe-C-HDMI-A-1
[212.965208] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[212.985082] Starting dynamic subtest: pipe-C-HDMI-A-2
[212.993660] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[212.995361] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.031s)
[213.815115] [068/155] (844s left) kms_busy (extended-pageflip-hang-oldfb)
[213.995027] Starting subtest: extended-pageflip-hang-oldfb
[213.996976] Starting dynamic subtest: pipe-A
[214.537024] Dynamic subtest pipe-A: SUCCESS (0.538s)
[214.562827] Starting dynamic subtest: pipe-C
[214.945927] Dynamic subtest pipe-C: SUCCESS (0.401s)
[214.947328] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.953s)
[215.307597] [069/155] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[215.491037] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[215.492965] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[215.656217] [070/155] (842s left) syncobj_eventfd (binary-wait)
[215.760798] Starting subtest: binary-wait
[215.771396] Subtest binary-wait: SUCCESS (0.013s)
[215.905613] [071/155] (842s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[216.001025] Starting subtest: cpuset-basic-small-copy-XY
[221.997641] Subtest cpuset-basic-small-copy-XY: SUCCESS (5.998s)
[222.166632] [072/155] (836s left) i915_drm_fdinfo (virtual-busy-idle)
[222.387308] Starting subtest: virtual-busy-idle
[224.991537] Subtest virtual-busy-idle: SUCCESS (2.604s)
[225.125371] [073/155] (833s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[225.310293] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[228.356097] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.041s)
[228.681599] [074/155] (830s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[228.870086] Starting subtest: psrhdr-slowdraw
[228.872088] Subtest psrhdr-slowdraw: SKIP (0.000s)
[229.029442] [075/155] (829s left) gem_exec_schedule (reorder-wide)
[229.283996] Starting subtest: reorder-wide
[229.287782] Starting dynamic subtest: rcs0
[229.427270] Dynamic subtest rcs0: SUCCESS (0.140s)
[229.457779] Starting dynamic subtest: bcs0
[229.719846] Dynamic subtest bcs0: SUCCESS (0.289s)
[229.749731] Starting dynamic subtest: vcs0
[229.868901] Dynamic subtest vcs0: SUCCESS (0.144s)
[229.896378] Starting dynamic subtest: vecs0
[230.011051] Dynamic subtest vecs0: SUCCESS (0.139s)
[230.013196] Subtest reorder-wide: SUCCESS (0.727s)
[230.281222] [076/155] (828s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[230.455705] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[230.458353] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[230.598616] [077/155] (828s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[230.781758] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[230.784151] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[230.929269] [078/155] (828s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[231.114073] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[232.284375] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SUCCESS (1.170s)
[232.507409] [079/155] (826s left) gem_mmap_gtt (big-copy-xy)
[232.605338] Starting subtest: big-copy-XY
[242.970021] Subtest big-copy-XY: SUCCESS (10.365s)
[243.177394] [080/155] (816s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[243.397773] Starting subtest: basic-wc-gtt-noreloc
[243.404278] Subtest basic-wc-gtt-noreloc: SUCCESS (0.008s)
[243.623531] [081/155] (815s left) kms_big_fb (linear-64bpp-rotate-90)
[243.813331] Starting subtest: linear-64bpp-rotate-90
[244.312050] Subtest linear-64bpp-rotate-90: SKIP (0.495s)
[244.589639] [082/155] (814s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[244.778733] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[245.003939] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.224s)
[245.278323] [083/155] (814s left) gem_userptr_blits (probe)
[245.422253] Starting subtest: probe
[245.771720] Subtest probe: SUCCESS (0.350s)
[245.926511] [084/155] (813s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[246.117679] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[248.892983] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SUCCESS (2.776s)
[249.101644] [085/155] (810s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[249.279865] Starting subtest: invalid-modeset-force-ultra-joiner
[249.283265] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[249.417574] [086/155] (810s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[249.585817] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[249.589678] Starting dynamic subtest: pipe-A-valid-mode
[250.575557] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.986s)
[250.576663] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (0.990s)
[250.906032] [087/155] (809s left) kms_prop_blob (invalid-get-prop)
[251.004442] Starting subtest: invalid-get-prop
[251.005454] Subtest invalid-get-prop: SUCCESS (0.000s)
[251.139790] [088/155] (808s left) kms_vblank (query-forked-hang)
[251.312356] Starting subtest: query-forked-hang
[251.313366] Starting dynamic subtest: pipe-A-HDMI-A-1
[258.931288] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.617s)
[258.961015] Starting dynamic subtest: pipe-A-HDMI-A-2
[265.908226] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.967s)
[265.936374] Starting dynamic subtest: pipe-C-HDMI-A-1
[272.863750] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.947s)
[272.891879] Starting dynamic subtest: pipe-C-HDMI-A-2
[279.909563] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.036s)
[279.912657] Subtest query-forked-hang: SUCCESS (28.596s)
[280.222954] [089/155] (779s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[280.408720] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[282.480203] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.072s)
[282.720317] [090/155] (777s left) syncobj_timeline (wait-any-complex)
[282.837602] Starting subtest: wait-any-complex
[282.902097] Subtest wait-any-complex: SUCCESS (0.066s)
[283.038629] [091/155] (777s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[283.223365] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[283.225236] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[283.389559] [092/155] (777s left) gem_ctx_shared (q-in-order)
[283.509787] Starting subtest: Q-in-order
[283.513426] Starting dynamic subtest: rcs0
[283.599100] Dynamic subtest rcs0: SUCCESS (0.087s)
[283.630562] Starting dynamic subtest: bcs0
[283.698167] Dynamic subtest bcs0: SUCCESS (0.095s)
[283.726902] Starting dynamic subtest: vcs0
[283.779026] Dynamic subtest vcs0: SUCCESS (0.077s)
[283.808925] Starting dynamic subtest: vecs0
[283.866318] Dynamic subtest vecs0: SUCCESS (0.081s)
[283.870145] Subtest Q-in-order: SUCCESS (0.355s)
[284.153193] [093/155] (776s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[284.321989] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[284.323922] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[285.007101] [094/155] (775s left) gem_softpin (32b-excludes-last-page)
[285.115944] Starting subtest: 32b-excludes-last-page
[285.120935] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[285.290657] [095/155] (775s left) syncobj_basic (bad-fd-to-handle)
[285.387627] Starting subtest: bad-fd-to-handle
[285.388723] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[285.527468] [096/155] (775s left) vgem_basic (second-client)
[285.638337] Starting subtest: second-client
[285.672248] Subtest second-client: SUCCESS (0.032s)
[285.789268] [097/155] (775s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[285.958895] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[286.181674] Starting dynamic subtest: pipe-A-plane-0
[286.481768] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[286.507071] Starting dynamic subtest: pipe-A-plane-1
[286.746952] Dynamic subtest pipe-A-plane-1: SUCCESS (0.262s)
[286.771819] Starting dynamic subtest: pipe-A-plane-2
[287.014471] Dynamic subtest pipe-A-plane-2: SUCCESS (0.264s)
[287.039951] Starting dynamic subtest: pipe-A-plane-3
[287.280514] Dynamic subtest pipe-A-plane-3: SUCCESS (0.262s)
[287.305649] Starting dynamic subtest: pipe-A-plane-4
[287.307522] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[287.694588] Starting dynamic subtest: pipe-B-plane-0
[287.941223] Dynamic subtest pipe-B-plane-0: SUCCESS (0.266s)
[287.966790] Starting dynamic subtest: pipe-B-plane-1
[288.207682] Dynamic subtest pipe-B-plane-1: SUCCESS (0.263s)
[288.232469] Starting dynamic subtest: pipe-B-plane-2
[288.472709] Dynamic subtest pipe-B-plane-2: SUCCESS (0.263s)
[288.497624] Starting dynamic subtest: pipe-B-plane-3
[288.756729] Dynamic subtest pipe-B-plane-3: SUCCESS (0.281s)
[288.783100] Starting dynamic subtest: pipe-B-plane-4
[288.785093] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[288.983399] Subtest pixel-format-yf-tiled-ccs-modifier: SUCCESS (3.026s)
[289.324179] [098/155] (771s left) kms_psr (psr2-sprite-render)
[289.497254] Subtest psr2-sprite-render: SKIP (0.000s)
[289.599130] [099/155] (771s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[289.781521] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[289.783302] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[289.938670] [100/155] (771s left) kms_dsc (dsc-fractional-bpp)
[290.109131] Subtest dsc-fractional-bpp: SKIP (0.000s)
[290.216537] [101/155] (771s left) kms_psr (fbc-psr2-primary-blt)
[290.383741] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[290.494773] [102/155] (770s left) syncobj_wait (wait-delayed-signal)
[290.592925] Starting subtest: wait-delayed-signal
[290.698184] Subtest wait-delayed-signal: SUCCESS (0.104s)
[290.870383] [103/155] (770s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[291.051979] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[291.054103] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[291.222625] [104/155] (770s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[291.409347] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[291.411382] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[291.556636] [105/155] (770s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[291.667127] Starting subtest: yf-tiled-ccs-to-yf-tiled
[291.668348] Starting dynamic subtest: smem
[292.022529] Dynamic subtest smem: SUCCESS (0.354s)
[292.028453] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.357s)
[292.273559] [106/155] (769s left) gem_exec_fence (syncobj-wait)
[292.800702] Starting subtest: syncobj-wait
[292.837038] Subtest syncobj-wait: SUCCESS (0.039s)
[293.242502] [107/155] (768s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[293.425952] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[293.427933] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[293.574733] [108/155] (768s left) kms_chamelium_hpd (vga-hpd-fast)
[294.117355] Subtest vga-hpd-fast: SKIP (0.000s)
[294.409615] [109/155] (767s left) kms_cursor_crc (cursor-random-128x42)
[294.593937] Starting subtest: cursor-random-128x42
[294.633238] Starting dynamic subtest: pipe-A-HDMI-A-1
[298.836116] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.199s)
[298.916486] Starting dynamic subtest: pipe-C-HDMI-A-1
[302.764550] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.869s)
[302.766585] Subtest cursor-random-128x42: SUCCESS (8.172s)
[303.118695] [110/155] (758s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[303.302647] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[304.088989] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (0.786s)
[304.374504] [111/155] (757s left) kms_content_protection (dp-mst-type-0-hdcp14)
[304.577877] Starting subtest: dp-mst-type-0-hdcp14
[304.582126] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[304.740265] [112/155] (757s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[304.910330] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[304.911868] Starting dynamic subtest: pipe-A-HDMI-A-1
[304.920761] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[304.943760] Starting dynamic subtest: pipe-A-HDMI-A-2
[304.952333] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[304.974719] Starting dynamic subtest: pipe-B-HDMI-A-1
[304.983411] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[305.005819] Starting dynamic subtest: pipe-B-HDMI-A-2
[305.014856] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[305.037362] Starting dynamic subtest: pipe-C-HDMI-A-1
[305.045581] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[305.067657] Starting dynamic subtest: pipe-C-HDMI-A-2
[305.076404] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[305.078172] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.030s)
[305.882430] [113/155] (756s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[306.056981] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[306.172550] [114/155] (756s left) syncobj_wait (invalid-signal-one-illegal-handle)
[306.268656] Starting subtest: invalid-signal-one-illegal-handle
[306.269707] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[306.414508] [115/155] (756s left) kms_vblank (ts-continuation-dpms-suspend)
[306.585339] Starting subtest: ts-continuation-dpms-suspend
[306.586388] Starting dynamic subtest: pipe-A-HDMI-A-1
[325.502373] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.684s)
[325.551910] Starting dynamic subtest: pipe-A-HDMI-A-2