[Devel] Problem with retransmissions when using TCP as a transport in Sipsak

Tavis P tavis.lists at galaxytelecom.net
Fri Jun 30 22:45:22 CEST 2006


This email is not related to OpenSER, however the Sipsak mailing list is
currently not accepting my emails and i know a good many in the OpenSER
community use Sipsak so please excuse my off-topic post


I'm having a really strange issue that i've had no luck tracking down,
that happens sporadically (although its easy to reproduce)

I'm using Sipsak 0.9.6, i've tried the latest SVN version and 0.9.5
(compiled without gnutls)

I'm using sipsak to send a hand crafted SIP NOTIFY message to OpenSER
(MWI) when new voicemail is left for a user inside an Asterisk voice mailbox

What seems to be happening is that the select() for a response to the
NOTIFY message (line 242 in transport.c) will return immediately causing
Sipsak to retransmit the NOTIFY message (this retransmission can occur
over 15 times over a period of several thousand microseconds), i'm
utterly baffled..

I've attached the strace output from Sipsak while this is occuring (both
when it is, and isn't)

Lines of Note:
In strace.sipsak.broken: line 588 is where the select occurs
In strace.sipsak.working: line 59 is where the select occurs


I"m using the following command line:
"sipsak -df /dev/shm/asterisk/tmp/mwi-immediate -E tcp -s
sip:$USER at 127.0.0.1:15061 -H 127.0.0.1"

Contents of mwi-immediate:
-------------
NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0
To: sip:200110005339 at 127.0.0.1:15061
From: sip:vm_notify at 127.0.0.1
Call-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1
CSeq: 1 NOTIFY
Max-Forwards: 10
Event: message-summary
Content-Type: application/simple-message-summary
Content-Length: 43

Messages-Waiting: yes
Voice-Message: 2/2
------------

When I run the command directly it seems to work most of the time,
however when i run it from a simple script it seems to happen almost
every time.. I've attached a copy of the script as well for reference




-------------- next part --------------


