April 2011 - FreeSWITCH-users - FreeSWITCH Mailing Lists

Re: [Freeswitch-users] FS does not repose to SIP OK message.
by Gary Chen 13 Apr '11

13 Apr '11

The FS1 should response back with ACK. It did not. The strange thing is that It works sometime.Here is the SIP trace from ngrep for both good and bad calls on FS1 server:SJPhone IP: 226.59.139.61FS1 IP:226.59.129.223FS2 IP:226.59.129.221You can see that FS2 sent several 200 OK and FS1 never reply back. Good sip call:U 226.59.139.61:5060 -> 226.59.129.223:5080 INVITE sip:5025155596@fs2000.lightyear.net SIP/2.0..Via: SIP/2.0/UDP 226.59.139.61;branch=z9hG4bKd8318b3d000007494da459a 900006fac00000273;rport..From: "unknown" <sip:1009@fs2000.lightyear.net>;tag=a344c583a24..To: <sip:5025155596@fs2000.lig htyear.net>..Contact: <sip:1009@226.59.139.61>..Call-ID: 56BF61B3189F4EDEB8C9067D5823C8480xd8318b3d..CSeq: 1 INVITE..Max -Forwards: 70..User-Agent: SJphone/1.65.377a (SJ Labs)..Content-Length: 368..Content-Type: application/sdp..Supported: r eplaces,norefersub,timer....v=0..o=- 3511605289 3511605289 IN IP4 226.59.139.61..s=SJphone..c=IN IP4 226.59.139.61..t=0 0..m=audio 49352 RTP/AVP 3 97 98 8 0 101..c=IN IP4 226.59.139.61..a=rtpmap:3 GSM/8000..a=rtpmap:97 iLBC/8000..a=rtpmap:9 8 iLBC/8000..a=fmtp:98 mode=20..a=rtpmap:8 PCMA/8000..a=rtpmap:0 PCMU/8000..a=rtpmap:101 telephone-event/8000..a=fmtp:10 1 0-16..a=setup:active..a=sendrecv.. # U 226.59.129.223:5080 -> 226.59.139.61:5060 SIP/2.0 100 Trying..Via: SIP/2.0/UDP 226.59.139.61;branch=z9hG4bKd8318b3d000007494da459a900006fac00000273;rport=5060..Fr om: "unknown" <sip:1009@fs2000.lightyear.net>;tag=a344c583a24..To: <sip:5025155596@fs2000.lightyear.net>..Call-ID: 56BF6 1B3189F4EDEB8C9067D5823C8480xd8318b3d..CSeq: 1 INVITE..User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-5310735 2011-04-07 15-47-30 -0500..Content-Length: 0.... # U 226.59.129.223:5060 -> 226.59.129.221:5060 INVITE sip:5596@226.59.129.221:5060 SIP/2.0..Via: SIP/2.0/UDP 226.59.129.223;rport;branch=z9hG4bK4g569HgUr3QXN..Max-Forw ards: 68..From: "unknown" <sip:1009@226.59.129.223>;tag=KQKpXe0m39X6e..To: <sip:5596@226.59.129.221:5060>..Call-ID: 4639 3d91-dfaf-122e-d1b0-e9d83e422dc6..CSeq: 10972180 INVITE..Contact: <sip:mod_sofia@226.59.129.223:5060>..User-Agent: FreeS WITCH-mod_sofia/1.0.head-git-5310735 2011-04-07 15-47-30 -0500..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDAT E, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk , hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refe r..Content-Type: application/sdp..Content-Disposition: session..Content-Length: 317..X-FS-Support: update_display..Remot e-Party-ID: "unknown" <sip:1009@226.59.129.223>;party=calling;screen=yes;privacy=off....v=0..o=FreeSWITCH 1302587641 130 2587642 IN IP4 226.59.129.223..s=FreeSWITCH..c=IN IP4 226.59.129.223..t=0 0..m=audio 28848 RTP/AVP 3 98 99 9 0 8 101 13. .a=rtpmap:98 G7221/32000..a=fmtp:98 bitrate=48000..a=rtpmap:99 G7221/16000..a=fmtp:99 bitrate=32000..a=rtpmap:101 teleph one-event/8000..a=fmtp:101 0-16..a=ptime:20.. # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 100 Trying..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bK4g569HgUr3QXN..From: "unknown" <sip:1009@21 6.49.129.223>;tag=KQKpXe0m39X6e..To: <sip:5596@226.59.129.221:5060>..Call-ID: 46393d91-dfaf-122e-d1b0-e9d83e422dc6..CSeq : 10972180 INVITE..User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110119T213949Z..Content-Length: 0.... # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bK4g569HgUr3QXN..From: "unknown" <sip:1009@226.59 .129.223>;tag=KQKpXe0m39X6e..To: <sip:5596@226.59.129.221:5060>;tag=7r593SDymv51S..Call-ID: 46393d91-dfaf-122e-d1b0-e9d8 3e422dc6..CSeq: 10972180 INVITE..Contact: <sip:5596@226.59.129.221:5060;transport=udp>..User-Agent: FreeSWITCH-mod_sofia /1.0.7-hacked-20110119T213949Z..Accept: application/sdp..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO , REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer..Cont ent-Type: application/sdp..Content-Disposition: session..Content-Length: 247..X-FS-Display-Name: 5596..X-FS-Display-Numb er: sip:5596@226.59.129.221..X-FS-Support: update_display..Remote-Party-ID: "5596" <sip:5596@226.59.129.221>;party=calli ng;privacy=off;screen=no....v=0..o=FreeSWITCH 1302597804 1302597805 IN IP4 226.59.129.221..s=FreeSWITCH..c=IN IP4 226.59 .129.221..t=0 0..m=audio 18640 RTP/AVP 3 101 13..a=rtpmap:3 GSM/8000..a=rtpmap:101 telephone-event/8000..a=fmtp:101 0-16 ..a=rtpmap:13 CN/8000..a=ptime:20.. # U 226.59.129.223:5060 -> 226.59.129.221:5060 ACK sip:5596@226.59.129.221:5060;transport=udp SIP/2.0..Via: SIP/2.0/UDP 226.59.129.223;rport;branch=z9hG4bK5SyZBD1yNceg H..Max-Forwards: 70..From: "unknown" <sip:1009@226.59.129.223>;tag=KQKpXe0m39X6e..To: <sip:5596@226.59.129.221:5060>;tag =7r593SDymv51S..Call-ID: 46393d91-dfaf-122e-d1b0-e9d83e422dc6..CSeq: 10972180 ACK..Contact: <sip:mod_sofia@226.59.129.22 3:5060>..Content-Length: 0.... # U 226.59.129.223:5080 -> 226.59.139.61:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.139.61;branch=z9hG4bKd8318b3d000007494da459a900006fac00000273;rport=5060..From: "unknown" <sip:1009@fs2000.lightyear.net>;tag=a344c583a24..To: <sip:5025155596@fs2000.lightyear.net>;tag=KB4NB13DD35eg.. Call-ID: 56BF61B3189F4EDEB8C9067D5823C8480xd8318b3d..CSeq: 1 INVITE..Contact: <sip:5025155596@226.59.129.223:5080;transp ort=udp>..User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-5310735 2011-04-07 15-47-30 -0500..Accept: application/sdp..Allo w: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY..Supported: timer, precondition, pa th, replaces..Allow-Events: talk, hold, refer..Content-Type: application/sdp..Content-Disposition: session..Content-Leng th: 250..X-FS-Display-Name: 5596..X-FS-Display-Number: sip:5596@226.59.129.221..X-FS-Support: update_display..Remote-Par ty-ID: "5596" <sip:5596@226.59.129.223>;party=calling;privacy=off;screen=no....v=0..o=FreeSWITCH 1302591209 1302591210 I N IP4 226.59.129.223..s=FreeSWITCH..c=IN IP4 226.59.129.223..t=0 0..m=audio 25280 RTP/AVP 3 101..a=rtpmap:3 GSM/8000..a= rtpmap:101 telephone-event/8000..a=fmtp:101 0-16..a=silenceSupp:off - - - -..a=ptime:20.. # U 226.59.139.61:5060 -> 226.59.129.223:5080 ACK sip:5025155596@226.59.129.223:5080;transport=udp SIP/2.0..Via: SIP/2.0/UDP 226.59.139.61;branch=z9hG4bKd8318b3d00000 7494da459a900003d7800000277;rport..From: "unknown" <sip:1009@fs2000.lightyear.net>;tag=a344c583a24..To: <sip:5025155596@ fs2000.lightyear.net>;tag=KB4NB13DD35eg..Contact: <sip:1009@226.59.139.61>..Call-ID: 56BF61B3189F4EDEB8C9067D5823C8480xd 8318b3d..CSeq: 1 ACK..Max-Forwards: 70..User-Agent: SJphone/1.65.377a (SJ Labs)..Content-Length: 0.... # U 226.59.129.223:5060 -> 226.59.129.221:5060 INFO sip:5596@226.59.129.221:5060;transport=udp SIP/2.0..Via: SIP/2.0/UDP 226.59.129.223;rport;branch=z9hG4bK62QrD8H2jN4 2c..Max-Forwards: 70..From: "unknown" <sip:1009@226.59.129.223>;tag=KQKpXe0m39X6e..To: <sip:5596@226.59.129.221:5060>;ta g=7r593SDymv51S..Call-ID: 46393d91-dfaf-122e-d1b0-e9d83e422dc6..CSeq: 10972181 INFO..Contact: <sip:mod_sofia@226.59.129. 223:5060>..User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-5310735 2011-04-07 15-47-30 -0500..Allow: INVITE, ACK, BYE, CAN CEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Content-Type: message/update_display..Content-Length: 0..X-FS-Display-Name: unknown..X-FS-Display-Number: 1009 .... # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bK62QrD8H2jN42c..From: "unknown" <sip:1009@226.59 .129.223>;tag=KQKpXe0m39X6e..To: <sip:5596@226.59.129.221:5060>;tag=7r593SDymv51S..Call-ID: 46393d91-dfaf-122e-d1b0-e9d8 3e422dc6..CSeq: 10972181 INFO..User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110119T213949Z..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, pat h, replaces..Content-Length: 0.... # U 226.59.139.61:5060 -> 226.59.129.223:5080 BYE sip:5025155596@226.59.129.223:5080;transport=udp SIP/2.0..Via: SIP/2.0/UDP 226.59.139.61;branch=z9hG4bKd8318b3d00000 74b4da459e200004b8500000278;rport..From: "unknown" <sip:1009@fs2000.lightyear.net>;tag=a344c583a24..To: <sip:5025155596@ fs2000.lightyear.net>;tag=KB4NB13DD35eg..Contact: <sip:1009@226.59.139.61>..Call-ID: 56BF61B3189F4EDEB8C9067D5823C8480xd 8318b3d..CSeq: 2 BYE..Max-Forwards: 70..User-Agent: SJphone/1.65.377a (SJ Labs)..Content-Length: 0..Supported: replaces, norefersub,timer.... # U 226.59.129.223:5080 -> 226.59.139.61:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.139.61;branch=z9hG4bKd8318b3d0000074b4da459e200004b8500000278;rport=5060..From: "unknown" <sip:1009@fs2000.lightyear.net>;tag=a344c583a24..To: <sip:5025155596@fs2000.lightyear.net>;tag=KB4NB13DD35eg.. Call-ID: 56BF61B3189F4EDEB8C9067D5823C8480xd8318b3d..CSeq: 2 BYE..User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-5310735 2011-04-07 15-47-30 -0500..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY..Sup ported: timer, precondition, path, replaces..Content-Length: 0.... # U 226.59.129.223:5060 -> 226.59.129.221:5060 BYE sip:5596@226.59.129.221:5060;transport=udp SIP/2.0..Via: SIP/2.0/UDP 226.59.129.223;rport;branch=z9hG4bK7BHHF325FytN r..Max-Forwards: 70..From: "unknown" <sip:1009@226.59.129.223>;tag=KQKpXe0m39X6e..To: <sip:5596@226.59.129.221:5060>;tag =7r593SDymv51S..Call-ID: 46393d91-dfaf-122e-d1b0-e9d83e422dc6..CSeq: 10972182 BYE..Contact: <sip:mod_sofia@226.59.129.22 3:5060>..User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-5310735 2011-04-07 15-47-30 -0500..Allow: INVITE, ACK, BYE, CANCE L, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, re places..Reason: Q.850;cause=16;text="NORMAL_CLEARING"..Content-Length: 0.... # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bK7BHHF325FytNr..From: "unknown" <sip:1009@226.59 .129.223>;tag=KQKpXe0m39X6e..To: <sip:5596@226.59.129.221:5060>;tag=7r593SDymv51S..Call-ID: 46393d91-dfaf-122e-d1b0-e9d8 3e422dc6..CSeq: 10972182 BYE..User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110119T213949Z..Allow: INVITE, ACK, BYE, C ANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path , replaces..Content-Length: 0.... Bad SIP call:U 226.59.139.61:5060 -> 226.59.129.223:5080 INVITE sip:5025155596@fs2000.lightyear.net SIP/2.0..Via: SIP/2.0/UDP 226.59.139.61;branch=z9hG4bKd8318b3d000007324da4586 e0000031200000260;rport..From: "unknown" <sip:1009@fs2000.lightyear.net>;tag=60654c536a55..To: <sip:5025155596@fs2000.li ghtyear.net>..Contact: <sip:1009@226.59.139.61>..Call-ID: 44C45839A15C4201A81F99F69C8FDB4D0xd8318b3d..CSeq: 1 INVITE..Ma x-Forwards: 70..User-Agent: SJphone/1.65.377a (SJ Labs)..Content-Length: 368..Content-Type: application/sdp..Supported: replaces,norefersub,timer....v=0..o=- 3511604973 3511604973 IN IP4 226.59.139.61..s=SJphone..c=IN IP4 226.59.139.61..t=0 0..m=audio 49346 RTP/AVP 3 97 98 8 0 101..c=IN IP4 226.59.139.61..a=rtpmap:3 GSM/8000..a=rtpmap:97 iLBC/8000..a=rtpmap: 98 iLBC/8000..a=fmtp:98 mode=20..a=rtpmap:8 PCMA/8000..a=rtpmap:0 PCMU/8000..a=rtpmap:101 telephone-event/8000..a=fmtp:1 01 0-16..a=setup:active..a=sendrecv.. # U 226.59.129.223:5080 -> 226.59.139.61:5060 SIP/2.0 100 Trying..Via: SIP/2.0/UDP 226.59.139.61;branch=z9hG4bKd8318b3d000007324da4586e0000031200000260;rport=5060..Fr om: "unknown" <sip:1009@fs2000.lightyear.net>;tag=60654c536a55..To: <sip:5025155596@fs2000.lightyear.net>..Call-ID: 44C4 5839A15C4201A81F99F69C8FDB4D0xd8318b3d..CSeq: 1 INVITE..User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-5310735 2011-04-07 15-47-30 -0500..Content-Length: 0.... # U 226.59.129.223:5060 -> 226.59.129.221:5060 INVITE sip:5596@226.59.129.221:5060 SIP/2.0..Via: SIP/2.0/UDP 226.59.129.223;rport;branch=z9hG4bKtp8er37QNaS2H..Max-Forw ards: 68..From: "unknown" <sip:1009@226.59.129.223>;tag=gv7BrXDacFUec..To: <sip:5596@226.59.129.221:5060>..Call-ID: 8a42 e048-dfae-122e-d1b0-e9d83e422dc6..CSeq: 10972023 INVITE..Contact: <sip:mod_sofia@226.59.129.223:5060>..User-Agent: FreeS WITCH-mod_sofia/1.0.head-git-5310735 2011-04-07 15-47-30 -0500..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDAT E, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk , hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refe r..Content-Type: application/sdp..Content-Disposition: session..Content-Length: 317..X-FS-Support: update_display..Remot e-Party-ID: "unknown" <sip:1009@226.59.129.223>;party=calling;screen=yes;privacy=off....v=0..o=FreeSWITCH 1302588008 130 2588009 IN IP4 226.59.129.223..s=FreeSWITCH..c=IN IP4 226.59.129.223..t=0 0..m=audio 28166 RTP/AVP 3 98 99 9 0 8 101 13. .a=rtpmap:98 G7221/32000..a=fmtp:98 bitrate=48000..a=rtpmap:99 G7221/16000..a=fmtp:99 bitrate=32000..a=rtpmap:101 teleph one-event/8000..a=fmtp:101 0-16..a=ptime:20.. # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 100 Trying..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bKtp8er37QNaS2H..From: "unknown" <sip:1009@21 6.49.129.223>;tag=gv7BrXDacFUec..To: <sip:5596@226.59.129.221:5060>..Call-ID: 8a42e048-dfae-122e-d1b0-e9d83e422dc6..CSeq : 10972023 INVITE..User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110119T213949Z..Content-Length: 0.... # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bKtp8er37QNaS2H..From: "unknown" <sip:1009@226.59 .129.223>;tag=gv7BrXDacFUec..To: <sip:5596@226.59.129.221:5060>;tag=4XSZy8tKX129p..Call-ID: 8a42e048-dfae-122e-d1b0-e9d8 3e422dc6..CSeq: 10972023 INVITE..Contact: <sip:5596@226.59.129.221:5060;transport=udp>..User-Agent: FreeSWITCH-mod_sofia /1.0.7-hacked-20110119T213949Z..Accept: application/sdp..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO , REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer..Cont ent-Type: application/sdp..Content-Disposition: session..Content-Length: 247..X-FS-Display-Name: 5596..X-FS-Display-Numb er: sip:5596@226.59.129.221..X-FS-Support: update_display..Remote-Party-ID: "5596" <sip:5596@226.59.129.221>;party=calli ng;privacy=off;screen=no....v=0..o=FreeSWITCH 1302589491 1302589492 IN IP4 226.59.129.221..s=FreeSWITCH..c=IN IP4 226.59 .129.221..t=0 0..m=audio 26638 RTP/AVP 3 101 13..a=rtpmap:3 GSM/8000..a=rtpmap:101 telephone-event/8000..a=fmtp:101 0-16 ..a=rtpmap:13 CN/8000..a=ptime:20.. # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bKtp8er37QNaS2H..From: "unknown" <sip:1009@226.59 .129.223>;tag=gv7BrXDacFUec..To: <sip:5596@226.59.129.221:5060>;tag=4XSZy8tKX129p..Call-ID: 8a42e048-dfae-122e-d1b0-e9d8 3e422dc6..CSeq: 10972023 INVITE..Contact: <sip:5596@226.59.129.221:5060;transport=udp>..User-Agent: FreeSWITCH-mod_sofia /1.0.7-hacked-20110119T213949Z..Accept: application/sdp..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO , REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer..Cont ent-Type: application/sdp..Content-Disposition: session..Content-Length: 247..X-FS-Display-Name: 5596..X-FS-Display-Numb er: sip:5596@226.59.129.221..X-FS-Support: update_display..Remote-Party-ID: "5596" <sip:5596@226.59.129.221>;party=calli ng;privacy=off;screen=no....v=0..o=FreeSWITCH 1302589491 1302589492 IN IP4 226.59.129.221..s=FreeSWITCH..c=IN IP4 226.59 .129.221..t=0 0..m=audio 26638 RTP/AVP 3 101 13..a=rtpmap:3 GSM/8000..a=rtpmap:101 telephone-event/8000..a=fmtp:101 0-16 ..a=rtpmap:13 CN/8000..a=ptime:20.. # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bKtp8er37QNaS2H..From: "unknown" <sip:1009@226.59 .129.223>;tag=gv7BrXDacFUec..To: <sip:5596@226.59.129.221:5060>;tag=4XSZy8tKX129p..Call-ID: 8a42e048-dfae-122e-d1b0-e9d8 3e422dc6..CSeq: 10972023 INVITE..Contact: <sip:5596@226.59.129.221:5060;transport=udp>..User-Agent: FreeSWITCH-mod_sofia /1.0.7-hacked-20110119T213949Z..Accept: application/sdp..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO , REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer..Cont ent-Type: application/sdp..Content-Disposition: session..Content-Length: 247..X-FS-Display-Name: 5596..X-FS-Display-Numb er: sip:5596@226.59.129.221..X-FS-Support: update_display..Remote-Party-ID: "5596" <sip:5596@226.59.129.221>;party=calli ng;privacy=off;screen=no....v=0..o=FreeSWITCH 1302589491 1302589492 IN IP4 226.59.129.221..s=FreeSWITCH..c=IN IP4 226.59 .129.221..t=0 0..m=audio 26638 RTP/AVP 3 101 13..a=rtpmap:3 GSM/8000..a=rtpmap:101 telephone-event/8000..a=fmtp:101 0-16 ..a=rtpmap:13 CN/8000..a=ptime:20.. # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bKtp8er37QNaS2H..From: "unknown" <sip:1009@226.59 .129.223>;tag=gv7BrXDacFUec..To: <sip:5596@226.59.129.221:5060>;tag=4XSZy8tKX129p..Call-ID: 8a42e048-dfae-122e-d1b0-e9d8 3e422dc6..CSeq: 10972023 INVITE..Contact: <sip:5596@226.59.129.221:5060;transport=udp>..User-Agent: FreeSWITCH-mod_sofia /1.0.7-hacked-20110119T213949Z..Accept: application/sdp..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO , REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer..Cont ent-Type: application/sdp..Content-Disposition: session..Content-Length: 247..X-FS-Display-Name: 5596..X-FS-Display-Numb er: sip:5596@226.59.129.221..X-FS-Support: update_display..Remote-Party-ID: "5596" <sip:5596@226.59.129.221>;party=calli ng;privacy=off;screen=no....v=0..o=FreeSWITCH 1302589491 1302589492 IN IP4 226.59.129.221..s=FreeSWITCH..c=IN IP4 226.59 .129.221..t=0 0..m=audio 26638 RTP/AVP 3 101 13..a=rtpmap:3 GSM/8000..a=rtpmap:101 telephone-event/8000..a=fmtp:101 0-16 ..a=rtpmap:13 CN/8000..a=ptime:20.. U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bKtp8er37QNaS2H..From: "unknown" <sip:1009@226.59 .129.223>;tag=gv7BrXDacFUec..To: <sip:5596@226.59.129.221:5060>;tag=4XSZy8tKX129p..Call-ID: 8a42e048-dfae-122e-d1b0-e9d8 3e422dc6..CSeq: 10972023 INVITE..Contact: <sip:5596@226.59.129.221:5060;transport=udp>..User-Agent: FreeSWITCH-mod_sofia /1.0.7-hacked-20110119T213949Z..Accept: application/sdp..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO , REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer..Cont ent-Type: application/sdp..Content-Disposition: session..Content-Length: 247..X-FS-Display-Name: 5596..X-FS-Display-Numb er: sip:5596@226.59.129.221..X-FS-Support: update_display..Remote-Party-ID: "5596" <sip:5596@226.59.129.221>;party=calli ng;privacy=off;screen=no....v=0..o=FreeSWITCH 1302589491 1302589492 IN IP4 226.59.129.221..s=FreeSWITCH..c=IN IP4 226.59 .129.221..t=0 0..m=audio 26638 RTP/AVP 3 101 13..a=rtpmap:3 GSM/8000..a=rtpmap:101 telephone-event/8000..a=fmtp:101 0-16 ..a=rtpmap:13 CN/8000..a=ptime:20.. # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bKtp8er37QNaS2H..From: "unknown" <sip:1009@226.59 .129.223>;tag=gv7BrXDacFUec..To: <sip:5596@226.59.129.221:5060>;tag=4XSZy8tKX129p..Call-ID: 8a42e048-dfae-122e-d1b0-e9d8 3e422dc6..CSeq: 10972023 INVITE..Contact: <sip:5596@226.59.129.221:5060;transport=udp>..User-Agent: FreeSWITCH-mod_sofia /1.0.7-hacked-20110119T213949Z..Accept: application/sdp..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO , REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer..Cont ent-Type: application/sdp..Content-Disposition: session..Content-Length: 247..X-FS-Display-Name: 5596..X-FS-Display-Numb er: sip:5596@226.59.129.221..X-FS-Support: update_display..Remote-Party-ID: "5596" <sip:5596@226.59.129.221>;party=calli ng;privacy=off;screen=no....v=0..o=FreeSWITCH 1302589491 1302589492 IN IP4 226.59.129.221..s=FreeSWITCH..c=IN IP4 226.59 .129.221..t=0 0..m=audio 26638 RTP/AVP 3 101 13..a=rtpmap:3 GSM/8000..a=rtpmap:101 telephone-event/8000..a=fmtp:101 0-16 ..a=rtpmap:13 CN/8000..a=ptime:20.. # U 226.59.129.221:5060 -> 226.59.129.223:5060 SIP/2.0 200 OK..Via: SIP/2.0/UDP 226.59.129.223;rport=5060;branch=z9hG4bKtp8er37QNaS2H..From: "unknown" <sip:1009@226.59 .129.223>;tag=gv7BrXDacFUec..To: <sip:5596@226.59.129.221:5060>;tag=4XSZy8tKX129p..Call-ID: 8a42e048-dfae-122e-d1b0-e9d8 3e422dc6..CSeq: 10972023 INVITE..Contact: <sip:5596@226.59.129.221:5060;transport=udp>..User-Agent: FreeSWITCH-mod_sofia /1.0.7-hacked-20110119T213949Z..Accept: application/sdp..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO , REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer..Cont ent-Type: application/sdp..Content-Disposition: session..Content-Length: 247..X-FS-Display-Name: 5596..X-FS-Display-Numb er: sip:5596@226.59.129.221..X-FS-Support: update_display..Remote-Party-ID: "5596" <sip:5596@226.59.129.221>;party=calli ng;privacy=off;screen=no....v=0..o=FreeSWITCH 1302589491 1302589492 IN IP4 226.59.129.221..s=FreeSWITCH..c=IN IP4 226.59 .129.221..t=0 0..m=audio 26638 RTP/AVP 3 101 13..a=rtpmap:3 GSM/8000..a=rtpmap:101 telephone-event/8000..a=fmtp:101 0-16 ..a=rtpmap:13 CN/8000..a=ptime:20.. -----Original Message----- From: freeswitch-users-bounces(a)lists.freeswitch.org [mailto:freeswitch-users-bounces@lists.freeswitch.org] On Behalf Of Anthony Minessale Sent: Tuesday, April 12, 2011 8:21 PM To: FreeSWITCH Users Help Subject: Re: [Freeswitch-users] FS does not repose to SIP OK message. The ack is not being received. Try your trace from the other side. Try finding the misconfiguration and the NAT or SIP alg on your network. On Tue, Apr 12, 2011 at 3:00 PM, Gary Chen <gchen00(a)insightbb.com> wrote: > Just update my test FS to newest snapshot: FreeSWITCH Version 1.0.head > (git-5310735 2011-04-07 15-47-30 -0500) > I am using SJphone softphone to call into my test FS1. This FS1 then forward > the call to another FS2. > FS2 will answer the call and start Music On Hold. Basically I am using > SJphone to initiate a SIP call and let FS2 to answer the call with Music On > Hold. > It is working with older version of FS. Now after update to this newest > version. The call sometime will not go through. The SJPhone just keep > ringing until timeout. This happens maybe on half of the calls. I also tried > to use Asterisk to replace FS2 for Music On Hold and it did the same thing. > The following is the part of console sofia log info: > 2011-04-12 15:29:06.285484 [DEBUG] mod_sofia.c:84 > sofia/internal/5596@226.59.129.221:5060 SOFIA INIT > nua: nh_create_handle: entering > nua: nua_handle_bind: entering > nua: nua_invite: entering > nua(0x18cc2c80): sent signal r_invite > 2011-04-12 15:29:06.285484 [DEBUG] mod_sofia.c:124 > (sofia/internal/5596@226.59.129.221:5060) State Change CS_INIT -> CS_ROUTING > 2011-04-12 15:29:06.285484 [DEBUG] switch_core_session.c:1116 Send signal > sofia/internal/5596@226.59.129.221:5060 [BREAK] > 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:361 > (sofia/internal/5596@226.59.129.221:5060) State INIT going to sleep > 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:325 > (sofia/internal/5596@226.59.129.221:5060) Running State Change CS_ROUTING > nua(0x18cc2c80): recv signal r_invite > 2011-04-12 15:29:06.285484 [DEBUG] switch_channel.c:1668 > (sofia/internal/5596@226.59.129.221:5060) Callstate Change DOWN -> RINGING > nua: nua_stack_set_params: entering > soa_clone(static::0x18c66f60, 0x18c474e0, 0x18cc2c80) called > soa_set_params(static::0x2aaabc072a60, ...) called > soa_set_params(static::0x2aaabc072a60, ...) called > soa_set_user_sdp(static::0x2aaabc072a60, (nil), 0x18ccb7b7, -1) called > soa_set_capability_sdp(static::0x2aaabc072a60, (nil), 0x18ccb7b7, -1) called > 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:364 > (sofia/internal/5596@226.59.129.221:5060) State ROUTING > 2011-04-12 15:29:06.285484 [DEBUG] mod_sofia.c:147 > sofia/internal/5596@226.59.129.221:5060 SOFIA ROUTING > 2011-04-12 15:29:06.285484 [DEBUG] switch_ivr_originate.c:66 > (sofia/internal/5596@226.59.129.221:5060) State Change CS_ROUTING -> > CS_CONSUME_MEDIA > nua(0x18cc2c80): adding session usage > 2011-04-12 15:29:06.285484 [DEBUG] switch_core_session.c:1116 Send signal > sofia/internal/5596@226.59.129.221:5060 [BREAK] > 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:364 > (sofia/internal/5596@226.59.129.221:5060) State ROUTING going to sleep > 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:325 > (sofia/internal/5596@226.59.129.221:5060) Running State Change > CS_CONSUME_MEDIA > nta_leg_tcreate(0x2aaaac05e220) > soa_init_offer_answer(static::0x2aaabc072a60) called > soa_generate_offer(static::0x2aaabc072a60, 0) called > soa_static_offer_answer_action(0x2aaabc072a60, soa_generate_offer): called > soa_static(0x2aaabc072a60, soa_generate_offer): generating local description > soa_static(0x2aaabc072a60, soa_generate_offer): upgrade with local > description > 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:383 > (sofia/internal/5596@226.59.129.221:5060) State CONSUME_MEDIA > soa_sdp_mode_set(0x406f6c60, (nil), ""): called > 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:383 > (sofia/internal/5596@226.59.129.221:5060) State CONSUME_MEDIA going to sleep > soa_static(0x2aaabc072a60, soa_generate_offer): storing local description > soa_get_local_sdp(static::0x2aaabc072a60, [(nil)], [0x406f6dc8], > [0x406f6dd4]) called > nta: selecting scheme sip > tport_tsend(0x18c69750) tpn = */226.59.129.221:5060 > tport_resolve addrinfo = 226.59.129.221:5060 > tport_by_addrinfo(0x18c69750): not found by name */226.59.129.221:5060 > tport_vsend(0x18c69750): 1245 bytes of 1245 to udp/226.59.129.221:5060 > tport_vsend returned 1245 > nta: sent INVITE (10982209) to */226.59.129.221:5060 > tport_pend(0x18c69750): pending 0x2aaaac059c30 for udp/226.59.129.223:5060 > (already 0) > nta: timer set to 32000 ms > nta: timer shortened to 1000 ms > nua(0x18cc2c80): call state changed: init -> calling, sent offer > soa_get_local_sdp(static::0x2aaabc072a60, [0x406f6db8], [0x406f6db0], > [(nil)]) called > nua(0x18cc2c80): event i_state INVITE sent > nua: nua_application_event: entering > 2011-04-12 15:29:06.285484 [DEBUG] sofia.c:4761 Channel > sofia/internal/5596@226.59.129.221:5060 entering state [calling][0] > nua: nua_handle_magic: entering > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) > has 344 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x18c87620 (344 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 100 Trying for INVITE (10982209) > nta: 100 Trying is going to a transaction > nta_outgoing: RTT is 0.765 ms > tport_release(0x18c69750): 0x2aaaac059c30 by 0x2aaabc05da60 with 0x18c87620 > (preliminary) > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x2aaabc070b20 from > (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x2aaabc070b20 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > tport_release(0x18c69750): 0x2aaaac059c30 by 0x2aaabc05da60 with > 0x2aaabc070b20 > soa_set_remote_sdp(static::0x2aaabc072a60, (nil), 0x2aaabc0712ac, 247) > called > soa_process_answer(static::0x2aaabc072a60) called > soa_static_offer_answer_action(0x2aaabc072a60, soa_process_answer): called > soa_sdp_mode_set(0x2aaabc070240, 0x2aaabc073500, ""): called > soa_static(0x2aaabc072a60, soa_process_answer): upgrade codecs with remote > description > soa_static(0x2aaabc072a60, soa_process_answer): storing local description > soa_activate(static::0x2aaabc072a60, (nil)) called > nua(0x18cc2c80): INVITE: processed SDP answer in 200 OK > nua(0x18cc2c80): event r_invite 200 OK > nua(0x18cc2c80): call state changed: calling -> completing, received answer > soa_get_remote_sdp(static::0x2aaabc072a60, [0x406f6828], [0x406f6820], > [(nil)]) called > soa_get_params(static::0x2aaabc072a60, ...) called > nua: nua_application_event: entering > nua(0x18cc2c80): event i_state 200 OK > 2011-04-12 15:29:06.294311 [INFO] sofia.c:740 > sofia/internal/5596@226.59.129.221:5060 Update Callee ID to "5596" > <sip:5596@226.59.129.221> > nta: timer not set > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x2aaab4022620 from > (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x2aaab4022620 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > nta: 200 OK is duplicate response to 10982209 INVITE > Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg > nta: timer set next to 31009 ms > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x2aaab4022620 from > (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x2aaab4022620 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > nta: 200 OK is duplicate response to 10982209 INVITE > Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x2aaaac060220 from > (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x2aaaac060220 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > nta: 200 OK is duplicate response to 10982209 INVITE > Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x2aaaac060220 from > (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x2aaaac060220 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > nta: 200 OK is duplicate response to 10982209 INVITE > Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x2aaaac060220 from > (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x2aaaac060220 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > nta: 200 OK is duplicate response to 10982209 INVITE > Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) > has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x18c87620 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > nta: 200 OK is duplicate response to 10982209 INVITE > Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) > has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x18c87620 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > nta: 200 OK is duplicate response to 10982209 INVITE > Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) > has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x18c87620 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > nta: 200 OK is duplicate response to 10982209 INVITE > Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg > tport_wakeup_pri(0x18c4dcc0): events IN > tport_recv_event(0x18c4dcc0) > tport_recv_iovec(0x18c4dcc0) msg 0x2aaaac060220 from > (udp/226.59.129.223:5080) has 876 bytes, veclen = 1 > tport_deliver(0x18c4dcc0): msg 0x2aaaac060220 (876 bytes) from > udp/226.59.139.61:5080/sip next=(nil) > nta: received INVITE sip:5025155596@fs2000.lightyear.net SIP/2.0 (CSeq 1) > nta: INVITE (1) going to existing INVITE transaction > nta: re-received INVITE request, retransmitting 100 reply > tport_tsend(0x18c4dcc0) tpn = UDP/226.59.139.61:5060 > tport_resolve addrinfo = 226.59.139.61:5060 > tport_by_addrinfo(0x18c4dcc0): not found by name UDP/226.59.139.61:5060 > tport_vsend(0x18c4dcc0): 397 bytes of 397 to udp/226.59.139.61:5060 > tport_vsend returned 397 > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) > has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x18c87620 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > nta: 200 OK is duplicate response to 10982209 INVITE > Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg > tport_wakeup_pri(0x18c69750): events IN > tport_recv_event(0x18c69750) > tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) > has 1235 bytes, veclen = 1 > tport_deliver(0x18c69750): msg 0x18c87620 (1235 bytes) from > udp/226.59.129.221:5060/sip next=(nil) > nta: received 200 OK for INVITE (10982209) > nta: 200 OK is going to a transaction > nta: 200 OK is duplicate response to 10982209 INVITE > Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg > 2011-04-12 15:29:36.002806 [DEBUG] switch_channel.c:2563 > (sofia/internal/5596@226.59.129.221:5060) Callstate Change RINGING -> HANGUP > 2011-04-12 15:29:36.002806 [NOTICE] switch_ivr_originate.c:3329 Hangup > sofia/internal/5596@226.59.129.221:5060 [CS_CONSUME_MEDIA] [NO_ANSWER] > 2011-04-12 15:29:36.002806 [DEBUG] switch_channel.c:2579 Send signal > sofia/internal/5596@226.59.129.221:5060 [KILL] > 2011-04-12 15:29:36.002806 [DEBUG] switch_core_session.c:1116 Send signal > sofia/internal/5596@226.59.129.221:5060 [BREAK] > 2011-04-12 15:29:36.002806 [INFO] mod_dptools.c:2647 Originate Failed. > Cause: NO_ANSWER > 2011-04-12 15:29:36.002806 [DEBUG] switch_cpp.cpp:988 > sofia/external/1009(a)fs2000.lightyear.net destroy/unlink session from object > 2011-04-12 15:29:36.002806 [DEBUG] switch_core_state_machine.c:325 > (sofia/internal/5596@226.59.129.221:5060) Running State Change CS_HANGUP > 2011-04-12 15:29:36.002806 [DEBUG] switch_core_state_machine.c:565 > (sofia/internal/5596@226.59.129.221:5060) State HANGUP > EXECUTE sofia/external/1009(a)fs2000.lightyear.net answer() > 2011-04-12 15:29:36.003897 [DEBUG] sofia_glue.c:3014 AUDIO RTP > [sofia/external/1009(a)fs2000.lightyear.net] 226.59.129.223 port 27272 -> > 226.59.139.61 port 49420 codec: 3 ms: 20 > nua: nua_handle_magic: entering > 2011-04-12 15:29:36.003897 [DEBUG] switch_rtp.c:1623 Starting timer [soft] > 160 bytes per 20ms > nua: nua_application_event: entering > 2011-04-12 15:29:36.003897 [DEBUG] mod_sofia.c:457 Channel > sofia/internal/5596@226.59.129.221:5060 hanging up, cause: NO_ANSWER > 2011-04-12 15:29:36.004809 [DEBUG] sofia_glue.c:3276 Set 2833 dtmf send > payload to 101 > 2011-04-12 15:29:36.004809 [DEBUG] sofia_glue.c:3281 Set 2833 dtmf receive > payload to 101 > 2011-04-12 15:29:36.004809 [DEBUG] mod_sofia.c:681 Local SDP > sofia/external/1009(a)fs2000.lightyear.net: > v=0 > o=FreeSWITCH 1302609304 1302609305 IN IP4 226.59.129.223 > s=FreeSWITCH > c=IN IP4 226.59.129.223 > > > > > > _______________________________________________ > FreeSWITCH-users mailing list > FreeSWITCH-users(a)lists.freeswitch.org > http://lists.freeswitch.org/mailman/listinfo/freeswitch-users > UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users > http://www.freeswitch.org > > -- Anthony Minessale II FreeSWITCH http://www.freeswitch.org/ ClueCon http://www.cluecon.com/ Twitter: http://twitter.com/FreeSWITCH_wire AIM: anthm MSN:anthony_minessale@hotmail.com GTALK/JABBER/PAYPAL:anthony.minessale@gmail.com IRC: irc.freenode.net #freeswitch FreeSWITCH Developer Conference sip:888@conference.freeswitch.org googletalk:conf+888@conference.freeswitch.org pstn:+19193869900 _______________________________________________ FreeSWITCH-users mailing list FreeSWITCH-users(a)lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org

