[60.268175] Initializing watchdogs
[60.268225]   /dev/watchdog0
[60.283246] [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]
[60.287797] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.290140] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.293705] [001/131] (960s left) gem_ctx_bad_destroy (double-destroy)
[60.368822] Starting subtest: double-destroy
[60.371304] Subtest double-destroy: SUCCESS (0.000s)
[60.482623] [002/131] (960s left) gem_exec_balancer (bonded-sync)
[60.544283] Starting subtest: bonded-sync
[60.548910] Subtest bonded-sync: SKIP (0.000s)
[60.845639] [003/131] (960s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[60.949054] Starting subtest: fbc-pr-sprite-mmap-cpu
[60.953724] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[61.023071] [004/131] (959s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[61.114537] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[61.118617] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[61.186150] [005/131] (959s left) kms_atomic (atomic-plane-damage)
[61.280149] Starting subtest: atomic-plane-damage
[61.369688] Starting dynamic subtest: pipe-A-eDP-1
[61.918534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s)
[61.920534] Subtest atomic-plane-damage: SUCCESS (0.639s)
[62.742279] [006/131] (958s left) gem_mmap_gtt (ptrace)
[62.800358] Subtest ptrace: SKIP (0.000s)
[62.856525] [007/131] (958s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[62.911775] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[62.980755] [008/131] (958s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[63.163161] Starting subtest: cursor-rapid-movement-64x64
[63.165524] Starting dynamic subtest: pipe-A-eDP-1
[63.708230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[63.739764] Starting dynamic subtest: pipe-D-eDP-1
[64.969938] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[64.972733] Subtest cursor-rapid-movement-64x64: SUCCESS (1.803s)
[65.808610] [009/131] (955s left) syncobj_timeline (reset-during-wait-for-submit)
[65.871050] Starting subtest: reset-during-wait-for-submit
[65.976397] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[66.047731] [010/131] (955s left) gem_ctx_isolation (dirty-create)
[66.104416] Starting subtest: dirty-create
[66.106798] Starting dynamic subtest: rcs0
[66.312989] Dynamic subtest rcs0: SUCCESS (0.209s)
[66.320729] Starting dynamic subtest: bcs0
[66.530634] Dynamic subtest bcs0: SUCCESS (0.217s)
[66.539045] Starting dynamic subtest: vcs0
[66.739218] Dynamic subtest vcs0: SUCCESS (0.208s)
[66.747061] Starting dynamic subtest: vcs1
[68.238829] Dynamic subtest vcs1: SUCCESS (1.499s)
[68.246591] Starting dynamic subtest: vecs0
[70.098514] Dynamic subtest vecs0: SUCCESS (1.859s)
[70.107720] Starting dynamic subtest: ccs0
[72.106426] Dynamic subtest ccs0: SUCCESS (2.007s)
[72.108547] Subtest dirty-create: SUCCESS (6.002s)
[72.340948] [011/131] (948s left) kms_addfb_basic (master-rmfb)
[72.398354] Starting subtest: master-rmfb
[72.400344] Subtest master-rmfb: SUCCESS (0.001s)
[72.537565] [012/131] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[72.642821] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[72.646858] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[72.740328] [013/131] (948s left) perf_pmu (rc6)
[72.782961] Starting subtest: rc6
[72.785225] Starting dynamic subtest: gt0
[79.159333] Dynamic subtest gt0: SUCCESS (6.374s)
[79.169663] Starting dynamic subtest: runtime-pm-gt0
[86.886867] Dynamic subtest runtime-pm-gt0: SUCCESS (7.724s)
[86.897204] Starting dynamic subtest: runtime-pm-long-gt0
[99.384080] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.497s)
[99.395189] Starting dynamic subtest: other-idle-gt0
[105.727321] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[105.738059] Starting dynamic subtest: gt1
[112.068366] Dynamic subtest gt1: SUCCESS (6.340s)
[112.079033] Starting dynamic subtest: runtime-pm-gt1
[119.551539] Dynamic subtest runtime-pm-gt1: SUCCESS (7.482s)
[119.562213] Starting dynamic subtest: runtime-pm-long-gt1
[131.998817] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.446s)
[132.009205] Starting dynamic subtest: other-idle-gt1
[138.341966] Dynamic subtest other-idle-gt1: SUCCESS (6.343s)
[138.344612] Subtest rc6: SUCCESS (65.556s)
[139.483331] [014/131] (881s left) gem_exec_schedule (noreorder-priority)
[139.675905] Starting subtest: noreorder-priority
[139.678052] Starting dynamic subtest: rcs0
[140.797896] Dynamic subtest rcs0: SUCCESS (1.124s)
[140.807463] Starting dynamic subtest: vcs0
[143.899336] Dynamic subtest vcs0: SUCCESS (3.099s)
[143.909795] Starting dynamic subtest: vcs1
[145.880393] Dynamic subtest vcs1: SUCCESS (1.979s)
[145.890722] Starting dynamic subtest: vecs0
[147.929852] Dynamic subtest vecs0: SUCCESS (2.047s)
[147.940896] Starting dynamic subtest: ccs0
[149.076398] Dynamic subtest ccs0: SUCCESS (1.147s)
[149.079255] Subtest noreorder-priority: SUCCESS (9.402s)
[149.239884] [015/131] (872s left) sw_sync (sync_multi_timeline_wait)
[149.282678] Starting subtest: sync_multi_timeline_wait
[149.284780] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[149.325677] [016/131] (872s left) gem_spin_batch (user-each)
[149.387885] Starting subtest: user-each
[152.669351] Subtest user-each: SUCCESS (3.272s)
[152.972976] [017/131] (868s left) gem_partial_pwrite_pread (write)
[153.042897] Subtest write: SKIP (0.000s)
[153.112200] [018/131] (868s left) gem_exec_params (no-blt)
[153.176612] Starting subtest: no-blt
[153.179056] Subtest no-blt: SUCCESS (0.005s)
[153.243811] [019/131] (868s left) gem_exec_whisper (basic-fds-priority)
[153.296294] Starting subtest: basic-fds-priority
[177.446091] Subtest basic-fds-priority: SUCCESS (24.147s)
[177.606223] [020/131] (843s left) kms_flip (plain-flip-interruptible)
[177.708949] Starting subtest: plain-flip-interruptible
[177.714648] Starting dynamic subtest: A-eDP1
[179.421873] Dynamic subtest A-eDP1: SUCCESS (1.711s)
[179.434757] Starting dynamic subtest: B-eDP1
[181.036132] Dynamic subtest B-eDP1: SUCCESS (1.612s)
[181.047387] Starting dynamic subtest: C-eDP1
[182.656678] Dynamic subtest C-eDP1: SUCCESS (1.620s)
[182.671129] Starting dynamic subtest: D-eDP1
[184.298986] Dynamic subtest D-eDP1: SUCCESS (1.642s)
[184.301529] Subtest plain-flip-interruptible: SUCCESS (6.594s)
[185.439431] [021/131] (836s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[185.535528] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[190.502350] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.970s)
[191.643555] [022/131] (829s left) gem_ctx_param (non-root-set)
[191.700754] Starting subtest: non-root-set
[191.723595] Subtest non-root-set: SUCCESS (0.023s)
[191.783864] [023/131] (829s left) kms_color_pipeline (plane-lut1d)
[191.881028] Starting subtest: plane-lut1d
[192.027027] Starting dynamic subtest: pipe-A-plane-0
[192.389311] Dynamic subtest pipe-A-plane-0: FAIL (0.183s)
[192.399056] Starting dynamic subtest: pipe-A-plane-1
[192.611141] Dynamic subtest pipe-A-plane-1: FAIL (0.169s)
[192.620025] Starting dynamic subtest: pipe-A-plane-2
[192.816357] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[193.769916] Starting dynamic subtest: pipe-B-plane-0
[194.205847] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[194.216411] Starting dynamic subtest: pipe-B-plane-1
[194.514268] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[194.526778] Starting dynamic subtest: pipe-B-plane-2
[194.807792] Dynamic subtest pipe-B-plane-2: FAIL (0.189s)
[195.473313] Starting dynamic subtest: pipe-C-plane-0
[195.964311] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[195.974419] Starting dynamic subtest: pipe-C-plane-1
[196.370736] Dynamic subtest pipe-C-plane-1: FAIL (0.155s)
[196.380057] Starting dynamic subtest: pipe-C-plane-2
[196.726597] Dynamic subtest pipe-C-plane-2: FAIL (0.640s)
[197.616568] Starting dynamic subtest: pipe-D-plane-0
[198.194125] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[198.204581] Starting dynamic subtest: pipe-D-plane-1
[198.654991] Dynamic subtest pipe-D-plane-1: FAIL (0.636s)
[198.664679] Starting dynamic subtest: pipe-D-plane-2
[199.080192] Dynamic subtest pipe-D-plane-2: FAIL (0.182s)
[199.081976] Subtest plane-lut1d: FAIL (6.979s)
[199.658225] [024/131] (822s left) kms_psr (psr-sprite-plane-onoff)
[199.756493] Starting subtest: psr-sprite-plane-onoff
[199.758758] Starting dynamic subtest: eDP-1
[201.521428] Dynamic subtest eDP-1: SUCCESS (1.764s)
[201.523703] Subtest psr-sprite-plane-onoff: SUCCESS (1.765s)
[202.313539] [025/131] (819s left) gem_eio (execbuf)
[202.536682] Starting subtest: execbuf
[202.873431] Subtest execbuf: SUCCESS (0.334s)
[203.000968] [026/131] (818s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[203.100295] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[204.234941] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.135s)
[204.337690] [027/131] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[204.426062] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[212.120820] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.697s)
[212.209760] [028/131] (809s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[212.265858] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[212.370368] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[212.423865] [029/131] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[212.526759] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[212.531315] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[212.604969] [030/131] (809s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[212.690851] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[212.692722] Starting dynamic subtest: pipe-A-eDP-1
[213.121080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s)
[213.132808] Starting dynamic subtest: pipe-B-eDP-1
[213.153633] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[213.164389] Starting dynamic subtest: pipe-C-eDP-1
[213.184067] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[213.192982] Starting dynamic subtest: pipe-D-eDP-1
[213.213667] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[213.215996] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.445s)
[215.425310] [031/131] (806s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[215.526067] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[215.528395] Starting dynamic subtest: pipe-A-eDP-1
[215.551424] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.562188] Starting dynamic subtest: pipe-B-eDP-1
[215.583776] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.592605] Starting dynamic subtest: pipe-C-eDP-1
[215.614236] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.623254] Starting dynamic subtest: pipe-D-eDP-1
[215.644570] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.648880] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[217.779157] [032/131] (804s left) kms_addfb_basic (basic)
[217.833525] Starting subtest: basic
[217.835877] Subtest basic: SUCCESS (0.000s)
[217.945020] [033/131] (804s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[218.339161] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[219.114819] [034/131] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[219.211072] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[219.215446] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[219.279903] [035/131] (802s left) gem_exec_schedule (semaphore-codependency)
[219.364094] Starting subtest: semaphore-codependency
[219.369078] Subtest semaphore-codependency: SUCCESS (0.012s)
[219.687663] [036/131] (802s left) device_reset (unbind-cold-reset-rebind)
[219.737228] Starting subtest: unbind-cold-reset-rebind
[219.741889] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[219.787496] [037/131] (802s left) kms_vblank (ts-continuation-idle-hang)
[219.887031] Starting subtest: ts-continuation-idle-hang
[219.888943] Starting dynamic subtest: pipe-A-eDP-1
[246.758721] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.871s)
[246.782881] Starting dynamic subtest: pipe-D-eDP-1
[271.638567] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.878s)
[271.641024] Subtest ts-continuation-idle-hang: SUCCESS (51.753s)
[272.469258] [038/131] (749s left) kms_hdr (bpc-switch)
[272.558285] Starting subtest: bpc-switch
[273.663903] Starting dynamic subtest: pipe-A-eDP-1
[277.152301] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.488s)
[277.154607] Subtest bpc-switch: SUCCESS (4.596s)
[277.253223] [039/131] (745s left) gem_fence_thrash (bo-write-verify-threaded-none)
[277.289784] Starting subtest: bo-write-verify-threaded-none
[277.306894] Subtest bo-write-verify-threaded-none: SKIP (0.016s)
[277.372671] [040/131] (744s left) i915_hangman (engine-error-state-capture)
[277.446780] Starting subtest: engine-error-state-capture
[277.449099] Starting dynamic subtest: rcs0
[280.885418] Dynamic subtest rcs0: SUCCESS (3.439s)
[280.897749] Starting dynamic subtest: bcs0
[286.901545] Dynamic subtest bcs0: SUCCESS (6.013s)
[286.914169] Starting dynamic subtest: vcs0
[292.854040] Dynamic subtest vcs0: SUCCESS (5.949s)
[292.866647] Starting dynamic subtest: vcs1
[298.805911] Dynamic subtest vcs1: SUCCESS (5.949s)
[298.825401] Starting dynamic subtest: vecs0
[304.821214] Dynamic subtest vecs0: SUCCESS (6.013s)
[304.839901] Starting dynamic subtest: ccs0
[309.877534] Dynamic subtest ccs0: SUCCESS (5.054s)
[309.880147] Subtest engine-error-state-capture: SUCCESS (32.431s)
[309.933510] [041/131] (712s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[310.062671] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[310.920662] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.859s)
[311.073101] [042/131] (711s left) i915_pm_rpm (gem-mmap-type)
[313.101845] Starting subtest: gem-mmap-type
[313.104732] Starting dynamic subtest: wb-smem0
[316.908971] Dynamic subtest wb-smem0: SUCCESS (3.809s)
[316.919106] Starting dynamic subtest: wc-smem0
[319.784319] Dynamic subtest wc-smem0: SUCCESS (2.873s)
[319.794962] Starting dynamic subtest: uc-smem0
[322.965788] Dynamic subtest uc-smem0: SUCCESS (3.182s)
[322.968153] Subtest gem-mmap-type: SUCCESS (9.867s)
[323.031375] [043/131] (699s left) gem_pxp (create-regular-context-2)
[323.158311] Starting subtest: create-regular-context-2
[323.160848] Subtest create-regular-context-2: SUCCESS (0.002s)
[323.241514] [044/131] (699s left) gem_watchdog (default-virtual)
[323.315225] Starting subtest: default-virtual
[329.588879] Subtest default-virtual: SUCCESS (6.284s)
[329.689863] [045/131] (692s left) kms_pm_dc (dc5-dpms-negative)
[330.788129] Starting subtest: dc5-dpms-negative
[330.792815] Subtest dc5-dpms-negative: SKIP (0.000s)
[330.845113] [046/131] (691s left) kms_psr (pr-sprite-blt)
[330.934339] Starting subtest: pr-sprite-blt
[330.938674] Subtest pr-sprite-blt: SKIP (0.000s)
[330.982231] [047/131] (691s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[331.083287] Starting subtest: compare-crc-sanitycheck-xr24
[331.085818] Starting dynamic subtest: pipe-A-eDP-1
[331.713992] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[331.727876] Starting dynamic subtest: pipe-B-eDP-1
[332.996563] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.280s)
[333.007140] Starting dynamic subtest: pipe-C-eDP-1
[334.267119] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.270s)
[334.280139] Starting dynamic subtest: pipe-D-eDP-1
[335.502118] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[335.504046] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.419s)
[336.316138] [048/131] (686s left) kms_lease (setcrtc-implicit-plane)
[336.412426] Starting subtest: setcrtc-implicit-plane
[336.414942] Starting dynamic subtest: pipe-A-eDP-1
[336.891036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[336.900668] Starting dynamic subtest: pipe-B-eDP-1
[338.088860] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.197s)
[338.098808] Starting dynamic subtest: pipe-C-eDP-1
[339.207071] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[339.217101] Starting dynamic subtest: pipe-D-eDP-1
[340.328902] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[340.330769] Subtest setcrtc-implicit-plane: SUCCESS (3.918s)
[341.164700] [049/131] (681s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[341.255042] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[341.257206] Starting dynamic subtest: pipe-A
[341.274451] Dynamic subtest pipe-A: SKIP (0.017s)
[341.286629] Starting dynamic subtest: pipe-B
[341.306754] Dynamic subtest pipe-B: SKIP (0.031s)
[341.316192] Starting dynamic subtest: pipe-C
[341.340313] Dynamic subtest pipe-C: SKIP (0.032s)
[341.349461] Starting dynamic subtest: pipe-D
[341.372014] Dynamic subtest pipe-D: SKIP (0.031s)
[341.376134] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.114s)
[341.445378] [050/131] (681s left) api_intel_bb (intel-bb-blit-y)
[341.505229] Starting subtest: intel-bb-blit-y
[345.219458] Subtest intel-bb-blit-y: SUCCESS (3.714s)
[345.318943] [051/131] (677s left) kms_joiner (basic-force-ultra-joiner)
[345.424428] Starting subtest: basic-force-ultra-joiner
[345.428714] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[345.470725] [052/131] (677s left) gem_exec_fence (long-history)
[345.954866] Starting subtest: long-history
[353.641662] Subtest long-history: SUCCESS (7.687s)
[354.475665] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[354.479225] [053/131] (668s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[354.581120] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[354.585431] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[354.631549] [054/131] (668s left) gem_ctx_exec (basic-invalid-context)
[354.696129] Starting subtest: basic-invalid-context
[354.700774] Subtest basic-invalid-context: SUCCESS (0.004s)
[354.808651] [055/131] (668s left) gem_ctx_param (get-priority-new-ctx)
[354.861855] Starting subtest: get-priority-new-ctx
[354.864304] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[354.946401] [056/131] (668s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[355.037270] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[361.612117] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.577s)
[361.701563] [057/131] (661s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[361.796089] Starting subtest: fbcpsr-shrfb-scaledprimary
[367.544524] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.750s)
[367.649548] [058/131] (655s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[367.750391] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[367.752607] Starting dynamic subtest: pipe-A-eDP-1
[367.809647] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[367.820849] Starting dynamic subtest: pipe-B-eDP-1
[367.878119] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[367.888524] Starting dynamic subtest: pipe-C-eDP-1
[367.946400] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[367.957154] Starting dynamic subtest: pipe-D-eDP-1
[368.014480] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[368.018887] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[370.025691] [059/131] (653s left) i915_selftest (perf)
[373.316991] Starting subtest: perf
[373.319269] Starting dynamic subtest: engine_cs
[377.609489] Dynamic subtest engine_cs: SUCCESS (4.296s)
[377.618676] Starting dynamic subtest: request
[384.853668] Dynamic subtest request: SUCCESS (7.242s)
[384.862424] Starting dynamic subtest: migrate
[387.695925] Dynamic subtest migrate: SUCCESS (2.841s)
[387.704801] Starting dynamic subtest: region
[393.392811] Dynamic subtest region: SUCCESS (5.695s)
[393.395314] Subtest perf: SUCCESS (20.081s)
[393.421077] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[393.421811] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[393.424981] [060/131] (629s left) gem_ctx_create (basic-files)
[394.883221] Starting subtest: basic-files
[397.049070] Subtest basic-files: SUCCESS (2.167s)
[398.887045] [FACT gem_ctx_create (basic-files)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[398.888308] [FACT gem_ctx_create (basic-files)] new: kernel.kmod_is_loaded.i915: true
[398.892063] [061/131] (624s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[398.956769] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[398.961127] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[399.114865] [062/131] (624s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[399.218611] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[399.222722] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[399.283601] [063/131] (623s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[399.384683] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[399.388754] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[399.434189] [064/131] (623s left) gen9_exec_parse (bb-start-far)
[399.498071] Subtest bb-start-far: SKIP (0.000s)
[399.567724] [065/131] (623s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[399.661706] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[399.666093] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[399.738718] [066/131] (623s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[399.833307] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[399.837312] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[399.901211] [067/131] (623s left) kms_cursor_crc (cursor-offscreen-32x32)
[400.047740] Starting subtest: cursor-offscreen-32x32
[400.102605] Subtest cursor-offscreen-32x32: SKIP (0.053s)
[400.362950] [068/131] (623s left) sysfs_timeslice_duration (duration)
[400.422450] Starting subtest: duration
[400.424230] Starting dynamic subtest: vecs0
[413.814396] Dynamic subtest vecs0: SUCCESS (13.388s)
[413.826282] Starting dynamic subtest: ccs0
[426.970914] Dynamic subtest ccs0: SUCCESS (13.155s)
[426.981828] Starting dynamic subtest: vcs0
[440.820448] Dynamic subtest vcs0: SUCCESS (13.845s)
[440.832201] Starting dynamic subtest: bcs0
[453.951302] Dynamic subtest bcs0: SUCCESS (13.129s)
[453.962982] Starting dynamic subtest: rcs0
[467.087966] Dynamic subtest rcs0: SUCCESS (13.134s)
[467.102526] Starting dynamic subtest: vcs1
[480.821375] Dynamic subtest vcs1: SUCCESS (13.728s)
[480.824159] Subtest duration: SUCCESS (80.396s)
[480.875907] [069/131] (542s left) gem_pxp (reject-modify-context-protection-off-3)
[481.002315] Starting subtest: reject-modify-context-protection-off-3
[481.005087] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[481.090252] [070/131] (542s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[481.194126] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[488.532317] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.340s)
[488.623498] [071/131] (534s left) gem_softpin (evict-active)
[488.683068] Starting subtest: evict-active
[488.687834] Subtest evict-active: SUCCESS (0.007s)
[488.755963] [072/131] (534s left) kms_cursor_crc (cursor-suspend)
[488.880638] Starting subtest: cursor-suspend
[488.883084] Starting dynamic subtest: pipe-A-eDP-1
[522.076215] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.021s)
[522.090835] Starting dynamic subtest: pipe-D-eDP-1
[555.100697] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.776s)
[555.103309] Subtest cursor-suspend: SUCCESS (7.800s)
[555.895627] [073/131] (467s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[556.007579] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[556.012089] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[556.052899] [074/131] (467s left) perf (polling-parameterized)
[556.148474] Starting subtest: polling-parameterized
[576.171745] Subtest polling-parameterized: SUCCESS (20.007s)
[576.225639] [075/131] (447s left) kms_panel_fitting (atomic-fastset)
[576.319124] Starting subtest: atomic-fastset
[576.321468] Starting dynamic subtest: pipe-A-eDP-1
[576.458319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[576.469296] Starting dynamic subtest: pipe-B-eDP-1
[577.694128] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.234s)
[577.705319] Starting dynamic subtest: pipe-C-eDP-1
[578.876169] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.180s)
[578.889152] Starting dynamic subtest: pipe-D-eDP-1
[580.003029] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[580.005741] Subtest atomic-fastset: SUCCESS (3.684s)
[581.144489] [076/131] (442s left) perf (global-sseu-config-invalid)
[581.211968] Starting subtest: global-sseu-config-invalid
[581.216915] Subtest global-sseu-config-invalid: SKIP (0.000s)
[581.262110] [077/131] (442s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[581.385724] Starting subtest: short-flip-before-cursor-toggle
[582.303316] Subtest short-flip-before-cursor-toggle: SUCCESS (0.917s)
[583.081156] [078/131] (440s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[583.182530] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[589.794645] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.613s)
[589.900835] [079/131] (434s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[590.013917] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[597.506236] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.493s)
[597.609834] [080/131] (426s left) kms_dp_linktrain_fallback (dsc-fallback)
[597.701865] Starting subtest: dsc-fallback
[597.709456] Subtest dsc-fallback: SKIP (0.000s)
[597.752688] [081/131] (426s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[597.855509] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[597.861213] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[597.956211] [082/131] (426s left) kms_chamelium_frames (dp-crc-single)
[598.342407] Subtest dp-crc-single: SKIP (0.000s)
[599.147640] [083/131] (424s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[599.246003] Starting subtest: dsc-fractional-bpp-with-bpc
[599.281955] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[599.326491] [084/131] (424s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[599.427288] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[599.432238] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[599.507809] [085/131] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[599.610136] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[599.615086] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[599.691051] [086/131] (424s left) gem_exec_reloc (basic-gtt-read)
[599.746629] Subtest basic-gtt-read: SKIP (0.000s)
[599.823547] [087/131] (424s left) prime_self_import (basic-with_one_bo_two_files)
[599.862690] Starting subtest: basic-with_one_bo_two_files
[599.883278] Subtest basic-with_one_bo_two_files: SUCCESS (0.020s)
[599.950814] [088/131] (424s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[600.054412] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[604.084460] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.032s)
[605.246965] [089/131] (419s left) gem_gpgpu_fill (offset-16x16)
[605.302826] Starting subtest: offset-16x16
[605.308987] Subtest offset-16x16: SUCCESS (0.007s)
[605.398709] [090/131] (419s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[605.498397] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[605.501420] Starting dynamic subtest: pipe-A-default-mode
[608.174191] Dynamic subtest pipe-A-default-mode: SUCCESS (2.675s)
[608.177110] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.677s)
[609.041222] [091/131] (415s left) kms_content_protection (uevent-hdcp14)
[609.190453] Starting subtest: uevent-hdcp14
[609.195767] Subtest uevent-hdcp14: SKIP (0.000s)
[609.280122] [092/131] (415s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[609.380525] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[609.386081] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[609.439121] [093/131] (415s left) kms_cdclk (mode-transition)
[609.528059] Starting subtest: mode-transition
[609.530617] Starting dynamic subtest: pipe-A-eDP-1
[609.816877] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[609.827172] Starting dynamic subtest: pipe-B-eDP-1
[609.833241] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[609.844064] Starting dynamic subtest: pipe-C-eDP-1
[609.849244] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[609.858992] Starting dynamic subtest: pipe-D-eDP-1
[609.864123] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[609.869124] Subtest mode-transition: SKIP (0.297s)
[610.662834] [094/131] (413s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[610.756534] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[615.069897] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.316s)
[616.192850] [095/131] (408s left) gem_exec_balancer (parallel-out-fence)
[616.457579] Starting subtest: parallel-out-fence
[617.784667] Subtest parallel-out-fence: SUCCESS (1.327s)
[617.858149] [096/131] (406s left) syncobj_timeline (invalid-wait-illegal-handle)
[617.920626] Starting subtest: invalid-wait-illegal-handle
[617.923420] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[617.984799] [097/131] (406s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[618.090747] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[618.737031] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[618.869240] [098/131] (405s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[618.984951] Starting subtest: flip-vs-cursor-crc-atomic
[619.672247] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.687s)
[620.490974] [099/131] (404s left) i915_drm_fdinfo (busy)
[620.531076] Starting subtest: busy
[620.533334] Starting dynamic subtest: rcs0
[620.554343] Dynamic subtest rcs0: SKIP (0.023s)
[620.566329] Starting dynamic subtest: bcs0
[620.571036] Dynamic subtest bcs0: SKIP (0.000s)
[620.580241] Starting dynamic subtest: vcs0
[620.584929] Dynamic subtest vcs0: SKIP (0.000s)
[620.594356] Starting dynamic subtest: vcs1
[620.599225] Dynamic subtest vcs1: SKIP (0.000s)
[620.608142] Starting dynamic subtest: vecs0
[620.612924] Dynamic subtest vecs0: SKIP (0.000s)
[620.622184] Starting dynamic subtest: ccs0
[620.626935] Dynamic subtest ccs0: SKIP (0.000s)
[620.631448] Subtest busy: SKIP (0.028s)
[620.670843] [100/131] (404s left) gem_userptr_blits (dmabuf-sync)
[620.741408] Starting subtest: dmabuf-sync
[620.746584] Subtest dmabuf-sync: SKIP (0.002s)
[620.833986] [101/131] (404s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[620.920570] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[620.922883] Starting dynamic subtest: pipe-A
[621.037138] Dynamic subtest pipe-A: SKIP (0.111s)
[621.046876] Starting dynamic subtest: pipe-B
[622.195042] Dynamic subtest pipe-B: SKIP (1.157s)
[622.205135] Starting dynamic subtest: pipe-C
[623.418280] Dynamic subtest pipe-C: SUCCESS (1.229s)
[623.430717] Starting dynamic subtest: pipe-D
[624.573429] Dynamic subtest pipe-D: SUCCESS (1.154s)
[624.576325] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.654s)
[625.752974] [102/131] (399s left) fbdev (write)
[625.800057] Starting subtest: write
[626.214369] Subtest write: SUCCESS (0.412s)
[626.261205] [103/131] (398s left) api_intel_allocator (reserve-simple)
[626.320938] Starting subtest: reserve-simple
[626.323465] Subtest reserve-simple: SUCCESS (0.003s)
[626.401974] [104/131] (398s left) perf_pmu (busy-idle-check-all)
[626.443820] Starting subtest: busy-idle-check-all
[626.446307] Starting dynamic subtest: rcs0
[627.094699] Dynamic subtest rcs0: SUCCESS (0.653s)
[627.107814] Starting dynamic subtest: bcs0
[627.747205] Dynamic subtest bcs0: SUCCESS (0.650s)
[627.760445] Starting dynamic subtest: vcs0
[629.313920] Dynamic subtest vcs0: SUCCESS (1.563s)
[629.326442] Starting dynamic subtest: vcs1
[631.298720] Dynamic subtest vcs1: SUCCESS (1.980s)
[631.311471] Starting dynamic subtest: vecs0
[632.021898] Dynamic subtest vecs0: FAIL (0.626s)
[632.032447] Starting dynamic subtest: ccs0
[632.650145] Dynamic subtest ccs0: FAIL (0.624s)
[632.652881] Subtest busy-idle-check-all: FAIL (6.110s)
[633.403288] [105/131] (391s left) kms_flip (plain-flip-ts-check-interruptible)
[633.499569] Starting subtest: plain-flip-ts-check-interruptible
[633.502440] Starting dynamic subtest: A-eDP1
[642.362684] Dynamic subtest A-eDP1: SUCCESS (8.860s)
[642.373885] Starting dynamic subtest: B-eDP1
[651.192941] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[651.204675] Starting dynamic subtest: C-eDP1
[660.021663] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[660.032485] Starting dynamic subtest: D-eDP1
[668.860761] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[668.863204] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.352s)
[670.022162] [106/131] (355s left) gem_pipe_control_store_loop (fresh-buffer)
[670.076426] Starting subtest: fresh-buffer
[672.231258] Subtest fresh-buffer: SUCCESS (2.152s)
[672.320130] [107/131] (352s left) syncobj_timeline (wait-all-for-submit-snapshot)
[672.392420] Starting subtest: wait-all-for-submit-snapshot
[672.472494] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[672.535322] [108/131] (352s left) gem_workarounds (reset-fd)
[672.601454] Starting subtest: reset-fd
[672.797365] Subtest reset-fd: SUCCESS (0.196s)
[672.904947] [109/131] (352s left) kms_psr (psr2-primary-page-flip)
[673.003081] Starting subtest: psr2-primary-page-flip
[673.005424] Starting dynamic subtest: eDP-1
[674.723730] Dynamic subtest eDP-1: SUCCESS (1.721s)
[674.726446] Subtest psr2-primary-page-flip: SUCCESS (1.722s)
[675.597809] [110/131] (349s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[675.700797] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[675.706203] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[675.777787] [111/131] (349s left) gem_exec_schedule (fifo)
[675.853341] Starting subtest: fifo
[675.856258] Starting dynamic subtest: rcs0
[675.966071] Dynamic subtest rcs0: SUCCESS (0.114s)
[675.978454] Starting dynamic subtest: vcs0
[676.059367] Dynamic subtest vcs0: SUCCESS (0.092s)
[676.070990] Starting dynamic subtest: vcs1
[676.143428] Dynamic subtest vcs1: SUCCESS (0.082s)
[676.157028] Starting dynamic subtest: vecs0
[676.229429] Dynamic subtest vecs0: SUCCESS (0.085s)
[676.240526] Starting dynamic subtest: ccs0
[676.350075] Dynamic subtest ccs0: SUCCESS (0.119s)
[676.353029] Subtest fifo: SUCCESS (0.501s)
[677.382058] [112/131] (348s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[677.489249] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[678.157054] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[678.285670] [113/131] (347s left) kms_selftest (drm_plane_helper)
[678.327798] Starting subtest: drm_plane_helper
[678.374578] Starting dynamic subtest: drm_test_check_plane_state
[678.482908] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.107s)
[678.493539] Starting dynamic subtest: drm_test_check_invalid_plane_state
[678.579471] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.098s)
[678.582044] Subtest drm_plane_helper: SUCCESS (0.252s)
[678.707579] [114/131] (346s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[678.806309] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[678.811212] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[678.857076] [115/131] (346s left) perf (buffer-fill)
[678.917168] Starting subtest: buffer-fill
[678.919872] Starting dynamic subtest: 0-rcs0
[681.168133] Dynamic subtest 0-rcs0: SUCCESS (2.249s)
[681.180053] Starting dynamic subtest: 1-vcs1
[685.631030] Dynamic subtest 1-vcs1: SUCCESS (4.441s)
[685.632979] Subtest buffer-fill: SUCCESS (6.692s)
[685.681179] [116/131] (339s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[685.793436] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[685.798258] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[685.874661] [117/131] (339s left) gem_ctx_persistence (legacy-engines-mixed)
[685.928543] Starting subtest: legacy-engines-mixed
[685.931225] Starting dynamic subtest: render
[686.003776] Dynamic subtest render: SUCCESS (0.074s)
[686.015652] Starting dynamic subtest: bsd1
[686.041134] Dynamic subtest bsd1: SUCCESS (0.035s)
[686.051718] Starting dynamic subtest: bsd2
[686.091440] Dynamic subtest bsd2: SUCCESS (0.049s)
[686.102363] Starting dynamic subtest: blt
[686.139810] Dynamic subtest blt: SUCCESS (0.046s)
[686.152273] Starting dynamic subtest: vebox
[686.191310] Dynamic subtest vebox: SUCCESS (0.050s)
[686.194086] Subtest legacy-engines-mixed: SUCCESS (0.263s)
[686.248010] [118/131] (339s left) perf (invalid-oa-metric-set-id)
[686.313165] Starting subtest: invalid-oa-metric-set-id
[686.324152] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[686.375223] [119/131] (339s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[686.476478] Starting subtest: yf-tiled-8bpp-rotate-90
[686.481844] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[686.549095] [120/131] (339s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[686.663431] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[686.668293] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[686.788635] [121/131] (339s left) kms_psr (fbc-psr2-sprite-plane-move)
[686.880326] Starting subtest: fbc-psr2-sprite-plane-move
[686.882622] Starting dynamic subtest: eDP-1
[686.886108] Dynamic subtest eDP-1: SKIP (0.000s)
[686.889920] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[686.930054] [122/131] (338s left) syncobj_wait (wait-for-submit-delayed-submit)
[686.981096] Starting subtest: wait-for-submit-delayed-submit
[687.082925] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[687.141888] [123/131] (338s left) kms_getfb (getfb-addfb-different-handles)
[687.242120] Starting subtest: getfb-addfb-different-handles
[687.244413] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[687.322760] [124/131] (338s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[687.375110] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[687.477317] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[687.553665] [125/131] (338s left) kms_psr (fbc-pr-basic)
[687.649431] Starting subtest: fbc-pr-basic
[687.654153] Subtest fbc-pr-basic: SKIP (0.000s)
[687.698743] [126/131] (338s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[687.790053] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[687.791888] Starting dynamic subtest: pipe-A-eDP-1
[687.813405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[687.823862] Starting dynamic subtest: pipe-B-eDP-1
[687.842705] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[687.852929] Starting dynamic subtest: pipe-C-eDP-1
[687.870802] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[687.880684] Starting dynamic subtest: pipe-D-eDP-1
[687.898402] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[687.900433] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[690.068573] [127/131] (336s left) kms_flip (2x-flip-vs-panning-interruptible)
[690.168032] Starting subtest: 2x-flip-vs-panning-interruptible
[690.180244] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[690.237537] [128/131] (335s left) gem_lmem_swapping (verify-ccs)
[690.279181] Subtest verify-ccs: SKIP (0.000s)
[690.326692] [129/131] (335s left) kms_prop_blob (basic)
[690.377781] Starting subtest: basic
[690.380182] Subtest basic: SUCCESS (0.000s)
[690.453750] [130/131] (335s left) kms_flip (2x-blocking-absolute-wf_vblank)
[690.535970] Starting subtest: 2x-blocking-absolute-wf_vblank
[690.547265] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[690.605368] [131/131] (335s left) core_auth (basic-auth)
[690.661437] Starting subtest: basic-auth
[690.664290] Subtest basic-auth: SUCCESS (0.001s)
[690.732788] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_bad_destroy
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_atomic
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: gem_ctx_isolation
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: sw_sync
results: parsing output: 15/ for test: gem_spin_batch
results: parsing output: 16/ for test: gem_partial_pwrite_pread
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: gem_exec_whisper
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: kms_color_pipeline
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_eio
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: device_reset
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: gem_fence_thrash
results: parsing output: 39/ for test: i915_hangman
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: gem_pxp
results: parsing output: 43/ for test: gem_watchdog
results: parsing output: 44/ for test: kms_pm_dc
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_pipe_crc_basic
results: parsing output: 47/ for test: kms_lease
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_joiner
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_ctx_exec
results: parsing output: 54/ for test: gem_ctx_param
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: i915_selftest
results: parsing output: 59/ for test: gem_ctx_create
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: sysfs_timeslice_duration
results: parsing output: 68/ for test: gem_pxp
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_softpin
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: kms_panel_fitting
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_dp_linktrain_fallback
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_chamelium_frames
results: parsing output: 82/ for test: kms_dsc
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: prime_self_import
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_gpgpu_fill
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cdclk
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: fbdev
results: parsing output: 102/ for test: api_intel_allocator
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: gem_pipe_control_store_loop
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: gem_workarounds
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_selftest
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: gem_lmem_swapping
results: parsing output: 128/ for test: kms_prop_blob
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: core_auth
Done.