decoder.go:103: WARN malformed packet with length 1750 which is neither hep nor protobuf encapsulated
--
You received this message because you are subscribed to the Google Groups "Homer Capture Server. sipcapture.org" group.
To unsubscribe from this group and stop receiving emails from it, send an email to homer-discus...@googlegroups.com.
For more options, visit https://groups.google.com/d/optout.
The homer project has a long history and a lot of cool stuff was added from time to time.
In some parts the documentation is like a puzzle. You have to lookup things here, in the github wiki and github issues.
Some time ago I was exactly in the same spot like you but trust me the most information are there.
Just search smartly and you will find them. The best way would be to contribute your findings back and improve the wiki :)
To your questions. First of all you need to know that there are RFC 3611 RTCP XR reports and RFC 6035 RTCP-XR reports inside SIP PUBLISH.
Google them both please. This thread is about RTCP-XR reports inside SIP PUBLISH.
You can spot them inside the SIP Body or look for the SIP header with Content-Type: application/vq-rtcpxr.
Now forget everything you did in the past and start with a fresh mind ;) I will tell you what you need to do.
Today during lunch I was in the mood to write a tiny collector for SIP PUBLISH RTCP-XR messages. Check it out:
https://github.com/negbie/heplify-xrcollector
Next you need heplify-server as a capture server. Since I'm not a big fan of installer scripts I would recommend you this guide:
https://github.com/sipcapture/heplify-server/tree/master/example/install/homer5
Point your phones to the heplify-xrcollector listen address (default port 9064) and it should send the reports to heplify-server.
# Listen on 0.0.0.0:9066 for vq-rtcpxr and send it as HEP to 192.168.1.10:9060 ./heplify-xrcollector -xs :9066 -hs 192.168.1.10:9060
2018/11/30 15:09:56 listen udp 192.168.1.1:9060: bind: cannot assign requested address
2018/12/01 12:54:21 Sent following RTCP-XR PUBLISH packet with 318 bytes:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.8.0.10:5060;branch=z9hG4bK919994501
From: "404" <sip:4...@10.8.0.1:5060>;tag=3018439844
To: <sip:Ho...@192.168.1.141:9066>;tag=Fg2Uy0r7geBQF
Contact: <sip:4...@10.8.0.10:5060>
Call-ID: 0_2943...@10.8.0.10
Cseq: 1 PUBLISH
User-Agent: heplify-xrcollector
Content-Length: 0
Hi,I had an copy paste issue. And used the hepserver address as collector address. Fixed it and uploaded a new binary under the same version. Please download it again.
--
Since I can't reproduce your issue I made a new docker-compose file which includes heplify-xrcollector into the stack:I wrote a simple test program which sends following packets multiple times to socket :9064
invite = "INVITE sip:87.103.120.253:9070 SIP/2.0\r\n" +
"Via: SIP/2.0/UDP 10.0.3.13:3072;branch=z9hG4bK-2atcagwblzv2;rport\r\n" +
"From: <sip:...@10.0.3.252>;tag=2ygtpy7bgk\r\n" +
"To: <sip:87.103.120.253:9070>\r\n" +
"Call-ID: 825962570309-8ds5sl3mca99\r\n" +
"CSeq: 1 INVITE\r\n" +
"Max-Forwards: 70\r\n" +
"Contact: <sip:50...@10.0.3.13:3072;line=swv8im3f>;reg-id=1\r\n" +
"User-Agent: snom821/873_19_20130321\r\n\r\n"
publish = "PUBLISH sip:87.103.120.253:9070 SIP/2.0\r\n" +
"Via: SIP/2.0/UDP 10.0.3.13:3072;branch=z9hG4bK-2atcagwblzv2;rport\r\n" +
"From: <sip:...@10.0.3.252>;tag=2ygtpy7bgk\r\n" +
"To: <sip:87.103.120.253:9070>\r\n" +
"Call-ID: 89596257635d-ip18q8n0lp1b\r\n" +
"CSeq: 2 PUBLISH\r\n" +
"Max-Forwards: 70\r\n" +
"Contact: <sip:50...@10.0.3.13:3072;line=swv8im3f>;reg-id=1\r\n" +
"User-Agent: snom821/873_19_20130321\r\n" +
"Event: vq-rtcpxr\r\n" +
"Accept: application/sdp, message/sipfrag\r\n" +
"Content-Type: application/vq-rtcpxr\r\n" +
"Content-Length: 804\r\n\r\n" +
"VQSessionReport: CallTerm\r\n" +
"CallID:825962570309-8ds5sl3mca99\r\n" +
"LocalID:<sip:...@10.0.3.252>\r\n" +
"RemoteID:<sip...@10.0.3.252;user=phone>\r\n" +
"OrigID:<sip:...@10.0.3.252>\r\n" +
"LocalAddr:IP=10.0.3.13 PORT=57460 SSRC=0x014EA261\r\n" +
"LocalMAC:0004135310DB\r\n" +
"RemoteAddr:IP=10.0.3.252 PORT=10034 SSRC=0x1F634EA2\r\n" +
"DialogID:825962570309-8ds5sl3mca99;to-tag=gqj87t0stF-M8g.kPREKLthaGl030mze;from-tag=2ygtpy7bgk\r\n" +
"x-UserAgent:snom821/873_19_20130321\r\n" +
"LocalMetrics:\r\n" +
"Timestamps:START=2016-06-16T07:47:14Z STOP=2016-06-16T07:47:21Z\r\n" +
"SessionDesc:PT=8 PD=PCMA SR=8000 PPS=50 SSUP=off\r\n" +
"x-SIPmetrics:SVA=RG SRD=392 SFC=0\r\n" +
"x-SIPterm:SDC=OK SDT=7 SDR=OR\r\n" +
"JitterBuffer:JBA=3 JBR=2 JBN=20 JBM=20JBX=240\r\n" +
"PacketLoss:NLR=3.0 JDR=3.0\r\n" +
"BurstGapLoss:BLD=0.0 BD=0 GLD=0.0 GD=5930 GMIN=16\r\n" +
"Delay:RTD=0 ESD=0 IAJ=11\r\n" +
"QualityEst:MOSLQ=4.1 MOSCQ=4.1\r\n"
Since I can't reproduce your issue I made a new docker-compose file which includes heplify-xrcollector into the stack:I wrote a simple test program which sends following packets multiple times to socket :9064
invite = "INVITE sip:87.103.120.253:9070 SIP/2.0\r\n" +
"Via: SIP/2.0/UDP 10.0.3.13:3072;branch=z9hG4bK-2atcagwblzv2;rport\r\n" +
"From: <sip:...@10.0.3.252>;tag=2ygtpy7bgk\r\n" +
"To: <sip:87.103.120.253:9070>\r\n" +
"Call-ID: 825962570309-8ds5sl3mca99\r\n" +
"CSeq: 1 INVITE\r\n" +
"Max-Forwards: 70\r\n" +
"Contact: <sip:50...@10.0.3.13:3072;line=swv8im3f>;reg-id=1\r\n" +
"User-Agent: snom821/873_19_20130321\r\n\r\n"
publish = "PUBLISH sip:87.103.120.253:9070 SIP/2.0\r\n" +
"Via: SIP/2.0/UDP 10.0.3.13:3072;branch=z9hG4bK-2atcagwblzv2;rport\r\n" +
"From: <sip:...@10.0.3.252>;tag=2ygtpy7bgk\r\n" +
"To: <sip:87.103.120.253:9070>\r\n" +
"Call-ID: 89596257635d-ip18q8n0lp1b\r\n" +
"CSeq: 2 PUBLISH\r\n" +
"Max-Forwards: 70\r\n" +
"Contact: <sip:50...@10.0.3.13:3072;line=swv8im3f>;reg-id=1\r\n" +
"User-Agent: snom821/873_19_20130321\r\n" +
"Event: vq-rtcpxr\r\n" +
"Accept: application/sdp, message/sipfrag\r\n" +
"Content-Type: application/vq-rtcpxr\r\n" +
"Content-Length: 804\r\n\r\n" +
"VQSessionReport: CallTerm\r\n" +
"CallID:825962570309-8ds5sl3mca99\r\n" +
"LocalID:<sip:...@10.0.3.252>\r\n" +
"LocalAddr:IP=10.0.3.13 PORT=57460 SSRC=0x014EA261\r\n" +
"LocalMAC:0004135310DB\r\n" +
"RemoteAddr:IP=10.0.3.252 PORT=10034 SSRC=0x1F634EA2\r\n" +
"DialogID:825962570309-8ds5sl3mca99;to-tag=gqj87t0stF-M8g.kPREKLthaGl030mze;from-tag=2ygtpy7bgk\r\n" +
"x-UserAgent:snom821/873_19_20130321\r\n" +
"LocalMetrics:\r\n" +
"Timestamps:START=2016-06-16T07:47:14Z STOP=2016-06-16T07:47:21Z\r\n" +
"SessionDesc:PT=8 PD=PCMA SR=8000 PPS=50 SSUP=off\r\n" +
"x-SIPmetrics:SVA=RG SRD=392 SFC=0\r\n" +
"x-SIPterm:SDC=OK SDT=7 SDR=OR\r\n" +
"JitterBuffer:JBA=3 JBR=2 JBN=20 JBM=20JBX=240\r\n" +
"PacketLoss:NLR=3.0 JDR=3.0\r\n" +
"BurstGapLoss:BLD=0.0 BD=0 GLD=0.0 GD=5930 GMIN=16\r\n" +
"Delay:RTD=0 ESD=0 IAJ=11\r\n" +
"QualityEst:MOSLQ=4.1 MOSCQ=4.1\r\n"
Sockets
- HEP packet input :9060
- RTCP-XR phone input :9064
Since I can't reproduce your issue I made a new docker-compose file which includes heplify-xrcollector into the stack:I wrote a simple test program which sends following packets multiple times to socket :9064
invite = "INVITE sip:87.103.120.253:9070 SIP/2.0\r\n" +
"Via: SIP/2.0/UDP 10.0.3.13:3072;branch=z9hG4bK-2atcagwblzv2;rport\r\n" +
"From: <sip:...@10.0.3.252>;tag=2ygtpy7bgk\r\n" +
"To: <sip:87.103.120.253:9070>\r\n" +
"Call-ID: 825962570309-8ds5sl3mca99\r\n" +
"CSeq: 1 INVITE\r\n" +
"Max-Forwards: 70\r\n" +
"Contact: <sip:50...@10.0.3.13:3072;line=swv8im3f>;reg-id=1\r\n" +
"User-Agent: snom821/873_19_20130321\r\n\r\n"
publish = "PUBLISH sip:87.103.120.253:9070 SIP/2.0\r\n" +
"Via: SIP/2.0/UDP 10.0.3.13:3072;branch=z9hG4bK-2atcagwblzv2;rport\r\n" +
"From: <sip:...@10.0.3.252>;tag=2ygtpy7bgk\r\n" +
"To: <sip:87.103.120.253:9070>\r\n" +
"Call-ID: 89596257635d-ip18q8n0lp1b\r\n" +
"CSeq: 2 PUBLISH\r\n" +
"Max-Forwards: 70\r\n" +
"Contact: <sip:50...@10.0.3.13:3072;line=swv8im3f>;reg-id=1\r\n" +
"User-Agent: snom821/873_19_20130321\r\n" +
"Event: vq-rtcpxr\r\n" +
"Accept: application/sdp, message/sipfrag\r\n" +
"Content-Type: application/vq-rtcpxr\r\n" +
"Content-Length: 804\r\n\r\n" +
"VQSessionReport: CallTerm\r\n" +
"CallID:825962570309-8ds5sl3mca99\r\n" +
"LocalID:<sip:...@10.0.3.252>\r\n" +
"LocalAddr:IP=10.0.3.13 PORT=57460 SSRC=0x014EA261\r\n" +
"LocalMAC:0004135310DB\r\n" +
"RemoteAddr:IP=10.0.3.252 PORT=10034 SSRC=0x1F634EA2\r\n" +
"DialogID:825962570309-8ds5sl3mca99;to-tag=gqj87t0stF-M8g.kPREKLthaGl030mze;from-tag=2ygtpy7bgk\r\n" +
"x-UserAgent:snom821/873_19_20130321\r\n" +
"LocalMetrics:\r\n" +
"Timestamps:START=2016-06-16T07:47:14Z STOP=2016-06-16T07:47:21Z\r\n" +
"SessionDesc:PT=8 PD=PCMA SR=8000 PPS=50 SSUP=off\r\n" +
"x-SIPmetrics:SVA=RG SRD=392 SFC=0\r\n" +
"x-SIPterm:SDC=OK SDT=7 SDR=OR\r\n" +
"JitterBuffer:JBA=3 JBR=2 JBN=20 JBM=20JBX=240\r\n" +
"PacketLoss:NLR=3.0 JDR=3.0\r\n" +
"BurstGapLoss:BLD=0.0 BD=0 GLD=0.0 GD=5930 GMIN=16\r\n" +
"Delay:RTD=0 ESD=0 IAJ=11\r\n" +
"QualityEst:MOSLQ=4.1 MOSCQ=4.1\r\n"
2018/12/04 21:12:43 Sent back OK with 319 bytes to 192.168.1.226:5060
2018-12-04 21:17:30 13 [Warning] Aborted connection 13 to db: 'homer_data' user: 'root' host: '172.21.0.8' (Got timeout reading communication packets)
heplify-xrcollector | 2018/12/05 19:22:15 Received packet with 1748 bytes from 192.168.1.226:5060
heplify-xrcollector | 2018/12/05 19:22:15 Sent back OK with 316 bytes to 192.168.1.226:5060
# mysql
Welcome to the MariaDB monitor. Commands end with ; or \g.
Your MariaDB connection id is 83
Server version: 10.3.11-MariaDB-1:10.3.11+maria~bionic mariadb.org binary distribution
Copyright (c) 2000, 2018, Oracle, MariaDB Corporation Ab and others.
Type 'help;' or '\h' for help. Type '\c' to clear the current input statement.
MariaDB [(none)]> select * from homer_data.report_capture_all_20181205;
Empty set (0.002 sec)
db | 2018-12-05 19:33:43 13 [Warning] Aborted connection 13 to db: 'homer_data' user: 'root' host: '172.18.0.8' (Got timeout reading communication packets)
heplify-xrcollector | 2018/12/07 22:34:15 Sent back OK with 342 bytes to 172.18.0.1:41705
heplify-xrcollector | 2018/12/07 22:34:15 Received packet with 1274 bytes from 172.18.0.1:41705
heplify-xrcollector | 2018/12/07 22:34:15 Sent back OK with 342 bytes to 172.18.0.1:41705
heplify-xrcollector | 2018/12/07 22:34:15 Received packet with 1274 bytes from 172.18.0.1:41705
heplify-xrcollector | 2018/12/07 22:34:15 Sent back OK with 342 bytes to 172.18.0.1:41705
heplify-server | 2018/12/07 22:35:12.633159 rotator.go:279: INFO end creating tables (2018-12-07 22:35:12.633131368 +0000 UTC m=+156.311568884)
heplify-server | 2018/12/07 22:35:12.633944 rotator.go:234: INFO schedule daily rotate job at 03:30:00
heplify-server | 2018/12/07 22:35:12.635271 rotator.go:248: INFO schedule daily drop job at 03:45:00
heplify-server | 2018/12/07 22:35:12.638561 sqlhomer5.go:137: INFO mysql connection established
heplify-server | 2018/12/07 22:37:36.380501 server.go:399: INFO stats since last 5 minutes. PPS: 0, HEP: 32, Duplicate: 0, Error: 0
alertmanager | level=error ts=2018-12-07T22:40:29.823225271Z caller=notify.go:332 component=dispatcher msg="Error on not ify" err="dial tcp 127.0.0.1:25: connect: connection refused"
alertmanager | level=error ts=2018-12-07T22:40:29.824244935Z caller=dispatch.go:280 component=dispatcher msg="Notify for alerts failed" num_alerts=1 err="dial tcp 127.0.0.1:25: connect: connection refused"
heplify-server | 2018/12/07 22:42:36.380997 server.go:399: INFO stats since last 5 minutes. PPS: 0, HEP: 0, Duplicate: 0, Error: 0
db | 2018-12-07 22:45:16 13 [Warning] Aborted connection 13 to db: 'homer_data' user: 'root' host: '172.18.0.8 ' (Got timeout reading communication packets)