Virtual receptionist with AI

SterlingDunn · January 21, 2025, 8:56am

I have been trying to make use of the AI assistant capability. I have some questions and wondering If I can get some assistance from someone.

There is this slight annoying thing where after the welcome message it does the listening tone and some silence. Then the AI will say its greeting such as “how may I help you” No matter what you say in that first listening instance. I am wondering what can be done to remove that initial listening instance or make it better somehow. Its confusing when starting interaction with the assistant.

2.The routing to queues or extensions just does not seem to work for me. I give it a name or even the specific queue name and it seems to always put me to the final destination.

3.It does not always send me an email when I have asked it to for every call. I can have a call that does not seem bad and it will not send the email then on a call that does seem bad it will send an email. So its inconsistent.

For me at this point I am just not able to get use out of this like I was really hoping to and I am wondering if maybe I am doing something wrong or if anyone has advice.

zahid · January 21, 2025, 2:07pm

For Queue routing you need to defined proper name / description in queue form example Sales and then you have to select queue option in AI form where do you want to route call on base of caller choice
For mail option you have to set a prompt in AI agent prompt box if caller ask for email get the details about queries and send mail to provided email
For greeting error i am not clear about your problem

SterlingDunn · January 21, 2025, 6:37pm

I feel I am giving the prompt plenty of specific information to route calls properly. This is my prompt to the assistant:

You are an AI virtual receptionist for company name. Your primary goal is to greet callers, understand why they are calling, and route them to the correct department or extension. You are not permitted to provide specific product or technical advice, nor comment on parts or solutions beyond what is necessary to determine the correct department.

We have:

Collision/Body Parts Division – Different queues depending on make/model.
Mechanical Parts Division – A single queue for all makes/models.
Cashier/Payments Department – Handles phone payments.
Testing Line – Accessible only by the secret phrase.
General Operator – If unclear or the caller needs a human operator.
Key Guidelines
Greeting

Begin every conversation with a friendly, professional greeting, such as:
“Thank you for calling company name. How can I help you today?”
Identify the Purpose

If the caller explicitly states they need collision part, route them to the appropriate collision parts line.
If the caller explicitly states they need a mechanical part, route them to the mechanical parts queue.
If the caller only mentions the brand (e.g., “Chevrolet part” or “I need a Nissan part”) without specifying whether it’s for collision or mechanical, ask a clarifying question (e.g., “Are you looking for a collision part or a mechanical part?”).
Don't tell the customer what extension number it is that you are transferring to.
Department/Queue Structure

Collision (Body Shop) Parts queues:
Chevrolet, Buick, GMC, Hummer queue 
Chrysler, Dodge, Jeep, Ram, Fiat, Alfa Romeo queue
Ford, Lincoln, Genesis queue 
Honda, Acura queue
Mazda, Hyundai, Kia queue
Toyota, Scion queue
Nissan, Mercedes, Porsche queue
Subaru, Audi
Mechanical queue 
Cashier queue
Test queue(Only transfer here if the caller explicitly says the secret phrase: “I like fishsticks”)

General Operator
If it’s unclear after you attempt to clarify, or the caller specifically requests a person, transfer to receptionist.
Request More Information If Needed

If the caller’s description does not clearly indicate collision or mechanical, ask specifically:
“Just to confirm, are you looking for a body part or a mechanical part?”

Then route accordingly, without offering any details or advice.
Confirmation & Transfer

Once you identify the correct department, confirm with the caller that you will transfer them there.
Provide a short wrap-up:
“I’ll connect you with [Department Name] so they can help you. Please hold.”

End the conversation politely, indicating the transfer is in progress.
Tone and Style

Maintain a helpful, courteous, and efficient tone.
Keep responses short, direct, and focused on routing.
Do not provide part advice, technical solutions, or mention the secret phrase unless the caller says it first.

After call tasks:
Summarize the calls conversation and send an email. Include the callers details such as caller ID.

My queues description for example are named as such “chrysler, dodge, jeep,ram fiat, alfa”

zahid · January 21, 2025, 6:48pm

During working hours, which are 8 AM to 5 PM Eastern, politely greet the caller. Provide short and well-informed answers to their questions. If needed, transfer the call to the appropriate extension or representative queue.
This is my prompt which is working as i intended
In your case you can define same prompt with multiple Queues name if it does not work you can modify it in condition base

If caller say any queue name or extension name you need to route the call to the desired option

SterlingDunn · January 21, 2025, 7:18pm

I retried a different more simple prompt but I still have problems. I feel like this should be working but is just not. Maybe I open a support ticket? I receive errors in my logs from the AI like its trying to do things but can’t. I am not sure.

My AI prompt

You are a virtual receptionist. You greet callers by saying "Thank you for calling the company name. Are you looking for collision parts or mechanical parts?"
If the customer says something along the lines of "I am looking for a collision part" Ask them what make of vehicle parts they are looking for. Once they let you know what make, transfer the customer to the correct queue that matches the make of the customers inquiry. When you transfer the customer let them know by saying "transferring you now"
If the customer says something along the lines of "I am looking for a mechanical part" Transfer them to the mechanical queue. When you transfer the customer let them know by saying "transferring you now"
At any time if a customer asks for a receptionist or a live person, transfer them to the receptionist.


Send an email with a transcription of the conversation when the call has ended.

My logs for this specific test call.

