[56.789338] Initializing watchdogs
[56.789386]   /dev/watchdog0
[56.803941] [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]
[56.808297] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.810496] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.813762] [001/155] (960s left) i915_module_load (resize-bar)
[56.868030] Starting subtest: resize-bar
[56.878065] Subtest resize-bar: SKIP (0.011s)
[56.919540] [002/155] (960s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[56.982102] Starting subtest: legacy-engines-hostile-preempt
[56.984306] Starting dynamic subtest: render
[57.060678] Dynamic subtest render: SUCCESS (0.082s)
[57.071748] Starting dynamic subtest: bsd1
[58.303336] Dynamic subtest bsd1: SUCCESS (1.264s)
[58.312046] Starting dynamic subtest: bsd2
[60.340121] Dynamic subtest bsd2: SUCCESS (2.014s)
[60.349978] Starting dynamic subtest: blt
[60.352335] Dynamic subtest blt: SUCCESS (0.064s)
[60.359094] Starting dynamic subtest: vebox
[62.265308] Dynamic subtest vebox: SUCCESS (1.935s)
[62.267957] Subtest legacy-engines-hostile-preempt: SUCCESS (5.367s)
[62.341316] [003/155] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[62.452088] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[62.456266] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[62.551027] [004/155] (954s left) i915_suspend (forcewake)
[62.604695] Starting subtest: forcewake
[94.992690] Subtest forcewake: SUCCESS (2.408s)
[95.091579] [005/155] (922s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[95.191855] Starting subtest: 4-tiled-64bpp-rotate-270
[95.224784] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.033s)
[95.343346] [006/155] (922s left) kms_cursor_crc (cursor-sliding-512x170)
[95.621744] Starting subtest: cursor-sliding-512x170
[95.627341] Subtest cursor-sliding-512x170: SKIP (0.001s)
[95.758943] [007/155] (921s left) kms_psr (psr2-primary-page-flip)
[95.854875] Starting subtest: psr2-primary-page-flip
[95.857126] Starting dynamic subtest: eDP-1
[97.811851] Dynamic subtest eDP-1: SUCCESS (2.020s)
[97.813958] Subtest psr2-primary-page-flip: SUCCESS (2.021s)
[98.651963] [008/155] (918s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[98.751167] Starting subtest: plane-lut1d-post-ctm3x4
[98.891474] Starting dynamic subtest: pipe-A-plane-0
[99.053382] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[99.062161] Starting dynamic subtest: pipe-A-plane-1
[99.186701] Dynamic subtest pipe-A-plane-1: SUCCESS (0.134s)
[99.194997] Starting dynamic subtest: pipe-A-plane-2
[99.324875] Dynamic subtest pipe-A-plane-2: SUCCESS (0.141s)
[100.550758] Starting dynamic subtest: pipe-B-plane-0
[100.684737] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[100.694461] Starting dynamic subtest: pipe-B-plane-1
[100.815674] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[100.824245] Starting dynamic subtest: pipe-B-plane-2
[100.947392] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[102.112191] Starting dynamic subtest: pipe-C-plane-0
[102.247963] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[102.257739] Starting dynamic subtest: pipe-C-plane-1
[102.390320] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[102.402618] Starting dynamic subtest: pipe-C-plane-2
[102.557504] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[103.741456] Starting dynamic subtest: pipe-D-plane-0
[103.864622] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[103.873851] Starting dynamic subtest: pipe-D-plane-1
[104.007581] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[104.016968] Starting dynamic subtest: pipe-D-plane-2
[104.150288] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[104.439342] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.791s)
[105.273592] [009/155] (912s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[105.333146] Starting subtest: single-wait-for-submit-available-signaled
[105.335408] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[105.453365] [010/155] (912s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[105.545891] Starting subtest: psrhdr-rgb565-draw-render
[105.550034] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[105.636313] [011/155] (912s left) kms_cursor_crc (cursor-onscreen-512x512)
[105.905188] Starting subtest: cursor-onscreen-512x512
[105.909335] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[106.047029] [012/155] (911s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[106.170299] Starting subtest: short-flip-after-cursor-atomic-transitions
[107.150660] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.990s)
[107.989333] [013/155] (909s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[108.083909] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[108.088382] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[108.202927] [014/155] (909s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff)
[108.303152] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff
[108.308602] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[108.404945] [015/155] (909s left) gem_lmem_evict (dontneed-evict-race)
[108.443973] Subtest dontneed-evict-race: SKIP (0.000s)
[108.481382] [016/155] (909s left) kms_pm_dc (dc5-dpms-negative)
[109.575325] Starting subtest: dc5-dpms-negative
[109.579872] Subtest dc5-dpms-negative: SKIP (0.000s)
[109.644580] [017/155] (908s left) gem_exec_whisper (basic-fds-forked-all)
[109.701268] Starting subtest: basic-fds-forked-all
[129.563650] Subtest basic-fds-forked-all: SUCCESS (19.905s)
[129.757086] [018/155] (888s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[129.880131] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[129.884344] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[129.946319] [019/155] (888s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[130.046881] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[130.050896] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[130.142769] [020/155] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[130.252983] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[130.257221] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[130.351036] [021/155] (887s left) kms_big_fb (x-tiled-addfb-size-overflow)
[130.441095] Starting subtest: x-tiled-addfb-size-overflow
[130.443345] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[130.519825] [022/155] (887s left) perf (i915-ref-count)
[130.588091] Starting subtest: i915-ref-count
[130.653332] Subtest i915-ref-count: SUCCESS (0.063s)
[130.712008] [023/155] (887s left) gem_mmap_gtt (big-bo)
[130.763552] Subtest big-bo: SKIP (0.000s)
[130.816155] [024/155] (887s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[130.908296] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[130.910179] Starting dynamic subtest: pipe-A-eDP-1
[130.929940] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[130.940895] Starting dynamic subtest: pipe-B-eDP-1
[130.958670] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[130.967321] Starting dynamic subtest: pipe-C-eDP-1
[130.985104] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[130.995256] Starting dynamic subtest: pipe-D-eDP-1
[131.013630] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[131.017185] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[133.180569] [025/155] (885s left) gem_softpin (allocator-nopin)
[133.239727] Starting subtest: allocator-nopin
[133.332088] Subtest allocator-nopin: SUCCESS (0.093s)
[133.473953] [026/155] (884s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[133.567497] Starting subtest: bad-aux-stride-y-tiled-ccs
[133.569753] Starting dynamic subtest: pipe-A-eDP-1
[133.593437] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[133.602346] Starting dynamic subtest: pipe-B-eDP-1
[133.623398] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[133.632040] Starting dynamic subtest: pipe-C-eDP-1
[133.653124] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[133.662191] Starting dynamic subtest: pipe-D-eDP-1
[133.684688] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[133.689319] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s)
[135.846516] [027/155] (882s left) kms_content_protection (dp-mst-lic-type-1)
[135.983230] Starting subtest: dp-mst-lic-type-1
[135.987974] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[136.122222] [028/155] (882s left) gem_ctx_shared (q-promotion)
[136.183319] Starting subtest: Q-promotion
[136.185755] Starting dynamic subtest: rcs0
[136.397400] Dynamic subtest rcs0: SUCCESS (0.216s)
[136.413474] Starting dynamic subtest: vcs0
[136.483287] Dynamic subtest vcs0: SUCCESS (0.087s)
[136.499295] Starting dynamic subtest: vcs1
[136.559817] Dynamic subtest vcs1: SUCCESS (0.076s)
[136.575047] Starting dynamic subtest: vecs0
[136.633070] Dynamic subtest vecs0: SUCCESS (0.073s)
[136.649665] Starting dynamic subtest: ccs0
[136.721640] Dynamic subtest ccs0: SUCCESS (0.087s)
[136.724027] Subtest Q-promotion: SUCCESS (0.542s)
[138.357607] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[138.360708] [029/155] (880s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[138.473634] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[138.477649] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[138.564302] [030/155] (879s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[138.656736] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[138.661091] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[138.774191] [031/155] (879s left) gem_busy (semaphore)
[138.956962] Subtest semaphore: SKIP (0.000s)
[139.182858] [032/155] (879s left) api_intel_bb (blit-noreloc-keep-cache)
[139.239249] Starting subtest: blit-noreloc-keep-cache
[139.245919] Subtest blit-noreloc-keep-cache: SUCCESS (0.009s)
[139.373694] [033/155] (879s left) template (a)
[139.426300] Starting subtest: A
[139.428556] Subtest A: SUCCESS (0.000s)
[139.535241] [034/155] (879s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[139.631516] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[139.633864] Starting dynamic subtest: pipe-A
[140.815946] Dynamic subtest pipe-A: SUCCESS (1.187s)
[140.828371] Starting dynamic subtest: pipe-B
[143.105963] Dynamic subtest pipe-B: SUCCESS (2.289s)
[143.117275] Starting dynamic subtest: pipe-C
[144.346861] Dynamic subtest pipe-C: SUCCESS (1.241s)
[144.356659] Starting dynamic subtest: pipe-D
[145.593774] Dynamic subtest pipe-D: SUCCESS (1.247s)
[145.596149] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.968s)
[146.784081] [035/155] (871s left) kms_prime (d3hot)
[146.865485] Subtest D3hot: SKIP (0.000s)
[146.970478] [036/155] (871s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[147.072553] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[151.031044] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.967s)
[152.188199] [037/155] (866s left) api_intel_bb (simple-bb)
[152.250983] Starting subtest: simple-bb
[152.256663] Subtest simple-bb: SUCCESS (0.006s)
[152.390032] [038/155] (866s left) i915_query (query-topology-kernel-writes)
[152.445184] Starting subtest: query-topology-kernel-writes
[152.447347] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[152.532234] [039/155] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[152.632676] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[159.252896] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.630s)
[159.362773] [040/155] (859s left) kms_psr (fbc-pr-cursor-blt)
[159.463726] Starting subtest: fbc-pr-cursor-blt
[159.467845] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[159.555228] [041/155] (859s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[159.613807] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[159.720598] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[159.807891] [042/155] (859s left) gem_mmap_gtt (big-copy)
[159.856312] Subtest big-copy: SKIP (0.000s)
[159.911949] [043/155] (859s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[160.022935] Starting subtest: cursor-vs-flip-atomic-transitions
[190.324782] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.317s)
[191.139772] [044/155] (827s left) syncobj_wait (single-wait-for-submit-signaled)
[191.202874] Starting subtest: single-wait-for-submit-signaled
[191.205320] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[191.316801] [045/155] (827s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[191.415416] Starting subtest: fbc-psr-sprite-mmap-cpu
[191.417669] Starting dynamic subtest: eDP-1
[191.421741] Dynamic subtest eDP-1: SKIP (0.000s)
[191.425882] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[191.503035] [046/155] (827s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[191.613588] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[195.818286] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.211s)
[196.953229] [047/155] (822s left) gem_mmap_gtt (fault-concurrent)
[197.015357] Subtest fault-concurrent: SKIP (0.000s)
[197.073769] [048/155] (822s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[197.474144] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[198.265347] [049/155] (821s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[198.368329] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[198.372516] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[198.472862] [050/155] (820s left) gem_exec_fence (syncobj-invalid-flags)
[198.886452] Starting subtest: syncobj-invalid-flags
[198.888750] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[200.368087] [051/155] (818s left) kms_psr (psr2-cursor-plane-move)
[200.460377] Starting subtest: psr2-cursor-plane-move
[200.462760] Starting dynamic subtest: eDP-1
[202.172304] Dynamic subtest eDP-1: SUCCESS (1.712s)
[202.174562] Subtest psr2-cursor-plane-move: SUCCESS (1.713s)
[203.070165] [052/155] (816s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[203.169938] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[203.174010] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[203.264375] [053/155] (816s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[203.360439] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[203.364846] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[203.468552] [054/155] (816s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt)
[203.565008] Starting subtest: psrhdr-rgb565-draw-blt
[203.569410] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s)
[203.671382] [055/155] (815s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[203.776507] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[203.780871] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[203.883704] [056/155] (815s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[203.990715] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[204.001855] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[204.077090] [057/155] (815s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[204.178323] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[204.181779] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[204.275657] [058/155] (815s left) gem_exec_schedule (u-semaphore-codependency)
[204.346810] Starting subtest: u-semaphore-codependency
[204.355452] Subtest u-semaphore-codependency: SUCCESS (0.013s)
[204.688756] [059/155] (814s left) gem_mmap_gtt (medium-copy-odd)
[204.738243] Subtest medium-copy-odd: SKIP (0.000s)
[204.800736] [060/155] (814s left) kms_big_fb (linear-8bpp-rotate-180)
[204.904787] Starting subtest: linear-8bpp-rotate-180
[206.162836] Subtest linear-8bpp-rotate-180: SUCCESS (1.258s)
[206.287970] [061/155] (813s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[206.384732] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[206.386588] Starting dynamic subtest: pipe-A-eDP-1
[206.408246] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[206.419969] Starting dynamic subtest: pipe-B-eDP-1
[206.439544] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[206.448762] Starting dynamic subtest: pipe-C-eDP-1
[206.467871] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[206.478671] Starting dynamic subtest: pipe-D-eDP-1
[206.499313] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[206.503022] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[208.631872] [062/155] (811s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[208.736655] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[208.739024] Starting dynamic subtest: A-eDP1
[212.373762] Dynamic subtest A-eDP1: SUCCESS (3.633s)
[212.383660] Starting dynamic subtest: B-eDP1
[215.690880] Dynamic subtest B-eDP1: SUCCESS (3.316s)
[215.701707] Starting dynamic subtest: C-eDP1
[218.888288] Dynamic subtest C-eDP1: SUCCESS (3.198s)
[218.900887] Starting dynamic subtest: D-eDP1
[222.092882] Dynamic subtest D-eDP1: SUCCESS (3.202s)
[222.095251] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.356s)
[222.902058] [063/155] (796s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[222.963868] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[223.028150] [064/155] (796s left) perf_pmu (init-sema)
[223.073059] Starting subtest: init-sema
[223.075333] Starting dynamic subtest: rcs0
[223.077642] Dynamic subtest rcs0: SUCCESS (0.002s)
[223.088457] Starting dynamic subtest: bcs0
[223.090380] Dynamic subtest bcs0: SUCCESS (0.000s)
[223.099353] Starting dynamic subtest: vcs0
[223.101128] Dynamic subtest vcs0: SUCCESS (0.001s)
[223.110169] Starting dynamic subtest: vcs1
[223.112119] Dynamic subtest vcs1: SUCCESS (0.000s)
[223.121009] Starting dynamic subtest: vecs0
[223.122909] Dynamic subtest vecs0: SUCCESS (0.001s)
[223.131757] Starting dynamic subtest: ccs0
[223.133691] Dynamic subtest ccs0: SUCCESS (0.000s)
[223.136003] Subtest init-sema: SUCCESS (0.008s)
[223.195621] [065/155] (796s left) gem_exec_balancer (semaphore)
[223.262584] Starting subtest: semaphore
[225.291190] Subtest semaphore: SUCCESS (2.027s)
[225.592338] [066/155] (794s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[225.688328] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[225.690594] Starting dynamic subtest: pipe-A-eDP-1
[225.750073] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[225.759747] Starting dynamic subtest: pipe-B-eDP-1
[225.817138] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[225.828348] Starting dynamic subtest: pipe-C-eDP-1
[225.886323] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[225.896215] Starting dynamic subtest: pipe-D-eDP-1
[225.949066] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[225.952944] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[227.955529] [067/155] (792s left) gem_pxp (create-regular-buffer)
[228.077841] Starting subtest: create-regular-buffer
[228.080259] Subtest create-regular-buffer: SUCCESS (0.000s)
[228.195884] [068/155] (791s left) gen3_mixed_blits
[228.304133] [069/155] (791s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[228.394546] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[228.396683] Starting dynamic subtest: pipe-A-eDP-1
[228.419134] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[228.429291] Starting dynamic subtest: pipe-B-eDP-1
[228.450465] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[228.460298] Starting dynamic subtest: pipe-C-eDP-1
[228.481908] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[228.491454] Starting dynamic subtest: pipe-D-eDP-1
[228.513390] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[228.517505] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[230.719920] [070/155] (789s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[230.828380] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[230.832486] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[230.906929] [071/155] (789s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[231.001590] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[231.005666] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[231.099593] [072/155] (789s left) gem_eio (in-flight-internal-10ms)
[231.320201] Starting subtest: in-flight-internal-10ms
[232.366712] Subtest in-flight-internal-10ms: SUCCESS (1.047s)
[232.503393] [073/155] (787s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt)
[232.595563] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt
[232.599709] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[232.721455] [074/155] (787s left) kms_chamelium_frames (hdmi-crc-single)
[233.111163] Subtest hdmi-crc-single: SKIP (0.000s)
[233.931684] [075/155] (786s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[233.988330] Starting subtest: invalid-signal-one-illegal-handle
[233.990319] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[234.070217] [076/155] (786s left) kms_vrr (seamless-rr-switch-drrs)
[234.162332] Starting subtest: seamless-rr-switch-drrs
[234.168747] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[234.233444] [077/155] (786s left) kms_plane_alpha_blend (constant-alpha-max)
[234.325486] Starting subtest: constant-alpha-max
[234.607254] Starting dynamic subtest: pipe-A-eDP-1
[235.592906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.983s)
[235.603322] Starting dynamic subtest: pipe-D-eDP-1
[237.177825] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.585s)
[237.180055] Subtest constant-alpha-max: SUCCESS (2.853s)
[238.044916] [078/155] (782s left) kms_sequence (get-idle)
[238.133813] Starting subtest: get-idle
[238.136143] Starting dynamic subtest: pipe-A-eDP-1
[239.931330] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.799s)
[239.942953] Starting dynamic subtest: pipe-B-eDP-1
[242.437755] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.505s)
[242.448651] Starting dynamic subtest: pipe-C-eDP-1
[244.951864] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.514s)
[244.966155] Starting dynamic subtest: pipe-D-eDP-1
[247.372184] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.418s)
[247.374852] Subtest get-idle: SUCCESS (9.241s)
[248.187528] [079/155] (772s left) perf (oa-exponents)
[248.269799] Starting subtest: oa-exponents
[248.272188] Starting dynamic subtest: 0-rcs0
[250.038314] Dynamic subtest 0-rcs0: SUCCESS (1.767s)
[250.049191] Starting dynamic subtest: 1-vcs0
[251.864354] Dynamic subtest 1-vcs0: SUCCESS (1.825s)
[251.867011] Subtest oa-exponents: SUCCESS (3.594s)
[251.914533] [080/155] (768s left) gem_userptr_blits (forbidden-operations)
[251.973816] Starting subtest: forbidden-operations
[251.978891] Subtest forbidden-operations: SKIP (0.000s)
[252.109593] [081/155] (768s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[252.205859] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[252.209957] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[252.273860] [082/155] (768s left) kms_scaling_modes (scaling-mode-full)
[252.360057] Starting subtest: scaling-mode-full
[252.362219] Starting dynamic subtest: pipe-A-eDP-1
[252.451862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[252.462832] Starting dynamic subtest: pipe-B-eDP-1
[253.615866] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s)
[253.627882] Starting dynamic subtest: pipe-C-eDP-1
[254.827867] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[254.839001] Starting dynamic subtest: pipe-D-eDP-1
[255.970477] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[255.972715] Subtest scaling-mode-full: SUCCESS (3.614s)
[257.135229] [083/155] (763s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[257.229537] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[257.233726] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[257.345990] [084/155] (763s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[257.447600] Starting subtest: invalid-modeset-force-ultra-joiner
[257.451619] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[257.517899] [085/155] (763s left) gem_mmap_gtt (bad-object)
[257.575963] Subtest bad-object: SKIP (0.000s)
[257.636089] [086/155] (763s left) gem_eio (in-flight-external)
[257.840409] Starting subtest: in-flight-external
[259.369787] Subtest in-flight-external: SUCCESS (1.529s)
[259.534525] [087/155] (761s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[259.631202] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[259.635639] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[259.736093] [088/155] (761s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[259.845598] Starting subtest: cursorA-vs-flipB-legacy
[259.849986] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[260.003395] [089/155] (760s left) kms_pm_backlight (brightness-with-dpms)
[260.093607] Starting subtest: brightness-with-dpms
[260.144063] Starting dynamic subtest: eDP-1
[262.528780] Dynamic subtest eDP-1: SUCCESS (2.388s)
[262.531369] Subtest brightness-with-dpms: SUCCESS (2.437s)
[263.416813] [090/155] (757s left) syncobj_timeline (reset-signaled)
[263.470935] Starting subtest: reset-signaled
[263.473110] Subtest reset-signaled: SUCCESS (0.000s)
[263.560698] [091/155] (757s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[263.658107] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[263.662481] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[263.759899] [092/155] (757s left) gem_close_race (basic-threads)
[263.818727] Starting subtest: basic-threads
[265.179614] Subtest basic-threads: SUCCESS (1.360s)
[265.366408] [093/155] (755s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[265.463291] Starting subtest: fbcpsr-suspend
[306.515435] Subtest fbcpsr-suspend: SUCCESS (10.134s)
[306.670812] [094/155] (714s left) gen9_exec_parse (unaligned-jump)
[306.746933] Subtest unaligned-jump: SKIP (0.000s)
[306.809724] [095/155] (714s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[306.905009] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[316.216950] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.463s)
[316.345962] [096/155] (704s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[316.439608] Starting subtest: fbc-shrfb-scaledprimary
[319.292682] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.878s)
[320.524158] [097/155] (700s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[320.615748] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[320.641764] Starting dynamic subtest: pipe-A-plane-0
[320.929223] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[320.939715] Starting dynamic subtest: pipe-A-plane-3
[321.160916] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[322.282882] Starting dynamic subtest: pipe-B-plane-0
[322.568439] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[322.578917] Starting dynamic subtest: pipe-B-plane-3
[322.811714] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[323.119274] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.516s)
[323.945346] [098/155] (697s left) kms_rotation_crc (primary-rotation-270)
[324.051941] Starting subtest: primary-rotation-270
[324.056589] Subtest primary-rotation-270: SKIP (0.001s)
[324.124254] [099/155] (697s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt)
[324.230702] Starting subtest: hdr-farfromfence-mmap-gtt
[324.234807] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s)
[324.328030] [100/155] (697s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[324.432758] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[325.542255] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.112s)
[325.664737] [101/155] (695s left) core_setmaster (master-drop-set-user)
[325.767236] Starting subtest: master-drop-set-user
[325.780938] Subtest master-drop-set-user: SUCCESS (0.013s)
[325.822533] [102/155] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[325.917238] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[325.920750] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[326.021992] [103/155] (695s left) kms_flip (2x-plain-flip-interruptible)
[326.122552] Starting subtest: 2x-plain-flip-interruptible
[326.134225] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[326.211180] [104/155] (695s left) kms_addfb_basic (no-handle)
[326.269175] Starting subtest: no-handle
[326.271142] Subtest no-handle: SUCCESS (0.000s)
[326.434661] [105/155] (695s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[326.563782] Starting subtest: flip-vs-cursor-atomic
[334.091060] Subtest flip-vs-cursor-atomic: SUCCESS (7.537s)
[334.956195] [106/155] (686s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[335.047613] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[335.073238] Starting dynamic subtest: pipe-A-plane-0
[335.462534] Dynamic subtest pipe-A-plane-0: SUCCESS (0.389s)
[335.473291] Starting dynamic subtest: pipe-A-plane-3
[335.796016] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s)
[336.944159] Starting dynamic subtest: pipe-B-plane-0
[337.346561] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[337.358129] Starting dynamic subtest: pipe-B-plane-3
[337.669004] Dynamic subtest pipe-B-plane-3: SUCCESS (0.321s)
[337.979448] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (2.927s)
[338.845215] [107/155] (682s left) gem_create (create-massive)
[338.916287] Starting subtest: create-massive
[338.918328] Subtest create-massive: SUCCESS (0.000s)
[339.098665] [108/155] (682s left) gen9_exec_parse (bb-large)
[339.165430] Subtest bb-large: SKIP (0.000s)
[339.235941] [109/155] (682s left) gem_exec_capture (userptr)
[339.289667] Starting subtest: userptr
[340.124901] Subtest userptr: SUCCESS (0.836s)
[340.261062] [110/155] (681s left) kms_flip (basic-flip-vs-modeset)
[340.349962] Starting subtest: basic-flip-vs-modeset
[340.352249] Starting dynamic subtest: A-eDP1
[342.922779] Dynamic subtest A-eDP1: SUCCESS (2.572s)
[342.933338] Starting dynamic subtest: B-eDP1
[345.083579] Dynamic subtest B-eDP1: SUCCESS (2.156s)
[345.095065] Starting dynamic subtest: C-eDP1
[347.254690] Dynamic subtest C-eDP1: SUCCESS (2.172s)
[347.267443] Starting dynamic subtest: D-eDP1
[349.431276] Dynamic subtest D-eDP1: SUCCESS (2.171s)
[349.433509] Subtest basic-flip-vs-modeset: SUCCESS (9.077s)
[350.323338] [111/155] (671s left) prime_self_import (basic-llseek-bad)
[350.370282] Starting subtest: basic-llseek-bad
[350.387139] Subtest basic-llseek-bad: SUCCESS (0.015s)
[350.485173] [112/155] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[350.593321] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[350.597740] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[350.696005] [113/155] (671s left) i915_pm_rpm (system-suspend-devices)
[352.529072] Starting subtest: system-suspend-devices
[362.424791] Subtest system-suspend-devices: SUCCESS (9.895s)
[363.211797] [114/155] (658s left) gem_mmap_wc (set-cache-level)
[363.266985] Subtest set-cache-level: SKIP (0.000s)
[363.324036] [115/155] (658s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[363.442814] Starting subtest: basic-flip-before-cursor-legacy
[364.361685] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.919s)
[365.241340] [116/155] (656s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[365.359903] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[366.786349] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.424s)
[367.612368] [117/155] (654s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[367.704428] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite
[367.708906] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[367.816208] [118/155] (654s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[367.875049] Subtest tiled-to-untiled: SKIP (0.000s)
[367.959515] [119/155] (654s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[368.062268] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[368.066400] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[368.172946] [120/155] (654s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[368.271519] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc
[368.275614] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[368.379724] [121/155] (653s left) kms_async_flips (invalid-async-flip)
[368.469686] Starting subtest: invalid-async-flip
[368.841166] Starting dynamic subtest: pipe-A-eDP-1
[369.705150] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.865s)
[370.082955] Starting dynamic subtest: pipe-B-eDP-1
[370.942347] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.875s)
[371.303632] Starting dynamic subtest: pipe-C-eDP-1
[372.081565] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.788s)
[372.454351] Starting dynamic subtest: pipe-D-eDP-1
[373.306302] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.864s)
[373.308446] Subtest invalid-async-flip: SUCCESS (4.839s)
[374.455411] [122/155] (647s left) sysfs_preempt_timeout (invalid)
[374.516145] Starting subtest: invalid
[374.518294] Starting dynamic subtest: vecs0
[374.520624] Dynamic subtest vecs0: SUCCESS (0.001s)
[374.530969] Starting dynamic subtest: ccs0
[374.532812] Dynamic subtest ccs0: SUCCESS (0.000s)
[374.542750] Starting dynamic subtest: vcs0
[374.544617] Dynamic subtest vcs0: SUCCESS (0.000s)
[374.558260] Starting dynamic subtest: bcs0
[374.560435] Dynamic subtest bcs0: SUCCESS (0.000s)
[374.578879] Starting dynamic subtest: rcs0
[374.581192] Dynamic subtest rcs0: SUCCESS (0.000s)
[374.591655] Starting dynamic subtest: vcs1
[374.593574] Dynamic subtest vcs1: SUCCESS (0.000s)
[374.595498] Subtest invalid: SUCCESS (0.007s)
[374.636037] [123/155] (647s left) gem_exec_schedule (preempt-queue-contexts-chain)
[374.707520] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[374.993047] [124/155] (647s left) kms_lease (lease-unleased-crtc)
[375.086479] Starting subtest: lease-unleased-crtc
[375.088800] Starting dynamic subtest: pipe-A-eDP-1
[375.396946] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.309s)
[375.408831] Starting dynamic subtest: pipe-B-eDP-1
[376.117411] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.719s)
[376.131129] Starting dynamic subtest: pipe-C-eDP-1
[376.133450] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[376.144477] Starting dynamic subtest: pipe-D-eDP-1
[376.146739] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[376.149093] Subtest lease-unleased-crtc: SUCCESS (1.046s)
[376.525275] [125/155] (645s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[376.587380] Starting subtest: mixed-tiled-to-y-tiled-ccs
[376.591938] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[376.784404] [126/155] (645s left) gem_exec_params (readonly)
[376.838520] Starting subtest: readonly
[376.840799] Subtest readonly: SUCCESS (0.002s)
[376.977144] [127/155] (645s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render)
[377.078381] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render
[377.082667] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[377.162725] [128/155] (645s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[377.260195] Starting subtest: fbc-modesetfrombusy
[381.001106] Subtest fbc-modesetfrombusy: SUCCESS (3.746s)
[382.167915] [129/155] (640s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render)
[382.280026] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render
[382.284321] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[382.387480] [130/155] (640s left) kms_dsc (dsc-with-bpc)
[382.474538] Starting subtest: dsc-with-bpc
[382.505752] Subtest dsc-with-bpc: SKIP (0.001s)
[382.564451] [131/155] (640s left) gem_wait (busy)
[382.626669] Starting subtest: busy
[382.629061] Starting dynamic subtest: all-engines
[384.371415] Dynamic subtest all-engines: SUCCESS (1.742s)
[384.386082] Starting dynamic subtest: rcs0
[384.914468] Dynamic subtest rcs0: SUCCESS (0.541s)
[384.928310] Starting dynamic subtest: bcs0
[385.453873] Dynamic subtest bcs0: SUCCESS (0.539s)
[385.466220] Starting dynamic subtest: vcs0
[387.317500] Dynamic subtest vcs0: SUCCESS (1.860s)
[387.330916] Starting dynamic subtest: vcs1
[389.363751] Dynamic subtest vcs1: SUCCESS (2.045s)
[389.376890] Starting dynamic subtest: vecs0
[391.347087] Dynamic subtest vecs0: SUCCESS (1.980s)
[391.361832] Starting dynamic subtest: ccs0
[391.888743] Dynamic subtest ccs0: SUCCESS (0.541s)
[391.891212] Subtest busy: SUCCESS (9.263s)
[392.093150] [132/155] (630s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[392.197336] Starting subtest: psr-rgb565-draw-blt
[399.289114] Subtest psr-rgb565-draw-blt: SUCCESS (7.097s)
[399.424676] [133/155] (623s left) gem_exec_balancer (nop)
[399.484509] Starting subtest: nop
[446.173283] Subtest nop: SUCCESS (46.695s)
[446.497501] [134/155] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[446.597618] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[446.601597] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[446.691804] [135/155] (576s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[446.783701] Starting subtest: y-tiled-8bpp-rotate-0
[446.787581] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[446.889108] [136/155] (576s left) kms_frontbuffer_tracking (hdr-suspend)
[446.995137] Starting subtest: hdr-suspend
[446.999121] Subtest hdr-suspend: SKIP (0.000s)
[447.084911] [137/155] (575s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[447.183385] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[454.242910] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.067s)
[454.356055] [138/155] (568s left) gem_mmap_gtt (zero-extend)
[454.415781] Subtest zero-extend: SKIP (0.000s)
[454.484292] [139/155] (568s left) kms_busy (extended-modeset-hang-newfb)
[454.593529] Starting subtest: extended-modeset-hang-newfb
[454.595841] Starting dynamic subtest: pipe-A
[489.291212] Dynamic subtest pipe-A: SUCCESS (34.702s)
[489.302498] Starting dynamic subtest: pipe-D
[512.241194] Dynamic subtest pipe-D: SUCCESS (22.956s)
[512.243547] Subtest extended-modeset-hang-newfb: SUCCESS (57.663s)
[513.057822] [140/155] (510s left) gem_ctx_persistence (engines-cleanup)
[513.120339] Starting subtest: engines-cleanup
[513.122205] Starting dynamic subtest: rcs0
[513.181030] Dynamic subtest rcs0: SUCCESS (0.063s)
[513.194552] Starting dynamic subtest: bcs0
[513.222979] Dynamic subtest bcs0: SUCCESS (0.040s)
[513.233904] Starting dynamic subtest: vcs0
[513.261734] Dynamic subtest vcs0: SUCCESS (0.037s)
[513.275334] Starting dynamic subtest: vcs1
[513.296807] Dynamic subtest vcs1: SUCCESS (0.033s)
[513.308865] Starting dynamic subtest: vecs0
[513.313500] Dynamic subtest vecs0: SUCCESS (0.013s)
[513.323283] Starting dynamic subtest: ccs0
[513.366350] Dynamic subtest ccs0: SUCCESS (0.053s)
[513.368869] Subtest engines-cleanup: SUCCESS (0.249s)
[513.457912] [141/155] (509s left) kms_vblank (query-idle-hang)
[513.555552] Starting subtest: query-idle-hang
[513.557792] Starting dynamic subtest: pipe-A-eDP-1
[540.085358] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.537s)
[540.101638] Starting dynamic subtest: pipe-D-eDP-1
[555.125504] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.041s)
[555.127967] Subtest query-idle-hang: SUCCESS (41.582s)
[556.004694] [142/155] (467s left) kms_addfb_basic (bad-pitch-1024)
[556.070480] Starting subtest: bad-pitch-1024
[556.072739] Subtest bad-pitch-1024: SUCCESS (0.000s)
[556.223949] [143/155] (467s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[556.281569] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[556.391940] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[556.474458] [144/155] (466s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render)
[556.569317] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render
[556.573685] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[556.686177] [145/155] (466s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[556.737732] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[556.815060] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.012s)
[556.860410] [146/155] (466s left) gem_mmap_wc (invalid-flags)
[556.921442] Subtest invalid-flags: SKIP (0.000s)
[556.985781] [147/155] (466s left) gem_exec_flush (basic-wb-rw-default)
[557.049009] Starting subtest: basic-wb-rw-default
[562.535894] Subtest basic-wb-rw-default: SUCCESS (5.458s)
[562.694691] [148/155] (460s left) kms_draw_crc (fill-fb)
[562.785252] Starting subtest: fill-fb
[563.214876] Subtest fill-fb: SUCCESS (0.431s)
[563.311861] [149/155] (460s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt)
[563.414964] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt
[563.418934] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[563.514922] [150/155] (460s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[563.703840] Starting subtest: cursor-rapid-movement-64x64
[563.708372] Starting dynamic subtest: pipe-A-eDP-1
[564.252119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[564.282768] Starting dynamic subtest: pipe-D-eDP-1
[565.522038] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[565.524363] Subtest cursor-rapid-movement-64x64: SUCCESS (1.816s)
[566.385107] [151/155] (457s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[566.483696] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[566.488053] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[566.564830] [152/155] (457s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[566.656438] Starting subtest: addfb25-y-tiled-legacy
[566.658264] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[566.752048] [153/155] (456s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[566.803653] Starting subtest: y-tiled-ccs-to-yf-tiled
[566.807995] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[566.999775] [154/155] (456s left) kms_display_modes (extended-mode-basic)
[567.098084] Starting subtest: extended-mode-basic
[567.102105] Subtest extended-mode-basic: SKIP (0.000s)
[567.145985] [155/155] (456s left) kms_psr (fbc-pr-sprite-plane-move)
[567.234840] Starting subtest: fbc-pr-sprite-plane-move
[567.238889] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[567.304878] Closing watchdogs
results: parsing output: 0/ for test: i915_module_load
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: i915_suspend
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_color_pipeline
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_lmem_evict
results: parsing output: 15/ for test: kms_pm_dc
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: gem_ctx_shared
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_busy
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: template
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_prime
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_pipe_b_c_ivb
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_pxp
results: parsing output: 67/ for test: gen3_mixed_blits
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_chamelium_frames
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: kms_plane_alpha_blend
results: parsing output: 77/ for test: kms_sequence
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_scaling_modes
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_joiner
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_pm_backlight
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_close_race
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gen9_exec_parse
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_plane
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: core_setmaster
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: gen9_exec_parse
results: parsing output: 108/ for test: gem_exec_capture
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: prime_self_import
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_pm_rpm
results: parsing output: 113/ for test: gem_mmap_wc
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_set_tiling_vs_blt
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_async_flips
results: parsing output: 121/ for test: sysfs_preempt_timeout
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_lease
results: parsing output: 124/ for test: gem_render_copy
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_dsc
results: parsing output: 130/ for test: gem_wait
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_balancer
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_big_fb
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_mmap_gtt
results: parsing output: 138/ for test: kms_busy
results: parsing output: 139/ for test: gem_ctx_persistence
results: parsing output: 140/ for test: kms_vblank
results: parsing output: 141/ for test: kms_addfb_basic
results: parsing output: 142/ for test: syncobj_timeline
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: sriov_basic
results: parsing output: 145/ for test: gem_mmap_wc
results: parsing output: 146/ for test: gem_exec_flush
results: parsing output: 147/ for test: kms_draw_crc
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_addfb_basic
results: parsing output: 152/ for test: gem_render_copy
results: parsing output: 153/ for test: kms_display_modes
results: parsing output: 154/ for test: kms_psr
Done.