[90.339591] Initializing watchdogs
[90.339766]   /dev/watchdog0
[90.378621] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.394184] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.400544] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.409023] [001/131] (960s left) api_intel_allocator (gem-pool)
[90.536837] Starting subtest: gem-pool
[90.552021] Subtest gem-pool: SUCCESS (0.018s)
[90.742288] [002/131] (960s left) gem_bad_reloc (negative-reloc)
[90.874881] Starting subtest: negative-reloc
[90.886512] Subtest negative-reloc: SUCCESS (0.003s)
[91.041295] [003/131] (960s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[91.263752] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[91.346623] [004/131] (959s left) kms_vblank (wait-forked-busy-hang)
[91.531177] Starting subtest: wait-forked-busy-hang
[91.534578] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.898882] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.362s)
[98.952470] Starting dynamic subtest: pipe-A-HDMI-A-2
[105.872068] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.967s)
[105.911560] Starting dynamic subtest: pipe-C-HDMI-A-1
[112.834309] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.949s)
[112.852931] Starting dynamic subtest: pipe-C-HDMI-A-2
[119.865922] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.025s)
[119.925374] Subtest wait-forked-busy-hang: SUCCESS (28.330s)
[120.195602] [005/131] (931s left) kms_fence_pin_leak
[124.340343] [006/131] (927s left) gem_exec_schedule (implicit-boths)
[124.483419] Starting subtest: implicit-boths
[124.486689] Starting dynamic subtest: rcs0
[124.612138] Dynamic subtest rcs0: SUCCESS (0.130s)
[124.640924] Starting dynamic subtest: bcs0
[124.759488] Dynamic subtest bcs0: SUCCESS (0.137s)
[124.778323] Starting dynamic subtest: vcs0
[124.874647] Dynamic subtest vcs0: SUCCESS (0.124s)
[124.896048] Starting dynamic subtest: vecs0
[125.001419] Dynamic subtest vecs0: SUCCESS (0.125s)
[125.005254] Subtest implicit-boths: SUCCESS (0.521s)
[125.467151] [007/131] (926s left) gem_render_copy_redux (flink)
[125.582308] Starting subtest: flink
[128.549606] Subtest flink: SUCCESS (2.964s)
[128.739629] [008/131] (922s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[128.938224] Starting subtest: pipe-fbc-rte
[128.953836] Subtest pipe-fbc-rte: SKIP (0.001s)
[129.107370] [009/131] (922s left) kms_cursor_crc (cursor-offscreen-512x512)
[129.306769] Starting subtest: cursor-offscreen-512x512
[129.313071] Subtest cursor-offscreen-512x512: SKIP (0.003s)
[129.515342] [010/131] (922s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[129.729506] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[129.742803] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[129.906749] [011/131] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[130.018975] Starting subtest: framebuffer-vs-set-tiling
[130.022193] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[130.273641] [012/131] (921s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[130.467615] Starting subtest: addfb25-y-tiled-legacy
[130.470942] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[130.639521] [013/131] (921s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[130.832677] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[130.837263] Starting dynamic subtest: pipe-A
[131.168122] Dynamic subtest pipe-A: SUCCESS (0.341s)
[131.194998] Starting dynamic subtest: pipe-B
[131.564145] Dynamic subtest pipe-B: SUCCESS (0.395s)
[131.598683] Starting dynamic subtest: pipe-C
[131.631465] Dynamic subtest pipe-C: SUCCESS (0.062s)
[131.636617] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.800s)
[132.115570] [014/131] (920s left) perf (gen12-oa-tlb-invalidate)
[132.361883] Starting subtest: gen12-oa-tlb-invalidate
[132.368584] Subtest gen12-oa-tlb-invalidate: SKIP (0.000s)
[132.466587] [015/131] (919s left) perf (stress-open-close)
[132.694761] Starting subtest: stress-open-close
[132.698388] Starting dynamic subtest: 0-rcs0
[134.896919] Dynamic subtest 0-rcs0: SUCCESS (2.204s)
[134.900861] Subtest stress-open-close: SUCCESS (2.204s)
[135.002100] [016/131] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[135.200141] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[135.208020] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[135.365374] [017/131] (917s left) kms_pm_rpm (universal-planes)
[137.332820] Starting subtest: universal-planes
[137.339028] Starting dynamic subtest: plane-34
[138.839551] Dynamic subtest plane-34: SUCCESS (1.511s)
[138.866794] Starting dynamic subtest: plane-43
[140.339898] Dynamic subtest plane-43: SUCCESS (1.497s)
[140.363078] Starting dynamic subtest: plane-52
[141.854255] Dynamic subtest plane-52: SUCCESS (1.513s)
[141.898122] Starting dynamic subtest: plane-61
[143.497911] Dynamic subtest plane-61: SUCCESS (1.638s)
[143.525424] Starting dynamic subtest: plane-70
[145.002387] Dynamic subtest plane-70: SUCCESS (1.503s)
[145.006333] Subtest universal-planes: SUCCESS (7.678s)
[145.405917] [018/131] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[145.619904] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[145.626414] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[145.785433] [019/131] (906s left) gem_exec_params (readonly)
[145.899845] Starting subtest: readonly
[145.904440] Subtest readonly: SUCCESS (0.002s)
[146.077494] [020/131] (906s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[146.195705] Starting subtest: legacy-engines-hostile-preempt
[146.199736] Starting dynamic subtest: render
[146.302750] Dynamic subtest render: SUCCESS (0.109s)
[146.323229] Starting dynamic subtest: bsd
[146.395214] Dynamic subtest bsd: SUCCESS (0.087s)
[146.414999] Starting dynamic subtest: blt
[146.488390] Dynamic subtest blt: SUCCESS (0.090s)
[146.508856] Starting dynamic subtest: vebox
[146.563196] Dynamic subtest vebox: SUCCESS (0.069s)
[146.567707] Subtest legacy-engines-hostile-preempt: SUCCESS (0.370s)
[146.745445] [021/131] (906s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[146.857097] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[146.955061] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[147.120168] [022/131] (905s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[147.229566] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[147.338646] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[147.508896] [023/131] (905s left) core_setmaster (master-drop-set-root)
[147.724308] Starting subtest: master-drop-set-root
[147.736499] Subtest master-drop-set-root: SUCCESS (0.013s)
[147.840280] [024/131] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[148.038592] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[148.045736] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[148.220804] [025/131] (904s left) gem_pwrite (basic-self)
[148.327198] Starting subtest: basic-self
[148.539442] Subtest basic-self: SUCCESS (0.212s)
[148.724050] [026/131] (904s left) kms_joiner (invalid-modeset-big-joiner)
[148.909981] Starting subtest: invalid-modeset-big-joiner
[148.916242] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[149.071842] [027/131] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[149.285323] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[152.385588] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (3.101s)
[152.690530] [028/131] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[152.887957] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[155.808385] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.922s)
[156.103373] [029/131] (897s left) perf_pmu (render-node-busy-idle)
[156.227752] Starting subtest: render-node-busy-idle
[156.232109] Starting dynamic subtest: rcs0
[156.852788] Dynamic subtest rcs0: SUCCESS (0.625s)
[156.876424] Starting dynamic subtest: bcs0
[157.499474] Dynamic subtest bcs0: SUCCESS (0.644s)
[157.520779] Starting dynamic subtest: vcs0
[158.126819] Dynamic subtest vcs0: SUCCESS (0.626s)
[158.148338] Starting dynamic subtest: vecs0
[158.760171] Dynamic subtest vecs0: SUCCESS (0.631s)
[158.764431] Subtest render-node-busy-idle: SUCCESS (2.531s)
[158.935097] [030/131] (894s left) i915_hangman (detector)
[159.063099] Starting subtest: detector
[159.066291] Starting dynamic subtest: rcs0
[169.225514] Dynamic subtest rcs0: SUCCESS (10.164s)
[169.265424] Starting dynamic subtest: bcs0
[179.142799] Dynamic subtest bcs0: SUCCESS (9.915s)
[179.164798] Starting dynamic subtest: vcs0
[189.052749] Dynamic subtest vcs0: SUCCESS (9.909s)
[189.075657] Starting dynamic subtest: vecs0
[199.174878] Dynamic subtest vecs0: SUCCESS (10.120s)
[199.178676] Subtest detector: SUCCESS (40.115s)
[199.357557] [031/131] (854s left) gem_ctx_engines (execute-allforone)
[199.487039] Starting subtest: execute-allforone
[199.502384] Subtest execute-allforone: SUCCESS (0.015s)
[199.812559] [032/131] (854s left) gem_ctx_param (non-root-set)
[199.920478] Starting subtest: non-root-set
[199.945810] Subtest non-root-set: SUCCESS (0.032s)
[200.123479] [033/131] (853s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[200.322108] Starting subtest: 4-tiled-8bpp-rotate-0
[200.328901] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[200.507444] [034/131] (853s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[200.695316] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[200.699181] Starting dynamic subtest: pipe-A-HDMI-A-1
[200.712877] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[200.755470] Starting dynamic subtest: pipe-A-HDMI-A-2
[200.769498] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[200.806723] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.820254] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[200.841723] Starting dynamic subtest: pipe-B-HDMI-A-2
[200.854667] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[200.876360] Starting dynamic subtest: pipe-C-HDMI-A-1
[200.889255] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[200.910570] Starting dynamic subtest: pipe-C-HDMI-A-2
[200.923716] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[200.929950] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.020s)
[201.696678] [035/131] (852s left) i915_suspend (basic-s3-without-i915)
[201.809395] Starting subtest: basic-s3-without-i915