[56.022850] Initializing watchdogs
[56.022900]   /dev/watchdog0
[56.038663] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.043372] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.046097] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.049456] [001/133] (960s left) kms_chamelium_hpd (dp-hpd-fast)
[56.462894] Subtest dp-hpd-fast: SKIP (0.000s)
[57.333745] [002/133] (959s left) gem_ctx_engines (execute-allforone)
[57.404766] Starting subtest: execute-allforone
[57.418858] Subtest execute-allforone: SUCCESS (0.014s)
[59.420948] [003/133] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[59.514070] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[59.518606] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[59.605228] [004/133] (957s left) i915_drm_fdinfo (memory-info-idle)
[59.654956] Starting subtest: memory-info-idle
[59.657282] Starting dynamic subtest: smem0
[59.706927] Dynamic subtest smem0: SUCCESS (0.052s)
[59.709892] Subtest memory-info-idle: SUCCESS (0.052s)
[59.780759] [005/133] (956s left) i915_suspend (sysfs-reader)
[59.843050] Starting subtest: sysfs-reader
[78.199182] Subtest sysfs-reader: SUCCESS (3.205s)
[78.252465] [006/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[78.378244] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[78.381997] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[78.479396] [007/133] (938s left) syncobj_timeline (invalid-query-bad-pad)
[78.544900] Starting subtest: invalid-query-bad-pad
[78.546638] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[78.638873] [008/133] (938s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[78.735259] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[78.737337] Starting dynamic subtest: pipe-A
[78.862753] Dynamic subtest pipe-A: SKIP (0.121s)
[78.871468] Starting dynamic subtest: pipe-B
[80.072248] Dynamic subtest pipe-B: SKIP (1.180s)
[80.081173] Starting dynamic subtest: pipe-C
[81.220885] Dynamic subtest pipe-C: SUCCESS (1.130s)
[81.231399] Starting dynamic subtest: pipe-D
[82.495227] Dynamic subtest pipe-D: SUCCESS (1.251s)
[82.497640] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.683s)
[83.693027] [009/133] (933s left) i915_hangman (error-state-basic)
[83.769635] Starting subtest: error-state-basic
[83.843215] Subtest error-state-basic: SUCCESS (0.072s)
[83.923190] [010/133] (932s left) gem_exec_reloc (basic-write-read-noreloc)
[83.986936] Subtest basic-write-read-noreloc: SKIP (0.000s)
[84.051535] [011/133] (932s left) gem_mmap_offset (open-flood)
[84.108088] Starting subtest: open-flood
[105.697656] Subtest open-flood: SUCCESS (21.489s)
[105.789476] [012/133] (911s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[105.897543] Starting subtest: yf-tiled-addfb-size-offset-overflow
[105.901072] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[105.985251] [013/133] (911s left) gem_mmap_gtt (big-bo-tiledy)
[106.052328] Subtest big-bo-tiledY: SKIP (0.000s)
[106.121359] [014/133] (910s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[106.214972] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[106.218283] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[106.287059] [015/133] (910s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[106.377980] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[106.380023] Starting dynamic subtest: pipe-A-eDP-1
[107.323239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.938s)
[107.332952] Starting dynamic subtest: pipe-B-eDP-1
[108.902546] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.575s)
[108.915812] Starting dynamic subtest: pipe-C-eDP-1
[110.429808] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.524s)
[110.440086] Starting dynamic subtest: pipe-D-eDP-1
[111.968991] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.542s)
[111.971355] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.584s)
[113.119776] [016/133] (904s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[113.221767] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[114.068558] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.848s)
[114.225779] [017/133] (902s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[114.293290] Starting subtest: invalid-bsd2-flag-on-blt
[114.295631] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[114.411587] [018/133] (902s left) kms_cursor_crc (cursor-offscreen-64x64)
[114.608354] Starting subtest: cursor-offscreen-64x64
[114.613385] Starting dynamic subtest: pipe-A-eDP-1
[116.567669] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.954s)
[116.594230] Starting dynamic subtest: pipe-D-eDP-1
[119.157279] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.571s)
[119.159615] Subtest cursor-offscreen-64x64: SUCCESS (4.550s)
[120.008623] [019/133] (897s left) prime_vgem (fence-write-hang)
[120.158847] Subtest fence-write-hang: SKIP (0.000s)
[120.248872] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true
[120.252637] [020/133] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[120.350210] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[127.185188] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.838s)
[127.296314] [021/133] (890s left) vgem_slow (nohang)
[127.349742] Starting subtest: nohang
[137.455031] Subtest nohang: SUCCESS (10.103s)
[137.520559] [022/133] (879s left) syncobj_timeline (single-wait-all-available-signaled)
[137.585862] Starting subtest: single-wait-all-available-signaled
[137.588246] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[137.686016] [023/133] (879s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[137.776915] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[137.781490] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[137.861565] [024/133] (879s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[137.981981] Starting subtest: cursor-vs-flip-legacy
[167.733189] Subtest cursor-vs-flip-legacy: SUCCESS (29.741s)
[168.600456] [025/133] (848s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[168.699461] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[176.042618] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.348s)
[176.173093] [026/133] (841s left) kms_setmode (clone-exclusive-crtc)
[176.237288] Starting subtest: clone-exclusive-crtc
[176.243520] Subtest clone-exclusive-crtc: SKIP (0.000s)
[176.355145] [027/133] (841s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[176.451143] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[183.460823] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.013s)
[183.588303] [028/133] (834s left) gem_exec_balancer (parallel-keep-in-fence)
[183.860855] Starting subtest: parallel-keep-in-fence
[185.096277] Subtest parallel-keep-in-fence: SUCCESS (1.234s)
[185.197183] [029/133] (832s left) fbdev (unaligned-read)
[185.248796] Starting subtest: unaligned-read
[185.264135] Subtest unaligned-read: SUCCESS (0.018s)
[185.332181] [030/133] (832s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[185.421541] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[185.423939] Starting dynamic subtest: pipe-A-eDP-1
[201.916787] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.497s)
[201.927444] Starting dynamic subtest: pipe-B-eDP-1
[219.137332] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.219s)
[219.139699] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.718s)
[220.004687] [031/133] (797s left) gem_ctx_isolation (nonpriv)
[220.077082] Starting subtest: nonpriv
[220.079103] Starting dynamic subtest: rcs0
[220.326065] Dynamic subtest rcs0: SUCCESS (0.251s)
[220.337964] Starting dynamic subtest: bcs0
[220.582987] Dynamic subtest bcs0: SUCCESS (0.256s)
[220.594566] Starting dynamic subtest: vcs0
[220.836866] Dynamic subtest vcs0: SUCCESS (0.253s)
[220.848708] Starting dynamic subtest: vcs1
[222.668101] Dynamic subtest vcs1: SUCCESS (1.830s)
[222.678829] Starting dynamic subtest: vecs0
[224.664786] Dynamic subtest vecs0: SUCCESS (1.995s)
[224.676132] Starting dynamic subtest: ccs0
[226.656413] Dynamic subtest ccs0: SUCCESS (1.990s)
[226.658784] Subtest nonpriv: SUCCESS (6.582s)
[226.913103] [032/133] (790s left) gem_flink_basic (bad-flink)
[226.969900] Starting subtest: bad-flink
[226.971784] Subtest bad-flink: SUCCESS (0.000s)
[227.063520] [033/133] (790s left) gem_exec_fence (invalid-timeline-fence-array)
[227.629803] Starting subtest: invalid-timeline-fence-array
[227.635677] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[229.484451] [034/133] (788s left) kms_psr (psr-dpms)
[229.579883] Starting subtest: psr-dpms
[229.582092] Starting dynamic subtest: eDP-1
[232.553471] Dynamic subtest eDP-1: SUCCESS (2.972s)
[232.555770] Subtest psr-dpms: SUCCESS (2.973s)
[233.409601] [035/133] (784s left) gem_tiled_pread_pwrite
[233.548688] [036/133] (784s left) kms_chamelium_edid (dp-edid-read)
[233.960431] Subtest dp-edid-read: SKIP (0.000s)
[234.731264] [037/133] (783s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[234.828264] Starting subtest: fbcpsr-rgb565-draw-pwrite
[241.969551] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.143s)
[242.082320] [038/133] (775s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[242.184646] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[242.186893] Starting dynamic subtest: pipe-A-default-mode
[244.953467] Dynamic subtest pipe-A-default-mode: SUCCESS (2.769s)
[244.955768] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.771s)
[245.788076] [039/133] (772s left) kms_properties (plane-properties-atomic)
[245.887053] Starting subtest: plane-properties-atomic
[245.889473] Starting dynamic subtest: pipe-A-eDP-1
[246.441517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[246.452683] Starting dynamic subtest: pipe-B-eDP-1
[247.680044] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.238s)
[247.689796] Starting dynamic subtest: pipe-C-eDP-1
[248.914873] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.233s)
[248.924378] Starting dynamic subtest: pipe-D-eDP-1
[250.154784] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[250.157089] Subtest plane-properties-atomic: SUCCESS (4.269s)
[250.973827] [040/133] (767s left) kms_cursor_legacy (torture-bo)
[251.123780] Starting subtest: torture-bo
[251.125983] Starting dynamic subtest: pipe-A
[257.154505] Dynamic subtest pipe-A: SUCCESS (6.026s)
[257.168407] Starting dynamic subtest: pipe-B
[264.211626] Dynamic subtest pipe-B: SUCCESS (7.053s)
[264.223990] Starting dynamic subtest: pipe-C
[270.514959] Dynamic subtest pipe-C: SUCCESS (6.300s)
[270.532975] Starting dynamic subtest: pipe-D
[277.416598] Dynamic subtest pipe-D: SUCCESS (6.898s)
[277.429402] Starting dynamic subtest: all-pipes
[284.494161] Dynamic subtest all-pipes: SUCCESS (7.075s)
[284.496445] Subtest torture-bo: SUCCESS (33.364s)
[284.653530] [041/133] (733s left) prime_busy (after-wait)
[284.709632] Starting subtest: after-wait
[284.714658] Starting dynamic subtest: rcs0
[284.737830] Dynamic subtest rcs0: SUCCESS (0.024s)
[284.747383] Starting dynamic subtest: bcs0
[284.786232] Dynamic subtest bcs0: SUCCESS (0.047s)
[284.801192] Starting dynamic subtest: vcs0
[284.829760] Dynamic subtest vcs0: SUCCESS (0.042s)
[284.844345] Starting dynamic subtest: vcs1
[284.871203] Dynamic subtest vcs1: SUCCESS (0.040s)
[284.880412] Starting dynamic subtest: vecs0
[284.909929] Dynamic subtest vecs0: SUCCESS (0.039s)
[284.921388] Starting dynamic subtest: ccs0
[284.950344] Dynamic subtest ccs0: SUCCESS (0.040s)
[285.056840] Subtest after-wait: SUCCESS (0.345s)
[285.127962] [042/133] (733s left) gem_partial_pwrite_pread (write-uncached)
[285.191340] Subtest write-uncached: SKIP (0.000s)
[285.264698] [043/133] (733s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[285.463467] Starting subtest: cursor-rapid-movement-128x128
[285.468185] Starting dynamic subtest: pipe-A-eDP-1
[286.026023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[286.052376] Starting dynamic subtest: pipe-D-eDP-1
[287.284786] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[287.287233] Subtest cursor-rapid-movement-128x128: SUCCESS (1.817s)
[288.126430] [044/133] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[288.227358] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[288.231886] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[288.340671] [045/133] (730s left) kms_psr (pr-basic)
[288.436128] Starting subtest: pr-basic
[288.440229] Subtest pr-basic: SKIP (0.000s)
[288.509566] [046/133] (729s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[288.602512] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[292.657672] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.057s)
[293.828328] [047/133] (724s left) gem_exec_reloc (basic-write-gtt-active)
[293.890753] Subtest basic-write-gtt-active: SKIP (0.000s)
[293.968055] [048/133] (724s left) gem_exec_schedule (manyslice)
[294.030168] Starting subtest: manyslice
[294.032124] Starting dynamic subtest: rcs0
[299.161846] Dynamic subtest rcs0: SUCCESS (5.139s)
[299.172424] Starting dynamic subtest: bcs0
[305.285872] Dynamic subtest bcs0: SUCCESS (6.123s)
[305.296638] Starting dynamic subtest: vcs0
[311.879788] Dynamic subtest vcs0: SUCCESS (6.594s)
[311.890666] Starting dynamic subtest: vcs1
[317.449476] Dynamic subtest vcs1: SUCCESS (5.569s)
[317.464763] Starting dynamic subtest: vecs0
[323.009960] Dynamic subtest vecs0: SUCCESS (5.559s)
[323.026454] Starting dynamic subtest: ccs0
[329.687917] Dynamic subtest ccs0: SUCCESS (6.677s)
[329.690124] Subtest manyslice: SUCCESS (35.672s)
[329.995678] [049/133] (688s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[330.088566] Starting subtest: async-flip-with-page-flip-events-tiled
[330.474245] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[333.295271] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.820s)
[333.305428] Starting dynamic subtest: pipe-A-eDP-1-4
[335.469987] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[335.479859] Starting dynamic subtest: pipe-A-eDP-1-4
[337.479495] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[337.491975] Starting dynamic subtest: pipe-A-eDP-1-x
[339.691605] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.211s)
[340.060463] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[342.856681] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[342.869603] Starting dynamic subtest: pipe-B-eDP-1-4
[345.015341] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[345.025421] Starting dynamic subtest: pipe-B-eDP-1-4
[347.025298] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[347.038438] Starting dynamic subtest: pipe-B-eDP-1-x
[349.215791] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[349.581798] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[352.348657] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.774s)
[352.359337] Starting dynamic subtest: pipe-C-eDP-1-4
[354.523582] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[354.533626] Starting dynamic subtest: pipe-C-eDP-1-4
[356.534944] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[356.547900] Starting dynamic subtest: pipe-C-eDP-1-x
[358.713298] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[359.075782] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[361.882689] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.814s)
[361.894944] Starting dynamic subtest: pipe-D-eDP-1-4
[364.058153] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[364.070951] Starting dynamic subtest: pipe-D-eDP-1-4
[366.068167] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[366.080656] Starting dynamic subtest: pipe-D-eDP-1-x
[368.246920] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[368.249666] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.159s)
[369.472836] [050/133] (649s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[369.536301] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[369.538600] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[369.639928] [051/133] (648s left) kms_lease (atomic-implicit-crtc)
[369.732888] Starting subtest: atomic-implicit-crtc
[369.735177] Starting dynamic subtest: pipe-A-eDP-1
[369.746575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[369.756773] Starting dynamic subtest: pipe-B-eDP-1
[369.768016] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[369.778043] Starting dynamic subtest: pipe-C-eDP-1
[369.788964] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[369.798445] Starting dynamic subtest: pipe-D-eDP-1
[369.809487] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[369.811381] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[369.873822] [052/133] (648s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[369.966612] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[369.971006] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[370.063991] [053/133] (648s left) syncobj_timeline (32bits-limit)
[370.111390] Starting subtest: 32bits-limit
[370.113859] Subtest 32bits-limit: SUCCESS (0.001s)
[370.217569] [054/133] (648s left) kms_color (ctm-0-50)
[370.310155] Starting subtest: ctm-0-50
[370.312037] Starting dynamic subtest: pipe-A-eDP-1
[373.888771] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.578s)
[373.898491] Starting dynamic subtest: pipe-B-eDP-1
[378.112902] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.224s)
[378.122786] Starting dynamic subtest: pipe-C-eDP-1
[382.149127] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.036s)
[382.159505] Starting dynamic subtest: pipe-D-eDP-1
[386.171011] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.020s)
[386.173176] Subtest ctm-0-50: SUCCESS (15.861s)
[386.969909] [055/133] (631s left) kms_psr (fbc-psr-sprite-blt)
[387.064476] Starting subtest: fbc-psr-sprite-blt
[387.066767] Starting dynamic subtest: eDP-1
[387.070886] Dynamic subtest eDP-1: SKIP (0.000s)
[387.075121] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[387.141208] [056/133] (631s left) kms_pm_lpsp (kms-lpsp)
[388.241175] Starting subtest: kms-lpsp
[388.243374] Starting dynamic subtest: pipe-A-eDP-1
[388.397004] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.157s)
[388.712627] Subtest kms-lpsp: SUCCESS (0.471s)
[389.512685] [057/133] (629s left) gem_exec_schedule (u-independent)
[389.584538] Starting subtest: u-independent
[389.586497] Starting dynamic subtest: rcs0
[391.442508] Dynamic subtest rcs0: SUCCESS (1.866s)
[391.455419] Starting dynamic subtest: vcs0
[393.435795] Dynamic subtest vcs0: SUCCESS (1.991s)
[393.448706] Starting dynamic subtest: vcs1
[395.428389] Dynamic subtest vcs1: SUCCESS (1.989s)
[395.441049] Starting dynamic subtest: vecs0
[397.406470] Dynamic subtest vecs0: SUCCESS (1.976s)
[397.419400] Starting dynamic subtest: ccs0
[399.441001] Dynamic subtest ccs0: SUCCESS (2.032s)
[399.443568] Subtest u-independent: SUCCESS (9.865s)
[399.746838] [058/133] (619s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[399.808010] Starting subtest: yf-tiled-to-vebox-yf-tiled
[399.812423] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[399.996384] [059/133] (618s left) api_intel_bb (purge-bb)
[400.051914] Starting subtest: purge-bb
[400.056526] Subtest purge-bb: SUCCESS (0.007s)
[400.176968] [060/133] (618s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[400.230787] Starting subtest: etime-single-wait-all-available-unsubmitted
[400.332992] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[400.414139] [061/133] (618s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[400.461997] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[400.463880] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[400.552413] [062/133] (618s left) gem_exec_flush (basic-wb-ro-before-default)
[400.615139] Starting subtest: basic-wb-ro-before-default
[406.084491] Subtest basic-wb-ro-before-default: SUCCESS (5.468s)
[406.273634] [063/133] (612s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[406.337167] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[406.339576] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[406.456910] [064/133] (612s left) kms_vblank (ts-continuation-modeset-rpm)
[406.564824] Starting subtest: ts-continuation-modeset-rpm
[406.566674] Starting dynamic subtest: pipe-A-eDP-1
[409.111849] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.547s)
[409.127137] Starting dynamic subtest: pipe-D-eDP-1
[411.370578] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.253s)
[411.372894] Subtest ts-continuation-modeset-rpm: SUCCESS (4.804s)
[412.248745] [065/133] (606s left) gem_ctx_param (non-root-set)
[412.310858] Starting subtest: non-root-set
[412.341777] Subtest non-root-set: SUCCESS (0.031s)
[412.457961] [066/133] (606s left) kms_big_fb (y-tiled-addfb)
[412.556585] Starting subtest: y-tiled-addfb
[412.560879] Subtest y-tiled-addfb: SKIP (0.000s)
[412.663036] [067/133] (606s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[412.794999] Starting subtest: verify-pxp-execution-after-suspend-resume
[419.836202] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.041s)
[419.979798] [068/133] (599s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[420.042119] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[420.105149] [069/133] (599s left) sw_sync (sync_random_merge)
[420.144844] Starting subtest: sync_random_merge
[420.192706] Subtest sync_random_merge: SUCCESS (0.047s)
[420.255514] [070/133] (599s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[420.347276] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[420.351480] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[420.444481] [071/133] (599s left) gem_exec_params (rel-constants-invalid-ring)
[420.508592] Starting subtest: rel-constants-invalid-ring
[420.511122] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[420.612840] [072/133] (598s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[420.708738] Starting subtest: pr-plane-move-sf-dmg-area
[420.712972] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[420.777833] [073/133] (598s left) kms_invalid_mode (uint-max-clock)
[420.867966] Starting subtest: uint-max-clock
[420.869783] Starting dynamic subtest: pipe-A-eDP-1
[421.148620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[421.159191] Starting dynamic subtest: pipe-B-eDP-1
[421.161503] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[421.173610] Starting dynamic subtest: pipe-C-eDP-1
[421.175788] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[421.185601] Starting dynamic subtest: pipe-D-eDP-1
[421.187595] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[421.189576] Subtest uint-max-clock: SUCCESS (0.288s)
[422.024707] [074/133] (597s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[422.119473] Starting subtest: fbc-rgb101010-draw-blt
[426.748688] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.631s)
[427.935185] [075/133] (591s left) gem_lmem_swapping (basic)
[427.971961] Subtest basic: SKIP (0.000s)
[428.025376] [076/133] (591s left) kms_chamelium_color (ctm-0-75)
[428.119666] Subtest ctm-0-75: SKIP (0.000s)
[428.165788] [077/133] (591s left) kms_prop_blob (invalid-get-prop)
[428.217498] Starting subtest: invalid-get-prop
[428.219507] Subtest invalid-get-prop: SUCCESS (0.000s)
[428.331100] [078/133] (591s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[428.420694] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[428.422893] Starting dynamic subtest: pipe-A-eDP-1
[428.890216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[428.901385] Starting dynamic subtest: pipe-B-eDP-1
[430.400504] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s)
[430.411222] Starting dynamic subtest: pipe-C-eDP-1
[431.773076] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[431.784406] Starting dynamic subtest: pipe-D-eDP-1
[433.187906] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.412s)
[433.190139] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.740s)
[434.369211] [079/133] (585s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[434.463285] Starting subtest: fbc-psr2-cursor-plane-onoff
[434.465212] Starting dynamic subtest: eDP-1
[434.469304] Dynamic subtest eDP-1: SKIP (0.000s)
[434.473379] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[434.549612] [080/133] (585s left) gem_userptr_blits (sync-unmap-after-close)
[434.611134] Starting subtest: sync-unmap-after-close
[434.621935] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[434.762225] [081/133] (585s left) gem_ctx_persistence (legacy-engines-cleanup)
[434.821760] Starting subtest: legacy-engines-cleanup
[434.823955] Starting dynamic subtest: render
[434.900519] Dynamic subtest render: SUCCESS (0.078s)
[434.913189] Starting dynamic subtest: bsd1
[434.944578] Dynamic subtest bsd1: SUCCESS (0.041s)
[434.957309] Starting dynamic subtest: bsd2
[434.985355] Dynamic subtest bsd2: SUCCESS (0.038s)
[434.999375] Starting dynamic subtest: blt
[435.042707] Dynamic subtest blt: SUCCESS (0.055s)
[435.057473] Starting dynamic subtest: vebox
[435.110756] Dynamic subtest vebox: SUCCESS (0.065s)
[435.113758] Subtest legacy-engines-cleanup: SUCCESS (0.290s)
[435.213458] [082/133] (584s left) kms_flip (2x-absolute-wf_vblank)
[435.303264] Starting subtest: 2x-absolute-wf_vblank
[435.312033] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[435.395590] [083/133] (584s left) gem_exec_schedule (fairslice)
[435.466141] Starting subtest: fairslice
[435.468044] Starting dynamic subtest: rcs0
[437.484190] Dynamic subtest rcs0: SUCCESS (2.018s)
[437.495024] Starting dynamic subtest: bcs0
[439.501001] Dynamic subtest bcs0: SUCCESS (2.017s)
[439.512540] Starting dynamic subtest: vcs0
[441.522315] Dynamic subtest vcs0: SUCCESS (2.018s)
[441.532776] Starting dynamic subtest: vcs1
[443.541076] Dynamic subtest vcs1: SUCCESS (2.019s)
[443.553549] Starting dynamic subtest: vecs0
[445.559887] Dynamic subtest vecs0: SUCCESS (2.017s)
[445.570809] Starting dynamic subtest: ccs0
[447.580060] Dynamic subtest ccs0: SUCCESS (2.021s)
[447.581917] Subtest fairslice: SUCCESS (12.118s)
[447.882431] [084/133] (572s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[447.975951] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[449.145557] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.169s)
[449.276897] [085/133] (570s left) gem_ctx_param (get-priority-new-ctx)
[449.324082] Starting subtest: get-priority-new-ctx
[449.326009] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[449.417314] [086/133] (570s left) kms_frontbuffer_tracking (fbc-stridechange)
[449.508678] Starting subtest: fbc-stridechange
[452.751384] Subtest fbc-stridechange: SUCCESS (3.243s)
[453.881197] [087/133] (566s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[453.979760] Starting subtest: yf-tiled-16bpp-rotate-180
[453.984119] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[454.086219] [088/133] (566s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[454.177774] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[454.182296] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[455.306687] [089/133] (564s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[455.414699] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[455.418915] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[455.524811] [090/133] (564s left) gen9_exec_parse (cmd-crossing-page)
[455.586979] Subtest cmd-crossing-page: SKIP (0.000s)
[455.661219] [091/133] (564s left) gem_mmap (pf-nonblock)
[455.724252] Subtest pf-nonblock: SKIP (0.000s)
[455.785907] [092/133] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[455.885002] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[465.276107] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.391s)
[465.439594] [093/133] (554s left) gem_exec_whisper (basic-normal)
[465.513687] Starting subtest: basic-normal
[469.002284] Subtest basic-normal: SUCCESS (3.486s)
[469.186764] [094/133] (551s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[469.297010] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[469.299302] Starting dynamic subtest: pipe-A-eDP-1
[469.322481] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[469.335411] Starting dynamic subtest: pipe-B-eDP-1
[469.357391] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[469.367528] Starting dynamic subtest: pipe-C-eDP-1
[469.389549] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[469.399887] Starting dynamic subtest: pipe-D-eDP-1
[469.421964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[469.426033] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[471.547671] [095/133] (548s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[471.644610] Starting subtest: plane-upscale-factor-0-25-with-rotation
[471.647045] Starting dynamic subtest: pipe-A
[471.869493] Dynamic subtest pipe-A: SUCCESS (0.226s)
[471.880032] Starting dynamic subtest: pipe-B
[473.129017] Dynamic subtest pipe-B: SUCCESS (1.259s)
[473.140427] Starting dynamic subtest: pipe-C
[474.477937] Dynamic subtest pipe-C: SUCCESS (1.346s)
[474.488509] Starting dynamic subtest: pipe-D
[475.792012] Dynamic subtest pipe-D: SUCCESS (1.313s)
[475.794468] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.151s)
[476.993508] [096/133] (543s left) gem_ctx_sseu (invalid-sseu)
[477.066118] Subtest invalid-sseu: SKIP (0.000s)
[477.129360] [097/133] (543s left) gem_unfence_active_buffers
[477.288972] [098/133] (543s left) kms_addfb_basic (too-wide)
[477.377592] Starting subtest: too-wide
[477.379881] Subtest too-wide: SUCCESS (0.000s)
[477.482943] [099/133] (543s left) gem_mmap (bad-size)
[477.540786] Subtest bad-size: SKIP (0.000s)
[477.608233] [100/133] (543s left) gem_exec_flush (basic-uc-set-default)
[477.672294] Starting subtest: basic-uc-set-default
[483.168126] Subtest basic-uc-set-default: SUCCESS (5.495s)
[483.354117] [101/133] (537s left) kms_content_protection (mei-interface)
[483.501474] Starting subtest: mei-interface
[483.506153] Subtest mei-interface: SKIP (0.001s)
[483.617171] [102/133] (537s left) kms_flip (flip-vs-fences)
[483.710600] Starting subtest: flip-vs-fences
[483.714813] Subtest flip-vs-fences: SKIP (0.000s)
[483.815427] [103/133] (537s left) gem_vm_create (invalid-destroy)
[483.860188] Starting subtest: invalid-destroy
[483.862674] Subtest invalid-destroy: SUCCESS (0.002s)
[483.959529] [104/133] (536s left) sw_sync (sync_multi_producer_single_consumer)
[484.003900] Starting subtest: sync_multi_producer_single_consumer
[485.078051] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[485.140521] [105/133] (535s left) kms_busy (extended-pageflip-hang-oldfb)
[485.225456] Starting subtest: extended-pageflip-hang-oldfb
[485.227888] Starting dynamic subtest: pipe-A
[485.617515] Dynamic subtest pipe-A: SUCCESS (0.390s)
[485.628302] Starting dynamic subtest: pipe-D
[486.706308] Dynamic subtest pipe-D: SUCCESS (1.087s)
[486.708772] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.482s)
[487.559637] [106/133] (533s left) kms_vrr (flipline)
[487.651890] Starting subtest: flipline
[487.658362] Subtest flipline: SKIP (0.000s)
[487.726222] [107/133] (533s left) gem_bad_reloc (negative-reloc-bltcopy)
[487.782405] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[487.859000] [108/133] (533s left) kms_cursor_crc (cursor-suspend)
[487.973365] Starting subtest: cursor-suspend
[487.975613] Starting dynamic subtest: pipe-A-eDP-1
[520.744460] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.225s)
[520.756015] Starting dynamic subtest: pipe-D-eDP-1
[554.678953] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.758s)
[554.681388] Subtest cursor-suspend: SUCCESS (6.988s)
[555.533088] [109/133] (465s left) syncobj_basic (illegal-fd-to-handle)
[555.591375] Starting subtest: illegal-fd-to-handle
[555.593602] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[555.690902] [110/133] (465s left) kms_pm_rpm (pm-caching)
[557.234581] Starting subtest: pm-caching
[557.239618] Subtest pm-caching: SKIP (0.000s)
[558.033221] [111/133] (463s left) perf_pmu (render-node-busy)
[558.102350] Starting subtest: render-node-busy
[558.104791] Starting dynamic subtest: rcs0
[558.711278] Dynamic subtest rcs0: SUCCESS (0.598s)
[558.724459] Starting dynamic subtest: bcs0
[559.274880] Dynamic subtest bcs0: SUCCESS (0.553s)
[559.288290] Starting dynamic subtest: vcs0
[561.016688] Dynamic subtest vcs0: SUCCESS (1.714s)
[561.030670] Starting dynamic subtest: vcs1
[563.063929] Dynamic subtest vcs1: SUCCESS (2.022s)
[563.078716] Starting dynamic subtest: vecs0
[565.047567] Dynamic subtest vecs0: SUCCESS (1.965s)
[565.062446] Starting dynamic subtest: ccs0
[565.622736] Dynamic subtest ccs0: SUCCESS (0.570s)
[565.625309] Subtest render-node-busy: SUCCESS (7.437s)
[565.703077] [112/133] (455s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[565.809774] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[565.813724] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[565.899174] [113/133] (455s left) kms_universal_plane (universal-plane-pageflip-windowed)
[565.993433] Starting subtest: universal-plane-pageflip-windowed
[565.995784] Starting dynamic subtest: pipe-A-eDP-1
[566.598816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[566.610880] Starting dynamic subtest: pipe-B-eDP-1
[567.840309] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s)
[567.851378] Starting dynamic subtest: pipe-C-eDP-1
[569.056609] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s)
[569.068384] Starting dynamic subtest: pipe-D-eDP-1
[570.291363] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[570.293733] Subtest universal-plane-pageflip-windowed: SUCCESS (4.279s)
[571.142550] [114/133] (450s left) syncobj_wait (wait-all-interrupted)
[571.195145] Starting subtest: wait-all-interrupted
[571.300461] Subtest wait-all-interrupted: SUCCESS (0.104s)
[571.392141] [115/133] (449s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[571.488624] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[578.382371] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.880s)
[578.508539] [116/133] (442s left) syncobj_basic (bad-create-flags)
[578.572938] Starting subtest: bad-create-flags
[578.574931] Subtest bad-create-flags: SUCCESS (0.000s)
[578.690793] [117/133] (442s left) kms_async_flips (test-time-stamp-atomic)
[578.782398] Starting subtest: test-time-stamp-atomic
[579.166949] Starting dynamic subtest: pipe-A-eDP-1
[579.992283] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s)
[580.383373] Starting dynamic subtest: pipe-B-eDP-1
[581.133179] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.755s)
[581.520831] Starting dynamic subtest: pipe-C-eDP-1
[582.281559] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[582.650281] Starting dynamic subtest: pipe-D-eDP-1
[583.405899] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.761s)
[583.408337] Subtest test-time-stamp-atomic: SUCCESS (4.618s)
[584.562140] [118/133] (436s left) syncobj_timeline (wait-delayed-signal)
[584.618475] Starting subtest: wait-delayed-signal
[584.719685] Subtest wait-delayed-signal: SUCCESS (0.102s)
[584.809659] [119/133] (436s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[584.866922] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[584.938524] [120/133] (436s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[585.040899] Starting subtest: psr-2p-primscrn-cur-indfb-move
[585.045364] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[585.139855] [121/133] (436s left) core_setmaster (master-drop-set-user)
[585.232676] Starting subtest: master-drop-set-user
[585.244900] Subtest master-drop-set-user: SUCCESS (0.014s)
[585.287492] [122/133] (436s left) perf (per-context-mode-unprivileged)
[585.409749] Starting subtest: per-context-mode-unprivileged
[585.413735] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[585.453761] [123/133] (436s left) kms_psr (psr2-no-drrs)
[585.542809] Starting subtest: psr2-no-drrs
[585.544702] Starting dynamic subtest: eDP-1
[587.127064] Dynamic subtest eDP-1: SUCCESS (1.583s)
[587.129379] Subtest psr2-no-drrs: SUCCESS (1.584s)
[587.938582] [124/133] (433s left) gem_exec_nop (basic-parallel)
[588.008756] Starting subtest: basic-parallel
[603.065845] Subtest basic-parallel: SUCCESS (15.063s)
[603.295282] [125/133] (418s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[603.397309] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[603.424133] Starting dynamic subtest: pipe-A-plane-0
[603.724098] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[603.736387] Starting dynamic subtest: pipe-A-plane-3
[603.958822] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[605.033699] Starting dynamic subtest: pipe-B-plane-0
[605.336069] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[605.349013] Starting dynamic subtest: pipe-B-plane-3
[605.580174] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[605.895487] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.498s)
[606.713736] [126/133] (415s left) kms_big_fb (4-tiled-addfb-size-overflow)
[606.815367] Starting subtest: 4-tiled-addfb-size-overflow
[606.817490] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[606.912230] [127/133] (414s left) gem_spin_batch (resubmit-new-all)
[606.969891] Starting subtest: resubmit-new-all
[606.972116] Starting dynamic subtest: rcs0
[606.988049] Dynamic subtest rcs0: SUCCESS (0.018s)
[606.999398] Starting dynamic subtest: bcs0
[607.004042] Dynamic subtest bcs0: SUCCESS (0.015s)
[607.015389] Starting dynamic subtest: vcs0
[607.017171] Dynamic subtest vcs0: SUCCESS (0.009s)
[607.028450] Starting dynamic subtest: vcs1
[607.030533] Dynamic subtest vcs1: SUCCESS (0.011s)
[607.041163] Starting dynamic subtest: vecs0
[607.043009] Dynamic subtest vecs0: SUCCESS (0.009s)
[607.053474] Starting dynamic subtest: ccs0
[607.055572] Dynamic subtest ccs0: SUCCESS (0.010s)
[607.057656] Subtest resubmit-new-all: SUCCESS (0.075s)
[609.056759] [128/133] (412s left) syncobj_wait (reset-multiple-signaled)
[609.108188] Starting subtest: reset-multiple-signaled
[609.110499] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[609.224792] [129/133] (412s left) gem_exec_balancer (full-late-pulse)
[609.309535] Starting subtest: full-late-pulse
[613.940124] Subtest full-late-pulse: SUCCESS (4.628s)
[614.288273] [130/133] (407s left) i915_pm_rpm (gem-mmap-type)
[616.218465] Starting subtest: gem-mmap-type
[616.220933] Starting dynamic subtest: wb-smem0
[619.997466] Dynamic subtest wb-smem0: SUCCESS (3.779s)
[620.008995] Starting dynamic subtest: wc-smem0
[623.169104] Dynamic subtest wc-smem0: SUCCESS (3.171s)
[623.180624] Starting dynamic subtest: uc-smem0
[626.028990] Dynamic subtest uc-smem0: SUCCESS (2.855s)
[626.031191] Subtest gem-mmap-type: SUCCESS (9.808s)
[626.131004] [131/133] (395s left) kms_dsc (dsc-with-formats)
[626.236754] Starting subtest: dsc-with-formats
[626.276812] Subtest dsc-with-formats: SKIP (0.001s)
[626.327771] [132/133] (395s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[626.416078] Starting subtest: stress-xrgb8888-yftiled
[626.420593] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[626.502284] [133/133] (395s left) sw_sync (sync_expired_merge)
[626.548499] Starting subtest: sync_expired_merge
[627.618834] Subtest sync_expired_merge: SUCCESS (1.074s)
[627.687344] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: gem_ctx_engines
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: i915_suspend
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: i915_hangman
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: prime_vgem
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: vgem_slow
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_setmode
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: fbdev
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: gem_ctx_isolation
results: parsing output: 31/ for test: gem_flink_basic
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_tiled_pread_pwrite
results: parsing output: 35/ for test: kms_chamelium_edid
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: kms_properties
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: prime_busy
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_lease
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_color
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_pm_lpsp
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_exec_flush
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: gem_ctx_param
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_pxp
results: parsing output: 67/ for test: gem_mmap_wc
results: parsing output: 68/ for test: sw_sync
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_invalid_mode
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_lmem_swapping
results: parsing output: 75/ for test: kms_chamelium_color
results: parsing output: 76/ for test: kms_prop_blob
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: gem_mmap
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_whisper
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: gem_ctx_sseu
results: parsing output: 96/ for test: gem_unfence_active_buffers
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: gem_mmap
results: parsing output: 99/ for test: gem_exec_flush
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: gem_vm_create
results: parsing output: 103/ for test: sw_sync
results: parsing output: 104/ for test: kms_busy
results: parsing output: 105/ for test: kms_vrr
results: parsing output: 106/ for test: gem_bad_reloc
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: syncobj_basic
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_universal_plane
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_basic
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_pipe_b_c_ivb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: core_setmaster
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_exec_nop
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_spin_batch
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: i915_pm_rpm
results: parsing output: 130/ for test: kms_dsc
results: parsing output: 131/ for test: kms_pipe_stress
results: parsing output: 132/ for test: sw_sync
Done.