[56.549826] Initializing watchdogs
[56.549917]   /dev/watchdog0
[56.570475] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[56.581115] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[56.584845] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.587366] [001/131] (960s left) kms_cursor_edge_walk (256x256-right-edge)
[56.771990] Starting subtest: 256x256-right-edge
[56.772881] Starting dynamic subtest: pipe-A-DP-3
[60.286420] Dynamic subtest pipe-A-DP-3: SUCCESS (3.508s)
[60.296199] Starting dynamic subtest: pipe-D-DP-3
[63.617946] Dynamic subtest pipe-D-DP-3: SUCCESS (3.327s)
[63.619064] Subtest 256x256-right-edge: SUCCESS (6.838s)
[63.917092] [002/131] (953s left) gem_exec_schedule (independent)
[64.003447] Starting subtest: independent
[64.004399] Starting dynamic subtest: rcs0
[64.442381] Dynamic subtest rcs0: SUCCESS (0.438s)
[64.450999] Starting dynamic subtest: bcs0
[64.814364] Dynamic subtest bcs0: SUCCESS (0.372s)
[64.824119] Starting dynamic subtest: vcs0
[65.201484] Dynamic subtest vcs0: SUCCESS (0.387s)
[65.210333] Starting dynamic subtest: vcs1
[65.593493] Dynamic subtest vcs1: SUCCESS (0.391s)
[65.603663] Starting dynamic subtest: vecs0
[65.972617] Dynamic subtest vecs0: SUCCESS (0.378s)
[66.006171] Starting dynamic subtest: vecs1
[66.396367] Dynamic subtest vecs1: SUCCESS (0.424s)
[66.405447] Starting dynamic subtest: ccs0
[66.802542] Dynamic subtest ccs0: SUCCESS (0.406s)
[66.803444] Subtest independent: SUCCESS (2.797s)
[67.519856] [003/131] (949s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[67.778705] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[70.307705] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.529s)
[70.567454] [004/131] (946s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[70.750476] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[70.765944] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s)
[70.925553] [005/131] (946s left) kms_async_flips (crc)
[71.105522] Starting subtest: crc
[71.343536] Starting dynamic subtest: pipe-A-DP-3
[73.746112] Dynamic subtest pipe-A-DP-3: SUCCESS (2.402s)
[73.945505] Starting dynamic subtest: pipe-B-DP-3
[76.162892] Dynamic subtest pipe-B-DP-3: SUCCESS (2.224s)
[76.371135] Starting dynamic subtest: pipe-C-DP-3
[78.588980] Dynamic subtest pipe-C-DP-3: SUCCESS (2.226s)
[78.764395] Starting dynamic subtest: pipe-D-DP-3
[80.982871] Dynamic subtest pipe-D-DP-3: SUCCESS (2.227s)
[80.983775] Subtest crc: SUCCESS (9.876s)
[81.409262] [006/131] (936s left) kms_psr (psr-cursor-plane-move)
[81.595441] Subtest psr-cursor-plane-move: SKIP (0.000s)
[81.653230] [007/131] (935s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[81.833947] Starting subtest: cursorA-vs-flipA-atomic-transitions
[92.792498] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.958s)
[93.103199] [008/131] (924s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[93.298175] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[93.345738] [009/131] (924s left) gem_cs_tlb (engines)
[93.422345] Starting subtest: engines
[93.423259] Starting dynamic subtest: rcs0
[95.576218] Dynamic subtest rcs0: SUCCESS (2.153s)
[95.584976] Starting dynamic subtest: bcs0
[97.730264] Dynamic subtest bcs0: SUCCESS (2.153s)
[97.738575] Starting dynamic subtest: vcs0
[99.885184] Dynamic subtest vcs0: SUCCESS (2.154s)
[99.893362] Starting dynamic subtest: vcs1
[102.038665] Dynamic subtest vcs1: SUCCESS (2.153s)
[102.046820] Starting dynamic subtest: vecs0
[104.190163] Dynamic subtest vecs0: SUCCESS (2.151s)
[104.198532] Starting dynamic subtest: vecs1
[106.343203] Dynamic subtest vecs1: SUCCESS (2.153s)
[106.351560] Starting dynamic subtest: ccs0
[108.495449] Dynamic subtest ccs0: SUCCESS (2.152s)
[108.496323] Subtest engines: SUCCESS (15.072s)
[108.650788] [010/131] (909s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[108.721121] Starting subtest: multi-wait-available-unsubmitted-signaled
[108.721979] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[108.897244] [011/131] (908s left) kms_cursor_crc (cursor-random-128x128)
[109.262392] Starting subtest: cursor-random-128x128
[109.266333] Starting dynamic subtest: pipe-A-DP-3
[113.740466] Dynamic subtest pipe-A-DP-3: SUCCESS (4.473s)
[113.791364] Starting dynamic subtest: pipe-D-DP-3
[118.125386] Dynamic subtest pipe-D-DP-3: SUCCESS (4.341s)
[118.126251] Subtest cursor-random-128x128: SUCCESS (8.862s)
[118.596304] [012/131] (899s left) kms_flip (dpms-off-confusion)
[118.779651] Starting subtest: dpms-off-confusion
[118.783931] Starting dynamic subtest: A-DP3
[126.633797] Dynamic subtest A-DP3: SUCCESS (7.850s)
[126.645921] Starting dynamic subtest: B-DP3
[134.428460] Dynamic subtest B-DP3: SUCCESS (7.794s)
[134.437687] Starting dynamic subtest: C-DP3
[142.203440] Dynamic subtest C-DP3: SUCCESS (7.774s)
[142.213118] Starting dynamic subtest: D-DP3
[149.971621] Dynamic subtest D-DP3: SUCCESS (7.766s)
[149.978717] Subtest dpms-off-confusion: SUCCESS (31.198s)
[150.316573] [013/131] (867s left) kms_frontbuffer_tracking (fbc-1p-rte)
[150.511702] Starting subtest: fbc-1p-rte
[153.994417] Subtest fbc-1p-rte: SUCCESS (3.485s)
[154.273639] [014/131] (863s left) sw_sync (sync_expired_merge)
[154.316423] Starting subtest: sync_expired_merge
[155.390524] Subtest sync_expired_merge: SUCCESS (1.074s)
[155.488597] [015/131] (862s left) gem_mmap_wc (write-gtt-read-wc)
[155.559155] Subtest write-gtt-read-wc: SKIP (0.000s)
[155.631629] [016/131] (862s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[155.819268] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[155.865442] [017/131] (862s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[158.463275] Starting subtest: verify-pxp-execution-after-suspend-resume
[158.465242] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[158.601115] [018/131] (859s left) gem_exec_schedule (submit-golden-slice)
[158.681781] Starting subtest: submit-golden-slice
[158.682692] Starting dynamic subtest: rcs0
[158.765655] Dynamic subtest rcs0: SUCCESS (0.083s)
[158.773992] Starting dynamic subtest: bcs0
[158.816337] Dynamic subtest bcs0: SUCCESS (0.050s)
[158.824640] Starting dynamic subtest: vcs0
[158.870531] Dynamic subtest vcs0: SUCCESS (0.054s)
[158.878997] Starting dynamic subtest: vcs1
[158.919795] Dynamic subtest vcs1: SUCCESS (0.048s)
[158.928191] Starting dynamic subtest: vecs0
[158.974180] Dynamic subtest vecs0: SUCCESS (0.054s)
[158.982561] Starting dynamic subtest: vecs1
[159.027205] Dynamic subtest vecs1: SUCCESS (0.052s)
[159.035514] Starting dynamic subtest: ccs0
[159.082509] Dynamic subtest ccs0: SUCCESS (0.055s)
[159.083519] Subtest submit-golden-slice: SUCCESS (0.401s)
[159.552547] [019/131] (858s left) kms_psr (fbc-pr-primary-blt)
[159.737500] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[159.781535] [020/131] (858s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[159.967511] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[159.968424] Starting dynamic subtest: pipe-A-DP-3
[159.976987] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[159.985370] Starting dynamic subtest: pipe-B-DP-3
[159.993900] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[160.002116] Starting dynamic subtest: pipe-C-DP-3
[160.010403] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[160.018404] Starting dynamic subtest: pipe-D-DP-3
[160.028526] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[160.030531] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[160.452742] [021/131] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[160.639037] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[160.640866] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[160.863306] [022/131] (857s left) gem_exec_fence (submit)
[161.064603] Starting subtest: submit
[161.066909] Subtest submit: SKIP (0.000s)
[161.876451] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[161.878507] [023/131] (856s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[161.955164] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[161.956118] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[162.158716] [024/131] (856s left) core_getversion (basic)
[162.219069] Starting subtest: basic
[162.221161] Subtest basic: SUCCESS (0.000s)
[162.362862] [025/131] (856s left) kms_draw_crc (draw-method-blt)
[162.557053] Starting subtest: draw-method-blt
[162.557957] Starting dynamic subtest: xrgb8888-untiled
[162.895550] Dynamic subtest xrgb8888-untiled: SUCCESS (0.337s)
[162.932442] Starting dynamic subtest: rgb565-untiled
[163.228737] Dynamic subtest rgb565-untiled: SUCCESS (0.331s)
[163.263067] Starting dynamic subtest: xrgb2101010-untiled
[163.528868] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[163.564070] Starting dynamic subtest: xbgr16161616f-untiled
[163.865201] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.334s)
[163.881725] Starting dynamic subtest: xrgb8888-xtiled
[164.012119] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[164.046520] Starting dynamic subtest: rgb565-xtiled
[164.178997] Dynamic subtest rgb565-xtiled: SUCCESS (0.164s)
[164.215695] Starting dynamic subtest: xrgb2101010-xtiled
[164.329124] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.147s)
[164.363651] Starting dynamic subtest: xbgr16161616f-xtiled
[164.479078] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.147s)
[164.512851] Starting dynamic subtest: xrgb8888-4tiled
[164.645373] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.164s)
[164.683081] Starting dynamic subtest: rgb565-4tiled
[164.827816] Dynamic subtest rgb565-4tiled: SUCCESS (0.181s)
[164.840918] Starting dynamic subtest: xrgb2101010-4tiled
[164.962373] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[164.996903] Starting dynamic subtest: xbgr16161616f-4tiled
[165.112388] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.147s)
[165.114312] Subtest draw-method-blt: SUCCESS (2.556s)
[165.327334] [026/131] (853s left) drm_mm (drm_mm)
[165.376145] Starting subtest: drm_mm
[165.383054] Starting dynamic subtest: drm_test_mm_init
[165.458068] Dynamic subtest drm_test_mm_init: SUCCESS (0.072s)
[165.488024] Starting dynamic subtest: drm_test_mm_debug
[165.539490] Dynamic subtest drm_test_mm_debug: SUCCESS (0.081s)
[165.573428] Starting dynamic subtest: drm_test_mm_align32
[165.632849] Dynamic subtest drm_test_mm_align32: SUCCESS (0.090s)
[165.668576] Starting dynamic subtest: drm_test_mm_align64
[165.728151] Dynamic subtest drm_test_mm_align64: SUCCESS (0.092s)
[165.738540] Starting dynamic subtest: drm_test_mm_lowest
[165.812130] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.083s)
[165.852264] Starting dynamic subtest: drm_test_mm_highest
[165.894949] Dynamic subtest drm_test_mm_highest: SUCCESS (0.080s)
[165.896693] Subtest drm_mm: SUCCESS (0.520s)
[166.127556] [027/131] (852s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[166.318313] Starting subtest: basic-flip-after-cursor-atomic
[167.371129] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.053s)
[167.705378] [028/131] (851s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[167.907905] Starting subtest: y-tiled-8bpp-rotate-0
[167.909575] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[168.105387] [029/131] (850s left) i915_getparams_basic (basic-eu-total)
[168.180348] Starting subtest: basic-eu-total
[168.182074] Subtest basic-eu-total: SUCCESS (0.000s)
[168.343342] [030/131] (850s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[168.426421] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[168.531752] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[168.669798] [031/131] (850s left) gem_mmap_wc (invalid-flags)
[168.749023] Subtest invalid-flags: SKIP (0.000s)
[168.813285] [032/131] (850s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[169.007893] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[171.277800] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (2.270s)
[171.484099] [033/131] (847s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[171.683937] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[171.685506] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[171.870798] [034/131] (847s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[172.071464] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[172.073336] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[172.214699] [035/131] (847s left) gem_exec_params (secure-non-master)
[172.306902] Starting subtest: secure-non-master
[172.308682] Subtest secure-non-master: SKIP (0.000s)
[172.440407] [036/131] (846s left) gem_ctx_persistence (idempotent)
[172.527223] Starting subtest: idempotent
[172.528151] Subtest idempotent: SUCCESS (0.000s)
[172.659963] [037/131] (846s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[172.859641] Starting subtest: x-tiled-64bpp-rotate-0
[174.757085] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.896s)
[174.985821] [038/131] (844s left) i915_suspend (debugfs-reader)
[175.080135] Starting subtest: debugfs-reader
[196.390190] Subtest debugfs-reader: SUCCESS (5.762s)
[196.671444] [039/131] (823s left) gem_exec_balancer (bonded-pair)
[196.769713] Starting subtest: bonded-pair
[196.771821] Subtest bonded-pair: SKIP (0.000s)
[197.197286] [040/131] (822s left) kms_psr (fbc-psr-primary-mmap-gtt)
[197.390163] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[197.457210] [041/131] (822s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[197.651034] Starting subtest: modeset-transition-nonblocking-fencing
[197.651907] Starting dynamic subtest: 1x-outputs
[200.226260] Dynamic subtest 1x-outputs: SUCCESS (2.575s)
[200.281280] Subtest modeset-transition-nonblocking-fencing: SUCCESS (2.630s)
[200.601343] [042/131] (819s left) perf_pmu (busy-idle-check-all)
[200.670743] Starting subtest: busy-idle-check-all
[200.671648] Starting dynamic subtest: rcs0
[201.359255] Dynamic subtest rcs0: SUCCESS (0.688s)
[201.374047] Starting dynamic subtest: bcs0
[202.016431] Dynamic subtest bcs0: SUCCESS (0.655s)
[202.035703] Starting dynamic subtest: vcs0
[202.712779] Dynamic subtest vcs0: FAIL (0.669s)
[202.723804] Starting dynamic subtest: vcs1
[203.365581] Dynamic subtest vcs1: FAIL (0.649s)
[203.378862] Starting dynamic subtest: vecs0
[204.021568] Dynamic subtest vecs0: FAIL (0.654s)
[204.034062] Starting dynamic subtest: vecs1
[204.676629] Dynamic subtest vecs1: FAIL (0.651s)
[204.689965] Starting dynamic subtest: ccs0
[205.328886] Dynamic subtest ccs0: FAIL (0.651s)
[205.329853] Subtest busy-idle-check-all: FAIL (4.631s)
[205.517143] [043/131] (814s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[205.711209] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[205.712010] Starting dynamic subtest: pipe-A
[206.282965] Dynamic subtest pipe-A: SUCCESS (0.571s)
[206.299780] Starting dynamic subtest: pipe-B
[206.933048] Dynamic subtest pipe-B: SUCCESS (0.649s)
[206.956261] Starting dynamic subtest: pipe-C
[207.614908] Dynamic subtest pipe-C: SUCCESS (0.680s)
[207.645714] Starting dynamic subtest: pipe-D
[208.296718] Dynamic subtest pipe-D: SUCCESS (0.680s)
[208.297794] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (2.586s)
[208.663642] [044/131] (811s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[208.850146] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[208.852496] Starting dynamic subtest: pipe-A-DP-3
[209.432589] Dynamic subtest pipe-A-DP-3: SUCCESS (0.578s)
[209.444217] Starting dynamic subtest: pipe-B-DP-3
[210.114546] Dynamic subtest pipe-B-DP-3: SUCCESS (0.680s)
[210.126143] Starting dynamic subtest: pipe-C-DP-3
[210.796479] Dynamic subtest pipe-C-DP-3: SUCCESS (0.680s)
[210.807782] Starting dynamic subtest: pipe-D-DP-3
[211.477808] Dynamic subtest pipe-D-DP-3: SUCCESS (0.680s)
[211.479031] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SUCCESS (2.624s)
[211.794695] [045/131] (808s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[211.985338] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[211.986199] Starting dynamic subtest: pipe-A
[212.089739] Dynamic subtest pipe-A: SUCCESS (0.104s)
[212.103394] Starting dynamic subtest: pipe-B
[212.289817] Dynamic subtest pipe-B: SUCCESS (0.199s)
[212.309989] Starting dynamic subtest: pipe-C
[212.504826] Dynamic subtest pipe-C: SUCCESS (0.214s)
[212.525564] Starting dynamic subtest: pipe-D
[212.719800] Dynamic subtest pipe-D: SUCCESS (0.214s)
[212.720783] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.735s)
[213.083258] [046/131] (807s left) gem_softpin (allocator-basic)
[213.165929] Starting subtest: allocator-basic
[213.393029] Subtest allocator-basic: SUCCESS (0.227s)
[213.565769] [047/131] (806s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[213.764823] Starting subtest: fbc-modesetfrombusy
[215.013706] Subtest fbc-modesetfrombusy: SUCCESS (1.250s)
[215.233067] [048/131] (805s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[215.316116] Starting subtest: rel-constants-invalid-rel-gen5
[215.317080] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[215.515251] [049/131] (805s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[215.590804] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[215.659546] [050/131] (804s left) api_intel_allocator (open-vm)
[215.741907] Starting subtest: open-vm
[215.769175] Subtest open-vm: SUCCESS (0.027s)
[215.983952] [051/131] (804s left) kms_force_connector_basic (force-load-detect)
[216.087957] Starting subtest: force-load-detect
[216.089702] Subtest force-load-detect: SKIP (0.000s)
[216.335146] [052/131] (804s left) gem_userptr_blits (unsync-unmap)
[216.423537] Subtest unsync-unmap: SKIP (0.000s)
[216.634453] [053/131] (804s left) kms_scaling_modes (scaling-mode-full)
[216.824964] Starting subtest: scaling-mode-full
[216.829967] Subtest scaling-mode-full: SKIP (0.001s)
[216.984493] [054/131] (803s left) kms_addfb_basic (addfb25-modifier-no-flag)
[217.177624] Starting subtest: addfb25-modifier-no-flag
[217.178570] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[217.366617] [055/131] (803s left) kms_content_protection (atomic)
[217.626135] Starting subtest: atomic
[217.648171] Starting dynamic subtest: pipe-A-DP-3
[339.352264] Dynamic subtest pipe-A-DP-3: FAIL (121.529s)
[339.353369] Subtest atomic: FAIL (121.648s)
[339.604804] [056/131] (681s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[339.806111] Starting subtest: x-tiled-8bpp-rotate-270
[339.868782] Subtest x-tiled-8bpp-rotate-270: SKIP (0.061s)
[340.086990] [057/131] (681s left) kms_setmode (basic)
[340.163074] Starting subtest: basic
[340.303821] Starting dynamic subtest: pipe-A-DP-3
[342.471588] Dynamic subtest pipe-A-DP-3: SUCCESS (2.165s)
[342.604579] Starting dynamic subtest: pipe-B-DP-3
[344.754477] Dynamic subtest pipe-B-DP-3: SUCCESS (2.158s)
[344.829271] Subtest basic: SUCCESS (4.665s)
[345.097363] [058/131] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[345.293537] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[345.295178] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[345.504774] [059/131] (675s left) sysfs_preempt_timeout (timeout)
[345.608467] Starting subtest: timeout
[345.609382] Starting dynamic subtest: vecs0
[347.499981] Dynamic subtest vecs0: SUCCESS (1.890s)
[347.513523] Starting dynamic subtest: ccs0
[349.291717] Dynamic subtest ccs0: SUCCESS (1.791s)
[349.304220] Starting dynamic subtest: vcs0
[350.959911] Dynamic subtest vcs0: SUCCESS (1.667s)
[350.972327] Starting dynamic subtest: bcs0
[352.641661] Dynamic subtest bcs0: SUCCESS (1.681s)
[352.653986] Starting dynamic subtest: vecs1
[354.299977] Dynamic subtest vecs1: SUCCESS (1.657s)
[354.312187] Starting dynamic subtest: rcs0
[355.988955] Dynamic subtest rcs0: SUCCESS (1.688s)
[356.001084] Starting dynamic subtest: vcs1
[357.628819] Dynamic subtest vcs1: SUCCESS (1.639s)
[357.629743] Subtest timeout: SUCCESS (12.020s)
[357.779390] [060/131] (663s left) gen7_exec_parse (basic-allocation)
[357.863813] Subtest basic-allocation: SKIP (0.000s)
[357.939454] [061/131] (663s left) api_intel_bb (add-remove-objects)
[358.019158] Starting subtest: add-remove-objects
[358.050547] Subtest add-remove-objects: SUCCESS (0.032s)
[358.259099] [062/131] (663s left) gem_exec_balancer (nohangcheck)
[358.607179] Starting subtest: nohangcheck
[360.131589] Subtest nohangcheck: SUCCESS (1.524s)
[360.306698] [063/131] (661s left) kms_plane_multiple (2x-tiling-4)
[360.492442] Starting subtest: 2x-tiling-4
[360.494143] Subtest 2x-tiling-4: SKIP (0.000s)
[360.666296] [064/131] (660s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[360.936468] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[361.089140] [065/131] (660s left) kms_chamelium_edid (dp-edid-resolution-list)
[361.358909] Subtest dp-edid-resolution-list: SKIP (0.000s)
[361.514054] [066/131] (660s left) kms_rmfb (rmfb-ioctl)
[361.707983] Starting subtest: rmfb-ioctl
[361.708875] Starting dynamic subtest: pipe-A-DP-3
[361.854501] Dynamic subtest pipe-A-DP-3: SUCCESS (0.146s)
[361.877809] Starting dynamic subtest: pipe-B-DP-3
[362.152217] Dynamic subtest pipe-B-DP-3: SUCCESS (0.295s)
[362.165774] Starting dynamic subtest: pipe-C-DP-3
[362.435327] Dynamic subtest pipe-C-DP-3: SUCCESS (0.281s)
[362.449100] Starting dynamic subtest: pipe-D-DP-3
[362.718137] Dynamic subtest pipe-D-DP-3: SUCCESS (0.281s)
[362.719054] Subtest rmfb-ioctl: SUCCESS (1.012s)
[363.049458] [067/131] (658s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[363.245010] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[363.246678] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[363.459328] [068/131] (658s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[363.671968] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[363.673542] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[363.838746] [069/131] (658s left) gem_eio (in-flight-immediate)
[364.121050] Starting subtest: in-flight-immediate
[368.972571] Subtest in-flight-immediate: SUCCESS (4.852s)
[369.257843] [070/131] (652s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[369.449063] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[369.449939] Starting dynamic subtest: pipe-A-valid-mode
[369.527783] Dynamic subtest pipe-A-valid-mode: SKIP (0.078s)
[369.529685] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.079s)
[369.769291] [071/131] (652s left) kms_getfb (getfb-handle-valid)
[369.957633] Starting subtest: getfb-handle-valid
[369.958602] Subtest getfb-handle-valid: SUCCESS (0.000s)
[370.138888] [072/131] (652s left) gem_partial_pwrite_pread (write)
[370.228864] Subtest write: SKIP (0.000s)
[370.348329] [073/131] (652s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[370.542449] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[370.544870] Starting dynamic subtest: pipe-A-DP-3
[370.553464] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[370.566039] Starting dynamic subtest: pipe-B-DP-3
[370.574436] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[370.586869] Starting dynamic subtest: pipe-C-DP-3
[370.595223] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[370.607841] Starting dynamic subtest: pipe-D-DP-3
[370.618124] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[370.620190] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[371.019110] [074/131] (651s left) gem_sync (basic-many-each)
[371.109812] Starting subtest: basic-many-each
[373.613867] Subtest basic-many-each: SUCCESS (2.504s)
[373.913794] [075/131] (648s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[374.114030] Starting subtest: psr-rgb101010-draw-render
[374.115717] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[374.298604] [076/131] (648s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[374.649034] Starting subtest: cursor-rapid-movement-64x21
[374.654129] Starting dynamic subtest: pipe-A-DP-3
[375.093903] Dynamic subtest pipe-A-DP-3: SUCCESS (0.439s)
[375.143024] Starting dynamic subtest: pipe-D-DP-3
[375.520125] Dynamic subtest pipe-D-DP-3: SUCCESS (0.390s)
[375.521104] Subtest cursor-rapid-movement-64x21: SUCCESS (0.872s)
[376.042010] [077/131] (646s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[376.234976] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[376.236768] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[376.453002] [078/131] (646s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[376.641055] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[376.641932] Starting dynamic subtest: pipe-A-DP-3
[376.663788] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[376.676520] Starting dynamic subtest: pipe-B-DP-3
[376.698204] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[376.710715] Starting dynamic subtest: pipe-C-DP-3
[376.734783] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[376.747255] Starting dynamic subtest: pipe-D-DP-3
[376.770191] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[376.772189] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.014s)
[377.104220] [079/131] (645s left) kms_busy (extended-pageflip-hang-newfb)
[377.303520] Starting subtest: extended-pageflip-hang-newfb
[377.304389] Starting dynamic subtest: pipe-A
[385.195214] Dynamic subtest pipe-A: SUCCESS (7.890s)
[385.223300] Starting dynamic subtest: pipe-D
[393.086271] Dynamic subtest pipe-D: SUCCESS (7.885s)
[393.087144] Subtest extended-pageflip-hang-newfb: SUCCESS (15.785s)
[393.383112] [080/131] (629s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[393.585070] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[394.847794] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.262s)
[395.101764] [081/131] (627s left) gem_exec_store (pages)
[395.192039] Starting subtest: pages
[395.193009] Starting dynamic subtest: rcs0
[395.347191] Dynamic subtest rcs0: SUCCESS (0.155s)
[395.360317] Starting dynamic subtest: bcs0
[395.451334] Dynamic subtest bcs0: SUCCESS (0.103s)
[395.465131] Starting dynamic subtest: vcs0
[395.557201] Dynamic subtest vcs0: SUCCESS (0.105s)
[395.570210] Starting dynamic subtest: vcs1
[395.659298] Dynamic subtest vcs1: SUCCESS (0.101s)
[395.672418] Starting dynamic subtest: vecs0
[395.761216] Dynamic subtest vecs0: SUCCESS (0.101s)
[395.774425] Starting dynamic subtest: vecs1
[395.868179] Dynamic subtest vecs1: SUCCESS (0.106s)
[395.881506] Starting dynamic subtest: ccs0
[395.974098] Dynamic subtest ccs0: SUCCESS (0.105s)
[395.975176] Subtest pages: SUCCESS (0.783s)
[396.248927] [082/131] (626s left) gem_render_copy (yf-tiled-ccs-to-linear)
[396.328238] Starting subtest: yf-tiled-ccs-to-linear
[396.330430] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[396.616682] [083/131] (626s left) syncobj_timeline (single-wait-for-submit-signaled)
[396.696028] Starting subtest: single-wait-for-submit-signaled
[396.696994] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[396.849027] [084/131] (626s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[397.043832] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[397.045532] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[397.227957] [085/131] (626s left) gem_render_copy (x-tiled)
[397.314085] Starting subtest: x-tiled
[397.315061] Starting dynamic subtest: smem
[397.421686] Dynamic subtest smem: SUCCESS (0.107s)
[397.434619] Starting dynamic subtest: lmem0
[399.039153] Dynamic subtest lmem0: SUCCESS (1.617s)
[399.040103] Subtest x-tiled: SUCCESS (1.725s)
[399.267254] [086/131] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[399.460916] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[399.462617] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[399.664178] [087/131] (623s left) kms_psr (psr2-cursor-plane-move)
[399.856391] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[399.926239] [088/131] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[400.119850] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[400.121616] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[400.316481] [089/131] (623s left) perf_pmu (most-busy-idle-check-all)
[400.387950] Starting subtest: most-busy-idle-check-all
[400.388925] Starting dynamic subtest: rcs0
[401.084242] Dynamic subtest rcs0: SUCCESS (0.695s)
[401.103642] Starting dynamic subtest: bcs0
[401.743157] Dynamic subtest bcs0: SUCCESS (0.656s)
[401.775179] Starting dynamic subtest: vcs0
[402.411234] Dynamic subtest vcs0: SUCCESS (0.664s)
[402.425609] Starting dynamic subtest: vcs1
[403.063100] Dynamic subtest vcs1: SUCCESS (0.651s)
[403.077817] Starting dynamic subtest: vecs0
[403.717062] Dynamic subtest vecs0: SUCCESS (0.653s)
[403.730291] Starting dynamic subtest: vecs1
[404.371180] Dynamic subtest vecs1: SUCCESS (0.653s)
[404.385866] Starting dynamic subtest: ccs0
[405.023298] Dynamic subtest ccs0: SUCCESS (0.651s)
[405.024170] Subtest most-busy-idle-check-all: SUCCESS (4.636s)
[405.213276] [090/131] (618s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[405.411832] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[405.413559] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[405.607123] [091/131] (618s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[405.805302] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[405.861109] [092/131] (617s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[406.050571] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[406.053035] Starting dynamic subtest: pipe-A-valid-mode
[407.923820] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.869s)
[407.925181] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SUCCESS (1.872s)
[408.210298] [093/131] (615s left) kms_getfb (getfb-handle-protection)
[408.418974] Starting subtest: getfb-handle-protection
[408.431840] Subtest getfb-handle-protection: SUCCESS (0.014s)
[408.643742] [094/131] (615s left) gem_ctx_shared (q-smoketest)
[408.737788] Starting subtest: Q-smoketest
[408.738781] Starting dynamic subtest: rcs0
[414.183035] Dynamic subtest rcs0: SUCCESS (5.439s)
[414.196249] Starting dynamic subtest: bcs0
[419.598565] Dynamic subtest bcs0: SUCCESS (5.415s)
[419.611757] Starting dynamic subtest: vcs0
[425.027620] Dynamic subtest vcs0: SUCCESS (5.427s)
[425.040714] Starting dynamic subtest: vcs1
[430.448041] Dynamic subtest vcs1: SUCCESS (5.419s)
[430.461218] Starting dynamic subtest: vecs0
[435.868053] Dynamic subtest vecs0: SUCCESS (5.419s)
[435.880904] Starting dynamic subtest: vecs1
[441.289520] Dynamic subtest vecs1: SUCCESS (5.419s)
[441.302882] Starting dynamic subtest: ccs0
[446.707952] Dynamic subtest ccs0: SUCCESS (5.418s)
[446.709238] Subtest Q-smoketest: SUCCESS (37.963s)
[447.034136] [095/131] (577s left) syncobj_wait (wait-delayed-signal)
[447.114110] Starting subtest: wait-delayed-signal
[447.217348] Subtest wait-delayed-signal: SUCCESS (0.102s)
[447.352223] [096/131] (576s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[447.556078] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[447.557816] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[447.739076] [097/131] (576s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[448.002440] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[448.157995] [098/131] (576s left) syncobj_wait (multi-wait-all-submitted)
[448.238094] Starting subtest: multi-wait-all-submitted
[448.342064] Subtest multi-wait-all-submitted: SUCCESS (0.104s)
[448.496427] [099/131] (575s left) kms_pm_rpm (universal-planes-dpms)
[450.540148] Starting subtest: universal-planes-dpms
[450.543850] Starting dynamic subtest: plane-33
[453.321058] Dynamic subtest plane-33: SUCCESS (2.779s)
[453.366191] Starting dynamic subtest: plane-43
[456.200827] Dynamic subtest plane-43: SUCCESS (2.876s)
[456.248970] Starting dynamic subtest: plane-53
[459.136690] Dynamic subtest plane-53: SUCCESS (2.930s)
[459.151417] Starting dynamic subtest: plane-63
[462.015584] Dynamic subtest plane-63: SUCCESS (2.875s)
[462.072935] Starting dynamic subtest: plane-73
[465.010857] Dynamic subtest plane-73: SUCCESS (2.991s)
[465.058490] Starting dynamic subtest: plane-83
[467.791432] Dynamic subtest plane-83: SUCCESS (2.774s)
[467.793282] Subtest universal-planes-dpms: SUCCESS (17.252s)
[468.242563] [100/131] (556s left) kms_dsc (dsc-with-output-formats)
[468.436193] Starting subtest: dsc-with-output-formats
[468.444544] Subtest dsc-with-output-formats: SKIP (0.001s)
[468.622394] [101/131] (555s left) gem_exec_fence (syncobj-timeline-chain-engines)
[469.285346] Starting subtest: syncobj-timeline-chain-engines
[469.440975] Subtest syncobj-timeline-chain-engines: SUCCESS (0.156s)
[469.824186] [102/131] (554s left) kms_pm_rpm (drm-resources-equal)
[471.567540] Starting subtest: drm-resources-equal
[473.026619] Subtest drm-resources-equal: SUCCESS (1.464s)
[473.254564] [103/131] (551s left) gem_exec_reloc (basic-gtt-read-noreloc)
[473.343146] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[473.448037] [104/131] (551s left) kms_hdr (static-toggle-suspend)
[473.639036] Starting subtest: static-toggle-suspend
[474.207386] Starting dynamic subtest: pipe-A-DP-3
[494.770602] Dynamic subtest pipe-A-DP-3: SUCCESS (5.091s)
[494.771526] Subtest static-toggle-suspend: SUCCESS (5.660s)
[495.087610] [105/131] (529s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[495.288754] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[495.304075] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.014s)
[495.476184] [106/131] (529s left) kms_lease (multimaster-lease)
[495.674504] Starting subtest: multimaster-lease
[495.695151] Subtest multimaster-lease: SUCCESS (0.021s)
[495.889255] [107/131] (529s left) i915_pm_rpm (system-suspend-devices)
[498.011631] Starting subtest: system-suspend-devices
[506.394599] Subtest system-suspend-devices: SUCCESS (8.383s)
[507.316144] [108/131] (517s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt)
[507.688022] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt
[507.689652] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[508.644387] [109/131] (516s left) gem_render_linear_blits (basic)
[508.735196] Starting subtest: basic
[508.819903] Subtest basic: SUCCESS (0.085s)
[508.931513] [110/131] (516s left) i915_drm_fdinfo (busy-idle)
[509.001427] Starting subtest: busy-idle
[509.002235] Starting dynamic subtest: rcs0
[509.025033] Dynamic subtest rcs0: SKIP (0.022s)
[509.039408] Starting dynamic subtest: bcs0
[509.041234] Dynamic subtest bcs0: SKIP (0.000s)
[509.055172] Starting dynamic subtest: vcs0
[509.057324] Dynamic subtest vcs0: SKIP (0.000s)
[509.070881] Starting dynamic subtest: vcs1
[509.073157] Dynamic subtest vcs1: SKIP (0.000s)
[509.086622] Starting dynamic subtest: vecs0
[509.088828] Dynamic subtest vecs0: SKIP (0.000s)
[509.105192] Starting dynamic subtest: vecs1
[509.107598] Dynamic subtest vecs1: SKIP (0.000s)
[509.120983] Starting dynamic subtest: ccs0
[509.122986] Dynamic subtest ccs0: SKIP (0.000s)
[509.125347] Subtest busy-idle: SKIP (0.031s)
[509.173568] [111/131] (516s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[509.369025] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[509.370777] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[509.579795] [112/131] (515s left) gem_mmap (bad-offset)
[509.657870] Subtest bad-offset: SKIP (0.000s)
[509.723387] [113/131] (515s left) gem_exec_whisper (basic-contexts-priority-all)
[509.812605] Starting subtest: basic-contexts-priority-all
[532.253612] Subtest basic-contexts-priority-all: SUCCESS (22.438s)
[532.507475] [114/131] (493s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[532.595178] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[532.596128] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[532.746096] [115/131] (492s left) gem_mmap_gtt (medium-copy-xy)
[532.824968] Subtest medium-copy-XY: SKIP (0.000s)
[532.894367] [116/131] (492s left) kms_vrr (flipline)
[533.082387] Starting subtest: flipline
[533.085002] Subtest flipline: SKIP (0.000s)
[533.257089] [117/131] (492s left) kms_vblank (accuracy-idle)
[533.446091] Starting subtest: accuracy-idle
[533.446982] Starting dynamic subtest: pipe-A-DP-3
[535.765278] Dynamic subtest pipe-A-DP-3: SUCCESS (2.319s)
[535.795803] Starting dynamic subtest: pipe-D-DP-3
[538.054858] Dynamic subtest pipe-D-DP-3: SUCCESS (2.281s)
[538.055799] Subtest accuracy-idle: SUCCESS (4.610s)
[538.333700] [118/131] (487s left) gem_eio (in-flight-internal-10ms)
[538.640779] Starting subtest: in-flight-internal-10ms
[539.885838] Subtest in-flight-internal-10ms: SUCCESS (1.246s)
[540.180437] [119/131] (485s left) kms_addfb_basic (no-handle)
[540.260538] Starting subtest: no-handle
[540.261388] Subtest no-handle: SUCCESS (0.000s)
[540.583454] [120/131] (485s left) gem_mmap_offset (open-flood)
[540.659260] Starting subtest: open-flood
[562.143962] Subtest open-flood: SUCCESS (21.484s)
[562.330752] [121/131] (463s left) syncobj_timeline (invalid-signal-bad-pad)
[562.409936] Starting subtest: invalid-signal-bad-pad
[562.410788] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[562.588153] [122/131] (463s left) gem_spin_batch (legacy-resubmit-new)
[562.676045] Starting subtest: legacy-resubmit-new
[562.676983] Starting dynamic subtest: default
[562.710063] Dynamic subtest default: SUCCESS (0.033s)
[562.724465] Starting dynamic subtest: render
[562.725333] Dynamic subtest render: SUCCESS (0.004s)
[562.739385] Starting dynamic subtest: bsd
[562.740261] Dynamic subtest bsd: SUCCESS (0.004s)
[562.754477] Starting dynamic subtest: bsd1
[562.755379] Dynamic subtest bsd1: SUCCESS (0.004s)
[562.769199] Starting dynamic subtest: bsd2
[562.770485] Dynamic subtest bsd2: SUCCESS (0.005s)
[562.784335] Starting dynamic subtest: blt
[562.785637] Dynamic subtest blt: SUCCESS (0.006s)
[562.799166] Starting dynamic subtest: vebox
[562.800429] Dynamic subtest vebox: SUCCESS (0.004s)
[562.801560] Subtest legacy-resubmit-new: SUCCESS (0.067s)
[563.074577] [123/131] (463s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[563.262685] Starting subtest: compare-crc-sanitycheck-nv12
[563.264967] Starting dynamic subtest: pipe-A-DP-3
[563.925274] Dynamic subtest pipe-A-DP-3: SUCCESS (0.660s)
[563.945871] Starting dynamic subtest: pipe-B-DP-3
[564.501508] Dynamic subtest pipe-B-DP-3: SUCCESS (0.574s)
[564.516315] Starting dynamic subtest: pipe-C-DP-3
[565.037225] Dynamic subtest pipe-C-DP-3: SUCCESS (0.534s)
[565.051926] Starting dynamic subtest: pipe-D-DP-3
[565.576386] Dynamic subtest pipe-D-DP-3: SUCCESS (0.538s)
[565.577236] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.314s)
[565.876710] [124/131] (460s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[566.076805] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[567.927877] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.851s)
[568.197394] [125/131] (458s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[568.387613] Starting subtest: cursorB-vs-flipB-atomic
[568.390797] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[568.548651] [126/131] (458s left) prime_vgem (fence-wait)
[568.652192] Starting subtest: fence-wait
[568.653123] Starting dynamic subtest: rcs0
[569.728316] Dynamic subtest rcs0: SUCCESS (1.067s)
[569.743193] Starting dynamic subtest: bcs0
[570.771790] Dynamic subtest bcs0: SUCCESS (1.045s)
[570.786660] Starting dynamic subtest: vcs0
[571.817222] Dynamic subtest vcs0: SUCCESS (1.045s)
[571.831270] Starting dynamic subtest: vcs1
[572.862126] Dynamic subtest vcs1: SUCCESS (1.043s)
[572.879720] Starting dynamic subtest: vecs0
[573.905262] Dynamic subtest vecs0: SUCCESS (1.039s)
[573.923054] Starting dynamic subtest: vecs1
[574.947936] Dynamic subtest vecs1: SUCCESS (1.038s)
[574.965863] Starting dynamic subtest: ccs0
[575.991079] Dynamic subtest ccs0: SUCCESS (1.039s)
[575.992932] Subtest fence-wait: SUCCESS (7.339s)
[576.174443] [127/131] (450s left) gem_exec_params (invalid-bsd2-flag-on-render)
[576.256437] Starting subtest: invalid-bsd2-flag-on-render
[576.257353] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[576.402328] [128/131] (450s left) gem_blits (basic)
[576.510331] Starting subtest: basic
[582.637953] Subtest basic: SUCCESS (6.127s)
[582.848755] [129/131] (443s left) i915_pm_rpm (gem-execbuf-stress)
[585.063023] Starting subtest: gem-execbuf-stress
[585.065026] Starting dynamic subtest: lmem0
[588.742110] Dynamic subtest lmem0: SUCCESS (3.677s)
[588.795735] Starting dynamic subtest: extra-wait-lmem0
[642.315767] Dynamic subtest extra-wait-lmem0: SUCCESS (53.568s)
[642.333043] Starting dynamic subtest: smem0
[645.948921] Dynamic subtest smem0: SUCCESS (3.630s)
[646.001727] Starting dynamic subtest: extra-wait-smem0
[699.517893] Dynamic subtest extra-wait-smem0: SUCCESS (53.563s)
[699.519486] Subtest gem-execbuf-stress: SUCCESS (114.453s)
[699.910442] [130/131] (326s left) gem_fence_thrash (bo-write-verify-threaded-y)
[699.958660] Starting subtest: bo-write-verify-threaded-y
[699.992986] Subtest bo-write-verify-threaded-y: SKIP (0.033s)
[700.067120] [131/131] (326s left) gem_exec_params (rsvd2-dirt)
[700.150298] Starting subtest: rsvd2-dirt
[700.152049] Subtest rsvd2-dirt: SKIP (0.000s)
[700.345064] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_async_flips
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: gem_cs_tlb
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: sw_sync
results: parsing output: 14/ for test: gem_mmap_wc
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: core_getversion
results: parsing output: 24/ for test: kms_draw_crc
results: parsing output: 25/ for test: drm_mm
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: i915_getparams_basic
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: i915_suspend
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_atomic_transition
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: gem_softpin
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: api_intel_allocator
results: parsing output: 50/ for test: kms_force_connector_basic
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_scaling_modes
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_setmode
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: sysfs_preempt_timeout
results: parsing output: 59/ for test: gen7_exec_parse
results: parsing output: 60/ for test: api_intel_bb
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: kms_plane_multiple
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: kms_chamelium_edid
results: parsing output: 65/ for test: kms_rmfb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_getfb
results: parsing output: 71/ for test: gem_partial_pwrite_pread
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_sync
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_busy
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_exec_store
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_getfb
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_chamelium_frames
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_dsc
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_hdr
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_lease
results: parsing output: 106/ for test: i915_pm_rpm
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_render_linear_blits
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_mmap
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_vrr
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: kms_addfb_basic
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_spin_batch
results: parsing output: 122/ for test: kms_pipe_crc_basic
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: gem_blits
results: parsing output: 128/ for test: i915_pm_rpm
results: parsing output: 129/ for test: gem_fence_thrash
results: parsing output: 130/ for test: gem_exec_params
Done.