[88.036908] Initializing watchdogs
[88.037246]   /dev/watchdog0
[88.076834] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.092131] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.098806] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.105594] [001/133] (960s left) gem_close_race (basic-threads)
[88.263084] Starting subtest: basic-threads
[89.451794] Subtest basic-threads: SUCCESS (1.190s)
[89.720692] [002/133] (958s left) kms_prop_blob (basic)
[89.820315] Starting subtest: basic
[89.823342] Subtest basic: SUCCESS (0.000s)
[89.958104] [003/133] (958s left) perf (missing-sample-flags)
[90.177474] Starting subtest: missing-sample-flags
[90.179520] Subtest missing-sample-flags: SUCCESS (0.002s)
[90.276120] [004/133] (958s left) perf_pmu (busy-accuracy-98)
[90.385190] Starting subtest: busy-accuracy-98
[90.388124] Starting dynamic subtest: rcs0
[93.440895] Dynamic subtest rcs0: SUCCESS (3.055s)
[93.459254] Starting dynamic subtest: bcs0
[96.500942] Dynamic subtest bcs0: SUCCESS (3.056s)
[96.519635] Starting dynamic subtest: vcs0
[99.553558] Dynamic subtest vcs0: SUCCESS (3.051s)
[99.572132] Starting dynamic subtest: vecs0
[102.604025] Dynamic subtest vecs0: SUCCESS (3.052s)
[102.605938] Subtest busy-accuracy-98: SUCCESS (12.217s)
[102.743336] [005/133] (946s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[102.935087] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[103.030096] [006/133] (945s left) kms_flip (flip-vs-dpms-on-nop)
[103.216319] Starting subtest: flip-vs-dpms-on-nop
[103.219509] Starting dynamic subtest: A-HDMI-A1
[104.680311] Dynamic subtest A-HDMI-A1: SUCCESS (1.466s)
[104.702597] Starting dynamic subtest: B-HDMI-A1
[105.894309] Dynamic subtest B-HDMI-A1: SUCCESS (1.209s)
[105.913671] Starting dynamic subtest: C-HDMI-A1
[107.097512] Dynamic subtest C-HDMI-A1: SUCCESS (1.204s)
[107.118227] Starting dynamic subtest: A-HDMI-A2
[108.289742] Dynamic subtest A-HDMI-A2: SUCCESS (1.189s)
[108.310048] Starting dynamic subtest: B-HDMI-A2
[109.484100] Dynamic subtest B-HDMI-A2: SUCCESS (1.193s)
[109.506748] Starting dynamic subtest: C-HDMI-A2
[110.670528] Dynamic subtest C-HDMI-A2: SUCCESS (1.180s)
[110.672285] Subtest flip-vs-dpms-on-nop: SUCCESS (7.460s)
[111.149950] [007/133] (937s left) gem_exec_gttfill (engines)
[111.286534] Starting subtest: engines
[111.292186] Starting dynamic subtest: rcs0
[138.742614] Dynamic subtest rcs0: SUCCESS (27.457s)
[138.765170] Starting dynamic subtest: bcs0
[168.286671] Dynamic subtest bcs0: SUCCESS (29.542s)
[168.314161] Starting dynamic subtest: vcs0
[195.802107] Dynamic subtest vcs0: SUCCESS (27.513s)
[195.825462] Starting dynamic subtest: vecs0
[223.627861] Dynamic subtest vecs0: SUCCESS (27.824s)
[223.630259] Subtest engines: SUCCESS (112.341s)
[223.911880] [008/133] (825s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[224.222097] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[224.323861] [009/133] (824s left) gem_exec_whisper (basic-queues)
[224.461218] Starting subtest: basic-queues
[229.631120] Subtest basic-queues: SUCCESS (5.171s)
[229.899987] [010/133] (819s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[230.074980] Starting subtest: 2x-long-flip-vs-cursor-atomic
[235.790482] Subtest 2x-long-flip-vs-cursor-atomic: SUCCESS (5.712s)
[236.080705] [011/133] (813s left) kms_big_fb (linear-16bpp-rotate-180)
[236.294545] Starting subtest: linear-16bpp-rotate-180
[240.528567] Subtest linear-16bpp-rotate-180: SUCCESS (4.233s)
[240.881193] [012/133] (808s left) kms_psr (fbc-psr-primary-page-flip)
[241.060073] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[241.155301] [013/133] (808s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[241.271101] Starting subtest: writes-after-reads
[244.492822] Subtest writes-after-reads: SUCCESS (3.221s)
[244.649580] [014/133] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[244.857221] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[247.413502] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.554s)
[247.634222] [015/133] (802s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[247.833884] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[247.839228] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[247.981054] [016/133] (801s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[248.173607] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[250.946208] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.770s)
[251.215392] [017/133] (798s left) perf_pmu (invalid-open)
[251.326225] Starting subtest: invalid-open
[251.329247] Subtest invalid-open: SUCCESS (0.002s)
[251.467481] [018/133] (798s left) kms_chamelium_frames (hdmi-aspect-ratio)
[252.021323] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[252.292289] [019/133] (797s left) gem_exec_nop (basic-series)
[252.432550] Starting subtest: basic-series
[255.490078] Subtest basic-series: SUCCESS (3.064s)
[255.777187] [020/133] (794s left) gem_exec_reloc (basic-write-cpu)
[255.895631] Starting subtest: basic-write-cpu
[255.909245] Subtest basic-write-cpu: SUCCESS (0.015s)
[256.130357] [021/133] (794s left) sw_sync (sync_busy_fork_unixsocket)
[256.243513] Starting subtest: sync_busy_fork_unixsocket
[256.269457] Subtest sync_busy_fork_unixsocket: SUCCESS (0.025s)
[256.410360] [022/133] (794s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[256.611074] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[256.616394] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[256.761124] [023/133] (793s left) i915_hangman (gt-error-state-capture)
[256.896561] Starting subtest: gt-error-state-capture
[256.900091] Starting dynamic subtest: rcs0
[267.068071] Dynamic subtest rcs0: SUCCESS (10.171s)
[267.100163] Starting dynamic subtest: bcs0
[277.017107] Dynamic subtest bcs0: SUCCESS (9.947s)
[277.050141] Starting dynamic subtest: vcs0
[287.066173] Dynamic subtest vcs0: SUCCESS (10.046s)
[287.091091] Starting dynamic subtest: vecs0
[297.041228] Dynamic subtest vecs0: SUCCESS (9.976s)
[297.044507] Subtest gt-error-state-capture: SUCCESS (40.145s)
[297.194383] [024/133] (753s left) gem_tiling_max_stride
[297.498399] [025/133] (753s left) kms_cursor_edge_walk (64x64-left-edge)
[297.682155] Starting subtest: 64x64-left-edge
[297.683645] Starting dynamic subtest: pipe-A-HDMI-A-1
[301.600095] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.917s)
[301.634022] Starting dynamic subtest: pipe-C-HDMI-A-1
[305.176873] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.567s)
[305.178477] Subtest 64x64-left-edge: SUCCESS (7.494s)
[305.503821] [026/133] (745s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[305.615372] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[305.712847] [027/133] (745s left) kms_big_fb (yf-tiled-addfb)
[305.905692] Starting subtest: yf-tiled-addfb
[305.908092] Subtest yf-tiled-addfb: SUCCESS (0.000s)
[306.049247] [028/133] (744s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[306.265169] Starting subtest: cursor-rapid-movement-max-size
[306.270515] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[306.407159] [029/133] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[306.598460] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[306.602769] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[306.749285] [030/133] (744s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[306.937090] Starting subtest: invalid-modeset-force-ultra-joiner
[306.941113] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[307.071148] [031/133] (744s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[307.250687] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[307.253968] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[307.389607] [032/133] (743s left) gem_lmem_swapping (random)
[307.506067] Subtest random: SKIP (0.000s)
[307.613792] [033/133] (743s left) i915_drm_fdinfo (memory-info-idle)
[307.725725] Starting subtest: memory-info-idle
[307.728800] Starting dynamic subtest: smem0
[307.762478] Dynamic subtest smem0: SUCCESS (0.036s)
[307.765377] Subtest memory-info-idle: SUCCESS (0.037s)
[307.907170] [034/133] (743s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[308.084068] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[308.087076] Starting dynamic subtest: pipe-A-HDMI-A-1
[308.183056] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[308.232290] Starting dynamic subtest: pipe-A-HDMI-A-2
[308.313111] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.012s)
[308.337239] Starting dynamic subtest: pipe-B-HDMI-A-1
[308.385283] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.012s)
[308.406581] Starting dynamic subtest: pipe-B-HDMI-A-2
[308.458985] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.012s)
[308.481182] Starting dynamic subtest: pipe-C-HDMI-A-1
[308.544431] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s)
[308.566092] Starting dynamic subtest: pipe-C-HDMI-A-2
[308.677086] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.012s)
[308.686053] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.090s)
[309.069122] [035/133] (742s left) api_intel_bb (intel-bb-blit-y)
[309.174107] Starting subtest: intel-bb-blit-y
[312.423151] Subtest intel-bb-blit-y: SUCCESS (3.248s)
[312.584417] [036/133] (739s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[312.786672] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[315.366633] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.575s)
[315.588313] [037/133] (736s left) core_getversion (all-cards)
[315.691321] Starting subtest: all-cards
[315.721444] Subtest all-cards: SUCCESS (0.033s)
[315.820292] [038/133] (736s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[315.924316] Starting subtest: invalid-multi-wait-unsubmitted
[315.926872] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[316.069474] [039/133] (735s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[316.262535] Starting subtest: psr-dirtyfb-ioctl
[316.275647] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[316.402069] [040/133] (735s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[316.589357] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[316.592764] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[316.720077] [041/133] (735s left) gem_exec_schedule (u-submit-early-slice)
[316.858451] Starting subtest: u-submit-early-slice
[316.860859] Starting dynamic subtest: rcs0
[316.915606] Dynamic subtest rcs0: SUCCESS (0.057s)
[316.943635] Starting dynamic subtest: bcs0
[316.967495] Dynamic subtest bcs0: SUCCESS (0.051s)
[316.996578] Starting dynamic subtest: vcs0
[317.022104] Dynamic subtest vcs0: SUCCESS (0.054s)
[317.051489] Starting dynamic subtest: vecs0
[317.073571] Dynamic subtest vecs0: SUCCESS (0.052s)
[317.075568] Subtest u-submit-early-slice: SUCCESS (0.219s)
[317.456406] [042/133] (734s left) prime_mmap (test_invalid_sync_flags)
[317.559769] Starting subtest: test_invalid_sync_flags
[317.562188] Starting dynamic subtest: test_invalid_sync_flags-smem
[317.566156] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[317.567865] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[317.706620] [043/133] (734s left) prime_busy (after)
[317.818024] Starting subtest: after
[317.834244] Starting dynamic subtest: rcs0
[317.842441] Dynamic subtest rcs0: SUCCESS (0.011s)
[317.877843] Starting dynamic subtest: bcs0
[317.879510] Dynamic subtest bcs0: SUCCESS (0.012s)
[317.904880] Starting dynamic subtest: vcs0
[317.907318] Dynamic subtest vcs0: SUCCESS (0.016s)
[317.930098] Starting dynamic subtest: vecs0
[317.932686] Dynamic subtest vecs0: SUCCESS (0.013s)
[318.005077] Subtest after: SUCCESS (0.183s)
[318.154366] [044/133] (734s left) syncobj_timeline (wait-for-submit-snapshot)
[318.261331] Starting subtest: wait-for-submit-snapshot
[318.348557] Subtest wait-for-submit-snapshot: SUCCESS (0.087s)
[318.483683] [045/133] (733s left) gem_flink_race (flink_name)
[318.582893] Starting subtest: flink_name
[323.955982] Subtest flink_name: SUCCESS (5.374s)
[324.102273] [046/133] (728s left) i915_suspend (basic-s2idle-without-i915)
[324.201233] Starting subtest: basic-s2idle-without-i915
[344.572733] Subtest basic-s2idle-without-i915: SUCCESS (5.288s)
[354.845548] [047/133] (707s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[355.036757] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[355.041346] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[355.831947] [048/133] (706s left) gem_tiled_blits (interruptible)
[356.213911] Starting subtest: interruptible
[401.715636] Subtest interruptible: SUCCESS (45.503s)
[401.893883] [049/133] (660s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[402.217418] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[402.220808] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[402.356055] [050/133] (660s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[402.537646] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[402.541917] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[402.672315] [051/133] (660s left) kms_flip (dpms-off-confusion-interruptible)
[402.873429] Starting subtest: dpms-off-confusion-interruptible
[402.875503] Starting dynamic subtest: A-HDMI-A1
[408.580914] Dynamic subtest A-HDMI-A1: SUCCESS (5.709s)
[408.610884] Starting dynamic subtest: B-HDMI-A1
[413.957159] Dynamic subtest B-HDMI-A1: SUCCESS (5.372s)
[413.985900] Starting dynamic subtest: C-HDMI-A1
[419.334435] Dynamic subtest C-HDMI-A1: SUCCESS (5.367s)
[419.358419] Starting dynamic subtest: A-HDMI-A2
[424.729193] Dynamic subtest A-HDMI-A2: SUCCESS (5.394s)
[424.753956] Starting dynamic subtest: B-HDMI-A2
[430.119327] Dynamic subtest B-HDMI-A2: SUCCESS (5.387s)
[430.143818] Starting dynamic subtest: C-HDMI-A2
[435.524776] Dynamic subtest C-HDMI-A2: SUCCESS (5.399s)
[435.528031] Subtest dpms-off-confusion-interruptible: SUCCESS (32.654s)
[435.988782] [052/133] (627s left) kms_async_flips (test-time-stamp-atomic)
[436.177632] Starting subtest: test-time-stamp-atomic
[436.770004] Starting dynamic subtest: pipe-A-HDMI-A-1
[436.975755] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.203s)
[437.345383] Starting dynamic subtest: pipe-A-HDMI-A-2
[437.590159] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.264s)
[437.980844] Starting dynamic subtest: pipe-B-HDMI-A-1
[438.172715] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.218s)
[438.530430] Starting dynamic subtest: pipe-B-HDMI-A-2
[438.714491] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.212s)
[439.074742] Starting dynamic subtest: pipe-C-HDMI-A-1
[439.247643] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.194s)
[439.617832] Starting dynamic subtest: pipe-C-HDMI-A-2
[439.790626] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.196s)
[439.792256] Subtest test-time-stamp-atomic: SUCCESS (3.612s)
[440.441650] [053/133] (622s left) gem_exec_schedule (preemptive-hang)
[440.718755] Starting subtest: preemptive-hang
[440.721817] Starting dynamic subtest: rcs0
[447.166433] Dynamic subtest rcs0: SUCCESS (6.444s)
[447.195083] Starting dynamic subtest: bcs0
[453.188541] Dynamic subtest bcs0: SUCCESS (6.013s)
[453.213117] Starting dynamic subtest: vcs0
[459.196855] Dynamic subtest vcs0: SUCCESS (6.001s)
[459.230887] Starting dynamic subtest: vecs0
[465.220733] Dynamic subtest vecs0: SUCCESS (6.014s)
[465.228055] Subtest preemptive-hang: SUCCESS (24.492s)
[465.472111] [054/133] (597s left) gem_eio (in-flight-suspend)
[465.600744] Starting subtest: in-flight-suspend