[Freeswitch-users] mod_xml_curl - missing dialplan variable (domain of originating user for blind transfer)

Mon Nov 19 07:34:13 MSK 2012

Hi guys,

In a nut shell, it appears that when attempting to perform a blind transfer
under certain conditions (explained below), mod_xml_curl does not expose
the originating domain in a clean format.

My initial plan was to find the point where these variable were being
generated, look at what was available, then add an extra variable for the
domain and submit a patch.

Sadly my C isn't great and I hit a brick wall, so if anyone can help out, I
will ensure the mod_xml_curl documentation is updated and/or assist with
any patching/testing required.

Please take the following scenario;

* Extension 2000 calls an external number via a gateway (i.e. bridge
sofia/gateway/name/e164_number_here).
* Call connects fine, audio stays good, no disconnection problems etc.
* Call is blind transferred to another extension

As a result, the following is determined;

* User initiating the blind transfer is 2000
* Domain initiating the blind transfer is c1881.voiceflare.co.uk
* Destination number of the call is 447866123456
* Number to blind transfer to is 2001
* Call to mod_xml_curl is made

It makes reference to the User in the following 'clean' variables (by
clean, I mean variables that just contain 2000 and don't require mangling
to extract the info);

 u'Caller-ANI': u'2000',
 u'Caller-Username': u'2000',
 u'Caller-Caller-ID-Number': u'2000',
 u'Hunt-ANI': u'2000',
 u'Hunt-Caller-ID-Number': u'2000',
 u'Hunt-Username': u'2000',
 u'variable_last_sent_callee_id_number': u'2000',
 u'variable_sip_from_user': u'2000',

It also has the User in the following unclean variables;

 u'variable_bridge_channel': u'sofia/external/
2000 at c1881.voiceflare.co.uk:5060',
 u'variable_sip_from_uri': u'2000 at 89.238.182.137',
 u'variable_sip_full_from': u'"foxx" <sip:2000 at 89.238.182.137
>;tag=XryjFQp3rB2NF',
 u'variable_sip_h_Referred-By': u'"foxx" <
sip:2000 at c1881.voiceflare.co.uk:5060>',

However, it only references the domain in the following unclean variables;

 u'variable_bridge_channel': u'sofia/external/
2000 at c1881.voiceflare.co.uk:5060',
 u'variable_sip_h_Referred-By': u'"foxx" <
sip:2000 at c1881.voiceflare.co.uk:5060>',
 u'variable_sip_refer_to': u'<sip:2001 at c1881.voiceflare.co.uk:5060>',

Lets say that we want to determine the user/domain that has initiated this
transfer, doing so would mean mangling with one of those above variables,
which seems a bit dirty (plus it is not clear which is the correct one to
use).

I have attached the SIP trace of the entire blind transfer event, and the
full mod_xml_curl request being sent.

If anyone could answer the following, it'd be much appreciated;

* Should there be an improvement patch that exposes the domain of the user
that originated the blind transfer?
* Are there better/alternative ways to extracting the domain of the user
that originated the blind transfer?

Many thanks

Cal
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20121119/ece33d1c/attachment-0001.html 
-------------- next part --------------

