[98.188340] Initializing watchdogs
[98.188532]   /dev/watchdog0
[98.230686] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[98.245741] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[98.252924] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[98.261330] [001/132] (960s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[98.392892] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[98.495037] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[98.642060] [002/132] (960s left) kms_sequence (queue-idle)
[98.827261] Starting subtest: queue-idle
[98.833324] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.615253] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.782s)
[101.638044] Starting dynamic subtest: pipe-A-HDMI-A-2
[104.131756] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.504s)
[104.162070] Starting dynamic subtest: pipe-B-HDMI-A-1
[106.613088] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.485s)
[106.639048] Starting dynamic subtest: pipe-B-HDMI-A-2
[109.096138] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.478s)
[109.129334] Starting dynamic subtest: pipe-C-HDMI-A-1
[111.577980] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.482s)
[111.598536] Starting dynamic subtest: pipe-C-HDMI-A-2
[114.031524] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.450s)
[114.037771] Subtest queue-idle: SUCCESS (15.204s)
[114.360934] [003/132] (944s left) gem_create (busy-create)
[114.494974] Starting subtest: busy-create
[114.499143] Starting dynamic subtest: smem0
[146.752766] Dynamic subtest smem0: SUCCESS (32.257s)
[146.756622] Subtest busy-create: SUCCESS (32.259s)
[147.010835] [004/132] (912s left) gem_exec_schedule (submit-golden-slice)
[147.156066] Starting subtest: submit-golden-slice
[147.159463] Starting dynamic subtest: rcs0
[147.213176] Dynamic subtest rcs0: SUCCESS (0.055s)
[147.239438] Starting dynamic subtest: bcs0
[147.262078] Dynamic subtest bcs0: SUCCESS (0.046s)
[147.282601] Starting dynamic subtest: vcs0
[147.311133] Dynamic subtest vcs0: SUCCESS (0.051s)
[147.340359] Starting dynamic subtest: vecs0
[147.353811] Dynamic subtest vecs0: SUCCESS (0.039s)
[147.357742] Subtest submit-golden-slice: SUCCESS (0.195s)
[147.743620] [005/132] (911s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[147.969128] Starting subtest: y-tiled-16bpp-rotate-180
[151.736464] Subtest y-tiled-16bpp-rotate-180: SUCCESS (3.770s)
[152.111184] [006/132] (907s left) gem_ctx_param (vm)
[152.224978] Starting subtest: vm
[152.283110] Subtest vm: SUCCESS (0.056s)
[152.443296] [007/132] (906s left) gem_sync (basic-all)
[152.601459] Starting subtest: basic-all
[155.117461] Subtest basic-all: SUCCESS (2.535s)
[155.415456] [008/132] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[155.626109] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[158.087162] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.470s)
[158.361492] [009/132] (901s left) kms_atomic_transition (modeset-transition-nonblocking)
[158.555344] Starting subtest: modeset-transition-nonblocking
[158.560067] Starting dynamic subtest: 1x-outputs
[162.075082] Dynamic subtest 1x-outputs: SUCCESS (3.525s)
[162.098088] Starting dynamic subtest: 2x-outputs
[169.444863] Dynamic subtest 2x-outputs: SUCCESS (7.369s)
[169.449263] Subtest modeset-transition-nonblocking: SUCCESS (10.895s)
[169.791844] [010/132] (889s left) kms_psr (pr-dpms)
[169.994080] Subtest pr-dpms: SKIP (0.000s)
[170.101588] [011/132] (889s left) prime_mmap (test_reprime)
[170.218590] Starting subtest: test_reprime
[170.223067] Starting dynamic subtest: test_reprime-smem
[170.226565] Dynamic subtest test_reprime-smem: SUCCESS (0.009s)
[170.230050] Subtest test_reprime: SUCCESS (0.010s)
[170.374311] [012/132] (889s left) kms_pm_dc (dc5-retention-flops)
[171.570163] Starting subtest: dc5-retention-flops
[171.577435] Subtest dc5-retention-flops: SKIP (0.000s)
[171.726031] [013/132] (888s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[171.855055] Starting subtest: yf-tiled-ccs-to-x-tiled
[171.858723] Starting dynamic subtest: smem
[172.096921] Dynamic subtest smem: SUCCESS (0.240s)
[172.100744] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.241s)
[172.343784] [014/132] (887s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[172.549879] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[172.559479] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[172.690589] [015/132] (887s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[172.883794] Starting subtest: cursorA-vs-flipA-toggle
[184.294660] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.306s)
[184.920618] [016/132] (875s left) kms_atomic_transition (plane-all-transition-fencing)
[185.415909] Starting subtest: plane-all-transition-fencing
[185.486213] Starting dynamic subtest: pipe-A-HDMI-A-1
[190.008384] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.750s)
[190.303340] Starting dynamic subtest: pipe-A-HDMI-A-2
[195.423614] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (5.161s)
[195.710155] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.780384] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.104s)
[201.051283] Starting dynamic subtest: pipe-B-HDMI-A-2
[206.466757] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (5.440s)
[206.728704] Subtest plane-all-transition-fencing: SUCCESS (21.467s)
[207.092197] [017/132] (853s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[207.347587] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[207.361396] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.005s)
[207.500658] [018/132] (853s left) gem_gtt_cpu_tlb
[207.774063] [019/132] (853s left) gem_exec_reloc (basic-gtt-wc-active)
[207.950411] Starting subtest: basic-gtt-wc-active
[208.080441] Subtest basic-gtt-wc-active: SUCCESS (0.133s)
[208.309720] [020/132] (852s left) kms_psr (fbc-psr2-suspend)
[208.508112] Subtest fbc-psr2-suspend: SKIP (0.000s)
[208.612850] [021/132] (852s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[208.820556] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[208.828284] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[208.970078] [022/132] (852s left) kms_vblank (ts-continuation-idle-hang)
[209.174318] Starting subtest: ts-continuation-idle-hang
[209.177504] Starting dynamic subtest: pipe-A-HDMI-A-1
[216.876432] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.687s)
[216.915497] Starting dynamic subtest: pipe-A-HDMI-A-2
[223.891189] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.014s)
[223.941411] Starting dynamic subtest: pipe-C-HDMI-A-1
[230.854827] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.943s)
[230.883046] Starting dynamic subtest: pipe-C-HDMI-A-2
[237.919781] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.054s)
[237.924668] Subtest ts-continuation-idle-hang: SUCCESS (28.743s)
[238.264063] [023/132] (822s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[238.457099] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[238.464851] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[238.596165] [024/132] (822s left) core_debugfs (read-all-entries)
[238.710696] Starting subtest: read-all-entries
[238.786739] Subtest read-all-entries: SUCCESS (0.078s)
[238.928264] [025/132] (822s left) sysfs_timeslice_duration (timeout)
[239.047894] Starting subtest: timeout
[239.051465] Starting dynamic subtest: vecs0
[239.907400] Dynamic subtest vecs0: SUCCESS (0.855s)
[239.930848] Starting dynamic subtest: vcs0
[240.750133] Dynamic subtest vcs0: SUCCESS (0.840s)
[240.775824] Starting dynamic subtest: bcs0
[241.607543] Dynamic subtest bcs0: SUCCESS (0.855s)
[241.633370] Starting dynamic subtest: rcs0
[242.476738] Dynamic subtest rcs0: SUCCESS (0.862s)
[242.480801] Subtest timeout: SUCCESS (3.428s)
[242.610388] [026/132] (818s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[242.800090] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[242.804433] Starting dynamic subtest: pipe-A
[243.151950] Dynamic subtest pipe-A: SUCCESS (0.352s)
[243.193157] Starting dynamic subtest: pipe-B
[243.560678] Dynamic subtest pipe-B: SUCCESS (0.405s)
[243.599098] Starting dynamic subtest: pipe-C
[243.651064] Dynamic subtest pipe-C: SUCCESS (0.086s)
[243.656844] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.853s)
[244.153424] [027/132] (817s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[244.364217] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[244.373117] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[244.505776] [028/132] (817s left) sw_sync (alloc_timeline)
[244.614086] Starting subtest: alloc_timeline
[244.617942] Subtest alloc_timeline: SUCCESS (0.001s)
[244.736890] [029/132] (817s left) gem_exec_schedule (pi-common)
[245.017305] Starting subtest: pi-common
[245.022888] Starting dynamic subtest: rcs0
[245.190853] Dynamic subtest rcs0: SUCCESS (0.166s)
[245.211628] Starting dynamic subtest: bcs0
[245.233069] Dynamic subtest bcs0: SUCCESS (0.052s)
[245.258110] Starting dynamic subtest: vcs0
[245.286088] Dynamic subtest vcs0: SUCCESS (0.050s)
[245.313529] Starting dynamic subtest: vecs0
[245.338160] Dynamic subtest vecs0: SUCCESS (0.049s)
[245.342369] Subtest pi-common: SUCCESS (0.329s)
[245.609475] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[245.616934] [030/132] (816s left) gem_softpin (allocator-nopin-reserve)
[245.741380] Starting subtest: allocator-nopin-reserve
[245.983505] Subtest allocator-nopin-reserve: SUCCESS (0.245s)
[246.165295] [031/132] (815s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[246.372675] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[246.380249] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[246.530196] [032/132] (815s left) prime_vgem (basic-read)
[246.666184] Starting subtest: basic-read
[246.729585] Subtest basic-read: SUCCESS (0.065s)
[246.896435] [033/132] (815s left) syncobj_timeline (wait-all-snapshot)
[247.040965] Starting subtest: wait-all-snapshot
[247.099078] Subtest wait-all-snapshot: SUCCESS (0.086s)
[247.247437] [034/132] (815s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[247.365533] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[247.470378] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.110s)
[247.630776] [035/132] (814s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[247.853349] Starting subtest: fbc-rgb101010-draw-render
[250.858497] Subtest fbc-rgb101010-draw-render: SUCCESS (3.011s)
[251.198186] [036/132] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[251.420096] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[254.760490] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.344s)
[255.102305] [037/132] (807s left) core_setmaster_vs_auth
[255.390563] [038/132] (807s left) i915_hangman (gt-engine-error)
[255.530232] Starting subtest: gt-engine-error
[255.535436] Starting dynamic subtest: rcs0
[255.607122] Dynamic subtest rcs0: SUCCESS (0.076s)
[255.635251] Starting dynamic subtest: bcs0
[255.643871] Dynamic subtest bcs0: SKIP (0.003s)
[255.678127] Starting dynamic subtest: vcs0
[255.684100] Dynamic subtest vcs0: SUCCESS (0.066s)
[255.706801] Starting dynamic subtest: vecs0
[255.766174] Dynamic subtest vecs0: SUCCESS (0.079s)
[255.769727] Subtest gt-engine-error: SUCCESS (0.240s)
[255.947212] [039/132] (806s left) gem_mmap_gtt (basic-write)
[256.064244] Starting subtest: basic-write
[256.467462] Subtest basic-write: SUCCESS (0.397s)
[256.615189] [040/132] (806s left) gen7_exec_parse (basic-allowed)
[256.742053] Subtest basic-allowed: SKIP (0.000s)
[256.870910] [041/132] (806s left) gem_lmem_swapping (verify-ccs)
[256.993306] Subtest verify-ccs: SKIP (0.000s)
[257.119085] [042/132] (806s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[257.710117] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[258.046554] [043/132] (805s left) gem_mmap_gtt (ptrace)
[258.174052] Starting subtest: ptrace
[258.391226] Subtest ptrace: SUCCESS (0.223s)
[258.559338] [044/132] (804s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[258.763042] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[258.885938] [045/132] (804s left) gen7_exec_parse (bitmasks)
[259.018393] Subtest bitmasks: SKIP (0.000s)
[259.135438] [046/132] (804s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[259.341215] Starting subtest: x-tiled-16bpp-rotate-270
[259.761366] Subtest x-tiled-16bpp-rotate-270: SKIP (0.412s)
[260.083914] [047/132] (803s left) gem_lmem_swapping (parallel-random-engines)
[260.208231] Subtest parallel-random-engines: SKIP (0.000s)
[260.330388] [048/132] (803s left) gem_mmap_gtt (basic-small-copy-odd)
[260.446912] Starting subtest: basic-small-copy-odd
[263.455071] Subtest basic-small-copy-odd: SUCCESS (3.012s)
[263.617174] [049/132] (800s left) kms_async_flips (async-flip-suspend-resume)
[263.992737] Starting subtest: async-flip-suspend-resume
[264.617037] Starting dynamic subtest: pipe-A-HDMI-A-1
[282.888164] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.217s)
[283.383953] Starting dynamic subtest: pipe-A-HDMI-A-2