[56.213528] Initializing watchdogs
[56.213574]   /dev/watchdog0
[56.227839] [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.232331] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.234848] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.238114] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[56.363631] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[56.367764] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[56.429545] [002/133] (960s left) kms_hdr (bpc-switch-dpms)
[56.525312] Starting subtest: bpc-switch-dpms
[57.587459] Starting dynamic subtest: pipe-A-eDP-1
[62.090046] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.535s)
[62.092371] Subtest bpc-switch-dpms: SUCCESS (5.611s)
[62.248142] [003/133] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[62.346176] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[62.350625] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[62.462921] [004/133] (954s left) gem_pxp (display-protected-crc)
[62.599604] Starting subtest: display-protected-crc
[64.223716] Subtest display-protected-crc: SUCCESS (1.634s)
[64.358556] [005/133] (952s left) kms_cursor_crc (cursor-alpha-transparent)
[64.450086] Starting subtest: cursor-alpha-transparent
[64.452418] Starting dynamic subtest: pipe-A-eDP-1
[65.067143] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[65.080959] Starting dynamic subtest: pipe-D-eDP-1
[66.351126] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s)
[66.353571] Subtest cursor-alpha-transparent: SUCCESS (1.907s)
[67.234416] [006/133] (949s left) i915_query (query-topology-garbage-items)
[67.542355] Starting subtest: query-topology-garbage-items
[67.544727] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[67.885053] [007/133] (949s left) kms_psr2_su (page_flip-xrgb8888)
[68.065064] Subtest page_flip-XRGB8888: SKIP (0.000s)
[68.236870] [008/133] (948s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[68.631058] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[69.490020] [009/133] (947s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[69.579771] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[69.582052] Starting dynamic subtest: pipe-A-eDP-1
[71.679063] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.104s)
[71.687526] Starting dynamic subtest: pipe-B-eDP-1
[73.962139] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.285s)
[73.969824] Starting dynamic subtest: pipe-C-eDP-1
[76.168210] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.206s)
[76.177302] Starting dynamic subtest: pipe-D-eDP-1
[78.167464] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.999s)
[78.169785] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.597s)
[79.406273] [010/133] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[79.522931] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[84.784227] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.265s)
[85.915786] [011/133] (931s left) kms_flip (plain-flip-ts-check-interruptible)
[86.021421] Starting subtest: plain-flip-ts-check-interruptible
[86.023653] Starting dynamic subtest: A-eDP1
[94.884579] Dynamic subtest A-eDP1: SUCCESS (8.862s)
[94.891913] Starting dynamic subtest: B-eDP1
[103.714866] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[103.724650] Starting dynamic subtest: C-eDP1
[112.536690] Dynamic subtest C-eDP1: SUCCESS (8.814s)
[112.544701] Starting dynamic subtest: D-eDP1
[121.361716] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[121.364080] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.345s)
[122.540258] [012/133] (894s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[122.607661] Starting subtest: verify-pxp-execution-after-suspend-resume
[129.730145] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.121s)
[129.881172] [013/133] (887s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[129.952543] Starting subtest: invalid-single-wait-unsubmitted
[129.954939] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[130.068826] [014/133] (887s left) i915_drm_fdinfo (memory-info-purgeable)
[130.115208] Starting subtest: memory-info-purgeable
[130.117497] Starting dynamic subtest: smem0
[132.765510] Dynamic subtest smem0: SUCCESS (2.651s)
[132.767917] Subtest memory-info-purgeable: SUCCESS (2.651s)
[132.852496] [015/133] (884s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[132.964109] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[137.160043] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.198s)
[138.310179] [016/133] (879s left) prime_busy (before-wait)
[138.373798] Starting subtest: before-wait
[138.379266] Starting dynamic subtest: rcs0
[138.424451] Dynamic subtest rcs0: SUCCESS (0.048s)
[138.434274] Starting dynamic subtest: bcs0
[138.494089] Dynamic subtest bcs0: SUCCESS (0.069s)
[138.503660] Starting dynamic subtest: vcs0
[138.534147] Dynamic subtest vcs0: SUCCESS (0.040s)
[138.542307] Starting dynamic subtest: vcs1
[138.575174] Dynamic subtest vcs1: SUCCESS (0.040s)
[138.583818] Starting dynamic subtest: vecs0
[138.616774] Dynamic subtest vecs0: SUCCESS (0.041s)
[138.625408] Starting dynamic subtest: ccs0
[138.656991] Dynamic subtest ccs0: SUCCESS (0.039s)
[138.765681] Subtest before-wait: SUCCESS (0.390s)
[138.849704] [017/133] (878s left) api_intel_bb (simple-bb)
[138.898304] Starting subtest: simple-bb
[138.900477] Subtest simple-bb: SUCCESS (0.005s)
[139.043127] [018/133] (878s left) kms_draw_crc (draw-method-mmap-gtt)
[139.148025] Starting subtest: draw-method-mmap-gtt
[139.152505] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[139.267199] [019/133] (878s left) perf (sysctl-defaults)
[139.358771] Starting subtest: sysctl-defaults
[139.361702] Subtest sysctl-defaults: SUCCESS (0.000s)
[139.451278] [020/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[139.553159] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[146.598937] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.047s)
[146.735763] [021/133] (870s left) kms_flip (nonexisting-fb)
[146.847744] Starting subtest: nonexisting-fb
[146.850028] Starting dynamic subtest: A-eDP1
[147.985875] Dynamic subtest A-eDP1: SUCCESS (1.140s)
[147.995077] Starting dynamic subtest: B-eDP1
[149.124665] Dynamic subtest B-eDP1: SUCCESS (1.138s)
[149.133895] Starting dynamic subtest: C-eDP1
[150.255329] Dynamic subtest C-eDP1: SUCCESS (1.130s)
[150.264262] Starting dynamic subtest: D-eDP1
[151.392294] Dynamic subtest D-eDP1: SUCCESS (1.136s)
[151.394640] Subtest nonexisting-fb: SUCCESS (4.550s)
[152.595345] [022/133] (865s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[152.704772] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[152.709158] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[152.782297] [023/133] (864s left) gem_exec_schedule (timeslicing)
[152.858591] Starting subtest: timeslicing
[152.860602] Starting dynamic subtest: rcs0
[152.868528] Dynamic subtest rcs0: SUCCESS (0.022s)
[152.878460] Starting dynamic subtest: bcs0
[152.888493] Dynamic subtest bcs0: SUCCESS (0.019s)
[152.896845] Starting dynamic subtest: vcs0
[152.911241] Dynamic subtest vcs0: SUCCESS (0.021s)
[152.919273] Starting dynamic subtest: vcs1
[152.929786] Dynamic subtest vcs1: SUCCESS (0.019s)
[152.937906] Starting dynamic subtest: vecs0
[152.950387] Dynamic subtest vecs0: SUCCESS (0.020s)
[152.958506] Starting dynamic subtest: ccs0
[152.970479] Dynamic subtest ccs0: SUCCESS (0.020s)
[152.972872] Subtest timeslicing: SUCCESS (0.124s)
[154.943855] [024/133] (862s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[155.069042] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[155.073188] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[155.194827] [025/133] (862s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[155.319384] Starting subtest: flip-vs-cursor-atomic-transitions
[162.846114] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.526s)
[163.711967] [026/133] (854s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[163.809094] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[163.813152] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[163.890235] [027/133] (853s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[164.010360] Starting subtest: basic-flip-after-cursor-legacy
[164.930224] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.918s)
[165.758908] [028/133] (852s left) prime_self_import (export-vs-gem_close-race)
[165.799822] Starting subtest: export-vs-gem_close-race
[170.914105] Subtest export-vs-gem_close-race: SUCCESS (5.113s)
[170.998621] [029/133] (846s left) gem_mmap_gtt (zero-extend)
[171.061468] Subtest zero-extend: SKIP (0.000s)
[171.125297] [030/133] (846s left) gem_ctx_persistence (legacy-engines-persistence)
[171.190969] Starting subtest: legacy-engines-persistence
[171.192842] Starting dynamic subtest: render
[172.019351] Dynamic subtest render: SUCCESS (0.830s)
[172.033822] Starting dynamic subtest: bsd1
[172.847859] Dynamic subtest bsd1: SUCCESS (0.825s)
[172.861292] Starting dynamic subtest: bsd2
[173.635072] Dynamic subtest bsd2: SUCCESS (0.784s)
[173.645422] Starting dynamic subtest: blt
[174.406759] Dynamic subtest blt: SUCCESS (0.769s)
[174.415234] Starting dynamic subtest: vebox
[175.209043] Dynamic subtest vebox: SUCCESS (0.800s)
[175.211954] Subtest legacy-engines-persistence: SUCCESS (4.021s)
[175.308976] [031/133] (842s left) i915_module_load (reload)
[175.343404] Starting subtest: reload
[180.372317] Subtest reload: SUCCESS (5.032s)
[180.412683] [032/133] (837s left) kms_color (degamma)
[181.925143] Starting subtest: degamma
[181.927477] Starting dynamic subtest: pipe-A-eDP-1
[182.703542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.776s)
[182.712067] Starting dynamic subtest: pipe-B-eDP-1
[184.137852] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.434s)
[184.145959] Starting dynamic subtest: pipe-C-eDP-1
[185.505947] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[185.514508] Starting dynamic subtest: pipe-D-eDP-1
[186.852514] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[186.854736] Subtest degamma: SUCCESS (4.925s)
[187.654378] [033/133] (830s left) prime_vgem (basic-fence-mmap)
[187.758386] Starting subtest: basic-fence-mmap
[187.763059] Subtest basic-fence-mmap: SKIP (0.000s)
[187.877434] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[187.881017] [034/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[187.995668] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[188.000354] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[188.142077] [035/133] (829s left) gem_lmem_swapping (parallel-random-engines)
[188.186711] Subtest parallel-random-engines: SKIP (0.000s)
[188.236618] [036/133] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[188.341399] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[195.469327] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.129s)
[195.629622] [037/133] (822s left) perf_pmu (init-busy)
[195.677704] Starting subtest: init-busy
[195.680025] Starting dynamic subtest: rcs0
[195.682276] Dynamic subtest rcs0: SUCCESS (0.002s)
[195.690677] Starting dynamic subtest: bcs0
[195.692788] Dynamic subtest bcs0: SUCCESS (0.001s)
[195.700668] Starting dynamic subtest: vcs0
[195.702738] Dynamic subtest vcs0: SUCCESS (0.001s)
[195.710842] Starting dynamic subtest: vcs1
[195.712983] Dynamic subtest vcs1: SUCCESS (0.001s)
[195.720586] Starting dynamic subtest: vecs0
[195.722685] Dynamic subtest vecs0: SUCCESS (0.001s)
[195.730217] Starting dynamic subtest: ccs0
[195.732312] Dynamic subtest ccs0: SUCCESS (0.000s)
[195.734430] Subtest init-busy: SUCCESS (0.009s)
[195.823237] [038/133] (822s left) kms_frontbuffer_tracking (fbc-1p-rte)
[195.925320] Starting subtest: fbc-1p-rte
[201.439736] Subtest fbc-1p-rte: SUCCESS (5.519s)
[202.655450] [039/133] (815s left) gem_ringfill (basic-all)
[207.900984] Starting subtest: basic-all
[209.062088] Subtest basic-all: SUCCESS (1.161s)
[209.207724] [040/133] (809s left) kms_cursor_edge_walk (128x128-left-edge)
[209.310355] Starting subtest: 128x128-left-edge
[209.313054] Starting dynamic subtest: pipe-A-eDP-1
[212.785418] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[212.796792] Starting dynamic subtest: pipe-D-eDP-1
[215.924073] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s)
[215.926303] Subtest 128x128-left-edge: SUCCESS (6.618s)
[216.735065] [041/133] (801s left) gem_vm_create (create-ext)
[216.806017] Starting subtest: create-ext
[216.811074] Subtest create-ext: SUCCESS (0.005s)
[216.964203] [042/133] (801s left) gem_exec_capture (userptr)
[217.025107] Starting subtest: userptr
[217.854380] Subtest userptr: SUCCESS (0.831s)
[218.003284] [043/133] (800s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[218.247827] Starting subtest: cursor-rapid-movement-256x256
[218.250183] Starting dynamic subtest: pipe-A-eDP-1
[218.790510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[218.819969] Starting dynamic subtest: pipe-D-eDP-1
[220.046252] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[220.048646] Subtest cursor-rapid-movement-256x256: SUCCESS (1.801s)
[220.902109] [044/133] (797s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[221.001693] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[221.003873] Starting dynamic subtest: pipe-A-eDP-1
[221.027107] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.039069] Starting dynamic subtest: pipe-B-eDP-1
[221.062084] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.070065] Starting dynamic subtest: pipe-C-eDP-1
[221.092988] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.102687] Starting dynamic subtest: pipe-D-eDP-1
[221.124816] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.128973] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[223.282998] [045/133] (795s left) kms_invalid_mode (zero-hdisplay)
[223.388192] Starting subtest: zero-hdisplay
[223.390480] Starting dynamic subtest: pipe-A-eDP-1
[223.673963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[223.683107] Starting dynamic subtest: pipe-B-eDP-1
[223.685277] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[223.693429] Starting dynamic subtest: pipe-C-eDP-1
[223.695628] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[223.704198] Starting dynamic subtest: pipe-D-eDP-1
[223.706083] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[223.707971] Subtest zero-hdisplay: SUCCESS (0.295s)
[224.499073] [046/133] (794s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[224.611506] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[225.590986] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.979s)
[225.746621] [047/133] (792s left) gem_softpin (evict-snoop)
[225.831385] Starting subtest: evict-snoop
[225.835568] Subtest evict-snoop: SKIP (0.000s)
[225.980060] [048/133] (792s left) prime_vgem (basic-write)
[226.068367] Starting subtest: basic-write
[226.077299] Subtest basic-write: SKIP (0.007s)
[226.218610] [049/133] (792s left) kms_atomic (plane-invalid-params)
[226.324437] Starting subtest: plane-invalid-params
[226.326440] Starting dynamic subtest: pipe-A-eDP-1
[226.736773] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[226.739207] Subtest plane-invalid-params: SUCCESS (0.414s)
[227.545599] [050/133] (791s left) gem_userptr_blits (unsync-unmap-cycles)
[227.602867] Subtest unsync-unmap-cycles: SKIP (0.000s)
[227.746231] [051/133] (791s left) gem_exec_schedule (preempt-contexts)
[227.822670] Starting subtest: preempt-contexts
[227.824621] Starting dynamic subtest: rcs0
[227.863198] Dynamic subtest rcs0: SUCCESS (0.048s)
[227.872209] Starting dynamic subtest: bcs0
[227.919393] Dynamic subtest bcs0: SUCCESS (0.055s)
[227.930493] Starting dynamic subtest: vcs0
[227.964631] Dynamic subtest vcs0: SUCCESS (0.045s)
[227.973180] Starting dynamic subtest: vcs1
[228.021621] Dynamic subtest vcs1: SUCCESS (0.057s)
[228.030516] Starting dynamic subtest: vecs0
[228.061738] Dynamic subtest vecs0: SUCCESS (0.039s)
[228.070381] Starting dynamic subtest: ccs0
[228.107737] Dynamic subtest ccs0: SUCCESS (0.045s)
[228.109912] Subtest preempt-contexts: SUCCESS (0.293s)
[230.044998] [052/133] (788s left) syncobj_wait (wait-any-interrupted)
[230.091282] Starting subtest: wait-any-interrupted
[230.191997] Subtest wait-any-interrupted: SUCCESS (0.101s)
[230.291666] [053/133] (788s left) gem_madvise (dontneed-before-exec)
[230.335978] Starting subtest: dontneed-before-exec
[230.356350] Subtest dontneed-before-exec: SKIP (0.019s)
[230.424688] [054/133] (788s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[230.528893] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[230.531147] Starting dynamic subtest: pipe-A-eDP-1
[230.553622] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.563705] Starting dynamic subtest: pipe-B-eDP-1
[230.585324] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.593855] Starting dynamic subtest: pipe-C-eDP-1
[230.615233] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.623778] Starting dynamic subtest: pipe-D-eDP-1
[230.645572] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.649651] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[232.732947] [055/133] (786s left) kms_psr (psr2-basic)
[232.840500] Starting subtest: psr2-basic
[232.842605] Starting dynamic subtest: eDP-1
[234.477662] Dynamic subtest eDP-1: SUCCESS (1.636s)
[234.479971] Subtest psr2-basic: SUCCESS (1.637s)
[235.286650] [056/133] (783s left) kms_chamelium_color (gamma)
[235.392632] Subtest gamma: SKIP (0.000s)
[235.436563] [057/133] (783s left) i915_pm_rpm (system-suspend-devices)
[236.957567] Starting subtest: system-suspend-devices
[244.595784] Subtest system-suspend-devices: SUCCESS (7.638s)
[244.993264] [058/133] (774s left) kms_chamelium_color (ctm-0-25)
[245.084095] Subtest ctm-0-25: SKIP (0.000s)
[245.131197] [059/133] (774s left) kms_rotation_crc (primary-rotation-90)
[245.218270] Starting subtest: primary-rotation-90
[245.222160] Subtest primary-rotation-90: SKIP (0.001s)
[245.322838] [060/133] (773s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[245.417088] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[245.792358] Starting dynamic subtest: pipe-A-eDP-1
[248.528550] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.735s)
[248.906975] Starting dynamic subtest: pipe-B-eDP-1
[251.657416] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[252.022419] Starting dynamic subtest: pipe-C-eDP-1
[254.784088] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[255.169488] Starting dynamic subtest: pipe-D-eDP-1
[257.910728] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.746s)
[257.913306] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.494s)
[259.108949] [061/133] (760s left) gem_exec_whisper (basic-queues)
[259.188718] Starting subtest: basic-queues
[264.281028] Subtest basic-queues: SUCCESS (5.089s)
[264.488823] [062/133] (754s left) kms_big_fb (4-tiled-addfb-size-overflow)
[264.601155] Starting subtest: 4-tiled-addfb-size-overflow
[264.602998] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[264.723568] [063/133] (754s left) gem_eio (suspend)
[264.977626] Starting subtest: suspend
[277.234637] Subtest suspend: SUCCESS (12.255s)
[277.361105] [064/133] (741s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[277.454822] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[277.457086] Starting dynamic subtest: pipe-A
[277.517459] Dynamic subtest pipe-A: SUCCESS (0.065s)
[277.528079] Starting dynamic subtest: pipe-B
[278.621653] Dynamic subtest pipe-B: SUCCESS (1.103s)
[278.633119] Starting dynamic subtest: pipe-C
[279.729404] Dynamic subtest pipe-C: SUCCESS (1.106s)
[279.739354] Starting dynamic subtest: pipe-D
[280.872521] Dynamic subtest pipe-D: SUCCESS (1.141s)
[280.874925] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.420s)
[282.039684] [065/133] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[282.148410] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[282.152913] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[282.274426] [066/133] (737s left) kms_psr (fbc-psr2-suspend)
[282.373134] Starting subtest: fbc-psr2-suspend
[282.375418] Starting dynamic subtest: eDP-1
[282.379773] Dynamic subtest eDP-1: SKIP (0.000s)
[282.384165] Subtest fbc-psr2-suspend: SKIP (0.001s)
[282.459268] [067/133] (737s left) gem_ctx_sseu (engines)
[282.530234] Subtest engines: SKIP (0.000s)
[282.613933] [068/133] (736s left) kms_vblank (wait-idle)
[282.695033] Starting subtest: wait-idle
[282.696973] Starting dynamic subtest: pipe-A-eDP-1
[284.448385] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[284.463363] Starting dynamic subtest: pipe-D-eDP-1
[286.869851] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s)
[286.872142] Subtest wait-idle: SUCCESS (4.177s)
[287.698371] [069/133] (731s left) kms_busy (extended-pageflip-hang-oldfb)
[287.805810] Starting subtest: extended-pageflip-hang-oldfb
[287.807991] Starting dynamic subtest: pipe-A
[288.209806] Dynamic subtest pipe-A: SUCCESS (0.400s)
[288.220593] Starting dynamic subtest: pipe-D
[289.302705] Dynamic subtest pipe-D: SUCCESS (1.091s)
[289.305058] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.498s)
[290.162276] [070/133] (729s left) kms_dp_linktrain_fallback (dsc-fallback)
[290.267239] Starting subtest: dsc-fallback
[290.273394] Subtest dsc-fallback: SKIP (0.000s)
[290.351986] [071/133] (729s left) perf_pmu (invalid-init)
[290.396918] Starting subtest: invalid-init
[290.399315] Subtest invalid-init: SUCCESS (0.000s)
[290.536511] [072/133] (729s left) kms_addfb_basic (bad-pitch-63)
[290.593317] Starting subtest: bad-pitch-63
[290.595494] Subtest bad-pitch-63: SUCCESS (0.000s)
[290.765338] [073/133] (728s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[290.861345] Starting subtest: fbc-2p-pri-indfb-multidraw
[290.865388] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[290.997634] [074/133] (728s left) perf_pmu (busy-double-start)
[291.043200] Starting subtest: busy-double-start
[291.045098] Starting dynamic subtest: rcs0
[294.684577] Dynamic subtest rcs0: FAIL (3.590s)
[294.695242] Starting dynamic subtest: bcs0
[298.237840] Dynamic subtest bcs0: SUCCESS (3.605s)
[298.249888] Starting dynamic subtest: vcs0
[302.462664] Dynamic subtest vcs0: SUCCESS (4.223s)
[302.474188] Starting dynamic subtest: vcs1
[306.423954] Dynamic subtest vcs1: SUCCESS (3.959s)
[306.435405] Starting dynamic subtest: vecs0
[310.462634] Dynamic subtest vecs0: SUCCESS (4.036s)
[310.474715] Starting dynamic subtest: ccs0
[314.099068] Dynamic subtest ccs0: FAIL (3.564s)
[314.101407] Subtest busy-double-start: FAIL (22.988s)
[314.168297] [075/133] (705s left) gem_exec_balancer (parallel-bb-first)
[314.426681] Starting subtest: parallel-bb-first
[315.356669] Subtest parallel-bb-first: SUCCESS (0.929s)
[315.932654] [076/133] (703s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[316.054390] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[316.097313] [077/133] (703s left) gem_mmap_gtt (bad-object)
[316.155276] Subtest bad-object: SKIP (0.000s)
[316.228894] [078/133] (703s left) gem_pread (snoop)
[316.293193] Subtest snoop: SKIP (0.000s)
[316.362029] [079/133] (703s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[316.469390] Starting subtest: y-tiled-addfb-size-offset-overflow
[316.473793] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[316.578410] [080/133] (703s left) syncobj_basic (bad-handle-to-fd)
[316.643787] Starting subtest: bad-handle-to-fd
[316.646160] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[316.767412] [081/133] (703s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[316.825926] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[316.932983] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[317.032520] [082/133] (703s left) gem_ppgtt (blt-vs-render-ctx0)
[317.091888] Starting subtest: blt-vs-render-ctx0
[350.174438] Subtest blt-vs-render-ctx0: SUCCESS (33.079s)
[350.323242] [083/133] (669s left) kms_pm_rpm (pm-tiling)
[352.033386] Starting subtest: pm-tiling
[352.038194] Subtest pm-tiling: SKIP (0.000s)
[352.705796] [084/133] (667s left) perf_pmu (all-busy-idle-check-all)
[352.748488] Starting subtest: all-busy-idle-check-all
[353.881473] Subtest all-busy-idle-check-all: SUCCESS (1.131s)
[353.998446] [085/133] (666s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[354.072196] Subtest untiled-to-tiled: SKIP (0.000s)
[354.141439] [086/133] (666s left) gem_create (create-ext-set-pat)
[354.305019] Starting subtest: create-ext-set-pat
[354.307792] Subtest create-ext-set-pat: SUCCESS (0.001s)
[354.439492] [087/133] (665s left) kms_plane_lowres (tiling-4)
[354.541222] Starting subtest: tiling-4
[354.543456] Starting dynamic subtest: pipe-A-eDP-1
[354.547868] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[354.848701] Starting dynamic subtest: pipe-B-eDP-1
[354.853266] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[354.865366] Starting dynamic subtest: pipe-C-eDP-1
[354.870201] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[354.881803] Starting dynamic subtest: pipe-D-eDP-1
[354.886064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[354.890397] Subtest tiling-4: SKIP (0.307s)
[355.737588] [088/133] (664s left) syncobj_timeline (wait-any-interrupted)
[355.807554] Starting subtest: wait-any-interrupted
[355.910532] Subtest wait-any-interrupted: SUCCESS (0.102s)
[356.002809] [089/133] (664s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[356.112341] Starting subtest: pr-cursor-plane-move-continuous-sf
[356.116857] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[356.207396] [090/133] (664s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[356.262967] Starting subtest: etime-multi-wait-all-for-submit-submitted
[356.363313] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[356.451399] [091/133] (664s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[356.580541] Starting subtest: short-flip-after-cursor-atomic-transitions
[357.540882] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.961s)
[358.374266] [092/133] (662s left) drm_mm (drm_mm)
[358.411517] Starting subtest: drm_mm
[358.469757] Starting dynamic subtest: drm_test_mm_init
[358.592221] Dynamic subtest drm_test_mm_init: SUCCESS (0.120s)
[358.604351] Starting dynamic subtest: drm_test_mm_debug
[358.733173] Dynamic subtest drm_test_mm_debug: SUCCESS (0.141s)
[358.744171] Starting dynamic subtest: drm_test_mm_align32
[358.872384] Dynamic subtest drm_test_mm_align32: SUCCESS (0.139s)
[358.883153] Starting dynamic subtest: drm_test_mm_align64
[359.026847] Dynamic subtest drm_test_mm_align64: SUCCESS (0.154s)
[359.038298] Starting dynamic subtest: drm_test_mm_lowest
[359.163138] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.134s)
[359.174630] Starting dynamic subtest: drm_test_mm_highest
[359.307998] Dynamic subtest drm_test_mm_highest: SUCCESS (0.144s)
[359.310110] Subtest drm_mm: SUCCESS (0.893s)
[359.523486] [093/133] (661s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[359.633191] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[359.637764] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[360.800934] [094/133] (659s left) gem_exec_balancer (smoke)
[360.866828] Starting subtest: smoke
[383.504187] Subtest smoke: SUCCESS (22.634s)
[384.989609] [095/133] (635s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[385.122789] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[386.234928] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.111s)
[386.396142] [096/133] (634s left) kms_flip (2x-flip-vs-fences-interruptible)
[386.500952] Starting subtest: 2x-flip-vs-fences-interruptible
[386.504693] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[386.631341] [097/133] (634s left) kms_content_protection (legacy-hdcp14)
[386.772880] Starting subtest: legacy-hdcp14
[386.776490] Subtest legacy-hdcp14: SKIP (0.000s)
[386.934515] [098/133] (633s left) gem_mmap_gtt (basic-write-read)
[387.005856] Subtest basic-write-read: SKIP (0.000s)
[387.065669] [099/133] (633s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[387.159476] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[387.161617] Starting dynamic subtest: pipe-A-eDP-1
[387.225272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s)
[387.545947] Starting dynamic subtest: pipe-B-eDP-1
[388.372274] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.838s)
[388.659219] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.499s)
[389.565063] [100/133] (631s left) kms_lease (invalid-create-leases)
[389.672348] Starting subtest: invalid-create-leases
[389.676973] Subtest invalid-create-leases: SUCCESS (0.006s)
[389.824121] [101/133] (631s left) gem_exec_reloc (basic-cpu-wc)
[389.890984] Subtest basic-cpu-wc: SKIP (0.000s)
[389.964813] [102/133] (631s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[390.062406] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[390.064814] Starting dynamic subtest: pipe-A
[390.333121] Dynamic subtest pipe-A: SUCCESS (0.273s)
[390.343322] Starting dynamic subtest: pipe-B
[391.647088] Dynamic subtest pipe-B: SUCCESS (1.313s)
[391.659107] Starting dynamic subtest: pipe-C
[392.967730] Dynamic subtest pipe-C: SUCCESS (1.320s)
[392.978065] Starting dynamic subtest: pipe-D
[394.312075] Dynamic subtest pipe-D: SUCCESS (1.343s)
[394.314293] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.252s)
[395.475664] [103/133] (625s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[395.581533] Starting subtest: primary-yf-tiled-reflect-x-180
[395.641891] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[395.757701] [104/133] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[395.859531] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[395.863801] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[395.986756] [105/133] (625s left) perf (invalid-oa-metric-set-id)
[396.149347] Starting subtest: invalid-oa-metric-set-id
[396.157911] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[396.206664] [106/133] (624s left) gem_exec_fence (syncobj-repeat)
[396.691094] Starting subtest: syncobj-repeat
[396.868348] Subtest syncobj-repeat: SUCCESS (0.177s)
[398.039981] [107/133] (623s left) kms_rotation_crc (multiplane-rotation)
[398.140606] Starting subtest: multiplane-rotation
[415.657574] Subtest multiplane-rotation: SUCCESS (17.518s)
[415.801086] [108/133] (605s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[415.864487] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[415.866534] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[415.989184] [109/133] (605s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[416.092868] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[416.096469] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[416.197936] [110/133] (605s left) syncobj_timeline (etime-single-wait-all-submitted)
[416.254352] Starting subtest: etime-single-wait-all-submitted
[416.355637] Subtest etime-single-wait-all-submitted: SUCCESS (0.101s)
[416.444936] [111/133] (604s left) gem_exec_params (invalid-flag)
[416.514585] Starting subtest: invalid-flag
[416.516464] Subtest invalid-flag: SUCCESS (0.000s)
[416.634563] [112/133] (604s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[416.730996] Starting subtest: yf-tiled-64bpp-rotate-0
[416.734845] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[416.861211] [113/133] (604s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[416.964874] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[417.933565] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.967s)
[418.098979] [114/133] (603s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[418.200811] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[418.226843] Starting dynamic subtest: pipe-A-plane-0
[418.515037] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[418.527831] Starting dynamic subtest: pipe-A-plane-3
[418.749399] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[419.862022] Starting dynamic subtest: pipe-B-plane-0
[420.148797] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[420.158831] Starting dynamic subtest: pipe-B-plane-3
[420.380255] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[420.687676] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.489s)
[421.548678] [115/133] (600s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[421.649707] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[430.235056] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.588s)
[430.363215] [116/133] (591s left) api_intel_bb (add-remove-objects)
[430.416045] Starting subtest: add-remove-objects
[430.420764] Subtest add-remove-objects: SUCCESS (0.007s)
[430.581783] [117/133] (591s left) kms_pm_rpm (cursor-dpms)
[432.100201] Starting subtest: cursor-dpms
[432.105352] Subtest cursor-dpms: SKIP (0.000s)
[432.844840] [118/133] (588s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[432.946296] Starting subtest: fbcpsr-rgb101010-draw-render
[439.742348] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.800s)
[439.896417] [119/133] (581s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[440.005582] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[440.009979] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[440.121192] [120/133] (581s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[440.207817] Starting subtest: disable-crc-after-crtc
[440.210095] Starting dynamic subtest: pipe-A-eDP-1
[441.841413] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.634s)
[441.852423] Starting dynamic subtest: pipe-B-eDP-1
[444.077518] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.232s)
[444.089047] Starting dynamic subtest: pipe-C-eDP-1
[446.335710] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.257s)
[446.345643] Starting dynamic subtest: pipe-D-eDP-1
[448.630815] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.295s)
[448.632982] Subtest disable-crc-after-crtc: SUCCESS (8.425s)
[449.459210] [121/133] (572s left) gem_ctx_isolation (clean)
[449.537631] Starting subtest: clean
[449.539600] Starting dynamic subtest: rcs0
[449.600045] Dynamic subtest rcs0: SUCCESS (0.065s)
[449.612184] Starting dynamic subtest: bcs0
[449.693259] Dynamic subtest bcs0: SUCCESS (0.092s)
[449.705164] Starting dynamic subtest: vcs0
[449.782331] Dynamic subtest vcs0: SUCCESS (0.088s)
[449.794563] Starting dynamic subtest: vcs1
[450.906921] Dynamic subtest vcs1: SUCCESS (1.124s)
[450.918921] Starting dynamic subtest: vecs0
[452.896564] Dynamic subtest vecs0: SUCCESS (1.989s)
[452.908164] Starting dynamic subtest: ccs0
[454.988148] Dynamic subtest ccs0: SUCCESS (2.091s)
[454.990515] Subtest clean: SUCCESS (5.454s)
[455.259631] [122/133] (566s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[455.323416] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[455.325737] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[455.489246] [123/133] (566s left) kms_psr (fbc-psr2-primary-page-flip)
[455.597830] Starting subtest: fbc-psr2-primary-page-flip
[455.600118] Starting dynamic subtest: eDP-1
[455.604240] Dynamic subtest eDP-1: SKIP (0.000s)
[455.608461] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[455.697081] [124/133] (566s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[455.804554] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[455.808916] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[455.910305] [125/133] (566s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[456.015986] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[456.020146] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[456.144163] [126/133] (565s left) kms_psr (psr-basic)
[456.239326] Starting subtest: psr-basic
[456.241278] Starting dynamic subtest: eDP-1
[457.843674] Dynamic subtest eDP-1: SUCCESS (1.603s)
[457.845963] Subtest psr-basic: SUCCESS (1.604s)
[458.731876] [127/133] (563s left) gem_softpin (allocator-fork)
[458.806301] Starting subtest: allocator-fork
[461.020248] Subtest allocator-fork: SUCCESS (2.212s)
[461.180058] [128/133] (560s left) gen9_exec_parse (bb-start-cmd)
[461.267057] Subtest bb-start-cmd: SKIP (0.000s)
[461.355636] [129/133] (560s left) gem_barrier_race (remote-request)
[461.423739] Starting subtest: remote-request
[461.426043] Starting dynamic subtest: rcs0
[466.562469] Dynamic subtest rcs0: SUCCESS (5.139s)
[466.564378] Subtest remote-request: SUCCESS (5.140s)
[466.726189] [130/133] (555s left) gem_exec_flush (basic-uc-ro-default)
[466.797871] Starting subtest: basic-uc-ro-default
[472.261269] Subtest basic-uc-ro-default: SUCCESS (5.463s)
[472.470412] [131/133] (549s left) gem_exec_schedule (implicit-boths)
[472.557868] Starting subtest: implicit-boths
[472.559843] Starting dynamic subtest: rcs0
[472.743561] Dynamic subtest rcs0: SUCCESS (0.191s)
[472.758379] Starting dynamic subtest: vcs0
[472.897517] Dynamic subtest vcs0: SUCCESS (0.154s)
[472.910523] Starting dynamic subtest: vcs1
[473.005050] Dynamic subtest vcs1: SUCCESS (0.106s)
[473.018085] Starting dynamic subtest: vecs0
[473.109501] Dynamic subtest vecs0: SUCCESS (0.105s)
[473.122536] Starting dynamic subtest: ccs0
[473.245938] Dynamic subtest ccs0: SUCCESS (0.136s)
[473.248245] Subtest implicit-boths: SUCCESS (0.696s)
[474.086283] [132/133] (548s left) sysfs_timeslice_duration (timeout)
[474.152599] Starting subtest: timeout
[474.154788] Starting dynamic subtest: vecs0
[483.957116] Dynamic subtest vecs0: SUCCESS (9.803s)
[483.968315] Starting dynamic subtest: ccs0
[485.329964] Dynamic subtest ccs0: SUCCESS (1.371s)
[485.342524] Starting dynamic subtest: vcs0
[494.941726] Dynamic subtest vcs0: SUCCESS (9.608s)
[494.954752] Starting dynamic subtest: bcs0
[495.625072] Dynamic subtest bcs0: SUCCESS (0.681s)
[495.637863] Starting dynamic subtest: rcs0
[497.032031] Dynamic subtest rcs0: SUCCESS (1.406s)
[497.045215] Starting dynamic subtest: vcs1
[506.934664] Dynamic subtest vcs1: SUCCESS (9.899s)
[506.937267] Subtest timeout: SUCCESS (32.783s)
[507.021255] [133/133] (515s left) syncobj_wait (multi-wait-for-submit-submitted)
[507.091474] Starting subtest: multi-wait-for-submit-submitted
[507.197594] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[507.287343] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_hdr
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_pxp
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: i915_query
results: parsing output: 6/ for test: kms_psr2_su
results: parsing output: 7/ for test: kms_chamelium_hpd
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: prime_busy
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: kms_draw_crc
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: prime_self_import
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: i915_module_load
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: prime_vgem
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_lmem_swapping
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ringfill
results: parsing output: 39/ for test: kms_cursor_edge_walk
results: parsing output: 40/ for test: gem_vm_create
results: parsing output: 41/ for test: gem_exec_capture
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_invalid_mode
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: prime_vgem
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: gem_madvise
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_chamelium_color
results: parsing output: 56/ for test: i915_pm_rpm
results: parsing output: 57/ for test: kms_chamelium_color
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_ctx_sseu
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_busy
results: parsing output: 69/ for test: kms_dp_linktrain_fallback
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: kms_tiled_display
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: gem_pread
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_ppgtt
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: gem_set_tiling_vs_blt
results: parsing output: 85/ for test: gem_create
results: parsing output: 86/ for test: kms_plane_lowres
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: drm_mm
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_rotation_crc
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_pipe_crc_basic
results: parsing output: 120/ for test: gem_ctx_isolation
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: gen9_exec_parse
results: parsing output: 128/ for test: gem_barrier_race
results: parsing output: 129/ for test: gem_exec_flush
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: sysfs_timeslice_duration
results: parsing output: 132/ for test: syncobj_wait
Done.