Outbound problem

Version 1
    This document was generated from CDN thread

    Created by: ahm gawad on 24-09-2010 01:08:47 PM
    HI ALL;
     
    I am using cvp outbound scripts from developer download section
     
    the problem is the cvp_dialer allways return "dialer response invalid"
     
    My GateWay is : 2811 and the same scripts is working well on another gateway 2821
     
    THE output:
     
    *Sep 24 13:48:04.729: //32462//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 32464
    *Sep 24 13:48:06.613: //32462//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 32464
    *Sep 24 13:48:16.705: //32462//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 32464
    *Sep 24 13:48:16.709: //32462//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXXX established
    *Sep 24 13:48:16.753: //32463//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 24 13:48:16.841: //32462//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
     
    Thanks for your time.

    Subject: RE: Outbound problem
    Replied by: Yaw-Ming Chen on 24-09-2010 04:33:27 PM
    Message is coming from cvp_obcallreq.tcl
     
    It's just follows the logic, looks like  cannot get one of the following:
     
     
     
    proc dialer_response { } {
        global call_leg

        if {[infotag get evt_gtd gtd_fac] &&
            [infotag get gtd_attr_exists gtd_fac uus.1]} {

            set outcome [binary format H* [object get gtd gtd_fac uus.1.dat]]
            puts -nonewline "******* CVP_OBCALLREQ: dialer call outcome: $outcome"

        } else {
            puts -nonewline "******* CVP_OBCALLREQ: dialer response invalid"
            set outcome "dialer_resp_invalid"
        }

        timer stop named_timer dialer_resp_timeout
        handoff return $call_leg -s $outcome
    }

    Subject: RE: Outbound problem
    Replied by: ahm gawad on 24-09-2010 10:27:26 PM
    That is right  But why obcallreq always return dialer respone invalid Although the dialer create avalid GTD object and append avalid data to it and i have checked it

    Subject: RE: Outbound problem
    Replied by: Yaw-Ming Chen on 24-09-2010 11:26:02 PM
    Collect deb voip app tcl as well so can look into more detail.
    Also since is is the cause by standard CVP tcl script so Cisco TAC should be able to help as well.
     
    Thanks !

    Subject: RE: Outbound problem
    Replied by: ahm gawad on 25-09-2010 12:57:58 AM
    *Sep 25 00:57:18.386: //32918//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to 012345678 established
    *Sep 25 00:57:18.386: //32918//TCL :/tcl_ObjectObjCmd:  object create gtd gtd_inf INF
    *Sep 25 00:57:18.386: //-1//TCL :/tcl_CreateObjCmd: 
    *Sep 25 00:57:18.386: //-1//AFW_:/tcl_CreateGtdObjCmd:  gtd gtd_inf INF
    *Sep 25 00:57:18.390: //32918//TCL :/tcl_ObjectObjCmd:  object append gtd gtd_inf uus.1.dat 636f6e6e6563746564
    *Sep 25 00:57:18.390: //-1//AFW_:/tcl_AppendGtdObjCmd:  gtd gtd_inf uus.1.dat 636f6e6e6563746564
    *Sep 25 00:57:18.390: //-1//AFW_:/tcl_modifyAttrGtdCmd:  gtd_inf uus.1.dat 636f6e6e6563746564
    *Sep 25 00:57:18.390: //-1//AFW_:/tcl_parseGtdSpec:  uus.1.dat 636f6e6e6563746564
    *Sep 25 00:57:18.390: //-1//AFW_:/tcl_gtdDoModifyAttrFromSpec: 
    *Sep 25 00:57:18.390: //-1//AFW_:/tcl_gtdDoModifyAttrFromSpecPost: 
    *Sep 25 00:57:18.390: //-1//AFW_:/tcl_gtdDoModifyOneAttrPost: gtd_put_parm_field gtd_buf=0x47BD9AC0 gtd_size=64 gtd_len=8 acto staion=2(APPEND) arg_count=1 format=0(FORMAT_SHORT)
    *Sep 25 00:57:18.390: parm_name=UUS field_name=dat instance=1 field_value=636f6e6e6563746564
    *Sep 25 00:57:18.390: //-1//AFW_:/tcl_gtdDoModifyOneAttrPost: gtd_put_parm_field gtd_status=0(SUCCESS) gtd_len=33
    *Sep 25 00:57:18.390: //-1//AFW_:/tcl_performOpsOnQueuedAttr: 
    *Sep 25 00:57:18.390: //32918//TCL :/tcl_LegObjCmd:  leg facility 32918 -g gtd_inf
    *Sep 25 00:57:18.390: //32918//TCL :/tcl_LegFacilityObjCmd: facility 32918 -g gtd_inf
    *Sep 25 00:57:18.390: //32918//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 00:57:18.434: //32920//TCL :/tcl_InfotagObjCmd:  infotag get evt_gtd gtd_fac
    *Sep 25 00:57:18.434: //32920//TCL :/tcl_InfotagGetObjCmd: infotag get evt_gtd gtd_fac
    *Sep 25 00:57:18.434: //32920//AFW_:/vtr_ev_gtd_object: argc 3 argindex 2 get evt_gtd gtd_fac
    *Sep 25 00:57:18.434: //32920//AFW_:/vtr_ev_gtd_object: cc_ev->e.event_id 15
    *Sep 25 00:57:18.438: //32920//AFW_:/vtr_ev_gtd_object: Unable to create a GTD object entry
    *Sep 25 00:57:18.438: //32920//TCL :rt/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid

    Subject: RE: Outbound problem
    Replied by: Yaw-Ming Chen on 25-09-2010 03:33:55 AM
    *Sep 25 00:57:18.438: //32920//AFW_:/vtr_ev_gtd_object: Unable to create a GTD object entry
     
    This might be the clue.
     
    Thanks !

    Subject: RE: Outbound problem
    Replied by: Yaw-Ming Chen on 26-09-2010 05:43:40 AM
    My suggestion is that contact Cisco TAC since this is standard CVP script, TAC will supoort it. You can post this question in CVP forum as well.
    My opinion is that there is not thing wrong with script.There are too many errors in the script output that you need to ask CVP support why ?
     
    For example :
    "call to poll CVP VXML outbound application failed, status ls_003 " that is  from setuping a call to destination
     
    "ls_003 --  The call setup failed because of a lack of resources in the network"  -- is not a common error for setup failure.
     
    Just like you said this might have something to do with setup, configuration.
     
    Thanks !

    Subject: RE: Outbound problem
    Replied by: ahm gawad on 25-09-2010 01:07:36 PM
    Does this problem related to hardware resources or  call configuration  ?

    Subject: RE: Outbound problem
    Replied by: ahm gawad on 25-09-2010 02:26:18 PM
    HERE IS THE COMPLETE DUMP :
     
    28:00.899: //141//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:28:00.923: //141//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 143
    *Sep 25 14:28:02.747: //141//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 143
    *Sep 25 14:28:12.975: //141//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 143
    *Sep 25 14:28:12.975: //141//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:28:13.019: //142//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:28:13.107: //141//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:28:30.899: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:28:30.931: //146//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=0116899EC7E811DF81C2A81FC4E601AD ******** CallID = 0116899EC7E811DF81C2A81FC4E601AD
    *Sep 25 14:28:30.955: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:28:31.131: //146//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:28:31.135: //146//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:28:31.143: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:28:31.151: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:28:31.151: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:28:31.155: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:28:31.155: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:28:31.155: //145//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:28:31.175: //145//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 147
    *Sep 25 14:28:33.131: //145//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 147
    *Sep 25 14:28:43.287: //145//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 147
    *Sep 25 14:28:43.287: //145//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:28:43.331: //146//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:28:43.419: //145//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:29:01.155: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:29:01.187: //150//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=131F3DFDC7E811DF81CEA81FC4E601AD ******** CallID = 131F3DFDC7E811DF81CEA81FC4E601AD
    *Sep 25 14:29:01.211: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:29:01.383: //150//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:29:01.387: //150//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:29:01.395: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:29:01.403: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:29:01.403: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:29:01.407: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:29:01.407: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:29:01.411: //149//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:29:01.431: //149//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 151
    *Sep 25 14:29:03.263: //149//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 151
    *Sep 25 14:29:13.259: //149//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 151
    *Sep 25 14:29:13.259: //149//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:29:13.303: //150//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:29:13.391: //149//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:29:31.407: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:29:31.439: //154//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=25275430C7E811DF81DAA81FC4E601AD ******** CallID = 25275430C7E811DF81DAA81FC4E601AD
    *Sep 25 14:29:31.459: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:29:31.639: //154//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:29:31.643: //154//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:29:31.651: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:29:31.655: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:29:31.659: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:29:31.663: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:29:31.663: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:29:31.663: //153//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:29:31.683: //153//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 155
    *Sep 25 14:29:33.583: //153//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 155
    *Sep 25 14:29:43.759: //153//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 155
    *Sep 25 14:29:43.763: //153//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:29:43.803: //154//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:29:46.279: //153//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:30:01.663: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:30:01.695: //158//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=3730068BC7E811DF81E6A81FC4E601AD ******** CallID = 3730068BC7E811DF81E6A81FC4E601AD
    *Sep 25 14:30:01.719: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:30:01.895: //158//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:30:01.899: //158//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:30:01.907: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:30:01.911: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:30:01.915: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:30:01.919: //157//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:30:01.927: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:30:01.927: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:30:01.939: //157//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 159
    *Sep 25 14:30:03.835: //157//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 159
    *Sep 25 14:30:13.903: //157//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 159
    *Sep 25 14:30:13.903: //157//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:30:13.947: //158//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:30:14.035: //157//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:30:31.927: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:30:31.955: //162//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=4939F1CEC7E811DF81F2A81FC4E601AD ******** CallID = 4939F1CEC7E811DF81F2A81FC4E601AD
    *Sep 25 14:30:31.983: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:30:32.159: //162//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:30:32.159: //162//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:30:32.171: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:30:32.175: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:30:32.179: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:30:32.179: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:30:32.179: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:30:32.183: //161//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:30:32.203: //161//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 163
    *Sep 25 14:30:34.111: //161//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 163
    *Sep 25 14:30:44.091: //161//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 163
    *Sep 25 14:30:44.095: //161//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:30:44.135: //162//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:30:44.223: //161//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:31:02.179: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:31:02.207: //166//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=5B420A06C7E811DF81FEA81FC4E601AD ******** CallID = 5B420A06C7E811DF81FEA81FC4E601AD
    *Sep 25 14:31:02.235: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:31:02.411: //166//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:31:02.415: //166//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:31:02.423: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:31:02.427: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:31:02.431: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:31:02.431: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:31:02.431: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:31:02.435: //165//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:31:02.455: //165//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 167
    *Sep 25 14:31:04.307: //165//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 167
    *Sep 25 14:31:14.331: //165//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 167
    *Sep 25 14:31:14.335: //165//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:31:14.375: //166//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:31:14.463: //165//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:31:32.431: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:31:32.459: //170//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=6D4A1FA0C7E811DF820AA81FC4E601AD ******** CallID = 6D4A1FA0C7E811DF820AA81FC4E601AD
    *Sep 25 14:31:32.487: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:31:32.663: //170//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:31:32.667: //170//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:31:32.675: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:31:32.679: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:31:32.683: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:31:32.687: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:31:32.687: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:31:32.687: //169//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:31:32.707: //169//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 171
    *Sep 25 14:31:34.507: //169//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 171
    *Sep 25 14:31:44.595: //169//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 171
    *Sep 25 14:31:44.599: //169//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:31:44.643: //170//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:31:47.043: //169//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:32:02.687: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:32:02.715: //174//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=7F52D293C7E811DF8216A81FC4E601AD ******** CallID = 7F52D293C7E811DF8216A81FC4E601AD
    *Sep 25 14:32:02.743: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:32:02.919: //174//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:32:02.919: //174//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:32:02.931: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:32:02.935: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:32:02.939: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:32:02.939: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:32:02.939: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:32:02.943: //173//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:32:02.963: //173//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 175
    *Sep 25 14:32:04.895: //173//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 175
    *Sep 25 14:32:14.855: //173//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 175
    *Sep 25 14:32:14.855: //173//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:32:14.899: //174//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:32:14.999: //173//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:32:32.939: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:32:32.975: //178//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=915AE8C6C7E811DF8222A81FC4E601AD ******** CallID = 915AE8C6C7E811DF8222A81FC4E601AD
    *Sep 25 14:32:32.991: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:32:33.191: //178//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:32:33.191: //178//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:32:33.203: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:32:33.207: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:32:33.211: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:32:33.211: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:32:33.211: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:32:33.215: //177//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:32:33.235: //177//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 179
    *Sep 25 14:32:35.231: //177//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 179
    *Sep 25 14:32:45.411: //177//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 179
    *Sep 25 14:32:45.415: //177//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:32:45.455: //178//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:32:45.543: //177//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:33:03.211: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:33:03.239: //182//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=A3660DC5C7E811DF822EA81FC4E601AD ******** CallID = A3660DC5C7E811DF822EA81FC4E601AD
    *Sep 25 14:33:03.267: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:33:05.475: //182//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:33:05.479: //182//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:33:05.487: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:33:05.491: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:33:05.495: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:33:05.495: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:33:05.499: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:33:05.499: //181//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:33:05.519: //181//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 183
    *Sep 25 14:33:07.443: //181//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 183
    *Sep 25 14:33:17.423: //181//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 183
    *Sep 25 14:33:17.427: //181//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:33:17.471: //182//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:33:17.559: //181//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:33:35.499: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:33:35.527: //186//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=B6A4CEF8C7E811DF823AA81FC4E601AD ******** CallID = B6A4CEF8C7E811DF823AA81FC4E601AD
    *Sep 25 14:33:35.555: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:33:35.727: //186//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:33:35.731: //186//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:33:35.739: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:33:35.743: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:33:35.747: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:33:35.751: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:33:35.751: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:33:35.751: //185//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:33:35.771: //185//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 187
    *Sep 25 14:33:37.607: //185//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 187
    *Sep 25 14:33:47.663: //185//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 187
    *Sep 25 14:33:47.667: //185//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:33:47.707: //186//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:33:47.795: //185//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:34:05.751: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:34:05.779: //190//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=C8ACE52BC7E811DF8246A81FC4E601AD ******** CallID = C8ACE52BC7E811DF8246A81FC4E601AD
    *Sep 25 14:34:05.807: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:34:05.983: //190//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:34:05.987: //190//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:34:05.995: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:34:05.999: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:34:06.003: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:34:06.003: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:34:06.007: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:34:06.007: //189//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:34:06.027: //189//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 191
    *Sep 25 14:34:07.843: //189//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 191
    *Sep 25 14:34:17.983: //189//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 191
    *Sep 25 14:34:17.983: //189//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:34:18.027: //190//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:34:18.115: //189//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:34:36.007: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:34:36.035: //194//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=DAB5998BC7E811DF8252A81FC4E601AD ******** CallID = DAB5998BC7E811DF8252A81FC4E601AD
    *Sep 25 14:34:36.063: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:34:36.239: //194//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:34:36.239: //194//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:34:36.251: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:34:36.255: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:34:36.259: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:34:36.259: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:34:36.259: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:34:36.263: //193//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:34:36.283: //193//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 195
    *Sep 25 14:34:38.159: //193//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 195
    *Sep 25 14:34:48.259: //193//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 195
    *Sep 25 14:34:48.263: //193//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:34:48.307: //194//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:34:48.391: //193//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:35:06.259: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:35:06.295: //198//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=ECBDAFBDC7E811DF825EA81FC4E601AD ******** CallID = ECBDAFBDC7E811DF825EA81FC4E601AD
    *Sep 25 14:35:06.311: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:35:06.491: //198//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:35:06.495: //198//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:35:06.503: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:35:06.511: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:35:06.511: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:35:06.515: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:35:06.515: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:35:06.515: //197//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:35:06.535: //197//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 199
    *Sep 25 14:35:08.295: //197//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 199
    *Sep 25 14:35:18.479: //197//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 199
    *Sep 25 14:35:18.483: //197//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:35:18.523: //198//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:35:18.611: //197//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    % Type "debug ?" for a list of subcommands
    CCODAUSVG#
    CCODAUSVG#
    CCODAUSVG#
    CCODAUSVG#debug v
    *Sep 25 14:35:36.515: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:35:36.543: //202//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=FEC66218C7E811DF826AA81FC4E601AD ******** CallID = FEC66218C7E811DF826AA81FC4E601AD
    *Sep 25 14:35:36.571: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:35:36.747: //202//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:35:36.751: //202//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: sent dialer record to CVP_OUTBOUND.TCL, waiting for call outcome ...
    *Sep 25 14:35:36.759: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: facility GTD report containing dialer record
    *Sep 25 14:35:36.763: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:35:36.767: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000
    oice
    *Sep 25 14:35:36.767: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:35:36.767: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:35:36.771: //201//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:35:36.791: //201//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 203apl
    *Sep 25 14:35:38.683: //201//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 20pli
    CCODAUSVG#debug voice application t
    CCODAUSVG#debug voice application tclcommands
    CCODAUSVG#debug voice application tclcommands
    CCODAUSVG#debug voice application tclcommands
    *Sep 25 14:35:48.859: //201//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 203
    *Sep 25 14:35:48.863: //201//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:35:48.903: //202//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:35:48.991: //201//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received?
      <cr>

    CCODAUSVG#debug voice application tclcommands
    voip application tcl commands debugging is on
    CCODAUSVG#
    *Sep 25 14:36:06.767: //-1//TCL :EE46DEE9D4000:/tcl_InfotagObjCmd:  infotag set evt_facility_report gtd
    *Sep 25 14:36:06.767: //-1//TCL :EE46DEE9D4000:/tcl_InfotagSetObjCmd: infotag set evt_facility_report gtd
    *Sep 25 14:36:06.767: //-1//AFW_:EE46DEE9D4000:/vtw_ev_facility_report: 
    *Sep 25 14:36:06.767: //-1//AFW_:EE46DEE9D4000:/vtw_ev_facility_report: reportFacilityBitmap=0x1
    *Sep 25 14:36:06.767: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:36:06.767: //-1//TCL :EE46DEE9D4000:/tcl_LegObjCmd:  leg setup 7788000 callinfo
    *Sep 25 14:36:06.771: //-1//TCL :EE46DEE9D4000:/tcl_FSMObjCmd:  fsm setstate POLLING_VXML
    *Sep 25 14:36:06.771: //-1//TCL :EE46DEE9D4000:/tcl_FSMSetStateObjCmd: setstate setstate POLLING_VXML
    *Sep 25 14:36:06.799: //206//TCL :/tcl_LegObjCmd:  leg setupack leg_incoming
    *Sep 25 14:36:06.799: //206//TCL :/tcl_LegSetupAckObjCmd: setupack leg_incoming
    *Sep 25 14:36:06.799: //206//AFW_:/vtd_lg_incoming: argc 2
    *Sep 25 14:36:06.799: //206//AFW_:/vtd_lg_incoming: Legs [206 ]
    *Sep 25 14:36:06.799: //206//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 14:36:06.799: //206//TCL :/tcl_LegObjCmd:  leg proceeding leg_incoming
    *Sep 25 14:36:06.799: //206//TCL :/tcl_LegProceedObjCmd: proceeding leg_incoming
    *Sep 25 14:36:06.799: //206//AFW_:/vtd_lg_incoming: argc 2
    *Sep 25 14:36:06.799: //206//AFW_:/vtd_lg_incoming: Legs [206 ]
    *Sep 25 14:36:06.799: //206//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 14:36:06.799: //206//TCL :/tcl_LegObjCmd:  leg alert leg_incoming
    *Sep 25 14:36:06.799: //206//TCL :/tcl_LegAlertObjCmd: alert leg_incoming
    *Sep 25 14:36:06.799: //206//AFW_:/vtd_lg_incoming: argc 2
    *Sep 25 14:36:06.799: //206//AFW_:/vtd_lg_incoming: Legs [206 ]
    *Sep 25 14:36:06.799: //206//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 14:36:06.799: //206//TCL :/tcl_LegObjCmd:  leg connect leg_incoming
    *Sep 25 14:36:06.799: //206//TCL :/tcl_LegConnectObjCmd: connect leg_incoming
    *Sep 25 14:36:06.799: //206//AFW_:/vtd_lg_incoming: argc 2
    *Sep 25 14:36:06.799: //206//AFW_:/vtd_lg_incoming: Legs [206 ]
    *Sep 25 14:36:06.799: //206//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 14:36:06.803: //206//TCL :/tcl_InfotagObjCmd:  infotag get leg_ani
    *Sep 25 14:36:06.803: //206//TCL :/tcl_InfotagGetObjCmd: infotag get leg_ani
    *Sep 25 14:36:06.803: //206//AFW_:/vtr_lg_ani: argc 2 argindex 2
    *Sep 25 14:36:06.803: //206//TCL :/tcl_InfotagObjCmd:  infotag get leg_dnis
    *Sep 25 14:36:06.803: //206//TCL :/tcl_InfotagGetObjCmd: infotag get leg_dnis
    *Sep 25 14:36:06.803: //206//AFW_:/vtr_lg_dnis: argc 2 argindex 2
    *Sep 25 14:36:06.803: //206//TCL :/tcl_InfotagObjCmd:  infotag get leg_guid
    *Sep 25 14:36:06.803: //206//TCL :/tcl_InfotagGetObjCmd: infotag get leg_guid
    *Sep 25 14:36:06.803: //206//AFW_:/vtr_lg_guid: argc 2 argindex 2
    *Sep 25 14:36:06.803: //206//TCL :/tcl_PutsObjCmd:
    TCL CVP: ******* Call arrived with ANI=sip:10.1.11.30, DNIS-OVERRIDE=, CALLID=10CE784BC7E911DF8276A81FC4E601AD ******** CallID = 10CE784BC7E911DF8276A81FC4E601AD
    *Sep 25 14:36:06.811: //206//TCL :/tcl_HandoffObjCmd:  handoff appl leg_incoming CVPSelfService CALLID=10CE784BC7E911DF8276A81FC4E601AD|APP=outboundTest|PORT=7000|PRIMARY=10.1.11.25|BACKUP=UNKNOWN|survive=UNDEFINED|PROTOCOL=http|var1=
    *Sep 25 14:36:06.815: //206//TCL :/tcl_handoff_common: appl leg_incoming CVPSelfService CALLID=10CE784BC7E911DF8276A81FC4E601AD|APP=outboundTest|PORT=7000|PRIMARY=10.1.11.25|BACKUP=UNKNOWN|survive=UNDEFINED|PROTOCOL=http|var1=
    *Sep 25 14:36:06.815: //206//AFW_:/vtd_lg_incoming: argc 4
    *Sep 25 14:36:06.815: //206//AFW_:/vtd_lg_incoming: Legs [206 ]
    *Sep 25 14:36:06.815: //206//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 14:36:06.815: //206//TCL :/tcl_handoff_common: Handing off Legs [206 ] to CVPSelfService with args=CALLID=10CE784BC7E911DF8276A81FC4E601AD|APP=outboundTest|PORT=7000|PRIMARY=10.1.11.25|BACKUP=UNKNOWN|survive=UNDEFINED|PROTOCOL=http|var1=
    *Sep 25 14:36:06.831: //-1//TCL :EE46DEE9D4000:/tcl_InfotagObjCmd:  infotag get evt_status
    *Sep 25 14:36:06.831: //-1//TCL :EE46DEE9D4000:/tcl_InfotagGetObjCmd: infotag get evt_status
    *Sep 25 14:36:06.831: //-1//AFW_:EE46DEE9D4000:/vtr_ev_status: argc 2 argindex 2
    *Sep 25 14:36:06.831: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: call to poll CVP VXML outbound application established
    *Sep 25 14:36:07.007: //206//TCL :/tcl_InfotagObjCmd:  infotag get evt_legs
    *Sep 25 14:36:07.007: //206//TCL :/tcl_InfotagGetObjCmd: infotag get evt_legs
    *Sep 25 14:36:07.011: //206//AFW_:/vtr_ev_legs: argc 2
    *Sep 25 14:36:07.011: //206//AFW_:/vtr_ev_legs: EV_LEGS []
    *Sep 25 14:36:07.011: //206//TCL :/tcl_InfotagObjCmd:  infotag get evt_handoff argstring
    *Sep 25 14:36:07.011: //206//TCL :/tcl_InfotagGetObjCmd: infotag get evt_handoff argstring
    *Sep 25 14:36:07.011: //206//AFW_:/vtr_ev_handoff: argc 3 argindex 2
    *Sep 25 14:36:07.011: //206//AFW_:/vtr_ev_handoff: event=CC_EV_CALL_HANDOFF, string=dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info"
    *Sep 25 14:36:07.011: //206//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:36:07.011: //206//TCL :/tcl_ObjectObjCmd:  object create gtd gtd_inf INF
    *Sep 25 14:36:07.011: //-1//TCL :/tcl_CreateObjCmd: 
    *Sep 25 14:36:07.011: //-1//AFW_:/tcl_CreateGtdObjCmd:  gtd gtd_inf INF
    *Sep 25 14:36:07.011: //206//TCL :/tcl_ObjectObjCmd:  object append gtd gtd_inf uus.1.dat 646e69733d3032363234323139383420636c693d3830303535353132313220726e613d33302069643d31323334207575693d2275756920696e666f22
    *Sep 25 14:36:07.011: //-1//AFW_:/tcl_AppendGtdObjCmd:  gtd gtd_inf uus.1.dat 646e69733d3032363234323139383420636c693d3830303535353132313220726e613d33302069643d31323334207575693d2275756920696e666f22
    *Sep 25 14:36:07.011: //-1//AFW_:/tcl_modifyAttrGtdCmd:  gtd_inf uus.1.dat 646e69733d3032363234323139383420636c693d3830303535353132313220726e613d33302069643d31323334207575693d2275756920696e666f22
    *Sep 25 14:36:07.011: //-1//AFW_:/tcl_parseGtdSpec:  uus.1.dat 646e69733d3032363234323139383420636c693d3830303535353132313220726e613d33302069643d31323334207575693d2275756920696e666f22
    *Sep 25 14:36:07.015: //-1//AFW_:/tcl_gtdDoModifyAttrFromSpec: 
    *Sep 25 14:36:07.015: //-1//AFW_:/tcl_gtdDoModifyAttrFromSpecPost: 
    *Sep 25 14:36:07.015: //-1//AFW_:/tcl_gtdDoModifyOneAttrPost: gtd_put_parm_field gtd_buf=0x47F7BE18 gtd_size=64 gtd_len=8 action=2(APPEND) arg_count=1 format=0(FORMAT_SHORT)
    *Sep 25 14:36:07.015: parm_name=UUS field_name=dat instance=1 field_value=646e69733d3032363234323139383420636c693d3830303535353132313220726e613d33302069643d31323334207575693d2275756920696e666f22
    *Sep 25 14:36:07.015: //-1//AFW_:/tcl_gtdDoModifyOneAttrPost: gtd_put_parm_field gtd_status=4(MSGBUF_SMALL) gtd_len=8
    *Sep 25 14:36:07.015: gtd_put_parm_field *** Error: UUS.1.dat.GTD_STATUS_MSGBUF_SMALL
    *Sep 25 14:36:07.015: //-1//AFW_:/tcl_gtdDoModifyOneAttrPost: gtd_put_parm_field gtd_buf=0x4650B1D0 gtd_size=128 gtd_len=8 action=2(APPEND) arg_count=1 format=0(FORMAT_SHORT)


    *Sep 25 14:36:07.031: //-1//AFW_:/TclObjGtdAttrExists: gtd_get_parms return status 0 (SUCCESS)
    *Sep 25 14:36:07.031: //-1//TCL :EE46DEE9D4000:/tcl_ObjectObjCmd:  object get gtd gtd_fac uus.1.dat
    *Sep 25 14:36:07.031: //-1//AFW_:/tcl_GetGtdObjCmd:  gtd gtd_fac uus.1.dat
    *Sep 25 14:36:07.031: //-1//AFW_:/tcl_parseGtdSpec:  uus.1.dat
    *Sep 25 14:36:07.031: //-1//AFW_:/tcl_gtdDoGetAttrFromSpec: 
    *Sep 25 14:36:07.031: //-1//AFW_:/tcl_gtdDoGetOneAttr: gtd_get_parm_field gtd_buf=0x461ED710 gtd_len=135 arg_count=1
    *Sep 25 14:36:07.031: parm_name=UUS field_name=dat instance=1 len_value=256
    *Sep 25 14:36:07.031: //-1//AFW_:/tcl_gtdDoGetOneAttr: gtd_get_parm_field gtd_buf=0x461ED710 gtd_status=0(SUCCESS)
    *Sep 25 14:36:07.031: parm_name=UUS field_name=dat instance=1 o_length=120 field_value=646e69733d3032363234323139383420636c693d3830303535353132313220726e613d33302069643d31323334207575693d2275756920696e666f22
    *Sep 25 14:36:07.035: //-1//TCL :EE46DEE9D4000:/tcl_HandoffObjCmd:  handoff appl leg_outgoing cvp_dialer dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info"
    *Sep 25 14:36:07.035: //-1//TCL :EE46DEE9D4000:/tcl_handoff_common: appl leg_outgoing cvp_dialer dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info"
    *Sep 25 14:36:07.035: //-1//AFW_:EE46DEE9D4000:/vtd_lg_outgoing: argc 4
    *Sep 25 14:36:07.035: //-1//AFW_:EE46DEE9D4000:/vtd_lg_outgoing: Legs [205 ]
    *Sep 25 14:36:07.035: //-1//Tcl :EE46DEE9D4000:/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 14:36:07.035: //-1//TCL :EE46DEE9D4000:/tcl_handoff_common: Handing off Legs [205 ] to cvp_dialer with args=dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info"
    *Sep 25 14:36:07.039: //-1//TCL :EE46DEE9D4000:/tcl_InfotagObjCmd:  infotag set evt_facility_report gtd
    *Sep 25 14:36:07.039: //-1//TCL :EE46DEE9D4000:/tcl_InfotagSetObjCmd: infotag set evt_facility_report gtd
    *Sep 25 14:36:07.039: //-1//AFW_:EE46DEE9D4000:/vtw_ev_facility_report: 
    *Sep 25 14:36:07.039: //-1//AFW_:EE46DEE9D4000:/vtw_ev_facility_report: reportFacilityBitmap=0x1
    *Sep 25 14:36:07.039: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: making call to poll CVP VXML application at <7788000>
    *Sep 25 14:36:07.039: //-1//TCL :EE46DEE9D4000:/tcl_LegObjCmd:  leg setup 7788000 callinfo
    *Sep 25 14:36:07.043: %CALL_CONTROL-6-MAX_CONNECTIONS: Maximum number of connections reached for dial-peer 7780000

    *Sep 25 14:36:07.043: //-1//TCL :EE46DEE9D4000:/tcl_FSMObjCmd:  fsm setstate POLLING_VXML
    *Sep 25 14:36:07.043: //-1//TCL :EE46DEE9D4000:/tcl_FSMSetStateObjCmd: setstate setstate POLLING_VXML
    *Sep 25 14:36:07.043: //-1//TCL :EE46DEE9D4000:/tcl_InfotagObjCmd:  infotag get evt_status
    *Sep 25 14:36:07.043: //-1//TCL :EE46DEE9D4000:/tcl_InfotagGetObjCmd: infotag get evt_status
    *Sep 25 14:36:07.043: //-1//AFW_:EE46DEE9D4000:/vtr_ev_status: argc 2 argindex 2
    *Sep 25 14:36:07.043: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: ERROR: call to poll CVP VXML outbound application failed, status ls_003
    *Sep 25 14:36:07.043: //-1//TCL :EE46DEE9D4000:/tcl_PutsObjCmd: ******* CVP_OUTBOUND: started poll timer
    *Sep 25 14:36:07.043: //-1//TCL :EE46DEE9D4000:/tcl_TimerObjCmd:  timer start named_timer 30 pollwait
    *Sep 25 14:36:07.047: //-1//TCL :EE46DEE9D4000:/tcl_TimerStartObjCmd: timer start named_timer 30 pollwait
    *Sep 25 14:36:07.047: //-1//TCL :EE46DEE9D4000:/tcl_FSMObjCmd:  fsm setstate POLL_INTERVAL_WAIT
    *Sep 25 14:36:07.047: //-1//TCL :EE46DEE9D4000:/tcl_FSMSetStateObjCmd: setstate setstate POLL_INTERVAL_WAIT
    *Sep 25 14:36:07.047: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_legs
    *Sep 25 14:36:07.047: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_legs
    *Sep 25 14:36:07.047: //205//AFW_:/vtr_ev_legs: argc 2
    *Sep 25 14:36:07.047: //205//AFW_:/vtr_ev_legs: EV_LEGS []
    *Sep 25 14:36:07.047: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_handoff argstring
    *Sep 25 14:36:07.047: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_handoff argstring
    *Sep 25 14:36:07.047: //205//AFW_:/vtr_ev_handoff: argc 3 argindex 2
    *Sep 25 14:36:07.047: //205//AFW_:/vtr_ev_handoff: event=CC_EV_CALL_HANDOFF, string=dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info"
    *Sep 25 14:36:07.047: //205//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: assumed control of call with argument: <dnis=XXXXXXXXXX cli=8005551212 rna=30 id=1234 uui="uui info">
    *Sep 25 14:36:07.051: //205//TCL :/tcl_ObjectObjCmd:  object create gtd gtd_setup IAM
    *Sep 25 14:36:07.051: //-1//TCL :/tcl_CreateObjCmd: 
    *Sep 25 14:36:07.051: //-1//AFW_:/tcl_CreateGtdObjCmd:  gtd gtd_setup IAM
    *Sep 25 14:36:07.055: //205//TCL :/tcl_ObjectObjCmd:  object append gtd gtd_setup uus.1.dat 75756920696e666f
    *Sep 25 14:36:07.055: //-1//AFW_:/tcl_AppendGtdObjCmd:  gtd gtd_setup uus.1.dat 75756920696e666f
    *Sep 25 14:36:07.055: //-1//AFW_:/tcl_modifyAttrGtdCmd:  gtd_setup uus.1.dat 75756920696e666f
    *Sep 25 14:36:07.055: //-1//AFW_:/tcl_parseGtdSpec:  uus.1.dat 75756920696e666f
    *Sep 25 14:36:07.055: //-1//AFW_:/tcl_gtdDoModifyAttrFromSpec: 
    *Sep 25 14:36:07.055: //-1//AFW_:/tcl_gtdDoModifyAttrFromSpecPost: 
    *Sep 25 14:36:07.055: //-1//AFW_:/tcl_gtdDoModifyOneAttrPost: gtd_put_parm_field gtd_buf=0x46209534 gtd_size=64 gtd_len=8 action=2(APPEND) arg_count=1 format=0(FORMAT_SHORT)
    *Sep 25 14:36:07.055: parm_name=UUS field_name=dat instance=1 field_value=75756920696e666f
    *Sep 25 14:36:07.055: //-1//AFW_:/tcl_gtdDoModifyOneAttrPost: gtd_put_parm_field gtd_status=0(SUCCESS) gtd_len=31
    *Sep 25 14:36:07.055: //-1//AFW_:/tcl_performOpsOnQueuedAttr: 
    *Sep 25 14:36:07.059: //205//TCL :/tcl_LegObjCmd:  leg setup XXXXXXXXXX callinfo 205 -g gtd_setup
    *Sep 25 14:36:07.059: //205//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 14:36:07.063: //-1//CSPK:/tclSetCallInfoParams: originationNum=8005551212
    *Sep 25 14:36:07.063: //-1//CSPK:/tclSetControlParams: alertTime(30) = 30
    *Sep 25 14:36:07.063: //-1//CSPK:/tclSetControlParams: Notify Signaling Mask=30
    *Sep 25 14:36:07.071: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_legs
    *Sep 25 14:36:07.071: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_legs
    *Sep 25 14:36:07.075: //205//AFW_:/vtr_ev_legs: argc 2
    *Sep 25 14:36:07.075: //205//AFW_:/vtr_ev_legs: EVCALLID [207]
    *Sep 25 14:36:07.075: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_event
    *Sep 25 14:36:07.075: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_event
    *Sep 25 14:36:07.075: //205//AFW_:/vtr_ev_event: argc 2
    *Sep 25 14:36:07.075: //205//AFW_:/vtr_ev_event: Event [ev_proceeding]
    *Sep 25 14:36:07.075: //205//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_proceeding on call leg 207
    *Sep 25 14:36:08.927: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_legs
    *Sep 25 14:36:08.927: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_legs
    *Sep 25 14:36:08.927: //205//AFW_:/vtr_ev_legs: argc 2
    *Sep 25 14:36:08.927: //205//AFW_:/vtr_ev_legs: EVCALLID [207]
    *Sep 25 14:36:08.927: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_event
    *Sep 25 14:36:08.931: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_event
    *Sep 25 14:36:08.931: //205//AFW_:/vtr_ev_event: argc 2
    *Sep 25 14:36:08.931: //205//AFW_:/vtr_ev_event: Event [ev_progress]
    *Sep 25 14:36:08.931: //205//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_progress on call leg 207
    *Sep 25 14:36:19.023: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_legs
    *Sep 25 14:36:19.023: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_legs
    *Sep 25 14:36:19.023: //205//AFW_:/vtr_ev_legs: argc 2
    *Sep 25 14:36:19.023: //205//AFW_:/vtr_ev_legs: EVCALLID [207]
    *Sep 25 14:36:19.023: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_event
    *Sep 25 14:36:19.023: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_event
    *Sep 25 14:36:19.023: //205//AFW_:/vtr_ev_event: argc 2
    *Sep 25 14:36:19.023: //205//AFW_:/vtr_ev_event: Event [ev_connected]
    *Sep 25 14:36:19.023: //205//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_connected on call leg 207
    *Sep 25 14:36:19.027: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_status
    *Sep 25 14:36:19.027: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_status
    *Sep 25 14:36:19.027: //205//AFW_:/vtr_ev_status: argc 2 argindex 2
    *Sep 25 14:36:19.027: //205//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: ID = 1234: call to XXXXXXXXXX established
    *Sep 25 14:36:19.027: //205//TCL :/tcl_ObjectObjCmd:  object create gtd gtd_inf INF
    *Sep 25 14:36:19.027: //-1//TCL :/tcl_CreateObjCmd: 
    *Sep 25 14:36:19.027: //-1//AFW_:/tcl_CreateGtdObjCmd:  gtd gtd_inf INF
    *Sep 25 14:36:19.027: //205//TCL :/tcl_ObjectObjCmd:  object append gtd gtd_inf uus.1.dat 636f6e6e6563746564
    *Sep 25 14:36:19.027: //-1//AFW_:/tcl_AppendGtdObjCmd:  gtd gtd_inf uus.1.dat 636f6e6e6563746564
    *Sep 25 14:36:19.027: //-1//AFW_:/tcl_modifyAttrGtdCmd:  gtd_inf uus.1.dat 636f6e6e6563746564
    *Sep 25 14:36:19.027: //-1//AFW_:/tcl_parseGtdSpec:  uus.1.dat 636f6e6e6563746564
    *Sep 25 14:36:19.027: //-1//AFW_:/tcl_gtdDoModifyAttrFromSpec: 
    *Sep 25 14:36:19.031: //-1//AFW_:/tcl_gtdDoModifyAttrFromSpecPost: 
    *Sep 25 14:36:19.031: //-1//AFW_:/tcl_gtdDoModifyOneAttrPost: gtd_put_parm_field gtd_buf=0x47F8C064 gtd_size=64 gtd_len=8 action=2(APPEND) arg_count=1 format=0(FORMAT_SHORT)
    *Sep 25 14:36:19.031: parm_name=UUS field_name=dat instance=1 field_value=636f6e6e6563746564
    *Sep 25 14:36:19.031: //-1//AFW_:/tcl_gtdDoModifyOneAttrPost: gtd_put_parm_field gtd_status=0(SUCCESS) gtd_len=33
    *Sep 25 14:36:19.031: //-1//AFW_:/tcl_performOpsOnQueuedAttr: 
    *Sep 25 14:36:19.031: //205//TCL :/tcl_LegObjCmd:  leg facility 205 -g gtd_inf
    *Sep 25 14:36:19.031: //205//TCL :/tcl_LegFacilityObjCmd: facility 205 -g gtd_inf
    *Sep 25 14:36:19.031: //205//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 14:36:19.075: //206//TCL :/tcl_InfotagObjCmd:  infotag get evt_gtd gtd_fac
    *Sep 25 14:36:19.075: //206//TCL :/tcl_InfotagGetObjCmd: infotag get evt_gtd gtd_fac
    *Sep 25 14:36:19.075: //206//AFW_:/vtr_ev_gtd_object: argc 3 argindex 2 get evt_gtd gtd_fac
    *Sep 25 14:36:19.075: //206//AFW_:/vtr_ev_gtd_object: cc_ev->e.event_id 15
    *Sep 25 14:36:19.075: //206//AFW_:/vtr_ev_gtd_object: Unable to create a GTD object entry
    *Sep 25 14:36:19.075: //206//TCL :/tcl_PutsObjCmd: ******* CVP_OBCALLREQ: dialer response invalid
    *Sep 25 14:36:19.075: //206//TCL :/tcl_TimerObjCmd:  timer stop named_timer dialer_resp_timeout
    *Sep 25 14:36:19.075: //206//TCL :/tcl_TimerStopObjCmd:  stop named_timer dialer_resp_timeout
    *Sep 25 14:36:19.075: //206//TCL :/tcl_HandoffObjCmd:  handoff return 206 -s dialer_resp_invalid
    *Sep 25 14:36:19.075: //206//TCL :/tcl_HandoffReturnObjCmd: return 206 -s dialer_resp_invalid
    *Sep 25 14:36:19.075: //206//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 14:36:19.075: //206//TCL :/tcl_HandoffReturnObjCmd: Returning  Legs [206 ] with args=dialer_resp_invalid
    *Sep 25 14:36:19.155: //206//PACK:/tclrecord_create_record_token_url: 
    *Sep 25 14:36:19.163: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_legs
    *Sep 25 14:36:19.167: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_legs
    *Sep 25 14:36:19.167: //205//AFW_:/vtr_ev_legs: argc 2
    *Sep 25 14:36:19.167: //205//AFW_:/vtr_ev_legs: EVCALLID [205]
    *Sep 25 14:36:19.167: //205//TCL :/tcl_LegObjCmd:  leg disconnect 205
    *Sep 25 14:36:19.167: //205//TCL :/tcl_LegDisconnectObjCmd: disconnect 205
    *Sep 25 14:36:19.167: //205//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1
    *Sep 25 14:36:19.167: //205//TCL :/tcl_InfotagObjCmd:  infotag get evt_event
    *Sep 25 14:36:19.167: //205//TCL :/tcl_InfotagGetObjCmd: infotag get evt_event
    *Sep 25 14:36:19.171: //205//AFW_:/vtr_ev_event: argc 2
    *Sep 25 14:36:19.171: //205//AFW_:/vtr_ev_event: Event [ev_destroy_done]
    *Sep 25 14:36:19.171: //205//TCL :/tcl_PutsObjCmd: ******* CVP_DIALER: event ev_destroy_done received
    *Sep 25 14:36:19.175: //205//TCL :/tcl_CallObjCmd:  call close
    *Sep 25 14:36:19.175: //205//TCL :/tcl_CallCloseObjCmd:  close

    Subject: RE: Outbound problem
    Replied by: ahm gawad on 17-10-2010 07:12:34 AM
    finally i got it
    it is a bug on cisco
    i hope they solve it
     

    Subject: RE: Outbound problem
    Replied by: CLAUDIO RIVAS on 22-08-2011 08:15:39 PM
    Sorry but TAC is not supporting this kind of scripts, they pointed me directly to the developer forum. wacko