<-- SIP read from 82.83.35.74:5060: SUBSCRIBE sip:1246@88.198.230.110 SIP/2.0 Via: SIP/2.0/UDP 82.83.35.74:5060;branch=z9hG4bKB034D577791F87B6 From: ;tag=4197593451 To: ;tag=as4772e7ac Call-ID: 618B5E3C4C12F0CB@82.83.36.167 CSeq: 150 SUBSCRIBE Contact: Event: message-summary Expires: 3600 Max-Forwards: 70 User-Agent: AVM FRITZ!Box Fon WLAN 7170 29.04.15 (Jul 12 2006) Allow: NOTIFY Accept: application/simple-message-summary Content-Length: 0 [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 0: SUBSCRIBE sip:1246@88.198.230.110 SIP/2.0 (41) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 1: Via: SIP/2.0/UDP 82.83.35.74:5060;branch=z9hG4bKB034D577791F87B6 (64) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 2: From: ;tag=4197593451 (50) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 3: To: ;tag=as4772e7ac (48) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 4: Call-ID: 618B5E3C4C12F0CB@82.83.36.167 (38) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 5: CSeq: 150 SUBSCRIBE (19) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 6: Contact: (66) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 7: Event: message-summary (22) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 8: Expires: 3600 (13) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 9: Max-Forwards: 70 (16) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 10: User-Agent: AVM FRITZ!Box Fon WLAN 7170 29.04.15 (Jul 12 2006) (62) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 11: Allow: NOTIFY (13) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 12: Accept: application/simple-message-summary (42) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 13: Content-Length: 0 (17) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 14: (0) --- (14 headers 0 lines)--- [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = No match Their Call ID: 0BvrLVaZzOHfjeCS@192.168.1.203 Their Tag S76YpdcUEca05dmj Our tag: as37b711eb [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = No match Their Call ID: o0rBNvA4otHQVQlt@192.168.1.138 Their Tag buh23xgjGC3x3dzG Our tag: as37f19732 [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = No match Their Call ID: 44b2de79323d8482693611bf4f631d99@84.16.245.104 Their Tag as2c8729f5 Our tag: as6c115dda [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = No match Their Call ID: glQh1AckaxHMWaYb@192.168.178.31 Their Tag tehHTh30CkgZHbAz Our tag: as5feb2662 [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = No match Their Call ID: 77707A89CABE628410D4F9E052F1E@192.168.124.208 Their Tag 2899484342 Our tag: as7a9869b6 [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4109 sip_alloc: Allocating new SIP dialog for 618B5E3C4C12F0CB@82.83.36.167 - SUBSCRIBE (No RTP) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:14007 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Creating new subscription Sending to 82.83.35.74 : 5060 (no NAT) [Aug 28 15:40:23] DEBUG[16681]: res_config_mysql.c:663 mysql_reconnect: MySQL RealTime: Everything is fine. [Aug 28 15:40:23] DEBUG[16681]: res_config_mysql.c:141 realtime_mysql: MySQL RealTime: Retrieve SQL: SELECT * FROM sip WHERE name = '1246' -- SIP Seeding peer from astdb: '1246' at 1246@82.83.35.74:5060 for 1800 Found peer '1246' Transmitting (NAT) to 82.83.35.74:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 82.83.35.74:5060;branch=z9hG4bKB034D577791F87B6;received=82.83.35.74 From: ;tag=4197593451 To: ;tag=as4772e7ac Call-ID: 618B5E3C4C12F0CB@82.83.36.167 CSeq: 150 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Supported: replaces Contact: WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="0faffaeb" Content-Length: 0 --- Scheduling destruction of SIP dialog '618B5E3C4C12F0CB@82.83.36.167' in 32000 ms (Method: SUBSCRIBE) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:2257 sip_destroy_peer: Destroying SIP peer 1246 <-- SIP read from 82.83.35.74:5060: SUBSCRIBE sip:1246@88.198.230.110 SIP/2.0 Via: SIP/2.0/UDP 82.83.35.74:5060;branch=z9hG4bK7E1739BFA7A83CCF From: ;tag=4197593451 To: ;tag=as4772e7ac Call-ID: 618B5E3C4C12F0CB@82.83.36.167 CSeq: 151 SUBSCRIBE Contact: Authorization: Digest username="1246", realm="asterisk", nonce="0faffaeb", uri="sip:1246@88.198.230.110", response="13bfda0000b08499f281e92aa660f395", algorithm=MD5 Event: message-summary Expires: 3600 Max-Forwards: 70 User-Agent: AVM FRITZ!Box Fon WLAN 7170 29.04.15 (Jul 12 2006) Allow: NOTIFY Accept: application/simple-message-summary Content-Length: 0 [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 0: SUBSCRIBE sip:1246@88.198.230.110 SIP/2.0 (41) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 1: Via: SIP/2.0/UDP 82.83.35.74:5060;branch=z9hG4bK7E1739BFA7A83CCF (64) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 2: From: ;tag=4197593451 (50) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 3: To: ;tag=as4772e7ac (48) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 4: Call-ID: 618B5E3C4C12F0CB@82.83.36.167 (38) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 5: CSeq: 151 SUBSCRIBE (19) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 6: Contact: (66) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 7: Authorization: Digest username="1246", realm="asterisk", nonce="0faffaeb", uri="sip:1246@88.198.230.110", response="13bfda0000b08499f281e92aa660f395", algorithm=MD5 (164) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 8: Event: message-summary (22) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 9: Expires: 3600 (13) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 10: Max-Forwards: 70 (16) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 11: User-Agent: AVM FRITZ!Box Fon WLAN 7170 29.04.15 (Jul 12 2006) (62) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 12: Allow: NOTIFY (13) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 13: Accept: application/simple-message-summary (42) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 14: Content-Length: 0 (17) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 15: (0) --- (15 headers 0 lines)--- [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = Found Their Call ID: 618B5E3C4C12F0CB@82.83.36.167 Their Tag 4197593451 Our tag: as3e7d7aeb [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:14007 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:13659 handle_request_subscribe: Got a new subscription 618B5E3C4C12F0CB@82.83.36.167 (possibly with auth) [Aug 28 15:40:23] DEBUG[16681]: res_config_mysql.c:663 mysql_reconnect: MySQL RealTime: Everything is fine. [Aug 28 15:40:23] DEBUG[16681]: res_config_mysql.c:141 realtime_mysql: MySQL RealTime: Retrieve SQL: SELECT * FROM sip WHERE name = '1246' -- SIP Seeding peer from astdb: '1246' at 1246@82.83.35.74:5060 for 1800 Found peer '1246' Looking for 1246 in internal (domain 88.198.230.110) [Aug 28 15:40:23] DEBUG[16681]: res_config_mysql.c:663 mysql_reconnect: MySQL RealTime: Everything is fine. [Aug 28 15:40:23] DEBUG[16681]: res_config_mysql.c:141 realtime_mysql: MySQL RealTime: Retrieve SQL: SELECT * FROM extensions WHERE exten = '1246' AND context = 'internal' AND priority = '1' [Aug 28 15:40:23] DEBUG[16681]: res_config_mysql.c:663 mysql_reconnect: MySQL RealTime: Everything is fine. [Aug 28 15:40:23] DEBUG[16681]: 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 28 15:40:23] DEBUG[16681]: chan_sip.c:13807 handle_request_subscribe: Adding subscription for mailbox notification - peer 1246 Mailbox 33 Scheduling destruction of SIP dialog '618B5E3C4C12F0CB@82.83.36.167' in 3610000 ms (Method: SUBSCRIBE) Transmitting (NAT) to 82.83.35.74:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 82.83.35.74:5060;branch=z9hG4bK7E1739BFA7A83CCF;received=82.83.35.74 From: ;tag=4197593451 To: ;tag=as4772e7ac Call-ID: 618B5E3C4C12F0CB@82.83.36.167 CSeq: 151 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Supported: replaces Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- -- Message count requested for mailbox 33 but voicemail not loaded. Reliably Transmitting (NAT) to 82.83.35.74:5060: NOTIFY sip:1246@82.83.35.74;uniq=C7ED67E2EC4003CD424CF595E9027 SIP/2.0 Via: SIP/2.0/UDP 88.198.230.110:5060;branch=z9hG4bK661bd488;rport From: "asterisk" ;tag=as3e7d7aeb To: ;tag=4197593451 Contact: Call-ID: 618B5E3C4C12F0CB@82.83.36.167 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Max-Forwards: 70 Event: message-summary Content-Type: application/simple-message-summary Subscription-State: active Content-Length: 98 Messages-Waiting: no Message-Account: sip:asterisk@sip.voiceover1p.de Voice-Message: 0/0 (0/0) --- [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:1902 __sip_reliable_xmit: *** SIP TIMER: Initalizing retransmit timer on packet: Id #2066 [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:2257 sip_destroy_peer: Destroying SIP peer 1246 [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:2976 sip_destroy: Destroying SIP dialog 618B5E3C4C12F0CB@82.83.36.167 Really destroying SIP dialog '618B5E3C4C12F0CB@82.83.36.167' Method: SUBSCRIBE <-- SIP read from 82.83.35.74:5060: SIP/2.0 481 Call Leg/Transaction Does Not Exist Via: SIP/2.0/UDP 88.198.230.110:5060;branch=z9hG4bK661bd488;rport=5060;received=88.198.230.110 From: "asterisk" ;tag=as3e7d7aeb To: ;tag=4197593451 Call-ID: 618B5E3C4C12F0CB@82.83.36.167 CSeq: 102 NOTIFY User-Agent: AVM FRITZ!Box Fon WLAN 7170 29.04.15 (Jul 12 2006) Content-Length: 0 [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 0: SIP/2.0 481 Call Leg/Transaction Does Not Exist (47) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 1: Via: SIP/2.0/UDP 88.198.230.110:5060;branch=z9hG4bK661bd488;rport=5060;received=88.198.230.110 (94) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 2: From: "asterisk" ;tag=as3e7d7aeb (65) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 3: To: ;tag=4197593451 (80) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 4: Call-ID: 618B5E3C4C12F0CB@82.83.36.167 (38) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 5: CSeq: 102 NOTIFY (16) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 6: User-Agent: AVM FRITZ!Box Fon WLAN 7170 29.04.15 (Jul 12 2006) (62) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 7: Content-Length: 0 (17) [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4329 parse_request: Header 8: (0) --- (8 headers 0 lines)--- [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = No match Their Call ID: 0BvrLVaZzOHfjeCS@192.168.1.203 Their Tag S76YpdcUEca05dmj Our tag: as37b711eb [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = No match Their Call ID: o0rBNvA4otHQVQlt@192.168.1.138 Their Tag buh23xgjGC3x3dzG Our tag: as37f19732 [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = No match Their Call ID: 44b2de79323d8482693611bf4f631d99@84.16.245.104 Their Tag as2c8729f5 Our tag: as6c115dda [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = No match Their Call ID: glQh1AckaxHMWaYb@192.168.178.31 Their Tag tehHTh30CkgZHbAz Our tag: as5feb2662 [Aug 28 15:40:23] DEBUG[16681]: chan_sip.c:4157 find_call: = No match Their Call ID: 77707A89CABE628410D4F9E052F1E@192.168.124.208 Their Tag 2899484342 Our tag: as7a9869b6 *** glibc detected *** /usr/sbin/asterisk: malloc(): memory corruption: 0x081d4217 *** ======= Backtrace: ========= /lib/libc.so.6[0xb7cfa911] /lib/libc.so.6[0xb7cfc93b] /lib/libc.so.6(calloc+0x95)[0xb7cfdcf5] /usr/sbin/asterisk(_ast_calloc+0x18)[0x80e53f9] /usr/lib/asterisk/modules/chan_sip.so[0xb737092c] /usr/lib/asterisk/modules/chan_sip.so[0xb7371c9a] /usr/lib/asterisk/modules/chan_sip.so[0xb73a0e99] /usr/sbin/asterisk(ast_io_wait+0x146)[0x809d265] /usr/lib/asterAborted (core dumped)