[87.308242] Initializing watchdogs
[87.308461]   /dev/watchdog0
[87.348306] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.363079] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.369747] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.377810] [001/134] (960s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[87.575479] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[87.578758] Starting dynamic subtest: pipe-A-valid-mode
[88.135961] Dynamic subtest pipe-A-valid-mode: SKIP (0.550s)
[88.142022] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SKIP (0.554s)
[88.602298] [002/134] (959s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[88.825740] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[88.908931] [003/134] (959s left) perf (polling-small-buf)
[89.163327] Starting subtest: polling-small-buf
[89.262569] Subtest polling-small-buf: SUCCESS (0.102s)
[89.361756] [004/134] (958s left) gem_ctx_exec (basic-close-race)
[89.474841] Starting subtest: basic-close-race
[94.927583] Subtest basic-close-race: SUCCESS (5.454s)
[95.134318] [005/134] (953s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[95.342673] Starting subtest: x-tiled-16bpp-rotate-0
[98.577822] Subtest x-tiled-16bpp-rotate-0: SUCCESS (3.232s)
[98.942119] [006/134] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[99.140881] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[99.148385] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[99.310840] [007/134] (949s left) kms_draw_crc (draw-method-mmap-wc)
[99.502894] Starting subtest: draw-method-mmap-wc
[99.506045] Starting dynamic subtest: xrgb8888-untiled
[99.975396] Dynamic subtest xrgb8888-untiled: SUCCESS (0.478s)
[99.993648] Starting dynamic subtest: rgb565-untiled
[100.240975] Dynamic subtest rgb565-untiled: SUCCESS (0.264s)
[100.259558] Starting dynamic subtest: xrgb2101010-untiled
[100.493877] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.248s)
[100.512881] Starting dynamic subtest: xbgr16161616f-untiled
[100.759721] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.267s)
[100.777791] Starting dynamic subtest: xrgb8888-xtiled
[100.945232] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.180s)
[100.963449] Starting dynamic subtest: rgb565-xtiled
[101.128317] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[101.147662] Starting dynamic subtest: xrgb2101010-xtiled
[101.291170] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s)
[101.310154] Starting dynamic subtest: xbgr16161616f-xtiled
[101.459204] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.165s)
[101.477077] Starting dynamic subtest: xrgb8888-ytiled
[101.644361] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.182s)
[101.662723] Starting dynamic subtest: rgb565-ytiled
[101.825539] Dynamic subtest rgb565-ytiled: SUCCESS (0.180s)
[101.843810] Starting dynamic subtest: xrgb2101010-ytiled
[101.991708] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.165s)
[102.010653] Starting dynamic subtest: xbgr16161616f-ytiled
[102.160625] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.164s)
[102.165205] Subtest draw-method-mmap-wc: SUCCESS (2.661s)
[102.410248] [008/134] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[102.614564] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[102.621593] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[102.777814] [009/134] (945s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[102.967331] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[102.970903] Starting dynamic subtest: pipe-A-HDMI-A-1
[103.111211] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[103.130242] Starting dynamic subtest: pipe-A-HDMI-A-2
[103.164459] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[103.183553] Starting dynamic subtest: pipe-B-HDMI-A-1
[103.215294] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[103.233454] Starting dynamic subtest: pipe-B-HDMI-A-2
[103.265871] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[103.287663] Starting dynamic subtest: pipe-C-HDMI-A-1
[103.320630] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[103.339021] Starting dynamic subtest: pipe-C-HDMI-A-2
[103.370746] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[103.376717] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.020s)
[103.936545] [010/134] (944s left) kms_chamelium_color (ctm-blue-to-red)
[104.125848] Subtest ctm-blue-to-red: SKIP (0.000s)
[104.235979] [011/134] (944s left) api_intel_bb (reset-bb)
[104.343199] Starting subtest: reset-bb
[104.347293] Subtest reset-bb: SUCCESS (0.005s)
[104.501233] [012/134] (944s left) drm_read (empty-block)
[104.919320] Starting subtest: empty-block
[105.928049] Subtest empty-block: SUCCESS (1.000s)
[106.232291] [013/134] (942s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[106.438471] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[108.905729] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.465s)
[109.183453] [014/134] (939s left) gen9_exec_parse (bb-start-out)
[109.312807] Starting subtest: bb-start-out
[109.320548] Subtest bb-start-out: SUCCESS (0.005s)
[109.616615] [015/134] (939s left) dmabuf_sync_file (import-basic)
[109.815483] Starting subtest: import-basic
[109.819958] Subtest import-basic: SUCCESS (0.010s)
[109.956928] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[109.964186] [016/134] (939s left) gem_exec_reloc (basic-write-read)
[110.078241] Starting subtest: basic-write-read
[110.097410] Subtest basic-write-read: SUCCESS (0.017s)
[110.347378] [017/134] (939s left) kms_cursor_crc (cursor-tearing-position-change)
[110.527473] Starting subtest: cursor-tearing-position-change
[110.530802] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.390202] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.865s)
[111.433557] Starting dynamic subtest: pipe-C-HDMI-A-1
[111.927162] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.535s)
[111.931649] Subtest cursor-tearing-position-change: SUCCESS (1.408s)
[112.275833] [018/134] (937s left) kms_psr (fbc-pr-primary-render)
[112.476207] Subtest fbc-pr-primary-render: SKIP (0.000s)
[112.586968] [019/134] (937s left) gem_busy (extended)
[112.855139] Starting subtest: extended
[112.858693] Starting dynamic subtest: rcs0
[112.873032] Dynamic subtest rcs0: SUCCESS (0.022s)
[112.892949] Starting dynamic subtest: bcs0
[112.897189] Dynamic subtest bcs0: SUCCESS (0.014s)
[112.916293] Starting dynamic subtest: vcs0
[112.919924] Dynamic subtest vcs0: SUCCESS (0.022s)
[112.940300] Starting dynamic subtest: vecs0
[112.944256] Dynamic subtest vecs0: SUCCESS (0.020s)
[112.948376] Subtest extended: SUCCESS (0.083s)
[113.219826] [020/134] (936s left) gem_exec_schedule (preempt-user)
[113.369289] Starting subtest: preempt-user
[113.372635] Starting dynamic subtest: rcs0
[113.423278] Dynamic subtest rcs0: SUCCESS (0.056s)
[113.443467] Starting dynamic subtest: bcs0
[113.505545] Dynamic subtest bcs0: SUCCESS (0.080s)
[113.526384] Starting dynamic subtest: vcs0
[113.563933] Dynamic subtest vcs0: SUCCESS (0.054s)
[113.583262] Starting dynamic subtest: vecs0
[113.611800] Dynamic subtest vecs0: SUCCESS (0.052s)
[113.615936] Subtest preempt-user: SUCCESS (0.246s)
[114.022858] [021/134] (935s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[114.224077] Starting subtest: 4-tiled-16bpp-rotate-180
[114.232162] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[114.403403] [022/134] (935s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[114.608493] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[114.621462] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[114.789516] [023/134] (935s left) gem_exec_fence (basic-await)
[115.046976] Starting subtest: basic-await
[115.050496] Starting dynamic subtest: rcs0
[115.166155] Dynamic subtest rcs0: SUCCESS (0.119s)
[115.186114] Starting dynamic subtest: bcs0
[115.282967] Dynamic subtest bcs0: SUCCESS (0.115s)
[115.303114] Starting dynamic subtest: vcs0
[115.400209] Dynamic subtest vcs0: SUCCESS (0.114s)
[115.420051] Starting dynamic subtest: vecs0
[115.516119] Dynamic subtest vecs0: SUCCESS (0.116s)
[115.520655] Subtest basic-await: SUCCESS (0.470s)
[116.221918] [024/134] (933s left) kms_selftest (drm_plane_helper)
[116.327662] Starting subtest: drm_plane_helper
[116.335822] Starting dynamic subtest: drm_test_check_plane_state
[116.386964] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.047s)
[116.406517] Starting dynamic subtest: drm_test_check_invalid_plane_state
[116.457942] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.071s)
[116.463023] Subtest drm_plane_helper: SUCCESS (0.130s)
[116.627650] [025/134] (933s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[116.836342] Starting subtest: cursor-vs-flip-legacy
[157.044969] Subtest cursor-vs-flip-legacy: SUCCESS (40.207s)
[157.383202] [026/134] (892s left) gem_exec_fence (invalid-fence-array)
[157.928944] Starting subtest: invalid-fence-array
[157.933625] Subtest invalid-fence-array: SUCCESS (0.005s)
[158.343345] [027/134] (892s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[158.545384] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[160.969183] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.427s)
[161.265279] [028/134] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[161.466607] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[161.473545] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[161.633138] [029/134] (888s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[161.840994] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[161.844155] Starting dynamic subtest: pipe-A-valid-mode
[162.281944] Dynamic subtest pipe-A-valid-mode: SKIP (0.380s)
[162.319493] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.384s)
[162.534766] [030/134] (888s left) kms_psr (fbc-psr-sprite-plane-move)
[162.730955] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[162.847981] [031/134] (887s left) vgem_basic (sysfs)
[162.981436] Starting subtest: sysfs
[162.986844] Subtest sysfs: SUCCESS (0.002s)
[163.151092] [032/134] (887s left) api_intel_allocator (fork-simple-once)
[163.260192] Starting subtest: fork-simple-once
[163.291387] Subtest fork-simple-once: SUCCESS (0.033s)
[163.448357] [033/134] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[163.651818] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[163.659283] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[163.831795] [034/134] (887s left) gem_exec_whisper (basic-fds-priority)
[163.958784] Starting subtest: basic-fds-priority
[176.659895] Subtest basic-fds-priority: SUCCESS (12.700s)
[176.949485] [035/134] (874s left) kms_plane (pixel-format)
[177.131684] Starting subtest: pixel-format
[177.353194] Starting dynamic subtest: pipe-A-plane-0
[182.570415] Dynamic subtest pipe-A-plane-0: SUCCESS (5.216s)
[182.595241] Starting dynamic subtest: pipe-A-plane-1
[187.652253] Dynamic subtest pipe-A-plane-1: SUCCESS (5.082s)
[187.673971] Starting dynamic subtest: pipe-A-plane-2
[190.151123] Dynamic subtest pipe-A-plane-2: SUCCESS (2.498s)
[190.173582] Starting dynamic subtest: pipe-A-plane-3
[192.652185] Dynamic subtest pipe-A-plane-3: SUCCESS (2.499s)
[192.674130] Starting dynamic subtest: pipe-A-plane-4
[192.869274] Dynamic subtest pipe-A-plane-4: SUCCESS (0.216s)
[193.341057] Starting dynamic subtest: pipe-B-plane-0
[198.212148] Dynamic subtest pipe-B-plane-0: SUCCESS (4.983s)
[198.237660] Starting dynamic subtest: pipe-B-plane-1
[203.310712] Dynamic subtest pipe-B-plane-1: SUCCESS (5.099s)
[203.332888] Starting dynamic subtest: pipe-B-plane-2
[205.811282] Dynamic subtest pipe-B-plane-2: SUCCESS (2.498s)
[205.833380] Starting dynamic subtest: pipe-B-plane-3
[208.310597] Dynamic subtest pipe-B-plane-3: SUCCESS (2.499s)
[208.333056] Starting dynamic subtest: pipe-B-plane-4
[208.525979] Dynamic subtest pipe-B-plane-4: SUCCESS (0.215s)
[208.887684] Subtest pixel-format: SUCCESS (31.615s)
[209.471697] [036/134] (842s left) perf (blocking)
[209.899658] Starting subtest: blocking
[209.965528] Starting dynamic subtest: 0-rcs0
[219.794290] Dynamic subtest 0-rcs0: SUCCESS (10.033s)
[219.798587] Subtest blocking: SUCCESS (10.035s)
[219.906763] [037/134] (831s left) kms_hdr (bpc-switch)
[220.092337] Starting subtest: bpc-switch
[248.381658] Subtest bpc-switch: SKIP (28.283s)
[248.886359] [038/134] (803s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[249.507390] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[249.806757] [039/134] (802s left) gem_ctx_shared (q-promotion)
[249.932833] Starting subtest: Q-promotion
[249.936952] Starting dynamic subtest: rcs0
[250.033648] Dynamic subtest rcs0: SUCCESS (0.093s)
[250.059495] Starting dynamic subtest: bcs0
[250.141952] Dynamic subtest bcs0: SUCCESS (0.106s)
[250.170189] Starting dynamic subtest: vcs0
[250.240963] Dynamic subtest vcs0: SUCCESS (0.094s)
[250.264596] Starting dynamic subtest: vecs0
[250.337162] Dynamic subtest vecs0: SUCCESS (0.093s)
[250.341792] Subtest Q-promotion: SUCCESS (0.401s)
[250.629533] [040/134] (801s left) i915_hangman (error-state-basic)
[250.767062] Starting subtest: error-state-basic
[250.775089] Subtest error-state-basic: SUCCESS (0.012s)
[250.973195] [041/134] (801s left) gem_softpin (softpin)
[251.102861] Starting subtest: softpin
[283.464440] Subtest softpin: SUCCESS (32.360s)
[283.629357] [042/134] (768s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[283.842704] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[283.850666] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[284.030196] [043/134] (768s left) syncobj_wait (reset-multiple-signaled)
[284.144533] Starting subtest: reset-multiple-signaled
[284.148750] Subtest reset-multiple-signaled: SUCCESS (0.002s)
[284.354973] [044/134] (768s left) gem_eio (wait-10ms)
[284.485924] Starting subtest: wait-10ms
[284.591226] Subtest wait-10ms: SUCCESS (0.105s)
[284.847766] [045/134] (767s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[285.055029] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[287.450361] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SUCCESS (2.398s)
[287.711319] [046/134] (765s left) gem_sync (basic-all)
[287.854369] Starting subtest: basic-all
[290.246169] Subtest basic-all: SUCCESS (2.402s)
[290.543566] [047/134] (762s left) kms_vblank (wait-forked)
[290.729962] Starting subtest: wait-forked
[290.733640] Starting dynamic subtest: pipe-A-HDMI-A-1
[293.457044] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.719s)
[293.499381] Starting dynamic subtest: pipe-A-HDMI-A-2
[295.914640] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.452s)
[295.962378] Starting dynamic subtest: pipe-C-HDMI-A-1
[298.346986] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.423s)
[298.394070] Starting dynamic subtest: pipe-C-HDMI-A-2
[300.788948] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.436s)
[300.793235] Subtest wait-forked: SUCCESS (10.060s)
[301.127378] [048/134] (751s left) gem_ctx_persistence (many-contexts)
[301.249774] Starting subtest: many-contexts
[334.036609] Subtest many-contexts: SUCCESS (32.786s)
[334.217242] [049/134] (718s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[334.424187] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[334.431569] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[334.612423] [050/134] (718s left) kms_content_protection (type1)
[334.821994] Starting subtest: type1
[334.858811] Subtest type1: SKIP (0.036s)
[335.043238] [051/134] (718s left) kms_chamelium_frames (dp-crc-single)
[335.623577] Subtest dp-crc-single: SKIP (0.000s)
[335.917051] [052/134] (717s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[336.127141] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[336.131873] Starting dynamic subtest: pipe-A-HDMI-A-1
[336.152035] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[336.260843] Starting dynamic subtest: pipe-A-HDMI-A-2
[336.305263] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[336.340214] Starting dynamic subtest: pipe-B-HDMI-A-1
[336.354988] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[336.378027] Starting dynamic subtest: pipe-B-HDMI-A-2
[336.391929] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[336.416057] Starting dynamic subtest: pipe-C-HDMI-A-1
[336.429892] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[336.453831] Starting dynamic subtest: pipe-C-HDMI-A-2
[336.466109] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[336.472275] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.057s)
[337.239767] [053/134] (716s left) gem_ppgtt (shrink-vs-evict-any)
[337.368146] Starting subtest: shrink-vs-evict-any
[342.430694] Subtest shrink-vs-evict-any: SUCCESS (5.061s)
[342.566191] [054/134] (711s left) gem_exec_schedule (preempt-contexts)
[342.708176] Starting subtest: preempt-contexts
[342.711461] Starting dynamic subtest: rcs0
[342.819033] Dynamic subtest rcs0: SUCCESS (0.106s)
[342.845078] Starting dynamic subtest: bcs0
[342.961301] Dynamic subtest bcs0: SUCCESS (0.138s)
[342.994311] Starting dynamic subtest: vcs0
[343.072764] Dynamic subtest vcs0: SUCCESS (0.110s)
[343.097888] Starting dynamic subtest: vecs0
[343.197941] Dynamic subtest vecs0: SUCCESS (0.116s)
[343.203591] Subtest preempt-contexts: SUCCESS (0.487s)
[343.619302] [055/134] (710s left) gem_exec_suspend (basic)
[343.741778] Starting subtest: basic
[343.745647] Starting dynamic subtest: smem
[344.904385] Dynamic subtest smem: SUCCESS (1.161s)
[344.907931] Subtest basic: SUCCESS (1.165s)
[345.204778] [056/134] (708s left) kms_feature_discovery (psr1)
[345.401247] Starting subtest: psr1
[345.407598] Subtest psr1: SKIP (0.000s)
[345.587100] [057/134] (708s left) kms_psr (psr2-no-drrs)
[345.781562] Subtest psr2-no-drrs: SKIP (0.000s)
[345.903079] [058/134] (708s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[346.115554] Starting subtest: fbc-tiling-linear
[348.405054] Subtest fbc-tiling-linear: SUCCESS (2.292s)
[348.721456] [059/134] (705s left) sysfs_timeslice_duration (idempotent)
[348.844198] Starting subtest: idempotent
[348.847955] Starting dynamic subtest: vecs0
[348.851225] Dynamic subtest vecs0: SUCCESS (0.002s)
[348.878146] Starting dynamic subtest: vcs0
[348.881754] Dynamic subtest vcs0: SUCCESS (0.002s)
[348.905462] Starting dynamic subtest: bcs0
[348.909552] Dynamic subtest bcs0: SUCCESS (0.002s)
[348.932966] Starting dynamic subtest: rcs0
[348.937357] Dynamic subtest rcs0: SUCCESS (0.002s)
[348.941557] Subtest idempotent: SUCCESS (0.022s)
[349.040400] [060/134] (705s left) syncobj_timeline (single-wait-signaled)
[349.148555] Starting subtest: single-wait-signaled
[349.152499] Subtest single-wait-signaled: SUCCESS (0.001s)
[349.335278] [061/134] (705s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[349.544452] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[349.551449] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[349.721151] [062/134] (704s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[349.933724] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[351.942040] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.012s)
[352.156337] [063/134] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[352.371275] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[352.378796] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[352.538270] [064/134] (702s left) gem_userptr_blits (dmabuf-sync)
[352.681918] Starting subtest: dmabuf-sync
[352.693953] Subtest dmabuf-sync: SKIP (0.007s)
[352.902238] [065/134] (701s left) gem_watchdog (default-physical)
[353.037363] Starting subtest: default-physical
[354.044699] Subtest default-physical: SUCCESS (1.021s)
[354.210190] [066/134] (700s left) template (b)
[354.318812] Starting subtest: B
[354.322552] Subtest B: SUCCESS (0.000s)
[354.501365] [067/134] (700s left) gem_exec_balancer (noheartbeat)
[354.754780] Starting subtest: noheartbeat
[359.140736] Subtest noheartbeat: SUCCESS (4.390s)
[359.352414] [068/134] (695s left) kms_colorop (plane-xr24-xr24-ctm_3x4_bt709_enc)
[359.624493] Subtest plane-XR24-XR24-ctm_3x4_bt709_enc: SKIP (0.000s)
[359.819503] [069/134] (695s left) kms_vrr (lobf)
[360.014586] Starting subtest: lobf
[360.021165] Subtest lobf: SKIP (0.000s)
[360.171155] [070/134] (695s left) kms_lease (empty-lease)
[360.350712] Starting subtest: empty-lease
[360.354196] Starting dynamic subtest: pipe-A-HDMI-A-1
[360.358465] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[360.451520] Starting dynamic subtest: pipe-A-HDMI-A-2
[360.456679] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s)
[360.497310] Starting dynamic subtest: pipe-B-HDMI-A-1
[360.500517] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.003s)
[360.523433] Starting dynamic subtest: pipe-B-HDMI-A-2
[360.526725] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.004s)
[360.549136] Starting dynamic subtest: pipe-C-HDMI-A-1
[360.555065] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.003s)
[360.581991] Starting dynamic subtest: pipe-C-HDMI-A-2
[360.587553] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.003s)
[360.591579] Subtest empty-lease: SUCCESS (0.096s)
[360.700232] [071/134] (694s left) gem_mmap (basic-small-bo)
[360.808111] Starting subtest: basic-small-bo
[361.539268] Subtest basic-small-bo: SUCCESS (0.733s)
[361.751446] [072/134] (693s left) kms_colorop (plane-xr24-xr24-gamma_2_2_inv_oetf-gamma_2_2_oetf)
[362.215854] Subtest plane-XR24-XR24-gamma_2_2_inv_oetf-gamma_2_2_oetf: SKIP (0.000s)
[362.391290] [073/134] (693s left) i915_drm_fdinfo (context-close-stress)
[362.516198] Starting subtest: context-close-stress
[373.275675] Subtest context-close-stress: SUCCESS (10.762s)
[373.440082] [074/134] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[373.657315] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[373.664613] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[373.823378] [075/134] (682s left) gem_lmem_swapping (verify)
[373.969811] Subtest verify: SKIP (0.000s)
[374.085107] [076/134] (681s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[374.283816] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[377.054072] Subtest fbc-2p-primscrn-cur-indfb-onoff: SUCCESS (2.774s)
[377.291056] [077/134] (678s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[377.422301] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[377.426135] Starting dynamic subtest: smem
[377.677357] Dynamic subtest smem: SUCCESS (0.251s)
[377.681338] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.254s)
[377.999067] [078/134] (678s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[378.207372] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[378.211458] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[389.467815] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.253s)
[389.494513] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[400.441899] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.968s)
[400.471591] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[411.384340] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.934s)
[411.388092] Subtest 2x-wf_vblank-ts-check-interruptible: SUCCESS (33.180s)
[412.043406] [079/134] (644s left) gem_mmap_wc (read-write)
[412.151277] Starting subtest: read-write
[412.162280] Subtest read-write: SUCCESS (0.008s)
[412.350706] [080/134] (644s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[412.565316] Starting subtest: psr-modesetfrombusy
[412.571953] Subtest psr-modesetfrombusy: SKIP (0.000s)
[412.772603] [081/134] (643s left) perf (invalid-remove-userspace-config)
[413.049158] Starting subtest: invalid-remove-userspace-config
[413.082970] Subtest invalid-remove-userspace-config: SUCCESS (0.032s)
[413.200058] [082/134] (643s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[413.421696] Starting subtest: y-tiled-8bpp-rotate-270
[413.750299] Subtest y-tiled-8bpp-rotate-270: SKIP (0.324s)
[414.061823] [083/134] (642s left) gem_mmap_wc (read)
[414.178117] Starting subtest: read
[414.201278] Subtest read: SUCCESS (0.029s)
[414.362506] [084/134] (642s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[414.544178] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[414.548733] Starting dynamic subtest: pipe-A-HDMI-A-1
[414.684254] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[414.707531] Starting dynamic subtest: pipe-A-HDMI-A-2
[414.739602] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[414.764678] Starting dynamic subtest: pipe-B-HDMI-A-1
[414.795615] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[414.819156] Starting dynamic subtest: pipe-B-HDMI-A-2
[414.850706] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[414.875524] Starting dynamic subtest: pipe-C-HDMI-A-1
[414.907942] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[414.931433] Starting dynamic subtest: pipe-C-HDMI-A-2
[414.962499] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[414.968678] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.033s)
[415.584426] [085/134] (641s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[415.777526] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[416.538857] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.769s)
[416.885698] [086/134] (640s left) gem_softpin (allocator-fork)
[417.007107] Starting subtest: allocator-fork
[419.357351] Subtest allocator-fork: SUCCESS (2.349s)
[419.573322] [087/134] (637s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[419.781283] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[419.788038] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[419.953059] [088/134] (637s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[420.071051] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[420.186131] [089/134] (637s left) gem_softpin (invalid)
[420.314504] Starting subtest: invalid
[420.325056] Subtest invalid: SUCCESS (0.012s)
[420.500253] [090/134] (637s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[420.610266] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[420.721060] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[420.919388] [091/134] (636s left) kms_pm_backlight (fade)
[421.109232] Subtest fade: SKIP (0.000s)
[421.250566] [092/134] (636s left) vgem_basic (dmabuf-export)
[421.387051] Starting subtest: dmabuf-export
[421.393987] Subtest dmabuf-export: SUCCESS (0.011s)
[421.566728] [093/134] (636s left) kms_plane_multiple (2x-tiling-none)
[421.746476] Starting subtest: 2x-tiling-none
[421.750192] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[422.728976] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.978s)
[422.792304] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2
[423.764525] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.014s)
[423.873039] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1
[424.978193] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.192s)
[425.042430] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1
[425.961480] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (0.963s)
[426.085267] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[427.206209] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.204s)
[427.248796] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2
[428.206426] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (0.978s)
[428.314305] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1
[429.439273] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.193s)
[429.543965] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1
[430.441529] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (0.961s)
[430.523716] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2
[431.489067] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.008s)
[431.574336] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2
[432.526824] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.997s)
[432.569064] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1
[433.770238] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.221s)
[433.850886] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1
[434.784387] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (0.994s)
[434.823051] Subtest 2x-tiling-none: SUCCESS (13.074s)
[435.570246] [094/134] (622s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[435.794346] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[435.801582] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[435.970543] [095/134] (622s left) kms_flip (absolute-wf_vblank)
[436.158415] Starting subtest: absolute-wf_vblank
[436.162087] Starting dynamic subtest: A-HDMI-A1
[441.810814] Dynamic subtest A-HDMI-A1: SUCCESS (5.647s)
[441.837793] Starting dynamic subtest: B-HDMI-A1
[447.202251] Dynamic subtest B-HDMI-A1: SUCCESS (5.385s)
[447.228566] Starting dynamic subtest: C-HDMI-A1
[452.583690] Dynamic subtest C-HDMI-A1: SUCCESS (5.376s)
[452.609578] Starting dynamic subtest: A-HDMI-A2
[457.976950] Dynamic subtest A-HDMI-A2: SUCCESS (5.389s)
[458.003590] Starting dynamic subtest: B-HDMI-A2
[463.369661] Dynamic subtest B-HDMI-A2: SUCCESS (5.387s)
[463.396500] Starting dynamic subtest: C-HDMI-A2
[468.760878] Dynamic subtest C-HDMI-A2: SUCCESS (5.385s)
[468.764360] Subtest absolute-wf_vblank: SUCCESS (32.604s)
[469.322382] [096/134] (588s left) gem_eio (throttle)
[469.464290] Starting subtest: throttle
[469.498540] Subtest throttle: SUCCESS (0.040s)
[469.788546] [097/134] (588s left) kms_psr (fbc-psr-cursor-plane-move)
[469.984651] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[470.105557] [098/134] (588s left) kms_colorop (plane-xr30-xr30-ctm_3x4_bt709_enc)
[470.386460] Subtest plane-XR30-XR30-ctm_3x4_bt709_enc: SKIP (0.000s)
[470.575514] [099/134] (588s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[470.689704] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[470.798660] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[470.971632] [100/134] (587s left) kms_cursor_crc (cursor-sliding-32x10)
[471.228507] Starting subtest: cursor-sliding-32x10
[471.361859] Subtest cursor-sliding-32x10: SKIP (0.178s)
[471.558729] [101/134] (587s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[471.782557] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[471.890196] [102/134] (587s left) syncobj_wait (wait-delayed-signal)
[472.008064] Starting subtest: wait-delayed-signal
[472.110739] Subtest wait-delayed-signal: SUCCESS (0.103s)
[472.261692] [103/134] (586s left) kms_pm_rpm (legacy-planes-dpms)
[474.178957] Starting subtest: legacy-planes-dpms
[474.182769] Starting dynamic subtest: plane-43
[475.679283] Dynamic subtest plane-43: SUCCESS (1.480s)
[475.705133] Starting dynamic subtest: plane-52
[477.286319] Dynamic subtest plane-52: SUCCESS (1.627s)
[477.312892] Starting dynamic subtest: plane-61
[478.889284] Dynamic subtest plane-61: SUCCESS (1.599s)
[478.892483] Subtest legacy-planes-dpms: SUCCESS (4.719s)
[479.318060] [104/134] (579s left) kms_atomic_interruptible (legacy-cursor)
[479.562539] Starting subtest: legacy-cursor
[479.569402] Starting dynamic subtest: pipe-A-HDMI-A-1
[486.304705] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.787s)
[486.307923] Subtest legacy-cursor: SUCCESS (6.793s)
[486.659281] [105/134] (572s left) perf (disabled-read-error)
[486.892317] Starting subtest: disabled-read-error
[486.923104] Subtest disabled-read-error: SUCCESS (0.031s)
[487.050443] [106/134] (572s left) gem_mmap_gtt (basic-small-copy-xy)
[487.157261] Starting subtest: basic-small-copy-XY
[489.861647] Subtest basic-small-copy-XY: SUCCESS (2.708s)
[490.067767] [107/134] (569s left) i915_query (query-topology-garbage-items)
[490.314553] Starting subtest: query-topology-garbage-items
[490.318467] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[490.488055] [108/134] (569s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[490.710064] Starting subtest: fbcpsr-rgb565-draw-blt
[490.716558] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[490.891806] [109/134] (568s left) kms_async_flips (async-flip-suspend-resume)
[491.087088] Starting subtest: async-flip-suspend-resume
[491.724435] Starting dynamic subtest: pipe-A-HDMI-A-1
[509.955584] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.506s)
[510.393083] Starting dynamic subtest: pipe-A-HDMI-A-2