[56.633360] Initializing watchdogs
[56.633507]   /dev/watchdog0
[56.648666] [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]
[56.653227] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.655826] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.660323] [001/134] (960s left) kms_flip (flip-vs-rmfb-interruptible)
[56.792437] Starting subtest: flip-vs-rmfb-interruptible
[56.794758] Starting dynamic subtest: A-eDP1
[65.482201] Dynamic subtest A-eDP1: SUCCESS (8.694s)
[65.491587] Starting dynamic subtest: B-eDP1
[74.102906] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[74.110505] Starting dynamic subtest: C-eDP1
[82.759351] Dynamic subtest C-eDP1: SUCCESS (8.656s)
[82.767900] Starting dynamic subtest: D-eDP1
[91.392088] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[91.396617] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.614s)
[92.647789] [002/134] (924s left) kms_addfb_basic (bo-too-small)
[92.747187] Starting subtest: bo-too-small
[92.749627] Subtest bo-too-small: SUCCESS (0.000s)
[92.866031] [003/134] (924s left) gem_mmap_gtt (basic-write-read-distinct)
[92.928722] Subtest basic-write-read-distinct: SKIP (0.000s)
[92.991323] [004/134] (924s left) syncobj_wait (multi-wait-for-submit-signaled)
[93.050610] Starting subtest: multi-wait-for-submit-signaled
[93.052895] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[93.159852] [005/134] (924s left) gem_ccs (ctrl-surf-copy-new-ctx)
[93.219481] Starting subtest: ctrl-surf-copy-new-ctx
[93.223676] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[93.337602] [006/134] (924s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[93.402575] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[93.404916] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[93.525757] [007/134] (923s left) kms_feature_discovery (display-3x)
[93.622918] Starting subtest: display-3x
[93.626731] Subtest display-3x: SKIP (0.000s)
[93.701827] [008/134] (923s left) api_intel_allocator (reloc-allocator)
[93.765311] Starting subtest: reloc-allocator
[93.766883] Starting dynamic subtest: basic
[93.768851] Dynamic subtest basic: SUCCESS (0.003s)
[93.779636] Starting dynamic subtest: parallel-one
[93.781595] Dynamic subtest parallel-one: SUCCESS (0.007s)
[93.790148] Starting dynamic subtest: print
[93.791667] Dynamic subtest print: SUCCESS (0.000s)
[93.797925] Starting dynamic subtest: reuse
[93.799505] Dynamic subtest reuse: SUCCESS (0.000s)
[93.805744] Starting dynamic subtest: fork-reopen-allocator
[93.807329] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[93.808960] Subtest reloc-allocator: SUCCESS (0.025s)
[93.938431] [009/134] (923s left) gem_exec_gttfill (basic)
[94.005228] Starting subtest: basic
[96.563976] Subtest basic: SUCCESS (2.558s)
[96.761168] [010/134] (920s left) gem_exec_schedule (preempt-queue-contexts-chain)
[96.892330] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[97.197893] [011/134] (920s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[97.262102] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[97.326784] [012/134] (920s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[97.440213] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[101.419875] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.984s)
[102.560244] [013/134] (915s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[102.684772] Starting subtest: cursorB-vs-flipA-legacy
[102.689478] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[102.840752] [014/134] (914s left) gem_render_copy (yf-tiled-ccs-to-linear)
[102.901174] Starting subtest: yf-tiled-ccs-to-linear
[102.905439] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[103.091313] [015/134] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[103.192600] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[103.197073] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[103.301271] [016/134] (914s left) gem_exec_schedule (fairslice)
[103.383280] Starting subtest: fairslice
[103.385591] Starting dynamic subtest: rcs0
[105.395841] Dynamic subtest rcs0: SUCCESS (2.019s)
[105.404295] Starting dynamic subtest: bcs0
[107.414323] Dynamic subtest bcs0: SUCCESS (2.018s)
[107.423669] Starting dynamic subtest: vcs0
[109.437918] Dynamic subtest vcs0: SUCCESS (2.021s)
[109.447786] Starting dynamic subtest: vcs1
[111.456324] Dynamic subtest vcs1: SUCCESS (2.017s)
[111.464322] Starting dynamic subtest: vecs0
[113.473620] Dynamic subtest vecs0: SUCCESS (2.017s)
[113.483051] Starting dynamic subtest: ccs0
[115.492293] Dynamic subtest ccs0: SUCCESS (2.020s)
[115.494294] Subtest fairslice: SUCCESS (12.116s)
[115.805923] [017/134] (901s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[115.914656] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[115.916866] Starting dynamic subtest: pipe-A-default-mode
[118.678094] Dynamic subtest pipe-A-default-mode: SUCCESS (2.760s)
[118.680066] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.762s)
[119.565166] [018/134] (898s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[119.677488] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[119.681891] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[119.801231] [019/134] (898s left) gem_userptr_blits (set-cache-level)
[119.866768] Starting subtest: set-cache-level
[119.870981] Subtest set-cache-level: SKIP (0.000s)
[120.003745] [020/134] (897s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[120.095417] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[120.106741] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[120.207537] [021/134] (897s left) gem_softpin (evict-active-interruptible)
[120.273243] Starting subtest: evict-active-interruptible
[120.279115] Subtest evict-active-interruptible: SUCCESS (0.006s)
[120.414435] [022/134] (897s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[120.508455] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[120.510043] Starting dynamic subtest: pipe-A-eDP-1
[120.528760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[120.536746] Starting dynamic subtest: pipe-B-eDP-1
[120.552887] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[120.561261] Starting dynamic subtest: pipe-C-eDP-1
[120.577038] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[120.584225] Starting dynamic subtest: pipe-D-eDP-1
[120.600377] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[120.602238] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[122.908682] [023/134] (895s left) kms_psr (fbc-psr2-dpms)
[123.013351] Starting subtest: fbc-psr2-dpms
[123.015696] Starting dynamic subtest: eDP-1
[123.020192] Dynamic subtest eDP-1: SKIP (0.000s)
[123.024604] Subtest fbc-psr2-dpms: SKIP (0.001s)
[123.094600] [024/134] (894s left) gem_tiled_pread_basic
[123.243331] [025/134] (894s left) gem_sync (basic-store-all)
[123.315468] Starting subtest: basic-store-all
[126.001443] Subtest basic-store-all: SUCCESS (2.696s)
[126.202830] [026/134] (891s left) kms_atomic_transition (plane-all-transition-fencing)
[126.326188] Starting subtest: plane-all-transition-fencing
[126.328475] Starting dynamic subtest: pipe-A-eDP-1
[128.830487] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.505s)
[129.134999] Starting dynamic subtest: pipe-B-eDP-1
[132.333795] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.206s)
[132.634941] Subtest plane-all-transition-fencing: SUCCESS (6.310s)
[133.469872] [027/134] (884s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[133.578939] Starting subtest: crc-primary-basic-yf-tiled-ccs
[133.581320] Starting dynamic subtest: pipe-A-eDP-1
[133.604139] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[133.612752] Starting dynamic subtest: pipe-B-eDP-1
[133.634560] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[133.642200] Starting dynamic subtest: pipe-C-eDP-1
[133.663310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[133.670896] Starting dynamic subtest: pipe-D-eDP-1
[133.692700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[133.696700] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[135.746081] [028/134] (882s left) gem_exec_reloc (basic-cpu-gtt)
[135.810342] Subtest basic-cpu-gtt: SKIP (0.000s)
[135.905585] [029/134] (882s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[135.977968] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[135.982634] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[136.185795] [030/134] (882s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[136.257979] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[136.317209] [031/134] (882s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[136.429602] Starting subtest: fbc-shrfb-scaledprimary
[139.472336] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.045s)
[140.644880] [032/134] (877s left) gem_eio (in-flight-contexts-1us)
[140.903803] Starting subtest: in-flight-contexts-1us
[154.940939] Subtest in-flight-contexts-1us: SUCCESS (14.035s)
[155.129317] [033/134] (863s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[155.230249] Starting subtest: coverage-vs-premult-vs-constant
[155.516573] Starting dynamic subtest: pipe-A-eDP-1
[156.091793] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[156.101523] Starting dynamic subtest: pipe-D-eDP-1
[157.447922] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[157.450296] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.218s)
[158.302890] [034/134] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[158.411767] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[158.416240] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[158.517376] [035/134] (859s left) kms_pwrite_crc
[160.133608] [036/134] (858s left) gem_lmem_swapping (heavy-multi)
[160.176308] Subtest heavy-multi: SKIP (0.000s)
[160.226202] [037/134] (858s left) gem_exec_schedule (preempt-other-chain)
[160.302289] Starting subtest: preempt-other-chain
[160.304235] Starting dynamic subtest: rcs0
[160.385907] Dynamic subtest rcs0: SUCCESS (0.091s)
[160.394176] Starting dynamic subtest: bcs0
[160.463328] Dynamic subtest bcs0: SUCCESS (0.076s)
[160.474670] Starting dynamic subtest: vcs0
[160.541224] Dynamic subtest vcs0: SUCCESS (0.077s)
[160.553948] Starting dynamic subtest: vcs1
[160.619450] Dynamic subtest vcs1: SUCCESS (0.078s)
[160.627600] Starting dynamic subtest: vecs0
[160.708427] Dynamic subtest vecs0: SUCCESS (0.088s)
[160.717561] Starting dynamic subtest: ccs0
[160.788898] Dynamic subtest ccs0: SUCCESS (0.079s)
[160.791321] Subtest preempt-other-chain: SUCCESS (0.495s)
[161.994183] [038/134] (856s left) kms_psr (psr-cursor-plane-move)
[162.094692] Starting subtest: psr-cursor-plane-move
[162.096819] Starting dynamic subtest: eDP-1
[163.827466] Dynamic subtest eDP-1: SUCCESS (1.733s)
[163.829868] Subtest psr-cursor-plane-move: SUCCESS (1.734s)
[164.696787] [039/134] (853s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[164.798917] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[164.801238] Starting dynamic subtest: pipe-A-eDP-1
[164.826550] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.839557] Starting dynamic subtest: pipe-B-eDP-1
[164.863129] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.870701] Starting dynamic subtest: pipe-C-eDP-1
[164.894251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.901952] Starting dynamic subtest: pipe-D-eDP-1
[164.926063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.930318] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[167.066032] [040/134] (851s left) dmabuf_sync_file (import-multiple-read-only)
[167.164998] Starting subtest: import-multiple-read-only
[167.167572] Subtest import-multiple-read-only: SUCCESS (0.004s)
[167.231387] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[167.234523] [041/134] (851s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[167.342688] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[168.532717] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.190s)
[168.678343] [042/134] (850s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[168.765209] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[168.767080] Starting dynamic subtest: pipe-A-eDP-1
[168.785731] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[168.794937] Starting dynamic subtest: pipe-B-eDP-1
[168.812583] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[168.819910] Starting dynamic subtest: pipe-C-eDP-1
[168.836933] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[168.843951] Starting dynamic subtest: pipe-D-eDP-1
[168.861524] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[168.865090] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[170.952261] [043/134] (847s left) gem_softpin (noreloc-interruptible)
[171.015602] Starting subtest: noreloc-interruptible
[176.400587] Subtest noreloc-interruptible: SUCCESS (5.384s)
[176.565016] [044/134] (842s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[176.652850] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[176.655083] Starting dynamic subtest: pipe-A
[176.674941] Dynamic subtest pipe-A: SKIP (0.017s)
[176.687783] Starting dynamic subtest: pipe-B
[176.725961] Dynamic subtest pipe-B: SKIP (0.051s)
[176.733930] Starting dynamic subtest: pipe-C
[176.760167] Dynamic subtest pipe-C: SKIP (0.033s)
[176.768120] Starting dynamic subtest: pipe-D
[176.794587] Dynamic subtest pipe-D: SKIP (0.032s)
[176.798781] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.139s)
[176.913044] [045/134] (841s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[176.978468] Starting subtest: multi-wait-all-for-submit-available-signaled
[176.980694] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[177.093344] [046/134] (841s left) gem_exec_balancer (bonded-sync)
[177.164356] Starting subtest: bonded-sync
[177.168642] Subtest bonded-sync: SKIP (0.000s)
[177.470837] [047/134] (841s left) gem_exec_fence (submit-chain)
[177.661797] Starting subtest: submit-chain
[177.679244] Subtest submit-chain: SUCCESS (0.017s)
[179.028952] [048/134] (839s left) vgem_basic (bad-handle)
[179.081985] Starting subtest: bad-handle
[179.084140] Subtest bad-handle: SUCCESS (0.000s)
[179.147465] [049/134] (839s left) kms_flip (basic-plain-flip)
[179.274846] Starting subtest: basic-plain-flip
[179.277129] Starting dynamic subtest: A-eDP1
[180.944174] Dynamic subtest A-eDP1: SUCCESS (1.668s)
[180.957624] Starting dynamic subtest: B-eDP1
[182.585878] Dynamic subtest B-eDP1: SUCCESS (1.639s)
[182.597478] Starting dynamic subtest: C-eDP1
[184.290562] Dynamic subtest C-eDP1: SUCCESS (1.702s)
[184.300773] Starting dynamic subtest: D-eDP1
[185.918315] Dynamic subtest D-eDP1: SUCCESS (1.627s)
[185.920686] Subtest basic-plain-flip: SUCCESS (6.648s)
[187.099250] [050/134] (831s left) gem_set_tiling_vs_pwrite
[187.247718] [051/134] (831s left) api_intel_bb (purge-bb)
[187.314576] Starting subtest: purge-bb
[187.320077] Subtest purge-bb: SUCCESS (0.004s)
[187.456836] [052/134] (831s left) gem_ctx_persistence (engines-hang)
[187.513602] Starting subtest: engines-hang
[187.515862] Starting dynamic subtest: rcs0
[187.654855] Dynamic subtest rcs0: SUCCESS (0.140s)
[187.666319] Starting dynamic subtest: bcs0
[187.705701] Dynamic subtest bcs0: SUCCESS (0.049s)
[187.719431] Starting dynamic subtest: vcs0
[187.813846] Dynamic subtest vcs0: SUCCESS (0.107s)
[187.825044] Starting dynamic subtest: vcs1
[187.934384] Dynamic subtest vcs1: SUCCESS (0.118s)
[187.948852] Starting dynamic subtest: vecs0
[188.049953] Dynamic subtest vecs0: SUCCESS (0.112s)
[188.061416] Starting dynamic subtest: ccs0
[188.175374] Dynamic subtest ccs0: SUCCESS (0.124s)
[188.177569] Subtest engines-hang: SUCCESS (0.663s)
[188.265225] [053/134] (830s left) kms_psr2_su (page_flip-nv12)
[188.325654] Subtest page_flip-NV12: SKIP (0.000s)
[188.383187] [054/134] (830s left) gem_exec_reloc (basic-wc-cpu)
[188.446142] Subtest basic-wc-cpu: SKIP (0.000s)
[188.535085] [055/134] (830s left) syncobj_wait (wait-any-snapshot)
[188.595355] Starting subtest: wait-any-snapshot
[188.677445] Subtest wait-any-snapshot: SUCCESS (0.081s)
[188.765284] [056/134] (830s left) drm_read (empty-nonblock)
[188.911789] Starting subtest: empty-nonblock
[188.913790] Subtest empty-nonblock: SUCCESS (0.000s)
[189.072370] [057/134] (830s left) gen9_exec_parse (batch-invalid-length)
[189.130528] Subtest batch-invalid-length: SKIP (0.000s)
[189.188019] [058/134] (830s left) gen3_render_mixed_blits
[189.328857] [059/134] (830s left) gem_ctx_create (basic)
[189.396480] Starting subtest: basic
[189.398435] Subtest basic: SUCCESS (0.000s)
[189.606953] [060/134] (829s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[189.711174] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[189.713500] Starting dynamic subtest: pipe-A-default-mode
[190.001927] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[190.006545] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.289s)
[190.825468] [061/134] (828s left) gem_mmap_gtt (ptrace)
[190.889888] Subtest ptrace: SKIP (0.000s)
[190.957234] [062/134] (828s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[191.054137] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[191.057970] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[191.147627] [063/134] (828s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[191.247755] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[191.251781] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[191.378510] [064/134] (828s left) syncobj_wait (multi-wait-all-signaled)
[191.450044] Starting subtest: multi-wait-all-signaled
[191.452261] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[191.577239] [065/134] (828s left) kms_prop_blob (invalid-set-prop-any)
[191.629437] Starting subtest: invalid-set-prop-any
[191.631699] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[191.751514] [066/134] (828s left) gem_lmem_swapping (verify-random)
[191.799912] Subtest verify-random: SKIP (0.000s)
[191.845871] [067/134] (827s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[191.911056] Starting subtest: single-wait-all-for-submit-available-signaled
[191.912902] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[192.033414] [068/134] (827s left) syncobj_timeline (reset-multiple-signaled)
[192.091039] Starting subtest: reset-multiple-signaled
[192.092744] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[192.228545] [069/134] (827s left) kms_chamelium_hpd (hdmi-hpd)
[192.635825] Subtest hdmi-hpd: SKIP (0.000s)
[193.438262] [070/134] (826s left) perf_pmu (rc6-all-gts)
[193.476655] Starting subtest: rc6-all-gts
[199.851773] Subtest rc6-all-gts: SUCCESS (6.375s)
[200.739152] [071/134] (819s left) kms_lease (simple-lease)
[200.844979] Starting subtest: simple-lease
[200.847356] Starting dynamic subtest: pipe-A-eDP-1
[201.343282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s)
[201.352149] Starting dynamic subtest: pipe-B-eDP-1
[202.785070] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[202.794601] Starting dynamic subtest: pipe-C-eDP-1
[204.204666] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.416s)
[204.213734] Starting dynamic subtest: pipe-D-eDP-1
[205.610515] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[205.612750] Subtest simple-lease: SUCCESS (4.765s)
[206.442220] [072/134] (813s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[206.552734] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[213.123543] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.576s)
[213.289904] [073/134] (806s left) kms_cursor_crc (cursor-onscreen-128x128)
[213.500824] Starting subtest: cursor-onscreen-128x128
[213.503112] Starting dynamic subtest: pipe-A-eDP-1
[215.590621] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.085s)
[215.616789] Starting dynamic subtest: pipe-D-eDP-1
[218.399044] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.787s)
[218.401180] Subtest cursor-onscreen-128x128: SUCCESS (4.898s)
[219.215714] [074/134] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[219.310828] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[226.391826] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.084s)
[226.497600] [075/134] (793s left) kms_pm_rpm (modeset-non-lpsp)
[228.131268] Starting subtest: modeset-non-lpsp
[229.282867] Subtest modeset-non-lpsp: SKIP (1.154s)
[229.672085] [076/134] (790s left) gem_exec_suspend (basic-s3-devices)
[229.743995] Starting subtest: basic-S3-devices
[229.746423] Starting dynamic subtest: smem
[240.919711] Dynamic subtest smem: SUCCESS (11.173s)
[240.922763] Subtest basic-S3-devices: SUCCESS (11.175s)
[241.119156] [077/134] (779s left) i915_drm_fdinfo (idle)
[241.178440] Starting subtest: idle
[241.180523] Starting dynamic subtest: rcs0
[241.779370] Dynamic subtest rcs0: SUCCESS (0.603s)
[241.791652] Starting dynamic subtest: bcs0
[242.290949] Dynamic subtest bcs0: SUCCESS (0.504s)
[242.302257] Starting dynamic subtest: vcs0
[242.793515] Dynamic subtest vcs0: SUCCESS (0.504s)
[242.806222] Starting dynamic subtest: vcs1
[243.301918] Dynamic subtest vcs1: SUCCESS (0.503s)
[243.311559] Starting dynamic subtest: vecs0
[243.803605] Dynamic subtest vecs0: SUCCESS (0.503s)
[243.816381] Starting dynamic subtest: ccs0
[244.308779] Dynamic subtest ccs0: SUCCESS (0.503s)
[244.311646] Subtest idle: SUCCESS (3.133s)
[244.414044] [078/134] (775s left) kms_joiner (invalid-modeset-ultra-joiner)
[244.514592] Starting subtest: invalid-modeset-ultra-joiner
[244.519078] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[244.598718] [079/134] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[244.701902] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[244.705969] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[244.846428] [080/134] (775s left) syncobj_basic (bad-create-flags)
[244.913600] Starting subtest: bad-create-flags
[244.916054] Subtest bad-create-flags: SUCCESS (0.000s)
[245.041796] [081/134] (775s left) syncobj_basic (bad-flags-fd-to-handle)
[245.100682] Starting subtest: bad-flags-fd-to-handle
[245.102966] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[245.231932] [082/134] (775s left) gem_pxp (display-protected-crc)
[245.365146] Starting subtest: display-protected-crc
[247.021750] Subtest display-protected-crc: SUCCESS (1.657s)
[247.137077] [083/134] (773s left) gem_softpin (safe-alignment)
[247.202309] Starting subtest: safe-alignment
[247.222590] Subtest safe-alignment: SUCCESS (0.020s)
[248.971895] [084/134] (771s left) i915_drm_fdinfo (virtual-busy-idle-all)
[249.006945] Starting subtest: virtual-busy-idle-all
[249.011382] Subtest virtual-busy-idle-all: SKIP (0.000s)
[249.079656] [085/134] (771s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[249.176248] Starting subtest: fb-8bpc-vs-panel-8bpc
[249.178540] Starting dynamic subtest: pipe-A-eDP-1
[250.589276] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.412s)
[250.591217] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.413s)
[251.389596] [086/134] (769s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[251.487296] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[251.491559] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[251.614395] [087/134] (769s left) i915_query (hwconfig_table)
[251.668929] Starting subtest: hwconfig_table
[251.967206] Subtest hwconfig_table: SUCCESS (0.001s)
[252.007429] [088/134] (768s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[252.102803] Starting subtest: basic-modeset-with-all-modifiers-formats
[252.479871] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[253.254184] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.774s)
[253.263926] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[253.275758] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[253.284688] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[253.298128] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[253.307227] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[253.442546] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[253.454132] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[253.464702] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[253.473989] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[253.486649] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[253.496134] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[253.509175] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[253.518204] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[253.531349] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[253.540180] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[253.553881] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[253.568971] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[253.575776] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[253.584760] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[253.598126] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[253.609620] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[253.620145] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[253.636275] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[253.779158] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[253.789878] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[253.798234] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[253.808484] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[253.820394] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[253.832234] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[253.842609] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[253.851669] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[253.865063] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[253.874566] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[253.887062] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[253.896887] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[253.909335] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[253.918585] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[253.931479] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[253.940662] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[253.953407] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[253.962831] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[254.109687] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[254.120188] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[254.131901] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[254.141121] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[254.154131] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[254.163368] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[254.176167] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[254.185208] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[254.198595] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[254.207731] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[254.220818] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[254.230272] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[254.242750] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[254.251650] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[254.264857] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[254.274716] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[254.286988] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[254.675024] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.574s)
[255.439735] [089/134] (765s left) kms_getfb (getfb2-handle-not-fb)
[255.533563] Starting subtest: getfb2-handle-not-fb
[255.535717] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[255.646555] [090/134] (765s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[255.834818] Starting subtest: cursor-rapid-movement-64x21
[255.883406] Subtest cursor-rapid-movement-64x21: SKIP (0.043s)
[256.132718] [091/134] (764s left) kms_cursor_crc (cursor-sliding-512x512)
[256.389158] Starting subtest: cursor-sliding-512x512
[256.393188] Subtest cursor-sliding-512x512: SKIP (0.001s)
[256.578654] [092/134] (764s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[256.685606] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[256.689136] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[256.802324] [093/134] (764s left) kms_big_fb (linear-16bpp-rotate-0)
[256.911363] Starting subtest: linear-16bpp-rotate-0
[258.290410] Subtest linear-16bpp-rotate-0: SUCCESS (1.378s)
[258.463922] [094/134] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[258.565367] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[258.568803] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[258.683306] [095/134] (762s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[258.780953] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[258.784281] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[258.911687] [096/134] (762s left) kms_psr (fbc-psr-no-drrs)
[259.000078] Starting subtest: fbc-psr-no-drrs
[259.002026] Starting dynamic subtest: eDP-1
[259.005437] Dynamic subtest eDP-1: SKIP (0.000s)
[259.008863] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[259.083730] [097/134] (761s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[259.171551] Starting subtest: primary-4-tiled-reflect-x-180
[266.268760] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.098s)
[267.505894] [098/134] (753s left) kms_content_protection (lic-type-1)
[267.646443] Starting subtest: lic-type-1
[267.650926] Subtest lic-type-1: SKIP (0.000s)
[267.795544] [099/134] (753s left) gem_ctx_shared (create-shared-gtt)
[267.868091] Starting subtest: create-shared-gtt
[270.020359] Subtest create-shared-gtt: SUCCESS (2.150s)
[270.482527] [100/134] (750s left) kms_flip (modeset-vs-vblank-race)
[270.591919] Starting subtest: modeset-vs-vblank-race
[270.594189] Starting dynamic subtest: A-eDP1
[275.317693] Dynamic subtest A-eDP1: SUCCESS (4.724s)
[275.329795] Starting dynamic subtest: B-eDP1
[280.025051] Dynamic subtest B-eDP1: SUCCESS (4.705s)
[280.037089] Starting dynamic subtest: C-eDP1
[284.726803] Dynamic subtest C-eDP1: SUCCESS (4.699s)
[284.740849] Starting dynamic subtest: D-eDP1
[289.355754] Dynamic subtest D-eDP1: SUCCESS (4.626s)
[289.358063] Subtest modeset-vs-vblank-race: SUCCESS (18.766s)
[290.636736] [101/134] (730s left) kms_plane_multiple (2x-tiling-none)
[290.737893] Starting subtest: 2x-tiling-none
[290.742128] Subtest 2x-tiling-none: SKIP (0.000s)
[290.838360] [102/134] (730s left) kms_async_flips (test-cursor)
[290.954168] Starting subtest: test-cursor
[290.958239] Subtest test-cursor: SKIP (0.000s)
[292.162454] [103/134] (729s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[292.258349] Starting subtest: y-tiled-16bpp-rotate-180
[292.262414] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[292.365919] [104/134] (729s left) gem_ctx_persistence (heartbeat-hang)
[292.435797] Starting subtest: heartbeat-hang
[292.440133] Subtest heartbeat-hang: SKIP (0.000s)
[292.558029] [105/134] (728s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[292.659658] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[292.661712] Starting dynamic subtest: pipe-A-eDP-1
[292.809835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.142s)
[292.819087] Starting dynamic subtest: pipe-B-eDP-1
[292.838231] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[292.848085] Starting dynamic subtest: pipe-C-eDP-1
[292.864674] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[292.874035] Starting dynamic subtest: pipe-D-eDP-1
[292.890192] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[292.891960] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.180s)
[295.119861] [106/134] (726s left) kms_flip (2x-absolute-wf_vblank)
[295.227588] Starting subtest: 2x-absolute-wf_vblank
[295.237785] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[295.350102] [107/134] (726s left) kms_chamelium_frames (hdmi-crc-fast)
[295.730183] Subtest hdmi-crc-fast: SKIP (0.000s)
[296.503447] [108/134] (725s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[296.569992] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[296.676128] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[296.769075] [109/134] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[296.873050] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[296.877643] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[296.971963] [110/134] (724s left) gem_exec_params (invalid-ring2)
[297.055603] Starting subtest: invalid-ring2
[297.057844] Subtest invalid-ring2: SUCCESS (0.000s)
[297.179178] [111/134] (724s left) prime_busy (hang-wait)
[297.240652] Starting subtest: hang-wait
[297.242921] Starting dynamic subtest: rcs0
[323.384965] Dynamic subtest rcs0: SUCCESS (26.140s)
[323.395094] Starting dynamic subtest: bcs0
[330.535818] Dynamic subtest bcs0: SUCCESS (7.149s)
[330.545286] Starting dynamic subtest: vcs0
[337.510404] Dynamic subtest vcs0: SUCCESS (6.970s)
[337.521531] Starting dynamic subtest: vcs1
[344.490685] Dynamic subtest vcs1: SUCCESS (6.977s)
[344.501577] Starting dynamic subtest: vecs0
[351.524449] Dynamic subtest vecs0: SUCCESS (7.034s)
[351.535727] Starting dynamic subtest: ccs0
[365.362992] Dynamic subtest ccs0: SUCCESS (13.835s)
[365.365543] Subtest hang-wait: SUCCESS (68.117s)
[365.524495] [112/134] (656s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[365.626726] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[365.628981] Starting dynamic subtest: pipe-A
[365.689417] Dynamic subtest pipe-A: SUCCESS (0.064s)
[365.699937] Starting dynamic subtest: pipe-B
[366.842176] Dynamic subtest pipe-B: SUCCESS (1.152s)
[366.853327] Starting dynamic subtest: pipe-C
[367.952245] Dynamic subtest pipe-C: SUCCESS (1.108s)
[367.961877] Starting dynamic subtest: pipe-D
[369.086682] Dynamic subtest pipe-D: SUCCESS (1.134s)
[369.089053] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.462s)
[370.254355] [113/134] (651s left) kms_vblank (query-forked-busy)
[370.348958] Starting subtest: query-forked-busy
[370.351250] Starting dynamic subtest: pipe-A-eDP-1
[372.232142] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[372.248908] Starting dynamic subtest: pipe-D-eDP-1
[374.810780] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.576s)
[374.812998] Subtest query-forked-busy: SUCCESS (4.461s)
[375.642858] [114/134] (646s left) gem_reg_read (timestamp-monotonic)
[375.710610] Starting subtest: timestamp-monotonic
[380.499354] Subtest timestamp-monotonic: SUCCESS (4.788s)
[380.587142] [115/134] (641s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[380.686576] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[380.691050] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[380.805382] [116/134] (641s left) i915_pm_rpm (gem-execbuf)
[383.136028] Starting subtest: gem-execbuf
[383.138549] Starting dynamic subtest: smem0
[384.860350] Dynamic subtest smem0: SUCCESS (1.727s)
[384.862642] Subtest gem-execbuf: SUCCESS (1.728s)
[384.959718] [117/134] (636s left) gem_exec_whisper (basic-fds)
[385.036502] Starting subtest: basic-fds
[390.978485] Subtest basic-fds: SUCCESS (5.943s)
[391.177230] [118/134] (630s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[391.276801] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[391.303374] Starting dynamic subtest: pipe-A-plane-0
[391.735704] Dynamic subtest pipe-A-plane-0: SUCCESS (0.432s)
[391.745329] Starting dynamic subtest: pipe-A-plane-3
[392.013425] Dynamic subtest pipe-A-plane-3: SUCCESS (0.277s)
[392.023592] Starting dynamic subtest: pipe-A-plane-5
[392.027913] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[393.101882] Starting dynamic subtest: pipe-B-plane-0
[393.549522] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[393.560921] Starting dynamic subtest: pipe-B-plane-3
[393.805069] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[393.815283] Starting dynamic subtest: pipe-B-plane-5
[393.819545] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[394.134379] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.859s)
[394.997409] [119/134] (627s left) gem_exec_balancer (parallel-bb-first)
[395.263637] Starting subtest: parallel-bb-first
[396.200655] Subtest parallel-bb-first: SUCCESS (0.937s)
[396.951751] [120/134] (625s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[397.066342] Starting subtest: 4-tiled-8bpp-rotate-90
[397.087117] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[397.246877] [121/134] (624s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[397.363643] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[397.368177] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[397.491126] [122/134] (624s left) kms_psr (pr-sprite-mmap-gtt)
[397.595912] Starting subtest: pr-sprite-mmap-gtt
[397.600288] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[397.680617] [123/134] (624s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[397.792722] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[398.561437] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.770s)
[398.780876] [124/134] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[398.886459] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[406.260035] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.376s)
[406.442598] [125/134] (615s left) kms_vblank (ts-continuation-modeset-rpm)
[406.550327] Starting subtest: ts-continuation-modeset-rpm
[406.552615] Starting dynamic subtest: pipe-A-eDP-1
[409.087037] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.535s)
[409.102684] Starting dynamic subtest: pipe-D-eDP-1
[411.344463] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.256s)
[411.346835] Subtest ts-continuation-modeset-rpm: SUCCESS (4.795s)
[412.158488] [126/134] (610s left) gem_mmap_gtt (basic-read)
[412.221670] Subtest basic-read: SKIP (0.000s)
[412.295940] [127/134] (610s left) gem_blits (basic)
[412.361722] Starting subtest: basic
[413.815381] Subtest basic: SUCCESS (1.453s)
[413.954638] [128/134] (608s left) kms_color (ctm-signed)
[414.047269] Starting subtest: ctm-signed
[414.049189] Starting dynamic subtest: pipe-A-eDP-1
[416.116670] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.067s)
[416.127282] Starting dynamic subtest: pipe-B-eDP-1
[419.008437] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.894s)
[419.018434] Starting dynamic subtest: pipe-C-eDP-1
[421.684804] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.672s)
[421.695169] Starting dynamic subtest: pipe-D-eDP-1
[424.347169] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.662s)
[424.349325] Subtest ctm-signed: SUCCESS (10.300s)
[425.182456] [129/134] (597s left) gem_eio (throttle)
[425.419872] Starting subtest: throttle
[425.767971] Subtest throttle: SUCCESS (0.348s)
[425.938654] [130/134] (596s left) syncobj_wait (invalid-signal-illegal-handle)
[425.993379] Starting subtest: invalid-signal-illegal-handle
[425.995668] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[426.102363] [131/134] (596s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[426.199853] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[426.203387] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[426.325423] [132/134] (596s left) kms_pm_backlight (fade-with-suspend)
[426.425905] Starting subtest: fade-with-suspend
[443.063914] Starting dynamic subtest: eDP-1
[445.742226] Dynamic subtest eDP-1: SUCCESS (2.685s)
[445.744564] Subtest fade-with-suspend: SUCCESS (3.915s)
[446.575840] [133/134] (576s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[451.642681] Starting subtest: psr2-overlay-plane-move-continuous-sf
[451.645035] Starting dynamic subtest: pipe-A-eDP-1
[458.336208] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.697s)
[458.347496] Starting dynamic subtest: pipe-B-eDP-1
[465.076101] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.739s)
[465.078510] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.439s)
[465.988342] [134/134] (556s left) perf (gen12-oa-tlb-invalidate)
[466.140331] Starting subtest: gen12-oa-tlb-invalidate
[466.142533] Starting dynamic subtest: 0-rcs0
[476.174721] Dynamic subtest 0-rcs0: SUCCESS (10.035s)
[476.185978] Starting dynamic subtest: 1-vcs0
[486.224834] Dynamic subtest 1-vcs0: SUCCESS (10.047s)
[486.227349] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.084s)
[486.264969] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_ccs
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: api_intel_allocator
results: parsing output: 8/ for test: gem_exec_gttfill
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_pipe_b_c_ivb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_softpin
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_tiled_pread_basic
results: parsing output: 24/ for test: gem_sync
results: parsing output: 25/ for test: kms_atomic_transition
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: gem_fenced_exec_thrash
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_eio
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_pwrite_crc
results: parsing output: 35/ for test: gem_lmem_swapping
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: dmabuf_sync_file
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: gem_exec_fence
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_psr2_su
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: drm_read
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: gen3_render_mixed_blits
results: parsing output: 58/ for test: gem_ctx_create
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: gem_exec_suspend
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_joiner
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: syncobj_basic
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: gem_softpin
results: parsing output: 83/ for test: i915_drm_fdinfo
results: parsing output: 84/ for test: kms_dither
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: i915_query
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: gem_ctx_shared
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_plane_multiple
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_chamelium_frames
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: prime_busy
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: gem_reg_read
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_blits
results: parsing output: 127/ for test: kms_color
results: parsing output: 128/ for test: gem_eio
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_pm_backlight
results: parsing output: 132/ for test: kms_psr2_sf
results: parsing output: 133/ for test: perf
Done.