Pjsua - 2nd incoming call gives different state result when in manual answer.

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



Can anybody validate why I'm getting call_info.state == PJSIP_INV_STATE_CONFIRMED on the second (2nd) incoming call. First (1st) incoming call gives me call_info.state == PJSIP_INV_STATE_INCOMING. This gives me a message "No pending incoming call" every time there is a second incoming call. This happen when answering in manual mode. Auto answer behaves properly. I have attached below pjsua logs in manual answer.

00:42:55.265 - call_info.state on the first call can be found on this logtime.
00:43:03.421 - call_info.state on the second call here.

Thanks,
espaunan



 00:42:48.796 sip_endpoint.c  Module "mod-pjsua-log" registered
 00:42:48.796 sip_endpoint.c  Module "mod-tsx-layer" registered
 00:42:48.796 sip_endpoint.c  Module "mod-stateful-util" registered
 00:42:48.796 sip_endpoint.c  Module "mod-ua" registered
 00:42:48.796 sip_endpoint.c  Module "mod-100rel" registered
 00:42:48.796 sip_endpoint.c  Module "mod-pjsua" registered
 00:42:48.796 sip_endpoint.c  Module "mod-invite" registered
 00:42:48.796      pasound.c  PA message: before paHostApiInitializers[0].

 00:42:48.828      pasound.c  PA message: Pa_GetDeviceInfo: Num input channels reported as 65535! Changed to 2.

 00:42:48.828      pasound.c  PA message: Pa_GetDeviceInfo: Num output channels reported as 65535! Changed to 2.

 00:42:48.828      pasound.c  PA message: after paHostApiInitializers[0].

 00:42:48.843      pasound.c  PA message: before paHostApiInitializers[1].

 00:42:48.890      pasound.c  PA message: after paHostApiInitializers[1].

 00:42:48.890      pasound.c  PA message: before paHostApiInitializers[2].

 00:42:48.890      pasound.c  PA message: after paHostApiInitializers[2].

 00:42:48.890      pasound.c  PortAudio sound library initialized, status=0
 00:42:48.890      pasound.c  PortAudio host api count=3
 00:42:48.890      pasound.c  Sound device count=8
 00:42:48.890          pjlib  WinNT IOCP I/O Queue created (01701EDC)
 00:42:48.890   conference.c  Creating conference bridge with 254 ports
 00:42:48.890   conference.c  Sound device successfully created for port 0
 00:42:48.890 sip_endpoint.c  Module "mod-evsub" registered
 00:42:48.890 sip_endpoint.c  Module "mod-presence" registered
 00:42:48.890        evsub.c  Event pkg "presence" registered by mod-presence
 00:42:48.890 sip_endpoint.c  Module "mod-refer" registered
 00:42:48.890        evsub.c  Event pkg "refer" registered by mod-refer
 00:42:48.890 sip_endpoint.c  Module "mod-pjsua-pres" registered
 00:42:48.890 sip_endpoint.c  Module "mod-pjsua-im" registered
 00:42:48.890 sip_endpoint.c  Module "mod-pjsua-options" registered
 00:42:48.890   pjsua_core.c  1 SIP worker threads created
 00:42:48.890   pjsua_core.c  pjsua version 1.0 for win32 initialized
 00:42:48.906   pjsua_core.c  SIP UDP socket reachable at 192.168.1.88:5060
 00:42:48.906    udp0170E9F0  SIP UDP transport started, published address is 192.168.1.88:5060
 00:42:48.906    pjsua_acc.c  Account <sip:192.168.1.88:5060> added with id 0
 00:42:48.906    tcplis:5060  SIP TCP listener ready for incoming connections at 192.168.1.88:5060
 00:42:48.906    pjsua_acc.c  Account <sip:192.168.1.88:5060;transport=TCP> added with id 1
 00:42:48.906    pjsua_acc.c  Account sip:8881088 at 192.168.1.188 added with id 2
 00:42:48.906       endpoint  Request msg REGISTER/cseq=24841 (tdta01711450) created.
 00:42:48.906    tsx017124BC  Transaction created for Request msg REGISTER/cseq=24842 (tdta01711450)
 00:42:48.906    tsx017124BC  Sending Request msg REGISTER/cseq=24842 (tdta01711450) in state Null
 00:42:48.906  sip_resolve.c  Target '192.168.1.188:0' type=Unspecified resolved to '192.168.1.188:5060' type=UDP (UDP transport)
 00:42:48.906   pjsua_core.c  TX 423 bytes Request msg REGISTER/cseq=24842 (tdta01711450) to UDP 192.168.1.188:5060:
REGISTER sip:192.168.1.188 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.88:5060;rport;branch=z9hG4bKPj44778a0dcfbc4c929a42a8439d085d7b
Max-Forwards: 70
From: <sip:8881088@192.168.1.188>;tag=67bd571350d7407e8be9c546a74391d3
To: <sip:8881088 at 192.168.1.188>
Call-ID: 1f4c67a4c0664a249145c383ea4579bb
CSeq: 24842 REGISTER
User-Agent: PJSUA v1.0/win32
Contact: <sip:8881088 at 192.168.1.88:5060>
Expires: 300
Content-Length:  0


--end msg--
 00:42:48.921    tsx017124BC  State changed from Null to Calling, event=TX_MSG
 00:42:48.921    pjsua_acc.c  Registration sent
 00:42:48.921        icetp00  Creating ICE stream transport with 2 component(s)
 00:42:48.921        icetp00  Comp 1: host candidate 192.168.1.88:1604 added
 00:42:48.921        icetp00  Comp 2: host candidate 192.168.1.88:1605 added
 00:42:48.921        icetp00  ICE stream transport created
 00:42:48.921        icetp01  Creating ICE stream transport with 2 component(s)
 00:42:48.921        icetp01  Comp 1: host candidate 192.168.1.88:1606 added
 00:42:48.921        icetp01  Comp 2: host candidate 192.168.1.88:1607 added
 00:42:48.937        icetp01  ICE stream transport created
 00:42:48.937        icetp02  Creating ICE stream transport with 2 component(s)
 00:42:48.937        icetp02  Comp 1: host candidate 192.168.1.88:1608 added
 00:42:48.937        icetp02  Comp 2: host candidate 192.168.1.88:1609 added
 00:42:48.937        icetp02  ICE stream transport created
 00:42:48.937        icetp03  Creating ICE stream transport with 2 component(s)
 00:42:48.937 sip_endpoint.c  Processing incoming message: Response msg 401/REGISTER/cseq=24842 (rdata0170EE64)
 00:42:48.937   pjsua_core.c  RX 506 bytes Response msg 401/REGISTER/cseq=24842 (rdata0170EE64) from UDP 192.168.1.188:5060:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.1.88:5060;rport=5060;branch=z9hG4bKPj44778a0dcfbc4c929a42a8439d085d7b
From: <sip:8881088@192.168.1.188>;tag=67bd571350d7407e8be9c546a74391d3
To: <sip:8881088 at 192.168.1.188>;tag=2c11ccde4a65ba314834801c074cdedf.2392
Call-ID: 1f4c67a4c0664a249145c383ea4579bb
CSeq: 24842 REGISTER
WWW-Authenticate: Digest realm="192.168.1.188", nonce="48fcb635000000c7fefb275b9a4faf742de6282644af0150"
Server: OpenSIPS (1.4.2-notls (i386/linux))
Content-Length: 0


