Thanks Brian. That seems to work partially and strangely too. All calls made to extensions above '1019' stopped working now. When a call is destined to any extension above '1019' comes back with '480 Temporarily Unavailable'. Below is a pasted copy of the SIP trace for a call from 1001 to 1019 (works), and 1001 to 1020 (doesn't work). Registration output is also pasted below. ========================================================================== recv 726 bytes from udp/[192.168.1.100]:5062 at 11:18:28.880410: ------------------------------------------------------------------------ INVITE sip:1020@192.168.1.100 SIP/2.0 Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3263-1-0 From: 1001 <sip:1001@192.168.1.100>;tag=32631 To: 1020 <sip:1020@192.168.1.100> Call-ID: 1-3263@192.168.1.100 CSeq: 1 INVITE Contact: 1001 <sip:1001@192.168.1.100:5062> Max-Forwards: 70 Allow: INVITE, OPTIONS, ACK, BYE, CANCEL, INFO, NOTIFY, MESSAGE, UPDATE, SUBSCRIBE Supported: 100rel, replaces, from-change Timestamp: 1 Content-Type: application/sdp Content-Length: 238 v=0 o=1001 53655765 2353687637 IN IP4 192.168.1.100 s=Talk c=IN IP4 192.168.1.100 t=0 0 m=audio 6001 RTP/AVP 0 8 97 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:97 iLBC/8000 m=video 6001 RTP/AVP 31 a=rtpmap:31 H261/90000 ------------------------------------------------------------------------ send 333 bytes to udp/[192.168.1.100]:5062 at 11:18:28.880719: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3263-1-0 From: 1001 <sip:1001@192.168.1.100>;tag=32631 To: 1020 <sip:1020@192.168.1.100> Call-ID: 1-3263@192.168.1.100 CSeq: 1 INVITE Timestamp: 1 0.000152 User-Agent: FreeSWITCH-mod_sofia/1.4.20 +git~20150703T164215Z~b95362f965~64bit Content-Length: 0 ------------------------------------------------------------------------ 2015-07-21 11:18:28.863966 [NOTICE] switch_channel.c:1075 New Channel sofia/internal/1001@192.168.1.100 [d4084b55-8351-48fa-87ff-01d4b2355d4e] 2015-07-21 11:18:28.863966 [INFO] mod_dialplan_xml.c:635 Processing 1001 <1001>->1020 in context public 2015-07-21 11:18:28.863966 [NOTICE] switch_core_state_machine.c:315 sofia/internal/1001@192.168.1.100 has executed the last dialplan instruction, hanging up. 2015-07-21 11:18:28.863966 [NOTICE] switch_core_state_machine.c:317 Hangup sofia/internal/1001@192.168.1.100 [CS_EXECUTE] [NORMAL_CLEARING] send 836 bytes to udp/[192.168.1.100]:5062 at 11:18:28.885154: ------------------------------------------------------------------------ SIP/2.0 480 Temporarily Unavailable Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3263-1-0 Max-Forwards: 70 From: 1001 <sip:1001@192.168.1.100>;tag=32631 To: 1020 <sip:1020@192.168.1.100>;tag=mrKveDD123K3K Call-ID: 1-3263@192.168.1.100 CSeq: 1 INVITE User-Agent: FreeSWITCH-mod_sofia/1.4.20 +git~20150703T164215Z~b95362f965~64bit Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Reason: Q.850;cause=16;text="NORMAL_CLEARING" Content-Length: 0 Remote-Party-ID: "1020" <sip:1020@192.168.1.100>;party=calling;privacy=off;screen=no ------------------------------------------------------------------------ 2015-07-21 11:18:28.883950 [NOTICE] switch_core_session.c:1641 Session 20 (sofia/internal/1001@192.168.1.100) Ended 2015-07-21 11:18:28.883950 [NOTICE] switch_core_session.c:1645 Close Channel sofia/internal/1001@192.168.1.100 [CS_DESTROY] recv 361 bytes from udp/[192.168.1.100]:5062 at 11:18:28.887876: ------------------------------------------------------------------------ ACK sip:1020@192.168.1.100 SIP/2.0 Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3263-1-0 From: 1001 <sip:1001@192.168.1.100>;tag=32631 To: 1020 <sip:1020@192.168.1.100>;tag=mrKveDD123K3K Call-ID: 1-3263@192.168.1.100 CSeq: 1 ACK Contact: <sip:sipp@192.168.1.100:5062;transport=UDP> Max-Forwards: 70 Subject: Performance Test Content-Length: 0 ------------------------------------------------------------------------
>>>>> 1001 - 1019 - Working >>>>>>>>>>>>>>>>
recv 726 bytes from udp/[192.168.1.100]:5062 at 11:20:10.977891: ------------------------------------------------------------------------ INVITE sip:1019@192.168.1.100 SIP/2.0 Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3281-1-0 From: 1001 <sip:1001@192.168.1.100>;tag=32811 To: 1019 <sip:1019@192.168.1.100> Call-ID: 1-3281@192.168.1.100 CSeq: 1 INVITE Contact: 1001 <sip:1001@192.168.1.100:5062> Max-Forwards: 70 Allow: INVITE, OPTIONS, ACK, BYE, CANCEL, INFO, NOTIFY, MESSAGE, UPDATE, SUBSCRIBE Supported: 100rel, replaces, from-change Timestamp: 1 Content-Type: application/sdp Content-Length: 238 v=0 o=1001 53655765 2353687637 IN IP4 192.168.1.100 s=Talk c=IN IP4 192.168.1.100 t=0 0 m=audio 6001 RTP/AVP 0 8 97 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:97 iLBC/8000 m=video 6001 RTP/AVP 31 a=rtpmap:31 H261/90000 ------------------------------------------------------------------------ send 333 bytes to udp/[192.168.1.100]:5062 at 11:20:10.978324: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3281-1-0 From: 1001 <sip:1001@192.168.1.100>;tag=32811 To: 1019 <sip:1019@192.168.1.100> Call-ID: 1-3281@192.168.1.100 CSeq: 1 INVITE Timestamp: 1 0.000208 User-Agent: FreeSWITCH-mod_sofia/1.4.20 +git~20150703T164215Z~b95362f965~64bit Content-Length: 0 ------------------------------------------------------------------------ 2015-07-21 11:20:10.963951 [NOTICE] switch_channel.c:1075 New Channel sofia/internal/1001@192.168.1.100 [3ea757fa-c80f-471f-909c-21d6b35ccd94] 2015-07-21 11:20:10.963951 [INFO] mod_dialplan_xml.c:635 Processing 1001 <1001>->1019 in context public 2015-07-21 11:20:10.963951 [NOTICE] switch_ivr.c:1863 Transfer sofia/internal/1001@192.168.1.100 to XML[1019@default] 2015-07-21 11:20:10.963951 [INFO] mod_dialplan_xml.c:635 Processing 1001 <1001>->1019 in context default 2015-07-21 11:20:10.983953 [NOTICE] switch_channel.c:1075 New Channel sofia/internal/1019@192.168.1.100:5061 [2bb31faa-8cc2-400a-8997-3d5126acf148] send 1189 bytes to udp/[192.168.1.100]:5061 at 11:20:10.990948: ------------------------------------------------------------------------ INVITE sip:1019@192.168.1.100:5061 SIP/2.0 Via: SIP/2.0/UDP 192.168.1.100;rport;branch=z9hG4bK8829733UK6ttr Max-Forwards: 68 From: "1001" <sip:1001@192.168.1.100>;tag=pa6Dj3e8vN08a To: <sip:1019@192.168.1.100:5061> Call-ID: 337749d6-aa67-1233-6ca8-705ab6872cf3 CSeq: 78411741 INVITE Contact: <sip:mod_sofia@192.168.1.100:5060> User-Agent: FreeSWITCH-mod_sofia/1.4.20 +git~20150703T164215Z~b95362f965~64bit Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 249 X-FS-Support: update_display,send_info Remote-Party-ID: "1001" <sip:1001@192.168.1.100>;party=calling;screen=yes;privacy=off v=0 o=FreeSWITCH 1437471870 1437471871 IN IP4 192.168.1.100 s=FreeSWITCH c=IN IP4 192.168.1.100 t=0 0 m=audio 23740 RTP/AVP 0 8 101 13 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 ------------------------------------------------------------------------ recv 325 bytes from udp/[192.168.1.100]:5061 at 11:20:10.994691: ------------------------------------------------------------------------ SIP/2.0 180 Ringing Via: SIP/2.0/UDP 192.168.1.100;rport;branch=z9hG4bK8829733UK6ttr From: "1001" <sip:1001@192.168.1.100>;tag=pa6Dj3e8vN08a To: <sip:1019@192.168.1.100:5061>;tag=32791 Call-ID: 337749d6-aa67-1233-6ca8-705ab6872cf3 CSeq: 78411741 INVITE Contact: 1019 <sip:1019@192.168.1.100:5061> Content-Length: 0 ------------------------------------------------------------------------ 2015-07-21 11:20:10.983953 [NOTICE] sofia.c:6729 Ring-Ready sofia/internal/1019@192.168.1.100:5061! 2015-07-21 11:20:11.003950 [INFO] switch_ivr_originate.c:1193 Sending early media 2015-07-21 11:20:11.003950 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1001@192.168.1.100! send 1069 bytes to udp/[192.168.1.100]:5062 at 11:20:11.015428: ------------------------------------------------------------------------ SIP/2.0 183 Session Progress Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3281-1-0 From: 1001 <sip:1001@192.168.1.100>;tag=32811 To: 1019 <sip:1019@192.168.1.100>;tag=N1cNg8X4ZcapF Call-ID: 1-3281@192.168.1.100 CSeq: 1 INVITE Contact: <sip:1019@192.168.1.100:5060;transport=udp> User-Agent: FreeSWITCH-mod_sofia/1.4.20 +git~20150703T164215Z~b95362f965~64bit Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 188 Remote-Party-ID: "1019" <sip:1019@192.168.1.100>;party=calling;privacy=off;screen=no v=0 o=FreeSWITCH 1437471111 1437471112 IN IP4 192.168.1.100 s=FreeSWITCH c=IN IP4 192.168.1.100 t=0 0 m=audio 24500 RTP/AVP 0 a=rtpmap:0 PCMU/8000 a=ptime:20 m=video 0 RTP/AVP 19 ------------------------------------------------------------------------ recv 593 bytes from udp/[192.168.1.100]:5061 at 11:20:11.995950: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.100;rport;branch=z9hG4bK8829733UK6ttr From: "1001" <sip:1001@192.168.1.100>;tag=pa6Dj3e8vN08a To: <sip:1019@192.168.1.100:5061>;tag=32791 Call-ID: 337749d6-aa67-1233-6ca8-705ab6872cf3 CSeq: 78411741 INVITE Contact: 1019 <sip:1019@192.168.1.100:5061> Content-Type: application/sdp Content-Length: 238 v=0 o=5001 53655765 2353687637 IN IP4 192.168.1.100 s=Talk c=IN IP4 192.168.1.100 t=0 0 m=audio 6000 RTP/AVP 0 8 97 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:97 iLBC/8000 m=video 6000 RTP/AVP 31 a=rtpmap:31 H261/90000 ------------------------------------------------------------------------ send 360 bytes to udp/[192.168.1.100]:5061 at 11:20:11.998449: ------------------------------------------------------------------------ ACK sip:1019@192.168.1.100:5061 SIP/2.0 Via: SIP/2.0/UDP 192.168.1.100;rport;branch=z9hG4bK9Hv29ymZgFHDm Max-Forwards: 70 From: "1001" <sip:1001@192.168.1.100>;tag=pa6Dj3e8vN08a To: <sip:1019@192.168.1.100:5061>;tag=32791 Call-ID: 337749d6-aa67-1233-6ca8-705ab6872cf3 CSeq: 78411741 ACK Contact: <sip:mod_sofia@192.168.1.100:5060> Content-Length: 0 ------------------------------------------------------------------------ 2015-07-21 11:20:11.983975 [NOTICE] sofia.c:7488 Channel [sofia/internal/1019@192.168.1.100:5061] has been answered send 1039 bytes to udp/[192.168.1.100]:5062 at 11:20:12.013969: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3281-1-0 From: 1001 <sip:1001@192.168.1.100>;tag=32811 To: 1019 <sip:1019@192.168.1.100>;tag=N1cNg8X4ZcapF Call-ID: 1-3281@192.168.1.100 CSeq: 1 INVITE Contact: <sip:1019@192.168.1.100:5060;transport=udp> User-Agent: FreeSWITCH-mod_sofia/1.4.20 +git~20150703T164215Z~b95362f965~64bit Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 188 Remote-Party-ID: "Outbound Call" <sip:1019@192.168.1.100>;party=calling;privacy=off;screen=no v=0 o=FreeSWITCH 1437471111 1437471112 IN IP4 192.168.1.100 s=FreeSWITCH c=IN IP4 192.168.1.100 t=0 0 m=audio 24500 RTP/AVP 0 a=rtpmap:0 PCMU/8000 a=ptime:20 m=video 0 RTP/AVP 19 2015-07-21 11:20:11.983975 [NOTICE] switch_ivr_originate.c:3523 Channel [sofia/internal/1001@192.168.1.100] has been answered ------------------------------------------------------------------------ recv 371 bytes from udp/[192.168.1.100]:5062 at 11:20:12.018300: ------------------------------------------------------------------------ ACK sip:1019@192.168.1.100:5060;transport=udp SIP/2.0 Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3281-1-0 From: 1001 <sip:1001@192.168.1.100>;tag=32811 To: 1019 <sip:1019@192.168.1.100>;tag=N1cNg8X4ZcapF Call-ID: 1-3281@192.168.1.100 CSeq: 1 ACK Contact: 1001 <sip:1001@192.168.1.100:5062> Max-Forwards: 70 Subject: Performance Test Content-Length: 0 ------------------------------------------------------------------------ recv 371 bytes from udp/[192.168.1.100]:5062 at 11:20:17.020325: ------------------------------------------------------------------------ BYE sip:1019@192.168.1.100:5060;transport=udp SIP/2.0 Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3281-1-0 From: 1001 <sip:1001@192.168.1.100>;tag=32811 To: 1019 <sip:1019@192.168.1.100>;tag=N1cNg8X4ZcapF Call-ID: 1-3281@192.168.1.100 CSeq: 2 BYE Contact: 1001 <sip:1001@192.168.1.100:5062> Max-Forwards: 70 Subject: Performance Test Content-Length: 0 ------------------------------------------------------------------------ 2015-07-21 11:20:17.023972 [NOTICE] sofia.c:952 Hangup sofia/internal/1001@192.168.1.100 [CS_EXECUTE] [NORMAL_CLEARING] send 465 bytes to udp/[192.168.1.100]:5062 at 11:20:17.035053: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.100:5062;branch=z9hG4bK-3281-1-0 From: 1001 <sip:1001@192.168.1.100>;tag=32811 To: 1019 <sip:1019@192.168.1.100>;tag=N1cNg8X4ZcapF Call-ID: 1-3281@192.168.1.100 CSeq: 2 BYE User-Agent: FreeSWITCH-mod_sofia/1.4.20 +git~20150703T164215Z~b95362f965~64bit Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Content-Length: 0 ------------------------------------------------------------------------ 2015-07-21 11:20:17.023972 [NOTICE] switch_ivr_bridge.c:758 Hangup sofia/internal/1019@192.168.1.100:5061 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING] send 585 bytes to udp/[192.168.1.100]:5061 at 11:20:17.042705: ------------------------------------------------------------------------ BYE sip:1019@192.168.1.100:5061 SIP/2.0 Via: SIP/2.0/UDP 192.168.1.100;rport;branch=z9hG4bKaUNUBt52Dr7ZF Max-Forwards: 70 From: "1001" <sip:1001@192.168.1.100>;tag=pa6Dj3e8vN08a To: <sip:1019@192.168.1.100:5061>;tag=32791 Call-ID: 337749d6-aa67-1233-6ca8-705ab6872cf3 CSeq: 78411742 BYE User-Agent: FreeSWITCH-mod_sofia/1.4.20 +git~20150703T164215Z~b95362f965~64bit Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Reason: Q.850;cause=16;text="NORMAL_CLEARING" Content-Length: 0 ------------------------------------------------------------------------ 2015-07-21 11:20:17.023972 [NOTICE] switch_core_session.c:1641 Session 21 (sofia/internal/1001@192.168.1.100) Ended 2015-07-21 11:20:17.023972 [NOTICE] switch_core_session.c:1645 Close Channel sofia/internal/1001@192.168.1.100 [CS_DESTROY] 2015-07-21 11:20:17.023972 [NOTICE] switch_core_session.c:1641 Session 22 (sofia/internal/1019@192.168.1.100:5061) Ended 2015-07-21 11:20:17.023972 [NOTICE] switch_core_session.c:1645 Close Channel sofia/internal/1019@192.168.1.100:5061 [CS_DESTROY] recv 317 bytes from udp/[192.168.1.100]:5061 at 11:20:17.051862: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.100;rport;branch=z9hG4bKaUNUBt52Dr7ZF From: "1001" <sip:1001@192.168.1.100>;tag=pa6Dj3e8vN08a To: <sip:1019@192.168.1.100:5061>;tag=32791 Call-ID: 337749d6-aa67-1233-6ca8-705ab6872cf3 CSeq: 78411742 BYE Contact: 1019 <sip:1019@192.168.1.100:5061> Content-Length: 0 ================================================================== Call-ID: 1-2629@192.168.1.100 User: 1001@192.168.1.100 Contact: "" <sip:1001@192.168.1.100:5061> Agent: SIPp Status: Registered(UDP)(unknown) EXP(2015-07-21 12:25:01) EXPSECS(3112) Ping-Status: Reachable Host: everest IP: 192.168.1.100 Port: 5061 Auth-User: unknown Auth-Realm: 192.168.1.100 MWI-Account: 1001@192.168.1.100 -------------------------------------------------------- Call-ID: 1-3203@192.168.1.100 User: 1020@192.168.1.100 Contact: "" <sip:1020@192.168.1.100:5061> Agent: SIPp Status: Registered(UDP)(unknown) EXP(2015-07-21 13:11:07) EXPSECS(5878) Ping-Status: Reachable Host: everest IP: 192.168.1.100 Port: 5061 Auth-User: unknown Auth-Realm: 192.168.1.100 MWI-Account: 1020@192.168.1.100 -------------------------------------------------------- Call-ID: 1-3216@192.168.1.100 User: 1019@192.168.1.100 Contact: "" <sip:1019@192.168.1.100:5061> Agent: SIPp Status: Registered(UDP)(unknown) EXP(2015-07-21 13:11:51) EXPSECS(5922) Ping-Status: Reachable Host: everest IP: 192.168.1.100 Port: 5061 Auth-User: unknown Auth-Realm: 192.168.1.100 MWI-Account: 1019@192.168.1.100