execve("/asterisk/usr/bin/sipsak", ["/asterisk/usr/bin/sipsak", "-df", "/dev/shm/asterisk/tmp/mwi-immediate", "-E", "tcp", "-s", "sip:@127.0.0.1:15061", "-H", "127.0.0.1"], [/* 17 vars */]) = 0
uname({sys="Linux", node="spb3.hq.galnet.ca", ...}) = 0
brk(0)                                  = 0x805882c
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7fc1000
open("/etc/ld.so.preload", O_RDONLY)    = -1 ENOENT (No such file or directory)
open("/etc/ld.so.cache", O_RDONLY)      = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=1435, ...}) = 0
mmap2(NULL, 1435, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7fc0000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/tls/i686/cmov/libcrypto.so.0.9.7", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0p\300\2\0004\0\0\0\220\262\17\0\0\0\0\0004\0 \0\5\0(\0\27\0\26\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\354\233\16\0\354\233\16\0\5\0\0\0\0\20\0\0\1\0\0\0\0\240\16\0\0\240\16\0\0\240\16\0\340\21\1\0\230L\1\0\6\0\0\0\0\20\0\0\2\0\0\0\30\254\17\0\30\254\17\0\30\254\17\0\330\0\0\0\330\0\0\0\6\0\0\0\4\0\0\0P\345td\320\233\16\0\320\233\16\0\320\233\16\0\34\0\0\0\34\0\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\7\0\0\0\4\0\0\0\5\10\0\0\346\n\0\0\0\0\0\0\253\n\0\0\0\0\0\0;\7\0\0\0\0\0\0\0\0\0\0E\7\0\0\221\n\0\0\0\0\0\0\0\0\0\0\363\6\0\0>\2\0\0\0\0\0\0\317\1\0\0;\2\0\0\0\3\0\0\224\10\0\0\200\n\0\0007\n\0\0<\6\0\0\0\0\0\0\307\3\0\0F\7\0\0\375\7\0\0X\0\0\0n\3\0\0\"\5\0\0\351\3\0\0\340\10\0\0\0\10\0\0\334\t\0\0\0\0\0\0\207\3\0\0\3\n\0\0\6\2\0\0007\6\0\0\0\0\0\0\273\4\0\0\0\0\0\0\307\2\0\0\t\n\0\0S\t\0\0Y\n\0\0\0\0\0\0\0\0\0\0\225\10\0\0\0\0\0\0\0\0\0\0\276\7\0\0\0\0\0\0\304\t\0\0`\t\0\0\263\10\0\0\0\0\0\0\0\0\0\0\231\1\0\0\"\n\0\0\240\3\0\0\0\0\0\0\22\5\0\0\17\10\0\0\316\3\0\0\0\0\0\0v\n\0\0\0\0\0\0\314\5\0\0\0\0\0\0\0\0\0\0\256\0\0\0&\4\0\0 \10\0\0\302\6\0\0O\6\0\0", 512) = 512
fstat64(3, {st_mode=S_IFREG|0644, st_size=1029672, ...}) = 0
mmap2(NULL, 1043608, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7ec1000
mmap2(0xb7fab000, 73728, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0xea) = 0xb7fab000
mmap2(0xb7fbd000, 11416, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7fbd000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/tls/i686/cmov/libc.so.6", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`Z\1\0004\0\0\0T\33\23\0\0\0\0\0004\0 \0\t\0(\0:\0009\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0 \1\0\0 \1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\10\177\22\0\10\177\22\0\10\177\22\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0000\222\22\0000\222\22\0\5\0\0\0\0\20\0\0\1\0\0\0@\222\22\0@\242\22\0@\242\22\0\344~\0\0l\252\0\0\6\0\0\0\0\20\0\0\2\0\0\0\244\r\23\0\244\35\23\0\244\35\23\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0T\1\0\0T\1\0\0T\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0\7\0\0\0\34\271\22\0\34\311\22\0\34\311\22\0\10\0\0\0(\0\0\0\4\0\0\0\4\0\0\0P\345td\34\177\22\0\34\177\22\0\34\177\22\0\24\23\0\0\24\23\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\377\3\0\0\260\10\0\0006\1\0\0\316\6\0\0\207\2\0\0\376\0\0\0007\7\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\275\6\0\0\32\6\0\0\0\0\0\0h\10\0\0\307\6\0\0E\2\0\0\335\2\0\0}\10\0\0[\4\0\0r\10\0\0j\3\0\0\375\6\0\0\257\2\0\0>\10\0\0i\6\0\0\10\5\0\0\17\10\0\0\330\7\0\0\0\0\0\0\344\4\0\0\374\5\0\0v\10\0\0\204\7\0\0\0\0\0\0", 512) = 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=1254500, ...}) = 0
mmap2(NULL, 1264812, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7d8c000
mmap2(0xb7eb6000, 36864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x129) = 0xb7eb6000
mmap2(0xb7ebf000, 7340, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7ebf000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/tls/i686/cmov/libdl.so.2", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\260\32\0\0004\0\0\0\200\"\0\0\0\0\0\0004\0 \0\7\0(\0\32\0\31\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0\340\0\0\0\340\0\0\0\5\0\0\0\4\0\0\0\3\0\0\0=\36\0\0=\36\0\0=\36\0\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0P\36\0\0P\36\0\0\5\0\0\0\0\20\0\0\1\0\0\0\0 \0\0\0 \0\0\0 \0\0\230\1\0\0\270\1\0\0\6\0\0\0\0\20\0\0\2\0\0\0\f \0\0\f \0\0\f \0\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\24\1\0\0\24\1\0\0\24\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0F\0\0\0J\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0I\0\0\0\0\0\0\0G\0\0\0007\0\0\0;\0\0\0<\0\0\0:\0\0\0\0\0\0\0D\0\0\0C\0\0\0.\0\0\0\0\0\0\0F\0\0\0*\0\0\0\0\0\0\0\0\0\0\0001\0\0\0006\0\0\0\0\0\0\0\0\0\0\0\'\0\0\0\0\0\0\0\0\0\0\0003\0\0\0&\0\0\0@\0\0\0E\0\0\0-\0\0\0\0\0\0\0\0\0\0\0A\0\0\0?\0\0\0\0\0\0\0+\0\0\0!\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0002\0\0\0\0\0\0\0005\0\0\0\0\0\0\0", 512) = 512
fstat64(3, {st_mode=S_IFREG|0644, st_size=9872, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7d8b000
mmap2(NULL, 8632, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7d88000
mmap2(0xb7d8a000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x2) = 0xb7d8a000
close(3)                                = 0
set_thread_area({entry_number:-1 -> 6, base_addr:0xb7d8b6c0, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
munmap(0xb7fc0000, 1435)                = 0
brk(0)                                  = 0x805882c
brk(0x807982c)                          = 0x807982c
brk(0)                                  = 0x807982c
brk(0x807a000)                          = 0x807a000
open("/dev/shm/asterisk/tmp/mwi-immediate", O_RDONLY) = 3
fstat64(3, {st_mode=S_IFREG|0640, st_size=332, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7fc0000
read(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\nTo: sip:200110005339 at 127.0.0.1:15061\nFrom: sip:vm_notify at 127.0.0.1\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\nCSeq: 1 NOTIFY\nMax-Forwards: 10\nEvent: message-summary\nContent-Type: application/simple-message-summary\nContent-Length: 43\n\nMessages-Waiting: yes\nVoice-Message: 2/2\n", 4096) = 332
read(3, "", 4096)                       = 0
close(3)                                = 0
munmap(0xb7fc0000, 4096)                = 0
brk(0)                                  = 0x807a000
brk(0)                                  = 0x807a000
brk(0x8079000)                          = 0x8079000
brk(0)                                  = 0x8079000
time(NULL)                              = 1151622116
getpid()                                = 25647
socket(PF_INET, SOCK_STREAM, IPPROTO_TCP) = 3
bind(3, {sa_family=AF_INET, sin_port=htons(0), sin_addr=inet_addr("0.0.0.0")}, 16) = 0
getsockname(3, {sa_family=AF_INET, sin_port=htons(52099), sin_addr=inet_addr("0.0.0.0")}, [16]) = 0

connect(3, {sa_family=AF_INET, sin_port=htons(15061), sin_addr=inet_addr("127.0.0.1")}, 16) = 0

send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:52099;branch=z9hG4bK.7572baa8;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414

gettimeofday({1151622116, 218145}, {0, 0}) = 0

select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [3], left {31, 996000})

gettimeofday({1151622116, 222200}, {0, 0}) = 0

poll([{fd=3, events=POLLERR}], 1, 10)   = 0

recvfrom(3, "SIP/2.0 200 Ok\r\nVia: SIP/2.0/TCP 127.0.0.1:52099;branch=z9hG4bK.7572baa8;rport=52099;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061;tag=a59827b149529376b0f0dada9096da86.3858\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nContent-Length: 0\r\n\r\n", 4096, 0, NULL, NULL) = 293
exit_group(0)                           = ?


-------------- next part --------------
NULL)     = 0
[pid 29325] exit_group(0)               = ?
Process 31843 resumed
Process 29325 detached
<... waitpid resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0) = 29325
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) @ 0 (0) ---
waitpid(-1, 0xbfb29618, WNOHANG)        = -1 ECHILD (No child processes)
sigreturn()                             = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x8075fa0, [], 0}, 8) = 0
rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
open(".", O_RDONLY|O_NONBLOCK|O_LARGEFILE|O_DIRECTORY) = 3
fstat64(3, {st_mode=S_IFDIR|0770, st_size=80, ...}) = 0
fcntl64(3, F_SETFD, FD_CLOEXEC)         = 0
brk(0)                                  = 0x80f2000
brk(0x8132000)                          = 0x8132000
getdents64(3, /* 3 entries */, 131072)  = 80
getdents64(3, /* 0 entries */, 131072)  = 0
brk(0)                                  = 0x8132000
brk(0x80f2000)                          = 0x80f2000
close(3)                                = 0
rt_sigprocmask(SIG_BLOCK, NULL, [], 8)  = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
write(1, "Found \"200110005339\", working\n", 30Found "200110005339", working
) = 30
open("200110005339", O_RDONLY|O_LARGEFILE) = 3
fcntl64(0, F_GETFD)                     = 0
fcntl64(0, F_DUPFD, 10)                 = 10
fcntl64(0, F_GETFD)                     = 0
fcntl64(10, F_SETFD, FD_CLOEXEC)        = 0
dup2(3, 0)                              = 0
close(3)                                = 0
ioctl(0, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfb29008) = -1 ENOTTY (Inappropriate ioctl for device)
_llseek(0, 0, [0], SEEK_CUR)            = 0
read(0, "200110005339 2\n", 128)        = 15
dup2(10, 0)                             = 0
fcntl64(10, F_GETFD)                    = 0x1 (flags FD_CLOEXEC)
close(10)                               = 0
rt_sigprocmask(SIG_BLOCK, NULL, [], 8)  = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
pipe([3, 4])                            = 0
rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
clone(Process 24739 attached
child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7d996f8) = 24739
[pid 31843] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid 31843] rt_sigaction(SIGCHLD, {0x8076f20, [], 0}, {0x8076f20, [], 0}, 8) = 0
[pid 31843] close(4)                    = 0
[pid 31843] read(3,  <unfinished ...>
[pid 24739] getpid()                    = 24739
[pid 24739] close(255)                  = 0
[pid 24739] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid 24739] rt_sigaction(SIGTSTP, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 24739] rt_sigaction(SIGTTIN, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 24739] rt_sigaction(SIGTTOU, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 24739] rt_sigaction(SIGINT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 24739] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_IGN}, 8) = 0
[pid 24739] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid 24739] rt_sigaction(SIGCHLD, {0x8076f20, [], 0}, {SIG_DFL}, 8) = 0
[pid 24739] rt_sigaction(SIGINT, {0x8085cc0, [], 0}, {SIG_DFL}, 8) = 0
[pid 24739] dup2(4, 1)                  = 1
[pid 24739] close(4)                    = 0
[pid 24739] close(3)                    = 0
[pid 24739] rt_sigprocmask(SIG_BLOCK, NULL, [], 8) = 0
[pid 24739] rt_sigprocmask(SIG_BLOCK, NULL, [], 8) = 0
[pid 24739] rt_sigaction(SIGINT, {SIG_DFL}, {0x8085cc0, [], 0}, 8) = 0
[pid 24739] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 24739] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid 24739] execve("/asterisk/usr/bin/expr", ["/asterisk/usr/bin/expr", "length", "yes"], [/* 16 vars */]) = 0
[pid 24739] uname({sys="Linux", node="spb3.hq.galnet.ca", ...}) = 0
[pid 24739] brk(0)                      = 0x804de6c
[pid 24739] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 24739] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f2a000
[pid 24739] open("/etc/ld.so.preload", O_RDONLY) = -1 ENOENT (No such file or directory)
[pid 24739] open("/etc/ld.so.cache", O_RDONLY) = 3
[pid 24739] fstat64(3, {st_mode=S_IFREG|0644, st_size=1435, ...}) = 0
[pid 24739] mmap2(NULL, 1435, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7f29000
[pid 24739] close(3)                    = 0
[pid 24739] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 24739] open("/lib/tls/i686/cmov/libc.so.6", O_RDONLY) = 3
[pid 24739] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`Z\1\0004\0\0\0T\33\23\0\0\0\0\0004\0 \0\t\0(\0:\0009\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0 \1\0\0 \1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\10\177\22\0\10\177\22\0\10\177\22\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0000\222\22\0000\222\22\0\5\0\0\0\0\20\0\0\1\0\0\0@\222\22\0@\242\22\0@\242\22\0\344~\0\0l\252\0\0\6\0\0\0\0\20\0\0\2\0\0\0\244\r\23\0\244\35\23\0\244\35\23\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0T\1\0\0T\1\0\0T\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0\7\0\0\0\34\271\22\0\34\311\22\0\34\311\22\0\10\0\0\0(\0\0\0\4\0\0\0\4\0\0\0P\345td\34\177\22\0\34\177\22\0\34\177\22\0\24\23\0\0\24\23\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\377\3\0\0\260\10\0\0006\1\0\0\316\6\0\0\207\2\0\0\376\0\0\0007\7\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\275\6\0\0\32\6\0\0\0\0\0\0h\10\0\0\307\6\0\0E\2\0\0\335\2\0\0}\10\0\0[\4\0\0r\10\0\0j\3\0\0\375\6\0\0\257\2\0\0>\10\0\0i\6\0\0\10\5\0\0\17\10\0\0\330\7\0\0\0\0\0\0\344\4\0\0\374\5\0\0v\10\0\0\204\7\0\0\0\0\0\0", 512) = 512
[pid 24739] fstat64(3, {st_mode=S_IFREG|0755, st_size=1254500, ...}) = 0
[pid 24739] mmap2(NULL, 1264812, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7df4000
[pid 24739] mmap2(0xb7f1e000, 36864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x129) = 0xb7f1e000
[pid 24739] mmap2(0xb7f27000, 7340, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7f27000
[pid 24739] close(3)                    = 0
[pid 24739] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7df3000
[pid 24739] set_thread_area({entry_number:-1 -> 6, base_addr:0xb7df3070, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
[pid 24739] munmap(0xb7f29000, 1435)    = 0
[pid 24739] brk(0)                      = 0x804de6c
[pid 24739] brk(0x806ee6c)              = 0x806ee6c
[pid 24739] brk(0)                      = 0x806ee6c
[pid 24739] brk(0x806f000)              = 0x806f000
[pid 24739] fstat64(1, {st_mode=S_IFIFO|0600, st_size=0, ...}) = 0
[pid 24739] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f29000
[pid 24739] write(1, "3\n", 2)          = 2
[pid 24739] close(1)                    = 0
[pid 24739] munmap(0xb7f29000, 4096)    = 0
[pid 24739] exit_group(0)               = ?
Process 24739 detached
<... read resumed> "3\n", 128)          = 2
--- SIGCHLD (Child exited) @ 0 (0) ---
waitpid(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], WNOHANG) = 24739
waitpid(-1, 0xbfb28c48, WNOHANG)        = -1 ECHILD (No child processes)
sigreturn()                             = ? (mask now [])
read(3, "", 128)                        = 0
close(3)                                = 0
rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGINT, {0x8075fa0, [], 0}, {SIG_DFL}, 8) = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
rt_sigaction(SIGINT, {SIG_DFL}, {0x8075fa0, [], 0}, 8) = 0
pipe([3, 4])                            = 0
rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
clone(Process 32653 attached
child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7d996f8) = 32653
[pid 31843] rt_sigprocmask(SIG_SETMASK, [],  <unfinished ...>
[pid 32653] getpid( <unfinished ...>
[pid 31843] <... rt_sigprocmask resumed> NULL, 8) = 0
[pid 32653] <... getpid resumed> )      = 32653
[pid 31843] rt_sigaction(SIGCHLD, {0x8076f20, [], 0},  <unfinished ...>
[pid 32653] close(255 <unfinished ...>
[pid 31843] <... rt_sigaction resumed> {0x8076f20, [], 0}, 8) = 0
[pid 32653] <... close resumed> )       = 0
[pid 31843] close(4)                    = 0
[pid 31843] read(3,  <unfinished ...>
[pid 32653] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid 32653] rt_sigaction(SIGTSTP, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 32653] rt_sigaction(SIGTTIN, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 32653] rt_sigaction(SIGTTOU, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 32653] rt_sigaction(SIGINT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 32653] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_IGN}, 8) = 0
[pid 32653] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid 32653] rt_sigaction(SIGCHLD, {0x8076f20, [], 0}, {SIG_DFL}, 8) = 0
[pid 32653] rt_sigaction(SIGINT, {0x8085cc0, [], 0}, {SIG_DFL}, 8) = 0
[pid 32653] dup2(4, 1)                  = 1
[pid 32653] close(4)                    = 0
[pid 32653] close(3)                    = 0
[pid 32653] rt_sigprocmask(SIG_BLOCK, NULL, [], 8) = 0
[pid 32653] rt_sigprocmask(SIG_BLOCK, NULL, [], 8) = 0
[pid 32653] rt_sigaction(SIGINT, {SIG_DFL}, {0x8085cc0, [], 0}, 8) = 0
[pid 32653] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 32653] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid 32653] execve("/asterisk/usr/bin/expr", ["/asterisk/usr/bin/expr", "length", "2"], [/* 16 vars */]) = 0
[pid 32653] uname({sys="Linux", node="spb3.hq.galnet.ca", ...}) = 0
[pid 32653] brk(0)                      = 0x804de6c
[pid 32653] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 32653] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f21000
[pid 32653] open("/etc/ld.so.preload", O_RDONLY) = -1 ENOENT (No such file or directory)
[pid 32653] open("/etc/ld.so.cache", O_RDONLY) = 3
[pid 32653] fstat64(3, {st_mode=S_IFREG|0644, st_size=1435, ...}) = 0
[pid 32653] mmap2(NULL, 1435, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7f20000
[pid 32653] close(3)                    = 0
[pid 32653] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 32653] open("/lib/tls/i686/cmov/libc.so.6", O_RDONLY) = 3
[pid 32653] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`Z\1\0004\0\0\0T\33\23\0\0\0\0\0004\0 \0\t\0(\0:\0009\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0 \1\0\0 \1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\10\177\22\0\10\177\22\0\10\177\22\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0000\222\22\0000\222\22\0\5\0\0\0\0\20\0\0\1\0\0\0@\222\22\0@\242\22\0@\242\22\0\344~\0\0l\252\0\0\6\0\0\0\0\20\0\0\2\0\0\0\244\r\23\0\244\35\23\0\244\35\23\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0T\1\0\0T\1\0\0T\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0\7\0\0\0\34\271\22\0\34\311\22\0\34\311\22\0\10\0\0\0(\0\0\0\4\0\0\0\4\0\0\0P\345td\34\177\22\0\34\177\22\0\34\177\22\0\24\23\0\0\24\23\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\377\3\0\0\260\10\0\0006\1\0\0\316\6\0\0\207\2\0\0\376\0\0\0007\7\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\275\6\0\0\32\6\0\0\0\0\0\0h\10\0\0\307\6\0\0E\2\0\0\335\2\0\0}\10\0\0[\4\0\0r\10\0\0j\3\0\0\375\6\0\0\257\2\0\0>\10\0\0i\6\0\0\10\5\0\0\17\10\0\0\330\7\0\0\0\0\0\0\344\4\0\0\374\5\0\0v\10\0\0\204\7\0\0\0\0\0\0", 512) = 512
[pid 32653] fstat64(3, {st_mode=S_IFREG|0755, st_size=1254500, ...}) = 0
[pid 32653] mmap2(NULL, 1264812, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7deb000
[pid 32653] mmap2(0xb7f15000, 36864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x129) = 0xb7f15000
[pid 32653] mmap2(0xb7f1e000, 7340, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7f1e000
[pid 32653] close(3)                    = 0
[pid 32653] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7dea000
[pid 32653] set_thread_area({entry_number:-1 -> 6, base_addr:0xb7dea070, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
[pid 32653] munmap(0xb7f20000, 1435)    = 0
[pid 32653] brk(0)                      = 0x804de6c
[pid 32653] brk(0x806ee6c)              = 0x806ee6c
[pid 32653] brk(0)                      = 0x806ee6c
[pid 32653] brk(0x806f000)              = 0x806f000
[pid 32653] fstat64(1, {st_mode=S_IFIFO|0600, st_size=0, ...}) = 0
[pid 32653] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f20000
[pid 32653] write(1, "1\n", 2)          = 2
[pid 31843] <... read resumed> "1\n", 128) = 2
[pid 31843] read(3,  <unfinished ...>
[pid 32653] close(1 <unfinished ...>
[pid 31843] <... read resumed> "", 128) = 0
[pid 32653] <... close resumed> )       = 0
[pid 31843] close(3)                    = 0
[pid 31843] rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
[pid 31843] rt_sigaction(SIGINT, {0x8075fa0, [], 0}, {SIG_DFL}, 8) = 0
[pid 31843] waitpid(-1, Process 31843 suspended
 <unfinished ...>
[pid 32653] munmap(0xb7f20000, 4096)    = 0
[pid 32653] exit_group(0)               = ?
Process 31843 resumed
Process 32653 detached
<... waitpid resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0) = 32653
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) @ 0 (0) ---
waitpid(-1, 0xbfb28b68, WNOHANG)        = -1 ECHILD (No child processes)
sigreturn()                             = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x8075fa0, [], 0}, 8) = 0
pipe([3, 4])                            = 0
rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
clone(Process 4869 attached
child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7d996f8) = 4869
[pid 31843] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid 31843] rt_sigaction(SIGCHLD, {0x8076f20, [], 0}, {0x8076f20, [], 0}, 8) = 0
[pid 31843] close(4)                    = 0
[pid 31843] read(3,  <unfinished ...>
[pid  4869] getpid()                    = 4869
[pid  4869] close(255)                  = 0
[pid  4869] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid  4869] rt_sigaction(SIGTSTP, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  4869] rt_sigaction(SIGTTIN, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  4869] rt_sigaction(SIGTTOU, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  4869] rt_sigaction(SIGINT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  4869] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_IGN}, 8) = 0
[pid  4869] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid  4869] rt_sigaction(SIGCHLD, {0x8076f20, [], 0}, {SIG_DFL}, 8) = 0
[pid  4869] rt_sigaction(SIGINT, {0x8085cc0, [], 0}, {SIG_DFL}, 8) = 0
[pid  4869] dup2(4, 1)                  = 1
[pid  4869] close(4)                    = 0
[pid  4869] close(3)                    = 0
[pid  4869] rt_sigprocmask(SIG_BLOCK, NULL, [], 8) = 0
[pid  4869] rt_sigprocmask(SIG_BLOCK, NULL, [], 8) = 0
[pid  4869] rt_sigaction(SIGINT, {SIG_DFL}, {0x8085cc0, [], 0}, 8) = 0
[pid  4869] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  4869] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid  4869] execve("/asterisk/usr/bin/expr", ["/asterisk/usr/bin/expr", "length", "2"], [/* 16 vars */]) = 0
[pid  4869] uname({sys="Linux", node="spb3.hq.galnet.ca", ...}) = 0
[pid  4869] brk(0)                      = 0x804de6c
[pid  4869] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid  4869] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f6e000
[pid  4869] open("/etc/ld.so.preload", O_RDONLY) = -1 ENOENT (No such file or directory)
[pid  4869] open("/etc/ld.so.cache", O_RDONLY) = 3
[pid  4869] fstat64(3, {st_mode=S_IFREG|0644, st_size=1435, ...}) = 0
[pid  4869] mmap2(NULL, 1435, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7f6d000
[pid  4869] close(3)                    = 0
[pid  4869] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid  4869] open("/lib/tls/i686/cmov/libc.so.6", O_RDONLY) = 3
[pid  4869] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`Z\1\0004\0\0\0T\33\23\0\0\0\0\0004\0 \0\t\0(\0:\0009\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0 \1\0\0 \1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\10\177\22\0\10\177\22\0\10\177\22\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0000\222\22\0000\222\22\0\5\0\0\0\0\20\0\0\1\0\0\0@\222\22\0@\242\22\0@\242\22\0\344~\0\0l\252\0\0\6\0\0\0\0\20\0\0\2\0\0\0\244\r\23\0\244\35\23\0\244\35\23\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0T\1\0\0T\1\0\0T\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0\7\0\0\0\34\271\22\0\34\311\22\0\34\311\22\0\10\0\0\0(\0\0\0\4\0\0\0\4\0\0\0P\345td\34\177\22\0\34\177\22\0\34\177\22\0\24\23\0\0\24\23\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\377\3\0\0\260\10\0\0006\1\0\0\316\6\0\0\207\2\0\0\376\0\0\0007\7\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\275\6\0\0\32\6\0\0\0\0\0\0h\10\0\0\307\6\0\0E\2\0\0\335\2\0\0}\10\0\0[\4\0\0r\10\0\0j\3\0\0\375\6\0\0\257\2\0\0>\10\0\0i\6\0\0\10\5\0\0\17\10\0\0\330\7\0\0\0\0\0\0\344\4\0\0\374\5\0\0v\10\0\0\204\7\0\0\0\0\0\0", 512) = 512
[pid  4869] fstat64(3, {st_mode=S_IFREG|0755, st_size=1254500, ...}) = 0
[pid  4869] mmap2(NULL, 1264812, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7e38000
[pid  4869] mmap2(0xb7f62000, 36864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x129) = 0xb7f62000
[pid  4869] mmap2(0xb7f6b000, 7340, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7f6b000
[pid  4869] close(3)                    = 0
[pid  4869] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7e37000
[pid  4869] set_thread_area({entry_number:-1 -> 6, base_addr:0xb7e37070, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
[pid  4869] munmap(0xb7f6d000, 1435)    = 0
[pid  4869] brk(0)                      = 0x804de6c
[pid  4869] brk(0x806ee6c)              = 0x806ee6c
[pid  4869] brk(0)                      = 0x806ee6c
[pid  4869] brk(0x806f000)              = 0x806f000
[pid  4869] fstat64(1, {st_mode=S_IFIFO|0600, st_size=0, ...}) = 0
[pid  4869] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f6d000
[pid  4869] write(1, "1\n", 2)          = 2
[pid 31843] <... read resumed> "1\n", 128) = 2
[pid 31843] read(3,  <unfinished ...>
[pid  4869] close(1)                    = 0
[pid 31843] <... read resumed> "", 128) = 0
[pid 31843] close(3)                    = 0
[pid 31843] rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
[pid 31843] rt_sigaction(SIGINT, {0x8075fa0, [], 0}, {SIG_DFL}, 8) = 0
[pid 31843] waitpid(-1, Process 31843 suspended
 <unfinished ...>
[pid  4869] munmap(0xb7f6d000, 4096)    = 0
[pid  4869] exit_group(0)               = ?
Process 31843 resumed
Process 4869 detached
<... waitpid resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0) = 4869
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) @ 0 (0) ---
waitpid(-1, 0xbfb28b68, WNOHANG)        = -1 ECHILD (No child processes)
sigreturn()                             = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x8075fa0, [], 0}, 8) = 0
rt_sigprocmask(SIG_BLOCK, NULL, [], 8)  = 0
rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
pipe([3, 4])                            = 0
rt_sigprocmask(SIG_BLOCK, [INT CHLD], [CHLD], 8) = 0
clone(Process 7702 attached
child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7d996f8) = 7702
[pid 31843] rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0
[pid 31843] close(4)                    = 0
[pid 31843] close(4)                    = -1 EBADF (Bad file descriptor)
[pid 31843] rt_sigprocmask(SIG_BLOCK, [INT CHLD], [CHLD], 8) = 0
[pid 31843] clone(Process 10886 attached
child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7d996f8) = 10886
[pid 31843] rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0
[pid 31843] close(3)                    = 0
[pid 31843] rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
[pid 31843] rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0
[pid 31843] rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
[pid 31843] rt_sigaction(SIGINT, {0x8075fa0, [], 0}, {SIG_DFL}, 8) = 0
[pid 31843] waitpid(-1, Process 31843 suspended
 <unfinished ...>
[pid  7702] getpid()                    = 7702
[pid  7702] close(255)                  = 0
[pid  7702] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid  7702] rt_sigaction(SIGTSTP, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  7702] rt_sigaction(SIGTTIN, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  7702] rt_sigaction(SIGTTOU, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  7702] close(3)                    = 0
[pid  7702] dup2(4, 1)                  = 1
[pid  7702] close(4)                    = 0
[pid  7702] rt_sigaction(SIGINT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  7702] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_IGN}, 8) = 0
[pid  7702] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid  7702] execve("/asterisk/usr/bin/cat", ["/asterisk/usr/bin/cat", "/asterisk/usr/bin/notify.msg"], [/* 16 vars */] <unfinished ...>
[pid 10886] getpid()                    = 10886
[pid 10886] close(255)                  = 0
[pid 10886] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid 10886] rt_sigaction(SIGTSTP, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 10886] rt_sigaction(SIGTTIN, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 10886] rt_sigaction(SIGTTOU, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 10886] dup2(3, 0)                  = 0
[pid 10886] close(3 <unfinished ...>
[pid  7702] <... execve resumed> )      = 0
[pid 10886] <... close resumed> )       = 0
[pid  7702] uname( <unfinished ...>
[pid 10886] rt_sigaction(SIGINT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 10886] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_IGN}, 8) = 0
[pid 10886] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid 10886] open("/dev/shm/asterisk/tmp/mwi-immediate", O_WRONLY|O_CREAT|O_TRUNC|O_LARGEFILE, 0666 <unfinished ...>
[pid  7702] <... uname resumed> {sys="Linux", node="spb3.hq.galnet.ca", ...}) = 0
[pid 10886] <... open resumed> )        = 3
[pid 10886] dup2(3, 1)                  = 1
[pid 10886] close(3)                    = 0
[pid  7702] brk(0)                      = 0x804cd6c
[pid 10886] execve("/asterisk/usr/bin/sed", ["/asterisk/usr/bin/sed", "--expression=s/!SUBSCRIBER!/200110005339/g;s/!MAILBOX!/200110005339/g;\n                 s/!CONTENT_LENGTH!/43/g;\n                 s/!HAS_MESSAGE!/yes/g;\n                 s/!NEW_COUNT!/2/g;\n                 s/!OLD_COUNT!/2/g;"], [/* 16 vars */] <unfinished ...>
[pid  7702] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid  7702] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
[pid 10886] <... execve resumed> )      = 0
[pid  7702] <... mmap2 resumed> )       = 0xb7f74000
[pid 10886] uname({sys="Linux", node="spb3.hq.galnet.ca", ...}) = 0
[pid  7702] open("/etc/ld.so.preload", O_RDONLY <unfinished ...>
[pid 10886] brk(0)                      = 0x8057bb0
[pid 10886] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 10886] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7fb0000
[pid 10886] open("/etc/ld.so.preload", O_RDONLY <unfinished ...>
[pid  7702] <... open resumed> )        = -1 ENOENT (No such file or directory)
[pid 10886] <... open resumed> )        = -1 ENOENT (No such file or directory)
[pid 10886] open("/etc/ld.so.cache", O_RDONLY) = 3
[pid 10886] fstat64(3, {st_mode=S_IFREG|0644, st_size=1435, ...}) = 0
[pid 10886] mmap2(NULL, 1435, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7faf000
[pid 10886] close(3)                    = 0
[pid 10886] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 10886] open("/lib/tls/i686/cmov/libc.so.6", O_RDONLY) = 3
[pid 10886] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`Z\1\0004\0\0\0T\33\23\0\0\0\0\0004\0 \0\t\0(\0:\0009\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0 \1\0\0 \1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\10\177\22\0\10\177\22\0\10\177\22\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0000\222\22\0000\222\22\0\5\0\0\0\0\20\0\0\1\0\0\0@\222\22\0@\242\22\0@\242\22\0\344~\0\0l\252\0\0\6\0\0\0\0\20\0\0\2\0\0\0\244\r\23\0\244\35\23\0\244\35\23\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0T\1\0\0T\1\0\0T\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0\7\0\0\0\34\271\22\0\34\311\22\0\34\311\22\0\10\0\0\0(\0\0\0\4\0\0\0\4\0\0\0P\345td\34\177\22\0\34\177\22\0\34\177\22\0\24\23\0\0\24\23\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\377\3\0\0\260\10\0\0006\1\0\0\316\6\0\0\207\2\0\0\376\0\0\0007\7\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\275\6\0\0\32\6\0\0\0\0\0\0h\10\0\0\307\6\0\0E\2\0\0\335\2\0\0}\10\0\0[\4\0\0r\10\0\0j\3\0\0\375\6\0\0\257\2\0\0>\10\0\0i\6\0\0\10\5\0\0\17\10\0\0\330\7\0\0\0\0\0\0\344\4\0\0\374\5\0\0v\10\0\0\204\7\0\0\0\0\0\0", 512) = 512
[pid  7702] open("/etc/ld.so.cache", O_RDONLY <unfinished ...>
[pid 10886] fstat64(3, {st_mode=S_IFREG|0755, st_size=1254500, ...}) = 0
[pid  7702] <... open resumed> )        = 3
[pid 10886] mmap2(NULL, 1264812, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7e7a000
[pid 10886] mmap2(0xb7fa4000, 36864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x129) = 0xb7fa4000
[pid 10886] mmap2(0xb7fad000, 7340, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
[pid  7702] fstat64(3,  <unfinished ...>
[pid 10886] <... mmap2 resumed> )       = 0xb7fad000
[pid  7702] <... fstat64 resumed> {st_mode=S_IFREG|0644, st_size=1435, ...}) = 0
[pid 10886] close(3)                    = 0
[pid 10886] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
[pid  7702] mmap2(NULL, 1435, PROT_READ, MAP_PRIVATE, 3, 0 <unfinished ...>
[pid 10886] <... mmap2 resumed> )       = 0xb7e79000
[pid  7702] <... mmap2 resumed> )       = 0xb7f73000
[pid  7702] close(3)                    = 0
[pid 10886] set_thread_area({entry_number:-1 ->  <unfinished ...>
[pid  7702] access("/etc/ld.so.nohwcap", F_OK <unfinished ...>
[pid 10886] <... set_thread_area resumed> 6, base_addr:0xb7e79070, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
[pid 10886] munmap(0xb7faf000, 1435)    = 0
[pid  7702] <... access resumed> )      = -1 ENOENT (No such file or directory)
[pid 10886] brk(0)                      = 0x8057bb0
[pid 10886] brk(0x8078bb0)              = 0x8078bb0
[pid 10886] brk(0)                      = 0x8078bb0
[pid 10886] brk(0x8079000)              = 0x8079000
[pid  7702] open("/lib/tls/i686/cmov/libc.so.6", O_RDONLY) = 3
[pid  7702] read(3,  <unfinished ...>
[pid 10886] fstat64(0, {st_mode=S_IFIFO|0600, st_size=0, ...}) = 0
[pid  7702] <... read resumed> "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`Z\1\0004\0\0\0T\33\23\0\0\0\0\0004\0 \0\t\0(\0:\0009\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0 \1\0\0 \1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\10\177\22\0\10\177\22\0\10\177\22\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0000\222\22\0000\222\22\0\5\0\0\0\0\20\0\0\1\0\0\0@\222\22\0@\242\22\0@\242\22\0\344~\0\0l\252\0\0\6\0\0\0\0\20\0\0\2\0\0\0\244\r\23\0\244\35\23\0\244\35\23\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0T\1\0\0T\1\0\0T\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0\7\0\0\0\34\271\22\0\34\311\22\0\34\311\22\0\10\0\0\0(\0\0\0\4\0\0\0\4\0\0\0P\345td\34\177\22\0\34\177\22\0\34\177\22\0\24\23\0\0\24\23\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\377\3\0\0\260\10\0\0006\1\0\0\316\6\0\0\207\2\0\0\376\0\0\0007\7\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\275\6\0\0\32\6\0\0\0\0\0\0h\10\0\0\307\6\0\0E\2\0\0\335\2\0\0}\10\0\0[\4\0\0r\10\0\0j\3\0\0\375\6\0\0\257\2\0\0>\10\0\0i\6\0\0\10\5\0\0\17\10\0\0\330\7\0\0\0\0\0\0\344\4\0\0\374\5\0\0v\10\0\0\204\7\0\0\0\0\0\0", 512) = 512
[pid 10886] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7faf000
[pid 10886] read(0,  <unfinished ...>
[pid  7702] fstat64(3, {st_mode=S_IFREG|0755, st_size=1254500, ...}) = 0
[pid  7702] mmap2(NULL, 1264812, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7e3e000
[pid  7702] mmap2(0xb7f68000, 36864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x129) = 0xb7f68000
[pid  7702] mmap2(0xb7f71000, 7340, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7f71000
[pid  7702] close(3)                    = 0
[pid  7702] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7e3d000
[pid  7702] set_thread_area({entry_number:-1 -> 6, base_addr:0xb7e3d070, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
[pid  7702] munmap(0xb7f73000, 1435)    = 0
[pid  7702] brk(0)                      = 0x804cd6c
[pid  7702] brk(0x806dd6c)              = 0x806dd6c
[pid  7702] brk(0)                      = 0x806dd6c
[pid  7702] brk(0x806e000)              = 0x806e000
[pid  7702] fstat64(1, {st_mode=S_IFIFO|0600, st_size=0, ...}) = 0
[pid  7702] open("/asterisk/usr/bin/notify.msg", O_RDONLY|O_LARGEFILE) = 3
[pid  7702] fstat64(3, {st_mode=S_IFREG|0750, st_size=376, ...}) = 0
[pid  7702] read(3, "NOTIFY sip:!SUBSCRIBER!@127.0.0.1:15061 SIP/2.0\nTo: sip:!SUBSCRIBER!@127.0.0.1:15061\nFrom: sip:vm_notify at 127.0.0.1\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\nCSeq: 1 NOTIFY\nMax-Forwards: 10\nEvent: message-summary\nContent-Type: application/simple-message-summary\nContent-Length: !CONTENT_LENGTH!\n\nMessages-Waiting: !HAS_MESSAGE!\nVoice-Message: !NEW_COUNT!/!OLD_COUNT!\n", 131072) = 376
[pid  7702] write(1, "NOTIFY sip:!SUBSCRIBER!@127.0.0.1:15061 SIP/2.0\nTo: sip:!SUBSCRIBER!@127.0.0.1:15061\nFrom: sip:vm_notify at 127.0.0.1\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\nCSeq: 1 NOTIFY\nMax-Forwards: 10\nEvent: message-summary\nContent-Type: application/simple-message-summary\nContent-Length: !CONTENT_LENGTH!\n\nMessages-Waiting: !HAS_MESSAGE!\nVoice-Message: !NEW_COUNT!/!OLD_COUNT!\n", 376) = 376
[pid 10886] <... read resumed> "NOTIFY sip:!SUBSCRIBER!@127.0.0.1:15061 SIP/2.0\nTo: sip:!SUBSCRIBER!@127.0.0.1:15061\nFrom: sip:vm_notify at 127.0.0.1\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\nCSeq: 1 NOTIFY\nMax-Forwards: 10\nEvent: message-summary\nContent-Type: application/simple-message-summary\nContent-Length: !CONTENT_LENGTH!\n\nMessages-Waiting: !HAS_MESSAGE!\nVoice-Message: !NEW_COUNT!/!OLD_COUNT!\n", 4096) = 376
[pid  7702] read(3,  <unfinished ...>
[pid 10886] fstat64(1,  <unfinished ...>
[pid  7702] <... read resumed> "", 131072) = 0
[pid 10886] <... fstat64 resumed> {st_mode=S_IFREG|0640, st_size=0, ...}) = 0
[pid  7702] brk(0 <unfinished ...>
[pid 10886] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
[pid  7702] <... brk resumed> )         = 0x806e000
[pid 10886] <... mmap2 resumed> )       = 0xb7e78000
[pid  7702] brk(0 <unfinished ...>
[pid 10886] read(0,  <unfinished ...>
[pid  7702] <... brk resumed> )         = 0x806e000
[pid  7702] brk(0x806d000)              = 0x806d000
[pid  7702] brk(0)                      = 0x806d000
[pid  7702] close(3)                    = 0
[pid  7702] close(1)                    = 0
[pid 10886] <... read resumed> "", 4096) = 0
[pid  7702] exit_group(0)               = ?
Process 31843 resumed
Process 7702 detached
[pid 10886] write(1, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\nTo: sip:200110005339 at 127.0.0.1:15061\nFrom: sip:vm_notify at 127.0.0.1\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\nCSeq: 1 NOTIFY\nMax-Forwards: 10\nEvent: message-summary\nContent-Type: application/simple-message-summary\nContent-Length: 43\n\nMessages-Waiting: yes\nVoice-Message: 2/2\n", 332 <unfinished ...>
[pid 31843] <... waitpid resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0) = 7702
[pid 31843] waitpid(-1, Process 31843 suspended
 <unfinished ...>
[pid 10886] <... write resumed> )       = 332
[pid 10886] close(1)                    = 0
[pid 10886] munmap(0xb7e78000, 4096)    = 0
[pid 10886] close(2)                    = 0
[pid 10886] exit_group(0)               = ?
Process 31843 resumed
Process 10886 detached
<... waitpid resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0) = 10886
rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0
rt_sigaction(SIGINT, {SIG_DFL}, {0x8075fa0, [], 0}, 8) = 0
close(3)                                = -1 EBADF (Bad file descriptor)
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) @ 0 (0) ---
waitpid(-1, 0xbfb290f8, WNOHANG)        = -1 ECHILD (No child processes)
sigreturn()                             = ? (mask now [])
rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
clone(Process 6344 attached
child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7d996f8) = 6344
[pid 31843] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid 31843] rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
[pid 31843] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid 31843] rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
[pid 31843] rt_sigaction(SIGINT, {0x8075fa0, [], 0}, {SIG_DFL}, 8) = 0
[pid 31843] waitpid(-1, Process 31843 suspended
 <unfinished ...>
[pid  6344] getpid()                    = 6344
[pid  6344] close(255)                  = 0
[pid  6344] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid  6344] rt_sigaction(SIGTSTP, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  6344] rt_sigaction(SIGTTIN, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  6344] rt_sigaction(SIGTTOU, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  6344] rt_sigaction(SIGINT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid  6344] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_IGN}, 8) = 0
[pid  6344] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid  6344] execve("/asterisk/usr/bin/cat", ["/asterisk/usr/bin/cat", "/dev/shm/asterisk/tmp/mwi-immediate"], [/* 16 vars */]) = 0
[pid  6344] uname({sys="Linux", node="spb3.hq.galnet.ca", ...}) = 0
[pid  6344] brk(0)                      = 0x804cd6c
[pid  6344] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid  6344] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f93000
[pid  6344] open("/etc/ld.so.preload", O_RDONLY) = -1 ENOENT (No such file or directory)
[pid  6344] open("/etc/ld.so.cache", O_RDONLY) = 3
[pid  6344] fstat64(3, {st_mode=S_IFREG|0644, st_size=1435, ...}) = 0
[pid  6344] mmap2(NULL, 1435, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7f92000
[pid  6344] close(3)                    = 0
[pid  6344] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid  6344] open("/lib/tls/i686/cmov/libc.so.6", O_RDONLY) = 3
[pid  6344] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`Z\1\0004\0\0\0T\33\23\0\0\0\0\0004\0 \0\t\0(\0:\0009\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0 \1\0\0 \1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\10\177\22\0\10\177\22\0\10\177\22\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0000\222\22\0000\222\22\0\5\0\0\0\0\20\0\0\1\0\0\0@\222\22\0@\242\22\0@\242\22\0\344~\0\0l\252\0\0\6\0\0\0\0\20\0\0\2\0\0\0\244\r\23\0\244\35\23\0\244\35\23\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0T\1\0\0T\1\0\0T\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0\7\0\0\0\34\271\22\0\34\311\22\0\34\311\22\0\10\0\0\0(\0\0\0\4\0\0\0\4\0\0\0P\345td\34\177\22\0\34\177\22\0\34\177\22\0\24\23\0\0\24\23\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\377\3\0\0\260\10\0\0006\1\0\0\316\6\0\0\207\2\0\0\376\0\0\0007\7\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\275\6\0\0\32\6\0\0\0\0\0\0h\10\0\0\307\6\0\0E\2\0\0\335\2\0\0}\10\0\0[\4\0\0r\10\0\0j\3\0\0\375\6\0\0\257\2\0\0>\10\0\0i\6\0\0\10\5\0\0\17\10\0\0\330\7\0\0\0\0\0\0\344\4\0\0\374\5\0\0v\10\0\0\204\7\0\0\0\0\0\0", 512) = 512
[pid  6344] fstat64(3, {st_mode=S_IFREG|0755, st_size=1254500, ...}) = 0
[pid  6344] mmap2(NULL, 1264812, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7e5d000
[pid  6344] mmap2(0xb7f87000, 36864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x129) = 0xb7f87000
[pid  6344] mmap2(0xb7f90000, 7340, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7f90000
[pid  6344] close(3)                    = 0
[pid  6344] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7e5c000
[pid  6344] set_thread_area({entry_number:-1 -> 6, base_addr:0xb7e5c070, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
[pid  6344] munmap(0xb7f92000, 1435)    = 0
[pid  6344] brk(0)                      = 0x804cd6c
[pid  6344] brk(0x806dd6c)              = 0x806dd6c
[pid  6344] brk(0)                      = 0x806dd6c
[pid  6344] brk(0x806e000)              = 0x806e000
[pid  6344] fstat64(1, {st_mode=S_IFCHR|0600, st_rdev=makedev(136, 0), ...}) = 0
[pid  6344] open("/dev/shm/asterisk/tmp/mwi-immediate", O_RDONLY|O_LARGEFILE) = 3
[pid  6344] fstat64(3, {st_mode=S_IFREG|0640, st_size=332, ...}) = 0
[pid  6344] read(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\nTo: sip:200110005339 at 127.0.0.1:15061\nFrom: sip:vm_notify at 127.0.0.1\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\nCSeq: 1 NOTIFY\nMax-Forwards: 10\nEvent: message-summary\nContent-Type: application/simple-message-summary\nContent-Length: 43\n\nMessages-Waiting: yes\nVoice-Message: 2/2\n", 4096) = 332
[pid  6344] write(1, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\nTo: sip:200110005339 at 127.0.0.1:15061\nFrom: sip:vm_notify at 127.0.0.1\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\nCSeq: 1 NOTIFY\nMax-Forwards: 10\nEvent: message-summary\nContent-Type: application/simple-message-summary\nContent-Length: 43\n\nMessages-Waiting: yes\nVoice-Message: 2/2\n", 332NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0
To: sip:200110005339 at 127.0.0.1:15061
From: sip:vm_notify at 127.0.0.1
Call-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1
CSeq: 1 NOTIFY
Max-Forwards: 10
Event: message-summary
Content-Type: application/simple-message-summary
Content-Length: 43

Messages-Waiting: yes
Voice-Message: 2/2
) = 332
[pid  6344] read(3, "", 4096)           = 0
[pid  6344] brk(0)                      = 0x806e000
[pid  6344] brk(0)                      = 0x806e000
[pid  6344] brk(0x806d000)              = 0x806d000
[pid  6344] brk(0)                      = 0x806d000
[pid  6344] close(3)                    = 0
[pid  6344] close(1)                    = 0
[pid  6344] exit_group(0)               = ?
Process 31843 resumed
Process 6344 detached
<... waitpid resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0) = 6344
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) @ 0 (0) ---
waitpid(-1, 0xbfb291e8, WNOHANG)        = -1 ECHILD (No child processes)
sigreturn()                             = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x8075fa0, [], 0}, 8) = 0
write(1, "Notifying 200110005339 ..", 25Notifying 200110005339 ..) = 25
rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
clone(Process 21119 attached
child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7d996f8) = 21119
[pid 31843] rt_sigprocmask(SIG_SETMASK, [],  <unfinished ...>
[pid 21119] getpid( <unfinished ...>
[pid 31843] <... rt_sigprocmask resumed> NULL, 8) = 0
[pid 21119] <... getpid resumed> )      = 21119
[pid 31843] rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
[pid 21119] close(255 <unfinished ...>
[pid 31843] <... rt_sigprocmask resumed> [], 8) = 0
[pid 21119] <... close resumed> )       = 0
[pid 31843] rt_sigprocmask(SIG_SETMASK, [],  <unfinished ...>
[pid 21119] rt_sigprocmask(SIG_SETMASK, [],  <unfinished ...>
[pid 31843] <... rt_sigprocmask resumed> NULL, 8) = 0
[pid 21119] <... rt_sigprocmask resumed> NULL, 8) = 0
[pid 31843] rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
[pid 21119] rt_sigaction(SIGTSTP, {SIG_DFL},  <unfinished ...>
[pid 31843] <... rt_sigprocmask resumed> [], 8) = 0
[pid 21119] <... rt_sigaction resumed> {SIG_DFL}, 8) = 0
[pid 31843] rt_sigaction(SIGINT, {0x8075fa0, [], 0},  <unfinished ...>
[pid 21119] rt_sigaction(SIGTTIN, {SIG_DFL},  <unfinished ...>
[pid 31843] <... rt_sigaction resumed> {SIG_DFL}, 8) = 0
[pid 21119] <... rt_sigaction resumed> {SIG_DFL}, 8) = 0
[pid 31843] waitpid(-1, Process 31843 suspended
 <unfinished ...>
[pid 21119] rt_sigaction(SIGTTOU, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 21119] rt_sigaction(SIGINT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 21119] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_IGN}, 8) = 0
[pid 21119] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid 21119] execve("/asterisk/usr/bin/sipsak", ["/asterisk/usr/bin/sipsak", "-df", "/dev/shm/asterisk/tmp/mwi-immediate", "-E", "tcp", "-s", "sip:200110005339 at 127.0.0.1:15061", "-H", "127.0.0.1"], [/* 16 vars */]) = 0
[pid 21119] uname({sys="Linux", node="spb3.hq.galnet.ca", ...}) = 0
[pid 21119] brk(0)                      = 0x805882c
[pid 21119] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 21119] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f75000
[pid 21119] open("/etc/ld.so.preload", O_RDONLY) = -1 ENOENT (No such file or directory)
[pid 21119] open("/etc/ld.so.cache", O_RDONLY) = 3
[pid 21119] fstat64(3, {st_mode=S_IFREG|0644, st_size=1435, ...}) = 0
[pid 21119] mmap2(NULL, 1435, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7f74000
[pid 21119] close(3)                    = 0
[pid 21119] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 21119] open("/lib/tls/i686/cmov/libcrypto.so.0.9.7", O_RDONLY) = 3
[pid 21119] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0p\300\2\0004\0\0\0\220\262\17\0\0\0\0\0004\0 \0\5\0(\0\27\0\26\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\354\233\16\0\354\233\16\0\5\0\0\0\0\20\0\0\1\0\0\0\0\240\16\0\0\240\16\0\0\240\16\0\340\21\1\0\230L\1\0\6\0\0\0\0\20\0\0\2\0\0\0\30\254\17\0\30\254\17\0\30\254\17\0\330\0\0\0\330\0\0\0\6\0\0\0\4\0\0\0P\345td\320\233\16\0\320\233\16\0\320\233\16\0\34\0\0\0\34\0\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\7\0\0\0\4\0\0\0\5\10\0\0\346\n\0\0\0\0\0\0\253\n\0\0\0\0\0\0;\7\0\0\0\0\0\0\0\0\0\0E\7\0\0\221\n\0\0\0\0\0\0\0\0\0\0\363\6\0\0>\2\0\0\0\0\0\0\317\1\0\0;\2\0\0\0\3\0\0\224\10\0\0\200\n\0\0007\n\0\0<\6\0\0\0\0\0\0\307\3\0\0F\7\0\0\375\7\0\0X\0\0\0n\3\0\0\"\5\0\0\351\3\0\0\340\10\0\0\0\10\0\0\334\t\0\0\0\0\0\0\207\3\0\0\3\n\0\0\6\2\0\0007\6\0\0\0\0\0\0\273\4\0\0\0\0\0\0\307\2\0\0\t\n\0\0S\t\0\0Y\n\0\0\0\0\0\0\0\0\0\0\225\10\0\0\0\0\0\0\0\0\0\0\276\7\0\0\0\0\0\0\304\t\0\0`\t\0\0\263\10\0\0\0\0\0\0\0\0\0\0\231\1\0\0\"\n\0\0\240\3\0\0\0\0\0\0\22\5\0\0\17\10\0\0\316\3\0\0\0\0\0\0v\n\0\0\0\0\0\0\314\5\0\0\0\0\0\0\0\0\0\0\256\0\0\0&\4\0\0 \10\0\0\302\6\0\0O\6\0\0", 512) = 512
[pid 21119] fstat64(3, {st_mode=S_IFREG|0644, st_size=1029672, ...}) = 0
[pid 21119] mmap2(NULL, 1043608, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7e75000
[pid 21119] mmap2(0xb7f5f000, 73728, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0xea) = 0xb7f5f000
[pid 21119] mmap2(0xb7f71000, 11416, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7f71000
[pid 21119] close(3)                    = 0
[pid 21119] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 21119] open("/lib/tls/i686/cmov/libc.so.6", O_RDONLY) = 3
[pid 21119] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`Z\1\0004\0\0\0T\33\23\0\0\0\0\0004\0 \0\t\0(\0:\0009\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0 \1\0\0 \1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\10\177\22\0\10\177\22\0\10\177\22\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0000\222\22\0000\222\22\0\5\0\0\0\0\20\0\0\1\0\0\0@\222\22\0@\242\22\0@\242\22\0\344~\0\0l\252\0\0\6\0\0\0\0\20\0\0\2\0\0\0\244\r\23\0\244\35\23\0\244\35\23\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0T\1\0\0T\1\0\0T\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0\7\0\0\0\34\271\22\0\34\311\22\0\34\311\22\0\10\0\0\0(\0\0\0\4\0\0\0\4\0\0\0P\345td\34\177\22\0\34\177\22\0\34\177\22\0\24\23\0\0\24\23\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\377\3\0\0\260\10\0\0006\1\0\0\316\6\0\0\207\2\0\0\376\0\0\0007\7\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\275\6\0\0\32\6\0\0\0\0\0\0h\10\0\0\307\6\0\0E\2\0\0\335\2\0\0}\10\0\0[\4\0\0r\10\0\0j\3\0\0\375\6\0\0\257\2\0\0>\10\0\0i\6\0\0\10\5\0\0\17\10\0\0\330\7\0\0\0\0\0\0\344\4\0\0\374\5\0\0v\10\0\0\204\7\0\0\0\0\0\0", 512) = 512
[pid 21119] fstat64(3, {st_mode=S_IFREG|0755, st_size=1254500, ...}) = 0
[pid 21119] mmap2(NULL, 1264812, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7d40000
[pid 21119] mmap2(0xb7e6a000, 36864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x129) = 0xb7e6a000
[pid 21119] mmap2(0xb7e73000, 7340, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7e73000
[pid 21119] close(3)                    = 0
[pid 21119] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 21119] open("/lib/tls/i686/cmov/libdl.so.2", O_RDONLY) = 3
[pid 21119] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\260\32\0\0004\0\0\0\200\"\0\0\0\0\0\0004\0 \0\7\0(\0\32\0\31\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0\340\0\0\0\340\0\0\0\5\0\0\0\4\0\0\0\3\0\0\0=\36\0\0=\36\0\0=\36\0\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0P\36\0\0P\36\0\0\5\0\0\0\0\20\0\0\1\0\0\0\0 \0\0\0 \0\0\0 \0\0\230\1\0\0\270\1\0\0\6\0\0\0\0\20\0\0\2\0\0\0\f \0\0\f \0\0\f \0\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\24\1\0\0\24\1\0\0\24\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0F\0\0\0J\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0I\0\0\0\0\0\0\0G\0\0\0007\0\0\0;\0\0\0<\0\0\0:\0\0\0\0\0\0\0D\0\0\0C\0\0\0.\0\0\0\0\0\0\0F\0\0\0*\0\0\0\0\0\0\0\0\0\0\0001\0\0\0006\0\0\0\0\0\0\0\0\0\0\0\'\0\0\0\0\0\0\0\0\0\0\0003\0\0\0&\0\0\0@\0\0\0E\0\0\0-\0\0\0\0\0\0\0\0\0\0\0A\0\0\0?\0\0\0\0\0\0\0+\0\0\0!\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0002\0\0\0\0\0\0\0005\0\0\0\0\0\0\0", 512) = 512
[pid 21119] fstat64(3, {st_mode=S_IFREG|0644, st_size=9872, ...}) = 0
[pid 21119] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7d3f000
[pid 21119] mmap2(NULL, 8632, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7d3c000
[pid 21119] mmap2(0xb7d3e000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x2) = 0xb7d3e000
[pid 21119] close(3)                    = 0
[pid 21119] set_thread_area({entry_number:-1 -> 6, base_addr:0xb7d3f6c0, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
[pid 21119] munmap(0xb7f74000, 1435)    = 0
[pid 21119] brk(0)                      = 0x805882c
[pid 21119] brk(0x807982c)              = 0x807982c
[pid 21119] brk(0)                      = 0x807982c
[pid 21119] brk(0x807a000)              = 0x807a000
[pid 21119] open("/dev/shm/asterisk/tmp/mwi-immediate", O_RDONLY) = 3
[pid 21119] fstat64(3, {st_mode=S_IFREG|0640, st_size=332, ...}) = 0
[pid 21119] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f74000
[pid 21119] read(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\nTo: sip:200110005339 at 127.0.0.1:15061\nFrom: sip:vm_notify at 127.0.0.1\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\nCSeq: 1 NOTIFY\nMax-Forwards: 10\nEvent: message-summary\nContent-Type: application/simple-message-summary\nContent-Length: 43\n\nMessages-Waiting: yes\nVoice-Message: 2/2\n", 4096) = 332
[pid 21119] read(3, "", 4096)           = 0
[pid 21119] close(3)                    = 0
[pid 21119] munmap(0xb7f74000, 4096)    = 0
[pid 21119] brk(0)                      = 0x807a000
[pid 21119] brk(0)                      = 0x807a000
[pid 21119] brk(0x8079000)              = 0x8079000
[pid 21119] brk(0)                      = 0x8079000
[pid 21119] time(NULL)                  = 1151621697
[pid 21119] getpid()                    = 21119
[pid 21119] socket(PF_INET, SOCK_STREAM, IPPROTO_TCP) = 3
[pid 21119] bind(3, {sa_family=AF_INET, sin_port=htons(0), sin_addr=inet_addr("0.0.0.0")}, 16) = 0
[pid 21119] getsockname(3, {sa_family=AF_INET, sin_port=htons(50762), sin_addr=inet_addr("0.0.0.0")}, [16]) = 0
[pid 21119] 

connect(3, {sa_family=AF_INET, sin_port=htons(15061), sin_addr=inet_addr("127.0.0.1")}, 16) = 0

send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414

gettimeofday({1151621697, 429995}, {0, 0}) = 0

select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})

gettimeofday({1151621697, 430394}, {0, 0}) = 0

send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414

gettimeofday({1151621697, 430902}, {0, 0}) = 0

select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})

gettimeofday({1151621697, 431249}, {0, 0}) = 0

send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 431751}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 432109}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 432592}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 432945}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 436787}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 437278}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 437795}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 438177}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 438665}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 439052}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 439553}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 439919}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 440407}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 440788}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 441372}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 441730}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 442232}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 442598}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 443123}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 443500}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 444016}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 444380}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 444877}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 445562}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 446394}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 447012}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 447816}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 448432}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 449271}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 449875}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 450557}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 451149}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 451830}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 452419}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 453456}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 454202}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 454931}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 455530}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 456211}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 456797}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 457553}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 458141}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 458822}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 459411}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 460091}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 460678}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 461420}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 462007}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 462690}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 463279}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 463960}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 464548}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 465288}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 465875}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 466556}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 467152}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 467833}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 468422}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 469165}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 469753}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 470434}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 471023}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 471506}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 471857}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 472270}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 472626}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 473113}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 473465}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 473884}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 474238}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 474654}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 475040}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 475454}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 475805}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 476221}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 476575}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 477162}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 477518}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 477937}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 478287}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 478704}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 479059}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 479476}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 479828}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 480246}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 480597}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 481075}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 481426}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 481844}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 482196}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 482613}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 482966}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 483387}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 483738}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 484155}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 484507}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 484924}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 485330}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 485748}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 486099}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 486516}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 486871}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 487290}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 487642}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 488059}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 488411}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 488831}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 489397}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 489816}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 490155}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 490563}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 490901}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 491366}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 491719}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 492136}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 492491}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 492908}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 493326}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 493743}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 494098}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 494515}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 494869}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 495290}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 495644}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 496061}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 496415}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 496834}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 497254}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 497662}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 498006}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 498444}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 498793}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 499213}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 1 (in [0], left {32, 0})
[pid 21119] gettimeofday({1151621697, 502040}, {0, 0}) = 0
[pid 21119] send(3, "NOTIFY sip:200110005339 at 127.0.0.1:15061 SIP/2.0\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nMax-Forwards: 10\r\nEvent: message-summary\r\nContent-Type: application/simple-message-summary\r\nContent-Length: 43\r\n\r\nMessages-Waiting: yes\r\nVoice-Message: 2/2\r\n", 414, 0) = 414
[pid 21119] gettimeofday({1151621697, 506075}, {0, 0}) = 0
[pid 21119] select(1024, [0 3], NULL, NULL, {32, 0}) = 2 (in [0 3], left {32, 0})
[pid 21119] gettimeofday({1151621697, 507045}, {0, 0}) = 0
[pid 21119] poll([{fd=3, events=POLLERR}], 1, 10) = 0
[pid 21119] recvfrom(3, "SIP/2.0 200 Ok\r\nVia: SIP/2.0/TCP 127.0.0.1:50762;branch=z9hG4bK.32883b6b;rport=50762;alias\r\nTo: sip:200110005339 at 127.0.0.1:15061;tag=a59827b149529376b0f0dada9096da86.d438\r\nFrom: sip:vm_notify at 127.0.0.1\r\nCall-ID: 4d61cf9e505d40e905032a18329d61ec at 127.0.0.1\r\nCSeq: 1 NOTIFY\r\nContent-Length: 0\r\n\r\n", 4096, 0, NULL, NULL) = 293
[pid 21119] exit_group(0)               = ?
Process 31843 resumed
Process 21119 detached
<... waitpid resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0) = 21119
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) @ 0 (0) ---
waitpid(-1, 0xbfb29288, WNOHANG)        = -1 ECHILD (No child processes)
sigreturn()                             = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x8075fa0, [], 0}, 8) = 0
write(1, "done\n", 5done
)                   = 5
rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
clone(Process 28639 attached
child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb7d996f8) = 28639
[pid 31843] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid 31843] rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
[pid 31843] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid 31843] rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
[pid 31843] rt_sigaction(SIGINT, {0x8075fa0, [], 0}, {SIG_DFL}, 8) = 0
[pid 31843] waitpid(-1, Process 31843 suspended
 <unfinished ...>
[pid 28639] getpid()                    = 28639
[pid 28639] close(255)                  = 0
[pid 28639] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
[pid 28639] rt_sigaction(SIGTSTP, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 28639] rt_sigaction(SIGTTIN, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 28639] rt_sigaction(SIGTTOU, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 28639] rt_sigaction(SIGINT, {SIG_DFL}, {SIG_DFL}, 8) = 0
[pid 28639] rt_sigaction(SIGQUIT, {SIG_DFL}, {SIG_IGN}, 8) = 0
[pid 28639] rt_sigaction(SIGCHLD, {SIG_DFL}, {0x8076f20, [], 0}, 8) = 0
[pid 28639] execve("/asterisk/usr/bin/sleep", ["/asterisk/usr/bin/sleep", "3"], [/* 16 vars */]) = 0
[pid 28639] uname({sys="Linux", node="spb3.hq.galnet.ca", ...}) = 0
[pid 28639] brk(0)                      = 0x804c52c
[pid 28639] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 28639] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7f66000
[pid 28639] open("/etc/ld.so.preload", O_RDONLY) = -1 ENOENT (No such file or directory)
[pid 28639] open("/etc/ld.so.cache", O_RDONLY) = 3
[pid 28639] fstat64(3, {st_mode=S_IFREG|0644, st_size=1435, ...}) = 0
[pid 28639] mmap2(NULL, 1435, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7f65000
[pid 28639] close(3)                    = 0
[pid 28639] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 28639] open("/lib/tls/i686/cmov/libm.so.6", O_RDONLY) = 3
[pid 28639] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\00005\0\0004\0\0\0\270\7\2\0\0\0\0\0004\0 \0\7\0(\0\35\0\34\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0\340\0\0\0\340\0\0\0\5\0\0\0\4\0\0\0\3\0\0\0(\4\2\0(\4\2\0(\4\2\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0;\4\2\0;\4\2\0\5\0\0\0\0\20\0\0\1\0\0\0@\4\2\0@\24\2\0@\24\2\0|\1\0\0\300\1\0\0\6\0\0\0\0\20\0\0\2\0\0\0p\4\2\0p\24\2\0p\24\2\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\24\1\0\0\24\1\0\0\24\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0]\2\0\0w\1\0\0\246\0\0\0v\1\0\0\235\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0=\0\0\0\0\0\0\0\0\0\0\0\277\0\0\0\0\0\0\0\0\0\0\0e\1\0\0\0\0\0\0X\1\0\0\0\0\0\0\0\0\0\0\17\1\0\0\333\0\0\0001\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\326\0\0\0\354\0\0\0\20\1\0\0\0\0\0\0\0\0\0\0V\0\0\0\0\0\0\0]\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0@\1\0\0=\1\0\0\0\0\0\0$\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0.\0\0\0\0\0\0\0\0\0\0\0A\0\0\0\263\0\0\0\322\0\0\0\0\0\0\0", 512) = 512
[pid 28639] fstat64(3, {st_mode=S_IFREG|0644, st_size=134208, ...}) = 0
[pid 28639] mmap2(NULL, 136704, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7f43000
[pid 28639] mmap2(0xb7f64000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x20) = 0xb7f64000
[pid 28639] close(3)                    = 0
[pid 28639] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 28639] open("/lib/tls/i686/cmov/librt.so.1", O_RDONLY) = 3
[pid 28639] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\200\33\0\0004\0\0\0LZ\0\0\0\0\0\0004\0 \0\10\0(\0\36\0\35\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0\0\1\0\0\0\1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\234T\0\0\234T\0\0\234T\0\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\4U\0\0\4U\0\0\5\0\0\0\0\20\0\0\1\0\0\0 U\0\0 e\0\0 e\0\0\374\3\0\0\254\4\0\0\6\0\0\0\0\20\0\0\2\0\0\0\0W\0\0\0g\0\0\0g\0\0\350\0\0\0\350\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0004\1\0\0004\1\0\0004\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0P\345td\260T\0\0\260T\0\0\260T\0\0T\0\0\0T\0\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\265\0\0\0\201\0\0\0\0\0\0\0\0\0\0\0f\0\0\0\0\0\0\0)\0\0\0v\0\0\0\0\0\0\0D\0\0\0\0\0\0\0\0\0\0\0M\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0_\0\0\0L\0\0\0N\0\0\0\0\0\0\0003\0\0\0@\0\0\0\\\0\0\0=\0\0\0o\0\0\0\0\0\0\0007\0\0\0i\0\0\0\0\0\0\0\0\0\0\0{\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0", 512) = 512
[pid 28639] fstat64(3, {st_mode=S_IFREG|0644, st_size=24316, ...}) = 0
[pid 28639] mmap2(NULL, 27084, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7f3c000
[pid 28639] mmap2(0xb7f42000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x5) = 0xb7f42000
[pid 28639] close(3)                    = 0
[pid 28639] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 28639] open("/lib/tls/i686/cmov/libc.so.6", O_RDONLY) = 3
[pid 28639] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`Z\1\0004\0\0\0T\33\23\0\0\0\0\0004\0 \0\t\0(\0:\0009\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0 \1\0\0 \1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\10\177\22\0\10\177\22\0\10\177\22\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0000\222\22\0000\222\22\0\5\0\0\0\0\20\0\0\1\0\0\0@\222\22\0@\242\22\0@\242\22\0\344~\0\0l\252\0\0\6\0\0\0\0\20\0\0\2\0\0\0\244\r\23\0\244\35\23\0\244\35\23\0\340\0\0\0\340\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0T\1\0\0T\1\0\0T\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0\7\0\0\0\34\271\22\0\34\311\22\0\34\311\22\0\10\0\0\0(\0\0\0\4\0\0\0\4\0\0\0P\345td\34\177\22\0\34\177\22\0\34\177\22\0\24\23\0\0\24\23\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\377\3\0\0\260\10\0\0006\1\0\0\316\6\0\0\207\2\0\0\376\0\0\0007\7\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\275\6\0\0\32\6\0\0\0\0\0\0h\10\0\0\307\6\0\0E\2\0\0\335\2\0\0}\10\0\0[\4\0\0r\10\0\0j\3\0\0\375\6\0\0\257\2\0\0>\10\0\0i\6\0\0\10\5\0\0\17\10\0\0\330\7\0\0\0\0\0\0\344\4\0\0\374\5\0\0v\10\0\0\204\7\0\0\0\0\0\0", 512) = 512
[pid 28639] fstat64(3, {st_mode=S_IFREG|0755, st_size=1254500, ...}) = 0
[pid 28639] mmap2(NULL, 1264812, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7e07000
[pid 28639] mmap2(0xb7f31000, 36864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0x129) = 0xb7f31000
[pid 28639] mmap2(0xb7f3a000, 7340, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7f3a000
[pid 28639] close(3)                    = 0
[pid 28639] mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7e06000
[pid 28639] access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
[pid 28639] open("/lib/tls/i686/cmov/libpthread.so.0", O_RDONLY) = 3
[pid 28639] read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\0G\0\0004\0\0\0|\337\0\0\0\0\0\0004\0 \0\10\0(\0!\0\36\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0\0\1\0\0\0\1\0\0\5\0\0\0\4\0\0\0\3\0\0\0\23\305\0\0\23\305\0\0\23\305\0\0\23\0\0\0\23\0\0\0\4\0\0\0\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\24\307\0\0\24\307\0\0\5\0\0\0\0\20\0\0\1\0\0\0\0\320\0\0\0\320\0\0\0\320\0\0\360\f\0\0\244-\0\0\6\0\0\0\0\20\0\0\2\0\0\0\270\332\0\0\270\332\0\0\270\332\0\0\360\0\0\0\360\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0004\1\0\0004\1\0\0004\1\0\0 \0\0\0 \0\0\0\4\0\0\0\4\0\0\0P\345td(\305\0\0(\305\0\0(\305\0\0\354\1\0\0\354\1\0\0\4\0\0\0\4\0\0\0Q\345td\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\6\0\0\0\4\0\0\0\4\0\0\0\20\0\0\0\1\0\0\0GNU\0\0\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0U\2\0\0T\1\0\0\0\0\0\0\0\0\0\0J\1\0\0\317\0\0\0\0\0\0\0\0\0\0\0\255\0\0\0\250\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0I\1\0\0A\0\0\0\f\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0?\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\342\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0!\1\0\0\0\0\0\0\0\0\0\0\345\0\0\0\0\0\0\0\0\0\0\0\300\0\0\0\311\0\0\0 \1\0\0\0\0\0\0\0\0\0\0\0\0\0\0", 512) = 512
[pid 28639] fstat64(3, {st_mode=S_IFREG|0755, st_size=82632, ...}) = 0
[pid 28639] mmap2(NULL, 64932, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3, 0) = 0xb7df6000
[pid 28639] mmap2(0xb7e03000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED, 3, 0xd) = 0xb7e03000
[pid 28639] mmap2(0xb7e04000, 7588, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb7e04000
[pid 28639] close(3)                    = 0
[pid 28639] set_thread_area({entry_number:-1 -> 6, base_addr:0xb7e06b10, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
[pid 28639] munmap(0xb7f65000, 1435)    = 0
[pid 28639] set_tid_address(0xb7e06b58) = 28639
[pid 28639] rt_sigaction(SIGRTMIN, {0xb7dfa660, [], SA_SIGINFO}, NULL, 8) = 0
[pid 28639] rt_sigprocmask(SIG_UNBLOCK, [RTMIN], NULL, 8) = 0
[pid 28639] getrlimit(RLIMIT_STACK, {rlim_cur=8192*1024, rlim_max=RLIM_INFINITY}) = 0
[pid 28639] brk(0)                      = 0x804c52c
[pid 28639] brk(0x806d52c)              = 0x806d52c
[pid 28639] brk(0)                      = 0x806d52c
[pid 28639] brk(0x806e000)              = 0x806e000
[pid 28639] clock_gettime(CLOCK_REALTIME, {1151621697, 535457000}) = 0
[pid 28639] nanosleep({3, 0}, 


-------------- next part --------------
A non-text attachment was scrubbed...
Name: mwi_notify-daemon.sh
Type: application/x-shellscript
Size: 2770 bytes
Desc: not available
Url : http://openser.org/pipermail/devel/attachments/20060630/7043f952/mwi_notify-daemon-0001.bin


More information about the Devel mailing list