[87.101633] Initializing watchdogs
[87.101804]   /dev/watchdog0
[87.142608] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.157340] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.164662] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.172698] [001/133] (960s left) gem_exec_whisper (basic-contexts-forked-all)
[87.328445] Starting subtest: basic-contexts-forked-all
[100.051097] Subtest basic-contexts-forked-all: SUCCESS (12.720s)
[100.328651] [002/133] (947s left) kms_psr (pr-sprite-plane-move)
[100.524540] Subtest pr-sprite-plane-move: SKIP (0.000s)
[100.625881] [003/133] (947s left) gem_wait (write-wait)
[100.772367] Starting subtest: write-wait
[100.777509] Starting dynamic subtest: all-engines
[101.898820] Dynamic subtest all-engines: SUCCESS (1.123s)
[101.922602] Starting dynamic subtest: rcs0
[102.931036] Dynamic subtest rcs0: SUCCESS (1.033s)
[102.954352] Starting dynamic subtest: bcs0
[103.965315] Dynamic subtest bcs0: SUCCESS (1.034s)
[103.989902] Starting dynamic subtest: vcs0
[105.001453] Dynamic subtest vcs0: SUCCESS (1.036s)
[105.024899] Starting dynamic subtest: vecs0
[106.040352] Dynamic subtest vecs0: SUCCESS (1.036s)
[106.045266] Subtest write-wait: SUCCESS (5.268s)
[106.349096] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[106.358124] [004/133] (941s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[106.547496] Starting subtest: flip-vs-cursor-crc-atomic
[107.495492] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.952s)
[107.801571] [005/133] (940s left) i915_pm_rpm (gem-idle)
[109.726527] Starting subtest: gem-idle
[114.982843] Subtest gem-idle: SUCCESS (5.256s)
[115.340462] [006/133] (932s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[115.567175] Starting subtest: y-tiled-64bpp-rotate-180
[123.157230] Subtest y-tiled-64bpp-rotate-180: SUCCESS (7.589s)
[123.706698] [007/133] (924s left) kms_setmode (clone-exclusive-crtc)
[123.820523] Starting subtest: clone-exclusive-crtc
[124.292807] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[124.567062] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.274s)
[125.066156] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[125.346307] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.296s)
[125.796900] Subtest clone-exclusive-crtc: SUCCESS (1.978s)
[126.100365] [008/133] (922s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[126.322219] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[128.772930] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.458s)
[129.064639] [009/133] (919s left) i915_drm_fdinfo (virtual-busy)
[129.175988] Starting subtest: virtual-busy
[131.327476] Subtest virtual-busy: SUCCESS (2.148s)
[131.481760] [010/133] (917s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[131.668244] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[131.675134] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.000s)
[131.818605] [011/133] (916s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[132.003465] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[132.006730] Starting dynamic subtest: pipe-A-HDMI-A-1
[132.023626] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[132.065060] Starting dynamic subtest: pipe-A-HDMI-A-2
[132.082837] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[132.123327] Starting dynamic subtest: pipe-B-HDMI-A-1
[132.144107] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[132.166803] Starting dynamic subtest: pipe-B-HDMI-A-2
[132.179888] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[132.201459] Starting dynamic subtest: pipe-C-HDMI-A-1
[132.216471] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[132.240157] Starting dynamic subtest: pipe-C-HDMI-A-2
[132.256093] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[132.264133] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.019s)
[132.993600] [012/133] (915s left) syncobj_wait (invalid-reset-one-illegal-handle)
[133.113444] Starting subtest: invalid-reset-one-illegal-handle
[133.117595] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.001s)
[133.264201] [013/133] (915s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[133.452875] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[133.459669] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[133.597673] [014/133] (915s left) kms_pm_rpm (fences-dpms)
[135.531264] Starting subtest: fences-dpms
[138.469886] Subtest fences-dpms: SUCCESS (2.941s)
[138.748335] [015/133] (910s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[138.969391] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[139.207917] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.235s)
[139.464337] [016/133] (909s left) vgem_basic (bad-pad)
[139.592587] Starting subtest: bad-pad
[139.597140] Subtest bad-pad: SUCCESS (0.000s)
[139.718549] [017/133] (909s left) gem_ccs (ctrl-surf-copy-new-ctx)
[139.840391] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[139.953938] [018/133] (909s left) kms_async_flips (crc-atomic)
[140.133106] Starting subtest: crc-atomic
[140.745334] Starting dynamic subtest: pipe-A-HDMI-A-1
[142.992391] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.249s)
[143.360967] Starting dynamic subtest: pipe-A-HDMI-A-2
[145.580210] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.242s)
[145.944747] Starting dynamic subtest: pipe-B-HDMI-A-1
[148.169813] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.246s)
[148.517100] Starting dynamic subtest: pipe-B-HDMI-A-2
[150.730382] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.240s)
[151.076192] Starting dynamic subtest: pipe-C-HDMI-A-1
[153.306746] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.253s)
[153.653642] Starting dynamic subtest: pipe-C-HDMI-A-2
[155.871126] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.254s)
[155.874538] Subtest crc-atomic: SUCCESS (15.742s)
[156.491306] [019/133] (893s left) kms_chamelium_color (ctm-limited-range)
[156.688105] Subtest ctm-limited-range: SKIP (0.000s)
[156.803366] [020/133] (892s left) gem_exec_reloc (basic-cpu-read-noreloc)
[156.928282] Starting subtest: basic-cpu-read-noreloc
[156.938709] Subtest basic-cpu-read-noreloc: SUCCESS (0.009s)
[157.200625] [021/133] (892s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[157.401561] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[158.689515] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.291s)
[159.024618] [022/133] (890s left) syncobj_basic (bad-destroy)
[159.133476] Starting subtest: bad-destroy
[159.139794] Subtest bad-destroy: SUCCESS (0.000s)
[159.271559] [023/133] (890s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[159.481777] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[159.492088] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[164.063722] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (4.566s)
[164.086373] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[168.211294] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (4.146s)
[168.240759] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[172.426065] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (4.211s)
[172.431701] Subtest 2x-dpms-vs-vblank-race-interruptible: SUCCESS (12.942s)
[172.783135] [024/133] (877s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[172.991096] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[193.310601] Subtest flip-vs-cursor-atomic-transitions-varying-size: FAIL (19.259s)
[193.411395] [025/133] (856s left) gem_mmap_gtt (basic-read-write)
[193.529666] Starting subtest: basic-read-write
[193.533465] Subtest basic-read-write: SUCCESS (0.010s)
[193.679810] [026/133] (856s left) gem_linear_blits (basic)
[194.767457] Starting subtest: basic
[194.871622] Subtest basic: SUCCESS (0.012s)
[195.504850] [027/133] (855s left) kms_invalid_mode (zero-clock)
[195.866569] Starting subtest: zero-clock
[195.871385] Starting dynamic subtest: pipe-A-HDMI-A-1
[196.319128] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.453s)
[196.364483] Starting dynamic subtest: pipe-A-HDMI-A-2
[196.368839] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[196.410799] Starting dynamic subtest: pipe-B-HDMI-A-1
[196.413872] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[196.456807] Starting dynamic subtest: pipe-B-HDMI-A-2
[196.459725] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[196.485085] Starting dynamic subtest: pipe-C-HDMI-A-1
[196.488125] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[196.514234] Starting dynamic subtest: pipe-C-HDMI-A-2
[196.518175] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.003s)
[196.521920] Subtest zero-clock: SUCCESS (0.492s)
[196.658536] [028/133] (853s left) perf (sysctl-defaults)
[196.893268] Starting subtest: sysctl-defaults
[196.896784] Subtest sysctl-defaults: SUCCESS (0.001s)
[197.056642] [029/133] (853s left) gem_tiled_pread_pwrite
[197.740896] [030/133] (853s left) prime_mmap_coherency (write)
[198.021738] Starting subtest: write
[203.417235] Subtest write: SUCCESS (5.401s)
[203.589705] [031/133] (847s left) gem_exec_balancer (bonded-semaphore)
[203.717257] Starting subtest: bonded-semaphore
[207.913055] Subtest bonded-semaphore: SUCCESS (4.196s)
[208.200804] [032/133] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[208.420559] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[208.427921] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[208.574062] [033/133] (842s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[208.771534] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[209.955135] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.180s)
[210.275050] [034/133] (841s left) gem_ctx_param (invalid-param-set)
[210.391697] Starting subtest: invalid-param-set
[210.395216] Subtest invalid-param-set: SUCCESS (0.000s)
[210.538341] [035/133] (840s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[210.668299] Starting subtest: y-tiled-ccs-to-yf-tiled
[210.672320] Starting dynamic subtest: smem
[210.992517] Dynamic subtest smem: SUCCESS (0.322s)
[210.996603] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.325s)
[211.285651] [036/133] (840s left) kms_psr (fbc-pr-cursor-plane-onoff)
[211.484394] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[211.601370] [037/133] (839s left) kms_cursor_edge_walk (128x128-top-bottom)
[211.791083] Starting subtest: 128x128-top-bottom
[211.794190] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.711987] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.913s)
[215.742890] Starting dynamic subtest: pipe-C-HDMI-A-1
[219.135738] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.423s)
[219.139379] Subtest 128x128-top-bottom: SUCCESS (7.347s)
[219.437123] [038/133] (832s left) gem_ctx_persistence (legacy-engines-mixed-process)
[219.567761] Starting subtest: legacy-engines-mixed-process
[219.573052] Starting dynamic subtest: render
[219.994555] Dynamic subtest render: SUCCESS (0.420s)
[220.077116] Starting dynamic subtest: bsd
[220.362272] Dynamic subtest bsd: SUCCESS (0.371s)
[220.419142] Starting dynamic subtest: blt
[220.765959] Dynamic subtest blt: SUCCESS (0.391s)
[220.805957] Starting dynamic subtest: vebox
[221.155057] Dynamic subtest vebox: SUCCESS (0.378s)
[221.161193] Subtest legacy-engines-mixed-process: SUCCESS (1.589s)
[221.319280] [039/133] (830s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[221.540126] Starting subtest: 4-tiled-64bpp-rotate-270
[221.551135] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[221.684746] [040/133] (830s left) dmabuf_sync_file (export-multiwait)
[221.811258] Starting subtest: export-multiwait
[221.815135] Subtest export-multiwait: SUCCESS (0.002s)
[221.932176] [041/133] (830s left) gem_ctx_isolation (preservation)
[222.064231] Starting subtest: preservation
[222.068648] Starting dynamic subtest: rcs0
[222.455240] Dynamic subtest rcs0: SUCCESS (0.391s)
[222.484187] Starting dynamic subtest: bcs0
[223.110260] Dynamic subtest bcs0: SUCCESS (0.651s)
[223.142315] Starting dynamic subtest: vcs0
[223.508098] Dynamic subtest vcs0: SUCCESS (0.396s)
[223.535401] Starting dynamic subtest: vecs0
[223.898094] Dynamic subtest vecs0: SUCCESS (0.388s)
[223.901791] Subtest preservation: SUCCESS (1.837s)
[224.169169] [042/133] (827s left) kms_lease (lease-invalid-crtc)
[224.371591] Starting subtest: lease-invalid-crtc
[224.375672] Starting dynamic subtest: pipe-A-HDMI-A-1
[224.381105] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[224.423960] Starting dynamic subtest: pipe-A-HDMI-A-2
[224.427524] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.000s)
[224.451534] Starting dynamic subtest: pipe-B-HDMI-A-1
[224.454929] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[224.481425] Starting dynamic subtest: pipe-B-HDMI-A-2
[224.484908] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s)
[224.508498] Starting dynamic subtest: pipe-C-HDMI-A-1
[224.511951] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[224.536171] Starting dynamic subtest: pipe-C-HDMI-A-2
[224.539919] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.000s)
[224.544460] Subtest lease-invalid-crtc: SUCCESS (0.045s)
[224.644097] [043/133] (827s left) gem_mmap (big-bo)
[224.756518] Starting subtest: big-bo
[225.010118] Subtest big-bo: SUCCESS (0.260s)
[225.202548] [044/133] (827s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[225.591887] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[225.599089] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[225.735587] [045/133] (826s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[226.431203] Starting subtest: syncobj-timeline-invalid-wait
[226.435127] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[226.703878] [046/133] (825s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[226.836663] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[226.940876] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s)
[227.101105] [047/133] (825s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[227.211711] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[227.215360] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.002s)
[227.368997] [048/133] (825s left) gen9_exec_parse (bb-start-far)
[227.495292] Starting subtest: bb-start-far
[227.504289] Subtest bb-start-far: SUCCESS (0.005s)
[227.785117] [049/133] (825s left) gem_exec_params (cliprects-invalid)
[227.900125] Starting subtest: cliprects-invalid
[227.903565] Subtest cliprects-invalid: SUCCESS (0.001s)
[228.069943] [050/133] (824s left) perf_pmu (event-wait)
[228.189803] Starting subtest: event-wait
[228.193263] Starting dynamic subtest: rcs0
[228.201621] Dynamic subtest rcs0: SKIP (0.000s)
[228.210257] Subtest event-wait: SKIP (0.003s)
[228.353222] [051/133] (824s left) i915_suspend (forcewake)
[228.475092] Starting subtest: forcewake