[94.835191] Initializing watchdogs
[94.835382]   /dev/watchdog0
[94.876251] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[94.891367] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[94.897907] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[94.905989] [001/156] (960s left) prime_mmap_coherency (write)
[95.057195] Starting subtest: write
[100.437332] Subtest write: SUCCESS (5.379s)
[100.612229] [002/156] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[100.849203] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[100.857337] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[100.992100] [003/156] (954s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[101.184067] Starting subtest: plane-primary-toggle-with-vblank-wait
[101.189315] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.695475] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.508s)
[101.957303] Starting dynamic subtest: pipe-A-HDMI-A-2
[102.347377] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.433s)
[102.647378] Starting dynamic subtest: pipe-B-HDMI-A-1
[102.957191] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.354s)
[103.197549] Starting dynamic subtest: pipe-B-HDMI-A-2
[103.512202] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.350s)
[103.714419] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (2.531s)
[104.067336] [004/156] (951s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[104.293155] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[105.942723] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.650s)
[106.250841] [005/156] (949s left) gem_userptr_blits (set-cache-level)
[106.388198] Starting subtest: set-cache-level
[106.392651] Subtest set-cache-level: SUCCESS (0.001s)
[106.582962] [006/156] (949s left) syncobj_eventfd (binary-wait-before-signal)
[106.698812] Starting subtest: binary-wait-before-signal
[106.732770] Subtest binary-wait-before-signal: SUCCESS (0.034s)
[106.863458] [007/156] (949s left) gem_ccs (block-copy-compressed)
[106.989991] Subtest block-copy-compressed: SKIP (0.000s)
[107.122256] [008/156] (948s left) gem_exec_await (wide-contexts)
[107.596690] Starting subtest: wide-contexts
[129.837978] Subtest wide-contexts: SUCCESS (22.228s)
[130.119037] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[130.131134] [009/156] (926s left) kms_chamelium_edid (dp-edid-read)
[130.886044] Subtest dp-edid-read: SKIP (0.000s)
[131.211958] [010/156] (925s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-msflip-blt)
[131.449416] Starting subtest: hdr-1p-primscrn-indfb-msflip-blt
[131.455958] Subtest hdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[131.610304] [011/156] (924s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[131.833761] Starting subtest: fbcpsr-suspend
[131.841489] Subtest fbcpsr-suspend: SKIP (0.000s)
[131.995525] [012/156] (924s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[132.220875] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[132.229237] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[132.375690] [013/156] (924s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[132.573799] Starting subtest: flip-vs-cursor-busy-crc-legacy
[133.533201] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.964s)
[133.879898] [014/156] (922s left) kms_addfb_basic (no-handle)
[133.994203] Starting subtest: no-handle
[133.999094] Subtest no-handle: SUCCESS (0.000s)
[134.230027] [015/156] (922s left) i915_pm_rpm (debugfs-forcewake-user)
[136.168539] Starting subtest: debugfs-forcewake-user
[146.615933] Subtest debugfs-forcewake-user: SUCCESS (10.448s)
[147.085212] [016/156] (909s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[147.303478] Starting subtest: fbcpsr-rgb101010-draw-render
[147.309713] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[147.456642] [017/156] (909s left) kms_cursor_crc (cursor-random-64x64)
[147.659821] Starting subtest: cursor-random-64x64
[147.713501] Starting dynamic subtest: pipe-A-HDMI-A-1
[151.922918] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.212s)
[152.012528] Starting dynamic subtest: pipe-C-HDMI-A-1
[155.889053] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.897s)
[155.893282] Subtest cursor-random-64x64: SUCCESS (8.229s)
[156.281765] [018/156] (900s left) gem_mmap_gtt (basic-read-write-distinct)
[156.402642] Starting subtest: basic-read-write-distinct
[156.408441] Subtest basic-read-write-distinct: SUCCESS (0.012s)
[156.562360] [019/156] (900s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[156.771379] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[156.780140] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[156.930336] [020/156] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[157.147385] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[157.157049] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[157.293883] [021/156] (900s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-onoff)
[157.516533] Starting subtest: hdr-2p-primscrn-spr-indfb-onoff
[157.522840] Subtest hdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[157.677415] [022/156] (899s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[157.899140] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[160.755686] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.870s)
[161.078159] [023/156] (896s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[161.298972] Starting subtest: 4-tiled-8bpp-rotate-90
[161.310456] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[161.448963] [024/156] (896s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[161.644263] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[161.769305] [025/156] (896s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[161.979257] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite
[161.985392] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[162.129717] [026/156] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[162.348188] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[165.242323] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.904s)
[165.442558] [027/156] (892s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt)
[165.653113] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt
[165.661138] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[165.812601] [028/156] (892s left) gem_exec_fence (syncobj-timeline-unused-fence)
[166.538106] Starting subtest: syncobj-timeline-unused-fence
[166.546055] Subtest syncobj-timeline-unused-fence: SUCCESS (0.008s)
[166.828332] [029/156] (891s left) gem_exec_balancer (parallel-out-fence)
[167.081832] Subtest parallel-out-fence: SKIP (0.000s)
[167.243471] [030/156] (891s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[167.427346] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[167.554307] [031/156] (890s left) kms_psr (psr2-cursor-mmap-cpu)
[167.745179] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[167.869731] [032/156] (890s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[168.074582] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[168.082556] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[168.214044] [033/156] (890s left) kms_psr (psr-primary-mmap-cpu)
[168.417560] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[168.539105] [034/156] (890s left) core_getclient (basic)
[168.654991] Starting subtest: basic
[168.659466] Subtest basic: SUCCESS (0.000s)
[168.810260] [035/156] (890s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[169.020158] Starting subtest: fbcpsrhdr-slowdraw
[169.027140] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[169.180661] [036/156] (889s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-onoff)
[169.421185] Starting subtest: hdr-1p-primscrn-spr-indfb-onoff
[169.427731] Subtest hdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[169.580293] [037/156] (889s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[169.801601] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[169.809188] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[169.961556] [038/156] (889s left) kms_draw_crc (fill-fb)
[170.170041] Starting subtest: fill-fb
[170.773504] Subtest fill-fb: SUCCESS (0.612s)
[171.064346] [039/156] (888s left) i915_query (query-topology-matches-eu-total)
[171.184817] Starting subtest: query-topology-matches-eu-total
[171.189951] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[171.326963] [040/156] (888s left) kms_flip (nonblocking-read)
[171.519886] Starting subtest: nonblocking-read
[171.523863] Subtest nonblocking-read: SUCCESS (0.000s)
[171.694959] [041/156] (887s left) kms_atomic (plane-invalid-params)
[171.881191] Starting subtest: plane-invalid-params
[171.885509] Starting dynamic subtest: pipe-A-HDMI-A-1
[172.499416] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.613s)
[172.503683] Subtest plane-invalid-params: SUCCESS (0.618s)
[172.888764] [042/156] (886s left) i915_query (engine-info)
[173.005131] Starting subtest: engine-info
[173.009545] Subtest engine-info: SUCCESS (0.004s)
[173.167465] [043/156] (886s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[173.357993] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[174.525376] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.168s)
[174.977296] [044/156] (884s left) kms_frontbuffer_tracking (fbchdr-1p-indfb-fliptrack-mmap-gtt)
[175.196419] Starting subtest: fbchdr-1p-indfb-fliptrack-mmap-gtt
[175.204448] Subtest fbchdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[175.351436] [045/156] (884s left) i915_drm_fdinfo (busy)
[175.475078] Starting subtest: busy
[175.479657] Starting dynamic subtest: rcs0
[176.016573] Dynamic subtest rcs0: SUCCESS (0.536s)
[176.041871] Starting dynamic subtest: bcs0
[176.554844] Dynamic subtest bcs0: SUCCESS (0.538s)
[176.580109] Starting dynamic subtest: vcs0
[177.094919] Dynamic subtest vcs0: SUCCESS (0.534s)
[177.119905] Starting dynamic subtest: vecs0
[177.623513] Dynamic subtest vecs0: SUCCESS (0.528s)
[177.629051] Subtest busy: SUCCESS (2.143s)
[177.775728] [046/156] (882s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[177.999242] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[178.006473] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[178.151373] [047/156] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[178.368977] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[178.375898] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[178.537267] [048/156] (881s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[179.159447] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[179.482076] [049/156] (881s left) core_setmaster (master-drop-set-root)
[179.681136] Starting subtest: master-drop-set-root
[179.695636] Subtest master-drop-set-root: SUCCESS (0.012s)
[179.837393] [050/156] (880s left) prime_mmap (test_reprime)
[179.951136] Starting subtest: test_reprime
[179.954341] Starting dynamic subtest: test_reprime-smem
[179.964685] Dynamic subtest test_reprime-smem: SUCCESS (0.011s)
[179.968215] Subtest test_reprime: SUCCESS (0.012s)
[180.128554] [051/156] (880s left) perf_pmu (init-wait)
[180.248215] Starting subtest: init-wait
[180.253418] Starting dynamic subtest: rcs0
[180.257564] Dynamic subtest rcs0: SUCCESS (0.003s)
[180.286612] Starting dynamic subtest: bcs0
[180.291382] Dynamic subtest bcs0: SUCCESS (0.002s)
[180.315222] Starting dynamic subtest: vcs0
[180.319823] Dynamic subtest vcs0: SUCCESS (0.001s)
[180.344460] Starting dynamic subtest: vecs0
[180.348374] Dynamic subtest vecs0: SUCCESS (0.001s)
[180.352890] Subtest init-wait: SUCCESS (0.014s)
[180.454557] [052/156] (880s left) gem_exec_params (no-bsd)
[180.580927] Starting subtest: no-bsd
[180.585058] Subtest no-bsd: SUCCESS (0.003s)
[180.744712] [053/156] (880s left) syncobj_timeline (invalid-transfer-bad-pad)
[180.863158] Starting subtest: invalid-transfer-bad-pad
[180.867617] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[181.024587] [054/156] (880s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[181.235516] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[181.243521] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[181.398102] [055/156] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[181.621739] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[184.140059] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.526s)
[184.508952] [056/156] (876s left) gem_gtt_cpu_tlb
[184.807224] [057/156] (876s left) syncobj_timeline (wait-any-complex)
[184.922133] Starting subtest: wait-any-complex
[184.990355] Subtest wait-any-complex: SUCCESS (0.069s)
[185.150794] [058/156] (876s left) kms_frontbuffer_tracking (fbc-suspend)
[185.375529] Starting subtest: fbc-suspend