[60.167688] Initializing watchdogs
[60.167736]   /dev/watchdog0
[60.181492] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.186536] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.188705] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.192179] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[60.320315] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[60.324573] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[60.422023] [002/131] (960s left) kms_addfb_basic (invalid-set-prop-any)
[60.477620] Starting subtest: invalid-set-prop-any
[60.479517] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[60.611206] [003/131] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[60.719934] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[60.724243] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[60.817197] [004/131] (959s left) syncobj_timeline (single-wait-all-available-signaled)
[60.868945] Starting subtest: single-wait-all-available-signaled
[60.871274] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[60.952673] [005/131] (959s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[61.050977] Starting subtest: y-tiled-64bpp-rotate-180
[61.054416] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[61.144714] [006/131] (959s left) gem_exec_reloc (basic-wc-gtt-active)
[61.205453] Subtest basic-wc-gtt-active: SKIP (0.000s)
[61.261717] [007/131] (959s left) gem_render_copy_redux (normal)
[61.325669] Starting subtest: normal
[61.588864] Subtest normal: SUCCESS (0.263s)
[61.702397] [008/131] (959s left) gem_tiled_pread_basic (basic)
[61.763930] Subtest basic: SKIP (0.000s)
[61.824961] [009/131] (959s left) i915_drm_fdinfo (busy-idle)
[61.864299] Starting subtest: busy-idle
[61.866166] Starting dynamic subtest: rcs0
[61.889169] Dynamic subtest rcs0: SKIP (0.023s)
[61.898302] Starting dynamic subtest: bcs0
[61.901802] Dynamic subtest bcs0: SKIP (0.000s)
[61.908381] Starting dynamic subtest: vcs0
[61.911808] Dynamic subtest vcs0: SKIP (0.001s)
[61.918552] Starting dynamic subtest: vcs1
[61.922036] Dynamic subtest vcs1: SKIP (0.001s)
[61.929469] Starting dynamic subtest: vecs0
[61.932899] Dynamic subtest vecs0: SKIP (0.000s)
[61.938913] Starting dynamic subtest: ccs0
[61.942483] Dynamic subtest ccs0: SKIP (0.001s)
[61.946040] Subtest busy-idle: SKIP (0.029s)
[61.981499] [010/131] (959s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[62.085180] Starting subtest: fbcpsr-tiling-4
[69.485706] Subtest fbcpsr-tiling-4: SUCCESS (7.410s)
[69.634568] [011/131] (951s left) kms_pm_dc (dc5-dpms-negative)
[70.742437] Starting subtest: dc5-dpms-negative
[70.747408] Subtest dc5-dpms-negative: SKIP (0.000s)
[70.811577] [012/131] (950s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[70.918525] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[75.331758] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.420s)
[76.478602] [013/131] (944s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[76.536231] Starting subtest: invalid-single-wait-all-unsubmitted
[76.538595] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[76.660793] [014/131] (944s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[76.764683] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[76.768750] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[76.862932] [015/131] (944s left) gem_lmem_swapping (random-engines)
[76.905826] Subtest random-engines: SKIP (0.000s)
[76.947859] [016/131] (944s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[77.040061] Starting subtest: plane-lut1d-post-ctm3x4
[77.162421] Starting dynamic subtest: pipe-A-plane-0
[77.351132] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[77.360384] Starting dynamic subtest: pipe-A-plane-1
[77.484457] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[77.492149] Starting dynamic subtest: pipe-A-plane-2
[77.617972] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[78.766143] Starting dynamic subtest: pipe-B-plane-0
[78.915787] Dynamic subtest pipe-B-plane-0: SUCCESS (0.156s)
[78.924907] Starting dynamic subtest: pipe-B-plane-1
[79.104211] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[79.112868] Starting dynamic subtest: pipe-B-plane-2
[79.248991] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[80.402120] Starting dynamic subtest: pipe-C-plane-0
[80.529059] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[80.537558] Starting dynamic subtest: pipe-C-plane-1
[80.662470] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[80.671611] Starting dynamic subtest: pipe-C-plane-2
[80.796328] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[81.934870] Starting dynamic subtest: pipe-D-plane-0
[82.062042] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[82.071304] Starting dynamic subtest: pipe-D-plane-1
[82.195198] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[82.203686] Starting dynamic subtest: pipe-D-plane-2
[82.339925] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[82.627506] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.589s)
[83.420504] [017/131] (937s left) kms_flip (2x-plain-flip-ts-check)
[83.526133] Starting subtest: 2x-plain-flip-ts-check
[83.535305] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[83.611232] [018/131] (937s left) i915_pm_rpm (gem-execbuf)
[88.381884] Starting subtest: gem-execbuf
[88.384167] Starting dynamic subtest: smem0
[90.788464] Dynamic subtest smem0: SUCCESS (2.407s)
[90.790801] Subtest gem-execbuf: SUCCESS (2.408s)
[90.871678] [019/131] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[90.968482] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[90.972791] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[91.065941] [020/131] (930s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[91.151838] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[91.156305] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[92.264244] [021/131] (929s left) kms_plane_multiple (2x-tiling-x)
[92.360791] Starting subtest: 2x-tiling-x
[92.365166] Subtest 2x-tiling-x: SKIP (0.000s)
[92.428669] [022/131] (929s left) perf_pmu (busy-accuracy-2)
[92.469640] Starting subtest: busy-accuracy-2
[92.471484] Starting dynamic subtest: rcs0
[95.512811] Dynamic subtest rcs0: SUCCESS (3.041s)
[95.520199] Starting dynamic subtest: bcs0
[98.572884] Dynamic subtest bcs0: SUCCESS (3.058s)
[98.583068] Starting dynamic subtest: vcs0
[101.619859] Dynamic subtest vcs0: SUCCESS (3.046s)
[101.630311] Starting dynamic subtest: vcs1
[104.669254] Dynamic subtest vcs1: SUCCESS (3.048s)
[104.679672] Starting dynamic subtest: vecs0
[107.714075] Dynamic subtest vecs0: SUCCESS (3.044s)
[107.723660] Starting dynamic subtest: ccs0
[110.768830] Dynamic subtest ccs0: SUCCESS (3.053s)
[110.771471] Subtest busy-accuracy-2: SUCCESS (18.298s)
[110.886116] [023/131] (910s left) api_intel_bb (intel-bb-blit-none)
[110.934596] Starting subtest: intel-bb-blit-none
[114.903298] Subtest intel-bb-blit-none: SUCCESS (3.969s)
[115.010797] [024/131] (906s left) sw_sync (timeline_closed)
[115.049685] Starting subtest: timeline_closed
[115.051592] Subtest timeline_closed: SUCCESS (0.000s)
[115.097646] [025/131] (906s left) gem_exec_schedule (u-semaphore-codependency)
[115.160586] Starting subtest: u-semaphore-codependency
[115.178945] Subtest u-semaphore-codependency: SUCCESS (0.026s)
[115.535693] [026/131] (906s left) prime_vgem (fence-read-hang)
[115.636183] Subtest fence-read-hang: SKIP (0.000s)
[115.720867] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[115.724313] [027/131] (905s left) kms_selftest (drm_format_helper)
[115.769579] Starting subtest: drm_format_helper
[115.776380] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[115.869655] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.093s)
[115.876983] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[115.960959] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.091s)
[115.971371] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[116.058608] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.096s)
[116.068023] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[116.171599] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.113s)
[116.179831] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[116.268608] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.097s)
[116.278197] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[116.362354] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.091s)
[116.369718] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[116.453062] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.092s)
[116.461802] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[116.543435] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.091s)
[116.552403] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[116.633375] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.089s)
[116.641114] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[116.726656] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.092s)
[116.734757] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[116.819619] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.092s)
[116.827475] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[116.902083] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.083s)
[116.909308] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[116.999520] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.096s)
[117.008625] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[117.097292] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.097s)
[117.105022] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[117.196205] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.100s)
[117.203045] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[117.301078] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.103s)
[117.309925] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[117.409064] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.107s)
[117.411048] Subtest drm_format_helper: SUCCESS (1.639s)
[117.564252] [028/131] (904s left) perf (invalid-oa-exponent)
[117.692567] Starting subtest: invalid-oa-exponent
[117.703413] Subtest invalid-oa-exponent: SUCCESS (0.012s)
[117.749356] [029/131] (904s left) gem_tiled_fence_blits (basic)
[117.800643] Subtest basic: SKIP (0.000s)
[117.882626] [030/131] (903s left) kms_chamelium_hpd (vga-hpd)
[118.271820] Subtest vga-hpd: SKIP (0.000s)
[119.064809] [031/131] (902s left) gem_exec_gttfill (multigpu-basic)
[119.243729] Starting subtest: multigpu-basic
[131.014245] Subtest multigpu-basic: SUCCESS (11.774s)
[131.068975] [032/131] (890s left) gem_exec_flush (basic-uc-pro-default)
[131.182220] Starting subtest: basic-uc-pro-default
[136.656638] Subtest basic-uc-pro-default: SUCCESS (5.474s)
[136.855226] [033/131] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[136.954746] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[136.959362] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[137.071215] [034/131] (884s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[137.157306] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[137.159526] Starting dynamic subtest: pipe-A
[137.176258] Dynamic subtest pipe-A: SKIP (0.017s)
[137.185287] Starting dynamic subtest: pipe-B
[137.207073] Dynamic subtest pipe-B: SKIP (0.030s)
[137.215293] Starting dynamic subtest: pipe-C
[137.237565] Dynamic subtest pipe-C: SKIP (0.029s)
[137.248025] Starting dynamic subtest: pipe-D
[137.267595] Dynamic subtest pipe-D: SKIP (0.030s)
[137.271907] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.107s)
[137.392248] [035/131] (884s left) kms_pm_rpm (pm-tiling)
[138.958652] Starting subtest: pm-tiling
[138.963629] Subtest pm-tiling: SKIP (0.000s)
[139.722236] [036/131] (882s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[139.812056] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[139.837537] Starting dynamic subtest: pipe-A-plane-0
[140.471076] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[140.481824] Starting dynamic subtest: pipe-A-plane-3
[140.914854] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[141.998340] Starting dynamic subtest: pipe-B-plane-0
[142.636947] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[142.646058] Starting dynamic subtest: pipe-B-plane-3
[143.035506] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[143.364563] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.554s)
[144.178696] [037/131] (877s left) syncobj_wait (wait-all-complex)
[144.245314] Starting subtest: wait-all-complex
[144.461590] Subtest wait-all-complex: SUCCESS (0.214s)
[144.548054] [038/131] (877s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[144.648641] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[151.456978] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.809s)
[151.594158] [039/131] (870s left) gem_partial_pwrite_pread (write-display)
[151.649841] Subtest write-display: SKIP (0.000s)
[151.715839] [040/131] (870s left) kms_chamelium_color (ctm-0-75)
[151.804812] Subtest ctm-0-75: SKIP (0.000s)
[151.851797] [041/131] (870s left) kms_big_fb (linear-8bpp-rotate-180)
[151.958576] Starting subtest: linear-8bpp-rotate-180
[153.183426] Subtest linear-8bpp-rotate-180: SUCCESS (1.225s)
[153.302430] [042/131] (869s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[153.402505] Starting subtest: bad-pixel-format-yf-tiled-ccs
[153.404425] Starting dynamic subtest: pipe-A-eDP-1
[153.424103] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[153.434077] Starting dynamic subtest: pipe-B-eDP-1
[153.451628] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[153.459173] Starting dynamic subtest: pipe-C-eDP-1
[153.476070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[153.483718] Starting dynamic subtest: pipe-D-eDP-1
[153.502056] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[153.505480] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[155.678745] [043/131] (866s left) kms_psr (pr-dpms)
[155.761054] Starting subtest: pr-dpms
[155.765389] Subtest pr-dpms: SKIP (0.000s)
[155.831535] [044/131] (866s left) gem_render_copy (linear-to-vebox-y-tiled)
[155.889243] Starting subtest: linear-to-vebox-y-tiled
[155.893495] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[156.097655] [045/131] (866s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[156.200174] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[156.202553] Starting dynamic subtest: pipe-A-eDP-1
[167.513669] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.313s)
[167.523235] Starting dynamic subtest: pipe-B-eDP-1
[179.484761] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.970s)
[179.487118] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.285s)
[180.324426] [046/131] (842s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[180.433912] Starting subtest: psr2-cursor-plane-move-continuous-sf
[180.436409] Starting dynamic subtest: pipe-A-eDP-1
[190.771632] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.343s)
[190.781837] Starting dynamic subtest: pipe-B-eDP-1
[201.892394] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.119s)
[201.894690] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.464s)
[202.704535] [047/131] (819s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[202.807161] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[202.811193] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[202.895503] [048/131] (819s left) prime_busy (hang)
[202.948682] Starting subtest: hang
[202.951053] Starting dynamic subtest: rcs0
[229.423351] Dynamic subtest rcs0: SUCCESS (26.471s)
[229.431048] Starting dynamic subtest: bcs0
[236.577081] Dynamic subtest bcs0: SUCCESS (7.151s)
[236.586874] Starting dynamic subtest: vcs0
[243.555661] Dynamic subtest vcs0: SUCCESS (6.977s)
[243.563598] Starting dynamic subtest: vcs1
[250.590339] Dynamic subtest vcs1: SUCCESS (7.038s)
[250.598716] Starting dynamic subtest: vecs0
[257.565339] Dynamic subtest vecs0: SUCCESS (6.973s)
[257.573944] Starting dynamic subtest: ccs0
[271.408563] Dynamic subtest ccs0: SUCCESS (13.839s)
[271.410488] Subtest hang: SUCCESS (68.455s)
[271.531667] [049/131] (751s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[271.637630] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[272.228376] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.592s)
[272.380922] [050/131] (750s left) sysfs_timeslice_duration (duration)
[272.440981] Starting subtest: duration
[272.443233] Starting dynamic subtest: vecs0
[285.813636] Dynamic subtest vecs0: SUCCESS (13.370s)
[285.824734] Starting dynamic subtest: ccs0
[298.955307] Dynamic subtest ccs0: SUCCESS (13.140s)
[298.966620] Starting dynamic subtest: vcs0
[312.820579] Dynamic subtest vcs0: SUCCESS (13.861s)
[312.834971] Starting dynamic subtest: bcs0
[325.967031] Dynamic subtest bcs0: SUCCESS (13.145s)
[325.983559] Starting dynamic subtest: rcs0
[339.112046] Dynamic subtest rcs0: SUCCESS (13.141s)
[339.123994] Starting dynamic subtest: vcs1
[352.820427] Dynamic subtest vcs1: SUCCESS (13.705s)
[352.823139] Subtest duration: SUCCESS (80.377s)
[352.897703] [051/131] (669s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[353.006077] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[353.010073] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[353.095071] [052/131] (669s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[353.192130] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[359.977662] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.788s)
[360.088356] [053/131] (662s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[360.146067] Starting subtest: multi-wait-for-submit-available-signaled
[360.148351] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[360.243182] [054/131] (662s left) gem_exec_reloc (basic-write-wc)
[360.310944] Subtest basic-write-wc: SKIP (0.000s)
[360.395059] [055/131] (662s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[360.498718] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[367.861795] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.366s)
[367.995896] [056/131] (654s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[368.057283] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[368.061652] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[368.242866] [057/131] (654s left) syncobj_wait (wait-for-submit-delayed-submit)
[368.300666] Starting subtest: wait-for-submit-delayed-submit
[368.402065] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[368.490878] [058/131] (654s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[368.543990] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[368.649771] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[368.723953] [059/131] (654s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[368.816725] Starting subtest: fbc-psr-cursor-mmap-gtt
[368.818987] Starting dynamic subtest: eDP-1
[368.823913] Dynamic subtest eDP-1: SKIP (0.000s)
[368.828468] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[368.900708] [060/131] (654s left) kms_fence_pin_leak
[369.069324] [061/131] (654s left) gem_userptr_blits (unsync-unmap-cycles)
[369.140778] Subtest unsync-unmap-cycles: SKIP (0.000s)
[369.273901] [062/131] (653s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[369.384304] Starting subtest: cursorA-vs-flipA-atomic-transitions
[380.545677] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.161s)
[381.379351] [063/131] (641s left) kms_cursor_edge_walk (256x256-left-edge)
[381.482661] Starting subtest: 256x256-left-edge
[381.485080] Starting dynamic subtest: pipe-A-eDP-1
[384.946387] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s)
[384.955993] Starting dynamic subtest: pipe-D-eDP-1
[388.051085] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.102s)
[388.053317] Subtest 256x256-left-edge: SUCCESS (6.569s)
[388.870438] [064/131] (634s left) kms_debugfs (display-off-read-all)
[388.964586] Starting subtest: display-off-read-all
[389.255815] Subtest display-off-read-all: SUCCESS (0.293s)
[390.086438] [065/131] (633s left) kms_addfb_basic (too-high)
[390.178687] Starting subtest: too-high
[390.180720] Subtest too-high: SUCCESS (0.001s)
[390.276928] [066/131] (633s left) i915_pm_rps (thresholds)
[390.343290] Starting subtest: thresholds
[390.347949] Subtest thresholds: SKIP (0.001s)
[390.453475] [067/131] (632s left) gem_mmap_gtt (hang-user)
[390.499534] Subtest hang-user: SKIP (0.000s)
[390.560682] [068/131] (632s left) syncobj_wait (single-wait-all-for-submit-submitted)
[390.611539] Starting subtest: single-wait-all-for-submit-submitted
[390.712940] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[390.804709] [069/131] (632s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[390.891155] Starting subtest: primary-yf-tiled-reflect-x-180
[390.951169] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[391.073971] [070/131] (632s left) kms_chamelium_edid (hdmi-mode-timings)
[391.443192] Subtest hdmi-mode-timings: SKIP (0.000s)
[392.296343] [071/131] (631s left) kms_psr (psr-no-drrs)
[392.391461] Starting subtest: psr-no-drrs
[392.393844] Starting dynamic subtest: eDP-1
[394.000227] Dynamic subtest eDP-1: SUCCESS (1.610s)
[394.002517] Subtest psr-no-drrs: SUCCESS (1.611s)
[394.884880] [072/131] (628s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[394.951237] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[395.018475] [073/131] (628s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[395.114460] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[395.118574] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[395.204199] [074/131] (628s left) i915_query (query-garbage)
[395.264865] Starting subtest: query-garbage
[395.267188] Subtest query-garbage: SUCCESS (0.000s)
[395.376436] [075/131] (628s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[395.470306] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[399.509159] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.042s)
[400.709149] [076/131] (622s left) gem_exec_balancer (parallel)
[400.965489] Starting subtest: parallel
[401.901624] Subtest parallel: SUCCESS (0.939s)
[402.875860] [077/131] (620s left) gen9_exec_parse (bb-chained)
[402.958602] Subtest bb-chained: SKIP (0.000s)
[403.019571] [078/131] (620s left) prime_vgem (basic-gtt)
[403.090335] Starting subtest: basic-gtt
[403.094791] Subtest basic-gtt: SKIP (0.000s)
[403.190580] [079/131] (620s left) syncobj_wait (invalid-reset-bad-pad)
[403.251553] Starting subtest: invalid-reset-bad-pad
[403.253878] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[403.342990] [080/131] (620s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[403.447364] Starting subtest: psr-rgb565-draw-blt
[410.525461] Subtest psr-rgb565-draw-blt: SUCCESS (7.081s)
[410.665690] [081/131] (613s left) gem_exec_fence (invalid-timeline-fence-array)
[411.239378] Starting subtest: invalid-timeline-fence-array
[411.241842] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[412.983910] [082/131] (610s left) kms_cursor_crc (cursor-onscreen-256x85)
[413.311728] Starting subtest: cursor-onscreen-256x85
[413.355295] Subtest cursor-onscreen-256x85: SKIP (0.038s)
[413.535382] [083/131] (610s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[413.644882] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[413.649210] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[413.752044] [084/131] (610s left) gem_exec_parallel (basic)
[413.821799] Starting subtest: basic
[413.824062] Starting dynamic subtest: rcs0
[415.276943] Dynamic subtest rcs0: SUCCESS (1.457s)
[415.288679] Starting dynamic subtest: bcs0
[416.730441] Dynamic subtest bcs0: SUCCESS (1.451s)
[416.742098] Starting dynamic subtest: vcs0
[418.837677] Dynamic subtest vcs0: SUCCESS (2.103s)
[418.847090] Starting dynamic subtest: vcs1
[420.886898] Dynamic subtest vcs1: SUCCESS (2.046s)
[420.904923] Starting dynamic subtest: vecs0
[422.869310] Dynamic subtest vecs0: SUCCESS (1.979s)
[422.880866] Starting dynamic subtest: ccs0
[424.356241] Dynamic subtest ccs0: SUCCESS (1.485s)
[424.358801] Subtest basic: SUCCESS (10.539s)
[424.545083] [085/131] (599s left) syncobj_timeline (etime-multi-wait-all-submitted)
[424.604062] Starting subtest: etime-multi-wait-all-submitted
[424.706292] Subtest etime-multi-wait-all-submitted: SUCCESS (0.101s)
[424.788072] [086/131] (599s left) kms_setmode (clone-exclusive-crtc)
[424.842528] Starting subtest: clone-exclusive-crtc
[424.848796] Subtest clone-exclusive-crtc: SKIP (0.000s)
[424.939210] [087/131] (599s left) kms_content_protection (dp-mst-lic-type-0)
[425.075403] Starting subtest: dp-mst-lic-type-0
[425.079874] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[425.198759] [088/131] (598s left) kms_addfb_basic (size-max)
[425.296222] Starting subtest: size-max
[425.298458] Subtest size-max: SUCCESS (0.000s)
[425.405402] [089/131] (598s left) gem_compute (compute-square)
[425.459862] Starting subtest: compute-square
[425.464779] Subtest compute-square: SUCCESS (0.007s)
[425.576822] [090/131] (598s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[425.663317] Starting subtest: addfb25-y-tiled-small-legacy
[425.667181] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[425.743281] [091/131] (598s left) kms_joiner (invalid-modeset-big-joiner)
[425.834903] Starting subtest: invalid-modeset-big-joiner
[425.838620] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[425.902996] [092/131] (598s left) gem_exec_basic (basic)
[425.966439] Starting subtest: basic
[425.968884] Starting dynamic subtest: rcs0-smem
[425.972990] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[425.985428] Starting dynamic subtest: bcs0-smem
[425.987321] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[425.995279] Starting dynamic subtest: vcs0-smem
[425.997083] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[426.004732] Starting dynamic subtest: vcs1-smem
[426.006579] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[426.014316] Starting dynamic subtest: vecs0-smem
[426.016244] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[426.024047] Starting dynamic subtest: ccs0-smem
[426.026215] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[426.028068] Subtest basic: SUCCESS (0.022s)
[427.969631] [093/131] (596s left) kms_atomic (atomic-invalid-params)
[428.066220] Starting subtest: atomic-invalid-params
[428.068509] Starting dynamic subtest: pipe-A-eDP-1
[428.461169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.394s)
[428.463108] Subtest atomic-invalid-params: SUCCESS (0.395s)
[429.338685] [094/131] (595s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[429.437956] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[429.442224] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[429.529985] [095/131] (594s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[429.629472] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[429.633505] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[429.733926] [096/131] (594s left) sw_sync (sync_busy)
[429.773083] Starting subtest: sync_busy
[429.775364] Subtest sync_busy: SUCCESS (0.002s)
[429.819871] [097/131] (594s left) kms_psr (psr2-cursor-plane-onoff)
[429.917924] Starting subtest: psr2-cursor-plane-onoff
[429.920273] Starting dynamic subtest: eDP-1
[431.636823] Dynamic subtest eDP-1: SUCCESS (1.717s)
[431.639087] Subtest psr2-cursor-plane-onoff: SUCCESS (1.718s)
[432.427142] [098/131] (592s left) gem_exec_whisper (basic-normal-all)
[432.493660] Starting subtest: basic-normal-all
[434.788251] Subtest basic-normal-all: SUCCESS (2.292s)
[434.968623] [099/131] (589s left) dumb_buffer (map-uaf)
[435.023804] Starting subtest: map-uaf
[435.026205] Subtest map-uaf: SUCCESS (0.004s)
[435.121505] [100/131] (589s left) perf_pmu (busy-idle)
[435.169256] Starting subtest: busy-idle
[435.171611] Starting dynamic subtest: rcs0
[435.862830] Dynamic subtest rcs0: SUCCESS (0.693s)
[435.873182] Starting dynamic subtest: bcs0
[436.525501] Dynamic subtest bcs0: SUCCESS (0.661s)
[436.537574] Starting dynamic subtest: vcs0
[437.910241] Dynamic subtest vcs0: SUCCESS (1.381s)
[437.920068] Starting dynamic subtest: vcs1
[439.893990] Dynamic subtest vcs1: SUCCESS (1.980s)
[439.905313] Starting dynamic subtest: vecs0
[441.877977] Dynamic subtest vecs0: SUCCESS (1.980s)
[441.889315] Starting dynamic subtest: ccs0
[442.544752] Dynamic subtest ccs0: SUCCESS (0.665s)
[442.547371] Subtest busy-idle: SUCCESS (7.377s)
[442.634314] [101/131] (582s left) gem_exec_flush (basic-wb-ro-default)
[442.698630] Starting subtest: basic-wb-ro-default
[448.189585] Subtest basic-wb-ro-default: SUCCESS (5.491s)
[448.381491] [102/131] (576s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[448.482895] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[448.485097] Starting dynamic subtest: pipe-A-eDP-1
[448.542461] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[448.551281] Starting dynamic subtest: pipe-B-eDP-1
[448.608747] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[448.618998] Starting dynamic subtest: pipe-C-eDP-1
[448.676042] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[448.685669] Starting dynamic subtest: pipe-D-eDP-1
[448.742230] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[448.746296] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[450.721408] [103/131] (574s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[450.776634] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[450.881589] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[450.958427] [104/131] (573s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[451.064285] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[451.066430] Starting dynamic subtest: pipe-A-eDP-1
[451.085918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[451.097349] Starting dynamic subtest: pipe-B-eDP-1
[451.115346] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[451.123605] Starting dynamic subtest: pipe-C-eDP-1
[451.142584] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[451.150601] Starting dynamic subtest: pipe-D-eDP-1
[451.169582] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[451.171505] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[453.376977] [105/131] (571s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[453.631738] Starting subtest: cursor-rapid-movement-256x85
[453.677053] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[453.847572] [106/131] (571s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[453.909998] Starting subtest: single-wait-all-for-submit-unsubmitted
[454.009382] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[454.087811] [107/131] (570s left) gem_softpin (zero)
[454.144585] Starting subtest: zero
[454.151887] Subtest zero: SUCCESS (0.005s)
[454.287060] [108/131] (570s left) drm_read (short-buffer-wakeup)
[454.435916] Starting subtest: short-buffer-wakeup
[486.653177] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[486.797618] [109/131] (538s left) gem_ctx_param (invalid-set-ringsize)
[486.850803] Starting subtest: invalid-set-ringsize
[486.853080] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[486.941218] [110/131] (538s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[487.033415] Starting subtest: x-tiled-8bpp-rotate-180
[488.224261] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.191s)
[488.345872] [111/131] (536s left) gem_exercise_blt (fast-copy)
[488.400360] Starting subtest: fast-copy
[488.404637] Starting dynamic subtest: linear-smem-smem
[488.422537] Dynamic subtest linear-smem-smem: SUCCESS (0.022s)
[488.433449] Starting dynamic subtest: xmajor-smem-smem
[488.438761] Dynamic subtest xmajor-smem-smem: SUCCESS (0.016s)
[488.446926] Starting dynamic subtest: tile4-smem-smem
[488.454833] Dynamic subtest tile4-smem-smem: SUCCESS (0.015s)
[488.463049] Starting dynamic subtest: tile64-smem-smem
[488.471444] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[488.473524] Subtest fast-copy: SUCCESS (0.072s)
[488.579097] [112/131] (536s left) gem_exec_capture (userptr)
[488.629172] Starting subtest: userptr
[489.473206] Subtest userptr: SUCCESS (0.844s)
[489.594173] [113/131] (535s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[489.684020] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[490.296838] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.614s)
[490.446082] [114/131] (534s left) gem_linear_blits (interruptible)
[490.712472] Starting subtest: interruptible
[494.522374] Subtest interruptible: SUCCESS (3.814s)
[494.676710] [115/131] (530s left) gem_mmap_gtt (basic-small-bo-tiledx)
[494.779053] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[494.838950] [116/131] (530s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[494.972292] Starting subtest: cursorA-vs-flipB-atomic
[494.976796] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[495.116765] [117/131] (530s left) kms_psr (fbc-psr2-primary-page-flip)
[495.203978] Starting subtest: fbc-psr2-primary-page-flip
[495.206424] Starting dynamic subtest: eDP-1
[495.210825] Dynamic subtest eDP-1: SKIP (0.000s)
[495.215336] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[495.314251] [118/131] (530s left) gem_ctx_shared (create-shared-gtt)
[495.385446] Starting subtest: create-shared-gtt
[497.539118] Subtest create-shared-gtt: SUCCESS (2.152s)
[497.937455] [119/131] (527s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[498.034966] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[498.039434] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[498.121302] [120/131] (527s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[498.223700] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[498.226050] Starting dynamic subtest: pipe-A-default-mode
[499.336117] Dynamic subtest pipe-A-default-mode: SKIP (1.110s)
[499.339921] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.112s)
[499.503978] [121/131] (526s left) i915_hangman (engine-error-state-capture)
[499.578611] Starting subtest: engine-error-state-capture
[499.580767] Starting dynamic subtest: rcs0
[502.836882] Dynamic subtest rcs0: SUCCESS (3.258s)
[502.849082] Starting dynamic subtest: bcs0
[508.851669] Dynamic subtest bcs0: SUCCESS (6.012s)
[508.863994] Starting dynamic subtest: vcs0
[514.802928] Dynamic subtest vcs0: SUCCESS (5.949s)
[514.815908] Starting dynamic subtest: vcs1
[519.796227] Dynamic subtest vcs1: SUCCESS (4.990s)
[519.808933] Starting dynamic subtest: vecs0
[524.851380] Dynamic subtest vecs0: SUCCESS (5.052s)
[524.863031] Starting dynamic subtest: ccs0
[530.868423] Dynamic subtest ccs0: SUCCESS (6.014s)
[530.871344] Subtest engine-error-state-capture: SUCCESS (31.291s)
[530.996096] [122/131] (494s left) kms_flip (flip-vs-blocking-wf-vblank)
[531.108310] Starting subtest: flip-vs-blocking-wf-vblank
[531.110496] Starting dynamic subtest: A-eDP1
[540.051485] Dynamic subtest A-eDP1: SUCCESS (8.944s)
[540.064183] Starting dynamic subtest: B-eDP1
[548.977435] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[548.989498] Starting dynamic subtest: C-eDP1
[557.899315] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[557.908245] Starting dynamic subtest: D-eDP1
[566.830933] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[566.833375] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.726s)
[568.048819] [123/131] (457s left) gem_pxp (display-protected-crc)
[568.182703] Starting subtest: display-protected-crc
[569.820318] Subtest display-protected-crc: SUCCESS (1.640s)
[569.938017] [124/131] (455s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[570.037243] Starting subtest: nonblocking-crc-frame-sequence
[570.039774] Starting dynamic subtest: pipe-A-eDP-1
[570.770798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[570.781212] Starting dynamic subtest: pipe-B-eDP-1
[572.178735] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s)
[572.188843] Starting dynamic subtest: pipe-C-eDP-1
[573.549109] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[573.559854] Starting dynamic subtest: pipe-D-eDP-1
[574.870835] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[574.872829] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.833s)
[575.685518] [125/131] (450s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[575.792223] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[575.796379] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[575.860201] [126/131] (449s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[575.952828] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[575.957131] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[576.053986] [127/131] (449s left) kms_draw_crc (draw-method-pwrite)
[576.153040] Starting subtest: draw-method-pwrite
[576.155034] Starting dynamic subtest: xrgb8888-untiled
[576.961387] Dynamic subtest xrgb8888-untiled: SUCCESS (0.810s)
[576.971225] Starting dynamic subtest: rgb565-untiled
[577.784206] Dynamic subtest rgb565-untiled: SUCCESS (0.821s)
[577.799669] Starting dynamic subtest: xrgb2101010-untiled
[578.317135] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.530s)
[578.330233] Starting dynamic subtest: xbgr16161616f-untiled
[579.106837] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.787s)
[579.116414] Starting dynamic subtest: xrgb8888-xtiled
[580.772764] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.665s)
[580.783412] Starting dynamic subtest: rgb565-xtiled
[581.783871] Dynamic subtest rgb565-xtiled: SUCCESS (1.010s)
[581.793724] Starting dynamic subtest: xrgb2101010-xtiled
[583.506414] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.722s)
[583.515892] Starting dynamic subtest: xbgr16161616f-xtiled
[586.617593] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.110s)
[586.627405] Starting dynamic subtest: xrgb8888-4tiled
[587.651073] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.031s)
[587.660426] Starting dynamic subtest: rgb565-4tiled
[588.173261] Dynamic subtest rgb565-4tiled: SUCCESS (0.521s)
[588.182649] Starting dynamic subtest: xrgb2101010-4tiled
[589.195488] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.021s)
[589.209237] Starting dynamic subtest: xbgr16161616f-4tiled
[592.028793] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.833s)
[592.031188] Subtest draw-method-pwrite: SUCCESS (15.878s)
[592.132817] [128/131] (433s left) kms_rotation_crc (exhaust-fences)
[592.244479] Starting subtest: exhaust-fences
[592.248605] Subtest exhaust-fences: SKIP (0.000s)
[592.317009] [129/131] (433s left) kms_lease (empty-lease)
[592.405207] Starting subtest: empty-lease
[592.407520] Starting dynamic subtest: pipe-A-eDP-1
[592.409680] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[592.423627] Starting dynamic subtest: pipe-B-eDP-1
[592.425786] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[592.439440] Starting dynamic subtest: pipe-C-eDP-1
[592.441567] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[592.450062] Starting dynamic subtest: pipe-D-eDP-1
[592.452315] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[592.454611] Subtest empty-lease: SUCCESS (0.009s)
[592.514920] [130/131] (433s left) kms_vblank (wait-idle)
[592.600934] Starting subtest: wait-idle
[592.602727] Starting dynamic subtest: pipe-A-eDP-1
[594.364486] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.763s)
[594.379314] Starting dynamic subtest: pipe-D-eDP-1
[596.836580] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.470s)
[596.839069] Subtest wait-idle: SUCCESS (4.236s)
[597.654887] [131/131] (428s left) gem_exec_schedule (pi-distinct-iova)
[597.870669] Starting subtest: pi-distinct-iova
[597.872665] Starting dynamic subtest: rcs0
[597.952848] Dynamic subtest rcs0: SUCCESS (0.085s)
[597.962157] Starting dynamic subtest: vcs0
[598.025103] Dynamic subtest vcs0: SUCCESS (0.071s)
[598.037056] Starting dynamic subtest: vcs1
[598.079892] Dynamic subtest vcs1: SUCCESS (0.055s)
[598.091051] Starting dynamic subtest: vecs0
[598.149185] Dynamic subtest vecs0: SUCCESS (0.068s)
[598.166058] Starting dynamic subtest: ccs0
[598.210917] Dynamic subtest ccs0: SUCCESS (0.061s)
[598.213465] Subtest pi-distinct-iova: SUCCESS (0.346s)
[599.975446] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: gem_render_copy_redux
results: parsing output: 7/ for test: gem_tiled_pread_basic
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_pm_dc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_lmem_swapping
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: i915_pm_rpm
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_plane_multiple
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: sw_sync
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: prime_vgem
results: parsing output: 26/ for test: kms_selftest
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: gem_tiled_fence_blits
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: gem_exec_gttfill
results: parsing output: 31/ for test: gem_exec_flush
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_pm_rpm
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_partial_pwrite_pread
results: parsing output: 39/ for test: kms_chamelium_color
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_busy
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: sysfs_timeslice_duration
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_fence_pin_leak
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_cursor_edge_walk
results: parsing output: 63/ for test: kms_debugfs
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: i915_pm_rps
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: kms_chamelium_edid
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_fenced_exec_thrash
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: gen9_exec_parse
results: parsing output: 77/ for test: prime_vgem
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_parallel
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_setmode
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: gem_compute
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_joiner
results: parsing output: 91/ for test: gem_exec_basic
results: parsing output: 92/ for test: kms_atomic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: sw_sync
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: dumb_buffer
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_exec_flush
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_softpin
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: gem_ctx_param
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exercise_blt
results: parsing output: 111/ for test: gem_exec_capture
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_linear_blits
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_ctx_shared
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: i915_hangman
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: kms_pipe_crc_basic
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_draw_crc
results: parsing output: 127/ for test: kms_rotation_crc
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: gem_exec_schedule
Done.