[139.008743] Initializing watchdogs
[139.008916]   /dev/watchdog0
[139.051553] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[139.067304] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[139.073682] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[139.082256] [001/133] (960s left) kms_plane_cursor (overlay)
[139.310988] Starting subtest: overlay
[139.322307] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[142.003411] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.689s)
[142.091070] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[144.701212] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.633s)
[144.788638] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[147.400201] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.632s)
[147.704374] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[150.336903] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.658s)
[150.405251] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[152.953427] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.567s)
[153.024147] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[155.570502] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.566s)
[155.869059] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[158.535292] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.712s)
[158.614777] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[161.220338] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.631s)
[161.287084] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[163.899756] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.633s)
[164.159401] Subtest overlay: SUCCESS (24.852s)
[164.507278] [002/133] (935s left) perf_pmu (idle-no-semaphores)
[164.653205] Starting subtest: idle-no-semaphores
[164.658922] Starting dynamic subtest: rcs0
[165.171858] Dynamic subtest rcs0: SUCCESS (0.519s)
[165.195301] Starting dynamic subtest: bcs0
[165.688059] Dynamic subtest bcs0: SUCCESS (0.513s)
[165.712556] Starting dynamic subtest: vcs0
[166.203677] Dynamic subtest vcs0: SUCCESS (0.509s)
[166.226969] Starting dynamic subtest: vecs0
[166.717166] Dynamic subtest vecs0: SUCCESS (0.513s)
[166.722188] Subtest idle-no-semaphores: SUCCESS (2.066s)
[166.860378] [003/133] (932s left) kms_panel_fitting (legacy)
[167.054225] Starting subtest: legacy
[167.062089] Subtest legacy: SKIP (0.000s)
[167.208529] [004/133] (932s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[167.407213] Starting subtest: flip-vs-cursor-busy-crc-atomic
[168.525606] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (1.120s)
[168.881429] [005/133] (931s left) gem_mmap_gtt (flink-race)
[169.003312] Starting subtest: flink-race
[189.076264] Subtest flink-race: SUCCESS (20.070s)
[189.224208] [006/133] (910s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[189.448830] Starting subtest: x-tiled-8bpp-rotate-90
[189.815886] Subtest x-tiled-8bpp-rotate-90: SKIP (0.364s)
[190.108694] [007/133] (910s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[190.321928] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[190.596729] Starting dynamic subtest: pipe-A-plane-0
[191.496518] Dynamic subtest pipe-A-plane-0: SUCCESS (0.900s)
[191.521759] Starting dynamic subtest: pipe-A-plane-1
[192.348931] Dynamic subtest pipe-A-plane-1: SUCCESS (0.849s)
[192.372112] Starting dynamic subtest: pipe-A-plane-2
[192.914847] Dynamic subtest pipe-A-plane-2: SUCCESS (0.566s)
[192.938581] Starting dynamic subtest: pipe-A-plane-3
[193.515260] Dynamic subtest pipe-A-plane-3: SUCCESS (0.598s)
[193.924383] Starting dynamic subtest: pipe-B-plane-0
[194.720648] Dynamic subtest pipe-B-plane-0: SUCCESS (0.816s)
[194.746581] Starting dynamic subtest: pipe-B-plane-1
[195.556394] Dynamic subtest pipe-B-plane-1: SUCCESS (0.832s)
[195.579653] Starting dynamic subtest: pipe-B-plane-2
[196.157409] Dynamic subtest pipe-B-plane-2: SUCCESS (0.599s)
[196.181057] Starting dynamic subtest: pipe-B-plane-3
[196.755681] Dynamic subtest pipe-B-plane-3: SUCCESS (0.599s)
[197.007928] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (6.683s)
[197.328801] [008/133] (902s left) gem_mmap_gtt (close-race)
[197.446500] Starting subtest: close-race
[217.517032] Subtest close-race: SUCCESS (20.063s)
[217.671917] [009/133] (882s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[217.874503] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[217.995117] [010/133] (882s left) kms_psr (fbc-pr-primary-blt)
[218.197719] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[218.299523] [011/133] (882s left) i915_hangman (gt-engine-hang)
[218.469262] Starting subtest: gt-engine-hang
[218.472858] Starting dynamic subtest: rcs0
[219.177328] Dynamic subtest rcs0: SUCCESS (0.592s)
[219.243109] Starting dynamic subtest: bcs0
[219.760148] Dynamic subtest bcs0: SUCCESS (0.583s)
[219.826449] Starting dynamic subtest: vcs0
[220.233068] Dynamic subtest vcs0: SUCCESS (0.586s)
[220.260290] Starting dynamic subtest: vecs0
[220.817226] Dynamic subtest vecs0: SUCCESS (0.582s)
[220.821154] Subtest gt-engine-hang: SUCCESS (2.352s)
[220.987463] [012/133] (879s left) gem_exec_reloc (basic-gtt-cpu-active)
[221.111664] Starting subtest: basic-gtt-cpu-active
[221.261417] Subtest basic-gtt-cpu-active: SUCCESS (0.147s)
[221.488642] [013/133] (879s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[221.715497] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[221.721575] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[221.870918] [014/133] (878s left) gem_exec_schedule (pi-shared-iova)
[222.143838] Starting subtest: pi-shared-iova
[222.147617] Starting dynamic subtest: rcs0
[222.215980] Dynamic subtest rcs0: SUCCESS (0.066s)
[222.255376] Starting dynamic subtest: bcs0
[222.287639] Dynamic subtest bcs0: SUCCESS (0.074s)
[222.315901] Starting dynamic subtest: vcs0
[222.365837] Dynamic subtest vcs0: SUCCESS (0.074s)
[222.403126] Starting dynamic subtest: vecs0
[222.422970] Dynamic subtest vecs0: SUCCESS (0.056s)
[222.427559] Subtest pi-shared-iova: SUCCESS (0.280s)
[222.706680] [015/133] (878s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[222.898078] Starting subtest: 2x-cursor-vs-flip-atomic
[254.471106] Subtest 2x-cursor-vs-flip-atomic: SUCCESS (31.566s)
[254.789982] [016/133] (846s left) gem_sync (basic-store-each)
[254.951290] Starting subtest: basic-store-each
[257.518744] Subtest basic-store-each: SUCCESS (2.582s)
[257.785515] [017/133] (843s left) gem_madvise (dontneed-before-pwrite)
[257.897571] Starting subtest: dontneed-before-pwrite
[257.904807] Subtest dontneed-before-pwrite: SUCCESS (0.005s)
[258.051594] [018/133] (843s left) perf_pmu (frequency)
[258.174236] Starting subtest: frequency
[258.182944] Starting dynamic subtest: gt0
[260.270500] Dynamic subtest gt0: SUCCESS (2.081s)
[260.294772] Starting dynamic subtest: idle-gt0
[260.775636] Dynamic subtest idle-gt0: SUCCESS (0.507s)
[260.779497] Subtest frequency: SUCCESS (2.602s)
[260.920955] [019/133] (840s left) kms_psr (psr2-cursor-mmap-gtt)
[261.124518] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[261.258731] [020/133] (840s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[261.469303] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[261.476916] Starting dynamic subtest: pipe-A-valid-mode
[262.015918] Dynamic subtest pipe-A-valid-mode: SKIP (0.544s)
[262.026305] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SKIP (0.553s)
[262.483909] [021/133] (839s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[264.348257] Starting subtest: gem-execbuf-stress-pc8
[264.403247] Subtest gem-execbuf-stress-pc8: SKIP (0.051s)
[264.782222] [022/133] (836s left) gem_eio (unwedge-stress)
[264.937582] Starting subtest: unwedge-stress
[264.942070] Starting dynamic subtest: render
[266.859748] Dynamic subtest render: SUCCESS (1.923s)
[266.888419] Starting dynamic subtest: bsd
[268.775770] Dynamic subtest bsd: SUCCESS (1.911s)
[268.806089] Starting dynamic subtest: blt
[271.591649] Dynamic subtest blt: SUCCESS (2.812s)
[271.620473] Starting dynamic subtest: vebox
[273.457777] Dynamic subtest vebox: SUCCESS (1.865s)
[273.463086] Subtest unwedge-stress: SUCCESS (8.527s)
[273.729948] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[273.736607] [023/133] (828s left) api_intel_bb (crc32)
[273.858107] Starting subtest: crc32
[273.865366] Subtest crc32: SKIP (0.000s)
[274.005666] [024/133] (827s left) gem_softpin (32b-excludes-last-page)
[274.130555] Starting subtest: 32b-excludes-last-page
[274.141169] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[274.316672] [025/133] (827s left) gem_softpin (noreloc-s3)
[274.449842] Starting subtest: noreloc-S3
[295.949679] Subtest noreloc-S3: SUCCESS (5.559s)
[300.152267] [026/133] (805s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[300.371802] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[300.379720] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[300.539696] [027/133] (805s left) gem_exec_store (cachelines)
[300.692490] Starting subtest: cachelines
[300.696912] Starting dynamic subtest: rcs0
[300.725371] Dynamic subtest rcs0: SUCCESS (0.033s)
[300.761130] Starting dynamic subtest: bcs0
[300.765426] Dynamic subtest bcs0: SUCCESS (0.021s)
[300.802679] Starting dynamic subtest: vcs0
[300.806809] Dynamic subtest vcs0: SUCCESS (0.022s)
[300.837863] Starting dynamic subtest: vecs0
[300.842050] Dynamic subtest vecs0: SUCCESS (0.024s)
[300.846806] Subtest cachelines: SUCCESS (0.109s)
[301.080315] [028/133] (805s left) kms_chamelium_frames (dp-crc-fast)
[301.693761] Subtest dp-crc-fast: SKIP (0.000s)
[302.135848] [029/133] (804s left) kms_plane_multiple (2x-tiling-4)
[302.345663] Starting subtest: 2x-tiling-4
[302.353629] Subtest 2x-tiling-4: SKIP (0.000s)
[302.520126] [030/133] (804s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[302.751793] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[302.758875] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[302.925924] [031/133] (803s left) kms_pm_rpm (fences)
[304.913065] Starting subtest: fences
[308.052494] Subtest fences: SUCCESS (3.074s)
[308.381370] [032/133] (798s left) kms_psr (pr-cursor-render)
[308.591074] Subtest pr-cursor-render: SKIP (0.000s)
[308.710393] [033/133] (798s left) gem_ctx_shared (detached-shared-gtt)
[308.863590] Starting subtest: detached-shared-gtt
[311.045966] Subtest detached-shared-gtt: SUCCESS (2.151s)
[311.321079] [034/133] (795s left) gem_close (many-handles-one-vma)
[311.442156] Starting subtest: many-handles-one-vma
[311.532919] Subtest many-handles-one-vma: SUCCESS (0.088s)
[311.691378] [035/133] (795s left) kms_addfb_basic (invalid-set-prop-any)
[311.808129] Starting subtest: invalid-set-prop-any
[311.811494] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[312.065851] [036/133] (795s left) i915_suspend (basic-s3-without-i915)
[312.178269] Starting subtest: basic-s3-without-i915