-- SIP Seeding peer from astdb: '1199' at 1199@84.132.106.117:5060 for 1800 Transmitting (NAT) to 84.132.106.117:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 84.132.106.117;branch=z9hG4bK55151138E209599603678C8BE350;received=84.132.106.117 From: ;tag=714999007 To: Call-ID: 2B8E8794C78EE580994E54785F80@192.168.2.1 CSeq: 239 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Supported: replaces Contact: Content-Length: 0 --- -- Saved useragent "AVM Speedport W 501V 28.03.93 (Nov 18 2005)" for peer 1199 [Aug 29 09:10:17] DEBUG[14030]: res_config_mysql.c:663 mysql_reconnect: MySQL RealTime: Everything is fine. [Aug 29 09:10:17] DEBUG[14030]: res_config_mysql.c:357 update_mysql: MySQL RealTime: Update SQL: UPDATE sip SET ipaddr = '84.132.106.117', port = '5060', regseconds = '1156837217', username = '1199' WHERE name = '1199' [Aug 29 09:10:17] DEBUG[14030]: res_config_mysql.c:371 update_mysql: MySQL RealTime: Updated 1 rows on table: sip Transmitting (NAT) to 84.132.106.117:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 84.132.106.117;branch=z9hG4bK55151138E209599603678C8BE350;received=84.132.106.117 From: ;tag=714999007 To: ;tag=as3d2ab7cb Call-ID: 2B8E8794C78EE580994E54785F80@192.168.2.1 CSeq: 239 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Supported: replaces Expires: 1800 Contact: ;expires=1800 Date: Tue, 29 Aug 2006 07:10:17 GMT Content-Length: 0 --- [Aug 29 09:10:17] DEBUG[14030]: devicestate.c:303 __ast_device_state_changed_literal: Notification of state change to be queued on device/channel SIP/1199 [Aug 29 09:10:17] DEBUG[14030]: chan_sip.c:2257 sip_destroy_peer: Destroying SIP peer 1199 Scheduling destruction of SIP dialog '2B8E8794C78EE580994E54785F80@192.168.2.1' in 15000 ms (Method: REGISTER) <-- SIP read from 84.132.106.117:5060: SUBSCRIBE sip:1199@88.198.230.110 SIP/2.0 Via: SIP/2.0/UDP 84.132.106.117;branch=z9hG4bK6A55A6337228F63C5C1489F29C25 From: ;tag=2294924750 To: ;tag=as44aebebb Call-ID: 00432BE47033A588C5492A1FE6B0@84.132.106.117 CSeq: 238 SUBSCRIBE Contact: Authorization: Digest username="1199", realm="asterisk", nonce="5f0bf172", uri="sip:1199@88.198.230.110", response="136bc6a53e9c99247d60b2735cd2c28a", algorithm=MD5 Event: message-summary Expires: 3600 Max-Forwards: 70 User-Agent: AVM Speedport W 501V 28.03.93 (Nov 18 2005) Allow: NOTIFY Accept: application/simple-message-summary Content-Length: 0 [Aug 29 09:10:17] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 0: SUBSCRIBE sip:1199@88.198.230.110 SIP/2.0 (41) [Aug 29 09:10:17] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 1: Via: SIP/2.0/UDP 84.132.106.117;branch=z9hG4bK6A55A6337228F63C5C1489F29C25 (74) [Aug 29 09:10:17] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 2: From: ;tag=2294924750 (46) [Aug 29 09:10:17] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 3: To: ;tag=as44aebebb (44) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 4: Call-ID: 00432BE47033A588C5492A1FE6B0@84.132.106.117 (52) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 5: CSeq: 238 SUBSCRIBE (19) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 6: Contact: (68) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 7: Authorization: Digest username="1199", realm="asterisk", nonce="5f0bf172", uri="sip:1199@88.198.230.110", response="136bc6a53e9c99247d60b2735cd2c28a", algorithm=MD5 (164) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 8: Event: message-summary (22) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 9: Expires: 3600 (13) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 10: Max-Forwards: 70 (16) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 11: User-Agent: AVM Speedport W 501V 28.03.93 (Nov 18 2005) (55) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 12: Allow: NOTIFY (13) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 13: Accept: application/simple-message-summary (42) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 14: Content-Length: 0 (17) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 15: (0) --- (15 headers 0 lines)--- [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4157 find_call: = Found Their Call ID: 00432BE47033A588C5492A1FE6B0@84.132.106.117 Their Tag 2294924750 Our tag: as52c87d40 [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:14008 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13645 handle_request_subscribe: XXX: function started event='message-summary',accept='application/simple-message-summary',p='81BD570' [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13659 handle_request_subscribe: Got a new subscription 00432BE47033A588C5492A1FE6B0@84.132.106.117 (possibly with auth) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13662 handle_request_subscribe: XXX: p='81BD570' [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13671 handle_request_subscribe: XXX: p='81BD570' [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13683 handle_request_subscribe: XXX: p='81BD570' [Aug 29 09:10:18] DEBUG[14030]: res_config_mysql.c:663 mysql_reconnect: MySQL RealTime: Everything is fine. [Aug 29 09:10:18] DEBUG[14030]: res_config_mysql.c:141 realtime_mysql: MySQL RealTime: Retrieve SQL: SELECT * FROM sip WHERE name = '1199' -- SIP Seeding peer from astdb: '1199' at 1199@84.132.106.117:5060 for 1800 Found peer '1199' [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13703 handle_request_subscribe: XXX: p='81BD570' Looking for 1199 in internal (domain 88.198.230.110) [Aug 29 09:10:18] DEBUG[14030]: res_config_mysql.c:663 mysql_reconnect: MySQL RealTime: Everything is fine. [Aug 29 09:10:18] DEBUG[14030]: res_config_mysql.c:141 realtime_mysql: MySQL RealTime: Retrieve SQL: SELECT * FROM extensions WHERE exten = '1199' AND context = 'internal' AND priority = '1' [Aug 29 09:10:17] DEBUG[14011]: devicestate.c:161 ast_device_state: No provider found, checking channel drivers for SIP - 1199 [Aug 29 09:10:18] DEBUG[14011]: chan_sip.c:14592 sip_devicestate: Checking device state for peer 1199 [Aug 29 09:10:18] DEBUG[14030]: res_config_mysql.c:663 mysql_reconnect: MySQL RealTime: Everything is fine. [Aug 29 09:10:18] DEBUG[14030]: res_config_mysql.c:261 realtime_multi_mysql: MySQL RealTime: Retrieve SQL: SELECT * FROM extensions WHERE exten LIKE '\\_%' AND context = 'internal' AND priority = '1' ORDER BY exten [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13713 handle_request_subscribe: XXX: p='81BD570' [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13723 handle_request_subscribe: XXX: p='81BD570' [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13793 handle_request_subscribe: XXX: p='81BD570' [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13798 handle_request_subscribe: XXX: p='81BD570' [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13804 handle_request_subscribe: XXX: p='81BD570' [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13807 handle_request_subscribe: Adding subscription for mailbox notification - peer 1199 Mailbox 13 Scheduling destruction of SIP dialog '00432BE47033A588C5492A1FE6B0@84.132.106.117' in 3610000 ms (Method: SUBSCRIBE) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13815 handle_request_subscribe: XXX: p='81BD570' Transmitting (NAT) to 84.132.106.117:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 84.132.106.117;branch=z9hG4bK6A55A6337228F63C5C1489F29C25;received=84.132.106.117 From: ;tag=2294924750 To: ;tag=as44aebebb Call-ID: 00432BE47033A588C5492A1FE6B0@84.132.106.117 CSeq: 238 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Supported: replaces Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Reliably Transmitting (NAT) to 84.132.106.117:5060: NOTIFY sip:1199@84.132.106.117;uniq=6F29334C96730DAC9D312E7F99C6 SIP/2.0 Via: SIP/2.0/UDP 88.198.230.110:5060;branch=z9hG4bK7ed7246b;rport From: "asterisk" ;tag=as52c87d40 To: ;tag=2294924750 Contact: Call-ID: 00432BE47033A588C5492A1FE6B0@84.132.106.117 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Max-Forwards: 70 Event: message-summary Content-Type: application/simple-message-summary Subscription-State: active Content-Length: 95 Messages-Waiting: yes Message-Account: sip:asterisk@sip.betamax.de Voice-Message: 3/0 (0/0) --- [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:1902 __sip_reliable_xmit: *** SIP TIMER: Initalizing retransmit timer on packet: Id #631 [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:13870 handle_request_subscribe: XXX END: p='81BD570' [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:2257 sip_destroy_peer: Destroying SIP peer 1199 [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:2976 sip_destroy: Destroying SIP dialog 00432BE47033A588C5492A1FE6B0@84.132.106.117 Really destroying SIP dialog '00432BE47033A588C5492A1FE6B0@84.132.106.117' Method: SUBSCRIBE <-- SIP read from 84.132.106.117:5060: SUBSCRIBE sip:1199@88.198.230.110 SIP/2.0 Via: SIP/2.0/UDP 84.132.106.117;branch=z9hG4bK419848F75F98E2F6C81D47877B31 From: ;tag=2294924750 To: ;tag=as44aebebb Call-ID: 00432BE47033A588C5492A1FE6B0@84.132.106.117 CSeq: 239 SUBSCRIBE Contact: Event: message-summary Expires: 3600 Max-Forwards: 70 User-Agent: AVM Speedport W 501V 28.03.93 (Nov 18 2005) Allow: NOTIFY Accept: application/simple-message-summary Content-Length: 0 [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 0: SUBSCRIBE sip:1199@88.198.230.110 SIP/2.0 (41) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 1: Via: SIP/2.0/UDP 84.132.106.117;branch=z9hG4bK419848F75F98E2F6C81D47877B31 (74) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 2: From: ;tag=2294924750 (46) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 3: To: ;tag=as44aebebb (44) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 4: Call-ID: 00432BE47033A588C5492A1FE6B0@84.132.106.117 (52) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 5: CSeq: 239 SUBSCRIBE (19) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 6: Contact: (68) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 7: Event: message-summary (22) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 8: Expires: 3600 (13) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 9: Max-Forwards: 70 (16) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 10: User-Agent: AVM Speedport W 501V 28.03.93 (Nov 18 2005) (55) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 11: Allow: NOTIFY (13) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 12: Accept: application/simple-message-summary (42) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 13: Content-Length: 0 (17) [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4329 parse_request: Header 14: (0) --- (14 headers 0 lines)--- [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4157 find_call: = No match Their Call ID: 2B8E8794C78EE580994E54785F80@192.168.2.1 Their Tag 714999007 Our tag: as3d2ab7cb [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4157 find_call: = No match Their Call ID: 6F6028B09CCCC56B@192.168.178.1 Their Tag 2435593483 Our tag: as53fbdf8d [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4157 find_call: = No match Their Call ID: 5039843871ce26724c9421227d5d430a@88.198.230.110 Their Tag l0Ibqm23BK9tv04e Our tag: as2e55f44e [Aug 29 09:10:18] DEBUG[14030]: chan_sip.c:4157 find_call: = No match Their Call ID: SpyTMMYh2FcLap2U@192.168.2.23 Their Tag w1eDglhlRwab9mZp Our tag: as5642262a *** glibc detected *** /usr/sbin/asterisk: malloc(): memory corruption: 0xb7dc217f *** ======= Backtrace: ========= /lib/libc.so.6[0xb7d08911] /lib/libc.so.6[0xb7d0a93b] /lib/libc.so.6(calloc+0x95)[0xb7d0bcf5] /usr/sbin/asterisk(_ast_calloc+0x18)[0x80e5e95] /usr/sbin/asterisk[0x80e7941] /usr/sbin/asterisk(__ast_string_field_init+0x18)[0x80e79a5] /usr/lib/asterisk/modules/chan_sip.so[0xb735196f] /usr/lib/asterisk/modules/chan_sip.so[0xb7352c9a] /usr/lib/asterisk/modules/chan_sip.so[0xb73821c5] /usr/sbin/asterisk(ast_io_wait+0x146)[0x809d24d] /usr/lib/asterisk/modules/chan_sip.so[0xb7382c5a] /usr/sbin/asterisk[0x80e6e8c] /lib/libpthread.so.0[0xb7f3534b] /lib/libc.so.6(__clone+0x5e)[0xb7d6265e] ======= Memory map: ======== 08048000-08135000 r-xp 00000000 21:02 95180 /usr/sbin/asterisk 08135000-08142000 rw-p 000ec000 21:02 95180 /usr/sbin/asterisk 08142000-081e7000 rw-p 08142000 00:00 0 [heap] b7000000-b7021000 rw-p b7000000 00:00 0 b7021000-b7100000 ---p b7021000 00:00 0 b71c8000-b71c9000 ---p b71c8000 00:00 0 b71c9000-b7209000 rw-p b71c9000 00:00 0 b7209000-b720a000 ---p b7209000 00:00 0 b720a000-b724a000 rw-p b720a000 00:00 0 b724a000-b724b000 ---p b724a000 00:00 0 b724b000-b728b000 rw-p b724b000 00:00 0 b728b000-b728c000 ---p b728b000 00:00 0 b728c000-b72cc000 rw-p b728c000 00:00 0 b72cc000-b72cd000 ---p b72cc000 00:00 0 b72cd000-b730d000 rw-p b72cd000 00:00 0 b730d000-b7342000 r--s 00000000 21:02 21745 /var/run/nscd/db4emObF (deleted) b7342000-b739c000 r-xp 00000000 21:02 97653 /usr/lib/asterisk/modules/chan_sip.so b739c000-b739f000 rw-p 00059000 21:02 97653 /usr/lib/asterisk/modules/chan_sip.so b739f000-b73a0000 r-xp 00000000 21:02 102498 /usr/lib/asterisk/modules/func_global.so b73a0000-b73a1000 rw-p 00000000 21:02 102498 /usr/lib/asterisk/modules/func_global.so b73a1000-b73a3000 r-xp 00000000 21:02 97672 /usr/lib/asterisk/modules/app_db.so b73a3000-b73a4000 rw-p 00001000 21:02 97672 /usr/lib/asterisk/modules/app_db.so b73a4000-b73a6000 r-xp 00000000 21:02 97681 /usr/lib/asterisk/modules/app_directed_pickup.so b73a6000-b73a7000 rw-p 00001000 21:02 97681 /usr/lib/asterisk/modules/app_directed_pickup.so b73a7000-b73aa000 r-xp 00000000 21:02 97631 /usr/lib/asterisk/modules/chan_features.so b73aa000-b73ab000 rw-p 00003000 21:02 97631 /usr/lib/asterisk/modules/chan_features.so b73ab000-b73ac000 rw-p b73ab000 00:00 0 b73ac000-b73b4000 r-xp 00000000 21:02 97668 /usr/lib/asterisk/modules/app_cibill.so b73b4000-b73b5000 rw-p 00008000 21:02 97668 /usr/lib/asterisk/modules/app_cibill.so b73b5000-b73b7000 r-xp 00000000 21:02 102434 /usr/lib/asterisk/modules/format_vox.so b73b7000-b73b8000 rw-p 00001000 21:02 102434 /usr/lib/asterisk/modules/format_vox.so b73b8000-b73ba000 r-xp 00000000 21:02 97703 /usr/lib/asterisk/modules/app_senddtmf.so b73ba000-b73bb000 rw-p 00001000 21:02 97703 /usr/lib/asterisk/modules/app_senddtmf.so b73bb000-b73be000 r-xp 00000000 21:02 102435 /usr/lib/asterisk/modules/format_wav.so b73be000-b73bf000 rw-p 00002000 21:02 102435 /usr/lib/asterisk/modules/format_wav.so b73bf000-b73c1000 r-xp 00000000 21:02 97686 /usr/lib/asterisk/modules/app_mp3.so b73c1000-b73c2000 rw-p Aborted (core dumped)