Displaying the last 32,768 of 2,073,216 bytes.
IL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(from_user_record=all)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.605468 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [from_user_record]=[all]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (PASS) [user_record] ${from_user_record}(all) =~ /^all$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(record_session=true) INLINE
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(record_session=true)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.605468 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [record_session]=[true]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^inbound$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^outbound$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^local$/ break=never
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (PASS) [user_record] ${record_session}(true) =~ /^true$/ break=on-false
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(api_on_answer=uuid_record ${uuid} start ${recordings_dir}/${domain_name}/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${uuid}.${record_ext})
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 parsing [192.168.0.102->redial] continue=true
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (FAIL) [redial] destination_number(09892504286) =~ /^(redial|\*870)$/ break=on-true
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Absolute Condition [redial]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 parsing [192.168.0.102->DinStar.11d] continue=false
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Regex (PASS) [DinStar.11d] destination_number(09892504286) =~ /^\+?(\d{11})$/ break=on-false
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(sip_h_X-accountcode=${accountcode})
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(sip_h_X-Tag=)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(call_direction=outbound)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(hangup_after_bridge=true)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(effective_caller_id_name=${outbound_caller_id_name})
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(effective_caller_id_number=${outbound_caller_id_number})
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(inherit_codec=true)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(ignore_display_updates=true)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(callee_id_number=09892504286)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action set(continue_on_fail=true)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 Dialplan: sofia/internal/1111@192.168.0.102 Action bridge(sofia/gateway/b56f23a2-7a63-4b2a-8f4f-6edf9bddc7bc/09892504286)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.605468 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1111@192.168.0.102) State Change CS_ROUTING -> CS_EXECUTE
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.605468 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.605468 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/1111@192.168.0.102) State ROUTING going to sleep
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1111@192.168.0.102) Running State Change CS_EXECUTE
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/1111@192.168.0.102) State EXECUTE
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_sofia.c:178 sofia/internal/1111@192.168.0.102 SOFIA EXECUTE
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1111@192.168.0.102 Standard EXECUTE
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(call_direction=local)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [call_direction]=[local]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(call_direction=outbound)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [call_direction]=[outbound]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 export(origination_callee_id_name=09892504286)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] switch_channel.c:1247 EXPORT (export_vars) [origination_callee_id_name]=[09892504286]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(RFC2822_DATE=Sun, 21 Aug 2016 10:50:51 India Standard Time)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [RFC2822_DATE]=[Sun, 21 Aug 2016 10:50:51 India Standard Time]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(api_on_answer=uuid_record a8af1b72-f196-4d87-88c1-44ca1067fdf5 start C:/Program Files/FreeSWITCH/recordings/192.168.0.102/archive/2016/Aug/21/a8af1b72-f196-4d87-88c1-44ca1067fdf5.wav)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [api_on_answer]=[uuid_record a8af1b72-f196-4d87-88c1-44ca1067fdf5 start C:/Program Files/FreeSWITCH/recordings/192.168.0.102/archive/2016/Aug/21/a8af1b72-f196-4d87-88c1-44ca1067fdf5.wav]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 hash(insert/192.168.0.102-last_dial/1111/09892504286)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(sip_h_X-accountcode=192.168.0.102)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [sip_h_X-accountcode]=[192.168.0.102]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(sip_h_X-Tag=)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [sip_h_X-Tag]=[UNDEF]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(call_direction=outbound)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [call_direction]=[outbound]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(hangup_after_bridge=true)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [hangup_after_bridge]=[true]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(effective_caller_id_name=)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [effective_caller_id_name]=[UNDEF]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(effective_caller_id_number=)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [effective_caller_id_number]=[UNDEF]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(inherit_codec=true)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [inherit_codec]=[true]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(ignore_display_updates=true)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [ignore_display_updates]=[true]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(callee_id_number=09892504286)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [callee_id_number]=[09892504286]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 set(continue_on_fail=true)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] mod_dptools.c:1435 sofia/internal/1111@192.168.0.102 SET [continue_on_fail]=[true]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 EXECUTE sofia/internal/1111@192.168.0.102 bridge(sofia/gateway/b56f23a2-7a63-4b2a-8f4f-6edf9bddc7bc/09892504286)
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] switch_channel.c:1201 sofia/internal/1111@192.168.0.102 EXPORTING[export_vars] [domain_name]=[192.168.0.102] to event
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] switch_channel.c:1201 sofia/internal/1111@192.168.0.102 EXPORTING[export_vars] [origination_callee_id_name]=[09892504286] to event
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.625000 [DEBUG] switch_ivr_originate.c:2103 Parsing global variables
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [NOTICE] switch_channel.c:1055 New Channel sofia/external/09892504286 [3ccb5900-4301-4b0e-9ce2-86145c413d3c]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] mod_sofia.c:4636 (sofia/external/09892504286) State Change CS_NEW -> CS_INIT
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:472 (sofia/external/09892504286) Running State Change CS_INIT
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:512 (sofia/external/09892504286) State INIT
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] mod_sofia.c:87 sofia/external/09892504286 SOFIA INIT
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] sofia_glue.c:1232 sofia/external/09892504286 sending invite version: 1.5.15b 32bit
3ccb5900-4301-4b0e-9ce2-86145c413d3c Local SDP:
3ccb5900-4301-4b0e-9ce2-86145c413d3c v=0
3ccb5900-4301-4b0e-9ce2-86145c413d3c o=FreeSWITCH 1471731559 1471731560 IN IP4 192.168.0.102
3ccb5900-4301-4b0e-9ce2-86145c413d3c s=FreeSWITCH
3ccb5900-4301-4b0e-9ce2-86145c413d3c c=IN IP4 192.168.0.102
3ccb5900-4301-4b0e-9ce2-86145c413d3c t=0 0
3ccb5900-4301-4b0e-9ce2-86145c413d3c m=audio 25292 RTP/AVP 9 0 8 3 101 13
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=rtpmap:9 G722/8000
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=rtpmap:0 PCMU/8000
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=rtpmap:8 PCMA/8000
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=rtpmap:3 GSM/8000
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=rtpmap:101 telephone-event/8000
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=fmtp:101 0-16
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=ptime:20
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=sendrecv
3ccb5900-4301-4b0e-9ce2-86145c413d3c
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:40 sofia/external/09892504286 Standard INIT
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:48 (sofia/external/09892504286) State Change CS_INIT -> CS_ROUTING
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:512 (sofia/external/09892504286) State INIT going to sleep
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:472 (sofia/external/09892504286) Running State Change CS_ROUTING
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:528 (sofia/external/09892504286) State ROUTING
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] mod_sofia.c:123 sofia/external/09892504286 SOFIA ROUTING
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_ivr_originate.c:67 (sofia/external/09892504286) State Change CS_ROUTING -> CS_CONSUME_MEDIA
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:528 (sofia/external/09892504286) State ROUTING going to sleep
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:472 (sofia/external/09892504286) Running State Change CS_CONSUME_MEDIA
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] sofia.c:6614 Channel sofia/external/09892504286 entering state [calling][0]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:547 (sofia/external/09892504286) State CONSUME_MEDIA
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.625000 [DEBUG] switch_core_state_machine.c:547 (sofia/external/09892504286) State CONSUME_MEDIA going to sleep
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] sofia.c:6614 Channel sofia/external/09892504286 entering state [proceeding][183]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] sofia.c:6624 Remote SDP:
3ccb5900-4301-4b0e-9ce2-86145c413d3c v=0
3ccb5900-4301-4b0e-9ce2-86145c413d3c o=Dinstar 41002750 41002751 IN IP4 192.168.0.212
3ccb5900-4301-4b0e-9ce2-86145c413d3c s=-
3ccb5900-4301-4b0e-9ce2-86145c413d3c c=IN IP4 192.168.0.212
3ccb5900-4301-4b0e-9ce2-86145c413d3c t=0 0
3ccb5900-4301-4b0e-9ce2-86145c413d3c m=audio 8012 RTP/AVP 0
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=rtpmap:0 PCMU/8000
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=ptime:20
3ccb5900-4301-4b0e-9ce2-86145c413d3c
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:3682 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:2473 Set Codec sofia/external/09892504286 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_codec.c:111 sofia/external/09892504286 Original read codec set to PCMU:0
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:3903 No 2833 in SDP. Disable 2833 dtmf and switch to INFO
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:5141 AUDIO RTP [sofia/external/09892504286] 192.168.0.102 port 25292 -> 192.168.0.212 port 8012 codec: 0 ms: 20
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_rtp.c:3548 Starting timer [soft] 160 bytes per 20ms
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/09892504286!
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.745117 [DEBUG] switch_channel.c:3395 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.745117 [DEBUG] switch_channel.c:3399 (sofia/external/09892504286) Callstate Change DOWN -> EARLY
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.745117 [DEBUG] switch_ivr_originate.c:412 Setting codec string on sofia/internal/1111@192.168.0.102 to PCMU@8000h@20i
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.745117 [INFO] switch_ivr_originate.c:3529 Sending early media
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:5141 AUDIO RTP [sofia/internal/1111@192.168.0.102] 192.168.0.102 port 26624 -> 192.168.0.103 port 60494 codec: 9 ms: 20
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.745117 [DEBUG] switch_rtp.c:3548 Starting timer [soft] 160 bytes per 20ms
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:5439 Set 2833 dtmf send payload to 101
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.745117 [DEBUG] switch_core_media.c:5445 Set 2833 dtmf receive payload to 101
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.745117 [DEBUG] mod_sofia.c:2268 Ring SDP:
a8af1b72-f196-4d87-88c1-44ca1067fdf5 v=0
a8af1b72-f196-4d87-88c1-44ca1067fdf5 o=FreeSWITCH 1471730227 1471730228 IN IP4 192.168.0.102
a8af1b72-f196-4d87-88c1-44ca1067fdf5 s=FreeSWITCH
a8af1b72-f196-4d87-88c1-44ca1067fdf5 c=IN IP4 192.168.0.102
a8af1b72-f196-4d87-88c1-44ca1067fdf5 t=0 0
a8af1b72-f196-4d87-88c1-44ca1067fdf5 m=audio 26624 RTP/AVP 9 101
a8af1b72-f196-4d87-88c1-44ca1067fdf5 a=rtpmap:9 G722/8000
a8af1b72-f196-4d87-88c1-44ca1067fdf5 a=rtpmap:101 telephone-event/8000
a8af1b72-f196-4d87-88c1-44ca1067fdf5 a=fmtp:101 0-16
a8af1b72-f196-4d87-88c1-44ca1067fdf5 a=ptime:20
a8af1b72-f196-4d87-88c1-44ca1067fdf5 a=sendrecv
a8af1b72-f196-4d87-88c1-44ca1067fdf5
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.745117 [NOTICE] mod_sofia.c:2271 Pre-Answer sofia/internal/1111@192.168.0.102!
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.764648 [DEBUG] switch_channel.c:3399 (sofia/internal/1111@192.168.0.102) Callstate Change RINGING -> EARLY
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.764648 [DEBUG] switch_core_session.c:908 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.764648 [DEBUG] switch_ivr_originate.c:3580 Originate Resulted in Success: [sofia/external/09892504286]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.764648 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.764648 [DEBUG] sofia.c:6614 Channel sofia/internal/1111@192.168.0.102 entering state [early][183]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.764648 [DEBUG] switch_core_session.c:908 Send signal sofia/external/09892504286 [BREAK]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.764648 [DEBUG] switch_core_session.c:908 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.764648 [DEBUG] switch_ivr_bridge.c:1465 (sofia/external/09892504286) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.764648 [DEBUG] switch_core_state_machine.c:472 (sofia/external/09892504286) Running State Change CS_EXCHANGE_MEDIA
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.764648 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.764648 [DEBUG] switch_core_state_machine.c:538 (sofia/external/09892504286) State EXCHANGE_MEDIA
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.764648 [DEBUG] mod_sofia.c:594 SOFIA EXCHANGE_MEDIA
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.865234 [DEBUG] switch_rtp.c:5856 Correct ip/port confirmed.
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.865234 [NOTICE] switch_core_io.c:1261 Activating write resampler
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:50:51.924804 [DEBUG] switch_rtp.c:5856 Correct ip/port confirmed.
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:50:51.924804 [NOTICE] switch_core_io.c:1261 Activating write resampler
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:51:06.825195 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:51:06.825195 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:51:06.844726 [DEBUG] sofia.c:6614 Channel sofia/external/09892504286 entering state [completing][200]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:51:06.844726 [DEBUG] sofia.c:6624 Remote SDP:
3ccb5900-4301-4b0e-9ce2-86145c413d3c v=0
3ccb5900-4301-4b0e-9ce2-86145c413d3c o=Dinstar 41004260 41004261 IN IP4 192.168.0.212
3ccb5900-4301-4b0e-9ce2-86145c413d3c s=-
3ccb5900-4301-4b0e-9ce2-86145c413d3c c=IN IP4 192.168.0.212
3ccb5900-4301-4b0e-9ce2-86145c413d3c t=0 0
3ccb5900-4301-4b0e-9ce2-86145c413d3c m=audio 8012 RTP/AVP 0
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=rtpmap:0 PCMU/8000
3ccb5900-4301-4b0e-9ce2-86145c413d3c a=ptime:20
3ccb5900-4301-4b0e-9ce2-86145c413d3c
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:51:06.844726 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:51:06.844726 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:51:06.865234 [DEBUG] sofia.c:6614 Channel sofia/external/09892504286 entering state [ready][200]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:51:06.865234 [DEBUG] switch_channel.c:3635 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:51:06.865234 [NOTICE] sofia.c:7416 Channel [sofia/external/09892504286] has been answered
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:51:06.865234 [DEBUG] switch_channel.c:3689 (sofia/external/09892504286) Callstate Change EARLY -> ACTIVE
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:51:06.884765 [DEBUG] mod_sofia.c:780 Local SDP sofia/internal/1111@192.168.0.102:
a8af1b72-f196-4d87-88c1-44ca1067fdf5 v=0
a8af1b72-f196-4d87-88c1-44ca1067fdf5 o=FreeSWITCH 1471730227 1471730229 IN IP4 192.168.0.102
a8af1b72-f196-4d87-88c1-44ca1067fdf5 s=FreeSWITCH
a8af1b72-f196-4d87-88c1-44ca1067fdf5 c=IN IP4 192.168.0.102
a8af1b72-f196-4d87-88c1-44ca1067fdf5 t=0 0
a8af1b72-f196-4d87-88c1-44ca1067fdf5 m=audio 26624 RTP/AVP 9 101
a8af1b72-f196-4d87-88c1-44ca1067fdf5 a=rtpmap:9 G722/8000
a8af1b72-f196-4d87-88c1-44ca1067fdf5 a=rtpmap:101 telephone-event/8000
a8af1b72-f196-4d87-88c1-44ca1067fdf5 a=fmtp:101 0-16
a8af1b72-f196-4d87-88c1-44ca1067fdf5 a=ptime:20
a8af1b72-f196-4d87-88c1-44ca1067fdf5 a=sendrecv
a8af1b72-f196-4d87-88c1-44ca1067fdf5
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:51:06.884765 [DEBUG] switch_core_session.c:908 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:51:06.884765 [NOTICE] switch_ivr_bridge.c:496 Channel [sofia/internal/1111@192.168.0.102] has been answered
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:51:06.884765 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:51:06.884765 [DEBUG] switch_channel.c:3494 sofia/internal/1111@192.168.0.102 process uuid_record a8af1b72-f196-4d87-88c1-44ca1067fdf5 start C:/Program Files/FreeSWITCH/recordings/192.168.0.102/archive/2016/Aug/21/a8af1b72-f196-4d87-88c1-44ca1067fdf5.wav: uuid_record(a8af1b72-f196-4d87-88c1-44ca1067fdf5 start C:/Program Files/FreeSWITCH/recordings/192.168.0.102/archive/2016/Aug/21/a8af1b72-f196-4d87-88c1-44ca1067fdf5.wav)
a8af1b72-f196-4d87-88c1-44ca1067fdf5
2016-08-21 10:51:06.884765 [INFO] mod_native_file.c:101 Opening File [C:/Program-in.G722] 16000hz
2016-08-21 10:51:06.884765 [INFO] mod_native_file.c:101 Opening File [C:/Program-out.G722] 16000hz
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:51:06.884765 [DEBUG] sofia.c:6614 Channel sofia/internal/1111@192.168.0.102 entering state [completed][200]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:51:06.884765 [DEBUG] switch_core_media_bug.c:534 Attaching BUG to sofia/internal/1111@192.168.0.102
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 10:51:06.884765 [DEBUG] switch_channel.c:3689 (sofia/internal/1111@192.168.0.102) Callstate Change EARLY -> ACTIVE
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 10:51:07.764648 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/09892504286 [BREAK]
2016-08-21 10:51:07.764648 [CRIT] switch_time.c:1194 Forward Clock Skew Detected!
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 11:00:06.368164 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 11:00:06.368164 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 11:00:06.368164 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
2016-08-21 11:00:06.368164 [WARNING] sofia_reg.c:1742 SIP auth challenge (REGISTER) on sofia profile 'internal' for [3333@192.168.0.102] from ip 192.168.0.212
2016-08-21 11:00:06.368164 [WARNING] sofia_reg.c:1742 SIP auth challenge (REGISTER) on sofia profile 'internal' for [8888@192.168.0.102] from ip 192.168.0.212
2016-08-21 11:00:06.368164 [WARNING] sofia_reg.c:1742 SIP auth challenge (REGISTER) on sofia profile 'internal' for [5555@192.168.0.102] from ip 192.168.0.212
2016-08-21 11:00:06.368164 [WARNING] sofia_reg.c:1742 SIP auth challenge (REGISTER) on sofia profile 'internal' for [4444@192.168.0.102] from ip 192.168.0.212
2016-08-21 11:00:06.368164 [WARNING] sofia_reg.c:1742 SIP auth challenge (REGISTER) on sofia profile 'internal' for [7777@192.168.0.102] from ip 192.168.0.212
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [NOTICE] sofia.c:952 Hangup sofia/external/09892504286 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_channel.c:3222 Send signal sofia/external/09892504286 [KILL]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [sofia/external/09892504286]
a8af1b72-f196-4d87-88c1-44ca1067fdf5 2016-08-21 11:00:06.388671 [DEBUG] switch_ivr_bridge.c:690 Send signal sofia/internal/1111@192.168.0.102 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:538 (sofia/external/09892504286) State EXCHANGE_MEDIA going to sleep
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:472 (sofia/external/09892504286) Running State Change CS_HANGUP
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:735 (sofia/external/09892504286) Callstate Change ACTIVE -> HANGUP
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:737 (sofia/external/09892504286) State HANGUP
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] mod_sofia.c:413 Channel sofia/external/09892504286 hanging up, cause: NORMAL_CLEARING
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:60 sofia/external/09892504286 Standard HANGUP, cause: NORMAL_CLEARING
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:737 (sofia/external/09892504286) State HANGUP going to sleep
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:504 (sofia/external/09892504286) State Change CS_HANGUP -> CS_REPORTING
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:472 (sofia/external/09892504286) Running State Change CS_REPORTING
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:823 (sofia/external/09892504286) State REPORTING
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:104 sofia/external/09892504286 Standard REPORTING, cause: NORMAL_CLEARING
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:823 (sofia/external/09892504286) State REPORTING going to sleep
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_state_machine.c:498 (sofia/external/09892504286) State Change CS_REPORTING -> CS_DESTROY
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/09892504286 [BREAK]
3ccb5900-4301-4b0e-9ce2-86145c413d3c 2016-08-21 11:00:06.388671 [DEBUG] switch_core_session.c:1615 Session 29 (sofia/external/09892504286) Locked, Waiting on external entities