Stange Case of Normal Clearing

I say its a stange case of Normal Clearing but.....

So we have a cloud hosted Multi Tennat Fusion PBX and yesterday we had an issue with one of our clients. They have been experiencing power cuts over the last couple of days. When they restart they had issues with outbond calls on the phones. Intially we sorted this it was down to their external IP address changing.

~However today we had the same issue but now cat resolve it. Calls can be made in but not out. We have an external phone connected to the same domain and that one is fine. They can call internally and I can call in from the external extention. they cant call external phone (obviously as its external...)

I cant see any traffic going out so im now a bit lost. I have tried to to a pcap in a call and thats below : Any Ideas?


´Ä_^ñ
> > $Ä : E (üö@ 4ëªR!¤Ÿ%;B3/ÄiÒ_*ç–’ŒP(—£ ¶Ä_^—Ï ë ë $Ä E ÛÖh@ 6ØBT\Ö§%;B3/Äh],m7 PÚ] INVITE sip:115@LH.voip.synthesis-it.co.uk:5060 SIP/2.0
Via: SIP/2.0/TCP 192.168.1.8:12159;branch=z9hG4bK3823221383
From: "Julie" <sip:102@LH.voip.synthesis-it.co.uk:5060>;tag=1115306992
To: <sip:115@LH.voip.synthesis-it.co.uk:5060>
Call-ID: 0_2082199486@192.168.1.8
CSeq: 1 INVITE
Contact: <sip:102@192.168.1.8:12159;transport=TCP>
Content-Type: application/sdp
Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE
Max-Forwards: 70
User-Agent: Yealink SIP-T23G 44.84.0.15
Allow-Events: talk,hold,conference,refer,check-sync
Supported: replaces
Content-Length: 304

v=0
o=- 20003 20003 IN IP4 192.168.1.8
s=SDP data
c=IN IP4 192.168.1.8
t=0 0
m=audio 12272 RTP/AVP 9 0 8 18 101
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
¶Ä_^qÐ ƒ ƒ RÛIO E sûˆ@ @«Š%;B3T\Ö§Ä/,m7 h`ÎPc“× SIP/2.0 100 Trying
Via: SIP/2.0/TCP 192.168.1.8:12159;branch=z9hG4bK3823221383;received=84.92.214.167;rport=12159
From: "Julie" <sip:102@LH.voip.synthesis-it.co.uk:5060>;tag=1115306992
To: <sip:115@LH.voip.synthesis-it.co.uk:5060>
Call-ID: 0_2082199486@192.168.1.8
CSeq: 1 INVITE
User-Agent: FreeSWITCH
Content-Length: 0

¶Ä_^©Ó D D RÛ@ E 4ž@ @m©%;B334”vÄÔMœÚüDQL€¬/?
XÚÐZ‹¶Ä_^‡è œ œ RÛag E Œû‰@ @©p%;B3T\Ö§Ä/,m8Kh`ÎPc•ð SIP/2.0 480 Temporarily Unavailable
Via: SIP/2.0/TCP 192.168.1.8:12159;branch=z9hG4bK3823221383;received=84.92.214.167;rport=12159
Max-Forwards: 70
From: "Julie" <sip:102@LH.voip.synthesis-it.co.uk:5060>;tag=1115306992
To: <sip:115@LH.voip.synthesis-it.co.uk:5060>;tag=yaae5cXtvBB6g
Call-ID: 0_2082199486@192.168.1.8
CSeq: 1 INVITE
User-Agent: FreeSWITCH
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Reason: Q.850;cause=16;text="NORMAL_CLEARING"
Content-Length: 0
Remote-Party-ID: "115" <sip:115@LH.voip.synthesis-it.co.uk>;party=calling;privacy=off;screen=no

