[56.338685] Initializing watchdogs
[56.338730]   /dev/watchdog0
[56.353109] [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.357528] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.360174] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.363344] [001/156] (960s left) kms_vrr (seamless-rr-switch-vrr)
[56.482640] Starting subtest: seamless-rr-switch-vrr
[56.489470] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[56.552811] [002/156] (960s left) perf (mi-rpc)
[56.684813] Starting subtest: mi-rpc
[56.689728] Subtest mi-rpc: SKIP (0.000s)
[56.722108] [003/156] (960s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-blt)
[56.816705] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-blt
[56.821198] Subtest hdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[56.911798] [004/156] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[57.008870] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[57.013032] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[57.100089] [005/156] (959s left) dumb_buffer (create-valid-dumb)
[57.149553] Starting subtest: create-valid-dumb
[57.151400] Subtest create-valid-dumb: SUCCESS (0.000s)
[57.247878] [006/156] (959s left) gem_ctx_param (invalid-set-ringsize)
[57.299159] Starting subtest: invalid-set-ringsize
[57.301192] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[57.374177] [007/156] (959s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[57.439885] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[57.548752] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.110s)
[57.634782] [008/156] (959s left) gem_exec_nop (basic-sequential)
[57.709864] Starting subtest: basic-sequential
[72.788219] Subtest basic-sequential: SUCCESS (15.204s)
[73.170679] [009/156] (943s left) syncobj_wait (wait-all-for-submit-snapshot)
[73.286650] Starting subtest: wait-all-for-submit-snapshot
[73.368805] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[73.445358] [010/156] (943s left) kms_pm_rpm (pm-caching)
[75.514521] Starting subtest: pm-caching
[75.520085] Subtest pm-caching: SKIP (0.000s)
[75.907989] [011/156] (941s left) kms_flip (bo-too-big-interruptible)
[76.010735] Starting subtest: bo-too-big-interruptible
[76.013132] Starting dynamic subtest: A-eDP1
[77.338652] Dynamic subtest A-eDP1: SUCCESS (1.329s)
[77.347490] Starting dynamic subtest: B-eDP1
[78.669942] Dynamic subtest B-eDP1: SUCCESS (1.331s)
[78.679628] Starting dynamic subtest: C-eDP1
[79.932667] Dynamic subtest C-eDP1: SUCCESS (1.263s)
[79.942666] Starting dynamic subtest: D-eDP1
[81.255795] Dynamic subtest D-eDP1: SUCCESS (1.323s)
[81.261812] Subtest bo-too-big-interruptible: SUCCESS (5.257s)
[82.464325] [012/156] (934s left) gem_softpin (evict-active)
[82.522984] Starting subtest: evict-active
[82.529678] Subtest evict-active: SUCCESS (0.007s)
[82.673313] [013/156] (934s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[82.773095] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[82.777216] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[82.854228] [014/156] (934s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[82.945897] Starting subtest: yf-tiled-64bpp-rotate-0
[82.950085] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[83.044701] [015/156] (934s left) gem_ctx_sseu (engines)
[83.097198] Subtest engines: SKIP (0.000s)
[83.162812] [016/156] (934s left) gem_mmap_gtt (pf-nonblock)
[83.212613] Subtest pf-nonblock: SKIP (0.000s)
[83.277713] [017/156] (934s left) gem_spin_batch (resubmit-all)
[83.343060] Starting subtest: resubmit-all
[83.345355] Starting dynamic subtest: rcs0
[83.355760] Dynamic subtest rcs0: SUCCESS (0.013s)
[83.364168] Starting dynamic subtest: bcs0
[83.366616] Dynamic subtest bcs0: SUCCESS (0.002s)
[83.374347] Starting dynamic subtest: vcs0
[83.376618] Dynamic subtest vcs0: SUCCESS (0.003s)
[83.383637] Starting dynamic subtest: vcs1
[83.385508] Dynamic subtest vcs1: SUCCESS (0.002s)
[83.392483] Starting dynamic subtest: vecs0
[83.394297] Dynamic subtest vecs0: SUCCESS (0.002s)
[83.401388] Starting dynamic subtest: ccs0
[83.403221] Dynamic subtest ccs0: SUCCESS (0.002s)
[83.404956] Subtest resubmit-all: SUCCESS (0.025s)
[85.350715] [018/156] (932s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[85.461984] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[85.466613] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[85.542918] [019/156] (931s left) kms_rotation_crc (bad-pixel-format)
[85.639769] Starting subtest: bad-pixel-format
[85.644196] Subtest bad-pixel-format: SKIP (0.001s)
[85.730198] [020/156] (931s left) kms_pm_backlight (fade-with-dpms)
[85.819845] Starting subtest: fade-with-dpms
[87.946943] Starting dynamic subtest: eDP-1
[90.946820] Dynamic subtest eDP-1: SUCCESS (3.000s)
[90.949352] Subtest fade-with-dpms: SUCCESS (5.128s)
[91.830479] [021/156] (925s left) tools_test (tools_test)
[91.891981] Starting subtest: tools_test
[91.943076] Subtest tools_test: SUCCESS (0.067s)
[92.015237] [022/156] (925s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[92.119861] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[92.122152] Starting dynamic subtest: pipe-A-eDP-1
[108.600757] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.484s)
[108.609069] Starting dynamic subtest: pipe-B-eDP-1
[125.808953] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.205s)
[125.811519] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.691s)
[126.686356] [023/156] (891s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[126.750334] Starting subtest: invalid-single-wait-all-unsubmitted
[126.752567] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[126.842424] [024/156] (890s left) perf_pmu (most-busy-check-all)
[126.878522] Starting subtest: most-busy-check-all
[126.880976] Starting dynamic subtest: rcs0
[128.320218] Dynamic subtest rcs0: SUCCESS (1.440s)
[128.332784] Starting dynamic subtest: bcs0
[130.306125] Dynamic subtest bcs0: SUCCESS (1.984s)
[130.318653] Starting dynamic subtest: vcs0
[132.287835] Dynamic subtest vcs0: SUCCESS (1.980s)
[132.298916] Starting dynamic subtest: vcs1
[134.272632] Dynamic subtest vcs1: SUCCESS (1.984s)
[134.284929] Starting dynamic subtest: vecs0
[136.320041] Dynamic subtest vecs0: SUCCESS (2.046s)
[136.331206] Starting dynamic subtest: ccs0
[138.305237] Dynamic subtest ccs0: SUCCESS (1.983s)
[138.308317] Subtest most-busy-check-all: SUCCESS (11.425s)
[138.404704] [025/156] (879s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[138.507601] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[138.511761] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[138.608989] [026/156] (879s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[138.719291] Starting subtest: cursorB-vs-flipA-atomic
[138.723933] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[138.861555] [027/156] (879s left) i915_module_load (reload)
[138.893768] Starting subtest: reload
[143.662366] Subtest reload: SUCCESS (4.770s)
[143.699901] [028/156] (874s left) i915_drm_fdinfo (most-busy-check-all)
[143.750484] Starting subtest: most-busy-check-all
[143.752827] Starting dynamic subtest: rcs0
[143.757402] Dynamic subtest rcs0: SKIP (0.003s)
[143.766205] Starting dynamic subtest: bcs0
[143.770167] Dynamic subtest bcs0: SKIP (0.000s)
[143.778535] Starting dynamic subtest: vcs0
[143.782889] Dynamic subtest vcs0: SKIP (0.000s)
[143.790713] Starting dynamic subtest: vcs1
[143.795148] Dynamic subtest vcs1: SKIP (0.000s)
[143.804193] Starting dynamic subtest: vecs0
[143.808389] Dynamic subtest vecs0: SKIP (0.000s)
[143.816226] Starting dynamic subtest: ccs0
[143.820471] Dynamic subtest ccs0: SKIP (0.000s)
[143.824711] Subtest most-busy-check-all: SKIP (0.007s)
[143.858916] [029/156] (874s left) sysfs_heartbeat_interval (idempotent)
[145.261637] Starting subtest: idempotent
[145.264069] Starting dynamic subtest: vecs0
[145.266417] Dynamic subtest vecs0: SUCCESS (0.001s)
[145.274362] Starting dynamic subtest: ccs0
[145.276660] Dynamic subtest ccs0: SUCCESS (0.001s)
[145.284383] Starting dynamic subtest: vcs0
[145.286787] Dynamic subtest vcs0: SUCCESS (0.000s)
[145.294341] Starting dynamic subtest: bcs0
[145.296709] Dynamic subtest bcs0: SUCCESS (0.000s)
[145.304648] Starting dynamic subtest: rcs0
[145.306847] Dynamic subtest rcs0: SUCCESS (0.000s)
[145.314426] Starting dynamic subtest: vcs1
[145.316677] Dynamic subtest vcs1: SUCCESS (0.001s)
[145.319087] Subtest idempotent: SUCCESS (0.006s)
[145.387274] [030/156] (872s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[145.438377] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[145.442455] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[145.631727] [031/156] (872s left) kms_psr (psr-primary-mmap-gtt)
[145.722997] Starting subtest: psr-primary-mmap-gtt
[145.725161] Starting dynamic subtest: eDP-1
[147.201829] Dynamic subtest eDP-1: SKIP (1.475s)
[147.206821] Subtest psr-primary-mmap-gtt: SKIP (1.477s)
[147.331953] [032/156] (870s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[147.436559] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[148.538070] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.101s)
[148.647276] [033/156] (869s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[148.748191] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[149.561935] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.814s)
[149.746944] [034/156] (868s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[149.851834] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[149.856448] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[149.947767] [035/156] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[150.057609] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[150.061784] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[150.153474] [036/156] (868s left) kms_cursor_crc (cursor-sliding-32x10)
[150.309235] Starting subtest: cursor-sliding-32x10
[150.355950] Subtest cursor-sliding-32x10: SKIP (0.046s)
[150.632769] [037/156] (867s left) gen9_exec_parse (bb-large)
[150.692642] Subtest bb-large: SKIP (0.000s)
[150.749659] [038/156] (867s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[150.837799] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[150.841446] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[150.935644] [039/156] (867s left) gem_mmap_gtt (cpuset-medium-copy)
[150.997260] Subtest cpuset-medium-copy: SKIP (0.000s)
[151.045474] [040/156] (867s left) gem_linear_blits (interruptible)
[151.431963] Starting subtest: interruptible
[155.529662] Subtest interruptible: SUCCESS (4.096s)
[155.683153] [041/156] (862s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[155.838273] Starting subtest: y-tiled-64bpp-rotate-180
[155.842954] Subtest y-tiled-64bpp-rotate-180: SKIP (0.002s)
[155.954920] [042/156] (862s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[156.057557] Starting subtest: hdr-rgb565-draw-blt
[156.061913] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[156.172727] [043/156] (862s left) gem_ctx_param (get-priority-new-ctx)
[156.219553] Starting subtest: get-priority-new-ctx
[156.221923] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[156.327285] [044/156] (862s left) gem_eio (unwedge-stress)
[156.535345] Starting subtest: unwedge-stress
[156.537445] Starting dynamic subtest: render
[161.024071] Dynamic subtest render: SUCCESS (4.487s)
[161.039867] Starting dynamic subtest: bsd1
[178.754848] Dynamic subtest bsd1: SUCCESS (17.729s)
[178.771976] Starting dynamic subtest: bsd2
[196.745619] Dynamic subtest bsd2: SUCCESS (17.990s)
[196.769333] Starting dynamic subtest: blt
[196.773948] Dynamic subtest blt: SKIP (0.000s)
[196.791064] Starting dynamic subtest: vebox
[214.727919] Dynamic subtest vebox: SUCCESS (17.979s)
[214.730652] Subtest unwedge-stress: SUCCESS (58.189s)
[216.370076] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[216.373518] [045/156] (802s left) gem_ringfill (legacy-basic)
[222.276795] Starting subtest: legacy-basic
[222.279408] Starting dynamic subtest: default
[222.333198] Dynamic subtest default: SUCCESS (0.058s)
[222.344541] Starting dynamic subtest: render
[222.373559] Dynamic subtest render: SUCCESS (0.039s)
[222.383120] Starting dynamic subtest: bsd
[222.416153] Dynamic subtest bsd: SUCCESS (0.041s)
[222.426557] Starting dynamic subtest: bsd1
[222.457321] Dynamic subtest bsd1: SUCCESS (0.039s)
[222.469323] Starting dynamic subtest: bsd2
[222.501036] Dynamic subtest bsd2: SUCCESS (0.042s)
[222.513941] Starting dynamic subtest: blt
[222.547795] Dynamic subtest blt: SUCCESS (0.044s)
[222.558954] Starting dynamic subtest: vebox
[222.589963] Dynamic subtest vebox: SUCCESS (0.042s)
[222.592497] Subtest legacy-basic: SUCCESS (0.315s)
[222.669435] [046/156] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[222.778877] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[229.833420] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (7.060s)
[229.957088] [047/156] (788s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt)
[230.068315] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt
[230.072459] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[230.169430] [048/156] (788s left) gem_exec_store (cachelines)
[230.243071] Starting subtest: cachelines
[230.244908] Starting dynamic subtest: rcs0
[230.321485] Dynamic subtest rcs0: SUCCESS (0.080s)
[230.333057] Starting dynamic subtest: bcs0
[230.371829] Dynamic subtest bcs0: SUCCESS (0.048s)
[230.382870] Starting dynamic subtest: vcs0
[230.425129] Dynamic subtest vcs0: SUCCESS (0.053s)
[230.436347] Starting dynamic subtest: vcs1
[230.479227] Dynamic subtest vcs1: SUCCESS (0.052s)
[230.491046] Starting dynamic subtest: vecs0
[230.532858] Dynamic subtest vecs0: SUCCESS (0.053s)
[230.544623] Starting dynamic subtest: ccs0
[230.584727] Dynamic subtest ccs0: SUCCESS (0.050s)
[230.587402] Subtest cachelines: SUCCESS (0.344s)
[230.771296] [049/156] (787s left) fbdev (write)
[230.818534] Starting subtest: write
[231.253430] Subtest write: SUCCESS (0.432s)
[231.319970] [050/156] (787s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[231.416257] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[231.420839] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[231.522541] [051/156] (787s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[231.614181] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[231.616484] Starting dynamic subtest: pipe-A-eDP-1
[233.892521] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.280s)
[233.902540] Starting dynamic subtest: pipe-B-eDP-1
[236.281537] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.386s)
[236.293065] Starting dynamic subtest: pipe-C-eDP-1
[238.371136] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.091s)
[238.381392] Starting dynamic subtest: pipe-D-eDP-1
[240.509337] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.137s)
[240.511214] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.898s)
[241.733362] [052/156] (777s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[241.841503] Starting subtest: psr-1p-pri-indfb-multidraw
[264.743545] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.908s)
[264.863737] [053/156] (754s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[264.927834] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[264.995031] [054/156] (753s left) api_intel_allocator (default-alignment)
[265.057258] Starting subtest: default-alignment
[265.059431] Subtest default-alignment: SUCCESS (0.003s)
[265.181195] [055/156] (753s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[265.271709] Starting subtest: bad-aux-stride-y-tiled-ccs
[265.273557] Starting dynamic subtest: pipe-A-eDP-1
[265.292096] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.303786] Starting dynamic subtest: pipe-B-eDP-1
[265.320750] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.329603] Starting dynamic subtest: pipe-C-eDP-1
[265.347273] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.355722] Starting dynamic subtest: pipe-D-eDP-1
[265.373822] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.377604] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[267.599144] [056/156] (751s left) gem_exec_schedule (preempt-self)
[267.674295] Starting subtest: preempt-self
[267.676289] Starting dynamic subtest: rcs0
[267.688133] Dynamic subtest rcs0: SUCCESS (0.021s)
[267.700483] Starting dynamic subtest: bcs0
[267.708623] Dynamic subtest bcs0: SUCCESS (0.020s)
[267.718079] Starting dynamic subtest: vcs0
[267.731489] Dynamic subtest vcs0: SUCCESS (0.022s)
[267.744281] Starting dynamic subtest: vcs1
[267.753772] Dynamic subtest vcs1: SUCCESS (0.021s)
[267.764048] Starting dynamic subtest: vecs0
[267.774696] Dynamic subtest vecs0: SUCCESS (0.020s)
[267.784446] Starting dynamic subtest: ccs0
[267.799520] Dynamic subtest ccs0: SUCCESS (0.024s)
[267.801739] Subtest preempt-self: SUCCESS (0.134s)
[269.404342] [057/156] (749s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt)
[269.498252] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt
[269.502140] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[269.603250] [058/156] (749s left) kms_frontbuffer_tracking (psrhdr-suspend)
[269.702480] Starting subtest: psrhdr-suspend
[269.706598] Subtest psrhdr-suspend: SKIP (0.000s)
[269.804423] [059/156] (749s left) gem_create (create-massive)
[269.868285] Starting subtest: create-massive
[269.870509] Subtest create-massive: SUCCESS (0.000s)
[270.051461] [060/156] (749s left) sw_sync (alloc_merge_fence)
[270.093870] Starting subtest: alloc_merge_fence
[270.095918] Subtest alloc_merge_fence: SUCCESS (0.000s)
[270.152875] [061/156] (749s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[270.249580] Starting subtest: 2x-plain-flip-ts-check-interruptible
[270.261228] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[270.340168] [062/156] (748s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[270.400754] Starting subtest: multi-wait-for-submit-available-submitted
[270.402815] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[270.514683] [063/156] (748s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[270.576678] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[270.684408] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[270.786348] [064/156] (748s left) gem_partial_pwrite_pread (reads-snoop)
[270.842645] Subtest reads-snoop: SKIP (0.000s)
[270.908166] [065/156] (748s left) kms_vblank (query-forked-busy-hang)
[271.001067] Starting subtest: query-forked-busy-hang
[271.002956] Starting dynamic subtest: pipe-A-eDP-1
[298.059505] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.057s)
[298.076283] Starting dynamic subtest: pipe-D-eDP-1
[313.047276] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.984s)
[313.049631] Subtest query-forked-busy-hang: SUCCESS (42.046s)
[313.871889] [066/156] (705s left) kms_psr (fbc-psr-sprite-render)
[313.972425] Starting subtest: fbc-psr-sprite-render
[313.974800] Starting dynamic subtest: eDP-1
[313.979290] Dynamic subtest eDP-1: SKIP (0.000s)
[313.983773] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[314.043903] [067/156] (705s left) gem_mmap_wc (write-wc-read-gtt)
[314.096567] Subtest write-wc-read-gtt: SKIP (0.000s)
[314.153678] [068/156] (705s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[314.209635] Starting subtest: wait-all-for-submit-delayed-submit
[314.312488] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[314.396789] [069/156] (705s left) i915_pm_rc6_residency (media-rc6-accuracy)
[314.454037] Starting subtest: media-rc6-accuracy
[314.458043] Subtest media-rc6-accuracy: SKIP (0.000s)
[314.538775] [070/156] (705s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[314.588595] Starting subtest: framebuffer-vs-set-tiling
[314.593357] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[314.708342] [071/156] (704s left) i915_pm_rps (thresholds-idle-park)
[314.767679] Starting subtest: thresholds-idle-park
[314.772324] Subtest thresholds-idle-park: SKIP (0.001s)
[314.862055] [072/156] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[314.964600] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[314.968854] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[315.066160] [073/156] (704s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[315.157146] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[315.161417] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[315.261305] [074/156] (704s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[315.362162] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[315.365483] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[315.483893] [075/156] (704s left) kms_chamelium_frames (hdmi-frame-dump)
[315.864062] Subtest hdmi-frame-dump: SKIP (0.000s)
[316.673455] [076/156] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[316.784490] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[320.518865] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.740s)
[321.690805] [077/156] (698s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[321.785224] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[328.492236] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.711s)
[328.626089] [078/156] (691s left) kms_frontbuffer_tracking (fbchdr-1p-indfb-fliptrack-mmap-gtt)
[328.726591] Starting subtest: fbchdr-1p-indfb-fliptrack-mmap-gtt
[328.730657] Subtest fbchdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[328.830686] [079/156] (691s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[328.934397] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[328.938707] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[329.023439] [080/156] (690s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[329.122291] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[329.126708] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[329.224636] [081/156] (690s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[329.326025] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[329.330579] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[329.454680] [082/156] (690s left) kms_plane_lowres (tiling-none)
[329.559557] Starting subtest: tiling-none
[329.561534] Starting dynamic subtest: pipe-A-eDP-1
[329.565357] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[329.859244] Starting dynamic subtest: pipe-B-eDP-1
[329.863919] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[329.875630] Starting dynamic subtest: pipe-C-eDP-1
[329.880822] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[329.890075] Starting dynamic subtest: pipe-D-eDP-1
[329.894088] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[329.898024] Subtest tiling-none: SKIP (0.299s)
[330.723452] [083/156] (689s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[330.828721] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[330.833156] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[330.919867] [084/156] (689s left) kms_pm_lpsp (kms-lpsp)
[332.031613] Starting subtest: kms-lpsp
[332.033878] Starting dynamic subtest: pipe-A-eDP-1
[332.164777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[332.460936] Subtest kms-lpsp: SUCCESS (0.434s)
[333.350747] [085/156] (686s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[333.443883] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[333.447809] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[333.518870] [086/156] (686s left) gem_mmap_wc (close)
[333.565478] Subtest close: SKIP (0.000s)
[333.642609] [087/156] (686s left) gem_exec_params (rsvd2-dirt)
[333.696615] Starting subtest: rsvd2-dirt
[333.701168] Subtest rsvd2-dirt: SKIP (0.000s)
[333.831181] [088/156] (686s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[333.931358] Starting subtest: x-tiled-32bpp-rotate-0
[335.443163] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.512s)
[335.636469] [089/156] (684s left) gem_ctx_persistence (userptr)
[335.688061] Starting subtest: userptr
[335.865738] Subtest userptr: SUCCESS (0.179s)
[335.945446] [090/156] (684s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[336.039861] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[336.043211] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[336.132078] [091/156] (684s left) kms_plane (pixel-format-4-tiled-modifier)
[336.216470] Starting subtest: pixel-format-4-tiled-modifier
[336.243443] Starting dynamic subtest: pipe-A-plane-0
[336.622977] Dynamic subtest pipe-A-plane-0: SUCCESS (0.378s)
[336.635181] Starting dynamic subtest: pipe-A-plane-3
[336.954298] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s)
[336.963504] Starting dynamic subtest: pipe-A-plane-5
[336.966980] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[338.046408] Starting dynamic subtest: pipe-B-plane-0
[338.425476] Dynamic subtest pipe-B-plane-0: SUCCESS (0.389s)
[338.435305] Starting dynamic subtest: pipe-B-plane-3
[338.736973] Dynamic subtest pipe-B-plane-3: SUCCESS (0.310s)
[338.746616] Starting dynamic subtest: pipe-B-plane-5
[338.751253] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[339.043804] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.829s)
[339.919375] [092/156] (680s left) kms_atomic_transition (modeset-transition-nonblocking)
[340.020316] Starting subtest: modeset-transition-nonblocking
[340.022312] Starting dynamic subtest: 1x-outputs
[351.370936] Dynamic subtest 1x-outputs: SUCCESS (11.352s)
[351.373442] Subtest modeset-transition-nonblocking: SUCCESS (11.354s)
[352.226614] [093/156] (668s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[352.331088] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[359.669319] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.344s)
[359.771786] [094/156] (660s left) gem_exec_schedule (fairslice)
[359.841708] Starting subtest: fairslice
[359.843799] Starting dynamic subtest: rcs0
[361.909411] Dynamic subtest rcs0: SUCCESS (2.022s)
[361.920062] Starting dynamic subtest: bcs0
[363.875224] Dynamic subtest bcs0: SUCCESS (2.017s)
[363.890332] Starting dynamic subtest: vcs0
[365.946432] Dynamic subtest vcs0: SUCCESS (2.023s)
[365.957757] Starting dynamic subtest: vcs1
[367.921652] Dynamic subtest vcs1: SUCCESS (2.020s)
[367.934111] Starting dynamic subtest: vecs0
[369.987734] Dynamic subtest vecs0: SUCCESS (2.018s)
[369.999374] Starting dynamic subtest: ccs0
[371.964535] Dynamic subtest ccs0: SUCCESS (2.025s)
[371.966739] Subtest fairslice: SUCCESS (12.130s)
[372.280811] [095/156] (648s left) perf (gen8-unprivileged-single-ctx-counters)
[372.423390] Starting subtest: gen8-unprivileged-single-ctx-counters
[372.427517] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[372.466091] [096/156] (648s left) kms_properties (plane-properties-atomic)
[372.568262] Starting subtest: plane-properties-atomic
[372.570546] Starting dynamic subtest: pipe-A-eDP-1
[373.122645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[373.134775] Starting dynamic subtest: pipe-B-eDP-1
[374.418240] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.296s)
[374.429925] Starting dynamic subtest: pipe-C-eDP-1
[375.650782] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.231s)
[375.662359] Starting dynamic subtest: pipe-D-eDP-1
[376.889813] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[376.892200] Subtest plane-properties-atomic: SUCCESS (4.324s)
[377.705382] [097/156] (643s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[377.790577] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[377.801454] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[377.877090] [098/156] (642s left) kms_psr (fbc-pr-cursor-plane-onoff)
[377.972216] Starting subtest: fbc-pr-cursor-plane-onoff
[377.976748] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[378.044976] [099/156] (642s left) kms_plane_scaling (2x-scaler-multi-pipe)
[378.143112] Starting subtest: 2x-scaler-multi-pipe
[378.147346] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[378.251835] [100/156] (642s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[378.351156] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[378.355670] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[378.436367] [101/156] (642s left) kms_psr (psr-suspend)
[378.530150] Starting subtest: psr-suspend
[378.532372] Starting dynamic subtest: eDP-1
[396.638501] Dynamic subtest eDP-1: SUCCESS (3.102s)
[396.640794] Subtest psr-suspend: SUCCESS (3.103s)
[397.480507] [102/156] (623s left) syncobj_timeline (single-wait-for-submit-signaled)
[397.547768] Starting subtest: single-wait-for-submit-signaled
[397.550281] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[397.647947] [103/156] (623s left) gem_exec_reloc (basic-cpu-active)
[397.719310] Subtest basic-cpu-active: SKIP (0.000s)
[397.823262] [104/156] (623s left) gem_gpgpu_fill (basic)
[397.875400] Starting subtest: basic
[397.877662] Starting dynamic subtest: smem
[397.884516] Dynamic subtest smem: SUCCESS (0.008s)
[397.886450] Subtest basic: SUCCESS (0.010s)
[398.017817] [105/156] (623s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[398.112365] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[398.116363] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[398.214505] [106/156] (622s left) gem_ctx_param (set-priority-invalid-size)
[398.276504] Starting subtest: set-priority-invalid-size
[398.278823] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[398.351943] [107/156] (622s left) kms_big_fb (4-tiled-addfb-size-overflow)
[398.439567] Starting subtest: 4-tiled-addfb-size-overflow
[398.441460] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[398.552348] [108/156] (622s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[398.646544] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[398.649827] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[398.740097] [109/156] (622s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[398.840571] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[398.844059] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[398.948816] [110/156] (622s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[399.044198] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[399.047936] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[399.154770] [111/156] (622s left) kms_draw_crc (draw-method-render)
[399.254384] Starting subtest: draw-method-render
[399.256169] Starting dynamic subtest: xrgb8888-untiled
[399.500569] Dynamic subtest xrgb8888-untiled: SUCCESS (0.254s)
[399.511047] Starting dynamic subtest: rgb565-untiled
[399.739402] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[399.750329] Starting dynamic subtest: xrgb2101010-untiled
[399.967308] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[399.978101] Starting dynamic subtest: xbgr16161616f-untiled
[400.195313] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[400.205541] Starting dynamic subtest: xrgb8888-xtiled
[400.326009] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[400.336634] Starting dynamic subtest: rgb565-xtiled
[400.434263] Dynamic subtest rgb565-xtiled: SUCCESS (0.109s)
[400.446663] Starting dynamic subtest: xrgb2101010-xtiled
[400.553620] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[400.564466] Starting dynamic subtest: xbgr16161616f-xtiled
[400.683942] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[400.694899] Starting dynamic subtest: xrgb8888-4tiled
[400.814818] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[400.826961] Starting dynamic subtest: rgb565-4tiled
[400.923527] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[400.934585] Starting dynamic subtest: xrgb2101010-4tiled
[401.043419] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[401.054362] Starting dynamic subtest: xbgr16161616f-4tiled
[401.173882] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[401.175746] Subtest draw-method-render: SUCCESS (1.966s)
[401.301171] [112/156] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[401.393545] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[401.396924] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[401.485202] [113/156] (619s left) gem_userptr_blits (probe)
[401.548472] Starting subtest: probe
[401.625524] Subtest probe: SUCCESS (0.078s)
[401.732309] [114/156] (619s left) kms_cursor_crc (cursor-alpha-transparent)
[401.824161] Starting subtest: cursor-alpha-transparent
[401.825698] Starting dynamic subtest: pipe-A-eDP-1
[402.432434] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[402.443426] Starting dynamic subtest: pipe-D-eDP-1
[403.706947] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.292s)
[403.709390] Subtest cursor-alpha-transparent: SUCCESS (1.914s)
[404.578826] [115/156] (616s left) kms_chamelium_hpd (common-hpd-after-suspend)
[404.951782] Subtest common-hpd-after-suspend: SKIP (0.000s)
[405.778247] [116/156] (615s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[405.863238] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[405.865550] Starting dynamic subtest: pipe-A-eDP-1
[405.888302] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[405.900951] Starting dynamic subtest: pipe-B-eDP-1
[405.923046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[405.933073] Starting dynamic subtest: pipe-C-eDP-1
[405.954831] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[405.964894] Starting dynamic subtest: pipe-D-eDP-1
[405.987117] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[405.990961] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[408.139400] [117/156] (613s left) gem_eio (execbuf)
[408.347082] Starting subtest: execbuf
[408.676299] Subtest execbuf: SUCCESS (0.332s)
[408.850684] [118/156] (612s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move)
[408.970487] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move
[408.974426] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[409.070436] [119/156] (612s left) gem_mmap (bad-object)
[409.129163] Subtest bad-object: SKIP (0.000s)
[409.192017] [120/156] (612s left) gem_exec_fence (submit-chain)
[409.367051] Starting subtest: submit-chain
[409.384104] Subtest submit-chain: SUCCESS (0.017s)
[411.378798] [121/156] (610s left) prime_busy (after)
[411.432994] Starting subtest: after
[411.437755] Starting dynamic subtest: rcs0
[411.471725] Dynamic subtest rcs0: SUCCESS (0.036s)
[411.482249] Starting dynamic subtest: bcs0
[411.540635] Dynamic subtest bcs0: SUCCESS (0.068s)
[411.552888] Starting dynamic subtest: vcs0
[411.582693] Dynamic subtest vcs0: SUCCESS (0.042s)
[411.596080] Starting dynamic subtest: vcs1
[411.624548] Dynamic subtest vcs1: SUCCESS (0.041s)
[411.637125] Starting dynamic subtest: vecs0
[411.665973] Dynamic subtest vecs0: SUCCESS (0.041s)
[411.677779] Starting dynamic subtest: ccs0
[411.708500] Dynamic subtest ccs0: SUCCESS (0.042s)
[411.816544] Subtest after: SUCCESS (0.383s)
[411.907405] [122/156] (609s left) gem_workarounds (basic-read-fd)
[411.963316] Starting subtest: basic-read-fd
[411.982559] Subtest basic-read-fd: SUCCESS (0.019s)
[412.098332] [123/156] (609s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[412.198718] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[412.200846] Starting dynamic subtest: pipe-A-eDP-1
[412.643427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.417s)
[412.656401] Starting dynamic subtest: pipe-B-eDP-1
[414.074683] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.437s)
[414.088546] Starting dynamic subtest: pipe-C-eDP-1
[415.438140] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[415.449928] Starting dynamic subtest: pipe-D-eDP-1
[416.880226] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.442s)
[416.882545] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.669s)
[418.036285] [124/156] (603s left) kms_plane_scaling (planes-downscale-factor-0-5)
[418.135393] Starting subtest: planes-downscale-factor-0-5
[418.137763] Starting dynamic subtest: pipe-A
[418.156155] Dynamic subtest pipe-A: SKIP (0.018s)
[418.167450] Starting dynamic subtest: pipe-B
[418.188739] Dynamic subtest pipe-B: SKIP (0.030s)
[418.199655] Starting dynamic subtest: pipe-C
[418.217441] Dynamic subtest pipe-C: SKIP (0.030s)
[418.228182] Starting dynamic subtest: pipe-D
[418.249696] Dynamic subtest pipe-D: SKIP (0.031s)
[418.253462] Subtest planes-downscale-factor-0-5: SKIP (0.111s)
[418.349348] [125/156] (603s left) gem_exec_balancer (bonded-pair)
[418.416998] Starting subtest: bonded-pair
[418.421077] Subtest bonded-pair: SKIP (0.000s)
[418.729579] [126/156] (603s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[418.830193] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[418.834218] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[418.942253] [127/156] (603s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[419.033461] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[419.037474] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[419.104814] [128/156] (602s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[419.333712] Starting subtest: cursor-rapid-movement-128x128
[419.336053] Starting dynamic subtest: pipe-A-eDP-1
[419.877006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[419.911662] Starting dynamic subtest: pipe-D-eDP-1
[421.148827] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[421.151318] Subtest cursor-rapid-movement-128x128: SUCCESS (1.819s)
[422.000018] [129/156] (600s left) kms_addfb_basic (basic-y-tiled-legacy)
[422.046980] Starting subtest: basic-y-tiled-legacy
[422.051289] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[422.199410] [130/156] (599s left) gem_partial_pwrite_pread (writes-after-reads)
[422.262150] Subtest writes-after-reads: SKIP (0.000s)
[422.335933] [131/156] (599s left) gem_exec_suspend (basic)
[422.386819] Starting subtest: basic
[422.389165] Starting dynamic subtest: smem
[424.285338] Dynamic subtest smem: SUCCESS (1.899s)
[424.288522] Subtest basic: SUCCESS (1.902s)
[424.470013] [132/156] (597s left) kms_cdclk (plane-scaling)
[424.563952] Starting subtest: plane-scaling
[424.566189] Starting dynamic subtest: pipe-A-eDP-1
[424.859240] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[424.870735] Starting dynamic subtest: pipe-B-eDP-1
[424.875671] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[424.887134] Starting dynamic subtest: pipe-C-eDP-1
[424.891944] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[424.902416] Starting dynamic subtest: pipe-D-eDP-1
[424.906968] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[424.911464] Subtest plane-scaling: SKIP (0.300s)
[425.718704] [133/156] (596s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[425.821306] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[433.236327] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.418s)
[433.388924] [134/156] (588s left) gem_exec_basic (basic)
[433.453632] Starting subtest: basic
[433.456092] Starting dynamic subtest: rcs0-smem
[433.458649] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[433.472562] Starting dynamic subtest: bcs0-smem
[433.474905] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[433.485296] Starting dynamic subtest: vcs0-smem
[433.487560] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[433.497681] Starting dynamic subtest: vcs1-smem
[433.499956] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[433.509953] Starting dynamic subtest: vecs0-smem
[433.512112] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[433.521945] Starting dynamic subtest: ccs0-smem
[433.524134] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[433.526366] Subtest basic: SUCCESS (0.015s)
[435.332438] [135/156] (587s left) kms_cursor_legacy (single-move)
[435.448044] Starting subtest: single-move
[435.450510] Starting dynamic subtest: pipe-A
[440.886649] Dynamic subtest pipe-A: SUCCESS (5.380s)
[440.899879] Starting dynamic subtest: pipe-B
[446.267485] Dynamic subtest pipe-B: SUCCESS (5.379s)
[446.280303] Starting dynamic subtest: pipe-C
[451.649577] Dynamic subtest pipe-C: SUCCESS (5.379s)
[451.662800] Starting dynamic subtest: pipe-D
[457.031339] Dynamic subtest pipe-D: SUCCESS (5.380s)
[457.044182] Starting dynamic subtest: all-pipes
[462.422589] Dynamic subtest all-pipes: SUCCESS (5.388s)
[462.424679] Subtest single-move: SUCCESS (26.925s)
[462.513913] [136/156] (559s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[462.567741] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[462.674334] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[462.751275] [137/156] (559s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[462.848551] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[462.850901] Starting dynamic subtest: pipe-A-default-mode
[465.556613] Dynamic subtest pipe-A-default-mode: SUCCESS (2.710s)
[465.559042] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.711s)
[466.427439] [138/156] (556s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[466.530481] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[466.534742] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[466.623176] [139/156] (555s left) gem_exec_flush (basic-uc-prw-default)
[466.691542] Starting subtest: basic-uc-prw-default
[472.180705] Subtest basic-uc-prw-default: SUCCESS (5.468s)
[472.360902] [140/156] (550s left) gem_sync (basic-store-each)
[472.433658] Starting subtest: basic-store-each
[475.084826] Subtest basic-store-each: SUCCESS (2.661s)
[475.276253] [141/156] (547s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-onoff)
[475.384362] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-onoff
[475.388394] Subtest fbchdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[475.493552] [142/156] (547s left) gem_userptr_blits (sync-unmap-cycles)
[475.551105] Starting subtest: sync-unmap-cycles
[480.916339] Subtest sync-unmap-cycles: SUCCESS (5.369s)
[481.040729] [143/156] (541s left) gem_exec_schedule (preempt-other)
[481.107439] Starting subtest: preempt-other
[481.109340] Starting dynamic subtest: rcs0
[481.233490] Dynamic subtest rcs0: SUCCESS (0.128s)
[481.250943] Starting dynamic subtest: bcs0
[481.358874] Dynamic subtest bcs0: SUCCESS (0.125s)
[481.370792] Starting dynamic subtest: vcs0
[481.481852] Dynamic subtest vcs0: SUCCESS (0.120s)
[481.501044] Starting dynamic subtest: vcs1
[481.599921] Dynamic subtest vcs1: SUCCESS (0.118s)
[481.615358] Starting dynamic subtest: vecs0
[481.717584] Dynamic subtest vecs0: SUCCESS (0.116s)
[481.732481] Starting dynamic subtest: ccs0
[481.845934] Dynamic subtest ccs0: SUCCESS (0.127s)
[481.848706] Subtest preempt-other: SUCCESS (0.742s)
[482.441483] [144/156] (540s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[482.555129] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[482.559784] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[482.641336] [145/156] (540s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[482.763167] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[483.758454] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.995s)
[484.564269] [146/156] (538s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[484.618703] Starting subtest: etime-multi-wait-all-available-unsubmitted
[484.721394] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s)
[484.800092] [147/156] (538s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[484.891371] Starting subtest: plane-lut1d-ctm3x4
[485.057385] Starting dynamic subtest: pipe-A-plane-0
[485.213439] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[485.225419] Starting dynamic subtest: pipe-A-plane-1
[485.401640] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[485.413221] Starting dynamic subtest: pipe-A-plane-2
[485.601498] Dynamic subtest pipe-A-plane-2: SUCCESS (0.199s)
[486.801068] Starting dynamic subtest: pipe-B-plane-0
[486.980705] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[486.996229] Starting dynamic subtest: pipe-B-plane-1
[487.160287] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[487.171046] Starting dynamic subtest: pipe-B-plane-2
[487.347347] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[488.544312] Starting dynamic subtest: pipe-C-plane-0
[488.677543] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[488.690264] Starting dynamic subtest: pipe-C-plane-1
[488.810697] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[488.821810] Starting dynamic subtest: pipe-C-plane-2
[488.966465] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[490.135717] Starting dynamic subtest: pipe-D-plane-0
[490.259504] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[490.270596] Starting dynamic subtest: pipe-D-plane-1
[490.415214] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[490.427283] Starting dynamic subtest: pipe-D-plane-2
[490.548272] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[490.839482] Subtest plane-lut1d-ctm3x4: SUCCESS (5.951s)
[491.705297] [148/156] (531s left) kms_content_protection (uevent)
[491.846379] Starting subtest: uevent
[491.850800] Subtest uevent: SKIP (0.000s)
[491.978481] [149/156] (530s left) kms_flip (2x-flip-vs-rmfb)
[492.086435] Starting subtest: 2x-flip-vs-rmfb
[492.094354] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[492.176354] [150/156] (530s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[492.271378] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[492.275568] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[492.336768] [151/156] (530s left) kms_psr (fbc-psr2-sprite-blt)
[492.429922] Starting subtest: fbc-psr2-sprite-blt
[492.432199] Starting dynamic subtest: eDP-1
[492.436600] Dynamic subtest eDP-1: SKIP (0.000s)
[492.441000] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[492.504478] [152/156] (530s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[492.608756] Starting subtest: fbcpsr-slowdraw
[517.849184] Subtest fbcpsr-slowdraw: SUCCESS (25.238s)
[517.975270] [153/156] (505s left) kms_vrr (flip-basic)
[518.073987] Starting subtest: flip-basic
[518.080635] Subtest flip-basic: SKIP (0.000s)
[518.162554] [154/156] (505s left) core_getstats (basic)
[518.219031] Starting subtest: basic
[518.221329] Subtest basic: SUCCESS (0.000s)
[518.318571] [155/156] (504s left) kms_psr (pr-sprite-render)
[518.406810] Starting subtest: pr-sprite-render
[518.411020] Subtest pr-sprite-render: SKIP (0.000s)
[518.481597] [156/156] (504s left) kms_lease (invalid-create-leases)
[518.580910] Starting subtest: invalid-create-leases
[518.586593] Subtest invalid-create-leases: SUCCESS (0.005s)
[518.704406] Closing watchdogs
results: parsing output: 0/ for test: kms_vrr
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: dumb_buffer
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: gem_exec_nop
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_softpin
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_ctx_sseu
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: gem_spin_batch
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_rotation_crc
results: parsing output: 19/ for test: kms_pm_backlight
results: parsing output: 20/ for test: tools_test
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: i915_module_load
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: sysfs_heartbeat_interval
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gem_linear_blits
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_ctx_param
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: gem_ringfill
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_store
results: parsing output: 48/ for test: fbdev
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_pipe_b_c_ivb
results: parsing output: 53/ for test: api_intel_allocator
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_create
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_partial_pwrite_pread
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_mmap_wc
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: i915_pm_rc6_residency
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: i915_pm_rps
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_chamelium_frames
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_plane_lowres
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_pm_lpsp
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: gem_mmap_wc
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_atomic_transition
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_properties
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: gem_gpgpu_fill
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: kms_chamelium_hpd
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_mmap
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: prime_busy
results: parsing output: 121/ for test: gem_workarounds
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: gem_partial_pwrite_pread
results: parsing output: 130/ for test: gem_exec_suspend
results: parsing output: 131/ for test: kms_cdclk
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_basic
results: parsing output: 134/ for test: kms_cursor_legacy
results: parsing output: 135/ for test: syncobj_wait
results: parsing output: 136/ for test: kms_flip_scaled_crc
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_exec_flush
results: parsing output: 139/ for test: gem_sync
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_userptr_blits
results: parsing output: 142/ for test: gem_exec_schedule
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: kms_cursor_legacy
results: parsing output: 145/ for test: syncobj_timeline
results: parsing output: 146/ for test: kms_color_pipeline
results: parsing output: 147/ for test: kms_content_protection
results: parsing output: 148/ for test: kms_flip
results: parsing output: 149/ for test: kms_joiner
results: parsing output: 150/ for test: kms_psr
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_vrr
results: parsing output: 153/ for test: core_getstats
results: parsing output: 154/ for test: kms_psr
results: parsing output: 155/ for test: kms_lease
Done.