[58.798397] Initializing watchdogs
[58.798445]   /dev/watchdog0
[58.813574] [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.818061] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.820623] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.824377] [001/133] (960s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[58.908918] Starting subtest: invalid-multi-wait-unsubmitted
[58.911314] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[59.020783] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[59.121489] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[59.126072] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[59.198694] [003/133] (960s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[59.295282] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[59.297544] Starting dynamic subtest: pipe-A-eDP-1
[59.320947] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.330160] Starting dynamic subtest: pipe-B-eDP-1
[59.351977] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.359731] Starting dynamic subtest: pipe-C-eDP-1
[59.381709] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.390530] Starting dynamic subtest: pipe-D-eDP-1
[59.412335] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[59.416370] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[61.531836] [004/133] (957s left) gem_mmap_gtt (basic-small-copy-odd)
[61.584973] Subtest basic-small-copy-odd: SKIP (0.000s)
[61.672505] [005/133] (957s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[61.764111] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[61.768236] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[61.832141] [006/133] (957s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[61.928724] Starting subtest: yf-tiled-32bpp-rotate-180
[61.933028] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[62.047435] [007/133] (957s left) syncobj_timeline (single-wait-available-signaled)
[62.099741] Starting subtest: single-wait-available-signaled
[62.102084] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[62.186430] [008/133] (957s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[62.303782] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[71.817055] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.543s)
[72.705737] [009/133] (946s left) gem_softpin (softpin)
[72.852338] Starting subtest: softpin
[105.139052] Subtest softpin: SUCCESS (32.292s)
[105.239541] [010/133] (914s left) gem_mmap_wc (read)
[105.296076] Subtest read: SKIP (0.000s)
[105.351117] [011/133] (914s left) gem_flink_basic (basic)
[105.400725] Starting subtest: basic
[105.402600] Subtest basic: SUCCESS (0.000s)
[105.503062] [012/133] (914s left) gem_exec_params (invalid-bsd1-flag-on-render)
[105.562090] Starting subtest: invalid-bsd1-flag-on-render
[105.564404] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[105.688407] [013/133] (914s left) gem_mmap_gtt (cpuset-big-copy)
[105.739983] Subtest cpuset-big-copy: SKIP (0.000s)
[105.800600] [014/133] (914s left) perf_pmu (busy-idle-check-all)
[105.835666] Starting subtest: busy-idle-check-all
[105.837932] Starting dynamic subtest: rcs0
[106.493208] Dynamic subtest rcs0: SUCCESS (0.657s)
[106.503877] Starting dynamic subtest: bcs0
[107.148401] Dynamic subtest bcs0: SUCCESS (0.654s)
[107.160369] Starting dynamic subtest: vcs0
[108.296622] Dynamic subtest vcs0: SUCCESS (1.145s)
[108.307432] Starting dynamic subtest: vcs1
[110.281529] Dynamic subtest vcs1: SUCCESS (1.983s)
[110.296197] Starting dynamic subtest: vecs0
[112.330888] Dynamic subtest vecs0: SUCCESS (2.048s)
[112.343373] Starting dynamic subtest: ccs0
[112.988112] Dynamic subtest ccs0: SUCCESS (0.657s)
[112.991290] Subtest busy-idle-check-all: SUCCESS (7.152s)
[113.098612] [015/133] (906s left) gem_render_copy_redux (flink)
[113.149051] Starting subtest: flink
[114.250475] Subtest flink: SUCCESS (1.105s)
[114.374594] [016/133] (905s left) kms_psr (fbc-psr-primary-blt)
[114.468466] Starting subtest: fbc-psr-primary-blt
[114.470512] Starting dynamic subtest: eDP-1
[114.474182] Dynamic subtest eDP-1: SKIP (0.000s)
[114.477831] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[114.553760] [017/133] (905s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[114.655294] Starting subtest: fbc-rgb565-draw-mmap-cpu
[118.691819] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.041s)
[119.841605] [018/133] (900s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[119.938375] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[119.942761] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[120.030116] [019/133] (900s left) gem_ctx_param (invalid-size-get)
[120.084687] Starting subtest: invalid-size-get
[120.087081] Subtest invalid-size-get: SUCCESS (0.002s)
[120.197481] [020/133] (899s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[120.284821] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[127.076168] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.796s)
[127.255232] [021/133] (892s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[127.384705] Starting subtest: flip-vs-cursor-atomic
[134.903318] Subtest flip-vs-cursor-atomic: SUCCESS (7.518s)
[135.706209] [022/133] (884s left) kms_vblank (wait-busy-hang)
[135.796070] Starting subtest: wait-busy-hang
[135.798410] Starting dynamic subtest: pipe-A-eDP-1
[162.060777] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.263s)
[162.075570] Starting dynamic subtest: pipe-D-eDP-1
[187.089370] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[187.091399] Subtest wait-busy-hang: SUCCESS (51.295s)
[187.957818] [023/133] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[188.048105] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[188.052368] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[188.141416] [024/133] (832s left) i915_query (test-query-geometry-subslices)
[188.198763] Starting subtest: test-query-geometry-subslices
[188.201627] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[188.320962] [025/133] (831s left) kms_chamelium_frames (hdmi-frame-dump)
[188.711780] Subtest hdmi-frame-dump: SKIP (0.000s)
[189.568034] [026/133] (830s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[189.690645] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[191.084290] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.393s)
[191.964391] [027/133] (828s left) kms_psr (psr-dpms)
[192.056984] Starting subtest: psr-dpms
[192.059202] Starting dynamic subtest: eDP-1
[195.017745] Dynamic subtest eDP-1: SUCCESS (2.961s)
[195.020056] Subtest psr-dpms: SUCCESS (2.962s)
[195.877627] [028/133] (824s left) perf (buffer-fill)
[196.000703] Starting subtest: buffer-fill
[196.002833] Starting dynamic subtest: 0-rcs0
[198.255122] Dynamic subtest 0-rcs0: SUCCESS (2.253s)
[198.264589] Starting dynamic subtest: 1-vcs1
[202.702640] Dynamic subtest 1-vcs1: SUCCESS (4.447s)
[202.705102] Subtest buffer-fill: SUCCESS (6.701s)
[202.752333] [029/133] (817s left) kms_feature_discovery (display)
[202.850838] Starting subtest: display
[202.853064] Subtest display: SUCCESS (0.000s)
[202.934542] [030/133] (817s left) syncobj_wait (invalid-single-wait-unsubmitted)
[202.982984] Starting subtest: invalid-single-wait-unsubmitted
[202.985269] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[203.072773] [031/133] (817s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[203.119795] Starting subtest: multi-wait-for-submit-submitted-signaled
[203.122167] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[203.235662] [032/133] (817s left) gem_exec_reloc (basic-concurrent0)
[203.291677] Subtest basic-concurrent0: SKIP (0.000s)
[203.357362] [033/133] (817s left) core_getversion (all-cards)
[203.393299] Starting subtest: all-cards
[203.401178] Subtest all-cards: SUCCESS (0.010s)
[203.451893] [034/133] (817s left) gem_request_retire (retire-vma-not-inactive)
[203.506046] Starting subtest: retire-vma-not-inactive
[203.564992] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[203.690432] [035/133] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[203.779099] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[203.782633] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[203.891475] [036/133] (816s left) gem_exec_schedule (timeslicing)
[203.959750] Starting subtest: timeslicing
[203.961537] Starting dynamic subtest: rcs0
[203.975691] Dynamic subtest rcs0: SUCCESS (0.021s)
[203.985875] Starting dynamic subtest: bcs0
[203.995931] Dynamic subtest bcs0: SUCCESS (0.020s)
[204.010839] Starting dynamic subtest: vcs0
[204.015891] Dynamic subtest vcs0: SUCCESS (0.020s)
[204.024814] Starting dynamic subtest: vcs1
[204.035151] Dynamic subtest vcs1: SUCCESS (0.019s)
[204.046127] Starting dynamic subtest: vecs0
[204.055089] Dynamic subtest vecs0: SUCCESS (0.020s)
[204.067544] Starting dynamic subtest: ccs0
[204.073961] Dynamic subtest ccs0: SUCCESS (0.018s)
[204.076417] Subtest timeslicing: SUCCESS (0.120s)
[205.374482] [037/133] (815s left) kms_psr (pr-sprite-render)
[205.462366] Starting subtest: pr-sprite-render
[205.466669] Subtest pr-sprite-render: SKIP (0.000s)
[205.536952] [038/133] (815s left) kms_frontbuffer_tracking (basic)
[205.632111] Starting subtest: basic
[209.063693] Subtest basic: SUCCESS (3.435s)
[209.179922] [039/133] (811s left) prime_vgem (sync)
[209.317127] Starting subtest: sync
[209.319107] Starting dynamic subtest: rcs0
[209.358793] Dynamic subtest rcs0: SUCCESS (0.042s)
[209.367114] Starting dynamic subtest: bcs0
[209.429516] Dynamic subtest bcs0: SUCCESS (0.070s)
[209.437840] Starting dynamic subtest: vcs0
[209.477495] Dynamic subtest vcs0: SUCCESS (0.047s)
[209.485864] Starting dynamic subtest: vcs1
[209.522539] Dynamic subtest vcs1: SUCCESS (0.044s)
[209.530935] Starting dynamic subtest: vecs0
[209.570226] Dynamic subtest vecs0: SUCCESS (0.047s)
[209.578769] Starting dynamic subtest: ccs0
[209.618804] Dynamic subtest ccs0: SUCCESS (0.048s)
[209.620648] Subtest sync: SUCCESS (0.302s)
[209.753403] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[209.756524] [040/133] (811s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[209.886072] Starting subtest: cursorA-vs-flipA-atomic
[221.020235] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.134s)
[221.904120] [041/133] (799s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[222.008194] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[229.113594] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.110s)
[229.233980] [042/133] (791s left) prime_vgem (basic-gtt)
[229.317373] Starting subtest: basic-gtt
[229.322279] Subtest basic-gtt: SKIP (0.000s)
[229.415119] [043/133] (791s left) gem_ctx_persistence (hostile)
[229.483082] Starting subtest: hostile
[238.977784] Subtest hostile: SUCCESS (9.490s)
[239.123372] [044/133] (781s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[239.516763] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[240.334725] [045/133] (780s left) kms_frontbuffer_tracking (psr-1p-rte)
[240.427806] Starting subtest: psr-1p-rte
[245.892192] Subtest psr-1p-rte: SUCCESS (5.468s)
[246.028573] [046/133] (775s left) kms_psr (fbc-pr-primary-mmap-gtt)
[246.124948] Starting subtest: fbc-pr-primary-mmap-gtt
[246.129281] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[246.222466] [047/133] (775s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[246.352424] Starting subtest: cursorB-vs-flipB-atomic
[246.357029] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[246.511389] [048/133] (774s left) gem_eio (in-flight-internal-10ms)
[246.716878] Starting subtest: in-flight-internal-10ms
[248.401655] Subtest in-flight-internal-10ms: SUCCESS (1.683s)
[248.532106] [049/133] (772s left) kms_cursor_crc (cursor-offscreen-64x64)
[248.716731] Starting subtest: cursor-offscreen-64x64
[248.725023] Starting dynamic subtest: pipe-A-eDP-1
[250.656113] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[250.686607] Starting dynamic subtest: pipe-D-eDP-1
[253.305229] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.624s)
[253.307182] Subtest cursor-offscreen-64x64: SUCCESS (4.586s)
[254.149597] [050/133] (767s left) gen7_exec_parse (oacontrol-tracking)
[254.200614] Subtest oacontrol-tracking: SKIP (0.000s)
[254.267333] [051/133] (767s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[254.355788] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[254.358075] Starting dynamic subtest: pipe-A-default-mode
[255.506678] Dynamic subtest pipe-A-default-mode: SKIP (1.149s)
[255.511901] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.151s)
[255.655032] [052/133] (765s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[255.745479] Starting subtest: disable-crc-after-crtc
[255.747769] Starting dynamic subtest: pipe-A-eDP-1
[257.436571] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.692s)
[257.446556] Starting dynamic subtest: pipe-B-eDP-1
[259.802108] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.364s)
[259.812912] Starting dynamic subtest: pipe-C-eDP-1
[262.071851] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.266s)
[262.082302] Starting dynamic subtest: pipe-D-eDP-1
[264.297518] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.225s)
[264.299733] Subtest disable-crc-after-crtc: SUCCESS (8.552s)
[265.136175] [053/133] (756s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[265.231904] Starting subtest: primary-yf-tiled-reflect-x-0
[265.302451] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[265.407577] [054/133] (756s left) gem_ctx_persistence (engines-hang)
[265.464569] Starting subtest: engines-hang
[265.467388] Starting dynamic subtest: rcs0
[265.596289] Dynamic subtest rcs0: SUCCESS (0.131s)
[265.608656] Starting dynamic subtest: bcs0
[265.654924] Dynamic subtest bcs0: SUCCESS (0.057s)
[265.666874] Starting dynamic subtest: vcs0
[265.745347] Dynamic subtest vcs0: SUCCESS (0.088s)
[265.756824] Starting dynamic subtest: vcs1
[265.847091] Dynamic subtest vcs1: SUCCESS (0.100s)
[265.859253] Starting dynamic subtest: vecs0
[265.932998] Dynamic subtest vecs0: SUCCESS (0.084s)
[265.945992] Starting dynamic subtest: ccs0
[266.021077] Dynamic subtest ccs0: SUCCESS (0.086s)
[266.023600] Subtest engines-hang: SUCCESS (0.558s)
[266.118314] [055/133] (755s left) gem_eio (in-flight-1us)
[266.331116] Starting subtest: in-flight-1us
[275.047088] Subtest in-flight-1us: SUCCESS (8.715s)
[275.243655] [056/133] (746s left) gem_mmap_wc (pf-nonblock)
[275.302076] Subtest pf-nonblock: SKIP (0.000s)
[275.367040] [057/133] (746s left) kms_flip (plain-flip-fb-recreate-interruptible)
[275.471061] Starting subtest: plain-flip-fb-recreate-interruptible
[275.473528] Starting dynamic subtest: A-eDP1
[284.327864] Dynamic subtest A-eDP1: SUCCESS (8.857s)
[284.337679] Starting dynamic subtest: B-eDP1
[293.160669] Dynamic subtest B-eDP1: SUCCESS (8.831s)
[293.175953] Starting dynamic subtest: C-eDP1
[301.973092] Dynamic subtest C-eDP1: SUCCESS (8.810s)
[301.982554] Starting dynamic subtest: D-eDP1
[310.816935] Dynamic subtest D-eDP1: SUCCESS (8.843s)
[310.821467] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.350s)
[311.989517] [058/133] (709s left) gem_exec_reloc (basic-wc-gtt-active)
[312.056703] Subtest basic-wc-gtt-active: SKIP (0.000s)
[312.147236] [059/133] (709s left) kms_async_flips (async-flip-hang)
[312.235522] Starting subtest: async-flip-hang
[312.606485] Starting dynamic subtest: pipe-A-eDP-1
[327.778600] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.171s)
[328.169655] Starting dynamic subtest: pipe-B-eDP-1
[343.782780] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.619s)
[344.168399] Starting dynamic subtest: pipe-C-eDP-1
[359.844099] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.682s)
[360.218340] Starting dynamic subtest: pipe-D-eDP-1
[375.778998] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.565s)
[375.781760] Subtest async-flip-hang: SUCCESS (63.544s)
[377.032658] [060/133] (644s left) gem_exec_flush (basic-wb-set-default)
[377.091825] Starting subtest: basic-wb-set-default
[382.548483] Subtest basic-wb-set-default: SUCCESS (5.457s)
[382.736401] [061/133] (639s left) kms_cursor_edge_walk (128x128-top-edge)
[382.850591] Starting subtest: 128x128-top-edge
[382.852966] Starting dynamic subtest: pipe-A-eDP-1
[386.272696] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[386.285682] Starting dynamic subtest: pipe-D-eDP-1
[389.405068] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[389.407284] Subtest 128x128-top-edge: SUCCESS (6.556s)
[390.205491] [062/133] (631s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[390.304388] Starting subtest: x-tiled-8bpp-rotate-180
[391.562451] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.258s)
[391.702368] [063/133] (630s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[391.801882] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[391.805362] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[391.931445] [064/133] (630s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[392.029547] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[392.031497] Starting dynamic subtest: pipe-A-eDP-1
[392.050579] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[392.060971] Starting dynamic subtest: pipe-B-eDP-1
[392.078901] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[392.088117] Starting dynamic subtest: pipe-C-eDP-1
[392.106360] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[392.115306] Starting dynamic subtest: pipe-D-eDP-1
[392.133314] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[392.136833] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[394.268469] [065/133] (627s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[394.365536] Starting subtest: 4-tiled-32bpp-rotate-180
[395.859381] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.491s)
[395.979047] [066/133] (626s left) gem_exec_fence (syncobj-channel)
[396.408744] Starting subtest: syncobj-channel
[397.428570] Subtest syncobj-channel: SUCCESS (1.016s)
[398.339582] [067/133] (623s left) kms_mmap_write_crc (main)
[398.440650] Starting subtest: main
[398.442901] Starting dynamic subtest: pipe-A-eDP-1
[402.036411] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.593s)
[402.038939] Subtest main: SUCCESS (3.594s)
[402.892826] [068/133] (619s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[402.999702] Starting subtest: y-tiled-32bpp-rotate-180
[403.004331] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[403.090654] [069/133] (619s left) kms_pm_rpm (fences-dpms)
[404.614967] Starting subtest: fences-dpms
[404.620246] Subtest fences-dpms: SKIP (0.000s)
[405.335988] [070/133] (616s left) gem_ctx_param (set-priority-range)
[405.397281] Starting subtest: set-priority-range
[405.412266] Subtest set-priority-range: SUCCESS (0.018s)
[405.517594] [071/133] (616s left) api_intel_allocator (alloc-simple)
[405.571731] Starting subtest: alloc-simple
[405.576576] Subtest alloc-simple: SUCCESS (0.004s)
[405.681646] [072/133] (616s left) gem_exec_schedule (preempt-other-chain)
[405.758714] Starting subtest: preempt-other-chain
[405.760718] Starting dynamic subtest: rcs0
[405.837821] Dynamic subtest rcs0: SUCCESS (0.086s)
[405.859099] Starting dynamic subtest: bcs0
[405.921406] Dynamic subtest bcs0: SUCCESS (0.083s)
[405.931937] Starting dynamic subtest: vcs0
[406.006592] Dynamic subtest vcs0: SUCCESS (0.085s)
[406.016669] Starting dynamic subtest: vcs1
[406.087916] Dynamic subtest vcs1: SUCCESS (0.080s)
[406.102357] Starting dynamic subtest: vecs0
[406.176757] Dynamic subtest vecs0: SUCCESS (0.087s)
[406.191215] Starting dynamic subtest: ccs0
[406.256908] Dynamic subtest ccs0: SUCCESS (0.081s)
[406.259216] Subtest preempt-other-chain: SUCCESS (0.506s)
[407.403602] [073/133] (614s left) kms_addfb_basic (too-wide)
[407.497963] Starting subtest: too-wide
[407.500241] Subtest too-wide: SUCCESS (0.000s)
[407.593703] [074/133] (614s left) gem_userptr_blits (set-cache-level)
[407.651581] Starting subtest: set-cache-level
[407.656062] Subtest set-cache-level: SKIP (0.000s)
[407.762830] [075/133] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[407.860661] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[407.864967] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[407.963408] [076/133] (614s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[408.050426] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[408.052743] Starting dynamic subtest: pipe-A-eDP-1
[408.062336] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.074229] Starting dynamic subtest: pipe-B-eDP-1
[408.083390] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.093496] Starting dynamic subtest: pipe-C-eDP-1
[408.102211] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.111997] Starting dynamic subtest: pipe-D-eDP-1
[408.120896] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.125220] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[410.301275] [077/133] (612s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[410.399440] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[410.411715] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[410.486954] [078/133] (612s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[410.578351] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[410.603946] Starting dynamic subtest: pipe-A-plane-0
[411.236754] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[411.249465] Starting dynamic subtest: pipe-A-plane-3
[411.692239] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[412.791338] Starting dynamic subtest: pipe-B-plane-0
[413.427751] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[413.437536] Starting dynamic subtest: pipe-B-plane-3
[413.872128] Dynamic subtest pipe-B-plane-3: SUCCESS (0.442s)
[414.195266] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.618s)
[415.068451] [079/133] (607s left) gem_exec_params (rsvd2-dirt)
[415.131188] Starting subtest: rsvd2-dirt
[415.135766] Subtest rsvd2-dirt: SKIP (0.000s)
[415.251617] [080/133] (607s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[415.349546] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[415.351989] Starting dynamic subtest: pipe-A-eDP-1
[415.894554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.516s)
[415.906576] Starting dynamic subtest: pipe-B-eDP-1
[417.361587] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[417.372699] Starting dynamic subtest: pipe-C-eDP-1
[418.840082] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.479s)
[418.852101] Starting dynamic subtest: pipe-D-eDP-1
[420.278776] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.438s)
[420.281154] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.903s)
[421.498089] [081/133] (601s left) kms_big_fb (linear-16bpp-rotate-90)
[421.590897] Starting subtest: linear-16bpp-rotate-90
[421.610534] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[421.727085] [082/133] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[421.827655] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[429.226672] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.403s)
[429.361234] [083/133] (593s left) kms_chamelium_audio (dp-audio)
[429.744580] Subtest dp-audio: SKIP (0.000s)
[430.539858] [084/133] (592s left) gem_bad_reloc (negative-reloc-lut)
[430.596136] Subtest negative-reloc-lut: SKIP (0.000s)
[430.677756] [085/133] (592s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[430.780172] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[430.784987] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[430.864528] [086/133] (592s left) i915_hangman (detector)
[430.933078] Starting subtest: detector
[430.935241] Starting dynamic subtest: rcs0
[442.280059] Dynamic subtest rcs0: SUCCESS (11.345s)
[442.294688] Starting dynamic subtest: bcs0
[454.249337] Dynamic subtest bcs0: SUCCESS (11.966s)
[454.262153] Starting dynamic subtest: vcs0
[466.279555] Dynamic subtest vcs0: SUCCESS (12.027s)
[466.292325] Starting dynamic subtest: vcs1
[478.249504] Dynamic subtest vcs1: SUCCESS (11.966s)
[478.261792] Starting dynamic subtest: vecs0
[490.215491] Dynamic subtest vecs0: SUCCESS (11.963s)
[490.228267] Starting dynamic subtest: ccs0
[501.287938] Dynamic subtest ccs0: SUCCESS (11.070s)
[501.291230] Subtest detector: SUCCESS (70.356s)
[501.423206] [087/133] (521s left) sysfs_heartbeat_interval (mixed)
[501.487855] Starting subtest: mixed
[501.489711] Starting dynamic subtest: vecs0
[506.710213] Dynamic subtest vecs0: SUCCESS (5.224s)
[506.722952] Starting dynamic subtest: ccs0
[511.919332] Dynamic subtest ccs0: SUCCESS (5.206s)
[511.932600] Starting dynamic subtest: vcs0
[517.131149] Dynamic subtest vcs0: SUCCESS (5.210s)
[517.143616] Starting dynamic subtest: bcs0
[522.340846] Dynamic subtest bcs0: SUCCESS (5.207s)
[522.353959] Starting dynamic subtest: rcs0
[527.575703] Dynamic subtest rcs0: SUCCESS (5.234s)
[527.587552] Starting dynamic subtest: vcs1
[532.789466] Dynamic subtest vcs1: SUCCESS (5.212s)
[532.792245] Subtest mixed: SUCCESS (31.305s)
[532.867396] [088/133] (490s left) kms_universal_plane (universal-plane-pageflip-windowed)
[532.977878] Starting subtest: universal-plane-pageflip-windowed
[532.979743] Starting dynamic subtest: pipe-A-eDP-1
[533.571667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[533.582671] Starting dynamic subtest: pipe-B-eDP-1
[534.773437] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s)
[534.784498] Starting dynamic subtest: pipe-C-eDP-1
[535.983064] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[535.993422] Starting dynamic subtest: pipe-D-eDP-1
[537.216966] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[537.219270] Subtest universal-plane-pageflip-windowed: SUCCESS (4.239s)
[538.070655] [089/133] (484s left) kms_dp_link_training (uhbr-sst)
[538.165452] Starting subtest: uhbr-sst
[538.174358] Subtest uhbr-sst: SKIP (0.000s)
[538.241242] [090/133] (484s left) gem_exec_balancer (bonded-pair)
[538.297342] Starting subtest: bonded-pair
[538.301761] Subtest bonded-pair: SKIP (0.000s)
[538.603985] [091/133] (484s left) gem_exec_fence (invalid-fence-array)
[539.048688] Starting subtest: invalid-fence-array
[539.054124] Subtest invalid-fence-array: SUCCESS (0.003s)
[540.386168] [092/133] (482s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[540.481610] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[540.485988] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[540.589646] [093/133] (482s left) kms_psr (psr-cursor-plane-onoff)
[540.686412] Starting subtest: psr-cursor-plane-onoff
[540.688599] Starting dynamic subtest: eDP-1
[542.372306] Dynamic subtest eDP-1: SUCCESS (1.685s)
[542.374578] Subtest psr-cursor-plane-onoff: SUCCESS (1.686s)
[543.263465] [094/133] (479s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[543.365902] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[543.370045] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[543.477199] [095/133] (479s left) kms_busy (basic)
[543.570968] Starting subtest: basic
[543.573162] Starting dynamic subtest: flip
[544.166167] Dynamic subtest flip: SUCCESS (0.593s)
[544.176859] Starting dynamic subtest: modeset
[547.570727] Dynamic subtest modeset: SUCCESS (3.404s)
[547.572952] Subtest basic: SUCCESS (4.000s)
[548.377600] [096/133] (474s left) gem_exec_async (forked-writes)
[548.440738] Starting subtest: forked-writes
[548.443274] Starting dynamic subtest: rcs0
[548.471713] Dynamic subtest rcs0: SUCCESS (0.031s)
[548.483104] Starting dynamic subtest: bcs0
[548.495293] Dynamic subtest bcs0: SUCCESS (0.023s)
[548.505783] Starting dynamic subtest: vcs0
[548.518311] Dynamic subtest vcs0: SUCCESS (0.022s)
[548.529303] Starting dynamic subtest: vcs1
[548.541333] Dynamic subtest vcs1: SUCCESS (0.022s)
[548.552735] Starting dynamic subtest: vecs0
[548.564353] Dynamic subtest vecs0: SUCCESS (0.022s)
[548.574638] Starting dynamic subtest: ccs0
[548.588093] Dynamic subtest ccs0: SUCCESS (0.023s)
[548.590403] Subtest forked-writes: SUCCESS (0.148s)
[548.825690] [097/133] (474s left) prime_vgem (coherency-gtt)
[548.897408] Starting subtest: coherency-gtt
[548.901770] Subtest coherency-gtt: SKIP (0.000s)
[549.004311] [098/133] (474s left) kms_properties (colorop-properties-legacy)
[549.099032] Starting subtest: colorop-properties-legacy
[549.101289] Starting dynamic subtest: pipe-A-eDP-1
[549.465097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[549.475607] Starting dynamic subtest: pipe-B-eDP-1
[550.533889] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.066s)
[550.544549] Starting dynamic subtest: pipe-C-eDP-1
[551.580321] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.045s)
[551.590797] Starting dynamic subtest: pipe-D-eDP-1
[552.603184] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.022s)
[552.605431] Subtest colorop-properties-legacy: SUCCESS (3.507s)
[553.402906] [099/133] (470s left) gem_mmap_wc (set-cache-level)
[553.463348] Subtest set-cache-level: SKIP (0.000s)
[553.525601] [100/133] (469s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[553.627671] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[560.571244] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.944s)
[560.712938] [101/133] (462s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[560.808490] Starting subtest: fbc-psr2-primary-mmap-cpu
[560.810697] Starting dynamic subtest: eDP-1
[560.815154] Dynamic subtest eDP-1: SKIP (0.000s)
[560.819416] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[560.884741] [102/133] (462s left) syncobj_timeline (32bits-limit)
[560.951496] Starting subtest: 32bits-limit
[560.953840] Subtest 32bits-limit: SUCCESS (0.002s)
[561.053436] [103/133] (462s left) perf_pmu (busy-accuracy-98)
[561.091650] Starting subtest: busy-accuracy-98
[561.093982] Starting dynamic subtest: rcs0
[564.130798] Dynamic subtest rcs0: SUCCESS (3.038s)
[564.144080] Starting dynamic subtest: bcs0
[567.188342] Dynamic subtest bcs0: SUCCESS (3.054s)
[567.200380] Starting dynamic subtest: vcs0
[570.229500] Dynamic subtest vcs0: SUCCESS (3.039s)
[570.241687] Starting dynamic subtest: vcs1
[573.276524] Dynamic subtest vcs1: SUCCESS (3.045s)
[573.290464] Starting dynamic subtest: vecs0
[576.320353] Dynamic subtest vecs0: SUCCESS (3.042s)
[576.330801] Starting dynamic subtest: ccs0
[579.374799] Dynamic subtest ccs0: SUCCESS (3.051s)
[579.377732] Subtest busy-accuracy-98: SUCCESS (18.282s)
[579.501939] [104/133] (444s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[579.608684] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[579.611098] Starting dynamic subtest: pipe-A
[579.632547] Dynamic subtest pipe-A: SKIP (0.020s)
[579.642765] Starting dynamic subtest: pipe-B
[579.668600] Dynamic subtest pipe-B: SKIP (0.035s)
[579.678717] Starting dynamic subtest: pipe-C
[579.702166] Dynamic subtest pipe-C: SKIP (0.035s)
[579.712361] Starting dynamic subtest: pipe-D
[579.739499] Dynamic subtest pipe-D: SKIP (0.034s)
[579.743814] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.127s)
[579.852993] [105/133] (443s left) gem_exec_whisper (basic-normal-all)
[579.922548] Starting subtest: basic-normal-all
[583.305568] Subtest basic-normal-all: SUCCESS (3.380s)
[583.492903] [106/133] (440s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[583.620424] Starting subtest: verify-pxp-execution-after-suspend-resume
[591.619315] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.998s)
[591.766049] [107/133] (432s left) gem_exec_reloc (basic-range-active)
[591.835714] Subtest basic-range-active: SKIP (0.000s)
[591.908071] [108/133] (431s left) kms_content_protection (dp-mst-type-1)
[592.056483] Starting subtest: dp-mst-type-1
[592.061227] Subtest dp-mst-type-1: SKIP (0.000s)
[592.188947] [109/133] (431s left) kms_invalid_mode (bad-htotal)
[592.281540] Starting subtest: bad-htotal
[592.283731] Starting dynamic subtest: pipe-A-eDP-1
[592.570062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[592.581105] Starting dynamic subtest: pipe-B-eDP-1
[592.583074] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[592.593581] Starting dynamic subtest: pipe-C-eDP-1
[592.595884] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[592.606336] Starting dynamic subtest: pipe-D-eDP-1
[592.608716] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[592.611072] Subtest bad-htotal: SUCCESS (0.296s)
[593.384664] [110/133] (430s left) gem_userptr_blits (unsync-unmap-after-close)
[593.454603] Subtest unsync-unmap-after-close: SKIP (0.000s)
[593.576911] [111/133] (430s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[593.672844] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[593.677029] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[593.793220] [112/133] (430s left) gem_exec_whisper (basic-queues-priority)
[593.856940] Starting subtest: basic-queues-priority
[618.297265] Subtest basic-queues-priority: SUCCESS (24.437s)
[618.498711] [113/133] (405s left) kms_flip (2x-flip-vs-suspend)
[618.599182] Starting subtest: 2x-flip-vs-suspend
[618.603152] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[618.722370] [114/133] (405s left) gem_ctx_engines (execute-one)
[618.795671] Starting subtest: execute-one
[621.257055] Subtest execute-one: SUCCESS (2.462s)
[621.454532] [115/133] (402s left) kms_color_pipeline (plane-ctm3x4)
[621.563448] Starting subtest: plane-ctm3x4
[621.721609] Starting dynamic subtest: pipe-A-plane-0
[621.877635] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[621.889101] Starting dynamic subtest: pipe-A-plane-1
[622.033419] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[622.044543] Starting dynamic subtest: pipe-A-plane-2
[622.188613] Dynamic subtest pipe-A-plane-2: SUCCESS (0.154s)
[623.405959] Starting dynamic subtest: pipe-B-plane-0
[623.561592] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[623.573252] Starting dynamic subtest: pipe-B-plane-1
[623.728026] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[623.739875] Starting dynamic subtest: pipe-B-plane-2
[623.883726] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[625.146212] Starting dynamic subtest: pipe-C-plane-0
[625.270825] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[625.282917] Starting dynamic subtest: pipe-C-plane-1
[625.403627] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[625.414990] Starting dynamic subtest: pipe-C-plane-2
[625.536247] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[626.772921] Starting dynamic subtest: pipe-D-plane-0
[626.895921] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[626.907977] Starting dynamic subtest: pipe-D-plane-1
[627.029372] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[627.040638] Starting dynamic subtest: pipe-D-plane-2
[627.162831] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[627.449648] Subtest plane-ctm3x4: SUCCESS (5.886s)
[628.334977] [116/133] (395s left) kms_plane (plane-position-hole-dpms)
[628.435600] Starting subtest: plane-position-hole-dpms
[628.959193] Starting dynamic subtest: pipe-A-plane-1
[631.340446] Dynamic subtest pipe-A-plane-1: SUCCESS (2.383s)
[631.351292] Starting dynamic subtest: pipe-A-plane-2
[633.805368] Dynamic subtest pipe-A-plane-2: SUCCESS (2.463s)
[633.816811] Starting dynamic subtest: pipe-A-plane-3
[636.237034] Dynamic subtest pipe-A-plane-3: SUCCESS (2.431s)
[636.248227] Starting dynamic subtest: pipe-A-plane-4
[638.600402] Dynamic subtest pipe-A-plane-4: SUCCESS (2.364s)
[638.612260] Starting dynamic subtest: pipe-A-plane-5
[638.626262] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[639.794522] Starting dynamic subtest: pipe-B-plane-1
[642.232248] Dynamic subtest pipe-B-plane-1: SUCCESS (2.450s)
[642.243974] Starting dynamic subtest: pipe-B-plane-2
[644.689948] Dynamic subtest pipe-B-plane-2: SUCCESS (2.456s)
[644.701936] Starting dynamic subtest: pipe-B-plane-3
[647.035238] Dynamic subtest pipe-B-plane-3: SUCCESS (2.345s)
[647.048025] Starting dynamic subtest: pipe-B-plane-4
[649.399492] Dynamic subtest pipe-B-plane-4: SUCCESS (2.361s)
[649.410764] Starting dynamic subtest: pipe-B-plane-5
[649.426100] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[649.428472] Subtest plane-position-hole-dpms: SUCCESS (20.990s)
[650.210893] [117/133] (373s left) kms_plane_cursor (primary)
[650.308090] Starting subtest: primary
[650.311972] Starting dynamic subtest: pipe-A-eDP-1-size-64
[653.006053] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.698s)
[653.033058] Starting dynamic subtest: pipe-A-eDP-1-size-128
[655.729504] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.706s)
[655.756351] Starting dynamic subtest: pipe-A-eDP-1-size-256
[658.453249] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.705s)
[658.775858] Starting dynamic subtest: pipe-B-eDP-1-size-64
[662.118651] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.356s)
[662.144969] Starting dynamic subtest: pipe-B-eDP-1-size-128
[664.808743] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.672s)
[664.836857] Starting dynamic subtest: pipe-B-eDP-1-size-256
[667.511152] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.683s)
[667.831609] Starting dynamic subtest: pipe-C-eDP-1-size-64
[670.925699] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.109s)
[670.954058] Starting dynamic subtest: pipe-C-eDP-1-size-128
[673.293339] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.348s)
[673.321388] Starting dynamic subtest: pipe-C-eDP-1-size-256
[675.670660] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.358s)
[675.990943] Starting dynamic subtest: pipe-D-eDP-1-size-64
[679.067963] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.091s)
[679.097064] Starting dynamic subtest: pipe-D-eDP-1-size-128
[681.456536] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.370s)
[681.484868] Starting dynamic subtest: pipe-D-eDP-1-size-256
[683.823263] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.348s)
[684.133522] Subtest primary: SUCCESS (33.825s)
[684.960195] [118/133] (339s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[685.066876] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[685.071408] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[685.161697] [119/133] (339s left) gen9_exec_parse (unaligned-access)
[685.224230] Subtest unaligned-access: SKIP (0.000s)
[685.346411] [120/133] (339s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[685.404460] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[685.408951] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[685.592635] [121/133] (338s left) kms_cursor_crc (cursor-random-64x64)
[685.763140] Starting subtest: cursor-random-64x64
[685.768378] Starting dynamic subtest: pipe-A-eDP-1
[689.144551] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.377s)
[689.179688] Starting dynamic subtest: pipe-D-eDP-1
[693.219920] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.049s)
[693.222547] Subtest cursor-random-64x64: SUCCESS (7.454s)
[694.080076] [122/133] (330s left) dumb_buffer (create-valid-dumb)
[694.131977] Starting subtest: create-valid-dumb
[694.134055] Subtest create-valid-dumb: SUCCESS (0.000s)
[694.225508] [123/133] (330s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[694.275891] Starting subtest: etime-multi-wait-all-submitted-signaled
[694.381366] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[694.472785] [124/133] (330s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[694.567773] Starting subtest: 4-tiled-16bpp-rotate-180
[695.903481] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.337s)
[696.069440] [125/133] (328s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[696.181474] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[696.185169] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[696.300632] [126/133] (328s left) i915_pm_rc6_residency (rc6-idle)
[696.409028] Starting subtest: rc6-idle
[696.430983] Starting dynamic subtest: gt0-rcs0
[720.712425] Dynamic subtest gt0-rcs0: SUCCESS (24.280s)
[720.723242] Starting dynamic subtest: gt0-bcs0
[745.015254] Dynamic subtest gt0-bcs0: SUCCESS (24.300s)
[745.025483] Starting dynamic subtest: gt0-ccs0
[769.307345] Dynamic subtest gt0-ccs0: SUCCESS (24.290s)
[769.321553] Starting dynamic subtest: gt1-vcs0
[775.481648] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[775.495689] Starting dynamic subtest: gt1-vecs0
[781.654080] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[781.657265] Subtest rc6-idle: SUCCESS (85.245s)
[781.755789] [127/133] (242s left) kms_pm_rpm (universal-planes-dpms)
[783.483949] Starting subtest: universal-planes-dpms
[783.486165] Starting dynamic subtest: plane-35
[791.815812] Dynamic subtest plane-35: SUCCESS (8.332s)
[791.829509] Starting dynamic subtest: plane-65
[800.133274] Dynamic subtest plane-65: SUCCESS (8.316s)
[800.145390] Starting dynamic subtest: plane-95
[808.731842] Dynamic subtest plane-95: SUCCESS (8.595s)
[808.745764] Starting dynamic subtest: plane-125
[817.354956] Dynamic subtest plane-125: SUCCESS (8.621s)
[817.368245] Starting dynamic subtest: plane-135
[825.705894] Dynamic subtest plane-135: SUCCESS (8.347s)
[825.720716] Starting dynamic subtest: plane-145
[834.121112] Dynamic subtest plane-145: SUCCESS (8.412s)
[834.123905] Subtest universal-planes-dpms: SUCCESS (50.640s)
[834.520896] [128/133] (190s left) gem_mmap_offset (bad-object)
[834.567583] Starting subtest: bad-object
[834.569577] Subtest bad-object: SUCCESS (0.001s)
[834.682270] [129/133] (190s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[834.771736] Starting subtest: fbc-modesetfrombusy
[838.557630] Subtest fbc-modesetfrombusy: SUCCESS (3.790s)
[839.739528] [130/133] (185s left) kms_properties (invalid-properties-legacy)
[839.825106] Starting subtest: invalid-properties-legacy
[839.932590] Subtest invalid-properties-legacy: SUCCESS (0.108s)
[840.008688] [131/133] (184s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[840.067254] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[840.069608] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[840.160319] [132/133] (184s left) gem_softpin (evict-single-offset)
[840.203497] Starting subtest: evict-single-offset
[868.298703] Subtest evict-single-offset: SUCCESS (28.091s)
[868.388223] [133/133] (156s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[868.542420] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[868.546739] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[868.631697] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: gem_flink_basic
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: gem_render_copy_redux
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_feature_discovery
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: core_getversion
results: parsing output: 33/ for test: gem_request_retire
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gen7_exec_parse
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_pipe_crc_basic
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_cursor_edge_walk
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_mmap_write_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_chamelium_audio
results: parsing output: 83/ for test: gem_bad_reloc
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: i915_hangman
results: parsing output: 86/ for test: sysfs_heartbeat_interval
results: parsing output: 87/ for test: kms_universal_plane
results: parsing output: 88/ for test: kms_dp_link_training
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_busy
results: parsing output: 95/ for test: gem_exec_async
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: kms_properties
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: kms_invalid_mode
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_ctx_engines
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: kms_plane_cursor
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: dumb_buffer
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.