Ring Groups not working

Status
Not open for further replies.
S

ska

New Member
Aug 7, 2019
10
1
3
36
Hi everyone,

I'm still new to fusionpbx. Besides the working extensions for every user, I'd like to add 3 ring groups. However, the ring groups aren't working and I don't really know why.

For testing, I added a greeting to one ring group and called - the greeting plays and afterwards the call is cancelled, even though I have destinations defined. The log file says "Assertion failed". Can you tell me how I could approach this problem?

Code: 
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [DEBUG] switch_core_state_machine.c:749 (sofia/external/00491514025****@10.23.101.13) State DESTROY going to sleep
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [DEBUG] switch_core_state_machine.c:181 sofia/external/00491514025****@10.23.101.13 Standard DESTROY
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [DEBUG] mod_sofia.c:365 sofia/external/00491514025****@10.23.101.13 SOFIA DESTROY
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [DEBUG] switch_core_state_machine.c:749 (sofia/external/00491514025****@10.23.101.13) State DESTROY
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [DEBUG] switch_core_state_machine.c:739 (sofia/external/00491514025****@10.23.101.13) Running State Change CS_DESTROY (Cur 1 Tot 113)
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/00491514025****@10.23.101.13 [CS_DESTROY]
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [NOTICE] switch_core_session.c:1744 Session 112 (sofia/external/00491514025****@10.23.101.13) Ended
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [DEBUG] switch_core_session.c:1726 Session 112 (sofia/external/00491514025****@10.23.101.13) Locked, Waiting on external entities
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [DEBUG] switch_core_state_machine.c:611 (sofia/external/00491514025****@10.23.101.13) State Change CS_REPORTING -> CS_DESTROY
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [DEBUG] switch_core_state_machine.c:936 (sofia/external/00491514025****@10.23.101.13) State REPORTING going to sleep
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.489758 [DEBUG] switch_core_state_machine.c:174 sofia/external/00491514025****@10.23.101.13 Standard REPORTING, cause: NORMAL_CLEARING
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] switch_core_state_machine.c:936 (sofia/external/00491514025****@10.23.101.13) State REPORTING
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] switch_core_state_machine.c:585 (sofia/external/00491514025****@10.23.101.13) Running State Change CS_REPORTING (Cur 2 Tot 113)
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] switch_core_state_machine.c:620 (sofia/external/00491514025****@10.23.101.13) State Change CS_HANGUP -> CS_REPORTING
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] switch_core_state_machine.c:850 (sofia/external/00491514025****@10.23.101.13) State HANGUP going to sleep
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] switch_core_state_machine.c:60 sofia/external/00491514025****@10.23.101.13 Standard HANGUP, cause: NORMAL_CLEARING
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] mod_sofia.c:514 Sending BYE to sofia/external/00491514025****@10.23.101.13
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] mod_sofia.c:460 Channel sofia/external/00491514025****@10.23.101.13 hanging up, cause: NORMAL_CLEARING
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] switch_core_state_machine.c:850 (sofia/external/00491514025****@10.23.101.13) State HANGUP
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] switch_core_state_machine.c:848 (sofia/external/00491514025****@10.23.101.13) Callstate Change ACTIVE -> HANGUP
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] switch_core_state_machine.c:585 (sofia/external/00491514025****@10.23.101.13) Running State Change CS_HANGUP (Cur 2 Tot 113)
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] switch_core_state_machine.c:651 (sofia/external/00491514025****@10.23.101.13) State EXECUTE going to sleep
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [NOTICE] switch_core_state_machine.c:388 Hangup sofia/external/00491514025****@10.23.101.13 [CS_EXECUTE] [NORMAL_CLEARING]
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [NOTICE] switch_core_state_machine.c:386 sofia/external/00491514025****@10.23.101.13 has executed the last dialplan instruction, hanging up.
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [DEBUG] switch_cpp.cpp:1187 sofia/external/00491514025****@10.23.101.13 destroy/unlink session from object
815dd8c2-637a-4059-8a84-16f639e5e1e0 /usr/share/freeswitch/scripts/app.lua:48: in main chunk
815dd8c2-637a-4059-8a84-16f639e5e1e0 /usr/share/freeswitch/scripts/app/ring_groups/index.lua:405: in main chunk
815dd8c2-637a-4059-8a84-16f639e5e1e0 [C]: in function assert
815dd8c2-637a-4059-8a84-16f639e5e1e0 stack traceback:
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:33.449780 [ERR] mod_lua.cpp:202 /usr/share/freeswitch/scripts/app/ring_groups/index.lua:405: assertion failed!
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:32.429815 [DEBUG] switch_ivr_play_say.c:1933 done playing file /usr/share/freeswitch/sounds/en/us/callie/ivr/ivr-yes_we_have_no_bananas.wav
815dd8c2-637a-4059-8a84-16f639e5e1e0 2019-11-26 14:36:30.689765 [DEBUG] switch_ivr_play_say.c:1492 Codec Activated L16@8000hz 1 channels 20ms
815dd8c2-637a-4059-8a84-16f639e5e1e0 EXECUTE [depth=0] sofia/external/00491514025****@10.23.101.13 playback(ivr/ivr-yes_we_have_no_bananas.wav)
2019-11-26 14:36:30.689765 [WARNING] switch_cpp.cpp:1443 [ring_group] Can not find audio file: ivr/ivr-yes_we_have_no_bananas.wav. Try using it in raw mode.
6ee28c5f-86e8-4925-b78c-107c2303d73e 2019-11-26 14:36:30.209873 [DEBUG] switch_core_state_machine.c:604 (sofia/external/or=@172.83.45.42) State NEW
2019-11-26 14:36:30.209873 [DEBUG] sofia.c:2426 detaching session 6ee28c5f-86e8-4925-b78c-107c2303d73e
2019-11-26 14:36:30.209873 [DEBUG] sofia.c:10336 verifying acl "domains" for ip/port 172.83.45.42:0.

