[41.467745] Initializing watchdogs
[41.467807]   /dev/watchdog0
[41.487153] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[41.492622] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[41.495260] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[41.497048] [001/131] (960s left) api_intel_allocator (gem-pool)
[41.531732] Starting subtest: gem-pool
[41.536709] Subtest gem-pool: SUCCESS (0.005s)
[41.677487] [002/131] (960s left) gem_bad_reloc (negative-reloc)
[41.715333] Starting subtest: negative-reloc
[41.717383] Subtest negative-reloc: SUCCESS (0.001s)
[41.852309] [003/131] (960s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[41.942866] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[41.974808] [004/131] (960s left) kms_vblank (wait-forked-busy-hang)
[42.057675] Starting subtest: wait-forked-busy-hang
[42.058377] Starting dynamic subtest: pipe-A-HDMI-A-1
[55.444309] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.367s)
[55.452904] Starting dynamic subtest: pipe-D-HDMI-A-1
[69.763717] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.301s)
[69.764390] Subtest wait-forked-busy-hang: SUCCESS (27.673s)
[69.935726] [005/131] (932s left) kms_fence_pin_leak
[71.448643] [006/131] (930s left) gem_exec_schedule (implicit-boths)
[71.490684] Starting subtest: implicit-boths
[71.491460] Starting dynamic subtest: rcs0
[71.551996] Dynamic subtest rcs0: SUCCESS (0.061s)
[71.561462] Starting dynamic subtest: bcs0
[71.615249] Dynamic subtest bcs0: SUCCESS (0.062s)
[71.624921] Starting dynamic subtest: vcs0
[71.678330] Dynamic subtest vcs0: SUCCESS (0.063s)
[71.688524] Starting dynamic subtest: vcs1
[71.742260] Dynamic subtest vcs1: SUCCESS (0.063s)
[71.752503] Starting dynamic subtest: vecs0
[71.806745] Dynamic subtest vecs0: SUCCESS (0.064s)
[71.807935] Subtest implicit-boths: SUCCESS (0.316s)
[72.134214] [007/131] (930s left) gem_render_copy_redux (flink)
[72.171380] Starting subtest: flink
[72.917429] Subtest flink: SUCCESS (0.746s)
[73.048565] [008/131] (929s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[73.138401] Starting subtest: pipe-fbc-rte
[73.142318] Subtest pipe-fbc-rte: SKIP (0.000s)
[73.255941] [009/131] (929s left) kms_cursor_crc (cursor-offscreen-512x512)
[73.343933] Starting subtest: cursor-offscreen-512x512
[73.345325] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[73.464429] [010/131] (928s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[73.559873] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[73.877121] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.317s)
[74.022964] [011/131] (928s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[74.055744] Starting subtest: framebuffer-vs-set-tiling
[74.056463] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[74.230603] [012/131] (928s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[74.315495] Starting subtest: addfb25-y-tiled-legacy
[74.316223] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[74.424391] [013/131] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[74.509665] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[74.510376] Starting dynamic subtest: pipe-A
[74.637270] Dynamic subtest pipe-A: SUCCESS (0.127s)
[74.643292] Starting dynamic subtest: pipe-B
[74.779983] Dynamic subtest pipe-B: SUCCESS (0.142s)
[74.787885] Starting dynamic subtest: pipe-C
[74.920785] Dynamic subtest pipe-C: SUCCESS (0.140s)
[74.933444] Starting dynamic subtest: pipe-D
[75.056803] Dynamic subtest pipe-D: SUCCESS (0.135s)
[75.057916] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.547s)
[75.257018] [014/131] (927s left) perf (gen12-oa-tlb-invalidate)
[75.357653] Starting subtest: gen12-oa-tlb-invalidate
[75.358330] Starting dynamic subtest: 0-rcs0
[85.424128] Dynamic subtest 0-rcs0: SUCCESS (10.029s)
[85.425169] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.030s)
[85.482938] [015/131] (917s left) perf (stress-open-close)
[85.582623] Starting subtest: stress-open-close
[85.583321] Starting dynamic subtest: 0-rcs0
[87.751035] Dynamic subtest 0-rcs0: SUCCESS (2.168s)
[87.751803] Subtest stress-open-close: SUCCESS (2.168s)
[87.786309] [016/131] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[87.876567] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[87.877912] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[87.993468] [017/131] (914s left) kms_pm_rpm (universal-planes)
[89.384095] Starting subtest: universal-planes
[89.385145] Starting dynamic subtest: plane-33
[97.667987] Dynamic subtest plane-33: SUCCESS (8.282s)
[97.677203] Starting dynamic subtest: plane-63
[106.056953] Dynamic subtest plane-63: SUCCESS (8.387s)
[106.072184] Starting dynamic subtest: plane-93
[114.358903] Dynamic subtest plane-93: SUCCESS (8.301s)
[114.368362] Starting dynamic subtest: plane-123
[122.742824] Dynamic subtest plane-123: SUCCESS (8.383s)
[122.757830] Starting dynamic subtest: plane-133
[130.942063] Dynamic subtest plane-133: SUCCESS (8.198s)
[130.950589] Starting dynamic subtest: plane-143
[139.213276] Dynamic subtest plane-143: SUCCESS (8.269s)
[139.228646] Starting dynamic subtest: plane-153
[147.716191] Dynamic subtest plane-153: SUCCESS (8.503s)
[147.725840] Starting dynamic subtest: plane-163
[156.101403] Dynamic subtest plane-163: SUCCESS (8.384s)
[156.102546] Subtest universal-planes: SUCCESS (66.716s)
[156.294364] [018/131] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[156.385707] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[156.387108] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[156.500856] [019/131] (846s left) gem_exec_params (readonly)
[156.536614] Starting subtest: readonly
[156.538141] Subtest readonly: SUCCESS (0.001s)
[156.676720] [020/131] (846s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[156.713123] Starting subtest: legacy-engines-hostile-preempt
[156.713814] Starting dynamic subtest: render
[156.804622] Dynamic subtest render: SUCCESS (0.090s)
[156.822459] Starting dynamic subtest: bsd1
[156.905569] Dynamic subtest bsd1: SUCCESS (0.099s)
[156.922432] Starting dynamic subtest: bsd2
[156.995828] Dynamic subtest bsd2: SUCCESS (0.089s)
[157.013710] Starting dynamic subtest: blt
[157.094687] Dynamic subtest blt: SUCCESS (0.097s)
[157.110592] Starting dynamic subtest: vebox
[157.191694] Dynamic subtest vebox: SUCCESS (0.095s)
[157.192757] Subtest legacy-engines-hostile-preempt: SUCCESS (0.479s)
[157.284820] [021/131] (845s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[157.317458] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[157.422692] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[157.509970] [022/131] (845s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[157.542530] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[157.648394] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[157.726616] [023/131] (845s left) core_setmaster (master-drop-set-root)
[157.804925] Starting subtest: master-drop-set-root
[157.813317] Subtest master-drop-set-root: SUCCESS (0.008s)
[157.857783] [024/131] (845s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[157.946303] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[157.947673] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[158.059604] [025/131] (844s left) gem_pwrite (basic-self)
[158.091347] Starting subtest: basic-self
[158.129588] Subtest basic-self: SUCCESS (0.038s)
[158.244555] [026/131] (844s left) kms_joiner (invalid-modeset-big-joiner)
[158.327641] Starting subtest: invalid-modeset-big-joiner
[158.328962] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[158.401396] [027/131] (844s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[158.487350] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[159.847506] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (1.360s)
[159.975636] [028/131] (843s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[160.064545] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[161.414663] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (1.350s)
[161.577062] [029/131] (841s left) perf_pmu (render-node-busy-idle)
[161.613657] Starting subtest: render-node-busy-idle
[161.614363] Starting dynamic subtest: rcs0
[162.259362] Dynamic subtest rcs0: SUCCESS (0.646s)
[162.269422] Starting dynamic subtest: bcs0
[162.909581] Dynamic subtest bcs0: SUCCESS (0.649s)
[162.920168] Starting dynamic subtest: vcs0
[163.549357] Dynamic subtest vcs0: SUCCESS (0.639s)
[163.559496] Starting dynamic subtest: vcs1
[164.189486] Dynamic subtest vcs1: SUCCESS (0.639s)
[164.199314] Starting dynamic subtest: vecs0
[164.831573] Dynamic subtest vecs0: SUCCESS (0.641s)
[164.832601] Subtest render-node-busy-idle: SUCCESS (3.219s)
[164.914269] [030/131] (838s left) i915_hangman (detector)
[164.955273] Starting subtest: detector
[164.955940] Starting dynamic subtest: rcs0
[175.083837] Dynamic subtest rcs0: SUCCESS (10.128s)
[175.100055] Starting dynamic subtest: bcs0
[185.059926] Dynamic subtest bcs0: SUCCESS (9.975s)
[185.076346] Starting dynamic subtest: vcs0
[195.023738] Dynamic subtest vcs0: SUCCESS (9.963s)
[195.039880] Starting dynamic subtest: vcs1
[205.004746] Dynamic subtest vcs1: SUCCESS (9.980s)
[205.020673] Starting dynamic subtest: vecs0
[215.079778] Dynamic subtest vecs0: SUCCESS (10.074s)
[215.080930] Subtest detector: SUCCESS (50.125s)
[215.227803] [031/131] (787s left) gem_ctx_engines (execute-allforone)
[215.265999] Starting subtest: execute-allforone
[215.271369] Subtest execute-allforone: SUCCESS (0.005s)
[215.469368] [032/131] (787s left) gem_ctx_param (non-root-set)
[215.500312] Starting subtest: non-root-set
[215.519258] Subtest non-root-set: SUCCESS (0.019s)
[215.609347] [033/131] (787s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[215.702664] Starting subtest: 4-tiled-8bpp-rotate-0
[215.704039] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[215.817954] [034/131] (787s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[215.899730] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[215.900397] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.903043] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[215.909840] Starting dynamic subtest: pipe-B-HDMI-A-1
[215.912443] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[215.919144] Starting dynamic subtest: pipe-C-HDMI-A-1
[215.921729] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[215.928337] Starting dynamic subtest: pipe-D-HDMI-A-1
[215.930979] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[215.932295] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[216.140661] [035/131] (787s left) i915_suspend (basic-s3-without-i915)
[216.170634] Starting subtest: basic-s3-without-i915