[57.687968] Initializing watchdogs
[57.688024]   /dev/watchdog0
[57.701621] [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.705800] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.708066] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.711195] [001/133] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[57.829018] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[57.831200] Starting dynamic subtest: pipe-A-eDP-1
[57.888141] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[57.896160] Starting dynamic subtest: pipe-B-eDP-1
[57.947758] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[57.956608] Starting dynamic subtest: pipe-C-eDP-1
[58.007982] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[58.016011] Starting dynamic subtest: pipe-D-eDP-1
[58.066731] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[58.069065] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.242s)
[60.307589] [002/133] (957s left) gem_softpin (zero)
[60.364791] Starting subtest: zero
[60.369533] Subtest zero: SUCCESS (0.004s)
[60.483225] [003/133] (957s left) kms_joiner (invalid-modeset-ultra-joiner)
[60.585626] Starting subtest: invalid-modeset-ultra-joiner
[60.589832] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[60.648082] [004/133] (957s left) gem_unfence_active_buffers
[60.824762] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[60.934539] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[60.938670] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[61.029708] [006/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[61.131372] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[61.135566] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[61.218243] [007/133] (957s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[61.331709] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[61.338598] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[61.484360] [008/133] (956s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[61.580166] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[61.582069] Starting dynamic subtest: pipe-A-eDP-1
[61.598934] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[61.607529] Starting dynamic subtest: pipe-B-eDP-1
[61.623292] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[61.629476] Starting dynamic subtest: pipe-C-eDP-1
[61.645246] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[61.651720] Starting dynamic subtest: pipe-D-eDP-1
[61.667525] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[61.669096] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[63.863120] [009/133] (954s left) syncobj_basic (bad-flags-fd-to-handle)
[63.918732] Starting subtest: bad-flags-fd-to-handle
[63.920980] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[64.011278] [010/133] (954s left) gem_userptr_blits (set-cache-level)
[64.070069] Starting subtest: set-cache-level
[64.074410] Subtest set-cache-level: SKIP (0.000s)
[64.177715] [011/133] (954s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[64.593420] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[65.396368] [012/133] (953s left) kms_flip (modeset-vs-vblank-race)
[65.491515] Starting subtest: modeset-vs-vblank-race
[65.493457] Starting dynamic subtest: A-eDP1
[70.173067] Dynamic subtest A-eDP1: SUCCESS (4.692s)
[70.183399] Starting dynamic subtest: B-eDP1
[74.915287] Dynamic subtest B-eDP1: SUCCESS (4.746s)
[74.924272] Starting dynamic subtest: C-eDP1
[79.531038] Dynamic subtest C-eDP1: SUCCESS (4.615s)
[79.539595] Starting dynamic subtest: D-eDP1
[84.068682] Dynamic subtest D-eDP1: SUCCESS (4.535s)
[84.073589] Subtest modeset-vs-vblank-race: SUCCESS (18.597s)
[85.260484] [013/133] (933s left) gem_pxp (display-protected-crc)
[85.393053] Starting subtest: display-protected-crc
[87.048491] Subtest display-protected-crc: SUCCESS (1.658s)
[87.153099] [014/133] (931s left) kms_cursor_crc (cursor-sliding-max-size)
[87.459551] Starting subtest: cursor-sliding-max-size
[87.466255] Subtest cursor-sliding-max-size: SKIP (0.000s)
[87.599107] [015/133] (931s left) prime_vgem (wait)
[87.709991] Starting subtest: wait
[87.712335] Starting dynamic subtest: rcs0
[87.751021] Dynamic subtest rcs0: SUCCESS (0.044s)
[87.758976] Starting dynamic subtest: bcs0
[87.815229] Dynamic subtest bcs0: SUCCESS (0.064s)
[87.822835] Starting dynamic subtest: vcs0
[87.863709] Dynamic subtest vcs0: SUCCESS (0.047s)
[87.872060] Starting dynamic subtest: vcs1
[87.907712] Dynamic subtest vcs1: SUCCESS (0.044s)
[87.915091] Starting dynamic subtest: vecs0
[87.951863] Dynamic subtest vecs0: SUCCESS (0.044s)
[87.959315] Starting dynamic subtest: ccs0
[88.001519] Dynamic subtest ccs0: SUCCESS (0.049s)
[88.003374] Subtest wait: SUCCESS (0.295s)
[88.108417] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[88.111366] [016/133] (930s left) kms_fence_pin_leak
[88.254959] [017/133] (930s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[88.350742] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[88.354266] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.448299] [018/133] (930s left) kms_chamelium_frames (dp-frame-dump)
[88.829119] Subtest dp-frame-dump: SKIP (0.000s)
[89.659510] [019/133] (929s left) gem_mmap (bad-offset)
[89.714856] Subtest bad-offset: SKIP (0.000s)
[89.780369] [020/133] (929s left) kms_cursor_crc (cursor-random-128x42)
[90.007891] Starting subtest: cursor-random-128x42
[90.053161] Subtest cursor-random-128x42: SKIP (0.040s)
[90.243953] [021/133] (928s left) kms_flip (flip-vs-fences)
[90.353170] Starting subtest: flip-vs-fences
[90.357279] Subtest flip-vs-fences: SKIP (0.000s)
[90.478241] [022/133] (928s left) kms_psr (fbc-pr-sprite-plane-move)
[90.573010] Starting subtest: fbc-pr-sprite-plane-move
[90.577412] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[90.649705] [023/133] (928s left) i915_drm_fdinfo (isolation)
[90.691495] Starting subtest: isolation
[90.693388] Starting dynamic subtest: rcs0
[90.714545] Dynamic subtest rcs0: SKIP (0.021s)
[90.724261] Starting dynamic subtest: bcs0
[90.727805] Dynamic subtest bcs0: SKIP (0.000s)
[90.737235] Starting dynamic subtest: vcs0
[90.741178] Dynamic subtest vcs0: SKIP (0.000s)
[90.748580] Starting dynamic subtest: vcs1
[90.751961] Dynamic subtest vcs1: SKIP (0.000s)
[90.758634] Starting dynamic subtest: vecs0
[90.762053] Dynamic subtest vecs0: SKIP (0.000s)
[90.768520] Starting dynamic subtest: ccs0
[90.771925] Dynamic subtest ccs0: SKIP (0.000s)
[90.775374] Subtest isolation: SKIP (0.024s)
[90.812141] [024/133] (928s left) gem_pxp (reject-modify-context-protection-off-1)
[90.865325] Starting subtest: reject-modify-context-protection-off-1
[90.867505] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[90.965696] [025/133] (928s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[91.028304] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[91.032268] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[91.223924] [026/133] (927s left) i915_pm_rpm (debugfs-forcewake-user)
[93.049802] Starting subtest: debugfs-forcewake-user
[104.450974] Subtest debugfs-forcewake-user: SUCCESS (11.401s)
[104.829398] [027/133] (914s left) syncobj_timeline (wait-all-for-submit-snapshot)
[104.891795] Starting subtest: wait-all-for-submit-snapshot
[104.973690] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[105.048059] [028/133] (914s left) kms_hdr (bpc-switch)
[105.132105] Starting subtest: bpc-switch
[106.194221] Starting dynamic subtest: pipe-A-eDP-1
[109.581917] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.389s)
[109.584205] Subtest bpc-switch: SUCCESS (4.452s)
[109.693262] [029/133] (909s left) gem_userptr_blits (unsync-unmap)
[109.776049] Subtest unsync-unmap: SKIP (0.000s)
[109.902968] [030/133] (909s left) kms_cursor_crc (cursor-onscreen-256x256)
[110.149467] Starting subtest: cursor-onscreen-256x256
[110.154580] Starting dynamic subtest: pipe-A-eDP-1
[112.251288] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s)
[112.280376] Starting dynamic subtest: pipe-D-eDP-1
[114.990355] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.716s)
[114.992966] Subtest cursor-onscreen-256x256: SUCCESS (4.840s)
[115.818333] [031/133] (903s left) syncobj_timeline (device-submit-unordered)
[115.873320] Starting subtest: device-submit-unordered
[115.875349] Subtest device-submit-unordered: SUCCESS (0.001s)
[115.960051] [032/133] (903s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[116.068739] Starting subtest: fbcpsr-rgb101010-draw-blt
[122.865561] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.798s)
[122.974862] [033/133] (896s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[123.069237] Starting subtest: fbc-pr-cursor-plane-update-sf
[123.073432] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[123.141158] [034/133] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[123.239391] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[123.243663] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[123.333686] [035/133] (896s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[123.431357] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[124.088445] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[124.241438] [036/133] (895s left) api_intel_bb (purge-bb)
[124.296827] Starting subtest: purge-bb
[124.301410] Subtest purge-bb: SUCCESS (0.004s)
[124.402138] [037/133] (895s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[124.490579] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[131.753082] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.265s)
[131.899196] [038/133] (887s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[132.003786] Starting subtest: psr-rgb565-draw-render
[138.941959] Subtest psr-rgb565-draw-render: SUCCESS (6.941s)
[139.057187] [039/133] (880s left) perf (create-destroy-userspace-config)
[139.184979] Starting subtest: create-destroy-userspace-config
[139.202821] Subtest create-destroy-userspace-config: SUCCESS (0.017s)
[139.240238] [040/133] (880s left) perf (missing-sample-flags)
[139.335325] Starting subtest: missing-sample-flags
[139.337637] Subtest missing-sample-flags: SUCCESS (0.000s)
[139.376396] [041/133] (880s left) gem_exec_balancer (full-late-pulse)
[139.436446] Starting subtest: full-late-pulse
[143.759242] Subtest full-late-pulse: SUCCESS (4.322s)
[144.061382] [042/133] (875s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[144.168914] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[144.173492] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[144.238575] [043/133] (875s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[144.335974] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[144.340348] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[144.439630] [044/133] (875s left) sw_sync (alloc_merge_fence)
[144.481150] Starting subtest: alloc_merge_fence
[144.483043] Subtest alloc_merge_fence: SUCCESS (0.000s)
[144.538232] [045/133] (875s left) kms_plane_multiple (tiling-y)
[144.625777] Starting subtest: tiling-y
[144.630442] Subtest tiling-y: SKIP (0.000s)
[144.697292] [046/133] (875s left) gem_mmap_wc (write-gtt-read-wc)
[144.745834] Subtest write-gtt-read-wc: SKIP (0.000s)
[144.807605] [047/133] (875s left) perf (gen12-group-exclusive-stream-ctx-handle)
[144.894827] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[144.919753] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s)
[144.969960] [048/133] (875s left) gem_mmap_offset (isolation)
[146.807915] Starting subtest: isolation
[146.826093] Subtest isolation: SUCCESS (0.007s)
[146.911449] [049/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[147.010333] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[147.014195] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[147.120131] [050/133] (873s left) gem_ctx_create (basic)
[147.182754] Starting subtest: basic
[147.184977] Subtest basic: SUCCESS (0.000s)
[147.364613] [051/133] (872s left) syncobj_wait (wait-any-interrupted)
[147.419204] Starting subtest: wait-any-interrupted
[147.529040] Subtest wait-any-interrupted: SUCCESS (0.109s)
[147.604375] [052/133] (872s left) gen9_exec_parse (bb-large)
[147.662486] Subtest bb-large: SKIP (0.000s)
[147.726256] [053/133] (872s left) syncobj_timeline (multi-wait-signaled)
[147.782574] Starting subtest: multi-wait-signaled
[147.784805] Subtest multi-wait-signaled: SUCCESS (0.000s)
[147.883907] [054/133] (872s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[148.013837] Starting subtest: multiplane-atomic-fence-wait
[148.336039] Subtest multiplane-atomic-fence-wait: SUCCESS (0.317s)
[149.428289] [055/133] (870s left) kms_invalid_mode (zero-vdisplay)
[149.524279] Starting subtest: zero-vdisplay
[149.526615] Starting dynamic subtest: pipe-A-eDP-1
[149.806127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[149.815092] Starting dynamic subtest: pipe-B-eDP-1
[149.817242] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[149.825159] Starting dynamic subtest: pipe-C-eDP-1
[149.827386] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[149.835310] Starting dynamic subtest: pipe-D-eDP-1
[149.837552] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[149.839814] Subtest zero-vdisplay: SUCCESS (0.293s)
[150.654089] [056/133] (869s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[150.755650] Starting subtest: fbc-rgb101010-draw-blt
[155.352302] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.601s)
[156.461857] [057/133] (863s left) gen3_render_linear_blits
[156.564415] [058/133] (863s left) gem_exec_reloc (basic-concurrent0)
[156.627298] Subtest basic-concurrent0: SKIP (0.000s)
[156.694885] [059/133] (863s left) syncobj_wait (multi-wait-for-submit-signaled)
[156.754930] Starting subtest: multi-wait-for-submit-signaled
[156.757252] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[156.850889] [060/133] (863s left) kms_big_fb (4-tiled-addfb-size-overflow)
[156.956620] Starting subtest: 4-tiled-addfb-size-overflow
[156.958807] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[157.063819] [061/133] (863s left) sw_sync (alloc_fence)
[157.102077] Starting subtest: alloc_fence
[157.104303] Subtest alloc_fence: SUCCESS (0.000s)
[157.149900] [062/133] (863s left) kms_prime (d3hot)
[157.231174] Subtest D3hot: SKIP (0.000s)
[157.323532] [063/133] (863s left) perf_pmu (idle-no-semaphores)
[157.366925] Starting subtest: idle-no-semaphores
[157.369156] Starting dynamic subtest: rcs0
[157.931350] Dynamic subtest rcs0: SUCCESS (0.562s)
[157.941185] Starting dynamic subtest: bcs0
[158.459083] Dynamic subtest bcs0: SUCCESS (0.525s)
[158.468539] Starting dynamic subtest: vcs0
[158.976860] Dynamic subtest vcs0: SUCCESS (0.513s)
[158.985346] Starting dynamic subtest: vcs1
[159.498085] Dynamic subtest vcs1: SUCCESS (0.519s)
[159.507702] Starting dynamic subtest: vecs0
[160.027597] Dynamic subtest vecs0: SUCCESS (0.527s)
[160.037173] Starting dynamic subtest: ccs0
[160.553701] Dynamic subtest ccs0: SUCCESS (0.523s)
[160.556650] Subtest idle-no-semaphores: SUCCESS (3.188s)
[160.664949] [064/133] (860s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[160.756710] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[160.760873] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[160.829409] [065/133] (859s left) kms_pm_dc (dc9-dpms)
[161.940286] Starting subtest: dc9-dpms
[163.364852] Subtest dc9-dpms: SUCCESS (1.425s)
[163.435883] [066/133] (857s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[163.508908] Starting subtest: legacy-engines-hostile-preempt
[163.511224] Starting dynamic subtest: render
[163.583725] Dynamic subtest render: SUCCESS (0.074s)
[163.602428] Starting dynamic subtest: bsd1
[164.859636] Dynamic subtest bsd1: SUCCESS (1.272s)
[164.871474] Starting dynamic subtest: bsd2
[166.862514] Dynamic subtest bsd2: SUCCESS (2.000s)
[166.873527] Starting dynamic subtest: blt
[166.922213] Dynamic subtest blt: SUCCESS (0.058s)
[166.932771] Starting dynamic subtest: vebox
[168.892103] Dynamic subtest vebox: SUCCESS (1.966s)
[168.894910] Subtest legacy-engines-hostile-preempt: SUCCESS (5.383s)
[169.007765] [067/133] (851s left) gem_userptr_blits (create-destroy-sync)
[169.072369] Starting subtest: create-destroy-sync
[174.087083] Subtest create-destroy-sync: SUCCESS (5.014s)
[174.200094] [068/133] (846s left) kms_cursor_legacy (torture-move)
[174.340382] Starting subtest: torture-move
[174.342524] Starting dynamic subtest: pipe-A
[180.275802] Dynamic subtest pipe-A: SUCCESS (5.932s)
[180.295635] Starting dynamic subtest: pipe-B
[187.326064] Dynamic subtest pipe-B: SUCCESS (7.050s)
[187.336281] Starting dynamic subtest: pipe-C
[195.682866] Dynamic subtest pipe-C: SUCCESS (8.353s)
[195.694936] Starting dynamic subtest: pipe-D
[202.713739] Dynamic subtest pipe-D: SUCCESS (7.031s)
[202.723073] Starting dynamic subtest: all-pipes
[210.369731] Dynamic subtest all-pipes: SUCCESS (7.650s)
[210.372363] Subtest torture-move: SUCCESS (36.026s)
[210.524101] [069/133] (810s left) device_reset (cold-reset-bound)
[210.576954] Starting subtest: cold-reset-bound
[210.582176] Subtest cold-reset-bound: SKIP (0.000s)
[210.648991] [070/133] (810s left) syncobj_timeline (etime-multi-wait-submitted)
[210.707088] Starting subtest: etime-multi-wait-submitted
[210.808058] Subtest etime-multi-wait-submitted: SUCCESS (0.101s)
[210.886050] [071/133] (810s left) kms_async_flips (invalid-async-flip-atomic)
[210.975014] Starting subtest: invalid-async-flip-atomic
[211.345905] Starting dynamic subtest: pipe-A-eDP-1
[212.121238] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.776s)
[212.479863] Starting dynamic subtest: pipe-B-eDP-1
[213.260441] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.788s)
[213.630689] Starting dynamic subtest: pipe-C-eDP-1
[214.493490] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.870s)
[214.849428] Starting dynamic subtest: pipe-D-eDP-1
[215.612836] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[215.615242] Subtest invalid-async-flip-atomic: SUCCESS (4.641s)
[216.763963] [072/133] (804s left) gem_exec_schedule (preempt-hang)
[216.935483] Starting subtest: preempt-hang
[216.938052] Starting dynamic subtest: rcs0
[217.169647] Dynamic subtest rcs0: SUCCESS (0.235s)
[217.178434] Starting dynamic subtest: bcs0
[217.398055] Dynamic subtest bcs0: SUCCESS (0.227s)
[217.409081] Starting dynamic subtest: vcs0
[217.621488] Dynamic subtest vcs0: SUCCESS (0.223s)
[217.632659] Starting dynamic subtest: vcs1
[217.845393] Dynamic subtest vcs1: SUCCESS (0.223s)
[217.856111] Starting dynamic subtest: vecs0
[218.069512] Dynamic subtest vecs0: SUCCESS (0.223s)
[218.080637] Starting dynamic subtest: ccs0
[218.310925] Dynamic subtest ccs0: SUCCESS (0.240s)
[218.313357] Subtest preempt-hang: SUCCESS (1.377s)
[218.998390] [073/133] (802s left) gem_mmap (basic-small-bo)
[219.060705] Subtest basic-small-bo: SKIP (0.000s)
[219.122811] [074/133] (802s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[219.226457] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[219.230524] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[219.338365] [075/133] (801s left) kms_plane (plane-position-covered)
[219.439165] Starting subtest: plane-position-covered
[219.940990] Starting dynamic subtest: pipe-A-plane-1
[221.241546] Dynamic subtest pipe-A-plane-1: SUCCESS (1.303s)
[221.250963] Starting dynamic subtest: pipe-A-plane-2
[222.544549] Dynamic subtest pipe-A-plane-2: SUCCESS (1.302s)
[222.553097] Starting dynamic subtest: pipe-A-plane-3
[223.768952] Dynamic subtest pipe-A-plane-3: SUCCESS (1.222s)
[223.778477] Starting dynamic subtest: pipe-A-plane-4
[225.004876] Dynamic subtest pipe-A-plane-4: SUCCESS (1.235s)
[225.014821] Starting dynamic subtest: pipe-A-plane-5
[225.028591] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[226.154648] Starting dynamic subtest: pipe-B-plane-1
[227.367339] Dynamic subtest pipe-B-plane-1: SUCCESS (1.217s)
[227.377764] Starting dynamic subtest: pipe-B-plane-2
[228.640069] Dynamic subtest pipe-B-plane-2: SUCCESS (1.274s)
[228.649551] Starting dynamic subtest: pipe-B-plane-3
[229.947410] Dynamic subtest pipe-B-plane-3: SUCCESS (1.308s)
[229.957167] Starting dynamic subtest: pipe-B-plane-4
[231.267942] Dynamic subtest pipe-B-plane-4: SUCCESS (1.318s)
[231.277040] Starting dynamic subtest: pipe-B-plane-5
[231.292830] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[231.295032] Subtest plane-position-covered: SUCCESS (11.854s)
[232.068423] [076/133] (789s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[232.171281] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[232.175583] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[232.246022] [077/133] (789s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[232.343073] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[232.345327] Starting dynamic subtest: pipe-A-eDP-1
[232.354335] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.368196] Starting dynamic subtest: pipe-B-eDP-1
[232.377092] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.385316] Starting dynamic subtest: pipe-C-eDP-1
[232.393666] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.401807] Starting dynamic subtest: pipe-D-eDP-1
[232.410365] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.414599] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[234.644267] [078/133] (786s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[234.741109] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[234.743320] Starting dynamic subtest: pipe-A
[234.760841] Dynamic subtest pipe-A: SKIP (0.017s)
[234.770269] Starting dynamic subtest: pipe-B
[234.793350] Dynamic subtest pipe-B: SKIP (0.031s)
[234.802065] Starting dynamic subtest: pipe-C
[234.824510] Dynamic subtest pipe-C: SKIP (0.029s)
[234.833214] Starting dynamic subtest: pipe-D
[234.852870] Dynamic subtest pipe-D: SKIP (0.030s)
[234.856593] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.109s)
[234.932951] [079/133] (786s left) kms_color (deep-color)
[235.019301] Starting subtest: deep-color
[236.116456] Starting dynamic subtest: pipe-A-eDP-1-gamma
[236.813993] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.697s)
[236.822903] Starting dynamic subtest: pipe-A-eDP-1-degamma
[238.213143] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.400s)
[238.221517] Starting dynamic subtest: pipe-A-eDP-1-ctm
[239.634778] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.421s)
[240.433658] Starting dynamic subtest: pipe-B-eDP-1-gamma
[241.096470] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.680s)
[241.105970] Starting dynamic subtest: pipe-B-eDP-1-degamma
[242.505696] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.408s)
[242.515223] Starting dynamic subtest: pipe-B-eDP-1-ctm
[243.906982] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.401s)
[244.714427] Starting dynamic subtest: pipe-C-eDP-1-gamma
[245.422375] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.716s)
[245.431659] Starting dynamic subtest: pipe-C-eDP-1-degamma
[246.854219] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.431s)
[246.863452] Starting dynamic subtest: pipe-C-eDP-1-ctm
[248.279079] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.421s)
[249.100047] Starting dynamic subtest: pipe-D-eDP-1-gamma
[249.760420] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.666s)
[249.777210] Starting dynamic subtest: pipe-D-eDP-1-degamma
[251.138502] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.378s)
[251.155452] Starting dynamic subtest: pipe-D-eDP-1-ctm
[252.593775] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.455s)
[252.595967] Subtest deep-color: SUCCESS (17.573s)
[253.450252] [080/133] (767s left) kms_atomic_transition (plane-all-transition-nonblocking)
[253.548454] Starting subtest: plane-all-transition-nonblocking
[253.550722] Starting dynamic subtest: pipe-A-eDP-1
[256.041489] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[256.349065] Starting dynamic subtest: pipe-B-eDP-1
[259.587071] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.247s)
[259.888307] Subtest plane-all-transition-nonblocking: SUCCESS (6.342s)
[260.716861] [081/133] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[260.834951] Starting subtest: psr-2p-primscrn-cur-indfb-move
[260.839440] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[260.932949] [082/133] (760s left) i915_query (engine-info-invalid)
[260.996494] Starting subtest: engine-info-invalid
[260.998925] Subtest engine-info-invalid: SUCCESS (0.000s)
[261.101292] [083/133] (760s left) kms_rotation_crc (sprite-rotation-90)
[261.202481] Starting subtest: sprite-rotation-90
[261.206653] Subtest sprite-rotation-90: SKIP (0.001s)
[261.280082] [084/133] (760s left) gem_userptr_blits (coherency-sync)
[261.342699] Starting subtest: coherency-sync
[261.729338] Subtest coherency-sync: SKIP (0.348s)
[261.823962] [085/133] (759s left) api_intel_allocator (default-alignment)
[261.923987] Starting subtest: default-alignment
[261.927551] Subtest default-alignment: SUCCESS (0.006s)
[262.058965] [086/133] (759s left) kms_psr (pr-cursor-render)
[262.159090] Starting subtest: pr-cursor-render
[262.163207] Subtest pr-cursor-render: SKIP (0.000s)
[262.234295] [087/133] (759s left) gem_exec_flush (basic-wb-pro-default)
[262.305161] Starting subtest: basic-wb-pro-default
[267.765413] Subtest basic-wb-pro-default: SUCCESS (5.460s)
[267.947742] [088/133] (753s left) gem_eio (kms)
[268.238856] Starting subtest: kms
[288.151090] Subtest kms: SUCCESS (19.910s)
[289.331618] [089/133] (732s left) template (a)
[289.384900] Starting subtest: A
[289.386972] Subtest A: SUCCESS (0.000s)
[289.478928] [090/133] (732s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[289.564797] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[289.567146] Starting dynamic subtest: pipe-A-default-mode
[292.268822] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s)
[292.271192] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.706s)
[293.106853] [091/133] (728s left) gem_exec_schedule (semaphore-noskip)
[293.182051] Starting subtest: semaphore-noskip
[293.622763] Subtest semaphore-noskip: SUCCESS (0.447s)
[293.956881] [092/133] (727s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[294.068910] Starting subtest: basic-flip-before-cursor-legacy
[294.986047] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.919s)
[295.835429] [093/133] (726s left) fbdev (write)
[295.877771] Starting subtest: write
[296.237034] Subtest write: SUCCESS (0.358s)
[296.303836] [094/133] (725s left) kms_flip (2x-blocking-absolute-wf_vblank)
[296.395715] Starting subtest: 2x-blocking-absolute-wf_vblank
[296.406748] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[296.524999] [095/133] (725s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[296.584853] Starting subtest: multi-wait-for-submit-unsubmitted
[296.687224] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[296.780022] [096/133] (725s left) kms_big_fb (x-tiled-addfb)
[296.878763] Starting subtest: x-tiled-addfb
[296.880962] Subtest x-tiled-addfb: SUCCESS (0.000s)
[296.985724] [097/133] (725s left) kms_selftest (drm_cmdline_parser)
[297.022924] Starting subtest: drm_cmdline_parser
[297.037026] Starting dynamic subtest: drm_test_cmdline_force_d_only
[297.130148] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.091s)
[297.141033] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[297.230555] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.099s)
[297.246264] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[297.328485] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.097s)
[297.339411] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[297.411089] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.081s)
[297.420069] Starting dynamic subtest: drm_test_cmdline_force_e_only
[297.509190] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.097s)
[297.517917] Starting dynamic subtest: drm_test_cmdline_res
[297.615123] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.106s)
[297.623786] Starting dynamic subtest: drm_test_cmdline_res_vesa
[297.751233] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.136s)
[297.760948] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[297.840400] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.089s)
[297.849073] Starting dynamic subtest: drm_test_cmdline_res_rblank
[297.960837] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.118s)
[297.971154] Starting dynamic subtest: drm_test_cmdline_res_bpp
[298.063094] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.101s)
[298.072551] Starting dynamic subtest: drm_test_cmdline_res_refresh
[298.185253] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.120s)
[298.195074] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[298.279299] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.094s)
[298.288083] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[298.363267] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.082s)
[298.373910] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[298.451134] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.087s)
[298.461678] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[298.560518] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.108s)
[298.572934] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[298.670590] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.109s)
[298.680096] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[298.760838] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.091s)
[298.769639] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[298.851760] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.088s)
[298.871109] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[298.942847] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.091s)
[298.954138] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[299.040927] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.098s)
[299.050442] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[299.141646] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.099s)
[299.157088] Starting dynamic subtest: drm_test_cmdline_name
[299.241263] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.099s)
[299.250402] Starting dynamic subtest: drm_test_cmdline_name_bpp
[299.335483] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.094s)
[299.344318] Starting dynamic subtest: drm_test_cmdline_name_option
[299.439689] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.104s)
[299.448542] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[299.532496] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.091s)
[299.540716] Starting dynamic subtest: drm_test_cmdline_rotate_0
[299.638054] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.105s)
[299.646267] Starting dynamic subtest: drm_test_cmdline_rotate_90
[299.732522] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.093s)
[299.742020] Starting dynamic subtest: drm_test_cmdline_rotate_180
[299.823367] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.088s)
[299.832326] Starting dynamic subtest: drm_test_cmdline_rotate_270
[299.932303] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.108s)
[299.944812] Starting dynamic subtest: drm_test_cmdline_hmirror
[300.045667] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.112s)
[300.055296] Starting dynamic subtest: drm_test_cmdline_vmirror
[300.136676] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.091s)
[300.146076] Starting dynamic subtest: drm_test_cmdline_margin_options
[300.234037] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.094s)
[300.242773] Starting dynamic subtest: drm_test_cmdline_multiple_options
[300.329335] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.094s)
[300.339679] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[300.413921] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.084s)
[300.423184] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[300.528660] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.113s)
[300.538884] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[300.611549] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.083s)
[300.621789] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[300.692110] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.080s)
[300.701266] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[300.773388] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.082s)
[300.781953] Starting dynamic subtest: drm_test_cmdline_invalid
[300.881316] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.108s)
[300.889740] Starting dynamic subtest: drm_test_cmdline_tv_options
[300.980518] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.099s)
[300.982731] Subtest drm_cmdline_parser: SUCCESS (3.958s)
[301.132290] [098/133] (720s left) gem_exec_balancer (sequential)
[301.195806] Starting subtest: sequential
[304.297717] Subtest sequential: SUCCESS (3.101s)
[304.588924] [099/133] (717s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[304.685263] Starting subtest: fbc-psr2-sprite-mmap-cpu
[304.687172] Starting dynamic subtest: eDP-1
[304.691222] Dynamic subtest eDP-1: SKIP (0.000s)
[304.695276] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[304.774043] [100/133] (717s left) gem_exec_fence (nb-await)
[304.948191] Starting subtest: nb-await
[304.950775] Starting dynamic subtest: rcs0
[305.016404] Dynamic subtest rcs0: SUCCESS (0.068s)
[305.027059] Starting dynamic subtest: bcs0
[305.073601] Dynamic subtest bcs0: SUCCESS (0.056s)
[305.084611] Starting dynamic subtest: vcs0
[305.133037] Dynamic subtest vcs0: SUCCESS (0.057s)
[305.146022] Starting dynamic subtest: vcs1
[305.192990] Dynamic subtest vcs1: SUCCESS (0.057s)
[305.203447] Starting dynamic subtest: vecs0
[305.251926] Dynamic subtest vecs0: SUCCESS (0.057s)
[305.262331] Starting dynamic subtest: ccs0
[305.310961] Dynamic subtest ccs0: SUCCESS (0.057s)
[305.313972] Subtest nb-await: SUCCESS (0.365s)
[306.963069] [101/133] (715s left) sysfs_timeslice_duration (idempotent)
[307.017894] Starting subtest: idempotent
[307.020371] Starting dynamic subtest: vecs0
[307.022787] Dynamic subtest vecs0: SUCCESS (0.000s)
[307.032350] Starting dynamic subtest: ccs0
[307.034401] Dynamic subtest ccs0: SUCCESS (0.000s)
[307.045552] Starting dynamic subtest: vcs0
[307.047725] Dynamic subtest vcs0: SUCCESS (0.000s)
[307.056659] Starting dynamic subtest: bcs0
[307.058859] Dynamic subtest bcs0: SUCCESS (0.000s)
[307.067598] Starting dynamic subtest: rcs0
[307.069784] Dynamic subtest rcs0: SUCCESS (0.000s)
[307.079490] Starting dynamic subtest: vcs1
[307.081718] Dynamic subtest vcs1: SUCCESS (0.000s)
[307.083778] Subtest idempotent: SUCCESS (0.006s)
[307.128468] [102/133] (715s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[307.239739] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[307.243700] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[307.321646] [103/133] (715s left) gem_exec_store (basic)
[307.389328] Starting subtest: basic
[307.489086] Subtest basic: SUCCESS (0.100s)
[307.671300] [104/133] (714s left) intel_hwmon (hwmon-read)
[307.724868] Subtest hwmon-read: SKIP (0.000s)
[307.782387] [105/133] (714s left) i915_getparams_basic (basic-eu-total)
[307.830104] Starting subtest: basic-eu-total
[307.834655] Subtest basic-eu-total: SUCCESS (0.000s)
[307.925785] [106/133] (714s left) kms_big_fb (linear-16bpp-rotate-90)
[308.029312] Starting subtest: linear-16bpp-rotate-90
[308.049350] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[308.178307] [107/133] (714s left) kms_vblank (query-forked-busy)
[308.276601] Starting subtest: query-forked-busy
[308.278456] Starting dynamic subtest: pipe-A-eDP-1
[310.160790] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[310.176136] Starting dynamic subtest: pipe-D-eDP-1
[312.710953] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s)
[312.713183] Subtest query-forked-busy: SUCCESS (4.431s)
[313.502594] [108/133] (709s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[313.605489] Starting subtest: nonblocking-crc-frame-sequence
[313.607482] Starting dynamic subtest: pipe-A-eDP-1
[314.347056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[314.356860] Starting dynamic subtest: pipe-B-eDP-1
[315.722548] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.372s)
[315.734519] Starting dynamic subtest: pipe-C-eDP-1
[317.127198] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.402s)
[317.137084] Starting dynamic subtest: pipe-D-eDP-1
[318.460061] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[318.462300] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.855s)
[319.261083] [109/133] (703s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[319.368381] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[319.370531] Starting dynamic subtest: pipe-A-eDP-1
[325.249813] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.883s)
[325.260182] Starting dynamic subtest: pipe-B-eDP-1
[331.907736] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s)
[331.910201] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.541s)
[332.789667] [110/133] (689s left) kms_flip (2x-plain-flip-interruptible)
[332.880350] Starting subtest: 2x-plain-flip-interruptible
[332.891581] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[332.969510] [111/133] (689s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[333.060859] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[333.063280] Starting dynamic subtest: pipe-A-eDP-1
[344.075871] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.017s)
[344.085378] Starting dynamic subtest: pipe-B-eDP-1
[355.800077] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.722s)
[355.802429] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.742s)
[356.663595] [112/133] (666s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[356.759274] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[356.761555] Starting dynamic subtest: pipe-A-eDP-1
[357.205823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[357.221659] Starting dynamic subtest: pipe-B-eDP-1
[358.560043] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.351s)
[358.570184] Starting dynamic subtest: pipe-C-eDP-1
[359.996538] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.435s)
[360.005888] Starting dynamic subtest: pipe-D-eDP-1
[361.315545] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[361.317770] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.529s)
[362.507911] [113/133] (660s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[362.632532] Starting subtest: cursorB-vs-flipA-varying-size
[362.637235] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[362.778424] [114/133] (660s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[362.899715] Starting subtest: pipe-fbc-rte
[362.906256] Starting dynamic subtest: pipe-B-eDP-1
[368.389673] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.494s)
[368.397330] Subtest pipe-fbc-rte: SUCCESS (5.497s)
[370.645171] [115/133] (652s left) syncobj_timeline (invalid-query-bad-pad)
[370.702874] Starting subtest: invalid-query-bad-pad
[370.705155] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[370.812968] [116/133] (652s left) gem_exercise_blt (fast-copy-emit)
[370.857288] Starting subtest: fast-copy-emit
[370.859207] Starting dynamic subtest: linear-smem-smem-emit
[370.877706] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[370.892750] Starting dynamic subtest: xmajor-smem-smem-emit
[370.897709] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[370.906169] Starting dynamic subtest: tile4-smem-smem-emit
[370.911277] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[370.920085] Starting dynamic subtest: tile64-smem-smem-emit
[370.927335] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[370.929617] Subtest fast-copy-emit: SUCCESS (0.071s)
[371.040377] [117/133] (651s left) gem_ctx_persistence (engines-queued)
[371.095614] Starting subtest: engines-queued
[371.097448] Starting dynamic subtest: rcs0
[371.128428] Dynamic subtest rcs0: SUCCESS (0.035s)
[371.139511] Starting dynamic subtest: bcs0
[371.179498] Dynamic subtest bcs0: SUCCESS (0.050s)
[371.190342] Starting dynamic subtest: vcs0
[372.861644] Dynamic subtest vcs0: SUCCESS (1.669s)
[372.874211] Starting dynamic subtest: vcs1
[374.899108] Dynamic subtest vcs1: SUCCESS (2.046s)
[374.912027] Starting dynamic subtest: vecs0
[376.883612] Dynamic subtest vecs0: SUCCESS (1.981s)
[376.895907] Starting dynamic subtest: ccs0
[377.061180] Dynamic subtest ccs0: SUCCESS (0.176s)
[377.063466] Subtest engines-queued: SUCCESS (5.968s)
[377.182061] [118/133] (645s left) kms_big_fb (y-tiled-addfb)
[377.282400] Starting subtest: y-tiled-addfb
[377.286685] Subtest y-tiled-addfb: SKIP (0.000s)
[377.385614] [119/133] (645s left) gem_partial_pwrite_pread (write-display)
[377.446376] Subtest write-display: SKIP (0.000s)
[377.522111] [120/133] (645s left) kms_psr (psr2-sprite-plane-move)
[377.617222] Starting subtest: psr2-sprite-plane-move
[377.619391] Starting dynamic subtest: eDP-1
[379.358440] Dynamic subtest eDP-1: SUCCESS (1.742s)
[379.360888] Subtest psr2-sprite-plane-move: SUCCESS (1.743s)
[380.207760] [121/133] (642s left) gem_close_race (multigpu-basic-threads)
[380.279354] Starting subtest: multigpu-basic-threads
[380.284047] Subtest multigpu-basic-threads: SKIP (0.000s)
[380.528491] [122/133] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[380.632338] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[380.636285] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[380.731134] [123/133] (642s left) kms_content_protection (dp-mst-type-0)
[380.873041] Starting subtest: dp-mst-type-0
[380.877578] Subtest dp-mst-type-0: SKIP (0.000s)
[381.009532] [124/133] (642s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[381.107294] Starting subtest: fbcpsr-stridechange
[387.337287] Subtest fbcpsr-stridechange: SUCCESS (6.233s)
[387.472324] [125/133] (635s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[387.568293] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[387.572563] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[387.669226] [126/133] (635s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[387.750324] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[387.754643] Starting dynamic subtest: pipe-A-eDP-1
[388.668966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.912s)
[388.684294] Starting dynamic subtest: pipe-B-eDP-1
[390.324959] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.653s)
[390.334703] Starting dynamic subtest: pipe-C-eDP-1
[391.882155] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.554s)
[391.892374] Starting dynamic subtest: pipe-D-eDP-1
[393.418626] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[393.420815] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.658s)
[394.573629] [127/133] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[394.671117] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[394.675212] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[394.766061] [128/133] (628s left) kms_psr (psr-sprite-render)
[394.865394] Starting subtest: psr-sprite-render
[394.867689] Starting dynamic subtest: eDP-1
[396.572555] Dynamic subtest eDP-1: SUCCESS (1.707s)
[396.574852] Subtest psr-sprite-render: SUCCESS (1.708s)
[397.404369] [129/133] (626s left) syncobj_wait (wait-all-for-submit-complex)
[397.464728] Starting subtest: wait-all-for-submit-complex
[397.679965] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[397.756914] [130/133] (625s left) gem_ctx_param (invalid-param-get)
[397.813728] Starting subtest: invalid-param-get
[397.815869] Subtest invalid-param-get: SUCCESS (0.001s)
[397.907626] [131/133] (625s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[398.051039] Starting subtest: basic-flip-before-cursor-varying-size
[398.973345] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.920s)
[399.846778] [132/133] (623s left) kms_chamelium_color (ctm-0-50)
[399.938366] Subtest ctm-0-50: SKIP (0.000s)
[399.986464] [133/133] (623s left) gem_ctx_param (invalid-ctx-get)
[400.051218] Starting subtest: invalid-ctx-get
[400.053692] Subtest invalid-ctx-get: SUCCESS (0.000s)
[400.123758] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: gem_unfence_active_buffers
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: syncobj_basic
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_pxp
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: kms_fence_pin_leak
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_chamelium_frames
results: parsing output: 18/ for test: gem_mmap
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: i915_pm_rpm
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_hdr
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: sw_sync
results: parsing output: 44/ for test: kms_plane_multiple
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: gem_mmap_offset
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_ctx_create
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: gen9_exec_parse
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_explicit_fence
results: parsing output: 54/ for test: kms_invalid_mode
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gen3_render_linear_blits
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: kms_prime
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_pm_dc
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: device_reset
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_async_flips
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: gem_mmap
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_color
results: parsing output: 79/ for test: kms_atomic_transition
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: i915_query
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: template
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: fbdev
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_selftest
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: sysfs_timeslice_duration
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_store
results: parsing output: 103/ for test: intel_hwmon
results: parsing output: 104/ for test: i915_getparams_basic
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: kms_pipe_crc_basic
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_exercise_blt
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_ctx_param
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: gem_ctx_param
Done.