[75.427911] Initializing watchdogs
[75.427963]   /dev/watchdog0
[75.443484] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[75.447666] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[75.449623] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[75.453480] [001/156] (960s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[75.549361] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[75.551691] Starting dynamic subtest: pipe-A-default-mode
[78.337584] Dynamic subtest pipe-A-default-mode: SUCCESS (2.787s)
[78.339882] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.788s)
[79.198735] [002/156] (956s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[79.294462] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[79.298528] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[79.390833] [003/156] (956s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[79.478658] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[79.482935] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[79.595021] [004/156] (956s left) syncobj_eventfd (timeline-wait-before-signal)
[79.642723] Starting subtest: timeline-wait-before-signal
[79.672672] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[79.758483] [005/156] (956s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[79.858310] Starting subtest: flip-vs-cursor-crc-atomic
[80.566074] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.708s)
[81.432727] [006/156] (954s left) kms_pm_rpm (dpms-non-lpsp)
[83.439686] Starting subtest: dpms-non-lpsp
[83.445015] Subtest dpms-non-lpsp: SKIP (0.001s)
[83.833342] [007/156] (952s left) kms_feature_discovery (chamelium)
[83.902892] Starting subtest: chamelium
[83.907650] Subtest chamelium: SKIP (0.000s)
[83.985344] [008/156] (952s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[84.067106] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[84.071100] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[84.160605] [009/156] (952s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[84.235369] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[84.240032] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[84.329667] [010/156] (951s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[84.408701] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[84.413163] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[84.508440] [011/156] (951s left) vgem_basic (sysfs)
[84.574216] Starting subtest: sysfs
[84.576146] Subtest sysfs: SUCCESS (0.000s)
[84.625755] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[84.628930] [012/156] (951s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[84.706943] Starting subtest: y-tiled-32bpp-rotate-270
[84.711567] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[84.807079] [013/156] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[84.885713] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[88.881248] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.001s)
[90.044202] [014/156] (946s left) kms_flip (2x-absolute-wf_vblank)
[90.126340] Starting subtest: 2x-absolute-wf_vblank
[90.133233] Subtest 2x-absolute-wf_vblank: SKIP (0.008s)
[90.221742] [015/156] (946s left) gem_ctx_persistence (saturated-hostile)
[90.274683] Starting subtest: saturated-hostile
[90.276980] Starting dynamic subtest: rcs0
[91.086190] Dynamic subtest rcs0: SUCCESS (0.811s)
[91.097640] Starting dynamic subtest: bcs0
[91.879894] Dynamic subtest bcs0: SUCCESS (0.792s)
[91.888683] Starting dynamic subtest: vcs0
[92.687606] Dynamic subtest vcs0: SUCCESS (0.807s)
[92.696817] Starting dynamic subtest: vcs1
[93.490931] Dynamic subtest vcs1: SUCCESS (0.802s)
[93.504814] Starting dynamic subtest: vecs0
[94.287421] Dynamic subtest vecs0: SUCCESS (0.794s)
[94.298487] Starting dynamic subtest: ccs0
[95.131929] Dynamic subtest ccs0: SUCCESS (0.844s)
[95.134516] Subtest saturated-hostile: SUCCESS (4.857s)
[95.208800] [016/156] (941s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[95.298694] Starting subtest: fbchdr-rgb101010-draw-render
[95.302631] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[95.418807] [017/156] (941s left) kms_psr (psr-sprite-plane-onoff)
[95.492655] Starting subtest: psr-sprite-plane-onoff
[95.494867] Starting dynamic subtest: eDP-1
[97.259431] Dynamic subtest eDP-1: SUCCESS (1.765s)
[97.261372] Subtest psr-sprite-plane-onoff: SUCCESS (1.766s)
[98.099019] [018/156] (938s left) gem_exec_schedule (semaphore-resolve)
[98.171859] Starting subtest: semaphore-resolve
[98.199308] Subtest semaphore-resolve: SUCCESS (0.036s)
[98.558316] [019/156] (938s left) gem_pxp (reject-modify-context-protection-off-1)
[98.679844] Starting subtest: reject-modify-context-protection-off-1
[98.682642] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[98.813775] [020/156] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[98.894664] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[98.898968] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[98.992193] [021/156] (937s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[99.085058] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[99.089226] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[99.179252] [022/156] (937s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[99.262677] Starting subtest: fbc-pr-cursor-mmap-cpu
[99.267137] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[99.339993] [023/156] (937s left) kms_vblank (ts-continuation-dpms-suspend)
[99.427781] Starting subtest: ts-continuation-dpms-suspend
[99.430155] Starting dynamic subtest: pipe-A-eDP-1
[116.674144] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.078s)
[116.689676] Starting dynamic subtest: pipe-D-eDP-1
[134.629986] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.588s)
[134.632379] Subtest ts-continuation-dpms-suspend: SUCCESS (4.669s)
[135.434287] [024/156] (901s left) kms_plane_lowres (tiling-y)
[135.512906] Starting subtest: tiling-y
[135.517294] Subtest tiling-y: SKIP (0.000s)
[135.586405] [025/156] (901s left) kms_cursor_edge_walk (64x64-top-edge)
[135.659211] Starting subtest: 64x64-top-edge
[135.661664] Starting dynamic subtest: pipe-A-eDP-1
[139.117433] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.443s)
[139.129757] Starting dynamic subtest: pipe-D-eDP-1
[142.263871] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s)
[142.266097] Subtest 64x64-top-edge: SUCCESS (6.583s)
[143.089241] [026/156] (893s left) kms_psr (fbc-psr2-primary-page-flip)
[143.170227] Starting subtest: fbc-psr2-primary-page-flip
[143.172607] Starting dynamic subtest: eDP-1
[143.176949] Dynamic subtest eDP-1: SKIP (0.000s)
[143.181396] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[143.241909] [027/156] (893s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[143.323689] Starting subtest: bad-aux-stride-yf-tiled-ccs
[143.325968] Starting dynamic subtest: pipe-A-eDP-1
[143.348952] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[143.358123] Starting dynamic subtest: pipe-B-eDP-1
[143.379824] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[143.389021] Starting dynamic subtest: pipe-C-eDP-1
[143.410957] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[143.419564] Starting dynamic subtest: pipe-D-eDP-1
[143.441614] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[143.445698] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s)
[145.627094] [028/156] (891s left) i915_module_load (reload-no-display)
[145.663948] Starting subtest: reload-no-display
[149.965359] Subtest reload-no-display: SUCCESS (4.284s)
[149.995963] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[149.996673] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[149.999565] [029/156] (887s left) kms_chamelium_frames (dp-crc-multiple)
[151.736662] Subtest dp-crc-multiple: SKIP (0.000s)
[152.620949] [FACT kms_chamelium_frames (dp-crc-multiple)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[152.623362] [FACT kms_chamelium_frames (dp-crc-multiple)] new: kernel.kmod_is_loaded.i915: true
[152.626727] [030/156] (884s left) gem_create (create-size-update)
[152.684825] Starting subtest: create-size-update
[152.687157] Subtest create-size-update: SUCCESS (0.000s)
[152.891343] [031/156] (884s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[152.992458] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[152.997039] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[153.135035] [032/156] (884s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[153.201982] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[153.204172] Starting dynamic subtest: pipe-A-eDP-1
[153.226382] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[153.236861] Starting dynamic subtest: pipe-B-eDP-1
[153.258533] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[153.266132] Starting dynamic subtest: pipe-C-eDP-1
[153.287761] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[153.295399] Starting dynamic subtest: pipe-D-eDP-1
[153.317296] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[153.321693] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[155.678918] [033/156] (881s left) gem_exec_suspend (basic)
[155.741759] Starting subtest: basic
[155.744202] Starting dynamic subtest: smem
[157.763492] Dynamic subtest smem: SUCCESS (2.007s)
[157.767684] Subtest basic: SUCCESS (2.008s)
[157.950884] [034/156] (879s left) kms_async_flips (async-flip-hang)
[158.021938] Starting subtest: async-flip-hang
[158.404167] Starting dynamic subtest: pipe-A-eDP-1
[173.269721] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.863s)
[173.661830] Starting dynamic subtest: pipe-B-eDP-1
[189.266768] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.611s)
[189.672629] Starting dynamic subtest: pipe-C-eDP-1
[205.263679] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.591s)
[205.638343] Starting dynamic subtest: pipe-D-eDP-1
[221.268138] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.632s)
[221.270641] Subtest async-flip-hang: SUCCESS (63.230s)
[222.459620] [035/156] (814s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[222.544609] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[231.192350] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.651s)
[231.304628] [036/156] (806s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[231.391617] Starting subtest: fbcpsr-slowdraw
[256.603359] Subtest fbcpsr-slowdraw: SUCCESS (25.223s)
[256.729601] [037/156] (780s left) kms_plane_alpha_blend (alpha-basic)
[256.805207] Starting subtest: alpha-basic
[257.098769] Starting dynamic subtest: pipe-A-eDP-1
[259.029969] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[259.060451] Starting dynamic subtest: pipe-D-eDP-1
[261.681071] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.629s)
[261.683396] Subtest alpha-basic: SUCCESS (4.876s)
[262.580178] [038/156] (774s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[262.656804] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[262.661122] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[262.744604] [039/156] (774s left) gem_mmap_gtt (isolation)
[262.788403] Subtest isolation: SKIP (0.000s)
[262.850369] [040/156] (774s left) gem_partial_pwrite_pread (write)
[262.906087] Subtest write: SKIP (0.000s)
[263.000840] [041/156] (774s left) kms_tiled_display (basic-test-pattern)
[263.088164] Subtest basic-test-pattern: SKIP (0.000s)
[263.131251] [042/156] (774s left) kms_chamelium_audio (dp-audio)
[263.495782] Subtest dp-audio: SKIP (0.000s)
[264.289332] [043/156] (773s left) gem_pxp (hw-rejects-pxp-buffer)
[264.414518] Starting subtest: hw-rejects-pxp-buffer
[264.419200] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[264.516030] [044/156] (773s left) kms_frontbuffer_tracking (fbc-tiling-y)
[264.598587] Starting subtest: fbc-tiling-y
[264.602954] Subtest fbc-tiling-y: SKIP (0.000s)
[264.701235] [045/156] (773s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[264.782234] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[271.850668] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.074s)
[271.951972] [046/156] (765s left) i915_suspend (basic-s3-without-i915)
[271.990744] Starting subtest: basic-s3-without-i915
[275.214759] Subtest basic-s3-without-i915: SKIP (3.218s)
[276.719411] [047/156] (761s left) kms_lease (multimaster-lease)
[276.802420] Starting subtest: multimaster-lease
[276.807256] Subtest multimaster-lease: SUCCESS (0.004s)
[276.920749] [048/156] (760s left) kms_atomic (crtc-invalid-params)
[276.999307] Starting subtest: crtc-invalid-params
[277.001632] Starting dynamic subtest: pipe-A-eDP-1
[277.369543] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.368s)
[277.372132] Subtest crtc-invalid-params: SUCCESS (0.369s)
[278.167933] [049/156] (759s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[278.253889] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[278.257995] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[278.347818] [050/156] (759s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[278.405833] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[278.480411] [051/156] (759s left) kms_invalid_mode (bad-vsync-start)
[278.553195] Starting subtest: bad-vsync-start
[278.555425] Starting dynamic subtest: pipe-A-eDP-1
[278.852395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[278.861414] Starting dynamic subtest: pipe-B-eDP-1
[278.863378] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[278.870947] Starting dynamic subtest: pipe-C-eDP-1
[278.872908] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[278.881136] Starting dynamic subtest: pipe-D-eDP-1
[278.883458] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[278.885750] Subtest bad-vsync-start: SUCCESS (0.306s)
[279.705360] [052/156] (758s left) gem_lmem_swapping (massive)
[279.750953] Subtest massive: SKIP (0.000s)
[279.807223] [053/156] (758s left) kms_atomic_transition (plane-all-transition-nonblocking)
[279.875205] Starting subtest: plane-all-transition-nonblocking
[279.877416] Starting dynamic subtest: pipe-A-eDP-1
[282.369270] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[282.689574] Starting dynamic subtest: pipe-B-eDP-1
[285.941396] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.259s)
[286.241716] Subtest plane-all-transition-nonblocking: SUCCESS (6.363s)
[287.062873] [054/156] (751s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[287.140412] Starting subtest: bad-pixel-format-yf-tiled-ccs
[287.142677] Starting dynamic subtest: pipe-A-eDP-1
[287.165940] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[287.176489] Starting dynamic subtest: pipe-B-eDP-1
[287.198556] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[287.206790] Starting dynamic subtest: pipe-C-eDP-1
[287.228266] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[287.236085] Starting dynamic subtest: pipe-D-eDP-1
[287.257722] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[287.262128] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[289.424240] [055/156] (748s left) kms_content_protection (dp-mst-type-0)
[289.543911] Starting subtest: dp-mst-type-0
[289.548656] Subtest dp-mst-type-0: SKIP (0.000s)
[289.678928] [056/156] (748s left) gem_exec_balancer (parallel-ordering)
[289.941555] Starting subtest: parallel-ordering
[290.896587] Subtest parallel-ordering: SUCCESS (0.955s)
[291.021802] [057/156] (747s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[291.099393] Starting subtest: psr-rgb565-draw-mmap-cpu
[297.909092] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.813s)
[298.021266] [058/156] (740s left) kms_flip (wf_vblank-ts-check)
[298.098257] Starting subtest: wf_vblank-ts-check
[298.100640] Starting dynamic subtest: A-eDP1
[306.993894] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[307.004207] Starting dynamic subtest: B-eDP1
[315.929079] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[315.941746] Starting dynamic subtest: C-eDP1
[324.854230] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[324.864072] Starting dynamic subtest: D-eDP1
[333.778674] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[333.784088] Subtest wf_vblank-ts-check: SUCCESS (35.682s)
[335.000588] [059/156] (703s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[335.082133] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[335.086155] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[335.181918] [060/156] (703s left) perf (gen12-unprivileged-single-ctx-counters)
[335.300392] Starting subtest: gen12-unprivileged-single-ctx-counters
[335.303049] Starting dynamic subtest: rcs0
[335.518157] Dynamic subtest rcs0: SUCCESS (0.219s)
[335.520625] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.220s)
[335.567202] [061/156] (702s left) api_intel_allocator (two-level-inception)
[335.637543] Starting subtest: two-level-inception
[341.046627] Subtest two-level-inception: SUCCESS (5.407s)
[341.177943] [062/156] (697s left) gen9_exec_parse (allowed-all)
[341.243524] Subtest allowed-all: SKIP (0.000s)
[341.330668] [063/156] (697s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-render)
[341.421781] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-render
[341.426264] Subtest fbchdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[341.515966] [064/156] (696s left) i915_drm_fdinfo (busy-idle)
[341.554135] Starting subtest: busy-idle
[341.556657] Starting dynamic subtest: rcs0
[341.585432] Dynamic subtest rcs0: SKIP (0.029s)
[341.597419] Starting dynamic subtest: bcs0
[341.601634] Dynamic subtest bcs0: SKIP (0.000s)
[341.610296] Starting dynamic subtest: vcs0
[341.614441] Dynamic subtest vcs0: SKIP (0.000s)
[341.622874] Starting dynamic subtest: vcs1
[341.627273] Dynamic subtest vcs1: SKIP (0.000s)
[341.636141] Starting dynamic subtest: vecs0
[341.640578] Dynamic subtest vecs0: SKIP (0.000s)
[341.649112] Starting dynamic subtest: ccs0
[341.653597] Dynamic subtest ccs0: SKIP (0.000s)
[341.658024] Subtest busy-idle: SKIP (0.035s)
[341.698542] [065/156] (696s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[341.777177] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[341.781141] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[341.875123] [066/156] (696s left) gem_spin_batch (legacy-resubmit)
[341.929130] Starting subtest: legacy-resubmit
[341.931524] Starting dynamic subtest: default
[341.936323] Dynamic subtest default: SUCCESS (0.006s)
[341.945642] Starting dynamic subtest: render
[341.947974] Dynamic subtest render: SUCCESS (0.001s)
[341.956942] Starting dynamic subtest: bsd
[341.958854] Dynamic subtest bsd: SUCCESS (0.002s)
[341.966997] Starting dynamic subtest: bsd1
[341.968922] Dynamic subtest bsd1: SUCCESS (0.003s)
[341.977334] Starting dynamic subtest: bsd2
[341.979270] Dynamic subtest bsd2: SUCCESS (0.001s)
[341.987799] Starting dynamic subtest: blt
[341.989672] Dynamic subtest blt: SUCCESS (0.003s)
[341.997951] Starting dynamic subtest: vebox
[341.999870] Dynamic subtest vebox: SUCCESS (0.002s)
[342.001773] Subtest legacy-resubmit: SUCCESS (0.024s)
[342.180816] [067/156] (696s left) gem_wait (busy)
[342.244365] Starting subtest: busy
[342.246735] Starting dynamic subtest: all-engines
[343.736832] Dynamic subtest all-engines: SUCCESS (1.490s)
[343.747296] Starting dynamic subtest: rcs0
[344.282815] Dynamic subtest rcs0: SUCCESS (0.542s)
[344.293214] Starting dynamic subtest: bcs0
[344.821867] Dynamic subtest bcs0: SUCCESS (0.539s)
[344.833791] Starting dynamic subtest: vcs0
[346.743884] Dynamic subtest vcs0: SUCCESS (1.919s)
[346.758516] Starting dynamic subtest: vcs1
[348.727729] Dynamic subtest vcs1: SUCCESS (1.980s)
[348.739838] Starting dynamic subtest: vecs0
[350.775367] Dynamic subtest vecs0: SUCCESS (2.045s)
[350.787911] Starting dynamic subtest: ccs0
[351.317462] Dynamic subtest ccs0: SUCCESS (0.540s)
[351.319981] Subtest busy: SUCCESS (9.071s)
[351.513243] [068/156] (687s left) syncobj_wait (wait-zero-handles)
[351.579296] Starting subtest: wait-zero-handles
[351.581702] Subtest wait-zero-handles: SUCCESS (0.000s)
[351.691653] [069/156] (687s left) api_intel_bb (object-reloc-keep-cache)
[351.737834] Starting subtest: object-reloc-keep-cache
[351.742469] Subtest object-reloc-keep-cache: SKIP (0.002s)
[351.843892] [070/156] (686s left) gem_exec_store (pages)
[351.910064] Starting subtest: pages
[351.912056] Starting dynamic subtest: rcs0
[352.015942] Dynamic subtest rcs0: SUCCESS (0.107s)
[352.027041] Starting dynamic subtest: bcs0
[352.089601] Dynamic subtest bcs0: SUCCESS (0.073s)
[352.101910] Starting dynamic subtest: vcs0
[352.169545] Dynamic subtest vcs0: SUCCESS (0.079s)
[352.181798] Starting dynamic subtest: vcs1
[352.241228] Dynamic subtest vcs1: SUCCESS (0.071s)
[352.252872] Starting dynamic subtest: vecs0
[352.321209] Dynamic subtest vecs0: SUCCESS (0.078s)
[352.333786] Starting dynamic subtest: ccs0
[352.400176] Dynamic subtest ccs0: SUCCESS (0.078s)
[352.402901] Subtest pages: SUCCESS (0.491s)
[352.594923] [071/156] (686s left) kms_plane (pixel-format-y-tiled-modifier)
[352.667850] Starting subtest: pixel-format-y-tiled-modifier
[352.672062] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[352.738273] [072/156] (686s left) gem_exec_fence (keep-in-fence)
[352.901415] Starting subtest: keep-in-fence
[352.903948] Starting dynamic subtest: rcs0
[352.955213] Dynamic subtest rcs0: SUCCESS (0.054s)
[352.967178] Starting dynamic subtest: bcs0
[353.009060] Dynamic subtest bcs0: SUCCESS (0.051s)
[353.020766] Starting dynamic subtest: vcs0
[354.745359] Dynamic subtest vcs0: SUCCESS (1.732s)
[354.757270] Starting dynamic subtest: vcs1
[356.730262] Dynamic subtest vcs1: SUCCESS (1.981s)
[356.742736] Starting dynamic subtest: vecs0
[358.776785] Dynamic subtest vecs0: SUCCESS (2.044s)
[358.789225] Starting dynamic subtest: ccs0
[359.003532] Dynamic subtest ccs0: SUCCESS (0.225s)
[359.006551] Subtest keep-in-fence: SUCCESS (6.102s)
[360.838418] [073/156] (678s left) gem_ctx_shared (exec-shared-gtt)
[360.905189] Starting subtest: exec-shared-gtt
[360.907499] Starting dynamic subtest: rcs0
[360.915227] Dynamic subtest rcs0: SUCCESS (0.013s)
[360.927403] Starting dynamic subtest: bcs0
[360.929654] Dynamic subtest bcs0: SUCCESS (0.010s)
[360.940985] Starting dynamic subtest: vcs0
[360.943402] Dynamic subtest vcs0: SUCCESS (0.011s)
[360.953608] Starting dynamic subtest: vcs1
[360.955417] Dynamic subtest vcs1: SUCCESS (0.010s)
[360.964483] Starting dynamic subtest: vecs0
[360.966724] Dynamic subtest vecs0: SUCCESS (0.009s)
[360.975519] Starting dynamic subtest: ccs0
[360.977421] Dynamic subtest ccs0: SUCCESS (0.007s)
[360.979451] Subtest exec-shared-gtt: SUCCESS (0.065s)
[361.167249] [074/156] (677s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[361.262926] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[361.267250] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[361.370858] [075/156] (677s left) gem_bad_reloc (negative-reloc-bltcopy)
[361.430161] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[361.496610] [076/156] (677s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[361.569610] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[361.579467] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.008s)
[361.694310] [077/156] (677s left) kms_getfb (getfb2-handle-closed)
[361.765873] Starting subtest: getfb2-handle-closed
[361.768210] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[361.855087] [078/156] (677s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[361.936049] Starting subtest: x-tiled-8bpp-rotate-90
[361.957685] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[362.085354] [079/156] (677s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[362.156781] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[369.134798] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.983s)
[369.295909] [080/156] (669s left) kms_atomic_interruptible (legacy-setmode)
[369.384729] Starting subtest: legacy-setmode
[369.387202] Starting dynamic subtest: pipe-A-eDP-1
[376.267408] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.886s)
[376.269761] Subtest legacy-setmode: SUCCESS (6.887s)
[377.071636] [081/156] (662s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[377.160659] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[378.265596] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.911s)
[378.304260] [082/156] (660s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite)
[378.388313] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite
[378.392694] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[378.504907] [083/156] (660s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[378.582291] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[378.584217] Starting dynamic subtest: pipe-A-eDP-1
[389.893121] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.316s)
[389.903002] Starting dynamic subtest: pipe-B-eDP-1
[401.878342] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.985s)
[401.880559] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.304s)
[402.717671] [084/156] (636s left) gem_exec_schedule (pi-ringfull)
[402.902503] Starting subtest: pi-ringfull
[402.904770] Starting dynamic subtest: rcs0
[402.930915] Dynamic subtest rcs0: SUCCESS (0.032s)
[402.944788] Starting dynamic subtest: bcs0
[402.959428] Dynamic subtest bcs0: SUCCESS (0.028s)
[402.973393] Starting dynamic subtest: vcs0
[402.987017] Dynamic subtest vcs0: SUCCESS (0.027s)
[403.001282] Starting dynamic subtest: vcs1
[403.014630] Dynamic subtest vcs1: SUCCESS (0.027s)
[403.028419] Starting dynamic subtest: vecs0
[403.041995] Dynamic subtest vecs0: SUCCESS (0.027s)
[403.057132] Starting dynamic subtest: ccs0
[403.068852] Dynamic subtest ccs0: SUCCESS (0.026s)
[403.071043] Subtest pi-ringfull: SUCCESS (0.171s)
[403.290172] [085/156] (636s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[403.358621] Starting subtest: primary-yf-tiled-reflect-x-180
[403.419063] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[403.520428] [086/156] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[403.600965] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[403.605118] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[403.709890] [087/156] (635s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[403.799726] Starting subtest: 2x-long-flip-vs-cursor-atomic
[403.804568] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[403.948011] [088/156] (635s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[404.012284] Starting subtest: stress-mm-invalidate-close-overlap
[406.162415] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.149s)
[406.274616] [089/156] (633s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[406.353223] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[406.357512] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[406.451807] [090/156] (633s left) gem_mmap_wc (write-cpu-read-wc)
[406.506812] Subtest write-cpu-read-wc: SKIP (0.000s)
[406.572763] [091/156] (633s left) gem_readwrite (new-obj)
[406.623641] Subtest new-obj: SKIP (0.000s)
[406.689876] [092/156] (632s left) kms_psr (psr-primary-mmap-cpu)
[406.769140] Starting subtest: psr-primary-mmap-cpu
[406.771443] Starting dynamic subtest: eDP-1
[408.499632] Dynamic subtest eDP-1: SUCCESS (1.729s)
[408.502027] Subtest psr-primary-mmap-cpu: SUCCESS (1.730s)
[409.375700] [093/156] (630s left) gem_create (create-valid-nonaligned)
[409.435550] Starting subtest: create-valid-nonaligned
[409.437992] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[409.637993] [094/156] (630s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[409.722360] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[409.726380] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[409.824284] [095/156] (629s left) kms_color (ctm-green-to-red)
[409.900849] Starting subtest: ctm-green-to-red
[409.903059] Starting dynamic subtest: pipe-A-eDP-1
[410.606658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[410.616367] Starting dynamic subtest: pipe-B-eDP-1
[412.016482] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s)
[412.026980] Starting dynamic subtest: pipe-C-eDP-1
[413.335764] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.317s)
[413.347866] Starting dynamic subtest: pipe-D-eDP-1
[414.685700] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s)
[414.687968] Subtest ctm-green-to-red: SUCCESS (4.787s)
[415.502609] [096/156] (624s left) kms_chamelium_hpd (dp-hpd)
[415.872951] Subtest dp-hpd: SKIP (0.000s)
[416.712211] [097/156] (623s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[416.790167] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[416.794661] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[416.891795] [098/156] (622s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[416.978292] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[417.955457] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.978s)
[418.077193] [099/156] (621s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[418.154941] Starting subtest: hdr-rgb565-draw-render
[418.159001] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[418.251272] [100/156] (621s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[418.326664] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[418.330143] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[418.420694] [101/156] (621s left) gem_mmap_gtt (big-copy-xy)
[418.478338] Subtest big-copy-XY: SKIP (0.000s)
[418.543501] [102/156] (621s left) kms_psr (fbc-psr-cursor-blt)
[418.611264] Starting subtest: fbc-psr-cursor-blt
[418.613182] Starting dynamic subtest: eDP-1
[418.616740] Dynamic subtest eDP-1: SKIP (0.000s)
[418.620019] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[418.691419] [103/156] (621s left) gem_render_copy (y-tiled)
[418.755488] Starting subtest: y-tiled
[418.759523] Subtest y-tiled: SKIP (0.000s)
[418.937762] [104/156] (621s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[419.016543] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[419.020878] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[419.128756] [105/156] (621s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[419.212367] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[419.216648] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[419.310795] [106/156] (620s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[419.388953] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[419.391463] Starting dynamic subtest: pipe-A-default-mode
[422.164505] Dynamic subtest pipe-A-default-mode: SUCCESS (2.774s)
[422.166825] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.776s)
[423.040091] [107/156] (617s left) gem_flink_basic (bad-open)
[423.094783] Starting subtest: bad-open
[423.096952] Subtest bad-open: SUCCESS (0.000s)
[423.214571] [108/156] (617s left) gem_mmap_gtt (cpuset-big-copy-odd)
[423.264406] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[423.332900] [109/156] (616s left) gem_exec_params (batch-first)
[423.390347] Starting subtest: batch-first
[423.395570] Subtest batch-first: SUCCESS (0.005s)
[423.522251] [110/156] (616s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff)
[423.608515] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff
[423.612889] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[423.705910] [111/156] (616s left) kms_psr (psr2-cursor-blt)
[423.785469] Starting subtest: psr2-cursor-blt
[423.787772] Starting dynamic subtest: eDP-1
[425.505883] Dynamic subtest eDP-1: SUCCESS (1.720s)
[425.508294] Subtest psr2-cursor-blt: SUCCESS (1.721s)
[426.384789] [112/156] (614s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[426.470901] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[426.475010] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[426.565706] [113/156] (613s left) syncobj_timeline (transfer-timeline-point)
[426.631339] Starting subtest: transfer-timeline-point
[426.633678] Subtest transfer-timeline-point: SUCCESS (0.001s)
[426.746679] [114/156] (613s left) kms_prop_blob (invalid-get-prop-any)
[426.794352] Starting subtest: invalid-get-prop-any
[426.796607] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[426.905387] [115/156] (613s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[426.990909] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[426.994969] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[427.092014] [116/156] (613s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[427.143478] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[427.145822] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[427.234446] [117/156] (613s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[427.281765] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[427.284103] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[427.390361] [118/156] (613s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[427.480150] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[427.483716] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[427.564295] [119/156] (613s left) gem_mmap_gtt (basic-read-write-distinct)
[427.615146] Subtest basic-read-write-distinct: SKIP (0.000s)
[427.673149] [120/156] (613s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-fullscreen)
[427.746387] Starting subtest: fbchdr-2p-primscrn-spr-indfb-fullscreen
[427.749733] Subtest fbchdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[427.852433] [121/156] (612s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[427.933199] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[428.560782] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[428.733500] [122/156] (612s left) kms_cursor_crc (cursor-random-128x128)
[428.911031] Starting subtest: cursor-random-128x128
[428.915946] Starting dynamic subtest: pipe-A-eDP-1
[432.275383] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.359s)
[432.308009] Starting dynamic subtest: pipe-D-eDP-1
[436.279672] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.978s)
[436.281809] Subtest cursor-random-128x128: SUCCESS (7.366s)
[437.152646] [123/156] (603s left) gem_render_copy (yf-tiled-to-vebox-linear)
[437.207534] Starting subtest: yf-tiled-to-vebox-linear
[437.211988] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[437.402505] [124/156] (603s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[437.487894] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[439.931560] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.448s)
[441.057514] [125/156] (599s left) kms_addfb_basic (unused-handle)
[441.106864] Starting subtest: unused-handle
[441.108746] Subtest unused-handle: SUCCESS (0.000s)
[441.224665] [126/156] (599s left) gem_exec_balancer (invalid-bonds)
[441.277391] Starting subtest: invalid-bonds
[441.281822] Subtest invalid-bonds: SKIP (0.000s)
[441.586551] [127/156] (599s left) gem_ctx_param (invalid-param-set)
[441.637921] Starting subtest: invalid-param-set
[441.640373] Subtest invalid-param-set: SUCCESS (0.000s)
[441.724028] [128/156] (599s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[441.799243] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[441.801468] Starting dynamic subtest: pipe-A-eDP-1
[441.825665] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[441.837111] Starting dynamic subtest: pipe-B-eDP-1
[441.857505] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[441.866382] Starting dynamic subtest: pipe-C-eDP-1
[441.887028] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[441.895769] Starting dynamic subtest: pipe-D-eDP-1
[441.916732] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[441.920982] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[444.093507] [129/156] (597s left) i915_pm_rc6_residency (media-rc6-accuracy)
[444.152451] Starting subtest: media-rc6-accuracy
[444.156915] Subtest media-rc6-accuracy: SKIP (0.000s)
[444.270229] [130/156] (596s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[444.352966] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[444.357480] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[444.462803] [131/156] (596s left) gem_eio (wait-1us)
[444.680376] Starting subtest: wait-1us
[445.033379] Subtest wait-1us: SUCCESS (0.355s)
[445.169679] [132/156] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[445.251455] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[445.255489] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[445.330821] [133/156] (595s left) perf_pmu (all-busy-check-all)
[445.370618] Starting subtest: all-busy-check-all
[446.776231] Subtest all-busy-check-all: SUCCESS (1.405s)
[446.906208] [134/156] (594s left) gem_flink_basic (double-flink)
[446.967873] Starting subtest: double-flink
[446.969781] Subtest double-flink: SUCCESS (0.000s)
[447.080388] [135/156] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[447.169206] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[447.173499] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[447.269796] [136/156] (594s left) gem_tiled_swapping (non-threaded)
[447.318589] Subtest non-threaded: SKIP (0.000s)
[447.382830] [137/156] (594s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[447.473082] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[447.475376] Starting dynamic subtest: pipe-A
[447.810258] Dynamic subtest pipe-A: SUCCESS (0.339s)
[447.821213] Starting dynamic subtest: pipe-B
[449.180247] Dynamic subtest pipe-B: SUCCESS (1.369s)
[449.190791] Starting dynamic subtest: pipe-C
[450.609667] Dynamic subtest pipe-C: SUCCESS (1.429s)
[450.619936] Starting dynamic subtest: pipe-D
[452.033288] Dynamic subtest pipe-D: SUCCESS (1.423s)
[452.035616] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.562s)
[453.200591] [138/156] (588s left) kms_cursor_crc (cursor-random-max-size)
[453.481623] Starting subtest: cursor-random-max-size
[453.488059] Subtest cursor-random-max-size: SKIP (0.000s)
[453.596242] [139/156] (587s left) syncobj_timeline (invalid-query-zero-handles)
[453.652159] Starting subtest: invalid-query-zero-handles
[453.654337] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[453.737692] [140/156] (587s left) syncobj_eventfd (invalid-bad-flags)
[453.784098] Starting subtest: invalid-bad-flags
[453.786374] Subtest invalid-bad-flags: SUCCESS (0.000s)
[453.877215] [141/156] (587s left) kms_plane_scaling (planes-upscale-20x20)
[453.944086] Starting subtest: planes-upscale-20x20
[453.946501] Starting dynamic subtest: pipe-A
[454.005646] Dynamic subtest pipe-A: SUCCESS (0.062s)
[454.018203] Starting dynamic subtest: pipe-B
[455.129047] Dynamic subtest pipe-B: SUCCESS (1.122s)
[455.140377] Starting dynamic subtest: pipe-C
[456.249030] Dynamic subtest pipe-C: SUCCESS (1.119s)
[456.259480] Starting dynamic subtest: pipe-D
[457.366662] Dynamic subtest pipe-D: SUCCESS (1.116s)
[457.369005] Subtest planes-upscale-20x20: SUCCESS (3.423s)
[458.538957] [142/156] (583s left) gem_exec_reloc (basic-wc-read-active)
[458.592227] Subtest basic-wc-read-active: SKIP (0.000s)
[458.659386] [143/156] (583s left) gem_create (create-invalid-size)
[458.711427] Starting subtest: create-invalid-size
[458.713601] Subtest create-invalid-size: SUCCESS (0.000s)
[458.898515] [144/156] (582s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[458.969782] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[458.974108] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[459.042674] [145/156] (582s left) perf_pmu (invalid-open)
[459.082094] Starting subtest: invalid-open
[459.084452] Subtest invalid-open: SUCCESS (0.000s)
[459.193376] [146/156] (582s left) gem_exec_gttfill (multigpu-basic)
[459.368540] Starting subtest: multigpu-basic
[471.850184] Subtest multigpu-basic: SUCCESS (12.483s)
[471.895775] [147/156] (570s left) gem_ccs (block-multicopy-compressed)
[471.997968] Starting subtest: block-multicopy-compressed
[472.002995] Subtest block-multicopy-compressed: SKIP (0.000s)
[472.121087] [148/156] (569s left) core_setmaster (master-drop-set-root)
[472.205276] Starting subtest: master-drop-set-root
[472.226291] Subtest master-drop-set-root: SUCCESS (0.024s)
[472.276910] [149/156] (569s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[472.368050] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[472.372389] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[472.456746] [150/156] (569s left) gem_exec_flush (basic-uc-rw-default)
[472.521820] Starting subtest: basic-uc-rw-default
[477.978807] Subtest basic-uc-rw-default: SUCCESS (5.457s)
[478.163576] [151/156] (563s left) sw_sync (sync_busy_fork_unixsocket)
[478.202207] Starting subtest: sync_busy_fork_unixsocket
[478.206065] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[478.265718] [152/156] (563s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[478.350866] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[478.353119] Starting dynamic subtest: pipe-A-eDP-1
[478.446953] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[478.457642] Starting dynamic subtest: pipe-B-eDP-1
[479.609070] Dynamic subtest pipe-B-eDP-1: SKIP (1.158s)
[479.613690] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.260s)
[480.813724] [153/156] (561s left) gem_userptr_blits (process-exit)
[480.889817] Starting subtest: process-exit
[480.895113] Subtest process-exit: SUCCESS (0.007s)
[481.029185] [154/156] (561s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[481.105633] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[481.107889] Starting dynamic subtest: pipe-A-eDP-1
[481.130310] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[481.143890] Starting dynamic subtest: pipe-B-eDP-1
[481.165408] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[481.176284] Starting dynamic subtest: pipe-C-eDP-1
[481.198283] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[481.208458] Starting dynamic subtest: pipe-D-eDP-1
[481.230425] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[481.234400] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[483.364536] [155/156] (558s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[483.446927] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[483.450870] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[483.535479] [156/156] (558s left) gem_ctx_isolation (preservation-s3)
[483.588834] Starting subtest: preservation-S3
[483.591140] Starting dynamic subtest: rcs0
[500.097743] Dynamic subtest rcs0: SUCCESS (1.320s)
[500.109383] Starting dynamic subtest: bcs0
[516.110920] Dynamic subtest bcs0: SUCCESS (1.337s)
[516.121726] Starting dynamic subtest: vcs0
[532.122898] Dynamic subtest vcs0: SUCCESS (2.586s)
[532.136013] Starting dynamic subtest: vcs1
[550.114143] Dynamic subtest vcs1: SUCCESS (4.946s)
[550.129284] Starting dynamic subtest: vecs0
[568.102986] Dynamic subtest vecs0: SUCCESS (4.972s)
[568.114829] Starting dynamic subtest: ccs0
[586.093509] Dynamic subtest ccs0: SUCCESS (3.216s)
[586.096231] Subtest preservation-S3: SUCCESS (18.384s)
[586.321169] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_eventfd
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: vgem_basic
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: kms_plane_lowres
results: parsing output: 24/ for test: kms_cursor_edge_walk
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: i915_module_load
results: parsing output: 28/ for test: kms_chamelium_frames
results: parsing output: 29/ for test: gem_create
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_exec_suspend
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_plane_alpha_blend
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gem_partial_pwrite_pread
results: parsing output: 40/ for test: kms_tiled_display
results: parsing output: 41/ for test: kms_chamelium_audio
results: parsing output: 42/ for test: gem_pxp
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: i915_suspend
results: parsing output: 46/ for test: kms_lease
results: parsing output: 47/ for test: kms_atomic
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_invalid_mode
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: kms_atomic_transition
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: api_intel_allocator
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_spin_batch
results: parsing output: 66/ for test: gem_wait
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: gem_exec_store
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: gem_ctx_shared
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_bad_reloc
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_getfb
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_atomic_interruptible
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_mmap_wc
results: parsing output: 90/ for test: gem_readwrite
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_create
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_chamelium_hpd
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: gem_flink_basic
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_prop_blob
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: i915_pm_rc6_residency
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_eio
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: perf_pmu
results: parsing output: 133/ for test: gem_flink_basic
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_tiled_swapping
results: parsing output: 136/ for test: kms_plane_scaling
results: parsing output: 137/ for test: kms_cursor_crc
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: syncobj_eventfd
results: parsing output: 140/ for test: kms_plane_scaling
results: parsing output: 141/ for test: gem_exec_reloc
results: parsing output: 142/ for test: gem_create
results: parsing output: 143/ for test: kms_flip_scaled_crc
results: parsing output: 144/ for test: perf_pmu
results: parsing output: 145/ for test: gem_exec_gttfill
results: parsing output: 146/ for test: gem_ccs
results: parsing output: 147/ for test: core_setmaster
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_exec_flush
results: parsing output: 150/ for test: sw_sync
results: parsing output: 151/ for test: kms_psr2_sf
results: parsing output: 152/ for test: gem_userptr_blits
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: gem_ctx_isolation
Done.