{u'Answer-State': u'answered',
 u'Call-Direction': u'outbound',
 u'Caller-ANI': u'2000',
 u'Caller-Callee-ID-Name': u'Outbound Call',
 u'Caller-Callee-ID-Number': u'447866123456',
 u'Caller-Caller-ID-Name': u'foxx',
 u'Caller-Caller-ID-Number': u'2000',
 u'Caller-Channel-Answered-Time': u'1353296828185007',
 u'Caller-Channel-Created-Time': u'1353296819484965',
 u'Caller-Channel-Hangup-Time': u'0',
 u'Caller-Channel-Name': u'sofia/external/447866123456',
 u'Caller-Channel-Progress-Media-Time': u'1353296824324993',
 u'Caller-Channel-Progress-Time': u'0',
 u'Caller-Channel-Transfer-Time': u'0',
 u'Caller-Context': u'default',
 u'Caller-Destination-Number': u'2001',
 u'Caller-Dialplan': u'XML',
 u'Caller-Direction': u'outbound',
 u'Caller-Network-Addr': u'80.93.165.111',
 u'Caller-Privacy-Hide-Name': u'false',
 u'Caller-Privacy-Hide-Number': u'false',
 u'Caller-Profile-Created-Time': u'1353296834585013',
 u'Caller-Profile-Index': u'2',
 u'Caller-RDNIS': u'447866123456',
 u'Caller-Screen-Bit': u'true',
 u'Caller-Source': u'mod_sofia',
 u'Caller-Transfer-Source': u'1353296834:ce841838-31fb-11e2-a40f-bdc0bb753e98:bl_xfer:2001/default/XML',
 u'Caller-Unique-ID': u'c58483e4-31fb-11e2-a406-bdc0bb753e98',
 u'Caller-Username': u'2000',
 u'Channel-Call-State': u'RINGING',
 u'Channel-Call-UUID': u'c58483e4-31fb-11e2-a406-bdc0bb753e98',
 u'Channel-HIT-Dialplan': u'false',
 u'Channel-Name': u'sofia/external/447866123456',
 u'Channel-Read-Codec-Bit-Rate': u'64000',
 u'Channel-Read-Codec-Name': u'PCMA',
 u'Channel-Read-Codec-Rate': u'8000',
 u'Channel-State': u'CS_ROUTING',
 u'Channel-State-Number': u'2',
 u'Channel-Write-Codec-Bit-Rate': u'64000',
 u'Channel-Write-Codec-Name': u'PCMA',
 u'Channel-Write-Codec-Rate': u'8000',
 u'Core-UUID': u'65606776-2ed1-11e2-92ce-bdc0bb753e98',
 u'Event-Calling-File': u'mod_dialplan_xml.c',
 u'Event-Calling-Function': u'dialplan_xml_locate',
 u'Event-Calling-Line-Number': u'456',
 u'Event-Date-GMT': u'Mon, 19 Nov 2012 03:47:14 GMT',
 u'Event-Date-Local': u'2012-11-19 03:47:14',
 u'Event-Date-Timestamp': u'1353296834605025',
 u'Event-Name': u'REQUEST_PARAMS',
 u'Event-Sequence': u'54154',
 u'FreeSWITCH-Hostname': u'vded213',
 u'FreeSWITCH-IPv4': u'89.238.182.137',
 u'FreeSWITCH-IPv6': u'::1',
 u'FreeSWITCH-Switchname': u'vded213',
 u'Hunt-ANI': u'2000',
 u'Hunt-Callee-ID-Name': u'Outbound Call',
 u'Hunt-Callee-ID-Number': u'447866123456',
 u'Hunt-Caller-ID-Name': u'foxx',
 u'Hunt-Caller-ID-Number': u'2000',
 u'Hunt-Channel-Answered-Time': u'1353296828185007',
 u'Hunt-Channel-Created-Time': u'1353296819484965',
 u'Hunt-Channel-Hangup-Time': u'0',
 u'Hunt-Channel-Name': u'sofia/external/447866123456',
 u'Hunt-Channel-Progress-Media-Time': u'1353296824324993',
 u'Hunt-Channel-Progress-Time': u'0',
 u'Hunt-Channel-Transfer-Time': u'0',
 u'Hunt-Context': u'default',
 u'Hunt-Destination-Number': u'2001',
 u'Hunt-Dialplan': u'XML',
 u'Hunt-Direction': u'outbound',
 u'Hunt-Network-Addr': u'80.93.165.111',
 u'Hunt-Privacy-Hide-Name': u'false',
 u'Hunt-Privacy-Hide-Number': u'false',
 u'Hunt-Profile-Created-Time': u'1353296834585013',
 u'Hunt-Profile-Index': u'2',
 u'Hunt-RDNIS': u'447866123456',
 u'Hunt-Screen-Bit': u'true',
 u'Hunt-Source': u'mod_sofia',
 u'Hunt-Transfer-Source': u'1353296834:ce841838-31fb-11e2-a40f-bdc0bb753e98:bl_xfer:2001/default/XML',
 u'Hunt-Unique-ID': u'c58483e4-31fb-11e2-a406-bdc0bb753e98',
 u'Hunt-Username': u'2000',
 u'Presence-Call-Direction': u'outbound',
 u'Unique-ID': u'c58483e4-31fb-11e2-a406-bdc0bb753e98',
 u'hostname': u'vded213',
 u'key_name': u'',
 u'key_value': u'',
 u'section': u'dialplan',
 u'tag_name': u'',
 u'variable_absolute_codec_string': u'PCMU at 8000h@20i at 64000b,PCMA at 8000h@20i at 64000b,GSM at 8000h@20i at 13200b',
 u'variable_advertised_media_ip': u'89.238.182.137',
 u'variable_bridge_channel': u'sofia/external/2000 at c1881.voiceflare.co.uk:5060',
 u'variable_bridge_uuid': u'c57cb114-31fb-11e2-a400-bdc0bb753e98',
 u'variable_call_uuid': u'c58483e4-31fb-11e2-a406-bdc0bb753e98',
 u'variable_channel_name': u'sofia/external/447866123456',
 u'variable_current_application': u'playback',
 u'variable_current_application_response': u'PLAYBACK ERROR',
 u'variable_direction': u'outbound',
 u'variable_endpoint_disposition': u'ANSWER',
 u'variable_ep_codec_string': u'PCMA at 8000h@20i at 64000b',
 u'variable_is_outbound': u'true',
 u'variable_last_bridge_to': u'c57cb114-31fb-11e2-a400-bdc0bb753e98',
 u'variable_last_sent_callee_id_name': u'foxx',
 u'variable_last_sent_callee_id_number': u'2000',
 u'variable_local_media_ip': u'89.238.182.137',
 u'variable_local_media_port': u'17622',
 u'variable_max_forwards': u'68',
 u'variable_originate_early_media': u'true',
 u'variable_originating_leg_uuid': u'c57cb114-31fb-11e2-a400-bdc0bb753e98',
 u'variable_originator': u'c57cb114-31fb-11e2-a400-bdc0bb753e98',
 u'variable_originator_codec': u'PCMU at 8000h@20i at 64000b,PCMA at 8000h@20i at 64000b,GSM at 8000h@20i at 13200b',
 u'variable_read_codec': u'PCMA',
 u'variable_read_rate': u'8000',
 u'variable_recovery_profile_name': u'external',
 u'variable_remote_media_ip': u'80.93.165.111',
 u'variable_remote_media_port': u'28436',
 u'variable_rtp_use_ssrc': u'1387842288',
 u'variable_session_id': u'115',
 u'variable_sip_2833_recv_payload': u'101',
 u'variable_sip_2833_send_payload': u'101',
 u'variable_sip_audio_recv_pt': u'8',
 u'variable_sip_call_id': u'9ce2e3bf-ac9e-1230-eead-000c299684b0',
 u'variable_sip_contact_host': u'80.93.165.111',
 u'variable_sip_contact_params': u'transport=udp',
 u'variable_sip_contact_port': u'5060',
 u'variable_sip_contact_uri': u'447866123456 at 80.93.165.111:5060',
 u'variable_sip_contact_user': u'447866123456',
 u'variable_sip_cseq': u'36312346',
 u'variable_sip_destination_url': u'sip:447866123456 at sip.numbergroup-services.com',
 u'variable_sip_from_display': u'foxx',
 u'variable_sip_from_host': u'89.238.182.137',
 u'variable_sip_from_tag': u'XryjFQp3rB2NF',
 u'variable_sip_from_uri': u'2000 at 89.238.182.137',
 u'variable_sip_from_user': u'2000',
 u'variable_sip_full_from': u'"foxx" <sip:2000 at 89.238.182.137>;tag=XryjFQp3rB2NF',
 u'variable_sip_full_to': u'<sip:447866123456 at sip.numbergroup-services.com>;tag=39FNHXrcry73S',
 u'variable_sip_full_via': u'SIP/2.0/UDP 89.238.182.137;rport=5060;branch=z9hG4bKeHtmQ2KK0er8r',
 u'variable_sip_gateway_name': u'numbergroup',
 u'variable_sip_h_Referred-By': u'"foxx" <sip:2000 at c1881.voiceflare.co.uk:5060>',
 u'variable_sip_local_network_addr': u'89.238.182.137',
 u'variable_sip_local_sdp_str': u'v=0\no=FreeSWITCH 1353279197 1353279198 IN IP4 89.238.182.137\ns=FreeSWITCH\nc=IN IP4 89.238.182.137\nt=0 0\nm=audio 17622 RTP/AVP 0 8 3 101 13\na=rtpmap:101 telephone-event/8000\na=fmtp:101 0-16\na=ptime:20\na=sendrecv\n',
 u'variable_sip_network_ip': u'80.93.165.111',
 u'variable_sip_network_port': u'5060',
 u'variable_sip_outgoing_contact_uri': u'<sip:gw+numbergroup at 89.238.182.137:5060;transport=udp;gw=numbergroup>',
 u'variable_sip_ph_P-Charging-Vector': u'icid-value=c58d77ce-31fb-11e2-a21a-99ec1789df65;icid-generated-at=80.93.165.111;orig-ioi=numbergroup.com',
 u'variable_sip_profile_name': u'gateway',
 u'variable_sip_recover_contact': u'<sip:447866123456 at 80.93.165.111:5060;transport=udp>',
 u'variable_sip_recover_via': u'SIP/2.0/UDP 89.238.182.137;rport=5060;branch=z9hG4bKeHtmQ2KK0er8r',
 u'variable_sip_refer_to': u'<sip:2001 at c1881.voiceflare.co.uk:5060>',
 u'variable_sip_reply_host': u'80.93.165.111',
 u'variable_sip_reply_port': u'5060',
 u'variable_sip_req_uri': u'447866123456 at sip.numbergroup-services.com',
 u'variable_sip_to_host': u'sip.numbergroup-services.com',
 u'variable_sip_to_tag': u'39FNHXrcry73S',
 u'variable_sip_to_uri': u'447866123456 at sip.numbergroup-services.com',
 u'variable_sip_to_user': u'447866123456',
 u'variable_sip_use_codec_name': u'PCMA',
 u'variable_sip_use_codec_ptime': u'20',
 u'variable_sip_use_codec_rate': u'8000',
 u'variable_sip_use_pt': u'8',
 u'variable_sip_user_agent': u'numbergroup.com',
 u'variable_sofia_profile_name': u'external',
 u'variable_switch_m_sdp': u'v=0\r\no=3cxVCE 263380575 226789996 IN IP4 82.30.159.182\r\ns=3cxVCE Audio Call\r\nc=IN IP4 82.30.159.182\r\nt=0 0\r\nm=audio 40046 RTP/AVP 0 8 3 101\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:3 GSM/8000\r\na=rtpmap:101 telephone-event/8000\r\na=fmtp:101 0-16\r\na=sendonly\r\na=ptime:20\r\nm=video 40000 RTP/AVP 34\r\nc=IN IP4 82.30.159.182\r\na=rtpmap:34 H263/90000\r\na=fmtp:34 QCIF=1;CIF=1;SQCIF=1;CIF4=1\r\n',
 u'variable_switch_r_sdp': u'v=0\r\no=numbergroup 1353268388 1353268389 IN IP4 80.93.165.111\r\ns=numbergroup\r\nc=IN IP4 80.93.165.111\r\nt=0 0\r\nm=audio 28436 RTP/AVP 8 101 13\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:101 telephone-event/8000\r\na=fmtp:101 0-16\r\na=rtpmap:13 CN/8000\r\na=ptime:20\r\n',
 u'variable_transfer_history': u'ARRAY::1353296834:ce841838-31fb-11e2-a40f-bdc0bb753e98:bl_xfer:2001/default/XML',
 u'variable_transfer_source': u'1353296834:ce841838-31fb-11e2-a40f-bdc0bb753e98:bl_xfer:2001/default/XML',
 u'variable_uuid': u'c58483e4-31fb-11e2-a406-bdc0bb753e98',
 u'variable_write_codec': u'PCMA',
 u'variable_write_rate': u'8000'}

