[86.585419] Initializing watchdogs
[86.585590]   /dev/watchdog0
[86.626203] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[86.640468] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[86.648200] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.656324] [001/133] (960s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[87.248514] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[87.504511] [002/133] (959s left) gem_exec_params (sol-reset-invalid)
[87.629767] Starting subtest: sol-reset-invalid
[87.634654] Subtest sol-reset-invalid: SUCCESS (0.003s)
[87.811253] [003/133] (959s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[88.016166] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[89.850549] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.833s)
[90.111933] [004/133] (957s left) kms_flip (2x-plain-flip)
[90.291120] Starting subtest: 2x-plain-flip
[90.297579] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[91.698679] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.404s)
[91.717124] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[93.043661] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.340s)
[93.061594] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[94.360563] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.308s)
[94.363833] Subtest 2x-plain-flip: SUCCESS (4.067s)
[94.970596] [005/133] (952s left) api_intel_allocator (reloc-allocator)
[95.095692] Starting subtest: reloc-allocator
[95.100027] Starting dynamic subtest: basic
[95.103821] Dynamic subtest basic: SUCCESS (0.007s)
[95.123289] Starting dynamic subtest: parallel-one
[95.126592] Dynamic subtest parallel-one: SUCCESS (0.012s)
[95.145757] Starting dynamic subtest: print
[95.149428] Dynamic subtest print: SUCCESS (0.000s)
[95.167593] Starting dynamic subtest: reuse
[95.171539] Dynamic subtest reuse: SUCCESS (0.002s)
[95.189719] Starting dynamic subtest: fork-reopen-allocator
[95.194214] Dynamic subtest fork-reopen-allocator: SUCCESS (0.040s)
[95.198582] Subtest reloc-allocator: SUCCESS (0.067s)
[95.309965] [006/133] (952s left) i915_drm_fdinfo (busy-idle-check-all)
[95.425056] Starting subtest: busy-idle-check-all
[95.429058] Starting dynamic subtest: rcs0
[96.059627] Dynamic subtest rcs0: SUCCESS (0.633s)
[96.078915] Starting dynamic subtest: bcs0
[96.687826] Dynamic subtest bcs0: SUCCESS (0.628s)
[96.705871] Starting dynamic subtest: vcs0
[97.316673] Dynamic subtest vcs0: SUCCESS (0.628s)
[97.334372] Starting dynamic subtest: vecs0
[97.945551] Dynamic subtest vecs0: SUCCESS (0.625s)
[97.948759] Subtest busy-idle-check-all: SUCCESS (2.517s)
[98.111259] [007/133] (949s left) gem_set_tiling_vs_gtt
[98.661968] [008/133] (949s left) sysfs_preempt_timeout (invalid)
[98.774251] Starting subtest: invalid
[98.777505] Starting dynamic subtest: vecs0
[98.780799] Dynamic subtest vecs0: SUCCESS (0.001s)
[98.800424] Starting dynamic subtest: vcs0
[98.804500] Dynamic subtest vcs0: SUCCESS (0.001s)
[98.823548] Starting dynamic subtest: bcs0
[98.828728] Dynamic subtest bcs0: SUCCESS (0.001s)
[98.850633] Starting dynamic subtest: rcs0
[98.854878] Dynamic subtest rcs0: SUCCESS (0.001s)
[98.858588] Subtest invalid: SUCCESS (0.009s)
[98.974296] [009/133] (948s left) i915_query (hwconfig_table)
[99.080134] Starting subtest: hwconfig_table
[99.086782] Subtest hwconfig_table: SKIP (0.000s)
[99.228913] [010/133] (948s left) kms_flip (2x-blocking-absolute-wf_vblank)
[99.415225] Starting subtest: 2x-blocking-absolute-wf_vblank
[99.418967] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[110.163641] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.744s)
[110.182125] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[120.839531] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.668s)
[120.857420] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[131.503913] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.663s)
[131.507313] Subtest 2x-blocking-absolute-wf_vblank: SUCCESS (32.087s)
[132.118066] [011/133] (915s left) gem_ctx_param (invalid-param-set)
[132.227793] Starting subtest: invalid-param-set
[132.231489] Subtest invalid-param-set: SUCCESS (0.000s)
[132.382813] [012/133] (915s left) gem_mmap_gtt (medium-copy-odd)
[132.486490] Starting subtest: medium-copy-odd
[137.285223] Subtest medium-copy-odd: SUCCESS (4.800s)
[137.457117] [013/133] (910s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[137.818082] Starting subtest: 4-tiled-8bpp-rotate-0
[137.824680] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[137.968724] [014/133] (910s left) sw_sync (sync_random_merge)
[138.091320] Starting subtest: sync_random_merge
[138.274180] Subtest sync_random_merge: SUCCESS (0.184s)
[138.397416] [015/133] (910s left) gem_ctx_create (basic)
[138.543605] Starting subtest: basic
[138.547651] Subtest basic: SUCCESS (0.000s)
[138.801230] [016/133] (909s left) kms_chamelium_frames (dp-crc-multiple)
[139.473684] Subtest dp-crc-multiple: SKIP (0.000s)
[140.063910] [017/133] (908s left) syncobj_wait (single-wait-for-submit-signaled)
[140.675659] Starting subtest: single-wait-for-submit-signaled
[140.680319] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[140.760311] [018/133] (908s left) kms_cursor_crc (cursor-random-max-size)
[140.978461] Starting subtest: cursor-random-max-size
[140.989233] Subtest cursor-random-max-size: SKIP (0.000s)
[141.150146] [019/133] (908s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[141.356115] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[141.362667] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[141.501059] [020/133] (907s left) gem_lmem_swapping (random)
[141.615901] Subtest random: SKIP (0.000s)
[141.712369] [021/133] (907s left) kms_plane_cursor (primary)
[141.880999] Starting subtest: primary
[141.889035] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[144.482887] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.599s)
[144.550965] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[146.968592] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.432s)
[147.037042] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[149.437062] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.414s)
[149.737090] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[152.196321] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.505s)
[152.241913] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[154.660782] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.433s)
[154.710992] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[157.127088] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.433s)
[157.396031] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[159.843816] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.500s)
[159.898175] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[162.311062] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.431s)
[162.362034] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[164.762528] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.416s)
[165.019081] Subtest primary: SUCCESS (23.095s)
[165.270394] [022/133] (884s left) perf_pmu (most-busy-idle-check-all)
[165.386451] Starting subtest: most-busy-idle-check-all
[165.389806] Starting dynamic subtest: rcs0
[166.129975] Dynamic subtest rcs0: SUCCESS (0.628s)
[166.227993] Starting dynamic subtest: bcs0
[166.746605] Dynamic subtest bcs0: SUCCESS (0.618s)
[166.927456] Starting dynamic subtest: vcs0
[167.260977] Dynamic subtest vcs0: SUCCESS (0.622s)
[167.280749] Starting dynamic subtest: vecs0
[167.882744] Dynamic subtest vecs0: SUCCESS (0.622s)
[167.886556] Subtest most-busy-idle-check-all: SUCCESS (2.494s)
[168.044334] [023/133] (881s left) gem_ctx_persistence (legacy-engines-cleanup)
[168.165416] Starting subtest: legacy-engines-cleanup
[168.169600] Starting dynamic subtest: render
[168.184921] Dynamic subtest render: SUCCESS (0.014s)
[168.206024] Starting dynamic subtest: bsd
[168.226053] Dynamic subtest bsd: SUCCESS (0.041s)
[168.247371] Starting dynamic subtest: blt
[168.260469] Dynamic subtest blt: SUCCESS (0.031s)
[168.282466] Starting dynamic subtest: vebox
[168.295096] Dynamic subtest vebox: SUCCESS (0.030s)
[168.298512] Subtest legacy-engines-cleanup: SUCCESS (0.127s)
[168.461964] [024/133] (881s left) gem_partial_pwrite_pread (writes-after-reads-display)
[168.578085] Starting subtest: writes-after-reads-display
[188.329867] Subtest writes-after-reads-display: SUCCESS (19.752s)
[188.495166] [025/133] (861s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[188.696275] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[191.332905] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SUCCESS (2.636s)
[191.562577] [026/133] (858s left) gem_close_race (multigpu-basic-threads)
[191.697070] Starting subtest: multigpu-basic-threads
[191.705593] Subtest multigpu-basic-threads: SKIP (0.000s)
[191.961400] [027/133] (857s left) gem_userptr_blits (unsync-unmap-after-close)
[192.090090] Subtest unsync-unmap-after-close: SKIP (0.000s)
[192.297379] [028/133] (857s left) kms_psr (psr-no-drrs)
[192.489244] Subtest psr-no-drrs: SKIP (0.000s)
[192.592476] [029/133] (857s left) kms_big_fb (linear-32bpp-rotate-0)
[192.796636] Starting subtest: linear-32bpp-rotate-0
[197.544547] Subtest linear-32bpp-rotate-0: SUCCESS (4.750s)
[197.963323] [030/133] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[198.157897] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[198.164861] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[198.331818] [031/133] (851s left) syncobj_timeline (host-signal-points)
[198.439603] Starting subtest: host-signal-points
[198.458507] Subtest host-signal-points: SUCCESS (0.023s)
[198.629282] [032/133] (851s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[198.838389] Starting subtest: fbcpsr-indfb-scaledprimary
[198.847883] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[199.014416] [033/133] (851s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[199.214394] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[199.222425] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[199.379510] [034/133] (851s left) kms_vblank (wait-busy)
[199.564669] Starting subtest: wait-busy
[199.575615] Starting dynamic subtest: pipe-A-HDMI-A-1
[202.556426] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.874s)
[202.621872] Starting dynamic subtest: pipe-A-HDMI-A-2
[205.041752] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.589s)
[205.072216] Starting dynamic subtest: pipe-C-HDMI-A-1
[207.630978] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.579s)
[207.655034] Starting dynamic subtest: pipe-C-HDMI-A-2
[210.257415] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.579s)
[210.263338] Subtest wait-busy: SUCCESS (10.647s)
[210.525106] [035/133] (840s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[210.710638] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[210.714848] Starting dynamic subtest: pipe-A-HDMI-A-1
[210.808124] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[210.830522] Starting dynamic subtest: pipe-A-HDMI-A-2
[210.861156] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[210.882303] Starting dynamic subtest: pipe-B-HDMI-A-1
[210.912275] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[210.933422] Starting dynamic subtest: pipe-B-HDMI-A-2
[210.962905] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[210.983593] Starting dynamic subtest: pipe-C-HDMI-A-1
[211.012614] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[211.033349] Starting dynamic subtest: pipe-C-HDMI-A-2
[211.064881] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[211.070864] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.023s)
[211.669052] [036/133] (839s left) kms_vrr (flip-suspend)
[211.849671] Starting subtest: flip-suspend
[211.865652] Subtest flip-suspend: SKIP (0.000s)
[212.001269] [037/133] (838s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[212.203614] Starting subtest: fbcpsr-slowdraw
[212.210372] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[212.366302] [038/133] (838s left) gem_exec_flush (basic-wb-ro-default)
[212.491243] Starting subtest: basic-wb-ro-default
[217.921333] Subtest basic-wb-ro-default: SUCCESS (5.430s)
[218.214781] [039/133] (832s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[218.403412] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[218.499351] [040/133] (832s left) gem_exec_params (rel-constants-invalid-ring)
[218.617746] Starting subtest: rel-constants-invalid-ring
[218.621975] Subtest rel-constants-invalid-ring: SUCCESS (0.001s)
[218.798583] [041/133] (832s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[218.905121] Starting subtest: single-wait-all-for-submit-available-submitted
[218.908660] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[219.056648] [042/133] (832s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[219.260391] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[221.685384] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.431s)
[221.984763] [043/133] (829s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[222.165202] Starting subtest: 2x-long-cursor-vs-flip-legacy
[273.638597] Subtest 2x-long-cursor-vs-flip-legacy: SUCCESS (51.466s)
[273.930631] [044/133] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[274.148074] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[276.612050] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SUCCESS (2.469s)
[276.840735] [045/133] (774s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[277.041057] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[277.047683] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[277.208526] [046/133] (774s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[277.322545] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[277.425069] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[277.591884] [047/133] (774s left) i915_hangman (gt-error-state-capture)
[277.725239] Starting subtest: gt-error-state-capture
[277.728659] Starting dynamic subtest: rcs0
[287.088740] Dynamic subtest rcs0: SUCCESS (9.362s)
[287.114912] Starting dynamic subtest: bcs0
[297.048314] Dynamic subtest bcs0: SUCCESS (9.954s)
[297.070217] Starting dynamic subtest: vcs0
[307.039866] Dynamic subtest vcs0: SUCCESS (9.991s)
[307.065769] Starting dynamic subtest: vecs0
[317.060053] Dynamic subtest vecs0: SUCCESS (10.013s)
[317.067050] Subtest gt-error-state-capture: SUCCESS (39.335s)
[317.239257] [048/133] (734s left) gem_exec_async (concurrent-writes)
[317.361793] Starting subtest: concurrent-writes
[317.365417] Starting dynamic subtest: rcs0
[317.379956] Dynamic subtest rcs0: SUCCESS (0.016s)
[317.403560] Starting dynamic subtest: bcs0
[317.406882] Dynamic subtest bcs0: SUCCESS (0.011s)
[317.431687] Starting dynamic subtest: vcs0
[317.435915] Dynamic subtest vcs0: SUCCESS (0.014s)
[317.458288] Starting dynamic subtest: vecs0
[317.462131] Dynamic subtest vecs0: SUCCESS (0.012s)
[317.466159] Subtest concurrent-writes: SUCCESS (0.063s)
[317.710323] [049/133] (734s left) gem_eio (in-flight-suspend)
[317.845985] Starting subtest: in-flight-suspend