[113.579755] Initializing watchdogs
[113.579937]   /dev/watchdog0
[113.622572] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[113.637336] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[113.645769] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[113.654744] [001/155] (960s left) gem_fenced_exec_thrash (2-spare-fences)
[113.802675] Starting subtest: 2-spare-fences
[115.976744] Subtest 2-spare-fences: SUCCESS (2.169s)
[116.142781] [002/155] (958s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[116.359499] Starting subtest: fbc-tiling-linear
[119.150237] Subtest fbc-tiling-linear: SUCCESS (2.795s)
[119.470432] [003/155] (954s left) perf_pmu (most-busy-idle-check-all)
[119.585908] Starting subtest: most-busy-idle-check-all
[119.589349] Starting dynamic subtest: rcs0
[120.218365] Dynamic subtest rcs0: SUCCESS (0.631s)
[120.242328] Starting dynamic subtest: bcs0
[120.848846] Dynamic subtest bcs0: SUCCESS (0.621s)
[120.872386] Starting dynamic subtest: vcs0
[121.466153] Dynamic subtest vcs0: SUCCESS (0.620s)
[121.489828] Starting dynamic subtest: vecs0
[122.089779] Dynamic subtest vecs0: SUCCESS (0.621s)
[122.093849] Subtest most-busy-idle-check-all: SUCCESS (2.496s)
[122.224607] [004/155] (952s left) kms_cursor_crc (cursor-offscreen-64x21)
[122.433487] Starting subtest: cursor-offscreen-64x21
[122.486206] Starting dynamic subtest: pipe-A-HDMI-A-1
[125.406551] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.911s)
[125.500913] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.070524] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.590s)
[128.074098] Subtest cursor-offscreen-64x21: SUCCESS (5.636s)
[128.448823] [005/155] (946s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[128.666173] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc
[129.495218] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (0.768s)
[130.076777] [006/155] (944s left) kms_dp_link_training (non-uhbr-sst)
[130.399115] Starting subtest: non-uhbr-sst
[130.421178] Subtest non-uhbr-sst: SKIP (0.000s)
[130.514417] [007/155] (944s left) gem_ctx_persistence (engines-hostile-preempt)
[130.645113] Starting subtest: engines-hostile-preempt
[130.649820] Starting dynamic subtest: rcs0
[130.728492] Dynamic subtest rcs0: SUCCESS (0.086s)
[130.757340] Starting dynamic subtest: bcs0
[130.812578] Dynamic subtest bcs0: SUCCESS (0.082s)
[130.841884] Starting dynamic subtest: vcs0
[130.902204] Dynamic subtest vcs0: SUCCESS (0.088s)
[130.926797] Starting dynamic subtest: vecs0
[130.987254] Dynamic subtest vecs0: SUCCESS (0.082s)
[130.992470] Subtest engines-hostile-preempt: SUCCESS (0.346s)
[131.141952] [008/155] (943s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[131.347531] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[132.083128] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (0.738s)
[132.385380] [009/155] (942s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[132.596117] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[132.603548] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[132.739645] [010/155] (942s left) gem_exec_params (invalid-ring)
[132.861231] Starting subtest: invalid-ring
[132.865822] Subtest invalid-ring: SUCCESS (0.001s)
[133.011235] [011/155] (942s left) syncobj_timeline (multi-wait-available-signaled)
[133.126351] Starting subtest: multi-wait-available-signaled
[133.130955] Subtest multi-wait-available-signaled: SUCCESS (0.004s)
[133.288329] [012/155] (942s left) api_intel_bb (misplaced-blitter)
[133.395593] Starting subtest: misplaced-blitter
[133.406364] Subtest misplaced-blitter: SUCCESS (0.015s)
[133.598223] [013/155] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[133.804129] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[133.812108] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[133.954511] [014/155] (941s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[134.168594] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[135.245689] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.076s)
[135.434417] [015/155] (940s left) kms_chamelium_color (ctm-0-50)
[135.631084] Subtest ctm-0-50: SKIP (0.000s)
[135.739697] [016/155] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[135.956699] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[135.962271] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[136.098168] [017/155] (939s left) kms_addfb_basic (basic-x-tiled-legacy)
[136.215507] Starting subtest: basic-x-tiled-legacy
[136.219050] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[136.448730] [018/155] (939s left) sw_sync (sync_merge)
[136.565575] Starting subtest: sync_merge
[136.569742] Subtest sync_merge: SUCCESS (0.001s)
[136.695295] [019/155] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[136.910599] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[136.918269] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[137.065337] [020/155] (939s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[137.183679] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[137.188831] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[137.334860] [021/155] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[137.540285] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[137.548823] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[137.684054] [022/155] (938s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[137.800408] Starting subtest: multi-wait-for-submit-submitted-signaled
[137.803713] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[137.979301] [023/155] (938s left) gem_exec_store (pages)
[138.109809] Starting subtest: pages
[138.113112] Starting dynamic subtest: rcs0
[138.204320] Dynamic subtest rcs0: SUCCESS (0.095s)
[138.231249] Starting dynamic subtest: bcs0
[138.294242] Dynamic subtest bcs0: SUCCESS (0.090s)
[138.317402] Starting dynamic subtest: vcs0
[138.373851] Dynamic subtest vcs0: SUCCESS (0.080s)
[138.398633] Starting dynamic subtest: vecs0
[138.463992] Dynamic subtest vecs0: SUCCESS (0.085s)
[138.468267] Subtest pages: SUCCESS (0.356s)
[138.711739] [024/155] (937s left) gem_exec_reloc (basic-cpu-read-noreloc)
[138.833318] Starting subtest: basic-cpu-read-noreloc
[138.846678] Subtest basic-cpu-read-noreloc: SUCCESS (0.012s)
[139.082890] [025/155] (937s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[139.298448] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[139.305806] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[139.449866] [026/155] (937s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[139.641848] Starting subtest: coverage-vs-premult-vs-constant
[139.801068] Starting dynamic subtest: pipe-A-HDMI-A-1
[140.800093] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.992s)
[140.851047] Starting dynamic subtest: pipe-C-HDMI-A-1
[141.444070] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.640s)
[141.452662] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.803s)
[141.784549] [027/155] (935s left) api_intel_bb (delta-check)
[141.904261] Starting subtest: delta-check
[141.914246] Subtest delta-check: SUCCESS (0.010s)
[142.046218] [028/155] (934s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[142.255504] Starting subtest: x-tiled-8bpp-rotate-270
[142.558348] Subtest x-tiled-8bpp-rotate-270: SKIP (0.298s)
[142.815297] [029/155] (934s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[143.022943] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[143.124617] [030/155] (934s left) kms_draw_crc (fill-fb)
[143.319563] Starting subtest: fill-fb
[143.908738] Subtest fill-fb: SUCCESS (0.589s)
[144.183098] [031/155] (933s left) perf (non-system-wide-paranoid)
[144.417104] Starting subtest: non-system-wide-paranoid
[144.493748] Subtest non-system-wide-paranoid: SUCCESS (0.082s)
[144.599558] [032/155] (932s left) gem_spin_batch (resubmit)
[144.732331] Starting subtest: resubmit
[144.737276] Starting dynamic subtest: rcs0
[144.742359] Dynamic subtest rcs0: SUCCESS (0.008s)
[144.780294] Starting dynamic subtest: bcs0
[144.784268] Dynamic subtest bcs0: SUCCESS (0.007s)
[144.807067] Starting dynamic subtest: vcs0
[144.810547] Dynamic subtest vcs0: SUCCESS (0.007s)
[144.833609] Starting dynamic subtest: vecs0
[144.837582] Dynamic subtest vecs0: SUCCESS (0.004s)
[144.841710] Subtest resubmit: SUCCESS (0.032s)
[145.031418] [033/155] (932s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[145.152099] Starting subtest: y-tiled-ccs-to-y-tiled
[145.155958] Starting dynamic subtest: smem
[145.381537] Dynamic subtest smem: SUCCESS (0.225s)
[145.385684] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.226s)
[145.662378] [034/155] (931s left) prime_mmap_coherency (read)
[145.778773] Starting subtest: read
[151.175493] Subtest read: SUCCESS (5.393s)
[151.363091] [035/155] (926s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[151.583131] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[154.397632] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.810s)
[154.614406] [036/155] (923s left) kms_psr (psr2-cursor-render)
[154.801115] Subtest psr2-cursor-render: SKIP (0.000s)
[154.909662] [037/155] (922s left) gem_exec_capture (capture-invisible)
[155.038053] Starting subtest: capture-invisible
[155.042823] Starting dynamic subtest: smem0
[155.050093] Dynamic subtest smem0: SKIP (0.000s)
[155.057301] Subtest capture-invisible: SKIP (0.002s)
[155.214945] [038/155] (922s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[155.417949] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[155.427687] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[155.550784] [039/155] (922s left) sw_sync (sync_multi_consumer)
[155.660368] Starting subtest: sync_multi_consumer
[156.306581] Subtest sync_multi_consumer: SUCCESS (0.647s)
[156.456482] [040/155] (921s left) gem_exec_schedule (preempt-contexts)
[156.592102] Starting subtest: preempt-contexts
[156.595514] Starting dynamic subtest: rcs0
[156.710242] Dynamic subtest rcs0: SUCCESS (0.115s)
[156.745614] Starting dynamic subtest: bcs0
[156.848404] Dynamic subtest bcs0: SUCCESS (0.135s)
[156.887193] Starting dynamic subtest: vcs0
[156.958934] Dynamic subtest vcs0: SUCCESS (0.109s)
[156.985382] Starting dynamic subtest: vecs0
[157.070601] Dynamic subtest vecs0: SUCCESS (0.114s)
[157.074680] Subtest preempt-contexts: SUCCESS (0.477s)
[157.497949] [041/155] (920s left) gem_exec_fence (syncobj-channel)
[158.126263] Starting subtest: syncobj-channel
[159.190129] Subtest syncobj-channel: SUCCESS (1.063s)
[159.588533] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[159.595094] [042/155] (918s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite)
[159.804495] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite
[161.028531] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SUCCESS (1.224s)
[161.233255] [043/155] (917s left) kms_flip (2x-flip-vs-expired-vblank)
[161.443884] Starting subtest: 2x-flip-vs-expired-vblank
[161.447505] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[172.305205] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.861s)
[172.335534] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[183.121871] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.811s)
[183.150858] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[193.888881] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.762s)
[193.893961] Subtest 2x-flip-vs-expired-vblank: SUCCESS (32.457s)
[194.651894] [044/155] (883s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[194.851612] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[198.180451] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.333s)
[198.486752] [045/155] (880s left) i915_drm_fdinfo (busy)
[198.604948] Starting subtest: busy
[198.609687] Starting dynamic subtest: rcs0
[199.148345] Dynamic subtest rcs0: SUCCESS (0.545s)
[199.179769] Starting dynamic subtest: bcs0
[199.681328] Dynamic subtest bcs0: SUCCESS (0.531s)
[199.707702] Starting dynamic subtest: vcs0
[200.208922] Dynamic subtest vcs0: SUCCESS (0.528s)
[200.233687] Starting dynamic subtest: vecs0
[200.749711] Dynamic subtest vecs0: SUCCESS (0.537s)
[200.753892] Subtest busy: SUCCESS (2.151s)
[200.899590] [046/155] (877s left) i915_query (query-regions-sanity-check)
[201.009367] Starting subtest: query-regions-sanity-check
[201.033247] Subtest query-regions-sanity-check: SUCCESS (0.028s)
[201.228510] [047/155] (877s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[201.341286] Starting subtest: etime-multi-wait-for-submit-submitted
[201.446083] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[201.629806] [048/155] (877s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[201.849950] Starting subtest: y-tiled-32bpp-rotate-0
[206.562417] Subtest y-tiled-32bpp-rotate-0: SUCCESS (4.729s)
[207.016699] [049/155] (872s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[207.231823] Starting subtest: 4-tiled-32bpp-rotate-0
[207.238773] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[207.386868] [050/155] (871s left) syncobj_wait (single-wait-signaled)
[207.503537] Starting subtest: single-wait-signaled
[207.507534] Subtest single-wait-signaled: SUCCESS (0.001s)
[207.696418] [051/155] (871s left) kms_plane_scaling (planes-downscale-factor-0-5)
[207.890774] Starting subtest: planes-downscale-factor-0-5
[207.897571] Starting dynamic subtest: pipe-A
[208.263627] Dynamic subtest pipe-A: SUCCESS (0.374s)
[208.315073] Starting dynamic subtest: pipe-B
[208.708627] Dynamic subtest pipe-B: SUCCESS (0.443s)
[208.759987] Starting dynamic subtest: pipe-C
[208.801961] Dynamic subtest pipe-C: SUCCESS (0.092s)
[208.806826] Subtest planes-downscale-factor-0-5: SUCCESS (0.916s)
[209.341854] [052/155] (870s left) gem_bad_reloc (negative-reloc)
[209.467773] Starting subtest: negative-reloc
[209.478992] Subtest negative-reloc: SUCCESS (0.002s)
[209.665336] [053/155] (869s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[209.883394] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[209.889879] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[210.045832] [054/155] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[210.262770] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[210.269663] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[210.422051] [055/155] (869s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-render)
[210.644187] Starting subtest: psrhdr-rgb101010-draw-render
[210.652602] Subtest psrhdr-rgb101010-draw-render: SKIP (0.000s)
[210.802963] [056/155] (869s left) kms_cursor_edge_walk (128x128-top-bottom)
[210.998330] Starting subtest: 128x128-top-bottom
[211.003458] Starting dynamic subtest: pipe-A-HDMI-A-1
[214.967525] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.856s)
[215.062995] Starting dynamic subtest: pipe-C-HDMI-A-1
[218.362704] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.497s)
[218.368658] Subtest 128x128-top-bottom: SUCCESS (7.362s)
[218.725172] [057/155] (861s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[218.931358] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[218.939099] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[219.094162] [058/155] (860s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[219.292501] Starting subtest: cursorB-vs-flipB-varying-size
[230.703175] Subtest cursorB-vs-flipB-varying-size: SUCCESS (11.303s)
[231.349352] [059/155] (849s left) syncobj_wait (wait-any-snapshot)
[231.818790] Starting subtest: wait-any-snapshot
[231.884632] Subtest wait-any-snapshot: SUCCESS (0.084s)
[232.125554] [060/155] (848s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[232.340986] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[233.636094] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.293s)
[233.832110] [061/155] (847s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[234.066636] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[234.073853] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[234.231466] [062/155] (846s left) gem_close_race (basic-threads)
[234.375115] Starting subtest: basic-threads
[235.579616] Subtest basic-threads: SUCCESS (1.206s)
[235.846177] [063/155] (845s left) sysfs_timeslice_duration (invalid)
[235.969360] Starting subtest: invalid
[235.974109] Starting dynamic subtest: vecs0
[235.978087] Dynamic subtest vecs0: SUCCESS (0.002s)
[236.009609] Starting dynamic subtest: vcs0
[236.013469] Dynamic subtest vcs0: SUCCESS (0.003s)
[236.038472] Starting dynamic subtest: bcs0
[236.042212] Dynamic subtest bcs0: SUCCESS (0.002s)
[236.067228] Starting dynamic subtest: rcs0
[236.070876] Dynamic subtest rcs0: SUCCESS (0.001s)
[236.074318] Subtest invalid: SUCCESS (0.023s)
[236.173922] [064/155] (845s left) kms_chamelium_frames (dp-crc-multiple)
[236.742581] Subtest dp-crc-multiple: SKIP (0.000s)
[237.101702] [065/155] (844s left) gem_madvise (dontneed-before-pwrite)
[237.213657] Starting subtest: dontneed-before-pwrite
[237.221324] Subtest dontneed-before-pwrite: SUCCESS (0.005s)
[237.373881] [066/155] (844s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[237.559581] Starting subtest: primary-4-tiled-reflect-x-0
[237.567578] Subtest primary-4-tiled-reflect-x-0: SKIP (0.003s)
[237.714287] [067/155] (843s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[237.924109] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[237.927506] Starting dynamic subtest: pipe-A-HDMI-A-1
[237.969458] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[238.019450] Starting dynamic subtest: pipe-A-HDMI-A-2
[238.070549] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[238.107128] Starting dynamic subtest: pipe-B-HDMI-A-1
[238.139253] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[238.164516] Starting dynamic subtest: pipe-B-HDMI-A-2
[238.200544] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[238.225155] Starting dynamic subtest: pipe-C-HDMI-A-1
[238.252855] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[238.278052] Starting dynamic subtest: pipe-C-HDMI-A-2
[238.309529] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[238.314828] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.036s)
[239.043258] [068/155] (842s left) kms_busy (extended-pageflip-hang-oldfb)
[239.269872] Starting subtest: extended-pageflip-hang-oldfb
[239.274047] Starting dynamic subtest: pipe-A
[239.865766] Dynamic subtest pipe-A: SUCCESS (0.592s)
[239.919428] Starting dynamic subtest: pipe-C
[240.303749] Dynamic subtest pipe-C: SUCCESS (0.426s)
[240.308452] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.040s)
[240.734135] [069/155] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[240.950791] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[240.956703] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[241.116492] [070/155] (840s left) syncobj_eventfd (binary-wait)
[241.235172] Starting subtest: binary-wait
[241.245824] Subtest binary-wait: SUCCESS (0.012s)
[241.405782] [071/155] (840s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[241.515856] Starting subtest: cpuset-basic-small-copy-XY
[247.536101] Subtest cpuset-basic-small-copy-XY: SUCCESS (6.023s)
[247.709288] [072/155] (834s left) i915_drm_fdinfo (virtual-busy-idle)
[247.961529] Starting subtest: virtual-busy-idle
[250.527620] Subtest virtual-busy-idle: SUCCESS (2.563s)
[250.689029] [073/155] (831s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[250.905624] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[254.825653] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.838s)
[255.128574] [074/155] (827s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[255.361320] Starting subtest: psrhdr-slowdraw
[255.369687] Subtest psrhdr-slowdraw: SKIP (0.000s)
[255.530205] [075/155] (826s left) gem_exec_schedule (reorder-wide)
[255.825365] Starting subtest: reorder-wide
[255.830951] Starting dynamic subtest: rcs0
[255.980591] Dynamic subtest rcs0: SUCCESS (0.148s)
[256.016423] Starting dynamic subtest: bcs0
[256.305575] Dynamic subtest bcs0: SUCCESS (0.327s)
[256.352681] Starting dynamic subtest: vcs0
[256.474767] Dynamic subtest vcs0: SUCCESS (0.164s)
[256.513859] Starting dynamic subtest: vecs0
[256.640259] Dynamic subtest vecs0: SUCCESS (0.156s)
[256.644988] Subtest reorder-wide: SUCCESS (0.817s)
[256.925099] [076/155] (825s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[257.117570] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[257.124394] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[257.278583] [077/155] (825s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[257.501754] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[257.509136] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[257.660487] [078/155] (825s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[257.877531] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[259.109793] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SUCCESS (1.232s)
[259.329980] [079/155] (823s left) gem_mmap_gtt (big-copy-xy)
[259.447172] Starting subtest: big-copy-XY
[269.948498] Subtest big-copy-XY: SUCCESS (10.499s)
[270.136117] [080/155] (812s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[270.392720] Starting subtest: basic-wc-gtt-noreloc
[270.405230] Subtest basic-wc-gtt-noreloc: SUCCESS (0.012s)
[270.679263] [081/155] (812s left) kms_big_fb (linear-64bpp-rotate-90)
[270.898154] Starting subtest: linear-64bpp-rotate-90
[271.421786] Subtest linear-64bpp-rotate-90: SKIP (0.522s)
[271.698392] [082/155] (811s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[271.922919] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[272.182310] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.255s)
[272.494795] [083/155] (810s left) gem_userptr_blits (probe)
[272.663875] Starting subtest: probe
[273.031246] Subtest probe: SUCCESS (0.362s)
[273.194404] [084/155] (810s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[273.419569] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[276.223063] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SUCCESS (2.808s)
[276.426505] [085/155] (807s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[276.626855] Starting subtest: invalid-modeset-force-ultra-joiner
[276.633075] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[276.783294] [086/155] (806s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[276.971663] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[276.976451] Starting dynamic subtest: pipe-A-valid-mode
[278.014620] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.036s)
[278.018230] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (1.041s)
[278.403572] [087/155] (805s left) kms_prop_blob (invalid-get-prop)
[278.523483] Starting subtest: invalid-get-prop
[278.527440] Subtest invalid-get-prop: SUCCESS (0.000s)
[278.674170] [088/155] (805s left) kms_vblank (query-forked-hang)
[278.886607] Starting subtest: query-forked-hang
[278.890033] Starting dynamic subtest: pipe-A-HDMI-A-1
[285.825543] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.936s)
[285.877721] Starting dynamic subtest: pipe-A-HDMI-A-2
[292.855373] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.023s)
[292.892365] Starting dynamic subtest: pipe-C-HDMI-A-1
[299.850695] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.986s)
[299.893349] Starting dynamic subtest: pipe-C-HDMI-A-2
[306.859604] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.999s)
[306.863230] Subtest query-forked-hang: SUCCESS (27.983s)
[307.264913] [089/155] (776s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[307.483848] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[309.560785] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.080s)
[309.800821] [090/155] (774s left) syncobj_timeline (wait-any-complex)
[309.942641] Starting subtest: wait-any-complex
[310.007248] Subtest wait-any-complex: SUCCESS (0.066s)
[310.170391] [091/155] (773s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[310.384642] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[310.392069] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[310.552406] [092/155] (773s left) gem_ctx_shared (q-in-order)
[310.688094] Starting subtest: Q-in-order
[310.692304] Starting dynamic subtest: rcs0
[310.775301] Dynamic subtest rcs0: SUCCESS (0.084s)
[310.815200] Starting dynamic subtest: bcs0
[310.877923] Dynamic subtest bcs0: SUCCESS (0.102s)
[310.915220] Starting dynamic subtest: vcs0
[310.968823] Dynamic subtest vcs0: SUCCESS (0.086s)
[311.004904] Starting dynamic subtest: vecs0
[311.064987] Dynamic subtest vecs0: SUCCESS (0.089s)
[311.071221] Subtest Q-in-order: SUCCESS (0.382s)
[311.364160] [093/155] (772s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[311.551327] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[311.564762] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[312.284573] [094/155] (772s left) gem_softpin (32b-excludes-last-page)
[312.418083] Starting subtest: 32b-excludes-last-page
[312.429286] Subtest 32b-excludes-last-page: SUCCESS (0.007s)
[312.579596] [095/155] (771s left) syncobj_basic (bad-fd-to-handle)
[312.690908] Starting subtest: bad-fd-to-handle
[312.694326] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[312.876367] [096/155] (771s left) vgem_basic (second-client)
[313.006820] Starting subtest: second-client
[313.039681] Subtest second-client: SUCCESS (0.033s)
[313.162457] [097/155] (771s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[313.352224] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[313.597104] Starting dynamic subtest: pipe-A-plane-0
[313.890174] Dynamic subtest pipe-A-plane-0: SUCCESS (0.297s)
[313.918641] Starting dynamic subtest: pipe-A-plane-1
[314.173856] Dynamic subtest pipe-A-plane-1: SUCCESS (0.279s)
[314.200412] Starting dynamic subtest: pipe-A-plane-2
[314.440634] Dynamic subtest pipe-A-plane-2: SUCCESS (0.263s)
[314.467210] Starting dynamic subtest: pipe-A-plane-3
[314.708709] Dynamic subtest pipe-A-plane-3: SUCCESS (0.263s)
[314.755721] Starting dynamic subtest: pipe-A-plane-4
[314.770169] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[315.118759] Starting dynamic subtest: pipe-B-plane-0
[315.363385] Dynamic subtest pipe-B-plane-0: SUCCESS (0.265s)
[315.389968] Starting dynamic subtest: pipe-B-plane-1
[315.646644] Dynamic subtest pipe-B-plane-1: SUCCESS (0.279s)
[315.672594] Starting dynamic subtest: pipe-B-plane-2
[315.930769] Dynamic subtest pipe-B-plane-2: SUCCESS (0.280s)
[315.957202] Starting dynamic subtest: pipe-B-plane-3
[316.212438] Dynamic subtest pipe-B-plane-3: SUCCESS (0.279s)
[316.241083] Starting dynamic subtest: pipe-B-plane-4
[316.250467] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[316.489961] Subtest pixel-format-yf-tiled-ccs-modifier: SUCCESS (3.133s)
[316.850200] [098/155] (768s left) kms_psr (psr2-sprite-render)
[317.046489] Subtest psr2-sprite-render: SKIP (0.000s)
[317.164408] [099/155] (767s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[317.383483] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[317.391610] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[317.556985] [100/155] (767s left) kms_dsc (dsc-fractional-bpp)
[317.754242] Subtest dsc-fractional-bpp: SKIP (0.000s)
[317.882430] [101/155] (767s left) kms_psr (fbc-psr2-primary-blt)
[318.091468] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[318.205987] [102/155] (767s left) syncobj_wait (wait-delayed-signal)
[318.320463] Starting subtest: wait-delayed-signal
[318.496268] Subtest wait-delayed-signal: SUCCESS (0.104s)
[318.965720] [103/155] (766s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[319.636147] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[319.767804] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[320.017998] [104/155] (765s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[320.242045] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[320.248697] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[320.427609] [105/155] (765s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[320.559028] Starting subtest: yf-tiled-ccs-to-yf-tiled
[320.562503] Starting dynamic subtest: smem
[320.910721] Dynamic subtest smem: SUCCESS (0.348s)
[320.915099] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.352s)
[321.186912] [106/155] (765s left) gem_exec_fence (syncobj-wait)
[321.740773] Starting subtest: syncobj-wait
[321.767970] Subtest syncobj-wait: SUCCESS (0.029s)
[322.169403] [107/155] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[322.398279] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[322.405790] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[322.556298] [108/155] (763s left) kms_chamelium_hpd (vga-hpd-fast)
[323.167545] Subtest vga-hpd-fast: SKIP (0.000s)
[323.570629] [109/155] (762s left) kms_cursor_crc (cursor-random-128x42)
[323.790871] Starting subtest: cursor-random-128x42
[323.843841] Starting dynamic subtest: pipe-A-HDMI-A-1
[328.083950] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.238s)
[328.212178] Starting dynamic subtest: pipe-C-HDMI-A-1
[332.030295] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.867s)
[332.034309] Subtest cursor-random-128x42: SUCCESS (8.237s)
[332.432211] [110/155] (754s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[332.638980] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[333.453658] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (0.813s)
[333.770577] [111/155] (753s left) kms_content_protection (dp-mst-type-0-hdcp14)
[333.971149] Starting subtest: dp-mst-type-0-hdcp14
[333.979262] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[334.139126] [112/155] (752s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[334.328098] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[334.332267] Starting dynamic subtest: pipe-A-HDMI-A-1
[334.382500] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[334.440630] Starting dynamic subtest: pipe-A-HDMI-A-2
[334.480228] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[334.507607] Starting dynamic subtest: pipe-B-HDMI-A-1
[334.539125] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[334.564930] Starting dynamic subtest: pipe-B-HDMI-A-2
[334.597604] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[334.623218] Starting dynamic subtest: pipe-C-HDMI-A-1
[334.655492] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[334.681465] Starting dynamic subtest: pipe-C-HDMI-A-2
[334.712711] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[334.718913] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.032s)
[335.471148] [113/155] (751s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[335.668110] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[335.801624] [114/155] (751s left) syncobj_wait (invalid-signal-one-illegal-handle)
[335.914562] Starting subtest: invalid-signal-one-illegal-handle
[335.918504] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.001s)
[336.069374] [115/155] (751s left) kms_vblank (ts-continuation-dpms-suspend)
[336.258185] Starting subtest: ts-continuation-dpms-suspend
[336.261456] Starting dynamic subtest: pipe-A-HDMI-A-1