[58.088087] Initializing watchdogs
[58.088135]   /dev/watchdog0
[58.102553] [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.106847] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.109101] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.112399] [001/133] (960s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[58.241806] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[58.244160] Starting dynamic subtest: pipe-A
[58.264193] Dynamic subtest pipe-A: SKIP (0.018s)
[58.272585] Starting dynamic subtest: pipe-B
[58.296438] Dynamic subtest pipe-B: SKIP (0.033s)
[58.303519] Starting dynamic subtest: pipe-C
[58.331215] Dynamic subtest pipe-C: SKIP (0.034s)
[58.338050] Starting dynamic subtest: pipe-D
[58.362927] Dynamic subtest pipe-D: SKIP (0.034s)
[58.366601] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.119s)
[58.448941] [002/133] (960s left) kms_prop_blob (invalid-set-prop)
[58.501602] Starting subtest: invalid-set-prop
[58.503842] Subtest invalid-set-prop: SUCCESS (0.000s)
[58.596498] [003/133] (960s left) gem_close_race (basic-threads)
[58.657321] Starting subtest: basic-threads
[60.088177] Subtest basic-threads: SUCCESS (1.431s)
[60.266192] [004/133] (958s left) kms_cursor_crc (cursor-onscreen-128x42)
[60.484127] Starting subtest: cursor-onscreen-128x42
[60.534353] Subtest cursor-onscreen-128x42: SKIP (0.045s)
[60.727009] [005/133] (958s left) kms_pm_dc (dc6-psr)
[61.828989] Starting subtest: dc6-psr
[64.722390] Subtest dc6-psr: SUCCESS (2.893s)
[65.619067] [006/133] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[65.729566] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[70.266780] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.541s)
[71.400215] [007/133] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[71.499714] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[78.566507] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.072s)
[78.661206] [008/133] (940s left) kms_flip (basic-flip-vs-dpms)
[78.754444] Starting subtest: basic-flip-vs-dpms
[78.756697] Starting dynamic subtest: A-eDP1
[81.317653] Dynamic subtest A-eDP1: SUCCESS (2.563s)
[81.326634] Starting dynamic subtest: B-eDP1
[83.488438] Dynamic subtest B-eDP1: SUCCESS (2.168s)
[83.499662] Starting dynamic subtest: C-eDP1
[85.567050] Dynamic subtest C-eDP1: SUCCESS (2.079s)
[85.576770] Starting dynamic subtest: D-eDP1
[87.654105] Dynamic subtest D-eDP1: SUCCESS (2.086s)
[87.656490] Subtest basic-flip-vs-dpms: SUCCESS (8.904s)
[88.443757] [009/133] (930s left) prime_vgem (basic-blt)
[88.575496] Starting subtest: basic-blt
[88.598704] Subtest basic-blt: SUCCESS (0.024s)
[88.724309] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[88.727365] [010/133] (930s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[88.818633] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[88.822791] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[88.912272] [011/133] (930s left) prime_mmap (test_refcounting)
[88.978640] Starting subtest: test_refcounting
[88.981063] Starting dynamic subtest: test_refcounting-smem
[89.008762] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[89.011843] Subtest test_refcounting: SUCCESS (0.032s)
[89.105249] [012/133] (929s left) gem_mmap_wc (read-write-distinct)
[89.154571] Subtest read-write-distinct: SKIP (0.000s)
[89.212117] [013/133] (929s left) kms_flip (modeset-vs-vblank-race)
[89.299157] Starting subtest: modeset-vs-vblank-race
[89.301521] Starting dynamic subtest: A-eDP1
[93.985509] Dynamic subtest A-eDP1: SUCCESS (4.685s)
[93.995081] Starting dynamic subtest: B-eDP1
[98.712778] Dynamic subtest B-eDP1: SUCCESS (4.725s)
[98.722815] Starting dynamic subtest: C-eDP1
[103.409079] Dynamic subtest C-eDP1: SUCCESS (4.694s)
[103.418077] Starting dynamic subtest: D-eDP1
[107.946118] Dynamic subtest D-eDP1: SUCCESS (4.535s)
[107.951435] Subtest modeset-vs-vblank-race: SUCCESS (18.652s)
[109.099306] [014/133] (910s left) gem_softpin (noreloc-interruptible)
[109.154709] Starting subtest: noreloc-interruptible
[114.575814] Subtest noreloc-interruptible: SUCCESS (5.419s)
[114.700477] [015/133] (904s left) vgem_basic (debugfs)
[114.751705] Starting subtest: debugfs
[114.754120] Subtest debugfs: SUCCESS (0.000s)
[114.811827] [016/133] (904s left) syncobj_wait (wait-for-submit-delayed-submit)
[114.865857] Starting subtest: wait-for-submit-delayed-submit
[114.967749] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[115.066279] [017/133] (904s left) kms_lease (lease-uevent)
[115.165913] Starting subtest: lease-uevent
[116.177499] Subtest lease-uevent: SUCCESS (1.012s)
[116.286988] [018/133] (902s left) kms_atomic_interruptible (legacy-cursor)
[116.385341] Starting subtest: legacy-cursor
[116.387753] Starting dynamic subtest: pipe-A-eDP-1
[123.803403] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.417s)
[123.805610] Subtest legacy-cursor: SUCCESS (7.418s)
[124.661151] [019/133] (894s left) gem_spin_batch (legacy-resubmit)
[124.721628] Starting subtest: legacy-resubmit
[124.723892] Starting dynamic subtest: default
[124.728183] Dynamic subtest default: SUCCESS (0.005s)
[124.735401] Starting dynamic subtest: render
[124.737250] Dynamic subtest render: SUCCESS (0.001s)
[124.744580] Starting dynamic subtest: bsd
[124.746706] Dynamic subtest bsd: SUCCESS (0.002s)
[124.753716] Starting dynamic subtest: bsd1
[124.755634] Dynamic subtest bsd1: SUCCESS (0.004s)
[124.762263] Starting dynamic subtest: bsd2
[124.764137] Dynamic subtest bsd2: SUCCESS (0.001s)
[124.770842] Starting dynamic subtest: blt
[124.772768] Dynamic subtest blt: SUCCESS (0.002s)
[124.779455] Starting dynamic subtest: vebox
[124.781347] Dynamic subtest vebox: SUCCESS (0.003s)
[124.783241] Subtest legacy-resubmit: SUCCESS (0.026s)
[124.973141] [020/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[125.061617] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[125.066079] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[125.165285] [021/133] (894s left) kms_vblank (invalid)
[125.255070] Starting subtest: invalid
[125.257294] Starting dynamic subtest: pipe-A-eDP-1
[125.652434] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[125.654823] Subtest invalid: SUCCESS (0.397s)
[126.493144] [022/133] (892s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[126.600035] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[149.048079] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.453s)
[149.196890] [023/133] (870s left) kms_color_pipeline (plane-ctm3x4)
[149.294067] Starting subtest: plane-ctm3x4
[149.429911] Starting dynamic subtest: pipe-A-plane-0
[149.551773] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s)
[149.558952] Starting dynamic subtest: pipe-A-plane-1
[149.685257] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[149.692225] Starting dynamic subtest: pipe-A-plane-2
[149.807480] Dynamic subtest pipe-A-plane-2: SUCCESS (0.121s)
[151.072143] Starting dynamic subtest: pipe-B-plane-0
[151.231064] Dynamic subtest pipe-B-plane-0: SUCCESS (0.165s)
[151.239708] Starting dynamic subtest: pipe-B-plane-1
[151.353402] Dynamic subtest pipe-B-plane-1: SUCCESS (0.121s)
[151.360770] Starting dynamic subtest: pipe-B-plane-2
[151.509254] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[152.651281] Starting dynamic subtest: pipe-C-plane-0
[152.778395] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[152.786320] Starting dynamic subtest: pipe-C-plane-1
[152.889720] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[152.897322] Starting dynamic subtest: pipe-C-plane-2
[153.000978] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[154.177374] Starting dynamic subtest: pipe-D-plane-0
[154.305015] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[154.315361] Starting dynamic subtest: pipe-D-plane-1
[154.415969] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[154.424855] Starting dynamic subtest: pipe-D-plane-2
[154.527407] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[154.818264] Subtest plane-ctm3x4: SUCCESS (5.523s)
[155.641757] [024/133] (863s left) perf_pmu (busy-check-all)
[155.688858] Starting subtest: busy-check-all
[155.690848] Starting dynamic subtest: rcs0
[156.237575] Dynamic subtest rcs0: SUCCESS (0.550s)
[156.248783] Starting dynamic subtest: bcs0
[156.787880] Dynamic subtest bcs0: SUCCESS (0.548s)
[156.798642] Starting dynamic subtest: vcs0
[157.910767] Dynamic subtest vcs0: SUCCESS (1.119s)
[157.921812] Starting dynamic subtest: vcs1
[159.895350] Dynamic subtest vcs1: SUCCESS (1.981s)
[159.906569] Starting dynamic subtest: vecs0
[161.879410] Dynamic subtest vecs0: SUCCESS (1.980s)
[161.890117] Starting dynamic subtest: ccs0
[162.433875] Dynamic subtest ccs0: SUCCESS (0.554s)
[162.436320] Subtest busy-check-all: SUCCESS (6.748s)
[162.536792] [025/133] (857s left) i915_pm_freq_mult (media-freq)
[162.606377] Starting subtest: media-freq
[162.608671] Starting dynamic subtest: gt0
[162.612864] Dynamic subtest gt0: SKIP (0.000s)
[162.621851] Starting dynamic subtest: gt1
[162.626023] Dynamic subtest gt1: SKIP (0.000s)
[162.630165] Subtest media-freq: SKIP (0.002s)
[162.716231] [026/133] (856s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[162.819837] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[162.846083] Starting dynamic subtest: pipe-A-plane-0
[163.268111] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[163.277407] Starting dynamic subtest: pipe-A-plane-3
[163.523183] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[163.531173] Starting dynamic subtest: pipe-A-plane-5
[163.535098] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[164.633795] Starting dynamic subtest: pipe-B-plane-0
[165.060624] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[165.068698] Starting dynamic subtest: pipe-B-plane-3
[165.316401] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[165.326242] Starting dynamic subtest: pipe-B-plane-5
[165.330408] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[165.633200] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.815s)
[166.530235] [027/133] (853s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[166.631522] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[166.636074] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[166.724903] [028/133] (852s left) gem_ppgtt (flink-and-close-vma-leak)
[166.787699] Starting subtest: flink-and-close-vma-leak
[166.830337] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[166.933337] [029/133] (852s left) kms_pm_rpm (fences-dpms)
[169.070430] Starting subtest: fences-dpms
[169.075872] Subtest fences-dpms: SKIP (0.000s)
[169.436676] [030/133] (850s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[169.530315] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[169.532558] Starting dynamic subtest: pipe-A-eDP-1
[169.555874] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[169.565657] Starting dynamic subtest: pipe-B-eDP-1
[169.587195] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.595225] Starting dynamic subtest: pipe-C-eDP-1
[169.617140] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.625038] Starting dynamic subtest: pipe-D-eDP-1
[169.647219] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.651280] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[171.788449] [031/133] (847s left) kms_cursor_edge_walk (256x256-left-edge)
[171.879540] Starting subtest: 256x256-left-edge
[171.882235] Starting dynamic subtest: pipe-A-eDP-1
[175.349484] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[175.358732] Starting dynamic subtest: pipe-D-eDP-1
[178.472042] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[178.474202] Subtest 256x256-left-edge: SUCCESS (6.593s)
[179.271250] [032/133] (840s left) gem_mmap_wc (write-read)
[179.321349] Subtest write-read: SKIP (0.000s)
[179.385974] [033/133] (840s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[179.473986] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[179.478365] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[179.557615] [034/133] (840s left) kms_flip (plain-flip-ts-check-interruptible)
[179.648246] Starting subtest: plain-flip-ts-check-interruptible
[179.650509] Starting dynamic subtest: A-eDP1
[188.504409] Dynamic subtest A-eDP1: SUCCESS (8.822s)
[188.513543] Starting dynamic subtest: B-eDP1
[197.332549] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[197.342991] Starting dynamic subtest: C-eDP1
[206.163594] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[206.174388] Starting dynamic subtest: D-eDP1
[214.998505] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[215.000946] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.310s)
[216.137891] [035/133] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[216.247418] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[216.251745] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[216.353480] [036/133] (803s left) gem_create (create-ext-placement-all)
[216.533103] Starting subtest: create-ext-placement-all
[216.535698] Subtest create-ext-placement-all: SUCCESS (0.000s)
[216.642412] [037/133] (803s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[216.881277] Starting subtest: cursor-rapid-movement-256x85
[216.929311] Subtest cursor-rapid-movement-256x85: SKIP (0.044s)
[217.108336] [038/133] (802s left) syncobj_timeline (wait-delayed-signal)
[217.174559] Starting subtest: wait-delayed-signal
[217.276396] Subtest wait-delayed-signal: SUCCESS (0.103s)
[217.357410] [039/133] (802s left) gem_ctx_shared (q-out-order)
[217.415983] Starting subtest: Q-out-order
[217.418415] Starting dynamic subtest: rcs0
[217.528677] Dynamic subtest rcs0: SUCCESS (0.111s)
[217.538574] Starting dynamic subtest: vcs0
[217.622037] Dynamic subtest vcs0: SUCCESS (0.093s)
[217.638080] Starting dynamic subtest: vcs1
[217.696676] Dynamic subtest vcs1: SUCCESS (0.072s)
[217.712935] Starting dynamic subtest: vecs0
[217.773206] Dynamic subtest vecs0: SUCCESS (0.075s)
[217.788772] Starting dynamic subtest: ccs0
[217.854484] Dynamic subtest ccs0: SUCCESS (0.080s)
[217.857418] Subtest Q-out-order: SUCCESS (0.438s)
[218.996698] [040/133] (801s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[219.093691] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[219.695648] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.603s)
[219.844968] [041/133] (800s left) kms_psr (psr-no-drrs)
[219.939308] Starting subtest: psr-no-drrs
[219.941589] Starting dynamic subtest: eDP-1
[221.529520] Dynamic subtest eDP-1: SUCCESS (1.591s)
[221.531917] Subtest psr-no-drrs: SUCCESS (1.592s)
[222.406149] [042/133] (797s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[222.504285] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[222.506598] Starting dynamic subtest: pipe-A-eDP-1
[222.529799] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[222.540086] Starting dynamic subtest: pipe-B-eDP-1
[222.561492] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[222.569061] Starting dynamic subtest: pipe-C-eDP-1
[222.590692] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[222.598329] Starting dynamic subtest: pipe-D-eDP-1
[222.620293] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[222.624672] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[224.691900] [043/133] (795s left) gen9_exec_parse (bb-start-cmd)
[224.746617] Subtest bb-start-cmd: SKIP (0.000s)
[224.818500] [044/133] (795s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[224.919055] Starting subtest: psr-rgb101010-draw-mmap-cpu
[231.950626] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.034s)
[232.077369] [045/133] (788s left) kms_fbcon_fbt (psr)
[232.133211] Starting subtest: psr
[239.429830] Subtest psr: SUCCESS (7.294s)
[239.506051] [046/133] (780s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[239.635890] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[239.640460] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[239.732480] [047/133] (780s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[239.829650] Starting subtest: fbc-rgb101010-draw-mmap-wc
[244.431732] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.605s)
[245.545658] [048/133] (774s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[245.643442] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[245.647821] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[245.739353] [049/133] (774s left) gem_exec_balancer (busy)
[245.801585] Starting subtest: busy
[247.885576] Subtest busy: SUCCESS (2.082s)
[248.215137] [050/133] (772s left) gem_exec_schedule (u-semaphore-user)
[248.290623] Starting subtest: u-semaphore-user
[248.350222] Subtest u-semaphore-user: SUCCESS (0.063s)
[249.941878] [051/133] (770s left) gem_exec_reloc (basic-range-active)
[250.004331] Subtest basic-range-active: SKIP (0.000s)
[250.077224] [052/133] (770s left) kms_vblank (wait-idle)
[250.164968] Starting subtest: wait-idle
[250.167134] Starting dynamic subtest: pipe-A-eDP-1
[251.920980] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[251.935921] Starting dynamic subtest: pipe-D-eDP-1
[254.370603] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.450s)
[254.373058] Subtest wait-idle: SUCCESS (4.208s)
[255.201423] [053/133] (765s left) gem_set_tiling_vs_pwrite
[255.312947] [054/133] (765s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[255.397434] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[255.399569] Starting dynamic subtest: pipe-A-eDP-1
[255.419929] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[255.430089] Starting dynamic subtest: pipe-B-eDP-1
[255.449018] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[255.457026] Starting dynamic subtest: pipe-C-eDP-1
[255.475685] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[255.485614] Starting dynamic subtest: pipe-D-eDP-1
[255.504348] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[255.506181] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[257.655117] [055/133] (763s left) perf_pmu (busy-hang)
[257.704626] Starting subtest: busy-hang
[257.707065] Starting dynamic subtest: rcs0
[258.996122] Dynamic subtest rcs0: SUCCESS (1.288s)
[259.004593] Starting dynamic subtest: bcs0
[260.246500] Dynamic subtest bcs0: SUCCESS (1.251s)
[260.257361] Starting dynamic subtest: vcs0
[262.423382] Dynamic subtest vcs0: SUCCESS (2.175s)
[262.433724] Starting dynamic subtest: vcs1
[264.405492] Dynamic subtest vcs1: SUCCESS (1.980s)
[264.416196] Starting dynamic subtest: vecs0
[266.454840] Dynamic subtest vecs0: SUCCESS (2.048s)
[266.465468] Starting dynamic subtest: ccs0
[267.695312] Dynamic subtest ccs0: SUCCESS (1.235s)
[267.697249] Subtest busy-hang: SUCCESS (9.988s)
[267.798483] [056/133] (753s left) gem_exec_schedule (preempt-other-chain)
[267.878693] Starting subtest: preempt-other-chain
[267.881054] Starting dynamic subtest: rcs0
[268.015915] Dynamic subtest rcs0: SUCCESS (0.142s)
[268.027866] Starting dynamic subtest: bcs0
[268.148329] Dynamic subtest bcs0: SUCCESS (0.133s)
[268.160052] Starting dynamic subtest: vcs0
[268.328367] Dynamic subtest vcs0: SUCCESS (0.178s)
[268.341127] Starting dynamic subtest: vcs1
[268.465789] Dynamic subtest vcs1: SUCCESS (0.136s)
[268.477091] Starting dynamic subtest: vecs0
[268.606101] Dynamic subtest vecs0: SUCCESS (0.140s)
[268.617609] Starting dynamic subtest: ccs0
[268.745337] Dynamic subtest ccs0: SUCCESS (0.139s)
[268.747594] Subtest preempt-other-chain: SUCCESS (0.873s)
[269.916590] [057/133] (750s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[270.017028] Starting subtest: addfb25-yf-tiled-legacy
[270.019292] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[270.130433] [058/133] (750s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[270.256432] Starting subtest: cursorB-vs-flipB-atomic-transitions
[270.260892] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[270.399550] [059/133] (750s left) gem_mmap_offset (partial-unmap)
[270.458051] Starting subtest: partial-unmap
[270.460300] Starting dynamic subtest: smem0
[270.964335] Dynamic subtest smem0: SUCCESS (0.506s)
[270.967311] Subtest partial-unmap: SUCCESS (0.507s)
[271.078789] [060/133] (749s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[271.174455] Starting subtest: bad-aux-stride-y-tiled-ccs
[271.176631] Starting dynamic subtest: pipe-A-eDP-1
[271.199052] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.207546] Starting dynamic subtest: pipe-B-eDP-1
[271.228826] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.237274] Starting dynamic subtest: pipe-C-eDP-1
[271.258453] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.266575] Starting dynamic subtest: pipe-D-eDP-1
[271.288120] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.292085] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[273.418862] [061/133] (747s left) gem_huc_copy (huc-copy)
[273.474943] Starting subtest: huc-copy
[273.479782] Subtest huc-copy: SUCCESS (0.003s)
[273.601452] [062/133] (747s left) gem_mmap_gtt (big-bo-tiledx)
[273.658722] Subtest big-bo-tiledX: SKIP (0.000s)
[273.714474] [063/133] (747s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[274.086745] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[274.924578] [064/133] (746s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[275.018950] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[275.021246] Starting dynamic subtest: pipe-A-eDP-1
[275.045314] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[275.055811] Starting dynamic subtest: pipe-B-eDP-1
[275.078167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[275.086629] Starting dynamic subtest: pipe-C-eDP-1
[275.109104] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[275.117161] Starting dynamic subtest: pipe-D-eDP-1
[275.140148] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[275.144066] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[277.303951] [065/133] (743s left) gem_exec_reloc (basic-cpu-gtt)
[277.369497] Subtest basic-cpu-gtt: SKIP (0.000s)
[277.437522] [066/133] (743s left) kms_psr (fbc-psr-cursor-plane-onoff)
[277.521976] Starting subtest: fbc-psr-cursor-plane-onoff
[277.524292] Starting dynamic subtest: eDP-1
[277.528571] Dynamic subtest eDP-1: SKIP (0.000s)
[277.532590] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.002s)
[277.600725] [067/133] (743s left) prime_mmap_kms (buffer-sharing)
[277.684157] Starting subtest: buffer-sharing
[278.132368] Subtest buffer-sharing: SUCCESS (0.449s)
[278.941476] [068/133] (742s left) gem_pxp (verify-pxp-stale-ctx-execution)
[279.065577] Starting subtest: verify-pxp-stale-ctx-execution
[280.136090] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.070s)
[280.257918] [069/133] (741s left) gem_eio (in-flight-10ms)
[280.492669] Starting subtest: in-flight-10ms
[288.704444] Subtest in-flight-10ms: SUCCESS (8.210s)
[288.826596] [070/133] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[288.924541] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[288.928617] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[289.011466] [071/133] (732s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[289.064330] Subtest tiled-to-tiled: SKIP (0.000s)
[289.142521] [072/133] (732s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[289.206516] Starting subtest: single-wait-for-submit-available-signaled
[289.208800] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[289.315128] [073/133] (732s left) kms_async_flips (test-time-stamp-atomic)
[289.405926] Starting subtest: test-time-stamp-atomic
[289.789643] Starting dynamic subtest: pipe-A-eDP-1
[290.550162] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[290.940342] Starting dynamic subtest: pipe-B-eDP-1
[291.693238] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[292.075712] Starting dynamic subtest: pipe-C-eDP-1
[292.831180] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[293.193745] Starting dynamic subtest: pipe-D-eDP-1
[293.958644] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[293.960969] Subtest test-time-stamp-atomic: SUCCESS (4.553s)
[295.105063] [074/133] (726s left) kms_big_fb (linear-8bpp-rotate-90)
[295.217434] Starting subtest: linear-8bpp-rotate-90
[295.238055] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[295.363834] [075/133] (726s left) kms_joiner (invalid-modeset-force-big-joiner)
[295.463612] Starting subtest: invalid-modeset-force-big-joiner
[295.468084] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[295.526229] [076/133] (726s left) api_intel_bb (object-noreloc-keep-cache-simple)
[295.577137] Starting subtest: object-noreloc-keep-cache-simple
[295.579602] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[295.719240] [077/133] (725s left) gem_fence_thrash (bo-write-verify-none)
[295.753870] Starting subtest: bo-write-verify-none
[295.772837] Subtest bo-write-verify-none: SKIP (0.020s)
[295.837776] [078/133] (725s left) gem_mmap_offset (ptrace)
[295.887502] Starting subtest: ptrace
[295.889853] Starting dynamic subtest: smem0-wb
[295.906912] Dynamic subtest smem0-wb: SUCCESS (0.019s)
[295.917538] Starting dynamic subtest: smem0-wc
[295.926622] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[295.934635] Starting dynamic subtest: smem0-uc
[295.951266] Dynamic subtest smem0-uc: SUCCESS (0.024s)
[295.953571] Subtest ptrace: SUCCESS (0.067s)
[296.082929] [079/133] (725s left) gem_exec_basic (basic)
[296.140544] Starting subtest: basic
[296.142704] Starting dynamic subtest: rcs0-smem
[296.144801] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[296.154923] Starting dynamic subtest: bcs0-smem
[296.156867] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[296.164602] Starting dynamic subtest: vcs0-smem
[296.166152] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[296.173314] Starting dynamic subtest: vcs1-smem
[296.174875] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[296.182105] Starting dynamic subtest: vecs0-smem
[296.183725] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[296.191030] Starting dynamic subtest: ccs0-smem
[296.192603] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[296.194205] Subtest basic: SUCCESS (0.015s)
[297.981458] [080/133] (723s left) kms_flip (2x-flip-vs-fences-interruptible)
[298.094259] Starting subtest: 2x-flip-vs-fences-interruptible
[298.098309] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[298.183985] [081/133] (723s left) kms_getfb (getfb-repeated-different-handles)
[298.280648] Starting subtest: getfb-repeated-different-handles
[298.283092] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[298.389642] [082/133] (723s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[298.494687] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[305.016045] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.523s)
[305.134983] [083/133] (716s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[305.241972] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[311.948033] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.710s)
[312.054286] [084/133] (709s left) kms_psr (pr-sprite-plane-onoff)
[312.145170] Starting subtest: pr-sprite-plane-onoff
[312.149582] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[312.218473] [085/133] (709s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[312.311739] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[312.314073] Starting dynamic subtest: pipe-A-eDP-1
[318.234835] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.926s)
[318.244822] Starting dynamic subtest: pipe-B-eDP-1
[324.879102] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.643s)
[324.881474] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.572s)
[325.756429] [086/133] (696s left) gem_exec_params (rel-constants-invalid-ring)
[325.816569] Starting subtest: rel-constants-invalid-ring
[325.818946] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[325.918508] [087/133] (696s left) kms_psr (psr-cursor-mmap-cpu)
[326.021929] Starting subtest: psr-cursor-mmap-cpu
[326.024192] Starting dynamic subtest: eDP-1
[327.748167] Dynamic subtest eDP-1: SUCCESS (1.725s)
[327.750505] Subtest psr-cursor-mmap-cpu: SUCCESS (1.727s)
[328.633123] [088/133] (693s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[328.728387] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[328.732629] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[328.796310] [089/133] (693s left) kms_panel_fitting (atomic-fastset)
[328.889415] Starting subtest: atomic-fastset
[328.891706] Starting dynamic subtest: pipe-A-eDP-1
[329.051656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.164s)
[329.063769] Starting dynamic subtest: pipe-B-eDP-1
[330.278190] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.225s)
[330.290054] Starting dynamic subtest: pipe-C-eDP-1
[331.463827] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.184s)
[331.481649] Starting dynamic subtest: pipe-D-eDP-1
[332.689051] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[332.691418] Subtest atomic-fastset: SUCCESS (3.802s)
[333.850316] [090/133] (688s left) dmabuf_sync_file (import-multiple-read-write)
[333.900960] Starting subtest: import-multiple-read-write
[333.903374] Subtest import-multiple-read-write: SUCCESS (0.003s)
[333.959969] [091/133] (688s left) gem_close_race (basic-process)
[334.020836] Starting subtest: basic-process
[334.078660] Subtest basic-process: SUCCESS (0.058s)
[334.267114] [092/133] (688s left) gem_exec_schedule (u-submit-late-slice)
[334.344982] Starting subtest: u-submit-late-slice
[334.347057] Starting dynamic subtest: rcs0
[334.384369] Dynamic subtest rcs0: SUCCESS (0.047s)
[334.400591] Starting dynamic subtest: bcs0
[334.426454] Dynamic subtest bcs0: SUCCESS (0.041s)
[334.435965] Starting dynamic subtest: vcs0
[334.478127] Dynamic subtest vcs0: SUCCESS (0.050s)
[334.489297] Starting dynamic subtest: vcs1
[334.514747] Dynamic subtest vcs1: SUCCESS (0.036s)
[334.525022] Starting dynamic subtest: vecs0
[334.550575] Dynamic subtest vecs0: SUCCESS (0.035s)
[334.562055] Starting dynamic subtest: ccs0
[334.589276] Dynamic subtest ccs0: SUCCESS (0.038s)
[334.591408] Subtest u-submit-late-slice: SUCCESS (0.253s)
[335.979673] [093/133] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[336.067214] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[342.900484] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.834s)
[343.039078] [094/133] (679s left) gem_ctx_persistence (legacy-engines-hang)
[343.098932] Starting subtest: legacy-engines-hang
[343.101392] Starting dynamic subtest: render
[343.160840] Dynamic subtest render: SUCCESS (0.061s)
[343.172477] Starting dynamic subtest: bsd1
[343.254237] Dynamic subtest bsd1: SUCCESS (0.090s)
[343.266253] Starting dynamic subtest: bsd2
[343.346721] Dynamic subtest bsd2: SUCCESS (0.090s)
[343.360351] Starting dynamic subtest: blt
[343.442812] Dynamic subtest blt: SUCCESS (0.093s)
[343.456682] Starting dynamic subtest: vebox
[343.535547] Dynamic subtest vebox: SUCCESS (0.090s)
[343.537921] Subtest legacy-engines-hang: SUCCESS (0.438s)
[343.627191] [095/133] (678s left) i915_hangman (hangcheck-unterminated)
[343.697975] Starting subtest: hangcheck-unterminated
[354.869426] Subtest hangcheck-unterminated: SUCCESS (11.171s)
[355.011119] [096/133] (667s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[355.067604] Starting subtest: yf-tiled-to-vebox-x-tiled
[355.072302] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[355.272529] [097/133] (667s left) gem_exec_fence (syncobj-timeline-wait)
[355.952231] Starting subtest: syncobj-timeline-wait
[356.933228] Subtest syncobj-timeline-wait: SUCCESS (0.984s)
[357.167025] [098/133] (665s left) gem_ctx_freq (sysfs)
[357.226227] Starting subtest: sysfs
[357.228749] Starting dynamic subtest: gt0
[362.742863] Dynamic subtest gt0: SUCCESS (5.516s)
[362.755768] Starting dynamic subtest: gt1
[403.925976] Dynamic subtest gt1: SUCCESS (41.180s)
[403.928641] Subtest sysfs: SUCCESS (46.700s)
[404.068664] [099/133] (618s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[404.171872] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[404.175758] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[404.266288] [100/133] (618s left) api_intel_allocator (reopen)
[404.324407] Starting subtest: reopen
[404.326836] Subtest reopen: SUCCESS (0.005s)
[404.445236] [101/133] (618s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[404.541829] Starting subtest: fbc-psr2-primary-mmap-gtt
[404.544049] Starting dynamic subtest: eDP-1
[404.548098] Dynamic subtest eDP-1: SKIP (0.000s)
[404.551960] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[404.613957] [102/133] (618s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[404.720346] Starting subtest: coverage-vs-premult-vs-constant
[405.022450] Starting dynamic subtest: pipe-A-eDP-1
[405.611056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[405.620701] Starting dynamic subtest: pipe-D-eDP-1
[406.974495] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.362s)
[406.976762] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.256s)
[407.826395] [103/133] (614s left) gem_sync (basic-each)
[407.899826] Starting subtest: basic-each
[410.325232] Subtest basic-each: SUCCESS (2.435s)
[410.514418] [104/133] (612s left) dumb_buffer (map-valid)
[410.569027] Starting subtest: map-valid
[410.571188] Subtest map-valid: SUCCESS (0.000s)
[410.666983] [105/133] (612s left) gem_wait (write-wait)
[410.729885] Starting subtest: write-wait
[410.732331] Starting dynamic subtest: all-engines
[411.851402] Dynamic subtest all-engines: SUCCESS (1.121s)
[411.869280] Starting dynamic subtest: rcs0
[412.910351] Dynamic subtest rcs0: SUCCESS (1.056s)
[412.926332] Starting dynamic subtest: bcs0
[413.966805] Dynamic subtest bcs0: SUCCESS (1.054s)
[413.982933] Starting dynamic subtest: vcs0
[415.019526] Dynamic subtest vcs0: SUCCESS (1.051s)
[415.035342] Starting dynamic subtest: vcs1
[416.073260] Dynamic subtest vcs1: SUCCESS (1.052s)
[416.088890] Starting dynamic subtest: vecs0
[417.127224] Dynamic subtest vecs0: SUCCESS (1.051s)
[417.142829] Starting dynamic subtest: ccs0
[418.184058] Dynamic subtest ccs0: SUCCESS (1.054s)
[418.186554] Subtest write-wait: SUCCESS (7.455s)
[418.397342] [106/133] (604s left) syncobj_timeline (multi-wait-for-submit-signaled)
[418.446407] Starting subtest: multi-wait-for-submit-signaled
[418.448618] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[418.542881] [107/133] (604s left) kms_plane_multiple (2x-tiling-none)
[418.642930] Starting subtest: 2x-tiling-none
[418.646841] Subtest 2x-tiling-none: SKIP (0.000s)
[418.726943] [108/133] (604s left) gem_exec_fence (submit-chain)
[418.908443] Starting subtest: submit-chain
[418.924363] Subtest submit-chain: SUCCESS (0.020s)
[420.968122] [109/133] (602s left) syncobj_timeline (etime-single-wait-submitted)
[421.018024] Starting subtest: etime-single-wait-submitted
[421.122928] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[421.205430] [110/133] (601s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[421.311757] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[421.316185] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[421.404872] [111/133] (601s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[421.492750] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[421.496816] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[421.586498] [112/133] (601s left) kms_debugfs (display-on-read-all)
[421.695923] Starting subtest: display-on-read-all
[421.868763] Subtest display-on-read-all: SUCCESS (0.173s)
[421.983299] [113/133] (601s left) i915_power (sanity)
[422.048960] Starting subtest: sanity
[426.094748] Subtest sanity: SUCCESS (4.040s)
[427.934583] [114/133] (595s left) kms_chamelium_edid (vga-edid-read)
[428.315951] Subtest vga-edid-read: SKIP (0.000s)
[429.126108] [115/133] (594s left) kms_plane (plane-position-covered)
[429.217964] Starting subtest: plane-position-covered
[429.733242] Starting dynamic subtest: pipe-A-plane-1
[431.037814] Dynamic subtest pipe-A-plane-1: SUCCESS (1.305s)
[431.048350] Starting dynamic subtest: pipe-A-plane-2
[432.393399] Dynamic subtest pipe-A-plane-2: SUCCESS (1.354s)
[432.402741] Starting dynamic subtest: pipe-A-plane-3
[433.679094] Dynamic subtest pipe-A-plane-3: SUCCESS (1.284s)
[433.689218] Starting dynamic subtest: pipe-A-plane-4
[434.905387] Dynamic subtest pipe-A-plane-4: SUCCESS (1.228s)
[434.915742] Starting dynamic subtest: pipe-A-plane-5
[434.931073] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[436.100805] Starting dynamic subtest: pipe-B-plane-1
[437.414951] Dynamic subtest pipe-B-plane-1: SUCCESS (1.322s)
[437.424759] Starting dynamic subtest: pipe-B-plane-2
[438.719262] Dynamic subtest pipe-B-plane-2: SUCCESS (1.303s)
[438.729045] Starting dynamic subtest: pipe-B-plane-3
[439.963614] Dynamic subtest pipe-B-plane-3: SUCCESS (1.241s)
[439.972893] Starting dynamic subtest: pipe-B-plane-4
[441.288070] Dynamic subtest pipe-B-plane-4: SUCCESS (1.324s)
[441.296879] Starting dynamic subtest: pipe-B-plane-5
[441.311998] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[441.314273] Subtest plane-position-covered: SUCCESS (12.094s)
[442.087611] [116/133] (581s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[442.193519] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[449.502316] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.312s)
[449.617346] [117/133] (573s left) gem_partial_pwrite_pread (write)
[449.682061] Subtest write: SKIP (0.000s)
[449.754749] [118/133] (573s left) kms_content_protection (uevent)
[449.884049] Starting subtest: uevent
[449.888654] Subtest uevent: SKIP (0.000s)
[450.013169] [119/133] (573s left) syncobj_timeline (invalid-query-illegal-handle)
[450.074136] Starting subtest: invalid-query-illegal-handle
[450.076419] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[450.181896] [120/133] (573s left) kms_properties (get_properties-sanity-non-atomic)
[450.279492] Starting subtest: get_properties-sanity-non-atomic
[450.281780] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[450.352587] [121/133] (573s left) i915_drm_fdinfo (most-busy-check-all)
[450.392862] Starting subtest: most-busy-check-all
[450.395205] Starting dynamic subtest: rcs0
[450.402094] Dynamic subtest rcs0: SKIP (0.007s)
[450.415636] Starting dynamic subtest: bcs0
[450.419851] Dynamic subtest bcs0: SKIP (0.001s)
[450.428280] Starting dynamic subtest: vcs0
[450.432137] Dynamic subtest vcs0: SKIP (0.000s)
[450.440061] Starting dynamic subtest: vcs1
[450.443715] Dynamic subtest vcs1: SKIP (0.001s)
[450.451540] Starting dynamic subtest: vecs0
[450.454923] Dynamic subtest vecs0: SKIP (0.000s)
[450.462631] Starting dynamic subtest: ccs0
[450.466060] Dynamic subtest ccs0: SKIP (0.000s)
[450.469482] Subtest most-busy-check-all: SKIP (0.017s)
[450.504957] [122/133] (573s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[450.595328] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[450.598725] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[450.666837] [123/133] (572s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[450.767743] Starting subtest: 4-tiled-32bpp-rotate-90
[450.790602] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.022s)
[450.904739] [124/133] (572s left) gem_exec_create (forked)
[450.957189] Starting subtest: forked
[450.959344] Starting dynamic subtest: smem
[472.920057] Dynamic subtest smem: SUCCESS (21.960s)
[472.922987] Subtest forked: SUCCESS (21.962s)
[473.112096] [125/133] (550s left) syncobj_wait (invalid-reset-bad-pad)
[473.163609] Starting subtest: invalid-reset-bad-pad
[473.165999] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[473.256741] [126/133] (550s left) gem_flink_basic (bad-flink)
[473.322254] Starting subtest: bad-flink
[473.324566] Subtest bad-flink: SUCCESS (0.000s)
[473.428152] [127/133] (550s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[473.531120] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[473.535016] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[473.620298] [128/133] (550s left) kms_rotation_crc (sprite-rotation-90)
[473.712159] Starting subtest: sprite-rotation-90
[473.716667] Subtest sprite-rotation-90: SKIP (0.001s)
[473.784525] [129/133] (550s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[473.854528] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[473.938714] [130/133] (549s left) gem_mmap_gtt (cpuset-big-copy-odd)
[473.991550] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[474.061837] [131/133] (549s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[474.111697] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[474.218955] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[474.319338] [132/133] (549s left) kms_draw_crc (draw-method-pwrite)
[474.411580] Starting subtest: draw-method-pwrite
[474.413889] Starting dynamic subtest: xrgb8888-untiled
[474.975512] Dynamic subtest xrgb8888-untiled: SUCCESS (0.566s)
[474.985079] Starting dynamic subtest: rgb565-untiled
[475.430732] Dynamic subtest rgb565-untiled: SUCCESS (0.453s)
[475.440021] Starting dynamic subtest: xrgb2101010-untiled
[475.975092] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.543s)
[475.986890] Starting dynamic subtest: xbgr16161616f-untiled
[476.730771] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s)
[476.741677] Starting dynamic subtest: xrgb8888-xtiled
[478.520679] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.788s)
[478.529874] Starting dynamic subtest: rgb565-xtiled
[479.553233] Dynamic subtest rgb565-xtiled: SUCCESS (1.030s)
[479.562734] Starting dynamic subtest: xrgb2101010-xtiled
[481.275156] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.720s)
[481.284355] Starting dynamic subtest: xbgr16161616f-xtiled
[484.475507] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.199s)
[484.485162] Starting dynamic subtest: xrgb8888-4tiled
[485.553261] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.076s)
[485.562330] Starting dynamic subtest: rgb565-4tiled
[486.097974] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s)
[486.113202] Starting dynamic subtest: xrgb2101010-4tiled
[487.155095] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.054s)
[487.164422] Starting dynamic subtest: xbgr16161616f-4tiled
[490.031166] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.875s)
[490.033598] Subtest draw-method-pwrite: SUCCESS (15.622s)
[490.137341] [133/133] (533s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[490.239752] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[491.351906] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.112s)
[491.473031] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_prop_blob
results: parsing output: 2/ for test: gem_close_race
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_pm_dc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: prime_vgem
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: prime_mmap
results: parsing output: 11/ for test: gem_mmap_wc
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_lease
results: parsing output: 17/ for test: kms_atomic_interruptible
results: parsing output: 18/ for test: gem_spin_batch
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_color_pipeline
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: i915_pm_freq_mult
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_ppgtt
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_cursor_edge_walk
results: parsing output: 31/ for test: gem_mmap_wc
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_ctx_shared
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gen9_exec_parse
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_fbcon_fbt
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gem_huc_copy
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: prime_mmap_kms
results: parsing output: 67/ for test: gem_pxp
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_set_tiling_vs_blt
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_joiner
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: gem_fence_thrash
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: gem_exec_basic
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_getfb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: kms_panel_fitting
results: parsing output: 89/ for test: dmabuf_sync_file
results: parsing output: 90/ for test: gem_close_race
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: i915_hangman
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: gem_ctx_freq
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_plane_alpha_blend
results: parsing output: 102/ for test: gem_sync
results: parsing output: 103/ for test: dumb_buffer
results: parsing output: 104/ for test: gem_wait
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_plane_multiple
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_debugfs
results: parsing output: 112/ for test: i915_power
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_partial_pwrite_pread
results: parsing output: 117/ for test: kms_content_protection
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_properties
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_exec_create
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: gem_flink_basic
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_rotation_crc
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_draw_crc
results: parsing output: 132/ for test: kms_big_fb
Done.