[96.376142] Initializing watchdogs
[96.376326]   /dev/watchdog0
[96.416968] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[96.432163] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[96.439728] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[96.447676] [001/133] (960s left) kms_cursor_crc (cursor-sliding-128x128)
[96.672066] Starting subtest: cursor-sliding-128x128
[96.749927] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.098548] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.348s)
[101.200083] Starting dynamic subtest: pipe-C-HDMI-A-1
[104.969102] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.797s)
[104.975667] Subtest cursor-sliding-128x128: SUCCESS (8.292s)
[105.284774] [002/133] (951s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[105.504275] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[105.510399] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[105.648364] [003/133] (951s left) gen7_exec_parse (basic-offset)
[105.779709] Subtest basic-offset: SKIP (0.000s)
[105.887241] [004/133] (951s left) gem_mmap_gtt (hang-busy)
[105.994224] Starting subtest: hang-busy
[121.047145] Subtest hang-busy: SUCCESS (15.048s)
[121.198538] [005/133] (936s left) perf_pmu (busy-check-all)
[121.318527] Starting subtest: busy-check-all
[121.321814] Starting dynamic subtest: rcs0
[121.855762] Dynamic subtest rcs0: SUCCESS (0.535s)
[121.877393] Starting dynamic subtest: bcs0
[122.386524] Dynamic subtest bcs0: SUCCESS (0.530s)
[122.407196] Starting dynamic subtest: vcs0
[122.919996] Dynamic subtest vcs0: SUCCESS (0.532s)
[122.941761] Starting dynamic subtest: vecs0
[123.447626] Dynamic subtest vecs0: SUCCESS (0.531s)
[123.452734] Subtest busy-check-all: SUCCESS (2.132s)
[123.583423] [006/133] (933s left) kms_cursor_crc (cursor-tearing-position-change)
[123.774036] Starting subtest: cursor-tearing-position-change
[123.776987] Starting dynamic subtest: pipe-A-HDMI-A-1
[124.626989] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.850s)
[124.674675] Starting dynamic subtest: pipe-C-HDMI-A-1
[125.165022] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.531s)
[125.168952] Subtest cursor-tearing-position-change: SUCCESS (1.394s)
[125.488268] [007/133] (932s left) kms_atomic_transition (plane-all-modeset-transition)
[125.686056] Starting subtest: plane-all-modeset-transition
[125.689345] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.016169] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (44.327s)
[170.212336] Starting dynamic subtest: pipe-A-HDMI-A-2
[214.208987] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (44.015s)
[214.405868] Starting dynamic subtest: pipe-B-HDMI-A-1
[255.040130] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (40.655s)
[255.220197] Starting dynamic subtest: pipe-B-HDMI-A-2
[295.856865] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (40.654s)
[296.014575] Subtest plane-all-modeset-transition: SUCCESS (170.327s)
[296.411415] [008/133] (761s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[296.521853] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[296.629770] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[296.769288] [009/133] (760s left) perf (invalid-remove-userspace-config)
[296.976089] Starting subtest: invalid-remove-userspace-config
[297.009710] Subtest invalid-remove-userspace-config: SUCCESS (0.032s)
[297.101476] [010/133] (760s left) gem_lmem_swapping (parallel-random-verify)
[297.222181] Subtest parallel-random-verify: SKIP (0.000s)
[297.326134] [011/133] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[297.548747] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[297.556185] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[297.673148] [012/133] (760s left) i915_drm_fdinfo (most-busy-check-all)
[297.798898] Starting subtest: most-busy-check-all
[297.805041] Starting dynamic subtest: rcs0
[298.333719] Dynamic subtest rcs0: SUCCESS (0.535s)
[298.356941] Starting dynamic subtest: bcs0
[298.858905] Dynamic subtest bcs0: SUCCESS (0.526s)
[298.881823] Starting dynamic subtest: vcs0
[299.390087] Dynamic subtest vcs0: SUCCESS (0.528s)
[299.411682] Starting dynamic subtest: vecs0
[299.915184] Dynamic subtest vecs0: SUCCESS (0.524s)
[299.919592] Subtest most-busy-check-all: SUCCESS (2.118s)
[300.053369] [013/133] (758s left) kms_tiled_display (basic-test-pattern)
[300.314096] Starting subtest: basic-test-pattern
[302.134135] Subtest basic-test-pattern: FAIL (1.042s)
[302.219697] [014/133] (755s left) kms_addfb_basic (master-rmfb)
[302.335276] Starting subtest: master-rmfb
[302.340069] Subtest master-rmfb: SUCCESS (0.002s)
[302.506639] [015/133] (755s left) gem_exec_reloc (basic-write-cpu)
[302.628415] Starting subtest: basic-write-cpu
[302.652126] Subtest basic-write-cpu: SUCCESS (0.023s)
[302.821682] [016/133] (755s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[302.971079] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[303.081057] [017/133] (755s left) perf_pmu (semaphore-wait-idle)
[303.204477] Starting subtest: semaphore-wait-idle
[303.208229] Starting dynamic subtest: rcs0
[303.756639] Dynamic subtest rcs0: SUCCESS (0.522s)
[303.821459] Starting dynamic subtest: bcs0
[304.287335] Dynamic subtest bcs0: SUCCESS (0.517s)
[304.355952] Starting dynamic subtest: vcs0
[304.775115] Dynamic subtest vcs0: SUCCESS (0.515s)
[304.795693] Starting dynamic subtest: vecs0
[305.278116] Dynamic subtest vecs0: SUCCESS (0.514s)
[305.281528] Subtest semaphore-wait-idle: SUCCESS (2.079s)
[305.435436] [018/133] (753s left) prime_vgem (basic-write)
[305.671494] Starting subtest: basic-write
[305.777783] Subtest basic-write: SUCCESS (0.103s)
[305.924867] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[305.930609] [019/133] (752s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[306.058992] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[306.062095] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.002s)
[306.244354] [020/133] (752s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[306.382333] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[306.387078] Starting dynamic subtest: pipe-A-HDMI-A-1
[306.402378] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[306.441329] Starting dynamic subtest: pipe-A-HDMI-A-2
[306.456821] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[306.478381] Starting dynamic subtest: pipe-B-HDMI-A-1
[306.492880] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[306.528576] Starting dynamic subtest: pipe-B-HDMI-A-2
[306.541096] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[306.564446] Starting dynamic subtest: pipe-C-HDMI-A-1
[306.576596] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[306.599238] Starting dynamic subtest: pipe-C-HDMI-A-2
[306.611727] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[306.617928] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.022s)
[307.393269] [021/133] (751s left) gem_lmem_swapping (heavy-random)
[307.523075] Subtest heavy-random: SKIP (0.000s)
[307.635361] [022/133] (751s left) syncobj_wait (invalid-signal-bad-pad)
[307.744401] Starting subtest: invalid-signal-bad-pad
[307.749172] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[307.891802] [023/133] (751s left) i915_pm_rps (fence-order)
[308.014291] Starting subtest: fence-order
[310.416337] Subtest fence-order: SUCCESS (2.393s)
[310.607061] [024/133] (748s left) kms_joiner (invalid-modeset-force-big-joiner)
[310.753950] Starting subtest: invalid-modeset-force-big-joiner
[310.761904] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[310.896573] [025/133] (748s left) syncobj_basic (create-signaled)
[311.010222] Starting subtest: create-signaled
[311.014251] Subtest create-signaled: SUCCESS (0.000s)
[311.161403] [026/133] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[311.335992] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[311.344154] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[311.480145] [027/133] (748s left) syncobj_timeline (multi-wait-available-signaled)
[311.602726] Starting subtest: multi-wait-available-signaled
[311.606060] Subtest multi-wait-available-signaled: SUCCESS (0.002s)
[311.743095] [028/133] (747s left) kms_chamelium_hpd (common-hpd-after-suspend)
[312.270112] Subtest common-hpd-after-suspend: SKIP (0.000s)
[312.594509] [029/133] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[312.766045] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[312.773630] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[312.925128] [030/133] (746s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[313.080181] Starting subtest: extended-pageflip-modeset-hang-oldfb
[313.084148] Starting dynamic subtest: pipe-A
[316.839116] Dynamic subtest pipe-A: SUCCESS (3.761s)
[316.866509] Starting dynamic subtest: pipe-C
[320.797126] Dynamic subtest pipe-C: SUCCESS (3.948s)
[320.801830] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (7.724s)
[321.131806] [031/133] (738s left) gem_ctx_shared (single-timeline)
[321.271155] Starting subtest: single-timeline
[321.290309] Subtest single-timeline: SUCCESS (0.014s)
[321.564838] [032/133] (738s left) perf (blocking)
[321.771103] Starting subtest: blocking
[321.775441] Starting dynamic subtest: 0-rcs0
[331.808320] Dynamic subtest 0-rcs0: SUCCESS (10.033s)
[331.814071] Subtest blocking: SUCCESS (10.034s)
[331.912819] [033/133] (728s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[332.033249] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[332.036802] Starting dynamic subtest: smem
[332.269969] Dynamic subtest smem: SUCCESS (0.237s)
[332.273384] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.239s)
[332.532293] [034/133] (727s left) i915_drm_fdinfo (virtual-busy-idle-all)
[332.649886] Starting subtest: virtual-busy-idle-all
[332.653748] Subtest virtual-busy-idle-all: SUCCESS (0.001s)
[332.795884] [035/133] (727s left) gem_eio (in-flight-suspend)
[332.928442] Starting subtest: in-flight-suspend