[59.963008] Initializing watchdogs
[59.963053]   /dev/watchdog0
[59.977600] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.982157] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.984303] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.987648] [001/133] (960s left) perf (global-sseu-config-invalid)
[60.144475] Starting subtest: global-sseu-config-invalid
[60.149071] Subtest global-sseu-config-invalid: SKIP (0.000s)
[60.183798] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[60.296577] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[60.300828] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.400821] [003/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[60.514220] Starting subtest: fbcpsr-2p-rte
[60.518506] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[60.621688] [004/133] (959s left) gem_ctx_shared (single-timeline)
[60.673666] Starting subtest: single-timeline
[60.692527] Subtest single-timeline: SUCCESS (0.014s)
[60.921588] [005/133] (959s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[60.988558] Subtest writes-after-reads-snoop: SKIP (0.000s)
[61.068623] [006/133] (959s left) kms_chamelium_frames (hdmi-crc-single)
[62.249750] Subtest hdmi-crc-single: SKIP (0.000s)
[62.552697] [007/133] (958s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[62.617442] Starting subtest: single-wait-for-submit-available-signaled
[62.619749] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[62.718347] [008/133] (958s left) kms_flip (2x-plain-flip-interruptible)
[62.811097] Starting subtest: 2x-plain-flip-interruptible
[62.821648] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[62.902645] [009/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[63.003880] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[63.007839] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[63.086808] [010/133] (957s left) gem_mmap (bad-size)
[63.157069] Subtest bad-size: SKIP (0.000s)
[63.207390] [011/133] (957s left) gem_eio (wait-wedge-10ms)
[63.365106] Starting subtest: wait-wedge-10ms
[64.958939] Subtest wait-wedge-10ms: SUCCESS (1.592s)
[65.123904] [012/133] (955s left) kms_psr (fbc-psr-primary-blt)
[65.211329] Starting subtest: fbc-psr-primary-blt
[65.213456] Starting dynamic subtest: eDP-1
[65.217447] Dynamic subtest eDP-1: SKIP (0.000s)
[65.221311] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[65.282290] [013/133] (955s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[65.379835] Starting subtest: y-tiled-8bpp-rotate-270
[65.384272] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[65.462648] [014/133] (955s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[65.561175] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[65.565399] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[65.669195] [015/133] (955s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[65.727077] Starting subtest: multi-wait-for-submit-submitted-signaled
[65.729374] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[65.837933] [016/133] (955s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[65.915247] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[65.918842] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[65.983721] [017/133] (955s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[66.079262] Starting subtest: pr-cursor-plane-move-continuous-sf
[66.082948] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[66.143878] [018/133] (954s left) gem_exec_balancer (full-pulse)
[66.201357] Starting subtest: full-pulse
[70.773813] Subtest full-pulse: SUCCESS (4.572s)
[71.084548] [019/133] (950s left) kms_prop_blob (blob-prop-core)
[71.146053] Starting subtest: blob-prop-core
[71.148526] Subtest blob-prop-core: SUCCESS (0.000s)
[71.264673] [020/133] (949s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[71.655150] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[72.490742] [021/133] (948s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[72.586621] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[72.591119] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[72.674490] [022/133] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[72.777124] Starting subtest: psr-1p-primscrn-spr-indfb-move
[80.334134] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.562s)
[80.468186] [023/133] (940s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[80.578228] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[80.582961] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[80.664674] [024/133] (940s left) gem_softpin (noreloc-s3)
[80.725837] Starting subtest: noreloc-S3
[99.805836] Subtest noreloc-S3: SUCCESS (5.400s)
[99.947464] [025/133] (921s left) template (b)
[100.015679] Starting subtest: B
[100.018005] Subtest B: SUCCESS (0.000s)
[100.107844] [026/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[100.198229] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[100.202644] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[100.284679] [027/133] (921s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[100.342535] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[100.401236] [028/133] (921s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[100.485409] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[107.691088] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.209s)
[107.802211] [029/133] (913s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[107.860650] Starting subtest: y-tiled-ccs-to-yf-tiled
[107.865605] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[108.046905] [030/133] (913s left) kms_sequence (get-idle)
[108.136318] Starting subtest: get-idle
[108.138744] Starting dynamic subtest: pipe-A-eDP-1
[109.955073] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[109.964564] Starting dynamic subtest: pipe-B-eDP-1
[112.451653] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.497s)
[112.461773] Starting dynamic subtest: pipe-C-eDP-1
[114.877060] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.423s)
[114.888511] Starting dynamic subtest: pipe-D-eDP-1
[117.308063] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.428s)
[117.310444] Subtest get-idle: SUCCESS (9.168s)
[118.116423] [031/133] (903s left) gem_lmem_swapping (basic)
[118.155276] Subtest basic: SKIP (0.000s)
[118.198035] [032/133] (903s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[118.298803] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[118.300974] Starting dynamic subtest: pipe-A
[118.320007] Dynamic subtest pipe-A: SKIP (0.018s)
[118.328863] Starting dynamic subtest: pipe-B
[118.353356] Dynamic subtest pipe-B: SKIP (0.031s)
[118.361981] Starting dynamic subtest: pipe-C
[118.384824] Dynamic subtest pipe-C: SKIP (0.031s)
[118.396103] Starting dynamic subtest: pipe-D
[118.415387] Dynamic subtest pipe-D: SKIP (0.030s)
[118.419483] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.112s)
[118.502091] [033/133] (903s left) sysfs_heartbeat_interval (precise)
[118.559922] Starting subtest: precise
[118.562214] Starting dynamic subtest: vecs0
[126.591695] Dynamic subtest vecs0: SUCCESS (8.028s)
[126.606773] Starting dynamic subtest: ccs0
[127.708888] Dynamic subtest ccs0: SUCCESS (1.117s)
[127.720629] Starting dynamic subtest: vcs0
[135.559470] Dynamic subtest vcs0: SUCCESS (7.848s)
[135.572460] Starting dynamic subtest: bcs0
[136.682887] Dynamic subtest bcs0: SUCCESS (1.124s)
[136.694609] Starting dynamic subtest: rcs0
[137.755743] Dynamic subtest rcs0: SUCCESS (1.073s)
[137.766490] Starting dynamic subtest: vcs1
[145.598913] Dynamic subtest vcs1: SUCCESS (7.840s)
[145.601774] Subtest precise: SUCCESS (27.036s)
[145.673387] [034/133] (876s left) core_auth (getclient-master-drop)
[145.717369] Starting subtest: getclient-master-drop
[145.739288] Subtest getclient-master-drop: SUCCESS (0.020s)
[145.850812] [035/133] (875s left) i915_pm_rps (engine-order)
[145.925895] Starting subtest: engine-order
[150.832707] Subtest engine-order: SUCCESS (4.903s)
[150.965228] [036/133] (870s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[151.023372] Starting subtest: etime-single-wait-all-for-submit-submitted
[151.128924] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[151.224832] [037/133] (870s left) prime_self_import (basic-with_two_bos)
[151.259775] Starting subtest: basic-with_two_bos
[151.288113] Subtest basic-with_two_bos: SUCCESS (0.030s)
[151.395059] [038/133] (870s left) gem_exec_parallel (basic)
[151.459071] Starting subtest: basic
[151.461519] Starting dynamic subtest: rcs0
[152.998790] Dynamic subtest rcs0: SUCCESS (1.539s)
[153.013222] Starting dynamic subtest: bcs0
[154.492257] Dynamic subtest bcs0: SUCCESS (1.492s)
[154.504560] Starting dynamic subtest: vcs0
[156.612924] Dynamic subtest vcs0: SUCCESS (2.118s)
[156.626017] Starting dynamic subtest: vcs1
[158.594498] Dynamic subtest vcs1: SUCCESS (1.980s)
[158.607639] Starting dynamic subtest: vecs0
[160.579673] Dynamic subtest vecs0: SUCCESS (1.983s)
[160.593030] Starting dynamic subtest: ccs0
[162.075889] Dynamic subtest ccs0: SUCCESS (1.496s)
[162.078547] Subtest basic: SUCCESS (10.617s)
[162.259124] [039/133] (859s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[162.360182] Starting subtest: plane-lut1d-pre-ctm3x4
[162.484280] Starting dynamic subtest: pipe-A-plane-0
[162.628565] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[162.638296] Starting dynamic subtest: pipe-A-plane-1
[162.761609] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[162.771525] Starting dynamic subtest: pipe-A-plane-2
[162.906284] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[164.112210] Starting dynamic subtest: pipe-B-plane-0
[164.247771] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[164.257656] Starting dynamic subtest: pipe-B-plane-1
[164.381867] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[164.394029] Starting dynamic subtest: pipe-B-plane-2
[164.525990] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[165.747591] Starting dynamic subtest: pipe-C-plane-0
[165.898132] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s)
[165.909745] Starting dynamic subtest: pipe-C-plane-1
[166.050620] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[166.059866] Starting dynamic subtest: pipe-C-plane-2
[166.216925] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[167.374756] Starting dynamic subtest: pipe-D-plane-0
[167.500209] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[167.510219] Starting dynamic subtest: pipe-D-plane-1
[167.633734] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[167.644044] Starting dynamic subtest: pipe-D-plane-2
[167.778042] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[168.066246] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.704s)
[168.859569] [040/133] (853s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[168.946445] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[168.948621] Starting dynamic subtest: A-eDP1
[172.595115] Dynamic subtest A-eDP1: SUCCESS (3.648s)
[172.605355] Starting dynamic subtest: B-eDP1
[175.802699] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[175.814029] Starting dynamic subtest: C-eDP1
[178.887870] Dynamic subtest C-eDP1: SUCCESS (3.085s)
[178.898401] Starting dynamic subtest: D-eDP1
[181.993756] Dynamic subtest D-eDP1: SUCCESS (3.105s)
[181.996177] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.050s)
[182.794280] [041/133] (839s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[182.892582] Starting subtest: psr-2p-primscrn-spr-indfb-move
[182.897196] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[183.012349] [042/133] (839s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[183.104256] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[183.106625] Starting dynamic subtest: pipe-A-eDP-1
[183.130276] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[183.146348] Starting dynamic subtest: pipe-B-eDP-1
[183.168718] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[183.179543] Starting dynamic subtest: pipe-C-eDP-1
[183.200528] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[183.212226] Starting dynamic subtest: pipe-D-eDP-1
[183.234311] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[183.238842] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[185.277969] [043/133] (836s left) kms_plane_scaling (intel-max-src-size)
[185.367148] Starting subtest: intel-max-src-size
[185.373421] Subtest intel-max-src-size: SKIP (0.000s)
[185.457679] [044/133] (836s left) kms_setmode (basic-clone-single-crtc)
[185.510226] Starting subtest: basic-clone-single-crtc
[185.517431] Subtest basic-clone-single-crtc: SKIP (0.000s)
[185.596414] [045/133] (836s left) syncobj_wait (reset-during-wait-for-submit)
[185.669926] Starting subtest: reset-during-wait-for-submit
[185.775021] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[185.865229] [046/133] (836s left) kms_addfb_basic (invalid-get-prop)
[185.932653] Starting subtest: invalid-get-prop
[185.935008] Subtest invalid-get-prop: SUCCESS (0.000s)
[186.058313] [047/133] (836s left) gem_exec_params (mmapped)
[186.128153] Starting subtest: mmapped
[186.130426] Subtest mmapped: SUCCESS (0.002s)
[186.251308] [048/133] (836s left) core_setmaster (master-drop-set-user)
[186.336820] Starting subtest: master-drop-set-user
[186.351557] Subtest master-drop-set-user: SUCCESS (0.015s)
[186.388112] [049/133] (835s left) perf (non-system-wide-paranoid)
[186.495274] Starting subtest: non-system-wide-paranoid
[186.524083] Subtest non-system-wide-paranoid: SUCCESS (0.029s)
[186.563392] [050/133] (835s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[186.663678] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[187.287785] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.625s)
[187.449309] [051/133] (834s left) gem_create (create-size-update)
[187.502743] Starting subtest: create-size-update
[187.505018] Subtest create-size-update: SUCCESS (0.000s)
[187.710782] [052/133] (834s left) syncobj_timeline (multi-wait-signaled)
[187.765766] Starting subtest: multi-wait-signaled
[187.768020] Subtest multi-wait-signaled: SUCCESS (0.001s)
[187.858876] [053/133] (834s left) kms_dp_link_training (non-uhbr-sst)
[187.949141] Starting subtest: non-uhbr-sst
[187.957933] Subtest non-uhbr-sst: SKIP (0.000s)
[188.017530] [054/133] (834s left) prime_vgem (basic-fence-read)
[188.164792] Starting subtest: basic-fence-read
[188.169979] Subtest basic-fence-read: SKIP (0.005s)
[188.299661] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[188.303361] [055/133] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[188.395682] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[188.399703] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[188.490804] [056/133] (834s left) kms_pm_rpm (system-suspend-modeset)
[190.737406] Starting subtest: system-suspend-modeset
[209.843254] Subtest system-suspend-modeset: SUCCESS (4.327s)
[210.214172] [057/133] (812s left) gem_mmap_offset (clear-via-pagefault)
[210.267800] Starting subtest: clear-via-pagefault
[210.270149] Starting dynamic subtest: smem0
[244.244332] Dynamic subtest smem0: SUCCESS (33.977s)
[244.247083] Subtest clear-via-pagefault: SUCCESS (33.979s)
[244.367343] [058/133] (778s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[244.461908] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[244.464248] Starting dynamic subtest: pipe-A-eDP-1
[244.489459] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.500119] Starting dynamic subtest: pipe-B-eDP-1
[244.526822] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.537357] Starting dynamic subtest: pipe-C-eDP-1
[244.565049] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.574122] Starting dynamic subtest: pipe-D-eDP-1
[244.602532] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.607759] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[246.741601] [059/133] (776s left) gem_userptr_blits (sd-probe)
[246.809301] Starting subtest: sd-probe
[246.811352] Subtest sd-probe: SUCCESS (0.000s)
[246.933784] [060/133] (775s left) gem_exec_store (pages)
[246.997842] Starting subtest: pages
[247.000598] Starting dynamic subtest: rcs0
[247.065169] Dynamic subtest rcs0: SUCCESS (0.070s)
[247.075312] Starting dynamic subtest: bcs0
[247.132557] Dynamic subtest bcs0: SUCCESS (0.065s)
[247.142172] Starting dynamic subtest: vcs0
[247.196829] Dynamic subtest vcs0: SUCCESS (0.064s)
[247.207094] Starting dynamic subtest: vcs1
[248.383387] Dynamic subtest vcs1: SUCCESS (1.182s)
[248.395463] Starting dynamic subtest: vecs0
[248.456998] Dynamic subtest vecs0: SUCCESS (0.070s)
[248.468273] Starting dynamic subtest: ccs0
[248.531591] Dynamic subtest ccs0: SUCCESS (0.076s)
[248.534590] Subtest pages: SUCCESS (1.537s)
[248.711323] [061/133] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[248.809185] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[248.814154] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[248.899221] [062/133] (774s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[249.002317] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[249.007334] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[249.073157] [063/133] (773s left) kms_psr (pr-sprite-mmap-cpu)
[249.165416] Starting subtest: pr-sprite-mmap-cpu
[249.170696] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[249.246239] [064/133] (773s left) prime_mmap (test_userptr)
[249.307386] Starting subtest: test_userptr
[249.310369] Starting dynamic subtest: test_userptr-smem
[249.312810] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[249.315157] Subtest test_userptr: SUCCESS (0.001s)
[249.421712] [065/133] (773s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[251.546867] Starting subtest: dpms-mode-unset-lpsp
[255.601248] Subtest dpms-mode-unset-lpsp: SUCCESS (4.058s)
[255.969081] [066/133] (767s left) api_intel_allocator (two-level-inception)
[256.018269] Starting subtest: two-level-inception
[261.415618] Subtest two-level-inception: SUCCESS (5.399s)
[261.535982] [067/133] (761s left) kms_lease (page-flip-implicit-plane)
[261.636842] Starting subtest: page-flip-implicit-plane
[261.639420] Starting dynamic subtest: pipe-A-eDP-1
[262.119385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.482s)
[262.131592] Starting dynamic subtest: pipe-B-eDP-1
[263.297686] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.175s)
[263.309295] Starting dynamic subtest: pipe-C-eDP-1
[264.411242] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[264.421573] Starting dynamic subtest: pipe-D-eDP-1
[265.538983] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[265.541867] Subtest page-flip-implicit-plane: SUCCESS (3.902s)
[266.380901] [068/133] (756s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[266.513769] Starting subtest: basic-busy-flip-before-cursor-legacy
[266.519423] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[266.661983] [069/133] (756s left) kms_plane (pixel-format-x-tiled-modifier)
[266.771678] Starting subtest: pixel-format-x-tiled-modifier
[266.799695] Starting dynamic subtest: pipe-A-plane-0
[267.499159] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s)
[267.509108] Starting dynamic subtest: pipe-A-plane-3
[267.956016] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[267.966208] Starting dynamic subtest: pipe-A-plane-5
[267.970997] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[269.057041] Starting dynamic subtest: pipe-B-plane-0
[269.737967] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[269.748887] Starting dynamic subtest: pipe-B-plane-3
[270.159874] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s)
[270.172052] Starting dynamic subtest: pipe-B-plane-5
[270.176078] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[270.469155] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.698s)
[271.322052] [070/133] (751s left) kms_plane_lowres (tiling-none)
[271.411029] Starting subtest: tiling-none
[271.413216] Starting dynamic subtest: pipe-A-eDP-1
[271.417993] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.711935] Starting dynamic subtest: pipe-B-eDP-1
[271.716987] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.726934] Starting dynamic subtest: pipe-C-eDP-1
[271.732121] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.741970] Starting dynamic subtest: pipe-D-eDP-1
[271.746707] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.751351] Subtest tiling-none: SKIP (0.299s)
[272.557689] [071/133] (750s left) gem_eio (execbuf)
[272.790563] Starting subtest: execbuf
[273.120708] Subtest execbuf: SUCCESS (0.329s)
[273.236565] [072/133] (750s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[273.343461] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[273.349005] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[273.441110] [073/133] (749s left) gem_ctx_isolation (preservation-s3)
[273.496951] Starting subtest: preservation-S3
[273.499361] Starting dynamic subtest: rcs0
[289.775077] Dynamic subtest rcs0: SUCCESS (1.429s)
[289.786232] Starting dynamic subtest: bcs0
[305.655544] Dynamic subtest bcs0: SUCCESS (1.333s)
[305.670154] Starting dynamic subtest: vcs0
[321.640130] Dynamic subtest vcs0: SUCCESS (3.220s)
[321.651037] Starting dynamic subtest: vcs1
[339.645211] Dynamic subtest vcs1: SUCCESS (4.992s)
[339.655244] Starting dynamic subtest: vecs0
[357.650634] Dynamic subtest vecs0: SUCCESS (4.982s)
[357.662776] Starting dynamic subtest: ccs0
[375.628204] Dynamic subtest ccs0: SUCCESS (3.145s)
[375.630391] Subtest preservation-S3: SUCCESS (19.107s)
[375.864586] [074/133] (647s left) gem_pxp (create-regular-context-2)
[375.999816] Starting subtest: create-regular-context-2
[376.002662] Subtest create-regular-context-2: SUCCESS (0.002s)
[376.129944] [075/133] (647s left) gem_workarounds (basic-read-fd)
[376.209191] Starting subtest: basic-read-fd
[376.221798] Subtest basic-read-fd: SUCCESS (0.012s)
[376.344481] [076/133] (647s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[376.506941] Starting subtest: cursor-rapid-movement-32x10
[376.548706] Subtest cursor-rapid-movement-32x10: SKIP (0.040s)
[376.787025] [077/133] (646s left) syncobj_wait (invalid-reset-bad-pad)
[376.839838] Starting subtest: invalid-reset-bad-pad
[376.841707] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[376.937908] [078/133] (646s left) gem_exec_fence (expired-history)
[377.384139] Starting subtest: expired-history
[384.111073] Subtest expired-history: SUCCESS (6.726s)
[384.871224] [079/133] (638s left) i915_drm_fdinfo (busy)
[384.913902] Starting subtest: busy
[384.916310] Starting dynamic subtest: rcs0
[384.935651] Dynamic subtest rcs0: SKIP (0.021s)
[384.948760] Starting dynamic subtest: bcs0
[384.953265] Dynamic subtest bcs0: SKIP (0.000s)
[384.963668] Starting dynamic subtest: vcs0
[384.968094] Dynamic subtest vcs0: SKIP (0.000s)
[384.977938] Starting dynamic subtest: vcs1
[384.982232] Dynamic subtest vcs1: SKIP (0.000s)
[384.992064] Starting dynamic subtest: vecs0
[384.996533] Dynamic subtest vecs0: SKIP (0.000s)
[385.006547] Starting dynamic subtest: ccs0
[385.010984] Dynamic subtest ccs0: SKIP (0.000s)
[385.015475] Subtest busy: SKIP (0.025s)
[385.056879] [080/133] (638s left) gem_exec_schedule (preempt-contexts)
[385.130982] Starting subtest: preempt-contexts
[385.134454] Starting dynamic subtest: rcs0
[385.207999] Dynamic subtest rcs0: SUCCESS (0.089s)
[385.222796] Starting dynamic subtest: bcs0
[385.283241] Dynamic subtest bcs0: SUCCESS (0.074s)
[385.296218] Starting dynamic subtest: vcs0
[385.334755] Dynamic subtest vcs0: SUCCESS (0.052s)
[385.345630] Starting dynamic subtest: vcs1
[385.401996] Dynamic subtest vcs1: SUCCESS (0.066s)
[385.414150] Starting dynamic subtest: vecs0
[385.465416] Dynamic subtest vecs0: SUCCESS (0.063s)
[385.476253] Starting dynamic subtest: ccs0
[385.552841] Dynamic subtest ccs0: SUCCESS (0.085s)
[385.555436] Subtest preempt-contexts: SUCCESS (0.434s)
[386.482256] [081/133] (637s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[386.574864] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[386.577173] Starting dynamic subtest: pipe-A-eDP-1
[386.599852] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[386.613986] Starting dynamic subtest: pipe-B-eDP-1
[386.635396] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[386.644884] Starting dynamic subtest: pipe-C-eDP-1
[386.666774] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[386.676090] Starting dynamic subtest: pipe-D-eDP-1
[386.697831] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[386.702082] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[388.824720] [082/133] (634s left) kms_invalid_mode (bad-hsync-start)
[388.929198] Starting subtest: bad-hsync-start
[388.931400] Starting dynamic subtest: pipe-A-eDP-1
[389.224971] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[389.236224] Starting dynamic subtest: pipe-B-eDP-1
[389.238417] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[389.248576] Starting dynamic subtest: pipe-C-eDP-1
[389.250844] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[389.260345] Starting dynamic subtest: pipe-D-eDP-1
[389.262618] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[389.264892] Subtest bad-hsync-start: SUCCESS (0.303s)
[390.068027] [083/133] (633s left) syncobj_timeline (multi-wait-all-available-signaled)
[390.111479] Starting subtest: multi-wait-all-available-signaled
[390.113431] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[390.216172] [084/133] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[390.312905] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[390.317376] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[390.412455] [085/133] (633s left) kms_plane_alpha_blend (constant-alpha-min)
[390.510663] Starting subtest: constant-alpha-min
[390.785726] Starting dynamic subtest: pipe-A-eDP-1
[391.506110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[391.516854] Starting dynamic subtest: pipe-D-eDP-1
[392.984816] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.476s)
[392.987195] Subtest constant-alpha-min: SUCCESS (2.474s)
[393.861977] [086/133] (630s left) perf_pmu (busy-idle-no-semaphores)
[393.901419] Starting subtest: busy-idle-no-semaphores
[393.903854] Starting dynamic subtest: rcs0
[394.559739] Dynamic subtest rcs0: SUCCESS (0.658s)
[394.570530] Starting dynamic subtest: bcs0
[395.211633] Dynamic subtest bcs0: SUCCESS (0.650s)
[395.223396] Starting dynamic subtest: vcs0
[395.864029] Dynamic subtest vcs0: SUCCESS (0.650s)
[395.877082] Starting dynamic subtest: vcs1
[396.976507] Dynamic subtest vcs1: SUCCESS (1.109s)
[396.989750] Starting dynamic subtest: vecs0
[399.031339] Dynamic subtest vecs0: SUCCESS (2.051s)
[399.046744] Starting dynamic subtest: ccs0
[400.947036] Dynamic subtest ccs0: SUCCESS (1.910s)
[400.950099] Subtest busy-idle-no-semaphores: SUCCESS (7.045s)
[401.066887] [087/133] (622s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[401.163849] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[402.130092] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.966s)
[402.244108] [088/133] (621s left) kms_async_flips (invalid-async-flip)
[402.330651] Starting subtest: invalid-async-flip
[402.705877] Starting dynamic subtest: pipe-A-eDP-1
[403.557540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s)
[403.924618] Starting dynamic subtest: pipe-B-eDP-1
[404.687594] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.771s)
[405.045545] Starting dynamic subtest: pipe-C-eDP-1
[405.785884] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.749s)
[406.148392] Starting dynamic subtest: pipe-D-eDP-1
[406.924615] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.783s)
[406.927273] Subtest invalid-async-flip: SUCCESS (4.596s)
[408.096985] [089/133] (616s left) gen7_exec_parse (batch-without-end)
[408.168756] Subtest batch-without-end: SKIP (0.000s)
[408.231978] [090/133] (615s left) kms_cursor_crc (cursor-sliding-64x21)
[408.432317] Starting subtest: cursor-sliding-64x21
[408.480177] Subtest cursor-sliding-64x21: SKIP (0.044s)
[408.695085] [091/133] (615s left) kms_async_flips (crc)
[408.784843] Starting subtest: crc
[409.170006] Starting dynamic subtest: pipe-A-eDP-1
[412.115794] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.946s)
[412.511142] Starting dynamic subtest: pipe-B-eDP-1
[415.446299] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.945s)
[415.819015] Starting dynamic subtest: pipe-C-eDP-1
[418.679186] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.869s)
[419.048453] Starting dynamic subtest: pipe-D-eDP-1
[421.891853] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.851s)
[421.894259] Subtest crc: SUCCESS (13.104s)
[423.055244] [092/133] (601s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[423.157477] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[423.161878] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[423.251491] [093/133] (601s left) perf (oa-formats)
[423.354329] Starting subtest: oa-formats
[423.356789] Starting dynamic subtest: 0-rcs0
[423.365789] Dynamic subtest 0-rcs0: SUCCESS (0.012s)
[423.377342] Starting dynamic subtest: 1-vecs0
[423.388942] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[423.391091] Subtest oa-formats: SUCCESS (0.035s)
[423.434548] [094/133] (600s left) syncobj_timeline (32bits-limit)
[423.486931] Starting subtest: 32bits-limit
[423.489153] Subtest 32bits-limit: SUCCESS (0.001s)
[423.609055] [095/133] (600s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[423.710071] Starting subtest: fbc-psr2-primary-mmap-cpu
[423.712394] Starting dynamic subtest: eDP-1
[423.716824] Dynamic subtest eDP-1: SKIP (0.000s)
[423.721176] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[423.786929] [096/133] (600s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[423.875296] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[428.035494] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.163s)
[429.172974] [097/133] (595s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[429.275008] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[433.657478] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.385s)
[434.866101] [098/133] (589s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[434.956904] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[434.961509] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[435.081845] [099/133] (589s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[435.182442] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[438.730353] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.551s)
[439.881627] [100/133] (584s left) kms_big_fb (linear-64bpp-rotate-270)
[439.985743] Starting subtest: linear-64bpp-rotate-270
[440.005040] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[440.120199] [101/133] (584s left) gem_ctx_param (invalid-param-set)
[440.169638] Starting subtest: invalid-param-set
[440.172140] Subtest invalid-param-set: SUCCESS (0.000s)
[440.244921] [102/133] (584s left) kms_rotation_crc (sprite-rotation-90)
[440.329977] Starting subtest: sprite-rotation-90
[440.333986] Subtest sprite-rotation-90: SKIP (0.001s)
[440.405927] [103/133] (584s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[440.527439] Starting subtest: cursorB-vs-flipA-legacy
[440.532035] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[440.682051] [104/133] (584s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[440.783996] Starting subtest: x-tiled-32bpp-rotate-0
[442.151284] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.366s)
[442.298309] [105/133] (582s left) kms_vblank (query-forked-busy)
[442.380198] Starting subtest: query-forked-busy
[442.382022] Starting dynamic subtest: pipe-A-eDP-1
[444.256478] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[444.273697] Starting dynamic subtest: pipe-D-eDP-1
[446.824472] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s)
[446.826402] Subtest query-forked-busy: SUCCESS (4.444s)
[447.628214] [106/133] (577s left) kms_content_protection (uevent)
[447.767689] Starting subtest: uevent
[447.772488] Subtest uevent: SKIP (0.000s)
[447.919499] [107/133] (576s left) syncobj_wait (single-wait-signaled)
[447.972860] Starting subtest: single-wait-signaled
[447.975074] Subtest single-wait-signaled: SUCCESS (0.000s)
[448.068193] [108/133] (576s left) kms_psr2_su (page_flip-p010)
[448.119019] Subtest page_flip-P010: SKIP (0.000s)
[448.186201] [109/133] (576s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[448.745487] Starting subtest: syncobj-stationary-timeline-chain-engines
[448.849104] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.105s)
[450.460127] [110/133] (574s left) kms_getfb (getfb-reject-nv12)
[450.556535] Starting subtest: getfb-reject-nv12
[450.558670] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[450.666888] [111/133] (574s left) kms_dsc (dsc-with-formats)
[450.764104] Starting subtest: dsc-with-formats
[450.804948] Subtest dsc-with-formats: SKIP (0.001s)
[450.879003] [112/133] (574s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[451.008578] Starting subtest: basic-flip-after-cursor-legacy
[451.932896] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.921s)
[452.777861] [113/133] (572s left) gem_exec_reloc (basic-write-wc-active)
[452.845416] Subtest basic-write-wc-active: SKIP (0.000s)
[452.906912] [114/133] (572s left) gem_pxp (reject-modify-context-protection-off-1)
[452.968484] Starting subtest: reject-modify-context-protection-off-1
[452.970846] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[453.071401] [115/133] (572s left) gem_spin_batch (legacy-resubmit-new)
[453.134141] Starting subtest: legacy-resubmit-new
[453.136059] Starting dynamic subtest: default
[453.140473] Dynamic subtest default: SUCCESS (0.008s)
[453.151039] Starting dynamic subtest: render
[453.153258] Dynamic subtest render: SUCCESS (0.003s)
[453.163768] Starting dynamic subtest: bsd
[453.166069] Dynamic subtest bsd: SUCCESS (0.007s)
[453.176248] Starting dynamic subtest: bsd1
[453.178398] Dynamic subtest bsd1: SUCCESS (0.004s)
[453.188387] Starting dynamic subtest: bsd2
[453.190647] Dynamic subtest bsd2: SUCCESS (0.002s)
[453.200217] Starting dynamic subtest: blt
[453.202416] Dynamic subtest blt: SUCCESS (0.004s)
[453.212046] Starting dynamic subtest: vebox
[453.214192] Dynamic subtest vebox: SUCCESS (0.003s)
[453.216365] Subtest legacy-resubmit-new: SUCCESS (0.037s)
[454.447167] [116/133] (570s left) kms_cursor_crc (cursor-offscreen-32x10)
[454.605290] Starting subtest: cursor-offscreen-32x10
[454.655548] Subtest cursor-offscreen-32x10: SKIP (0.046s)
[454.921593] [117/133] (570s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[455.011678] Starting subtest: psr-rgb101010-draw-mmap-gtt
[455.015911] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[455.103692] [118/133] (570s left) kms_psr (psr-primary-page-flip)
[455.207171] Starting subtest: psr-primary-page-flip
[455.209500] Starting dynamic subtest: eDP-1
[456.964065] Dynamic subtest eDP-1: SUCCESS (1.756s)
[456.965959] Subtest psr-primary-page-flip: SUCCESS (1.757s)
[457.834605] [119/133] (567s left) gem_exec_flush (basic-wb-ro-default)
[457.891920] Starting subtest: basic-wb-ro-default
[463.347915] Subtest basic-wb-ro-default: SUCCESS (5.457s)
[463.548648] [120/133] (561s left) prime_busy (before)
[463.636872] Starting subtest: before
[463.639449] Starting dynamic subtest: rcs0
[463.690698] Dynamic subtest rcs0: SUCCESS (0.052s)
[463.702625] Starting dynamic subtest: bcs0
[463.739414] Dynamic subtest bcs0: SUCCESS (0.048s)
[463.749475] Starting dynamic subtest: vcs0
[463.780865] Dynamic subtest vcs0: SUCCESS (0.041s)
[463.790981] Starting dynamic subtest: vcs1
[463.821857] Dynamic subtest vcs1: SUCCESS (0.040s)
[463.831841] Starting dynamic subtest: vecs0
[463.862709] Dynamic subtest vecs0: SUCCESS (0.040s)
[463.872800] Starting dynamic subtest: ccs0
[463.904491] Dynamic subtest ccs0: SUCCESS (0.041s)
[464.014798] Subtest before: SUCCESS (0.379s)
[464.094172] [121/133] (561s left) gem_ctx_persistence (legacy-engines-mixed-process)
[464.153180] Starting subtest: legacy-engines-mixed-process
[464.155505] Starting dynamic subtest: render
[465.355288] Dynamic subtest render: SUCCESS (1.201s)
[465.367606] Starting dynamic subtest: bsd1
[467.381435] Dynamic subtest bsd1: SUCCESS (2.024s)
[467.393599] Starting dynamic subtest: bsd2
[469.408886] Dynamic subtest bsd2: SUCCESS (2.026s)
[469.421496] Starting dynamic subtest: blt
[471.354236] Dynamic subtest blt: SUCCESS (1.941s)
[471.365229] Starting dynamic subtest: vebox
[473.361709] Dynamic subtest vebox: SUCCESS (2.007s)
[473.364239] Subtest legacy-engines-mixed-process: SUCCESS (9.209s)
[473.470542] [122/133] (552s left) kms_flip (absolute-wf_vblank-interruptible)
[473.581595] Starting subtest: absolute-wf_vblank-interruptible
[473.583456] Starting dynamic subtest: A-eDP1
[482.274979] Dynamic subtest A-eDP1: SUCCESS (8.691s)
[482.285682] Starting dynamic subtest: B-eDP1
[491.005500] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[491.017376] Starting dynamic subtest: C-eDP1
[499.733415] Dynamic subtest C-eDP1: SUCCESS (8.726s)
[499.745350] Starting dynamic subtest: D-eDP1
[508.467855] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[508.472567] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.889s)
[509.680235] [123/133] (515s left) gem_busy (parallel)
[509.877202] Starting subtest: parallel
[509.879391] Starting dynamic subtest: rcs0
[511.368601] Dynamic subtest rcs0: SUCCESS (1.492s)
[511.382560] Starting dynamic subtest: bcs0
[513.416415] Dynamic subtest bcs0: SUCCESS (2.045s)
[513.429641] Starting dynamic subtest: vcs0
[515.401160] Dynamic subtest vcs0: SUCCESS (1.982s)
[515.414431] Starting dynamic subtest: vcs1
[517.385319] Dynamic subtest vcs1: SUCCESS (1.981s)
[517.398832] Starting dynamic subtest: vecs0
[519.369472] Dynamic subtest vecs0: SUCCESS (1.981s)
[519.383137] Starting dynamic subtest: ccs0
[521.353999] Dynamic subtest ccs0: SUCCESS (1.981s)
[521.356986] Subtest parallel: SUCCESS (11.481s)
[521.627841] [124/133] (504s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[521.739100] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[526.127510] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.392s)
[527.298736] [125/133] (498s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[527.357477] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[527.460576] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[527.539151] [126/133] (498s left) i915_suspend (fence-restore-untiled)
[527.601822] Starting subtest: fence-restore-untiled
[527.606530] Subtest fence-restore-untiled: SKIP (0.000s)
[527.711591] [127/133] (498s left) kms_addfb_basic (bad-pitch-32)
[527.766810] Starting subtest: bad-pitch-32
[527.769118] Subtest bad-pitch-32: SUCCESS (0.000s)
[527.907549] [128/133] (497s left) i915_getparams_basic (basic-subslice-total)
[527.968191] Starting subtest: basic-subslice-total
[527.972594] Subtest basic-subslice-total: SUCCESS (0.000s)
[528.061630] [129/133] (497s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[528.162893] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[528.164836] Starting dynamic subtest: pipe-A-eDP-1
[544.801958] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.426s)
[544.816552] Starting dynamic subtest: pipe-B-eDP-1
[561.806987] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.446s)
[561.818182] Starting dynamic subtest: pipe-C-eDP-1
[578.768098] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.428s)
[578.779533] Starting dynamic subtest: pipe-D-eDP-1
[595.744362] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.378s)
[595.746695] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.683s)
[596.901800] [130/133] (429s left) kms_psr (psr-cursor-mmap-gtt)
[597.000586] Starting subtest: psr-cursor-mmap-gtt
[597.002934] Starting dynamic subtest: eDP-1
[598.688745] Dynamic subtest eDP-1: SUCCESS (1.684s)
[598.691030] Subtest psr-cursor-mmap-gtt: SUCCESS (1.685s)
[599.573030] [131/133] (426s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[599.671769] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[599.682562] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[599.780180] [132/133] (426s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[599.869350] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[599.871669] Starting dynamic subtest: pipe-A-eDP-1
[599.893576] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[599.907181] Starting dynamic subtest: pipe-B-eDP-1
[599.927723] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[599.938010] Starting dynamic subtest: pipe-C-eDP-1
[599.958808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[599.972779] Starting dynamic subtest: pipe-D-eDP-1
[599.994931] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[599.999003] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[602.043019] [133/133] (424s left) gem_exec_schedule (submit-golden-slice)
[602.122440] Starting subtest: submit-golden-slice
[602.124772] Starting dynamic subtest: rcs0
[602.146883] Dynamic subtest rcs0: SUCCESS (0.033s)
[602.160271] Starting dynamic subtest: bcs0
[602.173880] Dynamic subtest bcs0: SUCCESS (0.026s)
[602.184714] Starting dynamic subtest: vcs0
[602.212173] Dynamic subtest vcs0: SUCCESS (0.037s)
[602.222996] Starting dynamic subtest: vcs1
[602.251297] Dynamic subtest vcs1: SUCCESS (0.038s)
[602.262861] Starting dynamic subtest: vecs0
[602.278455] Dynamic subtest vecs0: SUCCESS (0.026s)
[602.288910] Starting dynamic subtest: ccs0
[602.313858] Dynamic subtest ccs0: SUCCESS (0.035s)
[602.316084] Subtest submit-golden-slice: SUCCESS (0.200s)
[603.383833] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_ctx_shared
results: parsing output: 4/ for test: gem_partial_pwrite_pread
results: parsing output: 5/ for test: kms_chamelium_frames
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: kms_prop_blob
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: template
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_pipe_b_c_ivb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: kms_sequence
results: parsing output: 30/ for test: gem_lmem_swapping
results: parsing output: 31/ for test: kms_plane_scaling
results: parsing output: 32/ for test: sysfs_heartbeat_interval
results: parsing output: 33/ for test: core_auth
results: parsing output: 34/ for test: i915_pm_rps
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: prime_self_import
results: parsing output: 37/ for test: gem_exec_parallel
results: parsing output: 38/ for test: kms_color_pipeline
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_setmode
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_addfb_basic
results: parsing output: 46/ for test: gem_exec_params
results: parsing output: 47/ for test: core_setmaster
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_create
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_dp_link_training
results: parsing output: 53/ for test: prime_vgem
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_exec_store
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: prime_mmap
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: api_intel_allocator
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_plane_lowres
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_isolation
results: parsing output: 73/ for test: gem_pxp
results: parsing output: 74/ for test: gem_workarounds
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_invalid_mode
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_plane_alpha_blend
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: gen7_exec_parse
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: kms_content_protection
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_psr2_su
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: kms_getfb
results: parsing output: 110/ for test: kms_dsc
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_pxp
results: parsing output: 114/ for test: gem_spin_batch
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_exec_flush
results: parsing output: 119/ for test: prime_busy
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_busy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: i915_suspend
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: i915_getparams_basic
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: gem_exec_schedule
Done.