[58.118114] Initializing watchdogs
[58.118163]   /dev/watchdog0
[58.132605] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.137279] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.139578] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.141381] [001/133] (960s left) kms_flip (2x-plain-flip-interruptible)
[58.240774] Starting subtest: 2x-plain-flip-interruptible
[58.252392] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[58.333566] [002/133] (960s left) kms_pm_rpm (modeset-non-lpsp-stress)
[60.092385] Starting subtest: modeset-non-lpsp-stress
[61.241188] Subtest modeset-non-lpsp-stress: SKIP (1.145s)
[61.618445] [003/133] (957s left) kms_plane_scaling (2x-scaler-multi-pipe)
[61.705665] Starting subtest: 2x-scaler-multi-pipe
[61.707524] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[61.818326] [004/133] (956s left) kms_vblank (query-busy)
[61.903892] Starting subtest: query-busy
[61.904759] Starting dynamic subtest: pipe-A-eDP-1
[63.806360] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.897s)
[63.813982] Starting dynamic subtest: pipe-D-eDP-1
[66.378804] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.566s)
[66.379676] Subtest query-busy: SUCCESS (4.466s)
[67.231337] [005/133] (951s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[67.570533] Starting subtest: 4-tiled-32bpp-rotate-270
[67.593750] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.023s)
[67.880316] [006/133] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[67.997608] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[67.999943] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[68.149765] [007/133] (950s left) kms_atomic_interruptible (atomic-setmode)
[68.320054] Starting subtest: atomic-setmode
[68.320948] Starting dynamic subtest: pipe-A-eDP-1
[75.214283] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.889s)
[75.215171] Subtest atomic-setmode: SUCCESS (6.890s)
[76.034478] [008/133] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[76.142843] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[76.144807] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[76.248333] [009/133] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[76.341435] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[76.343177] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[76.445605] [010/133] (942s left) gem_mmap_gtt (basic-short)
[76.495759] Subtest basic-short: SKIP (0.000s)
[76.558542] [011/133] (942s left) i915_query (query-topology-coherent-slice-mask)
[76.604069] Starting subtest: query-topology-coherent-slice-mask
[76.605927] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[76.712282] [012/133] (942s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[76.799169] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[76.801364] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[76.874181] [013/133] (942s left) syncobj_wait (wait-all-complex)
[76.933590] Starting subtest: wait-all-complex
[77.155754] Subtest wait-all-complex: SUCCESS (0.212s)
[77.224075] [014/133] (941s left) prime_vgem (wait)
[77.336725] Starting subtest: wait
[77.337655] Starting dynamic subtest: rcs0
[77.392091] Dynamic subtest rcs0: SUCCESS (0.055s)
[77.397870] Starting dynamic subtest: bcs0
[77.478092] Dynamic subtest bcs0: SUCCESS (0.086s)
[77.483612] Starting dynamic subtest: vcs0
[77.525882] Dynamic subtest vcs0: SUCCESS (0.047s)
[77.531693] Starting dynamic subtest: vcs1
[77.571049] Dynamic subtest vcs1: SUCCESS (0.045s)
[77.576596] Starting dynamic subtest: vecs0
[77.618036] Dynamic subtest vecs0: SUCCESS (0.047s)
[77.623522] Starting dynamic subtest: ccs0
[77.664274] Dynamic subtest ccs0: SUCCESS (0.046s)
[77.665080] Subtest wait: SUCCESS (0.328s)
[77.816207] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[77.817893] [015/133] (941s left) kms_flip (absolute-wf_vblank-interruptible)
[77.911909] Starting subtest: absolute-wf_vblank-interruptible
[77.913840] Starting dynamic subtest: A-eDP1
[86.615069] Dynamic subtest A-eDP1: SUCCESS (8.673s)
[86.623358] Starting dynamic subtest: B-eDP1
[95.347556] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[95.356038] Starting dynamic subtest: C-eDP1
[104.076163] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[104.084436] Starting dynamic subtest: D-eDP1
[112.772035] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[112.774279] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.857s)
[113.994381] [016/133] (905s left) sw_sync (sync_busy_fork)
[114.025444] Starting subtest: sync_busy_fork
[115.045835] Subtest sync_busy_fork: SUCCESS (1.011s)
[115.106103] [017/133] (904s left) i915_drm_fdinfo (virtual-busy-idle-all)
[115.144518] Starting subtest: virtual-busy-idle-all
[115.146284] Subtest virtual-busy-idle-all: SKIP (0.000s)
[115.215128] [018/133] (904s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[115.381973] Starting subtest: cursor-rapid-movement-64x64
[115.384832] Starting dynamic subtest: pipe-A-eDP-1
[115.914700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[115.941899] Starting dynamic subtest: pipe-D-eDP-1
[117.100500] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.164s)
[117.101484] Subtest cursor-rapid-movement-64x64: SUCCESS (1.718s)
[117.962756] [019/133] (901s left) kms_cursor_crc (cursor-suspend)
[118.084356] Starting subtest: cursor-suspend
[118.085274] Starting dynamic subtest: pipe-A-eDP-1
[152.113395] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.032s)
[152.121767] Starting dynamic subtest: pipe-D-eDP-1
[187.125836] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.587s)
[187.126778] Subtest cursor-suspend: SUCCESS (8.622s)
[193.011149] [020/133] (831s left) kms_psr (fbc-psr-cursor-plane-onoff)
[193.126246] Starting subtest: fbc-psr-cursor-plane-onoff
[193.127083] Starting dynamic subtest: eDP-1
[193.128724] Dynamic subtest eDP-1: SKIP (0.000s)
[193.130508] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[193.222679] [021/133] (831s left) kms_hdr (brightness-with-hdr)
[193.323609] Starting subtest: brightness-with-hdr
[193.326264] Subtest brightness-with-hdr: SKIP (0.000s)
[193.404727] [022/133] (831s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[193.785464] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[194.580062] [023/133] (829s left) i915_suspend (basic-s2idle-without-i915)
[194.613000] Starting subtest: basic-s2idle-without-i915
[216.085298] Subtest basic-s2idle-without-i915: SUCCESS (5.975s)
[221.277967] [024/133] (808s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[221.394377] Starting subtest: y-tiled-addfb-size-offset-overflow
[221.396098] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[221.519965] [025/133] (808s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[221.605564] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[221.606490] Starting dynamic subtest: pipe-A-eDP-1
[221.610121] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.617481] Starting dynamic subtest: pipe-B-eDP-1
[221.620589] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.626920] Starting dynamic subtest: pipe-C-eDP-1
[221.630181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.636220] Starting dynamic subtest: pipe-D-eDP-1
[221.639492] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.641219] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[223.848220] [026/133] (805s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[223.939937] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[223.940791] Starting dynamic subtest: pipe-A-default-mode
[226.693838] Dynamic subtest pipe-A-default-mode: SUCCESS (2.732s)
[226.694672] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.733s)
[227.571413] [027/133] (802s left) gem_userptr_blits (stress-mm-invalidate-close)
[227.633975] Starting subtest: stress-mm-invalidate-close
[229.841788] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[229.945226] [028/133] (799s left) gem_userptr_blits (relocations)
[230.000607] Starting subtest: relocations
[230.002421] Subtest relocations: SKIP (0.001s)
[230.162984] [029/133] (799s left) syncobj_eventfd (timeline-wait-signaled)
[230.210787] Starting subtest: timeline-wait-signaled
[230.211674] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[230.330764] [030/133] (799s left) kms_rotation_crc (exhaust-fences)
[230.430669] Starting subtest: exhaust-fences
[230.432427] Subtest exhaust-fences: SKIP (0.000s)
[230.511244] [031/133] (799s left) kms_addfb_basic (addfb25-4-tiled)
[230.619948] Starting subtest: addfb25-4-tiled
[230.620818] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[230.735532] [032/133] (799s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[230.841363] Starting subtest: cursorB-vs-flipA-legacy
[230.844883] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[231.021398] [033/133] (798s left) gem_partial_pwrite_pread (reads-display)
[231.080882] Subtest reads-display: SKIP (0.000s)
[231.141517] [034/133] (798s left) gem_softpin (evict-active-interruptible)
[231.203634] Starting subtest: evict-active-interruptible
[231.209657] Subtest evict-active-interruptible: SUCCESS (0.006s)
[231.380173] [035/133] (798s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[231.484817] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[231.486528] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[231.570949] [036/133] (798s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[231.672849] Starting subtest: fb-8bpc-vs-panel-8bpc
[231.673877] Starting dynamic subtest: pipe-A-eDP-1
[233.065291] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.387s)
[233.066302] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.389s)
[233.871052] [037/133] (796s left) syncobj_timeline (wait-all-snapshot)
[233.922042] Starting subtest: wait-all-snapshot
[234.004180] Subtest wait-all-snapshot: SUCCESS (0.081s)
[234.101598] [038/133] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[234.199788] Starting subtest: fbcpsr-2p-rte
[234.201647] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[234.322027] [039/133] (795s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[234.420105] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[234.421015] Starting dynamic subtest: pipe-A-eDP-1
[234.649258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.218s)
[234.656584] Starting dynamic subtest: pipe-B-eDP-1
[235.934976] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.282s)
[235.942208] Starting dynamic subtest: pipe-C-eDP-1
[237.126949] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.189s)
[237.134164] Starting dynamic subtest: pipe-D-eDP-1
[238.367592] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[238.368415] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.928s)
[239.616036] [040/133] (790s left) sw_sync (sync_busy_fork_unixsocket)
[239.649590] Starting subtest: sync_busy_fork_unixsocket
[239.656505] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[239.714425] [041/133] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[239.813737] Starting subtest: psr-2p-primscrn-cur-indfb-move
[239.815440] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[239.946633] [042/133] (790s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[240.041490] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[240.043263] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[240.119530] [043/133] (790s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[240.210473] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[240.212252] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[240.339499] [044/133] (789s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[240.440129] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[241.429970] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.989s)
[241.594571] [045/133] (788s left) kms_vblank (ts-continuation-modeset-hang)
[241.693970] Starting subtest: ts-continuation-modeset-hang
[241.694948] Starting dynamic subtest: pipe-A-eDP-1
[268.585641] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.876s)
[268.594611] Starting dynamic subtest: pipe-D-eDP-1
[293.560006] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.962s)
[293.560902] Subtest ts-continuation-modeset-hang: SUCCESS (51.843s)
[294.371817] [046/133] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[294.478981] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[294.480699] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[294.603659] [047/133] (735s left) gem_spin_batch (engines)
[294.680835] Starting subtest: engines
[294.681709] Starting dynamic subtest: rcs0
[297.930219] Dynamic subtest rcs0: SUCCESS (3.238s)
[297.940054] Starting dynamic subtest: bcs0
[301.204729] Dynamic subtest bcs0: SUCCESS (3.235s)
[301.214186] Starting dynamic subtest: vcs0
[304.443771] Dynamic subtest vcs0: SUCCESS (3.235s)
[304.453214] Starting dynamic subtest: vcs1
[307.680066] Dynamic subtest vcs1: SUCCESS (3.233s)
[307.689194] Starting dynamic subtest: vecs0
[310.916782] Dynamic subtest vecs0: SUCCESS (3.233s)
[310.926022] Starting dynamic subtest: ccs0
[314.153810] Dynamic subtest ccs0: SUCCESS (3.234s)
[314.155131] Subtest engines: SUCCESS (19.419s)
[314.373706] [048/133] (716s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[314.432072] Subtest no-spare-fences-busy: SKIP (0.000s)
[314.484653] [049/133] (715s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[314.537086] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[314.538274] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[314.663785] [050/133] (715s left) gem_exec_schedule (submit-golden-slice)
[314.722943] Starting subtest: submit-golden-slice
[314.723869] Starting dynamic subtest: rcs0
[314.777155] Dynamic subtest rcs0: SUCCESS (0.054s)
[314.786924] Starting dynamic subtest: bcs0
[314.824812] Dynamic subtest bcs0: SUCCESS (0.047s)
[314.834536] Starting dynamic subtest: vcs0
[314.872048] Dynamic subtest vcs0: SUCCESS (0.046s)
[314.880285] Starting dynamic subtest: vcs1
[314.919540] Dynamic subtest vcs1: SUCCESS (0.047s)
[314.927443] Starting dynamic subtest: vecs0
[314.966261] Dynamic subtest vecs0: SUCCESS (0.046s)
[314.975633] Starting dynamic subtest: ccs0
[315.007866] Dynamic subtest ccs0: SUCCESS (0.041s)
[315.009114] Subtest submit-golden-slice: SUCCESS (0.285s)
[316.885971] [051/133] (713s left) perf (oa-formats)
[317.022022] Starting subtest: oa-formats
[317.023337] Starting dynamic subtest: 0-rcs0
[317.038124] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[317.045219] Starting dynamic subtest: 1-vcs1
[317.061144] Dynamic subtest 1-vcs1: SUCCESS (0.022s)
[317.061996] Subtest oa-formats: SUCCESS (0.040s)
[317.104292] [052/133] (713s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[317.184066] Starting subtest: plane-all-modeset-transition-fencing
[317.185838] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[317.251493] [053/133] (713s left) api_intel_allocator (open-vm)
[317.298016] Starting subtest: open-vm
[317.301547] Subtest open-vm: SUCCESS (0.004s)
[317.440690] [054/133] (713s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[317.540031] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[317.540927] Starting dynamic subtest: pipe-A-eDP-1
[318.334344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.791s)
[318.341940] Starting dynamic subtest: pipe-B-eDP-1
[319.930088] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.594s)
[319.938257] Starting dynamic subtest: pipe-C-eDP-1
[321.387704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.457s)
[321.394777] Starting dynamic subtest: pipe-D-eDP-1
[322.931954] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.543s)
[322.932774] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.390s)
[324.132992] [055/133] (706s left) kms_panel_fitting (legacy)
[324.245968] Starting subtest: legacy
[324.246832] Starting dynamic subtest: pipe-A-eDP-1
[324.774834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[324.801831] Starting dynamic subtest: pipe-B-eDP-1
[326.416118] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.621s)
[326.442228] Starting dynamic subtest: pipe-C-eDP-1
[328.031560] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.596s)
[328.057170] Starting dynamic subtest: pipe-D-eDP-1
[329.611322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.560s)
[329.612106] Subtest legacy: SUCCESS (5.366s)
[330.852621] [056/133] (699s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[330.944709] Starting subtest: psr-rgb101010-draw-mmap-wc
[338.024737] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.079s)
[338.152191] [057/133] (692s left) gem_wait (busy)
[338.220284] Starting subtest: busy
[338.221284] Starting dynamic subtest: all-engines
[339.753556] Dynamic subtest all-engines: SUCCESS (1.523s)
[339.762666] Starting dynamic subtest: rcs0
[340.285899] Dynamic subtest rcs0: SUCCESS (0.540s)
[340.294933] Starting dynamic subtest: bcs0
[340.825580] Dynamic subtest bcs0: SUCCESS (0.539s)
[340.834739] Starting dynamic subtest: vcs0
[342.762463] Dynamic subtest vcs0: SUCCESS (1.925s)
[342.771620] Starting dynamic subtest: vcs1
[344.745049] Dynamic subtest vcs1: SUCCESS (1.980s)
[344.754555] Starting dynamic subtest: vecs0
[346.794375] Dynamic subtest vecs0: SUCCESS (2.046s)
[346.803676] Starting dynamic subtest: ccs0
[347.327712] Dynamic subtest ccs0: SUCCESS (0.541s)
[347.328919] Subtest busy: SUCCESS (9.106s)
[347.529217] [058/133] (683s left) perf_pmu (module-unload)
[347.641506] Starting subtest: module-unload
[354.400957] Subtest module-unload: FAIL (6.721s)
[354.423459] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[354.424208] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[354.425953] [059/133] (676s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[355.977539] Starting subtest: multi-wait-for-submit-available-signaled
[355.978549] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[356.071828] [FACT syncobj_timeline (multi-wait-for-submit-available-signaled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[356.073087] [FACT syncobj_timeline (multi-wait-for-submit-available-signaled)] new: kernel.kmod_is_loaded.i915: true
[356.075820] [060/133] (674s left) i915_pm_rc6_residency (rc6-fence)
[356.139155] Starting subtest: rc6-fence
[356.180003] Starting dynamic subtest: gt0
[368.516266] Dynamic subtest gt0: SUCCESS (12.325s)
[368.524018] Starting dynamic subtest: gt1
[384.747276] Dynamic subtest gt1: SUCCESS (16.221s)
[384.748562] Subtest rc6-fence: SUCCESS (28.590s)
[384.820598] [061/133] (646s left) kms_plane_alpha_blend (alpha-transparent-fb)
[384.929895] Starting subtest: alpha-transparent-fb
[385.223726] Starting dynamic subtest: pipe-A-eDP-1
[385.878008] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.654s)
[385.884652] Starting dynamic subtest: pipe-D-eDP-1
[387.198294] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[387.199516] Subtest alpha-transparent-fb: SUCCESS (2.267s)
[388.008291] [062/133] (642s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[388.115456] Starting subtest: yf-tiled-64bpp-rotate-270
[388.117440] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[388.239727] [063/133] (642s left) perf (buffer-fill)
[388.360678] Starting subtest: buffer-fill
[388.361568] Starting dynamic subtest: 0-rcs0
[390.621589] Dynamic subtest 0-rcs0: SUCCESS (2.251s)
[390.630920] Starting dynamic subtest: 1-vcs1
[395.058787] Dynamic subtest 1-vcs1: SUCCESS (4.434s)
[395.059893] Subtest buffer-fill: SUCCESS (6.688s)
[395.098752] [064/133] (635s left) gen9_exec_parse (unaligned-access)
[395.160360] Subtest unaligned-access: SKIP (0.000s)
[395.238010] [065/133] (635s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[395.329262] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[395.330848] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[395.466593] [066/133] (635s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[395.563083] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[395.564892] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[395.698665] [067/133] (635s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[395.794696] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[395.796457] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[395.901814] [068/133] (635s left) gem_mmap_gtt (big-bo)
[395.964946] Subtest big-bo: SKIP (0.000s)
[396.034532] [069/133] (635s left) kms_lease (multimaster-lease)
[396.124260] Starting subtest: multimaster-lease
[396.127930] Subtest multimaster-lease: SUCCESS (0.004s)
[396.244157] [070/133] (634s left) gem_exec_params (cliprects_ptr-dirt)
[396.294799] Starting subtest: cliprects_ptr-dirt
[396.295676] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[396.407587] [071/133] (634s left) kms_chamelium_audio (dp-audio)
[396.805127] Subtest dp-audio: SKIP (0.000s)
[397.620767] [072/133] (633s left) kms_atomic (plane-overlay-legacy)
[397.710142] Starting subtest: plane-overlay-legacy
[397.711084] Starting dynamic subtest: pipe-A-eDP-1
[398.144987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[398.145913] Subtest plane-overlay-legacy: SUCCESS (0.436s)
[398.988451] [073/133] (632s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[399.078330] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[399.079176] Starting dynamic subtest: pipe-A-eDP-1
[399.087641] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.095440] Starting dynamic subtest: pipe-B-eDP-1
[399.103455] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.110817] Starting dynamic subtest: pipe-C-eDP-1
[399.118722] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.125674] Starting dynamic subtest: pipe-D-eDP-1
[399.141095] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.142733] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[401.352984] [074/133] (629s left) gem_exec_reloc (basic-write-cpu)
[401.411962] Subtest basic-write-cpu: SKIP (0.000s)
[401.493693] [075/133] (629s left) gem_ctx_isolation (preservation-s3)
[401.557205] Starting subtest: preservation-S3
[401.558154] Starting dynamic subtest: rcs0
[417.687503] Dynamic subtest rcs0: SUCCESS (1.766s)
[417.696911] Starting dynamic subtest: bcs0
[434.682801] Dynamic subtest bcs0: SUCCESS (1.700s)
[434.691979] Starting dynamic subtest: vcs0
[451.684900] Dynamic subtest vcs0: SUCCESS (3.196s)
[451.697852] Starting dynamic subtest: vcs1
[469.683126] Dynamic subtest vcs1: SUCCESS (5.004s)
[469.691106] Starting dynamic subtest: vecs0
[487.692630] Dynamic subtest vecs0: SUCCESS (4.988s)
[487.700113] Starting dynamic subtest: ccs0
[505.708770] Dynamic subtest ccs0: SUCCESS (3.239s)
[505.709970] Subtest preservation-S3: SUCCESS (19.898s)
[511.979992] [076/133] (525s left) kms_psr (pr-primary-mmap-gtt)
[512.090084] Starting subtest: pr-primary-mmap-gtt
[512.092061] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[512.170435] [077/133] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[512.262960] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[535.470617] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.052s)
[535.649184] [078/133] (501s left) gem_ringfill (engines-basic)
[540.992637] Starting subtest: engines-basic
[540.993802] Starting dynamic subtest: rcs0
[541.037791] Dynamic subtest rcs0: SUCCESS (0.051s)
[541.049468] Starting dynamic subtest: bcs0
[541.082448] Dynamic subtest bcs0: SUCCESS (0.043s)
[541.093526] Starting dynamic subtest: vcs0
[541.125497] Dynamic subtest vcs0: SUCCESS (0.041s)
[541.135299] Starting dynamic subtest: vcs1
[541.168510] Dynamic subtest vcs1: SUCCESS (0.041s)
[541.177809] Starting dynamic subtest: vecs0
[541.211424] Dynamic subtest vecs0: SUCCESS (0.041s)
[541.221408] Starting dynamic subtest: ccs0
[541.256625] Dynamic subtest ccs0: SUCCESS (0.043s)
[541.259257] Subtest engines-basic: SUCCESS (0.272s)
[541.341519] [079/133] (496s left) gem_exec_fence (keep-in-fence)
[541.534778] Starting subtest: keep-in-fence
[541.535887] Starting dynamic subtest: rcs0
[541.609684] Dynamic subtest rcs0: SUCCESS (0.081s)
[541.622185] Starting dynamic subtest: bcs0
[541.664562] Dynamic subtest bcs0: SUCCESS (0.053s)
[541.676217] Starting dynamic subtest: vcs0
[543.039531] Dynamic subtest vcs0: SUCCESS (1.362s)
[543.049982] Starting dynamic subtest: vcs1
[545.023552] Dynamic subtest vcs1: SUCCESS (1.980s)
[545.033722] Starting dynamic subtest: vecs0
[547.007519] Dynamic subtest vecs0: SUCCESS (1.982s)
[547.017892] Starting dynamic subtest: ccs0
[547.221335] Dynamic subtest ccs0: SUCCESS (0.221s)
[547.222837] Subtest keep-in-fence: SUCCESS (5.692s)
[549.067491] [080/133] (488s left) syncobj_timeline (etime-single-wait-submitted)
[549.128888] Starting subtest: etime-single-wait-submitted
[549.234958] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[549.321665] [081/133] (488s left) fbdev (write)
[549.353343] Starting subtest: write
[549.725717] Subtest write: SUCCESS (0.363s)
[549.786877] [082/133] (487s left) gem_ctx_shared (create-shared-gtt)
[549.844546] Starting subtest: create-shared-gtt
[552.041249] Subtest create-shared-gtt: SUCCESS (2.153s)
[552.304368] [083/133] (485s left) kms_frontbuffer_tracking (basic)
[552.409166] Starting subtest: basic
[555.611936] Subtest basic: SUCCESS (3.204s)
[555.772536] [084/133] (481s left) gem_exec_balancer (bonded-semaphore)
[555.847512] Starting subtest: bonded-semaphore
[555.849429] Subtest bonded-semaphore: SKIP (0.000s)
[556.172062] [085/133] (481s left) kms_chamelium_edid (hdmi-edid-read)
[556.566958] Subtest hdmi-edid-read: SKIP (0.000s)
[557.386617] [086/133] (480s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[557.501687] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[564.313596] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.812s)
[564.458326] [087/133] (473s left) gem_exec_capture (capture-invisible)
[564.518671] Starting subtest: capture-invisible
[564.519658] Starting dynamic subtest: smem0
[564.521537] Dynamic subtest smem0: SKIP (0.000s)
[564.523357] Subtest capture-invisible: SKIP (0.001s)
[564.653249] [088/133] (473s left) kms_dsc (dsc-with-output-formats-with-bpc)
[564.746087] Starting subtest: dsc-with-output-formats-with-bpc
[564.767659] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[564.829896] [089/133] (473s left) api_intel_bb (purge-bb)
[564.882823] Starting subtest: purge-bb
[564.885399] Subtest purge-bb: SUCCESS (0.003s)
[565.042839] [090/133] (472s left) kms_flip (flip-vs-suspend-interruptible)
[565.134939] Starting subtest: flip-vs-suspend-interruptible
[565.136613] Starting dynamic subtest: A-eDP1
[598.652609] Dynamic subtest A-eDP1: SUCCESS (4.327s)
[598.667894] Starting dynamic subtest: B-eDP1
[633.669324] Dynamic subtest B-eDP1: SUCCESS (4.199s)
[633.684986] Starting dynamic subtest: C-eDP1
[667.667017] Dynamic subtest C-eDP1: SUCCESS (4.195s)
[667.681627] Starting dynamic subtest: D-eDP1
[701.670763] Dynamic subtest D-eDP1: SUCCESS (4.182s)
[701.674375] Subtest flip-vs-suspend-interruptible: SUCCESS (16.916s)
[708.918819] [091/133] (335s left) gem_shrink (reclaim)
[708.998940] Starting subtest: reclaim
[711.574207] Subtest reclaim: SUCCESS (2.485s)
[711.674152] [092/133] (332s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[711.784582] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[711.785875] Starting dynamic subtest: pipe-A-eDP-1
[717.759744] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.915s)
[717.768726] Starting dynamic subtest: pipe-B-eDP-1
[724.440516] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.648s)
[724.441661] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.567s)
[725.318590] [093/133] (318s left) kms_flip (flip-vs-fences)
[725.429360] Starting subtest: flip-vs-fences
[725.431339] Subtest flip-vs-fences: SKIP (0.000s)
[725.576428] [094/133] (318s left) kms_content_protection (srm)
[725.712327] Starting subtest: srm
[725.715044] Subtest srm: SKIP (0.001s)
[725.876523] [095/133] (318s left) kms_color (degamma)
[725.959691] Starting subtest: degamma
[725.960644] Starting dynamic subtest: pipe-A-eDP-1
[726.681667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[726.690075] Starting dynamic subtest: pipe-B-eDP-1
[728.171785] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s)
[728.179824] Starting dynamic subtest: pipe-C-eDP-1
[729.507935] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.334s)
[729.516265] Starting dynamic subtest: pipe-D-eDP-1
[730.837885] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[730.838848] Subtest degamma: SUCCESS (4.869s)
[731.650072] [096/133] (312s left) kms_atomic_transition (plane-toggle-modeset-transition)
[731.756114] Starting subtest: plane-toggle-modeset-transition
[731.756951] Starting dynamic subtest: pipe-A-eDP-1
[744.465519] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.705s)
[744.478397] Starting dynamic subtest: pipe-B-eDP-1
[756.926645] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.455s)
[756.930350] Subtest plane-toggle-modeset-transition: SUCCESS (25.166s)
[757.749801] [097/133] (286s left) prime_mmap (test_aperture_limit)
[757.817440] Starting subtest: test_aperture_limit
[757.818714] Starting dynamic subtest: test_aperture_limit-smem
[757.824760] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[757.826722] Subtest test_aperture_limit: SKIP (0.009s)
[757.941205] [098/133] (286s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[758.040413] Starting subtest: fbc-psr2-primary-mmap-gtt
[758.041671] Starting dynamic subtest: eDP-1
[758.044289] Dynamic subtest eDP-1: SKIP (0.000s)
[758.046350] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[758.124782] [099/133] (286s left) gem_pxp (reject-modify-context-protection-off-1)
[758.252541] Starting subtest: reject-modify-context-protection-off-1
[758.254240] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[758.387726] [100/133] (285s left) vgem_basic (bad-handle)
[758.426511] Starting subtest: bad-handle
[758.427557] Subtest bad-handle: SUCCESS (0.000s)
[758.489717] [101/133] (285s left) kms_psr (psr2-dpms)
[758.580365] Starting subtest: psr2-dpms
[758.581551] Starting dynamic subtest: eDP-1
[761.476679] Dynamic subtest eDP-1: SUCCESS (2.895s)
[761.477962] Subtest psr2-dpms: SUCCESS (2.896s)
[762.351918] [102/133] (282s left) core_setmaster (master-drop-set-user)
[762.442631] Starting subtest: master-drop-set-user
[762.455760] Subtest master-drop-set-user: SUCCESS (0.013s)
[762.487162] [103/133] (281s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[762.590347] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[762.592321] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[762.712008] [104/133] (281s left) gem_exec_fence (syncobj-wait)
[763.137720] Starting subtest: syncobj-wait
[764.657125] Subtest syncobj-wait: SUCCESS (1.510s)
[766.709962] [105/133] (277s left) gem_close_race (multigpu-basic-threads)
[766.767543] Starting subtest: multigpu-basic-threads
[766.769678] Subtest multigpu-basic-threads: SKIP (0.000s)
[767.033077] [106/133] (277s left) gem_exec_schedule (preemptive-hang)
[767.212993] Starting subtest: preemptive-hang
[767.214425] Starting dynamic subtest: rcs0
[776.807510] Dynamic subtest rcs0: SUCCESS (9.592s)
[776.815847] Starting dynamic subtest: bcs0
[785.764073] Dynamic subtest bcs0: SUCCESS (8.950s)
[785.772941] Starting dynamic subtest: vcs0
[794.786977] Dynamic subtest vcs0: SUCCESS (9.018s)
[794.797005] Starting dynamic subtest: vcs1
[803.812960] Dynamic subtest vcs1: SUCCESS (9.024s)
[803.820717] Starting dynamic subtest: vecs0
[812.767956] Dynamic subtest vecs0: SUCCESS (8.954s)
[812.777716] Starting dynamic subtest: ccs0
[821.734300] Dynamic subtest ccs0: SUCCESS (8.967s)
[821.735494] Subtest preemptive-hang: SUCCESS (54.516s)
[822.004663] [107/133] (222s left) gem_mmap_wc (write-wc-read-gtt)
[822.064615] Subtest write-wc-read-gtt: SKIP (0.000s)
[822.119044] [108/133] (222s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[822.229354] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[829.614498] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.386s)
[829.784779] [109/133] (214s left) gem_lmem_swapping (massive-random)
[829.824369] Subtest massive-random: SKIP (0.000s)
[829.865387] [110/133] (214s left) gem_exec_async (forked-writes)
[829.928263] Starting subtest: forked-writes
[829.929724] Starting dynamic subtest: rcs0
[829.957851] Dynamic subtest rcs0: SUCCESS (0.030s)
[829.969014] Starting dynamic subtest: bcs0
[829.981453] Dynamic subtest bcs0: SUCCESS (0.023s)
[829.989617] Starting dynamic subtest: vcs0
[830.002531] Dynamic subtest vcs0: SUCCESS (0.020s)
[830.011738] Starting dynamic subtest: vcs1
[830.025789] Dynamic subtest vcs1: SUCCESS (0.022s)
[830.034969] Starting dynamic subtest: vecs0
[830.048809] Dynamic subtest vecs0: SUCCESS (0.022s)
[830.057767] Starting dynamic subtest: ccs0
[830.071761] Dynamic subtest ccs0: SUCCESS (0.022s)
[830.072781] Subtest forked-writes: SUCCESS (0.144s)
[830.311317] [111/133] (214s left) gem_exec_params (secure-non-master)
[830.369897] Starting subtest: secure-non-master
[830.372735] Subtest secure-non-master: SKIP (0.000s)
[830.476812] [112/133] (214s left) kms_invalid_mode (uint-max-clock)
[830.567789] Starting subtest: uint-max-clock
[830.568942] Starting dynamic subtest: pipe-A-eDP-1
[830.856527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[830.864970] Starting dynamic subtest: pipe-B-eDP-1
[830.866370] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[830.874368] Starting dynamic subtest: pipe-C-eDP-1
[830.875354] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[830.883099] Starting dynamic subtest: pipe-D-eDP-1
[830.884116] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[830.884939] Subtest uint-max-clock: SUCCESS (0.295s)
[831.706614] [113/133] (213s left) perf (invalid-create-userspace-config)
[831.811795] Starting subtest: invalid-create-userspace-config
[831.815670] Subtest invalid-create-userspace-config: SUCCESS (0.002s)
[831.849659] [114/133] (212s left) gem_mmap_offset (mmap-unmap)
[831.905507] Starting subtest: mmap-unmap
[831.906634] Starting dynamic subtest: smem0
[855.874087] Dynamic subtest smem0: SUCCESS (23.920s)
[855.875435] Subtest mmap-unmap: SUCCESS (23.921s)
[855.943682] [115/133] (188s left) gem_exec_suspend (basic-s0)
[856.012151] Starting subtest: basic-S0
[856.013466] Starting dynamic subtest: smem
[876.137436] Dynamic subtest smem: SUCCESS (6.571s)
[876.139249] Subtest basic-S0: SUCCESS (6.573s)
[880.376985] [116/133] (168s left) prime_self_import (basic-with_one_bo)
[880.411645] Starting subtest: basic-with_one_bo
[880.443050] Subtest basic-with_one_bo: SUCCESS (0.033s)
[880.578457] [117/133] (168s left) kms_cursor_crc (cursor-onscreen-max-size)
[880.882657] Starting subtest: cursor-onscreen-max-size
[880.885573] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[881.037191] [118/133] (167s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[881.139445] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[881.141242] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[881.253971] [119/133] (167s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[881.350963] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[881.351820] Starting dynamic subtest: pipe-A
[881.706563] Dynamic subtest pipe-A: SUCCESS (0.349s)
[881.717031] Starting dynamic subtest: pipe-B
[883.138459] Dynamic subtest pipe-B: SUCCESS (1.407s)
[883.146967] Starting dynamic subtest: pipe-C
[884.597550] Dynamic subtest pipe-C: SUCCESS (1.437s)
[884.608076] Starting dynamic subtest: pipe-D
[886.050366] Dynamic subtest pipe-D: SUCCESS (1.436s)
[886.052908] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.633s)
[887.233116] [120/133] (161s left) kms_addfb_basic (small-bo)
[887.321940] Starting subtest: small-bo
[887.322805] Subtest small-bo: SUCCESS (0.000s)
[887.442322] [121/133] (161s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[887.531698] Starting subtest: fbc-rgb101010-draw-mmap-wc
[892.151495] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.589s)
[893.268498] [122/133] (155s left) kms_psr (psr-primary-blt)
[893.364652] Starting subtest: psr-primary-blt
[893.365709] Starting dynamic subtest: eDP-1
[895.082865] Dynamic subtest eDP-1: SUCCESS (1.712s)
[895.083669] Subtest psr-primary-blt: SUCCESS (1.713s)
[895.937355] [123/133] (153s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[896.037258] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[896.038164] Starting dynamic subtest: pipe-A-eDP-1
[896.161746] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[896.170866] Starting dynamic subtest: pipe-B-eDP-1
[897.304985] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s)
[897.306556] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.265s)
[898.496728] [124/133] (150s left) kms_pm_rpm (basic-rte)
[898.526935] Starting subtest: basic-rte
[901.767705] Subtest basic-rte: SUCCESS (3.235s)
[903.575452] [125/133] (145s left) gen9_exec_parse (batch-without-end)
[903.638497] Subtest batch-without-end: SKIP (0.000s)
[903.716423] [126/133] (145s left) gem_workarounds (basic-read-fd)
[903.773222] Starting subtest: basic-read-fd
[903.784414] Subtest basic-read-fd: SUCCESS (0.011s)
[903.938388] [127/133] (145s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[904.044201] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[904.045989] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[904.132674] [128/133] (145s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[904.215364] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[904.217348] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[904.322507] [129/133] (145s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[904.422003] Starting subtest: x-tiled-16bpp-rotate-0
[905.754169] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.331s)
[905.933180] [130/133] (143s left) gem_lmem_swapping (random-engines)
[905.973110] Subtest random-engines: SKIP (0.000s)
[906.011346] [131/133] (143s left) perf (global-sseu-config)
[906.126107] Starting subtest: global-sseu-config
[906.127960] Subtest global-sseu-config: SKIP (0.000s)
[906.174139] [132/133] (143s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[906.270940] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[907.086474] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[907.261352] [133/133] (142s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[907.326557] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[907.327641] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[907.445518] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_atomic_interruptible
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: i915_query
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: prime_vgem
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: sw_sync
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_hdr
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: i915_suspend
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: gem_userptr_blits
results: parsing output: 28/ for test: syncobj_eventfd
results: parsing output: 29/ for test: kms_rotation_crc
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: gem_softpin
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_dither
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: gem_fenced_exec_thrash
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: kms_atomic_transition
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_panel_fitting
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_wait
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: i915_pm_rc6_residency
results: parsing output: 60/ for test: kms_plane_alpha_blend
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_chamelium_audio
results: parsing output: 71/ for test: kms_atomic
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: gem_ctx_isolation
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ringfill
results: parsing output: 78/ for test: gem_exec_fence
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: kms_chamelium_edid
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_capture
results: parsing output: 87/ for test: kms_dsc
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_shrink
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_content_protection
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: prime_mmap
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: vgem_basic
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: core_setmaster
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: gem_close_race
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: gem_exec_async
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_invalid_mode
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: gem_exec_suspend
results: parsing output: 115/ for test: prime_self_import
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: gem_workarounds
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: perf
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: syncobj_wait
Done.