[55.709975] Initializing watchdogs
[55.710041]   /dev/watchdog0
[55.722535] [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]
[55.726468] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.728510] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.731927] [001/131] (960s left) gem_exec_schedule (preempt-user)
[55.812521] Starting subtest: preempt-user
[55.814430] Starting dynamic subtest: rcs0
[55.845818] Dynamic subtest rcs0: SUCCESS (0.038s)
[55.853786] Starting dynamic subtest: bcs0
[55.875088] Dynamic subtest bcs0: SUCCESS (0.029s)
[55.881480] Starting dynamic subtest: vcs0
[55.898943] Dynamic subtest vcs0: SUCCESS (0.024s)
[55.904986] Starting dynamic subtest: vcs1
[55.922597] Dynamic subtest vcs1: SUCCESS (0.023s)
[55.932294] Starting dynamic subtest: vecs0
[55.940702] Dynamic subtest vecs0: SUCCESS (0.018s)
[55.947157] Starting dynamic subtest: ccs0
[55.972588] Dynamic subtest ccs0: SUCCESS (0.032s)
[55.975042] Subtest preempt-user: SUCCESS (0.164s)
[58.069981] [002/131] (958s left) gem_exec_schedule (u-lateslice)
[58.145195] Starting subtest: u-lateslice
[58.147113] Starting dynamic subtest: rcs0
[58.165275] Dynamic subtest rcs0: SUCCESS (0.028s)
[58.172751] Starting dynamic subtest: bcs0
[58.187064] Dynamic subtest bcs0: SUCCESS (0.021s)
[58.193738] Starting dynamic subtest: vcs0
[58.208765] Dynamic subtest vcs0: SUCCESS (0.022s)
[58.215103] Starting dynamic subtest: vcs1
[58.231059] Dynamic subtest vcs1: SUCCESS (0.022s)
[58.237266] Starting dynamic subtest: vecs0
[58.249345] Dynamic subtest vecs0: SUCCESS (0.018s)
[58.255943] Starting dynamic subtest: ccs0
[58.269327] Dynamic subtest ccs0: SUCCESS (0.020s)
[58.271540] Subtest u-lateslice: SUCCESS (0.132s)
[60.036196] [003/131] (956s left) gem_exec_create (basic)
[60.103588] Starting subtest: basic
[60.106075] Starting dynamic subtest: smem
[63.914631] Dynamic subtest smem: SUCCESS (3.809s)
[63.916826] Subtest basic: SUCCESS (3.809s)
[64.086752] [004/131] (952s left) gem_bad_reloc (negative-reloc-lut)
[64.151057] Subtest negative-reloc-lut: SKIP (0.000s)
[64.207231] [005/131] (952s left) gem_userptr_blits (input-checking)
[64.266064] Starting subtest: input-checking
[64.268330] Subtest input-checking: SUCCESS (0.000s)
[64.393110] [006/131] (951s left) kms_atomic_interruptible (legacy-dpms)
[64.496994] Starting subtest: legacy-dpms
[64.499410] Starting dynamic subtest: pipe-A-eDP-1
[71.891680] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.394s)
[71.893835] Subtest legacy-dpms: SUCCESS (7.395s)
[72.720975] [007/131] (943s left) gem_exec_capture (capture-recoverable)
[72.786059] Starting subtest: capture-recoverable
[72.791074] Subtest capture-recoverable: SUCCESS (0.003s)
[72.920630] [008/131] (943s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[73.044304] Starting subtest: verify-pxp-execution-after-suspend-resume
[79.968034] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.923s)
[80.085796] [009/131] (936s left) gem_mmap_gtt (zero-extend)
[80.152325] Subtest zero-extend: SKIP (0.000s)
[80.208259] [010/131] (936s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[80.315574] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[86.853081] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.539s)
[87.014979] [011/131] (929s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[87.116000] Starting subtest: yf-tiled-addfb-size-overflow
[87.120607] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[87.200582] [012/131] (929s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[87.311283] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[94.212235] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.904s)
[94.319449] [013/131] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[94.424029] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[100.946307] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.524s)
[101.075402] [014/131] (915s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[101.171919] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[101.174154] Starting dynamic subtest: pipe-A
[101.188521] Dynamic subtest pipe-A: SKIP (0.011s)
[101.196061] Starting dynamic subtest: pipe-B
[101.210479] Dynamic subtest pipe-B: SKIP (0.022s)
[101.217859] Starting dynamic subtest: pipe-C
[101.235166] Dynamic subtest pipe-C: SKIP (0.023s)
[101.242344] Starting dynamic subtest: pipe-D
[101.257056] Dynamic subtest pipe-D: SKIP (0.023s)
[101.261444] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.080s)
[101.356364] [015/131] (915s left) kms_prime (d3hot)
[103.360304] Subtest D3hot: SKIP (0.000s)
[103.443881] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.amdgpu: true
[103.444420] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[103.444558] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.xe: true
[103.447365] [016/131] (913s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[103.543072] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[104.621318] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.080s)
[104.737974] [017/131] (911s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[104.802969] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[104.807514] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[104.982736] [018/131] (911s left) api_intel_bb (render)
[105.034515] Starting subtest: render
[105.036691] Starting dynamic subtest: render-none-512
[105.134429] Dynamic subtest render-none-512: SUCCESS (0.100s)
[105.144223] Starting dynamic subtest: render-none-1024
[105.514600] Dynamic subtest render-none-1024: SUCCESS (0.379s)
[105.524713] Starting dynamic subtest: render-x-512
[105.598400] Dynamic subtest render-x-512: SUCCESS (0.084s)
[105.608081] Starting dynamic subtest: render-x-1024
[105.940222] Dynamic subtest render-x-1024: SUCCESS (0.341s)
[105.949784] Starting dynamic subtest: render-y-512
[106.027039] Dynamic subtest render-y-512: SUCCESS (0.087s)
[106.037086] Starting dynamic subtest: render-y-1024
[106.369198] Dynamic subtest render-y-1024: SUCCESS (0.341s)
[106.371825] Subtest render: SUCCESS (1.334s)
[106.483061] [019/131] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[106.588509] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[106.593097] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[106.695158] [020/131] (910s left) gem_exec_whisper (basic-queues-all)
[106.766414] Starting subtest: basic-queues-all
[118.922038] Subtest basic-queues-all: SUCCESS (12.154s)
[119.101679] [021/131] (897s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[119.478403] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[120.279231] [022/131] (896s left) kms_psr (fbc-psr-primary-mmap-cpu)
[120.380894] Starting subtest: fbc-psr-primary-mmap-cpu
[120.383259] Starting dynamic subtest: eDP-1
[120.387632] Dynamic subtest eDP-1: SKIP (0.000s)
[120.391986] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[120.448081] [023/131] (896s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[120.549895] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[120.554157] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[120.642381] [024/131] (896s left) perf_pmu (init-sema)
[120.684894] Starting subtest: init-sema
[120.687246] Starting dynamic subtest: rcs0
[120.689668] Dynamic subtest rcs0: SUCCESS (0.002s)
[120.699339] Starting dynamic subtest: bcs0
[120.701461] Dynamic subtest bcs0: SUCCESS (0.000s)
[120.713709] Starting dynamic subtest: vcs0
[120.715908] Dynamic subtest vcs0: SUCCESS (0.001s)
[120.725110] Starting dynamic subtest: vcs1
[120.727267] Dynamic subtest vcs1: SUCCESS (0.000s)
[120.734841] Starting dynamic subtest: vecs0
[120.737073] Dynamic subtest vecs0: SUCCESS (0.000s)
[120.743728] Starting dynamic subtest: ccs0
[120.746077] Dynamic subtest ccs0: SUCCESS (0.000s)
[120.747951] Subtest init-sema: SUCCESS (0.005s)
[120.795828] [025/131] (896s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[120.892069] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[120.894327] Starting dynamic subtest: pipe-A-default-mode
[122.055772] Dynamic subtest pipe-A-default-mode: SKIP (1.158s)
[122.060223] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.159s)
[122.209365] [026/131] (894s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[122.597383] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[123.422822] [027/131] (893s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[123.525909] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[123.528350] Starting dynamic subtest: pipe-A-eDP-1
[123.551711] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.560743] Starting dynamic subtest: pipe-B-eDP-1
[123.582257] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.589215] Starting dynamic subtest: pipe-C-eDP-1
[123.611176] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.618306] Starting dynamic subtest: pipe-D-eDP-1
[123.640661] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.644827] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.002s)
[125.691275] [028/131] (891s left) kms_chamelium_audio (dp-audio)
[126.077446] Subtest dp-audio: SKIP (0.000s)
[126.890064] [029/131] (890s left) kms_async_flips (invalid-async-flip)
[126.993079] Starting subtest: invalid-async-flip
[126.997596] Subtest invalid-async-flip: SKIP (0.000s)
[128.137549] [030/131] (889s left) gem_exec_params (secure-non-root)
[128.191556] Starting subtest: secure-non-root
[128.196181] Subtest secure-non-root: SKIP (0.000s)
[128.290419] [031/131] (888s left) kms_properties (get_properties-sanity-atomic)
[128.397931] Starting subtest: get_properties-sanity-atomic
[128.400303] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[128.465074] [032/131] (888s left) gem_softpin (full)
[128.519708] Starting subtest: full
[128.527113] Subtest full: SUCCESS (0.007s)
[128.650167] [033/131] (888s left) gem_close_race (basic-process)
[128.713240] Starting subtest: basic-process
[128.786360] Subtest basic-process: SUCCESS (0.072s)
[128.960203] [034/131] (888s left) gem_userptr_blits (unsync-overlap)
[129.029868] Subtest unsync-overlap: SKIP (0.000s)
[129.175691] [035/131] (888s left) kms_flip (basic-flip-vs-modeset)
[129.267869] Starting subtest: basic-flip-vs-modeset
[129.270229] Starting dynamic subtest: A-eDP1
[131.812740] Dynamic subtest A-eDP1: SUCCESS (2.544s)
[131.821373] Starting dynamic subtest: B-eDP1
[133.962871] Dynamic subtest B-eDP1: SUCCESS (2.148s)
[133.971698] Starting dynamic subtest: C-eDP1
[136.115778] Dynamic subtest C-eDP1: SUCCESS (2.154s)
[136.124275] Starting dynamic subtest: D-eDP1
[138.290319] Dynamic subtest D-eDP1: SUCCESS (2.171s)
[138.292373] Subtest basic-flip-vs-modeset: SUCCESS (9.023s)
[139.073248] [036/131] (878s left) kms_psr (psr-no-drrs)
[139.175847] Starting subtest: psr-no-drrs
[139.178179] Starting dynamic subtest: eDP-1
[140.857464] Dynamic subtest eDP-1: SUCCESS (1.678s)
[140.859717] Subtest psr-no-drrs: SUCCESS (1.678s)
[141.719972] [037/131] (875s left) syncobj_basic (bad-fd-to-handle)
[141.784759] Starting subtest: bad-fd-to-handle
[141.787556] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[141.890152] [038/131] (875s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[141.998569] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[142.002791] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[142.104836] [039/131] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[142.209501] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[142.213845] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[142.292783] [040/131] (875s left) perf_pmu (busy)
[142.331550] Starting subtest: busy
[142.333752] Starting dynamic subtest: rcs0
[142.945685] Dynamic subtest rcs0: SUCCESS (0.613s)
[142.960246] Starting dynamic subtest: bcs0
[143.511043] Dynamic subtest bcs0: SUCCESS (0.564s)
[143.522189] Starting dynamic subtest: vcs0
[144.939499] Dynamic subtest vcs0: SUCCESS (1.427s)
[144.950427] Starting dynamic subtest: vcs1
[146.922892] Dynamic subtest vcs1: SUCCESS (1.982s)
[146.932876] Starting dynamic subtest: vecs0
[148.906841] Dynamic subtest vecs0: SUCCESS (1.983s)
[148.918333] Starting dynamic subtest: ccs0
[149.478334] Dynamic subtest ccs0: SUCCESS (0.572s)
[149.480882] Subtest busy: SUCCESS (7.147s)
[149.575933] [041/131] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[149.684183] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[149.688517] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[149.785157] [042/131] (867s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[154.786627] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[154.789060] Starting dynamic subtest: pipe-A-eDP-1
[161.381890] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.593s)
[161.390847] Starting dynamic subtest: pipe-B-eDP-1
[167.902739] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.520s)
[167.905097] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.117s)
[168.773873] [043/131] (848s left) kms_cursor_crc (cursor-offscreen-128x42)
[168.967610] Starting subtest: cursor-offscreen-128x42
[169.004685] Subtest cursor-offscreen-128x42: SKIP (0.032s)
[169.218967] [044/131] (848s left) kms_cursor_crc (cursor-sliding-128x128)
[169.400417] Starting subtest: cursor-sliding-128x128
[169.405411] Starting dynamic subtest: pipe-A-eDP-1
[172.853912] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.450s)
[172.882355] Starting dynamic subtest: pipe-D-eDP-1
[176.928463] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.052s)
[176.930939] Subtest cursor-sliding-128x128: SUCCESS (7.527s)
[177.720816] [045/131] (839s left) gem_lmem_swapping (heavy-verify-multi)
[177.766559] Subtest heavy-verify-multi: SKIP (0.000s)
[177.803462] [046/131] (839s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[177.906853] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[177.909117] Starting dynamic subtest: A-eDP1
[181.438693] Dynamic subtest A-eDP1: SUCCESS (3.527s)
[181.453561] Starting dynamic subtest: B-eDP1
[184.595691] Dynamic subtest B-eDP1: SUCCESS (3.157s)
[184.604562] Starting dynamic subtest: C-eDP1
[187.668525] Dynamic subtest C-eDP1: SUCCESS (3.072s)
[187.677349] Starting dynamic subtest: D-eDP1
[190.752442] Dynamic subtest D-eDP1: SUCCESS (3.083s)
[190.754811] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.846s)
[191.540802] [047/131] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[191.650069] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[191.654158] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[191.749584] [048/131] (826s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[191.808676] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[191.860967] [049/131] (825s left) api_intel_allocator (reloc-allocator)
[191.925350] Starting subtest: reloc-allocator
[191.927229] Starting dynamic subtest: basic
[191.929575] Dynamic subtest basic: SUCCESS (0.003s)
[191.938773] Starting dynamic subtest: parallel-one
[191.941084] Dynamic subtest parallel-one: SUCCESS (0.008s)
[191.949762] Starting dynamic subtest: print
[191.951624] Dynamic subtest print: SUCCESS (0.000s)
[191.959644] Starting dynamic subtest: reuse
[191.961776] Dynamic subtest reuse: SUCCESS (0.000s)
[191.969177] Starting dynamic subtest: fork-reopen-allocator
[191.971277] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[191.973305] Subtest reloc-allocator: SUCCESS (0.030s)
[192.093081] [050/131] (825s left) gem_render_copy_redux (normal)
[192.153952] Starting subtest: normal
[192.484949] Subtest normal: SUCCESS (0.332s)
[192.622337] [051/131] (825s left) kms_big_fb (linear-32bpp-rotate-90)
[192.730471] Starting subtest: linear-32bpp-rotate-90
[192.749245] Subtest linear-32bpp-rotate-90: SKIP (0.018s)
[192.878846] [052/131] (825s left) gem_ctx_persistence (engines-queued)
[192.940655] Starting subtest: engines-queued
[192.942667] Starting dynamic subtest: rcs0
[193.004313] Dynamic subtest rcs0: SUCCESS (0.063s)
[193.012596] Starting dynamic subtest: bcs0
[193.070390] Dynamic subtest bcs0: SUCCESS (0.065s)
[193.078671] Starting dynamic subtest: vcs0
[194.891588] Dynamic subtest vcs0: SUCCESS (1.818s)
[194.902697] Starting dynamic subtest: vcs1
[196.873473] Dynamic subtest vcs1: SUCCESS (1.980s)
[196.885776] Starting dynamic subtest: vecs0
[198.920497] Dynamic subtest vecs0: SUCCESS (2.045s)
[198.931931] Starting dynamic subtest: ccs0
[199.105966] Dynamic subtest ccs0: SUCCESS (0.185s)
[199.108498] Subtest engines-queued: SUCCESS (6.165s)
[199.189733] [053/131] (818s left) sw_sync (sync_merge)
[199.226110] Starting subtest: sync_merge
[199.228069] Subtest sync_merge: SUCCESS (0.000s)
[199.283875] [054/131] (818s left) gem_exec_reloc (basic-cpu-noreloc)
[199.347823] Subtest basic-cpu-noreloc: SKIP (0.000s)
[199.409439] [055/131] (818s left) kms_psr (psr2-primary-mmap-cpu)
[199.504391] Starting subtest: psr2-primary-mmap-cpu
[199.506682] Starting dynamic subtest: eDP-1
[201.216402] Dynamic subtest eDP-1: SUCCESS (1.710s)
[201.218919] Subtest psr2-primary-mmap-cpu: SUCCESS (1.710s)
[202.083974] [056/131] (815s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[202.146299] Starting subtest: single-wait-for-submit-available-signaled
[202.148534] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[202.239037] [057/131] (815s left) gem_exec_balancer (bonded-true-hang)
[202.492779] Starting subtest: bonded-true-hang
[202.497737] Subtest bonded-true-hang: SKIP (0.000s)
[202.607996] [058/131] (815s left) kms_getfb (getfb2-handle-zero)
[202.671195] Starting subtest: getfb2-handle-zero
[202.673327] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[202.778481] [059/131] (815s left) gem_exec_schedule (noreorder)
[202.959783] Starting subtest: noreorder
[202.962322] Starting dynamic subtest: rcs0
[203.027847] Dynamic subtest rcs0: SUCCESS (0.068s)
[203.042672] Starting dynamic subtest: vcs0
[204.932407] Dynamic subtest vcs0: SUCCESS (1.901s)
[204.942875] Starting dynamic subtest: vcs1
[206.954990] Dynamic subtest vcs1: SUCCESS (2.021s)
[206.963806] Starting dynamic subtest: vecs0
[208.960030] Dynamic subtest vecs0: SUCCESS (2.003s)
[208.970441] Starting dynamic subtest: ccs0
[209.044804] Dynamic subtest ccs0: SUCCESS (0.084s)
[209.047466] Subtest noreorder: SUCCESS (6.086s)
[209.225079] [060/131] (808s left) sysfs_timeslice_duration (timeout)
[209.291430] Starting subtest: timeout
[209.293824] Starting dynamic subtest: vecs0
[218.917069] Dynamic subtest vecs0: SUCCESS (9.622s)
[218.926524] Starting dynamic subtest: ccs0
[220.245287] Dynamic subtest ccs0: SUCCESS (1.327s)
[220.256291] Starting dynamic subtest: vcs0
[229.951256] Dynamic subtest vcs0: SUCCESS (9.703s)
[229.964168] Starting dynamic subtest: bcs0
[230.639759] Dynamic subtest bcs0: SUCCESS (0.688s)
[230.648560] Starting dynamic subtest: rcs0
[231.926393] Dynamic subtest rcs0: SUCCESS (1.286s)
[231.937046] Starting dynamic subtest: vcs1
[241.954194] Dynamic subtest vcs1: SUCCESS (10.025s)
[241.956881] Subtest timeout: SUCCESS (32.660s)
[242.022080] [061/131] (776s left) kms_joiner (basic-max-non-joiner)
[242.134316] Starting subtest: basic-max-non-joiner
[242.138606] Subtest basic-max-non-joiner: SKIP (0.000s)
[242.204169] [062/131] (776s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[242.297861] Starting subtest: fbc-rgb565-draw-mmap-cpu
[246.344492] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.048s)
[247.470576] [063/131] (770s left) syncobj_timeline (signal-array)
[247.522600] Starting subtest: signal-array
[247.524923] Subtest signal-array: SUCCESS (0.000s)
[247.617115] [064/131] (770s left) sriov_basic (enable-vfs-autoprobe-on)
[247.669744] Starting subtest: enable-vfs-autoprobe-on
[247.671756] Starting dynamic subtest: numvfs-1
[247.750795] Dynamic subtest numvfs-1: FAIL (0.028s)
[247.758803] Starting dynamic subtest: numvfs-2
[247.832055] Dynamic subtest numvfs-2: FAIL (0.003s)
[247.846146] Starting dynamic subtest: numvfs-3
[247.919696] Dynamic subtest numvfs-3: FAIL (0.003s)
[247.930567] Starting dynamic subtest: numvfs-4
[248.004416] Dynamic subtest numvfs-4: FAIL (0.003s)
[248.013880] Starting dynamic subtest: numvfs-5
[248.088213] Dynamic subtest numvfs-5: FAIL (0.003s)
[248.097259] Starting dynamic subtest: numvfs-6
[248.169538] Dynamic subtest numvfs-6: FAIL (0.003s)
[248.178644] Starting dynamic subtest: numvfs-7
[248.252600] Dynamic subtest numvfs-7: FAIL (0.003s)
[248.260778] Starting dynamic subtest: numvfs-random
[248.334469] Dynamic subtest numvfs-random: FAIL (0.003s)
[248.343218] Starting dynamic subtest: numvfs-all
[248.415033] Dynamic subtest numvfs-all: FAIL (0.515s)
[248.416827] Subtest enable-vfs-autoprobe-on: FAIL (0.572s)
[248.447630] [065/131] (769s left) gem_ctx_create (basic-files)
[248.513420] Starting subtest: basic-files
[250.625540] Subtest basic-files: SUCCESS (2.114s)
[251.980607] [066/131] (766s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[252.077831] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[252.080175] Starting dynamic subtest: pipe-A-eDP-1
[252.570638] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s)
[252.582073] Starting dynamic subtest: pipe-B-eDP-1
[252.603416] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[252.613335] Starting dynamic subtest: pipe-C-eDP-1
[252.632617] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[252.640904] Starting dynamic subtest: pipe-D-eDP-1
[252.661377] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[252.663717] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.504s)
[254.816548] [067/131] (763s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[254.913718] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[259.438587] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.530s)
[260.596372] [068/131] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[260.713469] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[260.717558] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[260.824654] [069/131] (757s left) gen3_render_tiledx_blits
[260.950892] [070/131] (757s left) perf (invalid-open-flags)
[261.053975] Starting subtest: invalid-open-flags
[261.056243] Subtest invalid-open-flags: SUCCESS (0.000s)
[261.086590] [071/131] (757s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[261.188247] Starting subtest: fbc-rgb565-draw-mmap-gtt
[261.192133] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[261.291569] [072/131] (757s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[261.399179] Starting subtest: coverage-vs-premult-vs-constant
[261.825547] Starting dynamic subtest: pipe-A-eDP-1
[262.367587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[262.376618] Starting dynamic subtest: pipe-D-eDP-1
[263.672603] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.304s)
[263.674914] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.273s)
[264.532983] [073/131] (754s left) kms_flip (2x-flip-vs-wf_vblank)
[264.637098] Starting subtest: 2x-flip-vs-wf_vblank
[264.647709] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[264.727016] [074/131] (753s left) kms_rotation_crc (exhaust-fences)
[264.819332] Starting subtest: exhaust-fences
[264.823810] Subtest exhaust-fences: SKIP (0.000s)
[264.885716] [075/131] (753s left) i915_pm_sseu (full-enable)
[264.941956] Subtest full-enable: SKIP (0.000s)
[265.040629] [076/131] (753s left) kms_cursor_edge_walk (128x128-right-edge)
[265.136072] Starting subtest: 128x128-right-edge
[265.138390] Starting dynamic subtest: pipe-A-eDP-1
[268.591543] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[268.600668] Starting dynamic subtest: pipe-D-eDP-1
[271.700031] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.107s)
[271.702363] Subtest 128x128-right-edge: SUCCESS (6.564s)
[272.522131] [077/131] (746s left) kms_lease (lease-get)
[272.619118] Starting subtest: lease-get
[272.621399] Starting dynamic subtest: pipe-A-eDP-1
[272.623675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[272.631815] Starting dynamic subtest: pipe-B-eDP-1
[272.633764] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[272.641081] Starting dynamic subtest: pipe-C-eDP-1
[272.642952] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[272.650436] Starting dynamic subtest: pipe-D-eDP-1
[272.652243] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[272.653982] Subtest lease-get: SUCCESS (0.008s)
[272.736676] [078/131] (746s left) kms_pm_rpm (legacy-planes-dpms)
[274.265625] Starting subtest: legacy-planes-dpms
[274.268899] Starting dynamic subtest: plane-41
[282.860024] Dynamic subtest plane-41: SUCCESS (8.594s)
[282.871045] Starting dynamic subtest: plane-50
[291.144405] Dynamic subtest plane-50: SUCCESS (8.282s)
[291.155073] Starting dynamic subtest: plane-59
[299.509273] Dynamic subtest plane-59: SUCCESS (8.363s)
[299.524760] Starting dynamic subtest: plane-68
[307.790958] Dynamic subtest plane-68: SUCCESS (8.278s)
[307.794022] Subtest legacy-planes-dpms: SUCCESS (33.526s)
[308.143796] [079/131] (710s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[313.104750] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[313.107045] Starting dynamic subtest: pipe-A-eDP-1
[313.911688] Dynamic subtest pipe-A-eDP-1: SKIP (0.803s)
[313.920470] Starting dynamic subtest: pipe-B-eDP-1
[315.140804] Dynamic subtest pipe-B-eDP-1: SKIP (1.227s)
[315.145179] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (2.034s)
[316.311449] [080/131] (702s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[316.416345] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[316.418600] Starting dynamic subtest: pipe-A
[316.754418] Dynamic subtest pipe-A: SUCCESS (0.338s)
[316.762855] Starting dynamic subtest: pipe-B
[318.187152] Dynamic subtest pipe-B: SUCCESS (1.432s)
[318.205971] Starting dynamic subtest: pipe-C
[319.606508] Dynamic subtest pipe-C: SUCCESS (1.419s)
[319.615931] Starting dynamic subtest: pipe-D
[321.031370] Dynamic subtest pipe-D: SUCCESS (1.424s)
[321.033706] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.616s)
[322.207146] [081/131] (696s left) kms_flip (dpms-vs-vblank-race)
[322.315787] Starting subtest: dpms-vs-vblank-race
[322.318059] Starting dynamic subtest: A-eDP1
[327.281753] Dynamic subtest A-eDP1: SUCCESS (4.963s)
[327.290098] Starting dynamic subtest: B-eDP1
[331.878451] Dynamic subtest B-eDP1: SUCCESS (4.596s)
[331.887081] Starting dynamic subtest: C-eDP1
[336.472386] Dynamic subtest C-eDP1: SUCCESS (4.593s)
[336.481557] Starting dynamic subtest: D-eDP1
[340.881634] Dynamic subtest D-eDP1: SUCCESS (4.408s)
[340.884173] Subtest dpms-vs-vblank-race: SUCCESS (18.570s)
[341.666865] [082/131] (677s left) kms_flip (flip-vs-absolute-wf_vblank)
[341.761271] Starting subtest: flip-vs-absolute-wf_vblank
[341.763542] Starting dynamic subtest: A-eDP1
[350.710042] Dynamic subtest A-eDP1: SUCCESS (8.948s)
[350.719352] Starting dynamic subtest: B-eDP1
[359.637283] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[359.646862] Starting dynamic subtest: C-eDP1
[368.546591] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[368.554809] Starting dynamic subtest: D-eDP1
[377.469808] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[377.473960] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.710s)
[378.675114] [083/131] (640s left) kms_psr (fbc-pr-cursor-blt)
[378.768937] Starting subtest: fbc-pr-cursor-blt
[378.773441] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[378.834367] [084/131] (640s left) kms_cursor_crc (cursor-onscreen-64x64)
[378.984299] Starting subtest: cursor-onscreen-64x64
[378.989440] Starting dynamic subtest: pipe-A-eDP-1
[381.275063] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.286s)
[381.299649] Starting dynamic subtest: pipe-D-eDP-1
[384.233993] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.942s)
[384.236403] Subtest cursor-onscreen-64x64: SUCCESS (5.248s)
[385.031410] [085/131] (634s left) gem_exec_fence (syncobj-timeline-signal)
[385.579590] Starting subtest: syncobj-timeline-signal
[385.585591] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[387.009034] [086/131] (632s left) gem_ctx_persistence (saturated-hostile)
[387.073632] Starting subtest: saturated-hostile
[387.075942] Starting dynamic subtest: rcs0
[387.922109] Dynamic subtest rcs0: SUCCESS (0.848s)
[387.933780] Starting dynamic subtest: bcs0
[388.749012] Dynamic subtest bcs0: SUCCESS (0.825s)
[388.760249] Starting dynamic subtest: vcs0
[389.572028] Dynamic subtest vcs0: SUCCESS (0.822s)
[389.583531] Starting dynamic subtest: vcs1
[390.395095] Dynamic subtest vcs1: SUCCESS (0.821s)
[390.406344] Starting dynamic subtest: vecs0
[391.199085] Dynamic subtest vecs0: SUCCESS (0.802s)
[391.211193] Starting dynamic subtest: ccs0
[392.039810] Dynamic subtest ccs0: SUCCESS (0.839s)
[392.042318] Subtest saturated-hostile: SUCCESS (4.967s)
[392.118764] [087/131] (627s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[392.219507] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[392.224025] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[392.318140] [088/131] (626s left) syncobj_basic (bad-destroy)
[392.385674] Starting subtest: bad-destroy
[392.388238] Subtest bad-destroy: SUCCESS (0.000s)
[392.496373] [089/131] (626s left) kms_dp_aux_dev
[392.849978] [090/131] (626s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[392.943708] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[392.948637] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[394.053504] [091/131] (625s left) gem_mmap_offset (partial-mmap)
[394.108112] Starting subtest: partial-mmap
[394.110031] Starting dynamic subtest: smem0
[394.112408] Dynamic subtest smem0: SUCCESS (0.005s)
[394.114745] Subtest partial-mmap: SUCCESS (0.005s)
[394.229678] [092/131] (625s left) device_reset (unbind-cold-reset-rebind)
[394.273872] Starting subtest: unbind-cold-reset-rebind
[394.278413] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[394.329500] [093/131] (624s left) i915_query (test-query-geometry-subslices)
[394.374074] Starting subtest: test-query-geometry-subslices
[394.376145] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[394.472296] [094/131] (624s left) i915_module_load (reload-with-fault-injection)
[394.508794] Starting subtest: reload-with-fault-injection
[434.292356] Subtest reload-with-fault-injection: SUCCESS (39.783s)
[434.313736] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[434.314537] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[434.317644] [095/131] (585s left) kms_vblank (wait-busy)
[435.676219] Starting subtest: wait-busy
[435.678124] Starting dynamic subtest: pipe-A-eDP-1
[437.583259] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.908s)
[437.596511] Starting dynamic subtest: pipe-D-eDP-1
[440.148728] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s)
[440.151095] Subtest wait-busy: SUCCESS (4.473s)
[440.942931] [FACT kms_vblank (wait-busy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[440.944627] [FACT kms_vblank (wait-busy)] new: kernel.kmod_is_loaded.i915: true
[440.948225] [096/131] (578s left) gem_render_copy (linear)
[441.013077] Starting subtest: linear
[441.015502] Starting dynamic subtest: smem
[441.058756] Dynamic subtest smem: SUCCESS (0.045s)
[441.061255] Subtest linear: SUCCESS (0.046s)
[441.303867] [097/131] (578s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[441.403898] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[441.406249] Starting dynamic subtest: pipe-A-default-mode
[442.718849] Dynamic subtest pipe-A-default-mode: SKIP (1.311s)
[442.723392] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.313s)
[442.888254] [098/131] (576s left) gem_userptr_blits (dmabuf-unsync)
[442.950176] Subtest dmabuf-unsync: SKIP (0.000s)
[443.080979] [099/131] (576s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[443.180534] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[443.184969] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[443.279399] [100/131] (576s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[443.394385] Starting subtest: y-tiled-32bpp-rotate-270
[443.398575] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[443.499707] [101/131] (576s left) gem_exec_balancer (individual)
[443.566270] Starting subtest: individual
[444.947371] Subtest individual: SUCCESS (1.379s)
[445.251980] [102/131] (574s left) kms_flip (flip-vs-expired-vblank)
[445.352199] Starting subtest: flip-vs-expired-vblank
[445.354523] Starting dynamic subtest: A-eDP1
[454.090329] Dynamic subtest A-eDP1: SUCCESS (8.738s)
[454.099320] Starting dynamic subtest: B-eDP1
[462.819696] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[462.828402] Starting dynamic subtest: C-eDP1
[471.534788] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[471.544492] Starting dynamic subtest: D-eDP1
[480.171971] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[480.174400] Subtest flip-vs-expired-vblank: SUCCESS (34.824s)
[481.326860] [103/131] (538s left) kms_psr (fbc-psr2-cursor-render)
[481.430888] Starting subtest: fbc-psr2-cursor-render
[481.433153] Starting dynamic subtest: eDP-1
[481.437200] Dynamic subtest eDP-1: SKIP (0.000s)
[481.441250] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[481.494377] [104/131] (538s left) kms_plane_scaling (intel-max-src-size)
[481.581138] Starting subtest: intel-max-src-size
[481.587839] Subtest intel-max-src-size: SKIP (0.000s)
[481.689693] [105/131] (538s left) gem_exec_reloc (basic-write-cpu-noreloc)
[481.741364] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[481.800264] [106/131] (537s left) gem_pxp (hw-rejects-pxp-buffer)
[481.926085] Starting subtest: hw-rejects-pxp-buffer
[481.930766] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[482.038933] [107/131] (537s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[482.143606] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[482.147754] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[482.247120] [108/131] (537s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[482.356486] Starting subtest: x-tiled-64bpp-rotate-90
[482.375345] Subtest x-tiled-64bpp-rotate-90: SKIP (0.018s)
[482.492243] [109/131] (537s left) kms_color (ctm-0-50)
[482.597468] Starting subtest: ctm-0-50
[482.599489] Starting dynamic subtest: pipe-A-eDP-1
[486.008865] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.408s)
[486.019746] Starting dynamic subtest: pipe-B-eDP-1
[490.086800] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.077s)
[490.095458] Starting dynamic subtest: pipe-C-eDP-1
[494.026926] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.940s)
[494.035712] Starting dynamic subtest: pipe-D-eDP-1
[498.016308] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.988s)
[498.018675] Subtest ctm-0-50: SUCCESS (15.417s)
[498.850979] [110/131] (521s left) syncobj_timeline (invalid-transfer-non-existent-point)
[498.915670] Starting subtest: invalid-transfer-non-existent-point
[498.917696] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[499.028453] [111/131] (520s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[499.087264] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[499.089218] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[499.189484] [112/131] (520s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[499.309067] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[499.313097] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[499.422155] [113/131] (520s left) gen9_exec_parse (shadow-peek)
[499.492615] Subtest shadow-peek: SKIP (0.000s)
[499.570809] [114/131] (520s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[499.675625] Starting subtest: 4-tiled-64bpp-rotate-180
[501.937722] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (2.261s)
[502.449649] [115/131] (517s left) kms_selftest (drm_dp_mst_helper)
[502.486415] Starting subtest: drm_dp_mst_helper
[502.503964] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[502.664340] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.160s)
[502.672330] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[502.817350] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.152s)
[502.825413] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[502.949452] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.131s)
[502.951666] Subtest drm_dp_mst_helper: SUCCESS (0.465s)
[503.141792] [116/131] (516s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[503.206335] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[503.311086] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[503.380350] [117/131] (516s left) syncobj_wait (invalid-reset-one-illegal-handle)
[503.432891] Starting subtest: invalid-reset-one-illegal-handle
[503.435125] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[503.538576] [118/131] (516s left) gem_cs_tlb (engines)
[503.597356] Starting subtest: engines
[503.599781] Starting dynamic subtest: rcs0
[505.753652] Dynamic subtest rcs0: SUCCESS (2.153s)
[505.762085] Starting dynamic subtest: bcs0
[507.909853] Dynamic subtest bcs0: SUCCESS (2.154s)
[507.918053] Starting dynamic subtest: vcs0
[510.062863] Dynamic subtest vcs0: SUCCESS (2.152s)
[510.071502] Starting dynamic subtest: vcs1
[512.215682] Dynamic subtest vcs1: SUCCESS (2.152s)
[512.226671] Starting dynamic subtest: vecs0
[514.368617] Dynamic subtest vecs0: SUCCESS (2.152s)
[514.381669] Starting dynamic subtest: ccs0
[516.521868] Dynamic subtest ccs0: SUCCESS (2.153s)
[516.523949] Subtest engines: SUCCESS (12.921s)
[516.650853] [119/131] (503s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[516.759356] Starting subtest: sprite-rotation-90-pos-100-0
[516.763777] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[516.827314] [120/131] (503s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[516.946883] Starting subtest: flip-vs-cursor-crc-atomic
[517.554533] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.607s)
[518.365111] [121/131] (501s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[518.465045] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[518.467434] Starting dynamic subtest: pipe-A-eDP-1
[518.490535] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[518.499727] Starting dynamic subtest: pipe-B-eDP-1
[518.522089] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[518.531803] Starting dynamic subtest: pipe-C-eDP-1
[518.553599] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[518.561334] Starting dynamic subtest: pipe-D-eDP-1
[518.583197] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[518.587598] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[520.620657] [122/131] (499s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[520.726125] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[520.736705] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[520.810428] [123/131] (499s left) kms_flip (flip-vs-panning-vs-hang)
[520.908111] Starting subtest: flip-vs-panning-vs-hang
[520.910390] Starting dynamic subtest: A-eDP1
[573.393062] Dynamic subtest A-eDP1: SUCCESS (52.485s)
[573.401887] Starting dynamic subtest: D-eDP1
[622.417384] Dynamic subtest D-eDP1: SUCCESS (49.024s)
[622.420633] Subtest flip-vs-panning-vs-hang: SUCCESS (101.512s)
[623.579785] [124/131] (396s left) gem_partial_pwrite_pread (write)
[623.644507] Subtest write: SKIP (0.000s)
[623.726757] [125/131] (396s left) gen7_exec_parse (cmd-crossing-page)
[623.796433] Subtest cmd-crossing-page: SKIP (0.000s)
[623.878847] [126/131] (396s left) kms_vblank (query-idle-hang)
[623.983049] Starting subtest: query-idle-hang
[623.985295] Starting dynamic subtest: pipe-A-eDP-1
[650.651790] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.668s)
[650.665480] Starting dynamic subtest: pipe-D-eDP-1
[675.749080] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.095s)
[675.751432] Subtest query-idle-hang: SUCCESS (51.767s)
[676.620143] [127/131] (343s left) gem_sync (basic-all)
[676.699101] Starting subtest: basic-all
[678.967612] Subtest basic-all: SUCCESS (2.278s)
[679.146634] [128/131] (341s left) drm_fdinfo (memory-info-shared)
[679.183118] Starting subtest: memory-info-shared
[679.185482] Starting dynamic subtest: smem0
[679.251834] Dynamic subtest smem0: SUCCESS (0.070s)
[679.254854] Subtest memory-info-shared: SUCCESS (0.070s)
[679.323298] [129/131] (341s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[679.443648] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[679.448078] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[679.558055] [130/131] (341s left) sw_sync (timeline_closed_signaled)
[679.594966] Starting subtest: timeline_closed_signaled
[679.597265] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[679.642398] [131/131] (341s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[679.739345] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[679.741640] Starting dynamic subtest: pipe-A-eDP-1
[679.811278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s)
[680.099948] Starting dynamic subtest: pipe-B-eDP-1
[680.921526] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.830s)
[681.195129] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.455s)
[682.057781] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: gem_exec_create
results: parsing output: 3/ for test: gem_bad_reloc
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_atomic_interruptible
results: parsing output: 6/ for test: gem_exec_capture
results: parsing output: 7/ for test: gem_pxp
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_prime
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: api_intel_bb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_whisper
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: kms_chamelium_edid
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_chamelium_audio
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_properties
results: parsing output: 31/ for test: gem_softpin
results: parsing output: 32/ for test: gem_close_race
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: syncobj_basic
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_pipe_b_c_ivb
results: parsing output: 48/ for test: api_intel_allocator
results: parsing output: 49/ for test: gem_render_copy_redux
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: sw_sync
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_getfb
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: sysfs_timeslice_duration
results: parsing output: 60/ for test: kms_joiner
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: sriov_basic
results: parsing output: 64/ for test: gem_ctx_create
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gen3_render_tiledx_blits
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_plane_alpha_blend
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: i915_pm_sseu
results: parsing output: 75/ for test: kms_cursor_edge_walk
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_basic
results: parsing output: 88/ for test: kms_dp_aux_dev
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_mmap_offset
results: parsing output: 91/ for test: device_reset
results: parsing output: 92/ for test: i915_query
results: parsing output: 93/ for test: i915_module_load
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_color
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_selftest
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: gem_cs_tlb
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: gem_partial_pwrite_pread
results: parsing output: 124/ for test: gen7_exec_parse
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: gem_sync
results: parsing output: 127/ for test: drm_fdinfo
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: sw_sync
results: parsing output: 130/ for test: kms_atomic_transition
Done.