[57.606504] Initializing watchdogs
[57.606624]   /dev/watchdog0
[57.622982] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.627618] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.629924] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.633353] [001/155] (960s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[57.776972] Starting subtest: x-tiled-8bpp-rotate-270
[57.814187] Subtest x-tiled-8bpp-rotate-270: SKIP (0.037s)
[57.930945] [002/155] (960s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[58.047303] Starting subtest: 2x-cursor-vs-flip-atomic
[58.051843] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[58.212304] [003/155] (959s left) kms_getfb (getfb2-handle-not-fb)
[58.311798] Starting subtest: getfb2-handle-not-fb
[58.314176] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[58.427770] [004/155] (959s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[58.484969] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[58.487391] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[58.582851] [005/155] (959s left) gen9_exec_parse (bb-start-cmd)
[58.644768] Subtest bb-start-cmd: SKIP (0.000s)
[58.714935] [006/155] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[58.811767] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[62.986862] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.156s)
[64.186985] [007/155] (954s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[64.311687] Starting subtest: flip-vs-cursor-toggle
[73.043527] Subtest flip-vs-cursor-toggle: FAIL (8.208s)
[73.098124] [008/155] (945s left) gem_exec_params (sol-reset-not-gen7)
[73.227573] Starting subtest: sol-reset-not-gen7
[73.232114] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[73.399277] [009/155] (945s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[73.443264] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[73.482171] [010/155] (945s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[73.610882] Starting subtest: crc-primary-suspend-y-tiled-ccs
[73.614430] Starting dynamic subtest: pipe-A-eDP-1
[73.622388] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.630286] Starting dynamic subtest: pipe-B-eDP-1
[73.637827] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.645575] Starting dynamic subtest: pipe-C-eDP-1
[73.652915] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.659998] Starting dynamic subtest: pipe-D-eDP-1
[73.667291] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.670881] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[75.873197] [011/155] (942s left) gem_exec_schedule (preempt-contexts)
[75.948416] Starting subtest: preempt-contexts
[75.950773] Starting dynamic subtest: rcs0
[76.002603] Dynamic subtest rcs0: SUCCESS (0.058s)
[76.013594] Starting dynamic subtest: bcs0
[76.055071] Dynamic subtest bcs0: SUCCESS (0.051s)
[76.067802] Starting dynamic subtest: vcs0
[76.106999] Dynamic subtest vcs0: SUCCESS (0.052s)
[76.116031] Starting dynamic subtest: vcs1
[76.156721] Dynamic subtest vcs1: SUCCESS (0.047s)
[76.168284] Starting dynamic subtest: vecs0
[76.195508] Dynamic subtest vecs0: SUCCESS (0.041s)
[76.204082] Starting dynamic subtest: ccs0
[76.241141] Dynamic subtest ccs0: SUCCESS (0.044s)
[76.243467] Subtest preempt-contexts: SUCCESS (0.297s)
[77.388387] [012/155] (941s left) kms_atomic_interruptible (legacy-setmode)
[77.483339] Starting subtest: legacy-setmode
[77.485777] Starting dynamic subtest: pipe-A-eDP-1
[84.407253] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.921s)
[84.409456] Subtest legacy-setmode: SUCCESS (6.922s)
[85.268898] [013/155] (933s left) kms_feature_discovery (display-3x)
[85.356146] Starting subtest: display-3x
[85.360674] Subtest display-3x: SKIP (0.000s)
[85.426047] [014/155] (933s left) kms_vblank (query-forked-busy)
[85.515224] Starting subtest: query-forked-busy
[85.517503] Starting dynamic subtest: pipe-A-eDP-1
[87.391172] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[87.406064] Starting dynamic subtest: pipe-D-eDP-1
[89.932721] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[89.935207] Subtest query-forked-busy: SUCCESS (4.417s)
[90.738324] [015/155] (927s left) api_intel_bb (misplaced-blitter)
[90.796938] Starting subtest: misplaced-blitter
[90.801512] Subtest misplaced-blitter: SUCCESS (0.006s)
[90.925518] [016/155] (927s left) kms_addfb_basic (clobberred-modifier)
[90.982952] Starting subtest: clobberred-modifier
[90.987502] Subtest clobberred-modifier: SKIP (0.000s)
[91.112389] [017/155] (927s left) gem_exec_fence (long-history)
[91.553227] Starting subtest: long-history
[98.996666] Subtest long-history: SUCCESS (7.442s)
[99.489616] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[99.492836] [018/155] (919s left) kms_async_flips (test-time-stamp)
[99.588102] Starting subtest: test-time-stamp
[100.691139] Starting dynamic subtest: pipe-A-eDP-1
[101.161071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.470s)
[101.548697] Starting dynamic subtest: pipe-B-eDP-1
[102.402118] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.857s)
[102.794532] Starting dynamic subtest: pipe-C-eDP-1
[103.638393] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.852s)
[104.002666] Starting dynamic subtest: pipe-D-eDP-1
[104.771679] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[104.774201] Subtest test-time-stamp: SUCCESS (5.183s)
[105.934084] [019/155] (912s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[106.035729] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite
[106.040297] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[106.124683] [020/155] (912s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[106.224945] Starting subtest: 4-tiled-32bpp-rotate-270
[106.245064] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[106.357046] [021/155] (912s left) kms_psr (psr-cursor-mmap-cpu)
[106.452180] Starting subtest: psr-cursor-mmap-cpu
[106.454574] Starting dynamic subtest: eDP-1
[108.228632] Dynamic subtest eDP-1: SUCCESS (1.776s)
[108.230831] Subtest psr-cursor-mmap-cpu: SUCCESS (1.776s)
[109.089716] [022/155] (909s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[109.191376] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[116.520174] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.335s)
[116.656340] [023/155] (902s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[116.748056] Starting subtest: plane-upscale-20x20-with-modifiers
[116.750426] Starting dynamic subtest: pipe-A
[117.083508] Dynamic subtest pipe-A: SUCCESS (0.337s)
[117.095125] Starting dynamic subtest: pipe-B
[118.496464] Dynamic subtest pipe-B: SUCCESS (1.412s)
[118.504743] Starting dynamic subtest: pipe-C
[119.932345] Dynamic subtest pipe-C: SUCCESS (1.435s)
[119.945345] Starting dynamic subtest: pipe-D
[121.367458] Dynamic subtest pipe-D: SUCCESS (1.434s)
[121.369859] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.622s)
[122.537701] [024/155] (896s left) kms_plane_multiple (tiling-4)
[122.638540] Starting subtest: tiling-4
[122.640474] Starting dynamic subtest: pipe-A-eDP-1
[126.387215] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.749s)
[126.396866] Starting dynamic subtest: pipe-B-eDP-1
[130.856110] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.468s)
[130.865175] Starting dynamic subtest: pipe-C-eDP-1
[135.365658] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.508s)
[135.374295] Starting dynamic subtest: pipe-D-eDP-1
[139.824526] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.457s)
[139.827205] Subtest tiling-4: SUCCESS (17.185s)
[140.635208] [025/155] (878s left) gem_ctx_persistence (userptr)
[140.689655] Starting subtest: userptr
[140.862042] Subtest userptr: SUCCESS (0.171s)
[140.951792] [026/155] (878s left) gem_exec_balancer (fairslice)
[141.010564] Starting subtest: fairslice
[143.941286] Subtest fairslice: SUCCESS (2.928s)
[144.328091] [027/155] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[144.443755] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[144.448110] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[144.524372] [028/155] (874s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[144.620618] Starting subtest: y-tiled-64bpp-rotate-0
[144.624587] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[144.714797] [029/155] (874s left) gem_pread (self)
[144.775206] Subtest self: SKIP (0.000s)
[144.835562] [030/155] (874s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[144.929797] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[144.933803] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[145.023204] [031/155] (874s left) kms_flip (flip-vs-panning-interruptible)
[145.111473] Starting subtest: flip-vs-panning-interruptible
[145.113864] Starting dynamic subtest: A-eDP1
[153.855785] Dynamic subtest A-eDP1: SUCCESS (8.744s)
[153.865852] Starting dynamic subtest: B-eDP1
[162.579282] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[162.588280] Starting dynamic subtest: C-eDP1
[171.299505] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[171.307595] Starting dynamic subtest: D-eDP1
[180.019974] Dynamic subtest D-eDP1: SUCCESS (8.719s)
[180.024702] Subtest flip-vs-panning-interruptible: SUCCESS (34.914s)
[181.180200] [032/155] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[181.291495] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[181.296045] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[181.394402] [033/155] (837s left) kms_invalid_mode (zero-hdisplay)
[181.497064] Starting subtest: zero-hdisplay
[181.499269] Starting dynamic subtest: pipe-A-eDP-1
[181.779186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[181.787143] Starting dynamic subtest: pipe-B-eDP-1
[181.789036] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[181.796457] Starting dynamic subtest: pipe-C-eDP-1
[181.798330] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[181.806181] Starting dynamic subtest: pipe-D-eDP-1
[181.808438] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[181.810681] Subtest zero-hdisplay: SUCCESS (0.290s)
[182.623542] [034/155] (836s left) gem_lmem_swapping (verify-ccs)
[182.667664] Subtest verify-ccs: SKIP (0.000s)
[182.705261] [035/155] (836s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[182.760895] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[182.763283] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[182.847136] [036/155] (836s left) gem_exec_reloc (basic-write-read)
[182.903047] Subtest basic-write-read: SKIP (0.000s)
[182.969097] [037/155] (836s left) kms_getfb (getfb-addfb-different-handles)
[183.061390] Starting subtest: getfb-addfb-different-handles
[183.063755] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[183.178656] [038/155] (836s left) gem_exec_gttfill (basic)
[183.241959] Starting subtest: basic
[185.832748] Subtest basic: SUCCESS (2.592s)
[186.032133] [039/155] (833s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt)
[186.185315] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt
[186.189557] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[186.281427] [040/155] (833s left) gem_eio (in-flight-contexts-10ms)
[186.513984] Starting subtest: in-flight-contexts-10ms
[200.343408] Subtest in-flight-contexts-10ms: SUCCESS (13.829s)
[200.530165] [041/155] (819s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[200.637274] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[201.520428] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.884s)
[201.679421] [042/155] (818s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[201.767280] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[201.771270] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[201.838764] [043/155] (817s left) gem_userptr_blits (sd-probe)
[201.893749] Starting subtest: sd-probe
[201.895803] Subtest sd-probe: SUCCESS (0.000s)
[202.005031] [044/155] (817s left) kms_plane_alpha_blend (constant-alpha-min)
[202.091416] Starting subtest: constant-alpha-min
[202.376080] Starting dynamic subtest: pipe-A-eDP-1
[203.100658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s)
[203.110797] Starting dynamic subtest: pipe-D-eDP-1
[204.606829] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.505s)
[204.609185] Subtest constant-alpha-min: SUCCESS (2.517s)
[205.482969] [045/155] (814s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[205.578580] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[212.934985] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.362s)
[214.109085] [046/155] (805s left) kms_psr2_su (page_flip-nv12)
[214.167200] Subtest page_flip-NV12: SKIP (0.000s)
[214.231079] [047/155] (805s left) gem_madvise (dontneed-before-pwrite)
[214.270097] Starting subtest: dontneed-before-pwrite
[214.282303] Subtest dontneed-before-pwrite: SKIP (0.012s)
[214.344939] [048/155] (805s left) kms_force_connector_basic (force-load-detect)
[214.416791] Starting subtest: force-load-detect
[214.421499] Subtest force-load-detect: SKIP (0.000s)
[214.532235] [049/155] (805s left) gem_ctx_persistence (engines-hostile)
[214.586955] Starting subtest: engines-hostile
[214.589760] Starting dynamic subtest: rcs0
[214.708651] Dynamic subtest rcs0: SUCCESS (0.124s)
[214.718847] Starting dynamic subtest: bcs0
[214.791849] Dynamic subtest bcs0: SUCCESS (0.081s)
[214.802661] Starting dynamic subtest: vcs0
[214.908720] Dynamic subtest vcs0: SUCCESS (0.115s)
[214.920234] Starting dynamic subtest: vcs1
[214.999892] Dynamic subtest vcs1: SUCCESS (0.089s)
[215.012094] Starting dynamic subtest: vecs0
[215.106683] Dynamic subtest vecs0: SUCCESS (0.105s)
[215.117394] Starting dynamic subtest: ccs0
[215.205383] Dynamic subtest ccs0: SUCCESS (0.097s)
[215.207726] Subtest engines-hostile: SUCCESS (0.622s)
[215.283386] [050/155] (804s left) syncobj_wait (wait-all-snapshot)
[215.332311] Starting subtest: wait-all-snapshot
[215.415431] Subtest wait-all-snapshot: SUCCESS (0.082s)
[215.488810] [051/155] (804s left) kms_psr (fbc-psr-cursor-blt)
[215.573462] Starting subtest: fbc-psr-cursor-blt
[215.575539] Starting dynamic subtest: eDP-1
[215.579039] Dynamic subtest eDP-1: SKIP (0.000s)
[215.582557] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[215.644423] [052/155] (804s left) prime_vgem (wait)
[215.721638] Starting subtest: wait
[215.723794] Starting dynamic subtest: rcs0
[215.783831] Dynamic subtest rcs0: SUCCESS (0.062s)
[215.793197] Starting dynamic subtest: bcs0
[215.849418] Dynamic subtest bcs0: SUCCESS (0.065s)
[215.859113] Starting dynamic subtest: vcs0
[215.899723] Dynamic subtest vcs0: SUCCESS (0.049s)
[215.908461] Starting dynamic subtest: vcs1
[215.943847] Dynamic subtest vcs1: SUCCESS (0.043s)
[215.952131] Starting dynamic subtest: vecs0
[215.992205] Dynamic subtest vecs0: SUCCESS (0.047s)
[216.000662] Starting dynamic subtest: ccs0
[216.036106] Dynamic subtest ccs0: SUCCESS (0.043s)
[216.038071] Subtest wait: SUCCESS (0.315s)
[216.165848] [053/155] (804s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[216.216165] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[216.218274] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[216.305276] [054/155] (803s left) kms_vblank (wait-forked-busy)
[216.395963] Starting subtest: wait-forked-busy
[216.397871] Starting dynamic subtest: pipe-A-eDP-1
[218.274752] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[218.291125] Starting dynamic subtest: pipe-D-eDP-1
[220.839650] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s)
[220.842089] Subtest wait-forked-busy: SUCCESS (4.445s)
[221.655441] [055/155] (798s left) gem_unref_active_buffers
[221.840893] [056/155] (798s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[221.895804] Starting subtest: invalid-smem-bo-on-discrete
[221.900439] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[222.040479] [057/155] (798s left) syncobj_timeline (32bits-limit)
[222.100623] Starting subtest: 32bits-limit
[222.103070] Subtest 32bits-limit: SUCCESS (0.001s)
[222.207260] [058/155] (798s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[222.303081] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[222.307245] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[222.403219] [059/155] (798s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[222.492100] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[222.494437] Starting dynamic subtest: pipe-A-default-mode
[225.197250] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s)
[225.199774] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.706s)
[226.068977] [060/155] (794s left) kms_scaling_modes (scaling-mode-none)
[226.158180] Starting subtest: scaling-mode-none
[226.160477] Starting dynamic subtest: pipe-A-eDP-1
[226.256252] Dynamic subtest pipe-A-eDP-1: SKIP (0.098s)
[226.269194] Starting dynamic subtest: pipe-B-eDP-1
[226.292190] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s)
[226.301673] Starting dynamic subtest: pipe-C-eDP-1
[226.331323] Dynamic subtest pipe-C-eDP-1: SKIP (0.038s)
[226.342200] Starting dynamic subtest: pipe-D-eDP-1
[226.368790] Dynamic subtest pipe-D-eDP-1: SKIP (0.036s)
[226.373184] Subtest scaling-mode-none: SKIP (0.212s)
[226.475340] [061/155] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[226.580090] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[226.584334] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[226.685584] [062/155] (793s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[226.790540] Starting subtest: psr-rgb565-draw-render
[233.782584] Subtest psr-rgb565-draw-render: SUCCESS (6.997s)
[233.897825] [063/155] (786s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[234.001977] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[234.006360] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[234.107468] [064/155] (786s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[234.214210] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[240.884701] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.675s)
[241.011259] [065/155] (779s left) kms_chamelium_hpd (dp-hpd-fast)
[241.395734] Subtest dp-hpd-fast: SKIP (0.000s)
[242.226377] [066/155] (778s left) gem_exec_schedule (semaphore-noskip)
[242.292552] Starting subtest: semaphore-noskip
[242.722917] Subtest semaphore-noskip: SUCCESS (0.434s)
[243.061147] [067/155] (777s left) i915_drm_fdinfo (memory-info-idle)
[243.100482] Starting subtest: memory-info-idle
[243.103450] Starting dynamic subtest: smem0
[243.144227] Dynamic subtest smem0: SUCCESS (0.046s)
[243.146880] Subtest memory-info-idle: SUCCESS (0.047s)
[243.218698] [068/155] (777s left) sw_sync (timeline_closed)
[243.262152] Starting subtest: timeline_closed
[243.264219] Subtest timeline_closed: SUCCESS (0.000s)
[243.318595] [069/155] (777s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[243.421489] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[243.425857] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[243.525159] [070/155] (777s left) perf (gen12-unprivileged-single-ctx-counters)
[243.662538] Starting subtest: gen12-unprivileged-single-ctx-counters
[243.664914] Starting dynamic subtest: rcs0
[243.732609] Dynamic subtest rcs0: SUCCESS (0.072s)
[243.735072] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.073s)
[243.784256] [071/155] (777s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[243.911634] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[243.916068] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[244.027079] [072/155] (776s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-blt)
[244.128763] Starting subtest: fbcpsrhdr-rgb101010-draw-blt
[244.132175] Subtest fbcpsrhdr-rgb101010-draw-blt: SKIP (0.000s)
[244.231070] [073/155] (776s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[244.326129] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[244.329751] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[244.427424] [074/155] (776s left) i915_drm_fdinfo (virtual-busy-idle-all)
[244.465929] Starting subtest: virtual-busy-idle-all
[244.469773] Subtest virtual-busy-idle-all: SKIP (0.000s)
[244.542749] [075/155] (776s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[244.650865] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[244.654670] Starting dynamic subtest: pipe-A-eDP-1
[244.806251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[244.817257] Starting dynamic subtest: pipe-B-eDP-1
[244.833669] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[244.842729] Starting dynamic subtest: pipe-C-eDP-1
[244.859970] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.015s)
[244.868926] Starting dynamic subtest: pipe-D-eDP-1
[244.886383] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[244.888235] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.191s)
[247.110398] [076/155] (774s left) gem_mmap_gtt (medium-copy)
[247.166496] Subtest medium-copy: SKIP (0.000s)
[247.232289] [077/155] (773s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[247.324598] Starting subtest: fbcpsrhdr-slowdraw
[247.328658] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[247.429899] [078/155] (773s left) kms_big_fb (linear-16bpp-rotate-90)
[247.534594] Starting subtest: linear-16bpp-rotate-90
[247.553465] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[247.670352] [079/155] (773s left) gem_exec_reloc (basic-write-read-noreloc)
[247.728570] Subtest basic-write-read-noreloc: SKIP (0.000s)
[247.812496] [080/155] (773s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt)
[247.909238] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt
[247.913417] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[248.008160] [081/155] (773s left) kms_plane_scaling (planes-downscale-factor-0-5)
[248.109577] Starting subtest: planes-downscale-factor-0-5
[248.111698] Starting dynamic subtest: pipe-A
[248.130678] Dynamic subtest pipe-A: SKIP (0.018s)
[248.140353] Starting dynamic subtest: pipe-B
[248.160596] Dynamic subtest pipe-B: SKIP (0.030s)
[248.169421] Starting dynamic subtest: pipe-C
[248.191846] Dynamic subtest pipe-C: SKIP (0.030s)
[248.200598] Starting dynamic subtest: pipe-D
[248.222914] Dynamic subtest pipe-D: SKIP (0.031s)
[248.226802] Subtest planes-downscale-factor-0-5: SKIP (0.112s)
[248.327687] [082/155] (773s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[248.413894] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[248.417447] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[248.517776] [083/155] (772s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[248.562100] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[248.564097] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[248.652036] [084/155] (772s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[248.746847] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[248.750300] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[248.849760] [085/155] (772s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[248.937669] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[248.941199] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[249.006864] [086/155] (772s left) prime_mmap_kms (buffer-sharing)
[249.095318] Starting subtest: buffer-sharing
[249.544065] Subtest buffer-sharing: SUCCESS (0.446s)
[250.443439] [087/155] (771s left) api_intel_allocator (standalone)
[250.501241] Starting subtest: standalone
[250.516136] Subtest standalone: SUCCESS (0.018s)
[250.641767] [088/155] (771s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[250.736265] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[250.740137] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[250.838590] [089/155] (770s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[250.943050] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[250.947440] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[251.039659] [090/155] (770s left) gem_exec_create (legacy)
[251.093415] Starting subtest: legacy
[251.095795] Starting dynamic subtest: smem
[254.273674] Dynamic subtest smem: SUCCESS (3.178s)
[254.276641] Subtest legacy: SUCCESS (3.180s)
[254.458586] [091/155] (767s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[254.565094] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt
[254.569110] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[254.664200] [092/155] (767s left) core_getversion (basic)
[254.698763] Starting subtest: basic
[254.702754] Subtest basic: SUCCESS (0.000s)
[254.762773] [093/155] (767s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[254.864861] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[262.273638] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.413s)
[262.411950] [094/155] (759s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[262.516414] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[262.520712] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[262.607639] [095/155] (759s left) perf (buffer-fill)
[262.708991] Starting subtest: buffer-fill
[262.711656] Starting dynamic subtest: 0-rcs0
[264.954594] Dynamic subtest 0-rcs0: SUCCESS (2.244s)
[264.964775] Starting dynamic subtest: 1-vecs0
[269.404078] Dynamic subtest 1-vecs0: SUCCESS (4.448s)
[269.406628] Subtest buffer-fill: SUCCESS (6.694s)
[269.453603] [096/155] (752s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[269.555562] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[269.560038] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[269.666637] [097/155] (752s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[269.768306] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[269.772237] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[269.860692] [098/155] (752s left) sysfs_preempt_timeout (invalid)
[269.918777] Starting subtest: invalid
[269.921506] Starting dynamic subtest: vecs0
[269.923888] Dynamic subtest vecs0: SUCCESS (0.000s)
[269.934298] Starting dynamic subtest: ccs0
[269.936186] Dynamic subtest ccs0: SUCCESS (0.000s)
[269.944951] Starting dynamic subtest: vcs0
[269.946980] Dynamic subtest vcs0: SUCCESS (0.000s)
[269.955642] Starting dynamic subtest: bcs0
[269.957546] Dynamic subtest bcs0: SUCCESS (0.000s)
[269.968798] Starting dynamic subtest: rcs0
[269.971103] Dynamic subtest rcs0: SUCCESS (0.000s)
[269.980407] Starting dynamic subtest: vcs1
[269.982311] Dynamic subtest vcs1: SUCCESS (0.000s)
[269.984222] Subtest invalid: SUCCESS (0.006s)
[270.022751] [099/155] (752s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt)
[270.120147] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt
[270.124521] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[270.233591] [100/155] (751s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[270.326992] Starting subtest: disable-crc-after-crtc
[270.329321] Starting dynamic subtest: pipe-A-eDP-1
[271.994227] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.665s)
[272.004376] Starting dynamic subtest: pipe-B-eDP-1
[274.375363] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.381s)
[274.384687] Starting dynamic subtest: pipe-C-eDP-1
[276.608357] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.232s)
[276.619770] Starting dynamic subtest: pipe-D-eDP-1
[278.881463] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.271s)
[278.883733] Subtest disable-crc-after-crtc: SUCCESS (8.556s)
[279.714178] [101/155] (742s left) kms_busy (extended-pageflip-hang-newfb)
[279.814265] Starting subtest: extended-pageflip-hang-newfb
[279.816717] Starting dynamic subtest: pipe-A
[306.146814] Dynamic subtest pipe-A: SUCCESS (26.330s)
[306.159364] Starting dynamic subtest: pipe-D
[331.095380] Dynamic subtest pipe-D: SUCCESS (24.947s)
[331.097695] Subtest extended-pageflip-hang-newfb: SUCCESS (51.282s)
[331.975535] [102/155] (690s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[332.023635] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[332.026091] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[332.113755] [103/155] (690s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[332.208887] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[332.212976] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[332.325459] [104/155] (689s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[332.415582] Starting subtest: bo-too-small-due-to-tiling
[332.419799] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[332.521423] [105/155] (689s left) gem_mmap_gtt (basic-wc)
[332.570585] Subtest basic-wc: SKIP (0.000s)
[332.628237] [106/155] (689s left) gem_softpin (evict-single-offset)
[332.688669] Starting subtest: evict-single-offset
[357.313445] Subtest evict-single-offset: SUCCESS (24.621s)
[357.403468] [107/155] (665s left) gem_mmap_offset (oob-read)
[357.497780] Starting subtest: oob-read
[357.500093] Subtest oob-read: SUCCESS (0.000s)
[357.604714] [108/155] (664s left) gem_ringfill (engines-basic)
[363.270889] Starting subtest: engines-basic
[363.273635] Starting dynamic subtest: rcs0
[363.339194] Dynamic subtest rcs0: SUCCESS (0.068s)
[363.351950] Starting dynamic subtest: bcs0
[363.385318] Dynamic subtest bcs0: SUCCESS (0.045s)
[363.396295] Starting dynamic subtest: vcs0
[363.429802] Dynamic subtest vcs0: SUCCESS (0.043s)
[363.439685] Starting dynamic subtest: vcs1
[363.474849] Dynamic subtest vcs1: SUCCESS (0.043s)
[363.486710] Starting dynamic subtest: vecs0
[363.518464] Dynamic subtest vecs0: SUCCESS (0.042s)
[363.529096] Starting dynamic subtest: ccs0
[363.565072] Dynamic subtest ccs0: SUCCESS (0.045s)
[363.567491] Subtest engines-basic: SUCCESS (0.298s)
[363.643485] [109/155] (658s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[363.769142] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[363.774055] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[363.877123] [110/155] (658s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[363.984071] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[371.018203] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.040s)
[371.118353] [111/155] (651s left) kms_psr (psr2-dpms)
[371.210959] Starting subtest: psr2-dpms
[371.213741] Starting dynamic subtest: eDP-1
[374.209252] Dynamic subtest eDP-1: SUCCESS (3.001s)
[374.211567] Subtest psr2-dpms: SUCCESS (3.002s)
[375.083548] [112/155] (647s left) perf (polling)
[375.200193] Starting subtest: polling
[375.202558] Starting dynamic subtest: 0-rcs0
[385.210338] Dynamic subtest 0-rcs0: SUCCESS (10.007s)
[385.220577] Starting dynamic subtest: 1-vcs0
[395.234130] Dynamic subtest 1-vcs0: SUCCESS (10.022s)
[395.236925] Subtest polling: SUCCESS (20.032s)
[395.282260] [113/155] (627s left) gem_exec_schedule (fairslice)
[395.363805] Starting subtest: fairslice
[395.365807] Starting dynamic subtest: rcs0
[397.393216] Dynamic subtest rcs0: SUCCESS (2.034s)
[397.402164] Starting dynamic subtest: bcs0
[399.419390] Dynamic subtest bcs0: SUCCESS (2.027s)
[399.429381] Starting dynamic subtest: vcs0
[401.438734] Dynamic subtest vcs0: SUCCESS (2.018s)
[401.447676] Starting dynamic subtest: vcs1
[403.464101] Dynamic subtest vcs1: SUCCESS (2.025s)
[403.472962] Starting dynamic subtest: vecs0
[405.489025] Dynamic subtest vecs0: SUCCESS (2.022s)
[405.500101] Starting dynamic subtest: ccs0
[407.514363] Dynamic subtest ccs0: SUCCESS (2.027s)
[407.516273] Subtest fairslice: SUCCESS (12.159s)
[407.817277] [114/155] (614s left) fbdev (info)
[407.855192] Starting subtest: info
[407.857182] Subtest info: SUCCESS (0.000s)
[407.913213] [115/155] (614s left) kms_frontbuffer_tracking (psr-1p-rte)
[408.016732] Starting subtest: psr-1p-rte
[413.385871] Subtest psr-1p-rte: SUCCESS (5.375s)
[413.507110] [116/155] (609s left) kms_cursor_edge_walk (256x256-left-edge)
[413.612987] Starting subtest: 256x256-left-edge
[413.615222] Starting dynamic subtest: pipe-A-eDP-1
[417.064021] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.450s)
[417.074144] Starting dynamic subtest: pipe-D-eDP-1
[420.200863] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[420.203237] Subtest 256x256-left-edge: SUCCESS (6.588s)
[421.009999] [117/155] (601s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu)
[421.118504] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu
[421.122739] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[421.227133] [118/155] (601s left) perf_pmu (init-wait)
[421.274852] Starting subtest: init-wait
[421.277277] Starting dynamic subtest: rcs0
[421.279490] Dynamic subtest rcs0: SUCCESS (0.002s)
[421.289861] Starting dynamic subtest: bcs0
[421.291979] Dynamic subtest bcs0: SUCCESS (0.001s)
[421.302701] Starting dynamic subtest: vcs0
[421.305061] Dynamic subtest vcs0: SUCCESS (0.001s)
[421.314585] Starting dynamic subtest: vcs1
[421.316730] Dynamic subtest vcs1: SUCCESS (0.001s)
[421.325717] Starting dynamic subtest: vecs0
[421.327885] Dynamic subtest vecs0: SUCCESS (0.001s)
[421.336831] Starting dynamic subtest: ccs0
[421.339200] Dynamic subtest ccs0: SUCCESS (0.001s)
[421.341447] Subtest init-wait: SUCCESS (0.009s)
[421.396446] [119/155] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[421.498776] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[421.502849] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[421.592282] [120/155] (601s left) template (a)
[421.654616] Starting subtest: A
[421.657060] Subtest A: SUCCESS (0.000s)
[421.767596] [121/155] (601s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[421.866351] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[421.870217] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[421.968953] [122/155] (601s left) gem_userptr_blits (unsync-unmap)
[422.038642] Subtest unsync-unmap: SKIP (0.000s)
[422.183021] [123/155] (600s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[422.280322] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[422.283777] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[422.374225] [124/155] (600s left) gem_ccs (suspend-resume)
[422.433995] Starting subtest: suspend-resume
[422.437908] Subtest suspend-resume: SKIP (0.000s)
[422.536449] [125/155] (600s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[422.705486] Starting subtest: cursor-rapid-movement-64x64
[422.710320] Starting dynamic subtest: pipe-A-eDP-1
[423.258745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[423.286469] Starting dynamic subtest: pipe-D-eDP-1
[424.523271] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[424.525991] Subtest cursor-rapid-movement-64x64: SUCCESS (1.819s)
[425.370742] [126/155] (597s left) gem_exec_reloc (basic-gtt-cpu)
[425.425863] Subtest basic-gtt-cpu: SKIP (0.000s)
[425.509626] [127/155] (597s left) kms_pm_rpm (modeset-non-lpsp-stress)
[427.453391] Starting subtest: modeset-non-lpsp-stress
[428.627951] Subtest modeset-non-lpsp-stress: SKIP (1.172s)
[429.023712] [128/155] (594s left) gem_exec_reloc (basic-gtt-active)
[429.087724] Subtest basic-gtt-active: SKIP (0.000s)
[429.168750] [129/155] (594s left) gem_exec_whisper (basic-forked)
[429.236672] Starting subtest: basic-forked
[437.332163] Subtest basic-forked: SUCCESS (8.093s)
[437.533783] [130/155] (585s left) syncobj_timeline (wait-all-delayed-signal)
[437.583834] Starting subtest: wait-all-delayed-signal
[437.688670] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[437.767859] [131/155] (585s left) kms_cursor_crc (cursor-onscreen-64x64)
[437.948235] Starting subtest: cursor-onscreen-64x64
[437.954397] Starting dynamic subtest: pipe-A-eDP-1
[440.069381] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.115s)
[440.096966] Starting dynamic subtest: pipe-D-eDP-1
[442.901663] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.813s)
[442.904076] Subtest cursor-onscreen-64x64: SUCCESS (4.953s)
[443.777143] [132/155] (579s left) i915_pm_rps (waitboost)
[443.836504] Starting subtest: waitboost
[449.923176] Subtest waitboost: SUCCESS (6.086s)
[450.047054] [133/155] (573s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[450.162452] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[450.164882] Starting dynamic subtest: pipe-A-eDP-1
[450.257437] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[450.274676] Starting dynamic subtest: pipe-B-eDP-1
[451.460706] Dynamic subtest pipe-B-eDP-1: SKIP (1.198s)
[451.464965] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.301s)
[452.641541] [134/155] (570s left) kms_content_protection (uevent-hdcp14)
[452.784464] Starting subtest: uevent-hdcp14
[452.789077] Subtest uevent-hdcp14: SKIP (0.000s)
[452.919016] [135/155] (570s left) kms_chamelium_frames (hdmi-crc-multiple)
[453.314850] Subtest hdmi-crc-multiple: SKIP (0.000s)
[454.159881] [136/155] (569s left) gem_pxp (reject-modify-context-protection-off-2)
[454.283125] Starting subtest: reject-modify-context-protection-off-2
[454.286092] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[454.390892] [137/155] (569s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[454.482115] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[454.496369] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.013s)
[454.620309] [138/155] (569s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[454.719138] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[454.721625] Starting dynamic subtest: pipe-A-eDP-1
[454.991258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.243s)
[455.002072] Starting dynamic subtest: pipe-B-eDP-1
[456.262411] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s)
[456.273785] Starting dynamic subtest: pipe-C-eDP-1
[457.543919] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.284s)
[457.555112] Starting dynamic subtest: pipe-D-eDP-1
[458.802701] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[458.804656] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.053s)
[460.011172] [139/155] (563s left) syncobj_timeline (multi-wait-all-available-signaled)
[460.064680] Starting subtest: multi-wait-all-available-signaled
[460.066864] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[460.160417] [140/155] (563s left) i915_pm_rc6_residency (rc6-accuracy)
[460.221030] Starting subtest: rc6-accuracy
[460.223489] Starting dynamic subtest: gt0
[463.391846] Dynamic subtest gt0: SUCCESS (3.169s)
[463.404081] Starting dynamic subtest: gt1
[466.564933] Dynamic subtest gt1: SUCCESS (3.169s)
[466.567514] Subtest rc6-accuracy: SUCCESS (6.345s)
[466.639168] [141/155] (557s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[466.776720] Starting subtest: cursorA-vs-flipA-atomic
[477.904411] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.128s)
[478.747465] [142/155] (545s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[478.857525] Starting subtest: fbc-rgb565-draw-blt
[483.042610] Subtest fbc-rgb565-draw-blt: SUCCESS (4.191s)
[484.238609] [143/155] (539s left) kms_atomic_transition (plane-all-transition)
[484.329857] Starting subtest: plane-all-transition
[484.332302] Starting dynamic subtest: pipe-A-eDP-1
[486.822273] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[487.130037] Starting dynamic subtest: pipe-B-eDP-1
[490.363918] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.244s)
[490.661210] Subtest plane-all-transition: SUCCESS (6.333s)
[491.491788] [144/155] (532s left) gem_exec_reloc (basic-wc)
[491.555819] Subtest basic-wc: SKIP (0.000s)
[491.636855] [145/155] (532s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[491.736040] Starting subtest: fbc-psr2-cursor-plane-onoff
[491.738215] Starting dynamic subtest: eDP-1
[491.742134] Dynamic subtest eDP-1: SKIP (0.000s)
[491.746122] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[491.825183] [146/155] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[491.917729] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[498.498746] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.584s)
[498.660220] [147/155] (525s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[498.754355] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[498.756762] Starting dynamic subtest: pipe-A-eDP-1
[498.779664] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[498.792099] Starting dynamic subtest: pipe-B-eDP-1
[498.813864] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[498.822968] Starting dynamic subtest: pipe-C-eDP-1
[498.844302] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[498.853448] Starting dynamic subtest: pipe-D-eDP-1
[498.875321] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[498.879696] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[501.066344] [148/155] (523s left) kms_color_pipeline (plane-lut1d-lut1d)
[501.169339] Starting subtest: plane-lut1d-lut1d
[501.329099] Starting dynamic subtest: pipe-A-plane-0
[501.484102] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[501.495990] Starting dynamic subtest: pipe-A-plane-1
[501.617386] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[501.628186] Starting dynamic subtest: pipe-A-plane-2
[501.807819] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[502.963168] Starting dynamic subtest: pipe-B-plane-0
[503.143948] Dynamic subtest pipe-B-plane-0: SUCCESS (0.188s)
[503.154397] Starting dynamic subtest: pipe-B-plane-1
[503.301209] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[503.312626] Starting dynamic subtest: pipe-B-plane-2
[503.476324] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[504.693384] Starting dynamic subtest: pipe-C-plane-0
[504.840682] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[504.850830] Starting dynamic subtest: pipe-C-plane-1
[504.996445] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[505.006488] Starting dynamic subtest: pipe-C-plane-2
[505.140539] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[506.354931] Starting dynamic subtest: pipe-D-plane-0
[506.478988] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[506.489806] Starting dynamic subtest: pipe-D-plane-1
[506.624116] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[506.635738] Starting dynamic subtest: pipe-D-plane-2
[506.791111] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[507.088828] Subtest plane-lut1d-lut1d: SUCCESS (5.920s)
[507.910085] [149/155] (516s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[508.002349] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[508.004664] Starting dynamic subtest: A-eDP1
[511.648545] Dynamic subtest A-eDP1: SUCCESS (3.645s)
[511.659930] Starting dynamic subtest: B-eDP1
[514.963782] Dynamic subtest B-eDP1: SUCCESS (3.311s)
[514.974384] Starting dynamic subtest: C-eDP1
[518.184664] Dynamic subtest C-eDP1: SUCCESS (3.221s)
[518.195855] Starting dynamic subtest: D-eDP1
[521.410937] Dynamic subtest D-eDP1: SUCCESS (3.225s)
[521.413310] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.409s)
[522.224196] [150/155] (502s left) kms_dp_link_training (uhbr-sst)
[522.317382] Starting subtest: uhbr-sst
[522.325774] Subtest uhbr-sst: SKIP (0.000s)
[522.401950] [151/155] (501s left) kms_cdclk (plane-scaling)
[522.490575] Starting subtest: plane-scaling
[522.492982] Starting dynamic subtest: pipe-A-eDP-1
[522.779778] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[522.793550] Starting dynamic subtest: pipe-B-eDP-1
[522.798246] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[522.807873] Starting dynamic subtest: pipe-C-eDP-1
[522.812877] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[522.823248] Starting dynamic subtest: pipe-D-eDP-1
[522.827855] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[522.832291] Subtest plane-scaling: SKIP (0.295s)
[523.650621] [152/155] (500s left) gem_ctx_shared (q-out-order)
[523.714389] Starting subtest: Q-out-order
[523.716694] Starting dynamic subtest: rcs0
[523.820617] Dynamic subtest rcs0: SUCCESS (0.105s)
[523.833751] Starting dynamic subtest: vcs0
[523.919664] Dynamic subtest vcs0: SUCCESS (0.098s)
[523.937439] Starting dynamic subtest: vcs1
[524.006055] Dynamic subtest vcs1: SUCCESS (0.085s)
[524.023991] Starting dynamic subtest: vecs0
[524.090898] Dynamic subtest vecs0: SUCCESS (0.082s)
[524.108073] Starting dynamic subtest: ccs0
[524.182683] Dynamic subtest ccs0: SUCCESS (0.090s)
[524.185576] Subtest Q-out-order: SUCCESS (0.468s)
[525.407442] [153/155] (498s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[525.512789] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[530.609180] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.101s)
[530.725255] [154/155] (493s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[530.828253] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[535.308785] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.487s)
[536.517411] [155/155] (487s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[536.609578] Starting subtest: pr-overlay-plane-update-continuous-sf
[536.613637] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[536.678263] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_atomic_interruptible
results: parsing output: 12/ for test: kms_feature_discovery
results: parsing output: 13/ for test: kms_vblank
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: kms_async_flips
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: kms_plane_multiple
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_pread
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_invalid_mode
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_getfb
results: parsing output: 37/ for test: gem_exec_gttfill
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_plane_alpha_blend
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr2_su
results: parsing output: 46/ for test: gem_madvise
results: parsing output: 47/ for test: kms_force_connector_basic
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: prime_vgem
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: gem_unref_active_buffers
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_scaling_modes
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_chamelium_hpd
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: i915_drm_fdinfo
results: parsing output: 67/ for test: sw_sync
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_drm_fdinfo
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: prime_mmap_kms
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_create
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: core_getversion
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: sysfs_preempt_timeout
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_pipe_crc_basic
results: parsing output: 100/ for test: kms_busy
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: gem_softpin
results: parsing output: 106/ for test: gem_mmap_offset
results: parsing output: 107/ for test: gem_ringfill
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: fbdev
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_cursor_edge_walk
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: template
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_ccs
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: i915_pm_rps
results: parsing output: 132/ for test: kms_psr2_sf
results: parsing output: 133/ for test: kms_content_protection
results: parsing output: 134/ for test: kms_chamelium_frames
results: parsing output: 135/ for test: gem_pxp
results: parsing output: 136/ for test: kms_flip
results: parsing output: 137/ for test: kms_ccs
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: i915_pm_rc6_residency
results: parsing output: 140/ for test: kms_cursor_legacy
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_atomic_transition
results: parsing output: 143/ for test: gem_exec_reloc
results: parsing output: 144/ for test: kms_psr
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_ccs
results: parsing output: 147/ for test: kms_color_pipeline
results: parsing output: 148/ for test: kms_flip
results: parsing output: 149/ for test: kms_dp_link_training
results: parsing output: 150/ for test: kms_cdclk
results: parsing output: 151/ for test: gem_ctx_shared
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_psr2_sf
Done.