[57.953682] Initializing watchdogs
[57.953726]   /dev/watchdog0
[57.967462] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.971773] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.973898] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.977081] [001/133] (960s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[58.103293] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[58.115452] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[58.186067] [002/133] (960s left) core_hotunplug (unbind-rebind)
[58.274888] Starting subtest: unbind-rebind
[64.134201] Subtest unbind-rebind: SUCCESS (5.898s)
[64.169984] [003/133] (954s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[65.890614] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[65.894870] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[65.974060] [004/133] (952s left) gen7_exec_parse (load-register-reg)
[66.025410] Subtest load-register-reg: SKIP (0.000s)
[66.092122] [005/133] (952s left) gem_exec_async (concurrent-writes)
[66.152308] Starting subtest: concurrent-writes
[66.154746] Starting dynamic subtest: rcs0
[66.169985] Dynamic subtest rcs0: SUCCESS (0.017s)
[66.177228] Starting dynamic subtest: bcs0
[66.183348] Dynamic subtest bcs0: SUCCESS (0.013s)
[66.190825] Starting dynamic subtest: vcs0
[66.193155] Dynamic subtest vcs0: SUCCESS (0.006s)
[66.200975] Starting dynamic subtest: vcs1
[66.203193] Dynamic subtest vcs1: SUCCESS (0.006s)
[66.210506] Starting dynamic subtest: vecs0
[66.212839] Dynamic subtest vecs0: SUCCESS (0.009s)
[66.219441] Starting dynamic subtest: ccs0
[66.221304] Dynamic subtest ccs0: SUCCESS (0.005s)
[66.223140] Subtest concurrent-writes: SUCCESS (0.058s)
[66.430317] [006/133] (952s left) gem_ctx_param (invalid-size-get)
[66.484734] Starting subtest: invalid-size-get
[66.487132] Subtest invalid-size-get: SUCCESS (0.001s)
[66.578796] [007/133] (952s left) kms_atomic (plane-cursor-legacy)
[66.676814] Starting subtest: plane-cursor-legacy
[66.679335] Starting dynamic subtest: pipe-A-eDP-1
[67.107113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.430s)
[67.109738] Subtest plane-cursor-legacy: SUCCESS (0.433s)
[67.932474] [008/133] (950s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[68.053081] Starting subtest: short-busy-flip-before-cursor-toggle
[68.057423] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[68.204239] [009/133] (950s left) kms_joiner (basic-ultra-joiner)
[68.303746] Starting subtest: basic-ultra-joiner
[68.308439] Subtest basic-ultra-joiner: SKIP (0.000s)
[68.362599] [010/133] (950s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[68.483871] Starting subtest: short-flip-before-cursor-toggle
[69.403180] Subtest short-flip-before-cursor-toggle: SUCCESS (0.921s)
[70.263177] [011/133] (948s left) i915_query (query-topology-garbage-items)
[70.309541] Starting subtest: query-topology-garbage-items
[70.311442] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[70.421703] [012/133] (948s left) kms_async_flips (alternate-sync-async-flip-atomic)
[70.517084] Starting subtest: alternate-sync-async-flip-atomic
[70.901424] Starting dynamic subtest: pipe-A-eDP-1
[73.649099] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.753s)
[74.030587] Starting dynamic subtest: pipe-B-eDP-1
[76.772502] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[77.167791] Starting dynamic subtest: pipe-C-eDP-1
[79.910224] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.750s)
[80.288368] Starting dynamic subtest: pipe-D-eDP-1
[83.050136] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[83.052535] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.544s)
[84.245379] [013/133] (934s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[84.347206] Starting subtest: y-tiled-64bpp-rotate-270
[84.351274] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[84.456851] [014/133] (934s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[84.586838] Starting subtest: flip-vs-cursor-varying-size
[93.205756] Subtest flip-vs-cursor-varying-size: SUCCESS (8.615s)
[94.042074] [015/133] (924s left) kms_content_protection (content-type-change)
[94.188470] Starting subtest: content-type-change
[94.193032] Subtest content-type-change: SKIP (0.000s)
[94.300628] [016/133] (924s left) api_intel_bb (object-reloc-purge-cache)
[94.366914] Starting subtest: object-reloc-purge-cache
[94.371504] Subtest object-reloc-purge-cache: SKIP (0.003s)
[94.478572] [017/133] (924s left) kms_psr (psr-no-drrs)
[94.573171] Starting subtest: psr-no-drrs
[94.575496] Starting dynamic subtest: eDP-1
[96.231203] Dynamic subtest eDP-1: SUCCESS (1.657s)
[96.233608] Subtest psr-no-drrs: SUCCESS (1.658s)
[97.101600] [018/133] (922s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[97.198272] Starting subtest: yf-tiled-8bpp-rotate-180
[97.202907] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[97.293703] [019/133] (921s left) kms_flip (2x-flip-vs-dpms-on-nop)
[97.386376] Starting subtest: 2x-flip-vs-dpms-on-nop
[97.394350] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[97.491214] [020/133] (921s left) kms_setmode (invalid-clone-single-crtc)
[97.545589] Starting subtest: invalid-clone-single-crtc
[97.551987] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[97.655650] [021/133] (921s left) gem_exec_balancer (parallel-contexts)
[97.906432] Starting subtest: parallel-contexts
[100.591336] Subtest parallel-contexts: SUCCESS (2.688s)
[100.687998] [022/133] (918s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[100.787683] Starting subtest: psr-farfromfence-mmap-gtt
[100.792268] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[100.890152] [023/133] (918s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[100.995910] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[108.100793] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.106s)
[108.238963] [024/133] (911s left) kms_cursor_crc (cursor-offscreen-512x170)
[108.510515] Starting subtest: cursor-offscreen-512x170
[108.515130] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[108.647212] [025/133] (910s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[108.749752] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[115.309297] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.563s)
[115.419835] [026/133] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[115.525952] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[119.788750] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.268s)
[120.955678] [027/133] (898s left) gem_ctx_persistence (engines-persistence)
[121.016459] Starting subtest: engines-persistence
[121.018920] Starting dynamic subtest: rcs0
[121.807808] Dynamic subtest rcs0: SUCCESS (0.790s)
[121.819517] Starting dynamic subtest: bcs0
[122.581843] Dynamic subtest bcs0: SUCCESS (0.772s)
[122.592605] Starting dynamic subtest: vcs0
[123.353813] Dynamic subtest vcs0: SUCCESS (0.770s)
[123.365497] Starting dynamic subtest: vcs1
[124.119706] Dynamic subtest vcs1: SUCCESS (0.764s)
[124.130658] Starting dynamic subtest: vecs0
[124.874947] Dynamic subtest vecs0: SUCCESS (0.754s)
[124.885867] Starting dynamic subtest: ccs0
[125.635947] Dynamic subtest ccs0: SUCCESS (0.759s)
[125.639245] Subtest engines-persistence: SUCCESS (4.620s)
[125.748932] [028/133] (893s left) kms_psr (fbc-psr2-sprite-plane-move)
[125.847897] Starting subtest: fbc-psr2-sprite-plane-move
[125.850159] Starting dynamic subtest: eDP-1
[125.854195] Dynamic subtest eDP-1: SKIP (0.000s)
[125.858263] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[125.922095] [029/133] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[126.014801] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[126.018996] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[126.110351] [030/133] (893s left) gem_ppgtt (shrink-vs-evict-pinned)
[126.157925] Starting subtest: shrink-vs-evict-pinned
[131.883760] Subtest shrink-vs-evict-pinned: SUCCESS (5.724s)
[131.960156] [031/133] (887s left) kms_sequence (get-busy)
[132.054286] Starting subtest: get-busy
[132.056380] Starting dynamic subtest: pipe-A-eDP-1
[133.976861] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s)
[133.991667] Starting dynamic subtest: pipe-B-eDP-1
[136.549104] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.572s)
[136.558230] Starting dynamic subtest: pipe-C-eDP-1
[139.158748] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s)
[139.167247] Starting dynamic subtest: pipe-D-eDP-1
[141.694299] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[141.696584] Subtest get-busy: SUCCESS (9.641s)
[142.498054] [032/133] (877s left) fbdev (read)
[142.546217] Starting subtest: read
[143.072029] Subtest read: SUCCESS (0.523s)
[143.130726] [033/133] (876s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[143.230404] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[143.234840] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[143.329326] [034/133] (876s left) prime_mmap (test_errors)
[143.385965] Starting subtest: test_errors
[143.387895] Starting dynamic subtest: test_errors-smem
[143.478931] Dynamic subtest test_errors-smem: SUCCESS (0.094s)
[143.481670] Subtest test_errors: SUCCESS (0.095s)
[143.566370] [035/133] (876s left) kms_cdclk (mode-transition)
[143.653667] Starting subtest: mode-transition
[143.655878] Starting dynamic subtest: pipe-A-eDP-1
[143.943926] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[143.951830] Starting dynamic subtest: pipe-B-eDP-1
[143.956134] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[143.963594] Starting dynamic subtest: pipe-C-eDP-1
[143.967962] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[143.975552] Starting dynamic subtest: pipe-D-eDP-1
[143.979905] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[143.983791] Subtest mode-transition: SKIP (0.295s)
[144.728211] [036/133] (875s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[144.832362] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[144.836730] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[144.898440] [037/133] (874s left) kms_psr (fbc-psr2-primary-page-flip)
[144.998285] Starting subtest: fbc-psr2-primary-page-flip
[145.000133] Starting dynamic subtest: eDP-1
[145.004190] Dynamic subtest eDP-1: SKIP (0.000s)
[145.008185] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[145.065731] [038/133] (874s left) kms_lease (lease-invalid-connector)
[145.158057] Starting subtest: lease-invalid-connector
[145.160557] Starting dynamic subtest: pipe-A-eDP-1
[145.162656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[145.170292] Starting dynamic subtest: pipe-B-eDP-1
[145.172097] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[145.179636] Starting dynamic subtest: pipe-C-eDP-1
[145.181680] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[145.189101] Starting dynamic subtest: pipe-D-eDP-1
[145.190937] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[145.192787] Subtest lease-invalid-connector: SUCCESS (0.004s)
[145.230762] [039/133] (874s left) gem_mmap_wc (write)
[145.291725] Subtest write: SKIP (0.000s)
[145.343715] [040/133] (874s left) gem_exec_fence (submit67)
[145.513617] Starting subtest: submit67
[145.517671] Subtest submit67: SKIP (0.000s)
[146.984187] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[146.987455] [041/133] (873s left) gem_close_race (multigpu-basic-process)
[147.041416] Starting subtest: multigpu-basic-process
[147.045900] Subtest multigpu-basic-process: SKIP (0.000s)
[147.270346] [042/133] (872s left) kms_cursor_edge_walk (64x64-right-edge)
[147.360304] Starting subtest: 64x64-right-edge
[147.362668] Starting dynamic subtest: pipe-A-eDP-1
[150.803441] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.443s)
[150.812811] Starting dynamic subtest: pipe-D-eDP-1
[153.930629] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[153.933117] Subtest 64x64-right-edge: SUCCESS (6.571s)
[154.760481] [043/133] (865s left) gem_exec_reloc (basic-wc-noreloc)
[154.827465] Subtest basic-wc-noreloc: SKIP (0.000s)
[154.888556] [044/133] (865s left) kms_atomic_interruptible (universal-setplane-primary)
[154.973305] Starting subtest: universal-setplane-primary
[154.975556] Starting dynamic subtest: pipe-A-eDP-1
[162.372195] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.399s)
[162.374617] Subtest universal-setplane-primary: SUCCESS (7.400s)
[163.203487] [045/133] (857s left) kms_psr (psr2-cursor-blt)
[163.304296] Starting subtest: psr2-cursor-blt
[163.306640] Starting dynamic subtest: eDP-1
[164.978653] Dynamic subtest eDP-1: SUCCESS (1.674s)
[164.980916] Subtest psr2-cursor-blt: SUCCESS (1.675s)
[165.770272] [046/133] (854s left) gem_userptr_blits (input-checking)
[165.844143] Starting subtest: input-checking
[165.846493] Subtest input-checking: SUCCESS (0.000s)
[165.956049] [047/133] (854s left) sysfs_timeslice_duration (idempotent)
[166.010551] Starting subtest: idempotent
[166.012892] Starting dynamic subtest: vecs0
[166.015316] Dynamic subtest vecs0: SUCCESS (0.000s)
[166.025185] Starting dynamic subtest: ccs0
[166.027032] Dynamic subtest ccs0: SUCCESS (0.000s)
[166.034845] Starting dynamic subtest: vcs0
[166.037064] Dynamic subtest vcs0: SUCCESS (0.000s)
[166.044676] Starting dynamic subtest: bcs0
[166.046626] Dynamic subtest bcs0: SUCCESS (0.000s)
[166.053968] Starting dynamic subtest: rcs0
[166.055948] Dynamic subtest rcs0: SUCCESS (0.000s)
[166.063832] Starting dynamic subtest: vcs1
[166.065747] Dynamic subtest vcs1: SUCCESS (0.000s)
[166.067590] Subtest idempotent: SUCCESS (0.007s)
[166.104175] [048/133] (854s left) gem_mmap_gtt (basic)
[166.155196] Subtest basic: SKIP (0.000s)
[166.215528] [049/133] (854s left) kms_properties (get_properties-sanity-non-atomic)
[166.315026] Starting subtest: get_properties-sanity-non-atomic
[166.317314] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[166.390695] [050/133] (854s left) gem_exec_schedule (manyslice)
[166.466772] Starting subtest: manyslice
[166.468782] Starting dynamic subtest: rcs0
[171.606615] Dynamic subtest rcs0: SUCCESS (5.148s)
[171.619906] Starting dynamic subtest: bcs0
[179.262981] Dynamic subtest bcs0: SUCCESS (7.656s)
[179.273584] Starting dynamic subtest: vcs0
[184.852951] Dynamic subtest vcs0: SUCCESS (5.587s)
[184.865757] Starting dynamic subtest: vcs1
[191.943551] Dynamic subtest vcs1: SUCCESS (7.089s)
[191.956965] Starting dynamic subtest: vecs0
[198.528072] Dynamic subtest vecs0: SUCCESS (6.582s)
[198.543562] Starting dynamic subtest: ccs0
[204.680122] Dynamic subtest ccs0: SUCCESS (6.151s)
[204.682992] Subtest manyslice: SUCCESS (38.222s)
[204.988597] [051/133] (815s left) gem_exec_params (secure-non-root)
[205.043616] Starting subtest: secure-non-root
[205.048305] Subtest secure-non-root: SKIP (0.000s)
[205.148254] [052/133] (815s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[205.258989] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[205.263528] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[205.328463] [053/133] (815s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[205.699855] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[206.474665] [054/133] (814s left) kms_rotation_crc (sprite-rotation-90)
[206.583295] Starting subtest: sprite-rotation-90
[206.587627] Subtest sprite-rotation-90: SKIP (0.001s)
[206.652981] [055/133] (813s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[206.707805] Starting subtest: mixed-tiled-to-y-tiled-ccs
[206.711809] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[206.902169] [056/133] (813s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[206.976614] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[207.033458] [057/133] (813s left) syncobj_timeline (single-wait-all-available-submitted)
[207.079385] Starting subtest: single-wait-all-available-submitted
[207.081840] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[207.170907] [058/133] (813s left) prime_self_import (basic-with_one_bo_two_files)
[207.205862] Starting subtest: basic-with_one_bo_two_files
[207.229055] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s)
[207.334414] [059/133] (813s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[207.421970] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[214.693118] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.274s)
[214.816329] [060/133] (806s left) gem_exec_reloc (basic-scanout)
[214.879837] Subtest basic-scanout: SKIP (0.000s)
[214.948301] [061/133] (805s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[215.057407] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[219.003695] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.947s)
[220.134551] [062/133] (800s left) gem_lmem_swapping (heavy-multi)
[220.174987] Subtest heavy-multi: SKIP (0.000s)
[220.216489] [063/133] (800s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[220.322470] Starting subtest: psr-modesetfrombusy
[226.488556] Subtest psr-modesetfrombusy: SUCCESS (6.169s)
[226.615888] [064/133] (794s left) perf_pmu (gt-awake)
[226.653009] Starting subtest: gt-awake
[234.902736] Subtest gt-awake: SUCCESS (8.248s)
[235.005876] [065/133] (786s left) prime_vgem (fence-read-hang)
[235.078313] Subtest fence-read-hang: SKIP (0.000s)
[235.168951] [066/133] (785s left) gem_flink_basic (bad-open)
[235.230747] Starting subtest: bad-open
[235.233168] Subtest bad-open: SUCCESS (0.000s)
[235.329070] [067/133] (785s left) gem_softpin (allocator-nopin-reserve)
[235.384802] Starting subtest: allocator-nopin-reserve
[235.474232] Subtest allocator-nopin-reserve: SUCCESS (0.088s)
[235.590059] [068/133] (785s left) kms_plane_scaling (planes-downscale-factor-0-75)
[235.684029] Starting subtest: planes-downscale-factor-0-75
[235.686407] Starting dynamic subtest: pipe-A
[235.706182] Dynamic subtest pipe-A: SKIP (0.018s)
[235.715458] Starting dynamic subtest: pipe-B
[235.738200] Dynamic subtest pipe-B: SKIP (0.032s)
[235.747710] Starting dynamic subtest: pipe-C
[235.770723] Dynamic subtest pipe-C: SKIP (0.031s)
[235.779285] Starting dynamic subtest: pipe-D
[235.802195] Dynamic subtest pipe-D: SKIP (0.031s)
[235.806525] Subtest planes-downscale-factor-0-75: SKIP (0.115s)
[235.922741] [069/133] (785s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[235.985343] Subtest writes-after-reads-uncached: SKIP (0.000s)
[236.052395] [070/133] (785s left) perf_pmu (busy-double-start)
[236.094191] Starting subtest: busy-double-start
[236.095974] Starting dynamic subtest: rcs0
[239.735912] Dynamic subtest rcs0: FAIL (3.588s)
[239.746137] Starting dynamic subtest: bcs0
[243.252419] Dynamic subtest bcs0: SUCCESS (3.569s)
[243.263305] Starting dynamic subtest: vcs0
[247.447812] Dynamic subtest vcs0: SUCCESS (4.193s)
[247.458177] Starting dynamic subtest: vcs1
[251.419673] Dynamic subtest vcs1: SUCCESS (3.970s)
[251.430512] Starting dynamic subtest: vecs0
[255.462816] Dynamic subtest vecs0: SUCCESS (4.041s)
[255.473557] Starting dynamic subtest: ccs0
[259.097716] Dynamic subtest ccs0: FAIL (3.567s)
[259.099607] Subtest busy-double-start: FAIL (22.938s)
[259.138950] [071/133] (762s left) gem_render_copy (y-tiled)
[259.199537] Starting subtest: y-tiled
[259.204093] Subtest y-tiled: SKIP (0.000s)
[259.386898] [072/133] (761s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[259.443663] Starting subtest: single-wait-all-for-submit-unsubmitted
[259.553228] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[259.643459] [073/133] (761s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[259.740946] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[259.743251] Starting dynamic subtest: pipe-A-eDP-1
[260.240883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.473s)
[260.249757] Starting dynamic subtest: pipe-B-eDP-1
[261.705324] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.462s)
[261.714291] Starting dynamic subtest: pipe-C-eDP-1
[263.129258] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.422s)
[263.138648] Starting dynamic subtest: pipe-D-eDP-1
[264.523662] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.393s)
[264.525599] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.755s)
[265.702491] [074/133] (755s left) kms_cursor_crc (cursor-random-max-size)
[266.023972] Starting subtest: cursor-random-max-size
[266.030749] Subtest cursor-random-max-size: SKIP (0.000s)
[266.152246] [075/133] (755s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[266.238913] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[266.241139] Starting dynamic subtest: pipe-A-eDP-1
[266.262883] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[266.272344] Starting dynamic subtest: pipe-B-eDP-1
[266.291378] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[266.302244] Starting dynamic subtest: pipe-C-eDP-1
[266.322795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[266.330786] Starting dynamic subtest: pipe-D-eDP-1
[266.352258] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[266.356580] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[268.471181] [076/133] (752s left) gem_exec_balancer (nohangcheck)
[268.734288] Starting subtest: nohangcheck
[269.614291] Subtest nohangcheck: SUCCESS (0.879s)
[269.723163] [077/133] (751s left) sw_sync (alloc_merge_fence)
[269.767296] Starting subtest: alloc_merge_fence
[269.769137] Subtest alloc_merge_fence: SUCCESS (0.000s)
[269.820500] [078/133] (751s left) kms_pm_backlight (fade-with-dpms)
[269.915400] Starting subtest: fade-with-dpms
[272.385405] Starting dynamic subtest: eDP-1
[274.875846] Dynamic subtest eDP-1: SUCCESS (2.490s)
[274.878209] Subtest fade-with-dpms: SUCCESS (4.961s)
[275.695771] [079/133] (745s left) kms_draw_crc (draw-method-blt)
[275.784048] Starting subtest: draw-method-blt
[275.785961] Starting dynamic subtest: xrgb8888-untiled
[276.004654] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[276.013338] Starting dynamic subtest: rgb565-untiled
[276.219999] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[276.238805] Starting dynamic subtest: xrgb2101010-untiled
[276.426448] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[276.435611] Starting dynamic subtest: xbgr16161616f-untiled
[276.648308] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[276.656651] Starting dynamic subtest: xrgb8888-xtiled
[276.770545] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[276.779997] Starting dynamic subtest: rgb565-xtiled
[276.893156] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[276.903487] Starting dynamic subtest: xrgb2101010-xtiled
[277.003812] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.108s)
[277.014199] Starting dynamic subtest: xbgr16161616f-xtiled
[277.125865] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.120s)
[277.136070] Starting dynamic subtest: xrgb8888-4tiled
[277.248016] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s)
[277.259308] Starting dynamic subtest: rgb565-4tiled
[277.370764] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[277.381166] Starting dynamic subtest: xrgb2101010-4tiled
[277.481933] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.109s)
[277.492453] Starting dynamic subtest: xbgr16161616f-4tiled
[277.603843] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.120s)
[277.605683] Subtest draw-method-blt: SUCCESS (1.823s)
[277.720814] [080/133] (743s left) kms_big_fb (linear-8bpp-rotate-0)
[277.819433] Starting subtest: linear-8bpp-rotate-0
[279.077448] Subtest linear-8bpp-rotate-0: SUCCESS (1.258s)
[279.188623] [081/133] (742s left) syncobj_timeline (etime-single-wait-submitted)
[279.243473] Starting subtest: etime-single-wait-submitted
[279.343412] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[279.419787] [082/133] (742s left) kms_plane_lowres (tiling-4)
[279.512598] Starting subtest: tiling-4
[279.514545] Starting dynamic subtest: pipe-A-eDP-1
[279.518352] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[279.814941] Starting dynamic subtest: pipe-B-eDP-1
[279.819934] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.830242] Starting dynamic subtest: pipe-C-eDP-1
[279.834850] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.843090] Starting dynamic subtest: pipe-D-eDP-1
[279.847687] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.852196] Subtest tiling-4: SKIP (0.305s)
[280.607153] [083/133] (741s left) kms_vblank (ts-continuation-modeset-rpm)
[280.702441] Starting subtest: ts-continuation-modeset-rpm
[280.704425] Starting dynamic subtest: pipe-A-eDP-1
[283.213350] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.512s)
[283.228692] Starting dynamic subtest: pipe-D-eDP-1
[285.464642] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.247s)
[285.467095] Subtest ts-continuation-modeset-rpm: SUCCESS (4.764s)
[286.273578] [084/133] (735s left) prime_vgem (coherency-blt)
[286.346014] Starting subtest: coherency-blt
[287.412269] Subtest coherency-blt: SUCCESS (1.065s)
[287.562819] [085/133] (734s left) gem_mmap_gtt (big-bo-tiledx)
[287.634167] Subtest big-bo-tiledX: SKIP (0.000s)
[287.696820] [086/133] (734s left) kms_psr2_su (frontbuffer-xrgb8888)
[287.758359] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[287.823939] [087/133] (734s left) gem_sync (basic-all)
[287.909658] Starting subtest: basic-all
[291.860853] Subtest basic-all: SUCCESS (3.960s)
[292.047486] [088/133] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[292.161061] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[292.165039] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[292.261305] [089/133] (729s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[292.359763] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[292.364846] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[292.447411] [090/133] (729s left) gem_exec_schedule (preempt-self)
[292.513888] Starting subtest: preempt-self
[292.516143] Starting dynamic subtest: rcs0
[292.525860] Dynamic subtest rcs0: SUCCESS (0.019s)
[292.535968] Starting dynamic subtest: bcs0
[292.544959] Dynamic subtest bcs0: SUCCESS (0.018s)
[292.558415] Starting dynamic subtest: vcs0
[292.570568] Dynamic subtest vcs0: SUCCESS (0.024s)
[292.579208] Starting dynamic subtest: vcs1
[292.588729] Dynamic subtest vcs1: SUCCESS (0.017s)
[292.597491] Starting dynamic subtest: vecs0
[292.613309] Dynamic subtest vecs0: SUCCESS (0.024s)
[292.622295] Starting dynamic subtest: ccs0
[292.629945] Dynamic subtest ccs0: SUCCESS (0.016s)
[292.632255] Subtest preempt-self: SUCCESS (0.124s)
[293.989601] [091/133] (728s left) gem_workarounds (suspend-resume-context)
[294.071616] Starting subtest: suspend-resume-context
[310.066983] Subtest suspend-resume-context: SUCCESS (1.283s)
[310.205810] [092/133] (711s left) gem_sync (basic-store-each)
[310.293823] Starting subtest: basic-store-each
[312.498851] Subtest basic-store-each: SUCCESS (2.294s)
[312.679319] [093/133] (709s left) gem_exec_params (invalid-bsd1-flag-on-render)
[312.757973] Starting subtest: invalid-bsd1-flag-on-render
[312.760140] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[312.853942] [094/133] (709s left) gem_lmem_swapping (parallel-random-verify-ccs)
[312.899441] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[312.950473] [095/133] (709s left) kms_pm_rpm (universal-planes-dpms)
[314.775916] Starting subtest: universal-planes-dpms
[314.778062] Starting dynamic subtest: plane-34
[323.177848] Dynamic subtest plane-34: SUCCESS (8.531s)
[323.190247] Starting dynamic subtest: plane-64
[331.772248] Dynamic subtest plane-64: SUCCESS (8.637s)
[331.784249] Starting dynamic subtest: plane-94
[340.062912] Dynamic subtest plane-94: SUCCESS (8.305s)
[340.074891] Starting dynamic subtest: plane-124
[348.394158] Dynamic subtest plane-124: SUCCESS (8.327s)
[348.406273] Starting dynamic subtest: plane-134
[356.679766] Dynamic subtest plane-134: SUCCESS (8.283s)
[356.693810] Starting dynamic subtest: plane-144
[364.978922] Dynamic subtest plane-144: SUCCESS (8.296s)
[364.982089] Subtest universal-planes-dpms: SUCCESS (50.397s)
[365.337960] [096/133] (656s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[365.435161] Starting subtest: fbcpsr-rgb101010-draw-render
[372.191346] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.761s)
[372.315040] [097/133] (649s left) gem_eio (in-flight-10ms)
[372.566560] Starting subtest: in-flight-10ms
[381.764778] Subtest in-flight-10ms: SUCCESS (9.199s)
[381.938689] [098/133] (640s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[383.775439] Starting subtest: gem-execbuf-stress-pc8
[383.827655] Subtest gem-execbuf-stress-pc8: SKIP (0.053s)
[384.200908] [099/133] (638s left) prime_vgem (basic-read)
[384.265586] Starting subtest: basic-read
[384.272809] Subtest basic-read: SKIP (0.005s)
[384.364400] [100/133] (638s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[384.422849] Starting subtest: yf-tiled-to-vebox-x-tiled
[384.427446] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[384.620644] [101/133] (637s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[384.710992] Starting subtest: 4-tiled-64bpp-rotate-0
[386.189243] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.478s)
[386.370903] [102/133] (636s left) gem_render_copy_redux (normal)
[386.433249] Starting subtest: normal
[386.724847] Subtest normal: SUCCESS (0.292s)
[386.817879] [103/133] (635s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[386.910723] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[386.912622] Starting dynamic subtest: pipe-A
[386.930162] Dynamic subtest pipe-A: SKIP (0.016s)
[386.940269] Starting dynamic subtest: pipe-B
[386.958143] Dynamic subtest pipe-B: SKIP (0.029s)
[386.968157] Starting dynamic subtest: pipe-C
[386.988236] Dynamic subtest pipe-C: SKIP (0.029s)
[386.997985] Starting dynamic subtest: pipe-D
[387.018303] Dynamic subtest pipe-D: SKIP (0.029s)
[387.021404] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.104s)
[387.127877] [104/133] (635s left) gem_ctx_persistence (heartbeat-many)
[387.188138] Starting subtest: heartbeat-many
[387.192221] Subtest heartbeat-many: SKIP (0.000s)
[387.300532] [105/133] (635s left) gem_mmap_offset (perf)
[387.355335] Starting subtest: perf
[387.357212] Starting dynamic subtest: smem0
[387.719460] Dynamic subtest smem0: SUCCESS (0.362s)
[387.721802] Subtest perf: SUCCESS (0.364s)
[387.843977] [106/133] (634s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[387.933476] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[387.935791] Starting dynamic subtest: pipe-A-eDP-1
[387.957120] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[387.971524] Starting dynamic subtest: pipe-B-eDP-1
[387.992233] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[388.001481] Starting dynamic subtest: pipe-C-eDP-1
[388.021113] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[388.030910] Starting dynamic subtest: pipe-D-eDP-1
[388.050447] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[388.052697] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[390.244345] [107/133] (632s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[390.301164] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[390.403608] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[390.478641] [108/133] (632s left) i915_drm_fdinfo (virtual-busy-hang-all)
[390.515550] Starting subtest: virtual-busy-hang-all
[390.520118] Subtest virtual-busy-hang-all: SKIP (0.000s)
[390.576898] [109/133] (632s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[390.674436] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[390.679078] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[391.764786] [110/133] (631s left) kms_color (legacy-gamma-reset)
[391.865570] Starting subtest: legacy-gamma-reset
[391.867785] Starting dynamic subtest: pipe-A-eDP-1
[392.253565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[392.263443] Starting dynamic subtest: pipe-B-eDP-1
[392.265662] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[392.275019] Starting dynamic subtest: pipe-C-eDP-1
[392.280141] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[392.289570] Starting dynamic subtest: pipe-D-eDP-1
[392.291905] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[392.294273] Subtest legacy-gamma-reset: SUCCESS (0.427s)
[393.088734] [111/133] (629s left) gem_tiled_pread_basic (basic)
[393.144405] Subtest basic: SKIP (0.000s)
[393.202716] [112/133] (629s left) gem_fence_thrash (bo-write-verify-threaded-none)
[393.239251] Starting subtest: bo-write-verify-threaded-none
[393.255617] Subtest bo-write-verify-threaded-none: SKIP (0.018s)
[393.322273] [113/133] (629s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[393.414768] Starting subtest: stress-xrgb8888-4tiled
[399.318774] Subtest stress-xrgb8888-4tiled: SUCCESS (5.907s)
[399.369808] [114/133] (623s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[399.464013] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[399.467613] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[399.560103] [115/133] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[399.652171] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[404.154046] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.505s)
[405.286504] [116/133] (617s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[405.385934] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[413.025880] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.640s)
[413.139351] [117/133] (609s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[413.249198] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[413.253333] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[413.318374] [118/133] (609s left) gem_exec_whisper (basic-fds-forked)
[413.382249] Starting subtest: basic-fds-forked
[437.176844] Subtest basic-fds-forked: SUCCESS (23.788s)
[437.375798] [119/133] (585s left) gem_render_copy (linear)
[437.431667] Starting subtest: linear
[437.433830] Starting dynamic subtest: smem
[437.476581] Dynamic subtest smem: SUCCESS (0.045s)
[437.479183] Subtest linear: SUCCESS (0.045s)
[437.698180] [120/133] (585s left) syncobj_timeline (invalid-signal-zero-handles)
[437.746283] Starting subtest: invalid-signal-zero-handles
[437.748661] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[437.841202] [121/133] (585s left) syncobj_timeline (multi-wait-available-signaled)
[437.892702] Starting subtest: multi-wait-available-signaled
[437.895114] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[438.001627] [122/133] (585s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[438.095058] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[438.099288] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[438.201666] [123/133] (585s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[438.298031] Starting subtest: yf-tiled-32bpp-rotate-0
[438.302368] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[438.381476] [124/133] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[438.481753] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[438.486052] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[438.569593] [125/133] (584s left) gem_tiled_blits (normal)
[438.631584] Subtest normal: SKIP (0.000s)
[438.690461] [126/133] (584s left) i915_drm_fdinfo (memory-info-resident)
[438.727940] Starting subtest: memory-info-resident
[438.729919] Starting dynamic subtest: smem0
[441.600345] Dynamic subtest smem0: SUCCESS (2.874s)
[441.602423] Subtest memory-info-resident: SUCCESS (2.874s)
[441.678047] [127/133] (581s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[441.782943] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[441.786390] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[441.891645] [128/133] (581s left) perf (short-reads)
[442.022952] Starting subtest: short-reads
[442.038893] Subtest short-reads: SUCCESS (0.018s)
[442.087817] [129/133] (581s left) kms_psr (psr-basic)
[442.184689] Starting subtest: psr-basic
[442.186444] Starting dynamic subtest: eDP-1
[443.787936] Dynamic subtest eDP-1: SUCCESS (1.602s)
[443.790195] Subtest psr-basic: SUCCESS (1.603s)
[444.662699] [130/133] (579s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[444.755495] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[452.148420] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.395s)
[452.281380] [131/133] (571s left) kms_chamelium_frames (hdmi-crc-fast)
[452.658150] Subtest hdmi-crc-fast: SKIP (0.000s)
[453.491044] [132/133] (570s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[453.585466] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[453.587322] Starting dynamic subtest: pipe-A-eDP-1
[454.955640] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.370s)
[455.235673] Starting dynamic subtest: pipe-B-eDP-1
[456.274652] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[456.538634] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.954s)
[457.388722] [133/133] (566s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[457.497834] Starting subtest: basic-flip-after-cursor-atomic
[458.432996] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.934s)
[459.235741] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: core_hotunplug
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: gem_exec_async
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: kms_atomic
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_joiner
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: i915_query
results: parsing output: 11/ for test: kms_async_flips
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_content_protection
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_setmode
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_ppgtt
results: parsing output: 30/ for test: kms_sequence
results: parsing output: 31/ for test: fbdev
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: kms_cdclk
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: gem_close_race
results: parsing output: 41/ for test: kms_cursor_edge_walk
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_atomic_interruptible
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: sysfs_timeslice_duration
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: kms_properties
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: kms_rotation_crc
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_pipe_b_c_ivb
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: prime_self_import
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_lmem_swapping
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: prime_vgem
results: parsing output: 65/ for test: gem_flink_basic
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: gem_partial_pwrite_pread
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: kms_pm_backlight
results: parsing output: 78/ for test: kms_draw_crc
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_plane_lowres
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: prime_vgem
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: kms_psr2_su
results: parsing output: 86/ for test: gem_sync
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: gem_workarounds
results: parsing output: 91/ for test: gem_sync
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: kms_pm_rpm
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: i915_pm_rpm
results: parsing output: 98/ for test: prime_vgem
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_render_copy_redux
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: i915_drm_fdinfo
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_color
results: parsing output: 110/ for test: gem_tiled_pread_basic
results: parsing output: 111/ for test: gem_fence_thrash
results: parsing output: 112/ for test: kms_pipe_stress
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: gem_exec_whisper
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_tiled_blits
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: perf
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_chamelium_frames
results: parsing output: 131/ for test: kms_atomic_transition
results: parsing output: 132/ for test: kms_cursor_legacy
Done.