[91.479718] Initializing watchdogs
[91.479943]   /dev/watchdog0
[91.517953] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.532509] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.539513] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.545128] [001/133] (960s left) gem_exec_reloc (basic-cpu-wc-active)
[91.687164] Starting subtest: basic-cpu-wc-active
[91.844343] Subtest basic-cpu-wc-active: SUCCESS (0.158s)
[92.083722] [002/133] (960s left) gem_mmap_offset (blt-coherency)
[92.215288] Starting subtest: blt-coherency
[92.233150] Subtest blt-coherency: SUCCESS (0.019s)
[92.380352] [003/133] (959s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[92.506537] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[92.509694] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[92.791228] [004/133] (959s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[92.981108] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[93.088954] [005/133] (959s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[95.063884] Starting subtest: gem-execbuf-stress-pc8
[95.120327] Subtest gem-execbuf-stress-pc8: SKIP (0.051s)
[95.435924] [006/133] (957s left) kms_content_protection (legacy-hdcp14)
[95.641351] Starting subtest: legacy-hdcp14
[95.690083] Subtest legacy-hdcp14: SKIP (0.044s)
[95.848888] [007/133] (956s left) kms_big_fb (linear-32bpp-rotate-180)
[96.050115] Starting subtest: linear-32bpp-rotate-180
[100.889474] Subtest linear-32bpp-rotate-180: SUCCESS (4.836s)
[101.291233] [008/133] (951s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[101.495155] Starting subtest: cursor-rapid-movement-128x128
[101.559355] Starting dynamic subtest: pipe-A-HDMI-A-1
[102.545177] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.982s)
[102.661621] Starting dynamic subtest: pipe-C-HDMI-A-1
[103.238586] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.608s)
[103.240190] Subtest cursor-rapid-movement-128x128: SUCCESS (1.744s)
[103.611926] [009/133] (949s left) kms_feature_discovery (dp-mst)
[103.806995] Starting subtest: dp-mst
[103.813235] Subtest dp-mst: SKIP (0.001s)
[103.948553] [010/133] (948s left) gem_mmap_gtt (big-bo)
[104.060555] Starting subtest: big-bo
[104.917113] Subtest big-bo: SUCCESS (0.857s)
[105.105200] [011/133] (947s left) kms_lease (lease-again)
[105.445205] Starting subtest: lease-again
[105.461174] Starting dynamic subtest: pipe-A-HDMI-A-1
[105.483286] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.020s)
[105.570681] Starting dynamic subtest: pipe-A-HDMI-A-2
[105.576070] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.023s)
[105.638170] Starting dynamic subtest: pipe-B-HDMI-A-1
[105.642113] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.009s)
[105.699073] Starting dynamic subtest: pipe-B-HDMI-A-2
[105.701054] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.012s)
[105.737079] Starting dynamic subtest: pipe-C-HDMI-A-1
[105.741612] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.028s)
[105.761096] Starting dynamic subtest: pipe-C-HDMI-A-2
[105.762695] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.017s)
[105.764208] Subtest lease-again: SUCCESS (0.192s)
[105.834115] [012/133] (947s left) gem_mmap_wc (set-cache-level)
[105.940899] Starting subtest: set-cache-level
[105.946351] Subtest set-cache-level: SUCCESS (0.006s)
[106.087254] [013/133] (947s left) kms_rotation_crc (sprite-rotation-90)
[106.275083] Starting subtest: sprite-rotation-90
[121.051319] Subtest sprite-rotation-90: SUCCESS (14.774s)
[121.296501] [014/133] (931s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[121.511334] Starting subtest: 4-tiled-32bpp-rotate-90
[121.514689] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[121.644722] [015/133] (931s left) core_auth (many-magics)
[121.747087] Starting subtest: many-magics
[122.964225] Subtest many-magics: SUCCESS (1.213s)
[123.116496] [016/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[123.318569] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[123.323157] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[123.464138] [017/133] (929s left) kms_getfb (getfb2-handle-protection)
[123.651066] Starting subtest: getfb2-handle-protection
[123.677669] Subtest getfb2-handle-protection: SUCCESS (0.030s)
[123.829380] [018/133] (929s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[124.037670] Starting subtest: fbc-modesetfrombusy
[125.978924] Subtest fbc-modesetfrombusy: SUCCESS (1.939s)
[126.227203] [019/133] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[126.432667] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[126.437924] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[126.560930] [020/133] (927s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[126.749082] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[126.993127] Starting dynamic subtest: pipe-A-plane-0
[127.843375] Dynamic subtest pipe-A-plane-0: SUCCESS (0.851s)
[127.862735] Starting dynamic subtest: pipe-A-plane-1
[128.625813] Dynamic subtest pipe-A-plane-1: SUCCESS (0.781s)
[128.644477] Starting dynamic subtest: pipe-A-plane-2
[129.211415] Dynamic subtest pipe-A-plane-2: SUCCESS (0.584s)
[129.230511] Starting dynamic subtest: pipe-A-plane-3
[129.775659] Dynamic subtest pipe-A-plane-3: SUCCESS (0.564s)
[130.187021] Starting dynamic subtest: pipe-B-plane-0
[130.953342] Dynamic subtest pipe-B-plane-0: SUCCESS (0.783s)
[130.972422] Starting dynamic subtest: pipe-B-plane-1
[131.724475] Dynamic subtest pipe-B-plane-1: SUCCESS (0.766s)
[131.748431] Starting dynamic subtest: pipe-B-plane-2
[132.304367] Dynamic subtest pipe-B-plane-2: SUCCESS (0.579s)
[132.323607] Starting dynamic subtest: pipe-B-plane-3
[132.870324] Dynamic subtest pipe-B-plane-3: SUCCESS (0.566s)
[133.125249] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (6.374s)
[133.459079] [021/133] (920s left) syncobj_timeline (wait-for-submit-snapshot)
[133.583076] Starting subtest: wait-for-submit-snapshot
[133.672543] Subtest wait-for-submit-snapshot: SUCCESS (0.089s)
[133.809343] [022/133] (920s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[133.993157] Starting subtest: primary-y-tiled-reflect-x-180
[133.997893] Subtest primary-y-tiled-reflect-x-180: SKIP (0.003s)
[134.124270] [023/133] (919s left) perf_pmu (pmu-read)
[134.242925] Starting subtest: pmu-read
[134.251187] Subtest pmu-read: SUCCESS (0.008s)
[134.390307] [024/133] (919s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[134.580078] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[134.682181] [025/133] (919s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[134.867171] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[134.870072] Starting dynamic subtest: pipe-A-HDMI-A-1
[134.891096] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[134.929241] Starting dynamic subtest: pipe-A-HDMI-A-2
[134.959414] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[134.996582] Starting dynamic subtest: pipe-B-HDMI-A-1
[135.026554] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[135.064336] Starting dynamic subtest: pipe-B-HDMI-A-2
[135.094203] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.003s)
[135.113053] Starting dynamic subtest: pipe-C-HDMI-A-1
[135.128637] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.005s)
[135.147714] Starting dynamic subtest: pipe-C-HDMI-A-2
[135.163842] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[135.166967] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.048s)
[135.896047] [026/133] (918s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[136.103111] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[136.106778] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[136.246092] [027/133] (918s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[136.839298] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[137.120737] [028/133] (917s left) gem_softpin (zero)
[137.245958] Starting subtest: zero
[137.253112] Subtest zero: SUCCESS (0.007s)
[137.387374] [029/133] (917s left) kms_flip (2x-flip-vs-dpms-on-nop)
[137.565051] Starting subtest: 2x-flip-vs-dpms-on-nop
[137.576084] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[139.370264] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.799s)
[139.393558] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[141.063543] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.686s)
[141.085185] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[142.728073] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.659s)
[142.730852] Subtest 2x-flip-vs-dpms-on-nop: SUCCESS (5.161s)
[143.344266] [030/133] (911s left) gen3_render_linear_blits
[143.554697] [031/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[143.752180] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[145.946683] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SUCCESS (2.199s)
[146.162369] [032/133] (908s left) kms_flip (flip-vs-absolute-wf_vblank)
[146.351121] Starting subtest: flip-vs-absolute-wf_vblank
[146.354054] Starting dynamic subtest: A-HDMI-A1
[152.293534] Dynamic subtest A-HDMI-A1: SUCCESS (5.943s)
[152.315394] Starting dynamic subtest: B-HDMI-A1
[158.141134] Dynamic subtest B-HDMI-A1: SUCCESS (5.842s)
[158.161308] Starting dynamic subtest: C-HDMI-A1
[164.006365] Dynamic subtest C-HDMI-A1: SUCCESS (5.866s)
[164.033281] Starting dynamic subtest: A-HDMI-A2
[169.877935] Dynamic subtest A-HDMI-A2: SUCCESS (5.867s)
[169.900400] Starting dynamic subtest: B-HDMI-A2
[175.718841] Dynamic subtest B-HDMI-A2: SUCCESS (5.836s)
[175.740402] Starting dynamic subtest: C-HDMI-A2
[181.419080] Dynamic subtest C-HDMI-A2: SUCCESS (5.692s)
[181.422056] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.069s)
[181.927375] [033/133] (872s left) i915_pm_sseu (full-enable)
[182.497846] Starting subtest: full-enable
[182.514584] Subtest full-enable: SUCCESS (0.017s)
[182.650918] [034/133] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[182.842882] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[182.849091] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[182.994513] [035/133] (871s left) kms_psr (fbc-pr-sprite-plane-move)
[183.180498] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[183.291680] [036/133] (871s left) syncobj_wait (invalid-single-wait-unsubmitted)
[183.405293] Starting subtest: invalid-single-wait-unsubmitted
[183.407254] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[183.548932] [037/133] (871s left) gem_reg_read (timestamp-moving)
[183.649064] Starting subtest: timestamp-moving
[184.654079] Subtest timestamp-moving: SUCCESS (1.001s)
[184.784853] [038/133] (870s left) kms_big_fb (y-tiled-addfb)
[184.981111] Starting subtest: y-tiled-addfb
[184.984457] Subtest y-tiled-addfb: SUCCESS (0.001s)
[185.114493] [039/133] (870s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[185.321799] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[187.864985] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.544s)
[188.049246] [040/133] (867s left) i915_pm_freq_api (freq-basic-api)
[188.167086] Subtest freq-basic-api: SKIP (0.000s)
[188.272527] [041/133] (867s left) syncobj_timeline (invalid-wait-bad-flags)
[188.374419] Starting subtest: invalid-wait-bad-flags
[188.377263] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[188.547614] [042/133] (867s left) gem_pxp (create-regular-context-2)
[191.193533] Starting subtest: create-regular-context-2
[191.197272] Subtest create-regular-context-2: SKIP (0.000s)
[191.332611] [043/133] (864s left) gem_ctx_shared (disjoint-timelines)
[191.455612] Starting subtest: disjoint-timelines
[191.548900] Subtest disjoint-timelines: SUCCESS (0.093s)
[191.826984] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[191.832858] [044/133] (863s left) gem_ctx_persistence (heartbeat-stop)
[191.948103] Starting subtest: heartbeat-stop
[192.097695] Subtest heartbeat-stop: SUCCESS (0.148s)
[192.247284] [045/133] (863s left) kms_vblank (ts-continuation-suspend)
[192.438980] Starting subtest: ts-continuation-suspend
[192.442112] Starting dynamic subtest: pipe-A-HDMI-A-1