freeswitch at vded213> 
recv 614 bytes from udp/[82.30.159.182]:60585 at 04:24:34.648703:
   ------------------------------------------------------------------------
   REFER sip:07866123456 at 89.238.182.137:5060;transport=udp SIP/2.0
   Via: SIP/2.0/UDP 82.30.159.182:60585;branch=z9hG4bK-d8754z-da5faa120000ed7a-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:2000 at 82.30.159.182:60585;rinstance=b0415b098f47701f>
   To: <sip:07866123456 at c1881.voiceflare.co.uk:5060>;tag=1yN876FKm9cDK
   From: "foxx"<sip:2000 at c1881.voiceflare.co.uk:5060>;tag=f5168a69
   Call-ID: ZWZhYTdhODk2NDgxODU4MjM5OTYyYjVlMTk4NTEwYWI.
   CSeq: 3 REFER
   User-Agent: 3CXPhone 6.0.25732.0
   Refer-To: <sip:2001 at c1881.voiceflare.co.uk:5060>
   Referred-By: "foxx"<sip:2000 at c1881.voiceflare.co.uk:5060>
   Content-Length: 0

   ------------------------------------------------------------------------
2012-11-19 04:24:34.644982 [DEBUG] switch_core_session.c:905 Send signal sofia/external/2000 at c1881.voiceflare.co.uk:5060 [BREAK]
2012-11-19 04:24:34.664991 [DEBUG] sofia.c:7308 Process REFER to [2001 at c1881.voiceflare.co.uk]
2012-11-19 04:24:34.664991 [DEBUG] switch_ivr.c:1742 (sofia/external/447866123456) State Change CS_EXCHANGE_MEDIA -> CS_ROUTING
2012-11-19 04:24:34.664991 [DEBUG] switch_core_session.c:1210 Send signal sofia/external/447866123456 [BREAK]
2012-11-19 04:24:34.664991 [DEBUG] switch_core_session.c:759 Send signal sofia/external/447866123456 [BREAK]
2012-11-19 04:24:34.664991 [NOTICE] switch_ivr.c:1748 Transfer sofia/external/447866123456 to XML[2001 at default]
send 646 bytes to udp/[82.30.159.182]:60585 at 04:24:34.665258:

   ------------------------------------------------------------------------
   SIP/2.0 202 Accepted
   Via: SIP/2.0/UDP 82.30.159.182:60585;branch=z9hG4bK-d8754z-da5faa120000ed7a-1---d8754z-;rport=60585
   From: "foxx"<sip:2000 at c1881.voiceflare.co.uk:5060>;tag=f5168a69
   To: <sip:07866123456 at c1881.voiceflare.co.uk:5060>;tag=1yN876FKm9cDK
   Call-ID: ZWZhYTdhODk2NDgxODU4MjM5OTYyYjVlMTk4NTEwYWI.
   CSeq: 3 REFER
   Contact: <sip:07866123456 at 89.238.182.137:5060;transport=udp>
   Expires: 60
   User-Agent: FreeSWITCH-mod_sofia/1.2.3
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, hold, conference, refer
   Content-Length: 0

   ------------------------------------------------------------------------