--end msg--
 00:42:48.937        icetp03  Comp 1: host candidate 192.168.1.88:1610 added
 00:42:48.937    tsx017124BC  Incoming Response msg 401/REGISTER/cseq=24842 (rdata0170EE64) in state Calling
 00:42:48.953    tsx017124BC  State changed from Calling to Completed, event=RX_MSG
 00:42:48.953        icetp03  Comp 2: host candidate 192.168.1.88:1611 added
 00:42:48.953    tsx017254FC  Transaction created for Request msg REGISTER/cseq=24843 (tdta01711450)
 00:42:48.953        icetp03  ICE stream transport created
 00:42:48.953    tsx017254FC  Sending Request msg REGISTER/cseq=24843 (tdta01711450) in state Null
 00:42:48.953  sip_resolve.c  Target '192.168.1.188:0' type=Unspecified resolved to '192.168.1.188:5060' type=UDP (UDP transport)
 00:42:48.953   pjsua_core.c  TX 616 bytes Request msg REGISTER/cseq=24843 (tdta01711450) to UDP 192.168.1.188:5060:
REGISTER sip:192.168.1.188 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.88:5060;rport;branch=z9hG4bKPjffc27b48225b4bbebb3a18848d325802
Max-Forwards: 70
From: <sip:8881088@192.168.1.188>;tag=67bd571350d7407e8be9c546a74391d3
To: <sip:8881088 at 192.168.1.188>
Call-ID: 1f4c67a4c0664a249145c383ea4579bb
CSeq: 24843 REGISTER
User-Agent: PJSUA v1.0/win32
Contact: <sip:8881088 at 192.168.1.88:5060>
Expires: 300
Authorization: Digest username="8881088", realm="192.168.1.188", nonce="48fcb635000000c7fefb275b9a4faf742de6282644af0150", uri="sip:192.168.1.188", response="98dd0af893cfd7a25779a3c521e9053b"
Content-Length:  0


--end msg--
 00:42:48.953    tsx017254FC  State changed from Null to Calling, event=TX_MSG
 00:42:48.968 sip_endpoint.c  Processing incoming message: Response msg 200/REGISTER/cseq=24843 (rdata0170EE64)
 00:42:48.968   pjsua_core.c  RX 444 bytes Response msg 200/REGISTER/cseq=24843 (rdata0170EE64) from UDP 192.168.1.188:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.88:5060;rport=5060;branch=z9hG4bKPjffc27b48225b4bbebb3a18848d325802
From: <sip:8881088@192.168.1.188>;tag=67bd571350d7407e8be9c546a74391d3
To: <sip:8881088 at 192.168.1.188>;tag=2c11ccde4a65ba314834801c074cdedf.037d
Call-ID: 1f4c67a4c0664a249145c383ea4579bb
CSeq: 24843 REGISTER
Contact: <sip:8881088 at 192.168.1.88:5060>;expires=300
Server: OpenSIPS (1.4.2-notls (i386/linux))
Content-Length: 0


--end msg--
 00:42:48.968    tsx017254FC  Incoming Response msg 200/REGISTER/cseq=24843 (rdata0170EE64) in state Calling
 00:42:48.984    tsx017254FC  State changed from Calling to Completed, event=RX_MSG
 00:42:48.984    pjsua_acc.c  sip:8881088 at 192.168.1.188: registration success, status=200 (OK), will re-register in 300 seconds
 00:42:48.984    pjsua_acc.c  Keep-alive timer started for acc 2, destination:192.168.1.188:5060, interval:15s
 00:42:52.593 sip_endpoint.c  Processing incoming message: Request msg INVITE/cseq=2 (rdata0170EE64)
 00:42:52.593   pjsua_core.c  RX 900 bytes Request msg INVITE/cseq=2 (rdata0170EE64) from UDP 192.168.1.188:5060:
INVITE sip:8881088 at 192.168.1.88:5060 SIP/2.0
Record-Route: <sip:192.168.1.188;lr=on>
To: <sip:8881088 at 192.168.1.188>
From: 8881001<sip:8881001@192.168.1.188>;tag=726b0e7c
Via: SIP/2.0/UDP 192.168.1.188;branch=z9hG4bK56fd.a106065.0
Via: SIP/2.0/UDP 192.168.1.1:6018;received=192.168.1.1;branch=z9hG4bK-d87543-522652435-1--d87543-;rport=6018
Call-ID: a84bca61c3020f18
CSeq: 2 INVITE
Contact: <sip:8881001 at 192.168.1.1:6018>
Max-Forwards: 69
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
Content-Type: application/sdp
User-Agent: eyeBeam release 3006o stamp 17551
Content-Length: 268

v=0
o=- 11288688 11288705 IN IP4 192.168.1.1
s=eyeBeam
c=IN IP4 192.168.1.1
t=0 0
m=audio 6020 RTP/AVP 18 8 0 3 100 6 5 101
a=alt:1 1 : B4FF5CF7 0000004F 192.168.1.1 6020
a=fmtp:101 0-15
a=rtpmap:100 speex/16000
a=rtpmap:101 telephone-event/8000
a=sendrecv

--end msg--
 00:42:52.640  pjsua_media.c  Media index 0 selected for call 0
 00:42:52.640        icetp00  ICE session created, comp_cnt=2, role is Controlled agent
 00:42:52.640        icetp00  Candidate 0 added: comp_id=1, type=host, foundation=H, addr=192.168.1.88:1604, base=192.168.1.88:1604, prio=0x27 (39)
 00:42:52.640        icetp00  Candidate 1 added: comp_id=2, type=host, foundation=H, addr=192.168.1.88:1605, base=192.168.1.88:1605, prio=0x26 (38)
 00:42:52.640        icetp00  Stopping ICE, reason=No ICE found in SDP offer
 00:42:52.640        icetp00  Destroying ICE session
 00:42:52.656    tsx0172BC64  Transaction created for Request msg INVITE/cseq=2 (rdata0170EE64)
 00:42:52.656    tsx0172BC64  Incoming Request msg INVITE/cseq=2 (rdata0170EE64) in state Null
 00:42:52.656    tsx0172BC64  State changed from Null to Trying, event=RX_MSG
 00:42:52.656    dlg0172B45C  Transaction tsx0172BC64 state changed to Trying
 00:42:52.656    dlg0172B45C  UAS dialog created
 00:42:52.656    dlg0172B45C  Module mod-invite added as dialog usage, data=01725CB4
 00:42:52.656    dlg0172B45C  Session count inc to 2 by mod-invite
 00:42:52.656    inv0172B45C  UAS invite session created for dialog dlg0172B45C
 00:42:52.656   pjsua_call.c  Call 0: remote NAT type is 0 (Unknown)
 00:42:52.656       endpoint  Response msg 100/INVITE/cseq=2 (tdta0172DE50) created
 00:42:52.656    dlg0172B45C  Initial answer Response msg 100/INVITE/cseq=2 (tdta0172DE50)
 00:42:52.656    inv0172B45C  Sending Response msg 100/INVITE/cseq=2 (tdta0172DE50)
 00:42:52.656    dlg0172B45C  Sending Response msg 100/INVITE/cseq=2 (tdta0172DE50)
 00:42:52.656    tsx0172BC64  Sending Response msg 100/INVITE/cseq=2 (tdta0172DE50) in state Trying
 00:42:52.656  sip_resolve.c  Target '192.168.1.188:5060' type=UDP resolved to '192.168.1.188:5060' type=UDP (UDP transport)
 00:42:52.656   pjsua_core.c  TX 408 bytes Response msg 100/INVITE/cseq=2 (tdta0172DE50) to UDP 192.168.1.188:5060:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.188;received=192.168.1.188;branch=z9hG4bK56fd.a106065.0
Via: SIP/2.0/UDP 192.168.1.1:6018;rport=6018;received=192.168.1.1;branch=z9hG4bK-d87543-522652435-1--d87543-
Record-Route: <sip:192.168.1.188;lr>
Call-ID: a84bca61c3020f18
From: "8881001" <sip:8881001@192.168.1.188>;tag=726b0e7c
To: <sip:8881088 at 192.168.1.188>
CSeq: 2 INVITE
Content-Length:  0


