[asterisk-users] 489 Bad Event

Tom Lynn tom at tomlynn.com
Fri Jul 14 19:19:22 MST 2006


I'm trying to debug why the message waiting lamp on my phone won't light.  I
suspect it doesn't adhere to standards.

I used tcpdump to capture it's bootup sequence.  From the dump, I can see
the phone trying to subscribe to my asterisk server (1.2.7), to which it
receives an initial 401 unauthorized response.  On the second notify
request, it receives a 489 bad event response.

Below is the second notify and the 489 bad event response.  I'm hoping that
someone who is more skilled than I can see what is wrong with the notify
request.

TIA
Tom

No.     Time        Source                Destination           Protocol
Info
    148 52.196856   192.168.1.50          192.168.1.1           SIP
Request: SUBSCRIBE sip:203 at tomlynn.com

Frame 148 (713 bytes on wire, 713 bytes captured)
    Arrival Time: Jul 14, 2006 18:30:45.344749000
    Time delta from previous packet: 0.046162000 seconds
    Time since reference or first frame: 52.196856000 seconds
    Frame Number: 148
    Packet Length: 713 bytes
    Capture Length: 713 bytes
    Protocols in frame: eth:ip:udp:sip
Ethernet II, Src: 192.168.1.50 (00:04:0d:50:22:8e), Dst:
192.168.1.1(00:b0:d0:5e:1e:a6)
    Destination: 192.168.1.1 (00:b0:d0:5e:1e:a6)
    Source: 192.168.1.50 (00:04:0d:50:22:8e)
    Type: IP (0x0800)
Internet Protocol, Src: 192.168.1.50 (192.168.1.50), Dst: 192.168.1.1 (
192.168.1.1)
    Version: 4
    Header length: 20 bytes
    Differentiated Services Field: 0x00 (DSCP 0x00: Default; ECN: 0x00)
        0000 00.. = Differentiated Services Codepoint: Default (0x00)
        .... ..0. = ECN-Capable Transport (ECT): 0
        .... ...0 = ECN-CE: 0
    Total Length: 699
    Identification: 0x0041 (65)
    Flags: 0x00
        0... = Reserved bit: Not set
        .0.. = Don't fragment: Not set
        ..0. = More fragments: Not set
    Fragment offset: 0
    Time to live: 64
    Protocol: UDP (0x11)
    Header checksum: 0xf46d [correct]
        Good: True
        Bad : False
    Source: 192.168.1.50 (192.168.1.50)
    Destination: 192.168.1.1 (192.168.1.1)
User Datagram Protocol, Src Port: 5060 (5060), Dst Port: 5060 (5060)
    Source port: 5060 (5060)
    Destination port: 5060 (5060)
    Length: 679
    Checksum: 0xede0 [correct]
Session Initiation Protocol
    Request-Line: SUBSCRIBE sip:203 at tomlynn.com SIP/2.0
        Method: SUBSCRIBE
        Resent Packet: False
    Message Header
        Via: SIP/2.0/UDP 192.168.1.50:5060;branch=z9hG4bKecd8ca820
        Max-Forwards: 70
        Content-Length: 0
        To: 203 <sip:203 at tomlynn.com>
            SIP Display info: 203
            SIP to address: sip:203 at tomlynn.com
        From: 203 <sip:203 at tomlynn.com>;tag=7463f27760ed517
            SIP Display info: 203
            SIP from address: sip:203 at tomlynn.com
            SIP tag: 7463f27760ed517
        Call-ID: b00cd7c33379cf3ea55ce8708d363c5d at 192.168.1.50
        CSeq: 1903799861 SUBSCRIBE
        Route: <sip:192.168.1.1;lr>
        Supported: timer
        Expires: 86400
        Event: message-summary
        Contact: 203 <sip:203 at 192.168.1.50:5060>
            Contact Binding: 203 <sip:203 at 192.168.1.50:5060>
                URI: 203 <sip:203 at 192.168.1.50:5060>
                    SIP Display info: 203
                    SIP contact address: sip:203 at 192.168.1.50:5060
        Supported: replaces
        Authorization:Digest
response="8533130fceedb3d6c8f14ea63c79d278",username="203",realm="asterisk",nonce="66fd9409",uri="
sip:203 at tomlynn.com"
        User-Agent: Avaya SIP R2.2 Endpoint Brcm Callctrl/1.5.1.0
