[58.039018] Initializing watchdogs
[58.039068]   /dev/watchdog0
[58.053096] [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]
[58.057689] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.059994] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.063896] [001/132] (960s left) gem_request_retire (retire-vma-not-inactive)
[58.154700] Starting subtest: retire-vma-not-inactive
[58.218537] Subtest retire-vma-not-inactive: SUCCESS (0.063s)
[58.354941] [002/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[58.459584] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[58.463719] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[58.569484] [003/132] (960s left) gem_exec_params (rel-constants-invalid)
[58.635814] Starting subtest: rel-constants-invalid
[58.638288] Subtest rel-constants-invalid: SUCCESS (0.000s)
[58.731026] [004/132] (959s left) kms_vblank (wait-idle-hang)
[58.826494] Starting subtest: wait-idle-hang
[58.828454] Starting dynamic subtest: pipe-A-eDP-1
[85.649923] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.859s)
[85.663749] Starting dynamic subtest: pipe-D-eDP-1
[110.702285] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.048s)
[110.704464] Subtest wait-idle-hang: SUCCESS (51.911s)
[111.510652] [005/132] (907s left) kms_vrr (seamless-rr-switch-vrr)
[111.611599] Starting subtest: seamless-rr-switch-vrr
[111.618171] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[111.695399] [006/132] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[111.789898] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[115.734185] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.947s)
[116.904211] [007/132] (901s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[116.995641] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[120.731252] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.741s)
[121.895154] [008/132] (896s left) gem_lmem_swapping (parallel-random-verify-ccs)
[121.949891] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[121.993923] [009/132] (896s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[122.404707] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[123.201031] [010/132] (895s left) kms_psr (psr-cursor-plane-onoff)
[123.297833] Starting subtest: psr-cursor-plane-onoff
[123.300287] Starting dynamic subtest: eDP-1
[125.029058] Dynamic subtest eDP-1: SUCCESS (1.732s)
[125.031472] Subtest psr-cursor-plane-onoff: SUCCESS (1.732s)
[125.890698] [011/132] (893s left) gem_userptr_blits (dmabuf-unsync)
[125.954741] Subtest dmabuf-unsync: SKIP (0.000s)
[126.075193] [012/132] (892s left) kms_flip_event_leak (basic)
[126.167527] Starting subtest: basic
[126.169477] Starting dynamic subtest: pipe-A-eDP-1
[126.600736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[126.609616] Starting dynamic subtest: pipe-B-eDP-1
[127.720282] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.119s)
[127.728441] Starting dynamic subtest: pipe-C-eDP-1
[128.819505] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.098s)
[128.827975] Starting dynamic subtest: pipe-D-eDP-1
[129.959916] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[129.962180] Subtest basic: SUCCESS (3.794s)
[130.817215] [013/132] (888s left) gem_exec_reloc (basic-cpu-active)
[130.877194] Subtest basic-cpu-active: SKIP (0.000s)
[130.952212] [014/132] (888s left) gem_render_tiled_blits (basic)
[131.011319] Subtest basic: SKIP (0.000s)
[131.085026] [015/132] (888s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[131.190764] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[131.193051] Starting dynamic subtest: pipe-A-eDP-1
[131.201808] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[131.210833] Starting dynamic subtest: pipe-B-eDP-1
[131.219868] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[131.227391] Starting dynamic subtest: pipe-C-eDP-1
[131.236265] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[131.243139] Starting dynamic subtest: pipe-D-eDP-1
[131.251871] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[131.256342] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[133.491477] [016/132] (885s left) i915_drm_fdinfo (virtual-busy)
[133.533322] Starting subtest: virtual-busy
[133.537358] Subtest virtual-busy: SKIP (0.000s)
[133.610751] [017/132] (885s left) kms_prop_blob (invalid-get-prop)
[133.660470] Starting subtest: invalid-get-prop
[133.662835] Subtest invalid-get-prop: SUCCESS (0.000s)
[133.750356] [018/132] (885s left) gen9_exec_parse (batch-invalid-length)
[133.805468] Subtest batch-invalid-length: SKIP (0.000s)
[133.878835] [019/132] (885s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[133.942156] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[134.015786] [020/132] (885s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[134.107333] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[134.109522] Starting dynamic subtest: pipe-A-eDP-1
[134.131805] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[134.140322] Starting dynamic subtest: pipe-B-eDP-1
[134.162477] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[134.171528] Starting dynamic subtest: pipe-C-eDP-1
[134.193084] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[134.200144] Starting dynamic subtest: pipe-D-eDP-1
[134.225175] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[134.229515] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[136.360242] [021/132] (882s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[136.468387] Starting subtest: extended-modeset-hang-newfb-with-reset
[136.470747] Starting dynamic subtest: pipe-A
[152.033579] Dynamic subtest pipe-A: SUCCESS (15.564s)
[152.041541] Starting dynamic subtest: pipe-D
[167.588498] Dynamic subtest pipe-D: SUCCESS (15.548s)
[167.590871] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.116s)
[168.412573] [022/132] (850s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[168.521958] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[168.526486] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[168.613472] [023/132] (850s left) gem_softpin (evict-snoop-interruptible)
[168.671997] Starting subtest: evict-snoop-interruptible
[168.676230] Subtest evict-snoop-interruptible: SKIP (0.000s)
[168.778357] [024/132] (850s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[168.875400] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[168.879790] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[168.941304] [025/132] (850s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[169.042299] Starting subtest: y-tiled-8bpp-rotate-0
[169.046465] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[169.142648] [026/132] (850s left) gem_exec_reloc (basic-cpu-gtt)
[169.202367] Subtest basic-cpu-gtt: SKIP (0.000s)
[169.277040] [027/132] (850s left) core_sysfs (read-all-entries)
[169.343556] Starting subtest: read-all-entries
[169.345522] Subtest read-all-entries: SUCCESS (0.003s)
[169.429829] [028/132] (850s left) syncobj_wait (wait-for-submit-delayed-submit)
[169.487344] Starting subtest: wait-for-submit-delayed-submit
[169.591941] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[169.676230] [029/132] (850s left) gem_eio (wait-immediate)
[169.858222] Starting subtest: wait-immediate
[170.148908] Subtest wait-immediate: SUCCESS (0.291s)
[170.286749] [030/132] (849s left) gem_exec_big (single)
[170.352506] Starting subtest: single
[172.819162] Subtest single: FAIL (2.405s)
[172.859377] [031/132] (846s left) prime_mmap (test_forked)
[172.948887] Starting subtest: test_forked
[172.951114] Starting dynamic subtest: test_forked-smem
[172.988486] Dynamic subtest test_forked-smem: SUCCESS (0.041s)
[172.990630] Subtest test_forked: SUCCESS (0.042s)
[173.090182] [032/132] (846s left) fbdev (unaligned-read)
[173.129214] Starting subtest: unaligned-read
[173.144727] Subtest unaligned-read: SUCCESS (0.016s)
[173.196019] [033/132] (846s left) kms_cursor_edge_walk (128x128-right-edge)
[173.297705] Starting subtest: 128x128-right-edge
[173.300058] Starting dynamic subtest: pipe-A-eDP-1
[176.759306] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[176.767730] Starting dynamic subtest: pipe-D-eDP-1
[179.888896] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[179.891189] Subtest 128x128-right-edge: SUCCESS (6.591s)
[180.687990] [034/132] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[180.790243] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[180.794653] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[180.884521] [035/132] (839s left) gem_exec_fence (syncobj-timeline-unused-fence)
[181.450577] Starting subtest: syncobj-timeline-unused-fence
[181.456027] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[183.004344] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[183.007892] [036/132] (836s left) syncobj_eventfd (invalid-illegal-handle)
[183.062892] Starting subtest: invalid-illegal-handle
[183.065194] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[183.164269] [037/132] (836s left) perf (invalid-open-flags)
[183.298222] Starting subtest: invalid-open-flags
[183.300767] Subtest invalid-open-flags: SUCCESS (0.000s)
[183.338557] [038/132] (836s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[183.442196] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[184.132528] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[184.282570] [039/132] (835s left) gem_pread (exhaustion)
[184.348483] Subtest exhaustion: SKIP (0.000s)
[184.406958] [040/132] (835s left) api_intel_allocator (fork-simple-stress)
[184.466123] Starting subtest: fork-simple-stress
[189.880368] Subtest fork-simple-stress: SUCCESS (5.412s)
[190.002539] [041/132] (830s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[190.117035] Starting subtest: psr-1p-primscrn-spr-indfb-move
[197.677575] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.564s)
[197.807641] [042/132] (822s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[197.914773] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[197.927329] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[198.015014] [043/132] (822s left) gem_exec_whisper (basic-sync)
[198.085506] Starting subtest: basic-sync
[205.907313] Subtest basic-sync: SUCCESS (7.819s)
[206.094521] [044/132] (814s left) kms_psr (fbc-psr2-suspend)
[206.203610] Starting subtest: fbc-psr2-suspend
[206.205734] Starting dynamic subtest: eDP-1
[206.209667] Dynamic subtest eDP-1: SKIP (0.000s)
[206.213681] Subtest fbc-psr2-suspend: SKIP (0.001s)
[206.286873] [045/132] (814s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[206.376277] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[206.378590] Starting dynamic subtest: pipe-A-eDP-1
[206.399266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[206.409976] Starting dynamic subtest: pipe-B-eDP-1
[206.429907] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[206.438587] Starting dynamic subtest: pipe-C-eDP-1
[206.457960] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[206.466356] Starting dynamic subtest: pipe-D-eDP-1
[206.485710] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[206.487938] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[208.581636] [046/132] (811s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[208.670787] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[208.673066] Starting dynamic subtest: pipe-A-eDP-1
[208.693422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[208.703769] Starting dynamic subtest: pipe-B-eDP-1
[208.723121] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[208.731843] Starting dynamic subtest: pipe-C-eDP-1
[208.750761] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[208.759141] Starting dynamic subtest: pipe-D-eDP-1
[208.778239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[208.780099] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[210.941201] [047/132] (809s left) kms_plane_lowres (tiling-none)
[211.046196] Starting subtest: tiling-none
[211.048485] Starting dynamic subtest: pipe-A-eDP-1
[211.052899] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.360102] Starting dynamic subtest: pipe-B-eDP-1
[211.364988] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.376048] Starting dynamic subtest: pipe-C-eDP-1
[211.380421] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.389589] Starting dynamic subtest: pipe-D-eDP-1
[211.394073] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.398235] Subtest tiling-none: SKIP (0.314s)
[212.184872] [048/132] (808s left) i915_drm_fdinfo (virtual-idle)
[212.230250] Starting subtest: virtual-idle
[215.294058] Subtest virtual-idle: SUCCESS (3.063s)
[215.384005] [049/132] (805s left) kms_psr (psr-sprite-mmap-gtt)
[215.485597] Starting subtest: psr-sprite-mmap-gtt
[215.487826] Starting dynamic subtest: eDP-1
[216.907715] Dynamic subtest eDP-1: SKIP (1.419s)
[216.912192] Subtest psr-sprite-mmap-gtt: SKIP (1.420s)
[217.051994] [050/132] (803s left) kms_flip (2x-plain-flip-interruptible)
[217.153611] Starting subtest: 2x-plain-flip-interruptible
[217.165393] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[217.247439] [051/132] (803s left) kms_dsc (dsc-fractional-bpp)
[217.350712] Starting subtest: dsc-fractional-bpp
[217.363144] Subtest dsc-fractional-bpp: SKIP (0.000s)
[217.440250] [052/132] (803s left) gem_ctx_persistence (engines-hang)
[217.493760] Starting subtest: engines-hang
[217.496165] Starting dynamic subtest: rcs0
[217.624478] Dynamic subtest rcs0: SUCCESS (0.130s)
[217.636676] Starting dynamic subtest: bcs0
[217.721096] Dynamic subtest bcs0: SUCCESS (0.094s)
[217.732807] Starting dynamic subtest: vcs0
[217.793266] Dynamic subtest vcs0: SUCCESS (0.070s)
[217.805423] Starting dynamic subtest: vcs1
[217.909905] Dynamic subtest vcs1: SUCCESS (0.115s)
[217.921245] Starting dynamic subtest: vecs0
[218.023667] Dynamic subtest vecs0: SUCCESS (0.112s)
[218.035207] Starting dynamic subtest: ccs0
[218.074737] Dynamic subtest ccs0: SUCCESS (0.050s)
[218.077109] Subtest engines-hang: SUCCESS (0.581s)
[218.155265] [053/132] (802s left) prime_busy (hang)
[218.209199] Starting subtest: hang
[218.211071] Starting dynamic subtest: rcs0
[244.402913] Dynamic subtest rcs0: SUCCESS (26.187s)
[244.413621] Starting dynamic subtest: bcs0
[251.559492] Dynamic subtest bcs0: SUCCESS (7.156s)
[251.567600] Starting dynamic subtest: vcs0
[258.594980] Dynamic subtest vcs0: SUCCESS (7.035s)
[258.603233] Starting dynamic subtest: vcs1
[265.566618] Dynamic subtest vcs1: SUCCESS (6.974s)
[265.575209] Starting dynamic subtest: vecs0
[272.549663] Dynamic subtest vecs0: SUCCESS (6.979s)
[272.557853] Starting dynamic subtest: ccs0
[286.447830] Dynamic subtest ccs0: SUCCESS (13.895s)
[286.450078] Subtest hang: SUCCESS (68.232s)
[286.580870] [054/132] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[286.696673] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[286.701067] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[286.797284] [055/132] (733s left) gem_exec_reloc (basic-cpu-wc)
[286.854439] Subtest basic-cpu-wc: SKIP (0.000s)
[286.932928] [056/132] (733s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[287.316125] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[288.114916] [057/132] (732s left) gem_ctx_engines (execute-one)
[288.170858] Starting subtest: execute-one
[290.765121] Subtest execute-one: SUCCESS (2.595s)
[290.946847] [058/132] (729s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[291.007817] Starting subtest: etime-single-wait-available-unsubmitted
[291.113325] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[291.185485] [059/132] (729s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[291.309900] Starting subtest: flip-vs-cursor-busy-crc-legacy
[292.126684] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.817s)
[292.970505] [060/132] (727s left) kms_vblank (invalid)
[293.068778] Starting subtest: invalid
[293.070703] Starting dynamic subtest: pipe-A-eDP-1
[293.477304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[293.479580] Subtest invalid: SUCCESS (0.410s)
[294.299517] [061/132] (726s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[294.404350] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[294.408743] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[294.490390] [062/132] (726s left) gem_exec_flush (basic-uc-set-default)
[294.553334] Starting subtest: basic-uc-set-default
[300.010417] Subtest basic-uc-set-default: SUCCESS (5.457s)
[300.194294] [063/132] (720s left) gem_userptr_blits (nohangcheck)
[300.269836] Starting subtest: nohangcheck
[300.584465] Subtest nohangcheck: SUCCESS (0.313s)
[300.701703] [064/132] (720s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[300.799925] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[300.804105] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[300.870326] [065/132] (720s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[300.927242] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[301.012445] [066/132] (720s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[301.103997] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[301.106292] Starting dynamic subtest: pipe-A-eDP-1
[301.130769] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[301.144104] Starting dynamic subtest: pipe-B-eDP-1
[301.167443] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[301.177387] Starting dynamic subtest: pipe-C-eDP-1
[301.200502] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[301.209246] Starting dynamic subtest: pipe-D-eDP-1
[301.234167] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[301.238229] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[303.380680] [067/132] (717s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[303.648869] Starting subtest: cursor-rapid-movement-256x85
[303.694564] Subtest cursor-rapid-movement-256x85: SKIP (0.044s)
[303.883086] [068/132] (717s left) kms_cursor_legacy (single-move)
[304.003244] Starting subtest: single-move
[304.005087] Starting dynamic subtest: pipe-A
[309.385022] Dynamic subtest pipe-A: SUCCESS (5.379s)
[309.395455] Starting dynamic subtest: pipe-B
[314.767810] Dynamic subtest pipe-B: SUCCESS (5.379s)
[314.778658] Starting dynamic subtest: pipe-C
[320.148876] Dynamic subtest pipe-C: SUCCESS (5.379s)
[320.159556] Starting dynamic subtest: pipe-D
[325.530032] Dynamic subtest pipe-D: SUCCESS (5.378s)
[325.540373] Starting dynamic subtest: all-pipes
[330.920184] Dynamic subtest all-pipes: SUCCESS (5.387s)
[330.922699] Subtest single-move: SUCCESS (26.914s)
[331.062219] [069/132] (690s left) gem_fenced_exec_thrash (no-spare-fences)
[331.132823] Subtest no-spare-fences: SKIP (0.000s)
[331.207843] [070/132] (690s left) kms_getfb (getfb2-into-addfb2)
[331.308764] Starting subtest: getfb2-into-addfb2
[331.311045] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[331.413033] [071/132] (689s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[331.509232] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[331.513161] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[331.613634] [072/132] (689s left) api_intel_bb (destroy-bb)
[331.674899] Starting subtest: destroy-bb
[331.683561] Subtest destroy-bb: SUCCESS (0.008s)
[331.798011] [073/132] (689s left) syncobj_timeline (wait-all-for-submit-snapshot)
[331.852071] Starting subtest: wait-all-for-submit-snapshot
[331.932645] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[332.019717] [074/132] (689s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[332.119887] Starting subtest: psr-rgb565-draw-render
[339.132389] Subtest psr-rgb565-draw-render: SUCCESS (7.013s)
[339.238361] [075/132] (682s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[339.345244] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[346.429020] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.088s)
[346.531269] [076/132] (675s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[346.600497] Subtest writes-after-reads-uncached: SKIP (0.000s)
[346.673329] [077/132] (674s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[346.767300] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[346.771531] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[346.868336] [078/132] (674s left) gem_partial_pwrite_pread (writes-after-reads-display)
[346.922834] Subtest writes-after-reads-display: SKIP (0.000s)
[346.996552] [079/132] (674s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[347.091080] Starting subtest: plane-ctm3x4-lut1d
[347.261281] Starting dynamic subtest: pipe-A-plane-0
[347.583644] Dynamic subtest pipe-A-plane-0: FAIL (0.176s)
[347.594501] Starting dynamic subtest: pipe-A-plane-1
[347.795863] Dynamic subtest pipe-A-plane-1: FAIL (0.191s)
[347.805332] Starting dynamic subtest: pipe-A-plane-2
[348.013178] Dynamic subtest pipe-A-plane-2: FAIL (0.183s)
[349.062274] Starting dynamic subtest: pipe-B-plane-0
[349.486731] Dynamic subtest pipe-B-plane-0: FAIL (0.169s)
[349.497967] Starting dynamic subtest: pipe-B-plane-1
[349.809349] Dynamic subtest pipe-B-plane-1: FAIL (0.171s)
[349.820143] Starting dynamic subtest: pipe-B-plane-2
[350.123393] Dynamic subtest pipe-B-plane-2: FAIL (0.185s)
[350.785889] Starting dynamic subtest: pipe-C-plane-0
[351.299691] Dynamic subtest pipe-C-plane-0: FAIL (0.152s)
[351.310923] Starting dynamic subtest: pipe-C-plane-1
[351.712172] Dynamic subtest pipe-C-plane-1: FAIL (0.617s)
[351.728711] Starting dynamic subtest: pipe-C-plane-2
[352.084844] Dynamic subtest pipe-C-plane-2: FAIL (0.171s)
[352.899856] Starting dynamic subtest: pipe-D-plane-0
[353.498206] Dynamic subtest pipe-D-plane-0: FAIL (0.141s)
[353.507786] Starting dynamic subtest: pipe-D-plane-1
[353.960499] Dynamic subtest pipe-D-plane-1: FAIL (0.609s)
[353.970902] Starting dynamic subtest: pipe-D-plane-2
[354.404878] Dynamic subtest pipe-D-plane-2: FAIL (0.564s)
[354.526395] Subtest plane-ctm3x4-lut1d: FAIL (7.435s)
[355.397068] [080/132] (666s left) kms_cursor_crc (cursor-onscreen-max-size)
[355.713107] Starting subtest: cursor-onscreen-max-size
[355.719569] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[355.842409] [081/132] (666s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[355.961791] Starting subtest: cursorA-vs-flipB-legacy
[355.966336] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[356.107992] [082/132] (665s left) i915_suspend (sysfs-reader)
[356.162140] Starting subtest: sysfs-reader
[374.322538] Subtest sysfs-reader: SUCCESS (3.241s)
[374.408250] [083/132] (647s left) kms_plane_scaling (planes-upscale-20x20)
[374.516176] Starting subtest: planes-upscale-20x20
[374.518197] Starting dynamic subtest: pipe-A
[374.579513] Dynamic subtest pipe-A: SUCCESS (0.064s)
[374.590963] Starting dynamic subtest: pipe-B
[375.674921] Dynamic subtest pipe-B: SUCCESS (1.112s)
[375.686995] Starting dynamic subtest: pipe-C
[376.776112] Dynamic subtest pipe-C: SUCCESS (1.115s)
[376.786585] Starting dynamic subtest: pipe-D
[377.900653] Dynamic subtest pipe-D: SUCCESS (1.138s)
[377.903010] Subtest planes-upscale-20x20: SUCCESS (3.434s)
[379.051618] [084/132] (642s left) gem_render_copy (yf-tiled-ccs-to-linear)
[379.115544] Starting subtest: yf-tiled-ccs-to-linear
[379.120059] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[379.298143] [085/132] (642s left) kms_async_flips (alternate-sync-async-flip-atomic)
[379.384792] Starting subtest: alternate-sync-async-flip-atomic
[379.765253] Starting dynamic subtest: pipe-A-eDP-1
[382.510864] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.767s)
[382.892989] Starting dynamic subtest: pipe-B-eDP-1
[385.618461] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[385.997077] Starting dynamic subtest: pipe-C-eDP-1
[388.741318] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[389.110042] Starting dynamic subtest: pipe-D-eDP-1
[391.858857] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[391.861035] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.537s)
[393.027594] [086/132] (629s left) gem_exec_create (madvise)
[393.106336] Starting subtest: madvise
[393.108711] Starting dynamic subtest: smem
[413.926664] Dynamic subtest smem: SUCCESS (20.826s)
[413.929299] Subtest madvise: SUCCESS (20.827s)
[414.990933] [087/132] (607s left) perf_pmu (multi-client)
[415.030718] Starting subtest: multi-client
[415.033095] Starting dynamic subtest: rcs0
[416.083469] Dynamic subtest rcs0: SUCCESS (1.054s)
[416.096273] Starting dynamic subtest: bcs0
[417.137655] Dynamic subtest bcs0: SUCCESS (1.050s)
[417.150165] Starting dynamic subtest: vcs0
[418.190827] Dynamic subtest vcs0: SUCCESS (1.051s)
[418.203290] Starting dynamic subtest: vcs1
[419.875197] Dynamic subtest vcs1: SUCCESS (1.681s)
[419.888341] Starting dynamic subtest: vecs0
[421.856671] Dynamic subtest vecs0: SUCCESS (1.978s)
[421.869245] Starting dynamic subtest: ccs0
[423.840853] Dynamic subtest ccs0: SUCCESS (1.980s)
[423.843743] Subtest multi-client: SUCCESS (8.812s)
[423.970792] [088/132] (598s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[424.085070] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[424.089088] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[424.188126] [089/132] (598s left) gem_exec_balancer (bonded-dual)
[424.249985] Starting subtest: bonded-dual
[424.254692] Subtest bonded-dual: SKIP (0.000s)
[424.564906] [090/132] (597s left) kms_pm_rpm (basic-pci-d3-state)
[426.121277] Starting subtest: basic-pci-d3-state
[427.730240] Subtest basic-pci-d3-state: SUCCESS (1.613s)
[427.856847] [091/132] (594s left) i915_pm_rps (engine-order)
[427.917819] Starting subtest: engine-order
[432.844004] Subtest engine-order: SUCCESS (4.928s)
[432.978752] [092/132] (589s left) gem_exec_schedule (submit-late-slice)
[433.049488] Starting subtest: submit-late-slice
[433.052168] Starting dynamic subtest: rcs0
[433.098209] Dynamic subtest rcs0: SUCCESS (0.058s)
[433.108477] Starting dynamic subtest: bcs0
[433.149283] Dynamic subtest bcs0: SUCCESS (0.050s)
[433.161466] Starting dynamic subtest: vcs0
[433.203367] Dynamic subtest vcs0: SUCCESS (0.053s)
[433.219095] Starting dynamic subtest: vcs1
[433.255118] Dynamic subtest vcs1: SUCCESS (0.051s)
[433.270180] Starting dynamic subtest: vecs0
[433.307849] Dynamic subtest vecs0: SUCCESS (0.051s)
[433.319018] Starting dynamic subtest: ccs0
[433.359989] Dynamic subtest ccs0: SUCCESS (0.050s)
[433.362492] Subtest submit-late-slice: SUCCESS (0.320s)
[434.943801] [093/132] (587s left) kms_lease (master-vs-lease)
[435.050573] Starting subtest: master-vs-lease
[435.052766] Subtest master-vs-lease: SUCCESS (0.002s)
[435.171814] [094/132] (587s left) kms_async_flips (test-time-stamp-atomic)
[435.273122] Starting subtest: test-time-stamp-atomic
[435.646336] Starting dynamic subtest: pipe-A-eDP-1
[436.476173] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[436.853991] Starting dynamic subtest: pipe-B-eDP-1
[437.602033] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.754s)
[437.989151] Starting dynamic subtest: pipe-C-eDP-1
[438.739878] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[439.106377] Starting dynamic subtest: pipe-D-eDP-1
[439.870042] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[439.872494] Subtest test-time-stamp-atomic: SUCCESS (4.598s)
[441.035453] [095/132] (581s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[441.104491] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[441.212492] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[441.292576] [096/132] (581s left) gem_exec_whisper (basic-contexts-forked-all)
[441.356330] Starting subtest: basic-contexts-forked-all
[459.765338] Subtest basic-contexts-forked-all: SUCCESS (18.411s)
[459.965530] [097/132] (562s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[460.066960] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[460.069359] Starting dynamic subtest: A-eDP1
[463.653725] Dynamic subtest A-eDP1: SUCCESS (3.586s)
[463.665120] Starting dynamic subtest: B-eDP1
[466.850490] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[466.861467] Starting dynamic subtest: C-eDP1
[469.940397] Dynamic subtest C-eDP1: SUCCESS (3.087s)
[469.952727] Starting dynamic subtest: D-eDP1
[473.048543] Dynamic subtest D-eDP1: SUCCESS (3.107s)
[473.050796] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.984s)
[473.851579] [098/132] (548s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[473.951149] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[478.557240] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.608s)
[479.666548] [099/132] (542s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[479.766607] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[480.912628] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.147s)
[481.035267] [100/132] (541s left) syncobj_timeline (reset-during-wait-for-submit)
[481.085449] Starting subtest: reset-during-wait-for-submit
[481.189628] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[481.282262] [101/132] (541s left) kms_psr (fbc-pr-primary-mmap-cpu)
[481.373454] Starting subtest: fbc-pr-primary-mmap-cpu
[481.377793] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[481.459025] [102/132] (541s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[481.524921] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[481.527235] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[481.644614] [103/132] (541s left) vgem_basic (busy-fence)
[481.680677] Starting subtest: busy-fence
[481.682597] Subtest busy-fence: SUCCESS (0.000s)
[481.737987] [104/132] (541s left) gem_exec_schedule (pi-distinct-iova)
[481.923126] Starting subtest: pi-distinct-iova
[481.925772] Starting dynamic subtest: rcs0
[481.998149] Dynamic subtest rcs0: SUCCESS (0.077s)
[482.010957] Starting dynamic subtest: vcs0
[482.061176] Dynamic subtest vcs0: SUCCESS (0.062s)
[482.074886] Starting dynamic subtest: vcs1
[482.115939] Dynamic subtest vcs1: SUCCESS (0.054s)
[482.132530] Starting dynamic subtest: vecs0
[482.182440] Dynamic subtest vecs0: SUCCESS (0.064s)
[482.198071] Starting dynamic subtest: ccs0
[482.238980] Dynamic subtest ccs0: SUCCESS (0.055s)
[482.241307] Subtest pi-distinct-iova: SUCCESS (0.318s)
[483.918861] [105/132] (538s left) gem_exec_reloc (basic-write-wc)
[483.978262] Subtest basic-write-wc: SKIP (0.000s)
[484.052044] [106/132] (538s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[484.153911] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[484.158026] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[484.251986] [107/132] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[484.356865] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[484.361105] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[484.461708] [108/132] (538s left) kms_psr (pr-cursor-plane-move)
[484.549005] Starting subtest: pr-cursor-plane-move
[484.553226] Subtest pr-cursor-plane-move: SKIP (0.000s)
[484.661886] [109/132] (538s left) kms_flip (flip-vs-fences)
[484.770228] Starting subtest: flip-vs-fences
[484.774101] Subtest flip-vs-fences: SKIP (0.000s)
[484.888269] [110/132] (538s left) prime_mmap_coherency (write)
[484.947476] Starting subtest: write
[490.322598] Subtest write: SUCCESS (5.375s)
[490.482759] [111/132] (532s left) gem_exec_fence (syncobj-signal)
[490.975923] Starting subtest: syncobj-signal
[490.981975] Subtest syncobj-signal: SUCCESS (0.007s)
[492.917451] [112/132] (530s left) gem_mmap_offset (isolation)
[492.990065] Starting subtest: isolation
[493.008125] Subtest isolation: SUCCESS (0.009s)
[493.113084] [113/132] (530s left) kms_plane_alpha_blend (constant-alpha-min)
[493.218215] Starting subtest: constant-alpha-min
[493.506139] Starting dynamic subtest: pipe-A-eDP-1
[494.239529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[494.249965] Starting dynamic subtest: pipe-D-eDP-1
[495.729317] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.487s)
[495.731855] Subtest constant-alpha-min: SUCCESS (2.511s)
[496.526511] [114/132] (526s left) gem_userptr_blits (process-exit)
[496.603886] Starting subtest: process-exit
[496.612157] Subtest process-exit: SUCCESS (0.008s)
[496.738488] [115/132] (526s left) kms_content_protection (dp-mst-type-0)
[496.884888] Starting subtest: dp-mst-type-0
[496.889162] Subtest dp-mst-type-0: SKIP (0.000s)
[497.004812] [116/132] (526s left) kms_psr (fbc-pr-sprite-plane-move)
[497.103532] Starting subtest: fbc-pr-sprite-plane-move
[497.107530] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[497.204651] [117/132] (526s left) kms_frontbuffer_tracking (fbc-tiling-4)
[497.307884] Starting subtest: fbc-tiling-4
[501.551807] Subtest fbc-tiling-4: SUCCESS (4.248s)
[502.751006] [118/132] (520s left) syncobj_wait (single-wait-submitted)
[502.798697] Starting subtest: single-wait-submitted
[502.898813] Subtest single-wait-submitted: SUCCESS (0.102s)
[502.977499] [119/132] (520s left) gem_flink_basic (double-flink)
[503.033466] Starting subtest: double-flink
[503.035921] Subtest double-flink: SUCCESS (0.000s)
[503.138585] [120/132] (520s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[503.235430] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[503.237710] Starting dynamic subtest: pipe-A
[503.585120] Dynamic subtest pipe-A: SUCCESS (0.351s)
[503.595802] Starting dynamic subtest: pipe-B
[505.010106] Dynamic subtest pipe-B: SUCCESS (1.424s)
[505.020233] Starting dynamic subtest: pipe-C
[506.439714] Dynamic subtest pipe-C: SUCCESS (1.429s)
[506.452226] Starting dynamic subtest: pipe-D
[507.890175] Dynamic subtest pipe-D: SUCCESS (1.450s)
[507.892323] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.658s)
[509.038766] [121/132] (514s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[509.138225] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[509.142204] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[509.251544] [122/132] (514s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[509.341429] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[509.345557] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[509.413068] [123/132] (514s left) kms_atomic_transition (plane-all-transition-nonblocking)
[509.518233] Starting subtest: plane-all-transition-nonblocking
[509.520760] Starting dynamic subtest: pipe-A-eDP-1
[512.009813] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[512.328976] Starting dynamic subtest: pipe-B-eDP-1
[515.584804] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.267s)
[515.899379] Subtest plane-all-transition-nonblocking: SUCCESS (6.385s)
[516.722119] [124/132] (507s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[518.975320] Starting subtest: modeset-lpsp-stress-no-wait
[528.878785] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.905s)
[528.959926] [125/132] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[529.059645] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[529.063837] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[529.162599] [126/132] (494s left) gem_softpin (evict-prime-sanity-check)
[529.215374] Starting subtest: evict-prime-sanity-check
[529.217654] Starting dynamic subtest: rcs0
[530.346169] Dynamic subtest rcs0: SUCCESS (1.130s)
[530.358727] Starting dynamic subtest: bcs0
[531.468296] Dynamic subtest bcs0: SUCCESS (1.121s)
[531.478861] Starting dynamic subtest: vcs0
[532.834384] Dynamic subtest vcs0: SUCCESS (1.362s)
[532.846483] Starting dynamic subtest: vcs1
[534.813483] Dynamic subtest vcs1: SUCCESS (1.977s)
[534.823900] Starting dynamic subtest: vecs0
[536.797899] Dynamic subtest vecs0: SUCCESS (1.982s)
[536.811135] Starting dynamic subtest: ccs0
[537.919107] Dynamic subtest ccs0: SUCCESS (1.121s)
[537.929839] Starting dynamic subtest: all
[539.058276] Dynamic subtest all: SUCCESS (1.137s)
[539.060814] Subtest evict-prime-sanity-check: SUCCESS (9.846s)
[539.153522] [127/132] (484s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[539.265598] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[546.615993] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.354s)
[546.742255] [128/132] (477s left) kms_big_fb (linear-8bpp-rotate-270)
[546.844181] Starting subtest: linear-8bpp-rotate-270
[546.865624] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[546.983712] [129/132] (476s left) kms_joiner (basic-force-big-joiner)
[547.087466] Starting subtest: basic-force-big-joiner
[547.091432] Subtest basic-force-big-joiner: SKIP (0.000s)
[547.155800] [130/132] (476s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[547.212100] Starting subtest: legacy-engines-hostile-preempt
[547.214673] Starting dynamic subtest: render
[547.288210] Dynamic subtest render: SUCCESS (0.075s)
[547.301098] Starting dynamic subtest: bsd1
[548.814252] Dynamic subtest bsd1: SUCCESS (1.522s)
[548.830609] Starting dynamic subtest: bsd2
[550.820063] Dynamic subtest bsd2: SUCCESS (2.002s)
[550.833168] Starting dynamic subtest: blt
[550.882451] Dynamic subtest blt: SUCCESS (0.061s)
[550.897523] Starting dynamic subtest: vebox
[552.800969] Dynamic subtest vebox: SUCCESS (1.915s)
[552.803560] Subtest legacy-engines-hostile-preempt: SUCCESS (5.590s)
[552.896225] [131/132] (471s left) gem_ringfill (legacy-basic)
[558.827480] Starting subtest: legacy-basic
[558.830505] Starting dynamic subtest: default
[558.893368] Dynamic subtest default: SUCCESS (0.065s)
[558.909007] Starting dynamic subtest: render
[558.937449] Dynamic subtest render: SUCCESS (0.041s)
[558.950851] Starting dynamic subtest: bsd
[558.980279] Dynamic subtest bsd: SUCCESS (0.040s)
[558.991130] Starting dynamic subtest: bsd1
[559.020311] Dynamic subtest bsd1: SUCCESS (0.038s)
[559.033832] Starting dynamic subtest: bsd2
[559.063475] Dynamic subtest bsd2: SUCCESS (0.041s)
[559.074000] Starting dynamic subtest: blt
[559.108254] Dynamic subtest blt: SUCCESS (0.042s)
[559.119339] Starting dynamic subtest: vebox
[559.150264] Dynamic subtest vebox: SUCCESS (0.040s)
[559.152676] Subtest legacy-basic: SUCCESS (0.325s)
[559.231513] [132/132] (464s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[559.342380] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[559.977658] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[560.124870] Closing watchdogs
results: parsing output: 0/ for test: gem_request_retire
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: kms_vrr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_lmem_swapping
results: parsing output: 8/ for test: kms_chamelium_hpd
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: kms_flip_event_leak
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: gem_render_tiled_blits
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: i915_drm_fdinfo
results: parsing output: 16/ for test: kms_prop_blob
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_busy
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: core_sysfs
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: gem_exec_big
results: parsing output: 30/ for test: prime_mmap
results: parsing output: 31/ for test: fbdev
results: parsing output: 32/ for test: kms_cursor_edge_walk
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: syncobj_eventfd
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_pread
results: parsing output: 39/ for test: api_intel_allocator
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: gem_exec_whisper
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_plane_lowres
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_dsc
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: prime_busy
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: gem_ctx_engines
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_exec_flush
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_fenced_exec_thrash
results: parsing output: 69/ for test: kms_getfb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_partial_pwrite_pread
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: kms_color_pipeline
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: i915_suspend
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: kms_async_flips
results: parsing output: 85/ for test: gem_exec_create
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_balancer
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: i915_pm_rps
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: kms_async_flips
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_exec_whisper
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: prime_mmap_coherency
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: gem_mmap_offset
results: parsing output: 112/ for test: kms_plane_alpha_blend
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_content_protection
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_flink_basic
results: parsing output: 119/ for test: kms_plane_scaling
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_atomic_transition
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_joiner
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: gem_ringfill
results: parsing output: 131/ for test: kms_big_fb
Done.