¶Ä_^V' > > $Ä ŸR E (Öi@ 6ÛôT\Ö§%;B3/Äh`Î,m8KPÚëV ¶Ä_^S4 D D $Ä ¿¹ E 4M–@ 4Ê34”v%;B3ÔÄDQLMœÚý€ ÁF
ZÈXÚжÄ_^^? > > $Ä E (Öj@ 6ÛóT\Ö§%;B3/Äh`Î,m;¯PŒæ@ ¶Ä_^ÚS x x $Ä pp E hÖk@ 6Ú²T\Ö§%;B3/Äh`Î,m;¯PŒ ñ ACK sip:115@LH.voip.synthesis-it.co.uk:5060 SIP/2.0
Via: SIP/2.0/TCP 192.168.1.8:12159;branch=z9hG4bK3823221383
From: "Julie" <sip:102@LH.voip.synthesis-it.co.uk:5060>;tag=1115306992
To: <sip:115@LH.voip.synthesis-it.co.uk:5060>;tag=yaae5cXtvBB6g
Call-ID: 0_2082199486@192.168.1.8
CSeq: 1 ACK
Content-Length: 0

+

vespaman said:

Did you try updating the acl of your provider or Fail to Ban address lists if the IP address has changed ?

Click to expand...

ACL has the SBCs in it. Calls work incoming with voice. And the phones all regiter with the remote PBX so I dont thnik its down to the new IP address. Ive never had to add the external IP to the ACL before.

DigitalDaz said:

A freeswitch log of the call would help.

Click to expand...

is this enough?
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] mod_dptools.c:1548 SET sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 [domain_name]=[amacus.voip.dimasoft.co.uk]
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 Dialplan: sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 Action set(call_direction=inbound) INLINE
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 EXECUTE sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 set(call_direction=inbound)
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] mod_dptools.c:1548 SET sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 [call_direction]=[inbound]
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 Dialplan: sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 Action log([inbound routes] 404 not found ${sip_network_ip}) INLINE
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 EXECUTE sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 log([inbound routes] 404 not found 84.92.214.167)
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] mod_dptools.c:1742 routes] 404 not found 84.92.214.167
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State Change CS_ROUTING -> CS_EXECUTE
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State ROUTING going to sleep
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) Running State Change CS_EXECUTE (Cur 3 Tot 347)
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State EXECUTE
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] mod_sofia.c:198 sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 SOFIA EXECUTE
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:328 sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 Standard EXECUTE
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [NOTICE] switch_core_state_machine.c:385 sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 has executed the last dialplan instruction, hanging up.
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 [CS_EXECUTE] [NORMAL_CLEARING]
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State EXECUTE going to sleep
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) Running State Change CS_HANGUP (Cur 3 Tot 347)
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) Callstate Change RINGING -> HANGUP
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State HANGUP
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] mod_sofia.c:438 Channel sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 hanging up, cause: NORMAL_CLEARING
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 480
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:60 sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 Standard HANGUP, cause: NORMAL_CLEARING
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State HANGUP going to sleep
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State Change CS_HANGUP -> CS_REPORTING
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) Running State Change CS_REPORTING (Cur 3 Tot 347)
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State REPORTING
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:174 sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 Standard REPORTING, cause: NORMAL_CLEARING
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State REPORTING going to sleep
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State Change CS_REPORTING -> CS_DESTROY
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_session.c:1665 Session 347 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) Locked, Waiting on external entities
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [NOTICE] switch_core_session.c:1683 Session 347 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) Ended
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 [CS_DESTROY]
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) Running State Change CS_DESTROY (Cur 2 Tot 347)
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State DESTROY
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] mod_sofia.c:343 sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 SOFIA DESTROY
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:181 sofia/internal/102@LH.voip.synthesis-it.co.uk:5060 Standard DESTROY
3a53f931-f59d-4597-b3ce-5a6a63f66ae3 2020-03-05 11:08:06.416825 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/102@LH.voip.synthesis-it.co.uk:5060) State DESTROY going to sleep
98a93c75-a7e0-4544-82ee-595d99adc55c 2020-03-05 11:08:13.496842 [DEBUG] sofia.c:7084 Channel sofia/internal/01912375673 entering state [completing][200]
98a93c75-a7e0-4544-82ee-595d99adc55c 2020-03-05 11:08:13.496842 [DEBUG] sofia.c:7091 Duplicate SDP

