[59.340554] Initializing watchdogs
[59.340687]   /dev/watchdog0
[59.354947] [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.359514] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.361759] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.365135] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[59.497280] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[59.501232] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[59.581642] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[59.674634] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[59.678925] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[59.757369] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[59.870578] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[60.551247] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.680s)
[60.716298] [004/133] (959s left) gen7_exec_parse (basic-offset)
[60.778794] Subtest basic-offset: SKIP (0.000s)
[60.823823] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[60.911515] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[65.215517] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.295s)
[66.331200] [006/133] (953s left) tools_test (tools_test)
[66.381112] Starting subtest: tools_test
[66.430796] Subtest tools_test: SUCCESS (0.064s)
[66.491715] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[66.590032] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[66.594620] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[67.776090] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[67.923541] Starting subtest: modeset-vs-vblank-race
[67.926060] Starting dynamic subtest: A-eDP1
[72.608416] Dynamic subtest A-eDP1: SUCCESS (4.679s)
[72.618444] Starting dynamic subtest: B-eDP1
[77.356259] Dynamic subtest B-eDP1: SUCCESS (4.744s)
[77.369846] Starting dynamic subtest: C-eDP1
[82.060405] Dynamic subtest C-eDP1: SUCCESS (4.701s)
[82.067618] Starting dynamic subtest: D-eDP1
[86.622876] Dynamic subtest D-eDP1: SUCCESS (4.560s)
[86.627966] Subtest modeset-vs-vblank-race: SUCCESS (18.694s)
[87.782328] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[90.115632] Starting subtest: reg-read-ioctl
[92.506327] Subtest reg-read-ioctl: SUCCESS (2.392s)
[92.893225] [010/133] (927s left) gem_exec_balancer (hang)
[93.141767] Starting subtest: hang
[94.933892] Subtest hang: SUCCESS (1.790s)
[95.052025] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[95.148406] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[95.152792] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[95.220242] [012/133] (925s left) perf_pmu (faulting-read)
[95.263623] Starting subtest: faulting-read
[95.265852] Starting dynamic subtest: wb
[95.268130] Dynamic subtest wb: SUCCESS (0.001s)
[95.276216] Starting dynamic subtest: wc
[95.278124] Dynamic subtest wc: SUCCESS (0.000s)
[95.284982] Starting dynamic subtest: uc
[95.287068] Dynamic subtest uc: SUCCESS (0.000s)
[95.288925] Subtest faulting-read: SUCCESS (0.002s)
[95.371791] [013/133] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[95.477942] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[95.482462] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[95.579649] [014/133] (924s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[95.950563] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[96.786533] [015/133] (923s left) gem_exec_schedule (pi-distinct-iova)
[96.985829] Starting subtest: pi-distinct-iova
[96.987991] Starting dynamic subtest: rcs0
[97.057851] Dynamic subtest rcs0: SUCCESS (0.073s)
[97.068483] Starting dynamic subtest: vcs0
[97.116819] Dynamic subtest vcs0: SUCCESS (0.059s)
[97.125443] Starting dynamic subtest: vcs1
[97.189569] Dynamic subtest vcs1: SUCCESS (0.071s)
[97.201327] Starting dynamic subtest: vecs0
[97.249872] Dynamic subtest vecs0: SUCCESS (0.061s)
[97.260906] Starting dynamic subtest: ccs0
[97.315944] Dynamic subtest ccs0: SUCCESS (0.065s)
[97.318352] Subtest pi-distinct-iova: SUCCESS (0.332s)
[98.993769] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[99.097405] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[99.101311] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[99.188209] [017/133] (921s left) drm_read (short-buffer-block)
[99.335860] Starting subtest: short-buffer-block
[99.338397] Subtest short-buffer-block: SUCCESS (0.000s)
[99.448816] [018/133] (921s left) perf (oa-formats)
[99.573147] Starting subtest: oa-formats
[99.575387] Starting dynamic subtest: 0-rcs0
[99.588834] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[99.596881] Starting dynamic subtest: 1-vecs0
[99.610390] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[99.612590] Subtest oa-formats: SUCCESS (0.038s)
[99.655595] [019/133] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[99.764793] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[99.769092] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[99.844753] [020/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[99.943094] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[99.947061] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.027287] [021/133] (920s left) kms_psr (pr-basic)
[100.124906] Starting subtest: pr-basic
[100.128260] Subtest pr-basic: SKIP (0.000s)
[100.194089] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[100.287584] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[100.289498] Starting dynamic subtest: pipe-A-eDP-1
[100.307461] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.320713] Starting dynamic subtest: pipe-B-eDP-1
[100.338999] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.348994] Starting dynamic subtest: pipe-C-eDP-1
[100.366219] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.373070] Starting dynamic subtest: pipe-D-eDP-1
[100.390780] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.394223] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[102.578772] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[102.959913] Subtest hdmi-mode-timings: SKIP (0.000s)
[103.795548] [024/133] (916s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[103.926906] Starting subtest: dp-mst-lic-type-0-hdcp14
[103.932032] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[104.054512] [025/133] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[104.153756] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[104.157639] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[104.227236] [026/133] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[104.324449] Starting subtest: primary-4-tiled-reflect-x-180
[111.310384] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.986s)
[112.488102] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[112.582126] Starting subtest: 2x-flip-vs-panning-interruptible
[112.593064] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[112.666877] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[112.771888] Starting subtest: plain-flip-fb-recreate
[112.774312] Starting dynamic subtest: A-eDP1
[121.673075] Dynamic subtest A-eDP1: SUCCESS (8.899s)
[121.683798] Starting dynamic subtest: B-eDP1
[130.524485] Dynamic subtest B-eDP1: SUCCESS (8.849s)
[130.537586] Starting dynamic subtest: C-eDP1
[139.344649] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[139.355652] Starting dynamic subtest: D-eDP1
[148.166899] Dynamic subtest D-eDP1: SUCCESS (8.821s)
[148.170998] Subtest plain-flip-fb-recreate: SUCCESS (35.401s)
[149.345919] [029/133] (871s left) gem_tiled_partial_pwrite_pread (writes)
[149.403406] Subtest writes: SKIP (0.000s)
[149.473197] [030/133] (871s left) gem_lmem_swapping (heavy-verify-random)
[149.519658] Subtest heavy-verify-random: SKIP (0.000s)
[149.561482] [031/133] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[149.664281] Starting subtest: x-tiled-64bpp-rotate-90
[149.683597] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[149.792076] [032/133] (871s left) vgem_basic (debugfs)
[149.895933] Starting subtest: debugfs
[149.898271] Subtest debugfs: SUCCESS (0.001s)
[149.957401] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[149.960575] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[150.050540] Starting subtest: legacy-setmode
[150.052710] Starting dynamic subtest: pipe-A-eDP-1
[156.967624] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.915s)
[156.970038] Subtest legacy-setmode: SUCCESS (6.917s)
[157.840449] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[157.969600] Starting subtest: reject-modify-context-protection-off-2
[157.972063] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[158.089561] [035/133] (863s left) gem_exec_basic (basic)
[158.143462] Starting subtest: basic
[158.145909] Starting dynamic subtest: rcs0-smem
[158.148324] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[158.158889] Starting dynamic subtest: bcs0-smem
[158.160795] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[158.168892] Starting dynamic subtest: vcs0-smem
[158.171058] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[158.180730] Starting dynamic subtest: vcs1-smem
[158.182789] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[158.190266] Starting dynamic subtest: vecs0-smem
[158.192397] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[158.199762] Starting dynamic subtest: ccs0-smem
[158.201841] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[158.203976] Subtest basic: SUCCESS (0.012s)
[159.937595] [036/133] (861s left) api_intel_bb (offset-control)
[159.991328] Starting subtest: offset-control
[159.996483] Subtest offset-control: SUCCESS (0.007s)
[160.115591] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[160.215433] Starting subtest: basic-max-non-joiner
[160.219672] Subtest basic-max-non-joiner: SKIP (0.000s)
[160.279500] [038/133] (861s left) kms_addfb_basic (small-bo)
[160.367693] Starting subtest: small-bo
[160.369888] Subtest small-bo: SUCCESS (0.000s)
[160.459066] [039/133] (860s left) i915_query (query-topology-garbage-items)
[160.525520] Starting subtest: query-topology-garbage-items
[160.528217] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[160.655615] [040/133] (860s left) perf (gen12-group-exclusive-stream-ctx-handle)
[160.770524] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[160.793662] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.022s)
[160.829654] [041/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[161.891108] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[161.895337] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[161.973312] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[162.034979] Starting subtest: cliprects-invalid
[162.037306] Subtest cliprects-invalid: SUCCESS (0.000s)
[162.135345] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[162.306586] Starting subtest: cursor-random-64x64
[162.311323] Starting dynamic subtest: pipe-A-eDP-1
[165.658283] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.347s)
[165.687631] Starting dynamic subtest: pipe-D-eDP-1
[169.637704] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.959s)
[169.639867] Subtest cursor-random-64x64: SUCCESS (7.330s)
[170.507996] [044/133] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[170.613318] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[170.617561] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[170.702539] [045/133] (850s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[170.808872] Starting subtest: 4-tiled-16bpp-rotate-180
[172.155735] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.348s)
[172.287689] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[172.333152] Starting subtest: create-valid-dumb
[172.335072] Subtest create-valid-dumb: SUCCESS (0.000s)
[172.431106] [047/133] (849s left) gem_softpin (zero)
[172.481711] Starting subtest: zero
[172.485300] Subtest zero: SUCCESS (0.003s)
[172.592802] [048/133] (849s left) gem_blits (basic)
[172.646465] Starting subtest: basic
[174.047734] Subtest basic: SUCCESS (1.400s)
[174.166401] [049/133] (847s left) gem_busy (close-race)
[174.229937] Starting subtest: close-race
[199.859562] Subtest close-race: SUCCESS (25.627s)
[200.226990] [050/133] (821s left) gem_exec_alignment (forked)
[200.330673] Starting subtest: forked
[239.988420] Subtest forked: SUCCESS (39.654s)
[240.066271] [051/133] (781s left) syncobj_eventfd (binary-wait-before-signal)
[240.174129] Starting subtest: binary-wait-before-signal
[240.202159] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[240.278438] [052/133] (781s left) prime_mmap (test_errors)
[240.333923] Starting subtest: test_errors
[240.336207] Starting dynamic subtest: test_errors-smem
[240.477988] Dynamic subtest test_errors-smem: SUCCESS (0.144s)
[240.481355] Subtest test_errors: SUCCESS (0.145s)
[240.594536] [053/133] (781s left) gem_ctx_persistence (heartbeat-stop)
[240.641886] Starting subtest: heartbeat-stop
[240.646343] Subtest heartbeat-stop: SKIP (0.000s)
[240.751928] [054/133] (781s left) gem_ctx_param (invalid-get-ringsize)
[240.808789] Starting subtest: invalid-get-ringsize
[240.811235] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[240.918141] [055/133] (781s left) i915_query (query-topology-matches-eu-total)
[240.978422] Starting subtest: query-topology-matches-eu-total
[240.980848] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[241.090624] [056/133] (781s left) kms_cursor_edge_walk (64x64-right-edge)
[241.180305] Starting subtest: 64x64-right-edge
[241.182659] Starting dynamic subtest: pipe-A-eDP-1
[244.643725] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[244.653574] Starting dynamic subtest: pipe-D-eDP-1
[247.764069] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[247.766374] Subtest 64x64-right-edge: SUCCESS (6.583s)
[248.575103] [057/133] (773s left) kms_plane (plane-position-covered)
[248.664839] Starting subtest: plane-position-covered
[249.187572] Starting dynamic subtest: pipe-A-plane-1
[250.452703] Dynamic subtest pipe-A-plane-1: SUCCESS (1.265s)
[250.463134] Starting dynamic subtest: pipe-A-plane-2
[251.688357] Dynamic subtest pipe-A-plane-2: SUCCESS (1.236s)
[251.700109] Starting dynamic subtest: pipe-A-plane-3
[252.994152] Dynamic subtest pipe-A-plane-3: SUCCESS (1.306s)
[253.003692] Starting dynamic subtest: pipe-A-plane-4
[254.281221] Dynamic subtest pipe-A-plane-4: SUCCESS (1.283s)
[254.290930] Starting dynamic subtest: pipe-A-plane-5
[254.309818] Dynamic subtest pipe-A-plane-5: SUCCESS (0.029s)
[255.493287] Starting dynamic subtest: pipe-B-plane-1
[256.724771] Dynamic subtest pipe-B-plane-1: SUCCESS (1.238s)
[256.735404] Starting dynamic subtest: pipe-B-plane-2
[258.001975] Dynamic subtest pipe-B-plane-2: SUCCESS (1.277s)
[258.013945] Starting dynamic subtest: pipe-B-plane-3
[259.297345] Dynamic subtest pipe-B-plane-3: SUCCESS (1.294s)
[259.306764] Starting dynamic subtest: pipe-B-plane-4
[260.556928] Dynamic subtest pipe-B-plane-4: SUCCESS (1.257s)
[260.567365] Starting dynamic subtest: pipe-B-plane-5
[260.580600] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[260.582488] Subtest plane-position-covered: SUCCESS (11.916s)
[261.427352] [058/133] (760s left) kms_frontbuffer_tracking (psr-suspend)
[261.539290] Starting subtest: psr-suspend
[299.522105] Subtest psr-suspend: SUCCESS (8.140s)
[299.665366] [059/133] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[299.768077] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[299.772421] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[299.882781] [060/133] (722s left) gem_exec_schedule (fairslice)
[299.954123] Starting subtest: fairslice
[299.956052] Starting dynamic subtest: rcs0
[301.966859] Dynamic subtest rcs0: SUCCESS (1.985s)
[301.978830] Starting dynamic subtest: bcs0
[303.981253] Dynamic subtest bcs0: SUCCESS (1.988s)
[303.991803] Starting dynamic subtest: vcs0
[306.004018] Dynamic subtest vcs0: SUCCESS (2.001s)
[306.015150] Starting dynamic subtest: vcs1
[308.026122] Dynamic subtest vcs1: SUCCESS (2.002s)
[308.036766] Starting dynamic subtest: vecs0
[310.043535] Dynamic subtest vecs0: SUCCESS (2.006s)
[310.055463] Starting dynamic subtest: ccs0
[312.064898] Dynamic subtest ccs0: SUCCESS (2.010s)
[312.066913] Subtest fairslice: SUCCESS (11.996s)
[312.366320] [061/133] (709s left) sw_sync (alloc_fence_invalid_timeline)
[312.416386] Starting subtest: alloc_fence_invalid_timeline
[312.418865] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[312.477658] [062/133] (709s left) gem_exec_whisper (basic-fds-forked)
[312.547214] Starting subtest: basic-fds-forked
[336.462951] Subtest basic-fds-forked: SUCCESS (23.882s)
[336.660472] [063/133] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[336.760797] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[336.764870] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[336.868225] [064/133] (685s left) gem_vm_create (execbuf)
[336.929891] Starting subtest: execbuf
[336.939988] Subtest execbuf: SUCCESS (0.010s)
[337.082727] [065/133] (685s left) kms_cursor_crc (cursor-onscreen-256x85)
[337.348629] Starting subtest: cursor-onscreen-256x85
[337.393524] Subtest cursor-onscreen-256x85: SKIP (0.040s)
[337.556870] [066/133] (684s left) kms_plane_alpha_blend (coverage-7efc)
[337.650700] Starting subtest: coverage-7efc
[337.949071] Starting dynamic subtest: pipe-A-eDP-1
[338.540781] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[338.570584] Starting dynamic subtest: pipe-D-eDP-1
[339.883756] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[339.886212] Subtest coverage-7efc: SUCCESS (2.235s)
[340.741371] [067/133] (681s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[340.828852] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[340.831065] Starting dynamic subtest: pipe-A
[340.857634] Dynamic subtest pipe-A: SKIP (0.026s)
[340.867874] Starting dynamic subtest: pipe-B
[340.887902] Dynamic subtest pipe-B: SKIP (0.030s)
[340.897021] Starting dynamic subtest: pipe-C
[340.918643] Dynamic subtest pipe-C: SKIP (0.029s)
[340.927827] Starting dynamic subtest: pipe-D
[340.974498] Dynamic subtest pipe-D: SKIP (0.054s)
[340.978763] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.142s)
[341.057535] [068/133] (681s left) vgem_basic (busy-fence)
[341.106793] Starting subtest: busy-fence
[341.108994] Subtest busy-fence: SUCCESS (0.000s)
[341.177624] [069/133] (681s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[341.286151] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[341.314754] Starting dynamic subtest: pipe-A-plane-0
[341.736264] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[341.746157] Starting dynamic subtest: pipe-A-plane-3
[341.992746] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[342.003282] Starting dynamic subtest: pipe-A-plane-5
[342.007059] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[343.129037] Starting dynamic subtest: pipe-B-plane-0
[343.553104] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[343.564059] Starting dynamic subtest: pipe-B-plane-3
[343.808413] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[343.818923] Starting dynamic subtest: pipe-B-plane-5
[343.823442] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[344.125939] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.840s)
[345.002703] [070/133] (677s left) kms_addfb_basic (invalid-set-prop-any)
[345.068776] Starting subtest: invalid-set-prop-any
[345.071084] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[345.205773] [071/133] (677s left) kms_addfb_basic (size-max)
[345.302783] Starting subtest: size-max
[345.304636] Subtest size-max: SUCCESS (0.000s)
[345.386144] [072/133] (677s left) kms_addfb_basic (bad-pitch-128)
[345.451889] Starting subtest: bad-pitch-128
[345.454279] Subtest bad-pitch-128: SUCCESS (0.000s)
[345.582653] [073/133] (677s left) syncobj_timeline (single-wait-available-submitted)
[345.639780] Starting subtest: single-wait-available-submitted
[345.642056] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[345.736187] [074/133] (677s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[345.850495] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[346.819585] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.971s)
[346.960147] [075/133] (675s left) gem_pread (exhaustion)
[347.029604] Subtest exhaustion: SKIP (0.000s)
[347.093479] [076/133] (675s left) kms_frontbuffer_tracking (psr-1p-rte)
[347.185907] Starting subtest: psr-1p-rte
[352.588525] Subtest psr-1p-rte: SUCCESS (5.405s)
[352.692848] [077/133] (670s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[352.813024] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[370.210889] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.390s)
[371.002234] [078/133] (652s left) api_intel_allocator (fork-simple-once)
[371.074461] Starting subtest: fork-simple-once
[371.091299] Subtest fork-simple-once: SUCCESS (0.018s)
[371.228433] [079/133] (651s left) gem_set_tiling_vs_pwrite
[371.341702] [080/133] (651s left) kms_pm_backlight (brightness-with-dpms)
[371.446665] Starting subtest: brightness-with-dpms
[371.498325] Starting dynamic subtest: eDP-1
[373.887549] Dynamic subtest eDP-1: SUCCESS (2.388s)
[373.889941] Subtest brightness-with-dpms: SUCCESS (2.441s)
[374.753821] [081/133] (648s left) kms_lease (lease-invalid-crtc)
[374.843821] Starting subtest: lease-invalid-crtc
[374.846103] Starting dynamic subtest: pipe-A-eDP-1
[374.848297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[374.858369] Starting dynamic subtest: pipe-B-eDP-1
[374.860690] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[374.869898] Starting dynamic subtest: pipe-C-eDP-1
[374.872098] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[374.880755] Starting dynamic subtest: pipe-D-eDP-1
[374.882634] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[374.884635] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[374.923890] [082/133] (648s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[375.013969] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[375.018347] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[375.101040] [083/133] (648s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[375.206610] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[381.987749] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.779s)
[382.124366] [084/133] (641s left) kms_dp_linktrain_fallback (dp-fallback)
[382.225653] Starting subtest: dp-fallback
[382.232295] Subtest dp-fallback: SKIP (0.000s)
[382.295584] [085/133] (641s left) kms_vblank (ts-continuation-idle)
[382.386800] Starting subtest: ts-continuation-idle
[382.388669] Starting dynamic subtest: pipe-A-eDP-1
[382.785631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[382.800736] Starting dynamic subtest: pipe-D-eDP-1
[383.896068] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.107s)
[383.898006] Subtest ts-continuation-idle: SUCCESS (1.509s)
[384.763476] [086/133] (638s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[384.858991] Starting subtest: fbc-psr-cursor-mmap-gtt
[384.861275] Starting dynamic subtest: eDP-1
[384.865603] Dynamic subtest eDP-1: SKIP (0.000s)
[384.869888] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[384.929380] [087/133] (638s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[385.055314] Starting subtest: cursor-vs-flip-varying-size
[416.154978] Subtest cursor-vs-flip-varying-size: SUCCESS (31.103s)
[416.989105] [088/133] (606s left) i915_drm_fdinfo (busy-check-all)
[417.047372] Starting subtest: busy-check-all
[417.049876] Starting dynamic subtest: rcs0
[417.054614] Dynamic subtest rcs0: SKIP (0.004s)
[417.067432] Starting dynamic subtest: bcs0
[417.071891] Dynamic subtest bcs0: SKIP (0.000s)
[417.081080] Starting dynamic subtest: vcs0
[417.085586] Dynamic subtest vcs0: SKIP (0.000s)
[417.094836] Starting dynamic subtest: vcs1
[417.099101] Dynamic subtest vcs1: SKIP (0.000s)
[417.108160] Starting dynamic subtest: vecs0
[417.112551] Dynamic subtest vecs0: SKIP (0.000s)
[417.121841] Starting dynamic subtest: ccs0
[417.126390] Dynamic subtest ccs0: SKIP (0.000s)
[417.130912] Subtest busy-check-all: SKIP (0.009s)
[417.171127] [089/133] (606s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[417.263610] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[417.265906] Starting dynamic subtest: pipe-A-eDP-1
[417.286237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[417.297321] Starting dynamic subtest: pipe-B-eDP-1
[417.315692] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[417.324536] Starting dynamic subtest: pipe-C-eDP-1
[417.342816] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[417.351640] Starting dynamic subtest: pipe-D-eDP-1
[417.370529] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[417.372467] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[419.551019] [090/133] (603s left) prime_busy (before-wait)
[419.600492] Starting subtest: before-wait
[419.605574] Starting dynamic subtest: rcs0
[419.630959] Dynamic subtest rcs0: SUCCESS (0.027s)
[419.640570] Starting dynamic subtest: bcs0
[419.670759] Dynamic subtest bcs0: SUCCESS (0.038s)
[419.679884] Starting dynamic subtest: vcs0
[419.708932] Dynamic subtest vcs0: SUCCESS (0.039s)
[419.718015] Starting dynamic subtest: vcs1
[419.748015] Dynamic subtest vcs1: SUCCESS (0.038s)
[419.756987] Starting dynamic subtest: vecs0
[419.788004] Dynamic subtest vecs0: SUCCESS (0.039s)
[419.797040] Starting dynamic subtest: ccs0
[419.827837] Dynamic subtest ccs0: SUCCESS (0.039s)
[419.937778] Subtest before-wait: SUCCESS (0.335s)
[420.018199] [091/133] (603s left) gem_ppgtt (blt-vs-render-ctx0)
[420.073885] Starting subtest: blt-vs-render-ctx0
[452.845434] Subtest blt-vs-render-ctx0: SUCCESS (32.765s)
[452.966083] [092/133] (570s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[453.134915] Starting subtest: cursorB-vs-flipB-atomic
[453.139232] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[453.281938] [093/133] (570s left) gem_exec_reloc (basic-wc-read-active)
[453.337296] Subtest basic-wc-read-active: SKIP (0.000s)
[453.404049] [094/133] (570s left) gem_exec_fence (syncobj-import)
[453.855975] Starting subtest: syncobj-import
[453.861762] Subtest syncobj-import: SUCCESS (0.005s)
[455.846003] [095/133] (567s left) kms_psr (fbc-psr2-sprite-blt)
[455.946705] Starting subtest: fbc-psr2-sprite-blt
[455.949120] Starting dynamic subtest: eDP-1
[455.953420] Dynamic subtest eDP-1: SKIP (0.000s)
[455.957760] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[456.018447] [096/133] (567s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[456.105110] Starting subtest: plane-lut1d-post-ctm3x4
[456.242728] Starting dynamic subtest: pipe-A-plane-0
[456.443348] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[456.453565] Starting dynamic subtest: pipe-A-plane-1
[456.586985] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[456.596893] Starting dynamic subtest: pipe-A-plane-2
[456.720255] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[457.953365] Starting dynamic subtest: pipe-B-plane-0
[458.101304] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[458.111538] Starting dynamic subtest: pipe-B-plane-1
[458.290567] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[458.300801] Starting dynamic subtest: pipe-B-plane-2
[458.490519] Dynamic subtest pipe-B-plane-2: SUCCESS (0.199s)
[459.673599] Starting dynamic subtest: pipe-C-plane-0
[459.798262] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[459.808425] Starting dynamic subtest: pipe-C-plane-1
[459.953897] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s)
[459.963678] Starting dynamic subtest: pipe-C-plane-2
[460.098343] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[461.328393] Starting dynamic subtest: pipe-D-plane-0
[461.473309] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[461.482956] Starting dynamic subtest: pipe-D-plane-1
[461.606049] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[461.619750] Starting dynamic subtest: pipe-D-plane-2
[461.751451] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[462.043698] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.939s)
[462.869863] [097/133] (560s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[462.923008] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[462.927808] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[463.119138] [098/133] (560s left) kms_big_fb (linear-8bpp-rotate-180)
[463.218603] Starting subtest: linear-8bpp-rotate-180
[464.511203] Subtest linear-8bpp-rotate-180: SUCCESS (1.292s)
[464.633600] [099/133] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[464.727386] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[464.730886] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[464.830758] [100/133] (559s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[464.930464] Starting subtest: extended-modeset-hang-oldfb-with-reset
[464.932394] Starting dynamic subtest: pipe-A
[476.758531] Dynamic subtest pipe-A: SUCCESS (11.824s)
[476.770012] Starting dynamic subtest: pipe-D
[489.006369] Dynamic subtest pipe-D: SUCCESS (12.242s)
[489.008814] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.070s)
[489.803655] [101/133] (534s left) gem_exec_schedule (timeslicing)
[489.888680] Starting subtest: timeslicing
[489.891142] Starting dynamic subtest: rcs0
[489.897115] Dynamic subtest rcs0: SUCCESS (0.021s)
[489.907174] Starting dynamic subtest: bcs0
[489.920445] Dynamic subtest bcs0: SUCCESS (0.022s)
[489.936616] Starting dynamic subtest: vcs0
[489.944591] Dynamic subtest vcs0: SUCCESS (0.023s)
[489.955241] Starting dynamic subtest: vcs1
[489.968537] Dynamic subtest vcs1: SUCCESS (0.022s)
[489.981778] Starting dynamic subtest: vecs0
[489.988950] Dynamic subtest vecs0: SUCCESS (0.020s)
[489.999032] Starting dynamic subtest: ccs0
[490.014561] Dynamic subtest ccs0: SUCCESS (0.025s)
[490.016950] Subtest timeslicing: SUCCESS (0.141s)
[491.699457] [102/133] (532s left) kms_chamelium_color (ctm-0-25)
[491.798299] Subtest ctm-0-25: SKIP (0.000s)
[491.851067] [103/133] (532s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[491.950009] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[491.952499] Starting dynamic subtest: pipe-A-eDP-1
[492.045112] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[492.056459] Starting dynamic subtest: pipe-B-eDP-1
[493.171767] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[493.176478] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.225s)
[494.363135] [104/133] (529s left) gem_mmap (short-mmap)
[494.425792] Subtest short-mmap: SKIP (0.000s)
[494.490233] [105/133] (529s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[494.542776] Starting subtest: multi-wait-available-unsubmitted-submitted
[494.545029] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[494.634004] [106/133] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[494.735297] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[494.739549] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[494.837278] [107/133] (529s left) kms_getfb (getfb2-accept-nv12)
[494.935501] Starting subtest: getfb2-accept-nv12
[494.937798] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[495.042961] [108/133] (529s left) syncobj_timeline (invalid-signal-zero-handles)
[495.097347] Starting subtest: invalid-signal-zero-handles
[495.099542] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[495.197882] [109/133] (529s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[495.286789] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[495.291121] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[495.364075] [110/133] (529s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[495.459941] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[495.461833] Starting dynamic subtest: pipe-A-eDP-1
[495.511785] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[495.521479] Starting dynamic subtest: pipe-B-eDP-1
[495.566187] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[495.575599] Starting dynamic subtest: pipe-C-eDP-1
[495.620562] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[495.629901] Starting dynamic subtest: pipe-D-eDP-1
[495.673820] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[495.677218] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[497.635900] [111/133] (526s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[497.731042] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[497.742155] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[497.826073] [112/133] (526s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[497.933535] Starting subtest: async-flip-with-page-flip-events-tiled
[498.309984] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[501.103039] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[501.116792] Starting dynamic subtest: pipe-A-eDP-1-4
[503.266734] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.162s)
[503.277234] Starting dynamic subtest: pipe-A-eDP-1-4
[505.276635] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[505.292306] Starting dynamic subtest: pipe-A-eDP-1-x
[507.455955] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[507.830523] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[510.638690] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.818s)
[510.648950] Starting dynamic subtest: pipe-B-eDP-1-4
[512.857675] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.218s)
[512.867901] Starting dynamic subtest: pipe-B-eDP-1-4
[514.868427] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[514.878503] Starting dynamic subtest: pipe-B-eDP-1-x
[517.059960] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[517.438682] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[520.164135] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.733s)
[520.177059] Starting dynamic subtest: pipe-C-eDP-1-4
[522.327774] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[522.341023] Starting dynamic subtest: pipe-C-eDP-1-4
[524.338332] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[524.348858] Starting dynamic subtest: pipe-C-eDP-1-x
[526.528574] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[526.896032] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[529.696443] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.808s)
[529.708753] Starting dynamic subtest: pipe-D-eDP-1-4
[531.881028] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[531.891238] Starting dynamic subtest: pipe-D-eDP-1-4
[533.890530] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[533.902098] Starting dynamic subtest: pipe-D-eDP-1-x
[536.069164] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[536.071611] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.133s)
[537.278757] [113/133] (487s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[537.375641] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[537.380166] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[537.471180] [114/133] (487s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[537.525681] Starting subtest: etime-multi-wait-for-submit-submitted
[537.629861] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[537.721173] [115/133] (486s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[539.888460] Starting subtest: modeset-non-lpsp-stress-no-wait
[539.935436] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.047s)
[540.257540] [116/133] (484s left) gem_exec_params (sol-reset-invalid)
[540.322477] Starting subtest: sol-reset-invalid
[540.324946] Subtest sol-reset-invalid: SUCCESS (0.002s)
[541.785088] [117/133] (482s left) gem_mmap_gtt (cpuset-big-copy)
[541.858700] Subtest cpuset-big-copy: SKIP (0.000s)
[541.950214] [118/133] (482s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[542.038706] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[549.732918] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.700s)
[549.849455] [119/133] (474s left) kms_psr (psr2-sprite-plane-onoff)
[549.950107] Starting subtest: psr2-sprite-plane-onoff
[549.952190] Starting dynamic subtest: eDP-1
[551.661736] Dynamic subtest eDP-1: SUCCESS (1.711s)
[551.664131] Subtest psr2-sprite-plane-onoff: SUCCESS (1.712s)
[552.523381] [120/133] (472s left) kms_dsc (dsc-with-output-formats)
[552.624453] Starting subtest: dsc-with-output-formats
[552.646672] Subtest dsc-with-output-formats: SKIP (0.000s)
[552.698065] [121/133] (472s left) gen3_mixed_blits
[552.808191] [122/133] (472s left) gem_mmap_offset (clear-via-pagefault)
[552.860488] Starting subtest: clear-via-pagefault
[552.862810] Starting dynamic subtest: smem0
[588.840026] Dynamic subtest smem0: SUCCESS (35.975s)
[588.842079] Subtest clear-via-pagefault: SUCCESS (35.977s)
[588.960311] [123/133] (435s left) gem_eio (reset-stress)
[589.195772] Starting subtest: reset-stress
[589.197698] Starting dynamic subtest: render
[594.122261] Dynamic subtest render: SUCCESS (4.925s)
[594.140316] Starting dynamic subtest: bsd1
[612.227624] Dynamic subtest bsd1: SUCCESS (18.103s)
[612.244746] Starting dynamic subtest: bsd2
[630.227656] Dynamic subtest bsd2: SUCCESS (17.996s)
[630.244615] Starting dynamic subtest: blt
[630.248860] Dynamic subtest blt: SKIP (0.000s)
[630.257867] Starting dynamic subtest: vebox
[648.211169] Dynamic subtest vebox: SUCCESS (17.980s)
[648.213560] Subtest reset-stress: SUCCESS (59.009s)
[649.792697] [124/133] (375s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[649.852942] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[649.854840] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[649.968081] [125/133] (375s left) kms_vblank (query-busy-hang)
[650.062013] Starting subtest: query-busy-hang
[650.064308] Starting dynamic subtest: pipe-A-eDP-1
[651.940675] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[651.959266] Starting dynamic subtest: pipe-D-eDP-1
[654.476768] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[654.479315] Subtest query-busy-hang: SUCCESS (4.415s)
[655.278374] [126/133] (369s left) kms_psr (fbc-pr-cursor-plane-onoff)
[655.368119] Starting subtest: fbc-pr-cursor-plane-onoff
[655.372340] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[655.441591] [127/133] (369s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[655.536184] Starting subtest: psr-1p-primscrn-cur-indfb-move
[662.890865] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.357s)
[663.019014] [128/133] (362s left) tools_test (sysfs_l3_parity)
[663.074339] Starting subtest: sysfs_l3_parity
[663.154501] Subtest sysfs_l3_parity: SKIP (0.092s)
[663.210313] [129/133] (361s left) kms_vblank (crtc-id)
[663.309316] Starting subtest: crtc-id
[663.311435] Starting dynamic subtest: pipe-A-eDP-1
[663.755248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[663.770052] Starting dynamic subtest: pipe-D-eDP-1
[664.921518] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.165s)
[664.923866] Subtest crtc-id: SUCCESS (1.613s)
[665.760653] [130/133] (359s left) gem_ctx_engines (independent)
[665.833448] Starting subtest: independent
[665.835865] Starting dynamic subtest: rcs0
[665.993801] Dynamic subtest rcs0: SUCCESS (0.159s)
[666.008089] Starting dynamic subtest: bcs0
[666.152738] Dynamic subtest bcs0: SUCCESS (0.158s)
[666.169045] Starting dynamic subtest: vcs0
[666.315050] Dynamic subtest vcs0: SUCCESS (0.161s)
[666.333080] Starting dynamic subtest: vcs1
[666.498758] Dynamic subtest vcs1: SUCCESS (0.183s)
[666.512362] Starting dynamic subtest: vecs0
[666.682768] Dynamic subtest vecs0: SUCCESS (0.183s)
[666.696609] Starting dynamic subtest: ccs0
[666.842189] Dynamic subtest ccs0: SUCCESS (0.157s)
[666.854274] Starting dynamic subtest: all-engines
[667.662529] Dynamic subtest all-engines: SUCCESS (0.819s)
[667.665404] Subtest independent: SUCCESS (1.828s)
[667.910876] [131/133] (357s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[668.016076] Starting subtest: flip-vs-dpms-on-nop-interruptible
[668.017945] Starting dynamic subtest: A-eDP1
[669.847322] Dynamic subtest A-eDP1: SUCCESS (1.829s)
[669.861900] Starting dynamic subtest: B-eDP1
[671.676887] Dynamic subtest B-eDP1: SUCCESS (1.828s)
[671.689890] Starting dynamic subtest: C-eDP1
[673.498057] Dynamic subtest C-eDP1: SUCCESS (1.818s)
[673.510630] Starting dynamic subtest: D-eDP1
[675.322899] Dynamic subtest D-eDP1: SUCCESS (1.823s)
[675.328273] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.310s)
[676.500872] [132/133] (348s left) kms_plane_lowres (tiling-x)
[676.591041] Starting subtest: tiling-x
[676.593436] Starting dynamic subtest: pipe-A-eDP-1
[676.598149] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[676.888722] Starting dynamic subtest: pipe-B-eDP-1
[676.893422] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[676.903932] Starting dynamic subtest: pipe-C-eDP-1
[676.908573] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[676.918735] Starting dynamic subtest: pipe-D-eDP-1
[676.923273] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[676.927789] Subtest tiling-x: SKIP (0.296s)
[677.739660] [133/133] (347s left) i915_pm_freq_api (freq-reset)
[677.811295] Starting subtest: freq-reset
[677.813840] Starting dynamic subtest: gt0
[678.013938] Dynamic subtest gt0: SUCCESS (0.199s)
[678.025359] Starting dynamic subtest: gt1
[678.184592] Dynamic subtest gt1: SUCCESS (0.170s)
[678.187827] Subtest freq-reset: SUCCESS (0.373s)
[678.260430] 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: gem_exec_alignment
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_vm_create
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_pread
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_dp_linktrain_fallback
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: prime_busy
results: parsing output: 90/ for test: gem_ppgtt
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_mmap
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_dsc
results: parsing output: 120/ for test: gen3_mixed_blits
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: tools_test
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_ctx_engines
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_plane_lowres
results: parsing output: 132/ for test: i915_pm_freq_api
Done.