[59.841543] Initializing watchdogs
[59.841593]   /dev/watchdog0
[59.857664] [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.862232] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.864545] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.867983] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[59.995687] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[60.000369] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[60.093171] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[60.195491] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[60.200037] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[60.313362] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[60.416286] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[61.111406] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[61.264065] [004/133] (959s left) gen7_exec_parse (basic-offset)
[61.330447] Subtest basic-offset: SKIP (0.000s)
[61.390328] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[61.494529] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[65.809950] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.299s)
[67.059411] [006/133] (953s left) tools_test (tools_test)
[67.130502] Starting subtest: tools_test
[67.253931] Subtest tools_test: SUCCESS (0.141s)
[67.350527] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[67.534246] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[67.538922] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[68.698603] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[68.800079] Starting subtest: modeset-vs-vblank-race
[68.802485] Starting dynamic subtest: A-eDP1
[73.521656] Dynamic subtest A-eDP1: SUCCESS (4.715s)
[73.532116] Starting dynamic subtest: B-eDP1
[78.260373] Dynamic subtest B-eDP1: SUCCESS (4.733s)
[78.271872] Starting dynamic subtest: C-eDP1
[82.872150] Dynamic subtest C-eDP1: SUCCESS (4.606s)
[82.879839] Starting dynamic subtest: D-eDP1
[87.428462] Dynamic subtest D-eDP1: SUCCESS (4.552s)
[87.433548] Subtest modeset-vs-vblank-race: SUCCESS (18.614s)
[88.582674] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[90.119520] Starting subtest: reg-read-ioctl
[92.507730] Subtest reg-read-ioctl: SUCCESS (2.389s)
[92.877732] [010/133] (927s left) gem_exec_balancer (hang)
[93.146580] Starting subtest: hang
[94.871102] Subtest hang: SUCCESS (1.725s)
[95.008044] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[95.095262] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[95.099484] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[95.179537] [012/133] (925s left) perf_pmu (faulting-read)
[95.223465] Starting subtest: faulting-read
[95.225454] Starting dynamic subtest: wb
[95.227840] Dynamic subtest wb: SUCCESS (0.001s)
[95.237607] Starting dynamic subtest: wc
[95.239458] Dynamic subtest wc: SUCCESS (0.000s)
[95.247041] Starting dynamic subtest: uc
[95.248848] Dynamic subtest uc: SUCCESS (0.000s)
[95.250679] Subtest faulting-read: SUCCESS (0.002s)
[95.336227] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[95.433240] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[95.437469] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[95.517382] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[95.897643] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[96.678336] [015/133] (924s left) gem_exec_schedule (pi-distinct-iova)
[96.857162] Starting subtest: pi-distinct-iova
[96.859274] Starting dynamic subtest: rcs0
[96.936891] Dynamic subtest rcs0: SUCCESS (0.081s)
[96.949979] Starting dynamic subtest: vcs0
[97.001750] Dynamic subtest vcs0: SUCCESS (0.064s)
[97.013833] Starting dynamic subtest: vcs1
[97.068636] Dynamic subtest vcs1: SUCCESS (0.067s)
[97.079982] Starting dynamic subtest: vecs0
[97.130512] Dynamic subtest vecs0: SUCCESS (0.062s)
[97.141660] Starting dynamic subtest: ccs0
[97.192572] Dynamic subtest ccs0: SUCCESS (0.061s)
[97.195614] Subtest pi-distinct-iova: SUCCESS (0.337s)
[98.996204] [016/133] (922s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[99.085831] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[99.090275] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[99.177235] [017/133] (921s left) drm_read (short-buffer-block)
[99.312429] Starting subtest: short-buffer-block
[99.314781] Subtest short-buffer-block: SUCCESS (0.000s)
[99.441468] [018/133] (921s left) perf (oa-formats)
[99.572670] Starting subtest: oa-formats
[99.574506] Starting dynamic subtest: 0-rcs0
[99.587693] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[99.596668] Starting dynamic subtest: 1-vcs0
[99.610227] Dynamic subtest 1-vcs0: SUCCESS (0.022s)
[99.612476] Subtest oa-formats: SUCCESS (0.039s)
[99.657614] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[99.755453] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[99.759918] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[99.863440] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[99.958454] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[99.962089] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.055118] [021/133] (921s left) kms_psr (pr-basic)
[100.146233] Starting subtest: pr-basic
[100.150032] Subtest pr-basic: SKIP (0.000s)
[100.218453] [022/133] (921s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[100.310989] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[100.313023] Starting dynamic subtest: pipe-A-eDP-1
[100.331763] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.341069] Starting dynamic subtest: pipe-B-eDP-1
[100.358259] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.366064] Starting dynamic subtest: pipe-C-eDP-1
[100.383895] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.391376] Starting dynamic subtest: pipe-D-eDP-1
[100.409532] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.412955] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[102.499506] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[102.899551] Subtest hdmi-mode-timings: SKIP (0.000s)
[103.705465] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[103.838782] Starting subtest: dp-mst-lic-type-0-hdcp14
[103.843574] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[103.964803] [025/133] (917s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[104.059486] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[104.063885] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[104.127754] [026/133] (917s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[104.220267] Starting subtest: primary-4-tiled-reflect-x-180
[111.212449] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.993s)
[112.408273] [027/133] (909s left) kms_flip (2x-flip-vs-panning-interruptible)
[112.506350] Starting subtest: 2x-flip-vs-panning-interruptible
[112.518744] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[112.588956] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[112.692457] Starting subtest: plain-flip-fb-recreate
[112.694423] Starting dynamic subtest: A-eDP1
[121.580970] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[121.591643] Starting dynamic subtest: B-eDP1
[130.406872] Dynamic subtest B-eDP1: SUCCESS (8.823s)
[130.417529] Starting dynamic subtest: C-eDP1
[139.225885] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[139.233971] Starting dynamic subtest: D-eDP1
[148.064195] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[148.069863] Subtest plain-flip-fb-recreate: SUCCESS (35.377s)
[149.250637] [029/133] (872s left) gem_tiled_partial_pwrite_pread (writes)
[149.299308] Subtest writes: SKIP (0.000s)
[149.358768] [030/133] (872s left) gem_lmem_swapping (heavy-verify-random)
[149.405125] Subtest heavy-verify-random: SKIP (0.000s)
[149.443109] [031/133] (872s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[149.551257] Starting subtest: x-tiled-64bpp-rotate-90
[149.570845] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[149.672435] [032/133] (872s left) vgem_basic (debugfs)
[149.783599] Starting subtest: debugfs
[149.785479] Subtest debugfs: SUCCESS (0.000s)
[149.836813] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[149.840038] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[149.926213] Starting subtest: legacy-setmode
[149.928537] Starting dynamic subtest: pipe-A-eDP-1
[156.833412] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.906s)
[156.835662] Subtest legacy-setmode: SUCCESS (6.907s)
[157.702146] [034/133] (864s left) gem_pxp (reject-modify-context-protection-off-2)
[157.821475] Starting subtest: reject-modify-context-protection-off-2
[157.823785] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[157.926866] [035/133] (863s left) gem_exec_basic (basic)
[157.970575] Starting subtest: basic
[157.972912] Starting dynamic subtest: rcs0-smem
[157.975185] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[157.984793] Starting dynamic subtest: bcs0-smem
[157.986977] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[157.995178] Starting dynamic subtest: vcs0-smem
[157.997442] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[158.005151] Starting dynamic subtest: vcs1-smem
[158.007063] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[158.014791] Starting dynamic subtest: vecs0-smem
[158.016758] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[158.024234] Starting dynamic subtest: ccs0-smem
[158.026096] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[158.027949] Subtest basic: SUCCESS (0.013s)
[159.950380] [036/133] (861s left) api_intel_bb (offset-control)
[160.003047] Starting subtest: offset-control
[160.007628] Subtest offset-control: SUCCESS (0.007s)
[160.136664] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[160.230624] Starting subtest: basic-max-non-joiner
[160.234840] Subtest basic-max-non-joiner: SKIP (0.000s)
[160.299052] [038/133] (861s left) kms_addfb_basic (small-bo)
[160.389567] Starting subtest: small-bo
[160.391821] Subtest small-bo: SUCCESS (0.000s)
[160.498811] [039/133] (861s left) i915_query (query-topology-garbage-items)
[160.559026] Starting subtest: query-topology-garbage-items
[160.561313] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[160.666316] [040/133] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[160.764471] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[160.797627] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.031s)
[160.839226] [041/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[161.894650] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[161.899375] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[161.985743] [042/133] (860s left) gem_exec_params (cliprects-invalid)
[162.046061] Starting subtest: cliprects-invalid
[162.048319] Subtest cliprects-invalid: SUCCESS (0.000s)
[162.146644] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[162.331905] Starting subtest: cursor-random-64x64
[162.337119] Starting dynamic subtest: pipe-A-eDP-1
[165.681703] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.345s)
[165.711064] Starting dynamic subtest: pipe-D-eDP-1
[169.737101] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.033s)
[169.739481] Subtest cursor-random-64x64: SUCCESS (7.406s)
[170.583967] [044/133] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[170.690129] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[170.694382] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[170.785726] [045/133] (851s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[170.880230] Starting subtest: 4-tiled-16bpp-rotate-180
[172.148648] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.270s)
[172.288020] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[172.346068] Starting subtest: create-valid-dumb
[172.348056] Subtest create-valid-dumb: SUCCESS (0.000s)
[172.446820] [047/133] (849s left) gem_softpin (zero)
[172.497341] Starting subtest: zero
[172.501230] Subtest zero: SUCCESS (0.004s)
[172.606149] [048/133] (849s left) gem_blits (basic)
[172.664326] Starting subtest: basic
[174.059898] Subtest basic: SUCCESS (1.395s)
[174.165781] [049/133] (848s left) gem_busy (close-race)
[174.230450] Starting subtest: close-race
[199.894971] Subtest close-race: SUCCESS (25.664s)
[200.253528] [050/133] (822s left) gem_exec_alignment (forked)
[200.355551] Starting subtest: forked
[239.216667] Subtest forked: SUCCESS (38.855s)
[239.294538] [051/133] (783s left) syncobj_eventfd (binary-wait-before-signal)
[239.398064] Starting subtest: binary-wait-before-signal
[239.424982] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[239.517393] [052/133] (783s left) prime_mmap (test_errors)
[239.581956] Starting subtest: test_errors
[239.584402] Starting dynamic subtest: test_errors-smem
[239.680431] Dynamic subtest test_errors-smem: SUCCESS (0.101s)
[239.683050] Subtest test_errors: SUCCESS (0.101s)
[239.770649] [053/133] (782s left) gem_ctx_persistence (heartbeat-stop)
[239.827212] Starting subtest: heartbeat-stop
[239.831767] Subtest heartbeat-stop: SKIP (0.000s)
[239.935371] [054/133] (782s left) gem_ctx_param (invalid-get-ringsize)
[239.994352] Starting subtest: invalid-get-ringsize
[239.996785] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[240.096149] [055/133] (782s left) i915_query (query-topology-matches-eu-total)
[240.147333] Starting subtest: query-topology-matches-eu-total
[240.149622] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[240.242312] [056/133] (782s left) kms_cursor_edge_walk (64x64-right-edge)
[240.344098] Starting subtest: 64x64-right-edge
[240.346083] Starting dynamic subtest: pipe-A-eDP-1
[243.839416] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s)
[243.849174] Starting dynamic subtest: pipe-D-eDP-1
[246.969072] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[246.971371] Subtest 64x64-right-edge: SUCCESS (6.624s)
[247.766031] [057/133] (774s left) kms_plane (plane-position-covered)
[247.865802] Starting subtest: plane-position-covered
[248.396075] Starting dynamic subtest: pipe-A-plane-1
[249.671358] Dynamic subtest pipe-A-plane-1: SUCCESS (1.275s)
[249.681684] Starting dynamic subtest: pipe-A-plane-2
[250.965894] Dynamic subtest pipe-A-plane-2: SUCCESS (1.295s)
[250.976125] Starting dynamic subtest: pipe-A-plane-3
[252.202828] Dynamic subtest pipe-A-plane-3: SUCCESS (1.235s)
[252.212400] Starting dynamic subtest: pipe-A-plane-4
[253.435478] Dynamic subtest pipe-A-plane-4: SUCCESS (1.232s)
[253.447266] Starting dynamic subtest: pipe-A-plane-5
[253.463417] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[254.590322] Starting dynamic subtest: pipe-B-plane-1
[255.942850] Dynamic subtest pipe-B-plane-1: SUCCESS (1.359s)
[255.952600] Starting dynamic subtest: pipe-B-plane-2
[257.250152] Dynamic subtest pipe-B-plane-2: SUCCESS (1.307s)
[257.264448] Starting dynamic subtest: pipe-B-plane-3
[258.504280] Dynamic subtest pipe-B-plane-3: SUCCESS (1.251s)
[258.514429] Starting dynamic subtest: pipe-B-plane-4
[259.768950] Dynamic subtest pipe-B-plane-4: SUCCESS (1.266s)
[259.778839] Starting dynamic subtest: pipe-B-plane-5
[259.794858] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[259.797247] Subtest plane-position-covered: SUCCESS (11.928s)
[260.653508] [058/133] (762s left) kms_frontbuffer_tracking (psr-suspend)
[260.765579] Starting subtest: psr-suspend
[298.870465] Subtest psr-suspend: SUCCESS (8.105s)
[298.964538] [059/133] (723s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[299.087045] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[299.092110] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[299.191113] [060/133] (723s left) gem_exec_schedule (fairslice)
[299.264807] Starting subtest: fairslice
[299.267620] Starting dynamic subtest: rcs0
[301.286302] Dynamic subtest rcs0: SUCCESS (1.961s)
[301.297539] Starting dynamic subtest: bcs0
[303.315014] Dynamic subtest bcs0: SUCCESS (1.980s)
[303.324969] Starting dynamic subtest: vcs0
[305.335450] Dynamic subtest vcs0: SUCCESS (1.982s)
[305.346769] Starting dynamic subtest: vcs1
[307.354937] Dynamic subtest vcs1: SUCCESS (1.989s)
[307.365336] Starting dynamic subtest: vecs0
[309.378409] Dynamic subtest vecs0: SUCCESS (1.997s)
[309.389822] Starting dynamic subtest: ccs0
[311.398338] Dynamic subtest ccs0: SUCCESS (2.001s)
[311.400360] Subtest fairslice: SUCCESS (11.915s)
[311.698984] [061/133] (711s left) sw_sync (alloc_fence_invalid_timeline)
[311.739009] Starting subtest: alloc_fence_invalid_timeline
[311.741815] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[311.801671] [062/133] (711s left) gem_exec_whisper (basic-fds-forked)
[311.871848] Starting subtest: basic-fds-forked
[337.255993] Subtest basic-fds-forked: SUCCESS (25.328s)
[337.442487] [063/133] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[337.542624] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[337.547835] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[337.654603] [064/133] (685s left) gem_vm_create (execbuf)
[337.720374] Starting subtest: execbuf
[337.726577] Subtest execbuf: SUCCESS (0.010s)
[337.845819] [065/133] (685s left) kms_cursor_crc (cursor-onscreen-256x85)
[338.115084] Starting subtest: cursor-onscreen-256x85
[338.161285] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[338.319265] [066/133] (684s left) kms_plane_alpha_blend (coverage-7efc)
[338.417453] Starting subtest: coverage-7efc
[338.734977] Starting dynamic subtest: pipe-A-eDP-1
[339.350743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.613s)
[339.377793] Starting dynamic subtest: pipe-D-eDP-1
[340.690402] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[340.692809] Subtest coverage-7efc: SUCCESS (2.271s)
[341.516324] [067/133] (681s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[341.610898] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[341.613595] Starting dynamic subtest: pipe-A
[341.632484] Dynamic subtest pipe-A: SKIP (0.017s)
[341.642545] Starting dynamic subtest: pipe-B
[341.661825] Dynamic subtest pipe-B: SKIP (0.030s)
[341.673013] Starting dynamic subtest: pipe-C
[341.692659] Dynamic subtest pipe-C: SKIP (0.029s)
[341.702525] Starting dynamic subtest: pipe-D
[341.724997] Dynamic subtest pipe-D: SKIP (0.030s)
[341.729887] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.109s)
[341.827496] [068/133] (681s left) vgem_basic (busy-fence)
[341.880788] Starting subtest: busy-fence
[341.883239] Subtest busy-fence: SUCCESS (0.000s)
[341.936278] [069/133] (681s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[342.031956] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[342.060704] Starting dynamic subtest: pipe-A-plane-0
[342.515362] Dynamic subtest pipe-A-plane-0: SUCCESS (0.455s)
[342.526908] Starting dynamic subtest: pipe-A-plane-3
[342.782563] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[342.792590] Starting dynamic subtest: pipe-A-plane-5
[342.796712] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[343.908263] Starting dynamic subtest: pipe-B-plane-0
[344.388916] Dynamic subtest pipe-B-plane-0: SUCCESS (0.489s)
[344.402033] Starting dynamic subtest: pipe-B-plane-3
[344.645749] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[344.656530] Starting dynamic subtest: pipe-B-plane-5
[344.661696] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[344.981774] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.949s)
[345.793602] [070/133] (677s left) kms_addfb_basic (invalid-set-prop-any)
[345.852768] Starting subtest: invalid-set-prop-any
[345.855479] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[345.995901] [071/133] (677s left) kms_addfb_basic (size-max)
[346.088000] Starting subtest: size-max
[346.090368] Subtest size-max: SUCCESS (0.000s)
[346.179601] [072/133] (677s left) kms_addfb_basic (bad-pitch-128)
[346.233632] Starting subtest: bad-pitch-128
[346.235934] Subtest bad-pitch-128: SUCCESS (0.000s)
[346.380354] [073/133] (677s left) syncobj_timeline (single-wait-available-submitted)
[346.442868] Starting subtest: single-wait-available-submitted
[346.445457] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[346.531901] [074/133] (676s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[346.626990] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[347.663746] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.036s)
[347.795572] [075/133] (675s left) gem_pread (exhaustion)
[347.859770] Subtest exhaustion: SKIP (0.000s)
[347.921119] [076/133] (675s left) kms_frontbuffer_tracking (psr-1p-rte)
[348.031548] Starting subtest: psr-1p-rte
[353.399003] Subtest psr-1p-rte: SUCCESS (5.370s)
[353.548803] [077/133] (670s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[353.664782] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[371.038850] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.368s)
[371.824342] [078/133] (651s left) api_intel_allocator (fork-simple-once)
[371.885354] Starting subtest: fork-simple-once
[371.898994] Subtest fork-simple-once: SUCCESS (0.017s)
[372.016639] [079/133] (651s left) gem_set_tiling_vs_pwrite
[372.143312] [080/133] (651s left) kms_pm_backlight (brightness-with-dpms)
[372.240703] Starting subtest: brightness-with-dpms
[372.290009] Starting dynamic subtest: eDP-1
[374.710539] Dynamic subtest eDP-1: SUCCESS (2.419s)
[374.713382] Subtest brightness-with-dpms: SUCCESS (2.471s)
[375.584545] [081/133] (648s left) kms_lease (lease-invalid-crtc)
[375.686711] Starting subtest: lease-invalid-crtc
[375.689351] Starting dynamic subtest: pipe-A-eDP-1
[375.691833] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[375.706465] Starting dynamic subtest: pipe-B-eDP-1
[375.708905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[375.719011] Starting dynamic subtest: pipe-C-eDP-1
[375.721339] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[375.731415] Starting dynamic subtest: pipe-D-eDP-1
[375.733696] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[375.735924] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[375.777293] [082/133] (648s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[375.873544] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[375.878828] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[376.040486] [083/133] (647s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[376.141599] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[383.113957] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.973s)
[383.254354] [084/133] (640s left) kms_dp_linktrain_fallback (dp-fallback)
[383.367031] Starting subtest: dp-fallback
[383.374384] Subtest dp-fallback: SKIP (0.000s)
[383.453645] [085/133] (640s left) kms_vblank (ts-continuation-idle)
[383.547675] Starting subtest: ts-continuation-idle
[383.549966] Starting dynamic subtest: pipe-A-eDP-1
[383.951438] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s)
[383.967510] Starting dynamic subtest: pipe-D-eDP-1
[385.017807] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.060s)
[385.020415] Subtest ts-continuation-idle: SUCCESS (1.470s)
[385.893063] [086/133] (638s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[385.986152] Starting subtest: fbc-psr-cursor-mmap-gtt
[385.989056] Starting dynamic subtest: eDP-1
[385.994309] Dynamic subtest eDP-1: SKIP (0.000s)
[385.999291] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[386.058769] [087/133] (638s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[386.171815] Starting subtest: cursor-vs-flip-varying-size
[417.565660] Subtest cursor-vs-flip-varying-size: SUCCESS (31.397s)
[418.418840] [088/133] (605s left) i915_drm_fdinfo (busy-check-all)
[418.456695] Starting subtest: busy-check-all
[418.459200] Starting dynamic subtest: rcs0
[418.464404] Dynamic subtest rcs0: SKIP (0.004s)
[418.476239] Starting dynamic subtest: bcs0
[418.481520] Dynamic subtest bcs0: SKIP (0.000s)
[418.491868] Starting dynamic subtest: vcs0
[418.496611] Dynamic subtest vcs0: SKIP (0.000s)
[418.506868] Starting dynamic subtest: vcs1
[418.511760] Dynamic subtest vcs1: SKIP (0.000s)
[418.521618] Starting dynamic subtest: vecs0
[418.526655] Dynamic subtest vecs0: SKIP (0.000s)
[418.536819] Starting dynamic subtest: ccs0
[418.541747] Dynamic subtest ccs0: SKIP (0.000s)
[418.546739] Subtest busy-check-all: SKIP (0.009s)
[418.587447] [089/133] (605s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[418.713442] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[418.715868] Starting dynamic subtest: pipe-A-eDP-1
[418.736678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[418.747557] Starting dynamic subtest: pipe-B-eDP-1
[418.770774] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[418.782772] Starting dynamic subtest: pipe-C-eDP-1
[418.804926] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[418.817769] Starting dynamic subtest: pipe-D-eDP-1
[418.840703] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[418.843223] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[420.995762] [090/133] (603s left) prime_busy (before-wait)
[421.051114] Starting subtest: before-wait
[421.056796] Starting dynamic subtest: rcs0
[421.082346] Dynamic subtest rcs0: SUCCESS (0.028s)
[421.095120] Starting dynamic subtest: bcs0
[421.123343] Dynamic subtest bcs0: SUCCESS (0.040s)
[421.133895] Starting dynamic subtest: vcs0
[421.164624] Dynamic subtest vcs0: SUCCESS (0.041s)
[421.175126] Starting dynamic subtest: vcs1
[421.206585] Dynamic subtest vcs1: SUCCESS (0.041s)
[421.218865] Starting dynamic subtest: vecs0
[421.249302] Dynamic subtest vecs0: SUCCESS (0.042s)
[421.261645] Starting dynamic subtest: ccs0
[421.291166] Dynamic subtest ccs0: SUCCESS (0.041s)
[421.399460] Subtest before-wait: SUCCESS (0.347s)
[421.478717] [091/133] (602s left) gem_ppgtt (blt-vs-render-ctx0)
[421.533723] Starting subtest: blt-vs-render-ctx0
[454.338894] Subtest blt-vs-render-ctx0: SUCCESS (32.802s)
[454.461936] [092/133] (569s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[454.643604] Starting subtest: cursorB-vs-flipB-atomic
[454.648487] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[454.788389] [093/133] (569s left) gem_exec_reloc (basic-wc-read-active)
[454.854925] Subtest basic-wc-read-active: SKIP (0.000s)
[454.916326] [094/133] (569s left) gem_exec_fence (syncobj-import)
[455.406407] Starting subtest: syncobj-import
[455.414026] Subtest syncobj-import: SUCCESS (0.008s)
[456.932866] [095/133] (567s left) kms_psr (fbc-psr2-sprite-blt)
[457.033262] Starting subtest: fbc-psr2-sprite-blt
[457.036075] Starting dynamic subtest: eDP-1
[457.041774] Dynamic subtest eDP-1: SKIP (0.000s)
[457.047510] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[457.114040] [096/133] (567s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[457.211794] Starting subtest: plane-lut1d-post-ctm3x4
[457.348797] Starting dynamic subtest: pipe-A-plane-0
[457.502163] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[457.512881] Starting dynamic subtest: pipe-A-plane-1
[457.657280] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[457.667917] Starting dynamic subtest: pipe-A-plane-2
[457.847232] Dynamic subtest pipe-A-plane-2: SUCCESS (0.187s)
[459.128320] Starting dynamic subtest: pipe-B-plane-0
[459.276687] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[459.287612] Starting dynamic subtest: pipe-B-plane-1
[459.419261] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[459.430557] Starting dynamic subtest: pipe-B-plane-2
[459.563621] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[460.819648] Starting dynamic subtest: pipe-C-plane-0
[460.954643] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[460.965031] Starting dynamic subtest: pipe-C-plane-1
[461.121645] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[461.133222] Starting dynamic subtest: pipe-C-plane-2
[461.268510] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[462.465401] Starting dynamic subtest: pipe-D-plane-0
[462.594546] Dynamic subtest pipe-D-plane-0: SUCCESS (0.143s)
[462.605786] Starting dynamic subtest: pipe-D-plane-1
[462.738659] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[462.749793] Starting dynamic subtest: pipe-D-plane-2
[462.894578] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[463.176982] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.967s)
[464.015323] [097/133] (560s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[464.085897] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[464.091277] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[464.272589] [098/133] (560s left) kms_big_fb (linear-8bpp-rotate-180)
[464.372817] Starting subtest: linear-8bpp-rotate-180
[465.652979] Subtest linear-8bpp-rotate-180: SUCCESS (1.281s)
[465.779905] [099/133] (558s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[465.880237] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[465.884711] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[465.990143] [100/133] (558s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[466.093582] Starting subtest: extended-modeset-hang-oldfb-with-reset
[466.095703] Starting dynamic subtest: pipe-A
[477.892005] Dynamic subtest pipe-A: SUCCESS (11.795s)
[477.904014] Starting dynamic subtest: pipe-D
[490.175020] Dynamic subtest pipe-D: SUCCESS (12.279s)
[490.177824] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.078s)
[490.980099] [101/133] (533s left) gem_exec_schedule (timeslicing)
[491.059491] Starting subtest: timeslicing
[491.061931] Starting dynamic subtest: rcs0
[491.068444] Dynamic subtest rcs0: SUCCESS (0.021s)
[491.079551] Starting dynamic subtest: bcs0
[491.091720] Dynamic subtest bcs0: SUCCESS (0.024s)
[491.102696] Starting dynamic subtest: vcs0
[491.113733] Dynamic subtest vcs0: SUCCESS (0.021s)
[491.124845] Starting dynamic subtest: vcs1
[491.133233] Dynamic subtest vcs1: SUCCESS (0.019s)
[491.143743] Starting dynamic subtest: vecs0
[491.153822] Dynamic subtest vecs0: SUCCESS (0.020s)
[491.164818] Starting dynamic subtest: ccs0
[491.176543] Dynamic subtest ccs0: SUCCESS (0.021s)
[491.179139] Subtest timeslicing: SUCCESS (0.131s)
[492.915097] [102/133] (531s left) kms_chamelium_color (ctm-0-25)
[493.011388] Subtest ctm-0-25: SKIP (0.000s)
[493.058310] [103/133] (531s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[493.157896] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[493.160152] Starting dynamic subtest: pipe-A-eDP-1
[493.257635] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[493.269294] Starting dynamic subtest: pipe-B-eDP-1
[494.372896] Dynamic subtest pipe-B-eDP-1: SKIP (1.114s)
[494.377859] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.217s)
[495.565962] [104/133] (529s left) gem_mmap (short-mmap)
[495.630694] Subtest short-mmap: SKIP (0.000s)
[495.689818] [105/133] (529s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[495.742834] Starting subtest: multi-wait-available-unsubmitted-submitted
[495.745226] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[495.837925] [106/133] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[495.930544] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[495.935812] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[496.036290] [107/133] (528s left) kms_getfb (getfb2-accept-nv12)
[496.131938] Starting subtest: getfb2-accept-nv12
[496.134847] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[496.221892] [108/133] (528s left) syncobj_timeline (invalid-signal-zero-handles)
[496.281777] Starting subtest: invalid-signal-zero-handles
[496.284828] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[496.378799] [109/133] (528s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[496.469499] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[496.474088] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[496.542891] [110/133] (528s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[496.633956] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[496.636359] Starting dynamic subtest: pipe-A-eDP-1
[496.692819] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[496.705628] Starting dynamic subtest: pipe-B-eDP-1
[496.757446] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[496.768678] Starting dynamic subtest: pipe-C-eDP-1
[496.823237] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[496.833377] Starting dynamic subtest: pipe-D-eDP-1
[496.889607] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[496.894214] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.011s)
[498.850782] [111/133] (526s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[498.944832] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[498.952636] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[499.037985] [112/133] (526s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[499.129839] Starting subtest: async-flip-with-page-flip-events-tiled
[499.518326] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[502.332387] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[502.347015] Starting dynamic subtest: pipe-A-eDP-1-4
[504.518808] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[504.532014] Starting dynamic subtest: pipe-A-eDP-1-4
[506.529026] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[506.542691] Starting dynamic subtest: pipe-A-eDP-1-x
[508.719905] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[509.100471] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[511.860724] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[511.875022] Starting dynamic subtest: pipe-B-eDP-1-4
[514.057985] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.195s)
[514.072041] Starting dynamic subtest: pipe-B-eDP-1-4
[516.068002] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[516.078933] Starting dynamic subtest: pipe-B-eDP-1-x
[518.270397] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[518.635077] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[521.409994] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.762s)
[521.423134] Starting dynamic subtest: pipe-C-eDP-1-4
[523.575838] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[523.587676] Starting dynamic subtest: pipe-C-eDP-1-4
[525.585142] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[525.598264] Starting dynamic subtest: pipe-C-eDP-1-x
[527.762980] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[528.128738] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[530.917173] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[530.931001] Starting dynamic subtest: pipe-D-eDP-1-4
[533.102010] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[533.114274] Starting dynamic subtest: pipe-D-eDP-1-4
[535.111451] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[535.122871] Starting dynamic subtest: pipe-D-eDP-1-x
[537.289932] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[537.292725] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.159s)
[538.498088] [113/133] (486s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[538.610008] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[538.615435] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[538.705279] [114/133] (486s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[538.761772] Starting subtest: etime-multi-wait-for-submit-submitted
[538.867894] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[538.951977] [115/133] (486s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[540.984740] Starting subtest: modeset-non-lpsp-stress-no-wait
[541.040520] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.054s)
[541.381350] [116/133] (483s left) gem_exec_params (sol-reset-invalid)
[541.449593] Starting subtest: sol-reset-invalid
[541.455530] Subtest sol-reset-invalid: SUCCESS (0.003s)
[542.844721] [117/133] (482s left) gem_mmap_gtt (cpuset-big-copy)
[542.906826] Subtest cpuset-big-copy: SKIP (0.000s)
[542.966052] [118/133] (482s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[543.062997] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[550.746684] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.688s)
[550.862676] [119/133] (474s left) kms_psr (psr2-sprite-plane-onoff)
[550.961034] Starting subtest: psr2-sprite-plane-onoff
[550.963390] Starting dynamic subtest: eDP-1
[552.693992] Dynamic subtest eDP-1: SUCCESS (1.732s)
[552.696353] Subtest psr2-sprite-plane-onoff: SUCCESS (1.733s)
[553.550081] [120/133] (471s left) kms_dsc (dsc-with-output-formats)
[553.636373] Starting subtest: dsc-with-output-formats
[553.660551] Subtest dsc-with-output-formats: SKIP (0.000s)
[553.725209] [121/133] (471s left) gen3_mixed_blits
[553.846850] [122/133] (471s left) gem_mmap_offset (clear-via-pagefault)
[553.904890] Starting subtest: clear-via-pagefault
[553.907394] Starting dynamic subtest: smem0
[586.680626] Dynamic subtest smem0: SUCCESS (32.771s)
[586.683590] Subtest clear-via-pagefault: SUCCESS (32.773s)
[586.784195] [123/133] (438s left) gem_eio (reset-stress)
[587.023263] Starting subtest: reset-stress
[587.025694] Starting dynamic subtest: render
[592.094278] Dynamic subtest render: SUCCESS (5.069s)
[592.110818] Starting dynamic subtest: bsd1
[610.392019] Dynamic subtest bsd1: SUCCESS (18.294s)
[610.409272] Starting dynamic subtest: bsd2
[628.358817] Dynamic subtest bsd2: SUCCESS (17.965s)
[628.374428] Starting dynamic subtest: blt
[628.379710] Dynamic subtest blt: SKIP (0.000s)
[628.390284] Starting dynamic subtest: vebox
[646.371678] Dynamic subtest vebox: SUCCESS (18.008s)
[646.374668] Subtest reset-stress: SUCCESS (59.341s)
[647.932771] [124/133] (377s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[647.997511] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[647.999847] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[648.101259] [125/133] (377s left) kms_vblank (query-busy-hang)
[648.189812] Starting subtest: query-busy-hang
[648.192244] Starting dynamic subtest: pipe-A-eDP-1
[650.068351] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[650.085272] Starting dynamic subtest: pipe-D-eDP-1
[652.599239] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s)
[652.601930] Subtest query-busy-hang: SUCCESS (4.413s)
[653.414248] [126/133] (372s left) kms_psr (fbc-pr-cursor-plane-onoff)
[653.499500] Starting subtest: fbc-pr-cursor-plane-onoff
[653.504237] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[653.575413] [127/133] (372s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[653.693792] Starting subtest: psr-1p-primscrn-cur-indfb-move
[661.111228] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.420s)
[661.234213] [128/133] (364s left) tools_test (sysfs_l3_parity)
[661.291607] Starting subtest: sysfs_l3_parity
[661.366892] Subtest sysfs_l3_parity: SKIP (0.089s)
[661.420857] [129/133] (364s left) kms_vblank (crtc-id)
[661.506902] Starting subtest: crtc-id
[661.509613] Starting dynamic subtest: pipe-A-eDP-1
[661.951701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[661.968810] Starting dynamic subtest: pipe-D-eDP-1
[663.040830] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.088s)
[663.043622] Subtest crtc-id: SUCCESS (1.535s)
[663.875532] [130/133] (362s left) gem_ctx_engines (independent)
[663.942380] Starting subtest: independent
[663.945305] Starting dynamic subtest: rcs0
[664.108328] Dynamic subtest rcs0: SUCCESS (0.164s)
[664.119515] Starting dynamic subtest: bcs0
[664.276007] Dynamic subtest bcs0: SUCCESS (0.166s)
[664.290146] Starting dynamic subtest: vcs0
[664.440518] Dynamic subtest vcs0: SUCCESS (0.164s)
[664.454150] Starting dynamic subtest: vcs1
[664.608136] Dynamic subtest vcs1: SUCCESS (0.166s)
[664.621811] Starting dynamic subtest: vecs0
[664.762585] Dynamic subtest vecs0: SUCCESS (0.154s)
[664.777161] Starting dynamic subtest: ccs0
[664.920434] Dynamic subtest ccs0: SUCCESS (0.157s)
[664.936039] Starting dynamic subtest: all-engines
[665.780118] Dynamic subtest all-engines: SUCCESS (0.858s)
[665.783013] Subtest independent: SUCCESS (1.836s)
[666.192918] [131/133] (359s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[666.285220] Starting subtest: flip-vs-dpms-on-nop-interruptible
[666.287877] Starting dynamic subtest: A-eDP1
[668.160237] Dynamic subtest A-eDP1: SUCCESS (1.873s)
[668.173739] Starting dynamic subtest: B-eDP1
[670.000628] Dynamic subtest B-eDP1: SUCCESS (1.838s)
[670.018114] Starting dynamic subtest: C-eDP1
[671.807461] Dynamic subtest C-eDP1: SUCCESS (1.803s)
[671.819819] Starting dynamic subtest: D-eDP1
[673.644732] Dynamic subtest D-eDP1: SUCCESS (1.836s)
[673.647588] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.362s)
[674.834029] [132/133] (351s left) kms_plane_lowres (tiling-x)
[674.937781] Starting subtest: tiling-x
[674.940519] Starting dynamic subtest: pipe-A-eDP-1
[674.945764] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[675.235631] Starting dynamic subtest: pipe-B-eDP-1
[675.240966] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[675.251996] Starting dynamic subtest: pipe-C-eDP-1
[675.257411] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[675.268772] Starting dynamic subtest: pipe-D-eDP-1
[675.273893] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[675.279046] Subtest tiling-x: SKIP (0.297s)
[676.056682] [133/133] (350s left) i915_pm_freq_api (freq-reset)
[676.132887] Starting subtest: freq-reset
[676.136006] Starting dynamic subtest: gt0
[676.316005] Dynamic subtest gt0: SUCCESS (0.186s)
[676.329067] Starting dynamic subtest: gt1
[676.493612] Dynamic subtest gt1: SUCCESS (0.172s)
[676.496680] Subtest freq-reset: SUCCESS (0.361s)
[676.565316] 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.