send 805 bytes to udp/[82.30.159.182]:60585 at 04:24:34.665421:
   ------------------------------------------------------------------------
   NOTIFY sip:2000 at 82.30.159.182:60585;rinstance=b0415b098f47701f SIP/2.0
   Via: SIP/2.0/UDP 89.238.182.137;rport;branch=z9hG4bKptDmyvN0cKKmr
   Max-Forwards: 70
   From: <sip:07866123456 at c1881.voiceflare.co.uk:5060>;tag=1yN876FKm9cDK
   To: "foxx" <sip:2000 at c1881.voiceflare.co.uk:5060>;tag=f5168a69
   Call-ID: ZWZhYTdhODk2NDgxODU4MjM5OTYyYjVlMTk4NTEwYWI.
   CSeq: 36313473 NOTIFY
   Contact: <sip:07866123456 at 89.238.182.137:5060;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.2.3
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
   Supported: timer, precondition, path, replaces
   Event: refer;id=3
   Allow-Events: talk, hold, conference, refer
   Subscription-State: terminated;reason=noresource
   Content-Type: message/sipfrag;version=2.0
   Content-Length: 16

   SIP/2.0 200 OK

   ------------------------------------------------------------------------
2012-11-19 04:24:34.685056 [DEBUG] switch_ivr_bridge.c:588 BRIDGE THREAD DONE [sofia/external/2000 at c1881.voiceflare.co.uk:5060]
2012-11-19 04:24:34.685056 [DEBUG] switch_ivr_bridge.c:613 Send signal sofia/external/447866123456 [BREAK]
2012-11-19 04:24:34.685056 [DEBUG] switch_ivr_bridge.c:588 BRIDGE THREAD DONE [sofia/external/447866123456]
2012-11-19 04:24:34.685056 [DEBUG] switch_ivr_bridge.c:613 Send signal sofia/external/2000 at c1881.voiceflare.co.uk:5060 [BREAK]
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:456 (sofia/external/447866123456) State EXCHANGE_MEDIA going to sleep
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:398 (sofia/external/447866123456) Running State Change CS_ROUTING
2012-11-19 04:24:34.685056 [DEBUG] switch_channel.c:1964 (sofia/external/447866123456) Callstate Change ACTIVE -> RINGING
2012-11-19 04:24:34.685056 [DEBUG] switch_core_session.c:759 Send signal sofia/external/447866123456 [BREAK]
2012-11-19 04:24:34.685056 [DEBUG] switch_core_session.c:759 Send signal sofia/external/2000 at c1881.voiceflare.co.uk:5060 [BREAK]
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:446 (sofia/external/447866123456) State ROUTING
2012-11-19 04:24:34.685056 [DEBUG] mod_sofia.c:149 sofia/external/447866123456 SOFIA ROUTING
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:117 sofia/external/447866123456 Standard ROUTING
2012-11-19 04:24:34.685056 [INFO] mod_dialplan_xml.c:485 Processing foxx <2000>->2001 in context default
2012-11-19 04:24:34.685056 [NOTICE] switch_core_state_machine.c:262 sofia/external/2000 at c1881.voiceflare.co.uk:5060 has executed the last dialplan instruction, hanging up.
2012-11-19 04:24:34.685056 [DEBUG] switch_channel.c:2950 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) Callstate Change HELD -> HANGUP
2012-11-19 04:24:34.685056 [NOTICE] switch_core_state_machine.c:264 Hangup sofia/external/2000 at c1881.voiceflare.co.uk:5060 [CS_EXECUTE] [NORMAL_CLEARING]
2012-11-19 04:24:34.685056 [DEBUG] switch_channel.c:2973 Send signal sofia/external/2000 at c1881.voiceflare.co.uk:5060 [KILL]
2012-11-19 04:24:34.685056 [DEBUG] switch_core_session.c:1210 Send signal sofia/external/2000 at c1881.voiceflare.co.uk:5060 [BREAK]
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:453 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) State EXECUTE going to sleep
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:398 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) Running State Change CS_HANGUP
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:638 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) State HANGUP
2012-11-19 04:24:34.685056 [DEBUG] mod_sofia.c:483 Channel sofia/external/2000 at c1881.voiceflare.co.uk:5060 hanging up, cause: NORMAL_CLEARING
2012-11-19 04:24:34.685056 [DEBUG] mod_sofia.c:532 Sending BYE to sofia/external/2000 at c1881.voiceflare.co.uk:5060
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:48 sofia/external/2000 at c1881.voiceflare.co.uk:5060 Standard HANGUP, cause: NORMAL_CLEARING
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:638 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) State HANGUP going to sleep
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:429 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) State Change CS_HANGUP -> CS_REPORTING
2012-11-19 04:24:34.685056 [DEBUG] switch_core_session.c:1210 Send signal sofia/external/2000 at c1881.voiceflare.co.uk:5060 [BREAK]
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:398 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) Running State Change CS_REPORTING
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:703 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) State REPORTING
2012-11-19 04:24:34.685056 [ERR] mod_xml_cdr.c:247 Error writing [/usr/local/freeswitch/log/xml_cdr/a_fb363230-3200-11e2-a468-bdc0bb753e98.cdr.xml][No such file or directory]
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:92 sofia/external/2000 at c1881.voiceflare.co.uk:5060 Standard REPORTING, cause: NORMAL_CLEARING
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:703 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) State REPORTING going to sleep
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:423 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) State Change CS_REPORTING -> CS_DESTROY
2012-11-19 04:24:34.685056 [DEBUG] switch_core_session.c:1210 Send signal sofia/external/2000 at c1881.voiceflare.co.uk:5060 [BREAK]
2012-11-19 04:24:34.685056 [DEBUG] switch_core_session.c:1415 Session 120 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) Locked, Waiting on external entities
2012-11-19 04:24:34.685056 [NOTICE] switch_core_session.c:1433 Session 120 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) Ended
2012-11-19 04:24:34.685056 [NOTICE] switch_core_session.c:1437 Close Channel sofia/external/2000 at c1881.voiceflare.co.uk:5060 [CS_DESTROY]
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:527 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) Callstate Change HANGUP -> DOWN
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:530 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) Running State Change CS_DESTROY
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:540 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) State DESTROY
2012-11-19 04:24:34.685056 [DEBUG] mod_sofia.c:376 sofia/external/2000 at c1881.voiceflare.co.uk:5060 SOFIA DESTROY
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:99 sofia/external/2000 at c1881.voiceflare.co.uk:5060 Standard DESTROY
2012-11-19 04:24:34.685056 [DEBUG] switch_core_state_machine.c:540 (sofia/external/2000 at c1881.voiceflare.co.uk:5060) State DESTROY going to sleep
recv 423 bytes from udp/[82.30.159.182]:60585 at 04:24:34.815422:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 89.238.182.137;rport=5060;branch=z9hG4bKptDmyvN0cKKmr
   Contact: <sip:2000 at 82.30.159.182:60585;rinstance=b0415b098f47701f>
   To: "foxx"<sip:2000 at c1881.voiceflare.co.uk:5060>;tag=f5168a69
   From: <sip:07866123456 at c1881.voiceflare.co.uk:5060>;tag=1yN876FKm9cDK
   Call-ID: ZWZhYTdhODk2NDgxODU4MjM5OTYyYjVlMTk4NTEwYWI.
   CSeq: 36313473 NOTIFY
   User-Agent: 3CXPhone 6.0.25732.0
   Content-Length: 0
   ------------------------------------------------------------------------
