[OpenSIPS-Users] Critical:core:anchor_lump: offset exceeds message size (1033 > 1000), abort

Tue Mar 24 16:39:33 CET 2009

Opensips 1.4.5 -- the latest release as of yesterday (non-1.5).

Working on getting you your trace now, will take a few minutes.

Much thanks.

2009/3/24 Bogdan-Andrei Iancu <bogdan at voice-system.ro>

> Hi Bobby,
>
> can you get the logs with debug=6 and post (or send priv to me) ? Also,
> what is the rev number your are using?
>
> Regards,
> Bogdan
>
> bobby.smith at gmail.com wrote:
>
>> A little more information into the problem. We enabled some additional
>> logging around the point where the anchor_lump function was being called to
>> print out the contents of the SIP message. You can see that after processing
>> this message several times, it craps out and kills all the children
>> processes.
>>
>> If someone could once over the routing script that I included to see, if
>> for example, that I'm trying to correct a nat'ed contact where I shouldn't
>> be, that would be much appreciated. Further, if that's not the case, is
>> there a way where we can gracefully kill one child without killing the whole
>> application?
>>
>> Last -- this is with an emergency update to production to Opensips 1.4.5
>> last night. This happened this morning around 9. More importantly, Opensips
>> consumed temporarily almost 2 GB of memory before dying, and then cached it.
>> Huge memory spike.
>>
>> Again, tunables: 32 MB private per process, 16 processes total (at this
>> point, we figured less private memory, more processes to work the CPU), 512
>> Shared memory, on a 4 GB, 2 x Dual Core box.
>>
>>
>>
>> Mar 24 09:09:41 serbox2 /sbin/opensips[2460]:
>> ERROR:registrar:update_contacts: invalid cseq for aor <vh13669>
>> Mar 24 09:09:43 serbox2 /sbin/opensips[2468]: CRITICAL:core:anchor_lump:
>> offset exceeds message size (1207 > 1204 message type 0) aborting...
>> Mar 24 09:09:43 serbox2 /sbin/opensips[2468]: CRITICAL:core:anchor_lump:
>> sip message: INVITE sip:4079641506 at my-domain.domain.com:5060 SIP/2.0^M
>> Via: SIP/2.0/UDP 192.168.1.101:5060;branch=z9hG4bK9b74ccab7^M
>> Max-Forwards: 69^M Content-Length: 566^M To: 4079641506 <
>> sip:4079641506 at my-domain.domain.com:5060>^M From:
>> sip:VH11453 at my-domain.domain.com:5060;tag=09a4248cffc7eac^M Call-ID:
>> 832e7673f6690afbbda3f4355558dcf3 at 192.168.1.101^M CSeq: 1845720778
>> INVITE^M Supported: timer^M Allow-Events: talk,hold,conference^M
>> Allow:NOTIFY,REFER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO^M Content-Type:
>> application/sdp^M Contact: sip:VH11453 at 172.16.0.2<sip%3AVH11453 at 172.16.0.2>^M
>> Supported: replaces^M User-Agent: Aastra 480i/1.4.1.2000 Brcm Callctrl/
>> 1.5.1.0 MxSF/v3.2.6.26^M ^M v=0^M o=MxSIP 0 2095421055 IN IP4
>> 192.168.1.101^M s=SIP Call^M c=IN IP4 192.168.1.101^M t=0 0^M m=audio 3000
>> RTP/AVP 0 18 96 102 107 104 105 106 97 98 2 99 8 101^M a=rtpmap:0
>> PCMU/8000^M a=rtpmap:18 G729/8000^M a=rtpmap:96 BV16/8000^M a=rtpmap:102
>> BV32/16000^M a=rtpmap:107 L16/16000^M
>> Mar 24 09:09:44 serbox2 /sbin/opensips[2463]: CRITICAL:core:anchor_lump:
>> offset exceeds message size (1207 > 1204 message type 0) aborting...
>> Mar 24 09:09:48 serbox2 /sbin/opensips[2463]: CRITICAL:core:anchor_lump:
>> sip message: INVITE sip:4079641506 at my-domain.domain.com:5060 SIP/2.0^M
>> Via: SIP/2.0/UDP 192.168.1.101:5060;branch=z9hG4bK9b74ccab7^M
>> Max-Forwards: 69^M Content-Length: 566^M To: 4079641506 <
>> sip:4079641506 at my-domain.domain.com:5060>^M From:
>> sip:VH11453 at my-domain.domain.com:5060;tag=09a4248cffc7eac^M Call-ID:
>> 832e7673f6690afbbda3f4355558dcf3 at 192.168.1.101^M CSeq: 1845720778
>> INVITE^M Supported: timer^M Allow-Events: talk,hold,conference^M
>> Allow:NOTIFY,REFER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO^M Content-Type:
>> application/sdp^M Contact: sip:VH11453 at 172.16.0.2<sip%3AVH11453 at 172.16.0.2>^M
>> Supported: replaces^M User-Agent: Aastra 480i/1.4.1.2000 Brcm Callctrl/
>> 1.5.1.0 MxSF/v3.2.6.26^M ^M v=0^M o=MxSIP 0 2095421055 IN IP4
>> 192.168.1.101^M s=SIP Call^M c=IN IP4 192.168.1.101^M t=0 0^M m=audio 3000
>> RTP/AVP 0 18 96 102 107 104 105 106 97 98 2 99 8 101^M a=rtpmap:0
>> PCMU/8000^M a=rtpmap:18 G729/8000^M a=rtpmap:96 BV16/8000^M a=rtpmap:102
>> BV32/16000^M a=rtpmap:107 L16/16000^M
>> Mar 24 09:10:12 serbox2 /sbin/opensips[2466]:
>> ERROR:registrar:update_contacts: invalid cseq for aor <vh12317>
>> Mar 24 09:10:31 serbox2 /sbin/opensips[2465]: CRITICAL:core:anchor_lump:
>> offset exceeds message size (1205 > 1204 message type 0) aborting...
>> Mar 24 09:10:31 serbox2 /sbin/opensips[2465]: CRITICAL:core:anchor_lump:
>> sip message: INVITE sip:4079641506 at my-domain.domain.com:5060 SIP/2.0^M
>> Via: SIP/2.0/UDP 192.168.1.101:5060;branch=z9hG4bK9b74ccab7^M
>> Max-Forwards: 69^M Content-Length: 566^M To: 4079641506 <
>> sip:4079641506 at my-domain.domain.com:5060>^M From:
>> sip:VH11453 at my-domain.domain.com:5060;tag=09a4248cffc7eac^M Call-ID:
>> 832e7673f6690afbbda3f4355558dcf3 at 192.168.1.101^M CSeq: 1845720778
>> INVITE^M Supported: timer^M Allow-Events: talk,hold,conference^M
>> Allow:NOTIFY,REFER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO^M Content-Type:
>> application/sdp^M Contact: sip:VH11453 at 172.16.0.2<sip%3AVH11453 at 172.16.0.2>^M
>> Supported: replaces^M User-Agent: Aastra 480i/1.4.1.2000 Brcm Callctrl/
>> 1.5.1.0 MxSF/v3.2.6.26^M ^M v=0^M o=MxSIP 0 2095421055 IN IP4
>> 192.168.1.101^M s=SIP Call^M c=IN IP4 192.168.1.101^M t=0 0^M m=audio 3000
>> RTP/AVP 0 18 96 102 107 104 105 106 97 98 2 99 8 101^M a=rtpmap:0
>> PCMU/8000^M a=rtpmap:18 G729/8000^M a=rtpmap:96 BV16/8000^M a=rtpmap:102
>> BV32/16000^M a=rtpmap:107 L16/16000^M
>> Mar 24 09:10:31 serbox2 /sbin/opensips[2470]:
>> ERROR:registrar:update_contacts: invalid cseq for aor <vh13669>
>> Mar 24 09:10:31 serbox2 /sbin/opensips[2473]: CRITICAL:core:anchor_lump:
>> offset exceeds message size (1205 > 1204 message type 0) aborting...
>> Mar 24 09:10:31 serbox2 /sbin/opensips[2473]: CRITICAL:core:anchor_lump:
>> sip message: INVITE sip:4079641506 at my-domain.domain.com:5060 SIP/2.0^M
>> Via: SIP/2.0/UDP 192.168.1.101:5060;branch=z9hG4bK9b74ccab7^M
>> Max-Forwards: 69^M Content-Length: 566^M To: 4079641506 <
>> sip:4079641506 at my-domain.domain.com:5060>^M From:
>> sip:VH11453 at my-domain.domain.com:5060;tag=09a4248cffc7eac^M Call-ID:
>> 832e7673f6690afbbda3f4355558dcf3 at 192.168.1.101^M CSeq: 1845720778
>> INVITE^M Supported: timer^M Allow-Events: talk,hold,conference^M
>> Allow:NOTIFY,REFER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO^M Content-Type:
>> application/sdp^M Contact: sip:VH11453 at 172.16.0.2<sip%3AVH11453 at 172.16.0.2>^M
>> Supported: replaces^M User-Agent: Aastra 480i/1.4.1.2000 Brcm Callctrl/
>> 1.5.1.0 MxSF/v3.2.6.26^M ^M v=0^M o=MxSIP 0 2095421055 IN IP4
>> 192.168.1.101^M s=SIP Call^M c=IN IP4 192.168.1.101^M t=0 0^M m=audio 3000
>> RTP/AVP 0 18 96 102 107 104 105 106 97 98 2 99 8 101^M a=rtpmap:0
>> PCMU/8000^M a=rtpmap:18 G729/8000^M a=rtpmap:96 BV16/8000^M a=rtpmap:102
>> BV32/16000^M a=rtpmap:107 L16/16000^M
>> Mar 24 09:10:31 serbox2 /sbin/opensips[2472]: CRITICAL:core:anchor_lump:
>> offset exceeds message size (1231 > 1220 message type 0) aborting...
>> Mar 24 09:10:32 serbox2 /sbin/opensips[2472]: CRITICAL:core:anchor_lump:
>> sip message: INVITE sip:4079641506 at my-domain.domain.com<sip%3A4079641506 at my-domain.domain.com>SIP/2.0^M Via: SIP/2.0/UDP 192.168.1.101:5060;branch=z9hG4bKf9fa46fbd^M
>> Max-Forwards: 69^M Content-Length: 574^M To: 4079641506 <
>> sip:4079641506 at my-domain.domain.com<sip%3A4079641506 at my-domain.domain.com>>^M
>> From: VH11453 <sip:VH11453 at my-domain.domain.com:5060>;tag=f2e9f213020776c^M
>> Call-ID: 1703e7198ef1277b9b7a2a7d55604ce0 at 192.168.1.101^M CSeq: 54476585
>> INVITE^M Supported: timer^M Allow-Events: talk,hold,conference^M
>> Allow:NOTIFY,REFER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO^M Content-Type:
>> application/sdp^M Contact: VH11453 <sip:VH11453 at 192.168.1.101:5060>^M
>> Supported: replaces^M User-Agent: Aastra 480i/1.4.1.2000 Brcm Callctrl/
>> 1.5.1.0 MxSF/v3.2.6.26^M ^M v=0^M o=MxSIP 0 1470460733 IN IP4
>> 192.168.1.101^M s=SIP Call^M c=IN IP4 192.168.1.101^M t=0 0^M m=audio 3000
>> RTP/AVP 0 18 96 102 107 104 105 106 97 98 2 99 8 101^M a=rtpmap:0
>> PCMU/8000^M a=rtpmap:18 G729/8000^M a=rtpmap:96 BV16/8000^M a=rtpmap:102
>> BV32/16000^M a=rtpmap:
>> Mar 24 09:10:33 serbox2 /sbin/opensips[2469]: CRITICAL:core:anchor_lump:
>> offset exceeds message size (1231 > 1220 message type 0) aborting...
>> Mar 24 09:10:36 serbox2 /sbin/opensips[2469]: CRITICAL:core:anchor_lump:
>> sip message: INVITE sip:4079641506 at my-domain.domain.com<sip%3A4079641506 at my-domain.domain.com>SIP/2.0^M Via: SIP/2.0/UDP 192.168.1.101:5060;branch=z9hG4bKf9fa46fbd^M
>> Max-Forwards: 69^M Content-Length: 574^M To: 4079641506 <
>> sip:4079641506 at my-domain.domain.com<sip%3A4079641506 at my-domain.domain.com>>^M
>> From: VH11453 <sip:VH11453 at my-domain.domain.com:5060>;tag=f2e9f213020776c^M
>> Call-ID: 1703e7198ef1277b9b7a2a7d55604ce0 at 192.168.1.101^M CSeq: 54476585
>> INVITE^M Supported: timer^M Allow-Events: talk,hold,conference^M
>> Allow:NOTIFY,REFER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO^M Content-Type:
>> application/sdp^M Contact: VH11453 <sip:VH11453 at 192.168.1.101:5060>^M
>> Supported: replaces^M User-Agent: Aastra 480i/1.4.1.2000 Brcm Callctrl/
>> 1.5.1.0 MxSF/v3.2.6.26^M ^M v=0^M o=MxSIP 0 1470460733 IN IP4
>> 192.168.1.101^M s=SIP Call^M c=IN IP4 192.168.1.101^M t=0 0^M m=audio 3000
>> RTP/AVP 0 18 96 102 107 104 105 106 97 98 2 99 8 101^M a=rtpmap:0
>> PCMU/8000^M a=rtpmap:18 G729/8000^M a=rtpmap:96 BV16/8000^M a=rtpmap:102
>> BV32/16000^M a=rtpmap:
>> Mar 24 09:10:40 serbox2 /sbin/opensips[2459]:
>> ERROR:registrar:update_contacts: invalid cseq for aor <vh12317>
>> Mar 24 09:10:40 serbox2 /sbin/opensips[2461]: CRITICAL:core:anchor_lump:
>> offset exceeds message size (1231 > 1220 message type 0) aborting...
>> Mar 24 09:10:40 serbox2 /sbin/opensips[2474]:
>> ERROR:registrar:update_contacts: invalid cseq for aor <vh13669>
>> Mar 24 09:10:40 serbox2 /sbin/opensips[2421]: INFO:core:handle_sigs: child
>> process 2468 exited by a signal 6
>> Mar 24 09:10:40 serbox2 /sbin/opensips[2461]: CRITICAL:core:anchor_lump:
>> sip message: INVITE sip:4079641506 at my-domain.domain.com<sip%3A4079641506 at my-domain.domain.com>SIP/2.0^M Via: SIP/2.0/UDP 192.168.1.101:5060;branch=z9hG4bKf9fa46fbd^M
>> Max-Forwards: 69^M Content-Length: 574^M To: 4079641506 <
>> sip:4079641506 at my-domain.domain.com<sip%3A4079641506 at my-domain.domain.com>>^M
>> From: VH11453 <sip:VH11453 at my-domain.domain.com:5060>;tag=f2e9f213020776c^M
>> Call-ID: 1703e7198ef1277b9b7a2a7d55604ce0 at 192.168.1.101^M CSeq: 54476585
>> INVITE^M Supported: timer^M Allow-Events: talk,hold,conference^M
>> Allow:NOTIFY,REFER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO^M Content-Type:
>> application/sdp^M Contact: VH11453 <sip:VH11453 at 192.168.1.101:5060>^M
>> Supported: replaces^M User-Agent: Aastra 480i/1.4.1.2000 Brcm Callctrl/
>> 1.5.1.0 MxSF/v3.2.6.26^M ^M v=0^M o=MxSIP 0 1470460733 IN IP4
>> 192.168.1.101^M s=SIP Call^M c=IN IP4 192.168.1.101^M t=0 0^M m=audio 3000
>> RTP/AVP 0 18 96 102 107 104 105 106 97 98 2 99 8 101^M a=rtpmap:0
>> PCMU/8000^M a=rtpmap:18 G729/8000^M a=rtpmap:96 BV16/8000^M a=rtpmap:102
>> BV32/16000^M a=rtpmap:
>> Mar 24 09:10:40 serbox2 /sbin/opensips[2464]:
>> ERROR:registrar:update_contacts: invalid cseq for aor <vh13669>
>> Mar 24 09:10:40 serbox2 /sbin/opensips[2474]:
>> ERROR:registrar:update_contacts: invalid cseq for aor <vh20664>
>> ------------------------------------------------------------------------
>>
>> _______________________________________________
>> Users mailing list
>> Users at lists.opensips.org
>> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>>
>>
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.opensips.org/pipermail/users/attachments/20090324/8dbe2c70/attachment-0001.htm 