[57.726143] Initializing watchdogs
[57.726190]   /dev/watchdog0
[57.740331] [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]
[57.744563] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.747143] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.750306] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[57.874598] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[57.878642] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[57.984727] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[58.079164] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[58.083255] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[58.161386] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[58.270804] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[58.969448] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.702s)
[59.112982] [004/133] (959s left) gen7_exec_parse (basic-offset)
[59.178950] Subtest basic-offset: SKIP (0.000s)
[59.245388] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[59.355478] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[63.545995] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.202s)
[64.705217] [006/133] (953s left) tools_test (tools_test)
[64.764692] Starting subtest: tools_test
[64.817073] Subtest tools_test: SUCCESS (0.069s)
[64.890246] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[64.992633] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[64.997041] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[66.150080] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[66.253606] Starting subtest: modeset-vs-vblank-race
[66.256103] Starting dynamic subtest: A-eDP1
[70.942431] Dynamic subtest A-eDP1: SUCCESS (4.692s)
[70.951082] Starting dynamic subtest: B-eDP1
[75.677062] Dynamic subtest B-eDP1: SUCCESS (4.734s)
[75.687342] Starting dynamic subtest: C-eDP1
[80.289326] Dynamic subtest C-eDP1: SUCCESS (4.612s)
[80.299512] Starting dynamic subtest: D-eDP1
[84.933659] Dynamic subtest D-eDP1: SUCCESS (4.644s)
[84.938602] Subtest modeset-vs-vblank-race: SUCCESS (18.692s)
[86.115717] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[88.054682] Starting subtest: reg-read-ioctl
[90.444621] Subtest reg-read-ioctl: SUCCESS (2.390s)
[90.839896] [010/133] (927s left) gem_exec_balancer (hang)
[91.104425] Starting subtest: hang
[92.884300] Subtest hang: SUCCESS (1.782s)
[93.015118] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[93.118180] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[93.122707] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[93.195174] [012/133] (925s left) perf_pmu (faulting-read)
[93.235326] Starting subtest: faulting-read
[93.237616] Starting dynamic subtest: wb
[93.239928] Dynamic subtest wb: SUCCESS (0.001s)
[93.250800] Starting dynamic subtest: wc
[93.252737] Dynamic subtest wc: SUCCESS (0.000s)
[93.260022] Starting dynamic subtest: uc
[93.261959] Dynamic subtest uc: SUCCESS (0.000s)
[93.263893] Subtest faulting-read: SUCCESS (0.002s)
[93.337230] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[93.432832] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[93.437122] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[93.522980] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[93.912635] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[94.732841] [015/133] (924s left) gem_exec_schedule (pi-distinct-iova)
[94.917937] Starting subtest: pi-distinct-iova
[94.920293] Starting dynamic subtest: rcs0
[94.991054] Dynamic subtest rcs0: SUCCESS (0.075s)
[95.003149] Starting dynamic subtest: vcs0
[95.061451] Dynamic subtest vcs0: SUCCESS (0.070s)
[95.072913] Starting dynamic subtest: vcs1
[95.129097] Dynamic subtest vcs1: SUCCESS (0.065s)
[95.140575] Starting dynamic subtest: vecs0
[95.190802] Dynamic subtest vecs0: SUCCESS (0.061s)
[95.204252] Starting dynamic subtest: ccs0
[95.257589] Dynamic subtest ccs0: SUCCESS (0.067s)
[95.260678] Subtest pi-distinct-iova: SUCCESS (0.341s)
[97.010977] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[97.108800] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[97.113147] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[97.197939] [017/133] (921s left) drm_read (short-buffer-block)
[97.350743] Starting subtest: short-buffer-block
[97.353685] Subtest short-buffer-block: SUCCESS (0.000s)
[97.483758] [018/133] (921s left) perf (oa-formats)
[97.618467] Starting subtest: oa-formats
[97.620701] Starting dynamic subtest: 0-rcs0
[97.633367] Dynamic subtest 0-rcs0: SUCCESS (0.018s)
[97.643480] Starting dynamic subtest: 1-vcs1
[97.654457] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[97.656691] Subtest oa-formats: SUCCESS (0.039s)
[97.701450] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[97.795245] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[97.799591] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[97.904993] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[97.997508] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[98.000881] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[98.086213] [021/133] (920s left) kms_psr (pr-basic)
[98.187343] Starting subtest: pr-basic
[98.190963] Subtest pr-basic: SKIP (0.000s)
[98.257468] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[98.338690] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[98.340708] Starting dynamic subtest: pipe-A-eDP-1
[98.360067] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.368992] Starting dynamic subtest: pipe-B-eDP-1
[98.387179] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.394542] Starting dynamic subtest: pipe-C-eDP-1
[98.412558] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.419635] Starting dynamic subtest: pipe-D-eDP-1
[98.437914] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.441487] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[100.544696] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[100.925344] Subtest hdmi-mode-timings: SKIP (0.000s)
[101.741269] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[101.892883] Starting subtest: dp-mst-lic-type-0-hdcp14
[101.897549] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[101.996350] [025/133] (917s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[102.098131] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[102.102393] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[102.168472] [026/133] (917s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[102.262821] Starting subtest: primary-4-tiled-reflect-x-180
[109.207083] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.947s)
[110.417687] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[110.508786] Starting subtest: 2x-flip-vs-panning-interruptible
[110.519268] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[110.595092] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[110.685411] Starting subtest: plain-flip-fb-recreate
[110.687871] Starting dynamic subtest: A-eDP1
[119.509136] Dynamic subtest A-eDP1: SUCCESS (8.826s)
[119.518530] Starting dynamic subtest: B-eDP1
[128.343966] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[128.353824] Starting dynamic subtest: C-eDP1
[137.154534] Dynamic subtest C-eDP1: SUCCESS (8.809s)
[137.164295] Starting dynamic subtest: D-eDP1
[145.992361] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[145.994435] Subtest plain-flip-fb-recreate: SUCCESS (35.313s)
[147.180758] [029/133] (872s left) gem_tiled_partial_pwrite_pread (writes)
[147.253557] Subtest writes: SKIP (0.000s)
[147.307929] [030/133] (872s left) gem_lmem_swapping (heavy-verify-random)
[147.356901] Subtest heavy-verify-random: SKIP (0.000s)
[147.395317] [031/133] (872s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[147.506297] Starting subtest: x-tiled-64bpp-rotate-90
[147.524643] Subtest x-tiled-64bpp-rotate-90: SKIP (0.018s)
[147.636778] [032/133] (871s left) vgem_basic (debugfs)
[147.726612] Starting subtest: debugfs
[147.728522] Subtest debugfs: SUCCESS (0.000s)
[147.777920] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[147.781195] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[147.869049] Starting subtest: legacy-setmode
[147.871191] Starting dynamic subtest: pipe-A-eDP-1
[154.782503] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.913s)
[154.784695] Subtest legacy-setmode: SUCCESS (6.914s)
[155.672341] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[155.795810] Starting subtest: reject-modify-context-protection-off-2
[155.798413] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[155.899277] [035/133] (863s left) gem_exec_basic (basic)
[155.961456] Starting subtest: basic
[155.963692] Starting dynamic subtest: rcs0-smem
[155.965972] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[155.974637] Starting dynamic subtest: bcs0-smem
[155.976550] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[155.983842] Starting dynamic subtest: vcs0-smem
[155.985645] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[155.992837] Starting dynamic subtest: vcs1-smem
[155.994663] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[156.001941] Starting dynamic subtest: vecs0-smem
[156.003831] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[156.011674] Starting dynamic subtest: ccs0-smem
[156.013565] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[156.015456] Subtest basic: SUCCESS (0.011s)
[157.953176] [036/133] (861s left) api_intel_bb (offset-control)
[158.021373] Starting subtest: offset-control
[158.026018] Subtest offset-control: SUCCESS (0.007s)
[158.165929] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[158.268257] Starting subtest: basic-max-non-joiner
[158.272602] Subtest basic-max-non-joiner: SKIP (0.000s)
[158.334551] [038/133] (861s left) kms_addfb_basic (small-bo)
[158.435078] Starting subtest: small-bo
[158.436944] Subtest small-bo: SUCCESS (0.000s)
[158.538586] [039/133] (861s left) i915_query (query-topology-garbage-items)
[158.602307] Starting subtest: query-topology-garbage-items
[158.604223] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[158.703481] [040/133] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[158.798695] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[158.832644] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.032s)
[158.873510] [041/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[160.865287] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[160.869345] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[160.961744] [042/133] (858s left) gem_exec_params (cliprects-invalid)
[161.021523] Starting subtest: cliprects-invalid
[161.023914] Subtest cliprects-invalid: SUCCESS (0.000s)
[161.112483] [043/133] (858s left) kms_cursor_crc (cursor-random-64x64)
[161.287465] Starting subtest: cursor-random-64x64
[161.296640] Starting dynamic subtest: pipe-A-eDP-1
[164.652194] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.356s)
[164.680207] Starting dynamic subtest: pipe-D-eDP-1
[168.784388] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.111s)
[168.786713] Subtest cursor-random-64x64: SUCCESS (7.495s)
[169.612618] [044/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[169.716936] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[169.721692] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[169.816696] [045/133] (850s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[169.912347] Starting subtest: 4-tiled-16bpp-rotate-180
[171.257851] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.345s)
[171.387910] [046/133] (848s left) dumb_buffer (create-valid-dumb)
[171.438225] Starting subtest: create-valid-dumb
[171.440060] Subtest create-valid-dumb: SUCCESS (0.000s)
[171.534656] [047/133] (848s left) gem_softpin (zero)
[171.595324] Starting subtest: zero
[171.601467] Subtest zero: SUCCESS (0.004s)
[171.732283] [048/133] (848s left) gem_blits (basic)
[171.785247] Starting subtest: basic
[173.203809] Subtest basic: SUCCESS (1.406s)
[173.303307] [049/133] (846s left) gem_busy (close-race)
[173.369459] Starting subtest: close-race
[198.834436] Subtest close-race: SUCCESS (25.463s)
[199.207378] [050/133] (821s left) gem_exec_alignment (forked)
[199.297549] Starting subtest: forked
[236.744117] Subtest forked: SUCCESS (37.444s)
[237.128896] [051/133] (783s left) syncobj_eventfd (binary-wait-before-signal)
[237.221034] Starting subtest: binary-wait-before-signal
[237.251784] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[237.348341] [052/133] (782s left) prime_mmap (test_errors)
[237.402868] Starting subtest: test_errors
[237.404753] Starting dynamic subtest: test_errors-smem
[237.496075] Dynamic subtest test_errors-smem: SUCCESS (0.095s)
[237.498836] Subtest test_errors: SUCCESS (0.096s)
[237.603293] [053/133] (782s left) gem_ctx_persistence (heartbeat-stop)
[237.664673] Starting subtest: heartbeat-stop
[237.668789] Subtest heartbeat-stop: SKIP (0.000s)
[237.776221] [054/133] (782s left) gem_ctx_param (invalid-get-ringsize)
[237.828632] Starting subtest: invalid-get-ringsize
[237.830759] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[237.922780] [055/133] (782s left) i915_query (query-topology-matches-eu-total)
[237.981192] Starting subtest: query-topology-matches-eu-total
[237.983597] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[238.086960] [056/133] (782s left) kms_cursor_edge_walk (64x64-right-edge)
[238.185106] Starting subtest: 64x64-right-edge
[238.186997] Starting dynamic subtest: pipe-A-eDP-1
[241.648844] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[241.659080] Starting dynamic subtest: pipe-D-eDP-1
[244.772310] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[244.774540] Subtest 64x64-right-edge: SUCCESS (6.588s)
[245.597212] [057/133] (774s left) kms_plane (plane-position-covered)
[245.703058] Starting subtest: plane-position-covered
[246.228649] Starting dynamic subtest: pipe-A-plane-1
[247.491303] Dynamic subtest pipe-A-plane-1: SUCCESS (1.262s)
[247.501855] Starting dynamic subtest: pipe-A-plane-2
[248.820612] Dynamic subtest pipe-A-plane-2: SUCCESS (1.328s)
[248.830482] Starting dynamic subtest: pipe-A-plane-3
[250.137441] Dynamic subtest pipe-A-plane-3: SUCCESS (1.316s)
[250.147342] Starting dynamic subtest: pipe-A-plane-4
[251.454978] Dynamic subtest pipe-A-plane-4: SUCCESS (1.318s)
[251.465693] Starting dynamic subtest: pipe-A-plane-5
[251.481328] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[252.626788] Starting dynamic subtest: pipe-B-plane-1
[253.937507] Dynamic subtest pipe-B-plane-1: SUCCESS (1.321s)
[253.948215] Starting dynamic subtest: pipe-B-plane-2
[255.159332] Dynamic subtest pipe-B-plane-2: SUCCESS (1.221s)
[255.169502] Starting dynamic subtest: pipe-B-plane-3
[256.409908] Dynamic subtest pipe-B-plane-3: SUCCESS (1.249s)
[256.419891] Starting dynamic subtest: pipe-B-plane-4
[257.657463] Dynamic subtest pipe-B-plane-4: SUCCESS (1.249s)
[257.667569] Starting dynamic subtest: pipe-B-plane-5
[257.684374] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[257.686388] Subtest plane-position-covered: SUCCESS (11.979s)
[258.526780] [058/133] (762s left) kms_frontbuffer_tracking (psr-suspend)
[258.633839] Starting subtest: psr-suspend
[296.776686] Subtest psr-suspend: SUCCESS (8.075s)
[296.898872] [059/133] (723s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[297.025432] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[297.030491] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[297.111359] [060/133] (723s left) gem_exec_schedule (fairslice)
[297.192136] Starting subtest: fairslice
[297.194492] Starting dynamic subtest: rcs0
[299.206427] Dynamic subtest rcs0: SUCCESS (2.034s)
[299.218307] Starting dynamic subtest: bcs0
[301.227226] Dynamic subtest bcs0: SUCCESS (2.028s)
[301.239023] Starting dynamic subtest: vcs0
[303.246829] Dynamic subtest vcs0: SUCCESS (2.026s)
[303.258032] Starting dynamic subtest: vcs1
[305.264346] Dynamic subtest vcs1: SUCCESS (2.023s)
[305.275227] Starting dynamic subtest: vecs0
[307.285482] Dynamic subtest vecs0: SUCCESS (2.023s)
[307.296761] Starting dynamic subtest: ccs0
[309.304201] Dynamic subtest ccs0: SUCCESS (2.025s)
[309.306615] Subtest fairslice: SUCCESS (12.164s)
[309.601673] [061/133] (711s left) sw_sync (alloc_fence_invalid_timeline)
[309.639443] Starting subtest: alloc_fence_invalid_timeline
[309.642336] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[309.690843] [062/133] (711s left) gem_exec_whisper (basic-fds-forked)
[309.769419] Starting subtest: basic-fds-forked
[337.469428] Subtest basic-fds-forked: SUCCESS (27.714s)
[337.655825] [063/133] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[337.763418] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[337.768606] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[337.860850] [064/133] (682s left) gem_vm_create (execbuf)
[337.918231] Starting subtest: execbuf
[337.926293] Subtest execbuf: SUCCESS (0.008s)
[338.037756] [065/133] (682s left) kms_cursor_crc (cursor-onscreen-256x85)
[338.313935] Starting subtest: cursor-onscreen-256x85
[338.359923] Subtest cursor-onscreen-256x85: SKIP (0.039s)
[338.516126] [066/133] (682s left) kms_plane_alpha_blend (coverage-7efc)
[338.620856] Starting subtest: coverage-7efc
[338.921819] Starting dynamic subtest: pipe-A-eDP-1
[339.500175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[339.530467] Starting dynamic subtest: pipe-D-eDP-1
[340.843933] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s)
[340.846359] Subtest coverage-7efc: SUCCESS (2.222s)
[341.677694] [067/133] (679s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[341.766277] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[341.768837] Starting dynamic subtest: pipe-A
[341.789362] Dynamic subtest pipe-A: SKIP (0.017s)
[341.802202] Starting dynamic subtest: pipe-B
[341.821119] Dynamic subtest pipe-B: SKIP (0.032s)
[341.833369] Starting dynamic subtest: pipe-C
[341.859260] Dynamic subtest pipe-C: SKIP (0.037s)
[341.871150] Starting dynamic subtest: pipe-D
[341.893451] Dynamic subtest pipe-D: SKIP (0.034s)
[341.897887] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.122s)
[341.993929] [068/133] (678s left) vgem_basic (busy-fence)
[342.045464] Starting subtest: busy-fence
[342.047871] Subtest busy-fence: SUCCESS (0.000s)
[342.102675] [069/133] (678s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[342.186115] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[342.216291] Starting dynamic subtest: pipe-A-plane-0
[342.659718] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[342.669890] Starting dynamic subtest: pipe-A-plane-3
[342.914716] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[342.924179] Starting dynamic subtest: pipe-A-plane-5
[342.927830] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[344.063643] Starting dynamic subtest: pipe-B-plane-0
[344.568616] Dynamic subtest pipe-B-plane-0: SUCCESS (0.511s)
[344.579667] Starting dynamic subtest: pipe-B-plane-3
[344.823377] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[344.834353] Starting dynamic subtest: pipe-B-plane-5
[344.839174] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[345.152130] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.967s)
[345.957669] [070/133] (675s left) kms_addfb_basic (invalid-set-prop-any)
[346.013175] Starting subtest: invalid-set-prop-any
[346.015631] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[346.140956] [071/133] (674s left) kms_addfb_basic (size-max)
[346.246748] Starting subtest: size-max
[346.248904] Subtest size-max: SUCCESS (0.000s)
[346.329924] [072/133] (674s left) kms_addfb_basic (bad-pitch-128)
[346.374902] Starting subtest: bad-pitch-128
[346.376970] Subtest bad-pitch-128: SUCCESS (0.000s)
[346.503969] [073/133] (674s left) syncobj_timeline (single-wait-available-submitted)
[346.557098] Starting subtest: single-wait-available-submitted
[346.559667] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[346.654451] [074/133] (674s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[346.753546] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[347.959159] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.207s)
[348.072532] [075/133] (673s left) gem_pread (exhaustion)
[348.134982] Subtest exhaustion: SKIP (0.000s)
[348.199724] [076/133] (673s left) kms_frontbuffer_tracking (psr-1p-rte)
[348.308232] Starting subtest: psr-1p-rte
[353.625551] Subtest psr-1p-rte: SUCCESS (5.322s)
[353.766356] [077/133] (667s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[353.884462] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[371.510121] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.629s)
[372.307494] [078/133] (649s left) api_intel_allocator (fork-simple-once)
[372.367415] Starting subtest: fork-simple-once
[372.381480] Subtest fork-simple-once: SUCCESS (0.016s)
[372.500487] [079/133] (648s left) gem_set_tiling_vs_pwrite
[372.614386] [080/133] (648s left) kms_pm_backlight (brightness-with-dpms)
[372.714320] Starting subtest: brightness-with-dpms
[372.775172] Starting dynamic subtest: eDP-1
[375.209456] Dynamic subtest eDP-1: SUCCESS (2.435s)
[375.212647] Subtest brightness-with-dpms: SUCCESS (2.495s)
[376.061714] [081/133] (645s left) kms_lease (lease-invalid-crtc)
[376.162793] Starting subtest: lease-invalid-crtc
[376.165167] Starting dynamic subtest: pipe-A-eDP-1
[376.167563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[376.177169] Starting dynamic subtest: pipe-B-eDP-1
[376.179726] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[376.189293] Starting dynamic subtest: pipe-C-eDP-1
[376.192024] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[376.201110] Starting dynamic subtest: pipe-D-eDP-1
[376.203431] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[376.205864] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[376.246514] [082/133] (645s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[376.344849] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[376.350330] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[376.444298] [083/133] (645s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[376.544900] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[383.490480] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.952s)
[383.630042] [084/133] (638s left) kms_dp_linktrain_fallback (dp-fallback)
[383.729830] Starting subtest: dp-fallback
[383.737224] Subtest dp-fallback: SKIP (0.000s)
[383.802659] [085/133] (637s left) kms_vblank (ts-continuation-idle)
[383.886345] Starting subtest: ts-continuation-idle
[383.889057] Starting dynamic subtest: pipe-A-eDP-1
[384.294161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[384.312696] Starting dynamic subtest: pipe-D-eDP-1
[385.381733] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.086s)
[385.384507] Subtest ts-continuation-idle: SUCCESS (1.497s)
[386.248280] [086/133] (635s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[386.354216] Starting subtest: fbc-psr-cursor-mmap-gtt
[386.356765] Starting dynamic subtest: eDP-1
[386.361699] Dynamic subtest eDP-1: SKIP (0.000s)
[386.367022] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[386.429026] [087/133] (635s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[386.538756] Starting subtest: cursor-vs-flip-varying-size
[417.678105] Subtest cursor-vs-flip-varying-size: SUCCESS (31.132s)
[418.482812] [088/133] (603s left) i915_drm_fdinfo (busy-check-all)
[418.525138] Starting subtest: busy-check-all
[418.527189] Starting dynamic subtest: rcs0
[418.532127] Dynamic subtest rcs0: SKIP (0.004s)
[418.542266] Starting dynamic subtest: bcs0
[418.546959] Dynamic subtest bcs0: SKIP (0.000s)
[418.556182] Starting dynamic subtest: vcs0
[418.560990] Dynamic subtest vcs0: SKIP (0.000s)
[418.570309] Starting dynamic subtest: vcs1
[418.574933] Dynamic subtest vcs1: SKIP (0.000s)
[418.584147] Starting dynamic subtest: vecs0
[418.588929] Dynamic subtest vecs0: SKIP (0.000s)
[418.598182] Starting dynamic subtest: ccs0
[418.602907] Dynamic subtest ccs0: SKIP (0.000s)
[418.607470] Subtest busy-check-all: SKIP (0.009s)
[418.645711] [089/133] (603s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[418.773823] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[418.776110] Starting dynamic subtest: pipe-A-eDP-1
[418.801077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[418.812516] Starting dynamic subtest: pipe-B-eDP-1
[418.835315] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[418.845086] Starting dynamic subtest: pipe-C-eDP-1
[418.867540] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[418.877247] Starting dynamic subtest: pipe-D-eDP-1
[418.901166] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[418.903799] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[420.973159] [090/133] (600s left) prime_busy (before-wait)
[421.035122] Starting subtest: before-wait
[421.041217] Starting dynamic subtest: rcs0
[421.070978] Dynamic subtest rcs0: SUCCESS (0.032s)
[421.084192] Starting dynamic subtest: bcs0
[421.121233] Dynamic subtest bcs0: SUCCESS (0.049s)
[421.135238] Starting dynamic subtest: vcs0
[421.163652] Dynamic subtest vcs0: SUCCESS (0.042s)
[421.175491] Starting dynamic subtest: vcs1
[421.205192] Dynamic subtest vcs1: SUCCESS (0.041s)
[421.216185] Starting dynamic subtest: vecs0
[421.247028] Dynamic subtest vecs0: SUCCESS (0.041s)
[421.258291] Starting dynamic subtest: ccs0
[421.289744] Dynamic subtest ccs0: SUCCESS (0.042s)
[421.398096] Subtest before-wait: SUCCESS (0.361s)
[421.473783] [091/133] (600s left) gem_ppgtt (blt-vs-render-ctx0)
[421.536294] Starting subtest: blt-vs-render-ctx0
[454.311616] Subtest blt-vs-render-ctx0: SUCCESS (32.780s)
[454.449633] [092/133] (567s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[454.629980] Starting subtest: cursorB-vs-flipB-atomic
[454.635241] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[454.772768] [093/133] (567s left) gem_exec_reloc (basic-wc-read-active)
[454.835414] Subtest basic-wc-read-active: SKIP (0.000s)
[454.906801] [094/133] (567s left) gem_exec_fence (syncobj-import)
[455.410086] Starting subtest: syncobj-import
[455.415493] Subtest syncobj-import: SUCCESS (0.006s)
[457.054931] [095/133] (565s left) kms_psr (fbc-psr2-sprite-blt)
[457.149330] Starting subtest: fbc-psr2-sprite-blt
[457.152250] Starting dynamic subtest: eDP-1
[457.157878] Dynamic subtest eDP-1: SKIP (0.000s)
[457.163143] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[457.228794] [096/133] (564s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[457.330716] Starting subtest: plane-lut1d-post-ctm3x4
[457.466312] Starting dynamic subtest: pipe-A-plane-0
[457.632189] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[457.642815] Starting dynamic subtest: pipe-A-plane-1
[457.776444] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[457.786940] Starting dynamic subtest: pipe-A-plane-2
[457.921623] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[459.139474] Starting dynamic subtest: pipe-B-plane-0
[459.279794] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[459.290913] Starting dynamic subtest: pipe-B-plane-1
[459.413431] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[459.424435] Starting dynamic subtest: pipe-B-plane-2
[459.558457] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[460.785991] Starting dynamic subtest: pipe-C-plane-0
[460.903928] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[460.917782] Starting dynamic subtest: pipe-C-plane-1
[461.049164] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[461.059930] Starting dynamic subtest: pipe-C-plane-2
[461.193033] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[462.422681] Starting dynamic subtest: pipe-D-plane-0
[462.561687] Dynamic subtest pipe-D-plane-0: SUCCESS (0.154s)
[462.572434] Starting dynamic subtest: pipe-D-plane-1
[462.728154] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[462.738162] Starting dynamic subtest: pipe-D-plane-2
[462.885197] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[463.173272] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.845s)
[463.976893] [097/133] (558s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[464.038814] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[464.043633] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[464.220500] [098/133] (558s left) kms_big_fb (linear-8bpp-rotate-180)
[464.317734] Starting subtest: linear-8bpp-rotate-180
[465.587704] Subtest linear-8bpp-rotate-180: SUCCESS (1.270s)
[465.713144] [099/133] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[465.805911] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[465.810560] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[465.923780] [100/133] (556s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[466.016132] Starting subtest: extended-modeset-hang-oldfb-with-reset
[466.018249] Starting dynamic subtest: pipe-A
[477.552515] Dynamic subtest pipe-A: SUCCESS (11.534s)
[477.564772] Starting dynamic subtest: pipe-D
[489.814603] Dynamic subtest pipe-D: SUCCESS (12.266s)
[489.817420] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.804s)
[490.619808] [101/133] (531s left) gem_exec_schedule (timeslicing)
[490.714226] Starting subtest: timeslicing
[490.716862] Starting dynamic subtest: rcs0
[490.723116] Dynamic subtest rcs0: SUCCESS (0.023s)
[490.734357] Starting dynamic subtest: bcs0
[490.745235] Dynamic subtest bcs0: SUCCESS (0.022s)
[490.756134] Starting dynamic subtest: vcs0
[490.767372] Dynamic subtest vcs0: SUCCESS (0.022s)
[490.777708] Starting dynamic subtest: vcs1
[490.788161] Dynamic subtest vcs1: SUCCESS (0.020s)
[490.798498] Starting dynamic subtest: vecs0
[490.808969] Dynamic subtest vecs0: SUCCESS (0.020s)
[490.819372] Starting dynamic subtest: ccs0
[490.830288] Dynamic subtest ccs0: SUCCESS (0.020s)
[490.833289] Subtest timeslicing: SUCCESS (0.131s)
[492.035684] [102/133] (530s left) kms_chamelium_color (ctm-0-25)
[492.138346] Subtest ctm-0-25: SKIP (0.000s)
[492.188938] [103/133] (530s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[492.280193] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[492.282938] Starting dynamic subtest: pipe-A-eDP-1
[492.375493] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[492.386814] Starting dynamic subtest: pipe-B-eDP-1
[493.496776] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[493.502201] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.223s)
[494.797451] [104/133] (527s left) gem_mmap (short-mmap)
[494.855249] Subtest short-mmap: SKIP (0.000s)
[494.925540] [105/133] (527s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[494.989272] Starting subtest: multi-wait-available-unsubmitted-submitted
[494.991721] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[495.093073] [106/133] (527s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[495.183210] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[495.188354] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[495.292855] [107/133] (527s left) kms_getfb (getfb2-accept-nv12)
[495.392023] Starting subtest: getfb2-accept-nv12
[495.394675] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[495.490795] [108/133] (527s left) syncobj_timeline (invalid-signal-zero-handles)
[495.551187] Starting subtest: invalid-signal-zero-handles
[495.554179] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[495.661964] [109/133] (527s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[495.768206] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[495.773307] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[495.843624] [110/133] (526s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[495.932083] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[495.934002] Starting dynamic subtest: pipe-A-eDP-1
[495.988023] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[495.998011] Starting dynamic subtest: pipe-B-eDP-1
[496.054828] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[496.065709] Starting dynamic subtest: pipe-C-eDP-1
[496.125989] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[496.139507] Starting dynamic subtest: pipe-D-eDP-1
[496.195415] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[496.199825] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[498.255581] [111/133] (524s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[498.359275] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[498.367170] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[498.448693] [112/133] (524s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[498.536321] Starting subtest: async-flip-with-page-flip-events-tiled
[498.921151] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[501.738718] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.818s)
[501.750025] Starting dynamic subtest: pipe-A-eDP-1-4
[503.912085] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s)
[503.922372] Starting dynamic subtest: pipe-A-eDP-1-4
[505.921264] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[505.935567] Starting dynamic subtest: pipe-A-eDP-1-x
[508.099825] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[508.478481] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[511.275363] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[511.288395] Starting dynamic subtest: pipe-B-eDP-1-4
[513.469647] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.194s)
[513.480299] Starting dynamic subtest: pipe-B-eDP-1-4
[515.479196] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[515.492571] Starting dynamic subtest: pipe-B-eDP-1-x
[517.680258] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[518.048855] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[520.797304] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.758s)
[520.807907] Starting dynamic subtest: pipe-C-eDP-1-4
[522.983569] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s)
[522.997494] Starting dynamic subtest: pipe-C-eDP-1-4
[524.994829] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[525.005453] Starting dynamic subtest: pipe-C-eDP-1-x
[527.185651] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[527.553878] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[530.338460] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[530.352450] Starting dynamic subtest: pipe-D-eDP-1-4
[532.523460] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[532.534561] Starting dynamic subtest: pipe-D-eDP-1-4
[534.534830] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[534.545383] Starting dynamic subtest: pipe-D-eDP-1-x
[536.713884] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[536.716305] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.179s)
[537.967918] [113/133] (484s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[538.061953] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[538.066634] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[538.166923] [114/133] (484s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[538.227990] Starting subtest: etime-multi-wait-for-submit-submitted
[538.332066] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[538.409231] [115/133] (484s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[540.134369] Starting subtest: modeset-non-lpsp-stress-no-wait
[540.187346] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.051s)
[540.675419] [116/133] (482s left) gem_exec_params (sol-reset-invalid)
[540.739797] Starting subtest: sol-reset-invalid
[540.742119] Subtest sol-reset-invalid: SUCCESS (0.003s)
[542.044520] [117/133] (481s left) gem_mmap_gtt (cpuset-big-copy)
[542.110347] Subtest cpuset-big-copy: SKIP (0.000s)
[542.173711] [118/133] (480s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[542.280056] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[549.900246] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.625s)
[550.014664] [119/133] (473s left) kms_psr (psr2-sprite-plane-onoff)
[550.110342] Starting subtest: psr2-sprite-plane-onoff
[550.113130] Starting dynamic subtest: eDP-1
[551.810443] Dynamic subtest eDP-1: SUCCESS (1.699s)
[551.813241] Subtest psr2-sprite-plane-onoff: SUCCESS (1.700s)
[552.667758] [120/133] (470s left) kms_dsc (dsc-with-output-formats)
[552.755037] Starting subtest: dsc-with-output-formats
[552.781375] Subtest dsc-with-output-formats: SKIP (0.001s)
[552.842870] [121/133] (470s left) gen3_mixed_blits
[552.970582] [122/133] (470s left) gem_mmap_offset (clear-via-pagefault)
[553.023209] Starting subtest: clear-via-pagefault
[553.025800] Starting dynamic subtest: smem0
[586.715355] Dynamic subtest smem0: SUCCESS (33.683s)
[586.718491] Subtest clear-via-pagefault: SUCCESS (33.686s)
[586.825328] [123/133] (436s left) gem_eio (reset-stress)
[587.056937] Starting subtest: reset-stress
[587.059449] Starting dynamic subtest: render
[592.062978] Dynamic subtest render: SUCCESS (5.004s)
[592.081481] Starting dynamic subtest: bsd1
[610.647063] Dynamic subtest bsd1: SUCCESS (18.584s)
[610.663349] Starting dynamic subtest: bsd2
[628.491037] Dynamic subtest bsd2: SUCCESS (17.844s)
[628.508865] Starting dynamic subtest: blt
[628.513151] Dynamic subtest blt: SKIP (0.000s)
[628.523549] Starting dynamic subtest: vebox
[646.516220] Dynamic subtest vebox: SUCCESS (18.025s)
[646.519011] Subtest reset-stress: SUCCESS (59.463s)
[647.999291] [124/133] (375s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[648.068041] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[648.070775] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[648.187335] [125/133] (375s left) kms_vblank (query-busy-hang)
[648.284098] Starting subtest: query-busy-hang
[648.286534] Starting dynamic subtest: pipe-A-eDP-1
[650.177036] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.892s)
[650.193972] Starting dynamic subtest: pipe-D-eDP-1
[652.727706] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[652.730333] Subtest query-busy-hang: SUCCESS (4.444s)
[653.528222] [126/133] (369s left) kms_psr (fbc-pr-cursor-plane-onoff)
[653.617130] Starting subtest: fbc-pr-cursor-plane-onoff
[653.622320] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[653.693219] [127/133] (369s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[653.797146] Starting subtest: psr-1p-primscrn-cur-indfb-move
[661.120927] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.329s)
[661.254912] [128/133] (362s left) tools_test (sysfs_l3_parity)
[661.311243] Starting subtest: sysfs_l3_parity
[661.373216] Subtest sysfs_l3_parity: SKIP (0.075s)
[661.426100] [129/133] (362s left) kms_vblank (crtc-id)
[661.524387] Starting subtest: crtc-id
[661.527259] Starting dynamic subtest: pipe-A-eDP-1
[661.969427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[661.987445] Starting dynamic subtest: pipe-D-eDP-1
[663.070945] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.102s)
[663.073434] Subtest crtc-id: SUCCESS (1.549s)
[663.908297] [130/133] (359s left) gem_ctx_engines (independent)
[663.972172] Starting subtest: independent
[663.974699] Starting dynamic subtest: rcs0
[664.135905] Dynamic subtest rcs0: SUCCESS (0.162s)
[664.147061] Starting dynamic subtest: bcs0
[664.292378] Dynamic subtest bcs0: SUCCESS (0.156s)
[664.303938] Starting dynamic subtest: vcs0
[664.459995] Dynamic subtest vcs0: SUCCESS (0.166s)
[664.470287] Starting dynamic subtest: vcs1
[664.621271] Dynamic subtest vcs1: SUCCESS (0.161s)
[664.633553] Starting dynamic subtest: vecs0
[664.802331] Dynamic subtest vecs0: SUCCESS (0.180s)
[664.816071] Starting dynamic subtest: ccs0
[664.969051] Dynamic subtest ccs0: SUCCESS (0.166s)
[664.984301] Starting dynamic subtest: all-engines
[665.701208] Dynamic subtest all-engines: SUCCESS (0.731s)
[665.704202] Subtest independent: SUCCESS (1.730s)
[666.150000] [131/133] (357s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[666.242703] Starting subtest: flip-vs-dpms-on-nop-interruptible
[666.245293] Starting dynamic subtest: A-eDP1
[668.126126] Dynamic subtest A-eDP1: SUCCESS (1.877s)
[668.140013] Starting dynamic subtest: B-eDP1
[669.946610] Dynamic subtest B-eDP1: SUCCESS (1.823s)
[669.959572] Starting dynamic subtest: C-eDP1
[671.756436] Dynamic subtest C-eDP1: SUCCESS (1.808s)
[671.769313] Starting dynamic subtest: D-eDP1
[673.603247] Dynamic subtest D-eDP1: SUCCESS (1.844s)
[673.608509] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.367s)
[674.787403] [132/133] (348s left) kms_plane_lowres (tiling-x)
[674.878450] Starting subtest: tiling-x
[674.881124] Starting dynamic subtest: pipe-A-eDP-1
[674.886231] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[675.174783] Starting dynamic subtest: pipe-B-eDP-1
[675.180229] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[675.190987] Starting dynamic subtest: pipe-C-eDP-1
[675.196429] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[675.207135] Starting dynamic subtest: pipe-D-eDP-1
[675.212485] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[675.218231] Subtest tiling-x: SKIP (0.294s)
[676.026447] [133/133] (347s left) i915_pm_freq_api (freq-reset)
[676.086460] Starting subtest: freq-reset
[676.088997] Starting dynamic subtest: gt0
[676.268890] Dynamic subtest gt0: SUCCESS (0.185s)
[676.281364] Starting dynamic subtest: gt1
[676.437181] Dynamic subtest gt1: SUCCESS (0.168s)
[676.439847] Subtest freq-reset: SUCCESS (0.355s)
[676.527342] 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.