3 2

FreeSWITCH Conference Call Today - SIPVicious (friendly-scanner) Author
by Michael Collins 13 Apr '11

13 Apr '11

Hello! Please join us for the conference call today as we welcome Sandro Gauci, author of SIPVicious. You may know this better by the name "friend-scanner" that the script kiddies are using. Hear from the SIPVicious author to find out what lead to him creating this tool, some of the challenges he's faced, and how he's dealt with nefarious types who've been misusing it. Today's agenda is here: http://wiki.freeswitch.org/wiki/FS_weekly_2011_04_13 Talk to you all soon! -MC

1 0

Re: [Freeswitch-users] CALL_REJECT on freeswitch
by Gourav Vohra 13 Apr '11

13 Apr '11

I have two freeswitch servers. First one is installed using the official release and the second is from a snapshot from mar 15. Call reject on the official release works without any problem. It doesn't work on the snapshot release. I am also having some trouble with SLA and barge on the snapshot release whereas the official release works without any problems. I am assuming the Official release should be used in production and snapshot releases are only for testing. Please correct me if I am wrong. Thanks.

3 8

Event queue is full.
by Gary Chen 13 Apr '11

13 Apr '11

FreeSWITCH Version 1.0.head (git-5310735 2011-04-07 15-47-30 -0500) Last night I start Sipp to sent calls to my test FS1 and FS1 in turn forward calls to another FS2 playing Music On Hold. I got about 300 concurrent calls with media going through FS1 before I left. This morning, the FS1 is not responding. I fs_cli into it and got a lot of messages like this: 2011-04-13 08:12:11.766570 [CRIT] switch_event.c:1367 Event queue is full! x2011-04-13 08:12:11.798571 [CRIT] switch_event.c:1367 Event queue is full! 2011-04-13 08:12:11.809567 [CRIT] switch_event.c:1367 Event queue is full! 2011-04-13 08:12:11.809567 [CRIT] switch_event.c:1367 Event queue is full! 2011-04-13 08:12:11.816565 [CRIT] switch_event.c:1367 Event queue is full! 2011-04-13 08:12:11.827574 [CRIT] switch_event.c:1367 Event queue is full! .... What is the possible cause of this? The FS1 is still running, How do I cleanup the Event queue beside reboot FS? Gary