--end msg--
 00:42:52.671    tsx0172BC64  State changed from Trying to Proceeding, event=TX_MSG
 00:42:52.671    dlg0172B45C  Transaction tsx0172BC64 state changed to Proceeding
 00:42:52.671    pjsua_app.c  Call 0 state changed to INCOMING
 00:42:52.671  pjsua_media.c  pjsua_set_snd_dev(): attempting to open devices @8000 Hz
 00:42:52.687      pasound.c  Opened device SoundMAX HD Audio(MME)/SoundMAX HD Audio(MME) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=100 ms
 00:42:52.687      pasound.c  Starting SoundMAX HD Audio stream..
 00:42:52.687      pasound.c  PA message: Pa_StartStream: waveInStart returned = 0x0.

 00:42:52.687      pasound.c  Done, status=0
 00:42:52.687   sound_port.c  Echo canceller is now disabled in the sound port
 00:42:52.687   conference.c  Port 2 (ring) transmitting to port 0 (SoundMAX HD Audio)
 00:42:52.703    pjsua_app.c  Incoming call for account 2!
From: "8881001" <sip:8881001@192.168.1.188>
To: <sip:8881088 at 192.168.1.188>
Press a to answer or h to reject call
 00:42:52.718      pasound.c  Recorder thread started
 00:42:52.734      pasound.c  Player thread started
 00:42:53.968    tsx017124BC  Timeout timer event
 00:42:53.968    tsx017124BC  State changed from Completed to Terminated, event=TIMER
 00:42:53.968    tsx017124BC  Timeout timer event
 00:42:53.968    tsx017124BC  State changed from Terminated to Destroyed, event=TIMER
 00:42:53.968    tsx017124BC  Transaction destroyed!
 00:42:53.984    tsx017254FC  Timeout timer event
 00:42:53.984    tsx017254FC  State changed from Completed to Terminated, event=TIMER
 00:42:53.984    tsx017254FC  Timeout timer event
 00:42:53.984    tsx017254FC  State changed from Terminated to Destroyed, event=TIMER
 00:42:53.984   tdta01711450  Destroying txdata Request msg REGISTER/cseq=24843 (tdta01711450)
 00:42:53.984    tsx017254FC  Transaction destroyed!
 00:42:55.265    pjsua_app.c  ------> current_call=0, call_info.role=1, call_info.state=2
 00:42:56.625    inv0172B45C  SDP negotiation done, status=0
 00:42:56.625   pjsua_call.c  Call 0: remote NAT type is 0 (Unknown)
 00:42:56.640          rtp.c  pjmedia_rtp_session_init: ses=017323E4, default_pt=18, ssrc=0x294823
 00:42:56.640          rtp.c  pjmedia_rtp_session_init: ses=01732B44, default_pt=18, ssrc=0x294823
 00:42:56.640       stream.c  Stream strm01731864 created
 00:42:56.640   strm01731864  Encoder stream started
 00:42:56.640   strm01731864  Decoder stream started
 00:42:56.640  pjsua_media.c  Media updates, stream #0: G729 (sendrecv)
 00:42:56.640   conference.c  Port 2 (ring) stop transmitting to port 0 (SoundMAX HD Audio)
 00:42:56.640   conference.c  Port 3 (sip:8881001 at 192.168.1.188) transmitting to port 0 (SoundMAX HD Audio)
 00:42:56.640   conference.c  Port 0 (SoundMAX HD Audio) transmitting to port 3 (sip:8881001 at 192.168.1.188)
 00:42:56.640    pjsua_app.c  Media for call 0 is active
 00:42:56.640    inv0172B45C  Sending Response msg 200/INVITE/cseq=2 (tdta0172DE50)
 00:42:56.640    dlg0172B45C  Sending Response msg 200/INVITE/cseq=2 (tdta0172DE50)
 00:42:56.640    tsx0172BC64  Sending Response msg 200/INVITE/cseq=2 (tdta0172DE50) in state Proceeding
 00:42:56.640   pjsua_core.c  TX 903 bytes Response msg 200/INVITE/cseq=2 (tdta0172DE50) to UDP 192.168.1.188:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.188;received=192.168.1.188;branch=z9hG4bK56fd.a106065.0
Via: SIP/2.0/UDP 192.168.1.1:6018;rport=6018;received=192.168.1.1;branch=z9hG4bK-d87543-522652435-1--d87543-
Record-Route: <sip:192.168.1.188;lr>
Call-ID: a84bca61c3020f18
From: "8881001" <sip:8881001@192.168.1.188>;tag=726b0e7c
To: <sip:8881088 at 192.168.1.188>;tag=0ab3c2980c744fad83a33d2207e28b1b
CSeq: 2 INVITE
Contact: <sip:8881088 at 192.168.1.88:5060>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
Content-Type: application/sdp
Content-Length:   253

v=0
o=- 3433538572 3433538573 IN IP4 192.168.1.88
s=pjmedia
c=IN IP4 192.168.1.88
t=0 0
a=X-nat:0
m=audio 1604 RTP/AVP 18 101
a=rtcp:1605 IN IP4 192.168.1.88
a=rtpmap:18 G729/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

--end msg--
 00:42:56.656   Master/sound  Underflow, buf_cnt=0, will generate 1 frame
 00:42:56.656    tsx0172BC64  State changed from Proceeding to Completed, event=TX_MSG
 00:42:56.656   strm01731864  Jitter buffer empty (prefetch=0)
 00:42:56.671    dlg0172B45C  Transaction tsx0172BC64 state changed to Completed
 00:42:56.671   strm01731864  Start talksprut..
 00:42:56.671    pjsua_app.c  Call 0 state changed to CONNECTING
 00:42:56.687 sip_endpoint.c  Processing incoming message: Request msg ACK/cseq=2 (rdata0170EE64)
 00:42:56.687   pjsua_core.c  RX 724 bytes Request msg ACK/cseq=2 (rdata0170EE64) from UDP 192.168.1.188:5060:
ACK sip:8881088 at 192.168.1.88:5060 SIP/2.0
To: <sip:8881088 at 192.168.1.188>;tag=0ab3c2980c744fad83a33d2207e28b1b
From: "8881001"<sip:8881001@192.168.1.188>;tag=726b0e7c
Via: SIP/2.0/UDP 192.168.1.188;branch=z9hG4bK56fd.a106065.2
Via: SIP/2.0/UDP 192.168.1.1:6018;received=192.168.1.1;branch=z9hG4bK-d87543-81405630-1--d87543-;rport=6018
Call-ID: a84bca61c3020f18
CSeq: 2 ACK
Contact: <sip:8881001 at 192.168.1.1:6018>
Max-Forwards: 69
Proxy-Authorization: Digest username="8881001",realm="192.168.1.188",nonce="48fcb639000000c8b47d6ef4e42e3ec0490397649553378b",uri="sip:8881088 at 192.168.1.188",response="1d7e47d8f1dfde3b9216ef66a81dfedb",algorithm=MD5
User-Agent: eyeBeam release 3006o stamp 17551
Content-Length: 0


