search

jambonz / jambonz-feature-server

Core telephony feature server for the jambones platform
MIT License
46 stars 38 forks source link

config.listen ignored when 'Record all calls' is on #607

Open mhertogs opened 10 months ago

mhertogs commented 10 months ago

Reproduction

  1. Create a Jambonz application with 'Record all calls' checked
  2. Return the following verb from Jambonz 
     {
    "verb": "config",
    "listen": {
        "wsAuth": {
            "username": "user",
            "password": "password"
        },
        "enable": true,
        "sampleRate": 8000,
        "mixType": "stereo",
        "url": "/my-websocket-url"
    }
}
  3. Verify that Jambonz does not send open any websocket connection to /my-websocket-url
  4. Turn off 'Record all calls' on the Jambonz application configuration
  5. Rerun step 2
  6. Verify that Jambonz successfully sends websocket connection to /my-websocket-url

Likely Root Cause Looking at the code, it seems that the 'Record all calls' setting is creating a background task with the task type listen https://github.com/jambonz/jambonz-feature-server/blob/d3d494191ffdfe479d8113706b1e6004a5a4cdab/lib/utils/background-task-manager.js#L134-L155)

Then when we try to use the config verb to perform a nested listen, the background task manager just skips creating the task because there is already a listen active (https://github.com/jambonz/jambonz-feature-server/blob/d3d494191ffdfe479d8113706b1e6004a5a4cdab/lib/utils/background-task-manager.js#L29-L34).

The fact that the _initRecord uses the listen task type seems to be the main problem.

xquanluu commented 10 months ago

Hi @mhertogs

Record has type record, listen has type listen, they are different types for background tasks.

I'm not able to reproduce on jambonz.me. Could you please help to attach feature server logs please.

mhertogs commented 10 months ago

Hi @xquanluu!

Here are the relevant feature logs (with personal details replaced by and I used ... to ellipse extraneous logs)

With 'Record All Calls' enabled

{"level":30,"time":1705022678615,"pid":2271,"hostname":"ip-10-0-74-134","uri":{"family":"ipv4","scheme":"sip","user":"<REDACTED>","host":"10.0.74.134","port":5070,"params":{},"headers":{}},"callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","msg":"new incoming call"}
{"level":30,"time":1705022678618,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","app":{"application_sid":"c85a177d-da91-4c9c-8ade-58d106cf719d","name":"incoming-call-assistant-prod","service_provider_sid":null,"account_sid":"205199f3-7715-4d99-8301-eafa284739a1","call_hook_sid":"0cc29333-f5c2-4739-8669-81d23dba3eca","call_status_hook_sid":"53c2c22a-44e0-42d7-8f2a-a0a66cd39458","messaging_hook_sid":"08365bd0-0240-43f7-9577-cd9a13f309da","app_json":null,"speech_synthesis_vendor":"whisper","speech_synthesis_language":"en-US","speech_synthesis_voice":"alloy","speech_synthesis_label":null,"speech_recognizer_vendor":"deepgram","speech_recognizer_language":"en-US","speech_recognizer_label":null,"use_for_fallback_speech":0,"fallback_speech_synthesis_vendor":null,"fallback_speech_synthesis_language":null,"fallback_speech_synthesis_voice":null,"fallback_speech_synthesis_label":null,"fallback_speech_recognizer_vendor":null,"fallback_speech_recognizer_language":null,"fallback_speech_recognizer_label":null,"created_at":"2023-12-14T22:50:47.000Z","record_all_calls":1},"msg":"retrieved application for incoming call to <REDACTED>"}
{"level":30,"time":1705022678986,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","response":[{"verb":"config","listen":{"wsAuth":{"username":"<REDACTED>","password":"<REDACTED>"},"enable":true,"url":"/ws/listen/v1/incoming-call-assistant/liveCall","mixType":"stereo","sampleRate":64000,"metadata":{"fcmToken":"<REDACTED>"}}},{"verb":"tag","data":{"conversation":[{"role":"assistant","content":"Hello, I'm Matthew's assistant. What is your name and what are you calling about?","t":1705022678980}],"userName":"Matthew","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"setup"}},{"verb":"play","url":"https://hiya-jambonz-media.s3.amazonaws.com/Phone_Ringing_8x.wav","timeoutSecs":15},{"verb":"redirect","actionHook":"/http/webhook/v1/incoming-call-assistant/start"}],"msg":"HttpRequestor:request POST https://jambonz.api.hiyaapi.com/http/webhook/v1/incoming-call-assistant succeeded in 367ms"}
{"level":30,"time":1705022678987,"pid":2271,"hostname":"ip-10-0-74-134","msg":"SessionTracker:add callSid 398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21, we have 1 session being tracked"}
{"level":30,"time":1705022678988,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","tasks":"[config{listen /ws/listen/v1/incoming-call-assistant/liveCall},tag,play:{url=https://hiya-jambonz-media.s3.amazonaws.com/Phone_Ringing_8x.wav},redirect]","msg":"CallSession:exec starting 4 tasks"}
{"level":30,"time":1705022678988,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","msg":"CallSession:exec starting task #0:1: config"}
{"level":30,"time":1705022679006,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","msg":"CallSession:startBackgroundListen - listen is already enabled, ignoring request"}
{"level":30,"time":1705022679006,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","msg":"CallSession:exec completed task #0:1: config"}
{"level":30,"time":1705022679006,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","msg":"CallSession:exec starting task #0:2: tag"}
{"level":30,"time":1705022679006,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","msg":"CallSession:exec completed task #0:2: tag"}
{"level":30,"time":1705022679006,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","msg":"CallSession:exec starting task #0:3: play"}
...
{"level":30,"time":1705022705144,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","msg":"CallSession:exec all tasks complete"}
{"level":30,"time":1705022705145,"pid":2271,"hostname":"ip-10-0-74-134","msg":"SessionTracker:remove callSid 398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21, we have 0 being tracked"}
{"level":30,"time":1705022705187,"pid":2271,"hostname":"ip-10-0-74-134","callId":"31cd13a5-2b8c-123d-9c8b-0e4b68f033e9","callSid":"398ca4c4-a05d-4b4b-9a26-d5b1dc18fa21","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"924a84dc240397efdd8ae8d768c0cf22","msg":"CallSession:startBackgroundListen: listen completed"}

With 'Record All Calls' disabled

{"level":30,"time":1705023256395,"pid":2271,"hostname":"ip-10-0-74-134","uri":{"family":"ipv4","scheme":"sip","user":"<REDACTED>","host":"10.0.74.134","port":5070,"params":{},"headers":{}},"callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","msg":"new incoming call"}
{"level":30,"time":1705023256399,"pid":2271,"hostname":"ip-10-0-74-134","callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callSid":"6a399c2d-7b32-4e94-97d2-26368d3397cb","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"78bbb3b05d3dd16b73b6c4ac29a1ba0e","app":{"application_sid":"c85a177d-da91-4c9c-8ade-58d106cf719d","name":"incoming-call-assistant-prod","service_provider_sid":null,"account_sid":"205199f3-7715-4d99-8301-eafa284739a1","call_hook_sid":"0cc29333-f5c2-4739-8669-81d23dba3eca","call_status_hook_sid":"53c2c22a-44e0-42d7-8f2a-a0a66cd39458","messaging_hook_sid":"08365bd0-0240-43f7-9577-cd9a13f309da","app_json":null,"speech_synthesis_vendor":"whisper","speech_synthesis_language":"en-US","speech_synthesis_voice":"alloy","speech_synthesis_label":null,"speech_recognizer_vendor":"deepgram","speech_recognizer_language":"en-US","speech_recognizer_label":null,"use_for_fallback_speech":0,"fallback_speech_synthesis_vendor":null,"fallback_speech_synthesis_language":null,"fallback_speech_synthesis_voice":null,"fallback_speech_synthesis_label":null,"fallback_speech_recognizer_vendor":null,"fallback_speech_recognizer_language":null,"fallback_speech_recognizer_label":null,"created_at":"2023-12-14T22:50:47.000Z","record_all_calls":0},"msg":"retrieved application for incoming call to <REDACTED>"}
{"level":30,"time":1705023260300,"pid":2271,"hostname":"ip-10-0-74-134","callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callSid":"6a399c2d-7b32-4e94-97d2-26368d3397cb","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"78bbb3b05d3dd16b73b6c4ac29a1ba0e","response":[{"verb":"config","listen":{"wsAuth":{"username":"<REDACTED>","password":"<REDACTED>"},"enable":true,"url":"/ws/listen/v1/incoming-call-assistant/liveCall","mixType":"stereo","sampleRate":64000,"metadata":{"fcmToken":"<REDACTED>"}}},{"verb":"tag","data":{"conversation":[{"role":"assistant","content":"Hello, I'm Matthew's assistant. What is your name and what are you calling about?","t":1705023260297}],"userName":"Matthew","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"setup"}},{"verb":"play","url":"https://hiya-jambonz-media.s3.amazonaws.com/Phone_Ringing_8x.wav","timeoutSecs":15},{"verb":"redirect","actionHook":"/http/webhook/v1/incoming-call-assistant/start"}],"msg":"HttpRequestor:request POST https://jambonz.api.hiyaapi.com/http/webhook/v1/incoming-call-assistant succeeded in 3900ms"}
{"level":30,"time":1705023260301,"pid":2271,"hostname":"ip-10-0-74-134","msg":"SessionTracker:add callSid 6a399c2d-7b32-4e94-97d2-26368d3397cb, we have 1 session being tracked"}
{"level":30,"time":1705023260302,"pid":2271,"hostname":"ip-10-0-74-134","callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callSid":"6a399c2d-7b32-4e94-97d2-26368d3397cb","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"78bbb3b05d3dd16b73b6c4ac29a1ba0e","tasks":"[config{listen /ws/listen/v1/incoming-call-assistant/liveCall},tag,play:{url=https://hiya-jambonz-media.s3.amazonaws.com/Phone_Ringing_8x.wav},redirect]","msg":"CallSession:exec starting 4 tasks"}
{"level":30,"time":1705023260302,"pid":2271,"hostname":"ip-10-0-74-134","callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callSid":"6a399c2d-7b32-4e94-97d2-26368d3397cb","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"78bbb3b05d3dd16b73b6c4ac29a1ba0e","msg":"CallSession:exec starting task #0:1: config"}
{"level":30,"time":1705023260326,"pid":2271,"hostname":"ip-10-0-74-134","callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callSid":"6a399c2d-7b32-4e94-97d2-26368d3397cb","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"78bbb3b05d3dd16b73b6c4ac29a1ba0e","msg":"CallSession:exec completed task #0:1: config"}
{"level":30,"time":1705023260327,"pid":2271,"hostname":"ip-10-0-74-134","callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callSid":"6a399c2d-7b32-4e94-97d2-26368d3397cb","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"78bbb3b05d3dd16b73b6c4ac29a1ba0e","msg":"CallSession:exec starting task #0:2: tag"}
{"level":30,"time":1705023260330,"pid":2271,"hostname":"ip-10-0-74-134","callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callSid":"6a399c2d-7b32-4e94-97d2-26368d3397cb","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"78bbb3b05d3dd16b73b6c4ac29a1ba0e","msg":"CallSession:exec completed task #0:2: tag"}
{"level":30,"time":1705023260330,"pid":2271,"hostname":"ip-10-0-74-134","callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callSid":"6a399c2d-7b32-4e94-97d2-26368d3397cb","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"78bbb3b05d3dd16b73b6c4ac29a1ba0e","msg":"CallSession:exec starting task #0:3: play"}
...
{"level":30,"time":1705023281124,"pid":2271,"hostname":"ip-10-0-74-134","callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callSid":"6a399c2d-7b32-4e94-97d2-26368d3397cb","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"78bbb3b05d3dd16b73b6c4ac29a1ba0e","msg":"CallSession:exec all tasks complete"}
{"level":30,"time":1705023281124,"pid":2271,"hostname":"ip-10-0-74-134","msg":"SessionTracker:remove callSid 6a399c2d-7b32-4e94-97d2-26368d3397cb, we have 0 being tracked"}
{"level":30,"time":1705023281167,"pid":2271,"hostname":"ip-10-0-74-134","callId":"8a2f50b1-2b8d-123d-9c8b-0e4b68f033e9","callSid":"6a399c2d-7b32-4e94-97d2-26368d3397cb","accountSid":"205199f3-7715-4d99-8301-eafa284739a1","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"78bbb3b05d3dd16b73b6c4ac29a1ba0e","msg":"CallSession:startBackgroundListen: listen completed"}
{"level":30,"time":1705023281473,"pid":2271,"hostname":"ip-10-0-74-134","msg":"tts rtt time for 61 chars on whisper: 1509"}

However, as I was digging into the code, I realized that this is likely due to a version mismatch. We are running on the AWS marketplace jambonz-mini version which is at 0.8.5-2. It looks like this might already be resolved in future versions. I'm working on moving to a newer version of our own hosted jambonz (rather than through AWS marketplace) and will see if I can reproduce and report back.

xquanluu commented 10 months ago

Yes you are right, the log showing that background-task-manager is not there. and the issue is fixed on latest version. Please help to upgrade and let me know the result

xquanluu commented 10 months ago

Hi @mhertogs please let me know if you still face with the issue on latest branch

mhertogs commented 9 months ago

Hi @xquanluu , since the Jambonz version in AWS Marketplace is not on the newest version, I went ahead and cloned jambonz-infrastructure and built a packer version of the jambonz-mini with the latest stable version v0.8.5-17.

The problem still exists that both config.listen and Record all calls are not working simultaneously, but it exhibits in a slightly different way in this new version.

Jambonz Feature Server logs

record_all_calls=1 and config.listen (successfully streams to listen websocket but no recording in console) Notice the error message "reason":"HS: ws upgrade response not 101","msg":"TaskListen:_onConnectFailure" happens in this case

{"level":30,"time":1705453060295,"pid":2176,"hostname":"ip-10-0-138-54","uri":{"family":"ipv4","scheme":"sip","user":"<REDACTED>","host":"10.0.138.54","port":5070,"params":{},"headers":{}},"callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","msg":"new incoming call"}
{"level":30,"time":1705453060300,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","app":{"application_sid":"7264ab17-bd66-4461-a29e-2c540fe94c43","name":"mhertogs-ngrok","service_provider_sid":null,"account_sid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","call_hook_sid":"fd52e7b1-15c5-47a3-8a5b-b2db2b05a63f","call_status_hook_sid":"ae3a2b81-0642-4cf9-a041-a35e7576fef5","messaging_hook_sid":"dd36b9d9-949b-47e1-965f-f9348eec0e97","app_json":null,"speech_synthesis_vendor":"whisper","speech_synthesis_language":"en-US","speech_synthesis_voice":"alloy","speech_synthesis_label":null,"speech_recognizer_vendor":"google","speech_recognizer_language":"en-US","speech_recognizer_label":null,"use_for_fallback_speech":0,"fallback_speech_synthesis_vendor":null,"fallback_speech_synthesis_language":null,"fallback_speech_synthesis_voice":null,"fallback_speech_synthesis_label":null,"fallback_speech_recognizer_vendor":null,"fallback_speech_recognizer_language":null,"fallback_speech_recognizer_label":null,"created_at":"2024-01-17T00:15:46.000Z","record_all_calls":1},"msg":"retrieved application for incoming call to 14086101665"}
{"level":30,"time":1705453061452,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","response":[{"verb":"config","listen":{"wsAuth":{"username":"<REDACTED>","password":"<REDACTED>"},"enable":true,"url":"/ws/listen/v1/incoming-call-assistant/liveCall","mixType":"stereo","sampleRate":64000,"metadata":{"fcmToken":"<REDACTED>"}}},{"verb":"tag","data":{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453061261}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"setup"}},{"verb":"play","url":"https://hiya-jambonz-media.s3.amazonaws.com/Phone_Ringing_8x.wav","timeoutSecs":15},{"verb":"redirect","actionHook":"/http/webhook/v1/incoming-call-assistant/start"}],"msg":"HttpRequestor:request POST https://c945-66-171-188-194.ngrok-free.app/http/webhook/v1/incoming-call-assistant succeeded in 1150ms"}
{"level":30,"time":1705453061453,"pid":2176,"hostname":"ip-10-0-138-54","msg":"SessionTracker:add callSid e1157d38-846b-4f17-964c-7b2f9e77cad2, we have 1 session being tracked"}
{"level":30,"time":1705453061457,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","tasks":"[config{listen /ws/listen/v1/incoming-call-assistant/liveCall},tag,play:{url=https://hiya-jambonz-media.s3.amazonaws.com/Phone_Ringing_8x.wav},redirect]","msg":"CallSession:exec starting 4 tasks"}
{"level":30,"time":1705453061457,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec starting task #0:1: config"}
{"level":30,"time":1705453061489,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"initiating Background task record"}
{"level":30,"time":1705453061497,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","taskOpts":{"verb":"listen","wsAuth":{"username":"<REDACTED>","password":"<REDACTED>"},"url":"/ws/listen/v1/incoming-call-assistant/liveCall","mixType":"stereo","sampleRate":64000,"metadata":{"fcmToken":"<REDACTED>"}},"msg":"initiating Background task listen"}
{"level":30,"time":1705453061499,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec completed task #0:1: config"}
{"level":30,"time":1705453061499,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec starting task #0:2: tag"}
{"level":30,"time":1705453061499,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec completed task #0:2: tag"}
{"level":30,"time":1705453061499,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec starting task #0:3: play"}
{"level":30,"time":1705453061629,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","reason":"HS: ws upgrade response not 101","msg":"TaskListen:_onConnectFailure"}
{"level":30,"time":1705453061629,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","reason":"HS: ws upgrade response not 101","msg":"TaskListen:_onConnectFailure"}
{"level":30,"time":1705453061629,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","type":"record","task":{"url":"ws://127.0.0.1:3002/api/v1/record/aws_s3","disableBidirectionalAudio":true,"mixType":"stereo","passDtmf":true,"wsAuth":{"username":"jambonz","password":"52862e7c-4d69-497b-b9f0-1bea61f7f29a"}},"msg":"BackgroundTaskManager:_taskCompleted: task completed"}
{"level":30,"time":1705453061630,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","type":"listen","task":{"wsAuth":{"username":"<REDACTED>","password":"<REDACTED>"},"url":"/ws/listen/v1/incoming-call-assistant/liveCall","mixType":"stereo","sampleRate":64000,"metadata":{"fcmToken":"<REDACTED>"}},"msg":"BackgroundTaskManager:_taskCompleted: task completed"}
{"level":30,"time":1705453076568,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec completed task #0:3: play"}
{"level":30,"time":1705453076568,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec starting task #0:4: redirect"}
{"level":30,"time":1705453076949,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","response":[{"verb":"tag","data":{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453076788}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"converse"}},{"verb":"gather","input":["speech"],"actionHook":"/http/webhook/v1/incoming-call-assistant/converse","listenDuringPrompt":true,"timeout":10,"recognizer":{"vendor":"google","language":"en-US","punctuation":true,"enhancedModel":true},"say":{"text":"<prosody volume=\"x-loud\"><break time=\"2s\"/>Hello, I'm Matt's assistant. What is your name and what are you calling about?</prosody>"}}],"msg":"HttpRequestor:request POST /http/webhook/v1/incoming-call-assistant/start succeeded in 380ms"}
{"level":30,"time":1705453076950,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","tasks":[{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453076788}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"converse"},{"input":["speech"],"actionHook":"/http/webhook/v1/incoming-call-assistant/converse","listenDuringPrompt":true,"timeout":10,"recognizer":{"vendor":"google","language":"en-US","punctuation":true,"enhancedModel":true,"altLanguages":[]},"say":{"text":"<prosody volume=\"x-loud\"><break time=\"2s\"/>Hello, I'm Matt's assistant. What is your name and what are you calling about?</prosody>"}}],"msg":"redirect replacing application with 2 tasks"}
{"level":30,"time":1705453076950,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","tasks":"[tag,gather{inputs=speech,vendor=google,language=en-US,with nested say task}]","msg":"CallSession:replaceApplication reset with 2 new tasks, stack depth is 1"}
{"level":30,"time":1705453076950,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec completed task #0:4: redirect"}
{"level":30,"time":1705453076950,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec starting task #1:1: tag"}
{"level":30,"time":1705453076950,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec completed task #1:1: tag"}
{"level":30,"time":1705453076950,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec starting task #1:2: gather"}
{"level":30,"time":1705453076950,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"Speech vendor: google  selected"}
{"level":30,"time":1705453076951,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"Speech vendor: whisper  selected"}
{"level":30,"time":1705453076951,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","vendor":"whisper","language":"en-US","voice":"alloy","msg":"TaskSay:exec"}
{"level":30,"time":1705453084656,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","evt":{"language_code":"en-US","channel_tag":1,"is_final":true,"alternatives":[{"confidence":0,"transcript":""}],"vendor":{"name":"google","evt":{"stability":0,"is_final":true,"alternatives":[{"confidence":0,"transcript":""}],"language_code":"en-us","channel_tag":0,"result_end_time":7280}}},"msg":"TaskGather:_onTranscription - got empty transcript, continue listening"}
{"level":30,"time":1705453086100,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"stopping background task, record is not running, skipped"}
{"level":30,"time":1705453086106,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"InboundCallSession: caller hung up"}
{"level":30,"time":1705453086106,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec completed task #1:2: gather"}
{"level":30,"time":1705453086106,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"CallSession:exec all tasks complete"}
{"level":30,"time":1705453086106,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"stopping background task, bargeIn is not running, skipped"}
{"level":30,"time":1705453086107,"pid":2176,"hostname":"ip-10-0-138-54","callId":"4145d3aa-2f76-123d-b0ab-0a64b443c813","callSid":"e1157d38-846b-4f17-964c-7b2f9e77cad2","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"3b4d89089ada9e8be4f0ea8a303cba9c","msg":"BackgroundTaskManager:stopAll"}
{"level":30,"time":1705453086107,"pid":2176,"hostname":"ip-10-0-138-54","msg":"SessionTracker:remove callSid e1157d38-846b-4f17-964c-7b2f9e77cad2, we have 0 being tracked"}

record_all_calls=0 and config.listen (successfully streams to listen websocket)

{"level":30,"time":1705452997524,"pid":2176,"hostname":"ip-10-0-138-54","uri":{"family":"ipv4","scheme":"sip","user":"<REDACTED>","host":"10.0.138.54","port":5070,"params":{},"headers":{}},"callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","msg":"new incoming call"}
{"level":30,"time":1705452997529,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","app":{"application_sid":"7264ab17-bd66-4461-a29e-2c540fe94c43","name":"mhertogs-ngrok","service_provider_sid":null,"account_sid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","call_hook_sid":"fd52e7b1-15c5-47a3-8a5b-b2db2b05a63f","call_status_hook_sid":"ae3a2b81-0642-4cf9-a041-a35e7576fef5","messaging_hook_sid":"dd36b9d9-949b-47e1-965f-f9348eec0e97","app_json":null,"speech_synthesis_vendor":"whisper","speech_synthesis_language":"en-US","speech_synthesis_voice":"alloy","speech_synthesis_label":null,"speech_recognizer_vendor":"google","speech_recognizer_language":"en-US","speech_recognizer_label":null,"use_for_fallback_speech":0,"fallback_speech_synthesis_vendor":null,"fallback_speech_synthesis_language":null,"fallback_speech_synthesis_voice":null,"fallback_speech_synthesis_label":null,"fallback_speech_recognizer_vendor":null,"fallback_speech_recognizer_language":null,"fallback_speech_recognizer_label":null,"created_at":"2024-01-17T00:15:46.000Z","record_all_calls":0},"msg":"retrieved application for incoming call to 14086101665"}
{"level":30,"time":1705453000399,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","response":[{"verb":"config","listen":{"wsAuth":{"username":"<REDACTED>","password":"<REDACTED>"},"enable":true,"url":"/ws/listen/v1/incoming-call-assistant/liveCall","mixType":"stereo","sampleRate":64000,"metadata":{"fcmToken":"<REDACTED>"}}},{"verb":"tag","data":{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453000193}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"setup"}},{"verb":"play","url":"https://hiya-jambonz-media.s3.amazonaws.com/Phone_Ringing_8x.wav","timeoutSecs":15},{"verb":"redirect","actionHook":"/http/webhook/v1/incoming-call-assistant/start"}],"msg":"HttpRequestor:request POST https://c945-66-171-188-194.ngrok-free.app/http/webhook/v1/incoming-call-assistant succeeded in 2869ms"}
{"level":30,"time":1705453000400,"pid":2176,"hostname":"ip-10-0-138-54","msg":"SessionTracker:add callSid 7ea4f226-9622-4281-90fa-4847d8855fc6, we have 1 session being tracked"}
{"level":30,"time":1705453000402,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","tasks":"[config{listen /ws/listen/v1/incoming-call-assistant/liveCall},tag,play:{url=https://hiya-jambonz-media.s3.amazonaws.com/Phone_Ringing_8x.wav},redirect]","msg":"CallSession:exec starting 4 tasks"}
{"level":30,"time":1705453000402,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec starting task #0:1: config"}
{"level":30,"time":1705453000427,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","taskOpts":{"verb":"listen","wsAuth":{"username":"<REDACTED>","password":"<REDACTED>"},"url":"/ws/listen/v1/incoming-call-assistant/liveCall","mixType":"stereo","sampleRate":64000,"metadata":{"fcmToken":"<REDACTED>"}},"msg":"initiating Background task listen"}
{"level":30,"time":1705453000427,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec completed task #0:1: config"}
{"level":30,"time":1705453000427,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec starting task #0:2: tag"}
{"level":30,"time":1705453000427,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec completed task #0:2: tag"}
{"level":30,"time":1705453000427,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec starting task #0:3: play"}
{"level":30,"time":1705453015496,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec completed task #0:3: play"}
{"level":30,"time":1705453015496,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec starting task #0:4: redirect"}
{"level":30,"time":1705453015713,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","response":[{"verb":"tag","data":{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453015562}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"converse"}},{"verb":"gather","input":["speech"],"actionHook":"/http/webhook/v1/incoming-call-assistant/converse","listenDuringPrompt":true,"timeout":10,"recognizer":{"vendor":"google","language":"en-US","punctuation":true,"enhancedModel":true},"say":{"text":"<prosody volume=\"x-loud\"><break time=\"2s\"/>Hello, I'm Matt's assistant. What is your name and what are you calling about?</prosody>"}}],"msg":"HttpRequestor:request POST /http/webhook/v1/incoming-call-assistant/start succeeded in 216ms"}
{"level":30,"time":1705453015713,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","tasks":[{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453015562}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"converse"},{"input":["speech"],"actionHook":"/http/webhook/v1/incoming-call-assistant/converse","listenDuringPrompt":true,"timeout":10,"recognizer":{"vendor":"google","language":"en-US","punctuation":true,"enhancedModel":true,"altLanguages":[]},"say":{"text":"<prosody volume=\"x-loud\"><break time=\"2s\"/>Hello, I'm Matt's assistant. What is your name and what are you calling about?</prosody>"}}],"msg":"redirect replacing application with 2 tasks"}
{"level":30,"time":1705453015713,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","tasks":"[tag,gather{inputs=speech,vendor=google,language=en-US,with nested say task}]","msg":"CallSession:replaceApplication reset with 2 new tasks, stack depth is 1"}
{"level":30,"time":1705453015713,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec completed task #0:4: redirect"}
{"level":30,"time":1705453015713,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec starting task #1:1: tag"}
{"level":30,"time":1705453015714,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec completed task #1:1: tag"}
{"level":30,"time":1705453015714,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec starting task #1:2: gather"}
{"level":30,"time":1705453015714,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"Speech vendor: google  selected"}
{"level":30,"time":1705453015715,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"Speech vendor: whisper  selected"}
{"level":30,"time":1705453015715,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","vendor":"whisper","language":"en-US","voice":"alloy","msg":"TaskSay:exec"}
{"level":30,"time":1705453023915,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"stopping background task, record is not running, skipped"}
{"level":30,"time":1705453023932,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"InboundCallSession: caller hung up"}
{"level":30,"time":1705453023932,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec completed task #1:2: gather"}
{"level":30,"time":1705453023933,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"CallSession:exec all tasks complete"}
{"level":30,"time":1705453023933,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"stopping background task, bargeIn is not running, skipped"}
{"level":30,"time":1705453023933,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"BackgroundTaskManager:stopAll"}
{"level":30,"time":1705453023933,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","msg":"stopping background task: listen"}
{"level":30,"time":1705453023933,"pid":2176,"hostname":"ip-10-0-138-54","msg":"SessionTracker:remove callSid 7ea4f226-9622-4281-90fa-4847d8855fc6, we have 0 being tracked"}
{"level":30,"time":1705453023933,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1bdbac85-2f76-123d-b0ab-0a64b443c813","callSid":"7ea4f226-9622-4281-90fa-4847d8855fc6","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"6d4418494f0b374bcc2ecddc6fe44dd9","type":"listen","task":{"wsAuth":{"username":"<REDACTED>","password":"<REDACTED>"},"url":"/ws/listen/v1/incoming-call-assistant/liveCall","mixType":"stereo","sampleRate":64000,"metadata":{"fcmToken":"<REDACTED>"}},"msg":"BackgroundTaskManager:_taskCompleted: task completed"}

record_all_calls=1 and no config.listen (successfully records call in console)

{"level":30,"time":1705453431963,"pid":2176,"hostname":"ip-10-0-138-54","uri":{"family":"ipv4","scheme":"sip","user":"<REDACTED>","host":"10.0.138.54","port":5070,"params":{},"headers":{}},"callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","msg":"new incoming call"}
{"level":30,"time":1705453431968,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","app":{"application_sid":"7264ab17-bd66-4461-a29e-2c540fe94c43","name":"mhertogs-ngrok","service_provider_sid":null,"account_sid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","call_hook_sid":"fd52e7b1-15c5-47a3-8a5b-b2db2b05a63f","call_status_hook_sid":"ae3a2b81-0642-4cf9-a041-a35e7576fef5","messaging_hook_sid":"dd36b9d9-949b-47e1-965f-f9348eec0e97","app_json":null,"speech_synthesis_vendor":"whisper","speech_synthesis_language":"en-US","speech_synthesis_voice":"alloy","speech_synthesis_label":null,"speech_recognizer_vendor":"google","speech_recognizer_language":"en-US","speech_recognizer_label":null,"use_for_fallback_speech":0,"fallback_speech_synthesis_vendor":null,"fallback_speech_synthesis_language":null,"fallback_speech_synthesis_voice":null,"fallback_speech_synthesis_label":null,"fallback_speech_recognizer_vendor":null,"fallback_speech_recognizer_language":null,"fallback_speech_recognizer_label":null,"created_at":"2024-01-17T00:15:46.000Z","record_all_calls":1},"msg":"retrieved application for incoming call to 14086101665"}
{"level":30,"time":1705453433313,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","response":[{"verb":"tag","data":{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453433140}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"setup"}},{"verb":"play","url":"https://hiya-jambonz-media.s3.amazonaws.com/Phone_Ringing_8x.wav","timeoutSecs":15},{"verb":"redirect","actionHook":"/http/webhook/v1/incoming-call-assistant/start"}],"msg":"HttpRequestor:request POST https://c945-66-171-188-194.ngrok-free.app/http/webhook/v1/incoming-call-assistant succeeded in 1344ms"}
{"level":30,"time":1705453433314,"pid":2176,"hostname":"ip-10-0-138-54","msg":"SessionTracker:add callSid 52425116-0add-41ff-91a8-9c7ad31d0286, we have 1 session being tracked"}
{"level":30,"time":1705453433317,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","tasks":"[tag,play:{url=https://hiya-jambonz-media.s3.amazonaws.com/Phone_Ringing_8x.wav},redirect]","msg":"CallSession:exec starting 3 tasks"}
{"level":30,"time":1705453433317,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec starting task #0:1: tag"}
{"level":30,"time":1705453433317,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec completed task #0:1: tag"}
{"level":30,"time":1705453433317,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec starting task #0:2: play"}
{"level":30,"time":1705453433360,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"initiating Background task record"}
{"level":30,"time":1705453448434,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec completed task #0:2: play"}
{"level":30,"time":1705453448434,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec starting task #0:3: redirect"}
{"level":30,"time":1705453448615,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","response":[{"verb":"tag","data":{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453448475}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"converse"}},{"verb":"gather","input":["speech"],"actionHook":"/http/webhook/v1/incoming-call-assistant/converse","listenDuringPrompt":true,"timeout":10,"recognizer":{"vendor":"google","language":"en-US","punctuation":true,"enhancedModel":true},"say":{"text":"<prosody volume=\"x-loud\"><break time=\"2s\"/>Hello, I'm Matt's assistant. What is your name and what are you calling about?</prosody>"}}],"msg":"HttpRequestor:request POST /http/webhook/v1/incoming-call-assistant/start succeeded in 180ms"}
{"level":30,"time":1705453448616,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","tasks":[{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453448475}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"converse"},{"input":["speech"],"actionHook":"/http/webhook/v1/incoming-call-assistant/converse","listenDuringPrompt":true,"timeout":10,"recognizer":{"vendor":"google","language":"en-US","punctuation":true,"enhancedModel":true,"altLanguages":[]},"say":{"text":"<prosody volume=\"x-loud\"><break time=\"2s\"/>Hello, I'm Matt's assistant. What is your name and what are you calling about?</prosody>"}}],"msg":"redirect replacing application with 2 tasks"}
{"level":30,"time":1705453448616,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","tasks":"[tag,gather{inputs=speech,vendor=google,language=en-US,with nested say task}]","msg":"CallSession:replaceApplication reset with 2 new tasks, stack depth is 1"}
{"level":30,"time":1705453448616,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec completed task #0:3: redirect"}
{"level":30,"time":1705453448616,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec starting task #1:1: tag"}
{"level":30,"time":1705453448616,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec completed task #1:1: tag"}
{"level":30,"time":1705453448616,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec starting task #1:2: gather"}
{"level":30,"time":1705453448617,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"Speech vendor: google  selected"}
{"level":30,"time":1705453448617,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"Speech vendor: whisper  selected"}
{"level":30,"time":1705453448617,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","vendor":"whisper","language":"en-US","voice":"alloy","msg":"TaskSay:exec"}
{"level":30,"time":1705453457123,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"stopping background task: record"}
{"level":30,"time":1705453457157,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"InboundCallSession: caller hung up"}
{"level":30,"time":1705453457163,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","type":"record","task":{"url":"ws://127.0.0.1:3002/api/v1/record/aws_s3","disableBidirectionalAudio":true,"mixType":"stereo","passDtmf":true,"wsAuth":{"username":"jambonz","password":"52862e7c-4d69-497b-b9f0-1bea61f7f29a"}},"msg":"BackgroundTaskManager:_taskCompleted: task completed"}
{"level":30,"time":1705453457328,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","response":[{"verb":"tag","data":{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453448475},{"role":"assistant","content":"Sorry, I didn't understand that. Could you try again?","t":1705453457189}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"converse"}},{"verb":"gather","input":["speech"],"actionHook":"/http/webhook/v1/incoming-call-assistant/converse","listenDuringPrompt":true,"timeout":10,"recognizer":{"vendor":"google","language":"en-US","punctuation":true,"enhancedModel":true},"say":{"text":"Sorry, I didn't understand that. Could you try again?"}}],"msg":"HttpRequestor:request POST /http/webhook/v1/incoming-call-assistant/converse succeeded in 323ms"}
{"level":30,"time":1705453457329,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","tasks":[{"conversation":[{"role":"assistant","content":"Hello, I'm Matt's assistant. What is your name and what are you calling about?","t":1705453448475},{"role":"assistant","content":"Sorry, I didn't understand that. Could you try again?","t":1705453457189}],"userName":"Matt","userNumber":"<REDACTED>","fcmToken":"<REDACTED>","stg":"converse"},{"input":["speech"],"actionHook":"/http/webhook/v1/incoming-call-assistant/converse","listenDuringPrompt":true,"timeout":10,"recognizer":{"vendor":"google","language":"en-US","punctuation":true,"enhancedModel":true,"altLanguages":[]},"say":{"text":"Sorry, I didn't understand that. Could you try again?"}}],"msg":"gather replacing application with 2 tasks"}
{"level":30,"time":1705453457329,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec completed task #1:2: gather"}
{"level":30,"time":1705453457329,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"CallSession:exec all tasks complete"}
{"level":30,"time":1705453457329,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"stopping background task, bargeIn is not running, skipped"}
{"level":30,"time":1705453457329,"pid":2176,"hostname":"ip-10-0-138-54","callId":"1ecdbcc8-2f77-123d-b0ab-0a64b443c813","callSid":"52425116-0add-41ff-91a8-9c7ad31d0286","accountSid":"fbb2d810-1b43-4cd2-a4e6-bee95c0f51eb","callingNumber":"<REDACTED>","calledNumber":"<REDACTED>","traceId":"edca5abc64302795b9cfd260cdb5f620","msg":"BackgroundTaskManager:stopAll"}
{"level":30,"time":1705453457329,"pid":2176,"hostname":"ip-10-0-138-54","msg":"SessionTracker:remove callSid 52425116-0add-41ff-91a8-9c7ad31d0286, we have 0 being tracked"}

Reproduction Steps

Building 0.8.5-17 steps

  1. Clone jambonz-infrastructure
  2. Update the version in the jambonz-mini Packer template to v0.8.5-17 and built the Packer AMI
  3. Updated the AMI here to my newly built AMI and deployed in Cloudformation

Running test

  1. Create a Jambonz application with 'Record all calls' checked
  2. Return the following verb from Jambonz 
    {
"verb": "config",
"listen": {
    "wsAuth": {
        "username": "user",
        "password": "password"
    },
    "enable": true,
    "sampleRate": 8000,
    "mixType": "stereo",
    "url": "/my-websocket-url"
}
}
  3. Verify that Jambonz sends to websocket connection on /my-websocket-url but no recording is available in Jambonz console
  4. Remove the config verb and verify that the recording now shows up in Jambonz console