[63.311052] Initializing watchdogs
[63.311117]   /dev/watchdog0
[63.329073] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.338458] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.342275] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.344796] [001/129] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[63.632991] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[63.634808] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[63.776567] [002/129] (960s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[63.847503] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[63.848411] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[63.970394] [003/129] (959s left) kms_big_fb (x-tiled-addfb-size-overflow)
[64.179200] Starting subtest: x-tiled-addfb-size-overflow
[64.180085] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[64.299367] [004/129] (959s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[64.379592] Starting subtest: etime-multi-wait-available-unsubmitted
[64.491933] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s)
[64.625187] [005/129] (959s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[64.834414] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[65.522140] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.689s)
[65.751469] [006/129] (958s left) perf (rc6-disable)
[66.086981] Starting subtest: rc6-disable
[66.276070] Subtest rc6-disable: SUCCESS (0.188s)
[66.379638] [007/129] (957s left) drm_fdinfo (busy-idle-check-all)
[66.443274] Starting subtest: busy-idle-check-all
[66.444215] Starting dynamic subtest: rcs0
[66.466151] Dynamic subtest rcs0: SKIP (0.022s)
[66.473690] Starting dynamic subtest: bcs0
[66.475575] Dynamic subtest bcs0: SKIP (0.000s)
[66.482949] Starting dynamic subtest: vcs0
[66.484986] Dynamic subtest vcs0: SKIP (0.000s)
[66.492559] Starting dynamic subtest: vcs1
[66.494650] Dynamic subtest vcs1: SKIP (0.000s)
[66.502062] Starting dynamic subtest: vecs0
[66.504150] Dynamic subtest vecs0: SKIP (0.001s)
[66.513597] Starting dynamic subtest: vecs1
[66.515733] Dynamic subtest vecs1: SKIP (0.000s)
[66.522750] Starting dynamic subtest: ccs0
[66.524786] Dynamic subtest ccs0: SKIP (0.000s)
[66.526814] Subtest busy-idle-check-all: SKIP (0.025s)
[66.562061] [008/129] (957s left) syncobj_wait (single-wait-all-for-submit-signaled)
[66.683245] Starting subtest: single-wait-all-for-submit-signaled
[66.684379] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[66.863346] [009/129] (957s left) kms_cdclk (mode-transition-all-outputs)
[67.160259] Starting subtest: mode-transition-all-outputs
[67.249636] Subtest mode-transition-all-outputs: SKIP (0.088s)
[67.444790] [010/129] (956s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[67.770256] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[67.771203] Starting dynamic subtest: pipe-A-valid-mode
[67.845168] Dynamic subtest pipe-A-valid-mode: SKIP (0.073s)
[67.847048] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.074s)
[68.036873] [011/129] (956s left) kms_atomic_transition (modeset-transition)
[68.237414] Starting subtest: modeset-transition
[68.238329] Starting dynamic subtest: 1x-outputs
[70.847051] Dynamic subtest 1x-outputs: SUCCESS (2.609s)
[70.902928] Subtest modeset-transition: SUCCESS (2.666s)
[71.176695] [012/129] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[71.384538] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[71.386270] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[71.560691] [013/129] (953s left) gem_mmap_wc (read)
[71.633099] Subtest read: SKIP (0.000s)
[71.705019] [014/129] (952s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[71.910277] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[71.952774] [015/129] (952s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[72.189730] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[72.191391] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[72.313482] [016/129] (952s left) gem_close (basic)
[72.390484] Starting subtest: basic
[72.391452] Subtest basic: SUCCESS (0.000s)
[72.545496] [017/129] (952s left) kms_content_protection (srm)
[72.801293] Starting subtest: srm
[72.834847] Starting dynamic subtest: pipe-A-DP-3
[195.381447] Dynamic subtest pipe-A-DP-3: FAIL (122.381s)
[195.382551] Subtest srm: FAIL (122.494s)
[195.561550] [018/129] (829s left) kms_chamelium_frames (hdmi-crc-fast)
[195.840572] Subtest hdmi-crc-fast: SKIP (0.000s)
[195.991554] [019/129] (828s left) prime_vgem (coherency-gtt)
[196.111524] Starting subtest: coherency-gtt
[196.113785] Subtest coherency-gtt: SKIP (0.000s)
[196.261096] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[196.263160] [020/129] (828s left) gem_exec_whisper (basic-contexts-all)
[196.357916] Starting subtest: basic-contexts-all
[218.322957] Subtest basic-contexts-all: SUCCESS (21.963s)
[218.573388] [021/129] (806s left) gem_ctx_sseu (invalid-args)
[218.657219] Subtest invalid-args: SKIP (0.000s)
[218.732377] [022/129] (806s left) gem_mmap_gtt (ptrace)
[218.813179] Subtest ptrace: SKIP (0.000s)
[218.885803] [023/129] (806s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[218.969517] Starting subtest: invalid-bsd2-flag-on-vebox
[218.970406] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[219.113941] [024/129] (806s left) gem_softpin (allocator-evict)
[219.198793] Starting subtest: allocator-evict
[219.199761] Starting dynamic subtest: rcs0
[245.559661] Dynamic subtest rcs0: SUCCESS (26.360s)
[245.567928] Starting dynamic subtest: bcs0
[271.878480] Dynamic subtest bcs0: SUCCESS (26.318s)
[271.886826] Starting dynamic subtest: vcs0
[298.638558] Dynamic subtest vcs0: SUCCESS (26.759s)
[298.646901] Starting dynamic subtest: vcs1
[325.431552] Dynamic subtest vcs1: SUCCESS (26.792s)
[325.439915] Starting dynamic subtest: vecs0
[351.870752] Dynamic subtest vecs0: SUCCESS (26.439s)
[351.879121] Starting dynamic subtest: vecs1
[378.586664] Dynamic subtest vecs1: SUCCESS (26.715s)
[378.595161] Starting dynamic subtest: ccs0
[405.103515] Dynamic subtest ccs0: SUCCESS (26.516s)
[405.104572] Subtest allocator-evict: SUCCESS (185.902s)
[405.286661] [025/129] (620s left) kms_vblank (ts-continuation-dpms-suspend)
[405.541090] Starting subtest: ts-continuation-dpms-suspend
[405.542984] Starting dynamic subtest: pipe-A-DP-3
[424.742067] Dynamic subtest pipe-A-DP-3: SUCCESS (4.198s)
[424.754010] Starting dynamic subtest: pipe-D-DP-3
[444.092102] Dynamic subtest pipe-D-DP-3: SUCCESS (4.037s)
[444.093052] Subtest ts-continuation-dpms-suspend: SUCCESS (8.239s)
[444.293406] [026/129] (611s left) syncobj_basic (bad-flags-handle-to-fd)
[444.378364] Starting subtest: bad-flags-handle-to-fd
[444.379447] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[444.493613] [027/129] (611s left) kms_vblank (wait-busy-hang)
[444.702385] Starting subtest: wait-busy-hang
[444.704344] Starting dynamic subtest: pipe-A-DP-3
[470.917151] Dynamic subtest pipe-A-DP-3: SUCCESS (26.213s)
[470.929390] Starting dynamic subtest: pipe-D-DP-3
[495.909433] Dynamic subtest pipe-D-DP-3: SUCCESS (24.990s)
[495.910344] Subtest wait-busy-hang: SUCCESS (51.208s)
[496.165821] [028/129] (559s left) gem_mmap_offset (bad-flags)
[496.315289] Starting subtest: bad-flags
[496.316388] Subtest bad-flags: SUCCESS (0.000s)
[496.485058] [029/129] (559s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[496.693814] Starting subtest: flip-vs-cursor-atomic-transitions
[506.769402] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (10.075s)
[507.042334] [030/129] (548s left) api_intel_bb (intel-bb-blit-none)
[507.121273] Starting subtest: intel-bb-blit-none
[507.811981] Subtest intel-bb-blit-none: SUCCESS (0.691s)
[507.926269] [031/129] (548s left) gem_eio (banned)
[508.215369] Starting subtest: banned
[509.218066] Subtest banned: SUCCESS (0.996s)
[509.524061] [032/129] (546s left) kms_cursor_crc (cursor-random-64x21)
[509.848751] Starting subtest: cursor-random-64x21
[509.852631] Starting dynamic subtest: pipe-A-DP-3
[514.294246] Dynamic subtest pipe-A-DP-3: SUCCESS (4.440s)
[514.344747] Starting dynamic subtest: pipe-D-DP-3
[518.659434] Dynamic subtest pipe-D-DP-3: SUCCESS (4.325s)
[518.660457] Subtest cursor-random-64x21: SUCCESS (8.810s)
[519.071047] [033/129] (537s left) kms_psr (fbc-psr-primary-mmap-cpu)
[519.275623] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[519.332541] [034/129] (536s left) syncobj_wait (wait-for-submit-delayed-submit)
[519.420367] Starting subtest: wait-for-submit-delayed-submit
[519.522904] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[519.655041] [035/129] (536s left) kms_dp_aux_dev
[520.314166] [036/129] (536s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[520.399724] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[520.401649] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[520.608837] [037/129] (535s left) gem_exec_params (invalid-ring)
[520.695242] Starting subtest: invalid-ring
[520.696189] Subtest invalid-ring: SUCCESS (0.000s)
[520.843854] [038/129] (535s left) gem_eio (wait-wedge-immediate)
[521.136602] Starting subtest: wait-wedge-immediate
[522.247820] Subtest wait-wedge-immediate: SUCCESS (1.112s)
[522.481027] [039/129] (534s left) syncobj_timeline (wait-for-submit-snapshot)
[522.578677] Starting subtest: wait-for-submit-snapshot
[522.663529] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[522.798386] [040/129] (533s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[523.010478] Starting subtest: bad-pixel-format-y-tiled-ccs
[523.011447] Starting dynamic subtest: pipe-A-DP-3
[523.020171] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[523.031503] Starting dynamic subtest: pipe-B-DP-3
[523.040267] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[523.051501] Starting dynamic subtest: pipe-C-DP-3
[523.060099] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[523.071565] Starting dynamic subtest: pipe-D-DP-3
[523.082133] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[523.084369] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[523.487390] [041/129] (533s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[523.702795] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[523.704510] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[523.865939] [042/129] (532s left) kms_chamelium_frames (dp-crc-single)
[524.161619] Subtest dp-crc-single: SKIP (0.000s)
[524.316502] [043/129] (532s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[524.528613] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[524.529550] Starting dynamic subtest: pipe-A-valid-mode
[529.472893] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.942s)
[529.474544] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SUCCESS (4.944s)
[529.751865] [044/129] (527s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[529.964173] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[529.965817] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[530.101518] [045/129] (526s left) gem_lmem_swapping (massive-random)
[533.120648] Starting subtest: massive-random
[533.121612] Starting dynamic subtest: lmem0
[533.445949] Dynamic subtest lmem0: SUCCESS (0.325s)
[533.446870] Subtest massive-random: SUCCESS (0.325s)
[535.014816] [FACT gem_lmem_swapping (massive-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[535.015817] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true
[535.017884] [046/129] (522s left) gem_workarounds (suspend-resume)
[536.542116] Starting subtest: suspend-resume
[555.271895] Subtest suspend-resume: SUCCESS (4.566s)
[555.373062] [FACT gem_workarounds (suspend-resume)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[555.377196] [FACT gem_workarounds (suspend-resume)] new: kernel.kmod_is_loaded.i915: true
[555.379972] [047/129] (515s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[555.591998] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[555.592923] Starting dynamic subtest: pipe-A-DP-3
[555.601770] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[555.611851] Starting dynamic subtest: pipe-B-DP-3
[555.620547] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[555.631775] Starting dynamic subtest: pipe-C-DP-3
[555.640205] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[555.650221] Starting dynamic subtest: pipe-D-DP-3
[555.661031] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[555.663195] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[556.042396] [048/129] (515s left) kms_plane_scaling (invalid-parameters)
[556.271773] Starting subtest: invalid-parameters
[556.272695] Starting dynamic subtest: less-than-1-height-src
[556.283833] Dynamic subtest less-than-1-height-src: SUCCESS (0.012s)
[556.294017] Starting dynamic subtest: less-than-1-width-src
[556.296903] Dynamic subtest less-than-1-width-src: SUCCESS (0.012s)
[556.297809] Subtest invalid-parameters: SUCCESS (0.026s)
[556.426773] [049/129] (514s left) gem_mmap_gtt (basic-read-write-distinct)
[556.509802] Subtest basic-read-write-distinct: SKIP (0.000s)
[556.627201] [050/129] (514s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[556.716299] Subtest untiled-to-tiled: SKIP (0.000s)
[556.799908] [051/129] (514s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[556.884403] Starting subtest: invalid-single-wait-unsubmitted
[556.885278] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[557.026222] [052/129] (514s left) gem_madvise (dontneed-before-mmap)
[557.076850] Starting subtest: dontneed-before-mmap
[557.122861] Subtest dontneed-before-mmap: SUCCESS (0.046s)
[557.280245] [053/129] (514s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[557.502808] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[560.177198] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.675s)
[560.370238] [054/129] (511s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[560.579594] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[560.581292] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[560.715006] [055/129] (511s left) kms_flip (busy-flip)
[560.922709] Starting subtest: busy-flip
[560.926657] Starting dynamic subtest: A-DP3
[561.780519] Dynamic subtest A-DP3: SUCCESS (0.854s)
[561.793495] Starting dynamic subtest: B-DP3
[562.548338] Dynamic subtest B-DP3: SUCCESS (0.767s)
[562.559374] Starting dynamic subtest: C-DP3
[563.300936] Dynamic subtest C-DP3: SUCCESS (0.752s)
[563.313133] Starting dynamic subtest: D-DP3
[564.051729] Dynamic subtest D-DP3: SUCCESS (0.749s)
[564.058789] Subtest busy-flip: SUCCESS (3.136s)
[564.414475] [056/129] (507s left) gem_madvise (dontneed-before-pwrite)
[564.465743] Starting subtest: dontneed-before-pwrite
[564.497851] Subtest dontneed-before-pwrite: SKIP (0.031s)
[564.585718] [057/129] (507s left) kms_pm_rpm (modeset-non-lpsp-stress)
[566.535226] Starting subtest: modeset-non-lpsp-stress
[571.549299] Subtest modeset-non-lpsp-stress: SUCCESS (5.014s)
[571.779896] [058/129] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[571.996677] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[571.998488] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[572.134610] [059/129] (499s left) i915_pm_rpm (gem-execbuf)
[574.492324] Starting subtest: gem-execbuf
[574.494127] Starting dynamic subtest: lmem0
[577.407869] Dynamic subtest lmem0: SUCCESS (2.913s)
[577.445607] Starting dynamic subtest: smem0
[580.031719] Dynamic subtest smem0: SUCCESS (2.621s)
[580.033623] Subtest gem-execbuf: SUCCESS (5.541s)
[580.416374] [060/129] (491s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[580.626142] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[580.628267] Starting dynamic subtest: pipe-A-DP-3
[580.644235] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[580.655063] Starting dynamic subtest: pipe-B-DP-3
[580.663592] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[580.674232] Starting dynamic subtest: pipe-C-DP-3
[580.684197] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[580.695091] Starting dynamic subtest: pipe-D-DP-3
[580.705791] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[580.707633] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.008s)
[581.084813] [061/129] (491s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[581.306109] Starting subtest: primary-y-tiled-reflect-x-180
[581.399053] Subtest primary-y-tiled-reflect-x-180: SKIP (0.091s)
[581.561016] [062/129] (490s left) drm_fdinfo (most-busy-idle-check-all)
[581.632457] Starting subtest: most-busy-idle-check-all
[581.633355] Starting dynamic subtest: rcs0
[581.660243] Dynamic subtest rcs0: SKIP (0.027s)
[581.671920] Starting dynamic subtest: bcs0
[581.674260] Dynamic subtest bcs0: SKIP (0.001s)
[581.685270] Starting dynamic subtest: vcs0
[581.687763] Dynamic subtest vcs0: SKIP (0.000s)
[581.698712] Starting dynamic subtest: vcs1
[581.700925] Dynamic subtest vcs1: SKIP (0.000s)
[581.711900] Starting dynamic subtest: vecs0
[581.714165] Dynamic subtest vecs0: SKIP (0.000s)
[581.726804] Starting dynamic subtest: vecs1
[581.729525] Dynamic subtest vecs1: SKIP (0.000s)
[581.740178] Starting dynamic subtest: ccs0
[581.742174] Dynamic subtest ccs0: SKIP (0.000s)
[581.743903] Subtest most-busy-idle-check-all: SKIP (0.035s)
[581.786825] [063/129] (490s left) gem_exec_balancer (sequential)
[581.918068] Starting subtest: sequential
[587.544121] Subtest sequential: SUCCESS (5.626s)
[587.946735] [064/129] (484s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[588.156579] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[588.158353] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[588.280588] [065/129] (484s left) kms_psr (fbc-psr2-cursor-plane-move)
[588.488045] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[588.556800] [066/129] (483s left) kms_concurrent (multi-plane-atomic-lowres)
[588.771961] Starting subtest: multi-plane-atomic-lowres
[588.772879] Starting dynamic subtest: pipe-A-DP-3
[589.264548] Dynamic subtest pipe-A-DP-3: SUCCESS (0.491s)
[589.265568] Subtest multi-plane-atomic-lowres: SUCCESS (0.493s)
[589.574795] [067/129] (483s left) kms_busy (extended-modeset-hang-newfb)
[589.788163] Starting subtest: extended-modeset-hang-newfb
[589.790341] Starting dynamic subtest: pipe-A
[605.469649] Dynamic subtest pipe-A: SUCCESS (15.677s)
[605.500160] Starting dynamic subtest: pipe-D
[621.211260] Dynamic subtest pipe-D: SUCCESS (15.732s)
[621.212286] Subtest extended-modeset-hang-newfb: SUCCESS (31.422s)
[621.535357] [068/129] (451s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[621.752726] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[624.767621] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.014s)
[624.989737] [069/129] (447s left) gen7_exec_parse (batch-without-end)
[625.078115] Subtest batch-without-end: SKIP (0.000s)
[625.167393] [070/129] (447s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[625.384145] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[625.385914] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[625.529768] [071/129] (447s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[625.743547] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[625.745252] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[625.896688] [072/129] (447s left) gem_exec_balancer (full-pulse)
[625.985122] Starting subtest: full-pulse
[627.855922] Subtest full-pulse: SUCCESS (1.871s)
[628.246773] [073/129] (444s left) kms_legacy_colorkey (basic)
[628.460261] Starting subtest: basic
[628.461196] Starting dynamic subtest: pipe-A
[628.516046] Dynamic subtest pipe-A: SUCCESS (0.055s)
[628.534188] Starting dynamic subtest: pipe-B
[628.535200] Dynamic subtest pipe-B: SUCCESS (0.000s)
[628.551872] Starting dynamic subtest: pipe-C
[628.553152] Dynamic subtest pipe-C: SUCCESS (0.000s)
[628.566283] Starting dynamic subtest: pipe-D
[628.567496] Dynamic subtest pipe-D: SUCCESS (0.000s)
[628.568745] Subtest basic: SUCCESS (0.061s)
[628.632613] [074/129] (444s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[628.854800] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[628.856725] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[628.977251] [075/129] (444s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[629.194911] Starting subtest: 2x-flip-vs-modeset-vs-hang
[629.211583] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.016s)
[629.324653] [076/129] (443s left) sriov_basic (enable-vfs-autoprobe-off)
[629.411927] Subtest enable-vfs-autoprobe-off: SKIP (0.000s)
[629.508935] [077/129] (443s left) gem_exec_nop (basic-sequential)
[629.602321] Starting subtest: basic-sequential
[634.074192] Subtest basic-sequential: SUCCESS (4.469s)
[634.319914] [078/129] (439s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[634.541106] Starting subtest: yf-tiled-addfb-size-overflow
[634.542941] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[634.703457] [079/129] (438s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[634.915412] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[634.916400] Starting dynamic subtest: pipe-A
[635.467314] Dynamic subtest pipe-A: SUCCESS (0.551s)
[635.502642] Starting dynamic subtest: pipe-B
[636.119261] Dynamic subtest pipe-B: SUCCESS (0.649s)
[636.149084] Starting dynamic subtest: pipe-C
[636.772129] Dynamic subtest pipe-C: SUCCESS (0.650s)
[636.807843] Starting dynamic subtest: pipe-D
[637.428754] Dynamic subtest pipe-D: SUCCESS (0.653s)
[637.430122] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (2.514s)
[637.773129] [080/129] (435s left) gem_ctx_persistence (smoketest)
[637.861166] Starting subtest: smoketest
[676.511435] Subtest smoketest: SUCCESS (38.650s)
[676.657244] [081/129] (396s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[676.865202] Starting subtest: coverage-vs-premult-vs-constant
[677.089102] Starting dynamic subtest: pipe-A-DP-3
[677.560820] Dynamic subtest pipe-A-DP-3: SUCCESS (0.471s)
[677.579035] Starting dynamic subtest: pipe-D-DP-3
[678.079660] Dynamic subtest pipe-D-DP-3: SUCCESS (0.516s)
[678.080581] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.214s)
[678.374105] [082/129] (395s left) gem_exec_reloc (basic-cpu-read-active)
[678.466575] Subtest basic-cpu-read-active: SKIP (0.000s)
[678.559472] [083/129] (395s left) kms_invalid_mode (bad-hsync-start)
[678.768800] Starting subtest: bad-hsync-start
[678.769759] Starting dynamic subtest: pipe-A-DP-3
[678.850660] Dynamic subtest pipe-A-DP-3: SUCCESS (0.081s)
[678.869218] Starting dynamic subtest: pipe-B-DP-3
[678.870461] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[678.886828] Starting dynamic subtest: pipe-C-DP-3
[678.887804] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[678.900992] Starting dynamic subtest: pipe-D-DP-3
[678.901893] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[678.902719] Subtest bad-hsync-start: SUCCESS (0.092s)
[679.091823] [084/129] (394s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[679.171737] Starting subtest: etime-single-wait-for-submit-unsubmitted
[679.273965] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[679.393650] [085/129] (394s left) syncobj_wait (single-wait-submitted)
[679.476147] Starting subtest: single-wait-submitted
[679.578217] Subtest single-wait-submitted: SUCCESS (0.101s)
[679.707447] [086/129] (394s left) perf (blocking-parameterized)
[680.057786] Starting subtest: blocking-parameterized
[700.091198] Subtest blocking-parameterized: SUCCESS (20.034s)
[700.149408] [087/129] (373s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[700.363832] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[700.438253] [088/129] (373s left) gem_exec_schedule (implicit-boths)
[700.534586] Starting subtest: implicit-boths
[700.535571] Starting dynamic subtest: rcs0
[700.810861] Dynamic subtest rcs0: SUCCESS (0.276s)
[700.824135] Starting dynamic subtest: bcs0
[701.005970] Dynamic subtest bcs0: SUCCESS (0.194s)
[701.020630] Starting dynamic subtest: vcs0
[701.208307] Dynamic subtest vcs0: SUCCESS (0.201s)
[701.221497] Starting dynamic subtest: vcs1
[701.410641] Dynamic subtest vcs1: SUCCESS (0.201s)
[701.423737] Starting dynamic subtest: vecs0
[701.614429] Dynamic subtest vecs0: SUCCESS (0.203s)
[701.627192] Starting dynamic subtest: vecs1
[701.817587] Dynamic subtest vecs1: SUCCESS (0.202s)
[701.830368] Starting dynamic subtest: ccs0
[702.022119] Dynamic subtest ccs0: SUCCESS (0.204s)
[702.023083] Subtest implicit-boths: SUCCESS (1.488s)
[702.589483] [089/129] (371s left) kms_cursor_crc (cursor-sliding-256x85)
[702.982610] Starting subtest: cursor-sliding-256x85
[702.987342] Starting dynamic subtest: pipe-A-DP-3
[707.263646] Dynamic subtest pipe-A-DP-3: SUCCESS (4.273s)
[707.314403] Starting dynamic subtest: pipe-D-DP-3
[711.658938] Dynamic subtest pipe-D-DP-3: SUCCESS (4.357s)
[711.659975] Subtest cursor-sliding-256x85: SUCCESS (8.676s)
[712.029230] [090/129] (362s left) gem_softpin (evict-snoop-interruptible)
[712.118289] Starting subtest: evict-snoop-interruptible
[712.120104] Subtest evict-snoop-interruptible: SKIP (0.000s)
[712.299452] [091/129] (362s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[712.512265] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[712.514557] Starting dynamic subtest: pipe-A-valid-mode
[712.586474] Dynamic subtest pipe-A-valid-mode: SKIP (0.071s)
[712.588259] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.073s)
[712.803867] [092/129] (361s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[713.034160] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[713.049105] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.014s)
[713.145716] [093/129] (361s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[713.359649] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[713.446469] [094/129] (361s left) gem_ctx_isolation (dirty-create)
[713.535235] Starting subtest: dirty-create
[713.536176] Starting dynamic subtest: rcs0
[714.096279] Dynamic subtest rcs0: SUCCESS (0.560s)
[714.109886] Starting dynamic subtest: bcs0
[714.727012] Dynamic subtest bcs0: SUCCESS (0.630s)
[714.740483] Starting dynamic subtest: vcs0
[715.337906] Dynamic subtest vcs0: SUCCESS (0.610s)
[715.351230] Starting dynamic subtest: vcs1
[715.944656] Dynamic subtest vcs1: SUCCESS (0.606s)
[715.958378] Starting dynamic subtest: vecs0
[716.545178] Dynamic subtest vecs0: SUCCESS (0.600s)
[716.558178] Starting dynamic subtest: vecs1
[717.167580] Dynamic subtest vecs1: SUCCESS (0.621s)
[717.180475] Starting dynamic subtest: ccs0
[717.815807] Dynamic subtest ccs0: SUCCESS (0.647s)
[717.816824] Subtest dirty-create: SUCCESS (4.281s)
[718.115465] [095/129] (356s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[718.325824] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[718.386918] [096/129] (356s left) kms_sequence (get-busy)
[718.603393] Starting subtest: get-busy
[718.606077] Starting dynamic subtest: pipe-A-DP-3
[721.166698] Dynamic subtest pipe-A-DP-3: SUCCESS (2.560s)
[721.181159] Starting dynamic subtest: pipe-B-DP-3
[723.668328] Dynamic subtest pipe-B-DP-3: SUCCESS (2.500s)
[723.681939] Starting dynamic subtest: pipe-C-DP-3
[726.141860] Dynamic subtest pipe-C-DP-3: SUCCESS (2.473s)
[726.157081] Starting dynamic subtest: pipe-D-DP-3
[728.617049] Dynamic subtest pipe-D-DP-3: SUCCESS (2.473s)
[728.618069] Subtest get-busy: SUCCESS (10.014s)
[728.886153] [097/129] (345s left) kms_hdr (static-toggle-suspend)
[729.104334] Starting subtest: static-toggle-suspend
[732.521039] Starting dynamic subtest: pipe-A-DP-3
[752.775185] Dynamic subtest pipe-A-DP-3: SUCCESS (5.022s)
[752.776169] Subtest static-toggle-suspend: SUCCESS (8.438s)
[753.096931] [098/129] (336s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[753.381399] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[753.383942] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[753.756806] [099/129] (336s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[754.135376] Starting subtest: flip-vs-cursor-varying-size
[765.129931] Subtest flip-vs-cursor-varying-size: SUCCESS (10.995s)
[765.411169] [100/129] (324s left) kms_plane_scaling (planes-upscale-factor-0-25)
[765.616513] Starting subtest: planes-upscale-factor-0-25
[765.617370] Starting dynamic subtest: pipe-A
[765.707478] Dynamic subtest pipe-A: SUCCESS (0.090s)
[765.721630] Starting dynamic subtest: pipe-B
[765.909669] Dynamic subtest pipe-B: SUCCESS (0.201s)
[765.933183] Starting dynamic subtest: pipe-C
[766.130426] Dynamic subtest pipe-C: SUCCESS (0.219s)
[766.146861] Starting dynamic subtest: pipe-D
[766.332559] Dynamic subtest pipe-D: SUCCESS (0.201s)
[766.333570] Subtest planes-upscale-factor-0-25: SUCCESS (0.717s)
[766.664162] [101/129] (323s left) gem_exec_schedule (preempt-other-chain)
[766.759778] Starting subtest: preempt-other-chain
[766.760799] Starting dynamic subtest: rcs0
[767.376387] Dynamic subtest rcs0: SUCCESS (0.615s)
[767.389298] Starting dynamic subtest: bcs0
[767.975559] Dynamic subtest bcs0: SUCCESS (0.598s)
[767.988486] Starting dynamic subtest: vcs0
[768.585121] Dynamic subtest vcs0: SUCCESS (0.608s)
[768.599278] Starting dynamic subtest: vcs1
[769.184818] Dynamic subtest vcs1: SUCCESS (0.599s)
[769.198155] Starting dynamic subtest: vecs0
[769.898372] Dynamic subtest vecs0: SUCCESS (0.712s)
[769.911773] Starting dynamic subtest: vecs1
[770.505469] Dynamic subtest vecs1: SUCCESS (0.606s)
[770.519120] Starting dynamic subtest: ccs0
[771.129914] Dynamic subtest ccs0: SUCCESS (0.623s)
[771.130900] Subtest preempt-other-chain: SUCCESS (4.370s)
[771.499736] [102/129] (318s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[771.715195] Starting subtest: x-tiled-64bpp-rotate-0
[773.437136] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.721s)
[773.613632] [103/129] (316s left) device_reset (cold-reset-bound)
[773.695365] Starting subtest: cold-reset-bound
[773.697511] Subtest cold-reset-bound: SKIP (0.000s)
[773.786686] [104/129] (316s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[774.485195] Starting subtest: syncobj-backward-timeline-chain-engines
[774.611593] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.127s)
[774.943302] [105/129] (315s left) kms_flip (plain-flip-fb-recreate)
[775.153025] Starting subtest: plain-flip-fb-recreate
[775.157536] Starting dynamic subtest: A-DP3
[783.293667] Dynamic subtest A-DP3: SUCCESS (8.135s)
[783.336023] Starting dynamic subtest: B-DP3
[791.368099] Dynamic subtest B-DP3: SUCCESS (8.068s)
[791.414487] Starting dynamic subtest: C-DP3
[799.440903] Dynamic subtest C-DP3: SUCCESS (8.067s)
[799.485402] Starting dynamic subtest: D-DP3
[807.517080] Dynamic subtest D-DP3: SUCCESS (8.070s)
[807.525061] Subtest plain-flip-fb-recreate: SUCCESS (32.370s)
[807.916387] [106/129] (282s left) gem_eio (in-flight-contexts-10ms)
[808.221006] Starting subtest: in-flight-contexts-10ms
[821.697414] Subtest in-flight-contexts-10ms: SUCCESS (13.477s)
[821.930157] [107/129] (268s left) i915_pm_rps (fence-order)
[822.019056] Starting subtest: fence-order
[826.177950] Subtest fence-order: SUCCESS (4.158s)
[826.334001] [108/129] (264s left) gem_ppgtt (flink-and-close-vma-leak)
[826.422140] Starting subtest: flink-and-close-vma-leak
[826.490718] Subtest flink-and-close-vma-leak: SUCCESS (0.069s)
[826.679186] [109/129] (264s left) kms_flip (2x-nonexisting-fb)
[826.897061] Starting subtest: 2x-nonexisting-fb
[826.912013] Subtest 2x-nonexisting-fb: SKIP (0.014s)
[827.032162] [110/129] (263s left) perf_pmu (module-unload)
[827.153416] Starting subtest: module-unload
[846.035317] Killing the test because the kernel is tainted.
[966.525499] Timeout. Killing the current test with SIGKILL.
[966.532514] Child refuses to die, tainted 0xc0. Aborting.
[966.533469] Closing watchdogs
[966.543990] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[966.544103] [FACT perf_pmu (module-unload)] new: kernel.is_tainted.taint_die: true
[966.544986] Closing watchdogs
Done.