[88.088939] Initializing watchdogs
[88.089281]   /dev/watchdog0
[88.128615] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.143540] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.151285] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.157284] [001/133] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[88.356922] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[88.452208] [002/133] (960s left) syncobj_wait (wait-all-interrupted)
[88.555131] Starting subtest: wait-all-interrupted
[88.661515] Subtest wait-all-interrupted: SUCCESS (0.105s)
[88.805836] [003/133] (960s left) syncobj_wait (reset-unsignaled)
[88.910821] Starting subtest: reset-unsignaled
[88.912499] Subtest reset-unsignaled: SUCCESS (0.000s)
[89.047290] [004/133] (959s left) kms_busy (extended-modeset-hang-oldfb)
[89.248699] Starting subtest: extended-modeset-hang-oldfb
[89.252996] Starting dynamic subtest: pipe-A
[94.170747] Dynamic subtest pipe-A: SUCCESS (4.920s)
[94.189526] Starting dynamic subtest: pipe-C
[98.172852] Dynamic subtest pipe-C: SUCCESS (3.991s)
[98.174714] Subtest extended-modeset-hang-oldfb: SUCCESS (8.925s)
[98.484878] [005/133] (950s left) gem_exec_schedule (preemptive-hang)
[98.760755] Starting subtest: preemptive-hang
[98.765758] Starting dynamic subtest: rcs0
[105.118752] Dynamic subtest rcs0: SUCCESS (6.346s)
[105.146310] Starting dynamic subtest: bcs0
[111.115641] Dynamic subtest bcs0: SUCCESS (6.006s)
[111.143294] Starting dynamic subtest: vcs0
[117.131462] Dynamic subtest vcs0: SUCCESS (6.015s)
[117.149590] Starting dynamic subtest: vecs0
[123.094601] Dynamic subtest vecs0: SUCCESS (5.957s)
[123.098053] Subtest preemptive-hang: SUCCESS (24.328s)
[123.355141] [006/133] (925s left) gem_caching (read-writes)
[123.471202] Starting subtest: read-writes
[145.589141] Subtest read-writes: SUCCESS (22.119s)
[145.762897] [007/133] (903s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[145.960290] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[145.964096] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[146.104904] [008/133] (903s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[146.225390] Starting subtest: y-tiled-ccs-to-yf-tiled
[146.228505] Starting dynamic subtest: smem
[146.552820] Dynamic subtest smem: SUCCESS (0.326s)
[146.555582] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.327s)
[146.792362] [009/133] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[146.992113] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[146.995617] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[147.120324] [010/133] (902s left) kms_pwrite_crc
[148.555925] [011/133] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[148.771208] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[148.775121] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[148.906807] [012/133] (900s left) gem_exec_balancer (indices)
[149.032828] Starting subtest: indices
[153.352221] Subtest indices: SUCCESS (4.321s)
[153.654102] [013/133] (896s left) gem_create (create-ext-cpu-access-big)
[153.878973] Starting subtest: create-ext-cpu-access-big
[153.882464] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[154.008079] [014/133] (895s left) gem_eio (banned)
[154.139075] Starting subtest: banned
[154.301839] Subtest banned: SUCCESS (0.159s)
[154.524379] [015/133] (895s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[154.712803] Starting subtest: invalid-modeset-force-ultra-joiner
[154.718409] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[154.840688] [016/133] (895s left) device_reset (cold-reset-bound)
[154.983436] Starting subtest: cold-reset-bound
[154.987315] Subtest cold-reset-bound: SKIP (0.000s)
[155.137757] [017/133] (894s left) i915_hangman (engine-engine-error)
[155.267616] Starting subtest: engine-engine-error
[155.270917] Starting dynamic subtest: rcs0
[155.346882] Dynamic subtest rcs0: SUCCESS (0.080s)
[155.378115] Starting dynamic subtest: bcs0
[155.384142] Dynamic subtest bcs0: SKIP (0.004s)
[155.405190] Starting dynamic subtest: vcs0
[155.423425] Dynamic subtest vcs0: SUCCESS (0.070s)
[155.446338] Starting dynamic subtest: vecs0
[155.495369] Dynamic subtest vecs0: SUCCESS (0.072s)
[155.498089] Subtest engine-engine-error: SUCCESS (0.230s)
[155.642793] [018/133] (894s left) gem_spin_batch (engines)
[155.765069] Starting subtest: engines
[155.767142] Starting dynamic subtest: rcs0
[159.003619] Dynamic subtest rcs0: SUCCESS (3.231s)
[159.022343] Starting dynamic subtest: bcs0
[162.229504] Dynamic subtest bcs0: SUCCESS (3.229s)
[162.248624] Starting dynamic subtest: vcs0
[165.458213] Dynamic subtest vcs0: SUCCESS (3.228s)
[165.477544] Starting dynamic subtest: vecs0
[168.687470] Dynamic subtest vecs0: SUCCESS (3.228s)
[168.689765] Subtest engines: SUCCESS (12.919s)
[168.941302] [019/133] (881s left) prime_mmap (test_correct)
[169.043688] Starting subtest: test_correct
[169.045180] Starting dynamic subtest: test_correct-smem
[169.051441] Dynamic subtest test_correct-smem: SUCCESS (0.009s)
[169.056526] Subtest test_correct: SUCCESS (0.011s)
[169.223932] [020/133] (881s left) kms_pm_rpm (legacy-planes)
[171.153612] Starting subtest: legacy-planes
[171.156290] Starting dynamic subtest: plane-45
[172.687108] Dynamic subtest plane-45: SUCCESS (1.533s)
[172.711076] Starting dynamic subtest: plane-54
[174.327574] Dynamic subtest plane-54: SUCCESS (1.638s)
[174.349833] Starting dynamic subtest: plane-63
[175.855248] Dynamic subtest plane-63: SUCCESS (1.526s)
[175.856421] Subtest legacy-planes: SUCCESS (4.703s)
[176.240421] [021/133] (874s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[176.450980] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[176.455366] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[176.618059] [022/133] (873s left) kms_cursor_crc (cursor-onscreen-256x85)
[176.824092] Starting subtest: cursor-onscreen-256x85
[176.889282] Starting dynamic subtest: pipe-A-HDMI-A-1
[179.571399] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.680s)
[179.685251] Starting dynamic subtest: pipe-C-HDMI-A-1
[182.091063] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.449s)
[182.093535] Subtest cursor-onscreen-256x85: SUCCESS (5.266s)
[182.421185] [023/133] (868s left) sw_sync (alloc_fence_invalid_timeline)
[182.524217] Starting subtest: alloc_fence_invalid_timeline
[182.527723] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[182.652303] [024/133] (867s left) api_intel_allocator (two-level-inception)
[182.756089] Starting subtest: two-level-inception
[188.283226] Subtest two-level-inception: SUCCESS (5.530s)
[188.421437] [025/133] (862s left) kms_big_fb (linear-64bpp-rotate-180)
[188.617085] Starting subtest: linear-64bpp-rotate-180
[194.180299] Subtest linear-64bpp-rotate-180: SUCCESS (5.563s)
[194.683048] [026/133] (856s left) kms_chamelium_frames (hdmi-crc-single)
[195.236054] Subtest hdmi-crc-single: SKIP (0.000s)
[195.507918] [027/133] (855s left) kms_plane_scaling (invalid-num-scalers)
[195.686079] Starting subtest: invalid-num-scalers
[195.719084] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[195.799889] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.081s)
[195.870727] Starting dynamic subtest: pipe-A-HDMI-A-2-invalid-num-scalers
[195.894985] Dynamic subtest pipe-A-HDMI-A-2-invalid-num-scalers: SUCCESS (0.067s)
[195.964051] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[195.990047] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.067s)
[196.061791] Starting dynamic subtest: pipe-B-HDMI-A-2-invalid-num-scalers
[196.088374] Dynamic subtest pipe-B-HDMI-A-2-invalid-num-scalers: SUCCESS (0.065s)
[196.148101] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[196.223226] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.111s)
[196.292257] Starting dynamic subtest: pipe-C-HDMI-A-2-invalid-num-scalers
[196.360689] Dynamic subtest pipe-C-HDMI-A-2-invalid-num-scalers: SUCCESS (0.110s)
[196.363096] Subtest invalid-num-scalers: SUCCESS (0.669s)
[196.528077] [028/133] (854s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[196.716101] Starting subtest: primary-4-tiled-reflect-x-180
[196.721305] Subtest primary-4-tiled-reflect-x-180: SKIP (0.004s)
[196.861946] [029/133] (854s left) gen9_exec_parse (bb-start-cmd)
[196.993222] Starting subtest: bb-start-cmd
[196.997112] Subtest bb-start-cmd: SUCCESS (0.006s)
[197.246225] [030/133] (853s left) drm_read (short-buffer-block)
[197.671087] Starting subtest: short-buffer-block
[197.673469] Subtest short-buffer-block: SUCCESS (0.000s)
[197.963402] [031/133] (853s left) gem_exec_schedule (preempt-self)
[198.105106] Starting subtest: preempt-self
[198.108704] Starting dynamic subtest: rcs0
[198.136756] Dynamic subtest rcs0: SUCCESS (0.029s)
[198.177114] Starting dynamic subtest: bcs0
[198.190730] Dynamic subtest bcs0: SUCCESS (0.049s)
[198.237986] Starting dynamic subtest: vcs0
[198.240073] Dynamic subtest vcs0: SUCCESS (0.027s)
[198.265112] Starting dynamic subtest: vecs0
[198.266635] Dynamic subtest vecs0: SUCCESS (0.029s)
[198.268217] Subtest preempt-self: SUCCESS (0.143s)
[198.628466] [032/133] (852s left) gem_exec_params (no-vebox)
[198.748238] Starting subtest: no-vebox
[198.751806] Subtest no-vebox: SUCCESS (0.003s)
[198.895184] [033/133] (852s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[199.700779] Starting subtest: syncobj-timeline-invalid-flags
[199.703469] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[199.969774] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[199.974976] [034/133] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[200.185629] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[200.188849] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[200.337592] [035/133] (851s left) gem_ctx_param (basic-default)
[200.444279] Starting subtest: basic-default
[200.446242] Subtest basic-default: SUCCESS (0.000s)
[200.589780] [036/133] (851s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[200.705196] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[200.708284] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.002s)
[200.856263] [037/133] (850s left) gem_pxp (reject-modify-context-protection-off-2)
[203.498397] Starting subtest: reject-modify-context-protection-off-2
[203.501591] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[203.639611] [038/133] (848s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[203.817257] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[203.825493] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[204.555323] [039/133] (847s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[204.750062] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[204.752219] Starting dynamic subtest: pipe-A-HDMI-A-1
[204.773062] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.004s)
[204.815471] Starting dynamic subtest: pipe-A-HDMI-A-2
[204.845437] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[204.888488] Starting dynamic subtest: pipe-B-HDMI-A-1
[204.920221] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[204.989433] Starting dynamic subtest: pipe-B-HDMI-A-2
[205.013746] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.004s)
[205.034562] Starting dynamic subtest: pipe-C-HDMI-A-1
[205.050973] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.004s)
[205.072310] Starting dynamic subtest: pipe-C-HDMI-A-2
[205.087996] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[205.091100] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.061s)
[205.974857] [040/133] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[206.184204] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[206.188228] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[206.346366] [041/133] (845s left) gem_gtt_cpu_tlb
[206.608888] [042/133] (845s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[206.818050] Starting subtest: y-tiled-8bpp-rotate-90
[207.198483] Subtest y-tiled-8bpp-rotate-90: SKIP (0.380s)
[207.481357] [043/133] (844s left) kms_pm_lpsp (screens-disabled)
[208.662909] Starting subtest: screens-disabled
[208.667083] Subtest screens-disabled: SKIP (0.000s)
[208.813508] [044/133] (843s left) gem_exec_reloc (basic-cpu-wc)
[208.927232] Starting subtest: basic-cpu-wc
[208.950930] Subtest basic-cpu-wc: SUCCESS (0.020s)
[209.161183] [045/133] (843s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[209.366276] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[211.752224] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (2.385s)
[212.062518] [046/133] (840s left) gem_ctx_create (basic)
[212.185790] Starting subtest: basic
[212.187438] Subtest basic: SUCCESS (0.000s)
[212.449578] [047/133] (840s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[212.551387] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[212.659869] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[212.814721] [048/133] (840s left) kms_universal_plane (universal-plane-pageflip-windowed)
[212.992055] Starting subtest: universal-plane-pageflip-windowed
[212.995282] Starting dynamic subtest: pipe-A-HDMI-A-1
[213.833881] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.840s)
[213.878084] Starting dynamic subtest: pipe-B-HDMI-A-2
[214.407819] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.566s)
[214.439214] Starting dynamic subtest: pipe-C-HDMI-A-1
[214.990306] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.573s)
[214.992571] Subtest universal-plane-pageflip-windowed: SUCCESS (2.001s)
[215.312551] [049/133] (837s left) i915_suspend (basic-s3-without-i915)
[215.413921] Starting subtest: basic-s3-without-i915