[124.684228] Initializing watchdogs
[124.684455]   /dev/watchdog0
[124.726701] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[124.741717] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[124.749317] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[124.757348] [001/156] (960s left) gem_bad_reloc (negative-reloc)
[124.905456] Starting subtest: negative-reloc
[124.919375] Subtest negative-reloc: SUCCESS (0.003s)
[125.071951] [002/156] (960s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[125.301521] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[126.107486] Subtest fbchdr-rgb565-draw-mmap-wc: SUCCESS (0.805s)
[126.449444] [003/156] (958s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[126.666152] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[126.675332] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[126.830371] [004/156] (958s left) kms_chamelium_color (ctm-0-75)
[127.026089] Subtest ctm-0-75: SKIP (0.000s)
[127.131545] [005/156] (958s left) gem_exec_reloc (basic-cpu-active)
[127.265627] Starting subtest: basic-cpu-active
[127.409227] Subtest basic-cpu-active: SUCCESS (0.147s)
[127.634867] [006/156] (958s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[127.857527] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[129.283507] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SUCCESS (1.354s)
[129.664370] [007/156] (956s left) perf_pmu (semaphore-busy)
[129.801783] Starting subtest: semaphore-busy
[129.807093] Starting dynamic subtest: rcs0
[131.349418] Dynamic subtest rcs0: SUCCESS (1.549s)
[131.373342] Starting dynamic subtest: bcs0
[132.904824] Dynamic subtest bcs0: SUCCESS (1.551s)
[132.927864] Starting dynamic subtest: vcs0
[134.455844] Dynamic subtest vcs0: SUCCESS (1.549s)
[134.479905] Starting dynamic subtest: vecs0
[135.995536] Dynamic subtest vecs0: SUCCESS (1.540s)
[135.999121] Subtest semaphore-busy: SUCCESS (6.197s)
[136.140357] [008/156] (950s left) gem_exec_whisper (basic-fds-all)
[136.280397] Starting subtest: basic-fds-all
[150.145652] Subtest basic-fds-all: SUCCESS (13.863s)
[150.395893] [009/156] (935s left) gem_linear_blits (basic)
[151.070895] Starting subtest: basic
[151.087799] Subtest basic: SUCCESS (0.020s)
[151.262238] [010/156] (935s left) api_intel_allocator (standalone)
[151.520952] Starting subtest: standalone
[151.562733] Subtest standalone: SUCCESS (0.047s)
[151.715117] [011/156] (934s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[151.938073] Starting subtest: psrhdr-shrfb-scaledprimary
[151.945848] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[152.111268] [012/156] (934s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[152.318521] Starting subtest: psr-rgb101010-draw-pwrite
[152.327173] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[152.464361] [013/156] (934s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[152.678600] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[156.596388] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.920s)
[156.787729] [014/156] (929s left) kms_vblank (query-forked)
[156.989937] Starting subtest: query-forked
[156.993218] Starting dynamic subtest: pipe-A-HDMI-A-1
[159.680375] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.689s)
[159.726982] Starting dynamic subtest: pipe-A-HDMI-A-2
[162.175368] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.491s)
[162.213613] Starting dynamic subtest: pipe-C-HDMI-A-1
[164.662794] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.478s)
[164.697336] Starting dynamic subtest: pipe-C-HDMI-A-2
[167.128797] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.463s)
[167.133071] Subtest query-forked: SUCCESS (10.144s)
[167.466240] [015/156] (919s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[167.674506] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[168.519714] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (0.847s)
[168.820966] [016/156] (918s left) gem_madvise (dontneed-before-exec)
[168.934250] Starting subtest: dontneed-before-exec
[168.941253] Subtest dontneed-before-exec: SUCCESS (0.010s)
[169.087478] [017/156] (917s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[169.276279] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[169.284129] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[169.423824] [018/156] (917s left) gem_spin_batch (spin-all-new)
[169.559844] Starting subtest: spin-all-new
[169.586995] Subtest spin-all-new: SUCCESS (0.027s)
[169.864543] [019/156] (917s left) i915_pm_freq_api (freq-reset-multiple)
[169.994237] Subtest freq-reset-multiple: SKIP (0.000s)
[170.104809] [020/156] (917s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[170.298681] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[170.314692] Starting dynamic subtest: pipe-A
[170.873829] Dynamic subtest pipe-A: SUCCESS (0.580s)
[170.922499] Starting dynamic subtest: pipe-B
[171.300165] Dynamic subtest pipe-B: SUCCESS (0.429s)
[171.339857] Starting dynamic subtest: pipe-C
[171.390727] Dynamic subtest pipe-C: SUCCESS (0.086s)
[171.395133] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (1.097s)
[171.908721] [021/156] (915s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[172.104538] Starting subtest: 2x-long-flip-vs-cursor-atomic
[177.795934] Subtest 2x-long-flip-vs-cursor-atomic: SUCCESS (5.692s)
[178.141896] [022/156] (909s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[178.330099] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[178.335814] Starting dynamic subtest: pipe-A-valid-mode
[179.373761] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.036s)
[179.381356] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.040s)
[179.728772] [023/156] (907s left) gem_mmap_gtt (flink-race)
[179.849955] Starting subtest: flink-race
[199.901564] Subtest flink-race: SUCCESS (20.060s)
[200.059893] [024/156] (887s left) kms_vrr (negative-basic)
[200.250182] Starting subtest: negative-basic
[200.262289] Subtest negative-basic: SKIP (0.000s)
[200.397069] [025/156] (887s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[200.619500] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[200.627166] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[200.762657] [026/156] (887s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt)
[200.964987] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt
[200.974270] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[201.141125] [027/156] (886s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[201.337106] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[201.456266] [028/156] (886s left) gem_exec_reloc (basic-wc-read-noreloc)
[201.585920] Starting subtest: basic-wc-read-noreloc
[201.592570] Subtest basic-wc-read-noreloc: SUCCESS (0.008s)
[201.831786] [029/156] (886s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt)
[202.045549] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt
[202.957322] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SUCCESS (0.832s)
[203.538923] [030/156] (885s left) sysfs_timeslice_duration (duration)
[203.793550] Starting subtest: duration
[203.796955] Starting dynamic subtest: vecs0
[203.878095] Dynamic subtest vecs0: SUCCESS (0.082s)
[203.907086] Starting dynamic subtest: vcs0
[203.970096] Dynamic subtest vcs0: SUCCESS (0.089s)
[204.003594] Starting dynamic subtest: bcs0
[204.061712] Dynamic subtest bcs0: SUCCESS (0.089s)
[204.087961] Starting dynamic subtest: rcs0
[204.147836] Dynamic subtest rcs0: SUCCESS (0.084s)
[204.151762] Subtest duration: SUCCESS (0.357s)
[204.292116] [031/156] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[204.510979] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[204.518877] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[204.663854] [032/156] (884s left) kms_cursor_crc (cursor-onscreen-32x32)
[204.901193] Starting subtest: cursor-onscreen-32x32
[205.160493] Subtest cursor-onscreen-32x32: SKIP (0.251s)
[205.312619] [033/156] (883s left) gem_pxp (create-regular-context-1)
[207.977802] Starting subtest: create-regular-context-1
[207.985403] Subtest create-regular-context-1: SKIP (0.000s)
[208.108920] [034/156] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[208.299579] Starting subtest: bo-too-small-due-to-tiling
[208.304104] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[208.444878] [035/156] (880s left) kms_flip (dpms-vs-vblank-race)
[208.642677] Starting subtest: dpms-vs-vblank-race
[208.646165] Starting dynamic subtest: A-HDMI-A1
[211.570183] Dynamic subtest A-HDMI-A1: SUCCESS (2.918s)
[211.605298] Starting dynamic subtest: B-HDMI-A1
[214.015739] Dynamic subtest B-HDMI-A1: SUCCESS (2.438s)
[214.050491] Starting dynamic subtest: C-HDMI-A1
[216.474421] Dynamic subtest C-HDMI-A1: SUCCESS (2.350s)
[216.568471] Starting dynamic subtest: A-HDMI-A2
[218.844056] Dynamic subtest A-HDMI-A2: SUCCESS (2.468s)
[218.878789] Starting dynamic subtest: B-HDMI-A2
[221.244145] Dynamic subtest B-HDMI-A2: SUCCESS (2.400s)
[221.288531] Starting dynamic subtest: C-HDMI-A2
[223.668111] Dynamic subtest C-HDMI-A2: SUCCESS (2.417s)
[223.675199] Subtest dpms-vs-vblank-race: SUCCESS (15.025s)
[224.139235] [036/156] (865s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[224.372418] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[224.379953] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[224.527207] [037/156] (864s left) gem_exec_fence (syncobj-channel)
[225.195464] Starting subtest: syncobj-channel
[226.254779] Subtest syncobj-channel: SUCCESS (1.058s)
[226.675232] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[226.682769] [038/156] (862s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[226.889280] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[226.896904] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[227.055575] [039/156] (862s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[227.180473] Starting subtest: writes-after-reads-uncached
[248.059341] Subtest writes-after-reads-uncached: SUCCESS (20.877s)
[248.235611] [040/156] (841s left) syncobj_timeline (wait-for-submit-complex)
[248.346865] Starting subtest: wait-for-submit-complex
[248.414700] Subtest wait-for-submit-complex: SUCCESS (0.068s)
[248.568144] [041/156] (841s left) drm_read (short-buffer-block)
[249.286221] Starting subtest: short-buffer-block
[249.349929] Subtest short-buffer-block: SUCCESS (0.000s)
[249.870711] [042/156] (840s left) gem_exec_schedule (preemptive-hang)
[250.505707] Starting subtest: preemptive-hang
[250.509627] Starting dynamic subtest: rcs0
[256.088272] Dynamic subtest rcs0: SUCCESS (5.817s)
[256.116559] Starting dynamic subtest: bcs0
[262.100403] Dynamic subtest bcs0: SUCCESS (6.015s)
[262.133923] Starting dynamic subtest: vcs0
[268.114725] Dynamic subtest vcs0: SUCCESS (6.016s)
[268.150908] Starting dynamic subtest: vecs0
[274.132652] Dynamic subtest vecs0: SUCCESS (6.015s)
[274.138262] Subtest preemptive-hang: SUCCESS (23.876s)
[274.414947] [043/156] (815s left) kms_cursor_crc (cursor-sliding-128x128)
[274.632417] Starting subtest: cursor-sliding-128x128
[274.682060] Starting dynamic subtest: pipe-A-HDMI-A-1
[278.712562] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.028s)
[278.828636] Starting dynamic subtest: pipe-C-HDMI-A-1
[282.617478] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.732s)
[282.682107] Subtest cursor-sliding-128x128: SUCCESS (7.883s)
[283.264853] [044/156] (807s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[283.819618] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[283.946530] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[284.048442] [045/156] (806s left) gem_media_vme
[284.290771] [046/156] (806s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render)
[284.496338] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render
[285.732383] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SUCCESS (1.241s)
[285.943181] [047/156] (805s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[286.073613] Starting subtest: invalid-bsd1-flag-on-vebox
[286.077110] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.002s)
[286.244775] [048/156] (804s left) gem_mmap_gtt (basic-write-read-distinct)
[286.365061] Starting subtest: basic-write-read-distinct
[286.378684] Subtest basic-write-read-distinct: SUCCESS (0.014s)
[286.543453] [049/156] (804s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[286.759939] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[286.887353] [050/156] (804s left) kms_big_fb (linear-16bpp-rotate-90)
[287.115695] Starting subtest: linear-16bpp-rotate-90
[287.651967] Subtest linear-16bpp-rotate-90: SKIP (0.526s)
[287.927472] [051/156] (803s left) dmabuf_sync_file (export-wait-after-attach)
[288.057444] Starting subtest: export-wait-after-attach
[288.062356] Subtest export-wait-after-attach: SUCCESS (0.002s)
[288.201079] [052/156] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[288.421649] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[290.595041] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.166s)
[290.838493] [053/156] (800s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[291.048516] Starting subtest: yf-tiled-64bpp-rotate-270
[291.056687] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[291.212396] [054/156] (800s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[291.334513] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[291.434208] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[291.590953] [055/156] (800s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[291.799597] Starting subtest: hdr-rgb565-draw-pwrite
[292.882877] Subtest hdr-rgb565-draw-pwrite: SUCCESS (1.083s)
[293.212906] [056/156] (798s left) kms_psr (psr-primary-page-flip)
[293.423950] Subtest psr-primary-page-flip: SKIP (0.000s)
[293.550377] [057/156] (798s left) kms_psr (pr-no-drrs)
[293.745862] Subtest pr-no-drrs: SKIP (0.000s)
[293.875201] [058/156] (798s left) kms_psr (psr-basic)
[294.075101] Subtest psr-basic: SKIP (0.000s)
[294.210077] [059/156] (798s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[294.423481] Starting subtest: fb-8bpc-vs-panel-6bpc
[294.428643] Starting dynamic subtest: pipe-A-HDMI-A-1
[294.875998] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.442s)
[294.938438] Starting dynamic subtest: pipe-A-HDMI-A-2
[294.958887] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.010s)
[294.967541] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.477s)
[295.345743] [060/156] (797s left) gem_ctx_engines (execute-allforone)
[295.480995] Starting subtest: execute-allforone
[295.495478] Subtest execute-allforone: SUCCESS (0.015s)
[295.792566] [061/156] (796s left) gem_workarounds (suspend-resume-context)
[295.944638] Starting subtest: suspend-resume-context