[57.450146] Initializing watchdogs
[57.450194]   /dev/watchdog0
[57.464373] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.468571] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.470639] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.473819] [001/132] (960s left) kms_content_protection (atomic-dpms-hdcp14)
[57.658122] Starting subtest: atomic-dpms-hdcp14
[57.662301] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[57.781366] [002/132] (960s left) kms_psr (pr-sprite-plane-onoff)
[57.873996] Starting subtest: pr-sprite-plane-onoff
[57.878248] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[57.969753] [003/132] (960s left) gem_flink_race (flink_close)
[58.004673] Starting subtest: flink_close
[63.104944] Subtest flink_close: SUCCESS (5.110s)
[63.176106] [004/132] (954s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[63.296393] Starting subtest: bad-rotation-90-y-tiled-ccs
[63.298719] Starting dynamic subtest: pipe-A-eDP-1
[63.322025] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.337593] Starting dynamic subtest: pipe-B-eDP-1
[63.360049] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.373539] Starting dynamic subtest: pipe-C-eDP-1
[63.396018] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.409982] Starting dynamic subtest: pipe-D-eDP-1
[63.433059] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.437351] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.003s)
[65.558987] [005/132] (952s left) gem_set_tiling_vs_gtt
[65.681673] [006/132] (952s left) gem_exec_flush (basic-wb-set-default)
[65.747032] Starting subtest: basic-wb-set-default
[71.195951] Subtest basic-wb-set-default: SUCCESS (5.453s)
[71.393182] [007/132] (946s left) gem_userptr_blits (process-exit)
[71.460270] Starting subtest: process-exit
[71.466362] Subtest process-exit: SUCCESS (0.008s)
[71.598158] [008/132] (946s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[71.690715] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[71.693070] Starting dynamic subtest: A-eDP1
[80.598834] Dynamic subtest A-eDP1: SUCCESS (8.909s)
[80.607640] Starting dynamic subtest: B-eDP1
[89.521252] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[89.530398] Starting dynamic subtest: C-eDP1
[98.447847] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[98.460194] Starting dynamic subtest: D-eDP1
[107.373588] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[107.376081] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.687s)
[108.588435] [009/132] (909s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[108.699829] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[108.704342] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[108.792820] [010/132] (909s left) api_intel_allocator (execbuf-with-allocator)
[108.846126] Starting subtest: execbuf-with-allocator
[108.850810] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[108.981394] [011/132] (909s left) gem_lmem_evict (dontneed-evict-race)
[109.027320] Subtest dontneed-evict-race: SKIP (0.000s)
[109.065110] [012/132] (909s left) kms_psr (fbc-psr2-sprite-render)
[109.167866] Starting subtest: fbc-psr2-sprite-render
[109.170191] Starting dynamic subtest: eDP-1
[109.174690] Dynamic subtest eDP-1: SKIP (0.000s)
[109.179107] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[109.252258] [013/132] (909s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[109.337366] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[109.341567] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[109.411524] [014/132] (909s left) kms_getfb (getfb-reject-nv12)
[109.499609] Starting subtest: getfb-reject-nv12
[109.501794] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[109.588432] [015/132] (908s left) gem_ccs (block-multicopy-compressed)
[109.648683] Starting subtest: block-multicopy-compressed
[109.652242] Subtest block-multicopy-compressed: SKIP (0.000s)
[109.761918] [016/132] (908s left) gem_userptr_blits (huge-split)
[109.847952] Starting subtest: huge-split
[109.854119] Subtest huge-split: SUCCESS (0.006s)
[109.973138] [017/132] (908s left) gem_mmap (bad-offset)
[110.022139] Subtest bad-offset: SKIP (0.000s)
[110.077740] [018/132] (908s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[110.178153] Starting subtest: extended-modeset-hang-oldfb-with-reset
[110.180205] Starting dynamic subtest: pipe-A
[121.776132] Dynamic subtest pipe-A: SUCCESS (11.597s)
[121.793087] Starting dynamic subtest: pipe-D
[134.042124] Dynamic subtest pipe-D: SUCCESS (12.264s)
[134.044712] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.865s)
[134.835649] [019/132] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[134.938286] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[141.748046] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.813s)
[141.860388] [020/132] (876s left) kms_sequence (queue-busy)
[141.955139] Starting subtest: queue-busy
[141.957536] Starting dynamic subtest: pipe-A-eDP-1
[143.902868] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.949s)
[143.913660] Starting dynamic subtest: pipe-B-eDP-1
[146.489103] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.585s)
[146.497142] Starting dynamic subtest: pipe-C-eDP-1
[149.091243] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.600s)
[149.102855] Starting dynamic subtest: pipe-D-eDP-1
[151.717623] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.626s)
[151.719768] Subtest queue-busy: SUCCESS (9.763s)
[152.602696] [021/132] (866s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[152.718367] Starting subtest: 4-tiled-16bpp-rotate-270
[152.738016] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[152.850769] [022/132] (865s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[152.950513] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[152.954741] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[153.028487] [023/132] (865s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[153.122805] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[153.127090] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[153.220509] [024/132] (865s left) syncobj_basic (bad-flags-handle-to-fd)
[153.278778] Starting subtest: bad-flags-handle-to-fd
[153.281021] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[153.390928] [025/132] (865s left) kms_flip (2x-wf_vblank-ts-check)
[153.482547] Starting subtest: 2x-wf_vblank-ts-check
[153.491862] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[153.577890] [026/132] (865s left) core_sysfs (read-all-entries)
[153.627935] Starting subtest: read-all-entries
[153.631717] Subtest read-all-entries: SUCCESS (0.005s)
[153.748176] [027/132] (865s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[153.813937] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[153.817483] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[153.998200] [028/132] (865s left) kms_psr (psr-primary-page-flip)
[154.099745] Starting subtest: psr-primary-page-flip
[154.102119] Starting dynamic subtest: eDP-1
[155.804650] Dynamic subtest eDP-1: SUCCESS (1.706s)
[155.807074] Subtest psr-primary-page-flip: SUCCESS (1.707s)
[156.651995] [029/132] (862s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[158.179316] Starting subtest: modeset-lpsp-stress-no-wait
[168.131781] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.955s)
[168.206397] [030/132] (850s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[168.311577] Starting subtest: yf-tiled-16bpp-rotate-0
[168.316086] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[168.410471] [031/132] (850s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[168.513767] Starting subtest: psr-rgb565-draw-mmap-cpu
[175.229509] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.719s)
[175.354117] [032/132] (843s left) vgem_basic (dmabuf-export)
[175.440116] Starting subtest: dmabuf-export
[175.474415] Subtest dmabuf-export: SUCCESS (0.035s)
[175.563016] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[175.566712] [033/132] (843s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[175.659176] Starting subtest: psr2-overlay-plane-move-continuous-sf
[175.661809] Starting dynamic subtest: pipe-A-eDP-1
[181.647885] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.993s)
[181.657061] Starting dynamic subtest: pipe-B-eDP-1
[188.301165] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.653s)
[188.303545] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.648s)
[189.183647] [034/132] (830s left) gem_ctx_isolation (preservation-reset)
[189.356997] Starting subtest: preservation-reset
[189.359673] Starting dynamic subtest: rcs0
[189.602062] Dynamic subtest rcs0: SUCCESS (0.246s)
[189.613062] Starting dynamic subtest: bcs0
[189.888496] Dynamic subtest bcs0: SUCCESS (0.286s)
[189.899574] Starting dynamic subtest: vcs0
[190.160042] Dynamic subtest vcs0: SUCCESS (0.271s)
[190.170616] Starting dynamic subtest: vcs1
[192.167375] Dynamic subtest vcs1: SUCCESS (2.007s)
[192.177891] Starting dynamic subtest: vecs0
[194.139475] Dynamic subtest vecs0: SUCCESS (1.971s)
[194.151806] Starting dynamic subtest: ccs0
[196.200161] Dynamic subtest ccs0: SUCCESS (2.060s)
[196.202672] Subtest preservation-reset: SUCCESS (6.846s)
[196.322752] [035/132] (822s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[196.430750] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[196.434798] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[196.497255] [036/132] (822s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[196.603455] Starting subtest: cursorA-vs-flipB-atomic-transitions
[196.608184] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[196.748383] [037/132] (822s left) kms_color (ctm-signed)
[196.851106] Starting subtest: ctm-signed
[196.852953] Starting dynamic subtest: pipe-A-eDP-1
[198.962943] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s)
[198.971853] Starting dynamic subtest: pipe-B-eDP-1
[201.744942] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.784s)
[201.753863] Starting dynamic subtest: pipe-C-eDP-1
[204.567448] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.819s)
[204.576057] Starting dynamic subtest: pipe-D-eDP-1
[207.206377] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.640s)
[207.208774] Subtest ctm-signed: SUCCESS (10.358s)
[208.063264] [038/132] (811s left) vgem_basic (setversion)
[208.114264] Starting subtest: setversion
[208.118831] Subtest setversion: SUCCESS (0.000s)
[208.185379] [039/132] (811s left) kms_async_flips (invalid-async-flip-atomic)
[208.277598] Starting subtest: invalid-async-flip-atomic
[208.659892] Starting dynamic subtest: pipe-A-eDP-1
[209.470121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.810s)
[209.832498] Starting dynamic subtest: pipe-B-eDP-1
[210.608576] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[210.964719] Starting dynamic subtest: pipe-C-eDP-1
[211.714825] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.754s)
[212.076834] Starting dynamic subtest: pipe-D-eDP-1
[212.840708] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[212.842854] Subtest invalid-async-flip-atomic: SUCCESS (4.565s)
[213.990928] [040/132] (805s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[214.085152] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[221.721170] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.638s)
[221.857719] [041/132] (797s left) kms_big_fb (linear-32bpp-rotate-0)
[221.949024] Starting subtest: linear-32bpp-rotate-0
[223.418137] Subtest linear-32bpp-rotate-0: SUCCESS (1.468s)
[223.537801] [042/132] (796s left) syncobj_timeline (wait-any-snapshot)
[223.597834] Starting subtest: wait-any-snapshot
[223.678356] Subtest wait-any-snapshot: SUCCESS (0.082s)
[223.766219] [043/132] (795s left) gem_exec_params (sol-reset-invalid)
[223.821773] Starting subtest: sol-reset-invalid
[223.823695] Subtest sol-reset-invalid: SUCCESS (0.002s)
[224.961937] [044/132] (794s left) gem_exec_balancer (parallel-keep-in-fence)
[225.230275] Starting subtest: parallel-keep-in-fence
[226.430249] Subtest parallel-keep-in-fence: SUCCESS (1.200s)
[226.544176] [045/132] (793s left) kms_chamelium_audio (hdmi-audio-edid)
[227.680133] Subtest hdmi-audio-edid: SKIP (0.000s)
[227.993494] [046/132] (791s left) gem_pwrite (basic-random)
[228.063572] Subtest basic-random: SKIP (0.000s)
[228.134120] [047/132] (791s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[228.187095] Starting subtest: multi-wait-all-for-submit-signaled
[228.189529] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[228.277754] [048/132] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[228.381895] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[228.386405] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[228.500343] [049/132] (791s left) gem_mmap_offset (open-flood)
[228.556357] Starting subtest: open-flood
[250.051600] Subtest open-flood: SUCCESS (21.496s)
[250.162238] [050/132] (769s left) gem_exec_params (rsvd2-dirt)
[250.221997] Starting subtest: rsvd2-dirt
[250.225838] Subtest rsvd2-dirt: SKIP (0.000s)
[250.312655] [051/132] (769s left) gem_exec_balancer (full-late-pulse)
[250.378445] Starting subtest: full-late-pulse
[254.784393] Subtest full-late-pulse: SUCCESS (4.408s)
[255.115672] [052/132] (764s left) gem_eio (kms)
[255.374705] Starting subtest: kms
[275.094443] Subtest kms: SUCCESS (19.718s)
[276.273542] [053/132] (743s left) perf (non-zero-reason)
[276.395527] Starting subtest: non-zero-reason
[276.397776] Starting dynamic subtest: 0-rcs0
[281.688064] Dynamic subtest 0-rcs0: SUCCESS (5.292s)
[281.701630] Starting dynamic subtest: 1-vecs0
[285.582302] Dynamic subtest 1-vecs0: SUCCESS (3.893s)
[285.585295] Subtest non-zero-reason: SUCCESS (9.186s)
[285.632856] [054/132] (734s left) syncobj_wait (invalid-wait-bad-flags)
[285.680870] Starting subtest: invalid-wait-bad-flags
[285.683157] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[285.767121] [055/132] (734s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[285.866101] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[289.934105] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.071s)
[291.064825] [056/132] (729s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[291.164650] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[291.168952] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[291.273740] [057/132] (728s left) kms_setmode (basic-clone-single-crtc)
[291.328325] Starting subtest: basic-clone-single-crtc
[291.334608] Subtest basic-clone-single-crtc: SKIP (0.000s)
[291.432604] [058/132] (728s left) kms_force_connector_basic (force-edid)
[291.508070] Starting subtest: force-edid
[291.871476] Subtest force-edid: SUCCESS (0.363s)
[292.014421] [059/132] (728s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[292.110707] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[292.112606] Starting dynamic subtest: pipe-A-eDP-1
[292.196389] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[292.205953] Starting dynamic subtest: pipe-B-eDP-1
[293.336056] Dynamic subtest pipe-B-eDP-1: SKIP (1.136s)
[293.340761] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.226s)
[294.576575] [060/132] (725s left) prime_busy (after)
[294.641360] Starting subtest: after
[294.646668] Starting dynamic subtest: rcs0
[294.679070] Dynamic subtest rcs0: SUCCESS (0.034s)
[294.689447] Starting dynamic subtest: bcs0
[294.729613] Dynamic subtest bcs0: SUCCESS (0.050s)
[294.739755] Starting dynamic subtest: vcs0
[294.770748] Dynamic subtest vcs0: SUCCESS (0.041s)
[294.780080] Starting dynamic subtest: vcs1
[294.811416] Dynamic subtest vcs1: SUCCESS (0.040s)
[294.820862] Starting dynamic subtest: vecs0
[294.852845] Dynamic subtest vecs0: SUCCESS (0.041s)
[294.862357] Starting dynamic subtest: ccs0
[294.893093] Dynamic subtest ccs0: SUCCESS (0.040s)
[295.002352] Subtest after: SUCCESS (0.359s)
[295.090404] [061/132] (725s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[295.180493] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[295.185062] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[295.267762] [062/132] (725s left) i915_pm_sseu (full-enable)
[295.326974] Subtest full-enable: SKIP (0.000s)
[295.427437] [063/132] (725s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[295.565540] Starting subtest: multiplane-atomic-fence-wait
[295.860391] Subtest multiplane-atomic-fence-wait: SUCCESS (0.294s)
[296.989815] [064/132] (723s left) kms_chamelium_color (ctm-red-to-blue)
[297.077944] Subtest ctm-red-to-blue: SKIP (0.000s)
[297.122289] [065/132] (723s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[297.227198] Starting subtest: 2x-flip-vs-cursor-legacy
[297.231440] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[297.370108] [066/132] (723s left) kms_flip (2x-plain-flip-interruptible)
[297.460564] Starting subtest: 2x-plain-flip-interruptible
[297.471585] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[297.551616] [067/132] (723s left) kms_plane_scaling (planes-upscale-20x20)
[297.640712] Starting subtest: planes-upscale-20x20
[297.642808] Starting dynamic subtest: pipe-A
[297.701780] Dynamic subtest pipe-A: SUCCESS (0.062s)
[297.711968] Starting dynamic subtest: pipe-B
[298.876658] Dynamic subtest pipe-B: SUCCESS (1.173s)
[298.888071] Starting dynamic subtest: pipe-C
[299.964760] Dynamic subtest pipe-C: SUCCESS (1.087s)
[299.974684] Starting dynamic subtest: pipe-D
[301.064151] Dynamic subtest pipe-D: SUCCESS (1.098s)
[301.066495] Subtest planes-upscale-20x20: SUCCESS (3.425s)
[302.206444] [068/132] (718s left) perf (buffer-fill)
[302.300903] Starting subtest: buffer-fill
[302.303371] Starting dynamic subtest: 0-rcs0
[304.545939] Dynamic subtest 0-rcs0: SUCCESS (2.243s)
[304.556183] Starting dynamic subtest: 1-vecs0
[308.939819] Dynamic subtest 1-vecs0: SUCCESS (4.392s)
[308.942387] Subtest buffer-fill: SUCCESS (6.637s)
[308.989396] [069/132] (711s left) gem_mmap_gtt (coherency)
[309.049287] Subtest coherency: SKIP (0.000s)
[309.111309] [070/132] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[309.216401] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[309.220606] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[309.307435] [071/132] (711s left) syncobj_timeline (invalid-signal-bad-pad)
[309.364445] Starting subtest: invalid-signal-bad-pad
[309.366462] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[309.478038] [072/132] (711s left) i915_pm_rpm (system-suspend-execbuf)
[311.112346] Starting subtest: system-suspend-execbuf
[369.218212] Subtest system-suspend-execbuf: SUCCESS (43.125s)
[369.607794] [073/132] (651s left) gem_tiled_wb
[369.738523] [074/132] (651s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[369.908789] Starting subtest: cursor-rapid-movement-64x64
[369.911099] Starting dynamic subtest: pipe-A-eDP-1
[370.451118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[370.479068] Starting dynamic subtest: pipe-D-eDP-1
[371.632974] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.159s)
[371.635662] Subtest cursor-rapid-movement-64x64: SUCCESS (1.725s)
[372.466905] [075/132] (648s left) kms_flip_event_leak (basic)
[372.553894] Starting subtest: basic
[372.556233] Starting dynamic subtest: pipe-A-eDP-1
[372.975953] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.423s)
[372.987178] Starting dynamic subtest: pipe-B-eDP-1
[374.076068] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.098s)
[374.086498] Starting dynamic subtest: pipe-C-eDP-1
[375.151381] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.074s)
[375.164986] Starting dynamic subtest: pipe-D-eDP-1
[376.233882] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.082s)
[376.236687] Subtest basic: SUCCESS (3.681s)
[377.059959] [076/132] (643s left) kms_pm_backlight (brightness-with-dpms)
[377.153494] Starting subtest: brightness-with-dpms
[377.202230] Starting dynamic subtest: eDP-1
[379.829275] Dynamic subtest eDP-1: SUCCESS (2.628s)
[379.832035] Subtest brightness-with-dpms: SUCCESS (2.679s)
[380.653117] [077/132] (640s left) gem_pread (uncached)
[380.716243] Subtest uncached: SKIP (0.000s)
[380.781401] [078/132] (640s left) perf_pmu (busy-start)
[380.820986] Starting subtest: busy-start
[380.823606] Starting dynamic subtest: rcs0
[383.372749] Dynamic subtest rcs0: SUCCESS (2.552s)
[383.383879] Starting dynamic subtest: bcs0
[385.920227] Dynamic subtest bcs0: SUCCESS (2.548s)
[385.931689] Starting dynamic subtest: vcs0
[390.014545] Dynamic subtest vcs0: SUCCESS (4.092s)
[390.028560] Starting dynamic subtest: vcs1
[393.981671] Dynamic subtest vcs1: SUCCESS (3.966s)
[393.995505] Starting dynamic subtest: vecs0
[398.013873] Dynamic subtest vecs0: SUCCESS (4.031s)
[398.026269] Starting dynamic subtest: ccs0
[400.563516] Dynamic subtest ccs0: SUCCESS (2.549s)
[400.566239] Subtest busy-start: SUCCESS (19.753s)
[400.667615] [079/132] (620s left) kms_cursor_crc (cursor-offscreen-64x21)
[400.885302] Starting subtest: cursor-offscreen-64x21
[400.955981] Subtest cursor-offscreen-64x21: SKIP (0.065s)
[401.195138] [080/132] (619s left) kms_lease (empty-lease)
[401.287969] Starting subtest: empty-lease
[401.290523] Starting dynamic subtest: pipe-A-eDP-1
[401.292850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[401.303146] Starting dynamic subtest: pipe-B-eDP-1
[401.305547] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[401.315220] Starting dynamic subtest: pipe-C-eDP-1
[401.317610] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[401.327899] Starting dynamic subtest: pipe-D-eDP-1
[401.329945] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[401.332129] Subtest empty-lease: SUCCESS (0.009s)
[401.408885] [081/132] (619s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[401.493730] Starting subtest: primary-yf-tiled-reflect-x-0
[401.552612] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[401.658511] [082/132] (619s left) gem_readwrite (read-bad-handle)
[401.716003] Subtest read-bad-handle: SKIP (0.000s)
[401.783480] [083/132] (619s left) kms_flip (modeset-vs-vblank-race)
[401.879928] Starting subtest: modeset-vs-vblank-race
[401.882142] Starting dynamic subtest: A-eDP1
[406.532094] Dynamic subtest A-eDP1: SUCCESS (4.654s)
[406.543291] Starting dynamic subtest: B-eDP1
[411.235894] Dynamic subtest B-eDP1: SUCCESS (4.703s)
[411.249251] Starting dynamic subtest: C-eDP1
[415.911811] Dynamic subtest C-eDP1: SUCCESS (4.676s)
[415.923599] Starting dynamic subtest: D-eDP1
[420.600865] Dynamic subtest D-eDP1: SUCCESS (4.690s)
[420.606964] Subtest modeset-vs-vblank-race: SUCCESS (18.736s)
[421.732344] [084/132] (599s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[421.871742] Starting subtest: flip-vs-cursor-crc-legacy
[422.572547] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.702s)
[423.436986] [085/132] (597s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[423.537399] Starting subtest: invalid-modeset-force-ultra-joiner
[423.541989] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[423.623663] [086/132] (597s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[423.720940] Starting subtest: x-tiled-64bpp-rotate-90
[423.740992] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[423.858210] [087/132] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[423.957635] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[427.593135] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.640s)
[428.755479] [088/132] (592s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[428.827982] Starting subtest: mixed-tiled-to-y-tiled-ccs
[428.832989] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[429.025291] [089/132] (592s left) api_intel_bb (intel-bb-blit-y)
[429.092105] Starting subtest: intel-bb-blit-y
[432.713880] Subtest intel-bb-blit-y: SUCCESS (3.620s)
[432.847985] [090/132] (588s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[433.450106] Starting subtest: syncobj-timeline-multiple-ext-nodes
[433.456845] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.007s)
[435.025114] [091/132] (586s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[435.138642] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[435.143223] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[436.246439] [092/132] (585s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[436.348005] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[436.352891] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[436.439143] [093/132] (585s left) gem_cs_tlb (engines)
[436.493206] Starting subtest: engines
[436.495986] Starting dynamic subtest: rcs0
[438.651069] Dynamic subtest rcs0: SUCCESS (2.155s)
[438.662231] Starting dynamic subtest: bcs0
[440.806387] Dynamic subtest bcs0: SUCCESS (2.151s)
[440.819176] Starting dynamic subtest: vcs0
[442.963234] Dynamic subtest vcs0: SUCCESS (2.155s)
[442.973631] Starting dynamic subtest: vcs1
[445.116840] Dynamic subtest vcs1: SUCCESS (2.152s)
[445.127820] Starting dynamic subtest: vecs0
[447.270981] Dynamic subtest vecs0: SUCCESS (2.152s)
[447.284685] Starting dynamic subtest: ccs0
[449.427290] Dynamic subtest ccs0: SUCCESS (2.153s)
[449.429876] Subtest engines: SUCCESS (12.926s)
[449.553599] [094/132] (572s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[449.616044] Starting subtest: etime-multi-wait-all-submitted-signaled
[449.722576] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[449.801136] [095/132] (572s left) kms_psr (fbc-psr2-basic)
[449.902535] Starting subtest: fbc-psr2-basic
[449.905213] Starting dynamic subtest: eDP-1
[449.910160] Dynamic subtest eDP-1: SKIP (0.000s)
[449.915502] Subtest fbc-psr2-basic: SKIP (0.001s)
[449.984074] [096/132] (571s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[450.039123] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[450.146280] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[450.235975] [097/132] (571s left) i915_drm_fdinfo (virtual-busy-hang-all)
[450.276905] Starting subtest: virtual-busy-hang-all
[450.281855] Subtest virtual-busy-hang-all: SKIP (0.000s)
[450.351605] [098/132] (571s left) gem_exec_schedule (semaphore-resolve)
[450.427737] Starting subtest: semaphore-resolve
[450.456080] Subtest semaphore-resolve: SUCCESS (0.039s)
[450.795581] [099/132] (571s left) gem_spin_batch (legacy-resubmit)
[450.855178] Starting subtest: legacy-resubmit
[450.857680] Starting dynamic subtest: default
[450.860275] Dynamic subtest default: SUCCESS (0.006s)
[450.871531] Starting dynamic subtest: render
[450.874155] Dynamic subtest render: SUCCESS (0.001s)
[450.884252] Starting dynamic subtest: bsd
[450.886654] Dynamic subtest bsd: SUCCESS (0.003s)
[450.896233] Starting dynamic subtest: bsd1
[450.898666] Dynamic subtest bsd1: SUCCESS (0.003s)
[450.908517] Starting dynamic subtest: bsd2
[450.911004] Dynamic subtest bsd2: SUCCESS (0.001s)
[450.921100] Starting dynamic subtest: blt
[450.923966] Dynamic subtest blt: SUCCESS (0.003s)
[450.934029] Starting dynamic subtest: vebox
[450.936684] Dynamic subtest vebox: SUCCESS (0.003s)
[450.939142] Subtest legacy-resubmit: SUCCESS (0.027s)
[451.101725] [100/132] (570s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[451.201349] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[457.628210] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.429s)
[457.729592] [101/132] (564s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[457.821648] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[457.823800] Starting dynamic subtest: pipe-A-eDP-1
[459.896893] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.077s)
[459.906816] Starting dynamic subtest: pipe-B-eDP-1
[462.163541] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.262s)
[462.184267] Starting dynamic subtest: pipe-C-eDP-1
[464.240724] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.075s)
[464.251962] Starting dynamic subtest: pipe-D-eDP-1
[466.307789] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.067s)
[466.309801] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.487s)
[467.457587] [102/132] (554s left) kms_vblank (ts-continuation-modeset-rpm)
[467.563281] Starting subtest: ts-continuation-modeset-rpm
[467.566093] Starting dynamic subtest: pipe-A-eDP-1
[470.097235] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.535s)
[470.113741] Starting dynamic subtest: pipe-D-eDP-1
[472.291516] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.192s)
[472.294293] Subtest ts-continuation-modeset-rpm: SUCCESS (4.730s)
[473.138246] [103/132] (549s left) gem_ctx_persistence (legacy-engines-hang)
[473.203213] Starting subtest: legacy-engines-hang
[473.205722] Starting dynamic subtest: render
[473.244834] Dynamic subtest render: SUCCESS (0.042s)
[473.257800] Starting dynamic subtest: bsd1
[473.356580] Dynamic subtest bsd1: SUCCESS (0.110s)
[473.371246] Starting dynamic subtest: bsd2
[473.446612] Dynamic subtest bsd2: SUCCESS (0.087s)
[473.462619] Starting dynamic subtest: blt
[473.536549] Dynamic subtest blt: SUCCESS (0.087s)
[473.549387] Starting dynamic subtest: vebox
[473.629031] Dynamic subtest vebox: SUCCESS (0.090s)
[473.632093] Subtest legacy-engines-hang: SUCCESS (0.429s)
[473.714062] [104/132] (548s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[473.772244] Starting subtest: rel-constants-invalid-rel-gen5
[473.775059] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[473.875719] [105/132] (548s left) gem_exec_store (dword)
[473.944817] Starting subtest: dword
[473.947439] Starting dynamic subtest: rcs0
[474.013942] Dynamic subtest rcs0: SUCCESS (0.073s)
[474.027515] Starting dynamic subtest: bcs0
[474.057170] Dynamic subtest bcs0: SUCCESS (0.041s)
[474.068553] Starting dynamic subtest: vcs0
[474.100062] Dynamic subtest vcs0: SUCCESS (0.042s)
[474.111619] Starting dynamic subtest: vcs1
[474.143264] Dynamic subtest vcs1: SUCCESS (0.041s)
[474.155155] Starting dynamic subtest: vecs0
[474.186910] Dynamic subtest vecs0: SUCCESS (0.041s)
[474.199069] Starting dynamic subtest: ccs0
[474.230474] Dynamic subtest ccs0: SUCCESS (0.042s)
[474.232791] Subtest dword: SUCCESS (0.291s)
[474.419399] [106/132] (547s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[474.517080] Starting subtest: y-tiled-8bpp-rotate-90
[474.522089] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[474.616400] [107/132] (547s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[474.706963] Starting subtest: read-crc-frame-sequence
[474.709629] Starting dynamic subtest: pipe-A-eDP-1
[475.418959] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[475.431624] Starting dynamic subtest: pipe-B-eDP-1
[476.782295] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s)
[476.794984] Starting dynamic subtest: pipe-C-eDP-1
[478.127137] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s)
[478.138473] Starting dynamic subtest: pipe-D-eDP-1
[479.402249] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.272s)
[479.405163] Subtest read-crc-frame-sequence: SUCCESS (4.697s)
[480.235768] [108/132] (542s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[480.330932] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[480.333310] Starting dynamic subtest: pipe-A
[480.666825] Dynamic subtest pipe-A: SUCCESS (0.339s)
[480.678478] Starting dynamic subtest: pipe-B
[482.102952] Dynamic subtest pipe-B: SUCCESS (1.436s)
[482.112899] Starting dynamic subtest: pipe-C
[483.515005] Dynamic subtest pipe-C: SUCCESS (1.411s)
[483.525032] Starting dynamic subtest: pipe-D
[485.013779] Dynamic subtest pipe-D: SUCCESS (1.496s)
[485.016301] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.688s)
[486.241631] [109/132] (536s left) gem_userptr_blits (unsync-unmap-cycles)
[486.313225] Subtest unsync-unmap-cycles: SKIP (0.000s)
[486.425101] [110/132] (536s left) kms_cursor_crc (cursor-sliding-512x512)
[486.692156] Starting subtest: cursor-sliding-512x512
[486.697697] Subtest cursor-sliding-512x512: SKIP (0.001s)
[486.836161] [111/132] (535s left) gem_ctx_param (invalid-ctx-set)
[486.894134] Starting subtest: invalid-ctx-set
[486.896774] Subtest invalid-ctx-set: SUCCESS (0.001s)
[486.998460] [112/132] (535s left) gem_exec_gttfill (multigpu-basic)
[487.167861] Starting subtest: multigpu-basic
[500.078269] Subtest multigpu-basic: SUCCESS (12.912s)
[500.153765] [113/132] (522s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[500.334697] Starting subtest: cursorA-vs-flipA-atomic
[511.496919] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.165s)
[512.329764] [114/132] (510s left) sw_sync (alloc_fence_invalid_timeline)
[512.383062] Starting subtest: alloc_fence_invalid_timeline
[512.386060] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[512.444552] [115/132] (510s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[512.531271] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[512.533935] Starting dynamic subtest: pipe-A-eDP-1
[512.681394] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[512.694219] Starting dynamic subtest: pipe-B-eDP-1
[512.716626] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[512.727388] Starting dynamic subtest: pipe-C-eDP-1
[512.749027] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[512.759209] Starting dynamic subtest: pipe-D-eDP-1
[512.782173] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[512.784514] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.176s)
[514.945907] [116/132] (507s left) i915_drm_fdinfo (isolation)
[514.997073] Starting subtest: isolation
[514.999500] Starting dynamic subtest: rcs0
[515.016588] Dynamic subtest rcs0: SKIP (0.019s)
[515.027263] Starting dynamic subtest: bcs0
[515.032057] Dynamic subtest bcs0: SKIP (0.000s)
[515.042379] Starting dynamic subtest: vcs0
[515.047968] Dynamic subtest vcs0: SKIP (0.000s)
[515.058881] Starting dynamic subtest: vcs1
[515.063968] Dynamic subtest vcs1: SKIP (0.000s)
[515.073939] Starting dynamic subtest: vecs0
[515.079054] Dynamic subtest vecs0: SKIP (0.000s)
[515.089039] Starting dynamic subtest: ccs0
[515.093963] Dynamic subtest ccs0: SKIP (0.000s)
[515.098942] Subtest isolation: SKIP (0.023s)
[515.138593] [117/132] (507s left) kms_cursor_legacy (single-move)
[515.268309] Starting subtest: single-move
[515.270657] Starting dynamic subtest: pipe-A
[520.650059] Dynamic subtest pipe-A: SUCCESS (5.380s)
[520.664237] Starting dynamic subtest: pipe-B
[526.030960] Dynamic subtest pipe-B: SUCCESS (5.380s)
[526.043944] Starting dynamic subtest: pipe-C
[531.412251] Dynamic subtest pipe-C: SUCCESS (5.380s)
[531.425220] Starting dynamic subtest: pipe-D
[536.792007] Dynamic subtest pipe-D: SUCCESS (5.379s)
[536.805052] Starting dynamic subtest: all-pipes
[542.181059] Dynamic subtest all-pipes: SUCCESS (5.387s)
[542.184202] Subtest single-move: SUCCESS (26.919s)
[542.326996] [118/132] (480s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[542.381377] Starting subtest: wait-all-for-submit-delayed-submit
[542.482820] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[542.575274] [119/132] (480s left) sw_sync (alloc_merge_fence)
[542.620697] Starting subtest: alloc_merge_fence
[542.623264] Subtest alloc_merge_fence: SUCCESS (0.000s)
[542.686966] [120/132] (480s left) kms_plane (pixel-format-4-tiled-modifier)
[542.771173] Starting subtest: pixel-format-4-tiled-modifier
[542.797159] Starting dynamic subtest: pipe-A-plane-0
[543.473647] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[543.485441] Starting dynamic subtest: pipe-A-plane-3
[543.917758] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[543.927648] Starting dynamic subtest: pipe-A-plane-5
[543.931788] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[544.983744] Starting dynamic subtest: pipe-B-plane-0
[545.685979] Dynamic subtest pipe-B-plane-0: SUCCESS (0.711s)
[545.696767] Starting dynamic subtest: pipe-B-plane-3
[546.185845] Dynamic subtest pipe-B-plane-3: SUCCESS (0.498s)
[546.196260] Starting dynamic subtest: pipe-B-plane-5
[546.200939] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[546.503495] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.733s)
[547.320900] [121/132] (475s left) kms_getfb (getfb-handle-zero)
[547.419750] Starting subtest: getfb-handle-zero
[547.422222] Subtest getfb-handle-zero: SUCCESS (0.000s)
[547.534077] [122/132] (475s left) gen9_exec_parse (bb-chained)
[547.595015] Subtest bb-chained: SKIP (0.000s)
[547.667670] [123/132] (475s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[547.771233] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[554.304863] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.535s)
[554.450845] [124/132] (468s left) gem_exec_schedule (noreorder)
[554.633265] Starting subtest: noreorder
[554.636096] Starting dynamic subtest: rcs0
[554.685453] Dynamic subtest rcs0: SUCCESS (0.051s)
[554.697978] Starting dynamic subtest: vcs0
[555.968489] Dynamic subtest vcs0: SUCCESS (1.279s)
[555.985513] Starting dynamic subtest: vcs1
[557.940229] Dynamic subtest vcs1: SUCCESS (1.968s)
[557.953255] Starting dynamic subtest: vecs0
[559.910912] Dynamic subtest vecs0: SUCCESS (1.967s)
[559.924499] Starting dynamic subtest: ccs0
[559.991664] Dynamic subtest ccs0: SUCCESS (0.079s)
[559.994850] Subtest noreorder: SUCCESS (5.357s)
[560.188450] [125/132] (462s left) kms_flip (nonblocking-read)
[560.298105] Starting subtest: nonblocking-read
[560.300480] Subtest nonblocking-read: SUCCESS (0.000s)
[560.414011] [126/132] (462s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[560.511164] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[567.098477] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.590s)
[567.200254] [127/132] (456s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[567.265678] Starting subtest: map-fixed-invalidate-overlap
[567.270110] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[567.403445] [128/132] (455s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[567.498777] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[567.588644] [129/132] (455s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[567.682762] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[567.687999] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[567.762896] [130/132] (455s left) kms_psr (psr2-cursor-plane-move)
[567.852118] Starting subtest: psr2-cursor-plane-move
[567.854826] Starting dynamic subtest: eDP-1
[569.568525] Dynamic subtest eDP-1: SUCCESS (1.715s)
[569.570975] Subtest psr2-cursor-plane-move: SUCCESS (1.716s)
[570.421887] [131/132] (452s left) kms_properties (crtc-properties-legacy)
[570.508137] Starting subtest: crtc-properties-legacy
[570.511005] Starting dynamic subtest: pipe-A-eDP-1
[570.947272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s)
[570.958904] Starting dynamic subtest: pipe-B-eDP-1
[572.155365] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.209s)
[572.167964] Starting dynamic subtest: pipe-C-eDP-1
[573.328840] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.172s)
[573.341550] Starting dynamic subtest: pipe-D-eDP-1
[574.454278] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[574.457271] Subtest crtc-properties-legacy: SUCCESS (3.947s)
[575.319669] [132/132] (448s left) kms_chamelium_hpd (hdmi-hpd-storm)
[575.718955] Subtest hdmi-hpd-storm: SKIP (0.000s)
[576.500620] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_flink_race
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_set_tiling_vs_gtt
results: parsing output: 5/ for test: gem_exec_flush
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: gem_lmem_evict
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: gem_ccs
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: gem_mmap
results: parsing output: 17/ for test: kms_busy
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_sequence
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_basic
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: core_sysfs
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: gem_ctx_isolation
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_color
results: parsing output: 37/ for test: vgem_basic
results: parsing output: 38/ for test: kms_async_flips
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_chamelium_audio
results: parsing output: 45/ for test: gem_pwrite
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: gem_exec_params
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: syncobj_wait
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_setmode
results: parsing output: 57/ for test: kms_force_connector_basic
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: prime_busy
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: i915_pm_sseu
results: parsing output: 62/ for test: kms_explicit_fence
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: i915_pm_rpm
results: parsing output: 72/ for test: gem_tiled_wb
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_flip_event_leak
results: parsing output: 75/ for test: kms_pm_backlight
results: parsing output: 76/ for test: gem_pread
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: kms_rotation_crc
results: parsing output: 81/ for test: gem_readwrite
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_joiner
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_cs_tlb
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: i915_drm_fdinfo
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: gem_spin_batch
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: gem_exec_params
results: parsing output: 104/ for test: gem_exec_store
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_pipe_crc_basic
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_ctx_param
results: parsing output: 111/ for test: gem_exec_gttfill
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: sw_sync
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: sw_sync
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: gen9_exec_parse
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_properties
results: parsing output: 131/ for test: kms_chamelium_hpd
Done.