[56.669769] Initializing watchdogs
[56.669818]   /dev/watchdog0
[56.685472] [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]
[56.690101] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.692463] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.695783] [001/156] (960s left) kms_universal_plane (universal-plane-pageflip-windowed)
[56.822302] Starting subtest: universal-plane-pageflip-windowed
[56.824721] Starting dynamic subtest: pipe-A-eDP-1
[57.428208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.591s)
[57.439958] Starting dynamic subtest: pipe-B-eDP-1
[58.696391] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.245s)
[58.704909] Starting dynamic subtest: pipe-C-eDP-1
[59.927110] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s)
[59.935509] Starting dynamic subtest: pipe-D-eDP-1
[61.173785] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[61.176240] Subtest universal-plane-pageflip-windowed: SUCCESS (4.278s)
[62.071329] [002/156] (955s left) gem_ppgtt (shrink-vs-evict-any)
[62.136661] Starting subtest: shrink-vs-evict-any
[69.320886] Subtest shrink-vs-evict-any: SUCCESS (7.084s)
[69.361072] [003/156] (947s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[69.476623] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[69.480771] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[69.588873] [004/156] (947s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[69.684619] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[69.689070] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[69.755905] [005/156] (947s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[69.860410] Starting subtest: yf-tiled-8bpp-rotate-90
[69.864756] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[69.956175] [006/156] (947s left) kms_psr (fbc-psr-cursor-render)
[70.040101] Starting subtest: fbc-psr-cursor-render
[70.042446] Starting dynamic subtest: eDP-1
[70.046947] Dynamic subtest eDP-1: SKIP (0.000s)
[70.051324] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[70.122374] [007/156] (947s left) gem_exec_fence (invalid-fence-array)
[70.561379] Starting subtest: invalid-fence-array
[70.563868] Subtest invalid-fence-array: SUCCESS (0.002s)
[72.474216] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[72.477795] [008/156] (945s left) gem_close_race (basic-process)
[72.601532] Starting subtest: basic-process
[73.040460] Subtest basic-process: SUCCESS (0.437s)
[73.242144] [009/156] (944s left) perf (invalid-create-userspace-config)
[73.394384] Starting subtest: invalid-create-userspace-config
[73.396657] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[73.450722] [010/156] (944s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[73.571210] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[73.575984] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[73.747855] [011/156] (943s left) kms_chamelium_color (ctm-limited-range)
[73.852454] Subtest ctm-limited-range: SKIP (0.000s)
[73.896724] [012/156] (943s left) gem_mmap_gtt (fault-concurrent-x)
[73.953314] Subtest fault-concurrent-X: SKIP (0.000s)
[74.014792] [013/156] (943s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[74.067059] Starting subtest: etime-single-wait-for-submit-unsubmitted
[74.172408] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[74.292836] [014/156] (943s left) prime_self_import (export-vs-gem_close-race)
[74.326386] Starting subtest: export-vs-gem_close-race
[79.428707] Subtest export-vs-gem_close-race: SUCCESS (5.077s)
[79.486334] [015/156] (938s left) kms_getfb (getfb-handle-protection)
[79.588955] Starting subtest: getfb-handle-protection
[79.613372] Subtest getfb-handle-protection: SUCCESS (0.025s)
[79.724721] [016/156] (938s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[79.820597] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[79.824946] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[79.912631] [017/156] (938s left) vgem_basic (dmabuf-mmap)
[79.953801] Starting subtest: dmabuf-mmap
[79.962703] Subtest dmabuf-mmap: SUCCESS (0.011s)
[80.018307] [018/156] (937s left) core_sysfs (read-all-entries)
[80.078096] Starting subtest: read-all-entries
[80.088195] Subtest read-all-entries: SUCCESS (0.012s)
[80.195370] [019/156] (937s left) kms_properties (connector-properties-atomic)
[80.281017] Starting subtest: connector-properties-atomic
[80.283195] Starting dynamic subtest: pipe-A-eDP-1
[88.367869] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.078s)
[88.377923] Starting dynamic subtest: pipe-None-DP-1
[88.382860] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[88.390825] Starting dynamic subtest: pipe-None-HDMI-A-1
[88.395403] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[88.403075] Starting dynamic subtest: pipe-None-DP-2
[88.407190] Dynamic subtest pipe-None-DP-2: SUCCESS (0.003s)
[88.415293] Starting dynamic subtest: pipe-None-HDMI-A-2
[88.419951] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[88.428376] Starting dynamic subtest: pipe-None-DP-3
[88.433090] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[88.441119] Starting dynamic subtest: pipe-None-DP-4
[88.445273] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[88.447394] Subtest connector-properties-atomic: SUCCESS (8.090s)
[89.265681] [020/156] (928s left) syncobj_timeline (invalid-query-one-illegal-handle)
[89.313774] Starting subtest: invalid-query-one-illegal-handle
[89.316175] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[89.434435] [021/156] (928s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[89.528433] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[89.532938] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[89.623544] [022/156] (928s left) gem_tiled_swapping (non-threaded)
[89.690862] Subtest non-threaded: SKIP (0.000s)
[89.748809] [023/156] (928s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[89.845030] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[93.453227] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.612s)
[94.676656] [024/156] (923s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[94.785646] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[94.790086] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[94.869385] [025/156] (923s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc)
[94.978017] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc
[94.982296] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[95.086444] [026/156] (923s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[95.194159] Starting subtest: 4-tiled-16bpp-rotate-270
[95.213739] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[95.337955] [027/156] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[95.431209] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[95.435444] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[95.547325] [028/156] (922s left) kms_psr (fbc-psr2-sprite-render)
[95.627997] Starting subtest: fbc-psr2-sprite-render
[95.629873] Starting dynamic subtest: eDP-1
[95.633514] Dynamic subtest eDP-1: SKIP (0.000s)
[95.637057] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[95.704160] [029/156] (922s left) i915_pm_freq_api (freq-reset)
[95.777104] Starting subtest: freq-reset
[95.779091] Starting dynamic subtest: gt0
[95.961084] Dynamic subtest gt0: SUCCESS (0.181s)
[95.969769] Starting dynamic subtest: gt1
[96.109038] Dynamic subtest gt1: SUCCESS (0.147s)
[96.111885] Subtest freq-reset: SUCCESS (0.330s)
[96.194229] [030/156] (922s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[96.296099] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[96.300784] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[96.394756] [031/156] (922s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[96.483925] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[96.488141] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[96.554164] [032/156] (921s left) kms_flip (dpms-off-confusion-interruptible)
[96.652286] Starting subtest: dpms-off-confusion-interruptible
[96.654405] Starting dynamic subtest: A-eDP1
[105.399277] Dynamic subtest A-eDP1: SUCCESS (8.707s)
[105.412152] Starting dynamic subtest: B-eDP1
[114.030657] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[114.042191] Starting dynamic subtest: C-eDP1
[122.672748] Dynamic subtest C-eDP1: SUCCESS (8.629s)
[122.683721] Starting dynamic subtest: D-eDP1
[131.311453] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[131.313945] Subtest dpms-off-confusion-interruptible: SUCCESS (34.606s)
[132.439358] [033/156] (886s left) sysfs_timeslice_duration (invalid)
[132.495799] Starting subtest: invalid
[132.498091] Starting dynamic subtest: vecs0
[132.500313] Dynamic subtest vecs0: SUCCESS (0.000s)
[132.512858] Starting dynamic subtest: ccs0
[132.515068] Dynamic subtest ccs0: SUCCESS (0.000s)
[132.523787] Starting dynamic subtest: vcs0
[132.525914] Dynamic subtest vcs0: SUCCESS (0.000s)
[132.534328] Starting dynamic subtest: bcs0
[132.536512] Dynamic subtest bcs0: SUCCESS (0.000s)
[132.544820] Starting dynamic subtest: rcs0
[132.547080] Dynamic subtest rcs0: SUCCESS (0.000s)
[132.555389] Starting dynamic subtest: vcs1
[132.557706] Dynamic subtest vcs1: SUCCESS (0.000s)
[132.559903] Subtest invalid: SUCCESS (0.004s)
[132.602633] [034/156] (886s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[132.700262] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[132.704852] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[132.801296] [035/156] (885s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[132.856816] Starting subtest: multi-wait-for-submit-unsubmitted
[132.963841] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[133.051116] [036/156] (885s left) gem_exec_whisper (basic-contexts)
[133.115698] Starting subtest: basic-contexts
[140.296891] Subtest basic-contexts: SUCCESS (7.178s)
[140.496616] [037/156] (878s left) api_intel_bb (intel-bb-blit-x)
[140.557924] Starting subtest: intel-bb-blit-x
[144.104281] Subtest intel-bb-blit-x: SUCCESS (3.545s)
[144.201383] [038/156] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[144.315655] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[144.320048] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[144.409178] [039/156] (874s left) gem_ringfill (legacy-basic)
[150.276102] Starting subtest: legacy-basic
[150.278939] Starting dynamic subtest: default
[150.323034] Dynamic subtest default: SUCCESS (0.047s)
[150.333953] Starting dynamic subtest: render
[150.363737] Dynamic subtest render: SUCCESS (0.040s)
[150.373602] Starting dynamic subtest: bsd
[150.408642] Dynamic subtest bsd: SUCCESS (0.043s)
[150.418927] Starting dynamic subtest: bsd1
[150.451418] Dynamic subtest bsd1: SUCCESS (0.042s)
[150.461730] Starting dynamic subtest: bsd2
[150.494964] Dynamic subtest bsd2: SUCCESS (0.042s)
[150.505672] Starting dynamic subtest: blt
[150.541051] Dynamic subtest blt: SUCCESS (0.044s)
[150.551548] Starting dynamic subtest: vebox
[150.586484] Dynamic subtest vebox: SUCCESS (0.043s)
[150.589053] Subtest legacy-basic: SUCCESS (0.312s)
[150.664633] [040/156] (868s left) kms_flip (blocking-absolute-wf_vblank)
[150.764018] Starting subtest: blocking-absolute-wf_vblank
[150.766344] Starting dynamic subtest: A-eDP1
[159.538207] Dynamic subtest A-eDP1: SUCCESS (8.740s)
[159.550252] Starting dynamic subtest: B-eDP1
[168.271287] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[168.282206] Starting dynamic subtest: C-eDP1
[176.996321] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[177.006179] Starting dynamic subtest: D-eDP1
[185.735280] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[185.738034] Subtest blocking-absolute-wf_vblank: SUCCESS (34.928s)
[186.900458] [041/156] (832s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[187.001867] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[187.006831] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[187.118358] [042/156] (831s left) sw_sync (sync_multi_consumer)
[187.148013] Starting subtest: sync_multi_consumer
[187.587945] Subtest sync_multi_consumer: SUCCESS (0.439s)
[187.648825] [043/156] (831s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[187.738423] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[187.740871] Starting dynamic subtest: pipe-A
[187.763180] Dynamic subtest pipe-A: SKIP (0.021s)
[187.772497] Starting dynamic subtest: pipe-B
[187.799293] Dynamic subtest pipe-B: SKIP (0.033s)
[187.808261] Starting dynamic subtest: pipe-C
[187.834027] Dynamic subtest pipe-C: SKIP (0.036s)
[187.843151] Starting dynamic subtest: pipe-D
[187.865231] Dynamic subtest pipe-D: SKIP (0.033s)
[187.868952] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.125s)
[187.963010] [044/156] (831s left) kms_color (ctm-negative)
[188.059084] Starting subtest: ctm-negative
[188.061307] Starting dynamic subtest: pipe-A-eDP-1
[188.771612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[188.782485] Starting dynamic subtest: pipe-B-eDP-1
[190.207375] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[190.217967] Starting dynamic subtest: pipe-C-eDP-1
[191.572190] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s)
[191.581592] Starting dynamic subtest: pipe-D-eDP-1
[192.914499] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[192.916850] Subtest ctm-negative: SUCCESS (4.856s)
[193.738891] [045/156] (825s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[193.845917] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[194.869488] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.023s)
[195.025046] [046/156] (824s left) kms_invalid_mode (int-max-clock)
[195.116732] Starting subtest: int-max-clock
[195.119259] Starting dynamic subtest: pipe-A-eDP-1
[195.399573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[195.409684] Starting dynamic subtest: pipe-B-eDP-1
[195.411638] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[195.420571] Starting dynamic subtest: pipe-C-eDP-1
[195.422865] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[195.432156] Starting dynamic subtest: pipe-D-eDP-1
[195.434407] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[195.436672] Subtest int-max-clock: SUCCESS (0.289s)
[196.260367] [047/156] (822s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[196.366098] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[196.368438] Starting dynamic subtest: pipe-A-eDP-1
[196.391726] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.401490] Starting dynamic subtest: pipe-B-eDP-1
[196.423339] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[196.432075] Starting dynamic subtest: pipe-C-eDP-1
[196.454173] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[196.462757] Starting dynamic subtest: pipe-D-eDP-1
[196.484866] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[196.489082] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[198.616897] [048/156] (820s left) syncobj_timeline (reset-during-wait-for-submit)
[198.683794] Starting subtest: reset-during-wait-for-submit
[198.787014] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[198.866312] [049/156] (820s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[198.964928] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[198.967317] Starting dynamic subtest: pipe-A
[200.103297] Dynamic subtest pipe-A: SUCCESS (1.141s)
[200.111969] Starting dynamic subtest: pipe-B
[202.369709] Dynamic subtest pipe-B: SUCCESS (2.265s)
[202.381370] Starting dynamic subtest: pipe-C
[203.524931] Dynamic subtest pipe-C: SUCCESS (1.154s)
[203.535192] Starting dynamic subtest: pipe-D
[204.759096] Dynamic subtest pipe-D: SUCCESS (1.234s)
[204.761510] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.797s)
[205.952254] [050/156] (813s left) gem_exec_balancer (hang)
[206.213644] Starting subtest: hang
[208.314588] Subtest hang: SUCCESS (2.100s)
[208.428874] [051/156] (810s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[208.556741] Starting subtest: cursorB-vs-flipB-atomic-transitions
[208.561157] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[208.700028] [052/156] (810s left) kms_plane_lowres (tiling-4)
[208.785896] Starting subtest: tiling-4
[208.788223] Starting dynamic subtest: pipe-A-eDP-1
[208.792772] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[209.089768] Starting dynamic subtest: pipe-B-eDP-1
[209.094463] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[209.103324] Starting dynamic subtest: pipe-C-eDP-1
[209.107978] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[209.120556] Starting dynamic subtest: pipe-D-eDP-1
[209.125023] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[209.129304] Subtest tiling-4: SKIP (0.303s)
[209.892414] [053/156] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[209.992174] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[209.996413] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[210.076897] [054/156] (809s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[210.174705] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[210.178760] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[210.283965] [055/156] (809s left) gem_softpin (noreloc-interruptible)
[210.337468] Starting subtest: noreloc-interruptible
[215.804067] Subtest noreloc-interruptible: SUCCESS (5.411s)
[215.897417] [056/156] (803s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[216.003070] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[216.007830] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[216.099891] [057/156] (803s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[216.196792] Starting subtest: psr-1p-primscrn-cur-indfb-move
[223.584569] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.392s)
[223.741658] [058/156] (795s left) gem_ctx_exec (basic-close-race)
[223.804915] Starting subtest: basic-close-race
[229.990504] Subtest basic-close-race: SUCCESS (6.132s)
[230.088119] [059/156] (789s left) kms_dsc (dsc-with-bpc-formats)
[230.187845] Starting subtest: dsc-with-bpc-formats
[230.296679] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[230.341846] [060/156] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[230.442143] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[230.446153] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[230.542017] [061/156] (789s left) kms_cursor_crc (cursor-onscreen-128x42)
[230.781340] Starting subtest: cursor-onscreen-128x42
[230.830832] Subtest cursor-onscreen-128x42: SKIP (0.047s)
[231.054080] [062/156] (788s left) perf_pmu (busy-double-start)
[231.095359] Starting subtest: busy-double-start
[231.097335] Starting dynamic subtest: rcs0
[234.733365] Dynamic subtest rcs0: FAIL (3.580s)
[234.747082] Starting dynamic subtest: bcs0
[238.246946] Dynamic subtest bcs0: SUCCESS (3.570s)
[238.259559] Starting dynamic subtest: vcs0
[242.851679] Dynamic subtest vcs0: SUCCESS (4.602s)
[242.864296] Starting dynamic subtest: vcs1
[246.811664] Dynamic subtest vcs1: SUCCESS (3.958s)
[246.822601] Starting dynamic subtest: vecs0
[250.846667] Dynamic subtest vecs0: SUCCESS (4.033s)
[250.860106] Starting dynamic subtest: ccs0
[254.479847] Dynamic subtest ccs0: FAIL (3.566s)
[254.482734] Subtest busy-double-start: FAIL (23.318s)
[254.546712] [063/156] (765s left) perf_pmu (init-sema)
[254.589584] Starting subtest: init-sema
[254.591974] Starting dynamic subtest: rcs0
[254.594304] Dynamic subtest rcs0: SUCCESS (0.001s)
[254.606242] Starting dynamic subtest: bcs0
[254.608408] Dynamic subtest bcs0: SUCCESS (0.000s)
[254.617814] Starting dynamic subtest: vcs0
[254.620058] Dynamic subtest vcs0: SUCCESS (0.001s)
[254.629306] Starting dynamic subtest: vcs1
[254.631481] Dynamic subtest vcs1: SUCCESS (0.001s)
[254.640678] Starting dynamic subtest: vecs0
[254.642907] Dynamic subtest vecs0: SUCCESS (0.001s)
[254.652068] Starting dynamic subtest: ccs0
[254.654227] Dynamic subtest ccs0: SUCCESS (0.000s)
[254.656330] Subtest init-sema: SUCCESS (0.008s)
[254.700628] [064/156] (765s left) gem_watchdog (default-physical)
[254.780241] Starting subtest: default-physical
[256.547675] Subtest default-physical: SUCCESS (1.777s)
[256.633390] [065/156] (763s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[256.731122] Starting subtest: 4-tiled-64bpp-rotate-180
[258.344490] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.613s)
[258.525554] [066/156] (761s left) gem_workarounds (suspend-resume-fd)
[258.598977] Starting subtest: suspend-resume-fd
[274.838732] Subtest suspend-resume-fd: SUCCESS (2.088s)
[274.960384] [067/156] (745s left) kms_debugfs (display-on-read-all)
[275.077880] Starting subtest: display-on-read-all
[275.263364] Subtest display-on-read-all: SUCCESS (0.186s)
[275.394482] [068/156] (744s left) gem_exec_reloc (basic-write-gtt)
[275.462071] Subtest basic-write-gtt: SKIP (0.000s)
[275.545764] [069/156] (744s left) fbdev (eof)
[275.588872] Starting subtest: eof
[275.591390] Subtest eof: SUCCESS (0.000s)
[275.677375] [070/156] (744s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[277.629931] Starting subtest: modeset-lpsp-stress-no-wait
[287.744258] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.938s)
[287.836583] [071/156] (732s left) gem_eio (in-flight-1us)
[288.055282] Starting subtest: in-flight-1us
[296.175845] Subtest in-flight-1us: SUCCESS (8.079s)
[296.367619] [072/156] (723s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[296.464847] Starting subtest: x-tiled-8bpp-rotate-270
[296.489231] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[296.603207] [073/156] (723s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[296.701867] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[296.706053] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[296.798047] [074/156] (723s left) kms_vblank (wait-busy-hang)
[296.894600] Starting subtest: wait-busy-hang
[296.896569] Starting dynamic subtest: pipe-A-eDP-1
[298.777137] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[298.792274] Starting dynamic subtest: pipe-D-eDP-1
[301.329059] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[301.331835] Subtest wait-busy-hang: SUCCESS (4.421s)
[302.142809] [075/156] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[302.252137] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[308.811771] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.561s)
[308.927954] [076/156] (711s left) kms_addfb_basic (addfb25-bad-modifier)
[309.019519] Starting subtest: addfb25-bad-modifier
[309.021830] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[309.124171] [077/156] (711s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[309.229372] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[309.233836] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[309.326891] [078/156] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[309.436024] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[316.872337] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.438s)
[317.020053] [079/156] (703s left) prime_vgem (fence-write-hang)
[317.079328] Subtest fence-write-hang: SKIP (0.000s)
[317.186134] [080/156] (703s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[317.289514] Starting subtest: y-tiled-64bpp-rotate-90
[317.293741] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[317.392742] [081/156] (703s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[317.496687] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[317.501068] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[317.581424] [082/156] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[317.686517] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[317.690939] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[317.795877] [083/156] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[317.906111] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[317.909816] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[318.012190] [084/156] (702s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[318.098319] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[318.102068] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[318.170832] [085/156] (702s left) sriov_basic (enable-vfs-autoprobe-off)
[318.223909] Starting subtest: enable-vfs-autoprobe-off
[318.226089] Starting dynamic subtest: numvfs-1
[318.230263] Dynamic subtest numvfs-1: SKIP (0.001s)
[318.242862] Starting dynamic subtest: numvfs-2
[318.246343] Dynamic subtest numvfs-2: SKIP (0.001s)
[318.256083] Starting dynamic subtest: numvfs-3
[318.259528] Dynamic subtest numvfs-3: SKIP (0.001s)
[318.269182] Starting dynamic subtest: numvfs-4
[318.272453] Dynamic subtest numvfs-4: SKIP (0.001s)
[318.282054] Starting dynamic subtest: numvfs-5
[318.285715] Dynamic subtest numvfs-5: SKIP (0.001s)
[318.295295] Starting dynamic subtest: numvfs-6
[318.299306] Dynamic subtest numvfs-6: SKIP (0.001s)
[318.311560] Starting dynamic subtest: numvfs-7
[318.315176] Dynamic subtest numvfs-7: SKIP (0.001s)
[318.324888] Starting dynamic subtest: numvfs-random
[318.328608] Dynamic subtest numvfs-random: SKIP (0.001s)
[318.338262] Starting dynamic subtest: numvfs-all
[318.341685] Dynamic subtest numvfs-all: SKIP (0.001s)
[318.345086] Subtest enable-vfs-autoprobe-off: SKIP (0.012s)
[318.383050] [086/156] (702s left) kms_chamelium_color (degamma)
[318.480823] Subtest degamma: SKIP (0.000s)
[318.529237] [087/156] (702s left) kms_plane (planar-pixel-format-settings)
[318.624360] Starting subtest: planar-pixel-format-settings
[318.692536] Subtest planar-pixel-format-settings: SUCCESS (0.067s)
[318.824489] [088/156] (702s left) gem_lmem_swapping (parallel-multi)
[318.865078] Subtest parallel-multi: SKIP (0.000s)
[318.908193] [089/156] (702s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[319.000236] Starting subtest: psrhdr-farfromfence-mmap-gtt
[319.003824] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[319.098443] [090/156] (701s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[319.196534] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[319.200072] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[319.305279] [091/156] (701s left) gen7_exec_parse (load-register-reg)
[319.366058] Subtest load-register-reg: SKIP (0.000s)
[319.444735] [092/156] (701s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[319.540164] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[319.541993] Starting dynamic subtest: pipe-A-eDP-1
[352.130269] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.908s)
[352.141535] Starting dynamic subtest: pipe-B-eDP-1
[385.056851] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.694s)
[385.068679] Starting dynamic subtest: pipe-C-eDP-1
[418.030623] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.671s)
[418.043169] Starting dynamic subtest: pipe-D-eDP-1
[451.031718] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.663s)
[451.034616] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.942s)
[452.326200] [093/156] (568s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[452.445290] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[452.450877] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[452.529178] [094/156] (568s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[452.919308] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[453.773371] [095/156] (567s left) gem_ctx_persistence (idempotent)
[453.842283] Starting subtest: idempotent
[453.845184] Subtest idempotent: SUCCESS (0.000s)
[453.978742] [096/156] (567s left) prime_mmap (test_userptr)
[454.032685] Starting subtest: test_userptr
[454.035727] Starting dynamic subtest: test_userptr-smem
[454.038173] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[454.040691] Subtest test_userptr: SUCCESS (0.001s)
[454.125764] [097/156] (567s left) gem_exec_schedule (reorder-wide)
[454.306844] Subtest reorder-wide: SKIP (0.000s)
[454.493319] [098/156] (566s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[454.601250] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[458.260721] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.590s)
[459.416753] [099/156] (562s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[459.522875] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[459.528663] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[459.623589] [100/156] (561s left) gem_eio (context-create)
[459.833519] Starting subtest: context-create
[460.132033] Subtest context-create: SUCCESS (0.294s)
[460.277365] [101/156] (561s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[460.369796] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[460.374252] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[460.483675] [102/156] (561s left) gem_ctx_param (set-priority-invalid-size)
[460.537594] Starting subtest: set-priority-invalid-size
[460.540048] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[460.612983] [103/156] (560s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[460.708596] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[467.183231] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.426s)
[468.365833] [104/156] (553s left) gem_exec_fence (submit67)
[468.539012] Starting subtest: submit67
[468.543990] Subtest submit67: SKIP (0.000s)
[469.644376] [105/156] (552s left) kms_pm_dc (dc5-psr)
[470.742835] Starting subtest: dc5-psr
[473.636547] Subtest dc5-psr: SUCCESS (2.886s)
[474.516765] [106/156] (547s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[474.625252] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[474.630715] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[474.726431] [107/156] (547s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[474.828790] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[474.833784] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[474.920717] [108/156] (546s left) gem_softpin (evict-prime)
[474.977826] Starting subtest: evict-prime
[474.980648] Starting dynamic subtest: rcs0
[476.138674] Dynamic subtest rcs0: SUCCESS (1.158s)
[476.152085] Starting dynamic subtest: bcs0
[477.263545] Dynamic subtest bcs0: SUCCESS (1.121s)
[477.276124] Starting dynamic subtest: vcs0
[478.529433] Dynamic subtest vcs0: SUCCESS (1.260s)
[478.542904] Starting dynamic subtest: vcs1
[480.494829] Dynamic subtest vcs1: SUCCESS (1.960s)
[480.506142] Starting dynamic subtest: vecs0
[482.478989] Dynamic subtest vecs0: SUCCESS (1.983s)
[482.491622] Starting dynamic subtest: ccs0
[483.592268] Dynamic subtest ccs0: SUCCESS (1.113s)
[483.603857] Starting dynamic subtest: all
[485.561164] Dynamic subtest all: SUCCESS (1.967s)
[485.564117] Subtest evict-prime: SUCCESS (10.578s)
[485.649823] [109/156] (536s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[485.759705] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[485.764716] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[485.857469] [110/156] (536s left) i915_pm_rpm (sysfs-read)
[487.688508] Starting subtest: sysfs-read
[488.857844] Subtest sysfs-read: SUCCESS (1.168s)
[489.252494] [111/156] (532s left) i915_query (query-topology-kernel-writes)
[489.302021] Starting subtest: query-topology-kernel-writes
[489.305023] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[489.425309] [112/156] (532s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[489.530834] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[489.535673] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[489.623637] [113/156] (532s left) kms_psr (pr-sprite-blt)
[489.717151] Starting subtest: pr-sprite-blt
[489.722355] Subtest pr-sprite-blt: SKIP (0.000s)
[489.796358] [114/156] (532s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[489.843782] Starting subtest: single-wait-all-for-submit-available-submitted
[489.846399] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[489.943274] [115/156] (532s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[490.039410] Starting subtest: psr2-plane-move-sf-dmg-area
[490.042121] Starting dynamic subtest: pipe-A-eDP-1
[494.602019] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.569s)
[494.613272] Starting dynamic subtest: pipe-B-eDP-1
[499.915947] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.314s)
[499.918933] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.886s)
[500.795111] [116/156] (521s left) gem_ctx_isolation (clean)
[500.851537] Starting subtest: clean
[500.854171] Starting dynamic subtest: rcs0
[500.900328] Dynamic subtest rcs0: SUCCESS (0.048s)
[500.918787] Starting dynamic subtest: bcs0
[500.970738] Dynamic subtest bcs0: SUCCESS (0.070s)
[500.981918] Starting dynamic subtest: vcs0
[501.015717] Dynamic subtest vcs0: SUCCESS (0.043s)
[501.029636] Starting dynamic subtest: vcs1
[502.518019] Dynamic subtest vcs1: SUCCESS (1.502s)
[502.530669] Starting dynamic subtest: vecs0
[504.585261] Dynamic subtest vecs0: SUCCESS (2.066s)
[504.597691] Starting dynamic subtest: ccs0
[506.578921] Dynamic subtest ccs0: SUCCESS (1.993s)
[506.581789] Subtest clean: SUCCESS (5.729s)
[506.829411] [117/156] (515s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[506.947489] Starting subtest: fbc-rgb565-draw-pwrite
[511.616713] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.675s)
[512.807443] [118/156] (509s left) kms_content_protection (uevent-hdcp14)
[512.954862] Starting subtest: uevent-hdcp14
[512.960733] Subtest uevent-hdcp14: SKIP (0.000s)
[513.079482] [119/156] (509s left) i915_drm_fdinfo (virtual-busy-hang-all)
[513.120247] Starting subtest: virtual-busy-hang-all
[513.125348] Subtest virtual-busy-hang-all: SKIP (0.000s)
[513.199091] [120/156] (509s left) i915_query (query-regions-sanity-check)
[513.245922] Starting subtest: query-regions-sanity-check
[513.255565] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[513.350886] [121/156] (509s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[513.405125] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[513.410779] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[513.606840] [122/156] (508s left) gem_exec_params (rsvd2-dirt)
[513.655441] Starting subtest: rsvd2-dirt
[513.660747] Subtest rsvd2-dirt: SKIP (0.000s)
[513.748040] [123/156] (508s left) kms_flip (2x-flip-vs-panning)
[513.840489] Starting subtest: 2x-flip-vs-panning
[513.849202] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[513.930365] [124/156] (508s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[514.028611] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[514.033763] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[514.123375] [125/156] (508s left) gem_mmap_offset (isolation)
[514.180226] Starting subtest: isolation
[514.202009] Subtest isolation: SUCCESS (0.006s)
[514.306584] [126/156] (508s left) syncobj_wait (wait-all-snapshot)
[514.355367] Starting subtest: wait-all-snapshot
[514.437206] Subtest wait-all-snapshot: SUCCESS (0.082s)
[514.517561] [127/156] (508s left) gem_exec_schedule (preempt-hang)
[514.694567] Starting subtest: preempt-hang
[514.696737] Starting dynamic subtest: rcs0
[514.928027] Dynamic subtest rcs0: SUCCESS (0.236s)
[514.939024] Starting dynamic subtest: bcs0
[515.161424] Dynamic subtest bcs0: SUCCESS (0.232s)
[515.173249] Starting dynamic subtest: vcs0
[515.395061] Dynamic subtest vcs0: SUCCESS (0.232s)
[515.407299] Starting dynamic subtest: vcs1
[515.622512] Dynamic subtest vcs1: SUCCESS (0.227s)
[515.634329] Starting dynamic subtest: vecs0
[515.861541] Dynamic subtest vecs0: SUCCESS (0.239s)
[515.873354] Starting dynamic subtest: ccs0
[516.091001] Dynamic subtest ccs0: SUCCESS (0.228s)
[516.093768] Subtest preempt-hang: SUCCESS (1.400s)
[516.646177] [128/156] (506s left) gem_exec_fence (syncobj-unused-fence)
[517.128417] Starting subtest: syncobj-unused-fence
[517.135249] Subtest syncobj-unused-fence: SUCCESS (0.007s)
[518.647005] [129/156] (504s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[518.756769] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[518.761907] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[518.854860] [130/156] (503s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[519.081629] Starting subtest: cursor-rapid-movement-128x42
[519.130770] Subtest cursor-rapid-movement-128x42: SKIP (0.044s)
[519.352579] [131/156] (503s left) kms_getfb (getfb-handle-valid)
[519.436907] Starting subtest: getfb-handle-valid
[519.439843] Subtest getfb-handle-valid: SUCCESS (0.000s)
[519.527892] [132/156] (503s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[519.619234] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[519.623312] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[519.723467] [133/156] (503s left) prime_vgem (coherency-gtt)
[519.784633] Starting subtest: coherency-gtt
[519.788818] Subtest coherency-gtt: SKIP (0.000s)
[519.878900] [134/156] (503s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[519.975861] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[519.980795] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[520.070188] [135/156] (502s left) gem_eio (in-flight-internal-10ms)
[520.283567] Starting subtest: in-flight-internal-10ms
[521.608259] Subtest in-flight-internal-10ms: SUCCESS (1.323s)
[521.758293] [136/156] (501s left) kms_addfb_basic (addfb25-modifier-no-flag)
[521.849842] Starting subtest: addfb25-modifier-no-flag
[521.852562] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[521.973859] [137/156] (501s left) kms_rotation_crc (multiplane-rotation)
[522.066253] Starting subtest: multiplane-rotation
[539.730599] Subtest multiplane-rotation: SUCCESS (17.661s)
[539.846875] [138/156] (483s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[539.976771] Starting subtest: short-flip-before-cursor-atomic-transitions
[540.956890] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.979s)
[541.814199] [139/156] (481s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[541.906786] Starting subtest: primary-y-tiled-reflect-x-180
[541.967919] Subtest primary-y-tiled-reflect-x-180: SKIP (0.060s)
[542.072994] [140/156] (481s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[542.172525] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[542.175027] Starting dynamic subtest: pipe-A-eDP-1
[542.451410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.241s)
[542.462995] Starting dynamic subtest: pipe-B-eDP-1
[543.690751] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.241s)
[543.703148] Starting dynamic subtest: pipe-C-eDP-1
[544.893655] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s)
[544.905810] Starting dynamic subtest: pipe-D-eDP-1
[546.118987] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[546.121896] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.911s)
[547.258567] [141/156] (476s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[547.356595] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[548.224857] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.870s)
[548.377804] [142/156] (474s left) syncobj_wait (single-wait-all-for-submit-signaled)
[548.428902] Starting subtest: single-wait-all-for-submit-signaled
[548.431811] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[548.534975] [143/156] (474s left) kms_addfb_basic (basic-x-tiled-legacy)
[548.592879] Starting subtest: basic-x-tiled-legacy
[548.598043] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[548.735105] [144/156] (474s left) gem_exec_fence (basic-busy-all)
[548.788624] Starting subtest: basic-busy-all
[548.879376] Subtest basic-busy-all: SUCCESS (0.090s)
[550.601600] [145/156] (472s left) kms_flip (2x-modeset-vs-vblank-race)
[550.692633] Starting subtest: 2x-modeset-vs-vblank-race
[550.701726] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[550.783371] [146/156] (472s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[550.877026] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[550.881703] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[550.956021] [147/156] (472s left) kms_psr (psr-cursor-blt)
[551.055846] Starting subtest: psr-cursor-blt
[551.058634] Starting dynamic subtest: eDP-1
[552.765013] Dynamic subtest eDP-1: SUCCESS (1.711s)
[552.767724] Subtest psr-cursor-blt: SUCCESS (1.712s)
[553.636028] [148/156] (469s left) syncobj_timeline (device-submit-unordered)
[553.696692] Starting subtest: device-submit-unordered
[553.698922] Subtest device-submit-unordered: SUCCESS (0.001s)
[553.814800] [149/156] (469s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[553.914747] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[560.762304] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.854s)
[560.881870] [150/156] (462s left) kms_cursor_crc (cursor-sliding-512x170)
[561.193404] Starting subtest: cursor-sliding-512x170
[561.197302] Subtest cursor-sliding-512x170: SKIP (0.001s)
[561.331901] [151/156] (462s left) kms_atomic_transition (plane-all-modeset-transition)
[561.419775] Starting subtest: plane-all-modeset-transition
[561.424852] Subtest plane-all-modeset-transition: SKIP (0.000s)
[561.494901] [152/156] (462s left) gem_exec_reloc (basic-wc-gtt)
[561.553329] Subtest basic-wc-gtt: SKIP (0.000s)
[561.627600] [153/156] (462s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[561.724880] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[561.727387] Starting dynamic subtest: pipe-A-eDP-1
[561.821885] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[561.833721] Starting dynamic subtest: pipe-B-eDP-1
[562.952643] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[562.957877] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.229s)
[564.142780] [154/156] (459s left) kms_lease (invalid-create-leases)
[564.237929] Starting subtest: invalid-create-leases
[564.246366] Subtest invalid-create-leases: SUCCESS (0.007s)
[564.349120] [155/156] (459s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt)
[564.442519] Starting subtest: fbchdr-rgb565-draw-blt
[564.447109] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s)
[564.520814] [156/156] (459s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[564.610392] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[564.615806] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[565.765432] Closing watchdogs
results: parsing output: 0/ for test: kms_universal_plane
results: parsing output: 1/ for test: gem_ppgtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: gem_close_race
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_chamelium_color
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: prime_self_import
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: vgem_basic
results: parsing output: 17/ for test: core_sysfs
results: parsing output: 18/ for test: kms_properties
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_tiled_swapping
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: i915_pm_freq_api
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: sysfs_timeslice_duration
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ringfill
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: sw_sync
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_color
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_invalid_mode
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_plane_lowres
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_ctx_exec
results: parsing output: 58/ for test: kms_dsc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: gem_watchdog
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_workarounds
results: parsing output: 66/ for test: kms_debugfs
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: fbdev
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: prime_vgem
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: sriov_basic
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gen7_exec_parse
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: prime_mmap
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_pm_dc
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: i915_pm_rpm
results: parsing output: 110/ for test: i915_query
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: gem_ctx_isolation
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_content_protection
results: parsing output: 118/ for test: i915_drm_fdinfo
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_mmap_offset
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_getfb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: prime_vgem
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_eio
results: parsing output: 135/ for test: kms_addfb_basic
results: parsing output: 136/ for test: kms_rotation_crc
results: parsing output: 137/ for test: kms_cursor_legacy
results: parsing output: 138/ for test: kms_rotation_crc
results: parsing output: 139/ for test: kms_ccs
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: syncobj_wait
results: parsing output: 142/ for test: kms_addfb_basic
results: parsing output: 143/ for test: gem_exec_fence
results: parsing output: 144/ for test: kms_flip
results: parsing output: 145/ for test: kms_plane
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: syncobj_timeline
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: kms_atomic_transition
results: parsing output: 151/ for test: gem_exec_reloc
results: parsing output: 152/ for test: kms_psr2_sf
results: parsing output: 153/ for test: kms_lease
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_ccs
Done.