Re: failing tests

From: Eray Aslan <eray.aslan_at_caf.com.tr>
Date: Sat, 25 Jun 2011 00:44:19 +0300

On Fri, Jun 24, 2011 at 10:28:40AM -0700, Murray S. Kucherawy wrote:
> What OS are you using?

Gentoo Linux

> Is a coredump produced? If so, can you use gdb to get a stack trace?

Well, no meaningful backtrace really, but:

Breakpoint 1 at 0x404900: file miltertest.c, line 417.
Starting program: /var/tmp/portage/mail-filter/opendkim-2.4.0/work/opendkim-2.4.0/miltertest/.libs/miltertest -s ./t-sign-rs-mixconf.lua
[Thread debugging using libthread_db enabled]

Breakpoint 1, mt_milter_read (fd=6, cmd=0x7fffffffd38f "", buf=0x7fffffffcf80 "", len=0x7fffffffd380) at miltertest.c:417
417 {
Continuing.

Breakpoint 1, mt_milter_read (fd=6, cmd=0x7fffffffdbff "c\006", buf=0x7fffffffd7d0 "localhost", len=0x7fffffffdbe8) at miltertest.c:417
417 {
Continuing.

Breakpoint 1, mt_milter_read (fd=6, cmd=0x7fffffffdbff "c\006", buf=0x7fffffffd7f0 "user_at_example.com", len=0x7fffffffdbf0) at miltertest.c:417
417 {
Continuing.

Breakpoint 1, mt_milter_read (fd=6, cmd=0x7fffffffd7bf "c\360\327\377\377\377\177", buf=0x7fffffffd3b0 "<recipient_at_example.com>",
    len=0x7fffffffd7b0) at miltertest.c:417
417 {
Continuing.

Breakpoint 1, mt_milter_read (fd=6, cmd=0x7fffffffdbff "c\006", buf=0x7fffffffd7f0 "From", len=0x7fffffffdbf0) at miltertest.c:417
417 {
Continuing.

Breakpoint 1, mt_milter_read (fd=6, cmd=0x7fffffffdbff "c\006", buf=0x7fffffffd7f0 "Date", len=0x7fffffffdbf0) at miltertest.c:417
417 {
Continuing.

Breakpoint 1, mt_milter_read (fd=6, cmd=0x7fffffffdbff "c\006", buf=0x7fffffffd7f0 "Subject", len=0x7fffffffdbf0) at miltertest.c:417
417 {
Continuing.

Breakpoint 1, mt_milter_read (fd=6, cmd=0x7fffffffdc1f "c\020\300`", buf=0x7fffffffd810 "-0800", len=0x7fffffffdc10) at miltertest.c:417
417 {
Continuing.

Breakpoint 1, mt_milter_read (fd=6, cmd=0x7fffffffdc0f "c\345ݙ\367\377\177", buf=0x7fffffffd800 "\001", len=0x7fffffffdc00) at miltertest.c:417
417 {
Continuing.

Breakpoint 1, mt_milter_read (fd=6, cmd=0x7fffffffdbff "", buf=0x7fffffffd7f0 "\360\303`", len=0x7fffffffdbf0) at miltertest.c:417
417 {

Program exited with code 01.
No stack.


Perhaps, strace can help (last 200 lines):

28570 23:33:37.543653 [ 7fd8c7a30fd0] close(3) = 0
28570 23:33:37.543693 [ 7fd8c7a3ac97] munmap(0x7fd8c9e59000, 4096) = 0
28570 23:33:37.543738 [ 7fd8c7a0d727] uname({sys="Linux", node="zptr-nb18", ...}) = 0
28570 23:33:37.543881 [ 7fd8c7ce0cd0] open("/dev/urandom", O_RDONLY|O_NOCTTY|O_NONBLOCK) = 3
28570 23:33:37.543937 [ 7fd8c7a303f4] fstat(3, {st_mode=S_IFCHR|0666, st_rdev=makedev(1, 9), ...}) = 0
28570 23:33:37.544000 [ 7fd8c7a351b8] poll([{fd=3, events=POLLIN}], 1, 10) = 1 ([{fd=3, revents=POLLIN}])
28570 23:33:37.544058 [ 7fd8c7ce0540] read(3, "\262h\313\211\364\236\31\231\1m\230\204\257\354W\323L\213T\25[G\305\2\245\234\334\1\340\237\224c", 32) = 32
28570 23:33:37.544140 [ 7fd8c7ce05a0] close(3) = 0
28570 23:33:37.544207 [ 7fd8c7a0eb47] getuid() = 0
28570 23:33:37.544361 [ 7fd8c7a3ef5a] socketpair(PF_FILE, SOCK_STREAM, 0, [3, 4]) = 0
28570 23:33:37.544416 [ 7fd8c7ce0608] fcntl(3, F_GETFL) = 0x2 (flags O_RDWR)
28570 23:33:37.544457 [ 7fd8c7ce0608] fcntl(3, F_SETFL, O_RDWR|O_NONBLOCK) = 0
28570 23:33:37.544497 [ 7fd8c7ce0608] fcntl(4, F_GETFL) = 0x2 (flags O_RDWR)
28570 23:33:37.544537 [ 7fd8c7ce0608] fcntl(4, F_SETFL, O_RDWR|O_NONBLOCK) = 0
28570 23:33:37.544578 [ 7fd8c7a3ef5a] socketpair(PF_FILE, SOCK_STREAM, 0, [5, 6]) = 0
28570 23:33:37.544626 [ 7fd8c7ce0608] fcntl(5, F_GETFL) = 0x2 (flags O_RDWR)
28570 23:33:37.544666 [ 7fd8c7ce0608] fcntl(5, F_SETFL, O_RDWR|O_NONBLOCK) = 0
28570 23:33:37.544706 [ 7fd8c7ce0608] fcntl(6, F_GETFL) = 0x2 (flags O_RDWR)
28570 23:33:37.544745 [ 7fd8c7ce0608] fcntl(6, F_SETFL, O_RDWR|O_NONBLOCK) = 0
28570 23:33:37.544812 [ 7fd8c7a3ac6a] mmap(NULL, 266240, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fd8c9df5000
28570 23:33:37.545447 [ 7fd8c7a366fa] brk(0x6f6000) = 0x6f6000
28570 23:33:37.545730 [ 7fd8c7a3ef27] socket(PF_FILE, SOCK_STREAM, 0) = 7
28570 23:33:37.545786 [ 7fd8c7ce07f0] connect(7, {sa_family=AF_FILE, path="/var/tmp/portage/mail-filter/opendkim-2.4.0/work/opendkim-2.4.0/opendkim/tests/t-sign-rs-mixconf.sock"}, 110) = -1 ECONNREFUSED (Connection refused)
28570 23:33:37.545888 [ 7fd8c7ce05a0] close(7) = 0
28570 23:33:37.545954 [ 7fd8c7a32987] unlink("/var/tmp/portage/mail-filter/opendkim-2.4.0/work/opendkim-2.4.0/opendkim/tests/t-sign-rs-mixconf.sock") = 0
28570 23:33:37.546076 [ 7fd8c7a3ef27] socket(PF_FILE, SOCK_STREAM, 0) = 7
28570 23:33:37.546125 [ 7fd8c7ce0608] fcntl(7, F_GETFD) = 0
28570 23:33:37.546165 [ 7fd8c7ce0608] fcntl(7, F_SETFD, FD_CLOEXEC) = 0
28570 23:33:37.546208 [ 7fd8c7a3ea77] bind(7, {sa_family=AF_FILE, path="/var/tmp/portage/mail-filter/opendkim-2.4.0/work/opendkim-2.4.0/opendkim/tests/t-sign-rs-mixconf.sock"}, 110) = 0
28570 23:33:37.546295 [ 7fd8c7a3eb97] listen(7, 128) = 0
28570 23:33:37.546350 [ 7fd8c7cde75a] rt_sigprocmask(SIG_BLOCK, [HUP INT USR1 TERM], NULL, 8) = 0
28570 23:33:37.549759 [ 7fd8c7a3ac6a] mmap(NULL, 8392704, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7fd8c549b000
28570 23:33:37.549877 [ 7fd8c7a3acc7] mprotect(0x7fd8c549b000, 4096, PROT_NONE) = 0
28570 23:33:37.549947 [ 7fd8c7a3de41] clone(child_stack=0x7fd8c5c9aff0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, parent_tidptr=0x7fd8c5c9b9d0, tls=0x7fd8c5c9b700, child_tidptr=0x7fd8c5c9b9d0) = 28584
28584 23:33:37.550030 [ 7fd8c7cd8ba9] set_robust_list(0x7fd8c5c9b9e0, 0x18 <unfinished ...>
28570 23:33:37.550055 [ 7fd8c799e458] rt_sigaction(SIGPIPE, {SIG_IGN, [PIPE], SA_RESTORER|SA_RESTART, 0x7fd8c799e3d0}, <unfinished ...>
28584 23:33:37.550091 [ 7fd8c7cd8ba9] <... set_robust_list resumed> ) = 0
28570 23:33:37.550109 [ 7fd8c799e458] <... rt_sigaction resumed> {SIG_DFL, [], 0}, 8) = 0
28584 23:33:37.550150 [ 7fd8c7ce1157] rt_sigtimedwait([USR1], NULL, NULL, 8 <unfinished ...>
28570 23:33:37.550180 [ 7fd8c7cde75a] rt_sigprocmask(SIG_BLOCK, [HUP INT TERM], NULL, 8) = 0
28570 23:33:37.550232 [ 7fd8c7a3ac6a] mmap(NULL, 8392704, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7fd8c4c9a000
28570 23:33:37.550286 [ 7fd8c7a3acc7] mprotect(0x7fd8c4c9a000, 4096, PROT_NONE) = 0
28570 23:33:37.550336 [ 7fd8c7a3de41] clone(child_stack=0x7fd8c5499ff0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, parent_tidptr=0x7fd8c549a9d0, tls=0x7fd8c549a700, child_tidptr=0x7fd8c549a9d0) = 28585
28585 23:33:37.550394 [ 7fd8c7cd8ba9] set_robust_list(0x7fd8c549a9e0, 0x18 <unfinished ...>
28570 23:33:37.550417 [ 7fd8c7a37683] select(8, [7], NULL, [7], {5, 0} <unfinished ...>
28585 23:33:37.550463 [ 7fd8c7cd8ba9] <... set_robust_list resumed> ) = 0
28585 23:33:37.550500 [ 7fd8c7ce1157] rt_sigtimedwait([HUP INT TERM], NULL, NULL, 8 <unfinished ...>
28569 23:33:37.592397 [ 7f7f2d0bec60] <... nanosleep resumed> NULL) = 0
28569 23:33:37.592438 [ 7f7f2d0efab0] connect(3, {sa_family=AF_FILE, path="/var/tmp/portage/mail-filter/opendkim-2.4.0/work/opendkim-2.4.0/opendkim/tests/t-sign-rs-mixconf.sock"}, 110) = 0
28570 23:33:37.592518 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [7], left {4, 957958})
28569 23:33:37.592551 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0\rO", 5}, {"\0\0\0\6\0\0\1\377\0\37\377\377", 12}], 2 <unfinished ...>
28570 23:33:37.592584 [ 7fd8c7ce07ad] accept(7, <unfinished ...>
28569 23:33:37.592598 [ 7f7f2d0e7c81] <... writev resumed> ) = 17
28570 23:33:37.592610 [ 7fd8c7ce07ad] <... accept resumed> {sa_family=AF_FILE, NULL}, [2]) = 8
28569 23:33:37.592629 [ 7f7f2d0e8663] select(4, [3], NULL, NULL, {10, 0} <unfinished ...>
28570 23:33:37.592649 [ 7fd8c7a3eeca] setsockopt(8, SOL_SOCKET, SO_KEEPALIVE, [1], 4) = 0
28570 23:33:37.592697 [ 7fd8c7a3ac6a] mmap(NULL, 8392704, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7fd8c4499000
28570 23:33:37.592744 [ 7fd8c7a3acc7] mprotect(0x7fd8c4499000, 4096, PROT_NONE) = 0
28570 23:33:37.592797 [ 7fd8c7a3de41] clone(child_stack=0x7fd8c4c98ff0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, parent_tidptr=0x7fd8c4c999d0, tls=0x7fd8c4c99700, child_tidptr=0x7fd8c4c999d0) = 28586
28570 23:33:37.592870 [ 7fd8c7a37683] select(8, [7], NULL, [7], {5, 0} <unfinished ...>
28586 23:33:37.592905 [ 7fd8c7cd8ba9] set_robust_list(0x7fd8c4c999e0, 0x18) = 0
28586 23:33:37.592983 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0}) = 1 (in [8], left {7209, 999997})
28586 23:33:37.593054 [ 7fd8c7ce055d] read(8, "\0\0\0\rO", 5) = 5
28586 23:33:37.593110 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7209, 999997}) = 1 (in [8], left {7209, 999994})
28586 23:33:37.593166 [ 7fd8c7ce055d] read(8, "\0\0\0\6\0\0\1\377\0\37\377\377", 12) = 12
28586 23:33:37.593243 [ 7fd8c7a37683] select(9, NULL, [8], NULL, {7209, 999994}) = 1 (out [8], left {7209, 999991})
28586 23:33:37.593306 [ 7fd8c7a36d01] writev(8, [{"\0\0\0\rO", 5}, {"\0\0\0\6\0\0\1\21\0\20\7\2", 12}], 2) = 17
28569 23:33:37.593358 [ 7f7f2d0e8663] <... select resumed> ) = 1 (in [3], left {9, 999300})
28586 23:33:37.593386 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0} <unfinished ...>
28569 23:33:37.593407 [ 7f7f2d0e2030] read(3, "\0\0\0\rO", 5) = 5
28569 23:33:37.593452 [ 7f7f2d0e2030] read(3, "\0\0\0\6\0\0\1\21\0\20\7\2", 12) = 12
28569 23:33:37.593509 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0\30C", 5}, {"localhost\000409127.0.0.1\0", 23}], 2 <unfinished ...>
28586 23:33:37.593546 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [8], left {7209, 999863})
28569 23:33:37.593570 [ 7f7f2d0e7c81] <... writev resumed> ) = 28
28586 23:33:37.593588 [ 7fd8c7ce055d] read(8, <unfinished ...>
28569 23:33:37.593606 [ 7f7f2d0e8663] select(4, [3], NULL, NULL, {10, 0} <unfinished ...>
28586 23:33:37.593627 [ 7fd8c7ce055d] <... read resumed> "\0\0\0\30C", 5) = 5
28586 23:33:37.593656 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7209, 999863}) = 1 (in [8], left {7209, 999861})
28586 23:33:37.593711 [ 7fd8c7ce055d] read(8, "localhost\000409127.0.0.1\0", 23) = 23
28586 23:33:37.593771 [ 7fd8c7a37683] select(9, NULL, [8], NULL, {7209, 999861}) = 1 (out [8], left {7209, 999858})
28586 23:33:37.593850 [ 7fd8c7a36d01] writev(8, [{"\0\0\0\1c", 5}], 1) = 5
28586 23:33:37.593905 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0} <unfinished ...>
28569 23:33:37.593939 [ 7f7f2d0e8663] <... select resumed> ) = 1 (in [3], left {9, 999697})
28569 23:33:37.593975 [ 7f7f2d0e2030] read(3, "\0\0\0\1c", 5) = 5
28569 23:33:37.594036 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0\26D", 5}, {"Mi\0t-sign-rs-mixconf\0", 21}], 2 <unfinished ...>
28586 23:33:37.594105 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [8], left {7209, 999827})
28569 23:33:37.594130 [ 7f7f2d0e7c81] <... writev resumed> ) = 26
28586 23:33:37.594148 [ 7fd8c7ce055d] read(8, "\0\0\0\26D", 5) = 5
28569 23:33:37.594188 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0\22M", 5}, {"user_at_example.com\0", 17}], 2 <unfinished ...>
28586 23:33:37.594217 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7209, 999827} <unfinished ...>
28569 23:33:37.594237 [ 7f7f2d0e7c81] <... writev resumed> ) = 22
28586 23:33:37.594255 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [8], left {7209, 999824})
28569 23:33:37.594287 [ 7f7f2d0e8663] select(4, [3], NULL, NULL, {10, 0} <unfinished ...>
28586 23:33:37.594313 [ 7fd8c7ce055d] read(8, "Mi\0t-sign-rs-mixconf\0", 21) = 21
28586 23:33:37.594375 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0}) = 1 (in [8], left {7209, 999997})
28586 23:33:37.594444 [ 7fd8c7ce055d] read(8, "\0\0\0\22M", 5) = 5
28586 23:33:37.594504 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7209, 999997}) = 1 (in [8], left {7209, 999994})
28586 23:33:37.594572 [ 7fd8c7ce055d] read(8, "user_at_example.com\0", 17) = 17
28586 23:33:37.594645 [ 7fd8c7a37683] select(9, NULL, [8], NULL, {7209, 999994}) = 1 (out [8], left {7209, 999991})
28586 23:33:37.594715 [ 7fd8c7a36d01] writev(8, [{"\0\0\0\1c", 5}], 1) = 5
28569 23:33:37.594768 [ 7f7f2d0e8663] <... select resumed> ) = 1 (in [3], left {9, 999562})
28586 23:33:37.594815 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0} <unfinished ...>
28569 23:33:37.594860 [ 7f7f2d0e2030] read(3, "\0\0\0\1c", 5) = 5
28569 23:33:37.594971 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0\31R", 5}, {"<recipient_at_example.com>\0", 24}], 2 <unfinished ...>
28586 23:33:37.595054 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [8], left {7209, 999797})
28569 23:33:37.595082 [ 7f7f2d0e7c81] <... writev resumed> ) = 29
28586 23:33:37.595104 [ 7fd8c7ce055d] read(8, "\0\0\0\31R", 5) = 5
28569 23:33:37.595152 [ 7f7f2d0e8663] select(4, [3], NULL, NULL, {10, 0} <unfinished ...>
28586 23:33:37.595180 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7209, 999797}) = 1 (in [8], left {7209, 999794})
28586 23:33:37.595245 [ 7fd8c7ce055d] read(8, "<recipient_at_example.com>\0", 24) = 24
28586 23:33:37.595314 [ 7fd8c7a37683] select(9, NULL, [8], NULL, {7209, 999794}) = 1 (out [8], left {7209, 999791})
28586 23:33:37.595383 [ 7fd8c7a36d01] writev(8, [{"\0\0\0\1c", 5}], 1) = 5
28569 23:33:37.595437 [ 7f7f2d0e8663] <... select resumed> ) = 1 (in [3], left {9, 999759})
28586 23:33:37.595468 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0} <unfinished ...>
28569 23:33:37.595494 [ 7f7f2d0e2030] read(3, "\0\0\0\1c", 5) = 5
28569 23:33:37.595548 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0\30L", 5}, {"From\0 user_at_example.com\0", 23}], 2 <unfinished ...>
28586 23:33:37.595592 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [8], left {7209, 999906})
28569 23:33:37.595619 [ 7f7f2d0e7c81] <... writev resumed> ) = 28
28586 23:33:37.595642 [ 7fd8c7ce055d] read(8, <unfinished ...>
28569 23:33:37.595662 [ 7f7f2d0e8663] select(4, [3], NULL, NULL, {10, 0} <unfinished ...>
28586 23:33:37.595687 [ 7fd8c7ce055d] <... read resumed> "\0\0\0\30L", 5) = 5
28586 23:33:37.595722 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7209, 999906}) = 1 (in [8], left {7209, 999903})
28586 23:33:37.595811 [ 7fd8c7ce055d] read(8, "From\0 user_at_example.com\0", 23) = 23
28586 23:33:37.595889 [ 7fd8c7a37683] select(9, NULL, [8], NULL, {7209, 999903}) = 1 (out [8], left {7209, 999899})
28586 23:33:37.595959 [ 7fd8c7a36d01] writev(8, [{"\0\0\0\1c", 5}], 1) = 5
28586 23:33:37.596025 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0} <unfinished ...>
28569 23:33:37.596073 [ 7f7f2d0e8663] <... select resumed> ) = 1 (in [3], left {9, 999625})
28569 23:33:37.596149 [ 7f7f2d0e2030] read(3, "\0\0\0\1c", 5) = 5
28569 23:33:37.596208 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0'L", 5}, {"Date\0 Tue, 22 Dec 2009 13:04:12 "..., 38}], 2 <unfinished ...>
28586 23:33:37.596267 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [8], left {7209, 999791})
28569 23:33:37.596296 [ 7f7f2d0e7c81] <... writev resumed> ) = 43
28586 23:33:37.596319 [ 7fd8c7ce055d] read(8, <unfinished ...>
28569 23:33:37.596340 [ 7f7f2d0e8663] select(4, [3], NULL, NULL, {10, 0} <unfinished ...>
28586 23:33:37.596365 [ 7fd8c7ce055d] <... read resumed> "\0\0\0'L", 5) = 5
28586 23:33:37.596400 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7209, 999791}) = 1 (in [8], left {7209, 999788})
28586 23:33:37.596468 [ 7fd8c7ce055d] read(8, "Date\0 Tue, 22 Dec 2009 13:04:12 "..., 38) = 38
28586 23:33:37.596537 [ 7fd8c7a37683] select(9, NULL, [8], NULL, {7209, 999788}) = 1 (out [8], left {7209, 999785})
28586 23:33:37.596606 [ 7fd8c7a36d01] writev(8, [{"\0\0\0\1c", 5}], 1) = 5
28569 23:33:37.596659 [ 7f7f2d0e8663] <... select resumed> ) = 1 (in [3], left {9, 999725})
28586 23:33:37.596691 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0} <unfinished ...>
28569 23:33:37.596718 [ 7f7f2d0e2030] read(3, "\0\0\0\1c", 5) = 5
28569 23:33:37.596774 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0\27L", 5}, {"Subject\0 Signing test\0", 22}], 2 <unfinished ...>
28586 23:33:37.596896 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [8], left {7209, 999825})
28569 23:33:37.596925 [ 7f7f2d0e7c81] <... writev resumed> ) = 27
28586 23:33:37.596948 [ 7fd8c7ce055d] read(8, "\0\0\0\27L", 5) = 5
28569 23:33:37.596998 [ 7f7f2d0e8663] select(4, [3], NULL, NULL, {10, 0} <unfinished ...>
28586 23:33:37.597026 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7209, 999825}) = 1 (in [8], left {7209, 999822})
28586 23:33:37.597091 [ 7fd8c7ce055d] read(8, "Subject\0 Signing test\0", 22) = 22
28586 23:33:37.597159 [ 7fd8c7a37683] select(9, NULL, [8], NULL, {7209, 999822}) = 1 (out [8], left {7209, 999819})
28586 23:33:37.597228 [ 7fd8c7a36d01] writev(8, [{"\0\0\0\1c", 5}], 1) = 5
28586 23:33:37.597292 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0} <unfinished ...>
28569 23:33:37.597320 [ 7f7f2d0e8663] <... select resumed> ) = 1 (in [3], left {9, 999763})
28569 23:33:37.597359 [ 7f7f2d0e2030] read(3, "\0\0\0\1c", 5) = 5
28569 23:33:37.597418 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0\1N", 5}], 1 <unfinished ...>
28586 23:33:37.597456 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [8], left {7209, 999870})
28569 23:33:37.597484 [ 7f7f2d0e7c81] <... writev resumed> ) = 5
28586 23:33:37.597506 [ 7fd8c7ce055d] read(8, <unfinished ...>
28569 23:33:37.597527 [ 7f7f2d0e8663] select(4, [3], NULL, NULL, {10, 0} <unfinished ...>
28586 23:33:37.597552 [ 7fd8c7ce055d] <... read resumed> "\0\0\0\1N", 5) = 5
28586 23:33:37.597667 [ 7fd8c7a366fa] brk(0x717000) = 0x717000
28586 23:33:37.598014 [ 7fd8c7ce0ced] open("./testkey.private", O_RDONLY) = 9
28586 23:33:37.598088 [ 7fd8c7a303f4] fstat(9, {st_mode=S_IFREG|0644, st_size=887, ...}) = 0
28586 23:33:37.598161 [ 7fd8c7ce055d] read(9, "-----BEGIN RSA PRIVATE KEY-----\n"..., 887) = 887
28586 23:33:37.598221 [ 7fd8c7ce05bd] close(9) = 0
28586 23:33:37.598509 [ 7fd8c7a37683] select(9, NULL, [8], NULL, {7209, 999870}) = 1 (out [8], left {7209, 999866})
28586 23:33:37.598586 [ 7fd8c7a36d01] writev(8, [{"\0\0\0\1c", 5}], 1) = 5
28586 23:33:37.598652 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0} <unfinished ...>
28569 23:33:37.598703 [ 7f7f2d0e8663] <... select resumed> ) = 1 (in [3], left {9, 998863})
28569 23:33:37.598742 [ 7f7f2d0e2030] read(3, "\0\0\0\1c", 5) = 5
28569 23:33:37.598885 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0\22B", 5}, {"This is a test!\r\n", 17}], 2 <unfinished ...>
28586 23:33:37.598970 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [8], left {7209, 999714})
28569 23:33:37.598998 [ 7f7f2d0e7c81] <... writev resumed> ) = 22
28586 23:33:37.599020 [ 7fd8c7ce055d] read(8, "\0\0\0\22B", 5) = 5
28569 23:33:37.599069 [ 7f7f2d0e8663] select(4, [3], NULL, NULL, {10, 0} <unfinished ...>
28586 23:33:37.599096 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7209, 999714}) = 1 (in [8], left {7209, 999711})
28586 23:33:37.599174 [ 7fd8c7ce055d] read(8, "This is a test!\r\n", 17) = 17
28586 23:33:37.599246 [ 7fd8c7a37683] select(9, NULL, [8], NULL, {7209, 999711}) = 1 (out [8], left {7209, 999708})
28586 23:33:37.599314 [ 7fd8c7a36d01] writev(8, [{"\0\0\0\1c", 5}], 1) = 5
28586 23:33:37.599377 [ 7fd8c7a37683] select(9, [8], NULL, [8], {7210, 0} <unfinished ...>
28569 23:33:37.599404 [ 7f7f2d0e8663] <... select resumed> ) = 1 (in [3], left {9, 999748})
28569 23:33:37.599443 [ 7f7f2d0e2030] read(3, "\0\0\0\1c", 5) = 5
28569 23:33:37.599531 [ 7f7f2d0e7c81] writev(3, [{"\0\0\0\1E", 5}], 1 <unfinished ...>
28586 23:33:37.599584 [ 7fd8c7a37683] <... select resumed> ) = 1 (in [8], left {7209, 999828})
28569 23:33:37.599620 [ 7f7f2d0e7c81] <... writev resumed> ) = 5
28586 23:33:37.599665 [ 7fd8c7ce055d] read(8, <unfinished ...>
28569 23:33:37.599701 [ 7f7f2d0e8663] select(4, [3], NULL, NULL, {10, 0} <unfinished ...>
28586 23:33:37.599727 [ 7fd8c7ce055d] <... read resumed> "\0\0\0\1E", 5) = 5
28586 23:33:37.600032 [ 7fd8c7a75edf] --- SIGSEGV (Segmentation fault) _at_ 0 (0) ---
28584 23:33:37.606865 [????????????????] +++ killed by SIGSEGV (core dumped) +++
28585 23:33:37.607351 [????????????????] +++ killed by SIGSEGV (core dumped) +++
28570 23:33:37.607370 [????????????????] +++ killed by SIGSEGV (core dumped) +++
28569 23:33:37.607381 [ 7f7f2d0e8663] <... select resumed> ) = 1 (in [3], left {9, 992362})
28569 23:33:37.607468 [ 7f7f2d0e8663] --- SIGCHLD (Child exited) _at_ 0 (0) ---
28569 23:33:37.607498 [ 7f7f2d0e2030] read(3, "", 5) = 0
28569 23:33:37.607575 [ 7f7f2d0e2090] write(2, "miltertest: read(3): returned 0,"..., 44) = 44
28569 23:33:37.607737 [ 7f7f2d0e2090] write(2, "miltertest: ./t-sign-rs-mixconf."..., 92) = 92
28569 23:33:37.607957 [ 7f7f2d04f517] kill(28570, SIGTERM) = 0
28569 23:33:37.608023 [ 7f7f2d0be7c4] wait4(-1, [{WIFSIGNALED(s) && WTERMSIG(s) == SIGSEGV && WCOREDUMP(s)}], 0, NULL) = 28570
28569 23:33:37.608096 [ 7f7f2d0e2090] write(2, "miltertest: filter process died "..., 47) = 47
28569 23:33:37.608257 [ 7f7f2d0bf018] exit_group(1) = ?
Received on Fri Jun 24 2011 - 21:44:40 PST

This archive was generated by hypermail 2.3.0 : Mon Oct 29 2012 - 23:20:18 PST