DigitalDaz said:

No, a bit earlier than that.

Click to expand...

35c98590-137f-41fc-9f1a-38875a78e780 v=0
35c98590-137f-41fc-9f1a-38875a78e780 o=FreeSWITCH 1583381291 1583381292 IN IP4 37.59.66.51
35c98590-137f-41fc-9f1a-38875a78e780 s=FreeSWITCH
35c98590-137f-41fc-9f1a-38875a78e780 c=IN IP4 37.59.66.51
35c98590-137f-41fc-9f1a-38875a78e780 t=0 0
35c98590-137f-41fc-9f1a-38875a78e780 m=audio 26100 RTP/AVP 8 101
35c98590-137f-41fc-9f1a-38875a78e780 a=rtpmap:8 PCMA/8000
35c98590-137f-41fc-9f1a-38875a78e780 a=rtpmap:101 telephone-event/8000
35c98590-137f-41fc-9f1a-38875a78e780 a=fmtp:101 0-16
35c98590-137f-41fc-9f1a-38875a78e780 a=ptime:20
35c98590-137f-41fc-9f1a-38875a78e780 a=sendrecv
35c98590-137f-41fc-9f1a-38875a78e780
35c98590-137f-41fc-9f1a-38875a78e780 2020-03-05 11:23:11.897012 [NOTICE] mod_sofia.c:2367 Pre-Answer sofia/internal/07435133861@88.215.54.143!
35c98590-137f-41fc-9f1a-38875a78e780 2020-03-05 11:23:11.897012 [DEBUG] switch_channel.c:3474 (sofia/internal/07435133861@88.215.54.143) Callstate Change RINGING -> EARLY
35c98590-137f-41fc-9f1a-38875a78e780 2020-03-05 11:23:11.897012 [DEBUG] switch_ivr_originate.c:1273 Raw Codec Activation Success L16@8000hz 1 channel 20ms
35c98590-137f-41fc-9f1a-38875a78e780 2020-03-05 11:23:11.897012 [DEBUG] switch_core_codec.c:223 sofia/internal/07435133861@88.215.54.143 Push codec L16:100
35c98590-137f-41fc-9f1a-38875a78e780 2020-03-05 11:23:11.897012 [DEBUG] switch_ivr_originate.c:1305 Play Ringback File [tone_stream://%(2000,4000,440,480);loops=-1]
35c98590-137f-41fc-9f1a-38875a78e780 2020-03-05 11:23:11.936829 [DEBUG] sofia.c:7084 Channel sofia/internal/07435133861@88.215.54.143 entering state [early][183]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.276823 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 [00abf058-af54-4eb8-80cd-c3439a563220]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.276823 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) Running State Change CS_NEW (Cur 5 Tot 375)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.276823 [DEBUG] sofia.c:9873 sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 receiving invite from 51.52.109.110:56183 version: 1.6.19 -36-7a77e0b 64bit
2020-03-05 11:23:13.276823 [DEBUG] sofia.c:10044 IP 51.52.109.110 Rejected by acl "domains". Falling back to Digest auth.
2020-03-05 11:23:13.276823 [WARNING] sofia_reg.c:1792 SIP auth challenge (INVITE) on sofia profile 'internal' for [907898435888@LH.voip.synthesis-it.co.uk] from ip 51.52.109.110
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.276823 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) State NEW
2020-03-05 11:23:13.276823 [DEBUG] sofia.c:2334 detaching session 00abf058-af54-4eb8-80cd-c3439a563220
2020-03-05 11:23:13.316822 [DEBUG] sofia.c:2442 Re-attaching to session 00abf058-af54-4eb8-80cd-c3439a563220
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] sofia.c:9873 sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 receiving invite from 51.52.109.110:56183 version: 1.6.19 -36-7a77e0b 64bit
2020-03-05 11:23:13.336826 [DEBUG] sofia.c:10044 IP 51.52.109.110 Rejected by acl "domains". Falling back to Digest auth.
2020-03-05 11:23:13.336826 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fd8f4041f60 Connected.
2020-03-05 11:23:13.336826 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7fd8f4041f60 released.
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] sofia.c:11168 Setting NAT mode based on via received
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] sofia.c:7084 Channel sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 entering state [received][100]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] sofia.c:7094 Remote SDP:
00abf058-af54-4eb8-80cd-c3439a563220 v=0
00abf058-af54-4eb8-80cd-c3439a563220 o=- 20000 20000 IN IP4 192.168.121.62
00abf058-af54-4eb8-80cd-c3439a563220 s=SDP data
00abf058-af54-4eb8-80cd-c3439a563220 c=IN IP4 192.168.121.62
00abf058-af54-4eb8-80cd-c3439a563220 t=0 0
00abf058-af54-4eb8-80cd-c3439a563220 m=audio 11842 RTP/AVP 9 0 8 18 101
00abf058-af54-4eb8-80cd-c3439a563220 a=rtpmap:9 G722/8000
00abf058-af54-4eb8-80cd-c3439a563220 a=rtpmap:0 PCMU/8000
00abf058-af54-4eb8-80cd-c3439a563220 a=rtpmap:8 PCMA/8000
00abf058-af54-4eb8-80cd-c3439a563220 a=rtpmap:18 G729/8000
00abf058-af54-4eb8-80cd-c3439a563220 a=fmtp:18 annexb=no
00abf058-af54-4eb8-80cd-c3439a563220 a=rtpmap:101 telephone-event/8000
00abf058-af54-4eb8-80cd-c3439a563220 a=fmtp:101 0-15
00abf058-af54-4eb8-80cd-c3439a563220 a=ptime:20
00abf058-af54-4eb8-80cd-c3439a563220
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 G722/8000 20 ms 160 samples 64000 bits 1 channels
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_codec.c:111 sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Original read codec set to G722:9
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_media.c:4767 sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Set 2833 dtmf send payload to 101 recv payload to 101
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] sofia.c:7507 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) State Change CS_NEW -> CS_INIT
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) Running State Change CS_INIT (Cur 5 Tot 375)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) State INIT
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] mod_sofia.c:90 sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 SOFIA INIT
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_state_machine.c:40 sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Standard INIT
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) State Change CS_INIT -> CS_ROUTING
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) State INIT going to sleep
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) Running State Change CS_ROUTING (Cur 5 Tot 375)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_channel.c:2249 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) Callstate Change DOWN -> RINGING
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) State ROUTING
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] mod_sofia.c:143 sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 SOFIA ROUTING
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [DEBUG] switch_core_state_machine.c:236 sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Standard ROUTING
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.336826 [INFO] mod_dialplan_xml.c:637 Processing 115 <