--end msg--
 00:42:56.703    dlg0172B45C  Received Request msg ACK/cseq=2 (rdata0170EE64)
 00:42:56.703    tsx0172BC64  Request to terminate transaction
 00:42:56.703    tsx0172BC64  State changed from Completed to Terminated, event=USER
 00:42:56.703    dlg0172B45C  Transaction tsx0172BC64 state changed to Terminated
 00:42:56.703    pjsua_app.c  Call 0 state changed to CONFIRMED
 00:42:56.703    tsx0172BC64  Timeout timer event
 00:42:56.703    tsx0172BC64  State changed from Terminated to Destroyed, event=TIMER
 00:42:56.703   tdta0172DE50  Destroying txdata Response msg 200/INVITE/cseq=2 (tdta0172DE50)
 00:42:56.703    tsx0172BC64  Transaction destroyed!
 00:42:56.703   strm01731864  RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0
 00:42:56.718   strm01731864  jb updated(2), prefetch=1, size=2
 00:42:56.718   strm01731864  PUT prefetch_cnt=1/1
 00:42:56.734   strm01731864  jb updated(2), prefetch=4, size=4
 00:42:56.750   strm01731864  PUT prefetch_cnt=2/4
 00:42:56.750   strm01731864  PUT prefetch_cnt=3/4
 00:42:56.781   strm01731864  PUT prefetch_cnt=4/4
 00:42:57.234   strm01731864  Jitter buffer empty (prefetch=4)
 00:42:57.859   strm01731864  PUT prefetch_cnt=67/4
 00:42:57.875   strm01731864  Internal RTCP NTP clock skew detected: lsr=A4103C28, now=A4113C28, dlsr=2C1DFF3B (11293:996ms), diff=740097851
 00:42:59.203 sip_endpoint.c  Processing incoming message: Request msg INVITE/cseq=3 (rdata0170EE64)
 00:42:59.203   pjsua_core.c  RX 1075 bytes Request msg INVITE/cseq=3 (rdata0170EE64) from UDP 192.168.1.188:5060:
INVITE sip:8881088 at 192.168.1.88:5060 SIP/2.0
To: <sip:8881088 at 192.168.1.188>;tag=0ab3c2980c744fad83a33d2207e28b1b
From: "8881001"<sip:8881001@192.168.1.188>;tag=726b0e7c
Via: SIP/2.0/UDP 192.168.1.188;branch=z9hG4bK66fd.4c7363a2.0
Via: SIP/2.0/UDP 192.168.1.1:6018;received=192.168.1.1;branch=z9hG4bK-d87543-72762978-1--d87543-;rport=6018
Call-ID: a84bca61c3020f18
CSeq: 3 INVITE
Contact: <sip:8881001 at 192.168.1.1:6018>
Max-Forwards: 69
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
Content-Type: application/sdp
Proxy-Authorization: Digest username="8881001",realm="192.168.1.188",nonce="48fcb639000000c8b47d6ef4e42e3ec0490397649553378b",uri="sip:8881088 at 192.168.1.88:5060",response="a5ee29e5d91e76b10a7c6a687724eafa",algorithm=MD5
User-Agent: eyeBeam release 3006o stamp 17551
Content-Length: 224

v=0
o=- 11288688 11295312 IN IP4 192.168.1.1
s=eyeBeam
c=IN IP4 0.0.0.0
t=0 0
m=audio 6020 RTP/AVP 18 101
a=alt:1 1 : B4FF5CF7 0000004F 192.168.1.1 6020
a=fmtp:101 0-15
a=rtpmap:101 telephone-event/8000
a=sendonly

--end msg--
 00:42:59.218   strm01731864  Jitter buffer empty (prefetch=4)
 00:42:59.218    dlg0172B45C  Received Request msg INVITE/cseq=3 (rdata0170EE64)
 00:42:59.218    tsx0172BC64  Transaction created for Request msg INVITE/cseq=3 (rdata0170EE64)
 00:42:59.218    tsx0172BC64  Incoming Request msg INVITE/cseq=3 (rdata0170EE64) in state Null
 00:42:59.218    tsx0172BC64  State changed from Null to Trying, event=RX_MSG
 00:42:59.218    dlg0172B45C  Transaction tsx0172BC64 state changed to Trying
 00:42:59.218    inv0172B45C  Got SDP offer in Request msg INVITE/cseq=3 (rdata0170EE64)
 00:42:59.218   pjsua_call.c  Call 0: received updated media offer
 00:42:59.218       endpoint  Response msg 200/INVITE/cseq=3 (tdta0173D310) created
 00:42:59.218    inv0172B45C  SDP negotiation done, status=0
 00:42:59.218   pjsua_call.c  Call 0: remote NAT type is 0 (Unknown)
 00:42:59.218  pjsua_media.c  Media session for call 0 is destroyed
 00:42:59.218        icetp00  Stopping ICE, reason=media stop requested
 00:42:59.218  pjsua_media.c  Media updates, stream #0: G729 (inactive)
 00:42:59.218    pjsua_app.c  Media for call 0 is inactive
 00:42:59.218    inv0172B45C  Sending Response msg 200/INVITE/cseq=3 (tdta0173D310)
 00:42:59.218    dlg0172B45C  Sending Response msg 200/INVITE/cseq=3 (tdta0173D310)
 00:42:59.218    tsx0172BC64  Sending Response msg 200/INVITE/cseq=3 (tdta0173D310) in state Trying
 00:42:59.218  sip_resolve.c  Target '192.168.1.188:5060' type=UDP resolved to '192.168.1.188:5060' type=UDP (UDP transport)
 00:42:59.218   pjsua_core.c  TX 860 bytes Response msg 200/INVITE/cseq=3 (tdta0173D310) to UDP 192.168.1.188:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.188;received=192.168.1.188;branch=z9hG4bK66fd.4c7363a2.0
Via: SIP/2.0/UDP 192.168.1.1:6018;rport=6018;received=192.168.1.1;branch=z9hG4bK-d87543-72762978-1--d87543-
Call-ID: a84bca61c3020f18
From: "8881001" <sip:8881001@192.168.1.188>;tag=726b0e7c
To: <sip:8881088 at 192.168.1.188>;tag=0ab3c2980c744fad83a33d2207e28b1b
CSeq: 3 INVITE
Contact: <sip:8881088 at 192.168.1.88:5060>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
Content-Type: application/sdp
Content-Length:   248

v=0
o=- 3433538579 3433538574 IN IP4 192.168.1.88
s=pjmedia
c=IN IP4 0.0.0.0
t=0 0
a=X-nat:0
m=audio 1604 RTP/AVP 18 101
a=rtcp:1605 IN IP4 192.168.1.88
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=recvonly

--end msg--
 00:42:59.234    tsx0172BC64  State changed from Trying to Completed, event=TX_MSG
 00:42:59.234    dlg0172B45C  Transaction tsx0172BC64 state changed to Completed
 00:42:59.250 sip_endpoint.c  Processing incoming message: Request msg ACK/cseq=3 (rdata0170EE64)
 00:42:59.250   pjsua_core.c  RX 730 bytes Request msg ACK/cseq=3 (rdata0170EE64) from UDP 192.168.1.188:5060:
ACK sip:8881088 at 192.168.1.88:5060 SIP/2.0
To: <sip:8881088 at 192.168.1.188>;tag=0ab3c2980c744fad83a33d2207e28b1b
From: "8881001"<sip:8881001@192.168.1.188>;tag=726b0e7c
Via: SIP/2.0/UDP 192.168.1.188;branch=z9hG4bK66fd.4c7363a2.2
Via: SIP/2.0/UDP 192.168.1.1:6018;received=192.168.1.1;branch=z9hG4bK-d87543-665597542-1--d87543-;rport=6018
Call-ID: a84bca61c3020f18
CSeq: 3 ACK
Contact: <sip:8881001 at 192.168.1.1:6018>
Max-Forwards: 69
Proxy-Authorization: Digest username="8881001",realm="192.168.1.188",nonce="48fcb639000000c8b47d6ef4e42e3ec0490397649553378b",uri="sip:8881088 at 192.168.1.88:5060",response="a5ee29e5d91e76b10a7c6a687724eafa",algorithm=MD5
User-Agent: eyeBeam release 3006o stamp 17551
Content-Length: 0


