Hi everybody, I'm actually using the lastest version of Freeswitch, I have a problem. I have a trunk SIP with my PABX. There is 3 phones : 1. one Alcatel Advanced with number 368 (on PABX) 2. one Alcatel IpTouch 4028 with number 987 (on PABX) 3. one Siemens Gigaset A580 IP with number 8401 (on Freeswitch) *The first test* is to say to the phone 2 to transfer all the call to number 8401. So when I dial 987 on the phone 1, all work perfectly, the phone 3 is ringing and it's work. I have that in the log : 2009-11-27 16:52:18.677299 [INFO] switch_ivr_originate.c:1024 Sending early media 2009-11-27 16:52:18.677299 [DEBUG] sofia_glue.c:2375 AUDIO RTP [sofia/internal/368@10.33.69.246] 10.33.169.92 port 23054 -> 10.33.69.246 port 32000 codec: 8 ms: 90 2009-11-27 16:52:18.677299 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 720 bytes per 90ms 2009-11-27 16:52:18.687301 [INFO] mod_sofia.c:1706 Ring SDP: v=0 o=FreeSWITCH 1259314084 1259314085 IN IP4 10.33.169.92 s=FreeSWITCH c=IN IP4 10.33.169.92 t=0 0 m=audio 23054 RTP/AVP 8 106 a=rtpmap:8 PCMA/8000 a=rtpmap:106 telephone-event/8000 a=fmtp:106 0-16 a=silenceSupp:off - - - - a=ptime:90 a=sendrecv 2009-11-27 16:52:18.687301 [NOTICE] mod_sofia.c:1709 Pre-Answer sofia/internal/368@10.33.69.246! 2009-11-27 16:52:18.687301 [DEBUG] switch_core_session.c:706 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK] 2009-11-27 16:52:18.687301 [DEBUG] sofia.c:412 sofia/internal/ sip:8401@10.33.170.231:5060 receive message [DISPLAY] 2009-11-27 16:52:18.687301 [DEBUG] sofia.c:3691 Channel sofia/internal/ 368@10.33.69.246 skipping state [early][183] 2009-11-27 16:52:18.687301 [DEBUG] switch_core_session.c:645 Send signal sofia/internal/368@10.33.69.246 [BREAK] 2009-11-27 16:52:18.687301 [DEBUG] switch_ivr_originate.c:1054 Raw Codec Activation Success L16@8000hz 1 channel 90ms 2009-11-27 16:52:18.687301 [DEBUG] switch_ivr_originate.c:1116 Play Ringback Tone [%(2000,4000,440.0,480.0)] 2009-11-27 16:52:18.747333 [DEBUG] switch_core_io.c:652 sofia/internal/ 368@10.33.69.246 receive message [TRANSCODING_NECESSARY] 2009-11-27 16:52:18.927433 [DEBUG] switch_rtp.c:1992 Correct ip/port confirmed. 2009-11-27 16:52:19.187876 [DEBUG] switch_core_io.c:402 Engaging Read Buffer at 1440 bytes vs 81 *The Second Tes*t is to say to the phone 1 to transfer all the call to number 8401. So when I dial 368 on the phone 2, the phone 3 is ringing just one time and after it hangup. I have that in the log : 2009-11-27 17:17:10.487610 [INFO] switch_ivr_originate.c:1024 Sending early media 2009-11-27 17:17:10.487610 [DEBUG] sofia_glue.c:2375 AUDIO RTP [sofia/internal/987@10.33.69.246] 10.33.169.92 port 27732 -> 10.33.69.144 port 32000 codec: 8 ms: 90 2009-11-27 17:17:10.487610 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 720 bytes per 90ms 2009-11-27 17:17:10.497659 [INFO] mod_sofia.c:1706 Ring SDP: v=0 o=FreeSWITCH 1259310898 1259310899 IN IP4 10.33.169.92 s=FreeSWITCH c=IN IP4 10.33.169.92 t=0 0 m=audio 27732 RTP/AVP 8 106 a=rtpmap:8 PCMA/8000 a=rtpmap:106 telephone-event/8000 a=fmtp:106 0-16 a=silenceSupp:off - - - - a=ptime:90 a=sendrecv 2009-11-27 17:17:10.497659 [NOTICE] mod_sofia.c:1709 Pre-Answer sofia/internal/987@10.33.69.246! 2009-11-27 17:17:10.497659 [DEBUG] switch_core_session.c:706 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK] 2009-11-27 17:17:10.497659 [DEBUG] sofia.c:412 sofia/internal/ sip:8401@10.33.170.231:5060 receive message [DISPLAY] 2009-11-27 17:17:10.497659 [DEBUG] sofia.c:3691 Channel sofia/internal/ 987@10.33.69.246 skipping state [early][183] 2009-11-27 17:17:10.497659 [DEBUG] switch_core_session.c:645 Send signal sofia/internal/987@10.33.69.246 [BREAK] 2009-11-27 17:17:10.497659 [DEBUG] switch_ivr_originate.c:1054 Raw Codec Activation Success L16@8000hz 1 channel 90ms 2009-11-27 17:17:10.497659 [DEBUG] switch_ivr_originate.c:1116 Play Ringback Tone [%(2000,4000,440.0,480.0)] 2009-11-27 17:17:10.537273 [DEBUG] switch_core_io.c:652 sofia/internal/ 987@10.33.69.246 receive message [TRANSCODING_NECESSARY] 2009-11-27 17:17:11.317096 [DEBUG] sofia.c:3696 Channel sofia/internal/ 987@10.33.69.246 entering state [terminated][487] 2009-11-27 17:17:11.317096 [NOTICE] sofia.c:4299 Hangup sofia/internal/ 987@10.33.69.246 [CS_EXECUTE] [ORIGINATOR_CANCEL] 2009-11-27 17:17:11.317096 [DEBUG] switch_channel.c:1912 Send signal sofia/internal/987@10.33.69.246 [KILL] 2009-11-27 17:17:11.317096 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK] 2009-11-27 17:17:11.317096 [DEBUG] switch_core_state_machine.c:459 thread mismatch skipping state handler. 2009-11-27 17:17:11.347287 [DEBUG] switch_core_codec.c:122 Restore original codec. 2009-11-27 17:17:11.347287 [NOTICE] switch_ivr_originate.c:2842 Hangup sofia/internal/sip:8401@10.33.170.231:5060 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL] 2009-11-27 17:17:11.347287 [DEBUG] switch_channel.c:1912 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [KILL] 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_HANGUP 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/sip:8401@10.33.170.231:5060) State HANGUP 2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:352 sofia/internal/ sip:8401@10.33.170.231:5060 Overriding SIP cause 487 with 487 from the other leg 2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:358 Channel sofia/internal/ sip:8401@10.33.170.231:5060 hanging up, cause: ORIGINATOR_CANCEL 2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:406 Sending CANCEL to sofia/internal/sip:8401@10.33.170.231:5060 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:46 sofia/internal/sip:8401@10.33.170.231:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/sip:8401@10.33.170.231:5060) State HANGUP going to sleep 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/sip:8401@10.33.170.231:5060) State Change CS_HANGUP -> CS_REPORTING 2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK] 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_REPORTING 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/sip:8401@10.33.170.231:5060) State REPORTING 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:53 sofia/internal/sip:8401@10.33.170.231:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/sip:8401@10.33.170.231:5060) State REPORTING going to sleep 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/sip:8401@10.33.170.231:5060) State Change CS_REPORTING -> CS_DESTROY 2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK] 2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:1121 Session 48 (sofia/internal/sip:8401@10.33.170.231:5060) Locked, Waiting on external entities 2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK] 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:459 thread mismatch skipping state handler. 2009-11-27 17:17:11.347287 [DEBUG] switch_ivr_originate.c:2982 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL] 2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1139 Session 48 (sofia/internal/sip:8401@10.33.170.231:5060) Ended 2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1141 Close Channel sofia/internal/sip:8401@10.33.170.231:5060 [CS_DESTROY] 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_DESTROY 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/sip:8401@10.33.170.231:5060) State DESTROY 2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:293 sofia/internal/ sip:8401@10.33.170.231:5060 SOFIA DESTROY 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:60 sofia/internal/sip:8401@10.33.170.231:5060 Standard DESTROY 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/sip:8401@10.33.170.231:5060) State DESTROY going to sleep 2009-11-27 17:17:11.347287 [ERR] switch_ivr_originate.c:2248 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL] 2009-11-27 17:17:11.347287 [DEBUG] switch_ivr_originate.c:2988 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL] 2009-11-27 17:17:11.347287 [INFO] mod_dptools.c:2295 Originate Failed. Cause: ORIGINATOR_CANCEL 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:348 (sofia/internal/987@10.33.69.246) State EXECUTE going to sleep 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/987@10.33.69.246) Running State Change CS_HANGUP 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/987@10.33.69.246) State HANGUP 2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:352 sofia/internal/ 987@10.33.69.246 Overriding SIP cause 487 with 487 from the other leg 2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:358 Channel sofia/internal/ 987@10.33.69.246 hanging up, cause: ORIGINATOR_CANCEL 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:46 sofia/internal/987@10.33.69.246 Standard HANGUP, cause: ORIGINATOR_CANCEL 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/987@10.33.69.246) State HANGUP going to sleep 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/987@10.33.69.246) State Change CS_HANGUP -> CS_REPORTING 2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK] 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/987@10.33.69.246) Running State Change CS_REPORTING 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/987@10.33.69.246) State REPORTING 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:53 sofia/internal/987@10.33.69.246 Standard REPORTING, cause: ORIGINATOR_CANCEL 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/987@10.33.69.246) State REPORTING going to sleep 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/987@10.33.69.246) State Change CS_REPORTING -> CS_DESTROY 2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK] 2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:1121 Session 47 (sofia/internal/987@10.33.69.246) Locked, Waiting on external entities 2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1139 Session 47 (sofia/internal/987@10.33.69.246) Ended 2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1141 Close Channel sofia/internal/987@10.33.69.246 [CS_DESTROY] 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/987@10.33.69.246) Running State Change CS_DESTROY 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/987@10.33.69.246) State DESTROY 2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:293 sofia/internal/ 987@10.33.69.246 SOFIA DESTROY 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:60 sofia/internal/987@10.33.69.246 Standard DESTROY 2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/987@10.33.69.246) State DESTROY going to sleep Finally when I tried to call the phone 3 with the phone 1 it's working, and not when I want to call the phone 3 with the phone 2, like just before, it's ringing just one time and hangup. Thanks you. Best Regards -- John
by latest do you mean SVN trunk? Can you issue the command "sofia profile internal siptrace on" before capturing your trace and post the results to http://pastebin.freeswitch.org or open a jira http://jira.freeswitch.orgon the issue and attach the log after you create the issue ticket, don't include it in the mailing list. On Fri, Nov 27, 2009 at 10:47 AM, Jonathan Barou <jbarou@sqli.com> wrote:
Hi everybody,
I'm actually using the lastest version of Freeswitch, I have a problem. I have a trunk SIP with my PABX.
There is 3 phones : 1. one Alcatel Advanced with number 368 (on PABX) 2. one Alcatel IpTouch 4028 with number 987 (on PABX) 3. one Siemens Gigaset A580 IP with number 8401 (on Freeswitch)
*The first test* is to say to the phone 2 to transfer all the call to number 8401. So when I dial 987 on the phone 1, all work perfectly, the phone 3 is ringing and it's work. I have that in the log :
2009-11-27 16:52:18.677299 [INFO] switch_ivr_originate.c:1024 Sending early media
2009-11-27 16:52:18.677299 [DEBUG] sofia_glue.c:2375 AUDIO RTP [sofia/internal/368@10.33.69.246] 10.33.169.92 port 23054 -> 10.33.69.246 port 32000 codec: 8 ms: 90
2009-11-27 16:52:18.677299 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 720 bytes per 90ms
2009-11-27 16:52:18.687301 [INFO] mod_sofia.c:1706 Ring SDP:
v=0
o=FreeSWITCH 1259314084 1259314085 IN IP4 10.33.169.92
s=FreeSWITCH
c=IN IP4 10.33.169.92
t=0 0
m=audio 23054 RTP/AVP 8 106
a=rtpmap:8 PCMA/8000
a=rtpmap:106 telephone-event/8000
a=fmtp:106 0-16
a=silenceSupp:off - - - -
a=ptime:90
a=sendrecv
2009-11-27 16:52:18.687301 [NOTICE] mod_sofia.c:1709 Pre-Answer sofia/internal/368@10.33.69.246!
2009-11-27 16:52:18.687301 [DEBUG] switch_core_session.c:706 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 16:52:18.687301 [DEBUG] sofia.c:412 sofia/internal/ sip:8401@10.33.170.231:5060 receive message [DISPLAY]
2009-11-27 16:52:18.687301 [DEBUG] sofia.c:3691 Channel sofia/internal/ 368@10.33.69.246 skipping state [early][183]
2009-11-27 16:52:18.687301 [DEBUG] switch_core_session.c:645 Send signal sofia/internal/368@10.33.69.246 [BREAK]
2009-11-27 16:52:18.687301 [DEBUG] switch_ivr_originate.c:1054 Raw Codec Activation Success L16@8000hz 1 channel 90ms
2009-11-27 16:52:18.687301 [DEBUG] switch_ivr_originate.c:1116 Play Ringback Tone [%(2000,4000,440.0,480.0)]
2009-11-27 16:52:18.747333 [DEBUG] switch_core_io.c:652 sofia/internal/ 368@10.33.69.246 receive message [TRANSCODING_NECESSARY]
2009-11-27 16:52:18.927433 [DEBUG] switch_rtp.c:1992 Correct ip/port confirmed.
2009-11-27 16:52:19.187876 [DEBUG] switch_core_io.c:402 Engaging Read Buffer at 1440 bytes vs 81
*The Second Tes*t is to say to the phone 1 to transfer all the call to number 8401. So when I dial 368 on the phone 2, the phone 3 is ringing just one time and after it hangup. I have that in the log :
2009-11-27 17:17:10.487610 [INFO] switch_ivr_originate.c:1024 Sending early media
2009-11-27 17:17:10.487610 [DEBUG] sofia_glue.c:2375 AUDIO RTP [sofia/internal/987@10.33.69.246] 10.33.169.92 port 27732 -> 10.33.69.144 port 32000 codec: 8 ms: 90
2009-11-27 17:17:10.487610 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 720 bytes per 90ms
2009-11-27 17:17:10.497659 [INFO] mod_sofia.c:1706 Ring SDP:
v=0
o=FreeSWITCH 1259310898 1259310899 IN IP4 10.33.169.92
s=FreeSWITCH
c=IN IP4 10.33.169.92
t=0 0
m=audio 27732 RTP/AVP 8 106
a=rtpmap:8 PCMA/8000
a=rtpmap:106 telephone-event/8000
a=fmtp:106 0-16
a=silenceSupp:off - - - -
a=ptime:90
a=sendrecv
2009-11-27 17:17:10.497659 [NOTICE] mod_sofia.c:1709 Pre-Answer sofia/internal/987@10.33.69.246!
2009-11-27 17:17:10.497659 [DEBUG] switch_core_session.c:706 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:10.497659 [DEBUG] sofia.c:412 sofia/internal/ sip:8401@10.33.170.231:5060 receive message [DISPLAY]
2009-11-27 17:17:10.497659 [DEBUG] sofia.c:3691 Channel sofia/internal/ 987@10.33.69.246 skipping state [early][183]
2009-11-27 17:17:10.497659 [DEBUG] switch_core_session.c:645 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:10.497659 [DEBUG] switch_ivr_originate.c:1054 Raw Codec Activation Success L16@8000hz 1 channel 90ms
2009-11-27 17:17:10.497659 [DEBUG] switch_ivr_originate.c:1116 Play Ringback Tone [%(2000,4000,440.0,480.0)]
2009-11-27 17:17:10.537273 [DEBUG] switch_core_io.c:652 sofia/internal/ 987@10.33.69.246 receive message [TRANSCODING_NECESSARY]
2009-11-27 17:17:11.317096 [DEBUG] sofia.c:3696 Channel sofia/internal/ 987@10.33.69.246 entering state [terminated][487]
2009-11-27 17:17:11.317096 [NOTICE] sofia.c:4299 Hangup sofia/internal/ 987@10.33.69.246 [CS_EXECUTE] [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.317096 [DEBUG] switch_channel.c:1912 Send signal sofia/internal/987@10.33.69.246 [KILL]
2009-11-27 17:17:11.317096 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.317096 [DEBUG] switch_core_state_machine.c:459 thread mismatch skipping state handler.
2009-11-27 17:17:11.347287 [DEBUG] switch_core_codec.c:122 Restore original codec.
2009-11-27 17:17:11.347287 [NOTICE] switch_ivr_originate.c:2842 Hangup sofia/internal/sip:8401@10.33.170.231:5060 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [DEBUG] switch_channel.c:1912 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [KILL]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_HANGUP
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/sip:8401@10.33.170.231:5060) State HANGUP
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:352 sofia/internal/ sip:8401@10.33.170.231:5060 Overriding SIP cause 487 with 487 from the other leg
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:358 Channel sofia/internal/ sip:8401@10.33.170.231:5060 hanging up, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:406 Sending CANCEL to sofia/internal/sip:8401@10.33.170.231:5060
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:46 sofia/internal/sip:8401@10.33.170.231:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/sip:8401@10.33.170.231:5060) State HANGUP going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/sip:8401@10.33.170.231:5060) State Change CS_HANGUP -> CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/sip:8401@10.33.170.231:5060) State REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:53 sofia/internal/sip:8401@10.33.170.231:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/sip:8401@10.33.170.231:5060) State REPORTING going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/sip:8401@10.33.170.231:5060) State Change CS_REPORTING -> CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:1121 Session 48 (sofia/internal/sip:8401@10.33.170.231:5060) Locked, Waiting on external entities
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:459 thread mismatch skipping state handler.
2009-11-27 17:17:11.347287 [DEBUG] switch_ivr_originate.c:2982 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1139 Session 48 (sofia/internal/sip:8401@10.33.170.231:5060) Ended
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1141 Close Channel sofia/internal/sip:8401@10.33.170.231:5060 [CS_DESTROY]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/sip:8401@10.33.170.231:5060) State DESTROY
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:293 sofia/internal/ sip:8401@10.33.170.231:5060 SOFIA DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:60 sofia/internal/sip:8401@10.33.170.231:5060 Standard DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/sip:8401@10.33.170.231:5060) State DESTROY going to sleep
2009-11-27 17:17:11.347287 [ERR] switch_ivr_originate.c:2248 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [DEBUG] switch_ivr_originate.c:2988 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [INFO] mod_dptools.c:2295 Originate Failed. Cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:348 (sofia/internal/987@10.33.69.246) State EXECUTE going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/987@10.33.69.246) Running State Change CS_HANGUP
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/987@10.33.69.246) State HANGUP
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:352 sofia/internal/ 987@10.33.69.246 Overriding SIP cause 487 with 487 from the other leg
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:358 Channel sofia/internal/ 987@10.33.69.246 hanging up, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:46 sofia/internal/987@10.33.69.246 Standard HANGUP, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/987@10.33.69.246) State HANGUP going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/987@10.33.69.246) State Change CS_HANGUP -> CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/987@10.33.69.246) Running State Change CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/987@10.33.69.246) State REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:53 sofia/internal/987@10.33.69.246 Standard REPORTING, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/987@10.33.69.246) State REPORTING going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/987@10.33.69.246) State Change CS_REPORTING -> CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:1121 Session 47 (sofia/internal/987@10.33.69.246) Locked, Waiting on external entities
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1139 Session 47 (sofia/internal/987@10.33.69.246) Ended
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1141 Close Channel sofia/internal/987@10.33.69.246 [CS_DESTROY]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/987@10.33.69.246) Running State Change CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/987@10.33.69.246) State DESTROY
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:293 sofia/internal/ 987@10.33.69.246 SOFIA DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:60 sofia/internal/987@10.33.69.246 Standard DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/987@10.33.69.246) State DESTROY going to sleep
Finally when I tried to call the phone 3 with the phone 1 it's working, and not when I want to call the phone 3 with the phone 2, like just before, it's ringing just one time and hangup.
Thanks you.
Best Regards
-- John
_______________________________________________ FreeSWITCH-users mailing list FreeSWITCH-users@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 <MSN%3Aanthony_minessale@hotmail.com> GTALK/JABBER/PAYPAL:anthony.minessale@gmail.com<PAYPAL%3Aanthony.minessale@gmail.com> IRC: irc.freenode.net #freeswitch FreeSWITCH Developer Conference sip:888@conference.freeswitch.org <sip%3A888@conference.freeswitch.org> iax:guest@conference.freeswitch.org/888 googletalk:conf+888@conference.freeswitch.org<googletalk%3Aconf%2B888@conference.freeswitch.org> pstn:213-799-1400
My version is FreeSWITCH Version 1.0.trunk (15691M) http://jira.freeswitch.org/browse/FSBUILD-213 Thanks you. 2009/11/27 Anthony Minessale <anthony.minessale@gmail.com>
by latest do you mean SVN trunk?
Can you issue the command "sofia profile internal siptrace on" before capturing your trace and post the results to http://pastebin.freeswitch.org or open a jira http://jira.freeswitch.org on the issue and attach the log after you create the issue ticket, don't include it in the mailing list.
On Fri, Nov 27, 2009 at 10:47 AM, Jonathan Barou <jbarou@sqli.com> wrote:
Hi everybody,
I'm actually using the lastest version of Freeswitch, I have a problem. I have a trunk SIP with my PABX.
There is 3 phones : 1. one Alcatel Advanced with number 368 (on PABX) 2. one Alcatel IpTouch 4028 with number 987 (on PABX) 3. one Siemens Gigaset A580 IP with number 8401 (on Freeswitch)
*The first test* is to say to the phone 2 to transfer all the call to number 8401. So when I dial 987 on the phone 1, all work perfectly, the phone 3 is ringing and it's work. I have that in the log :
2009-11-27 16:52:18.677299 [INFO] switch_ivr_originate.c:1024 Sending early media
2009-11-27 16:52:18.677299 [DEBUG] sofia_glue.c:2375 AUDIO RTP [sofia/internal/368@10.33.69.246] 10.33.169.92 port 23054 -> 10.33.69.246 port 32000 codec: 8 ms: 90
2009-11-27 16:52:18.677299 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 720 bytes per 90ms
2009-11-27 16:52:18.687301 [INFO] mod_sofia.c:1706 Ring SDP:
v=0
o=FreeSWITCH 1259314084 1259314085 IN IP4 10.33.169.92
s=FreeSWITCH
c=IN IP4 10.33.169.92
t=0 0
m=audio 23054 RTP/AVP 8 106
a=rtpmap:8 PCMA/8000
a=rtpmap:106 telephone-event/8000
a=fmtp:106 0-16
a=silenceSupp:off - - - -
a=ptime:90
a=sendrecv
2009-11-27 16:52:18.687301 [NOTICE] mod_sofia.c:1709 Pre-Answer sofia/internal/368@10.33.69.246!
2009-11-27 16:52:18.687301 [DEBUG] switch_core_session.c:706 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 16:52:18.687301 [DEBUG] sofia.c:412 sofia/internal/ sip:8401@10.33.170.231:5060 receive message [DISPLAY]
2009-11-27 16:52:18.687301 [DEBUG] sofia.c:3691 Channel sofia/internal/ 368@10.33.69.246 skipping state [early][183]
2009-11-27 16:52:18.687301 [DEBUG] switch_core_session.c:645 Send signal sofia/internal/368@10.33.69.246 [BREAK]
2009-11-27 16:52:18.687301 [DEBUG] switch_ivr_originate.c:1054 Raw Codec Activation Success L16@8000hz 1 channel 90ms
2009-11-27 16:52:18.687301 [DEBUG] switch_ivr_originate.c:1116 Play Ringback Tone [%(2000,4000,440.0,480.0)]
2009-11-27 16:52:18.747333 [DEBUG] switch_core_io.c:652 sofia/internal/ 368@10.33.69.246 receive message [TRANSCODING_NECESSARY]
2009-11-27 16:52:18.927433 [DEBUG] switch_rtp.c:1992 Correct ip/port confirmed.
2009-11-27 16:52:19.187876 [DEBUG] switch_core_io.c:402 Engaging Read Buffer at 1440 bytes vs 81
*The Second Tes*t is to say to the phone 1 to transfer all the call to number 8401. So when I dial 368 on the phone 2, the phone 3 is ringing just one time and after it hangup. I have that in the log :
2009-11-27 17:17:10.487610 [INFO] switch_ivr_originate.c:1024 Sending early media
2009-11-27 17:17:10.487610 [DEBUG] sofia_glue.c:2375 AUDIO RTP [sofia/internal/987@10.33.69.246] 10.33.169.92 port 27732 -> 10.33.69.144 port 32000 codec: 8 ms: 90
2009-11-27 17:17:10.487610 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 720 bytes per 90ms
2009-11-27 17:17:10.497659 [INFO] mod_sofia.c:1706 Ring SDP:
v=0
o=FreeSWITCH 1259310898 1259310899 IN IP4 10.33.169.92
s=FreeSWITCH
c=IN IP4 10.33.169.92
t=0 0
m=audio 27732 RTP/AVP 8 106
a=rtpmap:8 PCMA/8000
a=rtpmap:106 telephone-event/8000
a=fmtp:106 0-16
a=silenceSupp:off - - - -
a=ptime:90
a=sendrecv
2009-11-27 17:17:10.497659 [NOTICE] mod_sofia.c:1709 Pre-Answer sofia/internal/987@10.33.69.246!
2009-11-27 17:17:10.497659 [DEBUG] switch_core_session.c:706 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:10.497659 [DEBUG] sofia.c:412 sofia/internal/ sip:8401@10.33.170.231:5060 receive message [DISPLAY]
2009-11-27 17:17:10.497659 [DEBUG] sofia.c:3691 Channel sofia/internal/ 987@10.33.69.246 skipping state [early][183]
2009-11-27 17:17:10.497659 [DEBUG] switch_core_session.c:645 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:10.497659 [DEBUG] switch_ivr_originate.c:1054 Raw Codec Activation Success L16@8000hz 1 channel 90ms
2009-11-27 17:17:10.497659 [DEBUG] switch_ivr_originate.c:1116 Play Ringback Tone [%(2000,4000,440.0,480.0)]
2009-11-27 17:17:10.537273 [DEBUG] switch_core_io.c:652 sofia/internal/ 987@10.33.69.246 receive message [TRANSCODING_NECESSARY]
2009-11-27 17:17:11.317096 [DEBUG] sofia.c:3696 Channel sofia/internal/ 987@10.33.69.246 entering state [terminated][487]
2009-11-27 17:17:11.317096 [NOTICE] sofia.c:4299 Hangup sofia/internal/ 987@10.33.69.246 [CS_EXECUTE] [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.317096 [DEBUG] switch_channel.c:1912 Send signal sofia/internal/987@10.33.69.246 [KILL]
2009-11-27 17:17:11.317096 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.317096 [DEBUG] switch_core_state_machine.c:459 thread mismatch skipping state handler.
2009-11-27 17:17:11.347287 [DEBUG] switch_core_codec.c:122 Restore original codec.
2009-11-27 17:17:11.347287 [NOTICE] switch_ivr_originate.c:2842 Hangup sofia/internal/sip:8401@10.33.170.231:5060 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [DEBUG] switch_channel.c:1912 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [KILL]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_HANGUP
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/sip:8401@10.33.170.231:5060) State HANGUP
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:352 sofia/internal/ sip:8401@10.33.170.231:5060 Overriding SIP cause 487 with 487 from the other leg
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:358 Channel sofia/internal/ sip:8401@10.33.170.231:5060 hanging up, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:406 Sending CANCEL to sofia/internal/sip:8401@10.33.170.231:5060
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:46 sofia/internal/sip:8401@10.33.170.231:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/sip:8401@10.33.170.231:5060) State HANGUP going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/sip:8401@10.33.170.231:5060) State Change CS_HANGUP -> CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/sip:8401@10.33.170.231:5060) State REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:53 sofia/internal/sip:8401@10.33.170.231:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/sip:8401@10.33.170.231:5060) State REPORTING going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/sip:8401@10.33.170.231:5060) State Change CS_REPORTING -> CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:1121 Session 48 (sofia/internal/sip:8401@10.33.170.231:5060) Locked, Waiting on external entities
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:459 thread mismatch skipping state handler.
2009-11-27 17:17:11.347287 [DEBUG] switch_ivr_originate.c:2982 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1139 Session 48 (sofia/internal/sip:8401@10.33.170.231:5060) Ended
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1141 Close Channel sofia/internal/sip:8401@10.33.170.231:5060 [CS_DESTROY]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/sip:8401@10.33.170.231:5060) State DESTROY
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:293 sofia/internal/ sip:8401@10.33.170.231:5060 SOFIA DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:60 sofia/internal/sip:8401@10.33.170.231:5060 Standard DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/sip:8401@10.33.170.231:5060) State DESTROY going to sleep
2009-11-27 17:17:11.347287 [ERR] switch_ivr_originate.c:2248 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [DEBUG] switch_ivr_originate.c:2988 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [INFO] mod_dptools.c:2295 Originate Failed. Cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:348 (sofia/internal/987@10.33.69.246) State EXECUTE going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/987@10.33.69.246) Running State Change CS_HANGUP
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/987@10.33.69.246) State HANGUP
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:352 sofia/internal/ 987@10.33.69.246 Overriding SIP cause 487 with 487 from the other leg
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:358 Channel sofia/internal/ 987@10.33.69.246 hanging up, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:46 sofia/internal/987@10.33.69.246 Standard HANGUP, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/987@10.33.69.246) State HANGUP going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/987@10.33.69.246) State Change CS_HANGUP -> CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/987@10.33.69.246) Running State Change CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/987@10.33.69.246) State REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:53 sofia/internal/987@10.33.69.246 Standard REPORTING, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/987@10.33.69.246) State REPORTING going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/987@10.33.69.246) State Change CS_REPORTING -> CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:1121 Session 47 (sofia/internal/987@10.33.69.246) Locked, Waiting on external entities
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1139 Session 47 (sofia/internal/987@10.33.69.246) Ended
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1141 Close Channel sofia/internal/987@10.33.69.246 [CS_DESTROY]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/987@10.33.69.246) Running State Change CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/987@10.33.69.246) State DESTROY
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:293 sofia/internal/ 987@10.33.69.246 SOFIA DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:60 sofia/internal/987@10.33.69.246 Standard DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/987@10.33.69.246) State DESTROY going to sleep
Finally when I tried to call the phone 3 with the phone 1 it's working, and not when I want to call the phone 3 with the phone 2, like just before, it's ringing just one time and hangup.
Thanks you.
Best Regards
-- John
_______________________________________________ FreeSWITCH-users mailing list FreeSWITCH-users@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 <MSN%3Aanthony_minessale@hotmail.com> GTALK/JABBER/PAYPAL:anthony.minessale@gmail.com<PAYPAL%3Aanthony.minessale@gmail.com> IRC: irc.freenode.net #freeswitch
FreeSWITCH Developer Conference sip:888@conference.freeswitch.org <sip%3A888@conference.freeswitch.org> iax:guest@conference.freeswitch.org/888 googletalk:conf+888@conference.freeswitch.org<googletalk%3Aconf%2B888@conference.freeswitch.org> pstn:213-799-1400
_______________________________________________ FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
-- Jonathan BAROU Groupe SQLI - CRCI 0472405368 jbarou@sqli.com 1, place Verrazzano 69258 LYON CEDEX 09
Any ideas ? Thanks 2009/11/30 Jonathan Barou <jbarou@sqli.com>
My version is FreeSWITCH Version 1.0.trunk (15691M)
http://jira.freeswitch.org/browse/FSBUILD-213
Thanks you.
2009/11/27 Anthony Minessale <anthony.minessale@gmail.com>
by latest do you mean SVN trunk?
Can you issue the command "sofia profile internal siptrace on" before capturing your trace and post the results to http://pastebin.freeswitch.org or open a jira http://jira.freeswitch.org on the issue and attach the log after you create the issue ticket, don't include it in the mailing list.
On Fri, Nov 27, 2009 at 10:47 AM, Jonathan Barou <jbarou@sqli.com> wrote:
Hi everybody,
I'm actually using the lastest version of Freeswitch, I have a problem. I have a trunk SIP with my PABX.
There is 3 phones : 1. one Alcatel Advanced with number 368 (on PABX) 2. one Alcatel IpTouch 4028 with number 987 (on PABX) 3. one Siemens Gigaset A580 IP with number 8401 (on Freeswitch)
*The first test* is to say to the phone 2 to transfer all the call to number 8401. So when I dial 987 on the phone 1, all work perfectly, the phone 3 is ringing and it's work. I have that in the log :
2009-11-27 16:52:18.677299 [INFO] switch_ivr_originate.c:1024 Sending early media
2009-11-27 16:52:18.677299 [DEBUG] sofia_glue.c:2375 AUDIO RTP [sofia/internal/368@10.33.69.246] 10.33.169.92 port 23054 -> 10.33.69.246 port 32000 codec: 8 ms: 90
2009-11-27 16:52:18.677299 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 720 bytes per 90ms
2009-11-27 16:52:18.687301 [INFO] mod_sofia.c:1706 Ring SDP:
v=0
o=FreeSWITCH 1259314084 1259314085 IN IP4 10.33.169.92
s=FreeSWITCH
c=IN IP4 10.33.169.92
t=0 0
m=audio 23054 RTP/AVP 8 106
a=rtpmap:8 PCMA/8000
a=rtpmap:106 telephone-event/8000
a=fmtp:106 0-16
a=silenceSupp:off - - - -
a=ptime:90
a=sendrecv
2009-11-27 16:52:18.687301 [NOTICE] mod_sofia.c:1709 Pre-Answer sofia/internal/368@10.33.69.246!
2009-11-27 16:52:18.687301 [DEBUG] switch_core_session.c:706 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 16:52:18.687301 [DEBUG] sofia.c:412 sofia/internal/ sip:8401@10.33.170.231:5060 receive message [DISPLAY]
2009-11-27 16:52:18.687301 [DEBUG] sofia.c:3691 Channel sofia/internal/ 368@10.33.69.246 skipping state [early][183]
2009-11-27 16:52:18.687301 [DEBUG] switch_core_session.c:645 Send signal sofia/internal/368@10.33.69.246 [BREAK]
2009-11-27 16:52:18.687301 [DEBUG] switch_ivr_originate.c:1054 Raw Codec Activation Success L16@8000hz 1 channel 90ms
2009-11-27 16:52:18.687301 [DEBUG] switch_ivr_originate.c:1116 Play Ringback Tone [%(2000,4000,440.0,480.0)]
2009-11-27 16:52:18.747333 [DEBUG] switch_core_io.c:652 sofia/internal/ 368@10.33.69.246 receive message [TRANSCODING_NECESSARY]
2009-11-27 16:52:18.927433 [DEBUG] switch_rtp.c:1992 Correct ip/port confirmed.
2009-11-27 16:52:19.187876 [DEBUG] switch_core_io.c:402 Engaging Read Buffer at 1440 bytes vs 81
*The Second Tes*t is to say to the phone 1 to transfer all the call to number 8401. So when I dial 368 on the phone 2, the phone 3 is ringing just one time and after it hangup. I have that in the log :
2009-11-27 17:17:10.487610 [INFO] switch_ivr_originate.c:1024 Sending early media
2009-11-27 17:17:10.487610 [DEBUG] sofia_glue.c:2375 AUDIO RTP [sofia/internal/987@10.33.69.246] 10.33.169.92 port 27732 -> 10.33.69.144 port 32000 codec: 8 ms: 90
2009-11-27 17:17:10.487610 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 720 bytes per 90ms
2009-11-27 17:17:10.497659 [INFO] mod_sofia.c:1706 Ring SDP:
v=0
o=FreeSWITCH 1259310898 1259310899 IN IP4 10.33.169.92
s=FreeSWITCH
c=IN IP4 10.33.169.92
t=0 0
m=audio 27732 RTP/AVP 8 106
a=rtpmap:8 PCMA/8000
a=rtpmap:106 telephone-event/8000
a=fmtp:106 0-16
a=silenceSupp:off - - - -
a=ptime:90
a=sendrecv
2009-11-27 17:17:10.497659 [NOTICE] mod_sofia.c:1709 Pre-Answer sofia/internal/987@10.33.69.246!
2009-11-27 17:17:10.497659 [DEBUG] switch_core_session.c:706 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:10.497659 [DEBUG] sofia.c:412 sofia/internal/ sip:8401@10.33.170.231:5060 receive message [DISPLAY]
2009-11-27 17:17:10.497659 [DEBUG] sofia.c:3691 Channel sofia/internal/ 987@10.33.69.246 skipping state [early][183]
2009-11-27 17:17:10.497659 [DEBUG] switch_core_session.c:645 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:10.497659 [DEBUG] switch_ivr_originate.c:1054 Raw Codec Activation Success L16@8000hz 1 channel 90ms
2009-11-27 17:17:10.497659 [DEBUG] switch_ivr_originate.c:1116 Play Ringback Tone [%(2000,4000,440.0,480.0)]
2009-11-27 17:17:10.537273 [DEBUG] switch_core_io.c:652 sofia/internal/ 987@10.33.69.246 receive message [TRANSCODING_NECESSARY]
2009-11-27 17:17:11.317096 [DEBUG] sofia.c:3696 Channel sofia/internal/ 987@10.33.69.246 entering state [terminated][487]
2009-11-27 17:17:11.317096 [NOTICE] sofia.c:4299 Hangup sofia/internal/ 987@10.33.69.246 [CS_EXECUTE] [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.317096 [DEBUG] switch_channel.c:1912 Send signal sofia/internal/987@10.33.69.246 [KILL]
2009-11-27 17:17:11.317096 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.317096 [DEBUG] switch_core_state_machine.c:459 thread mismatch skipping state handler.
2009-11-27 17:17:11.347287 [DEBUG] switch_core_codec.c:122 Restore original codec.
2009-11-27 17:17:11.347287 [NOTICE] switch_ivr_originate.c:2842 Hangup sofia/internal/sip:8401@10.33.170.231:5060 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [DEBUG] switch_channel.c:1912 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [KILL]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_HANGUP
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/sip:8401@10.33.170.231:5060) State HANGUP
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:352 sofia/internal/ sip:8401@10.33.170.231:5060 Overriding SIP cause 487 with 487 from the other leg
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:358 Channel sofia/internal/sip:8401@10.33.170.231:5060 hanging up, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:406 Sending CANCEL to sofia/internal/sip:8401@10.33.170.231:5060
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:46 sofia/internal/sip:8401@10.33.170.231:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/sip:8401@10.33.170.231:5060) State HANGUP going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/sip:8401@10.33.170.231:5060) State Change CS_HANGUP -> CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/sip:8401@10.33.170.231:5060) State REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:53 sofia/internal/sip:8401@10.33.170.231:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/sip:8401@10.33.170.231:5060) State REPORTING going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/sip:8401@10.33.170.231:5060) State Change CS_REPORTING -> CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:1121 Session 48 (sofia/internal/sip:8401@10.33.170.231:5060) Locked, Waiting on external entities
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:459 thread mismatch skipping state handler.
2009-11-27 17:17:11.347287 [DEBUG] switch_ivr_originate.c:2982 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1139 Session 48 (sofia/internal/sip:8401@10.33.170.231:5060) Ended
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1141 Close Channel sofia/internal/sip:8401@10.33.170.231:5060 [CS_DESTROY]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/sip:8401@10.33.170.231:5060) State DESTROY
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:293 sofia/internal/ sip:8401@10.33.170.231:5060 SOFIA DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:60 sofia/internal/sip:8401@10.33.170.231:5060 Standard DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/sip:8401@10.33.170.231:5060) State DESTROY going to sleep
2009-11-27 17:17:11.347287 [ERR] switch_ivr_originate.c:2248 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [DEBUG] switch_ivr_originate.c:2988 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [INFO] mod_dptools.c:2295 Originate Failed. Cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:348 (sofia/internal/987@10.33.69.246) State EXECUTE going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/987@10.33.69.246) Running State Change CS_HANGUP
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/987@10.33.69.246) State HANGUP
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:352 sofia/internal/ 987@10.33.69.246 Overriding SIP cause 487 with 487 from the other leg
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:358 Channel sofia/internal/987@10.33.69.246 hanging up, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:46 sofia/internal/987@10.33.69.246 Standard HANGUP, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/987@10.33.69.246) State HANGUP going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/987@10.33.69.246) State Change CS_HANGUP -> CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/987@10.33.69.246) Running State Change CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/987@10.33.69.246) State REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:53 sofia/internal/987@10.33.69.246 Standard REPORTING, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/987@10.33.69.246) State REPORTING going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/987@10.33.69.246) State Change CS_REPORTING -> CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:1121 Session 47 (sofia/internal/987@10.33.69.246) Locked, Waiting on external entities
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1139 Session 47 (sofia/internal/987@10.33.69.246) Ended
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1141 Close Channel sofia/internal/987@10.33.69.246 [CS_DESTROY]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/987@10.33.69.246) Running State Change CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/987@10.33.69.246) State DESTROY
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:293 sofia/internal/ 987@10.33.69.246 SOFIA DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:60 sofia/internal/987@10.33.69.246 Standard DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/987@10.33.69.246) State DESTROY going to sleep
Finally when I tried to call the phone 3 with the phone 1 it's working, and not when I want to call the phone 3 with the phone 2, like just before, it's ringing just one time and hangup.
Thanks you.
Best Regards
-- John
_______________________________________________ FreeSWITCH-users mailing list FreeSWITCH-users@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 <MSN%3Aanthony_minessale@hotmail.com> GTALK/JABBER/PAYPAL:anthony.minessale@gmail.com<PAYPAL%3Aanthony.minessale@gmail.com> IRC: irc.freenode.net #freeswitch
FreeSWITCH Developer Conference sip:888@conference.freeswitch.org <sip%3A888@conference.freeswitch.org> iax:guest@conference.freeswitch.org/888 googletalk:conf+888@conference.freeswitch.org<googletalk%3Aconf%2B888@conference.freeswitch.org> pstn:213-799-1400
_______________________________________________ FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
-- Jonathan BAROU Groupe SQLI - CRCI
0472405368 jbarou@sqli.com
1, place Verrazzano 69258 LYON CEDEX 09
-- Jonathan BAROU Groupe SQLI - CRCI 0472405368 jbarou@sqli.com 1, place Verrazzano 69258 LYON CEDEX 09
you may have nat problems since I do not see many people reporting anything like this. On Wed, Dec 2, 2009 at 3:54 AM, Jonathan Barou <jbarou@sqli.com> wrote:
Any ideas ?
Thanks
2009/11/30 Jonathan Barou <jbarou@sqli.com>
My version is FreeSWITCH Version 1.0.trunk (15691M)
http://jira.freeswitch.org/browse/FSBUILD-213
Thanks you.
2009/11/27 Anthony Minessale <anthony.minessale@gmail.com>
by latest do you mean SVN trunk?
Can you issue the command "sofia profile internal siptrace on" before capturing your trace and post the results to http://pastebin.freeswitch.org or open a jira http://jira.freeswitch.org on the issue and attach the log after you create the issue ticket, don't include it in the mailing list.
On Fri, Nov 27, 2009 at 10:47 AM, Jonathan Barou <jbarou@sqli.com>wrote:
Hi everybody,
I'm actually using the lastest version of Freeswitch, I have a problem. I have a trunk SIP with my PABX.
There is 3 phones : 1. one Alcatel Advanced with number 368 (on PABX) 2. one Alcatel IpTouch 4028 with number 987 (on PABX) 3. one Siemens Gigaset A580 IP with number 8401 (on Freeswitch)
*The first test* is to say to the phone 2 to transfer all the call to number 8401. So when I dial 987 on the phone 1, all work perfectly, the phone 3 is ringing and it's work. I have that in the log :
2009-11-27 16:52:18.677299 [INFO] switch_ivr_originate.c:1024 Sending early media
2009-11-27 16:52:18.677299 [DEBUG] sofia_glue.c:2375 AUDIO RTP [sofia/internal/368@10.33.69.246] 10.33.169.92 port 23054 -> 10.33.69.246 port 32000 codec: 8 ms: 90
2009-11-27 16:52:18.677299 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 720 bytes per 90ms
2009-11-27 16:52:18.687301 [INFO] mod_sofia.c:1706 Ring SDP:
v=0
o=FreeSWITCH 1259314084 1259314085 IN IP4 10.33.169.92
s=FreeSWITCH
c=IN IP4 10.33.169.92
t=0 0
m=audio 23054 RTP/AVP 8 106
a=rtpmap:8 PCMA/8000
a=rtpmap:106 telephone-event/8000
a=fmtp:106 0-16
a=silenceSupp:off - - - -
a=ptime:90
a=sendrecv
2009-11-27 16:52:18.687301 [NOTICE] mod_sofia.c:1709 Pre-Answer sofia/internal/368@10.33.69.246!
2009-11-27 16:52:18.687301 [DEBUG] switch_core_session.c:706 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 16:52:18.687301 [DEBUG] sofia.c:412 sofia/internal/ sip:8401@10.33.170.231:5060 receive message [DISPLAY]
2009-11-27 16:52:18.687301 [DEBUG] sofia.c:3691 Channel sofia/internal/ 368@10.33.69.246 skipping state [early][183]
2009-11-27 16:52:18.687301 [DEBUG] switch_core_session.c:645 Send signal sofia/internal/368@10.33.69.246 [BREAK]
2009-11-27 16:52:18.687301 [DEBUG] switch_ivr_originate.c:1054 Raw Codec Activation Success L16@8000hz 1 channel 90ms
2009-11-27 16:52:18.687301 [DEBUG] switch_ivr_originate.c:1116 Play Ringback Tone [%(2000,4000,440.0,480.0)]
2009-11-27 16:52:18.747333 [DEBUG] switch_core_io.c:652 sofia/internal/ 368@10.33.69.246 receive message [TRANSCODING_NECESSARY]
2009-11-27 16:52:18.927433 [DEBUG] switch_rtp.c:1992 Correct ip/port confirmed.
2009-11-27 16:52:19.187876 [DEBUG] switch_core_io.c:402 Engaging Read Buffer at 1440 bytes vs 81
*The Second Tes*t is to say to the phone 1 to transfer all the call to number 8401. So when I dial 368 on the phone 2, the phone 3 is ringing just one time and after it hangup. I have that in the log :
2009-11-27 17:17:10.487610 [INFO] switch_ivr_originate.c:1024 Sending early media
2009-11-27 17:17:10.487610 [DEBUG] sofia_glue.c:2375 AUDIO RTP [sofia/internal/987@10.33.69.246] 10.33.169.92 port 27732 -> 10.33.69.144 port 32000 codec: 8 ms: 90
2009-11-27 17:17:10.487610 [DEBUG] switch_rtp.c:1155 Starting timer [soft] 720 bytes per 90ms
2009-11-27 17:17:10.497659 [INFO] mod_sofia.c:1706 Ring SDP:
v=0
o=FreeSWITCH 1259310898 1259310899 IN IP4 10.33.169.92
s=FreeSWITCH
c=IN IP4 10.33.169.92
t=0 0
m=audio 27732 RTP/AVP 8 106
a=rtpmap:8 PCMA/8000
a=rtpmap:106 telephone-event/8000
a=fmtp:106 0-16
a=silenceSupp:off - - - -
a=ptime:90
a=sendrecv
2009-11-27 17:17:10.497659 [NOTICE] mod_sofia.c:1709 Pre-Answer sofia/internal/987@10.33.69.246!
2009-11-27 17:17:10.497659 [DEBUG] switch_core_session.c:706 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:10.497659 [DEBUG] sofia.c:412 sofia/internal/ sip:8401@10.33.170.231:5060 receive message [DISPLAY]
2009-11-27 17:17:10.497659 [DEBUG] sofia.c:3691 Channel sofia/internal/ 987@10.33.69.246 skipping state [early][183]
2009-11-27 17:17:10.497659 [DEBUG] switch_core_session.c:645 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:10.497659 [DEBUG] switch_ivr_originate.c:1054 Raw Codec Activation Success L16@8000hz 1 channel 90ms
2009-11-27 17:17:10.497659 [DEBUG] switch_ivr_originate.c:1116 Play Ringback Tone [%(2000,4000,440.0,480.0)]
2009-11-27 17:17:10.537273 [DEBUG] switch_core_io.c:652 sofia/internal/ 987@10.33.69.246 receive message [TRANSCODING_NECESSARY]
2009-11-27 17:17:11.317096 [DEBUG] sofia.c:3696 Channel sofia/internal/ 987@10.33.69.246 entering state [terminated][487]
2009-11-27 17:17:11.317096 [NOTICE] sofia.c:4299 Hangup sofia/internal/ 987@10.33.69.246 [CS_EXECUTE] [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.317096 [DEBUG] switch_channel.c:1912 Send signal sofia/internal/987@10.33.69.246 [KILL]
2009-11-27 17:17:11.317096 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.317096 [DEBUG] switch_core_state_machine.c:459 thread mismatch skipping state handler.
2009-11-27 17:17:11.347287 [DEBUG] switch_core_codec.c:122 Restore original codec.
2009-11-27 17:17:11.347287 [NOTICE] switch_ivr_originate.c:2842 Hangup sofia/internal/sip:8401@10.33.170.231:5060 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [DEBUG] switch_channel.c:1912 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [KILL]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_HANGUP
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/sip:8401@10.33.170.231:5060) State HANGUP
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:352 sofia/internal/ sip:8401@10.33.170.231:5060 Overriding SIP cause 487 with 487 from the other leg
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:358 Channel sofia/internal/sip:8401@10.33.170.231:5060 hanging up, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:406 Sending CANCEL to sofia/internal/sip:8401@10.33.170.231:5060
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:46 sofia/internal/sip:8401@10.33.170.231:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/sip:8401@10.33.170.231:5060) State HANGUP going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/sip:8401@10.33.170.231:5060) State Change CS_HANGUP -> CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/sip:8401@10.33.170.231:5060) State REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:53 sofia/internal/sip:8401@10.33.170.231:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/sip:8401@10.33.170.231:5060) State REPORTING going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/sip:8401@10.33.170.231:5060) State Change CS_REPORTING -> CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:1121 Session 48 (sofia/internal/sip:8401@10.33.170.231:5060) Locked, Waiting on external entities
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/sip:8401@10.33.170.231:5060 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:459 thread mismatch skipping state handler.
2009-11-27 17:17:11.347287 [DEBUG] switch_ivr_originate.c:2982 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1139 Session 48 (sofia/internal/sip:8401@10.33.170.231:5060) Ended
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1141 Close Channel sofia/internal/sip:8401@10.33.170.231:5060 [CS_DESTROY]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/sip:8401@10.33.170.231:5060) Running State Change CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/sip:8401@10.33.170.231:5060) State DESTROY
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:293 sofia/internal/ sip:8401@10.33.170.231:5060 SOFIA DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:60 sofia/internal/sip:8401@10.33.170.231:5060 Standard DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/sip:8401@10.33.170.231:5060) State DESTROY going to sleep
2009-11-27 17:17:11.347287 [ERR] switch_ivr_originate.c:2248 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [DEBUG] switch_ivr_originate.c:2988 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
2009-11-27 17:17:11.347287 [INFO] mod_dptools.c:2295 Originate Failed. Cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:348 (sofia/internal/987@10.33.69.246) State EXECUTE going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/987@10.33.69.246) Running State Change CS_HANGUP
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/987@10.33.69.246) State HANGUP
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:352 sofia/internal/ 987@10.33.69.246 Overriding SIP cause 487 with 487 from the other leg
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:358 Channel sofia/internal/987@10.33.69.246 hanging up, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:46 sofia/internal/987@10.33.69.246 Standard HANGUP, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/987@10.33.69.246) State HANGUP going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/987@10.33.69.246) State Change CS_HANGUP -> CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/987@10.33.69.246) Running State Change CS_REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/987@10.33.69.246) State REPORTING
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:53 sofia/internal/987@10.33.69.246 Standard REPORTING, cause: ORIGINATOR_CANCEL
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:577 (sofia/internal/987@10.33.69.246) State REPORTING going to sleep
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/987@10.33.69.246) State Change CS_REPORTING -> CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:984 Send signal sofia/internal/987@10.33.69.246 [BREAK]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_session.c:1121 Session 47 (sofia/internal/987@10.33.69.246) Locked, Waiting on external entities
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1139 Session 47 (sofia/internal/987@10.33.69.246) Ended
2009-11-27 17:17:11.347287 [NOTICE] switch_core_session.c:1141 Close Channel sofia/internal/987@10.33.69.246 [CS_DESTROY]
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/987@10.33.69.246) Running State Change CS_DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/987@10.33.69.246) State DESTROY
2009-11-27 17:17:11.347287 [DEBUG] mod_sofia.c:293 sofia/internal/ 987@10.33.69.246 SOFIA DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:60 sofia/internal/987@10.33.69.246 Standard DESTROY
2009-11-27 17:17:11.347287 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/987@10.33.69.246) State DESTROY going to sleep
Finally when I tried to call the phone 3 with the phone 1 it's working, and not when I want to call the phone 3 with the phone 2, like just before, it's ringing just one time and hangup.
Thanks you.
Best Regards
-- John
_______________________________________________ FreeSWITCH-users mailing list FreeSWITCH-users@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 <MSN%3Aanthony_minessale@hotmail.com> GTALK/JABBER/PAYPAL:anthony.minessale@gmail.com<PAYPAL%3Aanthony.minessale@gmail.com> IRC: irc.freenode.net #freeswitch
FreeSWITCH Developer Conference sip:888@conference.freeswitch.org <sip%3A888@conference.freeswitch.org> iax:guest@conference.freeswitch.org/888 googletalk:conf+888@conference.freeswitch.org<googletalk%3Aconf%2B888@conference.freeswitch.org> pstn:213-799-1400
_______________________________________________ FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
-- Jonathan BAROU Groupe SQLI - CRCI
0472405368 jbarou@sqli.com
1, place Verrazzano 69258 LYON CEDEX 09
-- Jonathan BAROU Groupe SQLI - CRCI
0472405368 jbarou@sqli.com 1, place Verrazzano 69258 LYON CEDEX 09
_______________________________________________ FreeSWITCH-users mailing list FreeSWITCH-users@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 <MSN%3Aanthony_minessale@hotmail.com> GTALK/JABBER/PAYPAL:anthony.minessale@gmail.com<PAYPAL%3Aanthony.minessale@gmail.com> IRC: irc.freenode.net #freeswitch FreeSWITCH Developer Conference sip:888@conference.freeswitch.org <sip%3A888@conference.freeswitch.org> iax:guest@conference.freeswitch.org/888 googletalk:conf+888@conference.freeswitch.org<googletalk%3Aconf%2B888@conference.freeswitch.org> pstn:213-799-1400
participants (2)
-
Anthony Minessale
-
Jonathan Barou