Tell me if you need more or different information.

Thank you very much in advance!

Sebastian
 
DigitalDaz

DigitalDaz

Administrator
Staff member
Sep 29, 2016
3,070
577
113
Try it without the greeting for now, it looks like it has a problem with the greeting.
 
S

ska

New Member
Aug 7, 2019
10
1
3
36
Thanks for the quick reply. I tried without the greeting - same problem unfortunately.

I paste all lines that I think are part of the test call I did. Do you know what "assertion failed" means in this context?

Code: 
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [ERR] mod_lua.cpp:202 /usr/share/freeswitch/scripts/app/ring_groups/index.lua:405: assertion failed!

Code: 
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [DEBUG] switch_core_state_machine.c:749 (sofia/external/00491515908****@10.23.101.12) State DESTROY going to sleep
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [DEBUG] switch_core_state_machine.c:181 sofia/external/00491515908****@10.23.101.12 Standard DESTROY
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [DEBUG] mod_sofia.c:365 sofia/external/00491515908****@10.23.101.12 SOFIA DESTROY
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [DEBUG] switch_core_state_machine.c:749 (sofia/external/00491515908****@10.23.101.12) State DESTROY
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [DEBUG] switch_core_state_machine.c:739 (sofia/external/00491515908****@10.23.101.12) Running State Change CS_DESTROY (Cur 0 Tot 743)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/00491515908****@10.23.101.12 [CS_DESTROY]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [NOTICE] switch_core_session.c:1744 Session 743 (sofia/external/00491515908****@10.23.101.12) Ended
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [DEBUG] switch_core_session.c:1726 Session 743 (sofia/external/00491515908****@10.23.101.12) Locked, Waiting on external entities
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [DEBUG] switch_core_state_machine.c:611 (sofia/external/00491515908****@10.23.101.12) State Change CS_REPORTING -> CS_DESTROY
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [DEBUG] switch_core_state_machine.c:936 (sofia/external/00491515908****@10.23.101.12) State REPORTING going to sleep
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.269761 [DEBUG] switch_core_state_machine.c:174 sofia/external/00491515908****@10.23.101.12 Standard REPORTING, cause: NORMAL_CLEARING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] switch_core_state_machine.c:936 (sofia/external/00491515908****@10.23.101.12) State REPORTING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] switch_core_state_machine.c:585 (sofia/external/00491515908****@10.23.101.12) Running State Change CS_REPORTING (Cur 1 Tot 743)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] switch_core_state_machine.c:620 (sofia/external/00491515908****@10.23.101.12) State Change CS_HANGUP -> CS_REPORTING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] switch_core_state_machine.c:850 (sofia/external/00491515908****@10.23.101.12) State HANGUP going to sleep
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] switch_core_state_machine.c:60 sofia/external/00491515908****@10.23.101.12 Standard HANGUP, cause: NORMAL_CLEARING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] mod_sofia.c:605 Responding to INVITE with: 480
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] mod_sofia.c:460 Channel sofia/external/00491515908****@10.23.101.12 hanging up, cause: NORMAL_CLEARING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] switch_core_state_machine.c:850 (sofia/external/00491515908****@10.23.101.12) State HANGUP
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] switch_core_state_machine.c:848 (sofia/external/00491515908****@10.23.101.12) Callstate Change RINGING -> HANGUP
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] switch_core_state_machine.c:585 (sofia/external/00491515908****@10.23.101.12) Running State Change CS_HANGUP (Cur 1 Tot 743)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] switch_core_state_machine.c:651 (sofia/external/00491515908****@10.23.101.12) State EXECUTE going to sleep
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [NOTICE] switch_core_state_machine.c:388 Hangup sofia/external/00491515908****@10.23.101.12 [CS_EXECUTE] [NORMAL_CLEARING]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [NOTICE] switch_core_state_machine.c:386 sofia/external/00491515908****@10.23.101.12 has executed the last dialplan instruction, hanging up.
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [DEBUG] switch_cpp.cpp:1187 sofia/external/00491515908****@10.23.101.12 destroy/unlink session from object
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 /usr/share/freeswitch/scripts/app.lua:48: in main chunk
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 /usr/share/freeswitch/scripts/app/ring_groups/index.lua:405: in main chunk
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 [C]: in function assert
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 stack traceback:
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.189759 [ERR] mod_lua.cpp:202 /usr/share/freeswitch/scripts/app/ring_groups/index.lua:405: assertion failed!
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] switch_cpp.cpp:755 CoreSession::setVariable(call_timeout, 300)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [NOTICE] mod_dptools.c:1122 Ring Ready sofia/external/00491515908****@10.23.101.12!
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 ring_ready()
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 lua(app.lua ring_groups)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [ring_group_uuid]=[341ea39c-11c9-43e4-b3b8-4a8bfecf4eea]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(ring_group_uuid=341ea39c-11c9-43e4-b3b8-4a8bfecf4eea)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [NOTICE] mod_dptools.c:1122 Ring Ready sofia/external/00491515908****@10.23.101.12!
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] sofia.c:7289 Channel sofia/external/00491515908****@10.23.101.12 entering state [early][180]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [NOTICE] mod_sofia.c:2505 Ring-Ready sofia/external/00491515908****@10.23.101.12!
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 ring_ready()
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 hash(insert/116.203.***.***-last_dial/00491515908****/8)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [RFC2822_DATE]=[Tue, 26 Nov 2019 17:27:14 +0100]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(RFC2822_DATE=Tue, 26 Nov 2019 17:27:14 +0100)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[8]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 export(origination_callee_id_name=8)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [caller_id_number]=[00491515908****]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(caller_id_number=00491515908****)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] switch_core_state_machine.c:329 sofia/external/00491515908****@10.23.101.12 Standard EXECUTE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_sofia.c:209 sofia/external/00491515908****@10.23.101.12 SOFIA EXECUTE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] switch_core_state_machine.c:651 (sofia/external/00491515908****@10.23.101.12) State EXECUTE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] switch_core_state_machine.c:585 (sofia/external/00491515908****@10.23.101.12) Running State Change CS_EXECUTE (Cur 1 Tot 743)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] switch_core_state_machine.c:644 (sofia/external/00491515908****@10.23.101.12) State ROUTING going to sleep
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] switch_core_state_machine.c:287 (sofia/external/00491515908****@10.23.101.12) State Change CS_ROUTING -> CS_EXECUTE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action lua(app.lua ring_groups)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(ring_group_uuid=341ea39c-11c9-43e4-b3b8-4a8bfecf4eea)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action ring_ready()
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [ring group] destination_number(8) =~ /^8$/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->ring group] continue=
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [ring group] destination_number(8) =~ /^0$/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->ring group] continue=
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [ring group] destination_number(8) =~ /^7$/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->ring group] continue=
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [0512239120.00d917] ${user_exists}(true) =~ /false/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->0512239120.00d917] continue=false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [outbound_caller_id_number]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(outbound_caller_id_number=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [outbound_caller_id_name]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(outbound_caller_id_name=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [emergency_caller_id_number]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(emergency_caller_id_number=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [emergency_caller_id_name]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(emergency_caller_id_name=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->default_caller_id] continue=true
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [speed_dial] destination_number(8) =~ /^\*0(.*)$/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->speed_dial] continue=false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [redial] () =~ // break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [redial] destination_number(8) =~ /^(redial|\*870)$/ break=on-true
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->redial] continue=true
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->user_record] continue=true
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [is_loopback] ${is_follow_me_loopback}() =~ /true/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->is_loopback] continue=true
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->call-direction] continue=true
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action export(origination_callee_id_name=${destination_number})
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [variables] () =~ // break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->variables] continue=true
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(caller_id_number=${caller_id_number})
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [caller_id_name]=[00491515908****]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(caller_id_name=00491515908****)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(caller_id_name=${caller_id_name}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [caller_destination]=[8]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(caller_destination=8)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(caller_destination=${destination_number}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [caller-details] ${caller_destination}() =~ /^$/ break=never
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->caller-details] continue=true
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [user_record]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(user_record=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [call_screen_enabled]=[false]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(call_screen_enabled=false)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(call_screen_enabled=${user_data ${destination_number}@${domain_name} var call_screen_enabled}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.169753 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [toll_allow]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(toll_allow=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(toll_allow=${user_data ${destination_number}@${domain_name} var toll_allow}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.149755 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [missed_call_data]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(missed_call_data=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(missed_call_data=${user_data ${destination_number}@${domain_name} var missed_call_data}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.149755 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [missed_call_app]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(missed_call_app=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(missed_call_app=${user_data ${destination_number}@${domain_name} var missed_call_app}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.149755 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [call_timeout]=[30]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(call_timeout=30)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(call_timeout=${user_data ${destination_number}@${domain_name} var call_timeout}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.149755 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [do_not_disturb]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(do_not_disturb=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(do_not_disturb=${user_data ${destination_number}@${domain_name} var do_not_disturb}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.149755 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [follow_me_enabled]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(follow_me_enabled=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(follow_me_enabled=${user_data ${destination_number}@${domain_name} var follow_me_enabled}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.149755 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [forward_all_enabled]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(forward_all_enabled=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.129756 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [forward_user_not_registered_destination]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(forward_user_not_registered_destination=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(forward_user_not_registered_destination=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_destination}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.129756 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [forward_user_not_registered_enabled]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(forward_user_not_registered_enabled=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(forward_user_not_registered_enabled=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_enabled}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.129756 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [forward_no_answer_destination]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(forward_no_answer_destination=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(forward_no_answer_destination=${user_data ${destination_number}@${domain_name} var forward_no_answer_destination}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.129756 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [forward_no_answer_enabled]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(forward_no_answer_enabled=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(forward_no_answer_enabled=${user_data ${destination_number}@${domain_name} var forward_no_answer_enabled}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.129756 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [forward_busy_destination]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(forward_busy_destination=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(forward_busy_destination=${user_data ${destination_number}@${domain_name} var forward_busy_destination}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.129756 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [forward_busy_enabled]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(forward_busy_enabled=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(forward_busy_enabled=${user_data ${destination_number}@${domain_name} var forward_busy_enabled}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.109757 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [forward_all_destination]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(forward_all_destination=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(forward_all_destination=${user_data ${destination_number}@${domain_name} var forward_all_destination}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.109757 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [forward_all_enabled]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(forward_all_enabled=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.109757 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [hold_music]=[UNDEF]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(hold_music=)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(hold_music=${user_data ${destination_number}@${domain_name} var hold_music}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.109757 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [extension_uuid]=[b9d27420-541a-4742-b5a9-2736b19d8e1c]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(extension_uuid=b9d27420-541a-4742-b5a9-2736b19d8e1c)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(extension_uuid=${user_data ${destination_number}@${domain_name} var extension_uuid}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [user_exists] ${user_exists}(true) =~ /^true$/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.109757 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [from_user_exists]=[false]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(from_user_exists=false)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.109757 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [user_exists]=[true]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(user_exists=true)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [user_exists] () =~ // break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [116.203.***.***->user_exists] continue=true
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [INFO] mod_dialplan_xml.c:637 Processing 00491515908**** <00491515908****>->8 in context 116.203.***.***
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:236 sofia/external/00491515908****@10.23.101.12 Standard ROUTING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] mod_sofia.c:154 sofia/external/00491515908****@10.23.101.12 SOFIA ROUTING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] mod_sofia.c:145 Call appears to be already acknowledged
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:644 (sofia/external/00491515908****@10.23.101.12) State ROUTING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:585 (sofia/external/00491515908****@10.23.101.12) Running State Change CS_ROUTING (Cur 1 Tot 743)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:651 (sofia/external/00491515908****@10.23.101.12) State EXECUTE going to sleep
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [NOTICE] switch_ivr.c:2238 Transfer sofia/external/00491515908****@10.23.101.12 to XML[8@116.203.***.***]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_ivr.c:2231 (sofia/external/00491515908****@10.23.101.12) State Change CS_EXECUTE -> CS_ROUTING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 transfer(8 XML 116.203.***.***)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [continue_on_fail]=[true]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(continue_on_fail=true)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [hangup_after_bridge]=[true]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(hangup_after_bridge=true)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:329 sofia/external/00491515908****@10.23.101.12 Standard EXECUTE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] mod_sofia.c:209 sofia/external/00491515908****@10.23.101.12 SOFIA EXECUTE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:651 (sofia/external/00491515908****@10.23.101.12) State EXECUTE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:585 (sofia/external/00491515908****@10.23.101.12) Running State Change CS_EXECUTE (Cur 1 Tot 743)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:644 (sofia/external/00491515908****@10.23.101.12) State ROUTING going to sleep
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:287 (sofia/external/00491515908****@10.23.101.12) State Change CS_ROUTING -> CS_EXECUTE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action transfer(8 XML 116.203.***.***)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(continue_on_fail=true)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(hangup_after_bridge=true)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [domain_name]=[116.203.***.***]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(domain_name=116.203.***.***)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(domain_name=116.203.***.***) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] mod_dptools.c:1672 SET sofia/external/00491515908****@10.23.101.12 [domain_uuid]=[6d5fb977-64e4-4cfc-b54c-5c9377622191]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 set(domain_uuid=6d5fb977-64e4-4cfc-b54c-5c9377622191)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action set(domain_uuid=6d5fb977-64e4-4cfc-b54c-5c9377622191) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[inbound]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 EXECUTE [depth=0] sofia/external/00491515908****@10.23.101.12 export(call_direction=inbound)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Action export(call_direction=inbound) INLINE
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (PASS) [00435122391208] destination_number(00435122391208) =~ /^(00435122391208)$/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [public->00435122391208] continue=false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [00435122391207] destination_number(00435122391208) =~ /^(00435122391207)$/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [public->00435122391207] continue=false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [0043512239120] destination_number(00435122391208) =~ /^(0043512239120)$/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [public->0043512239120] continue=false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 Regex (FAIL) [00435122391203] destination_number(00435122391208) =~ /^(00435122391203)$/ break=on-false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 Dialplan: sofia/external/00491515908****@10.23.101.12 parsing [public->00435122391203] continue=false
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [INFO] mod_dialplan_xml.c:637 Processing 00491515908**** <00491515908****>->00435122391208 in context public
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:236 sofia/external/00491515908****@10.23.101.12 Standard ROUTING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] mod_sofia.c:154 sofia/external/00491515908****@10.23.101.12 SOFIA ROUTING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:644 (sofia/external/00491515908****@10.23.101.12) State ROUTING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_channel.c:2332 (sofia/external/00491515908****@10.23.101.12) Callstate Change DOWN -> RINGING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:585 (sofia/external/00491515908****@10.23.101.12) Running State Change CS_ROUTING (Cur 1 Tot 743)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:628 (sofia/external/00491515908****@10.23.101.12) State INIT going to sleep
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:48 (sofia/external/00491515908****@10.23.101.12) State Change CS_INIT -> CS_ROUTING
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:40 sofia/external/00491515908****@10.23.101.12 Standard INIT
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] mod_sofia.c:93 sofia/external/00491515908****@10.23.101.12 SOFIA INIT
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:628 (sofia/external/00491515908****@10.23.101.12) State INIT
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:585 (sofia/external/00491515908****@10.23.101.12) Running State Change CS_INIT (Cur 1 Tot 743)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:604 (sofia/external/00491515908****@10.23.101.12) State NEW
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] sofia.c:7723 (sofia/external/00491515908****@10.23.101.12) State Change CS_NEW -> CS_INIT
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5907 sofia/external/00491515908****@10.23.101.12 Set 2833 dtmf send payload to 101 recv payload to 101
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5849 Set telephone-event payload to 101@8000
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_codec.c:111 sofia/external/00491515908****@10.23.101.12 Original read codec set to PCMA:8
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:3834 Set Codec sofia/external/00491515908****@10.23.101.12 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5506 Set telephone-event payload to 101@8000
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5645 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5645 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 a=ptime:20
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 a=rtcp-mux
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 a=rtcp:56753
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 a=fmtp:101 0-16
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 a=rtpmap:101 telephone-event/8000
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 a=rtpmap:18 G729/8000
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 a=rtpmap:0 PCMU/8000
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 a=rtpmap:8 PCMA/8000
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 m=audio 56752 RTP/AVP 8 0 18 101
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 a=rtpengine:2c48e1f492cb
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 t=0 0
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 c=IN IP4 193.32.51.173
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 s=FreeSWITCH
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 o=FreeSWITCH 1574753666 1574753667 IN IP4 193.32.51.173
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 v=0
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] sofia.c:7299 Remote SDP:
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] sofia.c:7289 Channel sofia/external/00491515908****@10.23.101.12 entering state [received][100]
2019-11-26 17:27:14.089772 [DEBUG] sofia.c:10365 IP 193.32.51.173 Approved by acl "domains[]". Access Granted.
2019-11-26 17:27:14.089772 [DEBUG] sofia.c:10336 verifying acl "domains" for ip/port 193.32.51.173:0.
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] sofia.c:10242 sofia/external/00491515908****@10.23.101.12 receiving invite from 193.32.51.173:5060 version: 1.10.0 -release-11-7a921c608b 64bit
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [DEBUG] switch_core_state_machine.c:585 (sofia/external/00491515908****@10.23.101.12) Running State Change CS_NEW (Cur 1 Tot 743)
36c9aea3-ee8f-45ec-aa71-fc479cbbebd0 2019-11-26 17:27:14.089772 [NOTICE] switch_channel.c:1118 New Channel sofia/external/00491515908****@10.23.101.12 [36c9aea3-ee8f-45ec-aa71-fc479cbbebd0]
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:749 (sofia/external/or=@172.83.45.42) State DESTROY going to sleep
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:181 sofia/external/or=@172.83.45.42 Standard DESTROY
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] mod_sofia.c:365 sofia/external/or=@172.83.45.42 SOFIA DESTROY
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:749 (sofia/external/or=@172.83.45.42) State DESTROY
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:739 (sofia/external/or=@172.83.45.42) Running State Change CS_DESTROY (Cur 0 Tot 742)
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/or=@172.83.45.42 [CS_DESTROY]
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [NOTICE] switch_core_session.c:1744 Session 742 (sofia/external/or=@172.83.45.42) Ended
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_session.c:1726 Session 742 (sofia/external/or=@172.83.45.42) Locked, Waiting on external entities
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:611 (sofia/external/or=@172.83.45.42) State Change CS_REPORTING -> CS_DESTROY
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:936 (sofia/external/or=@172.83.45.42) State REPORTING going to sleep
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:174 sofia/external/or=@172.83.45.42 Standard REPORTING, cause: WRONG_CALL_STATE
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:936 (sofia/external/or=@172.83.45.42) State REPORTING
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:585 (sofia/external/or=@172.83.45.42) Running State Change CS_REPORTING (Cur 1 Tot 742)
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:620 (sofia/external/or=@172.83.45.42) State Change CS_HANGUP -> CS_REPORTING
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:850 (sofia/external/or=@172.83.45.42) State HANGUP going to sleep
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:60 sofia/external/or=@172.83.45.42 Standard HANGUP, cause: WRONG_CALL_STATE
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] mod_sofia.c:460 Channel sofia/external/or=@172.83.45.42 hanging up, cause: WRONG_CALL_STATE
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:850 (sofia/external/or=@172.83.45.42) State HANGUP
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:848 (sofia/external/or=@172.83.45.42) Callstate Change DOWN -> HANGUP
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [DEBUG] switch_core_state_machine.c:585 (sofia/external/or=@172.83.45.42) Running State Change CS_HANGUP (Cur 1 Tot 742)
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [NOTICE] switch_core_state_machine.c:691 Hangup sofia/external/or=@172.83.45.42 [CS_NEW] [WRONG_CALL_STATE]
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:11.769814 [WARNING] switch_core_state_machine.c:688 73598f02-b331-47a5-8d74-cc2e00300eb4 sofia/external/or=@172.83.45.42 Abandoned
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:01.730035 [DEBUG] switch_core_state_machine.c:604 (sofia/external/or=@172.83.45.42) State NEW
2019-11-26 17:27:01.730035 [DEBUG] sofia.c:2426 detaching session 73598f02-b331-47a5-8d74-cc2e00300eb4
2019-11-26 17:27:01.730035 [DEBUG] sofia.c:10336 verifying acl "domains" for ip/port 172.83.45.42:0.
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:01.730035 [DEBUG] sofia.c:10242 sofia/external/or=@172.83.45.42 receiving invite from 172.83.45.42:6257 version: 1.10.0 -release-11-7a921c608b 64bit
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:01.730035 [DEBUG] switch_core_state_machine.c:585 (sofia/external/or=@172.83.45.42) Running State Change CS_NEW (Cur 1 Tot 742)
73598f02-b331-47a5-8d74-cc2e00300eb4 2019-11-26 17:27:01.730035 [NOTICE] switch_channel.c:1118 New Channel sofia/external/or=@172.83.45.42 [73598f02-b331-47a5-8d74-cc2e00300eb4]
 
S

ska

New Member
Aug 7, 2019
10
1
3
36
Does anyone have another idea about this issue? I'm kinda stuck right now.
 
DigitalDaz

DigitalDaz

Administrator
Staff member
Sep 29, 2016
3,070
577
113
Well, I'm pretty sure extensions must be at least two digits.
 
S

ska

New Member
Aug 7, 2019
10
1
3
36
I changed all extensions (extensions and ring group) to two digits. Doesn't work either, unfortunately. Do you have another idea where I could dig for a solution?
 
S

ska

New Member
Aug 7, 2019
10
1
3
36
Sure.

Currently there are several (two digit) extensions under Accounts > extensions for our employees. Additionally I have a test ring group with the extension 07. I have two screenshots with the settings of the ring group and the dial plan attached.

ring group inbound dial plan
ring-group-inbound-dial-plan.png

ring group settings
ring-group-settings.png

The ring group currently only has one destination - the extension 03.

Here's the log from a test call:
Code: 
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [DEBUG] switch_core_state_machine.c:749 (sofia/external/0049151******14@10.23.101.12) State DESTROY going to sleep
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [DEBUG] switch_core_state_machine.c:181 sofia/external/0049151******14@10.23.101.12 Standard DESTROY
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [DEBUG] mod_sofia.c:365 sofia/external/0049151******14@10.23.101.12 SOFIA DESTROY
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [DEBUG] switch_core_state_machine.c:749 (sofia/external/0049151******14@10.23.101.12) State DESTROY
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [DEBUG] switch_core_state_machine.c:739 (sofia/external/0049151******14@10.23.101.12) Running State Change CS_DESTROY (Cur 0 Tot 2042)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/0049151******14@10.23.101.12 [CS_DESTROY]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [NOTICE] switch_core_session.c:1744 Session 2042 (sofia/external/0049151******14@10.23.101.12) Ended
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [DEBUG] switch_core_session.c:1726 Session 2042 (sofia/external/0049151******14@10.23.101.12) Locked, Waiting on external entities
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [DEBUG] switch_core_state_machine.c:611 (sofia/external/0049151******14@10.23.101.12) State Change CS_REPORTING -> CS_DESTROY
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [DEBUG] switch_core_state_machine.c:936 (sofia/external/0049151******14@10.23.101.12) State REPORTING going to sleep
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.912722 [DEBUG] switch_core_state_machine.c:174 sofia/external/0049151******14@10.23.101.12 Standard REPORTING, cause: NORMAL_CLEARING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_core_state_machine.c:936 (sofia/external/0049151******14@10.23.101.12) State REPORTING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0049151******14@10.23.101.12) Running State Change CS_REPORTING (Cur 1 Tot 2042)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_core_state_machine.c:620 (sofia/external/0049151******14@10.23.101.12) State Change CS_HANGUP -> CS_REPORTING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_core_state_machine.c:850 (sofia/external/0049151******14@10.23.101.12) State HANGUP going to sleep
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_core_state_machine.c:60 sofia/external/0049151******14@10.23.101.12 Standard HANGUP, cause: NORMAL_CLEARING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] mod_sofia.c:605 Responding to INVITE with: 480
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] mod_sofia.c:460 Channel sofia/external/0049151******14@10.23.101.12 hanging up, cause: NORMAL_CLEARING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_core_state_machine.c:850 (sofia/external/0049151******14@10.23.101.12) State HANGUP
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_core_state_machine.c:848 (sofia/external/0049151******14@10.23.101.12) Callstate Change RINGING -> HANGUP
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0049151******14@10.23.101.12) Running State Change CS_HANGUP (Cur 1 Tot 2042)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_core_state_machine.c:651 (sofia/external/0049151******14@10.23.101.12) State EXECUTE going to sleep
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [NOTICE] switch_core_state_machine.c:388 Hangup sofia/external/0049151******14@10.23.101.12 [CS_EXECUTE] [NORMAL_CLEARING]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [NOTICE] switch_core_state_machine.c:386 sofia/external/0049151******14@10.23.101.12 has executed the last dialplan instruction, hanging up.
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_cpp.cpp:1187 sofia/external/0049151******14@10.23.101.12 destroy/unlink session from object
5c0f74c2-29a1-4593-8964-8f127c7cc858 /usr/share/freeswitch/scripts/app.lua:48: in main chunk
5c0f74c2-29a1-4593-8964-8f127c7cc858 /usr/share/freeswitch/scripts/app/ring_groups/index.lua:405: in main chunk
5c0f74c2-29a1-4593-8964-8f127c7cc858 [C]: in function assert
5c0f74c2-29a1-4593-8964-8f127c7cc858 stack traceback:
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [ERR] mod_lua.cpp:202 /usr/share/freeswitch/scripts/app/ring_groups/index.lua:405: assertion failed!
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [DEBUG] switch_cpp.cpp:755 CoreSession::setVariable(call_timeout, 300)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.852714 [NOTICE] mod_dptools.c:1122 Ring Ready sofia/external/0049151******14@10.23.101.12!
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 ring_ready()
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 lua(app.lua ring_groups)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [ring_group_uuid]=[ea7a5b5d-ea7b-414b-9208-9ef55dd4ec30]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(ring_group_uuid=ea7a5b5d-ea7b-414b-9208-9ef55dd4ec30)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [NOTICE] mod_dptools.c:1122 Ring Ready sofia/external/0049151******14@10.23.101.12!
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] sofia.c:7289 Channel sofia/external/0049151******14@10.23.101.12 entering state [early][180]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [NOTICE] mod_sofia.c:2505 Ring-Ready sofia/external/0049151******14@10.23.101.12!
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 ring_ready()
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 hash(insert/116.203.195.10-last_dial/0049151******14/07)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [RFC2822_DATE]=[Fri, 13 Dec 2019 12:01:00 +0100]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(RFC2822_DATE=Fri, 13 Dec 2019 12:01:00 +0100)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[07]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 export(origination_callee_id_name=07)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [caller_id_number]=[0049151******14]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(caller_id_number=0049151******14)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] switch_core_state_machine.c:329 sofia/external/0049151******14@10.23.101.12 Standard EXECUTE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_sofia.c:209 sofia/external/0049151******14@10.23.101.12 SOFIA EXECUTE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] switch_core_state_machine.c:651 (sofia/external/0049151******14@10.23.101.12) State EXECUTE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0049151******14@10.23.101.12) Running State Change CS_EXECUTE (Cur 1 Tot 2042)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] switch_core_state_machine.c:644 (sofia/external/0049151******14@10.23.101.12) State ROUTING going to sleep
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] switch_core_state_machine.c:287 (sofia/external/0049151******14@10.23.101.12) State Change CS_ROUTING -> CS_EXECUTE
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action lua(app.lua ring_groups)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(ring_group_uuid=ea7a5b5d-ea7b-414b-9208-9ef55dd4ec30)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action ring_ready()
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [ring group] destination_number(07) =~ /^07$/ break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->ring group] continue=
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [0512239120.00d917] destination_number(07) =~ /^(00\d{9,17})$/ break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [0512239120.00d917] ${user_exists}(false) =~ /false/ break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->0512239120.00d917] continue=false
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [outbound_caller_id_number]=[UNDEF]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(outbound_caller_id_number=)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [outbound_caller_id_name]=[UNDEF]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(outbound_caller_id_name=)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [emergency_caller_id_number]=[UNDEF]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(emergency_caller_id_number=)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [emergency_caller_id_name]=[UNDEF]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(emergency_caller_id_name=)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->default_caller_id] continue=true
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [speed_dial] destination_number(07) =~ /^\*0(.*)$/ break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->speed_dial] continue=false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [redial] () =~ // break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [redial] destination_number(07) =~ /^(redial|\*870)$/ break=on-true
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->redial] continue=true
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->user_record] continue=true
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [is_loopback] ${is_follow_me_loopback}() =~ /true/ break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->is_loopback] continue=true
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action export(origination_callee_id_name=${destination_number})
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [variables] () =~ // break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->variables] continue=true
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->call-direction] continue=true
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(caller_id_number=${caller_id_number})
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [caller_id_name]=[0049151******14]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(caller_id_name=0049151******14)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(caller_id_name=${caller_id_name}) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [caller_destination]=[07]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(caller_destination=07)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(caller_destination=${destination_number}) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [caller-details] ${caller_destination}() =~ /^$/ break=never
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->caller-details] continue=true
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [from_user_exists]=[false]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(from_user_exists=false)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.832712 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [user_exists]=[false]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(user_exists=false)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [user_exists] () =~ // break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [116.203.195.10->user_exists] continue=true
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [INFO] mod_dialplan_xml.c:637 Processing 0049151******14 <0049151******14>->07 in context 116.203.195.10
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:236 sofia/external/0049151******14@10.23.101.12 Standard ROUTING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] mod_sofia.c:154 sofia/external/0049151******14@10.23.101.12 SOFIA ROUTING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] mod_sofia.c:145 Call appears to be already acknowledged
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:644 (sofia/external/0049151******14@10.23.101.12) State ROUTING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0049151******14@10.23.101.12) Running State Change CS_ROUTING (Cur 1 Tot 2042)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:651 (sofia/external/0049151******14@10.23.101.12) State EXECUTE going to sleep
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [NOTICE] switch_ivr.c:2238 Transfer sofia/external/0049151******14@10.23.101.12 to XML[07@116.203.195.10]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_ivr.c:2231 (sofia/external/0049151******14@10.23.101.12) State Change CS_EXECUTE -> CS_ROUTING
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 transfer(07 XML 116.203.195.10)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [continue_on_fail]=[true]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(continue_on_fail=true)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [hangup_after_bridge]=[true]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(hangup_after_bridge=true)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:329 sofia/external/0049151******14@10.23.101.12 Standard EXECUTE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] mod_sofia.c:209 sofia/external/0049151******14@10.23.101.12 SOFIA EXECUTE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:651 (sofia/external/0049151******14@10.23.101.12) State EXECUTE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0049151******14@10.23.101.12) Running State Change CS_EXECUTE (Cur 1 Tot 2042)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:644 (sofia/external/0049151******14@10.23.101.12) State ROUTING going to sleep
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:287 (sofia/external/0049151******14@10.23.101.12) State Change CS_ROUTING -> CS_EXECUTE
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action transfer(07 XML 116.203.195.10)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(continue_on_fail=true)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(hangup_after_bridge=true)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [domain_name]=[116.203.195.10]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(domain_name=116.203.195.10)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(domain_name=116.203.195.10) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] mod_dptools.c:1672 SET sofia/external/0049151******14@10.23.101.12 [domain_uuid]=[6d5fb977-64e4-4cfc-b54c-5c9377622191]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 set(domain_uuid=6d5fb977-64e4-4cfc-b54c-5c9377622191)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action set(domain_uuid=6d5fb977-64e4-4cfc-b54c-5c9377622191) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[inbound]
5c0f74c2-29a1-4593-8964-8f127c7cc858 EXECUTE [depth=0] sofia/external/0049151******14@10.23.101.12 export(call_direction=inbound)
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Action export(call_direction=inbound) INLINE
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (PASS) [0043******12007] destination_number(0043******12007) =~ /^(0043******12007)$/ break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [public->0043******12007] continue=false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 Regex (FAIL) [0043******12003] destination_number(0043******12007) =~ /^(0043******12003)$/ break=on-false
5c0f74c2-29a1-4593-8964-8f127c7cc858 Dialplan: sofia/external/0049151******14@10.23.101.12 parsing [public->0043******12003] continue=false
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [INFO] mod_dialplan_xml.c:637 Processing 0049151******14 <0049151******14>->0043******12007 in context public
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:236 sofia/external/0049151******14@10.23.101.12 Standard ROUTING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] mod_sofia.c:154 sofia/external/0049151******14@10.23.101.12 SOFIA ROUTING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:644 (sofia/external/0049151******14@10.23.101.12) State ROUTING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_channel.c:2332 (sofia/external/0049151******14@10.23.101.12) Callstate Change DOWN -> RINGING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0049151******14@10.23.101.12) Running State Change CS_ROUTING (Cur 1 Tot 2042)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:628 (sofia/external/0049151******14@10.23.101.12) State INIT going to sleep
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:48 (sofia/external/0049151******14@10.23.101.12) State Change CS_INIT -> CS_ROUTING
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:40 sofia/external/0049151******14@10.23.101.12 Standard INIT
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] mod_sofia.c:93 sofia/external/0049151******14@10.23.101.12 SOFIA INIT
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:628 (sofia/external/0049151******14@10.23.101.12) State INIT
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0049151******14@10.23.101.12) Running State Change CS_INIT (Cur 1 Tot 2042)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:604 (sofia/external/0049151******14@10.23.101.12) State NEW
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] sofia.c:7723 (sofia/external/0049151******14@10.23.101.12) State Change CS_NEW -> CS_INIT
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5907 sofia/external/0049151******14@10.23.101.12 Set 2833 dtmf send payload to 101 recv payload to 101
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5849 Set telephone-event payload to 101@8000
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_codec.c:111 sofia/external/0049151******14@10.23.101.12 Original read codec set to PCMA:8
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:3834 Set Codec sofia/external/0049151******14@10.23.101.12 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5506 Set telephone-event payload to 101@8000
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5645 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5645 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
5c0f74c2-29a1-4593-8964-8f127c7cc858
5c0f74c2-29a1-4593-8964-8f127c7cc858 a=ptime:20
5c0f74c2-29a1-4593-8964-8f127c7cc858 a=rtcp-mux
5c0f74c2-29a1-4593-8964-8f127c7cc858 a=rtcp:64561
5c0f74c2-29a1-4593-8964-8f127c7cc858 a=fmtp:101 0-16
5c0f74c2-29a1-4593-8964-8f127c7cc858 a=rtpmap:101 telephone-event/8000
5c0f74c2-29a1-4593-8964-8f127c7cc858 a=rtpmap:18 G729/8000
5c0f74c2-29a1-4593-8964-8f127c7cc858 a=rtpmap:0 PCMU/8000
5c0f74c2-29a1-4593-8964-8f127c7cc858 a=rtpmap:8 PCMA/8000
5c0f74c2-29a1-4593-8964-8f127c7cc858 m=audio 64560 RTP/AVP 8 0 18 101
5c0f74c2-29a1-4593-8964-8f127c7cc858 a=rtpengine:2c48e1f492cb
5c0f74c2-29a1-4593-8964-8f127c7cc858 t=0 0
5c0f74c2-29a1-4593-8964-8f127c7cc858 c=IN IP4 193.32.51.173
5c0f74c2-29a1-4593-8964-8f127c7cc858 s=FreeSWITCH
5c0f74c2-29a1-4593-8964-8f127c7cc858 o=FreeSWITCH 1576210535 1576210536 IN IP4 193.32.51.173
5c0f74c2-29a1-4593-8964-8f127c7cc858 v=0
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] sofia.c:7299 Remote SDP:
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] sofia.c:7289 Channel sofia/external/0049151******14@10.23.101.12 entering state [received][100]
2019-12-13 12:01:00.812739 [DEBUG] sofia.c:10365 IP 193.32.51.173 Approved by acl "domains[]". Access Granted.
2019-12-13 12:01:00.812739 [DEBUG] sofia.c:10336 verifying acl "domains" for ip/port 193.32.51.173:0.
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] sofia.c:10242 sofia/external/0049151******14@10.23.101.12 receiving invite from 193.32.51.173:5060 version: 1.10.0 -release-11-7a921c608b 64bit
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [DEBUG] switch_core_state_machine.c:585 (sofia/external/0049151******14@10.23.101.12) Running State Change CS_NEW (Cur 1 Tot 2042)
5c0f74c2-29a1-4593-8964-8f127c7cc858 2019-12-13 12:01:00.812739 [NOTICE] switch_channel.c:1118 New Channel sofia/external/0049151******14@10.23.101.12 [5c0f74c2-29a1-4593-8964-8f127c7cc858]