--end msg--
 00:42:59.265    dlg0172B45C  Received Request msg ACK/cseq=3 (rdata0170EE64)
 00:42:59.265    tsx0172BC64  Request to terminate transaction
 00:42:59.265    tsx0172BC64  State changed from Completed to Terminated, event=USER
 00:42:59.265    dlg0172B45C  Transaction tsx0172BC64 state changed to Terminated
 00:42:59.265    tsx0172BC64  Timeout timer event
 00:42:59.265    tsx0172BC64  State changed from Terminated to Destroyed, event=TIMER
 00:42:59.265   tdta0173D310  Destroying txdata Response msg 200/INVITE/cseq=3 (tdta0173D310)
 00:42:59.265    tsx0172BC64  Transaction destroyed!
 00:43:00.125 sip_endpoint.c  Processing incoming message: Request msg INVITE/cseq=2 (rdata0170EE64)
 00:43:00.125   pjsua_core.c  RX 901 bytes Request msg INVITE/cseq=2 (rdata0170EE64) from UDP 192.168.1.188:5060:
INVITE sip:8881088 at 192.168.1.88:5060 SIP/2.0
Record-Route: <sip:192.168.1.188;lr=on>
To: <sip:8881088 at 192.168.1.188>
From: 8881001<sip:8881001@192.168.1.188>;tag=6723c710
Via: SIP/2.0/UDP 192.168.1.188;branch=z9hG4bK32e4.9f6eb085.0
Via: SIP/2.0/UDP 192.168.1.1:6018;received=192.168.1.1;branch=z9hG4bK-d87543-671376826-1--d87543-;rport=6018
Call-ID: 2550eb25970e5659
CSeq: 2 INVITE
Contact: <sip:8881001 at 192.168.1.1:6018>
Max-Forwards: 69
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
Content-Type: application/sdp
User-Agent: eyeBeam release 3006o stamp 17551
Content-Length: 268

v=0
o=- 11296195 11296220 IN IP4 192.168.1.1
s=eyeBeam
c=IN IP4 192.168.1.1
t=0 0
m=audio 6024 RTP/AVP 18 8 0 3 100 6 5 101
a=alt:1 1 : 912A41ED 00000018 192.168.1.1 6024
a=fmtp:101 0-15
a=rtpmap:100 speex/16000
a=rtpmap:101 telephone-event/8000
a=sendrecv

--end msg--
 00:43:00.140  pjsua_media.c  Media index 0 selected for call 1
 00:43:00.140        icetp01  ICE session created, comp_cnt=2, role is Controlled agent
 00:43:00.140        icetp01  Candidate 0 added: comp_id=1, type=host, foundation=H, addr=192.168.1.88:1606, base=192.168.1.88:1606, prio=0x27 (39)
 00:43:00.140        icetp01  Candidate 1 added: comp_id=2, type=host, foundation=H, addr=192.168.1.88:1607, base=192.168.1.88:1607, prio=0x26 (38)
 00:43:00.140        icetp01  Stopping ICE, reason=No ICE found in SDP offer
 00:43:00.140        icetp01  Destroying ICE session
 00:43:00.140    tsx01729104  Transaction created for Request msg INVITE/cseq=2 (rdata0170EE64)
 00:43:00.140    tsx01729104  Incoming Request msg INVITE/cseq=2 (rdata0170EE64) in state Null
 00:43:00.140    tsx01729104  State changed from Null to Trying, event=RX_MSG
 00:43:00.140    dlg0173F52C  Transaction tsx01729104 state changed to Trying
 00:43:00.156    dlg0173F52C  UAS dialog created
 00:43:00.156    dlg0173F52C  Module mod-invite added as dialog usage, data=0173DFC4
 00:43:00.156    dlg0173F52C  Session count inc to 2 by mod-invite
 00:43:00.156    inv0173F52C  UAS invite session created for dialog dlg0173F52C
 00:43:00.156   pjsua_call.c  Call 1: remote NAT type is 0 (Unknown)
 00:43:00.156       endpoint  Response msg 100/INVITE/cseq=2 (tdta01730EF0) created
 00:43:00.156    dlg0173F52C  Initial answer Response msg 100/INVITE/cseq=2 (tdta01730EF0)
 00:43:00.156    inv0173F52C  Sending Response msg 100/INVITE/cseq=2 (tdta01730EF0)
 00:43:00.156    dlg0173F52C  Sending Response msg 100/INVITE/cseq=2 (tdta01730EF0)
 00:43:00.156    tsx01729104  Sending Response msg 100/INVITE/cseq=2 (tdta01730EF0) in state Trying
 00:43:00.156  sip_resolve.c  Target '192.168.1.188:5060' type=UDP resolved to '192.168.1.188:5060' type=UDP (UDP transport)
 00:43:00.156   pjsua_core.c  TX 409 bytes Response msg 100/INVITE/cseq=2 (tdta01730EF0) to UDP 192.168.1.188:5060:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.188;received=192.168.1.188;branch=z9hG4bK32e4.9f6eb085.0
Via: SIP/2.0/UDP 192.168.1.1:6018;rport=6018;received=192.168.1.1;branch=z9hG4bK-d87543-671376826-1--d87543-
Record-Route: <sip:192.168.1.188;lr>
Call-ID: 2550eb25970e5659
From: "8881001" <sip:8881001@192.168.1.188>;tag=6723c710
To: <sip:8881088 at 192.168.1.188>
CSeq: 2 INVITE
Content-Length:  0


--end msg--
 00:43:00.171    tsx01729104  State changed from Trying to Proceeding, event=TX_MSG
 00:43:00.171    dlg0173F52C  Transaction tsx01729104 state changed to Proceeding
 00:43:00.171    pjsua_app.c  Call 1 state changed to INCOMING
 00:43:00.171   conference.c  Port 2 (ring) transmitting to port 0 (SoundMAX HD Audio)
 00:43:00.171    pjsua_app.c  Incoming call for account 2!
From: "8881001" <sip:8881001@192.168.1.188>
To: <sip:8881088 at 192.168.1.188>
Press a to answer or h to reject call
 00:43:03.421    pjsua_app.c  ------> current_call=0, call_info.role=1, call_info.state=5
 00:43:03.421    pjsua_app.c  ------> No pending incoming call
 00:43:03.984    pjsua_acc.c  Sending 2 bytes keep-alive packet for acc 2 to 192.168.1.188:5060
 00:43:03.984   tdta01731EF8  Destroying txdata raw
 00:43:05.140    pjsua_app.c  ------> current_call=0, call_info.role=1, call_info.state=5
 00:43:05.156    pjsua_app.c  ------> No pending incoming call
 00:43:05.843    pjsua_app.c  ------> current_call=0, call_info.role=1, call_info.state=5
 00:43:05.843    pjsua_app.c  ------> No pending incoming call
 00:43:09.750          pjsua  Thread stack max usage=6393 by ..\src\pj\string.c:173
 00:43:09.750       endpoint  Request msg BYE/cseq=19836 (tdta01731EF8) created.
 00:43:09.750    inv0172B45C  Sending Request msg BYE/cseq=19836 (tdta01731EF8)
 00:43:09.750    dlg0172B45C  Sending Request msg BYE/cseq=19836 (tdta01731EF8)
 00:43:09.750    tsx0173E584  Transaction created for Request msg BYE/cseq=19835 (tdta01731EF8)
 00:43:09.750    tsx0173E584  Sending Request msg BYE/cseq=19835 (tdta01731EF8) in state Null
 00:43:09.750  sip_resolve.c  Target '192.168.1.188:0' type=Unspecified resolved to '192.168.1.188:5060' type=UDP (UDP transport)
 00:43:09.750   pjsua_core.c  TX 406 bytes Request msg BYE/cseq=19835 (tdta01731EF8) to UDP 192.168.1.188:5060:
BYE sip:8881001 at 192.168.1.1:6018 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.88:5060;rport;branch=z9hG4bKPj4ce3075c0d834f61a70faa91df2ea697
Max-Forwards: 70
From: <sip:8881088@192.168.1.188>;tag=0ab3c2980c744fad83a33d2207e28b1b
To: "8881001" <sip:8881001 at 192.168.1.188>;tag=726b0e7c
Call-ID: a84bca61c3020f18
CSeq: 19835 BYE
Route: <sip:192.168.1.188;lr>
User-Agent: PJSUA v1.0/win32
Content-Length:  0


--end msg--
 00:43:09.765    tsx0173E584  State changed from Null to Calling, event=TX_MSG
 00:43:09.765    dlg0172B45C  Transaction tsx0173E584 state changed to Calling
 00:43:09.765    inv0173F52C  Sending Response msg 603/INVITE/cseq=2 (tdta01730EF0)
 00:43:09.765    dlg0173F52C  Sending Response msg 603/INVITE/cseq=2 (tdta01730EF0)
 00:43:09.765    tsx01729104  Sending Response msg 603/INVITE/cseq=2 (tdta01730EF0) in state Proceeding
 00:43:09.765   pjsua_core.c  TX 447 bytes Response msg 603/INVITE/cseq=2 (tdta01730EF0) to UDP 192.168.1.188:5060:
SIP/2.0 603 Decline
Via: SIP/2.0/UDP 192.168.1.188;received=192.168.1.188;branch=z9hG4bK32e4.9f6eb085.0
Via: SIP/2.0/UDP 192.168.1.1:6018;rport=6018;received=192.168.1.1;branch=z9hG4bK-d87543-671376826-1--d87543-
Record-Route: <sip:192.168.1.188;lr>
Call-ID: 2550eb25970e5659
From: "8881001" <sip:8881001@192.168.1.188>;tag=6723c710
To: <sip:8881088 at 192.168.1.188>;tag=e826a72e92ec4d70a20cad224181f250
CSeq: 2 INVITE
Content-Length:  0


--end msg--
 00:43:09.765    tsx01729104  State changed from Proceeding to Completed, event=TX_MSG
 00:43:09.765    dlg0173F52C  Transaction tsx01729104 state changed to Completed
 00:43:09.781    pjsua_app.c  Call 1 is DISCONNECTED [reason=603 (Decline)]
 00:43:09.781    pjsua_app.c  Call 1 disconnected, dumping media stats..
 00:43:09.781    pjsua_app.c  
  [DISCONNCTD] To: "8881001" <sip:8881001 at 192.168.1.188>;tag=6723c710
    Call time: 00h:00m:00s, 1st res in 9641 ms, conn in 0ms
    SRTP status: Not active Crypto-suite: (null)
 00:43:09.781        icetp01  Stopping ICE, reason=media stop requested
 00:43:09.781    dlg0173F52C  Session count dec to 3 by mod-invite
 00:43:09.781       endpoint  Request msg REGISTER/cseq=24843 (tdta01727150) created.
 00:43:09.781    tsx017281BC  Transaction created for Request msg REGISTER/cseq=24844 (tdta01727150)
 00:43:09.781    tsx017281BC  Sending Request msg REGISTER/cseq=24844 (tdta01727150) in state Null
 00:43:09.781  sip_resolve.c  Target '192.168.1.188:0' type=Unspecified resolved to '192.168.1.188:5060' type=UDP (UDP transport)
 00:43:09.781   pjsua_core.c  TX 421 bytes Request msg REGISTER/cseq=24844 (tdta01727150) to UDP 192.168.1.188:5060:
REGISTER sip:192.168.1.188 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.88:5060;rport;branch=z9hG4bKPj6da2c1344aba4f69bf8591a3d96f636a
Max-Forwards: 70
From: <sip:8881088@192.168.1.188>;tag=1710c126847c47788d4a7d64e7769b6e
To: <sip:8881088 at 192.168.1.188>
Call-ID: 1f4c67a4c0664a249145c383ea4579bb
CSeq: 24844 REGISTER
User-Agent: PJSUA v1.0/win32
Contact: <sip:8881088 at 192.168.1.88:5060>
Expires: 0
Content-Length:  0


--end msg--
 00:43:09.796    tsx017281BC  State changed from Null to Calling, event=TX_MSG
 00:43:09.796    pjsua_acc.c  Unregistration sent
 00:43:09.796  pjsua_media.c  Closing (null) sound playback device and (null) sound capture device
 00:43:09.812      pasound.c  Stopping stream..
 00:43:09.812      pasound.c  PA message: WinMME StopStream: waiting for background thread.

 00:43:09.906      pasound.c  PA message: WinMME StopStream: waiting for background thread.

 00:43:09.906      pasound.c  Done, status=0
 00:43:09.906      pasound.c  Closing SoundMAX HD Audio: 0 underflow, 1 overflow
 00:43:09.906        icetp00  ICE stream transport destroyed
 00:43:09.906        icetp01  ICE stream transport destroyed
 00:43:09.906        icetp02  ICE stream transport destroyed
 00:43:09.906        icetp03  ICE stream transport destroyed
 00:43:10.406          media  Thread stack max usage=0 by (null):0
 00:43:10.406      pasound.c  PortAudio sound library shutting down..
 00:43:10.406      pasound.c  PA message: TerminateHostApis in 

 00:43:10.406      pasound.c  PA message: TerminateHostApis out

 00:43:10.406   pjsua_core.c  Shutting down...
 00:43:10.406    tsx0173E584  Retransmit timer event
 00:43:10.406    tsx0173E584  Retransmiting Request msg BYE/cseq=19835 (tdta01731EF8), count=0, restart?=1
 00:43:10.406   pjsua_core.c  TX 406 bytes Request msg BYE/cseq=19835 (tdta01731EF8) to UDP 192.168.1.188:5060:
BYE sip:8881001 at 192.168.1.1:6018 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.88:5060;rport;branch=z9hG4bKPj4ce3075c0d834f61a70faa91df2ea697
Max-Forwards: 70
From: <sip:8881088@192.168.1.188>;tag=0ab3c2980c744fad83a33d2207e28b1b
To: "8881001" <sip:8881001 at 192.168.1.188>;tag=726b0e7c
Call-ID: a84bca61c3020f18
CSeq: 19835 BYE
Route: <sip:192.168.1.188;lr>
User-Agent: PJSUA v1.0/win32
Content-Length:  0


--end msg--
 00:43:10.406    tsx01729104  Retransmit timer event
 00:43:10.406    tsx01729104  Retransmiting Response msg 603/INVITE/cseq=2 (tdta01730EF0), count=0, restart?=1
 00:43:10.406   pjsua_core.c  TX 447 bytes Response msg 603/INVITE/cseq=2 (tdta01730EF0) to UDP 192.168.1.188:5060:
SIP/2.0 603 Decline
Via: SIP/2.0/UDP 192.168.1.188;received=192.168.1.188;branch=z9hG4bK32e4.9f6eb085.0
Via: SIP/2.0/UDP 192.168.1.1:6018;rport=6018;received=192.168.1.1;branch=z9hG4bK-d87543-671376826-1--d87543-
Record-Route: <sip:192.168.1.188;lr>
Call-ID: 2550eb25970e5659
From: "8881001" <sip:8881001@192.168.1.188>;tag=6723c710
To: <sip:8881088 at 192.168.1.188>;tag=e826a72e92ec4d70a20cad224181f250
CSeq: 2 INVITE
Content-Length:  0


