[57.643449] Initializing watchdogs
[57.643495]   /dev/watchdog0
[57.657673] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.661697] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.663752] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.667141] [001/133] (960s left) kms_selftest (drm_format_helper)
[57.719258] Starting subtest: drm_format_helper
[57.729110] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[57.824229] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.095s)
[57.832750] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[57.934331] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.111s)
[57.943193] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[58.035425] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.101s)
[58.043322] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[58.140968] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.105s)
[58.149410] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[58.233428] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.090s)
[58.241962] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[58.339337] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.106s)
[58.347845] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[58.424351] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.086s)
[58.432661] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[58.514371] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.089s)
[58.522868] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[58.606921] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.094s)
[58.617311] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[58.703191] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.094s)
[58.710453] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[58.784150] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.081s)
[58.790400] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[58.872646] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.088s)
[58.879252] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[58.963390] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.092s)
[58.969962] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[59.057997] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.093s)
[59.064028] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[59.160435] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.103s)
[59.167399] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[59.253557] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.092s)
[59.259534] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[59.355095] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.102s)
[59.356656] Subtest drm_format_helper: SUCCESS (1.636s)
[59.493820] [002/133] (958s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[59.558264] Subtest tiled-to-tiled: SKIP (0.000s)
[59.618541] [003/133] (958s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[59.700732] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[59.702718] Starting dynamic subtest: pipe-A-default-mode
[62.425929] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[62.428404] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.728s)
[63.258185] [004/133] (955s left) prime_mmap (test_correct_cpu_write)
[63.312992] Starting subtest: test_correct_cpu_write
[63.315073] Starting dynamic subtest: test_correct_cpu_write-smem
[63.317104] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[63.319125] Subtest test_correct_cpu_write: SUCCESS (0.000s)
[63.438123] [005/133] (954s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[63.494782] Starting subtest: y-tiled-ccs-to-y-tiled
[63.499522] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[63.668091] [006/133] (954s left) sysfs_heartbeat_interval (nopreempt)
[63.733894] Starting subtest: nopreempt
[63.736240] Starting dynamic subtest: vecs0
[72.854238] Dynamic subtest vecs0: SUCCESS (9.124s)
[72.864934] Starting dynamic subtest: ccs0
[76.677054] Dynamic subtest ccs0: SUCCESS (3.821s)
[76.688288] Starting dynamic subtest: vcs0
[85.846482] Dynamic subtest vcs0: SUCCESS (9.166s)
[85.856730] Starting dynamic subtest: bcs0
[89.682996] Dynamic subtest bcs0: SUCCESS (3.840s)
[89.692831] Starting dynamic subtest: rcs0
[93.665884] Dynamic subtest rcs0: SUCCESS (3.982s)
[93.681964] Starting dynamic subtest: vcs1
[102.871529] Dynamic subtest vcs1: SUCCESS (9.203s)
[102.874214] Subtest nopreempt: SUCCESS (39.142s)
[102.946301] [007/133] (915s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[103.039246] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[103.041653] Starting dynamic subtest: pipe-A-eDP-1
[103.066030] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.076191] Starting dynamic subtest: pipe-B-eDP-1
[103.097304] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.104530] Starting dynamic subtest: pipe-C-eDP-1
[103.125995] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.133020] Starting dynamic subtest: pipe-D-eDP-1
[103.154722] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.159207] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[105.315955] [008/133] (913s left) gem_ctx_param (set-priority-not-supported)
[105.368684] Starting subtest: set-priority-not-supported
[105.373108] Subtest set-priority-not-supported: SKIP (0.000s)
[105.440114] [009/133] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[105.524661] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[105.529120] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[105.626402] [010/133] (912s left) syncobj_timeline (reset-during-wait-for-submit)
[105.674949] Starting subtest: reset-during-wait-for-submit
[105.777479] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[105.863604] [011/133] (912s left) kms_pm_dc (dc5-dpms-negative)
[106.935704] Starting subtest: dc5-dpms-negative
[106.940200] Subtest dc5-dpms-negative: SKIP (0.000s)
[107.005172] [012/133] (911s left) kms_psr (fbc-pr-suspend)
[107.081718] Starting subtest: fbc-pr-suspend
[107.086263] Subtest fbc-pr-suspend: SKIP (0.000s)
[107.151300] [013/133] (911s left) kms_content_protection (atomic)
[107.265076] Starting subtest: atomic
[107.269612] Subtest atomic: SKIP (0.000s)
[107.420991] [014/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[107.514680] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[107.518652] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[107.636888] [015/133] (911s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[107.713257] Starting subtest: 4-tiled-32bpp-rotate-90
[107.732762] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[107.843574] [016/133] (910s left) fbdev (unaligned-write)
[107.889670] Starting subtest: unaligned-write
[107.991683] Subtest unaligned-write: SUCCESS (0.102s)
[108.049549] [017/133] (910s left) i915_query (query-regions-sanity-check)
[108.103224] Starting subtest: query-regions-sanity-check
[108.116014] Subtest query-regions-sanity-check: SUCCESS (0.015s)
[108.243321] [018/133] (910s left) gem_exec_schedule (preempt-queue-chain)
[108.321981] Subtest preempt-queue-chain: SKIP (0.000s)
[108.609112] [019/133] (910s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[108.698305] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[108.702222] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[108.788728] [020/133] (910s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[108.880433] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[108.882810] Starting dynamic subtest: pipe-A-eDP-1
[108.941310] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[108.950506] Starting dynamic subtest: pipe-B-eDP-1
[109.008102] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[109.020175] Starting dynamic subtest: pipe-C-eDP-1
[109.076398] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[109.085463] Starting dynamic subtest: pipe-D-eDP-1
[109.144050] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[109.148255] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[111.157726] [021/133] (907s left) gem_userptr_blits (process-exit)
[111.226486] Starting subtest: process-exit
[111.234316] Subtest process-exit: SUCCESS (0.009s)
[111.361204] [022/133] (907s left) gem_tiled_partial_pwrite_pread (writes)
[111.412832] Subtest writes: SKIP (0.000s)
[111.467135] [023/133] (907s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[111.540009] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[111.542423] Starting dynamic subtest: pipe-A
[112.634489] Dynamic subtest pipe-A: SUCCESS (1.096s)
[112.643885] Starting dynamic subtest: pipe-B
[114.797902] Dynamic subtest pipe-B: SUCCESS (2.163s)
[114.806462] Starting dynamic subtest: pipe-C
[115.961331] Dynamic subtest pipe-C: SUCCESS (1.162s)
[115.970704] Starting dynamic subtest: pipe-D
[117.115876] Dynamic subtest pipe-D: SUCCESS (1.154s)
[117.118215] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.577s)
[118.302538] [024/133] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[118.402306] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[125.411142] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.010s)
[125.512316] [025/133] (893s left) perf (global-sseu-config)
[125.646364] Starting subtest: global-sseu-config
[125.650069] Subtest global-sseu-config: SKIP (0.000s)
[125.687781] [026/133] (893s left) gen9_exec_parse (allowed-single)
[125.745238] Subtest allowed-single: SKIP (0.000s)
[125.814826] [027/133] (893s left) gem_ringfill (engines-basic)
[131.866999] Starting subtest: engines-basic
[131.869637] Starting dynamic subtest: rcs0
[131.936084] Dynamic subtest rcs0: SUCCESS (0.069s)
[131.949073] Starting dynamic subtest: bcs0
[131.981032] Dynamic subtest bcs0: SUCCESS (0.044s)
[131.990607] Starting dynamic subtest: vcs0
[132.023121] Dynamic subtest vcs0: SUCCESS (0.041s)
[132.032249] Starting dynamic subtest: vcs1
[132.067038] Dynamic subtest vcs1: SUCCESS (0.042s)
[132.076652] Starting dynamic subtest: vecs0
[132.110490] Dynamic subtest vecs0: SUCCESS (0.042s)
[132.120193] Starting dynamic subtest: ccs0
[132.155802] Dynamic subtest ccs0: SUCCESS (0.044s)
[132.158235] Subtest engines-basic: SUCCESS (0.291s)
[132.230204] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[132.233502] [028/133] (886s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[132.324485] Starting subtest: 2x-absolute-wf_vblank-interruptible
[132.334590] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.008s)
[132.408873] [029/133] (886s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[132.495452] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[139.358892] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.865s)
[139.474322] [030/133] (879s left) kms_big_fb (linear-8bpp-rotate-90)
[139.554731] Starting subtest: linear-8bpp-rotate-90
[139.576833] Subtest linear-8bpp-rotate-90: SKIP (0.022s)
[139.690624] [031/133] (879s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[139.792957] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[141.308643] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.514s)
[142.106743] [032/133] (877s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[142.180753] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[142.183063] Starting dynamic subtest: pipe-A-default-mode
[144.929846] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s)
[144.931799] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.748s)
[145.794275] [033/133] (873s left) gem_userptr_blits (sd-probe)
[145.859451] Starting subtest: sd-probe
[145.861421] Subtest sd-probe: SUCCESS (0.000s)
[146.021719] [034/133] (873s left) gem_mmap_gtt (cpuset-big-copy)
[146.074553] Subtest cpuset-big-copy: SKIP (0.000s)
[146.140961] [035/133] (873s left) kms_cursor_crc (cursor-size-hints)
[146.260698] Starting subtest: cursor-size-hints
[146.263057] Starting dynamic subtest: pipe-A-eDP-1
[146.880969] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s)
[146.888829] Starting dynamic subtest: pipe-D-eDP-1
[148.165276] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s)
[148.167608] Subtest cursor-size-hints: SUCCESS (1.905s)
[148.965645] [036/133] (870s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[149.031969] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[149.034294] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[149.145897] [037/133] (870s left) kms_lease (lessee-list)
[149.218739] Starting subtest: lessee-list
[149.221254] Starting dynamic subtest: pipe-A-eDP-1
[149.223705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[149.240668] Starting dynamic subtest: pipe-B-eDP-1
[149.242828] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[149.260274] Starting dynamic subtest: pipe-C-eDP-1
[149.262273] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[149.271666] Starting dynamic subtest: pipe-D-eDP-1
[149.273595] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[149.275934] Subtest lessee-list: SUCCESS (0.008s)
[149.335140] [038/133] (870s left) core_auth (getclient-master-drop)
[149.365799] Starting subtest: getclient-master-drop
[149.384280] Subtest getclient-master-drop: SUCCESS (0.018s)
[149.478940] [039/133] (870s left) kms_getfb (getfb-handle-closed)
[149.552708] Starting subtest: getfb-handle-closed
[149.554945] Subtest getfb-handle-closed: SUCCESS (0.000s)
[149.661520] [040/133] (870s left) gem_userptr_blits (unsync-unmap-after-close)
[149.741314] Subtest unsync-unmap-after-close: SKIP (0.000s)
[149.869174] [041/133] (869s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[149.942688] Starting subtest: fbcpsr-indfb-scaledprimary
[155.720715] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.782s)
[155.859551] [042/133] (863s left) kms_pm_rpm (modeset-pc8-residency-stress)
[157.961777] Starting subtest: modeset-pc8-residency-stress
[157.966625] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[158.341526] [043/133] (861s left) i915_pm_freq_mult (media-freq)
[158.398174] Starting subtest: media-freq
[158.400435] Starting dynamic subtest: gt0
[158.404570] Dynamic subtest gt0: SKIP (0.000s)
[158.413277] Starting dynamic subtest: gt1
[158.417272] Dynamic subtest gt1: SKIP (0.000s)
[158.421223] Subtest media-freq: SKIP (0.001s)
[158.497972] [044/133] (861s left) gem_ctx_shared (q-promotion)
[158.554964] Starting subtest: Q-promotion
[158.557230] Starting dynamic subtest: rcs0
[158.657524] Dynamic subtest rcs0: SUCCESS (0.102s)
[158.670563] Starting dynamic subtest: vcs0
[158.742945] Dynamic subtest vcs0: SUCCESS (0.085s)
[158.758227] Starting dynamic subtest: vcs1
[158.821842] Dynamic subtest vcs1: SUCCESS (0.078s)
[158.837118] Starting dynamic subtest: vecs0
[158.899531] Dynamic subtest vecs0: SUCCESS (0.077s)
[158.914696] Starting dynamic subtest: ccs0
[158.989607] Dynamic subtest ccs0: SUCCESS (0.089s)
[158.991942] Subtest Q-promotion: SUCCESS (0.435s)
[159.926854] [045/133] (860s left) syncobj_timeline (signal-array)
[159.987185] Starting subtest: signal-array
[159.989315] Subtest signal-array: SUCCESS (0.000s)
[160.075885] [046/133] (859s left) gem_ctx_freq (sysfs)
[160.136543] Starting subtest: sysfs
[160.138849] Starting dynamic subtest: gt0
[165.655342] Dynamic subtest gt0: SUCCESS (5.518s)
[165.665650] Starting dynamic subtest: gt1
[206.874472] Dynamic subtest gt1: SUCCESS (41.214s)
[206.877056] Subtest sysfs: SUCCESS (46.735s)
[207.006367] [047/133] (813s left) gem_create (create-clear)
[207.068431] Starting subtest: create-clear
[207.070844] Starting dynamic subtest: smem0
[239.486245] Dynamic subtest smem0: SUCCESS (32.418s)
[239.488438] Subtest create-clear: SUCCESS (32.418s)
[239.689388] [048/133] (780s left) vgem_basic (sysfs)
[239.741177] Starting subtest: sysfs
[239.743134] Subtest sysfs: SUCCESS (0.000s)
[239.799543] [049/133] (780s left) kms_async_flips (crc-atomic)
[239.884238] Starting subtest: crc-atomic
[240.266611] Starting dynamic subtest: pipe-A-eDP-1
[243.146584] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.881s)
[243.534957] Starting dynamic subtest: pipe-B-eDP-1
[246.474307] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.947s)
[246.870061] Starting dynamic subtest: pipe-C-eDP-1
[249.777557] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.916s)
[250.153656] Starting dynamic subtest: pipe-D-eDP-1
[253.036653] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.897s)
[253.039153] Subtest crc-atomic: SUCCESS (13.154s)
[254.297577] [050/133] (765s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[254.374052] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[260.971348] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.599s)
[261.106904] [051/133] (759s left) kms_plane_alpha_blend (alpha-7efc)
[261.183090] Starting subtest: alpha-7efc
[261.457582] Starting dynamic subtest: pipe-A-eDP-1
[262.061770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[262.088325] Starting dynamic subtest: pipe-D-eDP-1
[263.353601] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.272s)
[263.355850] Subtest alpha-7efc: SUCCESS (2.172s)
[264.189135] [052/133] (756s left) kms_joiner (invalid-modeset-big-joiner)
[264.272799] Starting subtest: invalid-modeset-big-joiner
[264.277438] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[264.337416] [053/133] (755s left) kms_color (ctm-signed)
[264.410978] Starting subtest: ctm-signed
[264.413560] Starting dynamic subtest: pipe-A-eDP-1
[266.479817] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.067s)
[266.489535] Starting dynamic subtest: pipe-B-eDP-1
[269.337656] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.858s)
[269.347233] Starting dynamic subtest: pipe-C-eDP-1
[272.051055] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.712s)
[272.060263] Starting dynamic subtest: pipe-D-eDP-1
[274.690671] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.641s)
[274.692950] Subtest ctm-signed: SUCCESS (10.281s)
[275.523660] [054/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[275.602653] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[275.607185] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[275.694502] [055/133] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[275.769408] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[275.773960] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[275.863071] [056/133] (744s left) gem_userptr_blits (usage-restrictions)
[275.934109] Starting subtest: usage-restrictions
[275.936457] Subtest usage-restrictions: SUCCESS (0.000s)
[276.066583] [057/133] (744s left) gem_pxp (verify-pxp-stale-ctx-execution)
[276.195079] Starting subtest: verify-pxp-stale-ctx-execution
[277.256545] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.063s)
[277.370962] [058/133] (743s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[277.453616] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[277.457667] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[277.563975] [059/133] (742s left) gem_ctx_persistence (heartbeat-hang)
[277.628933] Starting subtest: heartbeat-hang
[277.633653] Subtest heartbeat-hang: SKIP (0.000s)
[277.728478] [060/133] (742s left) kms_chamelium_color (ctm-blue-to-red)
[277.792022] Subtest ctm-blue-to-red: SKIP (0.000s)
[277.834907] [061/133] (742s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[277.911815] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[284.098908] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.192s)
[285.234924] [062/133] (735s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[285.308211] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[285.310407] Starting dynamic subtest: pipe-A-eDP-1
[285.393623] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[285.403821] Starting dynamic subtest: pipe-B-eDP-1
[286.488954] Dynamic subtest pipe-B-eDP-1: SKIP (1.093s)
[286.493419] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.184s)
[287.674258] [063/133] (733s left) kms_cursor_legacy (torture-move)
[287.778485] Starting subtest: torture-move
[287.780299] Starting dynamic subtest: pipe-A
[293.759321] Dynamic subtest pipe-A: SUCCESS (5.977s)
[293.777554] Starting dynamic subtest: pipe-B
[300.797791] Dynamic subtest pipe-B: SUCCESS (7.038s)
[300.809172] Starting dynamic subtest: pipe-C
[307.885059] Dynamic subtest pipe-C: SUCCESS (7.082s)
[307.896641] Starting dynamic subtest: pipe-D
[317.264485] Dynamic subtest pipe-D: SUCCESS (9.377s)
[317.276971] Starting dynamic subtest: all-pipes
[324.973897] Dynamic subtest all-pipes: SUCCESS (7.708s)
[324.976495] Subtest torture-move: SUCCESS (37.194s)
[325.131420] [064/133] (695s left) api_intel_bb (blit-noreloc-keep-cache)
[325.207067] Starting subtest: blit-noreloc-keep-cache
[325.217579] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[325.332517] [065/133] (695s left) kms_vblank (wait-idle-hang)
[325.423653] Starting subtest: wait-idle-hang
[325.425753] Starting dynamic subtest: pipe-A-eDP-1
[351.682013] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.254s)
[351.695497] Starting dynamic subtest: pipe-D-eDP-1
[376.707532] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.022s)
[376.709513] Subtest wait-idle-hang: SUCCESS (51.281s)
[377.527015] [066/133] (643s left) gem_userptr_blits (process-exit-busy)
[377.603272] Starting subtest: process-exit-busy
[377.615444] Subtest process-exit-busy: SUCCESS (0.014s)
[377.739919] [067/133] (643s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[377.816537] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[377.820968] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[377.922888] [068/133] (642s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[378.023957] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[378.027947] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[378.133693] [069/133] (642s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[378.208118] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[378.234893] Starting dynamic subtest: pipe-A-plane-0
[378.523104] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[378.533862] Starting dynamic subtest: pipe-A-plane-3
[378.767693] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s)
[379.909116] Starting dynamic subtest: pipe-B-plane-0
[380.201823] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[380.211906] Starting dynamic subtest: pipe-B-plane-3
[380.435108] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[380.754462] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.546s)
[381.590154] [070/133] (639s left) core_setmaster (master-drop-set-user)
[381.682652] Starting subtest: master-drop-set-user
[381.693402] Subtest master-drop-set-user: SUCCESS (0.013s)
[381.730760] [071/133] (639s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[381.801850] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[381.804086] Starting dynamic subtest: pipe-A-eDP-1
[381.827107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[381.841803] Starting dynamic subtest: pipe-B-eDP-1
[381.870814] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[381.884315] Starting dynamic subtest: pipe-C-eDP-1
[381.903895] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[381.913440] Starting dynamic subtest: pipe-D-eDP-1
[381.932591] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[381.934662] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s)
[384.054306] [072/133] (637s left) kms_flip (2x-flip-vs-wf_vblank)
[384.127853] Starting subtest: 2x-flip-vs-wf_vblank
[384.135074] Subtest 2x-flip-vs-wf_vblank: SKIP (0.007s)
[384.233998] [073/133] (636s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[384.322515] Starting subtest: y-tiled-32bpp-rotate-90
[384.326958] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[384.418309] [074/133] (636s left) kms_setmode (invalid-clone-exclusive-crtc)
[384.472612] Starting subtest: invalid-clone-exclusive-crtc
[384.479038] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[384.555644] [075/133] (636s left) kms_psr (pr-cursor-blt)
[384.619875] Starting subtest: pr-cursor-blt
[384.624158] Subtest pr-cursor-blt: SKIP (0.000s)
[384.695505] [076/133] (636s left) kms_getfb (getfb-repeated-different-handles)
[384.770862] Starting subtest: getfb-repeated-different-handles
[384.773167] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[384.888569] [077/133] (636s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[384.971499] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[385.962045] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.990s)
[386.084523] [078/133] (635s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[386.157854] Starting subtest: primary-4-tiled-reflect-x-180
[393.167511] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.009s)
[394.315255] [079/133] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[394.404538] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[401.780374] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.381s)
[401.924733] [080/133] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[402.013179] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[406.197664] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.189s)
[407.354479] [081/133] (614s left) gem_mmap_offset (bad-object)
[407.406257] Starting subtest: bad-object
[407.408477] Subtest bad-object: SUCCESS (0.001s)
[407.523984] [082/133] (613s left) syncobj_timeline (invalid-query-illegal-handle)
[407.586163] Starting subtest: invalid-query-illegal-handle
[407.588499] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[407.713929] [083/133] (613s left) prime_vgem (fence-wait)
[407.794500] Starting subtest: fence-wait
[407.796524] Starting dynamic subtest: rcs0
[408.842326] Dynamic subtest rcs0: SUCCESS (1.047s)
[408.851199] Starting dynamic subtest: bcs0
[409.899706] Dynamic subtest bcs0: SUCCESS (1.057s)
[409.909255] Starting dynamic subtest: vcs0
[410.947043] Dynamic subtest vcs0: SUCCESS (1.045s)
[410.955897] Starting dynamic subtest: vcs1
[411.989210] Dynamic subtest vcs1: SUCCESS (1.039s)
[411.999491] Starting dynamic subtest: vecs0
[413.026799] Dynamic subtest vecs0: SUCCESS (1.037s)
[413.038958] Starting dynamic subtest: ccs0
[414.071091] Dynamic subtest ccs0: SUCCESS (1.042s)
[414.074086] Subtest fence-wait: SUCCESS (6.277s)
[414.212734] [084/133] (607s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[414.313595] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[414.315832] Starting dynamic subtest: pipe-A-eDP-1
[420.224745] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.918s)
[420.236982] Starting dynamic subtest: pipe-B-eDP-1
[426.873809] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.648s)
[426.876038] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.568s)
[427.751847] [085/133] (593s left) i915_module_load (reload-no-display)
[427.787464] Starting subtest: reload-no-display
[433.708231] Subtest reload-no-display: SUCCESS (5.921s)
[433.737570] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[433.738279] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[433.741362] [086/133] (587s left) testdisplay
[435.454410] [FACT testdisplay] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[435.455533] [FACT testdisplay] new: kernel.kmod_is_loaded.i915: true
[435.461189] [087/133] (586s left) gem_mmap_offset (pf-nonblock)
[435.519690] Starting subtest: pf-nonblock
[435.525056] Subtest pf-nonblock: SUCCESS (0.007s)
[435.641640] [088/133] (586s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[435.719938] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[435.724377] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[435.815224] [089/133] (585s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[435.900074] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[440.000922] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.104s)
[441.240440] [090/133] (580s left) prime_mmap_coherency (ioctl-errors)
[441.294095] Starting subtest: ioctl-errors
[455.268829] Subtest ioctl-errors: SUCCESS (13.976s)
[455.484575] [091/133] (566s left) gem_userptr_blits (unsync-unmap-cycles)
[455.596839] Subtest unsync-unmap-cycles: SKIP (0.000s)
[455.730968] [092/133] (566s left) kms_chamelium_frames (hdmi-frame-dump)
[456.099397] Subtest hdmi-frame-dump: SKIP (0.000s)
[456.914439] [093/133] (565s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[456.989904] Starting subtest: plane-upscale-20x20-with-rotation
[456.992322] Starting dynamic subtest: pipe-A
[457.224744] Dynamic subtest pipe-A: SUCCESS (0.236s)
[457.234618] Starting dynamic subtest: pipe-B
[458.504293] Dynamic subtest pipe-B: SUCCESS (1.278s)
[458.513124] Starting dynamic subtest: pipe-C
[459.828055] Dynamic subtest pipe-C: SUCCESS (1.323s)
[459.837095] Starting dynamic subtest: pipe-D
[461.160061] Dynamic subtest pipe-D: SUCCESS (1.331s)
[461.162418] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.172s)
[462.335248] [094/133] (559s left) kms_psr (psr2-primary-page-flip)
[462.412030] Starting subtest: psr2-primary-page-flip
[462.414232] Starting dynamic subtest: eDP-1
[464.125944] Dynamic subtest eDP-1: SUCCESS (1.712s)
[464.128291] Subtest psr2-primary-page-flip: SUCCESS (1.713s)
[464.988411] [095/133] (557s left) gem_exec_whisper (basic-contexts-priority-all)
[465.046702] Starting subtest: basic-contexts-priority-all
[487.811458] Subtest basic-contexts-priority-all: SUCCESS (22.762s)
[487.992442] [096/133] (534s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[488.069078] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[488.440541] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[491.168581] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.726s)
[491.179465] Starting dynamic subtest: pipe-A-eDP-1-4
[493.344071] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[493.356324] Starting dynamic subtest: pipe-A-eDP-1-4
[495.352994] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[495.365087] Starting dynamic subtest: pipe-A-eDP-1-x
[497.543379] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[497.909613] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[500.701290] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[500.714096] Starting dynamic subtest: pipe-B-eDP-1-4
[502.898277] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[502.910425] Starting dynamic subtest: pipe-B-eDP-1-4
[504.907678] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[504.919657] Starting dynamic subtest: pipe-B-eDP-1-x
[507.109599] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[507.485311] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[510.231104] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[510.240321] Starting dynamic subtest: pipe-C-eDP-1-4
[512.407043] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[512.418076] Starting dynamic subtest: pipe-C-eDP-1-4
[514.417094] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[514.427025] Starting dynamic subtest: pipe-C-eDP-1-x
[516.606969] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[516.974924] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[519.764118] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.795s)
[519.773656] Starting dynamic subtest: pipe-D-eDP-1-4
[521.936779] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.172s)
[521.949463] Starting dynamic subtest: pipe-D-eDP-1-4
[523.947220] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[523.959711] Starting dynamic subtest: pipe-D-eDP-1-x
[526.125650] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[526.127861] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.055s)
[527.358262] [097/133] (494s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[527.443757] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[527.447890] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[527.523650] [098/133] (494s left) gem_exec_reloc (basic-write-wc-noreloc)
[527.583053] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[527.649227] [099/133] (494s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[527.721306] Starting subtest: fbcpsr-tiling-linear
[534.385381] Subtest fbcpsr-tiling-linear: SUCCESS (6.667s)
[534.498477] [100/133] (487s left) kms_flip (flip-vs-fences-interruptible)
[534.568346] Starting subtest: flip-vs-fences-interruptible
[534.572782] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[534.672740] [101/133] (487s left) gem_exec_schedule (smoketest)
[534.870932] Starting subtest: smoketest
[534.873369] Starting dynamic subtest: rcs0
[540.429430] Dynamic subtest rcs0: SUCCESS (5.508s)
[540.440384] Starting dynamic subtest: bcs0
[545.952607] Dynamic subtest bcs0: SUCCESS (5.520s)
[545.966102] Starting dynamic subtest: vcs0
[551.453529] Dynamic subtest vcs0: SUCCESS (5.499s)
[551.466238] Starting dynamic subtest: vcs1
[556.954438] Dynamic subtest vcs1: SUCCESS (5.499s)
[556.970398] Starting dynamic subtest: vecs0
[562.454295] Dynamic subtest vecs0: SUCCESS (5.499s)
[562.466231] Starting dynamic subtest: ccs0
[567.949034] Dynamic subtest ccs0: SUCCESS (5.494s)
[567.951491] Subtest smoketest: SUCCESS (33.029s)
[568.090135] [102/133] (454s left) kms_properties (get_properties-sanity-atomic)
[568.169020] Starting subtest: get_properties-sanity-atomic
[568.171427] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[568.246819] [103/133] (454s left) gem_exec_fence (nb-await)
[568.422267] Starting subtest: nb-await
[568.424450] Starting dynamic subtest: rcs0
[568.489229] Dynamic subtest rcs0: SUCCESS (0.069s)
[568.500232] Starting dynamic subtest: bcs0
[568.548350] Dynamic subtest bcs0: SUCCESS (0.057s)
[568.558855] Starting dynamic subtest: vcs0
[568.607872] Dynamic subtest vcs0: SUCCESS (0.058s)
[568.619074] Starting dynamic subtest: vcs1
[568.666709] Dynamic subtest vcs1: SUCCESS (0.057s)
[568.677803] Starting dynamic subtest: vecs0
[568.727285] Dynamic subtest vecs0: SUCCESS (0.058s)
[568.738672] Starting dynamic subtest: ccs0
[568.785793] Dynamic subtest ccs0: SUCCESS (0.056s)
[568.788194] Subtest nb-await: SUCCESS (0.368s)
[570.916818] [104/133] (451s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[571.014870] Starting subtest: yf-tiled-8bpp-rotate-180
[571.019383] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[571.111501] [105/133] (451s left) gem_exec_params (batch-first)
[571.166574] Starting subtest: batch-first
[571.172422] Subtest batch-first: SUCCESS (0.006s)
[571.289216] [106/133] (451s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[571.359657] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[571.427137] [107/133] (451s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[571.496749] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[571.501298] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[571.569269] [108/133] (450s left) gem_exec_reloc (basic-concurrent16)
[571.636532] Subtest basic-concurrent16: SKIP (0.000s)
[571.708885] [109/133] (450s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[571.789414] Starting subtest: x-tiled-16bpp-rotate-270
[571.808589] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[571.906642] [110/133] (450s left) gem_exec_create (legacy)
[571.979786] Starting subtest: legacy
[571.981770] Starting dynamic subtest: smem
[575.769564] Dynamic subtest smem: SUCCESS (3.787s)
[575.772233] Subtest legacy: SUCCESS (3.789s)
[575.954602] [111/133] (446s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[576.332403] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[577.107429] [112/133] (445s left) gem_spin_batch (spin-all-new)
[577.163260] Starting subtest: spin-all-new
[577.182584] Subtest spin-all-new: SUCCESS (0.019s)
[578.817369] [113/133] (443s left) gem_exec_whisper (basic-queues-forked)
[578.878266] Starting subtest: basic-queues-forked
[601.969284] Subtest basic-queues-forked: SUCCESS (23.088s)
[602.169769] [114/133] (420s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[602.229393] Starting subtest: single-wait-for-submit-unsubmitted
[602.331844] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[602.436830] [115/133] (420s left) perf_pmu (idle-no-semaphores)
[602.479402] Starting subtest: idle-no-semaphores
[602.481700] Starting dynamic subtest: rcs0
[603.029663] Dynamic subtest rcs0: SUCCESS (0.549s)
[603.041903] Starting dynamic subtest: bcs0
[603.551419] Dynamic subtest bcs0: SUCCESS (0.519s)
[603.564178] Starting dynamic subtest: vcs0
[604.075890] Dynamic subtest vcs0: SUCCESS (0.520s)
[604.088787] Starting dynamic subtest: vcs1
[604.596985] Dynamic subtest vcs1: SUCCESS (0.519s)
[604.609805] Starting dynamic subtest: vecs0
[605.118241] Dynamic subtest vecs0: SUCCESS (0.518s)
[605.131840] Starting dynamic subtest: ccs0
[605.638051] Dynamic subtest ccs0: SUCCESS (0.517s)
[605.640941] Subtest idle-no-semaphores: SUCCESS (3.159s)
[605.740328] [116/133] (417s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[605.842454] Starting subtest: cursorB-vs-flipA-atomic
[605.847058] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[605.987858] [117/133] (416s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[606.062532] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[606.067051] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[606.155924] [118/133] (416s left) kms_frontbuffer_tracking (basic)
[606.228903] Starting subtest: basic
[609.418354] Subtest basic: SUCCESS (3.193s)
[609.531735] [119/133] (413s left) kms_cursor_edge_walk (256x256-right-edge)
[609.619159] Starting subtest: 256x256-right-edge
[609.621055] Starting dynamic subtest: pipe-A-eDP-1
[613.085562] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s)
[613.096217] Starting dynamic subtest: pipe-D-eDP-1
[616.211083] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[616.213370] Subtest 256x256-right-edge: SUCCESS (6.591s)
[617.009476] [120/133] (406s left) syncobj_eventfd (timeline-wait)
[617.074499] Starting subtest: timeline-wait
[617.083098] Subtest timeline-wait: SUCCESS (0.011s)
[617.172686] [121/133] (405s left) kms_cursor_crc (cursor-onscreen-32x32)
[617.298594] Starting subtest: cursor-onscreen-32x32
[617.344920] Subtest cursor-onscreen-32x32: SKIP (0.041s)
[617.611902] [122/133] (405s left) i915_drm_fdinfo (memory-info-resident)
[617.658416] Starting subtest: memory-info-resident
[617.660654] Starting dynamic subtest: smem0
[620.618935] Dynamic subtest smem0: SUCCESS (2.963s)
[620.620993] Subtest memory-info-resident: SUCCESS (2.964s)
[620.694053] [123/133] (402s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[620.772135] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[620.775686] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[620.878477] [124/133] (402s left) kms_plane_cursor (viewport)
[620.949095] Starting subtest: viewport
[620.953299] Starting dynamic subtest: pipe-A-eDP-1-size-64
[623.383758] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.435s)
[623.444584] Starting dynamic subtest: pipe-A-eDP-1-size-128
[625.918069] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.483s)
[625.979910] Starting dynamic subtest: pipe-A-eDP-1-size-256
[628.407974] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.438s)
[628.755326] Starting dynamic subtest: pipe-B-eDP-1-size-64
[631.897498] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.151s)
[631.959037] Starting dynamic subtest: pipe-B-eDP-1-size-128
[634.431613] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[634.493089] Starting dynamic subtest: pipe-B-eDP-1-size-256
[636.910400] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.426s)
[637.267125] Starting dynamic subtest: pipe-C-eDP-1-size-64
[640.039558] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.783s)
[640.077962] Starting dynamic subtest: pipe-C-eDP-1-size-128
[642.172503] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.103s)
[642.210204] Starting dynamic subtest: pipe-C-eDP-1-size-256
[644.295537] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.092s)
[644.635067] Starting dynamic subtest: pipe-D-eDP-1-size-64
[647.454495] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.830s)
[647.492795] Starting dynamic subtest: pipe-D-eDP-1-size-128
[649.588451] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.103s)
[649.626049] Starting dynamic subtest: pipe-D-eDP-1-size-256
[651.655422] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.036s)
[651.974231] Subtest viewport: SUCCESS (31.025s)
[652.834127] [125/133] (370s left) kms_psr (fbc-psr-sprite-blt)
[652.911406] Starting subtest: fbc-psr-sprite-blt
[652.913728] Starting dynamic subtest: eDP-1
[652.917895] Dynamic subtest eDP-1: SKIP (0.000s)
[652.922468] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[652.988595] [126/133] (370s left) syncobj_wait (wait-for-submit-delayed-submit)
[653.046052] Starting subtest: wait-for-submit-delayed-submit
[653.147438] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[653.238721] [127/133] (370s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[653.318298] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[653.320580] Starting dynamic subtest: pipe-A-eDP-1
[653.343666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[653.357128] Starting dynamic subtest: pipe-B-eDP-1
[653.378118] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[653.387061] Starting dynamic subtest: pipe-C-eDP-1
[653.408874] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[653.417660] Starting dynamic subtest: pipe-D-eDP-1
[653.439325] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[653.443737] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[655.592524] [128/133] (367s left) kms_draw_crc (draw-method-mmap-wc)
[655.655711] Starting subtest: draw-method-mmap-wc
[655.657620] Starting dynamic subtest: xrgb8888-untiled
[655.881883] Dynamic subtest xrgb8888-untiled: SUCCESS (0.227s)
[655.890949] Starting dynamic subtest: rgb565-untiled
[656.081317] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[656.093313] Starting dynamic subtest: xrgb2101010-untiled
[656.292857] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[656.304205] Starting dynamic subtest: xbgr16161616f-untiled
[656.493060] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[656.502282] Starting dynamic subtest: xrgb8888-xtiled
[656.625753] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[656.635045] Starting dynamic subtest: rgb565-xtiled
[656.759031] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[656.768402] Starting dynamic subtest: xrgb2101010-xtiled
[656.870304] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[656.879200] Starting dynamic subtest: xbgr16161616f-xtiled
[656.992860] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[657.001721] Starting dynamic subtest: xrgb8888-4tiled
[657.148056] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[657.157709] Starting dynamic subtest: rgb565-4tiled
[657.281383] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[657.290850] Starting dynamic subtest: xrgb2101010-4tiled
[657.414825] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[657.424198] Starting dynamic subtest: xbgr16161616f-4tiled
[657.581534] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[657.583363] Subtest draw-method-mmap-wc: SUCCESS (1.928s)
[657.666442] [129/133] (365s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[657.739968] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[657.743358] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[657.832467] [130/133] (365s left) prime_mmap_coherency (read)
[657.886562] Starting subtest: read
[663.260690] Subtest read: SUCCESS (5.375s)
[663.366610] [131/133] (360s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[663.432736] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[663.507213] [132/133] (360s left) gem_exec_balancer (bonded-dual)
[663.571427] Starting subtest: bonded-dual
[663.576095] Subtest bonded-dual: SKIP (0.000s)
[663.867603] [133/133] (359s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[663.950965] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[663.955472] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[664.041250] Closing watchdogs
results: parsing output: 0/ for test: kms_selftest
results: parsing output: 1/ for test: gem_set_tiling_vs_blt
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: prime_mmap
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: sysfs_heartbeat_interval
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_ctx_param
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_pm_dc
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: fbdev
results: parsing output: 16/ for test: i915_query
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: gen9_exec_parse
results: parsing output: 26/ for test: gem_ringfill
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_lease
results: parsing output: 37/ for test: core_auth
results: parsing output: 38/ for test: kms_getfb
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: i915_pm_freq_mult
results: parsing output: 43/ for test: gem_ctx_shared
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_ctx_freq
results: parsing output: 46/ for test: gem_create
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane_alpha_blend
results: parsing output: 51/ for test: kms_joiner
results: parsing output: 52/ for test: kms_color
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: gem_pxp
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: core_setmaster
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_setmode
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_getfb
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: prime_vgem
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: i915_module_load
results: parsing output: 85/ for test: testdisplay
results: parsing output: 86/ for test: gem_mmap_offset
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: prime_mmap_coherency
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_exec_whisper
results: parsing output: 95/ for test: kms_async_flips
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_properties
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: kms_pipe_b_c_ivb
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_exec_create
results: parsing output: 110/ for test: kms_chamelium_hpd
results: parsing output: 111/ for test: gem_spin_batch
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_edge_walk
results: parsing output: 119/ for test: syncobj_eventfd
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_plane_cursor
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_draw_crc
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: prime_mmap_coherency
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.