[54.937192] Initializing watchdogs
[54.937261]   /dev/watchdog0
[54.954171] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[54.959678] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.962322] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.964210] [001/156] (960s left) kms_psr (pr-basic)
[55.062441] Subtest pr-basic: SKIP (0.000s)
[55.104810] [002/156] (960s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[55.193483] Starting subtest: short-flip-before-cursor-toggle
[55.752990] Subtest short-flip-before-cursor-toggle: SUCCESS (0.559s)
[55.917963] [003/156] (959s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[56.015394] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[56.016851] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[56.099405] [004/156] (959s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[56.188917] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[56.190031] Starting dynamic subtest: pipe-A
[57.300730] Dynamic subtest pipe-A: SUCCESS (1.111s)
[57.308178] Starting dynamic subtest: pipe-B
[58.485118] Dynamic subtest pipe-B: SUCCESS (1.184s)
[58.491961] Starting dynamic subtest: pipe-C
[58.694769] Dynamic subtest pipe-C: SUCCESS (0.209s)
[58.701804] Starting dynamic subtest: pipe-D
[58.903680] Dynamic subtest pipe-D: SUCCESS (0.209s)
[58.904452] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.715s)
[59.085777] [005/156] (956s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[59.181331] Starting subtest: cursor-vs-flip-legacy
[89.066584] Subtest cursor-vs-flip-legacy: SUCCESS (29.885s)
[89.230692] [006/156] (926s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[89.330350] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[90.618213] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (1.288s)
[90.742889] [007/156] (924s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[90.840393] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[90.841825] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[90.926602] [008/156] (924s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[91.019104] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[91.020447] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[91.111483] [009/156] (924s left) kms_chamelium_hpd (common-hpd-after-suspend)
[91.252933] Subtest common-hpd-after-suspend: SKIP (0.000s)
[91.348822] [010/156] (924s left) gem_exec_schedule (in-order)
[91.402093] Starting subtest: in-order
[91.402993] Starting dynamic subtest: rcs0
[91.466647] Dynamic subtest rcs0: SUCCESS (0.064s)
[91.477905] Starting dynamic subtest: bcs0
[91.534499] Dynamic subtest bcs0: SUCCESS (0.066s)
[91.544720] Starting dynamic subtest: vcs0
[91.603931] Dynamic subtest vcs0: SUCCESS (0.069s)
[91.613676] Starting dynamic subtest: vcs1
[91.670459] Dynamic subtest vcs1: SUCCESS (0.066s)
[91.679756] Starting dynamic subtest: vecs0
[91.737456] Dynamic subtest vecs0: SUCCESS (0.066s)
[91.738640] Subtest in-order: SUCCESS (0.335s)
[92.051469] [011/156] (923s left) gem_ctx_exec (basic)
[92.086363] Starting subtest: basic
[92.088765] Subtest basic: SUCCESS (0.002s)
[92.190381] [012/156] (923s left) syncobj_wait (invalid-wait-bad-flags)
[92.224522] Starting subtest: invalid-wait-bad-flags
[92.225240] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[92.284661] [013/156] (923s left) kms_plane_multiple (tiling-x)
[92.375366] Starting subtest: tiling-x
[92.376066] Starting dynamic subtest: pipe-A-HDMI-A-1
[93.003294] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.627s)
[93.010398] Starting dynamic subtest: pipe-B-HDMI-A-1
[93.709438] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.705s)
[93.717218] Starting dynamic subtest: pipe-C-HDMI-A-1
[94.339919] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.628s)
[94.347874] Starting dynamic subtest: pipe-D-HDMI-A-1
[94.947015] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.606s)
[94.947855] Subtest tiling-x: SUCCESS (2.572s)
[95.116049] [014/156] (920s left) perf (short-reads)
[95.200978] Starting subtest: short-reads
[95.215428] Subtest short-reads: SUCCESS (0.014s)
[95.252878] [015/156] (920s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[95.348479] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[95.349918] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[95.431473] [016/156] (920s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[95.471663] Starting subtest: y-tiled-ccs-to-y-tiled
[95.472374] Starting dynamic subtest: smem
[95.578898] Dynamic subtest smem: SUCCESS (0.107s)
[95.579682] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.108s)
[95.757516] [017/156] (920s left) api_intel_bb (misplaced-blitter)
[95.791654] Starting subtest: misplaced-blitter
[95.796482] Subtest misplaced-blitter: SUCCESS (0.005s)
[95.889972] [018/156] (920s left) kms_atomic_transition (plane-all-transition-fencing)
[95.979799] Starting subtest: plane-all-transition-fencing
[95.980529] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.930807] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.950s)
[98.003264] Starting dynamic subtest: pipe-B-HDMI-A-1
[100.055775] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.059s)
[100.112094] Subtest plane-all-transition-fencing: SUCCESS (4.132s)
[100.262682] [019/156] (915s left) gem_reg_read (timestamp-monotonic)
[100.301822] Starting subtest: timestamp-monotonic
[105.292074] Subtest timestamp-monotonic: SUCCESS (4.956s)
[105.323723] [020/156] (910s left) kms_plane_cursor (primary)
[105.413871] Starting subtest: primary
[105.415295] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[106.629963] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.215s)
[106.667827] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[107.871860] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.216s)
[107.909553] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[109.113735] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.216s)
[109.199734] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[110.461621] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.269s)
[110.488293] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[111.695111] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.216s)
[111.722846] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[112.928698] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.216s)
[112.992655] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[114.249636] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.263s)
[114.276746] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[115.482922] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.216s)
[115.511442] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[116.716547] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.216s)
[116.790115] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[118.050817] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.267s)
[118.073623] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[119.276212] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.208s)
[119.303947] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[120.509670] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.216s)
[120.575749] Subtest primary: SUCCESS (15.161s)
[120.695861] [021/156] (895s left) gem_ctx_create (basic-files)
[120.744632] Starting subtest: basic-files
[122.754868] Subtest basic-files: SUCCESS (2.010s)
[122.966171] [022/156] (893s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[123.062093] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[123.063531] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[123.140707] [023/156] (893s left) kms_cursor_crc (cursor-tearing-position-change)
[123.230985] Starting subtest: cursor-tearing-position-change
[123.231763] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.492288] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.260s)
[123.500276] Starting dynamic subtest: pipe-D-HDMI-A-1
[123.724557] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.229s)
[123.725606] Subtest cursor-tearing-position-change: SUCCESS (0.493s)
[123.887391] [024/156] (892s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[123.982335] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[124.022268] [025/156] (892s left) syncobj_timeline (signal-point-0)
[124.057280] Starting subtest: signal-point-0
[124.058075] Subtest signal-point-0: SUCCESS (0.000s)
[124.136295] [026/156] (892s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[124.236503] Starting subtest: yf-tiled-16bpp-rotate-180
[124.238008] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[124.325724] [027/156] (892s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[124.418611] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[124.420183] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[124.503908] [028/156] (891s left) drm_read (empty-block)
[124.612061] Starting subtest: empty-block
[125.620186] Subtest empty-block: SUCCESS (1.000s)
[125.739702] [029/156] (890s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[125.831473] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[125.852154] Starting dynamic subtest: pipe-A-plane-0
[126.068818] Dynamic subtest pipe-A-plane-0: SUCCESS (0.216s)
[126.085127] Starting dynamic subtest: pipe-A-plane-3
[126.235420] Dynamic subtest pipe-A-plane-3: SUCCESS (0.164s)
[126.251225] Starting dynamic subtest: pipe-A-plane-5
[126.402125] Dynamic subtest pipe-A-plane-5: SUCCESS (0.164s)
[126.557008] Starting dynamic subtest: pipe-B-plane-0
[126.724862] Dynamic subtest pipe-B-plane-0: SUCCESS (0.175s)
[126.735961] Starting dynamic subtest: pipe-B-plane-3
[126.891427] Dynamic subtest pipe-B-plane-3: SUCCESS (0.164s)
[126.902228] Starting dynamic subtest: pipe-B-plane-5
[127.058119] Dynamic subtest pipe-B-plane-5: SUCCESS (0.165s)
[127.141043] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (1.309s)
[127.330300] [030/156] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[127.431441] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[127.432908] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[127.527128] [031/156] (889s left) kms_vblank (ts-continuation-dpms-rpm)
[127.617315] Starting subtest: ts-continuation-dpms-rpm
[127.619163] Starting dynamic subtest: pipe-A-HDMI-A-1
[129.194059] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.575s)
[129.203157] Starting dynamic subtest: pipe-D-HDMI-A-1
[130.431138] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.234s)
[130.431895] Subtest ts-continuation-dpms-rpm: SUCCESS (2.815s)
[130.571464] [032/156] (886s left) gem_exec_schedule (submit-late-slice)
[130.624077] Starting subtest: submit-late-slice
[130.624890] Starting dynamic subtest: rcs0
[130.658363] Dynamic subtest rcs0: SUCCESS (0.034s)
[130.670311] Starting dynamic subtest: bcs0
[130.691258] Dynamic subtest bcs0: SUCCESS (0.030s)
[130.699457] Starting dynamic subtest: vcs0
[130.722096] Dynamic subtest vcs0: SUCCESS (0.029s)
[130.730763] Starting dynamic subtest: vcs1
[130.748058] Dynamic subtest vcs1: SUCCESS (0.025s)
[130.757959] Starting dynamic subtest: vecs0
[130.781129] Dynamic subtest vecs0: SUCCESS (0.032s)
[130.782106] Subtest submit-late-slice: SUCCESS (0.158s)
[131.092848] [033/156] (885s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[131.185798] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[132.234688] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.050s)
[132.355936] [034/156] (884s left) syncobj_eventfd (binary-wait-signaled)
[132.391480] Starting subtest: binary-wait-signaled
[132.392179] Subtest binary-wait-signaled: SUCCESS (0.000s)
[132.456782] [035/156] (884s left) syncobj_wait (multi-wait-all-submitted-signaled)
[132.492174] Starting subtest: multi-wait-all-submitted-signaled
[132.597663] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[132.680732] [036/156] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[132.775179] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[132.776577] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[132.870529] [037/156] (883s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[132.960077] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[132.997216] [038/156] (883s left) kms_chamelium_frames (hdmi-crc-fast)
[133.144842] Subtest hdmi-crc-fast: SKIP (0.000s)
[133.240117] [039/156] (883s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[133.280947] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[133.282862] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[133.340051] [040/156] (883s left) gem_ctx_engines (execute-one)
[133.382582] Starting subtest: execute-one
[134.653530] Subtest execute-one: SUCCESS (1.262s)
[134.849511] [041/156] (882s left) gem_partial_pwrite_pread (write-snoop)
[134.887765] Starting subtest: write-snoop
[145.165446] Subtest write-snoop: SUCCESS (10.278s)
[145.269782] [042/156] (871s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[145.305570] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[145.306276] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[145.372507] [043/156] (871s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[145.464074] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[145.465561] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[145.526794] [044/156] (871s left) prime_mmap_kms (buffer-sharing)
[145.616110] Starting subtest: buffer-sharing
[145.802297] Subtest buffer-sharing: SUCCESS (0.187s)
[145.977348] [045/156] (871s left) kms_content_protection (dp-mst-type-1)
[146.075903] Starting subtest: dp-mst-type-1
[146.077484] Subtest dp-mst-type-1: SKIP (0.000s)
[146.186753] [046/156] (870s left) core_setmaster (master-drop-set-root)
[146.241931] Starting subtest: master-drop-set-root
[146.256139] Subtest master-drop-set-root: SUCCESS (0.014s)
[146.306026] [047/156] (870s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-gtt)
[146.401212] Starting subtest: fbchdr-rgb565-draw-mmap-gtt
[146.402690] Subtest fbchdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[146.492421] [048/156] (870s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[146.585500] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[146.586908] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[146.684964] [049/156] (870s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[146.773088] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[146.775515] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[146.829628] [050/156] (870s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[146.918997] Starting subtest: crc-primary-basic-yf-tiled-ccs
[146.919731] Starting dynamic subtest: pipe-A-HDMI-A-1
[146.926687] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[146.935924] Starting dynamic subtest: pipe-B-HDMI-A-1
[146.942822] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[146.949663] Starting dynamic subtest: pipe-C-HDMI-A-1
[146.956460] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[146.963137] Starting dynamic subtest: pipe-D-HDMI-A-1
[146.970412] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[146.971767] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.009s)
[147.168768] [051/156] (870s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[147.264138] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[147.265514] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[147.359792] [052/156] (870s left) gem_ctx_sseu (engines)
[147.397953] Subtest engines: SKIP (0.000s)
[147.435902] [053/156] (869s left) gem_exec_store (basic)
[147.478274] Starting subtest: basic
[147.548802] Subtest basic: SUCCESS (0.070s)
[147.720742] [054/156] (869s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[147.812432] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[147.813826] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[147.912976] [055/156] (869s left) gem_mmap_gtt (hang)
[147.949878] Starting subtest: hang
[153.384563] Subtest hang: SUCCESS (5.432s)
[153.469755] [056/156] (864s left) kms_psr (psr2-sprite-mmap-gtt)
[153.565688] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[153.606995] [057/156] (863s left) syncobj_timeline (etime-multi-wait-all-submitted)
[153.645681] Starting subtest: etime-multi-wait-all-submitted
[153.749072] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[153.811009] [058/156] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[153.905375] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[153.906744] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[153.994020] [059/156] (863s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[154.087111] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[154.134277] [060/156] (863s left) i915_drm_fdinfo (virtual-busy-hang)
[154.174592] Starting subtest: virtual-busy-hang
[159.406791] Subtest virtual-busy-hang: SUCCESS (5.232s)
[159.485884] [061/156] (858s left) gem_exec_fence (invalid-fence-array)
[159.852029] Starting subtest: invalid-fence-array
[159.854453] Subtest invalid-fence-array: SUCCESS (0.002s)
[160.181325] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[160.183900] [062/156] (857s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[160.279403] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[160.280883] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[160.360882] [063/156] (857s left) gen9_exec_parse (bb-start-far)
[160.399214] Subtest bb-start-far: SKIP (0.000s)
[160.440519] [064/156] (857s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[160.528319] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[160.529077] Starting dynamic subtest: pipe-A-HDMI-A-1
[160.536888] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[160.544098] Starting dynamic subtest: pipe-B-HDMI-A-1
[160.552051] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[160.559156] Starting dynamic subtest: pipe-C-HDMI-A-1
[160.566517] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[160.573487] Starting dynamic subtest: pipe-D-HDMI-A-1
[160.581036] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[160.582417] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[160.784942] [065/156] (857s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[160.878596] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[160.879358] Starting dynamic subtest: pipe-A-HDMI-A-1
[160.882232] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[160.891278] Starting dynamic subtest: pipe-B-HDMI-A-1
[160.894184] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[160.903861] Starting dynamic subtest: pipe-C-HDMI-A-1
[160.906797] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[160.915572] Starting dynamic subtest: pipe-D-HDMI-A-1
[160.918447] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[160.919868] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.007s)
[161.132831] [066/156] (856s left) sysfs_timeslice_duration (idempotent)
[161.171410] Starting subtest: idempotent
[161.173295] Starting dynamic subtest: vecs0
[161.174026] Dynamic subtest vecs0: SUCCESS (0.001s)
[161.181837] Starting dynamic subtest: vcs0
[161.182539] Dynamic subtest vcs0: SUCCESS (0.000s)
[161.189839] Starting dynamic subtest: bcs0
[161.190550] Dynamic subtest bcs0: SUCCESS (0.001s)
[161.197781] Starting dynamic subtest: rcs0
[161.198484] Dynamic subtest rcs0: SUCCESS (0.000s)
[161.205174] Starting dynamic subtest: vcs1
[161.205880] Dynamic subtest vcs1: SUCCESS (0.001s)
[161.206576] Subtest idempotent: SUCCESS (0.008s)
[161.244934] [067/156] (856s left) gem_lmem_swapping (verify-random-ccs)
[161.282888] Subtest verify-random-ccs: SKIP (0.000s)
[161.324991] [068/156] (856s left) kms_joiner (basic-force-ultra-joiner)
[161.415076] Starting subtest: basic-force-ultra-joiner
[161.416488] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[161.481701] [069/156] (856s left) perf (sysctl-defaults)
[161.551425] Starting subtest: sysctl-defaults
[161.552201] Subtest sysctl-defaults: SUCCESS (0.000s)
[161.603932] [070/156] (856s left) i915_pm_rpm (system-suspend-execbuf)
[163.008334] Starting subtest: system-suspend-execbuf
[205.786130] Subtest system-suspend-execbuf: SUCCESS (27.328s)
[206.046377] [071/156] (812s left) gem_render_copy (yf-tiled)
[206.092844] Starting subtest: yf-tiled
[206.093596] Starting dynamic subtest: smem
[206.161995] Dynamic subtest smem: SUCCESS (0.068s)
[206.162754] Subtest yf-tiled: SUCCESS (0.070s)
[206.342014] [072/156] (811s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[206.431569] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[206.432311] Starting dynamic subtest: pipe-A-HDMI-A-1
[206.439993] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[206.448230] Starting dynamic subtest: pipe-B-HDMI-A-1
[206.456125] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[206.464412] Starting dynamic subtest: pipe-C-HDMI-A-1
[206.472225] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[206.480020] Starting dynamic subtest: pipe-D-HDMI-A-1
[206.487872] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[206.489288] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[206.683947] [073/156] (811s left) kms_flip (blocking-wf_vblank)
[206.775040] Starting subtest: blocking-wf_vblank
[206.777743] Starting dynamic subtest: A-HDMI-A1
[214.629205] Dynamic subtest A-HDMI-A1: SUCCESS (7.831s)
[214.637017] Starting dynamic subtest: B-HDMI-A1
[222.423808] Dynamic subtest B-HDMI-A1: SUCCESS (7.808s)
[222.438103] Starting dynamic subtest: C-HDMI-A1
[230.255770] Dynamic subtest C-HDMI-A1: SUCCESS (7.804s)
[230.263520] Starting dynamic subtest: D-HDMI-A1
[238.050928] Dynamic subtest D-HDMI-A1: SUCCESS (7.817s)
[238.051666] Subtest blocking-wf_vblank: SUCCESS (31.276s)
[238.214069] [074/156] (779s left) kms_atomic (crtc-invalid-params-fence)
[238.311614] Starting subtest: crtc-invalid-params-fence
[238.312595] Starting dynamic subtest: pipe-A-HDMI-A-1
[238.492581] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.179s)
[238.493319] Subtest crtc-invalid-params-fence: SUCCESS (0.181s)
[238.657582] [075/156] (779s left) gem_exec_params (dr1-dirt)
[238.698418] Starting subtest: DR1-dirt
[238.699147] Subtest DR1-dirt: SUCCESS (0.000s)
[238.792441] [076/156] (779s left) gem_softpin (allocator-fork)
[238.832361] Starting subtest: allocator-fork
[241.064292] Subtest allocator-fork: SUCCESS (2.224s)
[241.168076] [077/156] (777s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[241.264902] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[241.266362] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[241.363959] [078/156] (776s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[241.398603] Starting subtest: single-wait-for-submit-available-signaled
[241.399326] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[241.501083] [079/156] (776s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[241.591306] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[241.592030] Starting dynamic subtest: pipe-A-HDMI-A-1
[241.598946] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[241.607184] Starting dynamic subtest: pipe-B-HDMI-A-1
[241.613942] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[241.622035] Starting dynamic subtest: pipe-C-HDMI-A-1
[241.628807] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[241.636597] Starting dynamic subtest: pipe-D-HDMI-A-1
[241.643415] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[241.644757] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[241.860338] [080/156] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[241.957606] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[241.958980] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[242.063668] [081/156] (776s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[242.157365] Starting subtest: hdr-rgb101010-draw-render
[242.158874] Subtest hdr-rgb101010-draw-render: SKIP (0.000s)
[242.248020] [082/156] (776s left) gem_mmap_gtt (basic-write-read)
[242.282630] Starting subtest: basic-write-read
[242.285250] Subtest basic-write-read: SUCCESS (0.003s)
[242.389867] [083/156] (776s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[242.493002] Starting subtest: 4-tiled-64bpp-rotate-0
[242.494412] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[242.586435] [084/156] (776s left) gem_ctx_persistence (many-contexts)
[242.625613] Starting subtest: many-contexts
[281.818096] Subtest many-contexts: SUCCESS (39.181s)
[281.899277] [085/156] (736s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[281.998640] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[282.000051] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[282.093538] [086/156] (736s left) kms_feature_discovery (display)
[282.186367] Starting subtest: display
[282.187061] Subtest display: SUCCESS (0.000s)
[282.267066] [087/156] (736s left) kms_psr (psr-sprite-mmap-cpu)
[282.357959] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[282.405965] [088/156] (736s left) gem_madvise (dontneed-before-exec)
[282.440461] Starting subtest: dontneed-before-exec
[282.444274] Subtest dontneed-before-exec: SUCCESS (0.004s)
[282.562054] [089/156] (736s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[282.656637] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[282.658052] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[282.746935] [090/156] (736s left) api_intel_allocator (reloc-allocator)
[282.782372] Starting subtest: reloc-allocator
[282.783088] Starting dynamic subtest: basic
[282.785021] Dynamic subtest basic: SUCCESS (0.002s)
[282.794213] Starting dynamic subtest: parallel-one
[282.794939] Dynamic subtest parallel-one: SUCCESS (0.004s)
[282.803239] Starting dynamic subtest: print
[282.803956] Dynamic subtest print: SUCCESS (0.000s)
[282.812185] Starting dynamic subtest: reuse
[282.812911] Dynamic subtest reuse: SUCCESS (0.000s)
[282.820892] Starting dynamic subtest: fork-reopen-allocator
[282.821606] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[282.822309] Subtest reloc-allocator: SUCCESS (0.025s)
[282.893980] [091/156] (736s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[282.988671] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[282.990086] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[283.091052] [092/156] (735s left) gem_exec_reloc (basic-wc-gtt-active)
[283.131081] Starting subtest: basic-wc-gtt-active
[283.264411] Subtest basic-wc-gtt-active: SUCCESS (0.124s)
[283.397976] [093/156] (735s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[283.437263] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[283.438024] Starting dynamic subtest: smem
[283.541046] Dynamic subtest smem: SUCCESS (0.103s)
[283.541796] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.104s)
[283.732505] [094/156] (735s left) kms_pm_rpm (cursor)
[285.135694] Starting subtest: cursor
[297.028482] Subtest cursor: SUCCESS (11.894s)
[297.222393] [095/156] (721s left) kms_debugfs (display-off-read-all)
[297.315310] Starting subtest: display-off-read-all
[297.375014] Subtest display-off-read-all: SUCCESS (0.060s)
[297.499156] [096/156] (721s left) i915_module_load (resize-bar)
[297.535519] Starting subtest: resize-bar
[297.540565] Subtest resize-bar: SKIP (0.006s)
[297.582525] [097/156] (721s left) perf_pmu (event-wait)
[297.618779] Starting subtest: event-wait
[297.619525] Starting dynamic subtest: rcs0
[297.620960] Dynamic subtest rcs0: SKIP (0.000s)
[297.622395] Subtest event-wait: SKIP (0.001s)
[297.689209] [098/156] (721s left) perf (non-system-wide-paranoid)
[297.778593] Starting subtest: non-system-wide-paranoid
[297.805620] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[297.845203] [099/156] (721s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[297.884590] Starting subtest: basic-wc-cpu-noreloc
[297.888055] Subtest basic-wc-cpu-noreloc: SUCCESS (0.003s)
[298.013915] [100/156] (721s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[298.107413] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[298.108855] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[298.200670] [101/156] (721s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[298.295776] Starting subtest: fbcpsrhdr-slowdraw
[298.297253] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[298.408216] [102/156] (720s left) kms_panel_fitting (atomic-fastset)
[298.500248] Starting subtest: atomic-fastset
[298.501586] Subtest atomic-fastset: SKIP (0.000s)
[298.571544] [103/156] (720s left) fbdev (unaligned-read)
[298.609829] Starting subtest: unaligned-read
[298.619029] Subtest unaligned-read: SUCCESS (0.009s)
[298.682294] [104/156] (720s left) gem_ctx_exec (basic-norecovery)
[298.716855] Starting subtest: basic-norecovery
[298.732651] Subtest basic-norecovery: SUCCESS (0.014s)
[298.850205] [105/156] (720s left) gem_mmap_offset (bad-extensions)
[298.884289] Starting subtest: bad-extensions
[298.885063] Subtest bad-extensions: SUCCESS (0.000s)
[298.980817] [106/156] (720s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[299.076924] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[299.078350] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[299.170253] [107/156] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[299.265357] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[299.266799] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[299.378270] [108/156] (720s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[299.471749] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[299.517115] [109/156] (720s left) gem_userptr_blits (readonly-pwrite-unsync)
[299.556126] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[299.677937] [110/156] (720s left) gem_pxp (create-protected-buffer)
[299.782823] Starting subtest: create-protected-buffer
[299.783901] Subtest create-protected-buffer: SUCCESS (0.000s)
[299.891955] [111/156] (719s left) kms_invalid_mode (bad-hsync-end)
[299.981001] Starting subtest: bad-hsync-end
[299.981735] Starting dynamic subtest: pipe-A-HDMI-A-1
[300.033769] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.052s)
[300.045827] Starting dynamic subtest: pipe-B-HDMI-A-1
[300.046569] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[300.054907] Starting dynamic subtest: pipe-C-HDMI-A-1
[300.055604] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[300.064031] Starting dynamic subtest: pipe-D-HDMI-A-1
[300.064762] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[300.065484] Subtest bad-hsync-end: SUCCESS (0.063s)
[300.208554] [112/156] (719s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[300.304573] Starting subtest: psrhdr-farfromfence-mmap-gtt
[300.305952] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[300.400912] [113/156] (719s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[300.493594] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[300.494985] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[300.593251] [114/156] (719s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[300.683618] Starting subtest: addfb25-yf-tiled-legacy
[300.684404] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[300.780291] [115/156] (719s left) gem_exec_reloc (basic-wc-read)
[300.819077] Starting subtest: basic-wc-read
[300.824775] Subtest basic-wc-read: SUCCESS (0.006s)
[300.946665] [116/156] (719s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[301.041655] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[301.043061] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[301.144634] [117/156] (718s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[301.246114] Starting subtest: y-tiled-8bpp-rotate-90
[301.328840] Subtest y-tiled-8bpp-rotate-90: SKIP (0.081s)
[301.435123] [118/156] (718s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[301.531543] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[301.532933] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[301.647732] [119/156] (718s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[301.749202] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[301.750586] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[301.854012] [120/156] (718s left) kms_vblank (accuracy-idle)
[301.948298] Starting subtest: accuracy-idle
[301.949016] Starting dynamic subtest: pipe-A-HDMI-A-1
[303.128596] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.180s)
[303.144002] Starting dynamic subtest: pipe-D-HDMI-A-1
[304.306433] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.171s)
[304.307450] Subtest accuracy-idle: SUCCESS (2.359s)
[304.452766] [121/156] (715s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[304.562189] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[304.563607] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[304.655164] [122/156] (715s left) intel_hwmon (hwmon-read)
[304.688468] Subtest hwmon-read: SKIP (0.000s)
[304.732874] [123/156] (715s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[304.825700] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[304.827131] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[304.924055] [124/156] (715s left) kms_flip (bo-too-big-interruptible)
[305.018344] Starting subtest: bo-too-big-interruptible
[305.021384] Starting dynamic subtest: A-HDMI-A1
[305.347984] Dynamic subtest A-HDMI-A1: SUCCESS (0.326s)
[305.358626] Starting dynamic subtest: B-HDMI-A1
[305.655700] Dynamic subtest B-HDMI-A1: SUCCESS (0.306s)
[305.666304] Starting dynamic subtest: C-HDMI-A1
[305.953877] Dynamic subtest C-HDMI-A1: SUCCESS (0.295s)
[305.964329] Starting dynamic subtest: D-HDMI-A1
[306.255266] Dynamic subtest D-HDMI-A1: SUCCESS (0.300s)
[306.258829] Subtest bo-too-big-interruptible: SUCCESS (1.240s)
[306.452215] [125/156] (713s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[306.552201] Starting subtest: extended-modeset-hang-oldfb-with-reset
[306.554184] Starting dynamic subtest: pipe-A
[317.316072] Dynamic subtest pipe-A: SUCCESS (10.762s)
[317.328111] Starting dynamic subtest: pipe-D
[328.065225] Dynamic subtest pipe-D: SUCCESS (10.744s)
[328.066104] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.512s)
[328.202575] [126/156] (692s left) gem_render_copy_redux (normal)
[328.263593] Starting subtest: normal
[328.590720] Subtest normal: SUCCESS (0.319s)
[328.686154] [127/156] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[328.781711] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[328.783154] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[328.887036] [128/156] (691s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[328.980880] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[328.982225] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[329.088124] [129/156] (691s left) kms_psr (pr-cursor-render)
[329.179098] Subtest pr-cursor-render: SKIP (0.000s)
[329.220476] [130/156] (691s left) perf_pmu (busy-idle-check-all)
[329.257755] Starting subtest: busy-idle-check-all
[329.258500] Starting dynamic subtest: rcs0
[329.884243] Dynamic subtest rcs0: SUCCESS (0.626s)
[329.897078] Starting dynamic subtest: bcs0
[330.509478] Dynamic subtest bcs0: SUCCESS (0.623s)
[330.521871] Starting dynamic subtest: vcs0
[331.132673] Dynamic subtest vcs0: SUCCESS (0.621s)
[331.144942] Starting dynamic subtest: vcs1
[331.755641] Dynamic subtest vcs1: SUCCESS (0.620s)
[331.766902] Starting dynamic subtest: vecs0
[332.377989] Dynamic subtest vecs0: SUCCESS (0.621s)
[332.379026] Subtest busy-idle-check-all: SUCCESS (3.121s)
[332.447160] [131/156] (688s left) gem_exec_schedule (deep)
[332.612384] Starting subtest: deep
[332.613583] Starting dynamic subtest: rcs0
[340.627731] Dynamic subtest rcs0: SUCCESS (8.006s)
[340.639947] Starting dynamic subtest: bcs0
[348.895859] Dynamic subtest bcs0: SUCCESS (8.257s)
[348.907203] Starting dynamic subtest: vcs0
[357.160475] Dynamic subtest vcs0: SUCCESS (8.271s)
[357.174998] Starting dynamic subtest: vcs1
[365.389981] Dynamic subtest vcs1: SUCCESS (8.229s)
[365.402162] Starting dynamic subtest: vecs0
[373.713871] Dynamic subtest vecs0: SUCCESS (8.322s)
[373.715188] Subtest deep: SUCCESS (41.093s)
[374.136581] [132/156] (646s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[374.228186] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[374.229542] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[374.301644] [133/156] (646s left) kms_fence_pin_leak
[375.830020] [134/156] (644s left) kms_cursor_crc (cursor-sliding-256x256)
[375.937375] Starting subtest: cursor-sliding-256x256
[375.942167] Starting dynamic subtest: pipe-A-HDMI-A-1
[377.784788] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.844s)
[377.822876] Starting dynamic subtest: pipe-D-HDMI-A-1
[379.639146] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.825s)
[379.639960] Subtest cursor-sliding-256x256: SUCCESS (3.702s)
[379.820299] [135/156] (640s left) gem_exec_reloc (basic-range-active)
[379.864538] Starting subtest: basic-range-active
[379.902988] Subtest basic-range-active: SUCCESS (0.038s)
[380.039332] [136/156] (640s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move)
[380.132720] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move
[380.134133] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[380.235983] [137/156] (640s left) kms_color (ctm-0-50)
[380.325303] Starting subtest: ctm-0-50
[380.326016] Starting dynamic subtest: pipe-A-HDMI-A-1
[381.156550] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.830s)
[381.168262] Starting dynamic subtest: pipe-B-HDMI-A-1
[381.955137] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.797s)
[381.965717] Starting dynamic subtest: pipe-C-HDMI-A-1
[382.768955] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.813s)
[382.779529] Starting dynamic subtest: pipe-D-HDMI-A-1
[383.564640] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.795s)
[383.565402] Subtest ctm-0-50: SUCCESS (3.239s)
[383.709231] [138/156] (637s left) gem_exec_balancer (invalid-balancer)
[383.755098] Starting subtest: invalid-balancer
[385.071129] Subtest invalid-balancer: SUCCESS (1.308s)
[385.253533] [139/156] (635s left) kms_cursor_crc (cursor-offscreen-256x256)
[385.348405] Starting subtest: cursor-offscreen-256x256
[385.353249] Starting dynamic subtest: pipe-A-HDMI-A-1
[386.599758] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.246s)
[386.637328] Starting dynamic subtest: pipe-D-HDMI-A-1
[387.857481] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.229s)
[387.858256] Subtest cursor-offscreen-256x256: SUCCESS (2.509s)
[388.044404] [140/156] (632s left) gem_exec_params (no-vebox)
[388.088795] Starting subtest: no-vebox
[388.089511] Subtest no-vebox: SUCCESS (0.001s)
[388.193564] [141/156] (632s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[388.666542] Starting subtest: syncobj-stationary-timeline-chain-engines
[388.729567] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.072s)
[388.908842] [142/156] (632s left) gem_vm_create (isolation)
[388.946228] Starting subtest: isolation
[388.950382] Subtest isolation: SUCCESS (0.004s)
[389.059719] [143/156] (632s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[389.156919] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[389.158350] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[389.255257] [144/156] (631s left) kms_lease (lease-get)
[389.345641] Starting subtest: lease-get
[389.346367] Starting dynamic subtest: pipe-A-HDMI-A-1
[389.347109] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[389.360010] Starting dynamic subtest: pipe-B-HDMI-A-1
[389.360766] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[389.369802] Starting dynamic subtest: pipe-C-HDMI-A-1
[389.370497] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[389.379133] Starting dynamic subtest: pipe-D-HDMI-A-1
[389.379863] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[389.380544] Subtest lease-get: SUCCESS (0.009s)
[389.447768] [145/156] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[389.542617] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[389.544028] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[389.642532] [146/156] (631s left) gem_exec_reloc (basic-cpu-active)
[389.681897] Starting subtest: basic-cpu-active
[389.813546] Subtest basic-cpu-active: SUCCESS (0.123s)
[389.933093] [147/156] (631s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[390.022304] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[390.023054] Starting dynamic subtest: pipe-A
[390.411406] Dynamic subtest pipe-A: SUCCESS (0.389s)
[390.425673] Starting dynamic subtest: pipe-B
[390.852849] Dynamic subtest pipe-B: SUCCESS (0.440s)
[390.863344] Starting dynamic subtest: pipe-C
[391.296395] Dynamic subtest pipe-C: SUCCESS (0.442s)
[391.317443] Starting dynamic subtest: pipe-D
[391.757512] Dynamic subtest pipe-D: SUCCESS (0.460s)
[391.758247] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (1.736s)
[391.948094] [148/156] (629s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[392.057320] Starting subtest: x-tiled-8bpp-rotate-90
[392.140072] Subtest x-tiled-8bpp-rotate-90: SKIP (0.081s)
[392.267951] [149/156] (629s left) gem_pread (snoop)
[392.302499] Starting subtest: snoop
[393.132241] Subtest snoop: SUCCESS (0.830s)
[393.219638] [150/156] (628s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[393.317956] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[393.319360] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[393.404613] [151/156] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[393.499306] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[393.500712] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[393.583149] [152/156] (627s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render)
[393.676632] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render
[393.678119] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[393.773115] [153/156] (627s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[393.866790] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[393.876396] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.009s)
[393.940415] [154/156] (627s left) kms_pm_rpm (system-suspend-modeset)
[395.339670] Starting subtest: system-suspend-modeset
[416.595354] Subtest system-suspend-modeset: SUCCESS (6.037s)
[421.870271] [155/156] (604s left) gem_lmem_swapping (parallel-random-verify)
[421.922495] Subtest parallel-random-verify: SKIP (0.000s)
[421.965573] [156/156] (604s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[422.059705] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[423.232909] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.172s)
[423.364086] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_chamelium_hpd
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: gem_ctx_exec
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_plane_multiple
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: kms_atomic_transition
results: parsing output: 18/ for test: gem_reg_read
results: parsing output: 19/ for test: kms_plane_cursor
results: parsing output: 20/ for test: gem_ctx_create
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: drm_read
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_vblank
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: syncobj_eventfd
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_ctx_engines
results: parsing output: 40/ for test: gem_partial_pwrite_pread
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: prime_mmap_kms
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: core_setmaster
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_ctx_sseu
results: parsing output: 52/ for test: gem_exec_store
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: gem_exec_fence
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gen9_exec_parse
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: sysfs_timeslice_duration
results: parsing output: 66/ for test: gem_lmem_swapping
results: parsing output: 67/ for test: kms_joiner
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: i915_pm_rpm
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_atomic
results: parsing output: 74/ for test: gem_exec_params
results: parsing output: 75/ for test: gem_softpin
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_feature_discovery
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_madvise
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: api_intel_allocator
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: kms_pm_rpm
results: parsing output: 94/ for test: kms_debugfs
results: parsing output: 95/ for test: i915_module_load
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_panel_fitting
results: parsing output: 102/ for test: fbdev
results: parsing output: 103/ for test: gem_ctx_exec
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: gem_pxp
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: intel_hwmon
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_busy
results: parsing output: 125/ for test: gem_render_copy_redux
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_fence_pin_leak
results: parsing output: 133/ for test: kms_cursor_crc
results: parsing output: 134/ for test: gem_exec_reloc
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_color
results: parsing output: 137/ for test: gem_exec_balancer
results: parsing output: 138/ for test: kms_cursor_crc
results: parsing output: 139/ for test: gem_exec_params
results: parsing output: 140/ for test: gem_exec_fence
results: parsing output: 141/ for test: gem_vm_create
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_lease
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_exec_reloc
results: parsing output: 146/ for test: kms_plane_scaling
results: parsing output: 147/ for test: kms_big_fb
results: parsing output: 148/ for test: gem_pread
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: kms_pm_rpm
results: parsing output: 154/ for test: gem_lmem_swapping
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.