Hi, My network scheme looks like:
10.10.1.2 ---> (10.10.1.1|10.10.2.1) ---> 10.10.2.2 I have two separate networks (10.10.1.0/24 and 10.10.2.0/24) without routing between them. I have CentOS 6.5 with sems-1.4.3-8.el6.x86_64 installed and with interfaces in each network. I need to forward all requests from 10.10.1.2 to 10.10.2.2 and foward responses back. My configuration looks like: # cat sems.conf additional_interfaces=lan1,lan2 sip_ip_lan1=10.10.1.1 sip_ip_lan2=10.10.2.1 plugin_path=/usr/lib64/sems/plug-in/ load_plugins=session_timer;sbc plugin_config_path=/etc/sems/etc/ application=sbc # cat etc/sbc.conf profiles=forward active_profile=forward # cat etc/forward.sbcprofile.conf next_hop_ip=10.10.1.2 next_hop_port=5060 next_hop_for_replies=no outbound_interface=lan2 enable_rtprelay=yes I've got this message dump on calling 10.10.2.2 -> 10.10.2.1: 0.000000 10.10.2.2 -> 10.10.2.1 SIP/SDP 1337 Request: INVITE sip:[email protected] | , with session description 0.012269 10.10.2.1 -> 10.10.2.2 SIP 434 Status: 100 Connecting | 0.028840 10.10.2.1 -> 10.10.2.2 SIP 410 Status: 500 Server Internal Error | 0.029695 10.10.2.2 -> 10.10.2.1 SIP 409 Request: ACK sip:[email protected] | and sems console output: [1461//builddir/build/BUILD/sems-1.4.3/core/AmRtpStream.cpp:96] ERROR: Address family not supported by protocol [1461//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:845] ERROR: while creating new socket. More detailed sems log is attached. The same problem was described 2 years ago - http://lists.iptel.org/pipermail/sems/2012-September/004103.html - but there are no answer :( -- WBR, Eugene Prokopiev
[15897//builddir/build/BUILD/sems-1.4.3/core/log.cpp:174] INFO: Logging initialized [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:244] DEBUG: Reading configuration... [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:585] WARNING: media_ip_lan1 parameter is missing: using same as sip_ip_lan1 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:585] WARNING: media_ip_lan2 parameter is missing: using same as sip_ip_lan2 [15897//builddir/build/BUILD/sems-1.4.3/core/AmUtils.cpp:462] ERROR: Name or service not known [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:804] INFO: Interface: 'default' (0) [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:805] INFO: LocalIP='10.7.7.7' [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:806] INFO: PublicIP='' [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:807] INFO: LocalSIPIP='10.7.7.7' [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:808] INFO: LocalSIPPort=5060 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:809] INFO: RtpLowPort=1024 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:810] INFO: RtpHighPort=65535 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:804] INFO: Interface: 'lan1' (1) [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:805] INFO: LocalIP='10.10.1.1' [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:806] INFO: PublicIP='' [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:807] INFO: LocalSIPIP='10.10.1.1' [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:808] INFO: LocalSIPPort=5060 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:809] INFO: RtpLowPort=1024 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:810] INFO: RtpHighPort=65535 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:804] INFO: Interface: 'lan2' (2) [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:805] INFO: LocalIP='10.10.2.1' [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:806] INFO: PublicIP='' [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:807] INFO: LocalSIPIP='10.10.2.1' [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:808] INFO: LocalSIPPort=5060 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:809] INFO: RtpLowPort=1024 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:810] INFO: RtpHighPort=65535 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:813] INFO: Signaling address map: [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:822] INFO: 10.10.1.1 -> lan1 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:822] INFO: 10.10.2.1 -> lan2 [15897//builddir/build/BUILD/sems-1.4.3/core/AmConfig.cpp:822] INFO: 10.7.7.7 -> default [15897//builddir/build/BUILD/sems-1.4.3/core/sems.cpp:463] INFO: Loading plug-ins [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:163] DEBUG: adding built-in codecs... [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:655] DEBUG: codec id 0 inserted [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:655] DEBUG: codec id 6 inserted [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:695] DEBUG: payload 'telephone-event' inserted with id 96 and order 196 [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:216] INFO: AmPlugIn: loading modules: 'session_timer;sbc' [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:233] DEBUG: loading /usr/lib64/sems/plug-in//session_timer.so... [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:589] DEBUG: session component 'session_timer' loaded. [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:617] DEBUG: component 'user_timer' loaded. [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:233] DEBUG: loading /usr/lib64/sems/plug-in//sbc.so... [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:242] DEBUG: AmPlugIn: modules loaded. [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:248] DEBUG: AmPlugIn: Initializing plugins... [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:187] INFO: SBC: loaded SBC profile 'forward' - MD5: ddedb48e28c09816d93d600b040ed90f [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:192] INFO: SBC: RURI = '' [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:193] INFO: SBC: From = '' [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:194] INFO: SBC: To = '' [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:199] INFO: SBC: force outbound proxy: no [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:200] INFO: SBC: outbound proxy = '' [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:203] INFO: SBC: next hop = 10.10.2.2:5060 [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:206] INFO: SBC: next hop used for replies: 'no' [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:211] INFO: SBC: header filter is transparent, 0 items in list [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:213] INFO: SBC: message filter is transparent, 0 items in list [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:216] INFO: SBC: SDP filter is disabled, transparent, 0 items in list [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:218] INFO: SBC: RTP relay enabled [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:229] INFO: SBC: SST disabled [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:230] INFO: SBC: SIP auth disabled [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:231] INFO: SBC: call timer disabled [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBCCallProfile.cpp:235] INFO: SBC: prepaid disabled [15897//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBC.cpp:112] INFO: SBC: active profile: 'forward' [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:763] DEBUG: Application 'sbc' registered. [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:826] DEBUG: DI Interface 'sbc' registered. [15897//builddir/build/BUILD/sems-1.4.3/core/AmPlugIn.cpp:315] DEBUG: AmPlugIn: Initialized plugins. [15899//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387893237504 is starting. [15897//builddir/build/BUILD/sems-1.4.3/core/sems.cpp:475] INFO: Starting session container [15897//builddir/build/BUILD/sems-1.4.3/core/sems.cpp:483] INFO: Starting media processor [15900//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387850450688 is starting. [15897//builddir/build/BUILD/sems-1.4.3/core/AmMediaProcessor.cpp:67] DEBUG: Starting 1 MediaProcessorThreads. [15897//builddir/build/BUILD/sems-1.4.3/core/sems.cpp:486] INFO: Starting RTP receiver [15901//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387849398016 is starting. [15900//builddir/build/BUILD/sems-1.4.3/core/AmSessionContainer.cpp:120] INFO: monitoring module not loaded, monitoring disabled [15897//builddir/build/BUILD/sems-1.4.3/core/sems.cpp:489] INFO: Starting SIP stack (control interface) [15897//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:82] DEBUG: accept_fr_without_totag = no [15897//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:93] DEBUG: log_raw_messages level = 3 [15897//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:99] DEBUG: log_parsed_messages = yes [15897//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:235] DEBUG: Starting SIP control interface [15903//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387847292672 is starting. [15897//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:141] DEBUG: UDP transport bound to 10.7.7.7:5060 [15902//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387848345344 is starting. [15897//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:141] DEBUG: UDP transport bound to 10.10.1.1:5060 [15904//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387846240000 is starting. [15907//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387843081984 is starting. [15905//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387845187328 is starting. [15906//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387844134656 is starting. [15904//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.7.7.7:5060 [15907//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.7.7.7:5060 [15909//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387840976640 is starting. [15908//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387842029312 is starting. [15897//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:141] DEBUG: UDP transport bound to 10.10.2.1:5060 [15905//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.7.7.7:5060 [15910//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387839923968 is starting. [15906//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.7.7.7:5060 [15909//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.10.1.1:5060 [15911//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387838871296 is starting. [15910//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.10.1.1:5060 [15908//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.10.1.1:5060 [15912//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387837818624 is starting. [15913//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387836765952 is starting. [15914//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387835713280 is starting. [15915//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387834660608 is starting. [15911//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.10.1.1:5060 [15912//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.10.2.1:5060 [15913//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.10.2.1:5060 [15914//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.10.2.1:5060 [15915//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:186] INFO: Started SIP server UDP transport on 10.10.2.1:5060 [15912//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:213] DEBUG: vv M [|] u recvd msg via UDP vv --++-- INVITE sip:[email protected] SIP/2.0 CSeq: 1 INVITE v: SIP/2.0/UDP 10.10.2.2:5060;branch=z9hG4bK706393a9-372c-e411-83ba-b888e3e8fdd7;rport User-Agent: Ekiga/4.0.1 f: "ENP" <sip:[email protected]>;tag=a8bd92a9-372c-e411-83ba-b888e3e8fdd7 i: d4be92a9-372c-e411-83ba-b888e3e8fdd7@thinkpad k: 100rel,replaces t: <sip:[email protected]> m: "ENP" <sip:[email protected]> Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK l: 804 c: application/sdp Max-Forwards: 70 v=0 o=- 1409130630 1 IN IP4 10.10.2.2 s=Ekiga/4.0.1 c=IN IP4 10.10.2.2 t=0 0 m=audio 5066 RTP/AVP 8 101 a=sendrecv a=rtpmap:8 PCMA/8000/1 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16,32,36 a=maxptime:240 m=video 5068 RTP/AVP 95 31 34 126 125 124 92 b=AS:4096 b=TIAS:4096000 a=sendrecv a=rtpmap:95 theora/90000 a=fmtp:95 height=576;width=704 a=rtpmap:31 h261/90000 a=fmtp:31 CIF=1;QCIF=1 a=rtpmap:34 H263/90000 a=fmtp:34 F=1;CIF=1;CIF4=1;QCIF=1 a=rtpmap:126 H263-1998/90000 a=fmtp:126 D=1;F=1;I=1;J=1;CIF=1;CIF4=1;QCIF=1 a=rtpmap:125 H264/90000 a=fmtp:125 max-fs=6336;max-mbps=190080;profile-level-id=42801e a=rtpmap:124 H264/90000 a=fmtp:124 packetization-mode=1;max-fs=6336;max-mbps=190080;profile-level-id=42801e a=rtpmap:92 MP4V-ES/90000 a=fmtp:92 profile-level-id=5 --++-- [15912//builddir/build/BUILD/sems-1.4.3/core/sip/parse_uri.cpp:332] DEBUG: Converted URI port () to int (5060) [15912//builddir/build/BUILD/sems-1.4.3/core/sip/parse_via.cpp:525] DEBUG: parsed branch: z9hG4bK706393a9-372c-e411-83ba-b888e3e8fdd7 [15912//builddir/build/BUILD/sems-1.4.3/core/sip/parse_via.cpp:548] DEBUG: has_rport: 1 [15912//builddir/build/BUILD/sems-1.4.3/core/sip/trans_table.cpp:68] DEBUG: Matching INVITE request [15912//builddir/build/BUILD/sems-1.4.3/core/sip/parse_uri.cpp:332] DEBUG: Converted URI port () to int (5060) [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:591] DEBUG: Received new request [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:594] DEBUG: req.method = <INVITE> [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:597] DEBUG: req.r_uri = <sip:[email protected]> [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:598] DEBUG: req.from_uri = <sip:[email protected]> [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:599] DEBUG: req.from = <"ENP" <sip:[email protected]>> [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:600] DEBUG: req.to = <<sip:[email protected]>> [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:601] DEBUG: req.callid = <d4be92a9-372c-e411-83ba-b888e3e8fdd7@thinkpad> [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:602] DEBUG: req.from_tag = <a8bd92a9-372c-e411-83ba-b888e3e8fdd7> [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:603] DEBUG: req.to_tag = <> [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:604] DEBUG: cseq = <1> [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:605] DEBUG: req.route = <> [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:606] DEBUG: hdrs = <User-Agent: Ekiga/4.0.1 k: 100rel,replaces Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK Max-Forwards: 70 > [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:607] DEBUG: body = <v=0 o=- 1409130630 1 IN IP4 10.10.2.2 s=Ekiga/4.0.1 c=IN IP4 10.10.2.2 t=0 0 m=audio 5066 RTP/AVP 8 101 a=sendrecv a=rtpmap:8 PCMA/8000/1 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16,32,36 a=maxptime:240 m=video 5068 RTP/AVP 95 31 34 126 125 124 92 b=AS:4096 b=TIAS:4096000 a=sendrecv a=rtpmap:95 theora/90000 a=fmtp:95 height=576;width=704 a=rtpmap:31 h261/90000 a=fmtp:31 CIF=1;QCIF=1 a=rtpmap:34 H263/90000 a=fmtp:34 F=1;CIF=1;CIF4=1;QCIF=1 a=rtpmap:126 H263-1998/90000 a=fmtp:126 D=1;F=1;I=1;J=1;CIF=1;CIF4=1;QCIF=1 a=rtpmap:125 H264/90000 a=fmtp:125 max-fs=6336;max-mbps=190080;profile-level-id=42801e a=rtpmap:124 H264/90000 a=fmtp:124 packetization-mode=1;max-fs=6336;max-mbps=190080;profile-level-id=42801e a=rtpmap:92 MP4V-ES/90000 a=fmtp:92 profile-level-id=5 > [15912//builddir/build/BUILD/sems-1.4.3/core/AmSipDispatcher.cpp:88] DEBUG: method: `INVITE' [6]. [15912//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBC.cpp:189] DEBUG: using call profile 'forward' (from matching active_profile rule 'forward') [15912//builddir/build/BUILD/sems-1.4.3/core/AmDtmfDetector.cpp:209] DEBUG: Setting internal DTMF detector [15912//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:225] DEBUG: AmSession::setLocalTag() - session id set to 5129CBC8-53FD9EC5000DC514-97343700 [15912//builddir/build/BUILD/sems-1.4.3/core/SipCtrlInterface.cpp:613] DEBUG: ^^ M [d4be92a9-372c-e411-83ba-b888e3e8fdd7@thinkpad|] Ru SIP request INVITE handled ^^ [15916//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387833607936 is starting. [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:337] DEBUG: startup session [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:341] DEBUG: running session event loop [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:445] DEBUG: vv S [|5129CBC8-53FD9EC5000DC514-97343700] Disconnected, running, 0 UACTransPending vv [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:785] DEBUG: AmSession processing event [15916//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:90] DEBUG: AmSipDialog::updateStatus(req = INVITE) [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:835] DEBUG: onSipRequest: method = INVITE [15916//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBC.cpp:501] DEBUG: processing initial INVITE [15916//builddir/build/BUILD/sems-1.4.3/core/sip/parse_uri.cpp:332] DEBUG: Converted URI port () to int (5060) [15916//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:267] DEBUG: reply: transaction found! [15916//builddir/build/BUILD/sems-1.4.3/core/sip/trans_layer.cpp:215] DEBUG: reply_len = 392 [15916//builddir/build/BUILD/sems-1.4.3/core/sip/trans_layer.cpp:383] DEBUG: Sending to 10.10.2.2:5060 <SIP/2.0 100 Connecting CSeq: 1 INVITE v: SIP/2.0...> [15916//builddir/build/BUILD/sems-1.4.3/core/sip/transport.cpp:98] DEBUG: send msg --++-- SIP/2.0 100 Connecting CSeq: 1 INVITE v: SIP/2.0/UDP 10.10.2.2:5060;branch=z9hG4bK706393a9-372c-e411-83ba-b888e3e8fdd7;rport=5060;received=10.10.2.2 f: "ENP" <sip:[email protected]>;tag=a8bd92a9-372c-e411-83ba-b888e3e8fdd7 i: d4be92a9-372c-e411-83ba-b888e3e8fdd7@thinkpad t: <sip:[email protected]>;tag=5129CBC8-53FD9EC5000DC514-97343700 Contact: <sip:[email protected]:5060> Content-Length: 0 --++-- [15916//builddir/build/BUILD/sems-1.4.3/core/sip/trans_layer.cpp:1473] DEBUG: update_uas_reply(t=0x7fae580018f0) [15916//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBC.cpp:530] DEBUG: set next hop ip to '10.10.2.2' [15916//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBC.cpp:541] DEBUG: set next hop port to '5060' [15916//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBC.cpp:552] DEBUG: Enabling RTP relay mode for SBC call [15916//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:772] DEBUG: enabled RTP relay mode for B2B call '5129CBC8-53FD9EC5000DC514-97343700' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:512] DEBUG: parse_sdp_line_ex: parsing sdp message .. [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:525] DEBUG: parse_sdp_line_ex: found version [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:533] DEBUG: parse_sdp_line_ex: found origin [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1129] DEBUG: parse_sdp_line_ex: parse_sdp_origin: parsing sdp origin [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1220] DEBUG: parse_sdp_line_ex: parse_sdp_origin: done parsing sdp origin [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:541] DEBUG: parse_sdp_line_ex: found session [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:584] DEBUG: parse_sdp_line_ex: found connection [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:680] DEBUG: parse_sdp_line_ex: parse_sdp_connection: parsing sdp connection [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:738] DEBUG: parse_sdp_line_ex: parse_sdp_connection: done parsing sdp connection [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:568] DEBUG: parse_sdp_line_ex: found unknown line 't' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:591] DEBUG: parse_sdp_line_ex: found media [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:758] DEBUG: parse_sdp_line_ex: parse_sdp_media: parsing media description... [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:874] DEBUG: parse_sdp_line_ex: parse_sdp_media: done parsing media description [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1111] DEBUG: found media attr 'sendrecv' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1010] DEBUG: found media attr 'rtpmap' type '8' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1010] DEBUG: found media attr 'rtpmap' type '101' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1053] DEBUG: found media attr 'fmtp' for payload '101': '0-16,32,36' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1098] DEBUG: found media attr 'maxptime' value '240' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:758] DEBUG: parse_sdp_line_ex: parse_sdp_media: parsing media description... [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:874] DEBUG: parse_sdp_line_ex: parse_sdp_media: done parsing media description [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1111] DEBUG: found media attr 'sendrecv' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1010] DEBUG: found media attr 'rtpmap' type '95' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1053] DEBUG: found media attr 'fmtp' for payload '95': 'height=576;width=704' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1010] DEBUG: found media attr 'rtpmap' type '31' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1053] DEBUG: found media attr 'fmtp' for payload '31': 'CIF=1;QCIF=1' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1010] DEBUG: found media attr 'rtpmap' type '34' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1053] DEBUG: found media attr 'fmtp' for payload '34': 'F=1;CIF=1;CIF4=1;QCIF=1' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1010] DEBUG: found media attr 'rtpmap' type '126' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1053] DEBUG: found media attr 'fmtp' for payload '126': 'D=1;F=1;I=1;J=1;CIF=1;CIF4=1;QCIF=1' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1010] DEBUG: found media attr 'rtpmap' type '125' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1053] DEBUG: found media attr 'fmtp' for payload '125': 'max-fs=6336;max-mbps=190080;profile-level-id=42801e' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1010] DEBUG: found media attr 'rtpmap' type '124' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1053] DEBUG: found media attr 'fmtp' for payload '124': 'packetization-mode=1;max-fs=6336;max-mbps=190080;profile-level-id=42801e' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1010] DEBUG: found media attr 'rtpmap' type '92' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:1053] DEBUG: found media attr 'fmtp' for payload '92': 'profile-level-id=5' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSdp.cpp:661] DEBUG: parse_sdp_line_ex: parsing sdp message done :) [15916//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:295] DEBUG: Created 2 RTP relay streams [15916//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:314] DEBUG: initializing RTP relay stream 0 with remote <10.10.2.2:5066> [15916//builddir/build/BUILD/sems-1.4.3/core/AmRtpStream.cpp:473] DEBUG: RTP remote address set to 10.10.2.2:5066 [15916//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:314] DEBUG: initializing RTP relay stream 1 with remote <10.10.2.2:5068> [15917//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:68] DEBUG: Thread 140387832555264 is starting. [15916//builddir/build/BUILD/sems-1.4.3/core/AmRtpStream.cpp:473] DEBUG: RTP remote address set to 10.10.2.2:5068 [15916//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBC.cpp:702] DEBUG: SBC: connecting to 'sip:[email protected]' [15916//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBC.cpp:703] DEBUG: From: '"ENP" <sip:[email protected]>' [15916//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBC.cpp:704] DEBUG: To: '<sip:[email protected]>' [15916//builddir/build/BUILD/sems-1.4.3/core/AmDtmfDetector.cpp:209] DEBUG: Setting internal DTMF detector [15916//builddir/build/BUILD/sems-1.4.3/apps/sbc/SBC.cpp:1064] DEBUG: Created B2BUA callee leg, From: "ENP" <sip:[email protected]> [15916//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:783] DEBUG: enabled RTP relay mode for B2B call '75AC0C8E-53FD9EC5000DDDBF-96F3F700' [15916//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:805] DEBUG: creating 2 RTP streams from other_session [15916//builddir/build/BUILD/sems-1.4.3/core/AmRtpStream.cpp:766] DEBUG: set relay stream [0x7fae9a68a010] for RTP instance [0x7fae9a6ce010] [15916//builddir/build/BUILD/sems-1.4.3/core/AmRtpStream.cpp:96] ERROR: Address family not supported by protocol [15916//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:76] DEBUG: relayed_req.size() = 0 [15916//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:77] DEBUG: recvd_req.size() = 0 [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:112] DEBUG: AmSession destructor finished [15916//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:61] DEBUG: callid = 36893789-53FD9EC5000DDDC5-96F3F700 [15916//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:62] DEBUG: local_tag = 75AC0C8E-53FD9EC5000DDDBF-96F3F700 [15916//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:63] DEBUG: uac_trans.size() = 0 [15916//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:71] DEBUG: uas_trans.size() = 0 [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:845] ERROR: while creating new socket. [15916//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:267] DEBUG: reply: transaction found! [15916//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:304] DEBUG: req.method = INVITE; t.method = INVITE [15916//builddir/build/BUILD/sems-1.4.3/core/sip/trans_layer.cpp:215] DEBUG: reply_len = 368 [15916//builddir/build/BUILD/sems-1.4.3/core/sip/trans_layer.cpp:383] DEBUG: Sending to 10.10.2.2:5060 <SIP/2.0 500 Server Internal Error CSeq: 1 INVITE ...> [15916//builddir/build/BUILD/sems-1.4.3/core/sip/transport.cpp:98] DEBUG: send msg --++-- SIP/2.0 500 Server Internal Error CSeq: 1 INVITE v: SIP/2.0/UDP 10.10.2.2:5060;branch=z9hG4bK706393a9-372c-e411-83ba-b888e3e8fdd7;rport=5060;received=10.10.2.2 f: "ENP" <sip:[email protected]>;tag=a8bd92a9-372c-e411-83ba-b888e3e8fdd7 i: d4be92a9-372c-e411-83ba-b888e3e8fdd7@thinkpad t: <sip:[email protected]>;tag=5129CBC8-53FD9EC5000DC514-97343700 Content-Length: 0 --++-- [15916//builddir/build/BUILD/sems-1.4.3/core/sip/trans_layer.cpp:1473] DEBUG: update_uas_reply(t=0x7fae580018f0) [15916//builddir/build/BUILD/sems-1.4.3/core/sip/sip_trans.cpp:185] DEBUG: New timer of type G at time=428 (repeated=0) [15916//builddir/build/BUILD/sems-1.4.3/core/sip/sip_trans.cpp:185] DEBUG: New timer of type H at time=2003 (repeated=0) [15916//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:474] DEBUG: AmB2BSession::relayEvent: to other_id='75AC0C8E-53FD9EC5000DDDBF-96F3F700' [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:463] DEBUG: ^^ S [d4be92a9-372c-e411-83ba-b888e3e8fdd7@thinkpad|5129CBC8-53FD9EC5000DC514-97343700] Disconnected, stopped, 0 UACTransPending ^^ [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:348] DEBUG: session event loop ended, finalizing session [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:523] DEBUG: running finalize sequence... [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:553] DEBUG: AmSession::destroy() [15916//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:153] DEBUG: Thread 140387833607936 (140387833607936) calling on_stop, give it a chance to clean up. [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:537] DEBUG: AmSession::stop() [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:777] DEBUG: Audio cleared !!! [15916//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:168] DEBUG: Thread 140387833607936 (140387833607936) finished detach. [15916//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:529] DEBUG: session is stopped. [15916//builddir/build/BUILD/sems-1.4.3/core/AmThread.cpp:72] DEBUG: Thread 140387833607936 is ending. [15913//builddir/build/BUILD/sems-1.4.3/core/sip/udp_trsp.cpp:213] DEBUG: vv M [|] u recvd msg via UDP vv --++-- ACK sip:[email protected] SIP/2.0 CSeq: 1 ACK Via: SIP/2.0/UDP 10.10.2.2:5060;branch=z9hG4bK706393a9-372c-e411-83ba-b888e3e8fdd7;rport From: "ENP" <sip:[email protected]>;tag=a8bd92a9-372c-e411-83ba-b888e3e8fdd7 Call-ID: d4be92a9-372c-e411-83ba-b888e3e8fdd7@thinkpad To: <sip:[email protected]>;tag=5129CBC8-53FD9EC5000DC514-97343700 Content-Length: 0 Max-Forwards: 70 --++-- [15913//builddir/build/BUILD/sems-1.4.3/core/sip/parse_uri.cpp:332] DEBUG: Converted URI port () to int (5060) [15913//builddir/build/BUILD/sems-1.4.3/core/sip/parse_via.cpp:525] DEBUG: parsed branch: z9hG4bK706393a9-372c-e411-83ba-b888e3e8fdd7 [15913//builddir/build/BUILD/sems-1.4.3/core/sip/parse_via.cpp:548] DEBUG: has_rport: 1 [15913//builddir/build/BUILD/sems-1.4.3/core/sip/trans_table.cpp:68] DEBUG: Matching ACK request [15913//builddir/build/BUILD/sems-1.4.3/core/sip/trans_table.cpp:87] DEBUG: do_3261_match = 1 [15913//builddir/build/BUILD/sems-1.4.3/core/sip/trans_layer.cpp:1112] DEBUG: ACK matched INVITE transaction 0x7fae580018f0 [15913//builddir/build/BUILD/sems-1.4.3/core/sip/trans_layer.cpp:1541] DEBUG: update_uas_request(t=0x7fae580018f0) [15913//builddir/build/BUILD/sems-1.4.3/core/sip/sip_trans.cpp:139] DEBUG: Clearing old timer of type G (this=0x7fae58004250) [15913//builddir/build/BUILD/sems-1.4.3/core/sip/sip_trans.cpp:139] DEBUG: Clearing old timer of type H (this=0x7fae5800b3c0) [15913//builddir/build/BUILD/sems-1.4.3/core/sip/sip_trans.cpp:185] DEBUG: New timer of type I at time=653 (repeated=0) [15913//builddir/build/BUILD/sems-1.4.3/core/sip/trans_layer.cpp:1115] DEBUG: update_uas_request(bucket,t=0x7fae580018f0,msg) = 6 [15913//builddir/build/BUILD/sems-1.4.3/core/sip/trans_layer.cpp:1137] DEBUG: Absorbing non-200-ACK [15903//builddir/build/BUILD/sems-1.4.3/core/sip/sip_trans.cpp:156] DEBUG: Transaction timer expired: type=I, trans=0x7fae580018f0, eta=653, t=653 [15903//builddir/build/BUILD/sems-1.4.3/core/sip/sip_trans.cpp:139] DEBUG: Clearing old timer of type I (this=0x7fae5c0013d0) [15900//builddir/build/BUILD/sems-1.4.3/core/AmSessionContainer.cpp:77] DEBUG: Session cleaner starting its work [15900//builddir/build/BUILD/sems-1.4.3/core/AmSessionContainer.cpp:93] DEBUG: session [0x7fae96f3f700] has been destroyed [15900//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:76] DEBUG: relayed_req.size() = 0 [15900//builddir/build/BUILD/sems-1.4.3/core/AmB2BSession.cpp:77] DEBUG: recvd_req.size() = 1 [15900//builddir/build/BUILD/sems-1.4.3/core/AmSession.cpp:112] DEBUG: AmSession destructor finished [15900//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:61] DEBUG: callid = d4be92a9-372c-e411-83ba-b888e3e8fdd7@thinkpad [15900//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:62] DEBUG: local_tag = 5129CBC8-53FD9EC5000DC514-97343700 [15900//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:63] DEBUG: uac_trans.size() = 0 [15900//builddir/build/BUILD/sems-1.4.3/core/AmSipDialog.cpp:71] DEBUG: uas_trans.size() = 0 [15900//builddir/build/BUILD/sems-1.4.3/core/AmSessionContainer.cpp:134] DEBUG: Session cleaner finished
_______________________________________________ Sems mailing list [email protected] http://lists.iptel.org/mailman/listinfo/sems
