[67.534013] Initializing watchdogs
[67.534096]   /dev/watchdog0
[67.564660] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.579383] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.583997] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.587033] [001/133] (960s left) kms_chamelium_frames (dp-crc-single)
[69.120988] Subtest dp-crc-single: SKIP (0.000s)
[69.227577] [002/133] (958s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[70.733317] Starting subtest: 4-tiled-16bpp-rotate-90
[70.735247] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[70.963285] [003/133] (957s left) gem_exec_schedule (smoketest)
[71.146439] Starting subtest: smoketest
[71.147294] Starting dynamic subtest: rcs0
[76.723584] Dynamic subtest rcs0: SUCCESS (5.572s)
[76.731690] Starting dynamic subtest: bcs0
[82.161275] Dynamic subtest bcs0: SUCCESS (5.440s)
[82.169277] Starting dynamic subtest: vcs0
[87.613497] Dynamic subtest vcs0: SUCCESS (5.451s)
[87.621604] Starting dynamic subtest: vcs1
[93.058382] Dynamic subtest vcs1: SUCCESS (5.446s)
[93.066457] Starting dynamic subtest: vecs0
[98.508672] Dynamic subtest vecs0: SUCCESS (5.448s)
[98.509721] Subtest smoketest: SUCCESS (27.359s)
[98.819224] [004/133] (929s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[100.324130] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[100.944264] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.621s)
[101.192087] [005/133] (927s left) kms_frontbuffer_tracking (psr-slowdraw)
[102.681630] Starting subtest: psr-slowdraw
[102.683308] Subtest psr-slowdraw: SKIP (0.000s)
[102.837429] [006/133] (925s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[102.898948] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[103.001949] [007/133] (925s left) kms_psr (fbc-psr-no-drrs)
[104.487607] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[104.563515] [008/133] (924s left) kms_feature_discovery (psr2)
[106.047582] Starting subtest: psr2
[106.049180] Subtest psr2: SKIP (0.000s)
[106.162613] [009/133] (922s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[107.663905] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[107.665748] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[107.823944] [010/133] (920s left) gem_exec_schedule (lateslice)
[107.892844] Starting subtest: lateslice
[107.893671] Starting dynamic subtest: rcs0
[107.931241] Dynamic subtest rcs0: SUCCESS (0.039s)
[107.939501] Starting dynamic subtest: bcs0
[107.950851] Dynamic subtest bcs0: SUCCESS (0.019s)
[107.959190] Starting dynamic subtest: vcs0
[107.969928] Dynamic subtest vcs0: SUCCESS (0.019s)
[107.978387] Starting dynamic subtest: vcs1
[107.990514] Dynamic subtest vcs1: SUCCESS (0.020s)
[107.998772] Starting dynamic subtest: vecs0
[108.012549] Dynamic subtest vecs0: SUCCESS (0.022s)
[108.013398] Subtest lateslice: SUCCESS (0.121s)
[108.389619] [011/133] (920s left) gem_lmem_swapping (heavy-verify-multi)
[112.526353] Starting subtest: heavy-verify-multi
[112.527263] Starting dynamic subtest: lmem0
[128.481829] Dynamic subtest lmem0: SUCCESS (15.952s)
[128.482822] Subtest heavy-verify-multi: SUCCESS (15.953s)
[130.061548] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true
[130.063628] [012/133] (898s left) perf (invalid-remove-userspace-config)
[133.329425] Starting subtest: invalid-remove-userspace-config
[133.347242] Subtest invalid-remove-userspace-config: SUCCESS (0.015s)
[133.420658] [FACT perf (invalid-remove-userspace-config)] new: kernel.kmod_is_loaded.i915: true
[133.423815] [013/133] (895s left) sw_sync (sync_multi_timeline_wait)
[133.468463] Starting subtest: sync_multi_timeline_wait
[133.469305] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[133.550310] [014/133] (895s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[133.622934] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[133.728114] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[133.865323] [015/133] (895s left) sysfs_timeslice_duration (timeout)
[133.914656] Starting subtest: timeout
[133.915492] Starting dynamic subtest: vecs0
[135.178161] Dynamic subtest vecs0: SUCCESS (1.262s)
[135.186928] Starting dynamic subtest: vcs0
[136.445900] Dynamic subtest vcs0: SUCCESS (1.268s)
[136.456584] Starting dynamic subtest: bcs0
[137.051906] Dynamic subtest bcs0: SUCCESS (0.606s)
[137.060369] Starting dynamic subtest: rcs0
[137.709216] Dynamic subtest rcs0: SUCCESS (0.657s)
[137.717721] Starting dynamic subtest: vcs1
[139.001928] Dynamic subtest vcs1: SUCCESS (1.293s)
[139.003051] Subtest timeout: SUCCESS (5.087s)
[139.133478] [016/133] (890s left) gem_exec_capture (capture)
[139.185869] Starting subtest: capture
[139.186876] Starting dynamic subtest: rcs0-smem
[140.068839] Dynamic subtest rcs0-smem: SUCCESS (0.884s)
[140.078108] Starting dynamic subtest: rcs0-lmem0
[141.173182] Dynamic subtest rcs0-lmem0: SUCCESS (1.104s)
[141.181610] Starting dynamic subtest: bcs0-smem
[142.038916] Dynamic subtest bcs0-smem: SUCCESS (0.865s)
[142.047468] Starting dynamic subtest: bcs0-lmem0
[142.900913] Dynamic subtest bcs0-lmem0: SUCCESS (0.862s)
[142.909454] Starting dynamic subtest: vcs0-smem
[143.759217] Dynamic subtest vcs0-smem: SUCCESS (0.858s)
[143.767769] Starting dynamic subtest: vcs0-lmem0
[144.622840] Dynamic subtest vcs0-lmem0: SUCCESS (0.863s)
[144.631422] Starting dynamic subtest: vcs1-smem
[145.982055] Dynamic subtest vcs1-smem: SUCCESS (1.359s)
[145.990566] Starting dynamic subtest: vcs1-lmem0
[146.838222] Dynamic subtest vcs1-lmem0: SUCCESS (0.856s)
[146.846874] Starting dynamic subtest: vecs0-smem
[147.728901] Dynamic subtest vecs0-smem: FAIL (0.868s)
[147.737420] Starting dynamic subtest: vecs0-lmem0
[148.731018] Dynamic subtest vecs0-lmem0: FAIL (1.001s)
[148.732048] Subtest capture: FAIL (9.523s)
[148.857579] [017/133] (880s left) api_intel_bb (misplaced-blitter)
[148.900956] Starting subtest: misplaced-blitter
[148.923017] Subtest misplaced-blitter: SUCCESS (0.022s)
[149.128277] [018/133] (880s left) syncobj_wait (invalid-wait-illegal-handle)
[149.173100] Starting subtest: invalid-wait-illegal-handle
[149.173919] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[149.306621] [019/133] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[150.795132] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[150.796963] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[151.007091] [020/133] (878s left) gem_ctx_persistence (legacy-engines-cleanup)
[151.056731] Starting subtest: legacy-engines-cleanup
[151.057606] Starting dynamic subtest: render
[151.117365] Dynamic subtest render: SUCCESS (0.060s)
[151.127015] Starting dynamic subtest: bsd1
[151.156309] Dynamic subtest bsd1: SUCCESS (0.038s)
[151.172825] Starting dynamic subtest: bsd2
[151.193696] Dynamic subtest bsd2: SUCCESS (0.036s)
[151.219369] Starting dynamic subtest: blt
[151.242558] Dynamic subtest blt: SUCCESS (0.047s)
[151.261957] Starting dynamic subtest: vebox
[151.290711] Dynamic subtest vebox: SUCCESS (0.047s)
[151.292168] Subtest legacy-engines-cleanup: SUCCESS (0.234s)
[151.465851] [021/133] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[152.953814] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[152.955674] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[153.087799] [022/133] (876s left) i915_pm_rpm (gem-execbuf-stress)
[157.018460] Starting subtest: gem-execbuf-stress
[157.019498] Starting dynamic subtest: lmem0
[167.878926] Dynamic subtest lmem0: SUCCESS (10.856s)
[167.926798] Starting dynamic subtest: extra-wait-lmem0
[226.851203] Dynamic subtest extra-wait-lmem0: SUCCESS (58.970s)
[226.860362] Starting dynamic subtest: smem0
[238.833520] Dynamic subtest smem0: SUCCESS (11.981s)
[238.877430] Starting dynamic subtest: extra-wait-smem0
[298.380163] Dynamic subtest extra-wait-smem0: SUCCESS (59.550s)
[298.380851] Subtest gem-execbuf-stress: SUCCESS (141.361s)
[298.703837] [023/133] (731s left) kms_psr (fbc-pr-dpms)
[300.193092] Subtest fbc-pr-dpms: SKIP (0.000s)
[300.269740] [024/133] (729s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[301.754308] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[301.821776] [025/133] (728s left) kms_flip (dpms-vs-vblank-race-interruptible)
[303.311103] Starting subtest: dpms-vs-vblank-race-interruptible
[303.318144] Starting dynamic subtest: A-HDMI-A4
[306.313335] Dynamic subtest A-HDMI-A4: SUCCESS (2.994s)
[306.325135] Starting dynamic subtest: B-HDMI-A4
[309.255217] Dynamic subtest B-HDMI-A4: SUCCESS (2.941s)
[309.264363] Starting dynamic subtest: C-HDMI-A4
[312.183959] Dynamic subtest C-HDMI-A4: SUCCESS (2.927s)
[312.193832] Starting dynamic subtest: D-HDMI-A4
[315.116878] Dynamic subtest D-HDMI-A4: SUCCESS (2.931s)
[315.117785] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.806s)
[315.292505] [026/133] (714s left) gem_ccs (suspend-resume)
[315.351161] Starting subtest: suspend-resume
[315.352835] Subtest suspend-resume: SKIP (0.000s)
[315.462933] [027/133] (714s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[315.516206] Starting subtest: yf-tiled-ccs-to-x-tiled
[315.517133] Starting dynamic subtest: smem
[315.607837] Dynamic subtest smem: SUCCESS (0.091s)
[315.618277] Starting dynamic subtest: lmem0
[316.539938] Dynamic subtest lmem0: SUCCESS (0.928s)
[316.540898] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (1.021s)
[316.815712] [028/133] (713s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[318.301442] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[318.302323] Starting dynamic subtest: pipe-A-HDMI-A-4
[318.324794] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[318.334253] Starting dynamic subtest: pipe-B-HDMI-A-4
[318.357064] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[318.365835] Starting dynamic subtest: pipe-C-HDMI-A-4
[318.389257] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[318.398246] Starting dynamic subtest: pipe-D-HDMI-A-4
[318.423233] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[318.424782] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.023s)
[318.603959] [029/133] (711s left) gem_exec_params (no-blt)
[318.655545] Starting subtest: no-blt
[318.658073] Subtest no-blt: SUCCESS (0.002s)
[318.889228] [030/133] (711s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[320.377882] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[320.379798] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[320.617729] [031/133] (709s left) gem_close_race (basic-process)
[320.691708] Starting subtest: basic-process
[320.744454] Subtest basic-process: SUCCESS (0.053s)
[321.038869] [032/133] (709s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[322.525262] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[322.601999] [033/133] (707s left) gem_userptr_blits (sync-unmap-cycles)
[322.662957] Starting subtest: sync-unmap-cycles
[328.041309] Subtest sync-unmap-cycles: SUCCESS (5.377s)
[328.246222] [034/133] (702s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[329.734454] Starting subtest: plane-lut1d-post-ctm3x4
[329.934357] Starting dynamic subtest: pipe-A-plane-0
[330.181198] Dynamic subtest pipe-A-plane-0: SUCCESS (0.247s)
[330.218785] Starting dynamic subtest: pipe-A-plane-1
[330.379361] Dynamic subtest pipe-A-plane-1: SUCCESS (0.192s)
[330.390259] Starting dynamic subtest: pipe-A-plane-2
[330.547914] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[330.827595] Starting dynamic subtest: pipe-B-plane-0
[330.993139] Dynamic subtest pipe-B-plane-0: SUCCESS (0.197s)
[331.025872] Starting dynamic subtest: pipe-B-plane-1
[331.195265] Dynamic subtest pipe-B-plane-1: SUCCESS (0.192s)
[331.226525] Starting dynamic subtest: pipe-B-plane-2
[331.395948] Dynamic subtest pipe-B-plane-2: SUCCESS (0.193s)
[331.697276] Starting dynamic subtest: pipe-C-plane-0
[331.888890] Dynamic subtest pipe-C-plane-0: SUCCESS (0.215s)
[331.924466] Starting dynamic subtest: pipe-C-plane-1
[332.105702] Dynamic subtest pipe-C-plane-1: SUCCESS (0.209s)
[332.143341] Starting dynamic subtest: pipe-C-plane-2
[332.322280] Dynamic subtest pipe-C-plane-2: SUCCESS (0.209s)
[332.627676] Starting dynamic subtest: pipe-D-plane-0
[332.818222] Dynamic subtest pipe-D-plane-0: SUCCESS (0.215s)
[332.850878] Starting dynamic subtest: pipe-D-plane-1
[333.034750] Dynamic subtest pipe-D-plane-1: SUCCESS (0.209s)
[333.063065] Starting dynamic subtest: pipe-D-plane-2
[333.251423] Dynamic subtest pipe-D-plane-2: SUCCESS (0.209s)
[333.305853] Subtest plane-lut1d-post-ctm3x4: SUCCESS (3.572s)
[333.471353] [035/133] (697s left) gem_pxp (create-valid-protected-context)
[336.044053] Starting subtest: create-valid-protected-context
[336.045889] Subtest create-valid-protected-context: SKIP (0.000s)
[336.144269] [036/133] (694s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[336.190157] Starting subtest: multi-wait-all-for-submit-signaled
[336.191071] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[336.336427] [037/133] (694s left) gem_exec_fence (long-history)
[336.846289] Starting subtest: long-history
[342.925040] Subtest long-history: SUCCESS (6.076s)
[343.323688] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[343.326486] [038/133] (687s left) kms_dp_link_training (non-uhbr-sst)
[344.810239] Starting subtest: non-uhbr-sst
[344.813337] Subtest non-uhbr-sst: SKIP (0.000s)
[344.950069] [039/133] (686s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[346.450808] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[346.451662] Starting dynamic subtest: pipe-A-HDMI-A-4
[346.459149] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[346.468876] Starting dynamic subtest: pipe-B-HDMI-A-4
[346.476215] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s)
[346.485542] Starting dynamic subtest: pipe-C-HDMI-A-4
[346.492982] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s)
[346.502205] Starting dynamic subtest: pipe-D-HDMI-A-4
[346.510139] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s)
[346.510955] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.017s)
[346.704125] [040/133] (684s left) gem_workarounds (reset-context)
[346.776252] Starting subtest: reset-context
[346.956552] Subtest reset-context: SUCCESS (0.179s)
[347.144866] [041/133] (684s left) kms_psr (psr-primary-page-flip)
[348.630425] Subtest psr-primary-page-flip: SKIP (0.000s)
[348.717034] [042/133] (682s left) i915_module_load (fault-injection)
[348.760179] Starting subtest: fault-injection
[348.783827] Starting dynamic subtest: __uc_init
[439.441570] Killing the test because the kernel is tainted.