[56.347477] Initializing watchdogs
[56.347529]   /dev/watchdog0
[56.362411] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.366800] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.369101] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.372541] [001/156] (960s left) syncobj_wait (wait-zero-handles)
[56.455099] Starting subtest: wait-zero-handles
[56.457568] Subtest wait-zero-handles: SUCCESS (0.000s)
[56.562362] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[56.677287] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[56.681383] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[56.789903] [003/156] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[56.889489] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[57.614589] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.727s)
[57.777949] [004/156] (959s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[57.877529] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[57.881803] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[57.963429] [005/156] (959s left) gem_softpin (allocator-basic-reserve)
[58.040765] Starting subtest: allocator-basic-reserve
[58.114359] Subtest allocator-basic-reserve: SUCCESS (0.075s)
[58.243800] [006/156] (958s left) core_setmaster (master-drop-set-user)
[58.334053] Starting subtest: master-drop-set-user
[58.349218] Subtest master-drop-set-user: SUCCESS (0.017s)
[58.386641] [007/156] (958s left) gem_ctx_isolation (preservation)
[58.444616] Starting subtest: preservation
[58.446877] Starting dynamic subtest: rcs0
[58.590613] Dynamic subtest rcs0: SUCCESS (0.145s)
[58.603639] Starting dynamic subtest: bcs0
[58.734027] Dynamic subtest bcs0: SUCCESS (0.144s)
[58.744991] Starting dynamic subtest: vcs0
[58.900037] Dynamic subtest vcs0: SUCCESS (0.165s)
[58.912288] Starting dynamic subtest: vcs1
[60.401225] Dynamic subtest vcs1: SUCCESS (1.500s)
[60.413953] Starting dynamic subtest: vecs0
[62.399459] Dynamic subtest vecs0: SUCCESS (1.997s)
[62.409468] Starting dynamic subtest: ccs0
[64.446492] Dynamic subtest ccs0: SUCCESS (2.047s)
[64.449365] Subtest preservation: SUCCESS (6.001s)
[64.682981] [008/156] (952s left) gem_exec_params (secure-non-root)
[64.730879] Starting subtest: secure-non-root
[64.735393] Subtest secure-non-root: SKIP (0.000s)
[64.828545] [009/156] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[64.938691] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[72.324871] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.390s)
[72.457212] [010/156] (944s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[72.649563] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[72.663581] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[72.847935] [011/156] (944s left) perf (invalid-oa-exponent)
[73.027364] Starting subtest: invalid-oa-exponent
[73.042679] Subtest invalid-oa-exponent: SUCCESS (0.016s)
[73.112049] [012/156] (944s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[73.235136] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[73.239750] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[73.426383] [013/156] (944s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[73.600253] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[73.604375] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[73.693195] [014/156] (943s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[73.792909] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[73.797192] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[73.877077] [015/156] (943s left) gem_exec_params (rsvd2-dirt)
[73.930730] Starting subtest: rsvd2-dirt
[73.935173] Subtest rsvd2-dirt: SKIP (0.000s)
[74.050788] [016/156] (943s left) perf_pmu (all-busy-check-all)
[74.097548] Starting subtest: all-busy-check-all
[75.263430] Subtest all-busy-check-all: SUCCESS (1.166s)
[75.373110] [017/156] (942s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[75.493357] Starting subtest: 2x-flip-vs-cursor-legacy
[75.497745] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[75.647855] [018/156] (941s left) gem_workarounds (reset-context)
[75.715302] Starting subtest: reset-context
[75.882751] Subtest reset-context: SUCCESS (0.167s)
[76.002026] [019/156] (941s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[76.097403] Starting subtest: fbc-psr-sprite-mmap-cpu
[76.099734] Starting dynamic subtest: eDP-1
[76.104203] Dynamic subtest eDP-1: SKIP (0.000s)
[76.108825] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[76.180121] [020/156] (941s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[76.279902] Starting subtest: flip-vs-dpms-off-vs-modeset
[76.282292] Starting dynamic subtest: A-eDP1
[79.959843] Dynamic subtest A-eDP1: SUCCESS (3.679s)
[79.970781] Starting dynamic subtest: B-eDP1
[83.176913] Dynamic subtest B-eDP1: SUCCESS (3.216s)
[83.186676] Starting dynamic subtest: C-eDP1
[86.398925] Dynamic subtest C-eDP1: SUCCESS (3.222s)
[86.410411] Starting dynamic subtest: D-eDP1
[89.622187] Dynamic subtest D-eDP1: SUCCESS (3.225s)
[89.624531] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.348s)
[90.436207] [021/156] (927s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[90.534517] Starting subtest: fbc-rgb565-draw-pwrite
[95.215380] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.686s)
[96.439535] [022/156] (921s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[96.560450] Starting subtest: 4-tiled-16bpp-rotate-270
[96.580648] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[96.682010] [023/156] (921s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[96.784205] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[96.788640] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[96.871977] [024/156] (920s left) syncobj_timeline (single-wait-for-submit-signaled)
[96.932105] Starting subtest: single-wait-for-submit-signaled
[96.934406] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[97.023123] [025/156] (920s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[97.119195] Starting subtest: fbc-pr-cursor-mmap-cpu
[97.123370] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[97.187967] [026/156] (920s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[97.301063] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[97.305201] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[97.397593] [027/156] (920s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[97.502550] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[97.506368] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[97.623189] [028/156] (920s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[97.722079] Starting subtest: y-tiled-16bpp-rotate-270
[97.725711] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[97.824490] [029/156] (920s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[97.946239] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[97.950252] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[98.098595] [030/156] (920s left) kms_setmode (basic)
[98.155925] Starting subtest: basic
[98.494675] Starting dynamic subtest: pipe-A-eDP-1
[100.551860] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.054s)
[100.908780] Starting dynamic subtest: pipe-B-eDP-1
[102.989236] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.086s)
[103.296100] Subtest basic: SUCCESS (5.139s)
[104.135739] [031/156] (914s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[104.238411] Starting subtest: nonblocking-crc-frame-sequence
[104.240683] Starting dynamic subtest: pipe-A-eDP-1
[105.011602] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.773s)
[105.024737] Starting dynamic subtest: pipe-B-eDP-1
[106.476265] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.464s)
[106.487683] Starting dynamic subtest: pipe-C-eDP-1
[107.852161] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[107.863852] Starting dynamic subtest: pipe-D-eDP-1
[109.266018] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.414s)
[109.268466] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.030s)
[110.065422] [032/156] (908s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[110.126944] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[110.131174] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[110.307535] [033/156] (907s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[110.391116] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[110.395259] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[110.458387] [034/156] (907s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[110.556912] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[113.074223] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.522s)
[114.270607] [035/156] (904s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[114.325155] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[114.327627] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[114.420956] [036/156] (903s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[114.532404] Starting subtest: hdr-1p-pri-indfb-multidraw
[114.536381] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[114.633769] [037/156] (903s left) api_intel_allocator (open-vm)
[114.689357] Starting subtest: open-vm
[114.694289] Subtest open-vm: SUCCESS (0.005s)
[114.834298] [038/156] (903s left) kms_lease (lease-again)
[114.921894] Starting subtest: lease-again
[114.924124] Starting dynamic subtest: pipe-A-eDP-1
[114.926342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[114.936295] Starting dynamic subtest: pipe-B-eDP-1
[114.938261] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[114.947062] Starting dynamic subtest: pipe-C-eDP-1
[114.948974] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[114.957909] Starting dynamic subtest: pipe-D-eDP-1
[114.959780] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[114.961643] Subtest lease-again: SUCCESS (0.012s)
[115.061452] [039/156] (903s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[115.161374] Starting subtest: yf-tiled-8bpp-rotate-90
[115.165336] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[115.253825] [040/156] (903s left) kms_vrr (seamless-rr-switch-vrr)
[115.347268] Starting subtest: seamless-rr-switch-vrr
[115.352555] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[115.417371] [041/156] (903s left) kms_psr (psr-cursor-mmap-gtt)
[115.508494] Starting subtest: psr-cursor-mmap-gtt
[115.510316] Starting dynamic subtest: eDP-1
[117.266352] Dynamic subtest eDP-1: SUCCESS (1.759s)
[117.268704] Subtest psr-cursor-mmap-gtt: SUCCESS (1.759s)
[118.142691] [042/156] (900s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[118.240972] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[118.245522] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[118.331284] [043/156] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[118.388318] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[118.496898] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[118.594995] [044/156] (900s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[118.703344] Starting subtest: basic-busy-flip-before-cursor-varying-size
[118.707842] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[118.870775] [045/156] (899s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[118.929751] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[118.985337] [046/156] (899s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[119.084255] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[119.088173] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[119.192278] [047/156] (899s left) gem_ctx_persistence (heartbeat-hostile)
[119.253459] Starting subtest: heartbeat-hostile
[119.257983] Subtest heartbeat-hostile: SKIP (0.000s)
[119.385539] [048/156] (899s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[119.485627] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[119.489995] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[119.583643] [049/156] (899s left) gem_flink_basic (double-flink)
[119.629895] Starting subtest: double-flink
[119.631881] Subtest double-flink: SUCCESS (0.000s)
[119.723444] [050/156] (899s left) perf (invalid-oa-metric-set-id)
[119.818515] Starting subtest: invalid-oa-metric-set-id
[119.829934] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[119.894979] [051/156] (899s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary)
[119.996911] Starting subtest: hdr-indfb-scaledprimary
[120.000536] Subtest hdr-indfb-scaledprimary: SKIP (0.000s)
[120.080824] [052/156] (898s left) kms_cursor_crc (cursor-offscreen-256x256)
[120.323503] Starting subtest: cursor-offscreen-256x256
[120.330876] Starting dynamic subtest: pipe-A-eDP-1
[122.276713] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.946s)
[122.310817] Starting dynamic subtest: pipe-D-eDP-1
[124.958032] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.655s)
[124.960312] Subtest cursor-offscreen-256x256: SUCCESS (4.633s)
[125.829631] [053/156] (893s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[125.931317] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[126.581595] Subtest linear-max-hw-stride-32bpp-rotate-0: FAIL (0.056s)
[126.619780] [054/156] (892s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[126.673145] Starting subtest: invalid-single-wait-unsubmitted
[126.674987] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[126.759895] [055/156] (892s left) gem_linear_blits (basic)
[127.108721] Starting subtest: basic
[127.120314] Subtest basic: SUCCESS (0.012s)
[127.277999] [056/156] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[127.427629] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[127.431738] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[127.524543] [057/156] (891s left) syncobj_wait (reset-during-wait-for-submit)
[127.586686] Starting subtest: reset-during-wait-for-submit
[127.690871] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[127.765114] [058/156] (891s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[127.876221] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[127.878566] Starting dynamic subtest: pipe-A
[128.923162] Dynamic subtest pipe-A: SUCCESS (1.050s)
[128.933301] Starting dynamic subtest: pipe-B
[131.015285] Dynamic subtest pipe-B: SUCCESS (2.092s)
[131.025384] Starting dynamic subtest: pipe-C
[132.216078] Dynamic subtest pipe-C: SUCCESS (1.200s)
[132.232535] Starting dynamic subtest: pipe-D
[133.450793] Dynamic subtest pipe-D: SUCCESS (1.234s)
[133.453195] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.578s)
[134.638411] [059/156] (884s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[134.732097] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[134.734376] Starting dynamic subtest: pipe-A-eDP-1
[134.757423] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[134.769686] Starting dynamic subtest: pipe-B-eDP-1
[134.791862] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[134.801531] Starting dynamic subtest: pipe-C-eDP-1
[134.822466] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[134.832124] Starting dynamic subtest: pipe-D-eDP-1
[134.853400] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[134.857667] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[137.010825] [060/156] (882s left) gem_sync (basic-many-each)
[137.083347] Starting subtest: basic-many-each
[139.362741] Subtest basic-many-each: SUCCESS (2.290s)
[139.557289] [061/156] (879s left) gem_mmap (pf-nonblock)
[139.624926] Subtest pf-nonblock: SKIP (0.000s)
[139.683442] [062/156] (879s left) fbdev (unaligned-write)
[139.729839] Starting subtest: unaligned-write
[139.826505] Subtest unaligned-write: SUCCESS (0.100s)
[139.891348] [063/156] (879s left) kms_color (ctm-signed)
[139.983085] Starting subtest: ctm-signed
[139.985411] Starting dynamic subtest: pipe-A-eDP-1
[142.100440] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[142.111632] Starting dynamic subtest: pipe-B-eDP-1
[144.958272] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.857s)
[144.969046] Starting dynamic subtest: pipe-C-eDP-1
[147.664135] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.703s)
[147.675068] Starting dynamic subtest: pipe-D-eDP-1
[150.334676] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.671s)
[150.337062] Subtest ctm-signed: SUCCESS (10.353s)
[151.161300] [064/156] (868s left) gem_ctx_param (invalid-size-set)
[151.218120] Starting subtest: invalid-size-set
[151.220475] Subtest invalid-size-set: SUCCESS (0.001s)
[151.313894] [065/156] (868s left) kms_psr (pr-sprite-blt)
[151.398587] Starting subtest: pr-sprite-blt
[151.402772] Subtest pr-sprite-blt: SKIP (0.000s)
[151.471235] [066/156] (868s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[151.592501] Starting subtest: short-busy-flip-before-cursor-toggle
[151.596944] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[151.739974] [067/156] (867s left) gen9_exec_parse (bb-start-param)
[151.793277] Subtest bb-start-param: SKIP (0.000s)
[151.868237] [068/156] (867s left) kms_addfb_basic (bad-pitch-1024)
[151.913823] Starting subtest: bad-pitch-1024
[151.916102] Subtest bad-pitch-1024: SUCCESS (0.000s)
[152.060387] [069/156] (867s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[152.107556] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[152.208957] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[152.285338] [070/156] (867s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[152.421794] Starting subtest: multiplane-atomic-fence-wait
[152.655543] Subtest multiplane-atomic-fence-wait: SUCCESS (0.233s)
[153.792273] [071/156] (866s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[154.044350] Starting subtest: cursor-rapid-movement-256x256
[154.050329] Starting dynamic subtest: pipe-A-eDP-1
[154.604621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[154.636630] Starting dynamic subtest: pipe-D-eDP-1
[155.820946] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s)
[155.822949] Subtest cursor-rapid-movement-256x256: SUCCESS (1.774s)
[156.659784] [072/156] (863s left) i915_query (engine-info-invalid)
[156.709047] Starting subtest: engine-info-invalid
[156.711214] Subtest engine-info-invalid: SUCCESS (0.000s)
[156.811462] [073/156] (863s left) kms_plane_scaling (planes-downscale-factor-0-5)
[156.906982] Starting subtest: planes-downscale-factor-0-5
[156.909135] Starting dynamic subtest: pipe-A
[156.928344] Dynamic subtest pipe-A: SKIP (0.019s)
[156.939086] Starting dynamic subtest: pipe-B
[156.964273] Dynamic subtest pipe-B: SKIP (0.035s)
[156.974528] Starting dynamic subtest: pipe-C
[156.999344] Dynamic subtest pipe-C: SKIP (0.035s)
[157.009255] Starting dynamic subtest: pipe-D
[157.037104] Dynamic subtest pipe-D: SKIP (0.037s)
[157.041050] Subtest planes-downscale-factor-0-5: SKIP (0.128s)
[157.136293] [074/156] (862s left) prime_busy (after)
[157.191597] Starting subtest: after
[157.197064] Starting dynamic subtest: rcs0
[157.229270] Dynamic subtest rcs0: SUCCESS (0.034s)
[157.239720] Starting dynamic subtest: bcs0
[157.268386] Dynamic subtest bcs0: SUCCESS (0.037s)
[157.278846] Starting dynamic subtest: vcs0
[157.308394] Dynamic subtest vcs0: SUCCESS (0.038s)
[157.320774] Starting dynamic subtest: vcs1
[157.349977] Dynamic subtest vcs1: SUCCESS (0.041s)
[157.360451] Starting dynamic subtest: vecs0
[157.392065] Dynamic subtest vecs0: SUCCESS (0.040s)
[157.402151] Starting dynamic subtest: ccs0
[157.431217] Dynamic subtest ccs0: SUCCESS (0.040s)
[157.540408] Subtest after: SUCCESS (0.347s)
[157.617363] [075/156] (862s left) gem_eio (wait-wedge-10ms)
[157.844808] Starting subtest: wait-wedge-10ms
[159.374056] Subtest wait-wedge-10ms: SUCCESS (1.527s)
[159.519741] [076/156] (860s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[159.622563] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[159.626870] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[159.718556] [077/156] (860s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[159.825094] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[159.827375] Starting dynamic subtest: pipe-A-eDP-1
[170.513529] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.693s)
[170.524172] Starting dynamic subtest: pipe-B-eDP-1
[181.971356] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.457s)
[181.973891] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.152s)
[182.840859] [078/156] (837s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[182.917394] Starting subtest: yf-tiled-ccs-to-yf-tiled
[182.921998] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[183.123189] [079/156] (837s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[183.228756] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[183.232747] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[183.324456] [080/156] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[183.427069] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[183.431502] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[183.545954] [081/156] (836s left) kms_prop_blob (invalid-set-prop-any)
[183.602620] Starting subtest: invalid-set-prop-any
[183.604592] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[183.708693] [082/156] (836s left) gem_exec_alignment (forked)
[183.769652] Starting subtest: forked
[221.364760] Subtest forked: SUCCESS (37.593s)
[221.579774] [083/156] (798s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[221.723075] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[221.725528] Starting dynamic subtest: pipe-A-eDP-1
[221.747947] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.760323] Starting dynamic subtest: pipe-B-eDP-1
[221.781136] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.791664] Starting dynamic subtest: pipe-C-eDP-1
[221.813534] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.823601] Starting dynamic subtest: pipe-D-eDP-1
[221.845567] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.849709] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[223.978258] [084/156] (796s left) gem_mmap_offset (isolation)
[224.032616] Starting subtest: isolation
[224.051161] Subtest isolation: SUCCESS (0.005s)
[224.140832] [085/156] (796s left) gem_exec_fence (syncobj-timeline-signal)
[224.758689] Starting subtest: syncobj-timeline-signal
[224.764703] Subtest syncobj-timeline-signal: SUCCESS (0.007s)
[226.372334] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[226.375629] [086/156] (794s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[226.491118] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[226.495162] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[226.608415] [087/156] (793s left) kms_fbcon_fbt (fbc-suspend)
[226.676170] Starting subtest: fbc-suspend
[276.077813] Subtest fbc-suspend: SUCCESS (19.247s)
[277.487854] [088/156] (743s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[277.592602] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[277.597636] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[277.674244] [089/156] (742s left) api_intel_bb (simple-bb)
[277.732398] Starting subtest: simple-bb
[277.735270] Subtest simple-bb: SUCCESS (0.007s)
[277.846885] [090/156] (742s left) kms_async_flips (async-flip-dpms)
[277.937237] Starting subtest: async-flip-dpms
[278.314011] Starting dynamic subtest: pipe-A-eDP-1
[282.219642] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.905s)
[282.593586] Starting dynamic subtest: pipe-B-eDP-1
[285.481084] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.898s)
[285.878004] Starting dynamic subtest: pipe-C-eDP-1
[288.746185] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.880s)
[289.126375] Starting dynamic subtest: pipe-D-eDP-1
[291.919935] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.802s)
[291.922380] Subtest async-flip-dpms: SUCCESS (13.986s)
[293.103672] [091/156] (727s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[293.201245] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[293.204042] Starting dynamic subtest: pipe-A-eDP-1
[293.230108] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[293.243249] Starting dynamic subtest: pipe-B-eDP-1
[293.268776] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[293.280197] Starting dynamic subtest: pipe-C-eDP-1
[293.305181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[293.316728] Starting dynamic subtest: pipe-D-eDP-1
[293.342151] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[293.347251] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[295.458665] [092/156] (725s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[295.559951] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[295.564354] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[295.658006] [093/156] (725s left) gem_eio (in-flight-suspend)
[295.890708] Starting subtest: in-flight-suspend
[341.256913] Subtest in-flight-suspend: SUCCESS (15.573s)
[341.388323] [094/156] (679s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[341.500223] Starting subtest: yf-tiled-32bpp-rotate-90
[341.504541] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[341.585206] [095/156] (679s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[341.684755] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[341.688960] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[341.781228] [096/156] (679s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[341.876943] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[341.881495] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[341.955314] [097/156] (678s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[342.056444] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[342.059878] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[342.166348] [098/156] (678s left) i915_drm_fdinfo (isolation)
[342.214428] Starting subtest: isolation
[342.216320] Starting dynamic subtest: rcs0
[342.246438] Dynamic subtest rcs0: SKIP (0.029s)
[342.260465] Starting dynamic subtest: bcs0
[342.264509] Dynamic subtest bcs0: SKIP (0.000s)
[342.275833] Starting dynamic subtest: vcs0
[342.279184] Dynamic subtest vcs0: SKIP (0.000s)
[342.290086] Starting dynamic subtest: vcs1
[342.293432] Dynamic subtest vcs1: SKIP (0.000s)
[342.304164] Starting dynamic subtest: vecs0
[342.307451] Dynamic subtest vecs0: SKIP (0.000s)
[342.318072] Starting dynamic subtest: ccs0
[342.321374] Dynamic subtest ccs0: SKIP (0.000s)
[342.324736] Subtest isolation: SKIP (0.035s)
[342.364509] [099/156] (678s left) kms_selftest (drm_format)
[342.401449] Starting subtest: drm_format
[342.409748] Starting dynamic subtest: drm_test_format_block_width_invalid
[342.514170] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.103s)
[342.527549] Starting dynamic subtest: drm_test_format_block_width_one_plane
[342.611437] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.095s)
[342.622812] Starting dynamic subtest: drm_test_format_block_width_two_plane
[342.738333] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.126s)
[342.749616] Starting dynamic subtest: drm_test_format_block_width_three_plane
[342.835706] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.097s)
[342.847235] Starting dynamic subtest: drm_test_format_block_width_tiled
[342.935005] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.099s)
[342.947806] Starting dynamic subtest: drm_test_format_block_height_invalid
[343.032101] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.096s)
[343.043828] Starting dynamic subtest: drm_test_format_block_height_one_plane
[343.141037] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.107s)
[343.153945] Starting dynamic subtest: drm_test_format_block_height_two_plane
[343.244153] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.100s)
[343.257075] Starting dynamic subtest: drm_test_format_block_height_three_plane
[343.349778] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.105s)
[343.362051] Starting dynamic subtest: drm_test_format_block_height_tiled
[343.444085] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.092s)
[343.456633] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[343.539138] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.093s)
[343.551401] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[343.635404] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.094s)
[343.647013] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[343.738599] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.103s)
[343.750084] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[343.841778] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.101s)
[343.855453] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[343.929479] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.087s)
[343.942250] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[344.039456] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.109s)
[344.052228] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[344.132291] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.093s)
[344.143897] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[344.229490] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.095s)
[344.231523] Subtest drm_format: SUCCESS (1.828s)
[344.401421] [100/156] (676s left) gem_exec_balancer (persistence)
[344.672363] Starting subtest: persistence
[345.625342] Subtest persistence: SUCCESS (0.955s)
[345.741429] [101/156] (675s left) gem_exec_balancer (hang)
[346.013545] Starting subtest: hang
[347.717054] Subtest hang: SUCCESS (1.708s)
[347.849884] [102/156] (673s left) kms_vblank (wait-forked-hang)
[347.948098] Starting subtest: wait-forked-hang
[347.950347] Starting dynamic subtest: pipe-A-eDP-1
[374.063044] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.118s)
[374.080080] Starting dynamic subtest: pipe-D-eDP-1
[399.029524] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.963s)
[399.031808] Subtest wait-forked-hang: SUCCESS (51.085s)
[399.932446] [103/156] (621s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[400.041639] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[400.045766] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[400.154294] [104/156] (621s left) gem_exec_whisper (basic-sync)
[400.218272] Starting subtest: basic-sync
[408.631653] Subtest basic-sync: SUCCESS (8.412s)
[408.825845] [105/156] (612s left) gem_exec_schedule (pi-common)
[409.005570] Starting subtest: pi-common
[409.007552] Starting dynamic subtest: rcs0
[409.030667] Dynamic subtest rcs0: SUCCESS (0.029s)
[409.045924] Starting dynamic subtest: bcs0
[409.063240] Dynamic subtest bcs0: SUCCESS (0.032s)
[409.080026] Starting dynamic subtest: vcs0
[409.093604] Dynamic subtest vcs0: SUCCESS (0.030s)
[409.110650] Starting dynamic subtest: vcs1
[409.125099] Dynamic subtest vcs1: SUCCESS (0.031s)
[409.142202] Starting dynamic subtest: vecs0
[409.154614] Dynamic subtest vecs0: SUCCESS (0.029s)
[409.170878] Starting dynamic subtest: ccs0
[409.185596] Dynamic subtest ccs0: SUCCESS (0.030s)
[409.187706] Subtest pi-common: SUCCESS (0.185s)
[409.438296] [106/156] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[409.543875] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[409.548183] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[409.647217] [107/156] (611s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[409.752632] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[416.734476] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.994s)
[416.885449] [108/156] (604s left) gem_userptr_blits (set-cache-level)
[416.948063] Starting subtest: set-cache-level
[416.952128] Subtest set-cache-level: SKIP (0.000s)
[417.084512] [109/156] (604s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[417.178944] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[424.597521] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.424s)
[424.736387] [110/156] (596s left) kms_rotation_crc (bad-pixel-format)
[424.845596] Starting subtest: bad-pixel-format
[424.850980] Subtest bad-pixel-format: SKIP (0.001s)
[424.922262] [111/156] (596s left) gem_mmap_gtt (basic-copy)
[424.975548] Subtest basic-copy: SKIP (0.000s)
[425.038329] [112/156] (596s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[425.146013] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[448.698290] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.560s)
[448.837419] [113/156] (572s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[448.942178] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[448.945583] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[449.039214] [114/156] (572s left) perf_pmu (interrupts-sync)
[449.082669] Starting subtest: interrupts-sync
[450.162594] Subtest interrupts-sync: SUCCESS (1.078s)
[450.275863] [115/156] (571s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[450.378159] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[450.382570] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[450.491423] [116/156] (571s left) i915_pm_rpm (reg-read-ioctl)
[452.449907] Starting subtest: reg-read-ioctl
[454.736051] Subtest reg-read-ioctl: SUCCESS (2.290s)
[455.124434] [117/156] (566s left) sw_sync (sync_multi_timeline_wait)
[455.163847] Starting subtest: sync_multi_timeline_wait
[455.166260] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[455.240353] [118/156] (566s left) gem_exec_reloc (basic-write-cpu-active)
[455.299889] Subtest basic-write-cpu-active: SKIP (0.000s)
[455.385587] [119/156] (566s left) kms_busy (basic)
[455.487001] Starting subtest: basic
[455.489305] Starting dynamic subtest: flip
[456.075633] Dynamic subtest flip: SUCCESS (0.589s)
[456.088555] Starting dynamic subtest: modeset
[459.771555] Dynamic subtest modeset: SUCCESS (3.694s)
[459.774089] Subtest basic: SUCCESS (4.286s)
[460.589961] [120/156] (561s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[460.705157] Starting subtest: psrhdr-rgb565-draw-render
[460.709185] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[460.814843] [121/156] (561s left) kms_flip (2x-plain-flip-ts-check)
[460.906145] Starting subtest: 2x-plain-flip-ts-check
[460.915133] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[460.998953] [122/156] (561s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[461.046406] Starting subtest: etime-single-wait-for-submit-unsubmitted
[461.147622] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[461.243990] [123/156] (560s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[461.350025] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[461.354420] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[461.459615] [124/156] (560s left) gem_close_race (multigpu-basic-process)
[461.514594] Starting subtest: multigpu-basic-process
[461.518326] Subtest multigpu-basic-process: SKIP (0.000s)
[461.736658] [125/156] (560s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[461.840634] Starting subtest: random-ccs-data-y-tiled-ccs
[461.842963] Starting dynamic subtest: pipe-A-eDP-1
[461.869091] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[461.883697] Starting dynamic subtest: pipe-B-eDP-1
[461.907679] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[461.919660] Starting dynamic subtest: pipe-C-eDP-1
[461.944793] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[461.961146] Starting dynamic subtest: pipe-D-eDP-1
[461.985242] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[461.989274] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[464.146752] [126/156] (558s left) gem_exec_store (basic)
[464.207254] Starting subtest: basic
[464.309636] Subtest basic: SUCCESS (0.102s)
[464.525588] [127/156] (557s left) gem_exec_schedule (u-fairslice-all)
[464.597836] Starting subtest: u-fairslice-all
[466.651650] Subtest u-fairslice-all: SUCCESS (2.061s)
[468.356760] [128/156] (554s left) kms_psr (psr-sprite-mmap-gtt)
[468.457739] Starting subtest: psr-sprite-mmap-gtt
[468.459895] Starting dynamic subtest: eDP-1
[469.936460] Dynamic subtest eDP-1: SKIP (1.475s)
[469.941164] Subtest psr-sprite-mmap-gtt: SKIP (1.477s)
[470.110316] [129/156] (552s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[470.204125] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[470.206271] Starting dynamic subtest: pipe-A-eDP-1
[470.225962] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[470.238895] Starting dynamic subtest: pipe-B-eDP-1
[470.258799] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[470.272758] Starting dynamic subtest: pipe-C-eDP-1
[470.292602] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[470.304747] Starting dynamic subtest: pipe-D-eDP-1
[470.325359] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[470.327786] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[472.638390] [130/156] (549s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[472.751842] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[477.678438] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.932s)
[478.842133] [131/156] (543s left) kms_pm_dc (dc5-dpms)
[479.942404] Starting subtest: dc5-dpms
[482.002462] Subtest dc5-dpms: SUCCESS (2.060s)
[482.082524] [132/156] (540s left) gem_exec_suspend (basic)
[482.137907] Starting subtest: basic
[482.140155] Starting dynamic subtest: smem
[484.273614] Dynamic subtest smem: SUCCESS (2.133s)
[484.276474] Subtest basic: SUCCESS (2.136s)
[484.465916] [133/156] (538s left) gem_partial_pwrite_pread (reads)
[484.523372] Subtest reads: SKIP (0.000s)
[484.605856] [134/156] (538s left) kms_pm_rpm (modeset-pc8-residency-stress)
[486.435463] Starting subtest: modeset-pc8-residency-stress
[486.441054] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[486.901252] [135/156] (535s left) gem_exec_params (invalid-flag)
[486.965909] Starting subtest: invalid-flag
[486.968349] Subtest invalid-flag: SUCCESS (0.000s)
[487.082957] [136/156] (535s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[487.176121] Starting subtest: fbcpsr-rgb101010-draw-blt
[491.943984] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.774s)
[492.085395] [137/156] (530s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen)
[492.189840] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen
[492.194283] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[492.290467] [138/156] (530s left) prime_mmap (test_forked_cpu_write)
[492.351959] Starting subtest: test_forked_cpu_write
[492.354264] Starting dynamic subtest: test_forked_cpu_write-smem
[492.360282] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[492.362572] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[492.459765] [139/156] (530s left) kms_psr (fbc-psr2-no-drrs)
[492.552842] Starting subtest: fbc-psr2-no-drrs
[492.555093] Starting dynamic subtest: eDP-1
[492.559206] Dynamic subtest eDP-1: SKIP (0.000s)
[492.563277] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[492.629748] [140/156] (530s left) kms_invalid_mode (zero-vdisplay)
[492.725239] Starting subtest: zero-vdisplay
[492.727625] Starting dynamic subtest: pipe-A-eDP-1
[493.014438] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[493.028401] Starting dynamic subtest: pipe-B-eDP-1
[493.030621] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[493.045681] Starting dynamic subtest: pipe-C-eDP-1
[493.047681] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[493.059727] Starting dynamic subtest: pipe-D-eDP-1
[493.062198] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[493.064603] Subtest zero-vdisplay: SUCCESS (0.298s)
[493.843198] [141/156] (529s left) kms_flip (2x-flip-vs-dpms)
[493.928185] Starting subtest: 2x-flip-vs-dpms
[493.939732] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[494.065060] [142/156] (528s left) gem_tiled_blits (normal)
[494.127172] Subtest normal: SKIP (0.000s)
[494.206603] [143/156] (528s left) gem_exec_flush (basic-batch-kernel-default-wb)
[494.273366] Starting subtest: basic-batch-kernel-default-wb
[501.796261] Subtest basic-batch-kernel-default-wb: SUCCESS (7.524s)
[501.985505] [144/156] (521s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[502.100696] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[505.836227] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.741s)
[507.041415] [145/156] (516s left) kms_tv_load_detect (load-detect)
[507.097559] Subtest load-detect: SKIP (0.000s)
[507.158649] [146/156] (516s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[507.268591] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[507.272569] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[507.387907] [147/156] (515s left) kms_chamelium_hpd (hdmi-hpd)
[507.780254] Subtest hdmi-hpd: SKIP (0.000s)
[508.645291] [148/156] (514s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[508.750289] Starting subtest: psr-rgb101010-draw-blt
[516.087386] Subtest psr-rgb101010-draw-blt: SUCCESS (7.340s)
[516.238682] [149/156] (507s left) perf_pmu (gt-awake)
[516.287120] Starting subtest: gt-awake
[525.235027] Subtest gt-awake: SUCCESS (8.945s)
[525.357783] [150/156] (498s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[525.468657] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[525.472959] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[525.552927] [151/156] (497s left) syncobj_timeline (multi-wait-signaled)
[525.619748] Starting subtest: multi-wait-signaled
[525.621766] Subtest multi-wait-signaled: SUCCESS (0.000s)
[525.743505] [152/156] (497s left) gem_exec_fence (syncobj-wait)
[526.184891] Starting subtest: syncobj-wait
[527.240765] Subtest syncobj-wait: SUCCESS (1.054s)
[529.314468] [153/156] (494s left) kms_content_protection (dp-mst-lic-type-1)
[529.459364] Starting subtest: dp-mst-lic-type-1
[529.464090] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[529.600079] [154/156] (493s left) i915_hangman (engine-engine-hang)
[529.667658] Starting subtest: engine-engine-hang
[529.669569] Starting dynamic subtest: rcs0
[531.215306] Dynamic subtest rcs0: SUCCESS (1.548s)
[531.228674] Starting dynamic subtest: bcs0
[533.198598] Dynamic subtest bcs0: SUCCESS (1.980s)
[533.213888] Starting dynamic subtest: vcs0
[535.247603] Dynamic subtest vcs0: SUCCESS (2.046s)
[535.261720] Starting dynamic subtest: vcs1
[537.167334] Dynamic subtest vcs1: SUCCESS (1.916s)
[537.183159] Starting dynamic subtest: vecs0
[539.215267] Dynamic subtest vecs0: SUCCESS (2.045s)
[539.230446] Starting dynamic subtest: ccs0
[541.199132] Dynamic subtest ccs0: SUCCESS (1.980s)
[541.202403] Subtest engine-engine-hang: SUCCESS (11.533s)
[541.286449] [155/156] (482s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[541.406019] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[548.117964] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.717s)
[548.259372] [156/156] (475s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[548.650339] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[549.431416] 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.