Hab schon folgende Parameter probiert:
sofia inbound-codec-prefs PCMA,G7221@32000h,G7221@16000h,G722,PCMU,GSM,H263,H264
sofia outbound-codec-prefs PCMA,G7221@32000h,G7221@16000h,G722,PCMU,GSM,H263,H264
Egal ob ich H263,H264 am Anfang oder Ende rein schreibe, ändert sich nichts.
Zusätzlich auch ein 3CX Client von Windows Rechner, auch ohne Erfolg.
Hier ein wenig von der fs_cli console, Anruf getätigt, angenommen, aufgelegt
Vielleicht kann jemand was entdecken, hoffe level ist nicht zu hoch ;-)
gruß
+OK log level [7]
2013-02-18 15:31:41.027453 [NOTICE] switch_channel.c:968 New Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 [13593db9-2f7a-46de-b260-1b8cf0d41ec8]
2013-02-18 15:31:41.027453 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.027453 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.027453 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_NEW
2013-02-18 15:31:41.047457 [DEBUG] sofia.c:5578 Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 entering state [received][100]
2013-02-18 15:31:41.047457 [DEBUG] sofia.c:5589 Remote SDP:
v=0
o=3cxVCE 7950180 238048635 IN IP4 192.168.2.222
s=3cxVCE Audio Call
c=IN IP4 192.168.2.222
t=0 0
m=audio 40024 RTP/AVP 0 8 3 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
m=video 40016 RTP/AVP 34
c=IN IP4 192.168.1.222
a=rtpmap:34 H263/90000
a=fmtp:34 CIF4=1;CIF=1;QCIF=1;SQCIF=1
2013-02-18 15:31:41.047457 [DEBUG] sofia_glue.c:5139 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMA:8:8000:20:64000]
2013-02-18 15:31:41.047457 [DEBUG] sofia_glue.c:5139 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2013-02-18 15:31:41.047457 [DEBUG] sofia_glue.c:3095 Set Codec sofia/gemeinschaft/
win...@192.168.1.106:5060 PCMA/8000 20 ms 160 samples 64000 bits
2013-02-18 15:31:41.047457 [DEBUG] switch_core_codec.c:111 sofia/gemeinschaft/
win...@192.168.1.106:5060 Original read codec set to PCMA:8
2013-02-18 15:31:41.047457 [DEBUG] sofia_glue.c:5268 Set 2833 dtmf send/recv payload to 101
2013-02-18 15:31:41.047457 [DEBUG] sofia.c:5822 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State Change CS_NEW -> CS_INIT
2013-02-18 15:31:41.047457 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.047457 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_INIT
2013-02-18 15:31:41.047457 [DEBUG] mod_sofia.c:126 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State Change CS_INIT -> CS_ROUTING
2013-02-18 15:31:41.047457 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.047457 [DEBUG] switch_core_state_machine.c:454 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State INIT going to sleep
2013-02-18 15:31:41.047457 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_ROUTING
2013-02-18 15:31:41.047457 [DEBUG] switch_channel.c:2003 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Callstate Change DOWN -> RINGING
2013-02-18 15:31:41.047457 [DEBUG] switch_core_state_machine.c:470 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State ROUTING
2013-02-18 15:31:41.047457 [DEBUG] switch_core_state_machine.c:117 sofia/gemeinschaft/
win...@192.168.1.106:5060 Standard ROUTING
2013-02-18 15:31:41.047457 [INFO] mod_dialplan_xml.c:557 Processing windows <windows>->1000 in context default
Dialplan: sofia/gemeinschaft/
win...@192.168.1.106:5060 Regex (FAIL) [transfer_loop] endpoint_disposition() =~ /BLIND_TRANSFER/ break=on-false
2013-02-18 15:31:41.047457 [DEBUG] switch_core_state_machine.c:167 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State Change CS_ROUTING -> CS_EXECUTE
2013-02-18 15:31:41.047457 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.047457 [DEBUG] switch_core_state_machine.c:470 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State ROUTING going to sleep
2013-02-18 15:31:41.047457 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_EXECUTE
2013-02-18 15:31:41.047457 [DEBUG] switch_core_state_machine.c:477 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State EXECUTE
2013-02-18 15:31:41.047457 [DEBUG] switch_core_state_machine.c:209 sofia/gemeinschaft/
win...@192.168.1.106:5060 Standard EXECUTE
2013-02-18 15:31:41.067466 [DEBUG] freeswitch_lua.cpp:352 DBH handle 0x9a87900 Connected.
2013-02-18 15:31:41.067466 [INFO] switch_cpp.cpp:1274 #E# [13593db9-2f7a-46de-b260-1b8cf0d41ec8] PRESENCE_INBOUND: account: windows, state: alerting
2013-02-18 15:31:41.067466 [DEBUG] switch_cpp.cpp:1274 #E# PRESENCE - account:
10...@192.168.1.106, state: confirmed, direction: inbound, uid: 13593db9-2f7a-46de-b260-1b8cf0d41ec8
2013-02-18 15:31:41.067466 [DEBUG] switch_cpp.cpp:1274 ### [13593db9-2f7a-46de-b260-1b8cf0d41ec8] AUTHENTICATION_REQUIRED_SIP_ACCOUNT - contact host: 192.168.0.222, ip: 192.168.1.222, domain: 192.168.1.106
2013-02-18 15:31:41.067466 [DEBUG] mod_sofia.c:2631 Responding with 407 [192.168.1.106]
2013-02-18 15:31:41.067466 [DEBUG] switch_channel.c:2994 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Callstate Change RINGING -> HANGUP
2013-02-18 15:31:41.067466 [NOTICE] mod_sofia.c:2690 Hangup sofia/gemeinschaft/
win...@192.168.1.106:5060 [CS_EXECUTE] [CALL_REJECTED]
2013-02-18 15:31:41.067466 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.067466 [DEBUG] switch_core_session.c:2689 sofia/gemeinschaft/
win...@192.168.1.106:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2013-02-18 15:31:41.067466 [DEBUG] switch_cpp.cpp:668 CoreSession::hangup
2013-02-18 15:31:41.067466 [DEBUG] freeswitch_lua.cpp:370 DBH handle (nil) released.
2013-02-18 15:31:41.067466 [DEBUG] switch_cpp.cpp:1049 sofia/gemeinschaft/
win...@192.168.1.106:5060 destroy/unlink session from object
2013-02-18 15:31:41.067466 [DEBUG] switch_core_session.c:2674 sofia/gemeinschaft/
win...@192.168.1.106:5060 skip receive message [APPLICATION_EXEC] (channel is hungup already)
2013-02-18 15:31:41.067466 [DEBUG] switch_core_session.c:2689 sofia/gemeinschaft/
win...@192.168.1.106:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:477 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State EXECUTE going to sleep
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_HANGUP
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:667 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State HANGUP
2013-02-18 15:31:41.067466 [DEBUG] mod_sofia.c:503 Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 hanging up, cause: CALL_REJECTED
2013-02-18 15:31:41.067466 [DEBUG] mod_sofia.c:595 Challenging call
2013-02-18 15:31:41.067466 [DEBUG] mod_sofia.c:633 Responding to INVITE with: 407
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:48 sofia/gemeinschaft/
win...@192.168.1.106:5060 Standard HANGUP, cause: CALL_REJECTED
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:667 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State HANGUP going to sleep
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:446 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State Change CS_HANGUP -> CS_REPORTING
2013-02-18 15:31:41.067466 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_REPORTING
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:749 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State REPORTING
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:92 sofia/gemeinschaft/
win...@192.168.1.106:5060 Standard REPORTING, cause: CALL_REJECTED
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:749 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State REPORTING going to sleep
2013-02-18 15:31:41.067466 [DEBUG] switch_core_state_machine.c:440 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State Change CS_REPORTING -> CS_DESTROY
2013-02-18 15:31:41.067466 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.067466 [DEBUG] switch_core_session.c:1499 Session 55 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Locked, Waiting on external entities
2013-02-18 15:31:41.067466 [NOTICE] switch_core_session.c:1517 Session 55 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Ended
2013-02-18 15:31:41.067466 [NOTICE] switch_core_session.c:1521 Close Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 [CS_DESTROY]
2013-02-18 15:31:41.087473 [DEBUG] switch_core_state_machine.c:556 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Callstate Change HANGUP -> DOWN
2013-02-18 15:31:41.087473 [DEBUG] switch_core_state_machine.c:559 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_DESTROY
2013-02-18 15:31:41.087473 [DEBUG] switch_core_state_machine.c:569 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State DESTROY
2013-02-18 15:31:41.087473 [INFO] switch_cpp.cpp:1274 #E# [13593db9-2f7a-46de-b260-1b8cf0d41ec8] PRESENCE_INBOUND: account: windows, state: idle
2013-02-18 15:31:41.087473 [DEBUG] switch_cpp.cpp:1274 #E# PRESENCE - account:
10...@192.168.1.106, state: terminated, direction: inbound, uid: 13593db9-2f7a-46de-b260-1b8cf0d41ec8
2013-02-18 15:31:41.087473 [DEBUG] switch_cpp.cpp:1274 #E# [13593db9-2f7a-46de-b260-1b8cf0d41ec8] CDR_SAVE - event: CHANNEL_DESTROY, direction: inbound, save_cdr: false
2013-02-18 15:31:41.087473 [DEBUG] switch_cpp.cpp:1274 #E# [13593db9-2f7a-46de-b260-1b8cf0d41ec8] CALL_HISTORY_SAVE - event: CHANNEL_DESTROY, direction: inbound, save_cdr: false
2013-02-18 15:31:41.187497 [NOTICE] switch_channel.c:968 New Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 [4888d917-0cba-4b45-9f76-8ff36a4b4acb]
2013-02-18 15:31:41.187497 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.187497 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.187497 [DEBUG] switch_core_state_machine.c:99 sofia/gemeinschaft/
win...@192.168.1.106:5060 Standard DESTROY
2013-02-18 15:31:41.187497 [DEBUG] switch_core_state_machine.c:569 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State DESTROY going to sleep
2013-02-18 15:31:41.187497 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_NEW
2013-02-18 15:31:41.227520 [DEBUG] freeswitch_lua.cpp:352 DBH handle 0x9b4b8b8 Connected.
2013-02-18 15:31:41.227520 [DEBUG] switch_cpp.cpp:1274 #C# [192.168.1.106] DIRECTORY_SIP_ACCOUNT - auth_name: windows, caller_name: Windows Rechner, domain: 192.168.1.106
2013-02-18 15:31:41.227520 [DEBUG] freeswitch_lua.cpp:370 DBH handle (nil) released.
2013-02-18 15:31:41.227520 [DEBUG] sofia.c:5578 Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 entering state [received][100]
2013-02-18 15:31:41.227520 [DEBUG] sofia.c:5589 Remote SDP:
v=0
o=3cxVCE 7950180 238048635 IN IP4 192.168.2.222
s=3cxVCE Audio Call
c=IN IP4 192.168.2.222
t=0 0
m=audio 40024 RTP/AVP 0 8 3 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
m=video 40016 RTP/AVP 34
c=IN IP4 192.168.1.222
a=rtpmap:34 H263/90000
a=fmtp:34 CIF4=1;CIF=1;QCIF=1;SQCIF=1
2013-02-18 15:31:41.227520 [DEBUG] sofia_glue.c:5139 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMA:8:8000:20:64000]
2013-02-18 15:31:41.227520 [DEBUG] sofia_glue.c:5139 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2013-02-18 15:31:41.227520 [DEBUG] sofia_glue.c:3095 Set Codec sofia/gemeinschaft/
win...@192.168.1.106:5060 PCMA/8000 20 ms 160 samples 64000 bits
2013-02-18 15:31:41.227520 [DEBUG] switch_core_codec.c:111 sofia/gemeinschaft/
win...@192.168.1.106:5060 Original read codec set to PCMA:8
2013-02-18 15:31:41.227520 [DEBUG] sofia_glue.c:5268 Set 2833 dtmf send/recv payload to 101
2013-02-18 15:31:41.227520 [DEBUG] sofia.c:5822 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State Change CS_NEW -> CS_INIT
2013-02-18 15:31:41.227520 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.227520 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_INIT
2013-02-18 15:31:41.227520 [DEBUG] mod_sofia.c:126 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State Change CS_INIT -> CS_ROUTING
2013-02-18 15:31:41.227520 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.227520 [DEBUG] switch_core_state_machine.c:454 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State INIT going to sleep
2013-02-18 15:31:41.227520 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_ROUTING
2013-02-18 15:31:41.227520 [DEBUG] switch_channel.c:2003 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Callstate Change DOWN -> RINGING
2013-02-18 15:31:41.227520 [DEBUG] switch_core_state_machine.c:470 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State ROUTING
2013-02-18 15:31:41.227520 [DEBUG] switch_core_state_machine.c:117 sofia/gemeinschaft/
win...@192.168.1.106:5060 Standard ROUTING
2013-02-18 15:31:41.227520 [INFO] mod_dialplan_xml.c:557 Processing windows <windows>->1000 in context default
Dialplan: sofia/gemeinschaft/
win...@192.168.1.106:5060 Regex (FAIL) [transfer_loop] endpoint_disposition() =~ /BLIND_TRANSFER/ break=on-false
2013-02-18 15:31:41.227520 [DEBUG] switch_core_state_machine.c:167 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State Change CS_ROUTING -> CS_EXECUTE
2013-02-18 15:31:41.227520 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.227520 [DEBUG] switch_core_state_machine.c:470 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State ROUTING going to sleep
2013-02-18 15:31:41.227520 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_EXECUTE
2013-02-18 15:31:41.227520 [DEBUG] switch_core_state_machine.c:477 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State EXECUTE
2013-02-18 15:31:41.227520 [DEBUG] switch_core_state_machine.c:209 sofia/gemeinschaft/
win...@192.168.1.106:5060 Standard EXECUTE
2013-02-18 15:31:41.247587 [DEBUG] freeswitch_lua.cpp:352 DBH handle 0x9a87900 Connected.
2013-02-18 15:31:41.247587 [INFO] switch_cpp.cpp:1274 #E# [4888d917-0cba-4b45-9f76-8ff36a4b4acb] PRESENCE_INBOUND: account: windows, state: alerting
2013-02-18 15:31:41.247587 [DEBUG] switch_cpp.cpp:1274 #E# PRESENCE - account:
10...@192.168.1.106, state: confirmed, direction: inbound, uid: 4888d917-0cba-4b45-9f76-8ff36a4b4acb
2013-02-18 15:31:41.247587 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] AUTH_SIP_ACCOUNT - SipAccount=/94d72f40-5c01-0130-7b69-00155d010207
2013-02-18 15:31:41.267612 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] CALLER_DATA - auth account: sipaccount=5/94d72f40-5c01-0130-7b69-00155d010207
2013-02-18 15:31:41.267612 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] CALLER_DATA - auth owner: user=5/88eebc30-5c01-0130-7b67-00155d010207
2013-02-18 15:31:41.267612 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] CALLER_DATA - caller account: sipaccount=5/94d72f40-5c01-0130-7b69-00155d010207, phone_numbers: 1, language: de
2013-02-18 15:31:41.267612 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] CALLER_DATA - caller owner: user=5/88eebc30-5c01-0130-7b67-00155d010207
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=1/international call
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=2/national call
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=3/local call
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=4/log in
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=5/log out
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=6/toggle ACD membership
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=7/activate CLIP
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=8/deactivate CLIP
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=9/activate CLIR
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=10/deactivate CLIR
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=11/activate CLIR for call
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=12/deactivate CLIR for call
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=13/activate call waiting
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=14/deactivate call waiting
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=15/deactivate all call forwards
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=16/delete all call forwards
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=17/set unconditional call forwarding
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=18/deactivate unconditional call forwarding
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=19/delete unconditional call forwarding
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=20/call forward if not answered
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=21/deactivate call forward if not answered
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=22/delete call forward if not answered
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=23/call forward if offline
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=24/deactivate call forward if offline
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=25/delete call forward if offline
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=26/call forward if busy
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=27/deactivate call forward if busy
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=28/delete call forward if busy
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=29/redial
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=30/check voicemail
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=31/acivate auto logout
2013-02-18 15:31:41.267612 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] ROUTE_NO_MATCH - prerouting=32/deacivate auto logout
2013-02-18 15:31:41.267612 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] DESTINATION_NEW - sipaccount=1/@1, number: 1000
2013-02-18 15:31:41.267612 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] DIALPLAN start - caller_id: 1003 "Windows Rechner" , number: 1000, language: de
2013-02-18 15:31:41.267612 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] LOOP 1 - destination: sipaccount=1/@1, number: 1000
2013-02-18 15:31:41.267612 [DEBUG] switch_channel.c:1135 EXPORT (export_vars) [alert_info]=[
http://amooma.de;info=Ringer1;x-line-id=0]
2013-02-18 15:31:41.287700 [DEBUG] switch_channel.c:1135 EXPORT (export_vars) [effective_callee_id_number]=[1000]
2013-02-18 15:31:41.287700 [DEBUG] switch_channel.c:1135 EXPORT (export_vars) [effective_callee_id_name]=[Zentrales Telefon]
2013-02-18 15:31:41.287700 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] FORK 1/1 - sipaccount=1/@1, number: 1000, caller_id: "" <1003>
2013-02-18 15:31:41.287700 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] CALL_WAITING - status: disabled, sip_account state:
2013-02-18 15:31:41.287700 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] FORK DIAL - destinations: 1, timeout: 120
2013-02-18 15:31:41.287700 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] FORK SESSION_START - call_url: {local_var_clobber=true}[gs_fork_index=1,ignore_display_updates=true,effective_callee_id_name='Zentrales Telefon',effective_callee_id_number='1000']sofia/gemeinschaft/zentrale%192.168.1.106
2013-02-18 15:31:41.287700 [DEBUG] switch_channel.c:1089 sofia/gemeinschaft/
win...@192.168.1.106:5060 EXPORTING[export_vars] [effective_callee_id_number]=[1000] to event
2013-02-18 15:31:41.287700 [DEBUG] switch_channel.c:1089 sofia/gemeinschaft/
win...@192.168.1.106:5060 EXPORTING[export_vars] [effective_callee_id_name]=[Zentrales Telefon] to event
2013-02-18 15:31:41.287700 [DEBUG] switch_ivr_originate.c:2022 Parsing global variables
2013-02-18 15:31:41.287700 [DEBUG] switch_event.c:1608 Parsing variable [local_var_clobber]=[true]
2013-02-18 15:31:41.287700 [DEBUG] switch_ivr_originate.c:2442 Parsing session specific variables
2013-02-18 15:31:41.287700 [DEBUG] switch_event.c:1608 Parsing variable [gs_fork_index]=[1]
2013-02-18 15:31:41.287700 [DEBUG] switch_event.c:1608 Parsing variable [ignore_display_updates]=[true]
2013-02-18 15:31:41.287700 [DEBUG] switch_event.c:1608 Parsing variable [effective_callee_id_name]=[Zentrales Telefon]
2013-02-18 15:31:41.287700 [DEBUG] switch_event.c:1608 Parsing variable [effective_callee_id_number]=[1000]
2013-02-18 15:31:41.287700 [NOTICE] switch_channel.c:968 New Channel sofia/gemeinschaft/zentrale [be28eb5a-2b45-494d-a201-956334f41eaa]
2013-02-18 15:31:41.287700 [DEBUG] mod_sofia.c:4961 (sofia/gemeinschaft/zentrale) State Change CS_NEW -> CS_INIT
2013-02-18 15:31:41.287700 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:41.287700 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/zentrale) Running State Change CS_INIT
2013-02-18 15:31:41.287700 [DEBUG] switch_core_state_machine.c:454 (sofia/gemeinschaft/zentrale) State INIT
2013-02-18 15:31:41.287700 [DEBUG] mod_sofia.c:86 sofia/gemeinschaft/zentrale SOFIA INIT
2013-02-18 15:31:41.287700 [DEBUG] sofia_glue.c:2649 Local SDP:
v=0
o=FreeSWITCH 1361165639 1361165640 IN IP4 192.168.1.106
s=FreeSWITCH
c=IN IP4 192.168.1.106
t=0 0
m=audio 32262 RTP/AVP 8 9 0 3 101 13
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
2013-02-18 15:31:41.287700 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:41.287700 [DEBUG] mod_sofia.c:126 (sofia/gemeinschaft/zentrale) State Change CS_INIT -> CS_ROUTING
2013-02-18 15:31:41.287700 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:41.287700 [DEBUG] switch_core_state_machine.c:454 (sofia/gemeinschaft/zentrale) State INIT going to sleep
2013-02-18 15:31:41.287700 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/zentrale) Running State Change CS_ROUTING
2013-02-18 15:31:41.287700 [DEBUG] switch_channel.c:2003 (sofia/gemeinschaft/zentrale) Callstate Change DOWN -> RINGING
2013-02-18 15:31:41.287700 [DEBUG] switch_core_state_machine.c:470 (sofia/gemeinschaft/zentrale) State ROUTING
2013-02-18 15:31:41.287700 [DEBUG] mod_sofia.c:149 sofia/gemeinschaft/zentrale SOFIA ROUTING
2013-02-18 15:31:41.287700 [DEBUG] switch_ivr_originate.c:67 (sofia/gemeinschaft/zentrale) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2013-02-18 15:31:41.287700 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:41.287700 [DEBUG] switch_core_state_machine.c:470 (sofia/gemeinschaft/zentrale) State ROUTING going to sleep
2013-02-18 15:31:41.287700 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/zentrale) Running State Change CS_CONSUME_MEDIA
2013-02-18 15:31:41.287700 [DEBUG] switch_core_state_machine.c:489 (sofia/gemeinschaft/zentrale) State CONSUME_MEDIA
2013-02-18 15:31:41.287700 [DEBUG] switch_core_state_machine.c:489 (sofia/gemeinschaft/zentrale) State CONSUME_MEDIA going to sleep
2013-02-18 15:31:41.287700 [DEBUG] sofia.c:5578 Channel sofia/gemeinschaft/zentrale entering state [calling][0]
2013-02-18 15:31:41.287700 [INFO] switch_cpp.cpp:1274 #E# [be28eb5a-2b45-494d-a201-956334f41eaa] PRESENCE_OUTBOUND: account: zentrale, state: progressing, caller: 1003
2013-02-18 15:31:41.287700 [DEBUG] switch_cpp.cpp:1274 #E# PRESENCE - account:
10...@192.168.1.106, state: early, direction: outbound, uid: be28eb5a-2b45-494d-a201-956334f41eaa
2013-02-18 15:31:41.387543 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:41.387543 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:41.387543 [DEBUG] sofia.c:5578 Channel sofia/gemeinschaft/zentrale entering state [proceeding][180]
2013-02-18 15:31:41.387543 [NOTICE] sofia.c:5670 Ring-Ready sofia/gemeinschaft/zentrale!
2013-02-18 15:31:41.387543 [INFO] switch_ivr_originate.c:1185 Sending early media
2013-02-18 15:31:41.387543 [DEBUG] sofia_glue.c:3353 AUDIO RTP [sofia/gemeinschaft/
win...@192.168.1.106:5060] 192.168.1.106 port 23684 -> 192.168.2.222 port 40024 codec: 8 ms: 20
2013-02-18 15:31:41.387543 [DEBUG] switch_rtp.c:1974 Starting timer [soft] 160 bytes per 20ms
2013-02-18 15:31:41.407559 [DEBUG] sofia_glue.c:3617 Set 2833 dtmf send payload to 101
2013-02-18 15:31:41.407559 [DEBUG] sofia_glue.c:3623 Set 2833 dtmf receive payload to 101
2013-02-18 15:31:41.407559 [DEBUG] mod_sofia.c:2810 Ring SDP:
v=0
o=FreeSWITCH 1361174217 1361174218 IN IP4 192.168.1.106
s=FreeSWITCH
c=IN IP4 192.168.1.106
t=0 0
m=audio 23684 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
2013-02-18 15:31:41.407559 [DEBUG] switch_channel.c:3136 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Callstate Change RINGING -> EARLY
2013-02-18 15:31:41.407559 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.407559 [DEBUG] sofia.c:5578 Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 entering state [early][183]
2013-02-18 15:31:41.407559 [DEBUG] switch_core_session.c:830 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:41.407559 [DEBUG] switch_ivr_originate.c:1242 Raw Codec Activation Success L16@8000hz 1 channel 20ms
2013-02-18 15:31:41.407559 [DEBUG] switch_ivr_originate.c:1305 Play Ringback Tone [%(2000,4000,440.0,480.0)]
2013-02-18 15:31:44.544300 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:44.544300 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:44.544300 [DEBUG] sofia.c:5578 Channel sofia/gemeinschaft/zentrale entering state [completing][200]
2013-02-18 15:31:44.544300 [DEBUG] sofia.c:5589 Remote SDP:
v=0
o=- 20013 20013 IN IP4 192.168.1.114
s=SDP data
c=IN IP4 192.168.1.114
t=0 0
m=audio 11800 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
2013-02-18 15:31:44.544300 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:44.544300 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:44.544300 [DEBUG] sofia.c:5578 Channel sofia/gemeinschaft/zentrale entering state [ready][200]
2013-02-18 15:31:44.544300 [DEBUG] sofia_glue.c:5139 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2013-02-18 15:31:44.544300 [DEBUG] sofia_glue.c:3095 Set Codec sofia/gemeinschaft/zentrale PCMA/8000 20 ms 160 samples 64000 bits
2013-02-18 15:31:44.544300 [DEBUG] switch_core_codec.c:111 sofia/gemeinschaft/zentrale Original read codec set to PCMA:8
2013-02-18 15:31:44.544300 [DEBUG] sofia_glue.c:5261 Set 2833 dtmf send payload to 101
2013-02-18 15:31:44.544300 [DEBUG] sofia_glue.c:3353 AUDIO RTP [sofia/gemeinschaft/zentrale] 192.168.1.106 port 32262 -> 192.168.1.114 port 11800 codec: 8 ms: 20
2013-02-18 15:31:44.544300 [DEBUG] switch_rtp.c:1974 Starting timer [soft] 160 bytes per 20ms
2013-02-18 15:31:44.564306 [DEBUG] sofia_glue.c:3617 Set 2833 dtmf send payload to 101
2013-02-18 15:31:44.564306 [DEBUG] sofia_glue.c:3623 Set 2833 dtmf receive payload to 101
2013-02-18 15:31:44.564306 [DEBUG] sofia_glue.c:3650 sofia/gemeinschaft/zentrale Set rtp dtmf delay to 40
2013-02-18 15:31:44.564306 [DEBUG] switch_channel.c:3395 (sofia/gemeinschaft/zentrale) Callstate Change RINGING -> ACTIVE
2013-02-18 15:31:44.564306 [NOTICE] sofia.c:6330 Channel [sofia/gemeinschaft/zentrale] has been answered
2013-02-18 15:31:44.564306 [INFO] switch_cpp.cpp:1274 #E# [be28eb5a-2b45-494d-a201-956334f41eaa] PRESENCE_OUTBOUND: account: zentrale, state: active, caller: 1003
2013-02-18 15:31:44.564306 [DEBUG] switch_cpp.cpp:1274 #E# PRESENCE - account:
10...@192.168.1.106, state: confirmed, direction: outbound, uid: be28eb5a-2b45-494d-a201-956334f41eaa
2013-02-18 15:31:44.564306 [DEBUG] switch_core_codec.c:244 sofia/gemeinschaft/
win...@192.168.1.106:5060 Restore previous codec PCMA:8.
v=0
o=FreeSWITCH 1361174217 1361174219 IN IP4 192.168.1.106
s=FreeSWITCH
c=IN IP4 192.168.1.106
t=0 0
m=audio 23684 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
2013-02-18 15:31:44.564306 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:44.564306 [DEBUG] sofia.c:5578 Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 entering state [completed][200]
2013-02-18 15:31:44.564306 [DEBUG] switch_core_session.c:830 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:44.564306 [DEBUG] switch_channel.c:3395 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Callstate Change EARLY -> ACTIVE
2013-02-18 15:31:44.564306 [NOTICE] switch_ivr_originate.c:3378 Channel [sofia/gemeinschaft/
win...@192.168.1.106:5060] has been answered
2013-02-18 15:31:44.564306 [DEBUG] switch_ivr_originate.c:3435 Originate Resulted in Success: [sofia/gemeinschaft/zentrale]
2013-02-18 15:31:44.564306 [DEBUG] switch_cpp.cpp:574 (sofia/gemeinschaft/zentrale) State Change CS_CONSUME_MEDIA -> CS_SOFT_EXECUTE
2013-02-18 15:31:44.564306 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:44.564306 [INFO] switch_cpp.cpp:1274 #E# [4888d917-0cba-4b45-9f76-8ff36a4b4acb] PRESENCE_INBOUND: account: windows, state: active
2013-02-18 15:31:44.564306 [DEBUG] switch_cpp.cpp:1274 #E# PRESENCE - account:
10...@192.168.1.106, state: confirmed, direction: inbound, uid: 4888d917-0cba-4b45-9f76-8ff36a4b4acb
2013-02-18 15:31:44.564306 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/zentrale) Running State Change CS_SOFT_EXECUTE
2013-02-18 15:31:44.564306 [DEBUG] switch_core_state_machine.c:483 (sofia/gemeinschaft/zentrale) State SOFT_EXECUTE
2013-02-18 15:31:44.564306 [DEBUG] mod_sofia.c:687 SOFIA SOFT_EXECUTE
2013-02-18 15:31:44.564306 [DEBUG] switch_core_state_machine.c:277 sofia/gemeinschaft/zentrale Standard SOFT_EXECUTE
2013-02-18 15:31:44.564306 [DEBUG] switch_core_state_machine.c:483 (sofia/gemeinschaft/zentrale) State SOFT_EXECUTE going to sleep
2013-02-18 15:31:44.564306 [DEBUG] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] FORK SESSION_INIT - dial_time: 3
2013-02-18 15:31:44.564306 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] FORK ANSWER - status: SUCCESS, dial_time: 3
2013-02-18 15:31:44.564306 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] FORK 1 BRIDGE - destination: sipaccount=1/@1, number: 1000, dial_time: 3
2013-02-18 15:31:44.564306 [DEBUG] switch_ivr_bridge.c:1268 (sofia/gemeinschaft/zentrale) State Change CS_SOFT_EXECUTE -> CS_CONSUME_MEDIA
2013-02-18 15:31:44.564306 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:44.564306 [DEBUG] mod_sofia.c:1731 sofia/gemeinschaft/zentrale activate passthru 2833 mode.
2013-02-18 15:31:44.564306 [DEBUG] switch_core_session.c:830 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:44.564306 [DEBUG] mod_sofia.c:1731 sofia/gemeinschaft/
win...@192.168.1.106:5060 activate passthru 2833 mode.
2013-02-18 15:31:44.564306 [DEBUG] switch_core_session.c:830 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:44.564306 [DEBUG] switch_ivr_bridge.c:1370 (sofia/gemeinschaft/zentrale) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
2013-02-18 15:31:44.564306 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:44.564306 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/zentrale) Running State Change CS_EXCHANGE_MEDIA
2013-02-18 15:31:44.564306 [DEBUG] switch_core_state_machine.c:480 (sofia/gemeinschaft/zentrale) State EXCHANGE_MEDIA
2013-02-18 15:31:44.564306 [DEBUG] mod_sofia.c:681 SOFIA EXCHANGE_MEDIA
2013-02-18 15:31:44.664322 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:44.664322 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:44.664322 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:44.684339 [DEBUG] sofia.c:5578 Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 entering state [ready][200]
2013-02-18 15:31:44.684339 [DEBUG] switch_core_session.c:892 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:44.684339 [DEBUG] switch_core_session.c:892 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:44.764353 [DEBUG] switch_rtp.c:3693 Correct ip/port confirmed.
2013-02-18 15:31:48.905390 [DEBUG] switch_core_session.c:975 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:48.925344 [DEBUG] switch_channel.c:2994 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Callstate Change ACTIVE -> HANGUP
2013-02-18 15:31:48.925344 [NOTICE] sofia.c:711 Hangup sofia/gemeinschaft/
win...@192.168.1.106:5060 [CS_EXECUTE] [NORMAL_CLEARING]
2013-02-18 15:31:48.925344 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:48.925344 [DEBUG] switch_ivr_bridge.c:622 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:48.945367 [DEBUG] switch_ivr_bridge.c:510 sofia/gemeinschaft/
win...@192.168.1.106:5060 ending bridge by request from write function
2013-02-18 15:31:48.945367 [DEBUG] switch_ivr_bridge.c:597 BRIDGE THREAD DONE [sofia/gemeinschaft/zentrale]
2013-02-18 15:31:48.945367 [DEBUG] switch_channel.c:2994 (sofia/gemeinschaft/zentrale) Callstate Change ACTIVE -> HANGUP
2013-02-18 15:31:48.945367 [NOTICE] switch_ivr_bridge.c:685 Hangup sofia/gemeinschaft/zentrale [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
2013-02-18 15:31:48.945367 [DEBUG] switch_channel.c:3017 Send signal sofia/gemeinschaft/zentrale [KILL]
2013-02-18 15:31:48.945367 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:480 (sofia/gemeinschaft/zentrale) State EXCHANGE_MEDIA going to sleep
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/zentrale) Running State Change CS_HANGUP
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:667 (sofia/gemeinschaft/zentrale) State HANGUP
2013-02-18 15:31:48.945367 [DEBUG] mod_sofia.c:497 sofia/gemeinschaft/zentrale Overriding SIP cause 480 with 200 from the other leg
2013-02-18 15:31:48.945367 [DEBUG] mod_sofia.c:503 Channel sofia/gemeinschaft/zentrale hanging up, cause: NORMAL_CLEARING
2013-02-18 15:31:48.945367 [DEBUG] mod_sofia.c:552 Sending BYE to sofia/gemeinschaft/zentrale
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:48 sofia/gemeinschaft/zentrale Standard HANGUP, cause: NORMAL_CLEARING
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:667 (sofia/gemeinschaft/zentrale) State HANGUP going to sleep
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:446 (sofia/gemeinschaft/zentrale) State Change CS_HANGUP -> CS_REPORTING
2013-02-18 15:31:48.945367 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/zentrale) Running State Change CS_REPORTING
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:749 (sofia/gemeinschaft/zentrale) State REPORTING
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:92 sofia/gemeinschaft/zentrale Standard REPORTING, cause: NORMAL_CLEARING
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:749 (sofia/gemeinschaft/zentrale) State REPORTING going to sleep
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:440 (sofia/gemeinschaft/zentrale) State Change CS_REPORTING -> CS_DESTROY
2013-02-18 15:31:48.945367 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/zentrale [BREAK]
2013-02-18 15:31:48.945367 [DEBUG] switch_core_session.c:1499 Session 57 (sofia/gemeinschaft/zentrale) Locked, Waiting on external entities
2013-02-18 15:31:48.945367 [DEBUG] switch_ivr_bridge.c:1471 sofia/gemeinschaft/
win...@192.168.1.106:5060 skip receive message [UNBRIDGE] (channel is hungup already)
2013-02-18 15:31:48.945367 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] HANGUP_HOOK: hangup
2013-02-18 15:31:48.945367 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] FORK EXIT - disposition: SUCCESS, cause: , code: 0, phrase: , dial_time: 7
2013-02-18 15:31:48.945367 [INFO] switch_cpp.cpp:1274 ### [4888d917-0cba-4b45-9f76-8ff36a4b4acb] DIALPLAN end - caller_id: 1003 "Windows Rechner", destination: sipaccount=1/@1, number: 1000, result: 0
2013-02-18 15:31:48.945367 [DEBUG] freeswitch_lua.cpp:370 DBH handle (nil) released.
2013-02-18 15:31:48.945367 [DEBUG] switch_cpp.cpp:1049 sofia/gemeinschaft/zentrale destroy/unlink session from object
2013-02-18 15:31:48.945367 [DEBUG] switch_cpp.cpp:1049 sofia/gemeinschaft/
win...@192.168.1.106:5060 destroy/unlink session from object
2013-02-18 15:31:48.945367 [DEBUG] switch_core_session.c:2674 sofia/gemeinschaft/
win...@192.168.1.106:5060 skip receive message [APPLICATION_EXEC] (channel is hungup already)
2013-02-18 15:31:48.945367 [DEBUG] switch_core_session.c:2689 sofia/gemeinschaft/
win...@192.168.1.106:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:477 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State EXECUTE going to sleep
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_HANGUP
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:667 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State HANGUP
2013-02-18 15:31:48.945367 [DEBUG] mod_sofia.c:503 Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 hanging up, cause: NORMAL_CLEARING
2013-02-18 15:31:48.945367 [INFO] switch_cpp.cpp:1274 #E# [be28eb5a-2b45-494d-a201-956334f41eaa] PRESENCE_OUTBOUND: account: zentrale, state: idle, caller: 1003
2013-02-18 15:31:48.945367 [DEBUG] switch_cpp.cpp:1274 #E# PRESENCE - account:
10...@192.168.1.106, state: terminated, direction: outbound, uid: be28eb5a-2b45-494d-a201-956334f41eaa
2013-02-18 15:31:48.945367 [NOTICE] switch_core_session.c:1517 Session 57 (sofia/gemeinschaft/zentrale) Ended
2013-02-18 15:31:48.945367 [NOTICE] switch_core_session.c:1521 Close Channel sofia/gemeinschaft/zentrale [CS_DESTROY]
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:556 (sofia/gemeinschaft/zentrale) Callstate Change HANGUP -> DOWN
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:559 (sofia/gemeinschaft/zentrale) Running State Change CS_DESTROY
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:569 (sofia/gemeinschaft/zentrale) State DESTROY
2013-02-18 15:31:48.945367 [DEBUG] mod_sofia.c:396 sofia/gemeinschaft/zentrale SOFIA DESTROY
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:99 sofia/gemeinschaft/zentrale Standard DESTROY
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:569 (sofia/gemeinschaft/zentrale) State DESTROY going to sleep
2013-02-18 15:31:48.945367 [DEBUG] switch_cpp.cpp:1274 #E# [be28eb5a-2b45-494d-a201-956334f41eaa] CDR_SAVE - event: CHANNEL_DESTROY, direction: outbound, save_cdr: false
2013-02-18 15:31:48.945367 [DEBUG] switch_cpp.cpp:1274 #E# [be28eb5a-2b45-494d-a201-956334f41eaa] CALL_HISTORY_SAVE - event: CHANNEL_DESTROY, direction: outbound, save_cdr: false
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:48 sofia/gemeinschaft/
win...@192.168.1.106:5060 Standard HANGUP, cause: NORMAL_CLEARING
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:667 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State HANGUP going to sleep
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:446 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State Change CS_HANGUP -> CS_REPORTING
2013-02-18 15:31:48.945367 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:415 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_REPORTING
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:749 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State REPORTING
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:92 sofia/gemeinschaft/
win...@192.168.1.106:5060 Standard REPORTING, cause: NORMAL_CLEARING
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:749 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State REPORTING going to sleep
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:440 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State Change CS_REPORTING -> CS_DESTROY
2013-02-18 15:31:48.945367 [DEBUG] switch_core_session.c:1291 Send signal sofia/gemeinschaft/
win...@192.168.1.106:5060 [BREAK]
2013-02-18 15:31:48.945367 [DEBUG] switch_core_session.c:1499 Session 56 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Locked, Waiting on external entities
2013-02-18 15:31:48.945367 [NOTICE] switch_core_session.c:1517 Session 56 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Ended
2013-02-18 15:31:48.945367 [NOTICE] switch_core_session.c:1521 Close Channel sofia/gemeinschaft/
win...@192.168.1.106:5060 [CS_DESTROY]
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:556 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Callstate Change HANGUP -> DOWN
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:559 (sofia/gemeinschaft/
win...@192.168.1.106:5060) Running State Change CS_DESTROY
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:569 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State DESTROY
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:99 sofia/gemeinschaft/
win...@192.168.1.106:5060 Standard DESTROY
2013-02-18 15:31:48.945367 [DEBUG] switch_core_state_machine.c:569 (sofia/gemeinschaft/
win...@192.168.1.106:5060) State DESTROY going to sleep
2013-02-18 15:31:48.945367 [INFO] switch_cpp.cpp:1274 #E# [4888d917-0cba-4b45-9f76-8ff36a4b4acb] PRESENCE_INBOUND: account: windows, state: idle
2013-02-18 15:31:48.945367 [DEBUG] switch_cpp.cpp:1274 #E# PRESENCE - account:
10...@192.168.1.106, state: terminated, direction: inbound, uid: 4888d917-0cba-4b45-9f76-8ff36a4b4acb
2013-02-18 15:31:48.945367 [INFO] switch_cpp.cpp:1274 #E# [4888d917-0cba-4b45-9f76-8ff36a4b4acb] CDR_SAVE - account: "SipAccount"="5", caller: "1003" "Windows Rechner", callee: "1000" "Zentrales Telefon", cause: "NORMAL_CLEARING"
2013-02-18 15:31:48.965360 [INFO] switch_cpp.cpp:1274 #E# [4888d917-0cba-4b45-9f76-8ff36a4b4acb] CALL_HISTORY_SAVE dialed - account: SipAccount=5, caller: "1003" "Windows Rechner", callee: "1000" "Zentrales Telefon", result: "NORMAL_CLEARING"
2013-02-18 15:31:48.965360 [INFO] switch_cpp.cpp:1274 #E# [4888d917-0cba-4b45-9f76-8ff36a4b4acb] CALL_HISTORY_SAVE received - account: sipaccount=1, caller: "1003" "Windows Rechner", callee: "1000" "Zentrales Telefon", result: "NORMAL_CLEARING"