** Description changed: Issue found on Focal 5.4.0-29.33 with node amaura (passed on rizzo, rizzo failed with other failures) utils:0116| Running './ftracetest -vvv test.d/ftrace/func_traceonoff_triggers.tc' utils:0153| [stdout] === Ftrace unit tests === utils:0153| [stderr] + initialize_ftrace utils:0153| [stderr] + disable_tracing utils:0153| [stderr] + echo 0 utils:0153| [stderr] + reset_tracer utils:0153| [stderr] + echo nop utils:0153| [stderr] + reset_trigger utils:0153| [stderr] + [ -d events/synthetic ] - ... + (long output skipped) + utils:0153| [stderr] + read line + (long output skipped) + utils:0153| [stderr] + read line + (long output skipped) + utils:0153| [stderr] + reset_events_filter + utils:0153| [stderr] + read line + (long output skipped) + utils:0153| [stderr] + reset_ftrace_filter + utils:0153| [stderr] + [ ! -f set_ftrace_filter ] + utils:0153| [stderr] + echo + utils:0153| [stderr] + grep -v ^# set_ftrace_filter + utils:0153| [stderr] + read t + utils:0153| [stderr] + disable_events + utils:0153| [stderr] + echo 0 + utils:0153| [stderr] + [ -f set_event_pid ] + utils:0153| [stderr] + echo + utils:0153| [stderr] + [ -f set_ftrace_pid ] + utils:0153| [stdout] [1] ftrace - test for function traceon/off triggers + utils:0153| [stderr] + echo + utils:0153| [stderr] + [ -f set_ftrace_notrace ] + utils:0153| [stderr] + echo + utils:0153| [stderr] + [ -f set_graph_function ] + utils:0153| [stderr] + tee set_graph_function set_graph_notrace + utils:0153| [stderr] + echo + utils:0153| [stderr] + [ -f stack_trace_filter ] + utils:0153| [stderr] + echo + utils:0153| [stderr] + [ -f kprobe_events ] + utils:0153| [stderr] + echo + utils:0153| [stderr] + [ -f uprobe_events ] + utils:0153| [stderr] + echo + utils:0153| [stderr] + [ -f synthetic_events ] + utils:0153| [stderr] + echo + utils:0153| [stderr] + [ -f snapshot ] + utils:0153| [stderr] + echo 0 + utils:0153| [stderr] + clear_trace + utils:0153| [stdout] Testing function probes with enabling disabling tracing: + utils:0153| [stdout] ** DISABLE TRACING + utils:0153| [stderr] + echo + utils:0153| [stderr] + enable_tracing + utils:0153| [stderr] + echo 1 + utils:0153| [stderr] + . /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/ftrace/func_traceonoff_triggers.tc + utils:0153| [stderr] + [ ! -f set_ftrace_filter ] + utils:0153| [stderr] + SLEEP_TIME=.1 + utils:0153| [stderr] + echo Testing function probes with enabling disabling tracing: + utils:0153| [stderr] + echo ** DISABLE TRACING + utils:0153| [stderr] + disable_tracing + utils:0153| [stderr] + echo 0 + utils:0153| [stderr] + clear_trace + utils:0153| [stderr] + echo + utils:0153| [stderr] + cnt_trace + utils:0153| [stderr] + + grep -v ^# trace + utils:0153| [stderr] wc -l + utils:0153| [stdout] ** ENABLE EVENTS + utils:0153| [stderr] + cnt=0 + utils:0153| [stderr] + [ 0 -ne 0 ] + utils:0153| [stderr] + echo ** ENABLE EVENTS + utils:0153| [stderr] + echo 1 + utils:0153| [stdout] ** ENABLE TRACING + utils:0153| [stderr] + echo ** ENABLE TRACING + utils:0153| [stderr] + enable_tracing + utils:0153| [stderr] + echo 1 + utils:0153| [stderr] + cnt_trace + utils:0153| [stderr] + wc -l + utils:0153| [stderr] + grep -v ^# trace + utils:0153| [stderr] + cnt=4077 + utils:0153| [stderr] + [ 4077 -eq 0 ] + utils:0153| [stderr] + func=schedule + utils:0153| [stderr] + available_file=available_filter_functions + utils:0153| [stderr] + [ -d ../../instances -a -f ../../available_filter_functions ] + utils:0153| [stderr] + grep ^\.schedule$ available_filter_functions + utils:0153| [stderr] + wc -l + utils:0153| [stdout] ** SET TRACEOFF + utils:0153| [stderr] + x=0 + utils:0153| [stderr] + [ 0 -eq 1 ] + utils:0153| [stderr] + echo ** SET TRACEOFF + utils:0153| [stderr] + echo schedule:traceoff + utils:0153| [stderr] + [ -d ../../instances ] + utils:0153| [stderr] + + wc -l + utils:0153| [stderr] grep schedule set_ftrace_filter + utils:0153| [stderr] + cnt=1 + utils:0153| [stderr] + [ 1 -ne 1 ] + utils:0153| [stderr] + cnt_trace + utils:0153| [stderr] + wc -l + utils:0153| [stderr] + grep -v ^# trace + utils:0153| [stderr] + cnt=21814 + utils:0153| [stderr] + sleep .1 + utils:0153| [stderr] + cnt_trace + utils:0153| [stderr] + grep+ wc -v ^# trace + utils:0153| [stderr] -l + utils:0153| [stderr] + cnt2=21814 + utils:0153| [stderr] + [ 21814 -ne 21814 ] + utils:0153| [stderr] + cat tracing_on + utils:0153| [stderr] + on=0 + utils:0153| [stderr] + [ 0 != 0 ] + utils:0153| [stderr] + md5sum trace + utils:0153| [stderr] + csum1=c6e4ee60fb108d69d9bbfe7e1db1063e trace + utils:0153| [stderr] + sleep .1 + utils:0153| [stderr] + md5sum trace + utils:0153| [stderr] + csum2=e4031c9f7b2a802822472087feacd82f trace + utils:0153| [stderr] + [ c6e4ee60fb108d69d9bbfe7e1db1063e trace != e4031c9f7b2a802822472087feacd82f trace ] + utils:0153| [stderr] + fail Tracing file is still changing + utils:0153| [stderr] + echo Tracing file is still changing + utils:0153| [stderr] + exit_fail + utils:0153| [stderr] + exit 1 + utils:0153| [stdout] Tracing file is still changing + utils:0153| [stdout] [FAIL] + utils:0153| [stderr] + initialize_ftrace + utils:0153| [stderr] + disable_tracing + utils:0153| [stderr] + echo 0 + utils:0153| [stderr] + reset_tracer + utils:0153| [stderr] + echo nop + utils:0153| [stderr] + reset_trigger + utils:0153| [stderr] + [ -d events/synthetic ] + (long output skipped) + utils:0153| [stderr] + read line + (long output skipped) + utils:0153| [stderr] + read line + (long output skipped) + utils:0153| [stderr] + reset_events_filter + utils:0153| [stderr] + read line + (long output skipped) utils:0153| [stderr] + reset_ftrace_filter utils:0153| [stderr] + [ ! -f set_ftrace_filter ] utils:0153| [stderr] + echo utils:0153| [stderr] + read t utils:0153| [stderr] + grep -v ^# set_ftrace_filter utils:0153| [stderr] + disable_events utils:0153| [stderr] + echo 0 utils:0153| [stderr] + [ -f set_event_pid ] utils:0153| [stderr] + echo utils:0153| [stderr] + [ -f set_ftrace_pid ] utils:0153| [stderr] + echo utils:0153| [stderr] + [ -f set_ftrace_notrace ] utils:0153| [stderr] + echo utils:0153| [stderr] + [ -f set_graph_function ] utils:0153| [stderr] + [ -f stack_trace_filter ] utils:0153| [stderr] + [ -f kprobe_events ] utils:0153| [stderr] + [ -f uprobe_events ] utils:0153| [stderr] + [ -f synthetic_events ] utils:0153| [stderr] + [ -f snapshot ] utils:0153| [stderr] + echo 0 utils:0153| [stderr] + clear_trace utils:0153| [stdout] [2] (instance) ftrace - test for function traceon/off triggersTesting function probes with enabling disabling tracing: utils:0153| [stdout] ** DISABLE TRACING utils:0153| [stderr] + echo utils:0153| [stderr] + enable_tracing utils:0153| [stderr] + echo 1 utils:0153| [stderr] + . /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/ftrace/func_traceonoff_triggers.tc utils:0153| [stderr] + [ ! -f set_ftrace_filter ] utils:0153| [stderr] + SLEEP_TIME=.1 utils:0153| [stderr] + echo Testing function probes with enabling disabling tracing: utils:0153| [stderr] + echo ** DISABLE TRACING utils:0153| [stderr] + disable_tracing utils:0153| [stderr] + echo 0 utils:0153| [stderr] + clear_trace utils:0153| [stderr] + echo utils:0153| [stderr] + cnt_trace utils:0153| [stderr] + wc -l utils:0153| [stderr] + grep -v ^# trace utils:0153| [stdout] ** ENABLE EVENTS utils:0153| [stdout] ** ENABLE TRACING utils:0153| [stderr] + cnt=0 utils:0153| [stderr] + [ 0 -ne 0 ] utils:0153| [stderr] + echo ** ENABLE EVENTS utils:0153| [stderr] + echo 1 utils:0153| [stderr] + echo ** ENABLE TRACING utils:0153| [stderr] + enable_tracing utils:0153| [stderr] + echo 1 utils:0153| [stderr] + cnt_trace utils:0153| [stderr] + wc -l utils:0153| [stderr] + grep -v ^# trace utils:0153| [stderr] + cnt=6780 utils:0153| [stderr] + [ 6780 -eq 0 ] utils:0153| [stderr] + func=schedule utils:0153| [stderr] + available_file=available_filter_functions utils:0153| [stderr] + [ -d ../../instances -a -f ../../available_filter_functions ] utils:0153| [stderr] + available_file=../../available_filter_functions utils:0153| [stderr] + grep ^\.schedule$ available_filter_functions utils:0153| [stderr] + wc -l utils:0153| [stderr] grep: available_filter_functions: No such file or directory utils:0153| [stderr] + x=0 utils:0153| [stderr] + [ 0 -eq 1 ] utils:0153| [stderr] + echo ** SET TRACEOFF utils:0153| [stderr] + echo schedule:traceoff utils:0153| [stdout] ** SET TRACEOFF utils:0153| [stderr] + [ -d ../../instances ] utils:0153| [stderr] + cat set_ftrace_filter utils:0153| [stderr] + cur=#### all functions enabled #### utils:0153| [stderr] schedule:traceoff:unlimited utils:0153| [stderr] + cat ../../set_ftrace_filter utils:0153| [stderr] + top=#### all functions enabled #### utils:0153| [stderr] schedule:traceoff:unlimited utils:0153| [stderr] + [ #### all functions enabled #### utils:0153| [stderr] schedule:traceoff:unlimited = #### all functions enabled #### utils:0153| [stderr] schedule:traceoff:unlimited ] utils:0153| [stderr] + echo This kernel is too old to support per instance filter utils:0153| [stdout] This kernel is too old to support per instance filter utils:0153| [stderr] + reset_ftrace_filter utils:0153| [stderr] + [ ! -f set_ftrace_filter ] utils:0153| [stderr] + echo utils:0153| [stderr] + grep -v+ ^#read t utils:0153| [stderr] set_ftrace_filter utils:0153| [stderr] + echo schedule:traceoff:unlimited utils:0153| [stderr] + cut -d: -f2 utils:0153| [stderr] + tr=traceoff utils:0153| [stderr] + [ traceoff = ] utils:0153| [stderr] + grep -q schedule:traceoff:unlimited set_ftrace_filter utils:0153| [stderr] + echo schedule:traceoff:unlimited utils:0153| [stderr] + cut -d: -f1 utils:0153| [stderr] + cut -d -f1 utils:0153| [stderr] + name=schedule utils:0153| [stderr] + [ traceoff = enable_event -o traceoff = disable_event ] utils:0153| [stderr] + cut -d: -f2 utils:0153| [stderr] + echo schedule:traceoff:unlimited utils:0153| [stderr] + tr=traceoff utils:0153| [stderr] + cut -d: -f3 utils:0153| [stderr] + echo schedule:traceoff:unlimited utils:0153| [stderr] + limit=unlimited utils:0153| [stderr] + [ unlimited != unlimited ] utils:0153| [stderr] + echo !schedule:traceoff utils:0153| [stderr] + read t utils:0153| [stderr] + exit_unsupported utils:0153| [stderr] + kill -s 40 23805 utils:0153| [stderr] + exit 0 utils:0153| [stdout] [UNSUPPORTED] utils:0153| [stdout] utils:0153| [stdout] utils:0153| [stdout] # of passed: 0 utils:0153| [stdout] # of failed: 1 utils:0153| [stdout] # of unresolved: 0 utils:0153| [stdout] # of untested: 0 utils:0153| [stdout] # of unsupported: 1 utils:0153| [stdout] # of xfailed: 0 utils:0153| [stdout] # of undefined(test bug): 0 - - - Need to retest on amaura to check if this is just a glitch.
** Description changed: - Issue found on Focal 5.4.0-29.33 with node amaura (passed on rizzo, - rizzo failed with other failures) - - utils:0116| Running './ftracetest -vvv test.d/ftrace/func_traceonoff_triggers.tc' - utils:0153| [stdout] === Ftrace unit tests === - utils:0153| [stderr] + initialize_ftrace - utils:0153| [stderr] + disable_tracing - utils:0153| [stderr] + echo 0 - utils:0153| [stderr] + reset_tracer - utils:0153| [stderr] + echo nop - utils:0153| [stderr] + reset_trigger - utils:0153| [stderr] + [ -d events/synthetic ] - (long output skipped) - utils:0153| [stderr] + read line - (long output skipped) - utils:0153| [stderr] + read line - (long output skipped) - utils:0153| [stderr] + reset_events_filter - utils:0153| [stderr] + read line - (long output skipped) - utils:0153| [stderr] + reset_ftrace_filter - utils:0153| [stderr] + [ ! -f set_ftrace_filter ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + grep -v ^# set_ftrace_filter - utils:0153| [stderr] + read t - utils:0153| [stderr] + disable_events - utils:0153| [stderr] + echo 0 - utils:0153| [stderr] + [ -f set_event_pid ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f set_ftrace_pid ] - utils:0153| [stdout] [1] ftrace - test for function traceon/off triggers - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f set_ftrace_notrace ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f set_graph_function ] - utils:0153| [stderr] + tee set_graph_function set_graph_notrace - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f stack_trace_filter ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f kprobe_events ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f uprobe_events ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f synthetic_events ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f snapshot ] - utils:0153| [stderr] + echo 0 - utils:0153| [stderr] + clear_trace - utils:0153| [stdout] Testing function probes with enabling disabling tracing: - utils:0153| [stdout] ** DISABLE TRACING - utils:0153| [stderr] + echo - utils:0153| [stderr] + enable_tracing - utils:0153| [stderr] + echo 1 - utils:0153| [stderr] + . /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/ftrace/func_traceonoff_triggers.tc - utils:0153| [stderr] + [ ! -f set_ftrace_filter ] - utils:0153| [stderr] + SLEEP_TIME=.1 - utils:0153| [stderr] + echo Testing function probes with enabling disabling tracing: - utils:0153| [stderr] + echo ** DISABLE TRACING - utils:0153| [stderr] + disable_tracing - utils:0153| [stderr] + echo 0 - utils:0153| [stderr] + clear_trace - utils:0153| [stderr] + echo - utils:0153| [stderr] + cnt_trace - utils:0153| [stderr] + + grep -v ^# trace - utils:0153| [stderr] wc -l - utils:0153| [stdout] ** ENABLE EVENTS - utils:0153| [stderr] + cnt=0 - utils:0153| [stderr] + [ 0 -ne 0 ] - utils:0153| [stderr] + echo ** ENABLE EVENTS - utils:0153| [stderr] + echo 1 - utils:0153| [stdout] ** ENABLE TRACING - utils:0153| [stderr] + echo ** ENABLE TRACING - utils:0153| [stderr] + enable_tracing - utils:0153| [stderr] + echo 1 - utils:0153| [stderr] + cnt_trace - utils:0153| [stderr] + wc -l - utils:0153| [stderr] + grep -v ^# trace - utils:0153| [stderr] + cnt=4077 - utils:0153| [stderr] + [ 4077 -eq 0 ] - utils:0153| [stderr] + func=schedule - utils:0153| [stderr] + available_file=available_filter_functions - utils:0153| [stderr] + [ -d ../../instances -a -f ../../available_filter_functions ] - utils:0153| [stderr] + grep ^\.schedule$ available_filter_functions - utils:0153| [stderr] + wc -l - utils:0153| [stdout] ** SET TRACEOFF - utils:0153| [stderr] + x=0 - utils:0153| [stderr] + [ 0 -eq 1 ] - utils:0153| [stderr] + echo ** SET TRACEOFF - utils:0153| [stderr] + echo schedule:traceoff - utils:0153| [stderr] + [ -d ../../instances ] - utils:0153| [stderr] + + wc -l - utils:0153| [stderr] grep schedule set_ftrace_filter - utils:0153| [stderr] + cnt=1 - utils:0153| [stderr] + [ 1 -ne 1 ] - utils:0153| [stderr] + cnt_trace - utils:0153| [stderr] + wc -l - utils:0153| [stderr] + grep -v ^# trace - utils:0153| [stderr] + cnt=21814 - utils:0153| [stderr] + sleep .1 - utils:0153| [stderr] + cnt_trace - utils:0153| [stderr] + grep+ wc -v ^# trace - utils:0153| [stderr] -l - utils:0153| [stderr] + cnt2=21814 - utils:0153| [stderr] + [ 21814 -ne 21814 ] - utils:0153| [stderr] + cat tracing_on - utils:0153| [stderr] + on=0 - utils:0153| [stderr] + [ 0 != 0 ] - utils:0153| [stderr] + md5sum trace - utils:0153| [stderr] + csum1=c6e4ee60fb108d69d9bbfe7e1db1063e trace - utils:0153| [stderr] + sleep .1 - utils:0153| [stderr] + md5sum trace - utils:0153| [stderr] + csum2=e4031c9f7b2a802822472087feacd82f trace - utils:0153| [stderr] + [ c6e4ee60fb108d69d9bbfe7e1db1063e trace != e4031c9f7b2a802822472087feacd82f trace ] - utils:0153| [stderr] + fail Tracing file is still changing - utils:0153| [stderr] + echo Tracing file is still changing - utils:0153| [stderr] + exit_fail - utils:0153| [stderr] + exit 1 - utils:0153| [stdout] Tracing file is still changing - utils:0153| [stdout] [FAIL] - utils:0153| [stderr] + initialize_ftrace - utils:0153| [stderr] + disable_tracing - utils:0153| [stderr] + echo 0 - utils:0153| [stderr] + reset_tracer - utils:0153| [stderr] + echo nop - utils:0153| [stderr] + reset_trigger - utils:0153| [stderr] + [ -d events/synthetic ] - (long output skipped) - utils:0153| [stderr] + read line - (long output skipped) - utils:0153| [stderr] + read line - (long output skipped) - utils:0153| [stderr] + reset_events_filter - utils:0153| [stderr] + read line - (long output skipped) - utils:0153| [stderr] + reset_ftrace_filter - utils:0153| [stderr] + [ ! -f set_ftrace_filter ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + read t - utils:0153| [stderr] + grep -v ^# set_ftrace_filter - utils:0153| [stderr] + disable_events - utils:0153| [stderr] + echo 0 - utils:0153| [stderr] + [ -f set_event_pid ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f set_ftrace_pid ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f set_ftrace_notrace ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + [ -f set_graph_function ] - utils:0153| [stderr] + [ -f stack_trace_filter ] - utils:0153| [stderr] + [ -f kprobe_events ] - utils:0153| [stderr] + [ -f uprobe_events ] - utils:0153| [stderr] + [ -f synthetic_events ] - utils:0153| [stderr] + [ -f snapshot ] - utils:0153| [stderr] + echo 0 - utils:0153| [stderr] + clear_trace - utils:0153| [stdout] [2] (instance) ftrace - test for function traceon/off triggersTesting function probes with enabling disabling tracing: - utils:0153| [stdout] ** DISABLE TRACING - utils:0153| [stderr] + echo - utils:0153| [stderr] + enable_tracing - utils:0153| [stderr] + echo 1 - utils:0153| [stderr] + . /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/ftrace/func_traceonoff_triggers.tc - utils:0153| [stderr] + [ ! -f set_ftrace_filter ] - utils:0153| [stderr] + SLEEP_TIME=.1 - utils:0153| [stderr] + echo Testing function probes with enabling disabling tracing: - utils:0153| [stderr] + echo ** DISABLE TRACING - utils:0153| [stderr] + disable_tracing - utils:0153| [stderr] + echo 0 - utils:0153| [stderr] + clear_trace - utils:0153| [stderr] + echo - utils:0153| [stderr] + cnt_trace - utils:0153| [stderr] + wc -l - utils:0153| [stderr] + grep -v ^# trace - utils:0153| [stdout] ** ENABLE EVENTS - utils:0153| [stdout] ** ENABLE TRACING - utils:0153| [stderr] + cnt=0 - utils:0153| [stderr] + [ 0 -ne 0 ] - utils:0153| [stderr] + echo ** ENABLE EVENTS - utils:0153| [stderr] + echo 1 - utils:0153| [stderr] + echo ** ENABLE TRACING - utils:0153| [stderr] + enable_tracing - utils:0153| [stderr] + echo 1 - utils:0153| [stderr] + cnt_trace - utils:0153| [stderr] + wc -l - utils:0153| [stderr] + grep -v ^# trace - utils:0153| [stderr] + cnt=6780 - utils:0153| [stderr] + [ 6780 -eq 0 ] - utils:0153| [stderr] + func=schedule - utils:0153| [stderr] + available_file=available_filter_functions - utils:0153| [stderr] + [ -d ../../instances -a -f ../../available_filter_functions ] - utils:0153| [stderr] + available_file=../../available_filter_functions - utils:0153| [stderr] + grep ^\.schedule$ available_filter_functions - utils:0153| [stderr] + wc -l - utils:0153| [stderr] grep: available_filter_functions: No such file or directory - utils:0153| [stderr] + x=0 - utils:0153| [stderr] + [ 0 -eq 1 ] - utils:0153| [stderr] + echo ** SET TRACEOFF - utils:0153| [stderr] + echo schedule:traceoff - utils:0153| [stdout] ** SET TRACEOFF - utils:0153| [stderr] + [ -d ../../instances ] - utils:0153| [stderr] + cat set_ftrace_filter - utils:0153| [stderr] + cur=#### all functions enabled #### - utils:0153| [stderr] schedule:traceoff:unlimited - utils:0153| [stderr] + cat ../../set_ftrace_filter - utils:0153| [stderr] + top=#### all functions enabled #### - utils:0153| [stderr] schedule:traceoff:unlimited - utils:0153| [stderr] + [ #### all functions enabled #### - utils:0153| [stderr] schedule:traceoff:unlimited = #### all functions enabled #### - utils:0153| [stderr] schedule:traceoff:unlimited ] - utils:0153| [stderr] + echo This kernel is too old to support per instance filter - utils:0153| [stdout] This kernel is too old to support per instance filter - utils:0153| [stderr] + reset_ftrace_filter - utils:0153| [stderr] + [ ! -f set_ftrace_filter ] - utils:0153| [stderr] + echo - utils:0153| [stderr] + grep -v+ ^#read t - utils:0153| [stderr] set_ftrace_filter - utils:0153| [stderr] + echo schedule:traceoff:unlimited - utils:0153| [stderr] + cut -d: -f2 - utils:0153| [stderr] + tr=traceoff - utils:0153| [stderr] + [ traceoff = ] - utils:0153| [stderr] + grep -q schedule:traceoff:unlimited set_ftrace_filter - utils:0153| [stderr] + echo schedule:traceoff:unlimited - utils:0153| [stderr] + cut -d: -f1 - utils:0153| [stderr] + cut -d -f1 - utils:0153| [stderr] + name=schedule - utils:0153| [stderr] + [ traceoff = enable_event -o traceoff = disable_event ] - utils:0153| [stderr] + cut -d: -f2 - utils:0153| [stderr] + echo schedule:traceoff:unlimited - utils:0153| [stderr] + tr=traceoff - utils:0153| [stderr] + cut -d: -f3 - utils:0153| [stderr] + echo schedule:traceoff:unlimited - utils:0153| [stderr] + limit=unlimited - utils:0153| [stderr] + [ unlimited != unlimited ] - utils:0153| [stderr] + echo !schedule:traceoff - utils:0153| [stderr] + read t - utils:0153| [stderr] + exit_unsupported - utils:0153| [stderr] + kill -s 40 23805 - utils:0153| [stderr] + exit 0 - utils:0153| [stdout] [UNSUPPORTED] - utils:0153| [stdout] - utils:0153| [stdout] - utils:0153| [stdout] # of passed: 0 - utils:0153| [stdout] # of failed: 1 - utils:0153| [stdout] # of unresolved: 0 - utils:0153| [stdout] # of untested: 0 - utils:0153| [stdout] # of unsupported: 1 - utils:0153| [stdout] # of xfailed: 0 - utils:0153| [stdout] # of undefined(test bug): 0 + Issue found on Focal 5.4.0-29.33 with node amaura (passed on rizzo, rizzo failed with other failures) + Running './ftracetest -vvv test.d/ftrace/func_traceonoff_triggers.tc' + [stdout] === Ftrace unit tests === + [stderr] + initialize_ftrace + [stderr] + disable_tracing + [stderr] + echo 0 + [stderr] + reset_tracer + [stderr] + echo nop + [stderr] + reset_trigger + [stderr] + [ -d events/synthetic ] + (long output skipped) + [stderr] + read line + (long output skipped) + [stderr] + read line + (long output skipped) + [stderr] + reset_events_filter + [stderr] + read line + (long output skipped) + [stderr] + reset_ftrace_filter + [stderr] + [ ! -f set_ftrace_filter ] + [stderr] + echo + [stderr] + grep -v ^# set_ftrace_filter + [stderr] + read t + [stderr] + disable_events + [stderr] + echo 0 + [stderr] + [ -f set_event_pid ] + [stderr] + echo + [stderr] + [ -f set_ftrace_pid ] + [stdout] [1] ftrace - test for function traceon/off triggers + [stderr] + echo + [stderr] + [ -f set_ftrace_notrace ] + [stderr] + echo + [stderr] + [ -f set_graph_function ] + [stderr] + tee set_graph_function set_graph_notrace + [stderr] + echo + [stderr] + [ -f stack_trace_filter ] + [stderr] + echo + [stderr] + [ -f kprobe_events ] + [stderr] + echo + [stderr] + [ -f uprobe_events ] + [stderr] + echo + [stderr] + [ -f synthetic_events ] + [stderr] + echo + [stderr] + [ -f snapshot ] + [stderr] + echo 0 + [stderr] + clear_trace + [stdout] Testing function probes with enabling disabling tracing: + [stdout] ** DISABLE TRACING + [stderr] + echo + [stderr] + enable_tracing + [stderr] + echo 1 + [stderr] + . /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/ftrace/func_traceonoff_triggers.tc + [stderr] + [ ! -f set_ftrace_filter ] + [stderr] + SLEEP_TIME=.1 + [stderr] + echo Testing function probes with enabling disabling tracing: + [stderr] + echo ** DISABLE TRACING + [stderr] + disable_tracing + [stderr] + echo 0 + [stderr] + clear_trace + [stderr] + echo + [stderr] + cnt_trace + [stderr] + + grep -v ^# trace + [stderr] wc -l + [stdout] ** ENABLE EVENTS + [stderr] + cnt=0 + [stderr] + [ 0 -ne 0 ] + [stderr] + echo ** ENABLE EVENTS + [stderr] + echo 1 + [stdout] ** ENABLE TRACING + [stderr] + echo ** ENABLE TRACING + [stderr] + enable_tracing + [stderr] + echo 1 + [stderr] + cnt_trace + [stderr] + wc -l + [stderr] + grep -v ^# trace + [stderr] + cnt=4077 + [stderr] + [ 4077 -eq 0 ] + [stderr] + func=schedule + [stderr] + available_file=available_filter_functions + [stderr] + [ -d ../../instances -a -f ../../available_filter_functions ] + [stderr] + grep ^\.schedule$ available_filter_functions + [stderr] + wc -l + [stdout] ** SET TRACEOFF + [stderr] + x=0 + [stderr] + [ 0 -eq 1 ] + [stderr] + echo ** SET TRACEOFF + [stderr] + echo schedule:traceoff + [stderr] + [ -d ../../instances ] + [stderr] + + wc -l + [stderr] grep schedule set_ftrace_filter + [stderr] + cnt=1 + [stderr] + [ 1 -ne 1 ] + [stderr] + cnt_trace + [stderr] + wc -l + [stderr] + grep -v ^# trace + [stderr] + cnt=21814 + [stderr] + sleep .1 + [stderr] + cnt_trace + [stderr] + grep+ wc -v ^# trace + [stderr] -l + [stderr] + cnt2=21814 + [stderr] + [ 21814 -ne 21814 ] + [stderr] + cat tracing_on + [stderr] + on=0 + [stderr] + [ 0 != 0 ] + [stderr] + md5sum trace + [stderr] + csum1=c6e4ee60fb108d69d9bbfe7e1db1063e trace + [stderr] + sleep .1 + [stderr] + md5sum trace + [stderr] + csum2=e4031c9f7b2a802822472087feacd82f trace + [stderr] + [ c6e4ee60fb108d69d9bbfe7e1db1063e trace != e4031c9f7b2a802822472087feacd82f trace ] + [stderr] + fail Tracing file is still changing + [stderr] + echo Tracing file is still changing + [stderr] + exit_fail + [stderr] + exit 1 + [stdout] Tracing file is still changing + [stdout] [FAIL] + [stderr] + initialize_ftrace + [stderr] + disable_tracing + [stderr] + echo 0 + [stderr] + reset_tracer + [stderr] + echo nop + [stderr] + reset_trigger + [stderr] + [ -d events/synthetic ] + (long output skipped) + [stderr] + read line + (long output skipped) + [stderr] + read line + (long output skipped) + [stderr] + reset_events_filter + [stderr] + read line + (long output skipped) + [stderr] + reset_ftrace_filter + [stderr] + [ ! -f set_ftrace_filter ] + [stderr] + echo + [stderr] + read t + [stderr] + grep -v ^# set_ftrace_filter + [stderr] + disable_events + [stderr] + echo 0 + [stderr] + [ -f set_event_pid ] + [stderr] + echo + [stderr] + [ -f set_ftrace_pid ] + [stderr] + echo + [stderr] + [ -f set_ftrace_notrace ] + [stderr] + echo + [stderr] + [ -f set_graph_function ] + [stderr] + [ -f stack_trace_filter ] + [stderr] + [ -f kprobe_events ] + [stderr] + [ -f uprobe_events ] + [stderr] + [ -f synthetic_events ] + [stderr] + [ -f snapshot ] + [stderr] + echo 0 + [stderr] + clear_trace + [stdout] [2] (instance) ftrace - test for function traceon/off triggersTesting function probes with enabling disabling tracing: + [stdout] ** DISABLE TRACING + [stderr] + echo + [stderr] + enable_tracing + [stderr] + echo 1 + [stderr] + . /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/ftrace/func_traceonoff_triggers.tc + [stderr] + [ ! -f set_ftrace_filter ] + [stderr] + SLEEP_TIME=.1 + [stderr] + echo Testing function probes with enabling disabling tracing: + [stderr] + echo ** DISABLE TRACING + [stderr] + disable_tracing + [stderr] + echo 0 + [stderr] + clear_trace + [stderr] + echo + [stderr] + cnt_trace + [stderr] + wc -l + [stderr] + grep -v ^# trace + [stdout] ** ENABLE EVENTS + [stdout] ** ENABLE TRACING + [stderr] + cnt=0 + [stderr] + [ 0 -ne 0 ] + [stderr] + echo ** ENABLE EVENTS + [stderr] + echo 1 + [stderr] + echo ** ENABLE TRACING + [stderr] + enable_tracing + [stderr] + echo 1 + [stderr] + cnt_trace + [stderr] + wc -l + [stderr] + grep -v ^# trace + [stderr] + cnt=6780 + [stderr] + [ 6780 -eq 0 ] + [stderr] + func=schedule + [stderr] + available_file=available_filter_functions + [stderr] + [ -d ../../instances -a -f ../../available_filter_functions ] + [stderr] + available_file=../../available_filter_functions + [stderr] + grep ^\.schedule$ available_filter_functions + [stderr] + wc -l + [stderr] grep: available_filter_functions: No such file or directory + [stderr] + x=0 + [stderr] + [ 0 -eq 1 ] + [stderr] + echo ** SET TRACEOFF + [stderr] + echo schedule:traceoff + [stdout] ** SET TRACEOFF + [stderr] + [ -d ../../instances ] + [stderr] + cat set_ftrace_filter + [stderr] + cur=#### all functions enabled #### + [stderr] schedule:traceoff:unlimited + [stderr] + cat ../../set_ftrace_filter + [stderr] + top=#### all functions enabled #### + [stderr] schedule:traceoff:unlimited + [stderr] + [ #### all functions enabled #### + [stderr] schedule:traceoff:unlimited = #### all functions enabled #### + [stderr] schedule:traceoff:unlimited ] + [stderr] + echo This kernel is too old to support per instance filter + [stdout] This kernel is too old to support per instance filter + [stderr] + reset_ftrace_filter + [stderr] + [ ! -f set_ftrace_filter ] + [stderr] + echo + [stderr] + grep -v+ ^#read t + [stderr] set_ftrace_filter + [stderr] + echo schedule:traceoff:unlimited + [stderr] + cut -d: -f2 + [stderr] + tr=traceoff + [stderr] + [ traceoff = ] + [stderr] + grep -q schedule:traceoff:unlimited set_ftrace_filter + [stderr] + echo schedule:traceoff:unlimited + [stderr] + cut -d: -f1 + [stderr] + cut -d -f1 + [stderr] + name=schedule + [stderr] + [ traceoff = enable_event -o traceoff = disable_event ] + [stderr] + cut -d: -f2 + [stderr] + echo schedule:traceoff:unlimited + [stderr] + tr=traceoff + [stderr] + cut -d: -f3 + [stderr] + echo schedule:traceoff:unlimited + [stderr] + limit=unlimited + [stderr] + [ unlimited != unlimited ] + [stderr] + echo !schedule:traceoff + [stderr] + read t + [stderr] + exit_unsupported + [stderr] + kill -s 40 23805 + [stderr] + exit 0 + [stdout] [UNSUPPORTED] + [stdout] + [stdout] + [stdout] # of passed: 0 + [stdout] # of failed: 1 + [stdout] # of unresolved: 0 + [stdout] # of untested: 0 + [stdout] # of unsupported: 1 + [stdout] # of xfailed: 0 + [stdout] # of undefined(test bug): 0 ** Attachment added: "ftrace-func_traceonoff_triggers.log" https://bugs.launchpad.net/ubuntu/+source/linux/+bug/1876687/+attachment/5688838/+files/ftrace-func_traceonoff_triggers.log -- You received this bug notification because you are a member of Kernel Packages, which is subscribed to linux in Ubuntu. https://bugs.launchpad.net/bugs/1876687 Title: func_traceonoff_triggers.tc from ubuntu_kselftests_ftrace flaky (Tracing file is still changing) Status in ubuntu-kernel-tests: New Status in linux package in Ubuntu: Incomplete Bug description: Issue found on Focal 5.4.0-29.33 with node amaura (passed on rizzo, rizzo failed with other failures) Running './ftracetest -vvv test.d/ftrace/func_traceonoff_triggers.tc' [stdout] === Ftrace unit tests === [stderr] + initialize_ftrace [stderr] + disable_tracing [stderr] + echo 0 [stderr] + reset_tracer [stderr] + echo nop [stderr] + reset_trigger [stderr] + [ -d events/synthetic ] (long output skipped) [stderr] + read line (long output skipped) [stderr] + read line (long output skipped) [stderr] + reset_events_filter [stderr] + read line (long output skipped) [stderr] + reset_ftrace_filter [stderr] + [ ! -f set_ftrace_filter ] [stderr] + echo [stderr] + grep -v ^# set_ftrace_filter [stderr] + read t [stderr] + disable_events [stderr] + echo 0 [stderr] + [ -f set_event_pid ] [stderr] + echo [stderr] + [ -f set_ftrace_pid ] [stdout] [1] ftrace - test for function traceon/off triggers [stderr] + echo [stderr] + [ -f set_ftrace_notrace ] [stderr] + echo [stderr] + [ -f set_graph_function ] [stderr] + tee set_graph_function set_graph_notrace [stderr] + echo [stderr] + [ -f stack_trace_filter ] [stderr] + echo [stderr] + [ -f kprobe_events ] [stderr] + echo [stderr] + [ -f uprobe_events ] [stderr] + echo [stderr] + [ -f synthetic_events ] [stderr] + echo [stderr] + [ -f snapshot ] [stderr] + echo 0 [stderr] + clear_trace [stdout] Testing function probes with enabling disabling tracing: [stdout] ** DISABLE TRACING [stderr] + echo [stderr] + enable_tracing [stderr] + echo 1 [stderr] + . /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/ftrace/func_traceonoff_triggers.tc [stderr] + [ ! -f set_ftrace_filter ] [stderr] + SLEEP_TIME=.1 [stderr] + echo Testing function probes with enabling disabling tracing: [stderr] + echo ** DISABLE TRACING [stderr] + disable_tracing [stderr] + echo 0 [stderr] + clear_trace [stderr] + echo [stderr] + cnt_trace [stderr] + + grep -v ^# trace [stderr] wc -l [stdout] ** ENABLE EVENTS [stderr] + cnt=0 [stderr] + [ 0 -ne 0 ] [stderr] + echo ** ENABLE EVENTS [stderr] + echo 1 [stdout] ** ENABLE TRACING [stderr] + echo ** ENABLE TRACING [stderr] + enable_tracing [stderr] + echo 1 [stderr] + cnt_trace [stderr] + wc -l [stderr] + grep -v ^# trace [stderr] + cnt=4077 [stderr] + [ 4077 -eq 0 ] [stderr] + func=schedule [stderr] + available_file=available_filter_functions [stderr] + [ -d ../../instances -a -f ../../available_filter_functions ] [stderr] + grep ^\.schedule$ available_filter_functions [stderr] + wc -l [stdout] ** SET TRACEOFF [stderr] + x=0 [stderr] + [ 0 -eq 1 ] [stderr] + echo ** SET TRACEOFF [stderr] + echo schedule:traceoff [stderr] + [ -d ../../instances ] [stderr] + + wc -l [stderr] grep schedule set_ftrace_filter [stderr] + cnt=1 [stderr] + [ 1 -ne 1 ] [stderr] + cnt_trace [stderr] + wc -l [stderr] + grep -v ^# trace [stderr] + cnt=21814 [stderr] + sleep .1 [stderr] + cnt_trace [stderr] + grep+ wc -v ^# trace [stderr] -l [stderr] + cnt2=21814 [stderr] + [ 21814 -ne 21814 ] [stderr] + cat tracing_on [stderr] + on=0 [stderr] + [ 0 != 0 ] [stderr] + md5sum trace [stderr] + csum1=c6e4ee60fb108d69d9bbfe7e1db1063e trace [stderr] + sleep .1 [stderr] + md5sum trace [stderr] + csum2=e4031c9f7b2a802822472087feacd82f trace [stderr] + [ c6e4ee60fb108d69d9bbfe7e1db1063e trace != e4031c9f7b2a802822472087feacd82f trace ] [stderr] + fail Tracing file is still changing [stderr] + echo Tracing file is still changing [stderr] + exit_fail [stderr] + exit 1 [stdout] Tracing file is still changing [stdout] [FAIL] [stderr] + initialize_ftrace [stderr] + disable_tracing [stderr] + echo 0 [stderr] + reset_tracer [stderr] + echo nop [stderr] + reset_trigger [stderr] + [ -d events/synthetic ] (long output skipped) [stderr] + read line (long output skipped) [stderr] + read line (long output skipped) [stderr] + reset_events_filter [stderr] + read line (long output skipped) [stderr] + reset_ftrace_filter [stderr] + [ ! -f set_ftrace_filter ] [stderr] + echo [stderr] + read t [stderr] + grep -v ^# set_ftrace_filter [stderr] + disable_events [stderr] + echo 0 [stderr] + [ -f set_event_pid ] [stderr] + echo [stderr] + [ -f set_ftrace_pid ] [stderr] + echo [stderr] + [ -f set_ftrace_notrace ] [stderr] + echo [stderr] + [ -f set_graph_function ] [stderr] + [ -f stack_trace_filter ] [stderr] + [ -f kprobe_events ] [stderr] + [ -f uprobe_events ] [stderr] + [ -f synthetic_events ] [stderr] + [ -f snapshot ] [stderr] + echo 0 [stderr] + clear_trace [stdout] [2] (instance) ftrace - test for function traceon/off triggersTesting function probes with enabling disabling tracing: [stdout] ** DISABLE TRACING [stderr] + echo [stderr] + enable_tracing [stderr] + echo 1 [stderr] + . /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/ftrace/func_traceonoff_triggers.tc [stderr] + [ ! -f set_ftrace_filter ] [stderr] + SLEEP_TIME=.1 [stderr] + echo Testing function probes with enabling disabling tracing: [stderr] + echo ** DISABLE TRACING [stderr] + disable_tracing [stderr] + echo 0 [stderr] + clear_trace [stderr] + echo [stderr] + cnt_trace [stderr] + wc -l [stderr] + grep -v ^# trace [stdout] ** ENABLE EVENTS [stdout] ** ENABLE TRACING [stderr] + cnt=0 [stderr] + [ 0 -ne 0 ] [stderr] + echo ** ENABLE EVENTS [stderr] + echo 1 [stderr] + echo ** ENABLE TRACING [stderr] + enable_tracing [stderr] + echo 1 [stderr] + cnt_trace [stderr] + wc -l [stderr] + grep -v ^# trace [stderr] + cnt=6780 [stderr] + [ 6780 -eq 0 ] [stderr] + func=schedule [stderr] + available_file=available_filter_functions [stderr] + [ -d ../../instances -a -f ../../available_filter_functions ] [stderr] + available_file=../../available_filter_functions [stderr] + grep ^\.schedule$ available_filter_functions [stderr] + wc -l [stderr] grep: available_filter_functions: No such file or directory [stderr] + x=0 [stderr] + [ 0 -eq 1 ] [stderr] + echo ** SET TRACEOFF [stderr] + echo schedule:traceoff [stdout] ** SET TRACEOFF [stderr] + [ -d ../../instances ] [stderr] + cat set_ftrace_filter [stderr] + cur=#### all functions enabled #### [stderr] schedule:traceoff:unlimited [stderr] + cat ../../set_ftrace_filter [stderr] + top=#### all functions enabled #### [stderr] schedule:traceoff:unlimited [stderr] + [ #### all functions enabled #### [stderr] schedule:traceoff:unlimited = #### all functions enabled #### [stderr] schedule:traceoff:unlimited ] [stderr] + echo This kernel is too old to support per instance filter [stdout] This kernel is too old to support per instance filter [stderr] + reset_ftrace_filter [stderr] + [ ! -f set_ftrace_filter ] [stderr] + echo [stderr] + grep -v+ ^#read t [stderr] set_ftrace_filter [stderr] + echo schedule:traceoff:unlimited [stderr] + cut -d: -f2 [stderr] + tr=traceoff [stderr] + [ traceoff = ] [stderr] + grep -q schedule:traceoff:unlimited set_ftrace_filter [stderr] + echo schedule:traceoff:unlimited [stderr] + cut -d: -f1 [stderr] + cut -d -f1 [stderr] + name=schedule [stderr] + [ traceoff = enable_event -o traceoff = disable_event ] [stderr] + cut -d: -f2 [stderr] + echo schedule:traceoff:unlimited [stderr] + tr=traceoff [stderr] + cut -d: -f3 [stderr] + echo schedule:traceoff:unlimited [stderr] + limit=unlimited [stderr] + [ unlimited != unlimited ] [stderr] + echo !schedule:traceoff [stderr] + read t [stderr] + exit_unsupported [stderr] + kill -s 40 23805 [stderr] + exit 0 [stdout] [UNSUPPORTED] [stdout] [stdout] [stdout] # of passed: 0 [stdout] # of failed: 1 [stdout] # of unresolved: 0 [stdout] # of untested: 0 [stdout] # of unsupported: 1 [stdout] # of xfailed: 0 [stdout] # of undefined(test bug): 0 To manage notifications about this bug go to: https://bugs.launchpad.net/ubuntu-kernel-tests/+bug/1876687/+subscriptions -- Mailing list: https://launchpad.net/~kernel-packages Post to : kernel-packages@lists.launchpad.net Unsubscribe : https://launchpad.net/~kernel-packages More help : https://help.launchpad.net/ListHelp
