failing test on master

Matzi Kratzi matzikratzi at gmail.com
Mon Aug 8 05:24:50 UTC 2016


Hi,
I am on a updated (yesterday) ubuntu 14.04 LTS and Intel® Core™ i3-5010U.

I followed the instructions on
https://github.com/mozilla/rr/wiki/Building-And-Installing (also yesterday)
and ended up with commit:

commit 3db52cd59894373bf9979bbda28a378ba8d4f55b
Author: Robert O'Callahan <robert at ocallahan.org>
Date:   Thu Aug 4 20:07:14 2016 +1200

    Extra logging


rr builds and a vast majority of the tests pass, but four of them fail:
783, 784, 1655 and 1656.

Is this expected on my HW and SW?

Kind regards
Mats

PS Details:
783/1744 Testing: fork_exec_info_thr
783/1744 Test: fork_exec_info_thr
Command: "/bin/bash"
"/home/matsj/src/rr/rr/src/test/fork_exec_info_thr.run" "-b"
"/home/matsj/src/rr/rr" "/home/matsj/src/rr/obj" "fork_exec_info_thr"
Directory: /home/matsj/src/rr/obj
"fork_exec_info_thr" start time: Aug 07 08:47 CEST
Output:
----------------------------------------------------------
Targeting recorded pid 29247 at event 51 ...
Test 'fork_exec_info_thr' PASSED
FAILED: expecting "atomic_printf"
exception: Timeout exceeded.
<pexpect.spawn object at 0x2b47b15eebd0>
version: 3.1
command: /home/matsj/src/rr/obj/bin/rr
args: ['/home/matsj/src/rr/obj/bin/rr', '--suppress-environment-warnings',
'--check-cached-mmaps', '--fatal-errors', '-M', 'replay', '-x',
'/home/matsj/src/rr/rr/src/test/test_setup.gdb', '-p', '29247', '-g', '51']
searcher: <pexpect.searcher_re object at 0x2b47b15eec50>
buffer (last 100 chars): '0x0000000000000001 in ?? ()\r\n#2
0x00007ffccc02b0b1 in ?? ()\r\n#3  0x0000000000000000 in ?? ()\r\n(rr) '
before (last 100 chars): '0x0000000000000001 in ?? ()\r\n#2
0x00007ffccc02b0b1 in ?? ()\r\n#3  0x0000000000000000 in ?? ()\r\n(rr) '
after: <class 'pexpect.TIMEOUT'>
match: None
match_index: None
exitstatus: None
flag_eof: False
pid: 29284
child_fd: 6
closed: False
timeout: 100
delimiter: <class 'pexpect.EOF'>
logfile: <open file 'gdb_rr.log', mode 'w' at 0x2b47b15989c0>
logfile_read: None
logfile_send: None
maxread: 2000
ignorecase: False
searchwindowsize: None
delaybeforesend: 0.05
delayafterclose: 0.1
delayafterterminate: 0.1
Test 'fork_exec_info_thr' FAILED: debug script failed
Test fork_exec_info_thr failed, leaving behind
/tmp/rr-test-fork_exec_info_thr-XEXsOdcND
To replay the failed test, run
  _RR_TRACE_DIR=/tmp/rr-test-fork_exec_info_thr-XEXsOdcND rr replay
<end of output>
Test time = 102.35 sec
----------------------------------------------------------
Test Fail Reason:
Error regular expression found in output. Regex=[FAILED]
"fork_exec_info_thr" end time: Aug 07 08:49 CEST
"fork_exec_info_thr" time elapsed: 00:01:42
----------------------------------------------------------

