[57.642175] Initializing watchdogs
[57.642220]   /dev/watchdog0
[57.657039] [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.661134] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.663193] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.666656] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[57.779139] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[57.783319] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[57.879678] [002/133] (960s left) kms_psr (psr-cursor-plane-move)
[57.948740] Starting subtest: psr-cursor-plane-move
[57.951653] Starting dynamic subtest: eDP-1
[59.702658] Dynamic subtest eDP-1: SUCCESS (1.742s)
[59.704694] Subtest psr-cursor-plane-move: SUCCESS (1.743s)
[60.565135] [003/133] (957s left) syncobj_wait (wait-all-for-submit-complex)
[60.618611] Starting subtest: wait-all-for-submit-complex
[60.832543] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[60.901624] [004/133] (957s left) gem_lmem_swapping (verify)
[60.947053] Subtest verify: SKIP (0.000s)
[60.989946] [005/133] (957s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[61.048415] Starting subtest: etime-multi-wait-available-unsubmitted
[61.148850] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.100s)
[61.237067] [006/133] (957s left) syncobj_wait (invalid-reset-illegal-handle)
[61.294972] Starting subtest: invalid-reset-illegal-handle
[61.297039] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[61.403825] [007/133] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[61.485664] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[61.490433] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[61.586049] [008/133] (956s left) prime_mmap (test_errors)
[61.639090] Starting subtest: test_errors
[61.641878] Starting dynamic subtest: test_errors-smem
[61.734801] Dynamic subtest test_errors-smem: SUCCESS (0.097s)
[61.737175] Subtest test_errors: SUCCESS (0.097s)
[61.817271] [009/133] (956s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[61.887110] Starting subtest: pixel-format-linear-modifier-source-clamping
[61.914805] Starting dynamic subtest: pipe-A-plane-0
[65.370282] Dynamic subtest pipe-A-plane-0: SUCCESS (3.445s)
[65.378230] Starting dynamic subtest: pipe-A-plane-3
[67.162988] Dynamic subtest pipe-A-plane-3: SUCCESS (1.788s)
[68.273070] Starting dynamic subtest: pipe-B-plane-0
[71.737246] Dynamic subtest pipe-B-plane-0: SUCCESS (3.467s)
[71.745628] Starting dynamic subtest: pipe-B-plane-3
[73.373206] Dynamic subtest pipe-B-plane-3: SUCCESS (1.633s)
[73.688267] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.778s)
[74.547776] [010/133] (943s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[74.650583] Starting subtest: psr-modesetfrombusy
[80.840517] Subtest psr-modesetfrombusy: SUCCESS (6.192s)
[80.974949] [011/133] (937s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[81.051051] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[81.054819] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[82.147390] [012/133] (936s left) kms_psr (fbc-pr-cursor-plane-onoff)
[82.225409] Starting subtest: fbc-pr-cursor-plane-onoff
[82.230079] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[82.306779] [013/133] (936s left) gem_exec_schedule (u-semaphore-user)
[82.373946] Starting subtest: u-semaphore-user
[82.434309] Subtest u-semaphore-user: SUCCESS (0.067s)
[83.902875] [014/133] (934s left) gem_exec_schedule (preempt-other)
[83.973984] Starting subtest: preempt-other
[83.976351] Starting dynamic subtest: rcs0
[84.052083] Dynamic subtest rcs0: SUCCESS (0.078s)
[84.062724] Starting dynamic subtest: bcs0
[84.116102] Dynamic subtest bcs0: SUCCESS (0.063s)
[84.126779] Starting dynamic subtest: vcs0
[84.179013] Dynamic subtest vcs0: SUCCESS (0.062s)
[84.188203] Starting dynamic subtest: vcs1
[84.241944] Dynamic subtest vcs1: SUCCESS (0.063s)
[84.249495] Starting dynamic subtest: vecs0
[84.312053] Dynamic subtest vecs0: SUCCESS (0.070s)
[84.321963] Starting dynamic subtest: ccs0
[84.376724] Dynamic subtest ccs0: SUCCESS (0.063s)
[84.379976] Subtest preempt-other: SUCCESS (0.401s)
[85.928714] [015/133] (932s left) gem_exec_gttfill (engines)
[85.996775] Starting subtest: engines
[85.999266] Starting dynamic subtest: rcs0
[109.500641] Dynamic subtest rcs0: SUCCESS (23.497s)
[109.511521] Starting dynamic subtest: bcs0
[132.809278] Dynamic subtest bcs0: SUCCESS (23.305s)
[132.818106] Starting dynamic subtest: vcs0
[156.108253] Dynamic subtest vcs0: SUCCESS (23.298s)
[156.118874] Starting dynamic subtest: vcs1
[179.399302] Dynamic subtest vcs1: SUCCESS (23.287s)
[179.409892] Starting dynamic subtest: vecs0
[202.669798] Dynamic subtest vecs0: SUCCESS (23.270s)
[202.680625] Starting dynamic subtest: ccs0
[225.998618] Dynamic subtest ccs0: SUCCESS (23.326s)
[226.001493] Subtest engines: SUCCESS (139.988s)
[226.186650] [016/133] (792s left) gem_exec_params (invalid-fence-in)
[226.277569] Starting subtest: invalid-fence-in
[226.279972] Subtest invalid-fence-in: SUCCESS (0.000s)
[226.381700] [017/133] (792s left) i915_pm_rps (fence-order)
[226.438863] Starting subtest: fence-order
[229.892850] Subtest fence-order: SUCCESS (3.450s)
[229.993581] [018/133] (788s left) kms_dp_link_training (uhbr-sst)
[230.082074] Starting subtest: uhbr-sst
[230.090442] Subtest uhbr-sst: SKIP (0.000s)
[230.166299] [019/133] (788s left) kms_plane_cursor (primary)
[230.240581] Starting subtest: primary
[230.244980] Starting dynamic subtest: pipe-A-eDP-1-size-64
[232.786113] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.546s)
[232.809713] Starting dynamic subtest: pipe-A-eDP-1-size-128
[235.343189] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.539s)
[235.366656] Starting dynamic subtest: pipe-A-eDP-1-size-256
[237.923082] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.562s)
[238.243388] Starting dynamic subtest: pipe-B-eDP-1-size-64
[241.552926] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.320s)
[241.576529] Starting dynamic subtest: pipe-B-eDP-1-size-128
[244.165350] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s)
[244.188250] Starting dynamic subtest: pipe-B-eDP-1-size-256
[246.722628] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s)
[247.037576] Starting dynamic subtest: pipe-C-eDP-1-size-64
[249.951192] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.924s)
[249.976632] Starting dynamic subtest: pipe-C-eDP-1-size-128
[252.151335] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[252.179509] Starting dynamic subtest: pipe-C-eDP-1-size-256
[254.385149] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[254.700954] Starting dynamic subtest: pipe-D-eDP-1-size-64
[257.621427] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.929s)
[257.651709] Starting dynamic subtest: pipe-D-eDP-1-size-128
[259.843631] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[259.867449] Starting dynamic subtest: pipe-D-eDP-1-size-256
[262.053549] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[262.364699] Subtest primary: SUCCESS (32.123s)
[263.158946] [020/133] (755s left) syncobj_timeline (single-wait-all-available-submitted)
[263.221797] Starting subtest: single-wait-all-available-submitted
[263.224083] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[263.308857] [021/133] (755s left) core_auth (many-magics)
[263.372773] Starting subtest: many-magics
[264.301067] Subtest many-magics: SUCCESS (0.931s)
[264.440269] [022/133] (754s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[264.532476] Starting subtest: fbcpsr-tiling-4
[271.609651] Subtest fbcpsr-tiling-4: SUCCESS (7.081s)
[271.728201] [023/133] (747s left) kms_cursor_edge_walk (128x128-left-edge)
[271.802300] Starting subtest: 128x128-left-edge
[271.804665] Starting dynamic subtest: pipe-A-eDP-1
[275.241781] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.439s)
[275.250803] Starting dynamic subtest: pipe-D-eDP-1
[278.421162] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.179s)
[278.423433] Subtest 128x128-left-edge: SUCCESS (6.622s)
[279.291790] [024/133] (739s left) core_auth (getclient-simple)
[279.330889] Starting subtest: getclient-simple
[279.349955] Subtest getclient-simple: SUCCESS (0.018s)
[279.447788] [025/133] (739s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[279.530579] Starting subtest: fbcpsr-rgb565-draw-pwrite
[286.472715] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.946s)
[286.627327] [026/133] (732s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[286.983550] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[287.826680] [027/133] (731s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[287.890577] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[287.999112] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[288.072706] [028/133] (731s left) kms_plane_alpha_blend (constant-alpha-min)
[288.150080] Starting subtest: constant-alpha-min
[288.427110] Starting dynamic subtest: pipe-A-eDP-1
[289.164514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[289.173733] Starting dynamic subtest: pipe-D-eDP-1
[290.627284] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.460s)
[290.629644] Subtest constant-alpha-min: SUCCESS (2.478s)
[291.414422] [029/133] (727s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[291.520805] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[300.504969] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.985s)
[301.346919] [030/133] (717s left) gem_exec_fence (keep-in-fence)
[301.529787] Starting subtest: keep-in-fence
[301.532524] Starting dynamic subtest: rcs0
[301.597819] Dynamic subtest rcs0: SUCCESS (0.069s)
[301.608868] Starting dynamic subtest: bcs0
[301.651372] Dynamic subtest bcs0: SUCCESS (0.052s)
[301.662370] Starting dynamic subtest: vcs0
[302.875956] Dynamic subtest vcs0: SUCCESS (1.220s)
[302.887978] Starting dynamic subtest: vcs1
[304.858346] Dynamic subtest vcs1: SUCCESS (1.979s)
[304.869631] Starting dynamic subtest: vecs0
[306.842568] Dynamic subtest vecs0: SUCCESS (1.981s)
[306.854043] Starting dynamic subtest: ccs0
[307.067984] Dynamic subtest ccs0: SUCCESS (0.224s)
[307.070621] Subtest keep-in-fence: SUCCESS (5.541s)
[308.898232] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[308.902056] [031/133] (710s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[308.993633] Starting subtest: y-tiled-8bpp-rotate-270
[308.998079] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[309.079479] [032/133] (710s left) kms_chamelium_frames (hdmi-crc-single)
[309.446349] Subtest hdmi-crc-single: SKIP (0.000s)
[310.252250] [033/133] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[310.340260] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[310.344264] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[310.428931] [034/133] (709s left) gem_exec_fence (concurrent)
[310.596457] Starting subtest: concurrent
[310.601021] Subtest concurrent: SKIP (0.000s)
[311.916473] [035/133] (707s left) syncobj_timeline (multi-wait-for-submit-signaled)
[311.966290] Starting subtest: multi-wait-for-submit-signaled
[311.968712] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[312.068741] [036/133] (707s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[312.151978] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[312.154273] Starting dynamic subtest: pipe-A-eDP-1
[312.176627] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[312.192368] Starting dynamic subtest: pipe-B-eDP-1
[312.213967] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[312.222931] Starting dynamic subtest: pipe-C-eDP-1
[312.243392] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[312.253257] Starting dynamic subtest: pipe-D-eDP-1
[312.274880] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[312.278807] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.011s)
[314.421177] [037/133] (705s left) gem_exec_parallel (fds)
[314.499742] Starting subtest: fds
[314.502100] Starting dynamic subtest: rcs0
[317.174738] Dynamic subtest rcs0: SUCCESS (2.673s)
[317.187048] Starting dynamic subtest: bcs0
[320.614336] Dynamic subtest bcs0: SUCCESS (3.437s)
[320.624980] Starting dynamic subtest: vcs0
[324.166840] Dynamic subtest vcs0: SUCCESS (3.550s)
[324.178397] Starting dynamic subtest: vcs1
[328.087940] Dynamic subtest vcs1: SUCCESS (3.920s)
[328.096732] Starting dynamic subtest: vecs0
[332.133775] Dynamic subtest vecs0: SUCCESS (4.043s)
[332.143374] Starting dynamic subtest: ccs0
[335.575832] Dynamic subtest ccs0: SUCCESS (3.441s)
[335.578671] Subtest fds: SUCCESS (21.077s)
[335.776415] [038/133] (683s left) kms_psr (psr2-cursor-blt)
[335.861373] Starting subtest: psr2-cursor-blt
[335.863623] Starting dynamic subtest: eDP-1
[337.603984] Dynamic subtest eDP-1: SUCCESS (1.742s)
[337.606400] Subtest psr2-cursor-blt: SUCCESS (1.743s)
[338.476347] [039/133] (681s left) intel_hwmon (hwmon-write)
[338.538602] Subtest hwmon-write: SKIP (0.000s)
[338.597495] [040/133] (681s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[338.661375] Starting subtest: fbc-rgb565-draw-pwrite
[343.286679] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.626s)
[344.454796] [041/133] (675s left) gem_exec_reloc (basic-range-active)
[344.516453] Subtest basic-range-active: SKIP (0.000s)
[344.573659] [042/133] (675s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[344.662912] Starting subtest: x-tiled-32bpp-rotate-180
[346.130254] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.468s)
[346.253379] [043/133] (673s left) gem_mmap_offset (mmap-unmap)
[346.321751] Starting subtest: mmap-unmap
[346.323447] Starting dynamic subtest: smem0
[368.890367] Dynamic subtest smem0: SUCCESS (22.568s)
[368.893049] Subtest mmap-unmap: SUCCESS (22.569s)
[369.016325] [044/133] (650s left) kms_cursor_crc (cursor-onscreen-max-size)
[369.305929] Starting subtest: cursor-onscreen-max-size
[369.312174] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[369.429115] [045/133] (650s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[369.502486] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[369.506903] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[369.608281] [046/133] (650s left) gem_tiled_blits (interruptible)
[369.659578] Subtest interruptible: SKIP (0.000s)
[369.723068] [047/133] (650s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[369.821400] Starting subtest: cursorB-vs-flipA-atomic-transitions
[369.826029] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[369.961589] [048/133] (650s left) gem_basic (multigpu-create-close)
[370.017549] Starting subtest: multigpu-create-close
[370.020965] Subtest multigpu-create-close: SKIP (0.000s)
[370.139333] [049/133] (649s left) kms_flip (2x-blocking-absolute-wf_vblank)
[370.218131] Starting subtest: 2x-blocking-absolute-wf_vblank
[370.224529] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.008s)
[370.300989] [050/133] (649s left) api_intel_bb (bb-with-allocator)
[370.348968] Starting subtest: bb-with-allocator
[370.352018] Subtest bb-with-allocator: SUCCESS (0.006s)
[370.434915] [051/133] (649s left) sw_sync (timeline_closed_signaled)
[370.471876] Starting subtest: timeline_closed_signaled
[370.474144] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[370.528029] [052/133] (649s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[370.589285] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[370.591164] Starting dynamic subtest: pipe-A-eDP-1
[370.608524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[370.617073] Starting dynamic subtest: pipe-B-eDP-1
[370.633826] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[370.641496] Starting dynamic subtest: pipe-C-eDP-1
[370.657622] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[370.665552] Starting dynamic subtest: pipe-D-eDP-1
[370.681718] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[370.683541] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[372.832105] [053/133] (647s left) vgem_basic (setversion)
[372.879164] Starting subtest: setversion
[372.883409] Subtest setversion: SUCCESS (0.000s)
[372.938329] [054/133] (647s left) i915_drm_fdinfo (memory-info-shared)
[372.983885] Starting subtest: memory-info-shared
[372.986281] Starting dynamic subtest: smem0
[373.027978] Dynamic subtest smem0: SUCCESS (0.047s)
[373.030735] Subtest memory-info-shared: SUCCESS (0.048s)
[373.109189] [055/133] (647s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[373.170855] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[373.175437] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[373.361402] [056/133] (646s left) kms_vrr (flipline)
[373.441472] Starting subtest: flipline
[373.447728] Subtest flipline: SKIP (0.000s)
[373.509827] [057/133] (646s left) gem_exec_schedule (u-submit-late-slice)
[373.584770] Starting subtest: u-submit-late-slice
[373.586706] Starting dynamic subtest: rcs0
[373.615686] Dynamic subtest rcs0: SUCCESS (0.036s)
[373.625435] Starting dynamic subtest: bcs0
[373.642391] Dynamic subtest bcs0: SUCCESS (0.026s)
[373.651272] Starting dynamic subtest: vcs0
[373.671209] Dynamic subtest vcs0: SUCCESS (0.028s)
[373.683241] Starting dynamic subtest: vcs1
[373.696608] Dynamic subtest vcs1: SUCCESS (0.025s)
[373.708925] Starting dynamic subtest: vecs0
[373.724446] Dynamic subtest vecs0: SUCCESS (0.027s)
[373.733596] Starting dynamic subtest: ccs0
[373.755574] Dynamic subtest ccs0: SUCCESS (0.031s)
[373.757890] Subtest u-submit-late-slice: SUCCESS (0.177s)
[374.956172] [058/133] (645s left) kms_selftest (drm_damage_helper)
[375.001627] Starting subtest: drm_damage_helper
[375.055989] Starting dynamic subtest: drm_test_damage_iter_no_damage
[375.148294] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.093s)
[375.157883] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[375.235996] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.087s)
[375.245790] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[375.340319] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.104s)
[375.348283] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[375.431890] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.090s)
[375.441260] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[375.520226] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.088s)
[375.535074] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[375.607104] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.087s)
[375.617488] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[375.695692] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.087s)
[375.703950] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[375.792514] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.097s)
[375.800505] Starting dynamic subtest: drm_test_damage_iter_single_damage
[375.875988] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.082s)
[375.884148] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[375.969321] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.092s)
[375.977065] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[376.066716] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.097s)
[376.074239] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[376.156379] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.090s)
[376.164954] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[376.244810] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.085s)
[376.252616] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[376.341753] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.096s)
[376.349498] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[376.435663] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.094s)
[376.443489] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[376.525864] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.089s)
[376.533682] Starting dynamic subtest: drm_test_damage_iter_damage
[376.622270] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.094s)
[376.631753] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[376.709238] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.087s)
[376.718996] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[376.787536] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.076s)
[376.796859] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[376.874751] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.088s)
[376.884159] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[376.960318] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.084s)
[376.962013] Subtest drm_damage_helper: SUCCESS (1.964s)
[377.103939] [059/133] (643s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[377.192178] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[377.195685] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[377.275383] [060/133] (643s left) gem_linear_blits (basic)
[377.502904] Starting subtest: basic
[377.511324] Subtest basic: SUCCESS (0.009s)
[377.628349] [061/133] (642s left) gem_ctx_persistence (heartbeat-stop)
[377.717726] Starting subtest: heartbeat-stop
[377.722562] Subtest heartbeat-stop: SKIP (0.000s)
[377.836607] [062/133] (642s left) sysfs_defaults (readonly)
[377.890772] Starting subtest: readonly
[377.893111] Starting dynamic subtest: vecs0
[377.895295] Dynamic subtest vecs0: SUCCESS (0.000s)
[377.904948] Starting dynamic subtest: ccs0
[377.907069] Dynamic subtest ccs0: SUCCESS (0.000s)
[377.915074] Starting dynamic subtest: vcs0
[377.917154] Dynamic subtest vcs0: SUCCESS (0.000s)
[377.925075] Starting dynamic subtest: bcs0
[377.927135] Dynamic subtest bcs0: SUCCESS (0.000s)
[377.935098] Starting dynamic subtest: rcs0
[377.937248] Dynamic subtest rcs0: SUCCESS (0.000s)
[377.945068] Starting dynamic subtest: vcs1
[377.947214] Dynamic subtest vcs1: SUCCESS (0.000s)
[377.949407] Subtest readonly: SUCCESS (0.006s)
[378.004831] [063/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[378.078667] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[378.082723] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[378.179742] [064/133] (642s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[378.274050] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[378.278664] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[378.376967] [065/133] (642s left) perf (whitelisted-registers-userspace-config)
[378.530597] Starting subtest: whitelisted-registers-userspace-config
[378.532469] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[378.589293] [066/133] (642s left) kms_invalid_mode (clock-too-high)
[378.661957] Starting subtest: clock-too-high
[378.664116] Starting dynamic subtest: pipe-A-eDP-1
[378.667886] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[378.676535] Starting dynamic subtest: pipe-B-eDP-1
[378.680233] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[378.688194] Starting dynamic subtest: pipe-C-eDP-1
[378.691575] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[378.699150] Starting dynamic subtest: pipe-D-eDP-1
[378.702613] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[378.706039] Subtest clock-too-high: SKIP (0.004s)
[378.742266] [067/133] (642s left) syncobj_basic (illegal-fd-to-handle)
[378.795082] Starting subtest: illegal-fd-to-handle
[378.796661] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[378.885570] [068/133] (641s left) gem_partial_pwrite_pread (write-snoop)
[378.947176] Subtest write-snoop: SKIP (0.000s)
[379.021800] [069/133] (641s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[379.095311] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[379.097373] Starting dynamic subtest: pipe-A-default-mode
[381.901472] Dynamic subtest pipe-A-default-mode: SUCCESS (2.807s)
[381.903814] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.809s)
[382.728092] [070/133] (638s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[382.818133] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[382.822114] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[382.930659] [071/133] (638s left) gem_lmem_swapping (parallel-random-engines)
[382.975963] Subtest parallel-random-engines: SKIP (0.000s)
[383.026768] [072/133] (637s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[383.102705] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[383.105017] Starting dynamic subtest: pipe-A-eDP-1
[383.125318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[383.136043] Starting dynamic subtest: pipe-B-eDP-1
[383.155283] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[383.164262] Starting dynamic subtest: pipe-C-eDP-1
[383.183526] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[383.191536] Starting dynamic subtest: pipe-D-eDP-1
[383.210785] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[383.212976] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[385.299122] [073/133] (635s left) perf_pmu (render-node-busy-idle)
[385.359682] Starting subtest: render-node-busy-idle
[385.362251] Starting dynamic subtest: rcs0
[386.055090] Dynamic subtest rcs0: SUCCESS (0.695s)
[386.066512] Starting dynamic subtest: bcs0
[386.723127] Dynamic subtest bcs0: SUCCESS (0.666s)
[386.731975] Starting dynamic subtest: vcs0
[387.864054] Dynamic subtest vcs0: SUCCESS (1.138s)
[387.876105] Starting dynamic subtest: vcs1
[389.849649] Dynamic subtest vcs1: SUCCESS (1.981s)
[389.862080] Starting dynamic subtest: vecs0
[391.833885] Dynamic subtest vecs0: SUCCESS (1.981s)
[391.845987] Starting dynamic subtest: ccs0
[392.505775] Dynamic subtest ccs0: SUCCESS (0.671s)
[392.508605] Subtest render-node-busy-idle: SUCCESS (7.147s)
[392.584197] [074/133] (628s left) dmabuf_sync_file (export-wait-after-attach)
[392.635891] Starting subtest: export-wait-after-attach
[392.638200] Subtest export-wait-after-attach: SUCCESS (0.001s)
[392.695363] [075/133] (628s left) kms_pm_lpsp (kms-lpsp)
[393.774573] Starting subtest: kms-lpsp
[393.777022] Starting dynamic subtest: pipe-A-eDP-1
[393.932907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.162s)
[394.244092] Subtest kms-lpsp: SUCCESS (0.473s)
[395.036544] [076/133] (626s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[395.124905] Starting subtest: primary-y-tiled-reflect-x-0
[395.185600] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[395.286275] [077/133] (625s left) kms_content_protection (lic-type-1)
[395.409023] Starting subtest: lic-type-1
[395.413581] Subtest lic-type-1: SKIP (0.000s)
[395.530876] [078/133] (625s left) prime_mmap (test_forked_cpu_write)
[395.592564] Starting subtest: test_forked_cpu_write
[395.594527] Starting dynamic subtest: test_forked_cpu_write-smem
[395.598880] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[395.601165] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[395.693418] [079/133] (625s left) kms_prime (basic-modeset-hybrid)
[395.758575] Subtest basic-modeset-hybrid: SKIP (0.000s)
[395.863946] [080/133] (625s left) kms_properties (plane-properties-legacy)
[395.937794] Starting subtest: plane-properties-legacy
[395.939816] Starting dynamic subtest: pipe-A-eDP-1
[396.496785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s)
[396.508433] Starting dynamic subtest: pipe-B-eDP-1
[397.805997] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s)
[397.815688] Starting dynamic subtest: pipe-C-eDP-1
[399.059097] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.253s)
[399.068094] Starting dynamic subtest: pipe-D-eDP-1
[400.285305] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[400.287698] Subtest plane-properties-legacy: SUCCESS (4.349s)
[401.084185] [081/133] (620s left) kms_chamelium_color (ctm-negative)
[401.167292] Subtest ctm-negative: SKIP (0.000s)
[401.211856] [082/133] (620s left) gem_eio (in-flight-suspend)
[401.421071] Starting subtest: in-flight-suspend
[444.317917] Subtest in-flight-suspend: SUCCESS (13.433s)
[444.436721] [083/133] (576s left) i915_hangman (gt-error-state-capture)
[444.514480] Starting subtest: gt-error-state-capture
[444.516431] Starting dynamic subtest: rcs0
[456.270554] Dynamic subtest rcs0: SUCCESS (11.543s)
[456.283141] Starting dynamic subtest: bcs0
[468.303576] Dynamic subtest bcs0: SUCCESS (11.980s)
[468.316014] Starting dynamic subtest: vcs0
[480.207496] Dynamic subtest vcs0: SUCCESS (11.892s)
[480.220297] Starting dynamic subtest: vcs1
[489.230953] Dynamic subtest vcs1: SUCCESS (9.020s)
[489.246557] Starting dynamic subtest: vecs0
[499.278137] Dynamic subtest vecs0: SUCCESS (10.042s)
[499.291102] Starting dynamic subtest: ccs0
[511.311138] Dynamic subtest ccs0: SUCCESS (12.027s)
[511.314471] Subtest gt-error-state-capture: SUCCESS (66.518s)
[511.429935] [084/133] (510s left) gem_ctx_shared (single-timeline)
[511.494473] Starting subtest: single-timeline
[511.520678] Subtest single-timeline: SUCCESS (0.024s)
[511.750782] [085/133] (509s left) kms_color (invalid-degamma-lut-sizes)
[511.835002] Starting subtest: invalid-degamma-lut-sizes
[511.837406] Starting dynamic subtest: pipe-A
[512.125597] Dynamic subtest pipe-A: SUCCESS (0.291s)
[512.136179] Starting dynamic subtest: pipe-B
[512.138427] Dynamic subtest pipe-B: SUCCESS (0.000s)
[512.147688] Starting dynamic subtest: pipe-C
[512.150006] Dynamic subtest pipe-C: SUCCESS (0.000s)
[512.159129] Starting dynamic subtest: pipe-D
[512.161342] Dynamic subtest pipe-D: SUCCESS (0.000s)
[512.163513] Subtest invalid-degamma-lut-sizes: SUCCESS (0.294s)
[512.935470] [086/133] (508s left) kms_psr (fbc-pr-sprite-render)
[513.000109] Starting subtest: fbc-pr-sprite-render
[513.004716] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[513.111523] [087/133] (508s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[513.176708] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[513.181388] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[513.247404] [088/133] (508s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[513.347577] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[513.352015] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[513.426610] [089/133] (508s left) syncobj_timeline (invalid-query-illegal-handle)
[513.484635] Starting subtest: invalid-query-illegal-handle
[513.486836] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[513.583742] [090/133] (508s left) gem_softpin (zero)
[513.656579] Starting subtest: zero
[513.661317] Subtest zero: SUCCESS (0.004s)
[513.824313] [091/133] (507s left) gem_create (create-ext-cpu-access-big)
[513.994981] Starting subtest: create-ext-cpu-access-big
[513.999504] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[514.078828] [092/133] (507s left) kms_big_fb (x-tiled-addfb-size-overflow)
[514.162877] Starting subtest: x-tiled-addfb-size-overflow
[514.165260] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[514.266610] [093/133] (507s left) kms_big_fb (linear-32bpp-rotate-180)
[514.355173] Starting subtest: linear-32bpp-rotate-180
[515.956917] Subtest linear-32bpp-rotate-180: SUCCESS (1.601s)
[516.079669] [094/133] (505s left) kms_hdr (bpc-switch-dpms)
[516.171553] Starting subtest: bpc-switch-dpms
[517.202105] Starting dynamic subtest: pipe-A-eDP-1
[521.721874] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.520s)
[521.724241] Subtest bpc-switch-dpms: SUCCESS (5.550s)
[521.843043] [095/133] (500s left) gem_workarounds (reset)
[521.913917] Starting subtest: reset
[522.068195] Subtest reset: SUCCESS (0.156s)
[522.198019] [096/133] (499s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[522.270092] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[529.578872] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.307s)
[529.740799] [097/133] (492s left) syncobj_basic (bad-destroy-pad)
[529.808867] Starting subtest: bad-destroy-pad
[529.810850] Subtest bad-destroy-pad: SUCCESS (0.000s)
[529.919660] [098/133] (492s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[530.010548] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[530.014725] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[530.098129] [099/133] (492s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[530.171699] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[530.176224] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[530.285324] [100/133] (491s left) kms_cursor_crc (cursor-sliding-128x42)
[530.485734] Starting subtest: cursor-sliding-128x42
[530.533488] Subtest cursor-sliding-128x42: SKIP (0.045s)
[530.712530] [101/133] (491s left) kms_busy (extended-pageflip-hang-oldfb)
[530.794294] Starting subtest: extended-pageflip-hang-oldfb
[530.796194] Starting dynamic subtest: pipe-A
[531.192373] Dynamic subtest pipe-A: SUCCESS (0.396s)
[531.202887] Starting dynamic subtest: pipe-D
[532.329588] Dynamic subtest pipe-D: SUCCESS (1.136s)
[532.331795] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.536s)
[533.170529] [102/133] (489s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[533.248419] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[534.205326] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.956s)
[534.329679] [103/133] (488s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[534.402762] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[534.404924] Starting dynamic subtest: pipe-A-eDP-1
[545.382716] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.985s)
[545.393243] Starting dynamic subtest: pipe-B-eDP-1
[557.079798] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.698s)
[557.082501] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.686s)
[557.938470] [104/133] (464s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[558.024303] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[558.028292] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[558.129817] [105/133] (464s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[558.211251] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[558.213636] Starting dynamic subtest: pipe-A
[558.235284] Dynamic subtest pipe-A: SKIP (0.019s)
[558.246462] Starting dynamic subtest: pipe-B
[558.272088] Dynamic subtest pipe-B: SKIP (0.035s)
[558.282391] Starting dynamic subtest: pipe-C
[558.306173] Dynamic subtest pipe-C: SKIP (0.034s)
[558.315980] Starting dynamic subtest: pipe-D
[558.338229] Dynamic subtest pipe-D: SKIP (0.031s)
[558.342293] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.123s)
[558.444011] [106/133] (464s left) gem_pxp (verify-pxp-stale-buf-execution)
[558.566322] Starting subtest: verify-pxp-stale-buf-execution
[559.627976] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[559.769476] [107/133] (462s left) gem_exec_nop (basic-sequential)
[559.842372] Starting subtest: basic-sequential
[574.861487] Subtest basic-sequential: SUCCESS (15.028s)
[575.097505] [108/133] (447s left) kms_debugfs (display-off-read-all)
[575.174308] Starting subtest: display-off-read-all
[575.462630] Subtest display-off-read-all: SUCCESS (0.289s)
[576.261632] [109/133] (446s left) kms_cursor_crc (cursor-size-change)
[576.360133] Starting subtest: cursor-size-change
[576.362410] Starting dynamic subtest: pipe-A-eDP-1
[577.179733] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s)
[577.192382] Starting dynamic subtest: pipe-D-eDP-1
[578.612461] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.429s)
[578.614675] Subtest cursor-size-change: SUCCESS (2.251s)
[579.415338] [110/133] (443s left) gen9_exec_parse (bb-start-cmd)
[579.469471] Subtest bb-start-cmd: SKIP (0.000s)
[579.537523] [111/133] (443s left) i915_pm_rps (thresholds)
[579.598055] Starting subtest: thresholds
[579.602460] Subtest thresholds: SKIP (0.001s)
[579.697483] [112/133] (443s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[579.811630] Starting subtest: cursorA-vs-flipA-varying-size
[590.928983] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.116s)
[591.735334] [113/133] (431s left) kms_addfb_basic (bad-pitch-65536)
[591.796799] Starting subtest: bad-pitch-65536
[591.798722] Subtest bad-pitch-65536: SUCCESS (0.000s)
[591.918956] [114/133] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[592.000860] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[592.005243] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[592.106213] [115/133] (430s left) gen7_exec_parse (basic-allocation)
[592.160139] Subtest basic-allocation: SKIP (0.000s)
[592.245953] [116/133] (430s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[592.310774] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[592.411715] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[592.488065] [117/133] (430s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[592.570667] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[592.574737] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[592.641241] [118/133] (430s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[592.702710] Starting subtest: single-wait-for-submit-unsubmitted
[592.803116] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[592.878521] [119/133] (430s left) gem_ctx_persistence (engines-hostile)
[592.940035] Starting subtest: engines-hostile
[592.942067] Starting dynamic subtest: rcs0
[593.026672] Dynamic subtest rcs0: SUCCESS (0.086s)
[593.044300] Starting dynamic subtest: bcs0
[593.134258] Dynamic subtest bcs0: SUCCESS (0.105s)
[593.148134] Starting dynamic subtest: vcs0
[593.225238] Dynamic subtest vcs0: SUCCESS (0.089s)
[593.237208] Starting dynamic subtest: vcs1
[593.315671] Dynamic subtest vcs1: SUCCESS (0.088s)
[593.328308] Starting dynamic subtest: vecs0
[593.406689] Dynamic subtest vecs0: SUCCESS (0.089s)
[593.418224] Starting dynamic subtest: ccs0
[593.496647] Dynamic subtest ccs0: SUCCESS (0.088s)
[593.498811] Subtest engines-hostile: SUCCESS (0.558s)
[593.575812] [120/133] (429s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[593.645157] Starting subtest: plane-scaler-unity-scaling-with-rotation
[593.646819] Starting dynamic subtest: pipe-A
[593.882138] Dynamic subtest pipe-A: SUCCESS (0.239s)
[593.894550] Starting dynamic subtest: pipe-B
[595.216537] Dynamic subtest pipe-B: SUCCESS (1.333s)
[595.227460] Starting dynamic subtest: pipe-C
[596.543150] Dynamic subtest pipe-C: SUCCESS (1.325s)
[596.555352] Starting dynamic subtest: pipe-D
[597.872153] Dynamic subtest pipe-D: SUCCESS (1.328s)
[597.874321] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.229s)
[599.073043] [121/133] (424s left) gem_exec_reloc (basic-write-gtt-active)
[599.144238] Subtest basic-write-gtt-active: SKIP (0.000s)
[599.222991] [122/133] (423s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[599.300912] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[605.770171] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.470s)
[605.883026] [123/133] (417s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[605.967605] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[612.529152] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.565s)
[612.652038] [124/133] (410s left) perf_pmu (busy-double-start)
[612.689783] Starting subtest: busy-double-start
[612.691719] Starting dynamic subtest: rcs0
[616.279904] Dynamic subtest rcs0: SUCCESS (3.590s)
[616.290796] Starting dynamic subtest: bcs0
[619.856944] Dynamic subtest bcs0: SUCCESS (3.573s)
[619.870712] Starting dynamic subtest: vcs0
[623.886736] Dynamic subtest vcs0: FAIL (3.970s)
[623.898249] Starting dynamic subtest: vcs1
[627.889526] Dynamic subtest vcs1: FAIL (3.989s)
[627.901302] Starting dynamic subtest: vecs0
[631.859698] Dynamic subtest vecs0: FAIL (3.965s)
[631.871275] Starting dynamic subtest: ccs0
[635.427779] Dynamic subtest ccs0: FAIL (3.564s)
[635.429842] Subtest busy-double-start: FAIL (22.663s)
[635.475575] [125/133] (387s left) kms_lease (lessee-list)
[635.559376] Starting subtest: lessee-list
[635.561715] Starting dynamic subtest: pipe-A-eDP-1
[635.564114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[635.576790] Starting dynamic subtest: pipe-B-eDP-1
[635.578713] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[635.588027] Starting dynamic subtest: pipe-C-eDP-1
[635.589901] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[635.599007] Starting dynamic subtest: pipe-D-eDP-1
[635.600873] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[635.602709] Subtest lessee-list: SUCCESS (0.009s)
[635.675486] [126/133] (387s left) gem_pxp (create-regular-context-1)
[635.738467] Starting subtest: create-regular-context-1
[635.740749] Subtest create-regular-context-1: SUCCESS (0.001s)
[635.863670] [127/133] (387s left) gem_mmap_gtt (basic-short)
[635.929898] Subtest basic-short: SKIP (0.000s)
[635.991985] [128/133] (387s left) gem_exec_balancer (bonded-sync)
[636.044711] Starting subtest: bonded-sync
[636.049348] Subtest bonded-sync: SKIP (0.000s)
[636.333763] [129/133] (387s left) perf_pmu (semaphore-wait-idle)
[636.375739] Starting subtest: semaphore-wait-idle
[636.378048] Starting dynamic subtest: rcs0
[636.890757] Dynamic subtest rcs0: SUCCESS (0.513s)
[636.903403] Starting dynamic subtest: bcs0
[637.405692] Dynamic subtest bcs0: SUCCESS (0.511s)
[637.418760] Starting dynamic subtest: vcs0
[637.919193] Dynamic subtest vcs0: SUCCESS (0.511s)
[637.931265] Starting dynamic subtest: vcs1
[638.432672] Dynamic subtest vcs1: SUCCESS (0.510s)
[638.446039] Starting dynamic subtest: vecs0
[638.949062] Dynamic subtest vecs0: SUCCESS (0.513s)
[638.962406] Starting dynamic subtest: ccs0
[639.464582] Dynamic subtest ccs0: SUCCESS (0.512s)
[639.467699] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[639.582510] [130/133] (383s left) kms_scaling_modes (scaling-mode-center)
[639.658345] Starting subtest: scaling-mode-center
[639.660754] Starting dynamic subtest: pipe-A-eDP-1
[639.773137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.114s)
[639.784880] Starting dynamic subtest: pipe-B-eDP-1
[640.932608] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s)
[640.944019] Starting dynamic subtest: pipe-C-eDP-1
[642.039283] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[642.051742] Starting dynamic subtest: pipe-D-eDP-1
[643.191319] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.149s)
[643.193566] Subtest scaling-mode-center: SUCCESS (3.534s)
[644.369715] [131/133] (379s left) kms_atomic (plane-overlay-legacy)
[644.453728] Starting subtest: plane-overlay-legacy
[644.455967] Starting dynamic subtest: pipe-A-eDP-1
[644.889512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[644.891713] Subtest plane-overlay-legacy: SUCCESS (0.436s)
[645.700435] [132/133] (377s left) gem_exec_gttfill (basic)
[645.776039] Starting subtest: basic
[648.227405] Subtest basic: SUCCESS (2.450s)
[648.422869] [133/133] (375s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[648.549101] Starting subtest: fbc-psr-sprite-mmap-gtt
[648.551427] Starting dynamic subtest: eDP-1
[648.555552] Dynamic subtest eDP-1: SKIP (0.000s)
[648.559686] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[648.618043] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: prime_mmap
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: gem_exec_gttfill
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: i915_pm_rps
results: parsing output: 17/ for test: kms_dp_link_training
results: parsing output: 18/ for test: kms_plane_cursor
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: core_auth
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_edge_walk
results: parsing output: 23/ for test: core_auth
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_chamelium_hpd
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_plane_alpha_blend
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_chamelium_frames
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: gem_exec_parallel
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: intel_hwmon
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_mmap_offset
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_tiled_blits
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: gem_basic
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: sw_sync
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: i915_drm_fdinfo
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_vrr
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: kms_selftest
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_linear_blits
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: sysfs_defaults
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_invalid_mode
results: parsing output: 66/ for test: syncobj_basic
results: parsing output: 67/ for test: gem_partial_pwrite_pread
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: dmabuf_sync_file
results: parsing output: 74/ for test: kms_pm_lpsp
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: prime_mmap
results: parsing output: 78/ for test: kms_prime
results: parsing output: 79/ for test: kms_properties
results: parsing output: 80/ for test: kms_chamelium_color
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: i915_hangman
results: parsing output: 83/ for test: gem_ctx_shared
results: parsing output: 84/ for test: kms_color
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_softpin
results: parsing output: 90/ for test: gem_create
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_hdr
results: parsing output: 94/ for test: gem_workarounds
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_basic
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_busy
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_exec_nop
results: parsing output: 107/ for test: kms_debugfs
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: gen9_exec_parse
results: parsing output: 110/ for test: i915_pm_rps
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gen7_exec_parse
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: kms_plane_scaling
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: gem_pxp
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: kms_scaling_modes
results: parsing output: 130/ for test: kms_atomic
results: parsing output: 131/ for test: gem_exec_gttfill
results: parsing output: 132/ for test: kms_psr
Done.