tests: zlogger nominally runs the daemon
[platform/core/system/dlog.git] / tests / dlog_test.in
index 607d2fc..bb4b3f0 100644 (file)
@@ -7,25 +7,6 @@
 
 source dlog_test_header
 
-#relevant pids default vals
-UTIL_PID=-1
-DLOGSEND_PID=-1
-MT_TEST=-1
-LOGGER=-1
-TEST_DYNAMIC_FILTERS=true
-
-
-cleanup() {
-       [ "$UTIL_PID" -ne -1 ] && kill "$UTIL_PID" > /dev/null 2>&1
-       [ "$MT_TEST"  -ne -1 ] && kill "$MT_TEST"  > /dev/null 2>&1
-       [ "$LOGGER"   -ne -1 ] && kill "$LOGGER"   > /dev/null 2>&1
-       # Shellcheck doesn't like this because the rm call is bad if $TESTDIR is empty.
-       # However, such cases would be caught by the conditional.
-       # shellcheck disable=SC2115
-       [ -d "$TESTDIR" ] && rm -rf "$TESTDIR"/*
-       [ -d "$RUNTIME_FILTERS_DIR" ] && rm -rf "$RUNTIME_FILTERS_DIR"
-}
-
 trap cleanup 0
 
 USAGE_MESSAGE="usage: $0 [--verbose] [--quick] pipe|logger|zero-copy"
@@ -106,50 +87,9 @@ if [ "$type" != "zero-copy" ]; then # These tests are inherently dynamic.
        RUNTIME_FILTERS_DIR="/tmp/dlog-filters/"
        mkdir -m 777 -p "$RUNTIME_FILTERS_DIR"
 
-       PREEARLYQUIT_CONFIG_PATH="$DLOG_CONFIG_PATH"
-       DLOG_CONFIG_PATH="$TESTDIR/earlyquit.conf"
        if [ "$quick" -ne 1 ]; then
-               for PERSISTENT in 1 0; do
-               for KMSG in 1 0; do
-               for SYSLOG in 1 0; do
-               for QOS in 1 0; do
-                       # TODO: Does syslog even work? Disabling for now.
-                       [ "$SYSLOG" -eq 1 ] && continue
-
-                       if [ "$QOS" -eq 1 ]; then
-                               SOURCE="@datadir@/dlog-$type.conf.qos"
-                       else
-                               SOURCE="@datadir@/dlog-$type.conf.test"
-                       fi
-
-                       if [ "$PERSISTENT" -eq 1 ]; then
-                               cp "$SOURCE" "$DLOG_CONFIG_PATH"
-                       else
-                               sed 's/^dlog_logger_conf.*$/#\0/' <"$SOURCE" >"$DLOG_CONFIG_PATH"
-                       fi
-
-                       echo "handle_kmsg=$KMSG" >> "$DLOG_CONFIG_PATH"
-                       echo "syslog_force=$SYSLOG" >> "$DLOG_CONFIG_PATH"
-
-                       dlog_logger -t 0 &
-                       LOGGER=$!
-                       sleep 1
-
-                       kill $LOGGER > /dev/null
-                       STOPPED=$?
-                       LOGGER=-1
-
-                       if [ "$PERSISTENT" -eq 0 ] && [ "$KMSG" -eq 0 ] && [ "$SYSLOG" -eq 0 ] && [ "$QOS" -eq 0 ] && [ "$type" = "logger" ]; then
-                               EXPECTED=1
-                       else
-                               EXPECTED=0
-                       fi
-
-                       LOG_DETAILS="testing if daemon stops when not needed (persistent=$PERSISTENT, kmsg=$KMSG, syslog=$SYSLOG, qos=$QOS)"
-                       [ "$STOPPED" -eq "$EXPECTED" ] && ok || fail
-               done; done; done; done
+               dlog_test_daemon_early_quit $type
        fi
-       DLOG_CONFIG_PATH="$PREEARLYQUIT_CONFIG_PATH"
 
        # Start the daemon
        dlog_logger -t 0 &
@@ -697,9 +637,9 @@ line=$($cmd_prefix $format)
 
 format="json"
 if [ "$type" = "pipe" ]; then
-       REGEX="s/^\{\"priority\":\"(verbose|debug|info|warning|error|fatal|silent)\",\"pid\":[1-9][0-9]*,\"tid\":[1-9][0-9]*,\"recv_real\":\"[0-9]{4}-[0-9]{2}-[0-9]{2}T[0-9]{2}:[0-9]{2}:[0-9]{2}$regex_timezone\",\"recv_mono\":[1-9][0-9]+\.[0-9]{9},\"sent_real\":\"[0-9]{4}-[0-9]{2}-[0-9]{2}T[0-9]{2}:[0-9]{2}:[0-9]{2}$regex_timezone\",\"sent_mono\":[1-9][0-9]+\.[0-9]{9},\"tag\":\"[[:print:]]*\",\"msg\":\"[[:print:]]*\"\}$/1/g"
+       REGEX="s/^\{\"priority\":\"(verbose|debug|info|warning|error|fatal|silent)\",\"pid\":[1-9][0-9]*,\"tid\":[1-9][0-9]*,\"recv_real\":\"[0-9]{4}-[0-9]{2}-[0-9]{2}T[0-9]{2}:[0-9]{2}:[0-9]{2}$regex_timezone\",\"recv_real_ns\":[1-9][0-9]*,\"recv_mono\":[1-9][0-9]+\.[0-9]{9},\"sent_real\":\"[0-9]{4}-[0-9]{2}-[0-9]{2}T[0-9]{2}:[0-9]{2}:[0-9]{2}$regex_timezone\",\"sent_real_ns\":[1-9][0-9]*,\"sent_mono\":[1-9][0-9]+\.[0-9]{9},\"tag\":\"[[:print:]]*\",\"msg\":\"[[:print:]]*\"\}$/1/g"
 elif [ "$type" = "logger" ]; then
-       REGEX="s/^\{\"priority\":\"(verbose|debug|info|warning|error|fatal|silent)\",\"pid\":[1-9][0-9]*,\"tid\":[1-9][0-9]*,\"sent_real\":\"[0-9]{4}-[0-9]{2}-[0-9]{2}T[0-9]{2}:[0-9]{2}:[0-9]{2}$regex_timezone\",\"tag\":\"[[:print:]]*\",\"msg\":\"[[:print:]]*\"\}$/1/g"
+       REGEX="s/^\{\"priority\":\"(verbose|debug|info|warning|error|fatal|silent)\",\"pid\":[1-9][0-9]*,\"tid\":[1-9][0-9]*,\"sent_real\":\"[0-9]{4}-[0-9]{2}-[0-9]{2}T[0-9]{2}:[0-9]{2}:[0-9]{2}$regex_timezone\",\"sent_real_ns\":[1-9][0-9]*,\"tag\":\"[[:print:]]*\",\"msg\":\"[[:print:]]*\"\}$/1/g"
 else # zero-copy
        REGEX="s/^\{\"priority\":\"(verbose|debug|info|warning|error|fatal|silent)\",\"pid\":[1-9][0-9]*,\"tid\":[1-9][0-9]*,\"sent_mono\":[1-9][0-9]+\.[0-9]{9},\"tag\":\"[[:print:]]*\",\"msg\":\"[[:print:]]*\"\}$/1/g"
 fi
@@ -785,41 +725,14 @@ if [ "$quick" -ne 1 ]; then
                dlogutil -db kmsg -v raw | grep -Fm1 "$last_dmesg" >/dev/null && ok || fail
        fi
 
-       LOG_DETAILS="testing if pid filtering works"
-       dlogsend -b main -t DLOG_TESTSUITE pidTEST &
-       sleep 1
-       line=$(dlogutil -v raw -d --pid $!)
-       [ "$line" = "pidTEST" ] && ok || fail
+       dlog_test_tid_filtering_secure_logging $type
+fi
 
-       LOG_DETAILS="testing if tid filtering works"
-       dlogsend -b main -t DLOG_TESTSUITE tidTEST &
-       sleep 1
-       line=$(dlogutil -v raw -d --tid $!) #dlogsend is a single threaded app so tid is the same as pid
-       [ "$line" = "tidTEST" ] && ok || fail
+DLOG_CONFIG_PATH="@datadir@/dlog-$type.conf.test"
 
-       mv $DLOG_CONFIG_PATH $DLOG_CONFIG_PATH.1
-       LOG_DETAILS="testing if secure logging works (1/2)"
-       grep -v enable_secure_logs $DLOG_CONFIG_PATH.1 > $DLOG_CONFIG_PATH
-       echo "enable_secure_logs=1" >> $DLOG_CONFIG_PATH
-       dlogutil -c
-       dlogsend -zb main -t DLOG_TESTSUITE secure &
-       sleep 1
-       dlogsend -b main -t DLOG_TESTSUITE insecure &
-       sleep 1
-       line=$(dlogutil -v raw -d | head -n1)
-       [ "$line" = "secure" ] && ok || fail
-       LOG_DETAILS="testing if secure logging works (2/2)"
-       grep -v enable_secure_logs $DLOG_CONFIG_PATH.1 > $DLOG_CONFIG_PATH
-       echo "enable_secure_logs=0" >> $DLOG_CONFIG_PATH
-       dlogutil -c
-       dlogsend -zb main -t DLOG_TESTSUITE secure &
-       sleep 1
-       dlogsend -b main -t DLOG_TESTSUITE insecure &
-       sleep 1
-       line=$(dlogutil -v raw -d | head -n1)
-       [ "$line" = "insecure" ] && ok || fail
-       mv $DLOG_CONFIG_PATH.1 $DLOG_CONFIG_PATH
-fi
+dlog_logger -t 0 &
+LOGGER=$!
+sleep 1
 
 dlogsend -b main -t DLOG_TESTSUITE_TAG0 -pI tagTEST0
 dlogsend -b main -t DLOG_TESTSUITE_TAG1 -pI tagTEST1
@@ -1176,6 +1089,7 @@ if [ "$type" != "zero-copy" ]; then # No dynamic filters in zero-copy
 fi
 
 LOG_DETAILS="testing if libdlogutil clears the buffer correctly"
+sleep 1 # make sure the earlier logs are handled so that they don't end up handled after the clear
 test_libdlogutil clear $LIBDLOGUTIL_CORRECT_PID $type && ok || fail
 
 if [ "$(date +%Y)" -le 2000 ]; then
@@ -1188,114 +1102,23 @@ test_verifytime && ok || fail
 
 DLOG_PREV_PATH=$DLOG_CONFIG_PATH
 
-LOG_DETAILS="testing if config has control over redirecting to stdout (1/3)"
-DLOG_CONFIG_PATH="@datadir@/dlog-$type.conf.stdout_enable.1"
-
-test_config_redirect 1 1 1 1 && ok || fail
-
-LOG_DETAILS="testing if config has control over redirecting to stdout (2/3)"
-DLOG_CONFIG_PATH="@datadir@/dlog-$type.conf.stdout_enable.2"
-test_config_redirect 0 0 1 1 && ok || fail
-
-LOG_DETAILS="testing if config has control over redirecting to stdout (3/3)"
-DLOG_CONFIG_PATH="@datadir@/dlog-$type.conf.stdout_enable.3"
-test_config_redirect 1 1 0 0 && ok || fail
+dlog_test_stdout_redirect $type
 
 DLOG_CONFIG_PATH=$DLOG_PREV_PATH
 
 if [ "$quick" -ne 1 ]; then
        if [ "$type" != "zero-copy" ]; then # Backend autodection and logger daemon stuff don't really work on zero-copy
-               PREAUTODETECT_CONFIG_PATH=$DLOG_CONFIG_PATH
-               DLOG_CONFIG_PATH="@datadir@/dlog-$type.conf.autodetect"
-               kill $LOGGER > /dev/null
-               sleep 1
-               if [ "$type" = "logger" ]; then
-                       dlogutil -cb main
-               fi
-               dlog_logger -t 0 &
-               LOGGER=$!
-               sleep 1
-
-               LOG_DETAILS="testing if backend autodetection works properly (1/2)"
-               dlogsend -b main -t DLOG_AUTODETECT "xd" && ok || fail
-               sleep 1
-
-               DLOG_CONFIG_PATH=$PREAUTODETECT_CONFIG_PATH
-               LOG_DETAILS="testing if backend autodetection works properly (2/2)"
-               [ "$(dlogutil -db main -v raw)" = "xd" ] && ok || fail
-
                kill $LOGGER > /dev/null
                sleep 1
-               rm "$TESTDIR"/test*
-               dlog_logger -t 0 &
-               LOGGER=$!
-               sleep 1
-
-               dlogsend -b main -t DLOG_LOGGER_TEST0 -c 100 "hi"
-               sleep 1
-               LOG_DETAILS="testing if logger daemon persistent logging works (1/3)"
-               [ "$(grep -c DLOG_LOGGER_TEST0 "$TESTDIR"/test0)" -eq 100 ] && ok || fail
-               LOG_DETAILS="testing if logger daemon persistent logging works (2/3)"
-               [ "$(grep -c DLOG_LOGGER_TEST0 "$TESTDIR"/test1)" -eq 100 ] && ok || fail
-               LOG_DETAILS="testing if logger daemon persistent logging works (3/3)"
-               [ "$(grep -c DLOG_LOGGER_TEST0 "$TESTDIR"/test2)" -eq 0 ] && ok || fail
-
-               dlogsend -b main -t DLOG_LOGGER_TEST1 -c 500000 "hi"
-               sleep 1
-               RESULT=$(du -c "$TESTDIR"/test0* | tail -n 1 | cut -f 1)
-               LOG_DETAILS="testing if logger daemon log rotating works (1/2)"
-               [ "$RESULT" -gt 4096 ] && ok || fail # Min 4 MB
-               LOG_DETAILS="testing if logger daemon log rotating works (2/2)"
-               [ "$RESULT" -lt 6144 ] && ok || fail # Max 6 MB
-
-               dlogutil -cb main
-               kill $LOGGER > /dev/null
-               sleep 1
-               rm "$TESTDIR"/test0*
-               dlog_logger -t 5 -b 100000 &
-               LOGGER=$!
-               sleep 1
-
-               dlogsend -b main -t DLOG_LOGGER_TEST2 -c 100 "hi"
-               sleep 1
-               LOG_DETAILS="testing if logger daemon buffering works (1/5)"
-               [ "$(grep -c DLOG_LOGGER_TEST2 "$TESTDIR"/test0)" -eq 0 ] && ok || fail
-
-               sleep 6
-               LOG_DETAILS="testing if logger daemon buffering works (2/5)"
-               [ "$(grep -c DLOG_LOGGER_TEST2 "$TESTDIR"/test0)" -eq 100 ] && ok || fail
-
-               dlogsend -b main -t DLOG_LOGGER_TEST3 -c 100 "hi"
-               sleep 1
-               LOG_DETAILS="testing if logger daemon buffering works (3/5)"
-               [ "$(grep -c DLOG_LOGGER_TEST3 "$TESTDIR"/test0)" -eq 0 ] && ok || fail
 
-               sleep 1
-               kill $LOGGER > /dev/null
-               LOGGER=-1
-               sleep 1
-               LOG_DETAILS="testing if logger daemon buffering works (4/5)"
-               [ "$(grep -c DLOG_LOGGER_TEST3 "$TESTDIR"/test0)" -eq 100 ] && ok || fail
-
-               dlogutil -cb main
-
-               dlog_logger -t 10000 -b 100 &
-               LOGGER=$!
-               sleep 1
-
-               dlogsend -b main -t DLOG_LOGGER_TEST4 -c 100 "hi"
-               sleep 1
-               LOG_DETAILS="testing if logger daemon buffering works (5/5)"
-               [ "$(grep -c DLOG_LOGGER_TEST4 "$TESTDIR"/test0)" -gt 90 ] && ok || fail
-
-               dlogutil -cb main
-               kill $LOGGER > /dev/null
-               sleep 1
-               dlog_logger -t 0 &
-               LOGGER=$!
-               sleep 1
+               dlog_test_backend_autodetection $type
+               dlog_test_logger_buffering_logging $type
        fi
 
+       dlog_logger -t 0 &
+       LOGGER=$!
+       sleep 1
+
        LOG_DETAILS="testing if the library works with multithreaded app"
        dlogutil -f $TESTDIR/dlog_mt_test &
        MT_TEST=$!
@@ -1337,7 +1160,7 @@ if [ "$quick" -ne 1 ]; then
                        LOG_DETAILS="testing if dlogutil --sort-by sorts correctly (${P}_mono)"
                        dlogutil -db main --sort-by "${P}_mono" -v json | sed -Ee "s/^.*\"${P}_mono\":([^,}]*).*\$/\\1/" | sort -c && ok || fail
                        LOG_DETAILS="testing if dlogutil --sort-by sorts correctly (${P}_real)"
-                       dlogutil -db main --sort-by "${P}_real" -v json | sed -Ee "s/^.*\"${P}_real\":\"([^\"]*)\".*\$/\\1/" | sort -c && ok || fail
+                       dlogutil -db main --sort-by "${P}_real" -v json | sed -Ee "s/^.*\"${P}_real\":\"([^\"]*)\",\"${P}_real_ns\":([^,}]*).*\$/\\1 \2/" | sort -c -k1,1 -k2,2g && ok || fail
                done
        fi