784/1744 Testing: fork_exec_info_thr-no-syscallbuf
784/1744 Test: fork_exec_info_thr-no-syscallbuf
Command: "/bin/bash"
"/home/matsj/src/rr/rr/src/test/fork_exec_info_thr.run" "-n"
"/home/matsj/src/rr/rr" "/home/matsj/src/rr/obj" "fork_exec_info_thr"
Directory: /home/matsj/src/rr/obj
"fork_exec_info_thr-no-syscallbuf" start time: Aug 07 08:49 CEST
Output:
----------------------------------------------------------
Targeting recorded pid 29313 at event 47 ...
Test 'fork_exec_info_thr' PASSED
FAILED: expecting "atomic_printf"
exception: Timeout exceeded.
<pexpect.spawn object at 0x2ab3be95fbd0>
version: 3.1
command: /home/matsj/src/rr/obj/bin/rr
args: ['/home/matsj/src/rr/obj/bin/rr', '--suppress-environment-warnings',
'--check-cached-mmaps', '--fatal-errors', '-M', 'replay', '-x',
'/home/matsj/src/rr/rr/src/test/test_setup.gdb', '-p', '29313', '-g', '47']
searcher: <pexpect.searcher_re object at 0x2ab3be95fc50>
buffer (last 100 chars): '0x0000000000000001 in ?? ()\r\n#2
0x00007ffe8b4800c6 in ?? ()\r\n#3  0x0000000000000000 in ?? ()\r\n(rr) '
before (last 100 chars): '0x0000000000000001 in ?? ()\r\n#2
0x00007ffe8b4800c6 in ?? ()\r\n#3  0x0000000000000000 in ?? ()\r\n(rr) '
after: <class 'pexpect.TIMEOUT'>
match: None
match_index: None
exitstatus: None
flag_eof: False
pid: 29350
child_fd: 6
closed: False
timeout: 100
delimiter: <class 'pexpect.EOF'>
logfile: <open file 'gdb_rr.log', mode 'w' at 0x2ab3be9099c0>
logfile_read: None
logfile_send: None
maxread: 2000
ignorecase: False
searchwindowsize: None
delaybeforesend: 0.05
delayafterclose: 0.1
delayafterterminate: 0.1
Test 'fork_exec_info_thr' FAILED: debug script failed
Test fork_exec_info_thr failed, leaving behind
/tmp/rr-test-fork_exec_info_thr-UVVPCyMef
To replay the failed test, run
  _RR_TRACE_DIR=/tmp/rr-test-fork_exec_info_thr-UVVPCyMef rr replay
<end of output>
Test time = 102.26 sec
----------------------------------------------------------
Test Fail Reason:
Error regular expression found in output. Regex=[FAILED]
"fork_exec_info_thr-no-syscallbuf" end time: Aug 07 08:50 CEST
"fork_exec_info_thr-no-syscallbuf" time elapsed: 00:01:42
----------------------------------------------------------


1655/1744 Testing: fork_exec_info_thr-32
1655/1744 Test: fork_exec_info_thr-32
Command: "/bin/bash"
"/home/matsj/src/rr/rr/src/test/fork_exec_info_thr.run" "-b"
"/home/matsj/src/rr/rr" "/home/matsj/src/rr/obj" "fork_exec_info_thr_32"
Directory: /home/matsj/src/rr/obj
"fork_exec_info_thr-32" start time: Aug 07 09:20 CEST
Output:
----------------------------------------------------------
Targeting recorded pid 7954 at event 82 ...
Test 'fork_exec_info_thr_32' PASSED
FAILED: expecting "atomic_printf"
exception: Timeout exceeded.
<pexpect.spawn object at 0x2b4115b65bd0>
version: 3.1
command: /home/matsj/src/rr/obj/bin/rr
args: ['/home/matsj/src/rr/obj/bin/rr', '--suppress-environment-warnings',
'--check-cached-mmaps', '--fatal-errors', '-M', 'replay', '-x',
'/home/matsj/src/rr/rr/src/test/test_setup.gdb', '-p', '7954', '-g', '82']
searcher: <pexpect.searcher_re object at 0x2b4115b65c50>
buffer (last 100 chars): ' bt\r\n#0  0x5555e0d0 in ?? () from
/lib/ld-linux.so.2\r\n(rr) '
before (last 100 chars): ' bt\r\n#0  0x5555e0d0 in ?? () from
/lib/ld-linux.so.2\r\n(rr) '
after: <class 'pexpect.TIMEOUT'>
match: None
match_index: None
exitstatus: None
flag_eof: False
pid: 7991
child_fd: 6
closed: False
timeout: 100
delimiter: <class 'pexpect.EOF'>
logfile: <open file 'gdb_rr.log', mode 'w' at 0x2b4115b0f9c0>
logfile_read: None
logfile_send: None
maxread: 2000
ignorecase: False
searchwindowsize: None
delaybeforesend: 0.05
delayafterclose: 0.1
delayafterterminate: 0.1
Test 'fork_exec_info_thr_32' FAILED: debug script failed
Test fork_exec_info_thr_32 failed, leaving behind
/tmp/rr-test-fork_exec_info_thr_32-sFxLpc6p0
To replay the failed test, run
  _RR_TRACE_DIR=/tmp/rr-test-fork_exec_info_thr_32-sFxLpc6p0 rr replay
