[57.778947] Initializing watchdogs
[57.779155]   /dev/watchdog0
[57.794253] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.798843] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.801147] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.804422] [001/131] (960s left) gem_exec_fence (submit-chain)
[58.002864] Starting subtest: submit-chain
[58.035687] Subtest submit-chain: SUCCESS (0.033s)
[60.017308] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[60.022536] [002/131] (958s left) kms_plane_alpha_blend (coverage-7efc)
[60.114858] Starting subtest: coverage-7efc
[60.413779] Starting dynamic subtest: pipe-A-eDP-1
[61.097768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[61.131110] Starting dynamic subtest: pipe-D-eDP-1
[62.458915] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[62.461332] Subtest coverage-7efc: SUCCESS (2.346s)
[63.276207] [003/131] (955s left) gem_readwrite (write-bad-handle)
[63.335055] Subtest write-bad-handle: SKIP (0.000s)
[63.394798] [004/131] (955s left) gem_exec_parallel (basic)
[63.448854] Starting subtest: basic
[63.451143] Starting dynamic subtest: rcs0
[64.864821] Dynamic subtest rcs0: SUCCESS (1.417s)
[64.872264] Starting dynamic subtest: bcs0
[66.334883] Dynamic subtest bcs0: SUCCESS (1.470s)
[66.342678] Starting dynamic subtest: vcs0
[68.085767] Dynamic subtest vcs0: SUCCESS (1.749s)
[68.094669] Starting dynamic subtest: vcs1
[69.908917] Dynamic subtest vcs1: SUCCESS (1.822s)
[69.924450] Starting dynamic subtest: vecs0
[71.895083] Dynamic subtest vecs0: SUCCESS (1.985s)
[71.904801] Starting dynamic subtest: ccs0
[73.401892] Dynamic subtest ccs0: SUCCESS (1.508s)
[73.404279] Subtest basic: SUCCESS (9.958s)
[73.585828] [005/131] (944s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[73.693938] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[73.696385] Starting dynamic subtest: pipe-A-eDP-1
[73.720490] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.730504] Starting dynamic subtest: pipe-B-eDP-1
[73.752681] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.759733] Starting dynamic subtest: pipe-C-eDP-1
[73.780205] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.788108] Starting dynamic subtest: pipe-D-eDP-1
[73.809276] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.813551] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[75.849667] [006/131] (942s left) vgem_basic (bad-handle)
[75.889788] Starting subtest: bad-handle
[75.892023] Subtest bad-handle: SUCCESS (0.000s)
[75.947224] [007/131] (942s left) gem_eio (create)
[76.173837] Starting subtest: create
[76.508162] Subtest create: SUCCESS (0.335s)
[76.644029] [008/131] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[76.752974] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[76.757147] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[76.849494] [009/131] (941s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[76.975814] Starting subtest: 2x-cursor-vs-flip-legacy
[76.979443] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[77.113271] [010/131] (941s left) sw_sync (timeline_closed_signaled)
[77.146608] Starting subtest: timeline_closed_signaled
[77.148605] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[77.203378] [011/131] (941s left) gem_mmap_gtt (basic-wc)
[77.260838] Subtest basic-wc: SKIP (0.000s)
[77.331137] [012/131] (941s left) drm_buddy (drm_buddy)
[77.367122] Starting subtest: drm_buddy
[77.370575] Subtest drm_buddy: SKIP (0.000s)
[77.419452] [013/131] (941s left) core_auth (getclient-simple)
[77.456156] Starting subtest: getclient-simple
[77.477068] Subtest getclient-simple: SUCCESS (0.021s)
[77.585178] [014/131] (941s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[77.669037] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[77.671115] Starting dynamic subtest: pipe-A
[77.689854] Dynamic subtest pipe-A: SKIP (0.017s)
[77.698585] Starting dynamic subtest: pipe-B
[77.723223] Dynamic subtest pipe-B: SKIP (0.034s)
[77.730570] Starting dynamic subtest: pipe-C
[77.757367] Dynamic subtest pipe-C: SKIP (0.035s)
[77.764461] Starting dynamic subtest: pipe-D
[77.788582] Dynamic subtest pipe-D: SKIP (0.031s)
[77.791693] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.117s)
[77.912348] [015/131] (940s left) gem_wait (busy)
[77.970069] Starting subtest: busy
[77.972243] Starting dynamic subtest: all-engines
[79.892501] Dynamic subtest all-engines: SUCCESS (1.921s)
[79.903104] Starting dynamic subtest: rcs0
[80.435228] Dynamic subtest rcs0: SUCCESS (0.544s)
[80.445402] Starting dynamic subtest: bcs0
[80.975432] Dynamic subtest bcs0: SUCCESS (0.540s)
[80.985398] Starting dynamic subtest: vcs0
[82.900857] Dynamic subtest vcs0: SUCCESS (1.924s)
[82.910868] Starting dynamic subtest: vcs1
[84.884596] Dynamic subtest vcs1: SUCCESS (1.983s)
[84.895060] Starting dynamic subtest: vecs0
[86.932544] Dynamic subtest vecs0: SUCCESS (2.047s)
[86.942747] Starting dynamic subtest: ccs0
[87.473601] Dynamic subtest ccs0: SUCCESS (0.542s)
[87.476237] Subtest busy: SUCCESS (9.505s)
[87.666445] [016/131] (931s left) gem_mmap_offset (ptrace)
[87.733744] Starting subtest: ptrace
[87.739387] Starting dynamic subtest: smem0-wb
[87.756629] Dynamic subtest smem0-wb: SUCCESS (0.017s)
[87.764141] Starting dynamic subtest: smem0-wc
[87.777625] Dynamic subtest smem0-wc: SUCCESS (0.021s)
[87.785070] Starting dynamic subtest: smem0-uc
[87.798365] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[87.800791] Subtest ptrace: SUCCESS (0.066s)
[87.893859] [017/131] (931s left) gem_create (create-ext-cpu-access-big)
[88.066306] Starting subtest: create-ext-cpu-access-big
[88.071842] Subtest create-ext-cpu-access-big: SKIP (0.002s)
[88.140119] [018/131] (930s left) gem_render_copy (linear-to-vebox-yf-tiled)
[88.204383] Starting subtest: linear-to-vebox-yf-tiled
[88.209037] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[88.389199] [019/131] (930s left) perf (polling-small-buf)
[88.502566] Starting subtest: polling-small-buf
[88.593933] Subtest polling-small-buf: SUCCESS (0.090s)
[88.640837] [020/131] (930s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[88.740607] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[88.745020] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[89.869413] [021/131] (929s left) kms_addfb_basic (basic)
[89.928079] Starting subtest: basic
[89.930469] Subtest basic: SUCCESS (0.000s)
[90.050368] [022/131] (929s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[90.155028] Starting subtest: 4-tiled-8bpp-rotate-0
[91.424335] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.270s)
[91.546333] [023/131] (927s left) gem_mmap_wc (read)
[91.606992] Subtest read: SKIP (0.000s)
[91.670196] [024/131] (927s left) kms_properties (get_properties-sanity-non-atomic)
[91.758217] Starting subtest: get_properties-sanity-non-atomic
[91.760057] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[91.844548] [025/131] (927s left) kms_color (legacy-gamma-reset)
[91.942096] Starting subtest: legacy-gamma-reset
[91.943933] Starting dynamic subtest: pipe-A-eDP-1
[92.314528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s)
[92.326894] Starting dynamic subtest: pipe-B-eDP-1
[92.329260] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[92.337146] Starting dynamic subtest: pipe-C-eDP-1
[92.339311] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[92.347117] Starting dynamic subtest: pipe-D-eDP-1
[92.351710] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[92.354067] Subtest legacy-gamma-reset: SUCCESS (0.409s)
[93.101862] [026/131] (926s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[93.164370] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[93.223124] [027/131] (926s left) gem_exec_create (basic)
[93.276597] Starting subtest: basic
[93.278931] Starting dynamic subtest: smem
[95.363043] Dynamic subtest smem: SUCCESS (2.086s)
[95.365701] Subtest basic: SUCCESS (2.087s)
[95.548483] [028/131] (923s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[95.645070] Starting subtest: fbc-pr-sprite-mmap-cpu
[95.649406] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[95.733957] [029/131] (923s left) gem_sync (basic-many-each)
[95.807398] Starting subtest: basic-many-each
[98.085074] Subtest basic-many-each: SUCCESS (2.289s)
[98.277928] [030/131] (921s left) kms_chamelium_edid (dp-edid-read)
[98.683577] Subtest dp-edid-read: SKIP (0.000s)
[99.507877] [031/131] (919s left) kms_async_flips (invalid-async-flip)
[99.602421] Starting subtest: invalid-async-flip
[99.990429] Starting dynamic subtest: pipe-A-eDP-1
[100.764854] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.774s)
[101.119385] Starting dynamic subtest: pipe-B-eDP-1
[101.896807] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.784s)
[102.256246] Starting dynamic subtest: pipe-C-eDP-1
[103.019292] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s)
[103.389025] Starting dynamic subtest: pipe-D-eDP-1
[104.165142] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.784s)
[104.167444] Subtest invalid-async-flip: SUCCESS (4.564s)
[105.304709] [032/131] (914s left) prime_vgem (fence-flip-hang)
[105.374063] Subtest fence-flip-hang: SKIP (0.000s)
[105.481036] [033/131] (914s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[105.579673] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[112.688099] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.112s)
[112.808156] [034/131] (906s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[112.868922] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[112.977762] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[113.053633] [035/131] (906s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[113.155829] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[113.160163] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[113.233540] [036/131] (906s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[113.333098] Starting subtest: yf-tiled-8bpp-rotate-180
[113.337397] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[113.427584] [037/131] (906s left) perf_pmu (busy)
[113.471368] Starting subtest: busy
[113.473199] Starting dynamic subtest: rcs0
[114.063932] Dynamic subtest rcs0: SUCCESS (0.593s)
[114.075093] Starting dynamic subtest: bcs0
[114.628897] Dynamic subtest bcs0: SUCCESS (0.564s)
[114.642038] Starting dynamic subtest: vcs0
[115.923728] Dynamic subtest vcs0: SUCCESS (1.293s)
[115.935809] Starting dynamic subtest: vcs1
[117.908876] Dynamic subtest vcs1: SUCCESS (1.981s)
[117.920580] Starting dynamic subtest: vecs0
[119.893453] Dynamic subtest vecs0: SUCCESS (1.983s)
[119.905102] Starting dynamic subtest: ccs0
[120.460827] Dynamic subtest ccs0: SUCCESS (0.567s)
[120.463549] Subtest busy: SUCCESS (6.991s)
[120.556441] [038/131] (899s left) i915_pm_rc6_residency (rc6-fence)
[120.612058] Starting subtest: rc6-fence
[120.633764] Starting dynamic subtest: gt0
[133.950638] Dynamic subtest gt0: SUCCESS (13.317s)
[133.962015] Starting dynamic subtest: gt1
[148.884085] Dynamic subtest gt1: SUCCESS (14.929s)
[148.886552] Subtest rc6-fence: SUCCESS (28.272s)
[148.963622] [039/131] (870s left) syncobj_wait (reset-during-wait-for-submit)
[149.034114] Starting subtest: reset-during-wait-for-submit
[149.138260] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[149.228159] [040/131] (870s left) gem_userptr_blits (process-exit-busy)
[149.296312] Starting subtest: process-exit-busy
[149.313035] Subtest process-exit-busy: SUCCESS (0.018s)
[149.441867] [041/131] (870s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[149.574572] Starting subtest: flip-vs-cursor-legacy
[157.013907] Subtest flip-vs-cursor-legacy: SUCCESS (7.436s)
[157.811456] [042/131] (862s left) kms_feature_discovery (psr2)
[157.909113] Starting subtest: psr2
[157.911434] Subtest psr2: SUCCESS (0.000s)
[157.981730] [043/131] (861s left) perf (create-destroy-userspace-config)
[158.080851] Starting subtest: create-destroy-userspace-config
[158.102403] Subtest create-destroy-userspace-config: SUCCESS (0.019s)
[158.148457] [044/131] (861s left) api_intel_allocator (execbuf-with-allocator)
[158.201757] Starting subtest: execbuf-with-allocator
[158.206529] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[158.350518] [045/131] (861s left) kms_selftest (drm_format_helper)
[158.393115] Starting subtest: drm_format_helper
[158.437711] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[158.548732] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.110s)
[158.558215] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[158.654824] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.107s)
[158.665126] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[158.776311] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.120s)
[158.786669] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[158.871176] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.096s)
[158.879257] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[158.964367] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.090s)
[158.973703] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[159.059517] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.095s)
[159.069076] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[159.166578] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.109s)
[159.176719] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[159.272426] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.104s)
[159.280282] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[159.371421] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.101s)
[159.381648] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[159.467614] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.094s)
[159.477261] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[159.582728] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.113s)
[159.592185] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[159.677631] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.097s)
[159.687251] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[159.785022] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.107s)
[159.794746] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[159.887786] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.102s)
[159.897189] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[159.993184] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.104s)
[160.002527] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[160.101116] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.108s)
[160.110929] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[160.200752] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.100s)
[160.202647] Subtest drm_format_helper: SUCCESS (1.810s)
[160.356264] [046/131] (859s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[160.462358] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[166.912571] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.449s)
[167.044432] [047/131] (853s left) gem_mmap_gtt (basic-write-gtt)
[167.112810] Subtest basic-write-gtt: SKIP (0.000s)
[167.172726] [048/131] (852s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[167.271286] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[168.162493] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.892s)
[168.347636] [049/131] (851s left) gem_exec_balancer (nop)
[168.403334] Starting subtest: nop
[214.805809] Subtest nop: SUCCESS (46.398s)
[215.123977] [050/131] (805s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[215.224958] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[216.271277] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.047s)
[216.396318] [051/131] (803s left) gem_exec_reloc (basic-write-gtt)
[216.459745] Subtest basic-write-gtt: SKIP (0.000s)
[216.533820] [052/131] (803s left) kms_draw_crc (draw-method-mmap-gtt)
[216.628755] Starting subtest: draw-method-mmap-gtt
[216.632158] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[216.738012] [053/131] (803s left) gem_exec_schedule (independent)
[216.801135] Starting subtest: independent
[216.802796] Starting dynamic subtest: rcs0
[217.941248] Dynamic subtest rcs0: SUCCESS (1.144s)
[217.952896] Starting dynamic subtest: vcs0
[219.936856] Dynamic subtest vcs0: SUCCESS (1.993s)
[219.949055] Starting dynamic subtest: vcs1
[221.920584] Dynamic subtest vcs1: SUCCESS (1.982s)
[221.931645] Starting dynamic subtest: vecs0
[223.891955] Dynamic subtest vecs0: SUCCESS (1.970s)
[223.902122] Starting dynamic subtest: ccs0
[225.876333] Dynamic subtest ccs0: SUCCESS (1.983s)
[225.879032] Subtest independent: SUCCESS (9.081s)
[226.185519] [054/131] (794s left) gem_mmap_gtt (basic-small-bo)
[226.239838] Subtest basic-small-bo: SKIP (0.000s)
[226.300824] [055/131] (794s left) kms_cursor_crc (cursor-onscreen-max-size)
[226.614854] Starting subtest: cursor-onscreen-max-size
[226.621757] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[226.729049] [056/131] (793s left) kms_busy (extended-pageflip-hang-newfb)
[226.822236] Starting subtest: extended-pageflip-hang-newfb
[226.824484] Starting dynamic subtest: pipe-A
[253.670690] Dynamic subtest pipe-A: SUCCESS (26.848s)
[253.680067] Starting dynamic subtest: pipe-D
[278.692433] Dynamic subtest pipe-D: SUCCESS (25.019s)
[278.694774] Subtest extended-pageflip-hang-newfb: SUCCESS (51.871s)
[279.510094] [057/131] (741s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[279.604166] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[279.606535] Starting dynamic subtest: pipe-A-eDP-1
[279.630465] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[279.641511] Starting dynamic subtest: pipe-B-eDP-1
[279.663350] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.671875] Starting dynamic subtest: pipe-C-eDP-1
[279.693474] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.704675] Starting dynamic subtest: pipe-D-eDP-1
[279.726644] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.731438] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[281.777704] [058/131] (738s left) gem_exec_capture (pi)
[281.839572] Starting subtest: pi
[281.842040] Starting dynamic subtest: rcs0
[286.009077] Dynamic subtest rcs0: SUCCESS (4.170s)
[286.019446] Starting dynamic subtest: bcs0
[289.796854] Dynamic subtest bcs0: SUCCESS (3.786s)
[289.805800] Starting dynamic subtest: vcs0
[293.603851] Dynamic subtest vcs0: SUCCESS (3.805s)
[293.621647] Starting dynamic subtest: vcs1
[297.512326] Dynamic subtest vcs1: SUCCESS (3.905s)
[297.524246] Starting dynamic subtest: vecs0
[301.327345] Dynamic subtest vecs0: SUCCESS (3.814s)
[301.337649] Starting dynamic subtest: ccs0
[305.248959] Dynamic subtest ccs0: SUCCESS (3.920s)
[305.251911] Subtest pi: SUCCESS (23.408s)
[305.327154] [059/131] (715s left) gem_userptr_blits (unsync-unmap-cycles)
[305.430965] Subtest unsync-unmap-cycles: SKIP (0.000s)
[305.567120] [060/131] (715s left) gen3_render_tiledy_blits
[305.694548] [061/131] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[305.797413] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[305.801513] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[305.893858] [062/131] (714s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[306.022247] Starting subtest: basic-busy-flip-before-cursor-atomic
[306.026731] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[306.167241] [063/131] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[306.259530] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[306.263178] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[306.369667] [064/131] (714s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[306.423042] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[306.529353] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[306.605905] [065/131] (714s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[306.702119] Starting subtest: psr-2p-pri-indfb-multidraw
[306.706256] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[306.807350] [066/131] (714s left) kms_psr (fbc-psr-cursor-blt)
[306.895064] Starting subtest: fbc-psr-cursor-blt
[306.897328] Starting dynamic subtest: eDP-1
[306.901636] Dynamic subtest eDP-1: SKIP (0.000s)
[306.905949] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[306.969636] [067/131] (713s left) prime_mmap (test_refcounting)
[307.037469] Starting subtest: test_refcounting
[307.039691] Starting dynamic subtest: test_refcounting-smem
[307.070348] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s)
[307.072742] Subtest test_refcounting: SUCCESS (0.034s)
[307.177630] [068/131] (713s left) gem_mmap_gtt (pf-nonblock)
[307.234716] Subtest pf-nonblock: SKIP (0.000s)
[307.300798] [069/131] (713s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[307.391536] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[314.180075] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.790s)
[314.301070] [070/131] (706s left) gem_mmap_gtt (basic)
[314.365526] Subtest basic: SKIP (0.000s)
[314.431658] [071/131] (706s left) gem_exec_parallel (engines)
[314.501465] Starting subtest: engines
[314.503776] Starting dynamic subtest: basic
[317.844752] Dynamic subtest basic: SUCCESS (3.341s)
[317.856215] Starting dynamic subtest: contexts
[322.486184] Dynamic subtest contexts: SUCCESS (4.638s)
[322.496084] Starting dynamic subtest: fds
[326.278586] Dynamic subtest fds: SUCCESS (3.792s)
[326.289344] Starting dynamic subtest: userptr
[327.930956] Dynamic subtest userptr: SUCCESS (1.650s)
[327.933499] Subtest engines: SUCCESS (13.429s)
[328.135465] [072/131] (693s left) gen9_exec_parse (bb-start-out)
[328.190302] Subtest bb-start-out: SKIP (0.000s)
[328.270524] [073/131] (692s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[328.396584] Starting subtest: short-flip-before-cursor-atomic-transitions
[329.393741] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.996s)
[330.207648] [074/131] (691s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[330.306627] Starting subtest: psr-1p-primscrn-cur-indfb-move
[337.691075] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.387s)
[337.825440] [075/131] (683s left) gem_exec_whisper (basic-contexts)
[337.887079] Starting subtest: basic-contexts
[345.909069] Subtest basic-contexts: SUCCESS (8.018s)
[346.096375] [076/131] (675s left) kms_psr (psr-cursor-render)
[346.202614] Starting subtest: psr-cursor-render
[346.204863] Starting dynamic subtest: eDP-1
[347.927937] Dynamic subtest eDP-1: SUCCESS (1.726s)
[347.930353] Subtest psr-cursor-render: SUCCESS (1.727s)
[348.786930] [077/131] (672s left) kms_plane_multiple (2x-tiling-4)
[348.876408] Starting subtest: 2x-tiling-4
[348.880591] Subtest 2x-tiling-4: SKIP (0.000s)
[348.953245] [078/131] (672s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[349.047336] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[349.074133] Starting dynamic subtest: pipe-A-plane-0
[349.362770] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[349.374525] Starting dynamic subtest: pipe-A-plane-3
[349.595774] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[349.604754] Starting dynamic subtest: pipe-A-plane-5
[349.608826] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[350.670343] Starting dynamic subtest: pipe-B-plane-0
[350.962799] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[350.972208] Starting dynamic subtest: pipe-B-plane-3
[351.195644] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[351.205133] Starting dynamic subtest: pipe-B-plane-5
[351.210060] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[351.524507] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.477s)
[352.345666] [079/131] (669s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[352.441836] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[352.444576] Starting dynamic subtest: pipe-A-eDP-1
[358.325161] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.886s)
[358.335235] Starting dynamic subtest: pipe-B-eDP-1
[364.990987] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.666s)
[364.993264] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.555s)
[365.874679] [080/131] (655s left) kms_psr (pr-cursor-render)
[365.970142] Starting subtest: pr-cursor-render
[365.974250] Subtest pr-cursor-render: SKIP (0.000s)
[366.054712] [081/131] (655s left) perf_pmu (gt-awake)
[366.094406] Starting subtest: gt-awake
[374.935804] Subtest gt-awake: SUCCESS (8.839s)
[375.037951] [082/131] (646s left) syncobj_timeline (single-wait-available-submitted)
[375.104867] Starting subtest: single-wait-available-submitted
[375.107197] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[375.226347] [083/131] (646s left) kms_big_fb (linear-64bpp-rotate-180)
[375.328061] Starting subtest: linear-64bpp-rotate-180
[376.974980] Subtest linear-64bpp-rotate-180: SUCCESS (1.647s)
[377.141574] [084/131] (644s left) sw_sync (sync_merge_invalid)
[377.180822] Starting subtest: sync_merge_invalid
[377.197566] Subtest sync_merge_invalid: SUCCESS (0.016s)
[377.267109] [085/131] (644s left) kms_chamelium_audio (dp-audio)
[377.642263] Subtest dp-audio: SKIP (0.000s)
[378.486712] [086/131] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[378.584203] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[378.588135] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[378.673845] [087/131] (643s left) kms_lease (invalid-create-leases)
[378.764729] Starting subtest: invalid-create-leases
[378.769487] Subtest invalid-create-leases: SUCCESS (0.005s)
[378.886163] [088/131] (643s left) i915_drm_fdinfo (memory-info-idle)
[378.939573] Starting subtest: memory-info-idle
[378.941633] Starting dynamic subtest: smem0
[378.994626] Dynamic subtest smem0: SUCCESS (0.055s)
[378.997197] Subtest memory-info-idle: SUCCESS (0.056s)
[379.067508] [089/131] (642s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[379.163608] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[379.167818] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[379.278858] [090/131] (642s left) kms_properties (colorop-properties-legacy)
[379.375079] Starting subtest: colorop-properties-legacy
[379.377219] Starting dynamic subtest: pipe-A-eDP-1
[379.732456] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[379.743416] Starting dynamic subtest: pipe-B-eDP-1
[380.776440] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.043s)
[380.788792] Starting dynamic subtest: pipe-C-eDP-1
[381.808985] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.032s)
[381.819549] Starting dynamic subtest: pipe-D-eDP-1
[382.833168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.021s)
[382.835447] Subtest colorop-properties-legacy: SUCCESS (3.459s)
[383.631271] [091/131] (638s left) i915_query (engine-info-invalid)
[383.701517] Starting subtest: engine-info-invalid
[383.703792] Subtest engine-info-invalid: SUCCESS (0.000s)
[383.792616] [092/131] (638s left) kms_flip (2x-plain-flip-fb-recreate)
[383.893147] Starting subtest: 2x-plain-flip-fb-recreate
[383.901396] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[384.011516] [093/131] (638s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[384.065794] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[384.068064] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[384.173895] [094/131] (637s left) kms_cursor_crc (cursor-size-change)
[384.261130] Starting subtest: cursor-size-change
[384.262999] Starting dynamic subtest: pipe-A-eDP-1
[385.040260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.780s)
[385.051078] Starting dynamic subtest: pipe-D-eDP-1
[386.493133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.448s)
[386.495070] Subtest cursor-size-change: SUCCESS (2.232s)
[387.299609] [095/131] (634s left) kms_vblank (wait-forked-busy)
[387.397405] Starting subtest: wait-forked-busy
[387.399560] Starting dynamic subtest: pipe-A-eDP-1
[389.285173] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s)
[389.299412] Starting dynamic subtest: pipe-D-eDP-1
[391.869038] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.583s)
[391.871253] Subtest wait-forked-busy: SUCCESS (4.474s)
[392.672111] [096/131] (629s left) gem_tiled_fence_blits (basic)
[392.739322] Subtest basic: SKIP (0.000s)
[392.814770] [097/131] (629s left) gem_ctx_persistence (legacy-engines-mixed)
[392.878619] Starting subtest: legacy-engines-mixed
[392.880976] Starting dynamic subtest: render
[392.962243] Dynamic subtest render: SUCCESS (0.082s)
[392.973755] Starting dynamic subtest: bsd1
[393.015892] Dynamic subtest bsd1: SUCCESS (0.051s)
[393.029065] Starting dynamic subtest: bsd2
[393.066776] Dynamic subtest bsd2: SUCCESS (0.048s)
[393.077720] Starting dynamic subtest: blt
[393.140559] Dynamic subtest blt: SUCCESS (0.071s)
[393.153338] Starting dynamic subtest: vebox
[393.196740] Dynamic subtest vebox: SUCCESS (0.054s)
[393.199270] Subtest legacy-engines-mixed: SUCCESS (0.319s)
[393.289957] [098/131] (629s left) kms_plane (plane-position-covered)
[393.382167] Starting subtest: plane-position-covered
[393.917483] Starting dynamic subtest: pipe-A-plane-1
[395.272652] Dynamic subtest pipe-A-plane-1: SUCCESS (1.357s)
[395.283733] Starting dynamic subtest: pipe-A-plane-2
[396.569650] Dynamic subtest pipe-A-plane-2: SUCCESS (1.296s)
[396.580581] Starting dynamic subtest: pipe-A-plane-3
[397.811289] Dynamic subtest pipe-A-plane-3: SUCCESS (1.241s)
[397.822561] Starting dynamic subtest: pipe-A-plane-4
[399.153071] Dynamic subtest pipe-A-plane-4: SUCCESS (1.339s)
[399.163826] Starting dynamic subtest: pipe-A-plane-5
[399.179874] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[400.308438] Starting dynamic subtest: pipe-B-plane-1
[401.635670] Dynamic subtest pipe-B-plane-1: SUCCESS (1.335s)
[401.645627] Starting dynamic subtest: pipe-B-plane-2
[402.932411] Dynamic subtest pipe-B-plane-2: SUCCESS (1.298s)
[402.942228] Starting dynamic subtest: pipe-B-plane-3
[404.200082] Dynamic subtest pipe-B-plane-3: SUCCESS (1.265s)
[404.210629] Starting dynamic subtest: pipe-B-plane-4
[405.432533] Dynamic subtest pipe-B-plane-4: SUCCESS (1.234s)
[405.443274] Starting dynamic subtest: pipe-B-plane-5
[405.463761] Dynamic subtest pipe-B-plane-5: SUCCESS (0.029s)
[405.466093] Subtest plane-position-covered: SUCCESS (12.082s)
[406.236065] [099/131] (616s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[406.327068] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[406.329309] Starting dynamic subtest: pipe-A-eDP-1
[406.388102] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[406.397582] Starting dynamic subtest: pipe-B-eDP-1
[406.455740] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[406.466427] Starting dynamic subtest: pipe-C-eDP-1
[406.523975] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[406.534609] Starting dynamic subtest: pipe-D-eDP-1
[406.592039] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[406.596284] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[408.596929] [100/131] (613s left) gem_exec_schedule (u-semaphore-codependency)
[408.676699] Starting subtest: u-semaphore-codependency
[408.682201] Subtest u-semaphore-codependency: SUCCESS (0.012s)
[409.033880] [101/131] (613s left) gem_spin_batch (resubmit-new-all)
[409.119462] Starting subtest: resubmit-new-all
[409.122045] Starting dynamic subtest: rcs0
[409.137201] Dynamic subtest rcs0: SUCCESS (0.017s)
[409.149713] Starting dynamic subtest: bcs0
[409.151891] Dynamic subtest bcs0: SUCCESS (0.010s)
[409.161722] Starting dynamic subtest: vcs0
[409.164071] Dynamic subtest vcs0: SUCCESS (0.010s)
[409.173461] Starting dynamic subtest: vcs1
[409.175745] Dynamic subtest vcs1: SUCCESS (0.011s)
[409.185348] Starting dynamic subtest: vecs0
[409.187574] Dynamic subtest vecs0: SUCCESS (0.008s)
[409.196718] Starting dynamic subtest: ccs0
[409.198636] Dynamic subtest ccs0: SUCCESS (0.011s)
[409.200555] Subtest resubmit-new-all: SUCCESS (0.075s)
[410.954276] [102/131] (611s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[411.046608] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[411.050651] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[411.134702] [103/131] (611s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[411.234992] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[411.617062] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[414.361922] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.744s)
[414.371457] Starting dynamic subtest: pipe-A-eDP-1-4
[416.546696] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[416.556664] Starting dynamic subtest: pipe-A-eDP-1-4
[418.557108] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[418.567303] Starting dynamic subtest: pipe-A-eDP-1-x
[420.735669] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[421.115365] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[423.883628] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.774s)
[423.894495] Starting dynamic subtest: pipe-B-eDP-1-4
[426.092097] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.206s)
[426.101930] Starting dynamic subtest: pipe-B-eDP-1-4
[428.101278] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[428.117612] Starting dynamic subtest: pipe-B-eDP-1-x
[430.303191] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[430.679211] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[433.417459] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.750s)
[433.429923] Starting dynamic subtest: pipe-C-eDP-1-4
[435.593057] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[435.605308] Starting dynamic subtest: pipe-C-eDP-1-4
[437.602669] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[437.615173] Starting dynamic subtest: pipe-C-eDP-1-x
[439.780340] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[440.155680] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[442.945794] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[442.958683] Starting dynamic subtest: pipe-D-eDP-1-4
[445.120788] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[445.132273] Starting dynamic subtest: pipe-D-eDP-1-4
[447.130028] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[447.139956] Starting dynamic subtest: pipe-D-eDP-1-x
[449.308809] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[449.311555] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.074s)
[450.538606] [104/131] (572s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[450.923782] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[451.751931] [105/131] (570s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[451.843056] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[451.847290] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[451.918376] [106/131] (570s left) syncobj_timeline (invalid-transfer-non-existent-point)
[451.973986] Starting subtest: invalid-transfer-non-existent-point
[451.976260] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[452.088537] [107/131] (570s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[452.155754] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[452.160292] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[452.338311] [108/131] (570s left) perf_pmu (all-busy-idle-check-all)
[452.388734] Starting subtest: all-busy-idle-check-all
[453.908378] Subtest all-busy-idle-check-all: SUCCESS (1.522s)
[454.023623] [109/131] (568s left) kms_psr (psr-basic)
[454.116773] Starting subtest: psr-basic
[454.118989] Starting dynamic subtest: eDP-1
[455.757025] Dynamic subtest eDP-1: SUCCESS (1.639s)
[455.759275] Subtest psr-basic: SUCCESS (1.640s)
[456.629398] [110/131] (566s left) gem_busy (extended)
[456.812902] Starting subtest: extended
[456.815428] Starting dynamic subtest: rcs0
[456.888377] Dynamic subtest rcs0: SUCCESS (0.075s)
[456.900467] Starting dynamic subtest: bcs0
[456.930758] Dynamic subtest bcs0: SUCCESS (0.040s)
[456.941621] Starting dynamic subtest: vcs0
[458.901318] Dynamic subtest vcs0: SUCCESS (1.966s)
[458.916907] Starting dynamic subtest: vcs1
[460.885334] Dynamic subtest vcs1: SUCCESS (1.981s)
[460.899525] Starting dynamic subtest: vecs0
[462.868855] Dynamic subtest vecs0: SUCCESS (1.981s)
[462.881445] Starting dynamic subtest: ccs0
[462.914250] Dynamic subtest ccs0: SUCCESS (0.045s)
[462.916836] Subtest extended: SUCCESS (6.103s)
[463.159771] [111/131] (559s left) kms_pm_lpsp (kms-lpsp)
[464.271346] Starting subtest: kms-lpsp
[464.273247] Starting dynamic subtest: pipe-A-eDP-1
[464.415236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.147s)
[464.726958] Subtest kms-lpsp: SUCCESS (0.459s)
[465.571587] [112/131] (557s left) kms_cursor_legacy (single-bo)
[465.694640] Starting subtest: single-bo
[465.696956] Starting dynamic subtest: pipe-A
[471.075920] Dynamic subtest pipe-A: SUCCESS (5.378s)
[471.087095] Starting dynamic subtest: pipe-B
[476.459032] Dynamic subtest pipe-B: SUCCESS (5.380s)
[476.470051] Starting dynamic subtest: pipe-C
[481.842988] Dynamic subtest pipe-C: SUCCESS (5.380s)
[481.854455] Starting dynamic subtest: pipe-D
[487.225685] Dynamic subtest pipe-D: SUCCESS (5.381s)
[487.235504] Starting dynamic subtest: all-pipes
[492.614125] Dynamic subtest all-pipes: SUCCESS (5.386s)
[492.616458] Subtest single-bo: SUCCESS (26.918s)
[492.761406] [113/131] (530s left) gem_eio (in-flight-internal-1us)
[492.970423] Starting subtest: in-flight-internal-1us
[493.975138] Subtest in-flight-internal-1us: SUCCESS (1.005s)
[494.092705] [114/131] (528s left) i915_getparams_basic (basic-eu-total)
[494.150229] Starting subtest: basic-eu-total
[494.154629] Subtest basic-eu-total: SUCCESS (0.000s)
[494.261642] [115/131] (528s left) syncobj_basic (bad-pad-fd-to-handle)
[494.318331] Starting subtest: bad-pad-fd-to-handle
[494.320627] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[494.428486] [116/131] (528s left) kms_joiner (basic-big-joiner)
[494.534976] Starting subtest: basic-big-joiner
[494.539346] Subtest basic-big-joiner: SKIP (0.000s)
[494.611391] [117/131] (528s left) kms_content_protection (atomic-dpms)
[494.758097] Starting subtest: atomic-dpms
[494.762824] Subtest atomic-dpms: SKIP (0.000s)
[494.901615] [118/131] (528s left) gem_exec_flush (basic-wb-rw-before-default)
[494.976259] Starting subtest: basic-wb-rw-before-default
[500.431142] Subtest basic-wb-rw-before-default: SUCCESS (5.456s)
[500.618241] [119/131] (522s left) kms_rotation_crc (sprite-rotation-180)
[500.712908] Starting subtest: sprite-rotation-180
[507.471422] Subtest sprite-rotation-180: SUCCESS (6.760s)
[508.643329] [120/131] (514s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[508.744021] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[508.748484] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[508.838262] [121/131] (514s left) kms_cursor_edge_walk (256x256-top-bottom)
[508.933561] Starting subtest: 256x256-top-bottom
[508.935808] Starting dynamic subtest: pipe-A-eDP-1
[512.416372] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s)
[512.427051] Starting dynamic subtest: pipe-D-eDP-1
[515.545540] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[515.548095] Subtest 256x256-top-bottom: SUCCESS (6.615s)
[516.334467] [122/131] (506s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[516.393079] Starting subtest: invalid-single-wait-all-unsubmitted
[516.395433] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[516.494796] [123/131] (506s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[516.605341] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[516.609344] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[516.687824] [124/131] (506s left) kms_fbcon_fbt (fbc-suspend)
[516.742507] Starting subtest: fbc-suspend
[566.205111] Subtest fbc-suspend: SUCCESS (20.004s)
[567.582674] [125/131] (455s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[567.693295] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[567.697514] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[567.781320] [126/131] (455s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[567.874912] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[567.878862] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[567.968385] [127/131] (455s left) gem_exec_whisper (basic-queues-forked-all)
[568.028207] Starting subtest: basic-queues-forked-all
[587.656197] Subtest basic-queues-forked-all: SUCCESS (19.650s)
[587.854989] [128/131] (435s left) gem_fenced_exec_thrash (too-many-fences)
[587.921295] Subtest too-many-fences: SKIP (0.000s)
[587.989439] [129/131] (435s left) gem_ctx_param (invalid-get-no-zeromap)
[588.043951] Starting subtest: invalid-get-no-zeromap
[588.046375] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[588.139905] [130/131] (435s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[588.231511] Starting subtest: fbc-rgb101010-draw-pwrite
[593.622550] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.397s)
[594.757586] [131/131] (428s left) kms_cursor_crc (cursor-size-hints)
[594.888039] Starting subtest: cursor-size-hints
[594.890832] Starting dynamic subtest: pipe-A-eDP-1
[595.537034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.647s)
[595.547069] Starting dynamic subtest: pipe-D-eDP-1
[596.841251] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[596.843513] Subtest cursor-size-hints: SUCCESS (1.953s)
[597.633038] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_plane_alpha_blend
results: parsing output: 2/ for test: gem_readwrite
results: parsing output: 3/ for test: gem_exec_parallel
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: vgem_basic
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: sw_sync
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: drm_buddy
results: parsing output: 12/ for test: core_auth
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: gem_wait
results: parsing output: 15/ for test: gem_mmap_offset
results: parsing output: 16/ for test: gem_create
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: kms_properties
results: parsing output: 24/ for test: kms_color
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gem_exec_create
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_sync
results: parsing output: 29/ for test: kms_chamelium_edid
results: parsing output: 30/ for test: kms_async_flips
results: parsing output: 31/ for test: prime_vgem
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: i915_pm_rc6_residency
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_feature_discovery
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: api_intel_allocator
results: parsing output: 44/ for test: kms_selftest
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: kms_draw_crc
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_busy
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_exec_capture
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gen3_render_tiledy_blits
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: prime_mmap
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: gem_exec_parallel
results: parsing output: 71/ for test: gen9_exec_parse
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_plane_multiple
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: sw_sync
results: parsing output: 84/ for test: kms_chamelium_audio
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_lease
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_properties
results: parsing output: 90/ for test: i915_query
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: gem_tiled_fence_blits
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: kms_plane
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_async_flips
results: parsing output: 103/ for test: kms_chamelium_hpd
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_busy
results: parsing output: 110/ for test: kms_pm_lpsp
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_eio
results: parsing output: 113/ for test: i915_getparams_basic
results: parsing output: 114/ for test: syncobj_basic
results: parsing output: 115/ for test: kms_joiner
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_cursor_edge_walk
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_fbcon_fbt
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_whisper
results: parsing output: 127/ for test: gem_fenced_exec_thrash
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
Done.