send 672 bytes to udp/[82.30.159.182]:60585 at 04:24:34.815653:
   ------------------------------------------------------------------------
   BYE sip:2000 at 82.30.159.182:60585;rinstance=b0415b098f47701f SIP/2.0
   Via: SIP/2.0/UDP 89.238.182.137;rport;branch=z9hG4bKQ36c0Q639U96K
   Max-Forwards: 70
   From: <sip:07866123456 at c1881.voiceflare.co.uk:5060>;tag=1yN876FKm9cDK
   To: "foxx" <sip:2000 at c1881.voiceflare.co.uk:5060>;tag=f5168a69
   Call-ID: ZWZhYTdhODk2NDgxODU4MjM5OTYyYjVlMTk4NTEwYWI.
   CSeq: 36313474 BYE
   Contact: <sip:07866123456 at 89.238.182.137:5060;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.2.3
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
   Supported: timer, precondition, path, replaces
   Reason: Q.850;cause=16;text="NORMAL_CLEARING"
   Content-Length: 0

   ------------------------------------------------------------------------
recv 501 bytes from udp/[82.30.159.182]:60585 at 04:24:34.815705:
   ------------------------------------------------------------------------
   BYE sip:07866123456 at 89.238.182.137:5060;transport=udp SIP/2.0
   Via: SIP/2.0/UDP 82.30.159.182:60585;branch=z9hG4bK-d8754z-cb28cb688f6de166-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:2000 at 82.30.159.182:60585;rinstance=b0415b098f47701f>
   To: <sip:07866123456 at c1881.voiceflare.co.uk:5060>;tag=1yN876FKm9cDK
   From: "foxx"<sip:2000 at c1881.voiceflare.co.uk:5060>;tag=f5168a69
   Call-ID: ZWZhYTdhODk2NDgxODU4MjM5OTYyYjVlMTk4NTEwYWI.
   CSeq: 5 BYE
   User-Agent: 3CXPhone 6.0.25732.0
   Content-Length: 0

   ------------------------------------------------------------------------
recv 420 bytes from udp/[82.30.159.182]:60585 at 04:24:34.942566:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 89.238.182.137;rport=5060;branch=z9hG4bKQ36c0Q639U96K
   Contact: <sip:2000 at 82.30.159.182:60585;rinstance=b0415b098f47701f>
   To: "foxx"<sip:2000 at c1881.voiceflare.co.uk:5060>;tag=f5168a69
   From: <sip:07866123456 at c1881.voiceflare.co.uk:5060>;tag=1yN876FKm9cDK
   Call-ID: ZWZhYTdhODk2NDgxODU4MjM5OTYyYjVlMTk4NTEwYWI.
   CSeq: 36313474 BYE
   User-Agent: 3CXPhone 6.0.25732.0
   Content-Length: 0

   ------------------------------------------------------------------------
