[57.136037] Initializing watchdogs
[57.136130]   /dev/watchdog0
[57.152909] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.157882] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.160378] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.163869] [001/133] (960s left) kms_chamelium_hpd (dp-hpd-fast)
[57.582724] Subtest dp-hpd-fast: SKIP (0.000s)
[58.443533] [002/133] (959s left) gem_ctx_engines (execute-allforone)
[58.515455] Starting subtest: execute-allforone
[58.529784] Subtest execute-allforone: SUCCESS (0.014s)
[60.365913] [003/133] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[60.462318] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[60.466589] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[60.573948] [004/133] (957s left) i915_drm_fdinfo (memory-info-idle)
[60.616556] Starting subtest: memory-info-idle
[60.618733] Starting dynamic subtest: smem0
[60.661904] Dynamic subtest smem0: SUCCESS (0.047s)
[60.664594] Subtest memory-info-idle: SUCCESS (0.047s)
[60.740160] [005/133] (957s left) i915_suspend (sysfs-reader)
[60.800058] Starting subtest: sysfs-reader
[79.136329] Subtest sysfs-reader: SUCCESS (3.217s)
[79.181138] [006/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[79.305871] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[79.310078] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[79.396948] [007/133] (938s left) syncobj_timeline (invalid-query-bad-pad)
[79.459060] Starting subtest: invalid-query-bad-pad
[79.461433] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[79.602270] [008/133] (938s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[79.689928] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[79.691947] Starting dynamic subtest: pipe-A
[79.817775] Dynamic subtest pipe-A: SKIP (0.122s)
[79.826312] Starting dynamic subtest: pipe-B
[81.021694] Dynamic subtest pipe-B: SKIP (1.179s)
[81.032303] Starting dynamic subtest: pipe-C
[82.256442] Dynamic subtest pipe-C: SUCCESS (1.219s)
[82.267895] Starting dynamic subtest: pipe-D
[83.497376] Dynamic subtest pipe-D: SUCCESS (1.223s)
[83.499782] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.744s)
[84.714789] [009/133] (933s left) i915_hangman (error-state-basic)
[84.783693] Starting subtest: error-state-basic
[84.858613] Subtest error-state-basic: SUCCESS (0.075s)
[84.933946] [010/133] (933s left) gem_exec_reloc (basic-write-read-noreloc)
[84.997716] Subtest basic-write-read-noreloc: SKIP (0.000s)
[85.052779] [011/133] (933s left) gem_mmap_offset (open-flood)
[85.106603] Starting subtest: open-flood
[106.678336] Subtest open-flood: SUCCESS (21.491s)
[106.786124] [012/133] (911s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[106.893795] Starting subtest: yf-tiled-addfb-size-offset-overflow
[106.897411] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[106.985651] [013/133] (911s left) gem_mmap_gtt (big-bo-tiledy)
[107.031619] Subtest big-bo-tiledY: SKIP (0.000s)
[107.093125] [014/133] (911s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[107.187544] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[107.191365] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[107.273311] [015/133] (910s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[107.372051] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[107.374154] Starting dynamic subtest: pipe-A-eDP-1
[108.331351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.952s)
[108.341249] Starting dynamic subtest: pipe-B-eDP-1
[110.045366] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.708s)
[110.055946] Starting dynamic subtest: pipe-C-eDP-1
[111.630516] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.584s)
[111.641613] Starting dynamic subtest: pipe-D-eDP-1
[113.275083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.644s)
[113.277224] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.892s)
[114.433692] [016/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[114.536788] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[115.405590] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.870s)
[115.575880] [017/133] (902s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[115.656828] Starting subtest: invalid-bsd2-flag-on-blt
[115.659039] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[115.756137] [018/133] (902s left) kms_cursor_crc (cursor-offscreen-64x64)
[115.930468] Starting subtest: cursor-offscreen-64x64
[115.932763] Starting dynamic subtest: pipe-A-eDP-1
[117.897123] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.963s)
[117.928916] Starting dynamic subtest: pipe-D-eDP-1
[120.575834] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.656s)
[120.578189] Subtest cursor-offscreen-64x64: SUCCESS (4.647s)
[121.408389] [019/133] (896s left) prime_vgem (fence-write-hang)
[121.551239] Subtest fence-write-hang: SKIP (0.000s)
[121.656518] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true
[121.659943] [020/133] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[121.754357] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[128.756643] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (7.004s)
[128.869532] [021/133] (889s left) vgem_slow (nohang)
[128.912800] Starting subtest: nohang
[138.961132] Subtest nohang: SUCCESS (10.045s)
[139.045030] [022/133] (879s left) syncobj_timeline (single-wait-all-available-signaled)
[139.098411] Starting subtest: single-wait-all-available-signaled
[139.100868] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[139.206705] [023/133] (879s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[139.306618] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[139.311083] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[139.379279] [024/133] (879s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[139.496027] Starting subtest: cursor-vs-flip-legacy
[169.319403] Subtest cursor-vs-flip-legacy: SUCCESS (29.811s)
[170.159623] [025/133] (848s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[170.260594] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[177.642020] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.384s)
[177.768200] [026/133] (840s left) kms_setmode (clone-exclusive-crtc)
[177.832508] Starting subtest: clone-exclusive-crtc
[177.839156] Subtest clone-exclusive-crtc: SKIP (0.000s)
[177.938482] [027/133] (840s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[178.033348] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[185.207441] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.177s)
[185.324182] [028/133] (833s left) gem_exec_balancer (parallel-keep-in-fence)
[185.586342] Starting subtest: parallel-keep-in-fence
[186.797073] Subtest parallel-keep-in-fence: SUCCESS (1.211s)
[186.912591] [029/133] (831s left) fbdev (unaligned-read)
[186.946505] Starting subtest: unaligned-read
[186.960622] Subtest unaligned-read: SUCCESS (0.015s)
[187.016131] [030/133] (831s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[187.117926] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[187.120164] Starting dynamic subtest: pipe-A-eDP-1
[203.597046] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.485s)
[203.607365] Starting dynamic subtest: pipe-B-eDP-1
[220.763172] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.163s)
[220.765617] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.652s)
[221.637903] [031/133] (797s left) gem_ctx_isolation (nonpriv)
[221.711098] Starting subtest: nonpriv
[221.713762] Starting dynamic subtest: rcs0
[221.953741] Dynamic subtest rcs0: SUCCESS (0.242s)
[221.964129] Starting dynamic subtest: bcs0
[222.207691] Dynamic subtest bcs0: SUCCESS (0.253s)
[222.220246] Starting dynamic subtest: vcs0
[222.460450] Dynamic subtest vcs0: SUCCESS (0.252s)
[222.472238] Starting dynamic subtest: vcs1
[223.634785] Dynamic subtest vcs1: SUCCESS (1.173s)
[223.648070] Starting dynamic subtest: vecs0
[225.655357] Dynamic subtest vecs0: SUCCESS (2.019s)
[225.667852] Starting dynamic subtest: ccs0
[227.646471] Dynamic subtest ccs0: SUCCESS (1.989s)
[227.648885] Subtest nonpriv: SUCCESS (5.935s)
[227.884061] [032/133] (791s left) gem_flink_basic (bad-flink)
[227.937896] Starting subtest: bad-flink
[227.940360] Subtest bad-flink: SUCCESS (0.000s)
[228.035504] [033/133] (790s left) gem_exec_fence (invalid-timeline-fence-array)
[228.607069] Starting subtest: invalid-timeline-fence-array
[228.613747] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[230.464191] [034/133] (788s left) kms_psr (psr-dpms)
[230.567548] Starting subtest: psr-dpms
[230.569873] Starting dynamic subtest: eDP-1
[233.548266] Dynamic subtest eDP-1: SUCCESS (2.980s)
[233.551235] Subtest psr-dpms: SUCCESS (2.981s)
[234.425097] [035/133] (784s left) gem_tiled_pread_pwrite
[234.543058] [036/133] (784s left) kms_chamelium_edid (dp-edid-read)
[234.943616] Subtest dp-edid-read: SKIP (0.000s)
[235.743768] [037/133] (783s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[235.846642] Starting subtest: fbcpsr-rgb565-draw-pwrite
[243.007677] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.163s)
[243.143393] [038/133] (776s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[243.240683] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[243.242977] Starting dynamic subtest: pipe-A-default-mode
[246.037965] Dynamic subtest pipe-A-default-mode: SUCCESS (2.796s)
[246.040396] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.798s)
[246.868188] [039/133] (772s left) kms_properties (plane-properties-atomic)
[246.954748] Starting subtest: plane-properties-atomic
[246.956977] Starting dynamic subtest: pipe-A-eDP-1
[247.513179] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[247.523624] Starting dynamic subtest: pipe-B-eDP-1
[248.748763] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.234s)
[248.759906] Starting dynamic subtest: pipe-C-eDP-1
[249.986616] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[249.997809] Starting dynamic subtest: pipe-D-eDP-1
[251.219042] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[251.220990] Subtest plane-properties-atomic: SUCCESS (4.263s)
[252.021792] [040/133] (767s left) kms_cursor_legacy (torture-bo)
[252.149093] Starting subtest: torture-bo
[252.151308] Starting dynamic subtest: pipe-A
[257.896392] Dynamic subtest pipe-A: SUCCESS (5.741s)
[257.912216] Starting dynamic subtest: pipe-B
[264.362906] Dynamic subtest pipe-B: SUCCESS (6.462s)
[264.381526] Starting dynamic subtest: pipe-C
[271.637967] Dynamic subtest pipe-C: SUCCESS (7.270s)
[271.648891] Starting dynamic subtest: pipe-D
[278.829009] Dynamic subtest pipe-D: SUCCESS (7.186s)
[278.839485] Starting dynamic subtest: all-pipes
[285.386999] Dynamic subtest all-pipes: SUCCESS (6.553s)
[285.389960] Subtest torture-bo: SUCCESS (33.226s)
[285.553778] [041/133] (733s left) prime_busy (after-wait)
[285.609060] Starting subtest: after-wait
[285.614178] Starting dynamic subtest: rcs0
[285.650735] Dynamic subtest rcs0: SUCCESS (0.039s)
[285.663595] Starting dynamic subtest: bcs0
[285.697964] Dynamic subtest bcs0: SUCCESS (0.047s)
[285.708842] Starting dynamic subtest: vcs0
[285.741022] Dynamic subtest vcs0: SUCCESS (0.042s)
[285.751627] Starting dynamic subtest: vcs1
[285.782811] Dynamic subtest vcs1: SUCCESS (0.040s)
[285.793038] Starting dynamic subtest: vecs0
[285.823777] Dynamic subtest vecs0: SUCCESS (0.040s)
[285.834224] Starting dynamic subtest: ccs0
[285.864760] Dynamic subtest ccs0: SUCCESS (0.040s)
[285.973924] Subtest after-wait: SUCCESS (0.363s)
[286.048900] [042/133] (733s left) gem_partial_pwrite_pread (write-uncached)
[286.104607] Subtest write-uncached: SKIP (0.000s)
[286.175934] [043/133] (733s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[286.379397] Starting subtest: cursor-rapid-movement-128x128
[286.384367] Starting dynamic subtest: pipe-A-eDP-1
[286.955537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[286.988325] Starting dynamic subtest: pipe-D-eDP-1
[288.144219] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.163s)
[288.146261] Subtest cursor-rapid-movement-128x128: SUCCESS (1.762s)
[288.976547] [044/133] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[289.068075] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[289.072143] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[289.170393] [045/133] (730s left) kms_psr (pr-basic)
[289.272946] Starting subtest: pr-basic
[289.277041] Subtest pr-basic: SKIP (0.000s)
[289.364021] [046/133] (730s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[289.461106] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[293.501898] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.043s)
[294.699024] [047/133] (724s left) gem_exec_reloc (basic-write-gtt-active)
[294.762696] Subtest basic-write-gtt-active: SKIP (0.000s)
[294.828569] [048/133] (724s left) gem_exec_schedule (manyslice)
[294.908955] Starting subtest: manyslice
[294.911176] Starting dynamic subtest: rcs0
[300.055722] Dynamic subtest rcs0: SUCCESS (5.150s)
[300.069397] Starting dynamic subtest: bcs0
[306.697274] Dynamic subtest bcs0: SUCCESS (6.641s)
[306.710300] Starting dynamic subtest: vcs0
[312.783319] Dynamic subtest vcs0: SUCCESS (6.086s)
[312.797990] Starting dynamic subtest: vcs1
[318.867039] Dynamic subtest vcs1: SUCCESS (6.082s)
[318.878197] Starting dynamic subtest: vecs0
[324.439212] Dynamic subtest vecs0: SUCCESS (5.573s)
[324.450862] Starting dynamic subtest: ccs0
[331.130486] Dynamic subtest ccs0: SUCCESS (6.690s)
[331.133321] Subtest manyslice: SUCCESS (36.233s)
[331.439986] [049/133] (688s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[331.527687] Starting subtest: async-flip-with-page-flip-events-tiled
[331.901049] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[334.656899] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.755s)
[334.667167] Starting dynamic subtest: pipe-A-eDP-1-4
[336.842801] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[336.856154] Starting dynamic subtest: pipe-A-eDP-1-4
[338.852074] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[338.865428] Starting dynamic subtest: pipe-A-eDP-1-x
[341.032666] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.179s)
[341.413874] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[344.184383] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[344.197662] Starting dynamic subtest: pipe-B-eDP-1-4
[346.369643] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[346.382441] Starting dynamic subtest: pipe-B-eDP-1-4
[348.379959] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[348.394693] Starting dynamic subtest: pipe-B-eDP-1-x
[350.580128] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[350.949807] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[353.713803] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.772s)
[353.724313] Starting dynamic subtest: pipe-C-eDP-1-4
[355.888503] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[355.899128] Starting dynamic subtest: pipe-C-eDP-1-4
[357.898503] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[357.911699] Starting dynamic subtest: pipe-C-eDP-1-x
[360.088191] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.188s)
[360.452888] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[363.243543] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[363.254421] Starting dynamic subtest: pipe-D-eDP-1-4
[365.418398] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[365.431553] Starting dynamic subtest: pipe-D-eDP-1-4
[367.427892] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[367.439503] Starting dynamic subtest: pipe-D-eDP-1-x
[369.617307] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[369.620195] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.093s)
[370.837819] [050/133] (648s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[370.900474] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[370.902823] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[370.998946] [051/133] (648s left) kms_lease (atomic-implicit-crtc)
[371.098716] Starting subtest: atomic-implicit-crtc
[371.102737] Starting dynamic subtest: pipe-A-eDP-1
[371.116047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[371.126622] Starting dynamic subtest: pipe-B-eDP-1
[371.137748] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[371.147790] Starting dynamic subtest: pipe-C-eDP-1
[371.157738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[371.167317] Starting dynamic subtest: pipe-D-eDP-1
[371.177525] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[371.179378] Subtest atomic-implicit-crtc: SUCCESS (0.042s)
[371.250967] [052/133] (648s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[371.356001] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[371.360554] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.457005] [053/133] (648s left) syncobj_timeline (32bits-limit)
[371.512445] Starting subtest: 32bits-limit
[371.514263] Subtest 32bits-limit: SUCCESS (0.002s)
[371.615830] [054/133] (648s left) kms_color (ctm-0-50)
[371.703753] Starting subtest: ctm-0-50
[371.705905] Starting dynamic subtest: pipe-A-eDP-1
[375.234614] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.529s)
[375.245183] Starting dynamic subtest: pipe-B-eDP-1
[379.524201] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.289s)
[379.534465] Starting dynamic subtest: pipe-C-eDP-1
[383.585613] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.063s)
[383.596414] Starting dynamic subtest: pipe-D-eDP-1
[387.568087] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.981s)
[387.570513] Subtest ctm-0-50: SUCCESS (15.865s)
[388.398264] [055/133] (631s left) kms_psr (fbc-psr-sprite-blt)
[388.503731] Starting subtest: fbc-psr-sprite-blt
[388.506008] Starting dynamic subtest: eDP-1
[388.510170] Dynamic subtest eDP-1: SKIP (0.000s)
[388.515059] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[388.594808] [056/133] (631s left) kms_pm_lpsp (kms-lpsp)
[389.705961] Starting subtest: kms-lpsp
[389.707872] Starting dynamic subtest: pipe-A-eDP-1
[389.852613] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[390.162300] Subtest kms-lpsp: SUCCESS (0.458s)
[391.038936] [057/133] (628s left) gem_exec_schedule (u-independent)
[391.104200] Starting subtest: u-independent
[391.106136] Starting dynamic subtest: rcs0
[392.371894] Dynamic subtest rcs0: SUCCESS (1.273s)
[392.385278] Starting dynamic subtest: vcs0
[394.365334] Dynamic subtest vcs0: SUCCESS (1.989s)
[394.379262] Starting dynamic subtest: vcs1
[396.414351] Dynamic subtest vcs1: SUCCESS (2.046s)
[396.427751] Starting dynamic subtest: vecs0
[398.395397] Dynamic subtest vecs0: SUCCESS (1.980s)
[398.408949] Starting dynamic subtest: ccs0
[400.370042] Dynamic subtest ccs0: SUCCESS (1.972s)
[400.372636] Subtest u-independent: SUCCESS (9.272s)
[400.675105] [058/133] (619s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[400.734837] Starting subtest: yf-tiled-to-vebox-yf-tiled
[400.739290] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[400.921813] [059/133] (619s left) api_intel_bb (purge-bb)
[400.978807] Starting subtest: purge-bb
[400.983994] Subtest purge-bb: SUCCESS (0.006s)
[401.116868] [060/133] (619s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[401.172282] Starting subtest: etime-single-wait-all-available-unsubmitted
[401.278357] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s)
[401.362643] [061/133] (618s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[401.421990] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[401.424027] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[401.546516] [062/133] (618s left) gem_exec_flush (basic-wb-ro-before-default)
[401.607700] Starting subtest: basic-wb-ro-before-default
[407.076247] Subtest basic-wb-ro-before-default: SUCCESS (5.468s)
[407.279402] [063/133] (613s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[407.343089] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[407.345409] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[407.460010] [064/133] (612s left) kms_vblank (ts-continuation-modeset-rpm)
[407.549564] Starting subtest: ts-continuation-modeset-rpm
[407.551890] Starting dynamic subtest: pipe-A-eDP-1
[410.032104] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.482s)
[410.047464] Starting dynamic subtest: pipe-D-eDP-1
[412.283274] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s)
[412.285647] Subtest ts-continuation-modeset-rpm: SUCCESS (4.734s)
[413.098398] [065/133] (607s left) gem_ctx_param (non-root-set)
[413.161624] Starting subtest: non-root-set
[413.178935] Subtest non-root-set: SUCCESS (0.017s)
[413.274071] [066/133] (607s left) kms_big_fb (y-tiled-addfb)
[413.376358] Starting subtest: y-tiled-addfb
[413.380622] Subtest y-tiled-addfb: SKIP (0.000s)
[413.473518] [067/133] (607s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[413.589077] Starting subtest: verify-pxp-execution-after-suspend-resume
[420.634195] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.047s)
[420.759516] [068/133] (599s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[420.809420] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[420.871174] [069/133] (599s left) sw_sync (sync_random_merge)
[420.912867] Starting subtest: sync_random_merge
[420.960431] Subtest sync_random_merge: SUCCESS (0.049s)
[421.039299] [070/133] (599s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[421.140049] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[421.144438] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[421.247497] [071/133] (599s left) gem_exec_params (rel-constants-invalid-ring)
[421.310985] Starting subtest: rel-constants-invalid-ring
[421.313233] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[421.430910] [072/133] (599s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[421.527007] Starting subtest: pr-plane-move-sf-dmg-area
[421.531245] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[421.596971] [073/133] (599s left) kms_invalid_mode (uint-max-clock)
[421.706992] Starting subtest: uint-max-clock
[421.709125] Starting dynamic subtest: pipe-A-eDP-1
[422.007845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[422.019334] Starting dynamic subtest: pipe-B-eDP-1
[422.021510] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[422.031702] Starting dynamic subtest: pipe-C-eDP-1
[422.033933] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[422.044468] Starting dynamic subtest: pipe-D-eDP-1
[422.046921] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[422.049252] Subtest uint-max-clock: SUCCESS (0.308s)
[422.841796] [074/133] (597s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[422.951082] Starting subtest: fbc-rgb101010-draw-blt
[427.524718] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.577s)
[428.640816] [075/133] (592s left) gem_lmem_swapping (basic)
[428.689952] Subtest basic: SKIP (0.000s)
[428.738451] [076/133] (592s left) kms_chamelium_color (ctm-0-75)
[428.839947] Subtest ctm-0-75: SKIP (0.000s)
[428.885231] [077/133] (592s left) kms_prop_blob (invalid-get-prop)
[428.934824] Starting subtest: invalid-get-prop
[428.937165] Subtest invalid-get-prop: SUCCESS (0.000s)
[429.051825] [078/133] (591s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[429.138736] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[429.141059] Starting dynamic subtest: pipe-A-eDP-1
[429.677079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.515s)
[429.687442] Starting dynamic subtest: pipe-B-eDP-1
[431.189972] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.505s)
[431.201169] Starting dynamic subtest: pipe-C-eDP-1
[432.612735] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.422s)
[432.626477] Starting dynamic subtest: pipe-D-eDP-1
[434.065346] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.451s)
[434.067685] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.899s)
[435.300108] [079/133] (585s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[435.391827] Starting subtest: fbc-psr2-cursor-plane-onoff
[435.394137] Starting dynamic subtest: eDP-1
[435.398321] Dynamic subtest eDP-1: SKIP (0.000s)
[435.402599] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[435.482614] [080/133] (585s left) gem_userptr_blits (sync-unmap-after-close)
[435.546970] Starting subtest: sync-unmap-after-close
[435.557899] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[435.678947] [081/133] (585s left) gem_ctx_persistence (legacy-engines-cleanup)
[435.737536] Starting subtest: legacy-engines-cleanup
[435.739801] Starting dynamic subtest: render
[435.798313] Dynamic subtest render: SUCCESS (0.060s)
[435.811316] Starting dynamic subtest: bsd1
[435.851161] Dynamic subtest bsd1: SUCCESS (0.051s)
[435.866506] Starting dynamic subtest: bsd2
[435.905445] Dynamic subtest bsd2: SUCCESS (0.051s)
[435.917621] Starting dynamic subtest: blt
[435.959300] Dynamic subtest blt: SUCCESS (0.051s)
[435.971794] Starting dynamic subtest: vebox
[436.010151] Dynamic subtest vebox: SUCCESS (0.048s)
[436.012819] Subtest legacy-engines-cleanup: SUCCESS (0.274s)
[436.096204] [082/133] (585s left) kms_flip (2x-absolute-wf_vblank)
[436.190404] Starting subtest: 2x-absolute-wf_vblank
[436.202191] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[436.288698] [083/133] (584s left) gem_exec_schedule (fairslice)
[436.360846] Starting subtest: fairslice
[436.362836] Starting dynamic subtest: rcs0
[438.376206] Dynamic subtest rcs0: SUCCESS (2.020s)
[438.387882] Starting dynamic subtest: bcs0
[440.400053] Dynamic subtest bcs0: SUCCESS (2.022s)
[440.413431] Starting dynamic subtest: vcs0
[442.424137] Dynamic subtest vcs0: SUCCESS (2.023s)
[442.436653] Starting dynamic subtest: vcs1
[444.449829] Dynamic subtest vcs1: SUCCESS (2.022s)
[444.459899] Starting dynamic subtest: vecs0
[446.468106] Dynamic subtest vecs0: SUCCESS (2.017s)
[446.478578] Starting dynamic subtest: ccs0
[448.494085] Dynamic subtest ccs0: SUCCESS (2.022s)
[448.496177] Subtest fairslice: SUCCESS (12.134s)
[448.809410] [084/133] (572s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[448.917888] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[450.074608] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.157s)
[450.210206] [085/133] (571s left) gem_ctx_param (get-priority-new-ctx)
[450.257031] Starting subtest: get-priority-new-ctx
[450.259033] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[450.362221] [086/133] (570s left) kms_frontbuffer_tracking (fbc-stridechange)
[450.465816] Starting subtest: fbc-stridechange
[453.748530] Subtest fbc-stridechange: SUCCESS (3.284s)
[454.883517] [087/133] (566s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[454.984286] Starting subtest: yf-tiled-16bpp-rotate-180
[454.988779] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[455.097868] [088/133] (566s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[455.181506] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[455.185826] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[456.298412] [089/133] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[456.386200] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[456.390618] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[456.484032] [090/133] (565s left) gen9_exec_parse (cmd-crossing-page)
[456.540418] Subtest cmd-crossing-page: SKIP (0.000s)
[456.607090] [091/133] (564s left) gem_mmap (pf-nonblock)
[456.661339] Subtest pf-nonblock: SKIP (0.000s)
[456.723877] [092/133] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[456.822196] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[466.435446] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.613s)
[466.574648] [093/133] (555s left) gem_exec_whisper (basic-normal)
[466.644436] Starting subtest: basic-normal
[470.206703] Subtest basic-normal: SUCCESS (3.559s)
[470.418918] [094/133] (551s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[470.513529] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[470.515804] Starting dynamic subtest: pipe-A-eDP-1
[470.537344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[470.549037] Starting dynamic subtest: pipe-B-eDP-1
[470.569801] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[470.580468] Starting dynamic subtest: pipe-C-eDP-1
[470.601300] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[470.611697] Starting dynamic subtest: pipe-D-eDP-1
[470.632772] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[470.636968] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[472.760411] [095/133] (548s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[472.864871] Starting subtest: plane-upscale-factor-0-25-with-rotation
[472.867181] Starting dynamic subtest: pipe-A
[473.090639] Dynamic subtest pipe-A: SUCCESS (0.228s)
[473.102407] Starting dynamic subtest: pipe-B
[474.360598] Dynamic subtest pipe-B: SUCCESS (1.269s)
[474.372195] Starting dynamic subtest: pipe-C
[475.685768] Dynamic subtest pipe-C: SUCCESS (1.324s)
[475.700315] Starting dynamic subtest: pipe-D
[477.023244] Dynamic subtest pipe-D: SUCCESS (1.337s)
[477.025625] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.160s)
[478.236940] [096/133] (543s left) gem_ctx_sseu (invalid-sseu)
[478.310205] Subtest invalid-sseu: SKIP (0.000s)
[478.391032] [097/133] (543s left) gem_unfence_active_buffers
[478.541635] [098/133] (543s left) kms_addfb_basic (too-wide)
[478.640608] Starting subtest: too-wide
[478.642819] Subtest too-wide: SUCCESS (0.000s)
[478.753823] [099/133] (543s left) gem_mmap (bad-size)
[478.802686] Subtest bad-size: SKIP (0.000s)
[478.868919] [100/133] (543s left) gem_exec_flush (basic-uc-set-default)
[478.936707] Starting subtest: basic-uc-set-default
[484.390024] Subtest basic-uc-set-default: SUCCESS (5.455s)
[484.578832] [101/133] (537s left) kms_content_protection (mei-interface)
[484.732247] Starting subtest: mei-interface
[484.738307] Subtest mei-interface: SKIP (0.001s)
[484.863204] [102/133] (537s left) kms_flip (flip-vs-fences)
[484.958635] Starting subtest: flip-vs-fences
[484.963032] Subtest flip-vs-fences: SKIP (0.000s)
[485.066547] [103/133] (537s left) gem_vm_create (invalid-destroy)
[485.134005] Starting subtest: invalid-destroy
[485.136237] Subtest invalid-destroy: SUCCESS (0.002s)
[485.248768] [104/133] (536s left) sw_sync (sync_multi_producer_single_consumer)
[485.285142] Starting subtest: sync_multi_producer_single_consumer
[486.359186] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[486.425948] [105/133] (535s left) kms_busy (extended-pageflip-hang-oldfb)
[486.526617] Starting subtest: extended-pageflip-hang-oldfb
[486.528858] Starting dynamic subtest: pipe-A
[486.938442] Dynamic subtest pipe-A: SUCCESS (0.410s)
[486.950171] Starting dynamic subtest: pipe-D
[488.023728] Dynamic subtest pipe-D: SUCCESS (1.083s)
[488.028358] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.497s)
[488.888198] [106/133] (533s left) kms_vrr (flipline)
[488.979634] Starting subtest: flipline
[488.986058] Subtest flipline: SKIP (0.000s)
[489.069402] [107/133] (533s left) gem_bad_reloc (negative-reloc-bltcopy)
[489.128171] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[489.204955] [108/133] (533s left) kms_cursor_crc (cursor-suspend)
[489.330514] Starting subtest: cursor-suspend
[489.332662] Starting dynamic subtest: pipe-A-eDP-1
[524.611047] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.213s)
[524.624156] Starting dynamic subtest: pipe-D-eDP-1
[558.585915] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.968s)
[558.588359] Subtest cursor-suspend: SUCCESS (10.185s)
[559.428916] [109/133] (462s left) syncobj_basic (illegal-fd-to-handle)
[559.506550] Starting subtest: illegal-fd-to-handle
[559.508664] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[559.630545] [110/133] (462s left) kms_pm_rpm (pm-caching)
[561.569576] Starting subtest: pm-caching
[561.574549] Subtest pm-caching: SKIP (0.000s)
[561.966457] [111/133] (460s left) perf_pmu (render-node-busy)
[562.039135] Starting subtest: render-node-busy
[562.041878] Starting dynamic subtest: rcs0
[562.629641] Dynamic subtest rcs0: SUCCESS (0.580s)
[562.643737] Starting dynamic subtest: bcs0
[563.207675] Dynamic subtest bcs0: SUCCESS (0.567s)
[563.222502] Starting dynamic subtest: vcs0
[564.464026] Dynamic subtest vcs0: SUCCESS (1.236s)
[564.478523] Starting dynamic subtest: vcs1
[566.450476] Dynamic subtest vcs1: SUCCESS (1.961s)
[566.463418] Starting dynamic subtest: vecs0
[568.433891] Dynamic subtest vecs0: SUCCESS (1.964s)
[568.448554] Starting dynamic subtest: ccs0
[569.010265] Dynamic subtest ccs0: SUCCESS (0.571s)
[569.013701] Subtest render-node-busy: SUCCESS (6.894s)
[569.105150] [112/133] (453s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[569.204354] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[569.209124] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[569.312571] [113/133] (453s left) kms_universal_plane (universal-plane-pageflip-windowed)
[569.398850] Starting subtest: universal-plane-pageflip-windowed
[569.400723] Starting dynamic subtest: pipe-A-eDP-1
[569.994505] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[570.007031] Starting dynamic subtest: pipe-B-eDP-1
[571.272917] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.271s)
[571.285435] Starting dynamic subtest: pipe-C-eDP-1
[572.485178] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[572.498518] Starting dynamic subtest: pipe-D-eDP-1
[573.707790] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[573.710397] Subtest universal-plane-pageflip-windowed: SUCCESS (4.288s)
[574.564233] [114/133] (448s left) syncobj_wait (wait-all-interrupted)
[574.615346] Starting subtest: wait-all-interrupted
[574.717050] Subtest wait-all-interrupted: SUCCESS (0.102s)
[574.809545] [115/133] (447s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[574.909223] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[581.882867] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.959s)
[582.023457] [116/133] (440s left) syncobj_basic (bad-create-flags)
[582.084829] Starting subtest: bad-create-flags
[582.087005] Subtest bad-create-flags: SUCCESS (0.000s)
[582.193615] [117/133] (440s left) kms_async_flips (test-time-stamp-atomic)
[582.278566] Starting subtest: test-time-stamp-atomic
[582.659571] Starting dynamic subtest: pipe-A-eDP-1
[583.479331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.816s)
[583.866112] Starting dynamic subtest: pipe-B-eDP-1
[584.611457] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s)
[584.993288] Starting dynamic subtest: pipe-C-eDP-1
[585.744934] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[586.115933] Starting dynamic subtest: pipe-D-eDP-1
[586.874169] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[586.876759] Subtest test-time-stamp-atomic: SUCCESS (4.590s)
[588.043005] [118/133] (434s left) syncobj_timeline (wait-delayed-signal)
[588.092794] Starting subtest: wait-delayed-signal
[588.194588] Subtest wait-delayed-signal: SUCCESS (0.102s)
[588.278309] [119/133] (434s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[588.329234] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[588.408127] [120/133] (434s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[588.508596] Starting subtest: psr-2p-primscrn-cur-indfb-move
[588.512959] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[588.624823] [121/133] (434s left) core_setmaster (master-drop-set-user)
[588.713163] Starting subtest: master-drop-set-user
[588.727104] Subtest master-drop-set-user: SUCCESS (0.014s)
[588.769079] [122/133] (434s left) perf (per-context-mode-unprivileged)
[588.903973] Starting subtest: per-context-mode-unprivileged
[588.908448] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[588.949799] [123/133] (434s left) kms_psr (psr2-no-drrs)
[589.045284] Starting subtest: psr2-no-drrs
[589.047319] Starting dynamic subtest: eDP-1
[590.708328] Dynamic subtest eDP-1: SUCCESS (1.663s)
[590.710687] Subtest psr2-no-drrs: SUCCESS (1.664s)
[591.509892] [124/133] (431s left) gem_exec_nop (basic-parallel)
[591.579730] Starting subtest: basic-parallel
[607.411245] Subtest basic-parallel: SUCCESS (15.839s)
[607.643906] [125/133] (415s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[607.735601] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[607.762386] Starting dynamic subtest: pipe-A-plane-0
[608.050882] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[608.063333] Starting dynamic subtest: pipe-A-plane-3
[608.284211] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[609.398294] Starting dynamic subtest: pipe-B-plane-0
[609.688030] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[609.702318] Starting dynamic subtest: pipe-B-plane-3
[609.921363] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[610.229582] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.495s)
[611.066357] [126/133] (412s left) kms_big_fb (4-tiled-addfb-size-overflow)
[611.172716] Starting subtest: 4-tiled-addfb-size-overflow
[611.174934] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[611.268601] [127/133] (411s left) gem_spin_batch (resubmit-new-all)
[611.330134] Starting subtest: resubmit-new-all
[611.332583] Starting dynamic subtest: rcs0
[611.344505] Dynamic subtest rcs0: SUCCESS (0.014s)
[611.356928] Starting dynamic subtest: bcs0
[611.359274] Dynamic subtest bcs0: SUCCESS (0.011s)
[611.374408] Starting dynamic subtest: vcs0
[611.376703] Dynamic subtest vcs0: SUCCESS (0.008s)
[611.388015] Starting dynamic subtest: vcs1
[611.390285] Dynamic subtest vcs1: SUCCESS (0.010s)
[611.401579] Starting dynamic subtest: vecs0
[611.403861] Dynamic subtest vecs0: SUCCESS (0.011s)
[611.414948] Starting dynamic subtest: ccs0
[611.417247] Dynamic subtest ccs0: SUCCESS (0.009s)
[611.419537] Subtest resubmit-new-all: SUCCESS (0.069s)
[612.520119] [128/133] (410s left) syncobj_wait (reset-multiple-signaled)
[612.576715] Starting subtest: reset-multiple-signaled
[612.579028] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[612.675623] [129/133] (410s left) gem_exec_balancer (full-late-pulse)
[612.730011] Starting subtest: full-late-pulse
[617.350439] Subtest full-late-pulse: SUCCESS (4.619s)
[617.667258] [130/133] (405s left) i915_pm_rpm (gem-mmap-type)
[619.598807] Starting subtest: gem-mmap-type
[619.601431] Starting dynamic subtest: wb-smem0
[623.090166] Dynamic subtest wb-smem0: SUCCESS (3.493s)
[623.106038] Starting dynamic subtest: wc-smem0
[626.294746] Dynamic subtest wc-smem0: SUCCESS (3.201s)
[626.310395] Starting dynamic subtest: uc-smem0
[629.462349] Dynamic subtest uc-smem0: SUCCESS (3.164s)
[629.464752] Subtest gem-mmap-type: SUCCESS (9.863s)
[629.553592] [131/133] (393s left) kms_dsc (dsc-with-formats)
[629.656778] Starting subtest: dsc-with-formats
[629.695367] Subtest dsc-with-formats: SKIP (0.001s)
[629.739835] [132/133] (393s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[629.830374] Starting subtest: stress-xrgb8888-yftiled
[629.834689] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[629.903513] [133/133] (393s left) sw_sync (sync_expired_merge)
[629.939066] Starting subtest: sync_expired_merge
[631.011630] Subtest sync_expired_merge: SUCCESS (1.074s)
[631.072826] 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.