[Freeswitch-users] MOH problems

Mon Nov 17 04:14:50 PST 2008

-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA1

Hello,

yes I have: FreeSWITCH Version 1.0.trunk (10423M)

same problem. No MOH

Console log:

2008-11-17 13:12:20 [DEBUG] sofia_glue.c:2382 sofia_glue_negotiate_sdp()
Audio Codec Compare [pcmu:0:8000]/[G722:9:8000]
2008-11-17 13:12:20 [DEBUG] sofia_glue.c:2382 sofia_glue_negotiate_sdp()
Audio Codec Compare [pcmu:0:8000]/[PCMU:0:8000]
2008-11-17 13:12:20 [DEBUG] sofia_glue.c:1590
sofia_glue_tech_set_codec() Set Codec sofia/internal/1000 at 85.16.246.6
PCMU/8000 20 ms 160 samples
2008-11-17 13:12:20 [DEBUG] sofia_glue.c:2346 sofia_glue_negotiate_sdp()
Set 2833 dtmf payload to 101
2008-11-17 13:12:20 [DEBUG] sofia.c:2459 sofia_handle_sip_i_state()
(sofia/internal/1000 at 85.16.246.6) State Change CS_NEW -> CS_INIT
2008-11-17 13:12:20 [DEBUG] switch_core_session.c:779
switch_core_session_signal_state_change() Send signal
sofia/internal/1000 at 85.16.246.6 [BREAK]
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:375
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) Running
State Change CS_INIT
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:423
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) State INIT
2008-11-17 13:12:20 [DEBUG] mod_sofia.c:83 sofia_on_init()
sofia/internal/1000 at 85.16.246.6 SOFIA INIT
2008-11-17 13:12:20 [DEBUG] mod_sofia.c:111 sofia_on_init()
(sofia/internal/1000 at 85.16.246.6) State Change CS_INIT -> CS_ROUTING
2008-11-17 13:12:20 [DEBUG] switch_core_session.c:779
switch_core_session_signal_state_change() Send signal
sofia/internal/1000 at 85.16.246.6 [BREAK]
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:423
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) State INIT
going to sleep
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:375
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) Running
State Change CS_ROUTING
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:426
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) State ROUTING
2008-11-17 13:12:20 [DEBUG] mod_sofia.c:130 sofia_on_routing()
sofia/internal/1000 at 85.16.246.6 SOFIA ROUTING
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:64
switch_core_standard_on_routing() sofia/internal/1000 at 85.16.246.6
Standard ROUTING
2008-11-17 13:12:20 [INFO] mod_dialplan_xml.c:233 dialplan_hunt()
Processing Benjamin FreeSWITCH->9000 in context default
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex:
[Local_Extension] destination_number(9000) =~
/^(10[01][0-9]|28[0-9][0-9]|27[0-9][0-9])$/
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:119 parse_exten() Regex
mismatch
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex:
[vmain] destination_number(9000) =~ /^9999$/
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:119 parse_exten() Regex
mismatch
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex:
[tts1] destination_number(9000) =~ /^4200$/
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:119 parse_exten() Regex
mismatch
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex:
[playback] destination_number(9000) =~ /^5000$/
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:119 parse_exten() Regex
mismatch
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex:
[parallel call] destination_number(9000) =~ /^(6000)$/
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:119 parse_exten() Regex
mismatch
2008-11-17 13:12:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex:
[hold_music] destination_number(9000) =~ /^9000$/
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:100
switch_core_standard_on_routing() (sofia/internal/1000 at 85.16.246.6)
State Change CS_ROUTING -> CS_EXECUTE
2008-11-17 13:12:20 [DEBUG] switch_core_session.c:779
switch_core_session_signal_state_change() Send signal
sofia/internal/1000 at 85.16.246.6 [BREAK]
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:426
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) State
ROUTING going to sleep
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:375
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) Running
State Change CS_EXECUTE
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:433
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) State EXECUTE
2008-11-17 13:12:20 [DEBUG] mod_sofia.c:173 sofia_on_execute()
sofia/internal/1000 at 85.16.246.6 SOFIA EXECUTE
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:137
switch_core_standard_on_execute() sofia/internal/1000 at 85.16.246.6
Standard EXECUTE
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:152
switch_core_standard_on_execute() sofia/internal/1000 at 85.16.246.6
Execute answer()
2008-11-17 13:12:20 [DEBUG] switch_channel.c:1712
switch_channel_perform_answer() sofia/internal/1000 at 85.16.246.6 receive
message [SWITCH_MESSAGE_INDICATE_ANSWER]
2008-11-17 13:12:20 [DEBUG] sofia_glue.c:1808 sofia_glue_activate_rtp()
AUDIO RTP [sofia/internal/1000 at 85.16.246.6] 85.16.246.6 port 23410 ->
85.16.245.208 port 63444 codec: 0 ms: 20
2008-11-17 13:12:20 [DEBUG] switch_rtp.c:849 switch_rtp_create()
Starting timer [soft] 160 bytes per 20000ms
2008-11-17 13:12:20 [DEBUG] mod_sofia.c:497 sofia_answer_channel() Local
SDP sofia/internal/1000 at 85.16.246.6:
v=0
o=FreeSWITCH 1226900530 1226900531 IN IP4 85.16.246.6
s=FreeSWITCH
c=IN IP4 85.16.246.6
t=0 0
m=audio 23410 RTP/AVP 0 101
a=rtpmap:0 pcmu/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

