[Spce-user] Internal error when using TLS

[Jirka Jirout]

Hello Andrew,

> Could you also look into kamailio-lb.log for this call and check if you
> have any errors there?
not really around the time I get this error (see the attached log). Only a few seconds later, there are a few:

Aug 29 11:50:36 crypto2 /usr/sbin/kamailio[1587]: ERROR: <core> [tcp_main.c:4324]: connect 83.161.151.39:54938 failed (timeout) 
Aug 29 11:50:36 crypto2 /usr/sbin/kamailio[1587]: ERROR: <core> [tcp_main.c:4324]: connect 83.161.151.39:54930 failed (timeout) 
Aug 29 11:50:38 crypto2 /usr/sbin/kamailio[1563]: INFO: <core> [parser/parse_fline.c:154]: ERROR:parse_first_line: method not followed by SP
Aug 29 11:50:38 crypto2 /usr/sbin/kamailio[1563]: INFO: <core> [parser/parse_fline.c:251]: ERROR:parse_first_line: bad message
Aug 29 11:50:38 crypto2 /usr/sbin/kamailio[1563]: ERROR: <core> [parser/msg_parser.c:714]: ERROR: parse_msg: message=<?4>
Aug 29 11:50:38 crypto2 /usr/sbin/kamailio[1563]: ERROR: <core> [receive.c:142]: ERROR: receive_msg: parse_msg failed
Aug 29 11:50:38 crypto2 /usr/sbin/kamailio[1563]: INFO: <core> [parser/parse_fline.c:154]: ERROR:parse_first_line: method not followed by SP

regards, jj

-------------- next part --------------
Aug 29 11:50:33 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: New request - M=INVITE R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:33 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: Reset loose-routing, du='sip:crypto.PROVIDER.cz:5888;lr;transport=tcp' - M=INVITE R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:33 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: NATed request detected - M=INVITE R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:33 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: Relaying request, du='sip:127.0.0.1:5062', fs='udp:127.0.0.1:5888' - M=INVITE R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:33 crypto2 /usr/sbin/kamailio[1570]: INFO: <script>: Reply from Inbound - S=100 - Trying F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=udp:127.0.0.1:5062 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:33 crypto2 /usr/sbin/kamailio[1570]: INFO: <script>: Sending reply, fs='udp:172.30.39.11:5888' - S=100 - Trying F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=udp:127.0.0.1:5062 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:33 crypto2 /usr/sbin/kamailio[1574]: INFO: <script>: Reply from Inbound - S=407 - Proxy Authentication Required F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=udp:127.0.0.1:5062 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:33 crypto2 /usr/sbin/kamailio[1574]: INFO: <script>: Sending reply, fs='udp:172.30.39.11:5888' - S=407 - Proxy Authentication Required F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=udp:127.0.0.1:5062 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: New request - M=ACK R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: Reset loose-routing, du='sip:crypto.PROVIDER.cz:5888;lr;transport=tcp' - M=ACK R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: Relaying request, du='sip:127.0.0.1:5062', fs='udp:127.0.0.1:5888' - M=ACK R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: New request - M=INVITE R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: Reset loose-routing, du='sip:crypto.PROVIDER.cz:5888;lr;transport=tcp' - M=INVITE R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: NATed request detected - M=INVITE R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: Relaying request, du='sip:127.0.0.1:5062', fs='udp:127.0.0.1:5888' - M=INVITE R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1568]: INFO: <script>: Reply from Inbound - S=100 - Trying F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=udp:127.0.0.1:5062 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1568]: INFO: <script>: Sending reply, fs='udp:172.30.39.11:5888' - S=100 - Trying F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=udp:127.0.0.1:5062 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1569]: INFO: <script>: Reply from Inbound - S=500 - Server Internal Error F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=udp:127.0.0.1:5062 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1569]: INFO: <script>: Sending reply, fs='udp:172.30.39.11:5888' - S=500 - Server Internal Error F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=udp:127.0.0.1:5062 ID=1106beed-8cff-0673-9aba-96acc4d7f665
Aug 29 11:50:34 crypto2 /usr/sbin/kamailio[1582]: INFO: <script>: New request - M=ACK R=sip:1001 at crypto.PROVIDER.cz F=sip:1004 at crypto.PROVIDER.cz T=sip:1001 at crypto.PROVIDER.cz IP=tcp:83.161.151.39:54945 ID=1106beed-8cff-0673-9aba-96acc4d7f665