[56.726806] Initializing watchdogs
[56.726854]   /dev/watchdog0
[56.741846] [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]
[56.746371] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.749083] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.752642] [001/133] (960s left) gem_softpin (reverse)
[56.837932] Starting subtest: reverse
[56.844442] Subtest reverse: SUCCESS (0.009s)
[56.987395] [002/133] (960s left) kms_addfb_basic (bo-too-small)
[57.089915] Starting subtest: bo-too-small
[57.092119] Subtest bo-too-small: SUCCESS (0.000s)
[57.186291] [003/133] (960s left) gem_exec_capture (pi)
[57.264510] Starting subtest: pi
[57.267041] Starting dynamic subtest: rcs0
[61.568579] Dynamic subtest rcs0: SUCCESS (4.281s)
[61.578984] Starting dynamic subtest: bcs0
[65.486523] Dynamic subtest bcs0: SUCCESS (3.905s)
[65.494574] Starting dynamic subtest: vcs0
[69.422022] Dynamic subtest vcs0: SUCCESS (3.927s)
[69.432458] Starting dynamic subtest: vcs1
[73.294251] Dynamic subtest vcs1: SUCCESS (3.866s)
[73.304797] Starting dynamic subtest: vecs0
[77.227148] Dynamic subtest vecs0: SUCCESS (3.930s)
[77.238033] Starting dynamic subtest: ccs0
[81.168915] Dynamic subtest ccs0: SUCCESS (3.939s)
[81.171652] Subtest pi: SUCCESS (23.851s)
[81.250538] [004/133] (936s left) kms_psr (fbc-psr-sprite-render)
[81.397995] Starting subtest: fbc-psr-sprite-render
[81.400425] Starting dynamic subtest: eDP-1
[81.404923] Dynamic subtest eDP-1: SKIP (0.000s)
[81.409438] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[81.475816] [005/133] (935s left) gem_exec_reloc (basic-cpu-noreloc)
[81.542538] Subtest basic-cpu-noreloc: SKIP (0.000s)
[81.624417] [006/133] (935s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[81.722839] Starting subtest: plane-upscale-20x20-with-modifiers
[81.725156] Starting dynamic subtest: pipe-A
[82.069335] Dynamic subtest pipe-A: SUCCESS (0.348s)
[82.077210] Starting dynamic subtest: pipe-B
[83.532574] Dynamic subtest pipe-B: SUCCESS (1.462s)
[83.540548] Starting dynamic subtest: pipe-C
[84.979148] Dynamic subtest pipe-C: SUCCESS (1.446s)
[84.988928] Starting dynamic subtest: pipe-D
[86.409712] Dynamic subtest pipe-D: SUCCESS (1.430s)
[86.412175] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.689s)
[87.577601] [007/133] (929s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[87.679489] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[87.684047] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[88.808979] [008/133] (928s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[88.913581] Starting subtest: x-tiled-16bpp-rotate-90
[88.933121] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[89.044124] [009/133] (928s left) syncobj_timeline (invalid-signal-zero-handles)
[89.109321] Starting subtest: invalid-signal-zero-handles
[89.111737] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[89.221043] [010/133] (928s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[89.317082] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[89.319261] Starting dynamic subtest: pipe-A-eDP-1
[90.238165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.916s)
[90.247553] Starting dynamic subtest: pipe-B-eDP-1
[91.797885] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.557s)
[91.806888] Starting dynamic subtest: pipe-C-eDP-1
[93.369112] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.569s)
[93.378941] Starting dynamic subtest: pipe-D-eDP-1
[94.870443] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.503s)
[94.872436] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.548s)
[96.037881] [011/133] (921s left) gem_tiled_blits (basic)
[96.096241] Subtest basic: SKIP (0.000s)
[96.162979] [012/133] (921s left) gem_partial_pwrite_pread (reads)
[96.224170] Subtest reads: SKIP (0.000s)
[96.285750] [013/133] (921s left) gem_exec_reloc (basic-write-read-noreloc)
[96.342055] Subtest basic-write-read-noreloc: SKIP (0.000s)
[96.413194] [014/133] (921s left) gem_eio (in-flight-immediate)
[96.613197] Starting subtest: in-flight-immediate
[104.844190] Subtest in-flight-immediate: SUCCESS (8.231s)
[105.012833] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[105.015955] [015/133] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[105.111560] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[105.115573] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[105.203534] [016/133] (912s left) sw_sync (timeline_closed_signaled)
[105.238396] Starting subtest: timeline_closed_signaled
[105.240271] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[105.287244] [017/133] (912s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[105.385836] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[114.041403] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.661s)
[114.146467] [018/133] (903s left) gem_ctx_persistence (heartbeat-hostile)
[114.219903] Starting subtest: heartbeat-hostile
[114.224765] Subtest heartbeat-hostile: SKIP (0.000s)
[114.331476] [019/133] (903s left) sw_sync (sync_merge_same)
[114.366677] Starting subtest: sync_merge_same
[114.368881] Subtest sync_merge_same: SUCCESS (0.000s)
[114.420220] [020/133] (903s left) gem_mmap_gtt (big-bo-tiledy)
[114.476184] Subtest big-bo-tiledY: SKIP (0.000s)
[114.533030] [021/133] (903s left) gem_workarounds (basic-read-context)
[114.591984] Starting subtest: basic-read-context
[114.600930] Subtest basic-read-context: SUCCESS (0.011s)
[114.733733] [022/133] (903s left) kms_psr2_su (page_flip-xrgb8888)
[114.793511] Subtest page_flip-XRGB8888: SKIP (0.000s)
[114.862262] [023/133] (903s left) gem_exec_params (mmapped)
[114.920911] Starting subtest: mmapped
[114.923208] Subtest mmapped: SUCCESS (0.003s)
[115.062058] [024/133] (903s left) kms_plane_lowres (tiling-4)
[115.153567] Starting subtest: tiling-4
[115.155561] Starting dynamic subtest: pipe-A-eDP-1
[115.159378] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[115.462316] Starting dynamic subtest: pipe-B-eDP-1
[115.467265] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[115.478326] Starting dynamic subtest: pipe-C-eDP-1
[115.482773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[115.491094] Starting dynamic subtest: pipe-D-eDP-1
[115.495456] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[115.499640] Subtest tiling-4: SKIP (0.305s)
[116.324450] [025/133] (901s left) gem_mmap_gtt (pf-nonblock)
[116.378666] Subtest pf-nonblock: SKIP (0.000s)
[116.437695] [026/133] (901s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[116.489368] Starting subtest: wait-all-for-submit-delayed-submit
[116.592402] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[116.671598] [027/133] (901s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[116.766761] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[116.769048] Starting dynamic subtest: pipe-A-eDP-1
[116.791047] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[116.805559] Starting dynamic subtest: pipe-B-eDP-1
[116.826348] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[116.838731] Starting dynamic subtest: pipe-C-eDP-1
[116.860138] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[116.870167] Starting dynamic subtest: pipe-D-eDP-1
[116.891887] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[116.896307] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[119.074964] [028/133] (899s left) i915_query (test-query-geometry-subslices)
[119.143387] Starting subtest: test-query-geometry-subslices
[119.145721] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[119.242105] [029/133] (899s left) prime_vgem (basic-fence-blt)
[119.340668] Starting subtest: basic-fence-blt
[119.418834] Subtest basic-fence-blt: SUCCESS (0.078s)
[119.541869] [030/133] (898s left) sw_sync (sync_multi_producer_single_consumer)
[119.580159] Starting subtest: sync_multi_producer_single_consumer
[120.655199] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[120.732704] [031/133] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[120.837449] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[120.842085] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[120.942749] [032/133] (897s left) gen9_exec_parse (basic-rejected)
[121.000135] Subtest basic-rejected: SKIP (0.000s)
[121.065627] [033/133] (897s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[121.119330] Starting subtest: y-tiled-ccs-to-x-tiled
[121.123765] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[121.306096] [034/133] (897s left) gem_mmap_gtt (basic-short)
[121.363898] Subtest basic-short: SKIP (0.000s)
[121.424902] [035/133] (897s left) kms_pm_dc (dc3co-vpb-simulation)
[122.533799] Starting subtest: dc3co-vpb-simulation
[131.757028] Subtest dc3co-vpb-simulation: SKIP (9.220s)
[131.888961] [036/133] (886s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[132.436532] Starting subtest: syncobj-timeline-invalid-flags
[132.438885] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[134.346943] [037/133] (884s left) kms_psr (fbc-psr-primary-page-flip)
[134.434049] Starting subtest: fbc-psr-primary-page-flip
[134.436318] Starting dynamic subtest: eDP-1
[134.440372] Dynamic subtest eDP-1: SKIP (0.000s)
[134.444528] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[134.508943] [038/133] (884s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[134.568819] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[134.571097] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[134.661383] [039/133] (884s left) gem_busy (close-race)
[134.711761] Starting subtest: close-race
[158.269475] Subtest close-race: SUCCESS (23.556s)
[158.636075] [040/133] (860s left) gem_pread (self)
[158.721696] Subtest self: SKIP (0.000s)
[158.784417] [041/133] (860s left) gem_exec_schedule (preempt-user)
[158.877809] Starting subtest: preempt-user
[158.879749] Starting dynamic subtest: rcs0
[158.910509] Dynamic subtest rcs0: SUCCESS (0.036s)
[158.919808] Starting dynamic subtest: bcs0
[158.945055] Dynamic subtest bcs0: SUCCESS (0.034s)
[158.953912] Starting dynamic subtest: vcs0
[159.002198] Dynamic subtest vcs0: SUCCESS (0.055s)
[159.011888] Starting dynamic subtest: vcs1
[159.032177] Dynamic subtest vcs1: SUCCESS (0.030s)
[159.043303] Starting dynamic subtest: vecs0
[159.061943] Dynamic subtest vecs0: SUCCESS (0.029s)
[159.071817] Starting dynamic subtest: ccs0
[159.095244] Dynamic subtest ccs0: SUCCESS (0.033s)
[159.097492] Subtest preempt-user: SUCCESS (0.221s)
[160.320815] [042/133] (858s left) i915_drm_fdinfo (memory-info-active)
[160.358768] Starting subtest: memory-info-active
[160.361107] Starting dynamic subtest: smem0
[163.270579] Dynamic subtest smem0: SUCCESS (2.913s)
[163.273293] Subtest memory-info-active: SUCCESS (2.914s)
[163.346591] [043/133] (855s left) gem_lmem_swapping (parallel-random-verify)
[163.395584] Subtest parallel-random-verify: SKIP (0.000s)
[163.441967] [044/133] (855s left) gem_tiled_pread_basic (basic)
[163.493092] Subtest basic: SKIP (0.000s)
[163.559820] [045/133] (855s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[163.702389] Starting subtest: cursorA-vs-flipA-atomic
[174.884113] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.182s)
[175.690090] [046/133] (843s left) kms_getfb (getfb-handle-zero)
[175.776356] Starting subtest: getfb-handle-zero
[175.778650] Subtest getfb-handle-zero: SUCCESS (0.000s)
[175.907461] [047/133] (843s left) gem_exec_balancer (full)
[175.989122] Starting subtest: full
[181.158264] Subtest full: SUCCESS (5.169s)
[181.481419] [048/133] (837s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[181.866488] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[182.702722] [049/133] (836s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[182.811615] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[182.816095] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[182.915018] [050/133] (836s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[183.041190] Starting subtest: verify-pxp-stale-buf-optout-execution
[184.101167] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.061s)
[184.243853] [051/133] (835s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[184.346239] Starting subtest: primary-yf-tiled-reflect-x-270
[184.350699] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[184.418662] [052/133] (834s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[184.530745] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[185.366358] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s)
[185.529740] [053/133] (833s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[185.583284] Starting subtest: y-tiled-ccs-to-yf-tiled
[185.587814] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[185.769451] [054/133] (833s left) api_intel_bb (purge-bb)
[185.830883] Starting subtest: purge-bb
[185.833097] Subtest purge-bb: SUCCESS (0.004s)
[185.950581] [055/133] (833s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[186.044426] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[186.048811] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[186.153996] [056/133] (833s left) kms_frontbuffer_tracking (fbc-1p-rte)
[186.256625] Starting subtest: fbc-1p-rte
[191.698371] Subtest fbc-1p-rte: SUCCESS (5.446s)
[192.834990] [057/133] (826s left) kms_pipe_crc_basic (bad-source)
[192.929970] Starting subtest: bad-source
[192.932194] Subtest bad-source: SUCCESS (0.000s)
[193.003320] [058/133] (826s left) gem_close (many-handles-one-vma)
[193.075686] Starting subtest: many-handles-one-vma
[193.101357] Subtest many-handles-one-vma: SUCCESS (0.028s)
[193.230021] [059/133] (826s left) gem_ctx_persistence (engines-cleanup)
[193.285632] Starting subtest: engines-cleanup
[193.287929] Starting dynamic subtest: rcs0
[193.348578] Dynamic subtest rcs0: SUCCESS (0.063s)
[193.368722] Starting dynamic subtest: bcs0
[193.371313] Dynamic subtest bcs0: SUCCESS (0.020s)
[193.384415] Starting dynamic subtest: vcs0
[193.432658] Dynamic subtest vcs0: SUCCESS (0.063s)
[193.444275] Starting dynamic subtest: vcs1
[193.478472] Dynamic subtest vcs1: SUCCESS (0.044s)
[193.491846] Starting dynamic subtest: vecs0
[193.530561] Dynamic subtest vecs0: SUCCESS (0.050s)
[193.543387] Starting dynamic subtest: ccs0
[193.554412] Dynamic subtest ccs0: SUCCESS (0.023s)
[193.557095] Subtest engines-cleanup: SUCCESS (0.269s)
[193.673299] [060/133] (825s left) kms_cursor_crc (cursor-offscreen-128x42)
[193.949472] Starting subtest: cursor-offscreen-128x42
[193.997860] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[194.227909] [061/133] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[194.333391] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[194.337061] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[194.462745] [062/133] (825s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[194.563545] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[194.589057] Starting dynamic subtest: pipe-A-plane-0
[194.910822] Dynamic subtest pipe-A-plane-0: SUCCESS (0.322s)
[194.925677] Starting dynamic subtest: pipe-A-plane-3
[195.167194] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[196.300786] Starting dynamic subtest: pipe-B-plane-0
[196.591850] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[196.601488] Starting dynamic subtest: pipe-B-plane-3
[196.838152] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[197.158442] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.597s)
[197.992458] [063/133] (821s left) gem_userptr_blits (unsync-unmap-cycles)
[198.059920] Subtest unsync-unmap-cycles: SKIP (0.000s)
[198.171998] [064/133] (821s left) kms_debugfs (display-off-read-all)
[198.275134] Starting subtest: display-off-read-all
[198.562548] Subtest display-off-read-all: SUCCESS (0.290s)
[199.408718] [065/133] (820s left) kms_flip (flip-vs-absolute-wf_vblank)
[199.510389] Starting subtest: flip-vs-absolute-wf_vblank
[199.512578] Starting dynamic subtest: A-eDP1
[208.454187] Dynamic subtest A-eDP1: SUCCESS (8.945s)
[208.465512] Starting dynamic subtest: B-eDP1
[217.388294] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[217.400215] Starting dynamic subtest: C-eDP1
[226.306586] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[226.321094] Starting dynamic subtest: D-eDP1
[235.226691] Dynamic subtest D-eDP1: SUCCESS (8.918s)
[235.229091] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.721s)
[236.442449] [066/133] (783s left) gem_blits (basic)
[236.510575] Starting subtest: basic
[237.984858] Subtest basic: SUCCESS (1.474s)
[238.091529] [067/133] (781s left) kms_flip (2x-flip-vs-suspend)
[238.179060] Starting subtest: 2x-flip-vs-suspend
[238.183307] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[238.284166] [068/133] (781s left) gem_workarounds (basic-read-fd)
[238.351064] Starting subtest: basic-read-fd
[238.362264] Subtest basic-read-fd: SUCCESS (0.011s)
[238.475487] [069/133] (781s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[238.577362] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[242.831696] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.257s)
[243.955339] [070/133] (776s left) device_reset (unbind-cold-reset-rebind)
[243.998294] Starting subtest: unbind-cold-reset-rebind
[244.002966] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[244.096723] [071/133] (776s left) kms_flip (absolute-wf_vblank)
[244.214238] Starting subtest: absolute-wf_vblank
[244.216117] Starting dynamic subtest: A-eDP1
[252.997043] Dynamic subtest A-eDP1: SUCCESS (8.784s)
[253.010289] Starting dynamic subtest: B-eDP1
[261.725433] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[261.737091] Starting dynamic subtest: C-eDP1
[270.447339] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[270.459753] Starting dynamic subtest: D-eDP1
[279.183476] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[279.188434] Subtest absolute-wf_vblank: SUCCESS (34.978s)
[280.395633] [072/133] (739s left) gem_exec_flush (basic-wb-rw-default)
[280.461869] Starting subtest: basic-wb-rw-default
[285.917840] Subtest basic-wb-rw-default: SUCCESS (5.457s)
[286.109267] [073/133] (734s left) kms_vblank (wait-busy-hang)
[286.217060] Starting subtest: wait-busy-hang
[286.219209] Starting dynamic subtest: pipe-A-eDP-1
[313.017632] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.798s)
[313.032472] Starting dynamic subtest: pipe-D-eDP-1
[338.050069] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.031s)
[338.051969] Subtest wait-busy-hang: SUCCESS (51.834s)
[338.850351] [074/133] (681s left) perf_pmu (all-busy-check-all)
[338.888811] Starting subtest: all-busy-check-all
[340.222519] Subtest all-busy-check-all: SUCCESS (1.332s)
[340.339539] [075/133] (679s left) kms_psr (fbc-pr-sprite-plane-onoff)
[340.438019] Starting subtest: fbc-pr-sprite-plane-onoff
[340.442324] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[340.513386] [076/133] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[340.614244] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[340.618288] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[340.732743] [077/133] (679s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[340.830930] Starting subtest: fbc-psr2-cursor-plane-update-sf
[340.833217] Starting dynamic subtest: pipe-A-eDP-1
[340.911065] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[340.921610] Starting dynamic subtest: pipe-B-eDP-1
[342.021192] Dynamic subtest pipe-B-eDP-1: SKIP (1.110s)
[342.025723] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.192s)
[343.236627] [078/133] (677s left) perf (gen12-oa-tlb-invalidate)
[343.382830] Starting subtest: gen12-oa-tlb-invalidate
[343.384692] Starting dynamic subtest: 0-rcs0
[353.430081] Dynamic subtest 0-rcs0: SUCCESS (10.046s)
[353.440501] Starting dynamic subtest: 1-vecs0
[363.474299] Dynamic subtest 1-vecs0: SUCCESS (10.043s)
[363.476993] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.092s)
[363.529735] [079/133] (656s left) syncobj_timeline (reset-during-wait-for-submit)
[363.591384] Starting subtest: reset-during-wait-for-submit
[363.695322] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[363.779407] [080/133] (656s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[363.882334] Starting subtest: 4-tiled-32bpp-rotate-90
[363.901384] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.018s)
[364.017172] [081/133] (656s left) kms_plane (plane-position-hole-dpms)
[364.118094] Starting subtest: plane-position-hole-dpms
[364.646467] Starting dynamic subtest: pipe-A-plane-1
[367.045079] Dynamic subtest pipe-A-plane-1: SUCCESS (2.398s)
[367.055605] Starting dynamic subtest: pipe-A-plane-2
[369.473530] Dynamic subtest pipe-A-plane-2: SUCCESS (2.427s)
[369.484191] Starting dynamic subtest: pipe-A-plane-3
[371.841337] Dynamic subtest pipe-A-plane-3: SUCCESS (2.368s)
[371.852042] Starting dynamic subtest: pipe-A-plane-4
[374.215324] Dynamic subtest pipe-A-plane-4: SUCCESS (2.372s)
[374.225941] Starting dynamic subtest: pipe-A-plane-5
[374.239530] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[375.386074] Starting dynamic subtest: pipe-B-plane-1
[377.859451] Dynamic subtest pipe-B-plane-1: SUCCESS (2.480s)
[377.869973] Starting dynamic subtest: pipe-B-plane-2
[380.298463] Dynamic subtest pipe-B-plane-2: SUCCESS (2.437s)
[380.317652] Starting dynamic subtest: pipe-B-plane-3
[382.718693] Dynamic subtest pipe-B-plane-3: SUCCESS (2.420s)
[382.729428] Starting dynamic subtest: pipe-B-plane-4
[385.102885] Dynamic subtest pipe-B-plane-4: SUCCESS (2.384s)
[385.113075] Starting dynamic subtest: pipe-B-plane-5
[385.128308] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[385.130571] Subtest plane-position-hole-dpms: SUCCESS (21.011s)
[385.985738] [082/133] (634s left) kms_atomic (atomic-invalid-params)
[386.096928] Starting subtest: atomic-invalid-params
[386.099201] Starting dynamic subtest: pipe-A-eDP-1
[386.489352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.392s)
[386.491719] Subtest atomic-invalid-params: SUCCESS (0.394s)
[387.310128] [083/133] (633s left) kms_lease (lease-get)
[387.395820] Starting subtest: lease-get
[387.398409] Starting dynamic subtest: pipe-A-eDP-1
[387.400873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[387.410925] Starting dynamic subtest: pipe-B-eDP-1
[387.412798] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[387.422308] Starting dynamic subtest: pipe-C-eDP-1
[387.424170] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[387.433419] Starting dynamic subtest: pipe-D-eDP-1
[387.435274] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[387.437110] Subtest lease-get: SUCCESS (0.009s)
[387.511077] [084/133] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[387.599959] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[394.595993] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.999s)
[394.770569] [085/133] (625s left) i915_module_load (reload-no-display)
[394.809390] Starting subtest: reload-no-display
[400.855903] Subtest reload-no-display: SUCCESS (6.049s)
[400.885157] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[400.885879] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[400.888906] [086/133] (619s left) kms_plane_alpha_blend (constant-alpha-min)
[402.466101] Starting subtest: constant-alpha-min
[402.760980] Starting dynamic subtest: pipe-A-eDP-1
[403.510306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.749s)
[403.519457] Starting dynamic subtest: pipe-D-eDP-1
[404.998508] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.484s)
[405.000934] Subtest constant-alpha-min: SUCCESS (2.532s)
[405.841693] [FACT kms_plane_alpha_blend (constant-alpha-min)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[405.843102] [FACT kms_plane_alpha_blend (constant-alpha-min)] new: kernel.kmod_is_loaded.i915: true
[405.846814] [087/133] (614s left) gem_exec_schedule (preempt-other)
[405.928277] Starting subtest: preempt-other
[405.930576] Starting dynamic subtest: rcs0
[406.000571] Dynamic subtest rcs0: SUCCESS (0.072s)
[406.011772] Starting dynamic subtest: bcs0
[406.068744] Dynamic subtest bcs0: SUCCESS (0.068s)
[406.082101] Starting dynamic subtest: vcs0
[406.136917] Dynamic subtest vcs0: SUCCESS (0.067s)
[406.152098] Starting dynamic subtest: vcs1
[406.208603] Dynamic subtest vcs1: SUCCESS (0.070s)
[406.219125] Starting dynamic subtest: vecs0
[406.286081] Dynamic subtest vecs0: SUCCESS (0.077s)
[406.298875] Starting dynamic subtest: ccs0
[406.358617] Dynamic subtest ccs0: SUCCESS (0.072s)
[406.361701] Subtest preempt-other: SUCCESS (0.431s)
[407.372439] [088/133] (613s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[407.475111] Starting subtest: basic-modeset-with-all-modifiers-formats
[407.852671] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[408.642654] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.790s)
[408.652115] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[408.665022] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[408.673725] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[408.687215] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[408.696653] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[408.831913] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[408.841307] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[408.853709] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[408.862693] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[408.876222] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[408.885136] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[408.898399] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[408.906768] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[408.920655] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[408.929127] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[408.942637] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[408.951128] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[408.965182] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[408.973584] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[408.987256] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[408.995599] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[409.009581] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[409.018138] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[409.154183] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.143s)
[409.163504] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[409.175938] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[409.185078] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[409.198560] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[409.207349] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[409.220774] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[409.229594] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[409.243065] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[409.251938] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[409.265306] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[409.274193] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[409.287388] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[409.296240] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[409.309686] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[409.318540] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[409.331875] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[409.340840] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[409.476359] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.144s)
[409.485583] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[409.498555] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[409.507092] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[409.520594] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[409.528941] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[409.542957] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[409.551225] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[409.565231] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[409.573753] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[409.587471] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[409.596045] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[409.609733] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[409.618216] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[409.631878] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[409.640513] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[409.654063] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[410.040825] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.567s)
[410.825345] [089/133] (610s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[410.919883] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[410.924056] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[410.992364] [090/133] (609s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[411.109109] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[411.113151] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[411.196693] [091/133] (609s left) kms_joiner (basic-force-ultra-joiner)
[411.289531] Starting subtest: basic-force-ultra-joiner
[411.293841] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[411.362052] [092/133] (609s left) kms_cursor_edge_walk (256x256-top-bottom)
[411.447094] Starting subtest: 256x256-top-bottom
[411.449415] Starting dynamic subtest: pipe-A-eDP-1
[414.896821] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[414.906063] Starting dynamic subtest: pipe-D-eDP-1
[418.023091] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[418.025416] Subtest 256x256-top-bottom: SUCCESS (6.576s)
[418.833194] [093/133] (602s left) kms_getfb (getfb2-handle-zero)
[418.940096] Starting subtest: getfb2-handle-zero
[418.942223] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[419.046493] [094/133] (602s left) gem_close_race (multigpu-basic-threads)
[419.112997] Starting subtest: multigpu-basic-threads
[419.117266] Subtest multigpu-basic-threads: SKIP (0.000s)
[419.326718] [095/133] (601s left) gem_exec_whisper (basic-contexts-forked)
[419.404234] Starting subtest: basic-contexts-forked
[443.001378] Subtest basic-contexts-forked: SUCCESS (23.593s)
[443.185550] [096/133] (578s left) kms_atomic_transition (plane-all-transition)
[443.276819] Starting subtest: plane-all-transition
[443.279106] Starting dynamic subtest: pipe-A-eDP-1
[445.771724] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[446.085596] Starting dynamic subtest: pipe-B-eDP-1
[449.269985] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.197s)
[449.573066] Subtest plane-all-transition: SUCCESS (6.296s)
[450.394024] [097/133] (570s left) api_intel_allocator (reopen)
[450.455270] Starting subtest: reopen
[450.457734] Subtest reopen: SUCCESS (0.005s)
[450.604947] [098/133] (570s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[450.703455] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[450.707789] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[450.795601] [099/133] (570s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[450.894863] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[450.898899] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[450.995093] [100/133] (570s left) gem_eio (create)
[451.241619] Starting subtest: create
[451.595049] Subtest create: SUCCESS (0.353s)
[451.716261] [101/133] (569s left) gem_fence_thrash (bo-copy)
[451.754094] Starting subtest: bo-copy
[451.782503] Subtest bo-copy: SKIP (0.028s)
[451.851359] [102/133] (569s left) kms_pm_rpm (modeset-lpsp)
[453.484714] Starting subtest: modeset-lpsp
[454.954058] Subtest modeset-lpsp: SUCCESS (1.472s)
[455.059936] [103/133] (566s left) gem_exec_flush (basic-wb-prw-default)
[455.128367] Starting subtest: basic-wb-prw-default
[460.599603] Subtest basic-wb-prw-default: SUCCESS (5.471s)
[460.788992] [104/133] (560s left) perf_pmu (render-node-busy-idle)
[460.872499] Starting subtest: render-node-busy-idle
[460.874449] Starting dynamic subtest: rcs0
[461.569218] Dynamic subtest rcs0: SUCCESS (0.698s)
[461.580835] Starting dynamic subtest: bcs0
[462.231532] Dynamic subtest bcs0: SUCCESS (0.660s)
[462.243151] Starting dynamic subtest: vcs0
[464.317983] Dynamic subtest vcs0: SUCCESS (2.082s)
[464.332859] Starting dynamic subtest: vcs1
[466.301415] Dynamic subtest vcs1: SUCCESS (1.980s)
[466.313959] Starting dynamic subtest: vecs0
[468.285613] Dynamic subtest vecs0: SUCCESS (1.981s)
[468.300837] Starting dynamic subtest: ccs0
[468.950467] Dynamic subtest ccs0: SUCCESS (0.664s)
[468.952885] Subtest render-node-busy-idle: SUCCESS (8.082s)
[469.029665] [105/133] (552s left) gem_mmap_wc (read-write-distinct)
[469.079840] Subtest read-write-distinct: SKIP (0.000s)
[469.138066] [106/133] (552s left) gem_userptr_blits (sync-overlap)
[469.195399] Starting subtest: sync-overlap
[469.197697] Subtest sync-overlap: SUCCESS (0.000s)
[469.318192] [107/133] (552s left) kms_content_protection (legacy)
[469.467344] Starting subtest: legacy
[469.471901] Subtest legacy: SKIP (0.000s)
[469.624559] [108/133] (552s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[469.723651] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[470.758015] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.034s)
[470.882994] [109/133] (550s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[470.977891] Starting subtest: yf-tiled-8bpp-rotate-180
[470.982167] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[471.067199] [110/133] (550s left) gem_exec_params (invalid-ring2)
[471.127586] Starting subtest: invalid-ring2
[471.129467] Subtest invalid-ring2: SUCCESS (0.000s)
[471.229386] [111/133] (550s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[471.483978] Starting subtest: cursor-rapid-movement-256x85
[471.532949] Subtest cursor-rapid-movement-256x85: SKIP (0.047s)
[471.692046] [112/133] (550s left) vgem_basic (bad-handle)
[471.739377] Starting subtest: bad-handle
[471.741558] Subtest bad-handle: SUCCESS (0.000s)
[471.805013] [113/133] (550s left) kms_chamelium_frames (dp-crc-multiple)
[472.183589] Subtest dp-crc-multiple: SKIP (0.000s)
[473.031361] [114/133] (548s left) kms_color (ctm-max)
[473.120288] Starting subtest: ctm-max
[473.122438] Starting dynamic subtest: pipe-A-eDP-1
[473.843687] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[473.856596] Starting dynamic subtest: pipe-B-eDP-1
[475.253326] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[475.266387] Starting dynamic subtest: pipe-C-eDP-1
[476.634288] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[476.645040] Starting dynamic subtest: pipe-D-eDP-1
[477.957188] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[477.959402] Subtest ctm-max: SUCCESS (4.839s)
[478.784241] [115/133] (543s left) kms_vblank (accuracy-idle)
[478.885929] Starting subtest: accuracy-idle
[478.888068] Starting dynamic subtest: pipe-A-eDP-1
[480.639434] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[480.655181] Starting dynamic subtest: pipe-D-eDP-1
[483.106159] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.462s)
[483.108335] Subtest accuracy-idle: SUCCESS (4.219s)
[483.930508] [116/133] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[484.020728] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[484.024955] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[484.125739] [117/133] (538s left) kms_dsc (dsc-with-output-formats)
[484.216699] Starting subtest: dsc-with-output-formats
[484.238408] Subtest dsc-with-output-formats: SKIP (0.001s)
[484.305487] [118/133] (537s left) i915_pm_rpm (debugfs-forcewake-user)
[486.436836] Starting subtest: debugfs-forcewake-user
[497.837331] Subtest debugfs-forcewake-user: SUCCESS (11.405s)
[498.237187] [119/133] (524s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[498.336237] Starting subtest: y-tiled-8bpp-rotate-270
[498.340741] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[498.435207] [120/133] (523s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[498.491385] Starting subtest: etime-multi-wait-all-available-unsubmitted
[498.593125] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s)
[498.671547] [121/133] (523s left) gem_exercise_blt (fast-copy-emit)
[498.739657] Starting subtest: fast-copy-emit
[498.741631] Starting dynamic subtest: linear-smem-smem-emit
[498.759582] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[498.771497] Starting dynamic subtest: xmajor-smem-smem-emit
[498.776225] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[498.786065] Starting dynamic subtest: tile4-smem-smem-emit
[498.793411] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[498.803250] Starting dynamic subtest: tile64-smem-smem-emit
[498.810904] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[498.813242] Subtest fast-copy-emit: SUCCESS (0.073s)
[498.936459] [122/133] (523s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[499.031315] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[499.033516] Starting dynamic subtest: pipe-A-default-mode
[501.764416] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[501.766634] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.735s)
[502.601742] [123/133] (519s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[502.693056] Starting subtest: multiplane-rotation-cropping-top
[520.206343] Subtest multiplane-rotation-cropping-top: SUCCESS (17.516s)
[520.334562] [124/133] (502s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[520.446846] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[520.450064] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[520.548042] [125/133] (501s left) syncobj_wait (invalid-wait-bad-flags)
[520.605899] Starting subtest: invalid-wait-bad-flags
[520.607563] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[520.715133] [126/133] (501s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[520.800270] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[520.801795] Starting dynamic subtest: pipe-A-eDP-1
[521.298450] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[521.310039] Starting dynamic subtest: pipe-B-eDP-1
[522.750533] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s)
[522.761659] Starting dynamic subtest: pipe-C-eDP-1
[524.119290] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[524.131937] Starting dynamic subtest: pipe-D-eDP-1
[525.459329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[525.461312] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.633s)
[526.627519] [127/133] (495s left) gem_eio (in-flight-contexts-immediate)
[526.852957] Starting subtest: in-flight-contexts-immediate
[538.326778] Subtest in-flight-contexts-immediate: SUCCESS (11.473s)
[538.497131] [128/133] (484s left) sw_sync (alloc_timeline)
[538.535237] Starting subtest: alloc_timeline
[538.537419] Subtest alloc_timeline: SUCCESS (0.000s)
[538.588636] [129/133] (484s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[538.674200] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[538.678782] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[539.761517] [130/133] (482s left) kms_busy (basic-hang)
[539.869169] Starting subtest: basic-hang
[539.871166] Starting dynamic subtest: flip-pipe-A
[540.471487] Dynamic subtest flip-pipe-A: SUCCESS (0.601s)
[540.482516] Starting dynamic subtest: modeset-pipe-A
[543.884357] Dynamic subtest modeset-pipe-A: SUCCESS (3.411s)
[543.895606] Starting dynamic subtest: flip-pipe-D
[545.088495] Dynamic subtest flip-pipe-D: SUCCESS (1.202s)
[545.104199] Starting dynamic subtest: modeset-pipe-D
[548.499636] Dynamic subtest modeset-pipe-D: SUCCESS (3.412s)
[548.502013] Subtest basic-hang: SUCCESS (8.632s)
[549.321427] [131/133] (473s left) kms_psr (psr2-primary-mmap-cpu)
[549.412061] Starting subtest: psr2-primary-mmap-cpu
[549.414250] Starting dynamic subtest: eDP-1
[551.186446] Dynamic subtest eDP-1: SUCCESS (1.772s)
[551.188420] Subtest psr2-primary-mmap-cpu: SUCCESS (1.773s)
[552.100516] [132/133] (470s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[552.214256] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[552.218512] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[552.313283] [133/133] (470s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[552.406410] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[552.410717] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[552.498029] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: gem_exec_capture
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_tiled_blits
results: parsing output: 11/ for test: gem_partial_pwrite_pread
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: sw_sync
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: gem_workarounds
results: parsing output: 21/ for test: kms_psr2_su
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_plane_lowres
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: i915_query
results: parsing output: 28/ for test: prime_vgem
results: parsing output: 29/ for test: sw_sync
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gen9_exec_parse
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_pm_dc
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_busy
results: parsing output: 39/ for test: gem_pread
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: i915_drm_fdinfo
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: gem_tiled_pread_basic
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_getfb
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_pxp
results: parsing output: 50/ for test: kms_rotation_crc
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_pipe_crc_basic
results: parsing output: 57/ for test: gem_close
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: kms_debugfs
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_blits
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_workarounds
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: device_reset
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: kms_lease
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_module_load
results: parsing output: 85/ for test: kms_plane_alpha_blend
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_joiner
results: parsing output: 91/ for test: kms_cursor_edge_walk
results: parsing output: 92/ for test: kms_getfb
results: parsing output: 93/ for test: gem_close_race
results: parsing output: 94/ for test: gem_exec_whisper
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: api_intel_allocator
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: gem_fence_thrash
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: gem_exec_flush
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: gem_mmap_wc
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: vgem_basic
results: parsing output: 112/ for test: kms_chamelium_frames
results: parsing output: 113/ for test: kms_color
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_dsc
results: parsing output: 117/ for test: i915_pm_rpm
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_exercise_blt
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: sw_sync
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_busy
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.