<end of output>
Test time = 102.29 sec
----------------------------------------------------------
Test Fail Reason:
Error regular expression found in output. Regex=[FAILED]
"fork_exec_info_thr-32" end time: Aug 07 09:21 CEST
"fork_exec_info_thr-32" time elapsed: 00:01:42
----------------------------------------------------------

1656/1744 Testing: fork_exec_info_thr-32-no-syscallbuf
1656/1744 Test: fork_exec_info_thr-32-no-syscallbuf
Command: "/bin/bash"
"/home/matsj/src/rr/rr/src/test/fork_exec_info_thr.run" "-n"
"/home/matsj/src/rr/rr" "/home/matsj/src/rr/obj" "fork_exec_info_thr_32"
Directory: /home/matsj/src/rr/obj
"fork_exec_info_thr-32-no-syscallbuf" start time: Aug 07 09:21 CEST
Output:
----------------------------------------------------------
Targeting recorded pid 8027 at event 79 ...
Test 'fork_exec_info_thr_32' PASSED
FAILED: expecting "atomic_printf"
exception: Timeout exceeded.
<pexpect.spawn object at 0x2b2870946bd0>
version: 3.1
command: /home/matsj/src/rr/obj/bin/rr
args: ['/home/matsj/src/rr/obj/bin/rr', '--suppress-environment-warnings',
'--check-cached-mmaps', '--fatal-errors', '-M', 'replay', '-x',
'/home/matsj/src/rr/rr/src/test/test_setup.gdb', '-p', '8027', '-g', '79']
searcher: <pexpect.searcher_re object at 0x2b2870946c50>
buffer (last 100 chars): ' bt\r\n#0  0x556130d0 in ?? () from
/lib/ld-linux.so.2\r\n(rr) '
before (last 100 chars): ' bt\r\n#0  0x556130d0 in ?? () from
/lib/ld-linux.so.2\r\n(rr) '
after: <class 'pexpect.TIMEOUT'>
match: None
match_index: None
exitstatus: None
flag_eof: False
pid: 8064
child_fd: 6
closed: False
timeout: 100
delimiter: <class 'pexpect.EOF'>
logfile: <open file 'gdb_rr.log', mode 'w' at 0x2b28708f09c0>
logfile_read: None
logfile_send: None
maxread: 2000
ignorecase: False
searchwindowsize: None
delaybeforesend: 0.05
delayafterclose: 0.1
delayafterterminate: 0.1
Test 'fork_exec_info_thr_32' FAILED: debug script failed
Test fork_exec_info_thr_32 failed, leaving behind
/tmp/rr-test-fork_exec_info_thr_32-Jpi1PRgxu
To replay the failed test, run
  _RR_TRACE_DIR=/tmp/rr-test-fork_exec_info_thr_32-Jpi1PRgxu rr replay
<end of output>
Test time = 102.28 sec
----------------------------------------------------------
Test Fail Reason:
Error regular expression found in output. Regex=[FAILED]
"fork_exec_info_thr-32-no-syscallbuf" end time: Aug 07 09:23 CEST
"fork_exec_info_thr-32-no-syscallbuf" time elapsed: 00:01:42
----------------------------------------------------------
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://mail.mozilla.org/pipermail/rr-dev/attachments/20160808/a4fc3cb3/attachment.html>


More information about the rr-dev mailing list