[57.052953] Initializing watchdogs
[57.053006]   /dev/watchdog0
[57.066779] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.071181] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.073354] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.076801] [001/133] (960s left) perf_pmu (all-busy-check-all)
[57.143103] Starting subtest: all-busy-check-all
[58.900989] Subtest all-busy-check-all: SUCCESS (1.762s)
[59.032962] [002/133] (958s left) gem_render_copy (y-tiled-to-vebox-linear)
[59.105261] Starting subtest: y-tiled-to-vebox-linear
[59.109692] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[59.298160] [003/133] (958s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[59.373982] Starting subtest: map-fixed-invalidate-overlap
[59.378962] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[59.548074] [004/133] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[59.659465] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[59.663712] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[59.777514] [005/133] (957s left) syncobj_timeline (wait-all-for-submit-complex)
[59.840209] Starting subtest: wait-all-for-submit-complex
[60.053923] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[60.147897] [006/133] (957s left) gen9_exec_parse (secure-batches)
[60.210336] Subtest secure-batches: SKIP (0.000s)
[60.285400] [007/133] (957s left) gem_mmap_gtt (isolation)
[60.346815] Subtest isolation: SKIP (0.000s)
[60.407444] [008/133] (957s left) kms_rotation_crc (primary-rotation-180)
[60.503310] Starting subtest: primary-rotation-180
[67.677987] Subtest primary-rotation-180: SUCCESS (7.187s)
[69.028795] [009/133] (948s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[69.120339] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[69.122707] Starting dynamic subtest: pipe-A-eDP-1
[69.145539] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[69.155162] Starting dynamic subtest: pipe-B-eDP-1
[69.176574] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[69.184106] Starting dynamic subtest: pipe-C-eDP-1
[69.205699] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[69.214644] Starting dynamic subtest: pipe-D-eDP-1
[69.235616] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[69.239554] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[71.398596] [010/133] (946s left) kms_properties (plane-properties-legacy)
[71.508049] Starting subtest: plane-properties-legacy
[71.510400] Starting dynamic subtest: pipe-A-eDP-1
[72.093476] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[72.102738] Starting dynamic subtest: pipe-B-eDP-1
[73.371718] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.276s)
[73.379185] Starting dynamic subtest: pipe-C-eDP-1
[74.614691] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.243s)
[74.623783] Starting dynamic subtest: pipe-D-eDP-1
[75.842284] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[75.844617] Subtest plane-properties-legacy: SUCCESS (4.335s)
[76.647912] [011/133] (941s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[76.754379] Starting subtest: yf-tiled-32bpp-rotate-270
[76.758872] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[76.868919] [012/133] (941s left) gem_exec_fence (basic-wait)
[77.037336] Starting subtest: basic-wait
[77.039978] Starting dynamic subtest: rcs0
[77.142350] Dynamic subtest rcs0: SUCCESS (0.105s)
[77.152391] Starting dynamic subtest: bcs0
[77.207173] Dynamic subtest bcs0: SUCCESS (0.065s)
[77.216807] Starting dynamic subtest: vcs0
[77.264791] Dynamic subtest vcs0: SUCCESS (0.056s)
[77.274859] Starting dynamic subtest: vcs1
[77.322215] Dynamic subtest vcs1: SUCCESS (0.057s)
[77.331822] Starting dynamic subtest: vecs0
[77.379396] Dynamic subtest vecs0: SUCCESS (0.056s)
[77.388850] Starting dynamic subtest: ccs0
[77.437351] Dynamic subtest ccs0: SUCCESS (0.058s)
[77.440088] Subtest basic-wait: SUCCESS (0.402s)
[78.975658] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[78.978787] [013/133] (939s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[79.075429] Starting subtest: async-flip-with-page-flip-events-linear
[79.459841] Starting dynamic subtest: pipe-A-eDP-1
[82.217029] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.756s)
[82.580777] Starting dynamic subtest: pipe-B-eDP-1
[85.344421] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[85.731771] Starting dynamic subtest: pipe-C-eDP-1
[88.483960] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s)
[88.859951] Starting dynamic subtest: pipe-D-eDP-1
[91.623067] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[91.625833] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.548s)
[92.817622] [014/133] (925s left) kms_psr (fbc-psr-cursor-plane-move)
[92.917692] Starting subtest: fbc-psr-cursor-plane-move
[92.919940] Starting dynamic subtest: eDP-1
[92.923989] Dynamic subtest eDP-1: SKIP (0.000s)
[92.928070] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[92.999206] [015/133] (925s left) kms_psr (pr-cursor-plane-onoff)
[93.079331] Starting subtest: pr-cursor-plane-onoff
[93.083590] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[93.162385] [016/133] (924s left) prime_vgem (fence-flip-hang)
[93.257558] Subtest fence-flip-hang: SKIP (0.000s)
[93.361403] [017/133] (924s left) drm_mm (drm_mm)
[93.397958] Starting subtest: drm_mm
[93.404668] Starting dynamic subtest: drm_test_mm_init
[93.501264] Dynamic subtest drm_test_mm_init: SUCCESS (0.097s)
[93.510874] Starting dynamic subtest: drm_test_mm_debug
[93.613411] Dynamic subtest drm_test_mm_debug: SUCCESS (0.111s)
[93.620684] Starting dynamic subtest: drm_test_mm_align32
[93.717078] Dynamic subtest drm_test_mm_align32: SUCCESS (0.104s)
[93.726163] Starting dynamic subtest: drm_test_mm_align64
[93.856386] Dynamic subtest drm_test_mm_align64: SUCCESS (0.138s)
[93.865145] Starting dynamic subtest: drm_test_mm_lowest
[94.002846] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.146s)
[94.009825] Starting dynamic subtest: drm_test_mm_highest
[94.124932] Dynamic subtest drm_test_mm_highest: SUCCESS (0.122s)
[94.127138] Subtest drm_mm: SUCCESS (0.728s)
[94.300531] [018/133] (923s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[94.389034] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[94.403679] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.013s)
[94.505157] [019/133] (923s left) kms_vrr (lobf)
[94.603700] Starting subtest: lobf
[94.607835] Subtest lobf: SKIP (0.000s)
[94.699784] [020/133] (923s left) kms_async_flips (test-cursor-atomic)
[94.790612] Starting subtest: test-cursor-atomic
[94.794832] Subtest test-cursor-atomic: SKIP (0.000s)
[96.044127] [021/133] (922s left) kms_plane_multiple (2x-tiling-none)
[96.150182] Starting subtest: 2x-tiling-none
[96.154384] Subtest 2x-tiling-none: SKIP (0.000s)
[96.234336] [022/133] (922s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[96.296639] Starting subtest: etime-single-wait-all-available-unsubmitted
[96.400750] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.103s)
[96.500664] [023/133] (921s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[96.599377] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[96.601688] Starting dynamic subtest: pipe-A-eDP-1
[96.696338] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[96.706240] Starting dynamic subtest: pipe-B-eDP-1
[97.810394] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s)
[97.815102] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.214s)
[99.107353] [024/133] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[99.217309] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[106.212269] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.997s)
[106.333083] [025/133] (912s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[106.428546] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[106.430695] Starting dynamic subtest: pipe-A
[106.448583] Dynamic subtest pipe-A: SKIP (0.017s)
[106.456436] Starting dynamic subtest: pipe-B
[106.478185] Dynamic subtest pipe-B: SKIP (0.029s)
[106.485944] Starting dynamic subtest: pipe-C
[106.507699] Dynamic subtest pipe-C: SKIP (0.030s)
[106.515759] Starting dynamic subtest: pipe-D
[106.537405] Dynamic subtest pipe-D: SKIP (0.029s)
[106.541637] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.107s)
[106.666889] [026/133] (911s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[106.778818] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[111.173040] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.398s)
[112.341260] [027/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[112.459731] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[112.464368] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[112.570224] [028/133] (906s left) kms_cursor_crc (cursor-sliding-128x128)
[112.778615] Starting subtest: cursor-sliding-128x128
[112.783631] Starting dynamic subtest: pipe-A-eDP-1
[115.981406] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.198s)
[116.006940] Starting dynamic subtest: pipe-D-eDP-1
[119.900972] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.899s)
[119.903397] Subtest cursor-sliding-128x128: SUCCESS (7.121s)
[120.795057] [029/133] (897s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[120.898572] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[120.903039] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[121.039292] [030/133] (897s left) core_auth (many-magics)
[121.100869] Starting subtest: many-magics
[122.101064] Subtest many-magics: SUCCESS (1.000s)
[122.230293] [031/133] (896s left) gem_reg_read (bad-register)
[122.290878] Starting subtest: bad-register
[122.293195] Subtest bad-register: SUCCESS (0.000s)
[122.412589] [032/133] (896s left) kms_invalid_mode (bad-vtotal)
[122.504117] Starting subtest: bad-vtotal
[122.506474] Starting dynamic subtest: pipe-A-eDP-1
[122.793368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[122.802563] Starting dynamic subtest: pipe-B-eDP-1
[122.804632] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[122.811757] Starting dynamic subtest: pipe-C-eDP-1
[122.813741] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[122.821210] Starting dynamic subtest: pipe-D-eDP-1
[122.823443] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[122.825644] Subtest bad-vtotal: SUCCESS (0.296s)
[123.617814] [033/133] (895s left) kms_psr (psr2-cursor-render)
[123.717969] Starting subtest: psr2-cursor-render
[123.720326] Starting dynamic subtest: eDP-1
[125.380767] Dynamic subtest eDP-1: SUCCESS (1.662s)
[125.382893] Subtest psr2-cursor-render: SUCCESS (1.663s)
[126.189318] [034/133] (892s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[126.300463] Starting subtest: random-ccs-data-yf-tiled-ccs
[126.302856] Starting dynamic subtest: pipe-A-eDP-1
[126.328392] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[126.338427] Starting dynamic subtest: pipe-B-eDP-1
[126.363125] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[126.370766] Starting dynamic subtest: pipe-C-eDP-1
[126.393898] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[126.401687] Starting dynamic subtest: pipe-D-eDP-1
[126.425216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[126.429554] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.011s)
[128.655052] [035/133] (890s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[128.716436] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[128.781546] [036/133] (890s left) gem_tiling_max_stride
[128.909379] [037/133] (890s left) kms_cursor_crc (cursor-onscreen-512x512)
[129.172021] Starting subtest: cursor-onscreen-512x512
[129.175804] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[129.351913] [038/133] (889s left) kms_flip (2x-blocking-absolute-wf_vblank)
[129.458058] Starting subtest: 2x-blocking-absolute-wf_vblank
[129.466772] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[129.573698] [039/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[129.687328] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[129.690747] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[129.805772] [040/133] (889s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[129.898145] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[129.899932] Starting dynamic subtest: pipe-A-eDP-1
[129.916308] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[129.928074] Starting dynamic subtest: pipe-B-eDP-1
[129.943754] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[129.952306] Starting dynamic subtest: pipe-C-eDP-1
[129.967525] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[129.974872] Starting dynamic subtest: pipe-D-eDP-1
[129.990137] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[129.991663] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[132.131864] [041/133] (887s left) sw_sync (sync_busy)
[132.168294] Starting subtest: sync_busy
[132.170628] Subtest sync_busy: SUCCESS (0.002s)
[132.239239] [042/133] (886s left) gem_mmap (pf-nonblock)
[132.302466] Subtest pf-nonblock: SKIP (0.000s)
[132.366730] [043/133] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[132.469420] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[132.473777] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[132.582746] [044/133] (886s left) gem_softpin (evict-snoop)
[132.642260] Starting subtest: evict-snoop
[132.646970] Subtest evict-snoop: SKIP (0.000s)
[132.771543] [045/133] (886s left) kms_cursor_legacy (torture-bo)
[132.897617] Starting subtest: torture-bo
[132.899844] Starting dynamic subtest: pipe-A
[139.244421] Dynamic subtest pipe-A: SUCCESS (6.342s)
[139.253732] Starting dynamic subtest: pipe-B
[146.380933] Dynamic subtest pipe-B: SUCCESS (7.137s)
[146.390474] Starting dynamic subtest: pipe-C
[153.243748] Dynamic subtest pipe-C: SUCCESS (6.860s)
[153.253801] Starting dynamic subtest: pipe-D
[159.827638] Dynamic subtest pipe-D: SUCCESS (6.584s)
[159.841637] Starting dynamic subtest: all-pipes
[167.533810] Dynamic subtest all-pipes: SUCCESS (7.704s)
[167.536360] Subtest torture-bo: SUCCESS (34.634s)
[167.715086] [046/133] (851s left) i915_pm_rps (reset)
[167.793238] Starting subtest: reset
[176.230982] Subtest reset: SUCCESS (8.438s)
[176.371022] [047/133] (843s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[176.442146] Starting subtest: y-tiled-ccs-to-x-tiled
[176.446360] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[176.640087] [048/133] (842s left) gem_wait (write-busy)
[176.715107] Starting subtest: write-busy
[176.717048] Starting dynamic subtest: all-engines
[177.366025] Dynamic subtest all-engines: SUCCESS (0.653s)
[177.379611] Starting dynamic subtest: rcs0
[177.924337] Dynamic subtest rcs0: SUCCESS (0.557s)
[177.940156] Starting dynamic subtest: bcs0
[178.475935] Dynamic subtest bcs0: SUCCESS (0.551s)
[178.489762] Starting dynamic subtest: vcs0
[179.926761] Dynamic subtest vcs0: SUCCESS (1.448s)
[179.941857] Starting dynamic subtest: vcs1
[181.907890] Dynamic subtest vcs1: SUCCESS (1.979s)
[181.922753] Starting dynamic subtest: vecs0
[183.892210] Dynamic subtest vecs0: SUCCESS (1.983s)
[183.909651] Starting dynamic subtest: ccs0
[184.443926] Dynamic subtest ccs0: SUCCESS (0.551s)
[184.446410] Subtest write-busy: SUCCESS (7.732s)
[184.649220] [049/133] (834s left) gem_exec_whisper (basic-queues-priority-all)
[184.719075] Starting subtest: basic-queues-priority-all
[208.200459] Subtest basic-queues-priority-all: SUCCESS (23.477s)
[208.407264] [050/133] (811s left) syncobj_wait (wait-any-snapshot)
[208.464288] Starting subtest: wait-any-snapshot
[208.545743] Subtest wait-any-snapshot: SUCCESS (0.082s)
[208.645542] [051/133] (810s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[208.753105] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[208.757304] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[208.879642] [052/133] (810s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[208.977636] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[209.005584] Starting dynamic subtest: pipe-A-plane-0
[209.010041] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[209.020342] Starting dynamic subtest: pipe-A-plane-3
[209.024611] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[209.032762] Starting dynamic subtest: pipe-A-plane-5
[209.037129] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[210.090178] Starting dynamic subtest: pipe-B-plane-0
[210.099459] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[210.107217] Starting dynamic subtest: pipe-B-plane-3
[210.111637] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[210.119256] Starting dynamic subtest: pipe-B-plane-5
[210.123550] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[210.393407] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (1.415s)
[211.270760] [053/133] (808s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[211.370241] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[211.374275] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[211.449140] [054/133] (808s left) kms_plane (plane-position-hole-dpms)
[211.544272] Starting subtest: plane-position-hole-dpms
[212.050789] Starting dynamic subtest: pipe-A-plane-1
[214.450316] Dynamic subtest pipe-A-plane-1: SUCCESS (2.399s)
[214.461085] Starting dynamic subtest: pipe-A-plane-2
[216.808894] Dynamic subtest pipe-A-plane-2: SUCCESS (2.358s)
[216.818667] Starting dynamic subtest: pipe-A-plane-3
[219.157484] Dynamic subtest pipe-A-plane-3: SUCCESS (2.348s)
[219.167630] Starting dynamic subtest: pipe-A-plane-4
[221.451988] Dynamic subtest pipe-A-plane-4: SUCCESS (2.294s)
[221.462075] Starting dynamic subtest: pipe-A-plane-5
[221.477493] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[222.629880] Starting dynamic subtest: pipe-B-plane-1
[224.967284] Dynamic subtest pipe-B-plane-1: SUCCESS (2.343s)
[224.976990] Starting dynamic subtest: pipe-B-plane-2
[227.329873] Dynamic subtest pipe-B-plane-2: SUCCESS (2.365s)
[227.339385] Starting dynamic subtest: pipe-B-plane-3
[229.669600] Dynamic subtest pipe-B-plane-3: SUCCESS (2.339s)
[229.679055] Starting dynamic subtest: pipe-B-plane-4
[232.056472] Dynamic subtest pipe-B-plane-4: SUCCESS (2.385s)
[232.067078] Starting dynamic subtest: pipe-B-plane-5
[232.082440] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[232.084605] Subtest plane-position-hole-dpms: SUCCESS (20.539s)
[232.888321] [055/133] (786s left) gem_busy (semaphore)
[233.080415] Subtest semaphore: SKIP (0.000s)
[233.338373] [056/133] (786s left) gen9_exec_parse (shadow-peek)
[233.401970] Subtest shadow-peek: SKIP (0.000s)
[233.483354] [057/133] (786s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[233.546833] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[233.551373] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[233.742700] [058/133] (786s left) kms_frontbuffer_tracking (fbc-1p-rte)
[233.838882] Starting subtest: fbc-1p-rte
[239.363930] Subtest fbc-1p-rte: SUCCESS (5.530s)
[240.593054] [059/133] (779s left) gem_exec_parallel (fds)
[240.655765] Starting subtest: fds
[240.658272] Starting dynamic subtest: rcs0
[244.150871] Dynamic subtest rcs0: SUCCESS (3.493s)
[244.162502] Starting dynamic subtest: bcs0
[248.155438] Dynamic subtest bcs0: SUCCESS (4.003s)
[248.170519] Starting dynamic subtest: vcs0
[252.202313] Dynamic subtest vcs0: SUCCESS (4.045s)
[252.213744] Starting dynamic subtest: vcs1
[257.990483] Dynamic subtest vcs1: SUCCESS (5.785s)
[258.001263] Starting dynamic subtest: vecs0
[262.221227] Dynamic subtest vecs0: SUCCESS (4.229s)
[262.233079] Starting dynamic subtest: ccs0
[266.306105] Dynamic subtest ccs0: SUCCESS (4.082s)
[266.308733] Subtest fds: SUCCESS (25.650s)
[266.524398] [060/133] (753s left) sysfs_preempt_timeout (invalid)
[266.590147] Starting subtest: invalid
[266.592529] Starting dynamic subtest: vecs0
[266.594754] Dynamic subtest vecs0: SUCCESS (0.000s)
[266.605407] Starting dynamic subtest: ccs0
[266.607619] Dynamic subtest ccs0: SUCCESS (0.000s)
[266.616762] Starting dynamic subtest: vcs0
[266.618818] Dynamic subtest vcs0: SUCCESS (0.000s)
[266.626690] Starting dynamic subtest: bcs0
[266.628746] Dynamic subtest bcs0: SUCCESS (0.000s)
[266.636671] Starting dynamic subtest: rcs0
[266.638727] Dynamic subtest rcs0: SUCCESS (0.000s)
[266.646534] Starting dynamic subtest: vcs1
[266.648393] Dynamic subtest vcs1: SUCCESS (0.000s)
[266.650235] Subtest invalid: SUCCESS (0.005s)
[266.736321] [061/133] (753s left) gem_ctx_persistence (processes)
[266.805071] Starting subtest: processes
[268.915947] Subtest processes: SUCCESS (2.110s)
[269.018767] [062/133] (750s left) i915_query (query-regions-garbage-items)
[269.076066] Starting subtest: query-regions-garbage-items
[269.078403] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[269.218728] [063/133] (750s left) kms_pipe_stress (stress-xrgb8888-untiled)
[269.314175] Starting subtest: stress-xrgb8888-untiled
[275.288150] Subtest stress-xrgb8888-untiled: SUCCESS (5.974s)
[275.343206] [064/133] (744s left) gem_softpin (noreloc-interruptible)
[275.411685] Starting subtest: noreloc-interruptible
[280.798589] Subtest noreloc-interruptible: SUCCESS (5.384s)
[281.005211] [065/133] (739s left) gem_exec_schedule (preemptive-hang)
[281.180329] Starting subtest: preemptive-hang
[281.183098] Starting dynamic subtest: rcs0
[290.048938] Dynamic subtest rcs0: SUCCESS (8.868s)
[290.059895] Starting dynamic subtest: bcs0
[299.005891] Dynamic subtest bcs0: SUCCESS (8.955s)
[299.016935] Starting dynamic subtest: vcs0
[308.031661] Dynamic subtest vcs0: SUCCESS (9.023s)
[308.041528] Starting dynamic subtest: vcs1
[317.050087] Dynamic subtest vcs1: SUCCESS (9.019s)
[317.061058] Starting dynamic subtest: vecs0
[326.010200] Dynamic subtest vecs0: SUCCESS (8.957s)
[326.023524] Starting dynamic subtest: ccs0
[335.035687] Dynamic subtest ccs0: SUCCESS (9.025s)
[335.038172] Subtest preemptive-hang: SUCCESS (53.858s)
[335.318352] [066/133] (684s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[335.420595] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[342.775416] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.358s)
[343.947283] [067/133] (676s left) kms_color_pipeline (plane-ctm3x4)
[344.063043] Starting subtest: plane-ctm3x4
[344.079057] Starting dynamic subtest: pipe-A-eDP-1
[344.778731] Dynamic subtest pipe-A-eDP-1: FAIL (0.315s)
[345.504866] Starting dynamic subtest: pipe-B-eDP-1
[346.270113] Dynamic subtest pipe-B-eDP-1: FAIL (0.257s)
[346.843085] Starting dynamic subtest: pipe-C-eDP-1
[347.695481] Dynamic subtest pipe-C-eDP-1: FAIL (0.269s)
[348.176931] Starting dynamic subtest: pipe-D-eDP-1
[348.975360] Dynamic subtest pipe-D-eDP-1: FAIL (0.213s)
[348.977399] Subtest plane-ctm3x4: FAIL (4.610s)
[349.573693] [068/133] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[349.674581] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[353.636329] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.965s)
[354.776351] [069/133] (665s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[354.904701] Starting subtest: basic-flip-before-cursor-legacy
[355.827876] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.922s)
[356.693168] [070/133] (663s left) gem_exec_whisper (basic-fds-forked)
[356.760961] Starting subtest: basic-fds-forked
[379.725448] Subtest basic-fds-forked: SUCCESS (22.961s)
[379.920316] [071/133] (640s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[380.039287] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[386.525993] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.490s)
[386.654838] [072/133] (633s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[386.748795] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[386.753188] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[386.839440] [073/133] (633s left) kms_flip (2x-flip-vs-rmfb)
[386.952499] Starting subtest: 2x-flip-vs-rmfb
[386.976365] Subtest 2x-flip-vs-rmfb: SKIP (0.024s)
[387.082482] [074/133] (633s left) kms_vblank (wait-idle)
[387.190951] Starting subtest: wait-idle
[387.193152] Starting dynamic subtest: pipe-A-eDP-1
[388.957753] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.766s)
[388.972371] Starting dynamic subtest: pipe-D-eDP-1
[391.353444] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.392s)
[391.355595] Subtest wait-idle: SUCCESS (4.162s)
[392.186432] [075/133] (628s left) kms_feature_discovery (display)
[392.277639] Starting subtest: display
[392.279857] Subtest display: SUCCESS (0.000s)
[392.365782] [076/133] (628s left) syncobj_wait (wait-for-submit-snapshot)
[392.427863] Starting subtest: wait-for-submit-snapshot
[392.507368] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[392.606948] [077/133] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[392.717275] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[399.624295] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.910s)
[399.795811] [078/133] (620s left) kms_big_fb (linear-addfb)
[399.892629] Starting subtest: linear-addfb
[399.894634] Subtest linear-addfb: SUCCESS (0.000s)
[400.038365] [079/133] (620s left) kms_chamelium_hpd (common-hpd-after-suspend)
[400.430691] Subtest common-hpd-after-suspend: SKIP (0.000s)
[401.208534] [080/133] (619s left) kms_getfb (getfb-addfb-different-handles)
[401.302855] Starting subtest: getfb-addfb-different-handles
[401.305230] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[401.434846] [081/133] (619s left) gem_exec_reloc (basic-write-cpu-noreloc)
[401.503082] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[401.574229] [082/133] (619s left) syncobj_basic (create-signaled)
[401.634478] Starting subtest: create-signaled
[401.636793] Subtest create-signaled: SUCCESS (0.000s)
[401.760086] [083/133] (619s left) syncobj_timeline (multi-wait-all-available-submitted)
[401.813508] Starting subtest: multi-wait-all-available-submitted
[401.815740] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[401.936648] [084/133] (618s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[402.039810] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[403.007684] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.967s)
[403.173940] [085/133] (617s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[403.235806] Starting subtest: multi-wait-all-for-submit-signaled
[403.238528] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[403.366517] [086/133] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[403.465801] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[403.469161] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[403.590421] [087/133] (617s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[403.694099] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[410.423294] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.733s)
[410.564987] [088/133] (610s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[411.132027] Starting subtest: syncobj-backward-timeline-chain-engines
[411.247440] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.120s)
[412.995076] [089/133] (608s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[413.103527] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[413.107957] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[413.201797] [090/133] (607s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[413.300647] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[413.305022] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[414.489906] [091/133] (606s left) syncobj_eventfd (timeline-wait-before-signal)
[414.547624] Starting subtest: timeline-wait-before-signal
[414.576463] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[414.667916] [092/133] (606s left) gem_caching (reads)
[414.728477] Subtest reads: SKIP (0.000s)
[414.809675] [093/133] (606s left) gem_mmap_wc (invalid-flags)
[414.871770] Subtest invalid-flags: SKIP (0.000s)
[414.926961] [094/133] (606s left) gem_exec_balancer (nop)
[414.993394] Starting subtest: nop
[461.547087] Subtest nop: SUCCESS (46.553s)
[461.878550] [095/133] (559s left) kms_lease (lease-invalid-plane)
[461.977099] Starting subtest: lease-invalid-plane
[461.979385] Starting dynamic subtest: pipe-A-eDP-1
[461.981585] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[461.989774] Starting dynamic subtest: pipe-B-eDP-1
[461.991677] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[461.999958] Starting dynamic subtest: pipe-C-eDP-1
[462.002122] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[462.010341] Starting dynamic subtest: pipe-D-eDP-1
[462.012243] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[462.014111] Subtest lease-invalid-plane: SUCCESS (0.004s)
[462.060059] [096/133] (559s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[462.446311] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[463.269257] [097/133] (558s left) kms_psr2_su (page_flip-nv12)
[463.338923] Subtest page_flip-NV12: SKIP (0.000s)
[463.411628] [098/133] (558s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[463.513609] Starting subtest: fbc-1p-pri-indfb-multidraw
[476.571803] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.063s)
[478.016148] [099/133] (543s left) kms_flip (flip-vs-panning)
[478.112774] Starting subtest: flip-vs-panning
[478.114762] Starting dynamic subtest: A-eDP1
[486.798816] Dynamic subtest A-eDP1: SUCCESS (8.685s)
[486.808912] Starting dynamic subtest: B-eDP1
[495.518082] Dynamic subtest B-eDP1: SUCCESS (8.717s)
[495.528528] Starting dynamic subtest: C-eDP1
[504.227637] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[504.240977] Starting dynamic subtest: D-eDP1
[512.963463] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[512.968547] Subtest flip-vs-panning: SUCCESS (34.856s)
[514.246844] [100/133] (507s left) kms_psr (fbc-psr2-cursor-blt)
[514.335992] Starting subtest: fbc-psr2-cursor-blt
[514.338363] Starting dynamic subtest: eDP-1
[514.342496] Dynamic subtest eDP-1: SKIP (0.000s)
[514.346705] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[514.436418] [101/133] (507s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[514.544040] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[514.548642] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[514.690207] [102/133] (506s left) gem_exec_schedule (promotion)
[514.773400] Starting subtest: promotion
[514.775790] Starting dynamic subtest: rcs0
[514.882638] Dynamic subtest rcs0: SUCCESS (0.111s)
[514.894705] Starting dynamic subtest: vcs0
[514.968237] Dynamic subtest vcs0: SUCCESS (0.085s)
[514.980546] Starting dynamic subtest: vcs1
[515.049653] Dynamic subtest vcs1: SUCCESS (0.080s)
[515.061751] Starting dynamic subtest: vecs0
[515.130331] Dynamic subtest vecs0: SUCCESS (0.080s)
[515.142107] Starting dynamic subtest: ccs0
[515.232644] Dynamic subtest ccs0: SUCCESS (0.102s)
[515.235212] Subtest promotion: SUCCESS (0.463s)
[517.016865] [103/133] (504s left) api_intel_allocator (reserve-simple)
[517.085115] Starting subtest: reserve-simple
[517.089997] Subtest reserve-simple: SUCCESS (0.005s)
[517.264452] [104/133] (504s left) gem_spin_batch (resubmit)
[517.331049] Starting subtest: resubmit
[517.333012] Starting dynamic subtest: rcs0
[517.337773] Dynamic subtest rcs0: SUCCESS (0.009s)
[517.349801] Starting dynamic subtest: bcs0
[517.352161] Dynamic subtest bcs0: SUCCESS (0.003s)
[517.363573] Starting dynamic subtest: vcs0
[517.365745] Dynamic subtest vcs0: SUCCESS (0.003s)
[517.374115] Starting dynamic subtest: vcs1
[517.376271] Dynamic subtest vcs1: SUCCESS (0.003s)
[517.384392] Starting dynamic subtest: vecs0
[517.386592] Dynamic subtest vecs0: SUCCESS (0.003s)
[517.394960] Starting dynamic subtest: ccs0
[517.397125] Dynamic subtest ccs0: SUCCESS (0.005s)
[517.399257] Subtest resubmit: SUCCESS (0.031s)
[517.634824] [105/133] (504s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[517.759029] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[517.763641] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[517.884730] [106/133] (503s left) gem_create (busy-create)
[517.944046] Starting subtest: busy-create
[517.946499] Starting dynamic subtest: smem0
[551.922594] Dynamic subtest smem0: SUCCESS (33.976s)
[551.925511] Subtest busy-create: SUCCESS (33.978s)
[552.119590] [107/133] (469s left) i915_hangman (engine-error-state-capture)
[552.191200] Starting subtest: engine-error-state-capture
[552.193486] Starting dynamic subtest: rcs0
[555.890877] Dynamic subtest rcs0: SUCCESS (3.698s)
[555.903103] Starting dynamic subtest: bcs0
[561.843707] Dynamic subtest bcs0: SUCCESS (5.950s)
[561.857031] Starting dynamic subtest: vcs0
[567.859606] Dynamic subtest vcs0: SUCCESS (6.013s)
[567.871289] Starting dynamic subtest: vcs1
[573.874755] Dynamic subtest vcs1: SUCCESS (6.012s)
[573.886823] Starting dynamic subtest: vecs0
[579.827232] Dynamic subtest vecs0: SUCCESS (5.950s)
[579.839913] Starting dynamic subtest: ccs0
[585.906555] Dynamic subtest ccs0: SUCCESS (6.077s)
[585.909909] Subtest engine-error-state-capture: SUCCESS (33.715s)
[586.104287] [108/133] (435s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[586.216039] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[586.218204] Starting dynamic subtest: pipe-A-eDP-1
[602.529083] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.530s)
[602.539684] Starting dynamic subtest: pipe-B-eDP-1
[619.478275] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.447s)
[619.489813] Starting dynamic subtest: pipe-C-eDP-1
[636.451838] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.334s)
[636.462300] Starting dynamic subtest: pipe-D-eDP-1
[653.462481] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.361s)
[653.464629] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.677s)
[654.700955] [109/133] (367s left) gem_eio (create-ext)
[654.888939] Starting subtest: create-ext
[655.173935] Subtest create-ext: SUCCESS (0.288s)
[655.334715] [110/133] (366s left) kms_cursor_crc (cursor-sliding-64x64)
[655.521267] Starting subtest: cursor-sliding-64x64
[655.526373] Starting dynamic subtest: pipe-A-eDP-1
[658.766341] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.265s)
[658.792186] Starting dynamic subtest: pipe-D-eDP-1
[662.606130] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.838s)
[662.608293] Subtest cursor-sliding-64x64: SUCCESS (7.127s)
[663.418307] [111/133] (358s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[663.521898] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[663.525921] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[663.659231] [112/133] (358s left) kms_pm_rpm (pm-tiling)
[665.783901] Starting subtest: pm-tiling
[665.788569] Subtest pm-tiling: SKIP (0.000s)
[666.206241] [113/133] (355s left) core_getclient (basic)
[666.270561] Starting subtest: basic
[666.273350] Subtest basic: SUCCESS (0.000s)
[666.403746] [114/133] (355s left) gem_exec_flush (basic-uc-rw-default)
[666.468723] Starting subtest: basic-uc-rw-default
[671.986575] Subtest basic-uc-rw-default: SUCCESS (5.531s)
[672.178634] [115/133] (350s left) kms_big_fb (y-tiled-addfb)
[672.275071] Starting subtest: y-tiled-addfb
[672.279610] Subtest y-tiled-addfb: SKIP (0.000s)
[672.371714] [116/133] (349s left) gem_softpin (noreloc-s3)
[672.426620] Starting subtest: noreloc-S3
[692.366205] Subtest noreloc-S3: SUCCESS (5.382s)
[692.518226] [117/133] (329s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[692.630332] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[692.635854] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[692.725344] [118/133] (329s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[692.813893] Starting subtest: flip-primary-invalidate-overlay
[704.513549] Subtest flip-primary-invalidate-overlay: SUCCESS (11.749s)
[704.708189] [119/133] (317s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[704.803622] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[704.805829] Starting dynamic subtest: pipe-A-eDP-1
[704.826102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[704.837568] Starting dynamic subtest: pipe-B-eDP-1
[704.855796] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[704.865589] Starting dynamic subtest: pipe-C-eDP-1
[704.885700] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[704.894691] Starting dynamic subtest: pipe-D-eDP-1
[704.913685] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[704.915988] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[707.055440] [120/133] (315s left) perf_pmu (idle-no-semaphores)
[707.096306] Starting subtest: idle-no-semaphores
[707.098975] Starting dynamic subtest: rcs0
[707.642768] Dynamic subtest rcs0: SUCCESS (0.549s)
[707.656753] Starting dynamic subtest: bcs0
[708.171620] Dynamic subtest bcs0: SUCCESS (0.527s)
[708.182558] Starting dynamic subtest: vcs0
[708.696289] Dynamic subtest vcs0: SUCCESS (0.523s)
[708.710495] Starting dynamic subtest: vcs1
[709.225846] Dynamic subtest vcs1: SUCCESS (0.527s)
[709.239786] Starting dynamic subtest: vecs0
[709.754214] Dynamic subtest vecs0: SUCCESS (0.526s)
[709.767050] Starting dynamic subtest: ccs0
[710.282196] Dynamic subtest ccs0: SUCCESS (0.526s)
[710.285214] Subtest idle-no-semaphores: SUCCESS (3.194s)
[710.421148] [121/133] (312s left) gem_busy (close-race)
[710.475179] Starting subtest: close-race
[736.106765] Subtest close-race: SUCCESS (25.633s)
[736.520084] [122/133] (286s left) gem_ctx_isolation (preservation-reset)
[736.740148] Starting subtest: preservation-reset
[736.743247] Starting dynamic subtest: rcs0
[737.044091] Dynamic subtest rcs0: SUCCESS (0.303s)
[737.055478] Starting dynamic subtest: bcs0
[737.449774] Dynamic subtest bcs0: SUCCESS (0.404s)
[737.460164] Starting dynamic subtest: vcs0
[737.745677] Dynamic subtest vcs0: SUCCESS (0.295s)
[737.755505] Starting dynamic subtest: vcs1
[739.416882] Dynamic subtest vcs1: SUCCESS (1.671s)
[739.428886] Starting dynamic subtest: vecs0
[741.469549] Dynamic subtest vecs0: SUCCESS (2.051s)
[741.482462] Starting dynamic subtest: ccs0
[743.457877] Dynamic subtest ccs0: SUCCESS (1.987s)
[743.460863] Subtest preservation-reset: SUCCESS (6.720s)
[743.622045] [123/133] (279s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[743.735395] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[743.740665] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[743.846181] [124/133] (278s left) kms_sequence (queue-idle)
[743.966664] Starting subtest: queue-idle
[743.972347] Starting dynamic subtest: pipe-A-eDP-1
[745.790849] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.820s)
[745.801665] Starting dynamic subtest: pipe-B-eDP-1
[748.291496] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.501s)
[748.302767] Starting dynamic subtest: pipe-C-eDP-1
[750.700795] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.408s)
[750.714052] Starting dynamic subtest: pipe-D-eDP-1
[753.134900] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.433s)
[753.138045] Subtest queue-idle: SUCCESS (9.169s)
[753.966493] [125/133] (268s left) kms_pm_dc (dc6-psr)
[755.084348] Starting subtest: dc6-psr
[757.982362] Subtest dc6-psr: SUCCESS (2.897s)
[758.815214] [126/133] (263s left) gem_readwrite (write-bad-handle)
[758.883388] Subtest write-bad-handle: SKIP (0.000s)
[758.956216] [127/133] (263s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[759.061834] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[759.067318] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[759.180512] [128/133] (263s left) kms_setmode (invalid-clone-single-crtc)
[759.248377] Starting subtest: invalid-clone-single-crtc
[759.255739] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[759.364504] [129/133] (263s left) gem_exec_fence (syncobj-wait)
[759.865289] Starting subtest: syncobj-wait
[761.118769] Subtest syncobj-wait: SUCCESS (1.253s)
[761.485945] [130/133] (261s left) kms_content_protection (content-type-change)
[761.635716] Starting subtest: content-type-change
[761.641119] Subtest content-type-change: SKIP (0.000s)
[761.792192] [131/133] (261s left) perf (polling-parameterized)
[761.937875] Starting subtest: polling-parameterized
[781.959778] Subtest polling-parameterized: SUCCESS (20.029s)
[782.010554] [132/133] (241s left) kms_fence_pin_leak
[782.201320] [133/133] (240s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[782.264426] Starting subtest: rel-constants-invalid-rel-gen5
[782.267330] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[782.385758] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: gem_userptr_blits
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: prime_vgem
results: parsing output: 16/ for test: drm_mm
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_vrr
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: kms_plane_multiple
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: core_auth
results: parsing output: 30/ for test: gem_reg_read
results: parsing output: 31/ for test: kms_invalid_mode
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: gem_tiling_max_stride
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: sw_sync
results: parsing output: 41/ for test: gem_mmap
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: i915_pm_rps
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: gem_wait
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_plane
results: parsing output: 54/ for test: gem_busy
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: sysfs_preempt_timeout
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: i915_query
results: parsing output: 62/ for test: kms_pipe_stress
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_color_pipeline
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: kms_feature_discovery
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_chamelium_hpd
results: parsing output: 79/ for test: kms_getfb
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: syncobj_basic
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: syncobj_eventfd
results: parsing output: 91/ for test: gem_caching
results: parsing output: 92/ for test: gem_mmap_wc
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_lease
results: parsing output: 95/ for test: kms_chamelium_edid
results: parsing output: 96/ for test: kms_psr2_su
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: api_intel_allocator
results: parsing output: 103/ for test: gem_spin_batch
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_create
results: parsing output: 106/ for test: i915_hangman
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: core_getclient
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_softpin
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_psr_stress_test
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_busy
results: parsing output: 121/ for test: gem_ctx_isolation
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_sequence
results: parsing output: 124/ for test: kms_pm_dc
results: parsing output: 125/ for test: gem_readwrite
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_setmode
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: kms_content_protection
results: parsing output: 130/ for test: perf
results: parsing output: 131/ for test: kms_fence_pin_leak
results: parsing output: 132/ for test: gem_exec_params
Done.