send 340 bytes to udp/[82.30.159.182]:60585 at 04:24:34.942843:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 82.30.159.182:60585;branch=z9hG4bK-d8754z-cb28cb688f6de166-1---d8754z-;rport=60585
   From: "foxx"<sip:2000 at c1881.voiceflare.co.uk:5060>;tag=f5168a69
   To: <sip:07866123456 at c1881.voiceflare.co.uk:5060>;tag=1yN876FKm9cDK
   Call-ID: ZWZhYTdhODk2NDgxODU4MjM5OTYyYjVlMTk4NTEwYWI.
   CSeq: 5 BYE
   Content-Length: 0

   ------------------------------------------------------------------------
2012-11-19 04:24:34.944968 [ERR] mod_xml_curl.c:310 Received HTTP error 500 trying to fetch http://localhost:80/api/1.1/fscurl
data: [hostname=vded213&section=dialplan&tag_name=&key_name=&key_value=&Event-Name=REQUEST_PARAMS&Core-UUID=65606776-2ed1-11e2-92ce-bdc0bb753e98&FreeSWITCH-Hostname=vded213&FreeSWITCH-Switchname=vded213&FreeSWITCH-IPv
4=89.238.182.137&FreeSWITCH-IPv6=%3A%3A1&Event-Date-Local=2012-11-19%2004%3A24%3A34&Event-Date-GMT=Mon,%2019%20Nov%202012%2004%3A24%3A34%20GMT&Event-Date-Timestamp=1353299074685056&Event-Calling-File=mod_dialplan_xml.
c&Event-Calling-Function=dialplan_xml_locate&Event-Calling-Line-Number=456&Event-Sequence=54747&Channel-State=CS_ROUTING&Channel-Call-State=RINGING&Channel-State-Number=2&Channel-Name=sofia/external/447866123456&Uniqu
e-ID=fb3e0014-3200-11e2-a46e-bdc0bb753e98&Call-Direction=outbound&Presence-Call-Direction=outbound&Channel-HIT-Dialplan=false&Channel-Call-UUID=fb3e0014-3200-11e2-a46e-bdc0bb753e98&Answer-State=answered&Channel-Read-C
odec-Name=PCMA&Channel-Read-Codec-Rate=8000&Channel-Read-Codec-Bit-Rate=64000&Channel-Write-Codec-Name=PCMA&Channel-Write-Codec-Rate=8000&Channel-Write-Codec-Bit-Rate=64000&Caller-Direction=outbound&Caller-Username=20
00&Caller-Dialplan=XML&Caller-Caller-ID-Name=foxx&Caller-Caller-ID-Number=2000&Caller-Callee-ID-Name=Outbound%20Call&Caller-Callee-ID-Number=447866123456&Caller-Network-Addr=80.93.165.111&Caller-ANI=2000&Caller-Destin
ation-Number=2001&Caller-Unique-ID=fb3e0014-3200-11e2-a46e-bdc0bb753e98&Caller-Source=mod_sofia&Caller-Transfer-Source=1353299074%3A05b52eaa-3201-11e2-a474-bdc0bb753e98%3Abl_xfer%3A2001/default/XML&Caller-Context=default&Caller-RDNIS=447866123456&Caller-Channel-Name=sofia/external/447866123456&Caller-Profile-Index=2&Caller-Profile-Created-Time=1353299074664991&Caller-Channel-Created-Time=1353299057104964&Caller-Channel-Answered-Time=1353299065304972&Caller-Channel-Progress-Time=0&Caller-Channel-Progress-Media-Time=1353299061845008&Caller-Channel-Hangup-Time=0&Caller-Channel-Transfer-Time=0&Caller-Screen-Bit=true&Caller-Privacy-Hide-Name=false&Caller-Privacy-Hide-Number=false&variable_direction=outbound&variable_is_outbound=true&variable_uuid=fb3e0014-3200-11e2-a46e-bdc0bb753e98&variable_session_id=121&variable_sip_gateway_name=numbergroup&variable_sip_profile_name=gateway&variable_channel_name=sofia/external/447866123456&variable_sip_destination_url=sip%3A447866123456%40sip.numbergroup-services.com&variable_absolute_codec_string=PCMU%408000h%4020i%4064000b,PCMA%408000h%4020i%4064000b,GSM%408000h%4020i%4013200b&variable_originator_codec=PCMU%408000h%4020i%4064000b,PCMA%408000h%4020i%4064000b,GSM%408000h%4020i%4013200b&variable_originator=fb363230-3200-11e2-a468-bdc0bb753e98&variable_originate_early_media=true&variable_originating_leg_uuid=fb363230-3200-11e2-a468-bdc0bb753e98&variable_sip_local_sdp_str=v%3D0%0Ao%3DFreeSWITCH%201353266655%201353266656%20IN%20IP4%2089.238.182.137%0As%3DFreeSWITCH%0Ac%3DIN%20IP4%2089.238.182.137%0At%3D0%200%0Am%3Daudio%2032402%20RTP/AVP%200%208%203%20101%2013%0Aa%3Drtpmap%3A101%20telephone-event/8000%0Aa%3Dfmtp%3A101%200-16%0Aa%3Dptime%3A20%0Aa%3Dsendrecv%0A&variable_sip_outgoing_contact_uri=%3Csip%3Agw%2Bnumbergroup%4089.238.182.137%3A5060%3Btransport%3Dudp%3Bgw%3Dnumbergroup%3E&variable_sip_req_uri=447866123456%40sip.numbergroup-services.com&variable_sofia_profile_name=external&variable_recovery_profile_name=external&variable_sip_ph_P-Charging-Vector=icid-value%3Dfb4572a4-3200-11e2-89d6-99ec1789df65%3Bicid-generated-at%3D80.93.165.111%3Borig-ioi%3Dnumbergroup.com&variable_switch_r_sdp=v%3D0%0D%0Ao%3Dnumbergroup%201353252075%201353252076%20IN%20IP4%2080.93.165.111%0D%0As%3Dnumbergroup%0D%0Ac%3DIN%20IP4%2080.93.165.111%0D%0At%3D0%200%0D%0Am%3Daudio%2046986%20RTP/AVP%208%20101%2013%0D%0Aa%3Drtpmap%3A8%20PCMA/8000%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-16%0D%0Aa%3Drtpmap%3A13%20CN/8000%0D%0Aa%3Dptime%3A20%0D%0A&variable_ep_codec_string=PCMA%408000h%4020i%4064000b&variable_sip_audio_recv_pt=8&variable_sip_use_codec_name=PCMA&variable_sip_use_codec_rate=8000&variable_sip_use_codec_ptime=20&variable_read_codec=PCMA&variable_read_rate=8000&variable_write_codec=PCMA&variable_write_rate=8000&variable_local_media_ip=89.238.182.137&variable_local_media_port=32402&variable_advertised_media_ip=89.238.182.137&variable_sip_use_pt=8&variable_rtp_use_ssrc=3232801725&variable_sip_2833_send_payload=101&variable_sip_2833_recv_payload=101&variable_remote_media_ip=80.93.165.111&variable_remote_media_port=46986&variable_last_bridge_to=fb363230-3200-11e2-a468-bdc0bb753e98&variable_bridge_channel=sofia/external/2000%40c1881.voiceflare.co.uk%3A5060&variable_bridge_uuid=fb363230-3200-11e2-a468-bdc0bb753e98&variable_sip_local_network_addr=89.238.182.137&variable_sip_reply_host=80.93.165.111&variable_sip_reply_port=5060&variable_sip_network_ip=80.93.165.111&variable_sip_network_port=5060&variable_sip_user_agent=numbergroup.com&variable_sip_recover_contact=%3Csip%3A447866123456%4080.93.165.111%3A5060%3Btransport%3Dudp%3E&variable_sip_full_via=SIP/2.0/UDP%2089.238.182.137%3Brport%3D5060%3Bbranch%3Dz9hG4bKKZ19rB3NNrgvN&variable_sip_recover_via=SIP/2.0/UDP%2089.238.182.137%3Brport%3D5060%3Bbranch%3Dz9hG4bKKZ19rB3NNrgvN&variable_sip_from_display=foxx&variable_sip_full_from=%22foxx%22%20%3Csip%3A2000%4089.238.182.137%3E%3Btag%3D27e1910pHj3Ze&variable_sip_full_to=%3Csip%3A447866123456%40sip.numbergroup-services.com%3E%3Btag%3DrrSHS2S5ZeZ9g&variable_sip_from_user=2000&variable_sip_from_uri=2000%4089.238.182.137&variable_sip_from_host=89.238.182.137&variable_sip_to_user=447866123456&variable_sip_to_uri=447866123456%40sip.numbergroup-services.com&variable_sip_to_host=sip.numbergroup-services.com&variable_sip_contact_params=transport%3Dudp&variable_sip_contact_user=447866123456&variable_sip_contact_port=5060&variable_sip_contact_uri=447866123456%4080.93.165.111%3A5060&variable_sip_contact_host=80.93.165.111&variable_sip_to_tag=rrSHS2S5ZeZ9g&variable_sip_from_tag=27e1910pHj3Ze&variable_sip_cseq=36313465&variable_sip_call_id=d29c5ff4-aca3-1230-eead-000c299684b0&variable_endpoint_disposition=ANSWER&variable_last_sent_callee_id_name=foxx&variable_last_sent_callee_id_number=2000&variable_switch_m_sdp=v%3D0%0D%0Ao%3D3cxVCE%20215333835%2095945341%20IN%20IP4%2082.30.159.182%0D%0As%3D3cxVCE%20Audio%20Call%0D%0Ac%3DIN%20IP4%2082.30.159.182%0D%0At%3D0%200%0D%0Am%3Daudio%2040020%20RTP/AVP%200%208%203%20101%0D%0Aa%3Drtpmap%3A0%20PCMU/8000%0D%0Aa%3Drtpmap%3A8%20PCMA/8000%0D%0Aa%3Drtpmap%3A3%20GSM/8000%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-16%0D%0Aa%3Dsendonly%0D%0Aa%3Dptime%3A20%0D%0Am%3Dvideo%2040018%20RTP/AVP%2034%0D%0Ac%3DIN%20IP4%2082.30.159.182%0D%0Aa%3Drtpmap%3A34%20H263/90000%0D%0Aa%3Dfmtp%3A34%20QCIF%3D1%3BCIF%3D1%3BSQCIF%3D1%3BCIF4%3D1%0D%0A&variable_current_application=playback&variable_current_application_response=PLAYBACK%20ERROR&variable_sip_h_Referred-By=%22foxx%22%20%3Csip%3A2000%40c1881.voiceflare.co.uk%3A5060%3E&variable_sip_refer_to=%3Csip%3A2001%40c1881.voiceflare.co.uk%3A5060%3E&variable_max_forwards=68&variable_transfer_history=ARRAY%3A%3A1353299074%3A05b52eaa-3201-11e2-a474-bdc0bb753e98%3Abl_xfer%3A2001/default/XML&variable_transfer_source=1353299074%3A05b52eaa-3201-11e2-a474-bdc0bb753e98%3Abl_xfer%3A2001/default/XML&variable_call_uuid=fb3e0014-3200-11e2-a46e-bdc0bb753e98&Hunt-Direction=outbound&Hunt-Username=2000&Hunt-Dialplan=XML&Hunt-Caller-ID-Name=foxx&Hunt-Caller-ID-Number=2000&Hunt-Callee-ID-Name=Outbound%20Call&Hunt-Callee-ID-Number=447866123456&Hunt-Network-Addr=80.93.165.111&Hunt-ANI=2000&Hunt-Destination-Number=2001&Hunt-Unique-ID=fb3e0014-3200-11e2-a46e-bdc0bb753e98&Hunt-Source=mod_sofia&Hunt-Transfer-Source=1353299074%3A05b52eaa-3201-11e2-a474-bdc0bb753e98%3Abl_xfer%3A2001/default/XML&Hunt-Context=default&Hunt-RDNIS=447866123456&Hunt-Channel-Name=sofia/external/447866123456&Hunt-Profile-Index=2&Hunt-Profile-Created-Time=1353299074664991&Hunt-Channel-Created-Time=1353299057104964&Hunt-Channel-Answered-Time=1353299065304972&Hunt-Channel-Progress-Time=0&Hunt-Channel-Progress-Media-Time=1353299061845008&Hunt-Channel-Hangup-Time=0&Hunt-Channel-Transfer-Time=0&Hunt-Screen-Bit=true&Hunt-Privacy-Hide-Name=false&Hunt-Privacy-Hide-Number=false]
2012-11-19 04:24:34.944968 [ERR] mod_dialplan_xml.c:507 Open of dialplan failed

