[88.370228] Initializing watchdogs
[88.370414]   /dev/watchdog0
[88.409753] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.424622] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.431787] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.437358] [001/133] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[88.647499] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[88.742739] [002/133] (960s left) syncobj_wait (wait-all-interrupted)
[88.845313] Starting subtest: wait-all-interrupted
[88.949069] Subtest wait-all-interrupted: SUCCESS (0.103s)
[89.084167] [003/133] (960s left) syncobj_wait (reset-unsignaled)
[89.183428] Starting subtest: reset-unsignaled
[89.186060] Subtest reset-unsignaled: SUCCESS (0.001s)
[89.305070] [004/133] (959s left) kms_busy (extended-modeset-hang-oldfb)
[89.501239] Starting subtest: extended-modeset-hang-oldfb
[89.503283] Starting dynamic subtest: pipe-A
[94.179841] Dynamic subtest pipe-A: SUCCESS (4.671s)
[94.198197] Starting dynamic subtest: pipe-C
[98.185202] Dynamic subtest pipe-C: SUCCESS (3.996s)
[98.187448] Subtest extended-modeset-hang-oldfb: SUCCESS (8.682s)
[98.525133] [005/133] (950s left) gem_exec_schedule (preemptive-hang)
[98.787068] Starting subtest: preemptive-hang
[98.788063] Starting dynamic subtest: rcs0
[105.099615] Dynamic subtest rcs0: SUCCESS (6.308s)
[105.126072] Starting dynamic subtest: bcs0
[111.123082] Dynamic subtest bcs0: SUCCESS (6.021s)
[111.153456] Starting dynamic subtest: vcs0
[117.130326] Dynamic subtest vcs0: SUCCESS (6.003s)
[117.160652] Starting dynamic subtest: vecs0
[123.096192] Dynamic subtest vecs0: SUCCESS (5.958s)
[123.102784] Subtest preemptive-hang: SUCCESS (24.294s)
[123.338195] [006/133] (925s left) gem_caching (read-writes)
[123.449900] Starting subtest: read-writes
[145.491027] Subtest read-writes: SUCCESS (22.039s)
[145.661249] [007/133] (903s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[145.866432] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[145.868585] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[146.007615] [008/133] (903s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[146.122300] Starting subtest: y-tiled-ccs-to-yf-tiled
[146.124078] Starting dynamic subtest: smem
[146.447290] Dynamic subtest smem: SUCCESS (0.323s)
[146.448618] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.323s)
[146.722910] [009/133] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[146.923882] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[146.927155] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[147.057569] [010/133] (902s left) kms_pwrite_crc
[148.509208] [011/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[148.713399] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[148.716122] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[148.839269] [012/133] (900s left) gem_exec_balancer (indices)
[148.968052] Starting subtest: indices
[153.327109] Subtest indices: SUCCESS (4.359s)
[153.593731] [013/133] (896s left) gem_create (create-ext-cpu-access-big)
[153.824963] Starting subtest: create-ext-cpu-access-big
[153.827320] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[153.961678] [014/133] (895s left) gem_eio (banned)
[154.102341] Starting subtest: banned
[154.261824] Subtest banned: SUCCESS (0.158s)
[154.519847] [015/133] (895s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[154.703303] Starting subtest: invalid-modeset-force-ultra-joiner
[154.706942] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[154.828490] [016/133] (895s left) device_reset (cold-reset-bound)
[154.971128] Starting subtest: cold-reset-bound
[154.973400] Subtest cold-reset-bound: SKIP (0.000s)
[155.094369] [017/133] (895s left) i915_hangman (engine-engine-error)
[155.222921] Starting subtest: engine-engine-error
[155.225899] Starting dynamic subtest: rcs0
[155.304524] Dynamic subtest rcs0: SUCCESS (0.083s)
[155.325463] Starting dynamic subtest: bcs0
[155.327142] Dynamic subtest bcs0: SKIP (0.006s)
[155.348953] Starting dynamic subtest: vcs0
[155.395862] Dynamic subtest vcs0: SUCCESS (0.077s)
[155.420246] Starting dynamic subtest: vecs0
[155.468061] Dynamic subtest vecs0: SUCCESS (0.073s)
[155.469074] Subtest engine-engine-error: SUCCESS (0.247s)
[155.625245] [018/133] (894s left) gem_spin_batch (engines)
[155.746482] Starting subtest: engines
[155.748995] Starting dynamic subtest: rcs0
[158.980077] Dynamic subtest rcs0: SUCCESS (3.231s)
[158.998343] Starting dynamic subtest: bcs0
[162.209794] Dynamic subtest bcs0: SUCCESS (3.229s)
[162.226819] Starting dynamic subtest: vcs0
[165.438768] Dynamic subtest vcs0: SUCCESS (3.228s)
[165.455714] Starting dynamic subtest: vecs0
[168.665988] Dynamic subtest vecs0: SUCCESS (3.229s)
[168.667054] Subtest engines: SUCCESS (12.921s)
[168.939494] [019/133] (881s left) prime_mmap (test_correct)
[169.042341] Starting subtest: test_correct
[169.043275] Starting dynamic subtest: test_correct-smem
[169.049762] Dynamic subtest test_correct-smem: SUCCESS (0.009s)
[169.053147] Subtest test_correct: SUCCESS (0.010s)
[169.193913] [020/133] (881s left) kms_pm_rpm (legacy-planes)
[171.109906] Starting subtest: legacy-planes
[171.110992] Starting dynamic subtest: plane-45
[172.599999] Dynamic subtest plane-45: SUCCESS (1.490s)
[172.619667] Starting dynamic subtest: plane-54
[174.177891] Dynamic subtest plane-54: SUCCESS (1.572s)
[174.199080] Starting dynamic subtest: plane-63
[175.863237] Dynamic subtest plane-63: SUCCESS (1.684s)
[175.864313] Subtest legacy-planes: SUCCESS (4.755s)
[176.229760] [021/133] (874s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[176.440117] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[176.444329] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[176.567865] [022/133] (874s left) kms_cursor_crc (cursor-onscreen-256x85)
[176.766084] Starting subtest: cursor-onscreen-256x85
[176.825066] Starting dynamic subtest: pipe-A-HDMI-A-1
[179.506654] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.679s)
[179.632253] Starting dynamic subtest: pipe-C-HDMI-A-1
[182.011061] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.416s)
[182.012102] Subtest cursor-onscreen-256x85: SUCCESS (5.241s)
[182.322665] [023/133] (868s left) sw_sync (alloc_fence_invalid_timeline)
[182.425137] Starting subtest: alloc_fence_invalid_timeline
[182.426347] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[182.534380] [024/133] (868s left) api_intel_allocator (two-level-inception)
[182.635054] Starting subtest: two-level-inception
[188.166113] Subtest two-level-inception: SUCCESS (5.535s)
[188.319282] [025/133] (862s left) kms_big_fb (linear-64bpp-rotate-180)
[188.516914] Starting subtest: linear-64bpp-rotate-180
[193.990347] Subtest linear-64bpp-rotate-180: SUCCESS (5.474s)
[194.519355] [026/133] (856s left) kms_chamelium_frames (hdmi-crc-single)
[195.134929] Subtest hdmi-crc-single: SKIP (0.000s)
[195.459342] [027/133] (855s left) kms_plane_scaling (invalid-num-scalers)
[195.645148] Starting subtest: invalid-num-scalers
[195.690144] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[195.810154] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.120s)
[195.893280] Starting dynamic subtest: pipe-A-HDMI-A-2-invalid-num-scalers
[195.991110] Dynamic subtest pipe-A-HDMI-A-2-invalid-num-scalers: SUCCESS (0.135s)
[196.078590] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[196.148416] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.104s)
[196.223330] Starting dynamic subtest: pipe-B-HDMI-A-2-invalid-num-scalers
[196.298107] Dynamic subtest pipe-B-HDMI-A-2-invalid-num-scalers: SUCCESS (0.111s)
[196.375411] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[196.525049] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.186s)
[196.610329] Starting dynamic subtest: pipe-C-HDMI-A-2-invalid-num-scalers
[196.789764] Dynamic subtest pipe-C-HDMI-A-2-invalid-num-scalers: SUCCESS (0.218s)
[196.793417] Subtest invalid-num-scalers: SUCCESS (1.145s)
[196.971755] [028/133] (854s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[197.159182] Starting subtest: primary-4-tiled-reflect-x-180
[197.168272] Subtest primary-4-tiled-reflect-x-180: SKIP (0.005s)
[197.297817] [029/133] (853s left) gen9_exec_parse (bb-start-cmd)
[197.427078] Starting subtest: bb-start-cmd
[197.433577] Subtest bb-start-cmd: SUCCESS (0.005s)
[197.687730] [030/133] (853s left) drm_read (short-buffer-block)
[198.131931] Starting subtest: short-buffer-block
[198.133199] Subtest short-buffer-block: SUCCESS (0.001s)
[198.387565] [031/133] (852s left) gem_exec_schedule (preempt-self)
[198.528885] Starting subtest: preempt-self
[198.531154] Starting dynamic subtest: rcs0
[198.561109] Dynamic subtest rcs0: SUCCESS (0.034s)
[198.609876] Starting dynamic subtest: bcs0
[198.612261] Dynamic subtest bcs0: SUCCESS (0.041s)
[198.650091] Starting dynamic subtest: vcs0
[198.652105] Dynamic subtest vcs0: SUCCESS (0.029s)
[198.688240] Starting dynamic subtest: vecs0
[198.690072] Dynamic subtest vecs0: SUCCESS (0.035s)
[198.691186] Subtest preempt-self: SUCCESS (0.155s)
[199.070778] [032/133] (852s left) gem_exec_params (no-vebox)
[199.182755] Starting subtest: no-vebox
[199.184340] Subtest no-vebox: SUCCESS (0.003s)
[199.350814] [033/133] (852s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[200.131380] Starting subtest: syncobj-timeline-invalid-flags
[200.132452] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.002s)
[200.397371] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[200.401633] [034/133] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[200.597730] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[200.601263] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[200.749338] [035/133] (850s left) gem_ctx_param (basic-default)
[200.852170] Starting subtest: basic-default
[200.856440] Subtest basic-default: SUCCESS (0.000s)
[201.027712] [036/133] (850s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[201.132458] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[201.137261] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.003s)
[201.282679] [037/133] (850s left) gem_pxp (reject-modify-context-protection-off-2)
[203.928532] Starting subtest: reject-modify-context-protection-off-2
[203.930319] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[204.065216] [038/133] (847s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[204.251218] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[204.257432] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[204.975333] [039/133] (847s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[205.157175] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[205.158116] Starting dynamic subtest: pipe-A-HDMI-A-1
[205.173070] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[205.216264] Starting dynamic subtest: pipe-A-HDMI-A-2
[205.256377] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[205.294184] Starting dynamic subtest: pipe-B-HDMI-A-1
[205.301924] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[205.320490] Starting dynamic subtest: pipe-B-HDMI-A-2
[205.328813] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[205.349425] Starting dynamic subtest: pipe-C-HDMI-A-1
[205.359286] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[205.378283] Starting dynamic subtest: pipe-C-HDMI-A-2
[205.386241] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[205.387842] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.035s)
[206.207829] [040/133] (845s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[206.401179] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[206.406326] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[206.554830] [041/133] (845s left) gem_gtt_cpu_tlb
[206.812779] [042/133] (845s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[207.022643] Starting subtest: y-tiled-8bpp-rotate-90
[207.365279] Subtest y-tiled-8bpp-rotate-90: SKIP (0.341s)
[207.609813] [043/133] (844s left) kms_pm_lpsp (screens-disabled)
[208.799629] Starting subtest: screens-disabled
[208.802264] Subtest screens-disabled: SKIP (0.001s)
[208.941694] [044/133] (843s left) gem_exec_reloc (basic-cpu-wc)
[209.067718] Starting subtest: basic-cpu-wc
[209.082132] Subtest basic-cpu-wc: SUCCESS (0.018s)
[209.309591] [045/133] (843s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[209.505116] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[211.903794] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (2.401s)
[212.191493] [046/133] (840s left) gem_ctx_create (basic)
[212.314014] Starting subtest: basic
[212.315179] Subtest basic: SUCCESS (0.000s)
[212.607357] [047/133] (840s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[212.718249] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[212.828142] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s)
[212.977095] [048/133] (839s left) kms_universal_plane (universal-plane-pageflip-windowed)
[213.165101] Starting subtest: universal-plane-pageflip-windowed
[213.166111] Starting dynamic subtest: pipe-A-HDMI-A-1
[214.052990] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.886s)
[214.105236] Starting dynamic subtest: pipe-B-HDMI-A-2
[214.589167] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.527s)
[214.621835] Starting dynamic subtest: pipe-C-HDMI-A-1
[215.178158] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.580s)
[215.180528] Subtest universal-plane-pageflip-windowed: SUCCESS (2.015s)
[215.540811] [049/133] (837s left) i915_suspend (basic-s3-without-i915)
[215.635305] Starting subtest: basic-s3-without-i915