[Freeswitch-users] FS processing 302
Chris Veazey
chris.veazey at gmail.com
Wed Aug 11 13:17:40 PDT 2010
Recompiled. Now getting a continuous Invite-->302 loop. That eventually gets
killed with a 503 by the upstream redirect server.
[root at fs1 log]# tail -f freeswitch.log
2010-08-11 20:03:30.027817 [DEBUG] switch_core_session.c:1039 Send signal
sofia/external/9995552000000 [BREAK]
2010-08-11 20:03:30.027817 [DEBUG] switch_core_session.c:1202 Session 6
(sofia/external/9995552000000) Locked, Waiting on external entities
2010-08-11 20:03:30.027817 [NOTICE] switch_core_session.c:1220 Session 6
(sofia/external/9995552000000) Ended
2010-08-11 20:03:30.027817 [NOTICE] switch_core_session.c:1222 Close Channel
sofia/external/9995552000000 [CS_DESTROY]
2010-08-11 20:03:30.027817 [DEBUG] switch_core_state_machine.c:427
(sofia/external/9995552000000) Callstate Change HANGUP -> DOWN
2010-08-11 20:03:30.027817 [DEBUG] switch_core_state_machine.c:430
(sofia/external/9995552000000) Running State Change CS_DESTROY
2010-08-11 20:03:30.027817 [DEBUG] switch_core_state_machine.c:440
(sofia/external/9995552000000) State DESTROY
2010-08-11 20:03:30.027817 [DEBUG] mod_sofia.c:358
sofia/external/9995552000000 SOFIA DESTROY
2010-08-11 20:03:30.027817 [DEBUG] switch_core_state_machine.c:60
sofia/external/9995552000000 Standard DESTROY
2010-08-11 20:03:30.027817 [DEBUG] switch_core_state_machine.c:440
(sofia/external/9995552000000) State DESTROY going to sleep
2010-08-11 20:07:50.601786 [DEBUG] sofia.c:5999 IP 10.14.0.128 Rejected by
acl "domains". Falling back to Digest auth.
2010-08-11 20:07:51.179975 [DEBUG] sofia.c:5999 IP 10.14.0.128 Rejected by
acl "domains". Falling back to Digest auth.
2010-08-11 20:07:51.186996 [NOTICE] switch_channel.c:779 New Channel
sofia/internal/9995551000000 at sip.blinkmind.net[1e96cac0-a584-11df-ba1a-11ad2b71c214]
2010-08-11 20:07:51.187997 [DEBUG] switch_core_state_machine.c:314
(sofia/internal/9995551000000 at sip.blinkmind.net) Running State Change CS_NEW
2010-08-11 20:07:51.187997 [DEBUG] switch_core_state_machine.c:320
(sofia/internal/9995551000000 at sip.blinkmind.net) State NEW
2010-08-11 20:07:51.195018 [DEBUG] sofia.c:4317 Channel sofia/internal/
9995551000000 at sip.blinkmind.net entering state [received][100]
2010-08-11 20:07:51.195018 [DEBUG] sofia.c:4328 Remote SDP:
v=0
o=- 0 0 IN IP4 10.14.0.128
s=-
c=IN IP4 10.14.0.128
t=0 0
m=audio 20596 RTP/AVP 107 0 101
a=rtpmap:107 CTL-SB-ADPCM/16000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
m=video 21114 RTP/AVP 125
a=rtpmap:125 H264/90000
a=fmtp:125
packetization-mode=1;profile-level-id=42E01F;sprop-parameter-sets=Z0IADPQLBKIA,aM44gAA=
2010-08-11 20:07:51.195018 [DEBUG] sofia.c:4445 (sofia/internal/
9995551000000 at sip.blinkmind.net) State Change CS_NEW -> CS_INIT
2010-08-11 20:07:51.195018 [DEBUG] switch_core_session.c:1039 Send signal
sofia/internal/9995551000000 at sip.blinkmind.net [BREAK]
2010-08-11 20:07:51.195018 [DEBUG] switch_core_state_machine.c:314
(sofia/internal/9995551000000 at sip.blinkmind.net) Running State Change
CS_INIT
2010-08-11 20:07:51.195018 [DEBUG] switch_core_state_machine.c:338
(sofia/internal/9995551000000 at sip.blinkmind.net) State INIT
2010-08-11 20:07:51.195018 [DEBUG] mod_sofia.c:83 sofia/internal/
9995551000000 at sip.blinkmind.net SOFIA INIT
2010-08-11 20:07:51.195018 [DEBUG] mod_sofia.c:119 (sofia/internal/
9995551000000 at sip.blinkmind.net) State Change CS_INIT -> CS_ROUTING
2010-08-11 20:07:51.195018 [DEBUG] switch_core_session.c:1039 Send signal
sofia/internal/9995551000000 at sip.blinkmind.net [BREAK]
2010-08-11 20:07:51.195018 [DEBUG] switch_core_state_machine.c:338
(sofia/internal/9995551000000 at sip.blinkmind.net) State INIT going to sleep
2010-08-11 20:07:51.195018 [DEBUG] switch_core_state_machine.c:314
(sofia/internal/9995551000000 at sip.blinkmind.net) Running State Change
CS_ROUTING
2010-08-11 20:07:51.195018 [DEBUG] switch_channel.c:1512 (sofia/internal/
9995551000000 at sip.blinkmind.net) Callstate Change DOWN -> RINGING
2010-08-11 20:07:51.196022 [DEBUG] switch_core_state_machine.c:341
(sofia/internal/9995551000000 at sip.blinkmind.net) State ROUTING
2010-08-11 20:07:51.196022 [DEBUG] mod_sofia.c:142 sofia/internal/
9995551000000 at sip.blinkmind.net SOFIA ROUTING
2010-08-11 20:07:51.196022 [DEBUG] switch_core_state_machine.c:77
sofia/internal/9995551000000 at sip.blinkmind.net Standard ROUTING
2010-08-11 20:07:51.196022 [INFO] mod_dialplan_xml.c:331 Processing
9995551000000->9995552000000 in context default
Dialplan: sofia/internal/9995551000000 at sip.blinkmind.net parsing
[default->unloop] continue=false
Dialplan: sofia/internal/9995551000000 at sip.blinkmind.net Regex (PASS)
[unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/internal/9995551000000 at sip.blinkmind.net Regex (FAIL)
[unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/9995551000000 at sip.blinkmind.net parsing
[default->sip_uri] continue=false
Dialplan: sofia/internal/9995551000000 at sip.blinkmind.net Regex (FAIL)
[sip_uri] destination_number(9995552000000) =~ /^sip:(.*)$/ break=on-false
Dialplan: sofia/internal/9995551000000 at sip.blinkmind.net parsing
[default->catchall] continue=false
Dialplan: sofia/internal/9995551000000 at sip.blinkmind.net Regex (PASS)
[catchall] destination_number(9995552000000) =~ /.*/ break=on-false
Dialplan: sofia/internal/9995551000000 at sip.blinkmind.net Action
bridge(sofia/gateway/sip.blinkmind.net/${destination_number})
2010-08-11 20:07:51.196022 [DEBUG] switch_core_state_machine.c:119
(sofia/internal/9995551000000 at sip.blinkmind.net) State Change CS_ROUTING ->
CS_EXECUTE
2010-08-11 20:07:51.196022 [DEBUG] switch_core_session.c:1039 Send signal
sofia/internal/9995551000000 at sip.blinkmind.net [BREAK]
2010-08-11 20:07:51.196022 [DEBUG] switch_core_state_machine.c:341
(sofia/internal/9995551000000 at sip.blinkmind.net) State ROUTING going to
sleep
2010-08-11 20:07:51.196022 [DEBUG] switch_core_state_machine.c:314
(sofia/internal/9995551000000 at sip.blinkmind.net) Running State Change
CS_EXECUTE
2010-08-11 20:07:51.196022 [DEBUG] switch_core_state_machine.c:348
(sofia/internal/9995551000000 at sip.blinkmind.net) State EXECUTE
2010-08-11 20:07:51.196022 [DEBUG] mod_sofia.c:235 sofia/internal/
9995551000000 at sip.blinkmind.net SOFIA EXECUTE
2010-08-11 20:07:51.196022 [DEBUG] switch_core_state_machine.c:157
sofia/internal/9995551000000 at sip.blinkmind.net Standard EXECUTE
EXECUTE sofia/internal/9995551000000 at sip.blinkmind.net bridge(sofia/gateway/
sip.blinkmind.net/9995552000000)
2010-08-11 20:07:51.196022 [NOTICE] switch_channel.c:779 New Channel
sofia/external/9995552000000 [1e984e40-a584-11df-ba1b-11ad2b71c214]
2010-08-11 20:07:51.196022 [DEBUG] mod_sofia.c:3892
(sofia/external/9995552000000) State Change CS_NEW -> CS_INIT
2010-08-11 20:07:51.196022 [DEBUG] switch_core_session.c:1039 Send signal
sofia/external/9995552000000 [BREAK]
2010-08-11 20:07:51.197023 [DEBUG] switch_core_state_machine.c:314
(sofia/external/9995552000000) Running State Change CS_INIT
2010-08-11 20:07:51.197023 [DEBUG] switch_core_state_machine.c:338
(sofia/external/9995552000000) State INIT
2010-08-11 20:07:51.197023 [DEBUG] mod_sofia.c:83
sofia/external/9995552000000 SOFIA INIT
2010-08-11 20:07:51.197023 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.197023 [DEBUG] mod_sofia.c:119
(sofia/external/9995552000000) State Change CS_INIT -> CS_ROUTING
2010-08-11 20:07:51.197023 [DEBUG] switch_core_session.c:1039 Send signal
sofia/external/9995552000000 [BREAK]
2010-08-11 20:07:51.197023 [DEBUG] switch_core_state_machine.c:338
(sofia/external/9995552000000) State INIT going to sleep
2010-08-11 20:07:51.197023 [DEBUG] switch_core_state_machine.c:314
(sofia/external/9995552000000) Running State Change CS_ROUTING
2010-08-11 20:07:51.197023 [DEBUG] switch_channel.c:1512
(sofia/external/9995552000000) Callstate Change DOWN -> RINGING
2010-08-11 20:07:51.197023 [DEBUG] switch_core_state_machine.c:341
(sofia/external/9995552000000) State ROUTING
2010-08-11 20:07:51.197023 [DEBUG] mod_sofia.c:142
sofia/external/9995552000000 SOFIA ROUTING
2010-08-11 20:07:51.197023 [DEBUG] switch_ivr_originate.c:66
(sofia/external/9995552000000) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2010-08-11 20:07:51.197023 [DEBUG] switch_core_session.c:1039 Send signal
sofia/external/9995552000000 [BREAK]
2010-08-11 20:07:51.197023 [DEBUG] switch_core_state_machine.c:341
(sofia/external/9995552000000) State ROUTING going to sleep
2010-08-11 20:07:51.197023 [DEBUG] switch_core_state_machine.c:314
(sofia/external/9995552000000) Running State Change CS_CONSUME_MEDIA
2010-08-11 20:07:51.197023 [DEBUG] switch_core_state_machine.c:360
(sofia/external/9995552000000) State CONSUME_MEDIA
2010-08-11 20:07:51.197023 [DEBUG] switch_core_state_machine.c:360
(sofia/external/9995552000000) State CONSUME_MEDIA going to sleep
2010-08-11 20:07:51.198023 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.201020 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.201020 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.203018 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.204015 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.206022 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.207023 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.209026 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.209026 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.212037 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.212037 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.215047 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.215047 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.217052 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.217052 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.220062 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.220062 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.222070 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.223073 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.225079 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.225079 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.227086 [DEBUG] sofia_glue.c:2036 sip:10.11.0.20 Setting
proxy route to sofia/external/9995552000000
2010-08-11 20:07:51.228089 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [calling][0]
2010-08-11 20:07:51.230097 [DEBUG] sofia.c:4317 Channel
sofia/external/9995552000000 entering state [terminated][503]
2010-08-11 20:07:51.230097 [DEBUG] switch_channel.c:2309
(sofia/external/9995552000000) Callstate Change RINGING -> HANGUP
2010-08-11 20:07:51.230097 [NOTICE] sofia.c:4931 Hangup
sofia/external/9995552000000 [CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE]
2010-08-11 20:07:51.230097 [DEBUG] switch_channel.c:2325 Send signal
sofia/external/9995552000000 [KILL]
2010-08-11 20:07:51.230097 [DEBUG] switch_core_session.c:1039 Send signal
sofia/external/9995552000000 [BREAK]
2010-08-11 20:07:51.230097 [DEBUG] switch_core_state_machine.c:314
(sofia/external/9995552000000) Running State Change CS_HANGUP
2010-08-11 20:07:51.230097 [DEBUG] switch_core_state_machine.c:535
(sofia/external/9995552000000) State HANGUP
2010-08-11 20:07:51.230097 [DEBUG] mod_sofia.c:447
sofia/external/9995552000000 Overriding SIP cause 503 with 503 from the
other leg
On Wed, Aug 11, 2010 at 2:15 PM, Jeff Lenk <jeff at jefflenk.com> wrote:
>
> Line 3998 of Sofia.c
> switch_channel_hangup(channel,
> SWITCH_CAUSE_REDIRECTION_TO_NEW_DESTINATION);
> --
> View this message in context:
> http://freeswitch-users.2379917.n2.nabble.com/FS-processing-302-tp5393783p5413561.html
> Sent from the freeswitch-users mailing list archive at Nabble.com.
>
> _______________________________________________
> FreeSWITCH-users mailing list
> FreeSWITCH-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20100811/0f4b223a/attachment-0001.html
More information about the FreeSWITCH-users
mailing list