Hi, Try increasing PJSIP_MAX_PKT_LEN (default 4000). I think you may be going over that, the SDP is 2660 bytes and the header has a lot of Record-Route lines. I find it surprising that it works correctly using UDP. Bill On 6/26/2014 4:51 PM, Swinney C. wrote: > Further to this, I have one more oddity to throw into the mix. > > The VCS's are able to interwork SIP <----> H.323 (and vice versa) and so if we have PJSUA registered to the VCS using TCP or TLS, and the MCU make an H.323 call instead of SIP call, the VCS will interwork H.323 --> SIP and the call is placed successfully. > > Chris > > _____________________________________________ > From: Swinney C. > Sent: 26 June 2014 19:15 > To: pjsip at lists.pjsip.org > Subject: Possible bug (Buffer overflow) - PJSUA unable to handle SIP message sent via Cisco 8510 MCU when registered to a Cisco VCS via TCP/TLS > > > Hi all, > > We are trying to get PJSIP and the PJSUA application working when we register to an account via either TCP or TLS transport. The Registrar is a Cisco VCS and we are trying to accept an inbound call initiated from a Cisco 8510 MCU. PJSIP is running on version 2.2.1 on a Raspberry Pi running Raspian. > > If we register PJSUA to the VCS using UDP as the transport, we can accept a call from the MCU with no issue. However, if we try to register via TCP as the transport mechanism to the VCS and make the same call from the same MCU, PJSUA is unable to handle the message and says there is a buffer overflow. Is there anything we can do to rectify this? > > For reference, I have included below the relevant log sections (level 5) from the failed call and the good call (obscure IP address and URIs). If there is anything else that might help (such as high level logs or packet captures), then let us know: > > > Log from FAILED inbound call when registered via TCP transport > > 08:53:02.110 sip_endpoint.c Error processing packet from 222.222.222.1:5060: Rx buffer overflow (PJSIP_ERXOVERFLOW) [code 171062]: > INVITE sip:pi at 222.222.222.222:5060;transport=TCP;ob SIP/2.0 > Via: SIP/2.0/TCP 222.222.222.1:5060;egress-zone=DefaultSubZone;branch=z9hG4bK2539fce0618acc914d081ece26433f06907450.e8169c45cc678bd159754752343056b4;proxy-call-id=1582591a-fd53-11e3-bd38-0010f30f5a60;rport > Via: SIP/2.0/TLS 111.111.111.111:7029;egress-zone=OurUniversity;branch=z9hG4bK895b55f2f3bf606bac3fc0651749fa5b61290.73594a4f2852aa8a3c87a40dd8159206;proxy-call-id=157cb19a-fd53-11e3-81d7-0010f30f56f0;received=111.111.111.111;rport=7029;ingress-zone=OurUniversity > Via: SIP/2.0/TLS 9.9.9.9:5061;egress-zone=dnsout;branch=z9hG4bK6fd1beced1963d9a99dca0da8be9743b1214218.bf97dcdf757250e2330b681719b63e91;proxy-call-id=d09ae921-6d48-490b-a44d-89da5ecb1735;received=9.9.9.9;rport=26521;ingress-zone=DefaultZone > Via: SIP/2.0/TCP 1.1.1.1:5060;branch=z9hG4bK17429394;received=1.1.1.1;ingress-zone=DefaultSubZone > Call-ID: C67D8C81 at 1.1.1.1 > CSeq: 1 INVITE > Contact: <sip:8510 at thierdomain.ac.uk;gr=urn:uuid:e42a7487-dd80-52f6-b21b-c718aaff8e59>;isfocus > From: "CONFERENCE1" <sip:8510@xxxxxxxxxxxxxxxxx>;tag=DC5D7A6BD0B50001 > To: <sip:pi at mydomain.ac.uk> > Max-Forwards: 13 > Record-Route: <sip:proxy-call-id=1582591a-fd53-11e3-bd38-0010f30f5a60 at 222.222.222.1:5060;transport=tcp;lr> > Record-Route: <sip:proxy-call-id=1582591a-fd53-11e3-bd38-0010f30f5a60 at 222.222.222.1:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=157cb19a-fd53-11e3-81d7-0010f30f56f0 at 111.111.111.111:7029;transport=tls;lr> > Record-Route: <sip:proxy-call-id=157cb19a-fd53-11e3-81d7-0010f30f56f0 at 111.111.111.111:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=d09ae921-6d48-490b-a44d-89da5ecb1735 at 9.9.9.9:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=d09ae921-6d48-490b-a44d-89da5ecb1735 at 9.9.9.9:5060;transport=tcp;lr> > Allow: INVITE,ACK,CANCEL,OPTIONS,UPDATE,INFO,NOTIFY,BYE,REFER > User-Agent: Codian MSE 8510 v4.4 (3.42) > Supported: timer,outbound > Session-Expires: 500 > X-TAATag: 7da68719-daec-4724-a92c-8c534dc98431 > Content-Type: application/sdp > Content-Length: 2660 > > v=0 > o=CODIAN 799447510 799447510 IN IP4 1.1.1.1 > s=- > i=Codian MSE 8510 v4.4 (3.42) > c=IN IP4 222.222.222.1 > b=AS:2046 > t=0 0 > m=audio 51620 RTP/AVP 113 108 109 110 98 114 115 118 99 100 102 9 104 105 0 8 15 18 101 > a=rtpmap:113 MP4A-LATM/90000 > a=fmtp:113 profile-level-id=24;object=23;bitrate=96000 > a=rtpmap:108 MP4A-LATM/90000 > a=fmtp:108 profile-level-id=24;object=23;bitrate=64000 > a=rtpmap:109 MP4A-LATM/90000 > a=fmtp:109 profile-level-id=24;object=23;bitrate=56000 > a=rtpmap:110 MP4A-LATM/90000 > a=fmtp:110 profile-level-id=24;object=23;bitrate=48000 > a=rtpmap:98 MP4A-LATM/32000 > a=fmtp:98 profile-level-id=2;object=2;bitrate=96000 > a=rtpmap:114 SIREN14/16000 > a=fmtp:114 bitrate=48000 > a=rtpmap:115 SIREN14/16000 > a=fmtp:115 bitrate=32000 > a=rtpmap:118 SIREN14/16000 > a=fmtp:118 bitrate=24000 > a=rtpmap:99 G7221/32000 > a=fmtp:99 bitrate=48000 > a=rtpmap:100 G7221/32000 > a=fmtp:100 bitrate=32000 > a=rtpmap:102 G7221/32000 > a=fmtp:102 bitrate=24000 > a=rtpmap:9 G722/8000 > a=rtpmap:104 G7221/16000 > a=fmtp:104 bitrate=32000 > a=rtpmap:105 G7221/16000 > a=fmtp:105 bitrate=24000 > a=rtpmap:0 PCMU/8000/1 > a=rtpmap:8 PCMA/8000/1 > a=rtpmap:15 G728/8000 > a=rtpmap:18 G729/8000 > a=fmtp:18 annexb=no > a=rtpmap:101 telephone-event/8000 > a=fmtp:101 0-15 > a=sendrecv > m=video 51610 RTP/AVP 126 97 96 34 31 > b=AS:2000 > a=rtpmap:126 H264/90000 > a=fmtp:126 profile-level-id=42e014;max-mbps=108000;max-fs=3600;max-dpb=5400;max-fps=6000;packetization-mode=1 > a=rtpmap:97 H264/90000 > a=fmtp:97 profile-level-id=42e014;max-mbps=108000;max-fs=3600;max-dpb=5400;max-fps=6000 > a=rtpmap:96 H263-1998/90000 > a=fmtp:96 CUSTOM=1280,720,1;CUSTOM=1024,768,1;CUSTOM=1024,576,1;CUSTOM=848,480,1;CIF4=1;CUSTOM=512,288,1;CIF=1;QCIF=1 > a=rtpmap:34 H263/90000 > a=fmtp:34 CIF4=1;CIF=1;QCIF=1 > a=rtpmap:31 H261/90000 > a=fmtp:31 CIF= > 08:53:53.443 pjsua_core.c !Shutting down, flags=0... > 08:53:53.444 pjsua_core.c PJSUA state changed: RUNNING --> CLOSING > 08:53:53.446 pjsua_call.c .Hangup all calls.. > 08:53:53.447 pjsua_media.c .Call 0: deinitializing media.. > 08:53:53.449 pjsua_pres.c .Shutting down presence.. > 08:53:53.451 pjsua_acc.c .Acc 3: setting unregistration.. > 08:53:53.452 endpoint ..Request msg REGISTER/cseq=33220 (tdta0x20e9320) created. > 08:53:53.453 tsx0x20ea38c ...Transaction created for Request msg REGISTER/cseq=33221 (tdta0x20e9320) > 08:53:53.453 tsx0x20ea38c ..Sending Request msg REGISTER/cseq=33221 (tdta0x20e9320) in state Null > 08:53:53.453 sip_resolve.c ...DNS resolver not available, target 'vcs.mydomain.ac.uk:0' type=TCP will be resolved with getaddrinfo() > 08:53:53.455 sip_resolve.c ...Target 'vcs.mydomain.ac.uk:0' type=TCP resolved to '222.222.222.1:5060' type=TCP (TCP transport) > 08:53:53.455 pjsua_core.c ...TX 573 bytes Request msg REGISTER/cseq=33221 (tdta0x20e9320) to TCP 222.222.222.1:5060: > REGISTER sip:vcs.mydomain.ac.uk;transport=tcp SIP/2.0 > Via: SIP/2.0/TCP 222.222.222.222:36452;rport;branch=z9hG4bKPjTJU486ZxLCQr4WanbdX7mrZxf9-fVxl2;alias > Max-Forwards: 70 > From: <sip:pi@xxxxxxxxxxxxxx>;tag=CiChlIjlVCJH3rYPYAcI4g47JhGXvEli > To: <sip:pi at mydomain.ac.uk> > Call-ID: iQjdX7e-R7SzQRN-RzaeEHGl4aYC1jeb > CSeq: 33221 REGISTER > User-Agent: PJSUA v2.2.1 Linux-3.12.22/armv6l/glibc-2.13 > Supported: outbound, path > Contact: <sip:pi at 222.222.222.222:5060;transport=TCP;ob>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-0000-0000-0000f361b107>" > Expires: 0 > Content-Length: 0 > > > --end msg-- > 08:53:53.461 tsx0x20ea38c ...State changed from Null to Calling, event=TX_MSG > 08:53:53.461 pjsua_acc.c ..Acc 3: Unregistration sent > 08:53:53.466 sip_transport. .Error processing 1361 bytes packet from TCP 222.222.222.1:5060 : PJSIP syntax error exception when parsing '' header on line 1 col 3: > rl:s-only > a=confid:160339198 > a=floorid:2 mstrm:12 > a=userid:37917 > a=connection:new > m=application 51628 RTP/AVP 100 > a=rtpmap:100 H224/4800 > a=sendrecv > m=video 51618 RTP/AVP 96 126 97 > b=AS:2000 > a=rtpmap:96 H263-1998/90000 > a=fmtp:96 CUSTOM=1280,720,2;CUSTOM=1024,768,2;CUSTOM=1024,576,2;CUSTOM=848,480,1;CUSTOM=800,600,2;CUSTOM=768,448,1;CUSTOM=640,480,1;CUSTOM=512,288,1;CIF=1 > a=rtpmap:126 H264/90000 > a=fmtp:126 profile-level-id=42e014;max-mbps=27000;max-fs=3600;max-dpb=1350;max-fps=6000;packetization-mode=1 > a=rtpmap:97 H264/90000 > a=fmtp:97 profile-level-id=42e014;max-mbps=27000;max-fs=3600;max-dpb=1350;max-fps=6000 > a=rtcp-fb:* nack pli > a=rtcp-fb:* ccm fir > a=sendrecv > a=content:slides > a=label:12 > SIP/2.0 200 OK > Via: SIP/2.0/TCP 222.222.222.222:36452;branch=z9hG4bKPjTJU486ZxLCQr4WanbdX7mrZxf9-fVxl2;alias;received=222.222.222.222;rport=36452 > Call-ID: iQjdX7e-R7SzQRN-RzaeEHGl4aYC1jeb > CSeq: 33221 REGISTER > From: <sip:pi@xxxxxxxxxxxxxx>;tag=CiChlIjlVCJH3rYPYAcI4g47JhGXvEli > To: <sip:pi at mydomain.ac.uk>;tag=ac91598765bd6a93 > Path: <sip:flow-token=MwAAAAAAAAAADwAAABPEAACJLKwBkn8AACAAAHiSfwAAYOPZfQAAAAAAAAAADwAAAI5kAACJLKw8AAAAAAAAAAAAAAAAAAAAACphL8vMwOZlk2A=@222.222.222.1;ob;lr> > Server: TANDBERG/4120 (X7.2.3) > Date: Thu, 26 Jun 2014 16:59:15 GMT > Supported: com.tandberg.sdp.extensions.v1,gruu,outbound,path > Require: outbound > Content-Length: 0 > > Log from GOOD inbound call when registered via UDP transport > > 09:04:18.880 sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=1 (rdata0xdd8b74) > 09:04:18.880 pjsua_core.c .RX 4000 bytes Request msg INVITE/cseq=1 (rdata0xdd8b74) from UDP 222.222.222.1:5060: > INVITE sip:pi at 222.222.222.222:5060;ob SIP/2.0 > Via: SIP/2.0/UDP 222.222.222.1:5060;egress-zone=DefaultSubZone;branch=z9hG4bKa75e2d5ac3d58fa40ac094bf43746267907573.16b26c94fddfcc8e7270188161369418;proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60;rport > Via: SIP/2.0/TLS 111.111.111.111:7029;egress-zone=OurUniversity;branch=z9hG4bK14b7b6b9ff6d433db7986af2d079fd5161301.8edbe65b1b55c77532ca579af82eea53;proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0;received=111.111.111.111;rport=7029;ingress-zone=OurUniversity > Via: SIP/2.0/TLS 9.9.9.9:5061;egress-zone=dnsout;branch=z9hG4bK0a581568f00c1d1218885d78c67f7e801214350.9ecf1523bb6f1feb6b39c5f18c6fe9e8;proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6;received=9.9.9.9;rport=26521;ingress-zone=DefaultZone > Via: SIP/2.0/TCP 1.1.1.1:5060;branch=z9hG4bK1742939a;received=1.1.1.1;ingress-zone=DefaultSubZone > Call-ID: C67D8C82 at 1.1.1.1 > CSeq: 1 INVITE > Contact: <sip:8510 at thierdomain.ac.uk;gr=urn:uuid:e42a7487-dd80-52f6-b21b-c718aaff8e59>;isfocus > From: "CONFERENCE2" <sip:8510@xxxxxxxxxxxxxxxxx>;tag=71193C78D0B60001 > To: <sip:pi at mydomain.ac.uk> > Max-Forwards: 13 > Record-Route: <sip:proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 at 222.222.222.1:5060;transport=udp;lr> > Record-Route: <sip:proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 at 222.222.222.1:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0 at 111.111.111.111:7029;transport=tls;lr> > Record-Route: <sip:proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0 at 111.111.111.111:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6 at 9.9.9.9:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6 at 9.9.9.9:5060;transport=tcp;lr> > Allow: INVITE,ACK,CANCEL,OPTIONS,UPDATE,INFO,NOTIFY,BYE,REFER > User-Agent: Codian MSE 8510 v4.4 (3.42) > Supported: timer,outbound > Session-Expires: 500 > X-TAATag: 74766091-9c9c-4970-bccb-77a8c4d6818d > Content-Type: application/sdp > Content-Length: 2661 > > v=0 > o=CODIAN 800124289 800124289 IN IP4 1.1.1.1 > s=- > i=Codian MSE 8510 v4.4 (3.42) > c=IN IP4 222.222.222.1 > b=AS:2046 > t=0 0 > m=audio 51622 RTP/AVP 113 108 109 110 98 114 115 118 99 100 102 9 104 105 0 8 15 18 101 > a=rtpmap:113 MP4A-LATM/90000 > a=fmtp:113 profile-level-id=24;object=23;bitrate=96000 > a=rtpmap:108 MP4A-LATM/90000 > a=fmtp:108 profile-level-id=24;object=23;bitrate=64000 > a=rtpmap:109 MP4A-LATM/90000 > a=fmtp:109 profile-level-id=24;object=23;bitrate=56000 > a=rtpmap:110 MP4A-LATM/90000 > a=fmtp:110 profile-level-id=24;object=23;bitrate=48000 > a=rtpmap:98 MP4A-LATM/32000 > a=fmtp:98 profile-level-id=2;object=2;bitrate=96000 > a=rtpmap:114 SIREN14/16000 > a=fmtp:114 bitrate=48000 > a=rtpmap:115 SIREN14/16000 > a=fmtp:115 bitrate=32000 > a=rtpmap:118 SIREN14/16000 > a=fmtp:118 bitrate=24000 > a=rtpmap:99 G7221/32000 > a=fmtp:99 bitrate=48000 > a=rtpmap:100 G7221/32000 > a=fmtp:100 bitrate=32000 > a=rtpmap:102 G7221/32000 > a=fmtp:102 bitrate=24000 > a=rtpmap:9 G722/8000 > a=rtpmap:104 G7221/16000 > a=fmtp:104 bitrate=32000 > a=rtpmap:105 G7221/16000 > a=fmtp:105 bitrate=24000 > a=rtpmap:0 PCMU/8000/1 > a=rtpmap:8 PCMA/8000/1 > a=rtpmap:15 G728/8000 > a=rtpmap:18 G729/8000 > a=fmtp:18 annexb=no > a=rtpmap:101 telephone-event/8000 > a=fmtp:101 0-15 > a=sendrecv > m=video 51626 RTP/AVP 126 97 96 34 31 > b=AS:2000 > a=rtpmap:126 H264/90000 > a=fmtp:126 profile-level-id=42e014;max-mbps=108000;max-fs=3600;max-dpb=5400;max-fps=6000;packetization-mode=1 > a=rtpmap:97 H264/90000 > a=fmtp:97 profile-level-id=42e014;max-mbps=108000;max-fs=3600;max-dpb=5400;max-fps=6000 > a=rtpmap:96 H263-1998/90000 > a=fmtp:96 CUSTOM=1280,720,1;CUSTOM=1024,768,1;CUSTOM=1024,576,1;CUSTOM=848,480,1;CIF4=1;CUSTOM=512,288,1;CIF=1;QCIF=1 > a=rtpmap:34 H263/90000 > a=fmtp:34 CIF4=1;CIF=1;QCIF=1 > a=rtpmap:31 H261/90000 > a=fmtp:31 CIF=1;QCIF=1 > a=rtcp-fb:* nack pli > > 09:04:18.899 pjsua_call.c .Incoming Request msg INVITE/cseq=1 (rdata0xdd8b74) > 09:04:18.900 tsx0xde1be4 ...Transaction created for Request msg INVITE/cseq=1 (rdata0xdd8b74) > 09:04:18.900 tsx0xde1be4 ..Incoming Request msg INVITE/cseq=1 (rdata0xdd8b74) in state Null > 09:04:18.900 tsx0xde1be4 ...State changed from Null to Trying, event=RX_MSG > 09:04:18.900 dlg0xde0fcc ....Transaction tsx0xde1be4 state changed to Trying > 09:04:18.900 dlg0xde0fcc ..UAS dialog created > 09:04:18.900 dlg0xde0fcc ..Module mod-invite added as dialog usage, data=0xddd544 > 09:04:18.900 dlg0xde0fcc ...Session count inc to 2 by mod-invite > 09:04:18.901 inv0xde0fcc ..UAS invite session created for dialog dlg0xde0fcc > 09:04:18.901 pjsua_media.c ..Call 0: initializing media.. > 09:04:18.903 pjsua_media.c ...RTP socket reachable at 222.222.222.222:4000 > 09:04:18.903 pjsua_media.c ...RTCP socket reachable at 222.222.222.222:4001 > 09:04:18.903 pjsua_media.c ...Media index 0 selected for audio call 0 > 09:04:18.906 pjsua_call.c ..Call 0: remote NAT type is 0 (Unknown) > 09:04:18.906 endpoint ...Response msg 100/INVITE/cseq=1 (tdta0xdec680) created > 09:04:18.906 dlg0xde0fcc ...Initial answer Response msg 100/INVITE/cseq=1 (tdta0xdec680) > 09:04:18.906 inv0xde0fcc ...Sending Response msg 100/INVITE/cseq=1 (tdta0xdec680) > 09:04:18.906 dlg0xde0fcc ....Sending Response msg 100/INVITE/cseq=1 (tdta0xdec680) > 09:04:18.906 tsx0xde1be4 ....Sending Response msg 100/INVITE/cseq=1 (tdta0xdec680) in state Trying > 09:04:18.906 pjsua_core.c .....TX 1702 bytes Response msg 100/INVITE/cseq=1 (tdta0xdec680) to UDP 222.222.222.1:5060: > SIP/2.0 100 Trying > Via: SIP/2.0/UDP 222.222.222.1:5060;rport=5060;received=222.222.222.1;branch=z9hG4bKa75e2d5ac3d58fa40ac094bf43746267907573.16b26c94fddfcc8e7270188161369418;egress-zone=DefaultSubZone;proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 > Via: SIP/2.0/TLS 111.111.111.111:7029;rport=7029;received=111.111.111.111;branch=z9hG4bK14b7b6b9ff6d433db7986af2d079fd5161301.8edbe65b1b55c77532ca579af82eea53;egress-zone=OurUniversity;proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0;ingress-zone=OurUniversity > Via: SIP/2.0/TLS 9.9.9.9:5061;rport=26521;received=9.9.9.9;branch=z9hG4bK0a581568f00c1d1218885d78c67f7e801214350.9ecf1523bb6f1feb6b39c5f18c6fe9e8;egress-zone=dnsout;proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6;ingress-zone=DefaultZone > Via: SIP/2.0/TCP 1.1.1.1:5060;received=1.1.1.1;branch=z9hG4bK1742939a;ingress-zone=DefaultSubZone > Record-Route: <sip:proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 at 222.222.222.1:5060;transport=udp;lr> > Record-Route: <sip:proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 at 222.222.222.1:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0 at 111.111.111.111:7029;transport=tls;lr> > Record-Route: <sip:proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0 at 111.111.111.111:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6 at 9.9.9.9:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6 at 9.9.9.9:5060;transport=tcp;lr> > Call-ID: C67D8C82 at 1.1.1.1 > From: "CONFERENCE2" <sip:8510@xxxxxxxxxxxxxxxxx>;tag=71193C78D0B60001 > To: <sip:pi at mydomain.ac.uk> > CSeq: 1 INVITE > Content-Length: 0 > > > --end msg-- > 09:04:18.908 tsx0xde1be4 .....State changed from Trying to Proceeding, event=TX_MSG > 09:04:18.908 dlg0xde0fcc ......Transaction tsx0xde1be4 state changed to Proceeding > 09:04:18.908 pjsua_aud.c ..Conf connect: 2 --> 0 > 09:04:18.911 pjsua_aud.c ...Set sound device: capture=2, playback=0 > 09:04:18.912 pjsua_app.c ....Turning sound device ON > 09:04:18.913 pjsua_aud.c ....Opening sound device PCM at 16000/1/20ms > 09:04:18.915 alsa_dev.c .....open_playback: Open playback device 'default:CARD=ALSA' > 09:04:18.942 alsa_dev.c .....Opened device alsa(default:CARD=ALSA) for playing, sample rate=16000, ch=1, bits=16, period size=320 frames, latency=140 ms > 09:04:18.942 alsa_dev.c .....open_capture: Open capture device 'default:CARD=Dummy' > 09:04:18.950 alsa_dev.c .....Opened device alsa(default:CARD=Dummy) for capture, sample rate=16000, ch=1, bits=16, period size=320 frames, latency=100 ms > 09:04:18.950 ec0xdf1a28 .....Creating AEC > 09:04:18.953 ec0xdf1a28 .....AEC created, clock_rate=16000, channel=1, samples per frame=320, tail length=200 ms, latency=0 ms > 09:04:18.955 conference.c ...Port 2 (ring) transmitting to port 0 (default:CARD=Dummy) > 09:04:18.956 pjsua_call.c ..Answering call 0: code=200 > 09:04:18.959 inv0xde0fcc ....SDP negotiation done, status=0 > 09:04:18.960 pjsua_call.c .....Call 0: remote NAT type is 0 (Unknown) > 09:04:18.960 pjsua_media.c .....Call 0: updating media.. > 09:04:18.961 alsa_dev.c !ca_thread_func(10075): Set thread priority for audio capture thread. > 09:04:18.961 alsa_dev.c Unable to increase thread priority, root access needed. > 09:04:18.962 pjsua_aud.c !......Audio channel update.. > 09:04:18.964 speex !warning: discarded first playback frame > 09:04:18.965 speex warning: discarded first playback frame > 09:04:18.964 strm0xe1de84 !.......VAD temporarily disabled > 09:04:18.967 rtp.c .......pjmedia_rtp_session_init: ses=0xe20510, default_pt=9, ssrc=0x55a981c0 > 09:04:18.967 rtp.c .......pjmedia_rtp_session_init: ses=0xe20b98, default_pt=9, ssrc=0x55a981c0 > 09:04:18.967 stream.c .......Stream strm0xe1de84 created > 09:04:18.967 strm0xe1de84 .......Encoder stream started > 09:04:18.969 speex !warning: discarded first playback frame > 09:04:18.970 speex warning: discarded first playback frame > 09:04:18.970 speex warning: discarded first playback frame > 09:04:18.970 speex warning: discarded first playback frame > 09:04:18.970 strm0xe1de84 !.......Decoder stream started > 09:04:18.972 speex !warning: discarded first playback frame > 09:04:18.973 pjsua_media.c !......Audio updated, stream #0: G722 (sendrecv) > 09:04:18.975 strm0xe1de84 !Start talksprut.. > 09:04:18.975 speex warning: discarded first playback frame > 09:04:18.976 pjsua_media.c !......Error updating media call00:1: Invalid media type (PJMEDIA_EINVALIMEDIATYPE) > 09:04:18.977 pjsua_media.c ......Error updating media call00:2: Invalid media type (PJMEDIA_EINVALIMEDIATYPE) > 09:04:18.979 pjsua_app.c .....Call 0 media 0 [type=audio], status is Active > 09:04:18.981 pjsua_aud.c .....Conf disconnect: 2 -x- 0 > 09:04:18.988 conference.c ......Port 2 (ring) stop transmitting to port 0 (default:CARD=Dummy) > 09:04:18.990 pjsua_aud.c .....Conf connect: 3 --> 0 > 09:04:18.992 conference.c ......Port 3 (sip:8510 at thierdomain.ac.uk) transmitting to port 0 (default:CARD=Dummy) > 09:04:18.993 pjsua_aud.c .....Conf connect: 0 --> 3 > 09:04:18.995 conference.c ......Port 0 (default:CARD=Dummy) transmitting to port 3 (sip:8510 at thierdomain.ac.uk) > 09:04:18.997 inv0xde0fcc ....Sending Response msg 200/INVITE/cseq=1 (tdta0xdec680) > 09:04:18.997 dlg0xde0fcc .....Sending Response msg 200/INVITE/cseq=1 (tdta0xdec680) > 09:04:18.997 tsx0xde1be4 .....Sending Response msg 200/INVITE/cseq=1 (tdta0xdec680) in state Proceeding > 09:04:18.998 pjsua_core.c ......TX 2399 bytes Response msg 200/INVITE/cseq=1 (tdta0xdec680) to UDP 222.222.222.1:5060: > SIP/2.0 200 OK > Via: SIP/2.0/UDP 222.222.222.1:5060;rport=5060;received=222.222.222.1;branch=z9hG4bKa75e2d5ac3d58fa40ac094bf43746267907573.16b26c94fddfcc8e7270188161369418;egress-zone=DefaultSubZone;proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 > Via: SIP/2.0/TLS 111.111.111.111:7029;rport=7029;received=111.111.111.111;branch=z9hG4bK14b7b6b9ff6d433db7986af2d079fd5161301.8edbe65b1b55c77532ca579af82eea53;egress-zone=OurUniversity;proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0;ingress-zone=OurUniversity > Via: SIP/2.0/TLS 9.9.9.9:5061;rport=26521;received=9.9.9.9;branch=z9hG4bK0a581568f00c1d1218885d78c67f7e801214350.9ecf1523bb6f1feb6b39c5f18c6fe9e8;egress-zone=dnsout;proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6;ingress-zone=DefaultZone > Via: SIP/2.0/TCP 1.1.1.1:5060;received=1.1.1.1;branch=z9hG4bK1742939a;ingress-zone=DefaultSubZone > Record-Route: <sip:proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 at 222.222.222.1:5060;transport=udp;lr> > Record-Route: <sip:proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 at 222.222.222.1:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0 at 111.111.111.111:7029;transport=tls;lr> > Record-Route: <sip:proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0 at 111.111.111.111:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6 at 9.9.9.9:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6 at 9.9.9.9:5060;transport=tcp;lr> > Call-ID: C67D8C82 at 1.1.1.1 > From: "CONFERENCE2" <sip:8510@xxxxxxxxxxxxxxxxx>;tag=71193C78D0B60001 > To: <sip:pi at mydomain.ac.uk>;tag=R3gbdJaQddbbOldCYhjdJ5Y5CaXTtRra > CSeq: 1 INVITE > Contact: <sip:pi at 222.222.222.222:5060;ob> > Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS > Supported: replaces, 100rel, timer, norefersub > Session-Expires: 500;refresher=uac > Require: timer > Content-Type: application/sdp > Content-Length: 391 > > v=0 > o=- 3605072658 3605072659 IN IP4 222.222.222.222 > s=pjmedia > b=AS:84 > t=0 0 > a=X-nat:0 > m=audio 4000 RTP/AVP 9 101 > c=IN IP4 222.222.222.222 > b=TIAS:64000 > a=rtcp:4001 IN IP4 222.222.222.222 > a=sendrecv > a=rtpmap:9 G722/8000 > a=rtpmap:101 telephone-event/8000 > a=fmtp:101 0-16 > m=video 0 RTP/AVP 126 97 96 34 31 > c=IN IP4 127.0.0.1 > b=AS:2000 > m=application 0 UDP/BFCP * > c=IN IP4 127.0.0.1 > > --end msg-- > 09:04:19.020 strm0xe1de84 !Jitter buffer is bufferring (prefetch=0), plc invoked > 09:04:19.021 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:19.021 Master/sound Underflow, buf_cnt=0, will generate 1 frame > 09:04:19.037 tsx0xde1be4 !......State changed from Proceeding to Completed, event=TX_MSG > 09:04:19.037 dlg0xde0fcc .......Transaction tsx0xde1be4 state changed to Completed > 09:04:19.037 pjsua_app.c .........Call 0 state changed to CONNECTING > 09:04:19.039 Master/sound !Underflow, buf_cnt=0, will generate 1 frame > 09:04:19.043 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:19.074 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:19.154 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:19.155 sip_endpoint.c !Processing incoming message: Request msg ACK/cseq=1 (rdata0xdd8b74) > 09:04:19.155 pjsua_core.c .RX 1303 bytes Request msg ACK/cseq=1 (rdata0xdd8b74) from UDP 222.222.222.1:5060: > ACK sip:pi at 222.222.222.222:5060;ob SIP/2.0 > Via: SIP/2.0/UDP 222.222.222.1:5060;egress-zone=DefaultSubZone;branch=z9hG4bKeb907f62b074f8adf7c7e96b765cbdd2907575.16b26c94fddfcc8e7270188161369418;proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60;rport > Via: SIP/2.0/TLS 111.111.111.111:7029;egress-zone=OurUniversity;branch=z9hG4bK5b01ac49ed365b43d7187b1cefbeb55a61302.8edbe65b1b55c77532ca579af82eea53;proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0;received=111.111.111.111;rport=7029;ingress-zone=OurUniversity > Via: SIP/2.0/TLS 9.9.9.9:5061;egress-zone=dnsout;branch=z9hG4bK229006a387aa5b022c13fac064f2ac0d1214351.9ecf1523bb6f1feb6b39c5f18c6fe9e8;proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6;received=9.9.9.9;rport=26521;ingress-zone=DefaultZone > Via: SIP/2.0/TCP 1.1.1.1:5060;branch=z9hG4bK1742939b;received=1.1.1.1;ingress-zone=DefaultSubZone > Call-ID: C67D8C82 at 1.1.1.1 > CSeq: 1 ACK > Contact: <sip:8510 at thierdomain.ac.uk;gr=urn:uuid:e42a7487-dd80-52f6-b21b-c718aaff8e59>;isfocus > From: "CONFERENCE2" <sip:8510@xxxxxxxxxxxxxxxxx>;tag=71193C78D0B60001 > To: <sip:pi at mydomain.ac.uk>;tag=R3gbdJaQddbbOldCYhjdJ5Y5CaXTtRra > Max-Forwards: 67 > User-Agent: Codian MSE 8510 v4.4 (3.42) > Supported: timer,outbound > X-TAATag: 74766091-9c9c-4970-bccb-77a8c4d6818d > Content-Length: 0 > > > --end msg-- > 09:04:19.163 dlg0xde0fcc .Received Request msg ACK/cseq=1 (rdata0xdd8b74) > 09:04:19.163 tsx0xde1be4 ..Request to terminate transaction > 09:04:19.163 tsx0xde1be4 ...State changed from Completed to Terminated, event=USER > 09:04:19.163 dlg0xde0fcc ....Transaction tsx0xde1be4 state changed to Terminated > 09:04:19.163 pjsua_app.c ...Call 0 state changed to CONFIRMED > 09:04:19.168 tsx0xde1be4 Timeout timer event > 09:04:19.168 tsx0xde1be4 .State changed from Terminated to Destroyed, event=TIMER > 09:04:19.169 tdta0xdec680 ..Destroying txdata Response msg 200/INVITE/cseq=1 (tdta0xdec680) > 09:04:19.169 tsx0xde1be4 Transaction destroyed! > 09:04:19.176 speex !warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:19.177 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:19.214 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:19.294 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:19.296 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:19.352 strm0xe1de84 !RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 > 09:04:19.352 stream.c G722 codec used, remote samples per frame detected = 80 > 09:04:19.355 strm0xe1de84 !Jitter buffer starts returning normal frames (after 17 empty/lost) > 09:04:19.434 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:19.437 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:19.574 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:19.577 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:19.603 strm0xe1de84 VAD re-enabled > 09:04:19.605 strm0xe1de84 Starting silence > 09:04:19.713 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:19.715 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:19.853 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:19.855 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:19.895 sip_endpoint.c !Processing incoming message: Request msg UPDATE/cseq=2 (rdata0xdd8b74) > 09:04:19.895 pjsua_core.c .RX 4000 bytes Request msg UPDATE/cseq=2 (rdata0xdd8b74) from UDP 222.222.222.1:5060: > UPDATE sip:pi at 222.222.222.222:5060;ob SIP/2.0 > Via: SIP/2.0/UDP 222.222.222.1:5060;egress-zone=DefaultSubZone;branch=z9hG4bK3c0043c58d581648f53497392dfb3fbe907576.16b26c94fddfcc8e7270188161369418;proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60;rport > Via: SIP/2.0/TLS 111.111.111.111:7029;egress-zone=OurUniversity;branch=z9hG4bK8cf7d6c613301828071f2c6e74492f9a61303.8edbe65b1b55c77532ca579af82eea53;proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0;received=111.111.111.111;rport=7029;ingress-zone=OurUniversity > Via: SIP/2.0/TLS 9.9.9.9:5061;egress-zone=dnsout;branch=z9hG4bKde3fda41e0b160af58904f51bd71ef461214352.9ecf1523bb6f1feb6b39c5f18c6fe9e8;proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6;received=9.9.9.9;rport=26521;ingress-zone=DefaultZone > Via: SIP/2.0/TCP 1.1.1.1:5060;branch=z9hG4bK1742939c;received=1.1.1.1;ingress-zone=DefaultSubZone > Call-ID: C67D8C82 at 1.1.1.1 > CSeq: 2 UPDATE > Contact: <sip:8510 at thierdomain.ac.uk;gr=urn:uuid:e42a7487-dd80-52f6-b21b-c718aaff8e59>;isfocus > From: "CONFERENCE2" <sip:8510@xxxxxxxxxxxxxxxxx>;tag=71193C78D0B60001 > To: <sip:pi at mydomain.ac.uk>;tag=R3gbdJaQddbbOldCYhjdJ5Y5CaXTtRra > Max-Forwards: 67 > Record-Route: <sip:proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 at 222.222.222.1:5060;transport=udp;lr> > Record-Route: <sip:proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 at 222.222.222.1:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0 at 111.111.111.111:7029;transport=tls;lr> > Record-Route: <sip:proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0 at 111.111.111.111:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6 at 9.9.9.9:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6 at 9.9.9.9:5060;transport=tcp;lr> > User-Agent: Codian MSE 8510 v4.4 (3.42) > Supported: timer,outbound > Session-Expires: 500;refresher=uac > X-TAATag: 74766091-9c9c-4970-bccb-77a8c4d6818d > Content-Type: application/sdp > Content-Length: 2661 > > v=0 > o=CODIAN 800124289 800124290 IN IP4 1.1.1.1 > s=- > i=Codian MSE 8510 v4.4 (3.42) > c=IN IP4 222.222.222.1 > b=AS:2046 > t=0 0 > m=audio 51622 RTP/AVP 113 108 109 110 98 114 115 118 99 100 102 9 104 105 0 8 15 18 101 > a=rtpmap:113 MP4A-LATM/90000 > a=fmtp:113 profile-level-id=24;object=23;bitrate=96000 > a=rtpmap:108 MP4A-LATM/90000 > a=fmtp:108 profile-level-id=24;object=23;bitrate=64000 > a=rtpmap:109 MP4A-LATM/90000 > a=fmtp:109 profile-level-id=24;object=23;bitrate=56000 > a=rtpmap:110 MP4A-LATM/90000 > a=fmtp:110 profile-level-id=24;object=23;bitrate=48000 > a=rtpmap:98 MP4A-LATM/32000 > a=fmtp:98 profile-level-id=2;object=2;bitrate=96000 > a=rtpmap:114 SIREN14/16000 > a=fmtp:114 bitrate=48000 > a=rtpmap:115 SIREN14/16000 > a=fmtp:115 bitrate=32000 > a=rtpmap:118 SIREN14/16000 > a=fmtp:118 bitrate=24000 > a=rtpmap:99 G7221/32000 > a=fmtp:99 bitrate=48000 > a=rtpmap:100 G7221/32000 > a=fmtp:100 bitrate=32000 > a=rtpmap:102 G7221/32000 > a=fmtp:102 bitrate=24000 > a=rtpmap:9 G722/8000 > a=rtpmap:104 G7221/16000 > a=fmtp:104 bitrate=32000 > a=rtpmap:105 G7221/16000 > a=fmtp:105 bitrate=24000 > a=rtpmap:0 PCMU/8000/1 > a=rtpmap:8 PCMA/8000/1 > a=rtpmap:15 G728/8000 > a=rtpmap:18 G729/8000 > a=fmtp:18 annexb=no > a=rtpmap:101 telephone-event/8000 > a=fmtp:101 0-15 > a=sendrecv > m=video 51636 RTP/AVP 126 97 96 34 31 > b=AS:2000 > a=rtpmap:126 H264/90000 > a=fmtp:126 profile-level-id=42e014;max-mbps=108000;max-fs=3600;max-dpb=5400;max-fps=6000;packetization-mode=1 > a=rtpmap:97 H264/90000 > a=fmtp:97 profile-level-id=42e014;max-mbps=108000;max-fs=3600;max-dpb=5400;max-fps=6000 > a=rtpmap:96 H263-1998/90000 > a=fmtp:96 CUSTOM=1280,720,1;CUSTOM=1024,768,1;CUSTOM=1024,576,1;CUSTOM=848,480,1;CIF4=1;CUSTOM=512,288,1;CIF=1;QCIF=1 > a=rtpmap:34 H263/90000 > a=fmtp:34 CIF4=1;CIF=1;QCIF=1 > a=rtpmap:31 H261/90000 > a=fmtp:31 CIF=1;QCIF=1 > a=rtcp-fb:* nack pli > a=rtcp-fb:* > 09:04:19.906 dlg0xde0fcc .Received Request msg UPDATE/cseq=2 (rdata0xdd8b74) > 09:04:19.906 tsx0xde1be4 ...Transaction created for Request msg UPDATE/cseq=2 (rdata0xdd8b74) > 09:04:19.906 tsx0xde1be4 ..Incoming Request msg UPDATE/cseq=2 (rdata0xdd8b74) in state Null > 09:04:19.906 tsx0xde1be4 ...State changed from Null to Trying, event=RX_MSG > 09:04:19.906 dlg0xde0fcc ....Transaction tsx0xde1be4 state changed to Trying > 09:04:19.907 inv0xde0fcc .....Got SDP offer in Request msg UPDATE/cseq=2 (rdata0xdd8b74) > 09:04:19.907 pjsua_call.c .....Call 0: received updated media offer > 09:04:19.914 strm0xe1de84 !Frame lost, recovered! > 09:04:19.914 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:19.915 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:19.918 pjsua_media.c !......Call 0: re-initializing media.. > 09:04:19.923 pjsua_media.c .......Media index 0 selected for audio call 0 > 09:04:19.924 inv0xde0fcc .....SDP negotiation done, status=0 > 09:04:19.925 pjsua_call.c ......Call 0: remote NAT type is 0 (Unknown) > 09:04:19.925 pjsua_media.c ......Call 0: updating media.. > 09:04:19.940 pjsua_media.c .......Call 0: stream #0 (audio) unchanged. > 09:04:19.942 pjsua_media.c .......Audio updated, stream #0: G722 (sendrecv) > 09:04:19.945 pjsua_media.c .......Error updating media call00:1: Invalid media type (PJMEDIA_EINVALIMEDIATYPE) > 09:04:19.946 pjsua_media.c .......Error updating media call00:2: Invalid media type (PJMEDIA_EINVALIMEDIATYPE) > 09:04:19.946 pjsua_app.c ......Call 0 media 0 [type=audio], status is Active > 09:04:19.948 pjsua_aud.c ......Conf connect: 3 --> 0 > 09:04:19.948 pjsua_aud.c ......Conf connect: 0 --> 3 > 09:04:19.948 endpoint .....Response msg 200/UPDATE/cseq=2 (tdta0xddf020) created > 09:04:19.949 dlg0xde0fcc ......Sending Response msg 200/UPDATE/cseq=2 (tdta0xddf020) > 09:04:19.949 tsx0xde1be4 ......Sending Response msg 200/UPDATE/cseq=2 (tdta0xddf020) in state Trying > 09:04:19.949 pjsua_core.c .......TX 2399 bytes Response msg 200/UPDATE/cseq=2 (tdta0xddf020) to UDP 222.222.222.1:5060: > SIP/2.0 200 OK > Via: SIP/2.0/UDP 222.222.222.1:5060;rport=5060;received=222.222.222.1;branch=z9hG4bK3c0043c58d581648f53497392dfb3fbe907576.16b26c94fddfcc8e7270188161369418;egress-zone=DefaultSubZone;proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 > Via: SIP/2.0/TLS 111.111.111.111:7029;rport=7029;received=111.111.111.111;branch=z9hG4bK8cf7d6c613301828071f2c6e74492f9a61303.8edbe65b1b55c77532ca579af82eea53;egress-zone=OurUniversity;proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0;ingress-zone=OurUniversity > Via: SIP/2.0/TLS 9.9.9.9:5061;rport=26521;received=9.9.9.9;branch=z9hG4bKde3fda41e0b160af58904f51bd71ef461214352.9ecf1523bb6f1feb6b39c5f18c6fe9e8;egress-zone=dnsout;proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6;ingress-zone=DefaultZone > Via: SIP/2.0/TCP 1.1.1.1:5060;received=1.1.1.1;branch=z9hG4bK1742939c;ingress-zone=DefaultSubZone > Record-Route: <sip:proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 at 222.222.222.1:5060;transport=udp;lr> > Record-Route: <sip:proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 at 222.222.222.1:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0 at 111.111.111.111:7029;transport=tls;lr> > Record-Route: <sip:proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0 at 111.111.111.111:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6 at 9.9.9.9:5061;transport=tls;lr> > Record-Route: <sip:proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6 at 9.9.9.9:5060;transport=tcp;lr> > Call-ID: C67D8C82 at 1.1.1.1 > From: "CONFERENCE2" <sip:8510@xxxxxxxxxxxxxxxxx>;tag=71193C78D0B60001 > To: <sip:pi at mydomain.ac.uk>;tag=R3gbdJaQddbbOldCYhjdJ5Y5CaXTtRra > CSeq: 2 UPDATE > Session-Expires: 500;refresher=uac > Require: timer > Contact: <sip:pi at 222.222.222.222:5060;ob> > Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS > Supported: replaces, 100rel, timer, norefersub > Content-Type: application/sdp > Content-Length: 391 > > v=0 > o=- 3605072658 3605072660 IN IP4 222.222.222.222 > s=pjmedia > b=AS:84 > t=0 0 > a=X-nat:0 > m=audio 4000 RTP/AVP 9 101 > c=IN IP4 222.222.222.222 > b=TIAS:64000 > a=rtcp:4001 IN IP4 222.222.222.222 > a=sendrecv > a=rtpmap:9 G722/8000 > a=rtpmap:101 telephone-event/8000 > a=fmtp:101 0-16 > m=video 0 RTP/AVP 126 97 96 34 31 > c=IN IP4 127.0.0.1 > b=AS:2000 > m=application 0 UDP/BFCP * > c=IN IP4 127.0.0.1 > > --end msg-- > 09:04:19.964 tsx0xde1be4 .......State changed from Trying to Completed, event=TX_MSG > 09:04:19.964 dlg0xde0fcc ........Transaction tsx0xde1be4 state changed to Completed > 09:04:19.991 speex !warning: No playback frame available (your application is buggy and/or got xruns) > 09:04:19.993 speex !warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:19.995 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:20.083 strm0xe1de84 Frame lost, recovered! > 09:04:20.133 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:20.133 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:20.135 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:20.273 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:20.275 strm0xe1de84 Frame lost, recovered! > 09:04:20.275 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:20.275 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:20.413 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:20.415 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:20.474 strm0xe1de84 Frame lost, recovered! > 09:04:20.474 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:20.553 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:20.555 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:20.693 strm0xe1de84 Frame lost, recovered! > 09:04:20.694 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:20.694 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:20.695 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:20.833 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:20.835 strm0xe1de84 Frame lost, recovered! > 09:04:20.835 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:20.863 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:20.973 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:20.975 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:21.034 strm0xe1de84 Frame lost, recovered! > 09:04:21.034 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:21.113 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:21.115 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:21.254 strm0xe1de84 Frame lost, recovered! > 09:04:21.254 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:21.255 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:21.256 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:21.393 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:21.395 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:21.454 strm0xe1de84 Frame lost, recovered! > 09:04:21.454 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:21.533 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:21.535 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:21.673 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:21.675 strm0xe1de84 Frame lost, recovered! > 09:04:21.675 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:21.703 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:21.813 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:21.815 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:21.903 strm0xe1de84 Frame lost, recovered! > 09:04:21.904 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:21.953 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:21.954 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:22.093 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:22.095 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:22.154 strm0xe1de84 Frame lost, recovered! > 09:04:22.183 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:22.233 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:22.234 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:22.373 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:22.375 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:22.434 strm0xe1de84 Frame lost, recovered! > 09:04:22.434 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:22.513 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:22.515 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:22.653 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:22.655 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:22.793 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:22.795 strm0xe1de84 Frame lost, recovered! > 09:04:22.795 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:22.795 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:22.933 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:22.935 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:23.073 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:23.075 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:23.213 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:23.215 strm0xe1de84 Frame lost, recovered! > 09:04:23.215 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:23.243 strm0xe1de84 Jitter buffer starts returning normal frames (after 1 empty/lost) > 09:04:23.353 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:23.355 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:23.493 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:23.495 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:23.583 silencedet.c Re-adjust threshold (in silence)to 0 > 09:04:23.633 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:23.635 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:23.773 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:23.775 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:23.834 strm0xe1de84 Start talksprut.. > 09:04:23.863 strm0xe1de84 Starting silence > 09:04:23.913 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:23.915 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:24.053 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:24.055 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:24.193 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:24.194 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:24.333 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:24.335 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:24.473 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:24.475 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:24.613 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:24.615 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:24.753 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:24.754 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:24.893 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:24.895 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:25.033 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:25.035 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:25.173 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:25.175 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:25.313 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:25.314 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:25.453 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:25.455 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:25.593 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:25.594 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:25.733 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:25.735 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:25.873 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:25.874 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:26.013 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:26.015 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:26.153 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:26.154 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:26.293 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:26.294 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:26.433 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:26.435 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:26.573 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:26.575 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:26.713 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:26.714 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:26.853 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:26.854 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:26.987 pjsua_acc.c !Sending 2 bytes keep-alive packet for acc 3 to 222.222.222.1:5060 > 09:04:26.988 tdta0xde9810 Destroying txdata raw > 09:04:26.993 speex !warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:26.994 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:27.133 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:27.134 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:27.273 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:27.275 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:27.413 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:27.415 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:27.553 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:27.554 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:27.583 silencedet.c Re-adjust threshold (in silence)to 0 > 09:04:27.693 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:27.694 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:27.833 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:27.834 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:27.973 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:27.975 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:28.113 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:28.114 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:28.253 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:28.255 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:28.393 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:28.394 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:28.531 sip_endpoint.c !Processing incoming message: Request msg BYE/cseq=3 (rdata0xdd8b74) > 09:04:28.531 pjsua_core.c .RX 1303 bytes Request msg BYE/cseq=3 (rdata0xdd8b74) from UDP 222.222.222.1:5060: > BYE sip:pi at 222.222.222.222:5060;ob SIP/2.0 > Via: SIP/2.0/UDP 222.222.222.1:5060;egress-zone=DefaultSubZone;branch=z9hG4bK47e0c65c8faea51fa147e2fbed45470c907579.16b26c94fddfcc8e7270188161369418;proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60;rport > Via: SIP/2.0/TLS 111.111.111.111:7029;egress-zone=OurUniversity;branch=z9hG4bK786e05648a0b2de9f7035391276d21d561304.8edbe65b1b55c77532ca579af82eea53;proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0;received=111.111.111.111;rport=7029;ingress-zone=OurUniversity > Via: SIP/2.0/TLS 9.9.9.9:5061;egress-zone=dnsout;branch=z9hG4bK6002b76c47dc04becb08051a3f37b7371214355.9ecf1523bb6f1feb6b39c5f18c6fe9e8;proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6;received=9.9.9.9;rport=26521;ingress-zone=DefaultZone > Via: SIP/2.0/TCP 1.1.1.1:5060;branch=z9hG4bK1742939d;received=1.1.1.1;ingress-zone=DefaultSubZone > Call-ID: C67D8C82 at 1.1.1.1 > CSeq: 3 BYE > Contact: <sip:8510 at thierdomain.ac.uk;gr=urn:uuid:e42a7487-dd80-52f6-b21b-c718aaff8e59>;isfocus > From: "CONFERENCE2" <sip:8510@xxxxxxxxxxxxxxxxx>;tag=71193C78D0B60001 > To: <sip:pi at mydomain.ac.uk>;tag=R3gbdJaQddbbOldCYhjdJ5Y5CaXTtRra > Max-Forwards: 67 > User-Agent: Codian MSE 8510 v4.4 (3.42) > Supported: timer,outbound > X-TAATag: 74766091-9c9c-4970-bccb-77a8c4d6818d > Content-Length: 0 > > > --end msg-- > 09:04:28.535 strm0xe1de84 !Jitter buffer empty (prefetch=0), plc invoked > 09:04:28.536 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:28.547 dlg0xde0fcc !.Received Request msg BYE/cseq=3 (rdata0xdd8b74) > 09:04:28.547 tsx0xe1d124 ...Transaction created for Request msg BYE/cseq=3 (rdata0xdd8b74) > 09:04:28.547 tsx0xe1d124 ..Incoming Request msg BYE/cseq=3 (rdata0xdd8b74) in state Null > 09:04:28.547 tsx0xe1d124 ...State changed from Null to Trying, event=RX_MSG > 09:04:28.547 dlg0xde0fcc ....Transaction tsx0xe1d124 state changed to Trying > 09:04:28.547 endpoint .....Response msg 200/BYE/cseq=3 (tdta0xde9810) created > 09:04:28.548 dlg0xde0fcc ......Sending Response msg 200/BYE/cseq=3 (tdta0xde9810) > 09:04:28.548 tsx0xe1d124 ......Sending Response msg 200/BYE/cseq=3 (tdta0xde9810) in state Trying > 09:04:28.548 pjsua_core.c .......TX 1080 bytes Response msg 200/BYE/cseq=3 (tdta0xde9810) to UDP 222.222.222.1:5060: > SIP/2.0 200 OK > Via: SIP/2.0/UDP 222.222.222.1:5060;rport=5060;received=222.222.222.1;branch=z9hG4bK47e0c65c8faea51fa147e2fbed45470c907579.16b26c94fddfcc8e7270188161369418;egress-zone=DefaultSubZone;proxy-call-id=a8e7a434-fd54-11e3-9bf8-0010f30f5a60 > Via: SIP/2.0/TLS 111.111.111.111:7029;rport=7029;received=111.111.111.111;branch=z9hG4bK786e05648a0b2de9f7035391276d21d561304.8edbe65b1b55c77532ca579af82eea53;egress-zone=OurUniversity;proxy-call-id=a8e1e0f8-fd54-11e3-89fe-0010f30f56f0;ingress-zone=OurUniversity > Via: SIP/2.0/TLS 9.9.9.9:5061;rport=26521;received=9.9.9.9;branch=z9hG4bK6002b76c47dc04becb08051a3f37b7371214355.9ecf1523bb6f1feb6b39c5f18c6fe9e8;egress-zone=dnsout;proxy-call-id=bc33e9ef-3d31-40ec-9417-c44e1323e9f6;ingress-zone=DefaultZone > Via: SIP/2.0/TCP 1.1.1.1:5060;received=1.1.1.1;branch=z9hG4bK1742939d;ingress-zone=DefaultSubZone > Call-ID: C67D8C82 at 1.1.1.1 > From: "CONFERENCE2" <sip:8510@xxxxxxxxxxxxxxxxx>;tag=71193C78D0B60001 > To: <sip:pi at mydomain.ac.uk>;tag=R3gbdJaQddbbOldCYhjdJ5Y5CaXTtRra > CSeq: 3 BYE > Content-Length: 0 > > > --end msg-- > 09:04:28.551 speex !warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:28.572 tsx0xe1d124 !.......State changed from Trying to Completed, event=TX_MSG > 09:04:28.572 dlg0xde0fcc ........Transaction tsx0xe1d124 state changed to Completed > 09:04:28.572 pjsua_app.c ......Call 0 is DISCONNECTED [reason=200 (Normal call clearing)] > 09:04:28.575 pjsua_app.c ......Call 0 disconnected, dumping media stats.. > 09:04:28.576 pjsua_app_comm ...... > [DISCONNCTD] To: "CONFERENCE2" <sip:8510 at thierdomain.ac.uk>;tag=71193C78D0B60001 > Call time: 00h:00m:09s, 1st res in 59 ms, conn in 264ms > #0 audio G722 @16kHz, sendrecv, peer=222.222.222.1:51622 > SRTP status: Not active Crypto-suite: > RX pt=9, last update:00h:00m:09.221s ago > total 467pkt 74.7KB (93.4KB +IP hdr) @avg=62.2Kbps/77.7Kbps > pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0 (0.0%) > (msec) min avg max last dev > loss period: 0.000 0.000 0.000 0.000 0.000 > jitter : 0.000 0.210 0.875 0.125 0.154 > TX pt=9, ptime=20, last update:00h:00m:02.478s ago > total 32pkt 5.0KB (6.3KB +IP hdr) @avg=4.1Kbps/5.2Kbps > pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%) > (msec) min avg max last dev > loss period: 0.000 0.000 0.000 0.000 0.000 > jitter : 4.875 4.875 4.875 4.875 0.000 > RTT msec : 0.000 0.000 0.000 0.000 0.000 > #1 unknown deactivated > #2 unknown deactivated > 09:04:28.582 pjsua_media.c ......Call 0: deinitializing media.. > 09:04:28.583 strm0xe1de84 ........JB summary: > size=0/eff=0 prefetch=0 level=4 > delay (min/max/avg/dev)=70/240/106/47 ms > burst (min/max/avg/dev)=2/4/3/0 frames > lost=15 discard=0 empty=21 > 09:04:28.583 pjsua_media.c ........Media stream call00:0 is destroyed > 09:04:28.584 pjsua_media.c ........Media stream call00:1 is destroyed > 09:04:28.584 pjsua_media.c ........Media stream call00:2 is destroyed > 09:04:28.584 dlg0xde0fcc ......Session count dec to 3 by mod-invite > 09:04:28.596 speex !warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:28.596 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:28.621 speex !warning: No playback frame available (your application is buggy and/or got xruns) > 09:04:28.622 speex !warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:28.673 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:28.673 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:28.812 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:28.813 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:28.953 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:28.953 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:29.092 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:29.093 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:29.232 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:29.233 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:29.372 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:29.373 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:29.513 speex warning: Auto-filling the buffer (your application is buggy and/or got xruns) > 09:04:29.513 speex warning: Had to discard a playback frame (your application is buggy and/or got xruns) > 09:04:29.582 pjsua_aud.c !Closing sound device after idle for 1 second(s) > 09:04:29.584 pjsua_app.c .Turning sound device OFF > 09:04:29.585 pjsua_aud.c .Closing default:CARD=ALSA sound playback device and default:CARD=Dummy sound capture device > 09:04:41.417 pjsua_core.c !Shutting down, flags=0... > 09:04:41.418 pjsua_core.c PJSUA state changed: RUNNING --> CLOSING > 09:04:41.425 pjsua_call.c .Hangup all calls.. > 09:04:41.426 pjsua_media.c .Call 0: deinitializing media.. > 09:04:41.428 pjsua_pres.c .Shutting down presence.. > 09:04:41.430 pjsua_acc.c .Acc 3: setting unregistration.. > 09:04:41.432 endpoint ..Request msg REGISTER/cseq=24270 (tdta0xe22160) created. > 09:04:41.432 tsx0xe231cc ...Transaction created for Request msg REGISTER/cseq=24271 (tdta0xe22160) > 09:04:41.432 tsx0xe231cc ..Sending Request msg REGISTER/cseq=24271 (tdta0xe22160) in state Null > 09:04:41.432 sip_resolve.c ...DNS resolver not available, target 'vcs.mydomain.ac.uk:0' type=Unspecified will be resolved with getaddrinfo() > 09:04:41.434 sip_resolve.c ...Target 'vcs.mydomain.ac.uk:0' type=Unspecified resolved to '222.222.222.1:5060' type=UDP (UDP transport) > 09:04:41.434 pjsua_core.c ...TX 438 bytes Request msg REGISTER/cseq=24271 (tdta0xe22160) to UDP 222.222.222.1:5060: > REGISTER sip:vcs.mydomain.ac.uk SIP/2.0 > Via: SIP/2.0/UDP 222.222.222.222:5060;rport;branch=z9hG4bKPj6-rBuPWXpvqtQvDjApSz8-FkZZ7ZlNam > Max-Forwards: 70 > From: <sip:pi@xxxxxxxxxxxxxx>;tag=gsAF9Gl66vfJG8GVkseqKyTY4psar4SY > To: <sip:pi at mydomain.ac.uk> > Call-ID: tuaaqJ-yv0dfsMPfd.ucRmeKYOEvt7oS > CSeq: 24271 REGISTER > User-Agent: PJSUA v2.2.1 Linux-3.12.22/armv6l/glibc-2.13 > Contact: <sip:pi at 222.222.222.222:5060;ob> > Expires: 0 > Content-Length: 0 > > > --end msg-- > 09:04:41.440 tsx0xe231cc ...State changed from Null to Calling, event=TX_MSG > 09:04:41.440 pjsua_acc.c ..Acc 3: Unregistration sent > 09:04:41.445 sip_endpoint.c .Processing incoming message: Response msg 200/REGISTER/cseq=24271 (rdata0xdd8b74) > 09:04:41.445 pjsua_core.c ..RX 461 bytes Response msg 200/REGISTER/cseq=24271 (rdata0xdd8b74) from UDP 222.222.222.1:5060: > SIP/2.0 200 OK > Via: SIP/2.0/UDP 222.222.222.222:5060;branch=z9hG4bKPj6-rBuPWXpvqtQvDjApSz8-FkZZ7ZlNam;received=222.222.222.222;rport=5060 > Call-ID: tuaaqJ-yv0dfsMPfd.ucRmeKYOEvt7oS > CSeq: 24271 REGISTER > From: <sip:pi@xxxxxxxxxxxxxx>;tag=gsAF9Gl66vfJG8GVkseqKyTY4psar4SY > To: <sip:pi at mydomain.ac.uk>;tag=27ad3bdee3050157 > Server: TANDBERG/4120 (X7.2.3) > Date: Thu, 26 Jun 2014 17:10:03 GMT > Supported: com.tandberg.sdp.extensions.v1,gruu,outbound,path > Content-Length: 0 > > > --end msg-- > > > Cheers > > Chris > > _______________________________________________ > Visit our blog: http://blog.pjsip.org > > pjsip mailing list > pjsip at lists.pjsip.org > http://lists.pjsip.org/mailman/listinfo/pjsip_lists.pjsip.org
