[57.273161] Initializing watchdogs
[57.273271]   /dev/watchdog0
[57.288119] [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]
[57.292592] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.294899] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.298360] [001/134] (960s left) kms_flip (flip-vs-rmfb-interruptible)
[57.430735] Starting subtest: flip-vs-rmfb-interruptible
[57.433039] Starting dynamic subtest: A-eDP1
[66.116038] Dynamic subtest A-eDP1: SUCCESS (8.684s)
[66.125112] Starting dynamic subtest: B-eDP1
[74.739767] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[74.748546] Starting dynamic subtest: C-eDP1
[83.367036] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[83.375174] Starting dynamic subtest: D-eDP1
[92.001976] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[92.006117] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.573s)
[93.193465] [002/134] (924s left) kms_addfb_basic (bo-too-small)
[93.294189] Starting subtest: bo-too-small
[93.296534] Subtest bo-too-small: SUCCESS (0.000s)
[93.421305] [003/134] (924s left) gem_mmap_gtt (basic-write-read-distinct)
[93.486204] Subtest basic-write-read-distinct: SKIP (0.000s)
[93.540521] [004/134] (924s left) syncobj_wait (multi-wait-for-submit-signaled)
[93.589419] Starting subtest: multi-wait-for-submit-signaled
[93.591680] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[93.710378] [005/134] (924s left) gem_ccs (ctrl-surf-copy-new-ctx)
[93.778324] Starting subtest: ctrl-surf-copy-new-ctx
[93.782862] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[93.898588] [006/134] (924s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[93.946256] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[93.948167] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[94.057938] [007/134] (923s left) kms_feature_discovery (display-3x)
[94.162321] Starting subtest: display-3x
[94.166020] Subtest display-3x: SKIP (0.000s)
[94.269650] [008/134] (923s left) api_intel_allocator (reloc-allocator)
[94.339881] Starting subtest: reloc-allocator
[94.342037] Starting dynamic subtest: basic
[94.343998] Dynamic subtest basic: SUCCESS (0.003s)
[94.352991] Starting dynamic subtest: parallel-one
[94.354848] Dynamic subtest parallel-one: SUCCESS (0.007s)
[94.362176] Starting dynamic subtest: print
[94.364115] Dynamic subtest print: SUCCESS (0.000s)
[94.370474] Starting dynamic subtest: reuse
[94.372361] Dynamic subtest reuse: SUCCESS (0.000s)
[94.378830] Starting dynamic subtest: fork-reopen-allocator
[94.380679] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[94.382503] Subtest reloc-allocator: SUCCESS (0.024s)
[94.496349] [009/134] (923s left) gem_exec_gttfill (basic)
[94.558377] Starting subtest: basic
[97.942417] Subtest basic: SUCCESS (3.381s)
[98.134110] [010/134] (920s left) gem_exec_schedule (preempt-queue-contexts-chain)
[98.258267] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[98.564422] [011/134] (919s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[98.626730] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[98.688563] [012/134] (919s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[98.804959] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[102.886756] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.084s)
[104.102199] [013/134] (914s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[104.232848] Starting subtest: cursorB-vs-flipA-legacy
[104.237611] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[104.387824] [014/134] (913s left) gem_render_copy (yf-tiled-ccs-to-linear)
[104.452370] Starting subtest: yf-tiled-ccs-to-linear
[104.456971] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[104.659436] [015/134] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[104.765122] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[104.769286] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[104.897416] [016/134] (913s left) gem_exec_schedule (fairslice)
[104.966780] Starting subtest: fairslice
[104.968733] Starting dynamic subtest: rcs0
[106.983877] Dynamic subtest rcs0: SUCCESS (2.021s)
[106.992893] Starting dynamic subtest: bcs0
[109.001395] Dynamic subtest bcs0: SUCCESS (2.019s)
[109.010804] Starting dynamic subtest: vcs0
[111.023624] Dynamic subtest vcs0: SUCCESS (2.022s)
[111.031875] Starting dynamic subtest: vcs1
[113.043993] Dynamic subtest vcs1: SUCCESS (2.018s)
[113.052633] Starting dynamic subtest: vecs0
[115.064047] Dynamic subtest vecs0: SUCCESS (2.019s)
[115.072053] Starting dynamic subtest: ccs0
[117.084935] Dynamic subtest ccs0: SUCCESS (2.021s)
[117.087173] Subtest fairslice: SUCCESS (12.125s)
[117.394640] [017/134] (901s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[117.514683] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[117.516928] Starting dynamic subtest: pipe-A-default-mode
[120.224838] Dynamic subtest pipe-A-default-mode: SUCCESS (2.708s)
[120.227063] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.709s)
[121.062071] [018/134] (897s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[121.170175] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[121.174151] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[121.297665] [019/134] (897s left) gem_userptr_blits (set-cache-level)
[121.374242] Starting subtest: set-cache-level
[121.378430] Subtest set-cache-level: SKIP (0.000s)
[121.509737] [020/134] (897s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[121.598183] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[121.610704] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[121.703589] [021/134] (896s left) gem_softpin (evict-active-interruptible)
[121.754830] Starting subtest: evict-active-interruptible
[121.760469] Subtest evict-active-interruptible: SUCCESS (0.006s)
[121.925653] [022/134] (896s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[122.020916] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[122.022574] Starting dynamic subtest: pipe-A-eDP-1
[122.042051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[122.050204] Starting dynamic subtest: pipe-B-eDP-1
[122.066487] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[122.073858] Starting dynamic subtest: pipe-C-eDP-1
[122.090845] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[122.099871] Starting dynamic subtest: pipe-D-eDP-1
[122.116881] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[122.119209] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[124.444601] [023/134] (894s left) kms_psr (fbc-psr2-dpms)
[124.544020] Starting subtest: fbc-psr2-dpms
[124.546287] Starting dynamic subtest: eDP-1
[124.550567] Dynamic subtest eDP-1: SKIP (0.000s)
[124.554997] Subtest fbc-psr2-dpms: SKIP (0.001s)
[124.625397] [024/134] (894s left) gem_tiled_pread_basic
[124.752081] [025/134] (894s left) gem_sync (basic-store-all)
[124.837485] Starting subtest: basic-store-all
[127.733322] Subtest basic-store-all: SUCCESS (2.907s)
[127.928954] [026/134] (890s left) kms_atomic_transition (plane-all-transition-fencing)
[128.035217] Starting subtest: plane-all-transition-fencing
[128.037567] Starting dynamic subtest: pipe-A-eDP-1
[130.528927] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[130.834780] Starting dynamic subtest: pipe-B-eDP-1
[134.045481] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.219s)
[134.357385] Subtest plane-all-transition-fencing: SUCCESS (6.322s)
[135.181594] [027/134] (883s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[135.288772] Starting subtest: crc-primary-basic-yf-tiled-ccs
[135.290962] Starting dynamic subtest: pipe-A-eDP-1
[135.312627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[135.321807] Starting dynamic subtest: pipe-B-eDP-1
[135.342769] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[135.350141] Starting dynamic subtest: pipe-C-eDP-1
[135.370263] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[135.377264] Starting dynamic subtest: pipe-D-eDP-1
[135.398641] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[135.402982] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[137.579059] [028/134] (881s left) gem_exec_reloc (basic-cpu-gtt)
[137.629525] Subtest basic-cpu-gtt: SKIP (0.000s)
[137.715862] [029/134] (881s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[137.785750] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[137.790094] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[137.990443] [030/134] (880s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[138.058669] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[138.128763] [031/134] (880s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[138.235778] Starting subtest: fbc-shrfb-scaledprimary
[141.275373] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.042s)
[142.486452] [032/134] (876s left) gem_eio (in-flight-contexts-1us)
[142.737680] Starting subtest: in-flight-contexts-1us
[153.897234] Subtest in-flight-contexts-1us: SUCCESS (11.159s)
[154.083126] [033/134] (865s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[154.176477] Starting subtest: coverage-vs-premult-vs-constant
[154.477161] Starting dynamic subtest: pipe-A-eDP-1
[155.079470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[155.087777] Starting dynamic subtest: pipe-D-eDP-1
[156.372444] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s)
[156.374672] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.194s)
[157.213973] [034/134] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[157.316760] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[157.321565] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[157.458342] [035/134] (861s left) kms_pwrite_crc
[159.145608] [036/134] (860s left) gem_lmem_swapping (heavy-multi)
[159.194347] Subtest heavy-multi: SKIP (0.000s)
[159.233299] [037/134] (860s left) gem_exec_schedule (preempt-other-chain)
[159.313496] Starting subtest: preempt-other-chain
[159.315532] Starting dynamic subtest: rcs0
[159.389992] Dynamic subtest rcs0: SUCCESS (0.086s)
[159.399412] Starting dynamic subtest: bcs0
[159.475202] Dynamic subtest bcs0: SUCCESS (0.084s)
[159.486978] Starting dynamic subtest: vcs0
[159.563027] Dynamic subtest vcs0: SUCCESS (0.088s)
[159.572106] Starting dynamic subtest: vcs1
[159.641086] Dynamic subtest vcs1: SUCCESS (0.077s)
[159.649090] Starting dynamic subtest: vecs0
[159.725484] Dynamic subtest vecs0: SUCCESS (0.083s)
[159.736884] Starting dynamic subtest: ccs0
[159.803958] Dynamic subtest ccs0: SUCCESS (0.078s)
[159.806534] Subtest preempt-other-chain: SUCCESS (0.501s)
[161.023340] [038/134] (858s left) kms_psr (psr-cursor-plane-move)
[161.123456] Starting subtest: psr-cursor-plane-move
[161.125783] Starting dynamic subtest: eDP-1
[162.827048] Dynamic subtest eDP-1: SUCCESS (1.703s)
[162.829346] Subtest psr-cursor-plane-move: SUCCESS (1.704s)
[163.708909] [039/134] (855s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[163.810115] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[163.812408] Starting dynamic subtest: pipe-A-eDP-1
[163.837603] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[163.853872] Starting dynamic subtest: pipe-B-eDP-1
[163.878473] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[163.894314] Starting dynamic subtest: pipe-C-eDP-1
[163.919302] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[163.929133] Starting dynamic subtest: pipe-D-eDP-1
[163.953808] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[163.958217] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[166.078050] [040/134] (853s left) dmabuf_sync_file (import-multiple-read-only)
[166.172058] Starting subtest: import-multiple-read-only
[166.174570] Subtest import-multiple-read-only: SUCCESS (0.003s)
[166.240791] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[166.244526] [041/134] (853s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[166.357446] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[167.457833] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.101s)
[167.622825] [042/134] (851s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[167.716343] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[167.718254] Starting dynamic subtest: pipe-A-eDP-1
[167.737475] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[167.746719] Starting dynamic subtest: pipe-B-eDP-1
[167.764265] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[167.771636] Starting dynamic subtest: pipe-C-eDP-1
[167.788765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[167.796439] Starting dynamic subtest: pipe-D-eDP-1
[167.814339] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[167.817925] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[169.945728] [043/134] (849s left) gem_softpin (noreloc-interruptible)
[170.012472] Starting subtest: noreloc-interruptible
[175.439910] Subtest noreloc-interruptible: SUCCESS (5.425s)
[175.612014] [044/134] (843s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[175.716152] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[175.718460] Starting dynamic subtest: pipe-A
[175.737054] Dynamic subtest pipe-A: SKIP (0.018s)
[175.747241] Starting dynamic subtest: pipe-B
[175.779240] Dynamic subtest pipe-B: SKIP (0.040s)
[175.787321] Starting dynamic subtest: pipe-C
[175.810449] Dynamic subtest pipe-C: SKIP (0.031s)
[175.818422] Starting dynamic subtest: pipe-D
[175.844514] Dynamic subtest pipe-D: SKIP (0.031s)
[175.849021] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.124s)
[175.949237] [045/134] (843s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[176.006061] Starting subtest: multi-wait-all-for-submit-available-signaled
[176.008363] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[176.159282] [046/134] (843s left) gem_exec_balancer (bonded-sync)
[176.224819] Starting subtest: bonded-sync
[176.229109] Subtest bonded-sync: SKIP (0.000s)
[176.549243] [047/134] (843s left) gem_exec_fence (submit-chain)
[176.735065] Starting subtest: submit-chain
[176.751972] Subtest submit-chain: SUCCESS (0.017s)
[178.996973] [048/134] (840s left) vgem_basic (bad-handle)
[179.036165] Starting subtest: bad-handle
[179.038360] Subtest bad-handle: SUCCESS (0.000s)
[179.102780] [049/134] (840s left) kms_flip (basic-plain-flip)
[179.197785] Starting subtest: basic-plain-flip
[179.199995] Starting dynamic subtest: A-eDP1
[180.848075] Dynamic subtest A-eDP1: SUCCESS (1.652s)
[180.859645] Starting dynamic subtest: B-eDP1
[182.488770] Dynamic subtest B-eDP1: SUCCESS (1.639s)
[182.499322] Starting dynamic subtest: C-eDP1
[184.198944] Dynamic subtest C-eDP1: SUCCESS (1.707s)
[184.208438] Starting dynamic subtest: D-eDP1
[185.836914] Dynamic subtest D-eDP1: SUCCESS (1.637s)
[185.842958] Subtest basic-plain-flip: SUCCESS (6.647s)
[187.133776] [050/134] (832s left) gem_set_tiling_vs_pwrite
[187.260215] [051/134] (832s left) api_intel_bb (purge-bb)
[187.322588] Starting subtest: purge-bb
[187.324554] Subtest purge-bb: SUCCESS (0.004s)
[187.478188] [052/134] (832s left) gem_ctx_persistence (engines-hang)
[187.549977] Starting subtest: engines-hang
[187.552338] Starting dynamic subtest: rcs0
[187.672361] Dynamic subtest rcs0: SUCCESS (0.121s)
[187.683736] Starting dynamic subtest: bcs0
[187.785037] Dynamic subtest bcs0: SUCCESS (0.111s)
[187.796067] Starting dynamic subtest: vcs0
[187.908379] Dynamic subtest vcs0: SUCCESS (0.121s)
[187.919868] Starting dynamic subtest: vcs1
[188.043335] Dynamic subtest vcs1: SUCCESS (0.133s)
[188.054571] Starting dynamic subtest: vecs0
[188.165701] Dynamic subtest vecs0: SUCCESS (0.121s)
[188.176615] Starting dynamic subtest: ccs0
[188.289664] Dynamic subtest ccs0: SUCCESS (0.122s)
[188.292394] Subtest engines-hang: SUCCESS (0.741s)
[188.387126] [053/134] (831s left) kms_psr2_su (page_flip-nv12)
[188.454268] Subtest page_flip-NV12: SKIP (0.000s)
[188.524265] [054/134] (831s left) gem_exec_reloc (basic-wc-cpu)
[188.576852] Subtest basic-wc-cpu: SKIP (0.000s)
[188.634155] [055/134] (831s left) syncobj_wait (wait-any-snapshot)
[188.696012] Starting subtest: wait-any-snapshot
[188.776038] Subtest wait-any-snapshot: SUCCESS (0.081s)
[188.863966] [056/134] (831s left) drm_read (empty-nonblock)
[189.014048] Starting subtest: empty-nonblock
[189.016090] Subtest empty-nonblock: SUCCESS (0.000s)
[189.169457] [057/134] (830s left) gen9_exec_parse (batch-invalid-length)
[189.228717] Subtest batch-invalid-length: SKIP (0.000s)
[189.305779] [058/134] (830s left) gen3_render_mixed_blits
[189.435110] [059/134] (830s left) gem_ctx_create (basic)
[189.497490] Starting subtest: basic
[189.499293] Subtest basic: SUCCESS (0.000s)
[189.689495] [060/134] (830s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[189.791092] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[189.793441] Starting dynamic subtest: pipe-A-default-mode
[190.087488] Dynamic subtest pipe-A-default-mode: SKIP (0.295s)
[190.092210] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.297s)
[190.957375] [061/134] (829s left) gem_mmap_gtt (ptrace)
[191.038880] Subtest ptrace: SKIP (0.000s)
[191.106527] [062/134] (829s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[191.196353] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[191.200380] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[191.309533] [063/134] (829s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[191.410332] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[191.414593] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[191.552076] [064/134] (828s left) syncobj_wait (multi-wait-all-signaled)
[191.609136] Starting subtest: multi-wait-all-signaled
[191.611424] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[191.730081] [065/134] (828s left) kms_prop_blob (invalid-set-prop-any)
[191.789464] Starting subtest: invalid-set-prop-any
[191.791548] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[191.906435] [066/134] (828s left) gem_lmem_swapping (verify-random)
[191.949388] Subtest verify-random: SKIP (0.000s)
[192.001435] [067/134] (828s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[192.053954] Starting subtest: single-wait-all-for-submit-available-signaled
[192.055986] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[192.184532] [068/134] (828s left) syncobj_timeline (reset-multiple-signaled)
[192.232419] Starting subtest: reset-multiple-signaled
[192.234362] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[192.354897] [069/134] (828s left) kms_chamelium_hpd (hdmi-hpd)
[192.729102] Subtest hdmi-hpd: SKIP (0.000s)
[193.565392] [070/134] (827s left) perf_pmu (rc6-all-gts)
[193.618530] Starting subtest: rc6-all-gts
[199.984275] Subtest rc6-all-gts: SUCCESS (6.364s)
[200.872734] [071/134] (819s left) kms_lease (simple-lease)
[200.976815] Starting subtest: simple-lease
[200.979050] Starting dynamic subtest: pipe-A-eDP-1
[201.478367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.500s)
[201.487451] Starting dynamic subtest: pipe-B-eDP-1
[202.922895] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.442s)
[202.932529] Starting dynamic subtest: pipe-C-eDP-1
[204.318201] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s)
[204.327307] Starting dynamic subtest: pipe-D-eDP-1
[205.716440] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s)
[205.718595] Subtest simple-lease: SUCCESS (4.739s)
[206.528728] [072/134] (814s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[206.644925] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[213.211125] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.570s)
[213.393408] [073/134] (807s left) kms_cursor_crc (cursor-onscreen-128x128)
[213.616273] Starting subtest: cursor-onscreen-128x128
[213.618594] Starting dynamic subtest: pipe-A-eDP-1
[215.724446] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.105s)
[215.753158] Starting dynamic subtest: pipe-D-eDP-1
[218.708911] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.961s)
[218.710823] Subtest cursor-onscreen-128x128: SUCCESS (5.093s)
[219.610581] [074/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[219.738215] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[226.788081] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.052s)
[226.924280] [075/134] (793s left) kms_pm_rpm (modeset-non-lpsp)
[229.074118] Starting subtest: modeset-non-lpsp
[230.225359] Subtest modeset-non-lpsp: SKIP (1.152s)
[230.628161] [076/134] (790s left) gem_exec_suspend (basic-s3-devices)
[230.696086] Starting subtest: basic-S3-devices
[230.698376] Starting dynamic subtest: smem
[241.878498] Dynamic subtest smem: SUCCESS (11.183s)
[241.881648] Subtest basic-S3-devices: SUCCESS (11.185s)
[242.075365] [077/134] (778s left) i915_drm_fdinfo (idle)
[242.132554] Starting subtest: idle
[242.134705] Starting dynamic subtest: rcs0
[242.712034] Dynamic subtest rcs0: SUCCESS (0.580s)
[242.724229] Starting dynamic subtest: bcs0
[243.216982] Dynamic subtest bcs0: SUCCESS (0.503s)
[243.228639] Starting dynamic subtest: vcs0
[243.724033] Dynamic subtest vcs0: SUCCESS (0.503s)
[243.733667] Starting dynamic subtest: vcs1
[244.229858] Dynamic subtest vcs1: SUCCESS (0.503s)
[244.241658] Starting dynamic subtest: vecs0
[244.734853] Dynamic subtest vecs0: SUCCESS (0.502s)
[244.747281] Starting dynamic subtest: ccs0
[245.243772] Dynamic subtest ccs0: SUCCESS (0.503s)
[245.246262] Subtest idle: SUCCESS (3.109s)
[245.329137] [078/134] (775s left) kms_joiner (invalid-modeset-ultra-joiner)
[245.442260] Starting subtest: invalid-modeset-ultra-joiner
[245.446488] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[245.537146] [079/134] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[245.639213] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[245.643576] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[245.769905] [080/134] (775s left) syncobj_basic (bad-create-flags)
[245.826421] Starting subtest: bad-create-flags
[245.828324] Subtest bad-create-flags: SUCCESS (0.000s)
[245.921858] [081/134] (775s left) syncobj_basic (bad-flags-fd-to-handle)
[245.985015] Starting subtest: bad-flags-fd-to-handle
[245.987275] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[246.097096] [082/134] (775s left) gem_pxp (display-protected-crc)
[246.228046] Starting subtest: display-protected-crc
[247.859506] Subtest display-protected-crc: SUCCESS (1.633s)
[248.008191] [083/134] (773s left) gem_softpin (safe-alignment)
[248.077608] Starting subtest: safe-alignment
[248.100101] Subtest safe-alignment: SUCCESS (0.022s)
[249.994759] [084/134] (771s left) i915_drm_fdinfo (virtual-busy-idle-all)
[250.035585] Starting subtest: virtual-busy-idle-all
[250.040368] Subtest virtual-busy-idle-all: SKIP (0.000s)
[250.115450] [085/134] (771s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[250.207669] Starting subtest: fb-8bpc-vs-panel-8bpc
[250.209903] Starting dynamic subtest: pipe-A-eDP-1
[251.612977] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.406s)
[251.615359] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.408s)
[252.488160] [086/134] (768s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[252.590576] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[252.594912] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.706979] [087/134] (768s left) i915_query (hwconfig_table)
[252.770094] Starting subtest: hwconfig_table
[253.067904] Subtest hwconfig_table: SUCCESS (0.001s)
[253.108113] [088/134] (768s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[253.209812] Starting subtest: basic-modeset-with-all-modifiers-formats
[253.581931] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[254.353918] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.773s)
[254.364698] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[254.375224] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[254.384404] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[254.397548] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[254.406777] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[254.542476] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[254.552707] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[254.564485] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[254.573976] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[254.586818] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[254.596013] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[254.609064] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[254.618088] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[254.631174] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[254.640260] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[254.653516] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[254.662540] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[254.675798] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[254.685076] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[254.697574] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[254.706981] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[254.719814] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[254.729153] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[254.864221] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[254.873821] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[254.886796] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[254.895975] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[254.909177] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[254.918572] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[254.931275] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[254.940261] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[254.953339] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[254.962338] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[254.975429] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[254.984330] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[254.997914] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[255.007455] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[255.020294] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.020s)
[255.028812] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[255.042214] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[255.051142] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[255.198094] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[255.210669] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[255.220640] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.020s)
[255.229754] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[255.242661] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.020s)
[255.251628] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[255.264652] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[255.273629] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[255.286737] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[255.295316] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[255.308951] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[255.317759] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[255.331282] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[255.339882] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[255.353459] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[255.362245] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[255.375691] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[255.778750] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.571s)
[256.632963] [089/134] (764s left) kms_getfb (getfb2-handle-not-fb)
[256.727522] Starting subtest: getfb2-handle-not-fb
[256.729614] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[256.830060] [090/134] (764s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[257.031848] Starting subtest: cursor-rapid-movement-64x21
[257.088646] Subtest cursor-rapid-movement-64x21: SKIP (0.053s)
[257.351569] [091/134] (764s left) kms_cursor_crc (cursor-sliding-512x512)
[257.633226] Starting subtest: cursor-sliding-512x512
[257.636866] Subtest cursor-sliding-512x512: SKIP (0.001s)
[257.829847] [092/134] (763s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[257.932966] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[257.936483] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[258.065077] [093/134] (763s left) kms_big_fb (linear-16bpp-rotate-0)
[258.160661] Starting subtest: linear-16bpp-rotate-0
[259.563842] Subtest linear-16bpp-rotate-0: SUCCESS (1.401s)
[259.727352] [094/134] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[259.812226] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[259.815649] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[259.946594] [095/134] (761s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[260.043875] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[260.047238] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[260.190669] [096/134] (761s left) kms_psr (fbc-psr-no-drrs)
[260.296161] Starting subtest: fbc-psr-no-drrs
[260.297979] Starting dynamic subtest: eDP-1
[260.301411] Dynamic subtest eDP-1: SKIP (0.000s)
[260.304840] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[260.380388] [097/134] (761s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[260.475309] Starting subtest: primary-4-tiled-reflect-x-180
[267.562511] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.088s)
[268.809097] [098/134] (753s left) kms_content_protection (lic-type-1)
[268.949441] Starting subtest: lic-type-1
[268.953788] Subtest lic-type-1: SKIP (0.000s)
[269.096027] [099/134] (752s left) gem_ctx_shared (create-shared-gtt)
[269.167760] Starting subtest: create-shared-gtt
[271.317341] Subtest create-shared-gtt: SUCCESS (2.151s)
[272.230586] [100/134] (749s left) kms_flip (modeset-vs-vblank-race)
[272.340054] Starting subtest: modeset-vs-vblank-race
[272.342242] Starting dynamic subtest: A-eDP1
[277.022546] Dynamic subtest A-eDP1: SUCCESS (4.683s)
[277.037432] Starting dynamic subtest: B-eDP1
[281.720570] Dynamic subtest B-eDP1: SUCCESS (4.695s)
[281.732795] Starting dynamic subtest: C-eDP1
[286.312078] Dynamic subtest C-eDP1: SUCCESS (4.589s)
[286.323048] Starting dynamic subtest: D-eDP1
[290.935790] Dynamic subtest D-eDP1: SUCCESS (4.622s)
[290.940995] Subtest modeset-vs-vblank-race: SUCCESS (18.604s)
[292.234391] [101/134] (729s left) kms_plane_multiple (2x-tiling-none)
[292.331046] Starting subtest: 2x-tiling-none
[292.335292] Subtest 2x-tiling-none: SKIP (0.000s)
[292.415519] [102/134] (729s left) kms_async_flips (test-cursor)
[292.520725] Starting subtest: test-cursor
[292.524752] Subtest test-cursor: SKIP (0.000s)
[293.740395] [103/134] (728s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[293.857982] Starting subtest: y-tiled-16bpp-rotate-180
[293.862349] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[293.959722] [104/134] (728s left) gem_ctx_persistence (heartbeat-hang)
[294.024207] Starting subtest: heartbeat-hang
[294.028738] Subtest heartbeat-hang: SKIP (0.000s)
[294.168245] [105/134] (727s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[294.258021] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[294.260319] Starting dynamic subtest: pipe-A-eDP-1
[294.408356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[294.419463] Starting dynamic subtest: pipe-B-eDP-1
[294.435192] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[294.444400] Starting dynamic subtest: pipe-C-eDP-1
[294.461522] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[294.470532] Starting dynamic subtest: pipe-D-eDP-1
[294.486607] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[294.488479] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.181s)
[296.698415] [106/134] (725s left) kms_flip (2x-absolute-wf_vblank)
[296.790762] Starting subtest: 2x-absolute-wf_vblank
[296.800921] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[296.906125] [107/134] (725s left) kms_chamelium_frames (hdmi-crc-fast)
[297.296416] Subtest hdmi-crc-fast: SKIP (0.000s)
[298.103940] [108/134] (724s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[298.167877] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[298.274303] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[298.362434] [109/134] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[298.470590] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[298.474990] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[298.624719] [110/134] (723s left) gem_exec_params (invalid-ring2)
[298.685416] Starting subtest: invalid-ring2
[298.687786] Subtest invalid-ring2: SUCCESS (0.000s)
[298.813534] [111/134] (723s left) prime_busy (hang-wait)
[298.871390] Starting subtest: hang-wait
[298.873729] Starting dynamic subtest: rcs0
[325.367043] Dynamic subtest rcs0: SUCCESS (26.491s)
[325.378507] Starting dynamic subtest: bcs0
[332.519113] Dynamic subtest bcs0: SUCCESS (7.147s)
[332.533617] Starting dynamic subtest: vcs0
[339.494391] Dynamic subtest vcs0: SUCCESS (6.974s)
[339.505524] Starting dynamic subtest: vcs1
[346.532522] Dynamic subtest vcs1: SUCCESS (7.035s)
[346.544108] Starting dynamic subtest: vecs0
[353.508098] Dynamic subtest vecs0: SUCCESS (6.974s)
[353.517262] Starting dynamic subtest: ccs0
[367.343926] Dynamic subtest ccs0: SUCCESS (13.835s)
[367.346679] Subtest hang-wait: SUCCESS (68.472s)
[367.494495] [112/134] (654s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[367.601732] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[367.603961] Starting dynamic subtest: pipe-A
[367.664505] Dynamic subtest pipe-A: SUCCESS (0.064s)
[367.676131] Starting dynamic subtest: pipe-B
[368.840869] Dynamic subtest pipe-B: SUCCESS (1.175s)
[368.852463] Starting dynamic subtest: pipe-C
[369.948377] Dynamic subtest pipe-C: SUCCESS (1.106s)
[369.958471] Starting dynamic subtest: pipe-D
[371.084713] Dynamic subtest pipe-D: SUCCESS (1.136s)
[371.087125] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.485s)
[372.255636] [113/134] (650s left) kms_vblank (query-forked-busy)
[372.360649] Starting subtest: query-forked-busy
[372.362854] Starting dynamic subtest: pipe-A-eDP-1
[374.238625] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[374.254461] Starting dynamic subtest: pipe-D-eDP-1
[376.813440] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.572s)
[376.815754] Subtest query-forked-busy: SUCCESS (4.453s)
[377.627087] [114/134] (644s left) gem_reg_read (timestamp-monotonic)
[377.685435] Starting subtest: timestamp-monotonic
[382.640318] Subtest timestamp-monotonic: SUCCESS (4.955s)
[382.732502] [115/134] (639s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[382.844397] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[382.848740] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[382.977228] [116/134] (639s left) i915_pm_rpm (gem-execbuf)
[385.103439] Starting subtest: gem-execbuf
[385.106218] Starting dynamic subtest: smem0
[386.841219] Dynamic subtest smem0: SUCCESS (1.737s)
[386.843549] Subtest gem-execbuf: SUCCESS (1.740s)
[386.951258] [117/134] (635s left) gem_exec_whisper (basic-fds)
[387.022035] Starting subtest: basic-fds
[393.846038] Subtest basic-fds: SUCCESS (6.819s)
[394.043711] [118/134] (628s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[394.164285] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[394.190825] Starting dynamic subtest: pipe-A-plane-0
[394.623814] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[394.633400] Starting dynamic subtest: pipe-A-plane-3
[394.879469] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[394.889826] Starting dynamic subtest: pipe-A-plane-5
[394.894324] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[395.989777] Starting dynamic subtest: pipe-B-plane-0
[396.427542] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[396.439238] Starting dynamic subtest: pipe-B-plane-3
[396.705895] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s)
[396.715938] Starting dynamic subtest: pipe-B-plane-5
[396.720172] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[397.023188] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.859s)
[397.883423] [119/134] (624s left) gem_exec_balancer (parallel-bb-first)
[398.142637] Starting subtest: parallel-bb-first
[399.076182] Subtest parallel-bb-first: SUCCESS (0.933s)
[399.954606] [120/134] (622s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[400.052974] Starting subtest: 4-tiled-8bpp-rotate-90
[400.074615] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[400.235386] [121/134] (622s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[400.341711] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[400.346143] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[400.444980] [122/134] (622s left) kms_psr (pr-sprite-mmap-gtt)
[400.547205] Starting subtest: pr-sprite-mmap-gtt
[400.551182] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[400.668884] [123/134] (622s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[400.773084] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[401.552974] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.781s)
[401.752703] [124/134] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[401.852046] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[409.258163] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.408s)
[409.440914] [125/134] (613s left) kms_vblank (ts-continuation-modeset-rpm)
[409.541576] Starting subtest: ts-continuation-modeset-rpm
[409.543648] Starting dynamic subtest: pipe-A-eDP-1
[412.050711] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.510s)
[412.067372] Starting dynamic subtest: pipe-D-eDP-1
[414.317798] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.261s)
[414.319803] Subtest ts-continuation-modeset-rpm: SUCCESS (4.775s)
[415.126199] [126/134] (607s left) gem_mmap_gtt (basic-read)
[415.189641] Subtest basic-read: SKIP (0.000s)
[415.256107] [127/134] (607s left) gem_blits (basic)
[415.312204] Starting subtest: basic
[416.649748] Subtest basic: SUCCESS (1.337s)
[416.816518] [128/134] (606s left) kms_color (ctm-signed)
[416.911575] Starting subtest: ctm-signed
[416.913776] Starting dynamic subtest: pipe-A-eDP-1
[418.986511] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s)
[418.996523] Starting dynamic subtest: pipe-B-eDP-1
[421.869444] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.883s)
[421.879533] Starting dynamic subtest: pipe-C-eDP-1
[424.556676] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.687s)
[424.568440] Starting dynamic subtest: pipe-D-eDP-1
[427.212097] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.655s)
[427.214471] Subtest ctm-signed: SUCCESS (10.303s)
[428.051166] [129/134] (595s left) gem_eio (throttle)
[428.303440] Starting subtest: throttle
[428.649312] Subtest throttle: SUCCESS (0.346s)
[428.807748] [130/134] (594s left) syncobj_wait (invalid-signal-illegal-handle)
[428.853395] Starting subtest: invalid-signal-illegal-handle
[428.855335] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[428.963869] [131/134] (594s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[429.071449] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[429.074751] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[429.170932] [132/134] (594s left) kms_pm_backlight (fade-with-suspend)
[429.263178] Starting subtest: fade-with-suspend
[445.182077] Starting dynamic subtest: eDP-1
[447.847947] Dynamic subtest eDP-1: SUCCESS (2.665s)
[447.850142] Subtest fade-with-suspend: SUCCESS (3.879s)
[448.723628] [133/134] (574s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[453.803316] Starting subtest: psr2-overlay-plane-move-continuous-sf
[453.805473] Starting dynamic subtest: pipe-A-eDP-1
[460.493549] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.684s)
[460.504257] Starting dynamic subtest: pipe-B-eDP-1
[467.145076] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.646s)
[467.147268] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.335s)
[468.032615] [134/134] (555s left) perf (gen12-oa-tlb-invalidate)
[468.195095] Starting subtest: gen12-oa-tlb-invalidate
[468.196946] Starting dynamic subtest: 0-rcs0
[478.237717] Dynamic subtest 0-rcs0: SUCCESS (10.041s)
[478.248506] Starting dynamic subtest: 1-vcs0
[488.286748] Dynamic subtest 1-vcs0: SUCCESS (10.046s)
[488.289394] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.090s)
[488.326530] 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.