[60.384526] Initializing watchdogs
[60.384573]   /dev/watchdog0
[60.399298] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.403743] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.405982] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.409395] [001/132] (960s left) gem_exec_schedule (noreorder-corked)
[60.603974] Starting subtest: noreorder-corked
[60.606633] Starting dynamic subtest: rcs0
[61.752351] Dynamic subtest rcs0: SUCCESS (1.148s)
[61.762064] Starting dynamic subtest: vcs0
[62.928255] Dynamic subtest vcs0: SUCCESS (1.176s)
[62.936912] Starting dynamic subtest: vcs1
[64.920515] Dynamic subtest vcs1: SUCCESS (1.990s)
[64.928761] Starting dynamic subtest: vecs0
[66.882641] Dynamic subtest vecs0: SUCCESS (1.961s)
[66.893088] Starting dynamic subtest: ccs0
[68.133336] Dynamic subtest ccs0: SUCCESS (1.250s)
[68.135743] Subtest noreorder-corked: SUCCESS (7.529s)
[68.309072] [002/132] (952s left) gem_mmap_wc (write-read-distinct)
[68.371411] Subtest write-read-distinct: SKIP (0.000s)
[68.441488] [003/132] (952s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[68.556564] Starting subtest: y-tiled-32bpp-rotate-90
[68.560848] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[68.638965] [004/132] (952s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[68.721770] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[68.759745] Starting dynamic subtest: pipe-A-plane-0
[69.204987] Dynamic subtest pipe-A-plane-0: SUCCESS (0.446s)
[69.213777] Starting dynamic subtest: pipe-A-plane-3
[69.459073] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[69.467796] Starting dynamic subtest: pipe-A-plane-5
[69.471448] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[70.524991] Starting dynamic subtest: pipe-B-plane-0
[70.949165] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[70.957543] Starting dynamic subtest: pipe-B-plane-3
[71.204561] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[71.211803] Starting dynamic subtest: pipe-B-plane-5
[71.218741] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[71.525089] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.803s)
[72.398531] [005/132] (948s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[72.493647] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[72.496514] Starting dynamic subtest: pipe-A-eDP-1
[88.966061] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.476s)
[88.973923] Starting dynamic subtest: pipe-B-eDP-1
[106.153726] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.187s)
[106.156086] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.664s)
[106.965664] [006/132] (914s left) gem_exec_fence (submit-chain)
[107.151731] Starting subtest: submit-chain
[107.171310] Subtest submit-chain: SUCCESS (0.020s)
[108.960767] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[108.963880] [007/132] (912s left) gem_exec_create (madvise)
[109.024913] Starting subtest: madvise
[109.027365] Starting dynamic subtest: smem
[129.941593] Dynamic subtest smem: SUCCESS (20.914s)
[129.944026] Subtest madvise: SUCCESS (20.915s)
[130.753818] [008/132] (890s left) kms_prop_blob (invalid-get-prop)
[130.816793] Starting subtest: invalid-get-prop
[130.819204] Subtest invalid-get-prop: SUCCESS (0.000s)
[130.936709] [009/132] (890s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[131.041505] Starting subtest: x-tiled-16bpp-rotate-180
[132.365331] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.325s)
[132.511101] [010/132] (888s left) kms_flip_tiling (flip-change-tiling)
[132.607119] Starting subtest: flip-change-tiling
[132.609069] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[132.818582] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.212s)
[132.827874] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[132.964357] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.143s)
[132.973851] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[133.109071] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s)
[133.119951] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[133.252331] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.144s)
[133.263045] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[133.396119] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s)
[133.407107] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[133.540214] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[133.553620] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[133.674119] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.133s)
[133.684867] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[133.796527] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.121s)
[133.807131] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[133.931154] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[133.943840] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[134.086569] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.154s)
[134.096259] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[134.245849] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.160s)
[134.254780] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[134.379254] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.132s)
[134.389804] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[134.501859] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.121s)
[134.512339] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[134.636637] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[134.647252] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[134.757710] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.121s)
[134.768948] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[134.902040] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[134.913759] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[135.045662] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[135.055858] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[135.190261] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[135.200464] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[135.334729] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.144s)
[135.345574] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[135.480052] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[135.490773] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[135.635958] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.154s)
[135.649496] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[135.785062] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.148s)
[135.795606] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[135.939887] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.155s)
[135.949919] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[136.095241] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.154s)
[136.105504] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[136.239565] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[136.249583] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[136.384586] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.144s)
[136.394284] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[136.528726] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[136.538989] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[136.672823] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.143s)
[136.684920] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[136.795842] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.119s)
[136.811828] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[136.940691] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s)
[136.949973] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[137.084705] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[137.095202] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[137.229302] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[137.239616] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[137.384518] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.154s)
[137.396088] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[137.528504] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.143s)
[137.538483] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[137.684844] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.154s)
[137.696455] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[137.806980] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.121s)
[137.858123] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[139.065404] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.212s)
[139.075859] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[139.199822] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[139.210869] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[139.333668] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[139.343448] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[139.476481] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[139.486928] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[139.620979] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s)
[139.631804] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[139.764569] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[139.775029] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[139.898447] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s)
[139.911845] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[140.020733] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.121s)
[140.031085] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[140.156099] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[140.167259] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[140.298504] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[140.310030] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[140.442484] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[140.453220] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[140.587062] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s)
[140.598083] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[140.720970] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[140.730825] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[140.855235] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[140.864366] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[140.965064] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[140.973330] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[141.098582] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.132s)
[141.109314] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[141.242554] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[141.251749] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[141.387600] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[141.398999] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[141.531932] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[141.542812] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[141.676539] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[141.687693] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[141.820811] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.143s)
[141.831830] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[141.942568] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.121s)
[141.953059] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[142.086405] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s)
[142.096916] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[142.230999] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.143s)
[142.240667] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[142.375423] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[142.385228] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[142.519967] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s)
[142.530070] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[142.664475] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[142.675167] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[142.808980] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.143s)
[142.819837] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[142.958697] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.149s)
[142.969606] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[143.103406] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.143s)
[143.112594] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[143.247311] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[143.256293] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[143.391961] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[143.401709] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[143.536463] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[143.545746] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[143.680380] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.143s)
[143.690754] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[143.836603] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.154s)
[143.846904] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[143.958998] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.121s)
[144.010966] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[145.208987] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.204s)
[145.223295] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[145.308971] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[145.318133] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[145.408807] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[145.422975] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[145.519908] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[145.530975] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[145.630370] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[145.640827] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[145.741538] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[145.751601] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[145.841928] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[145.852594] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[145.942336] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[145.953341] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[146.042304] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[146.054546] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[146.153343] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[146.163725] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[146.263801] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[146.273994] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[146.374706] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[146.384277] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[146.474894] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[146.484079] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[146.575410] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[146.587074] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[146.675517] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[146.685642] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[146.775552] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.099s)
[146.785384] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[146.885864] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.111s)
[146.896311] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[146.996957] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[147.007075] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[147.097488] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[147.108060] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[147.197495] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[147.208112] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[147.309060] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s)
[147.319664] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[147.420029] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s)
[147.430627] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[147.530382] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.110s)
[147.540627] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[147.641626] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[147.651423] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[147.752938] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[147.765512] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[147.864151] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[147.874771] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[147.963611] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[147.974895] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[148.075158] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.111s)
[148.085268] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[148.197444] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.121s)
[148.207674] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[148.308743] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[148.322449] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[148.419551] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[148.429374] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[148.530860] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[148.541724] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[148.641811] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[148.651988] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[148.764526] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.121s)
[148.777734] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[148.886514] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.121s)
[148.896492] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[148.997903] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[149.038262] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[150.237576] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.204s)
[150.253482] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[150.337295] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[150.350350] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[150.437049] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[150.447683] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[150.548386] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[150.558860] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[150.658317] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[150.668911] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[150.780375] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.121s)
[150.790795] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[150.880720] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[150.891855] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[150.981031] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[150.992513] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[151.081614] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[151.092399] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[151.192326] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[151.202666] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[151.302917] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[151.312965] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[151.413790] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[151.424032] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[151.514455] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[151.524943] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[151.614388] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[151.629106] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[151.725598] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[151.735571] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[151.836473] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[151.847498] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[151.946931] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[151.956863] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[152.058040] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[152.068567] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[152.158376] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[152.168684] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[152.269986] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[152.280648] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[152.381270] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s)
[152.393013] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[152.503428] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.121s)
[152.513555] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[152.613731] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.110s)
[152.624084] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[152.725357] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[152.736107] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[152.825048] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s)
[152.835429] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[152.925126] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[152.935545] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[153.025189] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[153.036068] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[153.136363] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[153.147582] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[153.247631] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[153.258074] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[153.358941] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.110s)
[153.369313] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[153.469231] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[153.479954] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[153.581695] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[153.592110] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[153.680364] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.099s)
[153.690498] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[153.791818] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[153.802176] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[153.902909] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[153.912995] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[154.014596] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[154.047298] Subtest flip-change-tiling: SUCCESS (21.441s)
[155.247793] [011/132] (866s left) syncobj_timeline (invalid-wait-illegal-handle)
[155.302054] Starting subtest: invalid-wait-illegal-handle
[155.304081] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[155.393096] [012/132] (865s left) kms_psr (fbc-pr-primary-page-flip)
[155.500966] Starting subtest: fbc-pr-primary-page-flip
[155.505378] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[155.571503] [013/132] (865s left) gem_userptr_blits (sync-overlap)
[155.632715] Starting subtest: sync-overlap
[155.634892] Subtest sync-overlap: SUCCESS (0.000s)
[155.756249] [014/132] (865s left) gem_mmap_gtt (cpuset-big-copy)
[155.816200] Subtest cpuset-big-copy: SKIP (0.000s)
[155.874470] [015/132] (865s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[155.970983] Starting subtest: fbcpsr-modesetfrombusy
[162.129213] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.161s)
[162.280756] [016/132] (859s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[162.395063] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[162.398812] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[162.540866] [017/132] (859s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[162.639815] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[162.643357] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[162.729711] [018/132] (858s left) gem_exec_schedule (preempt-user)
[162.792870] Starting subtest: preempt-user
[162.794597] Starting dynamic subtest: rcs0
[162.812216] Dynamic subtest rcs0: SUCCESS (0.024s)
[162.822158] Starting dynamic subtest: bcs0
[162.830715] Dynamic subtest bcs0: SUCCESS (0.018s)
[162.838107] Starting dynamic subtest: vcs0
[162.850379] Dynamic subtest vcs0: SUCCESS (0.019s)
[162.857870] Starting dynamic subtest: vcs1
[162.871188] Dynamic subtest vcs1: SUCCESS (0.020s)
[162.878642] Starting dynamic subtest: vecs0
[162.890941] Dynamic subtest vecs0: SUCCESS (0.019s)
[162.898316] Starting dynamic subtest: ccs0
[162.917036] Dynamic subtest ccs0: SUCCESS (0.026s)
[162.918872] Subtest preempt-user: SUCCESS (0.129s)
[164.012766] [019/132] (857s left) gem_softpin (safe-alignment)
[164.079274] Starting subtest: safe-alignment
[164.107692] Subtest safe-alignment: SUCCESS (0.029s)
[165.970127] [020/132] (855s left) gen9_exec_parse (batch-zero-length)
[166.021679] Subtest batch-zero-length: SKIP (0.000s)
[166.089715] [021/132] (855s left) perf (invalid-oa-exponent)
[166.208379] Starting subtest: invalid-oa-exponent
[166.222877] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[166.267056] [022/132] (855s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[166.328978] Starting subtest: etime-multi-wait-all-available-unsubmitted
[166.435237] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[166.520080] [023/132] (855s left) gem_busy (semaphore)
[166.713717] Subtest semaphore: SKIP (0.000s)
[166.933056] [024/132] (854s left) gem_exec_flush (basic-wb-pro-default)
[166.995807] Starting subtest: basic-wb-pro-default
[172.487423] Subtest basic-wb-pro-default: SUCCESS (5.477s)
[172.663820] [025/132] (849s left) kms_flip (modeset-vs-vblank-race)
[172.755057] Starting subtest: modeset-vs-vblank-race
[172.756986] Starting dynamic subtest: A-eDP1
[177.497617] Dynamic subtest A-eDP1: SUCCESS (4.744s)
[177.507029] Starting dynamic subtest: B-eDP1
[182.468109] Dynamic subtest B-eDP1: SUCCESS (4.969s)
[182.481611] Starting dynamic subtest: C-eDP1
[187.092537] Dynamic subtest C-eDP1: SUCCESS (4.623s)
[187.100788] Starting dynamic subtest: D-eDP1
[191.727550] Dynamic subtest D-eDP1: SUCCESS (4.632s)
[191.732423] Subtest modeset-vs-vblank-race: SUCCESS (18.979s)
[192.901248] [026/132] (829s left) gem_exec_whisper (basic-contexts-forked)
[192.970673] Starting subtest: basic-contexts-forked
[216.502251] Subtest basic-contexts-forked: SUCCESS (23.527s)
[216.685805] [027/132] (805s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[216.781342] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[216.783620] Starting dynamic subtest: pipe-A-eDP-1
[217.546194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s)
[217.556079] Starting dynamic subtest: pipe-B-eDP-1
[219.348811] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.802s)
[219.358200] Starting dynamic subtest: pipe-C-eDP-1
[221.151898] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.802s)
[221.160586] Starting dynamic subtest: pipe-D-eDP-1
[222.993929] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.840s)
[222.996277] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.204s)
[224.207447] [028/132] (797s left) i915_query (engine-info)
[224.269355] Starting subtest: engine-info
[224.274265] Subtest engine-info: SUCCESS (0.005s)
[224.396872] [029/132] (797s left) sw_sync (timeline_closed)
[224.433735] Starting subtest: timeline_closed
[224.436105] Subtest timeline_closed: SUCCESS (0.000s)
[224.484576] [030/132] (797s left) syncobj_wait (multi-wait-submitted)
[224.538053] Starting subtest: multi-wait-submitted
[224.642065] Subtest multi-wait-submitted: SUCCESS (0.104s)
[224.718892] [031/132] (797s left) gem_exec_params (invalid-batch-start-offset)
[224.774658] Starting subtest: invalid-batch-start-offset
[224.780061] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[224.904835] [032/132] (797s left) gem_ctx_persistence (legacy-engines-hostile)
[224.966317] Starting subtest: legacy-engines-hostile
[224.968620] Starting dynamic subtest: render
[225.017509] Dynamic subtest render: SUCCESS (0.050s)
[225.027719] Starting dynamic subtest: bsd1
[225.111727] Dynamic subtest bsd1: SUCCESS (0.093s)
[225.125472] Starting dynamic subtest: bsd2
[225.228654] Dynamic subtest bsd2: SUCCESS (0.114s)
[225.242704] Starting dynamic subtest: blt
[225.316580] Dynamic subtest blt: SUCCESS (0.086s)
[225.327632] Starting dynamic subtest: vebox
[225.418495] Dynamic subtest vebox: SUCCESS (0.100s)
[225.420843] Subtest legacy-engines-hostile: SUCCESS (0.453s)
[225.498790] [033/132] (796s left) gem_exec_flush (basic-batch-kernel-default-wb)
[225.557410] Starting subtest: basic-batch-kernel-default-wb
[231.845860] Subtest basic-batch-kernel-default-wb: SUCCESS (6.288s)
[232.052686] [034/132] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[232.164636] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[236.675210] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.513s)
[237.823411] [035/132] (784s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[237.916459] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[238.740699] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s)
[238.901535] [036/132] (783s left) gem_ctx_isolation (preservation)
[238.956197] Starting subtest: preservation
[238.958344] Starting dynamic subtest: rcs0
[239.078534] Dynamic subtest rcs0: SUCCESS (0.122s)
[239.087188] Starting dynamic subtest: bcs0
[239.237155] Dynamic subtest bcs0: SUCCESS (0.158s)
[239.245875] Starting dynamic subtest: vcs0
[239.386887] Dynamic subtest vcs0: SUCCESS (0.148s)
[239.397893] Starting dynamic subtest: vcs1
[241.021740] Dynamic subtest vcs1: SUCCESS (1.634s)
[241.030544] Starting dynamic subtest: vecs0
[243.018970] Dynamic subtest vecs0: SUCCESS (1.997s)
[243.027903] Starting dynamic subtest: ccs0
[245.016068] Dynamic subtest ccs0: SUCCESS (1.995s)
[245.018821] Subtest preservation: SUCCESS (6.059s)
[245.246108] [037/132] (777s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[245.357336] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[245.361950] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[245.468360] [038/132] (776s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[245.590593] Starting subtest: basic-flip-before-cursor-varying-size
[246.536411] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.947s)
[247.349877] [039/132] (775s left) kms_async_flips (test-cursor)
[247.444531] Starting subtest: test-cursor
[247.834472] Starting dynamic subtest: pipe-A-eDP-1
[248.626515] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s)
[249.002105] Starting dynamic subtest: pipe-B-eDP-1
[249.760874] Dynamic subtest pipe-B-eDP-1: SKIP (0.761s)
[250.134834] Starting dynamic subtest: pipe-C-eDP-1
[250.887266] Dynamic subtest pipe-C-eDP-1: SKIP (0.760s)
[251.260893] Starting dynamic subtest: pipe-D-eDP-1
[252.028429] Dynamic subtest pipe-D-eDP-1: SKIP (0.771s)
[252.033103] Subtest test-cursor: SKIP (4.580s)
[253.207233] [040/132] (769s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[253.298188] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[253.300493] Starting dynamic subtest: pipe-A-default-mode
[256.061987] Dynamic subtest pipe-A-default-mode: SUCCESS (2.764s)
[256.064415] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.765s)
[256.895175] [041/132] (765s left) kms_cursor_crc (cursor-random-128x42)
[257.121691] Starting subtest: cursor-random-128x42
[257.169341] Subtest cursor-random-128x42: SKIP (0.043s)
[257.376657] [042/132] (765s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[257.476910] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[257.479189] Starting dynamic subtest: pipe-A-eDP-1
[257.501490] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[257.511338] Starting dynamic subtest: pipe-B-eDP-1
[257.532174] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[257.540499] Starting dynamic subtest: pipe-C-eDP-1
[257.561862] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[257.570060] Starting dynamic subtest: pipe-D-eDP-1
[257.592126] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[257.596565] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[259.769890] [043/132] (762s left) perf (low-oa-exponent-permissions)
[259.867773] Starting subtest: low-oa-exponent-permissions
[259.904660] Subtest low-oa-exponent-permissions: SUCCESS (0.037s)
[259.951738] [044/132] (762s left) syncobj_timeline (single-wait-signaled)
[260.016805] Starting subtest: single-wait-signaled
[260.019094] Subtest single-wait-signaled: SUCCESS (0.001s)
[260.114223] [045/132] (762s left) kms_vblank (invalid)
[260.205652] Starting subtest: invalid
[260.207729] Starting dynamic subtest: pipe-A-eDP-1
[260.618348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.412s)
[260.620753] Subtest invalid: SUCCESS (0.413s)
[261.494747] [046/132] (761s left) kms_content_protection (mei-interface)
[261.630819] Starting subtest: mei-interface
[261.635541] Subtest mei-interface: SKIP (0.001s)
[261.750791] [047/132] (761s left) kms_dsc (dsc-with-output-formats-with-bpc)
[261.833056] Starting subtest: dsc-with-output-formats-with-bpc
[261.889333] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[261.930261] [048/132] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[262.039076] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[262.043226] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[262.145758] [049/132] (760s left) gem_userptr_blits (create-destroy-sync)
[262.209664] Starting subtest: create-destroy-sync
[267.287592] Subtest create-destroy-sync: SUCCESS (5.018s)
[267.337821] [050/132] (755s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[267.439438] Starting subtest: yf-tiled-8bpp-rotate-90
[267.443542] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[267.527859] [051/132] (755s left) kms_flip (2x-plain-flip-fb-recreate)
[267.620810] Starting subtest: 2x-plain-flip-fb-recreate
[267.631259] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[267.712169] [052/132] (755s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[267.774109] Starting subtest: y-tiled-ccs-to-x-tiled
[267.779082] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[267.979666] [053/132] (755s left) kms_psr (psr2-cursor-mmap-gtt)
[268.067060] Starting subtest: psr2-cursor-mmap-gtt
[268.069351] Starting dynamic subtest: eDP-1
[269.765476] Dynamic subtest eDP-1: SUCCESS (1.699s)
[269.767832] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.700s)
[270.570548] [054/132] (752s left) api_intel_allocator (two-level-inception-interruptible)
[270.629660] Starting subtest: two-level-inception-interruptible
[276.084620] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[276.166528] [055/132] (746s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[276.297324] Starting subtest: short-flip-after-cursor-atomic-transitions
[277.266771] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.969s)
[278.106749] [056/132] (745s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[278.231076] Starting subtest: basic-flip-after-cursor-legacy
[279.165420] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.935s)
[280.044424] [057/132] (743s left) kms_pm_rpm (drm-resources-equal)
[282.070900] Starting subtest: drm-resources-equal
[287.113193] Subtest drm-resources-equal: SUCCESS (5.039s)
[287.200931] [058/132] (736s left) kms_getfb (getfb-handle-zero)
[287.287095] Starting subtest: getfb-handle-zero
[287.289426] Subtest getfb-handle-zero: SUCCESS (0.000s)
[287.393754] [059/132] (735s left) kms_addfb_basic (bad-pitch-0)
[287.450118] Starting subtest: bad-pitch-0
[287.452319] Subtest bad-pitch-0: SUCCESS (0.000s)
[287.606317] [060/132] (735s left) kms_psr (psr-sprite-blt)
[287.709543] Starting subtest: psr-sprite-blt
[287.711638] Starting dynamic subtest: eDP-1
[289.471305] Dynamic subtest eDP-1: SUCCESS (1.762s)
[289.473621] Subtest psr-sprite-blt: SUCCESS (1.764s)
[290.302812] [061/132] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[290.400125] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[290.403992] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[290.495974] [062/132] (732s left) kms_chamelium_frames (hdmi-crc-single)
[290.870259] Subtest hdmi-crc-single: SKIP (0.000s)
[291.732334] [063/132] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[291.838401] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[291.842375] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.938147] [064/132] (731s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[292.033673] Starting subtest: primary-yf-tiled-reflect-x-180
[292.104660] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.071s)
[292.210441] [065/132] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[292.307943] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[292.311910] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[292.422767] [066/132] (731s left) kms_invalid_mode (bad-hsync-start)
[292.515581] Starting subtest: bad-hsync-start
[292.517808] Starting dynamic subtest: pipe-A-eDP-1
[292.805606] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[292.815090] Starting dynamic subtest: pipe-B-eDP-1
[292.817632] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[292.826186] Starting dynamic subtest: pipe-C-eDP-1
[292.828445] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[292.836849] Starting dynamic subtest: pipe-D-eDP-1
[292.839201] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[292.841513] Subtest bad-hsync-start: SUCCESS (0.295s)
[293.686751] [067/132] (729s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[293.786702] Starting subtest: pr-plane-move-sf-dmg-area
[293.791211] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[293.865781] [068/132] (729s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[293.960120] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[293.964266] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[294.059088] [069/132] (729s left) kms_plane (pixel-format-y-tiled-modifier)
[294.145146] Starting subtest: pixel-format-y-tiled-modifier
[294.149205] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[294.230420] [070/132] (729s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[294.320235] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[294.324889] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[295.492116] [071/132] (728s left) prime_busy (after-wait)
[295.540267] Starting subtest: after-wait
[295.545698] Starting dynamic subtest: rcs0
[295.579860] Dynamic subtest rcs0: SUCCESS (0.036s)
[295.590054] Starting dynamic subtest: bcs0
[295.620241] Dynamic subtest bcs0: SUCCESS (0.040s)
[295.629325] Starting dynamic subtest: vcs0
[295.662921] Dynamic subtest vcs0: SUCCESS (0.042s)
[295.677550] Starting dynamic subtest: vcs1
[295.704252] Dynamic subtest vcs1: SUCCESS (0.040s)
[295.713120] Starting dynamic subtest: vecs0
[295.745064] Dynamic subtest vecs0: SUCCESS (0.040s)
[295.754182] Starting dynamic subtest: ccs0
[295.785726] Dynamic subtest ccs0: SUCCESS (0.039s)
[295.893609] Subtest after-wait: SUCCESS (0.351s)
[295.969121] [072/132] (727s left) kms_vblank (wait-forked)
[296.061816] Starting subtest: wait-forked
[296.064099] Starting dynamic subtest: pipe-A-eDP-1
[297.872417] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[297.886666] Starting dynamic subtest: pipe-D-eDP-1
[300.375836] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.503s)
[300.378033] Subtest wait-forked: SUCCESS (4.317s)
[301.250534] [073/132] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[301.352262] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[301.356714] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[301.450916] [074/132] (722s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[301.532877] Starting subtest: nonblocking-crc-frame-sequence
[301.535148] Starting dynamic subtest: pipe-A-eDP-1
[302.305162] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.771s)
[302.326053] Starting dynamic subtest: pipe-B-eDP-1
[303.766379] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.458s)
[303.776946] Starting dynamic subtest: pipe-C-eDP-1
[305.166245] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[305.175776] Starting dynamic subtest: pipe-D-eDP-1
[306.499207] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[306.501567] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.968s)
[307.314451] [075/132] (716s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[307.415493] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[314.551929] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.139s)
[314.689205] [076/132] (709s left) gem_eio (in-flight-external)
[314.932367] Starting subtest: in-flight-external
[315.998145] Subtest in-flight-external: SUCCESS (1.065s)
[316.144425] [077/132] (707s left) gem_create (create-ext-cpu-access-sanity-check)
[316.312989] Starting subtest: create-ext-cpu-access-sanity-check
[316.318158] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[316.393445] [078/132] (707s left) prime_mmap (test_userptr)
[316.442116] Starting subtest: test_userptr
[316.444403] Starting dynamic subtest: test_userptr-smem
[316.446361] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[316.448278] Subtest test_userptr: SUCCESS (0.001s)
[316.552335] [079/132] (707s left) perf_pmu (invalid-open)
[316.599320] Starting subtest: invalid-open
[316.601507] Subtest invalid-open: SUCCESS (0.000s)
[316.697263] [080/132] (707s left) kms_psr (pr-primary-mmap-cpu)
[316.802607] Starting subtest: pr-primary-mmap-cpu
[316.806777] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[316.875207] [081/132] (707s left) perf_pmu (busy-accuracy-98)
[316.911280] Starting subtest: busy-accuracy-98
[316.913649] Starting dynamic subtest: rcs0
[319.947969] Dynamic subtest rcs0: SUCCESS (3.037s)
[319.959587] Starting dynamic subtest: bcs0
[323.053504] Dynamic subtest bcs0: SUCCESS (3.052s)
[323.063942] Starting dynamic subtest: vcs0
[326.097793] Dynamic subtest vcs0: SUCCESS (3.043s)
[326.108817] Starting dynamic subtest: vcs1
[329.139483] Dynamic subtest vcs1: SUCCESS (3.041s)
[329.150425] Starting dynamic subtest: vecs0
[332.181730] Dynamic subtest vecs0: SUCCESS (3.042s)
[332.192799] Starting dynamic subtest: ccs0
[335.236094] Dynamic subtest ccs0: SUCCESS (3.049s)
[335.238055] Subtest busy-accuracy-98: SUCCESS (18.277s)
[335.324664] [082/132] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[335.433624] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[335.437732] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[335.541858] [083/132] (688s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[335.651740] Starting subtest: cursorB-vs-flipB-atomic
[335.656274] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[335.802060] [084/132] (688s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[335.897716] Starting subtest: addfb25-y-tiled-small-legacy
[335.902183] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[335.998296] [085/132] (688s left) gem_pwrite (basic-exhaustion)
[336.065735] Subtest basic-exhaustion: SKIP (0.000s)
[336.131936] [086/132] (688s left) gem_exec_balancer (parallel-keep-submit-fence)
[336.401966] Starting subtest: parallel-keep-submit-fence
[337.542774] Subtest parallel-keep-submit-fence: SUCCESS (1.140s)
[337.647366] [087/132] (686s left) gem_readwrite (beyond-eob)
[337.706626] Subtest beyond-EOB: SKIP (0.000s)
[337.765269] [088/132] (686s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[337.851689] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[337.855493] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[337.959044] [089/132] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[338.059214] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[338.062834] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[338.176384] [090/132] (686s left) gem_workarounds (suspend-resume)
[338.237730] Starting subtest: suspend-resume
[355.067251] Subtest suspend-resume: SUCCESS (2.413s)
[367.276968] [091/132] (669s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[367.406750] Starting subtest: plane-upscale-20x20-with-pixel-format
[367.408859] Starting dynamic subtest: pipe-A
[368.454995] Dynamic subtest pipe-A: SUCCESS (1.050s)
[368.464755] Starting dynamic subtest: pipe-B
[370.556107] Dynamic subtest pipe-B: SUCCESS (2.099s)
[370.566564] Starting dynamic subtest: pipe-C
[371.761224] Dynamic subtest pipe-C: SUCCESS (1.203s)
[371.771708] Starting dynamic subtest: pipe-D
[372.907108] Dynamic subtest pipe-D: SUCCESS (1.144s)
[372.909456] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.501s)
[374.121596] [092/132] (662s left) kms_cursor_edge_walk (128x128-top-bottom)
[374.210440] Starting subtest: 128x128-top-bottom
[374.213249] Starting dynamic subtest: pipe-A-eDP-1
[377.701295] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s)
[377.711758] Starting dynamic subtest: pipe-D-eDP-1
[380.906228] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.201s)
[380.908138] Subtest 128x128-top-bottom: SUCCESS (6.695s)
[381.718255] [093/132] (655s left) gem_wait (write-busy)
[381.772166] Starting subtest: write-busy
[381.774919] Starting dynamic subtest: all-engines
[382.381085] Dynamic subtest all-engines: SUCCESS (0.607s)
[382.400402] Starting dynamic subtest: rcs0
[382.940992] Dynamic subtest rcs0: SUCCESS (0.557s)
[382.956759] Starting dynamic subtest: bcs0
[383.495272] Dynamic subtest bcs0: SUCCESS (0.554s)
[383.513127] Starting dynamic subtest: vcs0
[385.316178] Dynamic subtest vcs0: SUCCESS (1.818s)
[385.333025] Starting dynamic subtest: vcs1
[387.299616] Dynamic subtest vcs1: SUCCESS (1.981s)
[387.316589] Starting dynamic subtest: vecs0
[389.348210] Dynamic subtest vecs0: SUCCESS (2.045s)
[389.365082] Starting dynamic subtest: ccs0
[389.899387] Dynamic subtest ccs0: SUCCESS (0.550s)
[389.902049] Subtest write-busy: SUCCESS (8.125s)
[390.112647] [094/132] (646s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[390.173042] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[390.175311] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[390.268827] [095/132] (646s left) kms_plane_multiple (tiling-4)
[390.358549] Starting subtest: tiling-4
[390.360890] Starting dynamic subtest: pipe-A-eDP-1
[394.054740] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.695s)
[394.074553] Starting dynamic subtest: pipe-B-eDP-1
[398.410185] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.352s)
[398.420244] Starting dynamic subtest: pipe-C-eDP-1
[402.732687] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.322s)
[402.744235] Starting dynamic subtest: pipe-D-eDP-1
[407.072981] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.336s)
[407.074931] Subtest tiling-4: SUCCESS (16.711s)
[407.893573] [096/132] (629s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[407.994781] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[407.998710] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[408.080442] [097/132] (628s left) gem_ctx_shared (q-out-order)
[408.147180] Starting subtest: Q-out-order
[408.149412] Starting dynamic subtest: rcs0
[408.240698] Dynamic subtest rcs0: SUCCESS (0.096s)
[408.256363] Starting dynamic subtest: vcs0
[408.325372] Dynamic subtest vcs0: SUCCESS (0.084s)
[408.342413] Starting dynamic subtest: vcs1
[408.403147] Dynamic subtest vcs1: SUCCESS (0.076s)
[408.420899] Starting dynamic subtest: vecs0
[408.482253] Dynamic subtest vecs0: SUCCESS (0.076s)
[408.499688] Starting dynamic subtest: ccs0
[408.566936] Dynamic subtest ccs0: SUCCESS (0.083s)
[408.569411] Subtest Q-out-order: SUCCESS (0.423s)
[410.361028] [098/132] (626s left) sysfs_timeslice_duration (timeout)
[410.411232] Starting subtest: timeout
[410.413532] Starting dynamic subtest: vecs0
[420.316709] Dynamic subtest vecs0: SUCCESS (9.900s)
[420.336462] Starting dynamic subtest: ccs0
[421.575733] Dynamic subtest ccs0: SUCCESS (1.258s)
[421.588230] Starting dynamic subtest: vcs0
[431.329687] Dynamic subtest vcs0: SUCCESS (9.749s)
[431.341686] Starting dynamic subtest: bcs0
[431.981375] Dynamic subtest bcs0: SUCCESS (0.652s)
[431.991491] Starting dynamic subtest: rcs0
[433.206557] Dynamic subtest rcs0: SUCCESS (1.223s)
[433.216621] Starting dynamic subtest: vcs1
[442.337133] Dynamic subtest vcs1: SUCCESS (9.125s)
[442.339638] Subtest timeout: SUCCESS (31.920s)
[442.417285] [099/132] (594s left) gem_exec_reloc (basic-write-cpu-active)
[442.484792] Subtest basic-write-cpu-active: SKIP (0.000s)
[442.558065] [100/132] (594s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[442.665781] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[442.670395] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[443.823928] [101/132] (593s left) kms_properties (crtc-properties-legacy)
[443.917672] Starting subtest: crtc-properties-legacy
[443.920009] Starting dynamic subtest: pipe-A-eDP-1
[444.360246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[444.371288] Starting dynamic subtest: pipe-B-eDP-1
[445.484576] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.120s)
[445.495558] Starting dynamic subtest: pipe-C-eDP-1
[446.616440] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[446.627336] Starting dynamic subtest: pipe-D-eDP-1
[447.748185] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[447.750513] Subtest crtc-properties-legacy: SUCCESS (3.832s)
[448.557693] [102/132] (588s left) kms_lease (lease-unleased-connector)
[448.648486] Starting subtest: lease-unleased-connector
[448.650672] Starting dynamic subtest: pipe-A-eDP-1
[448.657929] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.009s)
[448.667998] Starting dynamic subtest: pipe-B-eDP-1
[448.670252] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[448.680776] Starting dynamic subtest: pipe-C-eDP-1
[448.683063] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[448.692678] Starting dynamic subtest: pipe-D-eDP-1
[448.694649] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[448.696616] Subtest lease-unleased-connector: SUCCESS (0.037s)
[448.819221] [103/132] (588s left) i915_drm_fdinfo (virtual-busy)
[448.861117] Starting subtest: virtual-busy
[448.865644] Subtest virtual-busy: SKIP (0.000s)
[448.930015] [104/132] (588s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[449.034466] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[449.044402] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[449.128311] [105/132] (588s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[449.244643] Starting subtest: plane-lut1d-ctm3x4-lut1d
[449.465618] Starting dynamic subtest: pipe-A-plane-0
[449.815399] Dynamic subtest pipe-A-plane-0: FAIL (0.207s)
[449.824865] Starting dynamic subtest: pipe-A-plane-1
[450.015420] Dynamic subtest pipe-A-plane-1: FAIL (0.171s)
[450.028373] Starting dynamic subtest: pipe-A-plane-2
[450.238216] Dynamic subtest pipe-A-plane-2: FAIL (0.184s)
[451.292827] Starting dynamic subtest: pipe-B-plane-0
[451.757858] Dynamic subtest pipe-B-plane-0: FAIL (0.196s)
[451.768231] Starting dynamic subtest: pipe-B-plane-1
[452.085883] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[452.096057] Starting dynamic subtest: pipe-B-plane-2
[452.396440] Dynamic subtest pipe-B-plane-2: FAIL (0.176s)
[452.995431] Starting dynamic subtest: pipe-C-plane-0
[453.508777] Dynamic subtest pipe-C-plane-0: FAIL (0.152s)
[453.519728] Starting dynamic subtest: pipe-C-plane-1
[453.915138] Dynamic subtest pipe-C-plane-1: FAIL (0.625s)
[453.925763] Starting dynamic subtest: pipe-C-plane-2
[454.312041] Dynamic subtest pipe-C-plane-2: FAIL (0.193s)
[455.142288] Starting dynamic subtest: pipe-D-plane-0
[455.778621] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[455.790515] Starting dynamic subtest: pipe-D-plane-1
[456.265384] Dynamic subtest pipe-D-plane-1: FAIL (0.634s)
[456.275990] Starting dynamic subtest: pipe-D-plane-2
[456.736566] Dynamic subtest pipe-D-plane-2: FAIL (0.559s)
[456.794144] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (7.548s)
[457.609701] [106/132] (579s left) i915_pm_rpm (system-suspend-devices)
[459.450298] Starting subtest: system-suspend-devices
[467.152108] Subtest system-suspend-devices: SUCCESS (7.702s)
[476.614172] [107/132] (569s left) gem_mmap_offset (partial-unmap)
[476.687506] Starting subtest: partial-unmap
[476.689870] Starting dynamic subtest: smem0
[477.167483] Dynamic subtest smem0: SUCCESS (0.480s)
[477.170036] Subtest partial-unmap: SUCCESS (0.481s)
[477.299843] [108/132] (569s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[477.409822] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[478.501482] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.092s)
[478.639758] [109/132] (567s left) kms_getfb (getfb2-handle-not-fb)
[478.728031] Starting subtest: getfb2-handle-not-fb
[478.729700] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[478.820465] [110/132] (567s left) kms_chamelium_hpd (vga-hpd-fast)
[479.200203] Subtest vga-hpd-fast: SKIP (0.000s)
[480.074321] [111/132] (566s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[480.177631] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[480.179862] Starting dynamic subtest: pipe-A-eDP-1
[480.188564] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[480.203531] Starting dynamic subtest: pipe-B-eDP-1
[480.212035] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[480.227087] Starting dynamic subtest: pipe-C-eDP-1
[480.235332] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[480.250042] Starting dynamic subtest: pipe-D-eDP-1
[480.258247] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[480.262114] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[482.420793] [112/132] (564s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[482.514170] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[482.518392] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[482.589581] [113/132] (564s left) gem_exec_reloc (basic-wc-read-active)
[482.641921] Subtest basic-wc-read-active: SKIP (0.000s)
[482.711927] [114/132] (564s left) gem_render_copy (yf-tiled)
[482.766061] Starting subtest: yf-tiled
[482.770725] Subtest yf-tiled: SKIP (0.000s)
[482.948763] [115/132] (563s left) gem_exec_whisper (basic-queues-forked-all)
[483.009586] Starting subtest: basic-queues-forked-all
[502.593705] Subtest basic-queues-forked-all: SUCCESS (19.577s)
[502.777988] [116/132] (544s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[502.836447] Starting subtest: single-wait-all-for-submit-unsubmitted
[502.944978] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[503.024058] [117/132] (543s left) kms_cursor_legacy (forked-bo)
[503.153273] Starting subtest: forked-bo
[503.155254] Starting dynamic subtest: pipe-A
[508.662717] Dynamic subtest pipe-A: SUCCESS (5.454s)
[508.675439] Starting dynamic subtest: pipe-B
[514.142455] Dynamic subtest pipe-B: SUCCESS (5.478s)
[514.159728] Starting dynamic subtest: pipe-C
[519.617029] Dynamic subtest pipe-C: SUCCESS (5.472s)
[519.629703] Starting dynamic subtest: pipe-D
[525.125491] Dynamic subtest pipe-D: SUCCESS (5.505s)
[525.147559] Starting dynamic subtest: all-pipes
[530.659469] Dynamic subtest all-pipes: SUCCESS (5.530s)
[530.662069] Subtest forked-bo: SUCCESS (27.453s)
[530.771175] [118/132] (516s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[530.891396] Starting subtest: 4-tiled-64bpp-rotate-180
[532.391501] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.500s)
[532.584768] [119/132] (514s left) gem_eio (wait-immediate)
[532.809005] Starting subtest: wait-immediate
[533.175933] Subtest wait-immediate: SUCCESS (0.367s)
[533.311847] [120/132] (513s left) api_intel_bb (object-reloc-purge-cache)
[533.365806] Starting subtest: object-reloc-purge-cache
[533.370233] Subtest object-reloc-purge-cache: SKIP (0.002s)
[533.490510] [121/132] (513s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[533.586699] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[541.132179] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.548s)
[541.245205] [122/132] (505s left) gem_exec_balancer (noheartbeat)
[541.521257] Starting subtest: noheartbeat
[541.525916] Subtest noheartbeat: SKIP (0.000s)
[541.625761] [123/132] (505s left) core_getversion (basic)
[541.669175] Starting subtest: basic
[541.673530] Subtest basic: SUCCESS (0.000s)
[541.735900] [124/132] (505s left) gem_fence_thrash (bo-write-verify-none)
[541.775918] Starting subtest: bo-write-verify-none
[541.801218] Subtest bo-write-verify-none: SKIP (0.027s)
[541.861085] [125/132] (505s left) kms_pm_rpm (modeset-non-lpsp)
[543.408225] Starting subtest: modeset-non-lpsp
[544.566914] Subtest modeset-non-lpsp: SKIP (1.156s)
[544.948480] [126/132] (502s left) kms_flip (2x-flip-vs-panning-interruptible)
[545.044114] Starting subtest: 2x-flip-vs-panning-interruptible
[545.055921] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[545.133647] [127/132] (502s left) i915_drm_fdinfo (virtual-busy-idle-all)
[545.178744] Starting subtest: virtual-busy-idle-all
[545.183406] Subtest virtual-busy-idle-all: SKIP (0.000s)
[545.243405] [128/132] (502s left) kms_psr (fbc-psr-primary-page-flip)
[545.335353] Starting subtest: fbc-psr-primary-page-flip
[545.337469] Starting dynamic subtest: eDP-1
[545.341376] Dynamic subtest eDP-1: SKIP (0.000s)
[545.345333] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[545.410575] [129/132] (502s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[545.482697] Starting subtest: y-tiled-to-vebox-y-tiled
[545.487648] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[545.690142] [130/132] (501s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[545.782821] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[545.786812] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[545.893397] [131/132] (501s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[545.949690] Starting subtest: etime-single-wait-for-submit-unsubmitted
[546.055435] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[546.133069] [132/132] (501s left) kms_cursor_crc (cursor-alpha-transparent)
[546.217562] Starting subtest: cursor-alpha-transparent
[546.219782] Starting dynamic subtest: pipe-A-eDP-1
[546.824916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[546.835980] Starting dynamic subtest: pipe-D-eDP-1
[548.111854] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.283s)
[548.114076] Subtest cursor-alpha-transparent: SUCCESS (1.894s)
[548.912312] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_mmap_wc
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: gem_exec_create
results: parsing output: 7/ for test: kms_prop_blob
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_flip_tiling
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_softpin
results: parsing output: 19/ for test: gen9_exec_parse
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_busy
results: parsing output: 23/ for test: gem_exec_flush
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: gem_exec_whisper
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: i915_query
results: parsing output: 28/ for test: sw_sync
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: gem_exec_flush
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_ctx_isolation
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_async_flips
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: kms_dsc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: api_intel_allocator
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: kms_getfb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_chamelium_frames
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_invalid_mode
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: kms_vblank
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_pipe_crc_basic
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: gem_create
results: parsing output: 77/ for test: prime_mmap
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: gem_pwrite
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: gem_readwrite
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_workarounds
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_cursor_edge_walk
results: parsing output: 92/ for test: gem_wait
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_plane_multiple
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_shared
results: parsing output: 97/ for test: sysfs_timeslice_duration
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_properties
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: i915_drm_fdinfo
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_color_pipeline
results: parsing output: 105/ for test: i915_pm_rpm
results: parsing output: 106/ for test: gem_mmap_offset
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_getfb
results: parsing output: 109/ for test: kms_chamelium_hpd
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: core_getversion
results: parsing output: 123/ for test: gem_fence_thrash
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: i915_drm_fdinfo
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_cursor_crc
Done.