2008-11-17 13:12:20 [DEBUG] switch_core_session.c:489
switch_core_session_perform_receive_message() Send signal
sofia/internal/1000 at 85.16.246.6 [BREAK]
2008-11-17 13:12:20 [NOTICE] mod_dptools.c:610 answer_function() Channel
[sofia/internal/1000 at 85.16.246.6] has been answered
2008-11-17 13:12:20 [DEBUG] switch_core_state_machine.c:152
switch_core_standard_on_execute() sofia/internal/1000 at 85.16.246.6
Execute playback(local_stream://moh)
2008-11-17 13:12:20 [DEBUG] mod_local_stream.c:327
local_stream_file_open() Opening Stream [moh/8000] 8000hz
2008-11-17 13:12:20 [DEBUG] switch_ivr_play_say.c:932
switch_ivr_play_file() Codec Activated L16 at 8000hz 1 channels 20ms
2008-11-17 13:12:20 [DEBUG] switch_core_io.c:610
switch_core_session_write_frame() sofia/internal/1000 at 85.16.246.6
receive message [SWITCH_MESSAGE_INDICATE_TRANSCODING_NECESSARY]
2008-11-17 13:12:20 [DEBUG] switch_core_session.c:489
switch_core_session_perform_receive_message() Send signal
sofia/internal/1000 at 85.16.246.6 [BREAK]
2008-11-17 13:12:20 [DEBUG] sofia.c:2314 sofia_handle_sip_i_state()
Channel sofia/internal/1000 at 85.16.246.6 entering state [completed]
2008-11-17 13:12:20 [DEBUG] sofia.c:2314 sofia_handle_sip_i_state()
Channel sofia/internal/1000 at 85.16.246.6 entering state [ready]
2008-11-17 13:12:24 [DEBUG] sofia.c:2314 sofia_handle_sip_i_state()
Channel sofia/internal/1000 at 85.16.246.6 entering state [terminated]
2008-11-17 13:12:24 [NOTICE] sofia.c:2853 sofia_handle_sip_i_state()
Hangup sofia/internal/1000 at 85.16.246.6 [CS_EXECUTE] [NORMAL_CLEARING]
2008-11-17 13:12:24 [DEBUG] switch_channel.c:1441
switch_channel_perform_hangup() Send signal
sofia/internal/1000 at 85.16.246.6 [KILL]
2008-11-17 13:12:24 [DEBUG] switch_core_session.c:779
switch_core_session_signal_state_change() Send signal
sofia/internal/1000 at 85.16.246.6 [BREAK]
2008-11-17 13:12:24 [DEBUG] switch_ivr_play_say.c:1222
switch_ivr_play_file() done playing file
2008-11-17 13:12:24 [DEBUG] switch_core_state_machine.c:433
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) State
EXECUTE going to sleep
2008-11-17 13:12:24 [DEBUG] switch_core_state_machine.c:375
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) Running
State Change CS_HANGUP
2008-11-17 13:12:24 [DEBUG] switch_core_state_machine.c:403
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) State HANGUP
2008-11-17 13:12:24 [DEBUG] mod_sofia.c:287 sofia_on_hangup() Channel
sofia/internal/1000 at 85.16.246.6 hanging up, cause: NORMAL_CLEARING
2008-11-17 13:12:24 [DEBUG] switch_core_state_machine.c:46
switch_core_standard_on_hangup() sofia/internal/1000 at 85.16.246.6
Standard HANGUP, cause: NORMAL_CLEARING
2008-11-17 13:12:24 [DEBUG] switch_core_state_machine.c:403
switch_core_session_run() (sofia/internal/1000 at 85.16.246.6) State HANGUP
going to sleep
2008-11-17 13:12:24 [DEBUG] switch_core_session.c:911
switch_core_session_thread() Session 5 (sofia/internal/1000 at 85.16.246.6)
Locked, Waiting on external entities
2008-11-17 13:12:24 [NOTICE] switch_core_session.c:929
switch_core_session_thread() Session 5 (sofia/internal/1000 at 85.16.246.6)
Ended
2008-11-17 13:12:24 [NOTICE] switch_core_session.c:931
switch_core_session_thread() Close Channel
sofia/internal/1000 at 85.16.246.6 [CS_HANGUP]

regards
helmut

Brian West schrieb:
> Have you updated to the latest SVN trunk?
> 
> /b
> 
> On Nov 17, 2008, at 2:05 AM, Helmut Kuper wrote:
> 
>> -----BEGIN PGP SIGNED MESSAGE-----
>> Hash: SHA1
>>
>> Hello,
>>
>> just to get an answer ..
>>
>> regards
>> Helmut
> 
> 
> _______________________________________________
> 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
> 
> 
-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.4.9 (MingW32)

iEYEARECAAYFAkkhYDkACgkQ4tZeNddg3dz9nACgsdsPLKRk8ptk5XBBJk6hxDlt
ncMAnj6PaQZMzudflsOi4uDZ/nN1snuT
=iXfh
-----END PGP SIGNATURE-----