[59.073143] Initializing watchdogs
[59.073192]   /dev/watchdog0
[59.087813] [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]
[59.092368] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.094813] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.098757] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[59.210612] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[59.215212] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[59.294139] [002/132] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[59.391540] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[59.395847] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[59.484016] [003/132] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[59.601451] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[60.279404] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.680s)
[60.425660] [004/132] (959s left) gen7_exec_parse (basic-offset)
[60.494089] Subtest basic-offset: SKIP (0.000s)
[60.565968] [005/132] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[60.683157] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[64.917561] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.236s)
[66.083467] [006/132] (953s left) tools_test (tools_test)
[66.132444] Starting subtest: tools_test
[66.189095] Subtest tools_test: SUCCESS (0.069s)
[66.245197] [007/132] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[66.335875] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[66.340178] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[67.521110] [008/132] (952s left) kms_flip (modeset-vs-vblank-race)
[67.637719] Starting subtest: modeset-vs-vblank-race
[67.640106] Starting dynamic subtest: A-eDP1
[72.304193] Dynamic subtest A-eDP1: SUCCESS (4.669s)
[72.314072] Starting dynamic subtest: B-eDP1
[77.044735] Dynamic subtest B-eDP1: SUCCESS (4.739s)
[77.058792] Starting dynamic subtest: C-eDP1
[81.753529] Dynamic subtest C-eDP1: SUCCESS (4.708s)
[81.761112] Starting dynamic subtest: D-eDP1
[86.291491] Dynamic subtest D-eDP1: SUCCESS (4.537s)
[86.293983] Subtest modeset-vs-vblank-race: SUCCESS (18.660s)
[87.456325] [009/132] (932s left) i915_pm_rpm (reg-read-ioctl)
[90.094415] Starting subtest: reg-read-ioctl
[92.493458] Subtest reg-read-ioctl: SUCCESS (2.401s)
[92.875430] [010/132] (927s left) gem_exec_balancer (hang)
[93.139103] Starting subtest: hang
[94.877346] Subtest hang: SUCCESS (1.738s)
[95.006283] [011/132] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[95.100927] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[95.105053] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[95.169961] [012/132] (924s left) perf_pmu (faulting-read)
[95.208813] Starting subtest: faulting-read
[95.211227] Starting dynamic subtest: wb
[95.213631] Dynamic subtest wb: SUCCESS (0.001s)
[95.226484] Starting dynamic subtest: wc
[95.228416] Dynamic subtest wc: SUCCESS (0.000s)
[95.236669] Starting dynamic subtest: uc
[95.238593] Dynamic subtest uc: SUCCESS (0.000s)
[95.240470] Subtest faulting-read: SUCCESS (0.002s)
[95.314636] [013/132] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[95.403645] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[95.408024] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[95.481214] [014/132] (924s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[95.861333] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[96.661515] [015/132] (923s left) gem_exec_schedule (pi-distinct-iova)
[96.846476] Starting subtest: pi-distinct-iova
[96.848556] Starting dynamic subtest: rcs0
[96.928402] Dynamic subtest rcs0: SUCCESS (0.084s)
[96.940024] Starting dynamic subtest: vcs0
[96.984888] Dynamic subtest vcs0: SUCCESS (0.056s)
[96.995898] Starting dynamic subtest: vcs1
[97.046771] Dynamic subtest vcs1: SUCCESS (0.062s)
[97.059681] Starting dynamic subtest: vecs0
[97.105817] Dynamic subtest vecs0: SUCCESS (0.057s)
[97.117719] Starting dynamic subtest: ccs0
[97.163397] Dynamic subtest ccs0: SUCCESS (0.058s)
[97.166082] Subtest pi-distinct-iova: SUCCESS (0.320s)
[99.002446] [016/132] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[99.098173] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[99.102417] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[99.206102] [017/132] (921s left) drm_read (short-buffer-block)
[99.349514] Starting subtest: short-buffer-block
[99.351915] Subtest short-buffer-block: SUCCESS (0.000s)
[99.477205] [018/132] (920s left) perf (oa-formats)
[99.596573] Starting subtest: oa-formats
[99.599559] Starting dynamic subtest: 0-rcs0
[99.611633] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[99.621070] Starting dynamic subtest: 1-vecs0
[99.634107] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[99.636406] Subtest oa-formats: SUCCESS (0.038s)
[99.683950] [019/132] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[99.790771] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[99.795755] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[99.891969] [020/132] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[99.974390] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[99.978161] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.062756] [021/132] (920s left) kms_psr (pr-basic)
[100.153822] Starting subtest: pr-basic
[100.157419] Subtest pr-basic: SKIP (0.000s)
[100.234477] [022/132] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[100.323598] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[100.327414] Starting dynamic subtest: pipe-A-eDP-1
[100.346763] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.356498] Starting dynamic subtest: pipe-B-eDP-1
[100.373649] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.380762] Starting dynamic subtest: pipe-C-eDP-1
[100.397616] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.404995] Starting dynamic subtest: pipe-D-eDP-1
[100.422180] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.425537] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[102.636560] [023/132] (917s left) kms_chamelium_edid (hdmi-mode-timings)
[103.029799] Subtest hdmi-mode-timings: SKIP (0.000s)
[103.841579] [024/132] (916s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[103.995912] Starting subtest: dp-mst-lic-type-0-hdcp14
[104.000741] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[104.116803] [025/132] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[104.220983] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[104.225468] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[104.288207] [026/132] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[104.380867] Starting subtest: primary-4-tiled-reflect-x-180
[111.314481] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.936s)
[112.536688] [027/132] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[112.636561] Starting subtest: 2x-flip-vs-panning-interruptible
[112.647638] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[112.727232] [028/132] (907s left) kms_flip (plain-flip-fb-recreate)
[112.827304] Starting subtest: plain-flip-fb-recreate
[112.829664] Starting dynamic subtest: A-eDP1
[121.733183] Dynamic subtest A-eDP1: SUCCESS (8.909s)
[121.741730] Starting dynamic subtest: B-eDP1
[130.555803] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[130.566354] Starting dynamic subtest: C-eDP1
[139.372800] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[139.380521] Starting dynamic subtest: D-eDP1
[148.204298] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[148.206304] Subtest plain-flip-fb-recreate: SUCCESS (35.384s)
[149.373266] [029/132] (871s left) gem_tiled_partial_pwrite_pread (writes)
[149.436036] Subtest writes: SKIP (0.000s)
[149.495560] [030/132] (871s left) gem_lmem_swapping (heavy-verify-random)
[149.536375] Subtest heavy-verify-random: SKIP (0.000s)
[149.584991] [031/132] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[149.681047] Starting subtest: x-tiled-64bpp-rotate-90
[149.703254] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[149.813614] [032/132] (871s left) vgem_basic (debugfs)
[149.910477] Starting subtest: debugfs
[149.912598] Subtest debugfs: SUCCESS (0.000s)
[149.964610] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[149.967862] [033/132] (870s left) kms_atomic_interruptible (legacy-setmode)
[150.052105] Starting subtest: legacy-setmode
[150.054408] Starting dynamic subtest: pipe-A-eDP-1
[156.929779] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.877s)
[156.932280] Subtest legacy-setmode: SUCCESS (6.878s)
[157.738257] [034/132] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[157.861904] Starting subtest: reject-modify-context-protection-off-2
[157.864337] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[157.987105] [035/132] (862s left) gem_exec_basic (basic)
[158.050930] Starting subtest: basic
[158.053231] Starting dynamic subtest: rcs0-smem
[158.055581] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[158.065153] Starting dynamic subtest: bcs0-smem
[158.067388] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[158.074845] Starting dynamic subtest: vcs0-smem
[158.076944] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[158.084292] Starting dynamic subtest: vcs1-smem
[158.086445] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[158.093815] Starting dynamic subtest: vecs0-smem
[158.095885] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[158.103286] Starting dynamic subtest: ccs0-smem
[158.105404] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[158.107522] Subtest basic: SUCCESS (0.011s)
[159.931173] [036/132] (861s left) api_intel_bb (offset-control)
[159.988773] Starting subtest: offset-control
[159.995063] Subtest offset-control: SUCCESS (0.007s)
[160.113159] [037/132] (860s left) kms_joiner (basic-max-non-joiner)
[160.209867] Starting subtest: basic-max-non-joiner
[160.214333] Subtest basic-max-non-joiner: SKIP (0.000s)
[160.277335] [038/132] (860s left) kms_addfb_basic (small-bo)
[160.368111] Starting subtest: small-bo
[160.370024] Subtest small-bo: SUCCESS (0.000s)
[160.474966] [039/132] (860s left) i915_query (query-topology-garbage-items)
[160.525790] Starting subtest: query-topology-garbage-items
[160.527939] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[160.621985] [040/132] (860s left) perf (gen12-group-exclusive-stream-ctx-handle)
[160.739762] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[160.770563] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.030s)
[160.813765] [041/132] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[161.890270] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[161.894267] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[161.976474] [042/132] (859s left) gem_exec_params (cliprects-invalid)
[162.028577] Starting subtest: cliprects-invalid
[162.030851] Subtest cliprects-invalid: SUCCESS (0.000s)
[162.122993] [043/132] (859s left) kms_cursor_crc (cursor-random-64x64)
[162.291157] Starting subtest: cursor-random-64x64
[162.293612] Starting dynamic subtest: pipe-A-eDP-1
[165.661275] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.367s)
[165.687257] Starting dynamic subtest: pipe-D-eDP-1
[169.645131] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.962s)
[169.647461] Subtest cursor-random-64x64: SUCCESS (7.352s)
[170.499974] [044/132] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[170.600341] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[170.604237] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[170.699055] [045/132] (850s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[170.808739] Starting subtest: 4-tiled-16bpp-rotate-180
[172.055379] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.248s)
[172.178952] [046/132] (849s left) dumb_buffer (create-valid-dumb)
[172.227328] Starting subtest: create-valid-dumb
[172.229263] Subtest create-valid-dumb: SUCCESS (0.000s)
[172.321434] [047/132] (849s left) gem_softpin (zero)
[172.367461] Starting subtest: zero
[172.373702] Subtest zero: SUCCESS (0.005s)
[172.493837] [048/132] (849s left) gem_blits (basic)
[172.551683] Starting subtest: basic
[173.876893] Subtest basic: SUCCESS (1.323s)
[173.990325] [049/132] (847s left) gem_busy (close-race)
[174.059810] Starting subtest: close-race
[197.909179] Subtest close-race: SUCCESS (23.847s)
[198.260097] [050/132] (823s left) syncobj_eventfd (binary-wait-before-signal)
[198.356946] Starting subtest: binary-wait-before-signal
[198.387838] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[198.464837] [051/132] (823s left) prime_mmap (test_errors)
[198.529168] Starting subtest: test_errors
[198.531478] Starting dynamic subtest: test_errors-smem
[198.626610] Dynamic subtest test_errors-smem: SUCCESS (0.097s)
[198.629282] Subtest test_errors: SUCCESS (0.098s)
[198.725813] [052/132] (822s left) gem_ctx_persistence (heartbeat-stop)
[198.788688] Starting subtest: heartbeat-stop
[198.793775] Subtest heartbeat-stop: SKIP (0.000s)
[198.888705] [053/132] (822s left) gem_ctx_param (invalid-get-ringsize)
[198.939996] Starting subtest: invalid-get-ringsize
[198.942296] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[199.054967] [054/132] (822s left) i915_query (query-topology-matches-eu-total)
[199.100916] Starting subtest: query-topology-matches-eu-total
[199.103087] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[199.210753] [055/132] (822s left) kms_cursor_edge_walk (64x64-right-edge)
[199.307821] Starting subtest: 64x64-right-edge
[199.309681] Starting dynamic subtest: pipe-A-eDP-1
[202.758331] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s)
[202.768075] Starting dynamic subtest: pipe-D-eDP-1
[205.914271] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.156s)
[205.916720] Subtest 64x64-right-edge: SUCCESS (6.605s)
[206.789235] [056/132] (815s left) kms_plane (plane-position-covered)
[206.884274] Starting subtest: plane-position-covered
[207.423118] Starting dynamic subtest: pipe-A-plane-1
[208.665308] Dynamic subtest pipe-A-plane-1: SUCCESS (1.240s)
[208.675607] Starting dynamic subtest: pipe-A-plane-2
[209.965334] Dynamic subtest pipe-A-plane-2: SUCCESS (1.300s)
[209.975457] Starting dynamic subtest: pipe-A-plane-3
[211.211660] Dynamic subtest pipe-A-plane-3: SUCCESS (1.247s)
[211.221927] Starting dynamic subtest: pipe-A-plane-4
[212.443038] Dynamic subtest pipe-A-plane-4: SUCCESS (1.231s)
[212.453065] Starting dynamic subtest: pipe-A-plane-5
[212.473062] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[213.601627] Starting dynamic subtest: pipe-B-plane-1
[214.842591] Dynamic subtest pipe-B-plane-1: SUCCESS (1.246s)
[214.852666] Starting dynamic subtest: pipe-B-plane-2
[216.151912] Dynamic subtest pipe-B-plane-2: SUCCESS (1.310s)
[216.162278] Starting dynamic subtest: pipe-B-plane-3
[217.423343] Dynamic subtest pipe-B-plane-3: SUCCESS (1.270s)
[217.435380] Starting dynamic subtest: pipe-B-plane-4
[218.707759] Dynamic subtest pipe-B-plane-4: SUCCESS (1.282s)
[218.720885] Starting dynamic subtest: pipe-B-plane-5
[218.732542] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[218.734808] Subtest plane-position-covered: SUCCESS (11.846s)
[219.507877] [057/132] (802s left) kms_frontbuffer_tracking (psr-suspend)
[219.605961] Starting subtest: psr-suspend
[258.350230] Subtest psr-suspend: SUCCESS (8.142s)
[258.474585] [058/132] (763s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[258.588439] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[258.592445] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[258.685752] [059/132] (763s left) gem_exec_schedule (fairslice)
[258.758478] Starting subtest: fairslice
[258.760563] Starting dynamic subtest: rcs0
[260.769434] Dynamic subtest rcs0: SUCCESS (2.017s)
[260.781008] Starting dynamic subtest: bcs0
[262.787963] Dynamic subtest bcs0: SUCCESS (2.015s)
[262.799340] Starting dynamic subtest: vcs0
[264.806447] Dynamic subtest vcs0: SUCCESS (2.017s)
[264.816661] Starting dynamic subtest: vcs1
[266.827854] Dynamic subtest vcs1: SUCCESS (2.019s)
[266.838249] Starting dynamic subtest: vecs0
[268.844767] Dynamic subtest vecs0: SUCCESS (2.016s)
[268.855267] Starting dynamic subtest: ccs0
[270.863075] Dynamic subtest ccs0: SUCCESS (2.018s)
[270.865320] Subtest fairslice: SUCCESS (12.106s)
[271.163051] [060/132] (750s left) sw_sync (alloc_fence_invalid_timeline)
[271.202006] Starting subtest: alloc_fence_invalid_timeline
[271.204365] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[271.266536] [061/132] (750s left) gem_exec_whisper (basic-fds-forked)
[271.330079] Starting subtest: basic-fds-forked
[295.209640] Subtest basic-fds-forked: SUCCESS (23.871s)
[295.396977] [062/132] (726s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[295.500348] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[295.504638] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[295.584696] [063/132] (726s left) gem_vm_create (execbuf)
[295.636171] Starting subtest: execbuf
[295.641957] Subtest execbuf: SUCCESS (0.006s)
[295.770234] [064/132] (726s left) kms_cursor_crc (cursor-onscreen-256x85)
[296.017911] Starting subtest: cursor-onscreen-256x85
[296.061326] Subtest cursor-onscreen-256x85: SKIP (0.039s)
[296.232791] [065/132] (725s left) kms_plane_alpha_blend (coverage-7efc)
[296.336135] Starting subtest: coverage-7efc
[296.629514] Starting dynamic subtest: pipe-A-eDP-1
[297.219971] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[297.245001] Starting dynamic subtest: pipe-D-eDP-1
[298.635963] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.399s)
[298.638516] Subtest coverage-7efc: SUCCESS (2.302s)
[299.443401] [066/132] (722s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[299.541186] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[299.543325] Starting dynamic subtest: pipe-A
[299.560366] Dynamic subtest pipe-A: SKIP (0.016s)
[299.570269] Starting dynamic subtest: pipe-B
[299.590767] Dynamic subtest pipe-B: SKIP (0.029s)
[299.600579] Starting dynamic subtest: pipe-C
[299.620882] Dynamic subtest pipe-C: SKIP (0.029s)
[299.630826] Starting dynamic subtest: pipe-D
[299.649819] Dynamic subtest pipe-D: SKIP (0.029s)
[299.653561] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.106s)
[299.772185] [067/132] (722s left) vgem_basic (busy-fence)
[299.819136] Starting subtest: busy-fence
[299.821482] Subtest busy-fence: SUCCESS (0.000s)
[299.879329] [068/132] (722s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[299.962316] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[299.991541] Starting dynamic subtest: pipe-A-plane-0
[300.413249] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[300.423174] Starting dynamic subtest: pipe-A-plane-3
[300.657854] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[300.667250] Starting dynamic subtest: pipe-A-plane-5
[300.670986] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[301.721035] Starting dynamic subtest: pipe-B-plane-0
[302.145836] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[302.163320] Starting dynamic subtest: pipe-B-plane-3
[302.412739] Dynamic subtest pipe-B-plane-3: SUCCESS (0.264s)
[302.425512] Starting dynamic subtest: pipe-B-plane-5
[302.430160] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[302.721693] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.760s)
[303.611623] [069/132] (718s left) kms_addfb_basic (invalid-set-prop-any)
[303.675722] Starting subtest: invalid-set-prop-any
[303.678063] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[303.802803] [070/132] (718s left) kms_addfb_basic (size-max)
[303.898230] Starting subtest: size-max
[303.900504] Subtest size-max: SUCCESS (0.000s)
[304.001569] [071/132] (718s left) kms_addfb_basic (bad-pitch-128)
[304.059668] Starting subtest: bad-pitch-128
[304.061885] Subtest bad-pitch-128: SUCCESS (0.000s)
[304.184460] [072/132] (718s left) syncobj_timeline (single-wait-available-submitted)
[304.232431] Starting subtest: single-wait-available-submitted
[304.234646] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[304.322687] [073/132] (718s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[304.427885] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[305.396334] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.968s)
[305.532877] [074/132] (717s left) gem_pread (exhaustion)
[305.596378] Subtest exhaustion: SKIP (0.000s)
[305.662753] [075/132] (716s left) kms_frontbuffer_tracking (psr-1p-rte)
[305.763427] Starting subtest: psr-1p-rte
[311.199393] Subtest psr-1p-rte: SUCCESS (5.438s)
[311.325508] [076/132] (711s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[311.449479] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[329.150023] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.697s)
[329.944973] [077/132] (692s left) api_intel_allocator (fork-simple-once)
[330.013296] Starting subtest: fork-simple-once
[330.028352] Subtest fork-simple-once: SUCCESS (0.017s)
[330.145974] [078/132] (692s left) gem_set_tiling_vs_pwrite
[330.274573] [079/132] (692s left) kms_pm_backlight (brightness-with-dpms)
[330.367030] Starting subtest: brightness-with-dpms
[330.415797] Starting dynamic subtest: eDP-1
[332.839703] Dynamic subtest eDP-1: SUCCESS (2.421s)
[332.842130] Subtest brightness-with-dpms: SUCCESS (2.472s)
[333.694058] [080/132] (689s left) kms_lease (lease-invalid-crtc)
[333.795430] Starting subtest: lease-invalid-crtc
[333.797680] Starting dynamic subtest: pipe-A-eDP-1
[333.799899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[333.810174] Starting dynamic subtest: pipe-B-eDP-1
[333.812305] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[333.823539] Starting dynamic subtest: pipe-C-eDP-1
[333.825678] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[333.834853] Starting dynamic subtest: pipe-D-eDP-1
[333.836948] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[333.839021] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[333.876687] [081/132] (689s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[333.976657] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[333.981157] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[334.073464] [082/132] (688s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[334.174459] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[341.093733] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.920s)
[341.217783] [083/132] (681s left) kms_dp_linktrain_fallback (dp-fallback)
[341.317535] Starting subtest: dp-fallback
[341.323956] Subtest dp-fallback: SKIP (0.000s)
[341.392308] [084/132] (681s left) kms_vblank (ts-continuation-idle)
[341.485061] Starting subtest: ts-continuation-idle
[341.487390] Starting dynamic subtest: pipe-A-eDP-1
[341.906762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[341.927590] Starting dynamic subtest: pipe-D-eDP-1
[343.009308] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.101s)
[343.011651] Subtest ts-continuation-idle: SUCCESS (1.525s)
[343.889383] [085/132] (679s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[343.984134] Starting subtest: fbc-psr-cursor-mmap-gtt
[343.986501] Starting dynamic subtest: eDP-1
[343.990876] Dynamic subtest eDP-1: SKIP (0.000s)
[343.995643] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[344.075532] [086/132] (679s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[344.192808] Starting subtest: cursor-vs-flip-varying-size
[375.508581] Subtest cursor-vs-flip-varying-size: SUCCESS (31.313s)
[376.318704] [087/132] (646s left) i915_drm_fdinfo (busy-check-all)
[376.370506] Starting subtest: busy-check-all
[376.372790] Starting dynamic subtest: rcs0
[376.377193] Dynamic subtest rcs0: SKIP (0.004s)
[376.394803] Starting dynamic subtest: bcs0
[376.399398] Dynamic subtest bcs0: SKIP (0.000s)
[376.409271] Starting dynamic subtest: vcs0
[376.413167] Dynamic subtest vcs0: SKIP (0.000s)
[376.422454] Starting dynamic subtest: vcs1
[376.426357] Dynamic subtest vcs1: SKIP (0.000s)
[376.435490] Starting dynamic subtest: vecs0
[376.439443] Dynamic subtest vecs0: SKIP (0.000s)
[376.449058] Starting dynamic subtest: ccs0
[376.453119] Dynamic subtest ccs0: SKIP (0.000s)
[376.457189] Subtest busy-check-all: SKIP (0.009s)
[376.497743] [088/132] (646s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[376.592770] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[376.594971] Starting dynamic subtest: pipe-A-eDP-1
[376.614458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[376.624330] Starting dynamic subtest: pipe-B-eDP-1
[376.644822] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[376.654748] Starting dynamic subtest: pipe-C-eDP-1
[376.674251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[376.683559] Starting dynamic subtest: pipe-D-eDP-1
[376.703259] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[376.705485] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[378.867488] [089/132] (644s left) prime_busy (before-wait)
[378.932803] Starting subtest: before-wait
[378.935210] Starting dynamic subtest: rcs0
[378.965793] Dynamic subtest rcs0: SUCCESS (0.032s)
[378.977538] Starting dynamic subtest: bcs0
[379.016563] Dynamic subtest bcs0: SUCCESS (0.050s)
[379.027117] Starting dynamic subtest: vcs0
[379.056664] Dynamic subtest vcs0: SUCCESS (0.039s)
[379.066485] Starting dynamic subtest: vcs1
[379.097775] Dynamic subtest vcs1: SUCCESS (0.040s)
[379.107560] Starting dynamic subtest: vecs0
[379.138460] Dynamic subtest vecs0: SUCCESS (0.040s)
[379.148235] Starting dynamic subtest: ccs0
[379.179904] Dynamic subtest ccs0: SUCCESS (0.041s)
[379.288524] Subtest before-wait: SUCCESS (0.356s)
[379.378749] [090/132] (643s left) gem_ppgtt (blt-vs-render-ctx0)
[379.439326] Starting subtest: blt-vs-render-ctx0
[412.204289] Subtest blt-vs-render-ctx0: SUCCESS (32.758s)
[412.333020] [091/132] (611s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[412.498613] Starting subtest: cursorB-vs-flipB-atomic
[412.503034] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[412.646383] [092/132] (610s left) gem_exec_reloc (basic-wc-read-active)
[412.701362] Subtest basic-wc-read-active: SKIP (0.000s)
[412.776196] [093/132] (610s left) gem_exec_fence (syncobj-import)
[413.226598] Starting subtest: syncobj-import
[413.232290] Subtest syncobj-import: SUCCESS (0.005s)
[414.598640] [094/132] (608s left) kms_psr (fbc-psr2-sprite-blt)
[414.692063] Starting subtest: fbc-psr2-sprite-blt
[414.694335] Starting dynamic subtest: eDP-1
[414.698321] Dynamic subtest eDP-1: SKIP (0.000s)
[414.702362] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[414.765991] [095/132] (608s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[414.864391] Starting subtest: plane-lut1d-post-ctm3x4
[414.998957] Starting dynamic subtest: pipe-A-plane-0
[415.187741] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[415.197880] Starting dynamic subtest: pipe-A-plane-1
[415.321155] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s)
[415.331373] Starting dynamic subtest: pipe-A-plane-2
[415.457642] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[416.707905] Starting dynamic subtest: pipe-B-plane-0
[416.845595] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[416.855772] Starting dynamic subtest: pipe-B-plane-1
[417.009723] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[417.020608] Starting dynamic subtest: pipe-B-plane-2
[417.165941] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[418.397637] Starting dynamic subtest: pipe-C-plane-0
[418.533193] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[418.543141] Starting dynamic subtest: pipe-C-plane-1
[418.688576] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[418.698526] Starting dynamic subtest: pipe-C-plane-2
[418.822019] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[420.052069] Starting dynamic subtest: pipe-D-plane-0
[420.187966] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[420.198370] Starting dynamic subtest: pipe-D-plane-1
[420.333142] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[420.343583] Starting dynamic subtest: pipe-D-plane-2
[420.466129] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[420.750837] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.888s)
[421.597693] [096/132] (601s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[421.668045] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[421.672785] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[421.856857] [097/132] (601s left) kms_big_fb (linear-8bpp-rotate-180)
[421.963131] Starting subtest: linear-8bpp-rotate-180
[423.211517] Subtest linear-8bpp-rotate-180: SUCCESS (1.248s)
[423.344834] [098/132] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[423.430977] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[423.434354] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[423.538457] [099/132] (600s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[423.642155] Starting subtest: extended-modeset-hang-oldfb-with-reset
[423.643991] Starting dynamic subtest: pipe-A
[435.577784] Dynamic subtest pipe-A: SUCCESS (11.932s)
[435.591152] Starting dynamic subtest: pipe-D
[447.840013] Dynamic subtest pipe-D: SUCCESS (12.257s)
[447.842653] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.195s)
[448.657740] [100/132] (575s left) gem_exec_schedule (timeslicing)
[448.748101] Starting subtest: timeslicing
[448.750322] Starting dynamic subtest: rcs0
[448.762243] Dynamic subtest rcs0: SUCCESS (0.021s)
[448.776026] Starting dynamic subtest: bcs0
[448.781135] Dynamic subtest bcs0: SUCCESS (0.019s)
[448.792004] Starting dynamic subtest: vcs0
[448.802571] Dynamic subtest vcs0: SUCCESS (0.020s)
[448.812795] Starting dynamic subtest: vcs1
[448.822390] Dynamic subtest vcs1: SUCCESS (0.019s)
[448.833375] Starting dynamic subtest: vecs0
[448.840703] Dynamic subtest vecs0: SUCCESS (0.018s)
[448.851052] Starting dynamic subtest: ccs0
[448.859459] Dynamic subtest ccs0: SUCCESS (0.018s)
[448.861774] Subtest timeslicing: SUCCESS (0.120s)
[450.595500] [101/132] (573s left) kms_chamelium_color (ctm-0-25)
[450.692496] Subtest ctm-0-25: SKIP (0.000s)
[450.739380] [102/132] (573s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[450.853492] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[450.855700] Starting dynamic subtest: pipe-A-eDP-1
[450.939117] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s)
[450.956868] Starting dynamic subtest: pipe-B-eDP-1
[452.124015] Dynamic subtest pipe-B-eDP-1: SKIP (1.182s)
[452.128130] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.275s)
[453.319371] [103/132] (570s left) gem_mmap (short-mmap)
[453.373989] Subtest short-mmap: SKIP (0.000s)
[453.437938] [104/132] (570s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[453.496504] Starting subtest: multi-wait-available-unsubmitted-submitted
[453.498691] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[453.588687] [105/132] (570s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[453.680374] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[453.684235] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[453.792462] [106/132] (570s left) kms_getfb (getfb2-accept-nv12)
[453.878272] Starting subtest: getfb2-accept-nv12
[453.880606] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[453.979806] [107/132] (570s left) syncobj_timeline (invalid-signal-zero-handles)
[454.031019] Starting subtest: invalid-signal-zero-handles
[454.033199] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[454.146031] [108/132] (569s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[454.238166] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[454.242090] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[454.322977] [109/132] (569s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[454.419222] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[454.421089] Starting dynamic subtest: pipe-A-eDP-1
[454.467534] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[454.477735] Starting dynamic subtest: pipe-B-eDP-1
[454.522402] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[454.535078] Starting dynamic subtest: pipe-C-eDP-1
[454.580956] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[454.591385] Starting dynamic subtest: pipe-D-eDP-1
[454.637302] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[454.640977] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[456.580149] [110/132] (567s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[456.677325] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[456.689200] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[456.782907] [111/132] (567s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[456.880086] Starting subtest: async-flip-with-page-flip-events-tiled
[457.259883] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[460.052291] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[460.062911] Starting dynamic subtest: pipe-A-eDP-1-4
[462.238492] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[462.249945] Starting dynamic subtest: pipe-A-eDP-1-4
[464.248125] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[464.261210] Starting dynamic subtest: pipe-A-eDP-1-x
[466.427287] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[466.801677] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[469.582847] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[469.593302] Starting dynamic subtest: pipe-B-eDP-1-4
[471.769822] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[471.787793] Starting dynamic subtest: pipe-B-eDP-1-4
[473.778843] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.007s)
[473.789223] Starting dynamic subtest: pipe-B-eDP-1-x
[475.970083] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[476.358121] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[479.118277] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[479.133035] Starting dynamic subtest: pipe-C-eDP-1-4
[481.303829] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s)
[481.316203] Starting dynamic subtest: pipe-C-eDP-1-4
[483.314218] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[483.324876] Starting dynamic subtest: pipe-C-eDP-1-x
[485.492505] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[485.881924] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[488.646239] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[488.657902] Starting dynamic subtest: pipe-D-eDP-1-4
[490.808920] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.162s)
[490.819562] Starting dynamic subtest: pipe-D-eDP-1-4
[492.819677] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[492.833214] Starting dynamic subtest: pipe-D-eDP-1-x
[494.997743] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[495.000333] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.117s)
[496.150538] [112/132] (528s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[496.259145] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[496.263603] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[496.374848] [113/132] (527s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[496.436617] Starting subtest: etime-multi-wait-for-submit-submitted
[496.542552] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[496.633369] [114/132] (527s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[498.670481] Starting subtest: modeset-non-lpsp-stress-no-wait
[498.727958] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.052s)
[499.060175] [115/132] (525s left) gem_exec_params (sol-reset-invalid)
[499.117350] Starting subtest: sol-reset-invalid
[499.122675] Subtest sol-reset-invalid: SUCCESS (0.003s)
[500.581384] [116/132] (523s left) gem_mmap_gtt (cpuset-big-copy)
[500.639435] Subtest cpuset-big-copy: SKIP (0.000s)
[500.699942] [117/132] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[500.795867] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[508.404980] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.613s)
[508.520530] [118/132] (515s left) kms_psr (psr2-sprite-plane-onoff)
[508.623082] Starting subtest: psr2-sprite-plane-onoff
[508.625267] Starting dynamic subtest: eDP-1
[510.353057] Dynamic subtest eDP-1: SUCCESS (1.730s)
[510.355409] Subtest psr2-sprite-plane-onoff: SUCCESS (1.731s)
[511.217003] [119/132] (513s left) kms_dsc (dsc-with-output-formats)
[511.305654] Starting subtest: dsc-with-output-formats
[511.327077] Subtest dsc-with-output-formats: SKIP (0.000s)
[511.378905] [120/132] (513s left) gen3_mixed_blits
[511.490645] [121/132] (513s left) gem_mmap_offset (clear-via-pagefault)
[511.547931] Starting subtest: clear-via-pagefault
[511.549868] Starting dynamic subtest: smem0
[547.476586] Dynamic subtest smem0: SUCCESS (35.923s)
[547.479195] Subtest clear-via-pagefault: SUCCESS (35.926s)
[547.569487] [122/132] (477s left) gem_eio (reset-stress)
[547.802653] Starting subtest: reset-stress
[547.805558] Starting dynamic subtest: render
[552.724703] Dynamic subtest render: SUCCESS (4.922s)
[552.740958] Starting dynamic subtest: bsd1
[571.042066] Dynamic subtest bsd1: SUCCESS (18.314s)
[571.060311] Starting dynamic subtest: bsd2
[589.038898] Dynamic subtest bsd2: SUCCESS (17.996s)
[589.055557] Starting dynamic subtest: blt
[589.059711] Dynamic subtest blt: SKIP (0.000s)
[589.069488] Starting dynamic subtest: vebox
[607.049183] Dynamic subtest vebox: SUCCESS (18.007s)
[607.051439] Subtest reset-stress: SUCCESS (59.242s)
[608.521677] [123/132] (416s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[608.578181] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[608.580354] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[608.684734] [124/132] (416s left) kms_vblank (query-busy-hang)
[608.779153] Starting subtest: query-busy-hang
[608.781370] Starting dynamic subtest: pipe-A-eDP-1
[610.655644] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[610.671814] Starting dynamic subtest: pipe-D-eDP-1
[613.274692] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.615s)
[613.277035] Subtest query-busy-hang: SUCCESS (4.494s)
[614.071525] [125/132] (410s left) kms_psr (fbc-pr-cursor-plane-onoff)
[614.163384] Starting subtest: fbc-pr-cursor-plane-onoff
[614.167960] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[614.240061] [126/132] (410s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[614.337051] Starting subtest: psr-1p-primscrn-cur-indfb-move
[621.711204] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.378s)
[621.843449] [127/132] (403s left) tools_test (sysfs_l3_parity)
[621.894555] Starting subtest: sysfs_l3_parity
[621.969007] Subtest sysfs_l3_parity: SKIP (0.084s)
[622.034983] [128/132] (402s left) kms_vblank (crtc-id)
[622.127214] Starting subtest: crtc-id
[622.129474] Starting dynamic subtest: pipe-A-eDP-1
[622.569180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[622.585657] Starting dynamic subtest: pipe-D-eDP-1
[623.725725] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.151s)
[623.727636] Subtest crtc-id: SUCCESS (1.597s)
[624.571985] [129/132] (400s left) gem_ctx_engines (independent)
[624.634464] Starting subtest: independent
[624.636740] Starting dynamic subtest: rcs0
[624.798006] Dynamic subtest rcs0: SUCCESS (0.162s)
[624.808695] Starting dynamic subtest: bcs0
[624.973547] Dynamic subtest bcs0: SUCCESS (0.173s)
[624.987086] Starting dynamic subtest: vcs0
[625.164456] Dynamic subtest vcs0: SUCCESS (0.190s)
[625.178568] Starting dynamic subtest: vcs1
[625.340956] Dynamic subtest vcs1: SUCCESS (0.176s)
[625.355188] Starting dynamic subtest: vecs0
[625.489509] Dynamic subtest vecs0: SUCCESS (0.148s)
[625.502648] Starting dynamic subtest: ccs0
[625.673296] Dynamic subtest ccs0: SUCCESS (0.183s)
[625.685494] Starting dynamic subtest: all-engines
[626.437793] Dynamic subtest all-engines: SUCCESS (0.763s)
[626.440529] Subtest independent: SUCCESS (1.803s)
[626.677146] [130/132] (398s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[626.780992] Starting subtest: flip-vs-dpms-on-nop-interruptible
[626.783324] Starting dynamic subtest: A-eDP1
[628.659325] Dynamic subtest A-eDP1: SUCCESS (1.877s)
[628.673158] Starting dynamic subtest: B-eDP1
[630.492917] Dynamic subtest B-eDP1: SUCCESS (1.831s)
[630.507445] Starting dynamic subtest: C-eDP1
[632.317283] Dynamic subtest C-eDP1: SUCCESS (1.822s)
[632.328281] Starting dynamic subtest: D-eDP1
[634.147521] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[634.153032] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.372s)
[635.339023] [131/132] (389s left) kms_plane_lowres (tiling-x)
[635.433331] Starting subtest: tiling-x
[635.435776] Starting dynamic subtest: pipe-A-eDP-1
[635.441839] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[635.730136] Starting dynamic subtest: pipe-B-eDP-1
[635.734881] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[635.746516] Starting dynamic subtest: pipe-C-eDP-1
[635.751399] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[635.763828] Starting dynamic subtest: pipe-D-eDP-1
[635.768134] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[635.772410] Subtest tiling-x: SKIP (0.294s)
[636.562666] [132/132] (388s left) i915_pm_freq_api (freq-reset)
[636.614133] Starting subtest: freq-reset
[636.616394] Starting dynamic subtest: gt0
[636.806387] Dynamic subtest gt0: SUCCESS (0.189s)
[636.817353] Starting dynamic subtest: gt1
[636.977502] Dynamic subtest gt1: SUCCESS (0.170s)
[636.980310] Subtest freq-reset: SUCCESS (0.362s)
[637.049785] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_pm_rpm
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: drm_read
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: kms_atomic_interruptible
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: gem_exec_basic
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_joiner
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: dumb_buffer
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: gem_blits
results: parsing output: 48/ for test: gem_busy
results: parsing output: 49/ for test: syncobj_eventfd
results: parsing output: 50/ for test: prime_mmap
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: gem_ctx_param
results: parsing output: 53/ for test: i915_query
results: parsing output: 54/ for test: kms_cursor_edge_walk
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_vm_create
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_plane_alpha_blend
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_pread
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: api_intel_allocator
results: parsing output: 77/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 78/ for test: kms_pm_backlight
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_dp_linktrain_fallback
results: parsing output: 83/ for test: kms_vblank
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: prime_busy
results: parsing output: 89/ for test: gem_ppgtt
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_color_pipeline
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_busy
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_chamelium_color
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: gem_mmap
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_getfb
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_dsc
results: parsing output: 119/ for test: gen3_mixed_blits
results: parsing output: 120/ for test: gem_mmap_offset
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: tools_test
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_ctx_engines
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_plane_lowres
results: parsing output: 131/ for test: i915_pm_freq_api
Done.