[57.368570] Initializing watchdogs
[57.368617]   /dev/watchdog0
[57.382940] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.387187] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.389560] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.392841] [001/156] (960s left) syncobj_wait (wait-zero-handles)
[57.473123] Starting subtest: wait-zero-handles
[57.475594] Subtest wait-zero-handles: SUCCESS (0.000s)
[57.583875] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[57.693916] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[57.698422] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[57.785678] [003/156] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[57.890683] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[58.589655] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[58.735509] [004/156] (959s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[58.846084] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[58.850076] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[58.938501] [005/156] (959s left) gem_softpin (allocator-basic-reserve)
[59.005817] Starting subtest: allocator-basic-reserve
[59.077197] Subtest allocator-basic-reserve: SUCCESS (0.070s)
[59.201513] [006/156] (958s left) core_setmaster (master-drop-set-user)
[59.278712] Starting subtest: master-drop-set-user
[59.291762] Subtest master-drop-set-user: SUCCESS (0.015s)
[59.324887] [007/156] (958s left) gem_ctx_isolation (preservation)
[59.386279] Starting subtest: preservation
[59.388758] Starting dynamic subtest: rcs0
[59.532769] Dynamic subtest rcs0: SUCCESS (0.145s)
[59.542971] Starting dynamic subtest: bcs0
[59.685496] Dynamic subtest bcs0: SUCCESS (0.150s)
[59.693933] Starting dynamic subtest: vcs0
[59.858719] Dynamic subtest vcs0: SUCCESS (0.170s)
[59.866914] Starting dynamic subtest: vcs1
[61.440859] Dynamic subtest vcs1: SUCCESS (1.567s)
[61.452081] Starting dynamic subtest: vecs0
[63.425030] Dynamic subtest vecs0: SUCCESS (1.969s)
[63.433114] Starting dynamic subtest: ccs0
[65.430745] Dynamic subtest ccs0: SUCCESS (1.994s)
[65.433564] Subtest preservation: SUCCESS (5.998s)
[65.649238] [008/156] (952s left) gem_exec_params (secure-non-root)
[65.707792] Starting subtest: secure-non-root
[65.712462] Subtest secure-non-root: SKIP (0.000s)
[65.802451] [009/156] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[65.910064] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[73.630658] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.704s)
[73.754331] [010/156] (944s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[73.846296] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[73.857447] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[73.945989] [011/156] (944s left) perf (invalid-oa-exponent)
[74.063674] Starting subtest: invalid-oa-exponent
[74.077717] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[74.115235] [012/156] (944s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[74.208915] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[74.213565] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[74.297478] [013/156] (944s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[74.392388] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[74.396466] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[74.487067] [014/156] (943s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[74.570142] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[74.573636] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[74.636095] [015/156] (943s left) gem_exec_params (rsvd2-dirt)
[74.687959] Starting subtest: rsvd2-dirt
[74.691864] Subtest rsvd2-dirt: SKIP (0.000s)
[74.794844] [016/156] (943s left) perf_pmu (all-busy-check-all)
[74.831101] Starting subtest: all-busy-check-all
[76.295809] Subtest all-busy-check-all: SUCCESS (1.461s)
[76.396323] [017/156] (942s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[76.511804] Starting subtest: 2x-flip-vs-cursor-legacy
[76.516417] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[76.654318] [018/156] (941s left) gem_workarounds (reset-context)
[76.716729] Starting subtest: reset-context
[76.874353] Subtest reset-context: SUCCESS (0.159s)
[76.990238] [019/156] (941s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[77.081634] Starting subtest: fbc-psr-sprite-mmap-cpu
[77.083511] Starting dynamic subtest: eDP-1
[77.087492] Dynamic subtest eDP-1: SKIP (0.000s)
[77.091502] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[77.154726] [020/156] (941s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[77.237466] Starting subtest: flip-vs-dpms-off-vs-modeset
[77.239953] Starting dynamic subtest: A-eDP1
[80.852823] Dynamic subtest A-eDP1: SUCCESS (3.610s)
[80.861591] Starting dynamic subtest: B-eDP1
[84.061881] Dynamic subtest B-eDP1: SUCCESS (3.207s)
[84.071710] Starting dynamic subtest: C-eDP1
[87.301168] Dynamic subtest C-eDP1: SUCCESS (3.236s)
[87.311467] Starting dynamic subtest: D-eDP1
[90.519702] Dynamic subtest D-eDP1: SUCCESS (3.216s)
[90.522057] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.274s)
[91.332727] [021/156] (927s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[91.437393] Starting subtest: fbc-rgb565-draw-pwrite
[96.058234] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.624s)
[97.240086] [022/156] (921s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[97.347273] Starting subtest: 4-tiled-16bpp-rotate-270
[97.367679] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[97.492451] [023/156] (921s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[97.581177] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[97.585254] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[97.688684] [024/156] (921s left) syncobj_timeline (single-wait-for-submit-signaled)
[97.751709] Starting subtest: single-wait-for-submit-signaled
[97.753837] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[97.858303] [025/156] (920s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[97.936976] Starting subtest: fbc-pr-cursor-mmap-cpu
[97.941515] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[98.004655] [026/156] (920s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[98.103844] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[98.107915] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[98.196314] [027/156] (920s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[98.293070] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[98.296500] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[98.393826] [028/156] (920s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[98.493080] Starting subtest: y-tiled-16bpp-rotate-270
[98.496637] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[98.600149] [029/156] (920s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[98.716207] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[98.720055] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[98.860810] [030/156] (920s left) kms_setmode (basic)
[98.909839] Starting subtest: basic
[99.248058] Starting dynamic subtest: pipe-A-eDP-1
[101.352006] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s)
[101.702604] Starting dynamic subtest: pipe-B-eDP-1
[103.783818] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.085s)
[104.097896] Subtest basic: SUCCESS (5.185s)
[104.919406] [031/156] (914s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[105.005059] Starting subtest: nonblocking-crc-frame-sequence
[105.007294] Starting dynamic subtest: pipe-A-eDP-1
[105.749035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[105.759801] Starting dynamic subtest: pipe-B-eDP-1
[107.150675] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[107.162509] Starting dynamic subtest: pipe-C-eDP-1
[108.535570] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[108.545107] Starting dynamic subtest: pipe-D-eDP-1
[109.966473] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.431s)
[109.968838] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.962s)
[110.852522] [032/156] (908s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[110.909411] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[110.914059] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[111.107894] [033/156] (908s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[111.206302] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[111.210465] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[111.280770] [034/156] (907s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[111.385280] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[113.834998] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.456s)
[114.944076] [035/156] (904s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[114.996078] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[114.998056] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[115.107112] [036/156] (904s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[115.215513] Starting subtest: hdr-1p-pri-indfb-multidraw
[115.219734] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[115.291488] [037/156] (903s left) api_intel_allocator (open-vm)
[115.349233] Starting subtest: open-vm
[115.353980] Subtest open-vm: SUCCESS (0.004s)
[115.480859] [038/156] (903s left) kms_lease (lease-again)
[115.568773] Starting subtest: lease-again
[115.571279] Starting dynamic subtest: pipe-A-eDP-1
[115.573645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[115.584821] Starting dynamic subtest: pipe-B-eDP-1
[115.587041] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[115.595232] Starting dynamic subtest: pipe-C-eDP-1
[115.597329] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[115.605621] Starting dynamic subtest: pipe-D-eDP-1
[115.607675] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[115.610047] Subtest lease-again: SUCCESS (0.012s)
[115.691534] [039/156] (903s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[115.790634] Starting subtest: yf-tiled-8bpp-rotate-90
[115.795300] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[115.886969] [040/156] (903s left) kms_vrr (seamless-rr-switch-vrr)
[115.967806] Starting subtest: seamless-rr-switch-vrr
[115.973132] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[116.037720] [041/156] (903s left) kms_psr (psr-cursor-mmap-gtt)
[116.135506] Starting subtest: psr-cursor-mmap-gtt
[116.137516] Starting dynamic subtest: eDP-1
[117.842882] Dynamic subtest eDP-1: SUCCESS (1.706s)
[117.845543] Subtest psr-cursor-mmap-gtt: SUCCESS (1.706s)
[118.715446] [042/156] (900s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[118.819052] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[118.823457] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[118.927507] [043/156] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[118.985105] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[119.090961] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[119.180132] [044/156] (900s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[119.299738] Starting subtest: basic-busy-flip-before-cursor-varying-size
[119.304593] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[119.468024] [045/156] (900s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[119.522739] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[119.576630] [046/156] (900s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[119.675762] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[119.679787] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[119.771839] [047/156] (899s left) gem_ctx_persistence (heartbeat-hostile)
[119.826855] Starting subtest: heartbeat-hostile
[119.831590] Subtest heartbeat-hostile: SKIP (0.000s)
[119.941366] [048/156] (899s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[120.042107] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[120.046647] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[120.141781] [049/156] (899s left) gem_flink_basic (double-flink)
[120.192472] Starting subtest: double-flink
[120.194340] Subtest double-flink: SUCCESS (0.000s)
[120.291745] [050/156] (899s left) perf (invalid-oa-metric-set-id)
[120.365646] Starting subtest: invalid-oa-metric-set-id
[120.376796] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[120.416396] [051/156] (899s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary)
[120.521987] Starting subtest: hdr-indfb-scaledprimary
[120.525542] Subtest hdr-indfb-scaledprimary: SKIP (0.000s)
[120.610951] [052/156] (899s left) kms_cursor_crc (cursor-offscreen-256x256)
[120.846359] Starting subtest: cursor-offscreen-256x256
[120.850301] Starting dynamic subtest: pipe-A-eDP-1
[122.797766] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[122.823247] Starting dynamic subtest: pipe-D-eDP-1
[125.448100] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.629s)
[125.450397] Subtest cursor-offscreen-256x256: SUCCESS (4.599s)
[126.293109] [053/156] (893s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[126.396017] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[127.045306] Subtest linear-max-hw-stride-32bpp-rotate-0: FAIL (0.053s)
[127.086348] [054/156] (892s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[127.142068] Starting subtest: invalid-single-wait-unsubmitted
[127.143910] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[127.237926] [055/156] (892s left) gem_linear_blits (basic)
[127.520675] Starting subtest: basic
[127.531561] Subtest basic: SUCCESS (0.013s)
[127.651919] [056/156] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[127.794572] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[127.798656] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[127.880947] [057/156] (892s left) syncobj_wait (reset-during-wait-for-submit)
[127.941566] Starting subtest: reset-during-wait-for-submit
[128.046529] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[128.121291] [058/156] (891s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[128.228304] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[128.230693] Starting dynamic subtest: pipe-A
[129.274719] Dynamic subtest pipe-A: SUCCESS (1.049s)
[129.283716] Starting dynamic subtest: pipe-B
[131.380510] Dynamic subtest pipe-B: SUCCESS (2.105s)
[131.389898] Starting dynamic subtest: pipe-C
[132.589844] Dynamic subtest pipe-C: SUCCESS (1.208s)
[132.599189] Starting dynamic subtest: pipe-D
[133.810403] Dynamic subtest pipe-D: SUCCESS (1.219s)
[133.812705] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.585s)
[134.999766] [059/156] (885s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[135.101685] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[135.103978] Starting dynamic subtest: pipe-A-eDP-1
[135.127065] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[135.137923] Starting dynamic subtest: pipe-B-eDP-1
[135.159403] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[135.167680] Starting dynamic subtest: pipe-C-eDP-1
[135.189404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[135.197594] Starting dynamic subtest: pipe-D-eDP-1
[135.220106] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[135.224436] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[137.368609] [060/156] (882s left) gem_sync (basic-many-each)
[137.450087] Starting subtest: basic-many-each
[139.720663] Subtest basic-many-each: SUCCESS (2.281s)
[139.914975] [061/156] (880s left) gem_mmap (pf-nonblock)
[139.980648] Subtest pf-nonblock: SKIP (0.000s)
[140.051148] [062/156] (880s left) fbdev (unaligned-write)
[140.100317] Starting subtest: unaligned-write
[140.252060] Subtest unaligned-write: SUCCESS (0.152s)
[140.330326] [063/156] (879s left) kms_color (ctm-signed)
[140.433760] Starting subtest: ctm-signed
[140.435899] Starting dynamic subtest: pipe-A-eDP-1
[142.547303] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s)
[142.558791] Starting dynamic subtest: pipe-B-eDP-1
[145.424088] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.878s)
[145.434187] Starting dynamic subtest: pipe-C-eDP-1
[148.123435] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.697s)
[148.133738] Starting dynamic subtest: pipe-D-eDP-1
[150.783832] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.658s)
[150.786552] Subtest ctm-signed: SUCCESS (10.349s)
[151.614802] [064/156] (868s left) gem_ctx_param (invalid-size-set)
[151.684035] Starting subtest: invalid-size-set
[151.686423] Subtest invalid-size-set: SUCCESS (0.001s)
[151.792855] [065/156] (868s left) kms_psr (pr-sprite-blt)
[151.885137] Starting subtest: pr-sprite-blt
[151.889180] Subtest pr-sprite-blt: SKIP (0.000s)
[151.957228] [066/156] (868s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[152.079639] Starting subtest: short-busy-flip-before-cursor-toggle
[152.084780] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[152.222259] [067/156] (868s left) gen9_exec_parse (bb-start-param)
[152.276453] Subtest bb-start-param: SKIP (0.000s)
[152.339765] [068/156] (868s left) kms_addfb_basic (bad-pitch-1024)
[152.394988] Starting subtest: bad-pitch-1024
[152.397224] Subtest bad-pitch-1024: SUCCESS (0.000s)
[152.527547] [069/156] (868s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[152.585754] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[152.691270] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[152.777164] [070/156] (867s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[152.908164] Starting subtest: multiplane-atomic-fence-wait
[153.140240] Subtest multiplane-atomic-fence-wait: SUCCESS (0.233s)
[154.346569] [071/156] (866s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[154.586936] Starting subtest: cursor-rapid-movement-256x256
[154.592182] Starting dynamic subtest: pipe-A-eDP-1
[155.157327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[155.183685] Starting dynamic subtest: pipe-D-eDP-1
[156.381127] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s)
[156.383416] Subtest cursor-rapid-movement-256x256: SUCCESS (1.792s)
[157.222138] [072/156] (863s left) i915_query (engine-info-invalid)
[157.271427] Starting subtest: engine-info-invalid
[157.273589] Subtest engine-info-invalid: SUCCESS (0.000s)
[157.358499] [073/156] (863s left) kms_plane_scaling (planes-downscale-factor-0-5)
[157.444035] Starting subtest: planes-downscale-factor-0-5
[157.446259] Starting dynamic subtest: pipe-A
[157.466775] Dynamic subtest pipe-A: SKIP (0.018s)
[157.478739] Starting dynamic subtest: pipe-B
[157.502080] Dynamic subtest pipe-B: SKIP (0.035s)
[157.511409] Starting dynamic subtest: pipe-C
[157.534033] Dynamic subtest pipe-C: SKIP (0.031s)
[157.546227] Starting dynamic subtest: pipe-D
[157.564637] Dynamic subtest pipe-D: SKIP (0.031s)
[157.568843] Subtest planes-downscale-factor-0-5: SKIP (0.117s)
[157.672410] [074/156] (863s left) prime_busy (after)
[157.734652] Starting subtest: after
[157.739677] Starting dynamic subtest: rcs0
[157.768278] Dynamic subtest rcs0: SUCCESS (0.030s)
[157.777730] Starting dynamic subtest: bcs0
[157.818689] Dynamic subtest bcs0: SUCCESS (0.050s)
[157.828897] Starting dynamic subtest: vcs0
[157.859719] Dynamic subtest vcs0: SUCCESS (0.040s)
[157.869556] Starting dynamic subtest: vcs1
[157.899897] Dynamic subtest vcs1: SUCCESS (0.039s)
[157.909618] Starting dynamic subtest: vecs0
[157.940722] Dynamic subtest vecs0: SUCCESS (0.040s)
[157.950625] Starting dynamic subtest: ccs0
[157.981698] Dynamic subtest ccs0: SUCCESS (0.040s)
[158.089077] Subtest after: SUCCESS (0.353s)
[158.163401] [075/156] (862s left) gem_eio (wait-wedge-10ms)
[158.384689] Starting subtest: wait-wedge-10ms
[159.384439] Subtest wait-wedge-10ms: SUCCESS (0.999s)
[159.531220] [076/156] (861s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[159.634051] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[159.638198] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[159.732203] [077/156] (861s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[159.825678] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[159.827841] Starting dynamic subtest: pipe-A-eDP-1
[170.502039] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.682s)
[170.512096] Starting dynamic subtest: pipe-B-eDP-1
[181.916909] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.410s)
[181.918909] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.095s)
[182.759103] [078/156] (838s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[182.820850] Starting subtest: yf-tiled-ccs-to-yf-tiled
[182.825484] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[183.020617] [079/156] (837s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[183.114502] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[183.118539] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[183.209298] [080/156] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[183.305695] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[183.310082] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[183.413347] [081/156] (837s left) kms_prop_blob (invalid-set-prop-any)
[183.474660] Starting subtest: invalid-set-prop-any
[183.477021] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[183.593281] [082/156] (837s left) gem_exec_alignment (forked)
[183.653626] Starting subtest: forked
[225.152745] Subtest forked: SUCCESS (41.495s)
[225.697920] [083/156] (795s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[225.813977] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[225.816934] Starting dynamic subtest: pipe-A-eDP-1
[225.841488] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[225.852622] Starting dynamic subtest: pipe-B-eDP-1
[225.874346] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[225.883692] Starting dynamic subtest: pipe-C-eDP-1
[225.904100] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[225.912919] Starting dynamic subtest: pipe-D-eDP-1
[225.933813] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[225.938055] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[228.120079] [084/156] (792s left) gem_mmap_offset (isolation)
[228.189346] Starting subtest: isolation
[228.206981] Subtest isolation: SUCCESS (0.007s)
[228.303610] [085/156] (792s left) gem_exec_fence (syncobj-timeline-signal)
[228.910640] Starting subtest: syncobj-timeline-signal
[228.917045] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[230.331531] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[230.336221] [086/156] (790s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[230.441605] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[230.446056] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[230.542562] [087/156] (790s left) kms_fbcon_fbt (fbc-suspend)
[230.616029] Starting subtest: fbc-suspend
[279.020140] Subtest fbc-suspend: SUCCESS (18.833s)
[280.377550] [088/156] (740s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[280.476533] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[280.480978] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[280.579312] [089/156] (740s left) api_intel_bb (simple-bb)
[280.650325] Starting subtest: simple-bb
[280.655453] Subtest simple-bb: SUCCESS (0.006s)
[280.797062] [090/156] (740s left) kms_async_flips (async-flip-dpms)
[280.882987] Starting subtest: async-flip-dpms
[281.257478] Starting dynamic subtest: pipe-A-eDP-1
[285.150853] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.851s)
[285.540583] Starting dynamic subtest: pipe-B-eDP-1
[288.430406] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.884s)
[288.837174] Starting dynamic subtest: pipe-C-eDP-1
[291.612020] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.774s)
[291.996889] Starting dynamic subtest: pipe-D-eDP-1
[294.800387] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.803s)
[294.802681] Subtest async-flip-dpms: SUCCESS (13.826s)
[295.973570] [091/156] (725s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[296.068857] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[296.071089] Starting dynamic subtest: pipe-A-eDP-1
[296.094095] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[296.106983] Starting dynamic subtest: pipe-B-eDP-1
[296.129162] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[296.139705] Starting dynamic subtest: pipe-C-eDP-1
[296.160827] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[296.171573] Starting dynamic subtest: pipe-D-eDP-1
[296.194848] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[296.198920] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[298.335498] [092/156] (723s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[298.432315] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[298.436910] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[298.522050] [093/156] (722s left) gem_eio (in-flight-suspend)
[298.731583] Starting subtest: in-flight-suspend
[342.204147] Subtest in-flight-suspend: SUCCESS (13.833s)
[342.343585] [094/156] (679s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[342.445096] Starting subtest: yf-tiled-32bpp-rotate-90
[342.449649] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[342.555799] [095/156] (679s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[342.648867] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[342.653395] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[342.741118] [096/156] (678s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[342.846817] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[342.851121] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[342.938830] [097/156] (678s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[343.035336] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[343.039029] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[343.148649] [098/156] (678s left) i915_drm_fdinfo (isolation)
[343.184742] Starting subtest: isolation
[343.186838] Starting dynamic subtest: rcs0
[343.216452] Dynamic subtest rcs0: SKIP (0.029s)
[343.227473] Starting dynamic subtest: bcs0
[343.231008] Dynamic subtest bcs0: SKIP (0.001s)
[343.241069] Starting dynamic subtest: vcs0
[343.244430] Dynamic subtest vcs0: SKIP (0.000s)
[343.254599] Starting dynamic subtest: vcs1
[343.258190] Dynamic subtest vcs1: SKIP (0.000s)
[343.268221] Starting dynamic subtest: vecs0
[343.271773] Dynamic subtest vecs0: SKIP (0.000s)
[343.281728] Starting dynamic subtest: ccs0
[343.285410] Dynamic subtest ccs0: SKIP (0.000s)
[343.288877] Subtest isolation: SKIP (0.036s)
[343.327303] [099/156] (678s left) kms_selftest (drm_format)
[343.367479] Starting subtest: drm_format
[343.378898] Starting dynamic subtest: drm_test_format_block_width_invalid
[343.466837] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.085s)
[343.479479] Starting dynamic subtest: drm_test_format_block_width_one_plane
[343.551977] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.083s)
[343.564261] Starting dynamic subtest: drm_test_format_block_width_two_plane
[343.644022] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.087s)
[343.656222] Starting dynamic subtest: drm_test_format_block_width_three_plane
[343.725128] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.077s)
[343.737271] Starting dynamic subtest: drm_test_format_block_width_tiled
[343.832158] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.103s)
[343.842506] Starting dynamic subtest: drm_test_format_block_height_invalid
[343.952225] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.112s)
[343.965233] Starting dynamic subtest: drm_test_format_block_height_one_plane
[344.044192] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.091s)
[344.055095] Starting dynamic subtest: drm_test_format_block_height_two_plane
[344.144304] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.094s)
[344.155016] Starting dynamic subtest: drm_test_format_block_height_three_plane
[344.256587] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.110s)
[344.267226] Starting dynamic subtest: drm_test_format_block_height_tiled
[344.339243] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.080s)
[344.351237] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[344.445106] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.100s)
[344.455603] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[344.546017] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.098s)
[344.558676] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[344.668486] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.117s)
[344.681324] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[344.764038] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.094s)
[344.775430] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[344.866636] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.100s)
[344.876937] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[344.970607] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.102s)
[344.983586] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[345.053032] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.077s)
[345.063563] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[345.153787] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.096s)
[345.156176] Subtest drm_format: SUCCESS (1.740s)
[345.304119] [100/156] (676s left) gem_exec_balancer (persistence)
[345.576488] Starting subtest: persistence
[346.488260] Subtest persistence: SUCCESS (0.892s)
[346.604459] [101/156] (675s left) gem_exec_balancer (hang)
[346.868722] Starting subtest: hang
[348.558102] Subtest hang: SUCCESS (1.668s)
[348.678142] [102/156] (673s left) kms_vblank (wait-forked-hang)
[348.773112] Starting subtest: wait-forked-hang
[348.775329] Starting dynamic subtest: pipe-A-eDP-1
[374.965288] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.083s)
[374.981108] Starting dynamic subtest: pipe-D-eDP-1
[390.053717] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.084s)
[390.056120] Subtest wait-forked-hang: SUCCESS (41.171s)
[390.881169] [103/156] (631s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[390.977390] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[390.982038] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[391.083900] [104/156] (630s left) gem_exec_whisper (basic-sync)
[391.142288] Starting subtest: basic-sync
[399.933259] Subtest basic-sync: SUCCESS (8.786s)
[400.116899] [105/156] (621s left) gem_exec_schedule (pi-common)
[400.306616] Starting subtest: pi-common
[400.308892] Starting dynamic subtest: rcs0
[400.337586] Dynamic subtest rcs0: SUCCESS (0.036s)
[400.350761] Starting dynamic subtest: bcs0
[400.368019] Dynamic subtest bcs0: SUCCESS (0.030s)
[400.381055] Starting dynamic subtest: vcs0
[400.397555] Dynamic subtest vcs0: SUCCESS (0.029s)
[400.411743] Starting dynamic subtest: vcs1
[400.427556] Dynamic subtest vcs1: SUCCESS (0.029s)
[400.438370] Starting dynamic subtest: vecs0
[400.459520] Dynamic subtest vecs0: SUCCESS (0.031s)
[400.472916] Starting dynamic subtest: ccs0
[400.490110] Dynamic subtest ccs0: SUCCESS (0.029s)
[400.492267] Subtest pi-common: SUCCESS (0.189s)
[400.736450] [106/156] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[400.833860] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[400.838000] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[400.928701] [107/156] (621s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[401.017965] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[407.866396] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.849s)
[408.004540] [108/156] (614s left) gem_userptr_blits (set-cache-level)
[408.067873] Starting subtest: set-cache-level
[408.072308] Subtest set-cache-level: SKIP (0.000s)
[408.180583] [109/156] (614s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[408.279228] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[415.723353] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.446s)
[415.872484] [110/156] (606s left) kms_rotation_crc (bad-pixel-format)
[415.970906] Starting subtest: bad-pixel-format
[415.975202] Subtest bad-pixel-format: SKIP (0.001s)
[416.059223] [111/156] (606s left) gem_mmap_gtt (basic-copy)
[416.118334] Subtest basic-copy: SKIP (0.000s)
[416.188251] [112/156] (606s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[416.290326] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[439.215293] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.924s)
[439.340795] [113/156] (583s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[439.439761] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[439.443248] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[439.550097] [114/156] (582s left) perf_pmu (interrupts-sync)
[439.594062] Starting subtest: interrupts-sync
[440.664453] Subtest interrupts-sync: SUCCESS (1.071s)
[440.774412] [115/156] (581s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[440.874373] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[440.878626] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[440.983612] [116/156] (581s left) i915_pm_rpm (reg-read-ioctl)
[442.528522] Starting subtest: reg-read-ioctl
[444.833494] Subtest reg-read-ioctl: SUCCESS (2.307s)
[445.243219] [117/156] (577s left) sw_sync (sync_multi_timeline_wait)
[445.281492] Starting subtest: sync_multi_timeline_wait
[445.283896] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[445.341178] [118/156] (577s left) gem_exec_reloc (basic-write-cpu-active)
[445.394700] Subtest basic-write-cpu-active: SKIP (0.000s)
[445.464129] [119/156] (577s left) kms_busy (basic)
[445.563112] Starting subtest: basic
[445.564997] Starting dynamic subtest: flip
[446.147756] Dynamic subtest flip: SUCCESS (0.582s)
[446.160869] Starting dynamic subtest: modeset
[449.859902] Dynamic subtest modeset: SUCCESS (3.715s)
[449.862298] Subtest basic: SUCCESS (4.300s)
[450.676305] [120/156] (572s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[450.776152] Starting subtest: psrhdr-rgb565-draw-render
[450.780239] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[450.867475] [121/156] (571s left) kms_flip (2x-plain-flip-ts-check)
[450.959294] Starting subtest: 2x-plain-flip-ts-check
[450.970744] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[451.055494] [122/156] (571s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[451.119218] Starting subtest: etime-single-wait-for-submit-unsubmitted
[451.225068] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[451.305410] [123/156] (571s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[451.397635] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[451.401641] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[451.479470] [124/156] (571s left) gem_close_race (multigpu-basic-process)
[451.551537] Starting subtest: multigpu-basic-process
[451.556007] Subtest multigpu-basic-process: SKIP (0.000s)
[451.782505] [125/156] (571s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[451.878181] Starting subtest: random-ccs-data-y-tiled-ccs
[451.880567] Starting dynamic subtest: pipe-A-eDP-1
[451.906243] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[451.919457] Starting dynamic subtest: pipe-B-eDP-1
[451.942662] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[451.953214] Starting dynamic subtest: pipe-C-eDP-1
[451.977132] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[451.987645] Starting dynamic subtest: pipe-D-eDP-1
[452.011720] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[452.015912] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[454.149333] [126/156] (568s left) gem_exec_store (basic)
[454.213450] Starting subtest: basic
[454.314212] Subtest basic: SUCCESS (0.103s)
[454.499203] [127/156] (568s left) gem_exec_schedule (u-fairslice-all)
[454.570484] Starting subtest: u-fairslice-all
[456.625619] Subtest u-fairslice-all: SUCCESS (2.060s)
[456.920206] [128/156] (566s left) kms_psr (psr-sprite-mmap-gtt)
[457.018011] Starting subtest: psr-sprite-mmap-gtt
[457.020368] Starting dynamic subtest: eDP-1
[458.431817] Dynamic subtest eDP-1: SKIP (1.411s)
[458.437318] Subtest psr-sprite-mmap-gtt: SKIP (1.413s)
[458.591976] [129/156] (564s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[458.678969] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[458.681458] Starting dynamic subtest: pipe-A-eDP-1
[458.701091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[458.714061] Starting dynamic subtest: pipe-B-eDP-1
[458.734274] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[458.745791] Starting dynamic subtest: pipe-C-eDP-1
[458.766172] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[458.777713] Starting dynamic subtest: pipe-D-eDP-1
[458.798218] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[458.800599] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[461.036851] [130/156] (562s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[461.128812] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[466.072876] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.949s)
[467.230177] [131/156] (555s left) kms_pm_dc (dc5-dpms)
[468.326710] Starting subtest: dc5-dpms
[470.403402] Subtest dc5-dpms: SUCCESS (2.076s)
[470.504838] [132/156] (552s left) gem_exec_suspend (basic)
[470.575511] Starting subtest: basic
[470.578063] Starting dynamic subtest: smem
[472.236292] Dynamic subtest smem: SUCCESS (1.659s)
[472.239361] Subtest basic: SUCCESS (1.661s)
[472.428370] [133/156] (550s left) gem_partial_pwrite_pread (reads)
[472.501465] Subtest reads: SKIP (0.000s)
[472.601782] [134/156] (550s left) kms_pm_rpm (modeset-pc8-residency-stress)
[474.332891] Starting subtest: modeset-pc8-residency-stress
[474.338504] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[474.900577] [135/156] (548s left) gem_exec_params (invalid-flag)
[474.951629] Starting subtest: invalid-flag
[474.953791] Subtest invalid-flag: SUCCESS (0.000s)
[475.057496] [136/156] (548s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[475.157851] Starting subtest: fbcpsr-rgb101010-draw-blt
[479.956828] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.802s)
[480.080383] [137/156] (543s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen)
[480.179772] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen
[480.184359] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[480.286156] [138/156] (543s left) prime_mmap (test_forked_cpu_write)
[480.341517] Starting subtest: test_forked_cpu_write
[480.343774] Starting dynamic subtest: test_forked_cpu_write-smem
[480.349003] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[480.351251] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[480.447734] [139/156] (543s left) kms_psr (fbc-psr2-no-drrs)
[480.532744] Starting subtest: fbc-psr2-no-drrs
[480.534969] Starting dynamic subtest: eDP-1
[480.539239] Dynamic subtest eDP-1: SKIP (0.000s)
[480.543449] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[480.618902] [140/156] (542s left) kms_invalid_mode (zero-vdisplay)
[480.717653] Starting subtest: zero-vdisplay
[480.719960] Starting dynamic subtest: pipe-A-eDP-1
[481.002938] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[481.014695] Starting dynamic subtest: pipe-B-eDP-1
[481.016615] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[481.027484] Starting dynamic subtest: pipe-C-eDP-1
[481.029769] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[481.040578] Starting dynamic subtest: pipe-D-eDP-1
[481.042964] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[481.045493] Subtest zero-vdisplay: SUCCESS (0.294s)
[481.839573] [141/156] (541s left) kms_flip (2x-flip-vs-dpms)
[481.942569] Starting subtest: 2x-flip-vs-dpms
[481.951068] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[482.033308] [142/156] (541s left) gem_tiled_blits (normal)
[482.098659] Subtest normal: SKIP (0.000s)
[482.174825] [143/156] (541s left) gem_exec_flush (basic-batch-kernel-default-wb)
[482.240091] Starting subtest: basic-batch-kernel-default-wb
[489.369194] Subtest basic-batch-kernel-default-wb: SUCCESS (7.129s)
[489.561714] [144/156] (534s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[489.672498] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[493.328637] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.661s)
[494.544763] [145/156] (529s left) kms_tv_load_detect (load-detect)
[494.597206] Subtest load-detect: SKIP (0.000s)
[494.661030] [146/156] (529s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[494.752643] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[494.756980] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[494.856052] [147/156] (528s left) kms_chamelium_hpd (hdmi-hpd)
[495.240297] Subtest hdmi-hpd: SKIP (0.000s)
[496.035380] [148/156] (527s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[496.137109] Starting subtest: psr-rgb101010-draw-blt
[503.451065] Subtest psr-rgb101010-draw-blt: SUCCESS (7.318s)
[503.591178] [149/156] (520s left) perf_pmu (gt-awake)
[503.632320] Starting subtest: gt-awake
[512.237015] Subtest gt-awake: SUCCESS (8.602s)
[512.351653] [150/156] (511s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[512.460194] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[512.464261] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[512.569209] [151/156] (511s left) syncobj_timeline (multi-wait-signaled)
[512.632003] Starting subtest: multi-wait-signaled
[512.634183] Subtest multi-wait-signaled: SUCCESS (0.000s)
[512.730561] [152/156] (511s left) gem_exec_fence (syncobj-wait)
[513.174077] Starting subtest: syncobj-wait
[514.227497] Subtest syncobj-wait: SUCCESS (1.052s)
[514.575424] [153/156] (509s left) kms_content_protection (dp-mst-lic-type-1)
[514.716136] Starting subtest: dp-mst-lic-type-1
[514.720669] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[514.831451] [154/156] (509s left) i915_hangman (engine-engine-hang)
[514.901365] Starting subtest: engine-engine-hang
[514.903439] Starting dynamic subtest: rcs0
[516.170448] Dynamic subtest rcs0: SUCCESS (1.269s)
[516.188481] Starting dynamic subtest: bcs0
[518.219010] Dynamic subtest bcs0: SUCCESS (2.045s)
[518.232530] Starting dynamic subtest: vcs0
[520.203914] Dynamic subtest vcs0: SUCCESS (1.981s)
[520.219597] Starting dynamic subtest: vcs1
[522.185868] Dynamic subtest vcs1: SUCCESS (1.978s)
[522.199075] Starting dynamic subtest: vecs0
[524.171504] Dynamic subtest vecs0: SUCCESS (1.984s)
[524.183448] Starting dynamic subtest: ccs0
[526.155240] Dynamic subtest ccs0: SUCCESS (1.979s)
[526.159167] Subtest engine-engine-hang: SUCCESS (11.253s)
[526.286812] [155/156] (497s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[526.393002] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[533.083980] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.693s)
[533.220860] [156/156] (491s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[533.603964] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[534.401905] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: core_setmaster
results: parsing output: 6/ for test: gem_ctx_isolation
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_workarounds
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_setmode
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_vrr
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_flink_basic
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_linear_blits
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_sync
results: parsing output: 60/ for test: gem_mmap
results: parsing output: 61/ for test: fbdev
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_explicit_fence
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: i915_query
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: prime_busy
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_prop_blob
results: parsing output: 81/ for test: gem_exec_alignment
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_fbcon_fbt
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_async_flips
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_eio
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: i915_drm_fdinfo
results: parsing output: 98/ for test: kms_selftest
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_whisper
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_close_race
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_exec_store
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_pm_dc
results: parsing output: 131/ for test: gem_exec_suspend
results: parsing output: 132/ for test: gem_partial_pwrite_pread
results: parsing output: 133/ for test: kms_pm_rpm
results: parsing output: 134/ for test: gem_exec_params
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: prime_mmap
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_invalid_mode
results: parsing output: 140/ for test: kms_flip
results: parsing output: 141/ for test: gem_tiled_blits
results: parsing output: 142/ for test: gem_exec_flush
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_tv_load_detect
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_chamelium_hpd
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: perf_pmu
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: syncobj_timeline
results: parsing output: 151/ for test: gem_exec_fence
results: parsing output: 152/ for test: kms_content_protection
results: parsing output: 153/ for test: i915_hangman
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_chamelium_edid
Done.