[55.240125] Initializing watchdogs
[55.240175]   /dev/watchdog0
[55.248064] [001/131] (960s left) gem_softpin (zero)
[55.306045] Starting subtest: zero
[55.313908] Subtest zero: SUCCESS (0.005s)
[55.413182] [002/131] (960s left) syncobj_wait (multi-wait-submitted-signaled)
[55.464808] Starting subtest: multi-wait-submitted-signaled
[55.467092] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[55.541617] [003/131] (960s left) kms_psr (fbc-pr-cursor-plane-move)
[55.643067] Starting subtest: fbc-pr-cursor-plane-move
[55.647543] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[55.696198] [004/131] (960s left) kms_rotation_crc (primary-rotation-180)
[55.793516] Starting subtest: primary-rotation-180
[62.695135] Subtest primary-rotation-180: SUCCESS (6.895s)
[63.873332] [005/131] (951s left) kms_psr (fbc-psr2-primary-blt)
[63.972105] Starting subtest: fbc-psr2-primary-blt
[63.974502] Starting dynamic subtest: eDP-1
[63.978810] Dynamic subtest eDP-1: SKIP (0.000s)
[63.983160] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[64.023503] [006/131] (951s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[64.128249] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[64.132576] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[64.204446] [007/131] (951s left) api_intel_bb (blit-noreloc-purge-cache)
[64.279107] Starting subtest: blit-noreloc-purge-cache
[64.290468] Subtest blit-noreloc-purge-cache: SUCCESS (0.012s)
[64.381678] [008/131] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[64.489570] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[64.494060] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[64.570924] [009/131] (951s left) sysfs_timeslice_duration (timeout)
[64.635963] Starting subtest: timeout
[64.638452] Starting dynamic subtest: vecs0
[73.914286] Dynamic subtest vecs0: SUCCESS (9.270s)
[73.925755] Starting dynamic subtest: ccs0
[75.289316] Dynamic subtest ccs0: SUCCESS (1.376s)
[75.299077] Starting dynamic subtest: vcs0
[84.908880] Dynamic subtest vcs0: SUCCESS (9.615s)
[84.918185] Starting dynamic subtest: bcs0
[85.647283] Dynamic subtest bcs0: SUCCESS (0.740s)
[85.656148] Starting dynamic subtest: rcs0
[87.064062] Dynamic subtest rcs0: SUCCESS (1.418s)
[87.073259] Starting dynamic subtest: vcs1
[96.944566] Dynamic subtest vcs1: SUCCESS (9.876s)
[96.947144] Subtest timeout: SUCCESS (32.298s)
[96.996028] [010/131] (918s left) kms_pm_backlight (fade)
[97.089164] Starting subtest: fade
[97.166746] Starting dynamic subtest: eDP-1
[99.815411] Dynamic subtest eDP-1: SUCCESS (2.648s)
[99.817963] Subtest fade: SUCCESS (2.725s)
[100.597638] [011/131] (915s left) kms_cursor_crc (cursor-offscreen-64x21)
[100.770634] Starting subtest: cursor-offscreen-64x21
[100.819177] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[101.027703] [012/131] (914s left) gem_mmap_wc (read-write)
[101.080991] Subtest read-write: SKIP (0.000s)
[101.127400] [013/131] (914s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[101.526637] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[102.302415] [014/131] (913s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[102.414990] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[102.417397] Starting dynamic subtest: pipe-A-default-mode
[103.583793] Dynamic subtest pipe-A-default-mode: SKIP (1.164s)
[103.588428] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.165s)
[103.705847] [015/131] (912s left) kms_psr (pr-primary-mmap-cpu)
[103.805117] Starting subtest: pr-primary-mmap-cpu
[103.809739] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[103.856880] [016/131] (912s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[103.975267] Starting subtest: x-tiled-32bpp-rotate-180
[105.524741] Subtest x-tiled-32bpp-rotate-180: FAIL (0.976s)
[105.539691] [017/131] (910s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[105.640149] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[110.186261] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.548s)
[110.277738] [018/131] (905s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[110.389023] Starting subtest: psr-farfromfence-mmap-gtt
[110.392951] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[110.462537] [019/131] (905s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[110.549528] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[110.551898] Starting dynamic subtest: pipe-A
[110.566168] Dynamic subtest pipe-A: SKIP (0.011s)
[110.574098] Starting dynamic subtest: pipe-B
[110.586898] Dynamic subtest pipe-B: SKIP (0.020s)
[110.594067] Starting dynamic subtest: pipe-C
[110.611716] Dynamic subtest pipe-C: SKIP (0.023s)
[110.620139] Starting dynamic subtest: pipe-D
[110.634030] Dynamic subtest pipe-D: SKIP (0.024s)
[110.637846] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.078s)
[110.716175] [020/131] (905s left) kms_vrr (seamless-rr-switch-virtual)
[110.824165] Starting subtest: seamless-rr-switch-virtual
[110.830682] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[110.877034] [021/131] (905s left) kms_pipe_crc_basic (nonblocking-crc)
[110.975835] Starting subtest: nonblocking-crc
[110.978278] Starting dynamic subtest: pipe-A-eDP-1
[111.764641] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[111.772509] Starting dynamic subtest: pipe-B-eDP-1
[113.128732] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s)
[113.135771] Starting dynamic subtest: pipe-C-eDP-1
[114.492937] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[114.501751] Starting dynamic subtest: pipe-D-eDP-1
[115.827145] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[115.829444] Subtest nonblocking-crc: SUCCESS (4.849s)
[116.628583] [022/131] (899s left) gem_exec_create (legacy)
[116.697432] Starting subtest: legacy
[116.699954] Starting dynamic subtest: smem
[119.918837] Dynamic subtest smem: SUCCESS (3.219s)
[119.921835] Subtest legacy: SUCCESS (3.219s)
[120.079676] [023/131] (896s left) kms_psr (psr2-cursor-render)
[120.177977] Starting subtest: psr2-cursor-render
[120.180279] Starting dynamic subtest: eDP-1
[121.804838] Dynamic subtest eDP-1: SUCCESS (1.623s)
[121.806830] Subtest psr2-cursor-render: SUCCESS (1.624s)
[122.569237] [024/131] (893s left) kms_color (invalid-ctm-matrix-sizes)
[122.665936] Starting subtest: invalid-ctm-matrix-sizes
[122.668280] Starting dynamic subtest: pipe-A
[122.670461] Dynamic subtest pipe-A: SUCCESS (0.002s)
[122.677873] Starting dynamic subtest: pipe-B
[122.680246] Dynamic subtest pipe-B: SUCCESS (0.003s)
[122.686716] Starting dynamic subtest: pipe-C
[122.688566] Dynamic subtest pipe-C: SUCCESS (0.003s)
[122.695087] Starting dynamic subtest: pipe-D
[122.697187] Dynamic subtest pipe-D: SUCCESS (0.004s)
[122.699318] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s)
[122.727901] [025/131] (893s left) syncobj_timeline (etime-multi-wait-all-submitted)
[122.785141] Starting subtest: etime-multi-wait-all-submitted
[122.895884] Subtest etime-multi-wait-all-submitted: SUCCESS (0.109s)
[122.947035] [026/131] (893s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[123.002903] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[123.007866] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[123.165891] [027/131] (893s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[123.222078] Starting subtest: etime-single-wait-for-submit-unsubmitted
[123.328058] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[123.381489] [028/131] (892s left) kms_busy (extended-pageflip-hang-oldfb)
[123.470847] Starting subtest: extended-pageflip-hang-oldfb
[123.473175] Starting dynamic subtest: pipe-A
[123.864807] Dynamic subtest pipe-A: SUCCESS (0.392s)
[123.872843] Starting dynamic subtest: pipe-D
[124.996805] Dynamic subtest pipe-D: SUCCESS (1.127s)
[124.999202] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.524s)
[125.815464] [029/131] (890s left) perf_pmu (all-busy-check-all)
[125.855081] Starting subtest: all-busy-check-all
[127.916356] Subtest all-busy-check-all: SUCCESS (2.059s)
[128.002811] [030/131] (888s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[128.105842] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[128.108276] Starting dynamic subtest: pipe-A-eDP-1
[128.131774] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[128.139281] Starting dynamic subtest: pipe-B-eDP-1
[128.160497] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[128.167512] Starting dynamic subtest: pipe-C-eDP-1
[128.189308] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[128.196084] Starting dynamic subtest: pipe-D-eDP-1
[128.218687] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[128.223166] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[130.257262] [031/131] (886s left) gem_exec_parallel (fds)
[130.326061] Starting subtest: fds
[130.328422] Starting dynamic subtest: rcs0
[132.726154] Dynamic subtest rcs0: SUCCESS (2.398s)
[132.735575] Starting dynamic subtest: bcs0
[135.688799] Dynamic subtest bcs0: SUCCESS (2.961s)
[135.698024] Starting dynamic subtest: vcs0
[139.183158] Dynamic subtest vcs0: SUCCESS (3.494s)
[139.196488] Starting dynamic subtest: vcs1
[143.187743] Dynamic subtest vcs1: SUCCESS (4.003s)
[143.195798] Starting dynamic subtest: vecs0
[147.168853] Dynamic subtest vecs0: SUCCESS (3.980s)
[147.180467] Starting dynamic subtest: ccs0
[150.425418] Dynamic subtest ccs0: SUCCESS (3.255s)
[150.428041] Subtest fds: SUCCESS (20.096s)
[150.592668] [032/131] (865s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[150.704437] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[150.708569] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[150.790671] [033/131] (865s left) core_setmaster (master-drop-set-root)
[152.872262] Starting subtest: master-drop-set-root
[152.882592] Subtest master-drop-set-root: SUCCESS (0.012s)
[152.908271] [034/131] (863s left) perf (missing-sample-flags)
[153.016491] Starting subtest: missing-sample-flags
[153.018801] Subtest missing-sample-flags: SUCCESS (0.000s)
[153.041622] [035/131] (863s left) prime_busy (after-wait)
[153.108587] Starting subtest: after-wait
[153.113318] Starting dynamic subtest: rcs0
[153.150151] Dynamic subtest rcs0: SUCCESS (0.038s)
[153.159623] Starting dynamic subtest: bcs0
[153.209472] Dynamic subtest bcs0: SUCCESS (0.059s)
[153.219360] Starting dynamic subtest: vcs0
[153.251808] Dynamic subtest vcs0: SUCCESS (0.042s)
[153.260153] Starting dynamic subtest: vcs1
[153.293655] Dynamic subtest vcs1: SUCCESS (0.041s)
[153.301818] Starting dynamic subtest: vecs0
[153.337471] Dynamic subtest vecs0: SUCCESS (0.043s)
[153.350654] Starting dynamic subtest: ccs0
[153.382830] Dynamic subtest ccs0: SUCCESS (0.045s)
[153.491673] Subtest after-wait: SUCCESS (0.382s)
[153.549336] [036/131] (862s left) gem_ctx_shared (exec-single-timeline)
[153.606447] Starting subtest: exec-single-timeline
[153.608748] Starting dynamic subtest: rcs0
[154.696815] Dynamic subtest rcs0: SUCCESS (1.088s)
[154.708492] Starting dynamic subtest: bcs0
[155.784672] Dynamic subtest bcs0: SUCCESS (1.087s)
[155.795386] Starting dynamic subtest: vcs0
[156.873432] Dynamic subtest vcs0: SUCCESS (1.087s)
[156.884430] Starting dynamic subtest: vcs1
[157.960696] Dynamic subtest vcs1: SUCCESS (1.086s)
[157.970827] Starting dynamic subtest: vecs0
[159.047836] Dynamic subtest vecs0: SUCCESS (1.085s)
[159.060140] Starting dynamic subtest: ccs0
[160.136335] Dynamic subtest ccs0: SUCCESS (1.088s)
[160.139249] Subtest exec-single-timeline: SUCCESS (6.529s)
[161.023947] [037/131] (855s left) gem_eio (in-flight-contexts-1us)
[161.254158] Starting subtest: in-flight-contexts-1us
[174.972515] Subtest in-flight-contexts-1us: SUCCESS (13.716s)
[175.150315] [038/131] (841s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[175.249058] Starting subtest: psr-rgb565-draw-blt
[180.059196] Subtest psr-rgb565-draw-blt: SUCCESS (4.815s)
[180.183310] [039/131] (836s left) gem_exec_params (dr4-dirt)
[180.255778] Starting subtest: DR4-dirt
[180.258092] Subtest DR4-dirt: SUCCESS (0.000s)
[180.345975] [040/131] (836s left) gem_partial_pwrite_pread (write-uncached)
[180.404376] Subtest write-uncached: SKIP (0.000s)
[180.469969] [041/131] (836s left) kms_flip (2x-nonexisting-fb)
[180.576041] Starting subtest: 2x-nonexisting-fb
[180.587608] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[180.695601] [042/131] (835s left) kms_universal_plane (universal-plane-functional)
[180.790033] Starting subtest: universal-plane-functional
[180.792349] Starting dynamic subtest: pipe-A-eDP-1
[184.561219] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.768s)
[184.569937] Starting dynamic subtest: pipe-B-eDP-1
[188.939575] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.378s)
[188.948927] Starting dynamic subtest: pipe-C-eDP-1
[193.184983] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.242s)
[193.194412] Starting dynamic subtest: pipe-D-eDP-1
[197.456760] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.272s)
[197.459131] Subtest universal-plane-functional: SUCCESS (16.665s)
[198.236813] [043/131] (818s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[198.343254] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[198.348100] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[198.431236] [044/131] (818s left) gem_exec_schedule (pi-ringfull)
[198.622627] Starting subtest: pi-ringfull
[198.625062] Starting dynamic subtest: rcs0
[198.749264] Dynamic subtest rcs0: SUCCESS (0.128s)
[198.763569] Starting dynamic subtest: bcs0
[198.823989] Dynamic subtest bcs0: SUCCESS (0.074s)
[198.839197] Starting dynamic subtest: vcs0
[198.897386] Dynamic subtest vcs0: SUCCESS (0.073s)
[198.912745] Starting dynamic subtest: vcs1
[198.970702] Dynamic subtest vcs1: SUCCESS (0.073s)
[198.985809] Starting dynamic subtest: vecs0
[199.045487] Dynamic subtest vecs0: SUCCESS (0.074s)
[199.060771] Starting dynamic subtest: ccs0
[199.120017] Dynamic subtest ccs0: SUCCESS (0.073s)
[199.122389] Subtest pi-ringfull: SUCCESS (0.501s)
[199.351340] [045/131] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[199.448562] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[199.452678] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[199.551899] [046/131] (817s left) gem_lmem_swapping (parallel-random-engines)
[199.596285] Subtest parallel-random-engines: SKIP (0.000s)
[199.623192] [047/131] (817s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[204.610683] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[204.613596] Starting dynamic subtest: pipe-A-eDP-1
[205.410349] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s)
[205.419680] Starting dynamic subtest: pipe-B-eDP-1
[206.533138] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[206.537298] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.922s)
[207.690639] [048/131] (808s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[207.796258] Starting subtest: yf-tiled-64bpp-rotate-180
[207.800234] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[207.883265] [049/131] (808s left) i915_hangman (hangcheck-unterminated)
[207.952431] Starting subtest: hangcheck-unterminated
[218.890975] Subtest hangcheck-unterminated: SUCCESS (10.936s)
[219.014772] [050/131] (797s left) gem_mmap_wc (write-wc-read-gtt)
[219.085068] Subtest write-wc-read-gtt: SKIP (0.000s)
[219.127973] [051/131] (797s left) gem_linear_blits (interruptible)
[219.475507] Starting subtest: interruptible
[224.718347] Subtest interruptible: SUCCESS (5.242s)
[224.865110] [052/131] (791s left) gem_partial_pwrite_pread (reads-display)
[224.968611] Subtest reads-display: SKIP (0.000s)
[225.035402] [053/131] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[225.153179] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[229.655857] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.505s)
[229.760864] [054/131] (787s left) gem_exec_flush (basic-uc-rw-default)
[229.825706] Starting subtest: basic-uc-rw-default
[235.305284] Subtest basic-uc-rw-default: SUCCESS (5.479s)
[235.476361] [055/131] (781s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[235.606626] Starting subtest: cursorA-vs-flipA-atomic-transitions
[246.819072] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.212s)
[247.659954] [056/131] (769s left) gem_ctx_isolation (clean)
[247.730333] Starting subtest: clean
[247.732837] Starting dynamic subtest: rcs0
[247.794485] Dynamic subtest rcs0: SUCCESS (0.063s)
[247.805599] Starting dynamic subtest: bcs0
[247.887360] Dynamic subtest bcs0: SUCCESS (0.092s)
[247.897360] Starting dynamic subtest: vcs0
[247.930226] Dynamic subtest vcs0: SUCCESS (0.042s)
[247.940379] Starting dynamic subtest: vcs1
[249.969426] Dynamic subtest vcs1: SUCCESS (2.038s)
[249.978612] Starting dynamic subtest: vecs0
[251.953284] Dynamic subtest vecs0: SUCCESS (1.983s)
[251.964308] Starting dynamic subtest: ccs0
[253.945937] Dynamic subtest ccs0: SUCCESS (1.992s)
[253.948485] Subtest clean: SUCCESS (6.216s)
[254.149324] [057/131] (762s left) sw_sync (alloc_timeline)
[254.190631] Starting subtest: alloc_timeline
[254.192954] Subtest alloc_timeline: SUCCESS (0.000s)
[254.228067] [058/131] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[254.340290] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[254.344535] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[254.432894] [059/131] (762s left) syncobj_basic (test-valid-cycle)
[254.497792] Starting subtest: test-valid-cycle
[254.499689] Subtest test-valid-cycle: SUCCESS (0.000s)
[254.594061] [060/131] (762s left) kms_cursor_crc (cursor-random-64x64)
[254.752052] Starting subtest: cursor-random-64x64
[254.757271] Starting dynamic subtest: pipe-A-eDP-1
[258.096352] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.339s)
[258.118888] Starting dynamic subtest: pipe-D-eDP-1
[262.072720] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.960s)
[262.075144] Subtest cursor-random-64x64: SUCCESS (7.319s)
[262.904512] [061/131] (754s left) api_intel_allocator (alloc-simple)
[262.968804] Starting subtest: alloc-simple
[262.970835] Subtest alloc-simple: SUCCESS (0.004s)
[263.066597] [062/131] (753s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[263.162076] Starting subtest: fbc-pr-sprite-mmap-gtt
[263.166438] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[263.213203] [063/131] (753s left) syncobj_wait (single-wait-all-signaled)
[263.274630] Starting subtest: single-wait-all-signaled
[263.276827] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[263.361216] [064/131] (753s left) i915_fb_tiling
[263.465813] [065/131] (753s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[263.565214] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[263.567501] Starting dynamic subtest: pipe-A-eDP-1
[263.624677] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[263.634270] Starting dynamic subtest: pipe-B-eDP-1
[263.691763] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[263.702580] Starting dynamic subtest: pipe-C-eDP-1
[263.762101] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[263.771805] Starting dynamic subtest: pipe-D-eDP-1
[263.828589] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[263.832877] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[265.655336] [066/131] (751s left) gem_exec_schedule (u-lateslice)
[265.728641] Starting subtest: u-lateslice
[265.730611] Starting dynamic subtest: rcs0
[265.742670] Dynamic subtest rcs0: SUCCESS (0.021s)
[265.752307] Starting dynamic subtest: bcs0
[265.761061] Dynamic subtest bcs0: SUCCESS (0.018s)
[265.769717] Starting dynamic subtest: vcs0
[265.779153] Dynamic subtest vcs0: SUCCESS (0.017s)
[265.787825] Starting dynamic subtest: vcs1
[265.796184] Dynamic subtest vcs1: SUCCESS (0.017s)
[265.804651] Starting dynamic subtest: vecs0
[265.812764] Dynamic subtest vecs0: SUCCESS (0.016s)
[265.821337] Starting dynamic subtest: ccs0
[265.830332] Dynamic subtest ccs0: SUCCESS (0.017s)
[265.832682] Subtest u-lateslice: SUCCESS (0.109s)
[266.988568] [067/131] (750s left) kms_flip (wf_vblank-ts-check)
[267.091148] Starting subtest: wf_vblank-ts-check
[267.093460] Starting dynamic subtest: A-eDP1
[276.015335] Dynamic subtest A-eDP1: SUCCESS (8.923s)
[276.027300] Starting dynamic subtest: B-eDP1
[284.942280] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[284.952538] Starting dynamic subtest: C-eDP1
[293.852742] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[293.863167] Starting dynamic subtest: D-eDP1
[302.781333] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[302.786724] Subtest wf_vblank-ts-check: SUCCESS (35.696s)
[303.979692] [068/131] (713s left) gem_exec_params (batch-first)
[304.039292] Starting subtest: batch-first
[304.045826] Subtest batch-first: SUCCESS (0.007s)
[304.150418] [069/131] (712s left) i915_query (query-regions-sanity-check)
[304.214396] Starting subtest: query-regions-sanity-check
[304.225953] Subtest query-regions-sanity-check: SUCCESS (0.014s)
[304.336484] [070/131] (712s left) syncobj_timeline (wait-any-interrupted)
[304.390357] Starting subtest: wait-any-interrupted
[304.493962] Subtest wait-any-interrupted: SUCCESS (0.102s)
[304.551199] [071/131] (712s left) gem_exec_whisper (basic-fds-forked-all)
[304.612057] Starting subtest: basic-fds-forked-all
[326.163274] Subtest basic-fds-forked-all: SUCCESS (21.546s)
[326.332779] [072/131] (690s left) gem_exec_suspend (basic-s4-devices)
[326.409046] Starting subtest: basic-S4-devices
[326.411426] Starting dynamic subtest: smem
[337.965340] Dynamic subtest smem: SUCCESS (11.554s)
[337.967883] Subtest basic-S4-devices: SUCCESS (11.555s)
[345.145331] [073/131] (679s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[345.261476] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[345.266220] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[345.336894] [074/131] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[345.446616] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[349.613918] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.174s)
[349.706072] [075/131] (674s left) syncobj_eventfd (timeline-wait-signaled)
[349.766635] Starting subtest: timeline-wait-signaled
[349.768963] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[349.832176] [076/131] (674s left) kms_addfb_basic (bad-pitch-63)
[349.898082] Starting subtest: bad-pitch-63
[349.900310] Subtest bad-pitch-63: SUCCESS (0.000s)
[350.034287] [077/131] (674s left) kms_vblank (invalid)
[350.138136] Starting subtest: invalid
[350.140341] Starting dynamic subtest: pipe-A-eDP-1
[350.536787] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[350.539170] Subtest invalid: SUCCESS (0.397s)
[351.352750] [078/131] (672s left) drm_fdinfo (all-busy-check-all)
[351.396509] Starting subtest: all-busy-check-all
[351.403237] Subtest all-busy-check-all: SKIP (0.004s)
[351.452066] [079/131] (672s left) gem_exec_balancer (bonded-sync)
[351.560793] Starting subtest: bonded-sync
[351.565191] Subtest bonded-sync: SKIP (0.000s)
[351.833935] [080/131] (672s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[351.938173] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[351.940441] Starting dynamic subtest: pipe-A-eDP-1
[351.963953] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[351.974044] Starting dynamic subtest: pipe-B-eDP-1
[351.995167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[352.004615] Starting dynamic subtest: pipe-C-eDP-1
[352.026880] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.036163] Starting dynamic subtest: pipe-D-eDP-1
[352.058257] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.062261] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[354.105572] [081/131] (670s left) syncobj_basic (illegal-fd-to-handle)
[354.170533] Starting subtest: illegal-fd-to-handle
[354.172864] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[354.243736] [082/131] (670s left) gem_close (basic)
[354.308156] Starting subtest: basic
[354.310597] Subtest basic: SUCCESS (0.000s)
[354.403772] [083/131] (669s left) kms_feature_discovery (psr2)
[354.512970] Starting subtest: psr2
[354.515312] Subtest psr2: SUCCESS (0.000s)
[354.566541] [084/131] (669s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite)
[354.674875] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite
[359.546329] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.874s)
[359.629634] [085/131] (664s left) gem_exec_reloc (basic-write-wc-active)
[359.693304] Subtest basic-write-wc-active: SKIP (0.000s)
[359.749183] [086/131] (664s left) kms_async_flips (async-flip-with-page-flip-events-atomic)
[359.846312] Starting subtest: async-flip-with-page-flip-events-atomic
[360.220422] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs
[360.998964] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.774s)
[361.009547] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[361.149434] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SKIP (0.150s)
[361.159634] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc
[361.293264] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.145s)
[361.302529] Starting dynamic subtest: pipe-A-eDP-1-4
[363.472389] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.181s)
[363.487765] Starting dynamic subtest: pipe-A-eDP-1-x
[365.661463] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[365.670917] Starting dynamic subtest: pipe-A-eDP-1-linear
[367.872343] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.210s)
[368.267453] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs
[369.231275] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.967s)
[369.240537] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[369.402992] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SKIP (0.166s)
[369.414109] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc
[369.573999] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.176s)
[369.583087] Starting dynamic subtest: pipe-B-eDP-1-4
[371.754055] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.180s)
[371.766877] Starting dynamic subtest: pipe-B-eDP-1-x
[373.953855] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.199s)
[373.966459] Starting dynamic subtest: pipe-B-eDP-1-linear
[376.153567] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.199s)
[376.537340] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs
[377.254702] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.728s)
[377.264870] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[377.420067] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SKIP (0.165s)
[377.430576] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc
[377.584878] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.164s)
[377.594941] Starting dynamic subtest: pipe-C-eDP-1-4
[379.754359] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.171s)
[379.764231] Starting dynamic subtest: pipe-C-eDP-1-x
[381.932657] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[381.943111] Starting dynamic subtest: pipe-C-eDP-1-linear
[384.121776] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.188s)
[384.485806] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs
[385.280144] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.800s)
[385.290066] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[385.442229] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SKIP (0.163s)
[385.453301] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc
[385.588227] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.144s)
[385.598503] Starting dynamic subtest: pipe-D-eDP-1-4
[387.757631] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.171s)
[387.770320] Starting dynamic subtest: pipe-D-eDP-1-x
[389.934593] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[389.944948] Starting dynamic subtest: pipe-D-eDP-1-linear
[392.123710] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.188s)
[392.126920] Subtest async-flip-with-page-flip-events-atomic: SUCCESS (32.275s)
[393.235429] [087/131] (631s left) i915_pm_rpm (gem-mmap-type)
[395.058091] Starting subtest: gem-mmap-type
[395.061225] Starting dynamic subtest: wb-smem0
[398.820612] Dynamic subtest wb-smem0: SUCCESS (3.760s)
[398.830617] Starting dynamic subtest: wc-smem0
[401.945458] Dynamic subtest wc-smem0: SUCCESS (3.124s)
[401.955873] Starting dynamic subtest: uc-smem0
[405.053186] Dynamic subtest uc-smem0: SUCCESS (3.107s)
[405.055468] Subtest gem-mmap-type: SUCCESS (9.993s)
[405.119439] [088/131] (619s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format)
[405.223287] Starting subtest: plane-downscale-factor-0-25-with-pixel-format
[405.225595] Starting dynamic subtest: pipe-A
[405.241144] Dynamic subtest pipe-A: SKIP (0.011s)
[405.253434] Starting dynamic subtest: pipe-B
[405.262160] Dynamic subtest pipe-B: SKIP (0.020s)
[405.271975] Starting dynamic subtest: pipe-C
[405.280997] Dynamic subtest pipe-C: SKIP (0.020s)
[405.291378] Starting dynamic subtest: pipe-D
[405.304753] Dynamic subtest pipe-D: SKIP (0.020s)
[405.308600] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (0.074s)
[405.385853] [089/131] (619s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[405.501741] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[406.092653] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.593s)
[406.249597] [090/131] (618s left) gem_exec_balancer (invalid-bonds)
[406.318143] Starting subtest: invalid-bonds
[406.322718] Subtest invalid-bonds: SKIP (0.000s)
[406.613148] [091/131] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[406.719072] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[406.723254] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[406.800608] [092/131] (617s left) gem_barrier_race (remote-request)
[406.872674] Starting subtest: remote-request
[406.874961] Starting dynamic subtest: rcs0
[412.079342] Dynamic subtest rcs0: SUCCESS (5.205s)
[412.084901] Subtest remote-request: SUCCESS (5.206s)
[412.209763] [093/131] (612s left) kms_prop_blob (invalid-get-prop)
[412.272727] Starting subtest: invalid-get-prop
[412.274652] Subtest invalid-get-prop: SUCCESS (0.000s)
[412.353968] [094/131] (612s left) dumb_buffer (create-valid-dumb)
[412.419934] Starting subtest: create-valid-dumb
[412.421880] Subtest create-valid-dumb: SUCCESS (0.000s)
[412.499100] [095/131] (612s left) kms_rotation_crc (cursor-rotation-180)
[412.603731] Starting subtest: cursor-rotation-180
[414.039900] Subtest cursor-rotation-180: SUCCESS (1.435s)
[415.232727] [096/131] (609s left) kms_lease (multimaster-lease)
[415.338090] Starting subtest: multimaster-lease
[415.343176] Subtest multimaster-lease: SUCCESS (0.004s)
[415.432190] [097/131] (609s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[415.495304] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[415.497867] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[415.580179] [098/131] (609s left) kms_force_connector_basic (force-connector-state)
[415.667291] Starting subtest: force-connector-state
[416.264661] Subtest force-connector-state: SUCCESS (0.597s)
[417.164257] [099/131] (607s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[417.226750] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[417.229200] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[417.308475] [100/131] (607s left) kms_chamelium_frames (vga-frame-dump)
[417.696888] Subtest vga-frame-dump: SKIP (0.000s)
[418.439973] [101/131] (606s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[418.549780] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[418.554124] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[418.639076] [102/131] (606s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[418.734095] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[418.736419] Starting dynamic subtest: pipe-A-eDP-1
[418.760431] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.770342] Starting dynamic subtest: pipe-B-eDP-1
[418.793658] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.803060] Starting dynamic subtest: pipe-C-eDP-1
[418.827392] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.836727] Starting dynamic subtest: pipe-D-eDP-1
[418.861219] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.865298] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[420.953884] [103/131] (603s left) kms_draw_crc (draw-method-mmap-wc)
[421.057982] Starting subtest: draw-method-mmap-wc
[421.060097] Starting dynamic subtest: xrgb8888-untiled
[421.258062] Dynamic subtest xrgb8888-untiled: SUCCESS (0.202s)
[421.269652] Starting dynamic subtest: rgb565-untiled
[421.435801] Dynamic subtest rgb565-untiled: SUCCESS (0.177s)
[421.446299] Starting dynamic subtest: xrgb2101010-untiled
[421.613600] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.177s)
[421.623809] Starting dynamic subtest: xrgb8888-xtiled
[421.724735] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[421.734881] Starting dynamic subtest: rgb565-xtiled
[421.846853] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[421.857313] Starting dynamic subtest: xrgb2101010-xtiled
[421.946735] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[421.956402] Starting dynamic subtest: xrgb8888-4tiled
[422.091303] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[422.100729] Starting dynamic subtest: rgb565-4tiled
[422.235505] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[422.245034] Starting dynamic subtest: xrgb2101010-4tiled
[422.357664] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[422.359217] Subtest draw-method-mmap-wc: SUCCESS (1.304s)
[422.444869] [104/131] (602s left) kms_pm_rpm (fences)
[423.970481] Starting subtest: fences
[423.975691] Subtest fences: SKIP (0.000s)
[424.665940] [105/131] (600s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[424.768625] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[424.772636] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[424.861562] [106/131] (600s left) gem_exec_gttfill (all-engines)
[424.916721] Starting subtest: all-engines
[447.751991] Subtest all-engines: SUCCESS (22.832s)
[447.922348] [107/131] (576s left) perf_pmu (busy-accuracy-2)
[447.999643] Starting subtest: busy-accuracy-2
[448.002048] Starting dynamic subtest: rcs0
[451.057396] Dynamic subtest rcs0: SUCCESS (3.055s)
[451.070105] Starting dynamic subtest: bcs0
[454.121806] Dynamic subtest bcs0: SUCCESS (3.063s)
[454.133874] Starting dynamic subtest: vcs0
[457.172973] Dynamic subtest vcs0: SUCCESS (3.048s)
[457.183199] Starting dynamic subtest: vcs1
[460.226333] Dynamic subtest vcs1: SUCCESS (3.051s)
[460.237019] Starting dynamic subtest: vecs0
[463.271688] Dynamic subtest vecs0: SUCCESS (3.045s)
[463.283720] Starting dynamic subtest: ccs0
[466.333424] Dynamic subtest ccs0: SUCCESS (3.059s)
[466.335548] Subtest busy-accuracy-2: SUCCESS (18.331s)
[466.428011] [108/131] (558s left) syncobj_wait (wait-any-complex)
[466.501623] Starting subtest: wait-any-complex
[466.564392] Subtest wait-any-complex: SUCCESS (0.062s)
[466.624469] [109/131] (558s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[466.744663] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[469.274422] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.533s)
[469.380632] [110/131] (555s left) kms_flip (modeset-vs-vblank-race-interruptible)
[469.480173] Starting subtest: modeset-vs-vblank-race-interruptible
[469.484779] Starting dynamic subtest: A-eDP1
[474.161746] Dynamic subtest A-eDP1: SUCCESS (4.678s)
[474.174749] Starting dynamic subtest: B-eDP1
[478.862096] Dynamic subtest B-eDP1: SUCCESS (4.698s)
[478.874116] Starting dynamic subtest: C-eDP1
[483.541454] Dynamic subtest C-eDP1: SUCCESS (4.678s)
[483.552456] Starting dynamic subtest: D-eDP1
[488.136133] Dynamic subtest D-eDP1: SUCCESS (4.592s)
[488.138394] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.657s)
[489.346430] [111/131] (535s left) kms_cursor_crc (cursor-sliding-max-size)
[489.618878] Starting subtest: cursor-sliding-max-size
[489.625390] Subtest cursor-sliding-max-size: SKIP (0.000s)
[489.749279] [112/131] (535s left) gem_render_copy (yf-tiled-to-vebox-linear)
[489.827811] Starting subtest: yf-tiled-to-vebox-linear
[489.832135] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[489.990391] [113/131] (535s left) gem_ctx_persistence (engines-hostile-preempt)
[490.045732] Starting subtest: engines-hostile-preempt
[490.047943] Starting dynamic subtest: rcs0
[490.110086] Dynamic subtest rcs0: SUCCESS (0.064s)
[490.121899] Starting dynamic subtest: bcs0
[490.216798] Dynamic subtest bcs0: SUCCESS (0.106s)
[490.229530] Starting dynamic subtest: vcs0
[491.923255] Dynamic subtest vcs0: SUCCESS (1.704s)
[491.934325] Starting dynamic subtest: vcs1
[493.906615] Dynamic subtest vcs1: SUCCESS (1.981s)
[493.922283] Starting dynamic subtest: vecs0
[495.936447] Dynamic subtest vecs0: SUCCESS (2.028s)
[495.948450] Starting dynamic subtest: ccs0
[495.970456] Dynamic subtest ccs0: SUCCESS (0.034s)
[495.972912] Subtest engines-hostile-preempt: SUCCESS (5.925s)
[496.076149] [114/131] (528s left) gem_exec_reloc (basic-wc-gtt-active)
[496.144881] Subtest basic-wc-gtt-active: SKIP (0.000s)
[496.197533] [115/131] (528s left) gem_mmap_gtt (hang-busy)
[496.255280] Subtest hang-busy: SKIP (0.000s)
[496.309796] [116/131] (528s left) kms_setmode (basic)
[496.361113] Starting subtest: basic
[496.697594] Starting dynamic subtest: pipe-A-eDP-1
[498.754656] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.052s)
[499.098361] Starting dynamic subtest: pipe-B-eDP-1
[501.153201] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.059s)
[501.457664] Subtest basic: SUCCESS (5.093s)
[502.245563] [117/131] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[502.350492] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[502.354617] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[502.430201] [118/131] (522s left) kms_content_protection (legacy)
[502.577323] Starting subtest: legacy
[506.388944] Subtest legacy: SKIP (3.808s)
[507.544320] [119/131] (517s left) kms_big_fb (x-tiled-addfb)
[507.652961] Starting subtest: x-tiled-addfb
[507.655413] Subtest x-tiled-addfb: SUCCESS (0.000s)
[507.746368] [120/131] (517s left) kms_invalid_mode (bad-hsync-start)
[507.847364] Starting subtest: bad-hsync-start
[507.849687] Starting dynamic subtest: pipe-A-eDP-1
[508.128534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[508.139214] Starting dynamic subtest: pipe-B-eDP-1
[508.141542] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[508.151131] Starting dynamic subtest: pipe-C-eDP-1
[508.153066] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[508.162064] Starting dynamic subtest: pipe-D-eDP-1
[508.164076] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[508.166072] Subtest bad-hsync-start: SUCCESS (0.285s)
[508.945423] [121/131] (516s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[508.997660] Starting subtest: invalid-bsd1-flag-on-vebox
[509.000169] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[509.093168] [122/131] (516s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[509.197440] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[509.201606] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[509.275593] [123/131] (515s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[509.378798] Starting subtest: 4-tiled-64bpp-rotate-0
[510.749240] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.372s)
[510.932498] [124/131] (514s left) gem_exec_schedule (independent)
[511.013157] Starting subtest: independent
[511.015092] Starting dynamic subtest: rcs0
[512.939326] Dynamic subtest rcs0: SUCCESS (1.936s)
[512.952831] Starting dynamic subtest: vcs0
[514.933346] Dynamic subtest vcs0: SUCCESS (1.992s)
[514.946362] Starting dynamic subtest: vcs1
[516.942043] Dynamic subtest vcs1: SUCCESS (2.007s)
[516.955618] Starting dynamic subtest: vecs0
[518.988593] Dynamic subtest vecs0: SUCCESS (2.044s)
[519.001859] Starting dynamic subtest: ccs0
[520.939447] Dynamic subtest ccs0: SUCCESS (1.949s)
[520.942079] Subtest independent: SUCCESS (9.937s)
[521.224817] [125/131] (504s left) gem_userptr_blits (set-cache-level)
[521.288571] Starting subtest: set-cache-level
[521.292700] Subtest set-cache-level: SKIP (0.000s)
[521.395428] [126/131] (503s left) kms_addfb_basic (size-max)
[521.502252] Starting subtest: size-max
[521.504428] Subtest size-max: SUCCESS (0.000s)
[521.598224] [127/131] (503s left) syncobj_wait (single-wait-for-submit-submitted)
[521.655775] Starting subtest: single-wait-for-submit-submitted
[521.759881] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[521.816969] [128/131] (503s left) gem_pread (uncached)
[521.872096] Subtest uncached: SKIP (0.000s)
[521.907358] [129/131] (503s left) kms_psr (psr-primary-blt)
[522.011130] Starting subtest: psr-primary-blt
[522.013525] Starting dynamic subtest: eDP-1
[523.726287] Dynamic subtest eDP-1: SUCCESS (1.714s)
[523.728702] Subtest psr-primary-blt: SUCCESS (1.715s)
[524.540328] [130/131] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[524.647202] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[529.468591] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.824s)
[529.562964] [131/131] (495s left) gem_mmap (pf-nonblock)
[529.627474] Subtest pf-nonblock: SKIP (0.000s)
[529.661320] Closing watchdogs
Done.