[66.828953] Initializing watchdogs
[66.829044]   /dev/watchdog0
[66.859973] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[66.875114] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[66.879961] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.882651] [001/131] (960s left) gem_exec_fence (submit-chain)
[67.063801] Starting subtest: submit-chain
[67.105057] Subtest submit-chain: SUCCESS (0.041s)
[67.818142] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[67.819978] [002/131] (959s left) kms_plane_alpha_blend (coverage-7efc)
[69.305131] Starting subtest: coverage-7efc
[69.593432] Starting dynamic subtest: pipe-A-HDMI-A-4
[70.167112] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.573s)
[70.197328] Starting dynamic subtest: pipe-D-HDMI-A-4
[70.801595] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.609s)
[70.802429] Subtest coverage-7efc: SUCCESS (1.494s)
[71.141556] [003/131] (956s left) gem_readwrite (write-bad-handle)
[71.235893] Subtest write-bad-handle: SKIP (0.000s)
[71.579266] [004/131] (956s left) gem_exec_parallel (basic)
[71.672989] Starting subtest: basic
[71.673994] Starting dynamic subtest: rcs0
[73.643941] Dynamic subtest rcs0: SUCCESS (1.970s)
[73.651946] Starting dynamic subtest: bcs0
[75.154955] Dynamic subtest bcs0: SUCCESS (1.510s)
[75.164054] Starting dynamic subtest: vcs0
[76.658989] Dynamic subtest vcs0: SUCCESS (1.503s)
[76.668649] Starting dynamic subtest: vcs1
[78.153200] Dynamic subtest vcs1: SUCCESS (1.493s)
[78.162076] Starting dynamic subtest: vecs0
[79.713948] Dynamic subtest vecs0: SUCCESS (1.560s)
[79.714794] Subtest basic: SUCCESS (8.039s)
[80.095027] [005/131] (947s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[81.579605] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[81.580488] Starting dynamic subtest: pipe-A-HDMI-A-4
[81.589934] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[81.598169] Starting dynamic subtest: pipe-B-HDMI-A-4
[81.605032] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[81.613164] Starting dynamic subtest: pipe-C-HDMI-A-4
[81.619952] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s)
[81.627898] Starting dynamic subtest: pipe-D-HDMI-A-4
[81.634968] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s)
[81.635847] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.012s)
[81.842448] [006/131] (945s left) vgem_basic (bad-handle)
[81.897685] Starting subtest: bad-handle
[81.898578] Subtest bad-handle: SUCCESS (0.000s)
[82.009560] [007/131] (945s left) gem_eio (create)
[82.197521] Starting subtest: create
[82.485216] Subtest create: SUCCESS (0.288s)
[84.060621] [008/131] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[85.562321] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[85.563937] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[85.805101] [009/131] (942s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[87.290543] Starting subtest: 2x-cursor-vs-flip-legacy
[87.293359] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.003s)
[87.400043] [010/131] (940s left) sw_sync (timeline_closed_signaled)
[87.449517] Starting subtest: timeline_closed_signaled
[87.450731] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[87.561798] [011/131] (940s left) gem_mmap_gtt (basic-wc)
[87.608317] Subtest basic-wc: SKIP (0.000s)
[87.691098] [012/131] (940s left) drm_buddy (drm_buddy)
[87.732560] Starting subtest: drm_buddy
[87.734360] Subtest drm_buddy: SKIP (0.001s)
[87.828454] [013/131] (940s left) core_auth (getclient-simple)
[87.869016] Starting subtest: getclient-simple
[87.871837] Subtest getclient-simple: SUCCESS (0.002s)
[87.995046] [014/131] (940s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[89.480939] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[89.481927] Starting dynamic subtest: pipe-A
[89.638918] Dynamic subtest pipe-A: SUCCESS (0.158s)
[89.648229] Starting dynamic subtest: pipe-B
[89.779585] Dynamic subtest pipe-B: SUCCESS (0.141s)
[89.788956] Starting dynamic subtest: pipe-C
[89.921143] Dynamic subtest pipe-C: SUCCESS (0.141s)
[89.929896] Starting dynamic subtest: pipe-D
[90.060537] Dynamic subtest pipe-D: SUCCESS (0.139s)
[90.061336] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.580s)
[90.251148] [015/131] (938s left) gem_wait (busy)
[90.312206] Starting subtest: busy
[90.313022] Starting dynamic subtest: all-engines
[90.872204] Dynamic subtest all-engines: SUCCESS (0.560s)
[90.881231] Starting dynamic subtest: rcs0
[91.410641] Dynamic subtest rcs0: SUCCESS (0.538s)
[91.419510] Starting dynamic subtest: bcs0
[91.952752] Dynamic subtest bcs0: SUCCESS (0.542s)
[91.961789] Starting dynamic subtest: vcs0
[92.491654] Dynamic subtest vcs0: SUCCESS (0.539s)
[92.500609] Starting dynamic subtest: vcs1
[93.029624] Dynamic subtest vcs1: SUCCESS (0.538s)
[93.038434] Starting dynamic subtest: vecs0
[93.568805] Dynamic subtest vecs0: SUCCESS (0.539s)
[93.569698] Subtest busy: SUCCESS (3.256s)
[93.865590] [016/131] (934s left) gem_mmap_offset (ptrace)
[93.909872] Starting subtest: ptrace
[93.913869] Starting dynamic subtest: lmem0-fixed
[94.041748] Dynamic subtest lmem0-fixed: SUCCESS (0.126s)
[94.050752] Starting dynamic subtest: smem0-fixed
[94.063610] Dynamic subtest smem0-fixed: SUCCESS (0.021s)
[94.064458] Subtest ptrace: SUCCESS (0.155s)
[94.226071] [017/131] (934s left) gem_create (create-ext-cpu-access-big)
[94.403506] Starting subtest: create-ext-cpu-access-big
[95.443474] Subtest create-ext-cpu-access-big: SUCCESS (1.043s)
[95.698557] [018/131] (933s left) gem_render_copy (linear-to-vebox-yf-tiled)
[95.750910] Starting subtest: linear-to-vebox-yf-tiled
[95.751849] Starting dynamic subtest: smem
[95.831909] Dynamic subtest smem: SUCCESS (0.082s)
[95.840955] Starting dynamic subtest: lmem0
[96.586941] Dynamic subtest lmem0: SUCCESS (0.752s)
[96.588205] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.834s)
[96.833400] [019/131] (932s left) perf (polling-small-buf)
[96.949426] Starting subtest: polling-small-buf
[97.051684] Subtest polling-small-buf: SUCCESS (0.102s)
[97.130994] [020/131] (931s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[98.649230] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[98.650851] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[98.835406] [021/131] (930s left) kms_addfb_basic (basic)
[98.880074] Starting subtest: basic
[98.880977] Subtest basic: SUCCESS (0.000s)
[100.481810] [022/131] (928s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[101.994812] Starting subtest: 4-tiled-8bpp-rotate-0
[101.996384] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[102.173937] [023/131] (927s left) gem_mmap_wc (read)
[102.217811] Subtest read: SKIP (0.000s)
[102.293659] [024/131] (927s left) kms_properties (get_properties-sanity-non-atomic)
[103.777947] Starting subtest: get_properties-sanity-non-atomic
[103.781893] Subtest get_properties-sanity-non-atomic: SUCCESS (0.004s)
[103.917445] [025/131] (925s left) kms_color (legacy-gamma-reset)
[105.416779] Starting subtest: legacy-gamma-reset
[105.417793] Starting dynamic subtest: pipe-A-HDMI-A-4
[105.682220] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.266s)
[105.692188] Starting dynamic subtest: pipe-B-HDMI-A-4
[105.732535] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.051s)
[105.741875] Starting dynamic subtest: pipe-C-HDMI-A-4
[105.771029] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.038s)
[105.780353] Starting dynamic subtest: pipe-D-HDMI-A-4
[105.809371] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.038s)
[105.810357] Subtest legacy-gamma-reset: SUCCESS (0.394s)
[105.956424] [026/131] (923s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[106.003322] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[106.083618] [027/131] (923s left) gem_exec_create (basic)
[106.138960] Starting subtest: basic
[106.139991] Starting dynamic subtest: smem
[108.234428] Dynamic subtest smem: SUCCESS (2.095s)
[108.243673] Starting dynamic subtest: lmem0
[110.328431] Dynamic subtest lmem0: SUCCESS (2.093s)
[110.329362] Subtest basic: SUCCESS (4.190s)
[110.576548] [028/131] (919s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[112.061366] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[112.133111] [029/131] (917s left) gem_sync (basic-many-each)
[112.190751] Starting subtest: basic-many-each
[114.611138] Subtest basic-many-each: SUCCESS (2.420s)
[114.931860] [030/131] (914s left) kms_chamelium_edid (dp-edid-read)
[116.464597] Subtest dp-edid-read: SKIP (0.000s)
[116.576207] [031/131] (913s left) kms_async_flips (invalid-async-flip)
[118.061537] Starting subtest: invalid-async-flip
[118.285226] Starting dynamic subtest: pipe-A-HDMI-A-4
[118.673929] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.389s)
[118.855274] Starting dynamic subtest: pipe-B-HDMI-A-4
[118.946290] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.099s)
[119.121360] Starting dynamic subtest: pipe-C-HDMI-A-4
[119.216690] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.103s)
[119.400267] Starting dynamic subtest: pipe-D-HDMI-A-4
[119.495574] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.103s)
[119.496509] Subtest invalid-async-flip: SUCCESS (1.435s)
[119.857649] [032/131] (910s left) prime_vgem (fence-flip-hang)
[119.930271] Subtest fence-flip-hang: SKIP (0.000s)
[120.107488] [033/131] (909s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[121.597985] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[121.599848] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[121.765348] [034/131] (908s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[121.814765] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[121.919645] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[122.095255] [035/131] (908s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[123.580540] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[123.655291] [036/131] (906s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[125.160618] Starting subtest: yf-tiled-8bpp-rotate-180
[125.162514] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[125.329740] [037/131] (905s left) perf_pmu (busy)
[125.379910] Starting subtest: busy
[125.383235] Starting dynamic subtest: rcs0
[125.985421] Dynamic subtest rcs0: SUCCESS (0.604s)
[125.997745] Starting dynamic subtest: bcs0
[126.544827] Dynamic subtest bcs0: SUCCESS (0.558s)
[126.556951] Starting dynamic subtest: vcs0
[127.103826] Dynamic subtest vcs0: SUCCESS (0.558s)
[127.115822] Starting dynamic subtest: vcs1
[127.661886] Dynamic subtest vcs1: SUCCESS (0.557s)
[127.673897] Starting dynamic subtest: vecs0
[128.224383] Dynamic subtest vecs0: SUCCESS (0.561s)
[128.226360] Subtest busy: SUCCESS (2.845s)
[128.357105] [038/131] (902s left) i915_pm_rc6_residency (rc6-fence)
[128.400647] Starting subtest: rc6-fence
[128.406358] Starting dynamic subtest: gt0
[146.827744] Dynamic subtest gt0: SUCCESS (18.420s)
[146.829833] Subtest rc6-fence: SUCCESS (18.428s)
[146.979635] [039/131] (883s left) syncobj_wait (reset-during-wait-for-submit)
[147.025409] Starting subtest: reset-during-wait-for-submit
[147.133593] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[147.319094] [040/131] (883s left) gem_userptr_blits (process-exit-busy)
[147.379639] Starting subtest: process-exit-busy
[147.398503] Subtest process-exit-busy: SUCCESS (0.019s)
[147.583444] [041/131] (883s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[149.068665] Starting subtest: flip-vs-cursor-legacy
[160.084978] Subtest flip-vs-cursor-legacy: SUCCESS (11.017s)
[160.265065] [042/131] (870s left) kms_feature_discovery (psr2)
[161.750280] Starting subtest: psr2
[161.752054] Subtest psr2: SKIP (0.000s)
[161.886505] [043/131] (868s left) perf (create-destroy-userspace-config)
[162.011243] Starting subtest: create-destroy-userspace-config
[162.041606] Subtest create-destroy-userspace-config: SUCCESS (0.031s)
[162.115396] [044/131] (868s left) api_intel_allocator (execbuf-with-allocator)
[162.160948] Starting subtest: execbuf-with-allocator
[162.181284] Subtest execbuf-with-allocator: SUCCESS (0.021s)
[162.392226] [045/131] (868s left) kms_selftest (drm_format_helper)
[162.436367] Starting subtest: drm_format_helper
[162.509381] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[162.559561] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.071s)
[162.583459] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[162.647822] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.081s)
[162.687141] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[162.719232] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.074s)
[162.734402] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[162.807549] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.084s)
[162.847735] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[162.884285] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.076s)
[162.903044] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[162.972204] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.086s)
[163.005577] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[163.040320] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.066s)
[163.059398] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[163.133451] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.091s)
[163.175603] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[163.206614] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.072s)
[163.224076] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[163.283517] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.074s)
[163.317873] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[163.352355] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.069s)
[163.368510] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[163.441264] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.085s)
[163.479061] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[163.518780] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.078s)
[163.541226] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[163.606932] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.084s)
[163.640756] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[163.681244] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.075s)
[163.703132] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[163.785203] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.099s)
[163.823936] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[163.860891] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.076s)
[163.861989] Subtest drm_format_helper: SUCCESS (1.425s)
[164.063558] [046/131] (867s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[165.554977] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[165.556964] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[165.761303] [047/131] (865s left) gem_mmap_gtt (basic-write-gtt)
[165.806761] Subtest basic-write-gtt: SKIP (0.000s)
[165.876702] [048/131] (865s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[167.380046] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[167.983742] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.604s)
[168.189194] [049/131] (863s left) gem_exec_balancer (nop)
[168.245144] Starting subtest: nop
[207.452401] Subtest nop: SUCCESS (39.207s)
[207.882890] [050/131] (823s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[209.386845] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[210.505093] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.114s)
[210.687557] [051/131] (820s left) gem_exec_reloc (basic-write-gtt)
[210.738096] Subtest basic-write-gtt: SKIP (0.000s)
[210.844988] [052/131] (820s left) kms_draw_crc (draw-method-mmap-gtt)
[212.329686] Starting subtest: draw-method-mmap-gtt
[212.331297] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[212.512942] [053/131] (819s left) gem_exec_schedule (independent)
[212.571666] Starting subtest: independent
[212.572518] Starting dynamic subtest: rcs0
[212.819360] Dynamic subtest rcs0: SUCCESS (0.247s)
[212.830982] Starting dynamic subtest: bcs0
[213.021355] Dynamic subtest bcs0: SUCCESS (0.201s)
[213.036298] Starting dynamic subtest: vcs0
[213.237024] Dynamic subtest vcs0: SUCCESS (0.215s)
[213.261641] Starting dynamic subtest: vcs1
[213.465791] Dynamic subtest vcs1: SUCCESS (0.228s)
[213.490706] Starting dynamic subtest: vecs0
[213.697271] Dynamic subtest vecs0: SUCCESS (0.230s)
[213.698246] Subtest independent: SUCCESS (1.126s)
[214.186347] [054/131] (817s left) gem_mmap_gtt (basic-small-bo)
[214.231719] Subtest basic-small-bo: SKIP (0.000s)
[214.311886] [055/131] (817s left) kms_cursor_crc (cursor-onscreen-max-size)
[216.115165] Starting subtest: cursor-onscreen-max-size
[216.117684] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[216.339146] [056/131] (815s left) kms_busy (extended-pageflip-hang-newfb)
[217.830597] Starting subtest: extended-pageflip-hang-newfb
[217.831448] Starting dynamic subtest: pipe-A
[225.639929] Dynamic subtest pipe-A: SUCCESS (7.809s)
[225.653968] Starting dynamic subtest: pipe-D
[233.424931] Dynamic subtest pipe-D: SUCCESS (7.779s)
[233.425898] Subtest extended-pageflip-hang-newfb: SUCCESS (15.595s)
[233.636703] [057/131] (798s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[235.122761] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[235.123551] Starting dynamic subtest: pipe-A-HDMI-A-4
[235.131162] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[235.141891] Starting dynamic subtest: pipe-B-HDMI-A-4
[235.149779] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[235.160039] Starting dynamic subtest: pipe-C-HDMI-A-4
[235.167989] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[235.178302] Starting dynamic subtest: pipe-D-HDMI-A-4
[235.186519] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[235.187495] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.010s)
[235.385682] [058/131] (796s left) gem_exec_capture (pi)
[235.436867] Starting subtest: pi
[235.437725] Starting dynamic subtest: rcs0
[242.406153] Dynamic subtest rcs0: SUCCESS (6.966s)
[242.417213] Starting dynamic subtest: bcs0
[248.824202] Dynamic subtest bcs0: SUCCESS (6.417s)
[248.835284] Starting dynamic subtest: vcs0
[255.285604] Dynamic subtest vcs0: SUCCESS (6.460s)
[255.296414] Starting dynamic subtest: vcs1
[261.775638] Dynamic subtest vcs1: SUCCESS (6.490s)
[261.786506] Starting dynamic subtest: vecs0
[268.128758] Dynamic subtest vecs0: SUCCESS (6.350s)
[268.129861] Subtest pi: SUCCESS (32.686s)
[268.311096] [059/131] (763s left) gem_userptr_blits (unsync-unmap-cycles)
[268.417051] Subtest unsync-unmap-cycles: SKIP (0.000s)
[268.589872] [060/131] (763s left) gen3_render_tiledy_blits
[268.712279] [061/131] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[270.207033] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[270.208549] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[270.368833] [062/131] (762s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[271.857571] Starting subtest: basic-busy-flip-before-cursor-atomic
[271.859232] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[271.971568] [063/131] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[273.466337] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[273.467943] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[273.648746] [064/131] (759s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[273.700904] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[273.810525] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[273.969823] [065/131] (758s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[275.457896] Starting subtest: psr-2p-pri-indfb-multidraw
[275.459597] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[275.610865] [066/131] (757s left) kms_psr (fbc-psr-cursor-blt)
[277.104807] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[277.179037] [067/131] (755s left) prime_mmap (test_refcounting)
[277.224837] Starting subtest: test_refcounting
[277.225688] Starting dynamic subtest: test_refcounting-smem
[277.290613] Dynamic subtest test_refcounting-smem: SUCCESS (0.066s)
[277.301415] Starting dynamic subtest: test_refcounting-lmem0
[277.357247] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.066s)
[277.358159] Subtest test_refcounting: SUCCESS (0.133s)
[277.493591] [068/131] (755s left) gem_mmap_gtt (pf-nonblock)
[277.539151] Subtest pf-nonblock: SKIP (0.000s)
[277.612126] [069/131] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[279.099466] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[279.101107] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[279.271669] [070/131] (753s left) gem_mmap_gtt (basic)
[279.321323] Subtest basic: SKIP (0.000s)
[279.395992] [071/131] (753s left) gem_exec_parallel (engines)
[279.451894] Starting subtest: engines
[279.452833] Starting dynamic subtest: basic
[281.021085] Dynamic subtest basic: SUCCESS (1.569s)
[281.032669] Starting dynamic subtest: contexts
[285.166397] Dynamic subtest contexts: SUCCESS (4.141s)
[285.177717] Starting dynamic subtest: fds
[289.764872] Dynamic subtest fds: SUCCESS (4.598s)
[289.776073] Starting dynamic subtest: userptr
[291.269090] Dynamic subtest userptr: SUCCESS (1.507s)
[291.270101] Subtest engines: SUCCESS (11.818s)
[291.625862] [072/131] (741s left) gen9_exec_parse (bb-start-out)
[291.676379] Subtest bb-start-out: SKIP (0.000s)
[291.746138] [073/131] (741s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[293.229840] Starting subtest: short-flip-before-cursor-atomic-transitions
[294.308184] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.078s)
[294.499094] [074/131] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[295.988396] Starting subtest: psr-1p-primscrn-cur-indfb-move
[295.989977] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[296.172139] [075/131] (737s left) gem_exec_whisper (basic-contexts)
[296.231309] Starting subtest: basic-contexts
[301.456322] Subtest basic-contexts: SUCCESS (5.221s)
[301.723727] [076/131] (732s left) kms_psr (psr-cursor-render)
[303.207919] Subtest psr-cursor-render: SKIP (0.000s)
[303.287444] [077/131] (730s left) kms_plane_multiple (2x-tiling-4)
[304.772713] Starting subtest: 2x-tiling-4
[304.774282] Subtest 2x-tiling-4: SKIP (0.000s)
[304.881187] [078/131] (728s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[306.371176] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[306.373136] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[306.485350] [079/131] (727s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[307.977470] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[308.053013] [080/131] (725s left) kms_psr (pr-cursor-render)
[309.537375] Subtest pr-cursor-render: SKIP (0.000s)
[309.621813] [081/131] (724s left) perf_pmu (gt-awake)
[309.671133] Starting subtest: gt-awake
[312.943103] Subtest gt-awake: SUCCESS (3.272s)
[313.070784] [082/131] (721s left) syncobj_timeline (single-wait-available-submitted)
[313.118884] Starting subtest: single-wait-available-submitted
[313.119734] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[313.226916] [083/131] (720s left) kms_big_fb (linear-64bpp-rotate-180)
[314.736379] Starting subtest: linear-64bpp-rotate-180
[317.046172] Subtest linear-64bpp-rotate-180: SUCCESS (2.307s)
[317.272968] [084/131] (717s left) sw_sync (sync_merge_invalid)
[317.316533] Starting subtest: sync_merge_invalid
[317.320657] Subtest sync_merge_invalid: SUCCESS (0.004s)
[317.409183] [085/131] (716s left) kms_chamelium_audio (dp-audio)
[318.933862] Subtest dp-audio: SKIP (0.000s)
[319.047143] [086/131] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[320.537064] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[320.538822] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[320.713224] [087/131] (713s left) kms_lease (invalid-create-leases)
[322.200840] Starting subtest: invalid-create-leases
[322.205542] Subtest invalid-create-leases: SUCCESS (0.006s)
[322.327087] [088/131] (712s left) i915_drm_fdinfo (memory-info-idle)
[322.382095] Starting subtest: memory-info-idle
[322.382971] Starting dynamic subtest: lmem0
[322.424555] Dynamic subtest lmem0: SUCCESS (0.043s)
[322.435976] Starting dynamic subtest: smem0
[322.470097] Dynamic subtest smem0: SUCCESS (0.045s)
[322.470997] Subtest memory-info-idle: SUCCESS (0.089s)
[322.594530] [089/131] (712s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[324.097969] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[325.351766] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.253s)
[325.570768] [090/131] (709s left) kms_properties (colorop-properties-legacy)
[327.054429] Starting subtest: colorop-properties-legacy
[327.056930] Starting dynamic subtest: pipe-A-HDMI-A-4
[327.173070] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.117s)
[327.185733] Starting dynamic subtest: pipe-B-HDMI-A-4
[327.264234] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.089s)
[327.278374] Starting dynamic subtest: pipe-C-HDMI-A-4
[327.365323] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.099s)
[327.377440] Starting dynamic subtest: pipe-D-HDMI-A-4
[327.474849] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.108s)
[327.475762] Subtest colorop-properties-legacy: SUCCESS (0.420s)
[327.664052] [091/131] (707s left) i915_query (engine-info-invalid)
[327.709187] Starting subtest: engine-info-invalid
[327.710019] Subtest engine-info-invalid: SUCCESS (0.000s)
[327.814523] [092/131] (707s left) kms_flip (2x-plain-flip-fb-recreate)
[329.299325] Starting subtest: 2x-plain-flip-fb-recreate
[329.317435] Subtest 2x-plain-flip-fb-recreate: SKIP (0.017s)
[329.443659] [093/131] (705s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[329.499169] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[329.501093] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[329.616846] [094/131] (705s left) kms_cursor_crc (cursor-size-change)
[331.102181] Starting subtest: cursor-size-change
[331.102998] Starting dynamic subtest: pipe-A-HDMI-A-4
[332.055194] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.952s)
[332.068111] Starting dynamic subtest: pipe-D-HDMI-A-4
[332.797972] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.741s)
[332.798834] Subtest cursor-size-change: SUCCESS (1.697s)
[333.514034] [095/131] (701s left) kms_vblank (wait-forked-busy)
[334.999123] Starting subtest: wait-forked-busy
[335.001219] Starting dynamic subtest: pipe-A-HDMI-A-4
[337.553563] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.553s)
[337.568193] Starting dynamic subtest: pipe-D-HDMI-A-4
[339.950049] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.392s)
[339.950929] Subtest wait-forked-busy: SUCCESS (4.952s)
[340.122721] [096/131] (695s left) gem_tiled_fence_blits (basic)
[340.175149] Subtest basic: SKIP (0.000s)
[340.250406] [097/131] (695s left) gem_ctx_persistence (legacy-engines-mixed)
[340.301370] Starting subtest: legacy-engines-mixed
[340.302218] Starting dynamic subtest: render
[340.369176] Dynamic subtest render: SUCCESS (0.067s)
[340.383173] Starting dynamic subtest: bsd1
[340.418290] Dynamic subtest bsd1: SUCCESS (0.048s)
[340.440513] Starting dynamic subtest: bsd2
[340.471525] Dynamic subtest bsd2: SUCCESS (0.051s)
[340.505324] Starting dynamic subtest: blt
[340.542434] Dynamic subtest blt: SUCCESS (0.068s)
[340.571449] Starting dynamic subtest: vebox
[340.609624] Dynamic subtest vebox: SUCCESS (0.064s)
[340.611141] Subtest legacy-engines-mixed: SUCCESS (0.309s)
[340.808628] [098/131] (694s left) kms_plane (plane-position-covered)
[342.294408] Starting subtest: plane-position-covered
[342.745208] Starting dynamic subtest: pipe-A-plane-1
[343.123571] Dynamic subtest pipe-A-plane-1: SUCCESS (0.377s)
[343.135190] Starting dynamic subtest: pipe-A-plane-2
[343.518206] Dynamic subtest pipe-A-plane-2: SUCCESS (0.394s)
[343.529823] Starting dynamic subtest: pipe-A-plane-3
[343.878495] Dynamic subtest pipe-A-plane-3: SUCCESS (0.360s)
[343.890046] Starting dynamic subtest: pipe-A-plane-4
[344.273139] Dynamic subtest pipe-A-plane-4: SUCCESS (0.394s)
[344.285864] Starting dynamic subtest: pipe-A-plane-5
[344.668321] Dynamic subtest pipe-A-plane-5: SUCCESS (0.394s)
[344.679992] Starting dynamic subtest: pipe-A-plane-6
[345.063546] Dynamic subtest pipe-A-plane-6: SUCCESS (0.394s)
[345.075104] Starting dynamic subtest: pipe-A-plane-7
[345.084724] Dynamic subtest pipe-A-plane-7: SUCCESS (0.019s)
[345.376237] Starting dynamic subtest: pipe-B-plane-1
[345.742464] Dynamic subtest pipe-B-plane-1: SUCCESS (0.378s)
[345.754124] Starting dynamic subtest: pipe-B-plane-2
[346.133391] Dynamic subtest pipe-B-plane-2: SUCCESS (0.390s)
[346.146404] Starting dynamic subtest: pipe-B-plane-3
[346.526356] Dynamic subtest pipe-B-plane-3: SUCCESS (0.392s)
[346.539482] Starting dynamic subtest: pipe-B-plane-4
[346.919227] Dynamic subtest pipe-B-plane-4: SUCCESS (0.391s)
[346.930810] Starting dynamic subtest: pipe-B-plane-5
[347.309257] Dynamic subtest pipe-B-plane-5: SUCCESS (0.389s)
[347.320796] Starting dynamic subtest: pipe-B-plane-6
[347.699654] Dynamic subtest pipe-B-plane-6: SUCCESS (0.389s)
[347.711277] Starting dynamic subtest: pipe-B-plane-7
[347.726037] Dynamic subtest pipe-B-plane-7: SUCCESS (0.024s)
[347.727026] Subtest plane-position-covered: SUCCESS (5.433s)
[347.918637] [099/131] (687s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[349.411261] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[349.412112] Starting dynamic subtest: pipe-A-HDMI-A-4
[349.433539] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[349.445295] Starting dynamic subtest: pipe-B-HDMI-A-4
[349.466157] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[349.477451] Starting dynamic subtest: pipe-C-HDMI-A-4
[349.499215] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[349.510417] Starting dynamic subtest: pipe-D-HDMI-A-4
[349.531738] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[349.533319] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.021s)
[349.684242] [100/131] (685s left) gem_exec_schedule (u-semaphore-codependency)
[349.745920] Starting subtest: u-semaphore-codependency
[349.773576] Subtest u-semaphore-codependency: SUCCESS (0.028s)
[350.213461] [101/131] (685s left) gem_spin_batch (resubmit-new-all)
[350.269113] Starting subtest: resubmit-new-all
[350.269917] Starting dynamic subtest: rcs0
[350.294970] Dynamic subtest rcs0: SUCCESS (0.025s)
[350.307982] Starting dynamic subtest: bcs0
[350.308901] Dynamic subtest bcs0: SUCCESS (0.008s)
[350.320466] Starting dynamic subtest: vcs0
[350.321396] Dynamic subtest vcs0: SUCCESS (0.007s)
[350.332858] Starting dynamic subtest: vcs1
[350.333985] Dynamic subtest vcs1: SUCCESS (0.007s)
[350.345262] Starting dynamic subtest: vecs0
[350.346358] Dynamic subtest vecs0: SUCCESS (0.008s)
[350.347229] Subtest resubmit-new-all: SUCCESS (0.062s)
[350.681900] [102/131] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[352.171811] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[352.173611] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[352.331128] [103/131] (683s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[353.820134] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[354.070391] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs
[356.348477] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs: SUCCESS (2.274s)
[356.363490] Starting dynamic subtest: pipe-A-HDMI-A-4-y
[358.548305] Dynamic subtest pipe-A-HDMI-A-4-y: SUCCESS (2.196s)
[358.562562] Starting dynamic subtest: pipe-A-HDMI-A-4-y
[360.563560] Dynamic subtest pipe-A-HDMI-A-4-y: SUCCESS (2.012s)
[360.577452] Starting dynamic subtest: pipe-A-HDMI-A-4-x
[362.780527] Dynamic subtest pipe-A-HDMI-A-4-x: SUCCESS (2.214s)
[362.991548] Starting dynamic subtest: pipe-B-HDMI-A-4-y-rc-ccs
[365.221528] Dynamic subtest pipe-B-HDMI-A-4-y-rc-ccs: SUCCESS (2.237s)
[365.235851] Starting dynamic subtest: pipe-B-HDMI-A-4-y
[367.402292] Dynamic subtest pipe-B-HDMI-A-4-y: SUCCESS (2.177s)
[367.417078] Starting dynamic subtest: pipe-B-HDMI-A-4-y
[369.418924] Dynamic subtest pipe-B-HDMI-A-4-y: SUCCESS (2.012s)
[369.433853] Starting dynamic subtest: pipe-B-HDMI-A-4-x
[371.618878] Dynamic subtest pipe-B-HDMI-A-4-x: SUCCESS (2.197s)
[371.789570] Starting dynamic subtest: pipe-C-HDMI-A-4-y-rc-ccs
[374.021072] Dynamic subtest pipe-C-HDMI-A-4-y-rc-ccs: SUCCESS (2.238s)
[374.035858] Starting dynamic subtest: pipe-C-HDMI-A-4-y
[376.201937] Dynamic subtest pipe-C-HDMI-A-4-y: SUCCESS (2.177s)
[376.213806] Starting dynamic subtest: pipe-C-HDMI-A-4-y
[378.220113] Dynamic subtest pipe-C-HDMI-A-4-y: SUCCESS (2.014s)
[378.235619] Starting dynamic subtest: pipe-C-HDMI-A-4-x
[380.417826] Dynamic subtest pipe-C-HDMI-A-4-x: SUCCESS (2.194s)
[380.597480] Starting dynamic subtest: pipe-D-HDMI-A-4-y-rc-ccs
[382.833527] Dynamic subtest pipe-D-HDMI-A-4-y-rc-ccs: SUCCESS (2.243s)
[382.848483] Starting dynamic subtest: pipe-D-HDMI-A-4-y
[385.017137] Dynamic subtest pipe-D-HDMI-A-4-y: SUCCESS (2.179s)
[385.031641] Starting dynamic subtest: pipe-D-HDMI-A-4-y
[387.033294] Dynamic subtest pipe-D-HDMI-A-4-y: SUCCESS (2.013s)
[387.047311] Starting dynamic subtest: pipe-D-HDMI-A-4-x
[389.231346] Dynamic subtest pipe-D-HDMI-A-4-x: SUCCESS (2.195s)
[389.232170] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (35.409s)
[389.593116] [104/131] (646s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[391.117712] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[391.233409] [105/131] (644s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[392.719482] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[392.720272] Starting dynamic subtest: pipe-A-valid-mode
[393.539156] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.818s)
[393.540043] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SUCCESS (0.821s)
[393.724880] [106/131] (642s left) syncobj_timeline (invalid-transfer-non-existent-point)
[393.772255] Starting subtest: invalid-transfer-non-existent-point
[393.772973] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[393.900220] [107/131] (642s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[393.953453] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[393.954272] Starting dynamic subtest: smem
[394.054786] Dynamic subtest smem: SUCCESS (0.101s)
[394.067897] Starting dynamic subtest: lmem0
[395.169416] Dynamic subtest lmem0: SUCCESS (1.110s)
[395.170569] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.214s)
[395.434400] [108/131] (640s left) perf_pmu (all-busy-idle-check-all)
[395.483840] Starting subtest: all-busy-idle-check-all
[396.153459] Subtest all-busy-idle-check-all: SUCCESS (0.669s)
[396.307814] [109/131] (639s left) kms_psr (psr-basic)
[397.792990] Subtest psr-basic: SKIP (0.000s)
[397.869661] [110/131] (638s left) gem_busy (extended)
[398.117306] Starting subtest: extended
[398.118450] Starting dynamic subtest: rcs0
[398.192141] Dynamic subtest rcs0: SUCCESS (0.076s)
[398.216146] Starting dynamic subtest: bcs0
[398.237179] Dynamic subtest bcs0: SUCCESS (0.043s)
[398.261392] Starting dynamic subtest: vcs0
[398.282070] Dynamic subtest vcs0: SUCCESS (0.042s)
[398.302535] Starting dynamic subtest: vcs1
[398.325958] Dynamic subtest vcs1: SUCCESS (0.042s)
[398.344063] Starting dynamic subtest: vecs0
[398.369112] Dynamic subtest vecs0: SUCCESS (0.041s)
[398.370256] Subtest extended: SUCCESS (0.255s)
[398.720209] [111/131] (637s left) kms_pm_lpsp (kms-lpsp)
[401.214306] Starting subtest: kms-lpsp
[401.215925] Subtest kms-lpsp: SKIP (0.000s)
[401.330786] [112/131] (635s left) kms_cursor_legacy (single-bo)
[402.822335] Starting subtest: single-bo
[402.823168] Starting dynamic subtest: pipe-A
[408.208595] Dynamic subtest pipe-A: SUCCESS (5.382s)
[408.220128] Starting dynamic subtest: pipe-B
[413.591981] Dynamic subtest pipe-B: SUCCESS (5.381s)
[413.603569] Starting dynamic subtest: pipe-C
[418.974843] Dynamic subtest pipe-C: SUCCESS (5.381s)
[418.986373] Starting dynamic subtest: pipe-D
[424.357848] Dynamic subtest pipe-D: SUCCESS (5.381s)
[424.369337] Starting dynamic subtest: all-pipes
[429.738973] Dynamic subtest all-pipes: SUCCESS (5.382s)
[429.739884] Subtest single-bo: SUCCESS (26.916s)
[429.860891] [113/131] (606s left) gem_eio (in-flight-internal-1us)
[430.049823] Starting subtest: in-flight-internal-1us
[431.844514] Subtest in-flight-internal-1us: SUCCESS (1.796s)
[433.427839] [114/131] (603s left) i915_getparams_basic (basic-eu-total)
[433.482747] Starting subtest: basic-eu-total
[433.484287] Subtest basic-eu-total: SUCCESS (0.000s)
[433.600416] [115/131] (603s left) syncobj_basic (bad-pad-fd-to-handle)
[433.644826] Starting subtest: bad-pad-fd-to-handle
[433.645822] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[433.791914] [116/131] (603s left) kms_joiner (basic-big-joiner)
[435.277452] Starting subtest: basic-big-joiner
[435.279316] Subtest basic-big-joiner: SKIP (0.000s)
[435.400053] [117/131] (601s left) kms_content_protection (atomic-dpms)
[436.950566] Starting subtest: atomic-dpms
[436.954717] Subtest atomic-dpms: SKIP (0.002s)
[437.167411] [118/131] (599s left) gem_exec_flush (basic-wb-rw-before-default)
[437.219479] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[437.329876] [119/131] (599s left) kms_rotation_crc (sprite-rotation-180)
[438.816195] Starting subtest: sprite-rotation-180
[449.267719] Subtest sprite-rotation-180: SUCCESS (10.452s)
[449.539636] [120/131] (587s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[451.031042] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[451.032872] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[451.226789] [121/131] (586s left) kms_cursor_edge_walk (256x256-top-bottom)
[452.713972] Starting subtest: 256x256-top-bottom
[452.714950] Starting dynamic subtest: pipe-A-HDMI-A-4
[456.025941] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.311s)
[456.039181] Starting dynamic subtest: pipe-D-HDMI-A-4
[459.245596] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.217s)
[459.246474] Subtest 256x256-top-bottom: SUCCESS (6.534s)
[459.428794] [122/131] (577s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[459.475216] Starting subtest: invalid-single-wait-all-unsubmitted
[459.475995] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[459.617530] [123/131] (577s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[461.108134] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[461.109887] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[461.292621] [124/131] (576s left) kms_fbcon_fbt (fbc-suspend)
[461.360274] Starting subtest: fbc-suspend
[517.100692] Subtest fbc-suspend: SUCCESS (33.925s)
[518.209646] [125/131] (520s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[519.697524] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[519.699240] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[519.827295] [126/131] (518s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[521.327601] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[521.329188] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[521.512906] [127/131] (517s left) gem_exec_whisper (basic-queues-forked-all)
[521.570645] Starting subtest: basic-queues-forked-all
[534.106523] Subtest basic-queues-forked-all: SUCCESS (12.532s)
[534.388320] [128/131] (504s left) gem_fenced_exec_thrash (too-many-fences)
[534.439121] Subtest too-many-fences: SKIP (0.000s)
[534.529053] [129/131] (504s left) gem_ctx_param (invalid-get-no-zeromap)
[534.577084] Starting subtest: invalid-get-no-zeromap
[534.577996] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[534.729157] [130/131] (504s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[536.221355] Starting subtest: fbc-rgb101010-draw-pwrite
[539.230844] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.009s)
[539.424709] [131/131] (499s left) kms_cursor_crc (cursor-size-hints)
[540.974040] Starting subtest: cursor-size-hints
[540.976632] Starting dynamic subtest: pipe-A-HDMI-A-4
[541.582267] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.606s)
[541.597327] Starting dynamic subtest: pipe-D-HDMI-A-4
[542.021850] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.437s)
[542.022718] Subtest cursor-size-hints: SUCCESS (1.049s)
[542.634011] 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.