(I obfuscated phone numbers and my server ip with ***)

Are there any other logs I can dig in?

Thank you for investigating this with me.
 
S

ska

New Member
Aug 7, 2019
10
1
3
36
Happy new year! Do you have any idea where else I could search for an approach to this?
 
J

JamesBorne

Active Member
Jan 24, 2019
294
57
28
Australia
Looking at line 405 of of that file shows kinda nothing (from GitHub source).

Can you confirm your file looks the same on line 405?

Knowing where in the Lua the call is failing may show you what the issue is.
 
S

ska

New Member
Aug 7, 2019
10
1
3
36
My lua seems to be different. The following assert starts on line 405:

Code: 
            assert(dbh:query(sql, params, function(row)
                if (row.ring_group_strategy == "random") then
                    if (database["type"] == "mysql") then
                        sql_order = 'rand()'
                    else
                        sql_order = 'random()' --both postgresql and sqlite uses random() instead of rand()
                    end
                else
                    sql_order='d.destination_delay, d.destination_number asc'
                end
            end));

This ist part of the "--process the ring group". I have the lua attached.
 

Attachments

  • index.lua
    34.2 KB · Views: 6
J

JamesBorne

Active Member
Jan 24, 2019
294
57
28
Australia
That makes more sense.
The query is returning False or nil, which is triggering your assertion to fail.

If it was me, I would pick apart the statement to find out what part is erroring it out.
Will require local debugging to solve this one, I think.
 
S

ska

New Member
Aug 7, 2019
10
1
3
36
Ok. It works now.

I didn't really know how to approach the debugging as I couldn't get my head around what the sql statements may be.

Then I was asking myself again, why the lua files are different and decided to go for an update. I followed the update process that is described in the fusionpbx docs and restarted everything. And now it works. Which is great :D

Thank you Daz and James for your help.
 
  • Like
Reactions: JamesBorne
Status
Not open for further replies.
Top Bottom