2 1

Incompatible destination
by FERNANDO VILLARROEL 13 Apr '11

13 Apr '11

Hi All. Today i updated my FS to version: FreeSWITCH Version 1.0.head (git-54e5011 2011-04-12 13-35-39 -0500) Before the do updated the calls are worked fine. But now i can't made calls: http://pastebin.ca/2045671 Anyone could help me? Regards.

3 2

Re: [Freeswitch-users] Passing SIP headers from b-leg to a-leg
by Javier Gallart 13 Apr '11

13 Apr '11

Hi Anthony, I'm using verson FreeSWITCH Version 1.0.head (git-54e5011 2011-04-12 13-35-39 -0500), but I haven't been able to make it work. This is my bridge application line: <action application="bridge" data="{sip_copy_custom_headers=true}sofia/internal/${ destination_number}(a)79.170.68.217" This the the failed response I'm getting from the provider: SIP/2.0 503 Service Unavailable..Via: SIP/2.0/UDP 79.170.68.154;rport;branch=z9hG4bKN48DavB78KjBm..From: "34917019888" < sip:34917019888@79.170.68.154>;tag=atFFtate53HcH..To: <sip:34661574758@79.170.68.217>;tag=1..Call-ID: 64911780-e04d-122e-ca81-001b7873d3a2..CSeq: 11006136 INVITE..Reason: Q.850 ;cause=34 ;text="Unknown"..*X-Release-Source: Provider*..Content-Length: 0.... And this is the message sent by FS to the A_leg: SIP/2.0 503 Service Unavailable..Via: SIP/2.0/UDP 79.170.68.144;branch=z9hG4bK805.e2f3bfa1.0..Via: SIP/2.0/UDP 79.170.64.151:5060;branch=z9hG4bK14faa4097ll7d213fINV26d034814d a55dbf..From: <sip:34917019888@79.170.64.151;noa=international>;tag=26d03481-co7455-INS001..To: <sip:34661574758@79.170.68.144 ;noa=international>;tag=5cHKH35vKQ2eQ..Call-ID: 4da55dbf000000050000001372519733@ens.com..CSeq: 745501 INVITE..User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-54e5011 2011-04-12 13-35-39 -0500..Accept: application/sdp..Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE..Supported: timer, precondition, path, replaces..Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer..Reason: Q.850;cause=41;text="NORMAL_TEMPORARY_FAILURE"..Content-Length: 0..Remote-Party-ID: "34661574758" <sip:34661574758@79.170.68.154 >;party=calling;privacy=off;screen=no.... Any idea of what am I doing wrong? Regards Javi ---------- Forwarded message ---------- > From: Anthony Minessale <anthony.minessale(a)gmail.com> > To: FreeSWITCH Users Help <freeswitch-users(a)lists.freeswitch.org> > Date: Tue, 12 Apr 2011 10:36:04 -0500 > Subject: > assuming you are on a more modern release: > > add {sip_copy_custom_headers=true} to the dial string of the b leg. > > > > > On Tue, Apr 12, 2011 at 6:02 AM, Javier Gallart <jgallartm(a)gmail.com> > wrote: > > Hi all > > I'm trying to pass some custom X-headers in final failed responses (>400) > > from B-leg to A-leg...is there a way to accomplish this? > > Thanks in advance > > > > _______________________________________________ > > FreeSWITCH-users mailing list > > FreeSWITCH-users(a)lists.freeswitch.org > > http://lists.freeswitch.org/mailman/listinfo/freeswitch-users > > UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users > > http://www.freeswitch.org > > > > > > > > -- > Anthony Minessale II > > FreeSWITCH http://www.freeswitch.org/ > ClueCon http://www.cluecon.com/ > Twitter: http://twitter.com/FreeSWITCH_wire > > AIM: anthm > MSN:anthony_minessale@hotmail.com > GTALK/JABBER/PAYPAL:anthony.minessale@gmail.com > IRC: irc.freenode.net #freeswitch > > FreeSWITCH Developer Conference > sip:888@conference.freeswitch.org > googletalk:conf+888@conference.freeswitch.or<googletalk%3Aconf%2B888(a)conference.freeswitch.org> > pstn:+19193869900 > > > > >

