Hi All,
Bit of a strange one. Moved all customers from old 4.4 to 5 without too much of a problem apart from 2 domains.
none of the dial plan instructions apart from outgoing and incoming calls work. Not even *97 for vm. I get the following error, could anyone point me in the right direction?
EXECUTE [depth=0] sofia/internal-lan/5000@xxxx.xxxx.xxxx.xxxx:5060 log(WARNING [inbound routes] 404 not found 192.168.100.116)
2022-10-20 07:22:40.866329 97.37% [WARNING] mod_dptools.c:1879 [inbound routes] 404 not found 192.168.100.116
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.446316 97.03% [NOTICE] switch_channel.c:1123 New Channel sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [27d308eb-940c-4159-903e-f104334ae664]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.446316 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_NEW (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.446316 97.03% [INFO] sofia.c:10462 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 receiving invite from 192.168.100.113:12572 version: 1.10.7 -release 64bit call-id: 0_2272274239@192.168.100.113
2022-10-20 07:49:59.446316 97.03% [DEBUG] sofia.c:10556 verifying acl "domains" for ip/port 192.168.100.113:0.
2022-10-20 07:49:59.446316 97.03% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'internal-lan' for [*97@prettylegspbx5.adept-systems.co.uk] from ip 192.168.100.113
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.446316 97.03% [DEBUG] switch_core_state_machine.c:600 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State NEW
2022-10-20 07:49:59.446316 97.03% [DEBUG] sofia.c:2419 detaching session 27d308eb-940c-4159-903e-f104334ae664
2022-10-20 07:49:59.466321 97.03% [DEBUG] sofia.c:2532 Re-attaching to session 27d308eb-940c-4159-903e-f104334ae664
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.466321 97.03% [INFO] sofia.c:10462 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 receiving invite from 192.168.100.113:12572 version: 1.10.7 -release 64bit call-id: 0_2272274239@192.168.100.113
2022-10-20 07:49:59.466321 97.03% [DEBUG] sofia.c:10556 verifying acl "domains" for ip/port 192.168.100.113:0.
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] sofia.c:7499 Channel sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 entering state [received][100]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] sofia.c:7509 Remote SDP:
27d308eb-940c-4159-903e-f104334ae664 v=0
27d308eb-940c-4159-903e-f104334ae664 o=- 20000 20000 IN IP4 192.168.100.113
27d308eb-940c-4159-903e-f104334ae664 s=SDP data
27d308eb-940c-4159-903e-f104334ae664 c=IN IP4 192.168.100.113
27d308eb-940c-4159-903e-f104334ae664 t=0 0
27d308eb-940c-4159-903e-f104334ae664 m=audio 12332 RTP/AVP 0 8 18 9 101
27d308eb-940c-4159-903e-f104334ae664 a=rtpmap:0 PCMU/8000
27d308eb-940c-4159-903e-f104334ae664 a=rtpmap:8 PCMA/8000
27d308eb-940c-4159-903e-f104334ae664 a=rtpmap:18 G729/8000
27d308eb-940c-4159-903e-f104334ae664 a=fmtp:18 annexb=no
27d308eb-940c-4159-903e-f104334ae664 a=rtpmap:9 G722/8000
27d308eb-940c-4159-903e-f104334ae664 a=rtpmap:101 telephone-event/8000
27d308eb-940c-4159-903e-f104334ae664 a=fmtp:101 0-15
27d308eb-940c-4159-903e-f104334ae664 a=ptime:20
27d308eb-940c-4159-903e-f104334ae664
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 101@8000
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:3870 Set Codec sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_codec.c:111 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Original read codec set to PCMU:0
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 101@8000
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5973 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Set 2833 dtmf send payload to 101 recv payload to 101
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] sofia.c:7933 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State Change CS_NEW -> CS_INIT
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_INIT (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:624 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State INIT
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] mod_sofia.c:97 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 SOFIA INIT
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:40 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard INIT
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:48 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State Change CS_INIT -> CS_ROUTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:624 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State INIT going to sleep
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_ROUTING (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_channel.c:2380 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Callstate Change DOWN -> RINGING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:640 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State ROUTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] mod_sofia.c:158 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 SOFIA ROUTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:230 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard ROUTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [INFO] mod_dialplan_xml.c:639 Processing 5000 <5000>->*97 in context prettylegspbx5.adept-systems.co.uk
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->caller-details] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [caller-details] () =~ // break=never
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(caller_destination=${sip_to_user}) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(caller_destination=*97)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.506310 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [caller_destination]=[*97]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(caller_id_name=${caller_id_name}) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(caller_id_name=5000)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.506310 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [caller_id_name]=[5000]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(caller_id_number=${caller_id_number})
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->user_exists] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [user_exists] ${loopback_leg}() =~ /^B$/ break=never
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [user_exists] () =~ // break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(user_exists=false)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.506310 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [user_exists]=[false]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(from_user_exists=true)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.506310 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [from_user_exists]=[true]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->global-variables] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [global-variables] () =~ // break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(timezone=Europe/London) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(timezone=Europe/London)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.506310 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [timezone]=[Europe/London]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->is_loopback] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [is_loopback] ${is_follow_me_loopback}() =~ /true/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->rtp_has_crypto] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [rtp_has_crypto] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Gamma_Adept.d6] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [Gamma_Adept.d6] ${user_exists}(false) =~ /false/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Gamma_Adept.d6] destination_number(*97) =~ /^(\d{6})$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Gamma_Adept.d1014] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [Gamma_Adept.d1014] ${user_exists}(false) =~ /false/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Gamma_Adept.d1014] destination_number(*97) =~ /^\+?(\d{10,14})$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->CUI] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [CUI] destination_number(*97) =~ /^5002$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->BankHol3may] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [BankHol3may] destination_number(*97) =~ /^9998$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->OfficeClosed] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [OfficeClosed] destination_number(*97) =~ /^9999$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Medalin Ring Group] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Medalin Ring Group] destination_number(*97) =~ /^5003$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Main] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Main] destination_number(*97) =~ /^5001$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Customer_Support] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Customer_Support] destination_number(*97) =~ /^([^#]+#)(.*)$/ break=never
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Customer_Support] destination_number(*97) =~ /^(callcenter\+)?6001$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->intercept-ext-polycom] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [intercept-ext-polycom] destination_number(*97) =~ /^\*97(\d+)$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->7003 Medalin] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [7003 Medalin] destination_number(*97) =~ /^7003$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->OfficeHours] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [OfficeHours] destination_number(*97) =~ /^7001$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Medalin-Fax-Server] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Medalin-Fax-Server] destination_number(*97) =~ /^2998$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->extension-to-voicemail] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [extension-to-voicemail] ${user_exists}(false) =~ /^true$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->CUI-Fax-Server] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [CUI-Fax-Server] destination_number(*97) =~ /^2999$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->follow-me-destinations] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [follow-me-destinations] ${user_exists}(false) =~ /^true$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->call-forward-all] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [call-forward-all] ${user_exists}(false) =~ /true/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->call-forward-not-registered] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [call-forward-not-registered] ${user_exists}(false) =~ /true/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->talking clock date and time] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [talking clock date and time] destination_number(*97) =~ /^\*9172$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->talking clock time] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [talking clock time] destination_number(*97) =~ /^\*9170$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->talking clock date] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [talking clock date] destination_number(*97) =~ /^\*9171$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->local_extension] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [local_extension] ${user_exists}(false) =~ /true/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->voicemail] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [voicemail] ${user_exists}(false) =~ /true/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->not-found] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [not-found] () =~ // break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(call_direction=inbound) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(call_direction=inbound)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [call_direction]=[inbound]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action log(WARNING [inbound routes] 404 not found ${sip_network_ip})
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:281 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State Change CS_ROUTING -> CS_EXECUTE
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:640 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State ROUTING going to sleep
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_EXECUTE (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:647 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State EXECUTE
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_sofia.c:213 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 SOFIA EXECUTE
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:323 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard EXECUTE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(caller_id_number=5000)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [caller_id_number]=[5000]
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(RFC2822_DATE=Thu, 20 Oct 2022 07:49:59 +0000)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [RFC2822_DATE]=[Thu, 20 Oct 2022 07:49:59 +0000]
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 log(WARNING [inbound routes] 404 not found 192.168.100.113)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [WARNING] mod_dptools.c:1879 [inbound routes] 404 not found 192.168.100.113
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [NOTICE] switch_core_state_machine.c:382 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 has executed the last dialplan instruction, hanging up.
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [NOTICE] switch_core_state_machine.c:384 Hangup sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [CS_EXECUTE] [NORMAL_CLEARING]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:647 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State EXECUTE going to sleep
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_HANGUP (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:844 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Callstate Change RINGING -> HANGUP
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:846 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State HANGUP
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_sofia.c:468 Channel sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 hanging up, cause: NORMAL_CLEARING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_sofia.c:613 Responding to INVITE with: 480
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:59 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard HANGUP, cause: NORMAL_CLEARING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:846 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State HANGUP going to sleep
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:616 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State Change CS_HANGUP -> CS_REPORTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_REPORTING (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:932 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State REPORTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:168 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard REPORTING, cause: NORMAL_CLEARING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:932 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State REPORTING going to sleep
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:607 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State Change CS_REPORTING -> CS_DESTROY
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_session.c:1753 Session 40418 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Locked, Waiting on external entities
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [NOTICE] switch_core_session.c:1771 Session 40418 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Ended
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [NOTICE] switch_core_session.c:1775 Close Channel sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [CS_DESTROY]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:735 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_DESTROY (Cur 2 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:745 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State DESTROY
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] mod_sofia.c:379 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 SOFIA DESTROY
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:175 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard DESTROY
Many thanks in advance.
Bit of a strange one. Moved all customers from old 4.4 to 5 without too much of a problem apart from 2 domains.
none of the dial plan instructions apart from outgoing and incoming calls work. Not even *97 for vm. I get the following error, could anyone point me in the right direction?
EXECUTE [depth=0] sofia/internal-lan/5000@xxxx.xxxx.xxxx.xxxx:5060 log(WARNING [inbound routes] 404 not found 192.168.100.116)
2022-10-20 07:22:40.866329 97.37% [WARNING] mod_dptools.c:1879 [inbound routes] 404 not found 192.168.100.116
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.446316 97.03% [NOTICE] switch_channel.c:1123 New Channel sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [27d308eb-940c-4159-903e-f104334ae664]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.446316 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_NEW (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.446316 97.03% [INFO] sofia.c:10462 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 receiving invite from 192.168.100.113:12572 version: 1.10.7 -release 64bit call-id: 0_2272274239@192.168.100.113
2022-10-20 07:49:59.446316 97.03% [DEBUG] sofia.c:10556 verifying acl "domains" for ip/port 192.168.100.113:0.
2022-10-20 07:49:59.446316 97.03% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'internal-lan' for [*97@prettylegspbx5.adept-systems.co.uk] from ip 192.168.100.113
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.446316 97.03% [DEBUG] switch_core_state_machine.c:600 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State NEW
2022-10-20 07:49:59.446316 97.03% [DEBUG] sofia.c:2419 detaching session 27d308eb-940c-4159-903e-f104334ae664
2022-10-20 07:49:59.466321 97.03% [DEBUG] sofia.c:2532 Re-attaching to session 27d308eb-940c-4159-903e-f104334ae664
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.466321 97.03% [INFO] sofia.c:10462 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 receiving invite from 192.168.100.113:12572 version: 1.10.7 -release 64bit call-id: 0_2272274239@192.168.100.113
2022-10-20 07:49:59.466321 97.03% [DEBUG] sofia.c:10556 verifying acl "domains" for ip/port 192.168.100.113:0.
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] sofia.c:7499 Channel sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 entering state [received][100]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] sofia.c:7509 Remote SDP:
27d308eb-940c-4159-903e-f104334ae664 v=0
27d308eb-940c-4159-903e-f104334ae664 o=- 20000 20000 IN IP4 192.168.100.113
27d308eb-940c-4159-903e-f104334ae664 s=SDP data
27d308eb-940c-4159-903e-f104334ae664 c=IN IP4 192.168.100.113
27d308eb-940c-4159-903e-f104334ae664 t=0 0
27d308eb-940c-4159-903e-f104334ae664 m=audio 12332 RTP/AVP 0 8 18 9 101
27d308eb-940c-4159-903e-f104334ae664 a=rtpmap:0 PCMU/8000
27d308eb-940c-4159-903e-f104334ae664 a=rtpmap:8 PCMA/8000
27d308eb-940c-4159-903e-f104334ae664 a=rtpmap:18 G729/8000
27d308eb-940c-4159-903e-f104334ae664 a=fmtp:18 annexb=no
27d308eb-940c-4159-903e-f104334ae664 a=rtpmap:9 G722/8000
27d308eb-940c-4159-903e-f104334ae664 a=rtpmap:101 telephone-event/8000
27d308eb-940c-4159-903e-f104334ae664 a=fmtp:101 0-15
27d308eb-940c-4159-903e-f104334ae664 a=ptime:20
27d308eb-940c-4159-903e-f104334ae664
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 101@8000
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:3870 Set Codec sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_codec.c:111 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Original read codec set to PCMU:0
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 101@8000
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_media.c:5973 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Set 2833 dtmf send payload to 101 recv payload to 101
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] sofia.c:7933 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State Change CS_NEW -> CS_INIT
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_INIT (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:624 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State INIT
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] mod_sofia.c:97 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 SOFIA INIT
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:40 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard INIT
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:48 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State Change CS_INIT -> CS_ROUTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:624 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State INIT going to sleep
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_ROUTING (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_channel.c:2380 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Callstate Change DOWN -> RINGING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:640 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State ROUTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] mod_sofia.c:158 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 SOFIA ROUTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [DEBUG] switch_core_state_machine.c:230 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard ROUTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.486332 97.03% [INFO] mod_dialplan_xml.c:639 Processing 5000 <5000>->*97 in context prettylegspbx5.adept-systems.co.uk
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->caller-details] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [caller-details] () =~ // break=never
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(caller_destination=${sip_to_user}) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(caller_destination=*97)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.506310 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [caller_destination]=[*97]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(caller_id_name=${caller_id_name}) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(caller_id_name=5000)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.506310 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [caller_id_name]=[5000]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(caller_id_number=${caller_id_number})
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->user_exists] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [user_exists] ${loopback_leg}() =~ /^B$/ break=never
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [user_exists] () =~ // break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(user_exists=false)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.506310 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [user_exists]=[false]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(from_user_exists=true)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.506310 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [from_user_exists]=[true]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->global-variables] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [global-variables] () =~ // break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(timezone=Europe/London) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(timezone=Europe/London)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.506310 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [timezone]=[Europe/London]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->is_loopback] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [is_loopback] ${is_follow_me_loopback}() =~ /true/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->rtp_has_crypto] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [rtp_has_crypto] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Gamma_Adept.d6] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [Gamma_Adept.d6] ${user_exists}(false) =~ /false/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Gamma_Adept.d6] destination_number(*97) =~ /^(\d{6})$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Gamma_Adept.d1014] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [Gamma_Adept.d1014] ${user_exists}(false) =~ /false/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Gamma_Adept.d1014] destination_number(*97) =~ /^\+?(\d{10,14})$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->CUI] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [CUI] destination_number(*97) =~ /^5002$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->BankHol3may] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [BankHol3may] destination_number(*97) =~ /^9998$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->OfficeClosed] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [OfficeClosed] destination_number(*97) =~ /^9999$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Medalin Ring Group] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Medalin Ring Group] destination_number(*97) =~ /^5003$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Main] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Main] destination_number(*97) =~ /^5001$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Customer_Support] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Customer_Support] destination_number(*97) =~ /^([^#]+#)(.*)$/ break=never
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Customer_Support] destination_number(*97) =~ /^(callcenter\+)?6001$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->intercept-ext-polycom] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [intercept-ext-polycom] destination_number(*97) =~ /^\*97(\d+)$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->7003 Medalin] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [7003 Medalin] destination_number(*97) =~ /^7003$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->OfficeHours] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [OfficeHours] destination_number(*97) =~ /^7001$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->Medalin-Fax-Server] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [Medalin-Fax-Server] destination_number(*97) =~ /^2998$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->extension-to-voicemail] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [extension-to-voicemail] ${user_exists}(false) =~ /^true$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->CUI-Fax-Server] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [CUI-Fax-Server] destination_number(*97) =~ /^2999$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->follow-me-destinations] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [follow-me-destinations] ${user_exists}(false) =~ /^true$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->call-forward-all] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [call-forward-all] ${user_exists}(false) =~ /true/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->call-forward-not-registered] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [call-forward-not-registered] ${user_exists}(false) =~ /true/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->talking clock date and time] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [talking clock date and time] destination_number(*97) =~ /^\*9172$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->talking clock time] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [talking clock time] destination_number(*97) =~ /^\*9170$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->talking clock date] continue=
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [talking clock date] destination_number(*97) =~ /^\*9171$/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->local_extension] continue=true
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [local_extension] ${user_exists}(false) =~ /true/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->voicemail] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (FAIL) [voicemail] ${user_exists}(false) =~ /true/ break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 parsing [prettylegspbx5.adept-systems.co.uk->not-found] continue=false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Regex (PASS) [not-found] () =~ // break=on-false
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action set(call_direction=inbound) INLINE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(call_direction=inbound)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [call_direction]=[inbound]
27d308eb-940c-4159-903e-f104334ae664 Dialplan: sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Action log(WARNING [inbound routes] 404 not found ${sip_network_ip})
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:281 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State Change CS_ROUTING -> CS_EXECUTE
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:640 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State ROUTING going to sleep
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_EXECUTE (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:647 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State EXECUTE
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_sofia.c:213 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 SOFIA EXECUTE
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:323 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard EXECUTE
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(caller_id_number=5000)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [caller_id_number]=[5000]
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 set(RFC2822_DATE=Thu, 20 Oct 2022 07:49:59 +0000)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_dptools.c:1685 SET sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [RFC2822_DATE]=[Thu, 20 Oct 2022 07:49:59 +0000]
27d308eb-940c-4159-903e-f104334ae664 EXECUTE [depth=0] sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 log(WARNING [inbound routes] 404 not found 192.168.100.113)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [WARNING] mod_dptools.c:1879 [inbound routes] 404 not found 192.168.100.113
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [NOTICE] switch_core_state_machine.c:382 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 has executed the last dialplan instruction, hanging up.
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [NOTICE] switch_core_state_machine.c:384 Hangup sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [CS_EXECUTE] [NORMAL_CLEARING]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:647 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State EXECUTE going to sleep
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_HANGUP (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:844 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Callstate Change RINGING -> HANGUP
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:846 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State HANGUP
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_sofia.c:468 Channel sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 hanging up, cause: NORMAL_CLEARING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] mod_sofia.c:613 Responding to INVITE with: 480
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:59 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard HANGUP, cause: NORMAL_CLEARING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:846 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State HANGUP going to sleep
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:616 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State Change CS_HANGUP -> CS_REPORTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:581 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_REPORTING (Cur 3 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.526325 97.03% [DEBUG] switch_core_state_machine.c:932 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State REPORTING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:168 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard REPORTING, cause: NORMAL_CLEARING
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:932 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State REPORTING going to sleep
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:607 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State Change CS_REPORTING -> CS_DESTROY
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_session.c:1753 Session 40418 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Locked, Waiting on external entities
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [NOTICE] switch_core_session.c:1771 Session 40418 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Ended
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [NOTICE] switch_core_session.c:1775 Close Channel sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 [CS_DESTROY]
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:735 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) Running State Change CS_DESTROY (Cur 2 Tot 40418)
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:745 (sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060) State DESTROY
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] mod_sofia.c:379 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 SOFIA DESTROY
27d308eb-940c-4159-903e-f104334ae664 2022-10-20 07:49:59.686305 97.03% [DEBUG] switch_core_state_machine.c:175 sofia/internal-lan/5000@prettylegspbx5.adept-systems.co.uk:5060 Standard DESTROY
Many thanks in advance.
Last edited: