1. 05/06 07:01:38 DEBUG| utils:0116| Running 'sudo sh -c 'echo 1 > /proc/sys/net/ipv4/conf/all/accept_local'' 2. 05/06 07:01:38 DEBUG| utils:0116| Running 'sudo make -C linux/tools/testing/selftests TARGETS=ftrace run_tests' 3. 05/06 07:01:38 DEBUG| utils:0153| [stdout] make: Entering directory '/home/ubuntu/autotest/client/tmp/ubuntu_kernel_selftests/src/linux/tools/testing/selftests' 4. 05/06 07:01:38 DEBUG| utils:0153| [stdout] make --no-builtin-rules ARCH=arm64 -C ../../.. headers_install 5. 05/06 07:01:38 DEBUG| utils:0153| [stdout] make[1]: Entering directory '/home/ubuntu/autotest/client/tmp/ubuntu_kernel_selftests/src/linux' 6. 05/06 07:01:39 DEBUG| utils:0153| [stdout] INSTALL ./usr/include 7. 05/06 07:01:39 DEBUG| utils:0153| [stdout] make[1]: Leaving directory '/home/ubuntu/autotest/client/tmp/ubuntu_kernel_selftests/src/linux' 8. 05/06 07:01:39 DEBUG| utils:0153| [stdout] make[1]: Entering directory '/home/ubuntu/autotest/client/tmp/ubuntu_kernel_selftests/src/linux/tools/testing/selftests/ftrace' 9. 05/06 07:01:39 DEBUG| utils:0153| [stdout] make[1]: Nothing to be done for 'all'. 10. 05/06 07:01:39 DEBUG| utils:0153| [stdout] make[1]: Leaving directory '/home/ubuntu/autotest/client/tmp/ubuntu_kernel_selftests/src/linux/tools/testing/selftests/ftrace' 11. 05/06 07:01:39 DEBUG| utils:0153| [stdout] make[1]: Entering directory '/home/ubuntu/autotest/client/tmp/ubuntu_kernel_selftests/src/linux/tools/testing/selftests/ftrace' 12. 05/06 07:01:39 DEBUG| utils:0153| [stdout] TAP version 13 13. 05/06 07:01:39 DEBUG| utils:0153| [stdout] 1..1 14. 05/06 07:01:39 DEBUG| utils:0153| [stdout] # selftests: ftrace: ftracetest 15. 05/06 07:01:39 DEBUG| utils:0153| [stdout] # === Ftrace unit tests === 16. 05/06 07:01:39 DEBUG| utils:0153| [stdout] # [1] Basic trace file check [PASS] 17. 05/06 07:01:41 DEBUG| utils:0153| [stdout] # [2] Basic test for tracers [PASS] 18. 05/06 07:01:41 DEBUG| utils:0153| [stdout] # [3] Basic trace clock test [PASS] 19. 05/06 07:01:41 DEBUG| utils:0153| [stdout] # [4] Basic event tracing check [PASS] 20. 05/06 07:01:42 DEBUG| utils:0153| [stdout] # [5] Change the ringbuffer size [PASS] 21. 05/06 07:01:42 DEBUG| utils:0153| [stdout] # [6] Snapshot and tracing setting [PASS] 22. 05/06 07:01:42 DEBUG| utils:0153| [stdout] # [7] trace_pipe and trace_marker [PASS] 23. 05/06 07:01:42 DEBUG| utils:0153| [stdout] # [8] Test ftrace direct functions against tracers [UNRESOLVED] 24. 05/06 07:01:43 DEBUG| utils:0153| [stdout] # [9] Test ftrace direct functions against kprobes [UNRESOLVED] 25. 05/06 07:01:43 DEBUG| utils:0153| [stdout] # [10] Generic dynamic event - add/remove kprobe events [PASS] 26. 05/06 07:01:43 DEBUG| utils:0153| [stdout] # [11] Generic dynamic event - add/remove synthetic events [PASS] 27. 05/06 07:01:44 DEBUG| utils:0153| [stdout] # [12] Generic dynamic event - selective clear (compatibility) [PASS] 28. 05/06 07:01:44 DEBUG| utils:0153| [stdout] # [13] Generic dynamic event - generic clear event [PASS] 29. 05/06 07:01:44 DEBUG| utils:0153| [stdout] # [14] event tracing - enable/disable with event level files [PASS] 30. 05/06 07:01:45 DEBUG| utils:0153| [stdout] # [15] event tracing - restricts events based on pid notrace filtering [FAIL] 31. 05/06 07:01:45 DEBUG| utils:0153| [stdout] # [16] event tracing - restricts events based on pid [PASS] 32. 05/06 07:01:45 DEBUG| utils:0153| [stdout] # [17] event tracing - enable/disable with subsystem level files [PASS] 33. 05/06 07:01:46 DEBUG| utils:0153| [stdout] # [18] event tracing - enable/disable with top level files [PASS] 34. 05/06 07:01:47 DEBUG| utils:0153| [stdout] # [19] Test trace_printk from module [PASS] 35. 05/06 07:01:50 DEBUG| utils:0153| [stdout] # [20] ftrace - function graph filters with stack tracer [PASS] 36. 05/06 07:01:51 DEBUG| utils:0153| [stdout] # [21] ftrace - function graph filters [PASS] 37. 05/06 07:01:52 DEBUG| utils:0153| [stdout] # [22] ftrace - function pid notrace filters [PASS] 38. 05/06 07:01:52 DEBUG| utils:0153| [stdout] # [23] ftrace - function pid filters [PASS] 39. 05/06 07:01:53 DEBUG| utils:0153| [stdout] # [24] ftrace - stacktrace filter command [PASS] 40. 05/06 07:01:54 DEBUG| utils:0153| [stdout] # [25] ftrace - function trace with cpumask [UNRESOLVED] 41. 05/06 07:01:57 DEBUG| utils:0153| [stdout] # [26] ftrace - test for function event triggers [PASS] 42. 05/06 07:01:58 DEBUG| utils:0153| [stdout] # [27] ftrace - function trace on module [PASS] 43. 05/06 07:02:00 DEBUG| utils:0153| [stdout] # [28] ftrace - function profiling [PASS] 44. 05/06 07:02:04 DEBUG| utils:0153| [stdout] # [29] ftrace - function profiler with function tracing [PASS] 45. 05/06 07:02:06 DEBUG| utils:0153| [stdout] # [30] ftrace - test reading of set_ftrace_filter [PASS] 46. 05/06 07:02:08 DEBUG| utils:0153| [stdout] # [31] ftrace - test for function traceon/off triggers [PASS] 47. 05/06 07:02:08 DEBUG| utils:0153| [stdout] # [32] ftrace - test tracing error log support [PASS] 48. 05/06 07:02:12 DEBUG| utils:0153| [stdout] # [33] Test creation and deletion of trace instances while setting an event [PASS] 49. 05/06 07:02:13 DEBUG| utils:0153| [stdout] # [34] Test creation and deletion of trace instances [PASS] 50. 05/06 07:02:14 DEBUG| utils:0153| [stdout] # [35] Kprobe dynamic event - adding and removing [PASS] 51. 05/06 07:02:14 DEBUG| utils:0153| [stdout] # [36] Kprobe dynamic event - busy event check [PASS] 52. 05/06 07:02:14 DEBUG| utils:0153| [stdout] # [37] Kprobe dynamic event with arguments [PASS] 53. 05/06 07:02:14 DEBUG| utils:0153| [stdout] # [38] Kprobe event with comm arguments [PASS] 54. 05/06 07:02:15 DEBUG| utils:0153| [stdout] # [39] Kprobe event string type argument [PASS] 55. 05/06 07:02:15 DEBUG| utils:0153| [stdout] # [40] Kprobe event symbol argument [PASS] 56. 05/06 07:02:16 DEBUG| utils:0153| [stdout] # [41] Kprobe event argument syntax [PASS] 57. 05/06 07:02:16 DEBUG| utils:0153| [stdout] # [42] Kprobes event arguments with types [PASS] 58. 05/06 07:02:17 DEBUG| utils:0153| [stdout] # [43] Kprobe event user-memory access [PASS] 59. 05/06 07:02:17 DEBUG| utils:0153| [stdout] # [44] Kprobe event auto/manual naming [PASS] 60. 05/06 07:02:18 DEBUG| utils:0153| [stdout] # [45] Kprobe dynamic event with function tracer [PASS] 61. 05/06 07:02:18 DEBUG| utils:0153| [stdout] # [46] Create/delete multiprobe on kprobe event [PASS] 62. 05/06 07:02:19 DEBUG| utils:0153| [stdout] # [47] Kprobe event parser error log check [PASS] 63. 05/06 07:02:19 DEBUG| utils:0153| [stdout] # [48] Kretprobe dynamic event with arguments [PASS] 64. 05/06 07:02:20 DEBUG| utils:0153| [stdout] # [49] Kretprobe dynamic event with maxactive [PASS] 65. 05/06 07:02:25 DEBUG| utils:0153| [stdout] # [50] Register/unregister many kprobe events [PASS] 66. 05/06 07:02:26 DEBUG| utils:0153| [stdout] # [51] Kprobe dynamic event - adding and removing [PASS] 67. 05/06 07:02:26 DEBUG| utils:0153| [stdout] # [52] Uprobe event parser error log check [PASS] 68. 05/06 07:02:26 DEBUG| utils:0153| [stdout] # [53] test for the preemptirqsoff tracer [UNSUPPORTED] 69. 05/06 07:02:51 DEBUG| utils:0153| [stdout] # [54] Meta-selftest: Checkbashisms [PASS] 70. 05/06 07:02:52 DEBUG| utils:0153| [stdout] # [55] Test wakeup tracer [PASS] 71. 05/06 07:02:53 DEBUG| utils:0153| [stdout] # [56] Test wakeup RT tracer [PASS] 72. 05/06 07:02:54 DEBUG| utils:0153| [stdout] # [57] event trigger - test inter-event histogram trigger expected fail actions [XFAIL] 73. 05/06 07:02:56 DEBUG| utils:0153| [stdout] # [58] event trigger - test field variable support [PASS] 74. 05/06 07:02:56 DEBUG| utils:0153| [stdout] # [59] event trigger - test multiple actions on hist trigger [PASS] 75. 05/06 07:03:01 DEBUG| utils:0153| [stdout] # [60] event trigger - test inter-event histogram trigger onchange action [PASS] 76. 05/06 07:03:05 DEBUG| utils:0153| [stdout] # [61] event trigger - test inter-event histogram trigger onmatch action [PASS] 77. 05/06 07:03:10 DEBUG| utils:0153| [stdout] # [62] event trigger - test inter-event histogram trigger onmatch-onmax action [PASS] 78. 05/06 07:03:12 DEBUG| utils:0153| [stdout] # [63] event trigger - test inter-event histogram trigger onmax action [PASS] 79. 05/06 07:03:17 DEBUG| utils:0153| [stdout] # [64] event trigger - test inter-event histogram trigger snapshot action [PASS] 80. 05/06 07:03:17 DEBUG| utils:0153| [stdout] # [65] event trigger - test synthetic_events syntax parser [PASS] 81. 05/06 07:03:22 DEBUG| utils:0153| [stdout] # [66] event trigger - test inter-event histogram trigger trace action [PASS] 82. 05/06 07:03:22 DEBUG| utils:0153| [stdout] # [67] event trigger - test event enable/disable trigger [PASS] 83. 05/06 07:03:23 DEBUG| utils:0153| [stdout] # [68] event trigger - test trigger filter [PASS] 84. 05/06 07:03:23 DEBUG| utils:0153| [stdout] # [69] event trigger - test histogram modifiers [PASS] 85. 05/06 07:03:23 DEBUG| utils:0153| [stdout] # [70] event trigger - test histogram parser errors [PASS] 86. 05/06 07:03:24 DEBUG| utils:0153| [stdout] # [71] event trigger - test multiple histogram triggers [PASS] 87. 05/06 07:03:24 DEBUG| utils:0153| [stdout] # [72] event trigger - test snapshot-trigger [PASS] 88. 05/06 07:03:25 DEBUG| utils:0153| [stdout] # [73] event trigger - test stacktrace-trigger [PASS] 89. 05/06 07:03:25 DEBUG| utils:0153| [stdout] # [74] trace_marker trigger - test snapshot trigger [PASS] 90. 05/06 07:03:26 DEBUG| utils:0153| [stdout] # [75] trace_marker trigger - test histogram with synthetic event against kernel event [PASS] 91. 05/06 07:03:27 DEBUG| utils:0153| [stdout] # [76] trace_marker trigger - test histogram with synthetic event [PASS] 92. 05/06 07:03:27 DEBUG| utils:0153| [stdout] # [77] event trigger - test traceon/off trigger [PASS] 93. 05/06 07:03:28 DEBUG| utils:0153| [stdout] # [78] (instance) Basic test for tracers [PASS] 94. 05/06 07:03:29 DEBUG| utils:0153| [stdout] # [79] (instance) Basic trace clock test [PASS] 95. 05/06 07:03:29 DEBUG| utils:0153| [stdout] # [80] (instance) Change the ringbuffer size [PASS] 96. 05/06 07:03:29 DEBUG| utils:0153| [stdout] # [81] (instance) Snapshot and tracing setting [PASS] 97. 05/06 07:03:29 DEBUG| utils:0153| [stdout] # [82] (instance) trace_pipe and trace_marker [PASS] 98. 05/06 07:03:30 DEBUG| utils:0153| [stdout] # [83] (instance) event tracing - enable/disable with event level files [PASS] 99. 05/06 07:03:30 DEBUG| utils:0153| [stdout] # [84] (instance) event tracing - restricts events based on pid notrace filtering [PASS] 100. 05/06 07:03:30 DEBUG| utils:0153| [stdout] # [85] (instance) event tracing - restricts events based on pid [PASS] 101. 05/06 07:03:30 DEBUG| utils:0153| [stdout] # [86] (instance) event tracing - enable/disable with subsystem level files [PASS] 102. 05/06 07:03:31 DEBUG| utils:0153| [stdout] # [87] (instance) ftrace - function pid notrace filters [PASS] 103. 05/06 07:03:31 DEBUG| utils:0153| [stdout] # [88] (instance) ftrace - function pid filters [PASS] 104. 05/06 07:03:33 DEBUG| utils:0153| [stdout] # [89] (instance) ftrace - stacktrace filter command [PASS] 105. 05/06 07:03:36 DEBUG| utils:0153| [stdout] # [90] (instance) ftrace - test for function event triggers [PASS] 106. 05/06 07:03:37 DEBUG| utils:0153| [stdout] # [91] (instance) ftrace - test for function traceon/off triggers [PASS] 107. 05/06 07:03:38 DEBUG| utils:0153| [stdout] # [92] (instance) event trigger - test event enable/disable trigger [PASS] 108. 05/06 07:03:38 DEBUG| utils:0153| [stdout] # [93] (instance) event trigger - test trigger filter [PASS] 109. 05/06 07:03:39 DEBUG| utils:0153| [stdout] # [94] (instance) event trigger - test histogram modifiers [PASS] 110. 05/06 07:03:39 DEBUG| utils:0153| [stdout] # [95] (instance) event trigger - test multiple histogram triggers [PASS] 111. 05/06 07:03:39 DEBUG| utils:0153| [stdout] # [96] (instance) trace_marker trigger - test snapshot trigger [PASS] 112. 05/06 07:03:39 DEBUG| utils:0153| [stdout] # 113. 05/06 07:03:40 DEBUG| utils:0153| [stdout] # 114. 05/06 07:03:40 DEBUG| utils:0153| [stdout] # # of passed: 90 115. 05/06 07:03:40 DEBUG| utils:0153| [stdout] # # of failed: 1 116. 05/06 07:03:40 DEBUG| utils:0153| [stdout] # # of unresolved: 3 117. 05/06 07:03:40 DEBUG| utils:0153| [stdout] # # of untested: 0 118. 05/06 07:03:40 DEBUG| utils:0153| [stdout] # # of unsupported: 1 119. 05/06 07:03:40 DEBUG| utils:0153| [stdout] # # of xfailed: 1 120. 05/06 07:03:40 DEBUG| utils:0153| [stdout] # # of undefined(test bug): 0 121. 05/06 07:03:40 DEBUG| utils:0153| [stdout] not ok 1 selftests: ftrace: ftracetest # exit=1 122. 05/06 07:03:40 DEBUG| utils:0153| [stdout] make[1]: Leaving directory '/home/ubuntu/autotest/client/tmp/ubuntu_kernel_selftests/src/linux/tools/testing/selftests/ftrace' 123. 05/06 07:03:40 DEBUG| utils:0153| [stdout] make: Leaving directory '/home/ubuntu/autotest/client/tmp/ubuntu_kernel_selftests/src/linux/tools/testing/selftests' 124. 05/06 07:03:40 INFO |ubuntu_ker:0243| ========== Summary =========== 125. 05/06 07:03:40 INFO |ubuntu_ker:0081| Sub test case: ftracetest failed. 126. 05/06 07:03:40 ERROR| test:0414| Exception escaping from test: 127. Traceback (most recent call last): 128. File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec 129. _call_test_function(self.execute, *p_args, **p_dargs) 130. File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function 131. return func(*args, **dargs) 132. File "/home/ubuntu/autotest/client/shared/test.py", line 291, in execute 133. postprocess_profiled_run, args, dargs) 134. File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once 135. self.run_once(*args, **dargs) 136. File "/home/ubuntu/autotest/client/tests/ubuntu_kernel_selftests/ubuntu_kernel_selftests.py", line 252, in run_once 137. raise error.TestError('Test failed for ' + test_name) 138. TestError: Test failed for ftrace 139.