[Freeswitch-users] SIP/Sofia create channel 503 error…

[Bit Rot]

Hey y'all,
 
We have FreeSWITCH and Microsoft Speech Server 2007 running fine on separate boxes.  However when we try to consolidate onto a single box as per instructions for inbound DID calls in Brian Campbell’s most excellent blog: 
 
http://gotspeech.net/blogs/verbalinput/archive/2010/01/08/speech-server-2007-marries-freeswitch-part-4-receiving-calls.aspx 
 
We receive a 503 error – terminate and SIP returns Error Cause: 41 [NORMAL_TEMPORARY_FAILURE].
 
The first leg from the provider to FreeSwitch works fine and the dialplan is parsed correctly, also outbound calls through FreeSWITCH work.  The problem occurs when the second leg of the call is trying to create a channel from FreeSWITCH to the Speech Server.  Here is the trace:
 
EXECUTE sofia/external/106308_1 at 74.54.54.178 bridge(sofia/internal/2146130149 at 127.0.0.1:5060;transport=tcp)
2011-01-13 22:23:27.387971 [NOTICE] switch_channel.c:784 New Channel sofia/internal/2146130149 at 127.0.0.1:5060 [1df88e9c-16e6-415a-ac1b-83e29d25b3b0]
2011-01-13 22:23:27.387971 [DEBUG] mod_sofia.c:3976 (sofia/internal/2146130149 at 127.0.0.1:5060) State Change CS_NEW -> CS_INIT
2011-01-13 22:23:27.387971 [DEBUG] switch_core_session.c:1064 Send signal sofia/internal/2146130149 at 127.0.0.1:5060 [BREAK]
2011-01-13 22:23:27.387971 [DEBUG] switch_core_state_machine.c:320 (sofia/internal/2146130149 at 127.0.0.1:5060) Running State Change CS_INIT
2011-01-13 22:23:27.387971 [DEBUG] switch_core_state_machine.c:356 (sofia/internal/2146130149 at 127.0.0.1:5060) State INIT
2011-01-13 22:23:27.387971 [DEBUG] mod_sofia.c:86 sofia/internal/2146130149 at 127.0.0.1:5060 SOFIA INIT
2011-01-13 22:23:27.388971 [DEBUG] mod_sofia.c:126 (sofia/internal/2146130149 at 127.0.0.1:5060) State Change CS_INIT -> CS_ROUTING
2011-01-13 22:23:27.388971 [DEBUG] switch_core_session.c:1064 Send signal sofia/internal/2146130149 at 127.0.0.1:5060 [BREAK]
2011-01-13 22:23:27.388971 [DEBUG] switch_core_state_machine.c:356 (sofia/internal/2146130149 at 127.0.0.1:5060) State INIT going to sleep
2011-01-13 22:23:27.388971 [DEBUG] switch_core_state_machine.c:320 (sofia/internal/2146130149 at 127.0.0.1:5060) Running State Change CS_ROUTING
2011-01-13 22:23:27.388971 [DEBUG] switch_channel.c:1615 (sofia/internal/2146130149 at 127.0.0.1:5060) Callstate Change DOWN -> RINGING
2011-01-13 22:23:27.388971 [DEBUG] switch_core_state_machine.c:359 (sofia/internal/2146130149 at 127.0.0.1:5060) State ROUTING
2011-01-13 22:23:27.388971 [DEBUG] mod_sofia.c:149 sofia/internal/2146130149 at 127.0.0.1:5060 SOFIA ROUTING
2011-01-13 22:23:27.388971 [DEBUG] switch_ivr_originate.c:66 (sofia/internal/2146130149 at 127.0.0.1:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2011-01-13 22:23:27.388971 [DEBUG] switch_core_session.c:1064 Send signal sofia/internal/2146130149 at 127.0.0.1:5060 [BREAK]
2011-01-13 22:23:27.388971 [DEBUG] switch_core_state_machine.c:359 (sofia/internal/2146130149 at 127.0.0.1:5060) State ROUTING going to sleep
2011-01-13 22:23:27.388971 [DEBUG] switch_core_state_machine.c:320 (sofia/internal/2146130149 at 127.0.0.1:5060) Running State Change CS_CONSUME_MEDIA
2011-01-13 22:23:27.388971 [DEBUG] switch_core_state_machine.c:378 (sofia/internal/2146130149 at 127.0.0.1:5060) State CONSUME_MEDIA
2011-01-13 22:23:27.388971 [DEBUG] switch_core_state_machine.c:378 (sofia/internal/2146130149 at 127.0.0.1:5060) State CONSUME_MEDIA going to sleep
 
2011-01-13 22:23:27.389971 [DEBUG] sofia.c:4604 Channel sofia/internal/2146130149 at 127.0.0.1:5060 entering state [calling][0]
2011-01-13 22:23:27.389971 [DEBUG] sofia.c:4604 Channel sofia/internal/2146130149 at 127.0.0.1:5060 entering state [terminated][503]
 
2011-01-13 22:23:27.389971 [DEBUG] switch_channel.c:2455 (sofia/internal/2146130149 at 127.0.0.1:5060) Callstate Change RINGING -> HANGUP
2011-01-13 22:23:27.389971 [NOTICE] sofia.c:5244 Hangup sofia/internal/2146130149 at 127.0.0.1:5060 [CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE]
2011-01-13 22:23:27.389971 [DEBUG] switch_channel.c:2471 Send signal sofia/internal/2146130149 at 127.0.0.1:5060 [KILL]
 
The Speech Server is listening at TCP 0.0.0.0:5060 and Sofia Internal at TCP IP Addy of box also on port 5060.
 
Any help or insight would be much appreciated.
 
Cheers.
 
bit
 		 	   		  
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20110114/0e6f7d7b/attachment.html