All of lore.kernel.org
 help / color / mirror / Atom feed
* [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
@ 2018-05-18  7:24 Sandipan Das
  2018-05-18 10:21 ` Thomas-Mich Richter
                   ` (2 more replies)
  0 siblings, 3 replies; 14+ messages in thread
From: Sandipan Das @ 2018-05-18  7:24 UTC (permalink / raw)
  To: acme, jolsa; +Cc: linux-kernel, ravi.bangoria, naveen.n.rao, tmricht

This test currently fails because the regular expressions for
matching the output of perf script do not consider the symbol
offsets to be part of the output.

The symbol offsets are seen because of the default behaviour
introduced by commit 4140d2ea74b3 ("perf script: Show symbol
offsets by default").

Before applying this patch:

  # perf test -v "probe libc's inet_pton & backtrace it with ping"

  62: probe libc's inet_pton & backtrace it with ping       :
  --- start ---
  test child forked, pid 30389
  ping 30406 [002] 307144.280983: probe_libc:inet_pton: (7f4117adf220)
  7f4117adf220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
  FAIL: expected backtrace entry 1 ".*inet_pton[[:space:]]\(/usr/lib64/libc-2.25.so|inlined\)$" got "7f4117adf220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)"
  test child finished with -1
  ---- end ----
  probe libc's inet_pton & backtrace it with ping: FAILED!

After applying this patch:

  # perf test -v "probe libc's inet_pton & backtrace it with ping"

  62: probe libc's inet_pton & backtrace it with ping       :
  --- start ---
  test child forked, pid 30539
  ping 30556 [003] 307254.313217: probe_libc:inet_pton: (7fe19ab10220)
  7fe19ab10220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
  7fe19aad5ebd getaddrinfo+0x11d (/usr/lib64/libc-2.25.so)
  56351e3c1c71 main+0x891 (/usr/bin/ping)
  test child finished with 0
  ---- end ----
  probe libc's inet_pton & backtrace it with ping: Ok

Signed-off-by: Sandipan Das <sandipan@linux.vnet.ibm.com>
---
 tools/perf/tests/shell/record+probe_libc_inet_pton.sh | 12 ++++++------
 1 file changed, 6 insertions(+), 6 deletions(-)

diff --git a/tools/perf/tests/shell/record+probe_libc_inet_pton.sh b/tools/perf/tests/shell/record+probe_libc_inet_pton.sh
index ee86473643be..650b208f700f 100755
--- a/tools/perf/tests/shell/record+probe_libc_inet_pton.sh
+++ b/tools/perf/tests/shell/record+probe_libc_inet_pton.sh
@@ -16,18 +16,18 @@ nm -g $libc 2>/dev/null | fgrep -q inet_pton || exit 254
 trace_libc_inet_pton_backtrace() {
 	idx=0
 	expected[0]="ping[][0-9 \.:]+probe_libc:inet_pton: \([[:xdigit:]]+\)"
-	expected[1]=".*inet_pton[[:space:]]\($libc|inlined\)$"
+	expected[1]=".*inet_pton\+0x[[:xdigit:]]+[[:space:]]\($libc|inlined\)$"
 	case "$(uname -m)" in
 	s390x)
 		eventattr='call-graph=dwarf,max-stack=4'
-		expected[2]="gaih_inet.*[[:space:]]\($libc|inlined\)$"
-		expected[3]="(__GI_)?getaddrinfo[[:space:]]\($libc|inlined\)$"
-		expected[4]="main[[:space:]]\(.*/bin/ping.*\)$"
+		expected[2]="gaih_inet.*\+0x[[:xdigit:]]+[[:space:]]\($libc|inlined\)$"
+		expected[3]="(__GI_)?getaddrinfo\+0x[[:xdigit:]]+[[:space:]]\($libc|inlined\)$"
+		expected[4]="main\+0x[[:xdigit:]]+[[:space:]]\(.*/bin/ping.*\)$"
 		;;
 	*)
 		eventattr='max-stack=3'
-		expected[2]="getaddrinfo[[:space:]]\($libc\)$"
-		expected[3]=".*\(.*/bin/ping.*\)$"
+		expected[2]="getaddrinfo\+0x[[:xdigit:]]+[[:space:]]\($libc\)$"
+		expected[3]=".*\+0x[[:xdigit:]]+[[:space:]]\(.*/bin/ping.*\)$"
 		;;
 	esac
 
-- 
2.13.6

^ permalink raw reply related	[flat|nested] 14+ messages in thread

* Re: [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
  2018-05-18  7:24 [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh Sandipan Das
@ 2018-05-18 10:21 ` Thomas-Mich Richter
  2018-05-18 10:29   ` Sandipan Das
  2018-05-18 19:21 ` Arnaldo Carvalho de Melo
  2018-07-04  6:57   ` kernel test robot
  2 siblings, 1 reply; 14+ messages in thread
From: Thomas-Mich Richter @ 2018-05-18 10:21 UTC (permalink / raw)
  To: Sandipan Das, acme, jolsa
  Cc: linux-kernel, ravi.bangoria, naveen.n.rao, Hendrik Brueckner

On 05/18/2018 09:24 AM, Sandipan Das wrote:
> This test currently fails because the regular expressions for
> matching the output of perf script do not consider the symbol
> offsets to be part of the output.
> 
> The symbol offsets are seen because of the default behaviour
> introduced by commit 4140d2ea74b3 ("perf script: Show symbol
> offsets by default").
> 
> Before applying this patch:
> 
>   # perf test -v "probe libc's inet_pton & backtrace it with ping"
> 
>   62: probe libc's inet_pton & backtrace it with ping       :
>   --- start ---
>   test child forked, pid 30389
>   ping 30406 [002] 307144.280983: probe_libc:inet_pton: (7f4117adf220)
>   7f4117adf220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
>   FAIL: expected backtrace entry 1 ".*inet_pton[[:space:]]\(/usr/lib64/libc-2.25.so|inlined\)$" got "7f4117adf220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)"
>   test child finished with -1
>   ---- end ----
>   probe libc's inet_pton & backtrace it with ping: FAILED!
> 
> After applying this patch:
> 
>   # perf test -v "probe libc's inet_pton & backtrace it with ping"
> 
>   62: probe libc's inet_pton & backtrace it with ping       :
>   --- start ---
>   test child forked, pid 30539
>   ping 30556 [003] 307254.313217: probe_libc:inet_pton: (7fe19ab10220)
>   7fe19ab10220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
>   7fe19aad5ebd getaddrinfo+0x11d (/usr/lib64/libc-2.25.so)
>   56351e3c1c71 main+0x891 (/usr/bin/ping)
>   test child finished with 0
>   ---- end ----
>   probe libc's inet_pton & backtrace it with ping: Ok
> 
> Signed-off-by: Sandipan Das <sandipan@linux.vnet.ibm.com>
> ---
>  tools/perf/tests/shell/record+probe_libc_inet_pton.sh | 12 ++++++------
>  1 file changed, 6 insertions(+), 6 deletions(-)
> 
> diff --git a/tools/perf/tests/shell/record+probe_libc_inet_pton.sh b/tools/perf/tests/shell/record+probe_libc_inet_pton.sh
> index ee86473643be..650b208f700f 100755
> --- a/tools/perf/tests/shell/record+probe_libc_inet_pton.sh
> +++ b/tools/perf/tests/shell/record+probe_libc_inet_pton.sh
> @@ -16,18 +16,18 @@ nm -g $libc 2>/dev/null | fgrep -q inet_pton || exit 254
>  trace_libc_inet_pton_backtrace() {
>  	idx=0
>  	expected[0]="ping[][0-9 \.:]+probe_libc:inet_pton: \([[:xdigit:]]+\)"
> -	expected[1]=".*inet_pton[[:space:]]\($libc|inlined\)$"
> +	expected[1]=".*inet_pton\+0x[[:xdigit:]]+[[:space:]]\($libc|inlined\)$"
>  	case "$(uname -m)" in
>  	s390x)
>  		eventattr='call-graph=dwarf,max-stack=4'
> -		expected[2]="gaih_inet.*[[:space:]]\($libc|inlined\)$"
> -		expected[3]="(__GI_)?getaddrinfo[[:space:]]\($libc|inlined\)$"
> -		expected[4]="main[[:space:]]\(.*/bin/ping.*\)$"
> +		expected[2]="gaih_inet.*\+0x[[:xdigit:]]+[[:space:]]\($libc|inlined\)$"
> +		expected[3]="(__GI_)?getaddrinfo\+0x[[:xdigit:]]+[[:space:]]\($libc|inlined\)$"
> +		expected[4]="main\+0x[[:xdigit:]]+[[:space:]]\(.*/bin/ping.*\)$"
>  		;;
>  	*)
>  		eventattr='max-stack=3'
> -		expected[2]="getaddrinfo[[:space:]]\($libc\)$"
> -		expected[3]=".*\(.*/bin/ping.*\)$"
> +		expected[2]="getaddrinfo\+0x[[:xdigit:]]+[[:space:]]\($libc\)$"
> +		expected[3]=".*\+0x[[:xdigit:]]+[[:space:]]\(.*/bin/ping.*\)$"
>  		;;
>  	esac
>  
> 

This patch fails on s390. I used 4.17.0rc5 + fedora 27 and I get this output:


[root@p23lp27 perf]# ./perf test 59
59: probe libc's inet_pton & backtrace it with ping       : Ok
[root@p23lp27 linux]# cd ~/linux; patch -p1 < ../inet_pton1 
(Stripping trailing CRs from patch; use --binary to disable.)
patching file tools/perf/tests/shell/record+probe_libc_inet_pton.sh
[root@p23lp27 linux]# cd -; 
[root@p23lp27 perf]# ./perf test 59
59: probe libc's inet_pton & backtrace it with ping       : FAILED!
[root@p23lp27 perf]#

Debugging revealed this line as cause of failure:


FAIL: expected backtrace entry 2 "gaih_inet.*\+0x[[:xdigit:]]+[[:space:]]\(/usr/lib64/libc-2.26.so|inlined\)$" got "fdcb1 gaih_inet.constprop.7 (/usr/lib64/libc-2.26.so)"

Here is the output of the trace file

[root@p23lp27 perf]# perf script 
ping 87291 [001] 96936.231618: probe_libc:inet_pton: (3ff96342378)
                  142378 __inet_pton (inlined)
                   fdcb1 gaih_inet.constprop.7 (/usr/lib64/libc-2.26.so)
                  100189 __GI_getaddrinfo (inlined)
                    398d main (/usr/bin/ping)
                   2303d __libc_start_main (/usr/lib64/libc-2.26.so)
                    457b [unknown] (/usr/bin/ping)

[root@p23lp27 perf]# 

Hope this helps
-- 
Thomas Richter, Dept 3303, IBM s390 Linux Development, Boeblingen, Germany
--
Vorsitzende des Aufsichtsrats: Martina Koederitz 
Geschäftsführung: Dirk Wittkopp
Sitz der Gesellschaft: Böblingen / Registergericht: Amtsgericht Stuttgart, HRB 243294

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
  2018-05-18 10:21 ` Thomas-Mich Richter
@ 2018-05-18 10:29   ` Sandipan Das
  2018-05-18 11:09     ` Thomas-Mich Richter
  0 siblings, 1 reply; 14+ messages in thread
From: Sandipan Das @ 2018-05-18 10:29 UTC (permalink / raw)
  To: Thomas-Mich Richter, acme, jolsa
  Cc: linux-kernel, ravi.bangoria, naveen.n.rao, Hendrik Brueckner

Hi Thomas,

On 05/18/2018 03:51 PM, Thomas-Mich Richter wrote:
[...]
> 
> This patch fails on s390. I used 4.17.0rc5 + fedora 27 and I get this output:
> 
> 
> [root@p23lp27 perf]# ./perf test 59
> 59: probe libc's inet_pton & backtrace it with ping       : Ok
> [root@p23lp27 linux]# cd ~/linux; patch -p1 < ../inet_pton1 
> (Stripping trailing CRs from patch; use --binary to disable.)
> patching file tools/perf/tests/shell/record+probe_libc_inet_pton.sh
> [root@p23lp27 linux]# cd -; 
> [root@p23lp27 perf]# ./perf test 59
> 59: probe libc's inet_pton & backtrace it with ping       : FAILED!
> [root@p23lp27 perf]#
> 
> Debugging revealed this line as cause of failure:
> 
> 
> FAIL: expected backtrace entry 2 "gaih_inet.*\+0x[[:xdigit:]]+[[:space:]]\(/usr/lib64/libc-2.26.so|inlined\)$" got "fdcb1 gaih_inet.constprop.7 (/usr/lib64/libc-2.26.so)"
> 
> Here is the output of the trace file
> 
> [root@p23lp27 perf]# perf script 
> ping 87291 [001] 96936.231618: probe_libc:inet_pton: (3ff96342378)
>                   142378 __inet_pton (inlined)
>                    fdcb1 gaih_inet.constprop.7 (/usr/lib64/libc-2.26.so)
>                   100189 __GI_getaddrinfo (inlined)
>                     398d main (/usr/bin/ping)
>                    2303d __libc_start_main (/usr/lib64/libc-2.26.so)
>                     457b [unknown] (/usr/bin/ping)
> 
> [root@p23lp27 perf]# 
> 
> Hope this helps
> 

Can you please apply these two patches as well and then re-test?

[1] https://lkml.org/lkml/2018/5/17/112
[2] https://lkml.org/lkml/2018/5/17/113

- Sandipan

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
  2018-05-18 10:29   ` Sandipan Das
@ 2018-05-18 11:09     ` Thomas-Mich Richter
  2018-05-18 14:14       ` Arnaldo Carvalho de Melo
  0 siblings, 1 reply; 14+ messages in thread
From: Thomas-Mich Richter @ 2018-05-18 11:09 UTC (permalink / raw)
  To: Sandipan Das, acme, jolsa
  Cc: linux-kernel, ravi.bangoria, naveen.n.rao, Hendrik Brueckner

On 05/18/2018 12:29 PM, Sandipan Das wrote:
> Hi Thomas,
> 
> On 05/18/2018 03:51 PM, Thomas-Mich Richter wrote:
> [...]
>>
>> This patch fails on s390. I used 4.17.0rc5 + fedora 27 and I get this output:
>>
>>
>> [root@p23lp27 perf]# ./perf test 59
>> 59: probe libc's inet_pton & backtrace it with ping       : Ok
>> [root@p23lp27 linux]# cd ~/linux; patch -p1 < ../inet_pton1 
>> (Stripping trailing CRs from patch; use --binary to disable.)
>> patching file tools/perf/tests/shell/record+probe_libc_inet_pton.sh
>> [root@p23lp27 linux]# cd -; 
>> [root@p23lp27 perf]# ./perf test 59
>> 59: probe libc's inet_pton & backtrace it with ping       : FAILED!
>> [root@p23lp27 perf]#
>>
>> Debugging revealed this line as cause of failure:
>>
>>
>> FAIL: expected backtrace entry 2 "gaih_inet.*\+0x[[:xdigit:]]+[[:space:]]\(/usr/lib64/libc-2.26.so|inlined\)$" got "fdcb1 gaih_inet.constprop.7 (/usr/lib64/libc-2.26.so)"
>>
>> Here is the output of the trace file
>>
>> [root@p23lp27 perf]# perf script 
>> ping 87291 [001] 96936.231618: probe_libc:inet_pton: (3ff96342378)
>>                   142378 __inet_pton (inlined)
>>                    fdcb1 gaih_inet.constprop.7 (/usr/lib64/libc-2.26.so)
>>                   100189 __GI_getaddrinfo (inlined)
>>                     398d main (/usr/bin/ping)
>>                    2303d __libc_start_main (/usr/lib64/libc-2.26.so)
>>                     457b [unknown] (/usr/bin/ping)
>>
>> [root@p23lp27 perf]# 
>>
>> Hope this helps
>>
> 
> Can you please apply these two patches as well and then re-test?
> 
> [1] https://lkml.org/lkml/2018/5/17/112
> [2] https://lkml.org/lkml/2018/5/17/113
> 
> - Sandipan
> 

Ahhh, yes that helped. Must have missed it. Thanks for the pointer.

-- 
Thomas Richter, Dept 3303, IBM s390 Linux Development, Boeblingen, Germany
--
Vorsitzende des Aufsichtsrats: Martina Koederitz 
Geschäftsführung: Dirk Wittkopp
Sitz der Gesellschaft: Böblingen / Registergericht: Amtsgericht Stuttgart, HRB 243294

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
  2018-05-18 11:09     ` Thomas-Mich Richter
@ 2018-05-18 14:14       ` Arnaldo Carvalho de Melo
  2018-05-18 18:24         ` Arnaldo Carvalho de Melo
  2018-05-22  6:09         ` Thomas-Mich Richter
  0 siblings, 2 replies; 14+ messages in thread
From: Arnaldo Carvalho de Melo @ 2018-05-18 14:14 UTC (permalink / raw)
  To: Thomas-Mich Richter
  Cc: Sandipan Das, jolsa, linux-kernel, ravi.bangoria, naveen.n.rao,
	Hendrik Brueckner

Em Fri, May 18, 2018 at 01:09:48PM +0200, Thomas-Mich Richter escreveu:
> On 05/18/2018 12:29 PM, Sandipan Das wrote:
> > Can you please apply these two patches as well and then re-test?

> > [1] https://lkml.org/lkml/2018/5/17/112
> > [2] https://lkml.org/lkml/2018/5/17/113

> Ahhh, yes that helped. Must have missed it. Thanks for the pointer.

Cool, can I take that as a Tested-by: Thomas?

- Arnaldo

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
  2018-05-18 14:14       ` Arnaldo Carvalho de Melo
@ 2018-05-18 18:24         ` Arnaldo Carvalho de Melo
  2018-05-22  6:09         ` Thomas-Mich Richter
  1 sibling, 0 replies; 14+ messages in thread
From: Arnaldo Carvalho de Melo @ 2018-05-18 18:24 UTC (permalink / raw)
  To: Thomas-Mich Richter
  Cc: Sandipan Das, jolsa, linux-kernel, ravi.bangoria, naveen.n.rao,
	Hendrik Brueckner

Em Fri, May 18, 2018 at 11:14:45AM -0300, Arnaldo Carvalho de Melo escreveu:
> Em Fri, May 18, 2018 at 01:09:48PM +0200, Thomas-Mich Richter escreveu:
> > On 05/18/2018 12:29 PM, Sandipan Das wrote:
> > > Can you please apply these two patches as well and then re-test?
> 
> > > [1] https://lkml.org/lkml/2018/5/17/112
> > > [2] https://lkml.org/lkml/2018/5/17/113
> 
> > Ahhh, yes that helped. Must have missed it. Thanks for the pointer.
> 
> Cool, can I take that as a Tested-by: Thomas?

Actually I'll fold this patch into the patch that made this test break,
so that we keep the tree bisectable wrt that specific 'perf test' entry.

- Arnaldo

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
  2018-05-18  7:24 [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh Sandipan Das
  2018-05-18 10:21 ` Thomas-Mich Richter
@ 2018-05-18 19:21 ` Arnaldo Carvalho de Melo
  2018-05-18 19:28   ` Sandipan Das
  2018-05-18 19:29   ` Arnaldo Carvalho de Melo
  2018-07-04  6:57   ` kernel test robot
  2 siblings, 2 replies; 14+ messages in thread
From: Arnaldo Carvalho de Melo @ 2018-05-18 19:21 UTC (permalink / raw)
  To: Sandipan Das; +Cc: jolsa, linux-kernel, ravi.bangoria, naveen.n.rao, tmricht

Em Fri, May 18, 2018 at 12:54:17PM +0530, Sandipan Das escreveu:
> This test currently fails because the regular expressions for
> matching the output of perf script do not consider the symbol
> offsets to be part of the output.
> 
> The symbol offsets are seen because of the default behaviour
> introduced by commit 4140d2ea74b3 ("perf script: Show symbol
> offsets by default").
> 
> Before applying this patch:
> 
>   # perf test -v "probe libc's inet_pton & backtrace it with ping"
> 
>   62: probe libc's inet_pton & backtrace it with ping       :
>   --- start ---
>   test child forked, pid 30389
>   ping 30406 [002] 307144.280983: probe_libc:inet_pton: (7f4117adf220)
>   7f4117adf220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
>   FAIL: expected backtrace entry 1 ".*inet_pton[[:space:]]\(/usr/lib64/libc-2.25.so|inlined\)$" got "7f4117adf220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)"
>   test child finished with -1
>   ---- end ----
>   probe libc's inet_pton & backtrace it with ping: FAILED!
> 
> After applying this patch:
> 
>   # perf test -v "probe libc's inet_pton & backtrace it with ping"
> 
>   62: probe libc's inet_pton & backtrace it with ping       :
>   --- start ---
>   test child forked, pid 30539
>   ping 30556 [003] 307254.313217: probe_libc:inet_pton: (7fe19ab10220)
>   7fe19ab10220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
>   7fe19aad5ebd getaddrinfo+0x11d (/usr/lib64/libc-2.25.so)
>   56351e3c1c71 main+0x891 (/usr/bin/ping)
>   test child finished with 0
>   ---- end ----
>   probe libc's inet_pton & backtrace it with ping: Ok

Here it went from failing with:

[root@seventh ~]# perf test -v pton
64: probe libc's inet_pton & backtrace it with ping       :
--- start ---
test child forked, pid 22590
ping 22607 [001] 12782.425689: probe_libc:inet_pton: (7f8686da4e40)
7f8686da4e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
FAIL: expected backtrace entry 1 ".*inet_pton[[:space:]]\(/usr/lib64/libc-2.26.so|inlined\)$" got "7f8686da4e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)"
test child finished with -1
---- end ----
probe libc's inet_pton & backtrace it with ping: FAILED!
[root@seventh ~]# 

To failing with:

[root@seventh ~]# perf test -v pton
64: probe libc's inet_pton & backtrace it with ping       :
--- start ---
test child forked, pid 28954
ping 28971 [002] 14277.711200: probe_libc:inet_pton: (7fc9d66e3e40)
7fc9d66e3e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
7fc9d66b02b4 getaddrinfo+0x124 (/usr/lib64/libc-2.26.so)
56075cb98f40 [unknown] (/usr/bin/ping)
FAIL: expected backtrace entry 3 ".*\+0x[[:xdigit:]]+[[:space:]]\(.*/bin/ping.*\)$" got "56075cb98f40 [unknown] (/usr/bin/ping)"
test child finished with -1
---- end ----
probe libc's inet_pton & backtrace it with ping: FAILED!
[root@seventh ~]# 

Trying to figure this out...

- Arnaldo

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
  2018-05-18 19:21 ` Arnaldo Carvalho de Melo
@ 2018-05-18 19:28   ` Sandipan Das
  2018-05-18 19:29   ` Arnaldo Carvalho de Melo
  1 sibling, 0 replies; 14+ messages in thread
From: Sandipan Das @ 2018-05-18 19:28 UTC (permalink / raw)
  To: Arnaldo Carvalho de Melo
  Cc: jolsa, linux-kernel, ravi.bangoria, naveen.n.rao, tmricht

Hi Arnaldo,

On 05/19/2018 12:51 AM, Arnaldo Carvalho de Melo wrote:
> Em Fri, May 18, 2018 at 12:54:17PM +0530, Sandipan Das escreveu:
>> This test currently fails because the regular expressions for
>> matching the output of perf script do not consider the symbol
>> offsets to be part of the output.
>>
>> The symbol offsets are seen because of the default behaviour
>> introduced by commit 4140d2ea74b3 ("perf script: Show symbol
>> offsets by default").
>>
>> Before applying this patch:
>>
>>   # perf test -v "probe libc's inet_pton & backtrace it with ping"
>>
>>   62: probe libc's inet_pton & backtrace it with ping       :
>>   --- start ---
>>   test child forked, pid 30389
>>   ping 30406 [002] 307144.280983: probe_libc:inet_pton: (7f4117adf220)
>>   7f4117adf220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
>>   FAIL: expected backtrace entry 1 ".*inet_pton[[:space:]]\(/usr/lib64/libc-2.25.so|inlined\)$" got "7f4117adf220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)"
>>   test child finished with -1
>>   ---- end ----
>>   probe libc's inet_pton & backtrace it with ping: FAILED!
>>
>> After applying this patch:
>>
>>   # perf test -v "probe libc's inet_pton & backtrace it with ping"
>>
>>   62: probe libc's inet_pton & backtrace it with ping       :
>>   --- start ---
>>   test child forked, pid 30539
>>   ping 30556 [003] 307254.313217: probe_libc:inet_pton: (7fe19ab10220)
>>   7fe19ab10220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
>>   7fe19aad5ebd getaddrinfo+0x11d (/usr/lib64/libc-2.25.so)
>>   56351e3c1c71 main+0x891 (/usr/bin/ping)
>>   test child finished with 0
>>   ---- end ----
>>   probe libc's inet_pton & backtrace it with ping: Ok
> 
> Here it went from failing with:
> 
> [root@seventh ~]# perf test -v pton
> 64: probe libc's inet_pton & backtrace it with ping       :
> --- start ---
> test child forked, pid 22590
> ping 22607 [001] 12782.425689: probe_libc:inet_pton: (7f8686da4e40)
> 7f8686da4e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
> FAIL: expected backtrace entry 1 ".*inet_pton[[:space:]]\(/usr/lib64/libc-2.26.so|inlined\)$" got "7f8686da4e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)"
> test child finished with -1
> ---- end ----
> probe libc's inet_pton & backtrace it with ping: FAILED!
> [root@seventh ~]# 
> 
> To failing with:
> 
> [root@seventh ~]# perf test -v pton
> 64: probe libc's inet_pton & backtrace it with ping       :
> --- start ---
> test child forked, pid 28954
> ping 28971 [002] 14277.711200: probe_libc:inet_pton: (7fc9d66e3e40)
> 7fc9d66e3e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
> 7fc9d66b02b4 getaddrinfo+0x124 (/usr/lib64/libc-2.26.so)
> 56075cb98f40 [unknown] (/usr/bin/ping)
> FAIL: expected backtrace entry 3 ".*\+0x[[:xdigit:]]+[[:space:]]\(.*/bin/ping.*\)$" got "56075cb98f40 [unknown] (/usr/bin/ping)"
> test child finished with -1
> ---- end ----
> probe libc's inet_pton & backtrace it with ping: FAILED!
> [root@seventh ~]# 
> 
> Trying to figure this out...
> 

Looks like perf failed to resolve the symbol's name for the last entry
in the callchain. I did not consider this case. So, if this happens, we
would be better off using the original regex for the last line:

expected[3]=".*\(.*/bin/ping.*\)$"

- Sandipan

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
  2018-05-18 19:21 ` Arnaldo Carvalho de Melo
  2018-05-18 19:28   ` Sandipan Das
@ 2018-05-18 19:29   ` Arnaldo Carvalho de Melo
  2018-05-18 19:30     ` Arnaldo Carvalho de Melo
  1 sibling, 1 reply; 14+ messages in thread
From: Arnaldo Carvalho de Melo @ 2018-05-18 19:29 UTC (permalink / raw)
  To: Sandipan Das; +Cc: jolsa, linux-kernel, ravi.bangoria, naveen.n.rao, tmricht

Em Fri, May 18, 2018 at 04:21:02PM -0300, Arnaldo Carvalho de Melo escreveu:
> Em Fri, May 18, 2018 at 12:54:17PM +0530, Sandipan Das escreveu:
> > This test currently fails because the regular expressions for
> > matching the output of perf script do not consider the symbol
> > offsets to be part of the output.
> > 
> > The symbol offsets are seen because of the default behaviour
> > introduced by commit 4140d2ea74b3 ("perf script: Show symbol
> > offsets by default").
> > 
> > Before applying this patch:
> > 
> >   # perf test -v "probe libc's inet_pton & backtrace it with ping"
> > 
> >   62: probe libc's inet_pton & backtrace it with ping       :
> >   --- start ---
> >   test child forked, pid 30389
> >   ping 30406 [002] 307144.280983: probe_libc:inet_pton: (7f4117adf220)
> >   7f4117adf220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
> >   FAIL: expected backtrace entry 1 ".*inet_pton[[:space:]]\(/usr/lib64/libc-2.25.so|inlined\)$" got "7f4117adf220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)"
> >   test child finished with -1
> >   ---- end ----
> >   probe libc's inet_pton & backtrace it with ping: FAILED!
> > 
> > After applying this patch:
> > 
> >   # perf test -v "probe libc's inet_pton & backtrace it with ping"
> > 
> >   62: probe libc's inet_pton & backtrace it with ping       :
> >   --- start ---
> >   test child forked, pid 30539
> >   ping 30556 [003] 307254.313217: probe_libc:inet_pton: (7fe19ab10220)
> >   7fe19ab10220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
> >   7fe19aad5ebd getaddrinfo+0x11d (/usr/lib64/libc-2.25.so)
> >   56351e3c1c71 main+0x891 (/usr/bin/ping)
> >   test child finished with 0
> >   ---- end ----
> >   probe libc's inet_pton & backtrace it with ping: Ok
> 
> Here it went from failing with:
> 
> [root@seventh ~]# perf test -v pton
> 64: probe libc's inet_pton & backtrace it with ping       :
> --- start ---
> test child forked, pid 22590
> ping 22607 [001] 12782.425689: probe_libc:inet_pton: (7f8686da4e40)
> 7f8686da4e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
> FAIL: expected backtrace entry 1 ".*inet_pton[[:space:]]\(/usr/lib64/libc-2.26.so|inlined\)$" got "7f8686da4e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)"
> test child finished with -1
> ---- end ----
> probe libc's inet_pton & backtrace it with ping: FAILED!
> [root@seventh ~]# 
> 
> To failing with:
> 
> [root@seventh ~]# perf test -v pton
> 64: probe libc's inet_pton & backtrace it with ping       :
> --- start ---
> test child forked, pid 28954
> ping 28971 [002] 14277.711200: probe_libc:inet_pton: (7fc9d66e3e40)
> 7fc9d66e3e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
> 7fc9d66b02b4 getaddrinfo+0x124 (/usr/lib64/libc-2.26.so)
> 56075cb98f40 [unknown] (/usr/bin/ping)
> FAIL: expected backtrace entry 3 ".*\+0x[[:xdigit:]]+[[:space:]]\(.*/bin/ping.*\)$" got "56075cb98f40 [unknown] (/usr/bin/ping)"
> test child finished with -1
> ---- end ----
> probe libc's inet_pton & backtrace it with ping: FAILED!
> [root@seventh ~]# 
> 
> Trying to figure this out...

[root@seventh perf]# perf script
ping 29170 [001] 14644.810782: probe_libc:inet_pton: (7f0bac71be40)
            7f0bac71be40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
            7f0bac6e82b4 getaddrinfo+0x124 (/usr/lib64/libc-2.26.so)
            5585e10adf40 [unknown] (/usr/bin/ping)

[root@seventh perf]# perf report --mmaps
#      pid      tid     ppid  comm
         0        0       -1 |swapper
     29170    29170       -1 |ping
                                5585e10ab000-5585e12dd000 r-xp 00000000 2771393 /usr/bin/ping
                                7f0babfcf000-7f0bac1ed000 r-xp 00000000 2762913 /usr/lib64/libpthread-2.26.so
                                7f0bac1ed000-7f0bac3f1000 r-xp 00000000 2753363 /usr/lib64/libdl-2.26.so
                                7f0bac3f1000-7f0bac608000 r-xp 00000000 2760078 /usr/lib64/libz.so.1.2.11
                                7f0bac608000-7f0bac9be000 r-xp 00000000 2753359 /usr/lib64/libc-2.26.so
                                7f0bac9be000-7f0bacd09000 r-xp 00000000 2762901 /usr/lib64/libm-2.26.so
                                7f0bacd09000-7f0bacf20000 r-xp 00000000 2762915 /usr/lib64/libresolv-2.26.so
                                7f0bacf20000-7f0bad3a8000 r-xp 00000000 2764213 /usr/lib64/libcrypto.so.1.1.0h
                                7f0bad3a8000-7f0bad5dc000 r-xp 00000000 2761070 /usr/lib64/libidn.so.11.6.18
                                7f0bad5dc000-7f0bad7e1000 r-xp 00000000 2760189 /usr/lib64/libcap.so.2.25
                                7f0bad7e1000-7f0bada08000 r-xp 00000000 2753353 /usr/lib64/ld-2.26.so
                                7ffe23d99000-7ffe23d9b000 r-xp 00000000 0 [vdso]
[root@seventh perf]# 

So it is there, but I don't have debuginfo for ping, lets see if I add
it...

[root@seventh perf]# rpm -qf `which ping`
iputils-20161105-7.fc27.x86_64
[root@seventh perf]# 
[root@seventh perf]# dnf debuginfo-install iputils

[root@seventh perf]# perf script
ping 29170 [001] 14644.810782: probe_libc:inet_pton: (7f0bac71be40)
            7f0bac71be40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
            7f0bac6e82b4 getaddrinfo+0x124 (/usr/lib64/libc-2.26.so)
            5585e10adf40 main+0x880 (/usr/bin/ping)

[root@seventh perf]# 

So we need to check if debuginfo is available, and if so, expect it to
resolve that entry to main, if not, expect it to _not_ resolve and have
[unknown]  instead...

- Arnaldo

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
  2018-05-18 19:29   ` Arnaldo Carvalho de Melo
@ 2018-05-18 19:30     ` Arnaldo Carvalho de Melo
  0 siblings, 0 replies; 14+ messages in thread
From: Arnaldo Carvalho de Melo @ 2018-05-18 19:30 UTC (permalink / raw)
  To: Sandipan Das; +Cc: jolsa, linux-kernel, ravi.bangoria, naveen.n.rao, tmricht

Em Fri, May 18, 2018 at 04:29:16PM -0300, Arnaldo Carvalho de Melo escreveu:
> Em Fri, May 18, 2018 at 04:21:02PM -0300, Arnaldo Carvalho de Melo escreveu:
> > Here it went from failing with:
> > 
> > [root@seventh ~]# perf test -v pton
> > 64: probe libc's inet_pton & backtrace it with ping       :
> > --- start ---
> > test child forked, pid 22590
> > ping 22607 [001] 12782.425689: probe_libc:inet_pton: (7f8686da4e40)
> > 7f8686da4e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
> > FAIL: expected backtrace entry 1 ".*inet_pton[[:space:]]\(/usr/lib64/libc-2.26.so|inlined\)$" got "7f8686da4e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)"
> > test child finished with -1
> > ---- end ----
> > probe libc's inet_pton & backtrace it with ping: FAILED!
> > [root@seventh ~]# 
> > 
> > To failing with:
> > 
> > [root@seventh ~]# perf test -v pton
> > 64: probe libc's inet_pton & backtrace it with ping       :
> > --- start ---
> > test child forked, pid 28954
> > ping 28971 [002] 14277.711200: probe_libc:inet_pton: (7fc9d66e3e40)
> > 7fc9d66e3e40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
> > 7fc9d66b02b4 getaddrinfo+0x124 (/usr/lib64/libc-2.26.so)
> > 56075cb98f40 [unknown] (/usr/bin/ping)
> > FAIL: expected backtrace entry 3 ".*\+0x[[:xdigit:]]+[[:space:]]\(.*/bin/ping.*\)$" got "56075cb98f40 [unknown] (/usr/bin/ping)"
> > test child finished with -1
> > ---- end ----
> > probe libc's inet_pton & backtrace it with ping: FAILED!
> > [root@seventh ~]# 
> > 
> > Trying to figure this out...
> 
> [root@seventh perf]# perf script
> ping 29170 [001] 14644.810782: probe_libc:inet_pton: (7f0bac71be40)
>             7f0bac71be40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
>             7f0bac6e82b4 getaddrinfo+0x124 (/usr/lib64/libc-2.26.so)
>             5585e10adf40 [unknown] (/usr/bin/ping)
> 
> [root@seventh perf]# perf report --mmaps
> #      pid      tid     ppid  comm
>          0        0       -1 |swapper
>      29170    29170       -1 |ping
>                                 5585e10ab000-5585e12dd000 r-xp 00000000 2771393 /usr/bin/ping
>                                 7f0babfcf000-7f0bac1ed000 r-xp 00000000 2762913 /usr/lib64/libpthread-2.26.so
>                                 7f0bac1ed000-7f0bac3f1000 r-xp 00000000 2753363 /usr/lib64/libdl-2.26.so
>                                 7f0bac3f1000-7f0bac608000 r-xp 00000000 2760078 /usr/lib64/libz.so.1.2.11
>                                 7f0bac608000-7f0bac9be000 r-xp 00000000 2753359 /usr/lib64/libc-2.26.so
>                                 7f0bac9be000-7f0bacd09000 r-xp 00000000 2762901 /usr/lib64/libm-2.26.so
>                                 7f0bacd09000-7f0bacf20000 r-xp 00000000 2762915 /usr/lib64/libresolv-2.26.so
>                                 7f0bacf20000-7f0bad3a8000 r-xp 00000000 2764213 /usr/lib64/libcrypto.so.1.1.0h
>                                 7f0bad3a8000-7f0bad5dc000 r-xp 00000000 2761070 /usr/lib64/libidn.so.11.6.18
>                                 7f0bad5dc000-7f0bad7e1000 r-xp 00000000 2760189 /usr/lib64/libcap.so.2.25
>                                 7f0bad7e1000-7f0bada08000 r-xp 00000000 2753353 /usr/lib64/ld-2.26.so
>                                 7ffe23d99000-7ffe23d9b000 r-xp 00000000 0 [vdso]
> [root@seventh perf]# 
> 
> So it is there, but I don't have debuginfo for ping, lets see if I add
> it...
> 
> [root@seventh perf]# rpm -qf `which ping`
> iputils-20161105-7.fc27.x86_64
> [root@seventh perf]# 
> [root@seventh perf]# dnf debuginfo-install iputils
> 
> [root@seventh perf]# perf script
> ping 29170 [001] 14644.810782: probe_libc:inet_pton: (7f0bac71be40)
>             7f0bac71be40 __GI___inet_pton+0x0 (/usr/lib64/libc-2.26.so)
>             7f0bac6e82b4 getaddrinfo+0x124 (/usr/lib64/libc-2.26.so)
>             5585e10adf40 main+0x880 (/usr/bin/ping)
> 
> [root@seventh perf]# 
> 
> So we need to check if debuginfo is available, and if so, expect it to
> resolve that entry to main, if not, expect it to _not_ resolve and have
> [unknown]  instead...

But tis is not related to your recent patches, so I'm folding this last
one with the one adding the offsets and go on from there...

- Arnaldo

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh
  2018-05-18 14:14       ` Arnaldo Carvalho de Melo
  2018-05-18 18:24         ` Arnaldo Carvalho de Melo
@ 2018-05-22  6:09         ` Thomas-Mich Richter
  1 sibling, 0 replies; 14+ messages in thread
From: Thomas-Mich Richter @ 2018-05-22  6:09 UTC (permalink / raw)
  To: Arnaldo Carvalho de Melo
  Cc: Sandipan Das, jolsa, linux-kernel, ravi.bangoria, naveen.n.rao,
	Hendrik Brueckner

On 05/18/2018 04:14 PM, Arnaldo Carvalho de Melo wrote:
> Em Fri, May 18, 2018 at 01:09:48PM +0200, Thomas-Mich Richter escreveu:
>> On 05/18/2018 12:29 PM, Sandipan Das wrote:
>>> Can you please apply these two patches as well and then re-test?
> 
>>> [1] https://lkml.org/lkml/2018/5/17/112
>>> [2] https://lkml.org/lkml/2018/5/17/113
> 
>> Ahhh, yes that helped. Must have missed it. Thanks for the pointer.
> 
> Cool, can I take that as a Tested-by: Thomas?
> 
> - Arnaldo
> 
Sure

-- 
Thomas Richter, Dept 3303, IBM s390 Linux Development, Boeblingen, Germany
--
Vorsitzende des Aufsichtsrats: Martina Koederitz 
Geschäftsführung: Dirk Wittkopp
Sitz der Gesellschaft: Böblingen / Registergericht: Amtsgericht Stuttgart, HRB 243294

^ permalink raw reply	[flat|nested] 14+ messages in thread

* [lkp-robot] [perf tests]  32a4debc7c: perf-sanity-tests.probe_libc's_inet_pton_&_backtrace_it_with_ping.fail
  2018-05-18  7:24 [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh Sandipan Das
@ 2018-07-04  6:57   ` kernel test robot
  2018-05-18 19:21 ` Arnaldo Carvalho de Melo
  2018-07-04  6:57   ` kernel test robot
  2 siblings, 0 replies; 14+ messages in thread
From: kernel test robot @ 2018-07-04  6:57 UTC (permalink / raw)
  To: Sandipan Das
  Cc: acme, jolsa, linux-kernel, ravi.bangoria, naveen.n.rao, tmricht, lkp

[-- Attachment #1: Type: text/plain, Size: 954 bytes --]


FYI, we noticed the following commit (built with gcc-7):

commit: 32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f ("[PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh")
url: https://github.com/0day-ci/linux/commits/Sandipan-Das/perf-tests-Fix-regex-for-record-probe_libc_inet_pton-sh/20180521-130408


in testcase: perf-sanity-tests
with following parameters:

	perf_compiler: gcc



on test machine: qemu-system-x86_64 -enable-kvm -cpu kvm64,+ssse3 -smp 2 -m 8G

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):


2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 62
62: probe libc's inet_pton & backtrace it with ping       : FAILED!



To reproduce:

        git clone https://github.com/intel/lkp-tests.git
        cd lkp-tests
        bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email



Thanks,
Xiaolong

[-- Attachment #2: job-script --]
[-- Type: text/plain, Size: 4386 bytes --]

#!/bin/sh

export_top_env()
{
	export suite='perf-sanity-tests'
	export testcase='perf-sanity-tests'
	export category='functional'
	export job_origin='/lkp/lkp/src/allot/rand/vm-lkp-nex04-8G/perf-sanity-tests.yaml'
	export testbox='vm-lkp-nex04-8G-2'
	export tbox_group='vm-lkp-nex04-8G'
	export kconfig='x86_64-fedora-25'
	export compiler='gcc-7'
	export queue='bisect'
	export branch='linux-devel/devel-spot-201805211347'
	export commit='32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f'
	export submit_id='5b03dff30b9a932b3a767d71'
	export job_file='/lkp/scheduled/vm-lkp-nex04-8G-2/perf-sanity-tests-gcc-debian-x86_64-2016-08-31.cgz-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f-20180522-11066-yve2a-1.yaml'
	export id='1bdd8b616b538b8db798a8cdad4603b67ca4566f'
	export model='qemu-system-x86_64 -enable-kvm -cpu kvm64,+ssse3'
	export nr_vm=10
	export nr_cpu=2
	export memory='8G'
	export hdd_partitions='/dev/vda'
	export need_linux_perf=true
	export need_kconfig='CONFIG_KVM_GUEST=y'
	export ssh_base_port=23250
	export rootfs='debian-x86_64-2016-08-31.cgz'
	export enqueue_time='2018-05-22 17:16:35 +0800'
	export _id='5b03e2ff0b9a932b3a767d72'
	export _rt='/result/perf-sanity-tests/gcc/vm-lkp-nex04-8G/debian-x86_64-2016-08-31.cgz/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f'
	export user='lkp'
	export result_root='/result/perf-sanity-tests/gcc/vm-lkp-nex04-8G/debian-x86_64-2016-08-31.cgz/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/0'
	export LKP_SERVER='inn'
	export max_uptime=3600
	export initrd='/osimage/debian/debian-x86_64-2016-08-31.cgz'
	export bootloader_append='root=/dev/ram0
user=lkp
job=/lkp/scheduled/vm-lkp-nex04-8G-2/perf-sanity-tests-gcc-debian-x86_64-2016-08-31.cgz-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f-20180522-11066-yve2a-1.yaml
ARCH=x86_64
kconfig=x86_64-fedora-25
branch=linux-devel/devel-spot-201805211347
commit=32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f
BOOT_IMAGE=/pkg/linux/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/vmlinuz-4.17.0-rc5-00073-g32a4deb
max_uptime=3600
RESULT_ROOT=/result/perf-sanity-tests/gcc/vm-lkp-nex04-8G/debian-x86_64-2016-08-31.cgz/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/0
LKP_SERVER=inn
debug
apic=debug
sysrq_always_enabled
rcupdate.rcu_cpu_stall_timeout=100
net.ifnames=0
printk.devkmsg=on
panic=-1
softlockup_panic=1
nmi_watchdog=panic
oops=panic
load_ramdisk=2
prompt_ramdisk=0
drbd.minor_count=8
systemd.log_level=err
ignore_loglevel
console=tty0
earlyprintk=ttyS0,115200
console=ttyS0,115200
vga=normal
rw'
	export modules_initrd='/pkg/linux/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/modules.cgz'
	export bm_initrd='/osimage/deps/debian-x86_64-2016-08-31.cgz/run-ipconfig_2016-11-15.cgz,/osimage/deps/debian-x86_64-2016-08-31.cgz/lkp_2018-05-14.cgz,/osimage/deps/debian-x86_64-2016-08-31.cgz/rsync-rootfs_2016-11-15.cgz,/osimage/deps/debian-x86_64-2016-08-31.cgz/perf-sanity-tests_2017-12-29.cgz,/osimage/pkg/debian-x86_64-2016-08-31.cgz/perf-x86_64-771c577c23ba_2018-05-21.cgz'
	export linux_perf_initrd='/pkg/linux/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/linux-perf.cgz'
	export lkp_initrd='/lkp/lkp/lkp-x86_64.cgz'
	export site='inn'
	export LKP_CGI_PORT=80
	export LKP_CIFS_PORT=139
	export kernel='/pkg/linux/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/vmlinuz-4.17.0-rc5-00073-g32a4deb'
	export dequeue_time='2018-05-22 17:33:08 +0800'
	export job_initrd='/lkp/scheduled/vm-lkp-nex04-8G-2/perf-sanity-tests-gcc-debian-x86_64-2016-08-31.cgz-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f-20180522-11066-yve2a-1.cgz'

	[ -n "$LKP_SRC" ] ||
	export LKP_SRC=/lkp/${user:-lkp}/src
}

run_job()
{
	echo $$ > $TMP/run-job.pid

	. $LKP_SRC/lib/http.sh
	. $LKP_SRC/lib/job.sh
	. $LKP_SRC/lib/env.sh

	export_top_env

	run_monitor $LKP_SRC/monitors/wrapper kmsg
	run_monitor $LKP_SRC/monitors/wrapper heartbeat
	run_monitor $LKP_SRC/monitors/wrapper oom-killer
	run_monitor $LKP_SRC/monitors/plain/watchdog

	run_test perf_compiler='gcc' $LKP_SRC/tests/wrapper perf-sanity-tests
}

extract_stats()
{
	$LKP_SRC/stats/wrapper perf-sanity-tests
	$LKP_SRC/stats/wrapper kmsg

	$LKP_SRC/stats/wrapper time perf-sanity-tests.time
	$LKP_SRC/stats/wrapper time
	$LKP_SRC/stats/wrapper dmesg
	$LKP_SRC/stats/wrapper kmsg
	$LKP_SRC/stats/wrapper stderr
	$LKP_SRC/stats/wrapper last_state
}

"$@"

[-- Attachment #3: dmesg.xz --]
[-- Type: application/x-xz, Size: 20828 bytes --]

[-- Attachment #4: perf-sanity-tests --]
[-- Type: text/plain, Size: 25349 bytes --]

2018-05-22 17:39:10 make ARCH= -C /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf
make: Entering directory '/usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf'
  BUILD:   Doing 'make ^[[33m-j2^[[m' parallel build
  HOSTCC   fixdep.o
  HOSTLD   fixdep-in.o
  LINK     fixdep

Auto-detecting system features:
...                         dwarf: [ ^[[32mon^[[m  ]
...            dwarf_getlocations: [ ^[[32mon^[[m  ]
...                         glibc: [ ^[[32mon^[[m  ]
...                          gtk2: [ ^[[31mOFF^[[m ]
...                      libaudit: [ ^[[32mon^[[m  ]
...                        libbfd: [ ^[[32mon^[[m  ]
...                        libelf: [ ^[[32mon^[[m  ]
...                       libnuma: [ ^[[32mon^[[m  ]
...        numa_num_possible_cpus: [ ^[[32mon^[[m  ]
...                       libperl: [ ^[[31mOFF^[[m ]
...                     libpython: [ ^[[32mon^[[m  ]
...                      libslang: [ ^[[31mOFF^[[m ]
...                     libcrypto: [ ^[[31mOFF^[[m ]
...                     libunwind: [ ^[[32mon^[[m  ]
...            libdw-dwarf-unwind: [ ^[[32mon^[[m  ]
...                          zlib: [ ^[[32mon^[[m  ]
...                          lzma: [ ^[[32mon^[[m  ]
...                     get_cpuid: [ ^[[32mon^[[m  ]
...                           bpf: [ ^[[32mon^[[m  ]

  GEN      common-cmds.h
  CC       fd/array.o
  LD       fd/libapi-in.o
  CC       fs/fs.o
  CC       fs/tracing_path.o
  CC       event-parse.o
  LD       fs/libapi-in.o
  CC       cpu.o
  CC       debug.o
  CC       str_error_r.o
  LD       libapi-in.o
  AR       libapi.a
  CC       exec-cmd.o
  CC       help.o
  CC       event-plugin.o
  CC       pager.o
  CC       trace-seq.o
  CC       parse-options.o
  CC       parse-filter.o
  CC       parse-utils.o
  CC       kbuffer-parse.o
  LD       libtraceevent-in.o
  LINK     libtraceevent.a
  CC       libbpf.o
  CC       run-command.o
  CC       bpf.o
  CC       sigchain.o
  CC       nlattr.o
  CC       subcmd-config.o
  LD       libbpf-in.o
  LINK     libbpf.a
  HOSTCC   pmu-events/json.o
  LD       libsubcmd-in.o
  AR       libsubcmd.a
  CC       plugin_jbd2.o
  HOSTCC   pmu-events/jsmn.o
  LD       plugin_jbd2-in.o
  CC       plugin_hrtimer.o
  HOSTCC   pmu-events/jevents.o
  LD       plugin_hrtimer-in.o
  CC       plugin_kmem.o
  LD       plugin_kmem-in.o
  CC       plugin_kvm.o
  HOSTLD   pmu-events/jevents-in.o
  GEN      perf-archive
  GEN      perf-with-kcore
  CC       util/annotate.o
  LD       plugin_kvm-in.o
  CC       plugin_mac80211.o
  LD       plugin_mac80211-in.o
  CC       plugin_sched_switch.o
  LD       plugin_sched_switch-in.o
  CC       plugin_function.o
  LD       plugin_function-in.o
  CC       plugin_xen.o
  LD       plugin_xen-in.o
  CC       plugin_scsi.o
  LD       plugin_scsi-in.o
  CC       plugin_cfg80211.o
  LD       plugin_cfg80211-in.o
  LINK     plugin_jbd2.so
  LINK     plugin_hrtimer.so
  LINK     plugin_kmem.so
  LINK     plugin_kvm.so
  LINK     plugin_mac80211.so
  LINK     plugin_sched_switch.so
  LINK     plugin_function.so
  LINK     plugin_xen.so
  LINK     plugin_scsi.so
  LINK     plugin_cfg80211.so
  CC       builtin-bench.o
  CC       builtin-annotate.o
  CC       builtin-config.o
  CC       builtin-diff.o
  CC       util/block-range.o
  CC       util/build-id.o
  CC       builtin-evlist.o
  CC       builtin-ftrace.o
  CC       util/config.o
  CC       builtin-help.o
  CC       builtin-sched.o
  CC       util/ctype.o
  CC       util/db-export.o
  CC       util/env.o
  CC       util/event.o
  CC       util/evlist.o
  CC       builtin-buildid-list.o
  CC       builtin-buildid-cache.o
  CC       builtin-kallsyms.o
  CC       builtin-list.o
  CC       util/evsel.o
  CC       builtin-record.o
  CC       builtin-report.o
  CC       builtin-stat.o
  CC       util/evsel_fprintf.o
  CC       util/find_bit.o
  CC       util/kallsyms.o
  CC       util/levenshtein.o
  CC       util/llvm-utils.o
  CC       util/mmap.o
  CC       util/memswap.o
  BISON    util/parse-events-bison.c
  CC       builtin-timechart.o
  CC       util/perf_regs.o
  CC       util/path.o
  CC       util/print_binary.o
  CC       util/rbtree.o
  CC       util/libstring.o
  CC       util/bitmap.o
  CC       util/hweight.o
  CC       util/smt.o
  CC       builtin-top.o
  CC       util/quote.o
  CC       util/strbuf.o
  CC       util/string.o
  CC       util/strlist.o
  CC       util/strfilter.o
  CC       builtin-script.o
  CC       util/top.o
  CC       util/usage.o
  CC       util/dso.o
  CC       util/symbol.o
  CC       builtin-kmem.o
  CC       util/symbol_fprintf.o
  CC       util/color.o
  CC       builtin-lock.o
  CC       util/metricgroup.o
  CC       builtin-kvm.o
  CC       util/header.o
  CC       builtin-inject.o
  CC       builtin-mem.o
  CC       builtin-data.o
  CC       builtin-version.o
  CC       builtin-c2c.o
  CC       util/callchain.o
  CC       builtin-trace.o
  CC       util/values.o
  CC       util/debug.o
  CC       util/machine.o
  CC       builtin-probe.o
  CC       bench/sched-messaging.o
  CC       bench/sched-pipe.o
  CC       util/map.o
  CC       bench/mem-functions.o
  CC       bench/futex-hash.o
  CC       bench/futex-wake.o
  CC       util/pstack.o
  CC       bench/futex-wake-parallel.o
  CC       util/session.o
  CC       bench/futex-requeue.o
  CC       bench/futex-lock-pi.o
  CC       bench/mem-memcpy-x86-64-asm.o
  CC       bench/mem-memset-x86-64-asm.o
  CC       bench/numa.o
  CC       util/syscalltbl.o
  CC       util/ordered-events.o
  CC       util/namespaces.o
  LD       bench/perf-in.o
  CC       tests/builtin-test.o
  CC       util/comm.o
  CC       util/thread.o
  CC       tests/parse-events.o
  CC       util/thread_map.o
  CC       util/trace-event-parse.o
  CC       util/parse-events-bison.o
  CC       tests/dso-data.o
  BISON    util/pmu-bison.c
  CC       util/trace-event-read.o
  CC       tests/attr.o
  CC       util/trace-event-info.o
  CC       tests/vmlinux-kallsyms.o
  CC       tests/openat-syscall.o
  CC       util/trace-event-scripting.o
  CC       tests/openat-syscall-all-cpus.o
  CC       util/trace-event.o
  CC       tests/openat-syscall-tp-fields.o
  CC       util/svghelper.o
  CC       tests/mmap-basic.o
  CC       tests/perf-record.o
  CC       util/sort.o
  CC       tests/evsel-roundtrip-name.o
  CC       tests/evsel-tp-sched.o
  CC       tests/fdarray.o
  CC       tests/pmu.o
  CC       tests/hists_common.o
  CC       tests/hists_link.o
  CC       util/hist.o
  CC       tests/hists_filter.o
  CC       tests/hists_output.o
  CC       tests/hists_cumulate.o
  CC       tests/python-use.o
  CC       tests/bp_signal.o
  CC       util/util.o
  CC       tests/bp_signal_overflow.o
  CC       tests/bp_account.o
  CC       util/xyarray.o
  CC       util/cpumap.o
  CC       tests/task-exit.o
  CC       tests/sw-clock.o
  CC       tests/mmap-thread-lookup.o
  CC       util/cgroup.o
  CC       tests/thread-mg-share.o
  CC       tests/switch-tracking.o
  CC       util/target.o
  CC       util/rblist.o
  CC       util/intlist.o
  CC       tests/keep-tracking.o
  CC       util/vdso.o
  CC       tests/code-reading.o
  CC       util/counts.o
  CC       util/stat.o
  CC       tests/sample-parsing.o
  CC       util/stat-shadow.o
  CC       tests/parse-no-sample-id-all.o
  CC       tests/kmod-path.o
  CC       tests/thread-map.o
  CC       tests/llvm.o
  CC       util/record.o
  CC       tests/bpf.o
  CC       util/srcline.o
  CC       tests/topology.o
  CC       tests/mem.o
  CC       util/data.o
  CC       tests/cpumap.o
  CC       util/tsc.o
  CC       util/cloexec.o
  CC       tests/stat.o
  CC       util/call-path.o
  CC       tests/event_update.o
  CC       util/rwsem.o
  CC       util/thread-stack.o
  CC       tests/event-times.o
  CC       tests/expr.o
  CC       util/auxtrace.o
  CC       tests/backward-ring-buffer.o
  CC       tests/sdt.o
  CC       tests/is_printable_array.o
  CC       tests/bitmap.o
  CC       tests/perf-hooks.o
  CC       tests/clang.o
  CC       util/intel-pt-decoder/intel-pt-pkt-decoder.o
  CC       tests/unit_number__scnprintf.o
  CC       tests/mem2node.o
  GEN      util/intel-pt-decoder/inat-tables.c
  CC       util/intel-pt-decoder/intel-pt-log.o
  CC       tests/dwarf-unwind.o
  CC       util/intel-pt-decoder/intel-pt-decoder.o
  CC       tests/llvm-src-base.o
  CC       tests/llvm-src-kbuild.o
  CC       tests/llvm-src-prologue.o
  CC       tests/llvm-src-relocation.o
  LD       tests/perf-in.o
  CC       perf.o
  LD       perf-in.o
  CC       util/intel-pt-decoder/intel-pt-insn-decoder.o
  LINK     pmu-events/jevents
  GEN      libtraceevent-dynamic-list
  GEN      pmu-events/pmu-events.c
  CC       pmu-events/pmu-events.o
  LD       pmu-events/pmu-events-in.o
  GEN      python/perf.so
  LD       util/intel-pt-decoder/libperf-in.o
  CC       util/scripting-engines/trace-event-python.o
  LD       util/scripting-engines/libperf-in.o
  CC       util/intel-pt.o
  CC       util/intel-bts.o
  CC       util/arm-spe.o
  CC       util/arm-spe-pkt-decoder.o
  CC       util/parse-branch-options.o
  CC       util/dump-insn.o
  CC       util/parse-regs-options.o
  CC       util/term.o
  CC       util/help-unknown-cmd.o
  CC       util/mem-events.o
  CC       util/vsprintf.o
  CC       util/drv_configs.o
  CC       util/units.o
  CC       util/time-utils.o
  BISON    util/expr-bison.c
  CC       util/branch.o
  CC       util/mem2node.o
  CC       util/bpf-loader.o
  CC       util/bpf-prologue.o
  CC       util/symbol-elf.o
  CC       util/probe-file.o
  CC       arch/common.o
  CC       arch/x86/util/header.o
  CC       arch/x86/util/tsc.o
  CC       util/probe-event.o
  CC       arch/x86/util/pmu.o
  CC       arch/x86/util/kvm-stat.o
  CC       arch/x86/util/perf_regs.o
  CC       arch/x86/util/group.o
  CC       arch/x86/util/dwarf-regs.o
  CC       arch/x86/util/unwind-libunwind.o
  CC       arch/x86/util/auxtrace.o
  CC       arch/x86/util/intel-pt.o
  CC       arch/x86/util/intel-bts.o
  CC       util/probe-finder.o
  LD       arch/x86/util/libperf-in.o
  CC       arch/x86/tests/regs_load.o
  CC       arch/x86/tests/dwarf-unwind.o
  CC       arch/x86/tests/arch-tests.o
  CC       arch/x86/tests/rdpmc.o
  CC       arch/x86/tests/perf-time-to-tsc.o
  CC       arch/x86/tests/insn-x86.o
  CC       util/dwarf-aux.o
  LD       arch/x86/tests/libperf-in.o
  LD       arch/x86/libperf-in.o
  LD       arch/libperf-in.o
  CC       ui/setup.o
  CC       ui/helpline.o
  CC       ui/progress.o
  CC       ui/util.o
  CC       util/dwarf-regs.o
  CC       ui/hist.o
  CC       util/unwind-libunwind-local.o
  CC       util/unwind-libunwind.o
  CC       util/zlib.o
  CC       util/lzma.o
  CC       util/demangle-java.o
  CC       util/demangle-rust.o
  CC       util/jitdump.o
  CC       ui/stdio/hist.o
  CC       util/genelf.o
  CC       util/genelf_debug.o
  LD       ui/libperf-in.o
  CC       scripts/python/Perf-Trace-Util/Context.o
  LD       scripts/python/Perf-Trace-Util/libperf-in.o
  LD       scripts/libperf-in.o
  CC       trace/beauty/clone.o
  CC       trace/beauty/fcntl.o
  CC       util/perf-hooks.o
  CC       trace/beauty/flock.o
  CC       trace/beauty/ioctl.o
  FLEX     util/parse-events-flex.c
  FLEX     util/pmu-flex.c
  CC       util/pmu-bison.o
  CC       trace/beauty/kcmp.o
  CC       trace/beauty/pkey_alloc.o
  CC       trace/beauty/prctl.o
  CC       util/expr-bison.o
  CC       trace/beauty/statx.o
  LD       trace/beauty/libperf-in.o
  CC       util/parse-events.o
  CC       util/parse-events-flex.o
  CC       util/pmu.o
  CC       util/pmu-flex.o
  LD       util/libperf-in.o
  LD       libperf-in.o
  AR       libperf.a
  LINK     perf
make: Leaving directory '/usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf'
2018-05-22 17:40:51 cd /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf
2018-05-22 17:40:51 mkdir -p /pkg
2018-05-22 17:40:51 mkdir -p /kbuild/obj/lkp/x86_64-fedora-25
2018-05-22 17:40:51 cp /pkg/linux/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/vmlinux.xz /tmp
2018-05-22 17:40:53 unxz -k /tmp/vmlinux.xz
2018-05-22 17:41:00 cp /tmp/vmlinux /kbuild/obj/lkp/x86_64-fedora-25
ignored_by_lkp: BPF filter
ignored_by_lkp: LLVM search and compile
ignored_by_lkp: Add vfs_getname probe to get syscall args filenames
ignored_by_lkp: Use vfs_getname probe to get syscall args filenames
ignored_by_lkp: Check open filename arg using perf trace + vfs_getname
ignored_by_lkp: builtin clang support
2018-05-22 17:41:01 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 1
 1: vmlinux symtab matches kallsyms                       : Ok
2018-05-22 17:41:02 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 2
 2: Detect openat syscall event                           : Ok
2018-05-22 17:41:02 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 3
 3: Detect openat syscall event on all cpus               : Ok
2018-05-22 17:41:02 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 4
 4: Read samples using the mmap interface                 : Ok
2018-05-22 17:41:02 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 5
 5: Test data source output                               : Ok
2018-05-22 17:41:02 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 6
 6: Parse event definition strings                        : FAILED!
2018-05-22 17:41:03 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 7
 7: Simple expression parser                              : Ok
2018-05-22 17:41:03 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 8
 8: PERF_RECORD_* events & perf_sample fields             : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 9
 9: Parse perf pmu format                                 : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 10
10: DSO data read                                         : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 11
11: DSO data cache                                        : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 12
12: DSO data reopen                                       : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 13
13: Roundtrip evsel->name                                 : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 14
14: Parse sched tracepoints fields                        : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 15
15: syscalls:sys_enter_openat event fields                : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 16
16: Setup struct perf_event_attr                          : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 17
17: Match and link multiple hists                         : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 18
18: 'import perf' in python                               : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 19
19: Breakpoint overflow signal handler                    : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 20
20: Breakpoint overflow sampling                          : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 21
21: Breakpoint accounting                                 : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 22
22: Number of exit events of a simple workload            : Skip
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 23
23: Software clock events period values                   : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 24
24: Object code reading                                   : FAILED!
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 25
25: Sample parsing                                        : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 26
26: Use a dummy software event to keep tracking           : Skip
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 27
27: Parse with no sample_id_all bit set                   : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 28
28: Filter hist entries                                   : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 29
29: Lookup mmap thread                                    : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 30
30: Share thread mg                                       : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 31
31: Sort output of hist entries                           : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 32
32: Cumulate child hist entries                           : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 33
33: Track with sched_switch                               : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 34
34: Filter fds with revents mask in a fdarray             : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 35
35: Add fd to a fdarray, making it autogrow               : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 36
36: kmod_path__parse                                      : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 37
37: Thread map                                            : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 39
39: Session topology                                      : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 41
41: Synthesize thread map                                 : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 42
42: Remove thread map                                     : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 43
43: Synthesize cpu map                                    : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 44
44: Synthesize stat config                                : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 45
45: Synthesize stat                                       : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 46
46: Synthesize stat round                                 : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 47
47: Synthesize attr update                                : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 48
48: Event times                                           : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 49
49: Read backward ring buffer                             : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 50
50: Print cpu map                                         : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 51
51: Probe SDT events                                      : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 52
52: is_printable_array                                    : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 53
53: Print bitmap                                          : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 54
54: perf hooks                                            : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 56
56: unit_number__scnprintf                                : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 57
57: mem2node                                              : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 58
58: x86 rdpmc                                             : FAILED!
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 59
59: Convert perf time to TSC                              : FAILED!
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 60
60: DWARF unwind                                          : Ok
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 61
61: x86 instruction decoder - new instructions            : Ok
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 62
62: probe libc's inet_pton & backtrace it with ping       : FAILED!
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 66
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 67
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 68
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 69
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 70
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 71
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 72
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 73

^ permalink raw reply	[flat|nested] 14+ messages in thread

* [lkp-robot] [perf tests] 32a4debc7c: perf-sanity-tests.probe_libc's_inet_pton_&_backtrace_it_with_ping.fail
@ 2018-07-04  6:57   ` kernel test robot
  0 siblings, 0 replies; 14+ messages in thread
From: kernel test robot @ 2018-07-04  6:57 UTC (permalink / raw)
  To: lkp

[-- Attachment #1: Type: text/plain, Size: 988 bytes --]


FYI, we noticed the following commit (built with gcc-7):

commit: 32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f ("[PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh")
url: https://github.com/0day-ci/linux/commits/Sandipan-Das/perf-tests-Fix-regex-for-record-probe_libc_inet_pton-sh/20180521-130408


in testcase: perf-sanity-tests
with following parameters:

	perf_compiler: gcc



on test machine: qemu-system-x86_64 -enable-kvm -cpu kvm64,+ssse3 -smp 2 -m 8G

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):


2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 62
62: probe libc's inet_pton & backtrace it with ping       : FAILED!



To reproduce:

        git clone https://github.com/intel/lkp-tests.git
        cd lkp-tests
        bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email



Thanks,
Xiaolong

[-- Attachment #2: job-script.ksh --]
[-- Type: text/plain, Size: 4386 bytes --]

#!/bin/sh

export_top_env()
{
	export suite='perf-sanity-tests'
	export testcase='perf-sanity-tests'
	export category='functional'
	export job_origin='/lkp/lkp/src/allot/rand/vm-lkp-nex04-8G/perf-sanity-tests.yaml'
	export testbox='vm-lkp-nex04-8G-2'
	export tbox_group='vm-lkp-nex04-8G'
	export kconfig='x86_64-fedora-25'
	export compiler='gcc-7'
	export queue='bisect'
	export branch='linux-devel/devel-spot-201805211347'
	export commit='32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f'
	export submit_id='5b03dff30b9a932b3a767d71'
	export job_file='/lkp/scheduled/vm-lkp-nex04-8G-2/perf-sanity-tests-gcc-debian-x86_64-2016-08-31.cgz-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f-20180522-11066-yve2a-1.yaml'
	export id='1bdd8b616b538b8db798a8cdad4603b67ca4566f'
	export model='qemu-system-x86_64 -enable-kvm -cpu kvm64,+ssse3'
	export nr_vm=10
	export nr_cpu=2
	export memory='8G'
	export hdd_partitions='/dev/vda'
	export need_linux_perf=true
	export need_kconfig='CONFIG_KVM_GUEST=y'
	export ssh_base_port=23250
	export rootfs='debian-x86_64-2016-08-31.cgz'
	export enqueue_time='2018-05-22 17:16:35 +0800'
	export _id='5b03e2ff0b9a932b3a767d72'
	export _rt='/result/perf-sanity-tests/gcc/vm-lkp-nex04-8G/debian-x86_64-2016-08-31.cgz/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f'
	export user='lkp'
	export result_root='/result/perf-sanity-tests/gcc/vm-lkp-nex04-8G/debian-x86_64-2016-08-31.cgz/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/0'
	export LKP_SERVER='inn'
	export max_uptime=3600
	export initrd='/osimage/debian/debian-x86_64-2016-08-31.cgz'
	export bootloader_append='root=/dev/ram0
user=lkp
job=/lkp/scheduled/vm-lkp-nex04-8G-2/perf-sanity-tests-gcc-debian-x86_64-2016-08-31.cgz-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f-20180522-11066-yve2a-1.yaml
ARCH=x86_64
kconfig=x86_64-fedora-25
branch=linux-devel/devel-spot-201805211347
commit=32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f
BOOT_IMAGE=/pkg/linux/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/vmlinuz-4.17.0-rc5-00073-g32a4deb
max_uptime=3600
RESULT_ROOT=/result/perf-sanity-tests/gcc/vm-lkp-nex04-8G/debian-x86_64-2016-08-31.cgz/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/0
LKP_SERVER=inn
debug
apic=debug
sysrq_always_enabled
rcupdate.rcu_cpu_stall_timeout=100
net.ifnames=0
printk.devkmsg=on
panic=-1
softlockup_panic=1
nmi_watchdog=panic
oops=panic
load_ramdisk=2
prompt_ramdisk=0
drbd.minor_count=8
systemd.log_level=err
ignore_loglevel
console=tty0
earlyprintk=ttyS0,115200
console=ttyS0,115200
vga=normal
rw'
	export modules_initrd='/pkg/linux/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/modules.cgz'
	export bm_initrd='/osimage/deps/debian-x86_64-2016-08-31.cgz/run-ipconfig_2016-11-15.cgz,/osimage/deps/debian-x86_64-2016-08-31.cgz/lkp_2018-05-14.cgz,/osimage/deps/debian-x86_64-2016-08-31.cgz/rsync-rootfs_2016-11-15.cgz,/osimage/deps/debian-x86_64-2016-08-31.cgz/perf-sanity-tests_2017-12-29.cgz,/osimage/pkg/debian-x86_64-2016-08-31.cgz/perf-x86_64-771c577c23ba_2018-05-21.cgz'
	export linux_perf_initrd='/pkg/linux/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/linux-perf.cgz'
	export lkp_initrd='/lkp/lkp/lkp-x86_64.cgz'
	export site='inn'
	export LKP_CGI_PORT=80
	export LKP_CIFS_PORT=139
	export kernel='/pkg/linux/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/vmlinuz-4.17.0-rc5-00073-g32a4deb'
	export dequeue_time='2018-05-22 17:33:08 +0800'
	export job_initrd='/lkp/scheduled/vm-lkp-nex04-8G-2/perf-sanity-tests-gcc-debian-x86_64-2016-08-31.cgz-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f-20180522-11066-yve2a-1.cgz'

	[ -n "$LKP_SRC" ] ||
	export LKP_SRC=/lkp/${user:-lkp}/src
}

run_job()
{
	echo $$ > $TMP/run-job.pid

	. $LKP_SRC/lib/http.sh
	. $LKP_SRC/lib/job.sh
	. $LKP_SRC/lib/env.sh

	export_top_env

	run_monitor $LKP_SRC/monitors/wrapper kmsg
	run_monitor $LKP_SRC/monitors/wrapper heartbeat
	run_monitor $LKP_SRC/monitors/wrapper oom-killer
	run_monitor $LKP_SRC/monitors/plain/watchdog

	run_test perf_compiler='gcc' $LKP_SRC/tests/wrapper perf-sanity-tests
}

extract_stats()
{
	$LKP_SRC/stats/wrapper perf-sanity-tests
	$LKP_SRC/stats/wrapper kmsg

	$LKP_SRC/stats/wrapper time perf-sanity-tests.time
	$LKP_SRC/stats/wrapper time
	$LKP_SRC/stats/wrapper dmesg
	$LKP_SRC/stats/wrapper kmsg
	$LKP_SRC/stats/wrapper stderr
	$LKP_SRC/stats/wrapper last_state
}

"$@"

[-- Attachment #3: dmesg.xz --]
[-- Type: application/x-xz, Size: 20828 bytes --]

[-- Attachment #4: perf-sanity-tests.ksh --]
[-- Type: text/plain, Size: 24830 bytes --]

2018-05-22 17:39:10 make ARCH= -C /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf
make: Entering directory '/usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf'
  BUILD:   Doing 'make ^[[33m-j2^[[m' parallel build
  HOSTCC   fixdep.o
  HOSTLD   fixdep-in.o
  LINK     fixdep

Auto-detecting system features:
...                         dwarf: [ ^[[32mon^[[m  ]
...            dwarf_getlocations: [ ^[[32mon^[[m  ]
...                         glibc: [ ^[[32mon^[[m  ]
...                          gtk2: [ ^[[31mOFF^[[m ]
...                      libaudit: [ ^[[32mon^[[m  ]
...                        libbfd: [ ^[[32mon^[[m  ]
...                        libelf: [ ^[[32mon^[[m  ]
...                       libnuma: [ ^[[32mon^[[m  ]
...        numa_num_possible_cpus: [ ^[[32mon^[[m  ]
...                       libperl: [ ^[[31mOFF^[[m ]
...                     libpython: [ ^[[32mon^[[m  ]
...                      libslang: [ ^[[31mOFF^[[m ]
...                     libcrypto: [ ^[[31mOFF^[[m ]
...                     libunwind: [ ^[[32mon^[[m  ]
...            libdw-dwarf-unwind: [ ^[[32mon^[[m  ]
...                          zlib: [ ^[[32mon^[[m  ]
...                          lzma: [ ^[[32mon^[[m  ]
...                     get_cpuid: [ ^[[32mon^[[m  ]
...                           bpf: [ ^[[32mon^[[m  ]

  GEN      common-cmds.h
  CC       fd/array.o
  LD       fd/libapi-in.o
  CC       fs/fs.o
  CC       fs/tracing_path.o
  CC       event-parse.o
  LD       fs/libapi-in.o
  CC       cpu.o
  CC       debug.o
  CC       str_error_r.o
  LD       libapi-in.o
  AR       libapi.a
  CC       exec-cmd.o
  CC       help.o
  CC       event-plugin.o
  CC       pager.o
  CC       trace-seq.o
  CC       parse-options.o
  CC       parse-filter.o
  CC       parse-utils.o
  CC       kbuffer-parse.o
  LD       libtraceevent-in.o
  LINK     libtraceevent.a
  CC       libbpf.o
  CC       run-command.o
  CC       bpf.o
  CC       sigchain.o
  CC       nlattr.o
  CC       subcmd-config.o
  LD       libbpf-in.o
  LINK     libbpf.a
  HOSTCC   pmu-events/json.o
  LD       libsubcmd-in.o
  AR       libsubcmd.a
  CC       plugin_jbd2.o
  HOSTCC   pmu-events/jsmn.o
  LD       plugin_jbd2-in.o
  CC       plugin_hrtimer.o
  HOSTCC   pmu-events/jevents.o
  LD       plugin_hrtimer-in.o
  CC       plugin_kmem.o
  LD       plugin_kmem-in.o
  CC       plugin_kvm.o
  HOSTLD   pmu-events/jevents-in.o
  GEN      perf-archive
  GEN      perf-with-kcore
  CC       util/annotate.o
  LD       plugin_kvm-in.o
  CC       plugin_mac80211.o
  LD       plugin_mac80211-in.o
  CC       plugin_sched_switch.o
  LD       plugin_sched_switch-in.o
  CC       plugin_function.o
  LD       plugin_function-in.o
  CC       plugin_xen.o
  LD       plugin_xen-in.o
  CC       plugin_scsi.o
  LD       plugin_scsi-in.o
  CC       plugin_cfg80211.o
  LD       plugin_cfg80211-in.o
  LINK     plugin_jbd2.so
  LINK     plugin_hrtimer.so
  LINK     plugin_kmem.so
  LINK     plugin_kvm.so
  LINK     plugin_mac80211.so
  LINK     plugin_sched_switch.so
  LINK     plugin_function.so
  LINK     plugin_xen.so
  LINK     plugin_scsi.so
  LINK     plugin_cfg80211.so
  CC       builtin-bench.o
  CC       builtin-annotate.o
  CC       builtin-config.o
  CC       builtin-diff.o
  CC       util/block-range.o
  CC       util/build-id.o
  CC       builtin-evlist.o
  CC       builtin-ftrace.o
  CC       util/config.o
  CC       builtin-help.o
  CC       builtin-sched.o
  CC       util/ctype.o
  CC       util/db-export.o
  CC       util/env.o
  CC       util/event.o
  CC       util/evlist.o
  CC       builtin-buildid-list.o
  CC       builtin-buildid-cache.o
  CC       builtin-kallsyms.o
  CC       builtin-list.o
  CC       util/evsel.o
  CC       builtin-record.o
  CC       builtin-report.o
  CC       builtin-stat.o
  CC       util/evsel_fprintf.o
  CC       util/find_bit.o
  CC       util/kallsyms.o
  CC       util/levenshtein.o
  CC       util/llvm-utils.o
  CC       util/mmap.o
  CC       util/memswap.o
  BISON    util/parse-events-bison.c
  CC       builtin-timechart.o
  CC       util/perf_regs.o
  CC       util/path.o
  CC       util/print_binary.o
  CC       util/rbtree.o
  CC       util/libstring.o
  CC       util/bitmap.o
  CC       util/hweight.o
  CC       util/smt.o
  CC       builtin-top.o
  CC       util/quote.o
  CC       util/strbuf.o
  CC       util/string.o
  CC       util/strlist.o
  CC       util/strfilter.o
  CC       builtin-script.o
  CC       util/top.o
  CC       util/usage.o
  CC       util/dso.o
  CC       util/symbol.o
  CC       builtin-kmem.o
  CC       util/symbol_fprintf.o
  CC       util/color.o
  CC       builtin-lock.o
  CC       util/metricgroup.o
  CC       builtin-kvm.o
  CC       util/header.o
  CC       builtin-inject.o
  CC       builtin-mem.o
  CC       builtin-data.o
  CC       builtin-version.o
  CC       builtin-c2c.o
  CC       util/callchain.o
  CC       builtin-trace.o
  CC       util/values.o
  CC       util/debug.o
  CC       util/machine.o
  CC       builtin-probe.o
  CC       bench/sched-messaging.o
  CC       bench/sched-pipe.o
  CC       util/map.o
  CC       bench/mem-functions.o
  CC       bench/futex-hash.o
  CC       bench/futex-wake.o
  CC       util/pstack.o
  CC       bench/futex-wake-parallel.o
  CC       util/session.o
  CC       bench/futex-requeue.o
  CC       bench/futex-lock-pi.o
  CC       bench/mem-memcpy-x86-64-asm.o
  CC       bench/mem-memset-x86-64-asm.o
  CC       bench/numa.o
  CC       util/syscalltbl.o
  CC       util/ordered-events.o
  CC       util/namespaces.o
  LD       bench/perf-in.o
  CC       tests/builtin-test.o
  CC       util/comm.o
  CC       util/thread.o
  CC       tests/parse-events.o
  CC       util/thread_map.o
  CC       util/trace-event-parse.o
  CC       util/parse-events-bison.o
  CC       tests/dso-data.o
  BISON    util/pmu-bison.c
  CC       util/trace-event-read.o
  CC       tests/attr.o
  CC       util/trace-event-info.o
  CC       tests/vmlinux-kallsyms.o
  CC       tests/openat-syscall.o
  CC       util/trace-event-scripting.o
  CC       tests/openat-syscall-all-cpus.o
  CC       util/trace-event.o
  CC       tests/openat-syscall-tp-fields.o
  CC       util/svghelper.o
  CC       tests/mmap-basic.o
  CC       tests/perf-record.o
  CC       util/sort.o
  CC       tests/evsel-roundtrip-name.o
  CC       tests/evsel-tp-sched.o
  CC       tests/fdarray.o
  CC       tests/pmu.o
  CC       tests/hists_common.o
  CC       tests/hists_link.o
  CC       util/hist.o
  CC       tests/hists_filter.o
  CC       tests/hists_output.o
  CC       tests/hists_cumulate.o
  CC       tests/python-use.o
  CC       tests/bp_signal.o
  CC       util/util.o
  CC       tests/bp_signal_overflow.o
  CC       tests/bp_account.o
  CC       util/xyarray.o
  CC       util/cpumap.o
  CC       tests/task-exit.o
  CC       tests/sw-clock.o
  CC       tests/mmap-thread-lookup.o
  CC       util/cgroup.o
  CC       tests/thread-mg-share.o
  CC       tests/switch-tracking.o
  CC       util/target.o
  CC       util/rblist.o
  CC       util/intlist.o
  CC       tests/keep-tracking.o
  CC       util/vdso.o
  CC       tests/code-reading.o
  CC       util/counts.o
  CC       util/stat.o
  CC       tests/sample-parsing.o
  CC       util/stat-shadow.o
  CC       tests/parse-no-sample-id-all.o
  CC       tests/kmod-path.o
  CC       tests/thread-map.o
  CC       tests/llvm.o
  CC       util/record.o
  CC       tests/bpf.o
  CC       util/srcline.o
  CC       tests/topology.o
  CC       tests/mem.o
  CC       util/data.o
  CC       tests/cpumap.o
  CC       util/tsc.o
  CC       util/cloexec.o
  CC       tests/stat.o
  CC       util/call-path.o
  CC       tests/event_update.o
  CC       util/rwsem.o
  CC       util/thread-stack.o
  CC       tests/event-times.o
  CC       tests/expr.o
  CC       util/auxtrace.o
  CC       tests/backward-ring-buffer.o
  CC       tests/sdt.o
  CC       tests/is_printable_array.o
  CC       tests/bitmap.o
  CC       tests/perf-hooks.o
  CC       tests/clang.o
  CC       util/intel-pt-decoder/intel-pt-pkt-decoder.o
  CC       tests/unit_number__scnprintf.o
  CC       tests/mem2node.o
  GEN      util/intel-pt-decoder/inat-tables.c
  CC       util/intel-pt-decoder/intel-pt-log.o
  CC       tests/dwarf-unwind.o
  CC       util/intel-pt-decoder/intel-pt-decoder.o
  CC       tests/llvm-src-base.o
  CC       tests/llvm-src-kbuild.o
  CC       tests/llvm-src-prologue.o
  CC       tests/llvm-src-relocation.o
  LD       tests/perf-in.o
  CC       perf.o
  LD       perf-in.o
  CC       util/intel-pt-decoder/intel-pt-insn-decoder.o
  LINK     pmu-events/jevents
  GEN      libtraceevent-dynamic-list
  GEN      pmu-events/pmu-events.c
  CC       pmu-events/pmu-events.o
  LD       pmu-events/pmu-events-in.o
  GEN      python/perf.so
  LD       util/intel-pt-decoder/libperf-in.o
  CC       util/scripting-engines/trace-event-python.o
  LD       util/scripting-engines/libperf-in.o
  CC       util/intel-pt.o
  CC       util/intel-bts.o
  CC       util/arm-spe.o
  CC       util/arm-spe-pkt-decoder.o
  CC       util/parse-branch-options.o
  CC       util/dump-insn.o
  CC       util/parse-regs-options.o
  CC       util/term.o
  CC       util/help-unknown-cmd.o
  CC       util/mem-events.o
  CC       util/vsprintf.o
  CC       util/drv_configs.o
  CC       util/units.o
  CC       util/time-utils.o
  BISON    util/expr-bison.c
  CC       util/branch.o
  CC       util/mem2node.o
  CC       util/bpf-loader.o
  CC       util/bpf-prologue.o
  CC       util/symbol-elf.o
  CC       util/probe-file.o
  CC       arch/common.o
  CC       arch/x86/util/header.o
  CC       arch/x86/util/tsc.o
  CC       util/probe-event.o
  CC       arch/x86/util/pmu.o
  CC       arch/x86/util/kvm-stat.o
  CC       arch/x86/util/perf_regs.o
  CC       arch/x86/util/group.o
  CC       arch/x86/util/dwarf-regs.o
  CC       arch/x86/util/unwind-libunwind.o
  CC       arch/x86/util/auxtrace.o
  CC       arch/x86/util/intel-pt.o
  CC       arch/x86/util/intel-bts.o
  CC       util/probe-finder.o
  LD       arch/x86/util/libperf-in.o
  CC       arch/x86/tests/regs_load.o
  CC       arch/x86/tests/dwarf-unwind.o
  CC       arch/x86/tests/arch-tests.o
  CC       arch/x86/tests/rdpmc.o
  CC       arch/x86/tests/perf-time-to-tsc.o
  CC       arch/x86/tests/insn-x86.o
  CC       util/dwarf-aux.o
  LD       arch/x86/tests/libperf-in.o
  LD       arch/x86/libperf-in.o
  LD       arch/libperf-in.o
  CC       ui/setup.o
  CC       ui/helpline.o
  CC       ui/progress.o
  CC       ui/util.o
  CC       util/dwarf-regs.o
  CC       ui/hist.o
  CC       util/unwind-libunwind-local.o
  CC       util/unwind-libunwind.o
  CC       util/zlib.o
  CC       util/lzma.o
  CC       util/demangle-java.o
  CC       util/demangle-rust.o
  CC       util/jitdump.o
  CC       ui/stdio/hist.o
  CC       util/genelf.o
  CC       util/genelf_debug.o
  LD       ui/libperf-in.o
  CC       scripts/python/Perf-Trace-Util/Context.o
  LD       scripts/python/Perf-Trace-Util/libperf-in.o
  LD       scripts/libperf-in.o
  CC       trace/beauty/clone.o
  CC       trace/beauty/fcntl.o
  CC       util/perf-hooks.o
  CC       trace/beauty/flock.o
  CC       trace/beauty/ioctl.o
  FLEX     util/parse-events-flex.c
  FLEX     util/pmu-flex.c
  CC       util/pmu-bison.o
  CC       trace/beauty/kcmp.o
  CC       trace/beauty/pkey_alloc.o
  CC       trace/beauty/prctl.o
  CC       util/expr-bison.o
  CC       trace/beauty/statx.o
  LD       trace/beauty/libperf-in.o
  CC       util/parse-events.o
  CC       util/parse-events-flex.o
  CC       util/pmu.o
  CC       util/pmu-flex.o
  LD       util/libperf-in.o
  LD       libperf-in.o
  AR       libperf.a
  LINK     perf
make: Leaving directory '/usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf'
2018-05-22 17:40:51 cd /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf
2018-05-22 17:40:51 mkdir -p /pkg
2018-05-22 17:40:51 mkdir -p /kbuild/obj/lkp/x86_64-fedora-25
2018-05-22 17:40:51 cp /pkg/linux/x86_64-fedora-25/gcc-7/32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/vmlinux.xz /tmp
2018-05-22 17:40:53 unxz -k /tmp/vmlinux.xz
2018-05-22 17:41:00 cp /tmp/vmlinux /kbuild/obj/lkp/x86_64-fedora-25
ignored_by_lkp: BPF filter
ignored_by_lkp: LLVM search and compile
ignored_by_lkp: Add vfs_getname probe to get syscall args filenames
ignored_by_lkp: Use vfs_getname probe to get syscall args filenames
ignored_by_lkp: Check open filename arg using perf trace + vfs_getname
ignored_by_lkp: builtin clang support
2018-05-22 17:41:01 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 1
 1: vmlinux symtab matches kallsyms                       : Ok
2018-05-22 17:41:02 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 2
 2: Detect openat syscall event                           : Ok
2018-05-22 17:41:02 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 3
 3: Detect openat syscall event on all cpus               : Ok
2018-05-22 17:41:02 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 4
 4: Read samples using the mmap interface                 : Ok
2018-05-22 17:41:02 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 5
 5: Test data source output                               : Ok
2018-05-22 17:41:02 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 6
 6: Parse event definition strings                        : FAILED!
2018-05-22 17:41:03 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 7
 7: Simple expression parser                              : Ok
2018-05-22 17:41:03 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 8
 8: PERF_RECORD_* events & perf_sample fields             : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 9
 9: Parse perf pmu format                                 : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 10
10: DSO data read                                         : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 11
11: DSO data cache                                        : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 12
12: DSO data reopen                                       : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 13
13: Roundtrip evsel->name                                 : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 14
14: Parse sched tracepoints fields                        : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 15
15: syscalls:sys_enter_openat event fields                : Ok
2018-05-22 17:41:05 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 16
16: Setup struct perf_event_attr                          : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 17
17: Match and link multiple hists                         : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 18
18: 'import perf' in python                               : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 19
19: Breakpoint overflow signal handler                    : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 20
20: Breakpoint overflow sampling                          : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 21
21: Breakpoint accounting                                 : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 22
22: Number of exit events of a simple workload            : Skip
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 23
23: Software clock events period values                   : Ok
2018-05-22 17:41:11 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 24
24: Object code reading                                   : FAILED!
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 25
25: Sample parsing                                        : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 26
26: Use a dummy software event to keep tracking           : Skip
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 27
27: Parse with no sample_id_all bit set                   : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 28
28: Filter hist entries                                   : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 29
29: Lookup mmap thread                                    : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 30
30: Share thread mg                                       : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 31
31: Sort output of hist entries                           : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 32
32: Cumulate child hist entries                           : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 33
33: Track with sched_switch                               : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 34
34: Filter fds with revents mask in a fdarray             : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 35
35: Add fd to a fdarray, making it autogrow               : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 36
36: kmod_path__parse                                      : Ok
2018-05-22 17:41:12 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 37
37: Thread map                                            : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 39
39: Session topology                                      : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 41
41: Synthesize thread map                                 : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 42
42: Remove thread map                                     : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 43
43: Synthesize cpu map                                    : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 44
44: Synthesize stat config                                : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 45
45: Synthesize stat                                       : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 46
46: Synthesize stat round                                 : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 47
47: Synthesize attr update                                : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 48
48: Event times                                           : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 49
49: Read backward ring buffer                             : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 50
50: Print cpu map                                         : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 51
51: Probe SDT events                                      : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 52
52: is_printable_array                                    : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 53
53: Print bitmap                                          : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 54
54: perf hooks                                            : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 56
56: unit_number__scnprintf                                : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 57
57: mem2node                                              : Ok
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 58
58: x86 rdpmc                                             : FAILED!
2018-05-22 17:41:13 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 59
59: Convert perf time to TSC                              : FAILED!
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 60
60: DWARF unwind                                          : Ok
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 61
61: x86 instruction decoder - new instructions            : Ok
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 62
62: probe libc's inet_pton & backtrace it with ping       : FAILED!
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 66
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 67
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 68
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 69
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 70
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 71
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 72
2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 73

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: [lkp-robot] [perf tests] 32a4debc7c: perf-sanity-tests.probe_libc's_inet_pton_&_backtrace_it_with_ping.fail
  2018-07-04  6:57   ` kernel test robot
  (?)
@ 2018-07-04 12:37   ` Sandipan Das
  -1 siblings, 0 replies; 14+ messages in thread
From: Sandipan Das @ 2018-07-04 12:37 UTC (permalink / raw)
  To: kernel test robot
  Cc: acme, jolsa, linux-kernel, ravi.bangoria, naveen.n.rao, tmricht, lkp

Hi Xiaolong,

On 07/04/2018 12:27 PM, kernel test robot wrote:
> 
> FYI, we noticed the following commit (built with gcc-7):
> 
> commit: 32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f ("[PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh")
> url: https://github.com/0day-ci/linux/commits/Sandipan-Das/perf-tests-Fix-regex-for-record-probe_libc_inet_pton-sh/20180521-130408
> 
> 
> in testcase: perf-sanity-tests
> with following parameters:
> 
> 	perf_compiler: gcc
> 
> 
> 
> on test machine: qemu-system-x86_64 -enable-kvm -cpu kvm64,+ssse3 -smp 2 -m 8G
> 
> caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
> 
> 
> 2018-05-22 17:41:14 sudo /usr/src/linux-perf-x86_64-fedora-25-32a4debc7c89ee5e29c0bbdfdd3ae0ce0e01057f/tools/perf/perf test 62
> 62: probe libc's inet_pton & backtrace it with ping       : FAILED!
> 
> 

This patch has the following dependencies which seem to be missing from your source tree.

7903a7086723 ("perf script: Show symbol offsets by default")
19610184693c ("perf script: Show virtual addresses instead of offsets")

Output without these patches:

  62: probe libc's inet_pton & backtrace it with ping       :
  --- start ---
  test child forked, pid 10323
  ping 10340 [001] 888647.764907: probe_libc:inet_pton: (7fe66cbc2220)
  132220 __GI___inet_pton (/usr/lib64/libc-2.25.so)
  FAIL: expected backtrace entry 1 ".*inet_pton\+0x[[:xdigit:]]+[[:space:]]\(/usr/lib64/libc-2.25.so|inlined\)$" got "132220 __GI___inet_pton (/usr/lib64/libc-2.25.so)"
  test child finished with -1
  ---- end ----
  probe libc's inet_pton & backtrace it with ping: FAILED!


Output with these patches:

  62: probe libc's inet_pton & backtrace it with ping       :
  --- start ---
  test child forked, pid 13155
  ping 13172 [000] 888783.582767: probe_libc:inet_pton: (7f2afe5ce220)
  7f2afe5ce220 __GI___inet_pton+0x0 (/usr/lib64/libc-2.25.so)
  7f2afe593ebd getaddrinfo+0x11d (/usr/lib64/libc-2.25.so)
  55b725fd8c71 main+0x891 (/usr/bin/ping)
  test child finished with 0
  ---- end ----
  probe libc's inet_pton & backtrace it with ping: Ok


--
With Regards,
Sandipan


^ permalink raw reply	[flat|nested] 14+ messages in thread

end of thread, other threads:[~2018-07-04 12:38 UTC | newest]

Thread overview: 14+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2018-05-18  7:24 [PATCH] perf tests: Fix regex for record+probe_libc_inet_pton.sh Sandipan Das
2018-05-18 10:21 ` Thomas-Mich Richter
2018-05-18 10:29   ` Sandipan Das
2018-05-18 11:09     ` Thomas-Mich Richter
2018-05-18 14:14       ` Arnaldo Carvalho de Melo
2018-05-18 18:24         ` Arnaldo Carvalho de Melo
2018-05-22  6:09         ` Thomas-Mich Richter
2018-05-18 19:21 ` Arnaldo Carvalho de Melo
2018-05-18 19:28   ` Sandipan Das
2018-05-18 19:29   ` Arnaldo Carvalho de Melo
2018-05-18 19:30     ` Arnaldo Carvalho de Melo
2018-07-04  6:57 ` [lkp-robot] [perf tests] 32a4debc7c: perf-sanity-tests.probe_libc's_inet_pton_&_backtrace_it_with_ping.fail kernel test robot
2018-07-04  6:57   ` kernel test robot
2018-07-04 12:37   ` Sandipan Das

This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.