[144.773952] Initializing watchdogs
[144.774284]   /dev/watchdog0
[144.813866] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[144.828739] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[144.835932] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[144.844262] [001/131] (960s left) api_intel_allocator (gem-pool)
[144.968496] Starting subtest: gem-pool
[144.988654] Subtest gem-pool: SUCCESS (0.022s)
[145.161824] [002/131] (960s left) gem_bad_reloc (negative-reloc)
[145.284795] Starting subtest: negative-reloc
[145.297675] Subtest negative-reloc: SUCCESS (0.003s)
[145.458961] [003/131] (960s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[145.668489] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[145.753496] [004/131] (959s left) kms_vblank (wait-forked-busy-hang)
[145.947762] Starting subtest: wait-forked-busy-hang
[145.951377] Starting dynamic subtest: pipe-A-HDMI-A-1
[153.885506] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.934s)
[153.917972] Starting dynamic subtest: pipe-A-HDMI-A-2
[160.839961] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.950s)
[160.891871] Starting dynamic subtest: pipe-C-HDMI-A-1
[167.869480] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.019s)
[167.892392] Starting dynamic subtest: pipe-C-HDMI-A-2
[174.837067] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.961s)
[174.891439] Subtest wait-forked-busy-hang: SUCCESS (28.894s)
[175.168282] [005/131] (930s left) kms_fence_pin_leak
[179.311560] [006/131] (926s left) gem_exec_schedule (implicit-boths)
[179.469789] Starting subtest: implicit-boths
[179.473207] Starting dynamic subtest: rcs0
[179.603139] Dynamic subtest rcs0: SUCCESS (0.136s)
[179.626838] Starting dynamic subtest: bcs0
[179.754933] Dynamic subtest bcs0: SUCCESS (0.143s)
[179.776402] Starting dynamic subtest: vcs0
[179.883055] Dynamic subtest vcs0: SUCCESS (0.124s)
[179.906374] Starting dynamic subtest: vecs0
[180.007202] Dynamic subtest vecs0: SUCCESS (0.122s)
[180.010950] Subtest implicit-boths: SUCCESS (0.535s)
[180.428432] [007/131] (925s left) gem_render_copy_redux (flink)
[180.549328] Starting subtest: flink
[183.511675] Subtest flink: SUCCESS (2.961s)
[183.695968] [008/131] (922s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[183.896533] Starting subtest: pipe-fbc-rte
[183.913623] Subtest pipe-fbc-rte: SKIP (0.001s)
[184.063764] [009/131] (921s left) kms_cursor_crc (cursor-offscreen-512x512)
[184.264448] Starting subtest: cursor-offscreen-512x512
[184.271748] Subtest cursor-offscreen-512x512: SKIP (0.003s)
[184.445248] [010/131] (921s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[184.656647] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[184.671392] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[184.828986] [011/131] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[184.939397] Starting subtest: framebuffer-vs-set-tiling
[184.942866] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[185.193401] [012/131] (921s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[185.381145] Starting subtest: addfb25-y-tiled-legacy
[185.384852] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[185.561679] [013/131] (920s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[185.744576] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[185.749322] Starting dynamic subtest: pipe-A
[186.057515] Dynamic subtest pipe-A: SUCCESS (0.317s)
[186.085285] Starting dynamic subtest: pipe-B
[186.435667] Dynamic subtest pipe-B: SUCCESS (0.377s)
[186.474588] Starting dynamic subtest: pipe-C
[186.499901] Dynamic subtest pipe-C: SUCCESS (0.063s)
[186.504865] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.760s)
[186.990377] [014/131] (919s left) perf (gen12-oa-tlb-invalidate)
[187.229716] Starting subtest: gen12-oa-tlb-invalidate
[187.238031] Subtest gen12-oa-tlb-invalidate: SKIP (0.000s)
[187.327314] [015/131] (919s left) perf (stress-open-close)
[187.544839] Starting subtest: stress-open-close
[187.548486] Starting dynamic subtest: 0-rcs0
[189.748547] Dynamic subtest 0-rcs0: SUCCESS (2.199s)
[189.752825] Subtest stress-open-close: SUCCESS (2.200s)
[189.843281] [016/131] (916s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[190.048075] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[190.054443] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[190.224878] [017/131] (916s left) kms_pm_rpm (universal-planes)
[192.179524] Starting subtest: universal-planes
[192.183736] Starting dynamic subtest: plane-34
[193.681029] Dynamic subtest plane-34: SUCCESS (1.497s)
[193.746217] Starting dynamic subtest: plane-43
[195.149998] Dynamic subtest plane-43: SUCCESS (1.472s)
[195.170998] Starting dynamic subtest: plane-52
[196.651555] Dynamic subtest plane-52: SUCCESS (1.497s)
[196.676567] Starting dynamic subtest: plane-61
[198.158116] Dynamic subtest plane-61: SUCCESS (1.503s)
[198.183507] Starting dynamic subtest: plane-70
[199.610932] Dynamic subtest plane-70: SUCCESS (1.450s)
[199.614998] Subtest universal-planes: SUCCESS (7.434s)
[200.023620] [018/131] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[200.240600] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[200.247079] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[200.420917] [019/131] (906s left) gem_exec_params (readonly)
[200.541647] Starting subtest: readonly
[200.546170] Subtest readonly: SUCCESS (0.003s)
[200.725245] [020/131] (906s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[200.846514] Starting subtest: legacy-engines-hostile-preempt
[200.849958] Starting dynamic subtest: render
[200.933450] Dynamic subtest render: SUCCESS (0.086s)
[200.953486] Starting dynamic subtest: bsd
[201.034050] Dynamic subtest bsd: SUCCESS (0.095s)
[201.053780] Starting dynamic subtest: blt
[201.129050] Dynamic subtest blt: SUCCESS (0.093s)
[201.148949] Starting dynamic subtest: vebox
[201.211369] Dynamic subtest vebox: SUCCESS (0.080s)
[201.216265] Subtest legacy-engines-hostile-preempt: SUCCESS (0.369s)
[201.404490] [021/131] (905s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[201.514636] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[201.619319] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[201.787449] [022/131] (905s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[201.896173] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[202.002097] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[202.182480] [023/131] (905s left) core_setmaster (master-drop-set-root)
[202.381478] Starting subtest: master-drop-set-root
[202.390685] Subtest master-drop-set-root: SUCCESS (0.013s)
[202.493247] [024/131] (904s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[202.703926] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[202.711542] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[202.869810] [025/131] (904s left) gem_pwrite (basic-self)
[202.973401] Starting subtest: basic-self
[203.179192] Subtest basic-self: SUCCESS (0.210s)
[203.353903] [026/131] (904s left) kms_joiner (invalid-modeset-big-joiner)
[203.541520] Starting subtest: invalid-modeset-big-joiner
[203.548191] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[203.706241] [027/131] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[203.916706] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[207.020045] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (3.106s)
[207.321460] [028/131] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[207.525869] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[210.488742] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.965s)
[210.806551] [029/131] (897s left) perf_pmu (render-node-busy-idle)
[210.935141] Starting subtest: render-node-busy-idle
[210.939059] Starting dynamic subtest: rcs0
[211.558330] Dynamic subtest rcs0: SUCCESS (0.628s)
[211.579871] Starting dynamic subtest: bcs0
[212.192367] Dynamic subtest bcs0: SUCCESS (0.632s)
[212.213620] Starting dynamic subtest: vcs0
[212.830792] Dynamic subtest vcs0: SUCCESS (0.635s)
[212.851864] Starting dynamic subtest: vecs0
[213.461813] Dynamic subtest vecs0: SUCCESS (0.630s)
[213.469073] Subtest render-node-busy-idle: SUCCESS (2.531s)
[213.621202] [030/131] (894s left) i915_hangman (detector)
[213.756099] Starting subtest: detector
[213.759223] Starting dynamic subtest: rcs0
[223.225715] Dynamic subtest rcs0: SUCCESS (9.473s)
[223.263340] Starting dynamic subtest: bcs0
[233.157165] Dynamic subtest bcs0: SUCCESS (9.930s)
[233.178544] Starting dynamic subtest: vcs0
[243.141406] Dynamic subtest vcs0: SUCCESS (9.982s)
[243.162603] Starting dynamic subtest: vecs0
[253.116521] Dynamic subtest vecs0: SUCCESS (9.973s)
[253.119979] Subtest detector: SUCCESS (39.366s)
[253.291265] [031/131] (854s left) gem_ctx_engines (execute-allforone)
[253.418183] Starting subtest: execute-allforone
[253.431227] Subtest execute-allforone: SUCCESS (0.015s)
[253.732119] [032/131] (854s left) gem_ctx_param (non-root-set)
[253.842987] Starting subtest: non-root-set
[253.904274] Subtest non-root-set: SUCCESS (0.036s)
[254.059311] [033/131] (854s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[254.260701] Starting subtest: 4-tiled-8bpp-rotate-0
[254.267511] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[254.422488] [034/131] (853s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[254.607773] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[254.611142] Starting dynamic subtest: pipe-A-HDMI-A-1
[254.624382] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[254.645516] Starting dynamic subtest: pipe-A-HDMI-A-2
[254.659030] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[254.683019] Starting dynamic subtest: pipe-B-HDMI-A-1
[254.695484] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[254.717544] Starting dynamic subtest: pipe-B-HDMI-A-2
[254.730208] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[254.756484] Starting dynamic subtest: pipe-C-HDMI-A-1
[254.768038] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[254.789965] Starting dynamic subtest: pipe-C-HDMI-A-2
[254.802156] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[254.808158] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.036s)
[255.600683] [035/131] (852s left) i915_suspend (basic-s3-without-i915)
[255.709787] Starting subtest: basic-s3-without-i915
[277.601107] Subtest basic-s3-without-i915: SUCCESS (5.729s)
[284.799886] [036/131] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[285.017552] Starting subtest: fbcpsr-1p-rte
[285.023580] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[285.198552] [037/131] (830s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[285.419341] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[285.422703] Starting dynamic subtest: pipe-A-HDMI-A-1
[285.559578] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[285.581138] Starting dynamic subtest: pipe-A-HDMI-A-2
[285.613006] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[285.637379] Starting dynamic subtest: pipe-B-HDMI-A-1
[285.671233] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[285.718068] Starting dynamic subtest: pipe-B-HDMI-A-2
[285.754712] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[285.777881] Starting dynamic subtest: pipe-C-HDMI-A-1
[285.812225] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[285.834324] Starting dynamic subtest: pipe-C-HDMI-A-2
[285.868178] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[285.875959] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.025s)
[286.461733] [038/131] (829s left) gem_ctx_isolation (preservation-s3)
[286.603589] Starting subtest: preservation-S3
[286.606968] Starting dynamic subtest: rcs0