[63.389167] Initializing watchdogs
[63.389239]   /dev/watchdog0
[63.410137] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.421215] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.425170] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.427499] [001/133] (960s left) syncobj_timeline (wait-any-snapshot)
[63.503265] Starting subtest: wait-any-snapshot
[63.586433] Subtest wait-any-snapshot: SUCCESS (0.083s)
[63.736234] [002/133] (960s left) kms_flip (dpms-vs-vblank-race-interruptible)
[65.237218] Starting subtest: dpms-vs-vblank-race-interruptible
[65.242928] Starting dynamic subtest: A-HDMI-A3
[68.362980] Dynamic subtest A-HDMI-A3: SUCCESS (3.127s)
[68.371854] Starting dynamic subtest: B-HDMI-A3
[71.315316] Dynamic subtest B-HDMI-A3: SUCCESS (2.955s)
[71.324167] Starting dynamic subtest: C-HDMI-A3
[74.273454] Dynamic subtest C-HDMI-A3: SUCCESS (2.960s)
[74.281477] Starting dynamic subtest: D-HDMI-A3
[77.233013] Dynamic subtest D-HDMI-A3: SUCCESS (2.960s)
[77.234019] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.012s)
[77.440496] [003/133] (946s left) gem_exec_schedule (fifo)
[77.531887] Starting subtest: fifo
[77.532795] Starting dynamic subtest: rcs0
[77.820132] Dynamic subtest rcs0: SUCCESS (0.281s)
[77.827797] Starting dynamic subtest: bcs0
[78.021272] Dynamic subtest bcs0: SUCCESS (0.199s)
[78.029136] Starting dynamic subtest: vcs0
[78.233760] Dynamic subtest vcs0: SUCCESS (0.211s)
[78.241543] Starting dynamic subtest: vcs1
[78.444575] Dynamic subtest vcs1: SUCCESS (0.209s)
[78.452524] Starting dynamic subtest: vecs0
[78.646464] Dynamic subtest vecs0: SUCCESS (0.210s)
[78.654119] Starting dynamic subtest: vecs1
[78.856985] Dynamic subtest vecs1: SUCCESS (0.210s)
[78.864624] Starting dynamic subtest: ccs0
[79.087525] Dynamic subtest ccs0: SUCCESS (0.229s)
[79.088655] Subtest fifo: SUCCESS (1.556s)
[79.564110] [004/133] (944s left) api_intel_bb (blit-noreloc-purge-cache)
[79.635345] Starting subtest: blit-noreloc-purge-cache
[79.668518] Subtest blit-noreloc-purge-cache: SUCCESS (0.034s)
[79.875480] [005/133] (944s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[81.381984] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[81.383825] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[81.511983] [006/133] (942s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[83.039732] Starting subtest: cursorA-vs-flipB-legacy
[83.041442] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[83.141967] [007/133] (941s left) gem_ccs (block-multicopy-inplace)
[83.246405] Starting subtest: block-multicopy-inplace
[83.247433] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[83.290506] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.044s)
[83.298392] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[83.388491] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.097s)
[83.397588] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[83.403905] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[83.411587] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[83.510962] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.106s)
[83.518857] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[83.526957] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s)
[83.534778] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[83.624605] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.097s)
[83.633683] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[83.640730] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s)
[83.648538] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[83.738046] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.096s)
[83.739032] Subtest block-multicopy-inplace: SUCCESS (0.493s)
[83.914812] [008/133] (940s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[83.986477] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[84.087783] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[84.192231] [009/133] (940s left) kms_cursor_crc (cursor-random-max-size)
[86.017359] Starting subtest: cursor-random-max-size
[86.020050] Subtest cursor-random-max-size: SKIP (0.000s)
[86.198643] [010/133] (938s left) gem_wait (write-busy)
[86.280991] Starting subtest: write-busy
[86.281929] Starting dynamic subtest: all-engines
[86.911273] Dynamic subtest all-engines: SUCCESS (0.630s)
[86.920500] Starting dynamic subtest: rcs0
[87.454348] Dynamic subtest rcs0: SUCCESS (0.542s)
[87.462825] Starting dynamic subtest: bcs0
[87.996054] Dynamic subtest bcs0: SUCCESS (0.541s)
[88.004597] Starting dynamic subtest: vcs0
[88.539181] Dynamic subtest vcs0: SUCCESS (0.542s)
[88.547641] Starting dynamic subtest: vcs1
[89.082088] Dynamic subtest vcs1: SUCCESS (0.542s)
[89.090760] Starting dynamic subtest: vecs0
[89.624053] Dynamic subtest vecs0: SUCCESS (0.541s)
[89.632705] Starting dynamic subtest: vecs1
[90.166051] Dynamic subtest vecs1: SUCCESS (0.541s)
[90.174596] Starting dynamic subtest: ccs0
[90.708180] Dynamic subtest ccs0: SUCCESS (0.542s)
[90.709162] Subtest write-busy: SUCCESS (4.429s)
[91.019496] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[91.021452] [011/133] (933s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[92.580412] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[92.670982] [012/133] (932s left) syncobj_timeline (wait-all-delayed-signal)
[92.754429] Starting subtest: wait-all-delayed-signal
[92.856311] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[93.038695] [013/133] (931s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[94.551905] Starting subtest: psr-rgb101010-draw-pwrite
[94.553687] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[94.677449] [014/133] (930s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[96.250334] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[96.341922] [015/133] (928s left) i915_hangman (gt-engine-hang)
[96.442201] Starting subtest: gt-engine-hang
[96.443161] Starting dynamic subtest: rcs0
[97.240655] Dynamic subtest rcs0: SUCCESS (0.798s)
[97.251197] Starting dynamic subtest: bcs0
[97.962356] Dynamic subtest bcs0: SUCCESS (0.721s)
[97.970777] Starting dynamic subtest: vcs0
[98.676369] Dynamic subtest vcs0: SUCCESS (0.713s)
[98.684690] Starting dynamic subtest: vcs1
[99.393359] Dynamic subtest vcs1: SUCCESS (0.716s)
[99.401655] Starting dynamic subtest: vecs0
[100.109326] Dynamic subtest vecs0: SUCCESS (0.715s)
[100.117452] Starting dynamic subtest: vecs1
[100.825374] Dynamic subtest vecs1: SUCCESS (0.715s)
[100.833779] Starting dynamic subtest: ccs0
[101.655455] Dynamic subtest ccs0: SUCCESS (0.829s)
[101.656459] Subtest gt-engine-hang: SUCCESS (5.215s)
[101.843913] [016/133] (923s left) gem_readwrite (beyond-eob)
[101.923189] Subtest beyond-EOB: SKIP (0.000s)
[101.988091] [017/133] (923s left) gem_exec_reloc (basic-cpu-read)
[102.072489] Subtest basic-cpu-read: SKIP (0.000s)
[102.157765] [018/133] (922s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[103.674044] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[103.675817] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[103.830467] [019/133] (921s left) i915_pm_rps (basic-api)
[103.952296] Starting subtest: basic-api
[103.954396] Subtest basic-api: SKIP (0.000s)
[104.086243] [020/133] (921s left) gen7_exec_parse (batch-without-end)
[104.174156] Subtest batch-without-end: SKIP (0.000s)
[104.257434] [021/133] (921s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[105.778466] Starting subtest: blocking-absolute-wf_vblank-interruptible
[105.784590] Starting dynamic subtest: A-HDMI-A3
[113.672559] Dynamic subtest A-HDMI-A3: SUCCESS (7.889s)
[113.683867] Starting dynamic subtest: B-HDMI-A3
[121.500943] Dynamic subtest B-HDMI-A3: SUCCESS (7.827s)
[121.511304] Starting dynamic subtest: C-HDMI-A3
[129.329685] Dynamic subtest C-HDMI-A3: SUCCESS (7.828s)
[129.340304] Starting dynamic subtest: D-HDMI-A3
[137.157237] Dynamic subtest D-HDMI-A3: SUCCESS (7.827s)
[137.158181] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.382s)
[137.348942] [022/133] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[138.866108] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[138.867876] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[139.091727] [023/133] (886s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[140.605913] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[140.606833] Starting dynamic subtest: pipe-A-HDMI-A-3
[140.615051] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[140.623372] Starting dynamic subtest: pipe-B-HDMI-A-3
[140.639077] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[140.647186] Starting dynamic subtest: pipe-C-HDMI-A-3
[140.655414] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[140.663233] Starting dynamic subtest: pipe-D-HDMI-A-3
[140.672387] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[140.674348] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[140.836618] [024/133] (884s left) gem_exec_balancer (full-late-pulse)
[140.926105] Starting subtest: full-late-pulse
[143.053249] Subtest full-late-pulse: SUCCESS (2.127s)
[143.496134] [025/133] (882s left) sriov_basic (enable-vfs-bind-unbind-each)
[143.575306] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[143.638990] [026/133] (882s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[145.152707] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[145.154259] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[145.316443] [027/133] (880s left) kms_psr (psr-cursor-plane-onoff)
[146.861397] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[146.922636] [028/133] (878s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[148.444974] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[148.446911] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[148.667921] [029/133] (877s left) gem_tiled_blits (normal)
[148.755429] Subtest normal: SKIP (0.000s)
[148.851924] [030/133] (877s left) gem_pxp (verify-pxp-stale-buf-execution)
[151.465999] Starting subtest: verify-pxp-stale-buf-execution
[151.468146] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[151.572301] [031/133] (874s left) kms_psr (fbc-psr2-sprite-plane-move)
[153.084341] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[153.142256] [032/133] (872s left) kms_pipe_stress (stress-xrgb8888-untiled)
[154.659222] Starting subtest: stress-xrgb8888-untiled
[167.901878] Subtest stress-xrgb8888-untiled: SUCCESS (13.239s)
[168.081535] [033/133] (858s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[169.658354] Starting subtest: dp-mst-lic-type-0-hdcp14
[169.660220] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[169.823746] [034/133] (856s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[169.910376] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[169.911320] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[170.096491] [035/133] (856s left) api_intel_bb (object-noreloc-purge-cache-simple)
[170.180500] Starting subtest: object-noreloc-purge-cache-simple
[170.209750] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.030s)
[170.393861] [036/133] (856s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[171.032166] Starting subtest: syncobj-timeline-invalid-flags
[171.033433] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[171.363993] [037/133] (855s left) kms_feature_discovery (chamelium)
[172.876537] Starting subtest: chamelium
[172.878245] Subtest chamelium: SKIP (0.000s)
[172.972327] [038/133] (853s left) i915_drm_fdinfo (busy)
[173.058956] Starting subtest: busy
[173.059875] Starting dynamic subtest: rcs0
[173.085447] Dynamic subtest rcs0: SKIP (0.025s)
[173.094503] Starting dynamic subtest: bcs0
[173.096279] Dynamic subtest bcs0: SKIP (0.000s)
[173.105137] Starting dynamic subtest: vcs0
[173.107346] Dynamic subtest vcs0: SKIP (0.000s)
[173.116473] Starting dynamic subtest: vcs1
[173.118612] Dynamic subtest vcs1: SKIP (0.000s)
[173.127604] Starting dynamic subtest: vecs0
[173.129595] Dynamic subtest vecs0: SKIP (0.000s)
[173.139297] Starting dynamic subtest: vecs1
[173.141057] Dynamic subtest vecs1: SKIP (0.000s)
[173.149912] Starting dynamic subtest: ccs0
[173.152129] Dynamic subtest ccs0: SKIP (0.000s)
[173.154337] Subtest busy: SKIP (0.033s)
[173.207170] [039/133] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[174.729251] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[174.730956] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[174.853515] [040/133] (851s left) kms_hdr (static-toggle-suspend)
[176.388974] Starting subtest: static-toggle-suspend
[176.391639] Subtest static-toggle-suspend: SKIP (0.000s)
[176.497108] [041/133] (850s left) gem_exec_schedule (preempt-queue-contexts-chain)
[176.614588] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[176.996673] [042/133] (849s left) gem_ppgtt (shrink-vs-evict-any)
[177.082136] Starting subtest: shrink-vs-evict-any
[182.931190] Subtest shrink-vs-evict-any: SUCCESS (5.848s)
[183.034799] [043/133] (843s left) gem_huc_copy (huc-copy)
[183.149473] Starting subtest: huc-copy
[183.155343] Subtest huc-copy: SUCCESS (0.007s)
[183.292058] [044/133] (843s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[184.803129] Starting subtest: plane-upscale-20x20-with-modifiers
[184.804008] Starting dynamic subtest: pipe-A
[185.389715] Dynamic subtest pipe-A: SUCCESS (0.587s)
[185.409740] Starting dynamic subtest: pipe-B
[185.964429] Dynamic subtest pipe-B: SUCCESS (0.573s)
[185.986581] Starting dynamic subtest: pipe-C
[186.538602] Dynamic subtest pipe-C: SUCCESS (0.572s)
[186.555655] Starting dynamic subtest: pipe-D
[187.095618] Dynamic subtest pipe-D: SUCCESS (0.555s)
[187.096681] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.294s)
[187.309179] [045/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[188.833130] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[188.834892] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[189.064938] [046/133] (838s left) gem_exec_schedule (preempt-hang)
[189.271358] Starting subtest: preempt-hang
[189.272720] Starting dynamic subtest: rcs0
[189.644573] Dynamic subtest rcs0: SUCCESS (0.373s)
[189.654237] Starting dynamic subtest: bcs0
[189.973963] Dynamic subtest bcs0: SUCCESS (0.328s)
[189.983391] Starting dynamic subtest: vcs0
[190.334165] Dynamic subtest vcs0: SUCCESS (0.359s)
[190.343458] Starting dynamic subtest: vcs1
[190.677436] Dynamic subtest vcs1: SUCCESS (0.342s)
[190.686743] Starting dynamic subtest: vecs0
[191.004623] Dynamic subtest vecs0: SUCCESS (0.326s)
[191.014539] Starting dynamic subtest: vecs1
[191.328381] Dynamic subtest vecs1: SUCCESS (0.323s)
[191.337818] Starting dynamic subtest: ccs0
[191.682135] Dynamic subtest ccs0: SUCCESS (0.352s)
[191.683088] Subtest preempt-hang: SUCCESS (2.412s)
[192.054846] [047/133] (835s left) kms_big_fb (linear-8bpp-rotate-0)
[193.581578] Starting subtest: linear-8bpp-rotate-0
[195.237357] Subtest linear-8bpp-rotate-0: SUCCESS (1.655s)
[195.464557] [048/133] (831s left) kms_getfb (getfb2-handle-closed)
[196.978158] Starting subtest: getfb2-handle-closed
[196.979039] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[197.169750] [049/133] (830s left) perf_pmu (faulting-read)
[197.252498] Starting subtest: faulting-read
[197.253470] Starting dynamic subtest: fixed
[197.255582] Dynamic subtest fixed: SUCCESS (0.001s)
[197.256464] Subtest faulting-read: SUCCESS (0.003s)
[197.401294] [050/133] (830s left) kms_pm_rpm (fences)
[201.037498] Starting subtest: fences
[201.040894] Subtest fences: SKIP (0.000s)
[202.012917] [051/133] (825s left) gem_mmap_gtt (cpuset-medium-copy)
[202.096265] Subtest cpuset-medium-copy: SKIP (0.000s)
[202.160867] [052/133] (825s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[203.677876] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[203.679464] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[203.922439] [053/133] (823s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[205.436037] Starting subtest: plane-primary-overlay-mutable-zpos
[207.095267] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.659s)
[207.305805] [054/133] (820s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[208.815985] Starting subtest: basic-flip-before-cursor-atomic
[209.801833] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.986s)
[209.992081] [055/133] (817s left) gem_ccs (suspend-resume)
[210.078716] Starting subtest: suspend-resume
[210.079619] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0