sof-test: include test interval in kernel check point

The sof-framework will add a 5-second test interval
between two test cases. This patch makes the kernel
check point include this test interval to avoid log
loss.

And also rename func_lib_setup_kernel_check_point
to setup_kernel_check_point, because the prefix
doesn't provide much information.

Signed-off-by: Chao Song <chao.song@linux.intel.com>

Author: Chao Song

case-lib/config.sh

@@ -56,3 +56,8 @@ SUDO_LEVEL=${SUDO_LEVEL:-}
 # pipelines will be filtered out. Example:
 #
 # NO_HDMI_MODE=true
+
+# Test interval between two test cases, the default value is 5 seconds
+# in CI, which is controlled by sof-framework. In manual run, user can
+# override the default value.
+SOF_TEST_INTERVAL=${SOF_TEST_INTERVAL:-5}

case-lib/lib.sh

@@ -40,10 +40,11 @@ if [ ! "$SOFCARD" ]; then
 		awk '/sof-[a-z]/ && $1 ~ /^[0-9]+$/ { $1=$1; print $1; exit 0;}')
 fi
 
-func_lib_setup_kernel_checkpoint()
+setup_kernel_check_point()
 {
-    # shellcheck disable=SC2034 # external script will use it
-    KERNEL_CHECKPOINT=$(date +%s)
+    # Make the check point $SOF_TEST_INTERVAL second(s) earlier to avoid log loss.
+    # Note this may lead to an error caused by one test appear in the next one.
+    KERNEL_CHECKPOINT=$(($(date +%s) - $SOF_TEST_INTERVAL))
 }
 
 # This function adds a fake error to dmesg (which is always saved by
@@ -342,5 +343,5 @@ is_sof_used()
 journalctl_cmd()
 {
    journalctl -k -q --no-pager --utc --output=short-monotonic \
-     --no-hostname  "$@"
+     --no-hostname "$@"
 }

test-case/check-capture.sh

@@ -59,7 +59,7 @@ file_prefix=${OPT_VAL['f']}
 
 [[ ${OPT_VAL['s']} -eq 1 ]] && func_lib_start_log_collect
 
-func_lib_setup_kernel_checkpoint
+setup_kernel_check_point
 func_lib_check_sudo
 func_pipeline_export "$tplg" "type:capture & ${OPT_VAL['S']}"
 

test-case/check-fw-echo-reference.sh

@@ -44,7 +44,7 @@ frequency=${OPT_VAL['f']}
 [[ ${OPT_VAL['s']} -eq 1 ]] && func_lib_start_log_collect
 
 func_pipeline_export "$tplg" "echo:any"
-func_lib_setup_kernel_checkpoint
+setup_kernel_check_point
 
 if [ "$PIPELINE_COUNT" != "2" ]; then
     die "Only detect $PIPELINE_COUNT pipeline(s) from topology, but two are needed"

test-case/check-ipc-flood.sh

@@ -44,7 +44,7 @@ do
     # cleanup dmesg buffer for each iteration
     sudo dmesg -c > /dev/null
     # set up timestamp for each iteration
-    func_lib_setup_kernel_checkpoint
+    setup_kernel_check_point
     dlogi "===== [$i/$loop_cnt] loop Begin ====="
     dlogc "sudo bash -c 'echo $lpc_loop_cnt > $ipc_flood_dfs'"
     sudo bash -c "'echo $lpc_loop_cnt > $ipc_flood_dfs'"

test-case/check-keyword-detection.sh

@@ -55,7 +55,7 @@ duration=${OPT_VAL['d']}
 [[ ${OPT_VAL['s']} -eq 1 ]] && func_lib_start_log_collect
 
 func_pipeline_export "$tplg" "kpbm:any"
-func_lib_setup_kernel_checkpoint
+setup_kernel_check_point
 
 if test "$PIPELINE_COUNT" != "1"; then
     die "detected $PIPELINE_COUNT wov pipeline(s) from topology, but 1 is needed"

test-case/check-kmod-load-unload.sh

@@ -33,7 +33,7 @@ OPT_NAME['p']='pulseaudio'   OPT_DESC['p']='disable pulseaudio on the test proce
 OPT_HAS_ARG['p']=0             OPT_VAL['p']=1
 
 func_opt_parse_option "$@"
-func_lib_setup_kernel_checkpoint
+setup_kernel_check_point
 
 loop_cnt=${OPT_VAL['l']}
 
@@ -48,7 +48,7 @@ for idx in $(seq 1 $loop_cnt)
 do
     dlogi "===== Starting iteration $idx of $loop_cnt ====="
     ## - 1: remove module section
-    func_lib_setup_kernel_checkpoint
+    setup_kernel_check_point
 
     # After module removal, it takes about 10s for "aplay -l" to show
     # device list, within this 10s, it shows "no soundcard found". Here
@@ -78,7 +78,7 @@ do
     sof-kernel-log-check.sh "$KERNEL_CHECKPOINT" ||
         die "error found after kmod unload is real error, failing"
 
-    func_lib_setup_kernel_checkpoint
+    setup_kernel_check_point
     dlogi "run kmod/sof_insert.sh"
     sudo sof_insert.sh || {
         # FIXME: don't exit the status of dloge(). Use die()

test-case/check-pause-release-suspend-resume.sh

@@ -110,7 +110,7 @@ esac
 
 [[ ${OPT_VAL['s']} -eq 1 ]] && func_lib_start_log_collect
 
-func_lib_setup_kernel_checkpoint
+setup_kernel_check_point
 
 dlogi "Entering audio stream expect script with: $cmd -D $pcm -r $rate -c $channel -f $fmt -vv -i $dummy_file -q"
 dlogi "Will enter suspend-resume cycle during paused period of audio stream process"

test-case/check-pause-resume.sh

@@ -81,7 +81,7 @@ func_pipeline_export "$tplg" "type:$test_mode & ${OPT_VAL['S']}"
 for idx in $(seq 0 $((PIPELINE_COUNT - 1)))
 do
     # set up checkpoint for each iteration
-    func_lib_setup_kernel_checkpoint
+    setup_kernel_check_point
     channel=$(func_pipeline_parse_value "$idx" channel)
     rate=$(func_pipeline_parse_value "$idx" rate)
     fmt=$(func_pipeline_parse_value "$idx" fmt)

test-case/check-playback.sh

@@ -67,7 +67,7 @@ else
     dlogi "using $file as playback source"
 fi
 
-func_lib_setup_kernel_checkpoint
+setup_kernel_check_point
 func_lib_check_sudo
 func_pipeline_export "$tplg" "type:playback & ${OPT_VAL['S']}"