[62.783783] Initializing watchdogs
[62.783848]   /dev/watchdog0
[62.803553] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.814035] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.817653] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.820005] [001/134] (960s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[63.002245] Starting subtest: addfb25-y-tiled-legacy
[63.003134] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[63.169450] [002/134] (960s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[63.359158] Starting subtest: 4-tiled-16bpp-rotate-0
[65.184620] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.825s)
[65.384361] [003/134] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[65.562434] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[68.418279] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.855s)
[68.661469] [004/134] (954s left) kms_plane_cursor (viewport)
[68.843736] Starting subtest: viewport
[68.845427] Starting dynamic subtest: pipe-A-DP-3-size-64
[72.050697] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.206s)
[72.128376] Starting dynamic subtest: pipe-A-DP-3-size-128
[75.351598] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.233s)
[75.432178] Starting dynamic subtest: pipe-A-DP-3-size-256
[78.667412] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.250s)
[78.839166] Starting dynamic subtest: pipe-B-DP-3-size-64
[82.098729] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.268s)
[82.162034] Starting dynamic subtest: pipe-B-DP-3-size-128
[85.382347] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.234s)
[85.445996] Starting dynamic subtest: pipe-B-DP-3-size-256
[88.632364] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.200s)
[88.768985] Starting dynamic subtest: pipe-C-DP-3-size-64
[92.043282] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.283s)
[92.110485] Starting dynamic subtest: pipe-C-DP-3-size-128
[95.292440] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.200s)
[95.357082] Starting dynamic subtest: pipe-C-DP-3-size-256
[98.576857] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.234s)
[98.712295] Starting dynamic subtest: pipe-D-DP-3-size-64
[101.985138] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.282s)
[102.049129] Starting dynamic subtest: pipe-D-DP-3-size-128
[105.267690] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.233s)
[105.335541] Starting dynamic subtest: pipe-D-DP-3-size-256
[108.518661] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.199s)
[108.643352] Subtest viewport: SUCCESS (39.799s)
[108.921774] [005/134] (914s left) kms_atomic_interruptible (legacy-cursor)
[109.112379] Starting subtest: legacy-cursor
[109.114396] Starting dynamic subtest: pipe-A-DP-3
[115.410528] Dynamic subtest pipe-A-DP-3: SUCCESS (6.297s)
[115.411410] Subtest legacy-cursor: SUCCESS (6.298s)
[115.648103] [006/134] (908s left) gem_exec_balancer (smoke)
[115.734243] Starting subtest: smoke
[139.004198] Subtest smoke: SUCCESS (23.270s)
[140.055694] [007/134] (883s left) gem_exec_params (no-bsd)
[140.135301] Starting subtest: no-bsd
[140.137272] Subtest no-bsd: SUCCESS (0.001s)
[140.332107] [008/134] (883s left) gem_ctx_persistence (legacy-engines-hostile)
[140.417059] Starting subtest: legacy-engines-hostile
[140.418166] Starting dynamic subtest: render
[140.527456] Dynamic subtest render: SUCCESS (0.111s)
[140.537032] Starting dynamic subtest: bsd1
[140.619119] Dynamic subtest bsd1: SUCCESS (0.090s)
[140.656848] Starting dynamic subtest: bsd2
[140.672554] Dynamic subtest bsd2: SUCCESS (0.051s)
[140.693496] Starting dynamic subtest: blt
[140.736733] Dynamic subtest blt: SUCCESS (0.062s)
[140.770645] Starting dynamic subtest: vebox
[140.781365] Dynamic subtest vebox: SUCCESS (0.043s)
[140.782626] Subtest legacy-engines-hostile: SUCCESS (0.366s)
[140.983649] [009/134] (882s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[141.169843] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[141.209996] [010/134] (882s left) kms_pm_rpm (modeset-non-lpsp-stress)
[143.118035] Starting subtest: modeset-non-lpsp-stress
[148.986572] Subtest modeset-non-lpsp-stress: SUCCESS (5.868s)
[149.224143] [011/134] (874s left) i915_pm_rpm (system-suspend)
[151.030937] Starting subtest: system-suspend
[170.531585] Subtest system-suspend: SUCCESS (4.776s)
[170.945191] [012/134] (853s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[171.128218] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[173.924163] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.796s)
[174.148259] [013/134] (849s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[174.325530] Starting subtest: bad-aux-stride-yf-tiled-ccs
[174.326422] Starting dynamic subtest: pipe-A-DP-3
[174.334592] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[174.344940] Starting dynamic subtest: pipe-B-DP-3
[174.353295] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[174.363856] Starting dynamic subtest: pipe-C-DP-3
[174.371956] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[174.382348] Starting dynamic subtest: pipe-D-DP-3
[174.392615] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[174.394629] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[174.815846] [014/134] (849s left) gem_exec_fence (submit3)
[175.009897] Starting subtest: submit3
[175.012175] Subtest submit3: SKIP (0.000s)
[175.779579] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[175.781409] [015/134] (848s left) core_getstats (basic)
[175.854428] Starting subtest: basic
[175.855322] Subtest basic: SUCCESS (0.000s)
[175.992340] [016/134] (848s left) kms_psr (psr2-cursor-plane-move)
[176.176807] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[176.244021] [017/134] (848s left) i915_hangman (engine-error-state-capture)
[176.345424] Starting subtest: engine-error-state-capture
[176.346351] Starting dynamic subtest: rcs0
[178.307964] Dynamic subtest rcs0: SUCCESS (1.962s)
[178.321389] Starting dynamic subtest: bcs0
[182.285975] Dynamic subtest bcs0: SUCCESS (3.977s)
[182.296876] Starting dynamic subtest: vcs0
[186.244615] Dynamic subtest vcs0: SUCCESS (3.958s)
[186.255406] Starting dynamic subtest: vcs1
[190.286670] Dynamic subtest vcs1: SUCCESS (4.041s)
[190.297562] Starting dynamic subtest: vecs0
[194.251680] Dynamic subtest vecs0: SUCCESS (3.964s)
[194.262815] Starting dynamic subtest: vecs1
[198.324986] Dynamic subtest vecs1: SUCCESS (4.072s)
[198.338643] Starting dynamic subtest: ccs0
[202.273537] Dynamic subtest ccs0: SUCCESS (3.947s)
[202.274492] Subtest engine-error-state-capture: SUCCESS (25.928s)
[202.453923] [018/134] (821s left) kms_flip (2x-flip-vs-wf_vblank)
[202.637974] Starting subtest: 2x-flip-vs-wf_vblank
[202.652860] Subtest 2x-flip-vs-wf_vblank: SKIP (0.014s)
[202.830143] [019/134] (821s left) gem_userptr_blits (unsync-unmap-after-close)
[202.915827] Subtest unsync-unmap-after-close: SKIP (0.000s)
[203.072108] [020/134] (821s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[203.262919] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[203.264590] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[203.452837] [021/134] (821s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[203.528604] Starting subtest: invalid-single-wait-all-unsubmitted
[203.529542] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[203.686663] [022/134] (821s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[203.869775] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[203.870578] Starting dynamic subtest: pipe-A
[204.251857] Dynamic subtest pipe-A: SUCCESS (0.382s)
[204.275368] Starting dynamic subtest: pipe-B
[204.730959] Dynamic subtest pipe-B: SUCCESS (0.478s)
[204.758590] Starting dynamic subtest: pipe-C
[205.210962] Dynamic subtest pipe-C: SUCCESS (0.478s)
[205.237928] Starting dynamic subtest: pipe-D
[205.689800] Dynamic subtest pipe-D: SUCCESS (0.477s)
[205.690879] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.820s)
[206.017333] [023/134] (818s left) gem_eio (execbuf)
[206.280612] Starting subtest: execbuf
[206.707971] Subtest execbuf: SUCCESS (0.427s)
[206.958943] [024/134] (817s left) gem_partial_pwrite_pread (writes-after-reads)
[207.040063] Subtest writes-after-reads: SKIP (0.000s)
[207.136937] [025/134] (817s left) sysfs_heartbeat_interval (mixed)
[207.225425] Starting subtest: mixed
[207.226361] Starting dynamic subtest: vecs0
[212.477022] Dynamic subtest vecs0: SUCCESS (5.249s)
[212.490966] Starting dynamic subtest: ccs0
[217.688716] Dynamic subtest ccs0: SUCCESS (5.209s)
[217.702722] Starting dynamic subtest: vcs0
[222.928819] Dynamic subtest vcs0: SUCCESS (5.237s)
[222.948880] Starting dynamic subtest: bcs0
[228.137056] Dynamic subtest bcs0: SUCCESS (5.205s)
[228.149680] Starting dynamic subtest: vecs1
[233.381804] Dynamic subtest vecs1: SUCCESS (5.243s)
[233.396534] Starting dynamic subtest: rcs0
[238.617629] Dynamic subtest rcs0: SUCCESS (5.232s)
[238.632059] Starting dynamic subtest: vcs1
[243.843514] Dynamic subtest vcs1: SUCCESS (5.224s)
[243.845347] Subtest mixed: SUCCESS (36.617s)
[244.039837] [026/134] (780s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[244.232894] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[244.234560] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[244.439284] [027/134] (780s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[244.529753] Subtest writes-after-reads-snoop: SKIP (0.000s)
[244.669646] [028/134] (780s left) i915_suspend (debugfs-reader)
[244.760513] Starting subtest: debugfs-reader
[266.210962] Subtest debugfs-reader: SUCCESS (5.624s)
[266.456742] [029/134] (758s left) kms_cursor_edge_walk (256x256-left-edge)
[266.639940] Starting subtest: 256x256-left-edge
[266.642195] Starting dynamic subtest: pipe-A-DP-3
[270.107676] Dynamic subtest pipe-A-DP-3: SUCCESS (3.466s)
[270.125917] Starting dynamic subtest: pipe-D-DP-3
[273.464723] Dynamic subtest pipe-D-DP-3: SUCCESS (3.353s)
[273.466215] Subtest 256x256-left-edge: SUCCESS (6.824s)
[273.743043] [030/134] (751s left) gem_exec_parallel (engines)
[273.831786] Starting subtest: engines
[273.832673] Starting dynamic subtest: basic
[275.679890] Dynamic subtest basic: SUCCESS (1.848s)
[275.692397] Starting dynamic subtest: contexts
[280.220109] Dynamic subtest contexts: SUCCESS (4.539s)
[280.233573] Starting dynamic subtest: fds
[284.856799] Dynamic subtest fds: SUCCESS (4.636s)
[284.872564] Starting dynamic subtest: userptr
[286.357784] Dynamic subtest userptr: SUCCESS (1.500s)
[286.358777] Subtest engines: SUCCESS (12.526s)
[286.689903] [031/134] (738s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[286.877019] Starting subtest: 2x-long-flip-vs-cursor-atomic
[286.879979] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[287.049609] [032/134] (738s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[287.127296] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[287.128212] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[287.306913] [033/134] (738s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[287.510140] Starting subtest: fbcpsr-rgb101010-draw-blt
[287.511827] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[287.708531] [034/134] (738s left) gem_exec_whisper (basic-forked-all)
[287.797491] Starting subtest: basic-forked-all
[290.455036] Subtest basic-forked-all: SUCCESS (2.656s)
[290.724768] [035/134] (735s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[290.912969] Starting subtest: fbcpsr-tiling-4
[290.914718] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[291.057947] [036/134] (734s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[291.251929] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[291.253534] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[291.462032] [037/134] (734s left) syncobj_eventfd (invalid-bad-pad)
[291.539181] Starting subtest: invalid-bad-pad
[291.540160] Subtest invalid-bad-pad: SUCCESS (0.000s)
[291.741620] [038/134] (734s left) kms_dsc (dsc-with-formats)
[291.933487] Starting subtest: dsc-with-formats
[291.949122] Subtest dsc-with-formats: SKIP (0.002s)
[292.060825] [039/134] (734s left) kms_joiner (basic-force-ultra-joiner)
[292.249873] Starting subtest: basic-force-ultra-joiner
[292.251451] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[292.417738] [040/134] (733s left) gem_exec_reloc (basic-range)
[292.498481] Subtest basic-range: SKIP (0.000s)
[292.572313] [041/134] (733s left) gem_bad_reloc (negative-reloc-bltcopy)
[292.654418] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[292.724076] [042/134] (733s left) api_intel_bb (blit-noreloc-keep-cache)
[292.807406] Starting subtest: blit-noreloc-keep-cache
[292.842604] Subtest blit-noreloc-keep-cache: SUCCESS (0.036s)
[293.074415] [043/134] (733s left) gem_spin_batch (legacy-resubmit)
[293.162814] Starting subtest: legacy-resubmit
[293.163806] Starting dynamic subtest: default
[293.192903] Dynamic subtest default: SUCCESS (0.029s)
[293.205284] Starting dynamic subtest: render
[293.206207] Dynamic subtest render: SUCCESS (0.002s)
[293.218354] Starting dynamic subtest: bsd
[293.219564] Dynamic subtest bsd: SUCCESS (0.002s)
[293.230933] Starting dynamic subtest: bsd1
[293.231851] Dynamic subtest bsd1: SUCCESS (0.002s)
[293.243029] Starting dynamic subtest: bsd2
[293.243882] Dynamic subtest bsd2: SUCCESS (0.001s)
[293.255159] Starting dynamic subtest: blt
[293.256277] Dynamic subtest blt: SUCCESS (0.002s)
[293.267734] Starting dynamic subtest: vebox
[293.268874] Dynamic subtest vebox: SUCCESS (0.002s)
[293.270053] Subtest legacy-resubmit: SUCCESS (0.047s)
[293.528737] [044/134] (733s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[293.727958] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[294.428358] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.700s)
[294.654416] [045/134] (731s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[294.838723] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[294.906143] [046/134] (731s left) gem_ctx_exec (basic-invalid-context)
[294.987145] Starting subtest: basic-invalid-context
[294.992112] Subtest basic-invalid-context: SUCCESS (0.006s)
[295.224411] [047/134] (731s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[295.409734] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[295.412013] Starting dynamic subtest: pipe-A-valid-mode
[295.488378] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[295.490150] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.078s)
[295.742487] [048/134] (731s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[295.932048] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[295.933770] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[296.124087] [049/134] (730s left) gem_tiled_pread_pwrite
[296.269197] [050/134] (730s left) gem_lmem_swapping (parallel-random-verify)
[299.051585] Starting subtest: parallel-random-verify
[299.052813] Starting dynamic subtest: lmem0
[356.448905] Dynamic subtest lmem0: SUCCESS (57.393s)
[356.449899] Subtest parallel-random-verify: SUCCESS (57.394s)
[357.496624] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[357.497556] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true
[357.499893] [051/134] (669s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[359.217577] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[359.299037] [FACT kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[359.301603] [FACT kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[359.304116] [052/134] (667s left) gem_exec_schedule (reorder-wide)
[359.526318] Subtest reorder-wide: SKIP (0.000s)
[359.774209] [053/134] (667s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[359.963891] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[360.010527] Starting dynamic subtest: pipe-A-plane-0
[360.012310] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[360.022613] Starting dynamic subtest: pipe-A-plane-3
[360.024839] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[360.034806] Starting dynamic subtest: pipe-A-plane-5
[360.036551] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[360.239046] Starting dynamic subtest: pipe-B-plane-0
[360.241208] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[360.259145] Starting dynamic subtest: pipe-B-plane-3
[360.261136] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[360.275060] Starting dynamic subtest: pipe-B-plane-5
[360.277026] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[360.314471] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.349s)
[360.624941] [054/134] (666s left) perf (global-sseu-config-invalid)
[361.025110] Starting subtest: global-sseu-config-invalid
[361.026759] Subtest global-sseu-config-invalid: SKIP (0.000s)
[361.078176] [055/134] (666s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[361.265258] Starting subtest: cursorB-vs-flipA-varying-size
[361.267000] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[361.435832] [056/134] (665s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[361.627131] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[361.628894] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[361.819122] [057/134] (665s left) kms_dp_aux_dev
[362.547129] [058/134] (664s left) kms_psr (fbc-psr2-cursor-plane-move)
[362.736404] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[362.790857] [059/134] (664s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[363.001214] Starting subtest: x-tiled-32bpp-rotate-180
[364.915328] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.913s)
[365.131459] [060/134] (662s left) sw_sync (sync_expired_merge)
[365.179399] Starting subtest: sync_expired_merge
[366.253912] Subtest sync_expired_merge: SUCCESS (1.075s)
[366.346893] [061/134] (661s left) gem_exec_nop (basic-sequential)
[366.436493] Starting subtest: basic-sequential
[370.915456] Subtest basic-sequential: SUCCESS (4.477s)
[371.212400] [062/134] (656s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[371.398436] Starting subtest: compare-crc-sanitycheck-nv12
[371.399344] Starting dynamic subtest: pipe-A-DP-3
[372.124599] Dynamic subtest pipe-A-DP-3: SUCCESS (0.725s)
[372.143092] Starting dynamic subtest: pipe-B-DP-3
[372.761955] Dynamic subtest pipe-B-DP-3: SUCCESS (0.635s)
[372.775464] Starting dynamic subtest: pipe-C-DP-3
[373.398068] Dynamic subtest pipe-C-DP-3: SUCCESS (0.634s)
[373.421832] Starting dynamic subtest: pipe-D-DP-3
[374.007406] Dynamic subtest pipe-D-DP-3: SUCCESS (0.603s)
[374.008268] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.610s)
[374.301327] [063/134] (653s left) syncobj_wait (wait-for-submit-complex)
[374.379456] Starting subtest: wait-for-submit-complex
[374.441777] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[374.572192] [064/134] (653s left) gem_mmap_wc (bad-offset)
[374.652130] Subtest bad-offset: SKIP (0.000s)
[374.724412] [065/134] (653s left) gem_exec_reloc (basic-wc)
[374.809149] Subtest basic-wc: SKIP (0.000s)
[374.892164] [066/134] (653s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[375.080402] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[375.114465] Starting dynamic subtest: pipe-A-plane-0
[375.116259] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[375.127593] Starting dynamic subtest: pipe-A-plane-3
[375.129702] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[375.141210] Starting dynamic subtest: pipe-A-plane-5
[375.143033] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[375.342573] Starting dynamic subtest: pipe-B-plane-0
[375.344537] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[375.362655] Starting dynamic subtest: pipe-B-plane-3
[375.364567] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[375.377569] Starting dynamic subtest: pipe-B-plane-5
[375.379885] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[375.415593] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.335s)
[375.675760] [067/134] (652s left) kms_sequence (get-busy)
[375.861916] Starting subtest: get-busy
[375.864274] Starting dynamic subtest: pipe-A-DP-3
[378.451914] Dynamic subtest pipe-A-DP-3: SUCCESS (2.588s)
[378.466107] Starting dynamic subtest: pipe-B-DP-3
[380.957127] Dynamic subtest pipe-B-DP-3: SUCCESS (2.503s)
[380.971210] Starting dynamic subtest: pipe-C-DP-3
[383.427044] Dynamic subtest pipe-C-DP-3: SUCCESS (2.468s)
[383.439716] Starting dynamic subtest: pipe-D-DP-3
[385.941124] Dynamic subtest pipe-D-DP-3: SUCCESS (2.511s)
[385.942426] Subtest get-busy: SUCCESS (10.080s)
[386.254893] [068/134] (641s left) syncobj_timeline (reset-multiple-signaled)
[386.332594] Starting subtest: reset-multiple-signaled
[386.341231] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[386.518087] [069/134] (641s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[386.702541] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[386.705112] Starting dynamic subtest: pipe-A-DP-3
[386.713670] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[386.724715] Starting dynamic subtest: pipe-B-DP-3
[386.733208] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[386.744013] Starting dynamic subtest: pipe-C-DP-3
[386.752279] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[386.763201] Starting dynamic subtest: pipe-D-DP-3
[386.773467] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[386.775484] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[387.224175] [070/134] (641s left) gem_exec_reloc (basic-wc-gtt)
[387.312958] Subtest basic-wc-gtt: SKIP (0.000s)
[387.400998] [071/134] (641s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[387.586256] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[387.587147] Starting dynamic subtest: pipe-A-DP-3
[387.595456] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[387.606510] Starting dynamic subtest: pipe-B-DP-3
[387.614880] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[387.625570] Starting dynamic subtest: pipe-C-DP-3
[387.633898] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[387.644733] Starting dynamic subtest: pipe-D-DP-3
[387.655897] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[387.658403] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[388.083411] [072/134] (640s left) kms_chamelium_frames (hdmi-crc-multiple)
[388.344124] Subtest hdmi-crc-multiple: SKIP (0.000s)
[388.493458] [073/134] (640s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[388.684247] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[388.685991] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[388.868518] [074/134] (639s left) kms_pm_rpm (cursor-dpms)
[390.583104] Starting subtest: cursor-dpms
[390.586730] Subtest cursor-dpms: SKIP (0.000s)
[391.013302] [075/134] (637s left) gem_eio (wait-wedge-immediate)
[391.300413] Starting subtest: wait-wedge-immediate
[392.410092] Subtest wait-wedge-immediate: SUCCESS (1.110s)
[392.653110] [076/134] (636s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[392.843494] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[392.858872] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.014s)
[393.016101] [077/134] (635s left) i915_query (query-topology-matches-eu-total)
[393.093358] Starting subtest: query-topology-matches-eu-total
[393.094275] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[393.298881] [078/134] (635s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[393.494893] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[393.496555] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[393.684325] [079/134] (635s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[393.883401] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[393.884196] Starting dynamic subtest: pipe-A
[393.964086] Dynamic subtest pipe-A: SUCCESS (0.081s)
[393.981119] Starting dynamic subtest: pipe-B
[394.161332] Dynamic subtest pipe-B: SUCCESS (0.196s)
[394.183476] Starting dynamic subtest: pipe-C
[394.373829] Dynamic subtest pipe-C: SUCCESS (0.211s)
[394.398574] Starting dynamic subtest: pipe-D
[394.586787] Dynamic subtest pipe-D: SUCCESS (0.211s)
[394.587831] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.705s)
[394.938456] [080/134] (634s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[395.123376] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[395.124239] Starting dynamic subtest: pipe-A-DP-3
[395.132542] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[395.144248] Starting dynamic subtest: pipe-B-DP-3
[395.154586] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[395.166990] Starting dynamic subtest: pipe-C-DP-3
[395.175292] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[395.186902] Starting dynamic subtest: pipe-D-DP-3
[395.197264] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[395.198946] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[395.615393] [081/134] (633s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[395.805974] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[403.212438] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.407s)
[403.411235] [082/134] (625s left) kms_chamelium_hpd (common-hpd-after-suspend)
[403.673158] Subtest common-hpd-after-suspend: SKIP (0.000s)
[403.822629] [083/134] (625s left) drm_read (short-buffer-nonblock)
[404.081370] Starting subtest: short-buffer-nonblock
[404.082238] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[404.346010] [084/134] (625s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[404.533964] Starting subtest: psr-abgr161616f-draw-mmap-wc
[404.535643] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[404.705318] [085/134] (624s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[404.894425] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[404.896170] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[405.040897] [086/134] (624s left) gem_exec_schedule (noreorder-priority)
[405.244558] Starting subtest: noreorder-priority
[405.245478] Starting dynamic subtest: rcs0
[406.400362] Dynamic subtest rcs0: SUCCESS (1.155s)
[406.413940] Starting dynamic subtest: bcs0
[407.543419] Dynamic subtest bcs0: SUCCESS (1.142s)
[407.558661] Starting dynamic subtest: vcs0
[408.650493] Dynamic subtest vcs0: SUCCESS (1.106s)
[408.664264] Starting dynamic subtest: vcs1
[409.784368] Dynamic subtest vcs1: SUCCESS (1.133s)
[409.798550] Starting dynamic subtest: vecs0
[410.891224] Dynamic subtest vecs0: SUCCESS (1.106s)
[410.904619] Starting dynamic subtest: vecs1
[411.996259] Dynamic subtest vecs1: SUCCESS (1.104s)
[412.009990] Starting dynamic subtest: ccs0
[413.096307] Dynamic subtest ccs0: SUCCESS (1.099s)
[413.097243] Subtest noreorder-priority: SUCCESS (7.852s)
[413.348751] [087/134] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[413.538276] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[413.539899] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[413.696269] [088/134] (616s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[413.779439] Starting subtest: etime-single-wait-for-submit-submitted
[413.883510] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.103s)
[414.060962] [089/134] (615s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[414.147649] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[414.149501] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[414.371891] [090/134] (615s left) kms_addfb_basic (clobberred-modifier)
[414.450559] Starting subtest: clobberred-modifier
[414.452261] Subtest clobberred-modifier: SKIP (0.000s)
[414.725634] [091/134] (615s left) kms_cursor_crc (cursor-onscreen-64x64)
[415.046613] Starting subtest: cursor-onscreen-64x64
[415.051985] Starting dynamic subtest: pipe-A-DP-3
[417.811575] Dynamic subtest pipe-A-DP-3: SUCCESS (2.760s)
[417.850524] Starting dynamic subtest: pipe-D-DP-3
[420.608381] Dynamic subtest pipe-D-DP-3: SUCCESS (2.769s)
[420.609306] Subtest cursor-onscreen-64x64: SUCCESS (5.562s)
[421.108050] [092/134] (608s left) gem_unfence_active_buffers
[421.344555] [093/134] (608s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[421.536106] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[421.537816] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[421.747431] [094/134] (608s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[421.956276] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[422.304201] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.348s)
[422.651880] [095/134] (607s left) syncobj_basic (illegal-fd-to-handle)
[422.728557] Starting subtest: illegal-fd-to-handle
[422.729533] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[422.916815] [096/134] (607s left) kms_psr (fbc-pr-no-drrs)
[423.105487] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[423.161736] [097/134] (607s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[423.359128] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[423.360835] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[423.572048] [098/134] (606s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[423.765007] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[423.766551] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[423.966960] [099/134] (606s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[424.157158] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[424.158950] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[424.316794] [100/134] (606s left) gem_eio (kms)
[424.784268] Starting subtest: kms
[456.640112] Subtest kms: SUCCESS (31.854s)
[457.003972] [101/134] (573s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[457.188284] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[457.189187] Starting dynamic subtest: pipe-A-DP-3
[457.198690] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[457.211148] Starting dynamic subtest: pipe-B-DP-3
[457.220274] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[457.232251] Starting dynamic subtest: pipe-C-DP-3
[457.250007] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[457.262198] Starting dynamic subtest: pipe-D-DP-3
[457.273443] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[457.275483] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[457.678621] [102/134] (573s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[460.312468] Starting subtest: heavy-verify-multi-ccs
[460.313817] Starting dynamic subtest: lmem0
[472.028417] Dynamic subtest lmem0: SUCCESS (11.715s)
[472.029345] Subtest heavy-verify-multi-ccs: SUCCESS (11.716s)
[473.339946] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[473.340865] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[473.342820] [103/134] (557s left) gem_spin_batch (user-each)
[474.932210] Starting subtest: user-each
[478.368694] Subtest user-each: SUCCESS (3.437s)
[478.622864] [FACT gem_spin_batch (user-each)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[478.625634] [FACT gem_spin_batch (user-each)] new: kernel.kmod_is_loaded.i915: true
[478.628261] [104/134] (552s left) kms_big_fb (linear-64bpp-rotate-0)
[478.830000] Starting subtest: linear-64bpp-rotate-0
[480.945050] Subtest linear-64bpp-rotate-0: SUCCESS (2.115s)
[481.160911] [105/134] (549s left) drm_read (empty-nonblock)
[481.428541] Starting subtest: empty-nonblock
[481.429387] Subtest empty-nonblock: SUCCESS (0.000s)
[481.697142] [106/134] (549s left) syncobj_timeline (wait-for-submit-delayed-submit)
[481.776468] Starting subtest: wait-for-submit-delayed-submit
[481.880703] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[481.996287] [107/134] (549s left) core_debugfs (read-all-entries)
[482.074458] Starting subtest: read-all-entries
[482.145904] Subtest read-all-entries: SUCCESS (0.072s)
[482.359397] [108/134] (548s left) gem_mmap_offset (blt-coherency)
[482.437334] Starting subtest: blt-coherency
[482.474201] Subtest blt-coherency: SUCCESS (0.037s)
[482.713942] [109/134] (548s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[482.907418] Starting subtest: 4-tiled-8bpp-rotate-270
[482.962407] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.054s)
[483.214278] [110/134] (548s left) kms_addfb_basic (invalid-set-prop-any)
[483.293733] Starting subtest: invalid-set-prop-any
[483.294558] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[483.595448] [111/134] (547s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[483.794006] Starting subtest: y-tiled-16bpp-rotate-90
[483.795773] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[483.995552] [112/134] (547s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[484.188370] Starting subtest: primary-y-tiled-reflect-x-270
[484.190142] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[484.341450] [113/134] (547s left) gen7_exec_parse (bitmasks)
[484.425502] Subtest bitmasks: SKIP (0.000s)
[484.512100] [114/134] (547s left) kms_content_protection (mei-interface)
[484.766395] Starting subtest: mei-interface
[484.773254] Subtest mei-interface: SKIP (0.004s)
[484.978917] [115/134] (546s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[485.165267] Starting subtest: flip-vs-cursor-legacy
[494.787388] Subtest flip-vs-cursor-legacy: SUCCESS (9.623s)
[495.106841] [116/134] (536s left) kms_vblank (ts-continuation-dpms-rpm)
[495.293559] Starting subtest: ts-continuation-dpms-rpm
[495.296195] Starting dynamic subtest: pipe-A-DP-3
[497.986580] Dynamic subtest pipe-A-DP-3: SUCCESS (2.691s)
[498.014033] Starting dynamic subtest: pipe-D-DP-3
[498.838193] Dynamic subtest pipe-D-DP-3: SUCCESS (0.843s)
[498.839181] Subtest ts-continuation-dpms-rpm: SUCCESS (3.544s)
[499.126171] [117/134] (532s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[499.316326] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[499.318103] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[499.521800] [118/134] (532s left) gem_busy (parallel)
[499.759764] Starting subtest: parallel
[499.760703] Starting dynamic subtest: rcs0
[499.892787] Dynamic subtest rcs0: SUCCESS (0.133s)
[499.910020] Starting dynamic subtest: bcs0
[499.956929] Dynamic subtest bcs0: SUCCESS (0.063s)
[499.979587] Starting dynamic subtest: vcs0
[500.032822] Dynamic subtest vcs0: SUCCESS (0.074s)
[500.048578] Starting dynamic subtest: vcs1
[500.095227] Dynamic subtest vcs1: SUCCESS (0.061s)
[500.119147] Starting dynamic subtest: vecs0
[500.172961] Dynamic subtest vecs0: SUCCESS (0.076s)
[500.192042] Starting dynamic subtest: vecs1
[500.241720] Dynamic subtest vecs1: SUCCESS (0.067s)
[500.254714] Starting dynamic subtest: ccs0
[500.304639] Dynamic subtest ccs0: SUCCESS (0.062s)
[500.305514] Subtest parallel: SUCCESS (0.546s)
[500.674457] [119/134] (531s left) prime_vgem (coherency-blt)
[500.782318] Starting subtest: coherency-blt
[503.076181] Subtest coherency-blt: SUCCESS (2.295s)
[503.276795] [120/134] (529s left) gem_exec_balancer (invalid-balancer)
[503.368400] Starting subtest: invalid-balancer
[504.889859] Subtest invalid-balancer: SUCCESS (1.521s)
[505.302585] [121/134] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[505.493120] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[505.494799] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[505.691218] [122/134] (526s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[505.888490] Starting subtest: yf-tiled-64bpp-rotate-90
[505.890236] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[506.070503] [123/134] (526s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[506.574312] Starting subtest: cursor-rapid-movement-max-size
[506.576852] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[506.807113] [124/134] (525s left) kms_color (ctm-green-to-red)
[506.996277] Starting subtest: ctm-green-to-red
[506.997175] Starting dynamic subtest: pipe-A-DP-3
[507.682771] Dynamic subtest pipe-A-DP-3: SUCCESS (0.686s)
[507.694542] Starting dynamic subtest: pipe-B-DP-3
[508.295854] Dynamic subtest pipe-B-DP-3: SUCCESS (0.612s)
[508.307402] Starting dynamic subtest: pipe-C-DP-3
[508.884789] Dynamic subtest pipe-C-DP-3: SUCCESS (0.587s)
[508.903339] Starting dynamic subtest: pipe-D-DP-3
[509.500476] Dynamic subtest pipe-D-DP-3: SUCCESS (0.615s)
[509.501417] Subtest ctm-green-to-red: SUCCESS (2.505s)
[509.850719] [125/134] (522s left) kms_flip (flip-vs-blocking-wf-vblank)
[510.035258] Starting subtest: flip-vs-blocking-wf-vblank
[510.039948] Starting dynamic subtest: A-DP3
[518.158422] Dynamic subtest A-DP3: SUCCESS (8.118s)
[518.173342] Starting dynamic subtest: B-DP3
[526.209548] Dynamic subtest B-DP3: SUCCESS (8.049s)
[526.223470] Starting dynamic subtest: C-DP3
[534.257667] Dynamic subtest C-DP3: SUCCESS (8.047s)
[534.271173] Starting dynamic subtest: D-DP3
[542.312606] Dynamic subtest D-DP3: SUCCESS (8.054s)
[542.314954] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.280s)
[542.675959] [126/134] (490s left) gem_ctx_engines (independent)
[542.765275] Starting subtest: independent
[542.766188] Starting dynamic subtest: rcs0
[542.940202] Dynamic subtest rcs0: SUCCESS (0.174s)
[542.953375] Starting dynamic subtest: bcs0
[543.103945] Dynamic subtest bcs0: SUCCESS (0.162s)
[543.115764] Starting dynamic subtest: vcs0
[543.271821] Dynamic subtest vcs0: SUCCESS (0.167s)
[543.283836] Starting dynamic subtest: vcs1
[543.450875] Dynamic subtest vcs1: SUCCESS (0.178s)
[543.462783] Starting dynamic subtest: vecs0
[543.618842] Dynamic subtest vecs0: SUCCESS (0.167s)
[543.630626] Starting dynamic subtest: vecs1
[543.785476] Dynamic subtest vecs1: SUCCESS (0.165s)
[543.797375] Starting dynamic subtest: ccs0
[543.956836] Dynamic subtest ccs0: SUCCESS (0.170s)
[543.968729] Starting dynamic subtest: all-engines
[544.347018] Dynamic subtest all-engines: SUCCESS (0.389s)
[544.347962] Subtest independent: SUCCESS (1.582s)
[545.389449] [127/134] (487s left) i915_query (query-topology-coherent-slice-mask)
[545.467312] Starting subtest: query-topology-coherent-slice-mask
[545.469375] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[545.641886] [128/134] (487s left) sw_sync (sync_merge)
[545.689138] Starting subtest: sync_merge
[545.690149] Subtest sync_merge: SUCCESS (0.000s)
[545.814893] [129/134] (487s left) i915_drm_fdinfo (memory-info-resident)
[545.885846] Starting subtest: memory-info-resident
[545.886789] Starting dynamic subtest: lmem0
[549.582478] Dynamic subtest lmem0: SUCCESS (3.695s)
[549.603216] Starting dynamic subtest: smem0
[553.933828] Dynamic subtest smem0: SUCCESS (4.345s)
[553.934719] Subtest memory-info-resident: SUCCESS (8.048s)
[554.049079] [130/134] (479s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[554.240100] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[554.241850] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[554.423888] [131/134] (478s left) kms_psr (psr2-sprite-plane-move)
[554.614586] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[554.669881] [132/134] (478s left) kms_selftest (drm_cmdline_parser)
[554.720378] Starting subtest: drm_cmdline_parser
[554.753349] Starting dynamic subtest: drm_test_cmdline_force_d_only
[554.823113] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.072s)
[554.854016] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[554.898125] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.071s)
[554.945430] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[554.982969] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.080s)
[555.004883] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[555.069340] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.083s)
[555.116841] Starting dynamic subtest: drm_test_cmdline_force_e_only
[555.164919] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.091s)
[555.211877] Starting dynamic subtest: drm_test_cmdline_res
[555.252545] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.085s)
[555.284460] Starting dynamic subtest: drm_test_cmdline_res_vesa
[555.338903] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.083s)
[555.382202] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[555.421930] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.078s)
[555.443166] Starting dynamic subtest: drm_test_cmdline_res_rblank
[555.504101] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.079s)
[555.548395] Starting dynamic subtest: drm_test_cmdline_res_bpp
[555.588955] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.081s)
[555.610146] Starting dynamic subtest: drm_test_cmdline_res_refresh
[555.675193] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.083s)
[555.718517] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[555.767603] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.088s)
[555.801967] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[555.843192] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.073s)
[555.855478] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[555.951525] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.106s)
[555.963614] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[556.030426] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.077s)
[556.077104] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[556.123808] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.090s)
[556.138853] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[556.189972] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.064s)
[556.217633] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[556.276279] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.083s)
[556.318752] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[556.356058] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.075s)
[556.382486] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[556.447137] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.087s)
[556.474124] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[556.512379] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.061s)
[556.527657] Starting dynamic subtest: drm_test_cmdline_name
[556.582418] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.067s)
[556.626506] Starting dynamic subtest: drm_test_cmdline_name_bpp
[556.669318] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.083s)
[556.699531] Starting dynamic subtest: drm_test_cmdline_name_option
[556.750908] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.078s)
[556.799526] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[556.830890] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.076s)
[556.850760] Starting dynamic subtest: drm_test_cmdline_rotate_0
[556.913323] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.080s)
[556.957806] Starting dynamic subtest: drm_test_cmdline_rotate_90
[557.016214] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.098s)
[557.060734] Starting dynamic subtest: drm_test_cmdline_rotate_180
[557.094221] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.074s)
[557.115508] Starting dynamic subtest: drm_test_cmdline_rotate_270
[557.189393] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.092s)
[557.234760] Starting dynamic subtest: drm_test_cmdline_hmirror
[557.273041] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.079s)
[557.299446] Starting dynamic subtest: drm_test_cmdline_vmirror
[557.376079] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.099s)
[557.421024] Starting dynamic subtest: drm_test_cmdline_margin_options
[557.461166] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.081s)
[557.485614] Starting dynamic subtest: drm_test_cmdline_multiple_options
[557.555377] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.091s)
[557.570610] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[557.642536] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.082s)
[557.688511] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[557.737513] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.090s)
[557.772190] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[557.839140] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.098s)
[557.854895] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[557.934245] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.089s)
[557.980336] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[558.021128] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.083s)
[558.052162] Starting dynamic subtest: drm_test_cmdline_invalid
[558.133958] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.109s)
[558.170374] Starting dynamic subtest: drm_test_cmdline_tv_options
[558.213480] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.077s)
[558.214458] Subtest drm_cmdline_parser: SUCCESS (3.494s)
[558.488876] [133/134] (474s left) perf_pmu (semaphore-busy)
[558.559420] Starting subtest: semaphore-busy
[558.560440] Starting dynamic subtest: rcs0
[560.243793] Dynamic subtest rcs0: SUCCESS (1.681s)
[560.261561] Starting dynamic subtest: bcs0
[561.888889] Dynamic subtest bcs0: SUCCESS (1.640s)
[561.906560] Starting dynamic subtest: vcs0
[563.531793] Dynamic subtest vcs0: SUCCESS (1.638s)
[563.549517] Starting dynamic subtest: vcs1
[565.175916] Dynamic subtest vcs1: SUCCESS (1.639s)
[565.190903] Starting dynamic subtest: vecs0
[566.819705] Dynamic subtest vecs0: SUCCESS (1.639s)
[566.837517] Starting dynamic subtest: vecs1
[568.463686] Dynamic subtest vecs1: SUCCESS (1.639s)
[568.485194] Starting dynamic subtest: ccs0
[570.106904] Dynamic subtest ccs0: SUCCESS (1.638s)
[570.108862] Subtest semaphore-busy: SUCCESS (11.548s)
[570.343457] [134/134] (462s left) gem_pxp (reject-modify-context-protection-off-2)
[572.950761] Starting subtest: reject-modify-context-protection-off-2
[572.953204] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[573.119891] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_plane_cursor
results: parsing output: 4/ for test: kms_atomic_interruptible
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: i915_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: core_getstats
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: i915_hangman
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: gem_partial_pwrite_pread
results: parsing output: 24/ for test: sysfs_heartbeat_interval
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_partial_pwrite_pread
results: parsing output: 27/ for test: i915_suspend
results: parsing output: 28/ for test: kms_cursor_edge_walk
results: parsing output: 29/ for test: gem_exec_parallel
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_eventfd
results: parsing output: 37/ for test: kms_dsc
results: parsing output: 38/ for test: kms_joiner
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_bad_reloc
results: parsing output: 41/ for test: api_intel_bb
results: parsing output: 42/ for test: gem_spin_batch
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: gem_ctx_exec
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_tiled_pread_pwrite
results: parsing output: 49/ for test: gem_lmem_swapping
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: kms_plane
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_dp_aux_dev
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: gem_exec_nop
results: parsing output: 61/ for test: kms_pipe_crc_basic
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_plane
results: parsing output: 66/ for test: kms_sequence
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_chamelium_frames
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_pm_rpm
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: drm_read
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_unfence_active_buffers
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: syncobj_basic
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_lmem_swapping
results: parsing output: 102/ for test: gem_spin_batch
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: drm_read
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: core_debugfs
results: parsing output: 107/ for test: gem_mmap_offset
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_addfb_basic
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: gen7_exec_parse
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_busy
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_color
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_ctx_engines
results: parsing output: 126/ for test: i915_query
results: parsing output: 127/ for test: sw_sync
results: parsing output: 128/ for test: i915_drm_fdinfo
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_selftest
results: parsing output: 132/ for test: perf_pmu
results: parsing output: 133/ for test: gem_pxp
Done.