I’m not sure when this issue started happening, because we have send voicemail message via email, and we rarely use the voicemail button on the S705, but now the voicemail button does not work on the S705 with the following error:
Failed to load xml file !
Voicemail works when using the code *97.
Phone apps is Enable and installed. Phone is up to date with the latest firmware 1.68 using Endpoint Manager.
Nothing shows up in the Aaterisk logs or the phone logs.
Here’s the phone logs around the time I tried to press the voicemail button to see if it shows up in the logs, but I can’t make heads or tails of these logs:
[2022-07-29 09:37:59][00:50:58:52:fa:64]
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.3.0.6:5060;rport=5060;branch=z9hG4bKPj4adb9065-7b19-4cc0-bd1b-cc2208fcee05
From: <sip:[email protected]>;tag=84389e1a-d234-4d07-abf1-04294ecfd53b
To: "Manager Office" <sip:[email protected]>;tag=16ed23fc7ea586c
Call-ID: [email protected]
CSeq: 25514 NOTIFY
User-Agent: Sangoma S705 V3.0.4.88
Allow: INVITE, ACK, UPDATE, INFO, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, PRACK
Content-Length: 0
[07-29 09:37:59 52:fa:64] cb_udp_snd_message:655===>>>SIP messages send to 10.3.0.6:5060
[07-29 09:37:59 52:fa:64] ##SIPPro Recv event 0x1010####
[07-29 09:38:09 52:fa:64] Open /dev/ttyS0
[07-29 09:38:09 52:fa:64] Baudrate is 2400
[07-29 09:38:09 52:fa:64] init_ehs_mode
[07-29 09:38:15 52:fa:64] Dial MSG
[07-29 09:38:15 52:fa:64] FXSCallProFSM:13427####Received NewEvent=0x111, event=0x111, CallState=0x80#######
[07-29 09:38:15 52:fa:64] GUI:NOTIFY_XMLAPP_VOICE_MAIL
[07-29 09:38:15 52:fa:64] GUI: XMLBrowserHandler phone.c, 4326
[07-29 09:38:15 52:fa:64] ParseSerPathStr:====== addr is 10.3.0.6
[07-29 09:38:15 52:fa:64] ParseSerPathStr: ip is 10.3.0.6, 0xa030006
[07-29 09:38:15 52:fa:64] ParseSerPathStr: path is applications.php/voicemail/main?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701
[07-29 09:38:15 52:fa:64] HTTPC: Need Resolve Domain 10.3.0.6
[07-29 09:38:15 52:fa:64] HTTPC: Resolve Domain 10.3.0.6, IP 10.3.0.6
[07-29 09:38:15 52:fa:64] HTTPC: Resolve Domain 10.3.0.6, IP 10.3.0.6
[07-29 09:38:15 52:fa:64] CfgUpgradeOpen(Protocol HTTP, Port 84, Filename applications.php/voicemail/main?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701)
[07-29 09:38:15 52:fa:64] HttpCOpen - AF_INET (4)
[07-29 09:38:15 52:fa:64] HttpCOpen: HTTP Command Size 234 bytes, Command:
GET /applications.php/voicemail/main?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701 HTTP/1.1
Host: 10.3.0.6:84
User-Agent: Sangoma S705 3.0.4.88 00:50:58:52:fa:64
Accept: */*
Connection: Keep-Alive
[07-29 09:38:15 52:fa:64] HttpCOpen: send 234 bytes success
[07-29 09:38:15 52:fa:64] HttpCOpen: recv 677 bytes back
[07-29 09:38:15 52:fa:64] HttpClientOpen:1265====nResponse=302
[07-29 09:38:15 52:fa:64] HTTPListCheckHeader:302**********https://freepbx.sheridanpoint.org:3443/?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701***
[07-29 09:38:15 52:fa:64] HttpClientOpen:1272====nResponse=302
[07-29 09:38:15 52:fa:64] HttpClientOpen:1282====NewHostName=https://freepbx.sheridanpoint.org:3443/?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701
[07-29 09:38:15 52:fa:64] ParseSerPathStr:====== addr is freepbx.sheridanpoint.org
[07-29 09:38:15 52:fa:64] ParseSerPathStr: domain is freepbx.sheridanpoint.org
[07-29 09:38:15 52:fa:64] ParseSerPathStr: path is ?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701
[07-29 09:38:15 52:fa:64] UrlHttpAndHttps302Proc:9644, Server IP:Port is 0xa030006:3443
[07-29 09:38:15 52:fa:64] HTTPSC: HttpsGetFile ?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701, Resolve Domain freepbx.sheridanpoint.org Success, SerIP:0xa030006
[07-29 09:38:15 52:fa:64] HTTPSC: There are Default Device Cert and Key!!!
[07-29 09:38:15 52:fa:64] TLS: commonName: MAC-00505852fa64
[07-29 09:38:15 52:fa:64] HTTPSC: Load Device Cert and Key Success!!!
[07-29 09:38:15 52:fa:64] TLS: HTTPSC Get File, SUPPORT TLS_RSA_WITH_AES_256_CBC_SHA256, TLS_RSA_WITH_AES_128_CBC_SHA, TLS_RSA_WITH_AES_256_CBC_SHA
[07-29 09:38:15 52:fa:64] client https://freepbx.sheridanpoint.org:3443/?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701, ser ip: 10.3.0.6, new: 1, resumed: 0, nciphers: 3, version: TLS 1.2
[07-29 09:38:15 52:fa:64] HTTPS: INITIAL CLIENT SESSION, Will Get /?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701
[07-29 09:38:15 52:fa:64] <<< Client creating CLIENT_HELLO message
[07-29 09:38:15 52:fa:64] >>> Client parsing SERVER_HELLO message
[07-29 09:38:15 52:fa:64] >>> Client parsing CERTIFICATE message
[07-29 09:38:15 52:fa:64] TLS: commonName: freepbx.sheridanpoint.org
[07-29 09:38:15 52:fa:64] TLS: commonName: R3
[07-29 09:38:15 52:fa:64] TLS: commonName: ISRG Root X1
[07-29 09:38:15 52:fa:64] TLS: SSLHandshake, setting(Trusted Certificates) is 2, Doing Custom Certificates Validations...
[07-29 09:38:15 52:fa:64] TLS: There is NO ANY Custom Trusted CA!!!
[07-29 09:38:15 52:fa:64] TLS: ValidateCerts, no issuing cert
[07-29 09:38:15 52:fa:64] TLS: X509AuthCert, sc 0x17754a0, sc->next 0x17740b8
[07-29 09:38:15 52:fa:64] TLS: X509AuthCert, sc 0x17740b8, sc->next 0x1774428
[07-29 09:38:15 52:fa:64] TLS: X509AuthCert, sc 0x1774428, sc->next 0x0
[07-29 09:38:15 52:fa:64] TLS: X509AuthCert, chain cert, node_nums 3
[07-29 09:38:15 52:fa:64] TLS: X509AuthCert, sc 0x17754a0, ic 0x17740b8
[07-29 09:38:15 52:fa:64] TLS: sc.subject.commonName: freepbx.sheridanpoint.org
[07-29 09:38:15 52:fa:64] TLS: sc.issuer .commonName: R3
[07-29 09:38:15 52:fa:64] TLS: ic.subject.commonName: R3
[07-29 09:38:15 52:fa:64] TLS: ic.issuer .commonName: ISRG Root X1
[07-29 09:38:15 52:fa:64] TLS: X509AuthCert, now sc 0x17740b8, ic 0x1774428
[07-29 09:38:15 52:fa:64] TLS: sc.subject.commonName: R3
[07-29 09:38:15 52:fa:64] TLS: sc.issuer .commonName: ISRG Root X1
[07-29 09:38:15 52:fa:64] TLS: ic.subject.commonName: ISRG Root X1
[07-29 09:38:15 52:fa:64] TLS: ic.issuer .commonName: DST Root CA X3
[07-29 09:38:15 52:fa:64] TLS: Checking with Default Trusted CA(ISRG Root X1)
[07-29 09:38:15 52:fa:64] TLS: ValidateCerts, setting(Common Name Validation) is ON
[07-29 09:38:15 52:fa:64] TLS: ValidateCerts, validate the CommonName or SubjectAltName of the certificate...
[07-29 09:38:15 52:fa:64] TLS: ValidateCerts, sc.commonName(freepbx.sheridanpoint.org), expectedName(freepbx.sheridanpoint.org)
[07-29 09:38:15 52:fa:64] SUCCESS: Validated cert for: freepbx.sheridanpoint.org.
[07-29 09:38:15 52:fa:64] >>> Client parsing SERVER_HELLO_DONE message
[07-29 09:38:15 52:fa:64] <<< Client creating CLIENT_KEY_EXCHANGE message
[07-29 09:38:15 52:fa:64] <<< Client creating CHANGE_CIPHER_SPEC message
[07-29 09:38:15 52:fa:64] <<< Client creating FINISHED message
[07-29 09:38:15 52:fa:64] >>> Client parsing NEW_SESSION_TICKET message
[07-29 09:38:15 52:fa:64] >>> Client parsing CHANGE_CIPHER_SPEC message
[07-29 09:38:15 52:fa:64] >>> Client parsing FINISHED message
[07-29 09:38:15 52:fa:64]
[07-29 09:38:15 52:fa:64] TLS 1.2
[07-29 09:38:15 52:fa:64] connection established:
[07-29 09:38:15 52:fa:64] TLS_RSA_WITH_AES_256_CBC_SHA256
[07-29 09:38:15 52:fa:64] SEND:
[GET /?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701 HTTP/1.1
User-Agent: Sangoma S705 3.0.4.88 00:50:58:52:fa:64
Host: freepbx.sheridanpoint.org
Connection: Keep-Alive
Authorization: Basic MDgxNTI1ZjQ6NDQ0ZWJiZWRlNTA4OTBhZg==
Content-Length: 0
]
[07-29 09:38:15 52:fa:64]
--------------------------len is 259--------------------------------
[07-29 09:38:15 52:fa:64] HTTP/1.1 200 OK
Date: Fri, 29 Jul 2022 14:38:18 GMT
Server: Apache/2.4.6 (CentOS) OpenSSL/1.0.2k-fips PHP/7.4.16
X-Powered-By: PHP/7.4.16
Content-Length: 157
Keep-Alive: timeout=5, max=100
Connection: Keep-Alive
Content-Type: text/xml;charset=UTF-8
[07-29 09:38:15 52:fa:64] ---------------------------------------------------------------------
[07-29 09:38:15 52:fa:64] RECV PARSED: [HTTP/1.1 200 OK]
[07-29 09:38:15 52:fa:64] httpBasicParse:1084===>>>Https Resv Response=200==
[07-29 09:38:15 52:fa:64] RECV PARSED: [Date: Fri, 29 Jul 2022 14:38:18 GMT]
[07-29 09:38:15 52:fa:64] RECV PARSED: [Server: Apache/2.4.6 (CentOS) OpenSSL/1.0.2k-fips PHP/7.4.16]
[07-29 09:38:15 52:fa:64] RECV PARSED: [X-Powered-By: PHP/7.4.16]
[07-29 09:38:15 52:fa:64] RECV PARSED: [Content-Length: 157]
[07-29 09:38:15 52:fa:64] HTTPSC: Content-Length is 157
[07-29 09:38:15 52:fa:64] RECV PARSED: [Keep-Alive: timeout=5, max=100]
[07-29 09:38:15 52:fa:64] RECV PARSED: [Connection: Keep-Alive]
[07-29 09:38:15 52:fa:64] RECV PARSED: [Content-Type: text/xml;charset=UTF-8]
[07-29 09:38:15 52:fa:64] RECV COMPLETE HTTP MESSAGE
[07-29 09:38:15 52:fa:64] -----------------cp->header_len is 259--------------------------------
[07-29 09:38:15 52:fa:64] HTTPS: Get Success, content len 157
[07-29 09:38:15 52:fa:64] HTTPSC: 416 bytes received
[07-29 09:38:15 52:fa:64] HTTPSC: 66 msec (66 avg msec/conn SSL handshake overhead)
[07-29 09:38:15 52:fa:64] HTTPSC: 4 msec (4 avg msec/conn SSL data overhead)
[07-29 09:38:15 52:fa:64] UrlHttpAndHttps302Proc:9699##########302 Get len=157##############
[07-29 09:38:15 52:fa:64] HttpClientOpen:1295##########302 Get len=157##############
[07-29 09:38:15 52:fa:64] HTTPC GetFile: OK --- Totallen=157!!!
[07-29 09:38:15 52:fa:64] WriteFile /tmp/xb/main?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701: Success Write 157 bytes
[07-29 09:38:15 52:fa:64] GUI: XBFileProc
[07-29 09:38:15 52:fa:64] GUI:DEBUGINFO:OpenXmlFile Fail!,File:./src/xmlbrowse.c------Line:2423
[07-29 09:38:15 52:fa:64] GUI: Idle Softkey History,,DND,Menu
[07-29 09:38:15 52:fa:64] GUI: PromptWarningInfomation
[07-29 09:38:16 52:fa:64] DNSC: resolv HostName -- freepbx.sheridanpoint.org
[07-29 09:38:16 52:fa:64] DNSC: Domain freepbx.sheridanpoint.org, ip 10.3.0.6, TTL 3600
[07-29 09:38:18 52:fa:64] GUI: Idle Softkey History,,DND,Menu
[07-29 09:38:18 52:fa:64] Dial MSG
[07-29 09:38:18 52:fa:64] FXSCallProFSM:13427####Received NewEvent=0x111, event=0x111, CallState=0x80#######
[07-29 09:38:18 52:fa:64] GUI:NOTIFY_XMLAPP_VOICE_MAIL
[07-29 09:38:18 52:fa:64] GUI: XMLBrowserHandler phone.c, 4326
[07-29 09:38:18 52:fa:64] ParseSerPathStr:====== addr is 10.3.0.6
[07-29 09:38:18 52:fa:64] ParseSerPathStr: ip is 10.3.0.6, 0xa030006
[07-29 09:38:18 52:fa:64] ParseSerPathStr: path is applications.php/voicemail/main?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701
[07-29 09:38:18 52:fa:64] HTTPC: Need Resolve Domain 10.3.0.6
[07-29 09:38:18 52:fa:64] HTTPC: Resolve Domain 10.3.0.6, IP 10.3.0.6
[07-29 09:38:18 52:fa:64] HTTPC: Resolve Domain 10.3.0.6, IP 10.3.0.6
[07-29 09:38:18 52:fa:64] CfgUpgradeOpen(Protocol HTTP, Port 84, Filename applications.php/voicemail/main?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701)
[07-29 09:38:18 52:fa:64] HttpCOpen - AF_INET (4)
[07-29 09:38:18 52:fa:64] HttpCOpen: HTTP Command Size 234 bytes, Command:
GET /applications.php/voicemail/main?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701 HTTP/1.1
Host: 10.3.0.6:84
User-Agent: Sangoma S705 3.0.4.88 00:50:58:52:fa:64
Accept: */*
Connection: Keep-Alive
[07-29 09:38:18 52:fa:64] HttpCOpen: send 234 bytes success
[07-29 09:38:18 52:fa:64] HttpCOpen: recv 677 bytes back
[07-29 09:38:18 52:fa:64] HttpClientOpen:1265====nResponse=302
[07-29 09:38:18 52:fa:64] HTTPListCheckHeader:302**********https://freepbx.sheridanpoint.org:3443/?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701***
[07-29 09:38:18 52:fa:64] HttpClientOpen:1272====nResponse=302
[07-29 09:38:18 52:fa:64] HttpClientOpen:1282====NewHostName=https://freepbx.sheridanpoint.org:3443/?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701
[07-29 09:38:18 52:fa:64] ParseSerPathStr:====== addr is freepbx.sheridanpoint.org
[07-29 09:38:18 52:fa:64] ParseSerPathStr: domain is freepbx.sheridanpoint.org
[07-29 09:38:18 52:fa:64] ParseSerPathStr: path is ?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701
[07-29 09:38:18 52:fa:64] UrlHttpAndHttps302Proc:9644, Server IP:Port is 0xa030006:3443
[07-29 09:38:18 52:fa:64] HTTPSC: HttpsGetFile ?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701, Resolve Domain freepbx.sheridanpoint.org Success, SerIP:0xa030006
[07-29 09:38:18 52:fa:64] HTTPSC: There are Default Device Cert and Key!!!
[07-29 09:38:18 52:fa:64] TLS: commonName: MAC-00505852fa64
[07-29 09:38:18 52:fa:64] HTTPSC: Load Device Cert and Key Success!!!
[07-29 09:38:18 52:fa:64] TLS: HTTPSC Get File, SUPPORT TLS_RSA_WITH_AES_256_CBC_SHA256, TLS_RSA_WITH_AES_128_CBC_SHA, TLS_RSA_WITH_AES_256_CBC_SHA
[07-29 09:38:18 52:fa:64] client https://freepbx.sheridanpoint.org:3443/?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701, ser ip: 10.3.0.6, new: 1, resumed: 0, nciphers: 3, version: TLS 1.2
[07-29 09:38:18 52:fa:64] HTTPS: INITIAL CLIENT SESSION, Will Get /?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701
[07-29 09:38:18 52:fa:64] <<< Client creating CLIENT_HELLO message
[07-29 09:38:18 52:fa:64] >>> Client parsing SERVER_HELLO message
[07-29 09:38:18 52:fa:64] >>> Client parsing CERTIFICATE message
[07-29 09:38:18 52:fa:64] TLS: commonName: freepbx.sheridanpoint.org
[07-29 09:38:18 52:fa:64] TLS: commonName: R3
[07-29 09:38:18 52:fa:64] TLS: commonName: ISRG Root X1
[07-29 09:38:18 52:fa:64] TLS: SSLHandshake, setting(Trusted Certificates) is 2, Doing Custom Certificates Validations...
[07-29 09:38:18 52:fa:64] TLS: There is NO ANY Custom Trusted CA!!!
[07-29 09:38:18 52:fa:64] TLS: ValidateCerts, no issuing cert
[07-29 09:38:18 52:fa:64] TLS: X509AuthCert, sc 0x17754c8, sc->next 0x17740b8
[07-29 09:38:18 52:fa:64] TLS: X509AuthCert, sc 0x17740b8, sc->next 0x1774428
[07-29 09:38:18 52:fa:64] TLS: X509AuthCert, sc 0x1774428, sc->next 0x0
[07-29 09:38:18 52:fa:64] TLS: X509AuthCert, chain cert, node_nums 3
[07-29 09:38:18 52:fa:64] TLS: X509AuthCert, sc 0x17754c8, ic 0x17740b8
[07-29 09:38:18 52:fa:64] TLS: sc.subject.commonName: freepbx.sheridanpoint.org
[07-29 09:38:18 52:fa:64] TLS: sc.issuer .commonName: R3
[07-29 09:38:18 52:fa:64] TLS: ic.subject.commonName: R3
[07-29 09:38:18 52:fa:64] TLS: ic.issuer .commonName: ISRG Root X1
[07-29 09:38:18 52:fa:64] TLS: X509AuthCert, now sc 0x17740b8, ic 0x1774428
[07-29 09:38:18 52:fa:64] TLS: sc.subject.commonName: R3
[07-29 09:38:18 52:fa:64] TLS: sc.issuer .commonName: ISRG Root X1
[07-29 09:38:18 52:fa:64] TLS: ic.subject.commonName: ISRG Root X1
[07-29 09:38:18 52:fa:64] TLS: ic.issuer .commonName: DST Root CA X3
[07-29 09:38:18 52:fa:64] TLS: Checking with Default Trusted CA(ISRG Root X1)
[07-29 09:38:18 52:fa:64] TLS: ValidateCerts, setting(Common Name Validation) is ON
[07-29 09:38:18 52:fa:64] TLS: ValidateCerts, validate the CommonName or SubjectAltName of the certificate...
[07-29 09:38:18 52:fa:64] TLS: ValidateCerts, sc.commonName(freepbx.sheridanpoint.org), expectedName(freepbx.sheridanpoint.org)
[07-29 09:38:18 52:fa:64] SUCCESS: Validated cert for: freepbx.sheridanpoint.org.
[07-29 09:38:18 52:fa:64] >>> Client parsing SERVER_HELLO_DONE message
[07-29 09:38:18 52:fa:64] <<< Client creating CLIENT_KEY_EXCHANGE message
[07-29 09:38:18 52:fa:64] <<< Client creating CHANGE_CIPHER_SPEC message
[07-29 09:38:18 52:fa:64] <<< Client creating FINISHED message
[07-29 09:38:18 52:fa:64] >>> Client parsing NEW_SESSION_TICKET message
[07-29 09:38:18 52:fa:64] >>> Client parsing CHANGE_CIPHER_SPEC message
[07-29 09:38:18 52:fa:64] >>> Client parsing FINISHED message
[07-29 09:38:18 52:fa:64]
[07-29 09:38:18 52:fa:64] TLS 1.2
[07-29 09:38:18 52:fa:64] connection established:
[07-29 09:38:18 52:fa:64] TLS_RSA_WITH_AES_256_CBC_SHA256
[07-29 09:38:18 52:fa:64] SEND:
[GET /?token=d64a9385-dd19-44b5-a7e1-c7f8f2083355&linestate=$$LINESTATE$$&user=701 HTTP/1.1
User-Agent: Sangoma S705 3.0.4.88 00:50:58:52:fa:64
Host: freepbx.sheridanpoint.org
Connection: Keep-Alive
Authorization: Basic MDgxNTI1ZjQ6NDQ0ZWJiZWRlNTA4OTBhZg==
Content-Length: 0
]
[07-29 09:38:18 52:fa:64] DNSC: resolv HostName -- freepbx.sheridanpoint.org
[07-29 09:38:18 52:fa:64] DNSC: Domain freepbx.sheridanpoint.org, ip 10.3.0.6, TTL 3600
[07-29 09:38:18 52:fa:64]
--------------------------len is 259--------------------------------