[59.255879] Initializing watchdogs
[59.255927]   /dev/watchdog0
[59.270623] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.275308] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.277773] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.280804] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[59.390496] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[63.202237] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.812s)
[64.345731] [002/133] (955s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[64.410512] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[64.412871] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[64.585348] [003/133] (955s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[64.700280] Starting subtest: 2x-flip-vs-cursor-legacy
[64.703043] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[64.835113] [004/133] (955s left) gem_wait (wait)
[64.903201] Starting subtest: wait
[64.904207] Starting dynamic subtest: all-engines
[66.911997] Dynamic subtest all-engines: SUCCESS (1.998s)
[66.921100] Starting dynamic subtest: rcs0
[67.953148] Dynamic subtest rcs0: SUCCESS (1.050s)
[67.962072] Starting dynamic subtest: bcs0
[69.000328] Dynamic subtest bcs0: SUCCESS (1.046s)
[69.008939] Starting dynamic subtest: vcs0
[70.045301] Dynamic subtest vcs0: SUCCESS (1.043s)
[70.054076] Starting dynamic subtest: vcs1
[71.090222] Dynamic subtest vcs1: SUCCESS (1.044s)
[71.098532] Starting dynamic subtest: vecs0
[72.134243] Dynamic subtest vecs0: SUCCESS (1.043s)
[72.143123] Starting dynamic subtest: ccs0
[73.181291] Dynamic subtest ccs0: SUCCESS (1.046s)
[73.182472] Subtest wait: SUCCESS (8.279s)
[73.382681] [005/133] (946s left) kms_vrr (flip-suspend)
[73.474888] Starting subtest: flip-suspend
[73.477563] Subtest flip-suspend: SKIP (0.000s)
[73.554826] [006/133] (946s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[73.658330] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[80.790856] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.133s)
[80.960981] [007/133] (939s left) kms_chamelium_color (ctm-limited-range)
[81.066252] Subtest ctm-limited-range: SKIP (0.000s)
[81.102059] [008/133] (938s left) prime_vgem (basic-fence-read)
[81.174414] Starting subtest: basic-fence-read
[81.179774] Subtest basic-fence-read: SKIP (0.005s)
[81.273192] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[81.274734] [009/133] (938s left) gem_exec_params (invalid-bsd1-flag-on-render)
[81.324560] Starting subtest: invalid-bsd1-flag-on-render
[81.325476] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[81.418282] [010/133] (938s left) kms_psr (fbc-psr-primary-page-flip)
[81.504347] Starting subtest: fbc-psr-primary-page-flip
[81.505243] Starting dynamic subtest: eDP-1
[81.506864] Dynamic subtest eDP-1: SKIP (0.000s)
[81.508572] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[81.571075] [011/133] (938s left) kms_dp_link_training (non-uhbr-sst)
[81.665207] Starting subtest: non-uhbr-sst
[81.668931] Subtest non-uhbr-sst: SKIP (0.000s)
[81.734229] [012/133] (938s left) prime_busy (hang)
[81.798388] Starting subtest: hang
[81.799548] Starting dynamic subtest: rcs0
[107.442350] Dynamic subtest rcs0: SUCCESS (25.639s)
[107.450474] Starting dynamic subtest: bcs0
[114.528766] Dynamic subtest bcs0: SUCCESS (7.087s)
[114.535642] Starting dynamic subtest: vcs0
[121.567458] Dynamic subtest vcs0: SUCCESS (7.038s)
[121.575468] Starting dynamic subtest: vcs1
[128.550170] Dynamic subtest vcs1: SUCCESS (6.983s)
[128.559312] Starting dynamic subtest: vecs0
[135.581517] Dynamic subtest vecs0: SUCCESS (7.031s)
[135.588478] Starting dynamic subtest: ccs0
[149.422335] Dynamic subtest ccs0: SUCCESS (13.839s)
[149.423576] Subtest hang: SUCCESS (67.621s)
[149.539580] [013/133] (870s left) gem_workarounds (reset-context)
[149.599752] Starting subtest: reset-context
[149.754973] Subtest reset-context: SUCCESS (0.155s)
[149.883343] [014/133] (870s left) syncobj_wait (wait-any-snapshot)
[149.931036] Starting subtest: wait-any-snapshot
[150.014195] Subtest wait-any-snapshot: SUCCESS (0.082s)
[150.086833] [015/133] (870s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[150.179035] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[150.179859] Starting dynamic subtest: pipe-A-eDP-1
[150.242761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[150.544847] Starting dynamic subtest: pipe-B-eDP-1
[151.355386] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.816s)
[151.654830] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.475s)
[152.522614] [016/133] (867s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[152.615889] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[152.617735] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[152.692693] [017/133] (867s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[152.782256] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[152.783245] Starting dynamic subtest: pipe-A-eDP-1
[186.580644] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.850s)
[186.588669] Starting dynamic subtest: pipe-B-eDP-1
[221.518952] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.474s)
[221.526233] Starting dynamic subtest: pipe-C-eDP-1
[256.507592] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.451s)
[256.515978] Starting dynamic subtest: pipe-D-eDP-1
[291.477557] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.406s)
[291.478442] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.187s)
[297.705416] [018/133] (727s left) kms_psr (psr-cursor-mmap-gtt)
[297.822847] Starting subtest: psr-cursor-mmap-gtt
[297.823735] Starting dynamic subtest: eDP-1
[299.546593] Dynamic subtest eDP-1: SUCCESS (1.722s)
[299.547365] Subtest psr-cursor-mmap-gtt: SUCCESS (1.723s)
[300.397629] [019/133] (725s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[300.485089] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[300.486998] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[300.553508] [020/133] (724s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[300.599070] Starting subtest: single-wait-for-submit-unsubmitted
[300.703606] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[300.773276] [021/133] (724s left) kms_chamelium_hpd (vga-hpd)
[301.139601] Subtest vga-hpd: SKIP (0.000s)
[301.915301] [022/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[302.005013] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[302.006632] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[302.107833] [023/133] (723s left) gem_exec_params (invalid-bsd-ring)
[302.161285] Starting subtest: invalid-bsd-ring
[302.162276] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[302.260118] [024/133] (723s left) kms_hdmi_inject (inject-audio)
[302.608002] Starting subtest: inject-audio
[302.885593] Subtest inject-audio: SUCCESS (0.279s)
[303.508161] [025/133] (722s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[303.586571] Starting subtest: primary-y-tiled-reflect-x-90
[303.588460] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[303.658766] [026/133] (722s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[303.755153] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[303.756068] Starting dynamic subtest: pipe-A-default-mode
[306.467858] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[306.468685] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.713s)
[307.283060] [027/133] (718s left) kms_force_connector_basic (force-load-detect)
[307.354520] Starting subtest: force-load-detect
[307.356862] Subtest force-load-detect: SKIP (0.000s)
[307.470711] [028/133] (718s left) gem_exec_fence (syncobj-timeline-chain-engines)
[308.012226] Starting subtest: syncobj-timeline-chain-engines
[308.132125] Subtest syncobj-timeline-chain-engines: SUCCESS (0.119s)
[309.520528] [029/133] (716s left) gem_partial_pwrite_pread (reads-snoop)
[309.590232] Subtest reads-snoop: SKIP (0.000s)
[309.667019] [030/133] (716s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[309.751099] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[314.180286] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.429s)
[315.378991] [031/133] (710s left) kms_psr (pr-sprite-plane-onoff)
[315.466063] Starting subtest: pr-sprite-plane-onoff
[315.467713] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[315.534787] [032/133] (710s left) perf (non-system-wide-paranoid)
[315.652737] Starting subtest: non-system-wide-paranoid
[315.678847] Subtest non-system-wide-paranoid: SUCCESS (0.026s)
[315.723692] [033/133] (710s left) kms_plane_alpha_blend (alpha-transparent-fb)
[315.816796] Starting subtest: alpha-transparent-fb
[316.107128] Starting dynamic subtest: pipe-A-eDP-1
[316.713319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[316.723833] Starting dynamic subtest: pipe-D-eDP-1
[318.131618] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.417s)
[318.132918] Subtest alpha-transparent-fb: SUCCESS (2.315s)
[318.981653] [034/133] (706s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[319.077132] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[319.079040] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[319.163761] [035/133] (706s left) kms_big_fb (linear-64bpp-rotate-0)
[319.280259] Starting subtest: linear-64bpp-rotate-0
[321.039783] Subtest linear-64bpp-rotate-0: SUCCESS (1.760s)
[321.206759] [036/133] (704s left) kms_async_flips (async-flip-dpms)
[321.295539] Starting subtest: async-flip-dpms
[321.667320] Starting dynamic subtest: pipe-A-eDP-1
[325.532712] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.864s)
[325.924060] Starting dynamic subtest: pipe-B-eDP-1
[328.827737] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.910s)
[329.221699] Starting dynamic subtest: pipe-C-eDP-1
[332.119907] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.907s)
[332.496078] Starting dynamic subtest: pipe-D-eDP-1
[335.319713] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.830s)
[335.320472] Subtest async-flip-dpms: SUCCESS (14.026s)
[336.482740] [037/133] (689s left) gem_ctx_bad_destroy (invalid-ctx)
[336.538127] Starting subtest: invalid-ctx
[336.539067] Subtest invalid-ctx: SUCCESS (0.000s)
[336.605865] [038/133] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[336.700268] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[336.702003] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[336.788953] [039/133] (689s left) kms_vblank (query-forked-busy)
[336.871487] Starting subtest: query-forked-busy
[336.872894] Starting dynamic subtest: pipe-A-eDP-1
[338.746286] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[338.755403] Starting dynamic subtest: pipe-D-eDP-1
[341.314038] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.566s)
[341.315018] Subtest query-forked-busy: SUCCESS (4.445s)
[342.168951] [040/133] (684s left) gem_spin_batch (spin-all)
[342.230203] Starting subtest: spin-all
[342.243567] Subtest spin-all: SUCCESS (0.013s)
[343.458021] [041/133] (682s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[343.547540] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[343.549214] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[343.626270] [042/133] (682s left) kms_pm_rpm (package-g7)
[345.543357] Starting subtest: package-g7
[345.545865] Subtest package-g7: SKIP (0.000s)
[345.913276] [043/133] (680s left) kms_force_connector_basic (force-connector-state)
[345.993085] Starting subtest: force-connector-state
[346.605767] Subtest force-connector-state: SUCCESS (0.613s)
[347.588243] [044/133] (678s left) kms_cursor_crc (cursor-onscreen-32x32)
[347.724058] Starting subtest: cursor-onscreen-32x32
[347.768523] Subtest cursor-onscreen-32x32: SKIP (0.042s)
[348.046065] [045/133] (678s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[348.133465] Starting subtest: yf-tiled-32bpp-rotate-0
[348.135168] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[348.222319] [046/133] (678s left) syncobj_eventfd (timeline-wait)
[348.266285] Starting subtest: timeline-wait
[348.276418] Subtest timeline-wait: SUCCESS (0.010s)
[348.370991] [047/133] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[348.460802] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[355.116324] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.656s)
[355.249959] [048/133] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[355.346374] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[362.205323] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.859s)
[362.335033] [049/133] (664s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[362.438234] Starting subtest: psr-rgb565-draw-mmap-cpu
[369.245854] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.809s)
[369.349160] [050/133] (657s left) gem_ctx_isolation (preservation-reset)
[369.521580] Starting subtest: preservation-reset
[369.522832] Starting dynamic subtest: rcs0
[369.798003] Dynamic subtest rcs0: SUCCESS (0.282s)
[369.805909] Starting dynamic subtest: bcs0
[370.118633] Dynamic subtest bcs0: SUCCESS (0.320s)
[370.127875] Starting dynamic subtest: vcs0
[370.440988] Dynamic subtest vcs0: SUCCESS (0.321s)
[370.448760] Starting dynamic subtest: vcs1
[371.730461] Dynamic subtest vcs1: SUCCESS (1.288s)
[371.739889] Starting dynamic subtest: vecs0
[373.726727] Dynamic subtest vecs0: SUCCESS (1.996s)
[373.734103] Starting dynamic subtest: ccs0
[375.732067] Dynamic subtest ccs0: SUCCESS (2.004s)
[375.733589] Subtest preservation-reset: SUCCESS (6.218s)
[375.861571] [051/133] (650s left) gem_mmap_wc (bad-size)
[375.905759] Subtest bad-size: SKIP (0.000s)
[375.965068] [052/133] (650s left) gem_ctx_persistence (idempotent)
[376.018371] Starting subtest: idempotent
[376.019239] Subtest idempotent: SUCCESS (0.000s)
[376.124062] [053/133] (650s left) kms_frontbuffer_tracking (fbc-stridechange)
[376.221148] Starting subtest: fbc-stridechange
[379.487144] Subtest fbc-stridechange: SUCCESS (3.266s)
[380.675816] [054/133] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[380.767204] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[380.768978] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[380.874886] [055/133] (645s left) api_intel_allocator (two-level-inception-interruptible)
[380.925482] Starting subtest: two-level-inception-interruptible
[386.375968] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[386.450093] [056/133] (640s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[386.555061] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[386.556939] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[386.656524] [057/133] (640s left) kms_psr (psr-sprite-mmap-gtt)
[386.748281] Starting subtest: psr-sprite-mmap-gtt
[386.749096] Starting dynamic subtest: eDP-1
[388.175457] Dynamic subtest eDP-1: SKIP (1.417s)
[388.177428] Subtest psr-sprite-mmap-gtt: SKIP (1.419s)
[388.325221] [058/133] (638s left) i915_pm_freq_api (freq-suspend)
[388.387666] Starting subtest: freq-suspend
[388.388735] Starting dynamic subtest: gt0
[405.254371] Dynamic subtest gt0: SUCCESS (7.678s)
[405.263305] Starting dynamic subtest: gt1
[422.332378] Dynamic subtest gt1: SUCCESS (1.629s)
[422.333192] Subtest freq-suspend: SUCCESS (9.312s)
[428.423162] [059/133] (604s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[428.513608] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[428.514979] Starting dynamic subtest: pipe-A-eDP-1
[428.526789] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[428.535103] Starting dynamic subtest: pipe-B-eDP-1
[428.545027] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[428.552929] Starting dynamic subtest: pipe-C-eDP-1
[428.561494] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[428.568553] Starting dynamic subtest: pipe-D-eDP-1
[428.577859] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[428.579566] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[430.773597] [060/133] (602s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[430.887398] Starting subtest: y-tiled-16bpp-rotate-90
[430.889827] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[430.975193] [061/133] (601s left) kms_psr (fbc-pr-sprite-blt)
[431.060862] Starting subtest: fbc-pr-sprite-blt
[431.063263] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[431.140387] [062/133] (601s left) kms_atomic_transition (plane-all-transition)
[431.220881] Starting subtest: plane-all-transition
[431.222259] Starting dynamic subtest: pipe-A-eDP-1
[433.719328] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[434.038613] Starting dynamic subtest: pipe-B-eDP-1
[437.259580] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.226s)
[437.557542] Subtest plane-all-transition: SUCCESS (6.333s)
[438.347671] [063/133] (594s left) core_auth (getclient-simple)
[438.380374] Starting subtest: getclient-simple
[438.400995] Subtest getclient-simple: SUCCESS (0.020s)
[438.501264] [064/133] (594s left) syncobj_timeline (etime-single-wait-submitted)
[438.547933] Starting subtest: etime-single-wait-submitted
[438.655830] Subtest etime-single-wait-submitted: SUCCESS (0.107s)
[438.739738] [065/133] (594s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[438.842390] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[438.844578] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[438.927388] [066/133] (594s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[439.024439] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[445.869904] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.844s)
[445.965393] [067/133] (587s left) kms_cursor_crc (cursor-random-128x42)
[446.198427] Starting subtest: cursor-random-128x42
[446.241996] Subtest cursor-random-128x42: SKIP (0.041s)
[446.449519] [068/133] (586s left) prime_self_import (basic-llseek-bad)
[446.480547] Starting subtest: basic-llseek-bad
[446.495018] Subtest basic-llseek-bad: SUCCESS (0.014s)
[446.582200] [069/133] (586s left) prime_mmap (test_forked_cpu_write)
[446.626443] Starting subtest: test_forked_cpu_write
[446.627635] Starting dynamic subtest: test_forked_cpu_write-smem
[446.634698] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[446.636177] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[446.726278] [070/133] (586s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[446.795839] Subtest writes-after-reads-snoop: SKIP (0.000s)
[446.861103] [071/133] (586s left) kms_cursor_crc (cursor-sliding-256x256)
[447.105637] Starting subtest: cursor-sliding-256x256
[447.108489] Starting dynamic subtest: pipe-A-eDP-1
[450.385385] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.275s)
[450.413850] Starting dynamic subtest: pipe-D-eDP-1
[454.406455] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.997s)
[454.407415] Subtest cursor-sliding-256x256: SUCCESS (7.298s)
[455.281316] [072/133] (578s left) gem_exec_suspend (basic-s0)
[455.345843] Starting subtest: basic-S0
[455.347428] Starting dynamic subtest: smem
[475.815678] Dynamic subtest smem: SUCCESS (6.656s)
[475.816936] Subtest basic-S0: SUCCESS (6.659s)
[482.010066] [073/133] (557s left) prime_mmap_coherency (ioctl-errors)
[482.070231] Starting subtest: ioctl-errors
[498.365827] Subtest ioctl-errors: SUCCESS (16.283s)
[498.507892] [074/133] (540s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[498.645261] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[498.647082] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[498.752048] [075/133] (540s left) gem_exec_schedule (noreorder-corked)
[498.932069] Starting subtest: noreorder-corked
[498.933373] Starting dynamic subtest: rcs0
[500.061288] Dynamic subtest rcs0: SUCCESS (1.131s)
[500.073460] Starting dynamic subtest: vcs0
[501.773135] Dynamic subtest vcs0: SUCCESS (1.699s)
[501.783830] Starting dynamic subtest: vcs1
[504.869618] Dynamic subtest vcs1: SUCCESS (3.093s)
[504.878511] Starting dynamic subtest: vecs0
[506.848625] Dynamic subtest vecs0: SUCCESS (1.976s)
[506.857477] Starting dynamic subtest: ccs0
[507.985286] Dynamic subtest ccs0: SUCCESS (1.143s)
[507.986608] Subtest noreorder-corked: SUCCESS (9.054s)
[508.170405] [076/133] (531s left) kms_plane_cursor (primary)
[508.261816] Starting subtest: primary
[508.263695] Starting dynamic subtest: pipe-A-eDP-1-size-64
[510.820546] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.558s)
[510.849285] Starting dynamic subtest: pipe-A-eDP-1-size-128
[513.399284] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[513.426578] Starting dynamic subtest: pipe-A-eDP-1-size-256
[515.956471] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[516.270421] Starting dynamic subtest: pipe-B-eDP-1-size-64
[519.520358] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.257s)
[519.547089] Starting dynamic subtest: pipe-B-eDP-1-size-128
[522.099485] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s)
[522.125452] Starting dynamic subtest: pipe-B-eDP-1-size-256
[524.712494] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.594s)
[525.025804] Starting dynamic subtest: pipe-C-eDP-1-size-64
[527.942725] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.924s)
[527.970210] Starting dynamic subtest: pipe-C-eDP-1-size-128
[530.153912] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s)
[530.181834] Starting dynamic subtest: pipe-C-eDP-1-size-256
[532.377342] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[532.706390] Starting dynamic subtest: pipe-D-eDP-1-size-64
[535.663789] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.964s)
[535.691510] Starting dynamic subtest: pipe-D-eDP-1-size-128
[537.942284] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.258s)
[537.971122] Starting dynamic subtest: pipe-D-eDP-1-size-256
[540.144011] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[540.449004] Subtest primary: SUCCESS (32.177s)
[541.270068] [077/133] (498s left) perf_pmu (busy-no-semaphores)
[541.309210] Starting subtest: busy-no-semaphores
[541.310250] Starting dynamic subtest: rcs0
[541.882932] Dynamic subtest rcs0: SUCCESS (0.563s)
[541.894041] Starting dynamic subtest: bcs0
[542.435086] Dynamic subtest bcs0: SUCCESS (0.548s)
[542.448597] Starting dynamic subtest: vcs0
[542.987084] Dynamic subtest vcs0: SUCCESS (0.549s)
[542.998028] Starting dynamic subtest: vcs1
[544.362349] Dynamic subtest vcs1: SUCCESS (1.372s)
[544.373168] Starting dynamic subtest: vecs0
[546.345690] Dynamic subtest vecs0: SUCCESS (1.980s)
[546.355849] Starting dynamic subtest: ccs0
[548.395604] Dynamic subtest ccs0: SUCCESS (2.046s)
[548.396911] Subtest busy-no-semaphores: SUCCESS (7.077s)
[548.498576] [078/133] (491s left) syncobj_timeline (single-wait-available-submitted)
[548.557210] Starting subtest: single-wait-available-submitted
[548.558100] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[548.662316] [079/133] (490s left) kms_chamelium_color (ctm-red-to-blue)
[548.755655] Subtest ctm-red-to-blue: SKIP (0.000s)
[548.795929] [080/133] (490s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[548.894807] Starting subtest: plane-lut1d-post-ctm3x4
[549.042672] Starting dynamic subtest: pipe-A-plane-0
[549.220218] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[549.229184] Starting dynamic subtest: pipe-A-plane-1
[549.386880] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[549.395615] Starting dynamic subtest: pipe-A-plane-2
[549.564999] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[550.755149] Starting dynamic subtest: pipe-B-plane-0
[550.911985] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[550.920896] Starting dynamic subtest: pipe-B-plane-1
[551.078878] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[551.089016] Starting dynamic subtest: pipe-B-plane-2
[551.245610] Dynamic subtest pipe-B-plane-2: SUCCESS (0.165s)
[552.446001] Starting dynamic subtest: pipe-C-plane-0
[552.604251] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[552.613249] Starting dynamic subtest: pipe-C-plane-1
[552.771190] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[552.780890] Starting dynamic subtest: pipe-C-plane-2
[552.926709] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[554.130568] Starting dynamic subtest: pipe-D-plane-0
[554.277528] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[554.286585] Starting dynamic subtest: pipe-D-plane-1
[554.444226] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[554.453013] Starting dynamic subtest: pipe-D-plane-2
[554.599720] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[554.897499] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.000s)
[555.782714] [081/133] (483s left) gem_reg_read (timestamp-monotonic)
[555.825149] Starting subtest: timestamp-monotonic
[560.398450] Subtest timestamp-monotonic: SUCCESS (4.561s)
[560.457438] [082/133] (479s left) kms_atomic (plane-overlay-legacy)
[560.550707] Starting subtest: plane-overlay-legacy
[560.551569] Starting dynamic subtest: pipe-A-eDP-1
[561.006052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[561.007011] Subtest plane-overlay-legacy: SUCCESS (0.455s)
[561.872779] [083/133] (477s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[561.963591] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[562.974710] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.012s)
[563.095912] [084/133] (476s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[563.191567] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[563.193361] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[563.287403] [085/133] (476s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[563.387965] Starting subtest: yf-tiled-32bpp-rotate-90
[563.389638] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[563.494294] [086/133] (476s left) gem_barrier_race (remote-request)
[563.561397] Starting subtest: remote-request
[563.562511] Starting dynamic subtest: rcs0
[568.732934] Dynamic subtest rcs0: SUCCESS (5.169s)
[568.734552] Subtest remote-request: SUCCESS (5.170s)
[568.885664] [087/133] (470s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[569.002515] Starting subtest: flip-vs-cursor-crc-atomic
[569.717943] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.715s)
[570.567434] [088/133] (469s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[570.657075] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[570.658049] Starting dynamic subtest: pipe-A
[570.721670] Dynamic subtest pipe-A: SUCCESS (0.066s)
[570.731272] Starting dynamic subtest: pipe-B
[571.869668] Dynamic subtest pipe-B: SUCCESS (1.146s)
[571.880352] Starting dynamic subtest: pipe-C
[572.974879] Dynamic subtest pipe-C: SUCCESS (1.104s)
[572.985009] Starting dynamic subtest: pipe-D
[574.051052] Dynamic subtest pipe-D: SUCCESS (1.075s)
[574.052003] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.395s)
[575.167146] [089/133] (464s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[575.257875] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[575.258788] Starting dynamic subtest: pipe-A-eDP-1
[575.266817] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[575.277345] Starting dynamic subtest: pipe-B-eDP-1
[575.293342] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[575.301531] Starting dynamic subtest: pipe-C-eDP-1
[575.309395] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[575.317402] Starting dynamic subtest: pipe-D-eDP-1
[575.325820] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[575.327409] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[577.476831] [090/133] (462s left) gen9_exec_parse (bb-start-param)
[577.539889] Subtest bb-start-param: SKIP (0.000s)
[577.612585] [091/133] (462s left) dmabuf_sync_file (export-before-signal)
[577.651588] Starting subtest: export-before-signal
[577.652552] Subtest export-before-signal: SUCCESS (0.000s)
[577.714986] [092/133] (462s left) kms_invalid_mode (zero-clock)
[577.806847] Starting subtest: zero-clock
[577.807757] Starting dynamic subtest: pipe-A-eDP-1
[578.093996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[578.102320] Starting dynamic subtest: pipe-B-eDP-1
[578.103154] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[578.111105] Starting dynamic subtest: pipe-C-eDP-1
[578.111966] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[578.120130] Starting dynamic subtest: pipe-D-eDP-1
[578.120978] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[578.121853] Subtest zero-clock: SUCCESS (0.293s)
[578.889475] [093/133] (461s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[581.014258] Starting subtest: dpms-mode-unset-lpsp
[585.071065] Subtest dpms-mode-unset-lpsp: SUCCESS (4.061s)
[585.438138] [094/133] (454s left) gem_media_vme
[585.561869] [095/133] (454s left) i915_drm_fdinfo (isolation)
[585.600295] Starting subtest: isolation
[585.601221] Starting dynamic subtest: rcs0
[585.618787] Dynamic subtest rcs0: SKIP (0.017s)
[585.633630] Starting dynamic subtest: bcs0
[585.636302] Dynamic subtest bcs0: SKIP (0.000s)
[585.652469] Starting dynamic subtest: vcs0
[585.654579] Dynamic subtest vcs0: SKIP (0.000s)
[585.665141] Starting dynamic subtest: vcs1
[585.667053] Dynamic subtest vcs1: SKIP (0.000s)
[585.675021] Starting dynamic subtest: vecs0
[585.676668] Dynamic subtest vecs0: SKIP (0.000s)
[585.684487] Starting dynamic subtest: ccs0
[585.686379] Dynamic subtest ccs0: SKIP (0.000s)
[585.688042] Subtest isolation: SKIP (0.023s)
[585.717961] [096/133] (454s left) gem_mmap_offset (perf)
[585.768127] Starting subtest: perf
[585.769012] Starting dynamic subtest: smem0
[586.122376] Dynamic subtest smem0: SUCCESS (0.353s)
[586.123892] Subtest perf: SUCCESS (0.354s)
[586.234115] [097/133] (453s left) i915_pm_rps (thresholds-idle-park)
[586.283782] Starting subtest: thresholds-idle-park
[586.285532] Subtest thresholds-idle-park: SKIP (0.001s)
[586.376128] [098/133] (453s left) sysfs_timeslice_duration (timeout)
[586.420046] Starting subtest: timeout
[586.421042] Starting dynamic subtest: vecs0
[595.870404] Dynamic subtest vecs0: SUCCESS (9.443s)
[595.881098] Starting dynamic subtest: ccs0
[597.176923] Dynamic subtest ccs0: SUCCESS (1.314s)
[597.186386] Starting dynamic subtest: vcs0
[606.885450] Dynamic subtest vcs0: SUCCESS (9.698s)
[606.895995] Starting dynamic subtest: bcs0
[607.488704] Dynamic subtest bcs0: SUCCESS (0.609s)
[607.502238] Starting dynamic subtest: rcs0
[608.718856] Dynamic subtest rcs0: SUCCESS (1.228s)
[608.730548] Starting dynamic subtest: vcs1
[617.886988] Dynamic subtest vcs1: SUCCESS (9.157s)
[617.888149] Subtest timeout: SUCCESS (31.463s)
[617.965699] [099/133] (422s left) gem_create (create-clear)
[618.035311] Starting subtest: create-clear
[618.036337] Starting dynamic subtest: smem0
[650.629508] Dynamic subtest smem0: SUCCESS (32.590s)
[650.630483] Subtest create-clear: SUCCESS (32.592s)
[650.836829] [100/133] (389s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[650.929922] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[655.519864] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.590s)
[656.671048] [101/133] (383s left) kms_frontbuffer_tracking (basic)
[656.760429] Starting subtest: basic
[660.182991] Subtest basic: SUCCESS (3.423s)
[660.293553] [102/133] (380s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[660.362508] Starting subtest: stress-mm-invalidate-close-overlap
[662.558396] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.149s)
[662.630432] [103/133] (377s left) kms_lease (simple-lease)
[662.718969] Starting subtest: simple-lease
[662.719997] Starting dynamic subtest: pipe-A-eDP-1
[663.228119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s)
[663.239046] Starting dynamic subtest: pipe-B-eDP-1
[664.675015] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.446s)
[664.684906] Starting dynamic subtest: pipe-C-eDP-1
[666.073411] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[666.081822] Starting dynamic subtest: pipe-D-eDP-1
[667.475187] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s)
[667.476161] Subtest simple-lease: SUCCESS (4.756s)
[668.265043] [104/133] (372s left) gem_ctx_shared (exec-shared-gtt)
[668.329900] Starting subtest: exec-shared-gtt
[668.330908] Starting dynamic subtest: rcs0
[668.337413] Dynamic subtest rcs0: SUCCESS (0.007s)
[668.347310] Starting dynamic subtest: bcs0
[668.348190] Dynamic subtest bcs0: SUCCESS (0.005s)
[668.356458] Starting dynamic subtest: vcs0
[668.357365] Dynamic subtest vcs0: SUCCESS (0.006s)
[668.365976] Starting dynamic subtest: vcs1
[668.366836] Dynamic subtest vcs1: SUCCESS (0.005s)
[668.375289] Starting dynamic subtest: vecs0
[668.376160] Dynamic subtest vecs0: SUCCESS (0.006s)
[668.384372] Starting dynamic subtest: ccs0
[668.385327] Dynamic subtest ccs0: SUCCESS (0.006s)
[668.386236] Subtest exec-shared-gtt: SUCCESS (0.039s)
[668.550273] [105/133] (371s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[668.608647] Starting subtest: multi-wait-available-unsubmitted-submitted
[668.609914] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[668.709937] [106/133] (371s left) kms_hdr (invalid-metadata-sizes)
[668.797026] Starting subtest: invalid-metadata-sizes
[668.799615] Subtest invalid-metadata-sizes: SKIP (0.000s)
[668.865217] [107/133] (371s left) gem_exec_fence (concurrent)
[669.039696] Starting subtest: concurrent
[669.041936] Subtest concurrent: SKIP (0.000s)
[670.930766] [108/133] (369s left) gem_exec_balancer (bonded-false-hang)
[671.201934] Starting subtest: bonded-false-hang
[671.204186] Subtest bonded-false-hang: SKIP (0.000s)
[671.290848] [109/133] (369s left) i915_pm_rps (min-max-config-idle)
[671.348000] Starting subtest: min-max-config-idle
[671.351597] Subtest min-max-config-idle: SKIP (0.001s)
[671.451488] [110/133] (369s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[671.541995] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[671.569435] Starting dynamic subtest: pipe-A-plane-0
[672.191497] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[672.201667] Starting dynamic subtest: pipe-A-plane-3
[672.613730] Dynamic subtest pipe-A-plane-3: SUCCESS (0.420s)
[673.724055] Starting dynamic subtest: pipe-B-plane-0
[674.415657] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[674.426416] Starting dynamic subtest: pipe-B-plane-3
[674.837931] Dynamic subtest pipe-B-plane-3: SUCCESS (0.420s)
[675.159692] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.618s)
[675.951093] [111/133] (364s left) gem_mmap_gtt (big-bo-tiledy)
[675.993826] Subtest big-bo-tiledY: SKIP (0.000s)
[676.047580] [112/133] (364s left) kms_content_protection (dp-mst-type-0-hdcp14)
[676.185963] Starting subtest: dp-mst-type-0-hdcp14
[676.188027] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[676.313053] [113/133] (364s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[676.361086] Starting subtest: multi-wait-all-available-submitted-signaled
[676.362102] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[676.454584] [114/133] (364s left) gem_exec_whisper (basic-queues-forked)
[676.527081] Starting subtest: basic-queues-forked
[701.075436] Subtest basic-queues-forked: SUCCESS (24.497s)
[701.212272] [115/133] (339s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[701.299518] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[708.043338] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.742s)
[708.167513] [116/133] (332s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[708.224293] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[708.294519] [117/133] (332s left) gem_mmap_wc (write-read-distinct)
[708.343321] Subtest write-read-distinct: SKIP (0.000s)
[708.409549] [118/133] (332s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[708.469255] Subtest writes-after-reads-uncached: SKIP (0.000s)
[708.534252] [119/133] (332s left) sw_sync (sync_busy)
[708.566134] Starting subtest: sync_busy
[708.567164] Subtest sync_busy: SUCCESS (0.002s)
[708.614294] [120/133] (332s left) kms_universal_plane (universal-plane-functional)
[708.707800] Starting subtest: universal-plane-functional
[708.708587] Starting dynamic subtest: pipe-A-eDP-1
[712.781091] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.073s)
[712.790105] Starting dynamic subtest: pipe-B-eDP-1
[717.500881] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.719s)
[717.510158] Starting dynamic subtest: pipe-C-eDP-1
[721.927793] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.425s)
[721.936484] Starting dynamic subtest: pipe-D-eDP-1
[726.316679] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.389s)
[726.317547] Subtest universal-plane-functional: SUCCESS (17.611s)
[727.152325] [121/133] (313s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[727.258490] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[727.259432] Starting dynamic subtest: pipe-A-eDP-1
[727.531447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.262s)
[727.540452] Starting dynamic subtest: pipe-B-eDP-1
[728.800677] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.267s)
[728.810406] Starting dynamic subtest: pipe-C-eDP-1
[730.054028] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.253s)
[730.063131] Starting dynamic subtest: pipe-D-eDP-1
[731.265979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[731.266859] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.997s)
[732.469948] [122/133] (308s left) syncobj_wait (multi-wait-all-submitted-signaled)
[732.530271] Starting subtest: multi-wait-all-submitted-signaled
[732.634384] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[732.706639] [123/133] (308s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[732.796988] Starting subtest: x-tiled-8bpp-rotate-0
[734.081104] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.284s)
[734.199529] [124/133] (306s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[734.298306] Starting subtest: fbcpsr-rgb101010-draw-blt
[740.987728] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.691s)
[741.122174] [125/133] (300s left) kms_properties (get_properties-sanity-non-atomic)
[741.224159] Starting subtest: get_properties-sanity-non-atomic
[741.225034] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[741.294415] [126/133] (299s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[741.435144] Starting subtest: multiplane-atomic-fence-wait
[741.751924] Subtest multiplane-atomic-fence-wait: SUCCESS (0.317s)
[742.852881] [127/133] (298s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[742.950212] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[742.951041] Starting dynamic subtest: pipe-A-eDP-1
[749.756624] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.805s)
[749.765933] Starting dynamic subtest: pipe-B-eDP-1
[756.791468] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.033s)
[756.792398] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.841s)
[757.675337] [128/133] (283s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[757.731280] Starting subtest: mixed-tiled-to-y-tiled-ccs
[757.733105] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[757.912486] [129/133] (283s left) gem_exec_fence (syncobj-timeline-signal)
[758.479318] Starting subtest: syncobj-timeline-signal
[758.480394] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[759.914043] [130/133] (281s left) kms_plane (plane-position-covered)
[759.998198] Starting subtest: plane-position-covered
[760.534251] Starting dynamic subtest: pipe-A-plane-1
[761.814856] Dynamic subtest pipe-A-plane-1: SUCCESS (1.281s)
[761.823604] Starting dynamic subtest: pipe-A-plane-2
[763.124843] Dynamic subtest pipe-A-plane-2: SUCCESS (1.310s)
[763.139373] Starting dynamic subtest: pipe-A-plane-3
[764.429473] Dynamic subtest pipe-A-plane-3: SUCCESS (1.303s)
[764.438190] Starting dynamic subtest: pipe-A-plane-4
[765.711803] Dynamic subtest pipe-A-plane-4: SUCCESS (1.281s)
[765.720375] Starting dynamic subtest: pipe-A-plane-5
[765.738579] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[766.951525] Starting dynamic subtest: pipe-B-plane-1
[768.215337] Dynamic subtest pipe-B-plane-1: SUCCESS (1.272s)
[768.224277] Starting dynamic subtest: pipe-B-plane-2
[769.529164] Dynamic subtest pipe-B-plane-2: SUCCESS (1.314s)
[769.538214] Starting dynamic subtest: pipe-B-plane-3
[770.807890] Dynamic subtest pipe-B-plane-3: SUCCESS (1.277s)
[770.820664] Starting dynamic subtest: pipe-B-plane-4
[772.108829] Dynamic subtest pipe-B-plane-4: SUCCESS (1.301s)
[772.117620] Starting dynamic subtest: pipe-B-plane-5
[772.134592] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[772.135462] Subtest plane-position-covered: SUCCESS (12.137s)
[772.960285] [131/133] (268s left) gem_shrink (reclaim)
[773.021443] Starting subtest: reclaim
[775.477513] Subtest reclaim: SUCCESS (2.455s)
[775.643357] [132/133] (265s left) gem_mmap_wc (write-gtt-read-wc)
[775.693332] Subtest write-gtt-read-wc: SKIP (0.000s)
[775.751652] [133/133] (265s left) gem_exec_schedule (u-fairslice-all)
[775.816040] Starting subtest: u-fairslice-all
[777.901832] Subtest u-fairslice-all: SUCCESS (2.085s)
[779.841336] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: kms_vrr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_chamelium_color
results: parsing output: 7/ for test: prime_vgem
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_dp_link_training
results: parsing output: 11/ for test: prime_busy
results: parsing output: 12/ for test: gem_workarounds
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: kms_atomic_transition
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_hdmi_inject
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_force_connector_basic
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: perf
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_big_fb
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: gem_ctx_bad_destroy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_vblank
results: parsing output: 39/ for test: gem_spin_batch
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: kms_force_connector_basic
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: syncobj_eventfd
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_ctx_isolation
results: parsing output: 50/ for test: gem_mmap_wc
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: api_intel_allocator
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: i915_pm_freq_api
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_atomic_transition
results: parsing output: 62/ for test: core_auth
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: prime_self_import
results: parsing output: 68/ for test: prime_mmap
results: parsing output: 69/ for test: gem_partial_pwrite_pread
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: gem_exec_suspend
results: parsing output: 72/ for test: prime_mmap_coherency
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_plane_cursor
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_chamelium_color
results: parsing output: 79/ for test: kms_color_pipeline
results: parsing output: 80/ for test: gem_reg_read
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_barrier_race
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: dmabuf_sync_file
results: parsing output: 91/ for test: kms_invalid_mode
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: gem_media_vme
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: gem_mmap_offset
results: parsing output: 96/ for test: i915_pm_rps
results: parsing output: 97/ for test: sysfs_timeslice_duration
results: parsing output: 98/ for test: gem_create
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_userptr_blits
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: gem_ctx_shared
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_hdr
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: i915_pm_rps
results: parsing output: 109/ for test: kms_plane
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_exec_whisper
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: gem_partial_pwrite_pread
results: parsing output: 118/ for test: sw_sync
results: parsing output: 119/ for test: kms_universal_plane
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: syncobj_wait
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_properties
results: parsing output: 125/ for test: kms_explicit_fence
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: gem_shrink
results: parsing output: 131/ for test: gem_mmap_wc
results: parsing output: 132/ for test: gem_exec_schedule
Done.