--end msg--
 00:43:10.421    tsx017281BC  Retransmit timer event
 00:43:10.421    tsx017281BC  Retransmiting Request msg REGISTER/cseq=24844 (tdta01727150), count=0, restart?=1
 00:43:10.421   pjsua_core.c  TX 421 bytes Request msg REGISTER/cseq=24844 (tdta01727150) to UDP 192.168.1.188:5060:
REGISTER sip:192.168.1.188 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.88:5060;rport;branch=z9hG4bKPj6da2c1344aba4f69bf8591a3d96f636a
Max-Forwards: 70
From: <sip:8881088@192.168.1.188>;tag=1710c126847c47788d4a7d64e7769b6e
To: <sip:8881088 at 192.168.1.188>
Call-ID: 1f4c67a4c0664a249145c383ea4579bb
CSeq: 24844 REGISTER
User-Agent: PJSUA v1.0/win32
Contact: <sip:8881088 at 192.168.1.88:5060>
Expires: 0
Content-Length:  0


--end msg--
 00:43:10.421 sip_endpoint.c  Processing incoming message: Response msg 200/BYE/cseq=19835 (rdata0170EE64)
 00:43:10.437   pjsua_core.c  RX 367 bytes Response msg 200/BYE/cseq=19835 (rdata0170EE64) from UDP 192.168.1.188:5060:
SIP/2.0 200 OK
To: "8881001"<sip:8881001 at 192.168.1.188>;tag=726b0e7c
From: <sip:8881088@192.168.1.188>;tag=0ab3c2980c744fad83a33d2207e28b1b
Via: SIP/2.0/UDP 192.168.1.88:5060;received=192.168.1.88;rport=5060;branch=z9hG4bKPj4ce3075c0d834f61a70faa91df2ea697
Call-ID: a84bca61c3020f18
CSeq: 19835 BYE
Contact: <sip:8881001 at 192.168.1.1:6018>
Content-Length: 0


--end msg--
 00:43:10.437    tsx0173E584  Incoming Response msg 200/BYE/cseq=19835 (rdata0170EE64) in state Calling
 00:43:10.437    tsx0173E584  State changed from Calling to Completed, event=RX_MSG
 00:43:10.437    dlg0172B45C  Received Response msg 200/BYE/cseq=19835 (rdata0170EE64)
 00:43:10.437    dlg0172B45C  Transaction tsx0173E584 state changed to Completed
 00:43:10.437    pjsua_app.c  Call 0 is DISCONNECTED [reason=200 (Normal call clearing)]
 00:43:10.437    pjsua_app.c  Call 0 disconnected, dumping media stats..
 00:43:10.437    pjsua_app.c  
  [DISCONNCTD] To: "8881001" <sip:8881001 at 192.168.1.188>;tag=726b0e7c
    Call time: 00h:00m:13s, 1st res in 4016 ms, conn in 4094ms
 00:43:10.437    dlg0172B45C  Session count dec to 1 by mod-invite
 00:43:10.437 sip_endpoint.c  Processing incoming message: Request msg ACK/cseq=2 (rdata0170EE64)
 00:43:10.453   pjsua_core.c  RX 358 bytes Request msg ACK/cseq=2 (rdata0170EE64) from UDP 192.168.1.188:5060:
ACK sip:8881088 at 192.168.1.88:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.188;branch=z9hG4bK32e4.9f6eb085.0
From: 8881001<sip:8881001@192.168.1.188>;tag=6723c710
Call-ID: 2550eb25970e5659
To: <sip:8881088 at 192.168.1.188>;tag=e826a72e92ec4d70a20cad224181f250
CSeq: 2 ACK
Max-Forwards: 70
User-Agent: OpenSIPS (1.4.2-notls (i386/linux))
Content-Length: 0


--end msg--
 00:43:10.453    tsx01729104  Incoming Request msg ACK/cseq=2 (rdata0170EE64) in state Completed
 00:43:10.453    tsx01729104  State changed from Completed to Confirmed, event=RX_MSG
 00:43:10.453    dlg0173F52C  Transaction tsx01729104 state changed to Confirmed
 00:43:10.453 sip_endpoint.c  Processing incoming message: Response msg 401/REGISTER/cseq=24844 (rdata0170EE64)
 00:43:10.453   pjsua_core.c  RX 506 bytes Response msg 401/REGISTER/cseq=24844 (rdata0170EE64) from UDP 192.168.1.188:5060:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.1.88:5060;rport=5060;branch=z9hG4bKPj6da2c1344aba4f69bf8591a3d96f636a
From: <sip:8881088@192.168.1.188>;tag=1710c126847c47788d4a7d64e7769b6e
To: <sip:8881088 at 192.168.1.188>;tag=2c11ccde4a65ba314834801c074cdedf.2768
Call-ID: 1f4c67a4c0664a249145c383ea4579bb
CSeq: 24844 REGISTER
WWW-Authenticate: Digest realm="192.168.1.188", nonce="48fcb64a000000caab5fab1977c23ac3438534d2d262b8e4"
Server: OpenSIPS (1.4.2-notls (i386/linux))
Content-Length: 0


--end msg--
 00:43:10.468    tsx017281BC  Incoming Response msg 401/REGISTER/cseq=24844 (rdata0170EE64) in state Calling
 00:43:10.468    tsx017281BC  State changed from Calling to Completed, event=RX_MSG
 00:43:10.468    tsx017154DC  Transaction created for Request msg REGISTER/cseq=24845 (tdta01727150)
 00:43:10.468    tsx017154DC  Sending Request msg REGISTER/cseq=24845 (tdta01727150) in state Null
 00:43:10.468  sip_resolve.c  Target '192.168.1.188:0' type=Unspecified resolved to '192.168.1.188:5060' type=UDP (UDP transport)
 00:43:10.468   pjsua_core.c  TX 614 bytes Request msg REGISTER/cseq=24845 (tdta01727150) to UDP 192.168.1.188:5060:
REGISTER sip:192.168.1.188 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.88:5060;rport;branch=z9hG4bKPjc5477a94c3574f559510b493e4426033
Max-Forwards: 70
From: <sip:8881088@192.168.1.188>;tag=1710c126847c47788d4a7d64e7769b6e
To: <sip:8881088 at 192.168.1.188>
Call-ID: 1f4c67a4c0664a249145c383ea4579bb
CSeq: 24845 REGISTER
User-Agent: PJSUA v1.0/win32
Contact: <sip:8881088 at 192.168.1.88:5060>
Expires: 0
Authorization: Digest username="8881088", realm="192.168.1.188", nonce="48fcb64a000000caab5fab1977c23ac3438534d2d262b8e4", uri="sip:192.168.1.188", response="77a8969bd3a9683f72019d6844a8e12d"
Content-Length:  0


--end msg--
 00:43:10.484    tsx017154DC  State changed from Null to Calling, event=TX_MSG
 00:43:10.484 sip_endpoint.c  Processing incoming message: Response msg 200/BYE/cseq=19835 (rdata0170EE64)
 00:43:10.484   pjsua_core.c  RX 367 bytes Response msg 200/BYE/cseq=19835 (rdata0170EE64) from UDP 192.168.1.188:5060:
SIP/2.0 200 OK
To: "8881001"<sip:8881001 at 192.168.1.188>;tag=726b0e7c
From: <sip:8881088@192.168.1.188>;tag=0ab3c2980c744fad83a33d2207e28b1b
Via: SIP/2.0/UDP 192.168.1.88:5060;received=192.168.1.88;rport=5060;branch=z9hG4bKPj4ce3075c0d834f61a70faa91df2ea697
Call-ID: a84bca61c3020f18
CSeq: 19835 BYE
Contact: <sip:8881001 at 192.168.1.1:6018>
Content-Length: 0


