[74.499619] Initializing watchdogs
[74.499675]   /dev/watchdog0
[74.514516] [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]
[74.519094] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[74.521383] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[74.524703] [001/156] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[74.647832] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[81.889235] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.251s)
[82.000168] [002/156] (953s left) gem_linear_blits (interruptible)
[82.327498] Starting subtest: interruptible
[86.363854] Subtest interruptible: SUCCESS (4.034s)
[86.569911] [003/156] (948s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[86.724939] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[86.729073] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[86.837987] [004/156] (948s left) kms_dp_linktrain_fallback (dsc-fallback)
[86.942205] Starting subtest: dsc-fallback
[86.948652] Subtest dsc-fallback: SKIP (0.000s)
[87.011579] [005/156] (948s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[87.400823] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[88.220943] [006/156] (946s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[88.331433] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[88.335960] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[88.400318] [007/156] (946s left) syncobj_timeline (reset-unsignaled)
[88.464239] Starting subtest: reset-unsignaled
[88.466666] Subtest reset-unsignaled: SUCCESS (0.000s)
[88.560405] [008/156] (946s left) gem_ctx_persistence (process)
[88.625025] Starting subtest: process
[88.794364] Subtest process: SUCCESS (0.168s)
[88.869550] [009/156] (946s left) i915_pm_rpm (system-suspend-devices)
[90.423068] Starting subtest: system-suspend-devices
[98.236824] Subtest system-suspend-devices: SUCCESS (7.815s)
[98.636019] [010/156] (936s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[98.709729] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[98.714457] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[98.888178] [011/156] (936s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[99.018721] Starting subtest: verify-pxp-execution-after-suspend-resume
[106.094223] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.077s)
[106.236899] [012/156] (929s left) prime_vgem (fence-wait)
[106.410396] Starting subtest: fence-wait
[106.412391] Starting dynamic subtest: rcs0
[107.457621] Dynamic subtest rcs0: SUCCESS (1.035s)
[107.466630] Starting dynamic subtest: bcs0
[108.513286] Dynamic subtest bcs0: SUCCESS (1.064s)
[108.525204] Starting dynamic subtest: vcs0
[109.558693] Dynamic subtest vcs0: SUCCESS (1.045s)
[109.568498] Starting dynamic subtest: vcs1
[110.597787] Dynamic subtest vcs1: SUCCESS (1.038s)
[110.608711] Starting dynamic subtest: vecs0
[111.643076] Dynamic subtest vecs0: SUCCESS (1.043s)
[111.654147] Starting dynamic subtest: ccs0
[112.686816] Dynamic subtest ccs0: SUCCESS (1.042s)
[112.692705] Subtest fence-wait: SUCCESS (6.277s)
[112.828915] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[112.831904] [013/156] (922s left) gem_pxp (create-regular-context-2)
[112.896786] Starting subtest: create-regular-context-2
[112.899234] Subtest create-regular-context-2: SUCCESS (0.001s)
[112.997253] [014/156] (922s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[113.116190] Starting subtest: cursorB-vs-flipB-legacy
[113.120891] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[113.263061] [015/156] (922s left) perf (gen12-group-exclusive-stream-ctx-handle)
[113.385785] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[113.410654] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[113.458807] [016/156] (922s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[115.279885] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[115.282290] Starting dynamic subtest: pipe-A-eDP-1
[115.291377] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[115.302764] Starting dynamic subtest: pipe-B-eDP-1
[115.311747] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[115.321245] Starting dynamic subtest: pipe-C-eDP-1
[115.329594] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[115.338496] Starting dynamic subtest: pipe-D-eDP-1
[115.347042] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[115.351136] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[117.594425] [017/156] (918s left) kms_pm_dc (dc6-dpms)
[118.700901] Starting subtest: dc6-dpms
[120.776569] Subtest dc6-dpms: SUCCESS (2.075s)
[120.865831] [018/156] (914s left) gem_exec_params (invalid-batch-start-offset)
[120.920725] Starting subtest: invalid-batch-start-offset
[120.923050] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[121.049056] [019/156] (914s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[121.149885] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[124.710188] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.566s)
[125.853707] [020/156] (909s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[126.407447] Starting subtest: syncobj-timeline-invalid-wait
[126.410228] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[127.406792] [021/156] (908s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[127.509095] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[127.513618] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[127.597129] [022/156] (908s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt)
[127.696516] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt
[127.701049] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[127.812216] [023/156] (908s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[127.913254] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[127.917602] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[128.010677] [024/156] (907s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[128.123993] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[128.128452] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[128.241156] [025/156] (907s left) gem_mmap_offset (isolation)
[128.297843] Starting subtest: isolation
[128.315781] Subtest isolation: SUCCESS (0.006s)
[128.427849] [026/156] (907s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[128.528038] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[128.531713] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[128.629472] [027/156] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[128.725640] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[128.729085] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[128.836243] [028/156] (907s left) kms_pm_rpm (pm-caching)
[130.367286] Starting subtest: pm-caching
[130.372257] Subtest pm-caching: SKIP (0.000s)
[131.087054] [029/156] (905s left) gem_eio (in-flight-immediate)
[131.300122] Starting subtest: in-flight-immediate
[139.789068] Subtest in-flight-immediate: SUCCESS (8.489s)
[139.951725] [030/156] (896s left) gem_readwrite (write-bad-handle)
[140.006796] Subtest write-bad-handle: SKIP (0.000s)
[140.095362] [031/156] (896s left) kms_color (ctm-negative)
[140.189437] Starting subtest: ctm-negative
[140.191424] Starting dynamic subtest: pipe-A-eDP-1
[140.926208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[140.936931] Starting dynamic subtest: pipe-B-eDP-1
[142.394355] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.466s)
[142.405640] Starting dynamic subtest: pipe-C-eDP-1
[143.769714] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[143.780065] Starting dynamic subtest: pipe-D-eDP-1
[145.104598] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[145.106887] Subtest ctm-negative: SUCCESS (4.917s)
[145.914998] [032/156] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[146.015317] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[146.019263] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[146.121163] [033/156] (890s left) gem_exec_schedule (independent)
[146.190565] Starting subtest: independent
[146.192615] Starting dynamic subtest: rcs0
[147.272262] Dynamic subtest rcs0: SUCCESS (1.092s)
[147.285629] Starting dynamic subtest: vcs0
[149.324786] Dynamic subtest vcs0: SUCCESS (2.052s)
[149.339168] Starting dynamic subtest: vcs1
[151.316184] Dynamic subtest vcs1: SUCCESS (1.991s)
[151.327182] Starting dynamic subtest: vecs0
[153.302330] Dynamic subtest vecs0: SUCCESS (1.985s)
[153.314314] Starting dynamic subtest: ccs0
[155.334460] Dynamic subtest ccs0: SUCCESS (2.030s)
[155.337298] Subtest independent: SUCCESS (9.155s)
[155.634941] [034/156] (880s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[155.769110] Starting subtest: flip-vs-cursor-toggle
[164.878648] Subtest flip-vs-cursor-toggle: SUCCESS (9.108s)
[165.754827] [035/156] (870s left) kms_universal_plane (disable-primary-vs-flip)
[165.844442] Starting subtest: disable-primary-vs-flip
[165.846836] Starting dynamic subtest: pipe-A-eDP-1
[167.399173] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.554s)
[167.409866] Starting dynamic subtest: pipe-B-eDP-1
[169.575588] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.175s)
[169.589058] Starting dynamic subtest: pipe-C-eDP-1
[171.768961] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.192s)
[171.778869] Starting dynamic subtest: pipe-D-eDP-1
[173.937251] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.166s)
[173.939604] Subtest disable-primary-vs-flip: SUCCESS (8.095s)
[174.743037] [036/156] (861s left) gem_wait (wait)
[174.819083] Starting subtest: wait
[174.821600] Starting dynamic subtest: all-engines
[176.325544] Dynamic subtest all-engines: SUCCESS (1.505s)
[176.337896] Starting dynamic subtest: rcs0
[177.372724] Dynamic subtest rcs0: SUCCESS (1.047s)
[177.385720] Starting dynamic subtest: bcs0
[178.422938] Dynamic subtest bcs0: SUCCESS (1.048s)
[178.434835] Starting dynamic subtest: vcs0
[179.468432] Dynamic subtest vcs0: SUCCESS (1.044s)
[179.479668] Starting dynamic subtest: vcs1
[180.512104] Dynamic subtest vcs1: SUCCESS (1.042s)
[180.524068] Starting dynamic subtest: vecs0
[181.556833] Dynamic subtest vecs0: SUCCESS (1.043s)
[181.569049] Starting dynamic subtest: ccs0
[182.604250] Dynamic subtest ccs0: SUCCESS (1.046s)
[182.606698] Subtest wait: SUCCESS (7.786s)
[182.820539] [037/156] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[182.915607] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[189.634478] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.725s)
[189.760437] [038/156] (846s left) i915_drm_fdinfo (virtual-busy)
[189.799100] Starting subtest: virtual-busy
[189.803291] Subtest virtual-busy: SKIP (0.000s)
[189.873799] [039/156] (846s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[189.966053] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[189.967965] Starting dynamic subtest: pipe-A-eDP-1
[190.491273] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s)
[190.503779] Starting dynamic subtest: pipe-B-eDP-1
[191.952314] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.461s)
[191.962613] Starting dynamic subtest: pipe-C-eDP-1
[193.446979] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.492s)
[193.459377] Starting dynamic subtest: pipe-D-eDP-1
[194.846450] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s)
[194.848779] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.853s)
[196.003516] [040/156] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[196.107541] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[196.111775] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[196.223707] [041/156] (840s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[196.321216] Starting subtest: psr2-cursor-plane-move-continuous-sf
[196.323649] Starting dynamic subtest: pipe-A-eDP-1
[206.664564] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.345s)
[206.675104] Starting dynamic subtest: pipe-B-eDP-1
[217.781677] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.116s)
[217.784096] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.463s)
[218.669397] [042/156] (818s left) kms_pm_backlight (bad-brightness)
[218.760148] Starting subtest: bad-brightness
[218.809380] Starting dynamic subtest: eDP-1
[219.127349] Dynamic subtest eDP-1: SUCCESS (0.316s)
[219.129544] Subtest bad-brightness: SUCCESS (0.367s)
[219.994556] [043/156] (816s left) gem_exec_balancer (busy)
[220.059195] Starting subtest: busy
[221.304258] Subtest busy: SUCCESS (1.242s)
[221.638611] [044/156] (815s left) kms_properties (connector-properties-legacy)
[221.730257] Starting subtest: connector-properties-legacy
[221.732434] Starting dynamic subtest: pipe-A-eDP-1
[229.878060] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.148s)
[229.888511] Starting dynamic subtest: pipe-None-DP-1
[229.892567] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[229.902046] Starting dynamic subtest: pipe-None-HDMI-A-1
[229.906335] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[229.916063] Starting dynamic subtest: pipe-None-DP-2
[229.920427] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[229.930054] Starting dynamic subtest: pipe-None-HDMI-A-2
[229.934330] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[229.945645] Starting dynamic subtest: pipe-None-DP-3
[229.950061] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[229.959779] Starting dynamic subtest: pipe-None-DP-4
[229.963670] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[229.965557] Subtest connector-properties-legacy: SUCCESS (8.159s)
[230.742797] [045/156] (806s left) kms_psr (pr-cursor-mmap-gtt)
[230.834055] Starting subtest: pr-cursor-mmap-gtt
[230.838056] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[230.908170] [046/156] (806s left) i915_drm_fdinfo (virtual-busy-idle)
[230.942070] Starting subtest: virtual-busy-idle
[230.946389] Subtest virtual-busy-idle: SKIP (0.000s)
[231.016636] [047/156] (805s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[231.108325] Starting subtest: addfb25-yf-tiled-legacy
[231.110590] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[231.210976] [048/156] (805s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[231.313349] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[232.137805] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[232.313528] [049/156] (804s left) gen7_exec_parse (chained-batch)
[232.379175] Subtest chained-batch: SKIP (0.000s)
[232.453156] [050/156] (804s left) kms_atomic (plane-primary-legacy)
[232.540204] Starting subtest: plane-primary-legacy
[232.542463] Starting dynamic subtest: pipe-A-eDP-1
[232.964366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s)
[232.966779] Subtest plane-primary-legacy: SUCCESS (0.426s)
[233.774590] [051/156] (803s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[234.077795] Starting subtest: cursor-rapid-movement-512x170
[234.082406] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[234.222809] [052/156] (802s left) core_sysfs (read-all-entries)
[234.269029] Starting subtest: read-all-entries
[234.281616] Subtest read-all-entries: SUCCESS (0.013s)
[234.357713] [053/156] (802s left) gem_readwrite (new-obj)
[234.419358] Subtest new-obj: SKIP (0.000s)
[234.482330] [054/156] (802s left) kms_psr (pr-sprite-mmap-cpu)
[234.571394] Starting subtest: pr-sprite-mmap-cpu
[234.575596] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[234.662187] [055/156] (802s left) gem_create (create-ext-cpu-access-sanity-check)
[234.833682] Starting subtest: create-ext-cpu-access-sanity-check
[234.838408] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[234.913608] [056/156] (802s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[235.019641] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[235.023777] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[235.115407] [057/156] (802s left) kms_busy (basic-hang)
[235.210240] Starting subtest: basic-hang
[235.212607] Starting dynamic subtest: flip-pipe-A
[235.792914] Dynamic subtest flip-pipe-A: SUCCESS (0.582s)
[235.802982] Starting dynamic subtest: modeset-pipe-A
[239.184915] Dynamic subtest modeset-pipe-A: SUCCESS (3.391s)
[239.195477] Starting dynamic subtest: flip-pipe-D
[240.414776] Dynamic subtest flip-pipe-D: SUCCESS (1.225s)
[240.425130] Starting dynamic subtest: modeset-pipe-D
[243.835540] Dynamic subtest modeset-pipe-D: SUCCESS (3.423s)
[243.837897] Subtest basic-hang: SUCCESS (8.628s)
[244.635979] [058/156] (792s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[244.727270] Starting subtest: crc-primary-basic-yf-tiled-ccs
[244.729591] Starting dynamic subtest: pipe-A-eDP-1
[244.752684] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.763752] Starting dynamic subtest: pipe-B-eDP-1
[244.784794] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.794068] Starting dynamic subtest: pipe-C-eDP-1
[244.816024] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.825474] Starting dynamic subtest: pipe-D-eDP-1
[244.847642] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.851731] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[247.003699] [059/156] (790s left) vgem_basic (bad-flag)
[247.051701] Starting subtest: bad-flag
[247.054043] Subtest bad-flag: SUCCESS (0.000s)
[247.108699] [060/156] (790s left) syncobj_timeline (invalid-wait-illegal-handle)
[247.154729] Starting subtest: invalid-wait-illegal-handle
[247.156727] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[247.253791] [061/156] (790s left) kms_plane_alpha_blend (constant-alpha-mid)
[247.343078] Starting subtest: constant-alpha-mid
[247.635542] Starting dynamic subtest: pipe-A-eDP-1
[248.587261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.950s)
[248.597635] Starting dynamic subtest: pipe-D-eDP-1
[250.186883] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.597s)
[250.189162] Subtest constant-alpha-mid: SUCCESS (2.844s)
[251.064114] [062/156] (786s left) gem_softpin (allocator-fork)
[251.121099] Starting subtest: allocator-fork
[253.335790] Subtest allocator-fork: SUCCESS (2.214s)
[253.480238] [063/156] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[253.589601] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[257.283445] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.699s)
[258.471824] [064/156] (779s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[258.562061] Starting subtest: compare-crc-sanitycheck-xr24
[258.564195] Starting dynamic subtest: pipe-A-eDP-1
[259.213374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.653s)
[259.226075] Starting dynamic subtest: pipe-B-eDP-1
[260.593742] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.376s)
[260.604448] Starting dynamic subtest: pipe-C-eDP-1
[261.859342] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.264s)
[261.869641] Starting dynamic subtest: pipe-D-eDP-1
[263.074636] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[263.076927] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.515s)
[263.907204] [065/156] (773s left) gem_pread (display)
[263.963664] Subtest display: SKIP (0.000s)
[264.022376] [066/156] (773s left) gem_userptr_blits (process-exit-busy)
[264.094046] Starting subtest: process-exit-busy
[264.106855] Subtest process-exit-busy: SUCCESS (0.014s)
[264.231988] [067/156] (773s left) kms_vrr (flip-suspend)
[264.328439] Starting subtest: flip-suspend
[264.335265] Subtest flip-suspend: SKIP (0.000s)
[264.404807] [068/156] (773s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[264.510811] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[264.515339] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[264.607496] [069/156] (773s left) core_debugfs (read-all-entries)
[264.652068] Starting subtest: read-all-entries
[264.735173] Subtest read-all-entries: SUCCESS (0.085s)
[264.829511] [070/156] (773s left) syncobj_timeline (etime-single-wait-all-submitted)
[264.879966] Starting subtest: etime-single-wait-all-submitted
[264.986329] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[265.072486] [071/156] (772s left) kms_dsc (dsc-fractional-bpp)
[265.159284] Starting subtest: dsc-fractional-bpp
[265.172284] Subtest dsc-fractional-bpp: SKIP (0.000s)
[265.235390] [072/156] (772s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[265.326336] Starting subtest: psr-rgb565-draw-pwrite
[272.434583] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.114s)
[272.548909] [073/156] (765s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[272.650895] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[272.655199] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[272.741033] [074/156] (765s left) kms_chamelium_color (ctm-0-25)
[272.828221] Subtest ctm-0-25: SKIP (0.000s)
[272.878181] [075/156] (765s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[272.988084] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[272.992290] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[273.075784] [076/156] (765s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[273.167998] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[273.172390] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[273.259791] [077/156] (765s left) prime_mmap (test_forked_cpu_write)
[273.312588] Starting subtest: test_forked_cpu_write
[273.314614] Starting dynamic subtest: test_forked_cpu_write-smem
[273.319196] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[273.321540] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[273.435904] [078/156] (764s left) kms_addfb_basic (too-high)
[273.519514] Starting subtest: too-high
[273.521506] Subtest too-high: SUCCESS (0.001s)
[273.618731] [079/156] (764s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[273.720178] Starting subtest: hdr-rgb101010-draw-blt
[273.723577] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s)
[273.819914] [080/156] (764s left) gem_exec_whisper (basic-contexts-all)
[273.887926] Starting subtest: basic-contexts-all
[285.128325] Subtest basic-contexts-all: SUCCESS (11.238s)
[285.318051] [081/156] (753s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[285.449569] Starting subtest: 2x-long-cursor-vs-flip-atomic
[285.453867] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[285.607546] [082/156] (752s left) gem_exec_flush (basic-wb-ro-default)
[285.671797] Starting subtest: basic-wb-ro-default
[291.130418] Subtest basic-wb-ro-default: SUCCESS (5.458s)
[291.321659] [083/156] (747s left) gen3_render_tiledy_blits
[291.434256] [084/156] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[291.532422] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[291.536383] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.627181] [085/156] (746s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[291.717722] Starting subtest: psr-2p-pri-indfb-multidraw
[291.722602] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[291.812866] [086/156] (746s left) kms_cursor_crc (cursor-onscreen-32x10)
[291.978451] Starting subtest: cursor-onscreen-32x10
[292.027196] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[292.305514] [087/156] (746s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[292.439426] Starting subtest: dp-mst-type-0-suspend-resume
[292.443386] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[292.562800] [088/156] (746s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-fullscreen)
[292.654088] Starting subtest: fbchdr-2p-primscrn-spr-indfb-fullscreen
[292.657652] Subtest fbchdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[292.742180] [089/156] (746s left) kms_addfb_basic (small-bo)
[292.833401] Starting subtest: small-bo
[292.835255] Subtest small-bo: SUCCESS (0.000s)
[292.923753] [090/156] (745s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[293.014696] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[293.018093] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[293.123888] [091/156] (745s left) gem_softpin (noreloc)
[293.189276] Starting subtest: noreloc
[298.613720] Subtest noreloc: SUCCESS (5.423s)
[298.723164] [092/156] (740s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[298.828242] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[298.832313] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[298.950733] [093/156] (739s left) kms_psr (psr2-sprite-render)
[299.038264] Starting subtest: psr2-sprite-render
[299.040456] Starting dynamic subtest: eDP-1
[300.811360] Dynamic subtest eDP-1: SUCCESS (1.773s)
[300.813702] Subtest psr2-sprite-render: SUCCESS (1.774s)
[301.675819] [094/156] (737s left) kms_plane_multiple (2x-tiling-y)
[301.764183] Starting subtest: 2x-tiling-y
[301.768162] Subtest 2x-tiling-y: SKIP (0.000s)
[301.837502] [095/156] (737s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[301.946244] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[301.950527] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[302.044759] [096/156] (737s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt)
[302.149594] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt
[302.153801] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[302.265612] [097/156] (736s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[302.367365] Starting subtest: plane-primary-toggle-with-vblank-wait
[302.369684] Starting dynamic subtest: pipe-A-eDP-1
[302.540477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[302.848655] Starting dynamic subtest: pipe-B-eDP-1
[303.775792] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.935s)
[304.087314] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.721s)
[304.941504] [098/156] (734s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[305.038307] Starting subtest: x-tiled-8bpp-rotate-0
[306.275382] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.236s)
[306.401167] [099/156] (732s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render)
[306.499679] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render
[306.503135] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[306.600573] [100/156] (732s left) kms_rotation_crc (primary-rotation-180)
[306.696131] Starting subtest: primary-rotation-180
[313.703145] Subtest primary-rotation-180: SUCCESS (7.008s)
[314.922528] [101/156] (724s left) i915_query (query-topology-known-pci-ids)
[314.989696] Starting subtest: query-topology-known-pci-ids
[314.994400] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[315.102577] [102/156] (724s left) kms_flip (blocking-absolute-wf_vblank)
[315.197529] Starting subtest: blocking-absolute-wf_vblank
[315.199477] Starting dynamic subtest: A-eDP1
[323.957292] Dynamic subtest A-eDP1: SUCCESS (8.761s)
[323.968718] Starting dynamic subtest: B-eDP1
[332.693248] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[332.713851] Starting dynamic subtest: C-eDP1
[341.415924] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[341.429676] Starting dynamic subtest: D-eDP1
[350.133685] Dynamic subtest D-eDP1: SUCCESS (8.716s)
[350.140556] Subtest blocking-absolute-wf_vblank: SUCCESS (34.943s)
[351.355718] [103/156] (688s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move)
[351.449694] Starting subtest: hdr-2p-primscrn-cur-indfb-move
[351.454021] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[351.556267] [104/156] (687s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[351.614430] Starting subtest: single-wait-for-submit-available-submitted
[351.616408] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[351.710867] [105/156] (687s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[351.804829] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[351.809192] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[351.895533] [106/156] (687s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[351.996988] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[352.001309] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[352.072824] [107/156] (687s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[352.125580] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[352.127879] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[352.224288] [108/156] (687s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[352.323240] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[352.327068] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[352.398077] [109/156] (687s left) drm_read (empty-nonblock)
[352.539499] Starting subtest: empty-nonblock
[352.541952] Subtest empty-nonblock: SUCCESS (0.000s)
[352.646297] [110/156] (687s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[352.754933] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[352.758575] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[352.859418] [111/156] (686s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[352.952737] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[352.956160] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[353.068617] [112/156] (686s left) kms_psr (fbc-psr2-primary-render)
[353.152547] Starting subtest: fbc-psr2-primary-render
[353.154552] Starting dynamic subtest: eDP-1
[353.158174] Dynamic subtest eDP-1: SKIP (0.000s)
[353.161820] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[353.237354] [113/156] (686s left) perf_pmu (idle-no-semaphores)
[353.275677] Starting subtest: idle-no-semaphores
[353.277290] Starting dynamic subtest: rcs0
[353.824596] Dynamic subtest rcs0: SUCCESS (0.548s)
[353.838436] Starting dynamic subtest: bcs0
[354.351644] Dynamic subtest bcs0: SUCCESS (0.524s)
[354.367524] Starting dynamic subtest: vcs0
[354.866618] Dynamic subtest vcs0: SUCCESS (0.512s)
[354.880734] Starting dynamic subtest: vcs1
[355.384357] Dynamic subtest vcs1: SUCCESS (0.514s)
[355.397718] Starting dynamic subtest: vecs0
[355.902111] Dynamic subtest vecs0: SUCCESS (0.515s)
[355.916179] Starting dynamic subtest: ccs0
[356.420067] Dynamic subtest ccs0: SUCCESS (0.515s)
[356.422722] Subtest idle-no-semaphores: SUCCESS (3.146s)
[356.536994] [114/156] (683s left) kms_flip (flip-vs-rmfb-interruptible)
[356.642727] Starting subtest: flip-vs-rmfb-interruptible
[356.644663] Starting dynamic subtest: A-eDP1
[365.337098] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[365.349612] Starting dynamic subtest: B-eDP1
[373.964501] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[373.977107] Starting dynamic subtest: C-eDP1
[382.592175] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[382.603746] Starting dynamic subtest: D-eDP1
[391.232478] Dynamic subtest D-eDP1: SUCCESS (8.639s)
[391.236954] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.594s)
[392.431240] [115/156] (647s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[392.526134] Starting subtest: primary-y-tiled-reflect-x-180
[392.596936] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s)
[392.702227] [116/156] (647s left) gem_exec_capture (capture-recoverable)
[392.771045] Starting subtest: capture-recoverable
[392.776350] Subtest capture-recoverable: SUCCESS (0.003s)
[392.895586] [117/156] (647s left) kms_getfb (getfb-addfb-different-handles)
[392.993211] Starting subtest: getfb-addfb-different-handles
[392.995472] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[393.103201] [118/156] (646s left) fbdev (info)
[393.141094] Starting subtest: info
[393.142880] Subtest info: SUCCESS (0.000s)
[393.207378] [119/156] (646s left) gem_flink_basic (basic)
[393.259795] Starting subtest: basic
[393.262151] Subtest basic: SUCCESS (0.000s)
[393.356725] [120/156] (646s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[393.460205] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[394.285385] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[394.459296] [121/156] (645s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[394.569590] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[394.573784] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[394.686289] [122/156] (645s left) kms_psr2_su (page_flip-nv12)
[394.747712] Subtest page_flip-NV12: SKIP (0.000s)
[394.806126] [123/156] (645s left) api_intel_bb (blit-reloc-purge-cache)
[394.869886] Starting subtest: blit-reloc-purge-cache
[394.874704] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[394.978812] [124/156] (645s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[395.068390] Starting subtest: pixel-format-y-tiled-ccs-modifier
[395.072540] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[395.144668] [125/156] (645s left) kms_hdr (bpc-switch)
[395.233316] Starting subtest: bpc-switch
[395.235445] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[399.773228] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.539s)
[399.786602] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[404.382610] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.608s)
[404.385040] Subtest bpc-switch: SUCCESS (9.150s)
[404.489245] [126/156] (635s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[404.585322] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[404.587568] Starting dynamic subtest: pipe-A-eDP-1
[404.733281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[404.748310] Starting dynamic subtest: pipe-B-eDP-1
[404.768241] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[404.778260] Starting dynamic subtest: pipe-C-eDP-1
[404.798260] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[404.808345] Starting dynamic subtest: pipe-D-eDP-1
[404.828152] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[404.830080] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.148s)
[407.005412] [127/156] (633s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[407.101430] Starting subtest: 4-tiled-32bpp-rotate-90
[407.120868] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[407.235630] [128/156] (633s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[407.342480] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[407.346635] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[407.454884] [129/156] (633s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[407.556493] Starting subtest: y-tiled-32bpp-rotate-270
[407.560592] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[407.667711] [130/156] (632s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[407.771413] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[407.775235] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[407.884990] [131/156] (632s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[407.978886] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[415.141235] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.167s)
[415.281647] [132/156] (625s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[415.347691] Starting subtest: invalid-bsd2-flag-on-blt
[415.349970] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[415.447130] [133/156] (625s left) kms_plane (plane-panning-top-left)
[415.545143] Starting subtest: plane-panning-top-left
[415.547439] Starting dynamic subtest: pipe-A
[417.240420] Dynamic subtest pipe-A: SUCCESS (1.693s)
[417.254961] Starting dynamic subtest: pipe-B
[419.715247] Dynamic subtest pipe-B: SUCCESS (2.475s)
[419.717630] Subtest plane-panning-top-left: SUCCESS (4.171s)
[420.604225] [134/156] (620s left) kms_selftest (drm_dp_mst_helper)
[420.645863] Starting subtest: drm_dp_mst_helper
[420.696542] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[420.823280] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.126s)
[420.834784] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[420.945850] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.121s)
[420.957276] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[421.054492] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.108s)
[421.056706] Subtest drm_dp_mst_helper: SUCCESS (0.407s)
[421.212792] [135/156] (619s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[421.332520] Starting subtest: 2x-long-flip-vs-cursor-legacy
[421.337108] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[421.490359] [136/156] (619s left) kms_cursor_edge_walk (64x64-right-edge)
[421.581642] Starting subtest: 64x64-right-edge
[421.583898] Starting dynamic subtest: pipe-A-eDP-1
[425.082613] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.502s)
[425.094717] Starting dynamic subtest: pipe-D-eDP-1
[428.311680] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.230s)
[428.313942] Subtest 64x64-right-edge: SUCCESS (6.734s)
[429.115523] [137/156] (611s left) gem_ctx_shared (exec-single-timeline)
[429.192982] Starting subtest: exec-single-timeline
[429.195445] Starting dynamic subtest: rcs0
[430.243092] Dynamic subtest rcs0: SUCCESS (1.048s)
[430.256883] Starting dynamic subtest: bcs0
[431.330621] Dynamic subtest bcs0: SUCCESS (1.084s)
[431.344479] Starting dynamic subtest: vcs0
[432.419482] Dynamic subtest vcs0: SUCCESS (1.085s)
[432.433801] Starting dynamic subtest: vcs1
[433.506916] Dynamic subtest vcs1: SUCCESS (1.084s)
[433.520697] Starting dynamic subtest: vecs0
[434.594838] Dynamic subtest vecs0: SUCCESS (1.085s)
[434.608867] Starting dynamic subtest: ccs0
[435.683521] Dynamic subtest ccs0: SUCCESS (1.085s)
[435.686960] Subtest exec-single-timeline: SUCCESS (6.490s)
[436.380502] [138/156] (604s left) syncobj_wait (wait-all-interrupted)
[436.441620] Starting subtest: wait-all-interrupted
[436.546340] Subtest wait-all-interrupted: SUCCESS (0.104s)
[436.625367] [139/156] (604s left) kms_invalid_mode (int-max-clock)
[436.732273] Starting subtest: int-max-clock
[436.734555] Starting dynamic subtest: pipe-A-eDP-1
[437.017347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[437.028950] Starting dynamic subtest: pipe-B-eDP-1
[437.031112] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[437.041615] Starting dynamic subtest: pipe-C-eDP-1
[437.043424] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[437.055697] Starting dynamic subtest: pipe-D-eDP-1
[437.057907] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[437.060141] Subtest int-max-clock: SUCCESS (0.292s)
[437.848622] [140/156] (603s left) gem_exec_schedule (u-fairslice)
[437.927226] Starting subtest: u-fairslice
[437.929245] Starting dynamic subtest: rcs0
[439.944887] Dynamic subtest rcs0: SUCCESS (2.024s)
[439.958153] Starting dynamic subtest: bcs0
[441.965081] Dynamic subtest bcs0: SUCCESS (2.019s)
[441.977256] Starting dynamic subtest: vcs0
[443.988434] Dynamic subtest vcs0: SUCCESS (2.023s)
[443.999034] Starting dynamic subtest: vcs1
[446.014011] Dynamic subtest vcs1: SUCCESS (2.022s)
[446.025195] Starting dynamic subtest: vecs0
[448.033761] Dynamic subtest vecs0: SUCCESS (2.020s)
[448.044376] Starting dynamic subtest: ccs0
[450.059612] Dynamic subtest ccs0: SUCCESS (2.026s)
[450.061842] Subtest u-fairslice: SUCCESS (12.140s)
[450.362901] [141/156] (590s left) kms_frontbuffer_tracking (hdr-2p-rte)
[450.480198] Starting subtest: hdr-2p-rte
[450.484311] Subtest hdr-2p-rte: SKIP (0.000s)
[450.600636] [142/156] (590s left) gem_exec_params (dr4-dirt)
[450.665419] Starting subtest: DR4-dirt
[450.667645] Subtest DR4-dirt: SUCCESS (0.000s)
[450.792894] [143/156] (590s left) gem_mmap_gtt (cpuset-medium-copy)
[450.847069] Subtest cpuset-medium-copy: SKIP (0.000s)
[450.912264] [144/156] (590s left) gem_fenced_exec_thrash (no-spare-fences)
[450.977159] Subtest no-spare-fences: SKIP (0.000s)
[451.054971] [145/156] (590s left) kms_flip (flip-vs-suspend-interruptible)
[451.149484] Starting subtest: flip-vs-suspend-interruptible
[451.151771] Starting dynamic subtest: A-eDP1
[612.197194] Dynamic subtest A-eDP1: SUCCESS (12.303s)
[612.200103] Subtest flip-vs-suspend-interruptible: SUCCESS (12.306s)
[612.335284] [146/156] (428s left) gem_ctx_persistence (file)
[612.392515] Starting subtest: file
[612.507340] Subtest file: SUCCESS (0.115s)
[612.633521] [147/156] (428s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[612.735290] Starting subtest: fbc-rgb565-draw-blt
[616.941435] Subtest fbc-rgb565-draw-blt: SUCCESS (4.251s)
[618.108251] [148/156] (423s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[618.211075] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[618.216076] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[618.307742] [149/156] (423s left) gem_exercise_blt (fast-copy)
[618.376914] Starting subtest: fast-copy
[618.379458] Starting dynamic subtest: linear-smem-smem
[618.398367] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[618.411175] Starting dynamic subtest: xmajor-smem-smem
[618.418168] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[618.431907] Starting dynamic subtest: tile4-smem-smem
[618.437438] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[618.448204] Starting dynamic subtest: tile64-smem-smem
[618.454487] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[618.457110] Subtest fast-copy: SUCCESS (0.081s)
[618.561975] [150/156] (422s left) syncobj_eventfd (invalid-illegal-handle)
[618.623477] Starting subtest: invalid-illegal-handle
[618.626197] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[618.709505] [151/156] (422s left) i915_pm_rps (thresholds-idle-park)
[618.777339] Starting subtest: thresholds-idle-park
[618.782817] Subtest thresholds-idle-park: SKIP (0.001s)
[618.881463] [152/156] (422s left) kms_chamelium_frames (hdmi-crc-fast)
[619.265822] Subtest hdmi-crc-fast: SKIP (0.000s)
[620.108549] [153/156] (421s left) kms_flip (2x-plain-flip-interruptible)
[620.194522] Starting subtest: 2x-plain-flip-interruptible
[620.206377] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[620.281267] [154/156] (421s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[620.373006] Starting subtest: fbcpsrhdr-stridechange
[620.377892] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[620.473534] [155/156] (421s left) gem_exec_reloc (basic-wc-active)
[620.527444] Subtest basic-wc-active: SKIP (0.000s)
[620.605046] [156/156] (421s left) perf (oa-formats)
[620.697689] Starting subtest: oa-formats
[620.699909] Starting dynamic subtest: 0-rcs0
[620.710061] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[620.722214] Starting dynamic subtest: 1-vcs1
[620.733790] Dynamic subtest 1-vcs1: SUCCESS (0.024s)
[620.736428] Subtest oa-formats: SUCCESS (0.040s)
[620.777071] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_linear_blits
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_dp_linktrain_fallback
results: parsing output: 4/ for test: kms_chamelium_hpd
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: i915_pm_rpm
results: parsing output: 9/ for test: gem_render_copy
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: prime_vgem
results: parsing output: 12/ for test: gem_pxp
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_pm_dc
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_mmap_offset
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_pm_rpm
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: gem_readwrite
results: parsing output: 30/ for test: kms_color
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_universal_plane
results: parsing output: 35/ for test: gem_wait
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_pm_backlight
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_properties
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: i915_drm_fdinfo
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gen7_exec_parse
results: parsing output: 49/ for test: kms_atomic
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: core_sysfs
results: parsing output: 52/ for test: gem_readwrite
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_create
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_busy
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: vgem_basic
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_plane_alpha_blend
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_pipe_crc_basic
results: parsing output: 64/ for test: gem_pread
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: kms_vrr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: core_debugfs
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_dsc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_chamelium_color
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_exec_flush
results: parsing output: 82/ for test: gen3_render_tiledy_blits
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_softpin
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_plane_multiple
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_atomic_transition
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: i915_query
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: drm_read
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: gem_exec_capture
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: fbdev
results: parsing output: 118/ for test: gem_flink_basic
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr2_su
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: kms_hdr
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_params
results: parsing output: 132/ for test: kms_plane
results: parsing output: 133/ for test: kms_selftest
results: parsing output: 134/ for test: kms_cursor_legacy
results: parsing output: 135/ for test: kms_cursor_edge_walk
results: parsing output: 136/ for test: gem_ctx_shared
results: parsing output: 137/ for test: syncobj_wait
results: parsing output: 138/ for test: kms_invalid_mode
results: parsing output: 139/ for test: gem_exec_schedule
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_exec_params
results: parsing output: 142/ for test: gem_mmap_gtt
results: parsing output: 143/ for test: gem_fenced_exec_thrash
results: parsing output: 144/ for test: kms_flip
results: parsing output: 145/ for test: gem_ctx_persistence
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_exercise_blt
results: parsing output: 149/ for test: syncobj_eventfd
results: parsing output: 150/ for test: i915_pm_rps
results: parsing output: 151/ for test: kms_chamelium_frames
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_exec_reloc
results: parsing output: 155/ for test: perf
Done.