[60.093775] Initializing watchdogs
[60.093823]   /dev/watchdog0
[60.107927] [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]
[60.112244] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.114566] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.116379] [001/134] (960s left) kms_flip (flip-vs-rmfb-interruptible)
[60.207337] Starting subtest: flip-vs-rmfb-interruptible
[60.209343] Starting dynamic subtest: A-eDP1
[68.881325] Dynamic subtest A-eDP1: SUCCESS (8.649s)
[68.889952] Starting dynamic subtest: B-eDP1
[77.555131] Dynamic subtest B-eDP1: SUCCESS (8.665s)
[77.562054] Starting dynamic subtest: C-eDP1
[86.164368] Dynamic subtest C-eDP1: SUCCESS (8.604s)
[86.171821] Starting dynamic subtest: D-eDP1
[94.798594] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[94.801386] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.557s)
[95.984500] [002/134] (924s left) kms_addfb_basic (bo-too-small)
[96.073172] Starting subtest: bo-too-small
[96.074074] Subtest bo-too-small: SUCCESS (0.000s)
[96.191891] [003/134] (924s left) gem_mmap_gtt (basic-write-read-distinct)
[96.253969] Subtest basic-write-read-distinct: SKIP (0.000s)
[96.316144] [004/134] (924s left) syncobj_wait (multi-wait-for-submit-signaled)
[96.379659] Starting subtest: multi-wait-for-submit-signaled
[96.380618] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[96.491654] [005/134] (924s left) gem_ccs (ctrl-surf-copy-new-ctx)
[96.540430] Starting subtest: ctrl-surf-copy-new-ctx
[96.542347] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[96.639791] [006/134] (924s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[96.693110] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[96.694176] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[96.785230] [007/134] (924s left) kms_feature_discovery (display-3x)
[96.875846] Starting subtest: display-3x
[96.877770] Subtest display-3x: SKIP (0.000s)
[96.950676] [008/134] (923s left) api_intel_allocator (reloc-allocator)
[97.014178] Starting subtest: reloc-allocator
[97.015171] Starting dynamic subtest: basic
[97.018678] Dynamic subtest basic: SUCCESS (0.004s)
[97.025881] Starting dynamic subtest: parallel-one
[97.026837] Dynamic subtest parallel-one: SUCCESS (0.007s)
[97.032342] Starting dynamic subtest: print
[97.033215] Dynamic subtest print: SUCCESS (0.000s)
[97.038416] Starting dynamic subtest: reuse
[97.039395] Dynamic subtest reuse: SUCCESS (0.000s)
[97.045823] Starting dynamic subtest: fork-reopen-allocator
[97.046805] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[97.047721] Subtest reloc-allocator: SUCCESS (0.028s)
[97.179856] [009/134] (923s left) gem_exec_gttfill (basic)
[97.238157] Starting subtest: basic
[99.836346] Subtest basic: SUCCESS (2.595s)
[100.024411] [010/134] (920s left) gem_exec_schedule (preempt-queue-contexts-chain)
[100.107029] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[100.412662] [011/134] (920s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[100.453040] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[100.512121] [012/134] (920s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[100.606774] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[104.665408] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.057s)
[105.789872] [013/134] (915s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[105.902702] Starting subtest: cursorB-vs-flipA-legacy
[105.905852] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[106.060500] [014/134] (914s left) gem_render_copy (yf-tiled-ccs-to-linear)
[106.126636] Starting subtest: yf-tiled-ccs-to-linear
[106.128425] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[106.311768] [015/134] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[106.403997] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[106.405954] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[106.512313] [016/134] (914s left) gem_exec_schedule (fairslice)
[106.564475] Starting subtest: fairslice
[106.565437] Starting dynamic subtest: rcs0
[108.586432] Dynamic subtest rcs0: SUCCESS (2.019s)
[108.593094] Starting dynamic subtest: bcs0
[110.605283] Dynamic subtest bcs0: SUCCESS (2.019s)
[110.612839] Starting dynamic subtest: vcs0
[112.624705] Dynamic subtest vcs0: SUCCESS (2.018s)
[112.632902] Starting dynamic subtest: vcs1
[114.643739] Dynamic subtest vcs1: SUCCESS (2.016s)
[114.650321] Starting dynamic subtest: vecs0
[116.661488] Dynamic subtest vecs0: SUCCESS (2.018s)
[116.668063] Starting dynamic subtest: ccs0
[118.679771] Dynamic subtest ccs0: SUCCESS (2.016s)
[118.680686] Subtest fairslice: SUCCESS (12.111s)
[118.981359] [017/134] (902s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[119.087529] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[119.088454] Starting dynamic subtest: pipe-A-default-mode
[121.822297] Dynamic subtest pipe-A-default-mode: SUCCESS (2.732s)
[121.823243] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.734s)
[122.680936] [018/134] (898s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[122.798747] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[122.800444] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[122.911502] [019/134] (898s left) gem_userptr_blits (set-cache-level)
[122.982878] Starting subtest: set-cache-level
[122.984767] Subtest set-cache-level: SKIP (0.000s)
[123.142465] [020/134] (898s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[123.241446] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[123.254464] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.013s)
[123.337412] [021/134] (897s left) gem_softpin (evict-active-interruptible)
[123.394874] Starting subtest: evict-active-interruptible
[123.402390] Subtest evict-active-interruptible: SUCCESS (0.008s)
[123.554313] [022/134] (897s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[123.642678] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[123.643700] Starting dynamic subtest: pipe-A-eDP-1
[123.662150] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[123.672398] Starting dynamic subtest: pipe-B-eDP-1
[123.684398] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[123.691602] Starting dynamic subtest: pipe-C-eDP-1
[123.706364] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[123.713471] Starting dynamic subtest: pipe-D-eDP-1
[123.727667] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[123.728517] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[125.965590] [023/134] (895s left) kms_psr (fbc-psr2-dpms)
[126.057807] Starting subtest: fbc-psr2-dpms
[126.058812] Starting dynamic subtest: eDP-1
[126.060826] Dynamic subtest eDP-1: SKIP (0.000s)
[126.062613] Subtest fbc-psr2-dpms: SKIP (0.001s)
[126.132009] [024/134] (895s left) gem_tiled_pread_basic
[126.250063] [025/134] (895s left) gem_sync (basic-store-all)
[126.312264] Starting subtest: basic-store-all
[128.659501] Subtest basic-store-all: SUCCESS (2.348s)
[128.851308] [026/134] (892s left) kms_atomic_transition (plane-all-transition-fencing)
[128.972492] Starting subtest: plane-all-transition-fencing
[128.974375] Starting dynamic subtest: pipe-A-eDP-1
[131.475750] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[131.785068] Starting dynamic subtest: pipe-B-eDP-1
[134.992483] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.217s)
[135.299210] Subtest plane-all-transition-fencing: SUCCESS (6.326s)
[136.138574] [027/134] (885s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[136.242490] Starting subtest: crc-primary-basic-yf-tiled-ccs
[136.243438] Starting dynamic subtest: pipe-A-eDP-1
[136.252484] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[136.265903] Starting dynamic subtest: pipe-B-eDP-1
[136.275879] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[136.289292] Starting dynamic subtest: pipe-C-eDP-1
[136.298091] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[136.311597] Starting dynamic subtest: pipe-D-eDP-1
[136.320907] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[136.322784] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.007s)
[138.400967] [028/134] (883s left) gem_exec_reloc (basic-cpu-gtt)
[138.466161] Subtest basic-cpu-gtt: SKIP (0.000s)
[138.547318] [029/134] (882s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[138.600895] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[138.602844] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[138.782267] [030/134] (882s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[138.843937] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[138.915868] [031/134] (882s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[139.022697] Starting subtest: fbc-shrfb-scaledprimary
[142.014279] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.992s)
[143.203078] [032/134] (878s left) gem_eio (in-flight-contexts-1us)
[143.456037] Starting subtest: in-flight-contexts-1us
[154.917501] Subtest in-flight-contexts-1us: SUCCESS (11.462s)
[155.127658] [033/134] (866s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[155.219252] Starting subtest: coverage-vs-premult-vs-constant
[155.501292] Starting dynamic subtest: pipe-A-eDP-1
[156.042285] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[156.050552] Starting dynamic subtest: pipe-D-eDP-1
[157.443073] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.399s)
[157.444455] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.225s)
[158.246570] [034/134] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[158.336903] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[158.338861] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[158.439435] [035/134] (863s left) kms_pwrite_crc
[160.076422] [036/134] (861s left) gem_lmem_swapping (heavy-multi)
[160.110768] Subtest heavy-multi: SKIP (0.000s)
[160.149455] [037/134] (861s left) gem_exec_schedule (preempt-other-chain)
[160.219083] Starting subtest: preempt-other-chain
[160.219975] Starting dynamic subtest: rcs0
[160.309724] Dynamic subtest rcs0: SUCCESS (0.089s)
[160.318747] Starting dynamic subtest: bcs0
[160.392694] Dynamic subtest bcs0: SUCCESS (0.082s)
[160.401631] Starting dynamic subtest: vcs0
[160.485476] Dynamic subtest vcs0: SUCCESS (0.092s)
[160.495894] Starting dynamic subtest: vcs1
[160.566624] Dynamic subtest vcs1: SUCCESS (0.080s)
[160.576506] Starting dynamic subtest: vecs0
[160.650849] Dynamic subtest vecs0: SUCCESS (0.083s)
[160.660072] Starting dynamic subtest: ccs0
[160.735684] Dynamic subtest ccs0: SUCCESS (0.084s)
[160.737110] Subtest preempt-other-chain: SUCCESS (0.516s)
[162.058287] [038/134] (859s left) kms_psr (psr-cursor-plane-move)
[162.148257] Starting subtest: psr-cursor-plane-move
[162.149070] Starting dynamic subtest: eDP-1
[163.863872] Dynamic subtest eDP-1: SUCCESS (1.714s)
[163.864871] Subtest psr-cursor-plane-move: SUCCESS (1.715s)
[164.754383] [039/134] (857s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[164.851641] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[164.852584] Starting dynamic subtest: pipe-A-eDP-1
[164.862296] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.868841] Starting dynamic subtest: pipe-B-eDP-1
[164.878540] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.885375] Starting dynamic subtest: pipe-C-eDP-1
[164.895761] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.902062] Starting dynamic subtest: pipe-D-eDP-1
[164.911899] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.913657] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[167.123468] [040/134] (854s left) dmabuf_sync_file (import-multiple-read-only)
[167.236720] Starting subtest: import-multiple-read-only
[167.240466] Subtest import-multiple-read-only: SUCCESS (0.004s)
[167.301310] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[167.303135] [041/134] (854s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[167.407953] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[168.464685] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.057s)
[168.593415] [042/134] (853s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[168.687071] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[168.687857] Starting dynamic subtest: pipe-A-eDP-1
[168.695818] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[168.702533] Starting dynamic subtest: pipe-B-eDP-1
[168.710655] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[168.717640] Starting dynamic subtest: pipe-C-eDP-1
[168.725815] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[168.731870] Starting dynamic subtest: pipe-D-eDP-1
[168.739901] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[168.741558] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[170.923286] [043/134] (850s left) gem_softpin (noreloc-interruptible)
[170.991141] Starting subtest: noreloc-interruptible
[176.388916] Subtest noreloc-interruptible: SUCCESS (5.395s)
[176.562353] [044/134] (845s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[176.666245] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[176.667080] Starting dynamic subtest: pipe-A
[176.682603] Dynamic subtest pipe-A: SKIP (0.015s)
[176.689233] Starting dynamic subtest: pipe-B
[176.711023] Dynamic subtest pipe-B: SKIP (0.027s)
[176.717610] Starting dynamic subtest: pipe-C
[176.738213] Dynamic subtest pipe-C: SKIP (0.027s)
[176.744489] Starting dynamic subtest: pipe-D
[176.766687] Dynamic subtest pipe-D: SKIP (0.027s)
[176.768391] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.099s)
[176.891755] [045/134] (845s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[176.950689] Starting subtest: multi-wait-all-for-submit-available-signaled
[176.951667] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[177.076232] [046/134] (844s left) gem_exec_balancer (bonded-sync)
[177.154794] Starting subtest: bonded-sync
[177.157208] Subtest bonded-sync: SKIP (0.000s)
[177.476340] [047/134] (844s left) gem_exec_fence (submit-chain)
[177.662178] Starting subtest: submit-chain
[177.680090] Subtest submit-chain: SUCCESS (0.018s)
[180.038307] [048/134] (842s left) vgem_basic (bad-handle)
[180.072551] Starting subtest: bad-handle
[180.073579] Subtest bad-handle: SUCCESS (0.000s)
[180.151060] [049/134] (841s left) kms_flip (basic-plain-flip)
[180.252561] Starting subtest: basic-plain-flip
[180.256349] Starting dynamic subtest: A-eDP1
[181.903334] Dynamic subtest A-eDP1: SUCCESS (1.649s)
[181.913136] Starting dynamic subtest: B-eDP1
[183.535154] Dynamic subtest B-eDP1: SUCCESS (1.630s)
[183.545183] Starting dynamic subtest: C-eDP1
[185.155750] Dynamic subtest C-eDP1: SUCCESS (1.618s)
[185.163634] Starting dynamic subtest: D-eDP1
[186.791486] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[186.794550] Subtest basic-plain-flip: SUCCESS (6.543s)
[187.970853] [050/134] (834s left) gem_set_tiling_vs_pwrite
[188.090223] [051/134] (834s left) api_intel_bb (purge-bb)
[188.154153] Starting subtest: purge-bb
[188.157498] Subtest purge-bb: SUCCESS (0.005s)
[188.307427] [052/134] (833s left) gem_ctx_persistence (engines-hang)
[188.359907] Starting subtest: engines-hang
[188.360729] Starting dynamic subtest: rcs0
[188.462801] Dynamic subtest rcs0: SUCCESS (0.102s)
[188.472473] Starting dynamic subtest: bcs0
[188.573430] Dynamic subtest bcs0: SUCCESS (0.108s)
[188.583267] Starting dynamic subtest: vcs0
[188.699730] Dynamic subtest vcs0: SUCCESS (0.124s)
[188.709814] Starting dynamic subtest: vcs1
[188.825724] Dynamic subtest vcs1: SUCCESS (0.124s)
[188.835839] Starting dynamic subtest: vecs0
[188.949320] Dynamic subtest vecs0: SUCCESS (0.122s)
[188.959097] Starting dynamic subtest: ccs0
[189.073501] Dynamic subtest ccs0: SUCCESS (0.122s)
[189.074732] Subtest engines-hang: SUCCESS (0.714s)
[189.157443] [053/134] (833s left) kms_psr2_su (page_flip-nv12)
[189.223285] Subtest page_flip-NV12: SKIP (0.000s)
[189.284453] [054/134] (832s left) gem_exec_reloc (basic-wc-cpu)
[189.345203] Subtest basic-wc-cpu: SKIP (0.000s)
[189.420379] [055/134] (832s left) syncobj_wait (wait-any-snapshot)
[189.482729] Starting subtest: wait-any-snapshot
[189.564628] Subtest wait-any-snapshot: SUCCESS (0.081s)
[189.645386] [056/134] (832s left) drm_read (empty-nonblock)
[189.780140] Starting subtest: empty-nonblock
[189.780961] Subtest empty-nonblock: SUCCESS (0.000s)
[189.934806] [057/134] (832s left) gen9_exec_parse (batch-invalid-length)
[189.991941] Subtest batch-invalid-length: SKIP (0.000s)
[190.067422] [058/134] (832s left) gen3_render_mixed_blits
[190.185954] [059/134] (832s left) gem_ctx_create (basic)
[190.258599] Starting subtest: basic
[190.259676] Subtest basic: SUCCESS (0.000s)
[190.460991] [060/134] (831s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[190.559373] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[190.560394] Starting dynamic subtest: pipe-A-default-mode
[190.851897] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[190.853697] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.292s)
[191.690311] [061/134] (830s left) gem_mmap_gtt (ptrace)
[191.749477] Subtest ptrace: SKIP (0.000s)
[191.817328] [062/134] (830s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[191.915071] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[191.916889] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[192.035525] [063/134] (830s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[192.138583] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[192.140400] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[192.260160] [064/134] (830s left) syncobj_wait (multi-wait-all-signaled)
[192.316194] Starting subtest: multi-wait-all-signaled
[192.317041] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[192.418233] [065/134] (830s left) kms_prop_blob (invalid-set-prop-any)
[192.475393] Starting subtest: invalid-set-prop-any
[192.476311] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[192.586924] [066/134] (830s left) gem_lmem_swapping (verify-random)
[192.628887] Subtest verify-random: SKIP (0.000s)
[192.665917] [067/134] (830s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[192.722991] Starting subtest: single-wait-all-for-submit-available-signaled
[192.724087] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[192.848169] [068/134] (829s left) syncobj_timeline (reset-multiple-signaled)
[192.906792] Starting subtest: reset-multiple-signaled
[192.907806] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[193.025988] [069/134] (829s left) kms_chamelium_hpd (hdmi-hpd)
[193.407620] Subtest hdmi-hpd: SKIP (0.000s)
[194.181229] [070/134] (828s left) perf_pmu (rc6-all-gts)
[194.224606] Starting subtest: rc6-all-gts
[200.590369] Subtest rc6-all-gts: SUCCESS (6.364s)
[200.971713] [071/134] (821s left) kms_lease (simple-lease)
[201.065865] Starting subtest: simple-lease
[201.066777] Starting dynamic subtest: pipe-A-eDP-1
[201.562443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s)
[201.571348] Starting dynamic subtest: pipe-B-eDP-1
[203.055365] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.491s)
[203.063431] Starting dynamic subtest: pipe-C-eDP-1
[204.459792] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[204.466867] Starting dynamic subtest: pipe-D-eDP-1
[205.855424] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.395s)
[205.856326] Subtest simple-lease: SUCCESS (4.791s)
[206.672385] [072/134] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[206.770397] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[213.328611] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.560s)
[213.482327] [073/134] (809s left) kms_cursor_crc (cursor-onscreen-128x128)
[213.686106] Starting subtest: cursor-onscreen-128x128
[213.690239] Starting dynamic subtest: pipe-A-eDP-1
[215.786119] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s)
[215.813161] Starting dynamic subtest: pipe-D-eDP-1
[218.592160] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.787s)
[218.592954] Subtest cursor-onscreen-128x128: SUCCESS (4.906s)
[219.397033] [074/134] (803s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[219.488608] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[226.491871] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.004s)
[226.615648] [075/134] (796s left) kms_pm_rpm (modeset-non-lpsp)
[228.143844] Starting subtest: modeset-non-lpsp
[229.286279] Subtest modeset-non-lpsp: SKIP (1.145s)
[229.664547] [076/134] (793s left) gem_exec_suspend (basic-s3-devices)
[229.718367] Starting subtest: basic-S3-devices
[229.719288] Starting dynamic subtest: smem
[240.920122] Dynamic subtest smem: SUCCESS (11.198s)
[240.921755] Subtest basic-S3-devices: SUCCESS (11.200s)
[247.123531] [077/134] (781s left) i915_drm_fdinfo (idle)
[247.164435] Starting subtest: idle
[247.165401] Starting dynamic subtest: rcs0
[247.744664] Dynamic subtest rcs0: SUCCESS (0.579s)
[247.756191] Starting dynamic subtest: bcs0
[248.252658] Dynamic subtest bcs0: SUCCESS (0.503s)
[248.262755] Starting dynamic subtest: vcs0
[248.759051] Dynamic subtest vcs0: SUCCESS (0.503s)
[248.769941] Starting dynamic subtest: vcs1
[249.264822] Dynamic subtest vcs1: SUCCESS (0.503s)
[249.275667] Starting dynamic subtest: vecs0
[249.769202] Dynamic subtest vecs0: SUCCESS (0.503s)
[249.780264] Starting dynamic subtest: ccs0
[250.275950] Dynamic subtest ccs0: SUCCESS (0.503s)
[250.277697] Subtest idle: SUCCESS (3.110s)
[250.369219] [078/134] (778s left) kms_joiner (invalid-modeset-ultra-joiner)
[250.474694] Starting subtest: invalid-modeset-ultra-joiner
[250.476531] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[250.571390] [079/134] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[250.669679] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[250.671527] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[250.766398] [080/134] (778s left) syncobj_basic (bad-create-flags)
[250.829219] Starting subtest: bad-create-flags
[250.830122] Subtest bad-create-flags: SUCCESS (0.000s)
[250.947864] [081/134] (778s left) syncobj_basic (bad-flags-fd-to-handle)
[250.997306] Starting subtest: bad-flags-fd-to-handle
[250.998232] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[251.112170] [082/134] (778s left) gem_pxp (display-protected-crc)
[251.221166] Starting subtest: display-protected-crc
[252.848143] Subtest display-protected-crc: SUCCESS (1.628s)
[252.994402] [083/134] (776s left) gem_softpin (safe-alignment)
[253.057134] Starting subtest: safe-alignment
[253.077667] Subtest safe-alignment: SUCCESS (0.020s)
[254.983410] [084/134] (774s left) i915_drm_fdinfo (virtual-busy-idle-all)
[255.021399] Starting subtest: virtual-busy-idle-all
[255.023296] Subtest virtual-busy-idle-all: SKIP (0.000s)
[255.099269] [085/134] (774s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[255.183204] Starting subtest: fb-8bpc-vs-panel-8bpc
[255.184025] Starting dynamic subtest: pipe-A-eDP-1
[256.597198] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.414s)
[256.598136] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.415s)
[257.404416] [086/134] (771s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[257.492423] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[257.494207] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[257.620392] [087/134] (771s left) i915_query (hwconfig_table)
[257.673917] Starting subtest: hwconfig_table
[257.786393] Subtest hwconfig_table: SUCCESS (0.001s)
[257.814472] [088/134] (771s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[257.909546] Starting subtest: basic-modeset-with-all-modifiers-formats
[258.294906] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[259.089096] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.794s)
[259.097126] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[259.110567] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[259.118042] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[259.132737] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[259.140296] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[259.277301] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[259.285787] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[259.299631] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[259.309105] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[259.321816] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[259.329899] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[259.344109] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[259.352291] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[259.366131] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[259.374987] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[259.388463] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[259.396369] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[259.410668] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[259.418436] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[259.432889] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[259.441840] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[259.455048] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[259.464146] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[259.599552] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.143s)
[259.607694] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[259.621723] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[259.629721] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[259.643869] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[259.651827] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[259.666137] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[259.673960] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[259.688482] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[259.696584] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[259.710756] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[259.718761] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[259.732885] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[259.740919] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[259.755083] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[259.763944] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[259.777368] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[259.786409] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[259.933292] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[259.942056] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[259.955516] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[259.963693] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[259.977745] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[259.985734] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[259.999958] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[260.007868] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[260.022142] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[260.030145] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[260.044438] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[260.052379] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[260.066661] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[260.074698] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[260.088907] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[260.097090] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[260.111043] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[260.505684] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.597s)
[261.276846] [089/134] (768s left) kms_getfb (getfb2-handle-not-fb)
[261.376551] Starting subtest: getfb2-handle-not-fb
[261.377377] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[261.484872] [090/134] (767s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[261.665412] Starting subtest: cursor-rapid-movement-64x21
[261.706454] Subtest cursor-rapid-movement-64x21: SKIP (0.039s)
[261.983400] [091/134] (767s left) kms_cursor_crc (cursor-sliding-512x512)
[262.246902] Starting subtest: cursor-sliding-512x512
[262.248786] Subtest cursor-sliding-512x512: SKIP (0.001s)
[262.395169] [092/134] (767s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[262.499858] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[262.501528] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[262.633231] [093/134] (766s left) kms_big_fb (linear-16bpp-rotate-0)
[262.743310] Starting subtest: linear-16bpp-rotate-0
[264.177058] Subtest linear-16bpp-rotate-0: SUCCESS (1.434s)
[264.332558] [094/134] (765s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[264.431713] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[264.433330] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[264.565634] [095/134] (765s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[264.666728] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[264.668424] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[264.784454] [096/134] (764s left) kms_psr (fbc-psr-no-drrs)
[264.883714] Starting subtest: fbc-psr-no-drrs
[264.884809] Starting dynamic subtest: eDP-1
[264.886725] Dynamic subtest eDP-1: SKIP (0.000s)
[264.888604] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[264.962374] [097/134] (764s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[265.061270] Starting subtest: primary-4-tiled-reflect-x-180
[272.128611] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.068s)
[273.343293] [098/134] (756s left) kms_content_protection (lic-type-1)
[273.501105] Starting subtest: lic-type-1
[273.502979] Subtest lic-type-1: SKIP (0.000s)
[273.639133] [099/134] (756s left) gem_ctx_shared (create-shared-gtt)
[273.699548] Starting subtest: create-shared-gtt
[275.853540] Subtest create-shared-gtt: SUCCESS (2.151s)
[276.266131] [100/134] (753s left) kms_flip (modeset-vs-vblank-race)
[276.359915] Starting subtest: modeset-vs-vblank-race
[276.361445] Starting dynamic subtest: A-eDP1
[281.077861] Dynamic subtest A-eDP1: SUCCESS (4.716s)
[281.088496] Starting dynamic subtest: B-eDP1
[285.834627] Dynamic subtest B-eDP1: SUCCESS (4.754s)
[285.850328] Starting dynamic subtest: C-eDP1
[290.535477] Dynamic subtest C-eDP1: SUCCESS (4.698s)
[290.549079] Starting dynamic subtest: D-eDP1
[295.069900] Dynamic subtest D-eDP1: SUCCESS (4.533s)
[295.072824] Subtest modeset-vs-vblank-race: SUCCESS (18.712s)
[296.332196] [101/134] (733s left) kms_plane_multiple (2x-tiling-none)
[296.432582] Starting subtest: 2x-tiling-none
[296.434277] Subtest 2x-tiling-none: SKIP (0.000s)
[296.518168] [102/134] (733s left) kms_async_flips (test-cursor)
[296.607271] Starting subtest: test-cursor
[296.608988] Subtest test-cursor: SKIP (0.000s)
[297.861007] [103/134] (732s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[297.965781] Starting subtest: y-tiled-16bpp-rotate-180
[297.967492] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[298.106140] [104/134] (731s left) gem_ctx_persistence (heartbeat-hang)
[298.161406] Starting subtest: heartbeat-hang
[298.163287] Subtest heartbeat-hang: SKIP (0.000s)
[298.338337] [105/134] (731s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[298.434873] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[298.435784] Starting dynamic subtest: pipe-A-eDP-1
[298.579957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[298.589256] Starting dynamic subtest: pipe-B-eDP-1
[298.596339] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[298.604234] Starting dynamic subtest: pipe-C-eDP-1
[298.611353] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[298.619079] Starting dynamic subtest: pipe-D-eDP-1
[298.626494] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[298.627349] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.177s)
[300.930864] [106/134] (729s left) kms_flip (2x-absolute-wf_vblank)
[301.033606] Starting subtest: 2x-absolute-wf_vblank
[301.045948] Subtest 2x-absolute-wf_vblank: SKIP (0.012s)
[301.135382] [107/134] (728s left) kms_chamelium_frames (hdmi-crc-fast)
[301.514043] Subtest hdmi-crc-fast: SKIP (0.000s)
[302.326361] [108/134] (727s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[302.387495] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[302.489588] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[302.582282] [109/134] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[302.673130] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[302.674741] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[302.787820] [110/134] (727s left) gem_exec_params (invalid-ring2)
[302.855318] Starting subtest: invalid-ring2
[302.856632] Subtest invalid-ring2: SUCCESS (0.000s)
[303.000443] [111/134] (727s left) prime_busy (hang-wait)
[303.076448] Starting subtest: hang-wait
[303.077522] Starting dynamic subtest: rcs0
[329.519184] Dynamic subtest rcs0: SUCCESS (26.438s)
[329.537392] Starting dynamic subtest: bcs0
[336.490210] Dynamic subtest bcs0: SUCCESS (6.967s)
[336.498086] Starting dynamic subtest: vcs0
[343.537372] Dynamic subtest vcs0: SUCCESS (7.047s)
[343.548346] Starting dynamic subtest: vcs1
[350.501542] Dynamic subtest vcs1: SUCCESS (6.960s)
[350.511313] Starting dynamic subtest: vecs0
[357.564774] Dynamic subtest vecs0: SUCCESS (7.056s)
[357.574064] Starting dynamic subtest: ccs0
[371.449418] Dynamic subtest ccs0: SUCCESS (13.883s)
[371.450467] Subtest hang-wait: SUCCESS (68.367s)
[371.608833] [112/134] (658s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[371.710341] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[371.711562] Starting dynamic subtest: pipe-A
[371.779979] Dynamic subtest pipe-A: SUCCESS (0.070s)
[371.788383] Starting dynamic subtest: pipe-B
[372.978947] Dynamic subtest pipe-B: SUCCESS (1.198s)
[372.989292] Starting dynamic subtest: pipe-C
[374.091743] Dynamic subtest pipe-C: SUCCESS (1.111s)
[374.100066] Starting dynamic subtest: pipe-D
[375.219050] Dynamic subtest pipe-D: SUCCESS (1.127s)
[375.220061] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.511s)
[376.379619] [113/134] (653s left) kms_vblank (query-forked-busy)
[376.490441] Starting subtest: query-forked-busy
[376.491350] Starting dynamic subtest: pipe-A-eDP-1
[378.362258] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.870s)
[378.372218] Starting dynamic subtest: pipe-D-eDP-1
[380.921846] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.558s)
[380.923074] Subtest query-forked-busy: SUCCESS (4.432s)
[381.734363] [114/134] (648s left) gem_reg_read (timestamp-monotonic)
[381.788979] Starting subtest: timestamp-monotonic
[386.587542] Subtest timestamp-monotonic: SUCCESS (4.796s)
[386.665978] [115/134] (643s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[386.762965] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[386.764760] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[386.889421] [116/134] (643s left) i915_pm_rpm (gem-execbuf)
[389.118645] Starting subtest: gem-execbuf
[389.119748] Starting dynamic subtest: smem0
[390.826996] Dynamic subtest smem0: SUCCESS (1.711s)
[390.827955] Subtest gem-execbuf: SUCCESS (1.712s)
[390.920977] [117/134] (639s left) gem_exec_whisper (basic-fds)
[390.986457] Starting subtest: basic-fds
[396.855292] Subtest basic-fds: SUCCESS (5.864s)
[397.043037] [118/134] (633s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[397.148158] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[397.176194] Starting dynamic subtest: pipe-A-plane-0
[397.598117] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[397.606373] Starting dynamic subtest: pipe-A-plane-3
[397.842864] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[397.850996] Starting dynamic subtest: pipe-A-plane-5
[397.852851] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[398.968056] Starting dynamic subtest: pipe-B-plane-0
[399.404551] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[399.413079] Starting dynamic subtest: pipe-B-plane-3
[399.660122] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[399.668529] Starting dynamic subtest: pipe-B-plane-5
[399.670292] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[399.990098] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.842s)
[400.866078] [119/134] (629s left) gem_exec_balancer (parallel-bb-first)
[401.138207] Starting subtest: parallel-bb-first
[402.073223] Subtest parallel-bb-first: SUCCESS (0.935s)
[402.935861] [120/134] (627s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[403.042194] Starting subtest: 4-tiled-8bpp-rotate-90
[403.064080] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[403.202098] [121/134] (627s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[403.316288] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[403.318048] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[403.429493] [122/134] (627s left) kms_psr (pr-sprite-mmap-gtt)
[403.518342] Starting subtest: pr-sprite-mmap-gtt
[403.520060] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[403.597125] [123/134] (627s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[403.686933] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[404.478826] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[404.690058] [124/134] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[404.776912] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[412.021862] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.245s)
[412.206034] [125/134] (618s left) kms_vblank (ts-continuation-modeset-rpm)
[412.307189] Starting subtest: ts-continuation-modeset-rpm
[412.308021] Starting dynamic subtest: pipe-A-eDP-1
[414.873734] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.566s)
[414.888407] Starting dynamic subtest: pipe-D-eDP-1
[417.118147] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s)
[417.119162] Subtest ts-continuation-modeset-rpm: SUCCESS (4.811s)
[417.923530] [126/134] (612s left) gem_mmap_gtt (basic-read)
[417.974927] Subtest basic-read: SKIP (0.000s)
[418.044242] [127/134] (612s left) gem_blits (basic)
[418.108085] Starting subtest: basic
[419.438549] Subtest basic: SUCCESS (1.328s)
[419.596978] [128/134] (611s left) kms_color (ctm-signed)
[419.692834] Starting subtest: ctm-signed
[419.693702] Starting dynamic subtest: pipe-A-eDP-1
[421.797369] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.102s)
[421.807966] Starting dynamic subtest: pipe-B-eDP-1
[424.575353] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.778s)
[424.585278] Starting dynamic subtest: pipe-C-eDP-1
[427.395733] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.818s)
[427.403812] Starting dynamic subtest: pipe-D-eDP-1
[430.044249] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.647s)
[430.045030] Subtest ctm-signed: SUCCESS (10.351s)
[430.873558] [129/134] (599s left) gem_eio (throttle)
[431.121078] Starting subtest: throttle
[431.478693] Subtest throttle: SUCCESS (0.357s)
[431.632939] [130/134] (599s left) syncobj_wait (invalid-signal-illegal-handle)
[431.693524] Starting subtest: invalid-signal-illegal-handle
[431.694631] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[431.818029] [131/134] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[431.916591] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[431.918472] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[432.021874] [132/134] (598s left) kms_pm_backlight (fade-with-suspend)
[432.123384] Starting subtest: fade-with-suspend
[448.521131] Starting dynamic subtest: eDP-1
[451.194479] Dynamic subtest eDP-1: SUCCESS (2.676s)
[451.195413] Subtest fade-with-suspend: SUCCESS (4.313s)
[462.045850] [133/134] (578s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[467.222615] Starting subtest: psr2-overlay-plane-move-continuous-sf
[467.224932] Starting dynamic subtest: pipe-A-eDP-1
[473.985101] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.683s)
[473.995237] Starting dynamic subtest: pipe-B-eDP-1
[480.650695] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.630s)
[480.651569] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.318s)
[481.463386] [134/134] (559s left) perf (gen12-oa-tlb-invalidate)
[481.592571] Starting subtest: gen12-oa-tlb-invalidate
[481.593428] Starting dynamic subtest: 0-rcs0
[491.647846] Dynamic subtest 0-rcs0: SUCCESS (10.035s)
[491.657286] Starting dynamic subtest: 1-vcs1
[501.701076] Dynamic subtest 1-vcs1: SUCCESS (10.050s)
[501.702350] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.088s)
[501.741915] 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.