tests: lib: filter out SSP timeouts

In legacy SSP driver, DMA request request is enabled
during FIFO drain, causing DMA keeps filling FIFO
and preventing empty, which leads to timeout.
ERROR is logged by poll_for_register_delay()
while ssp_empty_tx_fifo() returns WARN,
so there is inconsistent error handling between
this two functions.

Issue#4369 describe issue on older firmware version.

Signed-off-by: Mateusz Junkier <mateusz.junkier@intel.com>

Author: majunkier

case-lib/lib.sh

@@ -547,13 +547,20 @@ check_error_in_fw_logfile()
         dloge "file NOT FOUND: '$1'"
         return 1
     }
+
+    # Filter out SSP timeout errors and check for remaining errors
+    SSP_timeout_msgs=(
+        -e 'poll timeout reg .* mask .* val .* us .*'
+        -e 'ssp_empty_tx_fifo() warning: timeout'
+    )
     # -B 2 shows the header line when the first etrace message is an ERROR
     # -A 1 shows whether the ERROR is last or not.
     if (set -x
-        grep -B 2 -A 1 -i --word-regexp -e 'ERR' -e 'ERROR' -e '<err>' -e OSError "$1"
+        grep -v "${SSP_timeout_msgs[@]}" "$1" | \
+            grep -B 2 -A 1 -i --word-regexp -e 'ERR' -e 'ERROR' -e '<err>' -e OSError
        ); then
         # See internal Intel bug #448
-        dlogw 'An HTML display bug hides the bracketed Zephyr &lt;loglevels&gt; in this tab,'
+        dlogw 'An HTML display bug hides the bracketed Zephyr <loglevels> in this tab,'
         dlogw 'switch to the tab with the complete logs to see the log levels.'
         return 1
     fi
@@ -578,10 +585,10 @@ func_lib_check_sudo()
 func_lib_enable_pipewire()
 {
     dlogi "Starting Pipewire..."
-    
+
     sudo systemctl --global unmask pipewire{,-pulse}.{socket,service}
     systemctl --user unmask pipewire{,-pulse}.{socket,service}
-    sudo systemctl --global unmask wireplumber.service 
+    sudo systemctl --global unmask wireplumber.service
     systemctl --user unmask wireplumber.service
 
     systemctl --user start pipewire{,-pulse}.{socket,service}
@@ -596,7 +603,7 @@ func_lib_enable_pipewire()
 func_lib_check_and_disable_pipewire()
 {
     dlogi "Check if pipewire is running"
-    
+
     if systemctl is-active --user --quiet pipewire{,-pulse}.{socket,service}; then func_lib_disable_pipewire; else dlogi "Pipewire not running"; fi
 }
 
@@ -835,7 +842,7 @@ extract_format_number() {
     else
         die "Error: Unknown format: %s\n"
     fi
-}  
+}
 
 # Initialize the parameters using for audio testing.
 # shellcheck disable=SC2034
@@ -984,7 +991,7 @@ arecord_opts()
             dlogc "arecord $SOF_ALSA_OPTS $SOF_ARECORD_OPTS $*"
             # shellcheck disable=SC2086
             arecord $SOF_ALSA_OPTS $SOF_ARECORD_OPTS "$@"
-        fi  
+        fi
     else
         die "Unknown ALSA tool: ${SOF_ALSA_TOOL}"
     fi
@@ -993,7 +1000,7 @@ arecord_opts()
 # Get the ID of the first sink/source of a given type, e.g. "Speaker" or "Headphones". Print an empty line if ID not found.
 get_id_of_pipewire_endpoint()
 {
-    # $ wpctl status returns list of all endpoints managed by wireplumber. We filter by given sink/source type, which returns something like this: 
+    # $ wpctl status returns list of all endpoints managed by wireplumber. We filter by given sink/source type, which returns something like this:
     # │  *   48. sof-soundwire Headphones            [vol: 0.40]  (or without the * when it's not the current default)
     # We filter out everything but ID, and only take the first line of the output (if there's more that one object of that type we ignore the rest)
 
@@ -1505,7 +1512,7 @@ check_soundfile_for_glitches()
         if [ -f "$result_filename" ]; then
             dlogi "Analyzing $result_filename file..."
             if python3 "$SCRIPT_HOME"/tools/analyze-wav.py "$result_filename"; then
-                dlogi "$result_filename file is correct" 
+                dlogi "$result_filename file is correct"
             else
                 dlogw "Found issues in $result_filename file"
                 glitched_files=$((glitched_files+1))