[91.947764] Initializing watchdogs
[91.947943]   /dev/watchdog0
[91.987060] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[92.001682] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[92.008826] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[92.014789] [001/134] (960s left) kms_psr (fbc-psr-primary-blt)
[92.211204] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[92.302305] [002/134] (960s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[92.488174] Starting subtest: cursorB-vs-flipB-legacy
[103.846141] Subtest cursorB-vs-flipB-legacy: SUCCESS (11.365s)
[104.149881] [003/134] (948s left) kms_addfb_basic (master-rmfb)
[104.260125] Starting subtest: master-rmfb
[104.261734] Subtest master-rmfb: SUCCESS (0.002s)
[104.498033] [004/134] (948s left) kms_lease (implicit-plane-lease)
[104.676182] Starting subtest: implicit-plane-lease
[104.681301] Subtest implicit-plane-lease: SUCCESS (0.010s)
[104.818471] [005/134] (948s left) core_setmaster (master-drop-set-user)
[105.012178] Starting subtest: master-drop-set-user
[105.053251] Subtest master-drop-set-user: SUCCESS (0.046s)
[105.135688] [006/134] (947s left) gem_create (create-ext-placement-each)
[105.357493] Starting subtest: create-ext-placement-each
[105.362823] Subtest create-ext-placement-each: SUCCESS (0.000s)
[105.502820] [007/134] (947s left) kms_content_protection (dp-mst-type-0)
[105.686048] Starting subtest: dp-mst-type-0
[105.690078] Subtest dp-mst-type-0: SKIP (0.000s)
[105.817813] [008/134] (947s left) kms_prop_blob (blob-multiple)
[105.916889] Starting subtest: blob-multiple
[105.921914] Subtest blob-multiple: SUCCESS (0.005s)
[106.083250] [009/134] (947s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[106.186210] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[106.189217] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.003s)
[106.334168] [010/134] (946s left) kms_cursor_legacy (forked-move)
[106.516057] Starting subtest: forked-move
[106.518110] Starting dynamic subtest: pipe-A
[111.925032] Dynamic subtest pipe-A: SUCCESS (5.411s)
[111.951053] Starting dynamic subtest: pipe-B
[117.354516] Dynamic subtest pipe-B: SUCCESS (5.430s)
[117.379064] Starting dynamic subtest: pipe-C
[122.785567] Dynamic subtest pipe-C: SUCCESS (5.430s)
[122.809073] Starting dynamic subtest: all-pipes
[128.209184] Dynamic subtest all-pipes: SUCCESS (5.420s)
[128.210928] Subtest forked-move: SUCCESS (21.696s)
[128.338975] [011/134] (925s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[128.440796] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[128.548132] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[128.684922] [012/134] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[128.884176] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[128.888477] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[129.017917] [013/134] (924s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[129.216417] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[129.221361] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[129.350877] [014/134] (924s left) gem_partial_pwrite_pread (reads)
[129.473156] Starting subtest: reads
[135.689789] Subtest reads: SUCCESS (6.218s)
[135.869288] [015/134] (917s left) gem_exec_fence (submit3)
[136.136148] Starting subtest: submit3
[136.139149] Starting dynamic subtest: rcs0
[136.153395] Dynamic subtest rcs0: SUCCESS (0.016s)
[136.191232] Starting dynamic subtest: bcs0
[136.193791] Dynamic subtest bcs0: SUCCESS (0.016s)
[136.214098] Starting dynamic subtest: vcs0
[136.216816] Dynamic subtest vcs0: SUCCESS (0.010s)
[136.235647] Starting dynamic subtest: vecs0
[136.238098] Dynamic subtest vecs0: SUCCESS (0.024s)
[136.240772] Subtest submit3: SUCCESS (0.072s)
[136.960467] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[136.965206] [016/134] (916s left) perf (invalid-oa-format-id)
[137.173254] Starting subtest: invalid-oa-format-id
[137.199276] Subtest invalid-oa-format-id: SUCCESS (0.025s)
[137.310244] [017/134] (916s left) kms_force_connector_basic (force-edid)
[137.560078] Starting subtest: force-edid
[137.734746] Subtest force-edid: SUCCESS (0.175s)
[138.080830] [018/134] (915s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[138.289388] Starting subtest: psr-rgb101010-draw-blt
[138.293226] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[138.445099] [019/134] (915s left) i915_drm_fdinfo (virtual-busy-idle)
[138.557335] Starting subtest: virtual-busy-idle
[141.109979] Subtest virtual-busy-idle: SUCCESS (2.553s)
[141.247389] [020/134] (912s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[141.422990] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[141.426476] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[141.562853] [021/134] (912s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[142.165092] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[142.498795] [022/134] (911s left) gem_userptr_blits (unsync-overlap)
[142.618784] Subtest unsync-overlap: SKIP (0.000s)
[142.809190] [023/134] (911s left) prime_vgem (wait)
[142.942732] Starting subtest: wait
[142.944415] Starting dynamic subtest: rcs0
[142.961368] Dynamic subtest rcs0: SUCCESS (0.017s)
[142.995063] Starting dynamic subtest: vcs0
[142.997148] Dynamic subtest vcs0: SUCCESS (0.019s)
[143.020735] Starting dynamic subtest: vecs0
[143.023347] Dynamic subtest vecs0: SUCCESS (0.019s)
[143.025120] Subtest wait: SUCCESS (0.058s)
[143.156166] [024/134] (911s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[145.070435] Starting subtest: modeset-lpsp-stress-no-wait
[145.309033] Subtest modeset-lpsp-stress-no-wait: SKIP (0.236s)
[145.596860] [025/134] (909s left) gem_exec_schedule (u-submit-golden-slice)
[145.745496] Starting subtest: u-submit-golden-slice
[145.747137] Starting dynamic subtest: rcs0
[145.791344] Dynamic subtest rcs0: SUCCESS (0.044s)
[145.823326] Starting dynamic subtest: bcs0
[145.850819] Dynamic subtest bcs0: SUCCESS (0.056s)
[145.882301] Starting dynamic subtest: vcs0
[145.888722] Dynamic subtest vcs0: SUCCESS (0.039s)
[145.918545] Starting dynamic subtest: vecs0
[145.929294] Dynamic subtest vecs0: SUCCESS (0.039s)
[145.932589] Subtest u-submit-golden-slice: SUCCESS (0.183s)
[146.318307] [026/134] (908s left) gem_mmap_wc (bad-size)
[146.420502] Starting subtest: bad-size
[146.425087] Subtest bad-size: SUCCESS (0.004s)
[146.565300] [027/134] (908s left) gem_ctx_persistence (engines-persistence)
[146.678068] Starting subtest: engines-persistence
[146.681112] Starting dynamic subtest: rcs0
[147.456115] Dynamic subtest rcs0: SUCCESS (0.776s)
[147.477602] Starting dynamic subtest: bcs0
[148.224271] Dynamic subtest bcs0: SUCCESS (0.769s)
[148.244065] Starting dynamic subtest: vcs0
[148.991126] Dynamic subtest vcs0: SUCCESS (0.762s)
[149.014833] Starting dynamic subtest: vecs0
[149.757593] Dynamic subtest vecs0: SUCCESS (0.768s)
[149.759997] Subtest engines-persistence: SUCCESS (3.082s)
[149.899308] [028/134] (905s left) gem_ctx_bad_destroy (invalid-default-ctx)
[150.003224] Starting subtest: invalid-default-ctx
[150.005159] Subtest invalid-default-ctx: SUCCESS (0.000s)
[150.147341] [029/134] (904s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[150.326836] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[150.332680] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[151.054255] [030/134] (904s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[151.245406] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[151.248945] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[151.387784] [031/134] (903s left) gem_sync (basic-each)
[151.519187] Starting subtest: basic-each
[153.961117] Subtest basic-each: SUCCESS (2.447s)
[154.223997] [032/134] (901s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[154.480324] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[157.229646] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.747s)
[157.537963] [033/134] (897s left) perf (gen12-group-exclusive-stream-ctx-handle)
[157.751213] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[157.754397] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s)
[157.859543] [034/134] (897s left) prime_vgem (fence-read-hang)
[157.983490] Subtest fence-read-hang: SKIP (0.000s)
[158.139322] [035/134] (897s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[158.316079] Starting subtest: cursorB-vs-flipB-atomic
[169.583084] Subtest cursorB-vs-flipB-atomic: SUCCESS (11.268s)
[169.879981] [036/134] (885s left) gen7_exec_parse (oacontrol-tracking)
[169.996288] Subtest oacontrol-tracking: SKIP (0.000s)
[170.102280] [037/134] (885s left) kms_cursor_crc (cursor-random-32x32)
[170.281750] Starting subtest: cursor-random-32x32
[170.441668] Subtest cursor-random-32x32: SKIP (0.156s)
[170.597148] [038/134] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[170.811660] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[170.818122] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[170.962109] [039/134] (884s left) prime_vgem (basic-fence-flip)
[171.090084] Starting subtest: basic-fence-flip
[171.569801] Subtest basic-fence-flip: SUCCESS (0.478s)
[171.731776] [040/134] (884s left) syncobj_basic (bad-handle-to-fd)
[171.834210] Starting subtest: bad-handle-to-fd
[171.835904] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[171.978767] [041/134] (884s left) gem_softpin (evict-single-offset)
[172.094074] Starting subtest: evict-single-offset
[206.969741] Subtest evict-single-offset: SUCCESS (34.876s)
[207.120645] [042/134] (849s left) kms_frontbuffer_tracking (fbc-1p-rte)
[207.432131] Starting subtest: fbc-1p-rte
[211.084455] Subtest fbc-1p-rte: SUCCESS (3.661s)
[211.396255] [043/134] (844s left) gem_exec_schedule (preempt-hang)
[211.665818] Starting subtest: preempt-hang
[211.667442] Starting dynamic subtest: rcs0
[211.934845] Dynamic subtest rcs0: SUCCESS (0.269s)
[211.961790] Starting dynamic subtest: bcs0
[212.227342] Dynamic subtest bcs0: SUCCESS (0.283s)
[212.255983] Starting dynamic subtest: vcs0
[212.480682] Dynamic subtest vcs0: SUCCESS (0.249s)
[212.505112] Starting dynamic subtest: vecs0
[212.730286] Dynamic subtest vecs0: SUCCESS (0.245s)
[212.732979] Subtest preempt-hang: SUCCESS (1.051s)
[213.001726] [044/134] (843s left) kms_usb4_switch (dock-undock)
[213.193087] Subtest dock-undock: SKIP (0.000s)
[213.287135] [045/134] (843s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[213.469918] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[213.474058] Starting dynamic subtest: pipe-A
[213.800822] Dynamic subtest pipe-A: SUCCESS (0.330s)
[213.842200] Starting dynamic subtest: pipe-B
[214.197220] Dynamic subtest pipe-B: SUCCESS (0.395s)
[214.241828] Starting dynamic subtest: pipe-C
[214.258123] Dynamic subtest pipe-C: SUCCESS (0.054s)
[214.261209] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.782s)
[214.741990] [046/134] (841s left) kms_cursor_crc (cursor-offscreen-128x42)
[214.949119] Starting subtest: cursor-offscreen-128x42
[214.991918] Starting dynamic subtest: pipe-A-HDMI-A-1
[217.880950] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.888s)
[218.001280] Starting dynamic subtest: pipe-C-HDMI-A-1
[220.553508] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.598s)
[220.556451] Subtest cursor-offscreen-128x42: SUCCESS (5.605s)
[220.914255] [047/134] (835s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[221.022102] Starting subtest: single-wait-all-for-submit-unsubmitted
[221.129662] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[221.280519] [048/134] (835s left) vgem_basic (bad-handle)
[221.404804] Starting subtest: bad-handle
[221.407559] Subtest bad-handle: SUCCESS (0.000s)
[221.529650] [049/134] (835s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[221.733432] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[224.580063] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.847s)
[224.858382] [050/134] (832s left) gen3_mixed_blits
[225.081253] [051/134] (832s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[225.272201] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[225.276763] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s)
[225.426376] [052/134] (831s left) gem_exec_parallel (engines)
[225.559643] Starting subtest: engines
[225.563138] Starting dynamic subtest: basic
[228.873068] Dynamic subtest basic: SUCCESS (3.315s)
[228.896027] Starting dynamic subtest: contexts
[233.430208] Dynamic subtest contexts: SUCCESS (4.557s)
[233.451978] Starting dynamic subtest: fds
[242.342109] Dynamic subtest fds: SUCCESS (8.908s)
[242.368115] Starting dynamic subtest: userptr
[245.674432] Dynamic subtest userptr: SUCCESS (3.330s)
[245.676856] Subtest engines: SUCCESS (20.119s)
[245.956410] [053/134] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[246.158247] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[246.162236] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[246.312270] [054/134] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[246.514285] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[249.619620] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.099s)
[249.928576] [055/134] (807s left) kms_big_fb (linear-8bpp-rotate-180)
[250.145133] Starting subtest: linear-8bpp-rotate-180
[254.098058] Subtest linear-8bpp-rotate-180: SUCCESS (3.950s)
[254.393473] [056/134] (803s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[254.605348] Starting subtest: 4-tiled-32bpp-rotate-0
[254.610074] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[254.745500] [057/134] (802s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[254.938718] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[254.944076] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[265.970756] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.025s)
[265.999990] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[276.963900] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.986s)
[276.994468] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[287.938330] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.962s)
[287.943789] Subtest 2x-wf_vblank-ts-check-interruptible: SUCCESS (32.995s)
[288.630499] [058/134] (769s left) kms_plane (pixel-format-4-tiled-modifier)
[288.817406] Starting subtest: pixel-format-4-tiled-modifier
[288.820852] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s)
[288.962606] [059/134] (768s left) gem_exec_params (batch-first)
[289.076356] Starting subtest: batch-first
[289.088293] Subtest batch-first: SUCCESS (0.012s)
[289.262376] [060/134] (768s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[289.442063] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[289.445319] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[290.157433] [061/134] (767s left) gem_lmem_swapping (basic)
[290.281079] Subtest basic: SKIP (0.000s)
[290.396102] [062/134] (767s left) i915_pm_rpm (gem-execbuf-stress)
[292.273616] Starting subtest: gem-execbuf-stress
[292.276159] Starting dynamic subtest: smem0
[294.959052] Dynamic subtest smem0: SUCCESS (2.687s)
[294.987059] Starting dynamic subtest: extra-wait-smem0
[347.626818] Dynamic subtest extra-wait-smem0: SUCCESS (52.664s)
[347.628519] Subtest gem-execbuf-stress: SUCCESS (55.359s)
[348.016629] [063/134] (710s left) kms_cursor_edge_walk (256x256-left-edge)
[348.198978] Starting subtest: 256x256-left-edge
[348.203450] Starting dynamic subtest: pipe-A-HDMI-A-1
[352.093771] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.890s)
[352.137682] Starting dynamic subtest: pipe-C-HDMI-A-1
[355.536290] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.437s)
[355.541070] Subtest 256x256-left-edge: SUCCESS (7.338s)
[355.826408] [064/134] (702s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[356.408430] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[356.710238] [065/134] (701s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[356.906563] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[357.028457] [066/134] (701s left) kms_psr (fbc-psr2-primary-page-flip)
[357.227062] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[357.334575] [067/134] (701s left) gem_partial_pwrite_pread (write-snoop)
[357.453544] Starting subtest: write-snoop
[371.624769] Subtest write-snoop: SUCCESS (14.175s)
[371.794523] [068/134] (686s left) gem_exec_async (concurrent-writes)
[371.923107] Starting subtest: concurrent-writes
[371.924999] Starting dynamic subtest: rcs0
[371.939656] Dynamic subtest rcs0: SUCCESS (0.017s)
[371.991770] Starting dynamic subtest: bcs0
[371.994239] Dynamic subtest bcs0: SUCCESS (0.012s)
[372.015826] Starting dynamic subtest: vcs0
[372.018357] Dynamic subtest vcs0: SUCCESS (0.011s)
[372.039860] Starting dynamic subtest: vecs0
[372.042545] Dynamic subtest vecs0: SUCCESS (0.011s)
[372.045413] Subtest concurrent-writes: SUCCESS (0.061s)
[372.262688] [069/134] (686s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[372.466075] Starting subtest: x-tiled-16bpp-rotate-0
[376.111112] Subtest x-tiled-16bpp-rotate-0: SUCCESS (3.647s)
[376.475119] [070/134] (682s left) perf_pmu (rc6-all-gts)
[376.594412] Starting subtest: rc6-all-gts
[376.598035] Subtest rc6-all-gts: SKIP (0.000s)
[376.742408] [071/134] (682s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[376.926613] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[376.929901] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[377.075060] [072/134] (682s left) gem_vm_create (execbuf)
[377.191743] Starting subtest: execbuf
[377.201413] Subtest execbuf: SUCCESS (0.008s)
[377.361352] [073/134] (681s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[377.573580] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[377.579573] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[377.725804] [074/134] (681s left) gem_ctx_shared (create-shared-gtt)
[377.853189] Starting subtest: create-shared-gtt
[380.002527] Subtest create-shared-gtt: SUCCESS (2.151s)
[380.276863] [075/134] (679s left) gem_mmap_gtt (basic-read-write-distinct)
[380.387147] Starting subtest: basic-read-write-distinct
[380.398127] Subtest basic-read-write-distinct: SUCCESS (0.012s)
[380.540884] [076/134] (679s left) i915_suspend (forcewake)
[380.646114] Starting subtest: forcewake