[59.933351] Initializing watchdogs
[59.933401]   /dev/watchdog0
[59.948354] [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]
[59.952535] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.954769] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.958213] [001/130] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[60.085210] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[60.087554] Starting dynamic subtest: pipe-A-eDP-1
[60.108064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[60.117017] Starting dynamic subtest: pipe-B-eDP-1
[60.136690] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[60.143388] Starting dynamic subtest: pipe-C-eDP-1
[60.162520] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[60.169649] Starting dynamic subtest: pipe-D-eDP-1
[60.190678] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[60.192650] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[62.400798] [002/130] (958s left) gem_fence_thrash (bo-write-verify-x)
[62.444372] Starting subtest: bo-write-verify-x
[62.471257] Subtest bo-write-verify-x: SKIP (0.025s)
[62.528966] [003/130] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[62.631659] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[70.003677] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.375s)
[70.170762] [004/130] (950s left) gem_exec_parallel (contexts)
[70.240391] Starting subtest: contexts
[70.242827] Starting dynamic subtest: rcs0
[72.950378] Dynamic subtest rcs0: SUCCESS (2.708s)
[72.962858] Starting dynamic subtest: bcs0
[76.166736] Dynamic subtest bcs0: SUCCESS (3.215s)
[76.174594] Starting dynamic subtest: vcs0
[80.397751] Dynamic subtest vcs0: SUCCESS (4.230s)
[80.407997] Starting dynamic subtest: vcs1
[84.471599] Dynamic subtest vcs1: SUCCESS (4.073s)
[84.479449] Starting dynamic subtest: vecs0
[88.440087] Dynamic subtest vecs0: SUCCESS (3.967s)
[88.450841] Starting dynamic subtest: ccs0
[91.839871] Dynamic subtest ccs0: SUCCESS (3.399s)
[91.842625] Subtest contexts: SUCCESS (21.599s)
[92.058037] [005/130] (928s left) gem_wait (invalid-buf)
[92.118045] Starting subtest: invalid-buf
[92.120231] Subtest invalid-buf: SUCCESS (0.000s)
[92.346933] [006/130] (928s left) gem_tiled_wb
[92.483177] [007/130] (928s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[92.600066] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[96.311060] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.714s)
[97.454273] [008/130] (923s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[97.566078] Starting subtest: x-tiled-8bpp-rotate-90
[97.592326] Subtest x-tiled-8bpp-rotate-90: SKIP (0.023s)
[97.743304] [009/130] (923s left) i915_drm_fdinfo (most-busy-idle-check-all)
[97.781309] Starting subtest: most-busy-idle-check-all
[97.783657] Starting dynamic subtest: rcs0
[97.788252] Dynamic subtest rcs0: SKIP (0.004s)
[97.797251] Starting dynamic subtest: bcs0
[97.801665] Dynamic subtest bcs0: SKIP (0.000s)
[97.808959] Starting dynamic subtest: vcs0
[97.813166] Dynamic subtest vcs0: SKIP (0.000s)
[97.820498] Starting dynamic subtest: vcs1
[97.824830] Dynamic subtest vcs1: SKIP (0.000s)
[97.832250] Starting dynamic subtest: vecs0
[97.836617] Dynamic subtest vecs0: SKIP (0.000s)
[97.844644] Starting dynamic subtest: ccs0
[97.849178] Dynamic subtest ccs0: SKIP (0.000s)
[97.853453] Subtest most-busy-idle-check-all: SKIP (0.006s)
[97.888191] [010/130] (922s left) gem_exec_reloc (basic-wc-noreloc)
[97.951535] Subtest basic-wc-noreloc: SKIP (0.000s)
[98.034951] [011/130] (922s left) gem_mmap_offset (blt-coherency)
[98.089654] Starting subtest: blt-coherency
[98.094473] Subtest blt-coherency: SUCCESS (0.007s)
[98.251916] [012/130] (922s left) kms_dp_aux_dev
[98.616931] [013/130] (922s left) gem_exec_params (cliprects-invalid)
[98.663768] Starting subtest: cliprects-invalid
[98.666172] Subtest cliprects-invalid: SUCCESS (0.000s)
[98.784536] [014/130] (922s left) vgem_basic (mmap)
[98.907731] Starting subtest: mmap
[98.912072] Subtest mmap: SUCCESS (0.007s)
[98.994437] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[98.997656] [015/130] (921s left) kms_getfb (getfb-handle-closed)
[99.096625] Starting subtest: getfb-handle-closed
[99.098961] Subtest getfb-handle-closed: SUCCESS (0.000s)
[99.226289] [016/130] (921s left) kms_cursor_crc (cursor-offscreen-max-size)
[99.522240] Starting subtest: cursor-offscreen-max-size
[99.527807] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[99.675176] [017/130] (921s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[99.795061] Starting subtest: cursorB-vs-flipB-varying-size
[99.798818] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[99.984076] [018/130] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[100.077460] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[100.081148] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[100.190918] [019/130] (920s left) kms_big_fb (linear-8bpp-rotate-270)
[100.301353] Starting subtest: linear-8bpp-rotate-270
[100.322294] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[100.469875] [020/130] (920s left) kms_dp_linktrain_fallback (dp-fallback)
[100.575465] Starting subtest: dp-fallback
[100.580856] Subtest dp-fallback: SKIP (0.000s)
[100.671863] [021/130] (920s left) core_debugfs (read-all-entries)
[100.721108] Starting subtest: read-all-entries
[100.815685] Subtest read-all-entries: SUCCESS (0.096s)
[100.929836] [022/130] (920s left) gem_ctx_param (invalid-get-engines)
[100.983361] Starting subtest: invalid-get-engines
[100.985480] Subtest invalid-get-engines: SUCCESS (0.001s)
[101.120198] [023/130] (920s left) vgem_basic (setversion)
[101.159072] Starting subtest: setversion
[101.162725] Subtest setversion: SUCCESS (0.000s)
[101.238951] [024/130] (920s left) kms_psr (psr-primary-render)
[101.334483] Starting subtest: psr-primary-render
[101.336509] Starting dynamic subtest: eDP-1
[103.122893] Dynamic subtest eDP-1: SUCCESS (1.788s)
[103.125100] Subtest psr-primary-render: SUCCESS (1.789s)
[104.016875] [025/130] (917s left) kms_getfb (getfb-handle-zero)
[104.116229] Starting subtest: getfb-handle-zero
[104.118469] Subtest getfb-handle-zero: SUCCESS (0.000s)
[104.237040] [026/130] (917s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[104.337071] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[104.339293] Starting dynamic subtest: pipe-A-default-mode
[104.640104] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[104.644894] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.299s)
[105.452135] [027/130] (916s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[105.528849] Starting subtest: basic-batch-kernel-default-cmd
[105.533336] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[105.731621] [028/130] (915s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[105.831810] Starting subtest: fbc-farfromfence-mmap-gtt
[105.836425] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[105.971867] [029/130] (915s left) kms_plane_multiple (2x-tiling-4)
[106.073069] Starting subtest: 2x-tiling-4
[106.077256] Subtest 2x-tiling-4: SKIP (0.000s)
[106.166170] [030/130] (915s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[106.266301] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[106.268432] Starting dynamic subtest: pipe-A-eDP-1
[106.439034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.162s)
[106.449224] Starting dynamic subtest: pipe-B-eDP-1
[106.469737] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[106.477781] Starting dynamic subtest: pipe-C-eDP-1
[106.497149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[106.504903] Starting dynamic subtest: pipe-D-eDP-1
[106.523792] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[106.525953] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.170s)
[108.711335] [031/130] (912s left) gem_eio (in-flight-suspend)
[108.939969] Starting subtest: in-flight-suspend
[158.709293] Subtest in-flight-suspend: SUCCESS (20.027s)
[158.887754] [032/130] (862s left) gen7_exec_parse (bitmasks)
[158.962786] Subtest bitmasks: SKIP (0.000s)
[159.048567] [033/130] (862s left) gem_mmap_gtt (medium-copy-xy)
[159.101221] Subtest medium-copy-XY: SKIP (0.000s)
[159.156497] [034/130] (862s left) kms_chamelium_frames (hdmi-crc-single)
[159.548754] Subtest hdmi-crc-single: SKIP (0.000s)
[160.401510] [035/130] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[160.514931] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[160.519506] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[160.663062] [036/130] (861s left) gem_exec_schedule (timeslicing)
[160.739545] Starting subtest: timeslicing
[160.741876] Starting dynamic subtest: rcs0
[160.750607] Dynamic subtest rcs0: SUCCESS (0.021s)
[160.761643] Starting dynamic subtest: bcs0
[160.770983] Dynamic subtest bcs0: SUCCESS (0.020s)
[160.780811] Starting dynamic subtest: vcs0
[160.791497] Dynamic subtest vcs0: SUCCESS (0.020s)
[160.800676] Starting dynamic subtest: vcs1
[160.811352] Dynamic subtest vcs1: SUCCESS (0.019s)
[160.820532] Starting dynamic subtest: vecs0
[160.831786] Dynamic subtest vecs0: SUCCESS (0.020s)
[160.840974] Starting dynamic subtest: ccs0
[160.852635] Dynamic subtest ccs0: SUCCESS (0.020s)
[160.854959] Subtest timeslicing: SUCCESS (0.124s)
[162.690336] [037/130] (859s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[167.702138] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[167.704503] Starting dynamic subtest: pipe-A-eDP-1
[184.881621] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.174s)
[184.891929] Starting dynamic subtest: pipe-B-eDP-1
[202.015002] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.128s)
[202.017402] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.305s)
[202.841073] [038/130] (819s left) gem_exec_schedule (deep)
[203.014707] Starting subtest: deep
[203.017234] Starting dynamic subtest: rcs0
[208.437965] Dynamic subtest rcs0: SKIP (5.420s)
[208.450137] Starting dynamic subtest: vcs0
[219.469386] Dynamic subtest vcs0: SUCCESS (11.031s)
[219.483004] Starting dynamic subtest: vcs1
[230.750591] Dynamic subtest vcs1: SUCCESS (11.274s)
[230.761524] Starting dynamic subtest: vecs0
[242.224251] Dynamic subtest vecs0: SUCCESS (11.479s)
[242.236819] Starting dynamic subtest: ccs0
[254.722830] Dynamic subtest ccs0: SUCCESS (12.496s)
[254.726653] Subtest deep: SUCCESS (51.703s)
[255.907326] [039/130] (766s left) kms_color (degamma)
[256.003143] Starting subtest: degamma
[256.005336] Starting dynamic subtest: pipe-A-eDP-1
[256.767185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.764s)
[256.777362] Starting dynamic subtest: pipe-B-eDP-1
[258.230971] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.464s)
[258.242396] Starting dynamic subtest: pipe-C-eDP-1
[259.615071] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[259.625253] Starting dynamic subtest: pipe-D-eDP-1
[260.943184] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[260.945531] Subtest degamma: SUCCESS (4.940s)
[261.765591] [040/130] (760s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[261.874872] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[261.878918] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[262.003878] [041/130] (760s left) gem_eio (banned)
[262.236554] Starting subtest: banned
[262.884340] Subtest banned: SUCCESS (0.649s)
[263.059807] [042/130] (759s left) gem_ppgtt (flink-and-close-vma-leak)
[263.123700] Starting subtest: flink-and-close-vma-leak
[263.164467] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[263.331174] [043/130] (758s left) kms_cursor_crc (cursor-sliding-128x42)
[263.549848] Starting subtest: cursor-sliding-128x42
[263.596526] Subtest cursor-sliding-128x42: SKIP (0.042s)
[263.841591] [044/130] (758s left) kms_atomic_transition (modeset-transition-nonblocking)
[263.933666] Starting subtest: modeset-transition-nonblocking
[263.935444] Starting dynamic subtest: 1x-outputs
[274.995181] Dynamic subtest 1x-outputs: SUCCESS (11.061s)
[274.998063] Subtest modeset-transition-nonblocking: SUCCESS (11.062s)
[275.881906] [045/130] (746s left) kms_plane_alpha_blend (alpha-transparent-fb)
[275.974425] Starting subtest: alpha-transparent-fb
[276.258024] Starting dynamic subtest: pipe-A-eDP-1
[276.868898] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[276.879227] Starting dynamic subtest: pipe-D-eDP-1
[278.224735] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[278.227047] Subtest alpha-transparent-fb: SUCCESS (2.251s)
[279.045409] [046/130] (743s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[279.144642] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[286.466525] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.324s)
[286.637514] [047/130] (735s left) syncobj_wait (wait-all-complex)
[286.700764] Starting subtest: wait-all-complex
[286.912811] Subtest wait-all-complex: SUCCESS (0.212s)
[287.015658] [048/130] (735s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[287.123377] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[293.863536] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.742s)
[294.005594] [049/130] (728s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[294.103306] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[294.107898] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[295.260785] [050/130] (727s left) gem_exec_whisper (basic-fds-priority)
[295.336286] Starting subtest: basic-fds-priority
[319.094101] Subtest basic-fds-priority: SUCCESS (23.753s)
[319.306386] [051/130] (703s left) gem_wait (await)
[319.379961] Starting subtest: await
[319.382329] Starting dynamic subtest: all-engines
[320.546949] Dynamic subtest all-engines: SUCCESS (1.166s)
[320.559469] Starting dynamic subtest: rcs0
[321.615644] Dynamic subtest rcs0: SUCCESS (1.066s)
[321.632841] Starting dynamic subtest: bcs0
[322.679801] Dynamic subtest bcs0: SUCCESS (1.062s)
[322.696477] Starting dynamic subtest: vcs0
[323.736382] Dynamic subtest vcs0: SUCCESS (1.055s)
[323.754167] Starting dynamic subtest: vcs1
[324.790595] Dynamic subtest vcs1: SUCCESS (1.052s)
[324.808239] Starting dynamic subtest: vecs0
[325.845340] Dynamic subtest vecs0: SUCCESS (1.052s)
[325.862282] Starting dynamic subtest: ccs0
[326.904119] Dynamic subtest ccs0: SUCCESS (1.056s)
[326.906984] Subtest await: SUCCESS (7.525s)
[327.128913] [052/130] (695s left) kms_psr (pr-no-drrs)
[327.237404] Starting subtest: pr-no-drrs
[327.241890] Subtest pr-no-drrs: SKIP (0.000s)
[327.345644] [053/130] (695s left) kms_joiner (basic-max-non-joiner)
[327.461252] Starting subtest: basic-max-non-joiner
[327.465423] Subtest basic-max-non-joiner: SKIP (0.000s)
[327.543333] [054/130] (695s left) kms_vblank (query-idle-hang)
[327.644684] Starting subtest: query-idle-hang
[327.646934] Starting dynamic subtest: pipe-A-eDP-1
[354.431347] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.784s)
[354.446249] Starting dynamic subtest: pipe-D-eDP-1
[379.389335] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.955s)
[379.391521] Subtest query-idle-hang: SUCCESS (51.744s)
[380.215527] [055/130] (642s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[380.276527] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[380.278438] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[380.413365] [056/130] (642s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[380.686798] Starting subtest: cursor-rapid-movement-256x85
[380.737051] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[380.945632] [057/130] (641s left) gem_lmem_swapping (verify-ccs)
[380.992142] Subtest verify-ccs: SKIP (0.000s)
[381.035606] [058/130] (641s left) kms_universal_plane (cursor-fb-leak)
[381.137713] Starting subtest: cursor-fb-leak
[381.139757] Starting dynamic subtest: pipe-A-eDP-1
[381.453884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.317s)
[381.464373] Starting dynamic subtest: pipe-B-eDP-1
[382.776767] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.321s)
[382.788679] Starting dynamic subtest: pipe-C-eDP-1
[384.096166] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s)
[384.107094] Starting dynamic subtest: pipe-D-eDP-1
[385.415765] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[385.418196] Subtest cursor-fb-leak: SUCCESS (4.279s)
[386.620640] [059/130] (636s left) kms_getfb (getfb-reject-nv12)
[386.717482] Starting subtest: getfb-reject-nv12
[386.719803] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[386.845750] [060/130] (636s left) kms_lease (atomic-implicit-crtc)
[386.938693] Starting subtest: atomic-implicit-crtc
[386.940968] Starting dynamic subtest: pipe-A-eDP-1
[386.952098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[386.963295] Starting dynamic subtest: pipe-B-eDP-1
[386.974500] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[386.984116] Starting dynamic subtest: pipe-C-eDP-1
[386.994746] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[387.004110] Starting dynamic subtest: pipe-D-eDP-1
[387.014634] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[387.016514] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[387.114459] [061/130] (635s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[387.213659] Starting subtest: flip-vs-dpms-on-nop-interruptible
[387.218397] Starting dynamic subtest: A-eDP1
[389.099875] Dynamic subtest A-eDP1: SUCCESS (1.882s)
[389.112189] Starting dynamic subtest: B-eDP1
[390.924797] Dynamic subtest B-eDP1: SUCCESS (1.823s)
[390.937169] Starting dynamic subtest: C-eDP1
[392.732905] Dynamic subtest C-eDP1: SUCCESS (1.806s)
[392.744112] Starting dynamic subtest: D-eDP1
[394.561663] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[394.566671] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.353s)
[395.761137] [062/130] (627s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[395.862045] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[395.863973] Starting dynamic subtest: pipe-A-eDP-1
[396.608180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[396.618975] Starting dynamic subtest: pipe-B-eDP-1
[398.402494] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.793s)
[398.412349] Starting dynamic subtest: pipe-C-eDP-1
[400.213365] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.808s)
[400.225050] Starting dynamic subtest: pipe-D-eDP-1
[402.054445] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.840s)
[402.056369] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.187s)
[403.296586] [063/130] (619s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[403.405575] Starting subtest: fbc-modesetfrombusy
[407.131832] Subtest fbc-modesetfrombusy: SUCCESS (3.729s)
[408.335094] [064/130] (614s left) gem_create (busy-create)
[408.393589] Starting subtest: busy-create
[408.395946] Starting dynamic subtest: smem0
[441.698701] Dynamic subtest smem0: SUCCESS (33.301s)
[441.701526] Subtest busy-create: SUCCESS (33.303s)
[441.911842] [065/130] (581s left) kms_psr (fbc-pr-sprite-render)
[442.010271] Starting subtest: fbc-pr-sprite-render
[442.014786] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[442.106917] [066/130] (581s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[442.213615] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[442.217850] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[442.333124] [067/130] (580s left) gem_ctx_persistence (engines-queued)
[442.397402] Starting subtest: engines-queued
[442.399293] Starting dynamic subtest: rcs0
[442.508034] Dynamic subtest rcs0: SUCCESS (0.112s)
[442.521517] Starting dynamic subtest: bcs0
[442.553942] Dynamic subtest bcs0: SUCCESS (0.044s)
[442.565817] Starting dynamic subtest: vcs0
[443.618400] Dynamic subtest vcs0: SUCCESS (1.061s)
[443.631873] Starting dynamic subtest: vcs1
[445.600276] Dynamic subtest vcs1: SUCCESS (1.978s)
[445.613643] Starting dynamic subtest: vecs0
[447.583058] Dynamic subtest vecs0: SUCCESS (1.980s)
[447.597113] Starting dynamic subtest: ccs0
[447.774097] Dynamic subtest ccs0: SUCCESS (0.191s)
[447.776511] Subtest engines-queued: SUCCESS (5.381s)
[447.939846] [068/130] (575s left) gem_sync (basic-each)
[448.026923] Starting subtest: basic-each
[450.574027] Subtest basic-each: SUCCESS (2.555s)
[450.799837] [069/130] (572s left) gem_render_copy (x-tiled)
[450.865162] Starting subtest: x-tiled
[450.867617] Starting dynamic subtest: smem
[450.918663] Dynamic subtest smem: SUCCESS (0.052s)
[450.921646] Subtest x-tiled: SUCCESS (0.054s)
[451.194531] [070/130] (572s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[451.263787] Starting subtest: yf-tiled-ccs-to-x-tiled
[451.269045] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[451.501830] [071/130] (571s left) kms_flip (basic-flip-vs-wf_vblank)
[451.606680] Starting subtest: basic-flip-vs-wf_vblank
[451.609082] Starting dynamic subtest: A-eDP1
[453.543174] Dynamic subtest A-eDP1: SUCCESS (1.936s)
[453.555205] Starting dynamic subtest: B-eDP1
[455.470492] Dynamic subtest B-eDP1: SUCCESS (1.926s)
[455.481042] Starting dynamic subtest: C-eDP1
[457.394140] Dynamic subtest C-eDP1: SUCCESS (1.922s)
[457.406994] Starting dynamic subtest: D-eDP1
[459.322049] Dynamic subtest D-eDP1: SUCCESS (1.927s)
[459.327649] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.724s)
[460.575919] [072/130] (562s left) gem_exec_reloc (basic-gtt-wc-active)
[460.644308] Subtest basic-gtt-wc-active: SKIP (0.000s)
[460.751032] [073/130] (562s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[460.842593] Starting subtest: async-flip-with-page-flip-events-tiled
[461.224787] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[462.651994] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: FAIL (0.843s)
[462.663600] Starting dynamic subtest: pipe-A-eDP-1-4
[463.014611] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.655s)
[463.023916] Starting dynamic subtest: pipe-A-eDP-1-4
[463.136399] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.017s)
[463.147834] Starting dynamic subtest: pipe-A-eDP-1-x
[463.438233] Dynamic subtest pipe-A-eDP-1-x: FAIL (0.180s)
[463.450170] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[464.663244] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: FAIL (1.171s)
[464.673231] Starting dynamic subtest: pipe-B-eDP-1-4
[465.022558] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.179s)
[465.034685] Starting dynamic subtest: pipe-B-eDP-1-4
[465.152080] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.014s)
[465.163099] Starting dynamic subtest: pipe-B-eDP-1-x
[465.461582] Dynamic subtest pipe-B-eDP-1-x: FAIL (0.630s)
[465.679158] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[468.408545] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.737s)
[468.419818] Starting dynamic subtest: pipe-C-eDP-1-4
[470.572481] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[470.583300] Starting dynamic subtest: pipe-C-eDP-1-4
[472.583169] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[472.593435] Starting dynamic subtest: pipe-C-eDP-1-x
[474.750073] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s)
[475.115133] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[477.836993] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.732s)
[477.848489] Starting dynamic subtest: pipe-D-eDP-1-4
[480.012638] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[480.025684] Starting dynamic subtest: pipe-D-eDP-1-4
[482.023304] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[482.033698] Starting dynamic subtest: pipe-D-eDP-1-x
[484.201389] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[484.203578] Subtest async-flip-with-page-flip-events-tiled: FAIL (23.360s)
[485.452040] [074/130] (538s left) gem_softpin (allocator-basic-reserve)
[485.510580] Starting subtest: allocator-basic-reserve
[485.579542] Subtest allocator-basic-reserve: SUCCESS (0.068s)
[485.759480] [075/130] (537s left) perf_pmu (pmu-read)
[485.795382] Starting subtest: pmu-read
[485.797595] Subtest pmu-read: SUCCESS (0.003s)
[485.933013] [076/130] (537s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[486.038775] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[486.043119] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[486.180142] [077/130] (537s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[486.277889] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[486.282050] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[486.424896] [078/130] (537s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[486.488067] Starting subtest: single-wait-for-submit-available-submitted
[486.489972] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[486.625703] [079/130] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[486.731550] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[486.735016] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[486.875405] [080/130] (536s left) gem_render_copy (yf-tiled-to-vebox-linear)
[486.939796] Starting subtest: yf-tiled-to-vebox-linear
[486.943752] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[487.148037] [081/130] (536s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[487.718958] Starting subtest: syncobj-stationary-timeline-chain-engines
[487.836382] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.119s)
[488.771872] [082/130] (535s left) kms_psr (fbc-pr-primary-mmap-gtt)
[488.870801] Starting subtest: fbc-pr-primary-mmap-gtt
[488.875078] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[488.971813] [083/130] (534s left) gem_mmap_wc (copy)
[489.024210] Subtest copy: SKIP (0.000s)
[489.090064] [084/130] (534s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[489.183483] Starting subtest: plane-upscale-factor-0-25-with-rotation
[489.185667] Starting dynamic subtest: pipe-A
[489.408152] Dynamic subtest pipe-A: SUCCESS (0.227s)
[489.418373] Starting dynamic subtest: pipe-B
[490.704420] Dynamic subtest pipe-B: SUCCESS (1.295s)
[490.714763] Starting dynamic subtest: pipe-C
[492.034390] Dynamic subtest pipe-C: SUCCESS (1.328s)
[492.045052] Starting dynamic subtest: pipe-D
[493.359651] Dynamic subtest pipe-D: SUCCESS (1.324s)
[493.362085] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.179s)
[494.567775] [085/130] (529s left) gem_exec_schedule (preemptive-hang)
[494.741136] Starting subtest: preemptive-hang
[494.743919] Starting dynamic subtest: rcs0
[503.789994] Dynamic subtest rcs0: SUCCESS (9.046s)
[503.801879] Starting dynamic subtest: bcs0
[512.748090] Dynamic subtest bcs0: SUCCESS (8.960s)
[512.760211] Starting dynamic subtest: vcs0
[521.772928] Dynamic subtest vcs0: SUCCESS (9.021s)
[521.784917] Starting dynamic subtest: vcs1
[530.795013] Dynamic subtest vcs1: SUCCESS (9.019s)
[530.807010] Starting dynamic subtest: vecs0
[539.753668] Dynamic subtest vecs0: SUCCESS (8.956s)
[539.763631] Starting dynamic subtest: ccs0
[548.781639] Dynamic subtest ccs0: SUCCESS (9.028s)
[548.784107] Subtest preemptive-hang: SUCCESS (54.041s)
[549.080378] [086/130] (474s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[549.183454] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[549.185762] Starting dynamic subtest: pipe-A-eDP-1
[549.208630] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[549.223830] Starting dynamic subtest: pipe-B-eDP-1
[549.246468] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[549.258553] Starting dynamic subtest: pipe-C-eDP-1
[549.280407] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[549.290805] Starting dynamic subtest: pipe-D-eDP-1
[549.312854] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[549.316926] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[551.505292] [087/130] (472s left) gem_exec_suspend (basic-s3)
[551.573617] Starting subtest: basic-S3
[551.575966] Starting dynamic subtest: smem
[574.360784] Dynamic subtest smem: SUCCESS (9.066s)
[574.363771] Subtest basic-S3: SUCCESS (9.068s)
[581.588163] [088/130] (449s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[581.713754] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[581.719281] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[581.855222] [089/130] (449s left) gem_huc_copy (huc-copy)
[581.935000] Starting subtest: huc-copy
[581.937445] Subtest huc-copy: SUCCESS (0.006s)
[582.107338] [090/130] (449s left) kms_flip (flip-vs-expired-vblank)
[582.210268] Starting subtest: flip-vs-expired-vblank
[582.212749] Starting dynamic subtest: A-eDP1
[590.908622] Dynamic subtest A-eDP1: SUCCESS (8.690s)
[590.920759] Starting dynamic subtest: B-eDP1
[599.547437] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[599.558225] Starting dynamic subtest: C-eDP1
[608.175743] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[608.187305] Starting dynamic subtest: D-eDP1
[616.817316] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[616.823746] Subtest flip-vs-expired-vblank: SUCCESS (34.597s)
[618.040240] [091/130] (413s left) i915_pm_rc6_residency (rc6-fence)
[618.104996] Starting subtest: rc6-fence
[618.131132] Starting dynamic subtest: gt0
[630.458924] Dynamic subtest gt0: SUCCESS (12.328s)
[630.475607] Starting dynamic subtest: gt1
[646.296447] Dynamic subtest gt1: SUCCESS (15.831s)
[646.299761] Subtest rc6-fence: SUCCESS (28.192s)
[646.401106] [092/130] (384s left) kms_plane (plane-position-hole)
[646.508504] Starting subtest: plane-position-hole
[647.043678] Starting dynamic subtest: pipe-A-plane-1
[648.274434] Dynamic subtest pipe-A-plane-1: SUCCESS (1.232s)
[648.286098] Starting dynamic subtest: pipe-A-plane-2
[649.497531] Dynamic subtest pipe-A-plane-2: SUCCESS (1.222s)
[649.508680] Starting dynamic subtest: pipe-A-plane-3
[650.756207] Dynamic subtest pipe-A-plane-3: SUCCESS (1.258s)
[650.767553] Starting dynamic subtest: pipe-A-plane-4
[652.097684] Dynamic subtest pipe-A-plane-4: SUCCESS (1.340s)
[652.109962] Starting dynamic subtest: pipe-A-plane-5
[652.123795] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[653.323488] Starting dynamic subtest: pipe-B-plane-1
[654.557782] Dynamic subtest pipe-B-plane-1: SUCCESS (1.246s)
[654.569191] Starting dynamic subtest: pipe-B-plane-2
[655.809353] Dynamic subtest pipe-B-plane-2: SUCCESS (1.250s)
[655.821240] Starting dynamic subtest: pipe-B-plane-3
[657.133499] Dynamic subtest pipe-B-plane-3: SUCCESS (1.322s)
[657.143659] Starting dynamic subtest: pipe-B-plane-4
[658.357457] Dynamic subtest pipe-B-plane-4: SUCCESS (1.223s)
[658.369368] Starting dynamic subtest: pipe-B-plane-5
[658.385019] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[658.387179] Subtest plane-position-hole: SUCCESS (11.875s)
[659.186468] [093/130] (372s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[659.287475] Starting subtest: random-ccs-data-yf-tiled-ccs
[659.289921] Starting dynamic subtest: pipe-A-eDP-1
[659.318077] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[659.328055] Starting dynamic subtest: pipe-B-eDP-1
[659.355798] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[659.365367] Starting dynamic subtest: pipe-C-eDP-1
[659.392560] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[659.402396] Starting dynamic subtest: pipe-D-eDP-1
[659.430485] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[659.435562] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[661.545019] [094/130] (369s left) i915_hangman (engine-engine-error)
[661.617667] Starting subtest: engine-engine-error
[661.620416] Starting dynamic subtest: rcs0
[663.349787] Dynamic subtest rcs0: SUCCESS (1.731s)
[663.362597] Starting dynamic subtest: bcs0
[665.334278] Dynamic subtest bcs0: SUCCESS (1.982s)
[665.350000] Starting dynamic subtest: vcs0
[667.318450] Dynamic subtest vcs0: SUCCESS (1.981s)
[667.332130] Starting dynamic subtest: vcs1
[669.301864] Dynamic subtest vcs1: SUCCESS (1.980s)
[669.316519] Starting dynamic subtest: vecs0
[671.349894] Dynamic subtest vecs0: SUCCESS (2.045s)
[671.362785] Starting dynamic subtest: ccs0
[673.334538] Dynamic subtest ccs0: SUCCESS (1.981s)
[673.337568] Subtest engine-engine-error: SUCCESS (11.716s)
[673.503796] [095/130] (357s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[673.603113] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[680.914728] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.314s)
[681.085026] [096/130] (350s left) gem_pwrite (basic-exhaustion)
[681.150558] Subtest basic-exhaustion: SKIP (0.000s)
[681.217506] [097/130] (350s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[681.279501] Starting subtest: etime-single-wait-available-unsubmitted
[681.379893] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s)
[681.482826] [098/130] (350s left) kms_prime (basic-crc-vgem)
[681.576198] Starting subtest: basic-crc-vgem
[681.578561] Starting dynamic subtest: second-to-first
[682.617590] Dynamic subtest second-to-first: SUCCESS (1.043s)
[682.620544] Subtest basic-crc-vgem: SUCCESS (1.044s)
[682.724125] [099/130] (348s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[682.879027] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[682.881260] Starting dynamic subtest: pipe-A-default-mode
[683.181123] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[683.186306] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.299s)
[684.005025] [100/130] (347s left) gem_exec_balancer (invalid-bonds)
[684.069609] Starting subtest: invalid-bonds
[684.074601] Subtest invalid-bonds: SKIP (0.000s)
[684.395261] [101/130] (347s left) gem_exec_balancer (sliced)
[684.466591] Starting subtest: sliced
[684.472020] Subtest sliced: SKIP (0.000s)
[684.775573] [102/130] (346s left) gem_exec_parallel (basic)
[684.836505] Starting subtest: basic
[684.839361] Starting dynamic subtest: rcs0
[686.569544] Dynamic subtest rcs0: SUCCESS (1.733s)
[686.582443] Starting dynamic subtest: bcs0
[688.300487] Dynamic subtest bcs0: SUCCESS (1.730s)
[688.317577] Starting dynamic subtest: vcs0
[690.329787] Dynamic subtest vcs0: SUCCESS (2.026s)
[690.343567] Starting dynamic subtest: vcs1
[692.377632] Dynamic subtest vcs1: SUCCESS (2.046s)
[692.390085] Starting dynamic subtest: vecs0
[694.360973] Dynamic subtest vecs0: SUCCESS (1.980s)
[694.372772] Starting dynamic subtest: ccs0
[696.165487] Dynamic subtest ccs0: SUCCESS (1.803s)
[696.168240] Subtest basic: SUCCESS (11.331s)
[696.380349] [103/130] (335s left) prime_busy (after)
[696.442483] Starting subtest: after
[696.448563] Starting dynamic subtest: rcs0
[696.487831] Dynamic subtest rcs0: SUCCESS (0.041s)
[696.500036] Starting dynamic subtest: bcs0
[696.549248] Dynamic subtest bcs0: SUCCESS (0.061s)
[696.560508] Starting dynamic subtest: vcs0
[696.591484] Dynamic subtest vcs0: SUCCESS (0.042s)
[696.601638] Starting dynamic subtest: vcs1
[696.635222] Dynamic subtest vcs1: SUCCESS (0.042s)
[696.647503] Starting dynamic subtest: vecs0
[696.678421] Dynamic subtest vecs0: SUCCESS (0.042s)
[696.688631] Starting dynamic subtest: ccs0
[696.720550] Dynamic subtest ccs0: SUCCESS (0.041s)
[696.829090] Subtest after: SUCCESS (0.385s)
[696.930163] [104/130] (334s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[697.034607] Starting subtest: y-tiled-64bpp-rotate-0
[697.040041] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[697.161137] [105/130] (334s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[697.256391] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[697.260768] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[697.387360] [106/130] (334s left) gem_mmap_wc (read-write-distinct)
[697.450868] Subtest read-write-distinct: SKIP (0.000s)
[697.518937] [107/130] (334s left) gem_ctx_sseu (engines)
[697.575474] Subtest engines: SKIP (0.000s)
[697.652942] [108/130] (334s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[697.706031] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[697.813200] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[697.916347] [109/130] (334s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[698.042338] Starting subtest: basic-flip-before-cursor-atomic
[698.969813] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.928s)
[699.824631] [110/130] (332s left) syncobj_wait (single-wait-all-signaled)
[699.899456] Starting subtest: single-wait-all-signaled
[699.902306] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[700.039297] [111/130] (332s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[700.137244] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[700.805726] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[700.994734] [112/130] (331s left) perf (gen12-unprivileged-single-ctx-counters)
[701.146467] Starting subtest: gen12-unprivileged-single-ctx-counters
[701.149057] Starting dynamic subtest: rcs0
[701.224165] Dynamic subtest rcs0: SUCCESS (0.078s)
[701.226751] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.081s)
[701.278314] [113/130] (330s left) kms_psr (psr-cursor-blt)
[701.364357] Starting subtest: psr-cursor-blt
[701.366753] Starting dynamic subtest: eDP-1
[703.093504] Dynamic subtest eDP-1: SUCCESS (1.730s)
[703.096341] Subtest psr-cursor-blt: SUCCESS (1.731s)
[703.993872] [114/130] (328s left) gem_ccs (ctrl-surf-copy)
[704.059026] Starting subtest: ctrl-surf-copy
[704.064503] Subtest ctrl-surf-copy: SKIP (0.000s)
[704.200609] [115/130] (328s left) kms_flip (2x-absolute-wf_vblank)
[704.297542] Starting subtest: 2x-absolute-wf_vblank
[704.308657] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[704.444500] [116/130] (327s left) kms_pm_dc (dc3co-vpb-simulation)
[705.549632] Starting subtest: dc3co-vpb-simulation
[714.129007] Subtest dc3co-vpb-simulation: SKIP (8.576s)
[714.297261] [117/130] (318s left) i915_query (test-query-geometry-subslices)
[714.357896] Starting subtest: test-query-geometry-subslices
[714.359987] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[714.495177] [118/130] (317s left) kms_psr (fbc-psr-sprite-render)
[714.589502] Starting subtest: fbc-psr-sprite-render
[714.592133] Starting dynamic subtest: eDP-1
[714.596981] Dynamic subtest eDP-1: SKIP (0.000s)
[714.602073] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[714.689275] [119/130] (317s left) gem_userptr_blits (sync-overlap)
[714.772295] Starting subtest: sync-overlap
[714.774813] Subtest sync-overlap: SUCCESS (0.000s)
[714.948545] [120/130] (317s left) prime_vgem (fence-read-hang)
[715.030441] Subtest fence-read-hang: SKIP (0.000s)
[715.145497] [121/130] (317s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[715.209789] Starting subtest: invalid-single-wait-all-unsubmitted
[715.212346] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[715.335893] [122/130] (317s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[715.433492] Starting subtest: yf-tiled-64bpp-rotate-270
[715.438364] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[715.555041] [123/130] (317s left) core_setmaster (master-drop-set-shared-fd)
[715.650040] Starting subtest: master-drop-set-shared-fd
[715.669598] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[715.713158] [124/130] (316s left) gem_ctx_create (basic-files)
[715.774221] Starting subtest: basic-files
[717.783393] Subtest basic-files: SUCCESS (2.008s)
[719.450794] [125/130] (313s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[719.511747] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[719.574453] [126/130] (313s left) kms_color (ctm-blue-to-red)
[719.667513] Starting subtest: ctm-blue-to-red
[719.670124] Starting dynamic subtest: pipe-A-eDP-1
[720.343082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.677s)
[720.364867] Starting dynamic subtest: pipe-B-eDP-1
[721.747777] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.405s)
[721.759894] Starting dynamic subtest: pipe-C-eDP-1
[723.056356] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s)
[723.071360] Starting dynamic subtest: pipe-D-eDP-1
[724.427755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.372s)
[724.430588] Subtest ctm-blue-to-red: SUCCESS (4.763s)
[725.253453] [127/130] (307s left) gem_eio (in-flight-external)
[725.489790] Starting subtest: in-flight-external
[727.460416] Subtest in-flight-external: SUCCESS (1.970s)
[727.635691] [128/130] (305s left) kms_frontbuffer_tracking (fbc-2p-rte)
[727.733577] Starting subtest: fbc-2p-rte
[727.738558] Subtest fbc-2p-rte: SKIP (0.000s)
[727.867023] [129/130] (305s left) syncobj_wait (wait-all-for-submit-complex)
[727.921532] Starting subtest: wait-all-for-submit-complex
[728.135642] Subtest wait-all-for-submit-complex: SUCCESS (0.215s)
[728.238292] [130/130] (304s left) kms_properties (colorop-properties-atomic)
[728.336286] Starting subtest: colorop-properties-atomic
[728.338320] Starting dynamic subtest: pipe-A-eDP-1
[728.672739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.335s)
[728.692797] Starting dynamic subtest: pipe-B-eDP-1
[729.793880] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.118s)
[729.806515] Starting dynamic subtest: pipe-C-eDP-1
[730.828767] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.036s)
[730.841418] Starting dynamic subtest: pipe-D-eDP-1
[731.860539] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.031s)
[731.863323] Subtest colorop-properties-atomic: SUCCESS (3.526s)
[732.676418] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_fence_thrash
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_parallel
results: parsing output: 4/ for test: gem_wait
results: parsing output: 5/ for test: gem_tiled_wb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_dp_aux_dev
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_dp_linktrain_fallback
results: parsing output: 20/ for test: core_debugfs
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_exec_flush
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: gen7_exec_parse
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_color
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: gem_ppgtt
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_wait
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_joiner
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_universal_plane
results: parsing output: 58/ for test: kms_getfb
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_create
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: gem_sync
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_mmap_wc
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_exec_suspend
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_huc_copy
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: i915_pm_rc6_residency
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: i915_hangman
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_pwrite
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_prime
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: gem_exec_parallel
results: parsing output: 102/ for test: prime_busy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: gem_ctx_sseu
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_ccs
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_pm_dc
results: parsing output: 116/ for test: i915_query
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: core_setmaster
results: parsing output: 123/ for test: gem_ctx_create
results: parsing output: 124/ for test: kms_pipe_b_c_ivb
results: parsing output: 125/ for test: kms_color
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_properties
Done.