X-Git-Url: http://git.liburcu.org/?a=blobdiff_plain;f=tests%2Fregression%2Fust%2Fpython-logging%2Ftest_python_logging.in;fp=tests%2Fregression%2Fust%2Fpython-logging%2Ftest_python_logging.in;h=8aff4081ed4ab21ea041aea403795a0bec18ee08;hb=9586c1988d30b9729731a785108cde14990e50dd;hp=0000000000000000000000000000000000000000;hpb=7409dd343d2a7392338dc8b506edf8731e9f9c2d;p=lttng-tools.git diff --git a/tests/regression/ust/python-logging/test_python_logging.in b/tests/regression/ust/python-logging/test_python_logging.in new file mode 100755 index 000000000..8aff4081e --- /dev/null +++ b/tests/regression/ust/python-logging/test_python_logging.in @@ -0,0 +1,610 @@ +#!/bin/bash +# +# Copyright (C) - 2015 Philippe Proulx +# Copyright (C) - 2014 David Goulet +# +# This program is free software; you can redistribute it and/or modify it under +# the terms of the GNU General Public License, version 2 only, as published by +# the Free Software Foundation. +# +# This program is distributed in the hope that it will be useful, but WITHOUT +# ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or FITNESS +# FOR A PARTICULAR PURPOSE. See the GNU General Public License for more +# details. +# +# You should have received a copy of the GNU General Public License along with +# this program; if not, write to the Free Software Foundation, Inc., 51 +# Franklin Street, Fifth Floor, Boston, MA 02110-1301 USA. + +TEST_DESC="Python support" + +CURDIR=$(dirname $0)/ +TESTDIR=$CURDIR/../../.. +NR_ITER=5 +NR_SEC_WAIT=0 +TESTAPP_NAME="test" +TESTAPP_BIN="$TESTAPP_NAME.py" +TESTAPP_PATH="$CURDIR" +SESSION_NAME="python-test" +EVENT_NAME="python-ev-test1" +EVENT_NAME2="python-ev-test2" +OUTPUT_DEST="/dev/null" + +python_versions=(@PYTHON2_AGENT@ @PYTHON3_AGENT@) +run_test=@RUN_PYTHON_AGENT_TEST@ + +if [[ -z "$run_test" ]]; then + NUM_TESTS=1 +else + NUM_TESTS=$(((154 * ${#python_versions[@]})+2)) +fi + +source $TESTDIR/utils/utils.sh + +function run_app +{ + local python=$1 + local debug_tp=$2 + local fire_second_tp=$3 + + $python $TESTAPP_PATH/$TESTAPP_BIN $NR_ITER $NR_SEC_WAIT $debug_tp $fire_second_tp +} + +function run_app_background +{ + run_app $@ & +} + +function enable_python_loglevel_only() +{ + sess_name=$1 + event_name="$2" + loglevel=$3 + channel_name=$4 + + if [ -z $channel_name ]; then + # default channel if none specified + chan="" + else + chan="-c $channel_name" + fi + + $TESTDIR/../src/bin/lttng/$LTTNG_BIN enable-event --loglevel-only $loglevel "$event_name" $chan -s $sess_name -p >$OUTPUT_DEST + ok $? "Enable Python event $event_name for session $sess_name with loglevel-only $loglevel" +} + +function enable_python_filter() +{ + local sess_name="$1" + local event_name="$2" + local filter="$3" + + $TESTDIR/../src/bin/lttng/$LTTNG_BIN enable-event "$event_name" -s $sess_name -p --filter "$filter" >$OUTPUT_DEST + ok $? "Enable event $event_name with filter $filter for session $sess_name" +} + +function enable_python_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 -p --filter "$filter" >$OUTPUT_DEST + 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_python_before_start () +{ + diag "Test Python application BEFORE tracing starts" + create_lttng_session_ok $SESSION_NAME $TRACE_PATH + enable_python_lttng_event $SESSION_NAME $EVENT_NAME + + # Run 5 times with a 1 second delay + run_app_background $1 + + start_lttng_tracing_ok $SESSION_NAME + + # Wait for the applications started in background + wait + + 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 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_python_after_start () +{ + diag "Test Python application AFTER tracing starts" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH + enable_python_lttng_event $SESSION_NAME $EVENT_NAME + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay + run_app $1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_python_loglevel () +{ + diag "Test Python application with loglevel" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH + enable_python_lttng_event_loglevel $SESSION_NAME $EVENT_NAME "INFO" + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay + run_app $1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi + + diag "Test Python applications with lower loglevel" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH + enable_python_lttng_event_loglevel $SESSION_NAME $EVENT_NAME "CRITICAL" + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay + run_app $1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi + + diag "Test Python applications with higher loglevel" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH + enable_python_lttng_event_loglevel $SESSION_NAME $EVENT_NAME "DEBUG" + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay + run_app $1 + + 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 + return $? +} + +function test_python_loglevel_multiple () +{ + diag "Test Python application with multiple loglevel" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH + enable_python_lttng_event_loglevel $SESSION_NAME $EVENT_NAME "INFO" + enable_python_lttng_event_loglevel $SESSION_NAME $EVENT_NAME "DEBUG" + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay and fire two TP. + run_app $1 1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH + enable_python_lttng_event_loglevel $SESSION_NAME '*' "INFO" + enable_python_lttng_event_loglevel $SESSION_NAME '*' "DEBUG" + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay and fire two TP. + run_app $1 1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_python_multi_session_loglevel() +{ + diag "Test Python with multiple session" + + create_lttng_session_ok $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 + enable_python_loglevel_only $SESSION_NAME-1 '*' "INFO" + start_lttng_tracing_ok $SESSION_NAME-1 + + create_lttng_session_ok $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 + enable_python_loglevel_only $SESSION_NAME-2 '*' "DEBUG" + start_lttng_tracing_ok $SESSION_NAME-2 + + # Run 5 times with a 1 second delay and fire second TP. + run_app $1 1 1 + + 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 NR_ITER events being the main event and the second tp one. + trace_matches $EVENT_NAME $NR_ITER $TRACE_PATH/$SESSION_NAME-1 + if [ $? -ne 0 ]; then + return $? + fi + trace_matches $EVENT_NAME2 1 $TRACE_PATH/$SESSION_NAME-1 + if [ $? -ne 0 ]; then + return $? + fi + + # Expectin NR_ITER events being the debug TP. + trace_match_only $EVENT_NAME $NR_ITER $TRACE_PATH/$SESSION_NAME-2 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_python_multi_session_disable() +{ + diag "Test Python with multiple session with disabled event" + + create_lttng_session_ok $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 + enable_python_lttng_event $SESSION_NAME-1 $EVENT_NAME + enable_python_lttng_event $SESSION_NAME-1 $EVENT_NAME2 + disable_python_lttng_event $SESSION_NAME-1 $EVENT_NAME + start_lttng_tracing_ok $SESSION_NAME-1 + + create_lttng_session_ok $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 + enable_python_lttng_event $SESSION_NAME-2 $EVENT_NAME2 + start_lttng_tracing_ok $SESSION_NAME-2 + + # Run 5 times with a 1 second delay and fire second TP. + run_app $1 0 1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi + + # Validate test. Expecting one event of the second TP. + trace_match_only $EVENT_NAME2 1 $TRACE_PATH/$SESSION_NAME-2 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_python_multi_session_disable_wildcard() +{ + diag "Test Python with multiple session with disabled wildcard event" + + create_lttng_session_ok $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 + enable_python_lttng_event $SESSION_NAME-1 '*' + + create_lttng_session_ok $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 + enable_python_lttng_event $SESSION_NAME-2 '*' + + disable_python_lttng_event $SESSION_NAME-1 '*' + + start_lttng_tracing_ok $SESSION_NAME-1 + start_lttng_tracing_ok $SESSION_NAME-2 + + run_app $1 + + 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_python_disable_all() +{ + diag "Test Python with multiple session with disabled all event" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME + enable_python_lttng_event $SESSION_NAME '*' + enable_python_lttng_event $SESSION_NAME $EVENT_NAME + enable_python_lttng_event $SESSION_NAME $EVENT_NAME2 + + disable_python_lttng_event $SESSION_NAME '*' + + start_lttng_tracing_ok $SESSION_NAME + + run_app $1 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_python_multi_session() +{ + diag "Test Python with multiple session" + + create_lttng_session_ok $SESSION_NAME-1 $TRACE_PATH/$SESSION_NAME-1 + enable_python_lttng_event $SESSION_NAME-1 $EVENT_NAME + start_lttng_tracing_ok $SESSION_NAME-1 + + create_lttng_session_ok $SESSION_NAME-2 $TRACE_PATH/$SESSION_NAME-2 + enable_python_lttng_event $SESSION_NAME-2 $EVENT_NAME2 + start_lttng_tracing_ok $SESSION_NAME-2 + + # Run 5 times with a 1 second delay and fire second TP. + run_app $1 0 1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi + + # Validate test. Expecting one event of the second TP. + trace_match_only $EVENT_NAME2 1 $TRACE_PATH/$SESSION_NAME-2 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_python_destroy_session() +{ + diag "Test Python two session with destroy" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/first-sess + enable_python_lttng_event $SESSION_NAME $EVENT_NAME + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay + run_app_background $1 0 1 + + # Wait for the applications started in background + wait + + 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 + if [ $? -ne 0 ]; then + return $? + fi + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/second-sess + enable_python_lttng_event $SESSION_NAME $EVENT_NAME2 + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay + run_app_background $1 0 1 + + # Wait for the applications started in background + wait + + 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 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_python_filtering() +{ + diag "Test Python filtering" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME + # Enable all event with a filter. + enable_python_filter $SESSION_NAME '*' 'msg == "python-ev-test2 fired [INFO]"' + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay and fire second TP. + run_app $1 0 1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME + # Enable first Logger but filter msg payload for the INFO one while + # triggering the debug and second TP. + enable_python_filter $SESSION_NAME $EVENT_NAME 'msg == "python-ev-test1 fired [INFO]"' + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay, fire debug and second TP. + run_app $1 1 1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_python_disable() +{ + diag "Test Python disable event" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME + # Enable all event with a filter. + enable_python_lttng_event $SESSION_NAME $EVENT_NAME + enable_python_lttng_event $SESSION_NAME $EVENT_NAME2 + disable_python_lttng_event $SESSION_NAME $EVENT_NAME + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay and fire second TP. + run_app $1 0 1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_python_disable_enable() +{ + diag "Test Python disable event followed by an enable" + + create_lttng_session_ok $SESSION_NAME $TRACE_PATH/$SESSION_NAME + # Enable all event with a filter. + enable_python_lttng_event $SESSION_NAME $EVENT_NAME + disable_python_lttng_event $SESSION_NAME $EVENT_NAME + enable_python_lttng_event $SESSION_NAME $EVENT_NAME + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay and fire second TP. + run_app $1 0 1 + + 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 + if [ $? -ne 0 ]; then + return $? + fi +} + +function test_python_filter_loglevel() +{ + local BOGUS_EVENT_NAME="not_a_real_event" + local FILTER="int_loglevel > 30 || int_loglevel < 30" + local ALL_EVENTS="." + + diag "Test Python 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_python_filter_loglevel_only $SESSION_NAME $BOGUS_EVENT_NAME "$FILTER" "INFO" + disable_python_lttng_event $SESSION_NAME $BOGUS_EVENT_NAME + enable_python_filter_loglevel_only $SESSION_NAME $BOGUS_EVENT_NAME "$FILTER" "INFO" + start_lttng_tracing_ok $SESSION_NAME + + # Run 5 times with a 1 second delay and fire second TP. + run_app $1 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" + +if [[ ${#python_versions[@]} -eq 0 || "x$run_test" != "xyes" ]]; then + skip_agent=0 +else + skip_agent=1 +fi + +skip $skip_agent "Python agent test skipped." $NUM_TESTS || +{ + start_lttng_sessiond + + tests=( + test_python_multi_session_disable_wildcard + test_python_multi_session_disable + test_python_disable + test_python_disable_enable + test_python_disable_all + test_python_filtering + test_python_multi_session_loglevel + test_python_destroy_session + test_python_loglevel + test_python_loglevel_multiple + test_python_before_start + test_python_after_start + test_python_multi_session + test_python_filter_loglevel + ) + + + for python_version in ${python_versions[*]}; + do + for fct_test in ${tests[@]}; + do + TRACE_PATH=$(mktemp -d) + + diag "(Python $python_version)" + ${fct_test} $python_version + if [ $? -ne 0 ]; then + break; + fi + rm -rf $TRACE_PATH + done + done + stop_lttng_sessiond +}