2012-11-19 04:24:34.944968 [INFO] switch_core_state_machine.c:192 No Route, Aborting
2012-11-19 04:24:34.944968 [DEBUG] switch_channel.c:2950 (sofia/external/447866123456) Callstate Change RINGING -> HANGUP
2012-11-19 04:24:34.944968 [NOTICE] switch_core_state_machine.c:193 Hangup sofia/external/447866123456 [CS_ROUTING] [NO_ROUTE_DESTINATION]
2012-11-19 04:24:34.944968 [DEBUG] switch_channel.c:2973 Send signal sofia/external/447866123456 [KILL]
2012-11-19 04:24:34.944968 [DEBUG] switch_core_session.c:1210 Send signal sofia/external/447866123456 [BREAK]
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:446 (sofia/external/447866123456) State ROUTING going to sleep
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:398 (sofia/external/447866123456) Running State Change CS_HANGUP
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:638 (sofia/external/447866123456) State HANGUP
2012-11-19 04:24:34.944968 [DEBUG] mod_sofia.c:483 Channel sofia/external/447866123456 hanging up, cause: NO_ROUTE_DESTINATION
2012-11-19 04:24:34.944968 [DEBUG] mod_sofia.c:532 Sending BYE to sofia/external/447866123456
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:48 sofia/external/447866123456 Standard HANGUP, cause: NO_ROUTE_DESTINATION
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:638 (sofia/external/447866123456) State HANGUP going to sleep
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:429 (sofia/external/447866123456) State Change CS_HANGUP -> CS_REPORTING
2012-11-19 04:24:34.944968 [DEBUG] switch_core_session.c:1210 Send signal sofia/external/447866123456 [BREAK]
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:398 (sofia/external/447866123456) Running State Change CS_REPORTING
send 988 bytes to udp/[80.93.165.111]:5060 at 04:24:34.946395:
   ------------------------------------------------------------------------
   BYE sip:447866123456 at 80.93.165.111:5060;transport=udp SIP/2.0
   Via: SIP/2.0/UDP 89.238.182.137;rport;branch=z9hG4bKrc051jQ764ZSF
   Max-Forwards: 70
   From: "foxx" <sip:2000 at 89.238.182.137>;tag=27e1910pHj3Ze
   To: <sip:447866123456 at sip.numbergroup-services.com>;tag=rrSHS2S5ZeZ9g
   Call-ID: d29c5ff4-aca3-1230-eead-000c299684b0
   CSeq: 36313467 BYE
   Contact: <sip:gw+numbergroup at 89.238.182.137:5060;transport=udp;gw=numbergroup>
   User-Agent: FreeSWITCH-mod_sofia/1.2.3
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
   Supported: timer, precondition, path, replaces
   Proxy-Authorization: ***STRIPPED***
   Reason: Q.850;cause=3;text="NO_ROUTE_DESTINATION"
   Content-Length: 0

   ------------------------------------------------------------------------
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:703 (sofia/external/447866123456) State REPORTING
2012-11-19 04:24:34.944968 [ERR] mod_xml_cdr.c:247 Error writing [/usr/local/freeswitch/log/xml_cdr/a_fb3e0014-3200-11e2-a46e-bdc0bb753e98.cdr.xml][No such file or directory]
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:92 sofia/external/447866123456 Standard REPORTING, cause: NO_ROUTE_DESTINATION
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:703 (sofia/external/447866123456) State REPORTING going to sleep
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:423 (sofia/external/447866123456) State Change CS_REPORTING -> CS_DESTROY
2012-11-19 04:24:34.944968 [DEBUG] switch_core_session.c:1210 Send signal sofia/external/447866123456 [BREAK]
2012-11-19 04:24:34.944968 [DEBUG] switch_core_session.c:1415 Session 121 (sofia/external/447866123456) Locked, Waiting on external entities
2012-11-19 04:24:34.944968 [NOTICE] switch_core_session.c:1433 Session 121 (sofia/external/447866123456) Ended
2012-11-19 04:24:34.944968 [NOTICE] switch_core_session.c:1437 Close Channel sofia/external/447866123456 [CS_DESTROY]
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:527 (sofia/external/447866123456) Callstate Change HANGUP -> DOWN
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:530 (sofia/external/447866123456) Running State Change CS_DESTROY
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:540 (sofia/external/447866123456) State DESTROY
2012-11-19 04:24:34.944968 [DEBUG] mod_sofia.c:376 sofia/external/447866123456 SOFIA DESTROY
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:99 sofia/external/447866123456 Standard DESTROY
2012-11-19 04:24:34.944968 [DEBUG] switch_core_state_machine.c:540 (sofia/external/447866123456) State DESTROY going to sleep
recv 472 bytes from udp/[80.93.165.111]:5060 at 04:24:34.971946:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 89.238.182.137;rport=5060;branch=z9hG4bKrc051jQ764ZSF
   From: "foxx" <sip:2000 at 89.238.182.137>;tag=27e1910pHj3Ze
   To: <sip:447866123456 at sip.numbergroup-services.com>;tag=rrSHS2S5ZeZ9g
   Call-ID: d29c5ff4-aca3-1230-eead-000c299684b0
   CSeq: 36313467 BYE
   User-Agent: numbergroup.com
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
   Supported: timer, precondition, path, replaces
   Content-Length: 0

   ------------------------------------------------------------------------