X-Git-Url: https://git.lttng.org/?p=lttng-tools.git;a=blobdiff_plain;f=tests%2Fregression%2Fust%2Fjava-jul%2Ftest_java_jul;h=f9f244b61611523be8d030eddc55d6fd22e6b85c;hp=dc6e677f30a2966ac36c900d70779bd53693301f;hb=0b7af9456fb564df73d32ff7712200d14569a375;hpb=d53addeb964039ae2f544de1d7d452fb5ad6da69 diff --git a/tests/regression/ust/java-jul/test_java_jul b/tests/regression/ust/java-jul/test_java_jul index dc6e677f3..f9f244b61 100755 --- a/tests/regression/ust/java-jul/test_java_jul +++ b/tests/regression/ust/java-jul/test_java_jul @@ -27,9 +27,9 @@ TESTAPP_PATH="$CURDIR/$TESTAPP_NAME" SESSION_NAME="jul" EVENT_NAME="JTestLTTng" EVENT_NAME2="JTestLTTng2" -JAVA_CP="$CURDIR:/usr/local/lib/lttng/java/liblttng-ust-jul.jar:/usr/lib/lttng/java/liblttng-ust-jul.jar" +JAVA_CP="$CURDIR:$CLASSPATH" -NUM_TESTS=124 +NUM_TESTS=155 source $TESTDIR/utils/utils.sh @@ -38,7 +38,8 @@ function run_app local finest_tp=$1 local fire_second_tp=$2 - java -cp $JAVA_CP -Djava.library.path="/usr/local/lib:/usr/lib" $TESTAPP_NAME $NR_ITER $NR_MSEC_WAIT $finest_tp $fire_second_tp >/dev/null 2>&1 + #FIXME: app should have synchro. + java -cp $JAVA_CP -Djava.library.path="$LD_LIBRARY_PATH:/usr/local/lib:/usr/lib" $TESTAPP_NAME $NR_ITER $NR_MSEC_WAIT $finest_tp $fire_second_tp >/dev/null 2>&1 } function run_app_background @@ -74,24 +75,43 @@ function enable_jul_filter() ok $? "Enable event $event_name with filter $filter for session $sess_name" } +function enable_jul_filter_loglevel_only() +{ + local sess_name="$1" + local event_name="$2" + local filter="$3" + local loglevel="$4" + + $TESTDIR/../src/bin/lttng/$LTTNG_BIN enable-event --loglevel-only $loglevel "$event_name" -s $sess_name -j --filter "$filter" >/dev/null 2>&1 + ok $? "Enable event $event_name with filter \"$filter\" and loglevel-only $loglevel for session $sess_name" +} + # MUST set TESTDIR before calling those functions function test_jul_before_start () { + local file_sync_after_first=$(mktemp -u) + local file_sync_before_last=$(mktemp -u) + diag "Test JUL application BEFORE tracing starts" - create_lttng_session $SESSION_NAME $TRACE_PATH + create_lttng_session_ok $SESSION_NAME $TRACE_PATH enable_jul_lttng_event $SESSION_NAME $EVENT_NAME # Run 5 times with a 1 second delay run_app_background - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME + + touch ${file_sync_before_last} # Wait for the applications started in background - wait ${!} + wait + + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + rm -f ${file_sync_after_first} + rm -f ${file_sync_before_last} # Validate test. Expecting all events. trace_match_only $EVENT_NAME $NR_ITER $TRACE_PATH @@ -104,15 +124,15 @@ function test_jul_after_start () { diag "Test JUL application AFTER tracing starts" - create_lttng_session $SESSION_NAME $TRACE_PATH + create_lttng_session_ok $SESSION_NAME $TRACE_PATH enable_jul_lttng_event $SESSION_NAME $EVENT_NAME - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay run_app - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting all events. trace_match_only $EVENT_NAME $NR_ITER $TRACE_PATH @@ -125,15 +145,15 @@ function test_jul_loglevel () { diag "Test JUL application with loglevel" - create_lttng_session $SESSION_NAME $TRACE_PATH + create_lttng_session_ok $SESSION_NAME $TRACE_PATH enable_jul_lttng_event_loglevel $SESSION_NAME $EVENT_NAME "JUL_INFO" - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay run_app - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting all events. trace_match_only $EVENT_NAME $NR_ITER $TRACE_PATH @@ -143,15 +163,15 @@ function test_jul_loglevel () diag "Test JUL applications with lower loglevel" - create_lttng_session $SESSION_NAME $TRACE_PATH + create_lttng_session_ok $SESSION_NAME $TRACE_PATH enable_jul_lttng_event_loglevel $SESSION_NAME $EVENT_NAME "JUL_SEVERE" - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay run_app - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting 0 events. trace_match_only $EVENT_NAME 0 $TRACE_PATH @@ -161,15 +181,15 @@ function test_jul_loglevel () diag "Test JUL applications with higher loglevel" - create_lttng_session $SESSION_NAME $TRACE_PATH + create_lttng_session_ok $SESSION_NAME $TRACE_PATH enable_jul_lttng_event_loglevel $SESSION_NAME $EVENT_NAME "JUL_FINER" - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay run_app - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting all events. trace_match_only $EVENT_NAME $NR_ITER $TRACE_PATH @@ -180,16 +200,16 @@ function test_jul_loglevel_multiple () { diag "Test JUL application with multiple loglevel" - create_lttng_session $SESSION_NAME $TRACE_PATH + create_lttng_session_ok $SESSION_NAME $TRACE_PATH enable_jul_lttng_event_loglevel $SESSION_NAME $EVENT_NAME "JUL_INFO" enable_jul_lttng_event_loglevel $SESSION_NAME $EVENT_NAME "JUL_FINEST" - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay and fire two TP. run_app 1 - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting all events times two. trace_match_only $EVENT_NAME $(($NR_ITER * 2)) $TRACE_PATH @@ -197,16 +217,16 @@ function test_jul_loglevel_multiple () return $? fi - create_lttng_session $SESSION_NAME $TRACE_PATH + create_lttng_session_ok $SESSION_NAME $TRACE_PATH enable_jul_lttng_event_loglevel $SESSION_NAME '*' "JUL_INFO" enable_jul_lttng_event_loglevel $SESSION_NAME '*' "JUL_FINEST" - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay and fire two TP. run_app 1 - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting all events times two. trace_match_only $EVENT_NAME $(($NR_ITER * 2)) $TRACE_PATH @@ -219,21 +239,21 @@ function test_jul_multi_session_loglevel() { diag "Test JUL with multiple session" - create_lttng_session $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 + create_lttng_session_ok $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 enable_jul_loglevel_only $SESSION_NAME-1 '*' "JUL_INFO" - start_lttng_tracing $SESSION_NAME-1 + start_lttng_tracing_ok $SESSION_NAME-1 - create_lttng_session $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 + create_lttng_session_ok $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 enable_jul_loglevel_only $SESSION_NAME-2 '*' "JUL_FINEST" - start_lttng_tracing $SESSION_NAME-2 + start_lttng_tracing_ok $SESSION_NAME-2 # Run 5 times with a 1 second delay and fire second TP. run_app 1 1 - stop_lttng_tracing $SESSION_NAME-1 - stop_lttng_tracing $SESSION_NAME-2 - destroy_lttng_session $SESSION_NAME-1 - destroy_lttng_session $SESSION_NAME-2 + stop_lttng_tracing_ok $SESSION_NAME-1 + stop_lttng_tracing_ok $SESSION_NAME-2 + destroy_lttng_session_ok $SESSION_NAME-1 + destroy_lttng_session_ok $SESSION_NAME-2 # Expecting 6 events being the main event plus the second tp. trace_match_only $EVENT_NAME $(($NR_ITER + 1)) $TRACE_PATH/$SESSION_NAME-1 @@ -252,23 +272,23 @@ function test_jul_multi_session_disable() { diag "Test JUL with multiple session with disabled event" - create_lttng_session $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 + create_lttng_session_ok $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 enable_jul_lttng_event $SESSION_NAME-1 $EVENT_NAME enable_jul_lttng_event $SESSION_NAME-1 $EVENT_NAME2 disable_jul_lttng_event $SESSION_NAME-1 $EVENT_NAME - start_lttng_tracing $SESSION_NAME-1 + start_lttng_tracing_ok $SESSION_NAME-1 - create_lttng_session $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 + create_lttng_session_ok $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 enable_jul_lttng_event $SESSION_NAME-2 $EVENT_NAME2 - start_lttng_tracing $SESSION_NAME-2 + start_lttng_tracing_ok $SESSION_NAME-2 # Run 5 times with a 1 second delay and fire second TP. run_app 0 1 - stop_lttng_tracing $SESSION_NAME-1 - stop_lttng_tracing $SESSION_NAME-2 - destroy_lttng_session $SESSION_NAME-1 - destroy_lttng_session $SESSION_NAME-2 + stop_lttng_tracing_ok $SESSION_NAME-1 + stop_lttng_tracing_ok $SESSION_NAME-2 + destroy_lttng_session_ok $SESSION_NAME-1 + destroy_lttng_session_ok $SESSION_NAME-2 # Validate test. Expecting one event of the second TP. trace_match_only $EVENT_NAME2 1 $TRACE_PATH/$SESSION_NAME-1 @@ -283,25 +303,86 @@ function test_jul_multi_session_disable() fi } +function test_jul_multi_session_disable_wildcard() +{ + diag "Test JUL with multiple session with disabled wildcard event" + + create_lttng_session_ok $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 + enable_jul_lttng_event $SESSION_NAME-1 '*' + + create_lttng_session_ok $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 + enable_jul_lttng_event $SESSION_NAME-2 '*' + + disable_jul_lttng_event $SESSION_NAME-1 '*' + + start_lttng_tracing_ok $SESSION_NAME-1 + start_lttng_tracing_ok $SESSION_NAME-2 + + run_app + + stop_lttng_tracing_ok $SESSION_NAME-1 + stop_lttng_tracing_ok $SESSION_NAME-2 + destroy_lttng_session_ok $SESSION_NAME-1 + destroy_lttng_session_ok $SESSION_NAME-2 + + # Validate test. Expecting NO event of the first TP. + trace_match_only $EVENT_NAME 0 $TRACE_PATH/$SESSION_NAME-1 + if [ $? -ne 0 ]; then + return $? + fi + + # Validate test. Expecting all events of the first TP. + trace_match_only $EVENT_NAME $NR_ITER $TRACE_PATH/$SESSION_NAME-2 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_jul_disable_all() +{ + diag "Test JUL with multiple session with disabled all event" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME + enable_jul_lttng_event $SESSION_NAME '*' + enable_jul_lttng_event $SESSION_NAME $EVENT_NAME + enable_jul_lttng_event $SESSION_NAME $EVENT_NAME2 + + disable_jul_lttng_event $SESSION_NAME '*' + + start_lttng_tracing_ok $SESSION_NAME + + run_app 0 1 + + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME + + # Validate test. Expecting NO event of the first TP and second TP. + trace_match_only $EVENT_NAME 0 $TRACE_PATH/$SESSION_NAME + trace_match_only $EVENT_NAME2 0 $TRACE_PATH/$SESSION_NAME + if [ $? -ne 0 ]; then + return $? + fi +} + function test_jul_multi_session() { diag "Test JUL with multiple session" - create_lttng_session $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 + create_lttng_session_ok $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 enable_jul_lttng_event $SESSION_NAME-1 $EVENT_NAME - start_lttng_tracing $SESSION_NAME-1 + start_lttng_tracing_ok $SESSION_NAME-1 - create_lttng_session $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 + create_lttng_session_ok $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 enable_jul_lttng_event $SESSION_NAME-2 $EVENT_NAME2 - start_lttng_tracing $SESSION_NAME-2 + start_lttng_tracing_ok $SESSION_NAME-2 # Run 5 times with a 1 second delay and fire second TP. run_app 0 1 - stop_lttng_tracing $SESSION_NAME-1 - stop_lttng_tracing $SESSION_NAME-2 - destroy_lttng_session $SESSION_NAME-1 - destroy_lttng_session $SESSION_NAME-2 + stop_lttng_tracing_ok $SESSION_NAME-1 + stop_lttng_tracing_ok $SESSION_NAME-2 + destroy_lttng_session_ok $SESSION_NAME-1 + destroy_lttng_session_ok $SESSION_NAME-2 # Validate test. Expecting all events of first TP trace_match_only $EVENT_NAME $NR_ITER $TRACE_PATH/$SESSION_NAME-1 @@ -320,17 +401,18 @@ function test_jul_destroy_session() { diag "Test JUL two session with destroy" - create_lttng_session $SESSION_NAME $TRACE_PATH/first-sess + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/first-sess enable_jul_lttng_event $SESSION_NAME $EVENT_NAME - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay run_app_background 0 1 - sleep 1 + # Wait for the applications started in background + wait - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting at least one event num 1 validate_trace $EVENT_NAME $TRACE_PATH/first-sess @@ -338,15 +420,18 @@ function test_jul_destroy_session() return $? fi - create_lttng_session $SESSION_NAME $TRACE_PATH/second-sess + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/second-sess enable_jul_lttng_event $SESSION_NAME $EVENT_NAME2 - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay + run_app_background 0 1 # Wait for the applications started in background - wait ${!} + wait - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting only one event num 2 trace_match_only $EVENT_NAME2 1 $TRACE_PATH/second-sess @@ -359,16 +444,16 @@ function test_jul_filtering() { diag "Test JUL filtering" - create_lttng_session $SESSION_NAME $TRACE_PATH/$SESSION_NAME + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME # Enable all event with a filter. enable_jul_filter $SESSION_NAME '*' 'msg == "JUL second logger fired"' - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay and fire second TP. run_app 0 1 - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting one event of the second TP only. trace_match_only $EVENT_NAME2 1 $TRACE_PATH/$SESSION_NAME @@ -376,17 +461,17 @@ function test_jul_filtering() return $? fi - create_lttng_session $SESSION_NAME $TRACE_PATH/$SESSION_NAME + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME # Enable first Logger but filter msg payload for the INFO one while # triggering the finest and second TP. enable_jul_filter $SESSION_NAME $EVENT_NAME 'msg == "JUL tp fired!"' - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay, fire finest and second TP. run_app 1 1 - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting NR_ITER event of the main INFO tp. trace_match_only $EVENT_NAME $NR_ITER $TRACE_PATH/$SESSION_NAME @@ -399,18 +484,18 @@ function test_jul_disable() { diag "Test JUL disable event" - create_lttng_session $SESSION_NAME $TRACE_PATH/$SESSION_NAME + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME # Enable all event with a filter. enable_jul_lttng_event $SESSION_NAME $EVENT_NAME enable_jul_lttng_event $SESSION_NAME $EVENT_NAME2 disable_jul_lttng_event $SESSION_NAME $EVENT_NAME - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay and fire second TP. run_app 0 1 - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting one event of the second TP only. trace_match_only $EVENT_NAME2 1 $TRACE_PATH/$SESSION_NAME @@ -423,18 +508,18 @@ function test_jul_disable_enable() { diag "Test JUL disable event followed by an enable" - create_lttng_session $SESSION_NAME $TRACE_PATH/$SESSION_NAME + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME # Enable all event with a filter. enable_jul_lttng_event $SESSION_NAME $EVENT_NAME disable_jul_lttng_event $SESSION_NAME $EVENT_NAME enable_jul_lttng_event $SESSION_NAME $EVENT_NAME - start_lttng_tracing $SESSION_NAME + start_lttng_tracing_ok $SESSION_NAME # Run 5 times with a 1 second delay and fire second TP. run_app 0 1 - stop_lttng_tracing $SESSION_NAME - destroy_lttng_session $SESSION_NAME + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME # Validate test. Expecting NR_ITER event of the main INFO tp. trace_match_only $EVENT_NAME $NR_ITER $TRACE_PATH/$SESSION_NAME @@ -443,6 +528,34 @@ function test_jul_disable_enable() fi } +function test_jul_filter_loglevel() +{ + local BOGUS_EVENT_NAME="not_a_real_event" + local FILTER="int_loglevel > 700 || int_loglevel < 700" + local ALL_EVENTS="." + + diag "Test JUL a filter with a loglevel" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME + # Enable an event with a filter and the loglevel-only option. + enable_jul_filter_loglevel_only $SESSION_NAME $BOGUS_EVENT_NAME "$FILTER" JUL_CONFIG + disable_jul_lttng_event $SESSION_NAME $BOGUS_EVENT_NAME + enable_jul_filter_loglevel_only $SESSION_NAME $BOGUS_EVENT_NAME "$FILTER" JUL_CONFIG + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay and fire second TP. + run_app 0 1 + + stop_lttng_tracing_ok $SESSION_NAME + destroy_lttng_session_ok $SESSION_NAME + + # Validate test. Expecting no events. + trace_match_only $ALL_EVENTS 0 $TRACE_PATH/$SESSION_NAME + if [ $? -ne 0 ]; then + return $? + fi +} + plan_tests $NUM_TESTS print_test_banner "$TEST_DESC" @@ -458,9 +571,11 @@ skip $withapp "JUL support is needed. Skipping all tests." $NUM_TESTS || start_lttng_sessiond tests=( + test_jul_multi_session_disable_wildcard test_jul_multi_session_disable test_jul_disable test_jul_disable_enable + test_jul_disable_all test_jul_filtering test_jul_multi_session_loglevel test_jul_destroy_session @@ -469,6 +584,7 @@ skip $withapp "JUL support is needed. Skipping all tests." $NUM_TESTS || test_jul_before_start test_jul_after_start test_jul_multi_session + test_jul_filter_loglevel ) for fct_test in ${tests[@]};