[58.995221] Initializing watchdogs
[58.995362]   /dev/watchdog0
[59.012207] [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]
[59.016689] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.019433] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.022746] [001/134] (960s left) kms_flip (flip-vs-rmfb-interruptible)
[59.146905] Starting subtest: flip-vs-rmfb-interruptible
[59.149316] Starting dynamic subtest: A-eDP1
[67.881773] Dynamic subtest A-eDP1: SUCCESS (8.710s)
[67.891682] Starting dynamic subtest: B-eDP1
[76.525878] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[76.534167] Starting dynamic subtest: C-eDP1
[85.138347] Dynamic subtest C-eDP1: SUCCESS (8.608s)
[85.147026] Starting dynamic subtest: D-eDP1
[93.771856] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[93.776444] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.591s)
[95.193029] [002/134] (924s left) kms_addfb_basic (bo-too-small)
[95.281911] Starting subtest: bo-too-small
[95.284139] Subtest bo-too-small: SUCCESS (0.001s)
[95.423906] [003/134] (924s left) gem_mmap_gtt (basic-write-read-distinct)
[95.483915] Subtest basic-write-read-distinct: SKIP (0.000s)
[95.540627] [004/134] (924s left) syncobj_wait (multi-wait-for-submit-signaled)
[95.600621] Starting subtest: multi-wait-for-submit-signaled
[95.602465] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[95.725334] [005/134] (923s left) gem_ccs (ctrl-surf-copy-new-ctx)
[95.799879] Starting subtest: ctrl-surf-copy-new-ctx
[95.804458] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[95.929754] [006/134] (923s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[95.995167] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[95.997472] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[96.105110] [007/134] (923s left) kms_feature_discovery (display-3x)
[96.202065] Starting subtest: display-3x
[96.205722] Subtest display-3x: SKIP (0.000s)
[96.287890] [008/134] (923s left) api_intel_allocator (reloc-allocator)
[96.349666] Starting subtest: reloc-allocator
[96.351327] Starting dynamic subtest: basic
[96.352993] Dynamic subtest basic: SUCCESS (0.004s)
[96.362098] Starting dynamic subtest: parallel-one
[96.364079] Dynamic subtest parallel-one: SUCCESS (0.007s)
[96.370621] Starting dynamic subtest: print
[96.372257] Dynamic subtest print: SUCCESS (0.000s)
[96.379819] Starting dynamic subtest: reuse
[96.381665] Dynamic subtest reuse: SUCCESS (0.000s)
[96.388464] Starting dynamic subtest: fork-reopen-allocator
[96.390486] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[96.392492] Subtest reloc-allocator: SUCCESS (0.027s)
[96.518600] [009/134] (923s left) gem_exec_gttfill (basic)
[96.581087] Starting subtest: basic
[100.888121] Subtest basic: SUCCESS (4.304s)
[101.111823] [010/134] (918s left) gem_exec_schedule (preempt-queue-contexts-chain)
[101.239536] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[101.539288] [011/134] (918s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[101.596487] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[101.648929] [012/134] (918s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[101.759346] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[105.752071] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.995s)
[106.904143] [013/134] (913s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[107.041673] Starting subtest: cursorB-vs-flipA-legacy
[107.046243] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[107.197233] [014/134] (912s left) gem_render_copy (yf-tiled-ccs-to-linear)
[107.268779] Starting subtest: yf-tiled-ccs-to-linear
[107.273067] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[107.463582] [015/134] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[107.560202] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[107.564388] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[107.692307] [016/134] (912s left) gem_exec_schedule (fairslice)
[107.770475] Starting subtest: fairslice
[107.772786] Starting dynamic subtest: rcs0
[109.782717] Dynamic subtest rcs0: SUCCESS (2.019s)
[109.794925] Starting dynamic subtest: bcs0
[111.802023] Dynamic subtest bcs0: SUCCESS (2.017s)
[111.811119] Starting dynamic subtest: vcs0
[113.822240] Dynamic subtest vcs0: SUCCESS (2.018s)
[113.830392] Starting dynamic subtest: vcs1
[115.837847] Dynamic subtest vcs1: SUCCESS (2.016s)
[115.847199] Starting dynamic subtest: vecs0
[117.857698] Dynamic subtest vecs0: SUCCESS (2.017s)
[117.866481] Starting dynamic subtest: ccs0
[119.876723] Dynamic subtest ccs0: SUCCESS (2.019s)
[119.878705] Subtest fairslice: SUCCESS (12.112s)
[120.184535] [017/134] (899s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[120.298073] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[120.300388] Starting dynamic subtest: pipe-A-default-mode
[123.020060] Dynamic subtest pipe-A-default-mode: SUCCESS (2.720s)
[123.022518] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.722s)
[123.874041] [018/134] (896s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[123.975763] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[123.979701] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[124.078388] [019/134] (896s left) gem_userptr_blits (set-cache-level)
[124.142972] Starting subtest: set-cache-level
[124.147421] Subtest set-cache-level: SKIP (0.000s)
[124.302791] [020/134] (895s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[124.392267] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[124.404453] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[124.491879] [021/134] (895s left) gem_softpin (evict-active-interruptible)
[124.563612] Starting subtest: evict-active-interruptible
[124.570277] Subtest evict-active-interruptible: SUCCESS (0.007s)
[124.697808] [022/134] (895s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[124.800936] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[124.802715] Starting dynamic subtest: pipe-A-eDP-1
[124.820910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[124.828522] Starting dynamic subtest: pipe-B-eDP-1
[124.844245] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[124.851508] Starting dynamic subtest: pipe-C-eDP-1
[124.867405] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[124.874508] Starting dynamic subtest: pipe-D-eDP-1
[124.890591] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[124.892317] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[127.139852] [023/134] (893s left) kms_psr (fbc-psr2-dpms)
[127.232856] Starting subtest: fbc-psr2-dpms
[127.235127] Starting dynamic subtest: eDP-1
[127.239288] Dynamic subtest eDP-1: SKIP (0.000s)
[127.243359] Subtest fbc-psr2-dpms: SKIP (0.001s)
[127.315036] [024/134] (893s left) gem_tiled_pread_basic
[127.451254] [025/134] (893s left) gem_sync (basic-store-all)
[127.533589] Starting subtest: basic-store-all
[130.613219] Subtest basic-store-all: SUCCESS (3.089s)
[130.809844] [026/134] (889s left) kms_atomic_transition (plane-all-transition-fencing)
[130.902898] Starting subtest: plane-all-transition-fencing
[130.905114] Starting dynamic subtest: pipe-A-eDP-1
[133.398239] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[133.715365] Starting dynamic subtest: pipe-B-eDP-1
[136.979646] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.272s)
[137.278535] Subtest plane-all-transition-fencing: SUCCESS (6.376s)
[138.109783] [027/134] (882s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[138.205033] Starting subtest: crc-primary-basic-yf-tiled-ccs
[138.207272] Starting dynamic subtest: pipe-A-eDP-1
[138.230255] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[138.240298] Starting dynamic subtest: pipe-B-eDP-1
[138.262285] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[138.270388] Starting dynamic subtest: pipe-C-eDP-1
[138.292329] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[138.301239] Starting dynamic subtest: pipe-D-eDP-1
[138.323395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[138.327517] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[140.380593] [028/134] (880s left) gem_exec_reloc (basic-cpu-gtt)
[140.440882] Subtest basic-cpu-gtt: SKIP (0.000s)
[140.519107] [029/134] (880s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[140.578717] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[140.583277] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[140.773076] [030/134] (879s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[140.835186] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[140.933229] [031/134] (879s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[141.032288] Starting subtest: fbc-shrfb-scaledprimary
[144.105511] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.076s)
[145.273486] [032/134] (875s left) gem_eio (in-flight-contexts-1us)
[145.528187] Starting subtest: in-flight-contexts-1us
[156.898297] Subtest in-flight-contexts-1us: SUCCESS (11.370s)
[157.081593] [033/134] (863s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[157.182213] Starting subtest: coverage-vs-premult-vs-constant
[157.462828] Starting dynamic subtest: pipe-A-eDP-1
[158.053258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[158.061469] Starting dynamic subtest: pipe-D-eDP-1
[159.355696] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.300s)
[159.357992] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.173s)
[160.229432] [034/134] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[160.343105] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[160.347381] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[160.481821] [035/134] (860s left) kms_pwrite_crc
[162.142859] [036/134] (858s left) gem_lmem_swapping (heavy-multi)
[162.184026] Subtest heavy-multi: SKIP (0.000s)
[162.230107] [037/134] (858s left) gem_exec_schedule (preempt-other-chain)
[162.305190] Starting subtest: preempt-other-chain
[162.307074] Starting dynamic subtest: rcs0
[162.380022] Dynamic subtest rcs0: SUCCESS (0.081s)
[162.392137] Starting dynamic subtest: bcs0
[162.457508] Dynamic subtest bcs0: SUCCESS (0.076s)
[162.468102] Starting dynamic subtest: vcs0
[162.539671] Dynamic subtest vcs0: SUCCESS (0.081s)
[162.552757] Starting dynamic subtest: vcs1
[162.617953] Dynamic subtest vcs1: SUCCESS (0.077s)
[162.630767] Starting dynamic subtest: vecs0
[162.694035] Dynamic subtest vecs0: SUCCESS (0.075s)
[162.705945] Starting dynamic subtest: ccs0
[162.770391] Dynamic subtest ccs0: SUCCESS (0.076s)
[162.772801] Subtest preempt-other-chain: SUCCESS (0.472s)
[164.059460] [038/134] (856s left) kms_psr (psr-cursor-plane-move)
[164.153749] Starting subtest: psr-cursor-plane-move
[164.155976] Starting dynamic subtest: eDP-1
[165.844302] Dynamic subtest eDP-1: SUCCESS (1.690s)
[165.846617] Subtest psr-cursor-plane-move: SUCCESS (1.691s)
[166.720265] [039/134] (854s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[166.816605] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[166.818826] Starting dynamic subtest: pipe-A-eDP-1
[166.843392] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[166.853931] Starting dynamic subtest: pipe-B-eDP-1
[166.877139] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[166.884279] Starting dynamic subtest: pipe-C-eDP-1
[166.908173] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[166.915309] Starting dynamic subtest: pipe-D-eDP-1
[166.938451] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[166.942594] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[169.100775] [040/134] (851s left) dmabuf_sync_file (import-multiple-read-only)
[169.209732] Starting subtest: import-multiple-read-only
[169.211986] Subtest import-multiple-read-only: SUCCESS (0.003s)
[169.275357] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[169.278469] [041/134] (851s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[169.392665] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[170.539351] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.145s)
[170.720226] [042/134] (850s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[170.821580] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[170.823467] Starting dynamic subtest: pipe-A-eDP-1
[170.842181] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.851932] Starting dynamic subtest: pipe-B-eDP-1
[170.869452] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.876823] Starting dynamic subtest: pipe-C-eDP-1
[170.894109] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.901691] Starting dynamic subtest: pipe-D-eDP-1
[170.920470] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.923924] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[173.172476] [043/134] (848s left) gem_softpin (noreloc-interruptible)
[173.252608] Starting subtest: noreloc-interruptible
[178.676265] Subtest noreloc-interruptible: SUCCESS (5.424s)
[178.813619] [044/134] (842s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[178.916868] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[178.919110] Starting dynamic subtest: pipe-A
[178.938882] Dynamic subtest pipe-A: SKIP (0.017s)
[178.947272] Starting dynamic subtest: pipe-B
[178.969285] Dynamic subtest pipe-B: SKIP (0.031s)
[178.977099] Starting dynamic subtest: pipe-C
[179.002209] Dynamic subtest pipe-C: SKIP (0.031s)
[179.009959] Starting dynamic subtest: pipe-D
[179.032165] Dynamic subtest pipe-D: SKIP (0.031s)
[179.036359] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.113s)
[179.148189] [045/134] (842s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[179.215744] Starting subtest: multi-wait-all-for-submit-available-signaled
[179.218040] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[179.337431] [046/134] (841s left) gem_exec_balancer (bonded-sync)
[179.393275] Starting subtest: bonded-sync
[179.397698] Subtest bonded-sync: SKIP (0.000s)
[179.708963] [047/134] (841s left) gem_exec_fence (submit-chain)
[179.885704] Starting subtest: submit-chain
[179.901349] Subtest submit-chain: SUCCESS (0.016s)
[182.042260] [048/134] (839s left) vgem_basic (bad-handle)
[182.091541] Starting subtest: bad-handle
[182.093730] Subtest bad-handle: SUCCESS (0.000s)
[182.160986] [049/134] (839s left) kms_flip (basic-plain-flip)
[182.267417] Starting subtest: basic-plain-flip
[182.269756] Starting dynamic subtest: A-eDP1
[183.982623] Dynamic subtest A-eDP1: SUCCESS (1.714s)
[183.995643] Starting dynamic subtest: B-eDP1
[185.697730] Dynamic subtest B-eDP1: SUCCESS (1.712s)
[185.708871] Starting dynamic subtest: C-eDP1
[187.323160] Dynamic subtest C-eDP1: SUCCESS (1.622s)
[187.332828] Starting dynamic subtest: D-eDP1
[188.959056] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[188.961780] Subtest basic-plain-flip: SUCCESS (6.695s)
[190.152503] [050/134] (831s left) gem_set_tiling_vs_pwrite
[190.287578] [051/134] (831s left) api_intel_bb (purge-bb)
[190.346928] Starting subtest: purge-bb
[190.349161] Subtest purge-bb: SUCCESS (0.003s)
[190.499168] [052/134] (831s left) gem_ctx_persistence (engines-hang)
[190.568803] Starting subtest: engines-hang
[190.571036] Starting dynamic subtest: rcs0
[190.735035] Dynamic subtest rcs0: SUCCESS (0.165s)
[190.745784] Starting dynamic subtest: bcs0
[190.853530] Dynamic subtest bcs0: SUCCESS (0.117s)
[190.864829] Starting dynamic subtest: vcs0
[190.971567] Dynamic subtest vcs0: SUCCESS (0.116s)
[190.982855] Starting dynamic subtest: vcs1
[191.097588] Dynamic subtest vcs1: SUCCESS (0.124s)
[191.108053] Starting dynamic subtest: vecs0
[191.224783] Dynamic subtest vecs0: SUCCESS (0.125s)
[191.235555] Starting dynamic subtest: ccs0
[191.341835] Dynamic subtest ccs0: SUCCESS (0.115s)
[191.344338] Subtest engines-hang: SUCCESS (0.774s)
[191.433603] [053/134] (830s left) kms_psr2_su (page_flip-nv12)
[191.499545] Subtest page_flip-NV12: SKIP (0.000s)
[191.567627] [054/134] (830s left) gem_exec_reloc (basic-wc-cpu)
[191.635488] Subtest basic-wc-cpu: SKIP (0.000s)
[191.717592] [055/134] (829s left) syncobj_wait (wait-any-snapshot)
[191.773040] Starting subtest: wait-any-snapshot
[191.854951] Subtest wait-any-snapshot: SUCCESS (0.081s)
[191.942268] [056/134] (829s left) drm_read (empty-nonblock)
[192.098625] Starting subtest: empty-nonblock
[192.100602] Subtest empty-nonblock: SUCCESS (0.000s)
[192.237182] [057/134] (829s left) gen9_exec_parse (batch-invalid-length)
[192.298834] Subtest batch-invalid-length: SKIP (0.000s)
[192.365494] [058/134] (829s left) gen3_render_mixed_blits
[192.495140] [059/134] (829s left) gem_ctx_create (basic)
[192.558055] Starting subtest: basic
[192.559983] Subtest basic: SUCCESS (0.000s)
[192.750819] [060/134] (829s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[192.830175] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[192.832525] Starting dynamic subtest: pipe-A-default-mode
[193.117123] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[193.121577] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.286s)
[193.981145] [061/134] (827s left) gem_mmap_gtt (ptrace)
[194.045863] Subtest ptrace: SKIP (0.000s)
[194.114384] [062/134] (827s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[194.212560] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[194.216960] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[194.351133] [063/134] (827s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[194.456065] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[194.460177] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[194.610566] [064/134] (827s left) syncobj_wait (multi-wait-all-signaled)
[194.673032] Starting subtest: multi-wait-all-signaled
[194.675319] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[194.787642] [065/134] (827s left) kms_prop_blob (invalid-set-prop-any)
[194.850787] Starting subtest: invalid-set-prop-any
[194.852606] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[194.964835] [066/134] (827s left) gem_lmem_swapping (verify-random)
[195.011660] Subtest verify-random: SKIP (0.000s)
[195.064057] [067/134] (827s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[195.116194] Starting subtest: single-wait-all-for-submit-available-signaled
[195.118027] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[195.238092] [068/134] (827s left) syncobj_timeline (reset-multiple-signaled)
[195.301033] Starting subtest: reset-multiple-signaled
[195.303104] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[195.426386] [069/134] (826s left) kms_chamelium_hpd (hdmi-hpd)
[195.810182] Subtest hdmi-hpd: SKIP (0.000s)
[196.595118] [070/134] (825s left) perf_pmu (rc6-all-gts)
[196.632539] Starting subtest: rc6-all-gts
[203.012718] Subtest rc6-all-gts: SUCCESS (6.383s)
[203.895936] [071/134] (818s left) kms_lease (simple-lease)
[203.991803] Starting subtest: simple-lease
[203.994075] Starting dynamic subtest: pipe-A-eDP-1
[204.489677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s)
[204.498219] Starting dynamic subtest: pipe-B-eDP-1
[205.965953] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.476s)
[205.974414] Starting dynamic subtest: pipe-C-eDP-1
[207.484691] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.514s)
[207.493437] Starting dynamic subtest: pipe-D-eDP-1
[208.894676] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[208.896821] Subtest simple-lease: SUCCESS (4.903s)
[209.708626] [072/134] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[209.815181] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[216.394361] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.583s)
[216.566871] [073/134] (805s left) kms_cursor_crc (cursor-onscreen-128x128)
[216.777098] Starting subtest: cursor-onscreen-128x128
[216.781981] Starting dynamic subtest: pipe-A-eDP-1
[218.912630] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.131s)
[218.945597] Starting dynamic subtest: pipe-D-eDP-1
[221.711467] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[221.713440] Subtest cursor-onscreen-128x128: SUCCESS (4.932s)
[222.588994] [074/134] (799s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[222.697703] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[229.740839] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.046s)
[229.892696] [075/134] (792s left) kms_pm_rpm (modeset-non-lpsp)
[232.021936] Starting subtest: modeset-non-lpsp
[233.181506] Subtest modeset-non-lpsp: SKIP (1.160s)
[233.566438] [076/134] (789s left) gem_exec_suspend (basic-s3-devices)
[233.640468] Starting subtest: basic-S3-devices
[233.642802] Starting dynamic subtest: smem
[244.886425] Dynamic subtest smem: SUCCESS (11.243s)
[244.889612] Subtest basic-S3-devices: SUCCESS (11.246s)
[249.098393] [077/134] (777s left) i915_drm_fdinfo (idle)
[249.155715] Starting subtest: idle
[249.157926] Starting dynamic subtest: rcs0
[249.719695] Dynamic subtest rcs0: SUCCESS (0.563s)
[249.731177] Starting dynamic subtest: bcs0
[250.226943] Dynamic subtest bcs0: SUCCESS (0.503s)
[250.237184] Starting dynamic subtest: vcs0
[250.736595] Dynamic subtest vcs0: SUCCESS (0.503s)
[250.747380] Starting dynamic subtest: vcs1
[251.238489] Dynamic subtest vcs1: SUCCESS (0.503s)
[251.250988] Starting dynamic subtest: vecs0
[251.744404] Dynamic subtest vecs0: SUCCESS (0.503s)
[251.755065] Starting dynamic subtest: ccs0
[252.249966] Dynamic subtest ccs0: SUCCESS (0.503s)
[252.253047] Subtest idle: SUCCESS (3.094s)
[252.338595] [078/134] (774s left) kms_joiner (invalid-modeset-ultra-joiner)
[252.451497] Starting subtest: invalid-modeset-ultra-joiner
[252.455847] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[252.532824] [079/134] (774s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[252.627968] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[252.632190] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[252.739569] [080/134] (774s left) syncobj_basic (bad-create-flags)
[252.791025] Starting subtest: bad-create-flags
[252.793145] Subtest bad-create-flags: SUCCESS (0.000s)
[252.923946] [081/134] (773s left) syncobj_basic (bad-flags-fd-to-handle)
[252.990448] Starting subtest: bad-flags-fd-to-handle
[252.992413] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[253.135193] [082/134] (773s left) gem_pxp (display-protected-crc)
[253.261351] Starting subtest: display-protected-crc
[254.918975] Subtest display-protected-crc: SUCCESS (1.658s)
[255.070650] [083/134] (771s left) gem_softpin (safe-alignment)
[255.138275] Starting subtest: safe-alignment
[255.159430] Subtest safe-alignment: SUCCESS (0.021s)
[256.983314] [084/134] (769s left) i915_drm_fdinfo (virtual-busy-idle-all)
[257.032255] Starting subtest: virtual-busy-idle-all
[257.037014] Subtest virtual-busy-idle-all: SKIP (0.000s)
[257.121586] [085/134] (769s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[257.222722] Starting subtest: fb-8bpc-vs-panel-8bpc
[257.225040] Starting dynamic subtest: pipe-A-eDP-1
[258.566543] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.341s)
[258.568450] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.343s)
[259.380854] [086/134] (767s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[259.489107] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[259.493227] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[259.623480] [087/134] (767s left) i915_query (hwconfig_table)
[259.691524] Starting subtest: hwconfig_table
[259.991243] Subtest hwconfig_table: SUCCESS (0.001s)
[260.040493] [088/134] (767s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[260.140248] Starting subtest: basic-modeset-with-all-modifiers-formats
[260.525126] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[261.261107] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.737s)
[261.270793] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[261.283059] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[261.292187] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[261.305337] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[261.314456] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[261.449783] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[261.460092] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[261.471888] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[261.481085] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[261.494245] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[261.503422] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[261.516128] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[261.525189] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[261.538657] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[261.547348] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[261.560883] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[261.569554] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[261.583244] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[261.593802] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[261.605284] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[261.614188] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[261.627530] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[261.637079] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[261.771839] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[261.781720] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[261.794523] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[261.805163] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[261.816102] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[261.825524] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[261.838633] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[261.847816] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[261.860931] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[261.869853] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[261.883062] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[261.892097] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[261.905302] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[261.914267] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[261.927554] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[261.936535] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[261.949830] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[261.958903] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[262.128147] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.177s)
[262.138530] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[262.150396] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[262.161507] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[262.172377] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[262.183581] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[262.194334] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[262.203094] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[262.216690] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[262.225468] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[262.238769] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[262.247494] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[262.260936] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[262.269676] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[262.283154] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[262.294655] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[262.305523] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[262.687478] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.548s)
[263.559411] [089/134] (763s left) kms_getfb (getfb2-handle-not-fb)
[263.661147] Starting subtest: getfb2-handle-not-fb
[263.663456] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[263.799107] [090/134] (763s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[264.007918] Starting subtest: cursor-rapid-movement-64x21
[264.054678] Subtest cursor-rapid-movement-64x21: SKIP (0.043s)
[264.301889] [091/134] (762s left) kms_cursor_crc (cursor-sliding-512x512)
[264.582207] Starting subtest: cursor-sliding-512x512
[264.585709] Subtest cursor-sliding-512x512: SKIP (0.001s)
[264.771154] [092/134] (762s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[264.874632] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[264.878302] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[265.025682] [093/134] (762s left) kms_big_fb (linear-16bpp-rotate-0)
[265.127309] Starting subtest: linear-16bpp-rotate-0
[266.573972] Subtest linear-16bpp-rotate-0: SUCCESS (1.447s)
[266.719635] [094/134] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[266.825352] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[266.828928] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[266.935884] [095/134] (760s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[267.043981] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[267.047567] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[267.169808] [096/134] (760s left) kms_psr (fbc-psr-no-drrs)
[267.268037] Starting subtest: fbc-psr-no-drrs
[267.269935] Starting dynamic subtest: eDP-1
[267.273382] Dynamic subtest eDP-1: SKIP (0.000s)
[267.276779] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[267.355520] [097/134] (760s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[267.456260] Starting subtest: primary-4-tiled-reflect-x-180
[274.488097] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.033s)
[275.718172] [098/134] (751s left) kms_content_protection (lic-type-1)
[275.868589] Starting subtest: lic-type-1
[275.873078] Subtest lic-type-1: SKIP (0.000s)
[276.037766] [099/134] (751s left) gem_ctx_shared (create-shared-gtt)
[276.110687] Starting subtest: create-shared-gtt
[278.264268] Subtest create-shared-gtt: SUCCESS (2.152s)
[278.650291] [100/134] (749s left) kms_flip (modeset-vs-vblank-race)
[278.748362] Starting subtest: modeset-vs-vblank-race
[278.750723] Starting dynamic subtest: A-eDP1
[283.428748] Dynamic subtest A-eDP1: SUCCESS (4.679s)
[283.440175] Starting dynamic subtest: B-eDP1
[288.166592] Dynamic subtest B-eDP1: SUCCESS (4.736s)
[288.178568] Starting dynamic subtest: C-eDP1
[292.871021] Dynamic subtest C-eDP1: SUCCESS (4.702s)
[292.882570] Starting dynamic subtest: D-eDP1
[297.480275] Dynamic subtest D-eDP1: SUCCESS (4.608s)
[297.485691] Subtest modeset-vs-vblank-race: SUCCESS (18.738s)
[298.674406] [101/134] (729s left) kms_plane_multiple (2x-tiling-none)
[298.783703] Starting subtest: 2x-tiling-none
[298.788064] Subtest 2x-tiling-none: SKIP (0.000s)
[298.865313] [102/134] (728s left) kms_async_flips (test-cursor)
[298.970973] Starting subtest: test-cursor
[298.975329] Subtest test-cursor: SKIP (0.000s)
[300.202768] [103/134] (727s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[300.310342] Starting subtest: y-tiled-16bpp-rotate-180
[300.314414] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[300.441521] [104/134] (727s left) gem_ctx_persistence (heartbeat-hang)
[300.506266] Starting subtest: heartbeat-hang
[300.510575] Subtest heartbeat-hang: SKIP (0.000s)
[300.631406] [105/134] (727s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[300.733981] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[300.736264] Starting dynamic subtest: pipe-A-eDP-1
[300.894105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.152s)
[300.905111] Starting dynamic subtest: pipe-B-eDP-1
[300.921679] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[300.932426] Starting dynamic subtest: pipe-C-eDP-1
[300.949434] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[300.958204] Starting dynamic subtest: pipe-D-eDP-1
[300.974147] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[300.975968] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.188s)
[303.163733] [106/134] (724s left) kms_flip (2x-absolute-wf_vblank)
[303.278813] Starting subtest: 2x-absolute-wf_vblank
[303.290149] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[303.420878] [107/134] (724s left) kms_chamelium_frames (hdmi-crc-fast)
[303.802192] Subtest hdmi-crc-fast: SKIP (0.000s)
[304.654911] [108/134] (723s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[304.719682] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[304.825471] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[304.914263] [109/134] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[305.018500] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[305.022847] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[305.145698] [110/134] (722s left) gem_exec_params (invalid-ring2)
[305.212971] Starting subtest: invalid-ring2
[305.215184] Subtest invalid-ring2: SUCCESS (0.000s)
[305.359526] [111/134] (722s left) prime_busy (hang-wait)
[305.426928] Starting subtest: hang-wait
[305.429674] Starting dynamic subtest: rcs0
[331.445318] Dynamic subtest rcs0: SUCCESS (26.014s)
[331.455136] Starting dynamic subtest: bcs0
[338.597609] Dynamic subtest bcs0: SUCCESS (7.149s)
[338.608373] Starting dynamic subtest: vcs0
[345.510976] Dynamic subtest vcs0: SUCCESS (6.913s)
[345.522030] Starting dynamic subtest: vcs1
[352.487380] Dynamic subtest vcs1: SUCCESS (6.973s)
[352.498762] Starting dynamic subtest: vecs0
[359.583056] Dynamic subtest vecs0: SUCCESS (7.096s)
[359.595341] Starting dynamic subtest: ccs0
[373.435864] Dynamic subtest ccs0: SUCCESS (13.844s)
[373.438618] Subtest hang-wait: SUCCESS (68.003s)
[373.599793] [112/134] (654s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[373.722020] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[373.724377] Starting dynamic subtest: pipe-A
[373.783700] Dynamic subtest pipe-A: SUCCESS (0.064s)
[373.796373] Starting dynamic subtest: pipe-B
[374.896070] Dynamic subtest pipe-B: SUCCESS (1.111s)
[374.907890] Starting dynamic subtest: pipe-C
[376.011175] Dynamic subtest pipe-C: SUCCESS (1.114s)
[376.021146] Starting dynamic subtest: pipe-D
[377.128255] Dynamic subtest pipe-D: SUCCESS (1.116s)
[377.130573] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.410s)
[378.306508] [113/134] (649s left) kms_vblank (query-forked-busy)
[378.410096] Starting subtest: query-forked-busy
[378.411960] Starting dynamic subtest: pipe-A-eDP-1
[380.289806] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[380.303793] Starting dynamic subtest: pipe-D-eDP-1
[382.849825] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[382.852249] Subtest query-forked-busy: SUCCESS (4.442s)
[383.664441] [114/134] (644s left) gem_reg_read (timestamp-monotonic)
[383.736858] Starting subtest: timestamp-monotonic
[388.541407] Subtest timestamp-monotonic: SUCCESS (4.804s)
[388.628872] [115/134] (639s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[388.743457] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[388.747848] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[388.855043] [116/134] (639s left) i915_pm_rpm (gem-execbuf)
[391.085317] Starting subtest: gem-execbuf
[391.087413] Starting dynamic subtest: smem0
[392.600196] Dynamic subtest smem0: SUCCESS (1.516s)
[392.602480] Subtest gem-execbuf: SUCCESS (1.517s)
[392.703913] [117/134] (635s left) gem_exec_whisper (basic-fds)
[392.787850] Starting subtest: basic-fds
[398.901896] Subtest basic-fds: SUCCESS (6.109s)
[399.095648] [118/134] (629s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[399.209257] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[399.235847] Starting dynamic subtest: pipe-A-plane-0
[399.668315] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[399.678280] Starting dynamic subtest: pipe-A-plane-3
[399.923665] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[399.934028] Starting dynamic subtest: pipe-A-plane-5
[399.938132] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[401.052238] Starting dynamic subtest: pipe-B-plane-0
[401.470794] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[401.480692] Starting dynamic subtest: pipe-B-plane-3
[401.726487] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[401.736989] Starting dynamic subtest: pipe-B-plane-5
[401.741316] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[402.043590] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.834s)
[402.930931] [119/134] (625s left) gem_exec_balancer (parallel-bb-first)
[403.200050] Starting subtest: parallel-bb-first
[404.138294] Subtest parallel-bb-first: SUCCESS (0.942s)
[404.935110] [120/134] (623s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[405.056445] Starting subtest: 4-tiled-8bpp-rotate-90
[405.078295] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s)
[405.207991] [121/134] (623s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[405.324629] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[405.329077] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[405.448296] [122/134] (623s left) kms_psr (pr-sprite-mmap-gtt)
[405.542445] Starting subtest: pr-sprite-mmap-gtt
[405.546588] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[405.630624] [123/134] (622s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[405.733337] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[406.513589] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.781s)
[406.674272] [124/134] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[406.774447] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[414.149276] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.377s)
[414.345857] [125/134] (614s left) kms_vblank (ts-continuation-modeset-rpm)
[414.448199] Starting subtest: ts-continuation-modeset-rpm
[414.450426] Starting dynamic subtest: pipe-A-eDP-1
[416.951629] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[416.965673] Starting dynamic subtest: pipe-D-eDP-1
[419.199129] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s)
[419.201543] Subtest ts-continuation-modeset-rpm: SUCCESS (4.750s)
[420.023952] [126/134] (608s left) gem_mmap_gtt (basic-read)
[420.086839] Subtest basic-read: SKIP (0.000s)
[420.152736] [127/134] (608s left) gem_blits (basic)
[420.217709] Starting subtest: basic
[421.556827] Subtest basic: SUCCESS (1.340s)
[421.704508] [128/134] (607s left) kms_color (ctm-signed)
[421.803105] Starting subtest: ctm-signed
[421.805049] Starting dynamic subtest: pipe-A-eDP-1
[423.895068] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.092s)
[423.905735] Starting dynamic subtest: pipe-B-eDP-1
[426.739419] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.843s)
[426.749880] Starting dynamic subtest: pipe-C-eDP-1
[429.376415] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.636s)
[429.386504] Starting dynamic subtest: pipe-D-eDP-1
[432.060074] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.684s)
[432.062324] Subtest ctm-signed: SUCCESS (10.258s)
[432.891102] [129/134] (595s left) gem_eio (throttle)
[433.132883] Starting subtest: throttle
[433.483287] Subtest throttle: SUCCESS (0.350s)
[433.617970] [130/134] (595s left) syncobj_wait (invalid-signal-illegal-handle)
[433.676689] Starting subtest: invalid-signal-illegal-handle
[433.679043] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[433.799994] [131/134] (595s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[433.897775] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[433.901199] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[434.040133] [132/134] (594s left) kms_pm_backlight (fade-with-suspend)
[434.137287] Starting subtest: fade-with-suspend
[450.484140] Starting dynamic subtest: eDP-1
[453.152660] Dynamic subtest eDP-1: SUCCESS (2.668s)
[453.154932] Subtest fade-with-suspend: SUCCESS (4.290s)
[458.022509] [133/134] (575s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[463.187398] Starting subtest: psr2-overlay-plane-move-continuous-sf
[463.189662] Starting dynamic subtest: pipe-A-eDP-1
[469.933655] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.688s)
[469.944978] Starting dynamic subtest: pipe-B-eDP-1
[476.599298] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.637s)
[476.601586] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.331s)
[477.405004] [134/134] (555s left) perf (gen12-oa-tlb-invalidate)
[477.564664] Starting subtest: gen12-oa-tlb-invalidate
[477.566821] Starting dynamic subtest: 0-rcs0
[487.628468] Dynamic subtest 0-rcs0: SUCCESS (10.048s)
[487.638880] Starting dynamic subtest: 1-vcs0
[497.678882] Dynamic subtest 1-vcs0: SUCCESS (10.047s)
[497.681492] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.098s)
[497.717580] 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.