When I initiate a call via the REST server, I should hear some TTS but I hear silence instead. Freeswitch shows nothing in regards to the Speak command being sent.
2011-06-30 17:29:20,154 plivo-outbound[26161]: INFO: (9) New request from ('127.0.0.1', 48507)
2011-06-30 17:29:20,155 plivo-outbound[26161]: DEBUG: (9) Execute: connect args=''
2011-06-30 17:29:20,160 plivo-outbound[26161]: DEBUG: (9) Response: <CommandResponse headers={'variable_sip_use_codec_rate': '8000', 'Channel-Channel-Progress-Media-Time': '1309469368081094', 'variable_sip_use_codec_ptime': '20', 'Caller-Screen-Bit': 'true', 'variable_is_outbound': 'true', 'Call-Direction': 'outbound', 'Channel-Read-Codec-Bit-Rate': '64000', 'Event-Calling-Line-Number': '1843', 'variable_sip_req_uri': '[email protected]', 'variable_sip_full_from': '"" <sip:[email protected];transport=udp>;tag=v8Kc5vejeF49p', 'Reply-Text': '+OK\n', 'variable_call_uuid': '25797b6d-f590-428a-92df-98d4d4825af3', 'variable_sip_contact_uri': '[email protected]:5060', 'variable_sip_from_params': 'transport=udp', 'Channel-Channel-Created-Time': '1309469365996956', 'Event-Date-Timestamp': '1309469369765254', 'Event-Name': 'CHANNEL_DATA', 'FreeSWITCH-Switchname': 'plivo1.teltechsys.com', 'variable_sip_contact_params': 'transport=udp', 'Unique-ID': '78896797-1785-46c2-bb42-24d9391d46ae', 'variable_originate_early_media': 'false', 'Control': 'full', 'variable_plivo_sched_hangup_id': '01d47060-a360-11e0-8e69-12313b0c4557', 'Caller-Caller-ID-Number': '17328381916', 'variable_ignore_early_media': 'true', 'Caller-Privacy-Hide-Number': 'false', 'variable_sip_audio_recv_pt': '0', 'Channel-Write-Codec-Bit-Rate': '64000', 'Content-Type': 'command/reply', 'Channel-Write-Codec-Rate': '8000', 'variable_sip_to_user': '+17328381916', 'Event-Date-Local': '2011-06-30 17:29:29', 'Channel-Channel-Answered-Time': '1309469369745191', 'Event-Calling-Function': 'parse_command', 'variable_socket_host': '127.0.0.1', 'Caller-Destination-Number': '+17328381916', 'variable_sip_local_sdp_str': 'v=0\no=FreeSWITCH 1309439515 1309439516 IN IP4 50.17.206.81\ns=FreeSWITCH\nc=IN IP4 50.17.206.81\nt=0 0\nm=audio 29850 RTP/AVP 0 8 3 101 13\na=rtpmap:101 telephone-event/8000\na=fmtp:101 0-16\na=ptime:20\na=sendrecv\n', 'Caller-Profile-Index': '2', 'Channel-State': 'CS_EXECUTE', 'variable_plivo_app': 'true', 'variable_sip_contact_port': '5060', 'Caller-Caller-ID-Name': '17328381916', 'Core-UUID': '728288a5-efc6-44e0-8d58-f0753dcabdab', 'Caller-Profile-Created-Time': '1309469369765254', 'variable_sip_call_id': 'd9332edc-1e02-122f-6eac-12313b0c4557', 'variable_channel_name': 'sofia/external/+17328381916', 'Caller-Channel-Answered-Time': '1309469369745191', 'variable_switch_r_sdp': 'v=0\r\no=- 6755 11954 IN IP4 208.93.227.13\r\ns=-\r\nc=IN IP4 208.93.227.13\r\nt=0 0\r\nm=audio 16252 RTP/AVP 0 101\r\na=rtpmap:101 telephone-event/8000\r\na=fmtp:101 0-15\r\na=ptime:20\r\n', 'Answer-State': 'answered', 'Caller-Privacy-Hide-Name': 'false', 'variable_plivo_answer_url': 'http://api.telapia.com/_plivo/outgoing/answered', 'variable_remote_media_ip': '208.93.227.13', 'variable_write_codec': 'PCMU', 'Caller-Context': 'default', 'variable_max_forwards': '70', 'variable_sip_to_uri': '[email protected]', 'variable_sip_reply_port': '5060', 'variable_read_codec': 'PCMU', 'Channel-Channel-Progress-Time': '0', 'Caller-Channel-Created-Time': '1309469365996956', 'variable_endpoint_disposition': 'ANSWER', 'Channel-Context': 'default', 'variable_sip_from_tag': 'v8Kc5vejeF49p', 'Channel-Channel-Transfer-Time': '0', 'variable_sip_from_uri': '[email protected]', 'Channel-Channel-Hangup-Time': '0', 'Event-Date-GMT': 'Thu, 30 Jun 2011 21:29:29 GMT', 'Caller-Channel-Progress-Media-Time': '1309469368081094', 'variable_sip_full_via': 'SIP/2.0/UDP 50.17.206.81:5080;rport=5080;branch=z9hG4bKXNSa9vcQ7XQZg', 'Channel-Read-Codec-Rate': '8000', 'Channel-Profile-Index': '2', 'Channel-Direction': 'outbound', 'Channel-Name': 'sofia/external/+17328381916', 'variable_sip_reply_host': '75.101.162.138', 'variable_sofia_profile_name': 'external', 'Channel-Privacy-Hide-Name': 'false', 'Channel-State-Number': '4', 'variable_sip_destination_url': 'sip:[email protected]', 'Channel-Call-UUID': '25797b6d-f590-428a-92df-98d4d4825af3', 'variable_bridge_early_media': 'true', 'Channel-Caller-ID-Name': '17328381916', 'Caller-Dialplan': 'inline', 'variable_local_media_ip': '50.17.206.81', 'variable_rtp_use_ssrc': '75530', 'Caller-Source': 'src/switch_ivr_originate.c', 'variable_sip_network_ip': '75.101.162.138', 'Caller-Channel-Name': 'sofia/external/+17328381916', 'FreeSWITCH-IPv4': '10.98.70.165', 'FreeSWITCH-IPv6': '::1', 'Channel-Network-Addr': '75.101.162.138', 'variable_sip_full_to': '<sip:[email protected]>;tag=7KctBp3U43X1p', 'Channel-Dialplan': 'inline', 'variable_local_media_port': '29850', 'variable_sip_gateway_name': 'sip1', 'Caller-Channel-Transfer-Time': '0', 'variable_current_application': 'socket', 'variable_sip_profile_name': 'gateway', 'Event-Calling-File': 'mod_event_socket.c', 'Channel-Destination-Number': '+17328381916', 'variable_remote_media_port': '16252', 'Channel-Write-Codec-Name': 'PCMU', 'variable_current_application_data': '127.0.0.1:8084 async full', 'Channel-Source': 'src/switch_ivr_originate.c', 'Channel-Profile-Created-Time': '1309469369765254', 'variable_sip_network_port': '5060', 'Caller-Unique-ID': '78896797-1785-46c2-bb42-24d9391d46ae', 'variable_sip_to_host': 'sip1.teltechsys.com', 'Channel-Screen-Bit': 'true', 'variable_origination_caller_id_number': '555', 'Presence-Call-Direction': 'outbound', 'variable_pre_transfer_caller_id_number': '555', 'Channel-Read-Codec-Name': 'PCMU', 'variable_write_rate': '8000', 'variable_sip_contact_user': '7328381916', 'variable_sip_contact_host': '75.127.90.67', 'variable_sip_local_network_addr': '50.17.206.81', 'variable_plivo_request_uuid': '01d46c32-a360-11e0-8e69-12313b0c4557', 'variable_sip_cseq': '14398614', 'variable_read_rate': '8000', 'variable_sip_from_host': 'sip1.teltechsys.com', 'variable_sip_to_tag': '7KctBp3U43X1p', 'Caller-Channel-Hangup-Time': '0', 'Channel-Caller-ID-Number': '17328381916', 'Channel-Channel-Name': 'sofia/external/+17328381916', 'variable_sip_use_pt': '0', 'Channel-Privacy-Hide-Number': 'false', 'Caller-Direction': 'outbound', 'variable_uuid': '78896797-1785-46c2-bb42-24d9391d46ae', 'variable_direction': 'outbound', 'variable_sip_outgoing_contact_uri': '<sip:[email protected]:5080;transport=udp;gw=sip1>', 'Caller-Network-Addr': '75.101.162.138', 'Channel-Unique-ID': '78896797-1785-46c2-bb42-24d9391d46ae', 'variable_originate_timeout': '60', 'variable_sip_from_user': 'kamailio', 'Socket-Mode': 'async', 'variable_sip_use_codec_name': 'PCMU', 'Caller-Channel-Progress-Time': '0', 'FreeSWITCH-Hostname': 'plivo1.teltechsys.com', 'Channel-Call-State': 'ACTIVE', 'variable_api_on_answer': 'sched_api 01d47060-a360-11e0-8e69-12313b0c4557 +34602 hupall ALLOTTED_TIMEOUT plivo_request_uuid 01d46c32-a360-11e0-8e69-12313b0c4557'}, body=>
2011-06-30 17:29:20,160 plivo-outbound[26161]: DEBUG: (9) Execute: resume args=''
2011-06-30 17:29:20,221 plivo-outbound[26161]: DEBUG: (9) Response: <CommandResponse headers={'Content-Type': 'command/reply', 'Reply-Text': '+OK'}, body=>
2011-06-30 17:29:20,222 plivo-outbound[26161]: DEBUG: (9) Execute: linger args=''
2011-06-30 17:29:20,222 plivo-outbound[26161]: DEBUG: (9) Response: <CommandResponse headers={'Content-Type': 'command/reply', 'Reply-Text': '+OK will linger'}, body=>
2011-06-30 17:29:20,222 plivo-outbound[26161]: DEBUG: (9) Execute: myevents json args=''
2011-06-30 17:29:20,223 plivo-outbound[26161]: DEBUG: (9) Response: <CommandResponse headers={'Content-Type': 'command/reply', 'Reply-Text': '+OK Events Enabled'}, body=>
2011-06-30 17:29:20,223 plivo-outbound[26161]: DEBUG: (9) Execute: event json args='CUSTOM conference::maintenance'
2011-06-30 17:29:20,223 plivo-outbound[26161]: DEBUG: (9) Response: <CommandResponse headers={'Content-Type': 'command/reply', 'Reply-Text': '+OK event listener enabled json'}, body=>
2011-06-30 17:29:20,224 plivo-outbound[26161]: DEBUG: (9) Execute: set args=plivo_app=true, uuid='', lock=True, loops=1
2011-06-30 17:29:20,224 plivo-outbound[26161]: DEBUG: (9) Response: <CommandResponse headers={'Content-Type': 'command/reply', 'Reply-Text': '+OK'}, body=>
2011-06-30 17:29:20,225 plivo-outbound[26161]: DEBUG: (9) Execute: set args=hangup_after_bridge=false, uuid='', lock=True, loops=1
2011-06-30 17:29:20,225 plivo-outbound[26161]: DEBUG: (9) Response: <CommandResponse headers={'Content-Type': 'command/reply', 'Reply-Text': '+OK'}, body=>
2011-06-30 17:29:20,225 plivo-outbound[26161]: INFO: (9) Using AnswerUrl http://api.telapia.com/_plivo/outgoing/answered
2011-06-30 17:29:20,226 plivo-outbound[26161]: DEBUG: (9) Execute: unset args=plivo_sched_hangup_id, uuid='', lock=True, loops=1
2011-06-30 17:29:20,226 plivo-outbound[26161]: DEBUG: (9) Response: <CommandResponse headers={'Content-Type': 'command/reply', 'Reply-Text': '+OK'}, body=>
2011-06-30 17:29:20,226 plivo-outbound[26161]: INFO: (9) Processing Call
2011-06-30 17:29:20,227 plivo-outbound[26161]: INFO: (9) Fetching RESTXML from http://api.telapia.com/_plivo/outgoing/answered with {}
2011-06-30 17:29:20,378 plivo-outbound[26161]: INFO: (9) Sent to POST http://api.telapia.com/_plivo/outgoing/answered with {'Direction': 'outbound', 'From': '17328381916', 'ALegUUID': '78896797-1785-46c2-bb42-24d9391d46ae', 'CallStatus': 'in-progress', 'To': '17328381916', 'ALegRequestUUID': '01d46c32-a360-11e0-8e69-12313b0c4557', 'CallUUID': '78896797-1785-46c2-bb42-24d9391d46ae', 'ScheduledHangupId': '01d47060-a360-11e0-8e69-12313b0c4557'} -- Result: <Response><Speak loop="1" voice="slt">Hello</Speak></Response>
2011-06-30 17:29:20,378 plivo-outbound[26161]: INFO: (9) Requested RESTXML to http://api.telapia.com/_plivo/outgoing/answered with {'Direction': 'outbound', 'From': '17328381916', 'ALegUUID': '78896797-1785-46c2-bb42-24d9391d46ae', 'CallStatus': 'in-progress', 'To': '17328381916', 'ALegRequestUUID': '01d46c32-a360-11e0-8e69-12313b0c4557', 'CallUUID': '78896797-1785-46c2-bb42-24d9391d46ae', 'ScheduledHangupId': '01d47060-a360-11e0-8e69-12313b0c4557'}
2011-06-30 17:29:20,378 plivo-outbound[26161]: INFO: (9) [Speak] Hello {'engine': 'flite', 'language': 'en', 'voice': 'slt', 'type': '', 'method': '', 'loop': '1'}
2011-06-30 17:29:20,378 plivo-outbound[26161]: DEBUG: (9) Execute: speak args=flite|slt|Hello, uuid='', lock=True, loops=1
2011-06-30 17:29:20,386 plivo-outbound[26161]: DEBUG: (9) Response: <CommandResponse headers={'Content-Type': 'command/reply', 'Reply-Text': '+OK'}, body=>
2011-06-30 17:29:20,386 plivo-outbound[26161]: DEBUG: (9) Speaking 1 times ...
2011-06-30 17:29:20,398 plivo-outbound[26161]: INFO: (9) Event: channel 78896797-1785-46c2-bb42-24d9391d46ae has hung up (ALLOTTED_TIMEOUT)
2011-06-30 17:29:20,398 plivo-outbound[26161]: WARNING: (9) Speak Break (empty event)
2011-06-30 17:29:20,398 plivo-outbound[26161]: INFO: (9) [Speak] Done
2011-06-30 17:29:20,398 plivo-outbound[26161]: INFO: (9) End of RESTXML
2011-06-30 17:29:20,398 plivo-outbound[26161]: INFO: (9) Processing Call Ended
2011-06-30 17:29:20,399 plivo-outbound[26161]: DEBUG: (9) Releasing Connection ...
2011-06-30 17:29:20,399 plivo-outbound[26161]: DEBUG: (9) Releasing Connection Done
2011-06-30 17:29:20,399 plivo-outbound[26161]: INFO: (9) End request from ('127.0.0.1', 48507)