--end msg--
 00:43:10.484    tsx0173E584  Incoming Response msg 200/BYE/cseq=19835 (rdata0170EE64) in state Completed
 00:43:10.484 sip_endpoint.c  Processing incoming message: Request msg ACK/cseq=2 (rdata0170EE64)
 00:43:10.484   pjsua_core.c  RX 358 bytes Request msg ACK/cseq=2 (rdata0170EE64) from UDP 192.168.1.188:5060:
ACK sip:8881088 at 192.168.1.88:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.188;branch=z9hG4bK32e4.9f6eb085.0
From: 8881001<sip:8881001@192.168.1.188>;tag=6723c710
Call-ID: 2550eb25970e5659
To: <sip:8881088 at 192.168.1.188>;tag=e826a72e92ec4d70a20cad224181f250
CSeq: 2 ACK
Max-Forwards: 70
User-Agent: OpenSIPS (1.4.2-notls (i386/linux))
Content-Length: 0


--end msg--
 00:43:10.500    tsx01729104  Incoming Request msg ACK/cseq=2 (rdata0170EE64) in state Confirmed
 00:43:10.500 sip_endpoint.c  Processing incoming message: Response msg 401/REGISTER/cseq=24844 (rdata0170EE64)
 00:43:10.500   pjsua_core.c  RX 506 bytes Response msg 401/REGISTER/cseq=24844 (rdata0170EE64) from UDP 192.168.1.188:5060:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.1.88:5060;rport=5060;branch=z9hG4bKPj6da2c1344aba4f69bf8591a3d96f636a
From: <sip:8881088@192.168.1.188>;tag=1710c126847c47788d4a7d64e7769b6e
To: <sip:8881088 at 192.168.1.188>;tag=2c11ccde4a65ba314834801c074cdedf.2768
Call-ID: 1f4c67a4c0664a249145c383ea4579bb
CSeq: 24844 REGISTER
WWW-Authenticate: Digest realm="192.168.1.188", nonce="48fcb64b000000cb029ad5c6639bb0dab9510f6121a4d437"
Server: OpenSIPS (1.4.2-notls (i386/linux))
Content-Length: 0


--end msg--
 00:43:10.500    tsx017281BC  Incoming Response msg 401/REGISTER/cseq=24844 (rdata0170EE64) in state Completed
 00:43:10.500 sip_endpoint.c  Processing incoming message: Response msg 200/REGISTER/cseq=24845 (rdata0170EE64)
 00:43:10.500   pjsua_core.c  RX 390 bytes Response msg 200/REGISTER/cseq=24845 (rdata0170EE64) from UDP 192.168.1.188:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.88:5060;rport=5060;branch=z9hG4bKPjc5477a94c3574f559510b493e4426033
From: <sip:8881088@192.168.1.188>;tag=1710c126847c47788d4a7d64e7769b6e
To: <sip:8881088 at 192.168.1.188>;tag=2c11ccde4a65ba314834801c074cdedf.0f1b
Call-ID: 1f4c67a4c0664a249145c383ea4579bb
CSeq: 24845 REGISTER
Server: OpenSIPS (1.4.2-notls (i386/linux))
Content-Length: 0


--end msg--
 00:43:10.515    tsx017154DC  Incoming Response msg 200/REGISTER/cseq=24845 (rdata0170EE64) in state Calling
 00:43:10.515    tsx017154DC  State changed from Calling to Completed, event=RX_MSG
 00:43:10.515    pjsua_acc.c  sip:8881088 at 192.168.1.188: unregistration success
 00:43:10.515    tsx01729104  Timeout timer event
 00:43:10.515    tsx01729104  State changed from Confirmed to Terminated, event=TIMER
 00:43:10.515    dlg0173F52C  Transaction tsx01729104 state changed to Terminated
 00:43:10.515    dlg0173F52C  Dialog destroyed
 00:43:10.515    tsx01729104  Timeout timer event
 00:43:10.515    tsx01729104  State changed from Terminated to Destroyed, event=TIMER
 00:43:10.515   tdta01730EF0  Destroying txdata Response msg 603/INVITE/cseq=2 (tdta01730EF0)
 00:43:10.515    tsx01729104  Transaction destroyed!
 00:43:11.406   pjsua_core.c  Destroying...
 00:43:11.406 sip_endpoint.c  Destroying endpoing instance..
 00:43:11.406 sip_transactio  Stopping transaction layer module
 00:43:11.406    tsx017154DC  Request to terminate transaction
 00:43:11.406    tsx017154DC  State changed from Completed to Terminated, event=USER
 00:43:11.406    tsx017154DC  Transaction destroyed!
 00:43:11.406    tsx0173E584  Request to terminate transaction
 00:43:11.406    tsx0173E584  State changed from Completed to Terminated, event=USER
 00:43:11.406    dlg0172B45C  Transaction tsx0173E584 state changed to Terminated
 00:43:11.406    dlg0172B45C  Dialog destroyed
 00:43:11.406   tdta01731EF8  Destroying txdata Request msg BYE/cseq=19835 (tdta01731EF8)
 00:43:11.406    tsx0173E584  Transaction destroyed!
 00:43:11.406    tsx017281BC  Request to terminate transaction
 00:43:11.406    tsx017281BC  State changed from Completed to Terminated, event=USER
 00:43:11.406   tdta01727150  Destroying txdata Request msg REGISTER/cseq=24845 (tdta01727150)
 00:43:11.406    tsx017281BC  Transaction destroyed!
 00:43:11.406 sip_endpoint.c  Module "mod-pjsua-options" unregistered
 00:43:11.406 sip_endpoint.c  Module "mod-pjsua-im" unregistered
 00:43:11.406 sip_endpoint.c  Module "mod-pjsua-pres" unregistered
 00:43:11.406 sip_endpoint.c  Module "mod-pjsua" unregistered
 00:43:11.406 sip_endpoint.c  Module "mod-stateful-util" unregistered
 00:43:11.406 sip_endpoint.c  Module "mod-refer" unregistered
 00:43:11.421 sip_endpoint.c  Module "mod-presence" unregistered
 00:43:11.421 sip_endpoint.c  Module "mod-evsub" unregistered
 00:43:11.421 sip_endpoint.c  Module "mod-invite" unregistered
 00:43:11.421 sip_endpoint.c  Module "mod-100rel" unregistered
 00:43:11.421 sip_endpoint.c  Module "mod-ua" unregistered
 00:43:11.421 sip_transactio  Transaction layer module destroyed
 00:43:11.421 sip_endpoint.c  Module "mod-tsx-layer" unregistered
 00:43:11.421 sip_endpoint.c  Module "mod-msg-print" unregistered
 00:43:11.421 sip_endpoint.c  Module "mod-pjsua-log" unregistered
 00:43:11.421 sip_transport.  Destroying transport manager
 00:43:11.437    tcplis:5060  SIP TCP listener destroyed
 00:43:11.437 sip_endpoint.c  Endpoint 00585954 destroyed
 00:43:11.437   pjsua_core.c  PJSUA destroyed...

__________________________________________________
Do You Yahoo!?
Tired of spam?  Yahoo! Mail has the best spam protection around 
http://mail.yahoo.com 



[Index of Archives]     [Asterisk Users]     [Asterisk App Development]     [Linux ARM Kernel]     [Linux ARM]     [Linux Omap]     [Fedora ARM]     [IETF Annouce]     [Security]     [Bugtraq]     [Linux]     [Linux OMAP]     [Linux MIPS]     [Linux API]
  Powered by Linux