[61.288362] Initializing watchdogs
[61.288410]   /dev/watchdog0
[61.303456] [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]
[61.307886] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.310046] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.311883] [001/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[61.418084] Starting subtest: psr-rgb565-draw-render
[68.761619] Subtest psr-rgb565-draw-render: SUCCESS (7.341s)
[68.865874] [002/133] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[68.949264] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[68.950745] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[69.047881] [003/133] (952s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[69.137728] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[69.139660] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[69.222398] [004/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[69.318842] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[76.605466] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.286s)
[76.726504] [005/133] (945s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[78.272710] Starting subtest: dpms-mode-unset-lpsp
[82.325844] Subtest dpms-mode-unset-lpsp: SUCCESS (4.055s)
[82.723114] [006/133] (939s left) gem_ctx_param (invalid-param-get)
[82.777521] Starting subtest: invalid-param-get
[82.778583] Subtest invalid-param-get: SUCCESS (0.001s)
[82.879432] [007/133] (939s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[82.974545] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[82.976348] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[83.072103] [008/133] (938s left) gen9_exec_parse (batch-without-end)
[83.135977] Subtest batch-without-end: SKIP (0.000s)
[83.190706] [009/133] (938s left) api_intel_bb (add-remove-objects)
[83.248098] Starting subtest: add-remove-objects
[83.255056] Subtest add-remove-objects: SUCCESS (0.007s)
[83.364503] [010/133] (938s left) perf_pmu (init-busy)
[83.403125] Starting subtest: init-busy
[83.404211] Starting dynamic subtest: rcs0
[83.405168] Dynamic subtest rcs0: SUCCESS (0.001s)
[83.412541] Starting dynamic subtest: bcs0
[83.413446] Dynamic subtest bcs0: SUCCESS (0.000s)
[83.419279] Starting dynamic subtest: vcs0
[83.420194] Dynamic subtest vcs0: SUCCESS (0.001s)
[83.425940] Starting dynamic subtest: vcs1
[83.426929] Dynamic subtest vcs1: SUCCESS (0.001s)
[83.432680] Starting dynamic subtest: vecs0
[83.433515] Dynamic subtest vecs0: SUCCESS (0.001s)
[83.439167] Starting dynamic subtest: ccs0
[83.439950] Dynamic subtest ccs0: SUCCESS (0.000s)
[83.440867] Subtest init-busy: SUCCESS (0.005s)
[83.525539] [011/133] (938s left) syncobj_wait (invalid-wait-illegal-handle)
[83.578040] Starting subtest: invalid-wait-illegal-handle
[83.579246] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[83.678824] [012/133] (938s left) kms_pm_rpm (i2c)
[85.195936] Starting subtest: i2c
[90.909697] Subtest i2c: SUCCESS (5.714s)
[90.990083] [013/133] (931s left) kms_dp_linktrain_fallback (dsc-fallback)
[91.087883] Starting subtest: dsc-fallback
[91.090352] Subtest dsc-fallback: SKIP (0.001s)
[91.156716] [014/133] (931s left) gem_exec_flush (basic-batch-kernel-default-wb)
[91.219965] Starting subtest: basic-batch-kernel-default-wb
[98.674795] Subtest basic-batch-kernel-default-wb: SUCCESS (7.455s)
[98.868716] [015/133] (923s left) sw_sync (sync_expired_merge)
[98.899897] Starting subtest: sync_expired_merge
[99.982570] Subtest sync_expired_merge: SUCCESS (1.074s)
[100.029467] [016/133] (922s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[100.074437] Starting subtest: wait-all-for-submit-delayed-submit
[100.180068] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[100.273454] [017/133] (922s left) kms_plane_multiple (tiling-x)
[100.369781] Starting subtest: tiling-x
[100.370738] Starting dynamic subtest: pipe-A-eDP-1
[104.115458] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.744s)
[104.122273] Starting dynamic subtest: pipe-B-eDP-1
[108.545114] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.429s)
[108.551563] Starting dynamic subtest: pipe-C-eDP-1
[112.864889] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.318s)
[112.874278] Starting dynamic subtest: pipe-D-eDP-1
[117.199285] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.333s)
[117.200091] Subtest tiling-x: SUCCESS (16.828s)
[118.005460] [018/133] (904s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[118.104620] Starting subtest: 4-tiled-16bpp-rotate-270
[118.123931] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[118.234433] [019/133] (904s left) syncobj_timeline (device-signal-unordered)
[118.282972] Starting subtest: device-signal-unordered
[118.284043] Subtest device-signal-unordered: SUCCESS (0.000s)
[118.384191] [020/133] (904s left) syncobj_basic (create-signaled)
[118.442334] Starting subtest: create-signaled
[118.443461] Subtest create-signaled: SUCCESS (0.000s)
[118.558644] [021/133] (903s left) kms_cdclk (plane-scaling)
[118.642402] Starting subtest: plane-scaling
[118.643330] Starting dynamic subtest: pipe-A-eDP-1
[118.935714] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[118.941991] Starting dynamic subtest: pipe-B-eDP-1
[118.943777] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[118.949633] Starting dynamic subtest: pipe-C-eDP-1
[118.951525] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[118.957339] Starting dynamic subtest: pipe-D-eDP-1
[118.959032] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[118.960731] Subtest plane-scaling: SKIP (0.299s)
[119.762447] [022/133] (902s left) perf (whitelisted-registers-userspace-config)
[119.889096] Starting subtest: whitelisted-registers-userspace-config
[119.889937] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[119.928819] [023/133] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[120.012900] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[120.014548] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[120.111426] [024/133] (902s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[120.196400] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[120.197997] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[120.278989] [025/133] (902s left) kms_psr (fbc-pr-sprite-render)
[120.365465] Starting subtest: fbc-pr-sprite-render
[120.367369] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[120.430085] [026/133] (902s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[120.480444] Starting subtest: etime-multi-wait-available-unsubmitted
[120.586828] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[120.668615] [027/133] (901s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[120.760614] Starting subtest: x-tiled-16bpp-rotate-0
[122.150016] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.390s)
[122.270552] [028/133] (900s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[122.332347] Starting subtest: multi-wait-all-for-submit-available-submitted
[122.333345] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[122.427718] [029/133] (900s left) kms_psr2_su (frontbuffer-xrgb8888)
[122.475444] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[122.523060] [030/133] (900s left) gem_exec_schedule (smoketest)
[122.716812] Starting subtest: smoketest
[122.719330] Starting dynamic subtest: rcs0
[128.278395] Dynamic subtest rcs0: SUCCESS (5.505s)
[128.286095] Starting dynamic subtest: bcs0
[133.794081] Dynamic subtest bcs0: SUCCESS (5.514s)
[133.803926] Starting dynamic subtest: vcs0
[139.293318] Dynamic subtest vcs0: SUCCESS (5.491s)
[139.301424] Starting dynamic subtest: vcs1
[144.786855] Dynamic subtest vcs1: SUCCESS (5.497s)
[144.799593] Starting dynamic subtest: vecs0
[150.290779] Dynamic subtest vecs0: SUCCESS (5.505s)
[150.303541] Starting dynamic subtest: ccs0
[155.733879] Dynamic subtest ccs0: SUCCESS (5.481s)
[155.734863] Subtest smoketest: SUCCESS (32.996s)
[155.896472] [031/133] (866s left) kms_feature_discovery (display-4x)
[155.977947] Starting subtest: display-4x
[155.979707] Subtest display-4x: SKIP (0.000s)
[156.063593] [032/133] (866s left) gem_userptr_blits (sd-probe)
[156.123793] Starting subtest: sd-probe
[156.124628] Subtest sd-probe: SUCCESS (0.000s)
[156.233369] [033/133] (866s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[156.312408] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[156.314076] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[156.419334] [034/133] (866s left) kms_flip (basic-flip-vs-dpms)
[156.498682] Starting subtest: basic-flip-vs-dpms
[156.500895] Starting dynamic subtest: A-eDP1
[159.080687] Dynamic subtest A-eDP1: SUCCESS (2.579s)
[159.087299] Starting dynamic subtest: B-eDP1
[161.330608] Dynamic subtest B-eDP1: SUCCESS (2.248s)
[161.338790] Starting dynamic subtest: C-eDP1
[163.401964] Dynamic subtest C-eDP1: SUCCESS (2.071s)
[163.408524] Starting dynamic subtest: D-eDP1
[165.578318] Dynamic subtest D-eDP1: SUCCESS (2.175s)
[165.582527] Subtest basic-flip-vs-dpms: SUCCESS (9.083s)
[166.450771] [035/133] (856s left) kms_content_protection (dp-mst-lic-type-0)
[166.595744] Starting subtest: dp-mst-lic-type-0
[166.598269] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[166.715930] [036/133] (856s left) gem_busy (parallel)
[166.906052] Starting subtest: parallel
[166.907224] Starting dynamic subtest: rcs0
[168.928778] Dynamic subtest rcs0: SUCCESS (2.018s)
[168.936637] Starting dynamic subtest: bcs0
[170.911496] Dynamic subtest bcs0: SUCCESS (1.981s)
[170.920580] Starting dynamic subtest: vcs0
[172.895597] Dynamic subtest vcs0: SUCCESS (1.980s)
[172.904929] Starting dynamic subtest: vcs1
[174.943610] Dynamic subtest vcs1: SUCCESS (2.046s)
[174.952307] Starting dynamic subtest: vecs0
[176.928254] Dynamic subtest vecs0: SUCCESS (1.982s)
[176.937773] Starting dynamic subtest: ccs0
[178.912894] Dynamic subtest ccs0: SUCCESS (1.982s)
[178.914194] Subtest parallel: SUCCESS (12.004s)
[179.153835] [037/133] (843s left) gem_spin_batch (resubmit-new)
[179.225678] Starting subtest: resubmit-new
[179.226943] Starting dynamic subtest: rcs0
[179.240726] Dynamic subtest rcs0: SUCCESS (0.015s)
[179.248891] Starting dynamic subtest: bcs0
[179.249773] Dynamic subtest bcs0: SUCCESS (0.007s)
[179.255944] Starting dynamic subtest: vcs0
[179.256817] Dynamic subtest vcs0: SUCCESS (0.006s)
[179.262905] Starting dynamic subtest: vcs1
[179.263788] Dynamic subtest vcs1: SUCCESS (0.008s)
[179.269807] Starting dynamic subtest: vecs0
[179.271995] Dynamic subtest vecs0: SUCCESS (0.007s)
[179.278073] Starting dynamic subtest: ccs0
[179.280879] Dynamic subtest ccs0: SUCCESS (0.008s)
[179.281848] Subtest resubmit-new: SUCCESS (0.056s)
[180.933259] [038/133] (842s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[181.028197] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[181.030098] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[181.137037] [039/133] (841s left) gem_partial_pwrite_pread (reads)
[181.193433] Subtest reads: SKIP (0.000s)
[181.249448] [040/133] (841s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[181.330632] Starting subtest: invalid-modeset-force-ultra-joiner
[181.332428] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[181.391814] [041/133] (841s left) syncobj_wait (single-wait-submitted)
[181.446702] Starting subtest: single-wait-submitted
[181.554408] Subtest single-wait-submitted: SUCCESS (0.107s)
[181.620801] [042/133] (841s left) api_intel_bb (object-reloc-purge-cache)
[181.684166] Starting subtest: object-reloc-purge-cache
[181.690052] Subtest object-reloc-purge-cache: SKIP (0.005s)
[181.790260] [043/133] (841s left) sw_sync (sync_multi_timeline_wait)
[181.817956] Starting subtest: sync_multi_timeline_wait
[181.819438] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[181.866612] [044/133] (841s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[181.955388] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[182.945400] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.990s)
[183.061577] [045/133] (840s left) kms_frontbuffer_tracking (fbc-2p-rte)
[183.151152] Starting subtest: fbc-2p-rte
[183.152917] Subtest fbc-2p-rte: SKIP (0.000s)
[183.261235] [046/133] (840s left) vgem_slow (nohang)
[183.446619] Starting subtest: nohang
[193.697558] Subtest nohang: SUCCESS (10.205s)
[193.726129] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[193.728309] [047/133] (829s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[193.828080] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[193.828957] Starting dynamic subtest: pipe-A-eDP-1
[193.971059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[193.980255] Starting dynamic subtest: pipe-B-eDP-1
[193.987686] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[193.994420] Starting dynamic subtest: pipe-C-eDP-1
[194.002149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[194.008417] Starting dynamic subtest: pipe-D-eDP-1
[194.015263] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[194.016066] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.146s)
[196.212179] [048/133] (827s left) gem_ctx_persistence (legacy-engines-hang)
[196.260290] Starting subtest: legacy-engines-hang
[196.261173] Starting dynamic subtest: render
[196.372043] Dynamic subtest render: SUCCESS (0.110s)
[196.382964] Starting dynamic subtest: bsd1
[196.461882] Dynamic subtest bsd1: SUCCESS (0.087s)
[196.472205] Starting dynamic subtest: bsd2
[196.553644] Dynamic subtest bsd2: SUCCESS (0.089s)
[196.564051] Starting dynamic subtest: blt
[196.644684] Dynamic subtest blt: SUCCESS (0.089s)
[196.654681] Starting dynamic subtest: vebox
[196.743714] Dynamic subtest vebox: SUCCESS (0.096s)
[196.745033] Subtest legacy-engines-hang: SUCCESS (0.484s)
[196.829506] [049/133] (826s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[196.918345] Starting subtest: psr-1p-primscrn-spr-indfb-move
[204.497249] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.580s)
[204.627209] [050/133] (818s left) kms_flip (2x-plain-flip)
[204.711138] Starting subtest: 2x-plain-flip
[204.721379] Subtest 2x-plain-flip: SKIP (0.011s)
[204.795777] [051/133] (818s left) gem_ctx_param (root-set)
[204.834411] Starting subtest: root-set
[204.835345] Subtest root-set: SUCCESS (0.001s)
[204.925697] [052/133] (818s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[205.025317] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[205.026206] Starting dynamic subtest: pipe-A-eDP-1
[205.033871] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[205.044364] Starting dynamic subtest: pipe-B-eDP-1
[205.051948] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[205.058433] Starting dynamic subtest: pipe-C-eDP-1
[205.065914] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[205.074429] Starting dynamic subtest: pipe-D-eDP-1
[205.081588] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[205.082417] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[207.289527] [053/133] (816s left) kms_cursor_crc (cursor-offscreen-64x21)
[207.475386] Starting subtest: cursor-offscreen-64x21
[207.521497] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[207.745838] [054/133] (815s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[207.833480] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[207.834388] Starting dynamic subtest: pipe-A-default-mode
[210.516835] Dynamic subtest pipe-A-default-mode: SUCCESS (2.683s)
[210.517974] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.685s)
[211.374706] [055/133] (812s left) kms_addfb_basic (bad-pitch-128)
[211.413707] Starting subtest: bad-pitch-128
[211.414572] Subtest bad-pitch-128: SUCCESS (0.000s)
[211.539639] [056/133] (812s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[211.935395] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[212.710421] [057/133] (810s left) gem_exec_fence (syncobj-timeline-signal)
[213.258329] Starting subtest: syncobj-timeline-signal
[213.259537] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[214.954619] [058/133] (808s left) gem_ctx_bad_destroy (invalid-ctx)
[215.006561] Starting subtest: invalid-ctx
[215.007492] Subtest invalid-ctx: SUCCESS (0.000s)
[215.087378] [059/133] (808s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[215.187926] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[215.189754] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[215.258422] [060/133] (808s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[215.370225] Starting subtest: 2x-long-cursor-vs-flip-atomic
[215.372098] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[215.508773] [061/133] (808s left) drm_mm (drm_mm)
[215.538228] Starting subtest: drm_mm
[215.543498] Starting dynamic subtest: drm_test_mm_init
[215.627828] Dynamic subtest drm_test_mm_init: SUCCESS (0.083s)
[215.636398] Starting dynamic subtest: drm_test_mm_debug
[215.717519] Dynamic subtest drm_test_mm_debug: SUCCESS (0.089s)
[215.725540] Starting dynamic subtest: drm_test_mm_align32
[215.816489] Dynamic subtest drm_test_mm_align32: SUCCESS (0.097s)
[215.823559] Starting dynamic subtest: drm_test_mm_align64
[215.928839] Dynamic subtest drm_test_mm_align64: SUCCESS (0.112s)
[215.936804] Starting dynamic subtest: drm_test_mm_lowest
[216.010739] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.080s)
[216.018409] Starting dynamic subtest: drm_test_mm_highest
[216.091771] Dynamic subtest drm_test_mm_highest: SUCCESS (0.079s)
[216.092779] Subtest drm_mm: SUCCESS (0.553s)
[216.226051] [062/133] (807s left) i915_pm_freq_api (freq-reset-multiple)
[216.287831] Starting subtest: freq-reset-multiple
[216.288862] Starting dynamic subtest: gt0
[225.915432] Dynamic subtest gt0: SUCCESS (9.626s)
[225.924497] Starting dynamic subtest: gt1
[234.387387] Dynamic subtest gt1: SUCCESS (8.461s)
[234.388764] Subtest freq-reset-multiple: SUCCESS (18.089s)
[234.450218] [063/133] (789s left) kms_cursor_crc (cursor-sliding-512x512)
[234.770478] Starting subtest: cursor-sliding-512x512
[234.772532] Subtest cursor-sliding-512x512: SKIP (0.001s)
[234.928438] [064/133] (788s left) gem_exec_balancer (parallel-contexts)
[235.191069] Starting subtest: parallel-contexts
[238.037536] Subtest parallel-contexts: SUCCESS (2.848s)
[238.982545] [065/133] (784s left) kms_psr (psr2-dpms)
[239.081285] Starting subtest: psr2-dpms
[239.082387] Starting dynamic subtest: eDP-1
[241.968592] Dynamic subtest eDP-1: SUCCESS (2.886s)
[241.969453] Subtest psr2-dpms: SUCCESS (2.887s)
[242.833490] [066/133] (781s left) gem_ctx_shared (q-out-order)
[242.889318] Starting subtest: Q-out-order
[242.890321] Starting dynamic subtest: rcs0
[243.000882] Dynamic subtest rcs0: SUCCESS (0.110s)
[243.024040] Starting dynamic subtest: vcs0
[243.094825] Dynamic subtest vcs0: SUCCESS (0.093s)
[243.108562] Starting dynamic subtest: vcs1
[243.180564] Dynamic subtest vcs1: SUCCESS (0.084s)
[243.196595] Starting dynamic subtest: vecs0
[243.259835] Dynamic subtest vecs0: SUCCESS (0.079s)
[243.276626] Starting dynamic subtest: ccs0
[243.342962] Dynamic subtest ccs0: SUCCESS (0.081s)
[243.344794] Subtest Q-out-order: SUCCESS (0.454s)
[244.973634] [067/133] (778s left) gem_userptr_blits (unsync-overlap)
[245.021029] Subtest unsync-overlap: SKIP (0.000s)
[245.130527] [068/133] (778s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[245.221603] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[245.222485] Starting dynamic subtest: pipe-A-eDP-1
[245.231341] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.238852] Starting dynamic subtest: pipe-B-eDP-1
[245.247262] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[245.254423] Starting dynamic subtest: pipe-C-eDP-1
[245.270407] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.277163] Starting dynamic subtest: pipe-D-eDP-1
[245.285439] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.287235] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[247.512777] [069/133] (776s left) gem_eio (wait-wedge-1us)
[247.731710] Starting subtest: wait-wedge-1us
[248.999267] Subtest wait-wedge-1us: SUCCESS (1.268s)
[249.113980] [070/133] (774s left) kms_vblank (wait-forked)
[249.194350] Starting subtest: wait-forked
[249.195455] Starting dynamic subtest: pipe-A-eDP-1
[251.004421] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[251.013394] Starting dynamic subtest: pipe-D-eDP-1
[253.512268] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.506s)
[253.513076] Subtest wait-forked: SUCCESS (4.318s)
[254.374123] [071/133] (769s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[254.470067] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[254.497985] Starting dynamic subtest: pipe-A-plane-0
[254.786651] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[254.794342] Starting dynamic subtest: pipe-A-plane-3
[255.020071] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[256.163510] Starting dynamic subtest: pipe-B-plane-0
[256.456676] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[256.464282] Starting dynamic subtest: pipe-B-plane-3
[256.689876] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[257.006570] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.536s)
[257.833608] [072/133] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[257.917823] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[257.919428] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[258.003345] [073/133] (766s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[258.097565] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[264.842913] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.745s)
[264.952345] [074/133] (759s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[265.035289] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[265.036096] Starting dynamic subtest: pipe-A-eDP-1
[265.039408] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.046772] Starting dynamic subtest: pipe-B-eDP-1
[265.050133] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.057324] Starting dynamic subtest: pipe-C-eDP-1
[265.060830] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.067802] Starting dynamic subtest: pipe-D-eDP-1
[265.071387] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.073155] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[267.240904] [075/133] (756s left) prime_mmap_coherency (read)
[267.292629] Starting subtest: read
[272.711275] Subtest read: SUCCESS (5.373s)
[272.774035] [076/133] (751s left) kms_psr (pr-cursor-plane-move)
[272.868265] Starting subtest: pr-cursor-plane-move
[272.870057] Subtest pr-cursor-plane-move: SKIP (0.000s)
[272.933855] [077/133] (751s left) kms_properties (connector-properties-legacy)
[273.033673] Starting subtest: connector-properties-legacy
[273.034572] Starting dynamic subtest: pipe-A-eDP-1
[280.837970] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.804s)
[280.845093] Starting dynamic subtest: pipe-None-DP-1
[280.847028] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[280.853922] Starting dynamic subtest: pipe-None-HDMI-A-1
[280.855931] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[280.864619] Starting dynamic subtest: pipe-None-DP-2
[280.866263] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[280.874144] Starting dynamic subtest: pipe-None-HDMI-A-2
[280.875642] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[280.882249] Starting dynamic subtest: pipe-None-DP-3
[280.883926] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[280.890266] Starting dynamic subtest: pipe-None-DP-4
[280.891797] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[280.892621] Subtest connector-properties-legacy: SUCCESS (7.816s)
[281.696540] [078/133] (742s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[281.816152] Starting subtest: basic-flip-after-cursor-legacy
[282.730090] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.914s)
[283.524740] [079/133] (740s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[283.583488] Starting subtest: multi-wait-all-available-submitted-signaled
[283.584573] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[283.672037] [080/133] (740s left) gem_exec_parallel (fds)
[283.735290] Starting subtest: fds
[283.736342] Starting dynamic subtest: rcs0
[286.920988] Dynamic subtest rcs0: SUCCESS (3.176s)
[286.931903] Starting dynamic subtest: bcs0
[291.191231] Dynamic subtest bcs0: SUCCESS (4.268s)
[291.199081] Starting dynamic subtest: vcs0
[296.913106] Dynamic subtest vcs0: SUCCESS (5.720s)
[296.922494] Starting dynamic subtest: vcs1
[301.213756] Dynamic subtest vcs1: SUCCESS (4.298s)
[301.222723] Starting dynamic subtest: vecs0
[305.162384] Dynamic subtest vecs0: SUCCESS (3.946s)
[305.171525] Starting dynamic subtest: ccs0
[309.328243] Dynamic subtest ccs0: SUCCESS (4.163s)
[309.329454] Subtest fds: SUCCESS (25.584s)
[309.508430] [081/133] (714s left) vgem_basic (bad-flag)
[309.554375] Starting subtest: bad-flag
[309.555138] Subtest bad-flag: SUCCESS (0.000s)
[309.606499] [082/133] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[309.700446] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[309.702181] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[309.787186] [083/133] (714s left) gem_ctx_param (invalid-get-ringsize)
[309.829525] Starting subtest: invalid-get-ringsize
[309.830541] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[309.916305] [084/133] (714s left) gem_exec_schedule (pi-distinct-iova)
[310.098232] Starting subtest: pi-distinct-iova
[310.099152] Starting dynamic subtest: rcs0
[310.171187] Dynamic subtest rcs0: SUCCESS (0.081s)
[310.180869] Starting dynamic subtest: vcs0
[310.233632] Dynamic subtest vcs0: SUCCESS (0.062s)
[310.243398] Starting dynamic subtest: vcs1
[310.293429] Dynamic subtest vcs1: SUCCESS (0.059s)
[310.304345] Starting dynamic subtest: vecs0
[310.353418] Dynamic subtest vecs0: SUCCESS (0.059s)
[310.365778] Starting dynamic subtest: ccs0
[310.427521] Dynamic subtest ccs0: SUCCESS (0.074s)
[310.428624] Subtest pi-distinct-iova: SUCCESS (0.338s)
[311.974611] [085/133] (712s left) kms_chamelium_color (ctm-red-to-blue)
[312.070118] Subtest ctm-red-to-blue: SKIP (0.000s)
[312.110477] [086/133] (712s left) i915_selftest (mock)
[315.441575] Starting subtest: mock
[315.443027] Starting dynamic subtest: sanitycheck
[316.146991] Dynamic subtest sanitycheck: SUCCESS (0.706s)
[316.155157] Starting dynamic subtest: shmem
[316.855032] Dynamic subtest shmem: SUCCESS (0.706s)
[316.863110] Starting dynamic subtest: fence
[325.012253] Dynamic subtest fence: SUCCESS (8.154s)
[325.020772] Starting dynamic subtest: scatterlist
[326.692735] Dynamic subtest scatterlist: SUCCESS (1.678s)
[326.701231] Starting dynamic subtest: syncmap
[330.114473] Dynamic subtest syncmap: SUCCESS (3.419s)
[330.122596] Starting dynamic subtest: uncore
[330.781050] Dynamic subtest uncore: SUCCESS (0.665s)
[330.787921] Starting dynamic subtest: ring
[331.443618] Dynamic subtest ring: SUCCESS (0.660s)
[331.451520] Starting dynamic subtest: engine
[332.125985] Dynamic subtest engine: SUCCESS (0.681s)
[332.133947] Starting dynamic subtest: timelines
[336.130421] Dynamic subtest timelines: SUCCESS (4.002s)
[336.138970] Starting dynamic subtest: requests
[339.683073] Dynamic subtest requests: SUCCESS (3.550s)
[339.691435] Starting dynamic subtest: objects
[340.451039] Dynamic subtest objects: SUCCESS (0.767s)
[340.458907] Starting dynamic subtest: phys
[341.226165] Dynamic subtest phys: SUCCESS (0.774s)
[341.234065] Starting dynamic subtest: dmabuf
[341.999032] Dynamic subtest dmabuf: SUCCESS (0.771s)
[342.007084] Starting dynamic subtest: vma
[347.992787] Dynamic subtest vma: SUCCESS (5.991s)
[348.001088] Starting dynamic subtest: evict
[349.472602] Dynamic subtest evict: SUCCESS (1.479s)
[349.480341] Starting dynamic subtest: gtt
[352.869980] Dynamic subtest gtt: SUCCESS (3.394s)
[352.878534] Starting dynamic subtest: hugepages
[353.780087] Dynamic subtest hugepages: SUCCESS (0.909s)
[353.788559] Starting dynamic subtest: memory_region
[356.465845] Dynamic subtest memory_region: SUCCESS (2.684s)
[356.467017] Subtest mock: SUCCESS (41.025s)
[356.490424] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[356.491130] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[356.492886] [087/133] (668s left) kms_psr (psr-sprite-render)
[358.085294] Starting subtest: psr-sprite-render
[358.086103] Starting dynamic subtest: eDP-1
[359.843252] Dynamic subtest eDP-1: SUCCESS (1.750s)
[359.844084] Subtest psr-sprite-render: SUCCESS (1.751s)
[360.679817] [FACT kms_psr (psr-sprite-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[360.681086] [FACT kms_psr (psr-sprite-render)] new: kernel.kmod_is_loaded.i915: true
[360.683319] [088/133] (663s left) sw_sync (timeline_closed)
[360.716385] Starting subtest: timeline_closed
[360.717246] Subtest timeline_closed: SUCCESS (0.000s)
[360.762640] [089/133] (663s left) gem_pxp (verify-pxp-stale-buf-execution)
[360.881270] Starting subtest: verify-pxp-stale-buf-execution
[361.949625] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.069s)
[362.071243] [090/133] (662s left) gem_tiled_pread_pwrite
[362.169094] [091/133] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[362.253484] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[362.255141] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[362.340829] [092/133] (662s left) i915_drm_fdinfo (all-busy-check-all)
[362.382076] Starting subtest: all-busy-check-all
[362.385290] Subtest all-busy-check-all: SKIP (0.004s)
[362.439998] [093/133] (662s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[362.558367] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[362.560095] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[362.643268] [094/133] (662s left) kms_plane (planar-pixel-format-settings)
[362.745369] Starting subtest: planar-pixel-format-settings
[362.811968] Subtest planar-pixel-format-settings: SUCCESS (0.067s)
[362.914855] [095/133] (661s left) gem_exec_fence (submit)
[363.102871] Starting subtest: submit
[363.104991] Subtest submit: SKIP (0.000s)
[364.955086] [096/133] (659s left) kms_color_pipeline (plane-ctm3x4)
[365.046453] Starting subtest: plane-ctm3x4
[365.215724] Starting dynamic subtest: pipe-A-plane-0
[365.382117] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[365.388934] Starting dynamic subtest: pipe-A-plane-1
[365.515688] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[365.529051] Starting dynamic subtest: pipe-A-plane-2
[365.648912] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[366.892903] Starting dynamic subtest: pipe-B-plane-0
[367.029114] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[367.036289] Starting dynamic subtest: pipe-B-plane-1
[367.162623] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[367.169672] Starting dynamic subtest: pipe-B-plane-2
[367.307132] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[368.513362] Starting dynamic subtest: pipe-C-plane-0
[368.627451] Dynamic subtest pipe-C-plane-0: SUCCESS (0.122s)
[368.634901] Starting dynamic subtest: pipe-C-plane-1
[368.738513] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[368.745162] Starting dynamic subtest: pipe-C-plane-2
[368.849575] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[370.008172] Starting dynamic subtest: pipe-D-plane-0
[370.134869] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[370.141745] Starting dynamic subtest: pipe-D-plane-1
[370.246267] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[370.255905] Starting dynamic subtest: pipe-D-plane-2
[370.379957] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[370.679356] Subtest plane-ctm3x4: SUCCESS (5.633s)
[371.484314] [097/133] (653s left) gem_exec_whisper (basic-fds-all)
[371.540279] Starting subtest: basic-fds-all
[382.849213] Subtest basic-fds-all: SUCCESS (11.297s)
[383.018748] [098/133] (641s left) kms_addfb_basic (basic-x-tiled-legacy)
[383.083896] Starting subtest: basic-x-tiled-legacy
[383.085978] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[383.213456] [099/133] (641s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[383.272887] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[383.274652] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[383.449381] [100/133] (641s left) gem_exec_reloc (basic-wc-gtt)
[383.503000] Subtest basic-wc-gtt: SKIP (0.000s)
[383.573580] [101/133] (641s left) gem_pxp (display-protected-crc)
[383.622491] Starting subtest: display-protected-crc
[385.299584] Subtest display-protected-crc: SUCCESS (1.677s)
[385.402765] [102/133] (639s left) kms_pipe_crc_basic (nonblocking-crc)
[385.490320] Starting subtest: nonblocking-crc
[385.491119] Starting dynamic subtest: pipe-A-eDP-1
[386.244973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.754s)
[386.252034] Starting dynamic subtest: pipe-B-eDP-1
[387.728139] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.481s)
[387.736564] Starting dynamic subtest: pipe-C-eDP-1
[389.068580] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s)
[389.077066] Starting dynamic subtest: pipe-D-eDP-1
[390.395501] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[390.396446] Subtest nonblocking-crc: SUCCESS (4.905s)
[391.206484] [103/133] (633s left) kms_addfb_basic (bo-too-small)
[391.294962] Starting subtest: bo-too-small
[391.295813] Subtest bo-too-small: SUCCESS (0.000s)
[391.398999] [104/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[391.488895] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[391.490571] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[391.595578] [105/133] (633s left) gem_mmap_offset (partial-unmap)
[391.655022] Starting subtest: partial-unmap
[391.655961] Starting dynamic subtest: smem0
[392.173084] Dynamic subtest smem0: SUCCESS (0.509s)
[392.174647] Subtest partial-unmap: SUCCESS (0.510s)
[392.282124] [106/133] (632s left) perf_pmu (busy-check-all)
[392.316665] Starting subtest: busy-check-all
[392.317665] Starting dynamic subtest: rcs0
[392.878235] Dynamic subtest rcs0: SUCCESS (0.561s)
[392.894463] Starting dynamic subtest: bcs0
[393.427541] Dynamic subtest bcs0: SUCCESS (0.547s)
[393.438562] Starting dynamic subtest: vcs0
[394.910513] Dynamic subtest vcs0: SUCCESS (1.472s)
[394.920130] Starting dynamic subtest: vcs1
[396.895742] Dynamic subtest vcs1: SUCCESS (1.982s)
[396.908746] Starting dynamic subtest: vecs0
[398.945389] Dynamic subtest vecs0: SUCCESS (2.047s)
[398.955973] Starting dynamic subtest: ccs0
[399.493925] Dynamic subtest ccs0: SUCCESS (0.555s)
[399.495314] Subtest busy-check-all: SUCCESS (7.178s)
[399.594614] [107/133] (625s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[399.780590] Starting subtest: cursor-rapid-movement-64x21
[399.826353] Subtest cursor-rapid-movement-64x21: SKIP (0.044s)
[400.065311] [108/133] (625s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[400.159049] Starting subtest: plane-upscale-20x20-with-rotation
[400.159881] Starting dynamic subtest: pipe-A
[400.385841] Dynamic subtest pipe-A: SUCCESS (0.227s)
[400.394383] Starting dynamic subtest: pipe-B
[401.678036] Dynamic subtest pipe-B: SUCCESS (1.291s)
[401.686413] Starting dynamic subtest: pipe-C
[403.016918] Dynamic subtest pipe-C: SUCCESS (1.338s)
[403.024184] Starting dynamic subtest: pipe-D
[404.348891] Dynamic subtest pipe-D: SUCCESS (1.331s)
[404.349891] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.191s)
[405.521415] [109/133] (619s left) kms_flip (2x-flip-vs-modeset)
[405.619242] Starting subtest: 2x-flip-vs-modeset
[405.637961] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[405.704466] [110/133] (619s left) kms_draw_crc (fill-fb)
[405.789543] Starting subtest: fill-fb
[406.275385] Subtest fill-fb: SUCCESS (0.486s)
[406.387602] [111/133] (619s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[406.488058] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[406.489834] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[406.580178] [112/133] (618s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[406.672691] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[413.387763] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.716s)
[413.486895] [113/133] (611s left) tools_test (sysfs_l3_parity)
[413.520843] Starting subtest: sysfs_l3_parity
[413.594022] Subtest sysfs_l3_parity: SKIP (0.077s)
[413.645569] [114/133] (611s left) gem_lmem_swapping (parallel-random-verify-ccs)
[413.679886] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[413.727126] [115/133] (611s left) kms_atomic_transition (modeset-transition-fencing)
[413.814089] Starting subtest: modeset-transition-fencing
[413.814939] Starting dynamic subtest: 1x-outputs
[424.643061] Dynamic subtest 1x-outputs: SUCCESS (10.829s)
[424.645730] Subtest modeset-transition-fencing: SUCCESS (10.831s)
[425.490733] [116/133] (600s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[425.569319] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[425.570218] Starting dynamic subtest: pipe-A-eDP-1
[425.647279] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[425.655559] Starting dynamic subtest: pipe-B-eDP-1
[426.763146] Dynamic subtest pipe-B-eDP-1: SKIP (1.114s)
[426.765055] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.194s)
[427.955467] [117/133] (597s left) kms_psr (fbc-psr-primary-mmap-gtt)
[428.045300] Starting subtest: fbc-psr-primary-mmap-gtt
[428.046599] Starting dynamic subtest: eDP-1
[428.048478] Dynamic subtest eDP-1: SKIP (0.000s)
[428.050261] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[428.112546] [118/133] (597s left) kms_joiner (invalid-modeset-force-big-joiner)
[428.209477] Starting subtest: invalid-modeset-force-big-joiner
[428.211115] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[428.273542] [119/133] (597s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[428.378029] Starting subtest: fbcpsr-stridechange
[434.600196] Subtest fbcpsr-stridechange: SUCCESS (6.222s)
[434.720975] [120/133] (590s left) gem_create (create-ext-placement-all)
[434.901320] Starting subtest: create-ext-placement-all
[434.902570] Subtest create-ext-placement-all: SUCCESS (0.000s)
[434.992940] [121/133] (590s left) kms_scaling_modes (scaling-mode-full-aspect)
[435.075286] Starting subtest: scaling-mode-full-aspect
[435.076149] Starting dynamic subtest: pipe-A-eDP-1
[435.167026] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s)
[435.176483] Starting dynamic subtest: pipe-B-eDP-1
[436.302692] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.134s)
[436.314734] Starting dynamic subtest: pipe-C-eDP-1
[437.421645] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[437.433948] Starting dynamic subtest: pipe-D-eDP-1
[438.546744] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[438.548711] Subtest scaling-mode-full-aspect: SUCCESS (3.474s)
[439.701213] [122/133] (586s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[439.826423] Starting subtest: yf-tiled-16bpp-rotate-270
[439.828338] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[439.926373] [123/133] (585s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[440.010609] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[440.011471] Starting dynamic subtest: pipe-A-eDP-1
[440.100873] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[440.108649] Starting dynamic subtest: pipe-B-eDP-1
[441.281952] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s)
[441.283701] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.271s)
[442.454959] [124/133] (583s left) perf (stress-open-close)
[442.572204] Starting subtest: stress-open-close
[442.572974] Starting dynamic subtest: 0-rcs0
[444.737939] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[444.748073] Starting dynamic subtest: 1-vecs0
[446.903241] Dynamic subtest 1-vecs0: SUCCESS (2.163s)
[446.904215] Subtest stress-open-close: SUCCESS (4.332s)
[446.946912] [125/133] (578s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[447.050798] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[447.052388] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[447.139924] [126/133] (578s left) gem_exec_balancer (nohangcheck)
[447.413964] Starting subtest: nohangcheck
[448.392491] Subtest nohangcheck: SUCCESS (0.977s)
[448.505421] [127/133] (577s left) prime_vgem (basic-write)
[448.577080] Starting subtest: basic-write
[448.583552] Subtest basic-write: SKIP (0.006s)
[448.682995] [128/133] (577s left) kms_flip (wf_vblank-ts-check-interruptible)
[448.771373] Starting subtest: wf_vblank-ts-check-interruptible
[448.773762] Starting dynamic subtest: A-eDP1
[457.741829] Dynamic subtest A-eDP1: SUCCESS (8.944s)
[457.754771] Starting dynamic subtest: B-eDP1
[466.677205] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[466.687339] Starting dynamic subtest: C-eDP1
[475.614870] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[475.623595] Starting dynamic subtest: D-eDP1
[484.512053] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[484.516243] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.744s)
[485.742319] [129/133] (540s left) gem_exercise_blt (fast-copy-emit)
[485.792143] Starting subtest: fast-copy-emit
[485.792969] Starting dynamic subtest: linear-smem-smem-emit
[485.822272] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.029s)
[485.831954] Starting dynamic subtest: xmajor-smem-smem-emit
[485.839453] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[485.846236] Starting dynamic subtest: tile4-smem-smem-emit
[485.857648] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[485.864492] Starting dynamic subtest: tile64-smem-smem-emit
[485.876060] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s)
[485.876906] Subtest fast-copy-emit: SUCCESS (0.084s)
[485.987666] [130/133] (540s left) gem_fence_thrash (bo-write-verify-x)
[486.020600] Starting subtest: bo-write-verify-x
[486.036352] Subtest bo-write-verify-x: SKIP (0.015s)
[486.096440] [131/133] (539s left) gem_mmap_wc (invalid-flags)
[486.146369] Subtest invalid-flags: SKIP (0.000s)
[486.204414] [132/133] (539s left) i915_pm_rpm (debugfs-forcewake-user)
[488.032304] Starting subtest: debugfs-forcewake-user
[499.424276] Subtest debugfs-forcewake-user: SUCCESS (11.394s)
[499.805170] [133/133] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[499.905423] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[499.907226] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[499.996559] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: kms_dp_linktrain_fallback
results: parsing output: 13/ for test: gem_exec_flush
results: parsing output: 14/ for test: sw_sync
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_plane_multiple
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: kms_cdclk
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_psr2_su
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_feature_discovery
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_content_protection
results: parsing output: 35/ for test: gem_busy
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_partial_pwrite_pread
results: parsing output: 39/ for test: kms_joiner
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: api_intel_bb
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: vgem_slow
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: gem_ctx_param
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: gem_ctx_bad_destroy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: drm_mm
results: parsing output: 61/ for test: i915_pm_freq_api
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_ctx_shared
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: prime_mmap_coherency
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_properties
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_parallel
results: parsing output: 80/ for test: vgem_basic
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_ctx_param
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_chamelium_color
results: parsing output: 85/ for test: i915_selftest
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: sw_sync
results: parsing output: 88/ for test: gem_pxp
results: parsing output: 89/ for test: gem_tiled_pread_pwrite
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: i915_drm_fdinfo
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: gem_pxp
results: parsing output: 101/ for test: kms_pipe_crc_basic
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_draw_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: tools_test
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_atomic_transition
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_joiner
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_create
results: parsing output: 120/ for test: kms_scaling_modes
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: prime_vgem
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_exercise_blt
results: parsing output: 129/ for test: gem_fence_thrash
results: parsing output: 130/ for test: gem_mmap_wc
results: parsing output: 131/ for test: i915_pm_rpm
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.