MxSF/v3.2.6.26

0000  00 b0 d0 5e 1e a6 00 04 0d 50 22 8e 08 00 45 00   ...^.....P"...E.
0010  02 bb 00 41 00 00 40 11 f4 6d c0 a8 01 32 c0 a8   ...A.. at ..m...2..
0020  01 01 13 c4 13 c4 02 a7 ed e0 53 55 42 53 43 52   ..........SUBSCR
0030  49 42 45 20 73 69 70 3a 32 30 33 40 74 6f 6d 6c   IBE sip:203 at toml
0040  79 6e 6e 2e 63 6f 6d 20 53 49 50 2f 32 2e 30 0d   ynn.com SIP/2.0.
0050  0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 2f 55 44   .Via: SIP/2.0/UD
0060  50 20 31 39 32 2e 31 36 38 2e 31 2e 35 30 3a 35   P 192.168.1.50:5
0070  30 36 30 3b 62 72 61 6e 63 68 3d 7a 39 68 47 34   060;branch=z9hG4
0080  62 4b 65 63 64 38 63 61 38 32 30 0d 0a 4d 61 78   bKecd8ca820..Max
0090  2d 46 6f 72 77 61 72 64 73 3a 20 37 30 0d 0a 43   -Forwards: 70..C
00a0  6f 6e 74 65 6e 74 2d 4c 65 6e 67 74 68 3a 20 30   ontent-Length: 0
00b0  0d 0a 54 6f 3a 20 32 30 33 20 3c 73 69 70 3a 32   ..To: 203 <sip:2
00c0  30 33 40 74 6f 6d 6c 79 6e 6e 2e 63 6f 6d 3e 0d   03 at tomlynn.com>.
00d0  0a 46 72 6f 6d 3a 20 32 30 33 20 3c 73 69 70 3a   .From: 203 <sip:
00e0  32 30 33 40 74 6f 6d 6c 79 6e 6e 2e 63 6f 6d 3e   203 at tomlynn.com>
00f0  3b 74 61 67 3d 37 34 36 33 66 32 37 37 36 30 65   ;tag=7463f27760e
0100  64 35 31 37 0d 0a 43 61 6c 6c 2d 49 44 3a 20 62   d517..Call-ID: b
0110  30 30 63 64 37 63 33 33 33 37 39 63 66 33 65 61   00cd7c33379cf3ea
0120  35 35 63 65 38 37 30 38 64 33 36 33 63 35 64 40   55ce8708d363c5d@
0130  31 39 32 2e 31 36 38 2e 31 2e 35 30 0d 0a 43 53   192.168.1.50..CS
0140  65 71 3a 20 31 39 30 33 37 39 39 38 36 31 20 53   eq: 1903799861 S
0150  55 42 53 43 52 49 42 45 0d 0a 52 6f 75 74 65 3a   UBSCRIBE..Route:
0160  20 3c 73 69 70 3a 31 39 32 2e 31 36 38 2e 31 2e    <sip:192.168.1.
0170  31 3b 6c 72 3e 0d 0a 53 75 70 70 6f 72 74 65 64   1;lr>..Supported
0180  3a 20 74 69 6d 65 72 0d 0a 45 78 70 69 72 65 73   : timer..Expires
0190  3a 20 38 36 34 30 30 0d 0a 45 76 65 6e 74 3a 20   : 86400..Event:
01a0  6d 65 73 73 61 67 65 2d 73 75 6d 6d 61 72 79 0d   message-summary.
01b0  0a 43 6f 6e 74 61 63 74 3a 20 32 30 33 20 3c 73   .Contact: 203 <s
01c0  69 70 3a 32 30 33 40 31 39 32 2e 31 36 38 2e 31   ip:203 at 192.168.1
01d0  2e 35 30 3a 35 30 36 30 3e 0d 0a 53 75 70 70 6f   .50:5060>..Suppo
01e0  72 74 65 64 3a 20 72 65 70 6c 61 63 65 73 0d 0a   rted: replaces..
01f0  41 75 74 68 6f 72 69 7a 61 74 69 6f 6e 3a 44 69   Authorization:Di
0200  67 65 73 74 20 72 65 73 70 6f 6e 73 65 3d 22 38   gest response="8
0210  35 33 33 31 33 30 66 63 65 65 64 62 33 64 36 63   533130fceedb3d6c
0220  38 66 31 34 65 61 36 33 63 37 39 64 32 37 38 22   8f14ea63c79d278"
0230  2c 75 73 65 72 6e 61 6d 65 3d 22 32 30 33 22 2c   ,username="203",
0240  72 65 61 6c 6d 3d 22 61 73 74 65 72 69 73 6b 22   realm="asterisk"
0250  2c 6e 6f 6e 63 65 3d 22 36 36 66 64 39 34 30 39   ,nonce="66fd9409
0260  22 2c 75 72 69 3d 22 73 69 70 3a 32 30 33 40 74   ",uri="sip:203 at t
0270  6f 6d 6c 79 6e 6e 2e 63 6f 6d 22 0d 0a 55 73 65   omlynn.com"..Use
0280  72 2d 41 67 65 6e 74 3a 20 41 76 61 79 61 20 53   r-Agent: Avaya S
0290  49 50 20 52 32 2e 32 20 45 6e 64 70 6f 69 6e 74   IP R2.2 Endpoint
02a0  20 42 72 63 6d 20 43 61 6c 6c 63 74 72 6c 2f 31    Brcm Callctrl/1
02b0  2e 35 2e 31 2e 30 20 4d 78 53 46 2f 76 33 2e 32   .5.1.0 MxSF/v3.2
02c0  2e 36 2e 32 36 0d 0a 0d 0a                        .6.26....

