← Back to team overview

canonical-ubuntu-qa team mailing list archive

  1. canonical-ubuntu-qa team
  2. Mailing list archive
  3. Message #06052

[Bug 2095589] [NEW] ubuntu_kselftests_ftrace/test.d--trigger--inter-event--trigger-snapshot-action-hist.tc flaky on O-oracle

  Thread Previous • Date Previous • • Thread Next 
Public bug reported:

Issue found with O-oracle 6.11.0-1010.10 (s20241202) on BM.Optimized3.36
and BM.Standard3.64

Test passed on both instances with the 3rd attempt. Bug opened for
future reference.

Test failed with:
[1] event trigger - test inter-event histogram trigger snapshot action	[FAIL]

Test log (partially truncated):
=== Ftrace unit tests ===
[1] event trigger - test inter-event histogram trigger snapshot action	[FAIL]
execute: /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/trigger/inter-event/trigger-snapshot-action-hist.tc
+ checkreq /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/trigger/inter-event/trigger-snapshot-action-hist.tc
+ grep ^#[ \t]*requires: /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/trigger/inter-event/trigger-snapshot-action-hist.tc
+ cut -f2- -d:
+ requires= set_event snapshot events/sched/sched_process_fork/hist "onchange(var)":README "snapshot()":README ping:program
+ eval check_requires  set_event snapshot events/sched/sched_process_fork/hist "onchange(var)":README "snapshot()":README ping:program
+ check_requires set_event snapshot events/sched/sched_process_fork/hist onchange(var):README snapshot():README ping:program
+ p=set_event
+ r=set_event
+ t=set_event
+ [ set_event != set_event ]
+ [ set_event != set_event ]
+ [ set_event != set_event ]
+ [ ! -e set_event ]
+ p=snapshot
+ r=snapshot
+ t=snapshot
+ [ snapshot != snapshot ]
+ [ snapshot != snapshot ]
+ [ snapshot != snapshot ]
+ [ ! -e snapshot ]
+ p=events/sched/sched_process_fork/hist
+ r=events/sched/sched_process_fork/hist
+ t=events/sched/sched_process_fork/hist
+ [ events/sched/sched_process_fork/hist != events/sched/sched_process_fork/hist ]
+ [ events/sched/sched_process_fork/hist != events/sched/sched_process_fork/hist ]
+ [ events/sched/sched_process_fork/hist != events/sched/sched_process_fork/hist ]
+ [ ! -e events/sched/sched_process_fork/hist ]
+ p=onchange(var):README
+ r=onchange(var)
+ t=onchange(var):README
+ [ onchange(var):README != onchange(var):README ]
+ [ onchange(var):README != onchange(var):README ]
+ [ onchange(var) != onchange(var):README ]
+ grep -Fq onchange(var) README
+ p=snapshot():README
+ r=snapshot()
+ t=snapshot():README
+ [ snapshot():README != snapshot():README ]
+ [ snapshot():README != snapshot():README ]
+ [ snapshot() != snapshot():README ]
+ grep -Fq snapshot() README
+ p=ping
+ r=ping:program
+ t=ping:program
+ [ ping != ping:program ]
+ which ping
/usr/bin/ping
+ initialize_ftrace
+ disable_tracing
+ echo 0
+ reset_tracer
+ echo nop
+ reset_trigger
+ [ -d events/synthetic ]
+ reset_trigger_file events/alarmtimer/alarmtimer_cancel/trigger events/alarmtimer/alarmtimer_fired/trigger events/alarmtimer/alarmtimer_start/trigger ...
+ read line
+ grep -H :on[^:]*( events/alarmtimer/alarmtimer_cancel/trigger events/alarmtimer/alarmtimer_fired/trigger ...
+ read line
+ grep -Hv ^# events/alarmtimer/alarmtimer_cancel/trigger events/alarmtimer/alarmtimer_fired/trigger ...
+ reset_events_filter
+ read line
+ grep -v ^none events/alarmtimer/alarmtimer_cancel/filter events/alarmtimer/alarmtimer_fired/filter events/alarmtimer/alarmtimer_start/filter ...
+ reset_ftrace_filter
+ [ ! -f set_ftrace_filter ]
+ echo
+ grep -v ^# set_ftrace_filter
+ read t
+ disable_events
+ echo 0
+ clear_dynamic_events
+ again=1
+ stop=1
+ [ 1 -eq 1 ]
+ stop=2
+ [ 2 -gt 10 ]
+ again=2
+ grep -v ^# dynamic_events
+ read line
+ [ 2 -eq 1 ]
+ [ -f set_event_pid ]
+ echo
+ [ -f set_ftrace_pid ]
+ echo
+ [ -f set_ftrace_notrace ]
+ echo
+ [ -f set_graph_function ]
+ echo
+ tee set_graph_function set_graph_notrace

+ [ -f stack_trace_filter ]
+ echo
+ [ -f kprobe_events ]
+ echo
+ [ -f uprobe_events ]
+ echo
+ [ -f synthetic_events ]
+ echo
+ [ -f snapshot ]
+ echo 0
+ [ -f options/pause-on-trace ]
+ echo 1
+ clear_trace
+ echo
+ enable_tracing
+ echo 1
+ . /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/trigger/inter-event/trigger-snapshot-action-hist.tc
+ echo Test snapshot action
Test snapshot action
+ echo 1
+ echo hist:keys=comm:newprio=prio:onchange($newprio).save(comm,prio):onchange($newprio).snapshot() if comm=="ping"
+ ping 127.0.0.1 -c 3
PING 127.0.0.1 (127.0.0.1) 56(84) bytes of data.
64 bytes from 127.0.0.1: icmp_seq=1 ttl=64 time=0.068 ms
64 bytes from 127.0.0.1: icmp_seq=2 ttl=64 time=0.044 ms
64 bytes from 127.0.0.1: icmp_seq=3 ttl=64 time=0.045 ms

--- 127.0.0.1 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2048ms
rtt min/avg/max/mdev = 0.044/0.052/0.068/0.011 ms
+ nice -n 1 ping 127.0.0.1 -c 3
PING 127.0.0.1 (127.0.0.1) 56(84) bytes of data.
64 bytes from 127.0.0.1: icmp_seq=1 ttl=64 time=0.036 ms
64 bytes from 127.0.0.1: icmp_seq=2 ttl=64 time=0.045 ms
64 bytes from 127.0.0.1: icmp_seq=3 ttl=64 time=0.045 ms

--- 127.0.0.1 ping statistics ---
3 packets transmitted, 3 received, 0% packet loss, time 2043ms
rtt min/avg/max/mdev = 0.036/0.042/0.045/0.004 ms
+ echo 0
+ grep -q changed: events/sched/sched_waking/hist
+ grep -q comm=ping snapshot
+ fail Failed to create snapshot action inter-event histogram
+ echo Failed to create snapshot action inter-event histogram
Failed to create snapshot action inter-event histogram
+ exit_fail
+ exit 1

** Affects: ubuntu-kernel-tests
     Importance: Undecided
         Status: New


** Tags: 6.11 oracle oracular s20241202

-- 
You received this bug notification because you are a member of Canonical
Platform QA Team, which is subscribed to ubuntu-kernel-tests.
https://bugs.launchpad.net/bugs/2095589

Title:
  ubuntu_kselftests_ftrace/test.d--trigger--inter-event--trigger-
  snapshot-action-hist.tc flaky on O-oracle

Status in ubuntu-kernel-tests:
  New

Bug description:
  Issue found with O-oracle 6.11.0-1010.10 (s20241202) on
  BM.Optimized3.36 and BM.Standard3.64

  Test passed on both instances with the 3rd attempt. Bug opened for
  future reference.

  Test failed with:
  [1] event trigger - test inter-event histogram trigger snapshot action	[FAIL]

  Test log (partially truncated):
  === Ftrace unit tests ===
  [1] event trigger - test inter-event histogram trigger snapshot action	[FAIL]
  execute: /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/trigger/inter-event/trigger-snapshot-action-hist.tc
  + checkreq /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/trigger/inter-event/trigger-snapshot-action-hist.tc
  + grep ^#[ \t]*requires: /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/trigger/inter-event/trigger-snapshot-action-hist.tc
  + cut -f2- -d:
  + requires= set_event snapshot events/sched/sched_process_fork/hist "onchange(var)":README "snapshot()":README ping:program
  + eval check_requires  set_event snapshot events/sched/sched_process_fork/hist "onchange(var)":README "snapshot()":README ping:program
  + check_requires set_event snapshot events/sched/sched_process_fork/hist onchange(var):README snapshot():README ping:program
  + p=set_event
  + r=set_event
  + t=set_event
  + [ set_event != set_event ]
  + [ set_event != set_event ]
  + [ set_event != set_event ]
  + [ ! -e set_event ]
  + p=snapshot
  + r=snapshot
  + t=snapshot
  + [ snapshot != snapshot ]
  + [ snapshot != snapshot ]
  + [ snapshot != snapshot ]
  + [ ! -e snapshot ]
  + p=events/sched/sched_process_fork/hist
  + r=events/sched/sched_process_fork/hist
  + t=events/sched/sched_process_fork/hist
  + [ events/sched/sched_process_fork/hist != events/sched/sched_process_fork/hist ]
  + [ events/sched/sched_process_fork/hist != events/sched/sched_process_fork/hist ]
  + [ events/sched/sched_process_fork/hist != events/sched/sched_process_fork/hist ]
  + [ ! -e events/sched/sched_process_fork/hist ]
  + p=onchange(var):README
  + r=onchange(var)
  + t=onchange(var):README
  + [ onchange(var):README != onchange(var):README ]
  + [ onchange(var):README != onchange(var):README ]
  + [ onchange(var) != onchange(var):README ]
  + grep -Fq onchange(var) README
  + p=snapshot():README
  + r=snapshot()
  + t=snapshot():README
  + [ snapshot():README != snapshot():README ]
  + [ snapshot():README != snapshot():README ]
  + [ snapshot() != snapshot():README ]
  + grep -Fq snapshot() README
  + p=ping
  + r=ping:program
  + t=ping:program
  + [ ping != ping:program ]
  + which ping
  /usr/bin/ping
  + initialize_ftrace
  + disable_tracing
  + echo 0
  + reset_tracer
  + echo nop
  + reset_trigger
  + [ -d events/synthetic ]
  + reset_trigger_file events/alarmtimer/alarmtimer_cancel/trigger events/alarmtimer/alarmtimer_fired/trigger events/alarmtimer/alarmtimer_start/trigger ...
  + read line
  + grep -H :on[^:]*( events/alarmtimer/alarmtimer_cancel/trigger events/alarmtimer/alarmtimer_fired/trigger ...
  + read line
  + grep -Hv ^# events/alarmtimer/alarmtimer_cancel/trigger events/alarmtimer/alarmtimer_fired/trigger ...
  + reset_events_filter
  + read line
  + grep -v ^none events/alarmtimer/alarmtimer_cancel/filter events/alarmtimer/alarmtimer_fired/filter events/alarmtimer/alarmtimer_start/filter ...
  + reset_ftrace_filter
  + [ ! -f set_ftrace_filter ]
  + echo
  + grep -v ^# set_ftrace_filter
  + read t
  + disable_events
  + echo 0
  + clear_dynamic_events
  + again=1
  + stop=1
  + [ 1 -eq 1 ]
  + stop=2
  + [ 2 -gt 10 ]
  + again=2
  + grep -v ^# dynamic_events
  + read line
  + [ 2 -eq 1 ]
  + [ -f set_event_pid ]
  + echo
  + [ -f set_ftrace_pid ]
  + echo
  + [ -f set_ftrace_notrace ]
  + echo
  + [ -f set_graph_function ]
  + echo
  + tee set_graph_function set_graph_notrace

  + [ -f stack_trace_filter ]
  + echo
  + [ -f kprobe_events ]
  + echo
  + [ -f uprobe_events ]
  + echo
  + [ -f synthetic_events ]
  + echo
  + [ -f snapshot ]
  + echo 0
  + [ -f options/pause-on-trace ]
  + echo 1
  + clear_trace
  + echo
  + enable_tracing
  + echo 1
  + . /home/ubuntu/autotest/client/tmp/ubuntu_kselftests_ftrace/src/linux/tools/testing/selftests/ftrace/test.d/trigger/inter-event/trigger-snapshot-action-hist.tc
  + echo Test snapshot action
  Test snapshot action
  + echo 1
  + echo hist:keys=comm:newprio=prio:onchange($newprio).save(comm,prio):onchange($newprio).snapshot() if comm=="ping"
  + ping 127.0.0.1 -c 3
  PING 127.0.0.1 (127.0.0.1) 56(84) bytes of data.
  64 bytes from 127.0.0.1: icmp_seq=1 ttl=64 time=0.068 ms
  64 bytes from 127.0.0.1: icmp_seq=2 ttl=64 time=0.044 ms
  64 bytes from 127.0.0.1: icmp_seq=3 ttl=64 time=0.045 ms

  --- 127.0.0.1 ping statistics ---
  3 packets transmitted, 3 received, 0% packet loss, time 2048ms
  rtt min/avg/max/mdev = 0.044/0.052/0.068/0.011 ms
  + nice -n 1 ping 127.0.0.1 -c 3
  PING 127.0.0.1 (127.0.0.1) 56(84) bytes of data.
  64 bytes from 127.0.0.1: icmp_seq=1 ttl=64 time=0.036 ms
  64 bytes from 127.0.0.1: icmp_seq=2 ttl=64 time=0.045 ms
  64 bytes from 127.0.0.1: icmp_seq=3 ttl=64 time=0.045 ms

  --- 127.0.0.1 ping statistics ---
  3 packets transmitted, 3 received, 0% packet loss, time 2043ms
  rtt min/avg/max/mdev = 0.036/0.042/0.045/0.004 ms
  + echo 0
  + grep -q changed: events/sched/sched_waking/hist
  + grep -q comm=ping snapshot
  + fail Failed to create snapshot action inter-event histogram
  + echo Failed to create snapshot action inter-event histogram
  Failed to create snapshot action inter-event histogram
  + exit_fail
  + exit 1

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu-kernel-tests/+bug/2095589/+subscriptions
  Thread Previous • Date Previous • • Thread Next