[114.391953] Initializing watchdogs
[114.392214]   /dev/watchdog0
[114.432444] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[114.447675] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[114.454737] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[114.463349] [001/133] (960s left) kms_setmode (clone-exclusive-crtc)
[114.593253] Starting subtest: clone-exclusive-crtc
[115.148495] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[115.491894] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.335s)
[116.000380] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[116.322548] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.330s)
[116.799428] Subtest clone-exclusive-crtc: SUCCESS (2.208s)
[117.185193] [002/133] (957s left) kms_content_protection (dp-mst-type-1)
[117.394322] Starting subtest: dp-mst-type-1
[117.401784] Subtest dp-mst-type-1: SKIP (0.000s)
[117.552973] [003/133] (957s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[117.749216] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[117.848603] [004/133] (957s left) kms_setmode (basic)
[117.978312] Starting subtest: basic
[118.448405] Starting dynamic subtest: pipe-A-HDMI-A-1
[120.610121] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.151s)
[120.873325] Starting dynamic subtest: pipe-B-HDMI-A-1
[123.008097] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.144s)
[123.257483] Starting dynamic subtest: pipe-A-HDMI-A-2
[125.389206] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.145s)
[125.657039] Starting dynamic subtest: pipe-B-HDMI-A-2
[127.788463] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.145s)
[128.057502] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[130.376975] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (2.329s)
[130.878710] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[133.205101] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (2.337s)
[133.666260] Subtest basic: SUCCESS (15.703s)
[134.037134] [005/133] (941s left) perf (gen8-unprivileged-single-ctx-counters)
[134.286225] Starting subtest: gen8-unprivileged-single-ctx-counters
[134.412951] Subtest gen8-unprivileged-single-ctx-counters: SUCCESS (0.134s)
[134.519140] [006/133] (940s left) syncobj_wait (wait-any-snapshot)
[134.633471] Starting subtest: wait-any-snapshot
[134.719106] Subtest wait-any-snapshot: SUCCESS (0.086s)
[134.850296] [007/133] (940s left) i915_hangman (gt-engine-error)
[134.984102] Starting subtest: gt-engine-error
[134.988053] Starting dynamic subtest: rcs0
[135.072075] Dynamic subtest rcs0: SUCCESS (0.086s)
[135.096442] Starting dynamic subtest: bcs0
[135.102859] Dynamic subtest bcs0: SKIP (0.006s)
[135.131077] Starting dynamic subtest: vcs0
[135.154394] Dynamic subtest vcs0: SUCCESS (0.076s)
[135.175535] Starting dynamic subtest: vecs0
[135.230924] Dynamic subtest vecs0: SUCCESS (0.074s)
[135.234309] Subtest gt-engine-error: SUCCESS (0.249s)
[135.397821] [008/133] (940s left) gem_exec_schedule (semaphore-power)
[135.675645] Starting subtest: semaphore-power
[136.561369] Subtest semaphore-power: SUCCESS (0.879s)
[136.818791] [009/133] (938s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[137.057230] Starting subtest: extended-modeset-hang-newfb-with-reset
[137.063202] Starting dynamic subtest: pipe-A
[140.696327] Dynamic subtest pipe-A: SUCCESS (3.633s)
[140.732248] Starting dynamic subtest: pipe-C
[144.079369] Dynamic subtest pipe-C: SUCCESS (3.377s)
[144.087095] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (7.027s)
[144.456804] [010/133] (931s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[145.038068] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[145.391388] [011/133] (930s left) gem_mmap_wc (bad-size)
[145.509103] Starting subtest: bad-size
[145.513719] Subtest bad-size: SUCCESS (0.002s)
[145.650396] [012/133] (930s left) gem_softpin (noreloc-interruptible)
[145.781993] Starting subtest: noreloc-interruptible
[151.320883] Subtest noreloc-interruptible: SUCCESS (5.540s)
[151.509498] [013/133] (924s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[151.620569] Starting subtest: cpuset-basic-small-copy-odd
[156.927741] Subtest cpuset-basic-small-copy-odd: SUCCESS (5.306s)
[157.088457] [014/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[157.477868] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[157.485328] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[157.615239] [015/133] (918s left) kms_psr (psr-sprite-plane-move)
[157.818259] Subtest psr-sprite-plane-move: SKIP (0.000s)
[157.923675] [016/133] (918s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[158.126114] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[158.130056] Starting dynamic subtest: pipe-A-HDMI-A-1
[158.146320] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[158.193181] Starting dynamic subtest: pipe-A-HDMI-A-2
[158.214982] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[158.261410] Starting dynamic subtest: pipe-B-HDMI-A-1
[158.280080] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[158.303794] Starting dynamic subtest: pipe-B-HDMI-A-2
[158.317352] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[158.338975] Starting dynamic subtest: pipe-C-HDMI-A-1
[158.352541] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[158.374280] Starting dynamic subtest: pipe-C-HDMI-A-2
[158.386927] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[158.393422] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.021s)
[159.143709] [017/133] (917s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[159.276444] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[159.280711] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.003s)
[159.426422] [018/133] (917s left) gem_exec_balancer (bonded-true-hang)
[159.683193] Starting subtest: bonded-true-hang
[164.062032] Subtest bonded-true-hang: SUCCESS (4.380s)
[164.226485] [019/133] (912s left) gem_ctx_param (set-priority-invalid-size)
[164.335156] Starting subtest: set-priority-invalid-size
[164.338549] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[164.476304] [020/133] (912s left) gem_exec_reloc (basic-cpu-read-noreloc)
[164.604233] Starting subtest: basic-cpu-read-noreloc
[164.612061] Subtest basic-cpu-read-noreloc: SUCCESS (0.010s)
[164.844744] [021/133] (912s left) perf_pmu (invalid-open)
[164.965087] Starting subtest: invalid-open
[164.968376] Subtest invalid-open: SUCCESS (0.001s)
[165.105592] [022/133] (911s left) api_intel_bb (blit-reloc-keep-cache)
[165.214885] Starting subtest: blit-reloc-keep-cache
[165.232192] Subtest blit-reloc-keep-cache: SUCCESS (0.020s)
[165.404502] [023/133] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[165.614497] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[165.621609] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[165.758968] [024/133] (911s left) gem_create (create-invalid-size)
[165.876421] Starting subtest: create-invalid-size
[165.880324] Subtest create-invalid-size: SUCCESS (0.000s)
[166.139434] [025/133] (911s left) gem_ctx_param (invalid-get-engines)
[166.245327] Starting subtest: invalid-get-engines
[166.249080] Subtest invalid-get-engines: SUCCESS (0.000s)
[166.393682] [026/133] (910s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[166.583692] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[166.590325] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[166.723753] [027/133] (910s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[166.837580] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[166.943097] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[167.092510] [028/133] (910s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[167.305338] Starting subtest: 4-tiled-8bpp-rotate-270
[167.313343] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[167.456088] [029/133] (910s left) gen7_exec_parse (oacontrol-tracking)
[167.580305] Subtest oacontrol-tracking: SKIP (0.000s)
[167.695403] [030/133] (910s left) prime_vgem (basic-blt)
[167.924358] Starting subtest: basic-blt
[167.987318] Subtest basic-blt: SUCCESS (0.061s)
[168.146045] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[168.153315] [031/133] (909s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[168.333585] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[168.338254] Starting dynamic subtest: pipe-A-HDMI-A-1
[168.397195] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[168.446079] Starting dynamic subtest: pipe-A-HDMI-A-2
[168.493116] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[168.515918] Starting dynamic subtest: pipe-B-HDMI-A-1
[168.549083] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[168.571539] Starting dynamic subtest: pipe-B-HDMI-A-2
[168.605072] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[168.627312] Starting dynamic subtest: pipe-C-HDMI-A-1
[168.661323] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[168.684325] Starting dynamic subtest: pipe-C-HDMI-A-2
[168.715969] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[168.722241] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.020s)
[169.367909] [032/133] (908s left) kms_vblank (query-forked-busy-hang)
[169.557330] Starting subtest: query-forked-busy-hang
[169.561120] Starting dynamic subtest: pipe-A-HDMI-A-1
[176.864055] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.304s)
[176.895416] Starting dynamic subtest: pipe-A-HDMI-A-2
[183.898590] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.024s)
[183.936635] Starting dynamic subtest: pipe-C-HDMI-A-1
[190.853828] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.943s)
[190.884586] Starting dynamic subtest: pipe-C-HDMI-A-2
[197.892262] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.032s)
[197.895974] Subtest query-forked-busy-hang: SUCCESS (28.336s)
[198.242700] [033/133] (879s left) kms_3d (basic)
[198.363466] Starting subtest: basic
[203.527961] Subtest basic: SUCCESS (5.170s)
[204.048730] [034/133] (874s left) kms_psr (pr-sprite-blt)
[204.262023] Subtest pr-sprite-blt: SKIP (0.000s)
[204.381897] [035/133] (873s left) kms_properties (colorop-properties-atomic)
[204.580068] Starting subtest: colorop-properties-atomic
[204.585058] Starting dynamic subtest: pipe-A-HDMI-A-1
[205.091705] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.516s)
[205.129279] Starting dynamic subtest: pipe-A-HDMI-A-2
[205.474121] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.374s)
[205.505060] Starting dynamic subtest: pipe-B-HDMI-A-1
[205.822405] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.340s)
[205.855392] Starting dynamic subtest: pipe-B-HDMI-A-2
[206.156203] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.335s)
[206.205724] Starting dynamic subtest: pipe-C-HDMI-A-1
[206.498289] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.335s)
[206.542626] Starting dynamic subtest: pipe-C-HDMI-A-2
[206.905329] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.397s)
[206.910660] Subtest colorop-properties-atomic: SUCCESS (2.330s)
[207.297330] [036/133] (871s left) gem_workarounds (suspend-resume-context)
[207.452956] Starting subtest: suspend-resume-context