DigitalDaz said:

And then you stopped just at the interesting part

Click to expand...

thats what the ex wife used to say.... Ill try again

00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 parsing [LH.voip.synthesis-it.co.uk->user_exists] continue=true
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_exists] ${loopback_leg}() =~ /^B$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [user_exists] () =~ // break=on-false
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
2020-03-05 11:23:13.336826 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fd8f4041f60 Connected.
2020-03-05 11:23:13.336826 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7fd8f4041f60 released.
00abf058-af54-4eb8-80cd-c3439a563220 EXECUTE sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 set(user_exists=false)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] mod_dptools.c:1548 SET sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 [user_exists]=[false]
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 parsing [LH.voip.synthesis-it.co.uk->caller-details] continue=true
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [caller-details] ${caller_destination}() =~ /^$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(caller_destination=${destination_number}) INLINE
00abf058-af54-4eb8-80cd-c3439a563220 EXECUTE sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 set(caller_destination=907898435888)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] mod_dptools.c:1548 SET sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 [caller_destination]=[907898435888]
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(caller_id_name=${caller_id_name}) INLINE
00abf058-af54-4eb8-80cd-c3439a563220 EXECUTE sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 set(caller_id_name=115)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] mod_dptools.c:1548 SET sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 [caller_id_name]=[115]
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(caller_id_number=${caller_id_number})
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 parsing [LH.voip.synthesis-it.co.uk->variables] continue=true
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [variables] () =~ // break=on-false
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action export(origination_callee_id_name=${destination_number})
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 parsing [LH.voip.synthesis-it.co.uk->call-direction] continue=true
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 ANTI-Action export(call_direction=local) INLINE
00abf058-af54-4eb8-80cd-c3439a563220 EXECUTE sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 export(call_direction=local)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[local]
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 parsing [LH.voip.synthesis-it.co.uk->user_record] continue=true
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [user_record] () =~ // break=on-false
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
00abf058-af54-4eb8-80cd-c3439a563220 EXECUTE sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 set(from_user_exists=true)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] mod_dptools.c:1548 SET sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 [from_user_exists]=[true]
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE
00abf058-af54-4eb8-80cd-c3439a563220 EXECUTE sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 set(from_user_record=)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] mod_dptools.c:1548 SET sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 [from_user_record]=[UNDEF]
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 parsing [LH.voip.synthesis-it.co.uk->redial] continue=true
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [redial] destination_number(907898435888) =~ /^(redial|\*870)$/ break=on-true
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [redial] () =~ // break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 parsing [LH.voip.synthesis-it.co.uk->speed_dial] continue=false
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [speed_dial] destination_number(907898435888) =~ /^\*0(.*)$/ break=on-false
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 parsing [LH.voip.synthesis-it.co.uk->default_caller_id] continue=true
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [default_caller_id] ${emergency_caller_id_number}(01912861444) =~ /^$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (FAIL) [default_caller_id] ${outbound_caller_id_number}(01912861444) =~ /^$/ break=never
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 parsing [LH.voip.synthesis-it.co.uk->LH_Gamma.9.11d] continue=false
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [LH_Gamma.9.11d] ${user_exists}(false) =~ /false/ break=on-false
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Regex (PASS) [LH_Gamma.9.11d] destination_number(907898435888) =~ /^9(\d{11})$/ break=on-false
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(sip_h_X-accountcode=${accountcode})
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action export(call_direction=outbound)
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action unset(call_timeout)
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(hangup_after_bridge=true)
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(effective_caller_id_name=${outbound_caller_id_name})
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(effective_caller_id_number=${outbound_caller_id_number})
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(inherit_codec=true)
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(ignore_display_updates=true)
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(callee_id_number=07898435888)
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(continue_on_fail=true)
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action set(outbound_prefix=9)
00abf058-af54-4eb8-80cd-c3439a563220 Dialplan: sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Action bridge(sofia/gateway/08a2bae9-b537-4cca-9def-815590a93c6a/07898435888)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) State Change CS_ROUTING -> CS_EXECUTE
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) State ROUTING going to sleep
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) Running State Change CS_EXECUTE (Cur 5 Tot 375)
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/115@LH.voip.synthesis-it.co.uk:5060) State EXECUTE
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] mod_sofia.c:198 sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 SOFIA EXECUTE
00abf058-af54-4eb8-80cd-c3439a563220 2020-03-05 11:23:13.356824 [DEBUG] switch_core_state_machine.c:328 sofia/internal/115@LH.voip.synthesis-it.co.uk:5060 Standard EXECUTE

Gamma say they are not reciving it said they dont see any traffic. Stangely I have a phone on my desk on teh same domain but different location and that on works fine.

Ok so now its working for some reason. The only thing a chnaged is I noticed that someon had put in their external IP addess on the ACL i removed that.

Anyways it seems to be working fine now. Although do have another strange problem but thats for a different thread.

Thanks lads for taking the time to have a look and help me out.