[58.244691] Initializing watchdogs
[58.244757]   /dev/watchdog0
[58.259534] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.263846] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.266356] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.269483] [001/155] (960s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt)
[58.394153] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt
[58.398121] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[58.479993] [002/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[58.579307] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[58.583484] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[58.675609] [003/155] (960s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite)
[58.780697] Starting subtest: psrhdr-rgb101010-draw-pwrite
[58.785075] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[58.879505] [004/155] (959s left) kms_psr (psr-suspend)
[58.966962] Starting subtest: psr-suspend
[58.969378] Starting dynamic subtest: eDP-1
[77.565692] Dynamic subtest eDP-1: SUCCESS (3.348s)
[77.568187] Subtest psr-suspend: SUCCESS (3.349s)
[78.439569] [005/155] (940s left) gem_mmap_offset (bad-object)
[78.498796] Starting subtest: bad-object
[78.500896] Subtest bad-object: SUCCESS (0.001s)
[78.585981] [006/155] (940s left) gem_pread (exhaustion)
[78.635438] Subtest exhaustion: SKIP (0.000s)
[78.690518] [007/155] (940s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[78.771515] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[78.902797] [008/155] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[79.008664] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[79.012823] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[79.096446] [009/155] (939s left) kms_flip (plain-flip-fb-recreate-interruptible)
[79.193994] Starting subtest: plain-flip-fb-recreate-interruptible
[79.196386] Starting dynamic subtest: A-eDP1
[88.055123] Dynamic subtest A-eDP1: SUCCESS (8.857s)
[88.066101] Starting dynamic subtest: B-eDP1
[96.880890] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[96.893769] Starting dynamic subtest: C-eDP1
[105.700197] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[105.709906] Starting dynamic subtest: D-eDP1
[114.526980] Dynamic subtest D-eDP1: SUCCESS (8.824s)
[114.531059] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.333s)
[115.711462] [010/155] (903s left) kms_flip_event_leak (basic)
[115.818846] Starting subtest: basic
[115.820866] Starting dynamic subtest: pipe-A-eDP-1
[116.246752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.429s)
[116.256762] Starting dynamic subtest: pipe-B-eDP-1
[117.426593] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.179s)
[117.436018] Starting dynamic subtest: pipe-C-eDP-1
[118.528911] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[118.536809] Starting dynamic subtest: pipe-D-eDP-1
[119.659939] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[119.662310] Subtest basic: SUCCESS (3.842s)
[120.508398] [011/155] (898s left) gem_mmap_gtt (basic-small-bo-tiledy)
[120.570353] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[120.629591] [012/155] (898s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[120.749516] Starting subtest: verify-pxp-execution-after-suspend-resume
[127.804271] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.055s)
[127.932703] [013/155] (891s left) kms_frontbuffer_tracking (fbc-tiling-y)
[128.040421] Starting subtest: fbc-tiling-y
[128.044873] Subtest fbc-tiling-y: SKIP (0.000s)
[128.141995] [014/155] (891s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[128.243777] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[128.248199] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[128.340014] [015/155] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[128.432879] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[128.437268] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[128.526234] [016/155] (890s left) syncobj_timeline (multi-wait-all-available-signaled)
[128.575684] Starting subtest: multi-wait-all-available-signaled
[128.577906] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[128.685208] [017/155] (890s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[128.775580] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[128.778864] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[128.863936] [018/155] (890s left) kms_psr (psr-no-drrs)
[128.950559] Starting subtest: psr-no-drrs
[128.952392] Starting dynamic subtest: eDP-1
[130.552537] Dynamic subtest eDP-1: SUCCESS (1.601s)
[130.554886] Subtest psr-no-drrs: SUCCESS (1.603s)
[131.431430] [019/155] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[131.528872] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[135.998088] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.475s)
[137.163059] [020/155] (882s left) kms_chamelium_hpd (dp-hpd)
[137.559355] Subtest dp-hpd: SKIP (0.000s)
[138.339272] [021/155] (881s left) fbdev (pan)
[138.374111] Starting subtest: pan
[138.402896] Subtest pan: SUCCESS (0.033s)
[138.470558] [022/155] (881s left) gem_ctx_persistence (legacy-engines-mixed)
[138.527727] Starting subtest: legacy-engines-mixed
[138.529665] Starting dynamic subtest: render
[138.610684] Dynamic subtest render: SUCCESS (0.085s)
[138.622728] Starting dynamic subtest: bsd1
[138.657961] Dynamic subtest bsd1: SUCCESS (0.045s)
[138.669086] Starting dynamic subtest: bsd2
[138.704911] Dynamic subtest bsd2: SUCCESS (0.045s)
[138.715506] Starting dynamic subtest: blt
[138.750801] Dynamic subtest blt: SUCCESS (0.045s)
[138.764002] Starting dynamic subtest: vebox
[138.801843] Dynamic subtest vebox: SUCCESS (0.049s)
[138.804332] Subtest legacy-engines-mixed: SUCCESS (0.277s)
[138.880401] [023/155] (880s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[138.967873] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[138.969762] Starting dynamic subtest: pipe-A-eDP-1
[139.442479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[139.452705] Starting dynamic subtest: pipe-B-eDP-1
[140.893731] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s)
[140.904663] Starting dynamic subtest: pipe-C-eDP-1
[142.268641] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[142.277981] Starting dynamic subtest: pipe-D-eDP-1
[143.611651] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[143.614029] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.614s)
[144.776739] [024/155] (874s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[144.867862] Starting subtest: random-ccs-data-yf-tiled-ccs
[144.870043] Starting dynamic subtest: pipe-A-eDP-1
[144.895455] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[144.906143] Starting dynamic subtest: pipe-B-eDP-1
[144.928711] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[144.937140] Starting dynamic subtest: pipe-C-eDP-1
[144.960298] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[144.968105] Starting dynamic subtest: pipe-D-eDP-1
[144.992147] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[144.996546] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[147.128106] [025/155] (872s left) kms_universal_plane (universal-plane-functional)
[147.221984] Starting subtest: universal-plane-functional
[147.224351] Starting dynamic subtest: pipe-A-eDP-1
[151.156872] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.932s)
[151.165527] Starting dynamic subtest: pipe-B-eDP-1
[155.547619] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.390s)
[155.556060] Starting dynamic subtest: pipe-C-eDP-1
[159.836100] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.288s)
[159.848342] Starting dynamic subtest: pipe-D-eDP-1
[164.063837] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.224s)
[164.065873] Subtest universal-plane-functional: SUCCESS (16.840s)
[164.869681] [026/155] (854s left) kms_plane_multiple (tiling-none)
[164.965275] Starting subtest: tiling-none
[164.967527] Starting dynamic subtest: pipe-A-eDP-1
[168.822538] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.859s)
[168.832739] Starting dynamic subtest: pipe-B-eDP-1
[173.283758] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.458s)
[173.293306] Starting dynamic subtest: pipe-C-eDP-1
[177.717946] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.432s)
[177.726795] Starting dynamic subtest: pipe-D-eDP-1
[182.081428] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.363s)
[182.083751] Subtest tiling-none: SUCCESS (17.118s)
[182.889946] [027/155] (836s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff)
[182.998707] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff
[183.003028] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[183.098595] [028/155] (836s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[183.191702] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[183.196283] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[183.294874] [029/155] (836s left) kms_psr (fbc-pr-no-drrs)
[183.378449] Starting subtest: fbc-pr-no-drrs
[183.382732] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[183.470654] [030/155] (836s left) kms_psr (fbc-psr-cursor-blt)
[183.561980] Starting subtest: fbc-psr-cursor-blt
[183.564246] Starting dynamic subtest: eDP-1
[183.568372] Dynamic subtest eDP-1: SKIP (0.000s)
[183.572679] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[183.631221] [031/155] (836s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[183.733820] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[184.745533] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.012s)
[184.850989] [032/155] (835s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[184.944751] Starting subtest: yf-tiled-addfb-size-overflow
[184.948607] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[185.030998] [033/155] (834s left) kms_feature_discovery (display-4x)
[185.121432] Starting subtest: display-4x
[185.125044] Subtest display-4x: SKIP (0.000s)
[185.191941] [034/155] (834s left) gem_exec_async (forked-writes)
[185.247060] Starting subtest: forked-writes
[185.249169] Starting dynamic subtest: rcs0
[185.275463] Dynamic subtest rcs0: SUCCESS (0.028s)
[185.286749] Starting dynamic subtest: bcs0
[185.298223] Dynamic subtest bcs0: SUCCESS (0.022s)
[185.307556] Starting dynamic subtest: vcs0
[185.320162] Dynamic subtest vcs0: SUCCESS (0.021s)
[185.331862] Starting dynamic subtest: vcs1
[185.343010] Dynamic subtest vcs1: SUCCESS (0.022s)
[185.354223] Starting dynamic subtest: vecs0
[185.365087] Dynamic subtest vecs0: SUCCESS (0.021s)
[185.374174] Starting dynamic subtest: ccs0
[185.386803] Dynamic subtest ccs0: SUCCESS (0.021s)
[185.388782] Subtest forked-writes: SUCCESS (0.140s)
[185.602195] [035/155] (834s left) gem_exec_params (sol-reset-invalid)
[185.659993] Starting subtest: sol-reset-invalid
[185.662344] Subtest sol-reset-invalid: SUCCESS (0.002s)
[187.607037] [036/155] (832s left) core_setmaster (master-drop-set-user)
[187.704173] Starting subtest: master-drop-set-user
[187.718668] Subtest master-drop-set-user: SUCCESS (0.013s)
[187.755132] [037/155] (832s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[187.852861] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[187.857269] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[187.961451] [038/155] (832s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[188.056973] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[188.062062] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[188.125399] [039/155] (832s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[188.177047] Starting subtest: etime-single-wait-available-unsubmitted
[188.286445] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s)
[188.372029] [040/155] (831s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[188.466432] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[189.223778] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.759s)
[189.395136] [041/155] (830s left) syncobj_wait (signal)
[189.444220] Starting subtest: signal
[189.446572] Subtest signal: SUCCESS (0.000s)
[189.548709] [042/155] (830s left) kms_invalid_mode (bad-vsync-end)
[189.638503] Starting subtest: bad-vsync-end
[189.640819] Starting dynamic subtest: pipe-A-eDP-1
[189.923982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[189.932728] Starting dynamic subtest: pipe-B-eDP-1
[189.934813] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[189.943493] Starting dynamic subtest: pipe-C-eDP-1
[189.945713] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[189.953577] Starting dynamic subtest: pipe-D-eDP-1
[189.955394] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[189.957262] Subtest bad-vsync-end: SUCCESS (0.293s)
[190.736480] [043/155] (829s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-render)
[190.834790] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-render
[190.838729] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[190.935852] [044/155] (829s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[191.032569] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[191.034897] Starting dynamic subtest: pipe-A-eDP-1
[191.057831] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[191.068855] Starting dynamic subtest: pipe-B-eDP-1
[191.090658] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[191.099487] Starting dynamic subtest: pipe-C-eDP-1
[191.121247] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[191.132260] Starting dynamic subtest: pipe-D-eDP-1
[191.154671] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[191.158649] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[193.285048] [045/155] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[193.387395] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[200.803407] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.421s)
[200.928798] [046/155] (819s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[200.990842] Starting subtest: invalid-multi-wait-all-unsubmitted
[200.993171] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[201.086770] [047/155] (819s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[201.187735] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[201.191765] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[201.288570] [048/155] (819s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[201.380346] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[201.384362] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[201.471455] [049/155] (819s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[201.559850] Starting subtest: bad-pixel-format-y-tiled-ccs
[201.562038] Starting dynamic subtest: pipe-A-eDP-1
[201.583885] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[201.593672] Starting dynamic subtest: pipe-B-eDP-1
[201.615269] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[201.623814] Starting dynamic subtest: pipe-C-eDP-1
[201.644991] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[201.653208] Starting dynamic subtest: pipe-D-eDP-1
[201.674214] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[201.678114] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[203.889409] [050/155] (816s left) syncobj_timeline (device-submit-unordered)
[203.944507] Starting subtest: device-submit-unordered
[203.946890] Subtest device-submit-unordered: SUCCESS (0.001s)
[204.038008] [051/155] (816s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[204.143899] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[204.148274] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[204.242883] [052/155] (816s left) gem_request_retire (retire-vma-not-inactive)
[204.297522] Starting subtest: retire-vma-not-inactive
[204.358412] Subtest retire-vma-not-inactive: SUCCESS (0.056s)
[204.472714] [053/155] (816s left) gem_exec_reloc (basic-active)
[204.522865] Subtest basic-active: SKIP (0.000s)
[204.594659] [054/155] (816s left) gem_spin_batch (legacy)
[204.654646] Starting subtest: legacy
[204.656981] Starting dynamic subtest: default
[207.897288] Dynamic subtest default: SUCCESS (3.237s)
[207.909964] Starting dynamic subtest: render
[211.134364] Dynamic subtest render: SUCCESS (3.234s)
[211.147354] Starting dynamic subtest: bsd
[214.374831] Dynamic subtest bsd: SUCCESS (3.237s)
[214.385628] Starting dynamic subtest: bsd1
[217.611158] Dynamic subtest bsd1: SUCCESS (3.233s)
[217.622696] Starting dynamic subtest: bsd2
[220.850301] Dynamic subtest bsd2: SUCCESS (3.236s)
[220.861525] Starting dynamic subtest: blt
[224.088043] Dynamic subtest blt: SUCCESS (3.234s)
[224.097492] Starting dynamic subtest: vebox
[227.325367] Dynamic subtest vebox: SUCCESS (3.234s)
[227.327828] Subtest legacy: SUCCESS (22.669s)
[227.590421] [055/155] (793s left) kms_async_flips (test-cursor)
[227.694055] Starting subtest: test-cursor
[228.071473] Starting dynamic subtest: pipe-A-eDP-1
[228.860884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s)
[229.243043] Starting dynamic subtest: pipe-B-eDP-1
[230.003352] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.768s)
[230.374574] Starting dynamic subtest: pipe-C-eDP-1
[231.135827] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[231.504975] Starting dynamic subtest: pipe-D-eDP-1
[232.263586] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[232.265942] Subtest test-cursor: SUCCESS (4.573s)
[233.431742] [056/155] (787s left) perf (oa-exponents)
[233.541676] Starting subtest: oa-exponents
[233.543609] Starting dynamic subtest: 0-rcs0
[235.315061] Dynamic subtest 0-rcs0: SUCCESS (1.774s)
[235.324920] Starting dynamic subtest: 1-vecs0
[237.142207] Dynamic subtest 1-vecs0: SUCCESS (1.826s)
[237.144687] Subtest oa-exponents: SUCCESS (3.601s)
[237.187791] [057/155] (783s left) kms_frontbuffer_tracking (fbchdr-tiling-y)
[237.281892] Starting subtest: fbchdr-tiling-y
[237.286123] Subtest fbchdr-tiling-y: SKIP (0.000s)
[237.378995] [058/155] (783s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[237.488737] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[237.492753] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[237.603292] [059/155] (783s left) kms_psr (fbc-psr2-cursor-render)
[237.685324] Starting subtest: fbc-psr2-cursor-render
[237.687185] Starting dynamic subtest: eDP-1
[237.691242] Dynamic subtest eDP-1: SKIP (0.000s)
[237.695248] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[237.753243] [060/155] (783s left) kms_addfb_basic (bad-pitch-999)
[237.797295] Starting subtest: bad-pitch-999
[237.799637] Subtest bad-pitch-999: SUCCESS (0.000s)
[237.968548] [061/155] (783s left) prime_busy (after-wait)
[238.020704] Starting subtest: after-wait
[238.025519] Starting dynamic subtest: rcs0
[238.050292] Dynamic subtest rcs0: SUCCESS (0.026s)
[238.059392] Starting dynamic subtest: bcs0
[238.095443] Dynamic subtest bcs0: SUCCESS (0.044s)
[238.105180] Starting dynamic subtest: vcs0
[238.135517] Dynamic subtest vcs0: SUCCESS (0.039s)
[238.143781] Starting dynamic subtest: vcs1
[238.173918] Dynamic subtest vcs1: SUCCESS (0.038s)
[238.181935] Starting dynamic subtest: vecs0
[238.213184] Dynamic subtest vecs0: SUCCESS (0.039s)
[238.221025] Starting dynamic subtest: ccs0
[238.253057] Dynamic subtest ccs0: SUCCESS (0.039s)
[238.362042] Subtest after-wait: SUCCESS (0.339s)
[238.438058] [062/155] (782s left) i915_suspend (basic-s2idle-without-i915)
[238.474547] Starting subtest: basic-s2idle-without-i915
[259.279630] Subtest basic-s2idle-without-i915: SUCCESS (5.567s)
[259.384845] [063/155] (761s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[259.486706] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[259.490695] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[259.561164] [064/155] (761s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-pgflip-blt)
[259.663169] Starting subtest: hdr-2p-primscrn-indfb-pgflip-blt
[259.667538] Subtest hdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[259.754068] [065/155] (761s left) kms_plane_lowres (tiling-none)
[259.852674] Starting subtest: tiling-none
[259.854927] Starting dynamic subtest: pipe-A-eDP-1
[259.859537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[260.147449] Starting dynamic subtest: pipe-B-eDP-1
[260.152227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[260.160016] Starting dynamic subtest: pipe-C-eDP-1
[260.164703] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[260.172936] Starting dynamic subtest: pipe-D-eDP-1
[260.177580] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[260.181962] Subtest tiling-none: SKIP (0.294s)
[261.025665] [066/155] (760s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[261.131946] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[261.136100] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[261.231356] [067/155] (760s left) api_intel_allocator (reopen)
[261.280952] Starting subtest: reopen
[261.289077] Subtest reopen: SUCCESS (0.010s)
[261.414064] [068/155] (759s left) sw_sync (alloc_fence_invalid_timeline)
[261.448238] Starting subtest: alloc_fence_invalid_timeline
[261.450426] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[261.499150] [069/155] (759s left) i915_pm_rps (engine-order)
[261.569674] Starting subtest: engine-order
[266.727442] Subtest engine-order: SUCCESS (5.151s)
[266.854324] [070/155] (754s left) gem_userptr_blits (input-checking)
[266.918181] Starting subtest: input-checking
[266.920108] Subtest input-checking: SUCCESS (0.000s)
[267.038565] [071/155] (754s left) kms_busy (basic-hang)
[267.136556] Starting subtest: basic-hang
[267.138940] Starting dynamic subtest: flip-pipe-A
[267.719523] Dynamic subtest flip-pipe-A: SUCCESS (0.580s)
[267.728828] Starting dynamic subtest: modeset-pipe-A
[271.187171] Dynamic subtest modeset-pipe-A: SUCCESS (3.465s)
[271.196659] Starting dynamic subtest: flip-pipe-D
[272.383846] Dynamic subtest flip-pipe-D: SUCCESS (1.193s)
[272.393423] Starting dynamic subtest: modeset-pipe-D
[275.814235] Dynamic subtest modeset-pipe-D: SUCCESS (3.428s)
[275.817430] Subtest basic-hang: SUCCESS (8.674s)
[276.698329] [072/155] (744s left) kms_hdr (invalid-hdr)
[276.800325] Starting subtest: invalid-hdr
[276.802477] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[280.867244] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.064s)
[280.887626] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[284.851221] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (3.968s)
[284.864839] Subtest invalid-hdr: SUCCESS (8.065s)
[284.955409] [073/155] (736s left) i915_drm_fdinfo (virtual-busy-hang)
[284.995237] Starting subtest: virtual-busy-hang
[284.999568] Subtest virtual-busy-hang: SKIP (0.000s)
[285.056323] [074/155] (736s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[285.106695] Subtest untiled-to-tiled: SKIP (0.000s)
[285.183329] [075/155] (736s left) kms_plane (plane-position-covered)
[285.282922] Starting subtest: plane-position-covered
[286.860808] Starting dynamic subtest: pipe-A-plane-1
[288.122256] Dynamic subtest pipe-A-plane-1: SUCCESS (1.262s)
[288.135992] Starting dynamic subtest: pipe-A-plane-2
[289.407876] Dynamic subtest pipe-A-plane-2: SUCCESS (1.285s)
[289.417847] Starting dynamic subtest: pipe-A-plane-3
[290.666022] Dynamic subtest pipe-A-plane-3: SUCCESS (1.256s)
[290.680447] Starting dynamic subtest: pipe-A-plane-4
[291.910116] Dynamic subtest pipe-A-plane-4: SUCCESS (1.243s)
[291.920115] Starting dynamic subtest: pipe-A-plane-5
[291.937479] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[293.072266] Starting dynamic subtest: pipe-B-plane-1
[294.386321] Dynamic subtest pipe-B-plane-1: SUCCESS (1.323s)
[294.398064] Starting dynamic subtest: pipe-B-plane-2
[295.722363] Dynamic subtest pipe-B-plane-2: SUCCESS (1.336s)
[295.733094] Starting dynamic subtest: pipe-B-plane-3
[297.033560] Dynamic subtest pipe-B-plane-3: SUCCESS (1.308s)
[297.043425] Starting dynamic subtest: pipe-B-plane-4
[298.248110] Dynamic subtest pipe-B-plane-4: SUCCESS (1.215s)
[298.257245] Starting dynamic subtest: pipe-B-plane-5
[298.273842] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[298.276033] Subtest plane-position-covered: SUCCESS (12.989s)
[299.069452] [076/155] (722s left) kms_lease (lease-revoke)
[299.165219] Starting subtest: lease-revoke
[299.167563] Starting dynamic subtest: pipe-A-eDP-1
[299.197379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[299.209267] Starting dynamic subtest: pipe-B-eDP-1
[299.225584] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[299.241473] Starting dynamic subtest: pipe-C-eDP-1
[299.252485] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[299.261830] Starting dynamic subtest: pipe-D-eDP-1
[299.282538] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[299.284778] Subtest lease-revoke: SUCCESS (0.121s)
[299.415833] [077/155] (722s left) perf (invalid-remove-userspace-config)
[299.527830] Starting subtest: invalid-remove-userspace-config
[299.536553] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[299.575259] [078/155] (722s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[299.688280] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[299.692425] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[299.778866] [079/155] (721s left) syncobj_timeline (reset-unsignaled)
[299.838874] Starting subtest: reset-unsignaled
[299.840833] Subtest reset-unsignaled: SUCCESS (0.000s)
[299.923169] [080/155] (721s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[300.469864] Starting subtest: syncobj-timeline-multiple-ext-nodes
[300.472708] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[301.863264] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[301.867039] [081/155] (719s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[301.982767] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[303.449098] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.463s)
[304.322655] [082/155] (717s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[304.425140] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[304.429611] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[304.518782] [083/155] (717s left) kms_prime (d3hot)
[304.598621] Subtest D3hot: SKIP (0.000s)
[304.705184] [084/155] (717s left) api_intel_bb (reset-bb)
[304.757293] Starting subtest: reset-bb
[304.759484] Subtest reset-bb: SUCCESS (0.003s)
[304.881263] [085/155] (717s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[304.985617] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[304.987899] Starting dynamic subtest: pipe-A-eDP-1
[305.045221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[305.340841] Starting dynamic subtest: pipe-B-eDP-1
[306.119990] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.790s)
[306.415060] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.428s)
[307.277642] [086/155] (714s left) kms_cursor_crc (cursor-onscreen-256x256)
[307.530468] Starting subtest: cursor-onscreen-256x256
[307.532798] Starting dynamic subtest: pipe-A-eDP-1
[309.651582] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s)
[309.681102] Starting dynamic subtest: pipe-D-eDP-1
[312.457144] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[312.459655] Subtest cursor-onscreen-256x256: SUCCESS (4.926s)
[313.347481] [087/155] (708s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[313.735897] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[314.555899] [088/155] (707s left) kms_cursor_legacy (torture-move)
[314.680063] Starting subtest: torture-move
[314.682434] Starting dynamic subtest: pipe-A
[321.167631] Dynamic subtest pipe-A: SUCCESS (6.482s)
[321.179826] Starting dynamic subtest: pipe-B
[327.678955] Dynamic subtest pipe-B: SUCCESS (6.508s)
[327.689976] Starting dynamic subtest: pipe-C
[333.745880] Dynamic subtest pipe-C: SUCCESS (6.063s)
[333.756991] Starting dynamic subtest: pipe-D
[339.346865] Dynamic subtest pipe-D: SUCCESS (5.598s)
[339.359083] Starting dynamic subtest: all-pipes
[345.093597] Dynamic subtest all-pipes: SUCCESS (5.742s)
[345.096152] Subtest torture-move: SUCCESS (30.406s)
[345.250529] [089/155] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[345.360983] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[345.365359] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[345.455274] [090/155] (676s left) gem_exec_reloc (basic-write-cpu-noreloc)
[345.513784] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[345.576753] [091/155] (676s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[345.667848] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[345.672145] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[345.772061] [092/155] (676s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[345.865470] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[353.149040] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.288s)
[353.264214] [093/155] (669s left) gem_softpin (allocator-basic)
[353.316828] Starting subtest: allocator-basic
[353.391070] Subtest allocator-basic: SUCCESS (0.074s)
[353.508708] [094/155] (668s left) gem_close_race (multigpu-basic-threads)
[353.574322] Starting subtest: multigpu-basic-threads
[353.578754] Subtest multigpu-basic-threads: SKIP (0.000s)
[353.802153] [095/155] (668s left) gem_madvise (dontneed-before-exec)
[353.835405] Starting subtest: dontneed-before-exec
[353.864460] Subtest dontneed-before-exec: SKIP (0.028s)
[353.933568] [096/155] (668s left) kms_pm_dc (dc5-retention-flops)
[355.041477] Starting subtest: dc5-retention-flops
[355.045876] Subtest dc5-retention-flops: SKIP (0.000s)
[355.112637] [097/155] (667s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[355.226950] Starting subtest: addfb25-yf-tiled-legacy
[355.228886] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[355.334813] [098/155] (667s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[355.437331] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[355.441754] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[355.529485] [099/155] (667s left) gem_exec_balancer (full)
[355.584728] Starting subtest: full
[360.604782] Subtest full: SUCCESS (5.022s)
[360.924639] [100/155] (661s left) sw_sync (alloc_merge_fence)
[360.957652] Starting subtest: alloc_merge_fence
[360.959833] Subtest alloc_merge_fence: SUCCESS (0.000s)
[361.011556] [101/155] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[361.123987] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[361.128015] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[361.211450] [102/155] (661s left) gem_exec_whisper (basic-queues-forked)
[361.268230] Starting subtest: basic-queues-forked
[383.716272] Subtest basic-queues-forked: SUCCESS (22.451s)
[383.951972] [103/155] (638s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[384.221278] Starting subtest: cursor-rapid-movement-256x85
[384.269687] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[384.432204] [104/155] (638s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[384.533048] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[385.734782] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.202s)
[385.868309] [105/155] (636s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[385.968244] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[385.971570] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[386.065521] [106/155] (636s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[386.169485] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[386.173151] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[386.271337] [107/155] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[386.369460] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[393.013384] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.648s)
[393.161530] [108/155] (629s left) kms_setmode (clone-exclusive-crtc)
[393.220079] Starting subtest: clone-exclusive-crtc
[393.226687] Subtest clone-exclusive-crtc: SKIP (0.000s)
[393.313118] [109/155] (629s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[393.412541] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[393.416645] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[393.514581] [110/155] (629s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[393.610450] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[393.614764] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[393.684819] [111/155] (629s left) gem_ctx_param (basic-default)
[393.747708] Starting subtest: basic-default
[393.749999] Subtest basic-default: SUCCESS (0.000s)
[393.822309] [112/155] (629s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[393.920180] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[393.922463] Starting dynamic subtest: pipe-A-eDP-1
[393.944747] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[393.955752] Starting dynamic subtest: pipe-B-eDP-1
[393.976911] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.985612] Starting dynamic subtest: pipe-C-eDP-1
[394.006151] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[394.014777] Starting dynamic subtest: pipe-D-eDP-1
[394.033362] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[394.036829] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[396.181940] [113/155] (626s left) kms_flip (2x-flip-vs-expired-vblank)
[396.278102] Starting subtest: 2x-flip-vs-expired-vblank
[396.286744] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[396.381507] [114/155] (626s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render)
[396.487949] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render
[396.492113] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[396.617683] [115/155] (626s left) kms_psr (pr-cursor-plane-onoff)
[396.718631] Starting subtest: pr-cursor-plane-onoff
[396.722584] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[396.788566] [116/155] (626s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[396.881278] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[396.885664] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[396.980058] [117/155] (626s left) vgem_basic (setversion)
[397.020789] Starting subtest: setversion
[397.025050] Subtest setversion: SUCCESS (0.000s)
[397.091006] [118/155] (626s left) kms_color (ctm-0-50)
[397.176973] Starting subtest: ctm-0-50
[397.178931] Starting dynamic subtest: pipe-A-eDP-1
[400.699480] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.523s)
[400.709246] Starting dynamic subtest: pipe-B-eDP-1
[404.977907] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.276s)
[404.988005] Starting dynamic subtest: pipe-C-eDP-1
[409.051580] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.074s)
[409.061863] Starting dynamic subtest: pipe-D-eDP-1
[413.056067] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.001s)
[413.058358] Subtest ctm-0-50: SUCCESS (15.878s)
[413.861019] [119/155] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[413.970129] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[413.974217] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[414.061289] [120/155] (609s left) perf_pmu (busy-check-all)
[414.101480] Starting subtest: busy-check-all
[414.103646] Starting dynamic subtest: rcs0
[414.650503] Dynamic subtest rcs0: SUCCESS (0.548s)
[414.663308] Starting dynamic subtest: bcs0
[415.201286] Dynamic subtest bcs0: SUCCESS (0.549s)
[415.214005] Starting dynamic subtest: vcs0
[416.792534] Dynamic subtest vcs0: SUCCESS (1.587s)
[416.805354] Starting dynamic subtest: vcs1
[418.776597] Dynamic subtest vcs1: SUCCESS (1.981s)
[418.789312] Starting dynamic subtest: vecs0
[420.762087] Dynamic subtest vecs0: SUCCESS (1.980s)
[420.774727] Starting dynamic subtest: ccs0
[421.319174] Dynamic subtest ccs0: SUCCESS (0.557s)
[421.321984] Subtest busy-check-all: SUCCESS (7.219s)
[421.423828] [121/155] (602s left) gem_exec_reloc (basic-write-cpu-active)
[421.491472] Subtest basic-write-cpu-active: SKIP (0.000s)
[421.568460] [122/155] (601s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[421.622113] Starting subtest: single-wait-all-for-submit-unsubmitted
[421.724597] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[421.827587] [123/155] (601s left) gem_sync (basic-store-each)
[421.899873] Starting subtest: basic-store-each
[424.315150] Subtest basic-store-each: SUCCESS (2.424s)
[424.513255] [124/155] (599s left) kms_content_protection (type1)
[424.647506] Starting subtest: type1
[424.651979] Subtest type1: SKIP (0.000s)
[424.773027] [125/155] (598s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[424.873615] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[424.877987] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[424.973696] [126/155] (598s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[425.086298] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[425.088626] Starting dynamic subtest: pipe-A-eDP-1
[425.170968] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[425.180881] Starting dynamic subtest: pipe-B-eDP-1
[426.341335] Dynamic subtest pipe-B-eDP-1: SKIP (1.168s)
[426.346203] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.259s)
[427.535722] [127/155] (596s left) kms_cursor_edge_walk (256x256-top-bottom)
[427.628539] Starting subtest: 256x256-top-bottom
[427.630802] Starting dynamic subtest: pipe-A-eDP-1
[431.089515] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[431.099903] Starting dynamic subtest: pipe-D-eDP-1
[434.233280] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.142s)
[434.235598] Subtest 256x256-top-bottom: SUCCESS (6.606s)
[435.025627] [128/155] (588s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[435.129358] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[435.133565] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[435.219605] [129/155] (588s left) gem_ctx_param (invalid-get-no-zeromap)
[435.267368] Starting subtest: invalid-get-no-zeromap
[435.269636] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[435.388121] [130/155] (588s left) gem_exec_whisper (basic-fds-priority)
[435.445986] Starting subtest: basic-fds-priority
[459.262643] Subtest basic-fds-priority: SUCCESS (23.813s)
[459.448581] [131/155] (564s left) gen7_exec_parse (load-register-reg)
[459.519042] Subtest load-register-reg: SKIP (0.000s)
[459.595511] [132/155] (564s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[459.861702] Starting subtest: parallel-dmabuf-import-out-fence
[460.943946] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.083s)
[461.059805] [133/155] (562s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[461.152443] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[461.154752] Starting dynamic subtest: pipe-A-eDP-1
[461.299951] Dynamic subtest pipe-A-eDP-1: SKIP (0.150s)
[461.311939] Starting dynamic subtest: pipe-B-eDP-1
[462.504772] Dynamic subtest pipe-B-eDP-1: SKIP (1.202s)
[462.509472] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.355s)
[463.689573] [134/155] (560s left) syncobj_timeline (wait-all-delayed-signal)
[463.739911] Starting subtest: wait-all-delayed-signal
[463.843948] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[463.929537] [135/155] (560s left) syncobj_wait (invalid-signal-one-illegal-handle)
[463.991503] Starting subtest: invalid-signal-one-illegal-handle
[463.993725] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[464.110297] [136/155] (560s left) gem_tiled_pread_pwrite
[464.233594] [137/155] (559s left) gem_lmem_swapping (verify)
[464.276253] Subtest verify: SKIP (0.000s)
[464.322857] [138/155] (559s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[464.425468] Starting subtest: psr-rgb565-draw-render
[471.432120] Subtest psr-rgb565-draw-render: SUCCESS (7.011s)
[471.548948] [139/155] (552s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[471.651388] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[471.655832] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[471.766780] [140/155] (552s left) gem_exec_schedule (preemptive-hang)
[471.948471] Starting subtest: preemptive-hang
[471.951386] Starting dynamic subtest: rcs0
[480.965010] Dynamic subtest rcs0: SUCCESS (9.017s)
[480.976566] Starting dynamic subtest: bcs0
[489.924619] Dynamic subtest bcs0: SUCCESS (8.957s)
[489.934916] Starting dynamic subtest: vcs0
[498.881978] Dynamic subtest vcs0: SUCCESS (8.954s)
[498.893088] Starting dynamic subtest: vcs1
[507.904467] Dynamic subtest vcs1: SUCCESS (9.024s)
[507.917051] Starting dynamic subtest: vecs0
[516.923268] Dynamic subtest vecs0: SUCCESS (9.015s)
[516.938918] Starting dynamic subtest: ccs0
[525.886437] Dynamic subtest ccs0: SUCCESS (8.963s)
[525.889045] Subtest preemptive-hang: SUCCESS (53.939s)
[526.140335] [141/155] (498s left) gem_exec_schedule (reorder-wide)
[526.327680] Subtest reorder-wide: SKIP (0.000s)
[526.517958] [142/155] (497s left) kms_vblank (ts-continuation-modeset)
[526.622438] Starting subtest: ts-continuation-modeset
[526.624226] Starting dynamic subtest: pipe-A-eDP-1
[528.080324] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.458s)
[528.099108] Starting dynamic subtest: pipe-D-eDP-1
[530.246903] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.162s)
[530.248910] Subtest ts-continuation-modeset: SUCCESS (3.624s)
[531.056948] [143/155] (493s left) kms_vblank (crtc-id)
[531.160616] Starting subtest: crtc-id
[531.162864] Starting dynamic subtest: pipe-A-eDP-1
[531.624490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[531.639917] Starting dynamic subtest: pipe-D-eDP-1
[532.794714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.170s)
[532.796935] Subtest crtc-id: SUCCESS (1.635s)
[533.637893] [144/155] (490s left) perf_pmu (idle-no-semaphores)
[533.682503] Starting subtest: idle-no-semaphores
[533.684328] Starting dynamic subtest: rcs0
[534.227611] Dynamic subtest rcs0: SUCCESS (0.545s)
[534.240522] Starting dynamic subtest: bcs0
[534.747332] Dynamic subtest bcs0: SUCCESS (0.516s)
[534.759441] Starting dynamic subtest: vcs0
[535.264623] Dynamic subtest vcs0: SUCCESS (0.514s)
[535.278107] Starting dynamic subtest: vcs1
[535.781457] Dynamic subtest vcs1: SUCCESS (0.514s)
[535.792643] Starting dynamic subtest: vecs0
[536.307784] Dynamic subtest vecs0: SUCCESS (0.523s)
[536.319518] Starting dynamic subtest: ccs0
[536.826107] Dynamic subtest ccs0: SUCCESS (0.515s)
[536.828798] Subtest idle-no-semaphores: SUCCESS (3.146s)
[536.946349] [145/155] (487s left) gem_userptr_blits (create-destroy-unsync)
[537.012604] Subtest create-destroy-unsync: SKIP (0.000s)
[537.125528] [146/155] (487s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[537.226046] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[537.849522] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s)
[537.998594] [147/155] (486s left) kms_rotation_crc (sprite-rotation-270)
[538.085369] Starting subtest: sprite-rotation-270
[538.089531] Subtest sprite-rotation-270: SKIP (0.001s)
[538.156537] [148/155] (486s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[538.264213] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[538.268101] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[538.372874] [149/155] (486s left) i915_pm_freq_api (freq-suspend)
[538.439070] Starting subtest: freq-suspend
[538.441388] Starting dynamic subtest: gt0
[554.838367] Dynamic subtest gt0: SUCCESS (1.197s)
[554.852278] Starting dynamic subtest: gt1
[570.849362] Dynamic subtest gt1: SUCCESS (1.195s)
[570.855865] Subtest freq-suspend: SUCCESS (2.395s)
[570.924103] [150/155] (453s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[571.031201] Starting subtest: fbcpsr-rgb565-draw-pwrite
[578.040705] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.007s)
[578.166693] [151/155] (446s left) gen3_render_linear_blits
[578.277343] [152/155] (446s left) gem_exec_await (wide-all)
[578.522155] Starting subtest: wide-all
[601.765910] Subtest wide-all: SUCCESS (23.236s)
[601.972046] [153/155] (422s left) gem_close (many-handles-one-vma)
[602.081239] Starting subtest: many-handles-one-vma
[602.123757] Subtest many-handles-one-vma: SUCCESS (0.042s)
[602.250722] [154/155] (422s left) kms_plane_scaling (planes-scaler-unity-scaling)
[602.347279] Starting subtest: planes-scaler-unity-scaling
[602.349931] Starting dynamic subtest: pipe-A
[602.409251] Dynamic subtest pipe-A: SUCCESS (0.064s)
[602.421246] Starting dynamic subtest: pipe-B
[603.598343] Dynamic subtest pipe-B: SUCCESS (1.187s)
[603.611056] Starting dynamic subtest: pipe-C
[604.710132] Dynamic subtest pipe-C: SUCCESS (1.108s)
[604.722215] Starting dynamic subtest: pipe-D
[605.831842] Dynamic subtest pipe-D: SUCCESS (1.123s)
[605.834618] Subtest planes-scaler-unity-scaling: SUCCESS (3.487s)
[606.989330] [155/155] (417s left) gem_exec_schedule (smoketest-all)
[607.076500] Starting subtest: smoketest-all
[639.472463] Subtest smoketest-all: SUCCESS (32.344s)
[640.884111] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_mmap_offset
results: parsing output: 5/ for test: gem_pread
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_flip_event_leak
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: fbdev
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_universal_plane
results: parsing output: 25/ for test: kms_plane_multiple
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_feature_discovery
results: parsing output: 33/ for test: gem_exec_async
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: core_setmaster
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_invalid_mode
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_request_retire
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: gem_spin_batch
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: prime_busy
results: parsing output: 61/ for test: i915_suspend
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_plane_lowres
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: api_intel_allocator
results: parsing output: 67/ for test: sw_sync
results: parsing output: 68/ for test: i915_pm_rps
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_busy
results: parsing output: 71/ for test: kms_hdr
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: gem_set_tiling_vs_blt
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_prime
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_chamelium_edid
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: gem_close_race
results: parsing output: 94/ for test: gem_madvise
results: parsing output: 95/ for test: kms_pm_dc
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_balancer
results: parsing output: 99/ for test: sw_sync
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_setmode
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gem_ctx_param
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: vgem_basic
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_sync
results: parsing output: 123/ for test: kms_content_protection
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: kms_cursor_edge_walk
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: gen7_exec_parse
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_psr2_sf
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: syncobj_wait
results: parsing output: 135/ for test: gem_tiled_pread_pwrite
results: parsing output: 136/ for test: gem_lmem_swapping
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_exec_schedule
results: parsing output: 140/ for test: gem_exec_schedule
results: parsing output: 141/ for test: kms_vblank
results: parsing output: 142/ for test: kms_vblank
results: parsing output: 143/ for test: perf_pmu
results: parsing output: 144/ for test: gem_userptr_blits
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: kms_rotation_crc
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: i915_pm_freq_api
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gen3_render_linear_blits
results: parsing output: 151/ for test: gem_exec_await
results: parsing output: 152/ for test: gem_close
results: parsing output: 153/ for test: kms_plane_scaling
results: parsing output: 154/ for test: gem_exec_schedule
Done.