[56.580447] Initializing watchdogs
[56.580603]   /dev/watchdog0
[56.596035] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.600708] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.602948] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.606229] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[56.746306] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[56.750217] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[56.872439] [002/132] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[56.970432] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[56.974666] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[57.084663] [003/132] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[57.199901] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[57.875668] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[58.042869] [004/132] (959s left) gen7_exec_parse (basic-offset)
[58.112589] Subtest basic-offset: SKIP (0.000s)
[58.183943] [005/132] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[58.292477] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[62.614058] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.337s)
[63.802072] [006/132] (953s left) tools_test (tools_test)
[63.854313] Starting subtest: tools_test
[63.909850] Subtest tools_test: SUCCESS (0.071s)
[63.971697] [007/132] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[64.056332] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[64.061012] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[65.218406] [008/132] (952s left) kms_flip (modeset-vs-vblank-race)
[65.312182] Starting subtest: modeset-vs-vblank-race
[65.314575] Starting dynamic subtest: A-eDP1
[70.045196] Dynamic subtest A-eDP1: SUCCESS (4.738s)
[70.059720] Starting dynamic subtest: B-eDP1
[74.773841] Dynamic subtest B-eDP1: SUCCESS (4.730s)
[74.782711] Starting dynamic subtest: C-eDP1
[79.392876] Dynamic subtest C-eDP1: SUCCESS (4.619s)
[79.404716] Starting dynamic subtest: D-eDP1
[84.029186] Dynamic subtest D-eDP1: SUCCESS (4.634s)
[84.034179] Subtest modeset-vs-vblank-race: SUCCESS (18.730s)
[85.190801] [009/132] (932s left) i915_pm_rpm (reg-read-ioctl)
[87.038778] Starting subtest: reg-read-ioctl
[89.339945] Subtest reg-read-ioctl: SUCCESS (2.302s)
[89.715233] [010/132] (927s left) gem_exec_balancer (hang)
[89.991679] Starting subtest: hang
[91.926471] Subtest hang: SUCCESS (1.934s)
[92.047013] [011/132] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[92.147567] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[92.151759] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[92.220544] [012/132] (925s left) perf_pmu (faulting-read)
[92.254708] Starting subtest: faulting-read
[92.256975] Starting dynamic subtest: wb
[92.259163] Dynamic subtest wb: SUCCESS (0.001s)
[92.270278] Starting dynamic subtest: wc
[92.272449] Dynamic subtest wc: SUCCESS (0.000s)
[92.281603] Starting dynamic subtest: uc
[92.283766] Dynamic subtest uc: SUCCESS (0.000s)
[92.285966] Subtest faulting-read: SUCCESS (0.002s)
[92.372180] [013/132] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[92.473517] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[92.477991] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[92.573274] [014/132] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[92.989418] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[93.821434] [015/132] (923s left) gem_exec_schedule (pi-distinct-iova)
[94.004817] Starting subtest: pi-distinct-iova
[94.006752] Starting dynamic subtest: rcs0
[94.078806] Dynamic subtest rcs0: SUCCESS (0.077s)
[94.087025] Starting dynamic subtest: vcs0
[94.146138] Dynamic subtest vcs0: SUCCESS (0.066s)
[94.155958] Starting dynamic subtest: vcs1
[94.203920] Dynamic subtest vcs1: SUCCESS (0.057s)
[94.214257] Starting dynamic subtest: vecs0
[94.264830] Dynamic subtest vecs0: SUCCESS (0.061s)
[94.275213] Starting dynamic subtest: ccs0
[94.330248] Dynamic subtest ccs0: SUCCESS (0.065s)
[94.332893] Subtest pi-distinct-iova: SUCCESS (0.328s)
[95.980861] [016/132] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[96.078220] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[96.082207] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[96.171258] [017/132] (921s left) drm_read (short-buffer-block)
[96.334376] Starting subtest: short-buffer-block
[96.336795] Subtest short-buffer-block: SUCCESS (0.000s)
[96.444081] [018/132] (921s left) perf (oa-formats)
[96.566413] Starting subtest: oa-formats
[96.568588] Starting dynamic subtest: 0-rcs0
[96.580201] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[96.589509] Starting dynamic subtest: 1-vcs0
[96.601086] Dynamic subtest 1-vcs0: SUCCESS (0.021s)
[96.603371] Subtest oa-formats: SUCCESS (0.036s)
[96.649447] [019/132] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[96.747451] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[96.752089] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[96.844217] [020/132] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[96.938188] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[96.941850] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[97.038463] [021/132] (920s left) kms_psr (pr-basic)
[97.127282] Starting subtest: pr-basic
[97.130986] Subtest pr-basic: SKIP (0.000s)
[97.209313] [022/132] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[97.307914] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[97.309858] Starting dynamic subtest: pipe-A-eDP-1
[97.328738] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[97.336992] Starting dynamic subtest: pipe-B-eDP-1
[97.354761] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.361929] Starting dynamic subtest: pipe-C-eDP-1
[97.379587] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.387129] Starting dynamic subtest: pipe-D-eDP-1
[97.404881] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[97.408457] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[99.610832] [023/132] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[99.994221] Subtest hdmi-mode-timings: SKIP (0.000s)
[100.817911] [024/132] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[100.952051] Starting subtest: dp-mst-lic-type-0-hdcp14
[100.956516] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[101.097900] [025/132] (917s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[101.203186] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[101.207302] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[101.267191] [026/132] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[101.356898] Starting subtest: primary-4-tiled-reflect-x-180
[108.322493] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.967s)
[109.503096] [027/132] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[109.601456] Starting subtest: 2x-flip-vs-panning-interruptible
[109.613490] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[109.695831] [028/132] (908s left) kms_flip (plain-flip-fb-recreate)
[109.803345] Starting subtest: plain-flip-fb-recreate
[109.805790] Starting dynamic subtest: A-eDP1
[118.700888] Dynamic subtest A-eDP1: SUCCESS (8.897s)
[118.713345] Starting dynamic subtest: B-eDP1
[127.538863] Dynamic subtest B-eDP1: SUCCESS (8.836s)
[127.548929] Starting dynamic subtest: C-eDP1
[136.362056] Dynamic subtest C-eDP1: SUCCESS (8.821s)
[136.371594] Starting dynamic subtest: D-eDP1
[145.199901] Dynamic subtest D-eDP1: SUCCESS (8.836s)
[145.204581] Subtest plain-flip-fb-recreate: SUCCESS (35.402s)
[146.378207] [029/132] (871s left) gem_tiled_partial_pwrite_pread (writes)
[146.440050] Subtest writes: SKIP (0.000s)
[146.495740] [030/132] (871s left) gem_lmem_swapping (heavy-verify-random)
[146.543185] Subtest heavy-verify-random: SKIP (0.000s)
[146.588120] [031/132] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[146.683173] Starting subtest: x-tiled-64bpp-rotate-90
[146.702721] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[146.815170] [032/132] (871s left) vgem_basic (debugfs)
[146.927373] Starting subtest: debugfs
[146.929590] Subtest debugfs: SUCCESS (0.001s)
[146.980682] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[146.984243] [033/132] (871s left) kms_atomic_interruptible (legacy-setmode)
[147.081832] Starting subtest: legacy-setmode
[147.084134] Starting dynamic subtest: pipe-A-eDP-1
[154.012244] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.931s)
[154.014651] Subtest legacy-setmode: SUCCESS (6.932s)
[154.887789] [034/132] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[155.006514] Starting subtest: reject-modify-context-protection-off-2
[155.008911] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[155.139536] [035/132] (863s left) gem_exec_basic (basic)
[155.200046] Starting subtest: basic
[155.202371] Starting dynamic subtest: rcs0-smem
[155.204578] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[155.213249] Starting dynamic subtest: bcs0-smem
[155.215357] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[155.223161] Starting dynamic subtest: vcs0-smem
[155.225298] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[155.233177] Starting dynamic subtest: vcs1-smem
[155.235337] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[155.243446] Starting dynamic subtest: vecs0-smem
[155.245721] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[155.253766] Starting dynamic subtest: ccs0-smem
[155.255970] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[155.258176] Subtest basic: SUCCESS (0.011s)
[156.925770] [036/132] (861s left) api_intel_bb (offset-control)
[156.986446] Starting subtest: offset-control
[156.992404] Subtest offset-control: SUCCESS (0.008s)
[157.124967] [037/132] (861s left) kms_joiner (basic-max-non-joiner)
[157.225131] Starting subtest: basic-max-non-joiner
[157.228993] Subtest basic-max-non-joiner: SKIP (0.000s)
[157.289727] [038/132] (861s left) kms_addfb_basic (small-bo)
[157.386693] Starting subtest: small-bo
[157.388976] Subtest small-bo: SUCCESS (0.000s)
[157.487014] [039/132] (861s left) i915_query (query-topology-garbage-items)
[157.541732] Starting subtest: query-topology-garbage-items
[157.543960] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[157.623518] [040/132] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[157.728079] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[157.752966] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[157.792753] [041/132] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[158.946475] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[158.950556] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[159.048653] [042/132] (859s left) gem_exec_params (cliprects-invalid)
[159.114044] Starting subtest: cliprects-invalid
[159.116331] Subtest cliprects-invalid: SUCCESS (0.000s)
[159.229448] [043/132] (859s left) kms_cursor_crc (cursor-random-64x64)
[159.399847] Starting subtest: cursor-random-64x64
[159.402080] Starting dynamic subtest: pipe-A-eDP-1
[162.730071] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.326s)
[162.756836] Starting dynamic subtest: pipe-D-eDP-1
[166.690878] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.940s)
[166.693261] Subtest cursor-random-64x64: SUCCESS (7.292s)
[167.541884] [044/132] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[167.637977] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[167.642162] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[167.734095] [045/132] (851s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[167.838767] Starting subtest: 4-tiled-16bpp-rotate-180
[169.206145] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.368s)
[169.327574] [046/132] (849s left) dumb_buffer (create-valid-dumb)
[169.381988] Starting subtest: create-valid-dumb
[169.383997] Subtest create-valid-dumb: SUCCESS (0.000s)
[169.484292] [047/132] (849s left) gem_softpin (zero)
[169.543719] Starting subtest: zero
[169.547667] Subtest zero: SUCCESS (0.004s)
[169.660353] [048/132] (849s left) gem_blits (basic)
[169.729128] Starting subtest: basic
[171.144701] Subtest basic: SUCCESS (1.416s)
[171.261230] [049/132] (847s left) gem_busy (close-race)
[171.312792] Starting subtest: close-race
[196.850245] Subtest close-race: SUCCESS (25.535s)
[197.199851] [050/132] (821s left) syncobj_eventfd (binary-wait-before-signal)
[197.287580] Starting subtest: binary-wait-before-signal
[197.318529] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[197.409400] [051/132] (821s left) prime_mmap (test_errors)
[197.466516] Starting subtest: test_errors
[197.468904] Starting dynamic subtest: test_errors-smem
[197.572520] Dynamic subtest test_errors-smem: SUCCESS (0.105s)
[197.575712] Subtest test_errors: SUCCESS (0.106s)
[197.658857] [052/132] (821s left) gem_ctx_persistence (heartbeat-stop)
[197.718799] Starting subtest: heartbeat-stop
[197.723443] Subtest heartbeat-stop: SKIP (0.000s)
[197.848203] [053/132] (821s left) gem_ctx_param (invalid-get-ringsize)
[197.895971] Starting subtest: invalid-get-ringsize
[197.898310] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[198.000820] [054/132] (821s left) i915_query (query-topology-matches-eu-total)
[198.044988] Starting subtest: query-topology-matches-eu-total
[198.047330] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[198.145113] [055/132] (821s left) kms_cursor_edge_walk (64x64-right-edge)
[198.243303] Starting subtest: 64x64-right-edge
[198.245575] Starting dynamic subtest: pipe-A-eDP-1
[201.690204] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[201.702256] Starting dynamic subtest: pipe-D-eDP-1
[204.816231] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[204.818637] Subtest 64x64-right-edge: SUCCESS (6.573s)
[205.630403] [056/132] (813s left) kms_plane (plane-position-covered)
[205.730073] Starting subtest: plane-position-covered
[206.263084] Starting dynamic subtest: pipe-A-plane-1
[207.591661] Dynamic subtest pipe-A-plane-1: SUCCESS (1.328s)
[207.601617] Starting dynamic subtest: pipe-A-plane-2
[208.847784] Dynamic subtest pipe-A-plane-2: SUCCESS (1.255s)
[208.857971] Starting dynamic subtest: pipe-A-plane-3
[210.140752] Dynamic subtest pipe-A-plane-3: SUCCESS (1.293s)
[210.150153] Starting dynamic subtest: pipe-A-plane-4
[211.427554] Dynamic subtest pipe-A-plane-4: SUCCESS (1.286s)
[211.437735] Starting dynamic subtest: pipe-A-plane-5
[211.453179] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[212.672152] Starting dynamic subtest: pipe-B-plane-1
[213.965434] Dynamic subtest pipe-B-plane-1: SUCCESS (1.301s)
[213.979181] Starting dynamic subtest: pipe-B-plane-2
[215.259652] Dynamic subtest pipe-B-plane-2: SUCCESS (1.291s)
[215.269368] Starting dynamic subtest: pipe-B-plane-3
[216.563210] Dynamic subtest pipe-B-plane-3: SUCCESS (1.303s)
[216.572933] Starting dynamic subtest: pipe-B-plane-4
[217.796717] Dynamic subtest pipe-B-plane-4: SUCCESS (1.231s)
[217.807809] Starting dynamic subtest: pipe-B-plane-5
[217.819234] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[217.821553] Subtest plane-position-covered: SUCCESS (12.090s)
[218.597274] [057/132] (800s left) kms_frontbuffer_tracking (psr-suspend)
[218.703891] Starting subtest: psr-suspend
[256.817247] Subtest psr-suspend: SUCCESS (8.767s)
[256.952897] [058/132] (762s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[257.053065] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[257.056953] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[257.161003] [059/132] (762s left) gem_exec_schedule (fairslice)
[257.236380] Starting subtest: fairslice
[257.238700] Starting dynamic subtest: rcs0
[259.271102] Dynamic subtest rcs0: SUCCESS (2.058s)
[259.282726] Starting dynamic subtest: bcs0
[261.302042] Dynamic subtest bcs0: SUCCESS (2.047s)
[261.312800] Starting dynamic subtest: vcs0
[263.333044] Dynamic subtest vcs0: SUCCESS (2.042s)
[263.343582] Starting dynamic subtest: vcs1
[265.357516] Dynamic subtest vcs1: SUCCESS (2.034s)
[265.368307] Starting dynamic subtest: vecs0
[267.376329] Dynamic subtest vecs0: SUCCESS (2.027s)
[267.390434] Starting dynamic subtest: ccs0
[269.394772] Dynamic subtest ccs0: SUCCESS (2.026s)
[269.396949] Subtest fairslice: SUCCESS (12.243s)
[269.695842] [060/132] (749s left) sw_sync (alloc_fence_invalid_timeline)
[269.734292] Starting subtest: alloc_fence_invalid_timeline
[269.736409] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[269.807706] [061/132] (749s left) gem_exec_whisper (basic-fds-forked)
[269.873624] Starting subtest: basic-fds-forked
[293.961709] Subtest basic-fds-forked: SUCCESS (24.102s)
[294.162337] [062/132] (725s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[294.272795] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[294.276949] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[294.368692] [063/132] (725s left) gem_vm_create (execbuf)
[294.420419] Starting subtest: execbuf
[294.429380] Subtest execbuf: SUCCESS (0.009s)
[294.555385] [064/132] (725s left) kms_cursor_crc (cursor-onscreen-256x85)
[294.826794] Starting subtest: cursor-onscreen-256x85
[294.872055] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[295.063484] [065/132] (724s left) kms_plane_alpha_blend (coverage-7efc)
[295.162278] Starting subtest: coverage-7efc
[295.464338] Starting dynamic subtest: pipe-A-eDP-1
[296.051232] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[296.079949] Starting dynamic subtest: pipe-D-eDP-1
[297.401643] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[297.403963] Subtest coverage-7efc: SUCCESS (2.237s)
[298.243335] [066/132] (721s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[298.329269] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[298.331585] Starting dynamic subtest: pipe-A
[298.349449] Dynamic subtest pipe-A: SKIP (0.018s)
[298.360861] Starting dynamic subtest: pipe-B
[298.383574] Dynamic subtest pipe-B: SKIP (0.032s)
[298.393725] Starting dynamic subtest: pipe-C
[298.416504] Dynamic subtest pipe-C: SKIP (0.033s)
[298.426254] Starting dynamic subtest: pipe-D
[298.448181] Dynamic subtest pipe-D: SKIP (0.031s)
[298.451846] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.116s)
[298.535232] [067/132] (721s left) vgem_basic (busy-fence)
[298.582992] Starting subtest: busy-fence
[298.585219] Subtest busy-fence: SUCCESS (0.000s)
[298.639852] [068/132] (721s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[298.746288] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[298.777416] Starting dynamic subtest: pipe-A-plane-0
[299.198644] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[299.208658] Starting dynamic subtest: pipe-A-plane-3
[299.454287] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[299.464457] Starting dynamic subtest: pipe-A-plane-5
[299.468185] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[300.537816] Starting dynamic subtest: pipe-B-plane-0
[301.007887] Dynamic subtest pipe-B-plane-0: SUCCESS (0.478s)
[301.017957] Starting dynamic subtest: pipe-B-plane-3
[301.262635] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[301.273462] Starting dynamic subtest: pipe-B-plane-5
[301.277968] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[301.585530] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.839s)
[302.426753] [069/132] (717s left) kms_addfb_basic (invalid-set-prop-any)
[302.492185] Starting subtest: invalid-set-prop-any
[302.494094] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[302.623377] [070/132] (717s left) kms_addfb_basic (size-max)
[302.716290] Starting subtest: size-max
[302.718633] Subtest size-max: SUCCESS (0.000s)
[302.807927] [071/132] (717s left) kms_addfb_basic (bad-pitch-128)
[302.867357] Starting subtest: bad-pitch-128
[302.869165] Subtest bad-pitch-128: SUCCESS (0.000s)
[302.993956] [072/132] (717s left) syncobj_timeline (single-wait-available-submitted)
[303.054229] Starting subtest: single-wait-available-submitted
[303.056083] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[303.171296] [073/132] (716s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[303.271966] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[304.362279] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.091s)
[304.514509] [074/132] (715s left) gem_pread (exhaustion)
[304.567278] Subtest exhaustion: SKIP (0.000s)
[304.625013] [075/132] (715s left) kms_frontbuffer_tracking (psr-1p-rte)
[304.715972] Starting subtest: psr-1p-rte
[310.124580] Subtest psr-1p-rte: SUCCESS (5.410s)
[310.265766] [076/132] (709s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[310.385613] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[327.721422] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.338s)
[328.516067] [077/132] (691s left) api_intel_allocator (fork-simple-once)
[328.577868] Starting subtest: fork-simple-once
[328.592724] Subtest fork-simple-once: SUCCESS (0.018s)
[328.722644] [078/132] (691s left) gem_set_tiling_vs_pwrite
[328.853327] [079/132] (691s left) kms_pm_backlight (brightness-with-dpms)
[328.942332] Starting subtest: brightness-with-dpms
[328.993335] Starting dynamic subtest: eDP-1
[331.422566] Dynamic subtest eDP-1: SUCCESS (2.428s)
[331.424989] Subtest brightness-with-dpms: SUCCESS (2.482s)
[332.286222] [080/132] (688s left) kms_lease (lease-invalid-crtc)
[332.387831] Starting subtest: lease-invalid-crtc
[332.390089] Starting dynamic subtest: pipe-A-eDP-1
[332.392429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[332.402938] Starting dynamic subtest: pipe-B-eDP-1
[332.405206] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[332.414780] Starting dynamic subtest: pipe-C-eDP-1
[332.417107] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[332.429201] Starting dynamic subtest: pipe-D-eDP-1
[332.431274] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[332.433365] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[332.472347] [081/132] (687s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[332.571993] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[332.576142] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[332.669336] [082/132] (687s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[332.775505] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[339.714542] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.941s)
[339.853687] [083/132] (680s left) kms_dp_linktrain_fallback (dp-fallback)
[339.964444] Starting subtest: dp-fallback
[339.970607] Subtest dp-fallback: SKIP (0.000s)
[340.036266] [084/132] (680s left) kms_vblank (ts-continuation-idle)
[340.132337] Starting subtest: ts-continuation-idle
[340.134247] Starting dynamic subtest: pipe-A-eDP-1
[340.531369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[340.546980] Starting dynamic subtest: pipe-D-eDP-1
[341.601797] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.068s)
[341.604041] Subtest ts-continuation-idle: SUCCESS (1.470s)
[342.461551] [085/132] (678s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[342.556481] Starting subtest: fbc-psr-cursor-mmap-gtt
[342.558363] Starting dynamic subtest: eDP-1
[342.562294] Dynamic subtest eDP-1: SKIP (0.000s)
[342.566353] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[342.642365] [086/132] (677s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[342.769264] Starting subtest: cursor-vs-flip-varying-size
[374.012757] Subtest cursor-vs-flip-varying-size: SUCCESS (31.238s)
[374.904856] [087/132] (645s left) i915_drm_fdinfo (busy-check-all)
[374.946506] Starting subtest: busy-check-all
[374.948755] Starting dynamic subtest: rcs0
[374.953370] Dynamic subtest rcs0: SKIP (0.003s)
[374.963751] Starting dynamic subtest: bcs0
[374.968322] Dynamic subtest bcs0: SKIP (0.000s)
[374.978335] Starting dynamic subtest: vcs0
[374.982743] Dynamic subtest vcs0: SKIP (0.000s)
[374.992674] Starting dynamic subtest: vcs1
[374.997100] Dynamic subtest vcs1: SKIP (0.000s)
[375.007036] Starting dynamic subtest: vecs0
[375.011417] Dynamic subtest vecs0: SKIP (0.000s)
[375.021243] Starting dynamic subtest: ccs0
[375.025683] Dynamic subtest ccs0: SKIP (0.000s)
[375.030084] Subtest busy-check-all: SKIP (0.009s)
[375.068720] [088/132] (645s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[375.166374] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[375.168714] Starting dynamic subtest: pipe-A-eDP-1
[375.189122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[375.204942] Starting dynamic subtest: pipe-B-eDP-1
[375.225394] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[375.236070] Starting dynamic subtest: pipe-C-eDP-1
[375.255902] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[375.265972] Starting dynamic subtest: pipe-D-eDP-1
[375.286101] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[375.288336] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[377.484224] [089/132] (643s left) prime_busy (before-wait)
[377.536329] Starting subtest: before-wait
[377.538682] Starting dynamic subtest: rcs0
[377.566847] Dynamic subtest rcs0: SUCCESS (0.030s)
[377.578762] Starting dynamic subtest: bcs0
[377.607240] Dynamic subtest bcs0: SUCCESS (0.040s)
[377.617318] Starting dynamic subtest: vcs0
[377.648582] Dynamic subtest vcs0: SUCCESS (0.041s)
[377.658631] Starting dynamic subtest: vcs1
[377.690423] Dynamic subtest vcs1: SUCCESS (0.041s)
[377.700635] Starting dynamic subtest: vecs0
[377.732213] Dynamic subtest vecs0: SUCCESS (0.041s)
[377.742538] Starting dynamic subtest: ccs0
[377.772804] Dynamic subtest ccs0: SUCCESS (0.040s)
[377.880804] Subtest before-wait: SUCCESS (0.345s)
[377.958990] [090/132] (642s left) gem_ppgtt (blt-vs-render-ctx0)
[378.011270] Starting subtest: blt-vs-render-ctx0
[410.767815] Subtest blt-vs-render-ctx0: SUCCESS (32.754s)
[410.888276] [091/132] (609s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[411.055479] Starting subtest: cursorB-vs-flipB-atomic
[411.059812] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[411.209018] [092/132] (609s left) gem_exec_reloc (basic-wc-read-active)
[411.268877] Subtest basic-wc-read-active: SKIP (0.000s)
[411.352512] [093/132] (609s left) gem_exec_fence (syncobj-import)
[411.822546] Starting subtest: syncobj-import
[411.828386] Subtest syncobj-import: SUCCESS (0.005s)
[413.353504] [094/132] (607s left) kms_psr (fbc-psr2-sprite-blt)
[413.438472] Starting subtest: fbc-psr2-sprite-blt
[413.440657] Starting dynamic subtest: eDP-1
[413.444694] Dynamic subtest eDP-1: SKIP (0.000s)
[413.448755] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[413.517629] [095/132] (607s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[413.605260] Starting subtest: plane-lut1d-post-ctm3x4
[413.752151] Starting dynamic subtest: pipe-A-plane-0
[413.929476] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[413.940552] Starting dynamic subtest: pipe-A-plane-1
[414.073875] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[414.084524] Starting dynamic subtest: pipe-A-plane-2
[414.262604] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[415.493685] Starting dynamic subtest: pipe-B-plane-0
[415.661177] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[415.675379] Starting dynamic subtest: pipe-B-plane-1
[415.839326] Dynamic subtest pipe-B-plane-1: SUCCESS (0.176s)
[415.850355] Starting dynamic subtest: pipe-B-plane-2
[416.005047] Dynamic subtest pipe-B-plane-2: SUCCESS (0.164s)
[417.180043] Starting dynamic subtest: pipe-C-plane-0
[417.304782] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[417.316124] Starting dynamic subtest: pipe-C-plane-1
[417.449217] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[417.459792] Starting dynamic subtest: pipe-C-plane-2
[417.615715] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[418.821271] Starting dynamic subtest: pipe-D-plane-0
[418.958119] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[418.968550] Starting dynamic subtest: pipe-D-plane-1
[419.123029] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[419.133762] Starting dynamic subtest: pipe-D-plane-2
[419.278469] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[419.577364] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.972s)
[420.381323] [096/132] (600s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[420.442127] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[420.447194] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[420.630641] [097/132] (600s left) kms_big_fb (linear-8bpp-rotate-180)
[420.731014] Starting subtest: linear-8bpp-rotate-180
[421.955915] Subtest linear-8bpp-rotate-180: SUCCESS (1.225s)
[422.090656] [098/132] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[422.187113] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[422.190820] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[422.279813] [099/132] (598s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[422.375725] Starting subtest: extended-modeset-hang-oldfb-with-reset
[422.377595] Starting dynamic subtest: pipe-A
[434.368708] Dynamic subtest pipe-A: SUCCESS (11.993s)
[434.380829] Starting dynamic subtest: pipe-D
[446.642797] Dynamic subtest pipe-D: SUCCESS (12.273s)
[446.644693] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.270s)
[447.524565] [100/132] (573s left) gem_exec_schedule (timeslicing)
[447.605845] Starting subtest: timeslicing
[447.608032] Starting dynamic subtest: rcs0
[447.615642] Dynamic subtest rcs0: SUCCESS (0.021s)
[447.626948] Starting dynamic subtest: bcs0
[447.636284] Dynamic subtest bcs0: SUCCESS (0.020s)
[447.646550] Starting dynamic subtest: vcs0
[447.657110] Dynamic subtest vcs0: SUCCESS (0.020s)
[447.667219] Starting dynamic subtest: vcs1
[447.677529] Dynamic subtest vcs1: SUCCESS (0.020s)
[447.687796] Starting dynamic subtest: vecs0
[447.697938] Dynamic subtest vecs0: SUCCESS (0.020s)
[447.707980] Starting dynamic subtest: ccs0
[447.719225] Dynamic subtest ccs0: SUCCESS (0.021s)
[447.721397] Subtest timeslicing: SUCCESS (0.125s)
[449.337446] [101/132] (571s left) kms_chamelium_color (ctm-0-25)
[449.429211] Subtest ctm-0-25: SKIP (0.000s)
[449.474453] [102/132] (571s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[449.573074] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[449.575819] Starting dynamic subtest: pipe-A-eDP-1
[449.668440] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[449.684168] Starting dynamic subtest: pipe-B-eDP-1
[450.788360] Dynamic subtest pipe-B-eDP-1: SKIP (1.118s)
[450.792992] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.221s)
[452.091958] [103/132] (569s left) gem_mmap (short-mmap)
[452.155116] Subtest short-mmap: SKIP (0.000s)
[452.218994] [104/132] (569s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[452.269196] Starting subtest: multi-wait-available-unsubmitted-submitted
[452.271419] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[452.368653] [105/132] (569s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[452.466442] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[452.470891] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[452.585660] [106/132] (568s left) kms_getfb (getfb2-accept-nv12)
[452.675380] Starting subtest: getfb2-accept-nv12
[452.677215] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[452.775890] [107/132] (568s left) syncobj_timeline (invalid-signal-zero-handles)
[452.846018] Starting subtest: invalid-signal-zero-handles
[452.848291] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[452.934948] [108/132] (568s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[453.023276] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[453.026952] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[453.096944] [109/132] (568s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[453.182097] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[453.184091] Starting dynamic subtest: pipe-A-eDP-1
[453.233122] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[453.245306] Starting dynamic subtest: pipe-B-eDP-1
[453.293192] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[453.304367] Starting dynamic subtest: pipe-C-eDP-1
[453.351096] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[453.361523] Starting dynamic subtest: pipe-D-eDP-1
[453.407603] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[453.411275] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[455.451257] [110/132] (566s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[455.544270] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[455.553045] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[455.648615] [111/132] (566s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[455.746206] Starting subtest: async-flip-with-page-flip-events-tiled
[456.138470] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[458.926647] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[458.939586] Starting dynamic subtest: pipe-A-eDP-1-4
[461.107490] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[461.118772] Starting dynamic subtest: pipe-A-eDP-1-4
[463.110422] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[463.123742] Starting dynamic subtest: pipe-A-eDP-1-x
[465.288720] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[465.655857] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[468.452314] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.805s)
[468.466033] Starting dynamic subtest: pipe-B-eDP-1-4
[470.636995] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[470.647862] Starting dynamic subtest: pipe-B-eDP-1-4
[472.646617] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[472.660060] Starting dynamic subtest: pipe-B-eDP-1-x
[474.836875] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[475.205984] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[477.979214] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[477.991399] Starting dynamic subtest: pipe-C-eDP-1-4
[480.153529] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[480.166943] Starting dynamic subtest: pipe-C-eDP-1-4
[482.163479] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[482.177040] Starting dynamic subtest: pipe-C-eDP-1-x
[484.365125] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.200s)
[484.731269] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[487.505934] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[487.517489] Starting dynamic subtest: pipe-D-eDP-1-4
[489.680684] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[489.692626] Starting dynamic subtest: pipe-D-eDP-1-4
[491.690627] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[491.701371] Starting dynamic subtest: pipe-D-eDP-1-x
[493.870202] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[493.872910] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.127s)
[495.101025] [112/132] (526s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[495.197647] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[495.201877] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[495.302362] [113/132] (526s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[495.359509] Starting subtest: etime-multi-wait-for-submit-submitted
[495.460553] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[495.563092] [114/132] (526s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[497.491924] Starting subtest: modeset-non-lpsp-stress-no-wait
[497.549492] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.060s)
[497.876433] [115/132] (524s left) gem_exec_params (sol-reset-invalid)
[497.932900] Starting subtest: sol-reset-invalid
[497.938444] Subtest sol-reset-invalid: SUCCESS (0.003s)
[499.368981] [116/132] (522s left) gem_mmap_gtt (cpuset-big-copy)
[499.439065] Subtest cpuset-big-copy: SKIP (0.000s)
[499.509551] [117/132] (522s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[499.600947] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[507.336290] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.738s)
[507.449627] [118/132] (514s left) kms_psr (psr2-sprite-plane-onoff)
[507.548196] Starting subtest: psr2-sprite-plane-onoff
[507.550468] Starting dynamic subtest: eDP-1
[509.318314] Dynamic subtest eDP-1: SUCCESS (1.767s)
[509.320459] Subtest psr2-sprite-plane-onoff: SUCCESS (1.768s)
[510.171300] [119/132] (511s left) kms_dsc (dsc-with-output-formats)
[510.266346] Starting subtest: dsc-with-output-formats
[510.288412] Subtest dsc-with-output-formats: SKIP (0.000s)
[510.342424] [120/132] (511s left) gen3_mixed_blits
[510.470798] [121/132] (511s left) gem_mmap_offset (clear-via-pagefault)
[510.519618] Starting subtest: clear-via-pagefault
[510.521543] Starting dynamic subtest: smem0
[549.463451] Dynamic subtest smem0: SUCCESS (38.938s)
[549.465991] Subtest clear-via-pagefault: SUCCESS (38.939s)
[549.571303] [122/132] (472s left) gem_eio (reset-stress)
[549.822954] Starting subtest: reset-stress
[549.825347] Starting dynamic subtest: render
[554.858724] Dynamic subtest render: SUCCESS (5.032s)
[554.876477] Starting dynamic subtest: bsd1
[572.834973] Dynamic subtest bsd1: SUCCESS (17.975s)
[572.851664] Starting dynamic subtest: bsd2
[590.838019] Dynamic subtest bsd2: SUCCESS (18.004s)
[590.854827] Starting dynamic subtest: blt
[590.859066] Dynamic subtest blt: SKIP (0.000s)
[590.869641] Starting dynamic subtest: vebox
[608.786074] Dynamic subtest vebox: SUCCESS (17.948s)
[608.788453] Subtest reset-stress: SUCCESS (58.963s)
[610.325433] [123/132] (411s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[610.381213] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[610.383405] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[610.483653] [124/132] (411s left) kms_vblank (query-busy-hang)
[610.570509] Starting subtest: query-busy-hang
[610.572413] Starting dynamic subtest: pipe-A-eDP-1
[612.457564] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[612.474391] Starting dynamic subtest: pipe-D-eDP-1
[615.018687] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[615.020639] Subtest query-busy-hang: SUCCESS (4.449s)
[615.821860] [125/132] (406s left) kms_psr (fbc-pr-cursor-plane-onoff)
[615.910319] Starting subtest: fbc-pr-cursor-plane-onoff
[615.914756] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[615.985659] [126/132] (406s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[616.087558] Starting subtest: psr-1p-primscrn-cur-indfb-move
[623.508247] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.426s)
[623.661595] [127/132] (398s left) tools_test (sysfs_l3_parity)
[623.713190] Starting subtest: sysfs_l3_parity
[623.795006] Subtest sysfs_l3_parity: SKIP (0.091s)
[623.849756] [128/132] (398s left) kms_vblank (crtc-id)
[623.943115] Starting subtest: crtc-id
[623.944962] Starting dynamic subtest: pipe-A-eDP-1
[624.402242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[624.417516] Starting dynamic subtest: pipe-D-eDP-1
[625.510034] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.104s)
[625.512299] Subtest crtc-id: SUCCESS (1.568s)
[626.335650] [129/132] (396s left) gem_ctx_engines (independent)
[626.395523] Starting subtest: independent
[626.397748] Starting dynamic subtest: rcs0
[626.558810] Dynamic subtest rcs0: SUCCESS (0.160s)
[626.571721] Starting dynamic subtest: bcs0
[626.713879] Dynamic subtest bcs0: SUCCESS (0.155s)
[626.726074] Starting dynamic subtest: vcs0
[626.882106] Dynamic subtest vcs0: SUCCESS (0.167s)
[626.894434] Starting dynamic subtest: vcs1
[627.039992] Dynamic subtest vcs1: SUCCESS (0.158s)
[627.051538] Starting dynamic subtest: vecs0
[627.224568] Dynamic subtest vecs0: SUCCESS (0.183s)
[627.238435] Starting dynamic subtest: ccs0
[627.414907] Dynamic subtest ccs0: SUCCESS (0.190s)
[627.426378] Starting dynamic subtest: all-engines
[628.121649] Dynamic subtest all-engines: SUCCESS (0.706s)
[628.124158] Subtest independent: SUCCESS (1.725s)
[628.491755] [130/132] (394s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[628.577591] Starting subtest: flip-vs-dpms-on-nop-interruptible
[628.579840] Starting dynamic subtest: A-eDP1
[630.435339] Dynamic subtest A-eDP1: SUCCESS (1.855s)
[630.452480] Starting dynamic subtest: B-eDP1
[632.258670] Dynamic subtest B-eDP1: SUCCESS (1.820s)
[632.274881] Starting dynamic subtest: C-eDP1
[634.084987] Dynamic subtest C-eDP1: SUCCESS (1.825s)
[634.098481] Starting dynamic subtest: D-eDP1
[635.915319] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[635.920432] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.342s)
[637.099443] [131/132] (385s left) kms_plane_lowres (tiling-x)
[637.198814] Starting subtest: tiling-x
[637.200980] Starting dynamic subtest: pipe-A-eDP-1
[637.205461] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[637.494196] Starting dynamic subtest: pipe-B-eDP-1
[637.498801] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[637.509473] Starting dynamic subtest: pipe-C-eDP-1
[637.514023] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[637.524436] Starting dynamic subtest: pipe-D-eDP-1
[637.528783] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[637.533204] Subtest tiling-x: SKIP (0.294s)
[638.337652] [132/132] (384s left) i915_pm_freq_api (freq-reset)
[638.402255] Starting subtest: freq-reset
[638.406422] Starting dynamic subtest: gt0
[638.587798] Dynamic subtest gt0: SUCCESS (0.191s)
[638.600248] Starting dynamic subtest: gt1
[638.762571] Dynamic subtest gt1: SUCCESS (0.172s)
[638.765081] Subtest freq-reset: SUCCESS (0.365s)
[638.837143] 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.