[58.501698] Initializing watchdogs
[58.501743]   /dev/watchdog0
[58.515583] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.519950] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.522196] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.525246] [001/132] (960s left) kms_psr (psr-sprite-mmap-cpu)
[58.650711] Starting subtest: psr-sprite-mmap-cpu
[58.652912] Starting dynamic subtest: eDP-1
[60.368614] Dynamic subtest eDP-1: SUCCESS (1.706s)
[60.371004] Subtest psr-sprite-mmap-cpu: SUCCESS (1.707s)
[61.203979] [002/132] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[61.294390] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[61.296753] Starting dynamic subtest: pipe-A-eDP-1
[61.355822] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[61.363821] Starting dynamic subtest: pipe-B-eDP-1
[61.423489] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[61.431483] Starting dynamic subtest: pipe-C-eDP-1
[61.487530] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[61.497852] Starting dynamic subtest: pipe-D-eDP-1
[61.557223] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[61.562111] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[63.503900] [003/132] (955s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[63.596339] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[63.598823] Starting dynamic subtest: pipe-A-eDP-1
[63.622835] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.631207] Starting dynamic subtest: pipe-B-eDP-1
[63.652122] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.658800] Starting dynamic subtest: pipe-C-eDP-1
[63.679535] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.686318] Starting dynamic subtest: pipe-D-eDP-1
[63.708174] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.712575] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[65.784799] [004/132] (953s left) sw_sync (alloc_merge_fence)
[65.819065] Starting subtest: alloc_merge_fence
[65.820902] Subtest alloc_merge_fence: SUCCESS (0.000s)
[65.866370] [005/132] (953s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[65.991931] Starting subtest: 2x-flip-vs-cursor-legacy
[65.996615] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[66.133028] [006/132] (953s left) prime_mmap (test_map_unmap)
[66.200516] Starting subtest: test_map_unmap
[66.203022] Starting dynamic subtest: test_map_unmap-smem
[66.245228] Dynamic subtest test_map_unmap-smem: SUCCESS (0.047s)
[66.247512] Subtest test_map_unmap: SUCCESS (0.048s)
[66.365501] [007/132] (952s left) kms_setmode (clone-exclusive-crtc)
[66.420971] Starting subtest: clone-exclusive-crtc
[66.427002] Subtest clone-exclusive-crtc: SKIP (0.000s)
[66.523867] [008/132] (952s left) gem_exec_fence (syncobj-timeline-export)
[67.121773] Starting subtest: syncobj-timeline-export
[67.133534] Subtest syncobj-timeline-export: SUCCESS (0.015s)
[69.042029] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[69.044771] [009/132] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[69.146770] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[76.235916] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.083s)
[76.380149] [010/132] (942s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[76.480367] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[76.482773] Starting dynamic subtest: pipe-A-eDP-1
[76.506062] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.515124] Starting dynamic subtest: pipe-B-eDP-1
[76.536418] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[76.543764] Starting dynamic subtest: pipe-C-eDP-1
[76.565605] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[76.572867] Starting dynamic subtest: pipe-D-eDP-1
[76.594962] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.599193] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[78.809961] [011/132] (940s left) perf_pmu (busy-idle-no-semaphores)
[78.850056] Starting subtest: busy-idle-no-semaphores
[78.852454] Starting dynamic subtest: rcs0
[79.516259] Dynamic subtest rcs0: SUCCESS (0.665s)
[79.530195] Starting dynamic subtest: bcs0
[80.170472] Dynamic subtest bcs0: SUCCESS (0.652s)
[80.179751] Starting dynamic subtest: vcs0
[80.821039] Dynamic subtest vcs0: SUCCESS (0.649s)
[80.831108] Starting dynamic subtest: vcs1
[82.496433] Dynamic subtest vcs1: SUCCESS (1.673s)
[82.507671] Starting dynamic subtest: vecs0
[84.544466] Dynamic subtest vecs0: SUCCESS (2.045s)
[84.555894] Starting dynamic subtest: ccs0
[86.527685] Dynamic subtest ccs0: SUCCESS (1.981s)
[86.531060] Subtest busy-idle-no-semaphores: SUCCESS (7.671s)
[86.644467] [012/132] (932s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[86.742899] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[86.745262] Starting dynamic subtest: pipe-A-eDP-1
[86.770451] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[86.779125] Starting dynamic subtest: pipe-B-eDP-1
[86.802526] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[86.809912] Starting dynamic subtest: pipe-C-eDP-1
[86.833404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[86.840200] Starting dynamic subtest: pipe-D-eDP-1
[86.862826] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[86.867044] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[88.908066] [013/132] (930s left) gem_userptr_blits (huge-split)
[88.989635] Starting subtest: huge-split
[88.997773] Subtest huge-split: SUCCESS (0.008s)
[89.115349] [014/132] (930s left) gem_mmap_gtt (basic-read)
[89.179499] Subtest basic-read: SKIP (0.000s)
[89.232899] [015/132] (930s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[89.301297] Starting subtest: x-tiled-to-vebox-yf-tiled
[89.305662] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[89.495724] [016/132] (930s left) kms_3d (basic)
[89.552981] Starting subtest: basic
[91.542376] Subtest basic: SUCCESS (1.990s)
[92.032868] [017/132] (927s left) gem_mmap_wc (read-write)
[92.093055] Subtest read-write: SKIP (0.000s)
[92.165231] [018/132] (927s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[92.261615] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[92.266134] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[92.355601] [019/132] (927s left) gen9_exec_parse (batch-invalid-length)
[92.423464] Subtest batch-invalid-length: SKIP (0.000s)
[92.493132] [020/132] (927s left) kms_cursor_edge_walk (64x64-top-edge)
[92.579846] Starting subtest: 64x64-top-edge
[92.582108] Starting dynamic subtest: pipe-A-eDP-1
[95.996510] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.414s)
[96.005895] Starting dynamic subtest: pipe-D-eDP-1
[99.183290] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.184s)
[99.185574] Subtest 64x64-top-edge: SUCCESS (6.600s)
[100.056236] [021/132] (919s left) kms_chamelium_edid (hdmi-mode-timings)
[100.432553] Subtest hdmi-mode-timings: SKIP (0.000s)
[101.225681] [022/132] (918s left) kms_vblank (query-busy-hang)
[101.321251] Starting subtest: query-busy-hang
[101.323519] Starting dynamic subtest: pipe-A-eDP-1
[127.647366] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.319s)
[127.660845] Starting dynamic subtest: pipe-D-eDP-1
[152.671079] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.019s)
[152.673299] Subtest query-busy-hang: SUCCESS (51.342s)
[153.488454] [023/132] (866s left) gem_exec_reloc (basic-gtt-wc-active)
[153.549375] Subtest basic-gtt-wc-active: SKIP (0.000s)
[153.614426] [024/132] (866s left) syncobj_wait (wait-any-complex)
[153.662732] Starting subtest: wait-any-complex
[153.722366] Subtest wait-any-complex: SUCCESS (0.061s)
[153.797465] [025/132] (866s left) kms_flip (2x-flip-vs-fences)
[153.894763] Starting subtest: 2x-flip-vs-fences
[153.899064] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[153.981212] [026/132] (866s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[154.101150] Starting subtest: cursorA-vs-flipA-varying-size
[165.252344] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.150s)
[166.058970] [027/132] (853s left) kms_flip (2x-flip-vs-modeset)
[166.163426] Starting subtest: 2x-flip-vs-modeset
[166.171252] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[166.255079] [028/132] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[166.356331] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[166.360554] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[166.450542] [029/132] (853s left) gem_exec_reloc (basic-gtt-read-active)
[166.503899] Subtest basic-gtt-read-active: SKIP (0.000s)
[166.570018] [030/132] (853s left) kms_big_fb (yf-tiled-addfb)
[166.669614] Starting subtest: yf-tiled-addfb
[166.674128] Subtest yf-tiled-addfb: SKIP (0.000s)
[166.766267] [031/132] (853s left) kms_big_fb (linear-64bpp-rotate-270)
[166.868250] Starting subtest: linear-64bpp-rotate-270
[166.887525] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[167.002350] [032/132] (853s left) perf (gen8-unprivileged-single-ctx-counters)
[167.128593] Starting subtest: gen8-unprivileged-single-ctx-counters
[167.132440] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[167.172451] [033/132] (853s left) sw_sync (alloc_fence)
[167.212868] Starting subtest: alloc_fence
[167.214512] Subtest alloc_fence: SUCCESS (0.000s)
[167.272455] [034/132] (853s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[167.398986] Starting subtest: cursorB-vs-flipA-toggle
[167.402764] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[167.543382] [035/132] (852s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[167.602725] Starting subtest: single-wait-all-for-submit-unsubmitted
[167.703304] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.100s)
[167.783194] [036/132] (852s left) gem_exec_whisper (basic-sync)
[167.852369] Starting subtest: basic-sync
[174.773884] Subtest basic-sync: SUCCESS (6.919s)
[174.958315] [037/132] (845s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[175.075729] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[175.080031] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[175.147598] [038/132] (845s left) kms_psr (fbc-psr2-suspend)
[175.260172] Starting subtest: fbc-psr2-suspend
[175.262205] Starting dynamic subtest: eDP-1
[175.266435] Dynamic subtest eDP-1: SKIP (0.000s)
[175.270705] Subtest fbc-psr2-suspend: SKIP (0.001s)
[175.331523] [039/132] (845s left) gem_close_race (multigpu-basic-process)
[175.399964] Starting subtest: multigpu-basic-process
[175.404183] Subtest multigpu-basic-process: SKIP (0.000s)
[175.626212] [040/132] (844s left) kms_flip (modeset-vs-vblank-race)
[175.724083] Starting subtest: modeset-vs-vblank-race
[175.726411] Starting dynamic subtest: A-eDP1
[180.446848] Dynamic subtest A-eDP1: SUCCESS (4.722s)
[180.457810] Starting dynamic subtest: B-eDP1
[185.143324] Dynamic subtest B-eDP1: SUCCESS (4.694s)
[185.153648] Starting dynamic subtest: C-eDP1
[189.829638] Dynamic subtest C-eDP1: SUCCESS (4.684s)
[189.840484] Starting dynamic subtest: D-eDP1
[194.523848] Dynamic subtest D-eDP1: SUCCESS (4.692s)
[194.526258] Subtest modeset-vs-vblank-race: SUCCESS (18.802s)
[195.746892] [041/132] (824s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[195.851343] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[199.731685] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.881s)
[200.854382] [042/132] (819s left) kms_invalid_mode (uint-max-clock)
[200.956562] Starting subtest: uint-max-clock
[200.958771] Starting dynamic subtest: pipe-A-eDP-1
[201.240465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[201.249229] Starting dynamic subtest: pipe-B-eDP-1
[201.251419] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[201.258382] Starting dynamic subtest: pipe-C-eDP-1
[201.260777] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[201.268267] Starting dynamic subtest: pipe-D-eDP-1
[201.270623] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[201.272818] Subtest uint-max-clock: SUCCESS (0.290s)
[202.053196] [043/132] (818s left) syncobj_timeline (host-signal-ordered)
[202.108585] Starting subtest: host-signal-ordered
[202.110625] Subtest host-signal-ordered: SUCCESS (0.000s)
[202.191589] [044/132] (818s left) gem_exec_fence (syncobj-timeline-signal)
[202.721773] Starting subtest: syncobj-timeline-signal
[202.724224] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[204.000530] [045/132] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[204.113811] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[213.382743] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.268s)
[213.517175] [046/132] (807s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[213.621336] Starting subtest: yf-tiled-16bpp-rotate-180
[213.625480] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[213.728197] [047/132] (807s left) syncobj_basic (bad-fd-to-handle)
[213.792093] Starting subtest: bad-fd-to-handle
[213.793950] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[213.888736] [048/132] (807s left) gem_exec_schedule (smoketest)
[214.073865] Starting subtest: smoketest
[214.076634] Starting dynamic subtest: rcs0
[219.631802] Dynamic subtest rcs0: SUCCESS (5.510s)
[219.644236] Starting dynamic subtest: bcs0
[225.141734] Dynamic subtest bcs0: SUCCESS (5.506s)
[225.157326] Starting dynamic subtest: vcs0
[230.634272] Dynamic subtest vcs0: SUCCESS (5.496s)
[230.644587] Starting dynamic subtest: vcs1
[236.134617] Dynamic subtest vcs1: SUCCESS (5.496s)
[236.144365] Starting dynamic subtest: vecs0
[241.626140] Dynamic subtest vecs0: SUCCESS (5.493s)
[241.636818] Starting dynamic subtest: ccs0
[247.154553] Dynamic subtest ccs0: SUCCESS (5.521s)
[247.156967] Subtest smoketest: SUCCESS (33.030s)
[247.307879] [049/132] (773s left) kms_pm_backlight (fade)
[247.406153] Starting subtest: fade
[247.453997] Starting dynamic subtest: eDP-1
[250.130153] Dynamic subtest eDP-1: SUCCESS (2.675s)
[250.132572] Subtest fade: SUCCESS (2.726s)
[250.958118] [050/132] (770s left) gem_ctx_param (invalid-set-no-zeromap)
[251.011899] Starting subtest: invalid-set-no-zeromap
[251.014256] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[251.106759] [051/132] (769s left) kms_cursor_crc (cursor-offscreen-256x256)
[251.335040] Starting subtest: cursor-offscreen-256x256
[251.339820] Starting dynamic subtest: pipe-A-eDP-1
[253.290408] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s)
[253.318871] Starting dynamic subtest: pipe-D-eDP-1
[255.950889] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.639s)
[255.953145] Subtest cursor-offscreen-256x256: SUCCESS (4.615s)
[256.756384] [052/132] (764s left) dumb_buffer (map-uaf)
[256.806102] Starting subtest: map-uaf
[256.811143] Subtest map-uaf: SUCCESS (0.005s)
[256.907078] [053/132] (764s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[256.993115] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[256.997650] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[257.063594] [054/132] (764s left) kms_vrr (max-min)
[257.167125] Starting subtest: max-min
[257.173356] Subtest max-min: SKIP (0.000s)
[257.238208] [055/132] (763s left) kms_vblank (query-forked-busy-hang)
[257.332919] Starting subtest: query-forked-busy-hang
[257.335161] Starting dynamic subtest: pipe-A-eDP-1
[283.728527] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.395s)
[283.742476] Starting dynamic subtest: pipe-D-eDP-1
[298.727425] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.993s)
[298.729516] Subtest query-forked-busy-hang: SUCCESS (41.392s)
[299.559455] [056/132] (721s left) kms_flip (nonexisting-fb-interruptible)
[299.654336] Starting subtest: nonexisting-fb-interruptible
[299.656561] Starting dynamic subtest: A-eDP1
[300.805497] Dynamic subtest A-eDP1: SUCCESS (1.150s)
[300.815367] Starting dynamic subtest: B-eDP1
[301.911945] Dynamic subtest B-eDP1: SUCCESS (1.106s)
[301.921080] Starting dynamic subtest: C-eDP1
[303.092730] Dynamic subtest C-eDP1: SUCCESS (1.180s)
[303.100842] Starting dynamic subtest: D-eDP1
[304.199464] Dynamic subtest D-eDP1: SUCCESS (1.105s)
[304.201817] Subtest nonexisting-fb-interruptible: SUCCESS (4.548s)
[305.447518] [057/132] (715s left) gem_lmem_swapping (verify)
[305.492312] Subtest verify: SKIP (0.000s)
[305.531117] [058/132] (715s left) api_intel_bb (full-batch)
[305.580821] Starting subtest: full-batch
[305.585452] Subtest full-batch: SUCCESS (0.005s)
[305.701102] [059/132] (715s left) i915_drm_fdinfo (virtual-busy)
[305.743707] Starting subtest: virtual-busy
[305.747854] Subtest virtual-busy: SKIP (0.000s)
[305.816284] [060/132] (715s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[305.880485] Starting subtest: multi-wait-available-unsubmitted-signaled
[305.882906] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[306.014167] [061/132] (715s left) kms_setmode (basic-clone-single-crtc)
[306.059667] Starting subtest: basic-clone-single-crtc
[306.066329] Subtest basic-clone-single-crtc: SKIP (0.000s)
[306.167927] [062/132] (715s left) kms_color_pipeline (plane-lut1d-lut1d)
[306.259814] Starting subtest: plane-lut1d-lut1d
[306.383813] Starting dynamic subtest: pipe-A-plane-0
[306.549318] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[306.557846] Starting dynamic subtest: pipe-A-plane-1
[306.694126] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[306.701612] Starting dynamic subtest: pipe-A-plane-2
[306.827426] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[307.997484] Starting dynamic subtest: pipe-B-plane-0
[308.191031] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[308.199922] Starting dynamic subtest: pipe-B-plane-1
[308.357862] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[308.366097] Starting dynamic subtest: pipe-B-plane-2
[308.501973] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[309.724089] Starting dynamic subtest: pipe-C-plane-0
[309.862249] Dynamic subtest pipe-C-plane-0: SUCCESS (0.145s)
[309.870544] Starting dynamic subtest: pipe-C-plane-1
[310.005860] Dynamic subtest pipe-C-plane-1: SUCCESS (0.142s)
[310.014246] Starting dynamic subtest: pipe-C-plane-2
[310.150219] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[311.325417] Starting dynamic subtest: pipe-D-plane-0
[311.452343] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[311.460403] Starting dynamic subtest: pipe-D-plane-1
[311.596772] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[311.605193] Starting dynamic subtest: pipe-D-plane-2
[311.730251] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[312.017210] Subtest plane-lut1d-lut1d: SUCCESS (5.756s)
[312.835092] [063/132] (708s left) dmabuf (all-tests)
[312.874552] Starting subtest: all-tests
[312.876816] Starting dynamic subtest: sanitycheck
[313.007580] Dynamic subtest sanitycheck: SUCCESS (0.133s)
[313.019279] Starting dynamic subtest: dma_fence
[313.229960] Dynamic subtest dma_fence: SUCCESS (0.218s)
[313.241311] Starting dynamic subtest: dma_fence_chain
[322.374603] Dynamic subtest dma_fence_chain: SUCCESS (9.142s)
[322.384902] Starting dynamic subtest: dma_fence_unwrap
[322.470536] Dynamic subtest dma_fence_unwrap: SUCCESS (0.094s)
[322.481770] Starting dynamic subtest: dma_resv
[322.552726] Dynamic subtest dma_resv: SUCCESS (0.080s)
[322.555882] Subtest all-tests: SUCCESS (9.680s)
[322.615414] [064/132] (698s left) kms_dsc (dsc-with-formats)
[322.709165] Starting subtest: dsc-with-formats
[322.748885] Subtest dsc-with-formats: SKIP (0.001s)
[322.789159] [065/132] (698s left) i915_module_load (reload-no-display)
[322.826836] Starting subtest: reload-no-display
[328.655066] Subtest reload-no-display: SUCCESS (5.829s)
[328.680712] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[328.681497] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[328.685119] [066/132] (692s left) kms_psr (pr-cursor-blt)
[330.227163] Starting subtest: pr-cursor-blt
[330.231661] Subtest pr-cursor-blt: SKIP (0.000s)
[330.346279] [FACT kms_psr (pr-cursor-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[330.347425] [FACT kms_psr (pr-cursor-blt)] new: kernel.kmod_is_loaded.i915: true
[330.351453] [067/132] (691s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[330.417598] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[330.484387] [068/132] (691s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[330.576487] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[330.580568] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[330.669270] [069/132] (691s left) i915_pm_sseu (full-enable)
[330.729509] Subtest full-enable: SKIP (0.000s)
[330.813811] [070/132] (690s left) gem_exec_balancer (bonded-semaphore)
[330.872160] Starting subtest: bonded-semaphore
[330.876476] Subtest bonded-semaphore: SKIP (0.000s)
[331.169263] [071/132] (690s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[331.297992] Starting subtest: y-tiled-8bpp-rotate-90
[331.302641] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[331.395933] [072/132] (690s left) gem_userptr_blits (sync-unmap)
[331.478861] Starting subtest: sync-unmap
[331.494723] Subtest sync-unmap: SUCCESS (0.017s)
[331.605089] [073/132] (690s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[331.694861] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[331.698966] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[331.776522] [074/132] (690s left) api_intel_bb (add-remove-objects)
[331.827751] Starting subtest: add-remove-objects
[331.836078] Subtest add-remove-objects: SUCCESS (0.010s)
[331.945272] [075/132] (690s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[332.052933] Starting subtest: extended-modeset-hang-oldfb-with-reset
[332.055164] Starting dynamic subtest: pipe-A
[344.036070] Dynamic subtest pipe-A: SUCCESS (11.983s)
[344.052985] Starting dynamic subtest: pipe-D
[356.312665] Dynamic subtest pipe-D: SUCCESS (12.267s)
[356.315047] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.259s)
[357.117015] [076/132] (664s left) gem_exec_reloc (basic-wc-gtt)
[357.182968] Subtest basic-wc-gtt: SKIP (0.000s)
[357.252966] [077/132] (664s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[357.356765] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[361.946061] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.594s)
[363.149187] [078/132] (658s left) kms_pipe_crc_basic (hang-read-crc)
[363.242069] Starting subtest: hang-read-crc
[363.244547] Starting dynamic subtest: pipe-A-eDP-1
[365.324934] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.082s)
[365.334071] Starting dynamic subtest: pipe-B-eDP-1
[368.097823] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[368.111087] Starting dynamic subtest: pipe-C-eDP-1
[370.717239] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.619s)
[370.726437] Starting dynamic subtest: pipe-D-eDP-1
[373.401745] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.685s)
[373.404053] Subtest hang-read-crc: SUCCESS (10.161s)
[374.224583] [079/132] (647s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[374.331835] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[375.317767] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.987s)
[376.169473] [080/132] (646s left) gem_render_copy (y-tiled-ccs-to-linear)
[376.229542] Starting subtest: y-tiled-ccs-to-linear
[376.234104] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[376.415434] [081/132] (645s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[376.476291] Starting subtest: saturated-hostile-nopreempt
[376.478687] Starting dynamic subtest: rcs0
[376.534860] Dynamic subtest rcs0: SKIP (0.056s)
[376.548074] Starting dynamic subtest: bcs0
[376.555051] Dynamic subtest bcs0: SKIP (0.017s)
[376.566615] Starting dynamic subtest: vcs0
[376.574736] Dynamic subtest vcs0: SKIP (0.020s)
[376.582729] Starting dynamic subtest: vcs1
[376.604604] Dynamic subtest vcs1: SKIP (0.028s)
[376.612739] Starting dynamic subtest: vecs0
[376.622571] Dynamic subtest vecs0: SKIP (0.016s)
[376.630576] Starting dynamic subtest: ccs0
[376.641538] Dynamic subtest ccs0: SKIP (0.017s)
[376.645769] Subtest saturated-hostile-nopreempt: SKIP (0.164s)
[376.731645] [082/132] (645s left) kms_atomic_transition (plane-all-transition)
[376.815186] Starting subtest: plane-all-transition
[376.817424] Starting dynamic subtest: pipe-A-eDP-1
[379.308860] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[379.622649] Starting dynamic subtest: pipe-B-eDP-1
[382.819234] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.205s)
[383.117599] Subtest plane-all-transition: SUCCESS (6.303s)
[383.950269] [083/132] (638s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[384.365701] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[385.167475] [084/132] (637s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[385.264101] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[385.285976] Starting dynamic subtest: pipe-A-plane-0
[385.994045] Dynamic subtest pipe-A-plane-0: SUCCESS (0.711s)
[386.002744] Starting dynamic subtest: pipe-A-plane-3
[386.427195] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s)
[387.491652] Starting dynamic subtest: pipe-B-plane-0
[388.185232] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[388.194518] Starting dynamic subtest: pipe-B-plane-3
[388.662680] Dynamic subtest pipe-B-plane-3: SUCCESS (0.477s)
[388.973229] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.708s)
[389.771399] [085/132] (632s left) kms_lease (implicit-plane-lease)
[389.860288] Starting subtest: implicit-plane-lease
[389.862576] Subtest implicit-plane-lease: SUCCESS (0.003s)
[389.960501] [086/132] (632s left) gem_exec_reloc (basic-write-gtt-active)
[390.019346] Subtest basic-write-gtt-active: SKIP (0.000s)
[390.086860] [087/132] (632s left) kms_psr (psr2-primary-mmap-cpu)
[390.174502] Starting subtest: psr2-primary-mmap-cpu
[390.176808] Starting dynamic subtest: eDP-1
[391.893823] Dynamic subtest eDP-1: SUCCESS (1.720s)
[391.896116] Subtest psr2-primary-mmap-cpu: SUCCESS (1.722s)
[392.767533] [088/132] (629s left) gem_exec_schedule (u-submit-late-slice)
[392.836942] Starting subtest: u-submit-late-slice
[392.838959] Starting dynamic subtest: rcs0
[392.875775] Dynamic subtest rcs0: SUCCESS (0.046s)
[392.885376] Starting dynamic subtest: bcs0
[392.913092] Dynamic subtest bcs0: SUCCESS (0.036s)
[392.922398] Starting dynamic subtest: vcs0
[392.946360] Dynamic subtest vcs0: SUCCESS (0.033s)
[392.958476] Starting dynamic subtest: vcs1
[392.978234] Dynamic subtest vcs1: SUCCESS (0.031s)
[392.986769] Starting dynamic subtest: vecs0
[393.010284] Dynamic subtest vecs0: SUCCESS (0.032s)
[393.019050] Starting dynamic subtest: ccs0
[393.053241] Dynamic subtest ccs0: SUCCESS (0.042s)
[393.055856] Subtest u-submit-late-slice: SUCCESS (0.224s)
[394.985867] [089/132] (627s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[395.085176] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[395.096282] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[395.172449] [090/132] (627s left) syncobj_timeline (signal-point-0)
[395.224916] Starting subtest: signal-point-0
[395.227179] Subtest signal-point-0: SUCCESS (0.000s)
[395.322891] [091/132] (627s left) prime_mmap (test_aperture_limit)
[395.390922] Starting subtest: test_aperture_limit
[395.392984] Starting dynamic subtest: test_aperture_limit-smem
[395.401188] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[395.405341] Subtest test_aperture_limit: SKIP (0.008s)
[395.481709] [092/132] (627s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[395.545630] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[395.549814] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[395.727091] [093/132] (626s left) kms_debugfs (display-on-read-all)
[395.839554] Starting subtest: display-on-read-all
[396.005096] Subtest display-on-read-all: SUCCESS (0.166s)
[396.117715] [094/132] (626s left) kms_psr2_su (page_flip-nv12)
[396.173156] Subtest page_flip-NV12: SKIP (0.000s)
[396.231415] [095/132] (626s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[396.355822] Starting subtest: 2x-cursor-vs-flip-atomic
[396.360358] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[396.497417] [096/132] (626s left) kms_draw_crc (fill-fb)
[396.584471] Starting subtest: fill-fb
[397.001428] Subtest fill-fb: SUCCESS (0.419s)
[397.081485] [097/132] (625s left) gem_mmap_gtt (ptrace)
[397.137775] Subtest ptrace: SKIP (0.000s)
[397.206247] [098/132] (625s left) gem_softpin (evict-prime-sanity-check)
[397.265343] Starting subtest: evict-prime-sanity-check
[397.267609] Starting dynamic subtest: rcs0
[398.403719] Dynamic subtest rcs0: SUCCESS (1.138s)
[398.415494] Starting dynamic subtest: bcs0
[399.522751] Dynamic subtest bcs0: SUCCESS (1.118s)
[399.533857] Starting dynamic subtest: vcs0
[400.846280] Dynamic subtest vcs0: SUCCESS (1.320s)
[400.858749] Starting dynamic subtest: vcs1
[402.894569] Dynamic subtest vcs1: SUCCESS (2.046s)
[402.905200] Starting dynamic subtest: vecs0
[404.859331] Dynamic subtest vecs0: SUCCESS (1.962s)
[404.870391] Starting dynamic subtest: ccs0
[406.018204] Dynamic subtest ccs0: SUCCESS (1.158s)
[406.033664] Starting dynamic subtest: all
[407.132450] Dynamic subtest all: SUCCESS (1.111s)
[407.135268] Subtest evict-prime-sanity-check: SUCCESS (9.867s)
[407.223565] [099/132] (615s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[407.338311] Starting subtest: x-tiled-16bpp-rotate-0
[408.605775] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.268s)
[408.702660] [100/132] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[408.799247] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[415.843375] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.045s)
[415.967760] [101/132] (607s left) gem_exec_flush (basic-batch-kernel-default-wb)
[416.024445] Starting subtest: basic-batch-kernel-default-wb
[423.272208] Subtest basic-batch-kernel-default-wb: SUCCESS (7.248s)
[423.459924] [102/132] (599s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[423.562291] Starting subtest: fbc-rgb565-draw-mmap-cpu
[427.592937] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.033s)
[428.785482] [103/132] (594s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[428.878759] Starting subtest: primary-y-tiled-reflect-x-180
[428.938434] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[429.039497] [104/132] (594s left) i915_pm_rpm (debugfs-read)
[431.067610] Starting subtest: debugfs-read
[432.213428] Subtest debugfs-read: SUCCESS (1.147s)
[432.588190] [105/132] (590s left) kms_flip (2x-flip-vs-suspend-interruptible)
[432.685900] Starting subtest: 2x-flip-vs-suspend-interruptible
[432.690393] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[432.782627] [106/132] (590s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[432.868361] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[432.872322] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[432.973764] [107/132] (590s left) gem_exec_fence (basic-await)
[433.140229] Starting subtest: basic-await
[433.142591] Starting dynamic subtest: rcs0
[433.216925] Dynamic subtest rcs0: SUCCESS (0.076s)
[433.227184] Starting dynamic subtest: bcs0
[433.292424] Dynamic subtest bcs0: SUCCESS (0.074s)
[433.303809] Starting dynamic subtest: vcs0
[433.366796] Dynamic subtest vcs0: SUCCESS (0.072s)
[433.377485] Starting dynamic subtest: vcs1
[433.439792] Dynamic subtest vcs1: SUCCESS (0.071s)
[433.451335] Starting dynamic subtest: vecs0
[433.513884] Dynamic subtest vecs0: SUCCESS (0.072s)
[433.526317] Starting dynamic subtest: ccs0
[433.587296] Dynamic subtest ccs0: SUCCESS (0.071s)
[433.589747] Subtest basic-await: SUCCESS (0.448s)
[434.980947] [108/132] (588s left) prime_vgem (wait)
[435.058532] Starting subtest: wait
[435.060867] Starting dynamic subtest: rcs0
[435.100201] Dynamic subtest rcs0: SUCCESS (0.041s)
[435.109296] Starting dynamic subtest: bcs0
[435.166790] Dynamic subtest bcs0: SUCCESS (0.065s)
[435.175462] Starting dynamic subtest: vcs0
[435.210381] Dynamic subtest vcs0: SUCCESS (0.043s)
[435.218762] Starting dynamic subtest: vcs1
[435.258769] Dynamic subtest vcs1: SUCCESS (0.047s)
[435.269915] Starting dynamic subtest: vecs0
[435.304649] Dynamic subtest vecs0: SUCCESS (0.045s)
[435.313756] Starting dynamic subtest: ccs0
[435.356596] Dynamic subtest ccs0: SUCCESS (0.050s)
[435.358963] Subtest wait: SUCCESS (0.298s)
[435.487428] [109/132] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[435.591171] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[442.388813] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.801s)
[442.522915] [110/132] (580s left) gem_exec_flush (basic-uc-ro-default)
[442.594013] Starting subtest: basic-uc-ro-default
[448.054268] Subtest basic-uc-ro-default: SUCCESS (5.460s)
[448.237916] [111/132] (575s left) kms_psr (fbc-psr2-dpms)
[448.322119] Starting subtest: fbc-psr2-dpms
[448.324361] Starting dynamic subtest: eDP-1
[448.328436] Dynamic subtest eDP-1: SKIP (0.000s)
[448.332511] Subtest fbc-psr2-dpms: SKIP (0.001s)
[448.409255] [112/132] (575s left) kms_atomic_transition (modeset-transition-fencing)
[448.519917] Starting subtest: modeset-transition-fencing
[448.522237] Starting dynamic subtest: 1x-outputs
[459.374831] Dynamic subtest 1x-outputs: SUCCESS (10.855s)
[459.377469] Subtest modeset-transition-fencing: SUCCESS (10.857s)
[460.244604] [113/132] (563s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[460.357930] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[467.696312] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.341s)
[467.826516] [114/132] (555s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[467.918077] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[467.920229] Starting dynamic subtest: pipe-A
[467.980983] Dynamic subtest pipe-A: SUCCESS (0.064s)
[467.991527] Starting dynamic subtest: pipe-B
[469.103460] Dynamic subtest pipe-B: SUCCESS (1.121s)
[469.115231] Starting dynamic subtest: pipe-C
[470.214632] Dynamic subtest pipe-C: SUCCESS (1.109s)
[470.223799] Starting dynamic subtest: pipe-D
[471.339121] Dynamic subtest pipe-D: SUCCESS (1.124s)
[471.341579] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.423s)
[472.495122] [115/132] (551s left) gem_pxp (create-regular-buffer)
[472.609167] Starting subtest: create-regular-buffer
[472.611303] Subtest create-regular-buffer: SUCCESS (0.000s)
[472.736324] [116/132] (550s left) syncobj_wait (wait-all-complex)
[472.787668] Starting subtest: wait-all-complex
[473.000337] Subtest wait-all-complex: SUCCESS (0.212s)
[473.071427] [117/132] (550s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[473.163297] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[473.165483] Starting dynamic subtest: pipe-A-eDP-1
[473.187738] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[473.198170] Starting dynamic subtest: pipe-B-eDP-1
[473.219558] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[473.228153] Starting dynamic subtest: pipe-C-eDP-1
[473.249714] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[473.259706] Starting dynamic subtest: pipe-D-eDP-1
[473.281113] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[473.285130] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[475.450112] [118/132] (548s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[475.576473] Starting subtest: 2x-long-cursor-vs-flip-legacy
[475.580857] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[475.722190] [119/132] (548s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[475.813856] Starting subtest: 4-tiled-8bpp-rotate-180
[477.027138] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.214s)
[477.149229] [120/132] (546s left) gem_exec_params (rsvd2-dirt)
[477.212452] Starting subtest: rsvd2-dirt
[477.215916] Subtest rsvd2-dirt: SKIP (0.000s)
[477.309085] [121/132] (546s left) syncobj_timeline (32bits-limit)
[477.367097] Starting subtest: 32bits-limit
[477.368975] Subtest 32bits-limit: SUCCESS (0.001s)
[477.468673] [122/132] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[477.557847] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[477.561272] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[477.658444] [123/132] (546s left) syncobj_timeline (invalid-wait-bad-flags)
[477.713886] Starting subtest: invalid-wait-bad-flags
[477.715881] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[477.803886] [124/132] (546s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[477.902904] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[477.904938] Starting dynamic subtest: pipe-A
[477.925238] Dynamic subtest pipe-A: SKIP (0.016s)
[477.935070] Starting dynamic subtest: pipe-B
[477.954286] Dynamic subtest pipe-B: SKIP (0.030s)
[477.963146] Starting dynamic subtest: pipe-C
[477.985176] Dynamic subtest pipe-C: SKIP (0.030s)
[477.993608] Starting dynamic subtest: pipe-D
[478.015729] Dynamic subtest pipe-D: SKIP (0.030s)
[478.019194] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.109s)
[478.114117] [125/132] (545s left) kms_content_protection (type1)
[478.259560] Starting subtest: type1
[478.263562] Subtest type1: SKIP (0.000s)
[478.397557] [126/132] (545s left) kms_getfb (getfb2-into-addfb2)
[478.483605] Starting subtest: getfb2-into-addfb2
[478.485594] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[478.603953] [127/132] (545s left) gem_exec_schedule (manyslice)
[478.673575] Starting subtest: manyslice
[478.675246] Starting dynamic subtest: rcs0
[484.314205] Dynamic subtest rcs0: SUCCESS (5.646s)
[484.328551] Starting dynamic subtest: bcs0
[490.945997] Dynamic subtest bcs0: SUCCESS (6.629s)
[490.959630] Starting dynamic subtest: vcs0
[497.026495] Dynamic subtest vcs0: SUCCESS (6.077s)
[497.039884] Starting dynamic subtest: vcs1
[502.608993] Dynamic subtest vcs1: SUCCESS (5.581s)
[502.621068] Starting dynamic subtest: vecs0
[508.188321] Dynamic subtest vecs0: SUCCESS (5.576s)
[508.202370] Starting dynamic subtest: ccs0
[514.884507] Dynamic subtest ccs0: SUCCESS (6.693s)
[514.887095] Subtest manyslice: SUCCESS (36.215s)
[515.199654] [128/132] (508s left) sysfs_heartbeat_interval (idempotent)
[515.255775] Starting subtest: idempotent
[515.258191] Starting dynamic subtest: vecs0
[515.260719] Dynamic subtest vecs0: SUCCESS (0.001s)
[515.272447] Starting dynamic subtest: ccs0
[515.274349] Dynamic subtest ccs0: SUCCESS (0.002s)
[515.282650] Starting dynamic subtest: vcs0
[515.284579] Dynamic subtest vcs0: SUCCESS (0.000s)
[515.292575] Starting dynamic subtest: bcs0
[515.294473] Dynamic subtest bcs0: SUCCESS (0.001s)
[515.303842] Starting dynamic subtest: rcs0
[515.306045] Dynamic subtest rcs0: SUCCESS (0.001s)
[515.314087] Starting dynamic subtest: vcs1
[515.316299] Dynamic subtest vcs1: SUCCESS (0.000s)
[515.318173] Subtest idempotent: SUCCESS (0.010s)
[515.372519] [129/132] (508s left) gem_ctx_shared (q-smoketest-all)
[515.449096] Starting subtest: Q-smoketest-all
[547.830915] Subtest Q-smoketest-all: SUCCESS (32.328s)
[548.934397] [130/132] (475s left) kms_cursor_crc (cursor-random-max-size)
[549.267772] Starting subtest: cursor-random-max-size
[549.274292] Subtest cursor-random-max-size: SKIP (0.000s)
[549.416813] [131/132] (474s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[549.515264] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[549.519498] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[549.590604] [132/132] (474s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[549.684548] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[556.412247] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.731s)
[556.538064] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: sw_sync
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: prime_mmap
results: parsing output: 6/ for test: kms_setmode
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_3d
results: parsing output: 16/ for test: gem_mmap_wc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gen9_exec_parse
results: parsing output: 19/ for test: kms_cursor_edge_walk
results: parsing output: 20/ for test: kms_chamelium_edid
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: gem_close_race
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_invalid_mode
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: syncobj_basic
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_pm_backlight
results: parsing output: 49/ for test: gem_ctx_param
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: dumb_buffer
results: parsing output: 52/ for test: kms_plane
results: parsing output: 53/ for test: kms_vrr
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_setmode
results: parsing output: 61/ for test: kms_color_pipeline
results: parsing output: 62/ for test: dmabuf
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: i915_module_load
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_fenced_exec_thrash
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_pm_sseu
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: kms_busy
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pipe_crc_basic
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_atomic_transition
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: kms_lease
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_debugfs
results: parsing output: 93/ for test: kms_psr2_su
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_draw_crc
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: gem_softpin
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_flush
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: i915_pm_rpm
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_atomic_transition
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: gem_pxp
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: kms_getfb
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: sysfs_heartbeat_interval
results: parsing output: 128/ for test: gem_ctx_shared
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.