1 0

Freeswitch Server Down
by ovvenkat 13 Apr '11

13 Apr '11

Hi to all, Today, All my IVR are stopped working. When I check the freeSwitch it was down. I dont know the reason why Its Down. How I can find the reason, why my freeSwitch went down? Regards, Venkat.

4 6

FreeSWITCH: No Longer The Best Kept Secret In OSS VoIP Software
by Michael Collins 13 Apr '11

13 Apr '11

As you know, the FreeSWITCH project and community are both growing rapidly. We are always looking for people to step up and help out. This article talks about some of the things that you can do to assist in dealing with the growing pains that we all feel: http://www.freeswitch.org/node/320 Thanks for your support and please keep up the good work! -Michael

1 0

FS does not repose to SIP OK message.
by Gary Chen 13 Apr '11

13 Apr '11

Just update my test FS to newest snapshot: FreeSWITCH Version 1.0.head (git-5310735 2011-04-07 15-47-30 -0500) I am using SJphone softphone to call into my test FS1. This FS1 then forward the call to another FS2. FS2 will answer the call and start Music On Hold. Basically I am using SJphone to initiate a SIP call and let FS2 to answer the call with Music On Hold. It is working with older version of FS. Now after update to this newest version. The call sometime will not go through. The SJPhone just keep ringing until timeout. This happens maybe on half of the calls. I also tried to use Asterisk to replace FS2 for Music On Hold and it did the same thing. The following is the part of console sofia log info: 2011-04-12 15:29:06.285484 [DEBUG] mod_sofia.c:84 sofia/internal/5596@226.59.129.221:5060 SOFIA INIT nua: nh_create_handle: entering nua: nua_handle_bind: entering nua: nua_invite: entering nua(0x18cc2c80): sent signal r_invite 2011-04-12 15:29:06.285484 [DEBUG] mod_sofia.c:124 (sofia/internal/5596@226.59.129.221:5060) State Change CS_INIT -> CS_ROUTING 2011-04-12 15:29:06.285484 [DEBUG] switch_core_session.c:1116 Send signal sofia/internal/5596@226.59.129.221:5060 [BREAK] 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:361 (sofia/internal/5596@226.59.129.221:5060) State INIT going to sleep 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:325 (sofia/internal/5596@226.59.129.221:5060) Running State Change CS_ROUTING nua(0x18cc2c80): recv signal r_invite 2011-04-12 15:29:06.285484 [DEBUG] switch_channel.c:1668 (sofia/internal/5596@226.59.129.221:5060) Callstate Change DOWN -> RINGING nua: nua_stack_set_params: entering soa_clone(static::0x18c66f60, 0x18c474e0, 0x18cc2c80) called soa_set_params(static::0x2aaabc072a60, ...) called soa_set_params(static::0x2aaabc072a60, ...) called soa_set_user_sdp(static::0x2aaabc072a60, (nil), 0x18ccb7b7, -1) called soa_set_capability_sdp(static::0x2aaabc072a60, (nil), 0x18ccb7b7, -1) called 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:364 (sofia/internal/5596@226.59.129.221:5060) State ROUTING 2011-04-12 15:29:06.285484 [DEBUG] mod_sofia.c:147 sofia/internal/5596@226.59.129.221:5060 SOFIA ROUTING 2011-04-12 15:29:06.285484 [DEBUG] switch_ivr_originate.c:66 (sofia/internal/5596@226.59.129.221:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA nua(0x18cc2c80): adding session usage 2011-04-12 15:29:06.285484 [DEBUG] switch_core_session.c:1116 Send signal sofia/internal/5596@226.59.129.221:5060 [BREAK] 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:364 (sofia/internal/5596@226.59.129.221:5060) State ROUTING going to sleep 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:325 (sofia/internal/5596@226.59.129.221:5060) Running State Change CS_CONSUME_MEDIA nta_leg_tcreate(0x2aaaac05e220) soa_init_offer_answer(static::0x2aaabc072a60) called soa_generate_offer(static::0x2aaabc072a60, 0) called soa_static_offer_answer_action(0x2aaabc072a60, soa_generate_offer): called soa_static(0x2aaabc072a60, soa_generate_offer): generating local description soa_static(0x2aaabc072a60, soa_generate_offer): upgrade with local description 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:383 (sofia/internal/5596@226.59.129.221:5060) State CONSUME_MEDIA soa_sdp_mode_set(0x406f6c60, (nil), ""): called 2011-04-12 15:29:06.285484 [DEBUG] switch_core_state_machine.c:383 (sofia/internal/5596@226.59.129.221:5060) State CONSUME_MEDIA going to sleep soa_static(0x2aaabc072a60, soa_generate_offer): storing local description soa_get_local_sdp(static::0x2aaabc072a60, [(nil)], [0x406f6dc8], [0x406f6dd4]) called nta: selecting scheme sip tport_tsend(0x18c69750) tpn = */226.59.129.221:5060 tport_resolve addrinfo = 226.59.129.221:5060 tport_by_addrinfo(0x18c69750): not found by name */226.59.129.221:5060 tport_vsend(0x18c69750): 1245 bytes of 1245 to udp/226.59.129.221:5060 tport_vsend returned 1245 nta: sent INVITE (10982209) to */226.59.129.221:5060 tport_pend(0x18c69750): pending 0x2aaaac059c30 for udp/226.59.129.223:5060 (already 0) nta: timer set to 32000 ms nta: timer shortened to 1000 ms nua(0x18cc2c80): call state changed: init -> calling, sent offer soa_get_local_sdp(static::0x2aaabc072a60, [0x406f6db8], [0x406f6db0], [(nil)]) called nua(0x18cc2c80): event i_state INVITE sent nua: nua_application_event: entering 2011-04-12 15:29:06.285484 [DEBUG] sofia.c:4761 Channel sofia/internal/5596@226.59.129.221:5060 entering state [calling][0] nua: nua_handle_magic: entering tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) has 344 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x18c87620 (344 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 100 Trying for INVITE (10982209) nta: 100 Trying is going to a transaction nta_outgoing: RTT is 0.765 ms tport_release(0x18c69750): 0x2aaaac059c30 by 0x2aaabc05da60 with 0x18c87620 (preliminary) tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x2aaabc070b20 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x2aaabc070b20 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction tport_release(0x18c69750): 0x2aaaac059c30 by 0x2aaabc05da60 with 0x2aaabc070b20 soa_set_remote_sdp(static::0x2aaabc072a60, (nil), 0x2aaabc0712ac, 247) called soa_process_answer(static::0x2aaabc072a60) called soa_static_offer_answer_action(0x2aaabc072a60, soa_process_answer): called soa_sdp_mode_set(0x2aaabc070240, 0x2aaabc073500, ""): called soa_static(0x2aaabc072a60, soa_process_answer): upgrade codecs with remote description soa_static(0x2aaabc072a60, soa_process_answer): storing local description soa_activate(static::0x2aaabc072a60, (nil)) called nua(0x18cc2c80): INVITE: processed SDP answer in 200 OK nua(0x18cc2c80): event r_invite 200 OK nua(0x18cc2c80): call state changed: calling -> completing, received answer soa_get_remote_sdp(static::0x2aaabc072a60, [0x406f6828], [0x406f6820], [(nil)]) called soa_get_params(static::0x2aaabc072a60, ...) called nua: nua_application_event: entering nua(0x18cc2c80): event i_state 200 OK 2011-04-12 15:29:06.294311 [INFO] sofia.c:740 sofia/internal/5596@226.59.129.221:5060 Update Callee ID to "5596" <sip:5596@226.59.129.221> nta: timer not set tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x2aaab4022620 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x2aaab4022620 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction nta: 200 OK is duplicate response to 10982209 INVITE Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg nta: timer set next to 31009 ms tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x2aaab4022620 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x2aaab4022620 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction nta: 200 OK is duplicate response to 10982209 INVITE Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x2aaaac060220 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x2aaaac060220 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction nta: 200 OK is duplicate response to 10982209 INVITE Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x2aaaac060220 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x2aaaac060220 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction nta: 200 OK is duplicate response to 10982209 INVITE Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x2aaaac060220 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x2aaaac060220 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction nta: 200 OK is duplicate response to 10982209 INVITE Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x18c87620 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction nta: 200 OK is duplicate response to 10982209 INVITE Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x18c87620 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction nta: 200 OK is duplicate response to 10982209 INVITE Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x18c87620 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction nta: 200 OK is duplicate response to 10982209 INVITE Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg tport_wakeup_pri(0x18c4dcc0): events IN tport_recv_event(0x18c4dcc0) tport_recv_iovec(0x18c4dcc0) msg 0x2aaaac060220 from (udp/226.59.129.223:5080) has 876 bytes, veclen = 1 tport_deliver(0x18c4dcc0): msg 0x2aaaac060220 (876 bytes) from udp/226.59.139.61:5080/sip next=(nil) nta: received INVITE sip:5025155596@fs2000.lightyear.net SIP/2.0 (CSeq 1) nta: INVITE (1) going to existing INVITE transaction nta: re-received INVITE request, retransmitting 100 reply tport_tsend(0x18c4dcc0) tpn = UDP/226.59.139.61:5060 tport_resolve addrinfo = 226.59.139.61:5060 tport_by_addrinfo(0x18c4dcc0): not found by name UDP/226.59.139.61:5060 tport_vsend(0x18c4dcc0): 397 bytes of 397 to udp/226.59.139.61:5060 tport_vsend returned 397 tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x18c87620 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction nta: 200 OK is duplicate response to 10982209 INVITE Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg tport_wakeup_pri(0x18c69750): events IN tport_recv_event(0x18c69750) tport_recv_iovec(0x18c69750) msg 0x18c87620 from (udp/226.59.129.223:5060) has 1235 bytes, veclen = 1 tport_deliver(0x18c69750): msg 0x18c87620 (1235 bytes) from udp/226.59.129.221:5060/sip next=(nil) nta: received 200 OK for INVITE (10982209) nta: 200 OK is going to a transaction nta: 200 OK is duplicate response to 10982209 INVITE Via: SIP/2.0/UDP 226.59.129.223 ;branch=z9hG4bKa9ee6QBjeKFtg 2011-04-12 15:29:36.002806 [DEBUG] switch_channel.c:2563 (sofia/internal/5596@226.59.129.221:5060) Callstate Change RINGING -> HANGUP 2011-04-12 15:29:36.002806 [NOTICE] switch_ivr_originate.c:3329 Hangup sofia/internal/5596@226.59.129.221:5060 [CS_CONSUME_MEDIA] [NO_ANSWER] 2011-04-12 15:29:36.002806 [DEBUG] switch_channel.c:2579 Send signal sofia/internal/5596@226.59.129.221:5060 [KILL] 2011-04-12 15:29:36.002806 [DEBUG] switch_core_session.c:1116 Send signal sofia/internal/5596@226.59.129.221:5060 [BREAK] 2011-04-12 15:29:36.002806 [INFO] mod_dptools.c:2647 Originate Failed. Cause: NO_ANSWER 2011-04-12 15:29:36.002806 [DEBUG] switch_cpp.cpp:988 sofia/external/1009(a)fs2000.lightyear.net destroy/unlink session from object 2011-04-12 15:29:36.002806 [DEBUG] switch_core_state_machine.c:325 (sofia/internal/5596@226.59.129.221:5060) Running State Change CS_HANGUP 2011-04-12 15:29:36.002806 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/5596@226.59.129.221:5060) State HANGUP EXECUTE sofia/external/1009(a)fs2000.lightyear.net answer() 2011-04-12 15:29:36.003897 [DEBUG] sofia_glue.c:3014 AUDIO RTP [sofia/external/1009(a)fs2000.lightyear.net] 226.59.129.223 port 27272 -> 226.59.139.61 port 49420 codec: 3 ms: 20 nua: nua_handle_magic: entering 2011-04-12 15:29:36.003897 [DEBUG] switch_rtp.c:1623 Starting timer [soft] 160 bytes per 20ms nua: nua_application_event: entering 2011-04-12 15:29:36.003897 [DEBUG] mod_sofia.c:457 Channel sofia/internal/5596@226.59.129.221:5060 hanging up, cause: NO_ANSWER 2011-04-12 15:29:36.004809 [DEBUG] sofia_glue.c:3276 Set 2833 dtmf send payload to 101 2011-04-12 15:29:36.004809 [DEBUG] sofia_glue.c:3281 Set 2833 dtmf receive payload to 101 2011-04-12 15:29:36.004809 [DEBUG] mod_sofia.c:681 Local SDP sofia/external/1009(a)fs2000.lightyear.net: v=0 o=FreeSWITCH 1302609304 1302609305 IN IP4 226.59.129.223 s=FreeSWITCH c=IN IP4 226.59.129.223

2 1

error loading mod_file_string
by elijah 13 Apr '11

13 Apr '11

After updating a FreeSwitch installation against the repository today I see this error in the console on startup: switch_loadable_module.c:928 Error Loading module /usr/local/freeswitch/mod/mod_file_string.so **/usr/local/freeswitch/mod/mod_file_string.so: cannot open shared object file: No such file or directory** There are no other apparent symptoms. Please let me know if I'm an idiot or if you prefer I enter this in Jira or just think I should comment out mod_file_string in my modules.conf. thanks, elijah

3 3