[57.615500] Initializing watchdogs
[57.615552]   /dev/watchdog0
[57.628699] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.632598] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.634577] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.637790] [001/131] (960s left) kms_cursor_crc (cursor-random-32x32)
[57.830392] Starting subtest: cursor-random-32x32
[57.874911] Subtest cursor-random-32x32: SKIP (0.038s)
[58.144766] [002/131] (960s left) kms_flip (flip-vs-suspend)
[58.244759] Starting subtest: flip-vs-suspend
[58.246973] Starting dynamic subtest: A-eDP1
[107.060167] Dynamic subtest A-eDP1: SUCCESS (4.475s)
[107.067062] Starting dynamic subtest: B-eDP1
[156.070552] Dynamic subtest B-eDP1: SUCCESS (4.235s)
[156.077925] Starting dynamic subtest: C-eDP1
[205.057480] Dynamic subtest C-eDP1: SUCCESS (4.294s)
[205.066640] Starting dynamic subtest: D-eDP1
[254.075682] Dynamic subtest D-eDP1: SUCCESS (4.320s)
[254.078015] Subtest flip-vs-suspend: SUCCESS (17.330s)
[255.283690] [003/131] (762s left) kms_cursor_edge_walk (256x256-right-edge)
[255.378574] Starting subtest: 256x256-right-edge
[255.380974] Starting dynamic subtest: pipe-A-eDP-1
[258.860118] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[258.868499] Starting dynamic subtest: pipe-D-eDP-1
[261.984721] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[261.987101] Subtest 256x256-right-edge: SUCCESS (6.601s)
[262.771890] [004/131] (755s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[262.874905] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[262.877611] Starting dynamic subtest: pipe-A-default-mode
[263.162044] Dynamic subtest pipe-A-default-mode: SKIP (0.281s)
[263.166917] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.282s)
[263.991473] [005/131] (754s left) prime_self_import (export-vs-gem_close-race)
[264.026726] Starting subtest: export-vs-gem_close-race
[269.134350] Subtest export-vs-gem_close-race: SUCCESS (5.103s)
[269.200680] [006/131] (749s left) syncobj_timeline (multi-wait-available-signaled)
[269.251902] Starting subtest: multi-wait-available-signaled
[269.254428] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[269.369642] [007/131] (748s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[269.490568] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[269.495337] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[269.567318] [008/131] (748s left) gem_ctx_persistence (engines-queued)
[269.645089] Starting subtest: engines-queued
[269.647849] Starting dynamic subtest: rcs0
[269.768305] Dynamic subtest rcs0: SUCCESS (0.123s)
[269.779229] Starting dynamic subtest: bcs0
[269.843855] Dynamic subtest bcs0: SUCCESS (0.074s)
[269.853333] Starting dynamic subtest: vcs0
[271.353120] Dynamic subtest vcs0: SUCCESS (1.505s)
[271.363206] Starting dynamic subtest: vcs1
[273.403518] Dynamic subtest vcs1: SUCCESS (2.049s)
[273.414372] Starting dynamic subtest: vecs0
[275.385255] Dynamic subtest vecs0: SUCCESS (1.981s)
[275.395573] Starting dynamic subtest: ccs0
[275.563540] Dynamic subtest ccs0: SUCCESS (0.178s)
[275.566697] Subtest engines-queued: SUCCESS (5.917s)
[275.638361] [009/131] (742s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[275.752553] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[275.757256] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[275.844520] [010/131] (742s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[275.953123] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[279.705897] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.758s)
[280.885852] [011/131] (737s left) gem_eio (throttle)
[281.045997] Starting subtest: throttle
[281.258671] Subtest throttle: SUCCESS (0.212s)
[281.410037] [012/131] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[281.519065] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[281.524300] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[281.615628] [013/131] (736s left) prime_busy (before-wait)
[281.674476] Starting subtest: before-wait
[281.679967] Starting dynamic subtest: rcs0
[281.728352] Dynamic subtest rcs0: SUCCESS (0.050s)
[281.737331] Starting dynamic subtest: bcs0
[281.801937] Dynamic subtest bcs0: SUCCESS (0.073s)
[281.815025] Starting dynamic subtest: vcs0
[281.843466] Dynamic subtest vcs0: SUCCESS (0.041s)
[281.851172] Starting dynamic subtest: vcs1
[281.885318] Dynamic subtest vcs1: SUCCESS (0.041s)
[281.895135] Starting dynamic subtest: vecs0
[281.926576] Dynamic subtest vecs0: SUCCESS (0.041s)
[281.935629] Starting dynamic subtest: ccs0
[281.969096] Dynamic subtest ccs0: SUCCESS (0.042s)
[282.079319] Subtest before-wait: SUCCESS (0.403s)
[282.147328] [014/131] (736s left) perf (polling)
[282.276104] Starting subtest: polling
[282.278255] Starting dynamic subtest: 0-rcs0
[292.307035] Dynamic subtest 0-rcs0: SUCCESS (10.030s)
[292.315069] Starting dynamic subtest: 1-vecs0
[302.327770] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[302.330224] Subtest polling: SUCCESS (20.050s)
[302.369323] [015/131] (716s left) gem_spin_batch (spin-all)
[302.436609] Starting subtest: spin-all
[302.457177] Subtest spin-all: SUCCESS (0.021s)
[304.446512] [016/131] (714s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[304.560776] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[304.565453] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[304.674381] [017/131] (713s left) kms_universal_plane (universal-plane-functional)
[304.775191] Starting subtest: universal-plane-functional
[304.777802] Starting dynamic subtest: pipe-A-eDP-1
[308.610959] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.830s)
[308.620316] Starting dynamic subtest: pipe-B-eDP-1
[312.968907] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.359s)
[312.977441] Starting dynamic subtest: pipe-C-eDP-1
[317.216182] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.245s)
[317.224871] Starting dynamic subtest: pipe-D-eDP-1
[321.388493] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.172s)
[321.391288] Subtest universal-plane-functional: SUCCESS (16.609s)
[322.174744] [018/131] (696s left) i915_pm_rc6_residency (media-rc6-accuracy)
[322.234223] Starting subtest: media-rc6-accuracy
[322.239492] Subtest media-rc6-accuracy: SKIP (0.000s)
[322.344522] [019/131] (696s left) gem_exec_parallel (contexts)
[322.398633] Starting subtest: contexts
[322.401140] Starting dynamic subtest: rcs0
[326.700059] Dynamic subtest rcs0: SUCCESS (4.299s)
[326.710821] Starting dynamic subtest: bcs0
[331.295855] Dynamic subtest bcs0: SUCCESS (4.593s)
[331.304622] Starting dynamic subtest: vcs0
[335.866750] Dynamic subtest vcs0: SUCCESS (4.568s)
[335.875317] Starting dynamic subtest: vcs1
[341.790359] Dynamic subtest vcs1: SUCCESS (5.921s)
[341.799256] Starting dynamic subtest: vecs0
[346.834024] Dynamic subtest vecs0: SUCCESS (5.042s)
[346.844259] Starting dynamic subtest: ccs0
[351.637679] Dynamic subtest ccs0: SUCCESS (4.802s)
[351.640542] Subtest contexts: SUCCESS (29.235s)
[351.818402] [020/131] (666s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[356.846810] Starting subtest: pr-primary-plane-update-sf-dmg-area
[356.852168] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[357.689975] [021/131] (661s left) syncobj_timeline (wait-for-submit-delayed-submit)
[357.747905] Starting subtest: wait-for-submit-delayed-submit
[357.849720] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[357.922926] [022/131] (660s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[358.030081] Starting subtest: plane-upscale-20x20-with-rotation
[358.032706] Starting dynamic subtest: pipe-A
[358.257107] Dynamic subtest pipe-A: SUCCESS (0.227s)
[358.266288] Starting dynamic subtest: pipe-B
[359.575731] Dynamic subtest pipe-B: SUCCESS (1.318s)
[359.585803] Starting dynamic subtest: pipe-C
[360.895139] Dynamic subtest pipe-C: SUCCESS (1.319s)
[360.903386] Starting dynamic subtest: pipe-D
[362.216210] Dynamic subtest pipe-D: SUCCESS (1.320s)
[362.219021] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.186s)
[363.387954] [023/131] (655s left) gem_eio (in-flight-suspend)
[363.621572] Starting subtest: in-flight-suspend
[406.414703] Subtest in-flight-suspend: SUCCESS (13.759s)
[406.557713] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[406.561874] [024/131] (612s left) gem_mmap_gtt (cpuset-big-copy-odd)
[406.627780] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[406.691343] [025/131] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[406.798860] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[406.803525] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[406.895324] [026/131] (612s left) kms_psr (psr-primary-page-flip)
[406.998341] Starting subtest: psr-primary-page-flip
[407.000622] Starting dynamic subtest: eDP-1
[408.772671] Dynamic subtest eDP-1: SUCCESS (1.771s)
[408.775102] Subtest psr-primary-page-flip: SUCCESS (1.772s)
[409.622078] [027/131] (609s left) dumb_buffer (map-invalid-size)
[409.681197] Starting subtest: map-invalid-size
[409.683876] Subtest map-invalid-size: SUCCESS (0.000s)
[409.780352] [028/131] (609s left) kms_properties (crtc-properties-atomic)
[409.873655] Starting subtest: crtc-properties-atomic
[409.876329] Starting dynamic subtest: pipe-A-eDP-1
[410.332987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[410.342962] Starting dynamic subtest: pipe-B-eDP-1
[411.468446] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[411.477735] Starting dynamic subtest: pipe-C-eDP-1
[412.586624] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[412.595270] Starting dynamic subtest: pipe-D-eDP-1
[413.710415] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[413.712900] Subtest crtc-properties-atomic: SUCCESS (3.833s)
[414.519321] [029/131] (604s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[414.614644] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[414.617191] Starting dynamic subtest: pipe-A-eDP-1
[414.683449] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[414.691895] Starting dynamic subtest: pipe-B-eDP-1
[414.761783] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[414.771361] Starting dynamic subtest: pipe-C-eDP-1
[414.838766] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[414.848228] Starting dynamic subtest: pipe-D-eDP-1
[414.917513] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[414.922535] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[416.765283] [030/131] (602s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[416.872498] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[416.877752] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[416.975334] [031/131] (602s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[417.043818] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[417.148391] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[417.225322] [032/131] (601s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[417.335979] Starting subtest: 4-tiled-8bpp-rotate-90
[417.356733] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[417.485995] [033/131] (601s left) kms_pm_dc (dc6-psr)
[418.592700] Starting subtest: dc6-psr
[425.953775] Subtest dc6-psr: FAIL (6.644s)
[425.987681] [034/131] (593s left) kms_draw_crc (draw-method-render)
[426.090821] Starting subtest: draw-method-render
[426.093203] Starting dynamic subtest: xrgb8888-untiled
[426.327719] Dynamic subtest xrgb8888-untiled: SUCCESS (0.240s)
[426.336013] Starting dynamic subtest: rgb565-untiled
[426.538771] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[426.547574] Starting dynamic subtest: xrgb2101010-untiled
[426.739039] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[426.747553] Starting dynamic subtest: xbgr16161616f-untiled
[426.994239] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.255s)
[427.002672] Starting dynamic subtest: xrgb8888-xtiled
[427.127772] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[427.135960] Starting dynamic subtest: rgb565-xtiled
[427.239210] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[427.248756] Starting dynamic subtest: xrgb2101010-xtiled
[427.350398] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[427.358454] Starting dynamic subtest: xbgr16161616f-xtiled
[427.494613] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.144s)
[427.503405] Starting dynamic subtest: xrgb8888-4tiled
[427.616869] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[427.625523] Starting dynamic subtest: rgb565-4tiled
[427.727823] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[427.738364] Starting dynamic subtest: xrgb2101010-4tiled
[427.839150] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[427.847586] Starting dynamic subtest: xbgr16161616f-4tiled
[427.972515] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[427.974855] Subtest draw-method-render: SUCCESS (1.885s)
[428.083470] [035/131] (591s left) gem_sync (basic-store-all)
[428.149519] Starting subtest: basic-store-all
[432.629706] Subtest basic-store-all: SUCCESS (4.487s)
[432.812674] [036/131] (586s left) gem_exec_schedule (lateslice)
[432.889495] Starting subtest: lateslice
[432.892249] Starting dynamic subtest: rcs0
[432.906226] Dynamic subtest rcs0: SUCCESS (0.028s)
[432.914875] Starting dynamic subtest: bcs0
[432.929663] Dynamic subtest bcs0: SUCCESS (0.023s)
[432.938702] Starting dynamic subtest: vcs0
[432.953824] Dynamic subtest vcs0: SUCCESS (0.023s)
[432.962115] Starting dynamic subtest: vcs1
[432.976775] Dynamic subtest vcs1: SUCCESS (0.023s)
[432.987459] Starting dynamic subtest: vecs0
[432.999645] Dynamic subtest vecs0: SUCCESS (0.022s)
[433.010991] Starting dynamic subtest: ccs0
[433.020623] Dynamic subtest ccs0: SUCCESS (0.021s)
[433.023343] Subtest lateslice: SUCCESS (0.143s)
[434.535491] [037/131] (584s left) gem_exec_fence (long-history)
[434.964710] Starting subtest: long-history
[442.085041] Subtest long-history: SUCCESS (7.119s)
[444.120413] [038/131] (575s left) gem_exec_reloc (basic-write-cpu-noreloc)
[444.188992] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[444.270414] [039/131] (575s left) prime_mmap (test_dup)
[444.321128] Starting subtest: test_dup
[444.323112] Starting dynamic subtest: test_dup-smem
[444.352484] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[444.355251] Subtest test_dup: SUCCESS (0.034s)
[444.421415] [040/131] (575s left) syncobj_wait (invalid-signal-illegal-handle)
[444.485964] Starting subtest: invalid-signal-illegal-handle
[444.488792] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[444.589151] [041/131] (574s left) kms_invalid_mode (zero-vdisplay)
[444.695113] Starting subtest: zero-vdisplay
[444.697776] Starting dynamic subtest: pipe-A-eDP-1
[444.974002] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.279s)
[444.985621] Starting dynamic subtest: pipe-B-eDP-1
[444.987763] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[444.996191] Starting dynamic subtest: pipe-C-eDP-1
[444.998822] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[445.006969] Starting dynamic subtest: pipe-D-eDP-1
[445.009716] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[445.012176] Subtest zero-vdisplay: SUCCESS (0.284s)
[445.800894] [042/131] (573s left) kms_fbcon_fbt (fbc-suspend)
[445.862670] Starting subtest: fbc-suspend
[494.227741] Subtest fbc-suspend: SUCCESS (18.595s)
[495.285036] [043/131] (524s left) kms_plane_multiple (tiling-4)
[495.390261] Starting subtest: tiling-4
[495.392466] Starting dynamic subtest: pipe-A-eDP-1
[499.101630] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.706s)
[499.110820] Starting dynamic subtest: pipe-B-eDP-1
[503.492064] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.388s)
[503.500086] Starting dynamic subtest: pipe-C-eDP-1
[507.779241] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.285s)
[507.788273] Starting dynamic subtest: pipe-D-eDP-1
[512.078487] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.295s)
[512.080927] Subtest tiling-4: SUCCESS (16.678s)
[512.896767] [044/131] (506s left) i915_pm_rps (min-max-config-idle)
[512.955012] Starting subtest: min-max-config-idle
[512.960089] Subtest min-max-config-idle: SKIP (0.000s)
[513.030302] [045/131] (506s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[513.084937] Starting subtest: yf-tiled-to-vebox-x-tiled
[513.089440] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[513.259214] [046/131] (506s left) i915_query (query-regions-unallocated)
[513.316786] Starting subtest: query-regions-unallocated
[513.318624] Subtest query-regions-unallocated: SUCCESS (0.000s)
[513.427364] [047/131] (506s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[513.533483] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[520.768295] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.233s)
[520.855093] [048/131] (498s left) kms_vblank (wait-forked-busy)
[520.953286] Starting subtest: wait-forked-busy
[520.955471] Starting dynamic subtest: pipe-A-eDP-1
[522.834720] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[522.847650] Starting dynamic subtest: pipe-D-eDP-1
[525.360796] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.522s)
[525.363079] Subtest wait-forked-busy: SUCCESS (4.405s)
[526.150406] [049/131] (493s left) gem_ctx_param (non-root-set)
[526.206058] Starting subtest: non-root-set
[526.230286] Subtest non-root-set: SUCCESS (0.024s)
[526.322990] [050/131] (493s left) kms_content_protection (dp-mst-type-1)
[526.496351] Starting subtest: dp-mst-type-1
[526.501132] Subtest dp-mst-type-1: SKIP (0.000s)
[526.627744] [051/131] (493s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[526.750424] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[526.883835] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.136s)
[527.011808] [052/131] (492s left) api_intel_bb (misplaced-blitter)
[527.064071] Starting subtest: misplaced-blitter
[527.074109] Subtest misplaced-blitter: SUCCESS (0.010s)
[527.195640] [053/131] (492s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[527.581005] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[528.352568] [054/131] (491s left) syncobj_timeline (wait-all-snapshot)
[528.413638] Starting subtest: wait-all-snapshot
[528.493890] Subtest wait-all-snapshot: SUCCESS (0.081s)
[528.564683] [055/131] (491s left) kms_lease (lease-again)
[528.661306] Starting subtest: lease-again
[528.663760] Starting dynamic subtest: pipe-A-eDP-1
[528.666118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[528.675376] Starting dynamic subtest: pipe-B-eDP-1
[528.677237] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[528.684782] Starting dynamic subtest: pipe-C-eDP-1
[528.686663] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[528.694186] Starting dynamic subtest: pipe-D-eDP-1
[528.696130] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[528.698018] Subtest lease-again: SUCCESS (0.010s)
[528.781082] [056/131] (491s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[528.883801] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[528.888220] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[528.975033] [057/131] (491s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[529.067560] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[529.072435] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[530.198082] [058/131] (489s left) gem_bad_reloc (negative-reloc-bltcopy)
[530.254895] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[530.331227] [059/131] (489s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[530.428473] Starting subtest: read-crc-frame-sequence
[530.430660] Starting dynamic subtest: pipe-A-eDP-1
[531.129835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[531.138802] Starting dynamic subtest: pipe-B-eDP-1
[532.454361] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.322s)
[532.463378] Starting dynamic subtest: pipe-C-eDP-1
[533.724818] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.268s)
[533.734117] Starting dynamic subtest: pipe-D-eDP-1
[535.039890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[535.041859] Subtest read-crc-frame-sequence: SUCCESS (4.609s)
[535.894404] [060/131] (484s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[535.991745] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[535.995959] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[536.092316] [061/131] (484s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[536.181860] Starting subtest: primary-yf-tiled-reflect-x-0
[536.245013] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[536.340817] [062/131] (483s left) syncobj_wait (wait-any-snapshot)
[536.398071] Starting subtest: wait-any-snapshot
[536.479017] Subtest wait-any-snapshot: SUCCESS (0.081s)
[536.545739] [063/131] (483s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[536.672780] Starting subtest: cursorA-vs-flipA-varying-size
[547.837245] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.163s)
[548.627543] [064/131] (471s left) gem_exec_reloc (basic-write-read)
[548.681687] Subtest basic-write-read: SKIP (0.000s)
[548.742818] [065/131] (471s left) syncobj_wait (single-wait-all-signaled)
[548.801821] Starting subtest: single-wait-all-signaled
[548.804105] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[548.907067] [066/131] (471s left) gem_exec_schedule (pi-userfault)
[549.095935] Starting subtest: pi-userfault
[549.097821] Starting dynamic subtest: rcs0
[549.103395] Dynamic subtest rcs0: SUCCESS (0.009s)
[549.112021] Starting dynamic subtest: bcs0
[549.114203] Dynamic subtest bcs0: SUCCESS (0.007s)
[549.122682] Starting dynamic subtest: vcs0
[549.124549] Dynamic subtest vcs0: SUCCESS (0.006s)
[549.138093] Starting dynamic subtest: vcs1
[549.140367] Dynamic subtest vcs1: SUCCESS (0.008s)
[549.148448] Starting dynamic subtest: vecs0
[549.150396] Dynamic subtest vecs0: SUCCESS (0.006s)
[549.158418] Starting dynamic subtest: ccs0
[549.160573] Dynamic subtest ccs0: SUCCESS (0.005s)
[549.162438] Subtest pi-userfault: SUCCESS (0.045s)
[549.316859] [067/131] (471s left) gem_exec_schedule (wide)
[549.502157] Starting subtest: wide
[549.504711] Starting dynamic subtest: rcs0
[558.087507] Dynamic subtest rcs0: SUCCESS (8.582s)
[558.096740] Starting dynamic subtest: vcs0
[567.288527] Dynamic subtest vcs0: SUCCESS (9.198s)
[567.297186] Starting dynamic subtest: vcs1
[577.760979] Dynamic subtest vcs1: SUCCESS (10.468s)
[577.770488] Starting dynamic subtest: vecs0
[586.860382] Dynamic subtest vecs0: SUCCESS (9.096s)
[586.869423] Starting dynamic subtest: ccs0
[598.158903] Dynamic subtest ccs0: SUCCESS (11.300s)
[598.161292] Subtest wide: SUCCESS (48.649s)
[599.770803] [068/131] (420s left) gem_mmap_wc (bad-size)
[599.832235] Subtest bad-size: SKIP (0.000s)
[599.891553] [069/131] (420s left) gem_exec_fence (syncobj-channel)
[600.364272] Starting subtest: syncobj-channel
[601.390078] Subtest syncobj-channel: SUCCESS (1.022s)
[602.260761] [070/131] (418s left) kms_psr (pr-cursor-render)
[602.360265] Starting subtest: pr-cursor-render
[602.364380] Subtest pr-cursor-render: SKIP (0.000s)
[602.425941] [071/131] (418s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[602.526508] Starting subtest: fbc-pr-sprite-mmap-cpu
[602.531033] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[602.594794] [072/131] (417s left) kms_flip (basic-flip-vs-modeset)
[602.703497] Starting subtest: basic-flip-vs-modeset
[602.705841] Starting dynamic subtest: A-eDP1
[605.315962] Dynamic subtest A-eDP1: SUCCESS (2.612s)
[605.325117] Starting dynamic subtest: B-eDP1
[607.461455] Dynamic subtest B-eDP1: SUCCESS (2.144s)
[607.471056] Starting dynamic subtest: C-eDP1
[609.611606] Dynamic subtest C-eDP1: SUCCESS (2.151s)
[609.621130] Starting dynamic subtest: D-eDP1
[611.760777] Dynamic subtest D-eDP1: SUCCESS (2.147s)
[611.762670] Subtest basic-flip-vs-modeset: SUCCESS (9.062s)
[612.552134] [073/131] (408s left) kms_psr (psr-primary-mmap-gtt)
[612.650558] Starting subtest: psr-primary-mmap-gtt
[612.652823] Starting dynamic subtest: eDP-1
[614.057163] Dynamic subtest eDP-1: SKIP (1.401s)
[614.062240] Subtest psr-primary-mmap-gtt: SKIP (1.403s)
[614.210474] [074/131] (406s left) kms_atomic (plane-invalid-params)
[614.307142] Starting subtest: plane-invalid-params
[614.308921] Starting dynamic subtest: pipe-A-eDP-1
[614.723500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.417s)
[614.726435] Subtest plane-invalid-params: SUCCESS (0.418s)
[615.512709] [075/131] (405s left) kms_psr (fbc-psr2-sprite-plane-move)
[615.617480] Starting subtest: fbc-psr2-sprite-plane-move
[615.619653] Starting dynamic subtest: eDP-1
[615.623794] Dynamic subtest eDP-1: SKIP (0.000s)
[615.627800] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[615.690483] [076/131] (404s left) gem_ppgtt (blt-vs-render-ctx0)
[615.754833] Starting subtest: blt-vs-render-ctx0
[648.831811] Subtest blt-vs-render-ctx0: SUCCESS (33.077s)
[648.970463] [077/131] (371s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[649.127728] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[650.138354] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.011s)
[650.276168] [078/131] (370s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[650.383506] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[654.462684] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.083s)
[655.610360] [079/131] (365s left) gem_busy (busy)
[655.669632] Starting subtest: busy
[655.672091] Starting dynamic subtest: all-engines
[655.730810] Dynamic subtest all-engines: SUCCESS (0.061s)
[655.740667] Starting dynamic subtest: rcs0
[657.165569] Dynamic subtest rcs0: SUCCESS (1.433s)
[657.175708] Starting dynamic subtest: bcs0
[657.225297] Dynamic subtest bcs0: SUCCESS (0.057s)
[657.234527] Starting dynamic subtest: vcs0
[657.265365] Dynamic subtest vcs0: SUCCESS (0.039s)
[657.273784] Starting dynamic subtest: vcs1
[659.211343] Dynamic subtest vcs1: SUCCESS (1.942s)
[659.220828] Starting dynamic subtest: vecs0
[661.196008] Dynamic subtest vecs0: SUCCESS (1.982s)
[661.206106] Starting dynamic subtest: ccs0
[663.241462] Dynamic subtest ccs0: SUCCESS (2.046s)
[663.243726] Subtest busy: SUCCESS (7.569s)
[663.596042] [080/131] (357s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[663.701347] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[663.703580] Starting dynamic subtest: pipe-A
[663.718397] Dynamic subtest pipe-A: SKIP (0.010s)
[663.729516] Starting dynamic subtest: pipe-B
[663.738785] Dynamic subtest pipe-B: SKIP (0.020s)
[663.747918] Starting dynamic subtest: pipe-C
[663.761763] Dynamic subtest pipe-C: SKIP (0.021s)
[663.771039] Starting dynamic subtest: pipe-D
[663.780273] Dynamic subtest pipe-D: SKIP (0.021s)
[663.784044] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.075s)
[663.893640] [081/131] (356s left) perf_pmu (busy-accuracy-98)
[663.935609] Starting subtest: busy-accuracy-98
[663.937910] Starting dynamic subtest: rcs0
[666.974841] Dynamic subtest rcs0: SUCCESS (3.036s)
[666.987423] Starting dynamic subtest: bcs0
[670.025227] Dynamic subtest bcs0: SUCCESS (3.048s)
[670.036559] Starting dynamic subtest: vcs0
[673.072928] Dynamic subtest vcs0: SUCCESS (3.045s)
[673.084123] Starting dynamic subtest: vcs1
[676.115182] Dynamic subtest vcs1: SUCCESS (3.040s)
[676.125707] Starting dynamic subtest: vecs0
[679.157801] Dynamic subtest vecs0: SUCCESS (3.040s)
[679.169609] Starting dynamic subtest: ccs0
[682.211227] Dynamic subtest ccs0: SUCCESS (3.051s)
[682.213603] Subtest busy-accuracy-98: SUCCESS (18.271s)
[682.318587] [082/131] (338s left) vgem_basic (second-client)
[682.364871] Starting subtest: second-client
[682.386864] Subtest second-client: SUCCESS (0.022s)
[682.437957] [083/131] (338s left) gen9_exec_parse (valid-registers)
[682.503823] Subtest valid-registers: SKIP (0.000s)
[682.586878] [084/131] (338s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[682.690297] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[682.692538] Starting dynamic subtest: pipe-A-eDP-1
[682.716106] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[682.726859] Starting dynamic subtest: pipe-B-eDP-1
[682.748945] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[682.757857] Starting dynamic subtest: pipe-C-eDP-1
[682.779647] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[682.788347] Starting dynamic subtest: pipe-D-eDP-1
[682.810684] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[682.814839] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[684.828330] [085/131] (336s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[689.784028] Starting subtest: fbc-pr-cursor-plane-update-sf
[689.788824] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s)
[690.627061] [086/131] (330s left) syncobj_eventfd (timeline-wait-before-signal)
[690.695595] Starting subtest: timeline-wait-before-signal
[690.726827] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[690.799460] [087/131] (330s left) gem_ctx_sseu (invalid-args)
[690.855661] Subtest invalid-args: SKIP (0.000s)
[690.932098] [088/131] (330s left) kms_setmode (basic)
[690.985937] Starting subtest: basic
[691.317031] Starting dynamic subtest: pipe-A-eDP-1
[693.346557] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.023s)
[693.698619] Starting dynamic subtest: pipe-B-eDP-1
[695.775561] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.080s)
[696.081222] Subtest basic: SUCCESS (5.095s)
[696.906155] [089/131] (324s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[697.007296] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[698.084270] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.077s)
[698.245662] [090/131] (322s left) gem_readwrite (read-bad-handle)
[698.302435] Subtest read-bad-handle: SKIP (0.000s)
[698.362618] [091/131] (322s left) kms_chamelium_edid (dp-edid-read)
[698.746174] Subtest dp-edid-read: SKIP (0.000s)
[699.508979] [092/131] (321s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[699.620669] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[699.625045] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[699.694956] [093/131] (321s left) kms_force_connector_basic (force-edid)
[699.772829] Starting subtest: force-edid
[700.107536] Subtest force-edid: SUCCESS (0.335s)
[700.259611] [094/131] (321s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[700.358247] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[700.362542] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[701.447982] [095/131] (319s left) kms_color (ctm-negative)
[701.537318] Starting subtest: ctm-negative
[701.539577] Starting dynamic subtest: pipe-A-eDP-1
[702.249742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[702.261050] Starting dynamic subtest: pipe-B-eDP-1
[703.592050] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[703.603377] Starting dynamic subtest: pipe-C-eDP-1
[704.964547] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[704.975111] Starting dynamic subtest: pipe-D-eDP-1
[706.255679] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.290s)
[706.257982] Subtest ctm-negative: SUCCESS (4.717s)
[707.051669] [096/131] (314s left) gem_ctx_engines (execute-one)
[707.121645] Starting subtest: execute-one
[709.081644] Subtest execute-one: SUCCESS (1.960s)
[709.316808] [097/131] (312s left) gem_ctx_persistence (legacy-engines-mixed)
[709.378357] Starting subtest: legacy-engines-mixed
[709.380614] Starting dynamic subtest: render
[709.466953] Dynamic subtest render: SUCCESS (0.088s)
[709.479809] Starting dynamic subtest: bsd1
[709.516080] Dynamic subtest bsd1: SUCCESS (0.047s)
[709.525986] Starting dynamic subtest: bsd2
[709.573527] Dynamic subtest bsd2: SUCCESS (0.056s)
[709.583429] Starting dynamic subtest: blt
[709.644775] Dynamic subtest blt: SUCCESS (0.069s)
[709.655991] Starting dynamic subtest: vebox
[709.717765] Dynamic subtest vebox: SUCCESS (0.071s)
[709.720174] Subtest legacy-engines-mixed: SUCCESS (0.340s)
[709.793359] [098/131] (311s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[709.895908] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[709.901014] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[710.002866] [099/131] (311s left) gem_vm_create (invalid-create)
[710.055368] Starting subtest: invalid-create
[710.057661] Subtest invalid-create: SUCCESS (0.002s)
[710.161141] [100/131] (311s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[710.268664] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[710.272176] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[710.363705] [101/131] (311s left) kms_prop_blob (blob-prop-validate)
[710.416536] Starting subtest: blob-prop-validate
[710.418466] Subtest blob-prop-validate: SUCCESS (0.000s)
[710.513977] [102/131] (311s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[710.609479] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[710.613042] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[710.718240] [103/131] (310s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[710.812926] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[710.814858] Starting dynamic subtest: pipe-A-default-mode
[711.102535] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[711.107325] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.283s)
[711.947697] [104/131] (309s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[712.007660] Starting subtest: invalid-multi-wait-unsubmitted
[712.009932] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[712.116836] [105/131] (309s left) kms_async_flips (async-flip-suspend-resume)
[712.219480] Starting subtest: async-flip-suspend-resume
[712.577293] Starting dynamic subtest: pipe-A-eDP-1
[730.125266] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.906s)
[730.509792] Starting dynamic subtest: pipe-B-eDP-1
[733.297125] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.812s)
[733.687078] Starting dynamic subtest: pipe-C-eDP-1
[736.395713] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.726s)
[736.763094] Starting dynamic subtest: pipe-D-eDP-1
[739.485113] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.733s)
[739.487931] Subtest async-flip-suspend-resume: SUCCESS (12.638s)
[740.625516] [106/131] (281s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[740.880862] Starting subtest: parallel-dmabuf-import-out-fence
[742.025697] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.145s)
[742.117618] [107/131] (279s left) perf_pmu (interrupts-sync)
[742.160923] Starting subtest: interrupts-sync
[743.272684] Subtest interrupts-sync: SUCCESS (1.112s)
[743.400739] [108/131] (278s left) gem_exec_whisper (basic-sync)
[743.473299] Starting subtest: basic-sync
[753.772815] Subtest basic-sync: SUCCESS (10.300s)
[753.954726] [109/131] (267s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[754.055846] Starting subtest: fbcpsr-tiling-linear
[760.454894] Subtest fbcpsr-tiling-linear: SUCCESS (6.403s)
[760.624785] [110/131] (261s left) gem_ringfill (basic-all)
[765.818022] Starting subtest: basic-all
[767.004122] Subtest basic-all: SUCCESS (1.185s)
[767.157428] [111/131] (254s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[767.271982] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[767.276950] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[767.353883] [112/131] (254s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[767.450212] Starting subtest: yf-tiled-64bpp-rotate-90
[767.456141] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[767.545791] [113/131] (254s left) perf_pmu (enable-race)
[767.588658] Starting subtest: enable-race
[767.591202] Starting dynamic subtest: rcs0
[780.369017] Dynamic subtest rcs0: SUCCESS (12.781s)
[780.378897] Starting dynamic subtest: bcs0
[793.122191] Dynamic subtest bcs0: SUCCESS (12.752s)
[793.132389] Starting dynamic subtest: vcs0
[808.823264] Dynamic subtest vcs0: SUCCESS (15.700s)
[808.836676] Starting dynamic subtest: vcs1
[824.823036] Dynamic subtest vcs1: SUCCESS (15.998s)
[824.836298] Starting dynamic subtest: vecs0
[840.823684] Dynamic subtest vecs0: SUCCESS (15.996s)
[840.836538] Starting dynamic subtest: ccs0
[853.655541] Dynamic subtest ccs0: SUCCESS (12.830s)
[853.658410] Subtest enable-race: SUCCESS (86.068s)
[853.768302] [114/131] (168s left) gem_exec_reloc (basic-write-read-active)
[853.822189] Subtest basic-write-read-active: SKIP (0.000s)
[853.886792] [115/131] (168s left) kms_busy (extended-modeset-hang-oldfb)
[853.998286] Starting subtest: extended-modeset-hang-oldfb
[854.000700] Starting dynamic subtest: pipe-A
[865.747023] Dynamic subtest pipe-A: SUCCESS (11.747s)
[865.759993] Starting dynamic subtest: pipe-D
[878.044089] Dynamic subtest pipe-D: SUCCESS (12.295s)
[878.046925] Subtest extended-modeset-hang-oldfb: SUCCESS (24.046s)
[878.908713] [116/131] (143s left) syncobj_wait (reset-unsignaled)
[878.974134] Starting subtest: reset-unsignaled
[878.977018] Subtest reset-unsignaled: SUCCESS (0.000s)
[879.063429] [117/131] (143s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[879.173243] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[879.179069] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[879.277092] [118/131] (142s left) gem_lmem_swapping (verify)
[879.321215] Subtest verify: SKIP (0.000s)
[879.362197] [119/131] (142s left) gem_eio (suspend)
[879.561171] Starting subtest: suspend
[891.338421] Subtest suspend: SUCCESS (11.774s)
[891.472646] [120/131] (130s left) kms_properties (invalid-properties-legacy)
[891.571840] Starting subtest: invalid-properties-legacy
[891.673288] Subtest invalid-properties-legacy: SUCCESS (0.101s)
[891.757868] [121/131] (130s left) syncobj_wait (single-wait-all-for-submit-submitted)
[891.823430] Starting subtest: single-wait-all-for-submit-submitted
[891.931732] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[892.002200] [122/131] (130s left) gem_exec_params (invalid-bsd1-flag-on-render)
[892.053179] Starting subtest: invalid-bsd1-flag-on-render
[892.055837] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[892.147679] [123/131] (130s left) kms_psr (fbc-psr-primary-mmap-cpu)
[892.241558] Starting subtest: fbc-psr-primary-mmap-cpu
[892.244017] Starting dynamic subtest: eDP-1
[892.248912] Dynamic subtest eDP-1: SKIP (0.000s)
[892.253674] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[892.306984] [124/131] (130s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[892.411168] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[892.415716] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[892.513632] [125/131] (129s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[892.633985] Starting subtest: cursorA-vs-flipB-atomic
[892.638634] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[892.726697] [126/131] (129s left) gem_softpin (evict-snoop)
[892.790727] Starting subtest: evict-snoop
[892.795765] Subtest evict-snoop: SKIP (0.000s)
[892.920338] [127/131] (129s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[893.015620] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[900.193000] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.181s)
[901.318314] [128/131] (121s left) api_intel_allocator (gem-pool)
[901.387532] Starting subtest: gem-pool
[901.394116] Subtest gem-pool: SUCCESS (0.008s)
[901.532705] [129/131] (121s left) dmabuf_sync_file (import-multiple-read-only)
[901.578208] Starting subtest: import-multiple-read-only
[901.581026] Subtest import-multiple-read-only: SUCCESS (0.003s)
[901.630510] [130/131] (120s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[901.729193] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[901.733977] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[901.805735] [131/131] (120s left) kms_cursor_crc (cursor-random-64x64)
[901.979225] Starting subtest: cursor-random-64x64
[901.981941] Starting dynamic subtest: pipe-A-eDP-1
[905.813784] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.829s)
[905.835848] Starting dynamic subtest: pipe-D-eDP-1
[910.303295] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.475s)
[910.305910] Subtest cursor-random-64x64: SUCCESS (8.324s)
[911.102364] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: prime_self_import
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: prime_busy
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_universal_plane
results: parsing output: 17/ for test: i915_pm_rc6_residency
results: parsing output: 18/ for test: gem_exec_parallel
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: dumb_buffer
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_pm_dc
results: parsing output: 33/ for test: kms_draw_crc
results: parsing output: 34/ for test: gem_sync
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: prime_mmap
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: kms_invalid_mode
results: parsing output: 41/ for test: kms_fbcon_fbt
results: parsing output: 42/ for test: kms_plane_multiple
results: parsing output: 43/ for test: i915_pm_rps
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: i915_query
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: gem_ctx_param
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_bad_reloc
results: parsing output: 58/ for test: kms_pipe_crc_basic
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_mmap_wc
results: parsing output: 68/ for test: gem_exec_fence
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_atomic
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: gem_ppgtt
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_busy
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: gen9_exec_parse
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: syncobj_eventfd
results: parsing output: 86/ for test: gem_ctx_sseu
results: parsing output: 87/ for test: kms_setmode
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_readwrite
results: parsing output: 90/ for test: kms_chamelium_edid
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_force_connector_basic
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: gem_ctx_engines
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_vm_create
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_prop_blob
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_async_flips
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ringfill
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: kms_busy
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_properties
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: api_intel_allocator
results: parsing output: 128/ for test: dmabuf_sync_file
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
Done.