No.     Time        Source                Destination           Protocol
Info
    149 52.197592   192.168.1.1           192.168.1.50          SIP
Status: 489 Bad Event

Frame 149 (477 bytes on wire, 477 bytes captured)
    Arrival Time: Jul 14, 2006 18:30:45.345485000
    Time delta from previous packet: 0.000736000 seconds
    Time since reference or first frame: 52.197592000 seconds
    Frame Number: 149
    Packet Length: 477 bytes
    Capture Length: 477 bytes
    Protocols in frame: eth:ip:udp:sip
Ethernet II, Src: 192.168.1.1 (00:b0:d0:5e:1e:a6), Dst:
192.168.1.50(00:04:0d:50:22:8e)
    Destination: 192.168.1.50 (00:04:0d:50:22:8e)
    Source: 192.168.1.1 (00:b0:d0:5e:1e:a6)
    Type: IP (0x0800)
Internet Protocol, Src: 192.168.1.1 (192.168.1.1), Dst: 192.168.1.50 (
192.168.1.50)
    Version: 4
    Header length: 20 bytes
    Differentiated Services Field: 0x00 (DSCP 0x00: Default; ECN: 0x00)
        0000 00.. = Differentiated Services Codepoint: Default (0x00)
        .... ..0. = ECN-Capable Transport (ECT): 0
        .... ...0 = ECN-CE: 0
    Total Length: 463
    Identification: 0x0000 (0)
    Flags: 0x04 (Don't Fragment)
        0... = Reserved bit: Not set
        .1.. = Don't fragment: Set
        ..0. = More fragments: Not set
    Fragment offset: 0
    Time to live: 64
    Protocol: UDP (0x11)
    Header checksum: 0xb59a [correct]
        Good: True
        Bad : False
    Source: 192.168.1.1 (192.168.1.1)
    Destination: 192.168.1.50 (192.168.1.50)
User Datagram Protocol, Src Port: 5060 (5060), Dst Port: 5060 (5060)
    Source port: 5060 (5060)
    Destination port: 5060 (5060)
    Length: 443
    Checksum: 0xb809 [correct]
Session Initiation Protocol
    Status-Line: SIP/2.0 489 Bad Event
        Status-Code: 489
        Resent Packet: False
    Message Header
        Via: SIP/2.0/UDP 192.168.1.50:5060;branch=z9hG4bKecd8ca820;received=
192.168.1.50
        From: 203 <sip:203 at tomlynn.com>;tag=7463f27760ed517
            SIP Display info: 203
            SIP from address: sip:203 at tomlynn.com
            SIP tag: 7463f27760ed517
        To: 203 <sip:203 at tomlynn.com>;tag=as4d0e25d6
            SIP Display info: 203
            SIP to address: sip:203 at tomlynn.com
            SIP tag: as4d0e25d6
        Call-ID: b00cd7c33379cf3ea55ce8708d363c5d at 192.168.1.50
        CSeq: 1903799861 SUBSCRIBE
        User-Agent: Asterisk PBX
        Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
        Contact: <sip:203 at 192.168.1.1>
            Contact Binding: <sip:203 at 192.168.1.1>
                URI: <sip:203 at 192.168.1.1>
                    SIP contact address: sip:203 at 192.168.1.1
        Content-Length: 0

0000  00 04 0d 50 22 8e 00 b0 d0 5e 1e a6 08 00 45 00   ...P"....^....E.
0010  01 cf 00 00 40 00 40 11 b5 9a c0 a8 01 01 c0 a8   .... at .@.........
0020  01 32 13 c4 13 c4 01 bb b8 09 53 49 50 2f 32 2e   .2........SIP/2.
0030  30 20 34 38 39 20 42 61 64 20 45 76 65 6e 74 0d   0 489 Bad Event.
0040  0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 2f 55 44   .Via: SIP/2.0/UD
0050  50 20 31 39 32 2e 31 36 38 2e 31 2e 35 30 3a 35   P 192.168.1.50:5
0060  30 36 30 3b 62 72 61 6e 63 68 3d 7a 39 68 47 34   060;branch=z9hG4
0070  62 4b 65 63 64 38 63 61 38 32 30 3b 72 65 63 65   bKecd8ca820;rece
0080  69 76 65 64 3d 31 39 32 2e 31 36 38 2e 31 2e 35   ived=192.168.1.5
0090  30 0d 0a 46 72 6f 6d 3a 20 32 30 33 20 3c 73 69   0..From: 203 <si
00a0  70 3a 32 30 33 40 74 6f 6d 6c 79 6e 6e 2e 63 6f   p:203 at tomlynn.co
00b0  6d 3e 3b 74 61 67 3d 37 34 36 33 66 32 37 37 36   m>;tag=7463f2776
00c0  30 65 64 35 31 37 0d 0a 54 6f 3a 20 32 30 33 20   0ed517..To: 203
00d0  3c 73 69 70 3a 32 30 33 40 74 6f 6d 6c 79 6e 6e   <sip:203 at tomlynn
00e0  2e 63 6f 6d 3e 3b 74 61 67 3d 61 73 34 64 30 65   .com>;tag=as4d0e
00f0  32 35 64 36 0d 0a 43 61 6c 6c 2d 49 44 3a 20 62   25d6..Call-ID: b
0100  30 30 63 64 37 63 33 33 33 37 39 63 66 33 65 61   00cd7c33379cf3ea
0110  35 35 63 65 38 37 30 38 64 33 36 33 63 35 64 40   55ce8708d363c5d@
0120  31 39 32 2e 31 36 38 2e 31 2e 35 30 0d 0a 43 53   192.168.1.50..CS
0130  65 71 3a 20 31 39 30 33 37 39 39 38 36 31 20 53   eq: 1903799861 S
0140  55 42 53 43 52 49 42 45 0d 0a 55 73 65 72 2d 41   UBSCRIBE..User-A
0150  67 65 6e 74 3a 20 41 73 74 65 72 69 73 6b 20 50   gent: Asterisk P
0160  42 58 0d 0a 41 6c 6c 6f 77 3a 20 49 4e 56 49 54   BX..Allow: INVIT
0170  45 2c 20 41 43 4b 2c 20 43 41 4e 43 45 4c 2c 20   E, ACK, CANCEL,
0180  4f 50 54 49 4f 4e 53 2c 20 42 59 45 2c 20 52 45   OPTIONS, BYE, RE
0190  46 45 52 2c 20 53 55 42 53 43 52 49 42 45 2c 20   FER, SUBSCRIBE,
01a0  4e 4f 54 49 46 59 0d 0a 43 6f 6e 74 61 63 74 3a   NOTIFY..Contact:
01b0  20 3c 73 69 70 3a 32 30 33 40 31 39 32 2e 31 36    <sip:203 at 192.16
01c0  38 2e 31 2e 31 3e 0d 0a 43 6f 6e 74 65 6e 74 2d   8.1.1>..Content-
01d0  4c 65 6e 67 74 68 3a 20 30 0d 0a 0d 0a            Length: 0....
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.digium.com/pipermail/asterisk-users/attachments/20060714/b0520ead/attachment.htm


More information about the asterisk-users mailing list