[71.438765] Initializing watchdogs
[71.438824]   /dev/watchdog0
[71.454686] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[71.460234] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.463541] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.465356] [001/156] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[71.563468] Starting subtest: fbc-tiling-linear
[72.701616] Subtest fbc-tiling-linear: SUCCESS (1.139s)
[72.848635] [002/156] (959s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[72.883193] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[72.918533] [003/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[73.016664] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[73.018041] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[73.105713] [004/156] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[73.198199] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[73.199577] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[73.291598] [005/156] (958s left) kms_force_connector_basic (prune-stale-modes)
[73.416596] Starting subtest: prune-stale-modes
[73.561670] Subtest prune-stale-modes: SUCCESS (0.148s)
[73.715239] [006/156] (958s left) perf_pmu (most-busy-check-all)
[73.757160] Starting subtest: most-busy-check-all
[73.757974] Starting dynamic subtest: rcs0
[74.285409] Dynamic subtest rcs0: SUCCESS (0.528s)
[74.295197] Starting dynamic subtest: bcs0
[74.804184] Dynamic subtest bcs0: SUCCESS (0.519s)
[74.814328] Starting dynamic subtest: vcs0
[75.324147] Dynamic subtest vcs0: SUCCESS (0.520s)
[75.333494] Starting dynamic subtest: vcs1
[75.842340] Dynamic subtest vcs1: SUCCESS (0.518s)
[75.851752] Starting dynamic subtest: vecs0
[76.364187] Dynamic subtest vecs0: SUCCESS (0.522s)
[76.365144] Subtest most-busy-check-all: SUCCESS (2.609s)
[76.440588] [007/156] (955s left) gem_ccs (large-ctrl-surf-copy)
[76.496527] Starting subtest: large-ctrl-surf-copy
[76.498041] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[76.562622] [008/156] (955s left) kms_plane_alpha_blend (coverage-7efc)
[76.652585] Starting subtest: coverage-7efc
[76.722359] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.032075] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.309s)
[77.069177] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.523080] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.464s)
[77.523782] Subtest coverage-7efc: SUCCESS (0.871s)
[77.684237] [009/156] (954s left) gem_mmap_gtt (fault-concurrent)
[77.721841] Starting subtest: fault-concurrent
[80.236829] Subtest fault-concurrent: SUCCESS (2.508s)
[80.366929] [010/156] (951s left) api_intel_allocator (gem-pool)
[80.399590] Starting subtest: gem-pool
[80.406098] Subtest gem-pool: SUCCESS (0.006s)
[80.500851] [011/156] (951s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[80.595130] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[80.596503] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[80.692613] [012/156] (951s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[80.780622] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[80.782008] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[80.855523] [013/156] (951s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[80.942874] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[80.943610] Starting dynamic subtest: pipe-A-HDMI-A-1
[80.950411] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[80.957375] Starting dynamic subtest: pipe-B-HDMI-A-1
[80.964286] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[80.971034] Starting dynamic subtest: pipe-C-HDMI-A-1
[80.977735] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[80.984439] Starting dynamic subtest: pipe-D-HDMI-A-1
[80.991432] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[80.992786] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[81.192989] [014/156] (951s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[81.283610] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[81.284320] Starting dynamic subtest: pipe-A-HDMI-A-1
[81.291108] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[81.297897] Starting dynamic subtest: pipe-B-HDMI-A-1
[81.304742] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[81.311490] Starting dynamic subtest: pipe-C-HDMI-A-1
[81.318282] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[81.324858] Starting dynamic subtest: pipe-D-HDMI-A-1
[81.331650] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[81.333015] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[81.556414] [015/156] (950s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[81.649203] Starting subtest: hdr-rgb565-draw-blt
[81.650575] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[81.752935] [016/156] (950s left) kms_pm_rpm (legacy-planes-dpms)
[83.166776] Starting subtest: legacy-planes-dpms
[83.167867] Starting dynamic subtest: plane-65
[91.383239] Dynamic subtest plane-65: SUCCESS (8.216s)
[91.393827] Starting dynamic subtest: plane-95
[99.892919] Dynamic subtest plane-95: SUCCESS (8.509s)
[99.901599] Starting dynamic subtest: plane-125
[108.295341] Dynamic subtest plane-125: SUCCESS (8.401s)
[108.304632] Starting dynamic subtest: plane-135
[116.694622] Dynamic subtest plane-135: SUCCESS (8.390s)
[116.702121] Starting dynamic subtest: plane-145
[124.982176] Dynamic subtest plane-145: SUCCESS (8.295s)
[124.993053] Starting dynamic subtest: plane-155
[133.401050] Dynamic subtest plane-155: SUCCESS (8.409s)
[133.402264] Subtest legacy-planes-dpms: SUCCESS (50.227s)
[133.594510] [017/156] (898s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[133.636624] Starting subtest: x-tiled-to-vebox-y-tiled
[133.637348] Starting dynamic subtest: smem
[133.733987] Dynamic subtest smem: SUCCESS (0.097s)
[133.734774] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.098s)
[133.936626] [018/156] (898s left) sysfs_heartbeat_interval (invalid)
[133.973684] Starting subtest: invalid
[133.974375] Starting dynamic subtest: vecs0
[133.975114] Dynamic subtest vecs0: SUCCESS (0.000s)
[133.982042] Starting dynamic subtest: vcs0
[133.982744] Dynamic subtest vcs0: SUCCESS (0.000s)
[133.989310] Starting dynamic subtest: bcs0
[133.990183] Dynamic subtest bcs0: SUCCESS (0.000s)
[133.997196] Starting dynamic subtest: rcs0
[133.997887] Dynamic subtest rcs0: SUCCESS (0.000s)
[134.004570] Starting dynamic subtest: vcs1
[134.005301] Dynamic subtest vcs1: SUCCESS (0.000s)
[134.006014] Subtest invalid: SUCCESS (0.004s)
[134.034062] [019/156] (898s left) kms_frontbuffer_tracking (fbc-stridechange)
[134.127278] Starting subtest: fbc-stridechange
[135.094267] Subtest fbc-stridechange: SUCCESS (0.967s)
[135.218306] [020/156] (897s left) gem_ctx_param (basic-default)
[135.254476] Starting subtest: basic-default
[135.255291] Subtest basic-default: SUCCESS (0.000s)
[135.330662] [021/156] (897s left) kms_psr (fbc-pr-primary-mmap-gtt)
[135.421379] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[135.463436] [022/156] (897s left) i915_pm_freq_mult (media-freq)
[135.498975] Starting subtest: media-freq
[135.499716] Starting dynamic subtest: gt0
[135.501055] Dynamic subtest gt0: SKIP (0.000s)
[135.502412] Subtest media-freq: SKIP (0.001s)
[135.565625] [023/156] (897s left) prime_busy (before-wait)
[135.602411] Starting subtest: before-wait
[135.607872] Starting dynamic subtest: rcs0
[135.649698] Dynamic subtest rcs0: SUCCESS (0.041s)
[135.659085] Starting dynamic subtest: bcs0
[135.672280] Dynamic subtest bcs0: SUCCESS (0.022s)
[135.679718] Starting dynamic subtest: vcs0
[135.685405] Dynamic subtest vcs0: SUCCESS (0.012s)
[135.692150] Starting dynamic subtest: vcs1
[135.708408] Dynamic subtest vcs1: SUCCESS (0.022s)
[135.715552] Starting dynamic subtest: vecs0
[135.724512] Dynamic subtest vecs0: SUCCESS (0.015s)
[135.842238] Subtest before-wait: SUCCESS (0.231s)
[135.914576] [024/156] (896s left) gem_exec_gttfill (engines)
[135.958199] Starting subtest: engines
[135.958927] Starting dynamic subtest: rcs0
[159.461975] Dynamic subtest rcs0: SUCCESS (23.503s)
[159.472894] Starting dynamic subtest: bcs0
[182.446468] Dynamic subtest bcs0: SUCCESS (22.983s)
[182.459452] Starting dynamic subtest: vcs0
[205.727520] Dynamic subtest vcs0: SUCCESS (23.281s)
[205.741284] Starting dynamic subtest: vcs1
[228.754107] Dynamic subtest vcs1: SUCCESS (23.026s)
[228.763236] Starting dynamic subtest: vecs0
[251.836150] Dynamic subtest vecs0: SUCCESS (23.081s)
[251.836921] Subtest engines: SUCCESS (115.878s)
[252.019182] [025/156] (780s left) syncobj_timeline (etime-multi-wait-all-submitted)
[252.121241] Starting subtest: etime-multi-wait-all-submitted
[252.238543] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[252.295930] [026/156] (780s left) gem_ctx_param (get-priority-new-ctx)
[252.329850] Starting subtest: get-priority-new-ctx
[252.330632] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[252.394628] [027/156] (780s left) kms_big_fb (linear-32bpp-rotate-90)
[252.513137] Starting subtest: linear-32bpp-rotate-90
[252.603066] Subtest linear-32bpp-rotate-90: SKIP (0.089s)
[252.734560] [028/156] (780s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[252.774278] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[252.817388] [029/156] (780s left) gem_ctx_shared (disjoint-timelines)
[252.861894] Starting subtest: disjoint-timelines
[252.901152] Subtest disjoint-timelines: SUCCESS (0.039s)
[253.127805] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[253.130963] [030/156] (779s left) kms_psr (fbc-psr2-cursor-plane-move)
[253.220100] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[253.260511] [031/156] (779s left) gem_bad_reloc (negative-reloc-bltcopy)
[253.300852] Starting subtest: negative-reloc-bltcopy
[254.410625] Subtest negative-reloc-bltcopy: SUCCESS (1.100s)
[254.515261] [032/156] (778s left) kms_chamelium_hpd (hdmi-hpd)
[254.664329] Subtest hdmi-hpd: SKIP (0.000s)
[254.759623] [033/156] (778s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[254.851265] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[254.890972] [034/156] (778s left) gem_eio (wait-10ms)
[254.935740] Starting subtest: wait-10ms
[255.099276] Subtest wait-10ms: SUCCESS (0.164s)
[255.221275] [035/156] (778s left) kms_content_protection (legacy-hdcp14)
[255.319590] Starting subtest: legacy-hdcp14
[255.324850] Subtest legacy-hdcp14: SKIP (0.004s)
[255.423920] [036/156] (777s left) syncobj_wait (reset-signaled)
[255.459036] Starting subtest: reset-signaled
[255.459867] Subtest reset-signaled: SUCCESS (0.000s)
[255.523313] [037/156] (777s left) gem_ctx_isolation (dirty-switch)
[255.565977] Starting subtest: dirty-switch
[255.566864] Starting dynamic subtest: rcs0
[255.753122] Dynamic subtest rcs0: SUCCESS (0.178s)
[255.760977] Starting dynamic subtest: bcs0
[255.955646] Dynamic subtest bcs0: SUCCESS (0.202s)
[255.963542] Starting dynamic subtest: vcs0
[256.162058] Dynamic subtest vcs0: SUCCESS (0.206s)
[256.169926] Starting dynamic subtest: vcs1
[256.375305] Dynamic subtest vcs1: SUCCESS (0.220s)
[256.383182] Starting dynamic subtest: vecs0
[256.608440] Dynamic subtest vecs0: SUCCESS (0.225s)
[256.609179] Subtest dirty-switch: SUCCESS (1.034s)
[256.777059] [038/156] (776s left) gem_flink_basic (bad-open)
[256.810585] Starting subtest: bad-open
[256.811332] Subtest bad-open: SUCCESS (0.000s)
[256.874071] [039/156] (776s left) gem_caching (writes)
[256.911691] Starting subtest: writes
[266.114726] Subtest writes: SUCCESS (9.203s)
[266.215356] [040/156] (767s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[266.307788] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[266.308496] Starting dynamic subtest: pipe-A
[266.693292] Dynamic subtest pipe-A: SUCCESS (0.386s)
[266.704230] Starting dynamic subtest: pipe-B
[267.134815] Dynamic subtest pipe-B: SUCCESS (0.441s)
[267.144904] Starting dynamic subtest: pipe-C
[267.578214] Dynamic subtest pipe-C: SUCCESS (0.443s)
[267.590726] Starting dynamic subtest: pipe-D
[268.021180] Dynamic subtest pipe-D: SUCCESS (0.442s)
[268.021981] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (1.715s)
[268.218184] [041/156] (765s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[268.254593] Starting subtest: single-wait-all-for-submit-available-submitted
[268.255413] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[268.350025] [042/156] (765s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[268.446536] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[268.448101] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[268.534649] [043/156] (765s left) kms_pm_rpm (system-suspend-idle)
[269.952858] Starting subtest: system-suspend-idle
[289.829808] Subtest system-suspend-idle: SUCCESS (4.897s)
[297.089522] [044/156] (743s left) kms_atomic_transition (modeset-transition)
[297.185204] Starting subtest: modeset-transition
[297.186029] Starting dynamic subtest: 1x-outputs
[298.429542] Dynamic subtest 1x-outputs: SUCCESS (1.264s)
[298.430644] Subtest modeset-transition: SUCCESS (1.265s)
[298.600458] [045/156] (742s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[298.694173] Starting subtest: pipe-fbc-rte
[298.698200] Subtest pipe-fbc-rte: SKIP (0.000s)
[298.795982] [046/156] (741s left) gem_spin_batch (resubmit-all)
[298.837757] Starting subtest: resubmit-all
[298.838571] Starting dynamic subtest: rcs0
[298.841763] Dynamic subtest rcs0: SUCCESS (0.004s)
[298.852621] Starting dynamic subtest: bcs0
[298.853380] Dynamic subtest bcs0: SUCCESS (0.002s)
[298.861946] Starting dynamic subtest: vcs0
[298.862652] Dynamic subtest vcs0: SUCCESS (0.002s)
[298.870836] Starting dynamic subtest: vcs1
[298.871529] Dynamic subtest vcs1: SUCCESS (0.002s)
[298.879342] Starting dynamic subtest: vecs0
[298.880027] Dynamic subtest vecs0: SUCCESS (0.002s)
[298.880721] Subtest resubmit-all: SUCCESS (0.015s)
[299.030487] [047/156] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[299.120975] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[299.122378] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[299.236346] [048/156] (741s left) syncobj_basic (illegal-fd-to-handle)
[299.269139] Starting subtest: illegal-fd-to-handle
[299.269856] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[299.349700] [049/156] (741s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[299.442114] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[299.443540] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[299.544368] [050/156] (741s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[299.639555] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[300.311771] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.686s)
[300.449816] [051/156] (740s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[300.484592] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[300.585608] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[300.661718] [052/156] (740s left) api_intel_bb (misplaced-blitter)
[300.695388] Starting subtest: misplaced-blitter
[300.699693] Subtest misplaced-blitter: SUCCESS (0.005s)
[300.808224] [053/156] (740s left) kms_atomic_interruptible (universal-setplane-cursor)
[300.898522] Starting subtest: universal-setplane-cursor
[300.899260] Starting dynamic subtest: pipe-A-HDMI-A-1
[307.097446] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.281s)
[307.098214] Subtest universal-setplane-cursor: SUCCESS (6.283s)
[307.241168] [054/156] (733s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[307.342136] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[307.343582] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[307.439168] [055/156] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[307.535106] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[307.536789] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[307.630754] [056/156] (733s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[307.719707] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[307.720485] Starting dynamic subtest: pipe-A-valid-mode
[308.788539] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.076s)
[308.789385] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.077s)
[308.939139] [057/156] (732s left) gem_pxp (create-protected-buffer)
[309.042884] Starting subtest: create-protected-buffer
[309.043927] Subtest create-protected-buffer: SUCCESS (0.000s)
[309.156373] [058/156] (732s left) gem_fence_thrash (bo-write-verify-threaded-x)
[309.188960] Starting subtest: bo-write-verify-threaded-x
[313.920735] Subtest bo-write-verify-threaded-x: SUCCESS (4.722s)
[314.000644] [059/156] (727s left) gen9_exec_parse (allowed-single)
[314.038285] Subtest allowed-single: SKIP (0.000s)
[314.080457] [060/156] (727s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[314.175138] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[314.176613] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[314.280618] [061/156] (727s left) gem_exec_balancer (bonded-semaphore)
[314.323419] Starting subtest: bonded-semaphore
[318.661328] Subtest bonded-semaphore: SUCCESS (4.316s)
[318.829184] [062/156] (722s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[318.924711] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[318.942831] Starting dynamic subtest: pipe-A-plane-0
[319.159304] Dynamic subtest pipe-A-plane-0: SUCCESS (0.216s)
[319.174030] Starting dynamic subtest: pipe-A-plane-3
[319.333788] Dynamic subtest pipe-A-plane-3: SUCCESS (0.173s)
[319.352507] Starting dynamic subtest: pipe-A-plane-5
[319.499986] Dynamic subtest pipe-A-plane-5: SUCCESS (0.165s)
[319.659823] Starting dynamic subtest: pipe-B-plane-0
[319.833953] Dynamic subtest pipe-B-plane-0: SUCCESS (0.183s)
[319.853168] Starting dynamic subtest: pipe-B-plane-3
[320.001305] Dynamic subtest pipe-B-plane-3: SUCCESS (0.165s)
[320.014777] Starting dynamic subtest: pipe-B-plane-5
[320.166946] Dynamic subtest pipe-B-plane-5: SUCCESS (0.165s)
[320.249390] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (1.327s)
[320.421402] [063/156] (721s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[320.522162] Starting subtest: fbc-rgb565-draw-mmap-wc
[321.771284] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.252s)
[321.883509] [064/156] (719s left) kms_pwrite_crc (basic)
[321.977803] Starting subtest: basic
[322.277712] Subtest basic: SUCCESS (0.300s)
[322.429768] [065/156] (719s left) gem_flink_basic (bad-flink)
[322.467842] Starting subtest: bad-flink
[322.468597] Subtest bad-flink: SUCCESS (0.000s)
[322.526307] [066/156] (719s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[322.619140] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[322.620667] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[322.719532] [067/156] (718s left) gem_ctx_persistence (legacy-engines-persistence)
[322.758059] Starting subtest: legacy-engines-persistence
[322.758865] Starting dynamic subtest: render
[323.513363] Dynamic subtest render: SUCCESS (0.754s)
[323.526206] Starting dynamic subtest: bsd1
[324.282261] Dynamic subtest bsd1: SUCCESS (0.766s)
[324.295469] Starting dynamic subtest: bsd2
[325.054331] Dynamic subtest bsd2: SUCCESS (0.770s)
[325.067481] Starting dynamic subtest: blt
[325.814241] Dynamic subtest blt: SUCCESS (0.757s)
[325.826770] Starting dynamic subtest: vebox
[326.594302] Dynamic subtest vebox: SUCCESS (0.778s)
[326.595449] Subtest legacy-engines-persistence: SUCCESS (3.839s)
[326.685317] [068/156] (715s left) gen7_exec_parse (basic-allowed)
[326.724341] Subtest basic-allowed: SKIP (0.000s)
[326.769158] [069/156] (714s left) gem_exec_schedule (reorder-wide)
[326.934296] Starting subtest: reorder-wide
[326.935415] Starting dynamic subtest: rcs0
[327.010723] Dynamic subtest rcs0: SUCCESS (0.078s)
[327.022732] Starting dynamic subtest: bcs0
[327.089054] Dynamic subtest bcs0: SUCCESS (0.077s)
[327.103688] Starting dynamic subtest: vcs0
[327.167443] Dynamic subtest vcs0: SUCCESS (0.076s)
[327.182032] Starting dynamic subtest: vcs1
[327.242639] Dynamic subtest vcs1: SUCCESS (0.073s)
[327.256419] Starting dynamic subtest: vecs0
[327.318068] Dynamic subtest vecs0: SUCCESS (0.073s)
[327.318998] Subtest reorder-wide: SUCCESS (0.387s)
[327.516253] [070/156] (714s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[327.611202] Starting subtest: psrhdr-slowdraw
[327.612649] Subtest psrhdr-slowdraw: SKIP (0.000s)
[327.700857] [071/156] (714s left) perf (non-zero-reason)
[327.801812] Starting subtest: non-zero-reason
[327.802562] Starting dynamic subtest: 0-rcs0
[335.546265] Dynamic subtest 0-rcs0: SUCCESS (7.714s)
[335.547259] Subtest non-zero-reason: SUCCESS (7.715s)
[335.587990] [072/156] (706s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[335.682906] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[335.684367] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[335.780888] [073/156] (706s left) i915_drm_fdinfo (all-busy-check-all)
[335.819260] Starting subtest: all-busy-check-all
[336.341750] Subtest all-busy-check-all: SUCCESS (0.523s)
[336.410411] [074/156] (705s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[336.501737] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[336.503165] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[336.600069] [075/156] (705s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[336.703622] Starting subtest: compare-crc-sanitycheck-nv12
[336.705439] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.057594] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.352s)
[337.068250] Starting dynamic subtest: pipe-B-HDMI-A-1
[337.391435] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.332s)
[337.403651] Starting dynamic subtest: pipe-C-HDMI-A-1
[337.704740] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.311s)
[337.718788] Starting dynamic subtest: pipe-D-HDMI-A-1
[338.030276] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.323s)
[338.030991] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.327s)
[338.171590] [076/156] (703s left) gem_exec_reloc (basic-write-gtt)
[338.214896] Starting subtest: basic-write-gtt
[338.220978] Subtest basic-write-gtt: SUCCESS (0.006s)
[338.352154] [077/156] (703s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[338.446229] Starting subtest: cursor-rapid-movement-max-size
[338.448333] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[338.541443] [078/156] (703s left) kms_color_pipeline (plane-lut1d)
[338.630779] Starting subtest: plane-lut1d
[338.721879] Starting dynamic subtest: pipe-A-plane-0
[338.819163] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[338.836423] Starting dynamic subtest: pipe-A-plane-1
[338.910639] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s)
[338.927801] Starting dynamic subtest: pipe-A-plane-2
[339.002300] Dynamic subtest pipe-A-plane-2: SUCCESS (0.089s)
[339.214505] Starting dynamic subtest: pipe-B-plane-0
[339.289299] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s)
[339.303415] Starting dynamic subtest: pipe-B-plane-1
[339.388793] Dynamic subtest pipe-B-plane-1: SUCCESS (0.098s)
[339.404682] Starting dynamic subtest: pipe-B-plane-2
[339.480881] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[339.696056] Starting dynamic subtest: pipe-C-plane-0
[339.778347] Dynamic subtest pipe-C-plane-0: SUCCESS (0.092s)
[339.793136] Starting dynamic subtest: pipe-C-plane-1
[339.878050] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[339.891989] Starting dynamic subtest: pipe-C-plane-2
[339.978232] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s)
[340.196307] Starting dynamic subtest: pipe-D-plane-0
[340.279035] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s)
[340.290872] Starting dynamic subtest: pipe-D-plane-1
[340.371442] Dynamic subtest pipe-D-plane-1: SUCCESS (0.091s)
[340.388262] Starting dynamic subtest: pipe-D-plane-2
[340.471116] Dynamic subtest pipe-D-plane-2: SUCCESS (0.097s)
[340.520437] Subtest plane-lut1d: SUCCESS (1.890s)
[340.636582] [079/156] (701s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[340.737944] Starting subtest: yf-tiled-16bpp-rotate-180
[340.739387] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[340.849975] [080/156] (701s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[340.948141] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[340.949590] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[341.054152] [081/156] (701s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[341.146997] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[341.148436] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[341.257226] [082/156] (701s left) gem_exec_reloc (basic-wc-read)
[341.294965] Starting subtest: basic-wc-read
[341.300250] Subtest basic-wc-read: SUCCESS (0.005s)
[341.420924] [083/156] (700s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[341.509934] Starting subtest: short-busy-flip-before-cursor-toggle
[341.511403] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[341.581323] [084/156] (700s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[341.676448] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[341.685006] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[341.756069] [085/156] (700s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[341.851908] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[341.853392] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[341.928225] [086/156] (700s left) kms_draw_crc (draw-method-render)
[342.018997] Starting subtest: draw-method-render
[342.019801] Starting dynamic subtest: xrgb8888-untiled
[342.181258] Dynamic subtest xrgb8888-untiled: SUCCESS (0.161s)
[342.204296] Starting dynamic subtest: rgb565-untiled
[342.356398] Dynamic subtest rgb565-untiled: SUCCESS (0.171s)
[342.378794] Starting dynamic subtest: xrgb2101010-untiled
[342.514453] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.155s)
[342.537542] Starting dynamic subtest: xbgr16161616f-untiled
[342.681282] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.163s)
[342.702509] Starting dynamic subtest: xrgb8888-xtiled
[342.772678] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s)
[342.793023] Starting dynamic subtest: rgb565-xtiled
[342.864487] Dynamic subtest rgb565-xtiled: SUCCESS (0.088s)
[342.885415] Starting dynamic subtest: xrgb2101010-xtiled
[342.947613] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s)
[342.968349] Starting dynamic subtest: xbgr16161616f-xtiled
[343.039261] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.089s)
[343.059355] Starting dynamic subtest: xrgb8888-ytiled
[343.130966] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.089s)
[343.151333] Starting dynamic subtest: rgb565-ytiled
[343.222432] Dynamic subtest rgb565-ytiled: SUCCESS (0.089s)
[343.242888] Starting dynamic subtest: xrgb2101010-ytiled
[343.305916] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[343.326714] Starting dynamic subtest: xbgr16161616f-ytiled
[343.397430] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.089s)
[343.400836] Subtest draw-method-render: SUCCESS (1.380s)
[343.514472] [087/156] (699s left) kms_cursor_crc (cursor-sliding-256x85)
[343.609733] Starting subtest: cursor-sliding-256x85
[343.614057] Starting dynamic subtest: pipe-A-HDMI-A-1
[345.464352] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.850s)
[345.503115] Starting dynamic subtest: pipe-D-HDMI-A-1
[347.314261] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.824s)
[347.314979] Subtest cursor-sliding-256x85: SUCCESS (3.707s)
[347.480305] [088/156] (695s left) kms_cursor_crc (cursor-onscreen-256x256)
[347.578843] Starting subtest: cursor-onscreen-256x256
[347.582584] Starting dynamic subtest: pipe-A-HDMI-A-1
[348.746553] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.165s)
[348.792920] Starting dynamic subtest: pipe-D-HDMI-A-1
[349.949150] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.165s)
[349.949943] Subtest cursor-onscreen-256x256: SUCCESS (2.373s)
[350.135500] [089/156] (692s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[350.233523] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[350.234997] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[350.341382] [090/156] (692s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[350.441233] Starting subtest: fbcpsr-slowdraw
[350.442668] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[350.536312] [091/156] (692s left) kms_lease (cursor-implicit-plane)
[350.625856] Starting subtest: cursor-implicit-plane
[350.626648] Starting dynamic subtest: pipe-A-HDMI-A-1
[350.809928] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.183s)
[350.820630] Starting dynamic subtest: pipe-B-HDMI-A-1
[350.971737] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.160s)
[350.983968] Starting dynamic subtest: pipe-C-HDMI-A-1
[351.135323] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.161s)
[351.146012] Starting dynamic subtest: pipe-D-HDMI-A-1
[351.296374] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.159s)
[351.297229] Subtest cursor-implicit-plane: SUCCESS (0.671s)
[351.418550] [092/156] (691s left) syncobj_wait (invalid-reset-zero-handles)
[351.453558] Starting subtest: invalid-reset-zero-handles
[351.454310] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[351.536008] [093/156] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[351.629069] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[351.630621] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[351.715188] [094/156] (691s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[351.813522] Starting subtest: yf-tiled-64bpp-rotate-90
[351.814982] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[351.910174] [095/156] (690s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[352.003219] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[352.004698] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[352.105885] [096/156] (690s left) gem_exec_fence (long-history)
[352.431643] Starting subtest: long-history
[358.161326] Subtest long-history: SUCCESS (5.727s)
[358.613962] [097/156] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[358.710593] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[358.712121] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[358.812640] [098/156] (684s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[358.903006] Starting subtest: bad-rotation-90-yf-tiled-ccs
[358.903789] Starting dynamic subtest: pipe-A-HDMI-A-1
[358.911810] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[358.921121] Starting dynamic subtest: pipe-B-HDMI-A-1
[358.928686] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[358.937890] Starting dynamic subtest: pipe-C-HDMI-A-1
[358.945326] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[358.954519] Starting dynamic subtest: pipe-D-HDMI-A-1
[358.962014] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[358.963707] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s)
[359.168546] [099/156] (683s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[359.259093] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[361.651214] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.394s)
[361.815340] [100/156] (681s left) kms_chamelium_audio (dp-audio-edid)
[361.969024] Subtest dp-audio-edid: SKIP (0.000s)
[362.074486] [101/156] (681s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[362.168646] Starting subtest: addfb25-yf-tiled-legacy
[362.169460] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[362.277177] [102/156] (680s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[362.370838] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[362.372314] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[362.447814] [103/156] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[362.545242] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[362.546687] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[362.645515] [104/156] (680s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[362.739430] Starting subtest: fbc-2p-pri-indfb-multidraw
[362.740898] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[362.834709] [105/156] (680s left) kms_sequence (queue-busy)
[362.924724] Starting subtest: queue-busy
[362.925479] Starting dynamic subtest: pipe-A-HDMI-A-1
[364.218386] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.294s)
[364.229795] Starting dynamic subtest: pipe-B-HDMI-A-1
[365.514252] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.293s)
[365.528155] Starting dynamic subtest: pipe-C-HDMI-A-1
[366.811929] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.296s)
[366.821411] Starting dynamic subtest: pipe-D-HDMI-A-1
[368.096850] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.285s)
[368.097657] Subtest queue-busy: SUCCESS (5.176s)
[368.216128] [106/156] (675s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[368.310322] Starting subtest: plane-upscale-20x20-with-rotation
[368.311261] Starting dynamic subtest: pipe-A
[369.415288] Dynamic subtest pipe-A: SKIP (1.102s)
[369.425030] Starting dynamic subtest: pipe-B
[370.561238] Dynamic subtest pipe-B: SKIP (1.146s)
[370.572512] Starting dynamic subtest: pipe-C
[371.734351] Dynamic subtest pipe-C: SKIP (1.173s)
[371.743998] Starting dynamic subtest: pipe-D
[372.962831] Dynamic subtest pipe-D: SKIP (1.228s)
[372.964731] Subtest plane-upscale-20x20-with-rotation: SKIP (4.653s)
[373.149464] [107/156] (670s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[373.253512] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[373.255082] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[373.354378] [108/156] (670s left) gem_exec_reloc (basic-write-wc)
[373.394636] Starting subtest: basic-write-wc
[373.399651] Subtest basic-write-wc: SUCCESS (0.005s)
[373.518329] [109/156] (669s left) syncobj_timeline (reset-signaled)
[373.553146] Starting subtest: reset-signaled
[373.553933] Subtest reset-signaled: SUCCESS (0.001s)
[373.627455] [110/156] (669s left) kms_psr (pr-cursor-plane-move)
[373.716698] Subtest pr-cursor-plane-move: SKIP (0.000s)
[373.765003] [111/156] (669s left) syncobj_wait (invalid-wait-illegal-handle)
[373.800528] Starting subtest: invalid-wait-illegal-handle
[373.801360] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[373.860480] [112/156] (669s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[373.953879] Starting subtest: extended-pageflip-modeset-hang-oldfb
[373.954642] Starting dynamic subtest: pipe-A
[393.484701] Dynamic subtest pipe-A: SUCCESS (19.530s)
[393.498989] Starting dynamic subtest: pipe-D
[413.438979] Dynamic subtest pipe-D: SUCCESS (19.945s)
[413.439806] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.483s)
[413.581380] [113/156] (630s left) kms_psr (psr2-primary-blt)
[413.678902] Subtest psr2-primary-blt: SKIP (0.000s)
[413.722517] [114/156] (629s left) gem_softpin (evict-snoop-interruptible)
[413.762000] Starting subtest: evict-snoop-interruptible
[413.763465] Subtest evict-snoop-interruptible: SKIP (0.000s)
[413.843801] [115/156] (629s left) kms_force_connector_basic (force-load-detect)
[413.968690] Starting subtest: force-load-detect
[413.975167] Subtest force-load-detect: SKIP (0.000s)
[414.126516] [116/156] (629s left) kms_chamelium_edid (hdmi-mode-timings)
[414.274804] Subtest hdmi-mode-timings: SKIP (0.000s)
[414.373487] [117/156] (629s left) syncobj_timeline (invalid-signal-zero-handles)
[414.412023] Starting subtest: invalid-signal-zero-handles
[414.412758] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[414.477930] [118/156] (629s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[414.569877] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[414.571372] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[414.669412] [119/156] (629s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[414.762684] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[414.764244] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[414.879559] [120/156] (629s left) gem_mmap_gtt (fault-concurrent-x)
[414.914850] Starting subtest: fault-concurrent-X
[417.690714] Subtest fault-concurrent-X: SUCCESS (2.768s)
[417.813299] [121/156] (626s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[417.854435] Starting subtest: y-tiled-to-vebox-y-tiled
[417.855248] Starting dynamic subtest: smem
[417.950956] Dynamic subtest smem: SUCCESS (0.096s)
[417.951773] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.097s)
[418.148041] [122/156] (625s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[418.243207] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[418.244728] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[418.331514] [123/156] (625s left) vgem_basic (debugfs)
[418.369790] Starting subtest: debugfs
[418.370545] Subtest debugfs: SUCCESS (0.000s)
[418.425416] [124/156] (625s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[418.513716] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[418.514458] Starting dynamic subtest: pipe-A-valid-mode
[419.747885] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.233s)
[419.748769] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.235s)
[419.920789] [125/156] (624s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[420.019248] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[420.020666] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[420.103489] [126/156] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[420.195853] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[420.197361] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[420.290143] [127/156] (624s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[420.382703] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[420.384096] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[420.482418] [128/156] (623s left) kms_vblank (wait-forked-hang)
[420.570653] Starting subtest: wait-forked-hang
[420.572482] Starting dynamic subtest: pipe-A-HDMI-A-1
[434.460036] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.889s)
[434.472419] Starting dynamic subtest: pipe-D-HDMI-A-1
[448.774403] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.314s)
[448.775280] Subtest wait-forked-hang: SUCCESS (28.208s)
[448.953361] [129/156] (595s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[449.045699] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[449.047510] Starting dynamic subtest: pipe-A-valid-mode
[450.940485] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.894s)
[450.941215] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.896s)
[451.096700] [130/156] (593s left) gem_ctx_exec (basic-invalid-context)
[451.134990] Starting subtest: basic-invalid-context
[451.136933] Subtest basic-invalid-context: SUCCESS (0.002s)
[451.256855] [131/156] (593s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[451.352253] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[451.353696] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[451.444515] [132/156] (593s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[451.533111] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[451.580539] [133/156] (592s left) gem_ppgtt (blt-vs-render-ctxn)
[451.618720] Starting subtest: blt-vs-render-ctxN
[484.265821] Subtest blt-vs-render-ctxN: SUCCESS (32.646s)
[484.386551] [134/156] (560s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[484.483770] Starting subtest: basic-gtt-cpu-noreloc
[484.487790] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.004s)
[484.614306] [135/156] (560s left) gem_softpin (invalid)
[484.652295] Starting subtest: invalid
[484.656812] Subtest invalid: SUCCESS (0.005s)
[484.775856] [136/156] (559s left) gem_exec_capture (capture)
[484.814609] Starting subtest: capture
[484.815312] Starting dynamic subtest: rcs0-smem
[486.091814] Dynamic subtest rcs0-smem: SUCCESS (1.277s)
[486.101613] Starting dynamic subtest: bcs0-smem
[487.371155] Dynamic subtest bcs0-smem: SUCCESS (1.272s)
[487.381142] Starting dynamic subtest: vcs0-smem
[488.643743] Dynamic subtest vcs0-smem: SUCCESS (1.271s)
[488.653230] Starting dynamic subtest: vcs1-smem
[489.915247] Dynamic subtest vcs1-smem: SUCCESS (1.275s)
[489.924604] Starting dynamic subtest: vecs0-smem
[491.187683] Dynamic subtest vecs0-smem: SUCCESS (1.268s)
[491.188362] Subtest capture: SUCCESS (6.367s)
[491.286054] [137/156] (553s left) gem_tiled_blits (basic)
[491.367214] Starting subtest: basic
[491.382984] Subtest basic: SUCCESS (0.016s)
[491.498385] [138/156] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[491.646935] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[491.648331] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[491.749569] [139/156] (553s left) gem_mmap_offset (partial-remap)
[491.783949] Starting subtest: partial-remap
[491.784697] Starting dynamic subtest: smem0
[491.789453] Dynamic subtest smem0: SUCCESS (0.003s)
[491.790140] Subtest partial-remap: SUCCESS (0.004s)
[491.908810] [140/156] (552s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[492.004068] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[492.005507] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[492.108511] [141/156] (552s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[492.200691] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[492.202068] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[492.307034] [142/156] (552s left) i915_power (sanity)
[492.340888] Starting subtest: sanity
[496.365482] Subtest sanity: SUCCESS (4.016s)
[496.473676] [143/156] (548s left) gem_exec_schedule (preempt-queue)
[496.527262] Starting subtest: preempt-queue
[496.527993] Starting dynamic subtest: rcs0
[496.646408] Dynamic subtest rcs0: SUCCESS (0.110s)
[496.656565] Starting dynamic subtest: bcs0
[496.747993] Dynamic subtest bcs0: SUCCESS (0.109s)
[496.759856] Starting dynamic subtest: vcs0
[496.853339] Dynamic subtest vcs0: SUCCESS (0.104s)
[496.865710] Starting dynamic subtest: vcs1
[496.961134] Dynamic subtest vcs1: SUCCESS (0.106s)
[496.971362] Starting dynamic subtest: vecs0
[497.068691] Dynamic subtest vecs0: SUCCESS (0.107s)
[497.069529] Subtest preempt-queue: SUCCESS (0.542s)
[497.379023] [144/156] (547s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[497.473684] Starting subtest: cursorB-vs-flipA-legacy
[497.475303] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[497.536336] [145/156] (547s left) i915_pm_rps (reset)
[497.576032] Starting subtest: reset
[502.140147] Subtest reset: SUCCESS (4.534s)
[502.209326] [146/156] (542s left) kms_psr (fbc-psr-cursor-plane-onoff)
[502.301192] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[502.348210] [147/156] (542s left) kms_setmode (clone-exclusive-crtc)
[502.383048] Starting subtest: clone-exclusive-crtc
[502.385268] Subtest clone-exclusive-crtc: SKIP (0.000s)
[502.445014] [148/156] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[502.538063] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[502.539481] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[502.637447] [149/156] (542s left) kms_flip (flip-vs-rmfb)
[502.727927] Starting subtest: flip-vs-rmfb
[502.730585] Starting dynamic subtest: A-HDMI-A1
[510.441952] Dynamic subtest A-HDMI-A1: SUCCESS (7.714s)
[510.459614] Starting dynamic subtest: B-HDMI-A1
[518.097511] Dynamic subtest B-HDMI-A1: SUCCESS (7.652s)
[518.118761] Starting dynamic subtest: C-HDMI-A1
[525.769425] Dynamic subtest C-HDMI-A1: SUCCESS (7.663s)
[525.790278] Starting dynamic subtest: D-HDMI-A1
[533.442549] Dynamic subtest D-HDMI-A1: SUCCESS (7.666s)
[533.447835] Subtest flip-vs-rmfb: SUCCESS (30.717s)
[533.614275] [150/156] (511s left) gem_exec_whisper (basic-contexts-all)
[533.670446] Starting subtest: basic-contexts-all
[535.424147] Subtest basic-contexts-all: SUCCESS (1.753s)
[535.611528] [151/156] (509s left) dmabuf_sync_file (export-basic)
[535.653621] Starting subtest: export-basic
[535.654338] Subtest export-basic: SUCCESS (0.001s)
[535.727259] [152/156] (509s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[535.825220] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[535.826672] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[535.926629] [153/156] (509s left) gem_sync (basic-each)
[535.972937] Starting subtest: basic-each
[538.068840] Subtest basic-each: SUCCESS (2.095s)
[538.274317] [154/156] (507s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[538.370515] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[538.372768] Starting dynamic subtest: pipe-A-HDMI-A-1
[538.380860] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[538.395301] Starting dynamic subtest: pipe-B-HDMI-A-1
[538.403053] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[538.416318] Starting dynamic subtest: pipe-C-HDMI-A-1
[538.423874] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[538.433245] Starting dynamic subtest: pipe-D-HDMI-A-1
[538.441092] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[538.442433] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[538.645119] [155/156] (506s left) syncobj_wait (multi-wait-for-submit-submitted)
[538.683390] Starting subtest: multi-wait-for-submit-submitted
[538.786711] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[538.884488] [156/156] (506s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[538.977110] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[538.978512] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[539.077271] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_pipe_b_c_ivb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_force_connector_basic
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: gem_ccs
results: parsing output: 7/ for test: kms_plane_alpha_blend
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: sysfs_heartbeat_interval
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: i915_pm_freq_mult
results: parsing output: 22/ for test: prime_busy
results: parsing output: 23/ for test: gem_exec_gttfill
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_ctx_param
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_lmem_swapping
results: parsing output: 28/ for test: gem_ctx_shared
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_bad_reloc
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_content_protection
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gem_ctx_isolation
results: parsing output: 37/ for test: gem_flink_basic
results: parsing output: 38/ for test: gem_caching
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_pm_rpm
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_spin_batch
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: gem_pxp
results: parsing output: 57/ for test: gem_fence_thrash
results: parsing output: 58/ for test: gen9_exec_parse
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_pwrite_crc
results: parsing output: 64/ for test: gem_flink_basic
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: gen7_exec_parse
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_color_pipeline
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_draw_crc
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_chamelium_audio
results: parsing output: 100/ for test: kms_addfb_basic
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_sequence
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: kms_force_connector_basic
results: parsing output: 115/ for test: kms_chamelium_edid
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: vgem_basic
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: gem_ctx_exec
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: gem_ppgtt
results: parsing output: 133/ for test: gem_exec_reloc
results: parsing output: 134/ for test: gem_softpin
results: parsing output: 135/ for test: gem_exec_capture
results: parsing output: 136/ for test: gem_tiled_blits
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_mmap_offset
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: i915_power
results: parsing output: 142/ for test: gem_exec_schedule
results: parsing output: 143/ for test: kms_cursor_legacy
results: parsing output: 144/ for test: i915_pm_rps
results: parsing output: 145/ for test: kms_psr
results: parsing output: 146/ for test: kms_setmode
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_flip
results: parsing output: 149/ for test: gem_exec_whisper
results: parsing output: 150/ for test: dmabuf_sync_file
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_sync
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: syncobj_wait
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.