[58.412671] Initializing watchdogs
[58.412715]   /dev/watchdog0
[58.425962] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.430305] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.432508] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.435898] [001/133] (960s left) kms_display_modes (extended-mode-basic)
[58.565634] Starting subtest: extended-mode-basic
[58.570695] Subtest extended-mode-basic: SKIP (0.000s)
[58.611633] [002/133] (960s left) kms_plane_cursor (primary)
[58.699649] Starting subtest: primary
[58.704095] Starting dynamic subtest: pipe-A-eDP-1-size-64
[61.257303] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.558s)
[61.280290] Starting dynamic subtest: pipe-A-eDP-1-size-128
[63.847730] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[63.872022] Starting dynamic subtest: pipe-A-eDP-1-size-256
[66.417055] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.553s)
[66.739514] Starting dynamic subtest: pipe-B-eDP-1-size-64
[70.000958] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.272s)
[70.023342] Starting dynamic subtest: pipe-B-eDP-1-size-128
[72.580828] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s)
[72.602374] Starting dynamic subtest: pipe-B-eDP-1-size-256
[75.157752] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[75.475590] Starting dynamic subtest: pipe-C-eDP-1-size-64
[78.326070] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.860s)
[78.351653] Starting dynamic subtest: pipe-C-eDP-1-size-128
[80.505280] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.158s)
[80.529840] Starting dynamic subtest: pipe-C-eDP-1-size-256
[82.705370] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[83.020842] Starting dynamic subtest: pipe-D-eDP-1-size-64
[85.881163] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.869s)
[85.907999] Starting dynamic subtest: pipe-D-eDP-1-size-128
[88.092488] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[88.117196] Starting dynamic subtest: pipe-D-eDP-1-size-256
[90.282224] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[90.594506] Subtest primary: SUCCESS (31.891s)
[91.447793] [003/133] (927s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[91.598212] Starting subtest: dp-mst-type-0-suspend-resume
[91.602737] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[91.728770] [004/133] (927s left) kms_chamelium_frames (hdmi-frame-dump)
[92.117369] Subtest hdmi-frame-dump: SKIP (0.000s)
[92.939909] [005/133] (926s left) kms_flip (2x-busy-flip)
[93.041562] Starting subtest: 2x-busy-flip
[93.049421] Subtest 2x-busy-flip: SKIP (0.010s)
[93.125955] [006/133] (926s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[93.229056] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[93.863966] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[94.038335] [007/133] (925s left) kms_atomic_transition (modeset-transition-nonblocking)
[94.125896] Starting subtest: modeset-transition-nonblocking
[94.127770] Starting dynamic subtest: 1x-outputs
[104.867235] Dynamic subtest 1x-outputs: SUCCESS (10.741s)
[104.869796] Subtest modeset-transition-nonblocking: SUCCESS (10.742s)
[105.724657] [008/133] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[105.833777] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[112.915040] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.084s)
[113.037698] [009/133] (906s left) gem_create (create-ext-placement-all)
[113.211732] Starting subtest: create-ext-placement-all
[113.213840] Subtest create-ext-placement-all: SUCCESS (0.000s)
[113.300256] [010/133] (905s left) kms_psr (fbc-psr-cursor-blt)
[113.396209] Starting subtest: fbc-psr-cursor-blt
[113.398457] Starting dynamic subtest: eDP-1
[113.402533] Dynamic subtest eDP-1: SKIP (0.000s)
[113.406626] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[113.477583] [011/133] (905s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[113.583180] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[113.587600] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[113.663732] [012/133] (905s left) kms_vblank (ts-continuation-dpms-rpm)
[113.746046] Starting subtest: ts-continuation-dpms-rpm
[113.748386] Starting dynamic subtest: pipe-A-eDP-1
[116.281663] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.536s)
[116.294728] Starting dynamic subtest: pipe-D-eDP-1
[118.534234] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s)
[118.536417] Subtest ts-continuation-dpms-rpm: SUCCESS (4.787s)
[119.329449] [013/133] (900s left) kms_addfb_basic (invalid-set-prop-any)
[119.389063] Starting subtest: invalid-set-prop-any
[119.391072] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[119.519294] [014/133] (899s left) drm_buddy (drm_buddy)
[119.559391] Starting subtest: drm_buddy
[119.563918] Subtest drm_buddy: SKIP (0.000s)
[119.611944] [015/133] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[119.705200] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[119.709575] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[119.788623] [016/133] (899s left) gem_flink_basic (bad-flink)
[119.843364] Starting subtest: bad-flink
[119.845601] Subtest bad-flink: SUCCESS (0.000s)
[119.936226] [017/133] (899s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[120.029237] Starting subtest: x-tiled-16bpp-rotate-0
[121.240585] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.211s)
[121.346564] [018/133] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[121.443973] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[128.026465] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.583s)
[128.152435] [019/133] (891s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[128.256599] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[128.260992] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[128.352616] [020/133] (891s left) kms_psr (pr-sprite-render)
[128.443214] Starting subtest: pr-sprite-render
[128.447490] Subtest pr-sprite-render: SKIP (0.000s)
[128.510803] [021/133] (891s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[128.890337] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[129.665186] [022/133] (890s left) kms_draw_crc (draw-method-blt)
[129.763241] Starting subtest: draw-method-blt
[129.765157] Starting dynamic subtest: xrgb8888-untiled
[129.994543] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[130.002129] Starting dynamic subtest: rgb565-untiled
[130.194520] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[130.201860] Starting dynamic subtest: xrgb2101010-untiled
[130.405837] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[130.416611] Starting dynamic subtest: xbgr16161616f-untiled
[130.616965] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[130.624488] Starting dynamic subtest: xrgb8888-xtiled
[130.727563] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[130.734425] Starting dynamic subtest: rgb565-xtiled
[130.838633] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[130.845371] Starting dynamic subtest: xrgb2101010-xtiled
[130.949769] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[130.957050] Starting dynamic subtest: xbgr16161616f-xtiled
[131.049785] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[131.056886] Starting dynamic subtest: xrgb8888-4tiled
[131.160960] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[131.167613] Starting dynamic subtest: rgb565-4tiled
[131.271879] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[131.278750] Starting dynamic subtest: xrgb2101010-4tiled
[131.383322] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[131.390437] Starting dynamic subtest: xbgr16161616f-4tiled
[131.483023] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[131.484922] Subtest draw-method-blt: SUCCESS (1.723s)
[131.595999] [023/133] (888s left) kms_sequence (get-forked)
[131.703701] Starting subtest: get-forked
[131.705606] Starting dynamic subtest: pipe-A-eDP-1
[133.599199] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.893s)
[133.607911] Starting dynamic subtest: pipe-B-eDP-1
[136.118218] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.518s)
[136.126628] Starting dynamic subtest: pipe-C-eDP-1
[138.686472] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.569s)
[138.694742] Starting dynamic subtest: pipe-D-eDP-1
[141.172379] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.482s)
[141.174613] Subtest get-forked: SUCCESS (9.468s)
[142.012800] [024/133] (877s left) i915_query (query-topology-unsupported)
[142.077681] Starting subtest: query-topology-unsupported
[142.081883] Subtest query-topology-unsupported: SKIP (0.000s)
[142.170102] [025/133] (877s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[142.282414] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[142.287025] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[142.355968] [026/133] (877s left) kms_async_flips (async-flip-hang)
[142.453207] Starting subtest: async-flip-hang
[142.824047] Starting dynamic subtest: pipe-A-eDP-1
[158.390702] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.565s)
[158.773408] Starting dynamic subtest: pipe-B-eDP-1
[174.383989] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.612s)
[174.765820] Starting dynamic subtest: pipe-C-eDP-1
[190.384760] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.623s)
[190.759852] Starting dynamic subtest: pipe-D-eDP-1
[206.379888] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.626s)
[206.382469] Subtest async-flip-hang: SUCCESS (63.931s)
[207.596533] [027/133] (812s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[207.700371] Starting subtest: basic-busy-flip-before-cursor-atomic
[207.704702] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[207.841944] [028/133] (812s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[207.941844] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[207.954194] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[208.034284] [029/133] (811s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[208.152650] Starting subtest: basic-flip-after-cursor-legacy
[209.067063] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s)
[209.904927] [030/133] (810s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[210.011827] Starting subtest: yf-tiled-8bpp-rotate-180
[210.016147] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[210.098352] [031/133] (809s left) kms_flip (2x-flip-vs-suspend-interruptible)
[210.196235] Starting subtest: 2x-flip-vs-suspend-interruptible
[210.206775] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[210.309755] [032/133] (809s left) kms_prop_blob (blob-multiple)
[210.364631] Starting subtest: blob-multiple
[210.366917] Subtest blob-multiple: SUCCESS (0.002s)
[210.455346] [033/133] (809s left) i915_drm_fdinfo (memory-info-idle)
[210.493503] Starting subtest: memory-info-idle
[210.495785] Starting dynamic subtest: smem0
[210.534484] Dynamic subtest smem0: SUCCESS (0.041s)
[210.536935] Subtest memory-info-idle: SUCCESS (0.041s)
[210.604816] [034/133] (809s left) gem_exec_fence (submit-chain)
[210.783981] Starting subtest: submit-chain
[210.797144] Subtest submit-chain: SUCCESS (0.017s)
[212.974408] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[212.977820] [035/133] (807s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[213.030079] Starting subtest: wait-all-for-submit-delayed-submit
[213.134876] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[213.227201] [036/133] (807s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[213.327804] Starting subtest: fbcpsr-indfb-scaledprimary
[219.163852] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.839s)
[219.308917] [037/133] (801s left) kms_frontbuffer_tracking (fbc-suspend)
[219.407451] Starting subtest: fbc-suspend
[257.417616] Subtest fbc-suspend: SUCCESS (8.430s)
[258.603137] [038/133] (761s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[258.712594] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[266.078969] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.360s)
[266.218346] [039/133] (754s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[266.321012] Starting subtest: pixel-format-linear-modifier-source-clamping
[266.346636] Starting dynamic subtest: pipe-A-plane-0
[269.938008] Dynamic subtest pipe-A-plane-0: SUCCESS (3.589s)
[269.945676] Starting dynamic subtest: pipe-A-plane-3
[271.672775] Dynamic subtest pipe-A-plane-3: SUCCESS (1.733s)
[272.817161] Starting dynamic subtest: pipe-B-plane-0
[276.440791] Dynamic subtest pipe-B-plane-0: SUCCESS (3.633s)
[276.448784] Starting dynamic subtest: pipe-B-plane-3
[278.108606] Dynamic subtest pipe-B-plane-3: SUCCESS (1.666s)
[278.434687] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.104s)
[279.292792] [040/133] (741s left) gem_pread (display)
[279.362998] Subtest display: SKIP (0.000s)
[279.418817] [041/133] (741s left) kms_getfb (getfb2-handle-not-fb)
[279.499591] Starting subtest: getfb2-handle-not-fb
[279.501872] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[279.602979] [042/133] (740s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[279.692006] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[279.696423] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[280.841081] [043/133] (739s left) kms_psr (psr-sprite-plane-move)
[280.935247] Starting subtest: psr-sprite-plane-move
[280.937563] Starting dynamic subtest: eDP-1
[282.671867] Dynamic subtest eDP-1: SUCCESS (1.735s)
[282.674117] Subtest psr-sprite-plane-move: SUCCESS (1.736s)
[283.503452] [044/133] (737s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[283.611246] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[283.615413] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[283.711987] [045/133] (736s left) prime_self_import (export-vs-gem_close-race)
[283.753363] Starting subtest: export-vs-gem_close-race
[288.853839] Subtest export-vs-gem_close-race: SUCCESS (5.102s)
[288.932810] [046/133] (731s left) gem_ctx_param (invalid-size-set)
[288.992019] Starting subtest: invalid-size-set
[288.994363] Subtest invalid-size-set: SUCCESS (0.001s)
[289.115564] [047/133] (731s left) gem_workarounds (suspend-resume-fd)
[289.186828] Starting subtest: suspend-resume-fd
[304.934670] Subtest suspend-resume-fd: SUCCESS (1.538s)
[306.094404] [048/133] (715s left) syncobj_wait (single-wait-for-submit-submitted)
[306.157204] Starting subtest: single-wait-for-submit-submitted
[306.262030] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[306.337032] [049/133] (715s left) gem_lmem_swapping (massive)
[306.387449] Subtest massive: SKIP (0.000s)
[306.433824] [050/133] (715s left) kms_big_fb (linear-8bpp-rotate-270)
[306.545673] Starting subtest: linear-8bpp-rotate-270
[306.565324] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[306.676378] [051/133] (715s left) gem_exec_create (forked)
[306.745733] Starting subtest: forked
[306.748172] Starting dynamic subtest: smem
[328.673208] Dynamic subtest smem: SUCCESS (21.903s)
[328.676014] Subtest forked: SUCCESS (21.905s)
[328.858844] [052/133] (693s left) gem_exec_schedule (independent)
[328.926849] Starting subtest: independent
[328.929083] Starting dynamic subtest: rcs0
[330.720380] Dynamic subtest rcs0: SUCCESS (1.799s)
[330.732003] Starting dynamic subtest: vcs0
[332.716587] Dynamic subtest vcs0: SUCCESS (1.993s)
[332.729525] Starting dynamic subtest: vcs1
[334.695588] Dynamic subtest vcs1: SUCCESS (1.976s)
[334.707003] Starting dynamic subtest: vecs0
[336.681591] Dynamic subtest vecs0: SUCCESS (1.983s)
[336.692672] Starting dynamic subtest: ccs0
[338.720837] Dynamic subtest ccs0: SUCCESS (2.036s)
[338.723530] Subtest independent: SUCCESS (9.798s)
[339.025234] [053/133] (682s left) i915_getparams_basic (basic-subslice-total)
[339.077440] Starting subtest: basic-subslice-total
[339.081391] Subtest basic-subslice-total: SUCCESS (0.000s)
[339.162911] [054/133] (682s left) syncobj_timeline (host-signal-ordered)
[339.224002] Starting subtest: host-signal-ordered
[339.226439] Subtest host-signal-ordered: SUCCESS (0.000s)
[339.324647] [055/133] (682s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[339.428722] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[339.432796] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[339.528146] [056/133] (682s left) gem_softpin (allocator-basic)
[339.588958] Starting subtest: allocator-basic
[339.651035] Subtest allocator-basic: SUCCESS (0.062s)
[339.780649] [057/133] (682s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[339.890355] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[347.318250] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.430s)
[347.465107] [058/133] (674s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[347.567355] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[347.569480] Starting dynamic subtest: pipe-A-eDP-1
[349.687614] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s)
[349.696862] Starting dynamic subtest: pipe-B-eDP-1
[352.144594] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.457s)
[352.152891] Starting dynamic subtest: pipe-C-eDP-1
[354.277050] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.131s)
[354.286159] Starting dynamic subtest: pipe-D-eDP-1
[356.387471] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.109s)
[356.389725] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.822s)
[357.603701] [059/133] (664s left) gem_exec_whisper (basic-contexts-all)
[357.677887] Starting subtest: basic-contexts-all
[368.425574] Subtest basic-contexts-all: SUCCESS (10.742s)
[368.609535] [060/133] (653s left) gem_lmem_swapping (smem-oom)
[368.652535] Subtest smem-oom: SKIP (0.000s)
[368.694535] [061/133] (653s left) syncobj_wait (invalid-reset-zero-handles)
[368.744094] Starting subtest: invalid-reset-zero-handles
[368.746365] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[368.844420] [062/133] (653s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[368.904322] Starting subtest: multi-wait-for-submit-unsubmitted
[369.010116] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[369.089266] [063/133] (653s left) kms_color (ctm-0-75)
[369.185145] Starting subtest: ctm-0-75
[369.187462] Starting dynamic subtest: pipe-A-eDP-1
[374.117380] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.934s)
[374.132798] Starting dynamic subtest: pipe-B-eDP-1
[379.824610] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.703s)
[379.834377] Starting dynamic subtest: pipe-C-eDP-1
[385.209951] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.386s)
[385.219510] Starting dynamic subtest: pipe-D-eDP-1
[390.512861] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.300s)
[390.515192] Subtest ctm-0-75: SUCCESS (21.327s)
[391.347987] [064/133] (631s left) api_intel_bb (misplaced-blitter)
[391.402327] Starting subtest: misplaced-blitter
[391.407876] Subtest misplaced-blitter: SUCCESS (0.006s)
[391.537344] [065/133] (630s left) gem_userptr_blits (vma-merge)
[391.617952] Starting subtest: vma-merge
[391.657151] Subtest vma-merge: SUCCESS (0.039s)
[391.782063] [066/133] (630s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[391.884089] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[391.888061] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[391.990617] [067/133] (630s left) gem_eio (in-flight-immediate)
[392.236168] Starting subtest: in-flight-immediate
[400.600386] Subtest in-flight-immediate: SUCCESS (8.362s)
[400.752804] [068/133] (621s left) kms_addfb_basic (basic)
[400.816925] Starting subtest: basic
[400.819412] Subtest basic: SUCCESS (0.000s)
[400.977397] [069/133] (621s left) gem_pxp (verify-pxp-stale-ctx-execution)
[401.101679] Starting subtest: verify-pxp-stale-ctx-execution
[402.162934] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s)
[402.284369] [070/133] (620s left) kms_flip (2x-plain-flip)
[402.390492] Starting subtest: 2x-plain-flip
[402.401350] Subtest 2x-plain-flip: SKIP (0.010s)
[402.478452] [071/133] (620s left) kms_cursor_crc (cursor-offscreen-256x85)
[402.743777] Starting subtest: cursor-offscreen-256x85
[402.799944] Subtest cursor-offscreen-256x85: SKIP (0.052s)
[402.978263] [072/133] (619s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[403.034862] Starting subtest: multi-wait-for-submit-available-signaled
[403.037028] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[403.118177] [073/133] (619s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[403.181599] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[403.248234] [074/133] (619s left) kms_cursor_crc (cursor-random-max-size)
[403.556926] Starting subtest: cursor-random-max-size
[403.562828] Subtest cursor-random-max-size: SKIP (0.000s)
[403.692031] [075/133] (619s left) kms_setmode (clone-exclusive-crtc)
[403.757494] Starting subtest: clone-exclusive-crtc
[403.763342] Subtest clone-exclusive-crtc: SKIP (0.000s)
[403.845118] [076/133] (619s left) kms_lease (cursor-implicit-plane)
[403.934093] Starting subtest: cursor-implicit-plane
[403.935917] Starting dynamic subtest: pipe-A-eDP-1
[404.390912] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[404.400560] Starting dynamic subtest: pipe-B-eDP-1
[405.564986] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.172s)
[405.574876] Starting dynamic subtest: pipe-C-eDP-1
[406.696140] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[406.706154] Starting dynamic subtest: pipe-D-eDP-1
[407.812740] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s)
[407.814966] Subtest cursor-implicit-plane: SUCCESS (3.881s)
[408.678069] [077/133] (614s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[408.771663] Starting subtest: psr2-cursor-plane-move-continuous-sf
[408.773978] Starting dynamic subtest: pipe-A-eDP-1
[419.119820] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.350s)
[419.133378] Starting dynamic subtest: pipe-B-eDP-1
[430.147776] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.023s)
[430.150095] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.376s)
[430.954168] [078/133] (592s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[431.051360] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[431.053505] Starting dynamic subtest: pipe-A-eDP-1
[431.075203] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[431.086588] Starting dynamic subtest: pipe-B-eDP-1
[431.107764] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[431.116515] Starting dynamic subtest: pipe-C-eDP-1
[431.136480] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[431.145169] Starting dynamic subtest: pipe-D-eDP-1
[431.166654] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[431.170657] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[433.212362] [079/133] (589s left) syncobj_basic (bad-flags-handle-to-fd)
[433.276662] Starting subtest: bad-flags-handle-to-fd
[433.278590] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[433.381212] [080/133] (589s left) fbdev (pan)
[433.415992] Starting subtest: pan
[433.442217] Subtest pan: SUCCESS (0.027s)
[433.524991] [081/133] (589s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[433.631484] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[437.609218] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.980s)
[438.823792] [082/133] (584s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[438.931696] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[438.934078] Starting dynamic subtest: pipe-A-eDP-1
[438.943446] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[438.953055] Starting dynamic subtest: pipe-B-eDP-1
[438.962351] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[438.971390] Starting dynamic subtest: pipe-C-eDP-1
[438.980632] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[438.989738] Starting dynamic subtest: pipe-D-eDP-1
[438.998583] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[439.002813] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.014s)
[441.191598] [083/133] (582s left) gem_exec_balancer (bonded-chain)
[441.257922] Starting subtest: bonded-chain
[448.250899] Subtest bonded-chain: SUCCESS (6.989s)
[448.568397] [084/133] (574s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[448.637724] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[448.714063] [085/133] (574s left) kms_flip (2x-nonexisting-fb)
[448.822499] Starting subtest: 2x-nonexisting-fb
[448.845840] Subtest 2x-nonexisting-fb: SKIP (0.023s)
[448.948319] [086/133] (574s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[449.045648] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[449.049900] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[449.139448] [087/133] (574s left) syncobj_timeline (multi-wait-all-available-submitted)
[449.196346] Starting subtest: multi-wait-all-available-submitted
[449.198647] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[449.285051] [088/133] (574s left) kms_psr (fbc-psr2-primary-page-flip)
[449.375641] Starting subtest: fbc-psr2-primary-page-flip
[449.377865] Starting dynamic subtest: eDP-1
[449.382141] Dynamic subtest eDP-1: SKIP (0.000s)
[449.386453] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[449.457480] [089/133] (574s left) kms_invalid_mode (int-max-clock)
[449.535568] Starting subtest: int-max-clock
[449.537566] Starting dynamic subtest: pipe-A-eDP-1
[449.836102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[449.845708] Starting dynamic subtest: pipe-B-eDP-1
[449.847606] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[449.856683] Starting dynamic subtest: pipe-C-eDP-1
[449.858873] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[449.867661] Starting dynamic subtest: pipe-D-eDP-1
[449.870025] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[449.872364] Subtest int-max-clock: SUCCESS (0.304s)
[450.628795] [090/133] (572s left) kms_addfb_basic (bad-pitch-1024)
[450.686398] Starting subtest: bad-pitch-1024
[450.688646] Subtest bad-pitch-1024: SUCCESS (0.000s)
[450.837707] [091/133] (572s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[450.904774] Starting subtest: invalid-multi-wait-all-unsubmitted
[450.907032] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[451.013164] [092/133] (572s left) gem_exec_reloc (basic-write-wc-noreloc)
[451.068485] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[451.128794] [093/133] (572s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[451.226196] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[451.230322] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[451.324101] [094/133] (572s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[451.379353] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[451.484171] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[451.559608] [095/133] (572s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[451.650038] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[451.654263] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[451.756655] [096/133] (572s left) kms_vrr (flip-suspend)
[451.851777] Starting subtest: flip-suspend
[451.858198] Subtest flip-suspend: SKIP (0.000s)
[451.927521] [097/133] (571s left) prime_vgem (busy)
[452.012103] Starting subtest: busy
[452.014391] Starting dynamic subtest: rcs0
[452.057188] Dynamic subtest rcs0: SUCCESS (0.046s)
[452.066597] Starting dynamic subtest: bcs0
[452.117409] Dynamic subtest bcs0: SUCCESS (0.059s)
[452.127122] Starting dynamic subtest: vcs0
[452.165478] Dynamic subtest vcs0: SUCCESS (0.047s)
[452.174741] Starting dynamic subtest: vcs1
[452.210195] Dynamic subtest vcs1: SUCCESS (0.044s)
[452.219224] Starting dynamic subtest: vecs0
[452.257353] Dynamic subtest vecs0: SUCCESS (0.046s)
[452.266489] Starting dynamic subtest: ccs0
[452.303076] Dynamic subtest ccs0: SUCCESS (0.045s)
[452.305448] Subtest busy: SUCCESS (0.293s)
[452.441750] [098/133] (571s left) perf_pmu (most-busy-check-all)
[452.485223] Starting subtest: most-busy-check-all
[452.487034] Starting dynamic subtest: rcs0
[453.728802] Dynamic subtest rcs0: SUCCESS (1.242s)
[453.741360] Starting dynamic subtest: bcs0
[455.712894] Dynamic subtest bcs0: SUCCESS (1.981s)
[455.725663] Starting dynamic subtest: vcs0
[457.696243] Dynamic subtest vcs0: SUCCESS (1.979s)
[457.708589] Starting dynamic subtest: vcs1
[459.680766] Dynamic subtest vcs1: SUCCESS (1.980s)
[459.693166] Starting dynamic subtest: vecs0
[461.664912] Dynamic subtest vecs0: SUCCESS (1.980s)
[461.677271] Starting dynamic subtest: ccs0
[463.713600] Dynamic subtest ccs0: SUCCESS (2.045s)
[463.716223] Subtest most-busy-check-all: SUCCESS (11.226s)
[463.815384] [099/133] (560s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[463.880066] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[463.885043] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[464.083939] [100/133] (559s left) kms_cdclk (plane-scaling)
[464.183364] Starting subtest: plane-scaling
[464.185687] Starting dynamic subtest: pipe-A-eDP-1
[464.471140] Dynamic subtest pipe-A-eDP-1: SKIP (0.285s)
[464.481268] Starting dynamic subtest: pipe-B-eDP-1
[464.486126] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[464.495366] Starting dynamic subtest: pipe-C-eDP-1
[464.499948] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[464.508821] Starting dynamic subtest: pipe-D-eDP-1
[464.512955] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[464.517110] Subtest plane-scaling: SKIP (0.293s)
[465.274578] [101/133] (558s left) kms_psr (psr-cursor-plane-move)
[465.379476] Starting subtest: psr-cursor-plane-move
[465.381887] Starting dynamic subtest: eDP-1
[467.057099] Dynamic subtest eDP-1: SUCCESS (1.677s)
[467.059368] Subtest psr-cursor-plane-move: SUCCESS (1.677s)
[467.923536] [102/133] (556s left) gen9_exec_parse (batch-zero-length)
[467.979548] Subtest batch-zero-length: SKIP (0.000s)
[468.048712] [103/133] (556s left) gem_exec_gttfill (engines)
[468.108447] Starting subtest: engines
[468.110650] Starting dynamic subtest: rcs0
[491.198497] Dynamic subtest rcs0: SUCCESS (23.082s)
[491.211037] Starting dynamic subtest: bcs0
[514.564573] Dynamic subtest bcs0: SUCCESS (23.367s)
[514.577612] Starting dynamic subtest: vcs0
[537.862653] Dynamic subtest vcs0: SUCCESS (23.298s)
[537.872770] Starting dynamic subtest: vcs1
[561.216521] Dynamic subtest vcs1: SUCCESS (23.352s)
[561.226641] Starting dynamic subtest: vecs0
[584.554762] Dynamic subtest vecs0: SUCCESS (23.335s)
[584.567137] Starting dynamic subtest: ccs0
[607.926629] Dynamic subtest ccs0: SUCCESS (23.366s)
[607.929258] Subtest engines: SUCCESS (139.814s)
[608.121564] [104/133] (415s left) gem_userptr_blits (sync-unmap-after-close)
[608.224437] Starting subtest: sync-unmap-after-close
[608.245960] Subtest sync-unmap-after-close: SUCCESS (0.024s)
[608.382106] [105/133] (415s left) gem_mmap_offset (bad-object)
[608.438932] Starting subtest: bad-object
[608.441088] Subtest bad-object: SUCCESS (0.001s)
[608.528073] [106/133] (415s left) drm_read (short-buffer-nonblock)
[608.720949] Starting subtest: short-buffer-nonblock
[608.723340] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[608.844273] [107/133] (415s left) gem_exec_alignment (pi-isolated)
[608.913442] Starting subtest: pi-isolated
[660.638550] Subtest pi-isolated: SUCCESS (51.711s)
[661.751326] [108/133] (362s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[661.902543] Starting subtest: blocking-absolute-wf_vblank-interruptible
[661.904895] Starting dynamic subtest: A-eDP1
[670.672521] Dynamic subtest A-eDP1: SUCCESS (8.767s)
[670.684021] Starting dynamic subtest: B-eDP1
[679.395697] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[679.410014] Starting dynamic subtest: C-eDP1
[688.120011] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[688.133711] Starting dynamic subtest: D-eDP1
[696.858729] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[696.864030] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.954s)
[698.073046] [109/133] (326s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[698.188838] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[698.192940] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[698.314685] [110/133] (326s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[698.416111] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[699.240692] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.825s)
[699.403560] [111/133] (325s left) gem_userptr_blits (readonly-pwrite-unsync)
[699.472372] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[699.598556] [112/133] (324s left) gem_ctx_persistence (userptr)
[699.651867] Starting subtest: userptr
[699.811043] Subtest userptr: SUCCESS (0.159s)
[699.895002] [113/133] (324s left) kms_flip (busy-flip)
[699.982593] Starting subtest: busy-flip
[699.984504] Starting dynamic subtest: A-eDP1
[701.677950] Dynamic subtest A-eDP1: SUCCESS (1.696s)
[701.690017] Starting dynamic subtest: B-eDP1
[703.320592] Dynamic subtest B-eDP1: SUCCESS (1.641s)
[703.330921] Starting dynamic subtest: C-eDP1
[704.954853] Dynamic subtest C-eDP1: SUCCESS (1.632s)
[704.964375] Starting dynamic subtest: D-eDP1
[706.592866] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[706.595337] Subtest busy-flip: SUCCESS (6.614s)
[707.765582] [114/133] (316s left) kms_psr (fbc-pr-cursor-plane-onoff)
[707.857553] Starting subtest: fbc-pr-cursor-plane-onoff
[707.861594] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[707.930702] [115/133] (316s left) kms_cursor_edge_walk (64x64-top-edge)
[708.029209] Starting subtest: 64x64-top-edge
[708.031487] Starting dynamic subtest: pipe-A-eDP-1
[711.502373] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s)
[711.512889] Starting dynamic subtest: pipe-D-eDP-1
[714.636310] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[714.638618] Subtest 64x64-top-edge: SUCCESS (6.606s)
[715.437190] [116/133] (309s left) gem_exec_balancer (parallel-out-fence)
[715.710461] Starting subtest: parallel-out-fence
[716.895614] Subtest parallel-out-fence: SUCCESS (1.189s)
[717.009625] [117/133] (307s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[717.112079] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[717.116503] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[717.177808] [118/133] (307s left) kms_plane_scaling (invalid-num-scalers)
[717.272276] Starting subtest: invalid-num-scalers
[717.274609] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[717.290844] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[717.300730] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[717.324210] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[717.335353] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[717.354979] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[717.364784] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[717.386634] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[717.388946] Subtest invalid-num-scalers: SUCCESS (0.115s)
[717.505258] [119/133] (307s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[717.629026] Starting subtest: cursorB-vs-flipA-toggle
[717.633733] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[717.776410] [120/133] (307s left) gem_mmap_wc (bad-object)
[717.846203] Subtest bad-object: SKIP (0.000s)
[717.907745] [121/133] (306s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[717.999936] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[718.001890] Starting dynamic subtest: pipe-A
[718.063046] Dynamic subtest pipe-A: SUCCESS (0.065s)
[718.076811] Starting dynamic subtest: pipe-B
[719.178905] Dynamic subtest pipe-B: SUCCESS (1.114s)
[719.190476] Starting dynamic subtest: pipe-C
[720.290360] Dynamic subtest pipe-C: SUCCESS (1.110s)
[720.299725] Starting dynamic subtest: pipe-D
[721.438791] Dynamic subtest pipe-D: SUCCESS (1.147s)
[721.441060] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.440s)
[722.609015] [122/133] (302s left) gem_ctx_param (invalid-set-no-zeromap)
[722.673229] Starting subtest: invalid-set-no-zeromap
[722.675537] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[722.743751] [123/133] (302s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[722.834237] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[722.838964] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[722.938512] [124/133] (302s left) i915_selftest (mock)
[726.258076] Starting subtest: mock
[726.261343] Starting dynamic subtest: sanitycheck
[726.951576] Dynamic subtest sanitycheck: SUCCESS (0.692s)
[726.967037] Starting dynamic subtest: shmem
[727.623402] Dynamic subtest shmem: SUCCESS (0.670s)
[727.633580] Starting dynamic subtest: fence
[735.835059] Dynamic subtest fence: SUCCESS (8.207s)
[735.845060] Starting dynamic subtest: scatterlist
[738.086015] Dynamic subtest scatterlist: SUCCESS (2.248s)
[738.096096] Starting dynamic subtest: syncmap
[741.370701] Dynamic subtest syncmap: SUCCESS (3.283s)
[741.381110] Starting dynamic subtest: uncore
[742.023351] Dynamic subtest uncore: SUCCESS (0.651s)
[742.033394] Starting dynamic subtest: ring
[742.654354] Dynamic subtest ring: SUCCESS (0.629s)
[742.664348] Starting dynamic subtest: engine
[743.307330] Dynamic subtest engine: SUCCESS (0.651s)
[743.317626] Starting dynamic subtest: timelines
[747.007646] Dynamic subtest timelines: SUCCESS (3.697s)
[747.022797] Starting dynamic subtest: requests
[750.932834] Dynamic subtest requests: SUCCESS (3.923s)
[750.942389] Starting dynamic subtest: objects
[751.652464] Dynamic subtest objects: SUCCESS (0.718s)
[751.662571] Starting dynamic subtest: phys
[752.397429] Dynamic subtest phys: SUCCESS (0.743s)
[752.407022] Starting dynamic subtest: dmabuf
[753.127424] Dynamic subtest dmabuf: SUCCESS (0.728s)
[753.137513] Starting dynamic subtest: vma
[758.448089] Dynamic subtest vma: SUCCESS (5.316s)
[758.458068] Starting dynamic subtest: evict
[759.770714] Dynamic subtest evict: SUCCESS (1.320s)
[759.780528] Starting dynamic subtest: gtt
[762.968764] Dynamic subtest gtt: SUCCESS (3.197s)
[762.978118] Starting dynamic subtest: hugepages
[763.850996] Dynamic subtest hugepages: SUCCESS (0.879s)
[763.861024] Starting dynamic subtest: memory_region
[766.258706] Dynamic subtest memory_region: SUCCESS (2.405s)
[766.261181] Subtest mock: SUCCESS (39.990s)
[766.290390] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[766.291119] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[766.294278] [125/133] (258s left) i915_pm_rpm (debugfs-read)
[769.906220] Starting subtest: debugfs-read
[771.052092] Subtest debugfs-read: SUCCESS (1.149s)
[771.461761] [FACT i915_pm_rpm (debugfs-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[771.463131] [FACT i915_pm_rpm (debugfs-read)] new: kernel.kmod_is_loaded.i915: true
[771.467463] [126/133] (253s left) gem_mmap_gtt (basic-write-gtt)
[771.546729] Subtest basic-write-gtt: SKIP (0.000s)
[771.608641] [127/133] (253s left) kms_pm_backlight (fade-with-dpms)
[771.701374] Starting subtest: fade-with-dpms
[774.082345] Starting dynamic subtest: eDP-1
[776.792196] Dynamic subtest eDP-1: SUCCESS (2.711s)
[776.794543] Subtest fade-with-dpms: SUCCESS (5.092s)
[777.667318] [128/133] (247s left) gem_wait (invalid-flags)
[777.725928] Starting subtest: invalid-flags
[777.728232] Subtest invalid-flags: SUCCESS (0.000s)
[777.917206] [129/133] (247s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[778.026858] Starting subtest: stress-xrgb8888-4tiled
[783.924926] Subtest stress-xrgb8888-4tiled: SUCCESS (5.899s)
[783.974759] [130/133] (241s left) syncobj_timeline (wait-for-submit-snapshot)
[784.028767] Starting subtest: wait-for-submit-snapshot
[784.109240] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[784.193862] [131/133] (241s left) gem_exec_schedule (u-submit-early-slice)
[784.269189] Starting subtest: u-submit-early-slice
[784.271247] Starting dynamic subtest: rcs0
[784.300503] Dynamic subtest rcs0: SUCCESS (0.035s)
[784.312272] Starting dynamic subtest: bcs0
[784.335101] Dynamic subtest bcs0: SUCCESS (0.034s)
[784.344064] Starting dynamic subtest: vcs0
[784.375056] Dynamic subtest vcs0: SUCCESS (0.039s)
[784.388749] Starting dynamic subtest: vcs1
[784.417964] Dynamic subtest vcs1: SUCCESS (0.041s)
[784.428840] Starting dynamic subtest: vecs0
[784.451442] Dynamic subtest vecs0: SUCCESS (0.033s)
[784.460137] Starting dynamic subtest: ccs0
[784.483088] Dynamic subtest ccs0: SUCCESS (0.031s)
[784.485139] Subtest u-submit-early-slice: SUCCESS (0.219s)
[785.790858] [132/133] (239s left) gem_exec_flush (basic-uc-pro-default)
[785.848404] Starting subtest: basic-uc-pro-default
[791.309805] Subtest basic-uc-pro-default: SUCCESS (5.460s)
[791.512236] [133/133] (233s left) api_intel_bb (bb-with-allocator)
[791.569473] Starting subtest: bb-with-allocator
[791.578827] Subtest bb-with-allocator: SUCCESS (0.012s)
[791.695430] Closing watchdogs
results: parsing output: 0/ for test: kms_display_modes
results: parsing output: 1/ for test: kms_plane_cursor
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: kms_chamelium_frames
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_atomic_transition
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_create
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: drm_buddy
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_flink_basic
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: kms_draw_crc
results: parsing output: 22/ for test: kms_sequence
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_prop_blob
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: gem_pread
results: parsing output: 40/ for test: kms_getfb
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: prime_self_import
results: parsing output: 45/ for test: gem_ctx_param
results: parsing output: 46/ for test: gem_workarounds
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: gem_lmem_swapping
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_exec_create
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: i915_getparams_basic
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_softpin
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: gem_pxp
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_pipe_b_c_ivb
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_setmode
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: syncobj_basic
results: parsing output: 79/ for test: fbdev
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_invalid_mode
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_vrr
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: kms_cdclk
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gen9_exec_parse
results: parsing output: 102/ for test: gem_exec_gttfill
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: drm_read
results: parsing output: 106/ for test: gem_exec_alignment
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_cursor_edge_walk
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gem_mmap_wc
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: i915_selftest
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_pm_backlight
results: parsing output: 127/ for test: gem_wait
results: parsing output: 128/ for test: kms_pipe_stress
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: gem_exec_flush
results: parsing output: 132/ for test: api_intel_bb
Done.