[89.185127] Initializing watchdogs
[89.185400]   /dev/watchdog0
[89.225553] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.240320] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.247166] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.255444] [001/132] (960s left) kms_pm_rpm (system-suspend-idle)
[91.275588] Starting subtest: system-suspend-idle
[108.508943] Subtest system-suspend-idle: SUCCESS (2.397s)
[121.974326] [002/132] (940s left) dmabuf_sync_file (export-multiwait)
[122.182766] Starting subtest: export-multiwait
[122.189668] Subtest export-multiwait: SUCCESS (0.008s)
[122.338096] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[122.344918] [003/132] (940s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[122.558276] Starting subtest: x-tiled-8bpp-rotate-180
[125.960240] Subtest x-tiled-8bpp-rotate-180: SUCCESS (3.344s)
[126.292460] [004/132] (936s left) kms_content_protection (uevent)
[126.485655] Starting subtest: uevent
[126.507895] Subtest uevent: SKIP (0.011s)
[126.755921] [005/132] (936s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[126.904621] Starting subtest: invalid-signal-one-illegal-handle
[126.909204] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.003s)
[127.102291] [006/132] (936s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[127.455595] Starting subtest: invalid-modeset-force-ultra-joiner
[127.464100] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[127.749131] [007/132] (935s left) gem_exec_balancer (parallel-ordering)
[128.125362] Subtest parallel-ordering: SKIP (0.000s)
[128.283936] [008/132] (935s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[128.436606] Starting subtest: yf-tiled-ccs-to-x-tiled
[128.441715] Starting dynamic subtest: smem
[128.692233] Dynamic subtest smem: SUCCESS (0.253s)
[128.696030] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.256s)
[128.972541] [009/132] (934s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[129.154052] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[129.160927] Starting dynamic subtest: pipe-A
[130.254704] Dynamic subtest pipe-A: SUCCESS (1.090s)
[130.278715] Starting dynamic subtest: pipe-B
[131.402546] Dynamic subtest pipe-B: SUCCESS (1.140s)
[131.426931] Starting dynamic subtest: pipe-C
[131.849952] Dynamic subtest pipe-C: SUCCESS (0.443s)
[131.854291] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (2.675s)
[132.410524] [010/132] (931s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[132.600490] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[132.722875] [011/132] (931s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[132.913736] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[139.443032] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (6.501s)
[139.749022] [012/132] (924s left) gem_ctx_shared (detached-shared-gtt)
[139.891873] Starting subtest: detached-shared-gtt
[142.057763] Subtest detached-shared-gtt: SUCCESS (2.153s)
[142.538933] [013/132] (921s left) prime_vgem (shrink)
[142.674762] Starting subtest: shrink
[142.707532] Subtest shrink: SUCCESS (0.027s)
[142.871058] [014/132] (921s left) gem_fence_thrash (bo-write-verify-y)
[142.977082] Starting subtest: bo-write-verify-y
[144.151051] Subtest bo-write-verify-y: SUCCESS (1.173s)
[144.307183] [015/132] (920s left) kms_color (deep-color)
[144.492994] Starting subtest: deep-color
[144.500080] Subtest deep-color: SKIP (0.000s)
[144.658830] [016/132] (919s left) kms_rotation_crc (sprite-rotation-90)
[144.850592] Starting subtest: sprite-rotation-90
[159.751759] Subtest sprite-rotation-90: SUCCESS (14.892s)
[160.018930] [017/132] (904s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[160.201817] Starting subtest: cursorA-vs-flipA-varying-size
[171.624972] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.306s)
[172.246844] [018/132] (892s left) gem_lmem_swapping (parallel-random)
[172.842536] Subtest parallel-random: SKIP (0.000s)
[173.130330] [019/132] (892s left) kms_flip (2x-flip-vs-dpms)
[173.312832] Starting subtest: 2x-flip-vs-dpms
[173.316560] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[175.152668] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.829s)
[175.176716] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[176.537817] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.376s)
[176.564540] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[177.947815] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.402s)
[177.952945] Subtest 2x-flip-vs-dpms: SUCCESS (4.628s)
[178.274562] [020/132] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[178.515382] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[178.522388] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[178.672043] [021/132] (887s left) gem_ctx_exec (basic)
[178.780493] Starting subtest: basic
[178.791512] Subtest basic: SUCCESS (0.005s)
[178.957408] [022/132] (886s left) gem_exec_fence (parallel)
[179.213576] Starting subtest: parallel
[179.217218] Starting dynamic subtest: rcs0
[181.378134] Dynamic subtest rcs0: SUCCESS (2.154s)
[181.407067] Starting dynamic subtest: bcs0
[183.539791] Dynamic subtest bcs0: SUCCESS (2.157s)
[183.570102] Starting dynamic subtest: vcs0
[185.695859] Dynamic subtest vcs0: SUCCESS (2.154s)
[185.725257] Starting dynamic subtest: vecs0
[187.850542] Dynamic subtest vecs0: SUCCESS (2.158s)
[187.854330] Subtest parallel: SUCCESS (8.635s)
[188.592985] [023/132] (877s left) fbdev (pan)
[188.702023] Starting subtest: pan
[188.746625] Subtest pan: SUCCESS (0.050s)
[188.896181] [024/132] (877s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[189.015265] Starting subtest: writes-after-reads-uncached
[210.073367] Subtest writes-after-reads-uncached: SUCCESS (21.051s)
[210.241115] [025/132] (855s left) kms_chamelium_edid (dp-edid-read)
[210.963360] Subtest dp-edid-read: SKIP (0.000s)
[211.647310] [026/132] (855s left) perf_pmu (rc6)
[212.055240] Starting subtest: rc6
[212.205172] Starting dynamic subtest: gt0
[218.161548] Dynamic subtest gt0: SUCCESS (6.357s)
[218.202879] Starting dynamic subtest: runtime-pm-gt0
[226.029008] Dynamic subtest runtime-pm-gt0: SUCCESS (7.883s)
[226.054140] Starting dynamic subtest: runtime-pm-long-gt0
[238.470648] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.454s)
[238.499949] Starting dynamic subtest: other-idle-gt0
[238.506359] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[238.509854] Subtest rc6: SUCCESS (26.707s)
[240.133384] [027/132] (826s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[240.345557] Starting subtest: y-tiled-64bpp-rotate-270
[240.691069] Subtest y-tiled-64bpp-rotate-270: SKIP (0.341s)
[240.944785] [028/132] (825s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[241.168260] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[241.176176] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[241.304436] [029/132] (825s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[241.924544] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[242.238307] [030/132] (824s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[242.462545] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[243.509514] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.048s)
[243.807112] [031/132] (823s left) gem_exec_schedule (pi-userfault)
[244.072701] Starting subtest: pi-userfault
[244.076591] Starting dynamic subtest: rcs0
[244.089645] Dynamic subtest rcs0: SUCCESS (0.015s)
[244.127774] Starting dynamic subtest: bcs0
[244.134153] Dynamic subtest bcs0: SUCCESS (0.011s)
[244.160042] Starting dynamic subtest: vcs0
[244.164696] Dynamic subtest vcs0: SUCCESS (0.009s)
[244.190163] Starting dynamic subtest: vecs0
[244.194498] Dynamic subtest vecs0: SUCCESS (0.010s)
[244.198955] Subtest pi-userfault: SUCCESS (0.060s)
[244.381107] [032/132] (822s left) gem_exec_reloc (basic-cpu-read-active)
[244.519576] Starting subtest: basic-cpu-read-active
[244.666798] Subtest basic-cpu-read-active: SUCCESS (0.143s)
[244.872672] [033/132] (822s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[245.087528] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[247.797508] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SUCCESS (2.720s)
[247.977436] [034/132] (819s left) kms_psr (fbc-psr2-suspend)
[248.172503] Subtest fbc-psr2-suspend: SKIP (0.000s)
[248.307852] [035/132] (819s left) kms_dp_linktrain_fallback (dp-fallback)
[248.500771] Starting subtest: dp-fallback
[248.518556] Subtest dp-fallback: SKIP (0.001s)
[248.625190] [036/132] (819s left) gem_exec_schedule (u-independent)
[248.777492] Starting subtest: u-independent
[248.782218] Starting dynamic subtest: rcs0
[248.915707] Dynamic subtest rcs0: SUCCESS (0.144s)
[248.943748] Starting dynamic subtest: bcs0
[249.066369] Dynamic subtest bcs0: SUCCESS (0.150s)
[249.099434] Starting dynamic subtest: vcs0
[249.213525] Dynamic subtest vcs0: SUCCESS (0.142s)
[249.241796] Starting dynamic subtest: vecs0
[249.356389] Dynamic subtest vecs0: SUCCESS (0.137s)
[249.360653] Subtest u-independent: SUCCESS (0.591s)
[249.713235] [037/132] (818s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[249.900690] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[249.904158] Starting dynamic subtest: pipe-A-HDMI-A-1
[249.942715] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[249.994771] Starting dynamic subtest: pipe-A-HDMI-A-2
[250.032699] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[250.059699] Starting dynamic subtest: pipe-B-HDMI-A-1
[250.091967] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[250.116845] Starting dynamic subtest: pipe-B-HDMI-A-2
[250.148960] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[250.173613] Starting dynamic subtest: pipe-C-HDMI-A-1
[250.206141] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[250.231624] Starting dynamic subtest: pipe-C-HDMI-A-2
[250.263387] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[250.269850] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.041s)
[250.941879] [038/132] (817s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[251.163645] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[251.416944] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.249s)
[251.682744] [039/132] (816s left) gem_flink_race (flink_name)
[251.791894] Starting subtest: flink_name
[257.170560] Subtest flink_name: SUCCESS (5.373s)
[257.290786] [040/132] (810s left) kms_pm_rpm (cursor)
[259.204008] Starting subtest: cursor
[261.189679] Subtest cursor: SUCCESS (1.986s)
[261.598398] [041/132] (806s left) kms_flip (blocking-wf_vblank)
[261.790589] Starting subtest: blocking-wf_vblank
[261.796554] Starting dynamic subtest: A-HDMI-A1
[267.894945] Dynamic subtest A-HDMI-A1: SUCCESS (6.101s)
[267.925261] Starting dynamic subtest: B-HDMI-A1
[273.728650] Dynamic subtest B-HDMI-A1: SUCCESS (5.828s)
[273.759280] Starting dynamic subtest: C-HDMI-A1
[279.412313] Dynamic subtest C-HDMI-A1: SUCCESS (5.677s)
[279.439987] Starting dynamic subtest: A-HDMI-A2
[285.265083] Dynamic subtest A-HDMI-A2: SUCCESS (5.847s)
[285.292173] Starting dynamic subtest: B-HDMI-A2
[291.084803] Dynamic subtest B-HDMI-A2: SUCCESS (5.814s)
[291.121438] Starting dynamic subtest: C-HDMI-A2
[296.915544] Dynamic subtest C-HDMI-A2: SUCCESS (5.820s)
[296.920639] Subtest blocking-wf_vblank: SUCCESS (35.131s)
[297.462608] [042/132] (771s left) i915_module_load (reload-no-display)
[297.566141] Starting subtest: reload-no-display
[302.031199] Subtest reload-no-display: SUCCESS (4.468s)
[302.105876] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[302.108790] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[302.115422] [043/132] (766s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[305.142263] Starting subtest: addfb25-x-tiled-mismatch-legacy
[305.147453] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.003s)
[305.269027] [FACT kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[305.272075] [FACT kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)] new: kernel.kmod_is_loaded.i915: true
[305.285001] [044/132] (763s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[305.406726] Starting subtest: etime-single-wait-all-for-submit-submitted
[305.510035] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[305.631928] [045/132] (763s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[305.866079] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[305.873095] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[305.999992] [046/132] (762s left) syncobj_wait (multi-wait-submitted)
[306.116044] Starting subtest: multi-wait-submitted
[306.221578] Subtest multi-wait-submitted: SUCCESS (0.103s)
[306.342764] [047/132] (762s left) gem_mmap_gtt (big-copy)
[306.454925] Starting subtest: big-copy
[314.868045] Subtest big-copy: SUCCESS (8.412s)
[315.003313] [048/132] (754s left) gem_flink_basic (bad-flink)
[315.256317] Starting subtest: bad-flink
[315.259872] Subtest bad-flink: SUCCESS (0.000s)
[315.375908] [049/132] (753s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[315.526783] Starting subtest: single-wait-for-submit-available-submitted
[315.530064] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[315.640665] [050/132] (753s left) kms_frontbuffer_tracking (psr-1p-rte)
[315.871960] Starting subtest: psr-1p-rte
[315.880052] Subtest psr-1p-rte: SKIP (0.000s)
[315.999457] [051/132] (753s left) kms_hdr (bpc-switch-dpms)
[316.198519] Starting subtest: bpc-switch-dpms
[344.738752] Subtest bpc-switch-dpms: SKIP (28.522s)
[345.180729] [052/132] (724s left) gem_exec_reloc (basic-concurrent16)
[345.346329] Starting subtest: basic-concurrent16
[350.824913] Subtest basic-concurrent16: SUCCESS (5.482s)
[351.044018] [053/132] (718s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[351.231551] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[351.236563] Starting dynamic subtest: pipe-A-HDMI-A-1
[351.286046] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[351.342961] Starting dynamic subtest: pipe-A-HDMI-A-2
[351.414566] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[351.440112] Starting dynamic subtest: pipe-B-HDMI-A-1
[351.482221] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[351.508791] Starting dynamic subtest: pipe-B-HDMI-A-2
[351.542455] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[351.567819] Starting dynamic subtest: pipe-C-HDMI-A-1
[351.600502] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[351.625606] Starting dynamic subtest: pipe-C-HDMI-A-2
[351.657586] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[351.664808] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.034s)
[352.708513] [054/132] (717s left) kms_addfb_basic (invalid-get-prop)
[353.173664] Starting subtest: invalid-get-prop
[353.243401] Subtest invalid-get-prop: SUCCESS (0.000s)
[353.624530] [055/132] (716s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[353.838086] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[356.785717] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.954s)
[357.084656] [056/132] (713s left) syncobj_wait (signal)
[357.201694] Starting subtest: signal
[357.206183] Subtest signal: SUCCESS (0.001s)
[357.324689] [057/132] (713s left) kms_cursor_crc (cursor-onscreen-256x256)
[357.551759] Starting subtest: cursor-onscreen-256x256
[357.605555] Starting dynamic subtest: pipe-A-HDMI-A-1
[360.406987] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.798s)
[360.535821] Starting dynamic subtest: pipe-C-HDMI-A-1
[362.862370] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.380s)
[362.867116] Subtest cursor-onscreen-256x256: SUCCESS (5.311s)
[363.156039] [058/132] (707s left) kms_flip (2x-flip-vs-suspend-interruptible)
[363.379813] Starting subtest: 2x-flip-vs-suspend-interruptible
[363.384610] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2