[58.391432] Initializing watchdogs
[58.391480]   /dev/watchdog0
[58.407087] [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]
[58.411686] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.413946] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.415912] [001/156] (960s left) gem_mmap_gtt (basic-small-copy)
[58.477724] Subtest basic-small-copy: SKIP (0.000s)
[58.528624] [002/156] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[58.624189] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[58.625988] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[58.699659] [003/156] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[58.745054] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[58.746042] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[58.839318] [004/156] (960s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[58.890638] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[58.892863] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[59.066412] [005/156] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[59.156937] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[59.158826] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[59.234536] [006/156] (959s left) gem_lmem_swapping (heavy-verify-random)
[59.271957] Subtest heavy-verify-random: SKIP (0.000s)
[59.308468] [007/156] (959s left) gem_exec_whisper (basic-fds-priority)
[59.375572] Starting subtest: basic-fds-priority
[83.207723] Subtest basic-fds-priority: SUCCESS (23.821s)
[83.376602] [008/156] (935s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[83.473991] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[91.194475] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.722s)
[91.320524] [009/156] (927s left) kms_flip (2x-flip-vs-panning-interruptible)
[91.410283] Starting subtest: 2x-flip-vs-panning-interruptible
[91.423478] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[91.491700] [010/156] (927s left) gem_exec_schedule (out-order)
[91.544289] Starting subtest: out-order
[91.545260] Starting dynamic subtest: rcs0
[91.646563] Dynamic subtest rcs0: SUCCESS (0.103s)
[91.656375] Starting dynamic subtest: vcs0
[91.729080] Dynamic subtest vcs0: SUCCESS (0.082s)
[91.736290] Starting dynamic subtest: vcs1
[91.813980] Dynamic subtest vcs1: SUCCESS (0.084s)
[91.825096] Starting dynamic subtest: vecs0
[91.890860] Dynamic subtest vecs0: SUCCESS (0.077s)
[91.901388] Starting dynamic subtest: ccs0
[91.975946] Dynamic subtest ccs0: SUCCESS (0.086s)
[91.977067] Subtest out-order: SUCCESS (0.433s)
[93.436223] [011/156] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[93.534392] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[93.536045] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[93.623801] [012/156] (925s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[93.713567] Starting subtest: psr-rgb565-draw-mmap-gtt
[93.715527] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[93.811971] [013/156] (925s left) gem_pxp (verify-pxp-stale-ctx-execution)
[93.932877] Starting subtest: verify-pxp-stale-ctx-execution
[94.991310] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s)
[95.096889] [014/156] (924s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[95.471062] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[96.245307] [015/156] (923s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[96.340467] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[97.463432] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.123s)
[97.579786] [016/156] (921s left) kms_lease (master-vs-lease)
[97.676451] Starting subtest: master-vs-lease
[97.677439] Subtest master-vs-lease: SUCCESS (0.001s)
[97.771042] [017/156] (921s left) kms_psr (psr2-sprite-render)
[97.856185] Starting subtest: psr2-sprite-render
[97.857172] Starting dynamic subtest: eDP-1
[99.562210] Dynamic subtest eDP-1: SUCCESS (1.705s)
[99.563268] Subtest psr2-sprite-render: SUCCESS (1.706s)
[100.449154] [018/156] (919s left) gem_exec_fence (syncobj-timeline-chain-engines)
[101.052563] Starting subtest: syncobj-timeline-chain-engines
[101.150369] Subtest syncobj-timeline-chain-engines: SUCCESS (0.107s)
[102.393534] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[102.396184] [019/156] (917s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[102.482429] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[102.484223] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[102.562591] [020/156] (916s left) kms_flip (modeset-vs-vblank-race-interruptible)
[102.650458] Starting subtest: modeset-vs-vblank-race-interruptible
[102.652608] Starting dynamic subtest: A-eDP1
[107.455407] Dynamic subtest A-eDP1: SUCCESS (4.802s)
[107.465505] Starting dynamic subtest: B-eDP1
[112.274793] Dynamic subtest B-eDP1: SUCCESS (4.818s)
[112.287874] Starting dynamic subtest: C-eDP1
[116.999433] Dynamic subtest C-eDP1: SUCCESS (4.723s)
[117.010766] Starting dynamic subtest: D-eDP1
[121.638474] Dynamic subtest D-eDP1: SUCCESS (4.637s)
[121.641346] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.990s)
[122.790665] [021/156] (896s left) syncobj_timeline (multi-wait-all-available-signaled)
[122.842458] Starting subtest: multi-wait-all-available-signaled
[122.843523] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[122.921809] [022/156] (896s left) gem_ctx_isolation (preservation-reset)
[123.096461] Starting subtest: preservation-reset
[123.097511] Starting dynamic subtest: rcs0
[123.383283] Dynamic subtest rcs0: SUCCESS (0.296s)
[123.394778] Starting dynamic subtest: bcs0
[123.727499] Dynamic subtest bcs0: SUCCESS (0.343s)
[123.740710] Starting dynamic subtest: vcs0
[124.068754] Dynamic subtest vcs0: SUCCESS (0.341s)
[124.079450] Starting dynamic subtest: vcs1
[125.647361] Dynamic subtest vcs1: SUCCESS (1.578s)
[125.656261] Starting dynamic subtest: vecs0
[127.620648] Dynamic subtest vecs0: SUCCESS (1.972s)
[127.631617] Starting dynamic subtest: ccs0
[129.622405] Dynamic subtest ccs0: SUCCESS (2.002s)
[129.623982] Subtest preservation-reset: SUCCESS (6.537s)
[129.731762] [023/156] (889s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[129.782425] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[129.839767] [024/156] (889s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[129.940197] Starting subtest: x-tiled-16bpp-rotate-270
[129.960192] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[130.069340] [025/156] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[130.164838] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[130.166759] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[130.261051] [026/156] (889s left) kms_frontbuffer_tracking (fbc-tiling-4)
[130.348367] Starting subtest: fbc-tiling-4
[134.731810] Subtest fbc-tiling-4: SUCCESS (4.385s)
[135.894799] [027/156] (883s left) api_intel_bb (simple-bb)
[135.951367] Starting subtest: simple-bb
[135.958341] Subtest simple-bb: SUCCESS (0.008s)
[136.079391] [028/156] (883s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[136.121146] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[136.121981] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[136.229814] [029/156] (883s left) device_reset (unbind-cold-reset-rebind)
[136.285268] Starting subtest: unbind-cold-reset-rebind
[136.287086] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[136.348236] [030/156] (883s left) kms_prop_blob (blob-prop-validate)
[136.401092] Starting subtest: blob-prop-validate
[136.402077] Subtest blob-prop-validate: SUCCESS (0.000s)
[136.486818] [031/156] (883s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[136.583290] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[136.584871] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[136.680246] [032/156] (883s left) gem_ppgtt (flink-and-close-vma-leak)
[136.728132] Starting subtest: flink-and-close-vma-leak
[136.769902] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[136.897743] [033/156] (883s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[136.988123] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[141.197692] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.210s)
[142.381786] [034/156] (877s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[142.425459] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[142.426458] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[142.516863] [035/156] (877s left) syncobj_wait (invalid-signal-one-illegal-handle)
[142.563337] Starting subtest: invalid-signal-one-illegal-handle
[142.564398] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[142.670438] [036/156] (877s left) kms_vrr (seamless-rr-switch-drrs)
[142.749860] Starting subtest: seamless-rr-switch-drrs
[142.752370] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[142.819930] [037/156] (877s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[142.908768] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[142.910442] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[143.010133] [038/156] (877s left) kms_psr (pr-primary-mmap-cpu)
[143.101921] Starting subtest: pr-primary-mmap-cpu
[143.103801] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[143.169707] [039/156] (877s left) kms_dp_link_training (non-uhbr-mst)
[143.254362] Starting subtest: non-uhbr-mst
[143.257819] Subtest non-uhbr-mst: SKIP (0.000s)
[143.322421] [040/156] (876s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[143.414105] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[143.414970] Starting dynamic subtest: pipe-A-eDP-1
[143.418609] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[143.426732] Starting dynamic subtest: pipe-B-eDP-1
[143.430146] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[143.437910] Starting dynamic subtest: pipe-C-eDP-1
[143.441378] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[143.448929] Starting dynamic subtest: pipe-D-eDP-1
[143.452473] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[143.454151] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[145.726503] [041/156] (874s left) gem_exec_async (forked-writes)
[145.793575] Starting subtest: forked-writes
[145.794453] Starting dynamic subtest: rcs0
[145.818852] Dynamic subtest rcs0: SUCCESS (0.026s)
[145.828624] Starting dynamic subtest: bcs0
[145.844105] Dynamic subtest bcs0: SUCCESS (0.024s)
[145.853081] Starting dynamic subtest: vcs0
[145.866302] Dynamic subtest vcs0: SUCCESS (0.022s)
[145.875673] Starting dynamic subtest: vcs1
[145.890308] Dynamic subtest vcs1: SUCCESS (0.024s)
[145.899235] Starting dynamic subtest: vecs0
[145.911551] Dynamic subtest vecs0: SUCCESS (0.021s)
[145.920290] Starting dynamic subtest: ccs0
[145.933607] Dynamic subtest ccs0: SUCCESS (0.021s)
[145.934541] Subtest forked-writes: SUCCESS (0.142s)
[146.158575] [042/156] (874s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[146.249844] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[146.251716] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[146.334845] [043/156] (874s left) gem_create (create-massive)
[146.396715] Starting subtest: create-massive
[146.397752] Subtest create-massive: SUCCESS (0.000s)
[146.576673] [044/156] (873s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render)
[146.668062] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render
[146.669676] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[146.755897] [045/156] (873s left) gem_eio (in-flight-external)
[146.988557] Starting subtest: in-flight-external
[148.396141] Subtest in-flight-external: SUCCESS (1.407s)
[148.509890] [046/156] (871s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[148.622154] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[159.813085] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.188s)
[160.661989] [047/156] (859s left) kms_rotation_crc (primary-rotation-180)
[160.752339] Starting subtest: primary-rotation-180
[167.723288] Subtest primary-rotation-180: SUCCESS (6.971s)
[168.918730] [048/156] (851s left) kms_pm_backlight (basic-brightness)
[169.000267] Starting subtest: basic-brightness
[169.052191] Starting dynamic subtest: eDP-1
[169.568390] Dynamic subtest eDP-1: SUCCESS (0.516s)
[169.569268] Subtest basic-brightness: SUCCESS (0.568s)
[170.449446] [049/156] (850s left) kms_pipe_crc_basic (bad-source)
[170.541346] Starting subtest: bad-source
[170.542260] Subtest bad-source: SUCCESS (0.000s)
[170.607969] [050/156] (849s left) gem_mmap_gtt (basic-read-write-distinct)
[170.660031] Subtest basic-read-write-distinct: SKIP (0.000s)
[170.727895] [051/156] (849s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[170.817592] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[170.818460] Starting dynamic subtest: pipe-A-default-mode
[172.009814] Dynamic subtest pipe-A-default-mode: SKIP (1.192s)
[172.011569] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.193s)
[172.155238] [052/156] (848s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[172.249804] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[172.251571] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[172.330458] [053/156] (848s left) gem_tiled_pread_basic (basic)
[172.378748] Subtest basic: SKIP (0.000s)
[172.441434] [054/156] (848s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[172.527466] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[172.529157] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[172.617605] [055/156] (848s left) perf_pmu (multi-client)
[172.654788] Starting subtest: multi-client
[172.655758] Starting dynamic subtest: rcs0
[173.721602] Dynamic subtest rcs0: SUCCESS (1.058s)
[173.732642] Starting dynamic subtest: bcs0
[174.772435] Dynamic subtest bcs0: SUCCESS (1.048s)
[174.780751] Starting dynamic subtest: vcs0
[175.826627] Dynamic subtest vcs0: SUCCESS (1.051s)
[175.839919] Starting dynamic subtest: vcs1
[177.376062] Dynamic subtest vcs1: SUCCESS (1.546s)
[177.386017] Starting dynamic subtest: vecs0
[179.361977] Dynamic subtest vecs0: SUCCESS (1.983s)
[179.372343] Starting dynamic subtest: ccs0
[181.345755] Dynamic subtest ccs0: SUCCESS (1.980s)
[181.347274] Subtest multi-client: SUCCESS (8.684s)
[181.450837] [056/156] (839s left) kms_busy (extended-pageflip-hang-oldfb)
[181.549907] Starting subtest: extended-pageflip-hang-oldfb
[181.551042] Starting dynamic subtest: pipe-A
[181.953467] Dynamic subtest pipe-A: SUCCESS (0.401s)
[181.962031] Starting dynamic subtest: pipe-D
[183.105379] Dynamic subtest pipe-D: SUCCESS (1.151s)
[183.106464] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.556s)
[183.942575] [057/156] (836s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[184.041013] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[184.051964] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[184.124936] [058/156] (836s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[184.225163] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[184.226796] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[184.317416] [059/156] (836s left) sw_sync (sync_busy)
[184.348305] Starting subtest: sync_busy
[184.349218] Subtest sync_busy: SUCCESS (0.002s)
[184.403509] [060/156] (836s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[184.489081] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[184.490829] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[184.572624] [061/156] (836s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[184.661456] Starting subtest: pipe-fbc-rte
[184.664180] Starting dynamic subtest: pipe-B-eDP-1
[190.110838] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.450s)
[190.115034] Subtest pipe-fbc-rte: SUCCESS (5.453s)
[192.378099] [062/156] (828s left) gem_ccs (block-copy-uncompressed)
[192.435355] Starting subtest: block-copy-uncompressed
[192.436513] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[192.457511] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[192.467667] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[192.476048] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[192.485768] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[192.496661] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[192.505946] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[192.516133] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[192.516962] Subtest block-copy-uncompressed: SUCCESS (0.082s)
[192.640484] [063/156] (828s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[192.738832] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[192.740556] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[192.830535] [064/156] (828s left) kms_force_connector_basic (prune-stale-modes)
[192.899081] Starting subtest: prune-stale-modes
[193.286063] Subtest prune-stale-modes: SUCCESS (0.388s)
[193.418209] [065/156] (827s left) kms_async_flips (alternate-sync-async-flip)
[193.514345] Starting subtest: alternate-sync-async-flip
[193.890145] Starting dynamic subtest: pipe-A-eDP-1
[196.674062] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.784s)
[197.043313] Starting dynamic subtest: pipe-B-eDP-1
[199.869300] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.833s)
[200.250929] Starting dynamic subtest: pipe-C-eDP-1
[203.066768] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.823s)
[203.431165] Starting dynamic subtest: pipe-D-eDP-1
[206.267854] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.844s)
[206.268831] Subtest alternate-sync-async-flip: SUCCESS (12.754s)
[207.501187] [066/156] (813s left) gem_exec_balancer (parallel-balancer)
[207.790632] Starting subtest: parallel-balancer
[208.777273] Subtest parallel-balancer: SUCCESS (0.989s)
[208.872783] [067/156] (812s left) i915_drm_fdinfo (basics)
[208.906489] Starting subtest: basics
[208.907811] Subtest basics: SUCCESS (0.000s)
[208.967871] [068/156] (812s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render)
[209.068265] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render
[209.069843] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[209.173598] [069/156] (812s left) kms_force_connector_basic (force-connector-state)
[209.243480] Starting subtest: force-connector-state
[209.854879] Subtest force-connector-state: SUCCESS (0.611s)
[210.844543] [070/156] (810s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[210.948704] Starting subtest: fbcpsr-rgb101010-draw-blt
[215.907109] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.968s)
[216.052136] [071/156] (805s left) i915_query (query-topology-garbage-items)
[216.103325] Starting subtest: query-topology-garbage-items
[216.104083] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[216.199777] [072/156] (805s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[216.294702] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[216.296428] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[216.385824] [073/156] (804s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[216.504350] Starting subtest: basic-flip-after-cursor-atomic
[217.422053] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.916s)
[218.312622] [074/156] (803s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[218.407256] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[218.418039] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[218.537654] [075/156] (802s left) perf_pmu (invalid-init)
[218.571434] Starting subtest: invalid-init
[218.572377] Subtest invalid-init: SUCCESS (0.000s)
[218.674269] [076/156] (802s left) kms_psr (fbc-pr-cursor-plane-move)
[218.755389] Starting subtest: fbc-pr-cursor-plane-move
[218.757127] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[218.826586] [077/156] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[218.922300] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[226.034385] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.111s)
[226.200407] [078/156] (795s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[226.260874] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[226.261719] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[226.350048] [079/156] (795s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[226.448763] Starting subtest: psr-1p-primscrn-spr-indfb-move
[233.789670] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.342s)
[233.922083] [080/156] (787s left) gen9_exec_parse (bb-start-cmd)
[233.970533] Subtest bb-start-cmd: SKIP (0.000s)
[234.032859] [081/156] (787s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[234.122598] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[234.124344] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[234.201348] [082/156] (787s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[234.301125] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[234.302798] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[234.385711] [083/156] (787s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[234.482706] Starting subtest: fbc-psr-sprite-mmap-cpu
[234.483751] Starting dynamic subtest: eDP-1
[234.485932] Dynamic subtest eDP-1: SKIP (0.000s)
[234.487769] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[234.550867] [084/156] (787s left) kms_content_protection (dp-mst-lic-type-1)
[234.689071] Starting subtest: dp-mst-lic-type-1
[234.690810] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[234.841478] [085/156] (786s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[234.932388] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[234.934098] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[235.021741] [086/156] (786s left) i915_pm_freq_api (freq-basic-api)
[235.075180] Starting subtest: freq-basic-api
[235.076401] Starting dynamic subtest: gt0
[235.077550] Dynamic subtest gt0: SUCCESS (0.003s)
[235.088029] Starting dynamic subtest: gt1
[235.089229] Dynamic subtest gt1: SUCCESS (0.002s)
[235.090229] Subtest freq-basic-api: SUCCESS (0.007s)
[235.181217] [087/156] (786s left) kms_flip (blocking-wf_vblank)
[235.265953] Starting subtest: blocking-wf_vblank
[235.266950] Starting dynamic subtest: A-eDP1
[244.248087] Dynamic subtest A-eDP1: SUCCESS (8.955s)
[244.256850] Starting dynamic subtest: B-eDP1
[253.143330] Dynamic subtest B-eDP1: SUCCESS (8.893s)
[253.152274] Starting dynamic subtest: C-eDP1
[262.044983] Dynamic subtest C-eDP1: SUCCESS (8.888s)
[262.054088] Starting dynamic subtest: D-eDP1
[270.950508] Dynamic subtest D-eDP1: SUCCESS (8.904s)
[270.951597] Subtest blocking-wf_vblank: SUCCESS (35.652s)
[272.095630] [088/156] (749s left) kms_frontbuffer_tracking (psrhdr-suspend)
[272.189906] Starting subtest: psrhdr-suspend
[272.191709] Subtest psrhdr-suspend: SKIP (0.000s)
[272.287510] [089/156] (749s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[272.390584] Starting subtest: flip-vs-cursor-busy-crc-atomic
[273.111156] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.720s)
[274.004848] [090/156] (747s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[274.125612] Starting subtest: flip-vs-cursor-toggle
[283.375753] Subtest flip-vs-cursor-toggle: SUCCESS (9.249s)
[284.192623] [091/156] (737s left) kms_properties (get_properties-sanity-non-atomic)
[284.276229] Starting subtest: get_properties-sanity-non-atomic
[284.276974] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[284.344355] [092/156] (737s left) syncobj_eventfd (binary-wait-signaled)
[284.384201] Starting subtest: binary-wait-signaled
[284.385438] Subtest binary-wait-signaled: SUCCESS (0.000s)
[284.457764] [093/156] (737s left) kms_cdclk (plane-scaling)
[284.539220] Starting subtest: plane-scaling
[284.539987] Starting dynamic subtest: pipe-A-eDP-1
[284.834251] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[284.843992] Starting dynamic subtest: pipe-B-eDP-1
[284.845588] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[284.853675] Starting dynamic subtest: pipe-C-eDP-1
[284.855392] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[284.863411] Starting dynamic subtest: pipe-D-eDP-1
[284.865029] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[284.866577] Subtest plane-scaling: SKIP (0.302s)
[285.711488] [094/156] (736s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[285.811986] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[285.813744] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[285.910248] [095/156] (736s left) syncobj_wait (single-wait-signaled)
[285.957813] Starting subtest: single-wait-signaled
[285.958801] Subtest single-wait-signaled: SUCCESS (0.000s)
[286.057213] [096/156] (736s left) gem_exec_flush (basic-uc-rw-default)
[286.112548] Starting subtest: basic-uc-rw-default
[291.565804] Subtest basic-uc-rw-default: SUCCESS (5.452s)
[291.761887] [097/156] (730s left) gem_mmap_gtt (flink-race)
[291.814537] Subtest flink-race: SKIP (0.000s)
[291.875650] [098/156] (730s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[291.918765] Starting subtest: wait-all-for-submit-delayed-submit
[292.021752] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[292.112518] [099/156] (730s left) kms_atomic_transition (modeset-transition-fencing)
[292.208153] Starting subtest: modeset-transition-fencing
[292.212984] Starting dynamic subtest: 1x-outputs
[303.067181] Dynamic subtest 1x-outputs: SUCCESS (10.858s)
[303.068706] Subtest modeset-transition-fencing: SUCCESS (10.860s)
[303.900037] [100/156] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[303.992242] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[303.993907] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[304.089207] [101/156] (718s left) gem_exec_fence (syncobj-wait)
[304.526439] Starting subtest: syncobj-wait
[306.373269] Subtest syncobj-wait: SUCCESS (1.837s)
[306.713919] [102/156] (715s left) gem_exec_balancer (sliced)
[306.771672] Starting subtest: sliced
[306.773696] Subtest sliced: SKIP (0.000s)
[307.052302] [103/156] (715s left) kms_cursor_legacy (forked-bo)
[307.171982] Starting subtest: forked-bo
[307.173041] Starting dynamic subtest: pipe-A
[312.663783] Dynamic subtest pipe-A: SUCCESS (5.481s)
[312.676850] Starting dynamic subtest: pipe-B
[318.134082] Dynamic subtest pipe-B: SUCCESS (5.467s)
[318.149554] Starting dynamic subtest: pipe-C
[323.642200] Dynamic subtest pipe-C: SUCCESS (5.468s)
[323.653099] Starting dynamic subtest: pipe-D
[329.120182] Dynamic subtest pipe-D: SUCCESS (5.474s)
[329.134771] Starting dynamic subtest: all-pipes
[334.616888] Dynamic subtest all-pipes: SUCCESS (5.496s)
[334.618067] Subtest forked-bo: SUCCESS (27.398s)
[334.713685] [104/156] (687s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[334.818157] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[335.543399] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.647s)
[335.616909] [105/156] (686s left) kms_pipe_crc_basic (read-crc)
[335.714426] Starting subtest: read-crc
[335.715337] Starting dynamic subtest: pipe-A-eDP-1
[336.432671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[336.441563] Starting dynamic subtest: pipe-B-eDP-1
[337.847072] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s)
[337.855227] Starting dynamic subtest: pipe-C-eDP-1
[339.194739] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.346s)
[339.204640] Starting dynamic subtest: pipe-D-eDP-1
[340.507636] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[340.508611] Subtest read-crc: SUCCESS (4.794s)
[341.394878] [106/156] (681s left) kms_invalid_mode (bad-vtotal)
[341.489129] Starting subtest: bad-vtotal
[341.489971] Starting dynamic subtest: pipe-A-eDP-1
[341.777218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[341.785613] Starting dynamic subtest: pipe-B-eDP-1
[341.786495] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[341.794573] Starting dynamic subtest: pipe-C-eDP-1
[341.795506] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[341.804709] Starting dynamic subtest: pipe-D-eDP-1
[341.805603] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[341.806469] Subtest bad-vtotal: SUCCESS (0.294s)
[342.591567] [107/156] (679s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[342.684418] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[342.686240] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[342.752316] [108/156] (679s left) syncobj_basic (create-signaled)
[342.804503] Starting subtest: create-signaled
[342.805404] Subtest create-signaled: SUCCESS (0.000s)
[342.892715] [109/156] (679s left) i915_pm_rpm (gem-pread)
[344.525035] Starting subtest: gem-pread
[346.585193] Subtest gem-pread: SUCCESS (2.060s)
[346.668965] [110/156] (675s left) sysfs_heartbeat_interval (precise)
[346.722473] Starting subtest: precise
[346.723316] Starting dynamic subtest: vecs0
[354.345811] Dynamic subtest vecs0: SUCCESS (7.612s)
[354.355664] Starting dynamic subtest: ccs0
[355.489469] Dynamic subtest ccs0: SUCCESS (1.149s)
[355.498481] Starting dynamic subtest: vcs0
[363.292796] Dynamic subtest vcs0: SUCCESS (7.803s)
[363.306519] Starting dynamic subtest: bcs0
[366.330781] Dynamic subtest bcs0: SUCCESS (3.033s)
[366.341220] Starting dynamic subtest: rcs0
[367.439715] Dynamic subtest rcs0: SUCCESS (1.107s)
[367.448648] Starting dynamic subtest: vcs1
[375.323888] Dynamic subtest vcs1: SUCCESS (7.884s)
[375.327039] Subtest precise: SUCCESS (28.601s)
[375.411744] [111/156] (647s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[375.501138] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[375.502879] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[375.588814] [112/156] (647s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[375.673067] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[375.675138] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[375.770450] [113/156] (646s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[375.875239] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[375.876894] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[375.963225] [114/156] (646s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[376.057281] Starting subtest: plane-ctm3x4-lut1d
[376.227228] Starting dynamic subtest: pipe-A-plane-0
[376.404683] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[376.413901] Starting dynamic subtest: pipe-A-plane-1
[376.593556] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[376.603075] Starting dynamic subtest: pipe-A-plane-2
[376.738364] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[378.013033] Starting dynamic subtest: pipe-B-plane-0
[378.181590] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[378.190606] Starting dynamic subtest: pipe-B-plane-1
[378.437313] Dynamic subtest pipe-B-plane-1: SUCCESS (0.255s)
[378.448627] Starting dynamic subtest: pipe-B-plane-2
[378.681867] Dynamic subtest pipe-B-plane-2: SUCCESS (0.244s)
[379.879842] Starting dynamic subtest: pipe-C-plane-0
[380.009145] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[380.018220] Starting dynamic subtest: pipe-C-plane-1
[380.164893] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[380.174495] Starting dynamic subtest: pipe-C-plane-2
[380.320200] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[381.583550] Starting dynamic subtest: pipe-D-plane-0
[381.728331] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[381.737349] Starting dynamic subtest: pipe-D-plane-1
[381.894324] Dynamic subtest pipe-D-plane-1: SUCCESS (0.165s)
[381.906121] Starting dynamic subtest: pipe-D-plane-2
[382.060985] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[382.358572] Subtest plane-ctm3x4-lut1d: SUCCESS (6.301s)
[383.189757] [115/156] (639s left) gem_userptr_blits (process-exit)
[383.242356] Starting subtest: process-exit
[383.248560] Subtest process-exit: SUCCESS (0.006s)
[383.372862] [116/156] (639s left) kms_atomic_transition (plane-all-transition-fencing)
[383.460399] Starting subtest: plane-all-transition-fencing
[383.461255] Starting dynamic subtest: pipe-A-eDP-1
[385.958838] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[386.263272] Starting dynamic subtest: pipe-B-eDP-1
[389.500535] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.245s)
[389.797063] Subtest plane-all-transition-fencing: SUCCESS (6.336s)
[390.687464] [117/156] (632s left) syncobj_timeline (single-wait-signaled)
[390.735119] Starting subtest: single-wait-signaled
[390.736258] Subtest single-wait-signaled: SUCCESS (0.000s)
[390.848007] [118/156] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[390.944176] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[390.945866] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[391.055724] [119/156] (631s left) kms_sequence (get-forked-busy)
[391.142405] Starting subtest: get-forked-busy
[391.143406] Starting dynamic subtest: pipe-A-eDP-1
[393.077862] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[393.086967] Starting dynamic subtest: pipe-B-eDP-1
[395.665462] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.588s)
[395.675102] Starting dynamic subtest: pipe-C-eDP-1
[398.239283] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.572s)
[398.247551] Starting dynamic subtest: pipe-D-eDP-1
[400.840011] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.599s)
[400.841086] Subtest get-forked-busy: SUCCESS (9.698s)
[401.693770] [120/156] (621s left) kms_chamelium_frames (hdmi-aspect-ratio)
[402.077223] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[402.866086] [121/156] (620s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[402.963994] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[402.965877] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[403.053684] [122/156] (620s left) kms_pm_rpm (i2c)
[404.565925] Starting subtest: i2c
[409.979542] Subtest i2c: SUCCESS (5.414s)
[410.062416] [123/156] (613s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[410.117594] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[410.220796] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[410.304672] [124/156] (612s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[410.396481] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[410.398203] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[410.494101] [125/156] (612s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[410.685969] Starting subtest: cursor-rapid-movement-64x21
[410.729654] Subtest cursor-rapid-movement-64x21: SKIP (0.042s)
[410.955308] [126/156] (612s left) gem_vm_create (execbuf)
[411.011957] Starting subtest: execbuf
[411.017979] Subtest execbuf: SUCCESS (0.006s)
[411.135700] [127/156] (612s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[411.221751] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[411.223396] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[411.322350] [128/156] (611s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[411.413136] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[411.414955] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[411.527881] [129/156] (611s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[411.627568] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[411.630451] Starting dynamic subtest: A-eDP1
[415.382700] Dynamic subtest A-eDP1: SUCCESS (3.750s)
[415.392649] Starting dynamic subtest: B-eDP1
[418.662958] Dynamic subtest B-eDP1: SUCCESS (3.281s)
[418.671628] Starting dynamic subtest: C-eDP1
[421.880807] Dynamic subtest C-eDP1: SUCCESS (3.216s)
[421.889342] Starting dynamic subtest: D-eDP1
[425.112785] Dynamic subtest D-eDP1: SUCCESS (3.230s)
[425.113727] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.487s)
[425.924249] [130/156] (597s left) kms_cursor_crc (cursor-offscreen-512x512)
[426.186656] Starting subtest: cursor-offscreen-512x512
[426.188367] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[426.336163] [131/156] (597s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[426.439349] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[426.440272] Starting dynamic subtest: pipe-A-eDP-1
[426.448289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[426.457417] Starting dynamic subtest: pipe-B-eDP-1
[426.466540] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[426.476934] Starting dynamic subtest: pipe-C-eDP-1
[426.484334] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[426.492667] Starting dynamic subtest: pipe-D-eDP-1
[426.499559] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[426.500332] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[428.793427] [132/156] (594s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[428.880334] Starting subtest: bad-pixel-format-y-tiled-ccs
[428.881407] Starting dynamic subtest: pipe-A-eDP-1
[428.890082] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[428.898521] Starting dynamic subtest: pipe-B-eDP-1
[428.907058] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[428.915894] Starting dynamic subtest: pipe-C-eDP-1
[428.924685] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[428.932808] Starting dynamic subtest: pipe-D-eDP-1
[428.941413] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[428.942868] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[431.159032] [133/156] (592s left) gem_render_tiled_blits (basic)
[431.211434] Subtest basic: SKIP (0.000s)
[431.264684] [134/156] (592s left) gem_ctx_persistence (saturated-hostile)
[431.316685] Starting subtest: saturated-hostile
[431.317630] Starting dynamic subtest: rcs0
[432.139874] Dynamic subtest rcs0: SUCCESS (0.823s)
[432.152282] Starting dynamic subtest: bcs0
[432.942800] Dynamic subtest bcs0: SUCCESS (0.802s)
[432.955643] Starting dynamic subtest: vcs0
[433.738642] Dynamic subtest vcs0: SUCCESS (0.794s)
[433.749707] Starting dynamic subtest: vcs1
[434.550392] Dynamic subtest vcs1: SUCCESS (0.807s)
[434.560475] Starting dynamic subtest: vecs0
[435.358634] Dynamic subtest vecs0: SUCCESS (0.808s)
[435.371064] Starting dynamic subtest: ccs0
[436.204752] Dynamic subtest ccs0: SUCCESS (0.844s)
[436.206300] Subtest saturated-hostile: SUCCESS (4.890s)
[436.280547] [135/156] (587s left) kms_psr (fbc-psr2-suspend)
[436.369331] Starting subtest: fbc-psr2-suspend
[436.370195] Starting dynamic subtest: eDP-1
[436.372142] Dynamic subtest eDP-1: SKIP (0.000s)
[436.373794] Subtest fbc-psr2-suspend: SKIP (0.001s)
[436.437482] [136/156] (587s left) gem_lmem_swapping (parallel-random-verify-ccs)
[436.474473] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[436.512836] [137/156] (587s left) kms_fb_coherency (memset-crc)
[436.599069] Starting subtest: memset-crc
[436.599989] Starting dynamic subtest: mmap-offset-wc
[436.986855] Dynamic subtest mmap-offset-wc: SUCCESS (0.388s)
[437.286751] Starting dynamic subtest: mmap-offset-uc
[443.480334] Dynamic subtest mmap-offset-uc: SUCCESS (6.202s)
[443.773702] Subtest memset-crc: SUCCESS (7.175s)
[444.661766] [138/156] (578s left) gem_render_copy (x-tiled)
[444.716498] Starting subtest: x-tiled
[444.717348] Starting dynamic subtest: smem
[444.763931] Dynamic subtest smem: SUCCESS (0.046s)
[444.765339] Subtest x-tiled: SUCCESS (0.048s)
[444.945932] [139/156] (578s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[445.038126] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[445.876357] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.838s)
[446.033314] [140/156] (577s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[446.118842] Starting subtest: psr-1p-pri-indfb-multidraw
[469.269302] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.151s)
[469.393226] [141/156] (554s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[469.490934] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[469.492651] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[469.594856] [142/156] (554s left) gem_partial_pwrite_pread (write)
[469.650126] Subtest write: SKIP (0.000s)
[469.709939] [143/156] (554s left) kms_plane_lowres (tiling-y)
[469.802219] Starting subtest: tiling-y
[469.804116] Subtest tiling-y: SKIP (0.000s)
[469.880775] [144/156] (553s left) kms_plane_scaling (planes-downscale-factor-0-75)
[469.970950] Starting subtest: planes-downscale-factor-0-75
[469.971890] Starting dynamic subtest: pipe-A
[469.989868] Dynamic subtest pipe-A: SKIP (0.018s)
[469.998663] Starting dynamic subtest: pipe-B
[470.022686] Dynamic subtest pipe-B: SKIP (0.032s)
[470.031845] Starting dynamic subtest: pipe-C
[470.055223] Dynamic subtest pipe-C: SKIP (0.032s)
[470.064864] Starting dynamic subtest: pipe-D
[470.087095] Dynamic subtest pipe-D: SKIP (0.032s)
[470.088555] Subtest planes-downscale-factor-0-75: SKIP (0.117s)
[470.200969] [145/156] (553s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[470.299390] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[470.301341] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[470.387906] [146/156] (553s left) gem_exec_params (secure-non-root)
[470.442539] Starting subtest: secure-non-root
[470.444289] Subtest secure-non-root: SKIP (0.000s)
[470.547785] [147/156] (553s left) api_intel_allocator (reloc-allocator)
[470.591725] Starting subtest: reloc-allocator
[470.592795] Starting dynamic subtest: basic
[470.595173] Dynamic subtest basic: SUCCESS (0.003s)
[470.607393] Starting dynamic subtest: parallel-one
[470.608319] Dynamic subtest parallel-one: SUCCESS (0.008s)
[470.616755] Starting dynamic subtest: print
[470.617610] Dynamic subtest print: SUCCESS (0.000s)
[470.625771] Starting dynamic subtest: reuse
[470.626668] Dynamic subtest reuse: SUCCESS (0.000s)
[470.634789] Starting dynamic subtest: fork-reopen-allocator
[470.635863] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[470.636809] Subtest reloc-allocator: SUCCESS (0.025s)
[470.747199] [148/156] (553s left) kms_psr (psr-sprite-mmap-gtt)
[470.835215] Starting subtest: psr-sprite-mmap-gtt
[470.836065] Starting dynamic subtest: eDP-1
[472.257810] Dynamic subtest eDP-1: SKIP (1.412s)
[472.260086] Subtest psr-sprite-mmap-gtt: SKIP (1.414s)
[472.429142] [149/156] (551s left) gem_exec_params (sol-reset-invalid)
[472.485115] Starting subtest: sol-reset-invalid
[472.488118] Subtest sol-reset-invalid: SUCCESS (0.002s)
[474.401963] [150/156] (549s left) gem_pxp (create-valid-protected-context)
[474.495334] Starting subtest: create-valid-protected-context
[474.498285] Subtest create-valid-protected-context: SUCCESS (0.002s)
[474.612435] [151/156] (549s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[474.699396] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[474.700480] Starting dynamic subtest: pipe-A-eDP-1
[474.726106] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[474.736071] Starting dynamic subtest: pipe-B-eDP-1
[474.764976] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[474.773388] Starting dynamic subtest: pipe-C-eDP-1
[474.793829] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[474.801716] Starting dynamic subtest: pipe-D-eDP-1
[474.821737] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[474.823351] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[477.034871] [152/156] (547s left) gem_exec_schedule (semaphore-resolve)
[477.092522] Starting subtest: semaphore-resolve
[477.142765] Subtest semaphore-resolve: SUCCESS (0.050s)
[477.482489] [153/156] (546s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[477.577453] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[477.579095] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[477.669355] [154/156] (546s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[477.763854] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[477.765364] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[477.854456] [155/156] (546s left) kms_vblank (wait-forked)
[477.944540] Starting subtest: wait-forked
[477.945475] Starting dynamic subtest: pipe-A-eDP-1
[479.781566] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.836s)
[479.793570] Starting dynamic subtest: pipe-D-eDP-1
[482.242032] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.459s)
[482.243052] Subtest wait-forked: SUCCESS (4.299s)
[483.116930] [156/156] (541s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[483.211954] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[483.213592] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[483.306890] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_lmem_swapping
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_pxp
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_lease
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_ctx_isolation
results: parsing output: 22/ for test: kms_pipe_b_c_ivb
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: device_reset
results: parsing output: 29/ for test: kms_prop_blob
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_ppgtt
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_dp_link_training
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_exec_async
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: kms_pm_backlight
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_tiled_pread_basic
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_busy
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_force_connector_basic
results: parsing output: 64/ for test: kms_async_flips
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: i915_drm_fdinfo
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_force_connector_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: i915_query
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_content_protection
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: i915_pm_freq_api
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_properties
results: parsing output: 91/ for test: syncobj_eventfd
results: parsing output: 92/ for test: kms_cdclk
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_exec_flush
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: gem_exec_balancer
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_invalid_mode
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: i915_pm_rpm
results: parsing output: 109/ for test: sysfs_heartbeat_interval
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_color_pipeline
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_atomic_transition
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_sequence
results: parsing output: 119/ for test: kms_chamelium_frames
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_pm_rpm
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: gem_vm_create
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_flip
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: gem_render_tiled_blits
results: parsing output: 133/ for test: gem_ctx_persistence
results: parsing output: 134/ for test: kms_psr
results: parsing output: 135/ for test: gem_lmem_swapping
results: parsing output: 136/ for test: kms_fb_coherency
results: parsing output: 137/ for test: gem_render_copy
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_partial_pwrite_pread
results: parsing output: 142/ for test: kms_plane_lowres
results: parsing output: 143/ for test: kms_plane_scaling
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_exec_params
results: parsing output: 146/ for test: api_intel_allocator
results: parsing output: 147/ for test: kms_psr
results: parsing output: 148/ for test: gem_exec_params
results: parsing output: 149/ for test: gem_pxp
results: parsing output: 150/ for test: kms_ccs
results: parsing output: 151/ for test: gem_exec_schedule
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_vblank
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.