[59.966420] Initializing watchdogs
[59.966469]   /dev/watchdog0
[59.980852] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.985215] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.987354] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.989116] [001/131] (960s left) i915_pm_rc6_residency (media-rc6-accuracy)
[60.045186] Starting subtest: media-rc6-accuracy
[60.047701] Subtest media-rc6-accuracy: SKIP (0.000s)
[60.151827] [002/131] (960s left) kms_pm_rpm (modeset-lpsp-stress)
[62.083559] Starting subtest: modeset-lpsp-stress
[78.701065] Subtest modeset-lpsp-stress: SUCCESS (16.635s)
[78.814589] [003/131] (941s left) gem_mmap_gtt (big-bo-tiledx)
[78.874073] Subtest big-bo-tiledX: SKIP (0.000s)
[78.939921] [004/131] (941s left) kms_cursor_crc (cursor-offscreen-32x32)
[79.081822] Starting subtest: cursor-offscreen-32x32
[79.124902] Subtest cursor-offscreen-32x32: SKIP (0.042s)
[79.424379] [005/131] (941s left) syncobj_timeline (multi-wait-available-signaled)
[79.475090] Starting subtest: multi-wait-available-signaled
[79.476091] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[79.593218] [006/131] (941s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[79.688356] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[79.690060] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[79.822635] [007/131] (940s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[79.912965] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[79.914023] Starting dynamic subtest: pipe-A-eDP-1
[79.933908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[79.940236] Starting dynamic subtest: pipe-B-eDP-1
[79.954843] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[79.960512] Starting dynamic subtest: pipe-C-eDP-1
[79.975604] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[79.983087] Starting dynamic subtest: pipe-D-eDP-1
[79.996404] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[79.997276] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.084s)
[82.239011] [008/131] (938s left) gem_mmap (bad-object)
[82.290987] Subtest bad-object: SKIP (0.000s)
[82.357379] [009/131] (938s left) kms_fb_coherency (memset-crc)
[82.455141] Starting subtest: memset-crc
[82.455950] Starting dynamic subtest: mmap-offset-wc
[82.795924] Dynamic subtest mmap-offset-wc: CRASH (0.147s)
[83.007817] Subtest memset-crc: CRASH (0.327s)
[83.031601] [010/131] (937s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[83.147319] Starting subtest: basic-busy-flip-before-cursor-legacy
[83.148948] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[83.305964] [011/131] (937s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[83.398919] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[83.399878] Starting dynamic subtest: pipe-A-eDP-1
[83.409075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.415170] Starting dynamic subtest: pipe-B-eDP-1
[83.425066] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.430471] Starting dynamic subtest: pipe-C-eDP-1
[83.439758] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.445440] Starting dynamic subtest: pipe-D-eDP-1
[83.454749] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.456435] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[85.699855] [012/131] (935s left) syncobj_timeline (wait-delayed-signal)
[85.767482] Starting subtest: wait-delayed-signal
[85.873049] Subtest wait-delayed-signal: SUCCESS (0.102s)
[85.985255] [013/131] (934s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[86.108718] Starting subtest: protected-encrypted-src-copy-not-readible
[86.222034] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s)
[86.399205] [014/131] (934s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[86.503184] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[90.769935] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.266s)
[91.889257] [015/131] (929s left) gem_exec_reloc (basic-wc-read)
[91.944167] Subtest basic-wc-read: SKIP (0.000s)
[92.026193] [016/131] (928s left) perf_pmu (rc6-suspend)
[92.064249] Starting subtest: rc6-suspend
[114.804339] Subtest rc6-suspend: SUCCESS (12.419s)
[117.185315] [017/131] (905s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[117.282111] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[117.283274] Starting dynamic subtest: pipe-A-default-mode
[120.000785] Dynamic subtest pipe-A-default-mode: SUCCESS (2.754s)
[120.001849] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.755s)
[120.841025] [018/131] (902s left) gem_exec_reloc (basic-write-read-active)
[120.895580] Subtest basic-write-read-active: SKIP (0.000s)
[120.986038] [019/131] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[121.079736] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[121.081682] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[121.204786] [020/131] (901s left) gem_wait (wait)
[121.272314] Starting subtest: wait
[121.273473] Starting dynamic subtest: all-engines
[123.238462] Dynamic subtest all-engines: SUCCESS (1.983s)
[123.250693] Starting dynamic subtest: rcs0
[124.284122] Dynamic subtest rcs0: SUCCESS (1.056s)
[124.295792] Starting dynamic subtest: bcs0
[125.330376] Dynamic subtest bcs0: SUCCESS (1.052s)
[125.339153] Starting dynamic subtest: vcs0
[126.376577] Dynamic subtest vcs0: SUCCESS (1.052s)
[126.385644] Starting dynamic subtest: vcs1
[127.421758] Dynamic subtest vcs1: SUCCESS (1.050s)
[127.430969] Starting dynamic subtest: vecs0
[128.465956] Dynamic subtest vecs0: SUCCESS (1.048s)
[128.475603] Starting dynamic subtest: ccs0
[129.512666] Dynamic subtest ccs0: SUCCESS (1.050s)
[129.514202] Subtest wait: SUCCESS (8.299s)
[129.752401] [021/131] (893s left) gem_flink_basic (double-flink)
[129.794472] Starting subtest: double-flink
[129.795467] Subtest double-flink: SUCCESS (0.000s)
[129.924842] [022/131] (893s left) vgem_slow (nohang)
[129.996448] Starting subtest: nohang
[140.483983] Subtest nohang: SUCCESS (10.509s)
[140.563275] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[140.565040] [023/131] (882s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[140.659113] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[140.660025] Starting dynamic subtest: pipe-A-default-mode
[141.797821] Dynamic subtest pipe-A-default-mode: SKIP (1.138s)
[141.799644] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.140s)
[141.969316] [024/131] (881s left) gem_exec_schedule (wide)
[142.156796] Starting subtest: wide
[142.158377] Starting dynamic subtest: rcs0
[152.799767] Dynamic subtest rcs0: SUCCESS (10.643s)
[152.811567] Starting dynamic subtest: vcs0
[164.393182] Dynamic subtest vcs0: SUCCESS (11.590s)
[164.404127] Starting dynamic subtest: vcs1
[179.637616] Dynamic subtest vcs1: SUCCESS (15.246s)
[179.648163] Starting dynamic subtest: vecs0
[194.966517] Dynamic subtest vecs0: SUCCESS (15.332s)
[194.977236] Starting dynamic subtest: ccs0
[213.654489] Dynamic subtest ccs0: SUCCESS (18.692s)
[213.655564] Subtest wide: SUCCESS (71.507s)
[217.008161] [025/131] (806s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[217.107543] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[224.127537] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.019s)
[224.271249] [026/131] (799s left) gem_ctx_persistence (saturated-hostile)
[224.328894] Starting subtest: saturated-hostile
[224.329949] Starting dynamic subtest: rcs0
[225.149828] Dynamic subtest rcs0: SUCCESS (0.819s)
[225.159803] Starting dynamic subtest: bcs0
[225.954834] Dynamic subtest bcs0: SUCCESS (0.805s)
[225.965124] Starting dynamic subtest: vcs0
[226.747699] Dynamic subtest vcs0: SUCCESS (0.791s)
[226.758418] Starting dynamic subtest: vcs1
[227.533711] Dynamic subtest vcs1: SUCCESS (0.783s)
[227.543410] Starting dynamic subtest: vecs0
[228.333347] Dynamic subtest vecs0: SUCCESS (0.800s)
[228.343858] Starting dynamic subtest: ccs0
[229.184959] Dynamic subtest ccs0: SUCCESS (0.850s)
[229.186404] Subtest saturated-hostile: SUCCESS (4.856s)
[229.282317] [027/131] (794s left) gem_mmap_gtt (fault-concurrent-y)
[229.337327] Subtest fault-concurrent-Y: SKIP (0.000s)
[229.397880] [028/131] (793s left) i915_query (test-query-geometry-subslices)
[229.444997] Starting subtest: test-query-geometry-subslices
[229.445931] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[229.563771] [029/131] (793s left) perf (global-sseu-config-invalid)
[229.694945] Starting subtest: global-sseu-config-invalid
[229.696614] Subtest global-sseu-config-invalid: SKIP (0.000s)
[229.729931] [030/131] (793s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[229.824109] Starting subtest: fbcpsr-rgb565-draw-render
[236.835038] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.011s)
[237.012147] [031/131] (786s left) vgem_basic (dmabuf-fence-before)
[237.044848] Starting subtest: dmabuf-fence-before
[237.045964] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[237.121681] [032/131] (786s left) gem_exec_params (secure-non-root)
[237.182343] Starting subtest: secure-non-root
[237.184225] Subtest secure-non-root: SKIP (0.000s)
[237.308259] [033/131] (786s left) sw_sync (sync_expired_merge)
[237.342836] Starting subtest: sync_expired_merge
[238.418320] Subtest sync_expired_merge: SUCCESS (1.074s)
[238.496938] [034/131] (785s left) prime_mmap (test_reprime)
[238.545784] Starting subtest: test_reprime
[238.546768] Starting dynamic subtest: test_reprime-smem
[238.575990] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[238.577128] Subtest test_reprime: SUCCESS (0.032s)
[238.711095] [035/131] (784s left) gem_ctx_param (basic)
[238.758702] Starting subtest: basic
[238.759756] Subtest basic: SUCCESS (0.001s)
[238.886119] [036/131] (784s left) sysfs_heartbeat_interval (nopreempt)
[238.946988] Starting subtest: nopreempt
[238.947986] Starting dynamic subtest: vecs0
[247.235457] Dynamic subtest vecs0: SUCCESS (8.284s)
[247.245666] Starting dynamic subtest: ccs0
[251.230918] Dynamic subtest ccs0: SUCCESS (3.997s)
[251.240687] Starting dynamic subtest: vcs0
[260.225679] Dynamic subtest vcs0: SUCCESS (8.995s)
[260.233814] Starting dynamic subtest: bcs0
[264.231053] Dynamic subtest bcs0: SUCCESS (4.004s)
[264.241319] Starting dynamic subtest: rcs0
[268.309985] Dynamic subtest rcs0: SUCCESS (4.078s)
[268.319701] Starting dynamic subtest: vcs1
[278.273492] Dynamic subtest vcs1: SUCCESS (9.962s)
[278.274947] Subtest nopreempt: SUCCESS (39.328s)
[278.366030] [037/131] (745s left) kms_plane_multiple (2x-tiling-y)
[278.464462] Starting subtest: 2x-tiling-y
[278.466439] Subtest 2x-tiling-y: SKIP (0.000s)
[278.554511] [038/131] (745s left) gem_exec_balancer (bonded-semaphore)
[278.624911] Starting subtest: bonded-semaphore
[278.626928] Subtest bonded-semaphore: SKIP (0.000s)
[278.929648] [039/131] (744s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[279.032005] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[279.033874] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[279.155586] [040/131] (744s left) kms_cursor_crc (cursor-sliding-512x512)
[279.433343] Starting subtest: cursor-sliding-512x512
[279.435123] Subtest cursor-sliding-512x512: SKIP (0.001s)
[279.639403] [041/131] (744s left) kms_invalid_mode (bad-hsync-start)
[279.735922] Starting subtest: bad-hsync-start
[279.736875] Starting dynamic subtest: pipe-A-eDP-1
[280.029029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[280.037310] Starting dynamic subtest: pipe-B-eDP-1
[280.038174] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[280.046396] Starting dynamic subtest: pipe-C-eDP-1
[280.047170] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[280.054296] Starting dynamic subtest: pipe-D-eDP-1
[280.055099] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[280.055974] Subtest bad-hsync-start: SUCCESS (0.298s)
[280.916404] [042/131] (742s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[280.966743] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[281.074521] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[281.167472] [043/131] (742s left) kms_pm_rpm (i2c)
[283.295846] Starting subtest: i2c
[288.301452] Subtest i2c: SUCCESS (5.007s)
[288.413383] [044/131] (735s left) kms_atomic (atomic-plane-damage)
[288.508141] Starting subtest: atomic-plane-damage
[288.562525] Starting dynamic subtest: pipe-A-eDP-1
[289.130384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[289.131302] Subtest atomic-plane-damage: SUCCESS (0.623s)
[290.022477] [045/131] (733s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[290.120516] Starting subtest: 4-tiled-8bpp-rotate-270
[290.142491] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[290.297291] [046/131] (733s left) kms_chamelium_hpd (dp-hpd-storm)
[290.681357] Subtest dp-hpd-storm: SKIP (0.000s)
[291.506939] [047/131] (732s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[291.606684] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[291.618523] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[291.732373] [048/131] (732s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[291.835289] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[292.716330] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.881s)
[292.932466] [049/131] (731s left) kms_psr (psr-primary-page-flip)
[293.020176] Starting subtest: psr-primary-page-flip
[293.020983] Starting dynamic subtest: eDP-1
[294.743230] Dynamic subtest eDP-1: SUCCESS (1.723s)
[294.744238] Subtest psr-primary-page-flip: SUCCESS (1.724s)
[295.615637] [050/131] (728s left) prime_busy (hang)
[295.666444] Starting subtest: hang
[295.667473] Starting dynamic subtest: rcs0
[321.732674] Dynamic subtest rcs0: SUCCESS (26.072s)
[321.742829] Starting dynamic subtest: bcs0
[328.904938] Dynamic subtest bcs0: SUCCESS (7.172s)
[328.913007] Starting dynamic subtest: vcs0
[335.862020] Dynamic subtest vcs0: SUCCESS (6.958s)
[335.869986] Starting dynamic subtest: vcs1
[342.908404] Dynamic subtest vcs1: SUCCESS (7.046s)
[342.916337] Starting dynamic subtest: vecs0
[349.892634] Dynamic subtest vecs0: SUCCESS (6.980s)
[349.903012] Starting dynamic subtest: ccs0
[363.778568] Dynamic subtest ccs0: SUCCESS (13.879s)
[363.781125] Subtest hang: SUCCESS (68.117s)
[363.943848] [051/131] (660s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[364.053515] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[364.890370] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.836s)
[365.177000] [052/131] (658s left) kms_flip (flip-vs-modeset-vs-hang)
[365.268705] Starting subtest: flip-vs-modeset-vs-hang
[365.269677] Starting dynamic subtest: A-eDP1
[416.702704] Dynamic subtest A-eDP1: SUCCESS (51.425s)
[416.712768] Starting dynamic subtest: D-eDP1
[466.735369] Dynamic subtest D-eDP1: SUCCESS (50.035s)
[466.738104] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.466s)
[467.146214] [053/131] (557s left) kms_psr (psr-primary-mmap-cpu)
[467.247622] Starting subtest: psr-primary-mmap-cpu
[467.248552] Starting dynamic subtest: eDP-1
[469.022494] Dynamic subtest eDP-1: SUCCESS (1.775s)
[469.023454] Subtest psr-primary-mmap-cpu: SUCCESS (1.776s)
[469.912226] [054/131] (554s left) kms_cursor_crc (cursor-random-32x32)
[470.076750] Starting subtest: cursor-random-32x32
[470.116770] Subtest cursor-random-32x32: SKIP (0.038s)
[470.426213] [055/131] (553s left) kms_selftest (drm_format_helper)
[470.455785] Starting subtest: drm_format_helper
[470.496232] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[470.636357] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.140s)
[470.646064] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[470.779455] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.142s)
[470.788477] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[470.903491] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.123s)
[470.911870] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[471.025171] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.121s)
[471.033875] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[471.154254] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.128s)
[471.163659] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[471.308412] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.153s)
[471.317366] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[471.409649] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.102s)
[471.418994] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[471.541278] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.130s)
[471.550430] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[471.676164] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.133s)
[471.684015] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[471.796548] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.121s)
[471.804429] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[471.878475] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.082s)
[471.888218] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[471.993399] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.113s)
[472.001704] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[472.129266] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.136s)
[472.138196] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[472.267309] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.136s)
[472.276873] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[472.420129] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.152s)
[472.430804] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[472.555211] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.134s)
[472.571791] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[472.684907] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.129s)
[472.685816] Subtest drm_format_helper: SUCCESS (2.230s)
[472.908454] [056/131] (551s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[472.966955] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[472.968110] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[473.104342] [057/131] (551s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[473.213996] Starting subtest: y-tiled-16bpp-rotate-180
[473.215910] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[473.336870] [058/131] (551s left) gem_reg_read (timestamp-moving)
[473.398499] Starting subtest: timestamp-moving
[474.402043] Subtest timestamp-moving: SUCCESS (1.001s)
[474.494909] [059/131] (549s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[474.563520] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[474.623554] [060/131] (549s left) gem_exec_params (no-bsd)
[474.685425] Starting subtest: no-bsd
[474.688143] Subtest no-bsd: SUCCESS (0.002s)
[476.338201] [061/131] (548s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[476.432724] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[476.443975] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[476.540119] [062/131] (547s left) kms_atomic_interruptible (universal-setplane-cursor)
[476.624399] Starting subtest: universal-setplane-cursor
[476.625308] Starting dynamic subtest: pipe-A-eDP-1
[483.998924] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.375s)
[483.999940] Subtest universal-setplane-cursor: SUCCESS (7.376s)
[484.864346] [063/131] (539s left) kms_lease (atomic-implicit-crtc)
[484.949531] Starting subtest: atomic-implicit-crtc
[484.950457] Starting dynamic subtest: pipe-A-eDP-1
[484.955111] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[484.965330] Starting dynamic subtest: pipe-B-eDP-1
[484.969947] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[484.978926] Starting dynamic subtest: pipe-C-eDP-1
[484.983741] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[484.993594] Starting dynamic subtest: pipe-D-eDP-1
[484.997739] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[484.998593] Subtest atomic-implicit-crtc: SUCCESS (0.032s)
[485.102500] [064/131] (539s left) gem_exec_schedule (pi-common)
[485.283803] Starting subtest: pi-common
[485.284623] Starting dynamic subtest: rcs0
[485.308865] Dynamic subtest rcs0: SUCCESS (0.025s)
[485.320425] Starting dynamic subtest: bcs0
[485.335864] Dynamic subtest bcs0: SUCCESS (0.026s)
[485.347262] Starting dynamic subtest: vcs0
[485.361584] Dynamic subtest vcs0: SUCCESS (0.025s)
[485.369532] Starting dynamic subtest: vcs1
[485.387764] Dynamic subtest vcs1: SUCCESS (0.025s)
[485.399214] Starting dynamic subtest: vecs0
[485.413874] Dynamic subtest vecs0: SUCCESS (0.025s)
[485.425444] Starting dynamic subtest: ccs0
[485.439876] Dynamic subtest ccs0: SUCCESS (0.025s)
[485.440718] Subtest pi-common: SUCCESS (0.157s)
[485.693819] [065/131] (538s left) prime_mmap (test_correct)
[485.742195] Starting subtest: test_correct
[485.743014] Starting dynamic subtest: test_correct-smem
[485.774369] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[485.775355] Subtest test_correct: SUCCESS (0.033s)
[485.887285] [066/131] (538s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[485.974294] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[492.450949] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.475s)
[492.596182] [067/131] (532s left) sw_sync (sync_random_merge)
[492.624330] Starting subtest: sync_random_merge
[492.662984] Subtest sync_random_merge: SUCCESS (0.038s)
[492.749878] [068/131] (531s left) kms_psr (fbc-psr2-basic)
[492.845242] Starting subtest: fbc-psr2-basic
[492.846159] Starting dynamic subtest: eDP-1
[492.847974] Dynamic subtest eDP-1: SKIP (0.000s)
[492.849772] Subtest fbc-psr2-basic: SKIP (0.001s)
[492.938866] [069/131] (531s left) kms_psr (fbc-psr-primary-render)
[493.049967] Starting subtest: fbc-psr-primary-render
[493.052169] Starting dynamic subtest: eDP-1
[493.054033] Dynamic subtest eDP-1: SKIP (0.000s)
[493.055904] Subtest fbc-psr-primary-render: SKIP (0.003s)
[493.147664] [070/131] (531s left) gem_huc_copy (huc-copy)
[493.223493] Starting subtest: huc-copy
[493.226978] Subtest huc-copy: SUCCESS (0.003s)
[493.417185] [071/131] (531s left) kms_content_protection (lic-type-0)
[493.558498] Starting subtest: lic-type-0
[493.560532] Subtest lic-type-0: SKIP (0.000s)
[493.713173] [072/131] (531s left) gem_eio (reset-stress)
[493.934386] Starting subtest: reset-stress
[493.935285] Starting dynamic subtest: render
[498.919300] Dynamic subtest render: SUCCESS (4.984s)
[498.933918] Starting dynamic subtest: bsd1
[516.703846] Dynamic subtest bsd1: SUCCESS (17.785s)
[516.719695] Starting dynamic subtest: bsd2
[534.727813] Dynamic subtest bsd2: SUCCESS (18.026s)
[534.743351] Starting dynamic subtest: blt
[534.745357] Dynamic subtest blt: SKIP (0.000s)
[534.753375] Starting dynamic subtest: vebox
[552.773833] Dynamic subtest vebox: SUCCESS (18.046s)
[552.775111] Subtest reset-stress: SUCCESS (58.847s)
[554.269939] [073/131] (470s left) kms_vblank (wait-forked-busy-hang)
[554.369482] Starting subtest: wait-forked-busy-hang
[554.370422] Starting dynamic subtest: pipe-A-eDP-1
[556.271358] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.902s)
[556.281809] Starting dynamic subtest: pipe-D-eDP-1
[558.818114] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[558.819012] Subtest wait-forked-busy-hang: SUCCESS (4.450s)
[559.642334] [074/131] (465s left) kms_plane_scaling (2x-scaler-multi-pipe)
[559.736426] Starting subtest: 2x-scaler-multi-pipe
[559.738146] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[559.868550] [075/131] (465s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[559.930773] Starting subtest: y-tiled-to-vebox-yf-tiled
[559.932676] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[560.131297] [076/131] (464s left) gem_create (create-ext-placement-all)
[560.304549] Starting subtest: create-ext-placement-all
[560.305666] Subtest create-ext-placement-all: SUCCESS (0.000s)
[560.439149] [077/131] (464s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[560.534219] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[560.535111] Starting dynamic subtest: pipe-A-default-mode
[560.821148] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[560.822996] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.286s)
[561.667492] [078/131] (463s left) gen7_exec_parse (cmd-crossing-page)
[561.727598] Subtest cmd-crossing-page: SKIP (0.000s)
[561.797826] [079/131] (463s left) gem_shrink (reclaim)
[561.856593] Starting subtest: reclaim
[564.331473] Subtest reclaim: SUCCESS (2.473s)
[564.527444] [080/131] (460s left) kms_frontbuffer_tracking (fbc-tiling-4)
[564.621662] Starting subtest: fbc-tiling-4
[568.914953] Subtest fbc-tiling-4: SUCCESS (4.294s)
[570.079026] [081/131] (455s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[570.175128] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[570.175960] Starting dynamic subtest: pipe-A-eDP-1
[570.322981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[570.333300] Starting dynamic subtest: pipe-B-eDP-1
[570.340559] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[570.349116] Starting dynamic subtest: pipe-C-eDP-1
[570.357447] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[570.367695] Starting dynamic subtest: pipe-D-eDP-1
[570.375554] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[570.376404] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.181s)
[572.641616] [082/131] (452s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[573.017006] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[573.825477] [083/131] (451s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[573.920842] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[573.922630] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[574.032735] [084/131] (451s left) i915_drm_fdinfo (all-busy-check-all)
[574.069338] Starting subtest: all-busy-check-all
[574.074602] Subtest all-busy-check-all: SKIP (0.004s)
[574.165972] [085/131] (451s left) gem_ctx_shared (q-out-order)
[574.272943] Starting subtest: Q-out-order
[574.274117] Starting dynamic subtest: rcs0
[574.394932] Dynamic subtest rcs0: SUCCESS (0.120s)
[574.410630] Starting dynamic subtest: vcs0
[574.470927] Dynamic subtest vcs0: SUCCESS (0.077s)
[574.487645] Starting dynamic subtest: vcs1
[574.544410] Dynamic subtest vcs1: SUCCESS (0.073s)
[574.559009] Starting dynamic subtest: vecs0
[574.623786] Dynamic subtest vecs0: SUCCESS (0.078s)
[574.639912] Starting dynamic subtest: ccs0
[574.715989] Dynamic subtest ccs0: SUCCESS (0.090s)
[574.717379] Subtest Q-out-order: SUCCESS (0.442s)
[576.369004] [086/131] (448s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[576.452506] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[576.453395] Starting dynamic subtest: pipe-A-eDP-1
[576.457506] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[576.467911] Starting dynamic subtest: pipe-B-eDP-1
[576.471483] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[576.480032] Starting dynamic subtest: pipe-C-eDP-1
[576.483596] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[576.491771] Starting dynamic subtest: pipe-D-eDP-1
[576.495100] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[576.496815] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[578.647292] [087/131] (446s left) gem_exec_flush (basic-wb-ro-default)
[578.720908] Starting subtest: basic-wb-ro-default
[584.179197] Subtest basic-wb-ro-default: SUCCESS (5.461s)
[584.384101] [088/131] (441s left) gem_busy (extended)
[584.576705] Starting subtest: extended
[584.577870] Starting dynamic subtest: rcs0
[584.696657] Dynamic subtest rcs0: SUCCESS (0.120s)
[584.707796] Starting dynamic subtest: bcs0
[584.738672] Dynamic subtest bcs0: SUCCESS (0.041s)
[584.749845] Starting dynamic subtest: vcs0
[586.214736] Dynamic subtest vcs0: SUCCESS (1.472s)
[586.226663] Starting dynamic subtest: vcs1
[588.262519] Dynamic subtest vcs1: SUCCESS (2.045s)
[588.273854] Starting dynamic subtest: vecs0
[590.246694] Dynamic subtest vecs0: SUCCESS (1.982s)
[590.258367] Starting dynamic subtest: ccs0
[590.290798] Dynamic subtest ccs0: SUCCESS (0.044s)
[590.291812] Subtest extended: SUCCESS (5.716s)
[590.564840] [089/131] (434s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[590.660003] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[590.661907] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[590.778982] [090/131] (434s left) api_intel_allocator (two-level-inception-interruptible)
[590.836170] Starting subtest: two-level-inception-interruptible
[596.251928] Subtest two-level-inception-interruptible: SUCCESS (5.415s)
[596.375199] [091/131] (429s left) gem_exec_balancer (waits)
[596.448811] Starting subtest: waits
[603.274723] Subtest waits: SUCCESS (6.820s)
[603.617102] [092/131] (421s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[603.710158] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[603.712568] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[604.883215] [093/131] (420s left) gem_softpin (allocator-nopin-reserve)
[604.936658] Starting subtest: allocator-nopin-reserve
[605.047759] Subtest allocator-nopin-reserve: SUCCESS (0.109s)
[605.216830] [094/131] (420s left) gem_exec_reloc (basic-cpu)
[605.269981] Subtest basic-cpu: SKIP (0.000s)
[605.340914] [095/131] (420s left) kms_debugfs (display-on-read-all)
[605.432851] Starting subtest: display-on-read-all
[605.587969] Subtest display-on-read-all: SUCCESS (0.156s)
[605.769694] [096/131] (419s left) kms_plane (plane-position-hole-dpms)
[605.847727] Starting subtest: plane-position-hole-dpms
[606.369535] Starting dynamic subtest: pipe-A-plane-1
[608.752260] Dynamic subtest pipe-A-plane-1: SUCCESS (2.381s)
[608.760605] Starting dynamic subtest: pipe-A-plane-2
[611.109848] Dynamic subtest pipe-A-plane-2: SUCCESS (2.355s)
[611.118583] Starting dynamic subtest: pipe-A-plane-3
[613.554695] Dynamic subtest pipe-A-plane-3: SUCCESS (2.441s)
[613.563485] Starting dynamic subtest: pipe-A-plane-4
[615.954325] Dynamic subtest pipe-A-plane-4: SUCCESS (2.398s)
[615.963029] Starting dynamic subtest: pipe-A-plane-5
[615.979089] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[617.131238] Starting dynamic subtest: pipe-B-plane-1
[619.386436] Dynamic subtest pipe-B-plane-1: SUCCESS (2.262s)
[619.395490] Starting dynamic subtest: pipe-B-plane-2
[621.665908] Dynamic subtest pipe-B-plane-2: SUCCESS (2.276s)
[621.676048] Starting dynamic subtest: pipe-B-plane-3
[624.063698] Dynamic subtest pipe-B-plane-3: SUCCESS (2.396s)
[624.072652] Starting dynamic subtest: pipe-B-plane-4
[626.312357] Dynamic subtest pipe-B-plane-4: SUCCESS (2.247s)
[626.321464] Starting dynamic subtest: pipe-B-plane-5
[626.337520] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[626.338447] Subtest plane-position-hole-dpms: SUCCESS (20.478s)
[627.155175] [097/131] (398s left) gem_lmem_swapping (parallel-random-verify)
[627.201817] Subtest parallel-random-verify: SKIP (0.000s)
[627.240745] [098/131] (398s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[627.340386] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[634.112591] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.770s)
[634.265585] [099/131] (391s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[634.363242] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[634.364945] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[634.491241] [100/131] (391s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[634.592659] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[634.594420] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[634.723983] [101/131] (391s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[634.818170] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[634.819927] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[634.946707] [102/131] (390s left) gem_flink_basic (bad-open)
[635.004223] Starting subtest: bad-open
[635.005274] Subtest bad-open: SUCCESS (0.000s)
[635.132611] [103/131] (390s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[635.249504] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[635.251397] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[635.375488] [104/131] (390s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[635.434163] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[635.512185] [105/131] (390s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[635.621968] Starting subtest: cursor-vs-flip-legacy
[664.934130] Subtest cursor-vs-flip-legacy: SUCCESS (29.302s)
[665.821611] [106/131] (360s left) gem_exec_schedule (preempt-queue-contexts-chain)
[665.899384] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[666.238054] [107/131] (359s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[666.339809] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[670.799157] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.459s)
[671.969686] [108/131] (354s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[672.063692] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[672.065366] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[672.184472] [109/131] (353s left) gem_exec_fence (syncobj-invalid-wait)
[672.600686] Starting subtest: syncobj-invalid-wait
[672.601665] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[674.348174] [110/131] (351s left) kms_psr (fbc-pr-cursor-blt)
[674.451437] Starting subtest: fbc-pr-cursor-blt
[674.453159] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[674.545761] [111/131] (351s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[674.636996] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[681.591368] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.954s)
[681.757492] [112/131] (344s left) kms_psr (psr2-basic)
[681.856241] Starting subtest: psr2-basic
[681.857053] Starting dynamic subtest: eDP-1
[683.502051] Dynamic subtest eDP-1: SUCCESS (1.645s)
[683.502978] Subtest psr2-basic: SUCCESS (1.646s)
[684.328515] [113/131] (342s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[684.394470] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[684.395509] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[684.525477] [114/131] (341s left) gem_ctx_param (invalid-set-no-zeromap)
[684.583832] Starting subtest: invalid-set-no-zeromap
[684.585008] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[684.675603] [115/131] (341s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[684.768667] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[685.460623] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[685.687029] [116/131] (340s left) drm_buddy (drm_buddy)
[685.715460] Starting subtest: drm_buddy
[685.730129] Starting dynamic subtest: drm_test_buddy_alloc_limit
[685.871443] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.141s)
[685.881070] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[686.012189] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.137s)
[686.020344] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[686.131210] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.118s)
[686.145485] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[686.264537] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.133s)
[686.272690] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[686.378085] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.113s)
[686.386356] Starting dynamic subtest: drm_test_buddy_alloc_clear
[686.544566] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.166s)
[686.553772] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[686.706490] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.161s)
[686.714573] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[691.024616] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.313s)
[691.025530] Subtest drm_buddy: SUCCESS (5.305s)
[691.230043] [117/131] (335s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[691.288969] Starting subtest: multi-wait-available-submitted-signaled
[691.289974] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[691.423193] [118/131] (335s left) kms_flip (2x-flip-vs-modeset)
[691.518925] Starting subtest: 2x-flip-vs-modeset
[691.530681] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[691.676660] [119/131] (334s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[691.776144] Starting subtest: compare-crc-sanitycheck-xr24
[691.777792] Starting dynamic subtest: pipe-A-eDP-1
[692.477232] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[692.488176] Starting dynamic subtest: pipe-B-eDP-1
[693.752138] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.275s)
[693.761792] Starting dynamic subtest: pipe-C-eDP-1
[694.957724] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[694.966142] Starting dynamic subtest: pipe-D-eDP-1
[696.179890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[696.180890] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.403s)
[697.051722] [120/131] (329s left) gem_exec_reloc (basic-gtt-cpu)
[697.114697] Subtest basic-gtt-cpu: SKIP (0.000s)
[697.196375] [121/131] (329s left) gem_exec_reloc (basic-active)
[697.252806] Subtest basic-active: SKIP (0.000s)
[697.340209] [122/131] (329s left) gem_pread (exhaustion)
[697.399686] Subtest exhaustion: SKIP (0.000s)
[697.468575] [123/131] (329s left) gem_userptr_blits (unsync-unmap)
[697.527919] Subtest unsync-unmap: SKIP (0.000s)
[697.704326] [124/131] (328s left) i915_hangman (engine-engine-error)
[697.773443] Starting subtest: engine-engine-error
[697.774388] Starting dynamic subtest: rcs0
[699.203836] Dynamic subtest rcs0: SUCCESS (1.428s)
[699.215433] Starting dynamic subtest: bcs0
[701.189393] Dynamic subtest bcs0: SUCCESS (1.983s)
[701.200359] Starting dynamic subtest: vcs0
[703.172763] Dynamic subtest vcs0: SUCCESS (1.981s)
[703.188406] Starting dynamic subtest: vcs1
[705.220501] Dynamic subtest vcs1: SUCCESS (2.045s)
[705.230377] Starting dynamic subtest: vecs0
[707.204918] Dynamic subtest vecs0: SUCCESS (1.982s)
[707.218990] Starting dynamic subtest: ccs0
[709.189286] Dynamic subtest ccs0: SUCCESS (1.981s)
[709.190891] Subtest engine-engine-error: SUCCESS (11.415s)
[709.289498] [125/131] (317s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[714.291806] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[714.294955] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[715.185129] [126/131] (311s left) kms_flip (2x-flip-vs-wf_vblank)
[715.279825] Starting subtest: 2x-flip-vs-wf_vblank
[715.303797] Subtest 2x-flip-vs-wf_vblank: SKIP (0.023s)
[715.411817] [127/131] (311s left) api_intel_bb (lot-of-buffers)
[715.474491] Starting subtest: lot-of-buffers
[716.557178] Subtest lot-of-buffers: SUCCESS (1.082s)
[717.099845] [128/131] (309s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[722.130930] Starting subtest: pr-overlay-plane-move-continuous-sf
[722.139377] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.003s)
[722.984455] [129/131] (303s left) intel_hwmon (hwmon-read)
[723.040670] Subtest hwmon-read: SKIP (0.000s)
[723.103278] [130/131] (303s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[723.191156] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[723.192900] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[723.308795] [131/131] (303s left) kms_plane_scaling (planes-scaler-unity-scaling)
[723.395851] Starting subtest: planes-scaler-unity-scaling
[723.396738] Starting dynamic subtest: pipe-A
[723.458916] Dynamic subtest pipe-A: SUCCESS (0.064s)
[723.469061] Starting dynamic subtest: pipe-B
[724.594279] Dynamic subtest pipe-B: SUCCESS (1.134s)
[724.607096] Starting dynamic subtest: pipe-C
[725.710335] Dynamic subtest pipe-C: SUCCESS (1.114s)
[725.722346] Starting dynamic subtest: pipe-D
[726.828767] Dynamic subtest pipe-D: SUCCESS (1.117s)
[726.829717] Subtest planes-scaler-unity-scaling: SUCCESS (3.434s)
[728.016713] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rc6_residency
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_mmap
results: parsing output: 8/ for test: kms_fb_coherency
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_pxp
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_wait
results: parsing output: 20/ for test: gem_flink_basic
results: parsing output: 21/ for test: vgem_slow
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: i915_query
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: vgem_basic
results: parsing output: 31/ for test: gem_exec_params
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: gem_ctx_param
results: parsing output: 35/ for test: sysfs_heartbeat_interval
results: parsing output: 36/ for test: kms_plane_multiple
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: kms_invalid_mode
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_pm_rpm
results: parsing output: 43/ for test: kms_atomic
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_chamelium_hpd
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: prime_busy
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_selftest
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_reg_read
results: parsing output: 58/ for test: kms_pipe_b_c_ivb
results: parsing output: 59/ for test: gem_exec_params
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_atomic_interruptible
results: parsing output: 62/ for test: kms_lease
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: prime_mmap
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: sw_sync
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_huc_copy
results: parsing output: 70/ for test: kms_content_protection
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: gem_create
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: gen7_exec_parse
results: parsing output: 78/ for test: gem_shrink
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_chamelium_edid
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: i915_drm_fdinfo
results: parsing output: 84/ for test: gem_ctx_shared
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: gem_busy
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: api_intel_allocator
results: parsing output: 90/ for test: gem_exec_balancer
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_debugfs
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_flink_basic
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: drm_buddy
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_pipe_crc_basic
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_pread
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: i915_hangman
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: api_intel_bb
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: intel_hwmon
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_plane_scaling
Done.