[58.021554] Initializing watchdogs
[58.021641]   /dev/watchdog0
[58.036200] [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]
[58.040547] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.042751] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.046109] [001/134] (960s left) kms_flip (flip-vs-rmfb-interruptible)
[58.161601] Starting subtest: flip-vs-rmfb-interruptible
[58.163841] Starting dynamic subtest: A-eDP1
[66.796971] Dynamic subtest A-eDP1: SUCCESS (8.641s)
[66.803968] Starting dynamic subtest: B-eDP1
[75.417716] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[75.427120] Starting dynamic subtest: C-eDP1
[84.078340] Dynamic subtest C-eDP1: SUCCESS (8.662s)
[84.087050] Starting dynamic subtest: D-eDP1
[92.710211] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[92.714880] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.568s)
[93.965963] [002/134] (924s left) kms_addfb_basic (bo-too-small)
[94.063069] Starting subtest: bo-too-small
[94.065315] Subtest bo-too-small: SUCCESS (0.000s)
[94.183568] [003/134] (924s left) gem_mmap_gtt (basic-write-read-distinct)
[94.244317] Subtest basic-write-read-distinct: SKIP (0.000s)
[94.310675] [004/134] (924s left) syncobj_wait (multi-wait-for-submit-signaled)
[94.374996] Starting subtest: multi-wait-for-submit-signaled
[94.377475] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[94.486650] [005/134] (924s left) gem_ccs (ctrl-surf-copy-new-ctx)
[94.556346] Starting subtest: ctrl-surf-copy-new-ctx
[94.560749] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[94.687469] [006/134] (924s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[94.748633] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[94.750634] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[94.889998] [007/134] (923s left) kms_feature_discovery (display-3x)
[94.986107] Starting subtest: display-3x
[94.989771] Subtest display-3x: SKIP (0.000s)
[95.070292] [008/134] (923s left) api_intel_allocator (reloc-allocator)
[95.124604] Starting subtest: reloc-allocator
[95.126456] Starting dynamic subtest: basic
[95.128366] Dynamic subtest basic: SUCCESS (0.003s)
[95.134809] Starting dynamic subtest: parallel-one
[95.136743] Dynamic subtest parallel-one: SUCCESS (0.009s)
[95.143403] Starting dynamic subtest: print
[95.145165] Dynamic subtest print: SUCCESS (0.000s)
[95.151526] Starting dynamic subtest: reuse
[95.153437] Dynamic subtest reuse: SUCCESS (0.000s)
[95.159914] Starting dynamic subtest: fork-reopen-allocator
[95.161514] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[95.163278] Subtest reloc-allocator: SUCCESS (0.030s)
[95.299596] [009/134] (923s left) gem_exec_gttfill (basic)
[95.364247] Starting subtest: basic
[97.857748] Subtest basic: SUCCESS (2.492s)
[98.057121] [010/134] (920s left) gem_exec_schedule (preempt-queue-contexts-chain)
[98.181910] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[98.485548] [011/134] (920s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[98.543043] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[98.611126] [012/134] (920s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[98.722791] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[102.837683] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.119s)
[103.982648] [013/134] (915s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[104.104580] Starting subtest: cursorB-vs-flipA-legacy
[104.108903] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[104.257250] [014/134] (914s left) gem_render_copy (yf-tiled-ccs-to-linear)
[104.320025] Starting subtest: yf-tiled-ccs-to-linear
[104.324842] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[104.515416] [015/134] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[104.608847] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[104.613073] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[104.722039] [016/134] (914s left) gem_exec_schedule (fairslice)
[104.801093] Starting subtest: fairslice
[104.803273] Starting dynamic subtest: rcs0
[106.817141] Dynamic subtest rcs0: SUCCESS (2.022s)
[106.826130] Starting dynamic subtest: bcs0
[108.835558] Dynamic subtest bcs0: SUCCESS (2.016s)
[108.845127] Starting dynamic subtest: vcs0
[110.852877] Dynamic subtest vcs0: SUCCESS (2.018s)
[110.863484] Starting dynamic subtest: vcs1
[112.873786] Dynamic subtest vcs1: SUCCESS (2.018s)
[112.882577] Starting dynamic subtest: vecs0
[114.890438] Dynamic subtest vecs0: SUCCESS (2.018s)
[114.899570] Starting dynamic subtest: ccs0
[116.909081] Dynamic subtest ccs0: SUCCESS (2.019s)
[116.911036] Subtest fairslice: SUCCESS (12.117s)
[117.216982] [017/134] (901s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[117.318157] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[117.320472] Starting dynamic subtest: pipe-A-default-mode
[120.085999] Dynamic subtest pipe-A-default-mode: SUCCESS (2.767s)
[120.088363] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.769s)
[120.959620] [018/134] (898s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[121.060633] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[121.065016] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[121.192973] [019/134] (898s left) gem_userptr_blits (set-cache-level)
[121.266868] Starting subtest: set-cache-level
[121.271268] Subtest set-cache-level: SKIP (0.000s)
[121.430401] [020/134] (897s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[121.537016] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[121.548959] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[121.672962] [021/134] (897s left) gem_softpin (evict-active-interruptible)
[121.746044] Starting subtest: evict-active-interruptible
[121.749379] Subtest evict-active-interruptible: SUCCESS (0.006s)
[121.897886] [022/134] (897s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[121.990081] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[121.991864] Starting dynamic subtest: pipe-A-eDP-1
[122.012556] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[122.020150] Starting dynamic subtest: pipe-B-eDP-1
[122.036583] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[122.043770] Starting dynamic subtest: pipe-C-eDP-1
[122.060348] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[122.067630] Starting dynamic subtest: pipe-D-eDP-1
[122.086427] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[122.088309] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.090s)
[124.337393] [023/134] (895s left) kms_psr (fbc-psr2-dpms)
[124.447612] Starting subtest: fbc-psr2-dpms
[124.449949] Starting dynamic subtest: eDP-1
[124.454281] Dynamic subtest eDP-1: SKIP (0.000s)
[124.458659] Subtest fbc-psr2-dpms: SKIP (0.001s)
[124.543312] [024/134] (894s left) gem_tiled_pread_basic
[124.671112] [025/134] (894s left) gem_sync (basic-store-all)
[124.751268] Starting subtest: basic-store-all
[127.945381] Subtest basic-store-all: SUCCESS (3.205s)
[128.145087] [026/134] (891s left) kms_atomic_transition (plane-all-transition-fencing)
[128.244354] Starting subtest: plane-all-transition-fencing
[128.246663] Starting dynamic subtest: pipe-A-eDP-1
[130.738332] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[131.048616] Starting dynamic subtest: pipe-B-eDP-1
[134.249203] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.214s)
[134.546756] Subtest plane-all-transition-fencing: SUCCESS (6.302s)
[135.384251] [027/134] (884s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[135.485177] Starting subtest: crc-primary-basic-yf-tiled-ccs
[135.487434] Starting dynamic subtest: pipe-A-eDP-1
[135.509424] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[135.519094] Starting dynamic subtest: pipe-B-eDP-1
[135.540189] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[135.547941] Starting dynamic subtest: pipe-C-eDP-1
[135.568366] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[135.576154] Starting dynamic subtest: pipe-D-eDP-1
[135.597856] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[135.601906] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[137.751480] [028/134] (881s left) gem_exec_reloc (basic-cpu-gtt)
[137.816513] Subtest basic-cpu-gtt: SKIP (0.000s)
[137.890397] [029/134] (881s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[137.953235] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[137.957754] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[138.145366] [030/134] (881s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[138.215799] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[138.305109] [031/134] (881s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[138.408123] Starting subtest: fbc-shrfb-scaledprimary
[141.477599] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.074s)
[142.661414] [032/134] (877s left) gem_eio (in-flight-contexts-1us)
[142.911828] Starting subtest: in-flight-contexts-1us
[156.899092] Subtest in-flight-contexts-1us: SUCCESS (13.989s)
[157.094563] [033/134] (862s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[157.187111] Starting subtest: coverage-vs-premult-vs-constant
[157.466935] Starting dynamic subtest: pipe-A-eDP-1
[158.046625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[158.055135] Starting dynamic subtest: pipe-D-eDP-1
[159.356665] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[159.358953] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.171s)
[160.212688] [034/134] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[160.309059] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[160.313305] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[160.439058] [035/134] (859s left) kms_pwrite_crc
[162.146652] [036/134] (857s left) gem_lmem_swapping (heavy-multi)
[162.195399] Subtest heavy-multi: SKIP (0.000s)
[162.241959] [037/134] (857s left) gem_exec_schedule (preempt-other-chain)
[162.319236] Starting subtest: preempt-other-chain
[162.321406] Starting dynamic subtest: rcs0
[162.396218] Dynamic subtest rcs0: SUCCESS (0.081s)
[162.407654] Starting dynamic subtest: bcs0
[162.479585] Dynamic subtest bcs0: SUCCESS (0.083s)
[162.492528] Starting dynamic subtest: vcs0
[162.559010] Dynamic subtest vcs0: SUCCESS (0.079s)
[162.567812] Starting dynamic subtest: vcs1
[162.637067] Dynamic subtest vcs1: SUCCESS (0.077s)
[162.646054] Starting dynamic subtest: vecs0
[162.713640] Dynamic subtest vecs0: SUCCESS (0.076s)
[162.722706] Starting dynamic subtest: ccs0
[162.793184] Dynamic subtest ccs0: SUCCESS (0.078s)
[162.795355] Subtest preempt-other-chain: SUCCESS (0.480s)
[164.047638] [038/134] (855s left) kms_psr (psr-cursor-plane-move)
[164.154688] Starting subtest: psr-cursor-plane-move
[164.156903] Starting dynamic subtest: eDP-1
[165.830118] Dynamic subtest eDP-1: SUCCESS (1.675s)
[165.832413] Subtest psr-cursor-plane-move: SUCCESS (1.676s)
[166.712408] [039/134] (853s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[166.814325] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[166.816634] Starting dynamic subtest: pipe-A-eDP-1
[166.841104] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[166.850521] Starting dynamic subtest: pipe-B-eDP-1
[166.874060] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[166.881738] Starting dynamic subtest: pipe-C-eDP-1
[166.905175] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[166.912982] Starting dynamic subtest: pipe-D-eDP-1
[166.936865] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[166.940965] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[169.078790] [040/134] (850s left) dmabuf_sync_file (import-multiple-read-only)
[169.196103] Starting subtest: import-multiple-read-only
[169.198016] Subtest import-multiple-read-only: SUCCESS (0.003s)
[169.276441] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[169.280091] [041/134] (850s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[169.386319] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[170.510312] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.123s)
[170.654009] [042/134] (849s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[170.745869] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[170.747870] Starting dynamic subtest: pipe-A-eDP-1
[170.766641] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[170.776955] Starting dynamic subtest: pipe-B-eDP-1
[170.794507] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.802309] Starting dynamic subtest: pipe-C-eDP-1
[170.819673] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.827403] Starting dynamic subtest: pipe-D-eDP-1
[170.847021] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.850583] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.008s)
[173.056231] [043/134] (847s left) gem_softpin (noreloc-interruptible)
[173.124305] Starting subtest: noreloc-interruptible
[178.519276] Subtest noreloc-interruptible: SUCCESS (5.393s)
[178.684420] [044/134] (841s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[178.794174] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[178.796437] Starting dynamic subtest: pipe-A
[178.816242] Dynamic subtest pipe-A: SKIP (0.017s)
[178.833090] Starting dynamic subtest: pipe-B
[178.848618] Dynamic subtest pipe-B: SKIP (0.031s)
[178.865189] Starting dynamic subtest: pipe-C
[178.879917] Dynamic subtest pipe-C: SKIP (0.031s)
[178.896115] Starting dynamic subtest: pipe-D
[178.915396] Dynamic subtest pipe-D: SKIP (0.031s)
[178.919761] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.115s)
[179.048465] [045/134] (841s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[179.124035] Starting subtest: multi-wait-all-for-submit-available-signaled
[179.126225] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[179.243574] [046/134] (841s left) gem_exec_balancer (bonded-sync)
[179.329135] Starting subtest: bonded-sync
[179.333645] Subtest bonded-sync: SKIP (0.001s)
[179.725296] [047/134] (840s left) gem_exec_fence (submit-chain)
[179.899379] Starting subtest: submit-chain
[179.916306] Subtest submit-chain: SUCCESS (0.017s)
[181.988938] [048/134] (838s left) vgem_basic (bad-handle)
[182.028811] Starting subtest: bad-handle
[182.031261] Subtest bad-handle: SUCCESS (0.000s)
[182.097469] [049/134] (838s left) kms_flip (basic-plain-flip)
[182.214290] Starting subtest: basic-plain-flip
[182.216640] Starting dynamic subtest: A-eDP1
[183.933758] Dynamic subtest A-eDP1: SUCCESS (1.719s)
[183.943778] Starting dynamic subtest: B-eDP1
[185.579186] Dynamic subtest B-eDP1: SUCCESS (1.644s)
[185.593012] Starting dynamic subtest: C-eDP1
[187.292071] Dynamic subtest C-eDP1: SUCCESS (1.710s)
[187.301799] Starting dynamic subtest: D-eDP1
[188.929839] Dynamic subtest D-eDP1: SUCCESS (1.637s)
[188.934824] Subtest basic-plain-flip: SUCCESS (6.720s)
[190.210949] [050/134] (830s left) gem_set_tiling_vs_pwrite
[190.334748] [051/134] (830s left) api_intel_bb (purge-bb)
[190.403693] Starting subtest: purge-bb
[190.408927] Subtest purge-bb: SUCCESS (0.006s)
[190.548249] [052/134] (830s left) gem_ctx_persistence (engines-hang)
[190.614282] Starting subtest: engines-hang
[190.616582] Starting dynamic subtest: rcs0
[190.718841] Dynamic subtest rcs0: SUCCESS (0.104s)
[190.730045] Starting dynamic subtest: bcs0
[190.834860] Dynamic subtest bcs0: SUCCESS (0.114s)
[190.848793] Starting dynamic subtest: vcs0
[190.931186] Dynamic subtest vcs0: SUCCESS (0.095s)
[190.941473] Starting dynamic subtest: vcs1
[191.043815] Dynamic subtest vcs1: SUCCESS (0.110s)
[191.055218] Starting dynamic subtest: vecs0
[191.159542] Dynamic subtest vecs0: SUCCESS (0.114s)
[191.169329] Starting dynamic subtest: ccs0
[191.267305] Dynamic subtest ccs0: SUCCESS (0.106s)
[191.269476] Subtest engines-hang: SUCCESS (0.654s)
[191.357574] [053/134] (829s left) kms_psr2_su (page_flip-nv12)
[191.423820] Subtest page_flip-NV12: SKIP (0.000s)
[191.490016] [054/134] (829s left) gem_exec_reloc (basic-wc-cpu)
[191.551964] Subtest basic-wc-cpu: SKIP (0.000s)
[191.642521] [055/134] (829s left) syncobj_wait (wait-any-snapshot)
[191.715928] Starting subtest: wait-any-snapshot
[191.797850] Subtest wait-any-snapshot: SUCCESS (0.081s)
[191.895435] [056/134] (828s left) drm_read (empty-nonblock)
[192.043756] Starting subtest: empty-nonblock
[192.045646] Subtest empty-nonblock: SUCCESS (0.000s)
[192.203812] [057/134] (828s left) gen9_exec_parse (batch-invalid-length)
[192.262931] Subtest batch-invalid-length: SKIP (0.000s)
[192.349758] [058/134] (828s left) gen3_render_mixed_blits
[192.480266] [059/134] (828s left) gem_ctx_create (basic)
[192.545240] Starting subtest: basic
[192.547117] Subtest basic: SUCCESS (0.000s)
[192.752157] [060/134] (828s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[192.849065] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[192.851329] Starting dynamic subtest: pipe-A-default-mode
[193.147597] Dynamic subtest pipe-A-default-mode: SKIP (0.296s)
[193.152170] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.298s)
[193.945645] [061/134] (826s left) gem_mmap_gtt (ptrace)
[194.012153] Subtest ptrace: SKIP (0.000s)
[194.069323] [062/134] (826s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[194.173442] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[194.177371] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[194.305100] [063/134] (826s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[194.403947] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[194.408065] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[194.543107] [064/134] (826s left) syncobj_wait (multi-wait-all-signaled)
[194.612272] Starting subtest: multi-wait-all-signaled
[194.614573] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[194.722888] [065/134] (826s left) kms_prop_blob (invalid-set-prop-any)
[194.787381] Starting subtest: invalid-set-prop-any
[194.789566] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[194.907263] [066/134] (826s left) gem_lmem_swapping (verify-random)
[194.949081] Subtest verify-random: SKIP (0.000s)
[194.995026] [067/134] (826s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[195.052197] Starting subtest: single-wait-all-for-submit-available-signaled
[195.053992] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[195.184129] [068/134] (826s left) syncobj_timeline (reset-multiple-signaled)
[195.238437] Starting subtest: reset-multiple-signaled
[195.240390] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[195.366768] [069/134] (825s left) kms_chamelium_hpd (hdmi-hpd)
[195.753712] Subtest hdmi-hpd: SKIP (0.000s)
[196.553107] [070/134] (824s left) perf_pmu (rc6-all-gts)
[196.599296] Starting subtest: rc6-all-gts
[202.965090] Subtest rc6-all-gts: SUCCESS (6.366s)
[203.839554] [071/134] (817s left) kms_lease (simple-lease)
[203.950193] Starting subtest: simple-lease
[203.952494] Starting dynamic subtest: pipe-A-eDP-1
[204.452721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s)
[204.463531] Starting dynamic subtest: pipe-B-eDP-1
[205.914953] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.458s)
[205.924241] Starting dynamic subtest: pipe-C-eDP-1
[207.315513] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[207.324991] Starting dynamic subtest: pipe-D-eDP-1
[208.719831] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.402s)
[208.722029] Subtest simple-lease: SUCCESS (4.771s)
[209.546181] [072/134] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[209.651320] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[216.241877] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.595s)
[216.400049] [073/134] (804s left) kms_cursor_crc (cursor-onscreen-128x128)
[216.635665] Starting subtest: cursor-onscreen-128x128
[216.640417] Starting dynamic subtest: pipe-A-eDP-1
[218.749080] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s)
[218.778575] Starting dynamic subtest: pipe-D-eDP-1
[221.510084] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.740s)
[221.512388] Subtest cursor-onscreen-128x128: SUCCESS (4.874s)
[222.330028] [074/134] (799s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[222.443361] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[229.493271] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.052s)
[229.630342] [075/134] (791s left) kms_pm_rpm (modeset-non-lpsp)
[231.160331] Starting subtest: modeset-non-lpsp
[232.321571] Subtest modeset-non-lpsp: SKIP (1.158s)
[232.696649] [076/134] (788s left) gem_exec_suspend (basic-s3-devices)
[232.774280] Starting subtest: basic-S3-devices
[232.776217] Starting dynamic subtest: smem
[244.884414] Dynamic subtest smem: SUCCESS (12.112s)
[244.886814] Subtest basic-S3-devices: SUCCESS (12.114s)
[254.096942] [077/134] (776s left) i915_drm_fdinfo (idle)
[254.168985] Starting subtest: idle
[254.171248] Starting dynamic subtest: rcs0
[254.772244] Dynamic subtest rcs0: SUCCESS (0.604s)
[254.784250] Starting dynamic subtest: bcs0
[255.279700] Dynamic subtest bcs0: SUCCESS (0.504s)
[255.291801] Starting dynamic subtest: vcs0
[255.786379] Dynamic subtest vcs0: SUCCESS (0.503s)
[255.798768] Starting dynamic subtest: vcs1
[256.293412] Dynamic subtest vcs1: SUCCESS (0.504s)
[256.305639] Starting dynamic subtest: vecs0
[256.803378] Dynamic subtest vecs0: SUCCESS (0.503s)
[256.814977] Starting dynamic subtest: ccs0
[257.305023] Dynamic subtest ccs0: SUCCESS (0.503s)
[257.307771] Subtest idle: SUCCESS (3.138s)
[257.399522] [078/134] (773s left) kms_joiner (invalid-modeset-ultra-joiner)
[257.515764] Starting subtest: invalid-modeset-ultra-joiner
[257.520153] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[257.593720] [079/134] (773s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[257.692810] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[257.696899] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[257.835272] [080/134] (772s left) syncobj_basic (bad-create-flags)
[257.895742] Starting subtest: bad-create-flags
[257.898117] Subtest bad-create-flags: SUCCESS (0.000s)
[258.016069] [081/134] (772s left) syncobj_basic (bad-flags-fd-to-handle)
[258.074852] Starting subtest: bad-flags-fd-to-handle
[258.077107] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[258.197689] [082/134] (772s left) gem_pxp (display-protected-crc)
[258.323484] Starting subtest: display-protected-crc
[259.966987] Subtest display-protected-crc: SUCCESS (1.645s)
[260.122093] [083/134] (770s left) gem_softpin (safe-alignment)
[260.188214] Starting subtest: safe-alignment
[260.207029] Subtest safe-alignment: SUCCESS (0.022s)
[261.964540] [084/134] (768s left) i915_drm_fdinfo (virtual-busy-idle-all)
[262.014163] Starting subtest: virtual-busy-idle-all
[262.018527] Subtest virtual-busy-idle-all: SKIP (0.000s)
[262.103295] [085/134] (768s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[262.207337] Starting subtest: fb-8bpc-vs-panel-8bpc
[262.209490] Starting dynamic subtest: pipe-A-eDP-1
[263.598447] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.390s)
[263.600467] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.392s)
[264.482815] [086/134] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[264.597606] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[264.601720] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[264.704410] [087/134] (766s left) i915_query (hwconfig_table)
[264.770405] Starting subtest: hwconfig_table
[265.064200] Subtest hwconfig_table: SUCCESS (0.001s)
[265.125845] [088/134] (765s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[265.228770] Starting subtest: basic-modeset-with-all-modifiers-formats
[265.607463] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[266.357820] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.751s)
[266.367467] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[266.379796] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[266.389127] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[266.401680] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[266.411071] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[266.557733] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.154s)
[266.572049] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[266.579954] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[266.590229] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[266.601750] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[266.610997] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[266.624214] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[266.633225] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[266.646500] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[266.655615] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[266.668946] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[266.678077] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[266.691091] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[266.700069] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[266.713018] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[266.723993] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[266.735461] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[266.744986] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[266.880164] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[266.889688] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[266.902222] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[266.911570] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[266.924307] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[266.933348] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[266.946604] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[266.957873] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[266.968885] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[266.978183] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[266.991221] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[267.000540] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[267.013231] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[267.022464] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[267.035588] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[267.044944] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[267.057751] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[267.067745] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[267.213442] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[267.223399] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[267.235646] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[267.244614] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[267.257805] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[267.266628] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[267.279946] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[267.288769] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[267.302261] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[267.311581] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[267.324490] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[267.333991] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[267.346767] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[267.355434] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[267.368896] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[267.377485] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[267.390977] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[267.771775] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.544s)
[268.570414] [089/134] (762s left) kms_getfb (getfb2-handle-not-fb)
[268.669971] Starting subtest: getfb2-handle-not-fb
[268.672455] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[268.797184] [090/134] (762s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[268.987877] Starting subtest: cursor-rapid-movement-64x21
[269.036546] Subtest cursor-rapid-movement-64x21: SKIP (0.044s)
[269.307683] [091/134] (761s left) kms_cursor_crc (cursor-sliding-512x512)
[269.589463] Starting subtest: cursor-sliding-512x512
[269.592902] Subtest cursor-sliding-512x512: SKIP (0.001s)
[269.797244] [092/134] (761s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[269.900814] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[269.904465] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[270.033389] [093/134] (761s left) kms_big_fb (linear-16bpp-rotate-0)
[270.140514] Starting subtest: linear-16bpp-rotate-0
[271.453915] Subtest linear-16bpp-rotate-0: SUCCESS (1.312s)
[271.629376] [094/134] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[271.738832] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[271.742362] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[271.873611] [095/134] (759s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[271.956674] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[271.959969] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[272.082714] [096/134] (759s left) kms_psr (fbc-psr-no-drrs)
[272.174030] Starting subtest: fbc-psr-no-drrs
[272.176020] Starting dynamic subtest: eDP-1
[272.179668] Dynamic subtest eDP-1: SKIP (0.000s)
[272.183310] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[272.272208] [097/134] (759s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[272.360849] Starting subtest: primary-4-tiled-reflect-x-180
[279.592975] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.232s)
[280.819140] [098/134] (750s left) kms_content_protection (lic-type-1)
[280.973343] Starting subtest: lic-type-1
[280.977753] Subtest lic-type-1: SKIP (0.000s)
[281.146449] [099/134] (750s left) gem_ctx_shared (create-shared-gtt)
[281.212367] Starting subtest: create-shared-gtt
[283.365035] Subtest create-shared-gtt: SUCCESS (2.151s)
[284.218064] [100/134] (747s left) kms_flip (modeset-vs-vblank-race)
[284.309849] Starting subtest: modeset-vs-vblank-race
[284.311715] Starting dynamic subtest: A-eDP1
[289.046206] Dynamic subtest A-eDP1: SUCCESS (4.737s)
[289.058229] Starting dynamic subtest: B-eDP1
[293.791131] Dynamic subtest B-eDP1: SUCCESS (4.743s)
[293.803475] Starting dynamic subtest: C-eDP1
[298.495239] Dynamic subtest C-eDP1: SUCCESS (4.702s)
[298.506079] Starting dynamic subtest: D-eDP1
[303.063623] Dynamic subtest D-eDP1: SUCCESS (4.566s)
[303.065880] Subtest modeset-vs-vblank-race: SUCCESS (18.759s)
[304.335397] [101/134] (727s left) kms_plane_multiple (2x-tiling-none)
[304.438060] Starting subtest: 2x-tiling-none
[304.442523] Subtest 2x-tiling-none: SKIP (0.000s)
[304.530260] [102/134] (727s left) kms_async_flips (test-cursor)
[304.620823] Starting subtest: test-cursor
[304.625183] Subtest test-cursor: SKIP (0.000s)
[305.871397] [103/134] (725s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[305.986745] Starting subtest: y-tiled-16bpp-rotate-180
[305.990857] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[306.109239] [104/134] (725s left) gem_ctx_persistence (heartbeat-hang)
[306.167543] Starting subtest: heartbeat-hang
[306.172194] Subtest heartbeat-hang: SKIP (0.000s)
[306.290982] [105/134] (725s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[306.396186] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[306.398493] Starting dynamic subtest: pipe-A-eDP-1
[306.550704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.146s)
[306.565062] Starting dynamic subtest: pipe-B-eDP-1
[306.584205] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[306.595751] Starting dynamic subtest: pipe-C-eDP-1
[306.614781] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[306.623803] Starting dynamic subtest: pipe-D-eDP-1
[306.642827] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[306.644702] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.183s)
[308.844304] [106/134] (723s left) kms_flip (2x-absolute-wf_vblank)
[308.954114] Starting subtest: 2x-absolute-wf_vblank
[308.965731] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[309.094942] [107/134] (722s left) kms_chamelium_frames (hdmi-crc-fast)
[309.482273] Subtest hdmi-crc-fast: SKIP (0.000s)
[310.260025] [108/134] (721s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[310.314131] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[310.417540] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[310.518227] [109/134] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[310.632592] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[310.636688] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[310.761627] [110/134] (721s left) gem_exec_params (invalid-ring2)
[310.833873] Starting subtest: invalid-ring2
[310.836170] Subtest invalid-ring2: SUCCESS (0.000s)
[310.967205] [111/134] (721s left) prime_busy (hang-wait)
[311.035284] Starting subtest: hang-wait
[311.037188] Starting dynamic subtest: rcs0
[337.460820] Dynamic subtest rcs0: SUCCESS (26.424s)
[337.469912] Starting dynamic subtest: bcs0
[344.553485] Dynamic subtest bcs0: SUCCESS (7.089s)
[344.564831] Starting dynamic subtest: vcs0
[351.589072] Dynamic subtest vcs0: SUCCESS (7.032s)
[351.600049] Starting dynamic subtest: vcs1
[358.497828] Dynamic subtest vcs1: SUCCESS (6.911s)
[358.508541] Starting dynamic subtest: vecs0
[365.540972] Dynamic subtest vecs0: SUCCESS (7.036s)
[365.550725] Starting dynamic subtest: ccs0
[379.440245] Dynamic subtest ccs0: SUCCESS (13.897s)
[379.442840] Subtest hang-wait: SUCCESS (68.405s)
[379.607413] [112/134] (652s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[379.703113] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[379.705426] Starting dynamic subtest: pipe-A
[379.770690] Dynamic subtest pipe-A: SUCCESS (0.069s)
[379.782544] Starting dynamic subtest: pipe-B
[380.900082] Dynamic subtest pipe-B: SUCCESS (1.128s)
[380.914818] Starting dynamic subtest: pipe-C
[382.014209] Dynamic subtest pipe-C: SUCCESS (1.111s)
[382.024118] Starting dynamic subtest: pipe-D
[383.137637] Dynamic subtest pipe-D: SUCCESS (1.123s)
[383.139915] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.438s)
[384.308323] [113/134] (647s left) kms_vblank (query-forked-busy)
[384.416873] Starting subtest: query-forked-busy
[384.419033] Starting dynamic subtest: pipe-A-eDP-1
[386.293539] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[386.308755] Starting dynamic subtest: pipe-D-eDP-1
[388.859424] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[388.861823] Subtest query-forked-busy: SUCCESS (4.442s)
[389.675743] [114/134] (642s left) gem_reg_read (timestamp-monotonic)
[389.738466] Starting subtest: timestamp-monotonic
[394.511662] Subtest timestamp-monotonic: SUCCESS (4.773s)
[394.616142] [115/134] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[394.728747] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[394.732914] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[394.836589] [116/134] (637s left) i915_pm_rpm (gem-execbuf)
[397.062016] Starting subtest: gem-execbuf
[397.064978] Starting dynamic subtest: smem0
[398.488503] Dynamic subtest smem0: SUCCESS (1.426s)
[398.490714] Subtest gem-execbuf: SUCCESS (1.427s)
[398.610821] [117/134] (633s left) gem_exec_whisper (basic-fds)
[398.665721] Starting subtest: basic-fds
[404.919468] Subtest basic-fds: SUCCESS (6.249s)
[405.119467] [118/134] (627s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[405.235403] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[405.263626] Starting dynamic subtest: pipe-A-plane-0
[405.696747] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[405.706571] Starting dynamic subtest: pipe-A-plane-3
[405.952267] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[405.962214] Starting dynamic subtest: pipe-A-plane-5
[405.966675] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[407.029987] Starting dynamic subtest: pipe-B-plane-0
[407.455099] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[407.465104] Starting dynamic subtest: pipe-B-plane-3
[407.732918] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s)
[407.742507] Starting dynamic subtest: pipe-B-plane-5
[407.746995] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[408.049704] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.814s)
[408.921598] [119/134] (623s left) gem_exec_balancer (parallel-bb-first)
[409.173288] Starting subtest: parallel-bb-first
[410.167282] Subtest parallel-bb-first: SUCCESS (0.993s)
[410.953963] [120/134] (621s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[411.058678] Starting subtest: 4-tiled-8bpp-rotate-90
[411.079971] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[411.232078] [121/134] (621s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[411.329400] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[411.333861] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[411.436390] [122/134] (621s left) kms_psr (pr-sprite-mmap-gtt)
[411.529809] Starting subtest: pr-sprite-mmap-gtt
[411.534239] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[411.619085] [123/134] (620s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[411.725047] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[412.505233] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.781s)
[412.701926] [124/134] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[412.802338] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[420.279342] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.479s)
[420.439198] [125/134] (612s left) kms_vblank (ts-continuation-modeset-rpm)
[420.548116] Starting subtest: ts-continuation-modeset-rpm
[420.550309] Starting dynamic subtest: pipe-A-eDP-1
[423.034612] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.487s)
[423.049826] Starting dynamic subtest: pipe-D-eDP-1
[425.272580] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.236s)
[425.274865] Subtest ts-continuation-modeset-rpm: SUCCESS (4.727s)
[426.164447] [126/134] (606s left) gem_mmap_gtt (basic-read)
[426.230921] Subtest basic-read: SKIP (0.000s)
[426.296808] [127/134] (606s left) gem_blits (basic)
[426.361666] Starting subtest: basic
[427.677052] Subtest basic: SUCCESS (1.315s)
[427.830264] [128/134] (604s left) kms_color (ctm-signed)
[427.941994] Starting subtest: ctm-signed
[427.944252] Starting dynamic subtest: pipe-A-eDP-1
[430.021938] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.078s)
[430.032694] Starting dynamic subtest: pipe-B-eDP-1
[432.900380] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.879s)
[432.910738] Starting dynamic subtest: pipe-C-eDP-1
[435.618158] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.714s)
[435.628742] Starting dynamic subtest: pipe-D-eDP-1
[438.278096] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.660s)
[438.280403] Subtest ctm-signed: SUCCESS (10.336s)
[439.137158] [129/134] (593s left) gem_eio (throttle)
[439.383987] Starting subtest: throttle
[439.744056] Subtest throttle: SUCCESS (0.358s)
[439.909216] [130/134] (592s left) syncobj_wait (invalid-signal-illegal-handle)
[439.969027] Starting subtest: invalid-signal-illegal-handle
[439.970929] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[440.096607] [131/134] (592s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[440.200257] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[440.203566] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[440.304962] [132/134] (592s left) kms_pm_backlight (fade-with-suspend)
[440.409393] Starting subtest: fade-with-suspend
[457.455787] Starting dynamic subtest: eDP-1
[460.128307] Dynamic subtest eDP-1: SUCCESS (2.675s)
[460.130515] Subtest fade-with-suspend: SUCCESS (4.309s)
[470.981190] [133/134] (572s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[476.046128] Starting subtest: psr2-overlay-plane-move-continuous-sf
[476.048344] Starting dynamic subtest: pipe-A-eDP-1
[482.732325] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.696s)
[482.743614] Starting dynamic subtest: pipe-B-eDP-1
[489.367238] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.636s)
[489.369869] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.336s)
[490.260489] [134/134] (552s left) perf (gen12-oa-tlb-invalidate)
[490.394720] Starting subtest: gen12-oa-tlb-invalidate
[490.396632] Starting dynamic subtest: 0-rcs0
[500.426818] Dynamic subtest 0-rcs0: SUCCESS (10.038s)
[500.437241] Starting dynamic subtest: 1-vcs1
[510.472395] Dynamic subtest 1-vcs1: SUCCESS (10.049s)
[510.474827] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.089s)
[510.522617] 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.