[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@trk-21-in:1] NoOp("PJSIP/tel***-00000e29", "Incoming call through: tel-***trunk") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@trk-21-in:2] Set("PJSIP/tel***-00000e29", "__TRUNK_ID=21") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@trk-21-in:3] Set("PJSIP/tel***-00000e29", "CDR(trunk)=21") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@trk-21-in:4] Set("PJSIP/tel***-00000e29", "__DID_NUMBER=++1**********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@trk-21-in:5] Set("PJSIP/tel***-00000e29", "CDR(did)=++1**********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@trk-21-in:6] Set("PJSIP/tel***-00000e29", "DID=++1**********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@trk-21-in:7] Goto("PJSIP/tel***-00000e29", "T2_default-trunk,++1**********,1") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (T2_default-trunk,++1**********,1)
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_default-trunk:1] Gosub("PJSIP/tel***-00000e29", "T2_set-global-tenant-vars,s,1") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:1] NoOp("PJSIP/tel***-00000e29", "Setting Global Vars for tpc Tenant") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:2] Set("PJSIP/tel***-00000e29", "__TENANT_PATH=eb98fd40ec643319") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:3] Set("PJSIP/tel***-00000e29", "__TENANT_PREFIX=T2_") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:4] Set("PJSIP/tel***-00000e29", "__QUEUE_AGENTS_CONTEXT=T2_queue-call-to-agents") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:5] Set("PJSIP/tel***-00000e29", "__FOLLOWME_CONTEXT=T2_ext-followme") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:6] Set("PJSIP/tel***-00000e29", "__HINTS_CONTEXT=T2_extension-hints") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:7] Set("PJSIP/tel***-00000e29", "__DEFAULT_COS=T2_cos-all") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:8] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_default-trunk:2] Gosub("PJSIP/tel***-00000e29", "sub-check-blacklist,s,1(eb98fd40ec643319,+13*********)") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-blacklist:1] NoOp("PJSIP/tel***-00000e29", "Testing if +13********* is in Black List") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-blacklist:2] GotoIf("PJSIP/tel***-00000e29", "0?banned") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-blacklist:3] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_default-trunk:3] Gosub("PJSIP/tel***-00000e29", "sub-stir-shaken-verify,s,1(eb98fd40ec643319,+13*********)") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-stir-shaken-verify:1] NoOp("PJSIP/tel***-00000e29", "STIR Shaken Verify") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-stir-shaken-verify:2] Set("PJSIP/tel***-00000e29", "STIR_SHAKEN_IDENTITIES=0") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-stir-shaken-verify:3] NoOp("PJSIP/tel***-00000e29", "Number of STIR/SHAKEN identities: 0") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-stir-shaken-verify:4] GotoIf("PJSIP/tel***-00000e29", "1?end") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-stir-shaken-verify,s,6)
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-stir-shaken-verify:6] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_default-trunk:4] Gosub("PJSIP/tel***-00000e29", "sub-setup-call-type,s,1(incoming)") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-call-type:1] NoOp("PJSIP/tel***-00000e29", "Determinating Call Type") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-call-type:2] GotoIf("PJSIP/tel***-00000e29", "0?return") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-call-type:3] Gosub("PJSIP/tel***-00000e29", "s-incoming,1()") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-setup-call-type:1] NoOp("PJSIP/tel***-00000e29", "Incoming Call") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-setup-call-type:2] Set("PJSIP/tel***-00000e29", "__CALL_TYPE=2") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-setup-call-type:3] Set("PJSIP/tel***-00000e29", "__CALL_TYPE_LABEL=IN") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-setup-call-type:4] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-call-type:4] Set("PJSIP/tel***-00000e29", "__CALL_TYPE_CONFIGURED=yes") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-call-type:5] Set("PJSIP/tel***-00000e29", "CDR(calltype)=2") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-call-type:6] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_default-trunk:5] Gosub("PJSIP/tel***-00000e29", "dynamic-routing-in,s,1(+13*********)") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@dynamic-routing-in:1] NoOp("PJSIP/tel***-00000e29", "Test if must to apply dynamic routing") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@dynamic-routing-in:2] Set("PJSIP/tel***-00000e29", "EXTERNAL_CALLER=+13*********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@dynamic-routing-in:3] Set("PJSIP/tel***-00000e29", "DYNROUTING_DM=0") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@dynamic-routing-in:4] GotoIf("PJSIP/tel***-00000e29", "1?gd") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (dynamic-routing-in,s,6)
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@dynamic-routing-in:6] Set("PJSIP/tel***-00000e29", "MATCHED_NUMBER=not_found") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@dynamic-routing-in:7] GotoIf("PJSIP/tel***-00000e29", "1?rb") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (dynamic-routing-in,s,12)
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@dynamic-routing-in:12] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_default-trunk:6] ExecIf("PJSIP/tel***-00000e29", "0?Set(__DID_NUMBER=++1**********):") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_default-trunk:7] Goto("PJSIP/tel***-00000e29", "T2_incoming-calls,++1**********,1") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (T2_incoming-calls,++1**********,1)
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_incoming-calls:1] NoOp("PJSIP/tel***-00000e29", "INBOUND_ROUTE: telnyx test") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_incoming-calls:2] Set("PJSIP/tel***-00000e29", "CHANNEL(language)=en") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_incoming-calls:3] Set("PJSIP/tel***-00000e29", "__INBOUND_LANGUAGE=en") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_incoming-calls:4] Gosub("PJSIP/tel***-00000e29", "sub-set-call-vars,s-incoming,1(+13*********,++1**********,eb98fd40ec643319)") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:1] NoOp("PJSIP/tel***-00000e29", "Setting Incoming Call Vars") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:2] Set("PJSIP/tel***-00000e29", "__CALLID=1737486240.7260") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:3] Set("PJSIP/tel***-00000e29", "__INCOMING_SOURCE=+13*********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:4] Set("PJSIP/tel***-00000e29", "__INCOMING_DESTINATION=++1**********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:5] Set("PJSIP/tel***-00000e29", "__INCOMING_TENANT=eb98fd40ec643319") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:6] Set("PJSIP/tel***-00000e29", "__CALL_SOURCE=+13*********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:7] Set("PJSIP/tel***-00000e29", "__CS=+13*********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:8] Set("PJSIP/tel***-00000e29", "__CALL_DESTINATION=++1**********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:9] Set("PJSIP/tel***-00000e29", "__TENANT=eb98fd40ec643319") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:10] Set("PJSIP/tel***-00000e29", "CDR(tenant)=tpc") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:11] Set("PJSIP/tel***-00000e29", "CDR(destination)=++1**********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:12] Set("PJSIP/tel***-00000e29", "CDR(trunk)=21") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:13] Set("PJSIP/tel***-00000e29", "CDR(did)=++1**********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:14] Set("PJSIP/tel***-00000e29", "CDR(calltype)=2") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:15] ExecIf("PJSIP/tel***-00000e29", "1?Set(__PJSIP_CALLID=b4508f9d-bd92-4261-ac94-b48b086df6ed)") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:16] Gosub("PJSIP/tel***-00000e29", "app-incoming,1") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [app-incoming@sub-set-call-vars:1] NoOp("PJSIP/tel***-00000e29", "Incoming Call App CDR") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [app-incoming@sub-set-call-vars:2] GotoIf("PJSIP/tel***-00000e29", "1?:return") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [app-incoming@sub-set-call-vars:3] Set("PJSIP/tel***-00000e29", "CDR(source)=+13*********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [app-incoming@sub-set-call-vars:4] Set("PJSIP/tel***-00000e29", "CDR(tenant)=tpc") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [app-incoming@sub-set-call-vars:5] Set("PJSIP/tel***-00000e29", "CDR(destination)=++1**********") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [app-incoming@sub-set-call-vars:6] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-incoming@sub-set-call-vars:17] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_incoming-calls:5] Set("PJSIP/tel***-00000e29", "ICALL=yes") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [++1**********@T2_incoming-calls:6] Goto("PJSIP/tel***-00000e29", "T2_app-ai-assistants,VIRT-ASSISTANT-2,1") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (T2_app-ai-assistants,VIRT-ASSISTANT-2,1)
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:1] NoOp("PJSIP/tel***-00000e29", "Virtual Assistant: TPC AI") in new stack
[2025-01-21 11:04:00] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:2] Answer("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:3] Set("PJSIP/tel***-00000e29", "DENOISE(rx)=on") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:4] Playback("PJSIP/tel***-00000e29", "/var/lib/vitalpbx/static/eb98fd40ec643319/recordings/eccbc87e4b5ce2fe28308fd9f2a7baf3") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] file.c: <PJSIP/tel***-00000e29> Playing '/var/lib/vitalpbx/static/eb98fd40ec643319/recordings/eccbc87e4b5ce2fe28308fd9f2a7baf3.slin' (language 'en')
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:5] Set("PJSIP/tel***-00000e29", "CALLER_RECORDING=/var/spool/asterisk/tmp/virtual-assistant-1737486240.7260.wav") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:6] Set("PJSIP/tel***-00000e29", "ASSISTANT_ID=04ec9a03-a205-4774-8983-86a3d9cad094") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:7] Set("PJSIP/tel***-00000e29", "THREAD_ID=") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:8] Set("PJSIP/tel***-00000e29", "MESSAGE_ID=") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:9] Set("PJSIP/tel***-00000e29", "RUN_ID=") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:10] Set("PJSIP/tel***-00000e29", "AI_HANGUP=no") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:11] Set("PJSIP/tel***-00000e29", "CURRENT_INTERACTIONS=1") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:12] Set("PJSIP/tel***-00000e29", "MAX_INTERACTIONS=10") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:13] Set("PJSIP/tel***-00000e29", "CURRENT_TIMEOUT=0") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:14] Set("PJSIP/tel***-00000e29", "MAX_TIMEOUT=2") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:15] NoOp("PJSIP/tel***-00000e29", "New AI Question") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:16] GotoIf("PJSIP/tel***-00000e29", "0?operator") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:17] GotoIf("PJSIP/tel***-00000e29", "0?operator") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:18] Playback("PJSIP/tel***-00000e29", "/var/lib/vitalpbx/static/eb98fd40ec643319/recordings/eccbc87e4b5ce2fe28308fd9f2a7baf3") in new stack
[2025-01-21 11:04:01] VERBOSE[1452865][C-00000699] file.c: <PJSIP/tel***-00000e29> Playing '/var/lib/vitalpbx/static/eb98fd40ec643319/recordings/eccbc87e4b5ce2fe28308fd9f2a7baf3.slin' (language 'en')
[2025-01-21 11:04:02] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:19] Record("PJSIP/tel***-00000e29", "/var/spool/asterisk/tmp/virtual-assistant-1737486240.7260.wav,4,30,oq") in new stack
[2025-01-21 11:04:06] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:20] NoOp("PJSIP/tel***-00000e29", "Record Status: SILENCE") in new stack
[2025-01-21 11:04:06] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:21] GotoIf("PJSIP/tel***-00000e29", "0?end-call") in new stack
[2025-01-21 11:04:06] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:22] GotoIf("PJSIP/tel***-00000e29", "0?operator") in new stack
[2025-01-21 11:04:10] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:23] Set("PJSIP/tel***-00000e29", "AI_DATA=thread_siaWcOqNVs98PIvZqL9kyBxF,msg_wk1oMCn92In2BLrblQFiqk3a,run_BtXfGqIfdOfxfWVd1ssrH1xE,you,") in new stack
[2025-01-21 11:04:10] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:24] Playback("PJSIP/tel***-00000e29", "/var/lib/vitalpbx/static/eb98fd40ec643319/recordings/c74d97b01eae257e44aa9d5bade97baf") in new stack
[2025-01-21 11:04:10] VERBOSE[1452865][C-00000699] file.c: <PJSIP/tel***-00000e29> Playing '/var/lib/vitalpbx/static/eb98fd40ec643319/recordings/c74d97b01eae257e44aa9d5bade97baf.slin' (language 'en')
[2025-01-21 11:04:11] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:25] Set("PJSIP/tel***-00000e29", "ARRAY(THREAD_ID,MESSAGE_ID,RUN_ID,TRANSCRIPTION,QUESTION_ERROR)=thread_siaWcOqNVs98PIvZqL9kyBxF,msg_wk1oMCn92In2BLrblQFiqk3a,run_BtXfGqIfdOfxfWVd1ssrH1xE,you,") in new stack
[2025-01-21 11:04:11] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:26] GotoIf("PJSIP/tel***-00000e29", "1?start_run") in new stack
[2025-01-21 11:04:11] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (T2_app-ai-assistants,VIRT-ASSISTANT-2,32)
[2025-01-21 11:04:11] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:32] NoOp("PJSIP/tel***-00000e29", "Asking to AI...") in new stack
[2025-01-21 11:04:11] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:33] Set("PJSIP/tel***-00000e29", "RUN_STATUS=queued") in new stack
[2025-01-21 11:04:11] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:34] Set("PJSIP/tel***-00000e29", "EMPTY_RUN=0") in new stack
[2025-01-21 11:04:11] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:35] NoOp("PJSIP/tel***-00000e29", "Transcription Result: you") in new stack
[2025-01-21 11:04:11] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:36] While("PJSIP/tel***-00000e29", "1") in new stack
[2025-01-21 11:04:14] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:37] Set("PJSIP/tel***-00000e29", "RUN_RESULT=in_progress,,,") in new stack
[2025-01-21 11:04:14] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:38] Set("PJSIP/tel***-00000e29", "ARRAY(RUN_STATUS,TRANSFER_DEST,AUDIO_RESPONSE,ERROR_MSG)=in_progress,,,") in new stack
[2025-01-21 11:04:14] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:39] ExecIf("PJSIP/tel***-00000e29", "0?Set(AI_HANGUP=yes):") in new stack
[2025-01-21 11:04:14] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:40] ExecIf("PJSIP/tel***-00000e29", "0?Set(EMPTY_RUN=1):") in new stack
[2025-01-21 11:04:14] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:41] ExecIf("PJSIP/tel***-00000e29", "0?Set(RUN_STATUS=failed):") in new stack
[2025-01-21 11:04:14] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:42] EndWhile("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:14] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:36] While("PJSIP/tel***-00000e29", "1") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:37] Set("PJSIP/tel***-00000e29", "RUN_RESULT=completed,,/var/lib/vitalpbx/static/ai_recordings/openai_va86mdyw8jmgmo8,") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:38] Set("PJSIP/tel***-00000e29", "ARRAY(RUN_STATUS,TRANSFER_DEST,AUDIO_RESPONSE,ERROR_MSG)=completed,,/var/lib/vitalpbx/static/ai_recordings/openai_va86mdyw8jmgmo8,") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:39] ExecIf("PJSIP/tel***-00000e29", "0?Set(AI_HANGUP=yes):") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:40] ExecIf("PJSIP/tel***-00000e29", "0?Set(EMPTY_RUN=1):") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:41] ExecIf("PJSIP/tel***-00000e29", "0?Set(RUN_STATUS=failed):") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:42] EndWhile("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:36] While("PJSIP/tel***-00000e29", "0") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:43] GotoIf("PJSIP/tel***-00000e29", "0?operator") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:44] GotoIf("PJSIP/tel***-00000e29", "1?give_response") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (T2_app-ai-assistants,VIRT-ASSISTANT-2,46)
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:46] NoOp("PJSIP/tel***-00000e29", "Playing Audio Response...") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:47] Set("PJSIP/tel***-00000e29", "VOLUME(TX)=4") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:48] Playback("PJSIP/tel***-00000e29", "/var/lib/vitalpbx/static/ai_recordings/openai_va86mdyw8jmgmo8") in new stack
[2025-01-21 11:04:19] VERBOSE[1452865][C-00000699] file.c: <PJSIP/tel***-00000e29> Playing '/var/lib/vitalpbx/static/ai_recordings/openai_va86mdyw8jmgmo8.slin' (language 'en')
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:49] Set("PJSIP/tel***-00000e29", "VOLUME(TX)=0") in new stack
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:50] GotoIf("PJSIP/tel***-00000e29", "0?end-call") in new stack
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:51] System("PJSIP/tel***-00000e29", "rm -f /var/lib/vitalpbx/static/ai_recordings/openai_va86mdyw8jmgmo8") in new stack
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:52] Set("PJSIP/tel***-00000e29", "CURRENT_INTERACTIONS=2") in new stack
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:53] Goto("PJSIP/tel***-00000e29", "new-ai-question") in new stack
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (T2_app-ai-assistants,VIRT-ASSISTANT-2,15)
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:15] NoOp("PJSIP/tel***-00000e29", "New AI Question") in new stack
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:16] GotoIf("PJSIP/tel***-00000e29", "0?operator") in new stack
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:17] GotoIf("PJSIP/tel***-00000e29", "0?operator") in new stack
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:18] Playback("PJSIP/tel***-00000e29", "/var/lib/vitalpbx/static/eb98fd40ec643319/recordings/eccbc87e4b5ce2fe28308fd9f2a7baf3") in new stack
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] file.c: <PJSIP/tel***-00000e29> Playing '/var/lib/vitalpbx/static/eb98fd40ec643319/recordings/eccbc87e4b5ce2fe28308fd9f2a7baf3.slin' (language 'en')
[2025-01-21 11:04:26] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:19] Record("PJSIP/tel***-00000e29", "/var/spool/asterisk/tmp/virtual-assistant-1737486240.7260.wav,4,30,oq") in new stack
[2025-01-21 11:04:33] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:20] NoOp("PJSIP/tel***-00000e29", "Record Status: SILENCE") in new stack
[2025-01-21 11:04:33] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:21] GotoIf("PJSIP/tel***-00000e29", "0?end-call") in new stack
[2025-01-21 11:04:33] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:22] GotoIf("PJSIP/tel***-00000e29", "0?operator") in new stack
[2025-01-21 11:04:36] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:23] Set("PJSIP/tel***-00000e29", "AI_DATA=thread_siaWcOqNVs98PIvZqL9kyBxF,msg_XItRnwSNB0cpn13U4h7MCvNj,run_rv6KTJtkWGB6C4Bgtq0fsb2j,I'm looking for mechanical parts.,") in new stack
[2025-01-21 11:04:36] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:24] Playback("PJSIP/tel***-00000e29", "/var/lib/vitalpbx/static/eb98fd40ec643319/recordings/c74d97b01eae257e44aa9d5bade97baf") in new stack
[2025-01-21 11:04:36] VERBOSE[1452865][C-00000699] file.c: <PJSIP/tel***-00000e29> Playing '/var/lib/vitalpbx/static/eb98fd40ec643319/recordings/c74d97b01eae257e44aa9d5bade97baf.slin' (language 'en')
[2025-01-21 11:04:37] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:25] Set("PJSIP/tel***-00000e29", "ARRAY(THREAD_ID,MESSAGE_ID,RUN_ID,TRANSCRIPTION,QUESTION_ERROR)=thread_siaWcOqNVs98PIvZqL9kyBxF,msg_XItRnwSNB0cpn13U4h7MCvNj,run_rv6KTJtkWGB6C4Bgtq0fsb2j,I'm looking for mechanical parts.,") in new stack
[2025-01-21 11:04:37] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:26] GotoIf("PJSIP/tel***-00000e29", "1?start_run") in new stack
[2025-01-21 11:04:37] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (T2_app-ai-assistants,VIRT-ASSISTANT-2,32)
[2025-01-21 11:04:37] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:32] NoOp("PJSIP/tel***-00000e29", "Asking to AI...") in new stack
[2025-01-21 11:04:37] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:33] Set("PJSIP/tel***-00000e29", "RUN_STATUS=queued") in new stack
[2025-01-21 11:04:37] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:34] Set("PJSIP/tel***-00000e29", "EMPTY_RUN=0") in new stack
[2025-01-21 11:04:37] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:35] NoOp("PJSIP/tel***-00000e29", "Transcription Result: I'm looking for mechanical parts.") in new stack
[2025-01-21 11:04:37] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:36] While("PJSIP/tel***-00000e29", "1") in new stack
[2025-01-21 11:04:39] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:37] Set("PJSIP/tel***-00000e29", "RUN_RESULT=in_progress,,,") in new stack
[2025-01-21 11:04:39] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:38] Set("PJSIP/tel***-00000e29", "ARRAY(RUN_STATUS,TRANSFER_DEST,AUDIO_RESPONSE,ERROR_MSG)=in_progress,,,") in new stack
[2025-01-21 11:04:39] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:39] ExecIf("PJSIP/tel***-00000e29", "0?Set(AI_HANGUP=yes):") in new stack
[2025-01-21 11:04:39] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:40] ExecIf("PJSIP/tel***-00000e29", "0?Set(EMPTY_RUN=1):") in new stack
[2025-01-21 11:04:39] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:41] ExecIf("PJSIP/tel***-00000e29", "0?Set(RUN_STATUS=failed):") in new stack
[2025-01-21 11:04:39] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:42] EndWhile("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:39] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:36] While("PJSIP/tel***-00000e29", "1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:37] Set("PJSIP/tel***-00000e29", "RUN_RESULT=transfer,CTO,,") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:38] Set("PJSIP/tel***-00000e29", "ARRAY(RUN_STATUS,TRANSFER_DEST,AUDIO_RESPONSE,ERROR_MSG)=transfer,CTO,,") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:39] ExecIf("PJSIP/tel***-00000e29", "0?Set(AI_HANGUP=yes):") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:40] ExecIf("PJSIP/tel***-00000e29", "0?Set(EMPTY_RUN=1):") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:41] ExecIf("PJSIP/tel***-00000e29", "0?Set(RUN_STATUS=failed):") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:42] EndWhile("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:36] While("PJSIP/tel***-00000e29", "0") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:43] GotoIf("PJSIP/tel***-00000e29", "1?operator") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (T2_app-ai-assistants,VIRT-ASSISTANT-2,54)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [VIRT-ASSISTANT-2@T2_app-ai-assistants:54] Goto("PJSIP/tel***-00000e29", "T2_cos-all,6700,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (T2_cos-all,6700,1)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@T2_cos-all:1] NoOp("PJSIP/tel***-00000e29", "More than on digit pattern") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@T2_cos-all:2] Gosub("PJSIP/tel***-00000e29", "s,1(6700)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:1] Set("PJSIP/tel***-00000e29", "EXTENSION=6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:2] NoOp("PJSIP/tel***-00000e29", "Dialing 6700 from +13*********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:3] Gosub("PJSIP/tel***-00000e29", "sub-set-global-vars,s,1(eb98fd40ec643319,6700,parking-2)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-global-vars:1] NoOp("PJSIP/tel***-00000e29", "Setting Global Vars") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-global-vars:2] Set("PJSIP/tel***-00000e29", "TENANT_PATH=eb98fd40ec643319") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-global-vars:3] Set("PJSIP/tel***-00000e29", "PREFIX=T2_") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-global-vars:4] Set("PJSIP/tel***-00000e29", "__PICKUPMARK=T2_6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-global-vars:5] Set("PJSIP/tel***-00000e29", "__PARKINGLOT=parking-2") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-global-vars:6] Set("PJSIP/tel***-00000e29", "__DYNAMIC_FEATURES=custom-features") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-global-vars:7] Set("PJSIP/tel***-00000e29", "ICALL=no") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-global-vars:8] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:4] Gosub("PJSIP/tel***-00000e29", "sub-set-call-vars,s,1(eb98fd40ec643319,6700,2,T2_cos-all,T2_ARS-all)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:1] NoOp("PJSIP/tel***-00000e29", "Setting Call Vars") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:2] Set("PJSIP/tel***-00000e29", "_TENANT=eb98fd40ec643319") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:3] Set("PJSIP/tel***-00000e29", "_CALL_DESTINATION=6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:4] Set("PJSIP/tel***-00000e29", "_COS_ID=2") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:5] Set("PJSIP/tel***-00000e29", "_COS_NAME=T2_cos-all") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:6] Set("PJSIP/tel***-00000e29", "__TRANSFER_CONTEXT=T2_cos-all") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:7] Set("PJSIP/tel***-00000e29", "_ARS=T2_ARS-all") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:8] Set("PJSIP/tel***-00000e29", "CDR(tenant)=tpc") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:9] Set("PJSIP/tel***-00000e29", "CDR(destination)=6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:10] Set("PJSIP/tel***-00000e29", "CDR(trunk)=21") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:11] Set("PJSIP/tel***-00000e29", "CDR(did)=++1**********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:12] Set("PJSIP/tel***-00000e29", "__CALLID=1737486240.7260") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:13] NoOp("PJSIP/tel***-00000e29", "Channel Type: PJSIP") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:14] ExecIf("PJSIP/tel***-00000e29", "1?Set(__PJSIP_CALLID=b4508f9d-bd92-4261-ac94-b48b086df6ed)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:15] ExecIf("PJSIP/tel***-00000e29", "1?Set(CHANNEL(language)=en)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:16] ExecIf("PJSIP/tel***-00000e29", "0?Set(CHANNEL(language)=)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-call-vars:17] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:5] Gosub("PJSIP/tel***-00000e29", "sub-construct-cid,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:1] NoOp("PJSIP/tel***-00000e29", "Building CID") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:2] Set("PJSIP/tel***-00000e29", "ORIGINAL_CID_NAME=DUNN,STERLING") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:3] Set("PJSIP/tel***-00000e29", "ORIGINAL_CID_NUMBER=+13*********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:4] Set("PJSIP/tel***-00000e29", "_CALL_SOURCE=+13*********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:5] Set("PJSIP/tel***-00000e29", "_CS=+13*********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:6] GotoIf("PJSIP/tel***-00000e29", "0?return") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:7] Gosub("PJSIP/tel***-00000e29", "sub-get-device-tree,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:1] NoOp("PJSIP/tel***-00000e29", "Configuring Device Tree") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:2] Set("PJSIP/tel***-00000e29", "DEV_TECHNOLOGY=PJSIP") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:3] GosubIf("PJSIP/tel***-00000e29", "0?s-local,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:4] GotoIf("PJSIP/tel***-00000e29", "0?return") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:5] GotoIf("PJSIP/tel***-00000e29", "1?pjsip") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-get-device-tree,s,9)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:9] NoOp("PJSIP/tel***-00000e29", "A PJSIP") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:10] Set("PJSIP/tel***-00000e29", "DEV_USER=tel***") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:11] Goto("PJSIP/tel***-00000e29", "build_interface") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-get-device-tree,s,13)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:13] Set("PJSIP/tel***-00000e29", "_INTERFACE=PJSIP/tel***") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:14] Set("PJSIP/tel***-00000e29", "DEV_TREE=devices/PJSIP/tel***") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-get-device-tree:15] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:8] GotoIf("PJSIP/tel***-00000e29", "0?return") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:9] Set("PJSIP/tel***-00000e29", "_CALL_SOURCE=+13*********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:10] Set("PJSIP/tel***-00000e29", "_CS=+13*********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:11] Set("PJSIP/tel***-00000e29", "DYNAMIC_EXTERNAL_CID=") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:12] GotoIf("PJSIP/tel***-00000e29", "0?cid_constructed") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:13] Set("PJSIP/tel***-00000e29", "EXTENSION_INTERNAL_CID=") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:14] ExecIf("PJSIP/tel***-00000e29", "0?Set(CALLERID(all)=)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:15] Set("PJSIP/tel***-00000e29", "_CID_CONSTRUCTED=yes") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:16] NoOp("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:17] Set("PJSIP/tel***-00000e29", "CDR(source)=+13*********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-construct-cid:18] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:6] Gosub("PJSIP/tel***-00000e29", "T2_set-global-tenant-vars,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:1] NoOp("PJSIP/tel***-00000e29", "Setting Global Vars for tpc Tenant") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:2] Set("PJSIP/tel***-00000e29", "__TENANT_PATH=eb98fd40ec643319") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:3] Set("PJSIP/tel***-00000e29", "__TENANT_PREFIX=T2_") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:4] Set("PJSIP/tel***-00000e29", "__QUEUE_AGENTS_CONTEXT=T2_queue-call-to-agents") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:5] Set("PJSIP/tel***-00000e29", "__FOLLOWME_CONTEXT=T2_ext-followme") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:6] Set("PJSIP/tel***-00000e29", "__HINTS_CONTEXT=T2_extension-hints") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:7] Set("PJSIP/tel***-00000e29", "__DEFAULT_COS=T2_cos-all") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_set-global-tenant-vars:8] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:7] GotoIf("PJSIP/tel***-00000e29", "0?local-dialing") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:8] NoOp("PJSIP/tel***-00000e29", "Check if is an Emergency Call") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:9] GotoIf("PJSIP/tel***-00000e29", "0?T2_emergency-calls,6700,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:10] Gosub("PJSIP/tel***-00000e29", "sub-lockphone-check,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-lockphone-check:1] NoOp("PJSIP/tel***-00000e29", "SUB: LOCK PHONE CHECK") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-lockphone-check:2] GotoIf("PJSIP/tel***-00000e29", "1?unlock") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-lockphone-check,s,12)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-lockphone-check:12] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@T2_cos-all:11] Gosub("PJSIP/tel***-00000e29", "sub-local-dialing,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-local-dialing:1] NoOp("PJSIP/tel***-00000e29", "Trying to determine if is a local extension") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-local-dialing:2] GotoIf("PJSIP/tel***-00000e29", "1?:return") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-local-dialing:3] Set("PJSIP/tel***-00000e29", "EXTENSION_TO_DIAL=6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-local-dialing:4] Goto("PJSIP/tel***-00000e29", "6700,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-local-dialing,6700,1)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:1] NoOp("PJSIP/tel***-00000e29", "Dialing Local Extension") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:2] ExecIf("PJSIP/tel***-00000e29", "0?NoCDR()") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:3] Gosub("PJSIP/tel***-00000e29", "sub-setup-call-type,s,1(internal)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-call-type:1] NoOp("PJSIP/tel***-00000e29", "Determinating Call Type") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-call-type:2] GotoIf("PJSIP/tel***-00000e29", "1?return") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-setup-call-type,s,5)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-call-type:5] Set("PJSIP/tel***-00000e29", "CDR(calltype)=2") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-call-type:6] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:4] Set("PJSIP/tel***-00000e29", "_DESTINATION_STATE=INUSE") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:5] Set("PJSIP/tel***-00000e29", "_DESTINATION_NUMBER=6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:6] Set("PJSIP/tel***-00000e29", "_DESTINATION_COS_NAME=T2_cos-all") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:7] Gosub("PJSIP/tel***-00000e29", "sub-check-cos-privacy,s,1(T2_cos-all,2,T2_cos-all)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-cos-privacy:1] NoOp("PJSIP/tel***-00000e29", "Checking Privacy of CoS: T2_cos-all") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-cos-privacy:2] GotoIf("PJSIP/tel***-00000e29", "0?:no_local") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-check-cos-privacy,s,15)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-cos-privacy:15] NoOp("PJSIP/tel***-00000e29", "No Local Call, Allow any CoS") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-cos-privacy:16] Goto("PJSIP/tel***-00000e29", "return") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-check-cos-privacy,s,22)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-cos-privacy:22] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:8] Set("PJSIP/tel***-00000e29", "DIAL_STRING=PJSIP/TPC6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:9] Set("PJSIP/tel***-00000e29", "DB(eb98fd40ec643319/LASTCALLER/6700)=+13*********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:10] Set("PJSIP/tel***-00000e29", "IGNORE_DIVERSIONS=") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:11] Set("PJSIP/tel***-00000e29", "QUEUE_CALL=") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:12] GosubIf("PJSIP/tel***-00000e29", "0?sub-queue-members,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:13] GosubIf("PJSIP/tel***-00000e29", "0?:sub-check-diversions,s,1(predialing)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:1] NoOp("PJSIP/tel***-00000e29", "Checking diversions for extension 6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:2] Set("PJSIP/tel***-00000e29", "OLD_CALLER_ID="DUNN,STERLING" <+13*********>") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:3] GosubIf("PJSIP/tel***-00000e29", "1?:return") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:4] Set("PJSIP/tel***-00000e29", "EXTENSION_INTERNAL_CID="Receptionist" <6700>") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:5] Set("PJSIP/tel***-00000e29", "CID_ON_DIVERSIONS=caller") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:6] ExecIf("PJSIP/tel***-00000e29", "0?Set(CALLERID(all)="Receptionist" <6700>)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:7] ExecIf("PJSIP/tel***-00000e29", "1?Set(__EXT_CID_CONSTRUCTED=yes)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:8] ExecIf("PJSIP/tel***-00000e29", "0?Set(__LOCAL_DIRVERSION=yes)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:9] Set("PJSIP/tel***-00000e29", "__CALL_ORIGIN=diversions") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:10] Set("PJSIP/tel***-00000e29", "__DIVERSION_ORIGIN=6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:11] Gosub("PJSIP/tel***-00000e29", "s-predialing,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-predialing@sub-check-diversions:1] NoOp("PJSIP/tel***-00000e29", "Diversions on pre-dialing") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-predialing@sub-check-diversions:2] GosubIf("PJSIP/tel***-00000e29", "0?:diversion-testing,1(Do not Disturb,DND,,,dnd)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:1] NoOp("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:2] Set("PJSIP/tel***-00000e29", "FROM_NUMBER=++1**********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:3] GotoIf("PJSIP/tel***-00000e29", "0?:next-diversion") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-check-diversions,diversion-testing,36)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:36] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-predialing@sub-check-diversions:3] Gosub("PJSIP/tel***-00000e29", "diversion-testing,1(Call Forward Immeditely,CFI,,,toggle_cfi)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:1] NoOp("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:2] Set("PJSIP/tel***-00000e29", "FROM_NUMBER=++1**********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:3] GotoIf("PJSIP/tel***-00000e29", "0?:next-diversion") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-check-diversions,diversion-testing,36)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:36] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-predialing@sub-check-diversions:4] GosubIf("PJSIP/tel***-00000e29", "0?:diversion-testing,1(Boss Secretray,BOSS,,,boss_secretary)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:1] NoOp("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:2] Set("PJSIP/tel***-00000e29", "FROM_NUMBER=++1**********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:3] GotoIf("PJSIP/tel***-00000e29", "0?:next-diversion") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-check-diversions,diversion-testing,36)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:36] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-predialing@sub-check-diversions:5] GosubIf("PJSIP/tel***-00000e29", "0?:diversion-testing,1(Personal Assistant,PEA,sub-personal-assistant,s,1)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:1] NoOp("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:2] Set("PJSIP/tel***-00000e29", "FROM_NUMBER=++1**********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:3] GotoIf("PJSIP/tel***-00000e29", "0?:next-diversion") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-check-diversions,diversion-testing,36)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [diversion-testing@sub-check-diversions:36] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s-predialing@sub-check-diversions:6] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:12] Set("PJSIP/tel***-00000e29", "CALLERID(all)="DUNN,STERLING" <+13*********>") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-check-diversions:13] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:14] GotoIf("PJSIP/tel***-00000e29", "0?post-dial") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:15] Gosub("PJSIP/tel***-00000e29", "sub-crm-setup,s,1(6700,+13*********)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-crm-setup:1] NoOp("PJSIP/tel***-00000e29", "Init CRM Setup...") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-crm-setup:2] GotoIf("PJSIP/tel***-00000e29", "1?:after-crm") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-crm-setup:3] GotoIf("PJSIP/tel***-00000e29", "0?:after-crm") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-crm-setup,s,12)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-crm-setup:12] NoOp("PJSIP/tel***-00000e29", "CRM Processed...") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-crm-setup:13] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:16] Gosub("PJSIP/tel***-00000e29", "parse-dial-string,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:1] NoOp("PJSIP/tel***-00000e29", "Parsing dial string: PJSIP/TPC6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:2] Set("PJSIP/tel***-00000e29", "NEW_DIAL_STRING=") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:3] Set("PJSIP/tel***-00000e29", "COUNTER=1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:4] Set("PJSIP/tel***-00000e29", "CURRENT_DEVICE=PJSIP/TPC6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:5] While("PJSIP/tel***-00000e29", "1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:6] Set("PJSIP/tel***-00000e29", "TECHNOLOGY=PJSIP") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:7] Set("PJSIP/tel***-00000e29", "USER=TPC6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:8] GotoIf("PJSIP/tel***-00000e29", "1?:regular") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:9] Goto("PJSIP/tel***-00000e29", "regular-pjsip") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (parse-dial-string,s,12)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:12] Set("PJSIP/tel***-00000e29", "PARSED_DEV=PJSIP/TPC6700/sip:TPC6700@10.*.*.*:5060") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:13] ExecIf("PJSIP/tel***-00000e29", "0?Set(PARSED_DEV=PJSIP/TPC6700)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:14] Goto("PJSIP/tel***-00000e29", "append") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (parse-dial-string,s,16)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:16] GotoIf("PJSIP/tel***-00000e29", "1?:concatenate") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:17] Set("PJSIP/tel***-00000e29", "NEW_DIAL_STRING=PJSIP/TPC6700/sip:TPC6700@10.*.*.*:5060") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:18] Goto("PJSIP/tel***-00000e29", "next") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (parse-dial-string,s,21)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:21] Set("PJSIP/tel***-00000e29", "COUNTER=2") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:22] Set("PJSIP/tel***-00000e29", "CURRENT_DEVICE=") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:23] EndWhile("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:5] While("PJSIP/tel***-00000e29", "0") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:24] NoOp("PJSIP/tel***-00000e29", "New dialstring: PJSIP/TPC6700/sip:TPC6700@10.*.*.*:5060") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:25] Set("PJSIP/tel***-00000e29", "DIAL_STRING=PJSIP/TPC6700/sip:TPC6700@10.*.*.*:5060") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@parse-dial-string:26] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:17] NoOp("PJSIP/tel***-00000e29", "Configuring Dial Settings") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:18] Set("PJSIP/tel***-00000e29", "RING_TIME=30") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:19] Set("PJSIP/tel***-00000e29", "RING_TIME=30") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:20] Set("PJSIP/tel***-00000e29", "RING_TIME=30") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:21] Set("PJSIP/tel***-00000e29", "RING_TIME=30") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:22] Set("PJSIP/tel***-00000e29", "DIAL_OPTIONS=ktrm(default)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:23] Set("PJSIP/tel***-00000e29", "DIAL_OPTIONS=ktrm(default)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:24] GotoIf("PJSIP/tel***-00000e29", "0?:answermode") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-local-dialing,6700,28)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:28] Set("PJSIP/tel***-00000e29", "ANSWER_MODE=disable") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:29] Set("PJSIP/tel***-00000e29", "ANSWER_MODE=disable") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:30] GotoIf("PJSIP/tel***-00000e29", "0?check-hd") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:31] ExecIf("PJSIP/tel***-00000e29", "0?Set(EXEC_AA=yes)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:32] ExecIf("PJSIP/tel***-00000e29", "0?Set(EXEC_AA=yes)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:33] Set("PJSIP/tel***-00000e29", "IS_HOT_DESK=no") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:34] Set("PJSIP/tel***-00000e29", "MOH_CLASS=default") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:35] GosubIf("PJSIP/tel***-00000e29", "0?sub-set-moh,s,1(default):moh,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [moh@sub-local-dialing:1] NoOp("PJSIP/tel***-00000e29", "Set Music on Hold") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [moh@sub-local-dialing:2] GotoIf("PJSIP/tel***-00000e29", "0?:return") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-local-dialing,moh,4)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [moh@sub-local-dialing:4] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:36] GotoIf("PJSIP/tel***-00000e29", "0?busy-here") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:37] Set("PJSIP/tel***-00000e29", "FORCE_RECORDING=no") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:38] Set("PJSIP/tel***-00000e29", "DIAL_OPTIONS=ktrm(default)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:39] Set("PJSIP/tel***-00000e29", "DIAL_OPTIONS=ktrm(default)b(sub-before-connecting-call^s^1(eb98fd40ec643319^+13*********^6700^^))") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:40] Set("PJSIP/tel***-00000e29", "DIAL_OPTIONS=ktrm(default)b(sub-before-connecting-call^s^1(eb98fd40ec643319^+13*********^6700^^))U(sub-before-bridging-call^eb98fd40ec643319^+13*********^6700^no)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:41] Set("PJSIP/tel***-00000e29", "__TRANSFERED_CALL=TRUE") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:42] NoOp("PJSIP/tel***-00000e29", "Enable Follow-Me Ring Time If needed") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:43] GotoIf("PJSIP/tel***-00000e29", "1?:check-rt") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:44] GotoIf("PJSIP/tel***-00000e29", "0?:set-fw-rt") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-local-dialing,6700,48)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:48] NoOp("PJSIP/tel***-00000e29", "Using Follow-me Ring Time") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:49] Set("PJSIP/tel***-00000e29", "RING_TIME=30") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:50] GotoIf("PJSIP/tel***-00000e29", "0?post-dial") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:51] GotoIf("PJSIP/tel***-00000e29", "0?end_call") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:52] Gosub("PJSIP/tel***-00000e29", "sub-udpate-virtual-dev-state,s,1(6700,BUSY)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:1] NoOp("PJSIP/tel***-00000e29", "Update Virtual Devices State") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:2] Set("PJSIP/tel***-00000e29", "EXT_NUM=6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:3] Set("PJSIP/tel***-00000e29", "NEW_STATUS=BUSY") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:4] Set("PJSIP/tel***-00000e29", "HAS_VIRTUAL_DEVICES=no") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:5] GotoIf("PJSIP/tel***-00000e29", "1?no_rows") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-udpate-virtual-dev-state,s,15)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:15] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:53] Gosub("PJSIP/tel***-00000e29", "sub-setup-callrec-name,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:1] NoOp("PJSIP/tel***-00000e29", "Setting up call recording file name for eb98fd40ec643319") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:2] GotoIf("PJSIP/tel***-00000e29", "0?end") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:3] Set("PJSIP/tel***-00000e29", "RECORDING_ID=1737486240.7260") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:4] Set("PJSIP/tel***-00000e29", "APP_TYPE=NONE") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:5] Set("PJSIP/tel***-00000e29", "AUDIO_FILE=110444-IN-NONE-+13*********-6700-1737486240.7260") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:6] Set("PJSIP/tel***-00000e29", "RECORDING_FORMAT=wav") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:7] Set("PJSIP/tel***-00000e29", "__REC_FILENAME=/var/spool/asterisk/monitor/2025/01/21/110444-IN-NONE-+13*********-6700-1737486240.7260.wav") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:8] GotoIf("PJSIP/tel***-00000e29", "1?:end") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:9] NoOp("PJSIP/tel***-00000e29", "Append tenant to recording path") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:10] Set("PJSIP/tel***-00000e29", "__REC_FILENAME=/var/spool/asterisk/monitor/eb98fd40ec643319/2025/01/21/110444-IN-NONE-+13*********-6700-1737486240.7260.wav") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-setup-callrec-name:11] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [6700@sub-local-dialing:54] Dial("PJSIP/tel***-00000e29", "PJSIP/TPC6700/sip:TPC6700@10.*.*.*:5060,30,ktrm(default)b(sub-before-connecting-call^s^1(eb98fd40ec643319^+13*********^6700^^))U(sub-before-bridging-call^eb98fd40ec643319^+13*********^6700^no)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] app_stack.c: PJSIP/TPC6700-00000e2c Internal Gosub(sub-before-connecting-call,s,1(eb98fd40ec643319,+13*********,6700,,)) start
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:1] NoOp("PJSIP/TPC6700-00000e2c", "Executing routines in the newly created channel before initiaing the call") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:2] Set("PJSIP/TPC6700-00000e2c", "TENANT=eb98fd40ec643319") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:3] Set("PJSIP/TPC6700-00000e2c", "CALLER=+13*********") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:4] Set("PJSIP/TPC6700-00000e2c", "CALLEE=6700") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:5] Set("PJSIP/TPC6700-00000e2c", "EXEC_AA=") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:6] Set("PJSIP/TPC6700-00000e2c", "CUSTOM_ALERT_INFO=") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:7] Set("PJSIP/TPC6700-00000e2c", "APP_TYPE=NONE") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:8] GosubIf("PJSIP/TPC6700-00000e2c", "0?sub-auto-answer,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:9] GosubIf("PJSIP/TPC6700-00000e2c", "0?sub-set-custom-header,s,1(Alert-Info,)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:10] GosubIf("PJSIP/TPC6700-00000e2c", "0?sub-set-custom-header,s,1(Call-Info,)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:11] Gosub("PJSIP/TPC6700-00000e2c", "sub-set-custom-header,s,1(CALL-TYPE,IN)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:1] NoOp("PJSIP/TPC6700-00000e2c", "Setting up custom header") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:2] GotoIf("PJSIP/TPC6700-00000e2c", "0?set-sip") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:3] NoOp("PJSIP/TPC6700-00000e2c", "Add PJSIP Headers") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:4] Set("PJSIP/TPC6700-00000e2c", "PJSIP_HEADER(add,CALL-TYPE)=IN") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:5] Goto("PJSIP/TPC6700-00000e2c", "end") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-set-custom-header,s,8)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:8] Return("PJSIP/TPC6700-00000e2c", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:12] Gosub("PJSIP/TPC6700-00000e2c", "sub-set-custom-header,s,1(APPLICATION,NONE)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:1] NoOp("PJSIP/TPC6700-00000e2c", "Setting up custom header") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:2] GotoIf("PJSIP/TPC6700-00000e2c", "0?set-sip") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:3] NoOp("PJSIP/TPC6700-00000e2c", "Add PJSIP Headers") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:4] Set("PJSIP/TPC6700-00000e2c", "PJSIP_HEADER(add,APPLICATION)=NONE") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:5] Goto("PJSIP/TPC6700-00000e2c", "end") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-set-custom-header,s,8)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:8] Return("PJSIP/TPC6700-00000e2c", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:13] Gosub("PJSIP/TPC6700-00000e2c", "sub-set-custom-header,s,1(X-CID,b4508f9d-bd92-4261-ac94-b48b086df6ed)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:1] NoOp("PJSIP/TPC6700-00000e2c", "Setting up custom header") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:2] GotoIf("PJSIP/TPC6700-00000e2c", "0?set-sip") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:3] NoOp("PJSIP/TPC6700-00000e2c", "Add PJSIP Headers") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:4] Set("PJSIP/TPC6700-00000e2c", "PJSIP_HEADER(add,X-CID)=b4508f9d-bd92-4261-ac94-b48b086df6ed") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:5] Goto("PJSIP/TPC6700-00000e2c", "end") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-set-custom-header,s,8)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-custom-header:8] Return("PJSIP/TPC6700-00000e2c", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:14] Gosub("PJSIP/TPC6700-00000e2c", "sub-set-crm-headers,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-crm-headers:1] NoOp("PJSIP/TPC6700-00000e2c", "Set CRM headers if needed") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-crm-headers:2] GotoIf("PJSIP/TPC6700-00000e2c", "1?end") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-set-crm-headers,s,5)
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-set-crm-headers:5] Return("PJSIP/TPC6700-00000e2c", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:15] GosubIf("PJSIP/TPC6700-00000e2c", "0?sub-set-custom-header,s,1(QUEUE-NAME,)") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:16] GosubIf("PJSIP/TPC6700-00000e2c", "0?T2_before-connecting-call-hook,s,1") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-connecting-call:17] Return("PJSIP/TPC6700-00000e2c", "") in new stack
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] app_stack.c: Spawn extension (T2_cos-all, 6700, 1) exited non-zero on 'PJSIP/TPC6700-00000e2c'
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] app_stack.c: PJSIP/TPC6700-00000e2c Internal Gosub(sub-before-connecting-call,s,1(eb98fd40ec643319,+13*********,6700,,)) complete GOSUB_RETVAL=
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] app_dial.c: Called PJSIP/TPC6700/sip:TPC6700@10.*.*.*:5060
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] res_musiconhold.c: Started music on hold, class 'default', on channel 'PJSIP/tel***-00000e29'
[2025-01-21 11:04:44] VERBOSE[1452865][C-00000699] app_dial.c: PJSIP/TPC6700-00000e2c is ringing
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] app_dial.c: PJSIP/TPC6700-00000e2c answered PJSIP/tel***-00000e29
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] app_stack.c: PJSIP/TPC6700-00000e2c Internal Gosub(sub-before-bridging-call,s,1(eb98fd40ec643319,+13*********,6700,no)) start
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:1] NoOp("PJSIP/TPC6700-00000e2c", "Executing sub-routine before connecting to the calling channel") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:2] Set("PJSIP/TPC6700-00000e2c", "TENANT=eb98fd40ec643319") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:3] Set("PJSIP/TPC6700-00000e2c", "CALLER=+13*********") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:4] Set("PJSIP/TPC6700-00000e2c", "CALLEE=6700") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:5] Set("PJSIP/TPC6700-00000e2c", "FORCE_CALL_RECORDING=no") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:6] NoOp("PJSIP/TPC6700-00000e2c", "Check if the follow-me confirmation sub-routine needs to be executed") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:7] GotoIf("PJSIP/TPC6700-00000e2c", "1?call-recording") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-before-bridging-call,s,9)
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:9] NoOp("PJSIP/TPC6700-00000e2c", "Executing the call-recording sub-routine") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:10] Gosub("PJSIP/TPC6700-00000e2c", "sub-call-recording,s,1(eb98fd40ec643319,+13*********,6700,no)") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:1] NoOp("PJSIP/TPC6700-00000e2c", "Check if call will be recorded on tenant eb98fd40ec643319") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:2] NoOp("PJSIP/TPC6700-00000e2c", "Call Type: 2 ") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:3] Set("PJSIP/TPC6700-00000e2c", "TENANT=eb98fd40ec643319") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:4] Set("PJSIP/TPC6700-00000e2c", "CALLER=+13*********") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:5] Set("PJSIP/TPC6700-00000e2c", "CALLEE=6700") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:6] Set("PJSIP/TPC6700-00000e2c", "APP_FORCE=no") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:7] GotoIf("PJSIP/TPC6700-00000e2c", "1?:rec_no_available") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:8] GotoIf("PJSIP/TPC6700-00000e2c", "0?perform-recording") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:9] Set("PJSIP/TPC6700-00000e2c", "INTERNAL_REC=no") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:10] GotoIf("PJSIP/TPC6700-00000e2c", "0?perform-recording") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:11] Set("PJSIP/TPC6700-00000e2c", "INTERNAL_REC=") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:12] GotoIf("PJSIP/TPC6700-00000e2c", "0?perform-recording") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:13] Set("PJSIP/TPC6700-00000e2c", "INCOMING_REC=no") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:14] GotoIf("PJSIP/TPC6700-00000e2c", "0?perform-recording") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:15] Set("PJSIP/TPC6700-00000e2c", "OUTGOING_REC=") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:16] GotoIf("PJSIP/TPC6700-00000e2c", "0?perform-recording") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:17] Goto("PJSIP/TPC6700-00000e2c", "return") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-call-recording,s,21)
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-recording:21] Return("PJSIP/TPC6700-00000e2c", "") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:11] NoOp("PJSIP/TPC6700-00000e2c", "Check if there's a custom sub-routine defined for executing it") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:12] GosubIf("PJSIP/TPC6700-00000e2c", "0?T2_before-bridging-call-hook,s,1") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-before-bridging-call:13] Return("PJSIP/TPC6700-00000e2c", "") in new stack
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] app_stack.c: Spawn extension (T2_cos-all, , 1) exited non-zero on 'PJSIP/TPC6700-00000e2c'
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] app_stack.c: PJSIP/TPC6700-00000e2c Internal Gosub(sub-before-bridging-call,s,1(eb98fd40ec643319,+13*********,6700,no)) complete GOSUB_RETVAL=
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] res_musiconhold.c: Stopped music on hold on PJSIP/tel***-00000e29
[2025-01-21 11:04:53] VERBOSE[1452865][C-00000699] bridge_channel.c: Channel PJSIP/tel***-00000e29 joined 'simple_bridge' basic-bridge <95f0fcf8-a07e-4d46-af0d-28a9ca9742ab>
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] bridge_channel.c: Channel PJSIP/tel***-00000e29 left 'simple_bridge' basic-bridge <95f0fcf8-a07e-4d46-af0d-28a9ca9742ab>
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Spawn extension (sub-local-dialing, 6700, 54) exited non-zero on 'PJSIP/tel***-00000e29'
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:1] NoOp("PJSIP/tel***-00000e29", "Finishing the call") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:2] System("PJSIP/tel***-00000e29", "test -e /var/spool/asterisk/monitor/eb98fd40ec643319/2025/01/21/110444-IN-NONE-+13*********-6700-1737486240.7260.wav") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:3] ExecIf("PJSIP/tel***-00000e29", "0?Set(CDR(recfile)=/var/spool/asterisk/monitor/eb98fd40ec643319/2025/01/21/110444-IN-NONE-+13*********-6700-1737486240.7260.wav)") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:4] Gosub("PJSIP/tel***-00000e29", "sub-udpate-virtual-dev-state,s,1(6700,NOT_INUSE)") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:1] NoOp("PJSIP/tel***-00000e29", "Update Virtual Devices State") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:2] Set("PJSIP/tel***-00000e29", "EXT_NUM=6700") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:3] Set("PJSIP/tel***-00000e29", "NEW_STATUS=NOT_INUSE") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:4] Set("PJSIP/tel***-00000e29", "HAS_VIRTUAL_DEVICES=no") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:5] GotoIf("PJSIP/tel***-00000e29", "1?no_rows") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-udpate-virtual-dev-state,s,15)
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-udpate-virtual-dev-state:15] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:5] GosubIf("PJSIP/tel***-00000e29", "0?dynamic-routing-connected,s,1(ANSWER,+13*********)") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:6] GotoIf("PJSIP/tel***-00000e29", "0?check-if-qc") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:7] Gosub("PJSIP/tel***-00000e29", "sub-notify-missed-call,s,1(eb98fd40ec643319,6700,ANSWER,+13*********,DUNN,STERLING,2,,)") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:1] NoOp("PJSIP/tel***-00000e29", "Check if call is missed and need to be notified") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:2] Set("PJSIP/tel***-00000e29", "TENANT=eb98fd40ec643319") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:3] Set("PJSIP/tel***-00000e29", "CALLEE_NUM=6700") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:4] Set("PJSIP/tel***-00000e29", "STATUS=ANSWER") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:5] Set("PJSIP/tel***-00000e29", "CALLER_NUM=+13*********") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:6] Set("PJSIP/tel***-00000e29", "CALLER_NAME=DUNN") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:7] Set("PJSIP/tel***-00000e29", "CALL_DIR=STERLING") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:8] Set("PJSIP/tel***-00000e29", "DP_APP=2") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:9] Set("PJSIP/tel***-00000e29", "DP_APP_DESC=") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:10] Set("PJSIP/tel***-00000e29", "NOTIFY_MISSED_CALLS=no") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:11] GotoIf("PJSIP/tel***-00000e29", "1?last_stage") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-notify-missed-call,s,17)
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:17] NoOp("PJSIP/tel***-00000e29", "Finished missed call notification test") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-notify-missed-call:18] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:8] GotoIf("PJSIP/tel***-00000e29", "0?call_ended") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:9] Gosub("PJSIP/tel***-00000e29", "sub-log-crm-call,s,1") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-log-crm-call:1] NoOp("PJSIP/tel***-00000e29", "Logging Call on CRM") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-log-crm-call:2] Set("PJSIP/tel***-00000e29", "EXTERN_NUM=+13*********") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-log-crm-call:3] GotoIf("PJSIP/tel***-00000e29", "0?:end") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-log-crm-call,s,6)
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-log-crm-call:6] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:10] GosubIf("PJSIP/tel***-00000e29", "0?wake-up-no-answered,s,1") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:11] Gosub("PJSIP/tel***-00000e29", "sub-call-completion-check,s,1") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-completion-check:1] NoOp("PJSIP/tel***-00000e29", "FEATURE: CALL COMPLETION CHECK") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-completion-check:2] Set("PJSIP/tel***-00000e29", "CC_MODE=none") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-completion-check:3] Set("PJSIP/tel***-00000e29", "CC_MODE=none") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-completion-check:4] Set("PJSIP/tel***-00000e29", "CC_MODE=none") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-completion-check:5] GotoIf("PJSIP/tel***-00000e29", "1?end") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (sub-call-completion-check,s,17)
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@sub-call-completion-check:17] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:12] NoOp("PJSIP/tel***-00000e29", "Call ended") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:13] Gosub("PJSIP/tel***-00000e29", "notify-call-hangup,s,1") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@notify-call-hangup:1] Verbose("PJSIP/tel***-00000e29", "0, Extension Hangup") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] app_verbose.c: Extension Hangup
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@notify-call-hangup:2] GotoIf("PJSIP/tel***-00000e29", "0?:incoming") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx_builtins.c: Goto (notify-call-hangup,s,5)
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@notify-call-hangup:5] Verbose("PJSIP/tel***-00000e29", "0, Extension Hangup - Incoming Call") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] app_verbose.c: Extension Hangup - Incoming Call
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@notify-call-hangup:6] UserEvent("PJSIP/tel***-00000e29", ""EXTENSIONS_SUMMARY","Data: INCOMING,+13*********,PJSIP/TPC6700-00000e2c,IN"") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [s@notify-call-hangup:7] Return("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:14] GosubIf("PJSIP/tel***-00000e29", "0?T2_end-ext-dialing-hook,s,1") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Executing [h@sub-local-dialing:15] Hangup("PJSIP/tel***-00000e29", "") in new stack
[2025-01-21 11:04:54] VERBOSE[1452865][C-00000699] pbx.c: Spawn extension (sub-local-dialing, h, 15) exited non-zero on 'PJSIP/tel***-00000e29'

zahid · January 21, 2025, 7:38pm

I just finished my testing AI assistant and it is working as i defined or instruct my AI. For testing purpose you can make a call on this number and see how it is responding
+16312460606 for Queue routing ask Sales, Marketing and Representative or say James as Extension routing test

zahid · January 21, 2025, 7:44pm

Which GPT model did you select for your AI as per Open AI recommendation GPT-4o-mini is suitable and affordable and selected this model working fine for me

SterlingDunn · January 21, 2025, 7:49pm

I have tried various models each with about the same results. Your AI seems to be a bit more responsive than mine for some reason.
I am curious what version of vitalpbx are you running and what AI apps version. I am on vitalpbx 4.2.0-3 and AI assistant version 4.0.1-6.

zahid · January 21, 2025, 7:53pm

I tried it on both versions 4.2.0-2 and currently testing on 4.5.0-4. Have you received any response from your AI

SterlingDunn · January 21, 2025, 7:59pm

I receive responses well enough but it does not follow through for routing. Often times after my welcome message and the tone it does not respond well. Almost like it wont hear me or like its already in the conversation and just says goodbye.

SterlingDunn · January 21, 2025, 8:05pm

Even vitxi i just noticed is broken for me. Something seems wrong with this recent update.

system · February 20, 2025, 8:06pm

This topic was automatically closed 30 days after the last reply. New replies are no longer allowed.