[58.045401] Initializing watchdogs
[58.045445]   /dev/watchdog0
[58.060037] [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.064510] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.066815] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.070457] [001/130] (960s left) kms_content_protection (uevent)
[58.235119] Starting subtest: uevent
[58.239807] Subtest uevent: SKIP (0.000s)
[58.389643] [002/130] (960s left) gem_mmap_wc (pf-nonblock)
[58.456232] Subtest pf-nonblock: SKIP (0.000s)
[58.512802] [003/130] (960s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[58.633351] Starting subtest: basic-flip-before-cursor-varying-size
[59.599861] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.965s)
[60.419157] [004/130] (958s left) kms_psr (fbc-pr-primary-render)
[60.521069] Starting subtest: fbc-pr-primary-render
[60.525414] Subtest fbc-pr-primary-render: SKIP (0.000s)
[60.612725] [005/130] (958s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[60.716081] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[60.718227] Starting dynamic subtest: pipe-A-eDP-1
[60.740161] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[60.748965] Starting dynamic subtest: pipe-B-eDP-1
[60.769249] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[60.778180] Starting dynamic subtest: pipe-C-eDP-1
[60.798904] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[60.806714] Starting dynamic subtest: pipe-D-eDP-1
[60.829503] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.833815] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[62.895809] [006/130] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[62.996445] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[70.401999] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.407s)
[70.567045] [007/130] (948s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[70.672363] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[70.676943] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[70.787945] [008/130] (948s left) syncobj_timeline (multi-wait-signaled)
[70.847849] Starting subtest: multi-wait-signaled
[70.850222] Subtest multi-wait-signaled: SUCCESS (0.001s)
[70.974163] [009/130] (947s left) gem_ctx_shared (detached-shared-gtt)
[71.050398] Starting subtest: detached-shared-gtt
[73.205294] Subtest detached-shared-gtt: SUCCESS (2.151s)
[74.565238] [010/130] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[74.673827] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[74.678045] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[74.808872] [011/130] (944s left) i915_hangman (engine-engine-error)
[74.872939] Starting subtest: engine-engine-error
[74.874862] Starting dynamic subtest: rcs0
[76.855453] Dynamic subtest rcs0: SUCCESS (1.981s)
[76.865769] Starting dynamic subtest: bcs0
[78.901030] Dynamic subtest bcs0: SUCCESS (2.045s)
[78.911741] Starting dynamic subtest: vcs0
[80.885242] Dynamic subtest vcs0: SUCCESS (1.983s)
[80.895476] Starting dynamic subtest: vcs1
[82.868139] Dynamic subtest vcs1: SUCCESS (1.982s)
[82.880549] Starting dynamic subtest: vecs0
[84.854258] Dynamic subtest vecs0: SUCCESS (1.984s)
[84.864931] Starting dynamic subtest: ccs0
[86.901047] Dynamic subtest ccs0: SUCCESS (2.046s)
[86.903788] Subtest engine-engine-error: SUCCESS (12.027s)
[87.009195] [012/130] (931s left) api_intel_bb (blit-noreloc-purge-cache)
[87.072036] Starting subtest: blit-noreloc-purge-cache
[87.083018] Subtest blit-noreloc-purge-cache: SUCCESS (0.013s)
[87.254347] [013/130] (931s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[87.315076] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[87.395642] [014/130] (931s left) kms_psr (pr-dpms)
[87.505807] Starting subtest: pr-dpms
[87.509883] Subtest pr-dpms: SKIP (0.000s)
[87.597780] [015/130] (931s left) syncobj_basic (bad-pad-fd-to-handle)
[87.671054] Starting subtest: bad-pad-fd-to-handle
[87.673098] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[87.800312] [016/130] (931s left) gem_exec_create (basic)
[87.865858] Starting subtest: basic
[87.868150] Starting dynamic subtest: smem
[91.927085] Dynamic subtest smem: SUCCESS (4.059s)
[91.929443] Subtest basic: SUCCESS (4.060s)
[92.132918] [017/130] (927s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[92.249593] Starting subtest: yf-tiled-addfb-size-offset-overflow
[92.253604] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[92.381510] [018/130] (926s left) prime_mmap (test_forked_cpu_write)
[92.449626] Starting subtest: test_forked_cpu_write
[92.451584] Starting dynamic subtest: test_forked_cpu_write-smem
[92.455936] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[92.458335] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[92.594870] [019/130] (926s left) gem_workarounds (reset)
[92.667522] Starting subtest: reset
[92.863199] Subtest reset: SUCCESS (0.195s)
[93.001408] [020/130] (926s left) perf (non-zero-reason)
[93.125856] Starting subtest: non-zero-reason
[93.127941] Starting dynamic subtest: 0-rcs0
[98.541291] Dynamic subtest 0-rcs0: SUCCESS (5.360s)
[98.550732] Starting dynamic subtest: 1-vcs1
[102.445667] Dynamic subtest 1-vcs1: SUCCESS (3.902s)
[102.448482] Subtest non-zero-reason: SUCCESS (9.263s)
[102.487064] [021/130] (916s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[102.602087] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[109.163056] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.565s)
[109.286763] [022/130] (910s left) perf (unprivileged-single-ctx-counters)
[109.387038] Starting subtest: unprivileged-single-ctx-counters
[109.391953] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[109.426108] [023/130] (909s left) gem_softpin (allocator-evict)
[109.476766] Starting subtest: allocator-evict
[109.479127] Starting dynamic subtest: rcs0
[132.924137] Dynamic subtest rcs0: SUCCESS (23.446s)
[132.932084] Starting dynamic subtest: bcs0
[156.776521] Dynamic subtest bcs0: SUCCESS (23.850s)
[156.787487] Starting dynamic subtest: vcs0
[180.750761] Dynamic subtest vcs0: SUCCESS (23.971s)
[180.761608] Starting dynamic subtest: vcs1
[204.482608] Dynamic subtest vcs1: SUCCESS (23.731s)
[204.490673] Starting dynamic subtest: vecs0
[228.189495] Dynamic subtest vecs0: SUCCESS (23.705s)
[228.200348] Starting dynamic subtest: ccs0
[252.389292] Dynamic subtest ccs0: SUCCESS (24.197s)
[252.391696] Subtest allocator-evict: SUCCESS (142.907s)
[252.495406] [024/130] (766s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[252.645090] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[252.647658] Starting dynamic subtest: pipe-A
[252.993999] Dynamic subtest pipe-A: SUCCESS (0.351s)
[253.002963] Starting dynamic subtest: pipe-B
[254.460498] Dynamic subtest pipe-B: SUCCESS (1.466s)
[254.468640] Starting dynamic subtest: pipe-C
[255.864439] Dynamic subtest pipe-C: SUCCESS (1.403s)
[255.874100] Starting dynamic subtest: pipe-D
[257.321822] Dynamic subtest pipe-D: SUCCESS (1.457s)
[257.324174] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.679s)
[258.484708] [025/130] (760s left) kms_flip (2x-flip-vs-expired-vblank)
[258.586837] Starting subtest: 2x-flip-vs-expired-vblank
[258.598424] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[258.752484] [026/130] (760s left) kms_scaling_modes (scaling-mode-none)
[258.862786] Starting subtest: scaling-mode-none
[258.865272] Starting dynamic subtest: pipe-A-eDP-1
[258.963924] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[258.974376] Starting dynamic subtest: pipe-B-eDP-1
[258.996982] Dynamic subtest pipe-B-eDP-1: SKIP (0.031s)
[259.005197] Starting dynamic subtest: pipe-C-eDP-1
[259.028748] Dynamic subtest pipe-C-eDP-1: SKIP (0.031s)
[259.037090] Starting dynamic subtest: pipe-D-eDP-1
[259.061185] Dynamic subtest pipe-D-eDP-1: SKIP (0.031s)
[259.065606] Subtest scaling-mode-none: SKIP (0.199s)
[259.224496] [027/130] (760s left) kms_cursor_edge_walk (256x256-top-edge)
[259.316223] Starting subtest: 256x256-top-edge
[259.318448] Starting dynamic subtest: pipe-A-eDP-1
[262.726154] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.410s)
[262.734885] Starting dynamic subtest: pipe-D-eDP-1
[265.863209] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s)
[265.865525] Subtest 256x256-top-edge: SUCCESS (6.550s)
[266.691104] [028/130] (752s left) dumb_buffer (create-valid-dumb)
[266.756756] Starting subtest: create-valid-dumb
[266.758623] Subtest create-valid-dumb: SUCCESS (0.000s)
[266.890139] [029/130] (752s left) kms_invalid_mode (zero-vdisplay)
[266.986040] Starting subtest: zero-vdisplay
[266.988385] Starting dynamic subtest: pipe-A-eDP-1
[267.269412] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[267.278192] Starting dynamic subtest: pipe-B-eDP-1
[267.280601] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[267.287991] Starting dynamic subtest: pipe-C-eDP-1
[267.290220] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[267.297480] Starting dynamic subtest: pipe-D-eDP-1
[267.299394] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[267.301306] Subtest zero-vdisplay: SUCCESS (0.287s)
[268.130309] [030/130] (751s left) gem_exec_fence (syncobj-timeline-repeat)
[268.716432] Starting subtest: syncobj-timeline-repeat
[268.947242] Subtest syncobj-timeline-repeat: SUCCESS (0.231s)
[270.044134] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[270.047620] [031/130] (749s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[270.150204] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[270.152634] Starting dynamic subtest: pipe-A-default-mode
[270.450787] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[270.455464] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.300s)
[271.263291] [032/130] (748s left) gem_exec_whisper (basic-contexts-forked-all)
[271.340232] Starting subtest: basic-contexts-forked-all
[293.968773] Subtest basic-contexts-forked-all: SUCCESS (22.574s)
[294.129046] [033/130] (725s left) gem_exec_capture (capture)
[294.193941] Starting subtest: capture
[294.196398] Starting dynamic subtest: rcs0-smem
[295.036523] Dynamic subtest rcs0-smem: SUCCESS (0.839s)
[295.044412] Starting dynamic subtest: bcs0-smem
[295.862683] Dynamic subtest bcs0-smem: SUCCESS (0.826s)
[295.873048] Starting dynamic subtest: vcs0-smem
[296.690407] Dynamic subtest vcs0-smem: SUCCESS (0.826s)
[296.700794] Starting dynamic subtest: vcs1-smem
[297.522037] Dynamic subtest vcs1-smem: SUCCESS (0.832s)
[297.530642] Starting dynamic subtest: vecs0-smem
[298.918959] Dynamic subtest vecs0-smem: FAIL (1.338s)
[298.928824] Starting dynamic subtest: ccs0-smem
[300.186942] Dynamic subtest ccs0-smem: SUCCESS (1.327s)
[300.189816] Subtest capture: FAIL (5.990s)
[300.363808] [034/130] (719s left) gem_vm_create (create-ext)
[300.429613] Starting subtest: create-ext
[300.438037] Subtest create-ext: SUCCESS (0.008s)
[300.601815] [035/130] (719s left) gem_mmap_gtt (big-bo-tiledx)
[300.652948] Subtest big-bo-tiledX: SKIP (0.000s)
[300.725772] [036/130] (719s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[300.833116] Starting subtest: extended-pageflip-modeset-hang-oldfb
[300.835099] Starting dynamic subtest: pipe-A
[308.736472] Dynamic subtest pipe-A: SUCCESS (7.903s)
[308.745292] Starting dynamic subtest: pipe-D
[317.364176] Dynamic subtest pipe-D: SUCCESS (8.623s)
[317.366443] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.531s)
[318.232080] [037/130] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[318.345219] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[318.349102] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[318.495666] [038/130] (701s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[318.596671] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[325.376044] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.782s)
[325.520136] [039/130] (694s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[325.614149] Starting subtest: fbc-psr2-sprite-mmap-gtt
[325.616440] Starting dynamic subtest: eDP-1
[325.620693] Dynamic subtest eDP-1: SKIP (0.000s)
[325.624941] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[325.709310] [040/130] (694s left) kms_getfb (getfb-handle-closed)
[325.807151] Starting subtest: getfb-handle-closed
[325.809471] Subtest getfb-handle-closed: SUCCESS (0.000s)
[325.950083] [041/130] (694s left) sw_sync (sync_merge_same)
[325.988110] Starting subtest: sync_merge_same
[325.990127] Subtest sync_merge_same: SUCCESS (0.000s)
[326.081628] [042/130] (694s left) gen9_exec_parse (bb-oversize)
[326.136350] Subtest bb-oversize: SKIP (0.000s)
[326.209145] [043/130] (694s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[326.314975] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[326.317120] Starting dynamic subtest: pipe-A-eDP-1
[326.334717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[326.352084] Starting dynamic subtest: pipe-B-eDP-1
[326.369407] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[326.382367] Starting dynamic subtest: pipe-C-eDP-1
[326.399310] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[326.409175] Starting dynamic subtest: pipe-D-eDP-1
[326.426203] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[326.428265] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[328.529971] [044/130] (691s left) prime_vgem (shrink)
[328.626371] Starting subtest: shrink
[328.663362] Subtest shrink: SUCCESS (0.035s)
[328.807685] [045/130] (691s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[328.873843] Subtest writes-after-reads-uncached: SKIP (0.000s)
[328.993149] [046/130] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[329.097688] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[329.101946] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[329.225284] [047/130] (691s left) vgem_basic (sysfs)
[329.264591] Starting subtest: sysfs
[329.266666] Subtest sysfs: SUCCESS (0.000s)
[329.343550] [048/130] (691s left) perf_pmu (semaphore-busy)
[329.381039] Starting subtest: semaphore-busy
[329.383278] Starting dynamic subtest: rcs0
[331.024581] Dynamic subtest rcs0: SUCCESS (1.639s)
[331.035816] Starting dynamic subtest: bcs0
[332.655047] Dynamic subtest bcs0: SUCCESS (1.628s)
[332.666506] Starting dynamic subtest: vcs0
[336.454778] Dynamic subtest vcs0: SUCCESS (3.745s)
[336.465582] Starting dynamic subtest: vcs1
[342.417472] Dynamic subtest vcs1: SUCCESS (6.012s)
[342.428756] Starting dynamic subtest: vecs0
[348.369500] Dynamic subtest vecs0: SUCCESS (5.950s)
[348.380976] Starting dynamic subtest: ccs0
[351.509203] Dynamic subtest ccs0: SUCCESS (3.137s)
[351.511577] Subtest semaphore-busy: SUCCESS (22.125s)
[351.662392] [049/130] (668s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[356.711680] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[356.714291] Starting dynamic subtest: pipe-A-eDP-1
[368.116076] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.401s)
[368.126315] Starting dynamic subtest: pipe-B-eDP-1
[379.558432] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.438s)
[379.560434] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.844s)
[380.435051] [050/130] (640s left) kms_getfb (getfb2-handle-closed)
[380.540100] Starting subtest: getfb2-handle-closed
[380.542465] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[380.664331] [051/130] (639s left) api_intel_bb (reset-bb)
[380.716114] Starting subtest: reset-bb
[380.718404] Subtest reset-bb: SUCCESS (0.003s)
[380.900507] [052/130] (639s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[381.016016] Starting subtest: y-tiled-32bpp-rotate-270
[381.020472] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[381.153833] [053/130] (639s left) kms_psr (pr-basic)
[381.253310] Starting subtest: pr-basic
[381.257705] Subtest pr-basic: SKIP (0.000s)
[381.348317] [054/130] (639s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[381.418747] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[381.522314] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[381.623078] [055/130] (639s left) kms_vblank (ts-continuation-modeset)
[381.717046] Starting subtest: ts-continuation-modeset
[381.718953] Starting dynamic subtest: pipe-A-eDP-1
[383.167048] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.449s)
[383.181902] Starting dynamic subtest: pipe-D-eDP-1
[385.327212] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.158s)
[385.329102] Subtest ts-continuation-modeset: SUCCESS (3.611s)
[386.153875] [056/130] (634s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[386.261276] Starting subtest: stress-xrgb8888-ytiled
[386.265791] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[386.354374] [057/130] (634s left) kms_prop_blob (invalid-get-prop-any)
[386.415151] Starting subtest: invalid-get-prop-any
[386.417060] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[386.555948] [058/130] (634s left) kms_plane_alpha_blend (constant-alpha-mid)
[386.643734] Starting subtest: constant-alpha-mid
[386.928848] Starting dynamic subtest: pipe-A-eDP-1
[387.760242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[387.771269] Starting dynamic subtest: pipe-D-eDP-1
[389.210051] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.449s)
[389.212402] Subtest constant-alpha-mid: SUCCESS (2.568s)
[390.106980] [059/130] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[390.217177] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[397.041438] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.826s)
[397.207572] [060/130] (623s left) gem_partial_pwrite_pread (write-snoop)
[397.278761] Subtest write-snoop: SKIP (0.000s)
[397.370119] [061/130] (623s left) gem_mmap_gtt (hang-busy)
[397.432582] Subtest hang-busy: SKIP (0.000s)
[397.499877] [062/130] (623s left) gem_busy (extended)
[397.687960] Starting subtest: extended
[397.690664] Starting dynamic subtest: rcs0
[397.794291] Dynamic subtest rcs0: SUCCESS (0.109s)
[397.804328] Starting dynamic subtest: bcs0
[397.838175] Dynamic subtest bcs0: SUCCESS (0.042s)
[397.848238] Starting dynamic subtest: vcs0
[398.936195] Dynamic subtest vcs0: SUCCESS (1.094s)
[398.948540] Starting dynamic subtest: vcs1
[400.918968] Dynamic subtest vcs1: SUCCESS (1.980s)
[400.930628] Starting dynamic subtest: vecs0
[402.965700] Dynamic subtest vecs0: SUCCESS (1.981s)
[402.976823] Starting dynamic subtest: ccs0
[402.978926] Dynamic subtest ccs0: SUCCESS (0.045s)
[402.981024] Subtest extended: SUCCESS (5.265s)
[403.232167] [063/130] (617s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[403.289897] Starting subtest: yf-tiled-to-vebox-y-tiled
[403.294157] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[403.501499] [064/130] (617s left) prime_vgem (basic-fence-flip)
[403.584712] Starting subtest: basic-fence-flip
[403.908353] Subtest basic-fence-flip: SUCCESS (0.324s)
[404.072192] [065/130] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[404.159239] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[404.163144] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[404.276985] [066/130] (616s left) kms_flip (modeset-vs-vblank-race)
[404.381209] Starting subtest: modeset-vs-vblank-race
[404.383589] Starting dynamic subtest: A-eDP1
[409.048162] Dynamic subtest A-eDP1: SUCCESS (4.669s)
[409.059565] Starting dynamic subtest: B-eDP1
[413.780325] Dynamic subtest B-eDP1: SUCCESS (4.730s)
[413.792079] Starting dynamic subtest: C-eDP1
[418.482239] Dynamic subtest C-eDP1: SUCCESS (4.700s)
[418.492333] Starting dynamic subtest: D-eDP1
[423.123265] Dynamic subtest D-eDP1: SUCCESS (4.640s)
[423.129399] Subtest modeset-vs-vblank-race: SUCCESS (18.751s)
[424.417399] [067/130] (596s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[424.516135] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[424.518394] Starting dynamic subtest: pipe-A-default-mode
[427.209767] Dynamic subtest pipe-A-default-mode: SUCCESS (2.694s)
[427.212141] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.695s)
[428.102088] [068/130] (593s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[428.198040] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[428.200196] Starting dynamic subtest: pipe-A-eDP-1
[429.491867] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.296s)
[429.501568] Starting dynamic subtest: pipe-B-eDP-1
[431.835639] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.343s)
[431.844804] Starting dynamic subtest: pipe-C-eDP-1
[434.144861] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.308s)
[434.153604] Starting dynamic subtest: pipe-D-eDP-1
[436.469819] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.323s)
[436.472077] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.275s)
[437.712167] [069/130] (583s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[437.826071] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[437.828332] Starting dynamic subtest: pipe-A-eDP-1
[454.766228] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.577s)
[454.776144] Starting dynamic subtest: pipe-B-eDP-1
[472.768273] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.869s)
[472.777840] Starting dynamic subtest: pipe-C-eDP-1
[490.700133] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.839s)
[490.709667] Starting dynamic subtest: pipe-D-eDP-1
[508.717047] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s)
[508.719215] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (14.054s)
[515.031122] [070/130] (511s left) gem_exec_balancer (invalid-balancer)
[515.142349] Starting subtest: invalid-balancer
[516.025813] Subtest invalid-balancer: SUCCESS (0.881s)
[516.363841] [071/130] (510s left) kms_atomic_interruptible (legacy-setmode)
[516.471903] Starting subtest: legacy-setmode
[516.474240] Starting dynamic subtest: pipe-A-eDP-1
[523.353254] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.843s)
[523.355569] Subtest legacy-setmode: SUCCESS (6.844s)
[524.173006] [072/130] (502s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[524.287434] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[524.301707] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[524.401136] [073/130] (502s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[524.516250] Starting subtest: yf-tiled-32bpp-rotate-90
[524.520657] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[524.652409] [074/130] (501s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[524.744578] Starting subtest: random-ccs-data-yf-tiled-ccs
[524.746840] Starting dynamic subtest: pipe-A-eDP-1
[524.770966] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[524.781391] Starting dynamic subtest: pipe-B-eDP-1
[524.804193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[524.813492] Starting dynamic subtest: pipe-C-eDP-1
[524.836993] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[524.846223] Starting dynamic subtest: pipe-D-eDP-1
[524.870689] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[524.874835] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[527.058881] [075/130] (499s left) i915_drm_fdinfo (memory-info-purgeable)
[527.102450] Starting subtest: memory-info-purgeable
[527.104856] Starting dynamic subtest: smem0
[529.753637] Dynamic subtest smem0: SUCCESS (2.648s)
[529.755980] Subtest memory-info-purgeable: SUCCESS (2.649s)
[529.865658] [076/130] (496s left) kms_pm_lpsp (screens-disabled)
[530.977038] Starting subtest: screens-disabled
[530.981505] Subtest screens-disabled: SKIP (0.000s)
[531.076249] [077/130] (495s left) syncobj_timeline (single-wait-all-signaled)
[531.135284] Starting subtest: single-wait-all-signaled
[531.137208] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[531.275107] [078/130] (495s left) gem_exec_fence (syncobj-signal)
[531.701700] Starting subtest: syncobj-signal
[531.707810] Subtest syncobj-signal: SUCCESS (0.005s)
[532.828993] [079/130] (494s left) kms_display_modes (extended-mode-basic)
[532.937396] Starting subtest: extended-mode-basic
[532.941550] Subtest extended-mode-basic: SKIP (0.000s)
[532.984330] [080/130] (493s left) i915_pm_rpm (gem-pread)
[534.913328] Starting subtest: gem-pread
[536.979894] Subtest gem-pread: SUCCESS (2.067s)
[537.094140] [081/130] (489s left) kms_big_fb (linear-64bpp-rotate-270)
[537.198811] Starting subtest: linear-64bpp-rotate-270
[537.220828] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[537.368124] [082/130] (489s left) gem_tiled_fence_blits (normal)
[537.439252] Subtest normal: SKIP (0.000s)
[537.508988] [083/130] (489s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[537.599820] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[537.602140] Starting dynamic subtest: pipe-A-default-mode
[537.891177] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[537.895864] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.291s)
[538.797294] [084/130] (488s left) kms_draw_crc (draw-method-pwrite)
[538.895804] Starting subtest: draw-method-pwrite
[538.897673] Starting dynamic subtest: xrgb8888-untiled
[539.461517] Dynamic subtest xrgb8888-untiled: SUCCESS (0.566s)
[539.470987] Starting dynamic subtest: rgb565-untiled
[539.906309] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[539.917912] Starting dynamic subtest: xrgb2101010-untiled
[540.462841] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[540.475400] Starting dynamic subtest: xbgr16161616f-untiled
[541.262889] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.797s)
[541.274978] Starting dynamic subtest: xrgb8888-xtiled
[543.008518] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.742s)
[543.018274] Starting dynamic subtest: rgb565-xtiled
[544.098254] Dynamic subtest rgb565-xtiled: SUCCESS (1.088s)
[544.108472] Starting dynamic subtest: xrgb2101010-xtiled
[545.910742] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.810s)
[545.927045] Starting dynamic subtest: xbgr16161616f-xtiled
[549.133600] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.220s)
[549.143380] Starting dynamic subtest: xrgb8888-4tiled
[550.233656] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.097s)
[550.243797] Starting dynamic subtest: rgb565-4tiled
[550.789206] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s)
[550.800034] Starting dynamic subtest: xrgb2101010-4tiled
[551.878335] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.088s)
[551.888167] Starting dynamic subtest: xbgr16161616f-4tiled
[554.812559] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.932s)
[554.814899] Subtest draw-method-pwrite: SUCCESS (15.911s)
[554.964420] [085/130] (472s left) gem_mmap (bad-offset)
[555.025008] Subtest bad-offset: SKIP (0.000s)
[555.095652] [086/130] (472s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[555.195792] Starting subtest: primary-yf-tiled-reflect-x-0
[555.255103] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[555.383564] [087/130] (471s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[555.772575] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[556.586223] [088/130] (470s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[556.685023] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[556.689464] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[556.794723] [089/130] (470s left) kms_pipe_crc_basic (bad-source)
[556.878143] Starting subtest: bad-source
[556.880307] Subtest bad-source: SUCCESS (0.000s)
[556.975058] [090/130] (470s left) gem_basic (create-close)
[557.031592] Starting subtest: create-close
[557.036128] Subtest create-close: SUCCESS (0.000s)
[557.167641] [091/130] (470s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[557.230276] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[557.336825] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[557.440845] [092/130] (469s left) kms_sequence (get-busy)
[557.538509] Starting subtest: get-busy
[557.540533] Starting dynamic subtest: pipe-A-eDP-1
[559.473684] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[559.485599] Starting dynamic subtest: pipe-B-eDP-1
[562.109648] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.632s)
[562.121460] Starting dynamic subtest: pipe-C-eDP-1
[564.730501] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s)
[564.741175] Starting dynamic subtest: pipe-D-eDP-1
[567.277727] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s)
[567.279984] Subtest get-busy: SUCCESS (9.736s)
[568.105116] [093/130] (459s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[568.192924] Starting subtest: addfb25-y-tiled-legacy
[568.195087] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[568.328903] [094/130] (459s left) i915_query (test-query-geometry-subslices)
[568.395318] Starting subtest: test-query-geometry-subslices
[568.397329] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[568.508466] [095/130] (459s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[568.612780] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[569.237081] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[569.468609] [096/130] (458s left) gem_exec_whisper (basic-queues-priority-all)
[569.547270] Starting subtest: basic-queues-priority-all
[589.068193] Subtest basic-queues-priority-all: SUCCESS (19.511s)
[589.299333] [097/130] (438s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[589.427950] Starting subtest: cursorB-vs-flipA-atomic
[589.432565] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[589.599902] [098/130] (438s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[589.782158] Starting subtest: cursor-rapid-movement-64x21
[589.829509] Subtest cursor-rapid-movement-64x21: SKIP (0.044s)
[590.084589] [099/130] (437s left) gem_mmap_wc (write-cpu-read-wc)
[590.152466] Subtest write-cpu-read-wc: SKIP (0.000s)
[590.221865] [100/130] (437s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[590.331088] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[598.906046] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.572s)
[599.044040] [101/130] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[599.145098] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[599.149055] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[599.258899] [102/130] (428s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[599.356345] Starting subtest: 4-tiled-8bpp-rotate-90
[599.377559] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[599.554529] [103/130] (428s left) kms_pm_rpm (system-suspend-modeset)
[601.089245] Starting subtest: system-suspend-modeset
[620.761870] Subtest system-suspend-modeset: SUCCESS (4.731s)
[629.181212] [104/130] (406s left) prime_self_import (basic-with_fd_dup)
[629.238224] Starting subtest: basic-with_fd_dup
[629.262020] Subtest basic-with_fd_dup: SUCCESS (0.026s)
[629.403746] [105/130] (406s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[629.805602] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[630.655837] [106/130] (405s left) gem_create (create-clear)
[630.717531] Starting subtest: create-clear
[630.720258] Starting dynamic subtest: smem0
[663.601015] Dynamic subtest smem0: SUCCESS (32.809s)
[663.603448] Subtest create-clear: SUCCESS (32.810s)
[663.820939] [107/130] (372s left) syncobj_wait (invalid-signal-illegal-handle)
[663.884953] Starting subtest: invalid-signal-illegal-handle
[663.887307] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[664.000601] [108/130] (372s left) gem_userptr_blits (create-destroy-sync)
[664.077905] Starting subtest: create-destroy-sync
[669.150435] Subtest create-destroy-sync: SUCCESS (5.020s)
[669.267007] [109/130] (366s left) gem_linear_blits (interruptible)
[669.559197] Starting subtest: interruptible
[674.848140] Subtest interruptible: SUCCESS (5.289s)
[675.039850] [110/130] (361s left) vgem_basic (setversion)
[675.131503] Starting subtest: setversion
[675.135561] Subtest setversion: SUCCESS (0.000s)
[675.217954] [111/130] (361s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[675.322416] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[675.326758] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[675.460432] [112/130] (360s left) gem_exec_parallel (contexts)
[675.532012] Starting subtest: contexts
[675.534315] Starting dynamic subtest: rcs0
[678.538391] Dynamic subtest rcs0: SUCCESS (3.007s)
[678.551073] Starting dynamic subtest: bcs0
[682.581057] Dynamic subtest bcs0: SUCCESS (4.041s)
[682.593874] Starting dynamic subtest: vcs0
[687.074959] Dynamic subtest vcs0: SUCCESS (4.493s)
[687.085374] Starting dynamic subtest: vcs1
[691.246445] Dynamic subtest vcs1: SUCCESS (4.167s)
[691.256427] Starting dynamic subtest: vecs0
[695.234097] Dynamic subtest vecs0: SUCCESS (3.984s)
[695.243721] Starting dynamic subtest: ccs0
[698.864099] Dynamic subtest ccs0: SUCCESS (3.627s)
[698.866737] Subtest contexts: SUCCESS (23.329s)
[699.079029] [113/130] (337s left) gem_flink_basic (basic)
[699.132560] Starting subtest: basic
[699.134857] Subtest basic: SUCCESS (0.000s)
[699.283066] [114/130] (337s left) gem_exec_schedule (preemptive-hang)
[699.473682] Starting subtest: preemptive-hang
[699.475857] Starting dynamic subtest: rcs0
[708.840029] Dynamic subtest rcs0: SUCCESS (9.360s)
[708.853362] Starting dynamic subtest: bcs0
[717.800599] Dynamic subtest bcs0: SUCCESS (8.962s)
[717.817961] Starting dynamic subtest: vcs0
[726.819194] Dynamic subtest vcs0: SUCCESS (9.015s)
[726.843191] Starting dynamic subtest: vcs1
[735.782050] Dynamic subtest vcs1: SUCCESS (8.961s)
[735.795397] Starting dynamic subtest: vecs0
[744.806886] Dynamic subtest vecs0: SUCCESS (9.023s)
[744.816746] Starting dynamic subtest: ccs0
[753.894895] Dynamic subtest ccs0: SUCCESS (9.089s)
[753.897212] Subtest preemptive-hang: SUCCESS (54.419s)
[754.185347] [115/130] (282s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[754.286124] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[754.290383] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[754.416367] [116/130] (282s left) kms_lease (lease-invalid-crtc)
[754.504894] Starting subtest: lease-invalid-crtc
[754.507023] Starting dynamic subtest: pipe-A-eDP-1
[754.509246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[754.519125] Starting dynamic subtest: pipe-B-eDP-1
[754.521309] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[754.530780] Starting dynamic subtest: pipe-C-eDP-1
[754.533051] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[754.542630] Starting dynamic subtest: pipe-D-eDP-1
[754.544826] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[754.546997] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[754.604165] [117/130] (281s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[754.674230] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[754.676540] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[754.800654] [118/130] (281s left) gem_ctx_persistence (engines-queued)
[754.854172] Starting subtest: engines-queued
[754.856404] Starting dynamic subtest: rcs0
[754.957601] Dynamic subtest rcs0: SUCCESS (0.103s)
[754.970055] Starting dynamic subtest: bcs0
[755.032549] Dynamic subtest bcs0: SUCCESS (0.073s)
[755.043688] Starting dynamic subtest: vcs0
[756.635725] Dynamic subtest vcs0: SUCCESS (1.599s)
[756.647152] Starting dynamic subtest: vcs1
[758.682916] Dynamic subtest vcs1: SUCCESS (2.044s)
[758.695911] Starting dynamic subtest: vecs0
[760.718855] Dynamic subtest vecs0: SUCCESS (1.979s)
[760.731375] Starting dynamic subtest: ccs0
[760.845796] Dynamic subtest ccs0: SUCCESS (0.179s)
[760.848290] Subtest engines-queued: SUCCESS (5.992s)
[761.018396] [119/130] (275s left) gem_ctx_exec (basic-nohangcheck)
[761.080192] Starting subtest: basic-nohangcheck
[761.431195] Subtest basic-nohangcheck: SUCCESS (0.352s)
[761.563191] [120/130] (275s left) kms_psr (psr-cursor-mmap-cpu)
[761.663830] Starting subtest: psr-cursor-mmap-cpu
[761.666108] Starting dynamic subtest: eDP-1
[763.417004] Dynamic subtest eDP-1: SUCCESS (1.753s)
[763.419588] Subtest psr-cursor-mmap-cpu: SUCCESS (1.754s)
[764.314637] [121/130] (272s left) gem_exec_schedule (u-fairslice)
[764.384761] Starting subtest: u-fairslice
[764.386663] Starting dynamic subtest: rcs0
[766.403197] Dynamic subtest rcs0: SUCCESS (2.022s)
[766.413903] Starting dynamic subtest: bcs0
[768.418967] Dynamic subtest bcs0: SUCCESS (2.016s)
[768.428968] Starting dynamic subtest: vcs0
[770.488088] Dynamic subtest vcs0: SUCCESS (2.020s)
[770.499519] Starting dynamic subtest: vcs1
[772.460891] Dynamic subtest vcs1: SUCCESS (2.017s)
[772.471358] Starting dynamic subtest: vecs0
[774.526573] Dynamic subtest vecs0: SUCCESS (2.015s)
[774.538584] Starting dynamic subtest: ccs0
[776.494640] Dynamic subtest ccs0: SUCCESS (2.018s)
[776.496938] Subtest u-fairslice: SUCCESS (12.113s)
[776.816433] [122/130] (259s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[776.918630] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[776.920834] Starting dynamic subtest: pipe-A
[776.982237] Dynamic subtest pipe-A: SUCCESS (0.065s)
[776.994025] Starting dynamic subtest: pipe-B
[778.107559] Dynamic subtest pipe-B: SUCCESS (1.124s)
[778.120135] Starting dynamic subtest: pipe-C
[779.216057] Dynamic subtest pipe-C: SUCCESS (1.106s)
[779.233081] Starting dynamic subtest: pipe-D
[780.365278] Dynamic subtest pipe-D: SUCCESS (1.147s)
[780.367584] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.448s)
[781.532530] [123/130] (255s left) gem_exec_params (invalid-fence-in)
[781.608760] Starting subtest: invalid-fence-in
[781.611209] Subtest invalid-fence-in: SUCCESS (0.000s)
[781.744640] [124/130] (255s left) kms_color (ctm-max)
[781.840636] Starting subtest: ctm-max
[781.842429] Starting dynamic subtest: pipe-A-eDP-1
[782.583625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[782.595578] Starting dynamic subtest: pipe-B-eDP-1
[784.023663] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.440s)
[784.034751] Starting dynamic subtest: pipe-C-eDP-1
[785.417234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[785.428135] Starting dynamic subtest: pipe-D-eDP-1
[786.740609] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s)
[786.742936] Subtest ctm-max: SUCCESS (4.900s)
[787.560935] [125/130] (249s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[787.663414] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[787.667624] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[787.797674] [126/130] (249s left) kms_atomic_transition (modeset-transition-nonblocking)
[787.895832] Starting subtest: modeset-transition-nonblocking
[787.897746] Starting dynamic subtest: 1x-outputs
[798.947130] Dynamic subtest 1x-outputs: SUCCESS (11.050s)
[798.949613] Subtest modeset-transition-nonblocking: SUCCESS (11.052s)
[799.829774] [127/130] (237s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[799.935169] Starting subtest: fbc-rgb565-draw-mmap-wc
[803.940896] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.008s)
[805.119689] [128/130] (231s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[805.239277] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[805.243721] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[805.408025] [129/130] (231s left) gem_pxp (verify-pxp-stale-buf-execution)
[805.526067] Starting subtest: verify-pxp-stale-buf-execution
[806.595472] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.072s)
[806.768746] [130/130] (230s left) perf (non-sampling-read-error)
[806.899637] Starting subtest: non-sampling-read-error
[806.909089] Subtest non-sampling-read-error: SUCCESS (0.007s)
[806.946400] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: gem_mmap_wc
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_ctx_shared
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: i915_hangman
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: syncobj_basic
results: parsing output: 15/ for test: gem_exec_create
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: prime_mmap
results: parsing output: 18/ for test: gem_workarounds
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_scaling_modes
results: parsing output: 26/ for test: kms_cursor_edge_walk
results: parsing output: 27/ for test: dumb_buffer
results: parsing output: 28/ for test: kms_invalid_mode
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: gem_exec_whisper
results: parsing output: 32/ for test: gem_exec_capture
results: parsing output: 33/ for test: gem_vm_create
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: kms_busy
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_getfb
results: parsing output: 40/ for test: sw_sync
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: prime_vgem
results: parsing output: 44/ for test: gem_partial_pwrite_pread
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: vgem_basic
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_pipe_stress
results: parsing output: 56/ for test: kms_prop_blob
results: parsing output: 57/ for test: kms_plane_alpha_blend
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: gem_busy
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: prime_vgem
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_atomic_interruptible
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_pm_lpsp
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: kms_display_modes
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_tiled_fence_blits
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: kms_draw_crc
results: parsing output: 84/ for test: gem_mmap
results: parsing output: 85/ for test: kms_rotation_crc
results: parsing output: 86/ for test: kms_chamelium_hpd
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_pipe_crc_basic
results: parsing output: 89/ for test: gem_basic
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_sequence
results: parsing output: 92/ for test: kms_addfb_basic
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_exec_whisper
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: prime_self_import
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: gem_create
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: gem_linear_blits
results: parsing output: 109/ for test: vgem_basic
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_parallel
results: parsing output: 112/ for test: gem_flink_basic
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_lease
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: gem_ctx_exec
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_color
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_atomic_transition
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: perf
Done.