[60.949665] Initializing watchdogs
[60.949731]   /dev/watchdog0
[60.967372] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.977364] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.980690] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.983107] [001/131] (960s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[61.154981] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[61.155957] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[61.279614] [002/131] (960s left) kms_draw_crc (draw-method-mmap-wc)
[61.476971] Starting subtest: draw-method-mmap-wc
[61.478841] Subtest draw-method-mmap-wc: SKIP (0.000s)
[61.592381] [003/131] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[61.795887] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[61.797542] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[61.916936] [004/131] (959s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[62.127496] Starting subtest: x-tiled-16bpp-rotate-0
[63.754832] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.627s)
[63.931115] [005/131] (957s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[64.132169] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[64.133145] Starting dynamic subtest: pipe-A-DP-3
[72.693057] Dynamic subtest pipe-A-DP-3: SUCCESS (8.555s)
[72.704444] Starting dynamic subtest: pipe-B-DP-3
[73.482901] Dynamic subtest pipe-B-DP-3: SUCCESS (0.787s)
[73.494595] Starting dynamic subtest: pipe-C-DP-3
[74.270377] Dynamic subtest pipe-C-DP-3: SUCCESS (0.783s)
[74.282451] Starting dynamic subtest: pipe-D-DP-3
[75.041531] Dynamic subtest pipe-D-DP-3: SUCCESS (0.768s)
[75.044086] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SUCCESS (10.903s)
[75.395540] [006/131] (946s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[75.596265] Starting subtest: compare-crc-sanitycheck-nv12
[75.597228] Starting dynamic subtest: pipe-A-DP-3
[76.329417] Dynamic subtest pipe-A-DP-3: SUCCESS (0.732s)
[76.337415] Starting dynamic subtest: pipe-B-DP-3
[76.951219] Dynamic subtest pipe-B-DP-3: SUCCESS (0.621s)
[76.959035] Starting dynamic subtest: pipe-C-DP-3
[77.547428] Dynamic subtest pipe-C-DP-3: SUCCESS (0.595s)
[77.555391] Starting dynamic subtest: pipe-D-DP-3
[78.166356] Dynamic subtest pipe-D-DP-3: SUCCESS (0.618s)
[78.167867] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.569s)
[78.451723] [007/131] (943s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[78.660277] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[79.887788] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.227s)
[80.052181] [008/131] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[80.257947] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[80.259590] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[80.380953] [009/131] (941s left) gem_exec_schedule (implicit-read-write)
[80.472170] Starting subtest: implicit-read-write
[80.473159] Starting dynamic subtest: rcs0
[80.759427] Dynamic subtest rcs0: SUCCESS (0.287s)
[80.767178] Starting dynamic subtest: bcs0
[80.951840] Dynamic subtest bcs0: SUCCESS (0.192s)
[80.959683] Starting dynamic subtest: vcs0
[81.158363] Dynamic subtest vcs0: SUCCESS (0.206s)
[81.166158] Starting dynamic subtest: vcs1
[81.362205] Dynamic subtest vcs1: SUCCESS (0.204s)
[81.369592] Starting dynamic subtest: vecs0
[81.563146] Dynamic subtest vecs0: SUCCESS (0.201s)
[81.570788] Starting dynamic subtest: vecs1
[81.768623] Dynamic subtest vecs1: SUCCESS (0.205s)
[81.775959] Starting dynamic subtest: ccs0
[81.998424] Dynamic subtest ccs0: SUCCESS (0.230s)
[81.999369] Subtest implicit-read-write: SUCCESS (1.526s)
[82.437272] [010/131] (939s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[82.508511] Starting subtest: invalid-single-wait-unsubmitted
[82.509548] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[82.638135] [011/131] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[82.841825] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[82.843486] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[82.966070] [012/131] (939s left) kms_psr (psr-basic)
[83.167503] Subtest psr-basic: SKIP (0.000s)
[83.220801] [013/131] (938s left) gem_render_copy_redux (normal)
[83.300416] Starting subtest: normal
[83.986417] Subtest normal: SUCCESS (0.686s)
[84.161516] [014/131] (938s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[84.363650] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[84.405038] [015/131] (937s left) gem_ctx_persistence (hang)
[84.486431] Starting subtest: hang
[84.488422] Subtest hang: SKIP (0.000s)
[84.646792] [016/131] (937s left) kms_feature_discovery (display-3x)
[84.847179] Starting subtest: display-3x
[84.849037] Subtest display-3x: SKIP (0.000s)
[84.927068] [017/131] (937s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[85.124586] Starting subtest: cursorA-vs-flipA-toggle
[96.041448] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.916s)
[96.300535] [018/131] (926s left) kms_setmode (invalid-clone-single-crtc-stealing)
[96.374081] Starting subtest: invalid-clone-single-crtc-stealing
[96.377191] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[96.502656] [019/131] (926s left) gem_mmap_wc (write-prefaulted)
[96.577177] Subtest write-prefaulted: SKIP (0.000s)
[96.630946] [020/131] (925s left) gem_exec_reloc (basic-cpu-gtt)
[96.708868] Subtest basic-cpu-gtt: SKIP (0.000s)
[96.813437] [021/131] (925s left) perf_pmu (busy)
[96.875504] Starting subtest: busy
[96.876472] Starting dynamic subtest: rcs0
[97.504983] Dynamic subtest rcs0: SUCCESS (0.628s)
[97.517849] Starting dynamic subtest: bcs0
[98.070046] Dynamic subtest bcs0: SUCCESS (0.564s)
[98.082641] Starting dynamic subtest: vcs0
[98.637191] Dynamic subtest vcs0: SUCCESS (0.566s)
[98.650465] Starting dynamic subtest: vcs1
[99.200811] Dynamic subtest vcs1: SUCCESS (0.563s)
[99.213696] Starting dynamic subtest: vecs0
[99.765179] Dynamic subtest vecs0: SUCCESS (0.564s)
[99.778461] Starting dynamic subtest: vecs1
[100.325587] Dynamic subtest vecs1: SUCCESS (0.560s)
[100.336815] Starting dynamic subtest: ccs0
[100.885878] Dynamic subtest ccs0: SUCCESS (0.559s)
[100.887766] Subtest busy: SUCCESS (4.010s)
[101.006600] [022/131] (921s left) i915_query (query-regions-sanity-check)
[101.076156] Starting subtest: query-regions-sanity-check
[101.102861] Subtest query-regions-sanity-check: SUCCESS (0.027s)
[101.290924] [023/131] (921s left) gem_exec_schedule (pi-common)
[101.525054] Starting subtest: pi-common
[101.526649] Starting dynamic subtest: rcs0
[101.658760] Dynamic subtest rcs0: SUCCESS (0.135s)
[101.670256] Starting dynamic subtest: bcs0
[101.738739] Dynamic subtest bcs0: SUCCESS (0.079s)
[101.759843] Starting dynamic subtest: vcs0
[101.828719] Dynamic subtest vcs0: SUCCESS (0.090s)
[101.838073] Starting dynamic subtest: vcs1
[101.904186] Dynamic subtest vcs1: SUCCESS (0.075s)
[101.918209] Starting dynamic subtest: vecs0
[101.985541] Dynamic subtest vecs0: SUCCESS (0.081s)
[102.007159] Starting dynamic subtest: vecs1
[102.074362] Dynamic subtest vecs1: SUCCESS (0.089s)
[102.083690] Starting dynamic subtest: ccs0
[102.149377] Dynamic subtest ccs0: SUCCESS (0.075s)
[102.150450] Subtest pi-common: SUCCESS (0.626s)
[102.409590] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[102.411470] [024/131] (920s left) kms_getfb (getfb2-handle-not-fb)
[102.492104] Starting subtest: getfb2-handle-not-fb
[102.621130] Subtest getfb2-handle-not-fb: SUCCESS (0.129s)
[102.749722] [025/131] (920s left) kms_flip (2x-flip-vs-panning)
[102.962056] Starting subtest: 2x-flip-vs-panning
[102.976336] Subtest 2x-flip-vs-panning: SKIP (0.014s)
[103.083582] [026/131] (919s left) gem_exec_flush (basic-uc-pro-default)
[103.180024] Subtest basic-uc-pro-default: SKIP (0.000s)
[103.278922] [027/131] (919s left) drm_fdinfo (virtual-busy-hang)
[103.348690] Starting subtest: virtual-busy-hang
[103.350575] Subtest virtual-busy-hang: SKIP (0.000s)
[103.444561] [028/131] (919s left) gem_exec_balancer (waits)
[103.535379] Starting subtest: waits
[116.067579] Subtest waits: SUCCESS (12.531s)
[116.413145] [029/131] (906s left) gem_exec_params (no-bsd)
[116.497299] Starting subtest: no-bsd
[116.499293] Subtest no-bsd: SUCCESS (0.001s)
[116.681051] [030/131] (906s left) gem_pxp (display-protected-crc)
[119.281411] Starting subtest: display-protected-crc
[119.284475] Subtest display-protected-crc: SKIP (0.000s)
[119.387339] [031/131] (903s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[119.603960] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[119.605784] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[119.731762] [032/131] (903s left) kms_flip (blocking-wf_vblank)
[119.940025] Starting subtest: blocking-wf_vblank
[119.943539] Starting dynamic subtest: A-DP3
[128.065424] Dynamic subtest A-DP3: SUCCESS (8.122s)
[128.076309] Starting dynamic subtest: B-DP3
[136.106347] Dynamic subtest B-DP3: SUCCESS (8.040s)
[136.116047] Starting dynamic subtest: C-DP3
[144.172466] Dynamic subtest C-DP3: SUCCESS (8.066s)
[144.181694] Starting dynamic subtest: D-DP3
[152.211667] Dynamic subtest D-DP3: SUCCESS (8.039s)
[152.213539] Subtest blocking-wf_vblank: SUCCESS (32.273s)
[152.533355] [033/131] (870s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[152.613404] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[152.687108] [034/131] (870s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[152.892165] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[152.906439] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.014s)
[153.024485] [035/131] (870s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[153.229226] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[153.230163] Starting dynamic subtest: pipe-A-DP-3
[153.238995] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[153.247712] Starting dynamic subtest: pipe-B-DP-3
[153.256447] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[153.265060] Starting dynamic subtest: pipe-C-DP-3
[153.273378] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[153.281974] Starting dynamic subtest: pipe-D-DP-3
[153.293136] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[153.295419] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[153.669736] [036/131] (869s left) kms_properties (invalid-properties-legacy)
[153.878237] Starting subtest: invalid-properties-legacy
[154.032535] Subtest invalid-properties-legacy: SUCCESS (0.154s)
[154.115609] [037/131] (869s left) kms_psr (pr-primary-blt)
[154.321533] Subtest pr-primary-blt: SKIP (0.000s)
[154.376719] [038/131] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[154.591968] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[154.593675] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[154.725418] [039/131] (868s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[154.799618] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[154.907560] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[155.049025] [040/131] (868s left) i915_pm_rps (min-max-config-loaded)
[155.136152] Starting subtest: min-max-config-loaded
[155.138117] Subtest min-max-config-loaded: SKIP (0.001s)
[155.254341] [041/131] (868s left) gem_exec_whisper (basic-normal-all)
[155.348201] Starting subtest: basic-normal-all
[157.524715] Subtest basic-normal-all: SUCCESS (2.175s)
[157.813565] [042/131] (866s left) kms_vblank (ts-continuation-idle)
[158.020200] Starting subtest: ts-continuation-idle
[158.021337] Starting dynamic subtest: pipe-A-DP-3
[158.331683] Dynamic subtest pipe-A-DP-3: SUCCESS (0.310s)
[158.349405] Starting dynamic subtest: pipe-D-DP-3
[158.603218] Dynamic subtest pipe-D-DP-3: SUCCESS (0.267s)
[158.604183] Subtest ts-continuation-idle: SUCCESS (0.583s)
[158.841225] [043/131] (865s left) kms_addfb_basic (master-rmfb)
[158.922157] Starting subtest: master-rmfb
[158.937136] Subtest master-rmfb: SUCCESS (0.015s)
[159.179449] [044/131] (864s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[159.386181] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[159.387154] Starting dynamic subtest: pipe-A-DP-3
[159.395861] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[159.404416] Starting dynamic subtest: pipe-B-DP-3
[159.413023] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[159.421419] Starting dynamic subtest: pipe-C-DP-3
[159.429801] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[159.438079] Starting dynamic subtest: pipe-D-DP-3
[159.449095] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[159.451166] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[159.829409] [045/131] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[160.040873] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[160.042544] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[160.182866] [046/131] (864s left) gem_exec_balancer (bonded-chain)
[160.274072] Starting subtest: bonded-chain
[173.734128] Subtest bonded-chain: SUCCESS (13.459s)
[174.148814] [047/131] (850s left) gem_render_copy (linear-to-vebox-y-tiled)
[174.236491] Starting subtest: linear-to-vebox-y-tiled
[174.239257] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[174.460672] [048/131] (849s left) api_intel_bb (crc32)
[174.538072] Starting subtest: crc32
[174.539078] Starting dynamic subtest: rcs0-lmem0
[174.767941] Dynamic subtest rcs0-lmem0: SUCCESS (0.229s)
[174.804860] Starting dynamic subtest: rcs0-smem0
[175.105270] Dynamic subtest rcs0-smem0: SUCCESS (0.336s)
[175.118797] Starting dynamic subtest: bcs0-lmem0
[175.324730] Dynamic subtest bcs0-lmem0: SUCCESS (0.218s)
[175.357052] Starting dynamic subtest: bcs0-smem0
[175.659344] Dynamic subtest bcs0-smem0: SUCCESS (0.333s)
[175.672649] Starting dynamic subtest: vcs0-lmem0
[176.001328] Dynamic subtest vcs0-lmem0: SUCCESS (0.340s)
[176.037905] Starting dynamic subtest: vcs0-smem0
[176.503375] Dynamic subtest vcs0-smem0: SUCCESS (0.500s)
[176.514180] Starting dynamic subtest: vcs1-lmem0
[176.843302] Dynamic subtest vcs1-lmem0: SUCCESS (0.338s)
[176.881415] Starting dynamic subtest: vcs1-smem0
[177.350715] Dynamic subtest vcs1-smem0: SUCCESS (0.506s)
[177.362224] Starting dynamic subtest: vecs0-lmem0
[177.698645] Dynamic subtest vecs0-lmem0: SUCCESS (0.346s)
[177.708388] Starting dynamic subtest: vecs0-smem0
[178.155127] Dynamic subtest vecs0-smem0: SUCCESS (0.457s)
[178.166791] Starting dynamic subtest: vecs1-lmem0
[178.499291] Dynamic subtest vecs1-lmem0: SUCCESS (0.343s)
[178.537456] Starting dynamic subtest: vecs1-smem0
[179.002180] Dynamic subtest vecs1-smem0: SUCCESS (0.501s)
[179.013304] Starting dynamic subtest: ccs0-lmem0
[179.233837] Dynamic subtest ccs0-lmem0: SUCCESS (0.230s)
[179.271570] Starting dynamic subtest: ccs0-smem0
[179.593753] Dynamic subtest ccs0-smem0: SUCCESS (0.358s)
[179.595823] Subtest crc32: SUCCESS (5.055s)
[179.742702] [049/131] (844s left) kms_pm_rpm (modeset-non-lpsp-stress)
[182.105677] Starting subtest: modeset-non-lpsp-stress
[187.563088] Subtest modeset-non-lpsp-stress: SUCCESS (5.460s)
[187.852833] [050/131] (836s left) gem_ctx_engines (execute-oneforall)
[187.946104] Starting subtest: execute-oneforall
[188.548166] Subtest execute-oneforall: SUCCESS (0.602s)
[189.187563] [051/131] (835s left) gem_fence_thrash (bo-write-verify-x)
[189.238572] Starting subtest: bo-write-verify-x
[189.265145] Subtest bo-write-verify-x: SKIP (0.027s)
[189.341819] [052/131] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[189.554986] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[189.556697] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[189.708452] [053/131] (834s left) perf (rc6-disable)
[190.060388] Starting subtest: rc6-disable
[190.248267] Subtest rc6-disable: SUCCESS (0.188s)
[190.363477] [054/131] (834s left) kms_joiner (basic-force-big-joiner)
[190.574175] Starting subtest: basic-force-big-joiner
[190.574913] Starting dynamic subtest: single
[191.350260] Dynamic subtest single: SUCCESS (0.778s)
[191.351318] Subtest basic-force-big-joiner: SUCCESS (0.779s)
[191.732133] [055/131] (833s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[192.015464] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[192.168121] [056/131] (832s left) gem_exec_balancer (full-late-pulse)
[192.264517] Starting subtest: full-late-pulse
[194.104665] Subtest full-late-pulse: SUCCESS (1.840s)
[194.490916] [057/131] (830s left) gem_watchdog (default-physical)
[194.582422] Starting subtest: default-physical
[195.618996] Subtest default-physical: SUCCESS (1.036s)
[195.737221] [058/131] (829s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[195.944806] Starting subtest: cursorA-vs-flipB-varying-size
[195.946611] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[196.051575] [059/131] (828s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[196.288928] Starting subtest: psr-rgb101010-draw-pwrite
[196.290656] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[196.444144] [060/131] (828s left) gem_softpin (evict-single-offset)
[196.532683] Starting subtest: evict-single-offset
[224.213395] Subtest evict-single-offset: SUCCESS (27.680s)
[224.312626] [061/131] (800s left) perf_pmu (module-unload)
[224.466699] Starting subtest: module-unload
[251.156541] Killing the test because the kernel is tainted.
[371.626739] Timeout. Killing the current test with SIGKILL.
[371.633826] Child refuses to die, tainted 0xc0. Aborting.
[371.634653] Closing watchdogs
[371.644778] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[371.644832] [FACT perf_pmu (module-unload)] new: kernel.is_tainted.taint_die: true
[371.645708] Closing watchdogs
Done.